0s autopkgtest [16:39:10]: starting date and time: 2024-03-18 16:39:10+0000 0s autopkgtest [16:39:10]: git checkout: b506e79c ssh-setup/nova: fix ARCH having two lines of data 0s autopkgtest [16:39:10]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.xn2kedxb/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:elfutils,src:curl,src:gnutls28,src:libarchive,src:libmicrohttpd,src:libpsl,src:nettle --apt-upgrade heaptrack --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=elfutils/0.190-1.1build2 curl/8.5.0-2ubuntu7 gnutls28/3.8.3-1.1ubuntu2 libarchive/3.7.2-1.1ubuntu1 libmicrohttpd/1.0.0-2.1ubuntu1 libpsl/0.21.2-1.1 nettle/3.9.1-2.2' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos02-ppc64el-11.secgroup --name adt-noble-ppc64el-heaptrack-20240318-163910-juju-7f2275-prod-proposed-migration-environment-2 --image adt/ubuntu-noble-ppc64el-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,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com'"'"'' --mirror=http://ftpmaster.internal/ubuntu/ 113s autopkgtest [16:41:03]: testbed dpkg architecture: ppc64el 114s autopkgtest [16:41:04]: testbed apt version: 2.7.12 114s autopkgtest [16:41:04]: @@@@@@@@@@@@@@@@@@@@ test bed setup 115s Get:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease [117 kB] 115s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/restricted Sources [6540 B] 115s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/multiverse Sources [51.4 kB] 115s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/main Sources [485 kB] 115s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/universe Sources [3728 kB] 118s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el Packages [643 kB] 118s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el c-n-f Metadata [3116 B] 118s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/restricted ppc64el Packages [1372 B] 118s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/restricted ppc64el c-n-f Metadata [116 B] 118s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/universe ppc64el Packages [4009 kB] 120s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/universe ppc64el c-n-f Metadata [8652 B] 120s Get:12 http://ftpmaster.internal/ubuntu noble-proposed/multiverse ppc64el Packages [48.0 kB] 121s Get:13 http://ftpmaster.internal/ubuntu noble-proposed/multiverse ppc64el c-n-f Metadata [116 B] 123s Fetched 9102 kB in 7s (1372 kB/s) 123s Reading package lists... 126s Reading package lists... 126s Building dependency tree... 126s Reading state information... 127s Calculating upgrade... 127s The following packages have been kept back: 127s curl 127s 0 upgraded, 0 newly installed, 0 to remove and 1 not upgraded. 127s Reading package lists... 127s Building dependency tree... 127s Reading state information... 127s 0 upgraded, 0 newly installed, 0 to remove and 1 not upgraded. 128s Hit:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease 128s Hit:2 http://ftpmaster.internal/ubuntu noble InRelease 128s Hit:3 http://ftpmaster.internal/ubuntu noble-updates InRelease 128s Hit:4 http://ftpmaster.internal/ubuntu noble-security InRelease 129s Reading package lists... 129s Reading package lists... 129s Building dependency tree... 129s Reading state information... 129s Calculating upgrade... 129s The following packages have been kept back: 129s curl 129s 0 upgraded, 0 newly installed, 0 to remove and 1 not upgraded. 129s Reading package lists... 130s Building dependency tree... 130s Reading state information... 130s 0 upgraded, 0 newly installed, 0 to remove and 1 not upgraded. 133s autopkgtest [16:41:23]: testbed running kernel: Linux 6.8.0-11-generic #11-Ubuntu SMP Wed Feb 14 00:33:03 UTC 2024 133s autopkgtest [16:41:23]: @@@@@@@@@@@@@@@@@@@@ apt-source heaptrack 137s Get:1 http://ftpmaster.internal/ubuntu noble/universe heaptrack 1.5.0+dfsg1-2ubuntu1 (dsc) [2663 B] 137s Get:2 http://ftpmaster.internal/ubuntu noble/universe heaptrack 1.5.0+dfsg1-2ubuntu1 (tar) [5445 kB] 137s Get:3 http://ftpmaster.internal/ubuntu noble/universe heaptrack 1.5.0+dfsg1-2ubuntu1 (diff) [7932 B] 137s gpgv: Signature made Sun Dec 31 14:04:04 2023 UTC 137s gpgv: using RSA key 0CCBCFACAEBDBB9C2C8F34B622A04BEF9168BAD5 137s gpgv: issuer "rikmills@kde.org" 137s gpgv: Can't check signature: No public key 137s dpkg-source: warning: cannot verify inline signature for ./heaptrack_1.5.0+dfsg1-2ubuntu1.dsc: no acceptable signature found 137s autopkgtest [16:41:27]: testing package heaptrack version 1.5.0+dfsg1-2ubuntu1 138s autopkgtest [16:41:28]: build not needed 141s autopkgtest [16:41:31]: test 01-heaptrack: preparing testbed 144s Reading package lists... 144s Building dependency tree... 144s Reading state information... 144s Starting pkgProblemResolver with broken count: 0 144s Starting 2 pkgProblemResolver with broken count: 0 144s Done 144s The following additional packages will be installed: 144s heaptrack libboost-filesystem1.83.0 libboost-iostreams1.83.0 144s libboost-program-options1.83.0 libdw1 libheaptrack libunwind8 144s The following NEW packages will be installed: 144s autopkgtest-satdep heaptrack libboost-filesystem1.83.0 144s libboost-iostreams1.83.0 libboost-program-options1.83.0 libdw1 libheaptrack 144s libunwind8 144s 0 upgraded, 8 newly installed, 0 to remove and 1 not upgraded. 144s Need to get 1748 kB/1749 kB of archives. 144s After this operation, 9428 kB of additional disk space will be used. 144s Get:1 /tmp/autopkgtest.l0fzQA/1-autopkgtest-satdep.deb autopkgtest-satdep ppc64el 0 [712 B] 145s Get:2 http://ftpmaster.internal/ubuntu noble/main ppc64el libboost-filesystem1.83.0 ppc64el 1.83.0-2ubuntu1 [373 kB] 145s Get:3 http://ftpmaster.internal/ubuntu noble/main ppc64el libboost-iostreams1.83.0 ppc64el 1.83.0-2ubuntu1 [340 kB] 145s Get:4 http://ftpmaster.internal/ubuntu noble/main ppc64el libboost-program-options1.83.0 ppc64el 1.83.0-2ubuntu1 [421 kB] 145s Get:5 http://ftpmaster.internal/ubuntu noble/main ppc64el libdw1 ppc64el 0.190-1 [294 kB] 145s Get:6 http://ftpmaster.internal/ubuntu noble/main ppc64el libunwind8 ppc64el 1.6.2-3 [59.9 kB] 145s Get:7 http://ftpmaster.internal/ubuntu noble/universe ppc64el libheaptrack ppc64el 1.5.0+dfsg1-2ubuntu1 [101 kB] 145s Get:8 http://ftpmaster.internal/ubuntu noble/universe ppc64el heaptrack ppc64el 1.5.0+dfsg1-2ubuntu1 [159 kB] 146s Fetched 1748 kB in 1s (1436 kB/s) 146s Selecting previously unselected package libboost-filesystem1.83.0:ppc64el. 146s (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 ... 70095 files and directories currently installed.) 146s Preparing to unpack .../0-libboost-filesystem1.83.0_1.83.0-2ubuntu1_ppc64el.deb ... 146s Unpacking libboost-filesystem1.83.0:ppc64el (1.83.0-2ubuntu1) ... 146s Selecting previously unselected package libboost-iostreams1.83.0:ppc64el. 146s Preparing to unpack .../1-libboost-iostreams1.83.0_1.83.0-2ubuntu1_ppc64el.deb ... 146s Unpacking libboost-iostreams1.83.0:ppc64el (1.83.0-2ubuntu1) ... 146s Selecting previously unselected package libboost-program-options1.83.0:ppc64el. 146s Preparing to unpack .../2-libboost-program-options1.83.0_1.83.0-2ubuntu1_ppc64el.deb ... 146s Unpacking libboost-program-options1.83.0:ppc64el (1.83.0-2ubuntu1) ... 146s Selecting previously unselected package libdw1:ppc64el. 146s Preparing to unpack .../3-libdw1_0.190-1_ppc64el.deb ... 146s Unpacking libdw1:ppc64el (0.190-1) ... 146s Selecting previously unselected package libunwind8:ppc64el. 146s Preparing to unpack .../4-libunwind8_1.6.2-3_ppc64el.deb ... 146s Unpacking libunwind8:ppc64el (1.6.2-3) ... 146s Selecting previously unselected package libheaptrack. 146s Preparing to unpack .../5-libheaptrack_1.5.0+dfsg1-2ubuntu1_ppc64el.deb ... 146s Unpacking libheaptrack (1.5.0+dfsg1-2ubuntu1) ... 146s Selecting previously unselected package heaptrack. 146s Preparing to unpack .../6-heaptrack_1.5.0+dfsg1-2ubuntu1_ppc64el.deb ... 146s Unpacking heaptrack (1.5.0+dfsg1-2ubuntu1) ... 146s Selecting previously unselected package autopkgtest-satdep. 146s Preparing to unpack .../7-1-autopkgtest-satdep.deb ... 146s Unpacking autopkgtest-satdep (0) ... 146s Setting up libboost-program-options1.83.0:ppc64el (1.83.0-2ubuntu1) ... 146s Setting up libdw1:ppc64el (0.190-1) ... 146s Setting up libboost-filesystem1.83.0:ppc64el (1.83.0-2ubuntu1) ... 146s Setting up libunwind8:ppc64el (1.6.2-3) ... 146s Setting up libboost-iostreams1.83.0:ppc64el (1.83.0-2ubuntu1) ... 146s Setting up libheaptrack (1.5.0+dfsg1-2ubuntu1) ... 146s Setting up heaptrack (1.5.0+dfsg1-2ubuntu1) ... 146s Setting up autopkgtest-satdep (0) ... 146s Processing triggers for man-db (2.12.0-3) ... 146s Processing triggers for libc-bin (2.39-0ubuntu2) ... 149s (Reading database ... 70141 files and directories currently installed.) 149s Removing autopkgtest-satdep (0) ... 149s autopkgtest [16:41:39]: test 01-heaptrack: [----------------------- 149s /tmp/tmp.1UHpeQr0Vv 149s heaptrack output will be written to "/tmp/tmp.1UHpeQr0Vv/heaptrack.ls.2313.zst" 149s starting application, this might take some time... 149s heaptrack.ls.2313.zst 149s heaptrack stats: 149s allocations: 241 149s leaked allocations: 151 149s temporary allocations: 68 149s Heaptrack finished! Now run the following to investigate the data: 149s 149s heaptrack --analyze "/tmp/tmp.1UHpeQr0Vv/heaptrack.ls.2313.zst" 149s total 4 149s -rw-rw-r-- 1 ubuntu ubuntu 2140 Mar 18 16:41 heaptrack.ls.2313.zst 149s reading file "heaptrack.ls.2313.zst" - please wait, this might take some time... 149s Debuggee command was: /bin/ls 149s finished reading file, now analyzing data: 149s 149s MOST CALLS TO ALLOCATION FUNCTIONS 149s 236 calls to allocation functions with 116.54K peak consumption from 149s malloc 149s in /usr/lib/heaptrack/libheaptrack_preload.so 149s 36 calls with 838B peak consumption from: 149s 0x64969a446033 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x64969a4464db 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x64969a439157 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s setlocale 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x1fcea3d946f7 149s in /usr/bin/ls 149s 0x64969a426dcb 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s __libc_start_main 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 24 calls with 1.73K peak consumption from: 149s 0x64969a446373 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x64969a4464db 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x64969a439157 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s setlocale 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x1fcea3d946f7 149s in /usr/bin/ls 149s 0x64969a426dcb 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s __libc_start_main 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 24 calls with 353B peak consumption from: 149s 0x64969a446033 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x64969a4464db 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x64969a4464db 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x64969a439157 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s setlocale 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x1fcea3d946f7 149s in /usr/bin/ls 149s 0x64969a426dcb 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s __libc_start_main 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 12 calls with 96B peak consumption from: 149s __strdup 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s setlocale 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x1fcea3d946f7 149s in /usr/bin/ls 149s 0x64969a426dcb 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s __libc_start_main 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 12 calls with 84B peak consumption from: 149s __strndup 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x64969a4390db 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s setlocale 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x1fcea3d946f7 149s in /usr/bin/ls 149s 0x64969a426dcb 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s __libc_start_main 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s and 128 from 36 other places 149s 149s 5 calls to allocation functions with 24.45K peak consumption from 149s realloc 149s in /usr/lib/heaptrack/libheaptrack_preload.so 149s 2 calls with 2.05K peak consumption from: 149s 0x64969a445733 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x64969a445a53 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x64969a438d07 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s setlocale 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x1fcea3d946f7 149s in /usr/bin/ls 149s 0x64969a426dcb 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s __libc_start_main 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 1 calls with 1.60K peak consumption from: 149s 0x64969a44562f 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x64969a445a53 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x64969a438d07 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s setlocale 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x1fcea3d946f7 149s in /usr/bin/ls 149s 0x64969a426dcb 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s __libc_start_main 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 1 calls with 20.80K peak consumption from: 149s reallocarray 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x1fcea3d958df 149s in /usr/bin/ls 149s 0x64969a426dcb 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s __libc_start_main 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 1 calls with 0B peak consumption from: 149s reallocarray 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x1fcea3da6f6f 149s in /usr/bin/ls 149s 0x1fcea3daa67b 149s in /usr/bin/ls 149s 0x1fcea3d959eb 149s in /usr/bin/ls 149s 0x64969a426dcb 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s __libc_start_main 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 149s 149s PEAK MEMORY CONSUMERS 149s 116.54K peak memory consumed over 236 calls from 149s malloc 149s in /usr/lib/heaptrack/libheaptrack_preload.so 149s 73.73K consumed over 1 calls from: 149s 0x64969a0c4de3 149s in /lib/powerpc64le-linux-gnu/libstdc++.so.6 149s 0x64969a8d85eb 149s in /lib64/ld64.so.2 149s 0x64969a9069d7 149s in /lib64/ld64.so.2 149s 32.82K consumed over 1 calls from: 149s opendir 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x1fcea3daa2e7 149s in /usr/bin/ls 149s 0x1fcea3d959eb 149s in /usr/bin/ls 149s 0x64969a426dcb 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s __libc_start_main 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 2.86K consumed over 11 calls from: 149s 0x64969a43a1db 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x64969a43af93 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x64969a43906b 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s setlocale 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x1fcea3d946f7 149s in /usr/bin/ls 149s 0x64969a426dcb 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s __libc_start_main 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 1.73K consumed over 24 calls from: 149s 0x64969a446373 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x64969a4464db 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x64969a439157 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s setlocale 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x1fcea3d946f7 149s in /usr/bin/ls 149s 0x64969a426dcb 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s __libc_start_main 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 1.25K consumed over 12 calls from: 149s 0x64969a446373 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x64969a439157 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s setlocale 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x1fcea3d946f7 149s in /usr/bin/ls 149s 0x64969a426dcb 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s __libc_start_main 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s and 4.16K from 36 other places 149s 149s 24.45K peak memory consumed over 5 calls from 149s realloc 149s in /usr/lib/heaptrack/libheaptrack_preload.so 149s 20.80K consumed over 1 calls from: 149s reallocarray 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x1fcea3d958df 149s in /usr/bin/ls 149s 0x64969a426dcb 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s __libc_start_main 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 2.05K consumed over 2 calls from: 149s 0x64969a445733 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x64969a445a53 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x64969a438d07 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s setlocale 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x1fcea3d946f7 149s in /usr/bin/ls 149s 0x64969a426dcb 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s __libc_start_main 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 1.60K consumed over 1 calls from: 149s 0x64969a44562f 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x64969a445a53 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x64969a438d07 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s setlocale 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x1fcea3d946f7 149s in /usr/bin/ls 149s 0x64969a426dcb 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s __libc_start_main 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 149s 149s MOST TEMPORARY ALLOCATIONS 149s 68 temporary allocations of 236 allocations in total (28.81%) from 149s malloc 149s in /usr/lib/heaptrack/libheaptrack_preload.so 149s 12 temporary allocations of 12 allocations in total (100.00%) from: 149s 0x64969a4467ff 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x64969a4397fb 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x64969a4387e7 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s setlocale 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x1fcea3d946f7 149s in /usr/bin/ls 149s 0x64969a426dcb 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s __libc_start_main 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 12 temporary allocations of 12 allocations in total (100.00%) from: 149s 0x64969a446033 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x64969a438b97 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s setlocale 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x1fcea3d946f7 149s in /usr/bin/ls 149s 0x64969a426dcb 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s __libc_start_main 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 12 temporary allocations of 36 allocations in total (33.33%) from: 149s 0x64969a446033 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x64969a4464db 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x64969a439157 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s setlocale 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x1fcea3d946f7 149s in /usr/bin/ls 149s 0x64969a426dcb 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s __libc_start_main 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 12 temporary allocations of 24 allocations in total (50.00%) from: 149s 0x64969a446033 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x64969a4464db 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x64969a4464db 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x64969a439157 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s setlocale 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x1fcea3d946f7 149s in /usr/bin/ls 149s 0x64969a426dcb 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s __libc_start_main 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 4 temporary allocations of 4 allocations in total (100.00%) from: 149s 0x64969a446033 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x64969a446603 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x64969a446603 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x64969a4464db 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x64969a439157 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s setlocale 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x1fcea3d946f7 149s in /usr/bin/ls 149s 0x64969a426dcb 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s __libc_start_main 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s and 16B from 36 other places 149s 149s 1 temporary allocations of 5 allocations in total (20.00%) from 149s realloc 149s in /usr/lib/heaptrack/libheaptrack_preload.so 149s 1 temporary allocations of 2 allocations in total (50.00%) from: 149s 0x64969a445733 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x64969a445a53 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x64969a438d07 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s setlocale 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 0x1fcea3d946f7 149s in /usr/bin/ls 149s 0x64969a426dcb 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s __libc_start_main 149s in /lib/powerpc64le-linux-gnu/libc.so.6 149s 149s 149s total runtime: 0.01s. 149s calls to allocation functions: 241 (16066/s) 149s temporary memory allocations: 69 (4600/s) 149s peak heap memory consumption: 140.99K 149s peak RSS (including heaptrack overhead): 6.29M 149s total memory leaked: 34.44K 150s autopkgtest [16:41:40]: test 01-heaptrack: -----------------------] 150s autopkgtest [16:41:40]: test 01-heaptrack: - - - - - - - - - - results - - - - - - - - - - 150s 01-heaptrack PASS 151s autopkgtest [16:41:41]: test 02-heaptrack: preparing testbed 153s Reading package lists... 153s Building dependency tree... 153s Reading state information... 153s Starting pkgProblemResolver with broken count: 0 153s Starting 2 pkgProblemResolver with broken count: 0 153s Done 154s The following NEW packages will be installed: 154s autopkgtest-satdep 154s 0 upgraded, 1 newly installed, 0 to remove and 1 not upgraded. 154s Need to get 0 B/704 B of archives. 154s After this operation, 0 B of additional disk space will be used. 154s Get:1 /tmp/autopkgtest.l0fzQA/2-autopkgtest-satdep.deb autopkgtest-satdep ppc64el 0 [704 B] 154s Selecting previously unselected package autopkgtest-satdep. 154s (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 ... 70141 files and directories currently installed.) 154s Preparing to unpack .../2-autopkgtest-satdep.deb ... 154s Unpacking autopkgtest-satdep (0) ... 154s Setting up autopkgtest-satdep (0) ... 156s (Reading database ... 70141 files and directories currently installed.) 156s Removing autopkgtest-satdep (0) ... 157s autopkgtest [16:41:47]: test 02-heaptrack: [----------------------- 157s /tmp/tmp.p2W7E5PkYq 157s heaptrack output will be written to "/tmp/tmp.p2W7E5PkYq/heaptrack.timeout.2585.zst" 157s starting application, this might take some time... 157s top: failed tty get 157s heaptrack stats: 157s allocations: 228 157s leaked allocations: 145 157s temporary allocations: 68 157s Heaptrack finished! Now run the following to investigate the data: 157s 157s heaptrack --analyze "/tmp/tmp.p2W7E5PkYq/heaptrack.timeout.2585.zst" 157s total 4 157s -rw-rw-r-- 1 ubuntu ubuntu 1694 Mar 18 16:41 heaptrack.timeout.2585.zst 157s reading file "heaptrack.timeout.2585.zst" - please wait, this might take some time... 157s Debuggee command was: timeout 5 /usr/bin/top 157s finished reading file, now analyzing data: 157s 157s MOST CALLS TO ALLOCATION FUNCTIONS 157s 225 calls to allocation functions with 83.43K peak consumption from 157s malloc 157s in /usr/lib/heaptrack/libheaptrack_preload.so 157s 36 calls with 838B peak consumption from: 157s 0x72bea9a46033 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x72bea9a464db 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x72bea9a39157 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s setlocale 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x158c4fbc2323 157s in /usr/bin/timeout 157s 0x72bea9a26dcb 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s __libc_start_main 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 24 calls with 1.73K peak consumption from: 157s 0x72bea9a46373 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x72bea9a464db 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x72bea9a39157 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s setlocale 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x158c4fbc2323 157s in /usr/bin/timeout 157s 0x72bea9a26dcb 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s __libc_start_main 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 24 calls with 353B peak consumption from: 157s 0x72bea9a46033 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x72bea9a464db 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x72bea9a464db 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x72bea9a39157 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s setlocale 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x158c4fbc2323 157s in /usr/bin/timeout 157s 0x72bea9a26dcb 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s __libc_start_main 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 12 calls with 0B peak consumption from: 157s 0x72bea9a467ff 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x72bea9a397fb 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x72bea9a387e7 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s setlocale 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x158c4fbc2323 157s in /usr/bin/timeout 157s 0x72bea9a26dcb 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s __libc_start_main 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 12 calls with 96B peak consumption from: 157s __strdup 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s setlocale 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x158c4fbc2323 157s in /usr/bin/timeout 157s 0x72bea9a26dcb 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s __libc_start_main 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s and 117 from 25 other places 157s 157s 3 calls to allocation functions with 3.65K peak consumption from 157s realloc 157s in /usr/lib/heaptrack/libheaptrack_preload.so 157s 2 calls with 2.05K peak consumption from: 157s 0x72bea9a45733 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x72bea9a45a53 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x72bea9a38d07 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s setlocale 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x158c4fbc2323 157s in /usr/bin/timeout 157s 0x72bea9a26dcb 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s __libc_start_main 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 1 calls with 1.60K peak consumption from: 157s 0x72bea9a4562f 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x72bea9a45a53 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x72bea9a38d07 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s setlocale 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x158c4fbc2323 157s in /usr/bin/timeout 157s 0x72bea9a26dcb 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s __libc_start_main 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 157s 157s PEAK MEMORY CONSUMERS 157s 83.43K peak memory consumed over 225 calls from 157s malloc 157s in /usr/lib/heaptrack/libheaptrack_preload.so 157s 73.73K consumed over 1 calls from: 157s 0x72bea96c4de3 157s in /lib/powerpc64le-linux-gnu/libstdc++.so.6 157s 0x72bea9dc85eb 157s in /lib64/ld64.so.2 157s 0x72bea9df69d7 157s in /lib64/ld64.so.2 157s 2.86K consumed over 11 calls from: 157s 0x72bea9a3a1db 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x72bea9a3af93 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x72bea9a3906b 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s setlocale 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x158c4fbc2323 157s in /usr/bin/timeout 157s 0x72bea9a26dcb 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s __libc_start_main 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 1.73K consumed over 24 calls from: 157s 0x72bea9a46373 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x72bea9a464db 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x72bea9a39157 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s setlocale 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x158c4fbc2323 157s in /usr/bin/timeout 157s 0x72bea9a26dcb 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s __libc_start_main 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 1.25K consumed over 12 calls from: 157s 0x72bea9a46373 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x72bea9a39157 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s setlocale 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x158c4fbc2323 157s in /usr/bin/timeout 157s 0x72bea9a26dcb 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s __libc_start_main 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 838B consumed over 36 calls from: 157s 0x72bea9a46033 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x72bea9a464db 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x72bea9a39157 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s setlocale 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x158c4fbc2323 157s in /usr/bin/timeout 157s 0x72bea9a26dcb 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s __libc_start_main 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s and 3.02K from 25 other places 157s 157s 3.65K peak memory consumed over 3 calls from 157s realloc 157s in /usr/lib/heaptrack/libheaptrack_preload.so 157s 2.05K consumed over 2 calls from: 157s 0x72bea9a45733 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x72bea9a45a53 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x72bea9a38d07 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s setlocale 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x158c4fbc2323 157s in /usr/bin/timeout 157s 0x72bea9a26dcb 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s __libc_start_main 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 1.60K consumed over 1 calls from: 157s 0x72bea9a4562f 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x72bea9a45a53 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x72bea9a38d07 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s setlocale 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x158c4fbc2323 157s in /usr/bin/timeout 157s 0x72bea9a26dcb 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s __libc_start_main 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 157s 157s MOST TEMPORARY ALLOCATIONS 157s 67 temporary allocations of 225 allocations in total (29.78%) from 157s malloc 157s in /usr/lib/heaptrack/libheaptrack_preload.so 157s 12 temporary allocations of 12 allocations in total (100.00%) from: 157s 0x72bea9a467ff 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x72bea9a397fb 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x72bea9a387e7 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s setlocale 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x158c4fbc2323 157s in /usr/bin/timeout 157s 0x72bea9a26dcb 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s __libc_start_main 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 12 temporary allocations of 36 allocations in total (33.33%) from: 157s 0x72bea9a46033 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x72bea9a464db 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x72bea9a39157 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s setlocale 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x158c4fbc2323 157s in /usr/bin/timeout 157s 0x72bea9a26dcb 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s __libc_start_main 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 12 temporary allocations of 12 allocations in total (100.00%) from: 157s 0x72bea9a46033 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x72bea9a38b97 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s setlocale 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x158c4fbc2323 157s in /usr/bin/timeout 157s 0x72bea9a26dcb 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s __libc_start_main 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 12 temporary allocations of 24 allocations in total (50.00%) from: 157s 0x72bea9a46033 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x72bea9a464db 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x72bea9a464db 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x72bea9a39157 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s setlocale 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x158c4fbc2323 157s in /usr/bin/timeout 157s 0x72bea9a26dcb 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s __libc_start_main 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 4 temporary allocations of 4 allocations in total (100.00%) from: 157s 0x72bea9a46033 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x72bea9a46603 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x72bea9a46603 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x72bea9a39157 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s setlocale 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x158c4fbc2323 157s in /usr/bin/timeout 157s 0x72bea9a26dcb 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s __libc_start_main 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s and 15B from 25 other places 157s 157s 1 temporary allocations of 3 allocations in total (33.33%) from 157s realloc 157s in /usr/lib/heaptrack/libheaptrack_preload.so 157s 1 temporary allocations of 2 allocations in total (50.00%) from: 157s 0x72bea9a45733 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x72bea9a45a53 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x72bea9a38d07 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s setlocale 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 0x158c4fbc2323 157s in /usr/bin/timeout 157s 0x72bea9a26dcb 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s __libc_start_main 157s in /lib/powerpc64le-linux-gnu/libc.so.6 157s 157s 157s total runtime: 0.12s. 157s calls to allocation functions: 228 (1932/s) 157s temporary memory allocations: 68 (576/s) 157s peak heap memory consumption: 87.08K 157s peak RSS (including heaptrack overhead): 4.19M 157s total memory leaked: 13.35K 157s autopkgtest [16:41:47]: test 02-heaptrack: -----------------------] 158s autopkgtest [16:41:48]: test 02-heaptrack: - - - - - - - - - - results - - - - - - - - - - 158s 02-heaptrack PASS 158s autopkgtest [16:41:48]: @@@@@@@@@@@@@@@@@@@@ summary 158s 01-heaptrack PASS 158s 02-heaptrack PASS 171s Creating nova instance adt-noble-ppc64el-heaptrack-20240318-163910-juju-7f2275-prod-proposed-migration-environment-2 from image adt/ubuntu-noble-ppc64el-server-20240318.img (UUID 290ce4c5-ca44-4691-9a55-79589f8700e4)...