0s autopkgtest [10:25:18]: starting date and time: 2024-11-13 10:25:18+0000 0s autopkgtest [10:25:18]: git checkout: 0acbae0a WIP show VirtSubproc stderr in real-time 0s autopkgtest [10:25:18]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.m492ybiz/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 --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos03-arm64-19.secgroup --name adt-plucky-arm64-python-docx-template-20241113-102518-juju-7f2275-prod-proposed-migration-environment-2-a06a5ef9-47f2-4764-91b8-493db0fc6208 --image adt/ubuntu-plucky-arm64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-proposed-migration -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/ 77s autopkgtest [10:26:35]: testbed dpkg architecture: arm64 77s autopkgtest [10:26:35]: testbed apt version: 2.9.8 77s autopkgtest [10:26:35]: @@@@@@@@@@@@@@@@@@@@ test bed setup 78s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [73.9 kB] 78s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [76.4 kB] 78s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [7016 B] 78s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [15.3 kB] 78s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [849 kB] 79s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 Packages [104 kB] 79s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/restricted arm64 Packages [50.3 kB] 79s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/universe arm64 Packages [601 kB] 79s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse arm64 Packages [17.1 kB] 79s Fetched 1794 kB in 1s (2159 kB/s) 79s Reading package lists... 81s Reading package lists... 82s Building dependency tree... 82s Reading state information... 82s Calculating upgrade... 83s The following NEW packages will be installed: 83s python3.13-gdbm 83s The following packages will be upgraded: 83s libpython3-stdlib python3 python3-gdbm python3-minimal 83s 4 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 83s Need to get 101 kB of archives. 83s After this operation, 141 kB of additional disk space will be used. 83s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 python3-minimal arm64 3.12.7-1 [27.4 kB] 83s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 python3 arm64 3.12.7-1 [24.0 kB] 83s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 libpython3-stdlib arm64 3.12.7-1 [10.0 kB] 83s Get:4 http://ftpmaster.internal/ubuntu plucky/main arm64 python3.13-gdbm arm64 3.13.0-2 [30.7 kB] 84s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 python3-gdbm arm64 3.12.7-1 [8642 B] 84s Fetched 101 kB in 1s (120 kB/s) 84s (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 ... 79924 files and directories currently installed.) 84s Preparing to unpack .../python3-minimal_3.12.7-1_arm64.deb ... 84s Unpacking python3-minimal (3.12.7-1) over (3.12.6-0ubuntu1) ... 84s Setting up python3-minimal (3.12.7-1) ... 84s (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 ... 79924 files and directories currently installed.) 84s Preparing to unpack .../python3_3.12.7-1_arm64.deb ... 84s Unpacking python3 (3.12.7-1) over (3.12.6-0ubuntu1) ... 85s Preparing to unpack .../libpython3-stdlib_3.12.7-1_arm64.deb ... 85s Unpacking libpython3-stdlib:arm64 (3.12.7-1) over (3.12.6-0ubuntu1) ... 85s Selecting previously unselected package python3.13-gdbm. 85s Preparing to unpack .../python3.13-gdbm_3.13.0-2_arm64.deb ... 85s Unpacking python3.13-gdbm (3.13.0-2) ... 85s Preparing to unpack .../python3-gdbm_3.12.7-1_arm64.deb ... 85s Unpacking python3-gdbm:arm64 (3.12.7-1) over (3.12.6-1ubuntu1) ... 85s Setting up python3.13-gdbm (3.13.0-2) ... 85s Setting up libpython3-stdlib:arm64 (3.12.7-1) ... 85s Setting up python3 (3.12.7-1) ... 85s Setting up python3-gdbm:arm64 (3.12.7-1) ... 85s Processing triggers for man-db (2.12.1-3) ... 86s Reading package lists... 86s Building dependency tree... 86s Reading state information... 87s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 87s Hit:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease 87s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 87s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 87s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 88s Reading package lists... 88s Reading package lists... 88s Building dependency tree... 88s Reading state information... 89s Calculating upgrade... 89s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 89s Reading package lists... 90s Building dependency tree... 90s Reading state information... 90s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 94s autopkgtest [10:26:52]: testbed running kernel: Linux 6.11.0-8-generic #8-Ubuntu SMP PREEMPT_DYNAMIC Mon Sep 16 14:19:41 UTC 2024 94s autopkgtest [10:26:52]: @@@@@@@@@@@@@@@@@@@@ apt-source python-docx-template 96s Get:1 http://ftpmaster.internal/ubuntu plucky/universe python-docx-template 0.18.0+dfsg-1 (dsc) [2360 B] 96s Get:2 http://ftpmaster.internal/ubuntu plucky/universe python-docx-template 0.18.0+dfsg-1 (tar) [1526 kB] 96s Get:3 http://ftpmaster.internal/ubuntu plucky/universe python-docx-template 0.18.0+dfsg-1 (diff) [2816 B] 96s gpgv: Signature made Tue Jul 30 21:32:30 2024 UTC 96s gpgv: using RSA key 8F6DE104377F3B11E741748731F3144544A1741A 96s gpgv: issuer "tchet@debian.org" 96s gpgv: Can't check signature: No public key 96s dpkg-source: warning: cannot verify inline signature for ./python-docx-template_0.18.0+dfsg-1.dsc: no acceptable signature found 97s autopkgtest [10:26:55]: testing package python-docx-template version 0.18.0+dfsg-1 98s autopkgtest [10:26:56]: build not needed 98s autopkgtest [10:26:56]: test command1: preparing testbed 100s Reading package lists... 100s Building dependency tree... 100s Reading state information... 101s Starting pkgProblemResolver with broken count: 0 101s Starting 2 pkgProblemResolver with broken count: 0 101s Done 101s The following additional packages will be installed: 101s libdeflate0 libjbig0 libjpeg-turbo8 libjpeg8 liblerc4 libnetpbm11t64 101s libqrencode4 libsharpyuv0 libtiff6 libwebp7 libxslt1.1 netpbm python3-docx 101s python3-docxcompose python3-docxtpl python3-lxml qrencode 101s Suggested packages: 101s python-lxml-doc 101s Recommended packages: 101s ghostscript python3-bs4 python3-cssselect python3-html5lib 101s The following NEW packages will be installed: 101s autopkgtest-satdep libdeflate0 libjbig0 libjpeg-turbo8 libjpeg8 liblerc4 101s libnetpbm11t64 libqrencode4 libsharpyuv0 libtiff6 libwebp7 libxslt1.1 netpbm 101s python3-docx python3-docxcompose python3-docxtpl python3-lxml qrencode 101s 0 upgraded, 18 newly installed, 0 to remove and 0 not upgraded. 101s Need to get 4655 kB/4655 kB of archives. 101s After this operation, 35.3 MB of additional disk space will be used. 101s Get:1 /tmp/autopkgtest.XwGUG9/1-autopkgtest-satdep.deb autopkgtest-satdep arm64 0 [728 B] 102s Get:2 http://ftpmaster.internal/ubuntu plucky/main arm64 libdeflate0 arm64 1.22-1 [46.2 kB] 102s Get:3 http://ftpmaster.internal/ubuntu plucky/main arm64 libjpeg-turbo8 arm64 2.1.5-2ubuntu2 [163 kB] 102s Get:4 http://ftpmaster.internal/ubuntu plucky/main arm64 libjpeg8 arm64 8c-2ubuntu11 [2148 B] 102s Get:5 http://ftpmaster.internal/ubuntu plucky/main arm64 liblerc4 arm64 4.0.0+ds-4ubuntu2 [154 kB] 102s Get:6 http://ftpmaster.internal/ubuntu plucky/universe arm64 libnetpbm11t64 arm64 2:11.08.01-1 [114 kB] 102s Get:7 http://ftpmaster.internal/ubuntu plucky/universe arm64 libqrencode4 arm64 4.1.1-1build2 [25.3 kB] 102s Get:8 http://ftpmaster.internal/ubuntu plucky/main arm64 libsharpyuv0 arm64 1.4.0-0.1 [16.3 kB] 102s Get:9 http://ftpmaster.internal/ubuntu plucky/main arm64 libjbig0 arm64 2.1-6.1ubuntu2 [29.3 kB] 102s Get:10 http://ftpmaster.internal/ubuntu plucky/main arm64 libwebp7 arm64 1.4.0-0.1 [192 kB] 102s Get:11 http://ftpmaster.internal/ubuntu plucky/main arm64 libtiff6 arm64 4.5.1+git230720-4ubuntu4 [193 kB] 102s Get:12 http://ftpmaster.internal/ubuntu plucky/main arm64 libxslt1.1 arm64 1.1.39-0exp1ubuntu1 [167 kB] 102s Get:13 http://ftpmaster.internal/ubuntu plucky/universe arm64 netpbm arm64 2:11.08.01-1 [2125 kB] 102s Get:14 http://ftpmaster.internal/ubuntu plucky/main arm64 python3-lxml arm64 5.3.0-1 [1205 kB] 102s Get:15 http://ftpmaster.internal/ubuntu plucky/universe arm64 python3-docx all 1.1.2+dfsg-1 [158 kB] 102s Get:16 http://ftpmaster.internal/ubuntu plucky/universe arm64 python3-docxcompose all 1.4.0-3 [20.5 kB] 102s Get:17 http://ftpmaster.internal/ubuntu plucky/universe arm64 python3-docxtpl all 0.18.0+dfsg-1 [18.5 kB] 102s Get:18 http://ftpmaster.internal/ubuntu plucky/universe arm64 qrencode arm64 4.1.1-1build2 [25.5 kB] 102s Fetched 4655 kB in 1s (6060 kB/s) 103s Selecting previously unselected package libdeflate0:arm64. 103s (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 ... 79931 files and directories currently installed.) 103s Preparing to unpack .../00-libdeflate0_1.22-1_arm64.deb ... 103s Unpacking libdeflate0:arm64 (1.22-1) ... 103s Selecting previously unselected package libjpeg-turbo8:arm64. 103s Preparing to unpack .../01-libjpeg-turbo8_2.1.5-2ubuntu2_arm64.deb ... 103s Unpacking libjpeg-turbo8:arm64 (2.1.5-2ubuntu2) ... 103s Selecting previously unselected package libjpeg8:arm64. 103s Preparing to unpack .../02-libjpeg8_8c-2ubuntu11_arm64.deb ... 103s Unpacking libjpeg8:arm64 (8c-2ubuntu11) ... 103s Selecting previously unselected package liblerc4:arm64. 103s Preparing to unpack .../03-liblerc4_4.0.0+ds-4ubuntu2_arm64.deb ... 103s Unpacking liblerc4:arm64 (4.0.0+ds-4ubuntu2) ... 103s Selecting previously unselected package libnetpbm11t64:arm64. 103s Preparing to unpack .../04-libnetpbm11t64_2%3a11.08.01-1_arm64.deb ... 103s Unpacking libnetpbm11t64:arm64 (2:11.08.01-1) ... 103s Selecting previously unselected package libqrencode4:arm64. 103s Preparing to unpack .../05-libqrencode4_4.1.1-1build2_arm64.deb ... 103s Unpacking libqrencode4:arm64 (4.1.1-1build2) ... 103s Selecting previously unselected package libsharpyuv0:arm64. 103s Preparing to unpack .../06-libsharpyuv0_1.4.0-0.1_arm64.deb ... 103s Unpacking libsharpyuv0:arm64 (1.4.0-0.1) ... 103s Selecting previously unselected package libjbig0:arm64. 103s Preparing to unpack .../07-libjbig0_2.1-6.1ubuntu2_arm64.deb ... 103s Unpacking libjbig0:arm64 (2.1-6.1ubuntu2) ... 103s Selecting previously unselected package libwebp7:arm64. 103s Preparing to unpack .../08-libwebp7_1.4.0-0.1_arm64.deb ... 103s Unpacking libwebp7:arm64 (1.4.0-0.1) ... 103s Selecting previously unselected package libtiff6:arm64. 103s Preparing to unpack .../09-libtiff6_4.5.1+git230720-4ubuntu4_arm64.deb ... 103s Unpacking libtiff6:arm64 (4.5.1+git230720-4ubuntu4) ... 103s Selecting previously unselected package libxslt1.1:arm64. 103s Preparing to unpack .../10-libxslt1.1_1.1.39-0exp1ubuntu1_arm64.deb ... 103s Unpacking libxslt1.1:arm64 (1.1.39-0exp1ubuntu1) ... 103s Selecting previously unselected package netpbm. 103s Preparing to unpack .../11-netpbm_2%3a11.08.01-1_arm64.deb ... 103s Unpacking netpbm (2:11.08.01-1) ... 103s Selecting previously unselected package python3-lxml:arm64. 103s Preparing to unpack .../12-python3-lxml_5.3.0-1_arm64.deb ... 103s Unpacking python3-lxml:arm64 (5.3.0-1) ... 103s Selecting previously unselected package python3-docx. 103s Preparing to unpack .../13-python3-docx_1.1.2+dfsg-1_all.deb ... 103s Unpacking python3-docx (1.1.2+dfsg-1) ... 103s Selecting previously unselected package python3-docxcompose. 103s Preparing to unpack .../14-python3-docxcompose_1.4.0-3_all.deb ... 103s Unpacking python3-docxcompose (1.4.0-3) ... 103s Selecting previously unselected package python3-docxtpl. 103s Preparing to unpack .../15-python3-docxtpl_0.18.0+dfsg-1_all.deb ... 103s Unpacking python3-docxtpl (0.18.0+dfsg-1) ... 103s Selecting previously unselected package qrencode. 103s Preparing to unpack .../16-qrencode_4.1.1-1build2_arm64.deb ... 103s Unpacking qrencode (4.1.1-1build2) ... 103s Selecting previously unselected package autopkgtest-satdep. 103s Preparing to unpack .../17-1-autopkgtest-satdep.deb ... 103s Unpacking autopkgtest-satdep (0) ... 103s Setting up libsharpyuv0:arm64 (1.4.0-0.1) ... 103s Setting up liblerc4:arm64 (4.0.0+ds-4ubuntu2) ... 103s Setting up libqrencode4:arm64 (4.1.1-1build2) ... 103s Setting up qrencode (4.1.1-1build2) ... 103s Setting up libdeflate0:arm64 (1.22-1) ... 103s Setting up libjbig0:arm64 (2.1-6.1ubuntu2) ... 103s Setting up libnetpbm11t64:arm64 (2:11.08.01-1) ... 103s Setting up libjpeg-turbo8:arm64 (2.1.5-2ubuntu2) ... 103s Setting up libwebp7:arm64 (1.4.0-0.1) ... 103s Setting up libxslt1.1:arm64 (1.1.39-0exp1ubuntu1) ... 103s Setting up libjpeg8:arm64 (8c-2ubuntu11) ... 103s Setting up python3-lxml:arm64 (5.3.0-1) ... 104s Setting up libtiff6:arm64 (4.5.1+git230720-4ubuntu4) ... 104s Setting up python3-docx (1.1.2+dfsg-1) ... 104s Setting up python3-docxcompose (1.4.0-3) ... 104s Setting up python3-docxtpl (0.18.0+dfsg-1) ... 104s Setting up netpbm (2:11.08.01-1) ... 104s Setting up autopkgtest-satdep (0) ... 104s Processing triggers for man-db (2.12.1-3) ... 105s Processing triggers for libc-bin (2.40-1ubuntu3) ... 108s (Reading database ... 81089 files and directories currently installed.) 108s Removing autopkgtest-satdep (0) ... 109s autopkgtest [10:27:07]: test command1: make -f debian/rules override_dh_auto_test 109s autopkgtest [10:27:07]: test command1: [----------------------- 109s qrencode --output debian/test.png TEST 109s pngtopnm debian/test.png | pnmtojpeg > debian/test.jpg 109s cp debian/test.png tests/templates/dummy_pic_for_header.png 109s cp debian/test.png tests/templates/python_logo.png 109s cp debian/test.png tests/templates/django.png 109s cp debian/test.png tests/templates/python.png 109s cp debian/test.png tests/templates/zope.png 109s cp debian/test.png tests/templates/bottle.png 109s cp debian/test.png tests/templates/tornado.png 109s cp debian/test.png tests/templates/pyramid.png 109s cp debian/test.jpg tests/templates/python_jpeg.jpg 109s cd tests && PYTHONPATH=$(find ../.pybuild -name build 2>/dev/null | xargs echo | tr ' ' :) python3 runtests.py 115s Executing "python3 -m docxtpl templates/module_execute_tpl.docx templates/module_execute.json output/module_execute.docx -o -q" ... 115s --> File output/module_execute.docx has been generated. 118s ================================================================================ 118s Generating template error for testing (so it is safe to ignore) : 118s ................................................................................ 118s Encountered unknown tag 'endif'. 118s Context: 118s I am the second paragraph. 118s I am the third paragraph. 118s I am the fourth paragraph. 118s I am the fifth paragraph. {% if test_variable %}I am part of it, too.{% endif %} {% endif %} 118s I am the sixth paragraph. 118s I am the seventh paragraph. 118s I am the eighth paragraph. 118s ................................................................................ 118s End of TemplateError Test 118s ================================================================================ 119s cellbg.py ... 119s comments.py ... 119s custom_jinja_filters.py ... 119s doc_properties.py ... 119s dynamic_table.py ... 119s embedded.py ... 119s escape.py ... 119s escape_auto.py ... 119s header_footer.py ... 119s header_footer_entities.py ... 119s header_footer_image.py ... 119s header_footer_image_file_obj.py ... 119s header_footer_inline_image.py ... 119s header_footer_utf8.py ... 119s horizontal_merge.py ... 119s inline_image.py ... 119s less_cells_after_loop.py ... 119s merge_docx.py ... 119s merge_paragraph.py ... 119s module_execute.py ... 119s multi_rendering.py ... 119s nested_for.py ... 119s order.py ... 119s preserve_spaces.py ... 119s replace_picture.py ... 119s richtext.py ... 119s richtext_and_if.py ... 119s richtext_eastAsia.py ... 119s subdoc.py ... 119s template_error.py ... 119s vertical_merge.py ... 119s vertical_merge_nested.py ... 119s word2016.py ... 119s Done. 120s autopkgtest [10:27:18]: test command1: -----------------------] 120s command1 PASS 120s autopkgtest [10:27:18]: test command1: - - - - - - - - - - results - - - - - - - - - - 121s autopkgtest [10:27:19]: @@@@@@@@@@@@@@@@@@@@ summary 121s command1 PASS 134s virt: nova [W] Skipping flock in bos03-arm64 134s virt: Creating nova instance adt-plucky-arm64-python-docx-template-20241113-102518-juju-7f2275-prod-proposed-migration-environment-2-a06a5ef9-47f2-4764-91b8-493db0fc6208 from image adt/ubuntu-plucky-arm64-server-20241113.img (UUID 2d7760e6-2439-4200-89d6-5ed33e5c6330)...