Diff of the two buildlogs: -- --- b1/build.log 2023-05-21 07:03:09.091066060 +0000 +++ b2/build.log 2023-05-21 07:05:28.460973090 +0000 @@ -1,6 +1,6 @@ I: pbuilder: network access will be disabled during build -I: Current time: Sat Jun 22 01:22:26 -12 2024 -I: pbuilder-time-stamp: 1719062546 +I: Current time: Sun May 21 21:03:10 +14 2023 +I: pbuilder-time-stamp: 1684652590 I: Building the build Environment I: extracting base tarball [/var/cache/pbuilder/bookworm-reproducible-base.tgz] I: copying local configuration @@ -19,7 +19,7 @@ I: copying [./node-log4js_6.7.1+~cs8.4.17.orig.tar.gz] I: copying [./node-log4js_6.7.1+~cs8.4.17-1.debian.tar.xz] I: Extracting source -gpgv: Signature made Sat Dec 3 05:52:05 2022 -12 +gpgv: Signature made Sun Dec 4 07:52:05 2022 +14 gpgv: using RSA key 00DFE58B8B555779D1005EC9F6D74CA7C999EEE9 gpgv: Can't check signature: No public key dpkg-source: warning: cannot verify inline signature for ./node-log4js_6.7.1+~cs8.4.17-1.dsc: no acceptable signature found @@ -33,135 +33,167 @@ dpkg-source: info: applying privacy.patch I: Not using root during the build. I: Installing the build-deps -I: user script /srv/workspace/pbuilder/3801070/tmp/hooks/D02_print_environment starting +I: user script /srv/workspace/pbuilder/3664852/tmp/hooks/D01_modify_environment starting +debug: Running on ionos11-amd64. +I: Changing host+domainname to test build reproducibility +I: Adding a custom variable just for the fun of it... +I: Changing /bin/sh to bash +'/bin/sh' -> '/bin/bash' +lrwxrwxrwx 1 root root 9 May 21 21:03 /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/3664852/tmp/hooks/D01_modify_environment finished +I: user script /srv/workspace/pbuilder/3664852/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='amd64' - DEBIAN_FRONTEND='noninteractive' - DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all parallel=16 ' - DISTRIBUTION='bookworm' - HOME='/root' - HOST_ARCH='amd64' + BASH=/bin/sh + BASHOPTS=checkwinsize:cmdhist:complete_fullquote:extquote:force_fignore:globasciiranges:globskipdots:hostcomplete:interactive_comments:patsub_replacement:progcomp:promptvars:sourcepath + BASH_ALIASES=() + BASH_ARGC=() + BASH_ARGV=() + BASH_CMDS=() + BASH_LINENO=([0]="12" [1]="0") + BASH_LOADABLES_PATH=/usr/local/lib/bash:/usr/lib/bash:/opt/local/lib/bash:/usr/pkg/lib/bash:/opt/pkg/lib/bash:. + BASH_SOURCE=([0]="/tmp/hooks/D02_print_environment" [1]="/tmp/hooks/D02_print_environment") + BASH_VERSINFO=([0]="5" [1]="2" [2]="15" [3]="1" [4]="release" [5]="x86_64-pc-linux-gnu") + BASH_VERSION='5.2.15(1)-release' + BUILDDIR=/build + BUILDUSERGECOS='second user,second room,second work-phone,second home-phone,second other' + BUILDUSERNAME=pbuilder2 + BUILD_ARCH=amd64 + DEBIAN_FRONTEND=noninteractive + DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all parallel=15 ' + DIRSTACK=() + DISTRIBUTION=bookworm + EUID=0 + FUNCNAME=([0]="Echo" [1]="main") + GROUPS=() + HOME=/root + HOSTNAME=i-capture-the-hostname + HOSTTYPE=x86_64 + HOST_ARCH=amd64 IFS=' ' - INVOCATION_ID='44818b4610834531a4549f7cfd1e6783' - 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='3801070' - PS1='# ' - PS2='> ' + INVOCATION_ID=82d0d7617b0d41efa78144cb9394bcf4 + LANG=C + LANGUAGE=et_EE:et + LC_ALL=C + MACHTYPE=x86_64-pc-linux-gnu + MAIL=/var/mail/root + OPTERR=1 + OPTIND=1 + OSTYPE=linux-gnu + PATH=/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/i/capture/the/path + PBCURRENTCOMMANDLINEOPERATION=build + PBUILDER_OPERATION=build + PBUILDER_PKGDATADIR=/usr/share/pbuilder + PBUILDER_PKGLIBDIR=/usr/lib/pbuilder + PBUILDER_SYSCONFDIR=/etc + PIPESTATUS=([0]="0") + POSIXLY_CORRECT=y + PPID=3664852 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.4k0QQAy1/pbuilderrc_rCWK --distribution bookworm --hookdir /etc/pbuilder/first-build-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/bookworm-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/r-b-build.4k0QQAy1/b1 --logfile b1/build.log node-log4js_6.7.1+~cs8.4.17-1.dsc' - SUDO_GID='111' - SUDO_UID='106' - 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.4k0QQAy1/pbuilderrc_Ueqp --distribution bookworm --hookdir /etc/pbuilder/rebuild-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/bookworm-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/r-b-build.4k0QQAy1/b2 --logfile b2/build.log --extrapackages usrmerge node-log4js_6.7.1+~cs8.4.17-1.dsc' + SUDO_GID=111 + SUDO_UID=106 + SUDO_USER=jenkins + TERM=unknown + TZ=/usr/share/zoneinfo/Etc/GMT-14 + UID=0 + USER=root + _='I: set' + http_proxy=http://78.137.99.97:3128 I: uname -a - Linux ionos15-amd64 6.1.0-0.deb11.6-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.1.15-1~bpo11+1 (2023-03-16) x86_64 GNU/Linux + Linux i-capture-the-hostname 5.10.0-23-amd64 #1 SMP Debian 5.10.179-1 (2023-05-12) x86_64 GNU/Linux I: ls -l /bin total 5632 - -rwxr-xr-x 1 root root 1265648 Apr 23 2023 bash - -rwxr-xr-x 3 root root 39224 Sep 18 2022 bunzip2 - -rwxr-xr-x 3 root root 39224 Sep 18 2022 bzcat - lrwxrwxrwx 1 root root 6 Sep 18 2022 bzcmp -> bzdiff - -rwxr-xr-x 1 root root 2225 Sep 18 2022 bzdiff - lrwxrwxrwx 1 root root 6 Sep 18 2022 bzegrep -> bzgrep - -rwxr-xr-x 1 root root 4893 Nov 27 2021 bzexe - lrwxrwxrwx 1 root root 6 Sep 18 2022 bzfgrep -> bzgrep - -rwxr-xr-x 1 root root 3775 Sep 18 2022 bzgrep - -rwxr-xr-x 3 root root 39224 Sep 18 2022 bzip2 - -rwxr-xr-x 1 root root 14568 Sep 18 2022 bzip2recover - lrwxrwxrwx 1 root root 6 Sep 18 2022 bzless -> bzmore - -rwxr-xr-x 1 root root 1297 Sep 18 2022 bzmore - -rwxr-xr-x 1 root root 44016 Sep 20 2022 cat - -rwxr-xr-x 1 root root 68656 Sep 20 2022 chgrp - -rwxr-xr-x 1 root root 64496 Sep 20 2022 chmod - -rwxr-xr-x 1 root root 72752 Sep 20 2022 chown - -rwxr-xr-x 1 root root 151152 Sep 20 2022 cp - -rwxr-xr-x 1 root root 125640 Jan 5 2023 dash - -rwxr-xr-x 1 root root 121904 Sep 20 2022 date - -rwxr-xr-x 1 root root 89240 Sep 20 2022 dd - -rwxr-xr-x 1 root root 102200 Sep 20 2022 df - -rwxr-xr-x 1 root root 151344 Sep 20 2022 dir - -rwxr-xr-x 1 root root 88656 Mar 22 2023 dmesg - lrwxrwxrwx 1 root root 8 Dec 19 2022 dnsdomainname -> hostname - lrwxrwxrwx 1 root root 8 Dec 19 2022 domainname -> hostname - -rwxr-xr-x 1 root root 43856 Sep 20 2022 echo - -rwxr-xr-x 1 root root 41 Jan 24 2023 egrep - -rwxr-xr-x 1 root root 35664 Sep 20 2022 false - -rwxr-xr-x 1 root root 41 Jan 24 2023 fgrep - -rwxr-xr-x 1 root root 85600 Mar 22 2023 findmnt - -rwsr-xr-x 1 root root 35128 Mar 22 2023 fusermount - -rwxr-xr-x 1 root root 203152 Jan 24 2023 grep - -rwxr-xr-x 2 root root 2346 Apr 9 2022 gunzip - -rwxr-xr-x 1 root root 6447 Apr 9 2022 gzexe - -rwxr-xr-x 1 root root 98136 Apr 9 2022 gzip - -rwxr-xr-x 1 root root 22680 Dec 19 2022 hostname - -rwxr-xr-x 1 root root 72824 Sep 20 2022 ln - -rwxr-xr-x 1 root root 53024 Mar 23 2023 login - -rwxr-xr-x 1 root root 151344 Sep 20 2022 ls - -rwxr-xr-x 1 root root 207168 Mar 22 2023 lsblk - -rwxr-xr-x 1 root root 97552 Sep 20 2022 mkdir - -rwxr-xr-x 1 root root 72912 Sep 20 2022 mknod - -rwxr-xr-x 1 root root 43952 Sep 20 2022 mktemp - -rwxr-xr-x 1 root root 59712 Mar 22 2023 more - -rwsr-xr-x 1 root root 59704 Mar 22 2023 mount - -rwxr-xr-x 1 root root 18744 Mar 22 2023 mountpoint - -rwxr-xr-x 1 root root 142968 Sep 20 2022 mv - lrwxrwxrwx 1 root root 8 Dec 19 2022 nisdomainname -> hostname - lrwxrwxrwx 1 root root 14 Apr 2 2023 pidof -> /sbin/killall5 - -rwxr-xr-x 1 root root 43952 Sep 20 2022 pwd - lrwxrwxrwx 1 root root 4 Apr 23 2023 rbash -> bash - -rwxr-xr-x 1 root root 52112 Sep 20 2022 readlink - -rwxr-xr-x 1 root root 72752 Sep 20 2022 rm - -rwxr-xr-x 1 root root 56240 Sep 20 2022 rmdir - -rwxr-xr-x 1 root root 27560 Nov 2 2022 run-parts - -rwxr-xr-x 1 root root 126424 Jan 5 2023 sed - lrwxrwxrwx 1 root root 4 Jan 5 2023 sh -> dash - -rwxr-xr-x 1 root root 43888 Sep 20 2022 sleep - -rwxr-xr-x 1 root root 85008 Sep 20 2022 stty - -rwsr-xr-x 1 root root 72000 Mar 22 2023 su - -rwxr-xr-x 1 root root 39824 Sep 20 2022 sync - -rwxr-xr-x 1 root root 531984 Apr 6 2023 tar - -rwxr-xr-x 1 root root 14520 Nov 2 2022 tempfile - -rwxr-xr-x 1 root root 109616 Sep 20 2022 touch - -rwxr-xr-x 1 root root 35664 Sep 20 2022 true - -rwxr-xr-x 1 root root 14568 Mar 22 2023 ulockmgr_server - -rwsr-xr-x 1 root root 35128 Mar 22 2023 umount - -rwxr-xr-x 1 root root 43888 Sep 20 2022 uname - -rwxr-xr-x 2 root root 2346 Apr 9 2022 uncompress - -rwxr-xr-x 1 root root 151344 Sep 20 2022 vdir - -rwxr-xr-x 1 root root 72024 Mar 22 2023 wdctl - lrwxrwxrwx 1 root root 8 Dec 19 2022 ypdomainname -> hostname - -rwxr-xr-x 1 root root 1984 Apr 9 2022 zcat - -rwxr-xr-x 1 root root 1678 Apr 9 2022 zcmp - -rwxr-xr-x 1 root root 6460 Apr 9 2022 zdiff - -rwxr-xr-x 1 root root 29 Apr 9 2022 zegrep - -rwxr-xr-x 1 root root 29 Apr 9 2022 zfgrep - -rwxr-xr-x 1 root root 2081 Apr 9 2022 zforce - -rwxr-xr-x 1 root root 8103 Apr 9 2022 zgrep - -rwxr-xr-x 1 root root 2206 Apr 9 2022 zless - -rwxr-xr-x 1 root root 1842 Apr 9 2022 zmore - -rwxr-xr-x 1 root root 4577 Apr 9 2022 znew -I: user script /srv/workspace/pbuilder/3801070/tmp/hooks/D02_print_environment finished + -rwxr-xr-x 1 root root 1265648 Apr 24 11:23 bash + -rwxr-xr-x 3 root root 39224 Sep 19 2022 bunzip2 + -rwxr-xr-x 3 root root 39224 Sep 19 2022 bzcat + lrwxrwxrwx 1 root root 6 Sep 19 2022 bzcmp -> bzdiff + -rwxr-xr-x 1 root root 2225 Sep 19 2022 bzdiff + lrwxrwxrwx 1 root root 6 Sep 19 2022 bzegrep -> bzgrep + -rwxr-xr-x 1 root root 4893 Nov 28 2021 bzexe + lrwxrwxrwx 1 root root 6 Sep 19 2022 bzfgrep -> bzgrep + -rwxr-xr-x 1 root root 3775 Sep 19 2022 bzgrep + -rwxr-xr-x 3 root root 39224 Sep 19 2022 bzip2 + -rwxr-xr-x 1 root root 14568 Sep 19 2022 bzip2recover + lrwxrwxrwx 1 root root 6 Sep 19 2022 bzless -> bzmore + -rwxr-xr-x 1 root root 1297 Sep 19 2022 bzmore + -rwxr-xr-x 1 root root 44016 Sep 21 2022 cat + -rwxr-xr-x 1 root root 68656 Sep 21 2022 chgrp + -rwxr-xr-x 1 root root 64496 Sep 21 2022 chmod + -rwxr-xr-x 1 root root 72752 Sep 21 2022 chown + -rwxr-xr-x 1 root root 151152 Sep 21 2022 cp + -rwxr-xr-x 1 root root 125640 Jan 6 03:20 dash + -rwxr-xr-x 1 root root 121904 Sep 21 2022 date + -rwxr-xr-x 1 root root 89240 Sep 21 2022 dd + -rwxr-xr-x 1 root root 102200 Sep 21 2022 df + -rwxr-xr-x 1 root root 151344 Sep 21 2022 dir + -rwxr-xr-x 1 root root 88656 Mar 24 00:02 dmesg + lrwxrwxrwx 1 root root 8 Dec 20 03:33 dnsdomainname -> hostname + lrwxrwxrwx 1 root root 8 Dec 20 03:33 domainname -> hostname + -rwxr-xr-x 1 root root 43856 Sep 21 2022 echo + -rwxr-xr-x 1 root root 41 Jan 25 04:43 egrep + -rwxr-xr-x 1 root root 35664 Sep 21 2022 false + -rwxr-xr-x 1 root root 41 Jan 25 04:43 fgrep + -rwxr-xr-x 1 root root 85600 Mar 24 00:02 findmnt + -rwsr-xr-x 1 root root 35128 Mar 23 22:35 fusermount + -rwxr-xr-x 1 root root 203152 Jan 25 04:43 grep + -rwxr-xr-x 2 root root 2346 Apr 10 2022 gunzip + -rwxr-xr-x 1 root root 6447 Apr 10 2022 gzexe + -rwxr-xr-x 1 root root 98136 Apr 10 2022 gzip + -rwxr-xr-x 1 root root 22680 Dec 20 03:33 hostname + -rwxr-xr-x 1 root root 72824 Sep 21 2022 ln + -rwxr-xr-x 1 root root 53024 Mar 24 02:40 login + -rwxr-xr-x 1 root root 151344 Sep 21 2022 ls + -rwxr-xr-x 1 root root 207168 Mar 24 00:02 lsblk + -rwxr-xr-x 1 root root 97552 Sep 21 2022 mkdir + -rwxr-xr-x 1 root root 72912 Sep 21 2022 mknod + -rwxr-xr-x 1 root root 43952 Sep 21 2022 mktemp + -rwxr-xr-x 1 root root 59712 Mar 24 00:02 more + -rwsr-xr-x 1 root root 59704 Mar 24 00:02 mount + -rwxr-xr-x 1 root root 18744 Mar 24 00:02 mountpoint + -rwxr-xr-x 1 root root 142968 Sep 21 2022 mv + lrwxrwxrwx 1 root root 8 Dec 20 03:33 nisdomainname -> hostname + lrwxrwxrwx 1 root root 14 Apr 3 20:25 pidof -> /sbin/killall5 + -rwxr-xr-x 1 root root 43952 Sep 21 2022 pwd + lrwxrwxrwx 1 root root 4 Apr 24 11:23 rbash -> bash + -rwxr-xr-x 1 root root 52112 Sep 21 2022 readlink + -rwxr-xr-x 1 root root 72752 Sep 21 2022 rm + -rwxr-xr-x 1 root root 56240 Sep 21 2022 rmdir + -rwxr-xr-x 1 root root 27560 Nov 3 2022 run-parts + -rwxr-xr-x 1 root root 126424 Jan 6 09:55 sed + lrwxrwxrwx 1 root root 9 May 21 21:03 sh -> /bin/bash + -rwxr-xr-x 1 root root 43888 Sep 21 2022 sleep + -rwxr-xr-x 1 root root 85008 Sep 21 2022 stty + -rwsr-xr-x 1 root root 72000 Mar 24 00:02 su + -rwxr-xr-x 1 root root 39824 Sep 21 2022 sync + -rwxr-xr-x 1 root root 531984 Apr 7 04:25 tar + -rwxr-xr-x 1 root root 14520 Nov 3 2022 tempfile + -rwxr-xr-x 1 root root 109616 Sep 21 2022 touch + -rwxr-xr-x 1 root root 35664 Sep 21 2022 true + -rwxr-xr-x 1 root root 14568 Mar 23 22:35 ulockmgr_server + -rwsr-xr-x 1 root root 35128 Mar 24 00:02 umount + -rwxr-xr-x 1 root root 43888 Sep 21 2022 uname + -rwxr-xr-x 2 root root 2346 Apr 10 2022 uncompress + -rwxr-xr-x 1 root root 151344 Sep 21 2022 vdir + -rwxr-xr-x 1 root root 72024 Mar 24 00:02 wdctl + lrwxrwxrwx 1 root root 8 Dec 20 03:33 ypdomainname -> hostname + -rwxr-xr-x 1 root root 1984 Apr 10 2022 zcat + -rwxr-xr-x 1 root root 1678 Apr 10 2022 zcmp + -rwxr-xr-x 1 root root 6460 Apr 10 2022 zdiff + -rwxr-xr-x 1 root root 29 Apr 10 2022 zegrep + -rwxr-xr-x 1 root root 29 Apr 10 2022 zfgrep + -rwxr-xr-x 1 root root 2081 Apr 10 2022 zforce + -rwxr-xr-x 1 root root 8103 Apr 10 2022 zgrep + -rwxr-xr-x 1 root root 2206 Apr 10 2022 zless + -rwxr-xr-x 1 root root 1842 Apr 10 2022 zmore + -rwxr-xr-x 1 root root 4577 Apr 10 2022 znew +I: user script /srv/workspace/pbuilder/3664852/tmp/hooks/D02_print_environment finished -> Attempting to satisfy build-dependencies -> Creating pbuilder-satisfydepends-dummy package Package: pbuilder-satisfydepends-dummy @@ -594,7 +626,7 @@ Get: 379 http://deb.debian.org/debian bookworm/main amd64 node-widest-line all 3.1.0-2 [4092 B] Get: 380 http://deb.debian.org/debian bookworm/main amd64 node-ws all 8.11.0+~cs13.7.3-1 [51.1 kB] Get: 381 http://deb.debian.org/debian bookworm/main amd64 node-tap all 16.3.2+ds1+~cs50.8.16-1 [101 kB] -Fetched 45.8 MB in 2s (21.1 MB/s) +Fetched 45.8 MB in 2s (18.9 MB/s) debconf: delaying package configuration, since apt-utils is not installed 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 ... 19596 files and directories currently installed.) @@ -2146,8 +2178,19 @@ Writing extended state information... Building tag database... -> Finished parsing the build-deps +Reading package lists... +Building dependency tree... +Reading state information... +usrmerge is already the newest version (35). +0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. I: Building the package -I: Running cd /build/node-log4js-6.7.1+~cs8.4.17/ && 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 > ../node-log4js_6.7.1+~cs8.4.17-1_source.changes +I: user script /srv/workspace/pbuilder/3664852/tmp/hooks/A99_set_merged_usr starting +Re-configuring usrmerge... +removed '/etc/unsupported-skip-usrmerge-conversion' +The system has been successfully converted. +I: user script /srv/workspace/pbuilder/3664852/tmp/hooks/A99_set_merged_usr finished +hostname: Name or service not known +I: Running cd /build/node-log4js-6.7.1+~cs8.4.17/ && 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 > ../node-log4js_6.7.1+~cs8.4.17-1_source.changes dpkg-buildpackage: info: source package node-log4js dpkg-buildpackage: info: source version 6.7.1+~cs8.4.17-1 dpkg-buildpackage: info: source distribution unstable @@ -2185,9 +2228,9 @@ dh_auto_test --buildsystem=nodejs ln -s ../. node_modules/log4js /bin/sh -ex debian/tests/pkg-js/test -+ xargs grep -L sandboxed -+ ls test/tap/LoggingEvent-test.js test/tap/appender-dependencies-test.js test/tap/categoryFilter-test.js test/tap/cluster-test.js test/tap/configuration-inheritance-test.js test/tap/configuration-test.js test/tap/configuration-validation-test.js test/tap/connect-context-test.js test/tap/connect-logger-test.js test/tap/connect-nolog-test.js test/tap/consoleAppender-test.js test/tap/dateFileAppender-test.js test/tap/default-settings-test.js test/tap/disable-cluster-test.js test/tap/file-descriptor-leak-test.js test/tap/file-sighup-test.js test/tap/fileAppender-test.js test/tap/fileSyncAppender-test.js test/tap/layouts-test.js test/tap/levels-before-configure-test.js test/tap/levels-test.js test/tap/logLevelFilter-test.js test/tap/logger-test.js test/tap/logging-test.js test/tap/multi-file-appender-test.js test/tap/multiprocess-shutdown-test.js test/tap/multiprocess-test.js test/tap/newLevel-test.js test/tap/no-cluster-test.js test/tap/noLogFilter-test.js test/tap/passenger-test.js test/tap/pause-test.js test/tap/pm2-support-test.js test/tap/recordingAppender-test.js test/tap/server-test.js test/tap/setLevel-asymmetry-test.js test/tap/stacktraces-test.js test/tap/stderrAppender-test.js test/tap/stdoutAppender-test.js test/tap/subcategories-test.js test/tap/tcp-appender-test.js -+ grep -v -f debian/tests/test_excluded +++ ls test/tap/LoggingEvent-test.js test/tap/appender-dependencies-test.js test/tap/categoryFilter-test.js test/tap/cluster-test.js test/tap/configuration-inheritance-test.js test/tap/configuration-test.js test/tap/configuration-validation-test.js test/tap/connect-context-test.js test/tap/connect-logger-test.js test/tap/connect-nolog-test.js test/tap/consoleAppender-test.js test/tap/dateFileAppender-test.js test/tap/default-settings-test.js test/tap/disable-cluster-test.js test/tap/file-descriptor-leak-test.js test/tap/file-sighup-test.js test/tap/fileAppender-test.js test/tap/fileSyncAppender-test.js test/tap/layouts-test.js test/tap/levels-before-configure-test.js test/tap/levels-test.js test/tap/logLevelFilter-test.js test/tap/logger-test.js test/tap/logging-test.js test/tap/multi-file-appender-test.js test/tap/multiprocess-shutdown-test.js test/tap/multiprocess-test.js test/tap/newLevel-test.js test/tap/no-cluster-test.js test/tap/noLogFilter-test.js test/tap/passenger-test.js test/tap/pause-test.js test/tap/pm2-support-test.js test/tap/recordingAppender-test.js test/tap/server-test.js test/tap/setLevel-asymmetry-test.js test/tap/stacktraces-test.js test/tap/stderrAppender-test.js test/tap/stdoutAppender-test.js test/tap/subcategories-test.js test/tap/tcp-appender-test.js +++ xargs grep -L sandboxed +++ grep -v -f debian/tests/test_excluded + tap -R tap --no-cov --bail test/tap/LoggingEvent-test.js test/tap/cluster-test.js test/tap/configuration-inheritance-test.js test/tap/connect-logger-test.js test/tap/disable-cluster-test.js test/tap/file-descriptor-leak-test.js test/tap/layouts-test.js test/tap/levels-before-configure-test.js test/tap/levels-test.js test/tap/logLevelFilter-test.js test/tap/pause-test.js test/tap/pm2-support-test.js test/tap/recordingAppender-test.js test/tap/server-test.js test/tap/setLevel-asymmetry-test.js test/tap/stacktraces-test.js test/tap/subcategories-test.js TAP version 13 # Subtest: test/tap/LoggingEvent-test.js @@ -2195,7 +2238,7 @@ # Subtest: should throw error for invalid location ok 1 - Invalid location type passed to LoggingEvent constructor 1..1 - ok 1 - should throw error for invalid location # time=15.786ms + ok 1 - should throw error for invalid location # time=8.292ms # Subtest: should serialise to flatted ok 1 - should be equal @@ -2213,7 +2256,7 @@ ok 13 - should be equal ok 14 - should be equal 1..14 - ok 2 - should serialise to flatted # time=13.017ms + ok 2 - should serialise to flatted # time=10.615ms # Subtest: should deserialise from flatted ok 1 - type is LoggingEvent @@ -2239,7 +2282,7 @@ ok 21 - should be equal ok 22 - should be equal 1..22 - ok 3 - should deserialise from flatted # time=10.93ms + ok 3 - should deserialise from flatted # time=11.249ms # Subtest: Should correct construct with/without location info ok 1 - should be equal @@ -2259,7 +2302,7 @@ ok 15 - should be equal ok 16 - should be equal 1..16 - ok 4 - Should correct construct with/without location info # time=6.242ms + ok 4 - Should correct construct with/without location info # time=5.456ms # Subtest: Should contain class, method and alias names ok 1 - should be equal @@ -2271,19 +2314,19 @@ ok 7 - should be equal ok 8 - should be equal 1..8 - ok 5 - Should contain class, method and alias names # time=2.998ms + ok 5 - Should contain class, method and alias names # time=3.593ms # Subtest: Should correctly serialize and deserialize ok 1 - should match pattern provided 1..1 - ok 6 - Should correctly serialize and deserialize # time=11.722ms + ok 6 - Should correctly serialize and deserialize # time=12.457ms 1..6 - ok 1 - LoggingEvent # time=159.831ms + ok 1 - LoggingEvent # time=118.396ms 1..1 - # time=201.011ms -ok 1 - test/tap/LoggingEvent-test.js # time=201.011ms + # time=157.612ms +ok 1 - test/tap/LoggingEvent-test.js # time=157.612ms # Subtest: test/tap/cluster-test.js # Subtest: cluster master @@ -2306,23 +2349,23 @@ ok 16 - should be equal ok 17 - should be equal 1..17 - ok 1 - events should be logged # time=77.68ms + ok 1 - events should be logged # time=19.887ms 1..1 - ok 1 - cluster master # time=198.187ms + ok 1 - cluster master # time=45.449ms # Subtest: cluster worker # Subtest: logger should get correct config ok 1 - should be equal 1..1 - ok 1 - logger should get correct config # time=1.305ms + ok 1 - logger should get correct config # time=1.207ms 1..1 - ok 2 - cluster worker # time=25.567ms + ok 2 - cluster worker # time=7.901ms 1..2 - # time=364.766ms -ok 2 - test/tap/cluster-test.js # time=364.766ms + # time=64.367ms +ok 2 - test/tap/cluster-test.js # time=64.367ms # Subtest: test/tap/configuration-inheritance-test.js # Subtest: log4js category inherit all appenders from direct parent @@ -2333,7 +2376,7 @@ ok 4 - inherited stdout2 ok 5 - child level overrides parent 1..5 - ok 1 - should inherit appenders from direct parent # time=57.434ms + ok 1 - should inherit appenders from direct parent # time=22.298ms # Subtest: multiple children should inherit config from shared parent ok 1 - inherited 1 appender @@ -2345,7 +2388,7 @@ ok 7 - kept stdout2 ok 8 - inherited parent level 1..8 - ok 2 - multiple children should inherit config from shared parent # time=24.639ms + ok 2 - multiple children should inherit config from shared parent # time=8.448ms # Subtest: should inherit appenders from multiple parents ok 1 - expect truthy value @@ -2357,7 +2400,7 @@ ok 7 - inherited stdout1 ok 8 - kept stdout2 1..8 - ok 3 - should inherit appenders from multiple parents # time=45.38ms + ok 3 - should inherit appenders from multiple parents # time=9.16ms # Subtest: should inherit appenders from deep parent with missing direct parent ok 1 - expect truthy value @@ -2367,14 +2410,14 @@ ok 5 - created with 1 inherited appender ok 6 - inherited stdout1 1..6 - ok 4 - should inherit appenders from deep parent with missing direct parent # time=8.1ms + ok 4 - should inherit appenders from deep parent with missing direct parent # time=4.396ms # Subtest: should deal gracefully with missing parent ok 1 - expect truthy value ok 2 - should be equal ok 3 - expect truthy value 1..3 - ok 5 - should deal gracefully with missing parent # time=12.076ms + ok 5 - should deal gracefully with missing parent # time=4.539ms # Subtest: should not get duplicate appenders if parent has the same one ok 1 - expect truthy value @@ -2382,14 +2425,14 @@ ok 3 - still have stdout1 ok 4 - inherited stdout2 1..4 - ok 6 - should not get duplicate appenders if parent has the same one # time=12.318ms + ok 6 - should not get duplicate appenders if parent has the same one # time=4.609ms # Subtest: inherit:falses should disable inheritance ok 1 - expect truthy value ok 2 - inherited no appender ok 3 - kept stdout2 1..3 - ok 7 - inherit:falses should disable inheritance # time=13.367ms + ok 7 - inherit:falses should disable inheritance # time=4.367ms # Subtest: inheritance should stop if direct parent has inherit off ok 1 - expect truthy value @@ -2399,20 +2442,20 @@ ok 5 - did not inherit new appenders ok 6 - kept stdout2 1..6 - ok 8 - inheritance should stop if direct parent has inherit off # time=17.062ms + ok 8 - inheritance should stop if direct parent has inherit off # time=4.869ms # Subtest: should inherit level when it is missing ok 1 - inherited level ok 2 - generate parent inherited level from base 1..2 - ok 9 - should inherit level when it is missing # time=3.367ms + ok 9 - should inherit level when it is missing # time=3.287ms 1..9 - ok 1 - log4js category inherit all appenders from direct parent # time=383.529ms + ok 1 - log4js category inherit all appenders from direct parent # time=145.211ms 1..1 - # time=412.448ms -ok 3 - test/tap/configuration-inheritance-test.js # time=412.448ms + # time=154.428ms +ok 3 - test/tap/configuration-inheritance-test.js # time=154.428ms # Subtest: test/tap/connect-logger-test.js # Subtest: log4js connect logger @@ -2421,7 +2464,7 @@ # Subtest: should take a log4js logger and return a "connect logger" ok 1 - type is function 1..1 - ok 2 - should take a log4js logger and return a "connect logger" # time=38.25ms + ok 2 - should take a log4js logger and return a "connect logger" # time=5.783ms # Subtest: log events ok 1 - type is Array @@ -2432,13 +2475,13 @@ ok 6 - should match pattern provided ok 7 - should match pattern provided 1..7 - ok 3 - log events # time=51.608ms + ok 3 - log events # time=10.047ms # Subtest: log events with level below logging level ok 1 - type is Array ok 2 - should be equal 1..2 - ok 4 - log events with level below logging level # time=3.238ms + ok 4 - log events with level below logging level # time=2.61ms # Subtest: log events with non-default level and custom format ok 1 - type is Array @@ -2446,7 +2489,7 @@ ok 3 - expect truthy value ok 4 - should be equal 1..4 - ok 5 - log events with non-default level and custom format # time=15.901ms + ok 5 - log events with non-default level and custom format # time=2.831ms # Subtest: adding multiple loggers should only log once ok 1 - type is Array @@ -2454,96 +2497,96 @@ ok 3 - expect truthy value ok 4 - should be equal 1..4 - ok 6 - adding multiple loggers should only log once # time=18.71ms + ok 6 - adding multiple loggers should only log once # time=2.883ms 1..6 - ok 1 - getConnectLoggerModule # time=360.102ms + ok 1 - getConnectLoggerModule # time=76.847ms # Subtest: logger with options as string ok 1 - should be equal 1..1 - ok 2 - logger with options as string # time=2.317ms + ok 2 - logger with options as string # time=1.174ms # Subtest: auto log levels # Subtest: should use INFO for 2xx ok 1 - expect truthy value ok 2 - expect truthy value 1..2 - ok 1 - should use INFO for 2xx # time=2.606ms + ok 1 - should use INFO for 2xx # time=1.748ms # Subtest: should use WARN for 3xx ok 1 - expect truthy value 1..1 - ok 2 - should use WARN for 3xx # time=1.315ms + ok 2 - should use WARN for 3xx # time=1.178ms # Subtest: should use ERROR for 4xx ok 1 - expect truthy value 1..1 - ok 3 - should use ERROR for 4xx # time=1.444ms + ok 3 - should use ERROR for 4xx # time=1.606ms # Subtest: should use ERROR for 5xx ok 1 - expect truthy value 1..1 - ok 4 - should use ERROR for 5xx # time=13.909ms + ok 4 - should use ERROR for 5xx # time=1.105ms 1..4 - ok 3 - auto log levels # time=135.633ms + ok 3 - auto log levels # time=48.319ms # Subtest: logger with status code rules applied # Subtest: should use DEBUG for 2xx ok 1 - expect truthy value ok 2 - expect truthy value 1..2 - ok 1 - should use DEBUG for 2xx # time=14.453ms + ok 1 - should use DEBUG for 2xx # time=1.26ms # Subtest: should use WARN for 3xx, DEBUG for 304 ok 1 - expect truthy value ok 2 - expect truthy value 1..2 - ok 2 - should use WARN for 3xx, DEBUG for 304 # time=1.789ms + ok 2 - should use WARN for 3xx, DEBUG for 304 # time=1.233ms # Subtest: should use ERROR for 4xx ok 1 - expect truthy value 1..1 - ok 3 - should use ERROR for 4xx # time=1.893ms + ok 3 - should use ERROR for 4xx # time=1.302ms # Subtest: should use ERROR for 5xx ok 1 - expect truthy value 1..1 - ok 4 - should use ERROR for 5xx # time=9.861ms + ok 4 - should use ERROR for 5xx # time=1.117ms 1..4 - ok 4 - logger with status code rules applied # time=150.493ms + ok 4 - logger with status code rules applied # time=26.428ms # Subtest: format using a function ok 1 - should be equal 1..1 - ok 5 - format using a function # time=1.579ms + ok 5 - format using a function # time=1.465ms # Subtest: format using a function that also uses tokens ok 1 - should be equal 1..1 - ok 6 - format using a function that also uses tokens # time=10.182ms + ok 6 - format using a function that also uses tokens # time=1.34ms # Subtest: format using a function, but do not log anything if the function returns nothing ok 1 - should be equal 1..1 - ok 7 - format using a function, but do not log anything if the function returns nothing # time=1.354ms + ok 7 - format using a function, but do not log anything if the function returns nothing # time=1.147ms # Subtest: format that includes request headers ok 1 - should be equal 1..1 - ok 8 - format that includes request headers # time=6.106ms + ok 8 - format that includes request headers # time=1.308ms # Subtest: format that includes response headers ok 1 - should be equal 1..1 - ok 9 - format that includes response headers # time=10.22ms + ok 9 - format that includes response headers # time=1.352ms # Subtest: url token should check originalUrl and url ok 1 - should be equal 1..1 - ok 10 - url token should check originalUrl and url # time=1.524ms + ok 10 - url token should check originalUrl and url # time=1.2ms # Subtest: log events with custom token ok 1 - type is Array @@ -2551,7 +2594,7 @@ ok 3 - expect truthy value ok 4 - should be equal 1..4 - ok 11 - log events with custom token # time=10.706ms + ok 11 - log events with custom token # time=2.046ms # Subtest: log events with custom override token ok 1 - type is Array @@ -2559,32 +2602,32 @@ ok 3 - expect truthy value ok 4 - should be equal 1..4 - ok 12 - log events with custom override token # time=7.291ms + ok 12 - log events with custom override token # time=1.863ms # Subtest: log events with custom format ok 1 - expect truthy value ok 2 - should be equal 1..2 - ok 13 - log events with custom format # time=6.753ms + ok 13 - log events with custom format # time=1.718ms # Subtest: handle weird old node versions where socket contains socket ok 1 - should be equal 1..1 - ok 14 - handle weird old node versions where socket contains socket # time=9.965ms + ok 14 - handle weird old node versions where socket contains socket # time=1.215ms # Subtest: handles as soon as any of the events end/finish/error/close triggers (only once) ok 1 - should be equal ok 2 - should be equal ok 3 - should be equal 1..3 - ok 15 - handles as soon as any of the events end/finish/error/close triggers (only once) # time=15.505ms + ok 15 - handles as soon as any of the events end/finish/error/close triggers (only once) # time=1.634ms 1..15 - ok 1 - log4js connect logger # time=1156.022ms + ok 1 - log4js connect logger # time=255.726ms 1..1 - # time=1222.798ms -ok 4 - test/tap/connect-logger-test.js # time=1222.798ms + # time=262.379ms +ok 4 - test/tap/connect-logger-test.js # time=262.379ms # Subtest: test/tap/disable-cluster-test.js # Subtest: cluster worker @@ -2595,13 +2638,13 @@ ok 4 - type is Error ok 5 - should match pattern provided 1..5 - ok 1 - should send events to its own appender # time=66.036ms + ok 1 - should send events to its own appender # time=13.032ms 1..1 - ok 1 - cluster worker # time=180.095ms + ok 1 - cluster worker # time=36.225ms 1..1 - # time=304.079ms + # time=63.008ms # Subtest: cluster master # Subtest: only master events should be logged # Subtest @@ -2611,38 +2654,38 @@ ok 3 - should be equal ok 4 - should be equal 1..4 - ok 1 - only master events should be logged # time=48.3ms + ok 1 - only master events should be logged # time=8.096ms 1..1 - ok 1 - cluster master # time=176.409ms + ok 1 - cluster master # time=27.619ms 1..1 - # time=226.523ms -ok 5 - test/tap/disable-cluster-test.js # time=226.523ms + # time=56.476ms +ok 5 - test/tap/disable-cluster-test.js # time=56.476ms # Subtest: test/tap/file-descriptor-leak-test.js # Subtest: multiple log4js configure fd leak test # Subtest: initial log4js configure to increase file descriptor count ok 1 - file descriptor count should increase by 11 after 1st configure() call 1..1 - ok 1 - initial log4js configure to increase file descriptor count # time=331.828ms + ok 1 - initial log4js configure to increase file descriptor count # time=238.445ms # Subtest: repeated log4js configure to not increase file descriptor count ok 1 - file descriptor count should be identical after repeated configure() calls 1..1 - ok 2 - repeated log4js configure to not increase file descriptor count # time=295.372ms + ok 2 - repeated log4js configure to not increase file descriptor count # time=226.715ms # Subtest: file descriptor count should return back to initial count ok 1 - file descriptor count should be back to initial 1..1 - ok 3 - file descriptor count should return back to initial count # time=222.764ms + ok 3 - file descriptor count should return back to initial count # time=203.733ms 1..3 - ok 1 - multiple log4js configure fd leak test # time=935.11ms + ok 1 - multiple log4js configure fd leak test # time=698.917ms 1..1 - # time=976.47ms -ok 6 - test/tap/file-descriptor-leak-test.js # time=976.47ms + # time=713.627ms +ok 6 - test/tap/file-descriptor-leak-test.js # time=713.627ms # Subtest: test/tap/layouts-test.js # Subtest: log4js layouts @@ -2650,15 +2693,15 @@ # Subtest: should apply level colour codes to output ok 1 - should be equal 1..1 - ok 1 - should apply level colour codes to output # time=34.953ms + ok 1 - should apply level colour codes to output # time=11.071ms # Subtest: should support the console.log format for the message ok 1 - should be equal 1..1 - ok 2 - should support the console.log format for the message # time=25.91ms + ok 2 - should support the console.log format for the message # time=3.048ms 1..2 - ok 1 - colouredLayout # time=162.852ms + ok 1 - colouredLayout # time=43.796ms # Subtest: messagePassThroughLayout ok 1 - should take a logevent and output only the message @@ -2670,10 +2713,10 @@ ok 2 - should print error augmented string attributes ok 3 - should print error augmented object attributes 1..3 - ok 5 - with passed augmented errors # time=18.101ms + ok 5 - with passed augmented errors # time=6.441ms 1..5 - ok 2 - messagePassThroughLayout # time=81.797ms + ok 2 - messagePassThroughLayout # time=26.989ms # Subtest: basicLayout ok 1 - should be equal @@ -2691,75 +2734,75 @@ ok 11 - should be equal ok 12 - should be equal 1..12 - ok 2 - should output a stacktrace, message if the event has an error attached # time=24.98ms + ok 2 - should output a stacktrace, message if the event has an error attached # time=7.038ms # Subtest: should output any extra data in the log event as util.inspect strings ok 1 - should be equal 1..1 - ok 3 - should output any extra data in the log event as util.inspect strings # time=7.6ms + ok 3 - should output any extra data in the log event as util.inspect strings # time=2.273ms 1..3 - ok 3 - basicLayout # time=86.859ms + ok 3 - basicLayout # time=30.604ms # Subtest: dummyLayout # Subtest: should output just the first element of the log data ok 1 - should be equal 1..1 - ok 1 - should output just the first element of the log data # time=2.388ms + ok 1 - should output just the first element of the log data # time=1.223ms 1..1 - ok 4 - dummyLayout # time=24.744ms + ok 4 - dummyLayout # time=7.46ms # Subtest: patternLayout # Subtest: should default to "time logLevel loggerName - message" ok 1 - should be equal 1..1 - ok 1 - should default to "time logLevel loggerName - message" # time=4.566ms + ok 1 - should default to "time logLevel loggerName - message" # time=3.019ms # Subtest: %r should output time only ok 1 - should be equal 1..1 - ok 2 - %r should output time only # time=6.933ms + ok 2 - %r should output time only # time=1.664ms # Subtest: %p should output the log level ok 1 - should be equal 1..1 - ok 3 - %p should output the log level # time=1.411ms + ok 3 - %p should output the log level # time=1.136ms # Subtest: %c should output the log category ok 1 - should be equal 1..1 - ok 4 - %c should output the log category # time=5.992ms + ok 4 - %c should output the log category # time=1.167ms # Subtest: %m should output the log data ok 1 - should be equal 1..1 - ok 5 - %m should output the log data # time=1.807ms + ok 5 - %m should output the log data # time=1.206ms # Subtest: %n should output a new line ok 1 - should be equal 1..1 - ok 6 - %n should output a new line # time=5.87ms + ok 6 - %n should output a new line # time=1.212ms # Subtest: %h should output hostname ok 1 - should be equal 1..1 - ok 7 - %h should output hostname # time=6.827ms + ok 7 - %h should output hostname # time=1.463ms # Subtest: %z should output pid ok 1 - should be equal 1..1 - ok 8 - %z should output pid # time=2.266ms + ok 8 - %z should output pid # time=1.681ms # Subtest: %z should pick up pid from log event if present ok 1 - should be equal 1..1 - ok 9 - %z should pick up pid from log event if present # time=10.729ms + ok 9 - %z should pick up pid from log event if present # time=1.301ms # Subtest: %y should output pid (was cluster info) ok 1 - should be equal 1..1 - ok 10 - %y should output pid (was cluster info) # time=1.963ms + ok 10 - %y should output pid (was cluster info) # time=1.5ms # Subtest: %c should handle category names like java-style package names ok 1 - should be equal @@ -2769,12 +2812,12 @@ ok 5 - should be equal ok 6 - should be equal 1..6 - ok 11 - %c should handle category names like java-style package names # time=15.362ms + ok 11 - %c should handle category names like java-style package names # time=3.305ms # Subtest: %d should output the date in ISO8601 format ok 1 - should be equal 1..1 - ok 12 - %d should output the date in ISO8601 format # time=2.236ms + ok 12 - %d should output the date in ISO8601 format # time=1.916ms # Subtest: %d should allow for format specification ok 1 - should be equal @@ -2789,17 +2832,17 @@ ok 10 - should be equal ok 11 - should be equal 1..11 - ok 13 - %d should allow for format specification # time=36.926ms + ok 13 - %d should allow for format specification # time=7.328ms # Subtest: %% should output % ok 1 - should be equal 1..1 - ok 14 - %% should output % # time=14.936ms + ok 14 - %% should output % # time=1.512ms # Subtest: %f should output filename ok 1 - should be equal 1..1 - ok 15 - %f should output filename # time=10.873ms + ok 15 - %f should output filename # time=1.592ms # Subtest: %f should handle filename depth ok 1 - should be equal @@ -2809,7 +2852,7 @@ ok 5 - should be equal ok 6 - should be equal 1..6 - ok 16 - %f should handle filename depth # time=9.198ms + ok 16 - %f should handle filename depth # time=3.441ms # Subtest: %f should accept truncation and padding ok 1 - should be equal @@ -2817,12 +2860,12 @@ ok 3 - should be equal ok 4 - should be equal 1..4 - ok 17 - %f should accept truncation and padding # time=7.637ms + ok 17 - %f should accept truncation and padding # time=2.858ms # Subtest: %l should output line number ok 1 - should be equal 1..1 - ok 18 - %l should output line number # time=10.955ms + ok 18 - %l should output line number # time=1.496ms # Subtest: %l should accept truncation and padding ok 1 - should be equal @@ -2830,12 +2873,12 @@ ok 3 - should be equal ok 4 - should be equal 1..4 - ok 19 - %l should accept truncation and padding # time=25.814ms + ok 19 - %l should accept truncation and padding # time=2.332ms # Subtest: %o should output column postion ok 1 - should be equal 1..1 - ok 20 - %o should output column postion # time=15.037ms + ok 20 - %o should output column postion # time=1.242ms # Subtest: %o should accept truncation and padding ok 1 - should be equal @@ -2844,48 +2887,48 @@ ok 4 - should be equal ok 5 - should be equal 1..5 - ok 21 - %o should accept truncation and padding # time=2.334ms + ok 21 - %o should accept truncation and padding # time=2.25ms # Subtest: %s should output stack ok 1 - should be equal 1..1 - ok 22 - %s should output stack # time=10.532ms + ok 22 - %s should output stack # time=1.117ms # Subtest: %f should output empty string when fileName not exist ok 1 - should be equal 1..1 - ok 23 - %f should output empty string when fileName not exist # time=1.427ms + ok 23 - %f should output empty string when fileName not exist # time=1.091ms # Subtest: %l should output empty string when lineNumber not exist ok 1 - should be equal 1..1 - ok 24 - %l should output empty string when lineNumber not exist # time=1.567ms + ok 24 - %l should output empty string when lineNumber not exist # time=1.172ms # Subtest: %o should output empty string when columnNumber not exist ok 1 - should be equal 1..1 - ok 25 - %o should output empty string when columnNumber not exist # time=2.286ms + ok 25 - %o should output empty string when columnNumber not exist # time=1.148ms # Subtest: %s should output empty string when callStack not exist ok 1 - should be equal 1..1 - ok 26 - %s should output empty string when callStack not exist # time=14.502ms + ok 26 - %s should output empty string when callStack not exist # time=1.249ms # Subtest: should output anything not preceded by % as literal ok 1 - should be equal 1..1 - ok 27 - should output anything not preceded by % as literal # time=1.733ms + ok 27 - should output anything not preceded by % as literal # time=1.144ms # Subtest: should output the original string if no replacer matches the token ok 1 - should be equal 1..1 - ok 28 - should output the original string if no replacer matches the token # time=10.219ms + ok 28 - should output the original string if no replacer matches the token # time=1.084ms # Subtest: should handle complicated patterns ok 1 - should be equal ok 2 - should be equal 1..2 - ok 29 - should handle complicated patterns # time=11.321ms + ok 29 - should handle complicated patterns # time=10.435ms # Subtest: should truncate fields if specified ok 1 - should be equal @@ -2895,7 +2938,7 @@ ok 5 - should be equal ok 6 - should be equal 1..6 - ok 30 - should truncate fields if specified # time=8.214ms + ok 30 - should truncate fields if specified # time=2.68ms # Subtest: should pad fields if specified ok 1 - should be equal @@ -2907,105 +2950,105 @@ ok 7 - should be equal ok 8 - should be equal 1..8 - ok 31 - should pad fields if specified # time=16.163ms + ok 31 - should pad fields if specified # time=3.657ms # Subtest: %[%r%] should output colored time ok 1 - should be equal 1..1 - ok 32 - %[%r%] should output colored time # time=10.217ms + ok 32 - %[%r%] should output colored time # time=1.394ms # Subtest: %x{testString} should output the string stored in tokens ok 1 - should be equal 1..1 - ok 33 - %x{testString} should output the string stored in tokens # time=1.583ms + ok 33 - %x{testString} should output the string stored in tokens # time=1.282ms # Subtest: %x{testFunction} should output the result of the function stored in tokens ok 1 - should be equal 1..1 - ok 34 - %x{testFunction} should output the result of the function stored in tokens # time=1.538ms + ok 34 - %x{testFunction} should output the result of the function stored in tokens # time=1.18ms # Subtest: %x{doesNotExist} should output the string stored in tokens ok 1 - should be equal 1..1 - ok 35 - %x{doesNotExist} should output the string stored in tokens # time=14.18ms + ok 35 - %x{doesNotExist} should output the string stored in tokens # time=1.162ms # Subtest: %x{fnThatUsesLogEvent} should be able to use the logEvent ok 1 - should be equal 1..1 - ok 36 - %x{fnThatUsesLogEvent} should be able to use the logEvent # time=10.526ms + ok 36 - %x{fnThatUsesLogEvent} should be able to use the logEvent # time=1.276ms # Subtest: %x should output the string stored in tokens ok 1 - should be equal 1..1 - ok 37 - %x should output the string stored in tokens # time=1.452ms + ok 37 - %x should output the string stored in tokens # time=1.186ms # Subtest: %X{testString} should output the string stored in tokens ok 1 - should be equal 1..1 - ok 38 - %X{testString} should output the string stored in tokens # time=15.493ms + ok 38 - %X{testString} should output the string stored in tokens # time=1.292ms # Subtest: %X{testFunction} should output the result of the function stored in tokens ok 1 - should be equal 1..1 - ok 39 - %X{testFunction} should output the result of the function stored in tokens # time=1.518ms + ok 39 - %X{testFunction} should output the result of the function stored in tokens # time=1.244ms # Subtest: %X{doesNotExist} should output the string stored in tokens ok 1 - should be equal 1..1 - ok 40 - %X{doesNotExist} should output the string stored in tokens # time=14.575ms + ok 40 - %X{doesNotExist} should output the string stored in tokens # time=1.093ms # Subtest: %X{fnThatUsesLogEvent} should be able to use the logEvent ok 1 - should be equal 1..1 - ok 41 - %X{fnThatUsesLogEvent} should be able to use the logEvent # time=1.61ms + ok 41 - %X{fnThatUsesLogEvent} should be able to use the logEvent # time=1.186ms # Subtest: %X should output the string stored in tokens ok 1 - should be equal 1..1 - ok 42 - %X should output the string stored in tokens # time=14.251ms + ok 42 - %X should output the string stored in tokens # time=1.102ms # Subtest: %M should output function name ok 1 - should be equal 1..1 - ok 43 - %M should output function name # time=14.782ms + ok 43 - %M should output function name # time=1.161ms # Subtest: %M should output empty string when functionName not exist ok 1 - should be equal 1..1 - ok 44 - %M should output empty string when functionName not exist # time=14.23ms + ok 44 - %M should output empty string when functionName not exist # time=1.075ms # Subtest: %C should output class name ok 1 - should be equal 1..1 - ok 45 - %C should output class name # time=14.223ms + ok 45 - %C should output class name # time=1.136ms # Subtest: %C should output empty string when className not exist ok 1 - should be equal 1..1 - ok 46 - %C should output empty string when className not exist # time=1.686ms + ok 46 - %C should output empty string when className not exist # time=1.161ms # Subtest: %A should output function alias ok 1 - should be equal 1..1 - ok 47 - %A should output function alias # time=2.101ms + ok 47 - %A should output function alias # time=1.266ms # Subtest: %A should output empty string when functionAlias not exist ok 1 - should be equal 1..1 - ok 48 - %A should output empty string when functionAlias not exist # time=14.542ms + ok 48 - %A should output empty string when functionAlias not exist # time=1.183ms # Subtest: %F should output fully qualified caller name ok 1 - should be equal 1..1 - ok 49 - %F should output fully qualified caller name # time=1.86ms + ok 49 - %F should output fully qualified caller name # time=1.332ms # Subtest: %F should output empty string when callerName not exist ok 1 - should be equal 1..1 - ok 50 - %F should output empty string when callerName not exist # time=18.907ms + ok 50 - %F should output empty string when callerName not exist # time=1.269ms 1..50 - ok 5 - patternLayout # time=1762.904ms + ok 5 - patternLayout # time=400.758ms # Subtest: layout makers # Subtest: should have a maker for each layout @@ -3016,16 +3059,16 @@ ok 5 - expect truthy value ok 6 - expect truthy value 1..6 - ok 1 - should have a maker for each layout # time=22.01ms + ok 1 - should have a maker for each layout # time=3.544ms # Subtest: layout pattern maker should pass pattern and tokens to layout from config ok 1 - should be equal ok 2 - should be equal 1..2 - ok 2 - layout pattern maker should pass pattern and tokens to layout from config # time=14.748ms + ok 2 - layout pattern maker should pass pattern and tokens to layout from config # time=1.766ms 1..2 - ok 6 - layout makers # time=99.053ms + ok 6 - layout makers # time=18.279ms # Subtest: add layout # Subtest: should be able to add a layout @@ -3033,17 +3076,17 @@ ok 2 - expect truthy value ok 3 - should be equal 1..3 - ok 1 - should be able to add a layout # time=29.851ms + ok 1 - should be able to add a layout # time=1.999ms 1..1 - ok 7 - add layout # time=59.184ms + ok 7 - add layout # time=8.212ms 1..7 - ok 1 - log4js layouts # time=2563.559ms + ok 1 - log4js layouts # time=596.268ms 1..1 - # time=2678.483ms -ok 7 - test/tap/layouts-test.js # time=2678.483ms + # time=615.937ms +ok 7 - test/tap/layouts-test.js # time=615.937ms # Subtest: test/tap/levels-before-configure-test.js # Subtest: Accessing things setup in configure before configure is called @@ -3051,14 +3094,14 @@ ok 1 - expect truthy value ok 2 - expect truthy value 1..2 - ok 1 - should work # time=672.624ms + ok 1 - should work # time=111.525ms 1..1 - ok 1 - Accessing things setup in configure before configure is called # time=794.211ms + ok 1 - Accessing things setup in configure before configure is called # time=138.801ms 1..1 - # time=926.996ms -ok 8 - test/tap/levels-before-configure-test.js # time=926.996ms + # time=164.072ms +ok 8 - test/tap/levels-before-configure-test.js # time=164.072ms # Subtest: test/tap/levels-test.js # Subtest: levels @@ -3074,7 +3117,7 @@ ok 8 - expect truthy value ok 9 - expect truthy value 1..9 - ok 1 - should define some levels # time=39.368ms + ok 1 - should define some levels # time=13.187ms # Subtest: ALL ok 1 - expect truthy value @@ -3104,7 +3147,7 @@ ok 25 - expect falsey value ok 26 - expect falsey value 1..26 - ok 2 - ALL # time=33.842ms + ok 2 - ALL # time=9.57ms # Subtest: TRACE ok 1 - expect truthy value @@ -3134,7 +3177,7 @@ ok 25 - expect falsey value ok 26 - expect falsey value 1..26 - ok 3 - TRACE # time=34.846ms + ok 3 - TRACE # time=7.561ms # Subtest: DEBUG ok 1 - expect truthy value @@ -3163,7 +3206,7 @@ ok 24 - expect falsey value ok 25 - expect falsey value 1..25 - ok 4 - DEBUG # time=15.054ms + ok 4 - DEBUG # time=6.367ms # Subtest: INFO ok 1 - expect truthy value @@ -3192,7 +3235,7 @@ ok 24 - expect falsey value ok 25 - expect falsey value 1..25 - ok 5 - INFO # time=19.832ms + ok 5 - INFO # time=5.967ms # Subtest: WARN ok 1 - expect truthy value @@ -3220,7 +3263,7 @@ ok 23 - expect falsey value ok 24 - expect falsey value 1..24 - ok 6 - WARN # time=19.451ms + ok 6 - WARN # time=7.99ms # Subtest: ERROR ok 1 - expect truthy value @@ -3249,7 +3292,7 @@ ok 24 - expect falsey value ok 25 - expect falsey value 1..25 - ok 7 - ERROR # time=46.565ms + ok 7 - ERROR # time=22.036ms # Subtest: FATAL ok 1 - expect truthy value @@ -3278,7 +3321,7 @@ ok 24 - expect falsey value ok 25 - expect falsey value 1..25 - ok 8 - FATAL # time=14.443ms + ok 8 - FATAL # time=7.446ms # Subtest: MARK ok 1 - expect truthy value @@ -3307,7 +3350,7 @@ ok 24 - expect falsey value ok 25 - expect falsey value 1..25 - ok 9 - MARK # time=18.824ms + ok 9 - MARK # time=5.651ms # Subtest: OFF ok 1 - expect falsey value @@ -3336,10 +3379,10 @@ ok 24 - expect falsey value ok 25 - expect falsey value 1..25 - ok 10 - OFF # time=18.445ms + ok 10 - OFF # time=7.525ms 1..10 - ok 1 - values # time=503.619ms + ok 1 - values # time=173.303ms # Subtest: isGreaterThanOrEqualTo ok 1 - expect truthy value @@ -3351,7 +3394,7 @@ ok 7 - expect falsey value ok 8 - expect falsey value 1..8 - ok 2 - isGreaterThanOrEqualTo # time=9.89ms + ok 2 - isGreaterThanOrEqualTo # time=2.511ms # Subtest: isLessThanOrEqualTo ok 1 - expect falsey value @@ -3363,14 +3406,14 @@ ok 7 - expect truthy value ok 8 - expect truthy value 1..8 - ok 3 - isLessThanOrEqualTo # time=2.17ms + ok 3 - isLessThanOrEqualTo # time=2.406ms # Subtest: isEqualTo ok 1 - expect truthy value ok 2 - expect truthy value ok 3 - expect truthy value 1..3 - ok 4 - isEqualTo # time=1.271ms + ok 4 - isEqualTo # time=1.388ms # Subtest: getLevel ok 1 - should be equal @@ -3380,14 +3423,14 @@ ok 5 - should be equal ok 6 - should be equal 1..6 - ok 5 - getLevel # time=2.253ms + ok 5 - getLevel # time=2.314ms 1..5 - ok 1 - levels # time=629.605ms + ok 1 - levels # time=218.105ms 1..1 - # time=655.219ms -ok 9 - test/tap/levels-test.js # time=655.219ms + # time=226.052ms +ok 9 - test/tap/levels-test.js # time=226.052ms # Subtest: test/tap/logLevelFilter-test.js # Subtest: log4js logLevelFilter @@ -3397,36 +3440,36 @@ ok 2 - should be equal ok 3 - should be equal 1..3 - ok 1 - should only pass log events greater than or equal to its own level # time=66.959ms + ok 1 - should only pass log events greater than or equal to its own level # time=11.119ms 1..1 - ok 1 - appender # time=648.627ms + ok 1 - appender # time=131.839ms # Subtest: configure # Subtest: logLevelFilter.log should contain all log messages ok 1 - should be equivalent 1..1 - ok 1 - logLevelFilter.log should contain all log messages # time=97.999ms + ok 1 - logLevelFilter.log should contain all log messages # time=14.65ms # Subtest: logLevelFilter-warnings.log should contain only error and warning logs ok 1 - should be equivalent 1..1 - ok 2 - logLevelFilter-warnings.log should contain only error and warning logs # time=21.964ms + ok 2 - logLevelFilter-warnings.log should contain only error and warning logs # time=12.881ms # Subtest: logLevelFilter-debugs.log should contain only trace and debug logs ok 1 - should be equivalent 1..1 - ok 3 - logLevelFilter-debugs.log should contain only trace and debug logs # time=27.462ms + ok 3 - logLevelFilter-debugs.log should contain only trace and debug logs # time=4.113ms 1..3 - ok 2 - configure # time=468.692ms + ok 2 - configure # time=270.283ms 1..2 - ok 1 - log4js logLevelFilter # time=1264.336ms + ok 1 - log4js logLevelFilter # time=430.401ms 1..1 - # time=1306.06ms -ok 10 - test/tap/logLevelFilter-test.js # time=1306.06ms + # time=436.381ms +ok 10 - test/tap/logLevelFilter-test.js # time=436.381ms # Subtest: test/tap/pause-test.js # Subtest: Drain event test @@ -3434,20 +3477,20 @@ ok 1 - log4js:pause, true ok 2 - log4js:pause, false 1..2 - ok 1 - Should emit pause event and resume when logging in a file with high frequency # time=677.731ms + ok 1 - Should emit pause event and resume when logging in a file with high frequency # time=79.561ms # Subtest: Should emit pause event and resume when logging in a date file with high frequency ok 1 - log4js:pause, true ok 2 - log4js:pause, false 1..2 - ok 2 - Should emit pause event and resume when logging in a date file with high frequency # time=389.274ms + ok 2 - Should emit pause event and resume when logging in a date file with high frequency # time=18.732ms 1..2 - ok 1 - Drain event test # time=1191.869ms + ok 1 - Drain event test # time=126.997ms 1..1 - # time=1209.279ms -ok 11 - test/tap/pause-test.js # time=1209.279ms + # time=134.285ms +ok 11 - test/tap/pause-test.js # time=134.285ms # Subtest: test/tap/pm2-support-test.js # Subtest: PM2 Support @@ -3455,26 +3498,26 @@ ok 1 - expect falsey value ok 2 - expect falsey value 1..2 - ok 1 - should not get any events when turned off # time=32.237ms + ok 1 - should not get any events when turned off # time=6.276ms # Subtest: should get events on app instance 0 ok 1 - should be equal ok 2 - should be equal ok 3 - should be equal 1..3 - ok 2 - should get events on app instance 0 # time=10.576ms + ok 2 - should get events on app instance 0 # time=2.931ms # Subtest: should not get events on app instance 1 ok 1 - should be equal 1..1 - ok 3 - should not get events on app instance 1 # time=3.938ms + ok 3 - should not get events on app instance 1 # time=1.594ms 1..3 - ok 1 - PM2 Support # time=228.174ms + ok 1 - PM2 Support # time=42.481ms 1..1 - # time=316.442ms -ok 12 - test/tap/pm2-support-test.js # time=316.442ms + # time=61.994ms +ok 12 - test/tap/pm2-support-test.js # time=61.994ms # Subtest: test/tap/recordingAppender-test.js # Subtest: recording appender @@ -3483,11 +3526,11 @@ ok 3 - should be equal ok 4 - There should be 0 recorded events 1..4 - ok 1 - recording appender # time=81.465ms + ok 1 - recording appender # time=15.916ms 1..1 - # time=179.942ms -ok 13 - test/tap/recordingAppender-test.js # time=179.942ms + # time=40.578ms +ok 13 - test/tap/recordingAppender-test.js # time=40.578ms # Subtest: test/tap/server-test.js # Subtest: TCP Server @@ -3498,7 +3541,7 @@ ok 4 - should match pattern provided ok 5 - should match pattern provided 1..5 - ok 1 - should listen for TCP messages and re-send via process.send # time=356.27ms + ok 1 - should listen for TCP messages and re-send via process.send # time=244.486ms # Subtest: sending incomplete messages in chunks ok 1 - should be equal @@ -3507,14 +3550,14 @@ ok 4 - should match pattern provided ok 5 - should match pattern provided 1..5 - ok 2 - sending incomplete messages in chunks # time=774.666ms + ok 2 - sending incomplete messages in chunks # time=715.632ms 1..2 - ok 1 - TCP Server # time=1193.574ms + ok 1 - TCP Server # time=987.933ms 1..1 - # time=1227.654ms -ok 14 - test/tap/server-test.js # time=1227.654ms + # time=994.791ms +ok 14 - test/tap/server-test.js # time=994.791ms # Subtest: test/tap/setLevel-asymmetry-test.js # Subtest: log4js setLevel @@ -3527,7 +3570,7 @@ ok 5 - should be equal ok 6 - should be equal 1..6 - ok 1 - should convert string to level correctly # time=43.33ms + ok 1 - should convert string to level correctly # time=12.947ms # Subtest: should also accept a Level ok 1 - should be equal @@ -3537,10 +3580,10 @@ ok 5 - should be equal ok 6 - should be equal 1..6 - ok 2 - should also accept a Level # time=9.813ms + ok 2 - should also accept a Level # time=5.947ms 1..2 - ok 1 - is called with a Trace as string # time=148.678ms + ok 1 - is called with a Trace as string # time=42.761ms # Subtest: is called with a Debug as string # Subtest: should convert string to level correctly @@ -3551,7 +3594,7 @@ ok 5 - should be equal ok 6 - should be equal 1..6 - ok 1 - should convert string to level correctly # time=3.826ms + ok 1 - should convert string to level correctly # time=3.351ms # Subtest: should also accept a Level ok 1 - should be equal @@ -3561,10 +3604,10 @@ ok 5 - should be equal ok 6 - should be equal 1..6 - ok 2 - should also accept a Level # time=11.587ms + ok 2 - should also accept a Level # time=3.19ms 1..2 - ok 2 - is called with a Debug as string # time=93.402ms + ok 2 - is called with a Debug as string # time=20.259ms # Subtest: is called with a Info as string # Subtest: should convert string to level correctly @@ -3575,7 +3618,7 @@ ok 5 - should be equal ok 6 - should be equal 1..6 - ok 1 - should convert string to level correctly # time=11.398ms + ok 1 - should convert string to level correctly # time=2.952ms # Subtest: should also accept a Level ok 1 - should be equal @@ -3585,10 +3628,10 @@ ok 5 - should be equal ok 6 - should be equal 1..6 - ok 2 - should also accept a Level # time=2.93ms + ok 2 - should also accept a Level # time=3.011ms 1..2 - ok 3 - is called with a Info as string # time=53.358ms + ok 3 - is called with a Info as string # time=19.18ms # Subtest: is called with a Warn as string # Subtest: should convert string to level correctly @@ -3599,7 +3642,7 @@ ok 5 - should be equal ok 6 - should be equal 1..6 - ok 1 - should convert string to level correctly # time=14.671ms + ok 1 - should convert string to level correctly # time=2.796ms # Subtest: should also accept a Level ok 1 - should be equal @@ -3609,10 +3652,10 @@ ok 5 - should be equal ok 6 - should be equal 1..6 - ok 2 - should also accept a Level # time=11.72ms + ok 2 - should also accept a Level # time=2.844ms 1..2 - ok 4 - is called with a Warn as string # time=63.361ms + ok 4 - is called with a Warn as string # time=20.068ms # Subtest: is called with a Error as string # Subtest: should convert string to level correctly @@ -3623,7 +3666,7 @@ ok 5 - should be equal ok 6 - should be equal 1..6 - ok 1 - should convert string to level correctly # time=11.766ms + ok 1 - should convert string to level correctly # time=3.04ms # Subtest: should also accept a Level ok 1 - should be equal @@ -3633,10 +3676,10 @@ ok 5 - should be equal ok 6 - should be equal 1..6 - ok 2 - should also accept a Level # time=3.094ms + ok 2 - should also accept a Level # time=2.898ms 1..2 - ok 5 - is called with a Error as string # time=53.984ms + ok 5 - is called with a Error as string # time=18.915ms # Subtest: is called with a Fatal as string # Subtest: should convert string to level correctly @@ -3647,7 +3690,7 @@ ok 5 - should be equal ok 6 - should be equal 1..6 - ok 1 - should convert string to level correctly # time=2.422ms + ok 1 - should convert string to level correctly # time=2.785ms # Subtest: should also accept a Level ok 1 - should be equal @@ -3657,27 +3700,27 @@ ok 5 - should be equal ok 6 - should be equal 1..6 - ok 2 - should also accept a Level # time=2.768ms + ok 2 - should also accept a Level # time=2.762ms 1..2 - ok 6 - is called with a Fatal as string # time=42.012ms + ok 6 - is called with a Fatal as string # time=16.286ms 1..6 - ok 1 - log4js setLevel # time=622.339ms + ok 1 - log4js setLevel # time=194.422ms 1..1 - # time=664.283ms -ok 15 - test/tap/setLevel-asymmetry-test.js # time=664.283ms + # time=201.929ms +ok 15 - test/tap/setLevel-asymmetry-test.js # time=201.929ms # Subtest: test/tap/stacktraces-test.js # Subtest: Stacktraces from errors in different VM context ok 1 - should match pattern provided 1..1 - ok 1 - Stacktraces from errors in different VM context # time=561.541ms + ok 1 - Stacktraces from errors in different VM context # time=122.723ms 1..1 - # time=671.329ms -ok 16 - test/tap/stacktraces-test.js # time=671.329ms + # time=150.908ms +ok 16 - test/tap/stacktraces-test.js # time=150.908ms # Subtest: test/tap/subcategories-test.js # Subtest: subcategories @@ -3692,10 +3735,10 @@ ok 7 - should be equal ok 8 - should be equal 1..8 - ok 1 - check logger levels # time=50.729ms + ok 1 - check logger levels # time=13.374ms 1..1 - ok 1 - loggers created after levels configuration is loaded # time=125.801ms + ok 1 - loggers created after levels configuration is loaded # time=32.594ms # Subtest: loggers created before levels configuration is loaded # Subtest: should still get new levels @@ -3708,35 +3751,35 @@ ok 7 - should be equivalent ok 8 - should be equivalent 1..8 - ok 1 - should still get new levels # time=25.404ms + ok 1 - should still get new levels # time=7.571ms 1..1 - ok 2 - loggers created before levels configuration is loaded # time=93.281ms + ok 2 - loggers created before levels configuration is loaded # time=26.824ms # Subtest: setting level on subcategories should not set parent level # Subtest: should inherit parent level ok 1 - should be equivalent 1..1 - ok 1 - should inherit parent level # time=2.109ms + ok 1 - should inherit parent level # time=1.696ms # Subtest: changing child level should not change parent level ok 1 - should be equivalent ok 2 - should be equivalent 1..2 - ok 2 - changing child level should not change parent level # time=2.337ms + ok 2 - changing child level should not change parent level # time=2.054ms 1..2 - ok 3 - setting level on subcategories should not set parent level # time=55.574ms + ok 3 - setting level on subcategories should not set parent level # time=17.844ms 1..3 - ok 1 - subcategories # time=428.043ms + ok 1 - subcategories # time=113.306ms 1..1 - # time=461.512ms -ok 17 - test/tap/subcategories-test.js # time=461.512ms + # time=121.77ms +ok 17 - test/tap/subcategories-test.js # time=121.77ms 1..17 -# time=17673.299ms +# time=9066.518ms Removing node_modules/log4js create-stamp debian/debhelper-build-stamp dh_prep @@ -3852,12 +3895,12 @@ dh_nodejs_autodocs install -m 644 rfdc/readme.md debian/node-log4js/usr/share/doc//node-rfdc/ ln -s ../node-log4js/copyright debian/node-log4js/usr/share/doc//node-rfdc/ - install -m 644 date-format/README.md debian/node-log4js/usr/share/doc//node-date-format/ - install -m 644 date-format/CHANGELOG.md debian/node-log4js/usr/share/doc//node-date-format/changelog - ln -s ../node-log4js/copyright debian/node-log4js/usr/share/doc//node-date-format/ install -m 644 streamroller/README.md debian/node-log4js/usr/share/doc//node-streamroller/ install -m 644 streamroller/CHANGELOG.md debian/node-log4js/usr/share/doc//node-streamroller/changelog ln -s ../node-log4js/copyright debian/node-log4js/usr/share/doc//node-streamroller/ + install -m 644 date-format/README.md debian/node-log4js/usr/share/doc//node-date-format/ + install -m 644 date-format/CHANGELOG.md debian/node-log4js/usr/share/doc//node-date-format/changelog + ln -s ../node-log4js/copyright debian/node-log4js/usr/share/doc//node-date-format/ make[1]: Leaving directory '/build/node-log4js-6.7.1+~cs8.4.17' dh_installchangelogs dh_installexamples @@ -3881,12 +3924,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/3664852/tmp/hooks/B01_cleanup starting +I: user script /srv/workspace/pbuilder/3664852/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/3801070 and its subdirectories -I: Current time: Sat Jun 22 01:26:18 -12 2024 -I: pbuilder-time-stamp: 1719062778 +I: removing directory /srv/workspace/pbuilder/3664852 and its subdirectories +I: Current time: Sun May 21 21:05:28 +14 2023 +I: pbuilder-time-stamp: 1684652728