Diff of the two buildlogs: -- --- b1/build.log 2021-07-12 06:04:14.300964207 +0000 +++ b2/build.log 2021-07-12 06:05:24.762315273 +0000 @@ -1,6 +1,6 @@ I: pbuilder: network access will be disabled during build -I: Current time: Sun Jul 11 18:01:28 -12 2021 -I: pbuilder-time-stamp: 1626069688 +I: Current time: Mon Jul 12 20:04:22 +14 2021 +I: pbuilder-time-stamp: 1626069862 I: Building the build Environment I: extracting base tarball [/var/cache/pbuilder/bullseye-reproducible-base.tgz] I: copying local configuration @@ -16,8 +16,8 @@ I: copying [./libmojolicious-plugin-cgi-perl_0.40-1.debian.tar.xz] I: Extracting source gpgv: unknown type of key resource 'trustedkeys.kbx' -gpgv: keyblock resource '/tmp/dpkg-verify-sig.KaqPfyUn/trustedkeys.kbx': General error -gpgv: Signature made Sat Dec 22 07:24:20 2018 -12 +gpgv: keyblock resource '/tmp/dpkg-verify-sig.WObFlH2P/trustedkeys.kbx': General error +gpgv: Signature made Sun Dec 23 09:24:20 2018 +14 gpgv: using RSA key D1E1316E93A760A8104D85FABB3A68018649AA06 gpgv: Can't check signature: No public key dpkg-source: warning: failed to verify signature on ./libmojolicious-plugin-cgi-perl_0.40-1.dsc @@ -26,135 +26,169 @@ dpkg-source: info: unpacking libmojolicious-plugin-cgi-perl_0.40-1.debian.tar.xz I: using fakeroot in build. I: Installing the build-deps -I: user script /srv/workspace/pbuilder/26806/tmp/hooks/D02_print_environment starting +I: user script /srv/workspace/pbuilder/4134/tmp/hooks/D01_modify_environment starting +debug: Running on jtx1c. +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 +Removing 'diversion of /bin/sh to /bin/sh.distrib by dash' +Adding 'diversion of /bin/sh to /bin/sh.distrib by bash' +Removing 'diversion of /usr/share/man/man1/sh.1.gz to /usr/share/man/man1/sh.distrib.1.gz by dash' +Adding 'diversion of /usr/share/man/man1/sh.1.gz to /usr/share/man/man1/sh.distrib.1.gz by 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/4134/tmp/hooks/D01_modify_environment finished +I: user script /srv/workspace/pbuilder/4134/tmp/hooks/D02_print_environment starting I: set - BUILDDIR='/build' - BUILDUSERGECOS='first user,first room,first work-phone,first home-phone,first other' - BUILDUSERNAME='pbuilder1' - BUILD_ARCH='armhf' - DEBIAN_FRONTEND='noninteractive' - DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all,-fixfilepath parallel=3' - DISTRIBUTION='' - HOME='/root' - HOST_ARCH='armhf' + BASH=/bin/sh + BASHOPTS=checkwinsize:cmdhist:complete_fullquote:extquote:force_fignore:globasciiranges:hostcomplete:interactive_comments:progcomp:promptvars:sourcepath + BASH_ALIASES=() + BASH_ARGC=() + BASH_ARGV=() + BASH_CMDS=() + BASH_LINENO=([0]="12" [1]="0") + BASH_SOURCE=([0]="/tmp/hooks/D02_print_environment" [1]="/tmp/hooks/D02_print_environment") + BASH_VERSINFO=([0]="5" [1]="1" [2]="4" [3]="1" [4]="release" [5]="arm-unknown-linux-gnueabihf") + BASH_VERSION='5.1.4(1)-release' + BUILDDIR=/build + BUILDUSERGECOS='second user,second room,second work-phone,second home-phone,second other' + BUILDUSERNAME=pbuilder2 + BUILD_ARCH=armhf + DEBIAN_FRONTEND=noninteractive + DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all,-fixfilepath parallel=4' + DIRSTACK=() + DISTRIBUTION= + EUID=0 + FUNCNAME=([0]="Echo" [1]="main") + GROUPS=() + HOME=/root + HOSTNAME=i-capture-the-hostname + HOSTTYPE=arm + HOST_ARCH=armhf IFS=' ' - INVOCATION_ID='1068a9b569c241be80b2eb2047fa4230' - 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='26806' - PS1='# ' - PS2='> ' + INVOCATION_ID=1b50f2f25062409cb4ff175670e45240 + LANG=C + LANGUAGE=it_CH:it + LC_ALL=C + MACHTYPE=arm-unknown-linux-gnueabihf + MAIL=/var/mail/root + OPTERR=1 + OPTIND=1 + OSTYPE=linux-gnueabihf + 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=4134 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/tmp.oWc5psi2RN/pbuilderrc_HT3I --hookdir /etc/pbuilder/first-build-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/bullseye-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/tmp.oWc5psi2RN/b1 --logfile b1/build.log libmojolicious-plugin-cgi-perl_0.40-1.dsc' - SUDO_GID='113' - SUDO_UID='107' - SUDO_USER='jenkins' - TERM='unknown' - TZ='/usr/share/zoneinfo/Etc/GMT+12' - USER='root' - _='/usr/bin/systemd-run' - http_proxy='http://10.0.0.15:8000/' + 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/tmp.oWc5psi2RN/pbuilderrc_e2H6 --hookdir /etc/pbuilder/rebuild-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/bullseye-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/tmp.oWc5psi2RN/b2 --logfile b2/build.log --extrapackages usrmerge libmojolicious-plugin-cgi-perl_0.40-1.dsc' + SUDO_GID=114 + SUDO_UID=108 + SUDO_USER=jenkins + TERM=unknown + TZ=/usr/share/zoneinfo/Etc/GMT-14 + UID=0 + USER=root + _='I: set' + http_proxy=http://10.0.0.15:8000/ I: uname -a - Linux virt32c 5.10.0-7-armmp-lpae #1 SMP Debian 5.10.40-1 (2021-05-28) armv7l GNU/Linux + Linux i-capture-the-hostname 5.10.0-7-arm64 #1 SMP Debian 5.10.40-1 (2021-05-28) aarch64 GNU/Linux I: ls -l /bin total 3580 - -rwxr-xr-x 1 root root 816764 Jun 21 14:26 bash - -rwxr-xr-x 3 root root 26052 Jul 20 2020 bunzip2 - -rwxr-xr-x 3 root root 26052 Jul 20 2020 bzcat - lrwxrwxrwx 1 root root 6 Jul 20 2020 bzcmp -> bzdiff - -rwxr-xr-x 1 root root 2225 Jul 20 2020 bzdiff - lrwxrwxrwx 1 root root 6 Jul 20 2020 bzegrep -> bzgrep - -rwxr-xr-x 1 root root 4877 Sep 4 2019 bzexe - lrwxrwxrwx 1 root root 6 Jul 20 2020 bzfgrep -> bzgrep - -rwxr-xr-x 1 root root 3775 Jul 20 2020 bzgrep - -rwxr-xr-x 3 root root 26052 Jul 20 2020 bzip2 - -rwxr-xr-x 1 root root 9636 Jul 20 2020 bzip2recover - lrwxrwxrwx 1 root root 6 Jul 20 2020 bzless -> bzmore - -rwxr-xr-x 1 root root 1297 Jul 20 2020 bzmore - -rwxr-xr-x 1 root root 26668 Sep 22 2020 cat - -rwxr-xr-x 1 root root 43104 Sep 22 2020 chgrp - -rwxr-xr-x 1 root root 38984 Sep 22 2020 chmod - -rwxr-xr-x 1 root root 43112 Sep 22 2020 chown - -rwxr-xr-x 1 root root 92616 Sep 22 2020 cp - -rwxr-xr-x 1 root root 75524 Dec 10 2020 dash - -rwxr-xr-x 1 root root 75880 Sep 22 2020 date - -rwxr-xr-x 1 root root 55436 Sep 22 2020 dd - -rwxr-xr-x 1 root root 59912 Sep 22 2020 df - -rwxr-xr-x 1 root root 96764 Sep 22 2020 dir - -rwxr-xr-x 1 root root 55012 Feb 7 02:38 dmesg - lrwxrwxrwx 1 root root 8 Nov 6 2019 dnsdomainname -> hostname - lrwxrwxrwx 1 root root 8 Nov 6 2019 domainname -> hostname - -rwxr-xr-x 1 root root 22508 Sep 22 2020 echo - -rwxr-xr-x 1 root root 28 Nov 9 2020 egrep - -rwxr-xr-x 1 root root 22496 Sep 22 2020 false - -rwxr-xr-x 1 root root 28 Nov 9 2020 fgrep - -rwxr-xr-x 1 root root 47492 Feb 7 02:38 findmnt - -rwsr-xr-x 1 root root 26076 Feb 26 04:12 fusermount - -rwxr-xr-x 1 root root 124508 Nov 9 2020 grep - -rwxr-xr-x 2 root root 2346 Mar 2 11:30 gunzip - -rwxr-xr-x 1 root root 6376 Mar 2 11:30 gzexe - -rwxr-xr-x 1 root root 64212 Mar 2 11:30 gzip - -rwxr-xr-x 1 root root 13784 Nov 6 2019 hostname - -rwxr-xr-x 1 root root 43180 Sep 22 2020 ln - -rwxr-xr-x 1 root root 35068 Feb 7 2020 login - -rwxr-xr-x 1 root root 96764 Sep 22 2020 ls - -rwxr-xr-x 1 root root 99940 Feb 7 02:38 lsblk - -rwxr-xr-x 1 root root 51408 Sep 22 2020 mkdir - -rwxr-xr-x 1 root root 43184 Sep 22 2020 mknod - -rwxr-xr-x 1 root root 30780 Sep 22 2020 mktemp - -rwxr-xr-x 1 root root 34408 Feb 7 02:38 more - -rwsr-xr-x 1 root root 34400 Feb 7 02:38 mount - -rwxr-xr-x 1 root root 9824 Feb 7 02:38 mountpoint - -rwxr-xr-x 1 root root 88524 Sep 22 2020 mv - lrwxrwxrwx 1 root root 8 Nov 6 2019 nisdomainname -> hostname - lrwxrwxrwx 1 root root 14 Apr 18 03:38 pidof -> /sbin/killall5 - -rwxr-xr-x 1 root root 26652 Sep 22 2020 pwd - lrwxrwxrwx 1 root root 4 Jun 21 14:26 rbash -> bash - -rwxr-xr-x 1 root root 30740 Sep 22 2020 readlink - -rwxr-xr-x 1 root root 43104 Sep 22 2020 rm - -rwxr-xr-x 1 root root 30732 Sep 22 2020 rmdir - -rwxr-xr-x 1 root root 14144 Sep 27 2020 run-parts - -rwxr-xr-x 1 root root 76012 Dec 22 2018 sed - lrwxrwxrwx 1 root root 4 Jul 9 21:24 sh -> dash - -rwxr-xr-x 1 root root 22532 Sep 22 2020 sleep - -rwxr-xr-x 1 root root 55360 Sep 22 2020 stty - -rwsr-xr-x 1 root root 46704 Feb 7 02:38 su - -rwxr-xr-x 1 root root 22532 Sep 22 2020 sync - -rwxr-xr-x 1 root root 340872 Feb 16 21:55 tar - -rwxr-xr-x 1 root root 9808 Sep 27 2020 tempfile - -rwxr-xr-x 1 root root 67696 Sep 22 2020 touch - -rwxr-xr-x 1 root root 22496 Sep 22 2020 true - -rwxr-xr-x 1 root root 9636 Feb 26 04:12 ulockmgr_server - -rwsr-xr-x 1 root root 22108 Feb 7 02:38 umount - -rwxr-xr-x 1 root root 22520 Sep 22 2020 uname - -rwxr-xr-x 2 root root 2346 Mar 2 11:30 uncompress - -rwxr-xr-x 1 root root 96764 Sep 22 2020 vdir - -rwxr-xr-x 1 root root 38512 Feb 7 02:38 wdctl - lrwxrwxrwx 1 root root 8 Nov 6 2019 ypdomainname -> hostname - -rwxr-xr-x 1 root root 1984 Mar 2 11:30 zcat - -rwxr-xr-x 1 root root 1678 Mar 2 11:30 zcmp - -rwxr-xr-x 1 root root 5880 Mar 2 11:30 zdiff - -rwxr-xr-x 1 root root 29 Mar 2 11:30 zegrep - -rwxr-xr-x 1 root root 29 Mar 2 11:30 zfgrep - -rwxr-xr-x 1 root root 2081 Mar 2 11:30 zforce - -rwxr-xr-x 1 root root 7585 Mar 2 11:30 zgrep - -rwxr-xr-x 1 root root 2206 Mar 2 11:30 zless - -rwxr-xr-x 1 root root 1842 Mar 2 11:30 zmore - -rwxr-xr-x 1 root root 4553 Mar 2 11:30 znew -I: user script /srv/workspace/pbuilder/26806/tmp/hooks/D02_print_environment finished + -rwxr-xr-x 1 root root 816764 Jun 22 16:26 bash + -rwxr-xr-x 3 root root 26052 Jul 21 2020 bunzip2 + -rwxr-xr-x 3 root root 26052 Jul 21 2020 bzcat + lrwxrwxrwx 1 root root 6 Jul 21 2020 bzcmp -> bzdiff + -rwxr-xr-x 1 root root 2225 Jul 21 2020 bzdiff + lrwxrwxrwx 1 root root 6 Jul 21 2020 bzegrep -> bzgrep + -rwxr-xr-x 1 root root 4877 Sep 5 2019 bzexe + lrwxrwxrwx 1 root root 6 Jul 21 2020 bzfgrep -> bzgrep + -rwxr-xr-x 1 root root 3775 Jul 21 2020 bzgrep + -rwxr-xr-x 3 root root 26052 Jul 21 2020 bzip2 + -rwxr-xr-x 1 root root 9636 Jul 21 2020 bzip2recover + lrwxrwxrwx 1 root root 6 Jul 21 2020 bzless -> bzmore + -rwxr-xr-x 1 root root 1297 Jul 21 2020 bzmore + -rwxr-xr-x 1 root root 26668 Sep 23 2020 cat + -rwxr-xr-x 1 root root 43104 Sep 23 2020 chgrp + -rwxr-xr-x 1 root root 38984 Sep 23 2020 chmod + -rwxr-xr-x 1 root root 43112 Sep 23 2020 chown + -rwxr-xr-x 1 root root 92616 Sep 23 2020 cp + -rwxr-xr-x 1 root root 75524 Dec 11 2020 dash + -rwxr-xr-x 1 root root 75880 Sep 23 2020 date + -rwxr-xr-x 1 root root 55436 Sep 23 2020 dd + -rwxr-xr-x 1 root root 59912 Sep 23 2020 df + -rwxr-xr-x 1 root root 96764 Sep 23 2020 dir + -rwxr-xr-x 1 root root 55012 Feb 8 04:38 dmesg + lrwxrwxrwx 1 root root 8 Nov 8 2019 dnsdomainname -> hostname + lrwxrwxrwx 1 root root 8 Nov 8 2019 domainname -> hostname + -rwxr-xr-x 1 root root 22508 Sep 23 2020 echo + -rwxr-xr-x 1 root root 28 Nov 10 2020 egrep + -rwxr-xr-x 1 root root 22496 Sep 23 2020 false + -rwxr-xr-x 1 root root 28 Nov 10 2020 fgrep + -rwxr-xr-x 1 root root 47492 Feb 8 04:38 findmnt + -rwsr-xr-x 1 root root 26076 Feb 27 06:12 fusermount + -rwxr-xr-x 1 root root 124508 Nov 10 2020 grep + -rwxr-xr-x 2 root root 2346 Mar 3 13:30 gunzip + -rwxr-xr-x 1 root root 6376 Mar 3 13:30 gzexe + -rwxr-xr-x 1 root root 64212 Mar 3 13:30 gzip + -rwxr-xr-x 1 root root 13784 Nov 8 2019 hostname + -rwxr-xr-x 1 root root 43180 Sep 23 2020 ln + -rwxr-xr-x 1 root root 35068 Feb 8 2020 login + -rwxr-xr-x 1 root root 96764 Sep 23 2020 ls + -rwxr-xr-x 1 root root 99940 Feb 8 04:38 lsblk + -rwxr-xr-x 1 root root 51408 Sep 23 2020 mkdir + -rwxr-xr-x 1 root root 43184 Sep 23 2020 mknod + -rwxr-xr-x 1 root root 30780 Sep 23 2020 mktemp + -rwxr-xr-x 1 root root 34408 Feb 8 04:38 more + -rwsr-xr-x 1 root root 34400 Feb 8 04:38 mount + -rwxr-xr-x 1 root root 9824 Feb 8 04:38 mountpoint + -rwxr-xr-x 1 root root 88524 Sep 23 2020 mv + lrwxrwxrwx 1 root root 8 Nov 8 2019 nisdomainname -> hostname + lrwxrwxrwx 1 root root 14 Apr 19 05:38 pidof -> /sbin/killall5 + -rwxr-xr-x 1 root root 26652 Sep 23 2020 pwd + lrwxrwxrwx 1 root root 4 Jun 22 16:26 rbash -> bash + -rwxr-xr-x 1 root root 30740 Sep 23 2020 readlink + -rwxr-xr-x 1 root root 43104 Sep 23 2020 rm + -rwxr-xr-x 1 root root 30732 Sep 23 2020 rmdir + -rwxr-xr-x 1 root root 14144 Sep 28 2020 run-parts + -rwxr-xr-x 1 root root 76012 Dec 23 2018 sed + lrwxrwxrwx 1 root root 4 Jul 12 20:04 sh -> bash + lrwxrwxrwx 1 root root 4 Jul 10 23:25 sh.distrib -> dash + -rwxr-xr-x 1 root root 22532 Sep 23 2020 sleep + -rwxr-xr-x 1 root root 55360 Sep 23 2020 stty + -rwsr-xr-x 1 root root 46704 Feb 8 04:38 su + -rwxr-xr-x 1 root root 22532 Sep 23 2020 sync + -rwxr-xr-x 1 root root 340872 Feb 17 23:55 tar + -rwxr-xr-x 1 root root 9808 Sep 28 2020 tempfile + -rwxr-xr-x 1 root root 67696 Sep 23 2020 touch + -rwxr-xr-x 1 root root 22496 Sep 23 2020 true + -rwxr-xr-x 1 root root 9636 Feb 27 06:12 ulockmgr_server + -rwsr-xr-x 1 root root 22108 Feb 8 04:38 umount + -rwxr-xr-x 1 root root 22520 Sep 23 2020 uname + -rwxr-xr-x 2 root root 2346 Mar 3 13:30 uncompress + -rwxr-xr-x 1 root root 96764 Sep 23 2020 vdir + -rwxr-xr-x 1 root root 38512 Feb 8 04:38 wdctl + lrwxrwxrwx 1 root root 8 Nov 8 2019 ypdomainname -> hostname + -rwxr-xr-x 1 root root 1984 Mar 3 13:30 zcat + -rwxr-xr-x 1 root root 1678 Mar 3 13:30 zcmp + -rwxr-xr-x 1 root root 5880 Mar 3 13:30 zdiff + -rwxr-xr-x 1 root root 29 Mar 3 13:30 zegrep + -rwxr-xr-x 1 root root 29 Mar 3 13:30 zfgrep + -rwxr-xr-x 1 root root 2081 Mar 3 13:30 zforce + -rwxr-xr-x 1 root root 7585 Mar 3 13:30 zgrep + -rwxr-xr-x 1 root root 2206 Mar 3 13:30 zless + -rwxr-xr-x 1 root root 1842 Mar 3 13:30 zmore + -rwxr-xr-x 1 root root 4553 Mar 3 13:30 znew +I: user script /srv/workspace/pbuilder/4134/tmp/hooks/D02_print_environment finished -> Attempting to satisfy build-dependencies -> Creating pbuilder-satisfydepends-dummy package Package: pbuilder-satisfydepends-dummy @@ -235,7 +269,7 @@ Get: 39 http://deb.debian.org/debian bullseye/main armhf libjs-highlight.js all 9.18.5+dfsg1-1 [397 kB] Get: 40 http://deb.debian.org/debian bullseye/main armhf libjs-jquery all 3.5.1+dfsg+~3.5.5-7 [315 kB] Get: 41 http://deb.debian.org/debian bullseye/main armhf libmojolicious-perl all 8.71+dfsg-1 [809 kB] -Fetched 22.3 MB in 3s (8407 kB/s) +Fetched 22.3 MB in 2s (10.0 MB/s) debconf: delaying package configuration, since apt-utils is not installed Selecting previously unselected package bsdextrautils. (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 ... 19398 files and directories currently installed.) @@ -418,9 +452,42 @@ Building dependency tree... Reading state information... fakeroot is already the newest version (1.25.3-1.1). -0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. +The following additional packages will be installed: + libfile-find-rule-perl libnumber-compare-perl libtext-glob-perl +The following NEW packages will be installed: + libfile-find-rule-perl libnumber-compare-perl libtext-glob-perl usrmerge +0 upgraded, 4 newly installed, 0 to remove and 0 not upgraded. +Need to get 59.5 kB of archives. +After this operation, 157 kB of additional disk space will be used. +Get:1 http://deb.debian.org/debian bullseye/main armhf libnumber-compare-perl all 0.03-1.1 [6956 B] +Get:2 http://deb.debian.org/debian bullseye/main armhf libtext-glob-perl all 0.11-1 [8888 B] +Get:3 http://deb.debian.org/debian bullseye/main armhf libfile-find-rule-perl all 0.34-1 [30.6 kB] +Get:4 http://deb.debian.org/debian bullseye/main armhf usrmerge all 25 [13.0 kB] +debconf: delaying package configuration, since apt-utils is not installed +Fetched 59.5 kB in 0s (1154 kB/s) +Selecting previously unselected package libnumber-compare-perl. +(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 ... 22275 files and directories currently installed.) +Preparing to unpack .../libnumber-compare-perl_0.03-1.1_all.deb ... +Unpacking libnumber-compare-perl (0.03-1.1) ... +Selecting previously unselected package libtext-glob-perl. +Preparing to unpack .../libtext-glob-perl_0.11-1_all.deb ... +Unpacking libtext-glob-perl (0.11-1) ... +Selecting previously unselected package libfile-find-rule-perl. +Preparing to unpack .../libfile-find-rule-perl_0.34-1_all.deb ... +Unpacking libfile-find-rule-perl (0.34-1) ... +Selecting previously unselected package usrmerge. +Preparing to unpack .../archives/usrmerge_25_all.deb ... +Unpacking usrmerge (25) ... +Setting up libtext-glob-perl (0.11-1) ... +Setting up libnumber-compare-perl (0.03-1.1) ... +Setting up libfile-find-rule-perl (0.34-1) ... +Setting up usrmerge (25) ... +The system has been successfully converted. +Processing triggers for man-db (2.9.4-2) ... +Not building database; man-db/auto-update is not 'true'. I: Building the package -I: Running cd /build/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-1_source.changes +hostname: Name or service not known +I: Running cd /build/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-1_source.changes dpkg-buildpackage: info: source package libmojolicious-plugin-cgi-perl dpkg-buildpackage: info: source version 0.40-1 dpkg-buildpackage: info: source distribution unstable @@ -442,43 +509,43 @@ Writing Makefile for Mojolicious::Plugin::CGI Writing MYMETA.yml and MYMETA.json dh_auto_build - make -j3 + make -j4 make[1]: Entering directory '/build/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/libmojolicious-plugin-cgi-perl-0.40' dh_auto_test - make -j3 test TEST_VERBOSE=1 + make -j4 test TEST_VERBOSE=1 make[1]: Entering directory '/build/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(0xddc958)) (Test::Pod::Coverage is required) +ok 3 # skip pod_coverage_ok(Mojolicious::Plugin::CGI HASH(0x21fc130)) (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 -[2021-07-11 18:03:18.08539] [27831] [debug] [uovXHfhG] GET "/working" -[2021-07-11 18:03:18.08650] [27831] [debug] [uovXHfhG] Routing to a callback -[2021-07-11 18:03:18.09104] [27831] [debug] [CGI:basic.pl:27834] START /build/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/basic.pl -[2021-07-11 18:03:18.12229] [27831] [debug] [uovXHfhG] 200 OK (0.036859s, 27.130/s) -[2021-07-11 18:03:18.13901] [27831] [debug] [z_IwLJfH] GET "/env/basic/foo" -[2021-07-11 18:03:18.14021] [27831] [debug] [z_IwLJfH] Routing to a callback -[2021-07-11 18:03:18.14439] [27831] [debug] [CGI:env.cgi:27835] START /build/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi -[2021-07-11 18:03:18.17661] [27831] [debug] [z_IwLJfH] 200 OK (0.037554s, 26.628/s) -[2021-07-11 18:03:18.21098] [27831] [debug] [g3L4LJZn] GET "/env/basic/foo" -[2021-07-11 18:03:18.21154] [27831] [debug] [g3L4LJZn] Routing to a callback -[2021-07-11 18:03:18.21583] [27831] [debug] [CGI:env.cgi:27836] START /build/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi -[2021-07-11 18:03:18.24830] [27831] [debug] [g3L4LJZn] 200 OK (0.037264s, 26.836/s) +[2021-07-12 20:05:01.62187] [9851] [debug] [Eb8fhmAP] GET "/working" +[2021-07-12 20:05:01.62298] [9851] [debug] [Eb8fhmAP] Routing to a callback +[2021-07-12 20:05:01.62682] [9851] [debug] [CGI:basic.pl:9917] START /build/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/basic.pl +[2021-07-12 20:05:01.64749] [9851] [debug] [Eb8fhmAP] 200 OK (0.025586s, 39.084/s) +[2021-07-12 20:05:01.66008] [9851] [debug] [NKblEwSC] GET "/env/basic/foo" +[2021-07-12 20:05:01.66110] [9851] [debug] [NKblEwSC] Routing to a callback +[2021-07-12 20:05:01.66459] [9851] [debug] [CGI:env.cgi:9918] START /build/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi +[2021-07-12 20:05:01.68533] [9851] [debug] [NKblEwSC] 200 OK (0.025203s, 39.678/s) +[2021-07-12 20:05:01.70999] [9851] [debug] [lpcf48q_] GET "/env/basic/foo" +[2021-07-12 20:05:01.71054] [9851] [debug] [lpcf48q_] Routing to a callback +[2021-07-12 20:05:01.71406] [9851] [debug] [CGI:env.cgi:9920] START /build/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi +[2021-07-12 20:05:01.73499] [9851] [debug] [lpcf48q_] 200 OK (0.024951s, 40.079/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:37629/env/basic/foo?query=123 +ok 5 - GET http://127.0.0.1:42425/env/basic/foo?query=123 ok 6 - 200 OK ok 7 - ENVIRONMENT ok 8 - CONTENT_LENGTH=0 @@ -508,10 +575,10 @@ ok 32 - HTTP_X_FORWARDED_FOR=1.2.3.4 1..32 ok -[2021-07-11 18:03:20.19327] [27837] [debug] [wHWXyIhY] GET "/user/42" -[2021-07-11 18:03:20.19449] [27837] [debug] [wHWXyIhY] Routing to a callback -[2021-07-11 18:03:20.19890] [27837] [debug] [CGI:env.cgi:27839] START /build/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi -[2021-07-11 18:03:20.25399] [27837] [debug] [wHWXyIhY] 200 OK (0.060694s, 16.476/s) +[2021-07-12 20:05:02.53971] [9921] [debug] [YHLSWttC] GET "/user/42" +[2021-07-12 20:05:02.54091] [9921] [debug] [YHLSWttC] Routing to a callback +[2021-07-12 20:05:02.54486] [9921] [debug] [CGI:env.cgi:9933] START /build/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi +[2021-07-12 20:05:02.56597] [9921] [debug] [YHLSWttC] 200 OK (0.026236s, 38.116/s) t/before.t ....................... ok 1 - GET /user/42 ok 2 - 200 OK @@ -519,21 +586,21 @@ ok 4 - QUERY_STRING=...other_value=123 1..4 ok -[2021-07-11 18:03:22.34748] [27840] [debug] [fLQNcoRc] GET "/foo" -[2021-07-11 18:03:22.34862] [27840] [debug] [fLQNcoRc] Routing to a callback -[2021-07-11 18:03:22.36121] [27840] [debug] [CGI:CODE(0x2721350):27841] START CODE(0x2721350) +[2021-07-12 20:05:03.36540] [9934] [debug] [GRK37Enh] GET "/foo" +[2021-07-12 20:05:03.36677] [9934] [debug] [GRK37Enh] Routing to a callback +[2021-07-12 20:05:03.37093] [9934] [debug] [CGI:CODE(0x338b228):9960] START CODE(0x338b228) # PATH_INFO=/foo -[2021-07-11 18:03:22.39393] [27840] [debug] [fLQNcoRc] 200 OK (0.046413s, 21.546/s) -[2021-07-11 18:03:22.42711] [27840] [debug] [KkriOYx1] GET "/f%C3%B6%C3%B6" -[2021-07-11 18:03:22.42792] [27840] [debug] [KkriOYx1] Routing to a callback -[2021-07-11 18:03:22.43997] [27840] [debug] [CGI:CODE(0x2721350):27842] START CODE(0x2721350) +[2021-07-12 20:05:03.38388] [9934] [debug] [GRK37Enh] 200 OK (0.018414s, 54.307/s) +[2021-07-12 20:05:03.39838] [9934] [debug] [HvOL0bTX] GET "/f%C3%B6%C3%B6" +[2021-07-12 20:05:03.39917] [9934] [debug] [HvOL0bTX] Routing to a callback +[2021-07-12 20:05:03.40250] [9934] [debug] [CGI:CODE(0x338b228):9965] START CODE(0x338b228) # PATH_INFO=/föö -[2021-07-11 18:03:22.48202] [27840] [debug] [KkriOYx1] 200 OK (0.054841s, 18.235/s) -[2021-07-11 18:03:22.51251] [27840] [debug] [cnUnXyYf] GET "/f%C3%B6%E2%80%99" -[2021-07-11 18:03:22.51755] [27840] [debug] [cnUnXyYf] Routing to a callback -[2021-07-11 18:03:22.52564] [27840] [debug] [CGI:CODE(0x2721350):27843] START CODE(0x2721350) +[2021-07-12 20:05:03.41315] [9934] [debug] [HvOL0bTX] 200 OK (0.014708s, 67.990/s) +[2021-07-12 20:05:03.42420] [9934] [debug] [hdZTubxh] GET "/f%C3%B6%E2%80%99" +[2021-07-12 20:05:03.42494] [9934] [debug] [hdZTubxh] Routing to a callback +[2021-07-12 20:05:03.42822] [9934] [debug] [CGI:CODE(0x338b228):9966] START CODE(0x338b228) # PATH_INFO=/fö’ -[2021-07-11 18:03:22.55828] [27840] [debug] [cnUnXyYf] 200 OK (0.045709s, 21.878/s) +[2021-07-12 20:05:03.43896] [9934] [debug] [hdZTubxh] 200 OK (0.014671s, 68.162/s) t/encoding.t ..................... ok 1 - GET /foo ok 2 - 200 OK @@ -547,7 +614,7 @@ ok 10 - no warnings 1..10 ok -[2021-07-11 18:03:24.67304] [27844] [warn] [CGI:errlog:27845] yikes! at /build/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/errlog line 4. +[2021-07-12 20:05:04.23141] [9967] [warn] [CGI:errlog:9970] yikes! at /build/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/errlog line 4. t/errlog.t ....................... ok 1 - GET /err ok 2 - logged stderr @@ -558,19 +625,19 @@ 1..6 ok t/gh-16-loop_reset.t ............. skipped: set TEST_MORBO to enable this test (developer only!) -[2021-07-11 18:03:28.65386] [27851] [debug] [MqCsS2_x] GET "/cgi-bin/nope.cgi/foo" -[2021-07-11 18:03:28.65513] [27851] [debug] [MqCsS2_x] Routing to a callback +[2021-07-12 20:05:05.83037] [9979] [debug] [mlxLB-o-] GET "/cgi-bin/nope.cgi/foo" +[2021-07-12 20:05:05.83167] [9979] [debug] [mlxLB-o-] Routing to a callback Use of uninitialized value in print at t/Helper.pm line 18. -[2021-07-11 18:03:28.66866] [27851] [debug] [CGI:nope.cgi:27863] START /build/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/nope.cgi -[2021-07-11 18:03:28.71433] [27851] [debug] [MqCsS2_x] 500 Internal Server Error (0.060422s, 16.550/s) -[2021-07-11 18:03:28.74816] [27851] [debug] [-Rl3OGol] GET "/cgi-bin/env.cgi/some/path/info" -[2021-07-11 18:03:28.75328] [27851] [debug] [-Rl3OGol] Routing to a callback -[2021-07-11 18:03:28.76238] [27851] [debug] [CGI:env.cgi:27864] START /build/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi -[2021-07-11 18:03:28.81654] [27851] [debug] [-Rl3OGol] 200 OK (0.068322s, 14.637/s) -[2021-07-11 18:03:28.84559] [27851] [debug] [wmUHvZhe] GET "/cgi-bin/env/some/path/info" -[2021-07-11 18:03:28.84648] [27851] [debug] [wmUHvZhe] Routing to a callback -[2021-07-11 18:03:28.85949] [27851] [debug] [CGI:env.cgi:27865] START /build/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi -[2021-07-11 18:03:28.93806] [27851] [debug] [wmUHvZhe] 200 OK (0.09241s, 10.821/s) +[2021-07-12 20:05:05.83698] [9979] [debug] [CGI:nope.cgi:10133] START /build/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/nope.cgi +[2021-07-12 20:05:05.85723] [9979] [debug] [mlxLB-o-] 500 Internal Server Error (0.026826s, 37.277/s) +[2021-07-12 20:05:05.86810] [9979] [debug] [E1AVv-Lv] GET "/cgi-bin/env.cgi/some/path/info" +[2021-07-12 20:05:05.86905] [9979] [debug] [E1AVv-Lv] Routing to a callback +[2021-07-12 20:05:05.87340] [9979] [debug] [CGI:env.cgi:10134] START /build/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi +[2021-07-12 20:05:05.89438] [9979] [debug] [E1AVv-Lv] 200 OK (0.02622s, 38.139/s) +[2021-07-12 20:05:05.90704] [9979] [debug] [dZQBr5hi] GET "/cgi-bin/env/some/path/info" +[2021-07-12 20:05:05.90787] [9979] [debug] [dZQBr5hi] Routing to a callback +[2021-07-12 20:05:05.91192] [9979] [debug] [CGI:env.cgi:10135] START /build/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi +[2021-07-12 20:05:05.93096] [9979] [debug] [dZQBr5hi] 200 OK (0.02388s, 41.876/s) t/helper.t ....................... ok 1 - GET /cgi-bin/nope.cgi/foo ok 2 - 500 Internal Server Error @@ -589,50 +656,50 @@ ok 15 - SCRIPT_NAME 1..15 ok -[2021-07-11 18:03:31.10741] [27866] [debug] [2FUDppbS] POST "/file_upload" -[2021-07-11 18:03:31.11117] [27866] [debug] [2FUDppbS] Routing to a callback -[2021-07-11 18:03:31.12717] [27866] [debug] [CGI:file_upload:27950] START /build/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/file_upload -[2021-07-11 18:03:31.21990] [27866] [debug] [2FUDppbS] 200 OK (0.112756s, 8.869/s) +[2021-07-12 20:05:06.75332] [10136] [debug] [9pu0oV2_] POST "/file_upload" +[2021-07-12 20:05:06.75448] [10136] [debug] [9pu0oV2_] Routing to a callback +[2021-07-12 20:05:06.75877] [10136] [debug] [CGI:file_upload:10185] START /build/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/file_upload +[2021-07-12 20:05:06.77956] [10136] [debug] [9pu0oV2_] 200 OK (0.026213s, 38.149/s) t/multipart.t .................... ok 1 - POST /file_upload ok 2 - 200 OK ok 3 - content is similar 1..3 ok -[2021-07-11 18:03:33.99787] [27951] [debug] [VCoa0AIa] GET "/not-found" -[2021-07-11 18:03:33.99912] [27951] [debug] [VCoa0AIa] Routing to a callback -[2021-07-11 18:03:34.00731] [27951] [debug] [CGI:not-found.pl:28008] START /build/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/not-found.pl -[2021-07-11 18:03:34.06252] [27951] [debug] [VCoa0AIa] 404 Not Found (0.064629s, 15.473/s) +[2021-07-12 20:05:07.62392] [10191] [debug] [1NdUL4vI] GET "/not-found" +[2021-07-12 20:05:07.62510] [10191] [debug] [1NdUL4vI] Routing to a callback +[2021-07-12 20:05:07.62912] [10191] [debug] [CGI:not-found.pl:10194] START /build/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/not-found.pl +[2021-07-12 20:05:07.64997] [10191] [debug] [1NdUL4vI] 404 Not Found (0.026019s, 38.433/s) t/not-found.t .................... ok 1 - GET /not-found ok 2 - 404 Not Found ok 3 - content is similar 1..3 ok -[2021-07-11 18:03:36.28811] [28009] [debug] [x11PFhYz] GET "/not-modified" -[2021-07-11 18:03:36.29381] [28009] [debug] [x11PFhYz] Routing to a callback -[2021-07-11 18:03:36.30200] [28009] [debug] [CGI:not-modified.pl:28011] START /build/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/not-modified.pl -[2021-07-11 18:03:36.37489] [28009] [debug] [x11PFhYz] 304 Not Modified (0.086738s, 11.529/s) +[2021-07-12 20:05:08.49497] [10195] [debug] [oPLes3W2] GET "/not-modified" +[2021-07-12 20:05:08.49626] [10195] [debug] [oPLes3W2] Routing to a callback +[2021-07-12 20:05:08.50058] [10195] [debug] [CGI:not-modified.pl:10196] START /build/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/not-modified.pl +[2021-07-12 20:05:08.52220] [10195] [debug] [oPLes3W2] 304 Not Modified (0.027215s, 36.744/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 -[2021-07-11 18:03:38.55817] [28012] [debug] [y1fA8yme] GET "/nph-borked" -[2021-07-11 18:03:38.55936] [28012] [debug] [y1fA8yme] Routing to a callback -[2021-07-11 18:03:38.56789] [28012] [debug] [CGI:nph-borked.pl:28016] START /build/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/nph-borked.pl -[2021-07-11 18:03:38.65789] [28012] [debug] [y1fA8yme] 403 Forbidden (0.09969s, 10.031/s) +[2021-07-12 20:05:09.38735] [10197] [debug] [n7yPeczz] GET "/nph-borked" +[2021-07-12 20:05:09.38855] [10197] [debug] [n7yPeczz] Routing to a callback +[2021-07-12 20:05:09.39256] [10197] [debug] [CGI:nph-borked.pl:10236] START /build/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/nph-borked.pl +[2021-07-12 20:05:09.41371] [10197] [debug] [n7yPeczz] 403 Forbidden (0.026278s, 38.055/s) t/nph-borked.t ................... ok 1 - GET /nph-borked ok 2 - 403 Forbidden ok 3 - content is similar 1..3 ok -[2021-07-11 18:03:40.75374] [28017] [debug] [bsbkk8ZO] GET "/nph" -[2021-07-11 18:03:40.75499] [28017] [debug] [bsbkk8ZO] Routing to a callback -[2021-07-11 18:03:40.76327] [28017] [debug] [CGI:nph.pl:28018] START /build/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/nph.pl -[2021-07-11 18:03:40.80617] [28017] [debug] [bsbkk8ZO] 403 Payment Required (0.052399s, 19.084/s) +[2021-07-12 20:05:10.24973] [10237] [debug] [opAeY9eA] GET "/nph" +[2021-07-12 20:05:10.25086] [10237] [debug] [opAeY9eA] Routing to a callback +[2021-07-12 20:05:10.25481] [10237] [debug] [CGI:nph.pl:10238] START /build/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/nph.pl +[2021-07-12 20:05:10.27581] [10237] [debug] [opAeY9eA] 403 Payment Required (0.026094s, 38.323/s) t/nph.t .......................... ok 1 - GET /nph ok 2 - 403 Forbidden @@ -640,10 +707,10 @@ 1..3 ok t/post.t ......................... skipped: TEST_PIPES=1; No idea how to test this consistently -[2021-07-11 18:03:44.64887] [28020] [debug] [SWKqoZ7q] GET "/env/basic/foo" -[2021-07-11 18:03:44.64996] [28020] [debug] [SWKqoZ7q] Routing to a callback -[2021-07-11 18:03:44.65787] [28020] [debug] [CGI:env.cgi:28021] START /build/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi -[2021-07-11 18:03:44.71021] [28020] [debug] [SWKqoZ7q] 200 OK (0.061312s, 16.310/s) +[2021-07-12 20:05:11.86519] [10240] [debug] [FOBBh1AG] GET "/env/basic/foo" +[2021-07-12 20:05:11.86634] [10240] [debug] [FOBBh1AG] Routing to a callback +[2021-07-12 20:05:11.87020] [10240] [debug] [CGI:env.cgi:10241] START /build/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi +[2021-07-12 20:05:11.89080] [10240] [debug] [FOBBh1AG] 200 OK (0.025556s, 39.130/s) t/query-string-with-semicolon.t .. ok 1 - GET /env/basic/foo?a=1;b=2 ok 2 - 200 OK @@ -655,10 +722,10 @@ # expected: '1' 1..4 ok -[2021-07-11 18:03:46.68847] [28022] [debug] [MjqCvwku] GET "/redirect" -[2021-07-11 18:03:46.69385] [28022] [debug] [MjqCvwku] Routing to a callback -[2021-07-11 18:03:46.70189] [28022] [debug] [CGI:redirect.pl:28023] START /build/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/redirect.pl -[2021-07-11 18:03:46.74639] [28022] [debug] [MjqCvwku] 302 Found (0.057888s, 17.275/s) +[2021-07-12 20:05:12.70124] [10242] [debug] [fYxRSqpV] GET "/redirect" +[2021-07-12 20:05:12.70240] [10242] [debug] [fYxRSqpV] Routing to a callback +[2021-07-12 20:05:12.70619] [10242] [debug] [CGI:redirect.pl:10243] START /build/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/redirect.pl +[2021-07-12 20:05:12.72759] [10242] [debug] [fYxRSqpV] 302 Found (0.02631s, 38.008/s) t/redirect.t ..................... ok 1 - GET /redirect ok 2 - 302 Found @@ -666,35 +733,35 @@ ok 4 - exact match for content 1..4 ok -[2021-07-11 18:03:49.01927] [28024] [debug] [uO3ks74M] GET "/auth" -[2021-07-11 18:03:49.02590] [28024] [debug] [uO3ks74M] Routing to a callback -[2021-07-11 18:03:49.03387] [28024] [debug] [CGI:env.cgi:28025] START /build/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi -[2021-07-11 18:03:49.09450] [28024] [debug] [uO3ks74M] 200 OK (0.075181s, 13.301/s) -[2021-07-11 18:03:49.12977] [28024] [debug] [-l9vS_wb] GET "/auth" -[2021-07-11 18:03:49.13035] [28024] [debug] [-l9vS_wb] Routing to a callback -[2021-07-11 18:03:49.13446] [28024] [debug] [CGI:env.cgi:28027] START /build/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi -[2021-07-11 18:03:49.16628] [28024] [debug] [-l9vS_wb] 200 OK (0.036447s, 27.437/s) -[2021-07-11 18:03:49.18180] [28024] [debug] [ST1DnU3t] GET "/auth" -[2021-07-11 18:03:49.18235] [28024] [debug] [ST1DnU3t] Routing to a callback -[2021-07-11 18:03:49.18649] [28024] [debug] [CGI:env.cgi:28028] START /build/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi -[2021-07-11 18:03:49.21753] [28024] [debug] [ST1DnU3t] 200 OK (0.035668s, 28.036/s) +[2021-07-12 20:05:13.52855] [10244] [debug] [kUw6Vx72] GET "/auth" +[2021-07-12 20:05:13.52979] [10244] [debug] [kUw6Vx72] Routing to a callback +[2021-07-12 20:05:13.53319] [10244] [debug] [CGI:env.cgi:10245] START /build/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi +[2021-07-12 20:05:13.55329] [10244] [debug] [kUw6Vx72] 200 OK (0.024704s, 40.479/s) +[2021-07-12 20:05:13.56589] [10244] [debug] [ShjsHP1Y] GET "/auth" +[2021-07-12 20:05:13.56642] [10244] [debug] [ShjsHP1Y] Routing to a callback +[2021-07-12 20:05:13.56975] [10244] [debug] [CGI:env.cgi:10246] START /build/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi +[2021-07-12 20:05:13.58966] [10244] [debug] [ShjsHP1Y] 200 OK (0.023719s, 42.160/s) +[2021-07-12 20:05:13.60240] [10244] [debug] [rnk0QCXT] GET "/auth" +[2021-07-12 20:05:13.60292] [10244] [debug] [rnk0QCXT] Routing to a callback +[2021-07-12 20:05:13.60616] [10244] [debug] [CGI:env.cgi:10247] START /build/libmojolicious-plugin-cgi-perl-0.40/t/cgi-bin/env.cgi +[2021-07-12 20:05:13.62596] [10244] [debug] [rnk0QCXT] 200 OK (0.023511s, 42.533/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:36867/auth +ok 5 - GET http://127.0.0.1:41379/auth ok 6 - 200 OK ok 7 - REMOTE_USER=Aladdin -ok 8 - GET http://127.0.0.1:36867/auth +ok 8 - GET http://127.0.0.1:41379/auth ok 9 - 200 OK ok 10 - REMOTE_USER=Aladdin 1..10 ok -[2021-07-11 18:03:51.09948] [28029] [debug] [futoraVx] GET "/" -[2021-07-11 18:03:51.10065] [28029] [debug] [futoraVx] Routing to a callback -[2021-07-11 18:03:51.12091] [28029] [debug] [CGI:CODE(0x146ddc8):28033] START CODE(0x146ddc8) -[2021-07-11 18:03:51.14253] [28029] [debug] [futoraVx] 200 OK (0.042996s, 23.258/s) +[2021-07-12 20:05:14.50539] [10248] [debug] [i0R-qcci] GET "/" +[2021-07-12 20:05:14.50661] [10248] [debug] [i0R-qcci] Routing to a callback +[2021-07-12 20:05:14.51016] [10248] [debug] [CGI:CODE(0x170ae10):10249] START CODE(0x170ae10) +[2021-07-12 20:05:14.51959] [10248] [debug] [i0R-qcci] 200 OK (0.014124s, 70.801/s) t/run.t .......................... ok 1 - GET / ok 2 - 200 OK @@ -703,7 +770,7 @@ ok t/zombies.t ...................... skipped: (no reason given) All tests successful. -Files=18, Tests=110, 38 wallclock secs ( 0.11 usr 0.10 sys + 17.67 cusr 2.07 csys = 19.95 CPU) +Files=18, Tests=110, 15 wallclock secs ( 0.16 usr 0.04 sys + 13.28 cusr 1.58 csys = 15.06 CPU) Result: PASS make[1]: Leaving directory '/build/libmojolicious-plugin-cgi-perl-0.40' create-stamp debian/debhelper-build-stamp @@ -712,7 +779,7 @@ dh_testroot dh_prep dh_auto_install - make -j3 install DESTDIR=/build/libmojolicious-plugin-cgi-perl-0.40/debian/libmojolicious-plugin-cgi-perl AM_UPDATE_INFO_DIR=no PREFIX=/usr + make -j4 install DESTDIR=/build/libmojolicious-plugin-cgi-perl-0.40/debian/libmojolicious-plugin-cgi-perl AM_UPDATE_INFO_DIR=no PREFIX=/usr make[1]: Entering directory '/build/libmojolicious-plugin-cgi-perl-0.40' Manifying 1 pod document Installing /build/libmojolicious-plugin-cgi-perl-0.40/debian/libmojolicious-plugin-cgi-perl/usr/share/perl5/Mojolicious/Plugin/CGI.pm @@ -739,12 +806,14 @@ dpkg-buildpackage: info: binary-only upload (no source included) dpkg-genchanges: info: including full source code in upload I: copying local configuration +I: user script /srv/workspace/pbuilder/4134/tmp/hooks/B01_cleanup starting +I: user script /srv/workspace/pbuilder/4134/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/26806 and its subdirectories -I: Current time: Sun Jul 11 18:04:10 -12 2021 -I: pbuilder-time-stamp: 1626069850 +I: removing directory /srv/workspace/pbuilder/4134 and its subdirectories +I: Current time: Mon Jul 12 20:05:21 +14 2021 +I: pbuilder-time-stamp: 1626069921