Diff of the two buildlogs: -- --- b1/build.log 2024-10-28 23:15:14.743078687 +0000 +++ b2/build.log 2024-10-28 23:18:20.132488588 +0000 @@ -1,6 +1,6 @@ I: pbuilder: network access will be disabled during build -I: Current time: Sun Nov 30 17:35:17 -12 2025 -I: pbuilder-time-stamp: 1764567317 +I: Current time: Tue Oct 29 13:15:17 +14 2024 +I: pbuilder-time-stamp: 1730157317 I: Building the build Environment I: extracting base tarball [/var/cache/pbuilder/trixie-reproducible-base.tgz] I: copying local configuration @@ -30,51 +30,83 @@ dpkg-source: info: applying use-mitchellh-go-ps.patch I: Not using root during the build. I: Installing the build-deps -I: user script /srv/workspace/pbuilder/2737452/tmp/hooks/D02_print_environment starting +I: user script /srv/workspace/pbuilder/1749593/tmp/hooks/D01_modify_environment starting +debug: Running on infom01-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 Oct 28 23:15 /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/1749593/tmp/hooks/D01_modify_environment finished +I: user script /srv/workspace/pbuilder/1749593/tmp/hooks/D02_print_environment starting I: set - BUILDDIR='/build/reproducible-path' - BUILDUSERGECOS='first user,first room,first work-phone,first home-phone,first other' - BUILDUSERNAME='pbuilder1' - BUILD_ARCH='amd64' - DEBIAN_FRONTEND='noninteractive' + 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]="32" [3]="1" [4]="release" [5]="x86_64-pc-linux-gnu") + BASH_VERSION='5.2.32(1)-release' + BUILDDIR=/build/reproducible-path + 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=12 ' - DISTRIBUTION='trixie' - HOME='/root' - HOST_ARCH='amd64' + DIRSTACK=() + DISTRIBUTION=trixie + EUID=0 + FUNCNAME=([0]="Echo" [1]="main") + GROUPS=() + HOME=/root + HOSTNAME=i-capture-the-hostname + HOSTTYPE=x86_64 + HOST_ARCH=amd64 IFS=' ' - INVOCATION_ID='4def5a6dbeb54c179edef1261a990d11' - 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='2737452' - PS1='# ' - PS2='> ' + INVOCATION_ID=0cff1a58398e42f6802cecce82080251 + 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=1749593 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.rl4moaHT/pbuilderrc_9fZb --distribution trixie --hookdir /etc/pbuilder/first-build-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/trixie-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/r-b-build.rl4moaHT/b1 --logfile b1/build.log goss_0.4.9-1.dsc' - SUDO_GID='109' - SUDO_UID='104' - SUDO_USER='jenkins' - TERM='unknown' - TZ='/usr/share/zoneinfo/Etc/GMT+12' - USER='root' - _='/usr/bin/systemd-run' + 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.rl4moaHT/pbuilderrc_nd6a --distribution trixie --hookdir /etc/pbuilder/rebuild-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/trixie-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/r-b-build.rl4moaHT/b2 --logfile b2/build.log goss_0.4.9-1.dsc' + SUDO_GID=109 + SUDO_UID=104 + SUDO_USER=jenkins + TERM=unknown + TZ=/usr/share/zoneinfo/Etc/GMT-14 + UID=0 + USER=root + _='I: set' I: uname -a - Linux infom02-amd64 6.10.11+bpo-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.10.11-1~bpo12+1 (2024-10-03) x86_64 GNU/Linux + Linux i-capture-the-hostname 6.1.0-26-cloud-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.1.112-1 (2024-09-30) x86_64 GNU/Linux I: ls -l /bin - lrwxrwxrwx 1 root root 7 Aug 4 2024 /bin -> usr/bin -I: user script /srv/workspace/pbuilder/2737452/tmp/hooks/D02_print_environment finished + lrwxrwxrwx 1 root root 7 Aug 4 21:30 /bin -> usr/bin +I: user script /srv/workspace/pbuilder/1749593/tmp/hooks/D02_print_environment finished -> Attempting to satisfy build-dependencies -> Creating pbuilder-satisfydepends-dummy package Package: pbuilder-satisfydepends-dummy @@ -277,7 +309,7 @@ Get: 121 http://deb.debian.org/debian trixie/main amd64 golang-github-tidwall-pretty-dev all 1.0.5-1 [9552 B] Get: 122 http://deb.debian.org/debian trixie/main amd64 golang-github-tidwall-gjson-dev all 1.17.1-1 [33.5 kB] Get: 123 http://deb.debian.org/debian trixie/main amd64 golang-gomega-dev all 1.34.2-2 [160 kB] -Fetched 126 MB in 2s (58.5 MB/s) +Fetched 126 MB in 2s (58.3 MB/s) debconf: delaying package configuration, since apt-utils is not installed Selecting previously unselected package golang-golang-x-sys-dev. (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 ... 19947 files and directories currently installed.) @@ -784,7 +816,11 @@ Building tag database... -> Finished parsing the build-deps I: Building the package -I: Running cd /build/reproducible-path/goss-0.4.9/ && 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 > ../goss_0.4.9-1_source.changes +I: user script /srv/workspace/pbuilder/1749593/tmp/hooks/A99_set_merged_usr starting +Not re-configuring usrmerge for trixie +I: user script /srv/workspace/pbuilder/1749593/tmp/hooks/A99_set_merged_usr finished +hostname: Name or service not known +I: Running cd /build/reproducible-path/goss-0.4.9/ && 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 > ../goss_0.4.9-1_source.changes dpkg-buildpackage: info: source package goss dpkg-buildpackage: info: source version 0.4.9-1 dpkg-buildpackage: info: source distribution unstable @@ -803,30 +839,30 @@ dh_auto_configure -O--builddirectory=_build -O--buildsystem=golang dh_auto_build -O--builddirectory=_build -O--buildsystem=golang cd _build && go install -trimpath -v -p 12 github.com/goss-org/goss github.com/goss-org/goss/cmd/goss github.com/goss-org/goss/matchers github.com/goss-org/goss/outputs github.com/goss-org/goss/resource github.com/goss-org/goss/system github.com/goss-org/goss/util -internal/coverage/rtcov -internal/byteorder -internal/goarch internal/unsafeheader -internal/race +internal/profilerecord +internal/goarch +internal/coverage/rtcov internal/goos +internal/byteorder +internal/cpu internal/godebugs +internal/runtime/syscall +internal/race internal/goexperiment -internal/profilerecord internal/runtime/atomic -internal/cpu -internal/runtime/syscall sync/atomic -internal/abi -runtime/internal/math -runtime/internal/sys unicode unicode/utf8 cmp +internal/abi +runtime/internal/math +runtime/internal/sys encoding math/bits -internal/chacha8rand internal/itoa internal/asan +internal/chacha8rand internal/msan unicode/utf16 crypto/internal/alias @@ -836,14 +872,11 @@ internal/nettrace github.com/google/go-cmp/cmp/internal/flags github.com/onsi/gomega/matchers/support/goraph/node -internal/runtime/exithook golang.org/x/net/html/atom -internal/bytealg -math golang.org/x/text/encoding/internal/identifier +github.com/onsi/gomega/matchers/support/goraph/edge golang.org/x/text/internal/utf8internal container/list -github.com/onsi/gomega/matchers/support/goraph/edge vendor/golang.org/x/crypto/internal/alias log/internal golang.org/x/exp/constraints @@ -852,154 +885,155 @@ google.golang.org/protobuf/internal/flags google.golang.org/protobuf/internal/set github.com/klauspost/compress/internal/cpuinfo +internal/runtime/exithook +internal/bytealg +math internal/stringslite -runtime github.com/onsi/gomega/matchers/support/goraph/util github.com/klauspost/compress -iter +runtime internal/reflectlite -internal/weak +iter sync +internal/weak runtime/metrics -slices maps +slices internal/bisect internal/singleflight internal/testlog google.golang.org/protobuf/internal/pragma runtime/cgo errors -sort -io -internal/oserror internal/godebug -crypto/internal/edwards25519/field +internal/oserror path -crypto/internal/nistec/fiat +sort +crypto/internal/edwards25519/field +io strconv -syscall -math/rand/v2 -golang.org/x/text/internal/tag -github.com/tidwall/pretty vendor/golang.org/x/net/dns/dnsmessage -github.com/beorn7/perks/quantile +math/rand/v2 math/rand +syscall +crypto/internal/nistec/fiat crypto/internal/edwards25519 bytes strings hash crypto/internal/randutil internal/concurrent -unique hash/adler32 hash/crc32 -hash/fnv -internal/saferio -crypto +golang.org/x/text/internal/tag reflect -net/netip +crypto +unique encoding/base32 golang.org/x/crypto/blowfish -crypto/rc4 -crypto/cipher crypto/md5 +crypto/cipher +golang.org/x/text/transform regexp/syntax github.com/huandu/xstrings +net/netip html bufio -golang.org/x/text/transform -vendor/golang.org/x/text/transform +golang.org/x/text/encoding crypto/internal/boring +crypto/des +golang.org/x/text/runes crypto/aes crypto/sha512 crypto/hmac crypto/sha1 crypto/sha256 -crypto/des +golang.org/x/text/encoding/internal +crypto/rc4 +golang.org/x/text/encoding/charmap golang.org/x/crypto/pbkdf2 +golang.org/x/text/encoding/japanese +golang.org/x/text/encoding/korean +golang.org/x/text/encoding/simplifiedchinese time internal/syscall/unix internal/syscall/execenv -golang.org/x/text/encoding -golang.org/x/text/runes +regexp +golang.org/x/text/encoding/traditionalchinese +golang.org/x/text/encoding/unicode vendor/golang.org/x/crypto/hkdf +vendor/golang.org/x/text/transform net/http/internal/ascii net/http/internal/testcert +github.com/tidwall/pretty +github.com/beorn7/perks/quantile +hash/fnv github.com/munnerz/goautoneg github.com/hashicorp/logutils -golang.org/x/text/encoding/internal -regexp -golang.org/x/text/encoding/charmap -golang.org/x/text/encoding/korean -golang.org/x/text/encoding/simplifiedchinese -golang.org/x/text/encoding/unicode -golang.org/x/text/encoding/traditionalchinese -golang.org/x/text/encoding/japanese +internal/saferio io/fs context github.com/google/go-cmp/cmp/internal/diff github.com/tidwall/gjson internal/poll +github.com/onsi/gomega/types internal/filepathlite embed -github.com/onsi/gomega/types google.golang.org/protobuf/internal/editiondefaults crypto/internal/nistec os -crypto/ecdh encoding/binary internal/fmtsort github.com/google/go-cmp/cmp/internal/function -fmt -github.com/onsi/gomega/internal/gutil -path/filepath -io/ioutil -vendor/golang.org/x/sys/cpu -github.com/prometheus/procfs/internal/util +encoding/base64 golang.org/x/crypto/scrypt vendor/golang.org/x/crypto/chacha20 -encoding/base64 -golang.org/x/sys/unix -vendor/golang.org/x/crypto/internal/poly1305 github.com/cespare/xxhash -google.golang.org/protobuf/internal/detrand github.com/klauspost/compress/internal/snapref -vendor/golang.org/x/crypto/sha3 -vendor/golang.org/x/crypto/chacha20poly1305 -os/exec +vendor/golang.org/x/crypto/internal/poly1305 +golang.org/x/sys/unix +fmt +path/filepath +github.com/onsi/gomega/internal/gutil +vendor/golang.org/x/sys/cpu encoding/pem -net -encoding/json -math/big -net/url -database/sql/driver +io/ioutil +google.golang.org/protobuf/internal/detrand +github.com/prometheus/procfs/internal/util +crypto/ecdh +os/exec encoding/hex github.com/mitchellh/reflectwalk +net/url github.com/imdario/mergo -text/template/parse encoding/xml +encoding/json +database/sql/driver +text/template/parse +math/big github.com/onsi/gomega/format -github.com/google/go-cmp/cmp/internal/value github.com/mitchellh/copystructure +github.com/google/go-cmp/cmp/internal/value github.com/onsi/gomega/matchers/support/goraph/bipartitegraph golang.org/x/net/html github.com/google/go-cmp/cmp golang.org/x/text/internal/language mime gopkg.in/yaml.v3 -text/template compress/flate -log -vendor/golang.org/x/text/unicode/norm -vendor/golang.org/x/text/unicode/bidi +text/template compress/gzip +golang.org/x/text/internal/language/compact +vendor/golang.org/x/crypto/chacha20poly1305 github.com/Masterminds/semver github.com/blang/semver/v4 +vendor/golang.org/x/crypto/sha3 +golang.org/x/text/language +log +html/template +golang.org/x/text/encoding/htmlindex +vendor/golang.org/x/text/unicode/norm github.com/mattn/go-isatty -vendor/golang.org/x/net/http2/hpack -golang.org/x/text/internal/language/compact -vendor/golang.org/x/text/secure/bidirule -github.com/mattn/go-colorable crypto/dsa crypto/elliptic crypto/internal/bigmod @@ -1007,85 +1041,87 @@ encoding/asn1 crypto/rand github.com/shopspring/decimal -html/template +github.com/spf13/cast +github.com/mattn/go-colorable +golang.org/x/net/html/charset github.com/fatih/color -golang.org/x/text/language +vendor/golang.org/x/text/unicode/bidi crypto/ed25519 github.com/Masterminds/goutils golang.org/x/crypto/bcrypt crypto/internal/hpke crypto/rsa crypto/internal/mlkem768 +vendor/golang.org/x/net/http2/hpack mime/quotedprintable net/http/internal flag github.com/samber/lo -vendor/golang.org/x/net/idna github.com/opencontainers/runc/libcontainer/user github.com/oleiade/reflections golang.org/x/net/bpf -github.com/mitchellh/go-ps -golang.org/x/text/encoding/htmlindex -github.com/goss-org/goss/util -github.com/moby/sys/mountinfo vendor/golang.org/x/crypto/cryptobyte crypto/x509/pkix -os/user +github.com/mitchellh/go-ps +github.com/moby/sys/mountinfo +vendor/golang.org/x/text/secure/bidirule +github.com/goss-org/goss/util github.com/pmezard/go-difflib/difflib -golang.org/x/net/html/charset google.golang.org/protobuf/internal/errors go/token google.golang.org/protobuf/internal/version github.com/prometheus/procfs/internal/fs runtime/debug -github.com/klauspost/compress/fse encoding/gob +google.golang.org/protobuf/encoding/protowire +github.com/klauspost/compress/fse +vendor/golang.org/x/net/idna +crypto/ecdsa github.com/russross/blackfriday/v2 text/tabwriter -crypto/ecdsa -github.com/spf13/cast -google.golang.org/protobuf/encoding/protowire google.golang.org/protobuf/reflect/protoreflect github.com/klauspost/compress/huff0 -github.com/cpuguy83/go-md2man/v2/md2man -github.com/urfave/cli +os/user +net +google.golang.org/protobuf/internal/descfmt google.golang.org/protobuf/internal/descopts google.golang.org/protobuf/internal/strs -google.golang.org/protobuf/internal/descfmt google.golang.org/protobuf/internal/encoding/messageset google.golang.org/protobuf/internal/order -google.golang.org/protobuf/runtime/protoiface google.golang.org/protobuf/internal/genid -github.com/klauspost/compress/zstd -google.golang.org/protobuf/reflect/protoregistry -github.com/patrickmn/go-cache +google.golang.org/protobuf/runtime/protoiface google.golang.org/protobuf/internal/encoding/text +google.golang.org/protobuf/reflect/protoregistry +github.com/cpuguy83/go-md2man/v2/md2man +github.com/urfave/cli google.golang.org/protobuf/proto +github.com/klauspost/compress/zstd google.golang.org/protobuf/internal/encoding/defval -google.golang.org/protobuf/internal/filedesc +github.com/patrickmn/go-cache google.golang.org/protobuf/encoding/prototext +google.golang.org/protobuf/internal/filedesc google.golang.org/protobuf/encoding/protodelim google.golang.org/protobuf/internal/encoding/tag google.golang.org/protobuf/internal/impl -vendor/golang.org/x/net/http/httpproxy +google.golang.org/protobuf/internal/filetype +google.golang.org/protobuf/runtime/protoimpl +google.golang.org/protobuf/types/known/timestamppb +github.com/prometheus/client_model/go +github.com/prometheus/common/model +github.com/prometheus/client_golang/prometheus/internal github.com/aelsabbahy/GOnetstat +vendor/golang.org/x/net/http/httpproxy net/textproto -crypto/x509 github.com/google/uuid +crypto/x509 golang.org/x/net/internal/socket github.com/prometheus/procfs -google.golang.org/protobuf/internal/filetype -mime/multipart vendor/golang.org/x/net/http/httpguts +mime/multipart golang.org/x/net/ipv4 golang.org/x/net/ipv6 -google.golang.org/protobuf/runtime/protoimpl -google.golang.org/protobuf/types/known/timestamppb -github.com/prometheus/client_model/go -github.com/prometheus/common/model github.com/Masterminds/sprig crypto/tls -github.com/prometheus/client_golang/prometheus/internal net/http/httptrace github.com/miekg/dns net/http @@ -1110,9 +1146,9 @@ === RUN TestConfigMerge --- PASS: TestConfigMerge (0.00s) === RUN TestUseAsPackage ---- PASS: TestUseAsPackage (0.00s) +--- PASS: TestUseAsPackage (0.03s) === RUN TestSkipResourcesByType ---- PASS: TestSkipResourcesByType (0.00s) +--- PASS: TestSkipResourcesByType (0.22s) === RUN TestMatchers === RUN TestMatchers/testdata/out_matching_basic.0.documentation === RUN TestMatchers/testdata/out_matching_basic.0.nagios @@ -1130,7 +1166,7 @@ === RUN TestMatchers/testdata/out_matching_transformers_failing.1.rspecish === RUN TestMatchers/testdata/out_matching_transformers_failing.1.tap === RUN TestMatchers/testdata/out_matching_transformers_failing.2.nagios ---- PASS: TestMatchers (0.04s) +--- PASS: TestMatchers (0.03s) --- PASS: TestMatchers/testdata/out_matching_basic.0.documentation (0.00s) --- PASS: TestMatchers/testdata/out_matching_basic.0.nagios (0.00s) --- PASS: TestMatchers/testdata/out_matching_basic.0.rspecish (0.00s) @@ -1186,7 +1222,7 @@ [DEBUG][Command][%!s()][stdout] [TRACE] SUCCESS: Command => hello world (exit-status 0 0) [0.00] [0] [TRACE] SUCCESS: Command => hello world (stdout [hello world] &{s:[104 101 108 108 111 32 119 111 114 108 100 10] i:12 prevRune:-1}) [0.00] [0] - [DEBUG] OK SUMMARY: {"results":[{"duration":1548042,"end-time":"2025-12-01T05:38:01.175658608Z","err":null,"matcher-result":{"actual":0,"expected":0,"extra-elements":null,"found-elements":null,"message":"matches expectation","missing-elements":null,"transform-chain":null,"untransformed-value":null},"meta":null,"property":"exit-status","resource-id":"hello world","resource-type":"Command","result":0,"skipped":false,"start-time":"2025-12-01T05:38:01.174110576Z","successful":true,"summary-line":"Command: hello world: exit-status: matches expectation: 0","summary-line-compact":"Command: hello world: exit-status: matches expectation: 0","title":""},{"duration":6583,"end-time":"2025-12-01T05:38:01.175667334Z","err":null,"matcher-result":{"actual":{},"expected":["hello world"],"extra-elements":null,"found-elements":null,"message":"matches expectation","missing-elements":null,"transform-chain":null,"untransformed-value":null},"meta":null,"property":"stdout","resource-id":"hello world","resource-type":"Command","result":0,"skipped":false,"start-time":"2025-12-01T05:38:01.175660752Z","successful":true,"summary-line":"Command: hello world: stdout: matches expectation: [\"hello world\"]","summary-line-compact":"Command: hello world: stdout: matches expectation: [\"hello world\"]","title":""}],"summary":{"failed-count":0,"skipped-count":0,"summary-line":"Count: 2, Failed: 0, Skipped: 0, Duration: 0.002s","test-count":2,"total-duration":1556769}} + [DEBUG] OK SUMMARY: {"results":[{"duration":1543460,"end-time":"2024-10-28T23:18:05.871259664Z","err":null,"matcher-result":{"actual":0,"expected":0,"extra-elements":null,"found-elements":null,"message":"matches expectation","missing-elements":null,"transform-chain":null,"untransformed-value":null},"meta":null,"property":"exit-status","resource-id":"hello world","resource-type":"Command","result":0,"skipped":false,"start-time":"2024-10-28T23:18:05.869716195Z","successful":true,"summary-line":"Command: hello world: exit-status: matches expectation: 0","summary-line-compact":"Command: hello world: exit-status: matches expectation: 0","title":""},{"duration":8082,"end-time":"2024-10-28T23:18:05.871277201Z","err":null,"matcher-result":{"actual":{},"expected":["hello world"],"extra-elements":null,"found-elements":null,"message":"matches expectation","missing-elements":null,"transform-chain":null,"untransformed-value":null},"meta":null,"property":"stdout","resource-id":"hello world","resource-type":"Command","result":0,"skipped":false,"start-time":"2024-10-28T23:18:05.871269109Z","successful":true,"summary-line":"Command: hello world: stdout: matches expectation: [\"hello world\"]","summary-line-compact":"Command: hello world: stdout: matches expectation: [\"hello world\"]","title":""}],"summary":{"failed-count":0,"skipped-count":0,"summary-line":"Count: 2, Failed: 0, Skipped: 0, Duration: 0.002s","test-count":2,"total-duration":1560996}} [DEBUG] : status 200 === RUN TestServeCacheNegotiatingContent/immediately_re-request,_cache_should_be_warm @@ -1194,7 +1230,7 @@ [TRACE] Returning cached[res]. [TRACE] SUCCESS: Command => hello world (exit-status 0 0) [0.00] [0] [TRACE] SUCCESS: Command => hello world (stdout [hello world] &{s:[104 101 108 108 111 32 119 111 114 108 100 10] i:12 prevRune:-1}) [0.00] [0] - [DEBUG] OK SUMMARY: {"results":[{"duration":1548042,"end-time":"2025-12-01T05:38:01.175658608Z","err":null,"matcher-result":{"actual":0,"expected":0,"extra-elements":null,"found-elements":null,"message":"matches expectation","missing-elements":null,"transform-chain":null,"untransformed-value":null},"meta":null,"property":"exit-status","resource-id":"hello world","resource-type":"Command","result":0,"skipped":false,"start-time":"2025-12-01T05:38:01.174110576Z","successful":true,"summary-line":"Command: hello world: exit-status: matches expectation: 0","summary-line-compact":"Command: hello world: exit-status: matches expectation: 0","title":""},{"duration":6583,"end-time":"2025-12-01T05:38:01.175667334Z","err":null,"matcher-result":{"actual":{},"expected":["hello world"],"extra-elements":null,"found-elements":null,"message":"matches expectation","missing-elements":null,"transform-chain":null,"untransformed-value":null},"meta":null,"property":"stdout","resource-id":"hello world","resource-type":"Command","result":0,"skipped":false,"start-time":"2025-12-01T05:38:01.175660752Z","successful":true,"summary-line":"Command: hello world: stdout: matches expectation: [\"hello world\"]","summary-line-compact":"Command: hello world: stdout: matches expectation: [\"hello world\"]","title":""}],"summary":{"failed-count":0,"skipped-count":0,"summary-line":"Count: 2, Failed: 0, Skipped: 0, Duration: 0.002s","test-count":2,"total-duration":1556769}} + [DEBUG] OK SUMMARY: {"results":[{"duration":1543460,"end-time":"2024-10-28T23:18:05.871259664Z","err":null,"matcher-result":{"actual":0,"expected":0,"extra-elements":null,"found-elements":null,"message":"matches expectation","missing-elements":null,"transform-chain":null,"untransformed-value":null},"meta":null,"property":"exit-status","resource-id":"hello world","resource-type":"Command","result":0,"skipped":false,"start-time":"2024-10-28T23:18:05.869716195Z","successful":true,"summary-line":"Command: hello world: exit-status: matches expectation: 0","summary-line-compact":"Command: hello world: exit-status: matches expectation: 0","title":""},{"duration":8082,"end-time":"2024-10-28T23:18:05.871277201Z","err":null,"matcher-result":{"actual":{},"expected":["hello world"],"extra-elements":null,"found-elements":null,"message":"matches expectation","missing-elements":null,"transform-chain":null,"untransformed-value":null},"meta":null,"property":"stdout","resource-id":"hello world","resource-type":"Command","result":0,"skipped":false,"start-time":"2024-10-28T23:18:05.871269109Z","successful":true,"summary-line":"Command: hello world: stdout: matches expectation: [\"hello world\"]","summary-line-compact":"Command: hello world: stdout: matches expectation: [\"hello world\"]","title":""}],"summary":{"failed-count":0,"skipped-count":0,"summary-line":"Count: 2, Failed: 0, Skipped: 0, Duration: 0.002s","test-count":2,"total-duration":1560996}} [DEBUG] : status 200 === RUN TestServeCacheNegotiatingContent/immediately_re-request_but_different_accept_header,_cache_should_be_warm @@ -1212,7 +1248,7 @@ [DEBUG][Command][%!s()][stdout] [TRACE] SUCCESS: Command => hello world (exit-status 0 0) [0.00] [0] [TRACE] SUCCESS: Command => hello world (stdout [hello world] &{s:[104 101 108 108 111 32 119 111 114 108 100 10] i:12 prevRune:-1}) [0.00] [0] - [DEBUG] OK SUMMARY: {"results":[{"duration":1577648,"end-time":"2025-12-01T05:38:01.28411299Z","err":null,"matcher-result":{"actual":0,"expected":0,"extra-elements":null,"found-elements":null,"message":"matches expectation","missing-elements":null,"transform-chain":null,"untransformed-value":null},"meta":null,"property":"exit-status","resource-id":"hello world","resource-type":"Command","result":0,"skipped":false,"start-time":"2025-12-01T05:38:01.282535342Z","successful":true,"summary-line":"Command: hello world: exit-status: matches expectation: 0","summary-line-compact":"Command: hello world: exit-status: matches expectation: 0","title":""},{"duration":7154,"end-time":"2025-12-01T05:38:01.284123349Z","err":null,"matcher-result":{"actual":{},"expected":["hello world"],"extra-elements":null,"found-elements":null,"message":"matches expectation","missing-elements":null,"transform-chain":null,"untransformed-value":null},"meta":null,"property":"stdout","resource-id":"hello world","resource-type":"Command","result":0,"skipped":false,"start-time":"2025-12-01T05:38:01.284116196Z","successful":true,"summary-line":"Command: hello world: stdout: matches expectation: [\"hello world\"]","summary-line-compact":"Command: hello world: stdout: matches expectation: [\"hello world\"]","title":""}],"summary":{"failed-count":0,"skipped-count":0,"summary-line":"Count: 2, Failed: 0, Skipped: 0, Duration: 0.002s","test-count":2,"total-duration":1588008}} + [DEBUG] OK SUMMARY: {"results":[{"duration":1662250,"end-time":"2024-10-28T23:18:05.979034652Z","err":null,"matcher-result":{"actual":0,"expected":0,"extra-elements":null,"found-elements":null,"message":"matches expectation","missing-elements":null,"transform-chain":null,"untransformed-value":null},"meta":null,"property":"exit-status","resource-id":"hello world","resource-type":"Command","result":0,"skipped":false,"start-time":"2024-10-28T23:18:05.977372402Z","successful":true,"summary-line":"Command: hello world: exit-status: matches expectation: 0","summary-line-compact":"Command: hello world: exit-status: matches expectation: 0","title":""},{"duration":9284,"end-time":"2024-10-28T23:18:05.979051638Z","err":null,"matcher-result":{"actual":{},"expected":["hello world"],"extra-elements":null,"found-elements":null,"message":"matches expectation","missing-elements":null,"transform-chain":null,"untransformed-value":null},"meta":null,"property":"stdout","resource-id":"hello world","resource-type":"Command","result":0,"skipped":false,"start-time":"2024-10-28T23:18:05.979042344Z","successful":true,"summary-line":"Command: hello world: stdout: matches expectation: [\"hello world\"]","summary-line-compact":"Command: hello world: stdout: matches expectation: [\"hello world\"]","title":""}],"summary":{"failed-count":0,"skipped-count":0,"summary-line":"Count: 2, Failed: 0, Skipped: 0, Duration: 0.002s","test-count":2,"total-duration":1679226}} [DEBUG] : status 200 --- PASS: TestServeCacheNegotiatingContent (0.11s) @@ -1262,7 +1298,6 @@ === RUN TestServeNegotiatingContent/accept_{blank}_returns_process-level_format-option === NAME TestServeWithNoContentNegotiation/passing-json serve_test.go:66: testName "passing-json" log output: -=== RUN TestServeWithNoContentNegotiation/failing-json === NAME TestServeNegotiatingContent/accept_{blank}_returns_process-level_format-option serve_test.go:173: testName "accept {blank} returns process-level format-option" log output: [DEBUG] Warn: Using process-level output-format. Accept header on request missing or invalid. Accept header: [] @@ -1274,32 +1309,40 @@ [DEBUG][Command][%!s()][stdout] hello world [DEBUG][Command][%!s()][stdout] [TRACE] SUCCESS: Command => hello world (exit-status 0 0) [0.00] [0] + [DEBUG][Command][%!s()][stdout] hello world + [DEBUG][Command][%!s()][stdout] [TRACE] SUCCESS: Command => hello world (stdout [hello world] &{s:[104 101 108 108 111 32 119 111 114 108 100 10] i:12 prevRune:-1}) [0.00] [0] - [DEBUG] OK SUMMARY: {"results":[{"duration":1320446,"end-time":"2025-12-01T05:38:01.289299996Z","err":null,"matcher-result":{"actual":0,"expected":0,"extra-elements":null,"found-elements":null,"message":"matches expectation","missing-elements":null,"transform-chain":null,"untransformed-value":null},"meta":null,"property":"exit-status","resource-id":"hello world","resource-type":"Command","result":0,"skipped":false,"start-time":"2025-12-01T05:38:01.28797955Z","successful":true,"summary-line":"Command: hello world: exit-status: matches expectation: 0","summary-line-compact":"Command: hello world: exit-status: matches expectation: 0","title":""},{"duration":4949,"end-time":"2025-12-01T05:38:01.289306678Z","err":null,"matcher-result":{"actual":{},"expected":["hello world"],"extra-elements":null,"found-elements":null,"message":"matches expectation","missing-elements":null,"transform-chain":null,"untransformed-value":null},"meta":null,"property":"stdout","resource-id":"hello world","resource-type":"Command","result":0,"skipped":false,"start-time":"2025-12-01T05:38:01.289301729Z","successful":true,"summary-line":"Command: hello world: stdout: matches expectation: [\"hello world\"]","summary-line-compact":"Command: hello world: stdout: matches expectation: [\"hello world\"]","title":""}],"summary":{"failed-count":0,"skipped-count":0,"summary-line":"Count: 2, Failed: 0, Skipped: 0, Duration: 0.001s","test-count":2,"total-duration":1327128}} + [DEBUG] OK SUMMARY: {"results":[{"duration":1579804,"end-time":"2024-10-28T23:18:05.982725162Z","err":null,"matcher-result":{"actual":0,"expected":0,"extra-elements":null,"found-elements":null,"message":"matches expectation","missing-elements":null,"transform-chain":null,"untransformed-value":null},"meta":null,"property":"exit-status","resource-id":"hello world","resource-type":"Command","result":0,"skipped":false,"start-time":"2024-10-28T23:18:05.981145358Z","successful":true,"summary-line":"Command: hello world: exit-status: matches expectation: 0","summary-line-compact":"Command: hello world: exit-status: matches expectation: 0","title":""},{"duration":11667,"end-time":"2024-10-28T23:18:05.982740265Z","err":null,"matcher-result":{"actual":{},"expected":["hello world"],"extra-elements":null,"found-elements":null,"message":"matches expectation","missing-elements":null,"transform-chain":null,"untransformed-value":null},"meta":null,"property":"stdout","resource-id":"hello world","resource-type":"Command","result":0,"skipped":false,"start-time":"2024-10-28T23:18:05.982728597Z","successful":true,"summary-line":"Command: hello world: stdout: matches expectation: [\"hello world\"]","summary-line-compact":"Command: hello world: stdout: matches expectation: [\"hello world\"]","title":""}],"summary":{"failed-count":0,"skipped-count":0,"summary-line":"Count: 2, Failed: 0, Skipped: 0, Duration: 0.002s","test-count":2,"total-duration":1594907}} [DEBUG] : status 200 + [DEBUG] : status 200 +=== RUN TestServeWithNoContentNegotiation/failing-json === RUN TestServeNegotiatingContent/accept_application/json === NAME TestServeWithNoContentNegotiation/failing-json serve_test.go:66: testName "failing-json" log output: +=== RUN TestServeWithNoContentNegotiation/failing-default-output +=== NAME TestServeNegotiatingContent/accept_application/json + serve_test.go:173: testName "accept application/json" log output: + [TRACE] : requesting health probe + Stale cache[res], running tests [DEBUG] Warn: Using process-level output-format. Accept header on request missing or invalid. Accept header: [] [TRACE] : requesting health probe Stale cache[res], running tests [DEBUG][Command][%!s()][stdout] hello world [DEBUG][Command][%!s()][stdout] - [DEBUG] : status 200 -=== RUN TestServeWithNoContentNegotiation/failing-default-output -=== NAME TestServeNegotiatingContent/accept_application/json - serve_test.go:173: testName "accept application/json" log output: + [TRACE] FAIL: Command => hello world (exit-status 1 0) [0.00] [1] [DEBUG][Command][%!s()][stdout] hello world [DEBUG][Command][%!s()][stdout] - [TRACE] FAIL: Command => hello world (exit-status 1 0) [0.00] [1] [TRACE] FAIL: Command => hello world (stdout [did not echo this] object: *bytes.Reader) [0.00] [1] - [DEBUG] FAIL SUMMARY: {"results":[{"duration":1404143,"end-time":"2025-12-01T05:38:01.291470235Z","err":null,"matcher-result":{"actual":0,"expected":1,"extra-elements":null,"found-elements":null,"message":"to be numerically eq","missing-elements":null,"transform-chain":null,"untransformed-value":0},"meta":null,"property":"exit-status","resource-id":"hello world","resource-type":"Command","result":1,"skipped":false,"start-time":"2025-12-01T05:38:01.290066092Z","successful":false,"summary-line":"Command: hello world: exit-status:\nExpected\n 0\nto be numerically eq\n 1","summary-line-compact":"Command: hello world: exit-status: Expected 0 to be numerically eq 1","title":""},{"duration":6842,"end-time":"2025-12-01T05:38:01.291480113Z","err":null,"matcher-result":{"actual":"object: *bytes.Reader","expected":["did not echo this"],"extra-elements":null,"found-elements":null,"message":"to have patterns","missing-elements":["did not echo this"],"transform-chain":null,"untransformed-value":null},"meta":null,"property":"stdout","resource-id":"hello world","resource-type":"Command","result":1,"skipped":false,"start-time":"2025-12-01T05:38:01.291473271Z","successful":false,"summary-line":"Command: hello world: stdout:\nExpected\n \"object: *bytes.Reader\"\nto have patterns\n [\"did not echo this\"]\nthe missing elements were\n [\"did not echo this\"]","summary-line-compact":"Command: hello world: stdout: Expected \"object: *bytes.Reader\" to have patterns [\"did not echo this\"] the missing elements were [\"did not echo this\"]","title":""}],"summary":{"failed-count":2,"skipped-count":0,"summary-line":"Count: 2, Failed: 2, Skipped: 0, Duration: 0.001s","test-count":2,"total-duration":1414021}} - [DEBUG] : status 503 - {"results":[{"duration":1404143,"end-time":"2025-12-01T05:38:01.291470235Z","err":null,"matcher-result":{"actual":0,"expected":1,"extra-elements":null,"found-elements":null,"message":"to be numerically eq","missing-elements":null,"transform-chain":null,"untransformed-value":0},"meta":null,"property":"exit-status","resource-id":"hello world","resource-type":"Command","result":1,"skipped":false,"start-time":"2025-12-01T05:38:01.290066092Z","successful":false,"summary-line":"Command: hello world: exit-status:\nExpected\n 0\nto be numerically eq\n 1","summary-line-compact":"Command: hello world: exit-status: Expected 0 to be numerically eq 1","title":""},{"duration":6842,"end-time":"2025-12-01T05:38:01.291480113Z","err":null,"matcher-result":{"actual":"object: *bytes.Reader","expected":["did not echo this"],"extra-elements":null,"found-elements":null,"message":"to have patterns","missing-elements":["did not echo this"],"transform-chain":null,"untransformed-value":null},"meta":null,"property":"stdout","resource-id":"hello world","resource-type":"Command","result":1,"skipped":false,"start-time":"2025-12-01T05:38:01.291473271Z","successful":false,"summary-line":"Command: hello world: stdout:\nExpected\n \"object: *bytes.Reader\"\nto have patterns\n [\"did not echo this\"]\nthe missing elements were\n [\"did not echo this\"]","summary-line-compact":"Command: hello world: stdout: Expected \"object: *bytes.Reader\" to have patterns [\"did not echo this\"] the missing elements were [\"did not echo this\"]","title":""}],"summary":{"failed-count":2,"skipped-count":0,"summary-line":"Count: 2, Failed: 2, Skipped: 0, Duration: 0.001s","test-count":2,"total-duration":1414021}} + [TRACE] SUCCESS: Command => hello world (exit-status 0 0) [0.00] [0] + [DEBUG] FAIL SUMMARY: {"results":[{"duration":1676901,"end-time":"2024-10-28T23:18:05.986330284Z","err":null,"matcher-result":{"actual":0,"expected":1,"extra-elements":null,"found-elements":null,"message":"to be numerically eq","missing-elements":null,"transform-chain":null,"untransformed-value":0},"meta":null,"property":"exit-status","resource-id":"hello world","resource-type":"Command","result":1,"skipped":false,"start-time":"2024-10-28T23:18:05.984653373Z","successful":false,"summary-line":"Command: hello world: exit-status:\nExpected\n 0\nto be numerically eq\n 1","summary-line-compact":"Command: hello world: exit-status: Expected 0 to be numerically eq 1","title":""},{"duration":9224,"end-time":"2024-10-28T23:18:05.986342162Z","err":null,"matcher-result":{"actual":"object: *bytes.Reader","expected":["did not echo this"],"extra-elements":null,"found-elements":null,"message":"to have patterns","missing-elements":["did not echo this"],"transform-chain":null,"untransformed-value":null},"meta":null,"property":"stdout","resource-id":"hello world","resource-type":"Command","result":1,"skipped":false,"start-time":"2024-10-28T23:18:05.986332938Z","successful":false,"summary-line":"Command: hello world: stdout:\nExpected\n \"object: *bytes.Reader\"\nto have patterns\n [\"did not echo this\"]\nthe missing elements were\n [\"did not echo this\"]","summary-line-compact":"Command: hello world: stdout: Expected \"object: *bytes.Reader\" to have patterns [\"did not echo this\"] the missing elements were [\"did not echo this\"]","title":""}],"summary":{"failed-count":2,"skipped-count":0,"summary-line":"Count: 2, Failed: 2, Skipped: 0, Duration: 0.002s","test-count":2,"total-duration":1688779}} + [DEBUG] : status 503 - {"results":[{"duration":1676901,"end-time":"2024-10-28T23:18:05.986330284Z","err":null,"matcher-result":{"actual":0,"expected":1,"extra-elements":null,"found-elements":null,"message":"to be numerically eq","missing-elements":null,"transform-chain":null,"untransformed-value":0},"meta":null,"property":"exit-status","resource-id":"hello world","resource-type":"Command","result":1,"skipped":false,"start-time":"2024-10-28T23:18:05.984653373Z","successful":false,"summary-line":"Command: hello world: exit-status:\nExpected\n 0\nto be numerically eq\n 1","summary-line-compact":"Command: hello world: exit-status: Expected 0 to be numerically eq 1","title":""},{"duration":9224,"end-time":"2024-10-28T23:18:05.986342162Z","err":null,"matcher-result":{"actual":"object: *bytes.Reader","expected":["did not echo this"],"extra-elements":null,"found-elements":null,"message":"to have patterns","missing-elements":["did not echo this"],"transform-chain":null,"untransformed-value":null},"meta":null,"property":"stdout","resource-id":"hello world","resource-type":"Command","result":1,"skipped":false,"start-time":"2024-10-28T23:18:05.986332938Z","successful":false,"summary-line":"Command: hello world: stdout:\nExpected\n \"object: *bytes.Reader\"\nto have patterns\n [\"did not echo this\"]\nthe missing elements were\n [\"did not echo this\"]","summary-line-compact":"Command: hello world: stdout: Expected \"object: *bytes.Reader\" to have patterns [\"did not echo this\"] the missing elements were [\"did not echo this\"]","title":""}],"summary":{"failed-count":2,"skipped-count":0,"summary-line":"Count: 2, Failed: 2, Skipped: 0, Duration: 0.002s","test-count":2,"total-duration":1688779}} + [TRACE] SUCCESS: Command => hello world (stdout [hello world] &{s:[104 101 108 108 111 32 119 111 114 108 100 10] i:12 prevRune:-1}) [0.00] [0] + [DEBUG] OK SUMMARY: {"results":[{"duration":2040700,"end-time":"2024-10-28T23:18:05.98646638Z","err":null,"matcher-result":{"actual":0,"expected":0,"extra-elements":null,"found-elements":null,"message":"matches expectation","missing-elements":null,"transform-chain":null,"untransformed-value":null},"meta":null,"property":"exit-status","resource-id":"hello world","resource-type":"Command","result":0,"skipped":false,"start-time":"2024-10-28T23:18:05.98442568Z","successful":true,"summary-line":"Command: hello world: exit-status: matches expectation: 0","summary-line-compact":"Command: hello world: exit-status: matches expectation: 0","title":""},{"duration":7682,"end-time":"2024-10-28T23:18:05.986475734Z","err":null,"matcher-result":{"actual":{},"expected":["hello world"],"extra-elements":null,"found-elements":null,"message":"matches expectation","missing-elements":null,"transform-chain":null,"untransformed-value":null},"meta":null,"property":"stdout","resource-id":"hello world","resource-type":"Command","result":0,"skipped":false,"start-time":"2024-10-28T23:18:05.986468052Z","successful":true,"summary-line":"Command: hello world: stdout: matches expectation: [\"hello world\"]","summary-line-compact":"Command: hello world: stdout: matches expectation: [\"hello world\"]","title":""}],"summary":{"failed-count":0,"skipped-count":0,"summary-line":"Count: 2, Failed: 0, Skipped: 0, Duration: 0.002s","test-count":2,"total-duration":2050054}} + [DEBUG] : status 200 +=== RUN TestServeNegotiatingContent/accept_text/json_translates_to_application/json + serve_test.go:173: testName "accept text/json translates to application/json" log output: [TRACE] : requesting health probe Stale cache[res], running tests -=== RUN TestServeNegotiatingContent/accept_text/json_translates_to_application/json -=== NAME TestServeWithNoContentNegotiation/failing-default-output - serve_test.go:66: testName "failing-default-output" log output: [DEBUG] Warn: Using process-level output-format. Accept header on request missing or invalid. Accept header: [] [TRACE] : requesting health probe Stale cache[res], running tests @@ -1307,47 +1350,20 @@ [DEBUG][Command][%!s()][stdout] [TRACE] SUCCESS: Command => hello world (exit-status 0 0) [0.00] [0] [TRACE] SUCCESS: Command => hello world (stdout [hello world] &{s:[104 101 108 108 111 32 119 111 114 108 100 10] i:12 prevRune:-1}) [0.00] [0] - [DEBUG] OK SUMMARY: {"results":[{"duration":1272847,"end-time":"2025-12-01T05:38:01.293355951Z","err":null,"matcher-result":{"actual":0,"expected":0,"extra-elements":null,"found-elements":null,"message":"matches expectation","missing-elements":null,"transform-chain":null,"untransformed-value":null},"meta":null,"property":"exit-status","resource-id":"hello world","resource-type":"Command","result":0,"skipped":false,"start-time":"2025-12-01T05:38:01.292083104Z","successful":true,"summary-line":"Command: hello world: exit-status: matches expectation: 0","summary-line-compact":"Command: hello world: exit-status: matches expectation: 0","title":""},{"duration":9248,"end-time":"2025-12-01T05:38:01.293370388Z","err":null,"matcher-result":{"actual":{},"expected":["hello world"],"extra-elements":null,"found-elements":null,"message":"matches expectation","missing-elements":null,"transform-chain":null,"untransformed-value":null},"meta":null,"property":"stdout","resource-id":"hello world","resource-type":"Command","result":0,"skipped":false,"start-time":"2025-12-01T05:38:01.29336114Z","successful":true,"summary-line":"Command: hello world: stdout: matches expectation: [\"hello world\"]","summary-line-compact":"Command: hello world: stdout: matches expectation: [\"hello world\"]","title":""}],"summary":{"failed-count":0,"skipped-count":0,"summary-line":"Count: 2, Failed: 0, Skipped: 0, Duration: 0.001s","test-count":2,"total-duration":1287284}} [DEBUG][Command][%!s()][stdout] hello world - [DEBUG] : status 200 [DEBUG][Command][%!s()][stdout] [TRACE] FAIL: Command => hello world (exit-status 1 0) [0.00] [TRACE] FAIL: Command => hello world (stdout [did not echo this] object: *bytes.Reader) [0.00] - [DEBUG] FAIL SUMMARY: Total Duration: 0.001s Count: 2, Failed: 2, Skipped: 0 - [DEBUG] : status 503 - FF - - Failures/Skipped: - - Command: hello world: exit-status: - Expected - 0 - to be numerically eq - 1 - Command: hello world: stdout: - Expected - "object: *bytes.Reader" - to have patterns - ["did not echo this"] - the missing elements were - ["did not echo this"] - - Total Duration: 0.001s - Count: 2, Failed: 2, Skipped: 0 + [DEBUG] OK SUMMARY: {"results":[{"duration":1801560,"end-time":"2024-10-28T23:18:05.988962678Z","err":null,"matcher-result":{"actual":0,"expected":0,"extra-elements":null,"found-elements":null,"message":"matches expectation","missing-elements":null,"transform-chain":null,"untransformed-value":null},"meta":null,"property":"exit-status","resource-id":"hello world","resource-type":"Command","result":0,"skipped":false,"start-time":"2024-10-28T23:18:05.987161118Z","successful":true,"summary-line":"Command: hello world: exit-status: matches expectation: 0","summary-line-compact":"Command: hello world: exit-status: matches expectation: 0","title":""},{"duration":3756,"end-time":"2024-10-28T23:18:05.988968567Z","err":null,"matcher-result":{"actual":{},"expected":["hello world"],"extra-elements":null,"found-elements":null,"message":"matches expectation","missing-elements":null,"transform-chain":null,"untransformed-value":null},"meta":null,"property":"stdout","resource-id":"hello world","resource-type":"Command","result":0,"skipped":false,"start-time":"2024-10-28T23:18:05.988964601Z","successful":true,"summary-line":"Command: hello world: stdout: matches expectation: [\"hello world\"]","summary-line-compact":"Command: hello world: stdout: matches expectation: [\"hello world\"]","title":""}],"summary":{"failed-count":0,"skipped-count":0,"summary-line":"Count: 2, Failed: 0, Skipped: 0, Duration: 0.002s","test-count":2,"total-duration":1807449}} + [DEBUG] : status 200 +=== NAME TestServeWithNoContentNegotiation/failing-default-output + serve_test.go:66: testName "failing-default-output" log output: +=== RUN TestServeNegotiatingContent/when_accept_is_application/vnd.goss-json,_return_more_widely_known_application/json --- PASS: TestServeWithNoContentNegotiation (0.01s) --- PASS: TestServeWithNoContentNegotiation/passing-json (0.00s) --- PASS: TestServeWithNoContentNegotiation/failing-json (0.00s) --- PASS: TestServeWithNoContentNegotiation/failing-default-output (0.00s) -=== NAME TestServeNegotiatingContent/accept_text/json_translates_to_application/json - serve_test.go:173: testName "accept text/json translates to application/json" log output: - [TRACE] : requesting health probe - Stale cache[res], running tests - [DEBUG][Command][%!s()][stdout] hello world - [DEBUG][Command][%!s()][stdout] - [TRACE] SUCCESS: Command => hello world (exit-status 0 0) [0.00] [0] - [TRACE] SUCCESS: Command => hello world (stdout [hello world] &{s:[104 101 108 108 111 32 119 111 114 108 100 10] i:12 prevRune:-1}) [0.00] [0] - [DEBUG] OK SUMMARY: {"results":[{"duration":1255484,"end-time":"2025-12-01T05:38:01.295573539Z","err":null,"matcher-result":{"actual":0,"expected":0,"extra-elements":null,"found-elements":null,"message":"matches expectation","missing-elements":null,"transform-chain":null,"untransformed-value":null},"meta":null,"property":"exit-status","resource-id":"hello world","resource-type":"Command","result":0,"skipped":false,"start-time":"2025-12-01T05:38:01.294318054Z","successful":true,"summary-line":"Command: hello world: exit-status: matches expectation: 0","summary-line-compact":"Command: hello world: exit-status: matches expectation: 0","title":""},{"duration":3867,"end-time":"2025-12-01T05:38:01.295580411Z","err":null,"matcher-result":{"actual":{},"expected":["hello world"],"extra-elements":null,"found-elements":null,"message":"matches expectation","missing-elements":null,"transform-chain":null,"untransformed-value":null},"meta":null,"property":"stdout","resource-id":"hello world","resource-type":"Command","result":0,"skipped":false,"start-time":"2025-12-01T05:38:01.295576544Z","successful":true,"summary-line":"Command: hello world: stdout: matches expectation: [\"hello world\"]","summary-line-compact":"Command: hello world: stdout: matches expectation: [\"hello world\"]","title":""}],"summary":{"failed-count":0,"skipped-count":0,"summary-line":"Count: 2, Failed: 0, Skipped: 0, Duration: 0.001s","test-count":2,"total-duration":1262356}} - [DEBUG] : status 200 -=== RUN TestServeNegotiatingContent/when_accept_is_application/vnd.goss-json,_return_more_widely_known_application/json +=== NAME TestServeNegotiatingContent/when_accept_is_application/vnd.goss-json,_return_more_widely_known_application/json serve_test.go:173: testName "when accept is application/vnd.goss-json, return more widely known application/json" log output: [TRACE] : requesting health probe Stale cache[res], running tests @@ -1355,7 +1371,7 @@ [DEBUG][Command][%!s()][stdout] [TRACE] SUCCESS: Command => hello world (exit-status 0 0) [0.00] [0] [TRACE] SUCCESS: Command => hello world (stdout [hello world] &{s:[104 101 108 108 111 32 119 111 114 108 100 10] i:12 prevRune:-1}) [0.00] [0] - [DEBUG] OK SUMMARY: {"results":[{"duration":1328221,"end-time":"2025-12-01T05:38:01.298456815Z","err":null,"matcher-result":{"actual":0,"expected":0,"extra-elements":null,"found-elements":null,"message":"matches expectation","missing-elements":null,"transform-chain":null,"untransformed-value":null},"meta":null,"property":"exit-status","resource-id":"hello world","resource-type":"Command","result":0,"skipped":false,"start-time":"2025-12-01T05:38:01.297128594Z","successful":true,"summary-line":"Command: hello world: exit-status: matches expectation: 0","summary-line-compact":"Command: hello world: exit-status: matches expectation: 0","title":""},{"duration":3777,"end-time":"2025-12-01T05:38:01.298462185Z","err":null,"matcher-result":{"actual":{},"expected":["hello world"],"extra-elements":null,"found-elements":null,"message":"matches expectation","missing-elements":null,"transform-chain":null,"untransformed-value":null},"meta":null,"property":"stdout","resource-id":"hello world","resource-type":"Command","result":0,"skipped":false,"start-time":"2025-12-01T05:38:01.298458408Z","successful":true,"summary-line":"Command: hello world: stdout: matches expectation: [\"hello world\"]","summary-line-compact":"Command: hello world: stdout: matches expectation: [\"hello world\"]","title":""}],"summary":{"failed-count":0,"skipped-count":0,"summary-line":"Count: 2, Failed: 0, Skipped: 0, Duration: 0.001s","test-count":2,"total-duration":1333591}} + [DEBUG] OK SUMMARY: {"results":[{"duration":1047191,"end-time":"2024-10-28T23:18:05.990665778Z","err":null,"matcher-result":{"actual":0,"expected":0,"extra-elements":null,"found-elements":null,"message":"matches expectation","missing-elements":null,"transform-chain":null,"untransformed-value":null},"meta":null,"property":"exit-status","resource-id":"hello world","resource-type":"Command","result":0,"skipped":false,"start-time":"2024-10-28T23:18:05.989618587Z","successful":true,"summary-line":"Command: hello world: exit-status: matches expectation: 0","summary-line-compact":"Command: hello world: exit-status: matches expectation: 0","title":""},{"duration":10166,"end-time":"2024-10-28T23:18:05.990689484Z","err":null,"matcher-result":{"actual":{},"expected":["hello world"],"extra-elements":null,"found-elements":null,"message":"matches expectation","missing-elements":null,"transform-chain":null,"untransformed-value":null},"meta":null,"property":"stdout","resource-id":"hello world","resource-type":"Command","result":0,"skipped":false,"start-time":"2024-10-28T23:18:05.990679318Z","successful":true,"summary-line":"Command: hello world: stdout: matches expectation: [\"hello world\"]","summary-line-compact":"Command: hello world: stdout: matches expectation: [\"hello world\"]","title":""}],"summary":{"failed-count":0,"skipped-count":0,"summary-line":"Count: 2, Failed: 0, Skipped: 0, Duration: 0.001s","test-count":2,"total-duration":1070897}} [DEBUG] : status 200 === RUN TestServeNegotiatingContent/accept_header_contains_vendor-specific_output_format_different_from_process-level serve_test.go:173: testName "accept header contains vendor-specific output format different from process-level" log output: @@ -1383,7 +1399,7 @@ [DEBUG][Command][%!s()][stdout] [TRACE] SUCCESS: Command => hello world (exit-status 0 0) [0.00] [0] [TRACE] SUCCESS: Command => hello world (stdout [hello world] &{s:[104 101 108 108 111 32 119 111 114 108 100 10] i:12 prevRune:-1}) [0.00] [0] - [DEBUG] OK SUMMARY: {"results":[{"duration":1140548,"end-time":"2025-12-01T05:38:01.30396364Z","err":null,"matcher-result":{"actual":0,"expected":0,"extra-elements":null,"found-elements":null,"message":"matches expectation","missing-elements":null,"transform-chain":null,"untransformed-value":null},"meta":null,"property":"exit-status","resource-id":"hello world","resource-type":"Command","result":0,"skipped":false,"start-time":"2025-12-01T05:38:01.302823111Z","successful":true,"summary-line":"Command: hello world: exit-status: matches expectation: 0","summary-line-compact":"Command: hello world: exit-status: matches expectation: 0","title":""},{"duration":6502,"end-time":"2025-12-01T05:38:01.303972326Z","err":null,"matcher-result":{"actual":{},"expected":["hello world"],"extra-elements":null,"found-elements":null,"message":"matches expectation","missing-elements":null,"transform-chain":null,"untransformed-value":null},"meta":null,"property":"stdout","resource-id":"hello world","resource-type":"Command","result":0,"skipped":false,"start-time":"2025-12-01T05:38:01.303965814Z","successful":true,"summary-line":"Command: hello world: stdout: matches expectation: [\"hello world\"]","summary-line-compact":"Command: hello world: stdout: matches expectation: [\"hello world\"]","title":""}],"summary":{"failed-count":0,"skipped-count":0,"summary-line":"Count: 2, Failed: 0, Skipped: 0, Duration: 0.001s","test-count":2,"total-duration":1149214}} + [DEBUG] OK SUMMARY: {"results":[{"duration":1009904,"end-time":"2024-10-28T23:18:05.996396908Z","err":null,"matcher-result":{"actual":0,"expected":0,"extra-elements":null,"found-elements":null,"message":"matches expectation","missing-elements":null,"transform-chain":null,"untransformed-value":null},"meta":null,"property":"exit-status","resource-id":"hello world","resource-type":"Command","result":0,"skipped":false,"start-time":"2024-10-28T23:18:05.995387004Z","successful":true,"summary-line":"Command: hello world: exit-status: matches expectation: 0","summary-line-compact":"Command: hello world: exit-status: matches expectation: 0","title":""},{"duration":4887,"end-time":"2024-10-28T23:18:05.996403378Z","err":null,"matcher-result":{"actual":{},"expected":["hello world"],"extra-elements":null,"found-elements":null,"message":"matches expectation","missing-elements":null,"transform-chain":null,"untransformed-value":null},"meta":null,"property":"stdout","resource-id":"hello world","resource-type":"Command","result":0,"skipped":false,"start-time":"2024-10-28T23:18:05.996398491Z","successful":true,"summary-line":"Command: hello world: stdout: matches expectation: [\"hello world\"]","summary-line-compact":"Command: hello world: stdout: matches expectation: [\"hello world\"]","title":""}],"summary":{"failed-count":0,"skipped-count":0,"summary-line":"Count: 2, Failed: 0, Skipped: 0, Duration: 0.001s","test-count":2,"total-duration":1016374}} [DEBUG] : status 200 --- PASS: TestServeNegotiatingContent (0.02s) --- PASS: TestServeNegotiatingContent/accept_{blank}_returns_process-level_format-option (0.00s) @@ -1394,7 +1410,7 @@ --- PASS: TestServeNegotiatingContent/accept_header_contains_nonsense (0.00s) --- PASS: TestServeNegotiatingContent/accept_header_contains_nonsense_then_valid (0.00s) PASS -ok github.com/goss-org/goss 0.291s +ok github.com/goss-org/goss 0.522s === RUN TestBeSemverConstraint === RUN TestBeSemverConstraint/sanity --- PASS: TestBeSemverConstraint (0.00s) @@ -1472,47 +1488,40 @@ === RUN TestOptionsRegistration --- PASS: TestOptionsRegistration (0.00s) === RUN TestPrometheusOutput -=== RUN TestPrometheusOutput/all-success-single-type +=== RUN TestPrometheusOutput/all-success-multiple-types prometheus_test.go:515: # HELP goss_tests_outcomes_duration_milliseconds The duration of tests from this run. Note; tests run concurrently. # TYPE goss_tests_outcomes_duration_milliseconds counter - goss_tests_outcomes_duration_milliseconds{outcome="pass",type="command"} 20 + goss_tests_outcomes_duration_milliseconds{outcome="pass",type="command"} 10 + goss_tests_outcomes_duration_milliseconds{outcome="pass",type="file"} 10 # HELP goss_tests_outcomes_total The number of test-outcomes from this run. # TYPE goss_tests_outcomes_total counter - goss_tests_outcomes_total{outcome="pass",type="command"} 2 + goss_tests_outcomes_total{outcome="pass",type="command"} 1 + goss_tests_outcomes_total{outcome="pass",type="file"} 1 # HELP goss_tests_run_duration_milliseconds The end-to-end duration of this run. # TYPE goss_tests_run_duration_milliseconds counter goss_tests_run_duration_milliseconds{outcome="pass"} 9.223372036854e+12 # HELP goss_tests_run_outcomes_total The outcomes of this run as a whole. # TYPE goss_tests_run_outcomes_total counter goss_tests_run_outcomes_total{outcome="pass"} 1 -=== RUN TestPrometheusOutput/all-fail-single-type - prometheus_test.go:515: # HELP goss_tests_outcomes_duration_milliseconds The duration of tests from this run. Note; tests run concurrently. - # TYPE goss_tests_outcomes_duration_milliseconds counter - goss_tests_outcomes_duration_milliseconds{outcome="fail",type="command"} 20 - # HELP goss_tests_outcomes_total The number of test-outcomes from this run. - # TYPE goss_tests_outcomes_total counter - goss_tests_outcomes_total{outcome="fail",type="command"} 2 - # HELP goss_tests_run_duration_milliseconds The end-to-end duration of this run. - # TYPE goss_tests_run_duration_milliseconds counter - goss_tests_run_duration_milliseconds{outcome="fail"} 9.223372036854e+12 - # HELP goss_tests_run_outcomes_total The outcomes of this run as a whole. - # TYPE goss_tests_run_outcomes_total counter - goss_tests_run_outcomes_total{outcome="fail"} 1 -=== RUN TestPrometheusOutput/unknown-success +=== RUN TestPrometheusOutput/various-results-multiple-types prometheus_test.go:515: # HELP goss_tests_outcomes_duration_milliseconds The duration of tests from this run. Note; tests run concurrently. # TYPE goss_tests_outcomes_duration_milliseconds counter + goss_tests_outcomes_duration_milliseconds{outcome="fail",type="command"} 10 goss_tests_outcomes_duration_milliseconds{outcome="pass",type="command"} 10 - goss_tests_outcomes_duration_milliseconds{outcome="unknown",type="command"} 10 + goss_tests_outcomes_duration_milliseconds{outcome="skip",type="file"} 10 + goss_tests_outcomes_duration_milliseconds{outcome="unknown",type="file"} 10 # HELP goss_tests_outcomes_total The number of test-outcomes from this run. # TYPE goss_tests_outcomes_total counter + goss_tests_outcomes_total{outcome="fail",type="command"} 1 goss_tests_outcomes_total{outcome="pass",type="command"} 1 - goss_tests_outcomes_total{outcome="unknown",type="command"} 1 + goss_tests_outcomes_total{outcome="skip",type="file"} 1 + goss_tests_outcomes_total{outcome="unknown",type="file"} 1 # HELP goss_tests_run_duration_milliseconds The end-to-end duration of this run. # TYPE goss_tests_run_duration_milliseconds counter - goss_tests_run_duration_milliseconds{outcome="unknown"} 9.223372036854e+12 + goss_tests_run_duration_milliseconds{outcome="fail"} 9.223372036854e+12 # HELP goss_tests_run_outcomes_total The outcomes of this run as a whole. # TYPE goss_tests_run_outcomes_total counter - goss_tests_run_outcomes_total{outcome="unknown"} 1 + goss_tests_run_outcomes_total{outcome="fail"} 1 === RUN TestPrometheusOutput/unknown-fail prometheus_test.go:515: # HELP goss_tests_outcomes_duration_milliseconds The duration of tests from this run. Note; tests run concurrently. # TYPE goss_tests_outcomes_duration_milliseconds counter @@ -1528,14 +1537,14 @@ # HELP goss_tests_run_outcomes_total The outcomes of this run as a whole. # TYPE goss_tests_run_outcomes_total counter goss_tests_run_outcomes_total{outcome="fail"} 1 -=== RUN TestPrometheusOutput/skip-unknown +=== RUN TestPrometheusOutput/success-unknown prometheus_test.go:515: # HELP goss_tests_outcomes_duration_milliseconds The duration of tests from this run. Note; tests run concurrently. # TYPE goss_tests_outcomes_duration_milliseconds counter - goss_tests_outcomes_duration_milliseconds{outcome="skip",type="command"} 10 + goss_tests_outcomes_duration_milliseconds{outcome="pass",type="command"} 10 goss_tests_outcomes_duration_milliseconds{outcome="unknown",type="command"} 10 # HELP goss_tests_outcomes_total The number of test-outcomes from this run. # TYPE goss_tests_outcomes_total counter - goss_tests_outcomes_total{outcome="skip",type="command"} 1 + goss_tests_outcomes_total{outcome="pass",type="command"} 1 goss_tests_outcomes_total{outcome="unknown",type="command"} 1 # HELP goss_tests_run_duration_milliseconds The end-to-end duration of this run. # TYPE goss_tests_run_duration_milliseconds counter @@ -1543,29 +1552,55 @@ # HELP goss_tests_run_outcomes_total The outcomes of this run as a whole. # TYPE goss_tests_run_outcomes_total counter goss_tests_run_outcomes_total{outcome="unknown"} 1 -=== RUN TestPrometheusOutput/skip-fail +=== RUN TestPrometheusOutput/no-results + prometheus_test.go:515: # HELP goss_tests_run_duration_milliseconds The end-to-end duration of this run. + # TYPE goss_tests_run_duration_milliseconds counter + goss_tests_run_duration_milliseconds{outcome="unknown"} 9.223372036854e+12 + # HELP goss_tests_run_outcomes_total The outcomes of this run as a whole. + # TYPE goss_tests_run_outcomes_total counter + goss_tests_run_outcomes_total{outcome="unknown"} 1 +=== RUN TestPrometheusOutput/verbose prometheus_test.go:515: # HELP goss_tests_outcomes_duration_milliseconds The duration of tests from this run. Note; tests run concurrently. # TYPE goss_tests_outcomes_duration_milliseconds counter - goss_tests_outcomes_duration_milliseconds{outcome="fail",type="command"} 10 - goss_tests_outcomes_duration_milliseconds{outcome="skip",type="command"} 10 + goss_tests_outcomes_duration_milliseconds{outcome="fail",resource_id="/path/to/file",type="file"} 10 + goss_tests_outcomes_duration_milliseconds{outcome="pass",resource_id="some command here",type="command"} 10 + goss_tests_outcomes_duration_milliseconds{outcome="pass",resource_id="something else here",type="command"} 10 # HELP goss_tests_outcomes_total The number of test-outcomes from this run. # TYPE goss_tests_outcomes_total counter - goss_tests_outcomes_total{outcome="fail",type="command"} 1 - goss_tests_outcomes_total{outcome="skip",type="command"} 1 + goss_tests_outcomes_total{outcome="fail",resource_id="/path/to/file",type="file"} 1 + goss_tests_outcomes_total{outcome="pass",resource_id="some command here",type="command"} 1 + goss_tests_outcomes_total{outcome="pass",resource_id="something else here",type="command"} 1 # HELP goss_tests_run_duration_milliseconds The end-to-end duration of this run. # TYPE goss_tests_run_duration_milliseconds counter goss_tests_run_duration_milliseconds{outcome="fail"} 9.223372036854e+12 # HELP goss_tests_run_outcomes_total The outcomes of this run as a whole. # TYPE goss_tests_run_outcomes_total counter goss_tests_run_outcomes_total{outcome="fail"} 1 -=== RUN TestPrometheusOutput/fail-unknown +=== RUN TestPrometheusOutput/all-unknown-single-type + prometheus_test.go:515: # HELP goss_tests_outcomes_duration_milliseconds The duration of tests from this run. Note; tests run concurrently. + # TYPE goss_tests_outcomes_duration_milliseconds counter + goss_tests_outcomes_duration_milliseconds{outcome="unknown",type="command"} 20 + # HELP goss_tests_outcomes_total The number of test-outcomes from this run. + # TYPE goss_tests_outcomes_total counter + goss_tests_outcomes_total{outcome="unknown",type="command"} 2 + # HELP goss_tests_run_duration_milliseconds The end-to-end duration of this run. + # TYPE goss_tests_run_duration_milliseconds counter + goss_tests_run_duration_milliseconds{outcome="unknown"} 9.223372036854e+12 + # HELP goss_tests_run_outcomes_total The outcomes of this run as a whole. + # TYPE goss_tests_run_outcomes_total counter + goss_tests_run_outcomes_total{outcome="unknown"} 1 +=== RUN TestPrometheusOutput/various-results-single-type prometheus_test.go:515: # HELP goss_tests_outcomes_duration_milliseconds The duration of tests from this run. Note; tests run concurrently. # TYPE goss_tests_outcomes_duration_milliseconds counter goss_tests_outcomes_duration_milliseconds{outcome="fail",type="command"} 10 + goss_tests_outcomes_duration_milliseconds{outcome="pass",type="command"} 10 + goss_tests_outcomes_duration_milliseconds{outcome="skip",type="command"} 10 goss_tests_outcomes_duration_milliseconds{outcome="unknown",type="command"} 10 # HELP goss_tests_outcomes_total The number of test-outcomes from this run. # TYPE goss_tests_outcomes_total counter goss_tests_outcomes_total{outcome="fail",type="command"} 1 + goss_tests_outcomes_total{outcome="pass",type="command"} 1 + goss_tests_outcomes_total{outcome="skip",type="command"} 1 goss_tests_outcomes_total{outcome="unknown",type="command"} 1 # HELP goss_tests_run_duration_milliseconds The end-to-end duration of this run. # TYPE goss_tests_run_duration_milliseconds counter @@ -1573,7 +1608,7 @@ # HELP goss_tests_run_outcomes_total The outcomes of this run as a whole. # TYPE goss_tests_run_outcomes_total counter goss_tests_run_outcomes_total{outcome="fail"} 1 -=== RUN TestPrometheusOutput/success-unknown +=== RUN TestPrometheusOutput/unknown-success prometheus_test.go:515: # HELP goss_tests_outcomes_duration_milliseconds The duration of tests from this run. Note; tests run concurrently. # TYPE goss_tests_outcomes_duration_milliseconds counter goss_tests_outcomes_duration_milliseconds{outcome="pass",type="command"} 10 @@ -1588,108 +1623,95 @@ # HELP goss_tests_run_outcomes_total The outcomes of this run as a whole. # TYPE goss_tests_run_outcomes_total counter goss_tests_run_outcomes_total{outcome="unknown"} 1 -=== RUN TestPrometheusOutput/all-skip-single-type +=== RUN TestPrometheusOutput/skip-fail prometheus_test.go:515: # HELP goss_tests_outcomes_duration_milliseconds The duration of tests from this run. Note; tests run concurrently. # TYPE goss_tests_outcomes_duration_milliseconds counter - goss_tests_outcomes_duration_milliseconds{outcome="skip",type="command"} 20 + goss_tests_outcomes_duration_milliseconds{outcome="fail",type="command"} 10 + goss_tests_outcomes_duration_milliseconds{outcome="skip",type="command"} 10 # HELP goss_tests_outcomes_total The number of test-outcomes from this run. # TYPE goss_tests_outcomes_total counter - goss_tests_outcomes_total{outcome="skip",type="command"} 2 + goss_tests_outcomes_total{outcome="fail",type="command"} 1 + goss_tests_outcomes_total{outcome="skip",type="command"} 1 # HELP goss_tests_run_duration_milliseconds The end-to-end duration of this run. # TYPE goss_tests_run_duration_milliseconds counter - goss_tests_run_duration_milliseconds{outcome="skip"} 9.223372036854e+12 + goss_tests_run_duration_milliseconds{outcome="fail"} 9.223372036854e+12 # HELP goss_tests_run_outcomes_total The outcomes of this run as a whole. # TYPE goss_tests_run_outcomes_total counter - goss_tests_run_outcomes_total{outcome="skip"} 1 -=== RUN TestPrometheusOutput/all-success-multiple-types + goss_tests_run_outcomes_total{outcome="fail"} 1 +=== RUN TestPrometheusOutput/fail-unknown prometheus_test.go:515: # HELP goss_tests_outcomes_duration_milliseconds The duration of tests from this run. Note; tests run concurrently. # TYPE goss_tests_outcomes_duration_milliseconds counter - goss_tests_outcomes_duration_milliseconds{outcome="pass",type="command"} 10 - goss_tests_outcomes_duration_milliseconds{outcome="pass",type="file"} 10 + goss_tests_outcomes_duration_milliseconds{outcome="fail",type="command"} 10 + goss_tests_outcomes_duration_milliseconds{outcome="unknown",type="command"} 10 # HELP goss_tests_outcomes_total The number of test-outcomes from this run. # TYPE goss_tests_outcomes_total counter - goss_tests_outcomes_total{outcome="pass",type="command"} 1 - goss_tests_outcomes_total{outcome="pass",type="file"} 1 + goss_tests_outcomes_total{outcome="fail",type="command"} 1 + goss_tests_outcomes_total{outcome="unknown",type="command"} 1 # HELP goss_tests_run_duration_milliseconds The end-to-end duration of this run. # TYPE goss_tests_run_duration_milliseconds counter - goss_tests_run_duration_milliseconds{outcome="pass"} 9.223372036854e+12 + goss_tests_run_duration_milliseconds{outcome="fail"} 9.223372036854e+12 # HELP goss_tests_run_outcomes_total The outcomes of this run as a whole. # TYPE goss_tests_run_outcomes_total counter - goss_tests_run_outcomes_total{outcome="pass"} 1 -=== RUN TestPrometheusOutput/unknown-skip + goss_tests_run_outcomes_total{outcome="fail"} 1 +=== RUN TestPrometheusOutput/fail-skip prometheus_test.go:515: # HELP goss_tests_outcomes_duration_milliseconds The duration of tests from this run. Note; tests run concurrently. # TYPE goss_tests_outcomes_duration_milliseconds counter + goss_tests_outcomes_duration_milliseconds{outcome="fail",type="command"} 10 goss_tests_outcomes_duration_milliseconds{outcome="skip",type="command"} 10 - goss_tests_outcomes_duration_milliseconds{outcome="unknown",type="command"} 10 # HELP goss_tests_outcomes_total The number of test-outcomes from this run. # TYPE goss_tests_outcomes_total counter + goss_tests_outcomes_total{outcome="fail",type="command"} 1 goss_tests_outcomes_total{outcome="skip",type="command"} 1 - goss_tests_outcomes_total{outcome="unknown",type="command"} 1 # HELP goss_tests_run_duration_milliseconds The end-to-end duration of this run. # TYPE goss_tests_run_duration_milliseconds counter - goss_tests_run_duration_milliseconds{outcome="unknown"} 9.223372036854e+12 + goss_tests_run_duration_milliseconds{outcome="fail"} 9.223372036854e+12 # HELP goss_tests_run_outcomes_total The outcomes of this run as a whole. # TYPE goss_tests_run_outcomes_total counter - goss_tests_run_outcomes_total{outcome="unknown"} 1 -=== RUN TestPrometheusOutput/success-skip + goss_tests_run_outcomes_total{outcome="fail"} 1 +=== RUN TestPrometheusOutput/all-fail-single-type prometheus_test.go:515: # HELP goss_tests_outcomes_duration_milliseconds The duration of tests from this run. Note; tests run concurrently. # TYPE goss_tests_outcomes_duration_milliseconds counter - goss_tests_outcomes_duration_milliseconds{outcome="pass",type="command"} 10 - goss_tests_outcomes_duration_milliseconds{outcome="skip",type="command"} 10 + goss_tests_outcomes_duration_milliseconds{outcome="fail",type="command"} 20 # HELP goss_tests_outcomes_total The number of test-outcomes from this run. # TYPE goss_tests_outcomes_total counter - goss_tests_outcomes_total{outcome="pass",type="command"} 1 - goss_tests_outcomes_total{outcome="skip",type="command"} 1 + goss_tests_outcomes_total{outcome="fail",type="command"} 2 # HELP goss_tests_run_duration_milliseconds The end-to-end duration of this run. # TYPE goss_tests_run_duration_milliseconds counter - goss_tests_run_duration_milliseconds{outcome="pass"} 9.223372036854e+12 + goss_tests_run_duration_milliseconds{outcome="fail"} 9.223372036854e+12 # HELP goss_tests_run_outcomes_total The outcomes of this run as a whole. # TYPE goss_tests_run_outcomes_total counter - goss_tests_run_outcomes_total{outcome="pass"} 1 -=== RUN TestPrometheusOutput/verbose + goss_tests_run_outcomes_total{outcome="fail"} 1 +=== RUN TestPrometheusOutput/unknown-skip prometheus_test.go:515: # HELP goss_tests_outcomes_duration_milliseconds The duration of tests from this run. Note; tests run concurrently. # TYPE goss_tests_outcomes_duration_milliseconds counter - goss_tests_outcomes_duration_milliseconds{outcome="fail",resource_id="/path/to/file",type="file"} 10 - goss_tests_outcomes_duration_milliseconds{outcome="pass",resource_id="some command here",type="command"} 10 - goss_tests_outcomes_duration_milliseconds{outcome="pass",resource_id="something else here",type="command"} 10 + goss_tests_outcomes_duration_milliseconds{outcome="skip",type="command"} 10 + goss_tests_outcomes_duration_milliseconds{outcome="unknown",type="command"} 10 # HELP goss_tests_outcomes_total The number of test-outcomes from this run. # TYPE goss_tests_outcomes_total counter - goss_tests_outcomes_total{outcome="fail",resource_id="/path/to/file",type="file"} 1 - goss_tests_outcomes_total{outcome="pass",resource_id="some command here",type="command"} 1 - goss_tests_outcomes_total{outcome="pass",resource_id="something else here",type="command"} 1 + goss_tests_outcomes_total{outcome="skip",type="command"} 1 + goss_tests_outcomes_total{outcome="unknown",type="command"} 1 # HELP goss_tests_run_duration_milliseconds The end-to-end duration of this run. # TYPE goss_tests_run_duration_milliseconds counter - goss_tests_run_duration_milliseconds{outcome="fail"} 9.223372036854e+12 - # HELP goss_tests_run_outcomes_total The outcomes of this run as a whole. - # TYPE goss_tests_run_outcomes_total counter - goss_tests_run_outcomes_total{outcome="fail"} 1 -=== RUN TestPrometheusOutput/no-results - prometheus_test.go:515: # HELP goss_tests_run_duration_milliseconds The end-to-end duration of this run. - # TYPE goss_tests_run_duration_milliseconds counter goss_tests_run_duration_milliseconds{outcome="unknown"} 9.223372036854e+12 # HELP goss_tests_run_outcomes_total The outcomes of this run as a whole. # TYPE goss_tests_run_outcomes_total counter goss_tests_run_outcomes_total{outcome="unknown"} 1 -=== RUN TestPrometheusOutput/various-results-multiple-types +=== RUN TestPrometheusOutput/skip-success prometheus_test.go:515: # HELP goss_tests_outcomes_duration_milliseconds The duration of tests from this run. Note; tests run concurrently. # TYPE goss_tests_outcomes_duration_milliseconds counter - goss_tests_outcomes_duration_milliseconds{outcome="fail",type="command"} 10 goss_tests_outcomes_duration_milliseconds{outcome="pass",type="command"} 10 - goss_tests_outcomes_duration_milliseconds{outcome="skip",type="file"} 10 - goss_tests_outcomes_duration_milliseconds{outcome="unknown",type="file"} 10 + goss_tests_outcomes_duration_milliseconds{outcome="skip",type="command"} 10 # HELP goss_tests_outcomes_total The number of test-outcomes from this run. # TYPE goss_tests_outcomes_total counter - goss_tests_outcomes_total{outcome="fail",type="command"} 1 goss_tests_outcomes_total{outcome="pass",type="command"} 1 - goss_tests_outcomes_total{outcome="skip",type="file"} 1 - goss_tests_outcomes_total{outcome="unknown",type="file"} 1 + goss_tests_outcomes_total{outcome="skip",type="command"} 1 # HELP goss_tests_run_duration_milliseconds The end-to-end duration of this run. # TYPE goss_tests_run_duration_milliseconds counter - goss_tests_run_duration_milliseconds{outcome="fail"} 9.223372036854e+12 + goss_tests_run_duration_milliseconds{outcome="pass"} 9.223372036854e+12 # HELP goss_tests_run_outcomes_total The outcomes of this run as a whole. # TYPE goss_tests_run_outcomes_total counter - goss_tests_run_outcomes_total{outcome="fail"} 1 -=== RUN TestPrometheusOutput/skip-success + goss_tests_run_outcomes_total{outcome="pass"} 1 +=== RUN TestPrometheusOutput/success-skip prometheus_test.go:515: # HELP goss_tests_outcomes_duration_milliseconds The duration of tests from this run. Note; tests run concurrently. # TYPE goss_tests_outcomes_duration_milliseconds counter goss_tests_outcomes_duration_milliseconds{outcome="pass",type="command"} 10 @@ -1719,62 +1741,56 @@ # HELP goss_tests_run_outcomes_total The outcomes of this run as a whole. # TYPE goss_tests_run_outcomes_total counter goss_tests_run_outcomes_total{outcome="fail"} 1 -=== RUN TestPrometheusOutput/fail-success +=== RUN TestPrometheusOutput/all-success-single-type prometheus_test.go:515: # HELP goss_tests_outcomes_duration_milliseconds The duration of tests from this run. Note; tests run concurrently. # TYPE goss_tests_outcomes_duration_milliseconds counter - goss_tests_outcomes_duration_milliseconds{outcome="fail",type="command"} 10 - goss_tests_outcomes_duration_milliseconds{outcome="pass",type="command"} 10 + goss_tests_outcomes_duration_milliseconds{outcome="pass",type="command"} 20 # HELP goss_tests_outcomes_total The number of test-outcomes from this run. # TYPE goss_tests_outcomes_total counter - goss_tests_outcomes_total{outcome="fail",type="command"} 1 - goss_tests_outcomes_total{outcome="pass",type="command"} 1 + goss_tests_outcomes_total{outcome="pass",type="command"} 2 # HELP goss_tests_run_duration_milliseconds The end-to-end duration of this run. # TYPE goss_tests_run_duration_milliseconds counter - goss_tests_run_duration_milliseconds{outcome="fail"} 9.223372036854e+12 + goss_tests_run_duration_milliseconds{outcome="pass"} 9.223372036854e+12 # HELP goss_tests_run_outcomes_total The outcomes of this run as a whole. # TYPE goss_tests_run_outcomes_total counter - goss_tests_run_outcomes_total{outcome="fail"} 1 -=== RUN TestPrometheusOutput/all-unknown-single-type + goss_tests_run_outcomes_total{outcome="pass"} 1 +=== RUN TestPrometheusOutput/all-skip-single-type prometheus_test.go:515: # HELP goss_tests_outcomes_duration_milliseconds The duration of tests from this run. Note; tests run concurrently. # TYPE goss_tests_outcomes_duration_milliseconds counter - goss_tests_outcomes_duration_milliseconds{outcome="unknown",type="command"} 20 + goss_tests_outcomes_duration_milliseconds{outcome="skip",type="command"} 20 # HELP goss_tests_outcomes_total The number of test-outcomes from this run. # TYPE goss_tests_outcomes_total counter - goss_tests_outcomes_total{outcome="unknown",type="command"} 2 + goss_tests_outcomes_total{outcome="skip",type="command"} 2 # HELP goss_tests_run_duration_milliseconds The end-to-end duration of this run. # TYPE goss_tests_run_duration_milliseconds counter - goss_tests_run_duration_milliseconds{outcome="unknown"} 9.223372036854e+12 + goss_tests_run_duration_milliseconds{outcome="skip"} 9.223372036854e+12 # HELP goss_tests_run_outcomes_total The outcomes of this run as a whole. # TYPE goss_tests_run_outcomes_total counter - goss_tests_run_outcomes_total{outcome="unknown"} 1 -=== RUN TestPrometheusOutput/various-results-single-type + goss_tests_run_outcomes_total{outcome="skip"} 1 +=== RUN TestPrometheusOutput/skip-unknown prometheus_test.go:515: # HELP goss_tests_outcomes_duration_milliseconds The duration of tests from this run. Note; tests run concurrently. # TYPE goss_tests_outcomes_duration_milliseconds counter - goss_tests_outcomes_duration_milliseconds{outcome="fail",type="command"} 10 - goss_tests_outcomes_duration_milliseconds{outcome="pass",type="command"} 10 goss_tests_outcomes_duration_milliseconds{outcome="skip",type="command"} 10 goss_tests_outcomes_duration_milliseconds{outcome="unknown",type="command"} 10 # HELP goss_tests_outcomes_total The number of test-outcomes from this run. # TYPE goss_tests_outcomes_total counter - goss_tests_outcomes_total{outcome="fail",type="command"} 1 - goss_tests_outcomes_total{outcome="pass",type="command"} 1 goss_tests_outcomes_total{outcome="skip",type="command"} 1 goss_tests_outcomes_total{outcome="unknown",type="command"} 1 # HELP goss_tests_run_duration_milliseconds The end-to-end duration of this run. # TYPE goss_tests_run_duration_milliseconds counter - goss_tests_run_duration_milliseconds{outcome="fail"} 9.223372036854e+12 + goss_tests_run_duration_milliseconds{outcome="unknown"} 9.223372036854e+12 # HELP goss_tests_run_outcomes_total The outcomes of this run as a whole. # TYPE goss_tests_run_outcomes_total counter - goss_tests_run_outcomes_total{outcome="fail"} 1 -=== RUN TestPrometheusOutput/fail-skip + goss_tests_run_outcomes_total{outcome="unknown"} 1 +=== RUN TestPrometheusOutput/fail-success prometheus_test.go:515: # HELP goss_tests_outcomes_duration_milliseconds The duration of tests from this run. Note; tests run concurrently. # TYPE goss_tests_outcomes_duration_milliseconds counter goss_tests_outcomes_duration_milliseconds{outcome="fail",type="command"} 10 - goss_tests_outcomes_duration_milliseconds{outcome="skip",type="command"} 10 + goss_tests_outcomes_duration_milliseconds{outcome="pass",type="command"} 10 # HELP goss_tests_outcomes_total The number of test-outcomes from this run. # TYPE goss_tests_outcomes_total counter goss_tests_outcomes_total{outcome="fail",type="command"} 1 - goss_tests_outcomes_total{outcome="skip",type="command"} 1 + goss_tests_outcomes_total{outcome="pass",type="command"} 1 # HELP goss_tests_run_duration_milliseconds The end-to-end duration of this run. # TYPE goss_tests_run_duration_milliseconds counter goss_tests_run_duration_milliseconds{outcome="fail"} 9.223372036854e+12 @@ -1782,28 +1798,36 @@ # TYPE goss_tests_run_outcomes_total counter goss_tests_run_outcomes_total{outcome="fail"} 1 --- PASS: TestPrometheusOutput (0.00s) - --- PASS: TestPrometheusOutput/all-success-single-type (0.00s) - --- PASS: TestPrometheusOutput/all-fail-single-type (0.00s) - --- PASS: TestPrometheusOutput/unknown-success (0.00s) + --- PASS: TestPrometheusOutput/all-success-multiple-types (0.00s) + --- PASS: TestPrometheusOutput/various-results-multiple-types (0.00s) --- PASS: TestPrometheusOutput/unknown-fail (0.00s) - --- PASS: TestPrometheusOutput/skip-unknown (0.00s) + --- PASS: TestPrometheusOutput/success-unknown (0.00s) + --- PASS: TestPrometheusOutput/no-results (0.00s) + --- PASS: TestPrometheusOutput/verbose (0.00s) + --- PASS: TestPrometheusOutput/all-unknown-single-type (0.00s) + --- PASS: TestPrometheusOutput/various-results-single-type (0.00s) + --- PASS: TestPrometheusOutput/unknown-success (0.00s) --- PASS: TestPrometheusOutput/skip-fail (0.00s) --- PASS: TestPrometheusOutput/fail-unknown (0.00s) - --- PASS: TestPrometheusOutput/success-unknown (0.00s) - --- PASS: TestPrometheusOutput/all-skip-single-type (0.00s) - --- PASS: TestPrometheusOutput/all-success-multiple-types (0.00s) + --- PASS: TestPrometheusOutput/fail-skip (0.00s) + --- PASS: TestPrometheusOutput/all-fail-single-type (0.00s) --- PASS: TestPrometheusOutput/unknown-skip (0.00s) - --- PASS: TestPrometheusOutput/success-skip (0.00s) - --- PASS: TestPrometheusOutput/verbose (0.00s) - --- PASS: TestPrometheusOutput/no-results (0.00s) - --- PASS: TestPrometheusOutput/various-results-multiple-types (0.00s) --- PASS: TestPrometheusOutput/skip-success (0.00s) + --- PASS: TestPrometheusOutput/success-skip (0.00s) --- PASS: TestPrometheusOutput/success-fail (0.00s) + --- PASS: TestPrometheusOutput/all-success-single-type (0.00s) + --- PASS: TestPrometheusOutput/all-skip-single-type (0.00s) + --- PASS: TestPrometheusOutput/skip-unknown (0.00s) --- PASS: TestPrometheusOutput/fail-success (0.00s) - --- PASS: TestPrometheusOutput/all-unknown-single-type (0.00s) - --- PASS: TestPrometheusOutput/various-results-single-type (0.00s) - --- PASS: TestPrometheusOutput/fail-skip (0.00s) === RUN TestCanChangeOverallOutcome +=== RUN TestCanChangeOverallOutcome/pass/unknown +=== RUN TestCanChangeOverallOutcome/pass/pass +=== RUN TestCanChangeOverallOutcome/pass/skip +=== RUN TestCanChangeOverallOutcome/pass/fail +=== RUN TestCanChangeOverallOutcome/skip/pass +=== RUN TestCanChangeOverallOutcome/skip/skip +=== RUN TestCanChangeOverallOutcome/skip/fail +=== RUN TestCanChangeOverallOutcome/skip/unknown === RUN TestCanChangeOverallOutcome/fail/pass === RUN TestCanChangeOverallOutcome/fail/skip === RUN TestCanChangeOverallOutcome/fail/fail @@ -1812,15 +1836,15 @@ === RUN TestCanChangeOverallOutcome/unknown/skip === RUN TestCanChangeOverallOutcome/unknown/fail === RUN TestCanChangeOverallOutcome/unknown/unknown -=== RUN TestCanChangeOverallOutcome/pass/pass -=== RUN TestCanChangeOverallOutcome/pass/skip -=== RUN TestCanChangeOverallOutcome/pass/fail -=== RUN TestCanChangeOverallOutcome/pass/unknown -=== RUN TestCanChangeOverallOutcome/skip/skip -=== RUN TestCanChangeOverallOutcome/skip/fail -=== RUN TestCanChangeOverallOutcome/skip/unknown -=== RUN TestCanChangeOverallOutcome/skip/pass --- PASS: TestCanChangeOverallOutcome (0.00s) + --- PASS: TestCanChangeOverallOutcome/pass/unknown (0.00s) + --- PASS: TestCanChangeOverallOutcome/pass/pass (0.00s) + --- PASS: TestCanChangeOverallOutcome/pass/skip (0.00s) + --- PASS: TestCanChangeOverallOutcome/pass/fail (0.00s) + --- PASS: TestCanChangeOverallOutcome/skip/pass (0.00s) + --- PASS: TestCanChangeOverallOutcome/skip/skip (0.00s) + --- PASS: TestCanChangeOverallOutcome/skip/fail (0.00s) + --- PASS: TestCanChangeOverallOutcome/skip/unknown (0.00s) --- PASS: TestCanChangeOverallOutcome/fail/pass (0.00s) --- PASS: TestCanChangeOverallOutcome/fail/skip (0.00s) --- PASS: TestCanChangeOverallOutcome/fail/fail (0.00s) @@ -1829,16 +1853,8 @@ --- PASS: TestCanChangeOverallOutcome/unknown/skip (0.00s) --- PASS: TestCanChangeOverallOutcome/unknown/fail (0.00s) --- PASS: TestCanChangeOverallOutcome/unknown/unknown (0.00s) - --- PASS: TestCanChangeOverallOutcome/pass/pass (0.00s) - --- PASS: TestCanChangeOverallOutcome/pass/skip (0.00s) - --- PASS: TestCanChangeOverallOutcome/pass/fail (0.00s) - --- PASS: TestCanChangeOverallOutcome/pass/unknown (0.00s) - --- PASS: TestCanChangeOverallOutcome/skip/skip (0.00s) - --- PASS: TestCanChangeOverallOutcome/skip/fail (0.00s) - --- PASS: TestCanChangeOverallOutcome/skip/unknown (0.00s) - --- PASS: TestCanChangeOverallOutcome/skip/pass (0.00s) PASS -ok github.com/goss-org/goss/outputs 0.011s +ok github.com/goss-org/goss/outputs 0.010s === RUN TestMatcherToGomegaMatcher --- PASS: TestMatcherToGomegaMatcher (0.00s) === RUN TestValidateValue @@ -1858,7 +1874,7 @@ === RUN TestResultMarshaling --- PASS: TestResultMarshaling (0.00s) PASS -ok github.com/goss-org/goss/resource 0.007s +ok github.com/goss-org/goss/resource 0.005s === RUN TestCommandWrapper === PAUSE TestCommandWrapper === RUN TestParseServerString @@ -1879,16 +1895,16 @@ --- PASS: TestGroupsForUser (0.00s) === CONT TestCommandWrapper --- PASS: TestCommandWrapper (0.00s) -=== CONT TestDetectService === CONT TestHasCommand ---- PASS: TestDetectService (0.00s) -=== CONT TestPackageManager ---- PASS: TestPackageManager (0.00s) --- PASS: TestHasCommand (0.00s) === CONT TestDetectDistro --- PASS: TestDetectDistro (0.00s) +=== CONT TestDetectService +--- PASS: TestDetectService (0.00s) +=== CONT TestPackageManager +--- PASS: TestPackageManager (0.00s) PASS -ok github.com/goss-org/goss/system 0.006s +ok github.com/goss-org/goss/system 0.004s === RUN TestWithVarsBytes --- PASS: TestWithVarsBytes (0.00s) === RUN TestWithVarsString @@ -1927,8 +1943,8 @@ dpkg-gencontrol: warning: package goss: substitution variable ${misc:Static-Built-Using} unused, but is defined dh_md5sums -O--builddirectory=_build -O--buildsystem=golang dh_builddeb -O--builddirectory=_build -O--buildsystem=golang -dpkg-deb: building package 'goss' in '../goss_0.4.9-1_amd64.deb'. dpkg-deb: building package 'goss-dbgsym' in '../goss-dbgsym_0.4.9-1_amd64.deb'. +dpkg-deb: building package 'goss' in '../goss_0.4.9-1_amd64.deb'. dpkg-genbuildinfo --build=binary -O../goss_0.4.9-1_amd64.buildinfo dpkg-genchanges --build=binary -O../goss_0.4.9-1_amd64.changes dpkg-genchanges: info: binary-only upload (no source code included) @@ -1936,12 +1952,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/1749593/tmp/hooks/B01_cleanup starting +I: user script /srv/workspace/pbuilder/1749593/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/2737452 and its subdirectories -I: Current time: Sun Nov 30 17:38:13 -12 2025 -I: pbuilder-time-stamp: 1764567493 +I: removing directory /srv/workspace/pbuilder/1749593 and its subdirectories +I: Current time: Tue Oct 29 13:18:19 +14 2024 +I: pbuilder-time-stamp: 1730157499