Diff of the two buildlogs: -- --- b1/build.log 2020-07-22 05:08:55.060014181 +0000 +++ b2/build.log 2020-07-22 05:19:26.892550983 +0000 @@ -1,6 +1,6 @@ I: pbuilder: network access will be disabled during build -I: Current time: Tue Jul 21 16:58:54 -12 2020 -I: pbuilder-time-stamp: 1595393934 +I: Current time: Wed Aug 25 01:32:02 +14 2021 +I: pbuilder-time-stamp: 1629804722 I: Building the build Environment I: extracting base tarball [/var/cache/pbuilder/buster-reproducible-base.tgz] I: copying local configuration @@ -17,7 +17,7 @@ I: Extracting source gpgv: unknown type of key resource 'trustedkeys.kbx' gpgv: keyblock resource '/var/lib/jenkins/.gnupg/trustedkeys.kbx': General error -gpgv: Signature made Wed Sep 13 21:51:32 2017 -12 +gpgv: Signature made Thu Sep 14 23:51:32 2017 +14 gpgv: using RSA key B8CE4DE21080DCF903E16C40F513C419E4B9D0AC gpgv: issuer "ebourg@apache.org" gpgv: Can't check signature: No public key @@ -31,136 +31,170 @@ dpkg-source: info: applying 03-explicit-bundle-type.patch I: using fakeroot in build. I: Installing the build-deps -I: user script /srv/workspace/pbuilder/27727/tmp/hooks/D02_print_environment starting +I: user script /srv/workspace/pbuilder/29606/tmp/hooks/D01_modify_environment starting +debug: Running on codethink-sled15-arm64. +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 +Removing 'diversion of /bin/sh to /bin/sh.distrib by dash' +Adding 'diversion of /bin/sh to /bin/sh.distrib by bash' +Removing 'diversion of /usr/share/man/man1/sh.1.gz to /usr/share/man/man1/sh.distrib.1.gz by dash' +Adding 'diversion of /usr/share/man/man1/sh.1.gz to /usr/share/man/man1/sh.distrib.1.gz by 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/29606/tmp/hooks/D01_modify_environment finished +I: user script /srv/workspace/pbuilder/29606/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='arm64' - DEBIAN_FRONTEND='noninteractive' + BASH=/bin/sh + BASHOPTS=checkwinsize:cmdhist:complete_fullquote:extquote:force_fignore:globasciiranges:hostcomplete:interactive_comments:progcomp:promptvars:sourcepath + BASH_ALIASES=() + BASH_ARGC=() + BASH_ARGV=() + BASH_CMDS=() + BASH_LINENO=([0]="12" [1]="0") + BASH_SOURCE=([0]="/tmp/hooks/D02_print_environment" [1]="/tmp/hooks/D02_print_environment") + BASH_VERSINFO=([0]="5" [1]="0" [2]="3" [3]="1" [4]="release" [5]="aarch64-unknown-linux-gnu") + BASH_VERSION='5.0.3(1)-release' + BUILDDIR=/build + BUILDUSERGECOS='second user,second room,second work-phone,second home-phone,second other' + BUILDUSERNAME=pbuilder2 + BUILD_ARCH=arm64 + DEBIAN_FRONTEND=noninteractive DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all parallel=8' - DISTRIBUTION='' - HOME='/var/lib/jenkins' - HOST_ARCH='arm64' + DIRSTACK=() + DISTRIBUTION= + EUID=0 + FUNCNAME=([0]="Echo" [1]="main") + GROUPS=() + HOME=/var/lib/jenkins + HOSTNAME=i-capture-the-hostname + HOSTTYPE=aarch64 + HOST_ARCH=arm64 IFS=' ' - LANG='C' - LANGUAGE='en_US:en' - LC_ALL='C' - 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='27727' - PS1='# ' - PS2='> ' + LANG=C + LANGUAGE=nl_BE:nl + LC_ALL=C + MACHTYPE=aarch64-unknown-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=29606 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/tmp.oxzUBvfC1l/pbuilderrc_K0nL --hookdir /etc/pbuilder/first-build-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/buster-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/tmp.oxzUBvfC1l/b1 --logfile b1/build.log avro-java_1.7.7-3.dsc' - SUDO_GID='117' - SUDO_UID='110' - SUDO_USER='jenkins' - TERM='unknown' - TZ='/usr/share/zoneinfo/Etc/GMT+12' - USER='root' - USERNAME='root' - _='/usr/bin/systemd-run' - http_proxy='http://192.168.101.16: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/tmp.oxzUBvfC1l/pbuilderrc_zFXj --hookdir /etc/pbuilder/rebuild-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/buster-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/tmp.oxzUBvfC1l/b2 --logfile b2/build.log avro-java_1.7.7-3.dsc' + SUDO_GID=117 + SUDO_UID=110 + SUDO_USER=jenkins + TERM=unknown + TZ=/usr/share/zoneinfo/Etc/GMT-14 + UID=0 + USER=root + USERNAME=root + _='I: set' + http_proxy=http://192.168.101.16:3128 I: uname -a - Linux codethink-sled10-arm64 4.4.0-185-generic #215-Ubuntu SMP Mon Jun 8 21:55:24 UTC 2020 aarch64 GNU/Linux + Linux i-capture-the-hostname 4.4.0-185-generic #215-Ubuntu SMP Mon Jun 8 21:55:24 UTC 2020 aarch64 GNU/Linux I: ls -l /bin total 4928 - -rwxr-xr-x 1 root root 1216928 Apr 17 2019 bash - -rwxr-xr-x 3 root root 34808 Jul 10 2019 bunzip2 - -rwxr-xr-x 3 root root 34808 Jul 10 2019 bzcat - lrwxrwxrwx 1 root root 6 Jul 10 2019 bzcmp -> bzdiff - -rwxr-xr-x 1 root root 2227 Jul 10 2019 bzdiff - lrwxrwxrwx 1 root root 6 Jul 10 2019 bzegrep -> bzgrep - -rwxr-xr-x 1 root root 4877 Jun 24 2019 bzexe - lrwxrwxrwx 1 root root 6 Jul 10 2019 bzfgrep -> bzgrep - -rwxr-xr-x 1 root root 3641 Jul 10 2019 bzgrep - -rwxr-xr-x 3 root root 34808 Jul 10 2019 bzip2 - -rwxr-xr-x 1 root root 14264 Jul 10 2019 bzip2recover - lrwxrwxrwx 1 root root 6 Jul 10 2019 bzless -> bzmore - -rwxr-xr-x 1 root root 1297 Jul 10 2019 bzmore - -rwxr-xr-x 1 root root 35576 Feb 28 2019 cat - -rwxr-xr-x 1 root root 60256 Feb 28 2019 chgrp - -rwxr-xr-x 1 root root 56096 Feb 28 2019 chmod - -rwxr-xr-x 1 root root 64368 Feb 28 2019 chown - -rwxr-xr-x 1 root root 134632 Feb 28 2019 cp - -rwxr-xr-x 1 root root 129536 Jan 17 2019 dash - -rwxr-xr-x 1 root root 97136 Feb 28 2019 date - -rwxr-xr-x 1 root root 76736 Feb 28 2019 dd - -rwxr-xr-x 1 root root 93752 Feb 28 2019 df - -rwxr-xr-x 1 root root 138848 Feb 28 2019 dir - -rwxr-xr-x 1 root root 75984 Jan 9 2019 dmesg - lrwxrwxrwx 1 root root 8 Sep 26 2018 dnsdomainname -> hostname - lrwxrwxrwx 1 root root 8 Sep 26 2018 domainname -> hostname - -rwxr-xr-x 1 root root 31368 Feb 28 2019 echo - -rwxr-xr-x 1 root root 28 Jan 7 2019 egrep - -rwxr-xr-x 1 root root 27256 Feb 28 2019 false - -rwxr-xr-x 1 root root 28 Jan 7 2019 fgrep - -rwxr-xr-x 1 root root 68792 Jan 9 2019 findmnt - -rwsr-xr-x 1 root root 34824 Apr 22 07:38 fusermount - -rwxr-xr-x 1 root root 174304 Jan 7 2019 grep - -rwxr-xr-x 2 root root 2345 Jan 5 2019 gunzip - -rwxr-xr-x 1 root root 6375 Jan 5 2019 gzexe - -rwxr-xr-x 1 root root 89656 Jan 5 2019 gzip - -rwxr-xr-x 1 root root 18440 Sep 26 2018 hostname - -rwxr-xr-x 1 root root 64472 Feb 28 2019 ln - -rwxr-xr-x 1 root root 52544 Jul 26 2018 login - -rwxr-xr-x 1 root root 138848 Feb 28 2019 ls - -rwxr-xr-x 1 root root 108552 Jan 9 2019 lsblk - -rwxr-xr-x 1 root root 76840 Feb 28 2019 mkdir - -rwxr-xr-x 1 root root 64480 Feb 28 2019 mknod - -rwxr-xr-x 1 root root 39736 Feb 28 2019 mktemp - -rwxr-xr-x 1 root root 38840 Jan 9 2019 more - -rwsr-xr-x 1 root root 47112 Jan 9 2019 mount - -rwxr-xr-x 1 root root 14344 Jan 9 2019 mountpoint - -rwxr-xr-x 1 root root 138736 Feb 28 2019 mv - lrwxrwxrwx 1 root root 8 Sep 26 2018 nisdomainname -> hostname - lrwxrwxrwx 1 root root 14 Feb 14 2019 pidof -> /sbin/killall5 - -rwxr-xr-x 1 root root 35560 Feb 28 2019 pwd - lrwxrwxrwx 1 root root 4 Apr 17 2019 rbash -> bash - -rwxr-xr-x 1 root root 43712 Feb 28 2019 readlink - -rwxr-xr-x 1 root root 68440 Feb 28 2019 rm - -rwxr-xr-x 1 root root 39624 Feb 28 2019 rmdir - -rwxr-xr-x 1 root root 19144 Jan 21 2019 run-parts - -rwxr-xr-x 1 root root 114016 Dec 22 2018 sed - lrwxrwxrwx 1 root root 4 Jul 19 20:26 sh -> dash - -rwxr-xr-x 1 root root 31384 Feb 28 2019 sleep - -rwxr-xr-x 1 root root 72480 Feb 28 2019 stty - -rwsr-xr-x 1 root root 59424 Jan 9 2019 su - -rwxr-xr-x 1 root root 31416 Feb 28 2019 sync - -rwxr-xr-x 1 root root 449416 Apr 23 2019 tar - -rwxr-xr-x 1 root root 10560 Jan 21 2019 tempfile - -rwxr-xr-x 1 root root 88968 Feb 28 2019 touch - -rwxr-xr-x 1 root root 27256 Feb 28 2019 true - -rwxr-xr-x 1 root root 14264 Apr 22 07:38 ulockmgr_server - -rwsr-xr-x 1 root root 30728 Jan 9 2019 umount - -rwxr-xr-x 1 root root 31384 Feb 28 2019 uname - -rwxr-xr-x 2 root root 2345 Jan 5 2019 uncompress - -rwxr-xr-x 1 root root 138848 Feb 28 2019 vdir - -rwxr-xr-x 1 root root 34824 Jan 9 2019 wdctl - -rwxr-xr-x 1 root root 946 Jan 21 2019 which - lrwxrwxrwx 1 root root 8 Sep 26 2018 ypdomainname -> hostname - -rwxr-xr-x 1 root root 1983 Jan 5 2019 zcat - -rwxr-xr-x 1 root root 1677 Jan 5 2019 zcmp - -rwxr-xr-x 1 root root 5879 Jan 5 2019 zdiff - -rwxr-xr-x 1 root root 29 Jan 5 2019 zegrep - -rwxr-xr-x 1 root root 29 Jan 5 2019 zfgrep - -rwxr-xr-x 1 root root 2080 Jan 5 2019 zforce - -rwxr-xr-x 1 root root 7584 Jan 5 2019 zgrep - -rwxr-xr-x 1 root root 2205 Jan 5 2019 zless - -rwxr-xr-x 1 root root 1841 Jan 5 2019 zmore - -rwxr-xr-x 1 root root 4552 Jan 5 2019 znew -I: user script /srv/workspace/pbuilder/27727/tmp/hooks/D02_print_environment finished + -rwxr-xr-x 1 root root 1216928 Apr 18 2019 bash + -rwxr-xr-x 3 root root 34808 Jul 11 2019 bunzip2 + -rwxr-xr-x 3 root root 34808 Jul 11 2019 bzcat + lrwxrwxrwx 1 root root 6 Jul 11 2019 bzcmp -> bzdiff + -rwxr-xr-x 1 root root 2227 Jul 11 2019 bzdiff + lrwxrwxrwx 1 root root 6 Jul 11 2019 bzegrep -> bzgrep + -rwxr-xr-x 1 root root 4877 Jun 25 2019 bzexe + lrwxrwxrwx 1 root root 6 Jul 11 2019 bzfgrep -> bzgrep + -rwxr-xr-x 1 root root 3641 Jul 11 2019 bzgrep + -rwxr-xr-x 3 root root 34808 Jul 11 2019 bzip2 + -rwxr-xr-x 1 root root 14264 Jul 11 2019 bzip2recover + lrwxrwxrwx 1 root root 6 Jul 11 2019 bzless -> bzmore + -rwxr-xr-x 1 root root 1297 Jul 11 2019 bzmore + -rwxr-xr-x 1 root root 35576 Mar 1 2019 cat + -rwxr-xr-x 1 root root 60256 Mar 1 2019 chgrp + -rwxr-xr-x 1 root root 56096 Mar 1 2019 chmod + -rwxr-xr-x 1 root root 64368 Mar 1 2019 chown + -rwxr-xr-x 1 root root 134632 Mar 1 2019 cp + -rwxr-xr-x 1 root root 129536 Jan 18 2019 dash + -rwxr-xr-x 1 root root 97136 Mar 1 2019 date + -rwxr-xr-x 1 root root 76736 Mar 1 2019 dd + -rwxr-xr-x 1 root root 93752 Mar 1 2019 df + -rwxr-xr-x 1 root root 138848 Mar 1 2019 dir + -rwxr-xr-x 1 root root 75984 Jan 10 2019 dmesg + lrwxrwxrwx 1 root root 8 Sep 27 2018 dnsdomainname -> hostname + lrwxrwxrwx 1 root root 8 Sep 27 2018 domainname -> hostname + -rwxr-xr-x 1 root root 31368 Mar 1 2019 echo + -rwxr-xr-x 1 root root 28 Jan 8 2019 egrep + -rwxr-xr-x 1 root root 27256 Mar 1 2019 false + -rwxr-xr-x 1 root root 28 Jan 8 2019 fgrep + -rwxr-xr-x 1 root root 68792 Jan 10 2019 findmnt + -rwsr-xr-x 1 root root 34824 Apr 23 2020 fusermount + -rwxr-xr-x 1 root root 174304 Jan 8 2019 grep + -rwxr-xr-x 2 root root 2345 Jan 6 2019 gunzip + -rwxr-xr-x 1 root root 6375 Jan 6 2019 gzexe + -rwxr-xr-x 1 root root 89656 Jan 6 2019 gzip + -rwxr-xr-x 1 root root 18440 Sep 27 2018 hostname + -rwxr-xr-x 1 root root 64472 Mar 1 2019 ln + -rwxr-xr-x 1 root root 52544 Jul 27 2018 login + -rwxr-xr-x 1 root root 138848 Mar 1 2019 ls + -rwxr-xr-x 1 root root 108552 Jan 10 2019 lsblk + -rwxr-xr-x 1 root root 76840 Mar 1 2019 mkdir + -rwxr-xr-x 1 root root 64480 Mar 1 2019 mknod + -rwxr-xr-x 1 root root 39736 Mar 1 2019 mktemp + -rwxr-xr-x 1 root root 38840 Jan 10 2019 more + -rwsr-xr-x 1 root root 47112 Jan 10 2019 mount + -rwxr-xr-x 1 root root 14344 Jan 10 2019 mountpoint + -rwxr-xr-x 1 root root 138736 Mar 1 2019 mv + lrwxrwxrwx 1 root root 8 Sep 27 2018 nisdomainname -> hostname + lrwxrwxrwx 1 root root 14 Feb 15 2019 pidof -> /sbin/killall5 + -rwxr-xr-x 1 root root 35560 Mar 1 2019 pwd + lrwxrwxrwx 1 root root 4 Apr 18 2019 rbash -> bash + -rwxr-xr-x 1 root root 43712 Mar 1 2019 readlink + -rwxr-xr-x 1 root root 68440 Mar 1 2019 rm + -rwxr-xr-x 1 root root 39624 Mar 1 2019 rmdir + -rwxr-xr-x 1 root root 19144 Jan 22 2019 run-parts + -rwxr-xr-x 1 root root 114016 Dec 23 2018 sed + lrwxrwxrwx 1 root root 4 Aug 25 01:32 sh -> bash + lrwxrwxrwx 1 root root 4 Aug 24 04:49 sh.distrib -> dash + -rwxr-xr-x 1 root root 31384 Mar 1 2019 sleep + -rwxr-xr-x 1 root root 72480 Mar 1 2019 stty + -rwsr-xr-x 1 root root 59424 Jan 10 2019 su + -rwxr-xr-x 1 root root 31416 Mar 1 2019 sync + -rwxr-xr-x 1 root root 449416 Apr 24 2019 tar + -rwxr-xr-x 1 root root 10560 Jan 22 2019 tempfile + -rwxr-xr-x 1 root root 88968 Mar 1 2019 touch + -rwxr-xr-x 1 root root 27256 Mar 1 2019 true + -rwxr-xr-x 1 root root 14264 Apr 23 2020 ulockmgr_server + -rwsr-xr-x 1 root root 30728 Jan 10 2019 umount + -rwxr-xr-x 1 root root 31384 Mar 1 2019 uname + -rwxr-xr-x 2 root root 2345 Jan 6 2019 uncompress + -rwxr-xr-x 1 root root 138848 Mar 1 2019 vdir + -rwxr-xr-x 1 root root 34824 Jan 10 2019 wdctl + -rwxr-xr-x 1 root root 946 Jan 22 2019 which + lrwxrwxrwx 1 root root 8 Sep 27 2018 ypdomainname -> hostname + -rwxr-xr-x 1 root root 1983 Jan 6 2019 zcat + -rwxr-xr-x 1 root root 1677 Jan 6 2019 zcmp + -rwxr-xr-x 1 root root 5879 Jan 6 2019 zdiff + -rwxr-xr-x 1 root root 29 Jan 6 2019 zegrep + -rwxr-xr-x 1 root root 29 Jan 6 2019 zfgrep + -rwxr-xr-x 1 root root 2080 Jan 6 2019 zforce + -rwxr-xr-x 1 root root 7584 Jan 6 2019 zgrep + -rwxr-xr-x 1 root root 2205 Jan 6 2019 zless + -rwxr-xr-x 1 root root 1841 Jan 6 2019 zmore + -rwxr-xr-x 1 root root 4552 Jan 6 2019 znew +I: user script /srv/workspace/pbuilder/29606/tmp/hooks/D02_print_environment finished -> Attempting to satisfy build-dependencies -> Creating pbuilder-satisfydepends-dummy package Package: pbuilder-satisfydepends-dummy @@ -507,7 +541,7 @@ Get: 269 http://deb.debian.org/debian buster/main arm64 maven-repo-helper all 1.9.3 [142 kB] Get: 270 http://deb.debian.org/debian buster/main arm64 maven-debian-helper all 2.3.2 [122 kB] Get: 271 http://deb.debian.org/debian buster/main arm64 thrift-compiler arm64 0.11.0-4 [1106 kB] -Fetched 353 MB in 52s (6794 kB/s) +Fetched 353 MB in 1min 4s (5499 kB/s) debconf: delaying package configuration, since apt-utils is not installed Selecting previously unselected package libbsd0:arm64. (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 ... 19168 files and directories currently installed.) @@ -1796,7 +1830,7 @@ fakeroot is already the newest version (1.23-1). 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. I: Building the package -I: Running cd /build/avro-java-1.7.7/ && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games" HOME="/nonexistent/first-build" dpkg-buildpackage -us -uc -b +I: Running cd /build/avro-java-1.7.7/ && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/i/capture/the/path" HOME="/nonexistent/second-build" dpkg-buildpackage -us -uc -b dpkg-buildpackage: info: source package avro-java dpkg-buildpackage: info: source version 1.7.7-3 dpkg-buildpackage: info: source distribution unstable @@ -2209,15 +2243,15 @@ [INFO] Reactor Summary for Apache Avro Toplevel 1.7.7: [INFO] [INFO] Apache Avro Toplevel ............................... SUCCESS [ 0.010 s] -[INFO] Apache Avro Java ................................... SUCCESS [ 0.168 s] -[INFO] Apache Avro ........................................ SUCCESS [ 13.984 s] -[INFO] Apache Avro Compiler ............................... SUCCESS [ 2.587 s] -[INFO] Apache Avro Maven Plugin ........................... SUCCESS [ 4.778 s] +[INFO] Apache Avro Java ................................... SUCCESS [ 0.178 s] +[INFO] Apache Avro ........................................ SUCCESS [ 15.222 s] +[INFO] Apache Avro Compiler ............................... SUCCESS [ 2.627 s] +[INFO] Apache Avro Maven Plugin ........................... SUCCESS [ 5.176 s] [INFO] ------------------------------------------------------------------------ [INFO] BUILD SUCCESS [INFO] ------------------------------------------------------------------------ -[INFO] Total time: 23.439 s -[INFO] Finished at: 2020-07-21T17:01:22-12:00 +[INFO] Total time: 25.306 s +[INFO] Finished at: 2021-08-25T01:34:47+14:00 [INFO] ------------------------------------------------------------------------ dh_auto_test /usr/lib/jvm/default-java/bin/java -noverify -cp /usr/share/maven/boot/plexus-classworlds-2.x.jar -Dmaven.home=/usr/share/maven -Dmaven.multiModuleProjectDirectory=/build/avro-java-1.7.7 -Dclassworlds.conf=/etc/maven/m2-debian.conf -Dproperties.file.manual=/build/avro-java-1.7.7/debian/maven.properties org.codehaus.plexus.classworlds.launcher.Launcher -s/etc/maven/settings-debian.xml -Ddebian.dir=/build/avro-java-1.7.7/debian -Dmaven.repo.local=/build/avro-java-1.7.7/debian/maven-repo --batch-mode test @@ -2279,45 +2313,45 @@ [INFO] T E S T S [INFO] ------------------------------------------------------- [INFO] Running org.apache.avro.TestSchema -[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.588 s - in org.apache.avro.TestSchema +[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.602 s - in org.apache.avro.TestSchema [INFO] Running org.apache.avro.TestSchemaNormalization -[INFO] Tests run: 60, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.689 s - in org.apache.avro.TestSchemaNormalization +[INFO] Tests run: 60, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.746 s - in org.apache.avro.TestSchemaNormalization [INFO] Running org.apache.avro.TestSchemaValidation -[INFO] Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.73 s - in org.apache.avro.TestSchemaValidation +[INFO] Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.734 s - in org.apache.avro.TestSchemaValidation [INFO] Running org.apache.avro.util.TestUtf8 -[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.13 s - in org.apache.avro.util.TestUtf8 +[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.129 s - in org.apache.avro.util.TestUtf8 [INFO] Running org.apache.avro.util.TestCaseFinder -[INFO] Tests run: 17, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.205 s - in org.apache.avro.util.TestCaseFinder +[INFO] Tests run: 17, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.209 s - in org.apache.avro.util.TestCaseFinder [INFO] Running org.apache.avro.TestDataFile -[INFO] Tests run: 36, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.397 s - in org.apache.avro.TestDataFile +[INFO] Tests run: 36, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.963 s - in org.apache.avro.TestDataFile [INFO] Running org.apache.avro.specific.TestSpecificData -[INFO] Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.509 s - in org.apache.avro.specific.TestSpecificData +[INFO] Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.548 s - in org.apache.avro.specific.TestSpecificData [INFO] Running org.apache.avro.TestDataFileDeflate -[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.581 s - in org.apache.avro.TestDataFileDeflate +[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.628 s - in org.apache.avro.TestDataFileDeflate [INFO] Running org.apache.avro.TestDataFileConcat -[INFO] Tests run: 10, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.325 s - in org.apache.avro.TestDataFileConcat +[INFO] Tests run: 10, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.65 s - in org.apache.avro.TestDataFileConcat [INFO] Running org.apache.avro.TestDataFileReflect -[INFO] Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.702 s - in org.apache.avro.TestDataFileReflect +[INFO] Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.796 s - in org.apache.avro.TestDataFileReflect [INFO] Running org.apache.avro.TestSchemaCompatibility -[INFO] Tests run: 11, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.686 s - in org.apache.avro.TestSchemaCompatibility +[INFO] Tests run: 11, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.345 s - in org.apache.avro.TestSchemaCompatibility [INFO] Running org.apache.avro.file.TestBZip2Codec -[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.249 s - in org.apache.avro.file.TestBZip2Codec +[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.274 s - in org.apache.avro.file.TestBZip2Codec [INFO] Running org.apache.avro.file.TestCustomCodec -[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.165 s - in org.apache.avro.file.TestCustomCodec +[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.185 s - in org.apache.avro.file.TestCustomCodec [INFO] Running org.apache.avro.file.TestSeekableByteArrayInput -[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.635 s - in org.apache.avro.file.TestSeekableByteArrayInput +[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.623 s - in org.apache.avro.file.TestSeekableByteArrayInput [INFO] Running org.apache.avro.file.TestLengthLimitedInputStream -[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.126 s - in org.apache.avro.file.TestLengthLimitedInputStream +[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.133 s - in org.apache.avro.file.TestLengthLimitedInputStream [INFO] Running org.apache.avro.TestDataFileMeta -[INFO] Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.653 s - in org.apache.avro.TestDataFileMeta +[INFO] Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.594 s - in org.apache.avro.TestDataFileMeta [INFO] Running org.apache.avro.reflect.TestReflectDatumReader -[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.629 s - in org.apache.avro.reflect.TestReflectDatumReader +[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.592 s - in org.apache.avro.reflect.TestReflectDatumReader [INFO] Running org.apache.avro.reflect.TestReflectionUtil -[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.196 s - in org.apache.avro.reflect.TestReflectionUtil +[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.198 s - in org.apache.avro.reflect.TestReflectionUtil [INFO] Running org.apache.avro.reflect.TestByteBuffer -[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.915 s - in org.apache.avro.reflect.TestByteBuffer +[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.918 s - in org.apache.avro.reflect.TestByteBuffer [INFO] Running org.apache.avro.reflect.TestReflect -[ERROR] Tests run: 59, Failures: 2, Errors: 1, Skipped: 0, Time elapsed: 0.976 s <<< FAILURE! - in org.apache.avro.reflect.TestReflect +[ERROR] Tests run: 59, Failures: 2, Errors: 1, Skipped: 0, Time elapsed: 0.972 s <<< FAILURE! - in org.apache.avro.reflect.TestReflect [ERROR] testP0(org.apache.avro.reflect.TestReflect) Time elapsed: 0.017 s <<< FAILURE! java.lang.AssertionError: field 's' should not be null at org.apache.avro.reflect.TestReflect.testP0(TestReflect.java:316) @@ -2331,37 +2365,37 @@ at org.apache.avro.reflect.TestReflect.testP4(TestReflect.java:436) [INFO] Running org.apache.avro.TestSchemaBuilder -[INFO] Tests run: 29, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.841 s - in org.apache.avro.TestSchemaBuilder +[INFO] Tests run: 29, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.855 s - in org.apache.avro.TestSchemaBuilder [INFO] Running org.apache.avro.generic.TestGenericRecordBuilder -[INFO] Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.542 s - in org.apache.avro.generic.TestGenericRecordBuilder +[INFO] Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.536 s - in org.apache.avro.generic.TestGenericRecordBuilder [INFO] Running org.apache.avro.generic.TestGenericData -[INFO] Tests run: 23, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.617 s - in org.apache.avro.generic.TestGenericData +[INFO] Tests run: 23, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.613 s - in org.apache.avro.generic.TestGenericData [INFO] Running org.apache.avro.generic.TestGenericDatumWriter -[INFO] Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.663 s - in org.apache.avro.generic.TestGenericDatumWriter +[INFO] Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.659 s - in org.apache.avro.generic.TestGenericDatumWriter [INFO] Running org.apache.avro.TestProtocol -[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.62 s - in org.apache.avro.TestProtocol +[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.614 s - in org.apache.avro.TestProtocol [INFO] Running org.apache.avro.io.TestJsonDecoder -[INFO] Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.631 s - in org.apache.avro.io.TestJsonDecoder +[INFO] Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.557 s - in org.apache.avro.io.TestJsonDecoder [INFO] Running org.apache.avro.io.TestBlockingIO -[INFO] Tests run: 376, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.679 s - in org.apache.avro.io.TestBlockingIO +[INFO] Tests run: 376, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.649 s - in org.apache.avro.io.TestBlockingIO [INFO] Running org.apache.avro.io.TestResolvingIOResolving -[INFO] Tests run: 192, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.266 s - in org.apache.avro.io.TestResolvingIOResolving +[INFO] Tests run: 192, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.143 s - in org.apache.avro.io.TestResolvingIOResolving [INFO] Running org.apache.avro.io.TestBinaryEncoderFidelity -[INFO] Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.193 s - in org.apache.avro.io.TestBinaryEncoderFidelity +[INFO] Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.192 s - in org.apache.avro.io.TestBinaryEncoderFidelity [INFO] Running org.apache.avro.io.TestEncoders -[INFO] Tests run: 16, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.659 s - in org.apache.avro.io.TestEncoders +[INFO] Tests run: 16, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.623 s - in org.apache.avro.io.TestEncoders [INFO] Running org.apache.avro.io.TestResolvingIO -[INFO] Tests run: 816, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.349 s - in org.apache.avro.io.TestResolvingIO +[INFO] Tests run: 816, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.038 s - in org.apache.avro.io.TestResolvingIO [INFO] Running org.apache.avro.io.TestValidatingIO -[INFO] Tests run: 972, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.252 s - in org.apache.avro.io.TestValidatingIO +[INFO] Tests run: 972, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.064 s - in org.apache.avro.io.TestValidatingIO [INFO] Running org.apache.avro.io.TestBinaryDecoder -[INFO] Tests run: 46, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.917 s - in org.apache.avro.io.TestBinaryDecoder +[INFO] Tests run: 46, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.822 s - in org.apache.avro.io.TestBinaryDecoder [INFO] Running org.apache.avro.io.parsing.TestResolvingGrammarGenerator2 -[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.538 s - in org.apache.avro.io.parsing.TestResolvingGrammarGenerator2 +[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.551 s - in org.apache.avro.io.parsing.TestResolvingGrammarGenerator2 [INFO] Running org.apache.avro.io.parsing.TestResolvingGrammarGenerator -[INFO] Tests run: 32, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.845 s - in org.apache.avro.io.parsing.TestResolvingGrammarGenerator +[INFO] Tests run: 32, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.861 s - in org.apache.avro.io.parsing.TestResolvingGrammarGenerator [INFO] Running org.apache.avro.io.TestBlockingIO2 -[INFO] Tests run: 84, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.408 s - in org.apache.avro.io.TestBlockingIO2 +[INFO] Tests run: 84, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.427 s - in org.apache.avro.io.TestBlockingIO2 [INFO] [INFO] Results: [INFO] @@ -2413,9 +2447,9 @@ [INFO] T E S T S [INFO] ------------------------------------------------------- [INFO] Running org.apache.avro.compiler.TestSpecificCompiler -[INFO] Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.401 s - in org.apache.avro.compiler.TestSpecificCompiler +[INFO] Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.545 s - in org.apache.avro.compiler.TestSpecificCompiler [INFO] Running org.apache.avro.compiler.idl.TestIdl -[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.999 s - in org.apache.avro.compiler.idl.TestIdl +[INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.867 s - in org.apache.avro.compiler.idl.TestIdl [INFO] [INFO] Results: [INFO] @@ -2677,11 +2711,11 @@ [INFO] T E S T S [INFO] ------------------------------------------------------- [INFO] Running org.apache.avro.mojo.TestProtocolMojo -[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.255 s - in org.apache.avro.mojo.TestProtocolMojo +[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.493 s - in org.apache.avro.mojo.TestProtocolMojo [INFO] Running org.apache.avro.mojo.TestSchemaMojo -[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.613 s - in org.apache.avro.mojo.TestSchemaMojo +[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.679 s - in org.apache.avro.mojo.TestSchemaMojo [INFO] Running org.apache.avro.mojo.TestIDLProtocolMojo -[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.383 s - in org.apache.avro.mojo.TestIDLProtocolMojo +[INFO] Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.983 s - in org.apache.avro.mojo.TestIDLProtocolMojo [INFO] [INFO] Results: [INFO] @@ -2690,16 +2724,16 @@ [INFO] ------------------------------------------------------------------------ [INFO] Reactor Summary for Apache Avro Toplevel 1.7.7: [INFO] -[INFO] Apache Avro Toplevel ............................... SUCCESS [ 0.009 s] -[INFO] Apache Avro Java ................................... SUCCESS [ 0.181 s] +[INFO] Apache Avro Toplevel ............................... SUCCESS [ 0.011 s] +[INFO] Apache Avro Java ................................... SUCCESS [ 0.174 s] [INFO] Apache Avro ........................................ SUCCESS [06:03 min] -[INFO] Apache Avro Compiler ............................... SUCCESS [ 24.642 s] -[INFO] Apache Avro Maven Plugin ........................... SUCCESS [ 35.125 s] +[INFO] Apache Avro Compiler ............................... SUCCESS [ 24.885 s] +[INFO] Apache Avro Maven Plugin ........................... SUCCESS [ 35.004 s] [INFO] ------------------------------------------------------------------------ [INFO] BUILD SUCCESS [INFO] ------------------------------------------------------------------------ [INFO] Total time: 07:05 min -[INFO] Finished at: 2020-07-21T17:08:31-12:00 +[INFO] Finished at: 2021-08-25T01:41:56+14:00 [INFO] ------------------------------------------------------------------------ create-stamp debian/debhelper-build-stamp fakeroot debian/rules binary @@ -2784,16 +2818,16 @@ [INFO] ------------------------------------------------------------------------ [INFO] Reactor Summary for Apache Avro Toplevel 1.7.7: [INFO] -[INFO] Apache Avro Toplevel ............................... SUCCESS [ 0.516 s] -[INFO] Apache Avro Java ................................... SUCCESS [ 0.319 s] -[INFO] Apache Avro ........................................ SUCCESS [ 0.223 s] -[INFO] Apache Avro Compiler ............................... SUCCESS [ 0.085 s] -[INFO] Apache Avro Maven Plugin ........................... SUCCESS [ 0.042 s] +[INFO] Apache Avro Toplevel ............................... SUCCESS [ 0.754 s] +[INFO] Apache Avro Java ................................... SUCCESS [ 0.429 s] +[INFO] Apache Avro ........................................ SUCCESS [ 0.267 s] +[INFO] Apache Avro Compiler ............................... SUCCESS [ 0.116 s] +[INFO] Apache Avro Maven Plugin ........................... SUCCESS [ 0.046 s] [INFO] ------------------------------------------------------------------------ [INFO] BUILD SUCCESS [INFO] ------------------------------------------------------------------------ -[INFO] Total time: 3.288 s -[INFO] Finished at: 2020-07-21T17:08:39-12:00 +[INFO] Total time: 4.084 s +[INFO] Finished at: 2021-08-25T01:42:05+14:00 [INFO] ------------------------------------------------------------------------ mh_resolve_dependencies --non-interactive --offline --build -plibavro-java --base-directory=/build/avro-java-1.7.7 --non-explore Analysing pom.xml... @@ -2822,8 +2856,8 @@ dpkg-gencontrol: warning: package libavro-java: substitution variable ${maven:OptionalDepends} unused, but is defined dh_md5sums dh_builddeb -dpkg-deb: building package 'libavro-java' in '../libavro-java_1.7.7-3_all.deb'. dpkg-deb: building package 'libavro-maven-plugin-java' in '../libavro-maven-plugin-java_1.7.7-3_all.deb'. +dpkg-deb: building package 'libavro-java' in '../libavro-java_1.7.7-3_all.deb'. dpkg-deb: building package 'libavro-compiler-java' in '../libavro-compiler-java_1.7.7-3_all.deb'. dpkg-genbuildinfo --build=binary dpkg-genchanges --build=binary >../avro-java_1.7.7-3_arm64.changes @@ -2831,12 +2865,14 @@ dpkg-source --after-build . dpkg-buildpackage: info: binary-only upload (no source included) I: copying local configuration +I: user script /srv/workspace/pbuilder/29606/tmp/hooks/B01_cleanup starting +I: user script /srv/workspace/pbuilder/29606/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/27727 and its subdirectories -I: Current time: Tue Jul 21 17:08:53 -12 2020 -I: pbuilder-time-stamp: 1595394533 +I: removing directory /srv/workspace/pbuilder/29606 and its subdirectories +I: Current time: Wed Aug 25 01:42:23 +14 2021 +I: pbuilder-time-stamp: 1629805343