0s autopkgtest [16:29:09]: starting date and time: 2025-03-15 16:29:09+0000 0s autopkgtest [16:29:09]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production' 0s autopkgtest [16:29:09]: host juju-7f2275-prod-proposed-migration-environment-15; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.0vtya57u/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:glibc --apt-upgrade paml --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=glibc/2.41-1ubuntu2 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-s390x --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-15@bos03-s390x-32.secgroup --name adt-plucky-s390x-paml-20250315-162909-juju-7f2275-prod-proposed-migration-environment-15-2f7f861e-f69f-4cce-ab75-872980347385 --image adt/ubuntu-plucky-s390x-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-15 --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,radosgw.ps5.canonical.com'"'"'' --mirror=http://ftpmaster.internal/ubuntu/ 140s autopkgtest [16:31:29]: testbed dpkg architecture: s390x 140s autopkgtest [16:31:29]: testbed apt version: 2.9.33 141s autopkgtest [16:31:30]: @@@@@@@@@@@@@@@@@@@@ test bed setup 141s autopkgtest [16:31:30]: testbed release detected to be: None 142s autopkgtest [16:31:31]: updating testbed package index (apt update) 142s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [126 kB] 142s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 142s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 143s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 143s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [99.7 kB] 143s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [379 kB] 143s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [15.8 kB] 143s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x Packages [113 kB] 143s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x c-n-f Metadata [1824 B] 143s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted s390x c-n-f Metadata [116 B] 143s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x Packages [320 kB] 144s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x c-n-f Metadata [13.4 kB] 144s Get:13 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse s390x Packages [3776 B] 144s Get:14 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse s390x c-n-f Metadata [240 B] 144s Fetched 1073 kB in 2s (566 kB/s) 145s Reading package lists... 145s + lsb_release --codename --short 145s + RELEASE=plucky 145s + cat 145s + [ plucky != trusty ] 145s + DEBIAN_FRONTEND=noninteractive eatmydata apt-get -y --allow-downgrades -o Dpkg::Options::=--force-confnew dist-upgrade 145s Reading package lists... 145s Building dependency tree... 145s Reading state information... 145s Calculating upgrade... 145s Calculating upgrade... 146s The following packages were automatically installed and are no longer required: 146s libnsl2 libpython3.12-minimal libpython3.12-stdlib libpython3.12t64 146s linux-headers-6.11.0-8 linux-headers-6.11.0-8-generic 146s linux-modules-6.11.0-8-generic linux-tools-6.11.0-8 146s linux-tools-6.11.0-8-generic 146s Use 'sudo apt autoremove' to remove them. 146s The following packages will be upgraded: 146s pinentry-curses python3-jinja2 strace 146s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 146s Need to get 652 kB of archives. 146s After this operation, 27.6 kB of additional disk space will be used. 146s Get:1 http://ftpmaster.internal/ubuntu plucky/main s390x strace s390x 6.13+ds-1ubuntu1 [500 kB] 146s Get:2 http://ftpmaster.internal/ubuntu plucky/main s390x pinentry-curses s390x 1.3.1-2ubuntu3 [42.9 kB] 147s Get:3 http://ftpmaster.internal/ubuntu plucky/main s390x python3-jinja2 all 3.1.5-2ubuntu1 [109 kB] 147s Fetched 652 kB in 1s (649 kB/s) 147s (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 ... 81428 files and directories currently installed.) 147s Preparing to unpack .../strace_6.13+ds-1ubuntu1_s390x.deb ... 147s Unpacking strace (6.13+ds-1ubuntu1) over (6.11-0ubuntu1) ... 147s Preparing to unpack .../pinentry-curses_1.3.1-2ubuntu3_s390x.deb ... 147s Unpacking pinentry-curses (1.3.1-2ubuntu3) over (1.3.1-2ubuntu2) ... 147s Preparing to unpack .../python3-jinja2_3.1.5-2ubuntu1_all.deb ... 147s Unpacking python3-jinja2 (3.1.5-2ubuntu1) over (3.1.5-2) ... 147s Setting up pinentry-curses (1.3.1-2ubuntu3) ... 147s Setting up python3-jinja2 (3.1.5-2ubuntu1) ... 147s Setting up strace (6.13+ds-1ubuntu1) ... 147s Processing triggers for man-db (2.13.0-1) ... 148s + rm /etc/apt/preferences.d/force-downgrade-to-release.pref 148s + /usr/lib/apt/apt-helper analyze-pattern ?true 148s + uname -r 148s + sed s/\./\\./g 148s + running_kernel_pattern=^linux-.*6\.14\.0-10-generic.* 148s + apt list ?obsolete 148s + tail -n+2 148s + cut -d/ -f1 148s + grep -v ^linux-.*6\.14\.0-10-generic.* 148s + obsolete_pkgs=linux-headers-6.11.0-8-generic 148s linux-headers-6.11.0-8 148s linux-modules-6.11.0-8-generic 148s linux-tools-6.11.0-8-generic 148s linux-tools-6.11.0-8 148s + DEBIAN_FRONTEND=noninteractive eatmydata apt-get -y purge --autoremove linux-headers-6.11.0-8-generic linux-headers-6.11.0-8 linux-modules-6.11.0-8-generic linux-tools-6.11.0-8-generic linux-tools-6.11.0-8 148s Reading package lists... 148s Building dependency tree... 148s Reading state information... 148s Solving dependencies... 148s The following packages will be REMOVED: 148s libnsl2* libpython3.12-minimal* libpython3.12-stdlib* libpython3.12t64* 148s linux-headers-6.11.0-8* linux-headers-6.11.0-8-generic* 148s linux-modules-6.11.0-8-generic* linux-tools-6.11.0-8* 148s linux-tools-6.11.0-8-generic* 148s 0 upgraded, 0 newly installed, 9 to remove and 5 not upgraded. 148s After this operation, 167 MB disk space will be freed. 148s (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 ... 81428 files and directories currently installed.) 148s Removing linux-tools-6.11.0-8-generic (6.11.0-8.8) ... 148s Removing linux-tools-6.11.0-8 (6.11.0-8.8) ... 148s Removing libpython3.12t64:s390x (3.12.9-1) ... 148s Removing libpython3.12-stdlib:s390x (3.12.9-1) ... 148s Removing libnsl2:s390x (1.3.0-3build3) ... 148s Removing libpython3.12-minimal:s390x (3.12.9-1) ... 148s Removing linux-headers-6.11.0-8-generic (6.11.0-8.8) ... 149s Removing linux-headers-6.11.0-8 (6.11.0-8.8) ... 149s Removing linux-modules-6.11.0-8-generic (6.11.0-8.8) ... 149s Processing triggers for libc-bin (2.41-1ubuntu1) ... 149s (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 ... 56328 files and directories currently installed.) 149s Purging configuration files for libpython3.12-minimal:s390x (3.12.9-1) ... 149s Purging configuration files for linux-modules-6.11.0-8-generic (6.11.0-8.8) ... 150s + grep -q trusty /etc/lsb-release 150s + [ ! -d /usr/share/doc/unattended-upgrades ] 150s + [ ! -d /usr/share/doc/lxd ] 150s + [ ! -d /usr/share/doc/lxd-client ] 150s + [ ! -d /usr/share/doc/snapd ] 150s + type iptables 150s + cat 150s + chmod 755 /etc/rc.local 150s + . /etc/rc.local 150s + iptables -w -t mangle -A FORWARD -p tcp --tcp-flags SYN,RST SYN -j TCPMSS --clamp-mss-to-pmtu 150s + iptables -A OUTPUT -d 10.255.255.1/32 -p tcp -j DROP 150s + iptables -A OUTPUT -d 10.255.255.2/32 -p tcp -j DROP 150s + uname -m 150s + [ s390x = ppc64le ] 150s + [ -d /run/systemd/system ] 150s + systemd-detect-virt --quiet --vm 150s + mkdir -p /etc/systemd/system/systemd-random-seed.service.d/ 150s + cat 150s + grep -q lz4 /etc/initramfs-tools/initramfs.conf 150s + echo COMPRESS=lz4 150s autopkgtest [16:31:39]: upgrading testbed (apt dist-upgrade and autopurge) 150s Reading package lists... 150s Building dependency tree... 150s Reading state information... 150s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 150s Starting 2 pkgProblemResolver with broken count: 0 150s Done 150s Entering ResolveByKeep 150s 150s Calculating upgrade... 151s The following packages will be upgraded: 151s libc-bin libc-dev-bin libc6 libc6-dev locales 151s 5 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 151s Need to get 9512 kB of archives. 151s After this operation, 8192 B of additional disk space will be used. 151s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libc6-dev s390x 2.41-1ubuntu2 [1678 kB] 153s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libc-dev-bin s390x 2.41-1ubuntu2 [24.3 kB] 153s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libc6 s390x 2.41-1ubuntu2 [2892 kB] 156s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libc-bin s390x 2.41-1ubuntu2 [671 kB] 157s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x locales all 2.41-1ubuntu2 [4246 kB] 161s Preconfiguring packages ... 161s Fetched 9512 kB in 11s (895 kB/s) 161s (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 ... 56326 files and directories currently installed.) 161s Preparing to unpack .../libc6-dev_2.41-1ubuntu2_s390x.deb ... 163s Unpacking libc6-dev:s390x (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 163s Preparing to unpack .../libc-dev-bin_2.41-1ubuntu2_s390x.deb ... 163s Unpacking libc-dev-bin (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 163s Preparing to unpack .../libc6_2.41-1ubuntu2_s390x.deb ... 163s Unpacking libc6:s390x (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 163s Setting up libc6:s390x (2.41-1ubuntu2) ... 163s (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 ... 56326 files and directories currently installed.) 163s Preparing to unpack .../libc-bin_2.41-1ubuntu2_s390x.deb ... 163s Unpacking libc-bin (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 163s Setting up libc-bin (2.41-1ubuntu2) ... 163s (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 ... 56326 files and directories currently installed.) 163s Preparing to unpack .../locales_2.41-1ubuntu2_all.deb ... 163s Unpacking locales (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 163s Setting up locales (2.41-1ubuntu2) ... 163s Generating locales (this might take a while)... 163s en_US.UTF-8... done 163s Generation complete. 163s Setting up libc-dev-bin (2.41-1ubuntu2) ... 163s Setting up libc6-dev:s390x (2.41-1ubuntu2) ... 163s Processing triggers for man-db (2.13.0-1) ... 164s Processing triggers for systemd (257.3-1ubuntu3) ... 165s Reading package lists... 165s Building dependency tree... 165s Reading state information... 165s Starting pkgProblemResolver with broken count: 0 165s Starting 2 pkgProblemResolver with broken count: 0 165s Done 165s Solving dependencies... 165s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 165s autopkgtest [16:31:54]: rebooting testbed after setup commands that affected boot 187s autopkgtest [16:32:16]: testbed running kernel: Linux 6.14.0-10-generic #10-Ubuntu SMP Wed Mar 12 14:53:49 UTC 2025 190s autopkgtest [16:32:19]: @@@@@@@@@@@@@@@@@@@@ apt-source paml 194s Get:1 http://ftpmaster.internal/ubuntu plucky/universe paml 4.9j+dfsg-6 (dsc) [2244 B] 194s Get:2 http://ftpmaster.internal/ubuntu plucky/universe paml 4.9j+dfsg-6 (tar) [1375 kB] 194s Get:3 http://ftpmaster.internal/ubuntu plucky/universe paml 4.9j+dfsg-6 (diff) [8604 B] 194s gpgv: Signature made Wed Feb 26 22:07:37 2025 UTC 194s gpgv: using RSA key 8F91B227C7D6F2B1948C8236793CF67E8F0D11DA 194s gpgv: issuer "emollier@debian.org" 194s gpgv: Can't check signature: No public key 194s dpkg-source: warning: cannot verify inline signature for ./paml_4.9j+dfsg-6.dsc: no acceptable signature found 194s autopkgtest [16:32:23]: testing package paml version 4.9j+dfsg-6 194s autopkgtest [16:32:23]: build not needed 195s autopkgtest [16:32:24]: test run-unit-test: preparing testbed 195s Reading package lists... 196s Building dependency tree... 196s Reading state information... 196s Starting pkgProblemResolver with broken count: 0 196s Starting 2 pkgProblemResolver with broken count: 0 196s Done 196s The following NEW packages will be installed: 196s paml paml-doc 196s 0 upgraded, 2 newly installed, 0 to remove and 0 not upgraded. 196s Need to get 1909 kB of archives. 196s After this operation, 8831 kB of additional disk space will be used. 196s Get:1 http://ftpmaster.internal/ubuntu plucky/universe s390x paml s390x 4.9j+dfsg-6 [907 kB] 197s Get:2 http://ftpmaster.internal/ubuntu plucky/universe s390x paml-doc all 4.9j+dfsg-6 [1002 kB] 198s Fetched 1909 kB in 2s (881 kB/s) 198s Selecting previously unselected package paml. 198s (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 ... 56326 files and directories currently installed.) 198s Preparing to unpack .../paml_4.9j+dfsg-6_s390x.deb ... 198s Unpacking paml (4.9j+dfsg-6) ... 198s Selecting previously unselected package paml-doc. 198s Preparing to unpack .../paml-doc_4.9j+dfsg-6_all.deb ... 198s Unpacking paml-doc (4.9j+dfsg-6) ... 198s Setting up paml-doc (4.9j+dfsg-6) ... 198s Setting up paml (4.9j+dfsg-6) ... 200s autopkgtest [16:32:29]: test run-unit-test: [----------------------- 200s Test 4 202s 202s CODONML in paml version 4.9j, October 2019 202s 202s ---------------------------------------------- 202s Phe F TTT | Ser S TCT | Tyr Y TAT | Cys C TGT 202s TTC | TCC | TAC | TGC 202s Leu L TTA | TCA | *** * TAA | *** * TGA 202s TTG | TCG | TAG | Trp W TGG 202s ---------------------------------------------- 202s Leu L CTT | Pro P CCT | His H CAT | Arg R CGT 202s CTC | CCC | CAC | CGC 202s CTA | CCA | Gln Q CAA | CGA 202s CTG | CCG | CAG | CGG 202s ---------------------------------------------- 202s Ile I ATT | Thr T ACT | Asn N AAT | Ser S AGT 202s ATC | ACC | AAC | AGC 202s ATA | ACA | Lys K AAA | Arg R AGA 202s Met M ATG | ACG | AAG | AGG 202s ---------------------------------------------- 202s Val V GTT | Ala A GCT | Asp D GAT | Gly G GGT 202s GTC | GCC | GAC | GGC 202s GTA | GCA | Glu E GAA | GGA 202s GTG | GCG | GAG | GGG 202s ---------------------------------------------- 202s Nice code, uuh? 202s ns = 7 ls = 390 202s Reading sequences, sequential format.. 202s Reading seq # 1: Hsa_Human Reading seq # 2: Hla_gibbon Reading seq # 3: Cgu/Can_colobus Reading seq # 4: Pne_langur Reading seq # 5: Mmu_rhesus Reading seq # 6: Ssc_squirrelM Reading seq # 7: Cja_marmoset 202s Sequences read.. 202s Counting site patterns.. 0:00 202s Compressing, 81 patterns at 130 / 130 sites (100.0%), 0:00 202s Collecting fpatt[] & pose[], 81 patterns at 130 / 130 sites (100.0%), 0:00 202s Counting codons.. 202s 202s 168 bytes for distance 202s 79056 bytes for conP 202s 0 bytes for fhK 202s 5000000 bytes for space 202s 202s 2 branch types are in tree. Stop if wrong. 202s TREE # 1 202s ((1, 2), ((3, 4), 5), (6, 7)); MP score: 65 202s 197640 bytes for conP, adjusted 202s 202s 0.059992 0.030617 0.109773 0.016619 0.073459 0.029627 0.039253 0.083921 0.064332 0.053198 0.066567 0.827981 1.027699 0.941164 202s 202s ntime & nrate & np: 11 3 14 202s 202s Bounds (np=14): 202s 0.000004 0.000004 0.000004 0.000004 0.000004 0.000004 0.000004 0.000004 0.000004 0.000004 0.000004 0.000100 0.000100 0.000100 202s 50.000000 50.000000 50.000000 50.000000 50.000000 50.000000 50.000000 50.000000 50.000000 50.000000 50.000000 999.000000 999.000000 999.000000 202s 202s np = 14 202s lnL0 = -944.645677 202s 202s Iterating by ming2 202s Initial: fx= 944.645677 202s x= 0.05999 0.03062 0.10977 0.01662 0.07346 0.02963 0.03925 0.08392 0.06433 0.05320 0.06657 0.82798 1.02770 0.94116 202s 202s 1 h-m-p 0.0000 0.0009 260.6426 +++YCCC 934.091445 3 0.0005 27 | 0/14 202s 2 h-m-p 0.0001 0.0006 129.7803 +YYCCCC 930.912208 5 0.0004 53 | 0/14 202s 3 h-m-p 0.0002 0.0009 81.9342 CCCCC 930.226598 4 0.0003 78 | 0/14 202s 4 h-m-p 0.0004 0.0027 65.0543 +YCCC 929.176803 3 0.0009 101 | 0/14 202s 5 h-m-p 0.0003 0.0025 217.8674 +YYCC 926.090708 3 0.0009 123 | 0/14 202s 6 h-m-p 0.0003 0.0014 143.8785 +YCYCCC 923.793342 5 0.0009 149 | 0/14 202s 7 h-m-p 0.0002 0.0013 628.5502 +YCCC 919.098482 3 0.0005 172 | 0/14 202s 8 h-m-p 0.0004 0.0021 486.4387 YCCCCC 913.076112 5 0.0009 198 | 0/14 202s 9 h-m-p 0.0005 0.0025 116.0636 CCC 912.257179 2 0.0006 219 | 0/14 202s 10 h-m-p 0.0014 0.0072 7.0099 CCC 912.244114 2 0.0005 240 | 0/14 202s 11 h-m-p 0.0006 0.1331 5.6537 ++YCCC 911.844130 3 0.0261 264 | 0/14 202s 12 h-m-p 0.0023 0.0116 38.7841 CCC 911.782927 2 0.0007 285 | 0/14 202s 13 h-m-p 0.0094 0.2130 2.7224 +YCC 911.609385 2 0.0304 306 | 0/14 202s 14 h-m-p 0.0007 0.0315 127.0479 ++CYCCC 907.878471 4 0.0151 332 | 0/14 202s 15 h-m-p 0.4801 2.4003 1.3817 YCYC 906.199286 3 0.7789 353 | 0/14 202s 16 h-m-p 1.0421 5.2106 0.6455 CCCCC 904.917871 4 1.2970 378 | 0/14 202s 17 h-m-p 1.1552 5.7762 0.6261 CCCC 904.015147 3 1.8994 415 | 0/14 202s 18 h-m-p 1.6000 8.0000 0.7414 CCCC 903.602552 3 1.2065 452 | 0/14 202s 19 h-m-p 1.6000 8.0000 0.5197 CYC 903.458579 2 1.7357 486 | 0/14 202s 20 h-m-p 1.6000 8.0000 0.3227 CC 903.426568 1 1.4189 519 | 0/14 206s 21 h-m-p 1.6000 8.0000 0.1103 CC 903.421458 1 1.9703 552 | 0/14 206s 22 h-m-p 1.6000 8.0000 0.1113 ++ 903.405079 m 8.0000 583 | 0/14 206s 23 h-m-p 1.6000 8.0000 0.4511 ++ 903.304383 m 8.0000 614 | 0/14 206s 24 h-m-p 1.3779 8.0000 2.6191 +CCC 903.210053 2 4.5131 650 | 0/14 206s 25 h-m-p 1.6000 8.0000 2.7948 CCC 903.169701 2 2.0363 671 | 0/14 206s 26 h-m-p 1.5223 8.0000 3.7382 +YC 903.141214 1 4.2464 690 | 0/14 206s 27 h-m-p 1.6000 8.0000 5.0591 YCC 903.123475 2 2.9489 710 | 0/14 206s 28 h-m-p 1.6000 8.0000 8.6281 +YC 903.105482 1 4.0557 729 | 0/14 206s 29 h-m-p 1.6000 8.0000 12.6635 YCC 903.096748 2 2.6485 749 | 0/14 206s 30 h-m-p 1.6000 8.0000 18.6053 +YC 903.088497 1 4.2883 768 | 0/14 206s 31 h-m-p 1.6000 8.0000 28.7912 YC 903.084145 1 2.5921 786 | 0/14 206s 32 h-m-p 1.6000 8.0000 40.4200 +YC 903.080534 1 4.2702 805 | 0/14 206s 33 h-m-p 1.6000 8.0000 64.2595 YC 903.078479 1 2.6001 823 | 0/14 206s 34 h-m-p 0.8378 4.1890 89.6481 ++ 903.076837 m 4.1890 840 | 1/14 206s 35 h-m-p 1.6000 8.0000 0.0006 YC 903.076552 1 1.0017 858 | 1/14 206s 36 h-m-p 1.6000 8.0000 0.0001 C 903.076551 0 1.3989 888 | 1/14 206s 37 h-m-p 1.6000 8.0000 0.0000 C 903.076551 0 1.4341 918 | 1/14 206s 38 h-m-p 1.6000 8.0000 0.0000 Y 903.076551 0 0.7792 948 206s Out.. 206s lnL = -903.076551 206s 949 lfun, 1898 eigenQcodon, 10439 P(t) 206s 206s 2 branch types are in tree. Stop if wrong. 206s TREE # 2 206s ((1, 2), ((3, 4), 5), (6, 7)); MP score: 65 206s 0.029113 0.052480 0.087084 0.055717 0.106771 0.078773 0.064662 0.044817 0.061270 0.043588 0.090961 0.896568 1.079059 1.149456 206s 206s ntime & nrate & np: 11 3 14 206s 206s Bounds (np=14): 206s 0.000004 0.000004 0.000004 0.000004 0.000004 0.000004 0.000004 0.000004 0.000004 0.000004 0.000004 0.000100 0.000100 0.000100 206s 50.000000 50.000000 50.000000 50.000000 50.000000 50.000000 50.000000 50.000000 50.000000 50.000000 50.000000 999.000000 999.000000 999.000000 206s 206s np = 14 206s lnL0 = -942.758731 206s 206s Iterating by ming2 206s Initial: fx= 942.758731 206s x= 0.02911 0.05248 0.08708 0.05572 0.10677 0.07877 0.06466 0.04482 0.06127 0.04359 0.09096 0.89657 1.07906 1.14946 206s 206s 1 h-m-p 0.0000 0.0008 232.8869 +++YYCCCC 929.520009 5 0.0005 30 | 0/14 206s 2 h-m-p 0.0001 0.0007 102.1368 YCYCCC 927.797269 5 0.0003 55 | 0/14 206s 3 h-m-p 0.0003 0.0014 48.8020 YCCCCC 927.187607 5 0.0006 81 | 0/14 206s 4 h-m-p 0.0003 0.0027 101.4019 +YYCCC 925.815744 4 0.0008 105 | 0/14 206s 5 h-m-p 0.0004 0.0037 234.9483 YCCC 923.764529 3 0.0007 127 | 0/14 206s 6 h-m-p 0.0005 0.0031 343.3282 YCCC 918.952427 3 0.0011 149 | 0/14 206s 7 h-m-p 0.0009 0.0046 324.8671 YCCCCC 909.072579 5 0.0022 175 | 0/14 206s 8 h-m-p 0.0003 0.0014 243.6362 CCC 908.066861 2 0.0003 196 | 0/14 206s 9 h-m-p 0.0022 0.0108 23.9347 CCC 907.987918 2 0.0004 217 | 0/14 206s 10 h-m-p 0.0017 0.0204 6.3228 YC 907.967337 1 0.0011 235 | 0/14 206s 11 h-m-p 0.0004 0.0379 16.8834 ++CCCCC 907.544289 4 0.0087 262 | 0/14 206s 12 h-m-p 0.0087 0.0437 3.7831 -YC 907.539003 1 0.0009 281 | 0/14 206s 13 h-m-p 0.0007 0.3665 5.1933 +++YCCC 907.306933 3 0.0344 306 | 0/14 206s 14 h-m-p 0.0006 0.0143 276.5699 +YCCCC 905.205593 4 0.0060 331 | 0/14 206s 15 h-m-p 1.3412 6.7059 0.7571 CCC 903.118954 2 1.7130 352 | 0/14 206s 16 h-m-p 1.6000 8.0000 0.5967 YCCC 901.922051 3 3.2932 388 | 0/14 206s 17 h-m-p 1.4226 7.1130 0.5017 CYC 901.686297 2 1.3715 422 | 0/14 206s 18 h-m-p 1.6000 8.0000 0.3324 CCC 901.639635 2 1.3389 457 | 0/14 206s 19 h-m-p 1.6000 8.0000 0.1557 YC 901.631293 1 1.1694 489 | 0/14 206s 20 h-m-p 1.6000 8.0000 0.0298 YC 901.630916 1 1.0280 521 | 0/14 206s 21 h-m-p 1.6000 8.0000 0.0025 C 901.630909 0 1.2845 552 | 0/14 206s 22 h-m-p 1.6000 8.0000 0.0005 Y 901.630907 0 2.6131 583 | 0/14 206s 23 h-m-p 1.3671 8.0000 0.0010 ++ 901.630903 m 8.0000 614 | 0/14 206s 24 h-m-p 0.6708 8.0000 0.0124 +C 901.630894 0 2.8798 646 | 0/14 206s 25 h-m-p 1.6000 8.0000 0.0027 C 901.630891 0 1.5068 677 | 0/14 206s 26 h-m-p 1.6000 8.0000 0.0001 Y 901.630891 0 1.1034 708 | 0/14 206s 27 h-m-p 1.6000 8.0000 0.0000 Y 901.630891 0 1.1926 739 | 0/14 206s 28 h-m-p 0.7413 8.0000 0.0000 -C 901.630891 0 0.0463 771 | 0/14 206s 29 h-m-p 0.0396 8.0000 0.0000 -----Y 901.630891 0 0.0000 807 206s Out.. 206s lnL = -901.630891 206s 808 lfun, 1616 eigenQcodon, 8888 P(t) 206s 206s Tree comparisons (Kishino & Hasegawa 1989; Shimodaira & Hasegawa 1999) 206s Reading lnf for tree # 1 Reading lnf for tree # 2, done. 206s Calculating SEs by sitewise comparison, 0:06 206s RELL Bootstrapping.. replicate: 100 / 10000 0:06 RELL Bootstrapping.. replicate: 200 / 10000 0:06 RELL Bootstrapping.. replicate: 300 / 10000 0:06 RELL Bootstrapping.. replicate: 400 / 10000 0:06 RELL Bootstrapping.. replicate: 500 / 10000 0:06 RELL Bootstrapping.. replicate: 600 / 10000 0:06 RELL Bootstrapping.. replicate: 700 / 10000 0:06 RELL Bootstrapping.. replicate: 800 / 10000 0:06 RELL Bootstrapping.. replicate: 900 / 10000 0:06 RELL Bootstrapping.. replicate: 1000 / 10000 0:06 RELL Bootstrapping.. replicate: 1100 / 10000 0:06 RELL Bootstrapping.. replicate: 1200 / 10000 0:06 RELL Bootstrapping.. replicate: 1300 / 10000 0:06 RELL Bootstrapping.. replicate: 1400 / 10000 0:06 RELL Bootstrapping.. replicate: 1500 / 10000 0:06 RELL Bootstrapping.. replicate: 1600 / 10000 0:06 RELL Bootstrapping.. replicate: 1700 / 10000 0:06 RELL Bootstrapping.. replicate: 1800 / 10000 0:06 RELL Bootstrapping.. replicate: 1900 / 10000 0:06 RELL Bootstrapping.. replicate: 2000 / 10000 0:06 RELL Bootstrapping.. replicate: 2100 / 10000 0:06 RELL Bootstrapping.. replicate: 2200 / 10000 0:06 RELL Bootstrapping.. replicate: 2300 / 10000 0:06 RELL Bootstrapping.. replicate: 2400 / 10000 0:06 RELL Bootstrapping.. replicate: 2500 / 10000 0:06 RELL Bootstrapping.. replicate: 2600 / 10000 0:06 RELL Bootstrapping.. replicate: 2700 / 10000 0:06 RELL Bootstrapping.. replicate: 2800 / 10000 0:06 RELL Bootstrapping.. replicate: 2900 / 10000 0:06 RELL Bootstrapping.. replicate: 3000 / 10000 0:06 RELL Bootstrapping.. replicate: 3100 / 10000 0:06 RELL Bootstrapping.. replicate: 3200 / 10000 0:06 RELL Bootstrapping.. replicate: 3300 / 10000 0:06 RELL Bootstrapping.. replicate: 3400 / 10000 0:06 RELL Bootstrapping.. replicate: 3500 / 10000 0:06 RELL Bootstrapping.. replicate: 3600 / 10000 0:06 RELL Bootstrapping.. replicate: 3700 / 10000 0:06 RELL Bootstrapping.. replicate: 3800 / 10000 0:06 RELL Bootstrapping.. replicate: 3900 / 10000 0:06 RELL Bootstrapping.. replicate: 4000 / 10000 0:06 RELL Bootstrapping.. replicate: 4100 / 10000 0:06 RELL Bootstrapping.. replicate: 4200 / 10000 0:06 RELL Bootstrapping.. replicate: 4300 / 10000 0:06 RELL Bootstrapping.. replicate: 4400 / 10000 0:06 RELL Bootstrapping.. replicate: 4500 / 10000 0:06 RELL Bootstrapping.. replicate: 4600 / 10000 0:06 RELL Bootstrapping.. replicate: 4700 / 10000 0:06 RELL Bootstrapping.. replicate: 4800 / 10000 0:06 RELL Bootstrapping.. replicate: 4900 / 10000 0:06 RELL Bootstrapping.. replicate: 5000 / 10000 0:06 RELL Bootstrapping.. replicate: 5100 / 10000 0:06 RELL Bootstrapping.. replicate: 5200 / 10000 0:06 RELL Bootstrapping.. replicate: 5300 / 10000 0:06 RELL Bootstrapping.. replicate: 5400 / 10000 0:06 RELL Bootstrapping.. replicate: 5500 / 10000 0:06 RELL Bootstrapping.. replicate: 5600 / 10000 0:06 RELL Bootstrapping.. replicate: 5700 / 10000 0:06 RELL Bootstrapping.. replicate: 5800 / 10000 0:06 RELL Bootstrapping.. replicate: 5900 / 10000 0:06 RELL Bootstrapping.. replicate: 6000 / 10000 0:06 RELL Bootstrapping.. replicate: 6100 / 10000 0:06 RELL Bootstrapping.. replicate: 6200 / 10000 0:06 RELL Bootstrapping.. replicate: 6300 / 10000 0:06 RELL Bootstrapping.. replicate: 6400 / 10000 0:06 RELL Bootstrapping.. replicate: 6500 / 10000 0:06 RELL Bootstrapping.. replicate: 6600 / 10000 0:06 RELL Bootstrapping.. replicate: 6700 / 10000 0:06 RELL Bootstrapping.. replicate: 6800 / 10000 0:06 RELL Bootstrapping.. replicate: 6900 / 10000 0:06 RELL Bootstrapping.. replicate: 7000 / 10000 0:06 RELL Bootstrapping.. replicate: 7100 / 10000 0:06 RELL Bootstrapping.. replicate: 7200 / 10000 0:06 RELL Bootstrapping.. replicate: 7300 / 10000 0:06 RELL Bootstrapping.. replicate: 7400 / 10000 0:06 RELL Bootstrapping.. replicate: 7500 / 10000 0:06 RELL Bootstrapping.. replicate: 7600 / 10000 0:06 RELL Bootstrapping.. replicate: 7700 / 10000 0:06 RELL Bootstrapping.. replicate: 7800 / 10000 0:06 RELL Bootstrapping.. replicate: 7900 / 10000 0:06 RELL Bootstrapping.. replicate: 8000 / 10000 0:06 RELL Bootstrapping.. replicate: 8100 / 10000 0:06 RELL Bootstrapping.. replicate: 8200 / 10000 0:06 RELL Bootstrapping.. replicate: 8300 / 10000 0:06 RELL Bootstrapping.. replicate: 8400 / 10000 0:06 RELL Bootstrapping.. replicate: 8500 / 10000 0:06 RELL Bootstrapping.. replicate: 8600 / 10000 0:06 RELL Bootstrapping.. replicate: 8700 / 10000 0:06 RELL Bootstrapping.. replicate: 8800 / 10000 0:06 RELL Bootstrapping.. replicate: 8900 / 10000 0:06 RELL Bootstrapping.. replicate: 9000 / 10000 0:06 RELL Bootstrapping.. replicate: 9100 / 10000 0:06 RELL Bootstrapping.. replicate: 9200 / 10000 0:06 RELL Bootstrapping.. replicate: 9300 / 10000 0:06 RELL Bootstrapping.. replicate: 9400 / 10000 0:06 RELL Bootstrapping.. replicate: 9500 / 10000 0:06 RELL Bootstrapping.. replicate: 9600 / 10000 0:06 RELL Bootstrapping.. replicate: 9700 / 10000 0:06 RELL Bootstrapping.. replicate: 9800 / 10000 0:06 RELL Bootstrapping.. replicate: 9900 / 10000 0:06 RELL Bootstrapping.. replicate: 10000 / 10000 0:06 206s now doing S-H test 206s 206s Time used: 0:06 206s Passed 206s 206s autopkgtest [16:32:35]: test run-unit-test: -----------------------] 207s run-unit-test PASS 207s autopkgtest [16:32:36]: test run-unit-test: - - - - - - - - - - results - - - - - - - - - - 208s autopkgtest [16:32:37]: @@@@@@@@@@@@@@@@@@@@ summary 208s run-unit-test PASS 218s nova [W] Using flock in prodstack6-s390x 218s flock: timeout while waiting to get lock 218s Creating nova instance adt-plucky-s390x-paml-20250315-162909-juju-7f2275-prod-proposed-migration-environment-15-2f7f861e-f69f-4cce-ab75-872980347385 from image adt/ubuntu-plucky-s390x-server-20250315.img (UUID 3d3557fa-fd0f-4bba-9b89-8d5964e09f61)... 218s nova [W] Timed out waiting for ce6c96a4-47b6-4806-8799-f63758d049c0 to get deleted.