0s autopkgtest [12:43:01]: starting date and time: 2025-01-07 12:43:01+0000 0s autopkgtest [12:43:01]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production' 0s autopkgtest [12:43:01]: host juju-7f2275-prod-proposed-migration-environment-15; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.pigcptrt/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:qtbase-opensource-src,src:icu --apt-upgrade heaptrack --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=qtbase-opensource-src/5.15.15+dfsg-1ubuntu2 icu/76.1-1ubuntu2' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-s390x --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-15@bos03-s390x-17.secgroup --name adt-plucky-s390x-heaptrack-20250107-124301-juju-7f2275-prod-proposed-migration-environment-15-ce2b4ed8-813a-45b1-92dd-18cb077cf97d --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/ 101s autopkgtest [12:44:42]: testbed dpkg architecture: s390x 101s autopkgtest [12:44:42]: testbed apt version: 2.9.18 101s autopkgtest [12:44:42]: @@@@@@@@@@@@@@@@@@@@ test bed setup 101s autopkgtest [12:44:42]: testbed release detected to be: None 102s autopkgtest [12:44:43]: updating testbed package index (apt update) 102s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [73.9 kB] 103s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 103s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 103s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 103s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [750 kB] 103s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [117 kB] 103s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [17.2 kB] 103s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [9708 B] 103s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x Packages [191 kB] 103s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted s390x Packages [756 B] 103s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x Packages [800 kB] 103s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse s390x Packages [5556 B] 103s Fetched 1965 kB in 1s (2101 kB/s) 104s Reading package lists... 104s Reading package lists... 104s Building dependency tree... 104s Reading state information... 105s Calculating upgrade... 105s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 105s Reading package lists... 105s Building dependency tree... 105s Reading state information... 105s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 105s autopkgtest [12:44:46]: upgrading testbed (apt dist-upgrade and autopurge) 105s Reading package lists... 105s Building dependency tree... 105s Reading state information... 105s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 105s Starting 2 pkgProblemResolver with broken count: 0 105s Done 106s Entering ResolveByKeep 106s 106s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 106s Reading package lists... 106s Building dependency tree... 106s Reading state information... 106s Starting pkgProblemResolver with broken count: 0 106s Starting 2 pkgProblemResolver with broken count: 0 106s Done 106s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 109s autopkgtest [12:44:50]: testbed running kernel: Linux 6.11.0-8-generic #8-Ubuntu SMP Mon Sep 16 12:49:35 UTC 2024 109s autopkgtest [12:44:50]: @@@@@@@@@@@@@@@@@@@@ apt-source heaptrack 112s Get:1 http://ftpmaster.internal/ubuntu plucky/universe heaptrack 1.5.0+dfsg1-2ubuntu3 (dsc) [2675 B] 112s Get:2 http://ftpmaster.internal/ubuntu plucky/universe heaptrack 1.5.0+dfsg1-2ubuntu3 (tar) [5445 kB] 112s Get:3 http://ftpmaster.internal/ubuntu plucky/universe heaptrack 1.5.0+dfsg1-2ubuntu3 (diff) [8024 B] 112s gpgv: Signature made Sun Mar 31 18:24:10 2024 UTC 112s gpgv: using RSA key AC483F68DE728F43F2202FCA568D30F321B2133D 112s gpgv: issuer "steve.langasek@ubuntu.com" 112s gpgv: Can't check signature: No public key 112s dpkg-source: warning: cannot verify inline signature for ./heaptrack_1.5.0+dfsg1-2ubuntu3.dsc: no acceptable signature found 112s autopkgtest [12:44:53]: testing package heaptrack version 1.5.0+dfsg1-2ubuntu3 113s autopkgtest [12:44:54]: build not needed 114s autopkgtest [12:44:55]: test 01-heaptrack: preparing testbed 114s Reading package lists... 114s Building dependency tree... 114s Reading state information... 114s Starting pkgProblemResolver with broken count: 0 114s Starting 2 pkgProblemResolver with broken count: 0 114s Done 114s The following NEW packages will be installed: 114s heaptrack libboost-filesystem1.83.0 libboost-iostreams1.83.0 114s libboost-program-options1.83.0 libheaptrack libunwind8 115s 0 upgraded, 6 newly installed, 0 to remove and 0 not upgraded. 115s Need to get 1126 kB of archives. 115s After this operation, 7899 kB of additional disk space will be used. 115s Get:1 http://ftpmaster.internal/ubuntu plucky/main s390x libboost-filesystem1.83.0 s390x 1.83.0-4ubuntu1 [288 kB] 115s Get:2 http://ftpmaster.internal/ubuntu plucky/main s390x libboost-iostreams1.83.0 s390x 1.83.0-4ubuntu1 [259 kB] 115s Get:3 http://ftpmaster.internal/ubuntu plucky/main s390x libboost-program-options1.83.0 s390x 1.83.0-4ubuntu1 [326 kB] 115s Get:4 http://ftpmaster.internal/ubuntu plucky/main s390x libunwind8 s390x 1.6.2-3.1 [46.8 kB] 115s Get:5 http://ftpmaster.internal/ubuntu plucky/universe s390x libheaptrack s390x 1.5.0+dfsg1-2ubuntu3 [83.5 kB] 115s Get:6 http://ftpmaster.internal/ubuntu plucky/universe s390x heaptrack s390x 1.5.0+dfsg1-2ubuntu3 [123 kB] 115s Fetched 1126 kB in 1s (2055 kB/s) 115s Selecting previously unselected package libboost-filesystem1.83.0:s390x. 115s (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 ... 55616 files and directories currently installed.) 115s Preparing to unpack .../0-libboost-filesystem1.83.0_1.83.0-4ubuntu1_s390x.deb ... 115s Unpacking libboost-filesystem1.83.0:s390x (1.83.0-4ubuntu1) ... 115s Selecting previously unselected package libboost-iostreams1.83.0:s390x. 115s Preparing to unpack .../1-libboost-iostreams1.83.0_1.83.0-4ubuntu1_s390x.deb ... 115s Unpacking libboost-iostreams1.83.0:s390x (1.83.0-4ubuntu1) ... 115s Selecting previously unselected package libboost-program-options1.83.0:s390x. 115s Preparing to unpack .../2-libboost-program-options1.83.0_1.83.0-4ubuntu1_s390x.deb ... 115s Unpacking libboost-program-options1.83.0:s390x (1.83.0-4ubuntu1) ... 115s Selecting previously unselected package libunwind8:s390x. 115s Preparing to unpack .../3-libunwind8_1.6.2-3.1_s390x.deb ... 115s Unpacking libunwind8:s390x (1.6.2-3.1) ... 115s Selecting previously unselected package libheaptrack. 115s Preparing to unpack .../4-libheaptrack_1.5.0+dfsg1-2ubuntu3_s390x.deb ... 115s Unpacking libheaptrack (1.5.0+dfsg1-2ubuntu3) ... 115s Selecting previously unselected package heaptrack. 115s Preparing to unpack .../5-heaptrack_1.5.0+dfsg1-2ubuntu3_s390x.deb ... 115s Unpacking heaptrack (1.5.0+dfsg1-2ubuntu3) ... 115s Setting up libboost-program-options1.83.0:s390x (1.83.0-4ubuntu1) ... 115s Setting up libboost-filesystem1.83.0:s390x (1.83.0-4ubuntu1) ... 115s Setting up libunwind8:s390x (1.6.2-3.1) ... 115s Setting up libboost-iostreams1.83.0:s390x (1.83.0-4ubuntu1) ... 115s Setting up libheaptrack (1.5.0+dfsg1-2ubuntu3) ... 115s Setting up heaptrack (1.5.0+dfsg1-2ubuntu3) ... 115s Processing triggers for man-db (2.13.0-1) ... 116s Processing triggers for libc-bin (2.40-4ubuntu1) ... 117s autopkgtest [12:44:58]: test 01-heaptrack: [----------------------- 117s /tmp/tmp.Nnj5Ealbqp 117s heaptrack output will be written to "/tmp/tmp.Nnj5Ealbqp/heaptrack.ls.1795.zst" 117s starting application, this might take some time... 117s heaptrack.ls.1795.zst 117s heaptrack stats: 117s allocations: 241 117s leaked allocations: 151 117s temporary allocations: 68 117s Heaptrack finished! Now run the following to investigate the data: 117s 117s heaptrack --analyze "/tmp/tmp.Nnj5Ealbqp/heaptrack.ls.1795.zst" 117s total 4 117s -rw-rw-r-- 1 ubuntu ubuntu 1972 Jan 7 12:44 heaptrack.ls.1795.zst 117s reading file "heaptrack.ls.1795.zst" - please wait, this might take some time... 117s Debuggee command was: /bin/ls 117s finished reading file, now analyzing data: 117s 117s MOST CALLS TO ALLOCATION FUNCTIONS 117s 203 calls to allocation functions with 45.98K peak consumption from 117s 0x3ffb2b8c4bb 117s in /lib/s390x-linux-gnu/libc.so.6 117s 36 calls with 838B peak consumption from: 117s 0x3ffb2b488c5 117s in /lib/s390x-linux-gnu/libc.so.6 117s 0x3ffb2b3f333 117s in /lib/s390x-linux-gnu/libc.so.6 117s setlocale 117s in /lib/s390x-linux-gnu/libc.so.6 117s main 117s in /usr/bin/ls 117s 24 calls with 353B peak consumption from: 117s 0x3ffb2b488c5 117s in /lib/s390x-linux-gnu/libc.so.6 117s 0x3ffb2b488c5 117s in /lib/s390x-linux-gnu/libc.so.6 117s 0x3ffb2b3f333 117s in /lib/s390x-linux-gnu/libc.so.6 117s setlocale 117s in /lib/s390x-linux-gnu/libc.so.6 117s main 117s in /usr/bin/ls 117s 24 calls with 1.73K peak consumption from: 117s 0x3ffb2b488c5 117s in /lib/s390x-linux-gnu/libc.so.6 117s 0x3ffb2b3f333 117s in /lib/s390x-linux-gnu/libc.so.6 117s setlocale 117s in /lib/s390x-linux-gnu/libc.so.6 117s main 117s in /usr/bin/ls 117s 12 calls with 0B peak consumption from: 117s 0x3ffb2b3f7cb 117s in /lib/s390x-linux-gnu/libc.so.6 117s 0x3ffb2b3eceb 117s in /lib/s390x-linux-gnu/libc.so.6 117s setlocale 117s in /lib/s390x-linux-gnu/libc.so.6 117s main 117s in /usr/bin/ls 117s 12 calls with 672B peak consumption from: 117s 0x3ffb2b488c5 117s in /lib/s390x-linux-gnu/libc.so.6 117s 0x3ffb2b488c5 117s in /lib/s390x-linux-gnu/libc.so.6 117s 0x3ffb2b3f333 117s in /lib/s390x-linux-gnu/libc.so.6 117s setlocale 117s in /lib/s390x-linux-gnu/libc.so.6 117s main 117s in /usr/bin/ls 117s and 95 from 24 other places 117s 117s 13 calls to allocation functions with 106B peak consumption from 117s __strdup 117s in /lib/s390x-linux-gnu/libc.so.6 117s 12 calls with 96B peak consumption from: 117s setlocale 117s in /lib/s390x-linux-gnu/libc.so.6 117s main 117s in /usr/bin/ls 117s 1 calls with 10B peak consumption from: 117s textdomain 117s in /lib/s390x-linux-gnu/libc.so.6 117s main 117s in /usr/bin/ls 117s 117s 12 calls to allocation functions with 84B peak consumption from 117s __strndup 117s in /lib/s390x-linux-gnu/libc.so.6 117s 12 calls with 84B peak consumption from: 117s 0x3ffb2b3f2d3 117s in /lib/s390x-linux-gnu/libc.so.6 117s setlocale 117s in /lib/s390x-linux-gnu/libc.so.6 117s main 117s in /usr/bin/ls 117s 117s 7 calls to allocation functions with 296B peak consumption from 117s 0x2aa2a81317d 117s in /usr/bin/ls 117s 1 calls with 56B peak consumption from: 117s main 117s in /usr/bin/ls 117s 1 calls with 56B peak consumption from: 117s main 117s in /usr/bin/ls 117s 1 calls with 128B peak consumption from: 117s main 117s in /usr/bin/ls 117s 1 calls with 32B peak consumption from: 117s main 117s in /usr/bin/ls 117s 1 calls with 2B peak consumption from: 117s 0x2aa2a811d5f 117s in /usr/bin/ls 117s main 117s in /usr/bin/ls 117s and 2 from 2 other places 117s 117s 3 calls to allocation functions with 0B peak consumption from 117s _IO_file_doallocate 117s in /lib/s390x-linux-gnu/libc.so.6 117s 1 calls with 0B peak consumption from: 117s _IO_doallocbuf 117s in /lib/s390x-linux-gnu/libc.so.6 117s _IO_file_underflow 117s in /lib/s390x-linux-gnu/libc.so.6 117s __getdelim 117s in /lib/s390x-linux-gnu/libc.so.6 117s selinuxfs_exists 117s in /lib/s390x-linux-gnu/libselinux.so.1 117s 0x3ffb2d0738b 117s in /lib/s390x-linux-gnu/libselinux.so.1 117s 0x3ffb2e84b59 117s in /lib/ld64.so.1 117s 0x3ffb2e84c8f 117s in /lib/ld64.so.1 117s 0x3ffb2e98d7b 117s in /lib/ld64.so.1 117s 1 calls with 0B peak consumption from: 117s _IO_doallocbuf 117s in /lib/s390x-linux-gnu/libc.so.6 117s _IO_file_underflow 117s in /lib/s390x-linux-gnu/libc.so.6 117s _IO_default_uflow 117s in /lib/s390x-linux-gnu/libc.so.6 117s _IO_getline_info 117s in /lib/s390x-linux-gnu/libc.so.6 117s _IO_getline 117s in /lib/s390x-linux-gnu/libc.so.6 117s fgets_unlocked 117s in /lib/s390x-linux-gnu/libc.so.6 117s 0x3ffb2b473f3 117s in /lib/s390x-linux-gnu/libc.so.6 117s 0x3ffb2b47a9f 117s in /lib/s390x-linux-gnu/libc.so.6 117s 0x3ffb2b3ecfd 117s in /lib/s390x-linux-gnu/libc.so.6 117s setlocale 117s in /lib/s390x-linux-gnu/libc.so.6 117s main 117s in /usr/bin/ls 117s 1 calls with 0B peak consumption from: 117s _IO_doallocbuf 117s in /lib/s390x-linux-gnu/libc.so.6 117s _IO_file_overflow 117s in /lib/s390x-linux-gnu/libc.so.6 117s _IO_file_xsputn 117s in /lib/s390x-linux-gnu/libc.so.6 117s fwrite_unlocked 117s in /lib/s390x-linux-gnu/libc.so.6 117s 0x2aa2a80f8af 117s in /usr/bin/ls 117s 0x2aa2a80f9db 117s in /usr/bin/ls 117s 0x2aa2a81bfb5 117s in /usr/bin/ls 117s 0x2aa2a81168b 117s in /usr/bin/ls 117s main 117s in /usr/bin/ls 117s 117s 1 calls to allocation functions with 20.80K peak consumption from 117s main 117s in /usr/bin/ls 117s 1 calls with 20.80K peak consumption from: 117s 117s 1 calls to allocation functions with 0B peak consumption from 117s __getdelim 117s in /lib/s390x-linux-gnu/libc.so.6 117s 1 calls with 0B peak consumption from: 117s selinuxfs_exists 117s in /lib/s390x-linux-gnu/libselinux.so.1 117s 0x3ffb2d0738b 117s in /lib/s390x-linux-gnu/libselinux.so.1 117s 0x3ffb2e84b59 117s in /lib/ld64.so.1 117s 0x3ffb2e84c8f 117s in /lib/ld64.so.1 117s 0x3ffb2e98d7b 117s in /lib/ld64.so.1 117s 117s 1 calls to allocation functions with 71.68K peak consumption from 117s 0x3ffb27b5dd1 117s in /lib/s390x-linux-gnu/libstdc++.so.6 117s 1 calls with 71.68K peak consumption from: 117s 0x3ffb2e84b7f 117s in /lib/ld64.so.1 117s 0x3ffb2e84c8f 117s in /lib/ld64.so.1 117s 0x3ffb2e98d7b 117s in /lib/ld64.so.1 117s 117s 117s PEAK MEMORY CONSUMERS 117s 71.68K peak memory consumed over 1 calls from 117s 0x3ffb27b5dd1 117s in /lib/s390x-linux-gnu/libstdc++.so.6 117s 71.68K consumed over 1 calls from: 117s 0x3ffb2e84b7f 117s in /lib/ld64.so.1 117s 0x3ffb2e84c8f 117s in /lib/ld64.so.1 117s 0x3ffb2e98d7b 117s in /lib/ld64.so.1 117s 117s 45.98K peak memory consumed over 203 calls from 117s 0x3ffb2b8c4bb 117s in /lib/s390x-linux-gnu/libc.so.6 117s 32.82K consumed over 1 calls from: 117s 0x2aa2a81240d 117s in /usr/bin/ls 117s main 117s in /usr/bin/ls 117s 2.86K consumed over 11 calls from: 117s 0x3ffb2b40a31 117s in /lib/s390x-linux-gnu/libc.so.6 117s 0x3ffb2b3f27f 117s in /lib/s390x-linux-gnu/libc.so.6 117s setlocale 117s in /lib/s390x-linux-gnu/libc.so.6 117s main 117s in /usr/bin/ls 117s 2.05K consumed over 2 calls from: 117s 0x3ffb2b47a9f 117s in /lib/s390x-linux-gnu/libc.so.6 117s 0x3ffb2b3ecfd 117s in /lib/s390x-linux-gnu/libc.so.6 117s setlocale 117s in /lib/s390x-linux-gnu/libc.so.6 117s main 117s in /usr/bin/ls 117s 1.73K consumed over 24 calls from: 117s 0x3ffb2b488c5 117s in /lib/s390x-linux-gnu/libc.so.6 117s 0x3ffb2b3f333 117s in /lib/s390x-linux-gnu/libc.so.6 117s setlocale 117s in /lib/s390x-linux-gnu/libc.so.6 117s main 117s in /usr/bin/ls 117s 1.60K consumed over 1 calls from: 117s 0x3ffb2b47a9f 117s in /lib/s390x-linux-gnu/libc.so.6 117s 0x3ffb2b3ecfd 117s in /lib/s390x-linux-gnu/libc.so.6 117s setlocale 117s in /lib/s390x-linux-gnu/libc.so.6 117s main 117s in /usr/bin/ls 117s and 4.92K from 24 other places 117s 117s 20.80K peak memory consumed over 1 calls from 117s main 117s in /usr/bin/ls 117s 20.80K consumed over 1 calls from: 117s 117s 296B peak memory consumed over 7 calls from 117s 0x2aa2a81317d 117s in /usr/bin/ls 117s 128B consumed over 1 calls from: 117s main 117s in /usr/bin/ls 117s 56B consumed over 1 calls from: 117s main 117s in /usr/bin/ls 117s 56B consumed over 1 calls from: 117s main 117s in /usr/bin/ls 117s 32B consumed over 1 calls from: 117s main 117s in /usr/bin/ls 117s 22B consumed over 1 calls from: 117s 0x2aa2a81a755 117s in /usr/bin/ls 117s 0x2aa2a81291b 117s in /usr/bin/ls 117s main 117s in /usr/bin/ls 117s and 2B from 2 other places 117s 117s 106B peak memory consumed over 13 calls from 117s __strdup 117s in /lib/s390x-linux-gnu/libc.so.6 117s 96B consumed over 12 calls from: 117s setlocale 117s in /lib/s390x-linux-gnu/libc.so.6 117s main 117s in /usr/bin/ls 117s 10B consumed over 1 calls from: 117s textdomain 117s in /lib/s390x-linux-gnu/libc.so.6 117s main 117s in /usr/bin/ls 117s 117s 84B peak memory consumed over 12 calls from 117s __strndup 117s in /lib/s390x-linux-gnu/libc.so.6 117s 84B consumed over 12 calls from: 117s 0x3ffb2b3f2d3 117s in /lib/s390x-linux-gnu/libc.so.6 117s setlocale 117s in /lib/s390x-linux-gnu/libc.so.6 117s main 117s in /usr/bin/ls 117s 117s 117s MOST TEMPORARY ALLOCATIONS 117s 68 temporary allocations of 203 allocations in total (33.50%) from 117s 0x3ffb2b8c4bb 117s in /lib/s390x-linux-gnu/libc.so.6 117s 12 temporary allocations of 12 allocations in total (100.00%) from: 117s 0x3ffb2b3f7cb 117s in /lib/s390x-linux-gnu/libc.so.6 117s 0x3ffb2b3eceb 117s in /lib/s390x-linux-gnu/libc.so.6 117s setlocale 117s in /lib/s390x-linux-gnu/libc.so.6 117s main 117s in /usr/bin/ls 117s 12 temporary allocations of 12 allocations in total (100.00%) from: 117s 0x3ffb2b3f047 117s in /lib/s390x-linux-gnu/libc.so.6 117s setlocale 117s in /lib/s390x-linux-gnu/libc.so.6 117s main 117s in /usr/bin/ls 117s 12 temporary allocations of 24 allocations in total (50.00%) from: 117s 0x3ffb2b488c5 117s in /lib/s390x-linux-gnu/libc.so.6 117s 0x3ffb2b488c5 117s in /lib/s390x-linux-gnu/libc.so.6 117s 0x3ffb2b3f333 117s in /lib/s390x-linux-gnu/libc.so.6 117s setlocale 117s in /lib/s390x-linux-gnu/libc.so.6 117s main 117s in /usr/bin/ls 117s 12 temporary allocations of 36 allocations in total (33.33%) from: 117s 0x3ffb2b488c5 117s in /lib/s390x-linux-gnu/libc.so.6 117s 0x3ffb2b3f333 117s in /lib/s390x-linux-gnu/libc.so.6 117s setlocale 117s in /lib/s390x-linux-gnu/libc.so.6 117s main 117s in /usr/bin/ls 117s 4 temporary allocations of 4 allocations in total (100.00%) from: 117s 0x3ffb2b4848d 117s in /lib/s390x-linux-gnu/libc.so.6 117s 0x3ffb2b4848d 117s in /lib/s390x-linux-gnu/libc.so.6 117s 0x3ffb2b3f333 117s in /lib/s390x-linux-gnu/libc.so.6 117s setlocale 117s in /lib/s390x-linux-gnu/libc.so.6 117s main 117s in /usr/bin/ls 117s and 16B from 24 other places 117s 117s 1 temporary allocations of 1 allocations in total (100.00%) from 117s 0x3ffb27b5dd1 117s in /lib/s390x-linux-gnu/libstdc++.so.6 117s 1 temporary allocations of 1 allocations in total (100.00%) from: 117s 0x3ffb2e84b7f 117s in /lib/ld64.so.1 117s 0x3ffb2e84c8f 117s in /lib/ld64.so.1 117s 0x3ffb2e98d7b 117s in /lib/ld64.so.1 117s 117s 117s total runtime: 0.00s. 117s calls to allocation functions: 241 (80333/s) 117s temporary memory allocations: 69 (23000/s) 117s peak heap memory consumption: 138.94K 117s peak RSS (including heaptrack overhead): 4.73M 117s total memory leaked: 34.44K 117s autopkgtest [12:44:58]: test 01-heaptrack: -----------------------] 118s autopkgtest [12:44:59]: test 01-heaptrack: - - - - - - - - - - results - - - - - - - - - - 118s 01-heaptrack PASS 118s autopkgtest [12:44:59]: test 02-heaptrack: preparing testbed 118s Reading package lists... 118s Building dependency tree... 118s Reading state information... 118s Starting pkgProblemResolver with broken count: 0 118s Starting 2 pkgProblemResolver with broken count: 0 118s Done 119s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 119s autopkgtest [12:45:00]: test 02-heaptrack: [----------------------- 120s /tmp/tmp.eIL908NW9M 120s heaptrack output will be written to "/tmp/tmp.eIL908NW9M/heaptrack.timeout.1966.zst" 120s starting application, this might take some time... 120s top: failed tty get 120s Heaptrack finished! Now run the following to investigate the data: 120s 120s heaptrack --analyze "/tmp/tmp.eIL908NW9M/heaptrack.timeout.1966.zst" 120s total 4 120s -rw-rw-r-- 1 ubuntu ubuntu 1596 Jan 7 12:45 heaptrack.timeout.1966.zst 120s heaptrack stats: 120s allocations: 228 120s leaked allocations: 145 120s temporary allocations: 68 120s reading file "heaptrack.timeout.1966.zst" - please wait, this might take some time... 120s Debuggee command was: timeout 5 /usr/bin/top 120s finished reading file, now analyzing data: 120s 120s MOST CALLS TO ALLOCATION FUNCTIONS 120s 201 calls to allocation functions with 13.16K peak consumption from 120s 0x3ff92148a89 120s in /lib/s390x-linux-gnu/libc.so.6 120s 36 calls with 838B peak consumption from: 120s 0x3ff921488c5 120s in /lib/s390x-linux-gnu/libc.so.6 120s 0x3ff9213f333 120s in /lib/s390x-linux-gnu/libc.so.6 120s setlocale 120s in /lib/s390x-linux-gnu/libc.so.6 120s main 120s in /usr/bin/timeout 120s 24 calls with 1.73K peak consumption from: 120s 0x3ff921488c5 120s in /lib/s390x-linux-gnu/libc.so.6 120s 0x3ff9213f333 120s in /lib/s390x-linux-gnu/libc.so.6 120s setlocale 120s in /lib/s390x-linux-gnu/libc.so.6 120s main 120s in /usr/bin/timeout 120s 24 calls with 353B peak consumption from: 120s 0x3ff921488c5 120s in /lib/s390x-linux-gnu/libc.so.6 120s 0x3ff921488c5 120s in /lib/s390x-linux-gnu/libc.so.6 120s 0x3ff9213f333 120s in /lib/s390x-linux-gnu/libc.so.6 120s setlocale 120s in /lib/s390x-linux-gnu/libc.so.6 120s main 120s in /usr/bin/timeout 120s 12 calls with 0B peak consumption from: 120s 0x3ff92148c99 120s in /lib/s390x-linux-gnu/libc.so.6 120s 0x3ff9213efbb 120s in /lib/s390x-linux-gnu/libc.so.6 120s setlocale 120s in /lib/s390x-linux-gnu/libc.so.6 120s main 120s in /usr/bin/timeout 120s 12 calls with 0B peak consumption from: 120s 0x3ff9213f047 120s in /lib/s390x-linux-gnu/libc.so.6 120s setlocale 120s in /lib/s390x-linux-gnu/libc.so.6 120s main 120s in /usr/bin/timeout 120s and 93 from 22 other places 120s 120s 13 calls to allocation functions with 106B peak consumption from 120s __strdup 120s in /lib/s390x-linux-gnu/libc.so.6 120s 12 calls with 96B peak consumption from: 120s setlocale 120s in /lib/s390x-linux-gnu/libc.so.6 120s main 120s in /usr/bin/timeout 120s 1 calls with 10B peak consumption from: 120s textdomain 120s in /lib/s390x-linux-gnu/libc.so.6 120s main 120s in /usr/bin/timeout 120s 120s 12 calls to allocation functions with 84B peak consumption from 120s __strndup 120s in /lib/s390x-linux-gnu/libc.so.6 120s 12 calls with 84B peak consumption from: 120s 0x3ff9213f2d3 120s in /lib/s390x-linux-gnu/libc.so.6 120s setlocale 120s in /lib/s390x-linux-gnu/libc.so.6 120s main 120s in /usr/bin/timeout 120s 120s 1 calls to allocation functions with 0B peak consumption from 120s _IO_file_doallocate 120s in /lib/s390x-linux-gnu/libc.so.6 120s 1 calls with 0B peak consumption from: 120s _IO_doallocbuf 120s in /lib/s390x-linux-gnu/libc.so.6 120s _IO_file_underflow 120s in /lib/s390x-linux-gnu/libc.so.6 120s _IO_default_uflow 120s in /lib/s390x-linux-gnu/libc.so.6 120s _IO_getline_info 120s in /lib/s390x-linux-gnu/libc.so.6 120s _IO_getline 120s in /lib/s390x-linux-gnu/libc.so.6 120s fgets_unlocked 120s in /lib/s390x-linux-gnu/libc.so.6 120s 0x3ff921473f3 120s in /lib/s390x-linux-gnu/libc.so.6 120s 0x3ff92147a9f 120s in /lib/s390x-linux-gnu/libc.so.6 120s 0x3ff9213ecfd 120s in /lib/s390x-linux-gnu/libc.so.6 120s setlocale 120s in /lib/s390x-linux-gnu/libc.so.6 120s main 120s in /usr/bin/timeout 120s 120s 1 calls to allocation functions with 71.68K peak consumption from 120s 0x3ff91db5dd1 120s in /lib/s390x-linux-gnu/libstdc++.so.6 120s 1 calls with 71.68K peak consumption from: 120s 0x3ff92484b7f 120s in /lib/ld64.so.1 120s 0x3ff92484c71 120s in /lib/ld64.so.1 120s 0x3ff92498d7b 120s in /lib/ld64.so.1 120s 120s 120s PEAK MEMORY CONSUMERS 120s 71.68K peak memory consumed over 1 calls from 120s 0x3ff91db5dd1 120s in /lib/s390x-linux-gnu/libstdc++.so.6 120s 71.68K consumed over 1 calls from: 120s 0x3ff92484b7f 120s in /lib/ld64.so.1 120s 0x3ff92484c71 120s in /lib/ld64.so.1 120s 0x3ff92498d7b 120s in /lib/ld64.so.1 120s 120s 13.16K peak memory consumed over 201 calls from 120s 0x3ff92148a89 120s in /lib/s390x-linux-gnu/libc.so.6 120s 2.86K consumed over 11 calls from: 120s 0x3ff92140a31 120s in /lib/s390x-linux-gnu/libc.so.6 120s 0x3ff9213f27f 120s in /lib/s390x-linux-gnu/libc.so.6 120s setlocale 120s in /lib/s390x-linux-gnu/libc.so.6 120s main 120s in /usr/bin/timeout 120s 2.05K consumed over 2 calls from: 120s 0x3ff92147a9f 120s in /lib/s390x-linux-gnu/libc.so.6 120s 0x3ff9213ecfd 120s in /lib/s390x-linux-gnu/libc.so.6 120s setlocale 120s in /lib/s390x-linux-gnu/libc.so.6 120s main 120s in /usr/bin/timeout 120s 1.73K consumed over 24 calls from: 120s 0x3ff921488c5 120s in /lib/s390x-linux-gnu/libc.so.6 120s 0x3ff9213f333 120s in /lib/s390x-linux-gnu/libc.so.6 120s setlocale 120s in /lib/s390x-linux-gnu/libc.so.6 120s main 120s in /usr/bin/timeout 120s 1.60K consumed over 1 calls from: 120s 0x3ff92147a9f 120s in /lib/s390x-linux-gnu/libc.so.6 120s 0x3ff9213ecfd 120s in /lib/s390x-linux-gnu/libc.so.6 120s setlocale 120s in /lib/s390x-linux-gnu/libc.so.6 120s main 120s in /usr/bin/timeout 120s 1.25K consumed over 12 calls from: 120s 0x3ff9213f333 120s in /lib/s390x-linux-gnu/libc.so.6 120s setlocale 120s in /lib/s390x-linux-gnu/libc.so.6 120s main 120s in /usr/bin/timeout 120s and 3.67K from 22 other places 120s 120s 106B peak memory consumed over 13 calls from 120s __strdup 120s in /lib/s390x-linux-gnu/libc.so.6 120s 96B consumed over 12 calls from: 120s setlocale 120s in /lib/s390x-linux-gnu/libc.so.6 120s main 120s in /usr/bin/timeout 120s 10B consumed over 1 calls from: 120s textdomain 120s in /lib/s390x-linux-gnu/libc.so.6 120s main 120s in /usr/bin/timeout 120s 120s 84B peak memory consumed over 12 calls from 120s __strndup 120s in /lib/s390x-linux-gnu/libc.so.6 120s 84B consumed over 12 calls from: 120s 0x3ff9213f2d3 120s in /lib/s390x-linux-gnu/libc.so.6 120s setlocale 120s in /lib/s390x-linux-gnu/libc.so.6 120s main 120s in /usr/bin/timeout 120s 120s 120s MOST TEMPORARY ALLOCATIONS 120s 68 temporary allocations of 201 allocations in total (33.83%) from 120s 0x3ff92148a89 120s in /lib/s390x-linux-gnu/libc.so.6 120s 12 temporary allocations of 12 allocations in total (100.00%) from: 120s 0x3ff9213f047 120s in /lib/s390x-linux-gnu/libc.so.6 120s setlocale 120s in /lib/s390x-linux-gnu/libc.so.6 120s main 120s in /usr/bin/timeout 120s 12 temporary allocations of 12 allocations in total (100.00%) from: 120s 0x3ff9213f7cb 120s in /lib/s390x-linux-gnu/libc.so.6 120s 0x3ff9213eceb 120s in /lib/s390x-linux-gnu/libc.so.6 120s setlocale 120s in /lib/s390x-linux-gnu/libc.so.6 120s main 120s in /usr/bin/timeout 120s 12 temporary allocations of 36 allocations in total (33.33%) from: 120s 0x3ff921488c5 120s in /lib/s390x-linux-gnu/libc.so.6 120s 0x3ff9213f333 120s in /lib/s390x-linux-gnu/libc.so.6 120s setlocale 120s in /lib/s390x-linux-gnu/libc.so.6 120s main 120s in /usr/bin/timeout 120s 12 temporary allocations of 24 allocations in total (50.00%) from: 120s 0x3ff921488c5 120s in /lib/s390x-linux-gnu/libc.so.6 120s 0x3ff921488c5 120s in /lib/s390x-linux-gnu/libc.so.6 120s 0x3ff9213f333 120s in /lib/s390x-linux-gnu/libc.so.6 120s setlocale 120s in /lib/s390x-linux-gnu/libc.so.6 120s main 120s in /usr/bin/timeout 120s 4 temporary allocations of 4 allocations in total (100.00%) from: 120s 0x3ff9214848d 120s in /lib/s390x-linux-gnu/libc.so.6 120s 0x3ff9214848d 120s in /lib/s390x-linux-gnu/libc.so.6 120s 0x3ff921488c5 120s in /lib/s390x-linux-gnu/libc.so.6 120s 0x3ff9213f333 120s in /lib/s390x-linux-gnu/libc.so.6 120s setlocale 120s in /lib/s390x-linux-gnu/libc.so.6 120s main 120s in /usr/bin/timeout 120s and 16B from 22 other places 120s 120s 120s total runtime: 0.11s. 120s calls to allocation functions: 228 (2150/s) 120s temporary memory allocations: 68 (641/s) 120s peak heap memory consumption: 85.03K 120s peak RSS (including heaptrack overhead): 4.43M 120s total memory leaked: 13.35K 120s autopkgtest [12:45:01]: test 02-heaptrack: -----------------------] 121s autopkgtest [12:45:02]: test 02-heaptrack: - - - - - - - - - - results - - - - - - - - - - 121s 02-heaptrack PASS 121s autopkgtest [12:45:02]: @@@@@@@@@@@@@@@@@@@@ summary 121s 01-heaptrack PASS 121s 02-heaptrack PASS 127s nova [W] Using flock in prodstack6-s390x 127s flock: timeout while waiting to get lock 127s Creating nova instance adt-plucky-s390x-heaptrack-20250107-124301-juju-7f2275-prod-proposed-migration-environment-15-ce2b4ed8-813a-45b1-92dd-18cb077cf97d from image adt/ubuntu-plucky-s390x-server-20250107.img (UUID 7cc9e1fd-4aed-4e77-b31c-58092e21e4db)... 127s nova [W] Timed out waiting for cb60fabe-ec39-467d-a5ff-498264fb9c31 to get deleted.