Diff of the two buildlogs: -- --- b1/build.log 2024-10-19 01:39:18.758493646 +0000 +++ b2/build.log 2024-10-19 01:43:24.401758929 +0000 @@ -1,6 +1,6 @@ I: pbuilder: network access will be disabled during build -I: Current time: Fri Oct 18 13:37:41 -12 2024 -I: pbuilder-time-stamp: 1729301861 +I: Current time: Sat Oct 19 15:39:21 +14 2024 +I: pbuilder-time-stamp: 1729301961 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/604097/tmp/hooks/D02_print_environment starting +I: user script /srv/workspace/pbuilder/1514188/tmp/hooks/D01_modify_environment starting +debug: Running on codethink04-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 Oct 19 01:39 /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/1514188/tmp/hooks/D01_modify_environment finished +I: user script /srv/workspace/pbuilder/1514188/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]="32" [3]="1" [4]="release" [5]="aarch64-unknown-linux-gnu") + BASH_VERSION='5.2.32(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='trixie' - HOME='/root' - HOST_ARCH='arm64' + DIRSTACK=() + DISTRIBUTION=trixie + EUID=0 + FUNCNAME=([0]="Echo" [1]="main") + GROUPS=() + HOME=/root + HOSTNAME=i-capture-the-hostname + HOSTTYPE=aarch64 + HOST_ARCH=arm64 IFS=' ' - INVOCATION_ID='4f23868ccc9d45ca9687acd74b57cb80' - 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='604097' - PS1='# ' - PS2='> ' + INVOCATION_ID=fca1adb252a340e3be200ff0e98fe7e2 + 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=1514188 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.pMvHKClw/pbuilderrc_lhq8 --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.pMvHKClw/b1 --logfile b1/build.log grengine_3.0.2+dfsg-2.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.pMvHKClw/pbuilderrc_99Ez --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.pMvHKClw/b2 --logfile b2/build.log grengine_3.0.2+dfsg-2.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 codethink02-arm64 6.1.0-26-cloud-arm64 #1 SMP Debian 6.1.112-1 (2024-09-30) aarch64 GNU/Linux + Linux i-capture-the-hostname 6.1.0-26-cloud-arm64 #1 SMP Debian 6.1.112-1 (2024-09-30) aarch64 GNU/Linux I: ls -l /bin lrwxrwxrwx 1 root root 7 Aug 4 21:30 /bin -> usr/bin -I: user script /srv/workspace/pbuilder/604097/tmp/hooks/D02_print_environment finished +I: user script /srv/workspace/pbuilder/1514188/tmp/hooks/D02_print_environment finished -> Attempting to satisfy build-dependencies -> Creating pbuilder-satisfydepends-dummy package Package: pbuilder-satisfydepends-dummy @@ -379,7 +411,7 @@ Get: 251 http://deb.debian.org/debian trixie/main arm64 libpicocli-java all 4.6.2-2 [390 kB] Get: 252 http://deb.debian.org/debian trixie/main arm64 libunivocity-parsers-java all 2.9.1-1 [397 kB] Get: 253 http://deb.debian.org/debian trixie/main arm64 junit5 all 5.10.3-1 [2459 kB] -Fetched 246 MB in 1s (257 MB/s) +Fetched 246 MB in 2s (136 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 ... 19909 files and directories currently installed.) @@ -1216,8 +1248,8 @@ Setting up tzdata (2024a-4) ... Current default time zone: 'Etc/UTC' -Local time is now: Sat Oct 19 01:38:15 UTC 2024. -Universal Time is now: Sat Oct 19 01:38:15 UTC 2024. +Local time is now: Sat Oct 19 01:40:42 UTC 2024. +Universal Time is now: Sat Oct 19 01:40:42 UTC 2024. Run 'dpkg-reconfigure tzdata' if you wish to change it. Setting up libgeronimo-annotation-1.3-spec-java (1.3-1) ... @@ -1617,7 +1649,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/1514188/tmp/hooks/A99_set_merged_usr starting +Not re-configuring usrmerge for trixie +I: user script /srv/workspace/pbuilder/1514188/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 @@ -1650,18 +1686,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-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.004 secs. -The client will now receive all logging from the daemon (pid: 621236). The daemon log file: /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/daemon/4.4.1/daemon-621236.out.log +An attempt to start the daemon took 2.838 secs. +The client will now receive all logging from the daemon (pid: 1527566). The daemon log file: /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/daemon/4.4.1/daemon-1527566.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.0.2+dfsg/.gradle/caches/4.4.1/fileHashes/fileHashes.bin, access org.gradle.cache.internal.DefaultCacheAccess@19b99f59 -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@19b99f59 -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@1d1284b7 +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@68ebb43f +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@68ebb43f +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@1ba7d841 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@945b670 +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@46fa4390 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) @@ -1678,48 +1714,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@49774754 +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@22c5b481 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@1d1284b7 -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@6ef1fa2f -Creating new cache for outputFiles, path /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/buildOutputCleanup/outputFiles.bin, access org.gradle.cache.internal.DefaultCacheAccess@31b1727e -:compileJava (Thread[#51,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@1ba7d841 +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@7fd6bbfd +Creating new cache for outputFiles, path /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/buildOutputCleanup/outputFiles.bin, access org.gradle.cache.internal.DefaultCacheAccess@12cc6dde +: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.0.2+dfsg/.gradle/caches/modules-2/metadata-2.36/module-metadata.bin, access org.gradle.cache.internal.DefaultCacheAccess@37305bf1 +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@5d554f49 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 1.126 secs. It is not up-to-date because: +Up-to-date check for task ':compileJava' took 3.185 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[#51,Task worker for ':' Thread 2,5,main]) completed. Took 3.265 secs. -:processResources (Thread[#51,Task worker for ':' Thread 2,5,main]) started. +:compileJava (Thread[#50,Task worker for ':',5,main]) completed. Took 9.183 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.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[#51,Task worker for ':' Thread 2,5,main]) completed. Took 0.002 secs. -:classes (Thread[#51,Task worker for ':' Thread 2,5,main]) started. +:processResources (Thread[#50,Task worker for ':',5,main]) completed. Took 0.003 secs. +:classes (Thread[#50,Task worker for ':',5,main]) started. :classes Skipping task ':classes' as it has no actions. -:classes (Thread[#51,Task worker for ':' Thread 2,5,main]) completed. Took 0.0 secs. -:debianMavenPom (Thread[#51,Task worker for ':' Thread 2,5,main]) started. +:classes (Thread[#50,Task worker for ':',5,main]) completed. Took 0.0 secs. +: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.0 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[#51,Task worker for ':' Thread 2,5,main]) completed. Took 0.076 secs. -:jar (Thread[#51,Task worker for ':' Thread 2,5,main]) started. +:debianMavenPom (Thread[#50,Task worker for ':',5,main]) completed. Took 0.16 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.01 secs. It is not up-to-date because: +Up-to-date check for task ':jar' took 0.032 secs. It is not up-to-date because: No history is available. -:jar (Thread[#51,Task worker for ':' Thread 2,5,main]) completed. Took 0.063 secs. +:jar (Thread[#50,Task worker for ':',5,main]) completed. Took 0.179 secs. -BUILD SUCCESSFUL in 8s +BUILD SUCCESSFUL in 24s 3 actionable tasks: 3 executed jh_build -O--buildsystem=gradle debian/rules override_dh_auto_test @@ -1735,17 +1771,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-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.046 secs. -The client will now receive all logging from the daemon (pid: 622952). The daemon log file: /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/daemon/4.4.1/daemon-622952.out.log +An attempt to start the daemon took 2.759 secs. +The client will now receive all logging from the daemon (pid: 1530392). The daemon log file: /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/daemon/4.4.1/daemon-1530392.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.0.2+dfsg/.gradle/caches/4.4.1/fileHashes/fileHashes.bin, access org.gradle.cache.internal.DefaultCacheAccess@75552c1b -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@75552c1b -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@4aef76b1 +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@4d54faf7 +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@4d54faf7 +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@3992532e 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@bae8b38 +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@32d0c74d 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' @@ -1759,27 +1795,27 @@ 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@13a2cf7f +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@30c59fe5 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@4aef76b1 -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@536bf05e -Creating new cache for outputFiles, path /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/buildOutputCleanup/outputFiles.bin, access org.gradle.cache.internal.DefaultCacheAccess@389cd424 +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@3992532e +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@a15c351 +Creating new cache for outputFiles, path /build/reproducible-path/grengine-3.0.2+dfsg/.gradle/buildOutputCleanup/outputFiles.bin, access org.gradle.cache.internal.DefaultCacheAccess@aac6bd :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.0.2+dfsg/.gradle/caches/modules-2/metadata-2.36/module-metadata.bin, access org.gradle.cache.internal.DefaultCacheAccess@1f2447b +Putting task artifact state for task ':compileJava' into context took 0.014 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@450df6da 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.303 secs). +Skipping task ':compileJava' as it is up-to-date (took 0.941 secs). :compileJava UP-TO-DATE -:compileJava (Thread[#50,Task worker for ':',5,main]) completed. Took 0.359 secs. +:compileJava (Thread[#50,Task worker for ':',5,main]) completed. Took 1.049 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.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[#50,Task worker for ':',5,main]) completed. Took 0.003 secs. +:processResources (Thread[#50,Task worker for ':',5,main]) completed. Took 0.059 secs. :classes (Thread[#50,Task worker for ':',5,main]) started. :classes Skipping task ':classes' as it has no actions. @@ -1800,13 +1836,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.857 secs. It is not up-to-date because: +Up-to-date check for task ':compileTestJava' took 2.035 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[#50,Task worker for ':',5,main]) completed. Took 5.001 secs. +:compileTestJava (Thread[#50,Task worker for ':',5,main]) completed. Took 14.783 secs. -BUILD SUCCESSFUL in 10s +BUILD SUCCESSFUL in 29s 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 \ @@ -1815,158 +1851,158 @@ Thanks for using JUnit! Support its development at https://junit.org/sponsoring TEST LayeredEngine concurrent - top code cache - parent first -Thread 1 5: 364903 448012 495910 457094 472459 -Thread 2 5: 365684 435732 485053 408082 454298 -Thread 3 5: 392133 408807 459635 439763 438417 -Thread 4 5: 365400 397356 464040 424980 425565 -TOTAL OK 5: 1488120 1689907 1904638 1729919 1790739 -Script runs: 8603323 -Duration: 2576 ms -Average time per script run: 299 ns +Thread 1 5: 65724 207223 238342 280579 186318 +Thread 4 5: 62550 187649 209564 180719 228014 +Thread 3 5: 45307 171431 237842 198523 197286 +Thread 2 5: 58349 183740 262702 234717 307541 +TOTAL OK 5: 231930 750043 948450 894538 919159 +Script runs: 3744120 +Duration: 2652 ms +Average time per script run: 708 ns TEST LayeredEngine concurrent - top code cache - current first -Thread 1 5: 506364 483693 487856 474370 568713 -Thread 2 5: 505223 413075 464119 503325 522020 -Thread 3 5: 532706 449494 449693 433775 472175 -Thread 4 5: 536022 440836 444605 475153 474464 -TOTAL OK 5: 2080315 1787098 1846273 1886623 2037372 -Script runs: 9637681 -Duration: 2545 ms -Average time per script run: 264 ns +Thread 1 5: 86758 148431 306693 227367 208746 +Thread 2 5: 115620 243321 171329 153972 161595 +Thread 4 5: 74194 133936 200252 265875 391228 +Thread 3 5: 83888 150195 157573 162532 176545 +TOTAL OK 5: 360460 675883 835847 809746 938114 +Script runs: 3620050 +Duration: 2593 ms +Average time per script run: 716 ns TEST LayeredEngine concurrent - no top code cache -Thread 1 5: 532701 469639 492133 435686 377826 -Thread 2 5: 519976 451125 475027 457983 377122 -Thread 3 5: 531664 435174 422314 352494 343017 -Thread 4 5: 534340 393552 446679 421240 361265 -TOTAL OK 5: 2118681 1749490 1836153 1667403 1459230 -Script runs: 8830957 -Duration: 2552 ms -Average time per script run: 288 ns +Thread 1 5: 199584 264634 265937 260857 324134 +Thread 2 5: 224769 265469 321425 329923 341416 +Thread 4 5: 128674 171352 141181 256732 172027 +Thread 3 5: 207197 195290 158619 191429 191174 +TOTAL OK 5: 760224 896745 887162 1038941 1028751 +Script runs: 4611823 +Duration: 2587 ms +Average time per script run: 560 ns Loader[engineId=ch.artecat.grengine.engine.EngineId@67207d8a, number=17, isAttached=true] 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-4 about to load... Thread-5 about to load... Thread-6 about to load... -Thread-3 about to load... Thread-7 about to load... Thread-8 about to load... -Thread-9 about to load... -Thread-0 --- defineClass: about to sleep 100ms -Thread-1 --- defineClass: about to sleep 100ms -Thread-0 --- defineClass: done sleeping Thread-1 --- defineClass: done sleeping -Thread-0 loaded. -Thread-4 loaded. Thread-1 loaded. -Thread-6 loaded. +Thread-0 --- defineClass: done sleeping Thread-7 loaded. Thread-8 loaded. -Thread-2 loaded. +Thread-5 loaded. +Thread-9 about to load... Thread-9 loaded. +Thread-4 loaded. +Thread-0 loaded. Thread-3 loaded. -Thread-5 loaded. +Thread-6 loaded. +Thread-2 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-4 about to load... Thread-5 about to load... Thread-6 about to load... Thread-7 about to load... +Thread-1 --- defineClass: done sleeping +Thread-1 loaded. Thread-8 about to load... -Thread-0 --- defineClass: about to sleep 100ms -Thread-7 --- defineClass: about to sleep 100ms -Thread-9 about to load... Thread-0 --- defineClass: done sleeping -Thread-7 --- defineClass: done sleeping Thread-0 loaded. -Thread-6 loaded. Thread-7 loaded. Thread-4 loaded. Thread-8 loaded. -Thread-2 loaded. -Thread-9 loaded. Thread-5 loaded. +Thread-6 loaded. Thread-3 loaded. -Thread-1 loaded. +Thread-2 loaded. +Thread-9 about to load... +Thread-9 loaded. Thread-0 about to load... -Thread-1 about to load... Thread-0 --- defineClass: about to sleep 100ms -Thread-3 about to load... +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... Thread-6 about to load... -Thread-8 about to load... -Thread-9 about to load... Thread-7 about to load... Thread-0 --- defineClass: done sleeping Thread-0 loaded. -Thread-7 loaded. -Thread-8 loaded. Thread-6 loaded. +Thread-7 loaded. Thread-5 loaded. -Thread-9 loaded. Thread-4 loaded. -Thread-2 loaded. Thread-3 loaded. +Thread-2 loaded. +Thread-8 about to load... +Thread-8 loaded. Thread-1 loaded. +Thread-9 about to load... +Thread-9 loaded. Thread-0 about to load... +Thread-0 --- definePackage: 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-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-9 about to load... Thread-0 --- definePackage: done sleeping Thread-0 loaded. +Thread-6 loaded. +Thread-5 loaded. +Thread-3 loaded. +Thread-7 about to load... Thread-7 loaded. -Thread-9 loaded. Thread-1 loaded. -Thread-5 loaded. Thread-4 loaded. -Thread-6 loaded. -Thread-3 loaded. +Thread-8 about to load... Thread-8 loaded. Thread-2 loaded. +Thread-9 about to load... +Thread-9 loaded. hello world 123 hello world DefaultTextSource[ID=/groovy/script/ScriptEAC802B0B260F4204A095610E564BBBF, text='println 55'] DefaultTextSource[ID=/groovy/script/ScriptEAC802B0B260F4204A095610E564BBBF/FirstScript, text='println 55'] -DefaultUrlSource[ID=file:/tmp/gren13093136628170875277/MyScript.groovy] -DefaultFileSource[ID=/tmp/gren3794049494455258823/MyScript.groovy] +DefaultUrlSource[ID=file:/tmp/gren5507744556902470001/MyScript.groovy] +DefaultFileSource[ID=/tmp/gren10244902582473217921/MyScript.groovy] TEST Grengine concurrent - top code cache - parent first -Thread 1 5: 343602 474273 308983 394574 431120 -Thread 2 5: 246132 312668 410825 347945 412449 -Thread 3 5: 315197 351430 403344 286169 434254 -Thread 4 5: 324667 287867 358445 326771 400788 -TOTAL OK 5: 1229598 1426238 1481597 1355459 1678611 -Script runs: 7171503 -Duration: 2550 ms -Average time per script run: 355 ns +Thread 1 5: 55794 100316 170254 197067 190763 +Thread 2 5: 38466 175722 244476 175384 151104 +Thread 3 5: 45797 94385 145321 128823 164720 +Thread 4 5: 73070 101483 183624 185330 143325 +TOTAL OK 5: 213127 471906 743675 686604 649912 +Script runs: 2765224 +Duration: 2606 ms +Average time per script run: 942 ns TEST Grengine concurrent - top code cache - current first -Thread 1 5: 477901 429532 400291 439622 494041 -Thread 2 5: 440347 323125 399662 416463 484530 -Thread 3 5: 480072 364513 343330 356383 405785 -Thread 4 5: 422536 362842 343561 359182 416769 -TOTAL OK 5: 1820856 1480012 1486844 1571650 1801125 -Script runs: 8160487 -Duration: 2526 ms -Average time per script run: 309 ns +Thread 1 5: 150276 179190 201142 195097 276788 +Thread 2 5: 229693 240404 188492 188500 157261 +Thread 3 5: 181088 231964 217911 200707 139208 +Thread 4 5: 167971 157165 167320 184706 166830 +TOTAL OK 5: 729028 808723 774865 769010 740087 +Script runs: 3821713 +Duration: 2585 ms +Average time per script run: 676 ns TEST Grengine concurrent - no top code cache -Thread 1 5: 501039 465910 464832 501490 439330 -Thread 2 5: 509970 530708 451709 479101 384785 -Thread 3 5: 424014 484422 382327 454569 406836 -Thread 4 5: 453710 468366 423084 417689 346921 -TOTAL OK 5: 1888733 1949406 1721952 1852849 1577872 -Script runs: 8990812 -Duration: 2532 ms -Average time per script run: 281 ns +Thread 1 5: 204488 202556 208667 215225 183502 +Thread 3 5: 153837 206311 235228 182877 216784 +Thread 2 5: 259684 182846 233044 182697 165510 +Thread 4 5: 187879 190609 221627 189587 230996 +TOTAL OK 5: 805888 782322 898566 770386 796792 +Script runs: 4053954 +Duration: 2599 ms +Average time per script run: 641 ns ? ?? JUnit Platform Suite ? ?? JUnit Jupiter ? @@ -2358,7 +2394,7 @@ ? ?? testConstructSourcesCollectionNull() ? ?? JUnit Vintage ? -Test run finished after 21765 ms +Test run finished after 30690 ms [ 44 containers found ] [ 0 containers skipped ] [ 44 containers started ] @@ -2410,12 +2446,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/1514188/tmp/hooks/B01_cleanup starting +I: user script /srv/workspace/pbuilder/1514188/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/604097 and its subdirectories -I: Current time: Fri Oct 18 13:39:17 -12 2024 -I: pbuilder-time-stamp: 1729301957 +I: removing directory /srv/workspace/pbuilder/1514188 and its subdirectories +I: Current time: Sat Oct 19 15:43:23 +14 2024 +I: pbuilder-time-stamp: 1729302203