Diff of the two buildlogs: -- --- b1/build.log 2024-06-06 14:57:37.493203255 +0000 +++ b2/build.log 2024-06-06 15:06:27.722648769 +0000 @@ -1,6 +1,6 @@ I: pbuilder: network access will be disabled during build -I: Current time: Wed Jul 9 09:18:51 -12 2025 -I: pbuilder-time-stamp: 1752095931 +I: Current time: Fri Jun 7 04:57:40 +14 2024 +I: pbuilder-time-stamp: 1717685860 I: Building the build Environment I: extracting base tarball [/var/cache/pbuilder/trixie-reproducible-base.tgz] I: copying local configuration @@ -31,52 +31,84 @@ dpkg-source: info: applying 0004-Use-github.com-golang-protobuf-ptypes-empty.patch I: Not using root during the build. I: Installing the build-deps -I: user script /srv/workspace/pbuilder/3120511/tmp/hooks/D02_print_environment starting +I: user script /srv/workspace/pbuilder/3017386/tmp/hooks/D01_modify_environment starting +debug: Running on ionos1-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 Jun 6 14:58 /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/3017386/tmp/hooks/D01_modify_environment finished +I: user script /srv/workspace/pbuilder/3017386/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' - DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all parallel=42 ' - DISTRIBUTION='trixie' - HOME='/root' - HOST_ARCH='amd64' + BASH=/bin/sh + BASHOPTS=checkwinsize:cmdhist:complete_fullquote:extquote:force_fignore:globasciiranges:globskipdots:hostcomplete:interactive_comments:patsub_replacement:progcomp:promptvars:sourcepath + BASH_ALIASES=() + BASH_ARGC=() + BASH_ARGV=() + BASH_CMDS=() + BASH_LINENO=([0]="12" [1]="0") + BASH_LOADABLES_PATH=/usr/local/lib/bash:/usr/lib/bash:/opt/local/lib/bash:/usr/pkg/lib/bash:/opt/pkg/lib/bash:. + BASH_SOURCE=([0]="/tmp/hooks/D02_print_environment" [1]="/tmp/hooks/D02_print_environment") + BASH_VERSINFO=([0]="5" [1]="2" [2]="21" [3]="1" [4]="release" [5]="x86_64-pc-linux-gnu") + BASH_VERSION='5.2.21(1)-release' + BUILDDIR=/build/reproducible-path + BUILDUSERGECOS='second user,second room,second work-phone,second home-phone,second other' + BUILDUSERNAME=pbuilder2 + BUILD_ARCH=amd64 + DEBIAN_FRONTEND=noninteractive + DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all parallel=20 ' + 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='ff5e912ad27747a6839996f4483425d0' - 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='3120511' - PS1='# ' - PS2='> ' + INVOCATION_ID=4c6910849d3540d0b7820f0876dea7d6 + 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=3017386 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.O04S8L5Y/pbuilderrc_6ujo --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.O04S8L5Y/b1 --logfile b1/build.log notary_0.7.0+ds1-2.dsc' - SUDO_GID='110' - SUDO_UID='105' - SUDO_USER='jenkins' - TERM='unknown' - TZ='/usr/share/zoneinfo/Etc/GMT+12' - USER='root' - _='/usr/bin/systemd-run' - http_proxy='http://213.165.73.152:3128' + PWD=/ + SHELL=/bin/bash + SHELLOPTS=braceexpand:errexit:hashall:interactive-comments:posix + SHLVL=3 + SUDO_COMMAND='/usr/bin/timeout -k 24.1h 24h /usr/bin/ionice -c 3 /usr/bin/nice -n 11 /usr/bin/unshare --uts -- /usr/sbin/pbuilder --build --configfile /srv/reproducible-results/rbuild-debian/r-b-build.O04S8L5Y/pbuilderrc_Wv66 --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.O04S8L5Y/b2 --logfile b2/build.log notary_0.7.0+ds1-2.dsc' + SUDO_GID=110 + SUDO_UID=105 + SUDO_USER=jenkins + TERM=unknown + TZ=/usr/share/zoneinfo/Etc/GMT-14 + UID=0 + USER=root + _='I: set' + http_proxy=http://46.16.76.132:3128 I: uname -a - Linux ionos5-amd64 6.7.12+bpo-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.7.12-1~bpo12+1 (2024-05-06) x86_64 GNU/Linux + Linux i-capture-the-hostname 6.1.0-21-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.1.90-1 (2024-05-03) x86_64 GNU/Linux I: ls -l /bin - lrwxrwxrwx 1 root root 7 Jul 8 17:46 /bin -> usr/bin -I: user script /srv/workspace/pbuilder/3120511/tmp/hooks/D02_print_environment finished + lrwxrwxrwx 1 root root 7 Jun 5 11:24 /bin -> usr/bin +I: user script /srv/workspace/pbuilder/3017386/tmp/hooks/D02_print_environment finished -> Attempting to satisfy build-dependencies -> Creating pbuilder-satisfydepends-dummy package Package: pbuilder-satisfydepends-dummy @@ -354,7 +386,7 @@ Get: 186 http://deb.debian.org/debian trixie/main amd64 golang-goprotobuf-dev amd64 1.3.5-4+b6 [3444 B] Get: 187 http://deb.debian.org/debian trixie/main amd64 golang-gopkg-rethinkdb-rethinkdb-go.v6-dev all 6.2.1-2 [106 kB] Get: 188 http://deb.debian.org/debian trixie/main amd64 openssl amd64 3.2.1-3 [1360 kB] -Fetched 109 MB in 4s (25.4 MB/s) +Fetched 109 MB in 2s (46.6 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 ... 19698 files and directories currently installed.) @@ -1121,7 +1153,11 @@ Building tag database... -> Finished parsing the build-deps I: Building the package -I: Running cd /build/reproducible-path/notary-0.7.0+ds1/ && 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 > ../notary_0.7.0+ds1-2_source.changes +I: user script /srv/workspace/pbuilder/3017386/tmp/hooks/A99_set_merged_usr starting +Not re-configuring usrmerge for trixie +I: user script /srv/workspace/pbuilder/3017386/tmp/hooks/A99_set_merged_usr finished +hostname: Name or service not known +I: Running cd /build/reproducible-path/notary-0.7.0+ds1/ && 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 > ../notary_0.7.0+ds1-2_source.changes dpkg-buildpackage: info: source package notary dpkg-buildpackage: info: source version 0.7.0+ds1-2 dpkg-buildpackage: info: source distribution unstable @@ -1400,283 +1436,283 @@ src/github.com/theupdateframework/notary/utils/http.go src/github.com/theupdateframework/notary/utils/http_test.go src/github.com/theupdateframework/notary/version/version.go - cd _build && go install -trimpath -v -p 42 -tags pkcs11 github.com/theupdateframework/notary github.com/theupdateframework/notary/client github.com/theupdateframework/notary/client/changelist github.com/theupdateframework/notary/cmd/escrow github.com/theupdateframework/notary/cmd/notary github.com/theupdateframework/notary/cmd/notary-server github.com/theupdateframework/notary/cmd/notary-signer github.com/theupdateframework/notary/cryptoservice github.com/theupdateframework/notary/passphrase github.com/theupdateframework/notary/proto github.com/theupdateframework/notary/server github.com/theupdateframework/notary/server/errors github.com/theupdateframework/notary/server/handlers github.com/theupdateframework/notary/server/snapshot github.com/theupdateframework/notary/server/storage github.com/theupdateframework/notary/server/timestamp github.com/theupdateframework/notary/signer github.com/theupdateframework/notary/signer/api github.com/theupdateframework/notary/signer/client github.com/theupdateframework/notary/signer/keydbstore github.com/theupdateframework/notary/storage github.com/theupdateframework/notary/storage/rethinkdb github.com/theupdateframework/notary/trustmanager github.com/theupdateframework/notary/trustmanager/remoteks github.com/theupdateframework/notary/trustmanager/yubikey github.com/theupdateframework/notary/trustpinning github.com/theupdateframework/notary/tuf github.com/theupdateframework/notary/tuf/data github.com/theupdateframework/notary/tuf/signed github.com/theupdateframework/notary/tuf/testutils github.com/theupdateframework/notary/tuf/testutils/interfaces github.com/theupdateframework/notary/tuf/testutils/keys github.com/theupdateframework/notary/tuf/utils github.com/theupdateframework/notary/tuf/validation github.com/theupdateframework/notary/utils github.com/theupdateframework/notary/version -internal/coverage/rtcov -vendor/golang.org/x/crypto/cryptobyte/asn1 -internal/godebugs + cd _build && go install -trimpath -v -p 20 -tags pkcs11 github.com/theupdateframework/notary github.com/theupdateframework/notary/client github.com/theupdateframework/notary/client/changelist github.com/theupdateframework/notary/cmd/escrow github.com/theupdateframework/notary/cmd/notary github.com/theupdateframework/notary/cmd/notary-server github.com/theupdateframework/notary/cmd/notary-signer github.com/theupdateframework/notary/cryptoservice github.com/theupdateframework/notary/passphrase github.com/theupdateframework/notary/proto github.com/theupdateframework/notary/server github.com/theupdateframework/notary/server/errors github.com/theupdateframework/notary/server/handlers github.com/theupdateframework/notary/server/snapshot github.com/theupdateframework/notary/server/storage github.com/theupdateframework/notary/server/timestamp github.com/theupdateframework/notary/signer github.com/theupdateframework/notary/signer/api github.com/theupdateframework/notary/signer/client github.com/theupdateframework/notary/signer/keydbstore github.com/theupdateframework/notary/storage github.com/theupdateframework/notary/storage/rethinkdb github.com/theupdateframework/notary/trustmanager github.com/theupdateframework/notary/trustmanager/remoteks github.com/theupdateframework/notary/trustmanager/yubikey github.com/theupdateframework/notary/trustpinning github.com/theupdateframework/notary/tuf github.com/theupdateframework/notary/tuf/data github.com/theupdateframework/notary/tuf/signed github.com/theupdateframework/notary/tuf/testutils github.com/theupdateframework/notary/tuf/testutils/interfaces github.com/theupdateframework/notary/tuf/testutils/keys github.com/theupdateframework/notary/tuf/utils github.com/theupdateframework/notary/tuf/validation github.com/theupdateframework/notary/utils github.com/theupdateframework/notary/version internal/unsafeheader -internal/nettrace -google.golang.org/grpc/serviceconfig -github.com/theupdateframework/notary/version -container/list -google.golang.org/protobuf/internal/flags -vendor/golang.org/x/crypto/internal/alias -github.com/lib/pq/oid +cmp +encoding internal/goexperiment +unicode/utf16 +internal/godebugs +internal/goarch +crypto/internal/alias +internal/coverage/rtcov log/internal internal/goos -encoding +unicode/utf8 +runtime/internal/syscall +runtime/internal/atomic math/bits -cmp internal/race -unicode/utf8 -crypto/internal/alias -unicode/utf16 -unicode -internal/goarch -internal/itoa internal/cpu +internal/itoa +vendor/golang.org/x/crypto/cryptobyte/asn1 +unicode crypto/internal/boring/sig -crypto/subtle -runtime/internal/syscall -runtime/internal/atomic sync/atomic +crypto/subtle +internal/nettrace +container/list +vendor/golang.org/x/crypto/internal/alias +google.golang.org/grpc/serviceconfig +google.golang.org/protobuf/internal/flags internal/chacha8rand internal/abi runtime/internal/math runtime/internal/sys -google.golang.org/protobuf/internal/set +github.com/theupdateframework/notary/version +github.com/lib/pq/oid github.com/pelletier/go-toml/v2/internal/characters +google.golang.org/protobuf/internal/set slices internal/bytealg math runtime +sync internal/reflectlite runtime/metrics -sync internal/testlog internal/singleflight -google.golang.org/grpc/internal/grpcsync github.com/spf13/viper/internal/encoding -internal/bisect google.golang.org/grpc/internal/buffer +google.golang.org/grpc/internal/grpcsync google.golang.org/protobuf/internal/pragma +internal/bisect runtime/cgo -internal/godebug errors -sort io +strconv +sort +internal/godebug github.com/hashicorp/hcl/hcl/strconv -internal/oserror internal/safefilepath -internal/intern path -vendor/golang.org/x/net/dns/dnsmessage -math/rand -strconv crypto/internal/nistec/fiat -syscall -github.com/beorn7/perks/quantile -crypto/internal/randutil +vendor/golang.org/x/net/dns/dnsmessage +internal/oserror hash -text/tabwriter bytes +crypto/internal/randutil strings +internal/intern +text/tabwriter +math/rand +syscall hash/crc32 hash/fnv -vendor/golang.org/x/text/transform -golang.org/x/text/transform -github.com/dvsekhvalnov/jose2go/padding crypto +reflect +net/netip crypto/rc4 -golang.org/x/crypto/blowfish encoding/base32 -net/netip -reflect +golang.org/x/crypto/blowfish +github.com/beorn7/perks/quantile +vendor/golang.org/x/text/transform +golang.org/x/text/transform +github.com/dvsekhvalnov/jose2go/padding +regexp/syntax net/http/internal/ascii -bufio google.golang.org/grpc/encoding +html +bufio github.com/prometheus/common/internal/bitbucket.org/ww/goautoneg net/http/internal/testcert -html -regexp/syntax golang.org/x/text/runes -internal/syscall/execenv +regexp internal/syscall/unix +internal/syscall/execenv time -regexp github.com/jinzhu/inflection -google.golang.org/grpc/backoff -google.golang.org/grpc/keepalive -github.com/bugsnag/bugsnag-go/headers +internal/poll context -google.golang.org/grpc/internal/grpcrand +github.com/bugsnag/bugsnag-go/headers io/fs -internal/poll +google.golang.org/grpc/keepalive +google.golang.org/grpc/internal/grpcrand +google.golang.org/grpc/backoff google.golang.org/grpc/internal/backoff -internal/fmtsort -encoding/binary embed github.com/spf13/afero/internal/common -google.golang.org/grpc/tap golang.org/x/net/context +google.golang.org/grpc/tap gopkg.in/rethinkdb/rethinkdb-go.v6/vendor/gopkg.in/cenkalti/backoff.v2 -google.golang.org/protobuf/internal/editiondefaults os +google.golang.org/protobuf/internal/editiondefaults +encoding/binary +internal/fmtsort crypto/md5 encoding/base64 +crypto/cipher crypto/internal/edwards25519/field vendor/golang.org/x/crypto/internal/poly1305 -github.com/cespare/xxhash -crypto/cipher crypto/internal/nistec +github.com/cespare/xxhash golang.org/x/sys/unix -github.com/dvsekhvalnov/jose2go/base64url -encoding/pem -crypto/internal/edwards25519 -github.com/dvsekhvalnov/jose2go/compact -crypto/internal/boring -vendor/golang.org/x/crypto/chacha20 -crypto/des -crypto/sha1 -crypto/hmac -crypto/sha512 -crypto/sha256 -crypto/aes -golang.org/x/crypto/pbkdf2 -vendor/golang.org/x/crypto/hkdf -crypto/ecdh -google.golang.org/grpc/internal/envconfig +fmt +path/filepath io/ioutil +google.golang.org/grpc/internal/envconfig +vendor/golang.org/x/sys/cpu github.com/bugsnag/bugsnag-go/device -github.com/theupdateframework/notary google.golang.org/protobuf/internal/detrand -internal/lazyregexp -github.com/prometheus/procfs/internal/util internal/sysinfo -path/filepath +github.com/prometheus/procfs/internal/util os/signal -vendor/golang.org/x/sys/cpu -fmt -net +internal/lazyregexp +encoding/pem +github.com/dvsekhvalnov/jose2go/base64url +crypto/internal/boring +crypto/des +vendor/golang.org/x/crypto/chacha20 +github.com/theupdateframework/notary +crypto/internal/edwards25519 +github.com/dvsekhvalnov/jose2go/compact +crypto/aes +crypto/sha512 +crypto/sha256 +crypto/hmac +crypto/sha1 vendor/golang.org/x/crypto/chacha20poly1305 github.com/spf13/afero/mem os/exec +golang.org/x/crypto/pbkdf2 +vendor/golang.org/x/crypto/hkdf +net github.com/bugsnag/panicwrap +crypto/ecdh log +github.com/docker/go/canonical/json encoding/hex -mime/quotedprintable +encoding/json net/url mime +mime/quotedprintable +math/big +compress/flate +vendor/golang.org/x/text/unicode/norm net/http/internal -github.com/docker/go/canonical/json vendor/golang.org/x/net/http2/hpack flag -google.golang.org/protobuf/internal/version -github.com/subosito/gotenv encoding/csv -compress/flate -github.com/opentracing/opentracing-go/log -go/token -database/sql/driver -google.golang.org/grpc/attributes -github.com/pelletier/go-toml/v2/internal/danger -runtime/debug -gopkg.in/rethinkdb/rethinkdb-go.v6/encoding -gopkg.in/ini.v1 -math/big -encoding/json -google.golang.org/grpc/metadata -google.golang.org/grpc/internal/grpclog -github.com/hashicorp/hcl/hcl/token -gopkg.in/rethinkdb/rethinkdb-go.v6/types -github.com/pkg/errors -github.com/opencontainers/image-spec/specs-go -golang.org/x/net/http2/hpack -google.golang.org/grpc/codes -google.golang.org/protobuf/internal/errors -gopkg.in/yaml.v3 -text/template/parse -github.com/opencontainers/go-digest -github.com/prometheus/procfs/internal/fs github.com/miekg/pkcs11 -vendor/golang.org/x/text/unicode/norm -os/user +github.com/subosito/gotenv +text/template/parse golang.org/x/text/unicode/norm -runtime/trace -github.com/pmezard/go-difflib/difflib +github.com/hashicorp/hcl/hcl/token +gopkg.in/ini.v1 +github.com/pelletier/go-toml/v2/internal/danger github.com/pelletier/go-toml/v2/unstable -google.golang.org/protobuf/encoding/protowire -github.com/davecgh/go-spew/spew -google.golang.org/grpc/internal/balancerload +vendor/golang.org/x/text/unicode/bidi +github.com/spf13/jwalterweatherman github.com/hashicorp/hcl/hcl/ast github.com/hashicorp/hcl/hcl/scanner github.com/hashicorp/hcl/json/token -google.golang.org/protobuf/reflect/protoreflect -github.com/bugsnag/bugsnag-go/errors -go/scanner +gopkg.in/yaml.v3 golang.org/x/net/internal/timeseries +google.golang.org/grpc/internal/grpclog +github.com/hashicorp/hcl/hcl/parser +google.golang.org/grpc/attributes +github.com/hashicorp/hcl/json/scanner +google.golang.org/grpc/metadata +github.com/pelletier/go-toml/v2/internal/tracker +google.golang.org/grpc/codes google.golang.org/grpc/grpclog -github.com/hailocab/go-hostpool -github.com/docker/distribution/digestset +google.golang.org/grpc/internal/balancerload +compress/gzip golang.org/x/text/unicode/bidi -github.com/opencontainers/image-spec/specs-go/v1 -github.com/spf13/jwalterweatherman -github.com/hashicorp/hcl/json/scanner -vendor/golang.org/x/text/unicode/bidi -github.com/hashicorp/hcl/hcl/parser -database/sql -testing github.com/hashicorp/hcl/json/parser -github.com/docker/distribution/reference -google.golang.org/grpc/connectivity -go/ast -github.com/pelletier/go-toml/v2/internal/tracker +golang.org/x/net/http2/hpack github.com/hashicorp/hcl/hcl/printer -compress/gzip +github.com/pkg/errors +database/sql/driver +github.com/opencontainers/go-digest +google.golang.org/grpc/connectivity github.com/hashicorp/hcl google.golang.org/grpc/internal -internal/profile -runtime/pprof +github.com/opencontainers/image-spec/specs-go +google.golang.org/protobuf/internal/errors +go/token +github.com/bugsnag/bugsnag-go/errors +github.com/docker/distribution/digestset +github.com/opencontainers/image-spec/specs-go/v1 +google.golang.org/protobuf/encoding/protowire +vendor/golang.org/x/text/secure/bidirule +google.golang.org/protobuf/internal/version +github.com/prometheus/procfs/internal/fs +database/sql +runtime/debug +os/user +github.com/docker/distribution/reference +go/scanner +github.com/hailocab/go-hostpool golang.org/x/text/secure/bidirule +google.golang.org/protobuf/reflect/protoreflect +github.com/opentracing/opentracing-go/log +gopkg.in/rethinkdb/rethinkdb-go.v6/encoding +gopkg.in/rethinkdb/rethinkdb-go.v6/types text/template -vendor/golang.org/x/text/secure/bidirule +internal/profile +runtime/pprof +runtime/trace +vendor/golang.org/x/net/idna +github.com/davecgh/go-spew/spew +github.com/pmezard/go-difflib/difflib +testing +golang.org/x/net/idna +go/ast +github.com/theupdateframework/notary/tuf/validation +github.com/spf13/viper/internal/encoding/hcl +github.com/spf13/viper/internal/encoding/json +github.com/fsnotify/fsnotify +github.com/sirupsen/logrus +github.com/pelletier/go-toml/v2 +github.com/golang/protobuf/proto +google.golang.org/protobuf/internal/descfmt google.golang.org/protobuf/internal/descopts google.golang.org/protobuf/internal/strs google.golang.org/protobuf/internal/encoding/messageset -google.golang.org/protobuf/internal/descfmt -google.golang.org/protobuf/internal/order google.golang.org/protobuf/internal/genid -google.golang.org/protobuf/runtime/protoiface google.golang.org/protobuf/internal/encoding/text +google.golang.org/protobuf/internal/order google.golang.org/protobuf/reflect/protoregistry -github.com/theupdateframework/notary/tuf/validation -github.com/spf13/viper/internal/encoding/hcl -github.com/spf13/viper/internal/encoding/json -github.com/pelletier/go-toml/v2 -github.com/golang/protobuf/proto -vendor/golang.org/x/net/idna -google.golang.org/protobuf/proto -golang.org/x/net/idna -github.com/jinzhu/gorm -google.golang.org/protobuf/internal/encoding/defval -github.com/fsnotify/fsnotify -golang.org/x/term -github.com/sirupsen/logrus crypto/rand crypto/elliptic crypto/internal/bigmod crypto/internal/boring/bbig -crypto/dsa encoding/asn1 +crypto/dsa +github.com/spf13/viper/internal/encoding/yaml +google.golang.org/protobuf/runtime/protoiface github.com/docker/distribution/uuid -github.com/dvsekhvalnov/jose2go/arrays -github.com/lib/pq/scram crypto/ed25519 +golang.org/x/term golang.org/x/crypto/bcrypt +github.com/lib/pq/scram +github.com/dvsekhvalnov/jose2go/arrays +golang.org/x/crypto/ed25519 html/template -google.golang.org/protobuf/internal/filedesc -google.golang.org/protobuf/encoding/protodelim +google.golang.org/protobuf/internal/encoding/defval +google.golang.org/protobuf/proto github.com/dvsekhvalnov/jose2go/aes github.com/dvsekhvalnov/jose2go/kdf -google.golang.org/protobuf/encoding/prototext -golang.org/x/crypto/ed25519 -github.com/theupdateframework/notary/passphrase +github.com/jinzhu/gorm crypto/rsa +github.com/theupdateframework/notary/passphrase github.com/spf13/viper/internal/encoding/toml vendor/golang.org/x/crypto/cryptobyte crypto/x509/pkix -github.com/spf13/viper/internal/encoding/yaml +google.golang.org/protobuf/encoding/protodelim +google.golang.org/protobuf/encoding/prototext +google.golang.org/protobuf/internal/filedesc crypto/ecdsa github.com/spf13/cast github.com/spf13/viper/internal/encoding/dotenv @@ -1684,8 +1720,8 @@ google.golang.org/protobuf/internal/encoding/tag google.golang.org/protobuf/internal/impl github.com/golang/protobuf/ptypes/empty -github.com/golang/protobuf/ptypes/any google.golang.org/grpc/encoding/proto +github.com/golang/protobuf/ptypes/any github.com/golang/protobuf/ptypes/timestamp github.com/golang/protobuf/ptypes/duration gopkg.in/rethinkdb/rethinkdb-go.v6/ql2 @@ -1694,126 +1730,126 @@ google.golang.org/grpc/binarylog/grpc_binarylog_v1 google.golang.org/grpc/internal/status google.golang.org/grpc/status +crypto/x509 vendor/golang.org/x/net/http/httpproxy -google.golang.org/grpc/internal/syscall -google.golang.org/grpc/stats github.com/mitchellh/mapstructure -github.com/google/uuid net/textproto -crypto/x509 +google.golang.org/grpc/internal/syscall +google.golang.org/grpc/stats github.com/spf13/pflag +github.com/google/uuid github.com/prometheus/procfs -golang.org/x/net/http/httpguts -vendor/golang.org/x/net/http/httpguts mime/multipart +vendor/golang.org/x/net/http/httpguts +golang.org/x/net/http/httpguts +github.com/spf13/cobra github.com/theupdateframework/notary/tuf/data github.com/dvsekhvalnov/jose2go/keys/ecc crypto/tls google.golang.org/protobuf/internal/filetype github.com/dvsekhvalnov/jose2go -github.com/spf13/cobra google.golang.org/protobuf/runtime/protoimpl google.golang.org/protobuf/types/known/timestamppb -github.com/prometheus/client_model/go -github.com/theupdateframework/notary/client/changelist github.com/theupdateframework/notary/tuf/utils +github.com/theupdateframework/notary/client/changelist +github.com/prometheus/client_model/go github.com/prometheus/common/model github.com/prometheus/client_golang/prometheus/internal net/http/httptrace -github.com/docker/go-connections/tlsconfig google.golang.org/grpc/internal/credentials +github.com/docker/go-connections/tlsconfig github.com/docker/libtrust github.com/lib/pq github.com/go-sql-driver/mysql -net/http google.golang.org/grpc/credentials +net/http google.golang.org/grpc/resolver -google.golang.org/grpc/peer google.golang.org/grpc/internal/channelz +google.golang.org/grpc/peer +google.golang.org/grpc/balancer +google.golang.org/grpc/internal/grpcutil google.golang.org/grpc/balancer/grpclb/state google.golang.org/grpc/internal/resolver/passthrough -google.golang.org/grpc/internal/grpcutil -google.golang.org/grpc/balancer google.golang.org/grpc/internal/resolver/dns google.golang.org/grpc/internal/binarylog -google.golang.org/grpc/internal/serviceconfig google.golang.org/grpc/balancer/base +google.golang.org/grpc/internal/serviceconfig google.golang.org/grpc/balancer/roundrobin -github.com/docker/distribution/registry/auth -github.com/docker/distribution/registry/api/errcode +github.com/magiconair/properties +github.com/spf13/afero github.com/theupdateframework/notary/storage +golang.org/x/net/trace net/http/httputil -github.com/docker/distribution/registry/client/auth/challenge -expvar -github.com/magiconair/properties -github.com/docker/distribution/registry/client/transport net/http/pprof -github.com/docker/distribution -github.com/bugsnag/bugsnag-go/sessions net/http/httptest -github.com/gorilla/mux -golang.org/x/net/trace +github.com/bugsnag/bugsnag-go/sessions +golang.org/x/net/http2 +github.com/docker/distribution/registry/api/errcode +github.com/docker/distribution/registry/auth github.com/opentracing/opentracing-go +github.com/gorilla/mux github.com/prometheus/common/expfmt -golang.org/x/net/http2 -github.com/spf13/afero -github.com/theupdateframework/notary/server/errors -github.com/opentracing/opentracing-go/ext +github.com/docker/distribution +github.com/docker/distribution/registry/client/auth/challenge +github.com/docker/distribution/registry/client/transport +expvar github.com/bugsnag/bugsnag-go +github.com/opentracing/opentracing-go/ext +github.com/theupdateframework/notary/server/errors +gopkg.in/rethinkdb/rethinkdb-go.v6 +github.com/spf13/viper/internal/encoding/javaproperties github.com/stretchr/testify/assert github.com/theupdateframework/notary/trustmanager -gopkg.in/rethinkdb/rethinkdb-go.v6 +github.com/theupdateframework/notary/vendor/github.com/prometheus/client_golang/prometheus +github.com/prometheus/client_golang/prometheus github.com/docker/distribution/context github.com/docker/distribution/registry/api/v2 -github.com/spf13/viper/internal/encoding/javaproperties github.com/theupdateframework/notary/cryptoservice github.com/theupdateframework/notary/tuf/signed -github.com/docker/distribution/health -github.com/docker/distribution/registry/auth/htpasswd -github.com/docker/distribution/registry/auth/token -github.com/prometheus/client_golang/prometheus -github.com/theupdateframework/notary/vendor/github.com/prometheus/client_golang/prometheus github.com/Shopify/logrus-bugsnag github.com/theupdateframework/notary/trustpinning -github.com/theupdateframework/notary/tuf/testutils/keys github.com/theupdateframework/notary/trustmanager/yubikey -github.com/theupdateframework/notary/tuf +github.com/docker/distribution/registry/auth/htpasswd +github.com/docker/distribution/health +github.com/docker/distribution/registry/auth/token +github.com/theupdateframework/notary/tuf/testutils/keys github.com/spf13/viper +github.com/theupdateframework/notary/tuf github.com/theupdateframework/notary/client github.com/theupdateframework/notary/tuf/testutils -github.com/stretchr/testify/require github.com/theupdateframework/notary/utils +github.com/stretchr/testify/require github.com/prometheus/client_golang/prometheus/promhttp github.com/theupdateframework/notary/storage/rethinkdb -github.com/theupdateframework/notary/tuf/testutils/interfaces -github.com/theupdateframework/notary/signer/keydbstore -github.com/theupdateframework/notary/server/storage google.golang.org/grpc/internal/transport +github.com/theupdateframework/notary/server/storage +github.com/theupdateframework/notary/signer/keydbstore +github.com/theupdateframework/notary/tuf/testutils/interfaces github.com/theupdateframework/notary/server/snapshot github.com/docker/go-metrics github.com/theupdateframework/notary/server/timestamp github.com/theupdateframework/notary/server/handlers github.com/docker/distribution/metrics github.com/docker/distribution/registry/storage/cache -github.com/theupdateframework/notary/server github.com/docker/distribution/registry/storage/cache/memory +github.com/theupdateframework/notary/server github.com/docker/distribution/registry/client google.golang.org/grpc github.com/docker/distribution/registry/client/auth github.com/theupdateframework/notary/cmd/notary -google.golang.org/grpc/health/grpc_health_v1 github.com/theupdateframework/notary/trustmanager/remoteks github.com/theupdateframework/notary/proto +google.golang.org/grpc/health/grpc_health_v1 google.golang.org/grpc/health +github.com/theupdateframework/notary/cmd/escrow github.com/theupdateframework/notary/signer/client github.com/theupdateframework/notary/signer -github.com/theupdateframework/notary/cmd/escrow github.com/theupdateframework/notary/signer/api -github.com/theupdateframework/notary/cmd/notary-signer github.com/theupdateframework/notary/cmd/notary-server +github.com/theupdateframework/notary/cmd/notary-signer make[1]: Leaving directory '/build/reproducible-path/notary-0.7.0+ds1' dh_auto_test -O--builddirectory=/build/reproducible-path/notary-0.7.0\+ds1/_build -O--buildsystem=golang - cd _build && go test -vet=off -v -p 42 github.com/theupdateframework/notary github.com/theupdateframework/notary/client github.com/theupdateframework/notary/client/changelist github.com/theupdateframework/notary/cmd/escrow github.com/theupdateframework/notary/cmd/notary github.com/theupdateframework/notary/cmd/notary-server github.com/theupdateframework/notary/cmd/notary-signer github.com/theupdateframework/notary/cryptoservice github.com/theupdateframework/notary/passphrase github.com/theupdateframework/notary/proto github.com/theupdateframework/notary/server github.com/theupdateframework/notary/server/errors github.com/theupdateframework/notary/server/handlers github.com/theupdateframework/notary/server/snapshot github.com/theupdateframework/notary/server/storage github.com/theupdateframework/notary/server/timestamp github.com/theupdateframework/notary/signer github.com/theupdateframework/notary/signer/api github.com/theupdateframework/notary/signer/client github.com/theupdateframework/notary/signer/keydbstore github.com/theupdateframework/notary/storage github.com/theupdateframework/notary/storage/rethinkdb github.com/theupdateframework/notary/trustmanager github.com/theupdateframework/notary/trustmanager/remoteks github.com/theupdateframework/notary/trustmanager/yubikey github.com/theupdateframework/notary/trustpinning github.com/theupdateframework/notary/tuf github.com/theupdateframework/notary/tuf/data github.com/theupdateframework/notary/tuf/signed github.com/theupdateframework/notary/tuf/testutils github.com/theupdateframework/notary/tuf/testutils/interfaces github.com/theupdateframework/notary/tuf/testutils/keys github.com/theupdateframework/notary/tuf/utils github.com/theupdateframework/notary/tuf/validation github.com/theupdateframework/notary/utils github.com/theupdateframework/notary/version + cd _build && go test -vet=off -v -p 20 github.com/theupdateframework/notary github.com/theupdateframework/notary/client github.com/theupdateframework/notary/client/changelist github.com/theupdateframework/notary/cmd/escrow github.com/theupdateframework/notary/cmd/notary github.com/theupdateframework/notary/cmd/notary-server github.com/theupdateframework/notary/cmd/notary-signer github.com/theupdateframework/notary/cryptoservice github.com/theupdateframework/notary/passphrase github.com/theupdateframework/notary/proto github.com/theupdateframework/notary/server github.com/theupdateframework/notary/server/errors github.com/theupdateframework/notary/server/handlers github.com/theupdateframework/notary/server/snapshot github.com/theupdateframework/notary/server/storage github.com/theupdateframework/notary/server/timestamp github.com/theupdateframework/notary/signer github.com/theupdateframework/notary/signer/api github.com/theupdateframework/notary/signer/client github.com/theupdateframework/notary/signer/keydbstore github.com/theupdateframework/notary/storage github.com/theupdateframework/notary/storage/rethinkdb github.com/theupdateframework/notary/trustmanager github.com/theupdateframework/notary/trustmanager/remoteks github.com/theupdateframework/notary/trustmanager/yubikey github.com/theupdateframework/notary/trustpinning github.com/theupdateframework/notary/tuf github.com/theupdateframework/notary/tuf/data github.com/theupdateframework/notary/tuf/signed github.com/theupdateframework/notary/tuf/testutils github.com/theupdateframework/notary/tuf/testutils/interfaces github.com/theupdateframework/notary/tuf/testutils/keys github.com/theupdateframework/notary/tuf/utils github.com/theupdateframework/notary/tuf/validation github.com/theupdateframework/notary/utils github.com/theupdateframework/notary/version ? github.com/theupdateframework/notary [no test files] ? github.com/theupdateframework/notary/proto [no test files] ? github.com/theupdateframework/notary/server/errors [no test files] @@ -1825,15 +1861,15 @@ ? github.com/theupdateframework/notary/tuf/testutils/keys [no test files] ? github.com/theupdateframework/notary/version [no test files] === RUN Test0Dot1Migration ---- PASS: Test0Dot1Migration (0.05s) +--- PASS: Test0Dot1Migration (0.12s) === RUN Test0Dot3Migration ---- PASS: Test0Dot3Migration (0.05s) +--- PASS: Test0Dot3Migration (0.10s) === RUN Test0Dot1RepoFormat -time="2025-07-09T21:20:00Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" ---- PASS: Test0Dot1RepoFormat (0.12s) +time="2024-06-06T15:03:37Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" +--- PASS: Test0Dot1RepoFormat (0.52s) === RUN Test0Dot3RepoFormat -time="2025-07-09T21:20:00Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" ---- PASS: Test0Dot3RepoFormat (0.12s) +time="2024-06-06T15:03:38Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" +--- PASS: Test0Dot3RepoFormat (0.44s) === RUN TestDownloading0Dot1RepoFormat --- PASS: TestDownloading0Dot1RepoFormat (0.01s) === RUN TestDownloading0Dot3RepoFormat @@ -1841,378 +1877,378 @@ === RUN TestInitRepositoryManagedRolesIncludingRoot --- PASS: TestInitRepositoryManagedRolesIncludingRoot (0.00s) === RUN TestInitRepositoryManagedRolesInvalidRole ---- PASS: TestInitRepositoryManagedRolesInvalidRole (0.00s) +--- PASS: TestInitRepositoryManagedRolesInvalidRole (0.01s) === RUN TestInitRepositoryManagedRolesIncludingTargets ---- PASS: TestInitRepositoryManagedRolesIncludingTargets (0.00s) +--- PASS: TestInitRepositoryManagedRolesIncludingTargets (0.01s) === RUN TestInitRepositoryManagedRolesIncludingTimestamp ---- PASS: TestInitRepositoryManagedRolesIncludingTimestamp (0.01s) +--- PASS: TestInitRepositoryManagedRolesIncludingTimestamp (0.03s) === RUN TestInitRepositoryWithCerts ---- PASS: TestInitRepositoryWithCerts (0.01s) +--- PASS: TestInitRepositoryWithCerts (0.03s) === RUN TestMatchKeyIDsWithPublicKeys --- PASS: TestMatchKeyIDsWithPublicKeys (0.01s) === RUN TestInitRepositoryNeedsRemoteTimestampKey ---- PASS: TestInitRepositoryNeedsRemoteTimestampKey (0.01s) +--- PASS: TestInitRepositoryNeedsRemoteTimestampKey (0.03s) === RUN TestInitRepositoryNeedsRemoteSnapshotKey ---- PASS: TestInitRepositoryNeedsRemoteSnapshotKey (0.01s) +--- PASS: TestInitRepositoryNeedsRemoteSnapshotKey (0.05s) === RUN TestInitRepoServerOnlyManagesTimestampKey ---- PASS: TestInitRepoServerOnlyManagesTimestampKey (0.07s) +--- PASS: TestInitRepoServerOnlyManagesTimestampKey (0.29s) === RUN TestInitRepoServerManagesTimestampAndSnapshotKeys ---- PASS: TestInitRepoServerManagesTimestampAndSnapshotKeys (0.05s) +--- PASS: TestInitRepoServerManagesTimestampAndSnapshotKeys (0.31s) === RUN TestInitRepoAttemptsExceeded ---- PASS: TestInitRepoAttemptsExceeded (0.05s) +--- PASS: TestInitRepoAttemptsExceeded (0.21s) === RUN TestInitRepoPasswordInvalid ---- PASS: TestInitRepoPasswordInvalid (0.01s) +--- PASS: TestInitRepoPasswordInvalid (0.03s) === RUN TestAddTargetToTargetRoleByDefault ---- PASS: TestAddTargetToTargetRoleByDefault (0.03s) +--- PASS: TestAddTargetToTargetRoleByDefault (0.13s) === RUN TestAddTargetToSpecifiedValidRoles ---- PASS: TestAddTargetToSpecifiedValidRoles (0.02s) +--- PASS: TestAddTargetToSpecifiedValidRoles (0.10s) === RUN TestAddTargetToSpecifiedInvalidRoles ---- PASS: TestAddTargetToSpecifiedInvalidRoles (0.02s) +--- PASS: TestAddTargetToSpecifiedInvalidRoles (0.09s) === RUN TestAddTargetWithInvalidTarget ---- PASS: TestAddTargetWithInvalidTarget (0.01s) +--- PASS: TestAddTargetWithInvalidTarget (0.05s) === RUN TestAddTargetErrorWritingChanges ---- PASS: TestAddTargetErrorWritingChanges (0.01s) +--- PASS: TestAddTargetErrorWritingChanges (0.04s) === RUN TestRemoveTargetToTargetRoleByDefault ---- PASS: TestRemoveTargetToTargetRoleByDefault (0.02s) +--- PASS: TestRemoveTargetToTargetRoleByDefault (0.10s) === RUN TestRemoveTargetFromSpecifiedValidRoles ---- PASS: TestRemoveTargetFromSpecifiedValidRoles (0.03s) +--- PASS: TestRemoveTargetFromSpecifiedValidRoles (0.10s) === RUN TestRemoveTargetToSpecifiedInvalidRoles ---- PASS: TestRemoveTargetToSpecifiedInvalidRoles (0.02s) +--- PASS: TestRemoveTargetToSpecifiedInvalidRoles (0.08s) === RUN TestRemoveTargetErrorWritingChanges ---- PASS: TestRemoveTargetErrorWritingChanges (0.01s) +--- PASS: TestRemoveTargetErrorWritingChanges (0.07s) === RUN TestListTarget ---- PASS: TestListTarget (0.22s) +--- PASS: TestListTarget (1.61s) === RUN TestListTargetRestrictsDelegationPaths ---- PASS: TestListTargetRestrictsDelegationPaths (0.03s) +--- PASS: TestListTargetRestrictsDelegationPaths (0.14s) === RUN TestValidateRootKey ---- PASS: TestValidateRootKey (0.02s) +--- PASS: TestValidateRootKey (0.16s) === RUN TestGetChangelist ---- PASS: TestGetChangelist (0.02s) +--- PASS: TestGetChangelist (0.12s) === RUN TestPublishBareRepo ---- PASS: TestPublishBareRepo (0.22s) +--- PASS: TestPublishBareRepo (1.23s) === RUN TestPublishUninitializedRepo -time="2025-07-09T21:20:01Z" level=info msg="No TUF data found locally or remotely - initializing repository docker.com/notary for the first time" ---- PASS: TestPublishUninitializedRepo (0.02s) +time="2024-06-06T15:03:43Z" level=info msg="No TUF data found locally or remotely - initializing repository docker.com/notary for the first time" +--- PASS: TestPublishUninitializedRepo (0.13s) === RUN TestPublishClientHasSnapshotKey ---- PASS: TestPublishClientHasSnapshotKey (0.18s) +--- PASS: TestPublishClientHasSnapshotKey (0.93s) === RUN TestPublishAfterInitServerHasSnapshotKey ---- PASS: TestPublishAfterInitServerHasSnapshotKey (0.17s) +--- PASS: TestPublishAfterInitServerHasSnapshotKey (0.84s) === RUN TestPublishAfterPullServerHasSnapshotKey ---- PASS: TestPublishAfterPullServerHasSnapshotKey (0.06s) +--- PASS: TestPublishAfterPullServerHasSnapshotKey (0.39s) === RUN TestPublishNoOneHasSnapshotKey ---- PASS: TestPublishNoOneHasSnapshotKey (0.04s) +--- PASS: TestPublishNoOneHasSnapshotKey (0.24s) === RUN TestPublishSnapshotCorrupt ---- PASS: TestPublishSnapshotCorrupt (0.10s) +--- PASS: TestPublishSnapshotCorrupt (0.47s) === RUN TestPublishTargetsCorrupt ---- PASS: TestPublishTargetsCorrupt (0.05s) +--- PASS: TestPublishTargetsCorrupt (0.31s) === RUN TestPublishRootCorrupt -time="2025-07-09T21:20:01Z" level=error msg="Could not publish Repository since we could not update: invalid character 'h' in literal true (expecting 'r')" -time="2025-07-09T21:20:01Z" level=error msg="Could not publish Repository since we could not update: invalid character 'h' in literal true (expecting 'r')" ---- PASS: TestPublishRootCorrupt (0.04s) +time="2024-06-06T15:03:46Z" level=error msg="Could not publish Repository since we could not update: invalid character 'h' in literal true (expecting 'r')" +time="2024-06-06T15:03:47Z" level=error msg="Could not publish Repository since we could not update: invalid character 'h' in literal true (expecting 'r')" +--- PASS: TestPublishRootCorrupt (0.24s) === RUN TestPublishSnapshotLocalKeysCreatedFirst ---- PASS: TestPublishSnapshotLocalKeysCreatedFirst (0.00s) +--- PASS: TestPublishSnapshotLocalKeysCreatedFirst (0.01s) === RUN TestPublishDelegations ---- PASS: TestPublishDelegations (0.07s) +--- PASS: TestPublishDelegations (0.38s) === RUN TestPublishDelegationsX509 ---- PASS: TestPublishDelegationsX509 (0.08s) +--- PASS: TestPublishDelegationsX509 (0.38s) === RUN TestPublishTargetsDelegationScopeFailIfNoKeys -time="2025-07-09T21:20:02Z" level=error msg="couldn't add target to targets/a/b: tuf: invalid role targets/a/b. delegation does not exist" -time="2025-07-09T21:20:02Z" level=error msg="couldn't add target to targets/a/b: tuf: invalid role targets/a/b. delegation does not exist" ---- PASS: TestPublishTargetsDelegationScopeFailIfNoKeys (0.06s) +time="2024-06-06T15:03:48Z" level=error msg="couldn't add target to targets/a/b: tuf: invalid role targets/a/b. delegation does not exist" +time="2024-06-06T15:03:48Z" level=error msg="couldn't add target to targets/a/b: tuf: invalid role targets/a/b. delegation does not exist" +--- PASS: TestPublishTargetsDelegationScopeFailIfNoKeys (0.25s) === RUN TestPublishTargetsDelegationSuccessLocallyHasRoles ---- PASS: TestPublishTargetsDelegationSuccessLocallyHasRoles (0.06s) +--- PASS: TestPublishTargetsDelegationSuccessLocallyHasRoles (0.25s) === RUN TestPublishTargetsDelegationNoTargetsKeyNeeded ---- PASS: TestPublishTargetsDelegationNoTargetsKeyNeeded (0.08s) +--- PASS: TestPublishTargetsDelegationNoTargetsKeyNeeded (0.27s) === RUN TestPublishTargetsDelegationSuccessNeedsToDownloadRoles ---- PASS: TestPublishTargetsDelegationSuccessNeedsToDownloadRoles (0.07s) +--- PASS: TestPublishTargetsDelegationSuccessNeedsToDownloadRoles (0.30s) === RUN TestPublishTargetsDelegationFromTwoRepos ---- PASS: TestPublishTargetsDelegationFromTwoRepos (0.06s) +--- PASS: TestPublishTargetsDelegationFromTwoRepos (0.34s) === RUN TestPublishRemoveDelegationKeyFromDelegationRole -time="2025-07-09T21:20:02Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2025-07-09T21:20:02Z" level=error msg="couldn't add target to targets/a: could not find necessary signing keys, at least one of these keys must be available: 7210d81ea882ec497dde42fe8a313e86476adf8a207fcb9f8a70f55684ccbd04" ---- PASS: TestPublishRemoveDelegationKeyFromDelegationRole (0.05s) +time="2024-06-06T15:03:49Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2024-06-06T15:03:49Z" level=error msg="couldn't add target to targets/a: could not find necessary signing keys, at least one of these keys must be available: e2ddfd017d76a6eacc1088877324d07f3166cea029c6e9d1b765f755220b331b" +--- PASS: TestPublishRemoveDelegationKeyFromDelegationRole (0.24s) === RUN TestPublishRemoveDelegation -time="2025-07-09T21:20:02Z" level=warning msg="role targets/a has fewer keys than its threshold of 1; it will not be usable until keys are added to it" -time="2025-07-09T21:20:02Z" level=warning msg="role targets/a has fewer keys than its threshold of 1; it will not be usable until keys are added to it" -time="2025-07-09T21:20:02Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2025-07-09T21:20:02Z" level=error msg="couldn't add target to targets/a: could not find necessary signing keys, at least one of these keys must be available: " ---- PASS: TestPublishRemoveDelegation (0.04s) +time="2024-06-06T15:03:49Z" level=warning msg="role targets/a has fewer keys than its threshold of 1; it will not be usable until keys are added to it" +time="2024-06-06T15:03:49Z" level=warning msg="role targets/a has fewer keys than its threshold of 1; it will not be usable until keys are added to it" +time="2024-06-06T15:03:49Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2024-06-06T15:03:49Z" level=error msg="couldn't add target to targets/a: could not find necessary signing keys, at least one of these keys must be available: " +--- PASS: TestPublishRemoveDelegation (0.26s) === RUN TestPublishSucceedsDespiteDelegationCorrupt ---- PASS: TestPublishSucceedsDespiteDelegationCorrupt (0.05s) +--- PASS: TestPublishSucceedsDespiteDelegationCorrupt (0.29s) === RUN TestRotateKeyInvalidRole ---- PASS: TestRotateKeyInvalidRole (0.02s) +--- PASS: TestRotateKeyInvalidRole (0.14s) === RUN TestRemoteRotationError ---- PASS: TestRemoteRotationError (0.01s) +--- PASS: TestRemoteRotationError (0.03s) === RUN TestRemoteRotationEndpointError ---- PASS: TestRemoteRotationEndpointError (0.01s) +--- PASS: TestRemoteRotationEndpointError (0.09s) === RUN TestRemoteRotationNoRootKey ---- PASS: TestRemoteRotationNoRootKey (0.03s) +--- PASS: TestRemoteRotationNoRootKey (0.15s) === RUN TestRemoteRotationNoInit -time="2025-07-09T21:20:02Z" level=info msg="No TUF data found locally or remotely - initializing repository docker.com/notary for the first time" ---- PASS: TestRemoteRotationNoInit (0.02s) +time="2024-06-06T15:03:50Z" level=info msg="No TUF data found locally or remotely - initializing repository docker.com/notary for the first time" +--- PASS: TestRemoteRotationNoInit (0.08s) === RUN TestRotateBeforePublishFromRemoteKeyToLocalKey ---- PASS: TestRotateBeforePublishFromRemoteKeyToLocalKey (0.07s) +--- PASS: TestRotateBeforePublishFromRemoteKeyToLocalKey (0.36s) === RUN TestRotateKeyAfterPublishNoServerManagementChange ---- PASS: TestRotateKeyAfterPublishNoServerManagementChange (0.19s) +--- PASS: TestRotateKeyAfterPublishNoServerManagementChange (0.95s) === RUN TestRotateKeyAfterPublishServerManagementChange ---- PASS: TestRotateKeyAfterPublishServerManagementChange (0.23s) +--- PASS: TestRotateKeyAfterPublishServerManagementChange (1.13s) === RUN TestRotateRootKey ---- PASS: TestRotateRootKey (0.06s) +--- PASS: TestRotateRootKey (0.36s) === RUN TestRotateRootMultiple ---- PASS: TestRotateRootMultiple (0.08s) +--- PASS: TestRotateRootMultiple (0.45s) === RUN TestRotateRootKeyProvided ---- PASS: TestRotateRootKeyProvided (0.06s) +--- PASS: TestRotateRootKeyProvided (0.36s) === RUN TestRotateRootKeyLegacySupport ---- PASS: TestRotateRootKeyLegacySupport (0.09s) +--- PASS: TestRotateRootKeyLegacySupport (0.55s) === RUN TestRemoteServerUnavailableNoLocalCache -time="2025-07-09T21:20:03Z" level=error msg="Could not publish Repository since we could not update: unable to reach trust server at this time: 500." ---- PASS: TestRemoteServerUnavailableNoLocalCache (0.00s) +time="2024-06-06T15:03:54Z" level=error msg="Could not publish Repository since we could not update: unable to reach trust server at this time: 500." +--- PASS: TestRemoteServerUnavailableNoLocalCache (0.02s) === RUN TestAddDelegationChangefileValid ---- PASS: TestAddDelegationChangefileValid (0.01s) +--- PASS: TestAddDelegationChangefileValid (0.05s) === RUN TestAddDelegationChangefileApplicable ---- PASS: TestAddDelegationChangefileApplicable (0.01s) +--- PASS: TestAddDelegationChangefileApplicable (0.04s) === RUN TestAddDelegationErrorWritingChanges ---- PASS: TestAddDelegationErrorWritingChanges (0.01s) +--- PASS: TestAddDelegationErrorWritingChanges (0.04s) === RUN TestRemoveDelegationChangefileValid ---- PASS: TestRemoveDelegationChangefileValid (0.01s) +--- PASS: TestRemoveDelegationChangefileValid (0.04s) === RUN TestRemoveDelegationChangefileApplicable -time="2025-07-09T21:20:03Z" level=warning msg="role targets/a has fewer keys than its threshold of 1; it will not be usable until keys are added to it" -time="2025-07-09T21:20:03Z" level=warning msg="role targets/a has fewer keys than its threshold of 1; it will not be usable until keys are added to it" ---- PASS: TestRemoveDelegationChangefileApplicable (0.01s) +time="2024-06-06T15:03:55Z" level=warning msg="role targets/a has fewer keys than its threshold of 1; it will not be usable until keys are added to it" +time="2024-06-06T15:03:55Z" level=warning msg="role targets/a has fewer keys than its threshold of 1; it will not be usable until keys are added to it" +--- PASS: TestRemoveDelegationChangefileApplicable (0.05s) === RUN TestClearAllPathsDelegationChangefileApplicable ---- PASS: TestClearAllPathsDelegationChangefileApplicable (0.01s) +--- PASS: TestClearAllPathsDelegationChangefileApplicable (0.04s) === RUN TestFullAddDelegationChangefileApplicable ---- PASS: TestFullAddDelegationChangefileApplicable (0.01s) +--- PASS: TestFullAddDelegationChangefileApplicable (0.06s) === RUN TestFullRemoveDelegationChangefileApplicable ---- PASS: TestFullRemoveDelegationChangefileApplicable (0.01s) +--- PASS: TestFullRemoveDelegationChangefileApplicable (0.07s) === RUN TestRemoveDelegationErrorWritingChanges ---- PASS: TestRemoveDelegationErrorWritingChanges (0.01s) +--- PASS: TestRemoveDelegationErrorWritingChanges (0.05s) === RUN TestClientInvalidURL --- PASS: TestClientInvalidURL (0.00s) === RUN TestPublishTargetsDelegationCanUseUserKeyWithArbitraryRole ---- PASS: TestPublishTargetsDelegationCanUseUserKeyWithArbitraryRole (0.13s) +--- PASS: TestPublishTargetsDelegationCanUseUserKeyWithArbitraryRole (0.67s) === RUN TestDeleteRepo ---- PASS: TestDeleteRepo (0.02s) +--- PASS: TestDeleteRepo (0.11s) === RUN TestDeleteRemoteRepo ---- PASS: TestDeleteRemoteRepo (0.05s) +--- PASS: TestDeleteRemoteRepo (0.22s) === RUN TestListRoles ---- PASS: TestListRoles (0.08s) +--- PASS: TestListRoles (0.40s) === RUN TestGetAllTargetInfo ---- PASS: TestGetAllTargetInfo (0.05s) +--- PASS: TestGetAllTargetInfo (0.43s) === RUN TestUpdateSucceedsEvenIfCannotWriteNewRepo -time="2025-07-09T21:20:03Z" level=error msg="could not save root to cache: Non-writable" ---- PASS: TestUpdateSucceedsEvenIfCannotWriteNewRepo (0.04s) +time="2024-06-06T15:03:57Z" level=error msg="could not save root to cache: Non-writable" +--- PASS: TestUpdateSucceedsEvenIfCannotWriteNewRepo (0.35s) === RUN TestUpdateSucceedsEvenIfCannotWriteExistingRepo ---- PASS: TestUpdateSucceedsEvenIfCannotWriteExistingRepo (0.16s) +--- PASS: TestUpdateSucceedsEvenIfCannotWriteExistingRepo (0.89s) === RUN TestUpdateInOfflineMode -time="2025-07-09T21:20:04Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" -time="2025-07-09T21:20:04Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" ---- PASS: TestUpdateInOfflineMode (0.01s) +time="2024-06-06T15:03:58Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" +time="2024-06-06T15:03:58Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" +--- PASS: TestUpdateInOfflineMode (0.04s) === RUN TestUpdateReplacesCorruptOrMissingMetadata -time="2025-07-09T21:20:04Z" level=error msg="Metadata for root expired" -time="2025-07-09T21:20:04Z" level=error msg="Metadata for root expired" ---- PASS: TestUpdateReplacesCorruptOrMissingMetadata (0.29s) +time="2024-06-06T15:03:59Z" level=error msg="Metadata for root expired" +time="2024-06-06T15:03:59Z" level=error msg="Metadata for root expired" +--- PASS: TestUpdateReplacesCorruptOrMissingMetadata (1.57s) === RUN TestUpdateFailsIfServerRootKeyChangedWithoutMultiSign -time="2025-07-09T21:20:04Z" level=error msg="Metadata for root expired" -time="2025-07-09T21:20:04Z" level=error msg="Metadata for root expired" ---- PASS: TestUpdateFailsIfServerRootKeyChangedWithoutMultiSign (0.03s) +time="2024-06-06T15:04:00Z" level=error msg="Metadata for root expired" +time="2024-06-06T15:04:00Z" level=error msg="Metadata for root expired" +--- PASS: TestUpdateFailsIfServerRootKeyChangedWithoutMultiSign (0.20s) === RUN TestUpdateRemoteRootNotExistNoLocalCache ---- PASS: TestUpdateRemoteRootNotExistNoLocalCache (0.01s) +--- PASS: TestUpdateRemoteRootNotExistNoLocalCache (0.07s) === RUN TestUpdateRemoteRootNotExistCanUseLocalCache ---- PASS: TestUpdateRemoteRootNotExistCanUseLocalCache (0.02s) +--- PASS: TestUpdateRemoteRootNotExistCanUseLocalCache (0.13s) === RUN TestUpdateRemoteRootNotExistCannotUseLocalCache ---- PASS: TestUpdateRemoteRootNotExistCannotUseLocalCache (0.03s) +--- PASS: TestUpdateRemoteRootNotExistCannotUseLocalCache (0.16s) === RUN TestUpdateRemoteRoot50XNoLocalCache ---- PASS: TestUpdateRemoteRoot50XNoLocalCache (0.01s) +--- PASS: TestUpdateRemoteRoot50XNoLocalCache (0.06s) === RUN TestUpdateRemoteRoot50XCanUseLocalCache ---- PASS: TestUpdateRemoteRoot50XCanUseLocalCache (0.02s) +--- PASS: TestUpdateRemoteRoot50XCanUseLocalCache (0.12s) === RUN TestUpdateRemoteRoot50XCannotUseLocalCache ---- PASS: TestUpdateRemoteRoot50XCannotUseLocalCache (0.03s) +--- PASS: TestUpdateRemoteRoot50XCannotUseLocalCache (0.15s) === RUN TestUpdateNonRootRemoteMissingMetadataNoLocalCache ---- PASS: TestUpdateNonRootRemoteMissingMetadataNoLocalCache (0.06s) +--- PASS: TestUpdateNonRootRemoteMissingMetadataNoLocalCache (0.32s) === RUN TestUpdateNonRootRemoteMissingMetadataCanUseLocalCache -time="2025-07-09T21:20:04Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" ---- PASS: TestUpdateNonRootRemoteMissingMetadataCanUseLocalCache (0.07s) +time="2024-06-06T15:04:01Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" +--- PASS: TestUpdateNonRootRemoteMissingMetadataCanUseLocalCache (0.49s) === RUN TestUpdateNonRootRemoteMissingMetadataCannotUseLocalCache -time="2025-07-09T21:20:04Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" ---- PASS: TestUpdateNonRootRemoteMissingMetadataCannotUseLocalCache (0.10s) +time="2024-06-06T15:04:01Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" +--- PASS: TestUpdateNonRootRemoteMissingMetadataCannotUseLocalCache (0.68s) === RUN TestUpdateNonRootRemote50XNoLocalCache ---- PASS: TestUpdateNonRootRemote50XNoLocalCache (0.06s) +--- PASS: TestUpdateNonRootRemote50XNoLocalCache (0.34s) === RUN TestUpdateNonRootRemote50XCanUseLocalCache -time="2025-07-09T21:20:04Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" ---- PASS: TestUpdateNonRootRemote50XCanUseLocalCache (0.07s) +time="2024-06-06T15:04:02Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" +--- PASS: TestUpdateNonRootRemote50XCanUseLocalCache (0.41s) === RUN TestUpdateNonRootRemote50XCannotUseLocalCache -time="2025-07-09T21:20:04Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" ---- PASS: TestUpdateNonRootRemote50XCannotUseLocalCache (0.10s) +time="2024-06-06T15:04:03Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" +--- PASS: TestUpdateNonRootRemote50XCannotUseLocalCache (0.68s) === RUN TestUpdateRemoteChecksumWrongNoLocalCache ---- PASS: TestUpdateRemoteChecksumWrongNoLocalCache (0.07s) +--- PASS: TestUpdateRemoteChecksumWrongNoLocalCache (0.49s) === RUN TestUpdateRemoteChecksumWrongCanUseLocalCache ---- PASS: TestUpdateRemoteChecksumWrongCanUseLocalCache (0.10s) +--- PASS: TestUpdateRemoteChecksumWrongCanUseLocalCache (0.47s) === RUN TestUpdateRemoteChecksumWrongCannotUseLocalCache ---- PASS: TestUpdateRemoteChecksumWrongCannotUseLocalCache (0.13s) +--- PASS: TestUpdateRemoteChecksumWrongCannotUseLocalCache (0.48s) === RUN TestUpdateRootRemoteCorruptedNoLocalCache -time="2025-07-09T21:20:05Z" level=error msg="Metadata for root expired" -time="2025-07-09T21:20:05Z" level=error msg="Metadata for root expired" ---- PASS: TestUpdateRootRemoteCorruptedNoLocalCache (0.21s) +time="2024-06-06T15:04:05Z" level=error msg="Metadata for root expired" +time="2024-06-06T15:04:05Z" level=error msg="Metadata for root expired" +--- PASS: TestUpdateRootRemoteCorruptedNoLocalCache (1.09s) === RUN TestUpdateRootRemoteCorruptedCanUseLocalCache ---- PASS: TestUpdateRootRemoteCorruptedCanUseLocalCache (0.45s) +--- PASS: TestUpdateRootRemoteCorruptedCanUseLocalCache (2.67s) === RUN TestUpdateRootRemoteCorruptedCannotUseLocalCache -time="2025-07-09T21:20:06Z" level=error msg="Metadata for root expired" -time="2025-07-09T21:20:06Z" level=error msg="Metadata for root expired" ---- PASS: TestUpdateRootRemoteCorruptedCannotUseLocalCache (0.52s) +time="2024-06-06T15:04:10Z" level=error msg="Metadata for root expired" +time="2024-06-06T15:04:10Z" level=error msg="Metadata for root expired" +--- PASS: TestUpdateRootRemoteCorruptedCannotUseLocalCache (3.33s) === RUN TestUpdateNonRootRemoteCorruptedNoLocalCache -time="2025-07-09T21:20:06Z" level=error msg="Metadata for targets expired" -time="2025-07-09T21:20:06Z" level=error msg="Metadata for targets expired" -time="2025-07-09T21:20:06Z" level=error msg="Metadata for snapshot expired" -time="2025-07-09T21:20:06Z" level=error msg="Metadata for snapshot expired" -time="2025-07-09T21:20:06Z" level=error msg="Metadata for timestamp expired" -time="2025-07-09T21:20:06Z" level=error msg="Metadata for timestamp expired" -time="2025-07-09T21:20:06Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2025-07-09T21:20:06Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2025-07-09T21:20:06Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2025-07-09T21:20:06Z" level=error msg="Metadata for targets/a expired" -time="2025-07-09T21:20:06Z" level=warning msg="Error getting targets/a: targets/a expired at Sat Jun 8 21:20:06 UTC 2024" -time="2025-07-09T21:20:06Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" -time="2025-07-09T21:20:06Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" -time="2025-07-09T21:20:06Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" -time="2025-07-09T21:20:06Z" level=error msg="Metadata for targets/a/b expired" -time="2025-07-09T21:20:06Z" level=warning msg="Error getting targets/a/b: targets/a/b expired at Sat Jun 8 21:20:06 UTC 2024" -time="2025-07-09T21:20:06Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" -time="2025-07-09T21:20:06Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" -time="2025-07-09T21:20:06Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" -time="2025-07-09T21:20:06Z" level=error msg="Metadata for targets/b expired" -time="2025-07-09T21:20:06Z" level=warning msg="Error getting targets/b: targets/b expired at Sat Jun 8 21:20:06 UTC 2024" ---- PASS: TestUpdateNonRootRemoteCorruptedNoLocalCache (0.55s) +time="2024-06-06T15:04:12Z" level=error msg="Metadata for targets expired" +time="2024-06-06T15:04:12Z" level=error msg="Metadata for targets expired" +time="2024-06-06T15:04:13Z" level=error msg="Metadata for snapshot expired" +time="2024-06-06T15:04:13Z" level=error msg="Metadata for snapshot expired" +time="2024-06-06T15:04:13Z" level=error msg="Metadata for timestamp expired" +time="2024-06-06T15:04:13Z" level=error msg="Metadata for timestamp expired" +time="2024-06-06T15:04:13Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2024-06-06T15:04:13Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2024-06-06T15:04:13Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2024-06-06T15:04:14Z" level=error msg="Metadata for targets/a expired" +time="2024-06-06T15:04:14Z" level=warning msg="Error getting targets/a: targets/a expired at Fri May 5 15:04:14 UTC 2023" +time="2024-06-06T15:04:14Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" +time="2024-06-06T15:04:14Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" +time="2024-06-06T15:04:14Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" +time="2024-06-06T15:04:14Z" level=error msg="Metadata for targets/a/b expired" +time="2024-06-06T15:04:14Z" level=warning msg="Error getting targets/a/b: targets/a/b expired at Fri May 5 15:04:14 UTC 2023" +time="2024-06-06T15:04:14Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" +time="2024-06-06T15:04:14Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" +time="2024-06-06T15:04:14Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" +time="2024-06-06T15:04:15Z" level=error msg="Metadata for targets/b expired" +time="2024-06-06T15:04:15Z" level=warning msg="Error getting targets/b: targets/b expired at Fri May 5 15:04:14 UTC 2023" +--- PASS: TestUpdateNonRootRemoteCorruptedNoLocalCache (3.03s) === RUN TestUpdateNonRootRemoteCorruptedCanUseLocalCache -time="2025-07-09T21:20:07Z" level=error msg="Metadata for timestamp expired" -time="2025-07-09T21:20:07Z" level=error msg="Metadata for timestamp expired" ---- PASS: TestUpdateNonRootRemoteCorruptedCanUseLocalCache (0.75s) +time="2024-06-06T15:04:17Z" level=error msg="Metadata for timestamp expired" +time="2024-06-06T15:04:17Z" level=error msg="Metadata for timestamp expired" +--- PASS: TestUpdateNonRootRemoteCorruptedCanUseLocalCache (4.49s) === RUN TestUpdateNonRootRemoteCorruptedCannotUseLocalCache -time="2025-07-09T21:20:07Z" level=error msg="Metadata for targets expired" -time="2025-07-09T21:20:08Z" level=error msg="Metadata for snapshot expired" -time="2025-07-09T21:20:08Z" level=error msg="Metadata for snapshot expired" -time="2025-07-09T21:20:08Z" level=error msg="Metadata for timestamp expired" -time="2025-07-09T21:20:08Z" level=error msg="Metadata for timestamp expired" -time="2025-07-09T21:20:08Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2025-07-09T21:20:08Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2025-07-09T21:20:08Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2025-07-09T21:20:08Z" level=error msg="Metadata for targets/a expired" -time="2025-07-09T21:20:08Z" level=warning msg="Error getting targets/a: targets/a expired at Sat Jun 8 21:20:08 UTC 2024" -time="2025-07-09T21:20:08Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" -time="2025-07-09T21:20:08Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" -time="2025-07-09T21:20:08Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" -time="2025-07-09T21:20:08Z" level=error msg="Metadata for targets/a/b expired" -time="2025-07-09T21:20:08Z" level=warning msg="Error getting targets/a/b: targets/a/b expired at Sat Jun 8 21:20:08 UTC 2024" -time="2025-07-09T21:20:08Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" -time="2025-07-09T21:20:08Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" -time="2025-07-09T21:20:08Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" -time="2025-07-09T21:20:08Z" level=error msg="Metadata for targets/b expired" -time="2025-07-09T21:20:08Z" level=warning msg="Error getting targets/b: targets/b expired at Sat Jun 8 21:20:08 UTC 2024" ---- PASS: TestUpdateNonRootRemoteCorruptedCannotUseLocalCache (1.04s) +time="2024-06-06T15:04:20Z" level=error msg="Metadata for targets expired" +time="2024-06-06T15:04:21Z" level=error msg="Metadata for snapshot expired" +time="2024-06-06T15:04:21Z" level=error msg="Metadata for snapshot expired" +time="2024-06-06T15:04:22Z" level=error msg="Metadata for timestamp expired" +time="2024-06-06T15:04:22Z" level=error msg="Metadata for timestamp expired" +time="2024-06-06T15:04:22Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2024-06-06T15:04:23Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2024-06-06T15:04:23Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2024-06-06T15:04:23Z" level=error msg="Metadata for targets/a expired" +time="2024-06-06T15:04:23Z" level=warning msg="Error getting targets/a: targets/a expired at Fri May 5 15:04:23 UTC 2023" +time="2024-06-06T15:04:23Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" +time="2024-06-06T15:04:24Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" +time="2024-06-06T15:04:24Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" +time="2024-06-06T15:04:24Z" level=error msg="Metadata for targets/a/b expired" +time="2024-06-06T15:04:24Z" level=warning msg="Error getting targets/a/b: targets/a/b expired at Fri May 5 15:04:24 UTC 2023" +time="2024-06-06T15:04:24Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" +time="2024-06-06T15:04:25Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" +time="2024-06-06T15:04:25Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" +time="2024-06-06T15:04:25Z" level=error msg="Metadata for targets/b expired" +time="2024-06-06T15:04:25Z" level=warning msg="Error getting targets/b: targets/b expired at Fri May 5 15:04:25 UTC 2023" +--- PASS: TestUpdateNonRootRemoteCorruptedCannotUseLocalCache (6.03s) === RUN TestUpdateLocalAndRemoteRootCorrupt -time="2025-07-09T21:20:09Z" level=error msg="Metadata for root expired" -time="2025-07-09T21:20:09Z" level=error msg="Metadata for root expired" -time="2025-07-09T21:20:09Z" level=error msg="Metadata for root expired" -time="2025-07-09T21:20:09Z" level=error msg="Metadata for root expired" -time="2025-07-09T21:20:09Z" level=error msg="Metadata for root expired" -time="2025-07-09T21:20:09Z" level=error msg="Metadata for root expired" -time="2025-07-09T21:20:09Z" level=error msg="Metadata for root expired" -time="2025-07-09T21:20:09Z" level=error msg="Metadata for root expired" -time="2025-07-09T21:20:09Z" level=error msg="Metadata for root expired" -time="2025-07-09T21:20:09Z" level=error msg="Metadata for root expired" -time="2025-07-09T21:20:09Z" level=error msg="Metadata for root expired" -time="2025-07-09T21:20:09Z" level=error msg="Metadata for root expired" -time="2025-07-09T21:20:09Z" level=error msg="Metadata for root expired" -time="2025-07-09T21:20:09Z" level=error msg="Metadata for root expired" -time="2025-07-09T21:20:09Z" level=error msg="Metadata for root expired" -time="2025-07-09T21:20:09Z" level=error msg="Metadata for root expired" -time="2025-07-09T21:20:09Z" level=error msg="Metadata for root expired" -time="2025-07-09T21:20:09Z" level=error msg="Metadata for root expired" -time="2025-07-09T21:20:09Z" level=error msg="Metadata for root expired" -time="2025-07-09T21:20:09Z" level=error msg="Metadata for root expired" -time="2025-07-09T21:20:09Z" level=error msg="Metadata for root expired" -time="2025-07-09T21:20:09Z" level=error msg="Metadata for root expired" ---- PASS: TestUpdateLocalAndRemoteRootCorrupt (1.14s) +time="2024-06-06T15:04:28Z" level=error msg="Metadata for root expired" +time="2024-06-06T15:04:28Z" level=error msg="Metadata for root expired" +time="2024-06-06T15:04:31Z" level=error msg="Metadata for root expired" +time="2024-06-06T15:04:31Z" level=error msg="Metadata for root expired" +time="2024-06-06T15:04:31Z" level=error msg="Metadata for root expired" +time="2024-06-06T15:04:31Z" level=error msg="Metadata for root expired" +time="2024-06-06T15:04:31Z" level=error msg="Metadata for root expired" +time="2024-06-06T15:04:31Z" level=error msg="Metadata for root expired" +time="2024-06-06T15:04:31Z" level=error msg="Metadata for root expired" +time="2024-06-06T15:04:31Z" level=error msg="Metadata for root expired" +time="2024-06-06T15:04:31Z" level=error msg="Metadata for root expired" +time="2024-06-06T15:04:31Z" level=error msg="Metadata for root expired" +time="2024-06-06T15:04:31Z" level=error msg="Metadata for root expired" +time="2024-06-06T15:04:31Z" level=error msg="Metadata for root expired" +time="2024-06-06T15:04:31Z" level=error msg="Metadata for root expired" +time="2024-06-06T15:04:31Z" level=error msg="Metadata for root expired" +time="2024-06-06T15:04:31Z" level=error msg="Metadata for root expired" +time="2024-06-06T15:04:31Z" level=error msg="Metadata for root expired" +time="2024-06-06T15:04:31Z" level=error msg="Metadata for root expired" +time="2024-06-06T15:04:31Z" level=error msg="Metadata for root expired" +time="2024-06-06T15:04:31Z" level=error msg="Metadata for root expired" +time="2024-06-06T15:04:31Z" level=error msg="Metadata for root expired" +--- PASS: TestUpdateLocalAndRemoteRootCorrupt (6.08s) === RUN TestUpdateRemoteKeyRotated -time="2025-07-09T21:20:09Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2025-07-09T21:20:10Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" -time="2025-07-09T21:20:10Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" ---- PASS: TestUpdateRemoteKeyRotated (0.11s) +time="2024-06-06T15:04:32Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2024-06-06T15:04:32Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" +time="2024-06-06T15:04:32Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" +--- PASS: TestUpdateRemoteKeyRotated (0.27s) === RUN TestValidateRootRotationWithOldRole ---- PASS: TestValidateRootRotationWithOldRole (0.05s) +--- PASS: TestValidateRootRotationWithOldRole (0.15s) === RUN TestRootRoleInvariant ---- PASS: TestRootRoleInvariant (0.05s) +--- PASS: TestRootRoleInvariant (0.28s) === RUN TestBadIntermediateTransitions ---- PASS: TestBadIntermediateTransitions (0.02s) +--- PASS: TestBadIntermediateTransitions (0.09s) === RUN TestExpiredIntermediateTransitions -time="2025-07-09T21:20:10Z" level=warning msg="root is nearing expiry, you should re-sign the role metadata" ---- PASS: TestExpiredIntermediateTransitions (0.02s) +time="2024-06-06T15:04:32Z" level=warning msg="root is nearing expiry, you should re-sign the role metadata" +--- PASS: TestExpiredIntermediateTransitions (0.12s) === RUN TestDownloadTargetsLarge ---- PASS: TestDownloadTargetsLarge (2.05s) +--- PASS: TestDownloadTargetsLarge (10.25s) === RUN TestDownloadTargetsDeep ---- PASS: TestDownloadTargetsDeep (0.01s) +--- PASS: TestDownloadTargetsDeep (0.07s) === RUN TestDownloadSnapshotLargeDelegationsMany ---- PASS: TestDownloadSnapshotLargeDelegationsMany (1.77s) +--- PASS: TestDownloadSnapshotLargeDelegationsMany (8.47s) === RUN TestRootOnDiskTrustPinning ---- PASS: TestRootOnDiskTrustPinning (0.01s) +--- PASS: TestRootOnDiskTrustPinning (0.04s) === RUN TestLoadTUFRepoBadURL --- PASS: TestLoadTUFRepoBadURL (0.00s) === RUN TestApplyTargetsChange --- PASS: TestApplyTargetsChange (0.00s) === RUN TestApplyAddTargetTwice ---- PASS: TestApplyAddTargetTwice (0.00s) +--- PASS: TestApplyAddTargetTwice (0.01s) === RUN TestApplyChangelist --- PASS: TestApplyChangelist (0.00s) === RUN TestApplyChangelistMulti ---- PASS: TestApplyChangelistMulti (0.00s) +--- PASS: TestApplyChangelistMulti (0.01s) === RUN TestApplyTargetsDelegationCreateDelete --- PASS: TestApplyTargetsDelegationCreateDelete (0.00s) === RUN TestApplyTargetsDelegationCreate2SharedKey ---- PASS: TestApplyTargetsDelegationCreate2SharedKey (0.00s) +--- PASS: TestApplyTargetsDelegationCreate2SharedKey (0.01s) === RUN TestApplyTargetsDelegationCreateEdit ---- PASS: TestApplyTargetsDelegationCreateEdit (0.00s) +--- PASS: TestApplyTargetsDelegationCreateEdit (0.01s) === RUN TestApplyTargetsDelegationEditNonExisting --- PASS: TestApplyTargetsDelegationEditNonExisting (0.00s) === RUN TestApplyTargetsDelegationCreateAlreadyExisting ---- PASS: TestApplyTargetsDelegationCreateAlreadyExisting (0.00s) +--- PASS: TestApplyTargetsDelegationCreateAlreadyExisting (0.01s) === RUN TestApplyTargetsDelegationAlreadyExistingMergePaths ---- PASS: TestApplyTargetsDelegationAlreadyExistingMergePaths (0.00s) +--- PASS: TestApplyTargetsDelegationAlreadyExistingMergePaths (0.01s) === RUN TestApplyTargetsDelegationInvalidRole --- PASS: TestApplyTargetsDelegationInvalidRole (0.00s) === RUN TestApplyTargetsDelegationInvalidJSONContent ---- PASS: TestApplyTargetsDelegationInvalidJSONContent (0.00s) +--- PASS: TestApplyTargetsDelegationInvalidJSONContent (0.01s) === RUN TestApplyTargetsDelegationInvalidAction --- PASS: TestApplyTargetsDelegationInvalidAction (0.00s) === RUN TestApplyTargetsChangeInvalidType ---- PASS: TestApplyTargetsChangeInvalidType (0.00s) +--- PASS: TestApplyTargetsChangeInvalidType (0.01s) === RUN TestApplyTargetsDelegationCreate2Deep ---- PASS: TestApplyTargetsDelegationCreate2Deep (0.00s) +--- PASS: TestApplyTargetsDelegationCreate2Deep (0.01s) === RUN TestApplyTargetsDelegationParentDoesntExist --- PASS: TestApplyTargetsDelegationParentDoesntExist (0.00s) === RUN TestApplyChangelistCreatesDelegation ---- PASS: TestApplyChangelistCreatesDelegation (0.00s) +--- PASS: TestApplyChangelistCreatesDelegation (0.01s) === RUN TestApplyChangelistTargetsToMultipleRoles --- PASS: TestApplyChangelistTargetsToMultipleRoles (0.00s) === RUN TestApplyChangelistTargetsFailsNonexistentRole -time="2025-07-09T21:20:14Z" level=error msg="couldn't add target to targets/level1/level2/level3/level4: tuf: invalid role targets/level1/level2/level3/level4. delegation does not exist" -time="2025-07-09T21:20:14Z" level=error msg="couldn't remove target from targets/level1/level2/level3/level4: tuf: invalid role targets/level1/level2/level3/level4. delegation does not exist" ---- PASS: TestApplyChangelistTargetsFailsNonexistentRole (0.00s) +time="2024-06-06T15:04:51Z" level=error msg="couldn't add target to targets/level1/level2/level3/level4: tuf: invalid role targets/level1/level2/level3/level4. delegation does not exist" +time="2024-06-06T15:04:51Z" level=error msg="couldn't remove target from targets/level1/level2/level3/level4: tuf: invalid role targets/level1/level2/level3/level4. delegation does not exist" +--- PASS: TestApplyChangelistTargetsFailsNonexistentRole (0.01s) === RUN TestChangeTargetMetaFailsInvalidRole -time="2025-07-09T21:20:14Z" level=error msg="couldn't add target to ruhroh: tuf: invalid role ruhroh. does not exist" ---- PASS: TestChangeTargetMetaFailsInvalidRole (0.00s) +time="2024-06-06T15:04:51Z" level=error msg="couldn't add target to ruhroh: tuf: invalid role ruhroh. does not exist" +--- PASS: TestChangeTargetMetaFailsInvalidRole (0.01s) === RUN TestChangeTargetMetaFailsIfPrefixError -time="2025-07-09T21:20:14Z" level=error msg="couldn't add target to targets/level1: Could not add all targets" +time="2024-06-06T15:04:51Z" level=error msg="couldn't add target to targets/level1: Could not add all targets" --- PASS: TestChangeTargetMetaFailsIfPrefixError (0.00s) === RUN TestAllNearExpiry ---- PASS: TestAllNearExpiry (0.00s) +--- PASS: TestAllNearExpiry (0.01s) === RUN TestAllNotNearExpiry --- PASS: TestAllNotNearExpiry (0.00s) === RUN TestRotateRemoteKeyOffline ---- PASS: TestRotateRemoteKeyOffline (0.00s) +--- PASS: TestRotateRemoteKeyOffline (0.01s) PASS -ok github.com/theupdateframework/notary/client 14.045s +ok github.com/theupdateframework/notary/client 74.672s === RUN TestTUFDelegation ---- PASS: TestTUFDelegation (0.00s) +--- PASS: TestTUFDelegation (0.01s) === RUN TestMemChangelist --- PASS: TestMemChangelist (0.00s) === RUN TestMemChangeIterator @@ -2220,16 +2256,16 @@ === RUN TestMemChangelistRemove --- PASS: TestMemChangelistRemove (0.00s) === RUN TestAdd ---- PASS: TestAdd (0.00s) +--- PASS: TestAdd (0.01s) === RUN TestErrorConditions -time="2025-07-09T21:20:00Z" level=warning msg="invalid character '\\x05' looking for beginning of value" +time="2024-06-06T15:03:37Z" level=warning msg="invalid character '\\x05' looking for beginning of value" --- PASS: TestErrorConditions (0.00s) === RUN TestListOrder --- PASS: TestListOrder (0.00s) === RUN TestFileChangeIterator --- PASS: TestFileChangeIterator (0.00s) PASS -ok github.com/theupdateframework/notary/client/changelist 0.015s +ok github.com/theupdateframework/notary/client/changelist 0.068s === RUN TestParseConfigError --- PASS: TestParseConfigError (0.00s) === RUN TestSetupGRPCServer @@ -2239,7 +2275,7 @@ === RUN TestSetupNetListener --- PASS: TestSetupNetListener (0.00s) PASS -ok github.com/theupdateframework/notary/cmd/escrow 0.019s +ok github.com/theupdateframework/notary/cmd/escrow 0.048s === RUN TestPurgeDelegationKeys Usage: delegation [command] @@ -2263,13 +2299,13 @@ Use "delegation [command] --help" for more information about a command. Removal of the following keys from all delegations in gun staged for next publish: - abc ---- PASS: TestPurgeDelegationKeys (0.00s) +--- PASS: TestPurgeDelegationKeys (0.01s) === RUN TestAddInvalidDelegationName --- PASS: TestAddInvalidDelegationName (0.00s) === RUN TestAddInvalidDelegationCert --- PASS: TestAddInvalidDelegationCert (0.00s) === RUN TestAddInvalidShortPubkeyCert ---- PASS: TestAddInvalidShortPubkeyCert (0.00s) +--- PASS: TestAddInvalidShortPubkeyCert (0.02s) === RUN TestRemoveInvalidDelegationName --- PASS: TestRemoveInvalidDelegationName (0.00s) === RUN TestRemoveAllInvalidDelegationName @@ -2297,7 +2333,7 @@ remove Remove KeyID(s) from the specified Role delegation. Use "delegation [command] --help" for more information about a command. ---- PASS: TestListInvalidNumArgs (0.00s) +--- PASS: TestListInvalidNumArgs (0.01s) === RUN TestRemoveInvalidNumArgs Usage: delegation [command] @@ -2311,118 +2347,118 @@ Use "delegation [command] --help" for more information about a command. --- PASS: TestRemoveInvalidNumArgs (0.00s) === RUN TestInitWithRootKey ---- PASS: TestInitWithRootKey (0.08s) +--- PASS: TestInitWithRootKey (0.23s) === RUN TestInitWithRootCert ---- PASS: TestInitWithRootCert (0.05s) +--- PASS: TestInitWithRootCert (0.21s) === RUN TestClientTUFInteraction ---- PASS: TestClientTUFInteraction (0.10s) +--- PASS: TestClientTUFInteraction (0.36s) === RUN TestClientDeleteTUFInteraction -time="2025-07-09T21:20:00Z" level=error msg="could not reach https://invalid-server: Get \"https://invalid-server/v2/\": dial tcp: lookup invalid-server on [::1]:53: read udp [::1]:60167->[::1]:53: read: connection refused" ---- PASS: TestClientDeleteTUFInteraction (0.11s) +time="2024-06-06T15:03:38Z" level=error msg="could not reach https://invalid-server: Get \"https://invalid-server/v2/\": dial tcp: lookup invalid-server on [::1]:53: read udp [::1]:57985->[::1]:53: read: connection refused" +--- PASS: TestClientDeleteTUFInteraction (0.55s) === RUN TestClientTUFAddByHashInteraction ---- PASS: TestClientTUFAddByHashInteraction (0.16s) +--- PASS: TestClientTUFAddByHashInteraction (0.96s) === RUN TestClientDelegationsInteraction -time="2025-07-09T21:20:00Z" level=warning msg="role targets/delegation has fewer keys than its threshold of 1; it will not be usable until keys are added to it" -time="2025-07-09T21:20:00Z" level=warning msg="role targets/delegation has fewer keys than its threshold of 1; it will not be usable until keys are added to it" ---- PASS: TestClientDelegationsInteraction (0.36s) +time="2024-06-06T15:03:40Z" level=warning msg="role targets/delegation has fewer keys than its threshold of 1; it will not be usable until keys are added to it" +time="2024-06-06T15:03:40Z" level=warning msg="role targets/delegation has fewer keys than its threshold of 1; it will not be usable until keys are added to it" +--- PASS: TestClientDelegationsInteraction (2.21s) === RUN TestClientDelegationsPublishing ---- PASS: TestClientDelegationsPublishing (0.32s) +--- PASS: TestClientDelegationsPublishing (1.86s) === RUN TestClientKeyGenerationRotation ---- PASS: TestClientKeyGenerationRotation (0.41s) +--- PASS: TestClientKeyGenerationRotation (2.49s) === RUN TestKeyRotation ---- PASS: TestKeyRotation (0.07s) +--- PASS: TestKeyRotation (0.42s) === RUN TestKeyRotationNonRoot ---- PASS: TestKeyRotationNonRoot (0.08s) +--- PASS: TestKeyRotationNonRoot (0.50s) === RUN TestDefaultRootKeyGeneration ---- PASS: TestDefaultRootKeyGeneration (0.00s) +--- PASS: TestDefaultRootKeyGeneration (0.04s) === RUN TestLogLevelFlags --- PASS: TestLogLevelFlags (0.00s) === RUN TestClientKeyPassphraseChange ---- PASS: TestClientKeyPassphraseChange (0.07s) +--- PASS: TestClientKeyPassphraseChange (0.43s) === RUN TestPurgeSingleKey Removal of the following keys from all delegations in gun staged for next publish: - - 6d18f97a79ed878c0d98c96e41d6112833c793e32c04240e2dbeaf779b4d88c3 ---- PASS: TestPurgeSingleKey (0.06s) + - a68224158b94d00854679f2dd8d64e09c560dbeb7bf9df9c049ab9125d266a1d +--- PASS: TestPurgeSingleKey (0.32s) === RUN TestWitness -time="2025-07-09T21:20:02Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" -time="2025-07-09T21:20:02Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" -time="2025-07-09T21:20:02Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" -time="2025-07-09T21:20:02Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" -time="2025-07-09T21:20:02Z" level=warning msg="role targets/delegation has fewer keys than its threshold of 1; it will not be usable until keys are added to it" -time="2025-07-09T21:20:02Z" level=warning msg="role targets/delegation has fewer keys than its threshold of 1; it will not be usable until keys are added to it" -time="2025-07-09T21:20:02Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" ---- PASS: TestWitness (0.20s) +time="2024-06-06T15:03:48Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" +time="2024-06-06T15:03:48Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" +time="2024-06-06T15:03:49Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" +time="2024-06-06T15:03:49Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" +time="2024-06-06T15:03:49Z" level=warning msg="role targets/delegation has fewer keys than its threshold of 1; it will not be usable until keys are added to it" +time="2024-06-06T15:03:49Z" level=warning msg="role targets/delegation has fewer keys than its threshold of 1; it will not be usable until keys are added to it" +time="2024-06-06T15:03:49Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" +--- PASS: TestWitness (1.19s) === RUN TestClientTUFInitWithAutoPublish -time="2025-07-09T21:20:02Z" level=error msg="could not reach https://notary-server-on-the-moon:12306: Get \"https://notary-server-on-the-moon:12306/v2/\": dial tcp: lookup notary-server-on-the-moon on [::1]:53: read udp [::1]:35521->[::1]:53: read: connection refused" ---- PASS: TestClientTUFInitWithAutoPublish (0.05s) +time="2024-06-06T15:03:49Z" level=error msg="could not reach https://notary-server-on-the-moon:12306: Get \"https://notary-server-on-the-moon:12306/v2/\": dial tcp: lookup notary-server-on-the-moon on [::1]:53: read udp [::1]:60437->[::1]:53: read: connection refused" +--- PASS: TestClientTUFInitWithAutoPublish (0.28s) === RUN TestClientTUFAddWithAutoPublish -time="2025-07-09T21:20:02Z" level=error msg="could not reach https://notary-server:4443: Get \"https://notary-server:4443/v2/\": dial tcp: lookup notary-server on [::1]:53: read udp [::1]:59248->[::1]:53: read: connection refused" -time="2025-07-09T21:20:02Z" level=error msg="Could not publish Repository since we could not update: client is offline" -time="2025-07-09T21:20:02Z" level=error msg="could not reach https://notary-server-on-the-moon:12306: Get \"https://notary-server-on-the-moon:12306/v2/\": dial tcp: lookup notary-server-on-the-moon on [::1]:53: read udp [::1]:47537->[::1]:53: read: connection refused" -time="2025-07-09T21:20:02Z" level=error msg="Could not publish Repository since we could not update: client is offline" ---- PASS: TestClientTUFAddWithAutoPublish (0.06s) +time="2024-06-06T15:03:49Z" level=error msg="could not reach https://notary-server:4443: Get \"https://notary-server:4443/v2/\": dial tcp: lookup notary-server on [::1]:53: read udp [::1]:42455->[::1]:53: read: connection refused" +time="2024-06-06T15:03:49Z" level=error msg="Could not publish Repository since we could not update: client is offline" +time="2024-06-06T15:03:49Z" level=error msg="could not reach https://notary-server-on-the-moon:12306: Get \"https://notary-server-on-the-moon:12306/v2/\": dial tcp: lookup notary-server-on-the-moon on [::1]:53: read udp [::1]:60519->[::1]:53: read: connection refused" +time="2024-06-06T15:03:49Z" level=error msg="Could not publish Repository since we could not update: client is offline" +--- PASS: TestClientTUFAddWithAutoPublish (0.30s) === RUN TestClientTUFRemoveWithAutoPublish ---- PASS: TestClientTUFRemoveWithAutoPublish (0.11s) +--- PASS: TestClientTUFRemoveWithAutoPublish (0.49s) === RUN TestClientDelegationAddWithAutoPublish ---- PASS: TestClientDelegationAddWithAutoPublish (0.05s) +--- PASS: TestClientDelegationAddWithAutoPublish (0.20s) === RUN TestClientDelegationRemoveWithAutoPublish -time="2025-07-09T21:20:02Z" level=warning msg="role targets/delegation has fewer keys than its threshold of 1; it will not be usable until keys are added to it" -time="2025-07-09T21:20:02Z" level=warning msg="role targets/delegation has fewer keys than its threshold of 1; it will not be usable until keys are added to it" ---- PASS: TestClientDelegationRemoveWithAutoPublish (0.10s) +time="2024-06-06T15:03:50Z" level=warning msg="role targets/delegation has fewer keys than its threshold of 1; it will not be usable until keys are added to it" +time="2024-06-06T15:03:50Z" level=warning msg="role targets/delegation has fewer keys than its threshold of 1; it will not be usable until keys are added to it" +--- PASS: TestClientDelegationRemoveWithAutoPublish (0.47s) === RUN TestClientTUFAddByHashWithAutoPublish ---- PASS: TestClientTUFAddByHashWithAutoPublish (0.05s) +--- PASS: TestClientTUFAddByHashWithAutoPublish (0.22s) === RUN TestClientKeyImport -time="2025-07-09T21:20:02Z" level=warning msg="failed to import key to store: Invalid key generated, key may be encrypted and does not contain path header" -time="2025-07-09T21:20:02Z" level=warning msg="failed to import key () to store: Cannot have canonical role key without a gun, don't know what gun it belongs to" ---- PASS: TestClientKeyImport (0.02s) +time="2024-06-06T15:03:51Z" level=warning msg="failed to import key to store: Invalid key generated, key may be encrypted and does not contain path header" +time="2024-06-06T15:03:51Z" level=warning msg="failed to import key () to store: Cannot have canonical role key without a gun, don't know what gun it belongs to" +--- PASS: TestClientKeyImport (0.10s) === RUN TestAddDelImportKeyPublishFlow -time="2025-07-09T21:20:02Z" level=error msg="couldn't add target to targets/releases: could not find necessary signing keys, at least one of these keys must be available: 0570f9fdca00bdaf62f3f79bf84e70748ba2c8bff926f20dd996bac49e6164fc" ---- PASS: TestAddDelImportKeyPublishFlow (0.12s) +time="2024-06-06T15:03:51Z" level=error msg="couldn't add target to targets/releases: could not find necessary signing keys, at least one of these keys must be available: 0570f9fdca00bdaf62f3f79bf84e70748ba2c8bff926f20dd996bac49e6164fc" +--- PASS: TestAddDelImportKeyPublishFlow (0.60s) === RUN TestExportImportFlow ---- PASS: TestExportImportFlow (0.04s) +--- PASS: TestExportImportFlow (0.18s) === RUN TestDelegationKeyImportExport ---- PASS: TestDelegationKeyImportExport (0.00s) +--- PASS: TestDelegationKeyImportExport (0.02s) === RUN TestImportKeysNoYubikey ---- PASS: TestImportKeysNoYubikey (0.00s) +--- PASS: TestImportKeysNoYubikey (0.02s) === RUN TestExportImportKeysNoYubikey ---- PASS: TestExportImportKeysNoYubikey (0.01s) +--- PASS: TestExportImportKeysNoYubikey (0.02s) === RUN TestRemoveIfNoKey --- PASS: TestRemoveIfNoKey (0.00s) === RUN TestRemoveOneKeyAbort ---- PASS: TestRemoveOneKeyAbort (0.00s) +--- PASS: TestRemoveOneKeyAbort (0.02s) === RUN TestRemoveOneKeyConfirm ---- PASS: TestRemoveOneKeyConfirm (0.00s) +--- PASS: TestRemoveOneKeyConfirm (0.02s) === RUN TestRemoveMultikeysInvalidInput ---- PASS: TestRemoveMultikeysInvalidInput (0.00s) +--- PASS: TestRemoveMultikeysInvalidInput (0.01s) === RUN TestRemoveMultikeysAbortChoice ---- PASS: TestRemoveMultikeysAbortChoice (0.00s) +--- PASS: TestRemoveMultikeysAbortChoice (0.02s) === RUN TestRemoveMultikeysRemoveOnlyChosenKey ---- PASS: TestRemoveMultikeysRemoveOnlyChosenKey (0.00s) +--- PASS: TestRemoveMultikeysRemoveOnlyChosenKey (0.02s) === RUN TestRotateKeyInvalidRoles -time="2025-07-09T21:20:02Z" level=error msg="could not reach https://notary-server:4443: Get \"https://notary-server:4443/v2/\": dial tcp: lookup notary-server on [::1]:53: read udp [::1]:44073->[::1]:53: read: connection refused" -time="2025-07-09T21:20:02Z" level=error msg="could not reach https://notary-server:4443: Get \"https://notary-server:4443/v2/\": dial tcp: lookup notary-server on [::1]:53: read udp [::1]:46372->[::1]:53: read: connection refused" -time="2025-07-09T21:20:02Z" level=error msg="could not reach https://notary-server:4443: Get \"https://notary-server:4443/v2/\": dial tcp: lookup notary-server on [::1]:53: read udp [::1]:40575->[::1]:53: read: connection refused" -time="2025-07-09T21:20:02Z" level=error msg="could not reach https://notary-server:4443: Get \"https://notary-server:4443/v2/\": dial tcp: lookup notary-server on [::1]:53: read udp [::1]:45442->[::1]:53: read: connection refused" ---- PASS: TestRotateKeyInvalidRoles (0.00s) +time="2024-06-06T15:03:52Z" level=error msg="could not reach https://notary-server:4443: Get \"https://notary-server:4443/v2/\": dial tcp: lookup notary-server on [::1]:53: read udp [::1]:32844->[::1]:53: read: connection refused" +time="2024-06-06T15:03:52Z" level=error msg="could not reach https://notary-server:4443: Get \"https://notary-server:4443/v2/\": dial tcp: lookup notary-server on [::1]:53: read udp [::1]:48884->[::1]:53: read: connection refused" +time="2024-06-06T15:03:52Z" level=error msg="could not reach https://notary-server:4443: Get \"https://notary-server:4443/v2/\": dial tcp: lookup notary-server on [::1]:53: read udp [::1]:48784->[::1]:53: read: connection refused" +time="2024-06-06T15:03:52Z" level=error msg="could not reach https://notary-server:4443: Get \"https://notary-server:4443/v2/\": dial tcp: lookup notary-server on [::1]:53: read udp [::1]:35946->[::1]:53: read: connection refused" +--- PASS: TestRotateKeyInvalidRoles (0.01s) === RUN TestRotateKeyTargetCannotBeServerManaged -time="2025-07-09T21:20:02Z" level=error msg="could not reach https://notary-server:4443: Get \"https://notary-server:4443/v2/\": dial tcp: lookup notary-server on [::1]:53: read udp [::1]:57555->[::1]:53: read: connection refused" +time="2024-06-06T15:03:52Z" level=error msg="could not reach https://notary-server:4443: Get \"https://notary-server:4443/v2/\": dial tcp: lookup notary-server on [::1]:53: read udp [::1]:60996->[::1]:53: read: connection refused" --- PASS: TestRotateKeyTargetCannotBeServerManaged (0.00s) === RUN TestRotateKeyTimestampCannotBeLocallyManaged -time="2025-07-09T21:20:02Z" level=error msg="could not reach https://notary-server:4443: Get \"https://notary-server:4443/v2/\": dial tcp: lookup notary-server on [::1]:53: read udp [::1]:40554->[::1]:53: read: connection refused" ---- PASS: TestRotateKeyTimestampCannotBeLocallyManaged (0.00s) +time="2024-06-06T15:03:52Z" level=error msg="could not reach https://notary-server:4443: Get \"https://notary-server:4443/v2/\": dial tcp: lookup notary-server on [::1]:53: read udp [::1]:56660->[::1]:53: read: connection refused" +--- PASS: TestRotateKeyTimestampCannotBeLocallyManaged (0.01s) === RUN TestRotateKeyNoGUN Usage: --- PASS: TestRotateKeyNoGUN (0.00s) === RUN TestRotateKeyRemoteServerManagesKey Successfully rotated snapshot key for repository docker.com/notary Successfully rotated timestamp key for repository docker.com/notary ---- PASS: TestRotateKeyRemoteServerManagesKey (0.06s) +--- PASS: TestRotateKeyRemoteServerManagesKey (0.26s) === RUN TestRotateKeyBothKeys Successfully rotated targets key for repository docker.com/notary Successfully rotated snapshot key for repository docker.com/notary ---- PASS: TestRotateKeyBothKeys (0.04s) +--- PASS: TestRotateKeyBothKeys (0.21s) === RUN TestRotateKeyRootIsInteractive ---- PASS: TestRotateKeyRootIsInteractive (0.02s) +--- PASS: TestRotateKeyRootIsInteractive (0.06s) === RUN TestChangeKeyPassphraseInvalidID --- PASS: TestChangeKeyPassphraseInvalidID (0.00s) === RUN TestChangeKeyPassphraseInvalidNumArgs @@ -2431,40 +2467,40 @@ === RUN TestChangeKeyPassphraseNonexistentID --- PASS: TestChangeKeyPassphraseNonexistentID (0.00s) === RUN TestExportKeys ---- PASS: TestExportKeys (0.00s) +--- PASS: TestExportKeys (0.01s) === RUN TestExportKeysByGUN ---- PASS: TestExportKeysByGUN (0.00s) +--- PASS: TestExportKeysByGUN (0.01s) === RUN TestExportKeysByID ---- PASS: TestExportKeysByID (0.00s) +--- PASS: TestExportKeysByID (0.01s) === RUN TestExportKeysBadFlagCombo --- PASS: TestExportKeysBadFlagCombo (0.00s) === RUN TestImportKeysNonexistentFile --- PASS: TestImportKeysNonexistentFile (0.00s) === RUN TestKeyGeneration -time="2025-07-09T21:20:02Z" level=warning msg="failed to import key () to store: Cannot have canonical role key without a gun, don't know what gun it belongs to" ---- PASS: TestKeyGeneration (0.01s) +time="2024-06-06T15:03:52Z" level=warning msg="failed to import key () to store: Cannot have canonical role key without a gun, don't know what gun it belongs to" +--- PASS: TestKeyGeneration (0.04s) === RUN TestNotaryConfigFileDefault --- PASS: TestNotaryConfigFileDefault (0.00s) === RUN TestRemoteServerDefault ---- PASS: TestRemoteServerDefault (0.00s) +--- PASS: TestRemoteServerDefault (0.01s) === RUN TestRemoteServerUsesConfigFile --- PASS: TestRemoteServerUsesConfigFile (0.00s) === RUN TestRemoteServerCommandLineFlagOverridesConfig ---- PASS: TestRemoteServerCommandLineFlagOverridesConfig (0.00s) +--- PASS: TestRemoteServerCommandLineFlagOverridesConfig (0.01s) === RUN TestInvalidAddHashCommands ---- PASS: TestInvalidAddHashCommands (0.00s) +--- PASS: TestInvalidAddHashCommands (0.01s) === RUN TestConfigParsingErrorsPropagatedByCommands --- PASS: TestConfigParsingErrorsPropagatedByCommands (0.00s) === RUN TestInsufficientArgumentsReturnsErrorAndPrintsUsage ---- PASS: TestInsufficientArgumentsReturnsErrorAndPrintsUsage (0.01s) +--- PASS: TestInsufficientArgumentsReturnsErrorAndPrintsUsage (0.05s) === RUN TestBareCommandPrintsUsageAndNoError --- PASS: TestBareCommandPrintsUsageAndNoError (0.00s) === RUN TestConfigFileTLSCannotBeRelativeToCWD ---- PASS: TestConfigFileTLSCannotBeRelativeToCWD (0.00s) +--- PASS: TestConfigFileTLSCannotBeRelativeToCWD (0.02s) === RUN TestConfigFileTLSCanBeRelativeToConfigOrAbsolute ---- PASS: TestConfigFileTLSCanBeRelativeToConfigOrAbsolute (0.02s) +--- PASS: TestConfigFileTLSCanBeRelativeToConfigOrAbsolute (0.10s) === RUN TestConfigFileOverridenByCmdLineFlags ---- PASS: TestConfigFileOverridenByCmdLineFlags (0.02s) +--- PASS: TestConfigFileOverridenByCmdLineFlags (0.10s) === RUN TestConfigFileTrustPinning --- PASS: TestConfigFileTrustPinning (0.00s) === RUN TestPassphraseRetrieverCaching @@ -2478,7 +2514,7 @@ === RUN TestPrettyPrintZeroKeys --- PASS: TestPrettyPrintZeroKeys (0.00s) === RUN TestPrettyPrintRootAndSigningKeys ---- PASS: TestPrettyPrintRootAndSigningKeys (0.01s) +--- PASS: TestPrettyPrintRootAndSigningKeys (0.05s) === RUN TestPrettyPrintZeroTargets --- PASS: TestPrettyPrintZeroTargets (0.00s) === RUN TestPrettyPrintSortedTargets @@ -2490,10 +2526,10 @@ === RUN TestImportRootCert --- PASS: TestImportRootCert (0.00s) === RUN TestTokenAuth -time="2025-07-09T21:20:02Z" level=error msg="could not reach https://localhost:9999: Get \"https://localhost:9999/v2/\": dial tcp 127.0.0.1:9999: connect: connection refused" +time="2024-06-06T15:03:53Z" level=error msg="could not reach https://localhost:9999: Get \"https://localhost:9999/v2/\": dial tcp 127.0.0.1:9999: connect: connection refused" --- PASS: TestTokenAuth (0.00s) === RUN TestAdminTokenAuth -time="2025-07-09T21:20:02Z" level=error msg="could not reach https://localhost:9999: Get \"https://localhost:9999/v2/\": dial tcp 127.0.0.1:9999: connect: connection refused" +time="2024-06-06T15:03:53Z" level=error msg="could not reach https://localhost:9999: Get \"https://localhost:9999/v2/\": dial tcp 127.0.0.1:9999: connect: connection refused" --- PASS: TestAdminTokenAuth (0.00s) === RUN TestTokenAuth200Status --- PASS: TestTokenAuth200Status (0.00s) @@ -2504,18 +2540,18 @@ === RUN TestAdminTokenAuth401Status --- PASS: TestAdminTokenAuth401Status (0.00s) === RUN TestTokenAuthNon200Non401Status -time="2025-07-09T21:20:02Z" level=error msg="could not reach http://127.0.0.1:42247: 404" +time="2024-06-06T15:03:53Z" level=error msg="could not reach http://127.0.0.1:34657: 404" --- PASS: TestTokenAuthNon200Non401Status (0.00s) === RUN TestAdminTokenAuthNon200Non401Status -time="2025-07-09T21:20:02Z" level=error msg="could not reach http://127.0.0.1:37119: 404" +time="2024-06-06T15:03:53Z" level=error msg="could not reach http://127.0.0.1:44681: 404" --- PASS: TestAdminTokenAuthNon200Non401Status (0.00s) === RUN TestConfigureRepo ---- PASS: TestConfigureRepo (0.00s) +--- PASS: TestConfigureRepo (0.03s) === RUN TestConfigureRepoRW -Enter username: time="2025-07-09T21:20:02Z" level=error msg="error processing username input: EOF" +Enter username: time="2024-06-06T15:03:53Z" level=error msg="error processing username input: EOF" --- PASS: TestConfigureRepoRW (0.00s) === RUN TestConfigureRepoAdmin -Enter username: time="2025-07-09T21:20:02Z" level=error msg="error processing username input: EOF" +Enter username: time="2024-06-06T15:03:53Z" level=error msg="error processing username input: EOF" --- PASS: TestConfigureRepoAdmin (0.00s) === RUN TestStatusUnstageAndReset Successfully reset specified changes for repository gun @@ -2528,11 +2564,11 @@ Pushing changes to gun --- PASS: TestGetTrustPinningErrors (0.00s) === RUN TestPasswordStore -Enter username: time="2025-07-09T21:20:02Z" level=error msg="error processing username input: EOF" +Enter username: time="2024-06-06T15:03:53Z" level=error msg="error processing username input: EOF" --- PASS: TestPasswordStore (0.00s) === RUN TestPasswordStoreWithEnvvar -time="2025-07-09T21:20:02Z" level=error msg="Authentication string with zero-length username" -time="2025-07-09T21:20:02Z" level=error msg="Could not base64-decode authentication string" +time="2024-06-06T15:03:53Z" level=error msg="Authentication string with zero-length username" +time="2024-06-06T15:03:53Z" level=error msg="Could not base64-decode authentication string" --- PASS: TestPasswordStoreWithEnvvar (0.00s) === RUN TestGetPayload --- PASS: TestGetPayload (0.00s) @@ -2541,7 +2577,7 @@ === RUN TestHomeExpand --- PASS: TestHomeExpand (0.00s) PASS -ok github.com/theupdateframework/notary/cmd/notary 3.003s +ok github.com/theupdateframework/notary/cmd/notary 16.107s === RUN TestBootstrap --- PASS: TestBootstrap (0.00s) === RUN TestGetAddrAndTLSConfigInvalidTLS @@ -2557,57 +2593,57 @@ === RUN TestGetInvalidTrustService --- PASS: TestGetInvalidTrustService (0.00s) === RUN TestGetLocalTrustService -time="2025-07-09T21:20:00Z" level=info msg="Using local signing service, which requires ED25519. Ignoring all other trust_service parameters, including keyAlgorithm" +time="2024-06-06T15:03:37Z" level=info msg="Using local signing service, which requires ED25519. Ignoring all other trust_service parameters, including keyAlgorithm" --- PASS: TestGetLocalTrustService (0.00s) === RUN TestGetTrustServiceInvalidKeyAlgorithm --- PASS: TestGetTrustServiceInvalidKeyAlgorithm (0.00s) === RUN TestGetTrustServiceTLSMissingCertOrKey --- PASS: TestGetTrustServiceTLSMissingCertOrKey (0.00s) === RUN TestGetTrustServiceNoTLSConfig -time="2025-07-09T21:20:00Z" level=info msg="Using remote signing service" +time="2024-06-06T15:03:37Z" level=info msg="Using remote signing service" --- PASS: TestGetTrustServiceNoTLSConfig (0.00s) === RUN TestGetTrustServiceTLSSuccess -time="2025-07-09T21:20:00Z" level=info msg="Using remote signing service" +time="2024-06-06T15:03:37Z" level=info msg="Using remote signing service" --- PASS: TestGetTrustServiceTLSSuccess (0.00s) === RUN TestGetTrustServiceTLSFailure --- PASS: TestGetTrustServiceTLSFailure (0.00s) === RUN TestGetStoreInvalid -time="2025-07-09T21:20:00Z" level=info msg="Using asdf backend" +time="2024-06-06T15:03:37Z" level=info msg="Using asdf backend" --- PASS: TestGetStoreInvalid (0.00s) === RUN TestGetStoreDBStore -time="2025-07-09T21:20:00Z" level=info msg="Using sqlite3 backend" ---- PASS: TestGetStoreDBStore (0.01s) +time="2024-06-06T15:03:37Z" level=info msg="Using sqlite3 backend" +--- PASS: TestGetStoreDBStore (0.00s) === RUN TestGetStoreRethinkDBStoreConnectionFails -time="2025-07-09T21:20:00Z" level=info msg="Using rethinkdb backend" +time="2024-06-06T15:03:37Z" level=info msg="Using rethinkdb backend" --- PASS: TestGetStoreRethinkDBStoreConnectionFails (0.00s) === RUN TestGetMemoryStore -time="2025-07-09T21:20:00Z" level=info msg="Using memory backend" +time="2024-06-06T15:03:37Z" level=info msg="Using memory backend" --- PASS: TestGetMemoryStore (0.00s) === RUN TestGetCacheConfig --- PASS: TestGetCacheConfig (0.00s) === RUN TestGetGUNPRefixes --- PASS: TestGetGUNPRefixes (0.00s) === RUN TestSampleConfig -time="2025-07-09T21:20:00Z" level=info msg="Using remote signing service" -time="2025-07-09T21:20:00Z" level=info msg="Using sqlite3 backend" ---- PASS: TestSampleConfig (0.01s) +time="2024-06-06T15:03:37Z" level=info msg="Using remote signing service" +time="2024-06-06T15:03:37Z" level=info msg="Using sqlite3 backend" +--- PASS: TestSampleConfig (0.00s) PASS -ok github.com/theupdateframework/notary/cmd/notary-server 0.040s +ok github.com/theupdateframework/notary/cmd/notary-server 0.056s === RUN TestGetAddrAndTLSConfigInvalidTLS --- PASS: TestGetAddrAndTLSConfigInvalidTLS (0.00s) === RUN TestGetAddrAndTLSConfigNoGRPCAddr ---- PASS: TestGetAddrAndTLSConfigNoGRPCAddr (0.00s) +--- PASS: TestGetAddrAndTLSConfigNoGRPCAddr (0.01s) === RUN TestGetAddrAndTLSConfigSuccess --- PASS: TestGetAddrAndTLSConfigSuccess (0.00s) === RUN TestSetupCryptoServicesDBStoreNoDefaultAlias ---- PASS: TestSetupCryptoServicesDBStoreNoDefaultAlias (0.00s) +--- PASS: TestSetupCryptoServicesDBStoreNoDefaultAlias (0.01s) === RUN TestSetupCryptoServicesRethinkDBStoreNoDefaultAlias --- PASS: TestSetupCryptoServicesRethinkDBStoreNoDefaultAlias (0.00s) === RUN TestSetupCryptoServicesRethinkDBStoreConnectionFails main_test.go:121: DM - skipping malfunctioning test, fails on sbuild --- SKIP: TestSetupCryptoServicesRethinkDBStoreConnectionFails (0.00s) === RUN TestSetupCryptoServicesDBStoreSuccess ---- PASS: TestSetupCryptoServicesDBStoreSuccess (0.05s) +--- PASS: TestSetupCryptoServicesDBStoreSuccess (0.14s) === RUN TestSetupCryptoServicesMemoryStore --- PASS: TestSetupCryptoServicesMemoryStore (0.00s) === RUN TestSetupCryptoServicesInvalidStore @@ -2619,23 +2655,23 @@ === RUN TestBootstrap --- PASS: TestBootstrap (0.00s) === RUN TestGetEnv ---- PASS: TestGetEnv (0.00s) +--- PASS: TestGetEnv (0.01s) === RUN TestPassphraseRetrieverInvalid --- PASS: TestPassphraseRetrieverInvalid (0.00s) === RUN TestSampleConfig --- PASS: TestSampleConfig (0.00s) PASS -ok github.com/theupdateframework/notary/cmd/notary-signer 0.078s +ok github.com/theupdateframework/notary/cmd/notary-signer 0.237s === RUN TestGenerateCertificate --- PASS: TestGenerateCertificate (0.00s) === RUN TestCryptoServiceWithNonEmptyGUN ---- PASS: TestCryptoServiceWithNonEmptyGUN (0.37s) +--- PASS: TestCryptoServiceWithNonEmptyGUN (1.54s) === RUN TestCryptoServiceWithEmptyGUN ---- PASS: TestCryptoServiceWithEmptyGUN (0.33s) +--- PASS: TestCryptoServiceWithEmptyGUN (1.98s) === RUN TestCryptoSignerInterfaceBehavior --- PASS: TestCryptoSignerInterfaceBehavior (0.00s) PASS -ok github.com/theupdateframework/notary/cryptoservice 0.721s +ok github.com/theupdateframework/notary/cryptoservice 3.565s === RUN TestGetPassphraseForUsingDelegationKey --- PASS: TestGetPassphraseForUsingDelegationKey (0.00s) === RUN TestGetPassphraseLimitsShortPassphrases @@ -2651,280 +2687,280 @@ === RUN TestGetPassphrase --- PASS: TestGetPassphrase (0.00s) PASS -ok github.com/theupdateframework/notary/passphrase 0.011s +ok github.com/theupdateframework/notary/passphrase 0.054s === RUN TestValidationErrorFormat -time="2025-07-09T21:20:00Z" level=info msg="invalid update: Update sent by the client is invalid.: &{ErrBadHierarchy Metadata hierarchy is incomplete: no snapshot was included in update and server does not hold current snapshot key for repository}" go.version=go1.22.3 http.request.contenttype="multipart/form-data; boundary=75c144d2290f09ade715ebb3ce745a9b2c483b23b9d22e9a2ab7726c8530" http.request.host="127.0.0.1:44069" http.request.id=ece59757-d71d-4f7b-9673-1d130c39d429 http.request.method=POST http.request.remoteaddr="127.0.0.1:52624" http.request.uri=/v2/docker.com/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 -time="2025-07-09T21:20:00Z" level=info msg="response completed" go.version=go1.22.3 http.request.contenttype="multipart/form-data; boundary=75c144d2290f09ade715ebb3ce745a9b2c483b23b9d22e9a2ab7726c8530" http.request.host="127.0.0.1:44069" http.request.id=ece59757-d71d-4f7b-9673-1d130c39d429 http.request.method=POST http.request.remoteaddr="127.0.0.1:52624" http.request.uri=/v2/docker.com/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 http.response.contenttype="application/json; charset=utf-8" http.response.duration=1.573361ms http.response.status=400 http.response.written=260 ---- PASS: TestValidationErrorFormat (0.01s) +time="2024-06-06T15:03:38Z" level=info msg="invalid update: Update sent by the client is invalid.: &{ErrBadHierarchy Metadata hierarchy is incomplete: no snapshot was included in update and server does not hold current snapshot key for repository}" go.version=go1.22.3 http.request.contenttype="multipart/form-data; boundary=32b40815d911a3af248e1adbbe992a0e34305f77beeb6eea39d0ab6fd1ee" http.request.host="127.0.0.1:35425" http.request.id=cd8cd1a9-ca17-443c-af78-84bc70bd1452 http.request.method=POST http.request.remoteaddr="127.0.0.1:56472" http.request.uri=/v2/docker.com/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 +time="2024-06-06T15:03:38Z" level=info msg="response completed" go.version=go1.22.3 http.request.contenttype="multipart/form-data; boundary=32b40815d911a3af248e1adbbe992a0e34305f77beeb6eea39d0ab6fd1ee" http.request.host="127.0.0.1:35425" http.request.id=cd8cd1a9-ca17-443c-af78-84bc70bd1452 http.request.method=POST http.request.remoteaddr="127.0.0.1:56472" http.request.uri=/v2/docker.com/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 http.response.contenttype="application/json; charset=utf-8" http.response.duration=2.564577ms http.response.status=400 http.response.written=260 +--- PASS: TestValidationErrorFormat (0.15s) === RUN TestRunBadAddr --- PASS: TestRunBadAddr (0.00s) === RUN TestRunReservedPort --- PASS: TestRunReservedPort (0.00s) === RUN TestRepoPrefixMatches -time="2025-07-09T21:20:00Z" level=info msg="updated docker.io/notary to timestamp version 1, checksum c19d65d235c996c0846f2779fa49679e6c87c2753b9a487093b6bc9a658d9d73" docker.io/notary=gun go.version=go1.22.3 http.request.contenttype="multipart/form-data; boundary=d930a4707f168a0a9aadc44e3c22785e687e4d18012ce35862648fe8a608" http.request.host="127.0.0.1:40155" http.request.id=272af271-b73b-4873-8680-56539fe42b43 http.request.method=POST http.request.remoteaddr="127.0.0.1:39740" http.request.uri=/v2/docker.io/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 -time="2025-07-09T21:20:00Z" level=info msg="response completed" go.version=go1.22.3 http.request.contenttype="multipart/form-data; boundary=d930a4707f168a0a9aadc44e3c22785e687e4d18012ce35862648fe8a608" http.request.host="127.0.0.1:40155" http.request.id=272af271-b73b-4873-8680-56539fe42b43 http.request.method=POST http.request.remoteaddr="127.0.0.1:39740" http.request.uri=/v2/docker.io/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 http.response.duration=2.854842ms http.response.status=0 http.response.written=0 -time="2025-07-09T21:20:00Z" level=info msg="response completed" go.version=go1.22.3 http.request.host="127.0.0.1:40155" http.request.id=ffc48bc3-3308-41e8-8f51-8912b4c6e124 http.request.method=GET http.request.remoteaddr="127.0.0.1:39740" http.request.uri=/v2/docker.io/notary/_trust/tuf/snapshot.json http.request.useragent=Go-http-client/1.1 http.response.duration="356.334µs" http.response.status=200 http.response.written=683 -time="2025-07-09T21:20:00Z" level=info msg="response completed" go.version=go1.22.3 http.request.host="127.0.0.1:40155" http.request.id=7da591ae-2a8c-42e6-9ae8-a02b7c486b87 http.request.method=GET http.request.remoteaddr="127.0.0.1:39740" http.request.uri=/v2/docker.io/notary/_trust/tuf/snapshot.c0d3fad18253ae0dd8b2950b71a0dc1df25a4bcf2c9ea244697186641dcbc853.json http.request.useragent=Go-http-client/1.1 http.response.duration="28.184µs" http.response.status=200 http.response.written=683 -time="2025-07-09T21:20:00Z" level=info msg="response completed" go.version=go1.22.3 http.request.host="127.0.0.1:40155" http.request.id=0bde9a99-1399-48a0-abd3-19342706c3c2 http.request.method=GET http.request.remoteaddr="127.0.0.1:39740" http.request.uri=/v2/docker.io/notary/_trust/tuf/timestamp.key http.request.useragent=Go-http-client/1.1 http.response.duration="557.754µs" http.response.status=200 http.response.written=181 -time="2025-07-09T21:20:00Z" level=info msg="trust data deleted for docker.io/notary" docker.io/notary=gun go.version=go1.22.3 http.request.host="127.0.0.1:40155" http.request.id=c0f398f4-c7cf-432b-a55b-e474c2674021 http.request.method=DELETE http.request.remoteaddr="127.0.0.1:39740" http.request.uri=/v2/docker.io/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 -time="2025-07-09T21:20:00Z" level=info msg="response completed" go.version=go1.22.3 http.request.host="127.0.0.1:40155" http.request.id=c0f398f4-c7cf-432b-a55b-e474c2674021 http.request.method=DELETE http.request.remoteaddr="127.0.0.1:39740" http.request.uri=/v2/docker.io/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 http.response.duration="72.608µs" http.response.status=0 http.response.written=0 ---- PASS: TestRepoPrefixMatches (0.01s) +time="2024-06-06T15:03:38Z" level=info msg="updated docker.io/notary to timestamp version 1, checksum 3aab787e8e46910da5cd17deca1efa2b1a087854ed92354eb4f5c68aee39a5b1" docker.io/notary=gun go.version=go1.22.3 http.request.contenttype="multipart/form-data; boundary=cff05ca3ea6758dc1d493fc2318b27d8df25ef66565f5e97e2a6f5315de5" http.request.host="127.0.0.1:42317" http.request.id=ca1521c7-ec19-4fe5-9d3b-bdb927d004f1 http.request.method=POST http.request.remoteaddr="127.0.0.1:44468" http.request.uri=/v2/docker.io/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 +time="2024-06-06T15:03:38Z" level=info msg="response completed" go.version=go1.22.3 http.request.contenttype="multipart/form-data; boundary=cff05ca3ea6758dc1d493fc2318b27d8df25ef66565f5e97e2a6f5315de5" http.request.host="127.0.0.1:42317" http.request.id=ca1521c7-ec19-4fe5-9d3b-bdb927d004f1 http.request.method=POST http.request.remoteaddr="127.0.0.1:44468" http.request.uri=/v2/docker.io/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 http.response.duration=4.560241ms http.response.status=0 http.response.written=0 +time="2024-06-06T15:03:38Z" level=info msg="response completed" go.version=go1.22.3 http.request.host="127.0.0.1:42317" http.request.id=ae85f69e-a04a-4dc3-9e02-f9684818d74c http.request.method=GET http.request.remoteaddr="127.0.0.1:44468" http.request.uri=/v2/docker.io/notary/_trust/tuf/snapshot.json http.request.useragent=Go-http-client/1.1 http.response.duration="753.349µs" http.response.status=200 http.response.written=683 +time="2024-06-06T15:03:38Z" level=info msg="response completed" go.version=go1.22.3 http.request.host="127.0.0.1:42317" http.request.id=3df66d03-2624-4e55-892a-1234735c030e http.request.method=GET http.request.remoteaddr="127.0.0.1:44468" http.request.uri=/v2/docker.io/notary/_trust/tuf/snapshot.3421a886775c1c0da2df122fe9f2faaa6a7b590e8264b7d6ab1dce7a6707f077.json http.request.useragent=Go-http-client/1.1 http.response.duration="44.385µs" http.response.status=200 http.response.written=683 +time="2024-06-06T15:03:38Z" level=info msg="response completed" go.version=go1.22.3 http.request.host="127.0.0.1:42317" http.request.id=6b0e864e-9533-4842-b0dd-4b4d754aad5b http.request.method=GET http.request.remoteaddr="127.0.0.1:44468" http.request.uri=/v2/docker.io/notary/_trust/tuf/timestamp.key http.request.useragent=Go-http-client/1.1 http.response.duration="553.11µs" http.response.status=200 http.response.written=181 +time="2024-06-06T15:03:38Z" level=info msg="trust data deleted for docker.io/notary" docker.io/notary=gun go.version=go1.22.3 http.request.host="127.0.0.1:42317" http.request.id=515b1e7a-a747-4510-9dc3-4f8a6ee0b686 http.request.method=DELETE http.request.remoteaddr="127.0.0.1:44468" http.request.uri=/v2/docker.io/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 +time="2024-06-06T15:03:38Z" level=info msg="response completed" go.version=go1.22.3 http.request.host="127.0.0.1:42317" http.request.id=515b1e7a-a747-4510-9dc3-4f8a6ee0b686 http.request.method=DELETE http.request.remoteaddr="127.0.0.1:44468" http.request.uri=/v2/docker.io/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 http.response.duration=4.347597ms http.response.status=0 http.response.written=0 +--- PASS: TestRepoPrefixMatches (0.05s) === RUN TestRepoPrefixDoesNotMatch ---- PASS: TestRepoPrefixDoesNotMatch (0.01s) +--- PASS: TestRepoPrefixDoesNotMatch (0.09s) === RUN TestMetricsEndpoint ---- PASS: TestMetricsEndpoint (0.01s) +--- PASS: TestMetricsEndpoint (0.05s) === RUN TestGetKeysEndpoint -time="2025-07-09T21:20:00Z" level=info msg="metadata not found: You have requested metadata that does not exist.: " go.version=go1.22.3 http.request.host="127.0.0.1:46749" http.request.id=cba71ca0-2b70-4f76-87e7-980595c1a6dd http.request.method=GET http.request.remoteaddr="127.0.0.1:39556" http.request.uri=/v2/gun/_trust/tuf/root.key http.request.useragent=Go-http-client/1.1 -time="2025-07-09T21:20:00Z" level=info msg="response completed" go.version=go1.22.3 http.request.host="127.0.0.1:46749" http.request.id=cba71ca0-2b70-4f76-87e7-980595c1a6dd http.request.method=GET http.request.remoteaddr="127.0.0.1:39556" http.request.uri=/v2/gun/_trust/tuf/root.key http.request.useragent=Go-http-client/1.1 http.response.contenttype="application/json; charset=utf-8" http.response.duration="165.704µs" http.response.status=404 http.response.written=104 -time="2025-07-09T21:20:00Z" level=info msg="metadata not found: You have requested metadata that does not exist.: " go.version=go1.22.3 http.request.host="127.0.0.1:46749" http.request.id=9fdd07a7-ec2a-4155-8719-8fd98aaf720a http.request.method=GET http.request.remoteaddr="127.0.0.1:39562" http.request.uri=/v2/gun/_trust/tuf/somerandomrole.key http.request.useragent=Go-http-client/1.1 -time="2025-07-09T21:20:00Z" level=info msg="response completed" go.version=go1.22.3 http.request.host="127.0.0.1:46749" http.request.id=9fdd07a7-ec2a-4155-8719-8fd98aaf720a http.request.method=GET http.request.remoteaddr="127.0.0.1:39562" http.request.uri=/v2/gun/_trust/tuf/somerandomrole.key http.request.useragent=Go-http-client/1.1 http.response.contenttype="application/json; charset=utf-8" http.response.duration="100.739µs" http.response.status=404 http.response.written=104 -time="2025-07-09T21:20:00Z" level=info msg="response completed" go.version=go1.22.3 http.request.host="127.0.0.1:46749" http.request.id=9fa18024-4cd4-444a-8a48-f9d1bf0192e2 http.request.method=GET http.request.remoteaddr="127.0.0.1:39578" http.request.uri=/v2/gun/_trust/tuf/timestamp.key http.request.useragent=Go-http-client/1.1 http.response.duration=1.600492ms http.response.status=200 http.response.written=103 -time="2025-07-09T21:20:00Z" level=info msg="response completed" go.version=go1.22.3 http.request.host="127.0.0.1:46749" http.request.id=a07babd8-aa2f-40cd-b3ed-7149dd9a55fa http.request.method=GET http.request.remoteaddr="127.0.0.1:39592" http.request.uri=/v2/gun/_trust/tuf/snapshot.key http.request.useragent=Go-http-client/1.1 http.response.duration="104.69µs" http.response.status=200 http.response.written=103 -time="2025-07-09T21:20:00Z" level=info msg="metadata not found: You have requested metadata that does not exist.: " go.version=go1.22.3 http.request.host="127.0.0.1:46749" http.request.id=4f555482-a3ce-43a1-b78b-4f74075ffce3 http.request.method=GET http.request.remoteaddr="127.0.0.1:39596" http.request.uri=/v2/gun/_trust/tuf/targets.key http.request.useragent=Go-http-client/1.1 -time="2025-07-09T21:20:00Z" level=info msg="response completed" go.version=go1.22.3 http.request.host="127.0.0.1:46749" http.request.id=4f555482-a3ce-43a1-b78b-4f74075ffce3 http.request.method=GET http.request.remoteaddr="127.0.0.1:39596" http.request.uri=/v2/gun/_trust/tuf/targets.key http.request.useragent=Go-http-client/1.1 http.response.contenttype="application/json; charset=utf-8" http.response.duration="78.804µs" http.response.status=404 http.response.written=104 ---- PASS: TestGetKeysEndpoint (0.01s) +time="2024-06-06T15:03:39Z" level=info msg="metadata not found: You have requested metadata that does not exist.: " go.version=go1.22.3 http.request.host="127.0.0.1:35441" http.request.id=36d0ff29-21eb-4e5a-8d21-a948a169d550 http.request.method=GET http.request.remoteaddr="127.0.0.1:58100" http.request.uri=/v2/gun/_trust/tuf/targets.key http.request.useragent=Go-http-client/1.1 +time="2024-06-06T15:03:39Z" level=info msg="response completed" go.version=go1.22.3 http.request.host="127.0.0.1:35441" http.request.id=36d0ff29-21eb-4e5a-8d21-a948a169d550 http.request.method=GET http.request.remoteaddr="127.0.0.1:58100" http.request.uri=/v2/gun/_trust/tuf/targets.key http.request.useragent=Go-http-client/1.1 http.response.contenttype="application/json; charset=utf-8" http.response.duration="288.858µs" http.response.status=404 http.response.written=104 +time="2024-06-06T15:03:39Z" level=info msg="metadata not found: You have requested metadata that does not exist.: " go.version=go1.22.3 http.request.host="127.0.0.1:35441" http.request.id=fb30a99a-512c-42dc-b4ae-53071caddf87 http.request.method=GET http.request.remoteaddr="127.0.0.1:58112" http.request.uri=/v2/gun/_trust/tuf/root.key http.request.useragent=Go-http-client/1.1 +time="2024-06-06T15:03:39Z" level=info msg="response completed" go.version=go1.22.3 http.request.host="127.0.0.1:35441" http.request.id=fb30a99a-512c-42dc-b4ae-53071caddf87 http.request.method=GET http.request.remoteaddr="127.0.0.1:58112" http.request.uri=/v2/gun/_trust/tuf/root.key http.request.useragent=Go-http-client/1.1 http.response.contenttype="application/json; charset=utf-8" http.response.duration="99.432µs" http.response.status=404 http.response.written=104 +time="2024-06-06T15:03:39Z" level=info msg="metadata not found: You have requested metadata that does not exist.: " go.version=go1.22.3 http.request.host="127.0.0.1:35441" http.request.id=99b849bf-bd6e-4086-b215-4ca19302761a http.request.method=GET http.request.remoteaddr="127.0.0.1:58116" http.request.uri=/v2/gun/_trust/tuf/somerandomrole.key http.request.useragent=Go-http-client/1.1 +time="2024-06-06T15:03:39Z" level=info msg="response completed" go.version=go1.22.3 http.request.host="127.0.0.1:35441" http.request.id=99b849bf-bd6e-4086-b215-4ca19302761a http.request.method=GET http.request.remoteaddr="127.0.0.1:58116" http.request.uri=/v2/gun/_trust/tuf/somerandomrole.key http.request.useragent=Go-http-client/1.1 http.response.contenttype="application/json; charset=utf-8" http.response.duration="101.059µs" http.response.status=404 http.response.written=104 +time="2024-06-06T15:03:39Z" level=info msg="response completed" go.version=go1.22.3 http.request.host="127.0.0.1:35441" http.request.id=f2a45167-4b4f-4294-ba70-27bb21a01f52 http.request.method=GET http.request.remoteaddr="127.0.0.1:58122" http.request.uri=/v2/gun/_trust/tuf/timestamp.key http.request.useragent=Go-http-client/1.1 http.response.duration=13.182216ms http.response.status=200 http.response.written=103 +time="2024-06-06T15:03:39Z" level=info msg="response completed" go.version=go1.22.3 http.request.host="127.0.0.1:35441" http.request.id=2163f923-8f27-4db4-9d43-8fa6600cf80f http.request.method=GET http.request.remoteaddr="127.0.0.1:58138" http.request.uri=/v2/gun/_trust/tuf/snapshot.key http.request.useragent=Go-http-client/1.1 http.response.duration="276.715µs" http.response.status=200 http.response.written=103 +--- PASS: TestGetKeysEndpoint (0.05s) === RUN TestGetRoleByHash -time="2025-07-09T21:20:00Z" level=info msg="response completed" go.version=go1.22.3 http.request.host="127.0.0.1:41695" http.request.id=63d10c4c-a74a-4627-a692-7ae5cbab1d4a http.request.method=GET http.request.remoteaddr="127.0.0.1:43850" http.request.uri=/v2/gun/_trust/tuf/timestamp.4aef9802bf317ef529240392ef248fbd1c252f3979fb24a79516618c7bf581bf.json http.request.useragent=Go-http-client/1.1 http.response.duration="81.508µs" http.response.status=200 http.response.written=115 +time="2024-06-06T15:03:39Z" level=info msg="response completed" go.version=go1.22.3 http.request.host="127.0.0.1:44351" http.request.id=0c999567-85cb-4c7b-94db-4bb2f1d85eab http.request.method=GET http.request.remoteaddr="127.0.0.1:49526" http.request.uri=/v2/gun/_trust/tuf/timestamp.c86078fd110f2f86e90dfc1236f38dfe68f58805664b5d8ec7a2cbe4efe74bee.json http.request.useragent=Go-http-client/1.1 http.response.duration="156.261µs" http.response.status=200 http.response.written=115 --- PASS: TestGetRoleByHash (0.01s) === RUN TestGetRoleByVersion -time="2025-07-09T21:20:00Z" level=info msg="response completed" go.version=go1.22.3 http.request.host="127.0.0.1:33087" http.request.id=8eeea1dc-3df2-42f1-a694-d19426e139c8 http.request.method=GET http.request.remoteaddr="127.0.0.1:37674" http.request.uri=/v2/gun/_trust/tuf/1.timestamp.json http.request.useragent=Go-http-client/1.1 http.response.duration="309.68µs" http.response.status=200 http.response.written=115 ---- PASS: TestGetRoleByVersion (0.01s) +time="2024-06-06T15:03:39Z" level=info msg="response completed" go.version=go1.22.3 http.request.host="127.0.0.1:35599" http.request.id=198cab20-0cee-46eb-9e73-8f03295ec20d http.request.method=GET http.request.remoteaddr="127.0.0.1:46594" http.request.uri=/v2/gun/_trust/tuf/1.timestamp.json http.request.useragent=Go-http-client/1.1 http.response.duration="137.582µs" http.response.status=200 http.response.written=115 +--- PASS: TestGetRoleByVersion (0.03s) === RUN TestGetCurrentRole -time="2025-07-09T21:20:00Z" level=info msg="response completed" go.version=go1.22.3 http.request.host="127.0.0.1:42763" http.request.id=15666da5-b512-4ddb-84bb-c57a499a8692 http.request.method=GET http.request.remoteaddr="127.0.0.1:47640" http.request.uri=/v2/gun/_trust/tuf/timestamp.json http.request.useragent=Go-http-client/1.1 http.response.duration="343.308µs" http.response.status=200 http.response.written=495 +time="2024-06-06T15:03:39Z" level=info msg="response completed" go.version=go1.22.3 http.request.host="127.0.0.1:38209" http.request.id=2edb97e7-3e15-4bc5-968f-2391966510a4 http.request.method=GET http.request.remoteaddr="127.0.0.1:42284" http.request.uri=/v2/gun/_trust/tuf/timestamp.json http.request.useragent=Go-http-client/1.1 http.response.duration="792.857µs" http.response.status=200 http.response.written=495 --- PASS: TestGetCurrentRole (0.01s) === RUN TestRotateKeyEndpoint -time="2025-07-09T21:20:00Z" level=info msg="response completed" go.version=go1.22.3 http.request.contenttype=text/plain http.request.host="127.0.0.1:46155" http.request.id=b21ce290-097b-490c-a8fc-b5569c1dc3cc http.request.method=POST http.request.remoteaddr="127.0.0.1:37550" http.request.uri=/v2/gun/_trust/tuf/timestamp.key http.request.useragent=Go-http-client/1.1 http.response.duration="168.871µs" http.response.status=200 http.response.written=103 -time="2025-07-09T21:20:00Z" level=info msg="response completed" go.version=go1.22.3 http.request.contenttype=text/plain http.request.host="127.0.0.1:46155" http.request.id=ceae1ca8-7976-449b-b639-b7a531a50180 http.request.method=POST http.request.remoteaddr="127.0.0.1:37562" http.request.uri=/v2/gun/_trust/tuf/snapshot.key http.request.useragent=Go-http-client/1.1 http.response.duration="172.034µs" http.response.status=200 http.response.written=103 -time="2025-07-09T21:20:00Z" level=info msg="metadata not found: You have requested metadata that does not exist.: " go.version=go1.22.3 http.request.contenttype=text/plain http.request.host="127.0.0.1:46155" http.request.id=963d4413-ee40-45a0-b808-fff266f287e4 http.request.method=POST http.request.remoteaddr="127.0.0.1:37564" http.request.uri=/v2/gun/_trust/tuf/targets.key http.request.useragent=Go-http-client/1.1 -time="2025-07-09T21:20:00Z" level=info msg="response completed" go.version=go1.22.3 http.request.contenttype=text/plain http.request.host="127.0.0.1:46155" http.request.id=963d4413-ee40-45a0-b808-fff266f287e4 http.request.method=POST http.request.remoteaddr="127.0.0.1:37564" http.request.uri=/v2/gun/_trust/tuf/targets.key http.request.useragent=Go-http-client/1.1 http.response.contenttype="application/json; charset=utf-8" http.response.duration="98.268µs" http.response.status=404 http.response.written=104 -time="2025-07-09T21:20:00Z" level=info msg="metadata not found: You have requested metadata that does not exist.: " go.version=go1.22.3 http.request.contenttype=text/plain http.request.host="127.0.0.1:46155" http.request.id=42412f58-cd62-4145-a1af-89dc70a46fd3 http.request.method=POST http.request.remoteaddr="127.0.0.1:37574" http.request.uri=/v2/gun/_trust/tuf/root.key http.request.useragent=Go-http-client/1.1 -time="2025-07-09T21:20:00Z" level=info msg="response completed" go.version=go1.22.3 http.request.contenttype=text/plain http.request.host="127.0.0.1:46155" http.request.id=42412f58-cd62-4145-a1af-89dc70a46fd3 http.request.method=POST http.request.remoteaddr="127.0.0.1:37574" http.request.uri=/v2/gun/_trust/tuf/root.key http.request.useragent=Go-http-client/1.1 http.response.contenttype="application/json; charset=utf-8" http.response.duration="73.715µs" http.response.status=404 http.response.written=104 -time="2025-07-09T21:20:00Z" level=info msg="metadata not found: You have requested metadata that does not exist.: " go.version=go1.22.3 http.request.contenttype=text/plain http.request.host="127.0.0.1:46155" http.request.id=eed351d0-aba8-4deb-ac90-3c4faeff099e http.request.method=POST http.request.remoteaddr="127.0.0.1:37578" http.request.uri=/v2/gun/_trust/tuf/targets/delegation.key http.request.useragent=Go-http-client/1.1 -time="2025-07-09T21:20:00Z" level=info msg="response completed" go.version=go1.22.3 http.request.contenttype=text/plain http.request.host="127.0.0.1:46155" http.request.id=eed351d0-aba8-4deb-ac90-3c4faeff099e http.request.method=POST http.request.remoteaddr="127.0.0.1:37578" http.request.uri=/v2/gun/_trust/tuf/targets/delegation.key http.request.useragent=Go-http-client/1.1 http.response.contenttype="application/json; charset=utf-8" http.response.duration="90.036µs" http.response.status=404 http.response.written=104 -time="2025-07-09T21:20:00Z" level=info msg="metadata not found: You have requested metadata that does not exist.: " go.version=go1.22.3 http.request.contenttype=text/plain http.request.host="127.0.0.1:46155" http.request.id=024ee453-a0b2-4557-8406-0cf89f9921d4 http.request.method=POST http.request.remoteaddr="127.0.0.1:37582" http.request.uri=/v2/gun/_trust/tuf/somerandomrole.key http.request.useragent=Go-http-client/1.1 -time="2025-07-09T21:20:00Z" level=info msg="response completed" go.version=go1.22.3 http.request.contenttype=text/plain http.request.host="127.0.0.1:46155" http.request.id=024ee453-a0b2-4557-8406-0cf89f9921d4 http.request.method=POST http.request.remoteaddr="127.0.0.1:37582" http.request.uri=/v2/gun/_trust/tuf/somerandomrole.key http.request.useragent=Go-http-client/1.1 http.response.contenttype="application/json; charset=utf-8" http.response.duration="102.563µs" http.response.status=404 http.response.written=104 ---- PASS: TestRotateKeyEndpoint (0.01s) +time="2024-06-06T15:03:39Z" level=info msg="metadata not found: You have requested metadata that does not exist.: " go.version=go1.22.3 http.request.contenttype=text/plain http.request.host="127.0.0.1:33477" http.request.id=a19f416b-a698-44b4-814f-af1c1cbefbd3 http.request.method=POST http.request.remoteaddr="127.0.0.1:50984" http.request.uri=/v2/gun/_trust/tuf/root.key http.request.useragent=Go-http-client/1.1 +time="2024-06-06T15:03:39Z" level=info msg="response completed" go.version=go1.22.3 http.request.contenttype=text/plain http.request.host="127.0.0.1:33477" http.request.id=a19f416b-a698-44b4-814f-af1c1cbefbd3 http.request.method=POST http.request.remoteaddr="127.0.0.1:50984" http.request.uri=/v2/gun/_trust/tuf/root.key http.request.useragent=Go-http-client/1.1 http.response.contenttype="application/json; charset=utf-8" http.response.duration="200.651µs" http.response.status=404 http.response.written=104 +time="2024-06-06T15:03:39Z" level=info msg="metadata not found: You have requested metadata that does not exist.: " go.version=go1.22.3 http.request.contenttype=text/plain http.request.host="127.0.0.1:33477" http.request.id=2a2c54a4-3902-4c90-bdd5-8dd273b4cc24 http.request.method=POST http.request.remoteaddr="127.0.0.1:51000" http.request.uri=/v2/gun/_trust/tuf/targets/delegation.key http.request.useragent=Go-http-client/1.1 +time="2024-06-06T15:03:39Z" level=info msg="response completed" go.version=go1.22.3 http.request.contenttype=text/plain http.request.host="127.0.0.1:33477" http.request.id=2a2c54a4-3902-4c90-bdd5-8dd273b4cc24 http.request.method=POST http.request.remoteaddr="127.0.0.1:51000" http.request.uri=/v2/gun/_trust/tuf/targets/delegation.key http.request.useragent=Go-http-client/1.1 http.response.contenttype="application/json; charset=utf-8" http.response.duration="67.474µs" http.response.status=404 http.response.written=104 +time="2024-06-06T15:03:39Z" level=info msg="metadata not found: You have requested metadata that does not exist.: " go.version=go1.22.3 http.request.contenttype=text/plain http.request.host="127.0.0.1:33477" http.request.id=0cf1d398-a286-4ad6-ab2e-06a115b42d2a http.request.method=POST http.request.remoteaddr="127.0.0.1:51010" http.request.uri=/v2/gun/_trust/tuf/somerandomrole.key http.request.useragent=Go-http-client/1.1 +time="2024-06-06T15:03:39Z" level=info msg="response completed" go.version=go1.22.3 http.request.contenttype=text/plain http.request.host="127.0.0.1:33477" http.request.id=0cf1d398-a286-4ad6-ab2e-06a115b42d2a http.request.method=POST http.request.remoteaddr="127.0.0.1:51010" http.request.uri=/v2/gun/_trust/tuf/somerandomrole.key http.request.useragent=Go-http-client/1.1 http.response.contenttype="application/json; charset=utf-8" http.response.duration="60.726µs" http.response.status=404 http.response.written=104 +time="2024-06-06T15:03:39Z" level=info msg="response completed" go.version=go1.22.3 http.request.contenttype=text/plain http.request.host="127.0.0.1:33477" http.request.id=e54da644-c232-4954-b8b3-63a9eb7a2ef7 http.request.method=POST http.request.remoteaddr="127.0.0.1:51026" http.request.uri=/v2/gun/_trust/tuf/timestamp.key http.request.useragent=Go-http-client/1.1 http.response.duration="198.027µs" http.response.status=200 http.response.written=103 +time="2024-06-06T15:03:39Z" level=info msg="response completed" go.version=go1.22.3 http.request.contenttype=text/plain http.request.host="127.0.0.1:33477" http.request.id=063110d5-9f84-4a87-a967-eba3d654ab83 http.request.method=POST http.request.remoteaddr="127.0.0.1:51030" http.request.uri=/v2/gun/_trust/tuf/snapshot.key http.request.useragent=Go-http-client/1.1 http.response.duration="128.617µs" http.response.status=200 http.response.written=103 +time="2024-06-06T15:03:39Z" level=info msg="metadata not found: You have requested metadata that does not exist.: " go.version=go1.22.3 http.request.contenttype=text/plain http.request.host="127.0.0.1:33477" http.request.id=7904fdca-84e1-4e91-8108-b23c547dd759 http.request.method=POST http.request.remoteaddr="127.0.0.1:51040" http.request.uri=/v2/gun/_trust/tuf/targets.key http.request.useragent=Go-http-client/1.1 +time="2024-06-06T15:03:39Z" level=info msg="response completed" go.version=go1.22.3 http.request.contenttype=text/plain http.request.host="127.0.0.1:33477" http.request.id=7904fdca-84e1-4e91-8108-b23c547dd759 http.request.method=POST http.request.remoteaddr="127.0.0.1:51040" http.request.uri=/v2/gun/_trust/tuf/targets.key http.request.useragent=Go-http-client/1.1 http.response.contenttype="application/json; charset=utf-8" http.response.duration="197.812µs" http.response.status=404 http.response.written=104 +--- PASS: TestRotateKeyEndpoint (0.06s) PASS -ok github.com/theupdateframework/notary/server 0.095s +ok github.com/theupdateframework/notary/server 0.627s === RUN Test_changefeed --- PASS: Test_changefeed (0.00s) === RUN Test_checkChangefeedInputs -time="2025-07-09T21:20:00Z" level=error msg="500 GET unable to retrieve storage" -time="2025-07-09T21:20:00Z" level=error msg="400 GET invalid pageSize: not_a_number" +time="2024-06-06T15:03:38Z" level=error msg="500 GET unable to retrieve storage" +time="2024-06-06T15:03:38Z" level=error msg="400 GET invalid pageSize: not_a_number" --- PASS: Test_checkChangefeedInputs (0.00s) === RUN TestMainHandlerGet -time="2025-07-09T21:20:00Z" level=info msg="response completed" go.version=go1.22.3 http.request.host="127.0.0.1:38895" http.request.id=9572d6a7-61da-41ee-84f0-7919d2c93d80 http.request.method=GET http.request.remoteaddr="127.0.0.1:50714" http.request.uri=/ http.request.useragent=Go-http-client/1.1 http.response.duration="79.587µs" http.response.status=200 http.response.written=2 +time="2024-06-06T15:03:38Z" level=info msg="response completed" go.version=go1.22.3 http.request.host="127.0.0.1:33867" http.request.id=c0716e09-6ffc-4ff7-bc64-81f929b2c53e http.request.method=GET http.request.remoteaddr="127.0.0.1:59020" http.request.uri=/ http.request.useragent=Go-http-client/1.1 http.response.duration="56.306µs" http.response.status=200 http.response.written=2 --- PASS: TestMainHandlerGet (0.00s) === RUN TestMainHandlerNotGet -time="2025-07-09T21:20:00Z" level=info msg="generic not found: You have requested a resource that does not exist.: " go.version=go1.22.3 http.request.host="127.0.0.1:46371" http.request.id=f115240f-c6ca-47c0-aa80-dd39a8ecfccb http.request.method=HEAD http.request.remoteaddr="127.0.0.1:57358" http.request.uri=/ http.request.useragent=Go-http-client/1.1 -time="2025-07-09T21:20:00Z" level=info msg="response completed" go.version=go1.22.3 http.request.host="127.0.0.1:46371" http.request.id=f115240f-c6ca-47c0-aa80-dd39a8ecfccb http.request.method=HEAD http.request.remoteaddr="127.0.0.1:57358" http.request.uri=/ http.request.useragent=Go-http-client/1.1 http.response.contenttype="application/json; charset=utf-8" http.response.duration="367.907µs" http.response.status=404 http.response.written=105 ---- PASS: TestMainHandlerNotGet (0.00s) +time="2024-06-06T15:03:38Z" level=info msg="generic not found: You have requested a resource that does not exist.: " go.version=go1.22.3 http.request.host="127.0.0.1:46391" http.request.id=998b7930-dc18-4cfd-8055-45c7b04c7ae1 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:34232" http.request.uri=/ http.request.useragent=Go-http-client/1.1 +time="2024-06-06T15:03:38Z" level=info msg="response completed" go.version=go1.22.3 http.request.host="127.0.0.1:46391" http.request.id=998b7930-dc18-4cfd-8055-45c7b04c7ae1 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:34232" http.request.uri=/ http.request.useragent=Go-http-client/1.1 http.response.contenttype="application/json; charset=utf-8" http.response.duration="368.435µs" http.response.status=404 http.response.written=105 +--- PASS: TestMainHandlerNotGet (0.01s) === RUN TestKeyHandlersInvalidConfiguration -time="2025-07-09T21:20:00Z" level=error msg="500 GET storage not configured" go.version=go1.22.3 gun=gun -time="2025-07-09T21:20:00Z" level=error msg="500 GET storage not configured" go.version=go1.22.3 gun=gun -time="2025-07-09T21:20:00Z" level=error msg="500 GET crypto service not configured" go.version=go1.22.3 gun=gun -time="2025-07-09T21:20:00Z" level=error msg="500 GET crypto service not configured" go.version=go1.22.3 gun=gun -time="2025-07-09T21:20:00Z" level=error msg="500 GET key algorithm not configured" go.version=go1.22.3 gun=gun -time="2025-07-09T21:20:00Z" level=error msg="500 GET key algorithm not configured" go.version=go1.22.3 gun=gun -time="2025-07-09T21:20:00Z" level=error msg="500 POST storage not configured" go.version=go1.22.3 gun=gun -time="2025-07-09T21:20:00Z" level=error msg="500 POST storage not configured" go.version=go1.22.3 gun=gun -time="2025-07-09T21:20:00Z" level=error msg="500 POST crypto service not configured" go.version=go1.22.3 gun=gun -time="2025-07-09T21:20:00Z" level=error msg="500 POST crypto service not configured" go.version=go1.22.3 gun=gun -time="2025-07-09T21:20:00Z" level=error msg="500 POST key algorithm not configured" go.version=go1.22.3 gun=gun -time="2025-07-09T21:20:00Z" level=error msg="500 POST key algorithm not configured" go.version=go1.22.3 gun=gun +time="2024-06-06T15:03:38Z" level=error msg="500 GET storage not configured" go.version=go1.22.3 gun=gun +time="2024-06-06T15:03:38Z" level=error msg="500 GET storage not configured" go.version=go1.22.3 gun=gun +time="2024-06-06T15:03:38Z" level=error msg="500 GET crypto service not configured" go.version=go1.22.3 gun=gun +time="2024-06-06T15:03:38Z" level=error msg="500 GET crypto service not configured" go.version=go1.22.3 gun=gun +time="2024-06-06T15:03:38Z" level=error msg="500 GET key algorithm not configured" go.version=go1.22.3 gun=gun +time="2024-06-06T15:03:38Z" level=error msg="500 GET key algorithm not configured" go.version=go1.22.3 gun=gun +time="2024-06-06T15:03:38Z" level=error msg="500 POST storage not configured" go.version=go1.22.3 gun=gun +time="2024-06-06T15:03:38Z" level=error msg="500 POST storage not configured" go.version=go1.22.3 gun=gun +time="2024-06-06T15:03:38Z" level=error msg="500 POST crypto service not configured" go.version=go1.22.3 gun=gun +time="2024-06-06T15:03:38Z" level=error msg="500 POST crypto service not configured" go.version=go1.22.3 gun=gun +time="2024-06-06T15:03:38Z" level=error msg="500 POST key algorithm not configured" go.version=go1.22.3 gun=gun +time="2024-06-06T15:03:38Z" level=error msg="500 POST key algorithm not configured" go.version=go1.22.3 gun=gun --- PASS: TestKeyHandlersInvalidConfiguration (0.00s) === RUN TestKeyHandlersNoRoleOrRepo -time="2025-07-09T21:20:00Z" level=info msg="400 GET no gun in request" =gun go.version=go1.22.3 -time="2025-07-09T21:20:00Z" level=info msg="400 GET no gun in request" =gun go.version=go1.22.3 -time="2025-07-09T21:20:00Z" level=info msg="400 GET no role in request" go.version=go1.22.3 gun=gun -time="2025-07-09T21:20:00Z" level=info msg="400 GET no role in request" go.version=go1.22.3 gun=gun -time="2025-07-09T21:20:00Z" level=info msg="400 POST no gun in request" =gun go.version=go1.22.3 -time="2025-07-09T21:20:00Z" level=info msg="400 POST no gun in request" =gun go.version=go1.22.3 -time="2025-07-09T21:20:00Z" level=info msg="400 POST no role in request" go.version=go1.22.3 gun=gun -time="2025-07-09T21:20:00Z" level=info msg="400 POST no role in request" go.version=go1.22.3 gun=gun +time="2024-06-06T15:03:38Z" level=info msg="400 GET no gun in request" =gun go.version=go1.22.3 +time="2024-06-06T15:03:38Z" level=info msg="400 GET no gun in request" =gun go.version=go1.22.3 +time="2024-06-06T15:03:38Z" level=info msg="400 GET no role in request" go.version=go1.22.3 gun=gun +time="2024-06-06T15:03:38Z" level=info msg="400 GET no role in request" go.version=go1.22.3 gun=gun +time="2024-06-06T15:03:38Z" level=info msg="400 POST no gun in request" =gun go.version=go1.22.3 +time="2024-06-06T15:03:38Z" level=info msg="400 POST no gun in request" =gun go.version=go1.22.3 +time="2024-06-06T15:03:38Z" level=info msg="400 POST no role in request" go.version=go1.22.3 gun=gun +time="2024-06-06T15:03:38Z" level=info msg="400 POST no role in request" go.version=go1.22.3 gun=gun --- PASS: TestKeyHandlersNoRoleOrRepo (0.00s) === RUN TestKeyHandlersInvalidRole -time="2025-07-09T21:20:00Z" level=info msg="400 GET root key: " go.version=go1.22.3 gun=gun -time="2025-07-09T21:20:00Z" level=info msg="400 GET targets key: " go.version=go1.22.3 gun=gun -time="2025-07-09T21:20:00Z" level=info msg="400 GET targets/a key: " go.version=go1.22.3 gun=gun -time="2025-07-09T21:20:00Z" level=info msg="400 GET invalidrole key: " go.version=go1.22.3 gun=gun -time="2025-07-09T21:20:00Z" level=info msg="400 POST root key: " go.version=go1.22.3 gun=gun -time="2025-07-09T21:20:00Z" level=info msg="400 POST targets key: " go.version=go1.22.3 gun=gun -time="2025-07-09T21:20:00Z" level=info msg="400 POST targets/a key: " go.version=go1.22.3 gun=gun -time="2025-07-09T21:20:00Z" level=info msg="400 POST invalidrole key: " go.version=go1.22.3 gun=gun +time="2024-06-06T15:03:38Z" level=info msg="400 GET root key: " go.version=go1.22.3 gun=gun +time="2024-06-06T15:03:38Z" level=info msg="400 GET targets key: " go.version=go1.22.3 gun=gun +time="2024-06-06T15:03:38Z" level=info msg="400 GET targets/a key: " go.version=go1.22.3 gun=gun +time="2024-06-06T15:03:38Z" level=info msg="400 GET invalidrole key: " go.version=go1.22.3 gun=gun +time="2024-06-06T15:03:38Z" level=info msg="400 POST root key: " go.version=go1.22.3 gun=gun +time="2024-06-06T15:03:38Z" level=info msg="400 POST targets key: " go.version=go1.22.3 gun=gun +time="2024-06-06T15:03:38Z" level=info msg="400 POST targets/a key: " go.version=go1.22.3 gun=gun +time="2024-06-06T15:03:38Z" level=info msg="400 POST invalidrole key: " go.version=go1.22.3 gun=gun --- PASS: TestKeyHandlersInvalidRole (0.00s) === RUN TestGetKeyHandlerCreatesOnce ---- PASS: TestGetKeyHandlerCreatesOnce (0.00s) +--- PASS: TestGetKeyHandlerCreatesOnce (0.01s) === RUN TestKeyHandlersInvalidKeyAlgo -time="2025-07-09T21:20:00Z" level=error msg="500 GET timestamp key: only ED25519 supported by this cryptoservice" go.version=go1.22.3 gun=gun -time="2025-07-09T21:20:00Z" level=error msg="500 GET snapshot key: only ED25519 supported by this cryptoservice" go.version=go1.22.3 gun=gun -time="2025-07-09T21:20:00Z" level=error msg="500 POST timestamp key: only ED25519 supported by this cryptoservice" go.version=go1.22.3 gun=gun -time="2025-07-09T21:20:00Z" level=error msg="500 POST snapshot key: only ED25519 supported by this cryptoservice" go.version=go1.22.3 gun=gun +time="2024-06-06T15:03:38Z" level=error msg="500 GET timestamp key: only ED25519 supported by this cryptoservice" go.version=go1.22.3 gun=gun +time="2024-06-06T15:03:38Z" level=error msg="500 GET snapshot key: only ED25519 supported by this cryptoservice" go.version=go1.22.3 gun=gun +time="2024-06-06T15:03:38Z" level=error msg="500 POST timestamp key: only ED25519 supported by this cryptoservice" go.version=go1.22.3 gun=gun +time="2024-06-06T15:03:38Z" level=error msg="500 POST snapshot key: only ED25519 supported by this cryptoservice" go.version=go1.22.3 gun=gun --- PASS: TestKeyHandlersInvalidKeyAlgo (0.00s) === RUN TestRotateKeyHandlerSuccessfulRotation --- PASS: TestRotateKeyHandlerSuccessfulRotation (0.00s) === RUN TestGetHandlerRoot -time="2025-07-09T21:20:00Z" level=info msg="404 GET root role" go.version=go1.22.3 gun=gun ---- PASS: TestGetHandlerRoot (0.00s) +time="2024-06-06T15:03:38Z" level=info msg="404 GET root role" go.version=go1.22.3 gun=gun +--- PASS: TestGetHandlerRoot (0.01s) === RUN TestGetHandlerTimestamp ---- PASS: TestGetHandlerTimestamp (0.00s) +--- PASS: TestGetHandlerTimestamp (0.01s) === RUN TestGetHandlerSnapshot ---- PASS: TestGetHandlerSnapshot (0.00s) +--- PASS: TestGetHandlerSnapshot (0.01s) === RUN TestGetHandler404 -time="2025-07-09T21:20:00Z" level=info msg="404 GET root role" go.version=go1.22.3 gun=gun +time="2024-06-06T15:03:38Z" level=info msg="404 GET root role" go.version=go1.22.3 gun=gun --- PASS: TestGetHandler404 (0.00s) === RUN TestGetHandlerNilData -time="2025-07-09T21:20:00Z" level=info msg="404 GET root role" go.version=go1.22.3 gun=gun +time="2024-06-06T15:03:38Z" level=info msg="404 GET root role" go.version=go1.22.3 gun=gun --- PASS: TestGetHandlerNilData (0.00s) === RUN TestGetHandlerNoStorage -time="2025-07-09T21:20:00Z" level=error msg="500 GET: no storage exists" =gun go.version=go1.22.3 +time="2024-06-06T15:03:38Z" level=error msg="500 GET: no storage exists" =gun go.version=go1.22.3 --- PASS: TestGetHandlerNoStorage (0.00s) === RUN TestAtomicUpdateValidationFailurePropagated ---- PASS: TestAtomicUpdateValidationFailurePropagated (0.01s) +--- PASS: TestAtomicUpdateValidationFailurePropagated (0.02s) === RUN TestAtomicUpdateNonValidationFailureNotPropagated -time="2025-07-09T21:20:00Z" level=info msg="400 POST error validating update" go.version=go1.22.3 testGUN=gun ---- PASS: TestAtomicUpdateNonValidationFailureNotPropagated (0.00s) +time="2024-06-06T15:03:38Z" level=info msg="400 POST error validating update" go.version=go1.22.3 testGUN=gun +--- PASS: TestAtomicUpdateNonValidationFailureNotPropagated (0.02s) === RUN TestAtomicUpdateVersionErrorPropagated -time="2025-07-09T21:20:00Z" level=info msg="400 POST old version error" go.version=go1.22.3 testGUN=gun ---- PASS: TestAtomicUpdateVersionErrorPropagated (0.01s) +time="2024-06-06T15:03:38Z" level=info msg="400 POST old version error" go.version=go1.22.3 testGUN=gun +--- PASS: TestAtomicUpdateVersionErrorPropagated (0.05s) === RUN TestGetMaybeServerSignedNoCrypto --- PASS: TestGetMaybeServerSignedNoCrypto (0.00s) === RUN TestGetMaybeServerSignedNoKey --- PASS: TestGetMaybeServerSignedNoKey (0.00s) === RUN TestValidateEmptyNew ---- PASS: TestValidateEmptyNew (0.01s) +--- PASS: TestValidateEmptyNew (0.03s) === RUN TestValidateRootCanContainOnlyx509KeysWithRightGun ---- PASS: TestValidateRootCanContainOnlyx509KeysWithRightGun (0.01s) +--- PASS: TestValidateRootCanContainOnlyx509KeysWithRightGun (0.03s) === RUN TestValidatePrevTimestamp ---- PASS: TestValidatePrevTimestamp (0.01s) +--- PASS: TestValidatePrevTimestamp (0.03s) === RUN TestValidatePreviousTimestampCorrupt -time="2025-07-09T21:20:00Z" level=error msg="Failed to unmarshal existing timestamp for GUN docker.com/notary" ---- PASS: TestValidatePreviousTimestampCorrupt (0.00s) +time="2024-06-06T15:03:38Z" level=error msg="Failed to unmarshal existing timestamp for GUN docker.com/notary" +--- PASS: TestValidatePreviousTimestampCorrupt (0.02s) === RUN TestValidateGetCurrentTimestampBroken ---- PASS: TestValidateGetCurrentTimestampBroken (0.01s) +--- PASS: TestValidateGetCurrentTimestampBroken (0.02s) === RUN TestValidateNoNewRoot ---- PASS: TestValidateNoNewRoot (0.01s) +--- PASS: TestValidateNoNewRoot (0.02s) === RUN TestValidateNoNewTargets ---- PASS: TestValidateNoNewTargets (0.01s) +--- PASS: TestValidateNoNewTargets (0.04s) === RUN TestValidateOnlySnapshot ---- PASS: TestValidateOnlySnapshot (0.00s) +--- PASS: TestValidateOnlySnapshot (0.03s) === RUN TestValidateOldRoot ---- PASS: TestValidateOldRoot (0.01s) +--- PASS: TestValidateOldRoot (0.05s) === RUN TestValidateOldRootCorrupt ---- PASS: TestValidateOldRootCorrupt (0.00s) +--- PASS: TestValidateOldRootCorrupt (0.02s) === RUN TestValidateOldRootCorruptRootRole ---- PASS: TestValidateOldRootCorruptRootRole (0.01s) +--- PASS: TestValidateOldRootCorruptRootRole (0.03s) === RUN TestValidateRootGetCurrentRootBroken ---- PASS: TestValidateRootGetCurrentRootBroken (0.01s) +--- PASS: TestValidateRootGetCurrentRootBroken (0.02s) === RUN TestValidateRootRotationWithOldSigs ---- PASS: TestValidateRootRotationWithOldSigs (0.01s) +--- PASS: TestValidateRootRotationWithOldSigs (0.12s) === RUN TestValidateRootRotationMultipleKeysThreshold1 ---- PASS: TestValidateRootRotationMultipleKeysThreshold1 (0.01s) +--- PASS: TestValidateRootRotationMultipleKeysThreshold1 (0.09s) === RUN TestRootRotationNotSignedWithOldKeysForOldRole ---- PASS: TestRootRotationNotSignedWithOldKeysForOldRole (0.01s) +--- PASS: TestRootRotationNotSignedWithOldKeysForOldRole (0.14s) === RUN TestRootRotationVersionIncrement ---- PASS: TestRootRotationVersionIncrement (0.01s) +--- PASS: TestRootRotationVersionIncrement (0.04s) === RUN TestValidateNoRoot ---- PASS: TestValidateNoRoot (0.00s) +--- PASS: TestValidateNoRoot (0.02s) === RUN TestValidateSnapshotMissingNoSnapshotKey ---- PASS: TestValidateSnapshotMissingNoSnapshotKey (0.01s) +--- PASS: TestValidateSnapshotMissingNoSnapshotKey (0.02s) === RUN TestValidateSnapshotGenerateNoPrev ---- PASS: TestValidateSnapshotGenerateNoPrev (0.01s) +--- PASS: TestValidateSnapshotGenerateNoPrev (0.03s) === RUN TestValidateSnapshotGenerateWithPrev ---- PASS: TestValidateSnapshotGenerateWithPrev (0.01s) +--- PASS: TestValidateSnapshotGenerateWithPrev (0.04s) === RUN TestValidateSnapshotGeneratePrevCorrupt -time="2025-07-09T21:20:00Z" level=error msg="Failed to unmarshal existing snapshot for GUN docker.com/notary" ---- PASS: TestValidateSnapshotGeneratePrevCorrupt (0.01s) +time="2024-06-06T15:03:39Z" level=error msg="Failed to unmarshal existing snapshot for GUN docker.com/notary" +--- PASS: TestValidateSnapshotGeneratePrevCorrupt (0.04s) === RUN TestValidateSnapshotGenerateStoreGetCurrentSnapshotBroken ---- PASS: TestValidateSnapshotGenerateStoreGetCurrentSnapshotBroken (0.01s) +--- PASS: TestValidateSnapshotGenerateStoreGetCurrentSnapshotBroken (0.04s) === RUN TestValidateSnapshotGenerateNoTargets ---- PASS: TestValidateSnapshotGenerateNoTargets (0.01s) +--- PASS: TestValidateSnapshotGenerateNoTargets (0.05s) === RUN TestValidateSnapshotGenerate ---- PASS: TestValidateSnapshotGenerate (0.01s) +--- PASS: TestValidateSnapshotGenerate (0.05s) === RUN TestValidateRootNoTimestampKey ---- PASS: TestValidateRootNoTimestampKey (0.00s) +--- PASS: TestValidateRootNoTimestampKey (0.02s) === RUN TestValidateRootInvalidTimestampKey ---- PASS: TestValidateRootInvalidTimestampKey (0.00s) +--- PASS: TestValidateRootInvalidTimestampKey (0.02s) === RUN TestValidateRootInvalidTimestampThreshold ---- PASS: TestValidateRootInvalidTimestampThreshold (0.01s) +--- PASS: TestValidateRootInvalidTimestampThreshold (0.03s) === RUN TestValidateRootInvalidZeroThreshold ---- PASS: TestValidateRootInvalidZeroThreshold (0.02s) +--- PASS: TestValidateRootInvalidZeroThreshold (0.09s) === RUN TestValidateRootRoleMissing ---- PASS: TestValidateRootRoleMissing (0.00s) +--- PASS: TestValidateRootRoleMissing (0.02s) === RUN TestValidateTargetsRoleMissing ---- PASS: TestValidateTargetsRoleMissing (0.00s) +--- PASS: TestValidateTargetsRoleMissing (0.02s) === RUN TestValidateSnapshotRoleMissing ---- PASS: TestValidateSnapshotRoleMissing (0.00s) +--- PASS: TestValidateSnapshotRoleMissing (0.02s) === RUN TestValidateRootSigMissing ---- PASS: TestValidateRootSigMissing (0.00s) +--- PASS: TestValidateRootSigMissing (0.02s) === RUN TestValidateTargetsSigMissing -time="2025-07-09T21:20:00Z" level=error msg="ErrBadTargets: tuf: data has no signatures" ---- PASS: TestValidateTargetsSigMissing (0.00s) +time="2024-06-06T15:03:40Z" level=error msg="ErrBadTargets: tuf: data has no signatures" +--- PASS: TestValidateTargetsSigMissing (0.02s) === RUN TestValidateSnapshotSigMissing ---- PASS: TestValidateSnapshotSigMissing (0.00s) +--- PASS: TestValidateSnapshotSigMissing (0.02s) === RUN TestValidateRootCorrupt ---- PASS: TestValidateRootCorrupt (0.00s) +--- PASS: TestValidateRootCorrupt (0.02s) === RUN TestValidateTargetsCorrupt -time="2025-07-09T21:20:00Z" level=error msg="ErrBadTargets: invalid character '\\u0084' looking for beginning of value" ---- PASS: TestValidateTargetsCorrupt (0.00s) +time="2024-06-06T15:03:40Z" level=error msg="ErrBadTargets: invalid character '\\u0084' looking for beginning of value" +--- PASS: TestValidateTargetsCorrupt (0.03s) === RUN TestValidateSnapshotCorrupt ---- PASS: TestValidateSnapshotCorrupt (0.00s) +--- PASS: TestValidateSnapshotCorrupt (0.03s) === RUN TestValidateRootModifiedSize ---- PASS: TestValidateRootModifiedSize (0.00s) +--- PASS: TestValidateRootModifiedSize (0.02s) === RUN TestValidateTargetsModifiedSize ---- PASS: TestValidateTargetsModifiedSize (0.00s) +--- PASS: TestValidateTargetsModifiedSize (0.02s) === RUN TestValidateRootModifiedHash ---- PASS: TestValidateRootModifiedHash (0.01s) +--- PASS: TestValidateRootModifiedHash (0.03s) === RUN TestValidateTargetsModifiedHash ---- PASS: TestValidateTargetsModifiedHash (0.00s) +--- PASS: TestValidateTargetsModifiedHash (0.02s) === RUN TestGenerateSnapshotRootNotLoaded --- PASS: TestGenerateSnapshotRootNotLoaded (0.00s) === RUN TestGenerateSnapshotNoKey ---- PASS: TestGenerateSnapshotNoKey (0.00s) +--- PASS: TestGenerateSnapshotNoKey (0.02s) === RUN TestLoadTargetsLoadsNothingIfNoUpdates ---- PASS: TestLoadTargetsLoadsNothingIfNoUpdates (0.00s) +--- PASS: TestLoadTargetsLoadsNothingIfNoUpdates (0.01s) === RUN TestValidateTargetsRequiresStoredParent -time="2025-07-09T21:20:00Z" level=error msg="ErrBadTargets: targets must be loaded first" ---- PASS: TestValidateTargetsRequiresStoredParent (0.00s) +time="2024-06-06T15:03:40Z" level=error msg="ErrBadTargets: targets must be loaded first" +--- PASS: TestValidateTargetsRequiresStoredParent (0.02s) === RUN TestValidateTargetsParentInUpdate -time="2025-07-09T21:20:00Z" level=error msg="ErrBadTargets: invalid character 'I' looking for beginning of value" ---- PASS: TestValidateTargetsParentInUpdate (0.00s) +time="2024-06-06T15:03:40Z" level=error msg="ErrBadTargets: invalid character 'I' looking for beginning of value" +--- PASS: TestValidateTargetsParentInUpdate (0.02s) === RUN TestValidateTargetsRoleNotInParent -time="2025-07-09T21:20:00Z" level=error msg="ErrBadTargets: tuf: invalid role targets/level1. delegation does not exist" -time="2025-07-09T21:20:00Z" level=error msg="ErrBadTargets: targets has already been loaded" -time="2025-07-09T21:20:00Z" level=error msg="ErrBadTargets: tuf: invalid role targets/level1. delegation does not exist" ---- PASS: TestValidateTargetsRoleNotInParent (0.00s) +time="2024-06-06T15:03:40Z" level=error msg="ErrBadTargets: tuf: invalid role targets/level1. delegation does not exist" +time="2024-06-06T15:03:40Z" level=error msg="ErrBadTargets: targets has already been loaded" +time="2024-06-06T15:03:40Z" level=error msg="ErrBadTargets: tuf: invalid role targets/level1. delegation does not exist" +--- PASS: TestValidateTargetsRoleNotInParent (0.02s) PASS -ok github.com/theupdateframework/notary/server/handlers 0.319s +ok github.com/theupdateframework/notary/server/handlers 1.775s === RUN TestSnapshotExpired --- PASS: TestSnapshotExpired (0.00s) === RUN TestSnapshotNotExpired --- PASS: TestSnapshotNotExpired (0.00s) === RUN TestGetSnapshotKeyCreate ---- PASS: TestGetSnapshotKeyCreate (0.00s) +--- PASS: TestGetSnapshotKeyCreate (0.01s) === RUN TestGetSnapshotKeyCreateWithFailingStore -time="2025-07-09T21:20:00Z" level=error msg="Error when retrieving root role for GUN gun: failing store failed" +time="2024-06-06T15:03:38Z" level=error msg="Error when retrieving root role for GUN gun: failing store failed" --- PASS: TestGetSnapshotKeyCreateWithFailingStore (0.00s) === RUN TestGetSnapshotKeyCreateWithCorruptedStore -time="2025-07-09T21:20:00Z" level=error msg="Failed to unmarshal existing root for GUN gun to retrieve snapshot key ID" +time="2024-06-06T15:03:38Z" level=error msg="Failed to unmarshal existing root for GUN gun to retrieve snapshot key ID" --- PASS: TestGetSnapshotKeyCreateWithCorruptedStore (0.00s) === RUN TestGetSnapshotKeyCreateWithInvalidAlgo --- PASS: TestGetSnapshotKeyCreateWithInvalidAlgo (0.00s) === RUN TestGetSnapshotKeyExistingMetadata ---- PASS: TestGetSnapshotKeyExistingMetadata (0.00s) +--- PASS: TestGetSnapshotKeyExistingMetadata (0.01s) === RUN TestGetSnapshotNoPreviousSnapshot -time="2025-07-09T21:20:00Z" level=error msg="Failed to unmarshal existing snapshot for GUN gun" ---- PASS: TestGetSnapshotNoPreviousSnapshot (0.00s) +time="2024-06-06T15:03:38Z" level=error msg="Failed to unmarshal existing snapshot for GUN gun" +--- PASS: TestGetSnapshotNoPreviousSnapshot (0.01s) === RUN TestGetSnapshotReturnsPreviousSnapshotIfUnexpired ---- PASS: TestGetSnapshotReturnsPreviousSnapshotIfUnexpired (0.00s) +--- PASS: TestGetSnapshotReturnsPreviousSnapshotIfUnexpired (0.01s) === RUN TestGetSnapshotOldSnapshotExpired ---- PASS: TestGetSnapshotOldSnapshotExpired (0.00s) +--- PASS: TestGetSnapshotOldSnapshotExpired (0.02s) === RUN TestCannotMakeNewSnapshotIfNoRoot --- PASS: TestCannotMakeNewSnapshotIfNoRoot (0.00s) === RUN TestCreateSnapshotNoKeyInCrypto ---- PASS: TestCreateSnapshotNoKeyInCrypto (0.00s) +--- PASS: TestCreateSnapshotNoKeyInCrypto (0.02s) PASS -ok github.com/theupdateframework/notary/server/snapshot 0.033s +ok github.com/theupdateframework/notary/server/snapshot 0.178s === RUN TestMemoryUpdateCurrentEmpty --- PASS: TestMemoryUpdateCurrentEmpty (0.00s) === RUN TestMemoryUpdateCurrentVersionCheckOldVersionExists @@ -2950,67 +2986,67 @@ === RUN TestRDBTUFFileJSONUnmarshallingFailure --- PASS: TestRDBTUFFileJSONUnmarshallingFailure (0.00s) === RUN TestSQLUpdateCurrentEmpty ---- PASS: TestSQLUpdateCurrentEmpty (0.12s) +--- PASS: TestSQLUpdateCurrentEmpty (0.29s) === RUN TestSQLUpdateCurrentVersionCheckOldVersionExists ---- PASS: TestSQLUpdateCurrentVersionCheckOldVersionExists (0.04s) +--- PASS: TestSQLUpdateCurrentVersionCheckOldVersionExists (0.19s) === RUN TestSQLUpdateCurrentVersionCheckOldVersionNotExist ---- PASS: TestSQLUpdateCurrentVersionCheckOldVersionNotExist (0.04s) +--- PASS: TestSQLUpdateCurrentVersionCheckOldVersionNotExist (0.19s) === RUN TestSQLUpdateManyNoConflicts ---- PASS: TestSQLUpdateManyNoConflicts (0.06s) +--- PASS: TestSQLUpdateManyNoConflicts (0.18s) === RUN TestSQLUpdateManyConflictRollback ---- PASS: TestSQLUpdateManyConflictRollback (0.03s) +--- PASS: TestSQLUpdateManyConflictRollback (0.24s) === RUN TestSQLDelete ---- PASS: TestSQLDelete (0.05s) +--- PASS: TestSQLDelete (0.25s) === RUN TestSQLDBCheckHealthTableMissing ---- PASS: TestSQLDBCheckHealthTableMissing (0.03s) +--- PASS: TestSQLDBCheckHealthTableMissing (0.13s) === RUN TestSQLDBCheckHealthDBConnectionFail ---- PASS: TestSQLDBCheckHealthDBConnectionFail (0.02s) +--- PASS: TestSQLDBCheckHealthDBConnectionFail (0.09s) === RUN TestSQLDBCheckHealthSucceeds ---- PASS: TestSQLDBCheckHealthSucceeds (0.03s) +--- PASS: TestSQLDBCheckHealthSucceeds (0.11s) === RUN TestSQLDBGetChecksum ---- PASS: TestSQLDBGetChecksum (0.03s) +--- PASS: TestSQLDBGetChecksum (0.14s) === RUN TestSQLDBGetChecksumNotFound ---- PASS: TestSQLDBGetChecksumNotFound (0.02s) +--- PASS: TestSQLDBGetChecksumNotFound (0.12s) === RUN TestSQLTUFMetaStoreGetCurrent ---- PASS: TestSQLTUFMetaStoreGetCurrent (0.06s) +--- PASS: TestSQLTUFMetaStoreGetCurrent (0.31s) === RUN TestSQLGetChanges ---- PASS: TestSQLGetChanges (0.06s) +--- PASS: TestSQLGetChanges (0.75s) === RUN TestSQLDBGetVersion ---- PASS: TestSQLDBGetVersion (0.02s) +--- PASS: TestSQLDBGetVersion (0.13s) PASS -ok github.com/theupdateframework/notary/server/storage 0.636s +ok github.com/theupdateframework/notary/server/storage 3.187s === RUN TestTimestampExpired --- PASS: TestTimestampExpired (0.00s) === RUN TestTimestampNotExpired --- PASS: TestTimestampNotExpired (0.00s) === RUN TestGetTimestampKey ---- PASS: TestGetTimestampKey (0.00s) +--- PASS: TestGetTimestampKey (0.02s) === RUN TestGetTimestampNoPreviousTimestamp -time="2025-07-09T21:20:00Z" level=error msg="Failed to unmarshal existing timestamp" ---- PASS: TestGetTimestampNoPreviousTimestamp (0.00s) +time="2024-06-06T15:03:38Z" level=error msg="Failed to unmarshal existing timestamp" +--- PASS: TestGetTimestampNoPreviousTimestamp (0.02s) === RUN TestGetTimestampReturnsPreviousTimestampIfUnexpired ---- PASS: TestGetTimestampReturnsPreviousTimestampIfUnexpired (0.00s) +--- PASS: TestGetTimestampReturnsPreviousTimestampIfUnexpired (0.01s) === RUN TestGetTimestampOldTimestampExpired ---- PASS: TestGetTimestampOldTimestampExpired (0.00s) +--- PASS: TestGetTimestampOldTimestampExpired (0.03s) === RUN TestCannotMakeNewTimestampIfNoRootOrSnapshot -time="2025-07-09T21:20:00Z" level=error msg="Failed to create a new timestamp" -time="2025-07-09T21:20:00Z" level=error msg="Failed to create a new timestamp" ---- PASS: TestCannotMakeNewTimestampIfNoRootOrSnapshot (0.00s) +time="2024-06-06T15:03:38Z" level=error msg="Failed to create a new timestamp" +time="2024-06-06T15:03:38Z" level=error msg="Failed to create a new timestamp" +--- PASS: TestCannotMakeNewTimestampIfNoRootOrSnapshot (0.01s) === RUN TestCreateTimestampNoKeyInCrypto -time="2025-07-09T21:20:00Z" level=error msg="Failed to create a new timestamp" ---- PASS: TestCreateTimestampNoKeyInCrypto (0.00s) +time="2024-06-06T15:03:38Z" level=error msg="Failed to create a new timestamp" +--- PASS: TestCreateTimestampNoKeyInCrypto (0.02s) === RUN TestGetTimestampKeyCreateWithFailingStore -time="2025-07-09T21:20:00Z" level=error msg="Error when retrieving root role for GUN gun: failing store failed" +time="2024-06-06T15:03:38Z" level=error msg="Error when retrieving root role for GUN gun: failing store failed" --- PASS: TestGetTimestampKeyCreateWithFailingStore (0.00s) === RUN TestGetTimestampKeyCreateWithCorruptedStore -time="2025-07-09T21:20:00Z" level=error msg="Failed to unmarshal existing root for GUN gun to retrieve timestamp key ID" +time="2024-06-06T15:03:38Z" level=error msg="Failed to unmarshal existing root for GUN gun to retrieve timestamp key ID" --- PASS: TestGetTimestampKeyCreateWithCorruptedStore (0.00s) === RUN TestGetTimestampKeyCreateWithInvalidAlgo --- PASS: TestGetTimestampKeyCreateWithInvalidAlgo (0.00s) === RUN TestGetTimestampKeyExistingMetadata --- PASS: TestGetTimestampKeyExistingMetadata (0.01s) PASS -ok github.com/theupdateframework/notary/server/timestamp 0.045s +ok github.com/theupdateframework/notary/server/timestamp 0.176s === RUN TestHealthCheckKMUnhealthy --- PASS: TestHealthCheckKMUnhealthy (0.01s) === RUN TestHealthCheckSignerUnhealthy @@ -3022,7 +3058,7 @@ === RUN TestHealthCheckKMHealthy --- PASS: TestHealthCheckKMHealthy (0.00s) === RUN TestHealthCheckSignerHealthy ---- PASS: TestHealthCheckSignerHealthy (0.00s) +--- PASS: TestHealthCheckSignerHealthy (0.04s) === RUN TestHealthCheckKMConnectionDied --- PASS: TestHealthCheckKMConnectionDied (0.00s) === RUN TestHealthCheckSignerConnectionDied @@ -3032,27 +3068,27 @@ === RUN TestHealthCheckNonexistentService --- PASS: TestHealthCheckNonexistentService (0.00s) === RUN TestGetPrivateKeyAndSignWithExistingKey -time="2025-07-09T21:20:00Z" level=info msg="Sign: Signed message! with KeyID 4cb933c88fd455888efa0556549ef9d32a435890ca72a7f804358fec71042e43" go.version=go1.22.3 ---- PASS: TestGetPrivateKeyAndSignWithExistingKey (0.00s) +time="2024-06-06T15:03:42Z" level=info msg="Sign: Signed message! with KeyID 7c69d741c9c1c4fcb1661675acc66ced6d4b920efd2e7c7347b5c36c84673ec3" go.version=go1.22.3 +--- PASS: TestGetPrivateKeyAndSignWithExistingKey (0.02s) === RUN TestCannotSignWithKeyThatDoesntExist -time="2025-07-09T21:20:00Z" level=error msg="Sign: key d0ff3568f179ddc963d4236e5da9801329b4f6dd5a458d499bc13611da19ae67 not found" go.version=go1.22.3 ---- PASS: TestCannotSignWithKeyThatDoesntExist (0.00s) +time="2024-06-06T15:03:42Z" level=error msg="Sign: key 4db2bf9436363b95b6c64818262baac245956b2b5f3e462028cb095b2cb69e90 not found" go.version=go1.22.3 +--- PASS: TestCannotSignWithKeyThatDoesntExist (0.02s) === RUN TestCryptoSignerInterfaceBehavior -time="2025-07-09T21:20:00Z" level=error msg="GetKeyInfo: key nonexistent not found" go.version=go1.22.3 -time="2025-07-09T21:20:00Z" level=error msg="GetKeyInfo: key nonexistent not found" go.version=go1.22.3 -time="2025-07-09T21:20:00Z" level=info msg="CreateKey: Created KeyID 0c88603a40fc26a8917a0a6359b088203eefe4ffa4052777850650eefd98c138" go.version=go1.22.3 -time="2025-07-09T21:20:00Z" level=info msg="CreateKey: Created KeyID c507a8b29b0c5b046cf9b4b184015716189b1ac4e219829bce9b10feef86ebf6" go.version=go1.22.3 -time="2025-07-09T21:20:00Z" level=error msg="GetKeyInfo: key 0c88603a40fc26a8917a0a6359b088203eefe4ffa4052777850650eefd98c138 not found" go.version=go1.22.3 -time="2025-07-09T21:20:00Z" level=error msg="GetKeyInfo: key c507a8b29b0c5b046cf9b4b184015716189b1ac4e219829bce9b10feef86ebf6 not found" go.version=go1.22.3 ---- PASS: TestCryptoSignerInterfaceBehavior (0.01s) +time="2024-06-06T15:03:42Z" level=error msg="GetKeyInfo: key nonexistent not found" go.version=go1.22.3 +time="2024-06-06T15:03:42Z" level=error msg="GetKeyInfo: key nonexistent not found" go.version=go1.22.3 +time="2024-06-06T15:03:42Z" level=info msg="CreateKey: Created KeyID 120d72cc8cf8a1fac747b9e9d959004e8ef91322e2a1674e43030e88063a3d7a" go.version=go1.22.3 +time="2024-06-06T15:03:42Z" level=info msg="CreateKey: Created KeyID 8c064bf574c177249416c9c3f7c26df847ae0431d64806bfaa0a60a45d37280f" go.version=go1.22.3 +time="2024-06-06T15:03:42Z" level=error msg="GetKeyInfo: key 120d72cc8cf8a1fac747b9e9d959004e8ef91322e2a1674e43030e88063a3d7a not found" go.version=go1.22.3 +time="2024-06-06T15:03:42Z" level=error msg="GetKeyInfo: key 8c064bf574c177249416c9c3f7c26df847ae0431d64806bfaa0a60a45d37280f not found" go.version=go1.22.3 +--- PASS: TestCryptoSignerInterfaceBehavior (0.13s) PASS -ok github.com/theupdateframework/notary/signer 0.054s +ok github.com/theupdateframework/notary/signer 0.293s === RUN TestGetSuccessPopulatesCache ---- PASS: TestGetSuccessPopulatesCache (0.00s) +--- PASS: TestGetSuccessPopulatesCache (0.01s) === RUN TestAddKeyPopulatesCacheIfSuccessful ---- PASS: TestAddKeyPopulatesCacheIfSuccessful (0.00s) +--- PASS: TestAddKeyPopulatesCacheIfSuccessful (0.01s) === RUN TestDeleteKeyRemovesKeyFromCache ---- PASS: TestDeleteKeyRemovesKeyFromCache (0.01s) +--- PASS: TestDeleteKeyRemovesKeyFromCache (0.02s) === RUN TestRDBPrivateKeyJSONUnmarshalling --- PASS: TestRDBPrivateKeyJSONUnmarshalling (0.00s) === RUN TestRDBPrivateKeyJSONUnmarshallingFailure @@ -3061,30 +3097,30 @@ `nodb` is not officially supported, running under compatibility mode. --- PASS: TestNewSQLKeyDBStorePropagatesDBError (0.00s) === RUN TestSQLDBHealthCheckMissingTable ---- PASS: TestSQLDBHealthCheckMissingTable (0.04s) +--- PASS: TestSQLDBHealthCheckMissingTable (0.13s) === RUN TestSQLDBHealthCheckNoConnection ---- PASS: TestSQLDBHealthCheckNoConnection (0.03s) +--- PASS: TestSQLDBHealthCheckNoConnection (0.09s) === RUN TestSQLKeyCanOnlyBeAddedOnce (/build/reproducible-path/notary-0.7.0+ds1/_build/src/github.com/theupdateframework/notary/signer/keydbstore/sql_keydbstore.go:98) -[2025-07-09 21:20:00]  UNIQUE constraint failed: private_keys.key_id  ---- PASS: TestSQLKeyCanOnlyBeAddedOnce (0.06s) +[2024-06-06 15:03:42]  UNIQUE constraint failed: private_keys.key_id  +--- PASS: TestSQLKeyCanOnlyBeAddedOnce (0.28s) === RUN TestSQLCreateDelete ---- PASS: TestSQLCreateDelete (0.07s) +--- PASS: TestSQLCreateDelete (0.26s) === RUN TestSQLKeyRotation ---- PASS: TestSQLKeyRotation (0.08s) +--- PASS: TestSQLKeyRotation (0.39s) === RUN TestSQLSigningMarksKeyActive -time="2025-07-09T21:20:00Z" level=error msg="Key 342b32793ae044bc6dd62f4543a5fe4315d771916c130a6ca1c946e1e03dde2a was just used to sign hash successful, db closed, error when trying to mark key as active: sql: database is closed" +time="2024-06-06T15:03:43Z" level=error msg="Key 893fa67674979e9e5bf149d1ae881b13044ae46f2a2b9bff7489cec61fc2f05f was just used to sign hash successful, db closed, error when trying to mark key as active: sql: database is closed" +--- PASS: TestSQLSigningMarksKeyActive (0.43s) +=== RUN TestSQLCreateKey (/build/reproducible-path/notary-0.7.0+ds1/_build/src/github.com/theupdateframework/notary/signer/keydbstore/sql_keydbstore.go:197) -[2025-07-09 21:20:00]  sql: database is closed  ---- PASS: TestSQLSigningMarksKeyActive (0.11s) -=== RUN TestSQLCreateKey ---- PASS: TestSQLCreateKey (0.09s) +[2024-06-06 15:03:43]  sql: database is closed  +--- PASS: TestSQLCreateKey (0.34s) === RUN TestSQLUnimplementedInterfaceBehavior ---- PASS: TestSQLUnimplementedInterfaceBehavior (0.04s) +--- PASS: TestSQLUnimplementedInterfaceBehavior (0.16s) PASS -ok github.com/theupdateframework/notary/signer/keydbstore 0.555s +ok github.com/theupdateframework/notary/signer/keydbstore 2.168s === RUN TestSet --- PASS: TestSet (0.00s) === RUN TestSetWithNoParentDirectory @@ -3100,7 +3136,7 @@ === RUN TestRemoveAll --- PASS: TestRemoveAll (0.00s) === RUN TestAddFile ---- PASS: TestAddFile (0.00s) +--- PASS: TestAddFile (0.01s) === RUN TestRemoveFile --- PASS: TestRemoveFile (0.00s) === RUN TestListFiles @@ -3110,7 +3146,7 @@ === RUN TestGetPathProtection --- PASS: TestGetPathProtection (0.00s) === RUN TestGetData ---- PASS: TestGetData (0.00s) +--- PASS: TestGetData (0.04s) === RUN TestCreateDirectory --- PASS: TestCreateDirectory (0.00s) === RUN TestCreatePrivateDirectory @@ -3118,15 +3154,15 @@ === RUN TestFileStoreConsistency --- PASS: TestFileStoreConsistency (0.00s) === RUN TestHTTPStoreGetSized ---- PASS: TestHTTPStoreGetSized (0.00s) +--- PASS: TestHTTPStoreGetSized (0.02s) === RUN TestHTTPStoreGetAllMeta --- PASS: TestHTTPStoreGetAllMeta (0.00s) === RUN TestSetSingleAndSetMultiMeta ---- PASS: TestSetSingleAndSetMultiMeta (0.00s) +--- PASS: TestSetSingleAndSetMultiMeta (0.01s) === RUN Test404Error --- PASS: Test404Error (0.00s) === RUN Test50XErrors ---- PASS: Test50XErrors (0.00s) +--- PASS: Test50XErrors (0.02s) === RUN Test400Error --- PASS: Test400Error (0.00s) === RUN TestTranslateErrorsParse400Errors @@ -3136,13 +3172,13 @@ === RUN TestTranslateErrorsLimitsErrorSize --- PASS: TestTranslateErrorsLimitsErrorSize (0.00s) === RUN TestHTTPStoreRemoveAll ---- PASS: TestHTTPStoreRemoveAll (0.00s) +--- PASS: TestHTTPStoreRemoveAll (0.01s) === RUN TestHTTPStoreRotateKey --- PASS: TestHTTPStoreRotateKey (0.00s) === RUN TestHTTPStoreGetKey --- PASS: TestHTTPStoreGetKey (0.00s) === RUN TestHTTPStoreGetRotateKeySizeLimited ---- PASS: TestHTTPStoreGetRotateKeySizeLimited (0.01s) +--- PASS: TestHTTPStoreGetRotateKeySizeLimited (0.16s) === RUN TestHTTPOffline --- PASS: TestHTTPOffline (0.00s) === RUN TestErrServerUnavailable @@ -3163,7 +3199,7 @@ === RUN TestMemoryStoreMetadata --- PASS: TestMemoryStoreMetadata (0.00s) PASS -ok github.com/theupdateframework/notary/storage 0.047s +ok github.com/theupdateframework/notary/storage 0.340s === RUN TestExportKeys --- PASS: TestExportKeys (0.00s) === RUN TestExportKeysByGUN @@ -3175,127 +3211,127 @@ === RUN TestImportKeys --- PASS: TestImportKeys (0.00s) === RUN TestImportNoPath ---- PASS: TestImportNoPath (0.00s) +--- PASS: TestImportNoPath (0.01s) === RUN TestNonRootPathInference ---- PASS: TestNonRootPathInference (0.00s) +--- PASS: TestNonRootPathInference (0.02s) === RUN TestBlockHeaderPrecedenceRoleAndGun ---- PASS: TestBlockHeaderPrecedenceRoleAndGun (0.00s) +--- PASS: TestBlockHeaderPrecedenceRoleAndGun (0.02s) === RUN TestBlockHeaderPrecedenceGunFromPath ---- PASS: TestBlockHeaderPrecedenceGunFromPath (0.00s) +--- PASS: TestBlockHeaderPrecedenceGunFromPath (0.01s) === RUN TestImportKeys2InOneFile --- PASS: TestImportKeys2InOneFile (0.00s) === RUN TestImportKeys2InOneFileNoPath ---- PASS: TestImportKeys2InOneFileNoPath (0.00s) +--- PASS: TestImportKeys2InOneFileNoPath (0.03s) === RUN TestEncryptedKeyImportFail -time="2025-07-09T21:20:00Z" level=warning msg="failed to import key to store: Invalid key generated, key may be encrypted and does not contain path header" ---- PASS: TestEncryptedKeyImportFail (0.00s) +time="2024-06-06T15:03:42Z" level=warning msg="failed to import key to store: Invalid key generated, key may be encrypted and does not contain path header" +--- PASS: TestEncryptedKeyImportFail (0.01s) === RUN TestEncryptedKeyImportSuccess ---- PASS: TestEncryptedKeyImportSuccess (0.00s) +--- PASS: TestEncryptedKeyImportSuccess (0.02s) === RUN TestEncryption ---- PASS: TestEncryption (0.00s) +--- PASS: TestEncryption (0.02s) === RUN TestAddKey ---- PASS: TestAddKey (0.01s) +--- PASS: TestAddKey (0.07s) === RUN TestKeyStoreInternalState --- PASS: TestKeyStoreInternalState (0.01s) === RUN TestGet ---- PASS: TestGet (0.01s) +--- PASS: TestGet (0.06s) === RUN TestGetLegacyKey --- PASS: TestGetLegacyKey (0.00s) === RUN TestListKeys ---- PASS: TestListKeys (0.01s) +--- PASS: TestListKeys (0.06s) === RUN TestAddGetKeyMemStore ---- PASS: TestAddGetKeyMemStore (0.00s) +--- PASS: TestAddGetKeyMemStore (0.01s) === RUN TestAddGetKeyInfoMemStore ---- PASS: TestAddGetKeyInfoMemStore (0.01s) +--- PASS: TestAddGetKeyInfoMemStore (0.04s) === RUN TestGetDecryptedWithTamperedCipherText -time="2025-07-09T21:20:00Z" level=error msg="PEM block is empty" ---- PASS: TestGetDecryptedWithTamperedCipherText (0.00s) +time="2024-06-06T15:03:42Z" level=error msg="PEM block is empty" +--- PASS: TestGetDecryptedWithTamperedCipherText (0.01s) === RUN TestGetDecryptedWithInvalidPassphrase ---- PASS: TestGetDecryptedWithInvalidPassphrase (0.01s) +--- PASS: TestGetDecryptedWithInvalidPassphrase (0.06s) === RUN TestGetDecryptedWithConsistentlyInvalidPassphrase ---- PASS: TestGetDecryptedWithConsistentlyInvalidPassphrase (0.02s) +--- PASS: TestGetDecryptedWithConsistentlyInvalidPassphrase (0.11s) === RUN TestRemoveKey ---- PASS: TestRemoveKey (0.01s) +--- PASS: TestRemoveKey (0.06s) === RUN TestKeysAreCached ---- PASS: TestKeysAreCached (0.00s) +--- PASS: TestKeysAreCached (0.02s) PASS -ok github.com/theupdateframework/notary/trustmanager 0.157s +ok github.com/theupdateframework/notary/trustmanager 0.708s === RUN TestRemoteStore -time="2025-07-09T21:20:00Z" level=info msg="listing files from localhost:9888" -time="2025-07-09T21:20:00Z" level=info msg="listing files from localhost:9888" ---- PASS: TestRemoteStore (0.03s) +time="2024-06-06T15:03:43Z" level=info msg="listing files from localhost:9888" +time="2024-06-06T15:03:43Z" level=info msg="listing files from localhost:9888" +--- PASS: TestRemoteStore (0.06s) === RUN TestErrors -time="2025-07-09T21:20:00Z" level=error msg="failed to store: test error" ---- PASS: TestErrors (0.03s) +time="2024-06-06T15:03:43Z" level=error msg="failed to store: test error" +--- PASS: TestErrors (0.10s) === RUN TestNewGRPCStorage --- PASS: TestNewGRPCStorage (0.00s) === RUN TestGRPCStorage --- PASS: TestGRPCStorage (0.00s) PASS -ok github.com/theupdateframework/notary/trustmanager/remoteks 0.077s +ok github.com/theupdateframework/notary/trustmanager/remoteks 0.210s === RUN TestWildcardMatch --- PASS: TestWildcardMatch (0.00s) === RUN TestValidateRoot -2025/07/09 21:20:00 [INFO] generate received request -2025/07/09 21:20:00 [INFO] received CSR -2025/07/09 21:20:00 [INFO] generating key: ecdsa-256 -2025/07/09 21:20:00 [INFO] encoded CSR -2025/07/09 21:20:00 [INFO] signed certificate with serial number 587342103522035424853798118426557875664710295638 -2025/07/09 21:20:00 [INFO] received CSR -2025/07/09 21:20:00 [INFO] generating key: ecdsa-256 -2025/07/09 21:20:00 [INFO] encoded CSR -2025/07/09 21:20:00 [INFO] signed certificate with serial number 614481508142060548875133973819971241779924020879 -2025/07/09 21:20:00 [INFO] received CSR -2025/07/09 21:20:00 [INFO] generating key: ecdsa-256 -2025/07/09 21:20:00 [INFO] encoded CSR -2025/07/09 21:20:00 [INFO] signed certificate with serial number 332425152176736488188482835637031176404859693678 ---- PASS: TestValidateRoot (0.02s) +2024/06/06 15:03:43 [INFO] generate received request +2024/06/06 15:03:43 [INFO] received CSR +2024/06/06 15:03:43 [INFO] generating key: ecdsa-256 +2024/06/06 15:03:43 [INFO] encoded CSR +2024/06/06 15:03:43 [INFO] signed certificate with serial number 641243849007204083161382601017884127715705894565 +2024/06/06 15:03:43 [INFO] received CSR +2024/06/06 15:03:43 [INFO] generating key: ecdsa-256 +2024/06/06 15:03:43 [INFO] encoded CSR +2024/06/06 15:03:43 [INFO] signed certificate with serial number 648822257710791273372167962560631623536084971197 +2024/06/06 15:03:43 [INFO] received CSR +2024/06/06 15:03:43 [INFO] generating key: ecdsa-256 +2024/06/06 15:03:43 [INFO] encoded CSR +2024/06/06 15:03:43 [INFO] signed certificate with serial number 382139805913508475202140219448351255065508849748 +--- PASS: TestValidateRoot (0.03s) === RUN TestValidateRootWithoutTOFUS --- PASS: TestValidateRootWithoutTOFUS (0.00s) === RUN TestValidateRootWithPinnedCert --- PASS: TestValidateRootWithPinnedCert (0.00s) === RUN TestValidateRootWithPinnedCertAndIntermediates ---- PASS: TestValidateRootWithPinnedCertAndIntermediates (0.01s) +--- PASS: TestValidateRootWithPinnedCertAndIntermediates (0.07s) === RUN TestValidateRootFailuresWithPinnedCert ---- PASS: TestValidateRootFailuresWithPinnedCert (0.00s) +--- PASS: TestValidateRootFailuresWithPinnedCert (0.01s) === RUN TestValidateRootWithPinnedCA ---- PASS: TestValidateRootWithPinnedCA (0.03s) +--- PASS: TestValidateRootWithPinnedCA (0.20s) === RUN TestValidateSuccessfulRootRotation ---- PASS: TestValidateSuccessfulRootRotation (0.03s) +--- PASS: TestValidateSuccessfulRootRotation (0.08s) === RUN TestValidateRootRotationMissingOrigSig ---- PASS: TestValidateRootRotationMissingOrigSig (0.02s) +--- PASS: TestValidateRootRotationMissingOrigSig (0.07s) === RUN TestValidateRootRotationMissingNewSig ---- PASS: TestValidateRootRotationMissingNewSig (0.02s) +--- PASS: TestValidateRootRotationMissingNewSig (0.08s) === RUN TestValidateRootRotationTrustPinning ---- PASS: TestValidateRootRotationTrustPinning (0.02s) +--- PASS: TestValidateRootRotationTrustPinning (0.09s) === RUN TestValidateRootRotationTrustPinningInvalidCA ---- PASS: TestValidateRootRotationTrustPinningInvalidCA (0.02s) +--- PASS: TestValidateRootRotationTrustPinningInvalidCA (0.08s) === RUN TestParsePEMPublicKey -time="2025-07-09T21:20:00Z" level=warning msg="certificate with CN notary is near expiry" ---- PASS: TestParsePEMPublicKey (0.00s) +time="2024-06-06T15:03:43Z" level=warning msg="certificate with CN notary is near expiry" +--- PASS: TestParsePEMPublicKey (0.02s) === RUN TestCheckingCertExpiry -time="2025-07-09T21:20:00Z" level=warning msg="certificate with CN notary is near expiry" ---- PASS: TestCheckingCertExpiry (0.00s) +time="2024-06-06T15:03:43Z" level=warning msg="certificate with CN notary is near expiry" +--- PASS: TestCheckingCertExpiry (0.02s) === RUN TestValidateRootWithExpiredIntermediate ---- PASS: TestValidateRootWithExpiredIntermediate (0.01s) +--- PASS: TestValidateRootWithExpiredIntermediate (0.03s) === RUN TestCheckingWildcardCert ---- PASS: TestCheckingWildcardCert (0.00s) +--- PASS: TestCheckingWildcardCert (0.02s) === RUN TestWildcardMatching --- PASS: TestWildcardMatching (0.00s) PASS -ok github.com/theupdateframework/notary/trustpinning 0.197s +ok github.com/theupdateframework/notary/trustpinning 0.828s === RUN TestInitSnapshotNoTargets ---- PASS: TestInitSnapshotNoTargets (0.00s) +--- PASS: TestInitSnapshotNoTargets (0.03s) === RUN TestInitRepo ---- PASS: TestInitRepo (0.00s) +--- PASS: TestInitRepo (0.02s) === RUN TestUpdateDelegations --- PASS: TestUpdateDelegations (0.00s) === RUN TestPurgeDelegationsKeyFromTop -time="2025-07-09T21:20:00Z" level=warning msg="role targets/sybil has fewer keys than its threshold of 1; it will not be usable until keys are added to it" -time="2025-07-09T21:20:00Z" level=warning msg="role targets/vimes/carrot has fewer keys than its threshold of 1; it will not be usable until keys are added to it" +time="2024-06-06T15:03:43Z" level=warning msg="role targets/sybil has fewer keys than its threshold of 1; it will not be usable until keys are added to it" +time="2024-06-06T15:03:43Z" level=warning msg="role targets/vimes/carrot has fewer keys than its threshold of 1; it will not be usable until keys are added to it" --- PASS: TestPurgeDelegationsKeyFromTop (0.00s) === RUN TestPurgeDelegationsKeyFromDeep -time="2025-07-09T21:20:00Z" level=warning msg="role targets/vimes/carrot has fewer keys than its threshold of 1; it will not be usable until keys are added to it" +time="2024-06-06T15:03:43Z" level=warning msg="role targets/vimes/carrot has fewer keys than its threshold of 1; it will not be usable until keys are added to it" --- PASS: TestPurgeDelegationsKeyFromDeep (0.00s) === RUN TestPurgeDelegationsKeyBadWildRole --- PASS: TestPurgeDelegationsKeyBadWildRole (0.00s) @@ -3308,7 +3344,7 @@ === RUN TestUpdateDelegationsRoleThatIsMissingDelegationKey --- PASS: TestUpdateDelegationsRoleThatIsMissingDelegationKey (0.00s) === RUN TestUpdateDelegationsNotEnoughKeys -time="2025-07-09T21:20:00Z" level=warning msg="role targets/role has fewer keys than its threshold of 2; it will not be usable until keys are added to it" +time="2024-06-06T15:03:43Z" level=warning msg="role targets/role has fewer keys than its threshold of 2; it will not be usable until keys are added to it" --- PASS: TestUpdateDelegationsNotEnoughKeys (0.00s) === RUN TestUpdateDelegationsAddKeyToRole --- PASS: TestUpdateDelegationsAddKeyToRole (0.00s) @@ -3349,11 +3385,11 @@ === RUN TestRemoveTargetsNoSigningKeys --- PASS: TestRemoveTargetsNoSigningKeys (0.00s) === RUN TestAddBaseKeysToRoot ---- PASS: TestAddBaseKeysToRoot (0.00s) +--- PASS: TestAddBaseKeysToRoot (0.01s) === RUN TestRemoveBaseKeysFromRoot --- PASS: TestRemoveBaseKeysFromRoot (0.00s) === RUN TestReplaceBaseKeysInRoot ---- PASS: TestReplaceBaseKeysInRoot (0.00s) +--- PASS: TestReplaceBaseKeysInRoot (0.01s) === RUN TestGetAllRoles --- PASS: TestGetAllRoles (0.00s) === RUN TestGetBaseRoles @@ -3375,41 +3411,41 @@ === RUN TestGetDelegationRoleKeyMissing --- PASS: TestGetDelegationRoleKeyMissing (0.00s) === RUN TestSignRootOldKeyCertExists ---- PASS: TestSignRootOldKeyCertExists (0.02s) +--- PASS: TestSignRootOldKeyCertExists (0.03s) === RUN TestSignRootOldKeyCertMissing ---- PASS: TestSignRootOldKeyCertMissing (0.01s) +--- PASS: TestSignRootOldKeyCertMissing (0.04s) === RUN TestRootKeyRotation ---- PASS: TestRootKeyRotation (0.04s) +--- PASS: TestRootKeyRotation (0.13s) === RUN TestBuilderLoadsValidRolesOnly ---- PASS: TestBuilderLoadsValidRolesOnly (0.00s) +--- PASS: TestBuilderLoadsValidRolesOnly (0.02s) === RUN TestBuilderOnlyAcceptsRootFirstWhenLoading --- PASS: TestBuilderOnlyAcceptsRootFirstWhenLoading (0.00s) === RUN TestBuilderOnlyAcceptsDelegationsAfterParent ---- PASS: TestBuilderOnlyAcceptsDelegationsAfterParent (0.00s) +--- PASS: TestBuilderOnlyAcceptsDelegationsAfterParent (0.01s) === RUN TestMarkingIsValid ---- PASS: TestMarkingIsValid (0.00s) +--- PASS: TestMarkingIsValid (0.01s) === RUN TestBuilderLoadInvalidDelegations ---- PASS: TestBuilderLoadInvalidDelegations (0.00s) +--- PASS: TestBuilderLoadInvalidDelegations (0.02s) === RUN TestBuilderLoadInvalidDelegationsOldVersion ---- PASS: TestBuilderLoadInvalidDelegationsOldVersion (0.00s) +--- PASS: TestBuilderLoadInvalidDelegationsOldVersion (0.01s) === RUN TestBuilderAcceptRoleOnce ---- PASS: TestBuilderAcceptRoleOnce (0.00s) +--- PASS: TestBuilderAcceptRoleOnce (0.01s) === RUN TestBuilderStopsAcceptingOrProducingDataOnceDone ---- PASS: TestBuilderStopsAcceptingOrProducingDataOnceDone (0.00s) +--- PASS: TestBuilderStopsAcceptingOrProducingDataOnceDone (0.01s) === RUN TestGenerateSnapshotInvalidOperations ---- PASS: TestGenerateSnapshotInvalidOperations (0.02s) +--- PASS: TestGenerateSnapshotInvalidOperations (0.15s) === RUN TestGenerateTimestampInvalidOperations ---- PASS: TestGenerateTimestampInvalidOperations (0.01s) +--- PASS: TestGenerateTimestampInvalidOperations (0.08s) === RUN TestGetConsistentInfo ---- PASS: TestGetConsistentInfo (0.00s) +--- PASS: TestGetConsistentInfo (0.02s) === RUN TestTimestampPreAndPostChecksumming ---- PASS: TestTimestampPreAndPostChecksumming (0.01s) +--- PASS: TestTimestampPreAndPostChecksumming (0.03s) === RUN TestSnapshotLoadedFirstChecksumsOthers ---- PASS: TestSnapshotLoadedFirstChecksumsOthers (0.00s) +--- PASS: TestSnapshotLoadedFirstChecksumsOthers (0.02s) === RUN TestSnapshotLoadedAfterChecksumsOthersRetroactively ---- PASS: TestSnapshotLoadedAfterChecksumsOthersRetroactively (0.01s) +--- PASS: TestSnapshotLoadedAfterChecksumsOthersRetroactively (0.07s) PASS -ok github.com/theupdateframework/notary/tuf 0.192s +ok github.com/theupdateframework/notary/tuf 0.804s === RUN TestMergeStrSlicesExclusive --- PASS: TestMergeStrSlicesExclusive (0.00s) === RUN TestMergeStrSlicesOverlap @@ -3457,9 +3493,9 @@ === RUN TestRootFromSignedCopiesSignatures --- PASS: TestRootFromSignedCopiesSignatures (0.00s) === RUN TestRootFromSignedValidatesRoleData ---- PASS: TestRootFromSignedValidatesRoleData (0.01s) +--- PASS: TestRootFromSignedValidatesRoleData (0.02s) === RUN TestRootFromSignedValidatesRoleType ---- PASS: TestRootFromSignedValidatesRoleType (0.00s) +--- PASS: TestRootFromSignedValidatesRoleType (0.01s) === RUN TestRootFromSignedValidatesVersion --- PASS: TestRootFromSignedValidatesVersion (0.00s) === RUN TestSnapshotToSignedMarshalsSignedPortionWithCanonicalJSON @@ -3481,7 +3517,7 @@ === RUN TestSnapshotFromSignedValidatesRoleType --- PASS: TestSnapshotFromSignedValidatesRoleType (0.00s) === RUN TestSnapshotFromSignedValidatesVersion ---- PASS: TestSnapshotFromSignedValidatesVersion (0.00s) +--- PASS: TestSnapshotFromSignedValidatesVersion (0.01s) === RUN TestSnapshotGetMeta --- PASS: TestSnapshotGetMeta (0.00s) === RUN TestTargetsToSignedMarshalsSignedPortionWithCanonicalJSON @@ -3499,7 +3535,7 @@ === RUN TestTargetsFromSignedCopiesSignatures --- PASS: TestTargetsFromSignedCopiesSignatures (0.00s) === RUN TestTargetsFromSignedValidatesDelegations ---- PASS: TestTargetsFromSignedValidatesDelegations (0.00s) +--- PASS: TestTargetsFromSignedValidatesDelegations (0.01s) === RUN TestTargetsFromSignedValidatesRoleType --- PASS: TestTargetsFromSignedValidatesRoleType (0.00s) === RUN TestTargetsFromSignedValidatesRoleName @@ -3543,13 +3579,13 @@ === RUN TestFileMetaEquals --- PASS: TestFileMetaEquals (0.00s) PASS -ok github.com/theupdateframework/notary/tuf/data 0.031s +ok github.com/theupdateframework/notary/tuf/data 0.100s === RUN TestListKeys --- PASS: TestListKeys (0.00s) === RUN TestGetKeys --- PASS: TestGetKeys (0.00s) === RUN TestBasicSign ---- PASS: TestBasicSign (0.00s) +--- PASS: TestBasicSign (0.01s) === RUN TestReSign --- PASS: TestReSign (0.00s) === RUN TestMultiSign @@ -3561,7 +3597,7 @@ === RUN TestSignRemovesValidSigByInvalidKey --- PASS: TestSignRemovesValidSigByInvalidKey (0.00s) === RUN TestSignRemovesInvalidSig ---- PASS: TestSignRemovesInvalidSig (0.00s) +--- PASS: TestSignRemovesInvalidSig (0.01s) === RUN TestSignMinSignatures --- PASS: TestSignMinSignatures (0.00s) === RUN TestSignFailingKeys @@ -3569,19 +3605,19 @@ === RUN TestErrInsufficientSignaturesMessaging --- PASS: TestErrInsufficientSignaturesMessaging (0.00s) === RUN TestRSAPSSVerifier ---- PASS: TestRSAPSSVerifier (0.00s) +--- PASS: TestRSAPSSVerifier (0.01s) === RUN TestRSAPSSx509Verifier ---- PASS: TestRSAPSSx509Verifier (0.00s) +--- PASS: TestRSAPSSx509Verifier (0.01s) === RUN TestRSAPSSVerifierWithInvalidKeyType --- PASS: TestRSAPSSVerifierWithInvalidKeyType (0.00s) === RUN TestRSAPSSVerifierWithInvalidKeyLength ---- PASS: TestRSAPSSVerifierWithInvalidKeyLength (0.03s) +--- PASS: TestRSAPSSVerifierWithInvalidKeyLength (0.06s) === RUN TestRSAPSSVerifierWithInvalidKey --- PASS: TestRSAPSSVerifierWithInvalidKey (0.00s) === RUN TestRSAPSSVerifierWithInvalidSignature ---- PASS: TestRSAPSSVerifierWithInvalidSignature (0.00s) +--- PASS: TestRSAPSSVerifierWithInvalidSignature (0.01s) === RUN TestRSAPKCS1v15Verifier ---- PASS: TestRSAPKCS1v15Verifier (0.00s) +--- PASS: TestRSAPKCS1v15Verifier (0.01s) === RUN TestRSAPKCS1v15x509Verifier --- PASS: TestRSAPKCS1v15x509Verifier (0.00s) === RUN TestRSAPKCS1v15VerifierWithInvalidKeyType @@ -3589,12 +3625,12 @@ === RUN TestRSAPKCS1v15VerifierWithInvalidKey --- PASS: TestRSAPKCS1v15VerifierWithInvalidKey (0.00s) === RUN TestRSAPKCS1v15VerifierWithInvalidSignature -time="2025-07-09T21:20:00Z" level=error msg="Failed verification: crypto/rsa: verification error" ---- PASS: TestRSAPKCS1v15VerifierWithInvalidSignature (0.00s) +time="2024-06-06T15:03:43Z" level=error msg="Failed verification: crypto/rsa: verification error" +--- PASS: TestRSAPKCS1v15VerifierWithInvalidSignature (0.01s) === RUN TestECDSAVerifier --- PASS: TestECDSAVerifier (0.00s) === RUN TestECDSAVerifierOtherCurves ---- PASS: TestECDSAVerifierOtherCurves (0.03s) +--- PASS: TestECDSAVerifierOtherCurves (0.10s) === RUN TestECDSAx509Verifier --- PASS: TestECDSAx509Verifier (0.00s) === RUN TestECDSAVerifierWithInvalidKeyType @@ -3632,68 +3668,68 @@ === RUN TestVerifyVersion --- PASS: TestVerifyVersion (0.00s) === RUN TestVerifyExpiry -time="2025-07-09T21:20:00Z" level=error msg="Metadata for root expired" +time="2024-06-06T15:03:43Z" level=error msg="Metadata for root expired" --- PASS: TestVerifyExpiry (0.00s) === RUN TestVerifyPublicKeyMatchesPrivateKeyHappyCase --- PASS: TestVerifyPublicKeyMatchesPrivateKeyHappyCase (0.00s) === RUN TestVerifyPublicKeyMatchesPrivateKeyFails --- PASS: TestVerifyPublicKeyMatchesPrivateKeyFails (0.00s) PASS -ok github.com/theupdateframework/notary/tuf/signed 0.108s +ok github.com/theupdateframework/notary/tuf/signed 0.304s === RUN TestNewSwizzler ---- PASS: TestNewSwizzler (0.01s) +--- PASS: TestNewSwizzler (0.02s) === RUN TestSwizzlerSetInvalidJSON ---- PASS: TestSwizzlerSetInvalidJSON (0.00s) +--- PASS: TestSwizzlerSetInvalidJSON (0.01s) === RUN TestSwizzlerAddExtraSpace ---- PASS: TestSwizzlerAddExtraSpace (0.00s) +--- PASS: TestSwizzlerAddExtraSpace (0.01s) === RUN TestSwizzlerSetInvalidSigned ---- PASS: TestSwizzlerSetInvalidSigned (0.00s) +--- PASS: TestSwizzlerSetInvalidSigned (0.01s) === RUN TestSwizzlerSetInvalidSignedMeta ---- PASS: TestSwizzlerSetInvalidSignedMeta (0.00s) +--- PASS: TestSwizzlerSetInvalidSignedMeta (0.02s) === RUN TestSwizzlerSetInvalidMetadataType ---- PASS: TestSwizzlerSetInvalidMetadataType (0.00s) +--- PASS: TestSwizzlerSetInvalidMetadataType (0.01s) === RUN TestSwizzlerInvalidateMetadataSignatures ---- PASS: TestSwizzlerInvalidateMetadataSignatures (0.00s) +--- PASS: TestSwizzlerInvalidateMetadataSignatures (0.01s) === RUN TestSwizzlerRemoveMetadata ---- PASS: TestSwizzlerRemoveMetadata (0.00s) +--- PASS: TestSwizzlerRemoveMetadata (0.02s) === RUN TestSwizzlerSignMetadataWithInvalidKey --- PASS: TestSwizzlerSignMetadataWithInvalidKey (0.01s) === RUN TestSwizzlerOffsetMetadataVersion ---- PASS: TestSwizzlerOffsetMetadataVersion (0.00s) +--- PASS: TestSwizzlerOffsetMetadataVersion (0.16s) === RUN TestSwizzlerExpireMetadata ---- PASS: TestSwizzlerExpireMetadata (0.01s) +--- PASS: TestSwizzlerExpireMetadata (0.02s) === RUN TestSwizzlerSetThresholdBaseRole ---- PASS: TestSwizzlerSetThresholdBaseRole (0.01s) +--- PASS: TestSwizzlerSetThresholdBaseRole (0.02s) === RUN TestSwizzlerSetThresholdDelegatedRole ---- PASS: TestSwizzlerSetThresholdDelegatedRole (0.00s) +--- PASS: TestSwizzlerSetThresholdDelegatedRole (0.02s) === RUN TestSwizzlerChangeRootKey ---- PASS: TestSwizzlerChangeRootKey (0.01s) +--- PASS: TestSwizzlerChangeRootKey (0.02s) === RUN TestSwizzlerUpdateSnapshotHashesSpecifiedRoles ---- PASS: TestSwizzlerUpdateSnapshotHashesSpecifiedRoles (0.00s) +--- PASS: TestSwizzlerUpdateSnapshotHashesSpecifiedRoles (0.02s) === RUN TestSwizzlerUpdateSnapshotHashesNoSpecifiedRoles ---- PASS: TestSwizzlerUpdateSnapshotHashesNoSpecifiedRoles (0.00s) +--- PASS: TestSwizzlerUpdateSnapshotHashesNoSpecifiedRoles (0.02s) === RUN TestSwizzlerUpdateTimestamp ---- PASS: TestSwizzlerUpdateTimestamp (0.00s) +--- PASS: TestSwizzlerUpdateTimestamp (0.03s) === RUN TestMissingSigningKey ---- PASS: TestMissingSigningKey (0.00s) +--- PASS: TestMissingSigningKey (0.03s) === RUN TestSwizzlerMutateRoot ---- PASS: TestSwizzlerMutateRoot (0.00s) +--- PASS: TestSwizzlerMutateRoot (0.02s) === RUN TestSwizzlerMutateTimestamp ---- PASS: TestSwizzlerMutateTimestamp (0.00s) +--- PASS: TestSwizzlerMutateTimestamp (0.01s) === RUN TestSwizzlerMutateSnapshot ---- PASS: TestSwizzlerMutateSnapshot (0.00s) +--- PASS: TestSwizzlerMutateSnapshot (0.01s) === RUN TestSwizzlerMutateTargets ---- PASS: TestSwizzlerMutateTargets (0.00s) +--- PASS: TestSwizzlerMutateTargets (0.02s) === RUN TestSwizzlerRotateKeyBaseRole ---- PASS: TestSwizzlerRotateKeyBaseRole (0.01s) +--- PASS: TestSwizzlerRotateKeyBaseRole (0.03s) === RUN TestSwizzlerRotateKeyDelegationRole ---- PASS: TestSwizzlerRotateKeyDelegationRole (0.00s) +--- PASS: TestSwizzlerRotateKeyDelegationRole (0.02s) PASS -ok github.com/theupdateframework/notary/tuf/testutils 0.123s +ok github.com/theupdateframework/notary/tuf/testutils 0.623s === RUN TestConvertTUFKeyToPKCS8 ---- PASS: TestConvertTUFKeyToPKCS8 (0.02s) +--- PASS: TestConvertTUFKeyToPKCS8 (0.05s) === RUN TestParsePKCS8ToTufKey ---- PASS: TestParsePKCS8ToTufKey (0.05s) +--- PASS: TestParsePKCS8ToTufKey (0.10s) === RUN TestPEMtoPEM --- PASS: TestPEMtoPEM (0.00s) === RUN TestRoleListLen @@ -3739,7 +3775,7 @@ === RUN TestNewCertificate --- PASS: TestNewCertificate (0.00s) === RUN TestKeyOperations ---- PASS: TestKeyOperations (0.02s) +--- PASS: TestKeyOperations (0.04s) === RUN TestRSAX509PublickeyID --- PASS: TestRSAX509PublickeyID (0.00s) === RUN TestECDSAX509PublickeyID @@ -3749,15 +3785,15 @@ === RUN TestParsePEMPrivateKeyLegacy --- PASS: TestParsePEMPrivateKeyLegacy (0.00s) === RUN TestValidateCertificateWithSHA1 ---- PASS: TestValidateCertificateWithSHA1 (0.00s) +--- PASS: TestValidateCertificateWithSHA1 (0.01s) === RUN TestValidateCertificateWithExpiredCert --- PASS: TestValidateCertificateWithExpiredCert (0.00s) === RUN TestValidateCertificateWithInvalidExpiry --- PASS: TestValidateCertificateWithInvalidExpiry (0.00s) === RUN TestValidateCertificateWithShortKey ---- PASS: TestValidateCertificateWithShortKey (0.01s) +--- PASS: TestValidateCertificateWithShortKey (0.07s) PASS -ok github.com/theupdateframework/notary/tuf/utils 0.120s +ok github.com/theupdateframework/notary/tuf/utils 0.333s === RUN TestNewSerializableErrorNonValidationError --- PASS: TestNewSerializableErrorNonValidationError (0.00s) === RUN TestNewSerializableErrorValidationError @@ -3773,9 +3809,9 @@ === RUN TestUnmarshalInvalidJSON --- PASS: TestUnmarshalInvalidJSON (0.00s) PASS -ok github.com/theupdateframework/notary/tuf/validation 0.016s +ok github.com/theupdateframework/notary/tuf/validation 0.048s === RUN TestSetSignalTrap ---- PASS: TestSetSignalTrap (0.00s) +--- PASS: TestSetSignalTrap (0.02s) === RUN TestLogLevelSignalHandle Attempt to increase log level failed, will remain at debug level, error: log level can not be set higher than Debug Successfully setting log level to debug @@ -3823,7 +3859,7 @@ === RUN TestParseRethinkStorageDBStoreEmptyCA --- PASS: TestParseRethinkStorageDBStoreEmptyCA (0.00s) === RUN TestParseRethinkStorageDBStoreEmptyCertAndKey ---- PASS: TestParseRethinkStorageDBStoreEmptyCertAndKey (0.00s) +--- PASS: TestParseRethinkStorageDBStoreEmptyCertAndKey (0.01s) === RUN TestParseRethinkStorageDBStoreEmptyUsername --- PASS: TestParseRethinkStorageDBStoreEmptyUsername (0.00s) === RUN TestParseSQLStorageWithEnvironmentVariables @@ -3873,7 +3909,7 @@ === RUN TestDoAuthWildcardImage --- PASS: TestDoAuthWildcardImage (0.00s) PASS -ok github.com/theupdateframework/notary/utils 0.027s +ok github.com/theupdateframework/notary/utils 0.096s create-stamp debian/debhelper-build-stamp dh_testroot -O--builddirectory=/build/reproducible-path/notary-0.7.0\+ds1/_build -O--buildsystem=golang dh_prep -O--builddirectory=/build/reproducible-path/notary-0.7.0\+ds1/_build -O--buildsystem=golang @@ -3920,12 +3956,14 @@ dpkg-buildpackage: info: binary-only upload (no source included) dpkg-genchanges: info: not including original source code in upload I: copying local configuration +I: user script /srv/workspace/pbuilder/3017386/tmp/hooks/B01_cleanup starting +I: user script /srv/workspace/pbuilder/3017386/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/3120511 and its subdirectories -I: Current time: Wed Jul 9 09:20:36 -12 2025 -I: pbuilder-time-stamp: 1752096036 +I: removing directory /srv/workspace/pbuilder/3017386 and its subdirectories +I: Current time: Fri Jun 7 05:06:26 +14 2024 +I: pbuilder-time-stamp: 1717686386