Diff of the two buildlogs: -- --- b1/build.log 2024-05-16 03:30:55.473687758 +0000 +++ b2/build.log 2024-05-16 03:41:33.918538361 +0000 @@ -1,6 +1,6 @@ I: pbuilder: network access will be disabled during build -I: Current time: Tue Jun 17 21:51:40 -12 2025 -I: pbuilder-time-stamp: 1750240300 +I: Current time: Thu May 16 17:31:00 +14 2024 +I: pbuilder-time-stamp: 1715830260 I: Building the build Environment I: extracting base tarball [/var/cache/pbuilder/unstable-reproducible-base.tgz] I: copying local configuration @@ -27,52 +27,84 @@ dpkg-source: info: applying testdata.patch I: using fakeroot in build. I: Installing the build-deps -I: user script /srv/workspace/pbuilder/2237306/tmp/hooks/D02_print_environment starting +I: user script /srv/workspace/pbuilder/1055250/tmp/hooks/D01_modify_environment starting +debug: Running on ionos1-amd64. +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 May 16 03:31 /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/1055250/tmp/hooks/D01_modify_environment finished +I: user script /srv/workspace/pbuilder/1055250/tmp/hooks/D02_print_environment starting I: set - BUILDDIR='/build/reproducible-path' - BUILDUSERGECOS='first user,first room,first work-phone,first home-phone,first other' - BUILDUSERNAME='pbuilder1' - BUILD_ARCH='amd64' - DEBIAN_FRONTEND='noninteractive' - DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all parallel=42 ' - DISTRIBUTION='unstable' - HOME='/root' - HOST_ARCH='amd64' + 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]="21" [3]="1" [4]="release" [5]="x86_64-pc-linux-gnu") + BASH_VERSION='5.2.21(1)-release' + BUILDDIR=/build/reproducible-path + BUILDUSERGECOS='second user,second room,second work-phone,second home-phone,second other' + BUILDUSERNAME=pbuilder2 + BUILD_ARCH=amd64 + DEBIAN_FRONTEND=noninteractive + DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all parallel=20 ' + DIRSTACK=() + DISTRIBUTION=unstable + EUID=0 + FUNCNAME=([0]="Echo" [1]="main") + GROUPS=() + HOME=/root + HOSTNAME=i-capture-the-hostname + HOSTTYPE=x86_64 + HOST_ARCH=amd64 IFS=' ' - INVOCATION_ID='9ae42ab2fba94912999baa47792f2957' - 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='2237306' - PS1='# ' - PS2='> ' + INVOCATION_ID=967d7dc722464b5d9e60e8b12e0e29f6 + LANG=C + LANGUAGE=et_EE:et + LC_ALL=C + MACHTYPE=x86_64-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=1055250 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.7C7qxzZl/pbuilderrc_pe7g --distribution unstable --hookdir /etc/pbuilder/first-build-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/unstable-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/r-b-build.7C7qxzZl/b1 --logfile b1/build.log golang-github-cznic-ql_1.0.6-1.1.dsc' - SUDO_GID='111' - SUDO_UID='106' - SUDO_USER='jenkins' - TERM='unknown' - TZ='/usr/share/zoneinfo/Etc/GMT+12' - USER='root' - _='/usr/bin/systemd-run' - http_proxy='http://213.165.73.152: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.7C7qxzZl/pbuilderrc_SsKw --distribution unstable --hookdir /etc/pbuilder/rebuild-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/unstable-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/r-b-build.7C7qxzZl/b2 --logfile b2/build.log golang-github-cznic-ql_1.0.6-1.1.dsc' + SUDO_GID=110 + SUDO_UID=105 + SUDO_USER=jenkins + TERM=unknown + TZ=/usr/share/zoneinfo/Etc/GMT-14 + UID=0 + USER=root + _='I: set' + http_proxy=http://46.16.76.132:3128 I: uname -a - Linux ionos15-amd64 6.6.13+bpo-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.6.13-1~bpo12+1 (2024-02-15) x86_64 GNU/Linux + Linux i-capture-the-hostname 6.1.0-21-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.1.90-1 (2024-05-03) x86_64 GNU/Linux I: ls -l /bin - lrwxrwxrwx 1 root root 7 Jun 16 14:05 /bin -> usr/bin -I: user script /srv/workspace/pbuilder/2237306/tmp/hooks/D02_print_environment finished + lrwxrwxrwx 1 root root 7 May 15 07:43 /bin -> usr/bin +I: user script /srv/workspace/pbuilder/1055250/tmp/hooks/D02_print_environment finished -> Attempting to satisfy build-dependencies -> Creating pbuilder-satisfydepends-dummy package Package: pbuilder-satisfydepends-dummy @@ -171,7 +203,7 @@ Get: 43 http://deb.debian.org/debian unstable/main amd64 golang-github-golang-snappy-dev all 0.0.2-3 [53.9 kB] Get: 44 http://deb.debian.org/debian unstable/main amd64 golang-github-cznic-zappy-dev all 0.0~git20160305.0.4f5e6ef-3 [11.1 kB] Get: 45 http://deb.debian.org/debian unstable/main amd64 golang-github-cznic-lldb-dev all 1.0.1-1.1 [169 kB] -Fetched 63.1 MB in 1s (83.6 MB/s) +Fetched 63.1 MB in 4s (16.7 MB/s) debconf: delaying package configuration, since apt-utils is not installed Selecting previously unselected package sensible-utils. (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 ... 19701 files and directories currently installed.) @@ -371,7 +403,11 @@ fakeroot is already the newest version (1.34-1). 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. I: Building the package -I: Running cd /build/reproducible-path/golang-github-cznic-ql-1.0.6/ && 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-cznic-ql_1.0.6-1.1_source.changes +I: user script /srv/workspace/pbuilder/1055250/tmp/hooks/A99_set_merged_usr starting +Not re-configuring usrmerge for unstable +I: user script /srv/workspace/pbuilder/1055250/tmp/hooks/A99_set_merged_usr finished +hostname: Name or service not known +I: Running cd /build/reproducible-path/golang-github-cznic-ql-1.0.6/ && 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-cznic-ql_1.0.6-1.1_source.changes dpkg-buildpackage: info: source package golang-github-cznic-ql dpkg-buildpackage: info: source version 1.0.6-1.1 dpkg-buildpackage: info: source distribution unstable @@ -696,7 +732,7 @@ [2 b 2014-01-12 17:27:00 +0000] [1 hello 2014-01-12 17:28:00 +0000] ---- ---- FAIL: TestMemStorage (0.36s) +--- FAIL: TestMemStorage (3.20s) === RUN TestFileStorage storage_test.go:250: FAIL: 427 unknown time zone CET storage_test.go:250: FAIL: 429 unknown time zone CET @@ -836,7 +872,7 @@ [2 b 2014-01-12 17:27:00 +0000] [1 hello 2014-01-12 17:28:00 +0000] ---- ---- FAIL: TestFileStorage (1.38s) +--- FAIL: TestFileStorage (16.18s) === RUN TestOSFileStorage storage_test.go:250: FAIL: 427 unknown time zone CET storage_test.go:250: FAIL: 429 unknown time zone CET @@ -976,17 +1012,17 @@ [2 b 2014-01-12 17:27:00 +0000] [1 hello 2014-01-12 17:28:00 +0000] ---- ---- FAIL: TestOSFileStorage (2.93s) +--- FAIL: TestOSFileStorage (18.20s) === RUN TestString ---- PASS: TestString (0.05s) +--- PASS: TestString (0.51s) === RUN TestReopen ---- PASS: TestReopen (6.52s) +--- PASS: TestReopen (0.22s) === RUN TestLastInsertID --- PASS: TestLastInsertID (0.00s) === RUN TestRowsAffected --- PASS: TestRowsAffected (0.00s) === RUN TestIndices ---- PASS: TestIndices (2.13s) +--- PASS: TestIndices (1.04s) === RUN TestIndex all_test.go:1702: id 1 <- true all_test.go:1702: id 2 <- true @@ -1066,7 +1102,7 @@ === RUN TestIssue35 --- PASS: TestIssue35 (0.00s) === RUN TestIssue28 ---- PASS: TestIssue28 (0.02s) +--- PASS: TestIssue28 (0.08s) === RUN TestIssue50 all_test.go:2117: Opening db. all_test.go:2162: md5 of 1.xyz: f0f9b4a8d65e0f7f6a824bffd8182e5c @@ -1075,10 +1111,10 @@ all_test.go:2198: md5 of 13: 3969b3de3ea10b52b039e446d5fe0562 all_test.go:2198: md5 of 12: 17c1d2f49854c7d24903f43b38552862 all_test.go:2198: md5 of 11: f0f9b4a8d65e0f7f6a824bffd8182e5c - all_test.go:2206: Done: [{13 Job-0815 2025-06-18 09:53:44.263533006 +0000 UTC [] 0 2 3 0 0 0.3} {12 Job-0815 2025-06-18 09:53:44.261584306 +0000 UTC [] 0 2 3 0 0 0.3} {11 Job-0815 2025-06-18 09:53:44.259285033 +0000 UTC [] 0 2 3 0 0 0.3}] ---- PASS: TestIssue50 (0.04s) + all_test.go:2206: Done: [{13 Job-0815 2024-05-16 03:40:40.911444594 +0000 UTC [] 0 2 3 0 0 0.3} {12 Job-0815 2024-05-16 03:40:40.903685439 +0000 UTC [] 0 2 3 0 0 0.3} {11 Job-0815 2024-05-16 03:40:40.9002614 +0000 UTC [] 0 2 3 0 0 0.3}] +--- PASS: TestIssue50 (0.44s) === RUN TestIssue56 ---- PASS: TestIssue56 (0.02s) +--- PASS: TestIssue56 (0.11s) === RUN TestRecordSetRows all_test.go:2335: 0 all_test.go:2335: 1 @@ -1106,7 +1142,7 @@ all_test.go:2335: 23 all_test.go:2335: 24 all_test.go:2335: 25 ---- PASS: TestRecordSetRows (0.00s) +--- PASS: TestRecordSetRows (0.01s) === RUN TestRecordFirst all_test.go:2388: 0 all_test.go:2388: 1 @@ -1115,22 +1151,22 @@ all_test.go:2388: 4 all_test.go:2388: 5 all_test.go:2388: 6 ---- PASS: TestRecordFirst (0.00s) +--- PASS: TestRecordFirst (0.01s) === RUN TestIssue63 - all_test.go:2442: invalid operation: 2025-06-18 09:53:44.301732818 +0000 UTC m=+13.443918663 > 0 (mismatched types time.Time and int64) + all_test.go:2442: invalid operation: 2024-05-16 03:40:41.351847758 +0000 UTC m=+40.021331398 > 0 (mismatched types time.Time and int64) --- PASS: TestIssue63 (0.00s) === RUN TestIssue66Mem all_test.go:2472: cannot insert into unique index: duplicate value(s): [1] --- PASS: TestIssue66Mem (0.00s) === RUN TestIssue66File all_test.go:2495: (file-018) cannot insert into unique index: duplicate value(s): [1] ---- PASS: TestIssue66File (0.02s) +--- PASS: TestIssue66File (0.08s) === RUN TestIssue66MemDriver all_test.go:2516: cannot insert into unique index: duplicate value(s): [1] --- PASS: TestIssue66MemDriver (0.00s) === RUN TestIssue66FileDriver all_test.go:2544: (file-018) cannot insert into unique index: duplicate value(s): [1] ---- PASS: TestIssue66FileDriver (0.01s) +--- PASS: TestIssue66FileDriver (0.07s) === RUN TestIssue73 all_test.go:2621: Call to db.Begin() all_test.go:2626: Call to tx.QueryRow() @@ -1172,7 +1208,7 @@ all_test.go:2626: Call to tx.QueryRow() all_test.go:2628: Call to tx.Commit() all_test.go:2634: name: ---- PASS: TestIssue73 (0.02s) +--- PASS: TestIssue73 (0.06s) === RUN TestInPredicateBug --- PASS: TestInPredicateBug (0.00s) === RUN TestIssue108 @@ -1271,7 +1307,7 @@ all_test.go:3306: [â””Output field names ["awards.name" "people_awards.person_id" "people_awards.award_id"]] all_test.go:3320: ---- all_test.go:3235: OK ---- PASS: TestIssue109 (0.00s) +--- PASS: TestIssue109 (0.01s) === RUN TestHTTP --- PASS: TestHTTP (0.00s) === RUN TestSchema @@ -1279,7 +1315,7 @@ introspection_test.go:225: 1 cannot derive schema for () introspection_test.go:225: 11 BEGIN TRANSACTION; CREATE TABLE IF NOT EXISTS testSchema2 (); COMMIT; : 1:60 unexpected ')', expected table column definition or identifier introspection_test.go:225: 14 both index and uindex in QL struct tag ---- PASS: TestSchema (0.00s) +--- PASS: TestSchema (0.01s) === RUN TestMarshal introspection_test.go:541: cannot derive schema for type int (int) introspection_test.go:541: cannot derive schema for type *ql.u (int) @@ -1304,7 +1340,7 @@ === RUN ExampleTCtx_lastInsertID --- PASS: ExampleTCtx_lastInsertID (0.00s) === RUN Example_recordsetFields ---- PASS: Example_recordsetFields (0.00s) +--- PASS: Example_recordsetFields (0.02s) === RUN Example_lIKE --- PASS: Example_lIKE (0.00s) === RUN Example_id @@ -1316,14 +1352,14 @@ === RUN ExampleUnmarshal --- PASS: ExampleUnmarshal (0.00s) FAIL -FAIL github.com/cznic/ql 13.503s +FAIL github.com/cznic/ql 40.352s ? github.com/cznic/ql/design [no test files] === RUN Example_testFile ---- PASS: Example_testFile (0.03s) +--- PASS: Example_testFile (0.11s) === RUN Example_testMem --- PASS: Example_testMem (0.00s) PASS -ok github.com/cznic/ql/driver 0.030s +ok github.com/cznic/ql/driver 0.162s ? github.com/cznic/ql/ql [no test files] === RUN TestLock lock_test.go:79: test lock, portable false @@ -1335,7 +1371,7 @@ lock_test.go:125: Locking in child... lock_test.go:130: Unlocking lock in parent lock_test.go:135: Trying lock again in child... ---- PASS: TestLock (0.01s) +--- PASS: TestLock (0.11s) === RUN TestLockPortable lock_test.go:79: test lock, portable true lock_test.go:92: First lock in child @@ -1346,11 +1382,11 @@ lock_test.go:125: Locking in child... lock_test.go:130: Unlocking lock in parent lock_test.go:135: Trying lock again in child... ---- PASS: TestLockPortable (0.01s) +--- PASS: TestLockPortable (0.11s) === RUN TestLockInChild --- PASS: TestLockInChild (0.00s) PASS -ok github.com/cznic/ql/vendored/github.com/camlistore/go4/lock 0.013s +ok github.com/cznic/ql/vendored/github.com/camlistore/go4/lock 0.270s FAIL dh_auto_test: error: cd _build && go test -vet=off -v -p 1 github.com/cznic/ql github.com/cznic/ql/design github.com/cznic/ql/driver github.com/cznic/ql/ql github.com/cznic/ql/vendored/github.com/camlistore/go4/lock returned exit code 1 make[1]: [debian/rules:10: override_dh_auto_test] Error 255 (ignored) @@ -1403,12 +1439,14 @@ dpkg-buildpackage: info: binary-only upload (no source included) dpkg-genchanges: info: not including original source code in upload I: copying local configuration +I: user script /srv/workspace/pbuilder/1055250/tmp/hooks/B01_cleanup starting +I: user script /srv/workspace/pbuilder/1055250/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/2237306 and its subdirectories -I: Current time: Tue Jun 17 21:53:52 -12 2025 -I: pbuilder-time-stamp: 1750240432 +I: removing directory /srv/workspace/pbuilder/1055250 and its subdirectories +I: Current time: Thu May 16 17:41:33 +14 2024 +I: pbuilder-time-stamp: 1715830893