Diff of the two buildlogs: -- --- b1/build.log 2024-03-21 20:54:17.648674264 +0000 +++ b2/build.log 2024-03-21 20:55:04.086698419 +0000 @@ -1,6 +1,6 @@ I: pbuilder: network access will be disabled during build -I: Current time: Wed Apr 23 15:16:52 -12 2025 -I: pbuilder-time-stamp: 1745464612 +I: Current time: Fri Mar 22 10:54:20 +14 2024 +I: pbuilder-time-stamp: 1711054460 I: Building the build Environment I: extracting base tarball [/var/cache/pbuilder/trixie-reproducible-base.tgz] I: copying local configuration @@ -26,54 +26,86 @@ 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/33374/tmp/hooks/D02_print_environment starting +I: user script /srv/workspace/pbuilder/12544/tmp/hooks/D01_modify_environment starting +debug: Running on ionos12-i386. +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 Mar 21 20:54 /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/12544/tmp/hooks/D01_modify_environment finished +I: user script /srv/workspace/pbuilder/12544/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='i386' - DEBIAN_FRONTEND='noninteractive' - DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all parallel=22 ' - DISTRIBUTION='trixie' - HOME='/root' - HOST_ARCH='i386' + 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]="i686-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=i386 + DEBIAN_FRONTEND=noninteractive + DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all parallel=10 ' + DIRSTACK=() + DISTRIBUTION=trixie + EUID=0 + FUNCNAME=([0]="Echo" [1]="main") + GROUPS=() + HOME=/root + HOSTNAME=i-capture-the-hostname + HOSTTYPE=i686 + HOST_ARCH=i386 IFS=' ' - INVOCATION_ID='e4242405f38c4f198ec21906a6331572' - LANG='C' - LANGUAGE='en_US:en' - LC_ALL='C' - LD_LIBRARY_PATH='/usr/lib/libeatmydata' - LD_PRELOAD='libeatmydata.so' - 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='33374' - PS1='# ' - PS2='> ' + INVOCATION_ID=71f6941496a545378c9ee492c3b0cbd7 + LANG=C + LANGUAGE=de_CH:de + LC_ALL=C + LD_LIBRARY_PATH=/usr/lib/libeatmydata + LD_PRELOAD=libeatmydata.so + MACHTYPE=i686-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=12544 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.OUHdo0g2/pbuilderrc_KWYr --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.OUHdo0g2/b1 --logfile b1/build.log libmojolicious-plugin-cgi-perl_0.40-2.dsc' - SUDO_GID='112' - SUDO_UID='107' - SUDO_USER='jenkins' - TERM='unknown' - TZ='/usr/share/zoneinfo/Etc/GMT+12' - USER='root' - _='/usr/bin/systemd-run' - http_proxy='http://85.184.249.68: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.OUHdo0g2/pbuilderrc_0V78 --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.OUHdo0g2/b2 --logfile b2/build.log libmojolicious-plugin-cgi-perl_0.40-2.dsc' + SUDO_GID=112 + SUDO_UID=107 + SUDO_USER=jenkins + TERM=unknown + TZ=/usr/share/zoneinfo/Etc/GMT-14 + UID=0 + USER=root + _='I: set' + http_proxy=http://78.137.99.97:3128 I: uname -a - Linux ionos16-i386 6.1.0-18-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.1.76-1 (2024-02-01) x86_64 GNU/Linux + Linux i-capture-the-hostname 6.1.0-18-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.1.76-1 (2024-02-01) x86_64 GNU/Linux I: ls -l /bin - lrwxrwxrwx 1 root root 7 Apr 23 17:47 /bin -> usr/bin -I: user script /srv/workspace/pbuilder/33374/tmp/hooks/D02_print_environment finished + lrwxrwxrwx 1 root root 7 Mar 19 11:28 /bin -> usr/bin +I: user script /srv/workspace/pbuilder/12544/tmp/hooks/D02_print_environment finished -> Attempting to satisfy build-dependencies -> Creating pbuilder-satisfydepends-dummy package Package: pbuilder-satisfydepends-dummy @@ -150,7 +182,7 @@ Get: 35 http://deb.debian.org/debian trixie/main i386 libjs-highlight.js all 9.18.5+dfsg1-2 [397 kB] Get: 36 http://deb.debian.org/debian trixie/main i386 libjs-jquery all 3.6.1+dfsg+~3.5.14-1 [326 kB] Get: 37 http://deb.debian.org/debian trixie/main i386 libmojolicious-perl all 9.35+dfsg-1 [875 kB] -Fetched 21.5 MB in 0s (90.4 MB/s) +Fetched 21.5 MB in 1s (31.7 MB/s) debconf: delaying package configuration, since apt-utils is not installed Selecting previously unselected package sensible-utils. (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 19816 files and directories currently installed.) @@ -313,7 +345,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/12544/tmp/hooks/A99_set_merged_usr starting +Not re-configuring usrmerge for trixie +I: user script /srv/workspace/pbuilder/12544/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 @@ -335,43 +371,43 @@ Writing Makefile for Mojolicious::Plugin::CGI Writing MYMETA.yml and MYMETA.json dh_auto_build - make -j22 + make -j10 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 -j22 test TEST_VERBOSE=1 + make -j10 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(0x579f8c00)) (Test::Pod::Coverage is required) +ok 3 # skip pod_coverage_ok(Mojolicious::Plugin::CGI HASH(0x588e8668)) (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 -[2025-04-24 03:17:08.82431] [34500] [trace] [diYbCXkREIab] GET "/working" -[2025-04-24 03:17:08.82472] [34500] [trace] [diYbCXkREIab] Routing to a callback -[2025-04-24 03:17:08.82622] [34500] [debug] [CGI:basic.pl:34501] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/basic.pl -[2025-04-24 03:17:08.83509] [34500] [trace] [diYbCXkREIab] 200 OK (0.010765s, 92.894/s) -[2025-04-24 03:17:08.83987] [34500] [trace] [_VSOJ6lj1V72] GET "/env/basic/foo" -[2025-04-24 03:17:08.84023] [34500] [trace] [_VSOJ6lj1V72] Routing to a callback -[2025-04-24 03:17:08.84143] [34500] [debug] [CGI:env.cgi:34502] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi -[2025-04-24 03:17:08.85141] [34500] [trace] [_VSOJ6lj1V72] 200 OK (0.011524s, 86.775/s) -[2025-04-24 03:17:08.86287] [34500] [trace] [vgmia6indupd] GET "/env/basic/foo" -[2025-04-24 03:17:08.86309] [34500] [trace] [vgmia6indupd] Routing to a callback -[2025-04-24 03:17:08.86433] [34500] [debug] [CGI:env.cgi:34503] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi -[2025-04-24 03:17:08.87502] [34500] [trace] [vgmia6indupd] 200 OK (0.012108s, 82.590/s) +[2024-03-21 20:54:48.46035] [24075] [trace] [EZtHmmE3iFIk] GET "/working" +[2024-03-21 20:54:48.46087] [24075] [trace] [EZtHmmE3iFIk] Routing to a callback +[2024-03-21 20:54:48.46351] [24075] [debug] [CGI:basic.pl:24211] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/basic.pl +[2024-03-21 20:54:48.47863] [24075] [trace] [EZtHmmE3iFIk] 200 OK (0.018252s, 54.789/s) +[2024-03-21 20:54:48.48572] [24075] [trace] [8O-knzk7IC3T] GET "/env/basic/foo" +[2024-03-21 20:54:48.48624] [24075] [trace] [8O-knzk7IC3T] Routing to a callback +[2024-03-21 20:54:48.48860] [24075] [debug] [CGI:env.cgi:24222] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi +[2024-03-21 20:54:48.50295] [24075] [trace] [8O-knzk7IC3T] 200 OK (0.017176s, 58.221/s) +[2024-03-21 20:54:48.51674] [24075] [trace] [hSlRncUz6H_i] GET "/env/basic/foo" +[2024-03-21 20:54:48.51698] [24075] [trace] [hSlRncUz6H_i] Routing to a callback +[2024-03-21 20:54:48.51924] [24075] [debug] [CGI:env.cgi:24223] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi +[2024-03-21 20:54:48.53339] [24075] [trace] [hSlRncUz6H_i] 200 OK (0.016632s, 60.125/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:43071/env/basic/foo?query=123 +ok 5 - GET http://127.0.0.1:42541/env/basic/foo?query=123 ok 6 - 200 OK ok 7 - ENVIRONMENT ok 8 - CONTENT_LENGTH=0 @@ -401,10 +437,10 @@ ok 32 - HTTP_X_FORWARDED_FOR=1.2.3.4 1..32 ok -[2025-04-24 03:17:09.20204] [34504] [trace] [avKJRfHEKNs3] GET "/user/42" -[2025-04-24 03:17:09.20244] [34504] [trace] [avKJRfHEKNs3] Routing to a callback -[2025-04-24 03:17:09.20382] [34504] [debug] [CGI:env.cgi:34505] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi -[2025-04-24 03:17:09.21280] [34504] [trace] [avKJRfHEKNs3] 200 OK (0.010748s, 93.041/s) +[2024-03-21 20:54:49.24981] [24226] [trace] [ctzHhheFNnxF] GET "/user/42" +[2024-03-21 20:54:49.25064] [24226] [trace] [ctzHhheFNnxF] Routing to a callback +[2024-03-21 20:54:49.25413] [24226] [debug] [CGI:env.cgi:24300] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi +[2024-03-21 20:54:49.27290] [24226] [trace] [ctzHhheFNnxF] 200 OK (0.023076s, 43.335/s) t/before.t ....................... ok 1 - GET /user/42 ok 2 - 200 OK @@ -412,21 +448,21 @@ ok 4 - QUERY_STRING=...other_value=123 1..4 ok -[2025-04-24 03:17:09.54186] [34506] [trace] [IFakm3_IPkgL] GET "/foo" -[2025-04-24 03:17:09.54224] [34506] [trace] [IFakm3_IPkgL] Routing to a callback -[2025-04-24 03:17:09.54363] [34506] [debug] [CGI:CODE(0x57de1bc4):34507] START CODE(0x57de1bc4) +[2024-03-21 20:54:49.87842] [24306] [trace] [kpDqVFnUg7dJ] GET "/foo" +[2024-03-21 20:54:49.87896] [24306] [trace] [kpDqVFnUg7dJ] Routing to a callback +[2024-03-21 20:54:49.88186] [24306] [debug] [CGI:CODE(0x58caeb5c):24409] START CODE(0x58caeb5c) # PATH_INFO=/foo -[2025-04-24 03:17:09.55010] [34506] [trace] [IFakm3_IPkgL] 200 OK (0.008196s, 122.011/s) -[2025-04-24 03:17:09.55516] [34506] [trace] [I-59969NQAJ5] GET "/f%C3%B6%C3%B6" -[2025-04-24 03:17:09.55551] [34506] [trace] [I-59969NQAJ5] Routing to a callback -[2025-04-24 03:17:09.55685] [34506] [debug] [CGI:CODE(0x57de1bc4):34508] START CODE(0x57de1bc4) +[2024-03-21 20:54:49.88942] [24306] [trace] [kpDqVFnUg7dJ] 200 OK (0.010964s, 91.208/s) +[2024-03-21 20:54:49.89727] [24306] [trace] [vkixcJqDhtJn] GET "/f%C3%B6%C3%B6" +[2024-03-21 20:54:49.89771] [24306] [trace] [vkixcJqDhtJn] Routing to a callback +[2024-03-21 20:54:49.89989] [24306] [debug] [CGI:CODE(0x58caeb5c):24423] START CODE(0x58caeb5c) # PATH_INFO=/föö -[2025-04-24 03:17:09.56265] [34506] [trace] [I-59969NQAJ5] 200 OK (0.007453s, 134.174/s) -[2025-04-24 03:17:09.56698] [34506] [trace] [VoSFGcOjzDwc] GET "/f%C3%B6%E2%80%99" -[2025-04-24 03:17:09.56731] [34506] [trace] [VoSFGcOjzDwc] Routing to a callback -[2025-04-24 03:17:09.56852] [34506] [debug] [CGI:CODE(0x57de1bc4):34509] START CODE(0x57de1bc4) +[2024-03-21 20:54:49.90698] [24306] [trace] [vkixcJqDhtJn] 200 OK (0.009663s, 103.488/s) +[2024-03-21 20:54:49.91349] [24306] [trace] [ttqK_Jk-9Awd] GET "/f%C3%B6%E2%80%99" +[2024-03-21 20:54:49.91392] [24306] [trace] [ttqK_Jk-9Awd] Routing to a callback +[2024-03-21 20:54:49.91630] [24306] [debug] [CGI:CODE(0x58caeb5c):24425] START CODE(0x58caeb5c) # PATH_INFO=/fö’ -[2025-04-24 03:17:09.57336] [34506] [trace] [VoSFGcOjzDwc] 200 OK (0.006354s, 157.381/s) +[2024-03-21 20:54:49.92361] [24306] [trace] [ttqK_Jk-9Awd] 200 OK (0.01008s, 99.206/s) t/encoding.t ..................... ok 1 - GET /foo ok 2 - 200 OK @@ -440,7 +476,7 @@ ok 10 - no warnings 1..10 ok -[2025-04-24 03:17:09.90499] [34510] [warn] [CGI:errlog:34511] yikes! at /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/errlog line 4. +[2024-03-21 20:54:50.54478] [24426] [warn] [CGI:errlog:24519] 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 @@ -451,19 +487,19 @@ 1..6 ok t/gh-16-loop_reset.t ............. skipped: set TEST_MORBO to enable this test (developer only!) -[2025-04-24 03:17:10.52574] [34515] [trace] [-n5fztRM4C2v] GET "/cgi-bin/nope.cgi/foo" -[2025-04-24 03:17:10.52607] [34515] [trace] [-n5fztRM4C2v] Routing to a callback +[2024-03-21 20:54:51.78957] [24581] [trace] [X3n7jqDKU_5j] GET "/cgi-bin/nope.cgi/foo" +[2024-03-21 20:54:51.79011] [24581] [trace] [X3n7jqDKU_5j] Routing to a callback Use of uninitialized value in print at t/Helper.pm line 18. -[2025-04-24 03:17:10.52771] [34515] [debug] [CGI:nope.cgi:34516] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/nope.cgi -[2025-04-24 03:17:10.53745] [34515] [trace] [-n5fztRM4C2v] 500 Internal Server Error (0.0117s, 85.470/s) -[2025-04-24 03:17:10.54084] [34515] [trace] [U09JjXsl4lLk] GET "/cgi-bin/env.cgi/some/path/info" -[2025-04-24 03:17:10.54109] [34515] [trace] [U09JjXsl4lLk] Routing to a callback -[2025-04-24 03:17:10.54248] [34515] [debug] [CGI:env.cgi:34517] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi -[2025-04-24 03:17:10.55114] [34515] [trace] [U09JjXsl4lLk] 200 OK (0.010264s, 97.428/s) -[2025-04-24 03:17:10.55617] [34515] [trace] [c1rreN1ejMUP] GET "/cgi-bin/env/some/path/info" -[2025-04-24 03:17:10.55650] [34515] [trace] [c1rreN1ejMUP] Routing to a callback -[2025-04-24 03:17:10.55801] [34515] [debug] [CGI:env.cgi:34518] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi -[2025-04-24 03:17:10.56679] [34515] [trace] [c1rreN1ejMUP] 200 OK (0.010597s, 94.366/s) +[2024-03-21 20:54:51.79303] [24581] [debug] [CGI:nope.cgi:24654] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/nope.cgi +[2024-03-21 20:54:51.81126] [24581] [trace] [X3n7jqDKU_5j] 500 Internal Server Error (0.021648s, 46.194/s) +[2024-03-21 20:54:51.81674] [24581] [trace] [8heUETIzvMcz] GET "/cgi-bin/env.cgi/some/path/info" +[2024-03-21 20:54:51.81716] [24581] [trace] [8heUETIzvMcz] Routing to a callback +[2024-03-21 20:54:51.81974] [24581] [debug] [CGI:env.cgi:24655] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi +[2024-03-21 20:54:51.83766] [24581] [trace] [8heUETIzvMcz] 200 OK (0.020888s, 47.874/s) +[2024-03-21 20:54:51.84529] [24581] [trace] [zbs6MREWdYyI] GET "/cgi-bin/env/some/path/info" +[2024-03-21 20:54:51.84572] [24581] [trace] [zbs6MREWdYyI] Routing to a callback +[2024-03-21 20:54:51.84821] [24581] [debug] [CGI:env.cgi:24656] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi +[2024-03-21 20:54:51.86587] [24581] [trace] [zbs6MREWdYyI] 200 OK (0.020524s, 48.723/s) t/helper.t ....................... ok 1 - GET /cgi-bin/nope.cgi/foo ok 2 - 500 Internal Server Error @@ -482,50 +518,50 @@ ok 15 - SCRIPT_NAME 1..15 ok -[2025-04-24 03:17:10.89408] [34519] [trace] [Xli-3v7b8iqt] POST "/file_upload" -[2025-04-24 03:17:10.89440] [34519] [trace] [Xli-3v7b8iqt] Routing to a callback -[2025-04-24 03:17:10.89590] [34519] [debug] [CGI:file_upload:34520] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/file_upload -[2025-04-24 03:17:10.90617] [34519] [trace] [Xli-3v7b8iqt] 200 OK (0.012069s, 82.857/s) +[2024-03-21 20:54:52.46868] [24658] [trace] [uj4NeS1hRtwU] POST "/file_upload" +[2024-03-21 20:54:52.46919] [24658] [trace] [uj4NeS1hRtwU] Routing to a callback +[2024-03-21 20:54:52.47166] [24658] [debug] [CGI:file_upload:24692] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/file_upload +[2024-03-21 20:54:52.49009] [24658] [trace] [uj4NeS1hRtwU] 200 OK (0.021401s, 46.727/s) t/multipart.t .................... ok 1 - POST /file_upload ok 2 - 200 OK ok 3 - content is similar 1..3 ok -[2025-04-24 03:17:11.23283] [34521] [trace] [I3z5ktHv9rGL] GET "/not-found" -[2025-04-24 03:17:11.23323] [34521] [trace] [I3z5ktHv9rGL] Routing to a callback -[2025-04-24 03:17:11.23468] [34521] [debug] [CGI:not-found.pl:34522] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/not-found.pl -[2025-04-24 03:17:11.24500] [34521] [trace] [I3z5ktHv9rGL] 404 Not Found (0.012139s, 82.379/s) +[2024-03-21 20:54:53.08233] [24706] [trace] [VMqhE6q4IWNd] GET "/not-found" +[2024-03-21 20:54:53.08287] [24706] [trace] [VMqhE6q4IWNd] Routing to a callback +[2024-03-21 20:54:53.08527] [24706] [debug] [CGI:not-found.pl:24763] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/not-found.pl +[2024-03-21 20:54:53.10374] [24706] [trace] [VMqhE6q4IWNd] 404 Not Found (0.021394s, 46.742/s) t/not-found.t .................... ok 1 - GET /not-found ok 2 - 404 Not Found ok 3 - content is similar 1..3 ok -[2025-04-24 03:17:11.57212] [34523] [trace] [QGRQ7cvRQG_D] GET "/not-modified" -[2025-04-24 03:17:11.57256] [34523] [trace] [QGRQ7cvRQG_D] Routing to a callback -[2025-04-24 03:17:11.57401] [34523] [debug] [CGI:not-modified.pl:34524] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/not-modified.pl -[2025-04-24 03:17:11.58295] [34523] [trace] [QGRQ7cvRQG_D] 304 Not Modified (0.010815s, 92.464/s) +[2024-03-21 20:54:53.69257] [24766] [trace] [e_H6Vfc8XxkX] GET "/not-modified" +[2024-03-21 20:54:53.69306] [24766] [trace] [e_H6Vfc8XxkX] Routing to a callback +[2024-03-21 20:54:53.69528] [24766] [debug] [CGI:not-modified.pl:24809] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/not-modified.pl +[2024-03-21 20:54:53.70958] [24766] [trace] [e_H6Vfc8XxkX] 304 Not Modified (0.017011s, 58.785/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 -[2025-04-24 03:17:11.91012] [34525] [trace] [kUdYbv9fUb4B] GET "/nph-borked" -[2025-04-24 03:17:11.91058] [34525] [trace] [kUdYbv9fUb4B] Routing to a callback -[2025-04-24 03:17:11.91215] [34525] [debug] [CGI:nph-borked.pl:34526] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/nph-borked.pl -[2025-04-24 03:17:11.92133] [34525] [trace] [kUdYbv9fUb4B] 403 Forbidden (0.0112s, 89.286/s) +[2024-03-21 20:54:54.37630] [24811] [trace] [yIKZkq_2xQk4] GET "/nph-borked" +[2024-03-21 20:54:54.37687] [24811] [trace] [yIKZkq_2xQk4] Routing to a callback +[2024-03-21 20:54:54.37918] [24811] [debug] [CGI:nph-borked.pl:24875] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/nph-borked.pl +[2024-03-21 20:54:54.39325] [24811] [trace] [yIKZkq_2xQk4] 403 Forbidden (0.016927s, 59.077/s) t/nph-borked.t ................... ok 1 - GET /nph-borked ok 2 - 403 Forbidden ok 3 - content is similar 1..3 ok -[2025-04-24 03:17:12.25083] [34527] [trace] [dNTUPspnIlRJ] GET "/nph" -[2025-04-24 03:17:12.25130] [34527] [trace] [dNTUPspnIlRJ] Routing to a callback -[2025-04-24 03:17:12.25291] [34527] [debug] [CGI:nph.pl:34528] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/nph.pl -[2025-04-24 03:17:12.26215] [34527] [trace] [dNTUPspnIlRJ] 403 Payment Required (0.011307s, 88.441/s) +[2024-03-21 20:54:55.00003] [24876] [trace] [_mvjQ3GYcHKA] GET "/nph" +[2024-03-21 20:54:55.00049] [24876] [trace] [_mvjQ3GYcHKA] Routing to a callback +[2024-03-21 20:54:55.00320] [24876] [debug] [CGI:nph.pl:24904] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/nph.pl +[2024-03-21 20:54:55.01791] [24876] [trace] [_mvjQ3GYcHKA] 403 Payment Required (0.017856s, 56.004/s) t/nph.t .......................... ok 1 - GET /nph ok 2 - 403 Forbidden @@ -533,10 +569,10 @@ 1..3 ok t/post.t ......................... skipped: TEST_PIPES=1; No idea how to test this consistently -[2025-04-24 03:17:12.89585] [34530] [trace] [B75X0Q66UTaA] GET "/env/basic/foo" -[2025-04-24 03:17:12.89624] [34530] [trace] [B75X0Q66UTaA] Routing to a callback -[2025-04-24 03:17:12.89764] [34530] [debug] [CGI:env.cgi:34531] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi -[2025-04-24 03:17:12.90615] [34530] [trace] [B75X0Q66UTaA] 200 OK (0.01028s, 97.276/s) +[2024-03-21 20:54:56.33109] [24946] [trace] [-dEoNilxL-j3] GET "/env/basic/foo" +[2024-03-21 20:54:56.33175] [24946] [trace] [-dEoNilxL-j3] Routing to a callback +[2024-03-21 20:54:56.33453] [24946] [debug] [CGI:env.cgi:24978] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi +[2024-03-21 20:54:56.34974] [24946] [trace] [-dEoNilxL-j3] 200 OK (0.018622s, 53.700/s) t/query-string-with-semicolon.t .. ok 1 - GET /env/basic/foo?a=1;b=2 ok 2 - 200 OK @@ -548,10 +584,10 @@ # expected: '1' 1..4 ok -[2025-04-24 03:17:13.23090] [34532] [trace] [Ap48OJyYXEH-] GET "/redirect" -[2025-04-24 03:17:13.23126] [34532] [trace] [Ap48OJyYXEH-] Routing to a callback -[2025-04-24 03:17:13.23268] [34532] [debug] [CGI:redirect.pl:34533] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/redirect.pl -[2025-04-24 03:17:13.24262] [34532] [trace] [Ap48OJyYXEH-] 302 Found (0.011716s, 85.353/s) +[2024-03-21 20:54:56.97194] [24979] [trace] [H7E1UEN6TOcO] GET "/redirect" +[2024-03-21 20:54:56.97244] [24979] [trace] [H7E1UEN6TOcO] Routing to a callback +[2024-03-21 20:54:56.97474] [24979] [debug] [CGI:redirect.pl:24987] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/redirect.pl +[2024-03-21 20:54:56.98974] [24979] [trace] [H7E1UEN6TOcO] 302 Found (0.017755s, 56.322/s) t/redirect.t ..................... ok 1 - GET /redirect ok 2 - 302 Found @@ -559,35 +595,35 @@ ok 4 - exact match for content 1..4 ok -[2025-04-24 03:17:13.66888] [34534] [trace] [3OQoK2qnEje3] GET "/auth" -[2025-04-24 03:17:13.66936] [34534] [trace] [3OQoK2qnEje3] Routing to a callback -[2025-04-24 03:17:13.67103] [34534] [debug] [CGI:env.cgi:34535] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi -[2025-04-24 03:17:13.68118] [34534] [trace] [3OQoK2qnEje3] 200 OK (0.012266s, 81.526/s) -[2025-04-24 03:17:13.68639] [34534] [trace] [AlYnT8THFdUL] GET "/auth" -[2025-04-24 03:17:13.68660] [34534] [trace] [AlYnT8THFdUL] Routing to a callback -[2025-04-24 03:17:13.68786] [34534] [debug] [CGI:env.cgi:34536] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi -[2025-04-24 03:17:13.69642] [34534] [trace] [AlYnT8THFdUL] 200 OK (0.009993s, 100.070/s) -[2025-04-24 03:17:13.70063] [34534] [trace] [DbDhQT8fehJ6] GET "/auth" -[2025-04-24 03:17:13.70083] [34534] [trace] [DbDhQT8fehJ6] Routing to a callback -[2025-04-24 03:17:13.70206] [34534] [debug] [CGI:env.cgi:34537] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi -[2025-04-24 03:17:13.71096] [34534] [trace] [DbDhQT8fehJ6] 200 OK (0.010308s, 97.012/s) +[2024-03-21 20:54:57.60932] [24988] [trace] [yOnBNgOk43Z7] GET "/auth" +[2024-03-21 20:54:57.60985] [24988] [trace] [yOnBNgOk43Z7] Routing to a callback +[2024-03-21 20:54:57.61232] [24988] [debug] [CGI:env.cgi:25048] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi +[2024-03-21 20:54:57.62677] [24988] [trace] [yOnBNgOk43Z7] 200 OK (0.017404s, 57.458/s) +[2024-03-21 20:54:57.63575] [24988] [trace] [uPDk9Nf9VZQ6] GET "/auth" +[2024-03-21 20:54:57.63605] [24988] [trace] [uPDk9Nf9VZQ6] Routing to a callback +[2024-03-21 20:54:57.63853] [24988] [debug] [CGI:env.cgi:25054] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi +[2024-03-21 20:54:57.65320] [24988] [trace] [uPDk9Nf9VZQ6] 200 OK (0.017408s, 57.445/s) +[2024-03-21 20:54:57.66176] [24988] [trace] [HjsYZ9WkoVjC] GET "/auth" +[2024-03-21 20:54:57.66206] [24988] [trace] [HjsYZ9WkoVjC] Routing to a callback +[2024-03-21 20:54:57.66469] [24988] [debug] [CGI:env.cgi:25056] START /build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi +[2024-03-21 20:54:57.67896] [24988] [trace] [HjsYZ9WkoVjC] 200 OK (0.017158s, 58.282/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:34483/auth +ok 5 - GET http://127.0.0.1:41867/auth ok 6 - 200 OK ok 7 - REMOTE_USER=Aladdin -ok 8 - GET http://127.0.0.1:34483/auth +ok 8 - GET http://127.0.0.1:41867/auth ok 9 - 200 OK ok 10 - REMOTE_USER=Aladdin 1..10 ok -[2025-04-24 03:17:14.05099] [34538] [trace] [241-f6yXmoKT] GET "/" -[2025-04-24 03:17:14.05146] [34538] [trace] [241-f6yXmoKT] Routing to a callback -[2025-04-24 03:17:14.05304] [34538] [debug] [CGI:CODE(0x5760b230):34539] START CODE(0x5760b230) -[2025-04-24 03:17:14.05782] [34538] [trace] [241-f6yXmoKT] 200 OK (0.006813s, 146.778/s) +[2024-03-21 20:54:58.27008] [25057] [trace] [HCRJ9D6l2tyT] GET "/" +[2024-03-21 20:54:58.27058] [25057] [trace] [HCRJ9D6l2tyT] Routing to a callback +[2024-03-21 20:54:58.27332] [25057] [debug] [CGI:CODE(0x586a4240):25073] START CODE(0x586a4240) +[2024-03-21 20:54:58.28089] [25057] [trace] [HCRJ9D6l2tyT] 200 OK (0.010754s, 92.989/s) t/run.t .......................... ok 1 - GET / ok 2 - 200 OK @@ -596,13 +632,13 @@ ok t/zombies.t ...................... skipped: (no reason given) All tests successful. -Files=18, Tests=110, 6 wallclock secs ( 0.06 usr 0.02 sys + 5.28 cusr 0.64 csys = 6.00 CPU) +Files=18, Tests=110, 11 wallclock secs ( 0.10 usr 0.02 sys + 10.20 cusr 1.10 csys = 11.42 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 -j22 install DESTDIR=/build/reproducible-path/libmojolicious-plugin-cgi-perl-0.40/debian/libmojolicious-plugin-cgi-perl AM_UPDATE_INFO_DIR=no PREFIX=/usr + make -j10 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 @@ -629,12 +665,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/12544/tmp/hooks/B01_cleanup starting +I: user script /srv/workspace/pbuilder/12544/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/33374 and its subdirectories -I: Current time: Wed Apr 23 15:17:16 -12 2025 -I: pbuilder-time-stamp: 1745464636 +I: removing directory /srv/workspace/pbuilder/12544 and its subdirectories +I: Current time: Fri Mar 22 10:55:03 +14 2024 +I: pbuilder-time-stamp: 1711054503