Diff of the two buildlogs: -- --- b1/build.log 2019-06-09 12:28:06.274915925 +0000 +++ b2/build.log 2019-06-09 12:28:48.036968832 +0000 @@ -1,6 +1,6 @@ I: pbuilder: network access will be disabled during build -I: Current time: Sun Jun 9 00:09:28 -12 2019 -I: pbuilder-time-stamp: 1560082168 +I: Current time: Sun Jul 12 08:51:07 +14 2020 +I: pbuilder-time-stamp: 1594493467 I: Building the build Environment I: extracting base tarball [/var/cache/pbuilder/buster-reproducible-base.tgz] I: copying local configuration @@ -18,7 +18,7 @@ I: Extracting source gpgv: unknown type of key resource 'trustedkeys.kbx' gpgv: keyblock resource '/root/.gnupg/trustedkeys.kbx': General error -gpgv: Signature made Mon Feb 11 23:20:16 2019 -12 +gpgv: Signature made Wed Feb 13 01:20:16 2019 +14 gpgv: using RSA key 50BC7CF939D20C272A6B065652B6BBD953968D1B gpgv: Can't check signature: No public key dpkg-source: warning: failed to verify signature on ./golang-logrus_1.3.0-1.dsc @@ -27,6 +27,18 @@ dpkg-source: info: unpacking golang-logrus_1.3.0-1.debian.tar.xz I: using fakeroot in build. I: Installing the build-deps +I: user script /srv/workspace/pbuilder/23951/tmp/hooks/D01_modify_environment starting +disorder-fs debug: Running on profitbricks-build16-i386. +I: Changing host+domainname to test build reproducibility +I: Adding a custom variable just for the fun of it... +I: Changing /bin/sh to bash +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/23951/tmp/hooks/D01_modify_environment finished -> Attempting to satisfy build-dependencies -> Creating pbuilder-satisfydepends-dummy package Package: pbuilder-satisfydepends-dummy @@ -121,7 +133,7 @@ Get: 47 http://cdn-fastly.deb.debian.org/debian buster/main i386 golang-golang-x-net-dev all 1:0.0+git20181201.351d144+dfsg-3 [637 kB] Get: 48 http://cdn-fastly.deb.debian.org/debian buster/main i386 golang-golang-x-sys-dev all 0.0~git20190412.9773273+really0.0~git20181228.9a3f9b0-1 [291 kB] Get: 49 http://cdn-fastly.deb.debian.org/debian buster/main i386 golang-golang-x-crypto-dev all 1:0.0~git20181203.505ab14-1 [1445 kB] -Fetched 81.4 MB in 1min 12s (1124 kB/s) +Fetched 81.4 MB in 7s (11.1 MB/s) debconf: delaying package configuration, since apt-utils is not installed Selecting previously unselected package libbsd0:i386. (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 19231 files and directories currently installed.) @@ -338,9 +350,41 @@ Building dependency tree... Reading state information... fakeroot is already the newest version (1.23-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, 182 kB of additional disk space will be used. +Get:1 http://cdn-fastly.deb.debian.org/debian buster/main i386 libnumber-compare-perl all 0.03-1 [7642 B] +Get:2 http://cdn-fastly.deb.debian.org/debian buster/main i386 libtext-glob-perl all 0.10-1 [8362 B] +Get:3 http://cdn-fastly.deb.debian.org/debian buster/main i386 libfile-find-rule-perl all 0.34-1 [30.6 kB] +Get:4 http://cdn-fastly.deb.debian.org/debian buster/main i386 usrmerge all 21 [12.8 kB] +debconf: delaying package configuration, since apt-utils is not installed +Fetched 59.5 kB in 1s (78.3 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 ... 34173 files and directories currently installed.) +Preparing to unpack .../libnumber-compare-perl_0.03-1_all.deb ... +Unpacking libnumber-compare-perl (0.03-1) ... +Selecting previously unselected package libtext-glob-perl. +Preparing to unpack .../libtext-glob-perl_0.10-1_all.deb ... +Unpacking libtext-glob-perl (0.10-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_21_all.deb ... +Unpacking usrmerge (21) ... +Setting up libtext-glob-perl (0.10-1) ... +Setting up libnumber-compare-perl (0.03-1) ... +Setting up libfile-find-rule-perl (0.34-1) ... +Setting up usrmerge (21) ... +The system has been successfully converted. +Processing triggers for man-db (2.8.5-2) ... +Not building database; man-db/auto-update is not 'true'. I: Building the package -I: Running cd /build/golang-logrus-1.3.0/ && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games" HOME="/nonexistent/first-build" dpkg-buildpackage -us -uc -b +I: Running cd /build/golang-logrus-1.3.0/ && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/i/capture/the/path" HOME="/nonexistent/second-build" dpkg-buildpackage -us -uc -b dpkg-buildpackage: info: source package golang-logrus dpkg-buildpackage: info: source version 1.3.0-1 dpkg-buildpackage: info: source distribution unstable @@ -358,104 +402,104 @@ dh_autoreconf -O--buildsystem=golang dh_auto_configure -O--buildsystem=golang dh_auto_build -O--buildsystem=golang - cd obj-i686-linux-gnu && go install -gcflags=all=\"-trimpath=/build/golang-logrus-1.3.0/obj-i686-linux-gnu/src\" -asmflags=all=\"-trimpath=/build/golang-logrus-1.3.0/obj-i686-linux-gnu/src\" -v -p 10 github.com/sirupsen/logrus github.com/sirupsen/logrus/hooks/syslog github.com/sirupsen/logrus/hooks/test github.com/sirupsen/logrus/internal/testutils -internal/race -errors + cd obj-i686-linux-gnu && go install -gcflags=all=\"-trimpath=/build/golang-logrus-1.3.0/obj-i686-linux-gnu/src\" -asmflags=all=\"-trimpath=/build/golang-logrus-1.3.0/obj-i686-linux-gnu/src\" -v -p 18 github.com/sirupsen/logrus github.com/sirupsen/logrus/hooks/syslog github.com/sirupsen/logrus/hooks/test github.com/sirupsen/logrus/internal/testutils unicode/utf8 encoding +errors +internal/nettrace +crypto/internal/subtle +unicode/utf16 +crypto/subtle +internal/race +vendor/golang_org/x/crypto/cryptobyte/asn1 +math/bits runtime/internal/atomic +sync/atomic +container/list internal/cpu runtime/internal/sys -sync/atomic unicode -unicode/utf16 -math/bits +runtime/cgo vendor/golang_org/x/net/dns/dnsmessage -internal/nettrace math -runtime/cgo -container/list internal/testlog -crypto/internal/subtle internal/bytealg -crypto/subtle -vendor/golang_org/x/crypto/cryptobyte/asn1 runtime strconv crypto/rc4 sync io -reflect internal/singleflight math/rand +reflect syscall -bytes hash +bytes crypto/cipher crypto/internal/randutil strings -hash/crc32 crypto +hash/crc32 crypto/hmac +crypto/sha1 crypto/sha512 crypto/md5 -crypto/sha1 crypto/sha256 crypto/aes -bufio vendor/golang_org/x/text/transform +bufio path internal/syscall/unix time internal/poll -os encoding/binary sort +os regexp/syntax encoding/base64 +vendor/golang_org/x/crypto/internal/chacha20 crypto/des vendor/golang_org/x/crypto/poly1305 -vendor/golang_org/x/crypto/internal/chacha20 -runtime/debug vendor/golang_org/x/crypto/curve25519 -path/filepath -fmt vendor/golang_org/x/crypto/chacha20poly1305 encoding/pem +path/filepath +runtime/debug +fmt io/ioutil regexp log -encoding/hex context -github.com/pmezard/go-difflib/difflib +encoding/hex compress/flate net/url encoding/json -math/big -vendor/golang_org/x/text/unicode/norm -vendor/golang_org/x/text/unicode/bidi -vendor/golang_org/x/net/http2/hpack -net mime -mime/quotedprintable net/http/internal +vendor/golang_org/x/net/http2/hpack +github.com/pmezard/go-difflib/difflib +mime/quotedprintable +vendor/golang_org/x/text/unicode/norm +math/big flag +vendor/golang_org/x/text/unicode/bidi github.com/davecgh/go-spew/spew -vendor/golang_org/x/text/secure/bidirule runtime/trace +net testing -vendor/golang_org/x/net/idna +vendor/golang_org/x/text/secure/bidirule compress/gzip -crypto/rand -crypto/elliptic +vendor/golang_org/x/net/idna crypto/dsa +crypto/rand encoding/asn1 +crypto/elliptic crypto/rsa -crypto/x509/pkix crypto/ecdsa +crypto/x509/pkix vendor/golang_org/x/crypto/cryptobyte -vendor/golang_org/x/net/http/httpproxy log/syslog +vendor/golang_org/x/net/http/httpproxy net/textproto crypto/x509 golang.org/x/sys/unix @@ -473,11 +517,11 @@ github.com/stretchr/testify/require github.com/sirupsen/logrus/internal/testutils dh_auto_test -O--buildsystem=golang - cd obj-i686-linux-gnu && go test -vet=off -v -p 10 github.com/sirupsen/logrus github.com/sirupsen/logrus/hooks/syslog github.com/sirupsen/logrus/hooks/test github.com/sirupsen/logrus/internal/testutils + cd obj-i686-linux-gnu && go test -vet=off -v -p 18 github.com/sirupsen/logrus github.com/sirupsen/logrus/hooks/syslog github.com/sirupsen/logrus/hooks/test github.com/sirupsen/logrus/internal/testutils === RUN TestRegister --- PASS: TestRegister (0.00s) === RUN TestHandler ---- PASS: TestHandler (4.41s) +--- PASS: TestHandler (0.62s) === RUN TestEntryWithError --- PASS: TestEntryWithError (0.00s) === RUN TestEntryPanicln @@ -519,11 +563,11 @@ === RUN TestJSONEnableTimestamp --- PASS: TestJSONEnableTimestamp (0.00s) === RUN TestFieldValueError -{"level":"info","logrus_error":"can not add field \"func\"","msg":"test","time":"2019-06-09T12:27:56Z"} +{"level":"info","logrus_error":"can not add field \"func\"","msg":"test","time":"2020-07-11T18:51:45Z"} --- PASS: TestFieldValueError (0.00s) === RUN TestNoFieldValueError -{"level":"info","msg":"test","str":"str","time":"2019-06-09T12:27:56Z"} +{"level":"info","msg":"test","str":"str","time":"2020-07-11T18:51:45Z"} --- PASS: TestNoFieldValueError (0.00s) === RUN TestFormatting @@ -677,7 +721,7 @@ === RUN TestNestedLoggingReportsCorrectCaller --- PASS: TestNestedLoggingReportsCorrectCaller (0.00s) === RUN TestCallerReportingOverhead ---- PASS: TestCallerReportingOverhead (0.36s) +--- PASS: TestCallerReportingOverhead (0.09s) === RUN TestConvertLevelToString --- PASS: TestConvertLevelToString (0.00s) === RUN TestParseLevel @@ -685,209 +729,209 @@ === RUN TestGetSetLevelRace --- PASS: TestGetSetLevelRace (0.00s) === RUN TestLoggingRace -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info -time="2019-06-09T12:27:57Z" level=info msg=info ---- PASS: TestLoggingRace (0.01s) +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +time="2020-07-11T18:51:45Z" level=info msg=info +--- PASS: TestLoggingRace (0.00s) === RUN TestLoggingRaceWithHooksOnEntry -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale -time="2019-06-09T12:27:57Z" level=info msg=info context=clue wow=whale ---- PASS: TestLoggingRaceWithHooksOnEntry (0.01s) +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +time="2020-07-11T18:51:45Z" level=info msg=info context=clue wow=whale +--- PASS: TestLoggingRaceWithHooksOnEntry (0.00s) === RUN TestReplaceHooks --- PASS: TestReplaceHooks (0.00s) === RUN TestLogrusInterfaces @@ -897,29 +941,29 @@ === RUN TestLogLevelEnabled --- PASS: TestLogLevelEnabled (0.00s) === RUN TestReportCallerOnTextFormatter -INFO[0004] test file=file func=func -time="2019-06-09T12:27:57Z" level=info msg=test file=file func=func +INFO[0000] test file=file func=func +time="2020-07-11T18:51:45Z" level=info msg=test file=file func=func --- PASS: TestReportCallerOnTextFormatter (0.00s) === RUN Example_basic --- PASS: Example_basic (0.00s) === RUN Example --- PASS: Example (0.00s) PASS -ok github.com/sirupsen/logrus 4.838s +ok github.com/sirupsen/logrus 0.731s === RUN TestLocalhostAddAndPrint -time="2019-06-09T12:27:49Z" level=info msg="Congratulations!" +time="2020-07-11T18:51:44Z" level=info msg="Congratulations!" --- PASS: TestLocalhostAddAndPrint (0.00s) PASS -ok github.com/sirupsen/logrus/hooks/syslog 0.012s +ok github.com/sirupsen/logrus/hooks/syslog 0.003s === RUN TestAllHooks -time="2019-06-09T12:27:50Z" level=error msg="Hello error" +time="2020-07-11T18:51:44Z" level=error msg="Hello error" --- PASS: TestAllHooks (0.00s) === RUN TestLoggingWithHooksRace ---- PASS: TestLoggingWithHooksRace (0.01s) +--- PASS: TestLoggingWithHooksRace (0.00s) === RUN TestFatalWithAlternateExit --- PASS: TestFatalWithAlternateExit (0.00s) PASS -ok github.com/sirupsen/logrus/hooks/test 0.022s +ok github.com/sirupsen/logrus/hooks/test 0.005s ? github.com/sirupsen/logrus/internal/testutils [no test files] create-stamp debian/debhelper-build-stamp fakeroot debian/rules binary @@ -951,12 +995,14 @@ dpkg-source --after-build . dpkg-buildpackage: info: binary-only upload (no source included) I: copying local configuration +I: user script /srv/workspace/pbuilder/23951/tmp/hooks/B01_cleanup starting +I: user script /srv/workspace/pbuilder/23951/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/2057 and its subdirectories -I: Current time: Sun Jun 9 00:28:05 -12 2019 -I: pbuilder-time-stamp: 1560083285 +I: removing directory /srv/workspace/pbuilder/23951 and its subdirectories +I: Current time: Sun Jul 12 08:51:47 +14 2020 +I: pbuilder-time-stamp: 1594493507