Diff of the two buildlogs: -- --- b1/build.log 2024-04-17 06:21:06.149240947 +0000 +++ b2/build.log 2024-04-17 06:27:53.795958323 +0000 @@ -1,6 +1,6 @@ I: pbuilder: network access will be disabled during build -I: Current time: Tue Apr 16 18:17:49 -12 2024 -I: pbuilder-time-stamp: 1713334669 +I: Current time: Wed Apr 17 20:21:16 +14 2024 +I: pbuilder-time-stamp: 1713334876 I: Building the build Environment I: extracting base tarball [/var/cache/pbuilder/trixie-reproducible-base.tgz] I: copying local configuration @@ -29,52 +29,84 @@ dpkg-source: info: applying openjdk-21.patch I: Not using root during the build. I: Installing the build-deps -I: user script /srv/workspace/pbuilder/23253/tmp/hooks/D02_print_environment starting +I: user script /srv/workspace/pbuilder/1533/tmp/hooks/D01_modify_environment starting +debug: Running on virt64c. +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 17 06:21 /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/1533/tmp/hooks/D01_modify_environment finished +I: user script /srv/workspace/pbuilder/1533/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='armhf' - DEBIAN_FRONTEND='noninteractive' - DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all parallel=3 ' - DISTRIBUTION='trixie' - HOME='/root' - HOST_ARCH='armhf' + 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]="arm-unknown-linux-gnueabihf") + 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=armhf + DEBIAN_FRONTEND=noninteractive + DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all parallel=4 ' + DIRSTACK=() + DISTRIBUTION=trixie + EUID=0 + FUNCNAME=([0]="Echo" [1]="main") + GROUPS=() + HOME=/root + HOSTNAME=i-capture-the-hostname + HOSTTYPE=arm + HOST_ARCH=armhf IFS=' ' - INVOCATION_ID='50d5d46b0ffc4b728e1d58a37c1eb09a' - 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='23253' - PS1='# ' - PS2='> ' + INVOCATION_ID=ca87ab4668fc4eeb80ffb7331a7be169 + LANG=C + LANGUAGE=it_CH:it + LC_ALL=C + MACHTYPE=arm-unknown-linux-gnueabihf + MAIL=/var/mail/root + OPTERR=1 + OPTIND=1 + OSTYPE=linux-gnueabihf + 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=1533 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.tGr2rllc/pbuilderrc_AALj --distribution trixie --hookdir /etc/pbuilder/first-build-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/trixie-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/r-b-build.tGr2rllc/b1 --logfile b1/build.log grengine_3.0.2+dfsg-2.dsc' - SUDO_GID='110' - SUDO_UID='103' - SUDO_USER='jenkins' - TERM='unknown' - TZ='/usr/share/zoneinfo/Etc/GMT+12' - USER='root' - _='/usr/bin/systemd-run' - http_proxy='http://10.0.0.15:3142/' + 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.tGr2rllc/pbuilderrc_NB6G --distribution trixie --hookdir /etc/pbuilder/rebuild-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/trixie-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/r-b-build.tGr2rllc/b2 --logfile b2/build.log grengine_3.0.2+dfsg-2.dsc' + SUDO_GID=113 + SUDO_UID=107 + SUDO_USER=jenkins + TERM=unknown + TZ=/usr/share/zoneinfo/Etc/GMT-14 + UID=0 + USER=root + _='I: set' + http_proxy=http://10.0.0.15:3142/ I: uname -a - Linux virt32z 6.1.0-20-armmp-lpae #1 SMP Debian 6.1.85-1 (2024-04-11) armv7l GNU/Linux + Linux i-capture-the-hostname 6.1.0-20-arm64 #1 SMP Debian 6.1.85-1 (2024-04-11) aarch64 GNU/Linux I: ls -l /bin lrwxrwxrwx 1 root root 7 Apr 16 11:24 /bin -> usr/bin -I: user script /srv/workspace/pbuilder/23253/tmp/hooks/D02_print_environment finished +I: user script /srv/workspace/pbuilder/1533/tmp/hooks/D02_print_environment finished -> Attempting to satisfy build-dependencies -> Creating pbuilder-satisfydepends-dummy package Package: pbuilder-satisfydepends-dummy @@ -386,7 +418,7 @@ Get: 258 http://deb.debian.org/debian trixie/main armhf libpicocli-java all 4.6.2-2 [390 kB] Get: 259 http://deb.debian.org/debian trixie/main armhf libunivocity-parsers-java all 2.9.1-1 [397 kB] Get: 260 http://deb.debian.org/debian trixie/main armhf junit5 all 5.10.1-1 [2458 kB] -Fetched 234 MB in 3s (85.5 MB/s) +Fetched 234 MB in 6s (39.8 MB/s) debconf: delaying package configuration, since apt-utils is not installed Selecting previously unselected package libpipeline1:armhf. (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 ... 19635 files and directories currently installed.) @@ -1238,8 +1270,8 @@ Setting up tzdata (2024a-1) ... Current default time zone: 'Etc/UTC' -Local time is now: Wed Apr 17 06:18:59 UTC 2024. -Universal Time is now: Wed Apr 17 06:18:59 UTC 2024. +Local time is now: Wed Apr 17 06:24:23 UTC 2024. +Universal Time is now: Wed Apr 17 06:24:23 UTC 2024. Run 'dpkg-reconfigure tzdata' if you wish to change it. Setting up libgeronimo-annotation-1.3-spec-java (1.3-1) ... @@ -1646,7 +1678,11 @@ Building tag database... -> Finished parsing the build-deps I: Building the package -I: Running cd /build/reproducible-path/grengine-3.0.2+dfsg/ && 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 > ../grengine_3.0.2+dfsg-2_source.changes +I: user script /srv/workspace/pbuilder/1533/tmp/hooks/A99_set_merged_usr starting +Not re-configuring usrmerge for trixie +I: user script /srv/workspace/pbuilder/1533/tmp/hooks/A99_set_merged_usr finished +hostname: Name or service not known +I: Running cd /build/reproducible-path/grengine-3.0.2+dfsg/ && 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 > ../grengine_3.0.2+dfsg-2_source.changes dpkg-buildpackage: info: source package grengine dpkg-buildpackage: info: source version 3.0.2+dfsg-2 dpkg-buildpackage: info: source distribution unstable @@ -1671,7 +1707,7 @@ dh_auto_build -O--buildsystem=gradle mkdir -p .gradle/init.d cp /usr/share/gradle-debian-helper/init.gradle .gradle/init.d/ - gradle --info --console plain --offline --stacktrace --no-daemon --refresh-dependencies --gradle-user-home .gradle -Duser.home=. -Duser.name=debian -Ddebian.package=grengine -Dfile.encoding=UTF-8 --parallel --max-workers=3 jar + gradle --info --console plain --offline --stacktrace --no-daemon --refresh-dependencies --gradle-user-home .gradle -Duser.home=. -Duser.name=debian -Ddebian.package=grengine -Dfile.encoding=UTF-8 --parallel --max-workers=4 jar openjdk version "17.0.10" 2024-01-16 OpenJDK Runtime Environment (build 17.0.10+7-Debian-1) OpenJDK Server VM (build 17.0.10+7-Debian-1, mixed mode, sharing) @@ -1679,18 +1715,18 @@ To honour the JVM settings for this build a new JVM will be forked. Please consider using the daemon: https://docs.gradle.org/4.4.1/userguide/gradle_daemon.html. Starting process 'Gradle build daemon'. Working directory: /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/daemon/4.4.1 Command: /usr/lib/jvm/java-17-openjdk-armhf/bin/java --add-opens java.base/java.lang=ALL-UNNAMED -Xbootclasspath/a:/usr/share/java/gradle-helper-hook.jar:/usr/share/java/maven-repo-helper.jar -Dfile.encoding=UTF-8 -Duser.country=US -Duser.language=en -Duser.variant -cp /usr/share/gradle/lib/gradle-launcher-4.4.1.jar org.gradle.launcher.daemon.bootstrap.GradleDaemon 4.4.1 Successfully started process 'Gradle build daemon' -An attempt to start the daemon took 2.225 secs. -The client will now receive all logging from the daemon (pid: 30556). The daemon log file: /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/daemon/4.4.1/daemon-30556.out.log +An attempt to start the daemon took 3.692 secs. +The client will now receive all logging from the daemon (pid: 16487). The daemon log file: /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/daemon/4.4.1/daemon-16487.out.log Daemon will be stopped at the end of the build stopping after processing Closing daemon's stdin at end of input. The daemon will no longer process any standard input. -Using 3 worker leases. -Creating new cache for fileHashes, path /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/caches/4.4.1/fileHashes/fileHashes.bin, access org.gradle.cache.internal.DefaultCacheAccess@10fa1cb -Creating new cache for resourceHashesCache, path /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/caches/4.4.1/fileHashes/resourceHashesCache.bin, access org.gradle.cache.internal.DefaultCacheAccess@10fa1cb -Creating new cache for fileHashes, path /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/4.4.1/fileHashes/fileHashes.bin, access org.gradle.cache.internal.DefaultCacheAccess@4f5b18 +Using 4 worker leases. +Creating new cache for fileHashes, path /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/caches/4.4.1/fileHashes/fileHashes.bin, access org.gradle.cache.internal.DefaultCacheAccess@eb577e +Creating new cache for resourceHashesCache, path /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/caches/4.4.1/fileHashes/resourceHashesCache.bin, access org.gradle.cache.internal.DefaultCacheAccess@eb577e +Creating new cache for fileHashes, path /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/4.4.1/fileHashes/fileHashes.bin, access org.gradle.cache.internal.DefaultCacheAccess@e98543 Starting Build Compiling initialization script '/build/reproducible-path/grengine-3.0.2+dfsg/.gradle/init.d/init.gradle' using SubsetScriptTransformer. -Creating new cache for metadata-1.1/results, path /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/caches/transforms-1/metadata-1.1/results.bin, access org.gradle.cache.internal.DefaultCacheAccess@c42d94 +Creating new cache for metadata-1.1/results, path /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/caches/transforms-1/metadata-1.1/results.bin, access org.gradle.cache.internal.DefaultCacheAccess@1b0a804 Compiling initialization script '/build/reproducible-path/grengine-3.0.2+dfsg/.gradle/init.d/init.gradle' using BuildScriptTransformer. Settings evaluated using settings file '/build/reproducible-path/grengine-3.0.2+dfsg/settings.gradle'. Settings file not found (/build/reproducible-path/grengine-3.0.2+dfsg/settings.gradle) @@ -1707,48 +1743,48 @@ Linking the generated javadoc to the system JDK API documentation All projects evaluated. Selected primary task 'jar' from project : -Creating new cache for annotation-processors, path /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/4.4.1/fileContent/annotation-processors.bin, access org.gradle.cache.internal.DefaultCacheAccess@ebb7e3 +Creating new cache for annotation-processors, path /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/4.4.1/fileContent/annotation-processors.bin, access org.gradle.cache.internal.DefaultCacheAccess@1504fce Tasks to be executed: [task ':compileJava', task ':processResources', task ':classes', task ':debianMavenPom', task ':jar'] -Creating new cache for resourceHashesCache, path /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/4.4.1/fileHashes/resourceHashesCache.bin, access org.gradle.cache.internal.DefaultCacheAccess@4f5b18 -Creating new cache for taskHistory, path /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/4.4.1/taskHistory/taskHistory.bin, access org.gradle.cache.internal.DefaultCacheAccess@7ccef9 -Creating new cache for outputFiles, path /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/buildOutputCleanup/outputFiles.bin, access org.gradle.cache.internal.DefaultCacheAccess@1bc35b9 -:compileJava (Thread[Task worker for ':',5,main]) started. +Creating new cache for resourceHashesCache, path /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/4.4.1/fileHashes/resourceHashesCache.bin, access org.gradle.cache.internal.DefaultCacheAccess@e98543 +Creating new cache for taskHistory, path /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/4.4.1/taskHistory/taskHistory.bin, access org.gradle.cache.internal.DefaultCacheAccess@1682b23 +Creating new cache for outputFiles, path /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/buildOutputCleanup/outputFiles.bin, access org.gradle.cache.internal.DefaultCacheAccess@1fcc40d +:compileJava (Thread[Task worker for ':' Thread 2,5,main]) started. :compileJava -Putting task artifact state for task ':compileJava' into context took 0.018 secs. -Creating new cache for metadata-2.36/module-metadata, path /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/caches/modules-2/metadata-2.36/module-metadata.bin, access org.gradle.cache.internal.DefaultCacheAccess@6c64f2 +Putting task artifact state for task ':compileJava' into context took 0.016 secs. +Creating new cache for metadata-2.36/module-metadata, path /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/caches/modules-2/metadata-2.36/module-metadata.bin, access org.gradle.cache.internal.DefaultCacheAccess@5b482c Loading the Maven rules... Replacing org.apache.groovy:groovy:jar:4.0.9 -> org.codehaus.groovy:groovy-all:jar:debian -Up-to-date check for task ':compileJava' took 3.624 secs. It is not up-to-date because: +Up-to-date check for task ':compileJava' took 7.956 secs. It is not up-to-date because: No history is available. All input files are considered out-of-date for incremental task ':compileJava'. Compiling with JDK Java compiler API. -:compileJava (Thread[Task worker for ':',5,main]) completed. Took 9.746 secs. -:processResources (Thread[Task worker for ':',5,main]) started. +:compileJava (Thread[Task worker for ':' Thread 2,5,main]) completed. Took 20.815 secs. +:processResources (Thread[Task worker for ':' Thread 2,5,main]) started. :processResources Putting task artifact state for task ':processResources' into context took 0.0 secs. file or directory '/build/reproducible-path/grengine-3.0.2+dfsg/src/main/resources', not found Skipping task ':processResources' as it has no source files and no previous output files. :processResources NO-SOURCE -:processResources (Thread[Task worker for ':',5,main]) completed. Took 0.008 secs. -:classes (Thread[Task worker for ':',5,main]) started. +:processResources (Thread[Task worker for ':' Thread 2,5,main]) completed. Took 0.006 secs. +:classes (Thread[Task worker for ':' Thread 2,5,main]) started. :classes Skipping task ':classes' as it has no actions. -:classes (Thread[Task worker for ':',5,main]) completed. Took 0.001 secs. -:debianMavenPom (Thread[Task worker for ':',5,main]) started. +:classes (Thread[Task worker for ':' Thread 2,5,main]) completed. Took 0.015 secs. +:debianMavenPom (Thread[Task worker for ':' Thread 2,5,main]) started. :debianMavenPom Putting task artifact state for task ':debianMavenPom' into context took 0.0 secs. Up-to-date check for task ':debianMavenPom' took 0.002 secs. It is not up-to-date because: No history is available. Generating pom file /build/reproducible-path/grengine-3.0.2+dfsg/build/debian/grengine.pom -:debianMavenPom (Thread[Task worker for ':',5,main]) completed. Took 0.21 secs. -:jar (Thread[Task worker for ':',5,main]) started. +:debianMavenPom (Thread[Task worker for ':' Thread 2,5,main]) completed. Took 0.345 secs. +:jar (Thread[Task worker for ':' Thread 2,5,main]) started. :jar Putting task artifact state for task ':jar' into context took 0.0 secs. -Up-to-date check for task ':jar' took 0.023 secs. It is not up-to-date because: +Up-to-date check for task ':jar' took 0.048 secs. It is not up-to-date because: No history is available. -:jar (Thread[Task worker for ':',5,main]) completed. Took 0.18 secs. +:jar (Thread[Task worker for ':' Thread 2,5,main]) completed. Took 0.258 secs. -BUILD SUCCESSFUL in 23s +BUILD SUCCESSFUL in 42s 3 actionable tasks: 3 executed jh_build -O--buildsystem=gradle debian/rules override_dh_auto_test @@ -1756,7 +1792,7 @@ dh_auto_build -- compileTestJava mkdir -p .gradle/init.d cp /usr/share/gradle-debian-helper/init.gradle .gradle/init.d/ - gradle --info --console plain --offline --stacktrace --no-daemon --refresh-dependencies --gradle-user-home .gradle -Duser.home=. -Duser.name=debian -Ddebian.package=grengine -Dfile.encoding=UTF-8 --parallel --max-workers=3 compileTestJava + gradle --info --console plain --offline --stacktrace --no-daemon --refresh-dependencies --gradle-user-home .gradle -Duser.home=. -Duser.name=debian -Ddebian.package=grengine -Dfile.encoding=UTF-8 --parallel --max-workers=4 compileTestJava openjdk version "17.0.10" 2024-01-16 OpenJDK Runtime Environment (build 17.0.10+7-Debian-1) OpenJDK Server VM (build 17.0.10+7-Debian-1, mixed mode, sharing) @@ -1764,17 +1800,17 @@ To honour the JVM settings for this build a new JVM will be forked. Please consider using the daemon: https://docs.gradle.org/4.4.1/userguide/gradle_daemon.html. Starting process 'Gradle build daemon'. Working directory: /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/daemon/4.4.1 Command: /usr/lib/jvm/java-17-openjdk-armhf/bin/java --add-opens java.base/java.lang=ALL-UNNAMED -Xbootclasspath/a:/usr/share/java/gradle-helper-hook.jar:/usr/share/java/maven-repo-helper.jar -Dfile.encoding=UTF-8 -Duser.country=US -Duser.language=en -Duser.variant -cp /usr/share/gradle/lib/gradle-launcher-4.4.1.jar org.gradle.launcher.daemon.bootstrap.GradleDaemon 4.4.1 Successfully started process 'Gradle build daemon' -An attempt to start the daemon took 2.168 secs. -The client will now receive all logging from the daemon (pid: 32295). The daemon log file: /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/daemon/4.4.1/daemon-32295.out.log +An attempt to start the daemon took 3.274 secs. +The client will now receive all logging from the daemon (pid: 17980). The daemon log file: /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/daemon/4.4.1/daemon-17980.out.log Daemon will be stopped at the end of the build stopping after processing Closing daemon's stdin at end of input. The daemon will no longer process any standard input. -Using 3 worker leases. -Creating new cache for fileHashes, path /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/caches/4.4.1/fileHashes/fileHashes.bin, access org.gradle.cache.internal.DefaultCacheAccess@15e5a47 -Creating new cache for resourceHashesCache, path /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/caches/4.4.1/fileHashes/resourceHashesCache.bin, access org.gradle.cache.internal.DefaultCacheAccess@15e5a47 -Creating new cache for fileHashes, path /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/4.4.1/fileHashes/fileHashes.bin, access org.gradle.cache.internal.DefaultCacheAccess@38a3d1 +Using 4 worker leases. +Creating new cache for fileHashes, path /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/caches/4.4.1/fileHashes/fileHashes.bin, access org.gradle.cache.internal.DefaultCacheAccess@1d4b4e6 +Creating new cache for resourceHashesCache, path /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/caches/4.4.1/fileHashes/resourceHashesCache.bin, access org.gradle.cache.internal.DefaultCacheAccess@1d4b4e6 +Creating new cache for fileHashes, path /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/4.4.1/fileHashes/fileHashes.bin, access org.gradle.cache.internal.DefaultCacheAccess@5ffc5b Starting Build -Creating new cache for metadata-1.1/results, path /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/caches/transforms-1/metadata-1.1/results.bin, access org.gradle.cache.internal.DefaultCacheAccess@be8539 +Creating new cache for metadata-1.1/results, path /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/caches/transforms-1/metadata-1.1/results.bin, access org.gradle.cache.internal.DefaultCacheAccess@1d0f4f7 Settings evaluated using settings file '/build/reproducible-path/grengine-3.0.2+dfsg/settings.gradle'. Settings file not found (/build/reproducible-path/grengine-3.0.2+dfsg/settings.gradle) Root project name not defined in settings.gradle, defaulting to 'grengine' instead of the name of the root directory 'grengine-3.0.2+dfsg' @@ -1788,33 +1824,33 @@ Linking the generated javadoc to the system JDK API documentation All projects evaluated. Selected primary task 'compileTestJava' from project : -Creating new cache for annotation-processors, path /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/4.4.1/fileContent/annotation-processors.bin, access org.gradle.cache.internal.DefaultCacheAccess@1151f88 +Creating new cache for annotation-processors, path /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/4.4.1/fileContent/annotation-processors.bin, access org.gradle.cache.internal.DefaultCacheAccess@1f87be9 Tasks to be executed: [task ':compileJava', task ':processResources', task ':classes', task ':compileTestJava'] -Creating new cache for resourceHashesCache, path /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/4.4.1/fileHashes/resourceHashesCache.bin, access org.gradle.cache.internal.DefaultCacheAccess@38a3d1 -Creating new cache for taskHistory, path /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/4.4.1/taskHistory/taskHistory.bin, access org.gradle.cache.internal.DefaultCacheAccess@8ba39a -Creating new cache for outputFiles, path /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/buildOutputCleanup/outputFiles.bin, access org.gradle.cache.internal.DefaultCacheAccess@1e1183e -:compileJava (Thread[Task worker for ':' Thread 2,5,main]) started. +Creating new cache for resourceHashesCache, path /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/4.4.1/fileHashes/resourceHashesCache.bin, access org.gradle.cache.internal.DefaultCacheAccess@5ffc5b +Creating new cache for taskHistory, path /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/4.4.1/taskHistory/taskHistory.bin, access org.gradle.cache.internal.DefaultCacheAccess@154d646 +Creating new cache for outputFiles, path /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/buildOutputCleanup/outputFiles.bin, access org.gradle.cache.internal.DefaultCacheAccess@4e0e3c +:compileJava (Thread[Task worker for ':',5,main]) started. :compileJava -Putting task artifact state for task ':compileJava' into context took 0.01 secs. -Creating new cache for metadata-2.36/module-metadata, path /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/caches/modules-2/metadata-2.36/module-metadata.bin, access org.gradle.cache.internal.DefaultCacheAccess@6390cb +Putting task artifact state for task ':compileJava' into context took 0.017 secs. +Creating new cache for metadata-2.36/module-metadata, path /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/caches/modules-2/metadata-2.36/module-metadata.bin, access org.gradle.cache.internal.DefaultCacheAccess@197ffb7 Loading the Maven rules... Replacing org.apache.groovy:groovy:jar:4.0.9 -> org.codehaus.groovy:groovy-all:jar:debian -Skipping task ':compileJava' as it is up-to-date (took 0.774 secs). +Skipping task ':compileJava' as it is up-to-date (took 0.787 secs). :compileJava UP-TO-DATE -:compileJava (Thread[Task worker for ':' Thread 2,5,main]) completed. Took 0.843 secs. -:processResources (Thread[Task worker for ':' Thread 2,5,main]) started. +:compileJava (Thread[Task worker for ':',5,main]) completed. Took 0.889 secs. +:processResources (Thread[Task worker for ':',5,main]) started. :processResources Putting task artifact state for task ':processResources' into context took 0.0 secs. file or directory '/build/reproducible-path/grengine-3.0.2+dfsg/src/main/resources', not found Skipping task ':processResources' as it has no source files and no previous output files. :processResources NO-SOURCE -:processResources (Thread[Task worker for ':' Thread 2,5,main]) completed. Took 0.01 secs. -:classes (Thread[Task worker for ':' Thread 2,5,main]) started. +:processResources (Thread[Task worker for ':',5,main]) completed. Took 0.012 secs. +:classes (Thread[Task worker for ':',5,main]) started. :classes Skipping task ':classes' as it has no actions. :classes UP-TO-DATE -:classes (Thread[Task worker for ':' Thread 2,5,main]) completed. Took 0.007 secs. -:compileTestJava (Thread[Task worker for ':' Thread 2,5,main]) started. +:classes (Thread[Task worker for ':',5,main]) completed. Took 0.003 secs. +:compileTestJava (Thread[Task worker for ':',5,main]) started. :compileTestJava Putting task artifact state for task ':compileTestJava' into context took 0.0 secs. Replacing org.junit.jupiter:junit-jupiter-api:jar:5.9.2 -> org.junit.jupiter:junit-jupiter-api:jar:debian @@ -1829,13 +1865,13 @@ Replacing org.junit.platform:junit-platform-commons:jar:1.9.1 -> org.junit.platform:junit-platform-commons:jar:debian Passing through org.apiguardian:apiguardian-api:jar:debian Passing through org.hamcrest:hamcrest:jar:debian -Up-to-date check for task ':compileTestJava' took 2.353 secs. It is not up-to-date because: +Up-to-date check for task ':compileTestJava' took 4.619 secs. It is not up-to-date because: No history is available. All input files are considered out-of-date for incremental task ':compileTestJava'. Compiling with JDK Java compiler API. -:compileTestJava (Thread[Task worker for ':' Thread 2,5,main]) completed. Took 14.185 secs. +:compileTestJava (Thread[Task worker for ':',5,main]) completed. Took 30.926 secs. -BUILD SUCCESSFUL in 26s +BUILD SUCCESSFUL in 49s 2 actionable tasks: 1 executed, 1 up-to-date java -jar /usr/share/java/junit-platform-console-standalone.jar \ -cp $(readlink -f build/libs/grengine-*.jar):build/classes/java/test:/usr/share/java/groovy-all.jar:/usr/share/java/commons-io.jar:/usr/share/java/ivy.jar \ @@ -1844,32 +1880,32 @@ Thanks for using JUnit! Support its development at https://junit.org/sponsoring TEST LayeredEngine concurrent - top code cache - parent first -Thread 2 5: 20948 90945 133342 92536 129181 -Thread 1 5: 16501 91788 117830 95743 157689 -Thread 3 5: 36110 120727 135663 81966 119749 -Thread 4 5: 21993 99978 106348 117598 135036 -TOTAL OK 5: 95552 403438 493183 387843 541655 -Script runs: 1921671 -Duration: 2593 ms -Average time per script run: 1349 ns +Thread 2 5: 2910 6280 11624 48023 74879 +Thread 1 5: 3509 4620 10364 40220 95612 +Thread 4 5: 2469 4163 8764 59796 71849 +Thread 3 5: 3261 5305 9847 37170 70709 +TOTAL OK 5: 12149 20368 40599 185209 313049 +Script runs: 571374 +Duration: 2708 ms +Average time per script run: 4739 ns TEST LayeredEngine concurrent - top code cache - current first -Thread 2 5: 95722 120689 149706 152928 154761 -Thread 1 5: 95315 152623 152810 159994 137688 -Thread 4 5: 111431 127662 117730 143281 134424 -Thread 3 5: 82183 123481 137226 138908 133760 -TOTAL OK 5: 384651 524455 557472 595111 560633 -Script runs: 2622322 -Duration: 2574 ms -Average time per script run: 981 ns +Thread 1 5: 53905 82657 92370 71201 85661 +Thread 2 5: 37759 60640 59280 49818 40608 +Thread 3 5: 35153 60465 80079 55675 67016 +Thread 4 5: 35348 50709 53566 64676 35154 +TOTAL OK 5: 162165 254471 285295 241370 228439 +Script runs: 1171740 +Duration: 2617 ms +Average time per script run: 2233 ns TEST LayeredEngine concurrent - no top code cache -Thread 1 5: 135857 119858 138780 147895 156446 -Thread 2 5: 111157 127215 144425 141370 109882 -Thread 3 5: 135787 130059 153643 142901 107967 -Thread 4 5: 106353 105979 122475 125637 140865 -TOTAL OK 5: 489154 483111 559323 557803 515160 -Script runs: 2604551 -Duration: 2595 ms -Average time per script run: 996 ns +Thread 3 5: 55696 89359 76094 88451 63428 +Thread 2 5: 53712 69275 70543 66554 78637 +Thread 1 5: 63459 99762 77368 70045 114966 +Thread 4 5: 60878 64622 83856 64070 76152 +TOTAL OK 5: 233745 323018 307861 289120 333183 +Script runs: 1486927 +Duration: 2707 ms +Average time per script run: 1820 ns Loader[engineId=ch.artecat.grengine.engine.EngineId@1e46b62, number=17, isAttached=true] Thread-0 about to load... Thread-0 --- defineClass: about to sleep 100ms @@ -1884,20 +1920,20 @@ Thread-8 about to load... Thread-9 about to load... Thread-0 --- defineClass: done sleeping -Thread-1 --- defineClass: done sleeping Thread-0 loaded. -Thread-9 loaded. -Thread-8 loaded. -Thread-3 loaded. -Thread-1 loaded. Thread-2 loaded. -Thread-5 loaded. Thread-4 loaded. Thread-6 loaded. +Thread-8 loaded. +Thread-1 --- defineClass: done sleeping +Thread-1 loaded. +Thread-3 loaded. +Thread-5 loaded. Thread-7 loaded. +Thread-9 loaded. Thread-0 about to load... -Thread-1 about to load... Thread-0 --- defineClass: about to sleep 100ms +Thread-1 about to load... Thread-1 --- defineClass: about to sleep 100ms Thread-2 about to load... Thread-3 about to load... @@ -1907,22 +1943,22 @@ Thread-7 about to load... Thread-8 about to load... Thread-9 about to load... -Thread-1 --- defineClass: done sleeping Thread-0 --- defineClass: done sleeping -Thread-1 loaded. -Thread-9 loaded. -Thread-6 loaded. -Thread-4 loaded. -Thread-2 loaded. Thread-0 loaded. +Thread-2 loaded. +Thread-4 loaded. +Thread-6 loaded. +Thread-8 loaded. +Thread-1 --- defineClass: done sleeping +Thread-1 loaded. Thread-3 loaded. Thread-5 loaded. -Thread-8 loaded. Thread-7 loaded. +Thread-9 loaded. Thread-0 about to load... -Thread-2 about to load... -Thread-1 about to load... Thread-0 --- defineClass: about to sleep 100ms +Thread-1 about to load... +Thread-2 about to load... Thread-3 about to load... Thread-4 about to load... Thread-5 about to load... @@ -1932,70 +1968,70 @@ Thread-9 about to load... Thread-0 --- defineClass: done sleeping Thread-0 loaded. -Thread-9 loaded. -Thread-5 loaded. -Thread-3 loaded. Thread-1 loaded. +Thread-2 loaded. +Thread-3 loaded. +Thread-4 loaded. +Thread-5 loaded. Thread-6 loaded. Thread-7 loaded. Thread-8 loaded. -Thread-2 loaded. -Thread-4 loaded. +Thread-9 loaded. Thread-0 about to load... +Thread-0 --- definePackage: about to sleep 100ms Thread-1 about to load... Thread-3 about to load... Thread-2 about to load... Thread-4 about to load... -Thread-0 --- definePackage: about to sleep 100ms Thread-5 about to load... +Thread-6 about to load... Thread-7 about to load... Thread-8 about to load... -Thread-6 about to load... Thread-9 about to load... Thread-0 --- definePackage: done sleeping Thread-0 loaded. -Thread-9 loaded. Thread-6 loaded. -Thread-4 loaded. -Thread-8 loaded. Thread-7 loaded. -Thread-3 loaded. +Thread-8 loaded. +Thread-9 loaded. Thread-1 loaded. +Thread-3 loaded. Thread-2 loaded. +Thread-4 loaded. Thread-5 loaded. hello world 123 hello world -DefaultUrlSource[ID=file:/tmp/gren2814431253708251163/MyScript.groovy] DefaultTextSource[ID=/groovy/script/ScriptEAC802B0B260F4204A095610E564BBBF, text='println 55'] DefaultTextSource[ID=/groovy/script/ScriptEAC802B0B260F4204A095610E564BBBF/FirstScript, text='println 55'] -DefaultFileSource[ID=/tmp/gren4920269908373531647/MyScript.groovy] +DefaultUrlSource[ID=file:/tmp/gren10425801879002198368/MyScript.groovy] +DefaultFileSource[ID=/tmp/gren6278891009367930608/MyScript.groovy] TEST Grengine concurrent - top code cache - parent first -Thread 2 5: 13979 17138 46435 72831 129285 -Thread 1 5: 11678 19784 42855 104263 137251 -Thread 3 5: 11024 15167 37321 60482 130102 -Thread 4 5: 12846 14330 40614 96437 91247 -TOTAL OK 5: 49527 66419 167225 334013 487885 -Script runs: 1105069 -Duration: 2578 ms -Average time per script run: 2332 ns +Thread 1 5: 9426 8344 8377 8184 7864 +Thread 2 5: 8577 7004 8446 7492 8290 +Thread 3 5: 7391 6957 8338 7343 10307 +Thread 4 5: 7412 7200 8356 8330 6528 +TOTAL OK 5: 32806 29505 33517 31349 32989 +Script runs: 160166 +Duration: 2610 ms +Average time per script run: 16295 ns TEST Grengine concurrent - top code cache - current first -Thread 1 5: 102117 97997 113440 112371 102471 -Thread 3 5: 108571 128246 74173 71278 97772 -Thread 2 5: 116532 128490 117871 128397 92881 -Thread 4 5: 114230 124437 105918 119263 114424 -TOTAL OK 5: 441450 479170 411402 431309 407548 -Script runs: 2170879 -Duration: 2546 ms -Average time per script run: 1172 ns +Thread 1 5: 13833 11184 12524 7971 8979 +Thread 2 5: 16974 12963 12765 9203 8553 +Thread 3 5: 13580 10706 11123 10161 9273 +Thread 4 5: 12316 9819 10875 6542 8958 +TOTAL OK 5: 56703 44672 47287 33877 35763 +Script runs: 218302 +Duration: 2569 ms +Average time per script run: 11768 ns TEST Grengine concurrent - no top code cache -Thread 2 5: 81707 105918 75629 121882 138150 -Thread 1 5: 118878 117320 149273 92791 129548 -Thread 3 5: 127330 119224 130837 129482 91951 -Thread 4 5: 116730 120044 126000 118851 79352 -TOTAL OK 5: 444645 462506 481739 463006 439001 -Script runs: 2290897 -Duration: 2559 ms -Average time per script run: 1117 ns +Thread 1 5: 28949 33740 31292 46384 57977 +Thread 3 5: 33313 17513 30815 42514 84701 +Thread 2 5: 24885 17764 35548 54306 55379 +Thread 4 5: 23588 27245 31634 49131 64956 +TOTAL OK 5: 110735 96262 129289 192335 263013 +Script runs: 791634 +Duration: 2596 ms +Average time per script run: 3279 ns . +-- JUnit Platform Suite [OK] +-- JUnit Jupiter [OK] @@ -2021,16 +2057,16 @@ | | +-- testConstructDefaults() [OK] | | +-- testConstructSourceSetNull() [OK] | | '-- testConstructAllDefined() [OK] -| +-- DefaultTopCodeCacheTest [OK] -| | +-- testConstructAndGettersAndMore() [OK] -| | +-- testModifyBuilderAfterUse() [OK] -| | '-- testSetParentNull() [OK] | +-- DefaultSingleSourceCodeTest [OK] | | +-- testConstructPlusGetters() [OK] | | +-- testConstructNotSingleSource() [OK] | | +-- testConstructBytecodeMapNull() [OK] | | +-- testConstructCompiledSourceInfoMapNull() [OK] | | '-- testConstructSourcesNameNull() [OK] +| +-- DefaultTopCodeCacheTest [OK] +| | +-- testConstructAndGettersAndMore() [OK] +| | +-- testModifyBuilderAfterUse() [OK] +| | '-- testSetParentNull() [OK] | +-- ClassNameConflictExceptionTest [OK] | | '-- testConstruct() [OK] | +-- LayeredClassLoaderTest [OK] @@ -2154,19 +2190,15 @@ | | +-- testConstructFromDirWithoutSubDirs_WithParent() [OK] | | +-- testHelloWorld() [OK] | | '-- testConstructFromUrls() [OK] -| +-- GrengineVisualPerformanceTest [OK] -| | '-- testMain() [OK] | +-- DirModeTest [OK] | | +-- testValueOf() [OK] | | '-- testValues() [OK] +| +-- GrengineVisualPerformanceTest [OK] +| | '-- testMain() [OK] | +-- CompileExceptionTest [OK] | | +-- testConstructFromMessageAndThrowableNull() [OK] | | +-- testConstructFromMessageAndThrowable() [OK] | | '-- testConstructFromMessage() [OK] -| +-- DefaultUrlSourceTest [OK] -| | +-- testConstructFromUrlPlusGetters() [OK] -| | +-- testConstructFromUrlWithUrlNull() [OK] -| | '-- testEquals() [OK] | +-- DefaultTextSourceTest [OK] | | +-- testConstructFromTextPlusGetters() [OK] | | +-- testConstructFromTextAndNameWithTextNull() [OK] @@ -2176,6 +2208,10 @@ | | +-- testConstructFromTextWithTextNull() [OK] | | +-- testEquals() [OK] | | '-- testConstructFromTextAndNameWithNameNull() [OK] +| +-- DefaultUrlSourceTest [OK] +| | +-- testConstructFromUrlPlusGetters() [OK] +| | +-- testConstructFromUrlWithUrlNull() [OK] +| | '-- testEquals() [OK] | +-- DefaultFileSourceTest [OK] | | +-- testConstructFromFilePlusGetters() [OK] | | +-- testConstructFromFileWithFileNull() [OK] @@ -2211,12 +2247,6 @@ | | +-- testConstructFromMessageAndThrowableNull() [OK] | | +-- testConstructFromMessageAndThrowable() [OK] | | '-- testConstructFromMessage() [OK] -| +-- DefaultTopCodeCacheFactoryTest [OK] -| | +-- testConstructFromBuilderAndGetters() [OK] -| | +-- testConstructFromCompilerFactoryNull() [OK] -| | +-- testConstructDefault() [OK] -| | +-- testConstructFromCompilerFactory() [OK] -| | '-- testModifyBuilderAfterUse() [OK] | +-- DefaultGroovyCompilerTest [OK] | | +-- testWithGrape_configNull() [OK] | | +-- testCompileSourcesNull() [OK] @@ -2245,6 +2275,12 @@ | | +-- testWithGrape() [OK] | | +-- testCompileFailsUnknownSource() [OK] | | '-- testConcurrentGrabs() [S] touches $HOME +| +-- DefaultTopCodeCacheFactoryTest [OK] +| | +-- testConstructFromBuilderAndGetters() [OK] +| | +-- testConstructFromCompilerFactoryNull() [OK] +| | +-- testConstructDefault() [OK] +| | +-- testConstructFromCompilerFactory() [OK] +| | '-- testModifyBuilderAfterUse() [OK] | +-- DefaultCodeTest [OK] | | +-- testConstructPlusGetters() [OK] | | +-- testConstructBytecodeMapNull() [OK] @@ -2387,7 +2423,7 @@ | '-- testConstructSourcesCollectionNull() [OK] '-- JUnit Vintage [OK] -Test run finished after 26457 ms +Test run finished after 31343 ms [ 44 containers found ] [ 0 containers skipped ] [ 44 containers started ] @@ -2439,12 +2475,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/1533/tmp/hooks/B01_cleanup starting +I: user script /srv/workspace/pbuilder/1533/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/23253 and its subdirectories -I: Current time: Tue Apr 16 18:21:01 -12 2024 -I: pbuilder-time-stamp: 1713334861 +I: removing directory /srv/workspace/pbuilder/1533 and its subdirectories +I: Current time: Wed Apr 17 20:27:49 +14 2024 +I: pbuilder-time-stamp: 1713335269