Diff of the two buildlogs: -- --- b1/build.log 2024-12-21 18:20:45.520330717 +0000 +++ b2/build.log 2024-12-21 18:24:47.157262575 +0000 @@ -1,6 +1,6 @@ I: pbuilder: network access will be disabled during build -I: Current time: Fri Jan 23 12:41:56 -12 2026 -I: pbuilder-time-stamp: 1769215316 +I: Current time: Sun Dec 22 08:20:48 +14 2024 +I: pbuilder-time-stamp: 1734805248 I: Building the build Environment I: extracting base tarball [/var/cache/pbuilder/unstable-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/3042266/tmp/hooks/D02_print_environment starting +I: user script /srv/workspace/pbuilder/722269/tmp/hooks/D01_modify_environment starting +debug: Running on codethink02-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 +'/bin/sh' -> '/bin/bash' +lrwxrwxrwx 1 root root 9 Dec 21 18:20 /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/722269/tmp/hooks/D01_modify_environment finished +I: user script /srv/workspace/pbuilder/722269/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='arm64' - DEBIAN_FRONTEND='noninteractive' + 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]="37" [3]="1" [4]="release" [5]="aarch64-unknown-linux-gnu") + BASH_VERSION='5.2.37(1)-release' + BUILDDIR=/build/reproducible-path + 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=12 ' - DISTRIBUTION='unstable' - HOME='/root' - HOST_ARCH='arm64' + DIRSTACK=() + DISTRIBUTION=unstable + EUID=0 + FUNCNAME=([0]="Echo" [1]="main") + GROUPS=() + HOME=/root + HOSTNAME=i-capture-the-hostname + HOSTTYPE=aarch64 + HOST_ARCH=arm64 IFS=' ' - INVOCATION_ID='02c891a0e4984766b554c45d31b424c7' - 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='3042266' - PS1='# ' - PS2='> ' + INVOCATION_ID=3904bf95138345f9bea3c4b58f732e05 + 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=722269 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.EmyzgDOD/pbuilderrc_6I7a --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.EmyzgDOD/b1 --logfile b1/build.log grengine_3.1.0+dfsg-1.dsc' - SUDO_GID='109' - SUDO_UID='104' - SUDO_USER='jenkins' - TERM='unknown' - TZ='/usr/share/zoneinfo/Etc/GMT+12' - USER='root' - _='/usr/bin/systemd-run' - http_proxy='http://192.168.101.4: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.EmyzgDOD/pbuilderrc_wcnr --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.EmyzgDOD/b2 --logfile b2/build.log grengine_3.1.0+dfsg-1.dsc' + SUDO_GID=109 + SUDO_UID=104 + SUDO_USER=jenkins + TERM=unknown + TZ=/usr/share/zoneinfo/Etc/GMT-14 + UID=0 + USER=root + _='I: set' + http_proxy=http://192.168.101.4:3128 I: uname -a - Linux codethink01-arm64 6.1.0-28-cloud-arm64 #1 SMP Debian 6.1.119-1 (2024-11-22) aarch64 GNU/Linux + Linux i-capture-the-hostname 6.1.0-28-cloud-arm64 #1 SMP Debian 6.1.119-1 (2024-11-22) aarch64 GNU/Linux I: ls -l /bin - lrwxrwxrwx 1 root root 7 Nov 22 2024 /bin -> usr/bin -I: user script /srv/workspace/pbuilder/3042266/tmp/hooks/D02_print_environment finished + lrwxrwxrwx 1 root root 7 Nov 22 14:40 /bin -> usr/bin +I: user script /srv/workspace/pbuilder/722269/tmp/hooks/D02_print_environment finished -> Attempting to satisfy build-dependencies -> Creating pbuilder-satisfydepends-dummy package Package: pbuilder-satisfydepends-dummy @@ -380,7 +412,7 @@ Get: 252 http://deb.debian.org/debian unstable/main arm64 libpicocli-java all 4.6.2-2 [390 kB] Get: 253 http://deb.debian.org/debian unstable/main arm64 libunivocity-parsers-java all 2.9.1-1 [397 kB] Get: 254 http://deb.debian.org/debian unstable/main arm64 junit5 all 5.10.3-1 [2459 kB] -Fetched 247 MB in 1s (254 MB/s) +Fetched 247 MB in 2s (120 MB/s) debconf: delaying package configuration, since apt-utils is not installed Selecting previously unselected package libpipeline1: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 ... 20084 files and directories currently installed.) @@ -1220,8 +1252,8 @@ Setting up tzdata (2024b-4) ... Current default time zone: 'Etc/UTC' -Local time is now: Sat Jan 24 00:42:33 UTC 2026. -Universal Time is now: Sat Jan 24 00:42:33 UTC 2026. +Local time is now: Sat Dec 21 18:22:08 UTC 2024. +Universal Time is now: Sat Dec 21 18:22:08 UTC 2024. Run 'dpkg-reconfigure tzdata' if you wish to change it. Setting up libgeronimo-annotation-1.3-spec-java (1.3-1) ... @@ -1622,7 +1654,11 @@ Building tag database... -> Finished parsing the build-deps I: Building the package -I: Running cd /build/reproducible-path/grengine-3.1.0+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.1.0+dfsg-1_source.changes +I: user script /srv/workspace/pbuilder/722269/tmp/hooks/A99_set_merged_usr starting +Not re-configuring usrmerge for unstable +I: user script /srv/workspace/pbuilder/722269/tmp/hooks/A99_set_merged_usr finished +hostname: Name or service not known +I: Running cd /build/reproducible-path/grengine-3.1.0+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.1.0+dfsg-1_source.changes dpkg-buildpackage: info: source package grengine dpkg-buildpackage: info: source version 3.1.0+dfsg-1 dpkg-buildpackage: info: source distribution unstable @@ -1657,18 +1693,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.1.0+dfsg/.gradle/daemon/4.4.1 Command: /usr/lib/jvm/java-21-openjdk-arm64/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 1.209 secs. -The client will now receive all logging from the daemon (pid: 3081969). The daemon log file: /build/reproducible-path/grengine-3.1.0+dfsg/.gradle/daemon/4.4.1/daemon-3081969.out.log +An attempt to start the daemon took 2.428 secs. +The client will now receive all logging from the daemon (pid: 746104). The daemon log file: /build/reproducible-path/grengine-3.1.0+dfsg/.gradle/daemon/4.4.1/daemon-746104.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 12 worker leases. -Creating new cache for fileHashes, path /build/reproducible-path/grengine-3.1.0+dfsg/.gradle/caches/4.4.1/fileHashes/fileHashes.bin, access org.gradle.cache.internal.DefaultCacheAccess@7a0c8ec6 -Creating new cache for resourceHashesCache, path /build/reproducible-path/grengine-3.1.0+dfsg/.gradle/caches/4.4.1/fileHashes/resourceHashesCache.bin, access org.gradle.cache.internal.DefaultCacheAccess@7a0c8ec6 -Creating new cache for fileHashes, path /build/reproducible-path/grengine-3.1.0+dfsg/.gradle/4.4.1/fileHashes/fileHashes.bin, access org.gradle.cache.internal.DefaultCacheAccess@53730e27 +Creating new cache for fileHashes, path /build/reproducible-path/grengine-3.1.0+dfsg/.gradle/caches/4.4.1/fileHashes/fileHashes.bin, access org.gradle.cache.internal.DefaultCacheAccess@1ce46c19 +Creating new cache for resourceHashesCache, path /build/reproducible-path/grengine-3.1.0+dfsg/.gradle/caches/4.4.1/fileHashes/resourceHashesCache.bin, access org.gradle.cache.internal.DefaultCacheAccess@1ce46c19 +Creating new cache for fileHashes, path /build/reproducible-path/grengine-3.1.0+dfsg/.gradle/4.4.1/fileHashes/fileHashes.bin, access org.gradle.cache.internal.DefaultCacheAccess@3f574b91 Starting Build Compiling initialization script '/build/reproducible-path/grengine-3.1.0+dfsg/.gradle/init.d/init.gradle' using SubsetScriptTransformer. -Creating new cache for metadata-1.1/results, path /build/reproducible-path/grengine-3.1.0+dfsg/.gradle/caches/transforms-1/metadata-1.1/results.bin, access org.gradle.cache.internal.DefaultCacheAccess@25d1c7f7 +Creating new cache for metadata-1.1/results, path /build/reproducible-path/grengine-3.1.0+dfsg/.gradle/caches/transforms-1/metadata-1.1/results.bin, access org.gradle.cache.internal.DefaultCacheAccess@6bb7531d Compiling initialization script '/build/reproducible-path/grengine-3.1.0+dfsg/.gradle/init.d/init.gradle' using BuildScriptTransformer. Settings evaluated using settings file '/build/reproducible-path/grengine-3.1.0+dfsg/settings.gradle'. Settings file not found (/build/reproducible-path/grengine-3.1.0+dfsg/settings.gradle) @@ -1685,29 +1721,29 @@ 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.1.0+dfsg/.gradle/4.4.1/fileContent/annotation-processors.bin, access org.gradle.cache.internal.DefaultCacheAccess@59e969d0 +Creating new cache for annotation-processors, path /build/reproducible-path/grengine-3.1.0+dfsg/.gradle/4.4.1/fileContent/annotation-processors.bin, access org.gradle.cache.internal.DefaultCacheAccess@3e5761f2 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.1.0+dfsg/.gradle/4.4.1/fileHashes/resourceHashesCache.bin, access org.gradle.cache.internal.DefaultCacheAccess@53730e27 -Creating new cache for taskHistory, path /build/reproducible-path/grengine-3.1.0+dfsg/.gradle/4.4.1/taskHistory/taskHistory.bin, access org.gradle.cache.internal.DefaultCacheAccess@505b11b7 -Creating new cache for outputFiles, path /build/reproducible-path/grengine-3.1.0+dfsg/.gradle/buildOutputCleanup/outputFiles.bin, access org.gradle.cache.internal.DefaultCacheAccess@4fc47e8c +Creating new cache for resourceHashesCache, path /build/reproducible-path/grengine-3.1.0+dfsg/.gradle/4.4.1/fileHashes/resourceHashesCache.bin, access org.gradle.cache.internal.DefaultCacheAccess@3f574b91 +Creating new cache for taskHistory, path /build/reproducible-path/grengine-3.1.0+dfsg/.gradle/4.4.1/taskHistory/taskHistory.bin, access org.gradle.cache.internal.DefaultCacheAccess@6cb3e6fa +Creating new cache for outputFiles, path /build/reproducible-path/grengine-3.1.0+dfsg/.gradle/buildOutputCleanup/outputFiles.bin, access org.gradle.cache.internal.DefaultCacheAccess@6a807200 :compileJava (Thread[#50,Task worker for ':',5,main]) started. :compileJava -Putting task artifact state for task ':compileJava' into context took 0.005 secs. -Creating new cache for metadata-2.36/module-metadata, path /build/reproducible-path/grengine-3.1.0+dfsg/.gradle/caches/modules-2/metadata-2.36/module-metadata.bin, access org.gradle.cache.internal.DefaultCacheAccess@9a9fed9 +Putting task artifact state for task ':compileJava' into context took 0.023 secs. +Creating new cache for metadata-2.36/module-metadata, path /build/reproducible-path/grengine-3.1.0+dfsg/.gradle/caches/modules-2/metadata-2.36/module-metadata.bin, access org.gradle.cache.internal.DefaultCacheAccess@486650e0 Loading the Maven rules... Replacing org.apache.groovy:groovy:jar:4.0.22 -> org.codehaus.groovy:groovy-all:jar:debian -Up-to-date check for task ':compileJava' took 1.002 secs. It is not up-to-date because: +Up-to-date check for task ':compileJava' took 2.189 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[#50,Task worker for ':',5,main]) completed. Took 3.041 secs. +:compileJava (Thread[#50,Task worker for ':',5,main]) completed. Took 7.311 secs. :processResources (Thread[#50,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.1.0+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[#50,Task worker for ':',5,main]) completed. Took 0.01 secs. +:processResources (Thread[#50,Task worker for ':',5,main]) completed. Took 0.005 secs. :classes (Thread[#50,Task worker for ':',5,main]) started. :classes Skipping task ':classes' as it has no actions. @@ -1715,18 +1751,18 @@ :debianMavenPom (Thread[#50,Task worker for ':',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.001 secs. It is not up-to-date because: +Up-to-date check for task ':debianMavenPom' took 0.0 secs. It is not up-to-date because: No history is available. Generating pom file /build/reproducible-path/grengine-3.1.0+dfsg/build/debian/grengine.pom -:debianMavenPom (Thread[#50,Task worker for ':',5,main]) completed. Took 0.078 secs. +:debianMavenPom (Thread[#50,Task worker for ':',5,main]) completed. Took 0.147 secs. :jar (Thread[#50,Task worker for ':',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.013 secs. It is not up-to-date because: +Up-to-date check for task ':jar' took 0.017 secs. It is not up-to-date because: No history is available. -:jar (Thread[#50,Task worker for ':',5,main]) completed. Took 0.066 secs. +:jar (Thread[#50,Task worker for ':',5,main]) completed. Took 0.126 secs. -BUILD SUCCESSFUL in 10s +BUILD SUCCESSFUL in 20s 3 actionable tasks: 3 executed jh_build -O--buildsystem=gradle debian/rules override_dh_auto_test @@ -1742,17 +1778,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.1.0+dfsg/.gradle/daemon/4.4.1 Command: /usr/lib/jvm/java-21-openjdk-arm64/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 1.003 secs. -The client will now receive all logging from the daemon (pid: 3082600). The daemon log file: /build/reproducible-path/grengine-3.1.0+dfsg/.gradle/daemon/4.4.1/daemon-3082600.out.log +An attempt to start the daemon took 2.292 secs. +The client will now receive all logging from the daemon (pid: 749749). The daemon log file: /build/reproducible-path/grengine-3.1.0+dfsg/.gradle/daemon/4.4.1/daemon-749749.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 12 worker leases. -Creating new cache for fileHashes, path /build/reproducible-path/grengine-3.1.0+dfsg/.gradle/caches/4.4.1/fileHashes/fileHashes.bin, access org.gradle.cache.internal.DefaultCacheAccess@6f5779d2 -Creating new cache for resourceHashesCache, path /build/reproducible-path/grengine-3.1.0+dfsg/.gradle/caches/4.4.1/fileHashes/resourceHashesCache.bin, access org.gradle.cache.internal.DefaultCacheAccess@6f5779d2 -Creating new cache for fileHashes, path /build/reproducible-path/grengine-3.1.0+dfsg/.gradle/4.4.1/fileHashes/fileHashes.bin, access org.gradle.cache.internal.DefaultCacheAccess@2c684c45 +Creating new cache for fileHashes, path /build/reproducible-path/grengine-3.1.0+dfsg/.gradle/caches/4.4.1/fileHashes/fileHashes.bin, access org.gradle.cache.internal.DefaultCacheAccess@bd2efbd +Creating new cache for resourceHashesCache, path /build/reproducible-path/grengine-3.1.0+dfsg/.gradle/caches/4.4.1/fileHashes/resourceHashesCache.bin, access org.gradle.cache.internal.DefaultCacheAccess@bd2efbd +Creating new cache for fileHashes, path /build/reproducible-path/grengine-3.1.0+dfsg/.gradle/4.4.1/fileHashes/fileHashes.bin, access org.gradle.cache.internal.DefaultCacheAccess@3c40c626 Starting Build -Creating new cache for metadata-1.1/results, path /build/reproducible-path/grengine-3.1.0+dfsg/.gradle/caches/transforms-1/metadata-1.1/results.bin, access org.gradle.cache.internal.DefaultCacheAccess@26af94d5 +Creating new cache for metadata-1.1/results, path /build/reproducible-path/grengine-3.1.0+dfsg/.gradle/caches/transforms-1/metadata-1.1/results.bin, access org.gradle.cache.internal.DefaultCacheAccess@3c6b6eac Settings evaluated using settings file '/build/reproducible-path/grengine-3.1.0+dfsg/settings.gradle'. Settings file not found (/build/reproducible-path/grengine-3.1.0+dfsg/settings.gradle) Root project name not defined in settings.gradle, defaulting to 'grengine' instead of the name of the root directory 'grengine-3.1.0+dfsg' @@ -1766,33 +1802,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.1.0+dfsg/.gradle/4.4.1/fileContent/annotation-processors.bin, access org.gradle.cache.internal.DefaultCacheAccess@2396c967 +Creating new cache for annotation-processors, path /build/reproducible-path/grengine-3.1.0+dfsg/.gradle/4.4.1/fileContent/annotation-processors.bin, access org.gradle.cache.internal.DefaultCacheAccess@319f723b Tasks to be executed: [task ':compileJava', task ':processResources', task ':classes', task ':compileTestJava'] -Creating new cache for resourceHashesCache, path /build/reproducible-path/grengine-3.1.0+dfsg/.gradle/4.4.1/fileHashes/resourceHashesCache.bin, access org.gradle.cache.internal.DefaultCacheAccess@2c684c45 -Creating new cache for taskHistory, path /build/reproducible-path/grengine-3.1.0+dfsg/.gradle/4.4.1/taskHistory/taskHistory.bin, access org.gradle.cache.internal.DefaultCacheAccess@43f26de9 -Creating new cache for outputFiles, path /build/reproducible-path/grengine-3.1.0+dfsg/.gradle/buildOutputCleanup/outputFiles.bin, access org.gradle.cache.internal.DefaultCacheAccess@3bf7023a +Creating new cache for resourceHashesCache, path /build/reproducible-path/grengine-3.1.0+dfsg/.gradle/4.4.1/fileHashes/resourceHashesCache.bin, access org.gradle.cache.internal.DefaultCacheAccess@3c40c626 +Creating new cache for taskHistory, path /build/reproducible-path/grengine-3.1.0+dfsg/.gradle/4.4.1/taskHistory/taskHistory.bin, access org.gradle.cache.internal.DefaultCacheAccess@58d8d1f5 +Creating new cache for outputFiles, path /build/reproducible-path/grengine-3.1.0+dfsg/.gradle/buildOutputCleanup/outputFiles.bin, access org.gradle.cache.internal.DefaultCacheAccess@764a1d0e :compileJava (Thread[#50,Task worker for ':',5,main]) started. :compileJava -Putting task artifact state for task ':compileJava' into context took 0.008 secs. -Creating new cache for metadata-2.36/module-metadata, path /build/reproducible-path/grengine-3.1.0+dfsg/.gradle/caches/modules-2/metadata-2.36/module-metadata.bin, access org.gradle.cache.internal.DefaultCacheAccess@24217df3 +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.1.0+dfsg/.gradle/caches/modules-2/metadata-2.36/module-metadata.bin, access org.gradle.cache.internal.DefaultCacheAccess@6b9dd2c7 Loading the Maven rules... Replacing org.apache.groovy:groovy:jar:4.0.22 -> org.codehaus.groovy:groovy-all:jar:debian -Skipping task ':compileJava' as it is up-to-date (took 0.28 secs). +Skipping task ':compileJava' as it is up-to-date (took 1.451 secs). :compileJava UP-TO-DATE -:compileJava (Thread[#50,Task worker for ':',5,main]) completed. Took 0.323 secs. -:processResources (Thread[#56,Task worker for ':' Thread 7,5,main]) started. +:compileJava (Thread[#50,Task worker for ':',5,main]) completed. Took 1.627 secs. +:processResources (Thread[#50,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.1.0+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[#56,Task worker for ':' Thread 7,5,main]) completed. Took 0.003 secs. -:classes (Thread[#56,Task worker for ':' Thread 7,5,main]) started. +:processResources (Thread[#50,Task worker for ':',5,main]) completed. Took 0.015 secs. +:classes (Thread[#50,Task worker for ':',5,main]) started. :classes Skipping task ':classes' as it has no actions. :classes UP-TO-DATE -:classes (Thread[#56,Task worker for ':' Thread 7,5,main]) completed. Took 0.0 secs. -:compileTestJava (Thread[#56,Task worker for ':' Thread 7,5,main]) started. +:classes (Thread[#50,Task worker for ':',5,main]) completed. Took 0.0 secs. +:compileTestJava (Thread[#50,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.11.0 -> org.junit.jupiter:junit-jupiter-api:jar:debian @@ -1807,13 +1843,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 0.613 secs. It is not up-to-date because: +Up-to-date check for task ':compileTestJava' took 1.859 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[#56,Task worker for ':' Thread 7,5,main]) completed. Took 4.978 secs. +:compileTestJava (Thread[#50,Task worker for ':',5,main]) completed. Took 12.451 secs. -BUILD SUCCESSFUL in 10s +BUILD SUCCESSFUL in 26s 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 \ @@ -1822,191 +1858,191 @@ Thanks for using JUnit! Support its development at https://junit.org/sponsoring TEST LayeredEngine concurrent - top code cache - parent first -Thread 1 5: 395779 420964 480121 558466 502789 -Thread 2 5: 387267 409595 469938 552483 491608 -Thread 3 5: 394273 401700 450138 543771 484251 -Thread 4 5: 384982 389543 452145 535310 464302 -TOTAL OK 5: 1562301 1621802 1852342 2190030 1942950 -Script runs: 9169425 -Duration: 2555 ms -Average time per script run: 278 ns +Thread 2 5: 97182 277378 275941 273238 490471 +Thread 1 5: 95010 304709 230468 266267 292706 +Thread 4 5: 92196 273993 242802 265717 233782 +Thread 3 5: 93382 274766 293591 579758 250875 +TOTAL OK 5: 377770 1130846 1042802 1384980 1267834 +Script runs: 5204232 +Duration: 2667 ms +Average time per script run: 512 ns TEST LayeredEngine concurrent - top code cache - current first -Thread 1 5: 521644 516905 434233 420354 454940 -Thread 2 5: 545419 515740 435255 440949 437952 -Thread 3 5: 531685 513923 421061 421637 425532 -Thread 4 5: 516411 440697 416684 405826 415986 -TOTAL OK 5: 2115159 1987265 1707233 1688766 1734410 -Script runs: 9232833 -Duration: 2541 ms -Average time per script run: 275 ns +Thread 1 5: 241614 416775 307435 283203 315997 +Thread 2 5: 225936 194469 259275 412890 221516 +Thread 3 5: 235331 280044 329997 280106 207335 +Thread 4 5: 298629 249869 309468 236753 242278 +TOTAL OK 5: 1001510 1141157 1206175 1212952 987126 +Script runs: 5548920 +Duration: 2594 ms +Average time per script run: 467 ns TEST LayeredEngine concurrent - no top code cache -Thread 1 5: 480065 510972 494856 451262 465747 -Thread 2 5: 499112 483928 446095 421771 458151 -Thread 3 5: 480559 483091 448571 428202 433748 -Thread 4 5: 475659 477831 445374 409485 430855 -TOTAL OK 5: 1935395 1955822 1834896 1710720 1788501 -Script runs: 9225334 -Duration: 2537 ms -Average time per script run: 275 ns +Thread 1 5: 555254 340016 229409 279346 278988 +Thread 3 5: 263553 243658 199051 307480 357243 +Thread 2 5: 292534 318211 562893 258095 330000 +Thread 4 5: 292965 225940 182053 285053 292749 +TOTAL OK 5: 1404306 1127825 1173406 1129974 1258980 +Script runs: 6094491 +Duration: 2576 ms +Average time per script run: 422 ns Loader[engineId=ch.grengine.engine.EngineId@46aa712c, number=17, isAttached=true] -Script Text - Default: 9.680 ms -Script Text - Tweaked: 3.630 ms -Script File - Default: 18.111 ms -Script File - Tweaked: 13.765 ms +Script Text - Default: 29.486 ms +Script Text - Tweaked: 19.321 ms +Script File - Default: 43.797 ms +Script File - Tweaked: 28.346 ms 7 5 xx:yy xx:yy -GroovyShell: 3529.504 ms -Grengine: 18.282 ms +GroovyShell: 7293.170 ms +Grengine: 20.538 ms 7 7 2 -GroovyShell: 3070.949 ms -Grengine: 10.209 ms -Script: 0.224 ms +GroovyShell: 4406.715 ms +Grengine: 12.267 ms +Script: 0.178 ms 7 null /groovy/script/Script61E5513229BA3D53A09D057769AC99CC - 0 /groovy/script/Script61E5513229BA3D53A09D057769AC99CC/MyScript - 0 -/tmp/junit11448175524151145473/MyScript.groovy - 1769215407289 -file:/tmp/junit11448175524151145473/MyScript.groovy - 0 +/tmp/junit3072982721188889562/MyScript.groovy - 1734805457513 +file:/tmp/junit3072982721188889562/MyScript.groovy - 0 class Script61E5513229BA3D53A09D057769AC99CC -MyScript@391dfe7c +MyScript@474619d9 2 MyScript MyScript Script1 Script2 -script17692154073272024152416 -script17692154073312024152416 +script17348054575562024152416 +script17348054575612024152416 ScriptE15A19DFB5A38B7835981B7078A86D3B ScriptE15A19DFB5A38B7835981B7078A86D3B -DefaultFileSource[ID=/tmp/gren11890693031443443859/MyScript.groovy] +DefaultFileSource[ID=/tmp/gren5725487974280710185/MyScript.groovy] DefaultTextSource[ID=/groovy/script/ScriptEAC802B0B260F4204A095610E564BBBF, text='println 55'] DefaultTextSource[ID=/groovy/script/ScriptEAC802B0B260F4204A095610E564BBBF/FirstScript, text='println 55'] TEST Grengine concurrent - top code cache - parent first -Thread 1 5: 373821 403153 452897 394542 465417 -Thread 2 5: 387851 378103 448777 403358 473759 -Thread 3 5: 373343 374557 437731 386511 459922 -Thread 4 5: 388777 368959 428525 371926 446261 -TOTAL OK 5: 1523792 1524772 1767930 1556337 1845359 -Script runs: 8218190 -Duration: 2546 ms -Average time per script run: 309 ns +Thread 1 5: 210104 220983 217337 216726 221709 +Thread 2 5: 128102 221610 201995 207813 187372 +Thread 3 5: 144107 200069 191168 196160 213870 +Thread 4 5: 142527 175572 212715 180062 178042 +TOTAL OK 5: 624840 818234 823215 800761 800993 +Script runs: 3868043 +Duration: 2742 ms +Average time per script run: 708 ns TEST Grengine concurrent - top code cache - current first -Thread 1 5: 455085 452938 470552 479539 407035 -Thread 2 5: 449999 397322 467499 448682 381426 -Thread 3 5: 471408 428503 424927 454301 379466 -Thread 4 5: 460129 425826 424286 448615 369238 -TOTAL OK 5: 1836621 1704589 1787264 1831137 1537165 -Script runs: 8696776 -Duration: 2532 ms -Average time per script run: 291 ns +Thread 1 5: 207626 235039 293185 251558 241792 +Thread 2 5: 219293 254442 248842 260895 243502 +Thread 3 5: 208420 240812 215364 222425 258186 +Thread 4 5: 229863 217808 208418 209774 242775 +TOTAL OK 5: 865202 948101 965809 944652 986255 +Script runs: 4710019 +Duration: 2581 ms +Average time per script run: 547 ns TEST Grengine concurrent - no top code cache -Thread 1 5: 479318 471141 485523 516675 469237 -Thread 2 5: 451754 451751 482942 486817 459103 -Thread 3 5: 484385 431904 466552 480167 430931 -Thread 4 5: 463721 418443 456851 474923 427960 -TOTAL OK 5: 1879178 1773239 1891868 1958582 1787231 -Script runs: 9290098 -Duration: 2550 ms -Average time per script run: 274 ns +Thread 1 5: 243179 210502 266412 237405 199678 +Thread 2 5: 250575 216057 271800 237190 235565 +Thread 4 5: 227351 248686 249311 245599 234659 +Thread 3 5: 251741 200230 266106 217771 195684 +TOTAL OK 5: 972846 875475 1053629 937965 865586 +Script runs: 4705501 +Duration: 2586 ms +Average time per script run: 549 ns +Thread-0 about to load... +Thread-0 --- defineClass: about to sleep 100ms Thread-1 about to load... -Thread-4 about to load... +Thread-1 --- defineClass: about to sleep 100ms Thread-2 about to load... -Thread-0 about to load... Thread-3 about to load... +Thread-4 about to load... Thread-5 about to load... -Thread-4 --- defineClass: about to sleep 100ms -Thread-1 --- defineClass: about to sleep 100ms Thread-6 about to load... -Thread-7 about to load... -Thread-8 about to load... -Thread-9 about to load... -Thread-4 --- defineClass: done sleeping -Thread-1 --- defineClass: done sleeping -Thread-4 loaded. -Thread-8 loaded. -Thread-6 loaded. +Thread-0 --- defineClass: done sleeping Thread-0 loaded. -Thread-9 loaded. -Thread-5 loaded. +Thread-6 loaded. +Thread-4 loaded. +Thread-7 about to load... Thread-2 loaded. +Thread-1 --- defineClass: done sleeping Thread-1 loaded. Thread-7 loaded. +Thread-5 loaded. Thread-3 loaded. +Thread-8 about to load... +Thread-8 loaded. +Thread-9 about to load... +Thread-9 loaded. Thread-0 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... -Thread-0 --- defineClass: about to sleep 100ms Thread-4 about to load... -Thread-1 --- defineClass: about to sleep 100ms Thread-5 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 --- defineClass: done sleeping -Thread-1 --- defineClass: done sleeping Thread-0 loaded. Thread-6 loaded. +Thread-4 loaded. +Thread-7 about to load... Thread-2 loaded. +Thread-1 --- defineClass: done sleeping +Thread-8 about to load... Thread-8 loaded. Thread-1 loaded. -Thread-5 loaded. -Thread-4 loaded. -Thread-9 loaded. Thread-7 loaded. Thread-3 loaded. +Thread-5 loaded. +Thread-9 about to load... +Thread-9 loaded. Thread-0 about to load... Thread-0 --- defineClass: 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-3 about to load... Thread-5 about to load... Thread-6 about to load... +Thread-4 about to load... Thread-7 about to load... Thread-8 about to load... Thread-9 about to load... Thread-0 --- defineClass: done sleeping Thread-0 loaded. -Thread-8 loaded. -Thread-6 loaded. -Thread-4 loaded. Thread-9 loaded. +Thread-8 loaded. Thread-7 loaded. +Thread-4 loaded. +Thread-6 loaded. Thread-5 loaded. -Thread-2 loaded. Thread-3 loaded. +Thread-2 loaded. Thread-1 loaded. Thread-0 about to load... -Thread-2 about to load... +Thread-0 --- definePackage: about to sleep 100ms Thread-1 about to load... -Thread-4 about to load... +Thread-2 about to load... Thread-3 about to load... -Thread-0 --- definePackage: about to sleep 100ms +Thread-4 about to load... Thread-5 about to load... Thread-6 about to load... Thread-7 about to load... -Thread-9 about to load... -Thread-8 about to load... Thread-0 --- definePackage: done sleeping Thread-0 loaded. -Thread-8 loaded. -Thread-3 loaded. -Thread-5 loaded. Thread-7 loaded. -Thread-4 loaded. Thread-6 loaded. +Thread-5 loaded. +Thread-4 loaded. +Thread-3 loaded. +Thread-8 about to load... +Thread-8 loaded. Thread-2 loaded. Thread-1 loaded. +Thread-9 about to load... Thread-9 loaded. hello world 123 hello world -DefaultUrlSource[ID=file:/tmp/gren11113156890169247337/MyScript.groovy] +DefaultUrlSource[ID=file:/tmp/gren2225186143746621463/MyScript.groovy] ? ?? JUnit Platform Suite ? ?? JUnit Jupiter ? @@ -2412,7 +2448,7 @@ ? ?? testAsClassLoader() ? ?? JUnit Vintage ? -Test run finished after 27993 ms +Test run finished after 38336 ms [ 45 containers found ] [ 0 containers skipped ] [ 45 containers started ] @@ -2446,7 +2482,7 @@ dh_link -O--buildsystem=gradle jh_installlibs -O--buildsystem=gradle jh_classpath -O--buildsystem=gradle -Duplicate specification "V:s" for option "V" +Duplicate specification "version|V" for option "V" jh_manifest -O--buildsystem=gradle Duplicate specification "version|V" for option "V" jh_exec -O--buildsystem=gradle @@ -2467,12 +2503,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/722269/tmp/hooks/B01_cleanup starting +I: user script /srv/workspace/pbuilder/722269/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/3042266 and its subdirectories -I: Current time: Fri Jan 23 12:43:44 -12 2026 -I: pbuilder-time-stamp: 1769215424 +I: removing directory /srv/workspace/pbuilder/722269 and its subdirectories +I: Current time: Sun Dec 22 08:24:46 +14 2024 +I: pbuilder-time-stamp: 1734805486