Diff of the two buildlogs: -- --- b1/build.log 2024-05-13 03:06:39.045281955 +0000 +++ b2/build.log 2024-05-13 03:07:26.295271303 +0000 @@ -1,6 +1,6 @@ I: pbuilder: network access will be disabled during build -I: Current time: Sun May 12 15:05:00 -12 2024 -I: pbuilder-time-stamp: 1715569500 +I: Current time: Sun Jun 15 23:29:41 +14 2025 +I: pbuilder-time-stamp: 1749979781 I: Building the build Environment I: extracting base tarball [/var/cache/pbuilder/unstable-reproducible-base.tgz] I: copying local configuration @@ -25,52 +25,84 @@ dpkg-source: info: unpacking libmojolicious-plugin-cgi-perl_0.40-2.debian.tar.xz I: Not using root during the build. I: Installing the build-deps -I: user script /srv/workspace/pbuilder/771134/tmp/hooks/D02_print_environment starting +I: user script /srv/workspace/pbuilder/455939/tmp/hooks/D01_modify_environment starting +debug: Running on ionos15-amd64. +I: Changing host+domainname to test build reproducibility +I: Adding a custom variable just for the fun of it... +I: Changing /bin/sh to bash +'/bin/sh' -> '/bin/bash' +lrwxrwxrwx 1 root root 9 Jun 15 09:29 /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/455939/tmp/hooks/D01_modify_environment finished +I: user script /srv/workspace/pbuilder/455939/tmp/hooks/D02_print_environment starting I: set - BUILDDIR='/build/reproducible-path' - BUILDUSERGECOS='first user,first room,first work-phone,first home-phone,first other' - BUILDUSERNAME='pbuilder1' - BUILD_ARCH='amd64' - DEBIAN_FRONTEND='noninteractive' - DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all parallel=20 ' - DISTRIBUTION='unstable' - HOME='/root' - HOST_ARCH='amd64' + BASH=/bin/sh + BASHOPTS=checkwinsize:cmdhist:complete_fullquote:extquote:force_fignore:globasciiranges:globskipdots:hostcomplete:interactive_comments:patsub_replacement:progcomp:promptvars:sourcepath + BASH_ALIASES=() + BASH_ARGC=() + BASH_ARGV=() + BASH_CMDS=() + BASH_LINENO=([0]="12" [1]="0") + BASH_LOADABLES_PATH=/usr/local/lib/bash:/usr/lib/bash:/opt/local/lib/bash:/usr/pkg/lib/bash:/opt/pkg/lib/bash:. + BASH_SOURCE=([0]="/tmp/hooks/D02_print_environment" [1]="/tmp/hooks/D02_print_environment") + BASH_VERSINFO=([0]="5" [1]="2" [2]="21" [3]="1" [4]="release" [5]="x86_64-pc-linux-gnu") + BASH_VERSION='5.2.21(1)-release' + BUILDDIR=/build/reproducible-path + BUILDUSERGECOS='second user,second room,second work-phone,second home-phone,second other' + BUILDUSERNAME=pbuilder2 + BUILD_ARCH=amd64 + DEBIAN_FRONTEND=noninteractive + DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all parallel=42 ' + DIRSTACK=() + DISTRIBUTION=unstable + EUID=0 + FUNCNAME=([0]="Echo" [1]="main") + GROUPS=() + HOME=/root + HOSTNAME=i-capture-the-hostname + HOSTTYPE=x86_64 + HOST_ARCH=amd64 IFS=' ' - INVOCATION_ID='ccdd5004048f4aa3a3c4adda245538ae' - 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='771134' - PS1='# ' - PS2='> ' + INVOCATION_ID=51bc7da1847841f296de106cffed5e31 + LANG=C + LANGUAGE=et_EE:et + LC_ALL=C + MACHTYPE=x86_64-pc-linux-gnu + MAIL=/var/mail/root + OPTERR=1 + OPTIND=1 + OSTYPE=linux-gnu + PATH=/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/i/capture/the/path + PBCURRENTCOMMANDLINEOPERATION=build + PBUILDER_OPERATION=build + PBUILDER_PKGDATADIR=/usr/share/pbuilder + PBUILDER_PKGLIBDIR=/usr/lib/pbuilder + PBUILDER_SYSCONFDIR=/etc + PIPESTATUS=([0]="0") + POSIXLY_CORRECT=y + PPID=455939 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.ZauitWen/pbuilderrc_Fji2 --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.ZauitWen/b1 --logfile b1/build.log libmojolicious-plugin-cgi-perl_0.40-2.dsc' - SUDO_GID='110' - SUDO_UID='105' - SUDO_USER='jenkins' - TERM='unknown' - TZ='/usr/share/zoneinfo/Etc/GMT+12' - USER='root' - _='/usr/bin/systemd-run' - http_proxy='http://46.16.76.132: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.ZauitWen/pbuilderrc_nP9J --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.ZauitWen/b2 --logfile b2/build.log libmojolicious-plugin-cgi-perl_0.40-2.dsc' + SUDO_GID=111 + SUDO_UID=106 + SUDO_USER=jenkins + TERM=unknown + TZ=/usr/share/zoneinfo/Etc/GMT-14 + UID=0 + USER=root + _='I: set' + http_proxy=http://213.165.73.152:3128 I: uname -a - Linux ionos1-amd64 6.1.0-21-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.1.90-1 (2024-05-03) x86_64 GNU/Linux + Linux i-capture-the-hostname 6.6.13+bpo-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.6.13-1~bpo12+1 (2024-02-15) x86_64 GNU/Linux I: ls -l /bin - lrwxrwxrwx 1 root root 7 May 11 07:43 /bin -> usr/bin -I: user script /srv/workspace/pbuilder/771134/tmp/hooks/D02_print_environment finished + lrwxrwxrwx 1 root root 7 Jun 14 14:05 /bin -> usr/bin +I: user script /srv/workspace/pbuilder/455939/tmp/hooks/D02_print_environment finished -> Attempting to satisfy build-dependencies -> Creating pbuilder-satisfydepends-dummy package Package: pbuilder-satisfydepends-dummy @@ -146,7 +178,7 @@ Get: 34 http://deb.debian.org/debian unstable/main amd64 libjs-bootstrap4 all 4.6.1+dfsg1-4 [517 kB] Get: 35 http://deb.debian.org/debian unstable/main amd64 libjs-highlight.js all 9.18.5+dfsg1-2 [397 kB] Get: 36 http://deb.debian.org/debian unstable/main amd64 libmojolicious-perl all 9.36+dfsg-1 [842 kB] -Fetched 20.9 MB in 1s (28.7 MB/s) +Fetched 20.9 MB in 0s (49.2 MB/s) debconf: delaying package configuration, since apt-utils is not installed Selecting previously unselected package sensible-utils. (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 19699 files and directories currently installed.) @@ -305,7 +337,11 @@ Building tag database... -> Finished parsing the build-deps I: Building the package -I: Running cd /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/ && 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 > ../libmojolicious-plugin-cgi-perl_0.40-2_source.changes +I: user script /srv/workspace/pbuilder/455939/tmp/hooks/A99_set_merged_usr starting +Not re-configuring usrmerge for unstable +I: user script /srv/workspace/pbuilder/455939/tmp/hooks/A99_set_merged_usr finished +hostname: Name or service not known +I: Running cd /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/ && 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 > ../libmojolicious-plugin-cgi-perl_0.40-2_source.changes dpkg-buildpackage: info: source package libmojolicious-plugin-cgi-perl dpkg-buildpackage: info: source version 0.40-2 dpkg-buildpackage: info: source distribution unstable @@ -327,43 +363,43 @@ Writing Makefile for Mojolicious::Plugin::CGI Writing MYMETA.yml and MYMETA.json dh_auto_build - make -j20 + make -j42 make[1]: Entering directory '/build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40' cp lib/Mojolicious/Plugin/CGI.pm blib/lib/Mojolicious/Plugin/CGI.pm Manifying 1 pod document make[1]: Leaving directory '/build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40' dh_auto_test - make -j20 test TEST_VERBOSE=1 + make -j42 test TEST_VERBOSE=1 make[1]: Entering directory '/build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40' PERL_DL_NONLAZY=1 "/usr/bin/perl" "-MExtUtils::Command::MM" "-MTest::Harness" "-e" "undef *Test::Harness::Switches; test_harness(1, 'blib/lib', 'blib/arch')" t/*.t t/00-basic.t ..................... 1..7 ok 1 - use Mojolicious::Plugin::CGI ok 2 # skip pod_file_ok(blib/lib/Mojolicious/Plugin/CGI.pm) (Test::Pod is required) -ok 3 # skip pod_coverage_ok(Mojolicious::Plugin::CGI HASH(0x55d71e5da478)) (Test::Pod::Coverage is required) +ok 3 # skip pod_coverage_ok(Mojolicious::Plugin::CGI HASH(0x55b20ef5f4d0)) (Test::Pod::Coverage is required) ok 4 # skip changes_ok() (Test::CPAN::Changes is required) ok 5 # skip changes_ok() (Test::CPAN::Changes is required) ok 6 # skip changes_ok() (Test::CPAN::Changes is required) ok 7 # skip changes_ok() (Test::CPAN::Changes is required) ok -[2024-05-13 03:06:12.58147] [788072] [trace] [JrFqcX3KENs_] GET "/working" -[2024-05-13 03:06:12.58245] [788072] [trace] [JrFqcX3KENs_] Routing to a callback -[2024-05-13 03:06:12.58886] [788072] [debug] [CGI:basic.pl:788437] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/basic.pl -[2024-05-13 03:06:12.63693] [788072] [trace] [JrFqcX3KENs_] 200 OK (0.055511s, 18.014/s) -[2024-05-13 03:06:12.86948] [788072] [trace] [5LTYcSYa7ge_] GET "/env/basic/foo" -[2024-05-13 03:06:12.87018] [788072] [trace] [5LTYcSYa7ge_] Routing to a callback -[2024-05-13 03:06:12.88160] [788072] [debug] [CGI:env.cgi:788474] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi -[2024-05-13 03:06:12.92339] [788072] [trace] [5LTYcSYa7ge_] 200 OK (0.053833s, 18.576/s) -[2024-05-13 03:06:12.95982] [788072] [trace] [gitN_yG3Cs24] GET "/env/basic/foo" -[2024-05-13 03:06:12.96016] [788072] [trace] [gitN_yG3Cs24] Routing to a callback -[2024-05-13 03:06:13.15100] [788072] [debug] [CGI:env.cgi:788510] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi -[2024-05-13 03:06:13.21180] [788072] [trace] [gitN_yG3Cs24] 200 OK (0.251956s, 3.969/s) +[2025-06-15 09:30:11.72169] [459931] [trace] [2iYSmo6dmtTp] GET "/working" +[2025-06-15 09:30:11.72222] [459931] [trace] [2iYSmo6dmtTp] Routing to a callback +[2025-06-15 09:30:11.72439] [459931] [debug] [CGI:basic.pl:459961] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/basic.pl +[2025-06-15 09:30:11.73541] [459931] [trace] [2iYSmo6dmtTp] 200 OK (0.013704s, 72.971/s) +[2025-06-15 09:30:11.74061] [459931] [trace] [lleOW2jOGMVh] GET "/env/basic/foo" +[2025-06-15 09:30:11.74098] [459931] [trace] [lleOW2jOGMVh] Routing to a callback +[2025-06-15 09:30:11.74252] [459931] [debug] [CGI:env.cgi:459962] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi +[2025-06-15 09:30:11.75178] [459931] [trace] [lleOW2jOGMVh] 200 OK (0.01115s, 89.686/s) +[2025-06-15 09:30:11.76069] [459931] [trace] [ljZh6m7gFAuH] GET "/env/basic/foo" +[2025-06-15 09:30:11.76084] [459931] [trace] [ljZh6m7gFAuH] Routing to a callback +[2025-06-15 09:30:11.76218] [459931] [debug] [CGI:env.cgi:459965] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi +[2025-06-15 09:30:11.77314] [459931] [trace] [ljZh6m7gFAuH] 200 OK (0.012399s, 80.652/s) t/basic.t ........................ ok 1 - GET /working ok 2 - 200 OK ok 3 - Content-Type: text/custom ok 4 - exact match for content -ok 5 - GET http://127.0.0.1:42881/env/basic/foo?query=123 +ok 5 - GET http://127.0.0.1:39165/env/basic/foo?query=123 ok 6 - 200 OK ok 7 - ENVIRONMENT ok 8 - CONTENT_LENGTH=0 @@ -393,10 +429,10 @@ ok 32 - HTTP_X_FORWARDED_FOR=1.2.3.4 1..32 ok -[2024-05-13 03:06:14.45543] [788530] [trace] [u0KsE1egEG0F] GET "/user/42" -[2024-05-13 03:06:14.45609] [788530] [trace] [u0KsE1egEG0F] Routing to a callback -[2024-05-13 03:06:14.46073] [788530] [debug] [CGI:env.cgi:788684] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi -[2024-05-13 03:06:14.50163] [788530] [trace] [u0KsE1egEG0F] 200 OK (0.04616s, 21.664/s) +[2025-06-15 09:30:12.10088] [459993] [trace] [EPwrYf6Fwt0O] GET "/user/42" +[2025-06-15 09:30:12.10129] [459993] [trace] [EPwrYf6Fwt0O] Routing to a callback +[2025-06-15 09:30:12.10348] [459993] [debug] [CGI:env.cgi:460095] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi +[2025-06-15 09:30:12.11538] [459993] [trace] [EPwrYf6Fwt0O] 200 OK (0.014485s, 69.037/s) t/before.t ....................... ok 1 - GET /user/42 ok 2 - 200 OK @@ -404,21 +440,21 @@ ok 4 - QUERY_STRING=...other_value=123 1..4 ok -[2024-05-13 03:06:15.27877] [788692] [trace] [MeZWTB45R5TS] GET "/foo" -[2024-05-13 03:06:15.27933] [788692] [trace] [MeZWTB45R5TS] Routing to a callback -[2024-05-13 03:06:15.34063] [788692] [debug] [CGI:CODE(0x55f199c93068):788763] START CODE(0x55f199c93068) +[2025-06-15 09:30:12.46372] [460100] [trace] [G2AjZ7VzA-Ah] GET "/foo" +[2025-06-15 09:30:12.46419] [460100] [trace] [G2AjZ7VzA-Ah] Routing to a callback +[2025-06-15 09:30:12.46635] [460100] [debug] [CGI:CODE(0x5587d92e0518):460178] START CODE(0x5587d92e0518) # PATH_INFO=/foo -[2024-05-13 03:06:15.37489] [788692] [trace] [MeZWTB45R5TS] 200 OK (0.095419s, 10.480/s) -[2024-05-13 03:06:15.39600] [788692] [trace] [MD-C71ijnahB] GET "/f%C3%B6%C3%B6" -[2024-05-13 03:06:15.39646] [788692] [trace] [MD-C71ijnahB] Routing to a callback -[2024-05-13 03:06:15.40150] [788692] [debug] [CGI:CODE(0x55f199c93068):788776] START CODE(0x55f199c93068) +[2025-06-15 09:30:12.47466] [460100] [trace] [G2AjZ7VzA-Ah] 200 OK (0.010893s, 91.802/s) +[2025-06-15 09:30:12.48091] [460100] [trace] [5rROXvcl-Hrd] GET "/f%C3%B6%C3%B6" +[2025-06-15 09:30:12.48133] [460100] [trace] [5rROXvcl-Hrd] Routing to a callback +[2025-06-15 09:30:12.48337] [460100] [debug] [CGI:CODE(0x5587d92e0518):460186] START CODE(0x5587d92e0518) # PATH_INFO=/föö -[2024-05-13 03:06:15.43625] [788692] [trace] [MD-C71ijnahB] 200 OK (0.040183s, 24.886/s) -[2024-05-13 03:06:15.45357] [788692] [trace] [dGxnt0NANy5X] GET "/f%C3%B6%E2%80%99" -[2024-05-13 03:06:15.45405] [788692] [trace] [dGxnt0NANy5X] Routing to a callback -[2024-05-13 03:06:15.45792] [788692] [debug] [CGI:CODE(0x55f199c93068):788783] START CODE(0x55f199c93068) +[2025-06-15 09:30:12.49120] [460100] [trace] [5rROXvcl-Hrd] 200 OK (0.010274s, 97.333/s) +[2025-06-15 09:30:12.49690] [460100] [trace] [2ZiTz1MyHA-q] GET "/f%C3%B6%E2%80%99" +[2025-06-15 09:30:12.49728] [460100] [trace] [2ZiTz1MyHA-q] Routing to a callback +[2025-06-15 09:30:12.50361] [460100] [debug] [CGI:CODE(0x5587d92e0518):460188] START CODE(0x5587d92e0518) # PATH_INFO=/fö’ -[2024-05-13 03:06:15.46851] [788692] [trace] [dGxnt0NANy5X] 200 OK (0.014849s, 67.345/s) +[2025-06-15 09:30:12.51075] [460100] [trace] [2ZiTz1MyHA-q] 200 OK (0.01382s, 72.359/s) t/encoding.t ..................... ok 1 - GET /foo ok 2 - 200 OK @@ -432,7 +468,7 @@ ok 10 - no warnings 1..10 ok -[2024-05-13 03:06:16.23713] [788792] [warn] [CGI:errlog:788844] yikes! at /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/errlog line 4. +[2025-06-15 09:30:12.94268] [460199] [warn] [CGI:errlog:460263] yikes! at /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/errlog line 4. t/errlog.t ....................... ok 1 - GET /err ok 2 - logged stderr @@ -443,19 +479,19 @@ 1..6 ok t/gh-16-loop_reset.t ............. skipped: set TEST_MORBO to enable this test (developer only!) -[2024-05-13 03:06:17.83021] [788990] [trace] [OBusZwz3yKoE] GET "/cgi-bin/nope.cgi/foo" -[2024-05-13 03:06:17.83094] [788990] [trace] [OBusZwz3yKoE] Routing to a callback +[2025-06-15 09:30:13.66702] [460318] [trace] [XNKfIMTV0uIm] GET "/cgi-bin/nope.cgi/foo" +[2025-06-15 09:30:13.66743] [460318] [trace] [XNKfIMTV0uIm] Routing to a callback Use of uninitialized value in print at t/Helper.pm line 18. -[2024-05-13 03:06:17.83630] [788990] [debug] [CGI:nope.cgi:789059] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/nope.cgi -[2024-05-13 03:06:17.85808] [788990] [trace] [OBusZwz3yKoE] 500 Internal Server Error (0.027783s, 35.993/s) -[2024-05-13 03:06:17.86553] [788990] [trace] [VXtD_TriIyPX] GET "/cgi-bin/env.cgi/some/path/info" -[2024-05-13 03:06:17.86612] [788990] [trace] [VXtD_TriIyPX] Routing to a callback -[2024-05-13 03:06:17.91536] [788990] [debug] [CGI:env.cgi:789082] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi -[2024-05-13 03:06:17.95994] [788990] [trace] [VXtD_TriIyPX] 200 OK (0.09432s, 10.602/s) -[2024-05-13 03:06:17.97562] [788990] [trace] [tRCIBU9nz_eb] GET "/cgi-bin/env/some/path/info" -[2024-05-13 03:06:17.97613] [788990] [trace] [tRCIBU9nz_eb] Routing to a callback -[2024-05-13 03:06:18.27446] [788990] [debug] [CGI:env.cgi:789154] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi -[2024-05-13 03:06:18.30874] [788990] [trace] [tRCIBU9nz_eb] 200 OK (0.333084s, 3.002/s) +[2025-06-15 09:30:13.66988] [460318] [debug] [CGI:nope.cgi:460319] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/nope.cgi +[2025-06-15 09:30:13.68306] [460318] [trace] [XNKfIMTV0uIm] 500 Internal Server Error (0.016026s, 62.399/s) +[2025-06-15 09:30:13.68744] [460318] [trace] [6LeY8cVrIkVr] GET "/cgi-bin/env.cgi/some/path/info" +[2025-06-15 09:30:13.68784] [460318] [trace] [6LeY8cVrIkVr] Routing to a callback +[2025-06-15 09:30:13.68995] [460318] [debug] [CGI:env.cgi:460320] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi +[2025-06-15 09:30:13.70127] [460318] [trace] [6LeY8cVrIkVr] 200 OK (0.013787s, 72.532/s) +[2025-06-15 09:30:13.70866] [460318] [trace] [ZoiC6qNVeRk6] GET "/cgi-bin/env/some/path/info" +[2025-06-15 09:30:13.70911] [460318] [trace] [ZoiC6qNVeRk6] Routing to a callback +[2025-06-15 09:30:13.71148] [460318] [debug] [CGI:env.cgi:460321] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi +[2025-06-15 09:30:13.72083] [460318] [trace] [ZoiC6qNVeRk6] 200 OK (0.012145s, 82.338/s) t/helper.t ....................... ok 1 - GET /cgi-bin/nope.cgi/foo ok 2 - 500 Internal Server Error @@ -474,50 +510,50 @@ ok 15 - SCRIPT_NAME 1..15 ok -[2024-05-13 03:06:18.98526] [789172] [trace] [pwUtieDrDdW5] POST "/file_upload" -[2024-05-13 03:06:18.98592] [789172] [trace] [pwUtieDrDdW5] Routing to a callback -[2024-05-13 03:06:18.99171] [789172] [debug] [CGI:file_upload:789220] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/file_upload -[2024-05-13 03:06:19.02790] [789172] [trace] [pwUtieDrDdW5] 200 OK (0.042605s, 23.471/s) +[2025-06-15 09:30:14.24237] [460322] [trace] [LKC2ra-2-Lg6] POST "/file_upload" +[2025-06-15 09:30:14.24291] [460322] [trace] [LKC2ra-2-Lg6] Routing to a callback +[2025-06-15 09:30:14.24577] [460322] [debug] [CGI:file_upload:460323] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/file_upload +[2025-06-15 09:30:14.33058] [460322] [trace] [LKC2ra-2-Lg6] 200 OK (0.088199s, 11.338/s) t/multipart.t .................... ok 1 - POST /file_upload ok 2 - 200 OK ok 3 - content is similar 1..3 ok -[2024-05-13 03:06:20.46892] [789233] [trace] [9oOv84YIwM6s] GET "/not-found" -[2024-05-13 03:06:20.46965] [789233] [trace] [9oOv84YIwM6s] Routing to a callback -[2024-05-13 03:06:20.75799] [789233] [debug] [CGI:not-found.pl:789713] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/not-found.pl -[2024-05-13 03:06:20.79371] [789233] [trace] [9oOv84YIwM6s] 404 Not Found (0.324747s, 3.079/s) +[2025-06-15 09:30:14.83521] [460324] [trace] [blWxw_vvlvI9] GET "/not-found" +[2025-06-15 09:30:14.83552] [460324] [trace] [blWxw_vvlvI9] Routing to a callback +[2025-06-15 09:30:14.86002] [460324] [debug] [CGI:not-found.pl:460325] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/not-found.pl +[2025-06-15 09:30:14.86970] [460324] [trace] [blWxw_vvlvI9] 404 Not Found (0.034477s, 29.005/s) t/not-found.t .................... ok 1 - GET /not-found ok 2 - 404 Not Found ok 3 - content is similar 1..3 ok -[2024-05-13 03:06:21.61111] [789748] [trace] [CNKkEmsROB6D] GET "/not-modified" -[2024-05-13 03:06:21.61180] [789748] [trace] [CNKkEmsROB6D] Routing to a callback -[2024-05-13 03:06:21.62029] [789748] [debug] [CGI:not-modified.pl:789884] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/not-modified.pl -[2024-05-13 03:06:21.66940] [789748] [trace] [CNKkEmsROB6D] 304 Not Modified (0.058237s, 17.171/s) +[2025-06-15 09:30:15.19297] [460326] [trace] [yQulyTLJiouw] GET "/not-modified" +[2025-06-15 09:30:15.19338] [460326] [trace] [yQulyTLJiouw] Routing to a callback +[2025-06-15 09:30:15.19543] [460326] [debug] [CGI:not-modified.pl:460339] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/not-modified.pl +[2025-06-15 09:30:15.20532] [460326] [trace] [yQulyTLJiouw] 304 Not Modified (0.012344s, 81.011/s) t/not-modified.t ................. ok 1 - GET /not-modified ok 2 - 304 Not Modified ok 3 - X-Test: if-none-match seen: ABC 1..3 ok -[2024-05-13 03:06:22.47665] [789907] [trace] [fvp5jDRpi4oz] GET "/nph-borked" -[2024-05-13 03:06:22.47722] [789907] [trace] [fvp5jDRpi4oz] Routing to a callback -[2024-05-13 03:06:22.48161] [789907] [debug] [CGI:nph-borked.pl:790037] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/nph-borked.pl -[2024-05-13 03:06:22.50236] [789907] [trace] [fvp5jDRpi4oz] 403 Forbidden (0.025683s, 38.936/s) +[2025-06-15 09:30:15.59297] [460340] [trace] [r1qg5jZ9GRar] GET "/nph-borked" +[2025-06-15 09:30:15.59337] [460340] [trace] [r1qg5jZ9GRar] Routing to a callback +[2025-06-15 09:30:15.59524] [460340] [debug] [CGI:nph-borked.pl:460341] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/nph-borked.pl +[2025-06-15 09:30:15.60600] [460340] [trace] [r1qg5jZ9GRar] 403 Forbidden (0.013001s, 76.917/s) t/nph-borked.t ................... ok 1 - GET /nph-borked ok 2 - 403 Forbidden ok 3 - content is similar 1..3 ok -[2024-05-13 03:06:23.35672] [790052] [trace] [n5j9obCfc_fp] GET "/nph" -[2024-05-13 03:06:23.35725] [790052] [trace] [n5j9obCfc_fp] Routing to a callback -[2024-05-13 03:06:23.48339] [790052] [debug] [CGI:nph.pl:790111] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/nph.pl -[2024-05-13 03:06:23.50823] [790052] [trace] [n5j9obCfc_fp] 403 Payment Required (0.151471s, 6.602/s) +[2025-06-15 09:30:15.93839] [460342] [trace] [85NFocP4wxpy] GET "/nph" +[2025-06-15 09:30:15.93880] [460342] [trace] [85NFocP4wxpy] Routing to a callback +[2025-06-15 09:30:15.94066] [460342] [debug] [CGI:nph.pl:460343] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/nph.pl +[2025-06-15 09:30:15.95037] [460342] [trace] [85NFocP4wxpy] 403 Payment Required (0.011963s, 83.591/s) t/nph.t .......................... ok 1 - GET /nph ok 2 - 403 Forbidden @@ -525,10 +561,10 @@ 1..3 ok t/post.t ......................... skipped: TEST_PIPES=1; No idea how to test this consistently -[2024-05-13 03:06:25.04148] [790204] [trace] [JVnvHkr2jQ3I] GET "/env/basic/foo" -[2024-05-13 03:06:25.04857] [790204] [trace] [JVnvHkr2jQ3I] Routing to a callback -[2024-05-13 03:06:25.05513] [790204] [debug] [CGI:env.cgi:790300] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi -[2024-05-13 03:06:25.09366] [790204] [trace] [JVnvHkr2jQ3I] 200 OK (0.052196s, 19.159/s) +[2025-06-15 09:30:16.76126] [460345] [trace] [mR03bd9VxwEY] GET "/env/basic/foo" +[2025-06-15 09:30:16.76182] [460345] [trace] [mR03bd9VxwEY] Routing to a callback +[2025-06-15 09:30:16.76438] [460345] [debug] [CGI:env.cgi:460367] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi +[2025-06-15 09:30:16.77494] [460345] [trace] [mR03bd9VxwEY] 200 OK (0.013662s, 73.196/s) t/query-string-with-semicolon.t .. ok 1 - GET /env/basic/foo?a=1;b=2 ok 2 - 200 OK @@ -540,10 +576,10 @@ # expected: '1' 1..4 ok -[2024-05-13 03:06:25.75751] [790322] [trace] [0qpOEJB-bzee] GET "/redirect" -[2024-05-13 03:06:25.75815] [790322] [trace] [0qpOEJB-bzee] Routing to a callback -[2024-05-13 03:06:25.76291] [790322] [debug] [CGI:redirect.pl:790377] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/redirect.pl -[2024-05-13 03:06:26.05663] [790322] [trace] [0qpOEJB-bzee] 302 Found (0.299004s, 3.344/s) +[2025-06-15 09:30:17.09344] [460368] [trace] [Cdje1hq3j3er] GET "/redirect" +[2025-06-15 09:30:17.09385] [460368] [trace] [Cdje1hq3j3er] Routing to a callback +[2025-06-15 09:30:17.09609] [460368] [debug] [CGI:redirect.pl:460369] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/redirect.pl +[2025-06-15 09:30:17.10760] [460368] [trace] [Cdje1hq3j3er] 302 Found (0.014133s, 70.756/s) t/redirect.t ..................... ok 1 - GET /redirect ok 2 - 302 Found @@ -551,35 +587,35 @@ ok 4 - exact match for content 1..4 ok -[2024-05-13 03:06:26.96711] [790413] [trace] [5EkvR2odFZmd] GET "/auth" -[2024-05-13 03:06:26.96797] [790413] [trace] [5EkvR2odFZmd] Routing to a callback -[2024-05-13 03:06:27.08804] [790413] [debug] [CGI:env.cgi:790580] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi -[2024-05-13 03:06:27.13602] [790413] [trace] [5EkvR2odFZmd] 200 OK (0.168878s, 5.921/s) -[2024-05-13 03:06:27.27522] [790413] [trace] [51hZ1FWCJFaM] GET "/auth" -[2024-05-13 03:06:27.27557] [790413] [trace] [51hZ1FWCJFaM] Routing to a callback -[2024-05-13 03:06:27.28372] [790413] [debug] [CGI:env.cgi:790625] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi -[2024-05-13 03:06:27.30792] [790413] [trace] [51hZ1FWCJFaM] 200 OK (0.032646s, 30.632/s) -[2024-05-13 03:06:27.57952] [790413] [trace] [Y7J5Tjh_BGbM] GET "/auth" -[2024-05-13 03:06:27.57984] [790413] [trace] [Y7J5Tjh_BGbM] Routing to a callback -[2024-05-13 03:06:27.59199] [790413] [debug] [CGI:env.cgi:790679] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi -[2024-05-13 03:06:27.64385] [790413] [trace] [Y7J5Tjh_BGbM] 200 OK (0.064287s, 15.555/s) +[2025-06-15 09:30:17.47654] [460370] [trace] [WRSg46UH00E-] GET "/auth" +[2025-06-15 09:30:17.47694] [460370] [trace] [WRSg46UH00E-] Routing to a callback +[2025-06-15 09:30:17.47889] [460370] [debug] [CGI:env.cgi:460371] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi +[2025-06-15 09:30:17.48957] [460370] [trace] [WRSg46UH00E-] 200 OK (0.013007s, 76.882/s) +[2025-06-15 09:30:17.49521] [460370] [trace] [Qq6VvryqImnA] GET "/auth" +[2025-06-15 09:30:17.49545] [460370] [trace] [Qq6VvryqImnA] Routing to a callback +[2025-06-15 09:30:17.49704] [460370] [debug] [CGI:env.cgi:460372] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi +[2025-06-15 09:30:17.50722] [460370] [trace] [Qq6VvryqImnA] 200 OK (0.011979s, 83.479/s) +[2025-06-15 09:30:17.51243] [460370] [trace] [aZ44_bFp9N-P] GET "/auth" +[2025-06-15 09:30:17.51267] [460370] [trace] [aZ44_bFp9N-P] Routing to a callback +[2025-06-15 09:30:17.51420] [460370] [debug] [CGI:env.cgi:460373] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi +[2025-06-15 09:30:17.52380] [460370] [trace] [aZ44_bFp9N-P] 200 OK (0.011348s, 88.121/s) t/remote-user.t .................. ok 1 - GET /auth ok 2 - 200 OK ok 3 - 200 OK ok 4 - REMOTE_USER= -ok 5 - GET http://127.0.0.1:41919/auth +ok 5 - GET http://127.0.0.1:40651/auth ok 6 - 200 OK ok 7 - REMOTE_USER=Aladdin -ok 8 - GET http://127.0.0.1:41919/auth +ok 8 - GET http://127.0.0.1:40651/auth ok 9 - 200 OK ok 10 - REMOTE_USER=Aladdin 1..10 ok -[2024-05-13 03:06:28.42180] [790696] [trace] [kunEXX9x8CQF] GET "/" -[2024-05-13 03:06:28.42233] [790696] [trace] [kunEXX9x8CQF] Routing to a callback -[2024-05-13 03:06:28.42916] [790696] [debug] [CGI:CODE(0x564f50e73cd0):790747] START CODE(0x564f50e73cd0) -[2024-05-13 03:06:28.45589] [790696] [trace] [kunEXX9x8CQF] 200 OK (0.034033s, 29.383/s) +[2025-06-15 09:30:17.83488] [460374] [trace] [tZewtbaWNsS3] GET "/" +[2025-06-15 09:30:17.83526] [460374] [trace] [tZewtbaWNsS3] Routing to a callback +[2025-06-15 09:30:17.83719] [460374] [debug] [CGI:CODE(0x5569b7b4cce0):460375] START CODE(0x5569b7b4cce0) +[2025-06-15 09:30:17.84180] [460374] [trace] [tZewtbaWNsS3] 200 OK (0.006903s, 144.865/s) t/run.t .......................... ok 1 - GET / ok 2 - 200 OK @@ -588,13 +624,13 @@ ok t/zombies.t ...................... skipped: (no reason given) All tests successful. -Files=18, Tests=110, 21 wallclock secs ( 0.10 usr 0.05 sys + 10.06 cusr 1.71 csys = 11.92 CPU) +Files=18, Tests=110, 7 wallclock secs ( 0.06 usr 0.03 sys + 5.24 cusr 0.96 csys = 6.29 CPU) Result: PASS make[1]: Leaving directory '/build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40' create-stamp debian/debhelper-build-stamp dh_prep dh_auto_install --destdir=debian/libmojolicious-plugin-cgi-perl/ - make -j20 install DESTDIR=/build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/debian/libmojolicious-plugin-cgi-perl AM_UPDATE_INFO_DIR=no PREFIX=/usr + make -j42 install DESTDIR=/build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/debian/libmojolicious-plugin-cgi-perl AM_UPDATE_INFO_DIR=no PREFIX=/usr make[1]: Entering directory '/build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40' Manifying 1 pod document Installing /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/debian/libmojolicious-plugin-cgi-perl/usr/share/perl5/Mojolicious/Plugin/CGI.pm @@ -621,12 +657,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/455939/tmp/hooks/B01_cleanup starting +I: user script /srv/workspace/pbuilder/455939/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/771134 and its subdirectories -I: Current time: Sun May 12 15:06:38 -12 2024 -I: pbuilder-time-stamp: 1715569598 +I: removing directory /srv/workspace/pbuilder/455939 and its subdirectories +I: Current time: Sun Jun 15 23:30:25 +14 2025 +I: pbuilder-time-stamp: 1749979825