0s autopkgtest [12:38:44]: starting date and time: 2026-01-29 12:38:44+0000 0s autopkgtest [12:38:44]: git checkout: 4b346b80 nova: make wait_reboot return success even when a no-op 0s autopkgtest [12:38:44]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.5ylopjxf/out --timeout-copy=6000 --needs-internet=try --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:pkgconf --apt-upgrade librdkafka --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=pkgconf/2.5.1-2 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-cpu2-ram4-disk20-s390x --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@sto01-s390x-12.secgroup --name adt-resolute-s390x-librdkafka-20260129-123844-juju-7f2275-prod-proposed-migration-environment-2-a8a161de-a3df-4498-841c-767c04944b56 --image adt/ubuntu-resolute-s390x-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-autopkgtest-workers-s390x -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 4s Creating nova instance adt-resolute-s390x-librdkafka-20260129-123844-juju-7f2275-prod-proposed-migration-environment-2-a8a161de-a3df-4498-841c-767c04944b56 from image adt/ubuntu-resolute-s390x-server-20260128.img (UUID 5ba972fb-5682-41ac-8a6c-59e0b358d8f4)... 66s autopkgtest [12:39:50]: testbed dpkg architecture: s390x 66s autopkgtest [12:39:50]: testbed apt version: 3.1.14 67s autopkgtest [12:39:51]: @@@@@@@@@@@@@@@@@@@@ test bed setup 67s autopkgtest [12:39:51]: testbed release detected to be: None 68s autopkgtest [12:39:52]: updating testbed package index (apt update) 69s Get:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease [124 kB] 69s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 69s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 69s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 69s Get:5 http://ftpmaster.internal/ubuntu resolute-proposed/restricted Sources [2820 B] 69s Get:6 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse Sources [25.4 kB] 69s Get:7 http://ftpmaster.internal/ubuntu resolute-proposed/main Sources [106 kB] 69s Get:8 http://ftpmaster.internal/ubuntu resolute-proposed/universe Sources [1074 kB] 69s Get:9 http://ftpmaster.internal/ubuntu resolute-proposed/main s390x Packages [120 kB] 70s Get:10 http://ftpmaster.internal/ubuntu resolute-proposed/universe s390x Packages [701 kB] 70s Get:11 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse s390x Packages [6428 B] 70s Fetched 2160 kB in 1s (1838 kB/s) 73s Reading package lists... 74s Hit:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease 74s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 74s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 74s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 77s Reading package lists... 77s Reading package lists... 78s Building dependency tree... 78s Reading state information... 78s Calculating upgrade... 79s The following packages will be upgraded: 79s libxcb1 tzdata 79s 2 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 79s Need to get 250 kB of archives. 79s After this operation, 0 B of additional disk space will be used. 79s Get:1 http://ftpmaster.internal/ubuntu resolute/main s390x tzdata all 2025c-3ubuntu3 [199 kB] 79s Get:2 http://ftpmaster.internal/ubuntu resolute/main s390x libxcb1 s390x 1.17.0-2ubuntu1 [50.6 kB] 81s dpkg-preconfigure: unable to re-open stdin: No such file or directory 81s Fetched 250 kB in 0s (5327 kB/s) 82s (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 ... 87720 files and directories currently installed.) 82s Preparing to unpack .../tzdata_2025c-3ubuntu3_all.deb ... 82s Unpacking tzdata (2025c-3ubuntu3) over (2025c-3ubuntu2) ... 82s Preparing to unpack .../libxcb1_1.17.0-2ubuntu1_s390x.deb ... 82s Unpacking libxcb1:s390x (1.17.0-2ubuntu1) over (1.17.0-2build1) ... 83s Setting up libxcb1:s390x (1.17.0-2ubuntu1) ... 83s Setting up tzdata (2025c-3ubuntu3) ... 83s 83s Current default time zone: 'Etc/UTC' 83s Local time is now: Thu Jan 29 12:42:21 UTC 2026. 83s Universal Time is now: Thu Jan 29 12:42:21 UTC 2026. 83s Run 'dpkg-reconfigure tzdata' if you wish to change it. 83s 83s Processing triggers for libc-bin (2.42-2ubuntu4) ... 84s autopkgtest [12:40:08]: upgrading testbed (apt dist-upgrade and autopurge) 84s Reading package lists... 84s Building dependency tree... 84s Reading state information... 85s Calculating upgrade... 85s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 86s Reading package lists... 87s Building dependency tree... 87s Reading state information... 87s Solving dependencies... 88s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 92s autopkgtest [12:40:16]: testbed running kernel: Linux 6.18.0-9-generic #9-Ubuntu SMP Mon Jan 12 15:39:23 UTC 2026 93s autopkgtest [12:40:17]: @@@@@@@@@@@@@@@@@@@@ apt-source librdkafka 97s Get:1 http://ftpmaster.internal/ubuntu resolute/universe librdkafka 2.11.1-2 (dsc) [2185 B] 97s Get:2 http://ftpmaster.internal/ubuntu resolute/universe librdkafka 2.11.1-2 (tar) [4857 kB] 97s Get:3 http://ftpmaster.internal/ubuntu resolute/universe librdkafka 2.11.1-2 (diff) [13.7 kB] 97s gpgv: Signature made Thu Aug 28 17:17:46 2025 UTC 97s gpgv: using RSA key A9592C521CB904077D6598009D0B5E5B1EEC8F0E 97s gpgv: Can't check signature: No public key 97s dpkg-source: warning: cannot verify inline signature for ./librdkafka_2.11.1-2.dsc: no acceptable signature found 98s autopkgtest [12:40:22]: testing package librdkafka version 2.11.1-2 98s autopkgtest [12:40:22]: build not needed 99s autopkgtest [12:40:23]: test examples: preparing testbed 100s Reading package lists... 100s Building dependency tree... 100s Reading state information... 100s Solving dependencies... 101s The following NEW packages will be installed: 101s build-essential comerr-dev cpp cpp-15 cpp-15-s390x-linux-gnu 101s cpp-s390x-linux-gnu g++ g++-15 g++-15-s390x-linux-gnu g++-s390x-linux-gnu 101s gcc gcc-15 gcc-15-s390x-linux-gnu gcc-s390x-linux-gnu krb5-multidev libasan8 101s libbrotli-dev libcc1-0 libcurl4-openssl-dev libevent-2.1-7t64 libgcc-15-dev 101s libgmp-dev libgmpxx4ldbl libgnutls-dane0t64 libgnutls-openssl27t64 101s libgnutls28-dev libgomp1 libgssrpc4t64 libidn2-dev libisl23 libitm1 101s libkadm5clnt-mit12 libkadm5srv-mit12 libkdb5-10t64 libkrb5-dev libldap-dev 101s liblz4-dev libmpc3 libnghttp2-dev libp11-kit-dev libpkgconf7 libpsl-dev 101s librdkafka++1 librdkafka-dev librdkafka1 librtmp-dev libsasl2-dev 101s libssh2-1-dev libssl-dev libstdc++-15-dev libtasn1-6-dev libubsan1 101s libunbound8 libxxhash-dev libzstd-dev nettle-dev pkgconf pkgconf-bin 101s zlib1g-dev 101s 0 upgraded, 59 newly installed, 0 to remove and 0 not upgraded. 101s Need to get 63.6 MB of archives. 101s After this operation, 214 MB of additional disk space will be used. 101s Get:1 http://ftpmaster.internal/ubuntu resolute/main s390x libisl23 s390x 0.27-1build1 [702 kB] 101s Get:2 http://ftpmaster.internal/ubuntu resolute/main s390x libmpc3 s390x 1.3.1-2 [57.4 kB] 101s Get:3 http://ftpmaster.internal/ubuntu resolute/main s390x cpp-15-s390x-linux-gnu s390x 15.2.0-11ubuntu1 [10.2 MB] 102s Get:4 http://ftpmaster.internal/ubuntu resolute/main s390x cpp-15 s390x 15.2.0-11ubuntu1 [1028 B] 102s Get:5 http://ftpmaster.internal/ubuntu resolute/main s390x cpp-s390x-linux-gnu s390x 4:15.2.0-4ubuntu1 [5746 B] 102s Get:6 http://ftpmaster.internal/ubuntu resolute/main s390x cpp s390x 4:15.2.0-4ubuntu1 [22.4 kB] 102s Get:7 http://ftpmaster.internal/ubuntu resolute/main s390x libcc1-0 s390x 15.2.0-11ubuntu1 [50.0 kB] 102s Get:8 http://ftpmaster.internal/ubuntu resolute/main s390x libgomp1 s390x 15.2.0-11ubuntu1 [154 kB] 102s Get:9 http://ftpmaster.internal/ubuntu resolute/main s390x libitm1 s390x 15.2.0-11ubuntu1 [30.9 kB] 102s Get:10 http://ftpmaster.internal/ubuntu resolute/main s390x libasan8 s390x 15.2.0-11ubuntu1 [2968 kB] 102s Get:11 http://ftpmaster.internal/ubuntu resolute/main s390x libubsan1 s390x 15.2.0-11ubuntu1 [1211 kB] 103s Get:12 http://ftpmaster.internal/ubuntu resolute/main s390x libgcc-15-dev s390x 15.2.0-11ubuntu1 [1045 kB] 103s Get:13 http://ftpmaster.internal/ubuntu resolute/main s390x gcc-15-s390x-linux-gnu s390x 15.2.0-11ubuntu1 [19.9 MB] 104s Get:14 http://ftpmaster.internal/ubuntu resolute/main s390x gcc-15 s390x 15.2.0-11ubuntu1 [517 kB] 104s Get:15 http://ftpmaster.internal/ubuntu resolute/main s390x gcc-s390x-linux-gnu s390x 4:15.2.0-4ubuntu1 [1208 B] 104s Get:16 http://ftpmaster.internal/ubuntu resolute/main s390x gcc s390x 4:15.2.0-4ubuntu1 [5018 B] 104s Get:17 http://ftpmaster.internal/ubuntu resolute/main s390x libstdc++-15-dev s390x 15.2.0-11ubuntu1 [2660 kB] 104s Get:18 http://ftpmaster.internal/ubuntu resolute/main s390x g++-15-s390x-linux-gnu s390x 15.2.0-11ubuntu1 [11.7 MB] 104s Get:19 http://ftpmaster.internal/ubuntu resolute/main s390x g++-15 s390x 15.2.0-11ubuntu1 [24.6 kB] 104s Get:20 http://ftpmaster.internal/ubuntu resolute/main s390x g++-s390x-linux-gnu s390x 4:15.2.0-4ubuntu1 [956 B] 104s Get:21 http://ftpmaster.internal/ubuntu resolute/main s390x g++ s390x 4:15.2.0-4ubuntu1 [1078 B] 104s Get:22 http://ftpmaster.internal/ubuntu resolute/main s390x build-essential s390x 12.12ubuntu2 [5258 B] 104s Get:23 http://ftpmaster.internal/ubuntu resolute/main s390x comerr-dev s390x 2.1-1.47.2-3ubuntu2 [44.8 kB] 104s Get:24 http://ftpmaster.internal/ubuntu resolute/main s390x libgssrpc4t64 s390x 1.22.1-2 [58.7 kB] 104s Get:25 http://ftpmaster.internal/ubuntu resolute/main s390x libkadm5clnt-mit12 s390x 1.22.1-2 [40.8 kB] 104s Get:26 http://ftpmaster.internal/ubuntu resolute/main s390x libkdb5-10t64 s390x 1.22.1-2 [42.5 kB] 104s Get:27 http://ftpmaster.internal/ubuntu resolute/main s390x libkadm5srv-mit12 s390x 1.22.1-2 [55.7 kB] 104s Get:28 http://ftpmaster.internal/ubuntu resolute/main s390x krb5-multidev s390x 1.22.1-2 [126 kB] 104s Get:29 http://ftpmaster.internal/ubuntu resolute/main s390x libbrotli-dev s390x 1.1.0-2build6 [398 kB] 104s Get:30 http://ftpmaster.internal/ubuntu resolute/main s390x libidn2-dev s390x 2.3.8-4 [122 kB] 104s Get:31 http://ftpmaster.internal/ubuntu resolute/main s390x libkrb5-dev s390x 1.22.1-2 [11.9 kB] 104s Get:32 http://ftpmaster.internal/ubuntu resolute/main s390x libldap-dev s390x 2.6.10+dfsg-1ubuntu5 [314 kB] 104s Get:33 http://ftpmaster.internal/ubuntu resolute-proposed/main s390x libpkgconf7 s390x 2.5.1-2 [39.0 kB] 104s Get:34 http://ftpmaster.internal/ubuntu resolute-proposed/main s390x pkgconf-bin s390x 2.5.1-2 [23.6 kB] 104s Get:35 http://ftpmaster.internal/ubuntu resolute-proposed/main s390x pkgconf s390x 2.5.1-2 [20.0 kB] 104s Get:36 http://ftpmaster.internal/ubuntu resolute/main s390x libnghttp2-dev s390x 1.64.0-1.1ubuntu1 [121 kB] 104s Get:37 http://ftpmaster.internal/ubuntu resolute/main s390x libpsl-dev s390x 0.21.2-1.1build2 [79.2 kB] 104s Get:38 http://ftpmaster.internal/ubuntu resolute/main s390x libgmpxx4ldbl s390x 2:6.3.0+dfsg-5ubuntu1 [10.1 kB] 104s Get:39 http://ftpmaster.internal/ubuntu resolute/main s390x libgmp-dev s390x 2:6.3.0+dfsg-5ubuntu1 [423 kB] 104s Get:40 http://ftpmaster.internal/ubuntu resolute/main s390x libevent-2.1-7t64 s390x 2.1.12-stable-10build1 [144 kB] 104s Get:41 http://ftpmaster.internal/ubuntu resolute/main s390x libunbound8 s390x 1.24.2-1ubuntu1 [464 kB] 104s Get:42 http://ftpmaster.internal/ubuntu resolute/main s390x libgnutls-dane0t64 s390x 3.8.10-3ubuntu1 [24.6 kB] 104s Get:43 http://ftpmaster.internal/ubuntu resolute/main s390x libgnutls-openssl27t64 s390x 3.8.10-3ubuntu1 [24.7 kB] 104s Get:44 http://ftpmaster.internal/ubuntu resolute/main s390x libp11-kit-dev s390x 0.25.10-1 [29.3 kB] 104s Get:45 http://ftpmaster.internal/ubuntu resolute/main s390x libtasn1-6-dev s390x 4.21.0-2 [94.8 kB] 104s Get:46 http://ftpmaster.internal/ubuntu resolute/main s390x nettle-dev s390x 3.10.2-1 [1196 kB] 104s Get:47 http://ftpmaster.internal/ubuntu resolute/main s390x libgnutls28-dev s390x 3.8.10-3ubuntu1 [1026 kB] 104s Get:48 http://ftpmaster.internal/ubuntu resolute/main s390x zlib1g-dev s390x 1:1.3.dfsg+really1.3.1-1ubuntu2 [897 kB] 104s Get:49 http://ftpmaster.internal/ubuntu resolute/main s390x librtmp-dev s390x 2.4+20151223.gitfa8646d.1-3 [69.2 kB] 104s Get:50 http://ftpmaster.internal/ubuntu resolute/main s390x libssl-dev s390x 3.5.3-1ubuntu2 [2601 kB] 104s Get:51 http://ftpmaster.internal/ubuntu resolute/main s390x libssh2-1-dev s390x 1.11.1-1build1 [286 kB] 104s Get:52 http://ftpmaster.internal/ubuntu resolute/main s390x libzstd-dev s390x 1.5.7+dfsg-2 [415 kB] 104s Get:53 http://ftpmaster.internal/ubuntu resolute/main s390x libcurl4-openssl-dev s390x 8.18.0-1ubuntu1 [550 kB] 104s Get:54 http://ftpmaster.internal/ubuntu resolute/universe s390x librdkafka1 s390x 2.11.1-2 [959 kB] 105s Get:55 http://ftpmaster.internal/ubuntu resolute/universe s390x librdkafka++1 s390x 2.11.1-2 [43.9 kB] 105s Get:56 http://ftpmaster.internal/ubuntu resolute/main s390x libxxhash-dev s390x 0.8.3-2build1 [83.4 kB] 105s Get:57 http://ftpmaster.internal/ubuntu resolute/main s390x liblz4-dev s390x 1.10.0-6 [112 kB] 105s Get:58 http://ftpmaster.internal/ubuntu resolute/main s390x libsasl2-dev s390x 2.1.28+dfsg1-9ubuntu1 [259 kB] 105s Get:59 http://ftpmaster.internal/ubuntu resolute/universe s390x librdkafka-dev s390x 2.11.1-2 [1159 kB] 106s Fetched 63.6 MB in 4s (17.7 MB/s) 106s Selecting previously unselected package libisl23:s390x. 106s (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 ... 87720 files and directories currently installed.) 106s Preparing to unpack .../00-libisl23_0.27-1build1_s390x.deb ... 106s Unpacking libisl23:s390x (0.27-1build1) ... 106s Selecting previously unselected package libmpc3:s390x. 106s Preparing to unpack .../01-libmpc3_1.3.1-2_s390x.deb ... 106s Unpacking libmpc3:s390x (1.3.1-2) ... 106s Selecting previously unselected package cpp-15-s390x-linux-gnu. 106s Preparing to unpack .../02-cpp-15-s390x-linux-gnu_15.2.0-11ubuntu1_s390x.deb ... 106s Unpacking cpp-15-s390x-linux-gnu (15.2.0-11ubuntu1) ... 106s Selecting previously unselected package cpp-15. 106s Preparing to unpack .../03-cpp-15_15.2.0-11ubuntu1_s390x.deb ... 106s Unpacking cpp-15 (15.2.0-11ubuntu1) ... 106s Selecting previously unselected package cpp-s390x-linux-gnu. 106s Preparing to unpack .../04-cpp-s390x-linux-gnu_4%3a15.2.0-4ubuntu1_s390x.deb ... 106s Unpacking cpp-s390x-linux-gnu (4:15.2.0-4ubuntu1) ... 106s Selecting previously unselected package cpp. 106s Preparing to unpack .../05-cpp_4%3a15.2.0-4ubuntu1_s390x.deb ... 106s Unpacking cpp (4:15.2.0-4ubuntu1) ... 107s Selecting previously unselected package libcc1-0:s390x. 107s Preparing to unpack .../06-libcc1-0_15.2.0-11ubuntu1_s390x.deb ... 107s Unpacking libcc1-0:s390x (15.2.0-11ubuntu1) ... 107s Selecting previously unselected package libgomp1:s390x. 107s Preparing to unpack .../07-libgomp1_15.2.0-11ubuntu1_s390x.deb ... 107s Unpacking libgomp1:s390x (15.2.0-11ubuntu1) ... 107s Selecting previously unselected package libitm1:s390x. 107s Preparing to unpack .../08-libitm1_15.2.0-11ubuntu1_s390x.deb ... 107s Unpacking libitm1:s390x (15.2.0-11ubuntu1) ... 107s Selecting previously unselected package libasan8:s390x. 107s Preparing to unpack .../09-libasan8_15.2.0-11ubuntu1_s390x.deb ... 107s Unpacking libasan8:s390x (15.2.0-11ubuntu1) ... 107s Selecting previously unselected package libubsan1:s390x. 107s Preparing to unpack .../10-libubsan1_15.2.0-11ubuntu1_s390x.deb ... 107s Unpacking libubsan1:s390x (15.2.0-11ubuntu1) ... 107s Selecting previously unselected package libgcc-15-dev:s390x. 107s Preparing to unpack .../11-libgcc-15-dev_15.2.0-11ubuntu1_s390x.deb ... 107s Unpacking libgcc-15-dev:s390x (15.2.0-11ubuntu1) ... 107s Selecting previously unselected package gcc-15-s390x-linux-gnu. 107s Preparing to unpack .../12-gcc-15-s390x-linux-gnu_15.2.0-11ubuntu1_s390x.deb ... 107s Unpacking gcc-15-s390x-linux-gnu (15.2.0-11ubuntu1) ... 109s Selecting previously unselected package gcc-15. 109s Preparing to unpack .../13-gcc-15_15.2.0-11ubuntu1_s390x.deb ... 109s Unpacking gcc-15 (15.2.0-11ubuntu1) ... 109s Selecting previously unselected package gcc-s390x-linux-gnu. 110s Preparing to unpack .../14-gcc-s390x-linux-gnu_4%3a15.2.0-4ubuntu1_s390x.deb ... 110s Unpacking gcc-s390x-linux-gnu (4:15.2.0-4ubuntu1) ... 110s Selecting previously unselected package gcc. 110s Preparing to unpack .../15-gcc_4%3a15.2.0-4ubuntu1_s390x.deb ... 110s Unpacking gcc (4:15.2.0-4ubuntu1) ... 110s Selecting previously unselected package libstdc++-15-dev:s390x. 110s Preparing to unpack .../16-libstdc++-15-dev_15.2.0-11ubuntu1_s390x.deb ... 110s Unpacking libstdc++-15-dev:s390x (15.2.0-11ubuntu1) ... 111s Selecting previously unselected package g++-15-s390x-linux-gnu. 111s Preparing to unpack .../17-g++-15-s390x-linux-gnu_15.2.0-11ubuntu1_s390x.deb ... 111s Unpacking g++-15-s390x-linux-gnu (15.2.0-11ubuntu1) ... 112s Selecting previously unselected package g++-15. 112s Preparing to unpack .../18-g++-15_15.2.0-11ubuntu1_s390x.deb ... 112s Unpacking g++-15 (15.2.0-11ubuntu1) ... 112s Selecting previously unselected package g++-s390x-linux-gnu. 112s Preparing to unpack .../19-g++-s390x-linux-gnu_4%3a15.2.0-4ubuntu1_s390x.deb ... 112s Unpacking g++-s390x-linux-gnu (4:15.2.0-4ubuntu1) ... 112s Selecting previously unselected package g++. 112s Preparing to unpack .../20-g++_4%3a15.2.0-4ubuntu1_s390x.deb ... 112s Unpacking g++ (4:15.2.0-4ubuntu1) ... 112s Selecting previously unselected package build-essential. 112s Preparing to unpack .../21-build-essential_12.12ubuntu2_s390x.deb ... 112s Unpacking build-essential (12.12ubuntu2) ... 112s Selecting previously unselected package comerr-dev:s390x. 112s Preparing to unpack .../22-comerr-dev_2.1-1.47.2-3ubuntu2_s390x.deb ... 112s Unpacking comerr-dev:s390x (2.1-1.47.2-3ubuntu2) ... 113s Selecting previously unselected package libgssrpc4t64:s390x. 113s Preparing to unpack .../23-libgssrpc4t64_1.22.1-2_s390x.deb ... 113s Unpacking libgssrpc4t64:s390x (1.22.1-2) ... 113s Selecting previously unselected package libkadm5clnt-mit12:s390x. 113s Preparing to unpack .../24-libkadm5clnt-mit12_1.22.1-2_s390x.deb ... 113s Unpacking libkadm5clnt-mit12:s390x (1.22.1-2) ... 113s Selecting previously unselected package libkdb5-10t64:s390x. 113s Preparing to unpack .../25-libkdb5-10t64_1.22.1-2_s390x.deb ... 113s Unpacking libkdb5-10t64:s390x (1.22.1-2) ... 113s Selecting previously unselected package libkadm5srv-mit12:s390x. 113s Preparing to unpack .../26-libkadm5srv-mit12_1.22.1-2_s390x.deb ... 113s Unpacking libkadm5srv-mit12:s390x (1.22.1-2) ... 113s Selecting previously unselected package krb5-multidev:s390x. 113s Preparing to unpack .../27-krb5-multidev_1.22.1-2_s390x.deb ... 113s Unpacking krb5-multidev:s390x (1.22.1-2) ... 113s Selecting previously unselected package libbrotli-dev:s390x. 113s Preparing to unpack .../28-libbrotli-dev_1.1.0-2build6_s390x.deb ... 113s Unpacking libbrotli-dev:s390x (1.1.0-2build6) ... 113s Selecting previously unselected package libidn2-dev:s390x. 113s Preparing to unpack .../29-libidn2-dev_2.3.8-4_s390x.deb ... 113s Unpacking libidn2-dev:s390x (2.3.8-4) ... 113s Selecting previously unselected package libkrb5-dev:s390x. 113s Preparing to unpack .../30-libkrb5-dev_1.22.1-2_s390x.deb ... 113s Unpacking libkrb5-dev:s390x (1.22.1-2) ... 113s Selecting previously unselected package libldap-dev:s390x. 113s Preparing to unpack .../31-libldap-dev_2.6.10+dfsg-1ubuntu5_s390x.deb ... 113s Unpacking libldap-dev:s390x (2.6.10+dfsg-1ubuntu5) ... 113s Selecting previously unselected package libpkgconf7:s390x. 113s Preparing to unpack .../32-libpkgconf7_2.5.1-2_s390x.deb ... 113s Unpacking libpkgconf7:s390x (2.5.1-2) ... 113s Selecting previously unselected package pkgconf-bin. 113s Preparing to unpack .../33-pkgconf-bin_2.5.1-2_s390x.deb ... 113s Unpacking pkgconf-bin (2.5.1-2) ... 113s Selecting previously unselected package pkgconf:s390x. 113s Preparing to unpack .../34-pkgconf_2.5.1-2_s390x.deb ... 113s Unpacking pkgconf:s390x (2.5.1-2) ... 113s Selecting previously unselected package libnghttp2-dev:s390x. 113s Preparing to unpack .../35-libnghttp2-dev_1.64.0-1.1ubuntu1_s390x.deb ... 113s Unpacking libnghttp2-dev:s390x (1.64.0-1.1ubuntu1) ... 114s Selecting previously unselected package libpsl-dev:s390x. 114s Preparing to unpack .../36-libpsl-dev_0.21.2-1.1build2_s390x.deb ... 114s Unpacking libpsl-dev:s390x (0.21.2-1.1build2) ... 114s Selecting previously unselected package libgmpxx4ldbl:s390x. 114s Preparing to unpack .../37-libgmpxx4ldbl_2%3a6.3.0+dfsg-5ubuntu1_s390x.deb ... 114s Unpacking libgmpxx4ldbl:s390x (2:6.3.0+dfsg-5ubuntu1) ... 114s Selecting previously unselected package libgmp-dev:s390x. 114s Preparing to unpack .../38-libgmp-dev_2%3a6.3.0+dfsg-5ubuntu1_s390x.deb ... 114s Unpacking libgmp-dev:s390x (2:6.3.0+dfsg-5ubuntu1) ... 114s Selecting previously unselected package libevent-2.1-7t64:s390x. 114s Preparing to unpack .../39-libevent-2.1-7t64_2.1.12-stable-10build1_s390x.deb ... 114s Unpacking libevent-2.1-7t64:s390x (2.1.12-stable-10build1) ... 114s Selecting previously unselected package libunbound8:s390x. 114s Preparing to unpack .../40-libunbound8_1.24.2-1ubuntu1_s390x.deb ... 114s Unpacking libunbound8:s390x (1.24.2-1ubuntu1) ... 114s Selecting previously unselected package libgnutls-dane0t64:s390x. 114s Preparing to unpack .../41-libgnutls-dane0t64_3.8.10-3ubuntu1_s390x.deb ... 114s Unpacking libgnutls-dane0t64:s390x (3.8.10-3ubuntu1) ... 114s Selecting previously unselected package libgnutls-openssl27t64:s390x. 114s Preparing to unpack .../42-libgnutls-openssl27t64_3.8.10-3ubuntu1_s390x.deb ... 114s Unpacking libgnutls-openssl27t64:s390x (3.8.10-3ubuntu1) ... 114s Selecting previously unselected package libp11-kit-dev:s390x. 114s Preparing to unpack .../43-libp11-kit-dev_0.25.10-1_s390x.deb ... 114s Unpacking libp11-kit-dev:s390x (0.25.10-1) ... 114s Selecting previously unselected package libtasn1-6-dev:s390x. 114s Preparing to unpack .../44-libtasn1-6-dev_4.21.0-2_s390x.deb ... 114s Unpacking libtasn1-6-dev:s390x (4.21.0-2) ... 114s Selecting previously unselected package nettle-dev:s390x. 114s Preparing to unpack .../45-nettle-dev_3.10.2-1_s390x.deb ... 114s Unpacking nettle-dev:s390x (3.10.2-1) ... 114s Selecting previously unselected package libgnutls28-dev:s390x. 114s Preparing to unpack .../46-libgnutls28-dev_3.8.10-3ubuntu1_s390x.deb ... 114s Unpacking libgnutls28-dev:s390x (3.8.10-3ubuntu1) ... 114s Selecting previously unselected package zlib1g-dev:s390x. 114s Preparing to unpack .../47-zlib1g-dev_1%3a1.3.dfsg+really1.3.1-1ubuntu2_s390x.deb ... 114s Unpacking zlib1g-dev:s390x (1:1.3.dfsg+really1.3.1-1ubuntu2) ... 114s Selecting previously unselected package librtmp-dev:s390x. 114s Preparing to unpack .../48-librtmp-dev_2.4+20151223.gitfa8646d.1-3_s390x.deb ... 114s Unpacking librtmp-dev:s390x (2.4+20151223.gitfa8646d.1-3) ... 114s Selecting previously unselected package libssl-dev:s390x. 114s Preparing to unpack .../49-libssl-dev_3.5.3-1ubuntu2_s390x.deb ... 114s Unpacking libssl-dev:s390x (3.5.3-1ubuntu2) ... 114s Selecting previously unselected package libssh2-1-dev:s390x. 114s Preparing to unpack .../50-libssh2-1-dev_1.11.1-1build1_s390x.deb ... 114s Unpacking libssh2-1-dev:s390x (1.11.1-1build1) ... 114s Selecting previously unselected package libzstd-dev:s390x. 114s Preparing to unpack .../51-libzstd-dev_1.5.7+dfsg-2_s390x.deb ... 115s Unpacking libzstd-dev:s390x (1.5.7+dfsg-2) ... 115s Selecting previously unselected package libcurl4-openssl-dev:s390x. 115s Preparing to unpack .../52-libcurl4-openssl-dev_8.18.0-1ubuntu1_s390x.deb ... 115s Unpacking libcurl4-openssl-dev:s390x (8.18.0-1ubuntu1) ... 115s Selecting previously unselected package librdkafka1:s390x. 115s Preparing to unpack .../53-librdkafka1_2.11.1-2_s390x.deb ... 115s Unpacking librdkafka1:s390x (2.11.1-2) ... 115s Selecting previously unselected package librdkafka++1:s390x. 115s Preparing to unpack .../54-librdkafka++1_2.11.1-2_s390x.deb ... 115s Unpacking librdkafka++1:s390x (2.11.1-2) ... 115s Selecting previously unselected package libxxhash-dev:s390x. 115s Preparing to unpack .../55-libxxhash-dev_0.8.3-2build1_s390x.deb ... 115s Unpacking libxxhash-dev:s390x (0.8.3-2build1) ... 115s Selecting previously unselected package liblz4-dev:s390x. 115s Preparing to unpack .../56-liblz4-dev_1.10.0-6_s390x.deb ... 115s Unpacking liblz4-dev:s390x (1.10.0-6) ... 115s Selecting previously unselected package libsasl2-dev. 115s Preparing to unpack .../57-libsasl2-dev_2.1.28+dfsg1-9ubuntu1_s390x.deb ... 115s Unpacking libsasl2-dev (2.1.28+dfsg1-9ubuntu1) ... 115s Selecting previously unselected package librdkafka-dev:s390x. 115s Preparing to unpack .../58-librdkafka-dev_2.11.1-2_s390x.deb ... 115s Unpacking librdkafka-dev:s390x (2.11.1-2) ... 115s Setting up libgnutls-openssl27t64:s390x (3.8.10-3ubuntu1) ... 115s Setting up libzstd-dev:s390x (1.5.7+dfsg-2) ... 115s Setting up libpkgconf7:s390x (2.5.1-2) ... 115s Setting up libevent-2.1-7t64:s390x (2.1.12-stable-10build1) ... 115s Setting up libgomp1:s390x (15.2.0-11ubuntu1) ... 115s Setting up libpsl-dev:s390x (0.21.2-1.1build2) ... 115s Setting up libunbound8:s390x (1.24.2-1ubuntu1) ... 115s Setting up libgmpxx4ldbl:s390x (2:6.3.0+dfsg-5ubuntu1) ... 115s Setting up libgnutls-dane0t64:s390x (3.8.10-3ubuntu1) ... 115s Setting up libgssrpc4t64:s390x (1.22.1-2) ... 115s Setting up libldap-dev:s390x (2.6.10+dfsg-1ubuntu5) ... 115s Setting up comerr-dev:s390x (2.1-1.47.2-3ubuntu2) ... 115s Setting up libssl-dev:s390x (3.5.3-1ubuntu2) ... 115s Setting up libmpc3:s390x (1.3.1-2) ... 115s Setting up pkgconf-bin (2.5.1-2) ... 115s Setting up libidn2-dev:s390x (2.3.8-4) ... 115s Setting up librdkafka1:s390x (2.11.1-2) ... 115s Setting up libxxhash-dev:s390x (0.8.3-2build1) ... 115s Setting up libubsan1:s390x (15.2.0-11ubuntu1) ... 115s Setting up zlib1g-dev:s390x (1:1.3.dfsg+really1.3.1-1ubuntu2) ... 115s Setting up libasan8:s390x (15.2.0-11ubuntu1) ... 115s Setting up libisl23:s390x (0.27-1build1) ... 115s Setting up libtasn1-6-dev:s390x (4.21.0-2) ... 115s Setting up libcc1-0:s390x (15.2.0-11ubuntu1) ... 115s Setting up libbrotli-dev:s390x (1.1.0-2build6) ... 115s Setting up libp11-kit-dev:s390x (0.25.10-1) ... 115s Setting up libitm1:s390x (15.2.0-11ubuntu1) ... 115s Setting up libkadm5clnt-mit12:s390x (1.22.1-2) ... 115s Setting up libgcc-15-dev:s390x (15.2.0-11ubuntu1) ... 115s Setting up libgmp-dev:s390x (2:6.3.0+dfsg-5ubuntu1) ... 115s Setting up nettle-dev:s390x (3.10.2-1) ... 115s Setting up libkdb5-10t64:s390x (1.22.1-2) ... 115s Setting up librdkafka++1:s390x (2.11.1-2) ... 115s Setting up pkgconf:s390x (2.5.1-2) ... 115s Setting up libsasl2-dev (2.1.28+dfsg1-9ubuntu1) ... 115s Setting up libstdc++-15-dev:s390x (15.2.0-11ubuntu1) ... 115s Setting up liblz4-dev:s390x (1.10.0-6) ... 115s Setting up libssh2-1-dev:s390x (1.11.1-1build1) ... 115s Setting up cpp-15-s390x-linux-gnu (15.2.0-11ubuntu1) ... 115s Setting up libkadm5srv-mit12:s390x (1.22.1-2) ... 115s Setting up gcc-15-s390x-linux-gnu (15.2.0-11ubuntu1) ... 115s Setting up krb5-multidev:s390x (1.22.1-2) ... 115s Setting up g++-15-s390x-linux-gnu (15.2.0-11ubuntu1) ... 115s Setting up libgnutls28-dev:s390x (3.8.10-3ubuntu1) ... 115s Setting up libnghttp2-dev:s390x (1.64.0-1.1ubuntu1) ... 115s Setting up cpp-s390x-linux-gnu (4:15.2.0-4ubuntu1) ... 115s Setting up libkrb5-dev:s390x (1.22.1-2) ... 115s Setting up gcc-s390x-linux-gnu (4:15.2.0-4ubuntu1) ... 115s Setting up librtmp-dev:s390x (2.4+20151223.gitfa8646d.1-3) ... 115s Setting up cpp-15 (15.2.0-11ubuntu1) ... 115s Setting up cpp (4:15.2.0-4ubuntu1) ... 115s Setting up g++-s390x-linux-gnu (4:15.2.0-4ubuntu1) ... 115s Setting up gcc-15 (15.2.0-11ubuntu1) ... 115s Setting up libcurl4-openssl-dev:s390x (8.18.0-1ubuntu1) ... 115s Setting up librdkafka-dev:s390x (2.11.1-2) ... 115s Setting up g++-15 (15.2.0-11ubuntu1) ... 115s Setting up gcc (4:15.2.0-4ubuntu1) ... 115s Setting up g++ (4:15.2.0-4ubuntu1) ... 115s update-alternatives: using /usr/bin/g++ to provide /usr/bin/c++ (c++) in auto mode 115s Setting up build-essential (12.12ubuntu2) ... 115s Processing triggers for libc-bin (2.42-2ubuntu4) ... 115s Processing triggers for man-db (2.13.1-1) ... 119s Processing triggers for install-info (7.2-5) ... 120s autopkgtest [12:40:44]: test examples: [----------------------- 121s Info pkgconf (rdkafka): -I/usr/include/s390x-linux-gnu -isystem /usr/include/mit-krb5 -isystem /usr/include/mit-krb5 -I/usr/include/p11-kit-1 -lrdkafka 121s Info pkgconf (rdkafka++): -I/usr/include/s390x-linux-gnu -isystem /usr/include/mit-krb5 -isystem /usr/include/mit-krb5 -I/usr/include/p11-kit-1 -lrdkafka++ 121s Build consumer.c 122s Build producer.c 122s Build rdkafka_example.c 123s Build rdkafka_complex_consumer_example.cpp 125s Build rdkafka_example.cpp 128s Run consumer.c.out 128s Run producer.c.out 128s Run rdkafka_complex_consumer_example.cpp.out 128s Run rdkafka_example.c.out 128s Run rdkafka_example.cpp.out 128s All OK 129s autopkgtest [12:40:53]: test examples: -----------------------] 129s autopkgtest [12:40:53]: test examples: - - - - - - - - - - results - - - - - - - - - - 129s examples PASS 130s autopkgtest [12:40:54]: test unittest: preparing testbed 130s Reading package lists... 131s Building dependency tree... 131s Reading state information... 131s Solving dependencies... 131s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 133s autopkgtest [12:40:57]: test unittest: [----------------------- 133s RDUT: INFO: rdunittest.c:492: rd_unittest: Unittests running on CI 133s RDUT: INFO: rdunittest.c:503: rd_unittest: Unittests will not error out on slow CPUs 133s RDUT: INFO: rdunittest.c:160: ut_tq_test: Testing TAILQ: empty tqh[0] 133s RDUT: INFO: rdunittest.c:160: ut_tq_test: Testing TAILQ: prepend 1,0 133s RDUT: INFO: rdunittest.c:160: ut_tq_test: Testing TAILQ: prepend 2,1,0 133s RDUT: INFO: rdunittest.c:160: ut_tq_test: Testing TAILQ: insert 1 133s RDUT: INFO: rdunittest.c:160: ut_tq_test: Testing TAILQ: insert 1,2 133s RDUT: INFO: rdunittest.c:160: ut_tq_test: Testing TAILQ: append 1 133s RDUT: INFO: rdunittest.c:160: ut_tq_test: Testing TAILQ: append 1,2 133s RDUT: INFO: rdunittest.c:160: ut_tq_test: Testing TAILQ: insert 1,0,2 133s RDUT: INFO: rdunittest.c:160: ut_tq_test: Testing TAILQ: insert 2,0,1 133s RDUT: PASS: rdunittest.c:347: unittest_sysqueue 133s RDUT: INFO: rdunittest.c:521: rd_unittest: unittest: sysqueue: PASS 133s RDUT: INFO: rdstring.c:409: ut_strcasestr: BEGIN:  133s RDUT: PASS: rdstring.c:425: ut_strcasestr 133s RDUT: INFO: rdstring.c:606: ut_string_split: BEGIN:  133s RDUT: PASS: rdstring.c:632: ut_string_split 133s RDUT: INFO: rdunittest.c:521: rd_unittest: unittest: string: PASS 134s RDUT: INFO: rdmap.c:478: unittest_untyped_map: 500000 map_get iterations took 1185.065ms = 2us/get 134s RDUT: INFO: rdmap.c:495: unittest_untyped_map: Total time over 100000 entries took 1369.986ms 134s RDUT: PASS: rdmap.c:498: unittest_untyped_map 134s RDUT: INFO: rdmap.c:321: unittest_typed_map: enumerated key 2 person Hedvig Lindahl 134s RDUT: INFO: rdmap.c:321: unittest_typed_map: enumerated key 1 person Roy McPhearsome 134s RDUT: PASS: rdmap.c:339: unittest_typed_map 134s RDUT: INFO: rdunittest.c:521: rd_unittest: unittest: map: PASS 134s RDUT: PASS: rdbuf.c:1357: do_unittest_write_read 134s RDUT: PASS: rdbuf.c:1522: do_unittest_write_split_seek 134s RDUT: PASS: rdbuf.c:1612: do_unittest_write_read_payload_correctness 134s RDUT: PASS: rdbuf.c:1680: do_unittest_write_iov 134s RDUT: PASS: rdbuf.c:1870: do_unittest_erase 134s RDUT: INFO: rdunittest.c:521: rd_unittest: unittest: rdbuf: PASS 134s RDUT: PASS: rdvarint.c:107: do_test_rd_uvarint_enc_i64 134s RDUT: PASS: rdvarint.c:107: do_test_rd_uvarint_enc_i64 134s RDUT: PASS: rdvarint.c:107: do_test_rd_uvarint_enc_i64 134s RDUT: PASS: rdvarint.c:107: do_test_rd_uvarint_enc_i64 134s RDUT: PASS: rdvarint.c:107: do_test_rd_uvarint_enc_i64 134s RDUT: PASS: rdvarint.c:107: do_test_rd_uvarint_enc_i64 134s RDUT: PASS: rdvarint.c:107: do_test_rd_uvarint_enc_i64 134s RDUT: PASS: rdvarint.c:107: do_test_rd_uvarint_enc_i64 134s RDUT: INFO: rdunittest.c:521: rd_unittest: unittest: rdvarint: PASS 134s RDUT: INFO: crc32c.c:411: unittest_rd_crc32c: Calculate CRC32C using software 134s RDUT: INFO: crc32c.c:422: unittest_rd_crc32c: Calculate CRC32C using software 134s RDUT: PASS: crc32c.c:429: unittest_rd_crc32c 134s RDUT: INFO: rdunittest.c:521: rd_unittest: unittest: crc32c: PASS 134s RDUT: INFO: rdkafka_msg.c:2054: unittest_msgq_order: FIFO: testing in FIFO mode 134s RDUT: PASS: rdkafka_msg.c:2249: unittest_msg_seq_wrap 134s RDUT: INFO: rdkafka_msg.c:2294: unittest_msgq_insert_all_sort: Testing msgq insert (all) efficiency: get baseline insert time 134s RDUT: INFO: rdkafka_msg.c:2327: unittest_msgq_insert_all_sort: Begin insert of 2 messages into destq with 2 messages 134s RDUT: INFO: rdkafka_msg.c:2335: unittest_msgq_insert_all_sort: Done: took 0us, 0.0000us/msg 134s RDUT: PASS: rdkafka_msg.c:2366: unittest_msgq_insert_all_sort 134s RDUT: INFO: rdkafka_msg.c:2390: unittest_msgq_insert_each_sort: Testing msgq insert (each) efficiency: get baseline insert time 134s RDUT: INFO: rdkafka_msg.c:2427: unittest_msgq_insert_each_sort: Begin insert of 1 messages into destq with 2 messages 134s RDUT: INFO: rdkafka_msg.c:2438: unittest_msgq_insert_each_sort: Done: took 0us, 0.0000us/msg 134s RDUT: INFO: rdkafka_msg.c:2427: unittest_msgq_insert_each_sort: Begin insert of 1 messages into destq with 3 messages 134s RDUT: INFO: rdkafka_msg.c:2438: unittest_msgq_insert_each_sort: Done: took 0us, 0.0000us/msg 134s RDUT: INFO: rdkafka_msg.c:2463: unittest_msgq_insert_each_sort: Total: 0.0000us/msg over 2 messages in 0us 134s RDUT: PASS: rdkafka_msg.c:2479: unittest_msgq_insert_each_sort 134s RDUT: INFO: rdkafka_msg.c:2294: unittest_msgq_insert_all_sort: Testing msgq insert (all) efficiency: single-message ranges 134s RDUT: INFO: rdkafka_msg.c:2327: unittest_msgq_insert_all_sort: Begin insert of 4 messages into destq with 5 messages 134s RDUT: INFO: rdkafka_msg.c:2335: unittest_msgq_insert_all_sort: Done: took 1us, 0.1111us/msg 134s RDUT: PASS: rdkafka_msg.c:2366: unittest_msgq_insert_all_sort 134s RDUT: INFO: rdkafka_msg.c:2390: unittest_msgq_insert_each_sort: Testing msgq insert (each) efficiency: single-message ranges 134s RDUT: INFO: rdkafka_msg.c:2427: unittest_msgq_insert_each_sort: Begin insert of 1 messages into destq with 5 messages 134s RDUT: INFO: rdkafka_msg.c:2438: unittest_msgq_insert_each_sort: Done: took 0us, 0.0000us/msg 134s RDUT: INFO: rdkafka_msg.c:2427: unittest_msgq_insert_each_sort: Begin insert of 1 messages into destq with 6 messages 134s RDUT: INFO: rdkafka_msg.c:2438: unittest_msgq_insert_each_sort: Done: took 0us, 0.0000us/msg 134s RDUT: INFO: rdkafka_msg.c:2427: unittest_msgq_insert_each_sort: Begin insert of 1 messages into destq with 7 messages 134s RDUT: INFO: rdkafka_msg.c:2438: unittest_msgq_insert_each_sort: Done: took 0us, 0.0000us/msg 134s RDUT: INFO: rdkafka_msg.c:2427: unittest_msgq_insert_each_sort: Begin insert of 1 messages into destq with 8 messages 134s RDUT: INFO: rdkafka_msg.c:2438: unittest_msgq_insert_each_sort: Done: took 0us, 0.0000us/msg 134s RDUT: INFO: rdkafka_msg.c:2463: unittest_msgq_insert_each_sort: Total: 0.0000us/msg over 4 messages in 0us 134s RDUT: PASS: rdkafka_msg.c:2479: unittest_msgq_insert_each_sort 134s RDUT: INFO: rdkafka_msg.c:2294: unittest_msgq_insert_all_sort: Testing msgq insert (all) efficiency: many messages 137s RDUT: INFO: rdkafka_msg.c:2327: unittest_msgq_insert_all_sort: Begin insert of 4315956 messages into destq with 165288 messages 137s RDUT: INFO: rdkafka_msg.c:2335: unittest_msgq_insert_all_sort: Done: took 42459us, 0.0095us/msg 139s RDUT: PASS: rdkafka_msg.c:2366: unittest_msgq_insert_all_sort 139s RDUT: INFO: rdkafka_msg.c:2390: unittest_msgq_insert_each_sort: Testing msgq insert (each) efficiency: many messages 139s RDUT: INFO: rdkafka_msg.c:2427: unittest_msgq_insert_each_sort: Begin insert of 100001 messages into destq with 165288 messages 139s RDUT: INFO: rdkafka_msg.c:2438: unittest_msgq_insert_each_sort: Done: took 10us, 0.0001us/msg 139s RDUT: INFO: rdkafka_msg.c:2427: unittest_msgq_insert_each_sort: Begin insert of 50001 messages into destq with 265289 messages 139s RDUT: INFO: rdkafka_msg.c:2438: unittest_msgq_insert_each_sort: Done: took 7647us, 0.1529us/msg 139s RDUT: INFO: rdkafka_msg.c:2427: unittest_msgq_insert_each_sort: Begin insert of 20001 messages into destq with 315290 messages 139s RDUT: INFO: rdkafka_msg.c:2438: unittest_msgq_insert_each_sort: Done: took 5560us, 0.2780us/msg 139s RDUT: INFO: rdkafka_msg.c:2427: unittest_msgq_insert_each_sort: Begin insert of 59129 messages into destq with 335291 messages 139s RDUT: INFO: rdkafka_msg.c:2438: unittest_msgq_insert_each_sort: Done: took 2482us, 0.0420us/msg 139s RDUT: INFO: rdkafka_msg.c:2427: unittest_msgq_insert_each_sort: Begin insert of 86823 messages into destq with 394420 messages 139s RDUT: INFO: rdkafka_msg.c:2438: unittest_msgq_insert_each_sort: Done: took 8953us, 0.1031us/msg 140s RDUT: INFO: rdkafka_msg.c:2427: unittest_msgq_insert_each_sort: Begin insert of 4000001 messages into destq with 481243 messages 141s RDUT: INFO: rdkafka_msg.c:2438: unittest_msgq_insert_each_sort: Done: took 96552us, 0.0241us/msg 143s RDUT: INFO: rdkafka_msg.c:2463: unittest_msgq_insert_each_sort: Total: 0.0281us/msg over 4315956 messages in 121204us 143s RDUT: PASS: rdkafka_msg.c:2479: unittest_msgq_insert_each_sort 143s RDUT: INFO: rdkafka_msg.c:2294: unittest_msgq_insert_all_sort: Testing msgq insert (all) efficiency: issue #2508 143s RDUT: INFO: rdkafka_msg.c:2327: unittest_msgq_insert_all_sort: Begin insert of 145952 messages into destq with 154875 messages 143s RDUT: INFO: rdkafka_msg.c:2335: unittest_msgq_insert_all_sort: Done: took 9154us, 0.0304us/msg 143s RDUT: PASS: rdkafka_msg.c:2366: unittest_msgq_insert_all_sort 143s RDUT: INFO: rdkafka_msg.c:2390: unittest_msgq_insert_each_sort: Testing msgq insert (each) efficiency: issue #2508 143s RDUT: INFO: rdkafka_msg.c:2427: unittest_msgq_insert_each_sort: Begin insert of 59129 messages into destq with 154875 messages 143s RDUT: INFO: rdkafka_msg.c:2438: unittest_msgq_insert_each_sort: Done: took 1us, 0.0000us/msg 143s RDUT: INFO: rdkafka_msg.c:2427: unittest_msgq_insert_each_sort: Begin insert of 86823 messages into destq with 214004 messages 143s RDUT: INFO: rdkafka_msg.c:2438: unittest_msgq_insert_each_sort: Done: took 1us, 0.0000us/msg 143s RDUT: INFO: rdkafka_msg.c:2463: unittest_msgq_insert_each_sort: Total: 0.0000us/msg over 145952 messages in 2us 143s RDUT: PASS: rdkafka_msg.c:2479: unittest_msgq_insert_each_sort 143s RDUT: INFO: rdkafka_msg.c:2294: unittest_msgq_insert_all_sort: Testing msgq insert (all) efficiency: issue #2450 (v1.2.1 regression) 143s RDUT: INFO: rdkafka_msg.c:2327: unittest_msgq_insert_all_sort: Begin insert of 86 messages into destq with 199999 messages 143s RDUT: INFO: rdkafka_msg.c:2335: unittest_msgq_insert_all_sort: Done: took 1us, 0.0000us/msg 143s RDUT: PASS: rdkafka_msg.c:2366: unittest_msgq_insert_all_sort 143s RDUT: INFO: rdkafka_msg.c:2390: unittest_msgq_insert_each_sort: Testing msgq insert (each) efficiency: issue #2450 (v1.2.1 regression) 143s RDUT: INFO: rdkafka_msg.c:2427: unittest_msgq_insert_each_sort: Begin insert of 2 messages into destq with 199999 messages 143s RDUT: INFO: rdkafka_msg.c:2438: unittest_msgq_insert_each_sort: Done: took 0us, 0.0000us/msg 143s RDUT: INFO: rdkafka_msg.c:2427: unittest_msgq_insert_each_sort: Begin insert of 5 messages into destq with 200001 messages 143s RDUT: INFO: rdkafka_msg.c:2438: unittest_msgq_insert_each_sort: Done: took 0us, 0.0000us/msg 144s RDUT: INFO: rdkafka_msg.c:2427: unittest_msgq_insert_each_sort: Begin insert of 4 messages into destq with 200006 messages 144s RDUT: INFO: rdkafka_msg.c:2438: unittest_msgq_insert_each_sort: Done: took 1us, 0.2500us/msg 144s RDUT: INFO: rdkafka_msg.c:2427: unittest_msgq_insert_each_sort: Begin insert of 2 messages into destq with 200010 messages 144s RDUT: INFO: rdkafka_msg.c:2438: unittest_msgq_insert_each_sort: Done: took 0us, 0.0000us/msg 144s RDUT: INFO: rdkafka_msg.c:2427: unittest_msgq_insert_each_sort: Begin insert of 3 messages into destq with 200012 messages 144s RDUT: INFO: rdkafka_msg.c:2438: unittest_msgq_insert_each_sort: Done: took 1us, 0.3333us/msg 144s RDUT: INFO: rdkafka_msg.c:2427: unittest_msgq_insert_each_sort: Begin insert of 61 messages into destq with 200015 messages 144s RDUT: INFO: rdkafka_msg.c:2438: unittest_msgq_insert_each_sort: Done: took 0us, 0.0000us/msg 144s RDUT: INFO: rdkafka_msg.c:2427: unittest_msgq_insert_each_sort: Begin insert of 2 messages into destq with 200076 messages 144s RDUT: INFO: rdkafka_msg.c:2438: unittest_msgq_insert_each_sort: Done: took 0us, 0.0000us/msg 144s RDUT: INFO: rdkafka_msg.c:2427: unittest_msgq_insert_each_sort: Begin insert of 2 messages into destq with 200078 messages 144s RDUT: INFO: rdkafka_msg.c:2438: unittest_msgq_insert_each_sort: Done: took 0us, 0.0000us/msg 144s RDUT: INFO: rdkafka_msg.c:2427: unittest_msgq_insert_each_sort: Begin insert of 2 messages into destq with 200080 messages 144s RDUT: INFO: rdkafka_msg.c:2438: unittest_msgq_insert_each_sort: Done: took 0us, 0.0000us/msg 144s RDUT: INFO: rdkafka_msg.c:2427: unittest_msgq_insert_each_sort: Begin insert of 3 messages into destq with 200082 messages 144s RDUT: INFO: rdkafka_msg.c:2438: unittest_msgq_insert_each_sort: Done: took 0us, 0.0000us/msg 144s RDUT: INFO: rdkafka_msg.c:2463: unittest_msgq_insert_each_sort: Total: 0.0233us/msg over 86 messages in 2us 144s RDUT: PASS: rdkafka_msg.c:2479: unittest_msgq_insert_each_sort 144s RDUT: INFO: rdunittest.c:521: rd_unittest: unittest: msg: PASS 144s RDUT: PASS: rdmurmur2.c:166: unittest_murmur2 144s RDUT: INFO: rdunittest.c:521: rd_unittest: unittest: murmurhash: PASS 144s RDUT: PASS: rdfnv1a.c:112: unittest_fnv1a 144s RDUT: INFO: rdunittest.c:521: rd_unittest: unittest: fnv1a: PASS 144s RDUT: INFO: rdkafka_mock.c:3641: ut_cgrp_consumer_member_next_assignment: BEGIN:  144s RDUT: INFO: rdkafka_mock.c:3241: ut_cgrp_consumer_member_next_assignment1: Case 1: multiple revocations acked 144s %5|1769690602.600|CONFWARN|rdkafka#consumer-1| [thrd:app]: No `bootstrap.servers` configured: client will not be able to connect to Kafka cluster 144s RDUT: INFO: rdkafka_mock.c:3161: ut_cgrp_consumer_member_next_assignment0: test fixture 0: Target+Returned assignment 0,1,2. Epoch 0 -> 3 144s RDUT: INFO: rdkafka_mock.c:3161: ut_cgrp_consumer_member_next_assignment0: test fixture 1: Current assignment empty 144s RDUT: INFO: rdkafka_mock.c:3161: ut_cgrp_consumer_member_next_assignment0: test fixture 2: Empty heartbeat 144s RDUT: INFO: rdkafka_mock.c:3161: ut_cgrp_consumer_member_next_assignment0: test fixture 3: Current assignment 0 144s RDUT: INFO: rdkafka_mock.c:3161: ut_cgrp_consumer_member_next_assignment0: test fixture 4: Empty heartbeat 144s RDUT: INFO: rdkafka_mock.c:3161: ut_cgrp_consumer_member_next_assignment0: test fixture 5: Current assignment 0,1 144s RDUT: INFO: rdkafka_mock.c:3161: ut_cgrp_consumer_member_next_assignment0: test fixture 6: Empty heartbeat 144s RDUT: INFO: rdkafka_mock.c:3161: ut_cgrp_consumer_member_next_assignment0: test fixture 7: Current assignment 0,1,2 144s RDUT: INFO: rdkafka_mock.c:3161: ut_cgrp_consumer_member_next_assignment0: test fixture 8: Target assignment 0,1,3. Returned assignment 0,1 144s RDUT: INFO: rdkafka_mock.c:3161: ut_cgrp_consumer_member_next_assignment0: test fixture 9: Target assignment 0,3. Returned assignment 0 144s RDUT: INFO: rdkafka_mock.c:3161: ut_cgrp_consumer_member_next_assignment0: test fixture 10: Empty heartbeat 144s RDUT: INFO: rdkafka_mock.c:3161: ut_cgrp_consumer_member_next_assignment0: test fixture 11: Current assignment 0,1 144s RDUT: INFO: rdkafka_mock.c:3161: ut_cgrp_consumer_member_next_assignment0: test fixture 12: Empty heartbeat 144s RDUT: INFO: rdkafka_mock.c:3161: ut_cgrp_consumer_member_next_assignment0: test fixture 13: Current assignment 0. Returned assignment 0,3. Epoch 3 -> 5 144s RDUT: INFO: rdkafka_mock.c:3161: ut_cgrp_consumer_member_next_assignment0: test fixture 14: Empty heartbeat 144s RDUT: INFO: rdkafka_mock.c:3161: ut_cgrp_consumer_member_next_assignment0: test fixture 15: Current assignment 0,3 144s RDUT: INFO: rdkafka_mock.c:3367: ut_cgrp_consumer_member_next_assignment2: Case 2: reassignment of revoked partition, partial revocation acknowledge 144s %5|1769690602.602|CONFWARN|rdkafka#consumer-2| [thrd:app]: No `bootstrap.servers` configured: client will not be able to connect to Kafka cluster 144s RDUT: INFO: rdkafka_mock.c:3161: ut_cgrp_consumer_member_next_assignment0: test fixture 0: Target+Returned assignment 0,1,2. Epoch 0 -> 3 144s RDUT: INFO: rdkafka_mock.c:3161: ut_cgrp_consumer_member_next_assignment0: test fixture 1: Current assignment 0,1,2 144s RDUT: INFO: rdkafka_mock.c:3161: ut_cgrp_consumer_member_next_assignment0: test fixture 2: Target assignment 0,1,3. Returned assignment 0,1 144s RDUT: INFO: rdkafka_mock.c:3161: ut_cgrp_consumer_member_next_assignment0: test fixture 3: Target assignment 0,3. Returned assignment 0 144s RDUT: INFO: rdkafka_mock.c:3161: ut_cgrp_consumer_member_next_assignment0: test fixture 4: Empty heartbeat 144s RDUT: INFO: rdkafka_mock.c:3161: ut_cgrp_consumer_member_next_assignment0: test fixture 5: Current assignment 0,1 144s RDUT: INFO: rdkafka_mock.c:3161: ut_cgrp_consumer_member_next_assignment0: test fixture 6: Empty heartbeat 144s RDUT: INFO: rdkafka_mock.c:3161: ut_cgrp_consumer_member_next_assignment0: test fixture 7: Target+Returned assignment 0,1,3. Epoch 3 -> 6 144s RDUT: INFO: rdkafka_mock.c:3161: ut_cgrp_consumer_member_next_assignment0: test fixture 8: Empty heartbeat 144s RDUT: INFO: rdkafka_mock.c:3161: ut_cgrp_consumer_member_next_assignment0: test fixture 9: Current assignment 0,1,3 144s RDUT: INFO: rdkafka_mock.c:3459: ut_cgrp_consumer_member_next_assignment3: Case 3: reassignment of revoked partition and new partition, no revocation acknowledge 144s %5|1769690602.604|CONFWARN|rdkafka#consumer-3| [thrd:app]: No `bootstrap.servers` configured: client will not be able to connect to Kafka cluster 144s RDUT: INFO: rdkafka_mock.c:3161: ut_cgrp_consumer_member_next_assignment0: test fixture 0: Target+Returned assignment 0,1,2. Epoch 0 -> 3 144s RDUT: INFO: rdkafka_mock.c:3161: ut_cgrp_consumer_member_next_assignment0: test fixture 1: Current assignment 0,1,2 144s RDUT: INFO: rdkafka_mock.c:3161: ut_cgrp_consumer_member_next_assignment0: test fixture 2: Target assignment 0,1,3. Returned assignment 0,1 144s RDUT: INFO: rdkafka_mock.c:3161: ut_cgrp_consumer_member_next_assignment0: test fixture 3: Target assignment 0,3. Returned assignment 0 144s RDUT: INFO: rdkafka_mock.c:3161: ut_cgrp_consumer_member_next_assignment0: test fixture 4: Empty heartbeat 144s RDUT: INFO: rdkafka_mock.c:3161: ut_cgrp_consumer_member_next_assignment0: test fixture 5: Target+Returned assignment 0,1,2,3. Epoch 3 -> 6 144s RDUT: INFO: rdkafka_mock.c:3161: ut_cgrp_consumer_member_next_assignment0: test fixture 6: Empty heartbeat 144s RDUT: INFO: rdkafka_mock.c:3161: ut_cgrp_consumer_member_next_assignment0: test fixture 7: Current assignment 0,1,2,3 144s RDUT: INFO: rdkafka_mock.c:3537: ut_cgrp_consumer_member_next_assignment4: Case 4: reconciliation after disconnection 144s %5|1769690602.607|CONFWARN|rdkafka#consumer-4| [thrd:app]: No `bootstrap.servers` configured: client will not be able to connect to Kafka cluster 144s RDUT: INFO: rdkafka_mock.c:3161: ut_cgrp_consumer_member_next_assignment0: test fixture 0: Target+Returned assignment 0,1,2. Epoch 0 -> 3 144s RDUT: INFO: rdkafka_mock.c:3161: ut_cgrp_consumer_member_next_assignment0: test fixture 1: Current assignment empty 144s RDUT: INFO: rdkafka_mock.c:3161: ut_cgrp_consumer_member_next_assignment0: test fixture 2: Disconnected, resends current assignment. Returns assignment again 144s RDUT: INFO: rdkafka_mock.c:3161: ut_cgrp_consumer_member_next_assignment0: test fixture 3: Empty heartbeat 144s RDUT: INFO: rdkafka_mock.c:3161: ut_cgrp_consumer_member_next_assignment0: test fixture 4: Current assignment 0,1,2 144s RDUT: INFO: rdkafka_mock.c:3591: ut_cgrp_consumer_member_next_assignment5: Case 5: fenced consumer 144s %5|1769690602.608|CONFWARN|rdkafka#consumer-5| [thrd:app]: No `bootstrap.servers` configured: client will not be able to connect to Kafka cluster 144s RDUT: INFO: rdkafka_mock.c:3161: ut_cgrp_consumer_member_next_assignment0: test fixture 0: Target+Returned assignment 0,1,2. Epoch 0 -> 3 144s RDUT: INFO: rdkafka_mock.c:3161: ut_cgrp_consumer_member_next_assignment0: test fixture 1: Session times out, receives FENCED_MEMBER_EPOCH. Epoch 3 -> 0 144s RDUT: INFO: rdkafka_mock.c:3161: ut_cgrp_consumer_member_next_assignment0: test fixture 2: Target+Returned assignment 0,1,2. Epoch 0 -> 6 144s RDUT: INFO: rdkafka_mock.c:3161: ut_cgrp_consumer_member_next_assignment0: test fixture 3: Current assignment 0,1,2 144s RDUT: PASS: rdkafka_mock.c:3651: ut_cgrp_consumer_member_next_assignment 144s RDUT: INFO: rdunittest.c:521: rd_unittest: unittest: mock: PASS 144s RDUT: PASS: rdhdrhistogram.c:468: ut_high_sigfig 144s RDUT: PASS: rdhdrhistogram.c:495: ut_quantile 144s RDUT: PASS: rdhdrhistogram.c:514: ut_mean 144s RDUT: PASS: rdhdrhistogram.c:536: ut_stddev 144s RDUT: PASS: rdhdrhistogram.c:555: ut_totalcount 144s RDUT: PASS: rdhdrhistogram.c:573: ut_max 144s RDUT: PASS: rdhdrhistogram.c:590: ut_min 144s RDUT: PASS: rdhdrhistogram.c:609: ut_reset 144s RDUT: PASS: rdhdrhistogram.c:623: ut_nan 144s RDUT: PASS: rdhdrhistogram.c:638: ut_sigfigs 144s RDUT: PASS: rdhdrhistogram.c:654: ut_minmax_trackable 144s RDUT: PASS: rdhdrhistogram.c:664: ut_unitmagnitude_overflow 144s RDUT: PASS: rdhdrhistogram.c:697: ut_subbucketmask_overflow 144s RDUT: INFO: rdunittest.c:521: rd_unittest: unittest: rdhdrhistogram: PASS 144s RDUT: INFO: rdkafka_conf.c:4829: unittest_conf: Safified client.software.name="aba.-va" 144s RDUT: INFO: rdkafka_conf.c:4837: unittest_conf: Safified client.software.version="1.2.3.4.5----a" 144s RDUT: PASS: rdkafka_conf.c:4841: unittest_conf 144s RDUT: INFO: rdunittest.c:521: rd_unittest: unittest: conf: PASS 144s RDUT: PASS: rdkafka_broker.c:6265: rd_ut_reconnect_backoff 144s RDUT: PASS: rdkafka_broker.c:6312: rd_ut_ApiVersion_at_least 144s RDUT: INFO: rdunittest.c:521: rd_unittest: unittest: broker: PASS 144s RDUT: INFO: rdkafka_request.c:6762: unittest_idempotent_producer: Verifying idempotent producer error handling 144s %5|1769690602.721|CONFWARN|rdkafka#producer-6| [thrd:app]: No `bootstrap.servers` configured: client will not be able to connect to Kafka cluster 144s RDUT: INFO: rdkafka_request.c:6928: unittest_idempotent_producer: Got DeliveryReport event with 3 message(s) 144s RDUT: INFO: rdkafka_request.c:6933: unittest_idempotent_producer: DR for message: Success: (persistence=2) 144s RDUT: INFO: rdkafka_request.c:6933: unittest_idempotent_producer: DR for message: Success: (persistence=2) 144s RDUT: INFO: rdkafka_request.c:6933: unittest_idempotent_producer: DR for message: Success: (persistence=2) 144s RDUT: INFO: rdkafka_request.c:6928: unittest_idempotent_producer: Got DeliveryReport event with 3 message(s) 144s RDUT: INFO: rdkafka_request.c:6933: unittest_idempotent_producer: DR for message: Success: (persistence=2) 144s RDUT: INFO: rdkafka_request.c:6933: unittest_idempotent_producer: DR for message: Success: (persistence=2) 144s RDUT: INFO: rdkafka_request.c:6933: unittest_idempotent_producer: DR for message: Success: (persistence=2) 144s RDUT: INFO: rdkafka_request.c:6928: unittest_idempotent_producer: Got DeliveryReport event with 3 message(s) 144s RDUT: INFO: rdkafka_request.c:6933: unittest_idempotent_producer: DR for message: Success: (persistence=2) 144s RDUT: INFO: rdkafka_request.c:6933: unittest_idempotent_producer: DR for message: Success: (persistence=2) 144s RDUT: INFO: rdkafka_request.c:6933: unittest_idempotent_producer: DR for message: Success: (persistence=2) 144s RDUT: INFO: rdkafka_request.c:6928: unittest_idempotent_producer: Got DeliveryReport event with 3 message(s) 144s RDUT: INFO: rdkafka_request.c:6933: unittest_idempotent_producer: DR for message: Success: (persistence=2) 144s RDUT: INFO: rdkafka_request.c:6933: unittest_idempotent_producer: DR for message: Success: (persistence=2) 144s RDUT: INFO: rdkafka_request.c:6933: unittest_idempotent_producer: DR for message: Success: (persistence=2) 145s RDUT: PASS: rdkafka_request.c:6958: unittest_idempotent_producer 145s RDUT: INFO: rdkafka_request.c:6972: unittest_handle_GetTelemetrySubscriptions: Verifying GetTelemetrySubscriptions response handling 145s %5|1769690603.745|CONFWARN|rdkafka#consumer-7| [thrd:app]: No `bootstrap.servers` configured: client will not be able to connect to Kafka cluster 145s RDUT: INFO: rdunittest.c:521: rd_unittest: unittest: request: PASS 145s RDUT: PASS: rdkafka_sasl_oauthbearer.c:1592: do_unittest_config_no_principal_should_fail 145s RDUT: PASS: rdkafka_sasl_oauthbearer.c:1621: do_unittest_config_empty_should_fail 145s RDUT: PASS: rdkafka_sasl_oauthbearer.c:1688: do_unittest_config_empty_value_should_fail 145s RDUT: PASS: rdkafka_sasl_oauthbearer.c:1726: do_unittest_config_value_with_quote_should_fail 145s RDUT: PASS: rdkafka_sasl_oauthbearer.c:1651: do_unittest_config_unrecognized_should_fail 145s RDUT: PASS: rdkafka_sasl_oauthbearer.c:1475: do_unittest_config_defaults 145s RDUT: PASS: rdkafka_sasl_oauthbearer.c:1518: do_unittest_config_explicit_scope_and_life 145s RDUT: PASS: rdkafka_sasl_oauthbearer.c:1562: do_unittest_config_all_explicit_values 145s RDUT: PASS: rdkafka_sasl_oauthbearer.c:1765: do_unittest_config_extensions 145s RDUT: PASS: rdkafka_sasl_oauthbearer.c:1784: do_unittest_illegal_extension_keys_should_fail 145s RDUT: PASS: rdkafka_sasl_oauthbearer.c:1817: do_unittest_odd_extension_size_should_fail 145s RDUT: INFO: rdunittest.c:521: rd_unittest: unittest: sasl_oauthbearer: PASS 145s RDUT: PASS: rdkafka_msgset_reader.c:1805: unittest_aborted_txns 145s RDUT: INFO: rdunittest.c:521: rd_unittest: unittest: aborted_txns: PASS 145s RDUT: PASS: rdkafka_cgrp.c:7322: unittest_consumer_group_metadata 145s RDUT: PASS: rdkafka_cgrp.c:7393: unittest_set_intersect 145s RDUT: PASS: rdkafka_cgrp.c:7442: unittest_set_subtract 145s RDUT: PASS: rdkafka_cgrp.c:7469: unittest_map_to_list 145s RDUT: PASS: rdkafka_cgrp.c:7499: unittest_list_to_map 145s RDUT: PASS: rdkafka_cgrp.c:7568: unittest_member_metadata_serdes 145s RDUT: INFO: rdunittest.c:521: rd_unittest: unittest: cgrp: PASS 145s RDUT: PASS: rdkafka_sasl_scram.c:808: unittest_scram_nonce 145s RDUT: PASS: rdkafka_sasl_scram.c:847: unittest_scram_safe 145s RDUT: INFO: rdunittest.c:521: rd_unittest: unittest: scram: PASS 145s RDUT: INFO: rdkafka_assignor.c:1654: ut_assignors: Test case Symmetrical subscription: range assignor 145s RDUT: INFO: rdkafka_assignor.c:1654: ut_assignors: Test case Symmetrical subscription: roundrobin assignor 145s RDUT: INFO: rdkafka_assignor.c:1654: ut_assignors: Test case 1*3 partitions (asymmetrical): range assignor 145s RDUT: INFO: rdkafka_assignor.c:1654: ut_assignors: Test case 1*3 partitions (asymmetrical): roundrobin assignor 145s RDUT: INFO: rdkafka_assignor.c:1654: ut_assignors: Test case #2121 (asymmetrical): range assignor 145s RDUT: INFO: rdkafka_assignor.c:1654: ut_assignors: Test case #2121 (asymmetrical): roundrobin assignor 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #0, RackConfig = 0 ] 145s RDUT: PASS: rdkafka_range_assignor.c:645: ut_testOneConsumerNoTopic 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #0, RackConfig = 1 ] 145s RDUT: PASS: rdkafka_range_assignor.c:665: ut_testOneConsumerNoTopic 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #0, RackConfig = 2 ] 145s RDUT: PASS: rdkafka_range_assignor.c:665: ut_testOneConsumerNoTopic 145s RDUT: INFO: rdkafka_range_assignor.c:1719: rd_kafka_range_assignor_unittest: [ Test #0 ran for 0.012ms ] 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #1, RackConfig = 0 ] 145s RDUT: PASS: rdkafka_range_assignor.c:679: ut_testOneConsumerNonexistentTopic 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #1, RackConfig = 1 ] 145s RDUT: PASS: rdkafka_range_assignor.c:699: ut_testOneConsumerNonexistentTopic 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #1, RackConfig = 2 ] 145s RDUT: PASS: rdkafka_range_assignor.c:699: ut_testOneConsumerNonexistentTopic 145s RDUT: INFO: rdkafka_range_assignor.c:1719: rd_kafka_range_assignor_unittest: [ Test #1 ran for 0.010ms ] 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #2, RackConfig = 0 ] 145s RDUT: PASS: rdkafka_range_assignor.c:732: ut_testOneConsumerOneTopic 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #2, RackConfig = 1 ] 145s RDUT: PASS: rdkafka_range_assignor.c:732: ut_testOneConsumerOneTopic 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #2, RackConfig = 2 ] 145s RDUT: PASS: rdkafka_range_assignor.c:732: ut_testOneConsumerOneTopic 145s RDUT: INFO: rdkafka_range_assignor.c:1719: rd_kafka_range_assignor_unittest: [ Test #2 ran for 0.017ms ] 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #3, RackConfig = 0 ] 145s RDUT: PASS: rdkafka_range_assignor.c:762: ut_testOnlyAssignsPartitionsFromSubscribedTopics 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #3, RackConfig = 1 ] 145s RDUT: PASS: rdkafka_range_assignor.c:762: ut_testOnlyAssignsPartitionsFromSubscribedTopics 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #3, RackConfig = 2 ] 145s RDUT: PASS: rdkafka_range_assignor.c:762: ut_testOnlyAssignsPartitionsFromSubscribedTopics 145s RDUT: INFO: rdkafka_range_assignor.c:1719: rd_kafka_range_assignor_unittest: [ Test #3 ran for 0.017ms ] 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #4, RackConfig = 0 ] 145s RDUT: PASS: rdkafka_range_assignor.c:791: ut_testOneConsumerMultipleTopics 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #4, RackConfig = 1 ] 145s RDUT: PASS: rdkafka_range_assignor.c:791: ut_testOneConsumerMultipleTopics 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #4, RackConfig = 2 ] 145s RDUT: PASS: rdkafka_range_assignor.c:791: ut_testOneConsumerMultipleTopics 145s RDUT: INFO: rdkafka_range_assignor.c:1719: rd_kafka_range_assignor_unittest: [ Test #4 ran for 0.019ms ] 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #5, RackConfig = 0 ] 145s RDUT: PASS: rdkafka_range_assignor.c:824: ut_testTwoConsumersOneTopicOnePartition 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #5, RackConfig = 1 ] 145s RDUT: PASS: rdkafka_range_assignor.c:824: ut_testTwoConsumersOneTopicOnePartition 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #5, RackConfig = 2 ] 145s RDUT: PASS: rdkafka_range_assignor.c:824: ut_testTwoConsumersOneTopicOnePartition 145s RDUT: INFO: rdkafka_range_assignor.c:1719: rd_kafka_range_assignor_unittest: [ Test #5 ran for 0.014ms ] 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #6, RackConfig = 0 ] 145s RDUT: PASS: rdkafka_range_assignor.c:857: ut_testTwoConsumersOneTopicTwoPartitions 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #6, RackConfig = 1 ] 145s RDUT: PASS: rdkafka_range_assignor.c:857: ut_testTwoConsumersOneTopicTwoPartitions 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #6, RackConfig = 2 ] 145s RDUT: PASS: rdkafka_range_assignor.c:857: ut_testTwoConsumersOneTopicTwoPartitions 145s RDUT: INFO: rdkafka_range_assignor.c:1719: rd_kafka_range_assignor_unittest: [ Test #6 ran for 0.014ms ] 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #7, RackConfig = 0 ] 145s RDUT: PASS: rdkafka_range_assignor.c:894: ut_testMultipleConsumersMixedTopicSubscriptions 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #7, RackConfig = 1 ] 145s RDUT: PASS: rdkafka_range_assignor.c:894: ut_testMultipleConsumersMixedTopicSubscriptions 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #7, RackConfig = 2 ] 145s RDUT: PASS: rdkafka_range_assignor.c:894: ut_testMultipleConsumersMixedTopicSubscriptions 145s RDUT: INFO: rdkafka_range_assignor.c:1719: rd_kafka_range_assignor_unittest: [ Test #7 ran for 0.026ms ] 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #8, RackConfig = 0 ] 145s RDUT: PASS: rdkafka_range_assignor.c:927: ut_testTwoConsumersTwoTopicsSixPartitions 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #8, RackConfig = 1 ] 145s RDUT: PASS: rdkafka_range_assignor.c:927: ut_testTwoConsumersTwoTopicsSixPartitions 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #8, RackConfig = 2 ] 145s RDUT: PASS: rdkafka_range_assignor.c:927: ut_testTwoConsumersTwoTopicsSixPartitions 145s RDUT: INFO: rdkafka_range_assignor.c:1719: rd_kafka_range_assignor_unittest: [ Test #8 ran for 0.024ms ] 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #9, RackConfig = 0 ] 145s RDUT: PASS: rdkafka_range_assignor.c:1093: ut_testRackAwareAssignmentWithUniformSubscription 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #9, RackConfig = 1 ] 145s RDUT: PASS: rdkafka_range_assignor.c:1093: ut_testRackAwareAssignmentWithUniformSubscription 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #9, RackConfig = 2 ] 145s RDUT: PASS: rdkafka_range_assignor.c:1167: ut_testRackAwareAssignmentWithUniformSubscription 145s RDUT: INFO: rdkafka_range_assignor.c:1719: rd_kafka_range_assignor_unittest: [ Test #9 ran for 0.226ms ] 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #10, RackConfig = 0 ] 145s RDUT: PASS: rdkafka_range_assignor.c:1185: ut_testRackAwareAssignmentWithNonEqualSubscription 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #10, RackConfig = 1 ] 145s RDUT: PASS: rdkafka_range_assignor.c:1185: ut_testRackAwareAssignmentWithNonEqualSubscription 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #10, RackConfig = 2 ] 145s RDUT: PASS: rdkafka_range_assignor.c:1258: ut_testRackAwareAssignmentWithNonEqualSubscription 145s RDUT: INFO: rdkafka_range_assignor.c:1719: rd_kafka_range_assignor_unittest: [ Test #10 ran for 0.206ms ] 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #11, RackConfig = 0 ] 145s RDUT: PASS: rdkafka_range_assignor.c:1276: ut_testRackAwareAssignmentWithUniformPartitions 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #11, RackConfig = 1 ] 145s RDUT: PASS: rdkafka_range_assignor.c:1276: ut_testRackAwareAssignmentWithUniformPartitions 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #11, RackConfig = 2 ] 145s RDUT: PASS: rdkafka_range_assignor.c:1318: ut_testRackAwareAssignmentWithUniformPartitions 145s RDUT: INFO: rdkafka_range_assignor.c:1719: rd_kafka_range_assignor_unittest: [ Test #11 ran for 0.211ms ] 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #12, RackConfig = 0 ] 145s RDUT: PASS: rdkafka_range_assignor.c:1336: ut_testRackAwareAssignmentWithUniformPartitionsNonEqualSubscription 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #12, RackConfig = 1 ] 145s RDUT: PASS: rdkafka_range_assignor.c:1336: ut_testRackAwareAssignmentWithUniformPartitionsNonEqualSubscription 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #12, RackConfig = 2 ] 145s RDUT: PASS: rdkafka_range_assignor.c:1411: ut_testRackAwareAssignmentWithUniformPartitionsNonEqualSubscription 145s RDUT: INFO: rdkafka_range_assignor.c:1719: rd_kafka_range_assignor_unittest: [ Test #12 ran for 0.206ms ] 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #13, RackConfig = 0 ] 145s RDUT: PASS: rdkafka_range_assignor.c:1432: ut_testRackAwareAssignmentWithCoPartitioning0 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #13, RackConfig = 1 ] 145s RDUT: PASS: rdkafka_range_assignor.c:1432: ut_testRackAwareAssignmentWithCoPartitioning0 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #13, RackConfig = 2 ] 145s RDUT: PASS: rdkafka_range_assignor.c:1493: ut_testRackAwareAssignmentWithCoPartitioning0 145s RDUT: INFO: rdkafka_range_assignor.c:1719: rd_kafka_range_assignor_unittest: [ Test #13 ran for 0.078ms ] 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #14, RackConfig = 0 ] 145s RDUT: PASS: rdkafka_range_assignor.c:1511: ut_testRackAwareAssignmentWithCoPartitioning1 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #14, RackConfig = 1 ] 145s RDUT: PASS: rdkafka_range_assignor.c:1511: ut_testRackAwareAssignmentWithCoPartitioning1 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #14, RackConfig = 2 ] 145s RDUT: PASS: rdkafka_range_assignor.c:1595: ut_testRackAwareAssignmentWithCoPartitioning1 145s RDUT: INFO: rdkafka_range_assignor.c:1719: rd_kafka_range_assignor_unittest: [ Test #14 ran for 0.121ms ] 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #15, RackConfig = 0 ] 145s RDUT: PASS: rdkafka_range_assignor.c:1612: ut_testCoPartitionedAssignmentWithSameSubscription 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #15, RackConfig = 1 ] 145s RDUT: PASS: rdkafka_range_assignor.c:1612: ut_testCoPartitionedAssignmentWithSameSubscription 145s RDUT: INFO: rdkafka_range_assignor.c:1715: rd_kafka_range_assignor_unittest: [ Test #15, RackConfig = 2 ] 145s RDUT: PASS: rdkafka_range_assignor.c:1652: ut_testCoPartitionedAssignmentWithSameSubscription 145s RDUT: INFO: rdkafka_range_assignor.c:1719: rd_kafka_range_assignor_unittest: [ Test #15 ran for 0.086ms ] 145s RDUT: INFO: rdkafka_sticky_assignor.c:4749: rd_kafka_sticky_assignor_unittest: [ Test #0 ] 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #0, RackConfig = 0 ] 145s RDUT: PASS: rdkafka_sticky_assignor.c:2257: ut_testOneConsumerNoTopic 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #0, RackConfig = 1 ] 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testOneConsumerNoTopic:2275: verifying assignment for 1 member(s): 145s RDUT: PASS: rdkafka_sticky_assignor.c:2281: ut_testOneConsumerNoTopic 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #0, RackConfig = 2 ] 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testOneConsumerNoTopic:2275: verifying assignment for 1 member(s): 145s RDUT: PASS: rdkafka_sticky_assignor.c:2281: ut_testOneConsumerNoTopic 145s RDUT: INFO: rdkafka_sticky_assignor.c:4756: rd_kafka_sticky_assignor_unittest: [ Test #0 ran for 0.659ms ] 145s RDUT: INFO: rdkafka_sticky_assignor.c:4749: rd_kafka_sticky_assignor_unittest: [ Test #1 ] 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #1, RackConfig = 0 ] 145s RDUT: PASS: rdkafka_sticky_assignor.c:2295: ut_testOneConsumerNonexistentTopic 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #1, RackConfig = 1 ] 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testOneConsumerNonexistentTopic:2312: verifying assignment for 1 member(s): 145s RDUT: PASS: rdkafka_sticky_assignor.c:2318: ut_testOneConsumerNonexistentTopic 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #1, RackConfig = 2 ] 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testOneConsumerNonexistentTopic:2312: verifying assignment for 1 member(s): 145s RDUT: PASS: rdkafka_sticky_assignor.c:2318: ut_testOneConsumerNonexistentTopic 145s RDUT: INFO: rdkafka_sticky_assignor.c:4756: rd_kafka_sticky_assignor_unittest: [ Test #1 ran for 0.572ms ] 145s RDUT: INFO: rdkafka_sticky_assignor.c:4749: rd_kafka_sticky_assignor_unittest: [ Test #2 ] 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #2, RackConfig = 0 ] 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testOneConsumerOneTopic:2351: verifying assignment for 1 member(s): 145s RDUT: PASS: rdkafka_sticky_assignor.c:2357: ut_testOneConsumerOneTopic 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #2, RackConfig = 1 ] 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testOneConsumerOneTopic:2351: verifying assignment for 1 member(s): 145s RDUT: PASS: rdkafka_sticky_assignor.c:2357: ut_testOneConsumerOneTopic 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #2, RackConfig = 2 ] 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testOneConsumerOneTopic:2351: verifying assignment for 1 member(s): 145s RDUT: PASS: rdkafka_sticky_assignor.c:2357: ut_testOneConsumerOneTopic 145s RDUT: INFO: rdkafka_sticky_assignor.c:4756: rd_kafka_sticky_assignor_unittest: [ Test #2 ran for 0.867ms ] 145s RDUT: INFO: rdkafka_sticky_assignor.c:4749: rd_kafka_sticky_assignor_unittest: [ Test #3 ] 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #3, RackConfig = 0 ] 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testOnlyAssignsPartitionsFromSubscribedTopics:2386: verifying assignment for 1 member(s): 145s RDUT: PASS: rdkafka_sticky_assignor.c:2392: ut_testOnlyAssignsPartitionsFromSubscribedTopics 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #3, RackConfig = 1 ] 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testOnlyAssignsPartitionsFromSubscribedTopics:2386: verifying assignment for 1 member(s): 145s RDUT: PASS: rdkafka_sticky_assignor.c:2392: ut_testOnlyAssignsPartitionsFromSubscribedTopics 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #3, RackConfig = 2 ] 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testOnlyAssignsPartitionsFromSubscribedTopics:2386: verifying assignment for 1 member(s): 145s RDUT: PASS: rdkafka_sticky_assignor.c:2392: ut_testOnlyAssignsPartitionsFromSubscribedTopics 145s RDUT: INFO: rdkafka_sticky_assignor.c:4756: rd_kafka_sticky_assignor_unittest: [ Test #3 ran for 0.587ms ] 145s RDUT: INFO: rdkafka_sticky_assignor.c:4749: rd_kafka_sticky_assignor_unittest: [ Test #4 ] 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #4, RackConfig = 0 ] 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testOneConsumerMultipleTopics:2421: verifying assignment for 1 member(s): 145s RDUT: PASS: rdkafka_sticky_assignor.c:2427: ut_testOneConsumerMultipleTopics 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #4, RackConfig = 1 ] 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testOneConsumerMultipleTopics:2421: verifying assignment for 1 member(s): 145s RDUT: PASS: rdkafka_sticky_assignor.c:2427: ut_testOneConsumerMultipleTopics 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #4, RackConfig = 2 ] 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testOneConsumerMultipleTopics:2421: verifying assignment for 1 member(s): 145s RDUT: PASS: rdkafka_sticky_assignor.c:2427: ut_testOneConsumerMultipleTopics 145s RDUT: INFO: rdkafka_sticky_assignor.c:4756: rd_kafka_sticky_assignor_unittest: [ Test #4 ran for 0.488ms ] 145s RDUT: INFO: rdkafka_sticky_assignor.c:4749: rd_kafka_sticky_assignor_unittest: [ Test #5 ] 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #5, RackConfig = 0 ] 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testTwoConsumersOneTopicOnePartition:2458: verifying assignment for 2 member(s): 145s RDUT: PASS: rdkafka_sticky_assignor.c:2465: ut_testTwoConsumersOneTopicOnePartition 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #5, RackConfig = 1 ] 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testTwoConsumersOneTopicOnePartition:2458: verifying assignment for 2 member(s): 145s RDUT: PASS: rdkafka_sticky_assignor.c:2465: ut_testTwoConsumersOneTopicOnePartition 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #5, RackConfig = 2 ] 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testTwoConsumersOneTopicOnePartition:2458: verifying assignment for 2 member(s): 145s RDUT: PASS: rdkafka_sticky_assignor.c:2465: ut_testTwoConsumersOneTopicOnePartition 145s RDUT: INFO: rdkafka_sticky_assignor.c:4756: rd_kafka_sticky_assignor_unittest: [ Test #5 ran for 0.507ms ] 145s RDUT: INFO: rdkafka_sticky_assignor.c:4749: rd_kafka_sticky_assignor_unittest: [ Test #6 ] 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #6, RackConfig = 0 ] 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testTwoConsumersOneTopicTwoPartitions:2497: verifying assignment for 2 member(s): 145s RDUT: PASS: rdkafka_sticky_assignor.c:2504: ut_testTwoConsumersOneTopicTwoPartitions 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #6, RackConfig = 1 ] 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testTwoConsumersOneTopicTwoPartitions:2497: verifying assignment for 2 member(s): 145s RDUT: PASS: rdkafka_sticky_assignor.c:2504: ut_testTwoConsumersOneTopicTwoPartitions 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #6, RackConfig = 2 ] 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testTwoConsumersOneTopicTwoPartitions:2497: verifying assignment for 2 member(s): 145s RDUT: PASS: rdkafka_sticky_assignor.c:2504: ut_testTwoConsumersOneTopicTwoPartitions 145s RDUT: INFO: rdkafka_sticky_assignor.c:4756: rd_kafka_sticky_assignor_unittest: [ Test #6 ran for 0.057ms ] 145s RDUT: INFO: rdkafka_sticky_assignor.c:4749: rd_kafka_sticky_assignor_unittest: [ Test #7 ] 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #7, RackConfig = 0 ] 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testMultipleConsumersMixedTopicSubscriptions:2541: verifying assignment for 3 member(s): 145s RDUT: PASS: rdkafka_sticky_assignor.c:2549: ut_testMultipleConsumersMixedTopicSubscriptions 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #7, RackConfig = 1 ] 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testMultipleConsumersMixedTopicSubscriptions:2541: verifying assignment for 3 member(s): 145s RDUT: PASS: rdkafka_sticky_assignor.c:2549: ut_testMultipleConsumersMixedTopicSubscriptions 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #7, RackConfig = 2 ] 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testMultipleConsumersMixedTopicSubscriptions:2541: verifying assignment for 3 member(s): 145s RDUT: PASS: rdkafka_sticky_assignor.c:2549: ut_testMultipleConsumersMixedTopicSubscriptions 145s RDUT: INFO: rdkafka_sticky_assignor.c:4756: rd_kafka_sticky_assignor_unittest: [ Test #7 ran for 0.118ms ] 145s RDUT: INFO: rdkafka_sticky_assignor.c:4749: rd_kafka_sticky_assignor_unittest: [ Test #8 ] 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #8, RackConfig = 0 ] 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testTwoConsumersTwoTopicsSixPartitions:2583: verifying assignment for 2 member(s): 145s RDUT: PASS: rdkafka_sticky_assignor.c:2590: ut_testTwoConsumersTwoTopicsSixPartitions 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #8, RackConfig = 1 ] 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testTwoConsumersTwoTopicsSixPartitions:2583: verifying assignment for 2 member(s): 145s RDUT: PASS: rdkafka_sticky_assignor.c:2590: ut_testTwoConsumersTwoTopicsSixPartitions 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #8, RackConfig = 2 ] 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testTwoConsumersTwoTopicsSixPartitions:2583: verifying assignment for 2 member(s): 145s RDUT: PASS: rdkafka_sticky_assignor.c:2590: ut_testTwoConsumersTwoTopicsSixPartitions 145s RDUT: INFO: rdkafka_sticky_assignor.c:4756: rd_kafka_sticky_assignor_unittest: [ Test #8 ran for 0.129ms ] 145s RDUT: INFO: rdkafka_sticky_assignor.c:4749: rd_kafka_sticky_assignor_unittest: [ Test #9 ] 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #9, RackConfig = 0 ] 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testAddRemoveConsumerOneTopic:2619: verifying assignment for 1 member(s): 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testAddRemoveConsumerOneTopic:2635: verifying assignment for 2 member(s): 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testAddRemoveConsumerOneTopic:2648: verifying assignment for 1 member(s): 145s RDUT: PASS: rdkafka_sticky_assignor.c:2656: ut_testAddRemoveConsumerOneTopic 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #9, RackConfig = 1 ] 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testAddRemoveConsumerOneTopic:2619: verifying assignment for 1 member(s): 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testAddRemoveConsumerOneTopic:2635: verifying assignment for 2 member(s): 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testAddRemoveConsumerOneTopic:2648: verifying assignment for 1 member(s): 145s RDUT: PASS: rdkafka_sticky_assignor.c:2656: ut_testAddRemoveConsumerOneTopic 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #9, RackConfig = 2 ] 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testAddRemoveConsumerOneTopic:2619: verifying assignment for 1 member(s): 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testAddRemoveConsumerOneTopic:2635: verifying assignment for 2 member(s): 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testAddRemoveConsumerOneTopic:2648: verifying assignment for 1 member(s): 145s RDUT: PASS: rdkafka_sticky_assignor.c:2656: ut_testAddRemoveConsumerOneTopic 145s RDUT: INFO: rdkafka_sticky_assignor.c:4756: rd_kafka_sticky_assignor_unittest: [ Test #9 ran for 0.159ms ] 145s RDUT: INFO: rdkafka_sticky_assignor.c:4749: rd_kafka_sticky_assignor_unittest: [ Test #10 ] 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #10, RackConfig = 0 ] 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testPoorRoundRobinAssignmentScenario:2720: verifying assignment for 4 member(s): 145s RDUT: PASS: rdkafka_sticky_assignor.c:2729: ut_testPoorRoundRobinAssignmentScenario 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #10, RackConfig = 1 ] 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testPoorRoundRobinAssignmentScenario:2720: verifying assignment for 4 member(s): 145s RDUT: PASS: rdkafka_sticky_assignor.c:2729: ut_testPoorRoundRobinAssignmentScenario 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #10, RackConfig = 2 ] 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testPoorRoundRobinAssignmentScenario:2720: verifying assignment for 4 member(s): 145s RDUT: PASS: rdkafka_sticky_assignor.c:2729: ut_testPoorRoundRobinAssignmentScenario 145s RDUT: INFO: rdkafka_sticky_assignor.c:4756: rd_kafka_sticky_assignor_unittest: [ Test #10 ran for 0.160ms ] 145s RDUT: INFO: rdkafka_sticky_assignor.c:4749: rd_kafka_sticky_assignor_unittest: [ Test #11 ] 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #11, RackConfig = 0 ] 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testAddRemoveTopicTwoConsumers:2762: verifying assignment for 2 member(s): 145s RDUT: INFO: rdkafka_sticky_assignor.c:2768: ut_testAddRemoveTopicTwoConsumers: Adding topic2 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testAddRemoveTopicTwoConsumers:2785: verifying assignment for 2 member(s): 145s RDUT: INFO: rdkafka_sticky_assignor.c:2793: ut_testAddRemoveTopicTwoConsumers: Removing topic1 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testAddRemoveTopicTwoConsumers:2808: verifying assignment for 2 member(s): 145s RDUT: PASS: rdkafka_sticky_assignor.c:2816: ut_testAddRemoveTopicTwoConsumers 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #11, RackConfig = 1 ] 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testAddRemoveTopicTwoConsumers:2762: verifying assignment for 2 member(s): 145s RDUT: INFO: rdkafka_sticky_assignor.c:2768: ut_testAddRemoveTopicTwoConsumers: Adding topic2 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testAddRemoveTopicTwoConsumers:2785: verifying assignment for 2 member(s): 145s RDUT: INFO: rdkafka_sticky_assignor.c:2793: ut_testAddRemoveTopicTwoConsumers: Removing topic1 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testAddRemoveTopicTwoConsumers:2808: verifying assignment for 2 member(s): 145s RDUT: PASS: rdkafka_sticky_assignor.c:2816: ut_testAddRemoveTopicTwoConsumers 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #11, RackConfig = 2 ] 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testAddRemoveTopicTwoConsumers:2762: verifying assignment for 2 member(s): 145s RDUT: INFO: rdkafka_sticky_assignor.c:2768: ut_testAddRemoveTopicTwoConsumers: Adding topic2 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testAddRemoveTopicTwoConsumers:2785: verifying assignment for 2 member(s): 145s RDUT: INFO: rdkafka_sticky_assignor.c:2793: ut_testAddRemoveTopicTwoConsumers: Removing topic1 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testAddRemoveTopicTwoConsumers:2808: verifying assignment for 2 member(s): 145s RDUT: PASS: rdkafka_sticky_assignor.c:2816: ut_testAddRemoveTopicTwoConsumers 145s RDUT: INFO: rdkafka_sticky_assignor.c:4756: rd_kafka_sticky_assignor_unittest: [ Test #11 ran for 0.210ms ] 145s RDUT: INFO: rdkafka_sticky_assignor.c:4749: rd_kafka_sticky_assignor_unittest: [ Test #12 ] 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #12, RackConfig = 0 ] 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testReassignmentAfterOneConsumerLeaves:2871: verifying assignment for 19 member(s): 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testReassignmentAfterOneConsumerLeaves:2886: verifying assignment for 18 member(s): 145s RDUT: PASS: rdkafka_sticky_assignor.c:2893: ut_testReassignmentAfterOneConsumerLeaves 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #12, RackConfig = 1 ] 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testReassignmentAfterOneConsumerLeaves:2871: verifying assignment for 19 member(s): 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testReassignmentAfterOneConsumerLeaves:2886: verifying assignment for 18 member(s): 145s RDUT: PASS: rdkafka_sticky_assignor.c:2893: ut_testReassignmentAfterOneConsumerLeaves 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #12, RackConfig = 2 ] 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testReassignmentAfterOneConsumerLeaves:2871: verifying assignment for 19 member(s): 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testReassignmentAfterOneConsumerLeaves:2886: verifying assignment for 18 member(s): 145s RDUT: PASS: rdkafka_sticky_assignor.c:2893: ut_testReassignmentAfterOneConsumerLeaves 145s RDUT: INFO: rdkafka_sticky_assignor.c:4756: rd_kafka_sticky_assignor_unittest: [ Test #12 ran for 120.118ms ] 145s RDUT: INFO: rdkafka_sticky_assignor.c:4749: rd_kafka_sticky_assignor_unittest: [ Test #13 ] 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #13, RackConfig = 0 ] 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testReassignmentAfterOneConsumerAdded:2933: verifying assignment for 8 member(s): 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testReassignmentAfterOneConsumerAdded:2945: verifying assignment for 9 member(s): 145s RDUT: PASS: rdkafka_sticky_assignor.c:2952: ut_testReassignmentAfterOneConsumerAdded 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #13, RackConfig = 1 ] 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testReassignmentAfterOneConsumerAdded:2933: verifying assignment for 8 member(s): 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testReassignmentAfterOneConsumerAdded:2945: verifying assignment for 9 member(s): 145s RDUT: PASS: rdkafka_sticky_assignor.c:2952: ut_testReassignmentAfterOneConsumerAdded 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #13, RackConfig = 2 ] 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testReassignmentAfterOneConsumerAdded:2933: verifying assignment for 8 member(s): 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testReassignmentAfterOneConsumerAdded:2945: verifying assignment for 9 member(s): 145s RDUT: PASS: rdkafka_sticky_assignor.c:2952: ut_testReassignmentAfterOneConsumerAdded 145s RDUT: INFO: rdkafka_sticky_assignor.c:4756: rd_kafka_sticky_assignor_unittest: [ Test #13 ran for 1.644ms ] 145s RDUT: INFO: rdkafka_sticky_assignor.c:4749: rd_kafka_sticky_assignor_unittest: [ Test #14 ] 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #14, RackConfig = 0 ] 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testSameSubscriptions:3001: verifying assignment for 9 member(s): 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testSameSubscriptions:3014: verifying assignment for 8 member(s): 145s RDUT: PASS: rdkafka_sticky_assignor.c:3022: ut_testSameSubscriptions 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #14, RackConfig = 1 ] 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testSameSubscriptions:3001: verifying assignment for 9 member(s): 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testSameSubscriptions:3014: verifying assignment for 8 member(s): 145s RDUT: PASS: rdkafka_sticky_assignor.c:3022: ut_testSameSubscriptions 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #14, RackConfig = 2 ] 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testSameSubscriptions:3001: verifying assignment for 9 member(s): 145s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testSameSubscriptions:3014: verifying assignment for 8 member(s): 145s RDUT: PASS: rdkafka_sticky_assignor.c:3022: ut_testSameSubscriptions 145s RDUT: INFO: rdkafka_sticky_assignor.c:4756: rd_kafka_sticky_assignor_unittest: [ Test #14 ran for 43.365ms ] 145s RDUT: INFO: rdkafka_sticky_assignor.c:4749: rd_kafka_sticky_assignor_unittest: [ Test #15 ] 145s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #15, RackConfig = 0 ] 148s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testLargeAssignmentWithMultipleConsumersLeaving:3082: verifying assignment for 200 member(s): 149s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testLargeAssignmentWithMultipleConsumersLeaving:3098: verifying assignment for 150 member(s): 149s RDUT: PASS: rdkafka_sticky_assignor.c:3105: ut_testLargeAssignmentWithMultipleConsumersLeaving 149s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #15, RackConfig = 1 ] 151s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testLargeAssignmentWithMultipleConsumersLeaving:3082: verifying assignment for 200 member(s): 152s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testLargeAssignmentWithMultipleConsumersLeaving:3098: verifying assignment for 150 member(s): 152s RDUT: PASS: rdkafka_sticky_assignor.c:3105: ut_testLargeAssignmentWithMultipleConsumersLeaving 152s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #15, RackConfig = 2 ] 154s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testLargeAssignmentWithMultipleConsumersLeaving:3082: verifying assignment for 200 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testLargeAssignmentWithMultipleConsumersLeaving:3098: verifying assignment for 150 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:3105: ut_testLargeAssignmentWithMultipleConsumersLeaving 155s RDUT: INFO: rdkafka_sticky_assignor.c:4756: rd_kafka_sticky_assignor_unittest: [ Test #15 ran for 9707.936ms ] 155s RDUT: INFO: rdkafka_sticky_assignor.c:4749: rd_kafka_sticky_assignor_unittest: [ Test #16 ] 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #16, RackConfig = 0 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testNewSubscription:3150: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_sticky_assignor.c:3156: ut_testNewSubscription: Adding topic1 to consumer1 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testNewSubscription:3165: verifying assignment for 3 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:3173: ut_testNewSubscription 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #16, RackConfig = 1 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testNewSubscription:3150: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_sticky_assignor.c:3156: ut_testNewSubscription: Adding topic1 to consumer1 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testNewSubscription:3165: verifying assignment for 3 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:3173: ut_testNewSubscription 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #16, RackConfig = 2 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testNewSubscription:3150: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_sticky_assignor.c:3156: ut_testNewSubscription: Adding topic1 to consumer1 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testNewSubscription:3165: verifying assignment for 3 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:3173: ut_testNewSubscription 155s RDUT: INFO: rdkafka_sticky_assignor.c:4756: rd_kafka_sticky_assignor_unittest: [ Test #16 ran for 1.976ms ] 155s RDUT: INFO: rdkafka_sticky_assignor.c:4749: rd_kafka_sticky_assignor_unittest: [ Test #17 ] 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #17, RackConfig = 0 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testMoveExistingAssignments:3211: verifying assignment for 4 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testMoveExistingAssignments:3232: verifying assignment for 3 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:3268: ut_testMoveExistingAssignments 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #17, RackConfig = 1 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testMoveExistingAssignments:3211: verifying assignment for 4 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testMoveExistingAssignments:3232: verifying assignment for 3 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:3268: ut_testMoveExistingAssignments 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #17, RackConfig = 2 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testMoveExistingAssignments:3211: verifying assignment for 4 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testMoveExistingAssignments:3232: verifying assignment for 3 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:3268: ut_testMoveExistingAssignments 155s RDUT: INFO: rdkafka_sticky_assignor.c:4756: rd_kafka_sticky_assignor_unittest: [ Test #17 ran for 1.271ms ] 155s RDUT: INFO: rdkafka_sticky_assignor.c:4749: rd_kafka_sticky_assignor_unittest: [ Test #18 ] 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #18, RackConfig = 0 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testMoveExistingAssignments_j:3318: verifying assignment for 3 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:3327: ut_testMoveExistingAssignments_j 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #18, RackConfig = 1 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testMoveExistingAssignments_j:3318: verifying assignment for 3 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:3327: ut_testMoveExistingAssignments_j 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #18, RackConfig = 2 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testMoveExistingAssignments_j:3318: verifying assignment for 3 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:3327: ut_testMoveExistingAssignments_j 155s RDUT: INFO: rdkafka_sticky_assignor.c:4756: rd_kafka_sticky_assignor_unittest: [ Test #18 ran for 1.248ms ] 155s RDUT: INFO: rdkafka_sticky_assignor.c:4749: rd_kafka_sticky_assignor_unittest: [ Test #19 ] 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #19, RackConfig = 0 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testStickiness:3382: verifying assignment for 3 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:3388: ut_testStickiness 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #19, RackConfig = 1 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testStickiness:3382: verifying assignment for 3 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:3388: ut_testStickiness 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #19, RackConfig = 2 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testStickiness:3382: verifying assignment for 3 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:3388: ut_testStickiness 155s RDUT: INFO: rdkafka_sticky_assignor.c:4756: rd_kafka_sticky_assignor_unittest: [ Test #19 ran for 0.826ms ] 155s RDUT: INFO: rdkafka_sticky_assignor.c:4749: rd_kafka_sticky_assignor_unittest: [ Test #20 ] 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #20, RackConfig = 0 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testStickiness_j:3431: verifying assignment for 4 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testStickiness_j:3456: verifying assignment for 3 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:3492: ut_testStickiness_j 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #20, RackConfig = 1 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testStickiness_j:3431: verifying assignment for 4 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testStickiness_j:3456: verifying assignment for 3 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:3492: ut_testStickiness_j 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #20, RackConfig = 2 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testStickiness_j:3431: verifying assignment for 4 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testStickiness_j:3456: verifying assignment for 3 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:3492: ut_testStickiness_j 155s RDUT: INFO: rdkafka_sticky_assignor.c:4756: rd_kafka_sticky_assignor_unittest: [ Test #20 ran for 0.416ms ] 155s RDUT: INFO: rdkafka_sticky_assignor.c:4749: rd_kafka_sticky_assignor_unittest: [ Test #21 ] 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #21, RackConfig = 0 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testStickiness2:3529: verifying assignment for 1 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testStickiness2:3539: verifying assignment for 2 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testStickiness2:3553: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testStickiness2:3553: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testStickiness2:3565: verifying assignment for 2 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testStickiness2:3577: verifying assignment for 1 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:3586: ut_testStickiness2 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #21, RackConfig = 1 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testStickiness2:3529: verifying assignment for 1 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testStickiness2:3539: verifying assignment for 2 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testStickiness2:3553: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testStickiness2:3553: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testStickiness2:3565: verifying assignment for 2 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testStickiness2:3577: verifying assignment for 1 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:3586: ut_testStickiness2 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #21, RackConfig = 2 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testStickiness2:3529: verifying assignment for 1 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testStickiness2:3539: verifying assignment for 2 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testStickiness2:3553: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testStickiness2:3553: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testStickiness2:3565: verifying assignment for 2 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testStickiness2:3577: verifying assignment for 1 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:3586: ut_testStickiness2 155s RDUT: INFO: rdkafka_sticky_assignor.c:4756: rd_kafka_sticky_assignor_unittest: [ Test #21 ran for 5.993ms ] 155s RDUT: INFO: rdkafka_sticky_assignor.c:4749: rd_kafka_sticky_assignor_unittest: [ Test #22 ] 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #22, RackConfig = 0 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testAssignmentUpdatedForDeletedTopic:3612: verifying assignment for 1 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:3622: ut_testAssignmentUpdatedForDeletedTopic 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #22, RackConfig = 1 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testAssignmentUpdatedForDeletedTopic:3612: verifying assignment for 1 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:3622: ut_testAssignmentUpdatedForDeletedTopic 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #22, RackConfig = 2 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testAssignmentUpdatedForDeletedTopic:3612: verifying assignment for 1 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:3622: ut_testAssignmentUpdatedForDeletedTopic 155s RDUT: INFO: rdkafka_sticky_assignor.c:4756: rd_kafka_sticky_assignor_unittest: [ Test #22 ran for 3.207ms ] 155s RDUT: INFO: rdkafka_sticky_assignor.c:4749: rd_kafka_sticky_assignor_unittest: [ Test #23 ] 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #23, RackConfig = 0 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testNoExceptionThrownWhenOnlySubscribedTopicDeleted:3649: verifying assignment for 1 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testNoExceptionThrownWhenOnlySubscribedTopicDeleted:3663: verifying assignment for 1 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:3669: ut_testNoExceptionThrownWhenOnlySubscribedTopicDeleted 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #23, RackConfig = 1 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testNoExceptionThrownWhenOnlySubscribedTopicDeleted:3649: verifying assignment for 1 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testNoExceptionThrownWhenOnlySubscribedTopicDeleted:3663: verifying assignment for 1 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:3669: ut_testNoExceptionThrownWhenOnlySubscribedTopicDeleted 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #23, RackConfig = 2 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testNoExceptionThrownWhenOnlySubscribedTopicDeleted:3649: verifying assignment for 1 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testNoExceptionThrownWhenOnlySubscribedTopicDeleted:3663: verifying assignment for 1 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:3669: ut_testNoExceptionThrownWhenOnlySubscribedTopicDeleted 155s RDUT: INFO: rdkafka_sticky_assignor.c:4756: rd_kafka_sticky_assignor_unittest: [ Test #23 ran for 1.461ms ] 155s RDUT: INFO: rdkafka_sticky_assignor.c:4749: rd_kafka_sticky_assignor_unittest: [ Test #24 ] 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #24, RackConfig = 0 ] 155s RDUT: PASS: rdkafka_sticky_assignor.c:3687: ut_testConflictingPreviousAssignments 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #24, RackConfig = 1 ] 155s RDUT: PASS: rdkafka_sticky_assignor.c:3687: ut_testConflictingPreviousAssignments 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #24, RackConfig = 2 ] 155s RDUT: PASS: rdkafka_sticky_assignor.c:3687: ut_testConflictingPreviousAssignments 155s RDUT: INFO: rdkafka_sticky_assignor.c:4756: rd_kafka_sticky_assignor_unittest: [ Test #24 ran for 0.057ms ] 155s RDUT: INFO: rdkafka_sticky_assignor.c:4749: rd_kafka_sticky_assignor_unittest: [ Test #25 ] 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #25, RackConfig = 0 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testAllConsumersReachExpectedQuotaAndAreConsideredFilled:3775: verifying assignment for 3 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:3784: ut_testAllConsumersReachExpectedQuotaAndAreConsideredFilled 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #25, RackConfig = 1 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testAllConsumersReachExpectedQuotaAndAreConsideredFilled:3775: verifying assignment for 3 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:3784: ut_testAllConsumersReachExpectedQuotaAndAreConsideredFilled 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #25, RackConfig = 2 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testAllConsumersReachExpectedQuotaAndAreConsideredFilled:3775: verifying assignment for 3 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:3784: ut_testAllConsumersReachExpectedQuotaAndAreConsideredFilled 155s RDUT: INFO: rdkafka_sticky_assignor.c:4756: rd_kafka_sticky_assignor_unittest: [ Test #25 ran for 0.205ms ] 155s RDUT: INFO: rdkafka_sticky_assignor.c:4749: rd_kafka_sticky_assignor_unittest: [ Test #26 ] 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #26, RackConfig = 0 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testOwnedPartitionsAreInvalidatedForConsumerWithStaleGeneration:3822: verifying assignment for 2 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:3833: ut_testOwnedPartitionsAreInvalidatedForConsumerWithStaleGeneration 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #26, RackConfig = 1 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testOwnedPartitionsAreInvalidatedForConsumerWithStaleGeneration:3822: verifying assignment for 2 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:3833: ut_testOwnedPartitionsAreInvalidatedForConsumerWithStaleGeneration 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #26, RackConfig = 2 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testOwnedPartitionsAreInvalidatedForConsumerWithStaleGeneration:3822: verifying assignment for 2 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:3833: ut_testOwnedPartitionsAreInvalidatedForConsumerWithStaleGeneration 155s RDUT: INFO: rdkafka_sticky_assignor.c:4756: rd_kafka_sticky_assignor_unittest: [ Test #26 ran for 0.886ms ] 155s RDUT: INFO: rdkafka_sticky_assignor.c:4749: rd_kafka_sticky_assignor_unittest: [ Test #27 ] 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #27, RackConfig = 0 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testOwnedPartitionsAreInvalidatedForConsumerWithNoGeneration:3870: verifying assignment for 2 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:3881: ut_testOwnedPartitionsAreInvalidatedForConsumerWithNoGeneration 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #27, RackConfig = 1 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testOwnedPartitionsAreInvalidatedForConsumerWithNoGeneration:3870: verifying assignment for 2 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:3881: ut_testOwnedPartitionsAreInvalidatedForConsumerWithNoGeneration 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #27, RackConfig = 2 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testOwnedPartitionsAreInvalidatedForConsumerWithNoGeneration:3870: verifying assignment for 2 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:3881: ut_testOwnedPartitionsAreInvalidatedForConsumerWithNoGeneration 155s RDUT: INFO: rdkafka_sticky_assignor.c:4756: rd_kafka_sticky_assignor_unittest: [ Test #27 ran for 0.512ms ] 155s RDUT: INFO: rdkafka_sticky_assignor.c:4749: rd_kafka_sticky_assignor_unittest: [ Test #28 ] 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #28, RackConfig = 0 ] 155s %3|1769690613.684|STICKY|rdkafka#consumer-10| [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. 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testPartitionsTransferringOwnershipIncludeThePartitionClaimedByMultipleConsumersInSameGeneration:3922: verifying assignment for 3 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:3931: ut_testPartitionsTransferringOwnershipIncludeThePartitionClaimedByMultipleConsumersInSameGeneration 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #28, RackConfig = 1 ] 155s %3|1769690613.684|STICKY|rdkafka#consumer-10| [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. 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testPartitionsTransferringOwnershipIncludeThePartitionClaimedByMultipleConsumersInSameGeneration:3922: verifying assignment for 3 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:3931: ut_testPartitionsTransferringOwnershipIncludeThePartitionClaimedByMultipleConsumersInSameGeneration 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #28, RackConfig = 2 ] 155s %3|1769690613.684|STICKY|rdkafka#consumer-10| [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. 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testPartitionsTransferringOwnershipIncludeThePartitionClaimedByMultipleConsumersInSameGeneration:3922: verifying assignment for 3 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:3931: ut_testPartitionsTransferringOwnershipIncludeThePartitionClaimedByMultipleConsumersInSameGeneration 155s RDUT: INFO: rdkafka_sticky_assignor.c:4756: rd_kafka_sticky_assignor_unittest: [ Test #28 ran for 0.728ms ] 155s RDUT: INFO: rdkafka_sticky_assignor.c:4749: rd_kafka_sticky_assignor_unittest: [ Test #29 ] 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #29, RackConfig = 0 ] 155s %3|1769690613.685|STICKY|rdkafka#consumer-10| [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. 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testPartitionsTransferringOwnershipIncludeThePartitionClaimedByMultipleConsumersInSameGeneration2:3979: verifying assignment for 3 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:3988: ut_testPartitionsTransferringOwnershipIncludeThePartitionClaimedByMultipleConsumersInSameGeneration2 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #29, RackConfig = 1 ] 155s %3|1769690613.685|STICKY|rdkafka#consumer-10| [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. 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testPartitionsTransferringOwnershipIncludeThePartitionClaimedByMultipleConsumersInSameGeneration2:3979: verifying assignment for 3 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:3988: ut_testPartitionsTransferringOwnershipIncludeThePartitionClaimedByMultipleConsumersInSameGeneration2 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #29, RackConfig = 2 ] 155s %3|1769690613.685|STICKY|rdkafka#consumer-10| [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. 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testPartitionsTransferringOwnershipIncludeThePartitionClaimedByMultipleConsumersInSameGeneration2:3979: verifying assignment for 3 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:3988: ut_testPartitionsTransferringOwnershipIncludeThePartitionClaimedByMultipleConsumersInSameGeneration2 155s RDUT: INFO: rdkafka_sticky_assignor.c:4756: rd_kafka_sticky_assignor_unittest: [ Test #29 ran for 0.729ms ] 155s RDUT: INFO: rdkafka_sticky_assignor.c:4749: rd_kafka_sticky_assignor_unittest: [ Test #30 ] 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #30, RackConfig = 0 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testEnsurePartitionsAssignedToHighestGeneration:4041: verifying assignment for 3 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:4047: ut_testEnsurePartitionsAssignedToHighestGeneration 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #30, RackConfig = 1 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testEnsurePartitionsAssignedToHighestGeneration:4041: verifying assignment for 3 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:4047: ut_testEnsurePartitionsAssignedToHighestGeneration 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #30, RackConfig = 2 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testEnsurePartitionsAssignedToHighestGeneration:4041: verifying assignment for 3 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:4047: ut_testEnsurePartitionsAssignedToHighestGeneration 155s RDUT: INFO: rdkafka_sticky_assignor.c:4756: rd_kafka_sticky_assignor_unittest: [ Test #30 ran for 1.861ms ] 155s RDUT: INFO: rdkafka_sticky_assignor.c:4749: rd_kafka_sticky_assignor_unittest: [ Test #31 ] 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #31, RackConfig = 0 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testNoReassignmentOnCurrentMembers:4099: verifying assignment for 4 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:4107: ut_testNoReassignmentOnCurrentMembers 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #31, RackConfig = 1 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testNoReassignmentOnCurrentMembers:4099: verifying assignment for 4 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:4107: ut_testNoReassignmentOnCurrentMembers 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #31, RackConfig = 2 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testNoReassignmentOnCurrentMembers:4099: verifying assignment for 4 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:4107: ut_testNoReassignmentOnCurrentMembers 155s RDUT: INFO: rdkafka_sticky_assignor.c:4756: rd_kafka_sticky_assignor_unittest: [ Test #31 ran for 0.263ms ] 155s RDUT: INFO: rdkafka_sticky_assignor.c:4749: rd_kafka_sticky_assignor_unittest: [ Test #32 ] 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #32, RackConfig = 0 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testOwnedPartitionsAreInvalidatedForConsumerWithMultipleGeneration:4146: verifying assignment for 2 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:4156: ut_testOwnedPartitionsAreInvalidatedForConsumerWithMultipleGeneration 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #32, RackConfig = 1 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testOwnedPartitionsAreInvalidatedForConsumerWithMultipleGeneration:4146: verifying assignment for 2 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:4156: ut_testOwnedPartitionsAreInvalidatedForConsumerWithMultipleGeneration 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #32, RackConfig = 2 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: ut_testOwnedPartitionsAreInvalidatedForConsumerWithMultipleGeneration:4146: verifying assignment for 2 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:4156: ut_testOwnedPartitionsAreInvalidatedForConsumerWithMultipleGeneration 155s RDUT: INFO: rdkafka_sticky_assignor.c:4756: rd_kafka_sticky_assignor_unittest: [ Test #32 ran for 0.164ms ] 155s RDUT: INFO: rdkafka_sticky_assignor.c:4749: rd_kafka_sticky_assignor_unittest: [ Test #33 ] 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #33, RackConfig = 0 ] 155s RDUT: PASS: rdkafka_sticky_assignor.c:4371: ut_testRackAwareAssignmentWithUniformSubscription 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #33, RackConfig = 1 ] 155s RDUT: PASS: rdkafka_sticky_assignor.c:4371: ut_testRackAwareAssignmentWithUniformSubscription 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #33, RackConfig = 2 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: setupRackAwareAssignment0:4227: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: setupRackAwareAssignment0:4227: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: setupRackAwareAssignment0:4227: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: setupRackAwareAssignment0:4227: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: setupRackAwareAssignment0:4227: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: setupRackAwareAssignment0:4227: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: setupRackAwareAssignment0:4227: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: setupRackAwareAssignment0:4227: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: setupRackAwareAssignment0:4227: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: setupRackAwareAssignment0:4227: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: setupRackAwareAssignment0:4227: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: setupRackAwareAssignment0:4227: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: setupRackAwareAssignment0:4227: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: setupRackAwareAssignment0:4227: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: setupRackAwareAssignment0:4227: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: setupRackAwareAssignment0:4227: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: setupRackAwareAssignment0:4227: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: setupRackAwareAssignment0:4227: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: setupRackAwareAssignment0:4227: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: setupRackAwareAssignment0:4227: verifying assignment for 3 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:4528: ut_testRackAwareAssignmentWithUniformSubscription 155s RDUT: INFO: rdkafka_sticky_assignor.c:4756: rd_kafka_sticky_assignor_unittest: [ Test #33 ran for 13.964ms ] 155s RDUT: INFO: rdkafka_sticky_assignor.c:4749: rd_kafka_sticky_assignor_unittest: [ Test #34 ] 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #34, RackConfig = 0 ] 155s RDUT: PASS: rdkafka_sticky_assignor.c:4550: ut_testRackAwareAssignmentWithNonEqualSubscription 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #34, RackConfig = 1 ] 155s RDUT: PASS: rdkafka_sticky_assignor.c:4550: ut_testRackAwareAssignmentWithNonEqualSubscription 155s RDUT: INFO: rdkafka_sticky_assignor.c:4752: rd_kafka_sticky_assignor_unittest: [ Test #34, RackConfig = 2 ] 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: setupRackAwareAssignment0:4227: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: setupRackAwareAssignment0:4227: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: setupRackAwareAssignment0:4227: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: setupRackAwareAssignment0:4227: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: setupRackAwareAssignment0:4227: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: setupRackAwareAssignment0:4227: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: setupRackAwareAssignment0:4227: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: setupRackAwareAssignment0:4227: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: setupRackAwareAssignment0:4227: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: setupRackAwareAssignment0:4227: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: setupRackAwareAssignment0:4227: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: setupRackAwareAssignment0:4227: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: setupRackAwareAssignment0:4227: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: setupRackAwareAssignment0:4227: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: setupRackAwareAssignment0:4227: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: setupRackAwareAssignment0:4227: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: setupRackAwareAssignment0:4227: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: setupRackAwareAssignment0:4227: verifying assignment for 3 member(s): 155s RDUT: INFO: rdkafka_assignor.c:1206: verifyValidityAndBalance0: setupRackAwareAssignment0:4227: verifying assignment for 3 member(s): 155s RDUT: PASS: rdkafka_sticky_assignor.c:4669: ut_testRackAwareAssignmentWithNonEqualSubscription 155s RDUT: INFO: rdkafka_sticky_assignor.c:4756: rd_kafka_sticky_assignor_unittest: [ Test #34 ran for 6.443ms ] 155s RDUT: PASS: rdkafka_assignor.c:1777: ut_assignors 155s RDUT: INFO: rdunittest.c:521: rd_unittest: unittest: assignors: PASS 155s RDUT: SKIP: rdhttp.c:621: unittest_http: RD_UT_HTTP_URL environment variable not set 155s RDUT: INFO: rdunittest.c:521: rd_unittest: unittest: http: PASS 155s RDUT: INFO: rdkafka_sasl_oauthbearer_oidc.c:1039: ut_sasl_oauthbearer_oidc_should_succeed: BEGIN:  155s RDUT: PASS: rdkafka_sasl_oauthbearer_oidc.c:1079: ut_sasl_oauthbearer_oidc_should_succeed 155s RDUT: INFO: rdkafka_sasl_oauthbearer_oidc.c:1096: ut_sasl_oauthbearer_oidc_with_empty_key: BEGIN:  155s RDUT: PASS: rdkafka_sasl_oauthbearer_oidc.c:1127: ut_sasl_oauthbearer_oidc_with_empty_key 155s RDUT: INFO: rdkafka_sasl_oauthbearer_oidc.c:1144: ut_sasl_oauthbearer_oidc_post_fields: BEGIN:  155s RDUT: PASS: rdkafka_sasl_oauthbearer_oidc.c:1160: ut_sasl_oauthbearer_oidc_post_fields 155s RDUT: INFO: rdkafka_sasl_oauthbearer_oidc.c:1177: ut_sasl_oauthbearer_oidc_post_fields_with_empty_scope: BEGIN:  155s RDUT: PASS: rdkafka_sasl_oauthbearer_oidc.c:1193: ut_sasl_oauthbearer_oidc_post_fields_with_empty_scope 155s RDUT: INFO: rdunittest.c:521: rd_unittest: unittest: sasl_oauthbearer_oidc: PASS 155s RDUT: INFO: rdkafka_sasl_oauthbearer_oidc.c:1240: ut_sasl_oauthbearer_oidc_jwt_bearer_base64url_encode: BEGIN:  155s RDUT: PASS: rdkafka_sasl_oauthbearer_oidc.c:1259: ut_sasl_oauthbearer_oidc_jwt_bearer_base64url_encode 155s RDUT: INFO: rdkafka_sasl_oauthbearer_oidc.c:1275: ut_sasl_oauthbearer_oidc_jwt_bearer_build_request_body: BEGIN:  155s RDUT: PASS: rdkafka_sasl_oauthbearer_oidc.c:1287: ut_sasl_oauthbearer_oidc_jwt_bearer_build_request_body 155s RDUT: INFO: rdunittest.c:521: rd_unittest: unittest: sasl_oauthbearer_oidc_jwt_bearer: PASS 155s RDUT: INFO: rdkafka_sasl_oauthbearer_oidc.c:1301: ut_sasl_oauthbearer_oidc_assertion_parse_from_file: BEGIN:  155s RDUT: PASS: rdkafka_sasl_oauthbearer_oidc.c:1330: ut_sasl_oauthbearer_oidc_assertion_parse_from_file 155s RDUT: INFO: rdkafka_sasl_oauthbearer_oidc.c:1374: ut_sasl_oauthbearer_oidc_assertion_process_template_file: BEGIN:  155s RDUT: PASS: rdkafka_sasl_oauthbearer_oidc.c:1430: ut_sasl_oauthbearer_oidc_assertion_process_template_file 155s RDUT: INFO: rdkafka_sasl_oauthbearer_oidc.c:1445: ut_sasl_oauthbearer_oidc_assertion_create: BEGIN:  155s RDUT: PASS: rdkafka_sasl_oauthbearer_oidc.c:1527: ut_sasl_oauthbearer_oidc_assertion_create 155s RDUT: INFO: rdunittest.c:521: rd_unittest: unittest: sasl_oauthbearer_oidc_assertion: PASS 155s %5|1769690613.715|CONFWARN|rdkafka#producer-11| [thrd:app]: No `bootstrap.servers` configured: client will not be able to connect to Kafka cluster 155s RDUT: INFO: rdunittest.c:521: rd_unittest: unittest: telemetry: PASS 155s RDUT: INFO: rdkafka_telemetry_decode.c:623: unit_test_telemetry: metrics_payload_size: 216 155s RDUT: PASS: rdkafka_telemetry_decode.c:730: unit_test_telemetry 155s RDUT: INFO: rdkafka_telemetry_decode.c:623: unit_test_telemetry: metrics_payload_size: 230 155s RDUT: PASS: rdkafka_telemetry_decode.c:730: unit_test_telemetry 155s RDUT: INFO: rdkafka_telemetry_decode.c:623: unit_test_telemetry: metrics_payload_size: 230 155s RDUT: PASS: rdkafka_telemetry_decode.c:730: unit_test_telemetry 155s RDUT: INFO: rdkafka_telemetry_decode.c:623: unit_test_telemetry: metrics_payload_size: 213 155s RDUT: PASS: rdkafka_telemetry_decode.c:730: unit_test_telemetry 155s RDUT: INFO: rdkafka_telemetry_decode.c:623: unit_test_telemetry: metrics_payload_size: 213 155s RDUT: PASS: rdkafka_telemetry_decode.c:730: unit_test_telemetry 155s RDUT: INFO: rdkafka_telemetry_decode.c:623: unit_test_telemetry: metrics_payload_size: 227 155s RDUT: PASS: rdkafka_telemetry_decode.c:730: unit_test_telemetry 155s RDUT: INFO: rdkafka_telemetry_decode.c:623: unit_test_telemetry: metrics_payload_size: 227 155s RDUT: PASS: rdkafka_telemetry_decode.c:730: unit_test_telemetry 155s RDUT: INFO: rdkafka_telemetry_decode.c:623: unit_test_telemetry: metrics_payload_size: 219 155s RDUT: PASS: rdkafka_telemetry_decode.c:730: unit_test_telemetry 155s RDUT: INFO: rdkafka_telemetry_decode.c:623: unit_test_telemetry: metrics_payload_size: 219 155s RDUT: PASS: rdkafka_telemetry_decode.c:730: unit_test_telemetry 155s RDUT: INFO: rdkafka_telemetry_decode.c:623: unit_test_telemetry: metrics_payload_size: 253 155s RDUT: PASS: rdkafka_telemetry_decode.c:730: unit_test_telemetry 155s RDUT: INFO: rdkafka_telemetry_decode.c:623: unit_test_telemetry: metrics_payload_size: 267 155s RDUT: PASS: rdkafka_telemetry_decode.c:730: unit_test_telemetry 155s RDUT: INFO: rdkafka_telemetry_decode.c:623: unit_test_telemetry: metrics_payload_size: 267 155s RDUT: PASS: rdkafka_telemetry_decode.c:730: unit_test_telemetry 155s RDUT: INFO: rdkafka_telemetry_decode.c:623: unit_test_telemetry: metrics_payload_size: 274 155s RDUT: PASS: rdkafka_telemetry_decode.c:730: unit_test_telemetry 155s RDUT: INFO: rdkafka_telemetry_decode.c:623: unit_test_telemetry: metrics_payload_size: 280 155s RDUT: PASS: rdkafka_telemetry_decode.c:730: unit_test_telemetry 155s RDUT: INFO: rdkafka_telemetry_decode.c:623: unit_test_telemetry: metrics_payload_size: 280 155s RDUT: PASS: rdkafka_telemetry_decode.c:730: unit_test_telemetry 155s RDUT: INFO: rdkafka_telemetry_decode.c:623: unit_test_telemetry: metrics_payload_size: 267 155s RDUT: PASS: rdkafka_telemetry_decode.c:730: unit_test_telemetry 155s RDUT: INFO: rdkafka_telemetry_decode.c:623: unit_test_telemetry: metrics_payload_size: 267 155s RDUT: PASS: rdkafka_telemetry_decode.c:730: unit_test_telemetry 155s RDUT: INFO: rdkafka_telemetry_decode.c:623: unit_test_telemetry: metrics_payload_size: 250 155s RDUT: PASS: rdkafka_telemetry_decode.c:730: unit_test_telemetry 155s RDUT: INFO: rdkafka_telemetry_decode.c:623: unit_test_telemetry: metrics_payload_size: 274 155s RDUT: PASS: rdkafka_telemetry_decode.c:730: unit_test_telemetry 155s RDUT: INFO: rdkafka_telemetry_decode.c:623: unit_test_telemetry: metrics_payload_size: 274 155s RDUT: PASS: rdkafka_telemetry_decode.c:730: unit_test_telemetry 155s RDUT: INFO: rdkafka_telemetry_decode.c:623: unit_test_telemetry: metrics_payload_size: 218 155s RDUT: PASS: rdkafka_telemetry_decode.c:730: unit_test_telemetry 155s RDUT: INFO: rdkafka_telemetry_decode.c:623: unit_test_telemetry: metrics_payload_size: 255 155s RDUT: PASS: rdkafka_telemetry_decode.c:730: unit_test_telemetry 155s RDUT: INFO: rdkafka_telemetry_decode.c:623: unit_test_telemetry: metrics_payload_size: 255 155s RDUT: PASS: rdkafka_telemetry_decode.c:730: unit_test_telemetry 155s RDUT: INFO: rdkafka_telemetry_decode.c:623: unit_test_telemetry: metrics_payload_size: 284 155s RDUT: PASS: rdkafka_telemetry_decode.c:730: unit_test_telemetry 155s RDUT: INFO: rdunittest.c:521: rd_unittest: unittest: telemetry_decode: PASS 155s RDUT: PASS: rdkafka_feature.c:882: rd_ut_features_check 155s RDUT: INFO: rdunittest.c:521: rd_unittest: unittest: feature: PASS 155s autopkgtest [12:41:19]: test unittest: -----------------------] 156s autopkgtest [12:41:20]: test unittest: - - - - - - - - - - results - - - - - - - - - - 156s unittest PASS 156s autopkgtest [12:41:20]: @@@@@@@@@@@@@@@@@@@@ summary 156s examples PASS 156s unittest PASS