Diff of the two buildlogs: -- --- b1/build.log 2023-04-22 07:16:59.821802858 +0000 +++ b2/build.log 2023-04-22 07:22:49.026316804 +0000 @@ -1,6 +1,7 @@ +W: cgroups are not available on the host, not using them. I: pbuilder: network access will be disabled during build -I: Current time: Fri May 24 01:38:57 -12 2024 -I: pbuilder-time-stamp: 1716557937 +I: Current time: Sat Apr 22 21:19:01 +14 2023 +I: pbuilder-time-stamp: 1682147941 I: Building the build Environment I: extracting base tarball [/var/cache/pbuilder/bookworm-reproducible-base.tgz] I: copying local configuration @@ -17,7 +18,7 @@ I: copying [./golang-github-grpc-ecosystem-go-grpc-middleware_1.3.0.orig.tar.gz] I: copying [./golang-github-grpc-ecosystem-go-grpc-middleware_1.3.0-1.debian.tar.xz] I: Extracting source -gpgv: Signature made Tue Nov 22 20:09:24 2022 -12 +gpgv: Signature made Wed Nov 23 22:09:24 2022 +14 gpgv: using EDDSA key 9185D4F57767AEEE6C55D41E7F44FA25EA5514CB gpgv: issuer "zhsj@debian.org" gpgv: Can't check signature: No public key @@ -27,137 +28,168 @@ dpkg-source: info: unpacking golang-github-grpc-ecosystem-go-grpc-middleware_1.3.0-1.debian.tar.xz I: Not using root during the build. I: Installing the build-deps -I: user script /srv/workspace/pbuilder/72054/tmp/hooks/D02_print_environment starting +I: user script /srv/workspace/pbuilder/4192/tmp/hooks/D01_modify_environment starting +debug: Running on ionos12-i386. +I: Changing host+domainname to test build reproducibility +I: Adding a custom variable just for the fun of it... +I: Changing /bin/sh to bash +'/bin/sh' -> '/bin/bash' +lrwxrwxrwx 1 root root 9 Apr 22 21:19 /bin/sh -> /bin/bash +I: Setting pbuilder2's login shell to /bin/bash +I: Setting pbuilder2's GECOS to second user,second room,second work-phone,second home-phone,second other +I: user script /srv/workspace/pbuilder/4192/tmp/hooks/D01_modify_environment finished +I: user script /srv/workspace/pbuilder/4192/tmp/hooks/D02_print_environment starting I: set - BUILDDIR='/build' - BUILDUSERGECOS='first user,first room,first work-phone,first home-phone,first other' - BUILDUSERNAME='pbuilder1' - BUILD_ARCH='i386' - DEBIAN_FRONTEND='noninteractive' - DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all parallel=16' - DISTRIBUTION='bookworm' - HOME='/root' - HOST_ARCH='i386' + BASH=/bin/sh + BASHOPTS=checkwinsize:cmdhist:complete_fullquote:extquote:force_fignore:globasciiranges:globskipdots:hostcomplete:interactive_comments:patsub_replacement:progcomp:promptvars:sourcepath + BASH_ALIASES=() + BASH_ARGC=() + BASH_ARGV=() + BASH_CMDS=() + BASH_LINENO=([0]="12" [1]="0") + BASH_LOADABLES_PATH=/usr/local/lib/bash:/usr/lib/bash:/opt/local/lib/bash:/usr/pkg/lib/bash:/opt/pkg/lib/bash:. + BASH_SOURCE=([0]="/tmp/hooks/D02_print_environment" [1]="/tmp/hooks/D02_print_environment") + BASH_VERSINFO=([0]="5" [1]="2" [2]="15" [3]="1" [4]="release" [5]="i686-pc-linux-gnu") + BASH_VERSION='5.2.15(1)-release' + BUILDDIR=/build + BUILDUSERGECOS='second user,second room,second work-phone,second home-phone,second other' + BUILDUSERNAME=pbuilder2 + BUILD_ARCH=i386 + DEBIAN_FRONTEND=noninteractive + DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all parallel=7' + DIRSTACK=() + DISTRIBUTION=bookworm + EUID=0 + FUNCNAME=([0]="Echo" [1]="main") + GROUPS=() + HOME=/root + HOSTNAME=i-capture-the-hostname + HOSTTYPE=i686 + HOST_ARCH=i386 IFS=' ' - INVOCATION_ID='175c36962e194cb6a4039e361b21b9e8' - LANG='C' - LANGUAGE='en_US:en' - LC_ALL='C' - LD_LIBRARY_PATH='/usr/lib/libeatmydata' - LD_PRELOAD='libeatmydata.so' - MAIL='/var/mail/root' - OPTIND='1' - PATH='/usr/sbin:/usr/bin:/sbin:/bin:/usr/games' - PBCURRENTCOMMANDLINEOPERATION='build' - PBUILDER_OPERATION='build' - PBUILDER_PKGDATADIR='/usr/share/pbuilder' - PBUILDER_PKGLIBDIR='/usr/lib/pbuilder' - PBUILDER_SYSCONFDIR='/etc' - PPID='72054' - PS1='# ' - PS2='> ' + LANG=C + LANGUAGE=de_CH:de + LC_ALL=C + LD_LIBRARY_PATH=/usr/lib/libeatmydata + LD_PRELOAD=libeatmydata.so + MACHTYPE=i686-pc-linux-gnu + MAIL=/var/mail/root + OPTERR=1 + OPTIND=1 + OSTYPE=linux-gnu + PATH=/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/i/capture/the/path + PBCURRENTCOMMANDLINEOPERATION=build + PBUILDER_OPERATION=build + PBUILDER_PKGDATADIR=/usr/share/pbuilder + PBUILDER_PKGLIBDIR=/usr/lib/pbuilder + PBUILDER_SYSCONFDIR=/etc + PIPESTATUS=([0]="0") + POSIXLY_CORRECT=y + PPID=4192 PS4='+ ' - PWD='/' - SHELL='/bin/bash' - SHLVL='2' - SUDO_COMMAND='/usr/bin/timeout -k 18.1h 18h /usr/bin/ionice -c 3 /usr/bin/nice /usr/sbin/pbuilder --build --configfile /srv/reproducible-results/rbuild-debian/r-b-build.nseErXrQ/pbuilderrc_8DSB --distribution bookworm --hookdir /etc/pbuilder/first-build-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/bookworm-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/r-b-build.nseErXrQ/b1 --logfile b1/build.log golang-github-grpc-ecosystem-go-grpc-middleware_1.3.0-1.dsc' - SUDO_GID='112' - SUDO_UID='107' - SUDO_USER='jenkins' - TERM='unknown' - TZ='/usr/share/zoneinfo/Etc/GMT+12' - USER='root' - _='/usr/bin/systemd-run' - http_proxy='http://85.184.249.68:3128' + PWD=/ + SHELL=/bin/bash + SHELLOPTS=braceexpand:errexit:hashall:interactive-comments:posix + SHLVL=3 + SUDO_COMMAND='/usr/bin/timeout -k 24.1h 24h /usr/bin/ionice -c 3 /usr/bin/nice -n 11 /usr/bin/unshare --uts -- /usr/sbin/pbuilder --build --configfile /srv/reproducible-results/rbuild-debian/r-b-build.nseErXrQ/pbuilderrc_L9Au --distribution bookworm --hookdir /etc/pbuilder/rebuild-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/bookworm-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/r-b-build.nseErXrQ/b2 --logfile b2/build.log --extrapackages usrmerge golang-github-grpc-ecosystem-go-grpc-middleware_1.3.0-1.dsc' + SUDO_GID=112 + SUDO_UID=107 + SUDO_USER=jenkins + TERM=unknown + TZ=/usr/share/zoneinfo/Etc/GMT-14 + UID=0 + USER=root + _='I: set' + http_proxy=http://78.137.99.97:3128 I: uname -a - Linux ionos16-i386 5.10.0-21-amd64 #1 SMP Debian 5.10.162-1 (2023-01-21) x86_64 GNU/Linux + Linux i-capture-the-hostname 5.10.0-21-686-pae #1 SMP Debian 5.10.162-1 (2023-01-21) i686 GNU/Linux I: ls -l /bin total 6036 - -rwxr-xr-x 1 root root 1408088 Feb 12 2023 bash - -rwxr-xr-x 3 root root 38404 Sep 18 2022 bunzip2 - -rwxr-xr-x 3 root root 38404 Sep 18 2022 bzcat - lrwxrwxrwx 1 root root 6 Sep 18 2022 bzcmp -> bzdiff - -rwxr-xr-x 1 root root 2225 Sep 18 2022 bzdiff - lrwxrwxrwx 1 root root 6 Sep 18 2022 bzegrep -> bzgrep - -rwxr-xr-x 1 root root 4893 Nov 27 2021 bzexe - lrwxrwxrwx 1 root root 6 Sep 18 2022 bzfgrep -> bzgrep - -rwxr-xr-x 1 root root 3775 Sep 18 2022 bzgrep - -rwxr-xr-x 3 root root 38404 Sep 18 2022 bzip2 - -rwxr-xr-x 1 root root 17892 Sep 18 2022 bzip2recover - lrwxrwxrwx 1 root root 6 Sep 18 2022 bzless -> bzmore - -rwxr-xr-x 1 root root 1297 Sep 18 2022 bzmore - -rwxr-xr-x 1 root root 42920 Sep 20 2022 cat - -rwxr-xr-x 1 root root 79816 Sep 20 2022 chgrp - -rwxr-xr-x 1 root root 67496 Sep 20 2022 chmod - -rwxr-xr-x 1 root root 79816 Sep 20 2022 chown - -rwxr-xr-x 1 root root 162024 Sep 20 2022 cp - -rwxr-xr-x 1 root root 136916 Jan 5 2023 dash - -rwxr-xr-x 1 root root 137160 Sep 20 2022 date - -rwxr-xr-x 1 root root 100364 Sep 20 2022 dd - -rwxr-xr-x 1 root root 108940 Sep 20 2022 df - -rwxr-xr-x 1 root root 162152 Sep 20 2022 dir - -rwxr-xr-x 1 root root 87760 Mar 22 2023 dmesg - lrwxrwxrwx 1 root root 8 Dec 19 2022 dnsdomainname -> hostname - lrwxrwxrwx 1 root root 8 Dec 19 2022 domainname -> hostname - -rwxr-xr-x 1 root root 38760 Sep 20 2022 echo - -rwxr-xr-x 1 root root 41 Jan 24 2023 egrep - -rwxr-xr-x 1 root root 34664 Sep 20 2022 false - -rwxr-xr-x 1 root root 41 Jan 24 2023 fgrep - -rwxr-xr-x 1 root root 84272 Mar 22 2023 findmnt - -rwsr-xr-x 1 root root 30240 Mar 22 2023 fusermount - -rwxr-xr-x 1 root root 218680 Jan 24 2023 grep - -rwxr-xr-x 2 root root 2346 Apr 9 2022 gunzip - -rwxr-xr-x 1 root root 6447 Apr 9 2022 gzexe - -rwxr-xr-x 1 root root 100952 Apr 9 2022 gzip - -rwxr-xr-x 1 root root 21916 Dec 19 2022 hostname - -rwxr-xr-x 1 root root 75756 Sep 20 2022 ln - -rwxr-xr-x 1 root root 55600 Mar 22 2023 login - -rwxr-xr-x 1 root root 162152 Sep 20 2022 ls - -rwxr-xr-x 1 root root 214568 Mar 22 2023 lsblk - -rwxr-xr-x 1 root root 96328 Sep 20 2022 mkdir - -rwxr-xr-x 1 root root 84008 Sep 20 2022 mknod - -rwxr-xr-x 1 root root 38792 Sep 20 2022 mktemp - -rwxr-xr-x 1 root root 63016 Mar 22 2023 more - -rwsr-xr-x 1 root root 58912 Mar 22 2023 mount - -rwxr-xr-x 1 root root 13856 Mar 22 2023 mountpoint - -rwxr-xr-x 1 root root 157932 Sep 20 2022 mv - lrwxrwxrwx 1 root root 8 Dec 19 2022 nisdomainname -> hostname - lrwxrwxrwx 1 root root 14 Apr 2 2023 pidof -> /sbin/killall5 - -rwxr-xr-x 1 root root 38792 Sep 20 2022 pwd - lrwxrwxrwx 1 root root 4 Feb 12 2023 rbash -> bash - -rwxr-xr-x 1 root root 51080 Sep 20 2022 readlink - -rwxr-xr-x 1 root root 75720 Sep 20 2022 rm - -rwxr-xr-x 1 root root 51080 Sep 20 2022 rmdir - -rwxr-xr-x 1 root root 22308 Nov 2 2022 run-parts - -rwxr-xr-x 1 root root 133224 Jan 5 2023 sed - lrwxrwxrwx 1 root root 4 Jan 5 2023 sh -> dash - -rwxr-xr-x 1 root root 38760 Sep 20 2022 sleep - -rwxr-xr-x 1 root root 87976 Sep 20 2022 stty - -rwsr-xr-x 1 root root 83492 Mar 22 2023 su - -rwxr-xr-x 1 root root 38792 Sep 20 2022 sync - -rwxr-xr-x 1 root root 598456 Apr 6 2023 tar - -rwxr-xr-x 1 root root 13860 Nov 2 2022 tempfile - -rwxr-xr-x 1 root root 120776 Sep 20 2022 touch - -rwxr-xr-x 1 root root 34664 Sep 20 2022 true - -rwxr-xr-x 1 root root 17892 Mar 22 2023 ulockmgr_server - -rwsr-xr-x 1 root root 30236 Mar 22 2023 umount - -rwxr-xr-x 1 root root 38760 Sep 20 2022 uname - -rwxr-xr-x 2 root root 2346 Apr 9 2022 uncompress - -rwxr-xr-x 1 root root 162152 Sep 20 2022 vdir - -rwxr-xr-x 1 root root 71216 Mar 22 2023 wdctl - lrwxrwxrwx 1 root root 8 Dec 19 2022 ypdomainname -> hostname - -rwxr-xr-x 1 root root 1984 Apr 9 2022 zcat - -rwxr-xr-x 1 root root 1678 Apr 9 2022 zcmp - -rwxr-xr-x 1 root root 6460 Apr 9 2022 zdiff - -rwxr-xr-x 1 root root 29 Apr 9 2022 zegrep - -rwxr-xr-x 1 root root 29 Apr 9 2022 zfgrep - -rwxr-xr-x 1 root root 2081 Apr 9 2022 zforce - -rwxr-xr-x 1 root root 8103 Apr 9 2022 zgrep - -rwxr-xr-x 1 root root 2206 Apr 9 2022 zless - -rwxr-xr-x 1 root root 1842 Apr 9 2022 zmore - -rwxr-xr-x 1 root root 4577 Apr 9 2022 znew -I: user script /srv/workspace/pbuilder/72054/tmp/hooks/D02_print_environment finished + -rwxr-xr-x 1 root root 1408088 Feb 13 10:21 bash + -rwxr-xr-x 3 root root 38404 Sep 19 2022 bunzip2 + -rwxr-xr-x 3 root root 38404 Sep 19 2022 bzcat + lrwxrwxrwx 1 root root 6 Sep 19 2022 bzcmp -> bzdiff + -rwxr-xr-x 1 root root 2225 Sep 19 2022 bzdiff + lrwxrwxrwx 1 root root 6 Sep 19 2022 bzegrep -> bzgrep + -rwxr-xr-x 1 root root 4893 Nov 28 2021 bzexe + lrwxrwxrwx 1 root root 6 Sep 19 2022 bzfgrep -> bzgrep + -rwxr-xr-x 1 root root 3775 Sep 19 2022 bzgrep + -rwxr-xr-x 3 root root 38404 Sep 19 2022 bzip2 + -rwxr-xr-x 1 root root 17892 Sep 19 2022 bzip2recover + lrwxrwxrwx 1 root root 6 Sep 19 2022 bzless -> bzmore + -rwxr-xr-x 1 root root 1297 Sep 19 2022 bzmore + -rwxr-xr-x 1 root root 42920 Sep 21 2022 cat + -rwxr-xr-x 1 root root 79816 Sep 21 2022 chgrp + -rwxr-xr-x 1 root root 67496 Sep 21 2022 chmod + -rwxr-xr-x 1 root root 79816 Sep 21 2022 chown + -rwxr-xr-x 1 root root 162024 Sep 21 2022 cp + -rwxr-xr-x 1 root root 136916 Jan 6 03:20 dash + -rwxr-xr-x 1 root root 137160 Sep 21 2022 date + -rwxr-xr-x 1 root root 100364 Sep 21 2022 dd + -rwxr-xr-x 1 root root 108940 Sep 21 2022 df + -rwxr-xr-x 1 root root 162152 Sep 21 2022 dir + -rwxr-xr-x 1 root root 87760 Mar 24 00:20 dmesg + lrwxrwxrwx 1 root root 8 Dec 20 03:33 dnsdomainname -> hostname + lrwxrwxrwx 1 root root 8 Dec 20 03:33 domainname -> hostname + -rwxr-xr-x 1 root root 38760 Sep 21 2022 echo + -rwxr-xr-x 1 root root 41 Jan 25 04:43 egrep + -rwxr-xr-x 1 root root 34664 Sep 21 2022 false + -rwxr-xr-x 1 root root 41 Jan 25 04:43 fgrep + -rwxr-xr-x 1 root root 84272 Mar 24 00:20 findmnt + -rwsr-xr-x 1 root root 30240 Mar 23 22:38 fusermount + -rwxr-xr-x 1 root root 218680 Jan 25 04:43 grep + -rwxr-xr-x 2 root root 2346 Apr 10 2022 gunzip + -rwxr-xr-x 1 root root 6447 Apr 10 2022 gzexe + -rwxr-xr-x 1 root root 100952 Apr 10 2022 gzip + -rwxr-xr-x 1 root root 21916 Dec 20 03:33 hostname + -rwxr-xr-x 1 root root 75756 Sep 21 2022 ln + -rwxr-xr-x 1 root root 55600 Mar 24 01:43 login + -rwxr-xr-x 1 root root 162152 Sep 21 2022 ls + -rwxr-xr-x 1 root root 214568 Mar 24 00:20 lsblk + -rwxr-xr-x 1 root root 96328 Sep 21 2022 mkdir + -rwxr-xr-x 1 root root 84008 Sep 21 2022 mknod + -rwxr-xr-x 1 root root 38792 Sep 21 2022 mktemp + -rwxr-xr-x 1 root root 63016 Mar 24 00:20 more + -rwsr-xr-x 1 root root 58912 Mar 24 00:20 mount + -rwxr-xr-x 1 root root 13856 Mar 24 00:20 mountpoint + -rwxr-xr-x 1 root root 157932 Sep 21 2022 mv + lrwxrwxrwx 1 root root 8 Dec 20 03:33 nisdomainname -> hostname + lrwxrwxrwx 1 root root 14 Apr 3 20:25 pidof -> /sbin/killall5 + -rwxr-xr-x 1 root root 38792 Sep 21 2022 pwd + lrwxrwxrwx 1 root root 4 Feb 13 10:21 rbash -> bash + -rwxr-xr-x 1 root root 51080 Sep 21 2022 readlink + -rwxr-xr-x 1 root root 75720 Sep 21 2022 rm + -rwxr-xr-x 1 root root 51080 Sep 21 2022 rmdir + -rwxr-xr-x 1 root root 22308 Nov 3 06:31 run-parts + -rwxr-xr-x 1 root root 133224 Jan 6 09:55 sed + lrwxrwxrwx 1 root root 9 Apr 22 21:19 sh -> /bin/bash + -rwxr-xr-x 1 root root 38760 Sep 21 2022 sleep + -rwxr-xr-x 1 root root 87976 Sep 21 2022 stty + -rwsr-xr-x 1 root root 83492 Mar 24 00:20 su + -rwxr-xr-x 1 root root 38792 Sep 21 2022 sync + -rwxr-xr-x 1 root root 598456 Apr 7 04:25 tar + -rwxr-xr-x 1 root root 13860 Nov 3 06:31 tempfile + -rwxr-xr-x 1 root root 120776 Sep 21 2022 touch + -rwxr-xr-x 1 root root 34664 Sep 21 2022 true + -rwxr-xr-x 1 root root 17892 Mar 23 22:38 ulockmgr_server + -rwsr-xr-x 1 root root 30236 Mar 24 00:20 umount + -rwxr-xr-x 1 root root 38760 Sep 21 2022 uname + -rwxr-xr-x 2 root root 2346 Apr 10 2022 uncompress + -rwxr-xr-x 1 root root 162152 Sep 21 2022 vdir + -rwxr-xr-x 1 root root 71216 Mar 24 00:20 wdctl + lrwxrwxrwx 1 root root 8 Dec 20 03:33 ypdomainname -> hostname + -rwxr-xr-x 1 root root 1984 Apr 10 2022 zcat + -rwxr-xr-x 1 root root 1678 Apr 10 2022 zcmp + -rwxr-xr-x 1 root root 6460 Apr 10 2022 zdiff + -rwxr-xr-x 1 root root 29 Apr 10 2022 zegrep + -rwxr-xr-x 1 root root 29 Apr 10 2022 zfgrep + -rwxr-xr-x 1 root root 2081 Apr 10 2022 zforce + -rwxr-xr-x 1 root root 8103 Apr 10 2022 zgrep + -rwxr-xr-x 1 root root 2206 Apr 10 2022 zless + -rwxr-xr-x 1 root root 1842 Apr 10 2022 zmore + -rwxr-xr-x 1 root root 4577 Apr 10 2022 znew +I: user script /srv/workspace/pbuilder/4192/tmp/hooks/D02_print_environment finished -> Attempting to satisfy build-dependencies -> Creating pbuilder-satisfydepends-dummy package Package: pbuilder-satisfydepends-dummy @@ -327,7 +359,7 @@ Get: 108 http://deb.debian.org/debian bookworm/main i386 golang-golang-x-tools-dev all 1:0.5.0+ds-1 [1469 kB] Get: 109 http://deb.debian.org/debian bookworm/main i386 golang-github-go-kit-kit-dev all 0.10.0-1 [146 kB] Get: 110 http://deb.debian.org/debian bookworm/main i386 golang-github-gogo-protobuf-dev all 1.3.2-3 [849 kB] -Fetched 155 MB in 2s (85.4 MB/s) +Fetched 155 MB in 4s (40.6 MB/s) debconf: delaying package configuration, since apt-utils is not installed Selecting previously unselected package golang-golang-x-sys-dev. (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 ... 19604 files and directories currently installed.) @@ -781,8 +813,19 @@ Writing extended state information... Building tag database... -> Finished parsing the build-deps +Reading package lists... +Building dependency tree... +Reading state information... +usrmerge is already the newest version (35). +0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. I: Building the package -I: Running cd /build/golang-github-grpc-ecosystem-go-grpc-middleware-1.3.0/ && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games" HOME="/nonexistent/first-build" dpkg-buildpackage -us -uc -b && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games" HOME="/nonexistent/first-build" dpkg-genchanges -S > ../golang-github-grpc-ecosystem-go-grpc-middleware_1.3.0-1_source.changes +I: user script /srv/workspace/pbuilder/4192/tmp/hooks/A99_set_merged_usr starting +Re-configuring usrmerge... +removed '/etc/unsupported-skip-usrmerge-conversion' +The system has been successfully converted. +I: user script /srv/workspace/pbuilder/4192/tmp/hooks/A99_set_merged_usr finished +hostname: Name or service not known +I: Running cd /build/golang-github-grpc-ecosystem-go-grpc-middleware-1.3.0/ && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/i/capture/the/path" HOME="/nonexistent/second-build" dpkg-buildpackage -us -uc -b && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/i/capture/the/path" HOME="/nonexistent/second-build" dpkg-genchanges -S > ../golang-github-grpc-ecosystem-go-grpc-middleware_1.3.0-1_source.changes dpkg-buildpackage: info: source package golang-github-grpc-ecosystem-go-grpc-middleware dpkg-buildpackage: info: source version 1.3.0-1 dpkg-buildpackage: info: source distribution unstable @@ -800,228 +843,228 @@ dh_autoreconf -O--buildsystem=golang dh_auto_configure -O--buildsystem=golang dh_auto_build -O--buildsystem=golang - cd obj-i686-linux-gnu && go install -trimpath -v -p 16 github.com/grpc-ecosystem/go-grpc-middleware github.com/grpc-ecosystem/go-grpc-middleware/auth github.com/grpc-ecosystem/go-grpc-middleware/logging github.com/grpc-ecosystem/go-grpc-middleware/logging/kit github.com/grpc-ecosystem/go-grpc-middleware/logging/kit/ctxkit github.com/grpc-ecosystem/go-grpc-middleware/logging/logrus github.com/grpc-ecosystem/go-grpc-middleware/logging/logrus/ctxlogrus github.com/grpc-ecosystem/go-grpc-middleware/logging/settable github.com/grpc-ecosystem/go-grpc-middleware/logging/zap github.com/grpc-ecosystem/go-grpc-middleware/logging/zap/ctxzap github.com/grpc-ecosystem/go-grpc-middleware/ratelimit github.com/grpc-ecosystem/go-grpc-middleware/recovery github.com/grpc-ecosystem/go-grpc-middleware/retry github.com/grpc-ecosystem/go-grpc-middleware/tags github.com/grpc-ecosystem/go-grpc-middleware/tags/logrus github.com/grpc-ecosystem/go-grpc-middleware/tags/zap github.com/grpc-ecosystem/go-grpc-middleware/testing github.com/grpc-ecosystem/go-grpc-middleware/testing/gogotestproto github.com/grpc-ecosystem/go-grpc-middleware/testing/testproto github.com/grpc-ecosystem/go-grpc-middleware/tracing/opentracing github.com/grpc-ecosystem/go-grpc-middleware/util/backoffutils github.com/grpc-ecosystem/go-grpc-middleware/util/metautils github.com/grpc-ecosystem/go-grpc-middleware/validator -internal/unsafeheader + cd obj-i686-linux-gnu && go install -trimpath -v -p 7 github.com/grpc-ecosystem/go-grpc-middleware github.com/grpc-ecosystem/go-grpc-middleware/auth github.com/grpc-ecosystem/go-grpc-middleware/logging github.com/grpc-ecosystem/go-grpc-middleware/logging/kit github.com/grpc-ecosystem/go-grpc-middleware/logging/kit/ctxkit github.com/grpc-ecosystem/go-grpc-middleware/logging/logrus github.com/grpc-ecosystem/go-grpc-middleware/logging/logrus/ctxlogrus github.com/grpc-ecosystem/go-grpc-middleware/logging/settable github.com/grpc-ecosystem/go-grpc-middleware/logging/zap github.com/grpc-ecosystem/go-grpc-middleware/logging/zap/ctxzap github.com/grpc-ecosystem/go-grpc-middleware/ratelimit github.com/grpc-ecosystem/go-grpc-middleware/recovery github.com/grpc-ecosystem/go-grpc-middleware/retry github.com/grpc-ecosystem/go-grpc-middleware/tags github.com/grpc-ecosystem/go-grpc-middleware/tags/logrus github.com/grpc-ecosystem/go-grpc-middleware/tags/zap github.com/grpc-ecosystem/go-grpc-middleware/testing github.com/grpc-ecosystem/go-grpc-middleware/testing/gogotestproto github.com/grpc-ecosystem/go-grpc-middleware/testing/testproto github.com/grpc-ecosystem/go-grpc-middleware/tracing/opentracing github.com/grpc-ecosystem/go-grpc-middleware/util/backoffutils github.com/grpc-ecosystem/go-grpc-middleware/util/metautils github.com/grpc-ecosystem/go-grpc-middleware/validator internal/goarch -internal/race -internal/itoa +internal/unsafeheader internal/goexperiment internal/goos -encoding -unicode/utf8 -math/bits -internal/nettrace -sync/atomic -container/list runtime/internal/atomic -unicode/utf16 internal/cpu -internal/abi -unicode runtime/internal/syscall +internal/abi runtime/internal/math runtime/internal/sys +internal/race +sync/atomic +internal/itoa +unicode +unicode/utf8 +math/bits +encoding +unicode/utf16 +internal/bytealg +internal/nettrace +container/list crypto/internal/subtle crypto/subtle crypto/internal/boring/sig vendor/golang.org/x/crypto/cryptobyte/asn1 +math vendor/golang.org/x/crypto/internal/subtle google.golang.org/grpc/serviceconfig -math -internal/bytealg runtime internal/reflectlite sync +internal/testlog internal/singleflight google.golang.org/grpc/internal/buffer -internal/testlog google.golang.org/grpc/internal/grpcsync -internal/sysinfo math/rand runtime/cgo +internal/sysinfo errors sort internal/oserror internal/safefilepath io path -vendor/golang.org/x/net/dns/dnsmessage strconv -crypto/internal/nistec/fiat syscall -hash -crypto/internal/randutil +vendor/golang.org/x/net/dns/dnsmessage +crypto/internal/nistec/fiat bytes strings -text/tabwriter +reflect +hash hash/crc32 -golang.org/x/text/transform -vendor/golang.org/x/text/transform +bufio +html crypto +crypto/internal/randutil crypto/rc4 -reflect -html +vendor/golang.org/x/text/transform net/http/internal/ascii +text/tabwriter +time +internal/syscall/unix +internal/syscall/execenv google.golang.org/grpc/encoding -net/http/internal/testcert -bufio regexp/syntax -internal/syscall/execenv -internal/syscall/unix -time -regexp +golang.org/x/text/transform +net/http/internal/testcert +crypto/internal/nistec context google.golang.org/grpc/backoff io/fs +internal/poll google.golang.org/grpc/internal/grpcrand -github.com/grpc-ecosystem/go-grpc-middleware/util/backoffutils +regexp +google.golang.org/grpc/internal/backoff google.golang.org/grpc/keepalive -internal/poll go.uber.org/zap/buffer -google.golang.org/grpc/internal/backoff -crypto/internal/nistec -go.uber.org/zap/internal/bufferpool google.golang.org/grpc/tap -os +github.com/grpc-ecosystem/go-grpc-middleware/util/backoffutils +go.uber.org/zap/internal/bufferpool internal/fmtsort encoding/binary +os encoding/base64 crypto/md5 -crypto/internal/edwards25519/field vendor/golang.org/x/crypto/internal/poly1305 -vendor/golang.org/x/crypto/curve25519/internal/field +crypto/internal/edwards25519/field crypto/cipher -golang.org/x/sys/unix +vendor/golang.org/x/crypto/curve25519/internal/field encoding/pem +golang.org/x/sys/unix crypto/internal/edwards25519 -vendor/golang.org/x/crypto/chacha20 crypto/internal/boring crypto/des -internal/godebug -google.golang.org/grpc/internal/envconfig -go.uber.org/zap/internal/exit -fmt -io/ioutil -path/filepath -crypto/aes +vendor/golang.org/x/crypto/chacha20 crypto/sha512 +crypto/aes crypto/hmac -internal/intern crypto/sha1 crypto/sha256 +vendor/golang.org/x/crypto/chacha20poly1305 +fmt +internal/godebug +path/filepath +internal/intern vendor/golang.org/x/crypto/hkdf net/netip -vendor/golang.org/x/crypto/chacha20poly1305 +io/ioutil +google.golang.org/grpc/internal/envconfig +go.uber.org/zap/internal/exit net +compress/flate +net/url log +text/template/parse +encoding/json +golang.org/x/net/internal/timeseries +math/big encoding/hex -net/url vendor/golang.org/x/crypto/curve25519 -net/http/internal -mime/quotedprintable +compress/gzip +vendor/golang.org/x/text/unicode/bidi +vendor/golang.org/x/text/unicode/norm vendor/golang.org/x/net/http2/hpack +text/template mime -compress/flate -text/template/parse +mime/quotedprintable +vendor/golang.org/x/text/secure/bidirule +net/http/internal google.golang.org/grpc/internal/grpclog -encoding/json -math/big -vendor/golang.org/x/text/unicode/norm +google.golang.org/grpc/grpclog +github.com/golang/protobuf/proto google.golang.org/grpc/attributes google.golang.org/grpc/metadata google.golang.org/grpc/codes -golang.org/x/net/http2/hpack -github.com/go-logfmt/logfmt -flag -google.golang.org/grpc/internal/balancerload -golang.org/x/net/internal/timeseries -golang.org/x/text/unicode/norm -vendor/golang.org/x/text/unicode/bidi -google.golang.org/grpc/grpclog -github.com/grpc-ecosystem/go-grpc-middleware/util/metautils -golang.org/x/text/unicode/bidi -go.uber.org/zap/internal/color -github.com/davecgh/go-spew/spew -github.com/pmezard/go-difflib/difflib -runtime/debug -gopkg.in/yaml.v3 -runtime/trace google.golang.org/grpc/connectivity -compress/gzip -github.com/grpc-ecosystem/go-grpc-middleware/logging/settable -google.golang.org/grpc/internal -testing -github.com/opentracing/opentracing-go/log -vendor/golang.org/x/text/secure/bidirule -github.com/go-kit/kit/log -go.uber.org/atomic -github.com/golang/protobuf/proto -github.com/gogo/protobuf/proto -text/template -golang.org/x/text/secure/bidirule -github.com/sirupsen/logrus -github.com/go-kit/kit/log/level -go.uber.org/multierr -go.uber.org/zap/zapcore -golang.org/x/net/idna +google.golang.org/grpc/internal/balancerload vendor/golang.org/x/net/idna +google.golang.org/grpc/internal +html/template +golang.org/x/text/unicode/bidi +golang.org/x/text/unicode/norm crypto/rand crypto/elliptic crypto/internal/boring/bbig encoding/asn1 -crypto/dsa crypto/ed25519 crypto/rsa -html/template +crypto/dsa +golang.org/x/text/secure/bidirule +golang.org/x/net/http2/hpack +github.com/grpc-ecosystem/go-grpc-middleware/util/metautils +golang.org/x/net/idna +github.com/go-logfmt/logfmt vendor/golang.org/x/crypto/cryptobyte crypto/x509/pkix -go.uber.org/zap/internal +github.com/sirupsen/logrus +github.com/grpc-ecosystem/go-grpc-middleware/logging/settable +github.com/go-kit/kit/log +flag crypto/ecdsa +github.com/go-kit/kit/log/level +go.uber.org/atomic +go.uber.org/zap/internal/color +github.com/davecgh/go-spew/spew +github.com/pmezard/go-difflib/difflib +gopkg.in/yaml.v3 google.golang.org/grpc/encoding/proto github.com/golang/protobuf/ptypes/any github.com/golang/protobuf/ptypes/duration github.com/golang/protobuf/ptypes/timestamp +google.golang.org/genproto/googleapis/rpc/status github.com/golang/protobuf/ptypes/struct -google.golang.org/grpc/binarylog/grpc_binarylog_v1 +go.uber.org/multierr github.com/golang/protobuf/ptypes -google.golang.org/genproto/googleapis/rpc/status -github.com/golang/protobuf/jsonpb +google.golang.org/grpc/binarylog/grpc_binarylog_v1 +go.uber.org/zap/zapcore google.golang.org/grpc/internal/status +github.com/golang/protobuf/jsonpb +runtime/debug google.golang.org/grpc/status +runtime/trace github.com/grpc-ecosystem/go-grpc-middleware/logging -google.golang.org/grpc/internal/syscall +crypto/x509 +net/textproto vendor/golang.org/x/net/http/httpproxy +google.golang.org/grpc/internal/syscall google.golang.org/grpc/stats -net/textproto -crypto/x509 -golang.org/x/net/http/httpguts +testing vendor/golang.org/x/net/http/httpguts mime/multipart -github.com/gogo/protobuf/protoc-gen-gogo/descriptor +golang.org/x/net/http/httpguts +github.com/gogo/protobuf/proto +github.com/opentracing/opentracing-go/log +go.uber.org/zap/internal crypto/tls -github.com/gogo/protobuf/gogoproto -github.com/grpc-ecosystem/go-grpc-middleware/testing/gogotestproto net/http/httptrace google.golang.org/grpc/internal/credentials google.golang.org/grpc/credentials net/http +github.com/gogo/protobuf/protoc-gen-gogo/descriptor google.golang.org/grpc/resolver -google.golang.org/grpc/peer google.golang.org/grpc/internal/channelz -google.golang.org/grpc/balancer/grpclb/state +google.golang.org/grpc/peer google.golang.org/grpc/balancer -google.golang.org/grpc/internal/resolver/passthrough google.golang.org/grpc/internal/grpcutil +google.golang.org/grpc/balancer/grpclb/state +google.golang.org/grpc/internal/resolver/passthrough google.golang.org/grpc/internal/resolver/dns google.golang.org/grpc/internal/binarylog google.golang.org/grpc/balancer/base google.golang.org/grpc/internal/serviceconfig google.golang.org/grpc/balancer/roundrobin +github.com/gogo/protobuf/gogoproto +github.com/grpc-ecosystem/go-grpc-middleware/testing/gogotestproto golang.org/x/net/trace net/http/httputil +go.uber.org/zap net/http/httptest github.com/opentracing/opentracing-go -go.uber.org/zap golang.org/x/net/http2 github.com/opentracing/opentracing-go/ext github.com/stretchr/testify/assert @@ -1029,26 +1072,26 @@ github.com/stretchr/testify/suite google.golang.org/grpc/internal/transport google.golang.org/grpc -github.com/grpc-ecosystem/go-grpc-middleware/ratelimit github.com/grpc-ecosystem/go-grpc-middleware github.com/grpc-ecosystem/go-grpc-middleware/recovery -github.com/grpc-ecosystem/go-grpc-middleware/retry +github.com/grpc-ecosystem/go-grpc-middleware/ratelimit github.com/grpc-ecosystem/go-grpc-middleware/validator github.com/grpc-ecosystem/go-grpc-middleware/testing/testproto +github.com/grpc-ecosystem/go-grpc-middleware/retry github.com/grpc-ecosystem/go-grpc-middleware/auth github.com/grpc-ecosystem/go-grpc-middleware/tags -github.com/grpc-ecosystem/go-grpc-middleware/logging/kit/ctxkit -github.com/grpc-ecosystem/go-grpc-middleware/logging/logrus/ctxlogrus +github.com/grpc-ecosystem/go-grpc-middleware/testing github.com/grpc-ecosystem/go-grpc-middleware/logging/zap/ctxzap +github.com/grpc-ecosystem/go-grpc-middleware/logging/logrus/ctxlogrus +github.com/grpc-ecosystem/go-grpc-middleware/logging/kit/ctxkit github.com/grpc-ecosystem/go-grpc-middleware/tracing/opentracing -github.com/grpc-ecosystem/go-grpc-middleware/testing github.com/grpc-ecosystem/go-grpc-middleware/logging/kit github.com/grpc-ecosystem/go-grpc-middleware/tags/zap github.com/grpc-ecosystem/go-grpc-middleware/logging/zap -github.com/grpc-ecosystem/go-grpc-middleware/tags/logrus github.com/grpc-ecosystem/go-grpc-middleware/logging/logrus +github.com/grpc-ecosystem/go-grpc-middleware/tags/logrus dh_auto_test -O--buildsystem=golang - cd obj-i686-linux-gnu && go test -vet=off -v -p 16 github.com/grpc-ecosystem/go-grpc-middleware github.com/grpc-ecosystem/go-grpc-middleware/auth github.com/grpc-ecosystem/go-grpc-middleware/logging github.com/grpc-ecosystem/go-grpc-middleware/logging/kit github.com/grpc-ecosystem/go-grpc-middleware/logging/kit/ctxkit github.com/grpc-ecosystem/go-grpc-middleware/logging/logrus github.com/grpc-ecosystem/go-grpc-middleware/logging/logrus/ctxlogrus github.com/grpc-ecosystem/go-grpc-middleware/logging/settable github.com/grpc-ecosystem/go-grpc-middleware/logging/zap github.com/grpc-ecosystem/go-grpc-middleware/logging/zap/ctxzap github.com/grpc-ecosystem/go-grpc-middleware/ratelimit github.com/grpc-ecosystem/go-grpc-middleware/recovery github.com/grpc-ecosystem/go-grpc-middleware/retry github.com/grpc-ecosystem/go-grpc-middleware/tags github.com/grpc-ecosystem/go-grpc-middleware/tags/logrus github.com/grpc-ecosystem/go-grpc-middleware/tags/zap github.com/grpc-ecosystem/go-grpc-middleware/testing github.com/grpc-ecosystem/go-grpc-middleware/testing/gogotestproto github.com/grpc-ecosystem/go-grpc-middleware/testing/testproto github.com/grpc-ecosystem/go-grpc-middleware/tracing/opentracing github.com/grpc-ecosystem/go-grpc-middleware/util/backoffutils github.com/grpc-ecosystem/go-grpc-middleware/util/metautils github.com/grpc-ecosystem/go-grpc-middleware/validator + cd obj-i686-linux-gnu && go test -vet=off -v -p 7 github.com/grpc-ecosystem/go-grpc-middleware github.com/grpc-ecosystem/go-grpc-middleware/auth github.com/grpc-ecosystem/go-grpc-middleware/logging github.com/grpc-ecosystem/go-grpc-middleware/logging/kit github.com/grpc-ecosystem/go-grpc-middleware/logging/kit/ctxkit github.com/grpc-ecosystem/go-grpc-middleware/logging/logrus github.com/grpc-ecosystem/go-grpc-middleware/logging/logrus/ctxlogrus github.com/grpc-ecosystem/go-grpc-middleware/logging/settable github.com/grpc-ecosystem/go-grpc-middleware/logging/zap github.com/grpc-ecosystem/go-grpc-middleware/logging/zap/ctxzap github.com/grpc-ecosystem/go-grpc-middleware/ratelimit github.com/grpc-ecosystem/go-grpc-middleware/recovery github.com/grpc-ecosystem/go-grpc-middleware/retry github.com/grpc-ecosystem/go-grpc-middleware/tags github.com/grpc-ecosystem/go-grpc-middleware/tags/logrus github.com/grpc-ecosystem/go-grpc-middleware/tags/zap github.com/grpc-ecosystem/go-grpc-middleware/testing github.com/grpc-ecosystem/go-grpc-middleware/testing/gogotestproto github.com/grpc-ecosystem/go-grpc-middleware/testing/testproto github.com/grpc-ecosystem/go-grpc-middleware/tracing/opentracing github.com/grpc-ecosystem/go-grpc-middleware/util/backoffutils github.com/grpc-ecosystem/go-grpc-middleware/util/metautils github.com/grpc-ecosystem/go-grpc-middleware/validator === RUN TestChainUnaryServer --- PASS: TestChainUnaryServer (0.00s) === RUN TestChainStreamServer @@ -1060,7 +1103,7 @@ === RUN TestWrapServerStream --- PASS: TestWrapServerStream (0.00s) PASS -ok github.com/grpc-ecosystem/go-grpc-middleware 0.006s +ok github.com/grpc-ecosystem/go-grpc-middleware 0.023s === RUN TestAuthFromMD --- PASS: TestAuthFromMD (0.00s) === RUN TestAuthTestSuite @@ -1073,43 +1116,43 @@ === RUN TestAuthTestSuite/TestUnary_PassesAuth === RUN TestAuthTestSuite/TestUnary_PassesWithPerRpcCredentials === CONT TestAuthTestSuite - interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:36149 ---- PASS: TestAuthTestSuite (1.42s) + interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:37541 +--- PASS: TestAuthTestSuite (1.09s) --- PASS: TestAuthTestSuite/TestStream_BadAuth (0.00s) --- PASS: TestAuthTestSuite/TestStream_NoAuth (0.00s) --- PASS: TestAuthTestSuite/TestStream_PassesAuth (0.00s) - --- PASS: TestAuthTestSuite/TestStream_PassesWithPerRpcCredentials (0.01s) + --- PASS: TestAuthTestSuite/TestStream_PassesWithPerRpcCredentials (0.03s) --- PASS: TestAuthTestSuite/TestUnary_BadAuth (0.00s) --- PASS: TestAuthTestSuite/TestUnary_NoAuth (0.00s) --- PASS: TestAuthTestSuite/TestUnary_PassesAuth (0.00s) - --- PASS: TestAuthTestSuite/TestUnary_PassesWithPerRpcCredentials (0.02s) + --- PASS: TestAuthTestSuite/TestUnary_PassesWithPerRpcCredentials (0.04s) === RUN TestAuthOverrideTestSuite === RUN TestAuthOverrideTestSuite/TestStream_PassesAuth === RUN TestAuthOverrideTestSuite/TestUnary_PassesAuth === CONT TestAuthOverrideTestSuite - interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:46043 ---- PASS: TestAuthOverrideTestSuite (1.57s) + interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:40449 +--- PASS: TestAuthOverrideTestSuite (1.77s) --- PASS: TestAuthOverrideTestSuite/TestStream_PassesAuth (0.00s) --- PASS: TestAuthOverrideTestSuite/TestUnary_PassesAuth (0.00s) PASS -ok github.com/grpc-ecosystem/go-grpc-middleware/auth 3.002s +ok github.com/grpc-ecosystem/go-grpc-middleware/auth 2.879s ? github.com/grpc-ecosystem/go-grpc-middleware/logging [no test files] === RUN TestKitClientSuite === RUN TestKitClientSuite/TestPing === RUN TestKitClientSuite/TestPingError_WithCustomLevels === RUN TestKitClientSuite/TestPingList === CONT TestKitClientSuite - interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:40345 ---- PASS: TestKitClientSuite (1.28s) - --- PASS: TestKitClientSuite/TestPing (0.00s) + interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:33781 +--- PASS: TestKitClientSuite (2.61s) + --- PASS: TestKitClientSuite/TestPing (0.01s) --- PASS: TestKitClientSuite/TestPingError_WithCustomLevels (0.00s) --- PASS: TestKitClientSuite/TestPingList (0.00s) === RUN TestKitClientOverrideSuite === RUN TestKitClientOverrideSuite/TestPingList_HasOverrides === RUN TestKitClientOverrideSuite/TestPing_HasOverrides === CONT TestKitClientOverrideSuite - interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:44513 ---- PASS: TestKitClientOverrideSuite (1.47s) + interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:40941 +--- PASS: TestKitClientOverrideSuite (1.70s) --- PASS: TestKitClientOverrideSuite/TestPingList_HasOverrides (0.00s) --- PASS: TestKitClientOverrideSuite/TestPing_HasOverrides (0.00s) === RUN TestKitPayloadSuite @@ -1118,8 +1161,8 @@ === RUN TestKitPayloadSuite/TestPing_LogsBothRequestAndResponse payload_interceptors_test.go:81: map[grpc.method:Ping grpc.request.content:{"value":"something","sleepTimeMs":9999} grpc.service:mwitkow.testproto.TestService level:info span.kind:client system:grpc] === CONT TestKitPayloadSuite - interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:43289 ---- PASS: TestKitPayloadSuite (0.96s) + interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:43277 +--- PASS: TestKitPayloadSuite (1.00s) --- PASS: TestKitPayloadSuite/TestPingError_LogsOnlyRequestsOnError (0.00s) --- PASS: TestKitPayloadSuite/TestPingStream_LogsAllRequestsAndResponses (0.00s) --- PASS: TestKitPayloadSuite/TestPing_LogsBothRequestAndResponse (0.00s) @@ -1128,13 +1171,13 @@ === RUN TestKitLoggingSuite/TestPingList_WithCustomTags === RUN TestKitLoggingSuite/TestPing_WithCustomTags === CONT TestKitLoggingSuite - interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:38251 + interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:41611 === RUN TestKitLoggingSuite/TestPingError_WithCustomLevels#01 === RUN TestKitLoggingSuite/TestPingList_WithCustomTags#01 === RUN TestKitLoggingSuite/TestPing_WithCustomTags#01 === CONT TestKitLoggingSuite - interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:44443 ---- PASS: TestKitLoggingSuite (2.73s) + interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:44659 +--- PASS: TestKitLoggingSuite (3.89s) --- PASS: TestKitLoggingSuite/TestPingError_WithCustomLevels (0.00s) --- PASS: TestKitLoggingSuite/TestPingList_WithCustomTags (0.00s) --- PASS: TestKitLoggingSuite/TestPing_WithCustomTags (0.00s) @@ -1145,8 +1188,8 @@ === RUN TestKitLoggingOverrideSuite/TestPingList_HasOverriddenDuration === RUN TestKitLoggingOverrideSuite/TestPing_HasOverriddenDuration === CONT TestKitLoggingOverrideSuite - interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:37089 ---- PASS: TestKitLoggingOverrideSuite (0.27s) + interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:41983 +--- PASS: TestKitLoggingOverrideSuite (1.11s) --- PASS: TestKitLoggingOverrideSuite/TestPingList_HasOverriddenDuration (0.00s) --- PASS: TestKitLoggingOverrideSuite/TestPing_HasOverriddenDuration (0.00s) === RUN TestKitServerOverrideSuppressedSuite @@ -1154,16 +1197,16 @@ === RUN TestKitServerOverrideSuppressedSuite/TestPingList_HasOverriddenDecider === RUN TestKitServerOverrideSuppressedSuite/TestPing_HasOverriddenDecider === CONT TestKitServerOverrideSuppressedSuite - interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:36881 ---- PASS: TestKitServerOverrideSuppressedSuite (1.27s) + interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:34341 +--- PASS: TestKitServerOverrideSuppressedSuite (1.17s) --- PASS: TestKitServerOverrideSuppressedSuite/TestPingError_HasOverriddenDecider (0.00s) --- PASS: TestKitServerOverrideSuppressedSuite/TestPingList_HasOverriddenDecider (0.00s) --- PASS: TestKitServerOverrideSuppressedSuite/TestPing_HasOverriddenDecider (0.00s) PASS -ok github.com/grpc-ecosystem/go-grpc-middleware/logging/kit 7.983s +ok github.com/grpc-ecosystem/go-grpc-middleware/logging/kit 11.490s testing: warning: no tests to run PASS -ok github.com/grpc-ecosystem/go-grpc-middleware/logging/kit/ctxkit 0.026s [no tests to run] +ok github.com/grpc-ecosystem/go-grpc-middleware/logging/kit/ctxkit 0.025s [no tests to run] === RUN Test_logrusGrpcLoggerV2_V === RUN Test_logrusGrpcLoggerV2_V/WarnLevel_setup_when_we_have_WarnLevel_msg_should_return_TRUE === RUN Test_logrusGrpcLoggerV2_V/WarnLevel_setup_when_we_have_ErrorLevel_msg_should_return_TRUE @@ -1187,47 +1230,47 @@ === RUN TestLogrusClientSuite/TestPingError_WithCustomLevels === RUN TestLogrusClientSuite/TestPingList === CONT TestLogrusClientSuite - interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:42615 ---- PASS: TestLogrusClientSuite (0.31s) + interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:32921 +--- PASS: TestLogrusClientSuite (1.37s) --- PASS: TestLogrusClientSuite/TestPing (0.00s) - --- PASS: TestLogrusClientSuite/TestPingError_WithCustomLevels (0.00s) + --- PASS: TestLogrusClientSuite/TestPingError_WithCustomLevels (0.01s) --- PASS: TestLogrusClientSuite/TestPingList (0.00s) === RUN TestLogrusClientOverrideSuite === RUN TestLogrusClientOverrideSuite/TestPingList_HasOverrides === RUN TestLogrusClientOverrideSuite/TestPing_HasOverrides === CONT TestLogrusClientOverrideSuite - interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:41837 ---- PASS: TestLogrusClientOverrideSuite (0.53s) + interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:40455 +--- PASS: TestLogrusClientOverrideSuite (2.42s) --- PASS: TestLogrusClientOverrideSuite/TestPingList_HasOverrides (0.00s) --- PASS: TestLogrusClientOverrideSuite/TestPing_HasOverrides (0.00s) === RUN TestZapLoggingClientMessageProducerSuite === RUN TestZapLoggingClientMessageProducerSuite/TestPing_HasOverriddenMessageProducer === CONT TestZapLoggingClientMessageProducerSuite - interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:35425 ---- PASS: TestZapLoggingClientMessageProducerSuite (1.50s) + interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:37879 +--- PASS: TestZapLoggingClientMessageProducerSuite (3.44s) --- PASS: TestZapLoggingClientMessageProducerSuite/TestPing_HasOverriddenMessageProducer (0.00s) === RUN TestLogrusPayloadSuite === RUN TestLogrusPayloadSuite/TestPingError_LogsOnlyRequestsOnError === RUN TestLogrusPayloadSuite/TestPingStream_LogsAllRequestsAndResponses === RUN TestLogrusPayloadSuite/TestPing_LogsBothRequestAndResponse === CONT TestLogrusPayloadSuite - interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:42005 ---- PASS: TestLogrusPayloadSuite (2.63s) + interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:45129 +--- PASS: TestLogrusPayloadSuite (4.20s) --- PASS: TestLogrusPayloadSuite/TestPingError_LogsOnlyRequestsOnError (0.00s) - --- PASS: TestLogrusPayloadSuite/TestPingStream_LogsAllRequestsAndResponses (0.00s) + --- PASS: TestLogrusPayloadSuite/TestPingStream_LogsAllRequestsAndResponses (0.01s) --- PASS: TestLogrusPayloadSuite/TestPing_LogsBothRequestAndResponse (0.00s) === RUN TestLogrusServerSuite === RUN TestLogrusServerSuite/TestPingError_WithCustomLevels === RUN TestLogrusServerSuite/TestPingList_WithCustomTags === RUN TestLogrusServerSuite/TestPing_WithCustomTags === CONT TestLogrusServerSuite - interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:42025 + interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:33525 === RUN TestLogrusServerSuite/TestPingError_WithCustomLevels#01 === RUN TestLogrusServerSuite/TestPingList_WithCustomTags#01 === RUN TestLogrusServerSuite/TestPing_WithCustomTags#01 === CONT TestLogrusServerSuite - interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:46881 ---- PASS: TestLogrusServerSuite (2.10s) + interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:38413 +--- PASS: TestLogrusServerSuite (3.54s) --- PASS: TestLogrusServerSuite/TestPingError_WithCustomLevels (0.00s) --- PASS: TestLogrusServerSuite/TestPingList_WithCustomTags (0.00s) --- PASS: TestLogrusServerSuite/TestPing_WithCustomTags (0.00s) @@ -1238,8 +1281,8 @@ === RUN TestLogrusServerOverrideSuite/TestPingList_HasOverriddenDuration === RUN TestLogrusServerOverrideSuite/TestPing_HasOverriddenDuration === CONT TestLogrusServerOverrideSuite - interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:45307 ---- PASS: TestLogrusServerOverrideSuite (0.63s) + interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:41375 +--- PASS: TestLogrusServerOverrideSuite (1.35s) --- PASS: TestLogrusServerOverrideSuite/TestPingList_HasOverriddenDuration (0.00s) --- PASS: TestLogrusServerOverrideSuite/TestPing_HasOverriddenDuration (0.00s) === RUN TestLogrusServerOverrideDeciderSuite @@ -1247,26 +1290,26 @@ === RUN TestLogrusServerOverrideDeciderSuite/TestPingList_HasOverriddenDecider === RUN TestLogrusServerOverrideDeciderSuite/TestPing_HasOverriddenDecider === CONT TestLogrusServerOverrideDeciderSuite - interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:38859 ---- PASS: TestLogrusServerOverrideDeciderSuite (0.62s) + interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:40745 +--- PASS: TestLogrusServerOverrideDeciderSuite (1.74s) --- PASS: TestLogrusServerOverrideDeciderSuite/TestPingError_HasOverriddenDecider (0.00s) --- PASS: TestLogrusServerOverrideDeciderSuite/TestPingList_HasOverriddenDecider (0.00s) --- PASS: TestLogrusServerOverrideDeciderSuite/TestPing_HasOverriddenDecider (0.00s) === RUN TestLogrusServerMessageProducerSuite === RUN TestLogrusServerMessageProducerSuite/TestPing_HasMessageProducer === CONT TestLogrusServerMessageProducerSuite - interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:33859 ---- PASS: TestLogrusServerMessageProducerSuite (0.76s) + interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:36209 +--- PASS: TestLogrusServerMessageProducerSuite (1.19s) --- PASS: TestLogrusServerMessageProducerSuite/TestPing_HasMessageProducer (0.00s) PASS -ok github.com/grpc-ecosystem/go-grpc-middleware/logging/logrus 9.086s +ok github.com/grpc-ecosystem/go-grpc-middleware/logging/logrus 19.269s testing: warning: no tests to run PASS -ok github.com/grpc-ecosystem/go-grpc-middleware/logging/logrus/ctxlogrus 0.014s [no tests to run] +ok github.com/grpc-ecosystem/go-grpc-middleware/logging/logrus/ctxlogrus 0.052s [no tests to run] === RUN TestSettableLoggerV2_init --- PASS: TestSettableLoggerV2_init (0.00s) PASS -ok github.com/grpc-ecosystem/go-grpc-middleware/logging/settable 0.003s +ok github.com/grpc-ecosystem/go-grpc-middleware/logging/settable 0.007s === RUN Test_zapGrpcLogger_V --- PASS: Test_zapGrpcLogger_V (0.00s) === RUN TestDurationToTimeMillisField @@ -1276,8 +1319,8 @@ === RUN TestZapClientSuite/TestPingError_WithCustomLevels === RUN TestZapClientSuite/TestPingList === CONT TestZapClientSuite - interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:41633 ---- PASS: TestZapClientSuite (1.59s) + interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:34235 +--- PASS: TestZapClientSuite (0.97s) --- PASS: TestZapClientSuite/TestPing (0.00s) --- PASS: TestZapClientSuite/TestPingError_WithCustomLevels (0.00s) --- PASS: TestZapClientSuite/TestPingList (0.00s) @@ -1285,24 +1328,24 @@ === RUN TestZapClientOverrideSuite/TestPingList_HasOverrides === RUN TestZapClientOverrideSuite/TestPing_HasOverrides === CONT TestZapClientOverrideSuite - interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:39007 ---- PASS: TestZapClientOverrideSuite (0.65s) + interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:40301 +--- PASS: TestZapClientOverrideSuite (5.70s) --- PASS: TestZapClientOverrideSuite/TestPingList_HasOverrides (0.00s) --- PASS: TestZapClientOverrideSuite/TestPing_HasOverrides (0.00s) === RUN TestZapLoggingClientMessageProducerSuite === RUN TestZapLoggingClientMessageProducerSuite/TestPing_HasOverriddenMessageProducer === CONT TestZapLoggingClientMessageProducerSuite - interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:40703 ---- PASS: TestZapLoggingClientMessageProducerSuite (1.04s) + interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:39497 +--- PASS: TestZapLoggingClientMessageProducerSuite (2.38s) --- PASS: TestZapLoggingClientMessageProducerSuite/TestPing_HasOverriddenMessageProducer (0.00s) === RUN TestZapPayloadSuite === RUN TestZapPayloadSuite/TestPingError_LogsOnlyRequestsOnError === RUN TestZapPayloadSuite/TestPingStream_LogsAllRequestsAndResponses === RUN TestZapPayloadSuite/TestPing_LogsBothRequestAndResponse - payload_interceptors_test.go:83: map[grpc.method:Ping grpc.request.content:map[msg:map[sleepTimeMs:9999 value:something]] grpc.service:mwitkow.testproto.TestService level:info msg:client request payload logged as grpc.request.content span.kind:client system:grpc ts:1.7165579888905425e+09] + payload_interceptors_test.go:83: map[grpc.method:Ping grpc.request.content:map[msg:map[sleepTimeMs:9999 value:something]] grpc.service:mwitkow.testproto.TestService level:info msg:client request payload logged as grpc.request.content span.kind:client system:grpc ts:1.6821480328597882e+09] === CONT TestZapPayloadSuite - interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:42587 ---- PASS: TestZapPayloadSuite (0.68s) + interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:44737 +--- PASS: TestZapPayloadSuite (1.75s) --- PASS: TestZapPayloadSuite/TestPingError_LogsOnlyRequestsOnError (0.00s) --- PASS: TestZapPayloadSuite/TestPingStream_LogsAllRequestsAndResponses (0.00s) --- PASS: TestZapPayloadSuite/TestPing_LogsBothRequestAndResponse (0.00s) @@ -1311,13 +1354,13 @@ === RUN TestZapLoggingSuite/TestPingList_WithCustomTags === RUN TestZapLoggingSuite/TestPing_WithCustomTags === CONT TestZapLoggingSuite - interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:38697 + interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:34451 === RUN TestZapLoggingSuite/TestPingError_WithCustomLevels#01 === RUN TestZapLoggingSuite/TestPingList_WithCustomTags#01 === RUN TestZapLoggingSuite/TestPing_WithCustomTags#01 === CONT TestZapLoggingSuite - interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:35891 ---- PASS: TestZapLoggingSuite (1.80s) + interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:37287 +--- PASS: TestZapLoggingSuite (2.77s) --- PASS: TestZapLoggingSuite/TestPingError_WithCustomLevels (0.00s) --- PASS: TestZapLoggingSuite/TestPingList_WithCustomTags (0.00s) --- PASS: TestZapLoggingSuite/TestPing_WithCustomTags (0.00s) @@ -1328,8 +1371,8 @@ === RUN TestZapLoggingOverrideSuite/TestPingList_HasOverriddenDuration === RUN TestZapLoggingOverrideSuite/TestPing_HasOverriddenDuration === CONT TestZapLoggingOverrideSuite - interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:45175 ---- PASS: TestZapLoggingOverrideSuite (0.90s) + interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:34259 +--- PASS: TestZapLoggingOverrideSuite (0.95s) --- PASS: TestZapLoggingOverrideSuite/TestPingList_HasOverriddenDuration (0.00s) --- PASS: TestZapLoggingOverrideSuite/TestPing_HasOverriddenDuration (0.00s) === RUN TestZapServerOverrideSuppressedSuite @@ -1337,31 +1380,31 @@ === RUN TestZapServerOverrideSuppressedSuite/TestPingList_HasOverriddenDecider === RUN TestZapServerOverrideSuppressedSuite/TestPing_HasOverriddenDecider === CONT TestZapServerOverrideSuppressedSuite - interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:37687 ---- PASS: TestZapServerOverrideSuppressedSuite (0.66s) + interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:38467 +--- PASS: TestZapServerOverrideSuppressedSuite (1.27s) --- PASS: TestZapServerOverrideSuppressedSuite/TestPingError_HasOverriddenDecider (0.00s) --- PASS: TestZapServerOverrideSuppressedSuite/TestPingList_HasOverriddenDecider (0.00s) --- PASS: TestZapServerOverrideSuppressedSuite/TestPing_HasOverriddenDecider (0.00s) === RUN TestZapLoggingServerMessageProducerSuite === RUN TestZapLoggingServerMessageProducerSuite/TestPing_HasOverriddenMessageProducer === CONT TestZapLoggingServerMessageProducerSuite - interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:35465 ---- PASS: TestZapLoggingServerMessageProducerSuite (1.24s) + interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:37599 +--- PASS: TestZapLoggingServerMessageProducerSuite (1.73s) --- PASS: TestZapLoggingServerMessageProducerSuite/TestPing_HasOverriddenMessageProducer (0.00s) === RUN TestSpecificLogging - logger.go:130: 2024-05-24T01:39:53.499-1200 INFO [Test specific log-line] {"system": "grpc", "grpc_log": true} + logger.go:130: 2023-04-22T21:20:39.594+1400 INFO [Test specific log-line] {"system": "grpc", "grpc_log": true} --- PASS: TestSpecificLogging (0.00s) PASS -ok github.com/grpc-ecosystem/go-grpc-middleware/logging/zap 8.562s +ok github.com/grpc-ecosystem/go-grpc-middleware/logging/zap 17.528s === RUN TestShorthands === RUN TestShorthands/debug - logger.go:130: 2024-05-24T01:39:42.786-1200 DEBUG omg! + logger.go:130: 2023-04-22T21:20:19.770+1400 DEBUG omg! === RUN TestShorthands/info - logger.go:130: 2024-05-24T01:39:42.786-1200 INFO omg! + logger.go:130: 2023-04-22T21:20:19.770+1400 INFO omg! === RUN TestShorthands/warn - logger.go:130: 2024-05-24T01:39:42.786-1200 WARN omg! + logger.go:130: 2023-04-22T21:20:19.770+1400 WARN omg! === RUN TestShorthands/error - logger.go:130: 2024-05-24T01:39:42.787-1200 ERROR omg! + logger.go:130: 2023-04-22T21:20:19.770+1400 ERROR omg! --- PASS: TestShorthands (0.00s) --- PASS: TestShorthands/debug (0.00s) --- PASS: TestShorthands/info (0.00s) @@ -1370,7 +1413,7 @@ === RUN TestShorthandsNoop --- PASS: TestShorthandsNoop (0.00s) PASS -ok github.com/grpc-ecosystem/go-grpc-middleware/logging/zap/ctxzap 0.009s +ok github.com/grpc-ecosystem/go-grpc-middleware/logging/zap/ctxzap 0.038s === RUN TestUnaryServerInterceptor_RateLimitPass --- PASS: TestUnaryServerInterceptor_RateLimitPass (0.00s) === RUN TestUnaryServerInterceptor_RateLimitFail @@ -1380,7 +1423,7 @@ === RUN TestStreamServerInterceptor_RateLimitFail --- PASS: TestStreamServerInterceptor_RateLimitFail (0.00s) PASS -ok github.com/grpc-ecosystem/go-grpc-middleware/ratelimit 0.019s +ok github.com/grpc-ecosystem/go-grpc-middleware/ratelimit 0.020s === RUN TestRecoverySuite === RUN TestRecoverySuite/TestStream_NilPanickingReceive === RUN TestRecoverySuite/TestStream_PanickingReceive @@ -1389,8 +1432,8 @@ === RUN TestRecoverySuite/TestUnary_PanickingRequest === RUN TestRecoverySuite/TestUnary_SuccessfulRequest === CONT TestRecoverySuite - interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:37039 ---- PASS: TestRecoverySuite (1.15s) + interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:37681 +--- PASS: TestRecoverySuite (3.25s) --- PASS: TestRecoverySuite/TestStream_NilPanickingReceive (0.00s) --- PASS: TestRecoverySuite/TestStream_PanickingReceive (0.00s) --- PASS: TestRecoverySuite/TestStream_SuccessfulReceive (0.00s) @@ -1403,14 +1446,14 @@ === RUN TestRecoveryOverrideSuite/TestUnary_PanickingRequest === RUN TestRecoveryOverrideSuite/TestUnary_SuccessfulRequest === CONT TestRecoveryOverrideSuite - interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:38529 ---- PASS: TestRecoveryOverrideSuite (0.94s) + interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:46849 +--- PASS: TestRecoveryOverrideSuite (0.83s) --- PASS: TestRecoveryOverrideSuite/TestStream_PanickingReceive (0.00s) --- PASS: TestRecoveryOverrideSuite/TestStream_SuccessfulReceive (0.00s) --- PASS: TestRecoveryOverrideSuite/TestUnary_PanickingRequest (0.00s) --- PASS: TestRecoveryOverrideSuite/TestUnary_SuccessfulRequest (0.00s) PASS -ok github.com/grpc-ecosystem/go-grpc-middleware/recovery 2.095s +ok github.com/grpc-ecosystem/go-grpc-middleware/recovery 4.089s === RUN TestRetrySuite === RUN TestRetrySuite/TestCallOptionsDontPanicWithoutInterceptor === RUN TestRetrySuite/TestServerStream_CallFailsOnDeadlineExceeded @@ -1428,38 +1471,38 @@ === RUN TestRetrySuite/TestUnary_PerCallDeadline_Succeeds === RUN TestRetrySuite/TestUnary_SucceedsOnRetriableError === CONT TestRetrySuite - interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:41251 ---- PASS: TestRetrySuite (3.84s) - --- PASS: TestRetrySuite/TestCallOptionsDontPanicWithoutInterceptor (0.02s) + interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:37467 +--- PASS: TestRetrySuite (5.48s) + --- PASS: TestRetrySuite/TestCallOptionsDontPanicWithoutInterceptor (0.03s) --- PASS: TestRetrySuite/TestServerStream_CallFailsOnDeadlineExceeded (0.15s) --- PASS: TestRetrySuite/TestServerStream_CallFailsOnOutOfRetries (0.15s) - --- PASS: TestRetrySuite/TestServerStream_CallRetrySucceeds (0.72s) + --- PASS: TestRetrySuite/TestServerStream_CallRetrySucceeds (0.73s) --- PASS: TestRetrySuite/TestServerStream_FailsOnNonRetriableError (0.00s) - --- PASS: TestRetrySuite/TestServerStream_OverrideFromContext (0.20s) + --- PASS: TestRetrySuite/TestServerStream_OverrideFromContext (0.21s) --- PASS: TestRetrySuite/TestServerStream_PerCallDeadline_FailsOnParent (0.15s) --- PASS: TestRetrySuite/TestServerStream_PerCallDeadline_Succeeds (0.41s) - --- PASS: TestRetrySuite/TestServerStream_SucceedsOnRetriableError (0.10s) + --- PASS: TestRetrySuite/TestServerStream_SucceedsOnRetriableError (0.11s) --- PASS: TestRetrySuite/TestUnary_FailsOnNonRetriableContextError (0.00s) --- PASS: TestRetrySuite/TestUnary_FailsOnNonRetriableError (0.00s) - --- PASS: TestRetrySuite/TestUnary_OverrideFromDialOpts (0.20s) + --- PASS: TestRetrySuite/TestUnary_OverrideFromDialOpts (0.21s) --- PASS: TestRetrySuite/TestUnary_PerCallDeadline_FailsOnParent (0.15s) - --- PASS: TestRetrySuite/TestUnary_PerCallDeadline_Succeeds (0.22s) - --- PASS: TestRetrySuite/TestUnary_SucceedsOnRetriableError (0.10s) + --- PASS: TestRetrySuite/TestUnary_PerCallDeadline_Succeeds (0.23s) + --- PASS: TestRetrySuite/TestUnary_SucceedsOnRetriableError (0.11s) === RUN TestChainedRetrySuite === RUN TestChainedRetrySuite/TestStreamWithChainedInterceptors_NoFailure === RUN TestChainedRetrySuite/TestStreamWithChainedInterceptors_WithRetry === RUN TestChainedRetrySuite/TestUnaryWithChainedInterceptors_NoFailure === RUN TestChainedRetrySuite/TestUnaryWithChainedInterceptors_WithRetry === CONT TestChainedRetrySuite - interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:43617 ---- PASS: TestChainedRetrySuite (0.89s) + interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:38493 +--- PASS: TestChainedRetrySuite (0.74s) --- PASS: TestChainedRetrySuite/TestStreamWithChainedInterceptors_NoFailure (0.00s) --- PASS: TestChainedRetrySuite/TestStreamWithChainedInterceptors_WithRetry (0.05s) --- PASS: TestChainedRetrySuite/TestUnaryWithChainedInterceptors_NoFailure (0.00s) --- PASS: TestChainedRetrySuite/TestUnaryWithChainedInterceptors_WithRetry (0.06s) PASS -ok github.com/grpc-ecosystem/go-grpc-middleware/retry 4.733s -2024/05/24 01:39:43 proto: duplicate proto type registered: mwitkow.testproto.PingRequest +ok github.com/grpc-ecosystem/go-grpc-middleware/retry 6.232s +2023/04/22 21:20:22 proto: duplicate proto type registered: mwitkow.testproto.PingRequest === RUN TestCodeGenRequestLogFieldExtractor_ManualIsDeclared --- PASS: TestCodeGenRequestLogFieldExtractor_ManualIsDeclared (0.00s) === RUN TestTaggedRequestFiledExtractor_PingRequest @@ -1476,8 +1519,8 @@ === RUN TestTaggingSuite/TestPing_WithDeadline === RUN TestTaggingSuite/TestPing_WithNoDeadline === CONT TestTaggingSuite - interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:38425 ---- PASS: TestTaggingSuite (1.26s) + interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:33763 +--- PASS: TestTaggingSuite (1.37s) --- PASS: TestTaggingSuite/TestPingList_WithCustomTags (0.00s) --- PASS: TestTaggingSuite/TestPing_WithCustomTags (0.00s) --- PASS: TestTaggingSuite/TestPing_WithDeadline (0.00s) @@ -1489,15 +1532,15 @@ === RUN TestTaggingOnInitialRequestSuite/TestPing_WithDeadline === RUN TestTaggingOnInitialRequestSuite/TestPing_WithNoDeadline === CONT TestTaggingOnInitialRequestSuite - interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:39949 ---- PASS: TestTaggingOnInitialRequestSuite (1.01s) + interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:34205 +--- PASS: TestTaggingOnInitialRequestSuite (2.51s) --- PASS: TestTaggingOnInitialRequestSuite/TestPingList_WithCustomTags (0.00s) --- PASS: TestTaggingOnInitialRequestSuite/TestPingStream_WithCustomTagsFirstRequest (0.00s) --- PASS: TestTaggingOnInitialRequestSuite/TestPing_WithCustomTags (0.00s) --- PASS: TestTaggingOnInitialRequestSuite/TestPing_WithDeadline (0.00s) --- PASS: TestTaggingOnInitialRequestSuite/TestPing_WithNoDeadline (0.00s) PASS -ok github.com/grpc-ecosystem/go-grpc-middleware/tags 2.277s +ok github.com/grpc-ecosystem/go-grpc-middleware/tags 3.885s ? github.com/grpc-ecosystem/go-grpc-middleware/tags/logrus [no test files] ? github.com/grpc-ecosystem/go-grpc-middleware/tags/zap [no test files] ? github.com/grpc-ecosystem/go-grpc-middleware/testing [no test files] @@ -1509,22 +1552,22 @@ === RUN TestTaggingSuite/TestPingEmpty_NotSampleTraces === RUN TestTaggingSuite/TestPingError_PropagatesTraces interceptors_test.go:170: span: traceId=1337, spanId=50, parentId=999, sampled=true, name=/fake/parent/http/request, tags: map[] - interceptors_test.go:170: span: traceId=1337, spanId=54, parentId=52, sampled=true, name=/mwitkow.testproto.TestService/PingError, tags: map[component:gRPC error:true grpc.request.value:something peer.address:127.0.0.1:37794 span.kind:server trace.sampled:true trace.spanid:54 trace.traceid:1337] + interceptors_test.go:170: span: traceId=1337, spanId=54, parentId=52, sampled=true, name=/mwitkow.testproto.TestService/PingError, tags: map[component:gRPC error:true grpc.request.value:something peer.address:127.0.0.1:57684 span.kind:server trace.sampled:true trace.spanid:54 trace.traceid:1337] interceptors_test.go:170: span: traceId=1337, spanId=52, parentId=50, sampled=true, name=/mwitkow.testproto.TestService/PingError, tags: map[component:gRPC error:true span.kind:client] === RUN TestTaggingSuite/TestPingList_PropagatesTraces interceptors_test.go:170: span: traceId=1337, spanId=56, parentId=999, sampled=true, name=/fake/parent/http/request, tags: map[] interceptors_test.go:170: span: traceId=1337, spanId=58, parentId=56, sampled=true, name=/mwitkow.testproto.TestService/PingList, tags: map[component:gRPC span.kind:client] - interceptors_test.go:170: span: traceId=1337, spanId=60, parentId=58, sampled=true, name=/mwitkow.testproto.TestService/PingList, tags: map[component:gRPC grpc.request.value:something peer.address:127.0.0.1:37794 span.kind:server trace.sampled:true trace.spanid:60 trace.traceid:1337] + interceptors_test.go:170: span: traceId=1337, spanId=60, parentId=58, sampled=true, name=/mwitkow.testproto.TestService/PingList, tags: map[component:gRPC grpc.request.value:something peer.address:127.0.0.1:57684 span.kind:server trace.sampled:true trace.spanid:60 trace.traceid:1337] === RUN TestTaggingSuite/TestPing_ClientContextTags === RUN TestTaggingSuite/TestPing_CustomOpName === RUN TestTaggingSuite/TestPing_PropagatesTraces interceptors_test.go:170: span: traceId=1337, spanId=74, parentId=999, sampled=true, name=/fake/parent/http/request, tags: map[] - interceptors_test.go:170: span: traceId=1337, spanId=78, parentId=76, sampled=true, name=/mwitkow.testproto.TestService/Ping, tags: map[component:gRPC grpc.request.value:something peer.address:127.0.0.1:37794 span.kind:server trace.sampled:true trace.spanid:78 trace.traceid:1337] + interceptors_test.go:170: span: traceId=1337, spanId=78, parentId=76, sampled=true, name=/mwitkow.testproto.TestService/Ping, tags: map[component:gRPC grpc.request.value:something peer.address:127.0.0.1:57684 span.kind:server trace.sampled:true trace.spanid:78 trace.traceid:1337] interceptors_test.go:170: span: traceId=1337, spanId=76, parentId=74, sampled=true, name=/mwitkow.testproto.TestService/Ping, tags: map[component:gRPC span.kind:client] === RUN TestTaggingSuite/TestPing_WithUnaryRequestHandlerFunc === CONT TestTaggingSuite - interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:35931 ---- PASS: TestTaggingSuite (1.95s) + interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:45443 +--- PASS: TestTaggingSuite (2.55s) --- PASS: TestTaggingSuite/TestPingEmpty_NotSampleTraces (0.00s) --- PASS: TestTaggingSuite/TestPingError_PropagatesTraces (0.00s) --- PASS: TestTaggingSuite/TestPingList_PropagatesTraces (0.00s) @@ -1536,22 +1579,22 @@ === RUN TestTaggingSuiteJaeger/TestPingEmpty_NotSampleTraces === RUN TestTaggingSuiteJaeger/TestPingError_PropagatesTraces interceptors_test.go:170: span: traceId=1337, spanId=92, parentId=999, sampled=true, name=/fake/parent/http/request, tags: map[] - interceptors_test.go:170: span: traceId=1337, spanId=96, parentId=94, sampled=true, name=/mwitkow.testproto.TestService/PingError, tags: map[component:gRPC error:true grpc.request.value:something peer.address:127.0.0.1:49966 span.kind:server trace.sampled:true trace.spanid:96 trace.traceid:1337] + interceptors_test.go:170: span: traceId=1337, spanId=96, parentId=94, sampled=true, name=/mwitkow.testproto.TestService/PingError, tags: map[component:gRPC error:true grpc.request.value:something peer.address:127.0.0.1:53030 span.kind:server trace.sampled:true trace.spanid:96 trace.traceid:1337] interceptors_test.go:170: span: traceId=1337, spanId=94, parentId=92, sampled=true, name=/mwitkow.testproto.TestService/PingError, tags: map[component:gRPC error:true span.kind:client] === RUN TestTaggingSuiteJaeger/TestPingList_PropagatesTraces interceptors_test.go:170: span: traceId=1337, spanId=98, parentId=999, sampled=true, name=/fake/parent/http/request, tags: map[] interceptors_test.go:170: span: traceId=1337, spanId=100, parentId=98, sampled=true, name=/mwitkow.testproto.TestService/PingList, tags: map[component:gRPC span.kind:client] - interceptors_test.go:170: span: traceId=1337, spanId=102, parentId=100, sampled=true, name=/mwitkow.testproto.TestService/PingList, tags: map[component:gRPC grpc.request.value:something peer.address:127.0.0.1:49966 span.kind:server trace.sampled:true trace.spanid:102 trace.traceid:1337] + interceptors_test.go:170: span: traceId=1337, spanId=102, parentId=100, sampled=true, name=/mwitkow.testproto.TestService/PingList, tags: map[component:gRPC grpc.request.value:something peer.address:127.0.0.1:53030 span.kind:server trace.sampled:true trace.spanid:102 trace.traceid:1337] === RUN TestTaggingSuiteJaeger/TestPing_ClientContextTags === RUN TestTaggingSuiteJaeger/TestPing_CustomOpName === RUN TestTaggingSuiteJaeger/TestPing_PropagatesTraces interceptors_test.go:170: span: traceId=1337, spanId=116, parentId=999, sampled=true, name=/fake/parent/http/request, tags: map[] - interceptors_test.go:170: span: traceId=1337, spanId=120, parentId=118, sampled=true, name=/mwitkow.testproto.TestService/Ping, tags: map[component:gRPC grpc.request.value:something peer.address:127.0.0.1:49966 span.kind:server trace.sampled:true trace.spanid:120 trace.traceid:1337] + interceptors_test.go:170: span: traceId=1337, spanId=120, parentId=118, sampled=true, name=/mwitkow.testproto.TestService/Ping, tags: map[component:gRPC grpc.request.value:something peer.address:127.0.0.1:53030 span.kind:server trace.sampled:true trace.spanid:120 trace.traceid:1337] interceptors_test.go:170: span: traceId=1337, spanId=118, parentId=116, sampled=true, name=/mwitkow.testproto.TestService/Ping, tags: map[component:gRPC span.kind:client] === RUN TestTaggingSuiteJaeger/TestPing_WithUnaryRequestHandlerFunc === CONT TestTaggingSuiteJaeger - interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:35579 ---- PASS: TestTaggingSuiteJaeger (0.29s) + interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:42889 +--- PASS: TestTaggingSuiteJaeger (1.35s) --- PASS: TestTaggingSuiteJaeger/TestPingEmpty_NotSampleTraces (0.00s) --- PASS: TestTaggingSuiteJaeger/TestPingError_PropagatesTraces (0.00s) --- PASS: TestTaggingSuiteJaeger/TestPingList_PropagatesTraces (0.00s) @@ -1560,11 +1603,11 @@ --- PASS: TestTaggingSuiteJaeger/TestPing_PropagatesTraces (0.00s) --- PASS: TestTaggingSuiteJaeger/TestPing_WithUnaryRequestHandlerFunc (0.00s) PASS -ok github.com/grpc-ecosystem/go-grpc-middleware/tracing/opentracing 2.244s +ok github.com/grpc-ecosystem/go-grpc-middleware/tracing/opentracing 3.917s === RUN TestJitterUp --- PASS: TestJitterUp (0.00s) PASS -ok github.com/grpc-ecosystem/go-grpc-middleware/util/backoffutils 0.004s +ok github.com/grpc-ecosystem/go-grpc-middleware/util/backoffutils 0.007s === RUN TestNiceMD_Get --- PASS: TestNiceMD_Get (0.00s) === RUN TestNiceMD_Del @@ -1582,7 +1625,7 @@ === RUN TestNiceMD_ToIncoming --- PASS: TestNiceMD_ToIncoming (0.00s) PASS -ok github.com/grpc-ecosystem/go-grpc-middleware/util/metautils 0.003s +ok github.com/grpc-ecosystem/go-grpc-middleware/util/metautils 0.007s === RUN TestValidateWrapper --- PASS: TestValidateWrapper (0.00s) === RUN TestValidatorTestSuite @@ -1592,12 +1635,12 @@ === RUN TestValidatorTestSuite/TestValidPasses_ServerStream === RUN TestValidatorTestSuite/TestValidPasses_Unary === CONT TestValidatorTestSuite - interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:41469 + interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:44671 === RUN TestValidatorTestSuite/TestInvalidErrors_Unary#01 === RUN TestValidatorTestSuite/TestValidPasses_Unary#01 === CONT TestValidatorTestSuite - interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:44393 ---- PASS: TestValidatorTestSuite (2.68s) + interceptor_suite.go:151: stopped grpc.Server at: 127.0.0.1:46715 +--- PASS: TestValidatorTestSuite (3.35s) --- PASS: TestValidatorTestSuite/TestInvalidErrors_BidiStream (0.00s) --- PASS: TestValidatorTestSuite/TestInvalidErrors_ServerStream (0.00s) --- PASS: TestValidatorTestSuite/TestInvalidErrors_Unary (0.00s) @@ -1606,7 +1649,7 @@ --- PASS: TestValidatorTestSuite/TestInvalidErrors_Unary#01 (0.00s) --- PASS: TestValidatorTestSuite/TestValidPasses_Unary#01 (0.00s) PASS -ok github.com/grpc-ecosystem/go-grpc-middleware/validator 2.680s +ok github.com/grpc-ecosystem/go-grpc-middleware/validator 3.357s create-stamp debian/debhelper-build-stamp dh_testroot -O--buildsystem=golang dh_prep -O--buildsystem=golang @@ -1633,12 +1676,14 @@ dpkg-buildpackage: info: binary-only upload (no source included) dpkg-genchanges: info: including full source code in upload I: copying local configuration +I: user script /srv/workspace/pbuilder/4192/tmp/hooks/B01_cleanup starting +I: user script /srv/workspace/pbuilder/4192/tmp/hooks/B01_cleanup finished I: unmounting dev/ptmx filesystem I: unmounting dev/pts filesystem I: unmounting dev/shm filesystem I: unmounting proc filesystem I: unmounting sys filesystem I: cleaning the build env -I: removing directory /srv/workspace/pbuilder/72054 and its subdirectories -I: Current time: Fri May 24 01:39:58 -12 2024 -I: pbuilder-time-stamp: 1716557998 +I: removing directory /srv/workspace/pbuilder/4192 and its subdirectories +I: Current time: Sat Apr 22 21:20:48 +14 2023 +I: pbuilder-time-stamp: 1682148048