Diff of the two buildlogs: -- --- b1/build.log 2024-04-30 19:20:15.817809617 +0000 +++ b2/build.log 2024-04-30 19:20:53.652201350 +0000 @@ -1,6 +1,6 @@ I: pbuilder: network access will be disabled during build -I: Current time: Tue Apr 30 07:19:20 -12 2024 -I: pbuilder-time-stamp: 1714504760 +I: Current time: Tue Jun 3 15:43:19 +14 2025 +I: pbuilder-time-stamp: 1748914999 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 libtest-www-mechanize-mojo-perl_0.0.21-2.debian.tar.xz I: Not using root during the build. I: Installing the build-deps -I: user script /srv/workspace/pbuilder/62552/tmp/hooks/D02_print_environment starting +I: user script /srv/workspace/pbuilder/91978/tmp/hooks/D01_modify_environment starting +debug: Running on ionos16-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 Jun 3 01:43 /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/91978/tmp/hooks/D01_modify_environment finished +I: user script /srv/workspace/pbuilder/91978/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=11 ' - 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=21 ' + 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='35725efeace94dfda3c05ca10c0b2fae' - 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='62552' - PS1='# ' - PS2='> ' + INVOCATION_ID=e4c7481da2df4f2e8af928f694f0477e + 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=91978 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.A7VvywYW/pbuilderrc_pGB8 --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.A7VvywYW/b1 --logfile b1/build.log libtest-www-mechanize-mojo-perl_0.0.21-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://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.A7VvywYW/pbuilderrc_Vtyr --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.A7VvywYW/b2 --logfile b2/build.log libtest-www-mechanize-mojo-perl_0.0.21-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://213.165.73.152:3128 I: uname -a - Linux ionos12-i386 6.1.0-20-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.1.85-1 (2024-04-11) x86_64 GNU/Linux + Linux i-capture-the-hostname 6.1.0-20-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.1.85-1 (2024-04-11) x86_64 GNU/Linux I: ls -l /bin - lrwxrwxrwx 1 root root 7 Apr 21 07:12 /bin -> usr/bin -I: user script /srv/workspace/pbuilder/62552/tmp/hooks/D02_print_environment finished + lrwxrwxrwx 1 root root 7 May 27 17:46 /bin -> usr/bin +I: user script /srv/workspace/pbuilder/91978/tmp/hooks/D02_print_environment finished -> Attempting to satisfy build-dependencies -> Creating pbuilder-satisfydepends-dummy package Package: pbuilder-satisfydepends-dummy @@ -86,7 +118,7 @@ Depends: debhelper-compat (= 13), libmodule-build-perl, perl, libhtml-parser-perl, libmojolicious-perl (>= 8.61+dfsg-2~), libtest-www-mechanize-perl dpkg-deb: building package 'pbuilder-satisfydepends-dummy' in '/tmp/satisfydepends-aptitude/pbuilder-satisfydepends-dummy.deb'. Selecting previously unselected package pbuilder-satisfydepends-dummy. -(Reading database ... 19885 files and directories currently installed.) +(Reading database ... 19709 files and directories currently installed.) Preparing to unpack .../pbuilder-satisfydepends-dummy.deb ... Unpacking pbuilder-satisfydepends-dummy (0.invalid.0) ... dpkg: pbuilder-satisfydepends-dummy: dependency problems, but configuring anyway as you requested: @@ -230,21 +262,20 @@ Get: 68 http://deb.debian.org/debian trixie/main i386 libtest-longstring-perl all 0.17-3 [10.8 kB] Get: 69 http://deb.debian.org/debian trixie/main i386 libwww-mechanize-perl all 2.18-1 [114 kB] Get: 70 http://deb.debian.org/debian trixie/main i386 libtest-www-mechanize-perl all 1.60-1 [30.2 kB] -Fetched 27.1 MB in 1s (50.0 MB/s) +Fetched 27.1 MB in 0s (88.0 MB/s) debconf: delaying package configuration, since apt-utils is not installed dpkg: libssl3:i386: dependency problems, but removing anyway as you requested: - libkrb5-3:i386 depends on libssl3 (>= 3.0.0). coreutils depends on libssl3 (>= 3.0.0). -(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 ... 19885 files and directories currently installed.) +(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 ... 19709 files and directories currently installed.) Removing libssl3:i386 (3.1.5-1) ... Selecting previously unselected package libssl3t64:i386. -(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 ... 19872 files and directories currently installed.) +(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 ... 19696 files and directories currently installed.) Preparing to unpack .../libssl3t64_3.2.1-3_i386.deb ... Unpacking libssl3t64:i386 (3.2.1-3) ... Setting up libssl3t64:i386 (3.2.1-3) ... Selecting previously unselected package netbase. -(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 ... 19887 files and directories currently installed.) +(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 ... 19711 files and directories currently installed.) Preparing to unpack .../00-netbase_6.4_all.deb ... Unpacking netbase (6.4) ... Selecting previously unselected package sensible-utils. @@ -541,7 +572,11 @@ Building tag database... -> Finished parsing the build-deps I: Building the package -I: Running cd /build/reproducible-path/libtest-www-mechanize-mojo-perl-0.0.21/ && 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 > ../libtest-www-mechanize-mojo-perl_0.0.21-2_source.changes +I: user script /srv/workspace/pbuilder/91978/tmp/hooks/A99_set_merged_usr starting +Not re-configuring usrmerge for trixie +I: user script /srv/workspace/pbuilder/91978/tmp/hooks/A99_set_merged_usr finished +hostname: Name or service not known +I: Running cd /build/reproducible-path/libtest-www-mechanize-mojo-perl-0.0.21/ && 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 > ../libtest-www-mechanize-mojo-perl_0.0.21-2_source.changes dpkg-buildpackage: info: source package libtest-www-mechanize-mojo-perl dpkg-buildpackage: info: source version 0.0.21-2 dpkg-buildpackage: info: source distribution unstable @@ -568,12 +603,12 @@ 1..1 ok 1 - Test/WWW/Mechanize/Mojo.pm loaded ok ok -[2024-04-30 19:20:05.92215] [4314] [trace] [1NA-3KenkTnh] GET "/check_auth_basic/" -[2024-04-30 19:20:05.92269] [4314] [trace] [1NA-3KenkTnh] Routing to a callback -[2024-04-30 19:20:05.92302] [4314] [trace] [1NA-3KenkTnh] 200 OK (0.000869s, 1150.748/s) -[2024-04-30 19:20:05.93401] [4314] [trace] [v06N_ZuVQjeD] GET "/check_auth_basic/" -[2024-04-30 19:20:05.93428] [4314] [trace] [v06N_ZuVQjeD] Routing to a callback -[2024-04-30 19:20:05.93455] [4314] [trace] [v06N_ZuVQjeD] 401 Unauthorized (0.000526s, 1901.141/s) +[2025-06-03 01:43:47.10683] [97730] [trace] [N3bjj9K4Wr0e] GET "/check_auth_basic/" +[2025-06-03 01:43:47.10718] [97730] [trace] [N3bjj9K4Wr0e] Routing to a callback +[2025-06-03 01:43:47.10743] [97730] [trace] [N3bjj9K4Wr0e] 200 OK (0.000587s, 1703.578/s) +[2025-06-03 01:43:47.11403] [97730] [trace] [eTd2TPlqJinb] GET "/check_auth_basic/" +[2025-06-03 01:43:47.11420] [97730] [trace] [eTd2TPlqJinb] Routing to a callback +[2025-06-03 01:43:47.11442] [97730] [trace] [eTd2TPlqJinb] 401 Unauthorized (0.000383s, 2610.966/s) t/auth-test.t .... 1..5 ok 1 - GET http://localhost/check_auth_basic/ @@ -582,21 +617,21 @@ ok 4 ok 5 ok -[2024-04-30 19:20:06.77127] [4329] [trace] [GZmDV3q3zeZw] GET "/" -[2024-04-30 19:20:06.77220] [4329] [trace] [GZmDV3q3zeZw] Routing to a callback -[2024-04-30 19:20:06.77252] [4329] [trace] [GZmDV3q3zeZw] 200 OK (0.001241s, 805.802/s) +[2025-06-03 01:43:47.54265] [97731] [trace] [LEKuN3DsfRT-] GET "/" +[2025-06-03 01:43:47.54315] [97731] [trace] [LEKuN3DsfRT-] Routing to a callback +[2025-06-03 01:43:47.54335] [97731] [trace] [LEKuN3DsfRT-] 200 OK (0.000697s, 1434.720/s) t/cookies.t ...... 1..3 ok 1 - GET / ok 2 - Title is "Root" ok 3 ok -[2024-04-30 19:20:07.50122] [4350] [trace] [O-T8DzZS_-zW] GET "/form" -[2024-04-30 19:20:07.50205] [4350] [trace] [O-T8DzZS_-zW] Routing to a callback -[2024-04-30 19:20:07.50237] [4350] [trace] [O-T8DzZS_-zW] 200 OK (0.001148s, 871.080/s) -[2024-04-30 19:20:07.51609] [4350] [trace] [pi2oyJEdA_vh] POST "/form-submit" -[2024-04-30 19:20:07.51656] [4350] [trace] [pi2oyJEdA_vh] Routing to a callback -[2024-04-30 19:20:07.51694] [4350] [trace] [pi2oyJEdA_vh] 200 OK (0.000843s, 1186.240/s) +[2025-06-03 01:43:47.96729] [97779] [trace] [DuLoGFz7vwrC] GET "/form" +[2025-06-03 01:43:47.96785] [97779] [trace] [DuLoGFz7vwrC] Routing to a callback +[2025-06-03 01:43:47.96812] [97779] [trace] [DuLoGFz7vwrC] 200 OK (0.000828s, 1207.729/s) +[2025-06-03 01:43:47.97620] [97779] [trace] [eCEQZmWMRwZx] POST "/form-submit" +[2025-06-03 01:43:47.97652] [97779] [trace] [eCEQZmWMRwZx] Routing to a callback +[2025-06-03 01:43:47.97684] [97779] [trace] [eCEQZmWMRwZx] 200 OK (0.000627s, 1594.896/s) t/form_submit.t .. 1..5 ok 1 - GET http://localhost/form @@ -605,36 +640,36 @@ ok 4 - Was able to submit form. ok 5 - Content is like "(?^:Your email is sophie\@hello\.tld)" ok -[2024-04-30 19:20:08.36649] [4375] [trace] [vJw7WtRd3SLq] GET "/hi" -[2024-04-30 19:20:08.36706] [4375] [trace] [vJw7WtRd3SLq] Routing to a callback -[2024-04-30 19:20:08.36737] [4375] [trace] [vJw7WtRd3SLq] 302 Found (0.00088s, 1136.364/s) -[2024-04-30 19:20:08.37203] [4375] [trace] [LGbFHYMU_ZGu] GET "/hello" -[2024-04-30 19:20:08.37251] [4375] [trace] [LGbFHYMU_ZGu] Routing to a callback -[2024-04-30 19:20:08.37279] [4375] [trace] [LGbFHYMU_ZGu] 200 OK (0.000744s, 1344.086/s) -[2024-04-30 19:20:08.38894] [4375] [trace] [3-jINfxcLHa4] GET "/greetings" -[2024-04-30 19:20:08.38936] [4375] [trace] [3-jINfxcLHa4] Routing to a callback -[2024-04-30 19:20:08.38970] [4375] [trace] [3-jINfxcLHa4] 302 Found (0.000749s, 1335.113/s) -[2024-04-30 19:20:08.39373] [4375] [trace] [yPLw-15elu8g] GET "/hello" -[2024-04-30 19:20:08.39397] [4375] [trace] [yPLw-15elu8g] Routing to a callback -[2024-04-30 19:20:08.39425] [4375] [trace] [yPLw-15elu8g] 200 OK (0.000474s, 2109.705/s) -[2024-04-30 19:20:08.40091] [4375] [trace] [hDrzeofGwP6E] GET "/bonjour" -[2024-04-30 19:20:08.40130] [4375] [trace] [hDrzeofGwP6E] Routing to a callback -[2024-04-30 19:20:08.40158] [4375] [trace] [hDrzeofGwP6E] 302 Found (0.000655s, 1526.718/s) -[2024-04-30 19:20:08.40529] [4375] [trace] [JFI5PswUBY_i] GET "/hi" -[2024-04-30 19:20:08.40551] [4375] [trace] [JFI5PswUBY_i] Routing to a callback -[2024-04-30 19:20:08.40577] [4375] [trace] [JFI5PswUBY_i] 302 Found (0.000468s, 2136.752/s) -[2024-04-30 19:20:08.40925] [4375] [trace] [zLGefKRqTmSE] GET "/hello" -[2024-04-30 19:20:08.40946] [4375] [trace] [zLGefKRqTmSE] Routing to a callback -[2024-04-30 19:20:08.40971] [4375] [trace] [zLGefKRqTmSE] 200 OK (0.000445s, 2247.191/s) -[2024-04-30 19:20:08.41712] [4375] [trace] [VpdloHJYQwpW] GET "/redirect_with_500" -[2024-04-30 19:20:08.41765] [4375] [trace] [VpdloHJYQwpW] Routing to a callback -[2024-04-30 19:20:08.41799] [4375] [trace] [VpdloHJYQwpW] 302 Found (0.000858s, 1165.501/s) -[2024-04-30 19:20:08.41917] [4375] [error] [VpdloHJYQwpW] erk! at t/lib/MyMojjy.pm line 88. +[2025-06-03 01:43:48.40079] [97798] [trace] [NHDxy8XqWy7c] GET "/hi" +[2025-06-03 01:43:48.40122] [97798] [trace] [NHDxy8XqWy7c] Routing to a callback +[2025-06-03 01:43:48.40149] [97798] [trace] [NHDxy8XqWy7c] 302 Found (0.000689s, 1451.379/s) +[2025-06-03 01:43:48.40406] [97798] [trace] [grJof_1vrip-] GET "/hello" +[2025-06-03 01:43:48.40439] [97798] [trace] [grJof_1vrip-] Routing to a callback +[2025-06-03 01:43:48.40464] [97798] [trace] [grJof_1vrip-] 200 OK (0.000559s, 1788.909/s) +[2025-06-03 01:43:48.41326] [97798] [trace] [-8LwMCKRiRtp] GET "/greetings" +[2025-06-03 01:43:48.41354] [97798] [trace] [-8LwMCKRiRtp] Routing to a callback +[2025-06-03 01:43:48.41379] [97798] [trace] [-8LwMCKRiRtp] 302 Found (0.000521s, 1919.386/s) +[2025-06-03 01:43:48.41580] [97798] [trace] [ZjgwMAjEMD4u] GET "/hello" +[2025-06-03 01:43:48.41598] [97798] [trace] [ZjgwMAjEMD4u] Routing to a callback +[2025-06-03 01:43:48.41620] [97798] [trace] [ZjgwMAjEMD4u] 200 OK (0.000384s, 2604.167/s) +[2025-06-03 01:43:48.42037] [97798] [trace] [7hxpXNITlJZN] GET "/bonjour" +[2025-06-03 01:43:48.42064] [97798] [trace] [7hxpXNITlJZN] Routing to a callback +[2025-06-03 01:43:48.42088] [97798] [trace] [7hxpXNITlJZN] 302 Found (0.000498s, 2008.032/s) +[2025-06-03 01:43:48.42292] [97798] [trace] [I5j5eFk2TcLP] GET "/hi" +[2025-06-03 01:43:48.42310] [97798] [trace] [I5j5eFk2TcLP] Routing to a callback +[2025-06-03 01:43:48.42334] [97798] [trace] [I5j5eFk2TcLP] 302 Found (0.000414s, 2415.459/s) +[2025-06-03 01:43:48.42534] [97798] [trace] [PKHT67ObeVq3] GET "/hello" +[2025-06-03 01:43:48.42554] [97798] [trace] [PKHT67ObeVq3] Routing to a callback +[2025-06-03 01:43:48.42576] [97798] [trace] [PKHT67ObeVq3] 200 OK (0.000395s, 2531.646/s) +[2025-06-03 01:43:48.43033] [97798] [trace] [1RlIAKPcZBss] GET "/redirect_with_500" +[2025-06-03 01:43:48.43064] [97798] [trace] [1RlIAKPcZBss] Routing to a callback +[2025-06-03 01:43:48.43089] [97798] [trace] [1RlIAKPcZBss] 302 Found (0.000548s, 1824.818/s) +[2025-06-03 01:43:48.43153] [97798] [error] [1RlIAKPcZBss] erk! at t/lib/MyMojjy.pm line 88. -[2024-04-30 19:20:08.42045] [4375] [trace] [VpdloHJYQwpW] Template "exception.development.html.ep" not found -[2024-04-30 19:20:08.42071] [4375] [trace] [VpdloHJYQwpW] Template "exception.html.ep" not found -[2024-04-30 19:20:08.42092] [4375] [trace] [VpdloHJYQwpW] Rendering template "mojo/debug.html.ep" -[2024-04-30 19:20:08.45434] [4375] [trace] Your secret passphrase needs to be changed (see FAQ for more) +[2025-06-03 01:43:48.43215] [97798] [trace] [1RlIAKPcZBss] Template "exception.development.html.ep" not found +[2025-06-03 01:43:48.43237] [97798] [trace] [1RlIAKPcZBss] Template "exception.html.ep" not found +[2025-06-03 01:43:48.43258] [97798] [trace] [1RlIAKPcZBss] Rendering template "mojo/debug.html.ep" +[2025-06-03 01:43:48.44700] [97798] [trace] Your secret passphrase needs to be changed (see FAQ for more) t/redirect.t ..... 1..28 ok 1 - got something when we hi @@ -666,27 +701,27 @@ ok 27 - to the right place ok 28 - Redirect not followed on 500 ok -[2024-04-30 19:20:09.19658] [4537] [trace] [haw8FgmAc1bb] GET "/" -[2024-04-30 19:20:09.19755] [4537] [trace] [haw8FgmAc1bb] Routing to a callback -[2024-04-30 19:20:09.19785] [4537] [trace] [haw8FgmAc1bb] 200 OK (0.001269s, 788.022/s) -[2024-04-30 19:20:09.21211] [4537] [trace] [9JBGy6UZGgai] GET "/hello/" -[2024-04-30 19:20:09.21252] [4537] [trace] [9JBGy6UZGgai] Routing to a callback -[2024-04-30 19:20:09.21276] [4537] [trace] [9JBGy6UZGgai] 200 OK (0.000639s, 1564.945/s) -[2024-04-30 19:20:09.21792] [4537] [trace] [2_W_ARPHSThp] GET "/" -[2024-04-30 19:20:09.21815] [4537] [trace] [2_W_ARPHSThp] Routing to a callback -[2024-04-30 19:20:09.21851] [4537] [trace] [2_W_ARPHSThp] 200 OK (0.000602s, 1661.130/s) -[2024-04-30 19:20:09.22368] [4537] [trace] [0cakH_3g9lTm] GET "/" -[2024-04-30 19:20:09.22390] [4537] [trace] [0cakH_3g9lTm] Routing to a callback -[2024-04-30 19:20:09.22417] [4537] [trace] [0cakH_3g9lTm] 200 OK (0.000479s, 2087.683/s) -[2024-04-30 19:20:09.23019] [4537] [trace] [4KJ8PL3nuU18] GET "/hello/" -[2024-04-30 19:20:09.23048] [4537] [trace] [4KJ8PL3nuU18] Routing to a callback -[2024-04-30 19:20:09.23071] [4537] [trace] [4KJ8PL3nuU18] 200 OK (0.000509s, 1964.637/s) -[2024-04-30 19:20:09.23563] [4537] [trace] [j-bg2ZBEhOMB] GET "/with-params" -[2024-04-30 19:20:09.23619] [4537] [trace] [j-bg2ZBEhOMB] Routing to a callback -[2024-04-30 19:20:09.23658] [4537] [trace] [j-bg2ZBEhOMB] 200 OK (0.000939s, 1064.963/s) -[2024-04-30 19:20:09.24066] [4537] [trace] [WDhKtQ4GXmAy] GET "/with-params" -[2024-04-30 19:20:09.24090] [4537] [trace] [WDhKtQ4GXmAy] Routing to a callback -[2024-04-30 19:20:09.24123] [4537] [trace] [WDhKtQ4GXmAy] 200 OK (0.000563s, 1776.199/s) +[2025-06-03 01:43:48.86551] [97804] [trace] [ZyvpTiccKhM1] GET "/" +[2025-06-03 01:43:48.86608] [97804] [trace] [ZyvpTiccKhM1] Routing to a callback +[2025-06-03 01:43:48.86631] [97804] [trace] [ZyvpTiccKhM1] 200 OK (0.000795s, 1257.862/s) +[2025-06-03 01:43:48.87453] [97804] [trace] [5xcQZI6zeLWL] GET "/hello/" +[2025-06-03 01:43:48.87480] [97804] [trace] [5xcQZI6zeLWL] Routing to a callback +[2025-06-03 01:43:48.87499] [97804] [trace] [5xcQZI6zeLWL] 200 OK (0.000456s, 2192.982/s) +[2025-06-03 01:43:48.87813] [97804] [trace] [x5-OP7HwFYNv] GET "/" +[2025-06-03 01:43:48.87831] [97804] [trace] [x5-OP7HwFYNv] Routing to a callback +[2025-06-03 01:43:48.87849] [97804] [trace] [x5-OP7HwFYNv] 200 OK (0.000342s, 2923.977/s) +[2025-06-03 01:43:48.88131] [97804] [trace] [Jz5P28fVSCic] GET "/" +[2025-06-03 01:43:48.88147] [97804] [trace] [Jz5P28fVSCic] Routing to a callback +[2025-06-03 01:43:48.88168] [97804] [trace] [Jz5P28fVSCic] 200 OK (0.000359s, 2785.515/s) +[2025-06-03 01:43:48.88454] [97804] [trace] [CwFvujSJFAvD] GET "/hello/" +[2025-06-03 01:43:48.88471] [97804] [trace] [CwFvujSJFAvD] Routing to a callback +[2025-06-03 01:43:48.88490] [97804] [trace] [CwFvujSJFAvD] 200 OK (0.000347s, 2881.844/s) +[2025-06-03 01:43:48.88791] [97804] [trace] [HCQ0B5ozNmef] GET "/with-params" +[2025-06-03 01:43:48.88822] [97804] [trace] [HCQ0B5ozNmef] Routing to a callback +[2025-06-03 01:43:48.88851] [97804] [trace] [HCQ0B5ozNmef] 200 OK (0.000588s, 1700.680/s) +[2025-06-03 01:43:48.89082] [97804] [trace] [G_AlqQZbBK66] GET "/with-params" +[2025-06-03 01:43:48.89102] [97804] [trace] [G_AlqQZbBK66] Routing to a callback +[2025-06-03 01:43:48.89131] [97804] [trace] [G_AlqQZbBK66] 200 OK (0.000474s, 2109.705/s) t/simple.t ....... 1..25 ok 1 - GET http://localhost/ @@ -715,20 +750,20 @@ ok 24 - GET /with-params?one=sophie&two=jack ok 25 - Get params (\#2) are OK. ok -[2024-04-30 19:20:09.96486] [4545] [trace] [OsowK87V9QGn] GET "/user_agent" -[2024-04-30 19:20:09.96559] [4545] [trace] [OsowK87V9QGn] Routing to a callback -[2024-04-30 19:20:09.96591] [4545] [trace] [OsowK87V9QGn] 200 OK (0.001042s, 959.693/s) +[2025-06-03 01:43:49.31466] [97805] [trace] [F8YXSTmzGhES] GET "/user_agent" +[2025-06-03 01:43:49.31515] [97805] [trace] [F8YXSTmzGhES] Routing to a callback +[2025-06-03 01:43:49.31540] [97805] [trace] [F8YXSTmzGhES] 200 OK (0.000739s, 1353.180/s) t/useragent.t .... 1..2 ok 1 - GET http://localhost/user_agent ok 2 - title is correct: TestAgent/1.0 ok -[2024-04-30 19:20:10.71756] [4549] [trace] [7Q1pljlZcWGa] GET "/host" -[2024-04-30 19:20:10.71846] [4549] [trace] [7Q1pljlZcWGa] Routing to a callback -[2024-04-30 19:20:10.71878] [4549] [trace] [7Q1pljlZcWGa] 200 OK (0.001215s, 823.045/s) -[2024-04-30 19:20:10.72944] [4549] [trace] [HPWQ7zudMaHc] GET "/host" -[2024-04-30 19:20:10.72965] [4549] [trace] [HPWQ7zudMaHc] Routing to a callback -[2024-04-30 19:20:10.72990] [4549] [trace] [HPWQ7zudMaHc] 200 OK (0.000451s, 2217.295/s) +[2025-06-03 01:43:49.73977] [97806] [trace] [0VIRSwdUETl6] GET "/host" +[2025-06-03 01:43:49.74030] [97806] [trace] [0VIRSwdUETl6] Routing to a callback +[2025-06-03 01:43:49.74058] [97806] [trace] [0VIRSwdUETl6] 200 OK (0.000803s, 1245.330/s) +[2025-06-03 01:43:49.74658] [97806] [trace] [lGPsR4JarLt9] GET "/host" +[2025-06-03 01:43:49.74676] [97806] [trace] [lGPsR4JarLt9] Routing to a callback +[2025-06-03 01:43:49.74699] [97806] [trace] [lGPsR4JarLt9] 200 OK (0.000393s, 2544.529/s) t/white_label.t .. 1..4 ok 1 - GET /host @@ -737,7 +772,7 @@ ok 4 - Content contains "Host: localhost" ok All tests successful. -Files=8, Tests=73, 6 wallclock secs ( 0.06 usr 0.02 sys + 5.72 cusr 0.54 csys = 6.34 CPU) +Files=8, Tests=73, 3 wallclock secs ( 0.04 usr 0.00 sys + 3.18 cusr 0.32 csys = 3.54 CPU) Result: PASS create-stamp debian/debhelper-build-stamp dh_prep @@ -767,12 +802,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/91978/tmp/hooks/B01_cleanup starting +I: user script /srv/workspace/pbuilder/91978/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/62552 and its subdirectories -I: Current time: Tue Apr 30 07:20:15 -12 2024 -I: pbuilder-time-stamp: 1714504815 +I: removing directory /srv/workspace/pbuilder/91978 and its subdirectories +I: Current time: Tue Jun 3 15:43:52 +14 2025 +I: pbuilder-time-stamp: 1748915032