0s autopkgtest [02:04:50]: starting date and time: 2024-03-19 02:04:50+0000 0s autopkgtest [02:04:50]: git checkout: b506e79c ssh-setup/nova: fix ARCH having two lines of data 0s autopkgtest [02:04:50]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.8f3wuupx/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:openssl --apt-upgrade librdkafka --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=openssl/3.0.13-0ubuntu2 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos01-ppc64el-19.secgroup --name adt-noble-ppc64el-librdkafka-20240319-020450-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://us.ports.ubuntu.com/ubuntu-ports/ 189s autopkgtest [02:07:59]: testbed dpkg architecture: ppc64el 189s autopkgtest [02:07:59]: testbed apt version: 2.7.12 189s autopkgtest [02:07:59]: @@@@@@@@@@@@@@@@@@@@ test bed setup 190s Get:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease [117 kB] 191s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/restricted Sources [6540 B] 191s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/multiverse Sources [52.0 kB] 191s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/universe Sources [3748 kB] 192s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/main Sources [486 kB] 192s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el Packages [646 kB] 192s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el c-n-f Metadata [3116 B] 192s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/restricted ppc64el Packages [1372 B] 192s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/restricted ppc64el c-n-f Metadata [116 B] 192s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/universe ppc64el Packages [4020 kB] 192s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/universe ppc64el c-n-f Metadata [8652 B] 192s Get:12 http://ftpmaster.internal/ubuntu noble-proposed/multiverse ppc64el Packages [47.3 kB] 192s Get:13 http://ftpmaster.internal/ubuntu noble-proposed/multiverse ppc64el c-n-f Metadata [116 B] 199s Fetched 9136 kB in 4s (2053 kB/s) 200s Reading package lists... 204s Reading package lists... 205s Building dependency tree... 205s Reading state information... 205s Calculating upgrade... 206s The following packages will be REMOVED: 206s libssl3 206s The following NEW packages will be installed: 206s libssl3t64 206s The following packages will be upgraded: 206s openssl 206s 1 upgraded, 1 newly installed, 1 to remove and 0 not upgraded. 206s Need to get 3151 kB of archives. 206s After this operation, 73.7 kB of additional disk space will be used. 206s Get:1 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el openssl ppc64el 3.0.13-0ubuntu2 [1026 kB] 207s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el libssl3t64 ppc64el 3.0.13-0ubuntu2 [2125 kB] 209s Fetched 3151 kB in 2s (1437 kB/s) 209s (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.) 209s Preparing to unpack .../openssl_3.0.13-0ubuntu2_ppc64el.deb ... 209s Unpacking openssl (3.0.13-0ubuntu2) over (3.0.10-1ubuntu4) ... 210s dpkg: libssl3:ppc64el: dependency problems, but removing anyway as you requested: 210s wget depends on libssl3 (>= 3.0.0). 210s tnftp depends on libssl3 (>= 3.0.0). 210s tcpdump depends on libssl3 (>= 3.0.0). 210s systemd-resolved depends on libssl3 (>= 3.0.0). 210s systemd depends on libssl3 (>= 3.0.0). 210s sudo depends on libssl3 (>= 3.0.0). 210s rsync depends on libssl3 (>= 3.0.0). 210s python3-cryptography depends on libssl3 (>= 3.0.0). 210s openssh-server depends on libssl3 (>= 3.0.10). 210s openssh-client depends on libssl3 (>= 3.0.10). 210s linux-headers-6.8.0-11-generic depends on libssl3 (>= 3.0.0). 210s libsystemd-shared:ppc64el depends on libssl3 (>= 3.0.0). 210s libssh-4:ppc64el depends on libssl3 (>= 3.0.0). 210s libsasl2-modules:ppc64el depends on libssl3 (>= 3.0.0). 210s libsasl2-2:ppc64el depends on libssl3 (>= 3.0.0). 210s libpython3.12-minimal:ppc64el depends on libssl3 (>= 3.0.0). 210s libpython3.11-minimal:ppc64el depends on libssl3 (>= 3.0.0). 210s libnvme1 depends on libssl3 (>= 3.0.0). 210s libkrb5-3:ppc64el depends on libssl3 (>= 3.0.0). 210s libkmod2:ppc64el depends on libssl3 (>= 3.0.0). 210s libfido2-1:ppc64el depends on libssl3 (>= 3.0.0). 210s libcurl4:ppc64el depends on libssl3 (>= 3.0.0). 210s libcryptsetup12:ppc64el depends on libssl3 (>= 3.0.0). 210s kmod depends on libssl3 (>= 3.0.0). 210s dhcpcd-base depends on libssl3 (>= 3.0.0). 210s bind9-libs:ppc64el depends on libssl3 (>= 3.0.0). 210s 210s (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.) 210s Removing libssl3:ppc64el (3.0.10-1ubuntu4) ... 210s Selecting previously unselected package libssl3t64:ppc64el. 210s (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 ... 70084 files and directories currently installed.) 210s Preparing to unpack .../libssl3t64_3.0.13-0ubuntu2_ppc64el.deb ... 210s Unpacking libssl3t64:ppc64el (3.0.13-0ubuntu2) ... 210s Setting up libssl3t64:ppc64el (3.0.13-0ubuntu2) ... 210s Setting up openssl (3.0.13-0ubuntu2) ... 210s Processing triggers for man-db (2.12.0-3) ... 213s Processing triggers for libc-bin (2.39-0ubuntu2) ... 214s Reading package lists... 214s Building dependency tree... 214s Reading state information... 215s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 216s Hit:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease 217s Hit:2 http://ftpmaster.internal/ubuntu noble InRelease 217s Hit:3 http://ftpmaster.internal/ubuntu noble-updates InRelease 217s Hit:4 http://ftpmaster.internal/ubuntu noble-security InRelease 220s Reading package lists... 220s Reading package lists... 221s Building dependency tree... 221s Reading state information... 221s Calculating upgrade... 221s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 221s Reading package lists... 222s Building dependency tree... 222s Reading state information... 223s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 226s autopkgtest [02:08:36]: testbed running kernel: Linux 6.8.0-11-generic #11-Ubuntu SMP Wed Feb 14 00:33:03 UTC 2024 226s autopkgtest [02:08:36]: @@@@@@@@@@@@@@@@@@@@ apt-source librdkafka 233s Get:1 http://ftpmaster.internal/ubuntu noble/universe librdkafka 2.3.0-1 (dsc) [2258 B] 233s Get:2 http://ftpmaster.internal/ubuntu noble/universe librdkafka 2.3.0-1 (tar) [4381 kB] 233s Get:3 http://ftpmaster.internal/ubuntu noble/universe librdkafka 2.3.0-1 (diff) [12.3 kB] 233s gpgv: Signature made Fri Oct 27 14:34:28 2023 UTC 233s gpgv: using RSA key A9592C521CB904077D6598009D0B5E5B1EEC8F0E 233s gpgv: Can't check signature: No public key 233s dpkg-source: warning: cannot verify inline signature for ./librdkafka_2.3.0-1.dsc: no acceptable signature found 234s autopkgtest [02:08:44]: testing package librdkafka version 2.3.0-1 234s autopkgtest [02:08:44]: build not needed 243s autopkgtest [02:08:53]: test examples: preparing testbed 244s Reading package lists... 245s Building dependency tree... 245s Reading state information... 245s Starting pkgProblemResolver with broken count: 0 245s Starting 2 pkgProblemResolver with broken count: 0 245s Done 246s The following additional packages will be installed: 246s build-essential cpp cpp-13 cpp-13-powerpc64le-linux-gnu 246s cpp-powerpc64le-linux-gnu g++ g++-13 g++-13-powerpc64le-linux-gnu 246s g++-powerpc64le-linux-gnu gcc gcc-13 gcc-13-powerpc64le-linux-gnu 246s gcc-powerpc64le-linux-gnu libasan8 libatomic1 libc-dev-bin libc6-dev 246s libcc1-0 libcrypt-dev libgcc-13-dev libgomp1 libisl23 libitm1 liblsan0 246s libmpc3 libnsl-dev libpkgconf3 libquadmath0 librdkafka++1 librdkafka-dev 246s librdkafka1 libstdc++-13-dev libtirpc-dev libtsan2 libubsan1 linux-libc-dev 246s pkg-config pkgconf pkgconf-bin rpcsvc-proto 246s Suggested packages: 246s cpp-doc gcc-13-locales cpp-13-doc gcc-13-doc gcc-multilib manpages-dev 246s autoconf automake libtool flex bison gdb gcc-doc gdb-powerpc64le-linux-gnu 246s glibc-doc libstdc++-13-doc 246s Recommended packages: 246s manpages manpages-dev libc-devtools 246s The following NEW packages will be installed: 246s autopkgtest-satdep build-essential cpp cpp-13 cpp-13-powerpc64le-linux-gnu 246s cpp-powerpc64le-linux-gnu g++ g++-13 g++-13-powerpc64le-linux-gnu 246s g++-powerpc64le-linux-gnu gcc gcc-13 gcc-13-powerpc64le-linux-gnu 246s gcc-powerpc64le-linux-gnu libasan8 libatomic1 libc-dev-bin libc6-dev 246s libcc1-0 libcrypt-dev libgcc-13-dev libgomp1 libisl23 libitm1 liblsan0 246s libmpc3 libnsl-dev libpkgconf3 libquadmath0 librdkafka++1 librdkafka-dev 246s librdkafka1 libstdc++-13-dev libtirpc-dev libtsan2 libubsan1 linux-libc-dev 246s pkg-config pkgconf pkgconf-bin rpcsvc-proto 246s 0 upgraded, 41 newly installed, 0 to remove and 0 not upgraded. 246s Need to get 64.1 MB/64.1 MB of archives. 246s After this operation, 250 MB of additional disk space will be used. 246s Get:1 /tmp/autopkgtest.lVBOn2/1-autopkgtest-satdep.deb autopkgtest-satdep ppc64el 0 [732 B] 246s Get:2 http://ftpmaster.internal/ubuntu noble/main ppc64el libc-dev-bin ppc64el 2.39-0ubuntu2 [21.3 kB] 247s Get:3 http://ftpmaster.internal/ubuntu noble/main ppc64el linux-libc-dev ppc64el 6.8.0-11.11 [1585 kB] 247s Get:4 http://ftpmaster.internal/ubuntu noble/main ppc64el libcrypt-dev ppc64el 1:4.4.36-4 [167 kB] 247s Get:5 http://ftpmaster.internal/ubuntu noble/main ppc64el libtirpc-dev ppc64el 1.3.4+ds-1build1 [262 kB] 247s Get:6 http://ftpmaster.internal/ubuntu noble/main ppc64el libnsl-dev ppc64el 1.3.0-3 [79.2 kB] 247s Get:7 http://ftpmaster.internal/ubuntu noble/main ppc64el rpcsvc-proto ppc64el 1.4.2-0ubuntu6 [82.3 kB] 247s Get:8 http://ftpmaster.internal/ubuntu noble/main ppc64el libc6-dev ppc64el 2.39-0ubuntu2 [2102 kB] 248s Get:9 http://ftpmaster.internal/ubuntu noble/main ppc64el libisl23 ppc64el 0.26-3 [864 kB] 248s Get:10 http://ftpmaster.internal/ubuntu noble/main ppc64el libmpc3 ppc64el 1.3.1-1 [61.2 kB] 248s Get:11 http://ftpmaster.internal/ubuntu noble/main ppc64el cpp-13-powerpc64le-linux-gnu ppc64el 13.2.0-17ubuntu2 [10.7 MB] 249s Get:12 http://ftpmaster.internal/ubuntu noble/main ppc64el cpp-13 ppc64el 13.2.0-17ubuntu2 [1038 B] 249s Get:13 http://ftpmaster.internal/ubuntu noble/main ppc64el cpp-powerpc64le-linux-gnu ppc64el 4:13.2.0-7ubuntu1 [5330 B] 249s Get:14 http://ftpmaster.internal/ubuntu noble/main ppc64el cpp ppc64el 4:13.2.0-7ubuntu1 [22.5 kB] 249s Get:15 http://ftpmaster.internal/ubuntu noble/main ppc64el libcc1-0 ppc64el 14-20240303-1ubuntu1 [48.1 kB] 249s Get:16 http://ftpmaster.internal/ubuntu noble/main ppc64el libgomp1 ppc64el 14-20240303-1ubuntu1 [161 kB] 249s Get:17 http://ftpmaster.internal/ubuntu noble/main ppc64el libitm1 ppc64el 14-20240303-1ubuntu1 [32.4 kB] 249s Get:18 http://ftpmaster.internal/ubuntu noble/main ppc64el libatomic1 ppc64el 14-20240303-1ubuntu1 [10.7 kB] 249s Get:19 http://ftpmaster.internal/ubuntu noble/main ppc64el libasan8 ppc64el 14-20240303-1ubuntu1 [2973 kB] 249s Get:20 http://ftpmaster.internal/ubuntu noble/main ppc64el liblsan0 ppc64el 14-20240303-1ubuntu1 [1325 kB] 250s Get:21 http://ftpmaster.internal/ubuntu noble/main ppc64el libtsan2 ppc64el 14-20240303-1ubuntu1 [2734 kB] 250s Get:22 http://ftpmaster.internal/ubuntu noble/main ppc64el libubsan1 ppc64el 14-20240303-1ubuntu1 [1194 kB] 250s Get:23 http://ftpmaster.internal/ubuntu noble/main ppc64el libquadmath0 ppc64el 14-20240303-1ubuntu1 [158 kB] 250s Get:24 http://ftpmaster.internal/ubuntu noble/main ppc64el libgcc-13-dev ppc64el 13.2.0-17ubuntu2 [1581 kB] 250s Get:25 http://ftpmaster.internal/ubuntu noble/main ppc64el gcc-13-powerpc64le-linux-gnu ppc64el 13.2.0-17ubuntu2 [20.6 MB] 253s Get:26 http://ftpmaster.internal/ubuntu noble/main ppc64el gcc-13 ppc64el 13.2.0-17ubuntu2 [477 kB] 253s Get:27 http://ftpmaster.internal/ubuntu noble/main ppc64el gcc-powerpc64le-linux-gnu ppc64el 4:13.2.0-7ubuntu1 [1224 B] 253s Get:28 http://ftpmaster.internal/ubuntu noble/main ppc64el gcc ppc64el 4:13.2.0-7ubuntu1 [5022 B] 253s Get:29 http://ftpmaster.internal/ubuntu noble/main ppc64el libstdc++-13-dev ppc64el 13.2.0-17ubuntu2 [2445 kB] 253s Get:30 http://ftpmaster.internal/ubuntu noble/main ppc64el g++-13-powerpc64le-linux-gnu ppc64el 13.2.0-17ubuntu2 [12.2 MB] 255s Get:31 http://ftpmaster.internal/ubuntu noble/main ppc64el g++-13 ppc64el 13.2.0-17ubuntu2 [14.5 kB] 255s Get:32 http://ftpmaster.internal/ubuntu noble/main ppc64el g++-powerpc64le-linux-gnu ppc64el 4:13.2.0-7ubuntu1 [968 B] 255s Get:33 http://ftpmaster.internal/ubuntu noble/main ppc64el g++ ppc64el 4:13.2.0-7ubuntu1 [1086 B] 255s Get:34 http://ftpmaster.internal/ubuntu noble/main ppc64el build-essential ppc64el 12.10ubuntu1 [4936 B] 255s Get:35 http://ftpmaster.internal/ubuntu noble/main ppc64el libpkgconf3 ppc64el 1.8.1-2 [36.9 kB] 255s Get:36 http://ftpmaster.internal/ubuntu noble/universe ppc64el librdkafka1 ppc64el 2.3.0-1 [882 kB] 255s Get:37 http://ftpmaster.internal/ubuntu noble/universe ppc64el librdkafka++1 ppc64el 2.3.0-1 [48.1 kB] 255s Get:38 http://ftpmaster.internal/ubuntu noble/universe ppc64el librdkafka-dev ppc64el 2.3.0-1 [1134 kB] 255s Get:39 http://ftpmaster.internal/ubuntu noble/main ppc64el pkgconf-bin ppc64el 1.8.1-2 [22.0 kB] 255s Get:40 http://ftpmaster.internal/ubuntu noble/main ppc64el pkgconf ppc64el 1.8.1-2 [16.7 kB] 255s Get:41 http://ftpmaster.internal/ubuntu noble/main ppc64el pkg-config ppc64el 1.8.1-2 [7170 B] 256s Fetched 64.1 MB in 9s (6947 kB/s) 256s Selecting previously unselected package libc-dev-bin. 256s (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 ... 70097 files and directories currently installed.) 256s Preparing to unpack .../00-libc-dev-bin_2.39-0ubuntu2_ppc64el.deb ... 256s Unpacking libc-dev-bin (2.39-0ubuntu2) ... 256s Selecting previously unselected package linux-libc-dev:ppc64el. 256s Preparing to unpack .../01-linux-libc-dev_6.8.0-11.11_ppc64el.deb ... 256s Unpacking linux-libc-dev:ppc64el (6.8.0-11.11) ... 257s Selecting previously unselected package libcrypt-dev:ppc64el. 257s Preparing to unpack .../02-libcrypt-dev_1%3a4.4.36-4_ppc64el.deb ... 257s Unpacking libcrypt-dev:ppc64el (1:4.4.36-4) ... 257s Selecting previously unselected package libtirpc-dev:ppc64el. 257s Preparing to unpack .../03-libtirpc-dev_1.3.4+ds-1build1_ppc64el.deb ... 257s Unpacking libtirpc-dev:ppc64el (1.3.4+ds-1build1) ... 257s Selecting previously unselected package libnsl-dev:ppc64el. 257s Preparing to unpack .../04-libnsl-dev_1.3.0-3_ppc64el.deb ... 257s Unpacking libnsl-dev:ppc64el (1.3.0-3) ... 257s Selecting previously unselected package rpcsvc-proto. 257s Preparing to unpack .../05-rpcsvc-proto_1.4.2-0ubuntu6_ppc64el.deb ... 257s Unpacking rpcsvc-proto (1.4.2-0ubuntu6) ... 257s Selecting previously unselected package libc6-dev:ppc64el. 257s Preparing to unpack .../06-libc6-dev_2.39-0ubuntu2_ppc64el.deb ... 257s Unpacking libc6-dev:ppc64el (2.39-0ubuntu2) ... 258s Selecting previously unselected package libisl23:ppc64el. 258s Preparing to unpack .../07-libisl23_0.26-3_ppc64el.deb ... 258s Unpacking libisl23:ppc64el (0.26-3) ... 258s Selecting previously unselected package libmpc3:ppc64el. 258s Preparing to unpack .../08-libmpc3_1.3.1-1_ppc64el.deb ... 258s Unpacking libmpc3:ppc64el (1.3.1-1) ... 258s Selecting previously unselected package cpp-13-powerpc64le-linux-gnu. 258s Preparing to unpack .../09-cpp-13-powerpc64le-linux-gnu_13.2.0-17ubuntu2_ppc64el.deb ... 258s Unpacking cpp-13-powerpc64le-linux-gnu (13.2.0-17ubuntu2) ... 258s Selecting previously unselected package cpp-13. 258s Preparing to unpack .../10-cpp-13_13.2.0-17ubuntu2_ppc64el.deb ... 258s Unpacking cpp-13 (13.2.0-17ubuntu2) ... 258s Selecting previously unselected package cpp-powerpc64le-linux-gnu. 258s Preparing to unpack .../11-cpp-powerpc64le-linux-gnu_4%3a13.2.0-7ubuntu1_ppc64el.deb ... 258s Unpacking cpp-powerpc64le-linux-gnu (4:13.2.0-7ubuntu1) ... 258s Selecting previously unselected package cpp. 258s Preparing to unpack .../12-cpp_4%3a13.2.0-7ubuntu1_ppc64el.deb ... 258s Unpacking cpp (4:13.2.0-7ubuntu1) ... 258s Selecting previously unselected package libcc1-0:ppc64el. 258s Preparing to unpack .../13-libcc1-0_14-20240303-1ubuntu1_ppc64el.deb ... 258s Unpacking libcc1-0:ppc64el (14-20240303-1ubuntu1) ... 258s Selecting previously unselected package libgomp1:ppc64el. 258s Preparing to unpack .../14-libgomp1_14-20240303-1ubuntu1_ppc64el.deb ... 258s Unpacking libgomp1:ppc64el (14-20240303-1ubuntu1) ... 258s Selecting previously unselected package libitm1:ppc64el. 258s Preparing to unpack .../15-libitm1_14-20240303-1ubuntu1_ppc64el.deb ... 258s Unpacking libitm1:ppc64el (14-20240303-1ubuntu1) ... 259s Selecting previously unselected package libatomic1:ppc64el. 259s Preparing to unpack .../16-libatomic1_14-20240303-1ubuntu1_ppc64el.deb ... 259s Unpacking libatomic1:ppc64el (14-20240303-1ubuntu1) ... 259s Selecting previously unselected package libasan8:ppc64el. 259s Preparing to unpack .../17-libasan8_14-20240303-1ubuntu1_ppc64el.deb ... 259s Unpacking libasan8:ppc64el (14-20240303-1ubuntu1) ... 259s Selecting previously unselected package liblsan0:ppc64el. 259s Preparing to unpack .../18-liblsan0_14-20240303-1ubuntu1_ppc64el.deb ... 259s Unpacking liblsan0:ppc64el (14-20240303-1ubuntu1) ... 259s Selecting previously unselected package libtsan2:ppc64el. 259s Preparing to unpack .../19-libtsan2_14-20240303-1ubuntu1_ppc64el.deb ... 259s Unpacking libtsan2:ppc64el (14-20240303-1ubuntu1) ... 259s Selecting previously unselected package libubsan1:ppc64el. 259s Preparing to unpack .../20-libubsan1_14-20240303-1ubuntu1_ppc64el.deb ... 259s Unpacking libubsan1:ppc64el (14-20240303-1ubuntu1) ... 259s Selecting previously unselected package libquadmath0:ppc64el. 259s Preparing to unpack .../21-libquadmath0_14-20240303-1ubuntu1_ppc64el.deb ... 259s Unpacking libquadmath0:ppc64el (14-20240303-1ubuntu1) ... 259s Selecting previously unselected package libgcc-13-dev:ppc64el. 259s Preparing to unpack .../22-libgcc-13-dev_13.2.0-17ubuntu2_ppc64el.deb ... 259s Unpacking libgcc-13-dev:ppc64el (13.2.0-17ubuntu2) ... 259s Selecting previously unselected package gcc-13-powerpc64le-linux-gnu. 259s Preparing to unpack .../23-gcc-13-powerpc64le-linux-gnu_13.2.0-17ubuntu2_ppc64el.deb ... 259s Unpacking gcc-13-powerpc64le-linux-gnu (13.2.0-17ubuntu2) ... 260s Selecting previously unselected package gcc-13. 260s Preparing to unpack .../24-gcc-13_13.2.0-17ubuntu2_ppc64el.deb ... 260s Unpacking gcc-13 (13.2.0-17ubuntu2) ... 260s Selecting previously unselected package gcc-powerpc64le-linux-gnu. 260s Preparing to unpack .../25-gcc-powerpc64le-linux-gnu_4%3a13.2.0-7ubuntu1_ppc64el.deb ... 260s Unpacking gcc-powerpc64le-linux-gnu (4:13.2.0-7ubuntu1) ... 260s Selecting previously unselected package gcc. 260s Preparing to unpack .../26-gcc_4%3a13.2.0-7ubuntu1_ppc64el.deb ... 260s Unpacking gcc (4:13.2.0-7ubuntu1) ... 260s Selecting previously unselected package libstdc++-13-dev:ppc64el. 260s Preparing to unpack .../27-libstdc++-13-dev_13.2.0-17ubuntu2_ppc64el.deb ... 260s Unpacking libstdc++-13-dev:ppc64el (13.2.0-17ubuntu2) ... 261s Selecting previously unselected package g++-13-powerpc64le-linux-gnu. 261s Preparing to unpack .../28-g++-13-powerpc64le-linux-gnu_13.2.0-17ubuntu2_ppc64el.deb ... 261s Unpacking g++-13-powerpc64le-linux-gnu (13.2.0-17ubuntu2) ... 262s Selecting previously unselected package g++-13. 262s Preparing to unpack .../29-g++-13_13.2.0-17ubuntu2_ppc64el.deb ... 262s Unpacking g++-13 (13.2.0-17ubuntu2) ... 262s Selecting previously unselected package g++-powerpc64le-linux-gnu. 262s Preparing to unpack .../30-g++-powerpc64le-linux-gnu_4%3a13.2.0-7ubuntu1_ppc64el.deb ... 262s Unpacking g++-powerpc64le-linux-gnu (4:13.2.0-7ubuntu1) ... 262s Selecting previously unselected package g++. 262s Preparing to unpack .../31-g++_4%3a13.2.0-7ubuntu1_ppc64el.deb ... 262s Unpacking g++ (4:13.2.0-7ubuntu1) ... 262s Selecting previously unselected package build-essential. 262s Preparing to unpack .../32-build-essential_12.10ubuntu1_ppc64el.deb ... 262s Unpacking build-essential (12.10ubuntu1) ... 262s Selecting previously unselected package libpkgconf3:ppc64el. 262s Preparing to unpack .../33-libpkgconf3_1.8.1-2_ppc64el.deb ... 262s Unpacking libpkgconf3:ppc64el (1.8.1-2) ... 262s Selecting previously unselected package librdkafka1:ppc64el. 262s Preparing to unpack .../34-librdkafka1_2.3.0-1_ppc64el.deb ... 262s Unpacking librdkafka1:ppc64el (2.3.0-1) ... 262s Selecting previously unselected package librdkafka++1:ppc64el. 262s Preparing to unpack .../35-librdkafka++1_2.3.0-1_ppc64el.deb ... 262s Unpacking librdkafka++1:ppc64el (2.3.0-1) ... 262s Selecting previously unselected package librdkafka-dev:ppc64el. 262s Preparing to unpack .../36-librdkafka-dev_2.3.0-1_ppc64el.deb ... 262s Unpacking librdkafka-dev:ppc64el (2.3.0-1) ... 262s Selecting previously unselected package pkgconf-bin. 262s Preparing to unpack .../37-pkgconf-bin_1.8.1-2_ppc64el.deb ... 262s Unpacking pkgconf-bin (1.8.1-2) ... 262s Selecting previously unselected package pkgconf:ppc64el. 262s Preparing to unpack .../38-pkgconf_1.8.1-2_ppc64el.deb ... 262s Unpacking pkgconf:ppc64el (1.8.1-2) ... 262s Selecting previously unselected package pkg-config:ppc64el. 262s Preparing to unpack .../39-pkg-config_1.8.1-2_ppc64el.deb ... 262s Unpacking pkg-config:ppc64el (1.8.1-2) ... 262s Selecting previously unselected package autopkgtest-satdep. 262s Preparing to unpack .../40-1-autopkgtest-satdep.deb ... 262s Unpacking autopkgtest-satdep (0) ... 262s Setting up linux-libc-dev:ppc64el (6.8.0-11.11) ... 262s Setting up libgomp1:ppc64el (14-20240303-1ubuntu1) ... 262s Setting up libtirpc-dev:ppc64el (1.3.4+ds-1build1) ... 262s Setting up libpkgconf3:ppc64el (1.8.1-2) ... 262s Setting up rpcsvc-proto (1.4.2-0ubuntu6) ... 262s Setting up libquadmath0:ppc64el (14-20240303-1ubuntu1) ... 262s Setting up libmpc3:ppc64el (1.3.1-1) ... 262s Setting up libatomic1:ppc64el (14-20240303-1ubuntu1) ... 262s Setting up pkgconf-bin (1.8.1-2) ... 262s Setting up librdkafka1:ppc64el (2.3.0-1) ... 262s Setting up libubsan1:ppc64el (14-20240303-1ubuntu1) ... 262s Setting up libnsl-dev:ppc64el (1.3.0-3) ... 262s Setting up libcrypt-dev:ppc64el (1:4.4.36-4) ... 262s Setting up libasan8:ppc64el (14-20240303-1ubuntu1) ... 262s Setting up libtsan2:ppc64el (14-20240303-1ubuntu1) ... 262s Setting up libisl23:ppc64el (0.26-3) ... 262s Setting up libc-dev-bin (2.39-0ubuntu2) ... 262s Setting up cpp-13-powerpc64le-linux-gnu (13.2.0-17ubuntu2) ... 262s Setting up libcc1-0:ppc64el (14-20240303-1ubuntu1) ... 262s Setting up liblsan0:ppc64el (14-20240303-1ubuntu1) ... 262s Setting up libitm1:ppc64el (14-20240303-1ubuntu1) ... 262s Setting up cpp-powerpc64le-linux-gnu (4:13.2.0-7ubuntu1) ... 262s Setting up cpp-13 (13.2.0-17ubuntu2) ... 262s Setting up librdkafka++1:ppc64el (2.3.0-1) ... 262s Setting up pkgconf:ppc64el (1.8.1-2) ... 262s Setting up pkg-config:ppc64el (1.8.1-2) ... 262s Setting up libgcc-13-dev:ppc64el (13.2.0-17ubuntu2) ... 262s Setting up cpp (4:13.2.0-7ubuntu1) ... 262s Setting up librdkafka-dev:ppc64el (2.3.0-1) ... 262s Setting up libc6-dev:ppc64el (2.39-0ubuntu2) ... 262s Setting up libstdc++-13-dev:ppc64el (13.2.0-17ubuntu2) ... 262s Setting up gcc-13-powerpc64le-linux-gnu (13.2.0-17ubuntu2) ... 262s Setting up gcc-13 (13.2.0-17ubuntu2) ... 262s Setting up g++-13-powerpc64le-linux-gnu (13.2.0-17ubuntu2) ... 262s Setting up gcc-powerpc64le-linux-gnu (4:13.2.0-7ubuntu1) ... 262s Setting up g++-powerpc64le-linux-gnu (4:13.2.0-7ubuntu1) ... 262s Setting up g++-13 (13.2.0-17ubuntu2) ... 262s Setting up gcc (4:13.2.0-7ubuntu1) ... 262s Setting up g++ (4:13.2.0-7ubuntu1) ... 262s update-alternatives: using /usr/bin/g++ to provide /usr/bin/c++ (c++) in auto mode 262s Setting up build-essential (12.10ubuntu1) ... 262s Setting up autopkgtest-satdep (0) ... 262s Processing triggers for man-db (2.12.0-3) ... 264s Processing triggers for libc-bin (2.39-0ubuntu2) ... 271s (Reading database ... 73029 files and directories currently installed.) 271s Removing autopkgtest-satdep (0) ... 272s autopkgtest [02:09:22]: test examples: [----------------------- 272s Info pkg-config (rdkafka): -lrdkafka 272s Info pkg-config (rdkafka++): -lrdkafka++ 272s Build consumer.c 273s Build producer.c 273s Build rdkafka_example.c 273s Build rdkafka_complex_consumer_example.cpp 276s Build rdkafka_example.cpp 278s Run consumer.c.out 278s Run producer.c.out 278s Run rdkafka_complex_consumer_example.cpp.out 278s Run rdkafka_example.c.out 278s Run rdkafka_example.cpp.out 278s All OK 278s autopkgtest [02:09:28]: test examples: -----------------------] 279s examples PASS 279s autopkgtest [02:09:29]: test examples: - - - - - - - - - - results - - - - - - - - - - 280s autopkgtest [02:09:30]: test unittest: preparing testbed 282s Reading package lists... 283s Building dependency tree... 283s Reading state information... 284s Starting pkgProblemResolver with broken count: 0 284s Starting 2 pkgProblemResolver with broken count: 0 284s Done 284s The following NEW packages will be installed: 284s autopkgtest-satdep 284s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 284s Need to get 0 B/736 B of archives. 284s After this operation, 0 B of additional disk space will be used. 284s Get:1 /tmp/autopkgtest.lVBOn2/2-autopkgtest-satdep.deb autopkgtest-satdep ppc64el 0 [736 B] 285s Selecting previously unselected package autopkgtest-satdep. 285s (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 ... 73029 files and directories currently installed.) 285s Preparing to unpack .../2-autopkgtest-satdep.deb ... 285s Unpacking autopkgtest-satdep (0) ... 285s Setting up autopkgtest-satdep (0) ... 291s (Reading database ... 73029 files and directories currently installed.) 291s Removing autopkgtest-satdep (0) ... 292s autopkgtest [02:09:42]: test unittest: [----------------------- 292s RDUT: INFO: rdunittest.c:158: ut_tq_test: Testing TAILQ: empty tqh[0] 292s RDUT: INFO: rdunittest.c:158: ut_tq_test: Testing TAILQ: prepend 1,0 292s RDUT: INFO: rdunittest.c:158: ut_tq_test: Testing TAILQ: prepend 2,1,0 292s RDUT: INFO: rdunittest.c:158: ut_tq_test: Testing TAILQ: insert 1 292s RDUT: INFO: rdunittest.c:158: ut_tq_test: Testing TAILQ: insert 1,2 292s RDUT: INFO: rdunittest.c:158: ut_tq_test: Testing TAILQ: append 1 292s RDUT: INFO: rdunittest.c:158: ut_tq_test: Testing TAILQ: append 1,2 292s RDUT: INFO: rdunittest.c:158: ut_tq_test: Testing TAILQ: insert 1,0,2 292s RDUT: INFO: rdunittest.c:158: ut_tq_test: Testing TAILQ: insert 2,0,1 292s RDUT: PASS: rdunittest.c:345: unittest_sysqueue 292s RDUT: INFO: rdunittest.c:501: rd_unittest: unittest: sysqueue: PASS 292s RDUT: INFO: rdstring.c:409: ut_strcasestr: BEGIN:  292s RDUT: PASS: rdstring.c:425: ut_strcasestr 292s RDUT: INFO: rdstring.c:606: ut_string_split: BEGIN:  292s RDUT: PASS: rdstring.c:632: ut_string_split 292s RDUT: INFO: rdunittest.c:501: rd_unittest: unittest: string: PASS 293s RDUT: INFO: rdmap.c:457: unittest_untyped_map: 500000 map_get iterations took 509.824ms = 1us/get 293s RDUT: INFO: rdmap.c:474: unittest_untyped_map: Total time over 100000 entries took 797.610ms 293s RDUT: PASS: rdmap.c:477: unittest_untyped_map 293s RDUT: INFO: rdmap.c:305: unittest_typed_map: enumerated key 2 person Hedvig Lindahl 293s RDUT: INFO: rdmap.c:305: unittest_typed_map: enumerated key 1 person Roy McPhearsome 293s RDUT: PASS: rdmap.c:323: unittest_typed_map 293s RDUT: INFO: rdunittest.c:501: rd_unittest: unittest: map: PASS 293s RDUT: PASS: rdbuf.c:1353: do_unittest_write_read 293s RDUT: PASS: rdbuf.c:1518: do_unittest_write_split_seek 293s RDUT: PASS: rdbuf.c:1608: do_unittest_write_read_payload_correctness 293s RDUT: PASS: rdbuf.c:1676: do_unittest_write_iov 293s RDUT: PASS: rdbuf.c:1866: do_unittest_erase 293s RDUT: INFO: rdunittest.c:501: rd_unittest: unittest: rdbuf: PASS 293s RDUT: PASS: rdvarint.c:107: do_test_rd_uvarint_enc_i64 293s RDUT: PASS: rdvarint.c:107: do_test_rd_uvarint_enc_i64 293s RDUT: PASS: rdvarint.c:107: do_test_rd_uvarint_enc_i64 293s RDUT: PASS: rdvarint.c:107: do_test_rd_uvarint_enc_i64 293s RDUT: PASS: rdvarint.c:107: do_test_rd_uvarint_enc_i64 293s RDUT: PASS: rdvarint.c:107: do_test_rd_uvarint_enc_i64 293s RDUT: PASS: rdvarint.c:107: do_test_rd_uvarint_enc_i64 293s RDUT: PASS: rdvarint.c:107: do_test_rd_uvarint_enc_i64 293s RDUT: INFO: rdunittest.c:501: rd_unittest: unittest: rdvarint: PASS 293s RDUT: INFO: crc32c.c:411: unittest_rd_crc32c: Calculate CRC32C using software 293s RDUT: INFO: crc32c.c:422: unittest_rd_crc32c: Calculate CRC32C using software 293s RDUT: PASS: crc32c.c:429: unittest_rd_crc32c 293s RDUT: INFO: rdunittest.c:501: rd_unittest: unittest: crc32c: PASS 293s RDUT: INFO: rdkafka_msg.c:1999: unittest_msgq_order: FIFO: testing in FIFO mode 293s RDUT: PASS: rdkafka_msg.c:2194: unittest_msg_seq_wrap 293s RDUT: INFO: rdkafka_msg.c:2239: unittest_msgq_insert_all_sort: Testing msgq insert (all) efficiency: get baseline insert time 293s RDUT: INFO: rdkafka_msg.c:2272: unittest_msgq_insert_all_sort: Begin insert of 2 messages into destq with 2 messages 293s RDUT: INFO: rdkafka_msg.c:2280: unittest_msgq_insert_all_sort: Done: took 1us, 0.2500us/msg 293s RDUT: PASS: rdkafka_msg.c:2311: unittest_msgq_insert_all_sort 293s RDUT: INFO: rdkafka_msg.c:2335: unittest_msgq_insert_each_sort: Testing msgq insert (each) efficiency: get baseline insert time 293s RDUT: INFO: rdkafka_msg.c:2372: unittest_msgq_insert_each_sort: Begin insert of 1 messages into destq with 2 messages 293s RDUT: INFO: rdkafka_msg.c:2383: unittest_msgq_insert_each_sort: Done: took 0us, 0.0000us/msg 293s RDUT: INFO: rdkafka_msg.c:2372: unittest_msgq_insert_each_sort: Begin insert of 1 messages into destq with 3 messages 293s RDUT: INFO: rdkafka_msg.c:2383: unittest_msgq_insert_each_sort: Done: took 0us, 0.0000us/msg 293s RDUT: INFO: rdkafka_msg.c:2408: unittest_msgq_insert_each_sort: Total: 0.0000us/msg over 2 messages in 0us 293s RDUT: PASS: rdkafka_msg.c:2424: unittest_msgq_insert_each_sort 293s RDUT: INFO: rdkafka_msg.c:2239: unittest_msgq_insert_all_sort: Testing msgq insert (all) efficiency: single-message ranges 293s RDUT: INFO: rdkafka_msg.c:2272: unittest_msgq_insert_all_sort: Begin insert of 4 messages into destq with 5 messages 293s RDUT: INFO: rdkafka_msg.c:2280: unittest_msgq_insert_all_sort: Done: took 0us, 0.0000us/msg 293s RDUT: PASS: rdkafka_msg.c:2311: unittest_msgq_insert_all_sort 293s RDUT: INFO: rdkafka_msg.c:2335: unittest_msgq_insert_each_sort: Testing msgq insert (each) efficiency: single-message ranges 293s RDUT: INFO: rdkafka_msg.c:2372: unittest_msgq_insert_each_sort: Begin insert of 1 messages into destq with 5 messages 293s RDUT: INFO: rdkafka_msg.c:2383: unittest_msgq_insert_each_sort: Done: took 0us, 0.0000us/msg 293s RDUT: INFO: rdkafka_msg.c:2372: unittest_msgq_insert_each_sort: Begin insert of 1 messages into destq with 6 messages 293s RDUT: INFO: rdkafka_msg.c:2383: unittest_msgq_insert_each_sort: Done: took 0us, 0.0000us/msg 293s RDUT: INFO: rdkafka_msg.c:2372: unittest_msgq_insert_each_sort: Begin insert of 1 messages into destq with 7 messages 293s RDUT: INFO: rdkafka_msg.c:2383: unittest_msgq_insert_each_sort: Done: took 0us, 0.0000us/msg 293s RDUT: INFO: rdkafka_msg.c:2372: unittest_msgq_insert_each_sort: Begin insert of 1 messages into destq with 8 messages 293s RDUT: INFO: rdkafka_msg.c:2383: unittest_msgq_insert_each_sort: Done: took 0us, 0.0000us/msg 293s RDUT: INFO: rdkafka_msg.c:2408: unittest_msgq_insert_each_sort: Total: 0.0000us/msg over 4 messages in 0us 293s RDUT: PASS: rdkafka_msg.c:2424: unittest_msgq_insert_each_sort 293s RDUT: INFO: rdkafka_msg.c:2239: unittest_msgq_insert_all_sort: Testing msgq insert (all) efficiency: many messages 294s RDUT: INFO: rdkafka_msg.c:2272: unittest_msgq_insert_all_sort: Begin insert of 4315956 messages into destq with 165288 messages 294s RDUT: INFO: rdkafka_msg.c:2280: unittest_msgq_insert_all_sort: Done: took 25098us, 0.0056us/msg 294s RDUT: PASS: rdkafka_msg.c:2311: unittest_msgq_insert_all_sort 294s RDUT: INFO: rdkafka_msg.c:2335: unittest_msgq_insert_each_sort: Testing msgq insert (each) efficiency: many messages 294s RDUT: INFO: rdkafka_msg.c:2372: unittest_msgq_insert_each_sort: Begin insert of 100001 messages into destq with 165288 messages 294s RDUT: INFO: rdkafka_msg.c:2383: unittest_msgq_insert_each_sort: Done: took 4us, 0.0000us/msg 294s RDUT: INFO: rdkafka_msg.c:2372: unittest_msgq_insert_each_sort: Begin insert of 50001 messages into destq with 265289 messages 294s RDUT: INFO: rdkafka_msg.c:2383: unittest_msgq_insert_each_sort: Done: took 3222us, 0.0644us/msg 294s RDUT: INFO: rdkafka_msg.c:2372: unittest_msgq_insert_each_sort: Begin insert of 20001 messages into destq with 315290 messages 294s RDUT: INFO: rdkafka_msg.c:2383: unittest_msgq_insert_each_sort: Done: took 4793us, 0.2396us/msg 294s RDUT: INFO: rdkafka_msg.c:2372: unittest_msgq_insert_each_sort: Begin insert of 59129 messages into destq with 335291 messages 294s RDUT: INFO: rdkafka_msg.c:2383: unittest_msgq_insert_each_sort: Done: took 5591us, 0.0946us/msg 294s RDUT: INFO: rdkafka_msg.c:2372: unittest_msgq_insert_each_sort: Begin insert of 86823 messages into destq with 394420 messages 294s RDUT: INFO: rdkafka_msg.c:2383: unittest_msgq_insert_each_sort: Done: took 11522us, 0.1327us/msg 295s RDUT: INFO: rdkafka_msg.c:2372: unittest_msgq_insert_each_sort: Begin insert of 4000001 messages into destq with 481243 messages 295s RDUT: INFO: rdkafka_msg.c:2383: unittest_msgq_insert_each_sort: Done: took 13763us, 0.0034us/msg 295s RDUT: INFO: rdkafka_msg.c:2408: unittest_msgq_insert_each_sort: Total: 0.0090us/msg over 4315956 messages in 38895us 295s RDUT: PASS: rdkafka_msg.c:2424: unittest_msgq_insert_each_sort 295s RDUT: INFO: rdkafka_msg.c:2239: unittest_msgq_insert_all_sort: Testing msgq insert (all) efficiency: issue #2508 295s RDUT: INFO: rdkafka_msg.c:2272: unittest_msgq_insert_all_sort: Begin insert of 145952 messages into destq with 154875 messages 295s RDUT: INFO: rdkafka_msg.c:2280: unittest_msgq_insert_all_sort: Done: took 16713us, 0.0556us/msg 295s RDUT: PASS: rdkafka_msg.c:2311: unittest_msgq_insert_all_sort 295s RDUT: INFO: rdkafka_msg.c:2335: unittest_msgq_insert_each_sort: Testing msgq insert (each) efficiency: issue #2508 295s RDUT: INFO: rdkafka_msg.c:2372: unittest_msgq_insert_each_sort: Begin insert of 59129 messages into destq with 154875 messages 295s RDUT: INFO: rdkafka_msg.c:2383: unittest_msgq_insert_each_sort: Done: took 1us, 0.0000us/msg 296s RDUT: INFO: rdkafka_msg.c:2372: unittest_msgq_insert_each_sort: Begin insert of 86823 messages into destq with 214004 messages 296s RDUT: INFO: rdkafka_msg.c:2383: unittest_msgq_insert_each_sort: Done: took 0us, 0.0000us/msg 296s RDUT: INFO: rdkafka_msg.c:2408: unittest_msgq_insert_each_sort: Total: 0.0000us/msg over 145952 messages in 1us 296s RDUT: PASS: rdkafka_msg.c:2424: unittest_msgq_insert_each_sort 296s RDUT: INFO: rdkafka_msg.c:2239: unittest_msgq_insert_all_sort: Testing msgq insert (all) efficiency: issue #2450 (v1.2.1 regression) 296s RDUT: INFO: rdkafka_msg.c:2272: unittest_msgq_insert_all_sort: Begin insert of 86 messages into destq with 199999 messages 296s RDUT: INFO: rdkafka_msg.c:2280: unittest_msgq_insert_all_sort: Done: took 0us, 0.0000us/msg 296s RDUT: PASS: rdkafka_msg.c:2311: unittest_msgq_insert_all_sort 296s RDUT: INFO: rdkafka_msg.c:2335: unittest_msgq_insert_each_sort: Testing msgq insert (each) efficiency: issue #2450 (v1.2.1 regression) 296s RDUT: INFO: rdkafka_msg.c:2372: unittest_msgq_insert_each_sort: Begin insert of 2 messages into destq with 199999 messages 296s RDUT: INFO: rdkafka_msg.c:2383: unittest_msgq_insert_each_sort: Done: took 1us, 0.5000us/msg 296s RDUT: INFO: rdkafka_msg.c:2372: unittest_msgq_insert_each_sort: Begin insert of 5 messages into destq with 200001 messages 296s RDUT: INFO: rdkafka_msg.c:2383: unittest_msgq_insert_each_sort: Done: took 1us, 0.2000us/msg 296s RDUT: INFO: rdkafka_msg.c:2372: unittest_msgq_insert_each_sort: Begin insert of 4 messages into destq with 200006 messages 296s RDUT: INFO: rdkafka_msg.c:2383: unittest_msgq_insert_each_sort: Done: took 0us, 0.0000us/msg 296s RDUT: INFO: rdkafka_msg.c:2372: unittest_msgq_insert_each_sort: Begin insert of 2 messages into destq with 200010 messages 296s RDUT: INFO: rdkafka_msg.c:2383: unittest_msgq_insert_each_sort: Done: took 0us, 0.0000us/msg 296s RDUT: INFO: rdkafka_msg.c:2372: unittest_msgq_insert_each_sort: Begin insert of 3 messages into destq with 200012 messages 296s RDUT: INFO: rdkafka_msg.c:2383: unittest_msgq_insert_each_sort: Done: took 1us, 0.3333us/msg 296s RDUT: INFO: rdkafka_msg.c:2372: unittest_msgq_insert_each_sort: Begin insert of 61 messages into destq with 200015 messages 296s RDUT: INFO: rdkafka_msg.c:2383: unittest_msgq_insert_each_sort: Done: took 1us, 0.0164us/msg 296s RDUT: INFO: rdkafka_msg.c:2372: unittest_msgq_insert_each_sort: Begin insert of 2 messages into destq with 200076 messages 296s RDUT: INFO: rdkafka_msg.c:2383: unittest_msgq_insert_each_sort: Done: took 1us, 0.5000us/msg 296s RDUT: INFO: rdkafka_msg.c:2372: unittest_msgq_insert_each_sort: Begin insert of 2 messages into destq with 200078 messages 296s RDUT: INFO: rdkafka_msg.c:2383: unittest_msgq_insert_each_sort: Done: took 0us, 0.0000us/msg 296s RDUT: INFO: rdkafka_msg.c:2372: unittest_msgq_insert_each_sort: Begin insert of 2 messages into destq with 200080 messages 296s RDUT: INFO: rdkafka_msg.c:2383: unittest_msgq_insert_each_sort: Done: took 1us, 0.5000us/msg 296s RDUT: INFO: rdkafka_msg.c:2372: unittest_msgq_insert_each_sort: Begin insert of 3 messages into destq with 200082 messages 296s RDUT: INFO: rdkafka_msg.c:2383: unittest_msgq_insert_each_sort: Done: took 0us, 0.0000us/msg 296s RDUT: INFO: rdkafka_msg.c:2408: unittest_msgq_insert_each_sort: Total: 0.0698us/msg over 86 messages in 6us 296s RDUT: PASS: rdkafka_msg.c:2424: unittest_msgq_insert_each_sort 296s RDUT: INFO: rdunittest.c:501: rd_unittest: unittest: msg: PASS 296s RDUT: PASS: rdmurmur2.c:166: unittest_murmur2 296s RDUT: INFO: rdunittest.c:501: rd_unittest: unittest: murmurhash: PASS 296s RDUT: PASS: rdfnv1a.c:112: unittest_fnv1a 296s RDUT: INFO: rdunittest.c:501: rd_unittest: unittest: fnv1a: PASS 296s RDUT: PASS: rdhdrhistogram.c:468: ut_high_sigfig 296s RDUT: PASS: rdhdrhistogram.c:495: ut_quantile 296s RDUT: PASS: rdhdrhistogram.c:514: ut_mean 296s RDUT: PASS: rdhdrhistogram.c:536: ut_stddev 296s RDUT: PASS: rdhdrhistogram.c:555: ut_totalcount 296s RDUT: PASS: rdhdrhistogram.c:573: ut_max 296s RDUT: PASS: rdhdrhistogram.c:590: ut_min 296s RDUT: PASS: rdhdrhistogram.c:609: ut_reset 296s RDUT: PASS: rdhdrhistogram.c:623: ut_nan 296s RDUT: PASS: rdhdrhistogram.c:638: ut_sigfigs 296s RDUT: PASS: rdhdrhistogram.c:654: ut_minmax_trackable 296s RDUT: PASS: rdhdrhistogram.c:664: ut_unitmagnitude_overflow 296s RDUT: PASS: rdhdrhistogram.c:697: ut_subbucketmask_overflow 296s RDUT: INFO: rdunittest.c:501: rd_unittest: unittest: rdhdrhistogram: PASS 296s RDUT: INFO: rdkafka_conf.c:4415: unittest_conf: Safified client.software.name="aba.-va" 296s RDUT: INFO: rdkafka_conf.c:4423: unittest_conf: Safified client.software.version="1.2.3.4.5----a" 296s RDUT: PASS: rdkafka_conf.c:4427: unittest_conf 296s RDUT: INFO: rdunittest.c:501: rd_unittest: unittest: conf: PASS 296s RDUT: PASS: rdkafka_broker.c:2175: rd_ut_reconnect_backoff 296s RDUT: INFO: rdunittest.c:501: rd_unittest: unittest: broker: PASS 296s RDUT: INFO: rdkafka_request.c:5574: unittest_idempotent_producer: Verifying idempotent producer error handling 296s %5|1710814186.387|CONFWARN|rdkafka#producer-1| [thrd:app]: No `bootstrap.servers` configured: client will not be able to connect to Kafka cluster 296s RDUT: INFO: rdkafka_request.c:5741: unittest_idempotent_producer: Got DeliveryReport event with 3 message(s) 296s RDUT: INFO: rdkafka_request.c:5746: unittest_idempotent_producer: DR for message: Success: (persistence=2) 296s RDUT: INFO: rdkafka_request.c:5746: unittest_idempotent_producer: DR for message: Success: (persistence=2) 296s RDUT: INFO: rdkafka_request.c:5746: unittest_idempotent_producer: DR for message: Success: (persistence=2) 296s RDUT: INFO: rdkafka_request.c:5741: unittest_idempotent_producer: Got DeliveryReport event with 3 message(s) 296s RDUT: INFO: rdkafka_request.c:5746: unittest_idempotent_producer: DR for message: Success: (persistence=2) 296s RDUT: INFO: rdkafka_request.c:5746: unittest_idempotent_producer: DR for message: Success: (persistence=2) 296s RDUT: INFO: rdkafka_request.c:5746: unittest_idempotent_producer: DR for message: Success: (persistence=2) 296s RDUT: INFO: rdkafka_request.c:5741: unittest_idempotent_producer: Got DeliveryReport event with 3 message(s) 296s RDUT: INFO: rdkafka_request.c:5746: unittest_idempotent_producer: DR for message: Success: (persistence=2) 296s RDUT: INFO: rdkafka_request.c:5746: unittest_idempotent_producer: DR for message: Success: (persistence=2) 296s RDUT: INFO: rdkafka_request.c:5746: unittest_idempotent_producer: DR for message: Success: (persistence=2) 296s RDUT: INFO: rdkafka_request.c:5741: unittest_idempotent_producer: Got DeliveryReport event with 3 message(s) 296s RDUT: INFO: rdkafka_request.c:5746: unittest_idempotent_producer: DR for message: Success: (persistence=2) 296s RDUT: INFO: rdkafka_request.c:5746: unittest_idempotent_producer: DR for message: Success: (persistence=2) 296s RDUT: INFO: rdkafka_request.c:5746: unittest_idempotent_producer: DR for message: Success: (persistence=2) 297s RDUT: PASS: rdkafka_request.c:5769: unittest_idempotent_producer 297s RDUT: INFO: rdunittest.c:501: rd_unittest: unittest: request: PASS 297s RDUT: PASS: rdkafka_sasl_oauthbearer.c:1585: do_unittest_config_no_principal_should_fail 297s RDUT: PASS: rdkafka_sasl_oauthbearer.c:1614: do_unittest_config_empty_should_fail 297s RDUT: PASS: rdkafka_sasl_oauthbearer.c:1681: do_unittest_config_empty_value_should_fail 297s RDUT: PASS: rdkafka_sasl_oauthbearer.c:1719: do_unittest_config_value_with_quote_should_fail 297s RDUT: PASS: rdkafka_sasl_oauthbearer.c:1644: do_unittest_config_unrecognized_should_fail 297s RDUT: PASS: rdkafka_sasl_oauthbearer.c:1468: do_unittest_config_defaults 297s RDUT: PASS: rdkafka_sasl_oauthbearer.c:1511: do_unittest_config_explicit_scope_and_life 297s RDUT: PASS: rdkafka_sasl_oauthbearer.c:1555: do_unittest_config_all_explicit_values 297s RDUT: PASS: rdkafka_sasl_oauthbearer.c:1758: do_unittest_config_extensions 297s RDUT: PASS: rdkafka_sasl_oauthbearer.c:1777: do_unittest_illegal_extension_keys_should_fail 297s RDUT: PASS: rdkafka_sasl_oauthbearer.c:1810: do_unittest_odd_extension_size_should_fail 297s RDUT: INFO: rdunittest.c:501: rd_unittest: unittest: sasl_oauthbearer: PASS 297s RDUT: PASS: rdkafka_msgset_reader.c:1805: unittest_aborted_txns 297s RDUT: INFO: rdunittest.c:501: rd_unittest: unittest: aborted_txns: PASS 297s RDUT: PASS: rdkafka_cgrp.c:5806: unittest_consumer_group_metadata 297s RDUT: PASS: rdkafka_cgrp.c:5877: unittest_set_intersect 297s RDUT: PASS: rdkafka_cgrp.c:5926: unittest_set_subtract 297s RDUT: PASS: rdkafka_cgrp.c:5953: unittest_map_to_list 297s RDUT: PASS: rdkafka_cgrp.c:5983: unittest_list_to_map 297s RDUT: PASS: rdkafka_cgrp.c:6052: unittest_member_metadata_serdes 297s RDUT: INFO: rdunittest.c:501: rd_unittest: unittest: cgrp: PASS 297s RDUT: PASS: rdkafka_sasl_scram.c:810: unittest_scram_nonce 297s RDUT: PASS: rdkafka_sasl_scram.c:849: unittest_scram_safe 297s RDUT: INFO: rdunittest.c:501: rd_unittest: unittest: scram: PASS 297s RDUT: INFO: rdkafka_assignor.c:1653: ut_assignors: Test case Symmetrical subscription: range assignor 297s RDUT: INFO: rdkafka_assignor.c:1653: ut_assignors: Test case Symmetrical subscription: roundrobin assignor 297s RDUT: INFO: rdkafka_assignor.c:1653: ut_assignors: Test case 1*3 partitions (asymmetrical): range assignor 297s RDUT: INFO: rdkafka_assignor.c:1653: ut_assignors: Test case 1*3 partitions (asymmetrical): roundrobin assignor 297s RDUT: INFO: rdkafka_assignor.c:1653: ut_assignors: Test case #2121 (asymmetrical): range assignor 297s RDUT: INFO: rdkafka_assignor.c:1653: ut_assignors: Test case #2121 (asymmetrical): roundrobin assignor 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #0, RackConfig = 0 ] 297s RDUT: PASS: rdkafka_range_assignor.c:645: ut_testOneConsumerNoTopic 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #0, RackConfig = 1 ] 297s RDUT: PASS: rdkafka_range_assignor.c:665: ut_testOneConsumerNoTopic 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #0, RackConfig = 2 ] 297s RDUT: PASS: rdkafka_range_assignor.c:665: ut_testOneConsumerNoTopic 297s RDUT: INFO: rdkafka_range_assignor.c:1719: rd_kafka_range_assignor_unittest: [ Test #0 ran for 0.451ms ] 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #1, RackConfig = 0 ] 297s RDUT: PASS: rdkafka_range_assignor.c:679: ut_testOneConsumerNonexistentTopic 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #1, RackConfig = 1 ] 297s RDUT: PASS: rdkafka_range_assignor.c:699: ut_testOneConsumerNonexistentTopic 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #1, RackConfig = 2 ] 297s RDUT: PASS: rdkafka_range_assignor.c:699: ut_testOneConsumerNonexistentTopic 297s RDUT: INFO: rdkafka_range_assignor.c:1719: rd_kafka_range_assignor_unittest: [ Test #1 ran for 0.022ms ] 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #2, RackConfig = 0 ] 297s RDUT: PASS: rdkafka_range_assignor.c:732: ut_testOneConsumerOneTopic 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #2, RackConfig = 1 ] 297s RDUT: PASS: rdkafka_range_assignor.c:732: ut_testOneConsumerOneTopic 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #2, RackConfig = 2 ] 297s RDUT: PASS: rdkafka_range_assignor.c:732: ut_testOneConsumerOneTopic 297s RDUT: INFO: rdkafka_range_assignor.c:1719: rd_kafka_range_assignor_unittest: [ Test #2 ran for 0.030ms ] 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #3, RackConfig = 0 ] 297s RDUT: PASS: rdkafka_range_assignor.c:762: ut_testOnlyAssignsPartitionsFromSubscribedTopics 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #3, RackConfig = 1 ] 297s RDUT: PASS: rdkafka_range_assignor.c:762: ut_testOnlyAssignsPartitionsFromSubscribedTopics 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #3, RackConfig = 2 ] 297s RDUT: PASS: rdkafka_range_assignor.c:762: ut_testOnlyAssignsPartitionsFromSubscribedTopics 297s RDUT: INFO: rdkafka_range_assignor.c:1719: rd_kafka_range_assignor_unittest: [ Test #3 ran for 0.032ms ] 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #4, RackConfig = 0 ] 297s RDUT: PASS: rdkafka_range_assignor.c:791: ut_testOneConsumerMultipleTopics 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #4, RackConfig = 1 ] 297s RDUT: PASS: rdkafka_range_assignor.c:791: ut_testOneConsumerMultipleTopics 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #4, RackConfig = 2 ] 297s RDUT: PASS: rdkafka_range_assignor.c:791: ut_testOneConsumerMultipleTopics 297s RDUT: INFO: rdkafka_range_assignor.c:1719: rd_kafka_range_assignor_unittest: [ Test #4 ran for 0.033ms ] 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #5, RackConfig = 0 ] 297s RDUT: PASS: rdkafka_range_assignor.c:824: ut_testTwoConsumersOneTopicOnePartition 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #5, RackConfig = 1 ] 297s RDUT: PASS: rdkafka_range_assignor.c:824: ut_testTwoConsumersOneTopicOnePartition 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #5, RackConfig = 2 ] 297s RDUT: PASS: rdkafka_range_assignor.c:824: ut_testTwoConsumersOneTopicOnePartition 297s RDUT: INFO: rdkafka_range_assignor.c:1719: rd_kafka_range_assignor_unittest: [ Test #5 ran for 0.029ms ] 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #6, RackConfig = 0 ] 297s RDUT: PASS: rdkafka_range_assignor.c:857: ut_testTwoConsumersOneTopicTwoPartitions 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #6, RackConfig = 1 ] 297s RDUT: PASS: rdkafka_range_assignor.c:857: ut_testTwoConsumersOneTopicTwoPartitions 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #6, RackConfig = 2 ] 297s RDUT: PASS: rdkafka_range_assignor.c:857: ut_testTwoConsumersOneTopicTwoPartitions 297s RDUT: INFO: rdkafka_range_assignor.c:1719: rd_kafka_range_assignor_unittest: [ Test #6 ran for 0.029ms ] 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #7, RackConfig = 0 ] 297s RDUT: PASS: rdkafka_range_assignor.c:894: ut_testMultipleConsumersMixedTopicSubscriptions 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #7, RackConfig = 1 ] 297s RDUT: PASS: rdkafka_range_assignor.c:894: ut_testMultipleConsumersMixedTopicSubscriptions 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #7, RackConfig = 2 ] 297s RDUT: PASS: rdkafka_range_assignor.c:894: ut_testMultipleConsumersMixedTopicSubscriptions 297s RDUT: INFO: rdkafka_range_assignor.c:1719: rd_kafka_range_assignor_unittest: [ Test #7 ran for 0.045ms ] 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #8, RackConfig = 0 ] 297s RDUT: PASS: rdkafka_range_assignor.c:927: ut_testTwoConsumersTwoTopicsSixPartitions 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #8, RackConfig = 1 ] 297s RDUT: PASS: rdkafka_range_assignor.c:927: ut_testTwoConsumersTwoTopicsSixPartitions 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #8, RackConfig = 2 ] 297s RDUT: PASS: rdkafka_range_assignor.c:927: ut_testTwoConsumersTwoTopicsSixPartitions 297s RDUT: INFO: rdkafka_range_assignor.c:1719: rd_kafka_range_assignor_unittest: [ Test #8 ran for 0.043ms ] 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #9, RackConfig = 0 ] 297s RDUT: PASS: rdkafka_range_assignor.c:1093: ut_testRackAwareAssignmentWithUniformSubscription 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #9, RackConfig = 1 ] 297s RDUT: PASS: rdkafka_range_assignor.c:1093: ut_testRackAwareAssignmentWithUniformSubscription 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #9, RackConfig = 2 ] 297s RDUT: PASS: rdkafka_range_assignor.c:1167: ut_testRackAwareAssignmentWithUniformSubscription 297s RDUT: INFO: rdkafka_range_assignor.c:1719: rd_kafka_range_assignor_unittest: [ Test #9 ran for 0.299ms ] 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #10, RackConfig = 0 ] 297s RDUT: PASS: rdkafka_range_assignor.c:1185: ut_testRackAwareAssignmentWithNonEqualSubscription 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #10, RackConfig = 1 ] 297s RDUT: PASS: rdkafka_range_assignor.c:1185: ut_testRackAwareAssignmentWithNonEqualSubscription 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #10, RackConfig = 2 ] 297s RDUT: PASS: rdkafka_range_assignor.c:1258: ut_testRackAwareAssignmentWithNonEqualSubscription 297s RDUT: INFO: rdkafka_range_assignor.c:1719: rd_kafka_range_assignor_unittest: [ Test #10 ran for 0.313ms ] 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #11, RackConfig = 0 ] 297s RDUT: PASS: rdkafka_range_assignor.c:1276: ut_testRackAwareAssignmentWithUniformPartitions 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #11, RackConfig = 1 ] 297s RDUT: PASS: rdkafka_range_assignor.c:1276: ut_testRackAwareAssignmentWithUniformPartitions 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #11, RackConfig = 2 ] 297s RDUT: PASS: rdkafka_range_assignor.c:1318: ut_testRackAwareAssignmentWithUniformPartitions 297s RDUT: INFO: rdkafka_range_assignor.c:1719: rd_kafka_range_assignor_unittest: [ Test #11 ran for 0.276ms ] 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #12, RackConfig = 0 ] 297s RDUT: PASS: rdkafka_range_assignor.c:1336: ut_testRackAwareAssignmentWithUniformPartitionsNonEqualSubscription 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #12, RackConfig = 1 ] 297s RDUT: PASS: rdkafka_range_assignor.c:1336: ut_testRackAwareAssignmentWithUniformPartitionsNonEqualSubscription 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #12, RackConfig = 2 ] 297s RDUT: PASS: rdkafka_range_assignor.c:1411: ut_testRackAwareAssignmentWithUniformPartitionsNonEqualSubscription 297s RDUT: INFO: rdkafka_range_assignor.c:1719: rd_kafka_range_assignor_unittest: [ Test #12 ran for 0.263ms ] 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #13, RackConfig = 0 ] 297s RDUT: PASS: rdkafka_range_assignor.c:1432: ut_testRackAwareAssignmentWithCoPartitioning0 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #13, RackConfig = 1 ] 297s RDUT: PASS: rdkafka_range_assignor.c:1432: ut_testRackAwareAssignmentWithCoPartitioning0 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #13, RackConfig = 2 ] 297s RDUT: PASS: rdkafka_range_assignor.c:1493: ut_testRackAwareAssignmentWithCoPartitioning0 297s RDUT: INFO: rdkafka_range_assignor.c:1719: rd_kafka_range_assignor_unittest: [ Test #13 ran for 0.121ms ] 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #14, RackConfig = 0 ] 297s RDUT: PASS: rdkafka_range_assignor.c:1511: ut_testRackAwareAssignmentWithCoPartitioning1 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #14, RackConfig = 1 ] 297s RDUT: PASS: rdkafka_range_assignor.c:1511: ut_testRackAwareAssignmentWithCoPartitioning1 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #14, RackConfig = 2 ] 297s RDUT: PASS: rdkafka_range_assignor.c:1595: ut_testRackAwareAssignmentWithCoPartitioning1 297s RDUT: INFO: rdkafka_range_assignor.c:1719: rd_kafka_range_assignor_unittest: [ Test #14 ran for 0.184ms ] 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #15, RackConfig = 0 ] 297s RDUT: PASS: rdkafka_range_assignor.c:1612: ut_testCoPartitionedAssignmentWithSameSubscription 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #15, RackConfig = 1 ] 297s RDUT: PASS: rdkafka_range_assignor.c:1612: ut_testCoPartitionedAssignmentWithSameSubscription 297s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #15, RackConfig = 2 ] 297s RDUT: PASS: rdkafka_range_assignor.c:1652: ut_testCoPartitionedAssignmentWithSameSubscription 297s RDUT: INFO: rdkafka_range_assignor.c:1719: rd_kafka_range_assignor_unittest: [ Test #15 ran for 0.111ms ] 297s RDUT: INFO: rdkafka_sticky_assignor.c:4743: rd_kafka_sticky_assignor_unittest: [ Test #0 ] 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #0, RackConfig = 0 ] 297s RDUT: PASS: rdkafka_sticky_assignor.c:2255: ut_testOneConsumerNoTopic 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #0, RackConfig = 1 ] 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testOneConsumerNoTopic:2273: verifying assignment for 1 member(s): 297s RDUT: PASS: rdkafka_sticky_assignor.c:2279: ut_testOneConsumerNoTopic 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #0, RackConfig = 2 ] 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testOneConsumerNoTopic:2273: verifying assignment for 1 member(s): 297s RDUT: PASS: rdkafka_sticky_assignor.c:2279: ut_testOneConsumerNoTopic 297s RDUT: INFO: rdkafka_sticky_assignor.c:4750: rd_kafka_sticky_assignor_unittest: [ Test #0 ran for 0.681ms ] 297s RDUT: INFO: rdkafka_sticky_assignor.c:4743: rd_kafka_sticky_assignor_unittest: [ Test #1 ] 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #1, RackConfig = 0 ] 297s RDUT: PASS: rdkafka_sticky_assignor.c:2293: ut_testOneConsumerNonexistentTopic 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #1, RackConfig = 1 ] 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testOneConsumerNonexistentTopic:2310: verifying assignment for 1 member(s): 297s RDUT: PASS: rdkafka_sticky_assignor.c:2316: ut_testOneConsumerNonexistentTopic 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #1, RackConfig = 2 ] 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testOneConsumerNonexistentTopic:2310: verifying assignment for 1 member(s): 297s RDUT: PASS: rdkafka_sticky_assignor.c:2316: ut_testOneConsumerNonexistentTopic 297s RDUT: INFO: rdkafka_sticky_assignor.c:4750: rd_kafka_sticky_assignor_unittest: [ Test #1 ran for 0.839ms ] 297s RDUT: INFO: rdkafka_sticky_assignor.c:4743: rd_kafka_sticky_assignor_unittest: [ Test #2 ] 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #2, RackConfig = 0 ] 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testOneConsumerOneTopic:2349: verifying assignment for 1 member(s): 297s RDUT: PASS: rdkafka_sticky_assignor.c:2355: ut_testOneConsumerOneTopic 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #2, RackConfig = 1 ] 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testOneConsumerOneTopic:2349: verifying assignment for 1 member(s): 297s RDUT: PASS: rdkafka_sticky_assignor.c:2355: ut_testOneConsumerOneTopic 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #2, RackConfig = 2 ] 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testOneConsumerOneTopic:2349: verifying assignment for 1 member(s): 297s RDUT: PASS: rdkafka_sticky_assignor.c:2355: ut_testOneConsumerOneTopic 297s RDUT: INFO: rdkafka_sticky_assignor.c:4750: rd_kafka_sticky_assignor_unittest: [ Test #2 ran for 0.429ms ] 297s RDUT: INFO: rdkafka_sticky_assignor.c:4743: rd_kafka_sticky_assignor_unittest: [ Test #3 ] 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #3, RackConfig = 0 ] 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testOnlyAssignsPartitionsFromSubscribedTopics:2384: verifying assignment for 1 member(s): 297s RDUT: PASS: rdkafka_sticky_assignor.c:2390: ut_testOnlyAssignsPartitionsFromSubscribedTopics 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #3, RackConfig = 1 ] 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testOnlyAssignsPartitionsFromSubscribedTopics:2384: verifying assignment for 1 member(s): 297s RDUT: PASS: rdkafka_sticky_assignor.c:2390: ut_testOnlyAssignsPartitionsFromSubscribedTopics 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #3, RackConfig = 2 ] 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testOnlyAssignsPartitionsFromSubscribedTopics:2384: verifying assignment for 1 member(s): 297s RDUT: PASS: rdkafka_sticky_assignor.c:2390: ut_testOnlyAssignsPartitionsFromSubscribedTopics 297s RDUT: INFO: rdkafka_sticky_assignor.c:4750: rd_kafka_sticky_assignor_unittest: [ Test #3 ran for 0.071ms ] 297s RDUT: INFO: rdkafka_sticky_assignor.c:4743: rd_kafka_sticky_assignor_unittest: [ Test #4 ] 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #4, RackConfig = 0 ] 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testOneConsumerMultipleTopics:2419: verifying assignment for 1 member(s): 297s RDUT: PASS: rdkafka_sticky_assignor.c:2425: ut_testOneConsumerMultipleTopics 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #4, RackConfig = 1 ] 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testOneConsumerMultipleTopics:2419: verifying assignment for 1 member(s): 297s RDUT: PASS: rdkafka_sticky_assignor.c:2425: ut_testOneConsumerMultipleTopics 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #4, RackConfig = 2 ] 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testOneConsumerMultipleTopics:2419: verifying assignment for 1 member(s): 297s RDUT: PASS: rdkafka_sticky_assignor.c:2425: ut_testOneConsumerMultipleTopics 297s RDUT: INFO: rdkafka_sticky_assignor.c:4750: rd_kafka_sticky_assignor_unittest: [ Test #4 ran for 0.074ms ] 297s RDUT: INFO: rdkafka_sticky_assignor.c:4743: rd_kafka_sticky_assignor_unittest: [ Test #5 ] 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #5, RackConfig = 0 ] 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testTwoConsumersOneTopicOnePartition:2456: verifying assignment for 2 member(s): 297s RDUT: PASS: rdkafka_sticky_assignor.c:2463: ut_testTwoConsumersOneTopicOnePartition 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #5, RackConfig = 1 ] 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testTwoConsumersOneTopicOnePartition:2456: verifying assignment for 2 member(s): 297s RDUT: PASS: rdkafka_sticky_assignor.c:2463: ut_testTwoConsumersOneTopicOnePartition 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #5, RackConfig = 2 ] 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testTwoConsumersOneTopicOnePartition:2456: verifying assignment for 2 member(s): 297s RDUT: PASS: rdkafka_sticky_assignor.c:2463: ut_testTwoConsumersOneTopicOnePartition 297s RDUT: INFO: rdkafka_sticky_assignor.c:4750: rd_kafka_sticky_assignor_unittest: [ Test #5 ran for 0.066ms ] 297s RDUT: INFO: rdkafka_sticky_assignor.c:4743: rd_kafka_sticky_assignor_unittest: [ Test #6 ] 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #6, RackConfig = 0 ] 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testTwoConsumersOneTopicTwoPartitions:2495: verifying assignment for 2 member(s): 297s RDUT: PASS: rdkafka_sticky_assignor.c:2502: ut_testTwoConsumersOneTopicTwoPartitions 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #6, RackConfig = 1 ] 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testTwoConsumersOneTopicTwoPartitions:2495: verifying assignment for 2 member(s): 297s RDUT: PASS: rdkafka_sticky_assignor.c:2502: ut_testTwoConsumersOneTopicTwoPartitions 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #6, RackConfig = 2 ] 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testTwoConsumersOneTopicTwoPartitions:2495: verifying assignment for 2 member(s): 297s RDUT: PASS: rdkafka_sticky_assignor.c:2502: ut_testTwoConsumersOneTopicTwoPartitions 297s RDUT: INFO: rdkafka_sticky_assignor.c:4750: rd_kafka_sticky_assignor_unittest: [ Test #6 ran for 0.075ms ] 297s RDUT: INFO: rdkafka_sticky_assignor.c:4743: rd_kafka_sticky_assignor_unittest: [ Test #7 ] 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #7, RackConfig = 0 ] 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testMultipleConsumersMixedTopicSubscriptions:2539: verifying assignment for 3 member(s): 297s RDUT: PASS: rdkafka_sticky_assignor.c:2547: ut_testMultipleConsumersMixedTopicSubscriptions 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #7, RackConfig = 1 ] 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testMultipleConsumersMixedTopicSubscriptions:2539: verifying assignment for 3 member(s): 297s RDUT: PASS: rdkafka_sticky_assignor.c:2547: ut_testMultipleConsumersMixedTopicSubscriptions 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #7, RackConfig = 2 ] 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testMultipleConsumersMixedTopicSubscriptions:2539: verifying assignment for 3 member(s): 297s RDUT: PASS: rdkafka_sticky_assignor.c:2547: ut_testMultipleConsumersMixedTopicSubscriptions 297s RDUT: INFO: rdkafka_sticky_assignor.c:4750: rd_kafka_sticky_assignor_unittest: [ Test #7 ran for 0.113ms ] 297s RDUT: INFO: rdkafka_sticky_assignor.c:4743: rd_kafka_sticky_assignor_unittest: [ Test #8 ] 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #8, RackConfig = 0 ] 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testTwoConsumersTwoTopicsSixPartitions:2581: verifying assignment for 2 member(s): 297s RDUT: PASS: rdkafka_sticky_assignor.c:2588: ut_testTwoConsumersTwoTopicsSixPartitions 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #8, RackConfig = 1 ] 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testTwoConsumersTwoTopicsSixPartitions:2581: verifying assignment for 2 member(s): 297s RDUT: PASS: rdkafka_sticky_assignor.c:2588: ut_testTwoConsumersTwoTopicsSixPartitions 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #8, RackConfig = 2 ] 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testTwoConsumersTwoTopicsSixPartitions:2581: verifying assignment for 2 member(s): 297s RDUT: PASS: rdkafka_sticky_assignor.c:2588: ut_testTwoConsumersTwoTopicsSixPartitions 297s RDUT: INFO: rdkafka_sticky_assignor.c:4750: rd_kafka_sticky_assignor_unittest: [ Test #8 ran for 0.117ms ] 297s RDUT: INFO: rdkafka_sticky_assignor.c:4743: rd_kafka_sticky_assignor_unittest: [ Test #9 ] 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #9, RackConfig = 0 ] 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testAddRemoveConsumerOneTopic:2617: verifying assignment for 1 member(s): 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testAddRemoveConsumerOneTopic:2633: verifying assignment for 2 member(s): 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testAddRemoveConsumerOneTopic:2646: verifying assignment for 1 member(s): 297s RDUT: PASS: rdkafka_sticky_assignor.c:2654: ut_testAddRemoveConsumerOneTopic 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #9, RackConfig = 1 ] 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testAddRemoveConsumerOneTopic:2617: verifying assignment for 1 member(s): 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testAddRemoveConsumerOneTopic:2633: verifying assignment for 2 member(s): 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testAddRemoveConsumerOneTopic:2646: verifying assignment for 1 member(s): 297s RDUT: PASS: rdkafka_sticky_assignor.c:2654: ut_testAddRemoveConsumerOneTopic 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #9, RackConfig = 2 ] 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testAddRemoveConsumerOneTopic:2617: verifying assignment for 1 member(s): 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testAddRemoveConsumerOneTopic:2633: verifying assignment for 2 member(s): 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testAddRemoveConsumerOneTopic:2646: verifying assignment for 1 member(s): 297s RDUT: PASS: rdkafka_sticky_assignor.c:2654: ut_testAddRemoveConsumerOneTopic 297s RDUT: INFO: rdkafka_sticky_assignor.c:4750: rd_kafka_sticky_assignor_unittest: [ Test #9 ran for 0.196ms ] 297s RDUT: INFO: rdkafka_sticky_assignor.c:4743: rd_kafka_sticky_assignor_unittest: [ Test #10 ] 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #10, RackConfig = 0 ] 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testPoorRoundRobinAssignmentScenario:2718: verifying assignment for 4 member(s): 297s RDUT: PASS: rdkafka_sticky_assignor.c:2727: ut_testPoorRoundRobinAssignmentScenario 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #10, RackConfig = 1 ] 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testPoorRoundRobinAssignmentScenario:2718: verifying assignment for 4 member(s): 297s RDUT: PASS: rdkafka_sticky_assignor.c:2727: ut_testPoorRoundRobinAssignmentScenario 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #10, RackConfig = 2 ] 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testPoorRoundRobinAssignmentScenario:2718: verifying assignment for 4 member(s): 297s RDUT: PASS: rdkafka_sticky_assignor.c:2727: ut_testPoorRoundRobinAssignmentScenario 297s RDUT: INFO: rdkafka_sticky_assignor.c:4750: rd_kafka_sticky_assignor_unittest: [ Test #10 ran for 0.332ms ] 297s RDUT: INFO: rdkafka_sticky_assignor.c:4743: rd_kafka_sticky_assignor_unittest: [ Test #11 ] 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #11, RackConfig = 0 ] 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testAddRemoveTopicTwoConsumers:2760: verifying assignment for 2 member(s): 297s RDUT: INFO: rdkafka_sticky_assignor.c:2766: ut_testAddRemoveTopicTwoConsumers: Adding topic2 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testAddRemoveTopicTwoConsumers:2783: verifying assignment for 2 member(s): 297s RDUT: INFO: rdkafka_sticky_assignor.c:2791: ut_testAddRemoveTopicTwoConsumers: Removing topic1 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testAddRemoveTopicTwoConsumers:2806: verifying assignment for 2 member(s): 297s RDUT: PASS: rdkafka_sticky_assignor.c:2814: ut_testAddRemoveTopicTwoConsumers 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #11, RackConfig = 1 ] 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testAddRemoveTopicTwoConsumers:2760: verifying assignment for 2 member(s): 297s RDUT: INFO: rdkafka_sticky_assignor.c:2766: ut_testAddRemoveTopicTwoConsumers: Adding topic2 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testAddRemoveTopicTwoConsumers:2783: verifying assignment for 2 member(s): 297s RDUT: INFO: rdkafka_sticky_assignor.c:2791: ut_testAddRemoveTopicTwoConsumers: Removing topic1 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testAddRemoveTopicTwoConsumers:2806: verifying assignment for 2 member(s): 297s RDUT: PASS: rdkafka_sticky_assignor.c:2814: ut_testAddRemoveTopicTwoConsumers 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #11, RackConfig = 2 ] 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testAddRemoveTopicTwoConsumers:2760: verifying assignment for 2 member(s): 297s RDUT: INFO: rdkafka_sticky_assignor.c:2766: ut_testAddRemoveTopicTwoConsumers: Adding topic2 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testAddRemoveTopicTwoConsumers:2783: verifying assignment for 2 member(s): 297s RDUT: INFO: rdkafka_sticky_assignor.c:2791: ut_testAddRemoveTopicTwoConsumers: Removing topic1 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testAddRemoveTopicTwoConsumers:2806: verifying assignment for 2 member(s): 297s RDUT: PASS: rdkafka_sticky_assignor.c:2814: ut_testAddRemoveTopicTwoConsumers 297s RDUT: INFO: rdkafka_sticky_assignor.c:4750: rd_kafka_sticky_assignor_unittest: [ Test #11 ran for 0.278ms ] 297s RDUT: INFO: rdkafka_sticky_assignor.c:4743: rd_kafka_sticky_assignor_unittest: [ Test #12 ] 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #12, RackConfig = 0 ] 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testReassignmentAfterOneConsumerLeaves:2869: verifying assignment for 19 member(s): 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testReassignmentAfterOneConsumerLeaves:2884: verifying assignment for 18 member(s): 297s RDUT: PASS: rdkafka_sticky_assignor.c:2891: ut_testReassignmentAfterOneConsumerLeaves 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #12, RackConfig = 1 ] 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testReassignmentAfterOneConsumerLeaves:2869: verifying assignment for 19 member(s): 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testReassignmentAfterOneConsumerLeaves:2884: verifying assignment for 18 member(s): 297s RDUT: PASS: rdkafka_sticky_assignor.c:2891: ut_testReassignmentAfterOneConsumerLeaves 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #12, RackConfig = 2 ] 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testReassignmentAfterOneConsumerLeaves:2869: verifying assignment for 19 member(s): 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testReassignmentAfterOneConsumerLeaves:2884: verifying assignment for 18 member(s): 297s RDUT: PASS: rdkafka_sticky_assignor.c:2891: ut_testReassignmentAfterOneConsumerLeaves 297s RDUT: INFO: rdkafka_sticky_assignor.c:4750: rd_kafka_sticky_assignor_unittest: [ Test #12 ran for 25.836ms ] 297s RDUT: INFO: rdkafka_sticky_assignor.c:4743: rd_kafka_sticky_assignor_unittest: [ Test #13 ] 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #13, RackConfig = 0 ] 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testReassignmentAfterOneConsumerAdded:2931: verifying assignment for 8 member(s): 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testReassignmentAfterOneConsumerAdded:2943: verifying assignment for 9 member(s): 297s RDUT: PASS: rdkafka_sticky_assignor.c:2950: ut_testReassignmentAfterOneConsumerAdded 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #13, RackConfig = 1 ] 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testReassignmentAfterOneConsumerAdded:2931: verifying assignment for 8 member(s): 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testReassignmentAfterOneConsumerAdded:2943: verifying assignment for 9 member(s): 297s RDUT: PASS: rdkafka_sticky_assignor.c:2950: ut_testReassignmentAfterOneConsumerAdded 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #13, RackConfig = 2 ] 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testReassignmentAfterOneConsumerAdded:2931: verifying assignment for 8 member(s): 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testReassignmentAfterOneConsumerAdded:2943: verifying assignment for 9 member(s): 297s RDUT: PASS: rdkafka_sticky_assignor.c:2950: ut_testReassignmentAfterOneConsumerAdded 297s RDUT: INFO: rdkafka_sticky_assignor.c:4750: rd_kafka_sticky_assignor_unittest: [ Test #13 ran for 1.740ms ] 297s RDUT: INFO: rdkafka_sticky_assignor.c:4743: rd_kafka_sticky_assignor_unittest: [ Test #14 ] 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #14, RackConfig = 0 ] 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testSameSubscriptions:2999: verifying assignment for 9 member(s): 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testSameSubscriptions:3012: verifying assignment for 8 member(s): 297s RDUT: PASS: rdkafka_sticky_assignor.c:3020: ut_testSameSubscriptions 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #14, RackConfig = 1 ] 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testSameSubscriptions:2999: verifying assignment for 9 member(s): 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testSameSubscriptions:3012: verifying assignment for 8 member(s): 297s RDUT: PASS: rdkafka_sticky_assignor.c:3020: ut_testSameSubscriptions 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #14, RackConfig = 2 ] 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testSameSubscriptions:2999: verifying assignment for 9 member(s): 297s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testSameSubscriptions:3012: verifying assignment for 8 member(s): 297s RDUT: PASS: rdkafka_sticky_assignor.c:3020: ut_testSameSubscriptions 297s RDUT: INFO: rdkafka_sticky_assignor.c:4750: rd_kafka_sticky_assignor_unittest: [ Test #14 ran for 34.359ms ] 297s RDUT: INFO: rdkafka_sticky_assignor.c:4743: rd_kafka_sticky_assignor_unittest: [ Test #15 ] 297s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #15, RackConfig = 0 ] 298s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testLargeAssignmentWithMultipleConsumersLeaving:3076: verifying assignment for 200 member(s): 299s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testLargeAssignmentWithMultipleConsumersLeaving:3092: verifying assignment for 150 member(s): 299s RDUT: PASS: rdkafka_sticky_assignor.c:3099: ut_testLargeAssignmentWithMultipleConsumersLeaving 299s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #15, RackConfig = 1 ] 300s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testLargeAssignmentWithMultipleConsumersLeaving:3076: verifying assignment for 200 member(s): 300s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testLargeAssignmentWithMultipleConsumersLeaving:3092: verifying assignment for 150 member(s): 300s RDUT: PASS: rdkafka_sticky_assignor.c:3099: ut_testLargeAssignmentWithMultipleConsumersLeaving 300s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #15, RackConfig = 2 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testLargeAssignmentWithMultipleConsumersLeaving:3076: verifying assignment for 200 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testLargeAssignmentWithMultipleConsumersLeaving:3092: verifying assignment for 150 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:3099: ut_testLargeAssignmentWithMultipleConsumersLeaving 301s RDUT: INFO: rdkafka_sticky_assignor.c:4750: rd_kafka_sticky_assignor_unittest: [ Test #15 ran for 3981.377ms ] 301s RDUT: INFO: rdkafka_sticky_assignor.c:4743: rd_kafka_sticky_assignor_unittest: [ Test #16 ] 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #16, RackConfig = 0 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testNewSubscription:3144: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_sticky_assignor.c:3150: ut_testNewSubscription: Adding topic1 to consumer1 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testNewSubscription:3159: verifying assignment for 3 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:3167: ut_testNewSubscription 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #16, RackConfig = 1 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testNewSubscription:3144: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_sticky_assignor.c:3150: ut_testNewSubscription: Adding topic1 to consumer1 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testNewSubscription:3159: verifying assignment for 3 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:3167: ut_testNewSubscription 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #16, RackConfig = 2 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testNewSubscription:3144: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_sticky_assignor.c:3150: ut_testNewSubscription: Adding topic1 to consumer1 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testNewSubscription:3159: verifying assignment for 3 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:3167: ut_testNewSubscription 301s RDUT: INFO: rdkafka_sticky_assignor.c:4750: rd_kafka_sticky_assignor_unittest: [ Test #16 ran for 2.145ms ] 301s RDUT: INFO: rdkafka_sticky_assignor.c:4743: rd_kafka_sticky_assignor_unittest: [ Test #17 ] 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #17, RackConfig = 0 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testMoveExistingAssignments:3205: verifying assignment for 4 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testMoveExistingAssignments:3226: verifying assignment for 3 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:3262: ut_testMoveExistingAssignments 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #17, RackConfig = 1 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testMoveExistingAssignments:3205: verifying assignment for 4 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testMoveExistingAssignments:3226: verifying assignment for 3 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:3262: ut_testMoveExistingAssignments 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #17, RackConfig = 2 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testMoveExistingAssignments:3205: verifying assignment for 4 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testMoveExistingAssignments:3226: verifying assignment for 3 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:3262: ut_testMoveExistingAssignments 301s RDUT: INFO: rdkafka_sticky_assignor.c:4750: rd_kafka_sticky_assignor_unittest: [ Test #17 ran for 1.180ms ] 301s RDUT: INFO: rdkafka_sticky_assignor.c:4743: rd_kafka_sticky_assignor_unittest: [ Test #18 ] 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #18, RackConfig = 0 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testMoveExistingAssignments_j:3312: verifying assignment for 3 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:3321: ut_testMoveExistingAssignments_j 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #18, RackConfig = 1 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testMoveExistingAssignments_j:3312: verifying assignment for 3 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:3321: ut_testMoveExistingAssignments_j 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #18, RackConfig = 2 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testMoveExistingAssignments_j:3312: verifying assignment for 3 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:3321: ut_testMoveExistingAssignments_j 301s RDUT: INFO: rdkafka_sticky_assignor.c:4750: rd_kafka_sticky_assignor_unittest: [ Test #18 ran for 0.194ms ] 301s RDUT: INFO: rdkafka_sticky_assignor.c:4743: rd_kafka_sticky_assignor_unittest: [ Test #19 ] 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #19, RackConfig = 0 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testStickiness:3376: verifying assignment for 3 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:3382: ut_testStickiness 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #19, RackConfig = 1 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testStickiness:3376: verifying assignment for 3 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:3382: ut_testStickiness 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #19, RackConfig = 2 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testStickiness:3376: verifying assignment for 3 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:3382: ut_testStickiness 301s RDUT: INFO: rdkafka_sticky_assignor.c:4750: rd_kafka_sticky_assignor_unittest: [ Test #19 ran for 0.131ms ] 301s RDUT: INFO: rdkafka_sticky_assignor.c:4743: rd_kafka_sticky_assignor_unittest: [ Test #20 ] 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #20, RackConfig = 0 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testStickiness_j:3425: verifying assignment for 4 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testStickiness_j:3450: verifying assignment for 3 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:3486: ut_testStickiness_j 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #20, RackConfig = 1 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testStickiness_j:3425: verifying assignment for 4 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testStickiness_j:3450: verifying assignment for 3 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:3486: ut_testStickiness_j 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #20, RackConfig = 2 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testStickiness_j:3425: verifying assignment for 4 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testStickiness_j:3450: verifying assignment for 3 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:3486: ut_testStickiness_j 301s RDUT: INFO: rdkafka_sticky_assignor.c:4750: rd_kafka_sticky_assignor_unittest: [ Test #20 ran for 0.173ms ] 301s RDUT: INFO: rdkafka_sticky_assignor.c:4743: rd_kafka_sticky_assignor_unittest: [ Test #21 ] 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #21, RackConfig = 0 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testStickiness2:3523: verifying assignment for 1 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testStickiness2:3533: verifying assignment for 2 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testStickiness2:3547: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testStickiness2:3547: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testStickiness2:3559: verifying assignment for 2 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testStickiness2:3571: verifying assignment for 1 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:3580: ut_testStickiness2 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #21, RackConfig = 1 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testStickiness2:3523: verifying assignment for 1 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testStickiness2:3533: verifying assignment for 2 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testStickiness2:3547: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testStickiness2:3547: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testStickiness2:3559: verifying assignment for 2 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testStickiness2:3571: verifying assignment for 1 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:3580: ut_testStickiness2 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #21, RackConfig = 2 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testStickiness2:3523: verifying assignment for 1 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testStickiness2:3533: verifying assignment for 2 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testStickiness2:3547: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testStickiness2:3547: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testStickiness2:3559: verifying assignment for 2 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testStickiness2:3571: verifying assignment for 1 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:3580: ut_testStickiness2 301s RDUT: INFO: rdkafka_sticky_assignor.c:4750: rd_kafka_sticky_assignor_unittest: [ Test #21 ran for 0.929ms ] 301s RDUT: INFO: rdkafka_sticky_assignor.c:4743: rd_kafka_sticky_assignor_unittest: [ Test #22 ] 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #22, RackConfig = 0 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testAssignmentUpdatedForDeletedTopic:3606: verifying assignment for 1 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:3616: ut_testAssignmentUpdatedForDeletedTopic 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #22, RackConfig = 1 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testAssignmentUpdatedForDeletedTopic:3606: verifying assignment for 1 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:3616: ut_testAssignmentUpdatedForDeletedTopic 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #22, RackConfig = 2 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testAssignmentUpdatedForDeletedTopic:3606: verifying assignment for 1 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:3616: ut_testAssignmentUpdatedForDeletedTopic 301s RDUT: INFO: rdkafka_sticky_assignor.c:4750: rd_kafka_sticky_assignor_unittest: [ Test #22 ran for 1.990ms ] 301s RDUT: INFO: rdkafka_sticky_assignor.c:4743: rd_kafka_sticky_assignor_unittest: [ Test #23 ] 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #23, RackConfig = 0 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testNoExceptionThrownWhenOnlySubscribedTopicDeleted:3643: verifying assignment for 1 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testNoExceptionThrownWhenOnlySubscribedTopicDeleted:3657: verifying assignment for 1 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:3663: ut_testNoExceptionThrownWhenOnlySubscribedTopicDeleted 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #23, RackConfig = 1 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testNoExceptionThrownWhenOnlySubscribedTopicDeleted:3643: verifying assignment for 1 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testNoExceptionThrownWhenOnlySubscribedTopicDeleted:3657: verifying assignment for 1 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:3663: ut_testNoExceptionThrownWhenOnlySubscribedTopicDeleted 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #23, RackConfig = 2 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testNoExceptionThrownWhenOnlySubscribedTopicDeleted:3643: verifying assignment for 1 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testNoExceptionThrownWhenOnlySubscribedTopicDeleted:3657: verifying assignment for 1 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:3663: ut_testNoExceptionThrownWhenOnlySubscribedTopicDeleted 301s RDUT: INFO: rdkafka_sticky_assignor.c:4750: rd_kafka_sticky_assignor_unittest: [ Test #23 ran for 0.507ms ] 301s RDUT: INFO: rdkafka_sticky_assignor.c:4743: rd_kafka_sticky_assignor_unittest: [ Test #24 ] 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #24, RackConfig = 0 ] 301s RDUT: PASS: rdkafka_sticky_assignor.c:3681: ut_testConflictingPreviousAssignments 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #24, RackConfig = 1 ] 301s RDUT: PASS: rdkafka_sticky_assignor.c:3681: ut_testConflictingPreviousAssignments 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #24, RackConfig = 2 ] 301s RDUT: PASS: rdkafka_sticky_assignor.c:3681: ut_testConflictingPreviousAssignments 301s RDUT: INFO: rdkafka_sticky_assignor.c:4750: rd_kafka_sticky_assignor_unittest: [ Test #24 ran for 0.018ms ] 301s RDUT: INFO: rdkafka_sticky_assignor.c:4743: rd_kafka_sticky_assignor_unittest: [ Test #25 ] 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #25, RackConfig = 0 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testAllConsumersReachExpectedQuotaAndAreConsideredFilled:3769: verifying assignment for 3 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:3778: ut_testAllConsumersReachExpectedQuotaAndAreConsideredFilled 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #25, RackConfig = 1 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testAllConsumersReachExpectedQuotaAndAreConsideredFilled:3769: verifying assignment for 3 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:3778: ut_testAllConsumersReachExpectedQuotaAndAreConsideredFilled 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #25, RackConfig = 2 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testAllConsumersReachExpectedQuotaAndAreConsideredFilled:3769: verifying assignment for 3 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:3778: ut_testAllConsumersReachExpectedQuotaAndAreConsideredFilled 301s RDUT: INFO: rdkafka_sticky_assignor.c:4750: rd_kafka_sticky_assignor_unittest: [ Test #25 ran for 0.110ms ] 301s RDUT: INFO: rdkafka_sticky_assignor.c:4743: rd_kafka_sticky_assignor_unittest: [ Test #26 ] 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #26, RackConfig = 0 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testOwnedPartitionsAreInvalidatedForConsumerWithStaleGeneration:3816: verifying assignment for 2 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:3827: ut_testOwnedPartitionsAreInvalidatedForConsumerWithStaleGeneration 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #26, RackConfig = 1 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testOwnedPartitionsAreInvalidatedForConsumerWithStaleGeneration:3816: verifying assignment for 2 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:3827: ut_testOwnedPartitionsAreInvalidatedForConsumerWithStaleGeneration 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #26, RackConfig = 2 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testOwnedPartitionsAreInvalidatedForConsumerWithStaleGeneration:3816: verifying assignment for 2 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:3827: ut_testOwnedPartitionsAreInvalidatedForConsumerWithStaleGeneration 301s RDUT: INFO: rdkafka_sticky_assignor.c:4750: rd_kafka_sticky_assignor_unittest: [ Test #26 ran for 0.133ms ] 301s RDUT: INFO: rdkafka_sticky_assignor.c:4743: rd_kafka_sticky_assignor_unittest: [ Test #27 ] 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #27, RackConfig = 0 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testOwnedPartitionsAreInvalidatedForConsumerWithNoGeneration:3864: verifying assignment for 2 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:3875: ut_testOwnedPartitionsAreInvalidatedForConsumerWithNoGeneration 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #27, RackConfig = 1 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testOwnedPartitionsAreInvalidatedForConsumerWithNoGeneration:3864: verifying assignment for 2 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:3875: ut_testOwnedPartitionsAreInvalidatedForConsumerWithNoGeneration 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #27, RackConfig = 2 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testOwnedPartitionsAreInvalidatedForConsumerWithNoGeneration:3864: verifying assignment for 2 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:3875: ut_testOwnedPartitionsAreInvalidatedForConsumerWithNoGeneration 301s RDUT: INFO: rdkafka_sticky_assignor.c:4750: rd_kafka_sticky_assignor_unittest: [ Test #27 ran for 0.128ms ] 301s RDUT: INFO: rdkafka_sticky_assignor.c:4743: rd_kafka_sticky_assignor_unittest: [ Test #28 ] 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #28, RackConfig = 0 ] 301s %3|1710814191.456|STICKY|rdkafka#consumer-4| [thrd:app]: Sticky assignor: Found multiple consumers consumer1 and consumer2 claiming the same topic partition topic1:0 in the same generation 1, this will be invalidated and removed from their previous assignment. 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testPartitionsTransferringOwnershipIncludeThePartitionClaimedByMultipleConsumersInSameGeneration:3916: verifying assignment for 3 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:3925: ut_testPartitionsTransferringOwnershipIncludeThePartitionClaimedByMultipleConsumersInSameGeneration 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #28, RackConfig = 1 ] 301s %3|1710814191.456|STICKY|rdkafka#consumer-4| [thrd:app]: Sticky assignor: Found multiple consumers consumer1 and consumer2 claiming the same topic partition topic1:0 in the same generation 1, this will be invalidated and removed from their previous assignment. 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testPartitionsTransferringOwnershipIncludeThePartitionClaimedByMultipleConsumersInSameGeneration:3916: verifying assignment for 3 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:3925: ut_testPartitionsTransferringOwnershipIncludeThePartitionClaimedByMultipleConsumersInSameGeneration 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #28, RackConfig = 2 ] 301s %3|1710814191.456|STICKY|rdkafka#consumer-4| [thrd:app]: Sticky assignor: Found multiple consumers consumer1 and consumer2 claiming the same topic partition topic1:0 in the same generation 1, this will be invalidated and removed from their previous assignment. 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testPartitionsTransferringOwnershipIncludeThePartitionClaimedByMultipleConsumersInSameGeneration:3916: verifying assignment for 3 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:3925: ut_testPartitionsTransferringOwnershipIncludeThePartitionClaimedByMultipleConsumersInSameGeneration 301s RDUT: INFO: rdkafka_sticky_assignor.c:4750: rd_kafka_sticky_assignor_unittest: [ Test #28 ran for 0.126ms ] 301s RDUT: INFO: rdkafka_sticky_assignor.c:4743: rd_kafka_sticky_assignor_unittest: [ Test #29 ] 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #29, RackConfig = 0 ] 301s %3|1710814191.457|STICKY|rdkafka#consumer-4| [thrd:app]: Sticky assignor: Found multiple consumers consumer1 and consumer2 claiming the same topic partition topic1:1 in the same generation 1, this will be invalidated and removed from their previous assignment. 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testPartitionsTransferringOwnershipIncludeThePartitionClaimedByMultipleConsumersInSameGeneration2:3973: verifying assignment for 3 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:3982: ut_testPartitionsTransferringOwnershipIncludeThePartitionClaimedByMultipleConsumersInSameGeneration2 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #29, RackConfig = 1 ] 301s %3|1710814191.457|STICKY|rdkafka#consumer-4| [thrd:app]: Sticky assignor: Found multiple consumers consumer1 and consumer2 claiming the same topic partition topic1:1 in the same generation 1, this will be invalidated and removed from their previous assignment. 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testPartitionsTransferringOwnershipIncludeThePartitionClaimedByMultipleConsumersInSameGeneration2:3973: verifying assignment for 3 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:3982: ut_testPartitionsTransferringOwnershipIncludeThePartitionClaimedByMultipleConsumersInSameGeneration2 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #29, RackConfig = 2 ] 301s %3|1710814191.457|STICKY|rdkafka#consumer-4| [thrd:app]: Sticky assignor: Found multiple consumers consumer1 and consumer2 claiming the same topic partition topic1:1 in the same generation 1, this will be invalidated and removed from their previous assignment. 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testPartitionsTransferringOwnershipIncludeThePartitionClaimedByMultipleConsumersInSameGeneration2:3973: verifying assignment for 3 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:3982: ut_testPartitionsTransferringOwnershipIncludeThePartitionClaimedByMultipleConsumersInSameGeneration2 301s RDUT: INFO: rdkafka_sticky_assignor.c:4750: rd_kafka_sticky_assignor_unittest: [ Test #29 ran for 0.119ms ] 301s RDUT: INFO: rdkafka_sticky_assignor.c:4743: rd_kafka_sticky_assignor_unittest: [ Test #30 ] 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #30, RackConfig = 0 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testEnsurePartitionsAssignedToHighestGeneration:4035: verifying assignment for 3 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:4041: ut_testEnsurePartitionsAssignedToHighestGeneration 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #30, RackConfig = 1 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testEnsurePartitionsAssignedToHighestGeneration:4035: verifying assignment for 3 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:4041: ut_testEnsurePartitionsAssignedToHighestGeneration 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #30, RackConfig = 2 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testEnsurePartitionsAssignedToHighestGeneration:4035: verifying assignment for 3 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:4041: ut_testEnsurePartitionsAssignedToHighestGeneration 301s RDUT: INFO: rdkafka_sticky_assignor.c:4750: rd_kafka_sticky_assignor_unittest: [ Test #30 ran for 0.198ms ] 301s RDUT: INFO: rdkafka_sticky_assignor.c:4743: rd_kafka_sticky_assignor_unittest: [ Test #31 ] 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #31, RackConfig = 0 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testNoReassignmentOnCurrentMembers:4093: verifying assignment for 4 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:4101: ut_testNoReassignmentOnCurrentMembers 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #31, RackConfig = 1 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testNoReassignmentOnCurrentMembers:4093: verifying assignment for 4 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:4101: ut_testNoReassignmentOnCurrentMembers 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #31, RackConfig = 2 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testNoReassignmentOnCurrentMembers:4093: verifying assignment for 4 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:4101: ut_testNoReassignmentOnCurrentMembers 301s RDUT: INFO: rdkafka_sticky_assignor.c:4750: rd_kafka_sticky_assignor_unittest: [ Test #31 ran for 0.770ms ] 301s RDUT: INFO: rdkafka_sticky_assignor.c:4743: rd_kafka_sticky_assignor_unittest: [ Test #32 ] 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #32, RackConfig = 0 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testOwnedPartitionsAreInvalidatedForConsumerWithMultipleGeneration:4140: verifying assignment for 2 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:4150: ut_testOwnedPartitionsAreInvalidatedForConsumerWithMultipleGeneration 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #32, RackConfig = 1 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testOwnedPartitionsAreInvalidatedForConsumerWithMultipleGeneration:4140: verifying assignment for 2 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:4150: ut_testOwnedPartitionsAreInvalidatedForConsumerWithMultipleGeneration 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #32, RackConfig = 2 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: ut_testOwnedPartitionsAreInvalidatedForConsumerWithMultipleGeneration:4140: verifying assignment for 2 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:4150: ut_testOwnedPartitionsAreInvalidatedForConsumerWithMultipleGeneration 301s RDUT: INFO: rdkafka_sticky_assignor.c:4750: rd_kafka_sticky_assignor_unittest: [ Test #32 ran for 0.757ms ] 301s RDUT: INFO: rdkafka_sticky_assignor.c:4743: rd_kafka_sticky_assignor_unittest: [ Test #33 ] 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #33, RackConfig = 0 ] 301s RDUT: PASS: rdkafka_sticky_assignor.c:4365: ut_testRackAwareAssignmentWithUniformSubscription 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #33, RackConfig = 1 ] 301s RDUT: PASS: rdkafka_sticky_assignor.c:4365: ut_testRackAwareAssignmentWithUniformSubscription 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #33, RackConfig = 2 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: setupRackAwareAssignment0:4221: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: setupRackAwareAssignment0:4221: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: setupRackAwareAssignment0:4221: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: setupRackAwareAssignment0:4221: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: setupRackAwareAssignment0:4221: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: setupRackAwareAssignment0:4221: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: setupRackAwareAssignment0:4221: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: setupRackAwareAssignment0:4221: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: setupRackAwareAssignment0:4221: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: setupRackAwareAssignment0:4221: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: setupRackAwareAssignment0:4221: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: setupRackAwareAssignment0:4221: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: setupRackAwareAssignment0:4221: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: setupRackAwareAssignment0:4221: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: setupRackAwareAssignment0:4221: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: setupRackAwareAssignment0:4221: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: setupRackAwareAssignment0:4221: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: setupRackAwareAssignment0:4221: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: setupRackAwareAssignment0:4221: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: setupRackAwareAssignment0:4221: verifying assignment for 3 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:4522: ut_testRackAwareAssignmentWithUniformSubscription 301s RDUT: INFO: rdkafka_sticky_assignor.c:4750: rd_kafka_sticky_assignor_unittest: [ Test #33 ran for 1.669ms ] 301s RDUT: INFO: rdkafka_sticky_assignor.c:4743: rd_kafka_sticky_assignor_unittest: [ Test #34 ] 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #34, RackConfig = 0 ] 301s RDUT: PASS: rdkafka_sticky_assignor.c:4544: ut_testRackAwareAssignmentWithNonEqualSubscription 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #34, RackConfig = 1 ] 301s RDUT: PASS: rdkafka_sticky_assignor.c:4544: ut_testRackAwareAssignmentWithNonEqualSubscription 301s RDUT: INFO: rdkafka_sticky_assignor.c:4746: rd_kafka_sticky_assignor_unittest: [ Test #34, RackConfig = 2 ] 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: setupRackAwareAssignment0:4221: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: setupRackAwareAssignment0:4221: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: setupRackAwareAssignment0:4221: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: setupRackAwareAssignment0:4221: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: setupRackAwareAssignment0:4221: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: setupRackAwareAssignment0:4221: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: setupRackAwareAssignment0:4221: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: setupRackAwareAssignment0:4221: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: setupRackAwareAssignment0:4221: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: setupRackAwareAssignment0:4221: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: setupRackAwareAssignment0:4221: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: setupRackAwareAssignment0:4221: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: setupRackAwareAssignment0:4221: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: setupRackAwareAssignment0:4221: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: setupRackAwareAssignment0:4221: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: setupRackAwareAssignment0:4221: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: setupRackAwareAssignment0:4221: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: setupRackAwareAssignment0:4221: verifying assignment for 3 member(s): 301s RDUT: INFO: rdkafka_assignor.c:1205: verifyValidityAndBalance0: setupRackAwareAssignment0:4221: verifying assignment for 3 member(s): 301s RDUT: PASS: rdkafka_sticky_assignor.c:4663: ut_testRackAwareAssignmentWithNonEqualSubscription 301s RDUT: INFO: rdkafka_sticky_assignor.c:4750: rd_kafka_sticky_assignor_unittest: [ Test #34 ran for 2.421ms ] 301s RDUT: PASS: rdkafka_assignor.c:1776: ut_assignors 301s RDUT: INFO: rdunittest.c:501: rd_unittest: unittest: assignors: PASS 301s autopkgtest [02:09:51]: test unittest: -----------------------] 302s unittest PASS 302s autopkgtest [02:09:52]: test unittest: - - - - - - - - - - results - - - - - - - - - - 303s autopkgtest [02:09:53]: @@@@@@@@@@@@@@@@@@@@ summary 303s examples PASS 303s unittest PASS 336s Creating nova instance adt-noble-ppc64el-librdkafka-20240319-020450-juju-7f2275-prod-proposed-migration-environment-2 from image adt/ubuntu-noble-ppc64el-server-20240319.img (UUID 9d87beed-6c32-481f-958d-7469e26317f3)...