0s autopkgtest [17:36:40]: starting date and time: 2025-01-08 17:36:40+0000 0s autopkgtest [17:36:40]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production' 0s autopkgtest [17:36:40]: host juju-7f2275-prod-proposed-migration-environment-15; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.pbb32uuq/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:sphinx --apt-upgrade xmldiff --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=sphinx/8.1.3-4 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-ppc64el --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-15@bos03-ppc64el-26.secgroup --name adt-plucky-ppc64el-xmldiff-20250108-173639-juju-7f2275-prod-proposed-migration-environment-15-bbe3d532-cd0e-444a-90f4-60df1ad2963a --image adt/ubuntu-plucky-ppc64el-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-15 --net-id=net_prod-proposed-migration-ppc64el -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,radosgw.ps5.canonical.com'"'"'' --mirror=http://ftpmaster.internal/ubuntu/ 117s autopkgtest [17:38:37]: testbed dpkg architecture: ppc64el 117s autopkgtest [17:38:37]: testbed apt version: 2.9.18 117s autopkgtest [17:38:37]: @@@@@@@@@@@@@@@@@@@@ test bed setup 118s autopkgtest [17:38:38]: testbed release detected to be: None 118s autopkgtest [17:38:38]: updating testbed package index (apt update) 119s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [73.9 kB] 119s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 119s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 119s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 119s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [127 kB] 119s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [17.3 kB] 119s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [9708 B] 119s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [813 kB] 119s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main ppc64el Packages [242 kB] 119s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted ppc64el Packages [756 B] 119s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe ppc64el Packages [988 kB] 120s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse ppc64el Packages [15.8 kB] 120s Fetched 2287 kB in 1s (1877 kB/s) 121s Reading package lists... 122s Reading package lists... 122s Building dependency tree... 122s Reading state information... 122s Calculating upgrade... 122s The following packages will be upgraded: 122s python3-oauthlib 123s 1 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 123s Need to get 89.9 kB of archives. 123s After this operation, 0 B of additional disk space will be used. 123s Get:1 http://ftpmaster.internal/ubuntu plucky/main ppc64el python3-oauthlib all 3.2.2-3 [89.9 kB] 123s Fetched 89.9 kB in 0s (321 kB/s) 124s (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 ... 74025 files and directories currently installed.) 124s Preparing to unpack .../python3-oauthlib_3.2.2-3_all.deb ... 124s Unpacking python3-oauthlib (3.2.2-3) over (3.2.2-2) ... 124s Setting up python3-oauthlib (3.2.2-3) ... 124s Reading package lists... 124s Building dependency tree... 124s Reading state information... 125s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 125s autopkgtest [17:38:45]: upgrading testbed (apt dist-upgrade and autopurge) 125s Reading package lists... 125s Building dependency tree... 125s Reading state information... 126s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 126s Starting 2 pkgProblemResolver with broken count: 0 126s Done 126s Entering ResolveByKeep 126s 126s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 127s Reading package lists... 127s Building dependency tree... 127s Reading state information... 127s Starting pkgProblemResolver with broken count: 0 127s Starting 2 pkgProblemResolver with broken count: 0 127s Done 128s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 130s autopkgtest [17:38:50]: testbed running kernel: Linux 6.11.0-8-generic #8-Ubuntu SMP Mon Sep 16 13:49:23 UTC 2024 130s autopkgtest [17:38:50]: @@@@@@@@@@@@@@@@@@@@ apt-source xmldiff 132s Get:1 http://ftpmaster.internal/ubuntu plucky/universe xmldiff 2.6.3-0.1 (dsc) [2006 B] 132s Get:2 http://ftpmaster.internal/ubuntu plucky/universe xmldiff 2.6.3-0.1 (tar) [81.9 kB] 132s Get:3 http://ftpmaster.internal/ubuntu plucky/universe xmldiff 2.6.3-0.1 (diff) [8800 B] 132s gpgv: Signature made Sat May 4 14:23:01 2024 UTC 132s gpgv: using RSA key 8F6DE104377F3B11E741748731F3144544A1741A 132s gpgv: issuer "tchet@debian.org" 132s gpgv: Can't check signature: No public key 132s dpkg-source: warning: cannot verify inline signature for ./xmldiff_2.6.3-0.1.dsc: no acceptable signature found 132s autopkgtest [17:38:52]: testing package xmldiff version 2.6.3-0.1 133s autopkgtest [17:38:53]: build not needed 133s autopkgtest [17:38:53]: test command1: preparing testbed 133s Reading package lists... 134s Building dependency tree... 134s Reading state information... 134s Starting pkgProblemResolver with broken count: 0 134s Starting 2 pkgProblemResolver with broken count: 0 134s Done 134s The following NEW packages will be installed: 134s libjs-jquery libjs-sphinxdoc libjs-underscore libxslt1.1 python3-lxml 134s xmldiff 135s 0 upgraded, 6 newly installed, 0 to remove and 0 not upgraded. 135s Need to get 2524 kB of archives. 135s After this operation, 12.9 MB of additional disk space will be used. 135s Get:1 http://ftpmaster.internal/ubuntu plucky/main ppc64el libjs-jquery all 3.6.1+dfsg+~3.5.14-1 [328 kB] 135s Get:2 http://ftpmaster.internal/ubuntu plucky/main ppc64el libjs-underscore all 1.13.4~dfsg+~1.11.4-3 [118 kB] 135s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main ppc64el libjs-sphinxdoc all 8.1.3-4 [30.9 kB] 135s Get:4 http://ftpmaster.internal/ubuntu plucky/main ppc64el libxslt1.1 ppc64el 1.1.39-0exp1ubuntu2 [191 kB] 135s Get:5 http://ftpmaster.internal/ubuntu plucky/main ppc64el python3-lxml ppc64el 5.3.0-1build1 [1751 kB] 135s Get:6 http://ftpmaster.internal/ubuntu plucky/universe ppc64el xmldiff all 2.6.3-0.1 [107 kB] 136s Fetched 2524 kB in 1s (3765 kB/s) 136s Selecting previously unselected package libjs-jquery. 136s (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 ... 74025 files and directories currently installed.) 136s Preparing to unpack .../0-libjs-jquery_3.6.1+dfsg+~3.5.14-1_all.deb ... 136s Unpacking libjs-jquery (3.6.1+dfsg+~3.5.14-1) ... 136s Selecting previously unselected package libjs-underscore. 136s Preparing to unpack .../1-libjs-underscore_1.13.4~dfsg+~1.11.4-3_all.deb ... 136s Unpacking libjs-underscore (1.13.4~dfsg+~1.11.4-3) ... 136s Selecting previously unselected package libjs-sphinxdoc. 136s Preparing to unpack .../2-libjs-sphinxdoc_8.1.3-4_all.deb ... 136s Unpacking libjs-sphinxdoc (8.1.3-4) ... 136s Selecting previously unselected package libxslt1.1:ppc64el. 136s Preparing to unpack .../3-libxslt1.1_1.1.39-0exp1ubuntu2_ppc64el.deb ... 136s Unpacking libxslt1.1:ppc64el (1.1.39-0exp1ubuntu2) ... 136s Selecting previously unselected package python3-lxml:ppc64el. 136s Preparing to unpack .../4-python3-lxml_5.3.0-1build1_ppc64el.deb ... 136s Unpacking python3-lxml:ppc64el (5.3.0-1build1) ... 136s Selecting previously unselected package xmldiff. 136s Preparing to unpack .../5-xmldiff_2.6.3-0.1_all.deb ... 136s Unpacking xmldiff (2.6.3-0.1) ... 136s Setting up libxslt1.1:ppc64el (1.1.39-0exp1ubuntu2) ... 136s Setting up libjs-jquery (3.6.1+dfsg+~3.5.14-1) ... 136s Setting up libjs-underscore (1.13.4~dfsg+~1.11.4-3) ... 136s Setting up libjs-sphinxdoc (8.1.3-4) ... 136s Setting up python3-lxml:ppc64el (5.3.0-1build1) ... 136s Setting up xmldiff (2.6.3-0.1) ... 136s Processing triggers for man-db (2.13.0-1) ... 137s Processing triggers for libc-bin (2.40-4ubuntu1) ... 138s autopkgtest [17:38:58]: test command1: xmldiff debian/tests/all_actions.left.xml debian/tests/all_actions.right.xml 138s autopkgtest [17:38:58]: test command1: [----------------------- 139s [move, /document/node[2], /document[1], 2] 139s [insert-comment, /document[1], 0, " Insert a new comment "] 139s [update-attribute, /document/node[1], name, "was updated"] 139s [rename-attribute, /document/node[1], attribute, newtribute] 139s [insert-attribute, /document/node[1], this, "is new"] 139s [delete-attribute, /document/node[1], attr] 139s [update-text, /document/node[1], "\n Modified\n "] 139s [update-text-after, /document/node[1], "\n New tail content\n "] 139s [rename, /document/node[2], nod] 139s [insert, /document[1], new, 4] 139s [delete, /document/tail[1]] 139s autopkgtest [17:38:59]: test command1: -----------------------] 139s autopkgtest [17:38:59]: test command1: - - - - - - - - - - results - - - - - - - - - - 139s command1 PASS 140s autopkgtest [17:39:00]: test command2: preparing testbed 140s Reading package lists... 140s Building dependency tree... 140s Reading state information... 141s Starting pkgProblemResolver with broken count: 0 141s Starting 2 pkgProblemResolver with broken count: 0 141s Done 141s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 142s autopkgtest [17:39:02]: test command2: cp -a debian/tests/all_actions.* $AUTOPKGTEST_TMP; xmldiff $AUTOPKGTEST_TMP/all_actions.left.xml $AUTOPKGTEST_TMP/all_actions.right.xml > $AUTOPKGTEST_TMP/diff; xmlpatch $AUTOPKGTEST_TMP/diff $AUTOPKGTEST_TMP/all_actions.left.xml 142s autopkgtest [17:39:02]: test command2: [----------------------- 143s 143s 143s Modified 143s 143s New tail content 143s 143s And something else 143s 143s 143s Here we have some text. 143s 143s 143s autopkgtest [17:39:03]: test command2: -----------------------] 143s command2 PASS 143s autopkgtest [17:39:03]: test command2: - - - - - - - - - - results - - - - - - - - - - 144s autopkgtest [17:39:04]: @@@@@@@@@@@@@@@@@@@@ summary 144s command1 PASS 144s command2 PASS 148s nova [W] Using flock in prodstack6-ppc64el 148s flock: timeout while waiting to get lock 148s Creating nova instance adt-plucky-ppc64el-xmldiff-20250108-173639-juju-7f2275-prod-proposed-migration-environment-15-bbe3d532-cd0e-444a-90f4-60df1ad2963a from image adt/ubuntu-plucky-ppc64el-server-20250108.img (UUID 4336f050-c876-44a2-a40e-4862551c85cb)... 148s nova [W] Timed out waiting for 7fc9637e-c321-4afa-a6b8-9f3adafef937 to get deleted.