Diff of the two buildlogs: -- --- b1/build.log 2024-04-12 21:49:17.471312278 +0000 +++ b2/build.log 2024-04-12 21:53:30.452549959 +0000 @@ -1,6 +1,6 @@ I: pbuilder: network access will be disabled during build -I: Current time: Thu May 15 16:07:56 -12 2025 -I: pbuilder-time-stamp: 1747368476 +I: Current time: Sat Apr 13 11:49:20 +14 2024 +I: pbuilder-time-stamp: 1712958560 I: Building the build Environment I: extracting base tarball [/var/cache/pbuilder/trixie-reproducible-base.tgz] I: copying local configuration @@ -32,54 +32,86 @@ 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/112815/tmp/hooks/D02_print_environment starting +I: user script /srv/workspace/pbuilder/25686/tmp/hooks/D01_modify_environment starting +debug: Running on ionos2-i386. +I: Changing host+domainname to test build reproducibility +I: Adding a custom variable just for the fun of it... +I: Changing /bin/sh to bash +'/bin/sh' -> '/bin/bash' +lrwxrwxrwx 1 root root 9 Apr 12 21:49 /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/25686/tmp/hooks/D01_modify_environment finished +I: user script /srv/workspace/pbuilder/25686/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='i386' - DEBIAN_FRONTEND='noninteractive' - DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all parallel=22 ' - DISTRIBUTION='trixie' - HOME='/root' - HOST_ARCH='i386' + 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]="i686-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=i386 + DEBIAN_FRONTEND=noninteractive + DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all parallel=7 ' + DIRSTACK=() + DISTRIBUTION=trixie + EUID=0 + FUNCNAME=([0]="Echo" [1]="main") + GROUPS=() + HOME=/root + HOSTNAME=i-capture-the-hostname + HOSTTYPE=i686 + HOST_ARCH=i386 IFS=' ' - INVOCATION_ID='3ac471d6f0be43a388f91b20695bb404' - LANG='C' - LANGUAGE='en_US:en' - LC_ALL='C' - LD_LIBRARY_PATH='/usr/lib/libeatmydata' - LD_PRELOAD='libeatmydata.so' - 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='112815' - PS1='# ' - PS2='> ' + INVOCATION_ID=2d51de6ab21441168ab905606207391c + LANG=C + LANGUAGE=de_CH:de + LC_ALL=C + LD_LIBRARY_PATH=/usr/lib/libeatmydata + LD_PRELOAD=libeatmydata.so + MACHTYPE=i686-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=25686 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.oV89cGUO/pbuilderrc_D1Ok --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.oV89cGUO/b1 --logfile b1/build.log notary_0.7.0+ds1-2.dsc' - SUDO_GID='112' - SUDO_UID='107' - SUDO_USER='jenkins' - TERM='unknown' - TZ='/usr/share/zoneinfo/Etc/GMT+12' - USER='root' - _='/usr/bin/systemd-run' - http_proxy='http://85.184.249.68:3128' + PWD=/ + SHELL=/bin/bash + SHELLOPTS=braceexpand:errexit:hashall:interactive-comments:posix + SHLVL=3 + SUDO_COMMAND='/usr/bin/timeout -k 24.1h 24h /usr/bin/ionice -c 3 /usr/bin/nice -n 11 /usr/bin/unshare --uts -- /usr/sbin/pbuilder --build --configfile /srv/reproducible-results/rbuild-debian/r-b-build.oV89cGUO/pbuilderrc_u7vM --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.oV89cGUO/b2 --logfile b2/build.log notary_0.7.0+ds1-2.dsc' + SUDO_GID=112 + SUDO_UID=107 + SUDO_USER=jenkins + TERM=unknown + TZ=/usr/share/zoneinfo/Etc/GMT-14 + UID=0 + USER=root + _='I: set' + http_proxy=http://78.137.99.97:3128 I: uname -a - Linux ionos16-i386 6.1.0-18-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.1.76-1 (2024-02-01) x86_64 GNU/Linux + Linux i-capture-the-hostname 6.1.0-18-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.1.76-1 (2024-02-01) x86_64 GNU/Linux I: ls -l /bin - lrwxrwxrwx 1 root root 7 May 15 17:46 /bin -> usr/bin -I: user script /srv/workspace/pbuilder/112815/tmp/hooks/D02_print_environment finished + lrwxrwxrwx 1 root root 7 Apr 10 11:24 /bin -> usr/bin +I: user script /srv/workspace/pbuilder/25686/tmp/hooks/D02_print_environment finished -> Attempting to satisfy build-dependencies -> Creating pbuilder-satisfydepends-dummy package Package: pbuilder-satisfydepends-dummy @@ -358,7 +390,7 @@ Get: 187 http://deb.debian.org/debian trixie/main i386 golang-goprotobuf-dev i386 1.3.5-4+b6 [3436 B] Get: 188 http://deb.debian.org/debian trixie/main i386 golang-gopkg-rethinkdb-rethinkdb-go.v6-dev all 6.2.1-2 [106 kB] Get: 189 http://deb.debian.org/debian trixie/main i386 openssl i386 3.1.5-1 [1246 kB] -Fetched 107 MB in 3s (41.9 MB/s) +Fetched 107 MB in 4s (25.0 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 ... 19874 files and directories currently installed.) @@ -1129,7 +1161,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/25686/tmp/hooks/A99_set_merged_usr starting +Not re-configuring usrmerge for trixie +I: user script /srv/workspace/pbuilder/25686/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 @@ -1408,48 +1444,48 @@ 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 22 -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 + cd _build && go install -trimpath -v -p 7 -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/godebugs +internal/coverage/rtcov +internal/unsafeheader internal/goos -unicode/utf8 +internal/goarch +internal/goexperiment +internal/cpu +runtime/internal/atomic +internal/abi +runtime/internal/math +internal/chacha8rand +runtime/internal/sys +runtime/internal/syscall internal/race -internal/unsafeheader +sync/atomic +math/bits +unicode/utf8 +internal/itoa +internal/bytealg cmp unicode -internal/itoa -crypto/internal/alias -internal/goexperiment +encoding +unicode/utf16 +slices +math log/internal -internal/cpu -sync/atomic -runtime/internal/atomic -vendor/golang.org/x/crypto/cryptobyte/asn1 +crypto/internal/alias crypto/internal/boring/sig -math/bits -runtime/internal/syscall +vendor/golang.org/x/crypto/cryptobyte/asn1 internal/nettrace container/list vendor/golang.org/x/crypto/internal/alias +github.com/pelletier/go-toml/v2/internal/characters google.golang.org/grpc/serviceconfig google.golang.org/protobuf/internal/flags +google.golang.org/protobuf/internal/set github.com/theupdateframework/notary/version -internal/coverage/rtcov github.com/lib/pq/oid -internal/goarch -unicode/utf16 -google.golang.org/protobuf/internal/set -slices -encoding -github.com/pelletier/go-toml/v2/internal/characters -runtime/internal/math -internal/chacha8rand -runtime/internal/sys -internal/abi -math -internal/bytealg runtime -internal/reflectlite crypto/subtle +internal/reflectlite runtime/metrics sync internal/testlog @@ -1457,368 +1493,368 @@ internal/bisect github.com/spf13/viper/internal/encoding google.golang.org/grpc/internal/buffer +runtime/cgo google.golang.org/grpc/internal/grpcsync google.golang.org/protobuf/internal/pragma -runtime/cgo +errors internal/godebug sort -errors -internal/oserror -internal/safefilepath io +strconv path -internal/intern +internal/oserror +internal/safefilepath math/rand -vendor/golang.org/x/net/dns/dnsmessage -crypto/internal/nistec/fiat -github.com/hashicorp/hcl/hcl/strconv -strconv syscall +crypto/internal/nistec/fiat hash -crypto/internal/randutil -text/tabwriter bytes strings -net/netip -github.com/beorn7/perks/quantile +crypto/internal/randutil +vendor/golang.org/x/net/dns/dnsmessage crypto -hash/fnv -hash/crc32 reflect +internal/intern +net/netip +bufio +regexp/syntax +hash/crc32 crypto/rc4 +vendor/golang.org/x/text/transform net/http/internal/ascii golang.org/x/text/transform -golang.org/x/crypto/blowfish html -github.com/prometheus/common/internal/bitbucket.org/ww/goautoneg -github.com/dvsekhvalnov/jose2go/padding -vendor/golang.org/x/text/transform -encoding/base32 -net/http/internal/testcert -bufio -google.golang.org/grpc/encoding -regexp/syntax -golang.org/x/text/runes -internal/syscall/execenv internal/syscall/unix time -crypto/internal/nistec +internal/syscall/execenv +golang.org/x/text/runes regexp +github.com/hashicorp/hcl/hcl/strconv +text/tabwriter +google.golang.org/grpc/encoding +github.com/beorn7/perks/quantile +hash/fnv +github.com/prometheus/common/internal/bitbucket.org/ww/goautoneg +golang.org/x/crypto/blowfish +encoding/base32 +github.com/dvsekhvalnov/jose2go/padding +net/http/internal/testcert github.com/jinzhu/inflection +internal/fmtsort +encoding/binary +crypto/internal/nistec +io/fs context +internal/poll google.golang.org/grpc/backoff google.golang.org/grpc/internal/grpcrand -internal/poll -io/fs -github.com/bugsnag/bugsnag-go/headers google.golang.org/grpc/keepalive -internal/fmtsort -encoding/binary google.golang.org/grpc/internal/backoff +github.com/bugsnag/bugsnag-go/headers google.golang.org/grpc/tap gopkg.in/rethinkdb/rethinkdb-go.v6/vendor/gopkg.in/cenkalti/backoff.v2 golang.org/x/net/context github.com/spf13/afero/internal/common -os -crypto/md5 encoding/base64 -vendor/golang.org/x/crypto/internal/poly1305 -crypto/internal/edwards25519/field -github.com/cespare/xxhash +crypto/md5 crypto/cipher +crypto/internal/edwards25519/field golang.org/x/sys/unix -crypto/internal/edwards25519 -github.com/dvsekhvalnov/jose2go/base64url +os encoding/pem -vendor/golang.org/x/crypto/chacha20 -crypto/des +crypto/internal/edwards25519 +vendor/golang.org/x/crypto/internal/poly1305 crypto/internal/boring -github.com/dvsekhvalnov/jose2go/compact -crypto/hmac +crypto/des +vendor/golang.org/x/crypto/chacha20 crypto/aes -crypto/sha512 crypto/ecdh -crypto/sha1 +crypto/sha512 crypto/sha256 +crypto/sha1 +crypto/hmac +vendor/golang.org/x/crypto/chacha20poly1305 golang.org/x/crypto/pbkdf2 vendor/golang.org/x/crypto/hkdf -vendor/golang.org/x/crypto/chacha20poly1305 +github.com/cespare/xxhash +github.com/dvsekhvalnov/jose2go/base64url +github.com/dvsekhvalnov/jose2go/compact +github.com/theupdateframework/notary io/ioutil google.golang.org/grpc/internal/envconfig -github.com/bugsnag/bugsnag-go/device path/filepath -google.golang.org/protobuf/internal/detrand -os/signal fmt +net +github.com/bugsnag/bugsnag-go/device +os/signal +google.golang.org/protobuf/internal/detrand github.com/prometheus/procfs/internal/util internal/lazyregexp -github.com/theupdateframework/notary internal/sysinfo -net github.com/spf13/afero/mem os/exec -log -mime/quotedprintable -net/url -encoding/hex +github.com/bugsnag/panicwrap encoding/json +log github.com/docker/go/canonical/json -github.com/subosito/gotenv -net/http/internal -encoding/csv +math/big +encoding/hex +net/url mime -github.com/hashicorp/hcl/hcl/token -flag -golang.org/x/text/unicode/norm -text/template/parse -vendor/golang.org/x/net/http2/hpack +mime/quotedprintable compress/flate +vendor/golang.org/x/text/unicode/bidi +github.com/theupdateframework/notary/tuf/validation +vendor/golang.org/x/net/http2/hpack vendor/golang.org/x/text/unicode/norm -math/big +compress/gzip +vendor/golang.org/x/text/secure/bidirule +net/http/internal +github.com/sirupsen/logrus github.com/miekg/pkcs11 -gopkg.in/ini.v1 -github.com/pelletier/go-toml/v2/internal/danger +flag +encoding/csv +github.com/fsnotify/fsnotify +crypto/rand +crypto/elliptic +github.com/docker/distribution/uuid +crypto/internal/bigmod +crypto/internal/boring/bbig +encoding/asn1 +crypto/dsa +crypto/rsa +crypto/ed25519 +vendor/golang.org/x/net/idna +golang.org/x/text/unicode/norm +golang.org/x/crypto/ed25519 +text/template/parse github.com/spf13/jwalterweatherman -gopkg.in/yaml.v3 -vendor/golang.org/x/text/unicode/bidi +vendor/golang.org/x/crypto/cryptobyte +crypto/x509/pkix +github.com/subosito/gotenv +github.com/hashicorp/hcl/hcl/token +gopkg.in/ini.v1 +crypto/ecdsa github.com/hashicorp/hcl/hcl/ast +text/template github.com/hashicorp/hcl/hcl/scanner github.com/hashicorp/hcl/json/token +github.com/hashicorp/hcl/hcl/parser +github.com/spf13/viper/internal/encoding/json +github.com/pelletier/go-toml/v2/internal/danger +github.com/hashicorp/hcl/json/scanner github.com/pelletier/go-toml/v2/unstable -google.golang.org/grpc/internal/grpclog +github.com/hashicorp/hcl/hcl/printer +github.com/hashicorp/hcl/json/parser +github.com/hashicorp/hcl +gopkg.in/yaml.v3 +github.com/golang/protobuf/proto +github.com/pelletier/go-toml/v2/internal/tracker +github.com/pelletier/go-toml/v2 +github.com/spf13/viper/internal/encoding/hcl +html/template golang.org/x/net/internal/timeseries +google.golang.org/grpc/internal/grpclog +google.golang.org/grpc/grpclog +google.golang.org/grpc/connectivity google.golang.org/grpc/attributes -github.com/hashicorp/hcl/json/scanner +google.golang.org/grpc/internal google.golang.org/grpc/metadata -github.com/hashicorp/hcl/hcl/parser google.golang.org/grpc/codes -google.golang.org/grpc/grpclog +google.golang.org/grpc/internal/balancerload +github.com/spf13/cast +github.com/spf13/viper/internal/encoding/toml golang.org/x/text/unicode/bidi -github.com/hashicorp/hcl/json/parser golang.org/x/net/http2/hpack -google.golang.org/grpc/internal/balancerload +github.com/spf13/viper/internal/encoding/dotenv +github.com/spf13/viper/internal/encoding/ini +golang.org/x/text/secure/bidirule github.com/pkg/errors -github.com/bugsnag/panicwrap -github.com/hashicorp/hcl/hcl/printer -google.golang.org/grpc/connectivity database/sql/driver -github.com/hashicorp/hcl -github.com/pelletier/go-toml/v2/internal/tracker -google.golang.org/grpc/internal -github.com/opencontainers/go-digest +golang.org/x/net/idna +github.com/spf13/viper/internal/encoding/yaml github.com/bugsnag/bugsnag-go/errors -compress/gzip -vendor/golang.org/x/text/secure/bidirule +github.com/opencontainers/go-digest +database/sql github.com/opencontainers/image-spec/specs-go -google.golang.org/protobuf/internal/errors -text/template -go/token github.com/docker/distribution/digestset -github.com/pelletier/go-toml/v2 -google.golang.org/protobuf/internal/version -database/sql -github.com/prometheus/procfs/internal/fs -google.golang.org/protobuf/encoding/protowire -runtime/debug github.com/opencontainers/image-spec/specs-go/v1 -os/user +google.golang.org/protobuf/internal/errors github.com/docker/distribution/reference -github.com/hailocab/go-hostpool -gopkg.in/rethinkdb/rethinkdb-go.v6/types -gopkg.in/rethinkdb/rethinkdb-go.v6/encoding -github.com/opentracing/opentracing-go/log -internal/profile +google.golang.org/protobuf/encoding/protowire +crypto/x509 +net/textproto +vendor/golang.org/x/net/http/httpproxy +github.com/mitchellh/mapstructure +github.com/spf13/pflag +github.com/golang/protobuf/ptypes/empty +mime/multipart +vendor/golang.org/x/net/http/httpguts +google.golang.org/grpc/encoding/proto +github.com/golang/protobuf/ptypes/any +github.com/golang/protobuf/ptypes/duration +github.com/golang/protobuf/ptypes/timestamp +google.golang.org/genproto/googleapis/rpc/status +golang.org/x/net/http/httpguts +github.com/golang/protobuf/ptypes +google.golang.org/grpc/binarylog/grpc_binarylog_v1 +google.golang.org/grpc/internal/syscall +google.golang.org/grpc/stats +google.golang.org/grpc/internal/status +github.com/google/uuid +google.golang.org/grpc/status google.golang.org/protobuf/reflect/protoreflect -go/scanner -github.com/theupdateframework/notary/tuf/validation -github.com/spf13/viper/internal/encoding/hcl -github.com/spf13/viper/internal/encoding/json -runtime/pprof -runtime/trace -github.com/pmezard/go-difflib/difflib -github.com/golang/protobuf/proto -github.com/davecgh/go-spew/spew -go/ast -golang.org/x/text/secure/bidirule -testing -crypto/internal/bigmod -crypto/internal/boring/bbig -crypto/elliptic -crypto/rand -encoding/asn1 -crypto/dsa -vendor/golang.org/x/net/idna -github.com/fsnotify/fsnotify -github.com/docker/distribution/uuid -crypto/ed25519 -github.com/sirupsen/logrus -html/template -github.com/spf13/viper/internal/encoding/toml -golang.org/x/net/idna -golang.org/x/crypto/ed25519 +go/token +google.golang.org/protobuf/internal/version +github.com/prometheus/procfs/internal/fs +github.com/prometheus/procfs golang.org/x/term -golang.org/x/crypto/bcrypt -crypto/rsa -github.com/lib/pq/scram +runtime/debug +github.com/theupdateframework/notary/tuf/data +crypto/tls +github.com/theupdateframework/notary/passphrase 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/encoding/text google.golang.org/protobuf/internal/genid google.golang.org/protobuf/internal/order -google.golang.org/protobuf/runtime/protoiface -google.golang.org/protobuf/internal/encoding/text -crypto/x509/pkix -vendor/golang.org/x/crypto/cryptobyte -github.com/dvsekhvalnov/jose2go/arrays -github.com/spf13/viper/internal/encoding/yaml google.golang.org/protobuf/reflect/protoregistry -github.com/dvsekhvalnov/jose2go/aes -github.com/dvsekhvalnov/jose2go/kdf -github.com/theupdateframework/notary/passphrase -github.com/jinzhu/gorm +google.golang.org/protobuf/runtime/protoiface +github.com/spf13/cobra +github.com/theupdateframework/notary/client/changelist +github.com/theupdateframework/notary/tuf/utils google.golang.org/protobuf/internal/encoding/defval -github.com/spf13/cast google.golang.org/protobuf/proto -crypto/ecdsa -github.com/spf13/viper/internal/encoding/dotenv -github.com/spf13/viper/internal/encoding/ini -google.golang.org/protobuf/encoding/protodelim -google.golang.org/protobuf/encoding/prototext +golang.org/x/crypto/bcrypt +github.com/lib/pq/scram +os/user +go/scanner google.golang.org/protobuf/internal/filedesc -github.com/golang/protobuf/ptypes/empty -google.golang.org/grpc/encoding/proto -github.com/golang/protobuf/ptypes/any -github.com/golang/protobuf/ptypes/timestamp +google.golang.org/protobuf/encoding/prototext +google.golang.org/protobuf/encoding/protodelim +go/ast +github.com/hailocab/go-hostpool +github.com/opentracing/opentracing-go/log +gopkg.in/rethinkdb/rethinkdb-go.v6/encoding gopkg.in/rethinkdb/rethinkdb-go.v6/ql2 -github.com/golang/protobuf/ptypes/duration -google.golang.org/genproto/googleapis/rpc/status -google.golang.org/grpc/binarylog/grpc_binarylog_v1 -github.com/golang/protobuf/ptypes +github.com/jinzhu/gorm +gopkg.in/rethinkdb/rethinkdb-go.v6/types google.golang.org/protobuf/internal/encoding/tag -google.golang.org/grpc/internal/status -google.golang.org/grpc/status +internal/profile +runtime/pprof google.golang.org/protobuf/internal/impl -net/textproto -vendor/golang.org/x/net/http/httpproxy -google.golang.org/grpc/stats -github.com/mitchellh/mapstructure -google.golang.org/grpc/internal/syscall -github.com/google/uuid -github.com/spf13/pflag -crypto/x509 -github.com/prometheus/procfs -vendor/golang.org/x/net/http/httpguts -golang.org/x/net/http/httpguts -mime/multipart -github.com/dvsekhvalnov/jose2go/keys/ecc -github.com/theupdateframework/notary/tuf/data -crypto/tls -github.com/dvsekhvalnov/jose2go -github.com/spf13/cobra -github.com/theupdateframework/notary/client/changelist -google.golang.org/protobuf/internal/filetype -github.com/theupdateframework/notary/tuf/utils -google.golang.org/protobuf/runtime/protoimpl -google.golang.org/protobuf/types/known/timestamppb -github.com/prometheus/client_model/go -github.com/prometheus/common/model -github.com/prometheus/client_golang/prometheus/internal -google.golang.org/grpc/internal/credentials net/http/httptrace +net/http +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 google.golang.org/grpc/credentials -net/http +github.com/go-sql-driver/mysql +github.com/docker/libtrust google.golang.org/grpc/resolver -google.golang.org/grpc/peer -google.golang.org/grpc/internal/channelz google.golang.org/grpc/balancer +google.golang.org/grpc/balancer/base +google.golang.org/grpc/balancer/roundrobin google.golang.org/grpc/internal/grpcutil +google.golang.org/grpc/internal/binarylog +google.golang.org/grpc/internal/channelz google.golang.org/grpc/balancer/grpclb/state -google.golang.org/grpc/internal/resolver/passthrough google.golang.org/grpc/internal/resolver/dns -google.golang.org/grpc/internal/binarylog -google.golang.org/grpc/balancer/base +google.golang.org/grpc/internal/resolver/passthrough google.golang.org/grpc/internal/serviceconfig -google.golang.org/grpc/balancer/roundrobin +google.golang.org/grpc/peer +github.com/lib/pq +runtime/trace +github.com/dvsekhvalnov/jose2go/arrays +github.com/dvsekhvalnov/jose2go/keys/ecc +github.com/dvsekhvalnov/jose2go/aes +github.com/dvsekhvalnov/jose2go/kdf +github.com/davecgh/go-spew/spew +github.com/pmezard/go-difflib/difflib +github.com/dvsekhvalnov/jose2go +testing +google.golang.org/protobuf/internal/filetype +google.golang.org/protobuf/runtime/protoimpl +google.golang.org/protobuf/types/known/timestamppb +github.com/prometheus/client_model/go +github.com/prometheus/common/model +github.com/prometheus/client_golang/prometheus/internal +github.com/spf13/afero +golang.org/x/net/trace github.com/bugsnag/bugsnag-go/sessions -github.com/docker/distribution/registry/auth -github.com/docker/distribution/registry/api/errcode net/http/httputil +github.com/theupdateframework/notary/storage github.com/magiconair/properties -github.com/gorilla/mux -golang.org/x/net/trace -github.com/docker/distribution -github.com/docker/distribution/registry/client/auth/challenge -expvar -github.com/docker/distribution/registry/client/transport golang.org/x/net/http2 -github.com/theupdateframework/notary/storage -github.com/opentracing/opentracing-go -net/http/pprof -net/http/httptest -github.com/spf13/afero -github.com/prometheus/common/expfmt -github.com/theupdateframework/notary/server/errors -github.com/opentracing/opentracing-go/ext github.com/bugsnag/bugsnag-go -github.com/docker/distribution/context -github.com/docker/distribution/registry/api/v2 -gopkg.in/rethinkdb/rethinkdb-go.v6 -github.com/stretchr/testify/assert github.com/theupdateframework/notary/trustmanager github.com/spf13/viper/internal/encoding/javaproperties -github.com/theupdateframework/notary/vendor/github.com/prometheus/client_golang/prometheus -github.com/prometheus/client_golang/prometheus -github.com/docker/distribution/registry/auth/htpasswd +github.com/gorilla/mux +github.com/docker/distribution/registry/api/errcode +github.com/docker/distribution/registry/auth github.com/theupdateframework/notary/cryptoservice -github.com/docker/distribution/registry/auth/token github.com/theupdateframework/notary/tuf/signed -github.com/docker/distribution/health +github.com/docker/distribution +github.com/docker/distribution/registry/client/auth/challenge github.com/Shopify/logrus-bugsnag github.com/spf13/viper -github.com/theupdateframework/notary/tuf/testutils/keys -github.com/theupdateframework/notary/trustpinning +github.com/docker/distribution/context +github.com/docker/distribution/registry/api/v2 +github.com/docker/distribution/registry/client/transport +expvar github.com/theupdateframework/notary/trustmanager/yubikey +github.com/theupdateframework/notary/trustpinning +github.com/prometheus/common/expfmt +github.com/docker/distribution/health github.com/theupdateframework/notary/tuf +github.com/docker/distribution/registry/auth/htpasswd +github.com/docker/distribution/registry/auth/token +github.com/theupdateframework/notary/server/errors +github.com/opentracing/opentracing-go +net/http/pprof +github.com/opentracing/opentracing-go/ext +github.com/theupdateframework/notary/tuf/testutils/keys github.com/theupdateframework/notary/utils -github.com/stretchr/testify/require +gopkg.in/rethinkdb/rethinkdb-go.v6 +net/http/httptest +github.com/theupdateframework/notary/vendor/github.com/prometheus/client_golang/prometheus +github.com/prometheus/client_golang/prometheus github.com/theupdateframework/notary/tuf/testutils github.com/theupdateframework/notary/client -github.com/theupdateframework/notary/tuf/testutils/interfaces -github.com/theupdateframework/notary/storage/rethinkdb +github.com/stretchr/testify/assert +google.golang.org/grpc/internal/transport +github.com/stretchr/testify/require github.com/prometheus/client_golang/prometheus/promhttp +github.com/theupdateframework/notary/storage/rethinkdb +google.golang.org/grpc +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/snapshot github.com/docker/go-metrics -github.com/theupdateframework/notary/server/timestamp -github.com/theupdateframework/notary/server/handlers -google.golang.org/grpc +github.com/theupdateframework/notary/server/snapshot github.com/docker/distribution/metrics +github.com/theupdateframework/notary/server/timestamp github.com/docker/distribution/registry/storage/cache -github.com/theupdateframework/notary/server +github.com/theupdateframework/notary/server/handlers github.com/docker/distribution/registry/storage/cache/memory github.com/docker/distribution/registry/client +github.com/theupdateframework/notary/server +github.com/theupdateframework/notary/trustmanager/remoteks 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/proto -github.com/theupdateframework/notary/trustmanager/remoteks +google.golang.org/grpc/health/grpc_health_v1 +github.com/theupdateframework/notary/cmd/notary google.golang.org/grpc/health -github.com/theupdateframework/notary/signer/client -github.com/theupdateframework/notary/signer github.com/theupdateframework/notary/cmd/escrow +github.com/theupdateframework/notary/signer +github.com/theupdateframework/notary/signer/client github.com/theupdateframework/notary/signer/api -github.com/theupdateframework/notary/cmd/notary-server github.com/theupdateframework/notary/cmd/notary-signer +github.com/theupdateframework/notary/cmd/notary-server 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 22 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 7 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] @@ -1830,394 +1866,394 @@ ? github.com/theupdateframework/notary/tuf/testutils/keys [no test files] ? github.com/theupdateframework/notary/version [no test files] === RUN Test0Dot1Migration ---- PASS: Test0Dot1Migration (0.31s) +--- PASS: Test0Dot1Migration (0.03s) === RUN Test0Dot3Migration ---- PASS: Test0Dot3Migration (0.30s) +--- PASS: Test0Dot3Migration (0.03s) === RUN Test0Dot1RepoFormat -time="2025-05-16T04:10:06Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" ---- PASS: Test0Dot1RepoFormat (1.78s) +time="2024-04-12T21:51:10Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" +--- PASS: Test0Dot1RepoFormat (0.74s) === RUN Test0Dot3RepoFormat -time="2025-05-16T04:10:07Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" ---- PASS: Test0Dot3RepoFormat (1.47s) +time="2024-04-12T21:51:10Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" +--- PASS: Test0Dot3RepoFormat (0.71s) === RUN TestDownloading0Dot1RepoFormat ---- PASS: TestDownloading0Dot1RepoFormat (0.10s) +--- PASS: TestDownloading0Dot1RepoFormat (0.02s) === RUN TestDownloading0Dot3RepoFormat ---- PASS: TestDownloading0Dot3RepoFormat (0.05s) +--- PASS: TestDownloading0Dot3RepoFormat (0.03s) === RUN TestInitRepositoryManagedRolesIncludingRoot ---- PASS: TestInitRepositoryManagedRolesIncludingRoot (0.02s) +--- PASS: TestInitRepositoryManagedRolesIncludingRoot (0.01s) === RUN TestInitRepositoryManagedRolesInvalidRole ---- PASS: TestInitRepositoryManagedRolesInvalidRole (0.02s) +--- PASS: TestInitRepositoryManagedRolesInvalidRole (0.01s) === RUN TestInitRepositoryManagedRolesIncludingTargets --- PASS: TestInitRepositoryManagedRolesIncludingTargets (0.01s) === RUN TestInitRepositoryManagedRolesIncludingTimestamp ---- PASS: TestInitRepositoryManagedRolesIncludingTimestamp (0.09s) +--- PASS: TestInitRepositoryManagedRolesIncludingTimestamp (0.05s) === RUN TestInitRepositoryWithCerts ---- PASS: TestInitRepositoryWithCerts (0.12s) +--- PASS: TestInitRepositoryWithCerts (0.07s) === RUN TestMatchKeyIDsWithPublicKeys ---- PASS: TestMatchKeyIDsWithPublicKeys (0.03s) +--- PASS: TestMatchKeyIDsWithPublicKeys (0.02s) === RUN TestInitRepositoryNeedsRemoteTimestampKey --- PASS: TestInitRepositoryNeedsRemoteTimestampKey (0.04s) === RUN TestInitRepositoryNeedsRemoteSnapshotKey --- PASS: TestInitRepositoryNeedsRemoteSnapshotKey (0.03s) === RUN TestInitRepoServerOnlyManagesTimestampKey ---- PASS: TestInitRepoServerOnlyManagesTimestampKey (0.34s) +--- PASS: TestInitRepoServerOnlyManagesTimestampKey (0.27s) === RUN TestInitRepoServerManagesTimestampAndSnapshotKeys ---- PASS: TestInitRepoServerManagesTimestampAndSnapshotKeys (0.26s) +--- PASS: TestInitRepoServerManagesTimestampAndSnapshotKeys (0.24s) === RUN TestInitRepoAttemptsExceeded ---- PASS: TestInitRepoAttemptsExceeded (0.15s) +--- PASS: TestInitRepoAttemptsExceeded (0.12s) === RUN TestInitRepoPasswordInvalid ---- PASS: TestInitRepoPasswordInvalid (0.04s) +--- PASS: TestInitRepoPasswordInvalid (0.02s) === RUN TestAddTargetToTargetRoleByDefault ---- PASS: TestAddTargetToTargetRoleByDefault (0.18s) +--- PASS: TestAddTargetToTargetRoleByDefault (0.11s) === RUN TestAddTargetToSpecifiedValidRoles ---- PASS: TestAddTargetToSpecifiedValidRoles (0.13s) +--- PASS: TestAddTargetToSpecifiedValidRoles (0.11s) === RUN TestAddTargetToSpecifiedInvalidRoles ---- PASS: TestAddTargetToSpecifiedInvalidRoles (0.14s) +--- PASS: TestAddTargetToSpecifiedInvalidRoles (0.10s) === RUN TestAddTargetWithInvalidTarget ---- PASS: TestAddTargetWithInvalidTarget (0.06s) +--- PASS: TestAddTargetWithInvalidTarget (0.05s) === RUN TestAddTargetErrorWritingChanges ---- PASS: TestAddTargetErrorWritingChanges (0.08s) +--- PASS: TestAddTargetErrorWritingChanges (0.06s) === RUN TestRemoveTargetToTargetRoleByDefault ---- PASS: TestRemoveTargetToTargetRoleByDefault (0.16s) +--- PASS: TestRemoveTargetToTargetRoleByDefault (0.12s) === RUN TestRemoveTargetFromSpecifiedValidRoles ---- PASS: TestRemoveTargetFromSpecifiedValidRoles (0.14s) +--- PASS: TestRemoveTargetFromSpecifiedValidRoles (0.12s) === RUN TestRemoveTargetToSpecifiedInvalidRoles ---- PASS: TestRemoveTargetToSpecifiedInvalidRoles (0.14s) +--- PASS: TestRemoveTargetToSpecifiedInvalidRoles (0.11s) === RUN TestRemoveTargetErrorWritingChanges ---- PASS: TestRemoveTargetErrorWritingChanges (0.06s) +--- PASS: TestRemoveTargetErrorWritingChanges (0.05s) === RUN TestListTarget ---- PASS: TestListTarget (2.24s) +--- PASS: TestListTarget (1.41s) === RUN TestListTargetRestrictsDelegationPaths ---- PASS: TestListTargetRestrictsDelegationPaths (0.39s) +--- PASS: TestListTargetRestrictsDelegationPaths (0.28s) === RUN TestValidateRootKey ---- PASS: TestValidateRootKey (0.16s) +--- PASS: TestValidateRootKey (0.12s) === RUN TestGetChangelist ---- PASS: TestGetChangelist (0.14s) +--- PASS: TestGetChangelist (0.12s) === RUN TestPublishBareRepo ---- PASS: TestPublishBareRepo (1.61s) +--- PASS: TestPublishBareRepo (1.11s) === RUN TestPublishUninitializedRepo -time="2025-05-16T04:10:16Z" level=info msg="No TUF data found locally or remotely - initializing repository docker.com/notary for the first time" ---- PASS: TestPublishUninitializedRepo (0.11s) +time="2024-04-12T21:51:16Z" level=info msg="No TUF data found locally or remotely - initializing repository docker.com/notary for the first time" +--- PASS: TestPublishUninitializedRepo (0.10s) === RUN TestPublishClientHasSnapshotKey ---- PASS: TestPublishClientHasSnapshotKey (1.67s) +--- PASS: TestPublishClientHasSnapshotKey (1.17s) === RUN TestPublishAfterInitServerHasSnapshotKey ---- PASS: TestPublishAfterInitServerHasSnapshotKey (1.58s) +--- PASS: TestPublishAfterInitServerHasSnapshotKey (1.15s) === RUN TestPublishAfterPullServerHasSnapshotKey ---- PASS: TestPublishAfterPullServerHasSnapshotKey (0.66s) +--- PASS: TestPublishAfterPullServerHasSnapshotKey (0.41s) === RUN TestPublishNoOneHasSnapshotKey ---- PASS: TestPublishNoOneHasSnapshotKey (0.26s) +--- PASS: TestPublishNoOneHasSnapshotKey (0.27s) === RUN TestPublishSnapshotCorrupt ---- PASS: TestPublishSnapshotCorrupt (0.91s) +--- PASS: TestPublishSnapshotCorrupt (0.76s) === RUN TestPublishTargetsCorrupt ---- PASS: TestPublishTargetsCorrupt (0.51s) +--- PASS: TestPublishTargetsCorrupt (0.40s) === RUN TestPublishRootCorrupt -time="2025-05-16T04:10:22Z" level=error msg="Could not publish Repository since we could not update: invalid character 'h' in literal true (expecting 'r')" -time="2025-05-16T04:10:22Z" level=error msg="Could not publish Repository since we could not update: invalid character 'h' in literal true (expecting 'r')" ---- PASS: TestPublishRootCorrupt (0.34s) +time="2024-04-12T21:51:20Z" level=error msg="Could not publish Repository since we could not update: invalid character 'h' in literal true (expecting 'r')" +time="2024-04-12T21:51:20Z" level=error msg="Could not publish Repository since we could not update: invalid character 'h' in literal true (expecting 'r')" +--- PASS: TestPublishRootCorrupt (0.28s) === RUN TestPublishSnapshotLocalKeysCreatedFirst ---- PASS: TestPublishSnapshotLocalKeysCreatedFirst (0.02s) +--- PASS: TestPublishSnapshotLocalKeysCreatedFirst (0.01s) === RUN TestPublishDelegations ---- PASS: TestPublishDelegations (0.51s) +--- PASS: TestPublishDelegations (0.56s) === RUN TestPublishDelegationsX509 ---- PASS: TestPublishDelegationsX509 (0.69s) +--- PASS: TestPublishDelegationsX509 (0.52s) === RUN TestPublishTargetsDelegationScopeFailIfNoKeys -time="2025-05-16T04:10:23Z" level=error msg="couldn't add target to targets/a/b: tuf: invalid role targets/a/b. delegation does not exist" -time="2025-05-16T04:10:24Z" level=error msg="couldn't add target to targets/a/b: tuf: invalid role targets/a/b. delegation does not exist" ---- PASS: TestPublishTargetsDelegationScopeFailIfNoKeys (0.61s) +time="2024-04-12T21:51:22Z" level=error msg="couldn't add target to targets/a/b: tuf: invalid role targets/a/b. delegation does not exist" +time="2024-04-12T21:51:22Z" level=error msg="couldn't add target to targets/a/b: tuf: invalid role targets/a/b. delegation does not exist" +--- PASS: TestPublishTargetsDelegationScopeFailIfNoKeys (0.47s) === RUN TestPublishTargetsDelegationSuccessLocallyHasRoles ---- PASS: TestPublishTargetsDelegationSuccessLocallyHasRoles (0.60s) +--- PASS: TestPublishTargetsDelegationSuccessLocallyHasRoles (0.43s) === RUN TestPublishTargetsDelegationNoTargetsKeyNeeded ---- PASS: TestPublishTargetsDelegationNoTargetsKeyNeeded (0.81s) +--- PASS: TestPublishTargetsDelegationNoTargetsKeyNeeded (0.58s) === RUN TestPublishTargetsDelegationSuccessNeedsToDownloadRoles ---- PASS: TestPublishTargetsDelegationSuccessNeedsToDownloadRoles (0.64s) +--- PASS: TestPublishTargetsDelegationSuccessNeedsToDownloadRoles (0.60s) === RUN TestPublishTargetsDelegationFromTwoRepos ---- PASS: TestPublishTargetsDelegationFromTwoRepos (0.61s) +--- PASS: TestPublishTargetsDelegationFromTwoRepos (0.42s) === RUN TestPublishRemoveDelegationKeyFromDelegationRole -time="2025-05-16T04:10:27Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2025-05-16T04:10:27Z" 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: 0bf0649a2936ed6369cd9cbf8c6c18269b0f457d5f681efe02be9856c0346623" ---- PASS: TestPublishRemoveDelegationKeyFromDelegationRole (0.44s) +time="2024-04-12T21:51:24Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2024-04-12T21:51:24Z" 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: f7e3b3c53b744060c2b9a5ea0b75fb271722ba4ee7d6502412e6af16fef9ee4a" +--- PASS: TestPublishRemoveDelegationKeyFromDelegationRole (0.33s) === RUN TestPublishRemoveDelegation -time="2025-05-16T04:10:27Z" 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-05-16T04:10:27Z" 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-05-16T04:10:27Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2025-05-16T04:10:27Z" 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.36s) +time="2024-04-12T21:51:25Z" 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-04-12T21:51:25Z" 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-04-12T21:51:25Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2024-04-12T21:51:25Z" 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.27s) === RUN TestPublishSucceedsDespiteDelegationCorrupt ---- PASS: TestPublishSucceedsDespiteDelegationCorrupt (0.53s) +--- PASS: TestPublishSucceedsDespiteDelegationCorrupt (0.40s) === RUN TestRotateKeyInvalidRole ---- PASS: TestRotateKeyInvalidRole (0.29s) +--- PASS: TestRotateKeyInvalidRole (0.20s) === RUN TestRemoteRotationError --- PASS: TestRemoteRotationError (0.06s) === RUN TestRemoteRotationEndpointError ---- PASS: TestRemoteRotationEndpointError (0.19s) +--- PASS: TestRemoteRotationEndpointError (0.14s) === RUN TestRemoteRotationNoRootKey ---- PASS: TestRemoteRotationNoRootKey (0.21s) +--- PASS: TestRemoteRotationNoRootKey (0.22s) === RUN TestRemoteRotationNoInit -time="2025-05-16T04:10:28Z" level=info msg="No TUF data found locally or remotely - initializing repository docker.com/notary for the first time" ---- PASS: TestRemoteRotationNoInit (0.13s) +time="2024-04-12T21:51:26Z" level=info msg="No TUF data found locally or remotely - initializing repository docker.com/notary for the first time" +--- PASS: TestRemoteRotationNoInit (0.17s) === RUN TestRotateBeforePublishFromRemoteKeyToLocalKey ---- PASS: TestRotateBeforePublishFromRemoteKeyToLocalKey (0.74s) +--- PASS: TestRotateBeforePublishFromRemoteKeyToLocalKey (0.68s) === RUN TestRotateKeyAfterPublishNoServerManagementChange ---- PASS: TestRotateKeyAfterPublishNoServerManagementChange (1.95s) +--- PASS: TestRotateKeyAfterPublishNoServerManagementChange (1.72s) === RUN TestRotateKeyAfterPublishServerManagementChange ---- PASS: TestRotateKeyAfterPublishServerManagementChange (2.21s) +--- PASS: TestRotateKeyAfterPublishServerManagementChange (1.97s) === RUN TestRotateRootKey ---- PASS: TestRotateRootKey (0.63s) +--- PASS: TestRotateRootKey (0.50s) === RUN TestRotateRootMultiple ---- PASS: TestRotateRootMultiple (0.88s) +--- PASS: TestRotateRootMultiple (0.66s) === RUN TestRotateRootKeyProvided ---- PASS: TestRotateRootKeyProvided (0.65s) +--- PASS: TestRotateRootKeyProvided (0.46s) === RUN TestRotateRootKeyLegacySupport ---- PASS: TestRotateRootKeyLegacySupport (0.96s) +--- PASS: TestRotateRootKeyLegacySupport (0.69s) === RUN TestRemoteServerUnavailableNoLocalCache -time="2025-05-16T04:10:37Z" level=error msg="Could not publish Repository since we could not update: unable to reach trust server at this time: 500." +time="2024-04-12T21:51:32Z" 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) === RUN TestAddDelegationChangefileValid ---- PASS: TestAddDelegationChangefileValid (0.07s) +--- PASS: TestAddDelegationChangefileValid (0.05s) === RUN TestAddDelegationChangefileApplicable ---- PASS: TestAddDelegationChangefileApplicable (0.06s) +--- PASS: TestAddDelegationChangefileApplicable (0.05s) === RUN TestAddDelegationErrorWritingChanges ---- PASS: TestAddDelegationErrorWritingChanges (0.06s) +--- PASS: TestAddDelegationErrorWritingChanges (0.05s) === RUN TestRemoveDelegationChangefileValid ---- PASS: TestRemoveDelegationChangefileValid (0.06s) +--- PASS: TestRemoveDelegationChangefileValid (0.05s) === RUN TestRemoveDelegationChangefileApplicable -time="2025-05-16T04:10:37Z" 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-05-16T04:10:37Z" 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.08s) +time="2024-04-12T21:51:33Z" 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-04-12T21:51:33Z" 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.06s) +--- PASS: TestClearAllPathsDelegationChangefileApplicable (0.05s) === RUN TestFullAddDelegationChangefileApplicable ---- PASS: TestFullAddDelegationChangefileApplicable (0.07s) +--- PASS: TestFullAddDelegationChangefileApplicable (0.05s) === RUN TestFullRemoveDelegationChangefileApplicable ---- PASS: TestFullRemoveDelegationChangefileApplicable (0.08s) +--- PASS: TestFullRemoveDelegationChangefileApplicable (0.05s) === RUN TestRemoveDelegationErrorWritingChanges ---- PASS: TestRemoveDelegationErrorWritingChanges (0.06s) +--- PASS: TestRemoveDelegationErrorWritingChanges (0.05s) === RUN TestClientInvalidURL --- PASS: TestClientInvalidURL (0.00s) === RUN TestPublishTargetsDelegationCanUseUserKeyWithArbitraryRole ---- PASS: TestPublishTargetsDelegationCanUseUserKeyWithArbitraryRole (1.19s) +--- PASS: TestPublishTargetsDelegationCanUseUserKeyWithArbitraryRole (0.86s) === RUN TestDeleteRepo ---- PASS: TestDeleteRepo (0.12s) +--- PASS: TestDeleteRepo (0.08s) === RUN TestDeleteRemoteRepo ---- PASS: TestDeleteRemoteRepo (0.32s) +--- PASS: TestDeleteRemoteRepo (0.25s) === RUN TestListRoles ---- PASS: TestListRoles (0.82s) +--- PASS: TestListRoles (0.63s) === RUN TestGetAllTargetInfo ---- PASS: TestGetAllTargetInfo (0.59s) +--- PASS: TestGetAllTargetInfo (0.40s) === RUN TestUpdateSucceedsEvenIfCannotWriteNewRepo -time="2025-05-16T04:10:40Z" level=error msg="could not save root to cache: Non-writable" ---- PASS: TestUpdateSucceedsEvenIfCannotWriteNewRepo (0.49s) +time="2024-04-12T21:51:35Z" level=error msg="could not save root to cache: Non-writable" +--- PASS: TestUpdateSucceedsEvenIfCannotWriteNewRepo (0.32s) === RUN TestUpdateSucceedsEvenIfCannotWriteExistingRepo ---- PASS: TestUpdateSucceedsEvenIfCannotWriteExistingRepo (2.01s) +--- PASS: TestUpdateSucceedsEvenIfCannotWriteExistingRepo (1.42s) === RUN TestUpdateInOfflineMode -time="2025-05-16T04:10:43Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" -time="2025-05-16T04:10:43Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" ---- PASS: TestUpdateInOfflineMode (0.18s) +time="2024-04-12T21:51:37Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" +time="2024-04-12T21:51:37Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" +--- PASS: TestUpdateInOfflineMode (0.14s) === RUN TestUpdateReplacesCorruptOrMissingMetadata -time="2025-05-16T04:10:44Z" level=error msg="Metadata for root expired" -time="2025-05-16T04:10:44Z" level=error msg="Metadata for root expired" ---- PASS: TestUpdateReplacesCorruptOrMissingMetadata (3.88s) +time="2024-04-12T21:51:39Z" level=error msg="Metadata for root expired" +time="2024-04-12T21:51:39Z" level=error msg="Metadata for root expired" +--- PASS: TestUpdateReplacesCorruptOrMissingMetadata (2.83s) === RUN TestUpdateFailsIfServerRootKeyChangedWithoutMultiSign -time="2025-05-16T04:10:47Z" level=error msg="Metadata for root expired" -time="2025-05-16T04:10:47Z" level=error msg="Metadata for root expired" ---- PASS: TestUpdateFailsIfServerRootKeyChangedWithoutMultiSign (0.32s) +time="2024-04-12T21:51:40Z" level=error msg="Metadata for root expired" +time="2024-04-12T21:51:40Z" level=error msg="Metadata for root expired" +--- PASS: TestUpdateFailsIfServerRootKeyChangedWithoutMultiSign (0.25s) === RUN TestUpdateRemoteRootNotExistNoLocalCache ---- PASS: TestUpdateRemoteRootNotExistNoLocalCache (0.18s) +--- PASS: TestUpdateRemoteRootNotExistNoLocalCache (0.13s) === RUN TestUpdateRemoteRootNotExistCanUseLocalCache ---- PASS: TestUpdateRemoteRootNotExistCanUseLocalCache (0.32s) +--- PASS: TestUpdateRemoteRootNotExistCanUseLocalCache (0.25s) === RUN TestUpdateRemoteRootNotExistCannotUseLocalCache ---- PASS: TestUpdateRemoteRootNotExistCannotUseLocalCache (0.36s) +--- PASS: TestUpdateRemoteRootNotExistCannotUseLocalCache (0.27s) === RUN TestUpdateRemoteRoot50XNoLocalCache ---- PASS: TestUpdateRemoteRoot50XNoLocalCache (0.17s) +--- PASS: TestUpdateRemoteRoot50XNoLocalCache (0.13s) === RUN TestUpdateRemoteRoot50XCanUseLocalCache ---- PASS: TestUpdateRemoteRoot50XCanUseLocalCache (0.34s) +--- PASS: TestUpdateRemoteRoot50XCanUseLocalCache (0.25s) === RUN TestUpdateRemoteRoot50XCannotUseLocalCache ---- PASS: TestUpdateRemoteRoot50XCannotUseLocalCache (0.35s) +--- PASS: TestUpdateRemoteRoot50XCannotUseLocalCache (0.27s) === RUN TestUpdateNonRootRemoteMissingMetadataNoLocalCache ---- PASS: TestUpdateNonRootRemoteMissingMetadataNoLocalCache (0.86s) +--- PASS: TestUpdateNonRootRemoteMissingMetadataNoLocalCache (0.65s) === RUN TestUpdateNonRootRemoteMissingMetadataCanUseLocalCache -time="2025-05-16T04:10:50Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" ---- PASS: TestUpdateNonRootRemoteMissingMetadataCanUseLocalCache (1.14s) +time="2024-04-12T21:51:42Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" +--- PASS: TestUpdateNonRootRemoteMissingMetadataCanUseLocalCache (0.84s) === RUN TestUpdateNonRootRemoteMissingMetadataCannotUseLocalCache -time="2025-05-16T04:10:51Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" ---- PASS: TestUpdateNonRootRemoteMissingMetadataCannotUseLocalCache (1.37s) +time="2024-04-12T21:51:43Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" +--- PASS: TestUpdateNonRootRemoteMissingMetadataCannotUseLocalCache (1.02s) === RUN TestUpdateNonRootRemote50XNoLocalCache ---- PASS: TestUpdateNonRootRemote50XNoLocalCache (0.87s) +--- PASS: TestUpdateNonRootRemote50XNoLocalCache (0.65s) === RUN TestUpdateNonRootRemote50XCanUseLocalCache -time="2025-05-16T04:10:54Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" ---- PASS: TestUpdateNonRootRemote50XCanUseLocalCache (1.14s) +time="2024-04-12T21:51:45Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" +--- PASS: TestUpdateNonRootRemote50XCanUseLocalCache (0.86s) === RUN TestUpdateNonRootRemote50XCannotUseLocalCache -time="2025-05-16T04:10:55Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" ---- PASS: TestUpdateNonRootRemote50XCannotUseLocalCache (1.39s) +time="2024-04-12T21:51:46Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" +--- PASS: TestUpdateNonRootRemote50XCannotUseLocalCache (1.02s) === RUN TestUpdateRemoteChecksumWrongNoLocalCache ---- PASS: TestUpdateRemoteChecksumWrongNoLocalCache (0.74s) +--- PASS: TestUpdateRemoteChecksumWrongNoLocalCache (0.83s) === RUN TestUpdateRemoteChecksumWrongCanUseLocalCache ---- PASS: TestUpdateRemoteChecksumWrongCanUseLocalCache (0.95s) +--- PASS: TestUpdateRemoteChecksumWrongCanUseLocalCache (1.14s) === RUN TestUpdateRemoteChecksumWrongCannotUseLocalCache ---- PASS: TestUpdateRemoteChecksumWrongCannotUseLocalCache (1.01s) +--- PASS: TestUpdateRemoteChecksumWrongCannotUseLocalCache (1.38s) === RUN TestUpdateRootRemoteCorruptedNoLocalCache -time="2025-05-16T04:10:59Z" level=error msg="Metadata for root expired" -time="2025-05-16T04:10:59Z" level=error msg="Metadata for root expired" ---- PASS: TestUpdateRootRemoteCorruptedNoLocalCache (1.96s) +time="2024-04-12T21:51:51Z" level=error msg="Metadata for root expired" +time="2024-04-12T21:51:51Z" level=error msg="Metadata for root expired" +--- PASS: TestUpdateRootRemoteCorruptedNoLocalCache (2.71s) === RUN TestUpdateRootRemoteCorruptedCanUseLocalCache ---- PASS: TestUpdateRootRemoteCorruptedCanUseLocalCache (3.57s) +--- PASS: TestUpdateRootRemoteCorruptedCanUseLocalCache (4.96s) === RUN TestUpdateRootRemoteCorruptedCannotUseLocalCache -time="2025-05-16T04:11:06Z" level=error msg="Metadata for root expired" -time="2025-05-16T04:11:06Z" level=error msg="Metadata for root expired" ---- PASS: TestUpdateRootRemoteCorruptedCannotUseLocalCache (3.84s) +time="2024-04-12T21:52:00Z" level=error msg="Metadata for root expired" +time="2024-04-12T21:52:00Z" level=error msg="Metadata for root expired" +--- PASS: TestUpdateRootRemoteCorruptedCannotUseLocalCache (5.58s) === RUN TestUpdateNonRootRemoteCorruptedNoLocalCache -time="2025-05-16T04:11:08Z" level=error msg="Metadata for targets expired" -time="2025-05-16T04:11:08Z" level=error msg="Metadata for targets expired" -time="2025-05-16T04:11:09Z" level=error msg="Metadata for snapshot expired" -time="2025-05-16T04:11:09Z" level=error msg="Metadata for snapshot expired" -time="2025-05-16T04:11:10Z" level=error msg="Metadata for timestamp expired" -time="2025-05-16T04:11:10Z" level=error msg="Metadata for timestamp expired" -time="2025-05-16T04:11:10Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2025-05-16T04:11:10Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2025-05-16T04:11:10Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2025-05-16T04:11:10Z" level=error msg="Metadata for targets/a expired" -time="2025-05-16T04:11:10Z" level=warning msg="Error getting targets/a: targets/a expired at Mon Apr 15 04:11:10 UTC 2024" -time="2025-05-16T04:11:11Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" -time="2025-05-16T04:11:11Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" -time="2025-05-16T04:11:11Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" -time="2025-05-16T04:11:11Z" level=error msg="Metadata for targets/a/b expired" -time="2025-05-16T04:11:11Z" level=warning msg="Error getting targets/a/b: targets/a/b expired at Mon Apr 15 04:11:11 UTC 2024" -time="2025-05-16T04:11:12Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" -time="2025-05-16T04:11:12Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" -time="2025-05-16T04:11:12Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" -time="2025-05-16T04:11:12Z" level=error msg="Metadata for targets/b expired" -time="2025-05-16T04:11:12Z" level=warning msg="Error getting targets/b: targets/b expired at Mon Apr 15 04:11:12 UTC 2024" ---- PASS: TestUpdateNonRootRemoteCorruptedNoLocalCache (4.68s) +time="2024-04-12T21:52:04Z" level=error msg="Metadata for targets expired" +time="2024-04-12T21:52:04Z" level=error msg="Metadata for targets expired" +time="2024-04-12T21:52:05Z" level=error msg="Metadata for snapshot expired" +time="2024-04-12T21:52:05Z" level=error msg="Metadata for snapshot expired" +time="2024-04-12T21:52:06Z" level=error msg="Metadata for timestamp expired" +time="2024-04-12T21:52:06Z" level=error msg="Metadata for timestamp expired" +time="2024-04-12T21:52:07Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2024-04-12T21:52:07Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2024-04-12T21:52:07Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2024-04-12T21:52:07Z" level=error msg="Metadata for targets/a expired" +time="2024-04-12T21:52:07Z" level=warning msg="Error getting targets/a: targets/a expired at Sat Mar 11 21:52:07 UTC 2023" +time="2024-04-12T21:52:08Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" +time="2024-04-12T21:52:08Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" +time="2024-04-12T21:52:08Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" +time="2024-04-12T21:52:08Z" level=error msg="Metadata for targets/a/b expired" +time="2024-04-12T21:52:08Z" level=warning msg="Error getting targets/a/b: targets/a/b expired at Sat Mar 11 21:52:08 UTC 2023" +time="2024-04-12T21:52:09Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" +time="2024-04-12T21:52:09Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" +time="2024-04-12T21:52:09Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" +time="2024-04-12T21:52:09Z" level=error msg="Metadata for targets/b expired" +time="2024-04-12T21:52:09Z" level=warning msg="Error getting targets/b: targets/b expired at Sat Mar 11 21:52:09 UTC 2023" +--- PASS: TestUpdateNonRootRemoteCorruptedNoLocalCache (6.87s) === RUN TestUpdateNonRootRemoteCorruptedCanUseLocalCache -time="2025-05-16T04:11:15Z" level=error msg="Metadata for timestamp expired" -time="2025-05-16T04:11:15Z" level=error msg="Metadata for timestamp expired" ---- PASS: TestUpdateNonRootRemoteCorruptedCanUseLocalCache (6.66s) +time="2024-04-12T21:52:14Z" level=error msg="Metadata for timestamp expired" +time="2024-04-12T21:52:14Z" level=error msg="Metadata for timestamp expired" +--- PASS: TestUpdateNonRootRemoteCorruptedCanUseLocalCache (8.79s) === RUN TestUpdateNonRootRemoteCorruptedCannotUseLocalCache -time="2025-05-16T04:11:20Z" level=error msg="Metadata for targets expired" -time="2025-05-16T04:11:22Z" level=error msg="Metadata for snapshot expired" -time="2025-05-16T04:11:22Z" level=error msg="Metadata for snapshot expired" -time="2025-05-16T04:11:23Z" level=error msg="Metadata for timestamp expired" -time="2025-05-16T04:11:23Z" level=error msg="Metadata for timestamp expired" -time="2025-05-16T04:11:24Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2025-05-16T04:11:24Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2025-05-16T04:11:24Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2025-05-16T04:11:24Z" level=error msg="Metadata for targets/a expired" -time="2025-05-16T04:11:24Z" level=warning msg="Error getting targets/a: targets/a expired at Mon Apr 15 04:11:24 UTC 2024" -time="2025-05-16T04:11:25Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" -time="2025-05-16T04:11:25Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" -time="2025-05-16T04:11:25Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" -time="2025-05-16T04:11:25Z" level=error msg="Metadata for targets/a/b expired" -time="2025-05-16T04:11:25Z" level=warning msg="Error getting targets/a/b: targets/a/b expired at Mon Apr 15 04:11:25 UTC 2024" -time="2025-05-16T04:11:26Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" -time="2025-05-16T04:11:26Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" -time="2025-05-16T04:11:27Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" -time="2025-05-16T04:11:27Z" level=error msg="Metadata for targets/b expired" -time="2025-05-16T04:11:27Z" level=warning msg="Error getting targets/b: targets/b expired at Mon Apr 15 04:11:27 UTC 2024" ---- PASS: TestUpdateNonRootRemoteCorruptedCannotUseLocalCache (8.32s) +time="2024-04-12T21:52:20Z" level=error msg="Metadata for targets expired" +time="2024-04-12T21:52:22Z" level=error msg="Metadata for snapshot expired" +time="2024-04-12T21:52:22Z" level=error msg="Metadata for snapshot expired" +time="2024-04-12T21:52:23Z" level=error msg="Metadata for timestamp expired" +time="2024-04-12T21:52:23Z" level=error msg="Metadata for timestamp expired" +time="2024-04-12T21:52:24Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2024-04-12T21:52:25Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2024-04-12T21:52:25Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2024-04-12T21:52:25Z" level=error msg="Metadata for targets/a expired" +time="2024-04-12T21:52:25Z" level=warning msg="Error getting targets/a: targets/a expired at Sat Mar 11 21:52:25 UTC 2023" +time="2024-04-12T21:52:26Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" +time="2024-04-12T21:52:26Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" +time="2024-04-12T21:52:27Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" +time="2024-04-12T21:52:27Z" level=error msg="Metadata for targets/a/b expired" +time="2024-04-12T21:52:27Z" level=warning msg="Error getting targets/a/b: targets/a/b expired at Sat Mar 11 21:52:27 UTC 2023" +time="2024-04-12T21:52:28Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" +time="2024-04-12T21:52:28Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" +time="2024-04-12T21:52:29Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" +time="2024-04-12T21:52:29Z" level=error msg="Metadata for targets/b expired" +time="2024-04-12T21:52:29Z" level=warning msg="Error getting targets/b: targets/b expired at Sat Mar 11 21:52:29 UTC 2023" +--- PASS: TestUpdateNonRootRemoteCorruptedCannotUseLocalCache (10.99s) === RUN TestUpdateLocalAndRemoteRootCorrupt -time="2025-05-16T04:11:30Z" level=error msg="Metadata for root expired" -time="2025-05-16T04:11:31Z" level=error msg="Metadata for root expired" -time="2025-05-16T04:11:34Z" level=error msg="Metadata for root expired" -time="2025-05-16T04:11:34Z" level=error msg="Metadata for root expired" -time="2025-05-16T04:11:34Z" level=error msg="Metadata for root expired" -time="2025-05-16T04:11:34Z" level=error msg="Metadata for root expired" -time="2025-05-16T04:11:34Z" level=error msg="Metadata for root expired" -time="2025-05-16T04:11:34Z" level=error msg="Metadata for root expired" -time="2025-05-16T04:11:34Z" level=error msg="Metadata for root expired" -time="2025-05-16T04:11:35Z" level=error msg="Metadata for root expired" -time="2025-05-16T04:11:35Z" level=error msg="Metadata for root expired" -time="2025-05-16T04:11:35Z" level=error msg="Metadata for root expired" -time="2025-05-16T04:11:35Z" level=error msg="Metadata for root expired" -time="2025-05-16T04:11:35Z" level=error msg="Metadata for root expired" -time="2025-05-16T04:11:35Z" level=error msg="Metadata for root expired" -time="2025-05-16T04:11:35Z" level=error msg="Metadata for root expired" -time="2025-05-16T04:11:35Z" level=error msg="Metadata for root expired" -time="2025-05-16T04:11:35Z" level=error msg="Metadata for root expired" -time="2025-05-16T04:11:35Z" level=error msg="Metadata for root expired" -time="2025-05-16T04:11:35Z" level=error msg="Metadata for root expired" -time="2025-05-16T04:11:36Z" level=error msg="Metadata for root expired" -time="2025-05-16T04:11:36Z" level=error msg="Metadata for root expired" ---- PASS: TestUpdateLocalAndRemoteRootCorrupt (8.27s) +time="2024-04-12T21:52:35Z" level=error msg="Metadata for root expired" +time="2024-04-12T21:52:35Z" level=error msg="Metadata for root expired" +time="2024-04-12T21:52:40Z" level=error msg="Metadata for root expired" +time="2024-04-12T21:52:40Z" level=error msg="Metadata for root expired" +time="2024-04-12T21:52:40Z" level=error msg="Metadata for root expired" +time="2024-04-12T21:52:40Z" level=error msg="Metadata for root expired" +time="2024-04-12T21:52:40Z" level=error msg="Metadata for root expired" +time="2024-04-12T21:52:40Z" level=error msg="Metadata for root expired" +time="2024-04-12T21:52:40Z" level=error msg="Metadata for root expired" +time="2024-04-12T21:52:40Z" level=error msg="Metadata for root expired" +time="2024-04-12T21:52:41Z" level=error msg="Metadata for root expired" +time="2024-04-12T21:52:41Z" level=error msg="Metadata for root expired" +time="2024-04-12T21:52:41Z" level=error msg="Metadata for root expired" +time="2024-04-12T21:52:41Z" level=error msg="Metadata for root expired" +time="2024-04-12T21:52:41Z" level=error msg="Metadata for root expired" +time="2024-04-12T21:52:41Z" level=error msg="Metadata for root expired" +time="2024-04-12T21:52:41Z" level=error msg="Metadata for root expired" +time="2024-04-12T21:52:42Z" level=error msg="Metadata for root expired" +time="2024-04-12T21:52:42Z" level=error msg="Metadata for root expired" +time="2024-04-12T21:52:42Z" level=error msg="Metadata for root expired" +time="2024-04-12T21:52:42Z" level=error msg="Metadata for root expired" +time="2024-04-12T21:52:42Z" level=error msg="Metadata for root expired" +--- PASS: TestUpdateLocalAndRemoteRootCorrupt (12.21s) === RUN TestUpdateRemoteKeyRotated -time="2025-05-16T04:11:36Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2025-05-16T04:11:36Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" -time="2025-05-16T04:11:36Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" ---- PASS: TestUpdateRemoteKeyRotated (0.80s) +time="2024-04-12T21:52:43Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2024-04-12T21:52:43Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" +time="2024-04-12T21:52:43Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" +--- PASS: TestUpdateRemoteKeyRotated (1.10s) === RUN TestValidateRootRotationWithOldRole ---- PASS: TestValidateRootRotationWithOldRole (0.36s) +--- PASS: TestValidateRootRotationWithOldRole (0.50s) === RUN TestRootRoleInvariant ---- PASS: TestRootRoleInvariant (0.34s) +--- PASS: TestRootRoleInvariant (0.45s) === RUN TestBadIntermediateTransitions ---- PASS: TestBadIntermediateTransitions (0.13s) +--- PASS: TestBadIntermediateTransitions (0.18s) === RUN TestExpiredIntermediateTransitions -time="2025-05-16T04:11:37Z" level=warning msg="root is nearing expiry, you should re-sign the role metadata" ---- PASS: TestExpiredIntermediateTransitions (0.16s) +time="2024-04-12T21:52:44Z" level=warning msg="root is nearing expiry, you should re-sign the role metadata" +--- PASS: TestExpiredIntermediateTransitions (0.22s) === RUN TestDownloadTargetsLarge ---- PASS: TestDownloadTargetsLarge (3.34s) +--- PASS: TestDownloadTargetsLarge (4.74s) === RUN TestDownloadTargetsDeep ---- PASS: TestDownloadTargetsDeep (0.11s) +--- PASS: TestDownloadTargetsDeep (0.15s) === RUN TestDownloadSnapshotLargeDelegationsMany ---- PASS: TestDownloadSnapshotLargeDelegationsMany (3.27s) +--- PASS: TestDownloadSnapshotLargeDelegationsMany (4.84s) === RUN TestRootOnDiskTrustPinning ---- PASS: TestRootOnDiskTrustPinning (0.08s) +--- PASS: TestRootOnDiskTrustPinning (0.11s) === RUN TestLoadTUFRepoBadURL --- PASS: TestLoadTUFRepoBadURL (0.00s) === RUN TestApplyTargetsChange ---- PASS: TestApplyTargetsChange (0.01s) +--- PASS: TestApplyTargetsChange (0.02s) === RUN TestApplyAddTargetTwice ---- PASS: TestApplyAddTargetTwice (0.01s) +--- PASS: TestApplyAddTargetTwice (0.02s) === RUN TestApplyChangelist ---- PASS: TestApplyChangelist (0.01s) +--- PASS: TestApplyChangelist (0.02s) === RUN TestApplyChangelistMulti ---- PASS: TestApplyChangelistMulti (0.01s) +--- PASS: TestApplyChangelistMulti (0.02s) === RUN TestApplyTargetsDelegationCreateDelete ---- PASS: TestApplyTargetsDelegationCreateDelete (0.01s) +--- PASS: TestApplyTargetsDelegationCreateDelete (0.02s) === RUN TestApplyTargetsDelegationCreate2SharedKey ---- PASS: TestApplyTargetsDelegationCreate2SharedKey (0.01s) +--- PASS: TestApplyTargetsDelegationCreate2SharedKey (0.02s) === RUN TestApplyTargetsDelegationCreateEdit ---- PASS: TestApplyTargetsDelegationCreateEdit (0.01s) +--- PASS: TestApplyTargetsDelegationCreateEdit (0.02s) === RUN TestApplyTargetsDelegationEditNonExisting ---- PASS: TestApplyTargetsDelegationEditNonExisting (0.01s) +--- PASS: TestApplyTargetsDelegationEditNonExisting (0.02s) === RUN TestApplyTargetsDelegationCreateAlreadyExisting ---- PASS: TestApplyTargetsDelegationCreateAlreadyExisting (0.01s) +--- PASS: TestApplyTargetsDelegationCreateAlreadyExisting (0.02s) === RUN TestApplyTargetsDelegationAlreadyExistingMergePaths ---- PASS: TestApplyTargetsDelegationAlreadyExistingMergePaths (0.01s) +--- PASS: TestApplyTargetsDelegationAlreadyExistingMergePaths (0.02s) === RUN TestApplyTargetsDelegationInvalidRole ---- PASS: TestApplyTargetsDelegationInvalidRole (0.01s) +--- PASS: TestApplyTargetsDelegationInvalidRole (0.02s) === RUN TestApplyTargetsDelegationInvalidJSONContent ---- PASS: TestApplyTargetsDelegationInvalidJSONContent (0.01s) +--- PASS: TestApplyTargetsDelegationInvalidJSONContent (0.02s) === RUN TestApplyTargetsDelegationInvalidAction ---- PASS: TestApplyTargetsDelegationInvalidAction (0.01s) +--- PASS: TestApplyTargetsDelegationInvalidAction (0.02s) === RUN TestApplyTargetsChangeInvalidType ---- PASS: TestApplyTargetsChangeInvalidType (0.01s) +--- PASS: TestApplyTargetsChangeInvalidType (0.02s) === RUN TestApplyTargetsDelegationCreate2Deep ---- PASS: TestApplyTargetsDelegationCreate2Deep (0.01s) +--- PASS: TestApplyTargetsDelegationCreate2Deep (0.02s) === RUN TestApplyTargetsDelegationParentDoesntExist ---- PASS: TestApplyTargetsDelegationParentDoesntExist (0.01s) +--- PASS: TestApplyTargetsDelegationParentDoesntExist (0.02s) === RUN TestApplyChangelistCreatesDelegation ---- PASS: TestApplyChangelistCreatesDelegation (0.01s) +--- PASS: TestApplyChangelistCreatesDelegation (0.02s) === RUN TestApplyChangelistTargetsToMultipleRoles ---- PASS: TestApplyChangelistTargetsToMultipleRoles (0.01s) +--- PASS: TestApplyChangelistTargetsToMultipleRoles (0.02s) === RUN TestApplyChangelistTargetsFailsNonexistentRole -time="2025-05-16T04:11:44Z" 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-05-16T04:11:44Z" 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) +time="2024-04-12T21:52:54Z" 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-04-12T21:52:54Z" 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.02s) === RUN TestChangeTargetMetaFailsInvalidRole -time="2025-05-16T04:11:44Z" level=error msg="couldn't add target to ruhroh: tuf: invalid role ruhroh. does not exist" ---- PASS: TestChangeTargetMetaFailsInvalidRole (0.01s) +time="2024-04-12T21:52:55Z" level=error msg="couldn't add target to ruhroh: tuf: invalid role ruhroh. does not exist" +--- PASS: TestChangeTargetMetaFailsInvalidRole (0.02s) === RUN TestChangeTargetMetaFailsIfPrefixError -time="2025-05-16T04:11:44Z" level=error msg="couldn't add target to targets/level1: Could not add all targets" ---- PASS: TestChangeTargetMetaFailsIfPrefixError (0.01s) +time="2024-04-12T21:52:55Z" level=error msg="couldn't add target to targets/level1: Could not add all targets" +--- PASS: TestChangeTargetMetaFailsIfPrefixError (0.02s) === RUN TestAllNearExpiry ---- PASS: TestAllNearExpiry (0.01s) +--- PASS: TestAllNearExpiry (0.02s) === RUN TestAllNotNearExpiry ---- PASS: TestAllNotNearExpiry (0.01s) +--- PASS: TestAllNotNearExpiry (0.02s) === RUN TestRotateRemoteKeyOffline --- PASS: TestRotateRemoteKeyOffline (0.00s) PASS -ok github.com/theupdateframework/notary/client 99.473s +ok github.com/theupdateframework/notary/client 105.024s === RUN TestTUFDelegation ---- PASS: TestTUFDelegation (0.05s) +--- PASS: TestTUFDelegation (0.03s) === RUN TestMemChangelist --- PASS: TestMemChangelist (0.00s) === RUN TestMemChangeIterator @@ -2227,14 +2263,14 @@ === RUN TestAdd --- PASS: TestAdd (0.00s) === RUN TestErrorConditions -time="2025-05-16T04:10:05Z" level=warning msg="invalid character '\\x05' looking for beginning of value" +time="2024-04-12T21:51:10Z" 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.096s +ok github.com/theupdateframework/notary/client/changelist 0.040s === RUN TestParseConfigError --- PASS: TestParseConfigError (0.00s) === RUN TestSetupGRPCServer @@ -2244,7 +2280,7 @@ === RUN TestSetupNetListener --- PASS: TestSetupNetListener (0.00s) PASS -ok github.com/theupdateframework/notary/cmd/escrow 0.017s +ok github.com/theupdateframework/notary/cmd/escrow 0.007s === RUN TestPurgeDelegationKeys Usage: delegation [command] @@ -2272,7 +2308,7 @@ === RUN TestAddInvalidDelegationName --- PASS: TestAddInvalidDelegationName (0.02s) === RUN TestAddInvalidDelegationCert ---- PASS: TestAddInvalidDelegationCert (0.03s) +--- PASS: TestAddInvalidDelegationCert (0.01s) === RUN TestAddInvalidShortPubkeyCert --- PASS: TestAddInvalidShortPubkeyCert (0.01s) === RUN TestRemoveInvalidDelegationName @@ -2316,75 +2352,75 @@ Use "delegation [command] --help" for more information about a command. --- PASS: TestRemoveInvalidNumArgs (0.00s) === RUN TestInitWithRootKey ---- PASS: TestInitWithRootKey (0.61s) +--- PASS: TestInitWithRootKey (0.26s) === RUN TestInitWithRootCert ---- PASS: TestInitWithRootCert (0.44s) +--- PASS: TestInitWithRootCert (0.23s) === RUN TestClientTUFInteraction ---- PASS: TestClientTUFInteraction (1.25s) +--- PASS: TestClientTUFInteraction (0.63s) === RUN TestClientDeleteTUFInteraction -time="2025-05-16T04:10:08Z" 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]:46782->[::1]:53: read: connection refused" ---- PASS: TestClientDeleteTUFInteraction (1.31s) +time="2024-04-12T21:51:13Z" 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]:33223->[::1]:53: read: connection refused" +--- PASS: TestClientDeleteTUFInteraction (0.65s) === RUN TestClientTUFAddByHashInteraction ---- PASS: TestClientTUFAddByHashInteraction (2.38s) +--- PASS: TestClientTUFAddByHashInteraction (1.03s) === RUN TestClientDelegationsInteraction -time="2025-05-16T04:10:12Z" 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-05-16T04:10:12Z" 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 (3.36s) +time="2024-04-12T21:51:15Z" 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-04-12T21:51:15Z" 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.24s) === RUN TestClientDelegationsPublishing ---- PASS: TestClientDelegationsPublishing (3.15s) +--- PASS: TestClientDelegationsPublishing (2.28s) === RUN TestClientKeyGenerationRotation ---- PASS: TestClientKeyGenerationRotation (3.88s) +--- PASS: TestClientKeyGenerationRotation (2.99s) === RUN TestKeyRotation ---- PASS: TestKeyRotation (0.53s) +--- PASS: TestKeyRotation (0.36s) === RUN TestKeyRotationNonRoot ---- PASS: TestKeyRotationNonRoot (0.76s) +--- PASS: TestKeyRotationNonRoot (0.56s) === RUN TestDefaultRootKeyGeneration ---- PASS: TestDefaultRootKeyGeneration (0.02s) +--- PASS: TestDefaultRootKeyGeneration (0.01s) === RUN TestLogLevelFlags --- PASS: TestLogLevelFlags (0.00s) === RUN TestClientKeyPassphraseChange ---- PASS: TestClientKeyPassphraseChange (0.52s) +--- PASS: TestClientKeyPassphraseChange (0.45s) === RUN TestPurgeSingleKey Removal of the following keys from all delegations in gun staged for next publish: - - bd5d2098d07a136cced9e1e57077385be36d7ef103f5710ddae2d5318ddc1cea ---- PASS: TestPurgeSingleKey (0.57s) + - 54fddf785ecb893a8979770f94cbdab9dc0bf90c7c3230c126e8595c34192a8a +--- PASS: TestPurgeSingleKey (0.46s) === RUN TestWitness -time="2025-05-16T04:10:25Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" -time="2025-05-16T04:10:25Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" -time="2025-05-16T04:10:25Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" -time="2025-05-16T04:10:26Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" -time="2025-05-16T04:10:26Z" 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-05-16T04:10:26Z" 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-05-16T04:10:26Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" ---- PASS: TestWitness (2.15s) +time="2024-04-12T21:51:24Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" +time="2024-04-12T21:51:24Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" +time="2024-04-12T21:51:25Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" +time="2024-04-12T21:51:25Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" +time="2024-04-12T21:51:25Z" 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-04-12T21:51:25Z" 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-04-12T21:51:25Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" +--- PASS: TestWitness (1.45s) === RUN TestClientTUFInitWithAutoPublish -time="2025-05-16T04:10:26Z" 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]:56033->[::1]:53: read: connection refused" ---- PASS: TestClientTUFInitWithAutoPublish (0.39s) +time="2024-04-12T21:51:25Z" 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]:37263->[::1]:53: read: connection refused" +--- PASS: TestClientTUFInitWithAutoPublish (0.31s) === RUN TestClientTUFAddWithAutoPublish -time="2025-05-16T04:10:27Z" 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]:52301->[::1]:53: read: connection refused" -time="2025-05-16T04:10:27Z" level=error msg="Could not publish Repository since we could not update: client is offline" -time="2025-05-16T04:10:27Z" 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]:58426->[::1]:53: read: connection refused" -time="2025-05-16T04:10:27Z" level=error msg="Could not publish Repository since we could not update: client is offline" ---- PASS: TestClientTUFAddWithAutoPublish (0.49s) +time="2024-04-12T21:51:26Z" 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]:34361->[::1]:53: read: connection refused" +time="2024-04-12T21:51:26Z" level=error msg="Could not publish Repository since we could not update: client is offline" +time="2024-04-12T21:51:26Z" 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]:43083->[::1]:53: read: connection refused" +time="2024-04-12T21:51:26Z" level=error msg="Could not publish Repository since we could not update: client is offline" +--- PASS: TestClientTUFAddWithAutoPublish (0.42s) === RUN TestClientTUFRemoveWithAutoPublish ---- PASS: TestClientTUFRemoveWithAutoPublish (0.92s) +--- PASS: TestClientTUFRemoveWithAutoPublish (0.85s) === RUN TestClientDelegationAddWithAutoPublish ---- PASS: TestClientDelegationAddWithAutoPublish (0.41s) +--- PASS: TestClientDelegationAddWithAutoPublish (0.31s) === RUN TestClientDelegationRemoveWithAutoPublish -time="2025-05-16T04:10:29Z" 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-05-16T04:10:29Z" 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.81s) +time="2024-04-12T21:51:28Z" 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-04-12T21:51:28Z" 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.71s) === RUN TestClientTUFAddByHashWithAutoPublish ---- PASS: TestClientTUFAddByHashWithAutoPublish (0.46s) +--- PASS: TestClientTUFAddByHashWithAutoPublish (0.35s) === RUN TestClientKeyImport -time="2025-05-16T04:10:30Z" level=warning msg="failed to import key to store: Invalid key generated, key may be encrypted and does not contain path header" -time="2025-05-16T04:10:30Z" 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.14s) +time="2024-04-12T21:51:28Z" level=warning msg="failed to import key to store: Invalid key generated, key may be encrypted and does not contain path header" +time="2024-04-12T21:51:28Z" 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.12s) === RUN TestAddDelImportKeyPublishFlow -time="2025-05-16T04:10:30Z" 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.91s) +time="2024-04-12T21:51:29Z" 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.88s) === RUN TestExportImportFlow ---- PASS: TestExportImportFlow (0.24s) +--- PASS: TestExportImportFlow (0.22s) === RUN TestDelegationKeyImportExport --- PASS: TestDelegationKeyImportExport (0.01s) === RUN TestImportKeysNoYubikey @@ -2394,7 +2430,7 @@ === RUN TestRemoveIfNoKey --- PASS: TestRemoveIfNoKey (0.00s) === RUN TestRemoveOneKeyAbort ---- PASS: TestRemoveOneKeyAbort (0.04s) +--- PASS: TestRemoveOneKeyAbort (0.03s) === RUN TestRemoveOneKeyConfirm --- PASS: TestRemoveOneKeyConfirm (0.01s) === RUN TestRemoveMultikeysInvalidInput @@ -2404,16 +2440,16 @@ === RUN TestRemoveMultikeysRemoveOnlyChosenKey --- PASS: TestRemoveMultikeysRemoveOnlyChosenKey (0.01s) === RUN TestRotateKeyInvalidRoles -time="2025-05-16T04:10:31Z" 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]:51821->[::1]:53: read: connection refused" -time="2025-05-16T04:10:31Z" 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]:33751->[::1]:53: read: connection refused" -time="2025-05-16T04:10:31Z" 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]:57355->[::1]:53: read: connection refused" -time="2025-05-16T04:10:31Z" 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]:44641->[::1]:53: read: connection refused" +time="2024-04-12T21:51:29Z" 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]:42927->[::1]:53: read: connection refused" +time="2024-04-12T21:51:29Z" 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]:51601->[::1]:53: read: connection refused" +time="2024-04-12T21:51:29Z" 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]:54261->[::1]:53: read: connection refused" +time="2024-04-12T21:51:29Z" 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]:37366->[::1]:53: read: connection refused" --- PASS: TestRotateKeyInvalidRoles (0.00s) === RUN TestRotateKeyTargetCannotBeServerManaged -time="2025-05-16T04:10:31Z" 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]:40161->[::1]:53: read: connection refused" +time="2024-04-12T21:51:29Z" 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]:56649->[::1]:53: read: connection refused" --- PASS: TestRotateKeyTargetCannotBeServerManaged (0.00s) === RUN TestRotateKeyTimestampCannotBeLocallyManaged -time="2025-05-16T04:10:31Z" 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]:36490->[::1]:53: read: connection refused" +time="2024-04-12T21:51:29Z" 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]:33094->[::1]:53: read: connection refused" --- PASS: TestRotateKeyTimestampCannotBeLocallyManaged (0.00s) === RUN TestRotateKeyNoGUN Usage: @@ -2421,13 +2457,13 @@ === RUN TestRotateKeyRemoteServerManagesKey Successfully rotated snapshot key for repository docker.com/notary Successfully rotated timestamp key for repository docker.com/notary ---- PASS: TestRotateKeyRemoteServerManagesKey (0.41s) +--- PASS: TestRotateKeyRemoteServerManagesKey (0.33s) === RUN TestRotateKeyBothKeys Successfully rotated targets key for repository docker.com/notary Successfully rotated snapshot key for repository docker.com/notary ---- PASS: TestRotateKeyBothKeys (0.39s) +--- PASS: TestRotateKeyBothKeys (0.28s) === RUN TestRotateKeyRootIsInteractive ---- PASS: TestRotateKeyRootIsInteractive (0.11s) +--- PASS: TestRotateKeyRootIsInteractive (0.06s) === RUN TestChangeKeyPassphraseInvalidID --- PASS: TestChangeKeyPassphraseInvalidID (0.00s) === RUN TestChangeKeyPassphraseInvalidNumArgs @@ -2446,8 +2482,8 @@ === RUN TestImportKeysNonexistentFile --- PASS: TestImportKeysNonexistentFile (0.00s) === RUN TestKeyGeneration -time="2025-05-16T04:10:32Z" 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) +time="2024-04-12T21:51:30Z" 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.02s) === RUN TestNotaryConfigFileDefault --- PASS: TestNotaryConfigFileDefault (0.00s) === RUN TestRemoteServerDefault @@ -2457,19 +2493,19 @@ === RUN TestRemoteServerCommandLineFlagOverridesConfig --- PASS: TestRemoteServerCommandLineFlagOverridesConfig (0.00s) === RUN TestInvalidAddHashCommands ---- PASS: TestInvalidAddHashCommands (0.01s) +--- PASS: TestInvalidAddHashCommands (0.00s) === RUN TestConfigParsingErrorsPropagatedByCommands --- PASS: TestConfigParsingErrorsPropagatedByCommands (0.01s) === RUN TestInsufficientArgumentsReturnsErrorAndPrintsUsage ---- PASS: TestInsufficientArgumentsReturnsErrorAndPrintsUsage (0.02s) +--- PASS: TestInsufficientArgumentsReturnsErrorAndPrintsUsage (0.01s) === RUN TestBareCommandPrintsUsageAndNoError --- PASS: TestBareCommandPrintsUsageAndNoError (0.00s) === RUN TestConfigFileTLSCannotBeRelativeToCWD --- PASS: TestConfigFileTLSCannotBeRelativeToCWD (0.01s) === RUN TestConfigFileTLSCanBeRelativeToConfigOrAbsolute ---- PASS: TestConfigFileTLSCanBeRelativeToConfigOrAbsolute (0.15s) +--- PASS: TestConfigFileTLSCanBeRelativeToConfigOrAbsolute (0.11s) === RUN TestConfigFileOverridenByCmdLineFlags ---- PASS: TestConfigFileOverridenByCmdLineFlags (0.19s) +--- PASS: TestConfigFileOverridenByCmdLineFlags (0.12s) === RUN TestConfigFileTrustPinning --- PASS: TestConfigFileTrustPinning (0.00s) === RUN TestPassphraseRetrieverCaching @@ -2495,10 +2531,10 @@ === RUN TestImportRootCert --- PASS: TestImportRootCert (0.00s) === RUN TestTokenAuth -time="2025-05-16T04:10:32Z" 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-04-12T21:51:30Z" 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-05-16T04:10:32Z" 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-04-12T21:51:30Z" 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) @@ -2509,35 +2545,35 @@ === RUN TestAdminTokenAuth401Status --- PASS: TestAdminTokenAuth401Status (0.00s) === RUN TestTokenAuthNon200Non401Status -time="2025-05-16T04:10:32Z" level=error msg="could not reach http://127.0.0.1:40135: 404" +time="2024-04-12T21:51:30Z" level=error msg="could not reach http://127.0.0.1:44593: 404" --- PASS: TestTokenAuthNon200Non401Status (0.00s) === RUN TestAdminTokenAuthNon200Non401Status -time="2025-05-16T04:10:32Z" level=error msg="could not reach http://127.0.0.1:37909: 404" +time="2024-04-12T21:51:30Z" level=error msg="could not reach http://127.0.0.1:45983: 404" --- PASS: TestAdminTokenAuthNon200Non401Status (0.00s) === RUN TestConfigureRepo ---- PASS: TestConfigureRepo (0.01s) +--- PASS: TestConfigureRepo (0.00s) === RUN TestConfigureRepoRW -Enter username: time="2025-05-16T04:10:32Z" level=error msg="error processing username input: EOF" +Enter username: time="2024-04-12T21:51:30Z" level=error msg="error processing username input: EOF" --- PASS: TestConfigureRepoRW (0.00s) === RUN TestConfigureRepoAdmin -Enter username: time="2025-05-16T04:10:32Z" level=error msg="error processing username input: EOF" ---- PASS: TestConfigureRepoAdmin (0.01s) +Enter username: time="2024-04-12T21:51:30Z" level=error msg="error processing username input: EOF" +--- PASS: TestConfigureRepoAdmin (0.00s) === RUN TestStatusUnstageAndReset Successfully reset specified changes for repository gun Addition of target "test1" by sha256 hash to repository "gun" staged for next publish. Addition of target "test2" by sha256 hash to repository "gun" staged for next publish. Addition of target "test3" by sha256 hash to repository "gun" staged for next publish. Addition of target "test4" by sha256 hash to repository "gun" staged for next publish. ---- PASS: TestStatusUnstageAndReset (0.01s) +--- PASS: TestStatusUnstageAndReset (0.00s) === RUN TestGetTrustPinningErrors Pushing changes to gun --- PASS: TestGetTrustPinningErrors (0.00s) === RUN TestPasswordStore -Enter username: time="2025-05-16T04:10:32Z" level=error msg="error processing username input: EOF" +Enter username: time="2024-04-12T21:51:30Z" level=error msg="error processing username input: EOF" --- PASS: TestPasswordStore (0.00s) === RUN TestPasswordStoreWithEnvvar -time="2025-05-16T04:10:32Z" level=error msg="Authentication string with zero-length username" -time="2025-05-16T04:10:32Z" level=error msg="Could not base64-decode authentication string" +time="2024-04-12T21:51:30Z" level=error msg="Authentication string with zero-length username" +time="2024-04-12T21:51:30Z" level=error msg="Could not base64-decode authentication string" --- PASS: TestPasswordStoreWithEnvvar (0.00s) === RUN TestGetPayload --- PASS: TestGetPayload (0.00s) @@ -2546,7 +2582,7 @@ === RUN TestHomeExpand --- PASS: TestHomeExpand (0.00s) PASS -ok github.com/theupdateframework/notary/cmd/notary 27.356s +ok github.com/theupdateframework/notary/cmd/notary 18.945s === RUN TestBootstrap --- PASS: TestBootstrap (0.00s) === RUN TestGetAddrAndTLSConfigInvalidTLS @@ -2554,54 +2590,54 @@ === RUN TestGetAddrAndTLSConfigNoHTTPAddr --- PASS: TestGetAddrAndTLSConfigNoHTTPAddr (0.00s) === RUN TestGetAddrAndTLSConfigSuccessWithTLS ---- PASS: TestGetAddrAndTLSConfigSuccessWithTLS (0.01s) +--- PASS: TestGetAddrAndTLSConfigSuccessWithTLS (0.00s) === RUN TestGetAddrAndTLSConfigSuccessWithoutTLS --- PASS: TestGetAddrAndTLSConfigSuccessWithoutTLS (0.00s) === RUN TestGetAddrAndTLSConfigWithClientTLS ---- PASS: TestGetAddrAndTLSConfigWithClientTLS (0.01s) +--- PASS: TestGetAddrAndTLSConfigWithClientTLS (0.00s) === RUN TestGetInvalidTrustService --- PASS: TestGetInvalidTrustService (0.00s) === RUN TestGetLocalTrustService -time="2025-05-16T04:10:05Z" level=info msg="Using local signing service, which requires ED25519. Ignoring all other trust_service parameters, including keyAlgorithm" +time="2024-04-12T21:51:16Z" 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-05-16T04:10:05Z" level=info msg="Using remote signing service" +time="2024-04-12T21:51:16Z" level=info msg="Using remote signing service" --- PASS: TestGetTrustServiceNoTLSConfig (0.00s) === RUN TestGetTrustServiceTLSSuccess -time="2025-05-16T04:10:05Z" level=info msg="Using remote signing service" +time="2024-04-12T21:51:16Z" level=info msg="Using remote signing service" --- PASS: TestGetTrustServiceTLSSuccess (0.00s) === RUN TestGetTrustServiceTLSFailure --- PASS: TestGetTrustServiceTLSFailure (0.00s) === RUN TestGetStoreInvalid -time="2025-05-16T04:10:05Z" level=info msg="Using asdf backend" +time="2024-04-12T21:51:16Z" level=info msg="Using asdf backend" --- PASS: TestGetStoreInvalid (0.00s) === RUN TestGetStoreDBStore -time="2025-05-16T04:10:05Z" level=info msg="Using sqlite3 backend" +time="2024-04-12T21:51:16Z" level=info msg="Using sqlite3 backend" --- PASS: TestGetStoreDBStore (0.00s) === RUN TestGetStoreRethinkDBStoreConnectionFails -time="2025-05-16T04:10:05Z" level=info msg="Using rethinkdb backend" +time="2024-04-12T21:51:16Z" level=info msg="Using rethinkdb backend" --- PASS: TestGetStoreRethinkDBStoreConnectionFails (0.00s) === RUN TestGetMemoryStore -time="2025-05-16T04:10:05Z" level=info msg="Using memory backend" +time="2024-04-12T21:51:16Z" 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-05-16T04:10:05Z" level=info msg="Using remote signing service" -time="2025-05-16T04:10:05Z" level=info msg="Using sqlite3 backend" ---- PASS: TestSampleConfig (0.01s) +time="2024-04-12T21:51:16Z" level=info msg="Using remote signing service" +time="2024-04-12T21:51:16Z" level=info msg="Using sqlite3 backend" +--- PASS: TestSampleConfig (0.00s) PASS -ok github.com/theupdateframework/notary/cmd/notary-server 0.112s +ok github.com/theupdateframework/notary/cmd/notary-server 0.021s === RUN TestGetAddrAndTLSConfigInvalidTLS --- PASS: TestGetAddrAndTLSConfigInvalidTLS (0.00s) === RUN TestGetAddrAndTLSConfigNoGRPCAddr ---- PASS: TestGetAddrAndTLSConfigNoGRPCAddr (0.01s) +--- PASS: TestGetAddrAndTLSConfigNoGRPCAddr (0.00s) === RUN TestGetAddrAndTLSConfigSuccess --- PASS: TestGetAddrAndTLSConfigSuccess (0.00s) === RUN TestSetupCryptoServicesDBStoreNoDefaultAlias @@ -2612,7 +2648,7 @@ main_test.go:121: DM - skipping malfunctioning test, fails on sbuild --- SKIP: TestSetupCryptoServicesRethinkDBStoreConnectionFails (0.00s) === RUN TestSetupCryptoServicesDBStoreSuccess ---- PASS: TestSetupCryptoServicesDBStoreSuccess (0.27s) +--- PASS: TestSetupCryptoServicesDBStoreSuccess (0.05s) === RUN TestSetupCryptoServicesMemoryStore --- PASS: TestSetupCryptoServicesMemoryStore (0.01s) === RUN TestSetupCryptoServicesInvalidStore @@ -2630,17 +2666,17 @@ === RUN TestSampleConfig --- PASS: TestSampleConfig (0.00s) PASS -ok github.com/theupdateframework/notary/cmd/notary-signer 0.328s +ok github.com/theupdateframework/notary/cmd/notary-signer 0.083s === RUN TestGenerateCertificate ---- PASS: TestGenerateCertificate (0.03s) +--- PASS: TestGenerateCertificate (0.02s) === RUN TestCryptoServiceWithNonEmptyGUN ---- PASS: TestCryptoServiceWithNonEmptyGUN (2.31s) +--- PASS: TestCryptoServiceWithNonEmptyGUN (1.13s) === RUN TestCryptoServiceWithEmptyGUN ---- PASS: TestCryptoServiceWithEmptyGUN (1.68s) +--- PASS: TestCryptoServiceWithEmptyGUN (1.14s) === RUN TestCryptoSignerInterfaceBehavior --- PASS: TestCryptoSignerInterfaceBehavior (0.03s) PASS -ok github.com/theupdateframework/notary/cryptoservice 4.071s +ok github.com/theupdateframework/notary/cryptoservice 2.331s === RUN TestGetPassphraseForUsingDelegationKey --- PASS: TestGetPassphraseForUsingDelegationKey (0.00s) === RUN TestGetPassphraseLimitsShortPassphrases @@ -2656,272 +2692,272 @@ === RUN TestGetPassphrase --- PASS: TestGetPassphrase (0.00s) PASS -ok github.com/theupdateframework/notary/passphrase 0.044s +ok github.com/theupdateframework/notary/passphrase 0.007s === RUN TestValidationErrorFormat -time="2025-05-16T04:10:05Z" 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.2 http.request.contenttype="multipart/form-data; boundary=98fb4bf16085244715006344ccdaca77c380e998319bd9e97b7c36a08668" http.request.host="127.0.0.1:36581" http.request.id=8544584f-0456-4c72-b509-49dc453aa622 http.request.method=POST http.request.remoteaddr="127.0.0.1:53962" http.request.uri=/v2/docker.com/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 -time="2025-05-16T04:10:05Z" level=info msg="response completed" go.version=go1.22.2 http.request.contenttype="multipart/form-data; boundary=98fb4bf16085244715006344ccdaca77c380e998319bd9e97b7c36a08668" http.request.host="127.0.0.1:36581" http.request.id=8544584f-0456-4c72-b509-49dc453aa622 http.request.method=POST http.request.remoteaddr="127.0.0.1:53962" 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=33.540557ms http.response.status=400 http.response.written=260 ---- PASS: TestValidationErrorFormat (0.30s) +time="2024-04-12T21:51:19Z" 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.2 http.request.contenttype="multipart/form-data; boundary=80475c7440fee74f2800dfd76e9b75a88e3614db9834fe4f76c036d0d393" http.request.host="127.0.0.1:36731" http.request.id=6f1cd81c-10df-42b1-810a-207e0954ed8e http.request.method=POST http.request.remoteaddr="127.0.0.1:34054" http.request.uri=/v2/docker.com/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 +time="2024-04-12T21:51:19Z" level=info msg="response completed" go.version=go1.22.2 http.request.contenttype="multipart/form-data; boundary=80475c7440fee74f2800dfd76e9b75a88e3614db9834fe4f76c036d0d393" http.request.host="127.0.0.1:36731" http.request.id=6f1cd81c-10df-42b1-810a-207e0954ed8e http.request.method=POST http.request.remoteaddr="127.0.0.1:34054" 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=10.426444ms http.response.status=400 http.response.written=260 +--- PASS: TestValidationErrorFormat (0.07s) === RUN TestRunBadAddr --- PASS: TestRunBadAddr (0.00s) === RUN TestRunReservedPort ---- PASS: TestRunReservedPort (0.01s) +--- PASS: TestRunReservedPort (0.00s) === RUN TestRepoPrefixMatches -time="2025-05-16T04:10:06Z" level=info msg="updated docker.io/notary to timestamp version 1, checksum e857fc927535ceb621bdf1378e94998c79ab4b986236bacfb129cdd464d69dc1" docker.io/notary=gun go.version=go1.22.2 http.request.contenttype="multipart/form-data; boundary=4dc5a6a4e9089d061b6fd4ac5d6ebdaf360f5d9d0f8d6b5a344fe1453e78" http.request.host="127.0.0.1:36435" http.request.id=57470634-a671-43ba-b220-43b13fa3b743 http.request.method=POST http.request.remoteaddr="127.0.0.1:34514" http.request.uri=/v2/docker.io/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 -time="2025-05-16T04:10:06Z" level=info msg="response completed" go.version=go1.22.2 http.request.contenttype="multipart/form-data; boundary=4dc5a6a4e9089d061b6fd4ac5d6ebdaf360f5d9d0f8d6b5a344fe1453e78" http.request.host="127.0.0.1:36435" http.request.id=57470634-a671-43ba-b220-43b13fa3b743 http.request.method=POST http.request.remoteaddr="127.0.0.1:34514" http.request.uri=/v2/docker.io/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 http.response.duration=49.847371ms http.response.status=0 http.response.written=0 -time="2025-05-16T04:10:06Z" level=info msg="response completed" go.version=go1.22.2 http.request.host="127.0.0.1:36435" http.request.id=437c00b3-34e8-4dfa-b25d-164b0318dafe http.request.method=GET http.request.remoteaddr="127.0.0.1:34514" http.request.uri=/v2/docker.io/notary/_trust/tuf/snapshot.json http.request.useragent=Go-http-client/1.1 http.response.duration="740.878µs" http.response.status=200 http.response.written=683 -time="2025-05-16T04:10:06Z" level=info msg="response completed" go.version=go1.22.2 http.request.host="127.0.0.1:36435" http.request.id=8ed17330-89f0-4789-ad96-a06787468bd0 http.request.method=GET http.request.remoteaddr="127.0.0.1:34514" http.request.uri=/v2/docker.io/notary/_trust/tuf/snapshot.ea3a7a05ab73a6b2955d5adfc636d6a346cdd8f49c470ff8828957e452dda9aa.json http.request.useragent=Go-http-client/1.1 http.response.duration="42.418µs" http.response.status=200 http.response.written=683 -time="2025-05-16T04:10:06Z" level=info msg="response completed" go.version=go1.22.2 http.request.host="127.0.0.1:36435" http.request.id=b2a64333-767e-427e-8a55-9b8ae2991938 http.request.method=GET http.request.remoteaddr="127.0.0.1:34514" http.request.uri=/v2/docker.io/notary/_trust/tuf/timestamp.key http.request.useragent=Go-http-client/1.1 http.response.duration="545.169µs" http.response.status=200 http.response.written=181 -time="2025-05-16T04:10:06Z" level=info msg="trust data deleted for docker.io/notary" docker.io/notary=gun go.version=go1.22.2 http.request.host="127.0.0.1:36435" http.request.id=083ac1cb-6c18-4150-8eba-e83d62e7c66d http.request.method=DELETE http.request.remoteaddr="127.0.0.1:34514" http.request.uri=/v2/docker.io/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 -time="2025-05-16T04:10:06Z" level=info msg="response completed" go.version=go1.22.2 http.request.host="127.0.0.1:36435" http.request.id=083ac1cb-6c18-4150-8eba-e83d62e7c66d http.request.method=DELETE http.request.remoteaddr="127.0.0.1:34514" http.request.uri=/v2/docker.io/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 http.response.duration="62.682µs" http.response.status=0 http.response.written=0 ---- PASS: TestRepoPrefixMatches (0.18s) +time="2024-04-12T21:51:19Z" level=info msg="updated docker.io/notary to timestamp version 1, checksum 19a1c9563b2831c4c35978b908bcfd1d99168128b252f3a258d065f41652b337" docker.io/notary=gun go.version=go1.22.2 http.request.contenttype="multipart/form-data; boundary=dc1f106a88459eab2f011018b08c321af6ba0c5735fbe386ae644d900343" http.request.host="127.0.0.1:33725" http.request.id=ae3d4253-9346-4059-9c48-c39e21d60995 http.request.method=POST http.request.remoteaddr="127.0.0.1:33612" http.request.uri=/v2/docker.io/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 +time="2024-04-12T21:51:19Z" level=info msg="response completed" go.version=go1.22.2 http.request.contenttype="multipart/form-data; boundary=dc1f106a88459eab2f011018b08c321af6ba0c5735fbe386ae644d900343" http.request.host="127.0.0.1:33725" http.request.id=ae3d4253-9346-4059-9c48-c39e21d60995 http.request.method=POST http.request.remoteaddr="127.0.0.1:33612" http.request.uri=/v2/docker.io/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 http.response.duration=23.060775ms http.response.status=0 http.response.written=0 +time="2024-04-12T21:51:19Z" level=info msg="response completed" go.version=go1.22.2 http.request.host="127.0.0.1:33725" http.request.id=23d17eb0-82d2-46d3-9c8a-0424aa65d269 http.request.method=GET http.request.remoteaddr="127.0.0.1:33612" http.request.uri=/v2/docker.io/notary/_trust/tuf/snapshot.json http.request.useragent=Go-http-client/1.1 http.response.duration="641.723µs" http.response.status=200 http.response.written=683 +time="2024-04-12T21:51:19Z" level=info msg="response completed" go.version=go1.22.2 http.request.host="127.0.0.1:33725" http.request.id=0490d07b-9cf7-4d67-8fe1-9c8601bfe127 http.request.method=GET http.request.remoteaddr="127.0.0.1:33612" http.request.uri=/v2/docker.io/notary/_trust/tuf/snapshot.246d64db1d3bc7f7ce7a910dc8e7e62ddb2f43a956abfad920fdd108ed22d60b.json http.request.useragent=Go-http-client/1.1 http.response.duration="38.207µs" http.response.status=200 http.response.written=683 +time="2024-04-12T21:51:19Z" level=info msg="response completed" go.version=go1.22.2 http.request.host="127.0.0.1:33725" http.request.id=f11347c0-37dd-4937-acf3-b6581c4fe85d http.request.method=GET http.request.remoteaddr="127.0.0.1:33612" http.request.uri=/v2/docker.io/notary/_trust/tuf/timestamp.key http.request.useragent=Go-http-client/1.1 http.response.duration="408.989µs" http.response.status=200 http.response.written=181 +time="2024-04-12T21:51:19Z" level=info msg="trust data deleted for docker.io/notary" docker.io/notary=gun go.version=go1.22.2 http.request.host="127.0.0.1:33725" http.request.id=c18999a0-642f-4948-b829-b76bf851a454 http.request.method=DELETE http.request.remoteaddr="127.0.0.1:33612" http.request.uri=/v2/docker.io/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 +time="2024-04-12T21:51:19Z" level=info msg="response completed" go.version=go1.22.2 http.request.host="127.0.0.1:33725" http.request.id=c18999a0-642f-4948-b829-b76bf851a454 http.request.method=DELETE http.request.remoteaddr="127.0.0.1:33612" http.request.uri=/v2/docker.io/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 http.response.duration="67.528µs" http.response.status=0 http.response.written=0 +--- PASS: TestRepoPrefixMatches (0.08s) === RUN TestRepoPrefixDoesNotMatch ---- PASS: TestRepoPrefixDoesNotMatch (0.16s) +--- PASS: TestRepoPrefixDoesNotMatch (0.07s) === RUN TestMetricsEndpoint ---- PASS: TestMetricsEndpoint (0.20s) +--- PASS: TestMetricsEndpoint (0.02s) === RUN TestGetKeysEndpoint -time="2025-05-16T04:10:06Z" level=info msg="metadata not found: You have requested metadata that does not exist.: " go.version=go1.22.2 http.request.host="127.0.0.1:33917" http.request.id=92cc71fb-bd8b-4b3c-acf9-96b8b3de4568 http.request.method=GET http.request.remoteaddr="127.0.0.1:55390" http.request.uri=/v2/gun/_trust/tuf/somerandomrole.key http.request.useragent=Go-http-client/1.1 -time="2025-05-16T04:10:06Z" level=info msg="response completed" go.version=go1.22.2 http.request.host="127.0.0.1:33917" http.request.id=92cc71fb-bd8b-4b3c-acf9-96b8b3de4568 http.request.method=GET http.request.remoteaddr="127.0.0.1:55390" 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="158.488µs" http.response.status=404 http.response.written=104 -time="2025-05-16T04:10:06Z" level=info msg="response completed" go.version=go1.22.2 http.request.host="127.0.0.1:33917" http.request.id=b873810e-386c-46c6-9c8b-f729f26ea82e http.request.method=GET http.request.remoteaddr="127.0.0.1:55392" http.request.uri=/v2/gun/_trust/tuf/timestamp.key http.request.useragent=Go-http-client/1.1 http.response.duration=66.933014ms http.response.status=200 http.response.written=103 -time="2025-05-16T04:10:06Z" level=info msg="response completed" go.version=go1.22.2 http.request.host="127.0.0.1:33917" http.request.id=5832ff5b-10cd-44c1-a521-db0c0f5202d6 http.request.method=GET http.request.remoteaddr="127.0.0.1:55404" http.request.uri=/v2/gun/_trust/tuf/snapshot.key http.request.useragent=Go-http-client/1.1 http.response.duration="637.26µs" http.response.status=200 http.response.written=103 -time="2025-05-16T04:10:06Z" level=info msg="metadata not found: You have requested metadata that does not exist.: " go.version=go1.22.2 http.request.host="127.0.0.1:33917" http.request.id=6928502a-fcb1-4646-9237-4af4eea599c9 http.request.method=GET http.request.remoteaddr="127.0.0.1:55406" http.request.uri=/v2/gun/_trust/tuf/targets.key http.request.useragent=Go-http-client/1.1 -time="2025-05-16T04:10:06Z" level=info msg="response completed" go.version=go1.22.2 http.request.host="127.0.0.1:33917" http.request.id=6928502a-fcb1-4646-9237-4af4eea599c9 http.request.method=GET http.request.remoteaddr="127.0.0.1:55406" 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="140.336µs" http.response.status=404 http.response.written=104 -time="2025-05-16T04:10:06Z" level=info msg="metadata not found: You have requested metadata that does not exist.: " go.version=go1.22.2 http.request.host="127.0.0.1:33917" http.request.id=58c3db3c-a365-4c78-922b-64f6824f94bb http.request.method=GET http.request.remoteaddr="127.0.0.1:55408" http.request.uri=/v2/gun/_trust/tuf/root.key http.request.useragent=Go-http-client/1.1 -time="2025-05-16T04:10:06Z" level=info msg="response completed" go.version=go1.22.2 http.request.host="127.0.0.1:33917" http.request.id=58c3db3c-a365-4c78-922b-64f6824f94bb http.request.method=GET http.request.remoteaddr="127.0.0.1:55408" 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="80.188µs" http.response.status=404 http.response.written=104 ---- PASS: TestGetKeysEndpoint (0.11s) +time="2024-04-12T21:51:19Z" level=info msg="response completed" go.version=go1.22.2 http.request.host="127.0.0.1:35863" http.request.id=9a9d691a-7d1b-4054-8541-8447bb837a04 http.request.method=GET http.request.remoteaddr="127.0.0.1:56578" http.request.uri=/v2/gun/_trust/tuf/timestamp.key http.request.useragent=Go-http-client/1.1 http.response.duration=30.718973ms http.response.status=200 http.response.written=103 +time="2024-04-12T21:51:19Z" level=info msg="response completed" go.version=go1.22.2 http.request.host="127.0.0.1:35863" http.request.id=2f717234-8ba9-47ba-b92e-53d7956034f6 http.request.method=GET http.request.remoteaddr="127.0.0.1:56582" http.request.uri=/v2/gun/_trust/tuf/snapshot.key http.request.useragent=Go-http-client/1.1 http.response.duration="491.472µs" http.response.status=200 http.response.written=103 +time="2024-04-12T21:51:19Z" level=info msg="metadata not found: You have requested metadata that does not exist.: " go.version=go1.22.2 http.request.host="127.0.0.1:35863" http.request.id=89972932-1fcd-436b-bb42-35820b172947 http.request.method=GET http.request.remoteaddr="127.0.0.1:56590" http.request.uri=/v2/gun/_trust/tuf/targets.key http.request.useragent=Go-http-client/1.1 +time="2024-04-12T21:51:19Z" level=info msg="response completed" go.version=go1.22.2 http.request.host="127.0.0.1:35863" http.request.id=89972932-1fcd-436b-bb42-35820b172947 http.request.method=GET http.request.remoteaddr="127.0.0.1:56590" 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="124.005µs" http.response.status=404 http.response.written=104 +time="2024-04-12T21:51:19Z" level=info msg="metadata not found: You have requested metadata that does not exist.: " go.version=go1.22.2 http.request.host="127.0.0.1:35863" http.request.id=cfad1ce2-a927-431c-b894-3bd43ed31a46 http.request.method=GET http.request.remoteaddr="127.0.0.1:56596" http.request.uri=/v2/gun/_trust/tuf/root.key http.request.useragent=Go-http-client/1.1 +time="2024-04-12T21:51:19Z" level=info msg="response completed" go.version=go1.22.2 http.request.host="127.0.0.1:35863" http.request.id=cfad1ce2-a927-431c-b894-3bd43ed31a46 http.request.method=GET http.request.remoteaddr="127.0.0.1:56596" 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="88.585µs" http.response.status=404 http.response.written=104 +time="2024-04-12T21:51:19Z" level=info msg="metadata not found: You have requested metadata that does not exist.: " go.version=go1.22.2 http.request.host="127.0.0.1:35863" http.request.id=7afdaf7b-4900-4a0d-848a-fb4b409d604c http.request.method=GET http.request.remoteaddr="127.0.0.1:56600" http.request.uri=/v2/gun/_trust/tuf/somerandomrole.key http.request.useragent=Go-http-client/1.1 +time="2024-04-12T21:51:19Z" level=info msg="response completed" go.version=go1.22.2 http.request.host="127.0.0.1:35863" http.request.id=7afdaf7b-4900-4a0d-848a-fb4b409d604c http.request.method=GET http.request.remoteaddr="127.0.0.1:56600" 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="138.219µs" http.response.status=404 http.response.written=104 +--- PASS: TestGetKeysEndpoint (0.04s) === RUN TestGetRoleByHash -time="2025-05-16T04:10:06Z" level=info msg="response completed" go.version=go1.22.2 http.request.host="127.0.0.1:33453" http.request.id=f08a3c12-8da6-4473-9ff5-e4cc1388bcb9 http.request.method=GET http.request.remoteaddr="127.0.0.1:59696" http.request.uri=/v2/gun/_trust/tuf/timestamp.904f398835c8e182870259634f9dfab161719e7dfe41d32b6f413c426f4467a9.json http.request.useragent=Go-http-client/1.1 http.response.duration="82.677µs" http.response.status=200 http.response.written=115 ---- PASS: TestGetRoleByHash (0.01s) +time="2024-04-12T21:51:19Z" level=info msg="response completed" go.version=go1.22.2 http.request.host="127.0.0.1:38075" http.request.id=6ff9f5a7-67b3-4ef3-82f1-0279c0842d63 http.request.method=GET http.request.remoteaddr="127.0.0.1:41366" http.request.uri=/v2/gun/_trust/tuf/timestamp.14f2244a215d24c17a372fd92dabc4548d1d37541a017f43fde64c4f0200302a.json http.request.useragent=Go-http-client/1.1 http.response.duration="74.422µs" http.response.status=200 http.response.written=115 +--- PASS: TestGetRoleByHash (0.00s) === RUN TestGetRoleByVersion -time="2025-05-16T04:10:06Z" level=info msg="response completed" go.version=go1.22.2 http.request.host="127.0.0.1:37447" http.request.id=131e1a34-f648-4e9c-bd22-1a740aa11979 http.request.method=GET http.request.remoteaddr="127.0.0.1:47280" http.request.uri=/v2/gun/_trust/tuf/1.timestamp.json http.request.useragent=Go-http-client/1.1 http.response.duration="71.203µs" http.response.status=200 http.response.written=115 +time="2024-04-12T21:51:19Z" level=info msg="response completed" go.version=go1.22.2 http.request.host="127.0.0.1:40845" http.request.id=1d2652fb-61a5-4afe-9524-272a5cbdfc0e http.request.method=GET http.request.remoteaddr="127.0.0.1:53574" http.request.uri=/v2/gun/_trust/tuf/1.timestamp.json http.request.useragent=Go-http-client/1.1 http.response.duration="74.634µs" http.response.status=200 http.response.written=115 --- PASS: TestGetRoleByVersion (0.01s) === RUN TestGetCurrentRole -time="2025-05-16T04:10:06Z" level=info msg="response completed" go.version=go1.22.2 http.request.host="127.0.0.1:39049" http.request.id=befc944f-219b-4e78-b115-99c3178e9f70 http.request.method=GET http.request.remoteaddr="127.0.0.1:53020" http.request.uri=/v2/gun/_trust/tuf/timestamp.json http.request.useragent=Go-http-client/1.1 http.response.duration="662.709µs" http.response.status=200 http.response.written=495 ---- PASS: TestGetCurrentRole (0.12s) +time="2024-04-12T21:51:19Z" level=info msg="response completed" go.version=go1.22.2 http.request.host="127.0.0.1:46129" http.request.id=850647b1-e431-4554-8817-ca79960224fb http.request.method=GET http.request.remoteaddr="127.0.0.1:47542" http.request.uri=/v2/gun/_trust/tuf/timestamp.json http.request.useragent=Go-http-client/1.1 http.response.duration="641.972µs" http.response.status=200 http.response.written=495 +--- PASS: TestGetCurrentRole (0.05s) === RUN TestRotateKeyEndpoint -time="2025-05-16T04:10:06Z" level=info msg="metadata not found: You have requested metadata that does not exist.: " go.version=go1.22.2 http.request.contenttype=text/plain http.request.host="127.0.0.1:46119" http.request.id=6b582e0c-bd9f-4b57-ae39-5f35b381f4c5 http.request.method=POST http.request.remoteaddr="127.0.0.1:47514" http.request.uri=/v2/gun/_trust/tuf/somerandomrole.key http.request.useragent=Go-http-client/1.1 -time="2025-05-16T04:10:06Z" level=info msg="response completed" go.version=go1.22.2 http.request.contenttype=text/plain http.request.host="127.0.0.1:46119" http.request.id=6b582e0c-bd9f-4b57-ae39-5f35b381f4c5 http.request.method=POST http.request.remoteaddr="127.0.0.1:47514" 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="161.117µs" http.response.status=404 http.response.written=104 -time="2025-05-16T04:10:06Z" level=info msg="response completed" go.version=go1.22.2 http.request.contenttype=text/plain http.request.host="127.0.0.1:46119" http.request.id=3ed01b7b-8a32-4795-b94e-d8a3ca5e67e7 http.request.method=POST http.request.remoteaddr="127.0.0.1:47522" http.request.uri=/v2/gun/_trust/tuf/timestamp.key http.request.useragent=Go-http-client/1.1 http.response.duration="608.49µs" http.response.status=200 http.response.written=103 -time="2025-05-16T04:10:06Z" level=info msg="response completed" go.version=go1.22.2 http.request.contenttype=text/plain http.request.host="127.0.0.1:46119" http.request.id=d257deb5-43d5-403d-8d1b-cc93e045a940 http.request.method=POST http.request.remoteaddr="127.0.0.1:47526" http.request.uri=/v2/gun/_trust/tuf/snapshot.key http.request.useragent=Go-http-client/1.1 http.response.duration="568.425µs" http.response.status=200 http.response.written=103 -time="2025-05-16T04:10:06Z" level=info msg="metadata not found: You have requested metadata that does not exist.: " go.version=go1.22.2 http.request.contenttype=text/plain http.request.host="127.0.0.1:46119" http.request.id=09e54ea4-4c79-443b-9386-21cbb7ec4330 http.request.method=POST http.request.remoteaddr="127.0.0.1:47536" http.request.uri=/v2/gun/_trust/tuf/targets.key http.request.useragent=Go-http-client/1.1 -time="2025-05-16T04:10:06Z" level=info msg="response completed" go.version=go1.22.2 http.request.contenttype=text/plain http.request.host="127.0.0.1:46119" http.request.id=09e54ea4-4c79-443b-9386-21cbb7ec4330 http.request.method=POST http.request.remoteaddr="127.0.0.1:47536" 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="87.772µs" http.response.status=404 http.response.written=104 -time="2025-05-16T04:10:06Z" level=info msg="metadata not found: You have requested metadata that does not exist.: " go.version=go1.22.2 http.request.contenttype=text/plain http.request.host="127.0.0.1:46119" http.request.id=0a649394-7983-401b-84db-8fe7efaadf49 http.request.method=POST http.request.remoteaddr="127.0.0.1:47550" http.request.uri=/v2/gun/_trust/tuf/root.key http.request.useragent=Go-http-client/1.1 -time="2025-05-16T04:10:06Z" level=info msg="response completed" go.version=go1.22.2 http.request.contenttype=text/plain http.request.host="127.0.0.1:46119" http.request.id=0a649394-7983-401b-84db-8fe7efaadf49 http.request.method=POST http.request.remoteaddr="127.0.0.1:47550" 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="112.912µs" http.response.status=404 http.response.written=104 -time="2025-05-16T04:10:06Z" level=info msg="metadata not found: You have requested metadata that does not exist.: " go.version=go1.22.2 http.request.contenttype=text/plain http.request.host="127.0.0.1:46119" http.request.id=ac0149fe-275e-4ce4-ae3f-a05c1bc91884 http.request.method=POST http.request.remoteaddr="127.0.0.1:47554" http.request.uri=/v2/gun/_trust/tuf/targets/delegation.key http.request.useragent=Go-http-client/1.1 -time="2025-05-16T04:10:06Z" level=info msg="response completed" go.version=go1.22.2 http.request.contenttype=text/plain http.request.host="127.0.0.1:46119" http.request.id=ac0149fe-275e-4ce4-ae3f-a05c1bc91884 http.request.method=POST http.request.remoteaddr="127.0.0.1:47554" 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="119.962µs" http.response.status=404 http.response.written=104 ---- PASS: TestRotateKeyEndpoint (0.04s) +time="2024-04-12T21:51:19Z" level=info msg="metadata not found: You have requested metadata that does not exist.: " go.version=go1.22.2 http.request.contenttype=text/plain http.request.host="127.0.0.1:39735" http.request.id=5eef7b7e-116e-4f30-89f5-2d0719c38bff http.request.method=POST http.request.remoteaddr="127.0.0.1:43210" http.request.uri=/v2/gun/_trust/tuf/targets.key http.request.useragent=Go-http-client/1.1 +time="2024-04-12T21:51:19Z" level=info msg="response completed" go.version=go1.22.2 http.request.contenttype=text/plain http.request.host="127.0.0.1:39735" http.request.id=5eef7b7e-116e-4f30-89f5-2d0719c38bff http.request.method=POST http.request.remoteaddr="127.0.0.1:43210" 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="145.92µs" http.response.status=404 http.response.written=104 +time="2024-04-12T21:51:19Z" level=info msg="metadata not found: You have requested metadata that does not exist.: " go.version=go1.22.2 http.request.contenttype=text/plain http.request.host="127.0.0.1:39735" http.request.id=614447cd-f2ca-4421-9963-7baba7e71e73 http.request.method=POST http.request.remoteaddr="127.0.0.1:43222" http.request.uri=/v2/gun/_trust/tuf/root.key http.request.useragent=Go-http-client/1.1 +time="2024-04-12T21:51:19Z" level=info msg="response completed" go.version=go1.22.2 http.request.contenttype=text/plain http.request.host="127.0.0.1:39735" http.request.id=614447cd-f2ca-4421-9963-7baba7e71e73 http.request.method=POST http.request.remoteaddr="127.0.0.1:43222" 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="182.554µs" http.response.status=404 http.response.written=104 +time="2024-04-12T21:51:19Z" level=info msg="metadata not found: You have requested metadata that does not exist.: " go.version=go1.22.2 http.request.contenttype=text/plain http.request.host="127.0.0.1:39735" http.request.id=26878443-38f8-4f03-8212-849cb34e70d1 http.request.method=POST http.request.remoteaddr="127.0.0.1:43228" http.request.uri=/v2/gun/_trust/tuf/targets/delegation.key http.request.useragent=Go-http-client/1.1 +time="2024-04-12T21:51:19Z" level=info msg="response completed" go.version=go1.22.2 http.request.contenttype=text/plain http.request.host="127.0.0.1:39735" http.request.id=26878443-38f8-4f03-8212-849cb34e70d1 http.request.method=POST http.request.remoteaddr="127.0.0.1:43228" 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="99.237µs" http.response.status=404 http.response.written=104 +time="2024-04-12T21:51:19Z" level=info msg="metadata not found: You have requested metadata that does not exist.: " go.version=go1.22.2 http.request.contenttype=text/plain http.request.host="127.0.0.1:39735" http.request.id=f28a8e31-601e-4f30-93e3-91d8da4f98e2 http.request.method=POST http.request.remoteaddr="127.0.0.1:43234" http.request.uri=/v2/gun/_trust/tuf/somerandomrole.key http.request.useragent=Go-http-client/1.1 +time="2024-04-12T21:51:19Z" level=info msg="response completed" go.version=go1.22.2 http.request.contenttype=text/plain http.request.host="127.0.0.1:39735" http.request.id=f28a8e31-601e-4f30-93e3-91d8da4f98e2 http.request.method=POST http.request.remoteaddr="127.0.0.1:43234" 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="63.601µs" http.response.status=404 http.response.written=104 +time="2024-04-12T21:51:19Z" level=info msg="response completed" go.version=go1.22.2 http.request.contenttype=text/plain http.request.host="127.0.0.1:39735" http.request.id=d6e9c7e9-8143-49c2-9958-9c0f05f7cedc http.request.method=POST http.request.remoteaddr="127.0.0.1:43250" http.request.uri=/v2/gun/_trust/tuf/timestamp.key http.request.useragent=Go-http-client/1.1 http.response.duration="557.208µs" http.response.status=200 http.response.written=103 +time="2024-04-12T21:51:19Z" level=info msg="response completed" go.version=go1.22.2 http.request.contenttype=text/plain http.request.host="127.0.0.1:39735" http.request.id=48f86a05-4411-4002-b895-9c3e1137ce46 http.request.method=POST http.request.remoteaddr="127.0.0.1:43260" http.request.uri=/v2/gun/_trust/tuf/snapshot.key http.request.useragent=Go-http-client/1.1 http.response.duration="491.965µs" http.response.status=200 http.response.written=103 +--- PASS: TestRotateKeyEndpoint (0.02s) PASS -ok github.com/theupdateframework/notary/server 1.288s +ok github.com/theupdateframework/notary/server 0.377s === RUN Test_changefeed --- PASS: Test_changefeed (0.00s) === RUN Test_checkChangefeedInputs -time="2025-05-16T04:10:05Z" level=error msg="500 GET unable to retrieve storage" -time="2025-05-16T04:10:05Z" level=error msg="400 GET invalid pageSize: not_a_number" +time="2024-04-12T21:51:20Z" level=error msg="500 GET unable to retrieve storage" +time="2024-04-12T21:51:20Z" level=error msg="400 GET invalid pageSize: not_a_number" --- PASS: Test_checkChangefeedInputs (0.00s) === RUN TestMainHandlerGet -time="2025-05-16T04:10:05Z" level=info msg="response completed" go.version=go1.22.2 http.request.host="127.0.0.1:37111" http.request.id=0e0796a4-527d-4631-abca-490e8683f373 http.request.method=GET http.request.remoteaddr="127.0.0.1:51932" http.request.uri=/ http.request.useragent=Go-http-client/1.1 http.response.duration="48.046µs" http.response.status=200 http.response.written=2 +time="2024-04-12T21:51:20Z" level=info msg="response completed" go.version=go1.22.2 http.request.host="127.0.0.1:35139" http.request.id=db136ea0-e42b-4c29-a155-6f1aefd4cc33 http.request.method=GET http.request.remoteaddr="127.0.0.1:39888" http.request.uri=/ http.request.useragent=Go-http-client/1.1 http.response.duration="58.8µs" http.response.status=200 http.response.written=2 --- PASS: TestMainHandlerGet (0.00s) === RUN TestMainHandlerNotGet -time="2025-05-16T04:10:05Z" level=info msg="generic not found: You have requested a resource that does not exist.: " go.version=go1.22.2 http.request.host="127.0.0.1:34737" http.request.id=f0978107-95f1-4acf-acb0-9350b6030aea http.request.method=HEAD http.request.remoteaddr="127.0.0.1:58488" http.request.uri=/ http.request.useragent=Go-http-client/1.1 -time="2025-05-16T04:10:05Z" level=info msg="response completed" go.version=go1.22.2 http.request.host="127.0.0.1:34737" http.request.id=f0978107-95f1-4acf-acb0-9350b6030aea http.request.method=HEAD http.request.remoteaddr="127.0.0.1:58488" http.request.uri=/ http.request.useragent=Go-http-client/1.1 http.response.contenttype="application/json; charset=utf-8" http.response.duration="206.083µs" http.response.status=404 http.response.written=105 +time="2024-04-12T21:51:20Z" level=info msg="generic not found: You have requested a resource that does not exist.: " go.version=go1.22.2 http.request.host="127.0.0.1:43755" http.request.id=e6c19c67-b7c0-44f3-acce-b7f836745791 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:52804" http.request.uri=/ http.request.useragent=Go-http-client/1.1 +time="2024-04-12T21:51:20Z" level=info msg="response completed" go.version=go1.22.2 http.request.host="127.0.0.1:43755" http.request.id=e6c19c67-b7c0-44f3-acce-b7f836745791 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:52804" http.request.uri=/ http.request.useragent=Go-http-client/1.1 http.response.contenttype="application/json; charset=utf-8" http.response.duration="223.364µs" http.response.status=404 http.response.written=105 --- PASS: TestMainHandlerNotGet (0.00s) === RUN TestKeyHandlersInvalidConfiguration -time="2025-05-16T04:10:05Z" level=error msg="500 GET storage not configured" go.version=go1.22.2 gun=gun -time="2025-05-16T04:10:05Z" level=error msg="500 GET storage not configured" go.version=go1.22.2 gun=gun -time="2025-05-16T04:10:05Z" level=error msg="500 GET crypto service not configured" go.version=go1.22.2 gun=gun -time="2025-05-16T04:10:05Z" level=error msg="500 GET crypto service not configured" go.version=go1.22.2 gun=gun -time="2025-05-16T04:10:05Z" level=error msg="500 GET key algorithm not configured" go.version=go1.22.2 gun=gun -time="2025-05-16T04:10:05Z" level=error msg="500 GET key algorithm not configured" go.version=go1.22.2 gun=gun -time="2025-05-16T04:10:05Z" level=error msg="500 POST crypto service not configured" go.version=go1.22.2 gun=gun -time="2025-05-16T04:10:05Z" level=error msg="500 POST crypto service not configured" go.version=go1.22.2 gun=gun -time="2025-05-16T04:10:05Z" level=error msg="500 POST key algorithm not configured" go.version=go1.22.2 gun=gun -time="2025-05-16T04:10:05Z" level=error msg="500 POST key algorithm not configured" go.version=go1.22.2 gun=gun -time="2025-05-16T04:10:05Z" level=error msg="500 POST storage not configured" go.version=go1.22.2 gun=gun -time="2025-05-16T04:10:05Z" level=error msg="500 POST storage not configured" go.version=go1.22.2 gun=gun +time="2024-04-12T21:51:20Z" level=error msg="500 GET storage not configured" go.version=go1.22.2 gun=gun +time="2024-04-12T21:51:20Z" level=error msg="500 GET storage not configured" go.version=go1.22.2 gun=gun +time="2024-04-12T21:51:20Z" level=error msg="500 GET crypto service not configured" go.version=go1.22.2 gun=gun +time="2024-04-12T21:51:20Z" level=error msg="500 GET crypto service not configured" go.version=go1.22.2 gun=gun +time="2024-04-12T21:51:20Z" level=error msg="500 GET key algorithm not configured" go.version=go1.22.2 gun=gun +time="2024-04-12T21:51:20Z" level=error msg="500 GET key algorithm not configured" go.version=go1.22.2 gun=gun +time="2024-04-12T21:51:20Z" level=error msg="500 POST crypto service not configured" go.version=go1.22.2 gun=gun +time="2024-04-12T21:51:20Z" level=error msg="500 POST crypto service not configured" go.version=go1.22.2 gun=gun +time="2024-04-12T21:51:20Z" level=error msg="500 POST key algorithm not configured" go.version=go1.22.2 gun=gun +time="2024-04-12T21:51:20Z" level=error msg="500 POST key algorithm not configured" go.version=go1.22.2 gun=gun +time="2024-04-12T21:51:20Z" level=error msg="500 POST storage not configured" go.version=go1.22.2 gun=gun +time="2024-04-12T21:51:20Z" level=error msg="500 POST storage not configured" go.version=go1.22.2 gun=gun --- PASS: TestKeyHandlersInvalidConfiguration (0.00s) === RUN TestKeyHandlersNoRoleOrRepo -time="2025-05-16T04:10:05Z" level=info msg="400 GET no gun in request" =gun go.version=go1.22.2 -time="2025-05-16T04:10:05Z" level=info msg="400 GET no gun in request" =gun go.version=go1.22.2 -time="2025-05-16T04:10:05Z" level=info msg="400 GET no role in request" go.version=go1.22.2 gun=gun -time="2025-05-16T04:10:05Z" level=info msg="400 GET no role in request" go.version=go1.22.2 gun=gun -time="2025-05-16T04:10:05Z" level=info msg="400 POST no gun in request" =gun go.version=go1.22.2 -time="2025-05-16T04:10:05Z" level=info msg="400 POST no gun in request" =gun go.version=go1.22.2 -time="2025-05-16T04:10:05Z" level=info msg="400 POST no role in request" go.version=go1.22.2 gun=gun -time="2025-05-16T04:10:05Z" level=info msg="400 POST no role in request" go.version=go1.22.2 gun=gun +time="2024-04-12T21:51:20Z" level=info msg="400 GET no gun in request" =gun go.version=go1.22.2 +time="2024-04-12T21:51:20Z" level=info msg="400 GET no gun in request" =gun go.version=go1.22.2 +time="2024-04-12T21:51:20Z" level=info msg="400 GET no role in request" go.version=go1.22.2 gun=gun +time="2024-04-12T21:51:20Z" level=info msg="400 GET no role in request" go.version=go1.22.2 gun=gun +time="2024-04-12T21:51:20Z" level=info msg="400 POST no gun in request" =gun go.version=go1.22.2 +time="2024-04-12T21:51:20Z" level=info msg="400 POST no gun in request" =gun go.version=go1.22.2 +time="2024-04-12T21:51:20Z" level=info msg="400 POST no role in request" go.version=go1.22.2 gun=gun +time="2024-04-12T21:51:20Z" level=info msg="400 POST no role in request" go.version=go1.22.2 gun=gun --- PASS: TestKeyHandlersNoRoleOrRepo (0.00s) === RUN TestKeyHandlersInvalidRole -time="2025-05-16T04:10:05Z" level=info msg="400 GET root key: " go.version=go1.22.2 gun=gun -time="2025-05-16T04:10:05Z" level=info msg="400 GET targets key: " go.version=go1.22.2 gun=gun -time="2025-05-16T04:10:05Z" level=info msg="400 GET targets/a key: " go.version=go1.22.2 gun=gun -time="2025-05-16T04:10:05Z" level=info msg="400 GET invalidrole key: " go.version=go1.22.2 gun=gun -time="2025-05-16T04:10:05Z" level=info msg="400 POST root key: " go.version=go1.22.2 gun=gun -time="2025-05-16T04:10:05Z" level=info msg="400 POST targets key: " go.version=go1.22.2 gun=gun -time="2025-05-16T04:10:05Z" level=info msg="400 POST targets/a key: " go.version=go1.22.2 gun=gun -time="2025-05-16T04:10:05Z" level=info msg="400 POST invalidrole key: " go.version=go1.22.2 gun=gun +time="2024-04-12T21:51:20Z" level=info msg="400 GET root key: " go.version=go1.22.2 gun=gun +time="2024-04-12T21:51:20Z" level=info msg="400 GET targets key: " go.version=go1.22.2 gun=gun +time="2024-04-12T21:51:20Z" level=info msg="400 GET targets/a key: " go.version=go1.22.2 gun=gun +time="2024-04-12T21:51:20Z" level=info msg="400 GET invalidrole key: " go.version=go1.22.2 gun=gun +time="2024-04-12T21:51:20Z" level=info msg="400 POST root key: " go.version=go1.22.2 gun=gun +time="2024-04-12T21:51:20Z" level=info msg="400 POST targets key: " go.version=go1.22.2 gun=gun +time="2024-04-12T21:51:20Z" level=info msg="400 POST targets/a key: " go.version=go1.22.2 gun=gun +time="2024-04-12T21:51:20Z" level=info msg="400 POST invalidrole key: " go.version=go1.22.2 gun=gun --- PASS: TestKeyHandlersInvalidRole (0.00s) === RUN TestGetKeyHandlerCreatesOnce ---- PASS: TestGetKeyHandlerCreatesOnce (0.04s) +--- PASS: TestGetKeyHandlerCreatesOnce (0.03s) === RUN TestKeyHandlersInvalidKeyAlgo -time="2025-05-16T04:10:05Z" level=error msg="500 GET timestamp key: only ED25519 supported by this cryptoservice" go.version=go1.22.2 gun=gun -time="2025-05-16T04:10:05Z" level=error msg="500 GET snapshot key: only ED25519 supported by this cryptoservice" go.version=go1.22.2 gun=gun -time="2025-05-16T04:10:05Z" level=error msg="500 POST timestamp key: only ED25519 supported by this cryptoservice" go.version=go1.22.2 gun=gun -time="2025-05-16T04:10:05Z" level=error msg="500 POST snapshot key: only ED25519 supported by this cryptoservice" go.version=go1.22.2 gun=gun +time="2024-04-12T21:51:20Z" level=error msg="500 GET timestamp key: only ED25519 supported by this cryptoservice" go.version=go1.22.2 gun=gun +time="2024-04-12T21:51:20Z" level=error msg="500 GET snapshot key: only ED25519 supported by this cryptoservice" go.version=go1.22.2 gun=gun +time="2024-04-12T21:51:20Z" level=error msg="500 POST timestamp key: only ED25519 supported by this cryptoservice" go.version=go1.22.2 gun=gun +time="2024-04-12T21:51:20Z" level=error msg="500 POST snapshot key: only ED25519 supported by this cryptoservice" go.version=go1.22.2 gun=gun --- PASS: TestKeyHandlersInvalidKeyAlgo (0.00s) === RUN TestRotateKeyHandlerSuccessfulRotation --- PASS: TestRotateKeyHandlerSuccessfulRotation (0.00s) === RUN TestGetHandlerRoot -time="2025-05-16T04:10:05Z" level=info msg="404 GET root role" go.version=go1.22.2 gun=gun +time="2024-04-12T21:51:20Z" level=info msg="404 GET root role" go.version=go1.22.2 gun=gun --- PASS: TestGetHandlerRoot (0.04s) === RUN TestGetHandlerTimestamp --- PASS: TestGetHandlerTimestamp (0.04s) === RUN TestGetHandlerSnapshot --- PASS: TestGetHandlerSnapshot (0.04s) === RUN TestGetHandler404 -time="2025-05-16T04:10:05Z" level=info msg="404 GET root role" go.version=go1.22.2 gun=gun +time="2024-04-12T21:51:20Z" level=info msg="404 GET root role" go.version=go1.22.2 gun=gun --- PASS: TestGetHandler404 (0.00s) === RUN TestGetHandlerNilData -time="2025-05-16T04:10:05Z" level=info msg="404 GET root role" go.version=go1.22.2 gun=gun +time="2024-04-12T21:51:20Z" level=info msg="404 GET root role" go.version=go1.22.2 gun=gun --- PASS: TestGetHandlerNilData (0.00s) === RUN TestGetHandlerNoStorage -time="2025-05-16T04:10:05Z" level=error msg="500 GET: no storage exists" =gun go.version=go1.22.2 +time="2024-04-12T21:51:20Z" level=error msg="500 GET: no storage exists" =gun go.version=go1.22.2 --- PASS: TestGetHandlerNoStorage (0.00s) === RUN TestAtomicUpdateValidationFailurePropagated ---- PASS: TestAtomicUpdateValidationFailurePropagated (0.07s) +--- PASS: TestAtomicUpdateValidationFailurePropagated (0.06s) === RUN TestAtomicUpdateNonValidationFailureNotPropagated -time="2025-05-16T04:10:05Z" level=info msg="400 POST error validating update" go.version=go1.22.2 testGUN=gun ---- PASS: TestAtomicUpdateNonValidationFailureNotPropagated (0.06s) +time="2024-04-12T21:51:20Z" level=info msg="400 POST error validating update" go.version=go1.22.2 testGUN=gun +--- PASS: TestAtomicUpdateNonValidationFailureNotPropagated (0.04s) === RUN TestAtomicUpdateVersionErrorPropagated -time="2025-05-16T04:10:05Z" level=info msg="400 POST old version error" go.version=go1.22.2 testGUN=gun ---- PASS: TestAtomicUpdateVersionErrorPropagated (0.09s) +time="2024-04-12T21:51:20Z" level=info msg="400 POST old version error" go.version=go1.22.2 testGUN=gun +--- PASS: TestAtomicUpdateVersionErrorPropagated (0.07s) === RUN TestGetMaybeServerSignedNoCrypto --- PASS: TestGetMaybeServerSignedNoCrypto (0.00s) === RUN TestGetMaybeServerSignedNoKey --- PASS: TestGetMaybeServerSignedNoKey (0.00s) === RUN TestValidateEmptyNew ---- PASS: TestValidateEmptyNew (0.08s) +--- PASS: TestValidateEmptyNew (0.07s) === RUN TestValidateRootCanContainOnlyx509KeysWithRightGun ---- PASS: TestValidateRootCanContainOnlyx509KeysWithRightGun (0.13s) +--- PASS: TestValidateRootCanContainOnlyx509KeysWithRightGun (0.11s) === RUN TestValidatePrevTimestamp ---- PASS: TestValidatePrevTimestamp (0.11s) +--- PASS: TestValidatePrevTimestamp (0.08s) === RUN TestValidatePreviousTimestampCorrupt -time="2025-05-16T04:10:06Z" level=error msg="Failed to unmarshal existing timestamp for GUN docker.com/notary" ---- PASS: TestValidatePreviousTimestampCorrupt (0.10s) +time="2024-04-12T21:51:21Z" level=error msg="Failed to unmarshal existing timestamp for GUN docker.com/notary" +--- PASS: TestValidatePreviousTimestampCorrupt (0.07s) === RUN TestValidateGetCurrentTimestampBroken ---- PASS: TestValidateGetCurrentTimestampBroken (0.09s) +--- PASS: TestValidateGetCurrentTimestampBroken (0.06s) === RUN TestValidateNoNewRoot ---- PASS: TestValidateNoNewRoot (0.10s) +--- PASS: TestValidateNoNewRoot (0.07s) === RUN TestValidateNoNewTargets ---- PASS: TestValidateNoNewTargets (0.08s) +--- PASS: TestValidateNoNewTargets (0.07s) === RUN TestValidateOnlySnapshot ---- PASS: TestValidateOnlySnapshot (0.13s) +--- PASS: TestValidateOnlySnapshot (0.07s) === RUN TestValidateOldRoot ---- PASS: TestValidateOldRoot (0.17s) +--- PASS: TestValidateOldRoot (0.08s) === RUN TestValidateOldRootCorrupt ---- PASS: TestValidateOldRootCorrupt (0.19s) +--- PASS: TestValidateOldRootCorrupt (0.05s) === RUN TestValidateOldRootCorruptRootRole ---- PASS: TestValidateOldRootCorruptRootRole (0.12s) +--- PASS: TestValidateOldRootCorruptRootRole (0.05s) === RUN TestValidateRootGetCurrentRootBroken ---- PASS: TestValidateRootGetCurrentRootBroken (0.11s) +--- PASS: TestValidateRootGetCurrentRootBroken (0.04s) === RUN TestValidateRootRotationWithOldSigs ---- PASS: TestValidateRootRotationWithOldSigs (0.36s) +--- PASS: TestValidateRootRotationWithOldSigs (0.20s) === RUN TestValidateRootRotationMultipleKeysThreshold1 ---- PASS: TestValidateRootRotationMultipleKeysThreshold1 (0.24s) +--- PASS: TestValidateRootRotationMultipleKeysThreshold1 (0.12s) === RUN TestRootRotationNotSignedWithOldKeysForOldRole ---- PASS: TestRootRotationNotSignedWithOldKeysForOldRole (0.29s) +--- PASS: TestRootRotationNotSignedWithOldKeysForOldRole (0.20s) === RUN TestRootRotationVersionIncrement ---- PASS: TestRootRotationVersionIncrement (0.22s) +--- PASS: TestRootRotationVersionIncrement (0.14s) === RUN TestValidateNoRoot ---- PASS: TestValidateNoRoot (0.06s) +--- PASS: TestValidateNoRoot (0.05s) === RUN TestValidateSnapshotMissingNoSnapshotKey --- PASS: TestValidateSnapshotMissingNoSnapshotKey (0.06s) === RUN TestValidateSnapshotGenerateNoPrev ---- PASS: TestValidateSnapshotGenerateNoPrev (0.08s) +--- PASS: TestValidateSnapshotGenerateNoPrev (0.07s) === RUN TestValidateSnapshotGenerateWithPrev ---- PASS: TestValidateSnapshotGenerateWithPrev (0.14s) +--- PASS: TestValidateSnapshotGenerateWithPrev (0.07s) === RUN TestValidateSnapshotGeneratePrevCorrupt -time="2025-05-16T04:10:08Z" level=error msg="Failed to unmarshal existing snapshot for GUN docker.com/notary" ---- PASS: TestValidateSnapshotGeneratePrevCorrupt (0.14s) +time="2024-04-12T21:51:22Z" level=error msg="Failed to unmarshal existing snapshot for GUN docker.com/notary" +--- PASS: TestValidateSnapshotGeneratePrevCorrupt (0.06s) === RUN TestValidateSnapshotGenerateStoreGetCurrentSnapshotBroken ---- PASS: TestValidateSnapshotGenerateStoreGetCurrentSnapshotBroken (0.15s) +--- PASS: TestValidateSnapshotGenerateStoreGetCurrentSnapshotBroken (0.06s) === RUN TestValidateSnapshotGenerateNoTargets ---- PASS: TestValidateSnapshotGenerateNoTargets (0.15s) +--- PASS: TestValidateSnapshotGenerateNoTargets (0.07s) === RUN TestValidateSnapshotGenerate ---- PASS: TestValidateSnapshotGenerate (0.19s) +--- PASS: TestValidateSnapshotGenerate (0.07s) === RUN TestValidateRootNoTimestampKey ---- PASS: TestValidateRootNoTimestampKey (0.13s) +--- PASS: TestValidateRootNoTimestampKey (0.05s) === RUN TestValidateRootInvalidTimestampKey ---- PASS: TestValidateRootInvalidTimestampKey (0.13s) +--- PASS: TestValidateRootInvalidTimestampKey (0.05s) === RUN TestValidateRootInvalidTimestampThreshold ---- PASS: TestValidateRootInvalidTimestampThreshold (0.17s) +--- PASS: TestValidateRootInvalidTimestampThreshold (0.06s) === RUN TestValidateRootInvalidZeroThreshold ---- PASS: TestValidateRootInvalidZeroThreshold (0.26s) +--- PASS: TestValidateRootInvalidZeroThreshold (0.17s) === RUN TestValidateRootRoleMissing ---- PASS: TestValidateRootRoleMissing (0.08s) +--- PASS: TestValidateRootRoleMissing (0.04s) === RUN TestValidateTargetsRoleMissing ---- PASS: TestValidateTargetsRoleMissing (0.05s) +--- PASS: TestValidateTargetsRoleMissing (0.04s) === RUN TestValidateSnapshotRoleMissing ---- PASS: TestValidateSnapshotRoleMissing (0.06s) +--- PASS: TestValidateSnapshotRoleMissing (0.04s) === RUN TestValidateRootSigMissing ---- PASS: TestValidateRootSigMissing (0.05s) +--- PASS: TestValidateRootSigMissing (0.04s) === RUN TestValidateTargetsSigMissing -time="2025-05-16T04:10:10Z" level=error msg="ErrBadTargets: tuf: data has no signatures" ---- PASS: TestValidateTargetsSigMissing (0.06s) +time="2024-04-12T21:51:23Z" level=error msg="ErrBadTargets: tuf: data has no signatures" +--- PASS: TestValidateTargetsSigMissing (0.07s) === RUN TestValidateSnapshotSigMissing ---- PASS: TestValidateSnapshotSigMissing (0.06s) +--- PASS: TestValidateSnapshotSigMissing (0.05s) === RUN TestValidateRootCorrupt ---- PASS: TestValidateRootCorrupt (0.05s) +--- PASS: TestValidateRootCorrupt (0.04s) === RUN TestValidateTargetsCorrupt -time="2025-05-16T04:10:10Z" level=error msg="ErrBadTargets: invalid character '\\u0084' looking for beginning of value" ---- PASS: TestValidateTargetsCorrupt (0.06s) +time="2024-04-12T21:51:23Z" level=error msg="ErrBadTargets: invalid character '\\u0084' looking for beginning of value" +--- PASS: TestValidateTargetsCorrupt (0.05s) === RUN TestValidateSnapshotCorrupt ---- PASS: TestValidateSnapshotCorrupt (0.06s) +--- PASS: TestValidateSnapshotCorrupt (0.05s) === RUN TestValidateRootModifiedSize ---- PASS: TestValidateRootModifiedSize (0.05s) +--- PASS: TestValidateRootModifiedSize (0.04s) === RUN TestValidateTargetsModifiedSize ---- PASS: TestValidateTargetsModifiedSize (0.09s) +--- PASS: TestValidateTargetsModifiedSize (0.06s) === RUN TestValidateRootModifiedHash ---- PASS: TestValidateRootModifiedHash (0.07s) +--- PASS: TestValidateRootModifiedHash (0.05s) === RUN TestValidateTargetsModifiedHash ---- PASS: TestValidateTargetsModifiedHash (0.06s) +--- PASS: TestValidateTargetsModifiedHash (0.05s) === RUN TestGenerateSnapshotRootNotLoaded --- PASS: TestGenerateSnapshotRootNotLoaded (0.00s) === RUN TestGenerateSnapshotNoKey ---- PASS: TestGenerateSnapshotNoKey (0.08s) +--- PASS: TestGenerateSnapshotNoKey (0.05s) === RUN TestLoadTargetsLoadsNothingIfNoUpdates ---- PASS: TestLoadTargetsLoadsNothingIfNoUpdates (0.06s) +--- PASS: TestLoadTargetsLoadsNothingIfNoUpdates (0.04s) === RUN TestValidateTargetsRequiresStoredParent -time="2025-05-16T04:10:11Z" level=error msg="ErrBadTargets: targets must be loaded first" ---- PASS: TestValidateTargetsRequiresStoredParent (0.11s) +time="2024-04-12T21:51:23Z" level=error msg="ErrBadTargets: targets must be loaded first" +--- PASS: TestValidateTargetsRequiresStoredParent (0.06s) === RUN TestValidateTargetsParentInUpdate -time="2025-05-16T04:10:11Z" level=error msg="ErrBadTargets: invalid character 'I' looking for beginning of value" ---- PASS: TestValidateTargetsParentInUpdate (0.13s) +time="2024-04-12T21:51:23Z" level=error msg="ErrBadTargets: invalid character 'I' looking for beginning of value" +--- PASS: TestValidateTargetsParentInUpdate (0.07s) === RUN TestValidateTargetsRoleNotInParent -time="2025-05-16T04:10:11Z" level=error msg="ErrBadTargets: tuf: invalid role targets/level1. delegation does not exist" -time="2025-05-16T04:10:11Z" level=error msg="ErrBadTargets: targets has already been loaded" -time="2025-05-16T04:10:11Z" level=error msg="ErrBadTargets: tuf: invalid role targets/level1. delegation does not exist" ---- PASS: TestValidateTargetsRoleNotInParent (0.11s) +time="2024-04-12T21:51:23Z" level=error msg="ErrBadTargets: tuf: invalid role targets/level1. delegation does not exist" +time="2024-04-12T21:51:23Z" level=error msg="ErrBadTargets: targets has already been loaded" +time="2024-04-12T21:51:23Z" level=error msg="ErrBadTargets: tuf: invalid role targets/level1. delegation does not exist" +--- PASS: TestValidateTargetsRoleNotInParent (0.08s) PASS -ok github.com/theupdateframework/notary/server/handlers 5.854s +ok github.com/theupdateframework/notary/server/handlers 3.605s === RUN TestSnapshotExpired --- PASS: TestSnapshotExpired (0.00s) === RUN TestSnapshotNotExpired --- PASS: TestSnapshotNotExpired (0.00s) === RUN TestGetSnapshotKeyCreate ---- PASS: TestGetSnapshotKeyCreate (0.06s) +--- PASS: TestGetSnapshotKeyCreate (0.05s) === RUN TestGetSnapshotKeyCreateWithFailingStore -time="2025-05-16T04:10:05Z" level=error msg="Error when retrieving root role for GUN gun: failing store failed" +time="2024-04-12T21:51:20Z" level=error msg="Error when retrieving root role for GUN gun: failing store failed" --- PASS: TestGetSnapshotKeyCreateWithFailingStore (0.00s) === RUN TestGetSnapshotKeyCreateWithCorruptedStore -time="2025-05-16T04:10:05Z" level=error msg="Failed to unmarshal existing root for GUN gun to retrieve snapshot key ID" +time="2024-04-12T21:51:20Z" 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.06s) +--- PASS: TestGetSnapshotKeyExistingMetadata (0.05s) === RUN TestGetSnapshotNoPreviousSnapshot -time="2025-05-16T04:10:05Z" level=error msg="Failed to unmarshal existing snapshot for GUN gun" ---- PASS: TestGetSnapshotNoPreviousSnapshot (0.03s) +time="2024-04-12T21:51:20Z" level=error msg="Failed to unmarshal existing snapshot for GUN gun" +--- PASS: TestGetSnapshotNoPreviousSnapshot (0.02s) === RUN TestGetSnapshotReturnsPreviousSnapshotIfUnexpired ---- PASS: TestGetSnapshotReturnsPreviousSnapshotIfUnexpired (0.03s) +--- PASS: TestGetSnapshotReturnsPreviousSnapshotIfUnexpired (0.02s) === RUN TestGetSnapshotOldSnapshotExpired --- PASS: TestGetSnapshotOldSnapshotExpired (0.05s) === RUN TestCannotMakeNewSnapshotIfNoRoot @@ -2929,7 +2965,7 @@ === RUN TestCreateSnapshotNoKeyInCrypto --- PASS: TestCreateSnapshotNoKeyInCrypto (0.04s) PASS -ok github.com/theupdateframework/notary/server/snapshot 0.344s +ok github.com/theupdateframework/notary/server/snapshot 0.271s === RUN TestMemoryUpdateCurrentEmpty --- PASS: TestMemoryUpdateCurrentEmpty (0.00s) === RUN TestMemoryUpdateCurrentVersionCheckOldVersionExists @@ -2955,69 +2991,69 @@ === RUN TestRDBTUFFileJSONUnmarshallingFailure --- PASS: TestRDBTUFFileJSONUnmarshallingFailure (0.00s) === RUN TestSQLUpdateCurrentEmpty ---- PASS: TestSQLUpdateCurrentEmpty (0.33s) +--- PASS: TestSQLUpdateCurrentEmpty (0.05s) === RUN TestSQLUpdateCurrentVersionCheckOldVersionExists ---- PASS: TestSQLUpdateCurrentVersionCheckOldVersionExists (0.19s) +--- PASS: TestSQLUpdateCurrentVersionCheckOldVersionExists (0.02s) === RUN TestSQLUpdateCurrentVersionCheckOldVersionNotExist ---- PASS: TestSQLUpdateCurrentVersionCheckOldVersionNotExist (0.11s) +--- PASS: TestSQLUpdateCurrentVersionCheckOldVersionNotExist (0.03s) === RUN TestSQLUpdateManyNoConflicts ---- PASS: TestSQLUpdateManyNoConflicts (0.12s) +--- PASS: TestSQLUpdateManyNoConflicts (0.05s) === RUN TestSQLUpdateManyConflictRollback ---- PASS: TestSQLUpdateManyConflictRollback (0.20s) +--- PASS: TestSQLUpdateManyConflictRollback (0.02s) === RUN TestSQLDelete ---- PASS: TestSQLDelete (0.11s) +--- PASS: TestSQLDelete (0.04s) === RUN TestSQLDBCheckHealthTableMissing ---- PASS: TestSQLDBCheckHealthTableMissing (0.04s) +--- PASS: TestSQLDBCheckHealthTableMissing (0.01s) === RUN TestSQLDBCheckHealthDBConnectionFail --- PASS: TestSQLDBCheckHealthDBConnectionFail (0.02s) === RUN TestSQLDBCheckHealthSucceeds ---- PASS: TestSQLDBCheckHealthSucceeds (0.06s) +--- PASS: TestSQLDBCheckHealthSucceeds (0.01s) === RUN TestSQLDBGetChecksum ---- PASS: TestSQLDBGetChecksum (0.11s) +--- PASS: TestSQLDBGetChecksum (0.02s) === RUN TestSQLDBGetChecksumNotFound ---- PASS: TestSQLDBGetChecksumNotFound (0.14s) +--- PASS: TestSQLDBGetChecksumNotFound (0.02s) === RUN TestSQLTUFMetaStoreGetCurrent ---- PASS: TestSQLTUFMetaStoreGetCurrent (0.31s) +--- PASS: TestSQLTUFMetaStoreGetCurrent (0.10s) === RUN TestSQLGetChanges ---- PASS: TestSQLGetChanges (0.31s) +--- PASS: TestSQLGetChanges (0.04s) === RUN TestSQLDBGetVersion ---- PASS: TestSQLDBGetVersion (0.06s) +--- PASS: TestSQLDBGetVersion (0.02s) PASS -ok github.com/theupdateframework/notary/server/storage 2.138s +ok github.com/theupdateframework/notary/server/storage 0.478s === RUN TestTimestampExpired --- PASS: TestTimestampExpired (0.00s) === RUN TestTimestampNotExpired --- PASS: TestTimestampNotExpired (0.00s) === RUN TestGetTimestampKey ---- PASS: TestGetTimestampKey (0.06s) +--- PASS: TestGetTimestampKey (0.03s) === RUN TestGetTimestampNoPreviousTimestamp -time="2025-05-16T04:10:05Z" level=error msg="Failed to unmarshal existing timestamp" ---- PASS: TestGetTimestampNoPreviousTimestamp (0.09s) +time="2024-04-12T21:51:21Z" level=error msg="Failed to unmarshal existing timestamp" +--- PASS: TestGetTimestampNoPreviousTimestamp (0.05s) === RUN TestGetTimestampReturnsPreviousTimestampIfUnexpired ---- PASS: TestGetTimestampReturnsPreviousTimestampIfUnexpired (0.05s) +--- PASS: TestGetTimestampReturnsPreviousTimestampIfUnexpired (0.04s) === RUN TestGetTimestampOldTimestampExpired ---- PASS: TestGetTimestampOldTimestampExpired (0.13s) +--- PASS: TestGetTimestampOldTimestampExpired (0.07s) === RUN TestCannotMakeNewTimestampIfNoRootOrSnapshot -time="2025-05-16T04:10:05Z" level=error msg="Failed to create a new timestamp" -time="2025-05-16T04:10:05Z" level=error msg="Failed to create a new timestamp" ---- PASS: TestCannotMakeNewTimestampIfNoRootOrSnapshot (0.07s) +time="2024-04-12T21:51:22Z" level=error msg="Failed to create a new timestamp" +time="2024-04-12T21:51:22Z" level=error msg="Failed to create a new timestamp" +--- PASS: TestCannotMakeNewTimestampIfNoRootOrSnapshot (0.06s) === RUN TestCreateTimestampNoKeyInCrypto -time="2025-05-16T04:10:05Z" level=error msg="Failed to create a new timestamp" ---- PASS: TestCreateTimestampNoKeyInCrypto (0.07s) +time="2024-04-12T21:51:22Z" level=error msg="Failed to create a new timestamp" +--- PASS: TestCreateTimestampNoKeyInCrypto (0.06s) === RUN TestGetTimestampKeyCreateWithFailingStore -time="2025-05-16T04:10:05Z" level=error msg="Error when retrieving root role for GUN gun: failing store failed" +time="2024-04-12T21:51:22Z" level=error msg="Error when retrieving root role for GUN gun: failing store failed" --- PASS: TestGetTimestampKeyCreateWithFailingStore (0.00s) === RUN TestGetTimestampKeyCreateWithCorruptedStore -time="2025-05-16T04:10:05Z" level=error msg="Failed to unmarshal existing root for GUN gun to retrieve timestamp key ID" +time="2024-04-12T21:51:22Z" 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.03s) +--- PASS: TestGetTimestampKeyExistingMetadata (0.02s) PASS -ok github.com/theupdateframework/notary/server/timestamp 0.534s +ok github.com/theupdateframework/notary/server/timestamp 0.342s === RUN TestHealthCheckKMUnhealthy ---- PASS: TestHealthCheckKMUnhealthy (0.01s) +--- PASS: TestHealthCheckKMUnhealthy (0.00s) === RUN TestHealthCheckSignerUnhealthy --- PASS: TestHealthCheckSignerUnhealthy (0.00s) === RUN TestHealthCheckKMTimeout @@ -3037,27 +3073,27 @@ === RUN TestHealthCheckNonexistentService --- PASS: TestHealthCheckNonexistentService (0.00s) === RUN TestGetPrivateKeyAndSignWithExistingKey -time="2025-05-16T04:10:07Z" level=info msg="Sign: Signed message! with KeyID 804cc3074211e664c0e91fdf798ef57f020595662936d3590d25eca92833211f" go.version=go1.22.2 ---- PASS: TestGetPrivateKeyAndSignWithExistingKey (0.05s) +time="2024-04-12T21:51:23Z" level=info msg="Sign: Signed message! with KeyID b770947e7a4be3b12e3f4558a794b057dd3c3cc8128d18aeaf159e8a01b7a0cc" go.version=go1.22.2 +--- PASS: TestGetPrivateKeyAndSignWithExistingKey (0.02s) === RUN TestCannotSignWithKeyThatDoesntExist -time="2025-05-16T04:10:07Z" level=error msg="Sign: key 7d96664e8d66f94a7122f9961bacb8009a3cf7fd94773c7a7cf50f3e1d46a33d not found" go.version=go1.22.2 ---- PASS: TestCannotSignWithKeyThatDoesntExist (0.01s) +time="2024-04-12T21:51:23Z" level=error msg="Sign: key caa6a70ba201e7b208a4c7ae6e6fbbed6b1c96b43412be06df511a88a200ca35 not found" go.version=go1.22.2 +--- PASS: TestCannotSignWithKeyThatDoesntExist (0.00s) === RUN TestCryptoSignerInterfaceBehavior -time="2025-05-16T04:10:07Z" level=error msg="GetKeyInfo: key nonexistent not found" go.version=go1.22.2 -time="2025-05-16T04:10:07Z" level=error msg="GetKeyInfo: key nonexistent not found" go.version=go1.22.2 -time="2025-05-16T04:10:07Z" level=info msg="CreateKey: Created KeyID be5e3433c6e4f1ea472e0c67404cd620509a31697d928e24b880f6c95fa58bea" go.version=go1.22.2 -time="2025-05-16T04:10:07Z" level=info msg="CreateKey: Created KeyID fb5d363c651d95c69fc73cdc914b0e6dc1ff4294c713fd877045e16c0943af09" go.version=go1.22.2 -time="2025-05-16T04:10:07Z" level=error msg="GetKeyInfo: key be5e3433c6e4f1ea472e0c67404cd620509a31697d928e24b880f6c95fa58bea not found" go.version=go1.22.2 -time="2025-05-16T04:10:07Z" level=error msg="GetKeyInfo: key fb5d363c651d95c69fc73cdc914b0e6dc1ff4294c713fd877045e16c0943af09 not found" go.version=go1.22.2 ---- PASS: TestCryptoSignerInterfaceBehavior (0.03s) +time="2024-04-12T21:51:23Z" level=error msg="GetKeyInfo: key nonexistent not found" go.version=go1.22.2 +time="2024-04-12T21:51:23Z" level=error msg="GetKeyInfo: key nonexistent not found" go.version=go1.22.2 +time="2024-04-12T21:51:23Z" level=info msg="CreateKey: Created KeyID 5af01ee57665b431d849ec50bfb28226fc48b9209f664962a856db4d6b9ba829" go.version=go1.22.2 +time="2024-04-12T21:51:23Z" level=info msg="CreateKey: Created KeyID bfa3185dccabe4e2a48bfba590623a1ae051666921cfa640201e1f4290654e96" go.version=go1.22.2 +time="2024-04-12T21:51:23Z" level=error msg="GetKeyInfo: key 5af01ee57665b431d849ec50bfb28226fc48b9209f664962a856db4d6b9ba829 not found" go.version=go1.22.2 +time="2024-04-12T21:51:23Z" level=error msg="GetKeyInfo: key bfa3185dccabe4e2a48bfba590623a1ae051666921cfa640201e1f4290654e96 not found" go.version=go1.22.2 +--- PASS: TestCryptoSignerInterfaceBehavior (0.02s) PASS -ok github.com/theupdateframework/notary/signer 0.136s +ok github.com/theupdateframework/notary/signer 0.065s === RUN TestGetSuccessPopulatesCache ---- PASS: TestGetSuccessPopulatesCache (0.03s) +--- PASS: TestGetSuccessPopulatesCache (0.02s) === RUN TestAddKeyPopulatesCacheIfSuccessful --- PASS: TestAddKeyPopulatesCacheIfSuccessful (0.01s) === RUN TestDeleteKeyRemovesKeyFromCache ---- PASS: TestDeleteKeyRemovesKeyFromCache (0.02s) +--- PASS: TestDeleteKeyRemovesKeyFromCache (0.01s) === RUN TestRDBPrivateKeyJSONUnmarshalling --- PASS: TestRDBPrivateKeyJSONUnmarshalling (0.00s) === RUN TestRDBPrivateKeyJSONUnmarshallingFailure @@ -3066,30 +3102,30 @@ `nodb` is not officially supported, running under compatibility mode. --- PASS: TestNewSQLKeyDBStorePropagatesDBError (0.00s) === RUN TestSQLDBHealthCheckMissingTable ---- PASS: TestSQLDBHealthCheckMissingTable (0.04s) +--- PASS: TestSQLDBHealthCheckMissingTable (0.02s) === RUN TestSQLDBHealthCheckNoConnection ---- PASS: TestSQLDBHealthCheckNoConnection (0.24s) +--- PASS: TestSQLDBHealthCheckNoConnection (0.02s) === RUN TestSQLKeyCanOnlyBeAddedOnce (/build/reproducible-path/notary-0.7.0+ds1/_build/src/github.com/theupdateframework/notary/signer/keydbstore/sql_keydbstore.go:98) -[2025-05-16 04:10:08]  UNIQUE constraint failed: private_keys.key_id  ---- PASS: TestSQLKeyCanOnlyBeAddedOnce (0.44s) +[2024-04-12 21:51:24]  UNIQUE constraint failed: private_keys.key_id  +--- PASS: TestSQLKeyCanOnlyBeAddedOnce (0.12s) === RUN TestSQLCreateDelete ---- PASS: TestSQLCreateDelete (0.15s) +--- PASS: TestSQLCreateDelete (0.14s) === RUN TestSQLKeyRotation ---- PASS: TestSQLKeyRotation (0.31s) +--- PASS: TestSQLKeyRotation (0.16s) === RUN TestSQLSigningMarksKeyActive -time="2025-05-16T04:10:09Z" level=error msg="Key c18983b2d9b8772dfca6caab9e431c99fc6e0158dce0f1e0b412bdd5a769a729 was just used to sign hash successful, db closed, error when trying to mark key as active: sql: database is closed" +time="2024-04-12T21:51:25Z" level=error msg="Key 02aba6d7d9ef19a6548a01395b4ee746ea0136067f7dae95c4f4a9095c87d7c2 was just used to sign hash successful, db closed, error when trying to mark key as active: sql: database is closed" (/build/reproducible-path/notary-0.7.0+ds1/_build/src/github.com/theupdateframework/notary/signer/keydbstore/sql_keydbstore.go:197) -[2025-05-16 04:10:09]  sql: database is closed  ---- PASS: TestSQLSigningMarksKeyActive (0.50s) +[2024-04-12 21:51:25]  sql: database is closed  +--- PASS: TestSQLSigningMarksKeyActive (0.23s) === RUN TestSQLCreateKey ---- PASS: TestSQLCreateKey (0.64s) +--- PASS: TestSQLCreateKey (0.22s) === RUN TestSQLUnimplementedInterfaceBehavior ---- PASS: TestSQLUnimplementedInterfaceBehavior (0.18s) +--- PASS: TestSQLUnimplementedInterfaceBehavior (0.05s) PASS -ok github.com/theupdateframework/notary/signer/keydbstore 2.599s +ok github.com/theupdateframework/notary/signer/keydbstore 1.028s === RUN TestSet --- PASS: TestSet (0.00s) === RUN TestSetWithNoParentDirectory @@ -3127,7 +3163,7 @@ === RUN TestHTTPStoreGetAllMeta --- PASS: TestHTTPStoreGetAllMeta (0.00s) === RUN TestSetSingleAndSetMultiMeta ---- PASS: TestSetSingleAndSetMultiMeta (0.01s) +--- PASS: TestSetSingleAndSetMultiMeta (0.00s) === RUN Test404Error --- PASS: Test404Error (0.00s) === RUN Test50XErrors @@ -3147,7 +3183,7 @@ === RUN TestHTTPStoreGetKey --- PASS: TestHTTPStoreGetKey (0.00s) === RUN TestHTTPStoreGetRotateKeySizeLimited ---- PASS: TestHTTPStoreGetRotateKeySizeLimited (0.05s) +--- PASS: TestHTTPStoreGetRotateKeySizeLimited (0.02s) === RUN TestHTTPOffline --- PASS: TestHTTPOffline (0.00s) === RUN TestErrServerUnavailable @@ -3168,7 +3204,7 @@ === RUN TestMemoryStoreMetadata --- PASS: TestMemoryStoreMetadata (0.00s) PASS -ok github.com/theupdateframework/notary/storage 0.116s +ok github.com/theupdateframework/notary/storage 0.051s === RUN TestExportKeys --- PASS: TestExportKeys (0.00s) === RUN TestExportKeysByGUN @@ -3180,197 +3216,197 @@ === RUN TestImportKeys --- PASS: TestImportKeys (0.00s) === RUN TestImportNoPath ---- PASS: TestImportNoPath (0.03s) +--- PASS: TestImportNoPath (0.01s) === RUN TestNonRootPathInference ---- PASS: TestNonRootPathInference (0.04s) +--- PASS: TestNonRootPathInference (0.01s) === RUN TestBlockHeaderPrecedenceRoleAndGun ---- PASS: TestBlockHeaderPrecedenceRoleAndGun (0.00s) +--- PASS: TestBlockHeaderPrecedenceRoleAndGun (0.01s) === RUN TestBlockHeaderPrecedenceGunFromPath ---- PASS: TestBlockHeaderPrecedenceGunFromPath (0.01s) +--- PASS: TestBlockHeaderPrecedenceGunFromPath (0.00s) === RUN TestImportKeys2InOneFile --- PASS: TestImportKeys2InOneFile (0.00s) === RUN TestImportKeys2InOneFileNoPath --- PASS: TestImportKeys2InOneFileNoPath (0.01s) === RUN TestEncryptedKeyImportFail -time="2025-05-16T04:10:07Z" level=warning msg="failed to import key to store: Invalid key generated, key may be encrypted and does not contain path header" +time="2024-04-12T21:51:25Z" 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.02s) === RUN TestEncryptedKeyImportSuccess ---- PASS: TestEncryptedKeyImportSuccess (0.02s) +--- PASS: TestEncryptedKeyImportSuccess (0.01s) === RUN TestEncryption ---- PASS: TestEncryption (0.01s) +--- PASS: TestEncryption (0.02s) === RUN TestAddKey ---- PASS: TestAddKey (0.23s) +--- PASS: TestAddKey (0.04s) === RUN TestKeyStoreInternalState --- PASS: TestKeyStoreInternalState (0.02s) === RUN TestGet ---- PASS: TestGet (0.03s) +--- PASS: TestGet (0.02s) === RUN TestGetLegacyKey --- PASS: TestGetLegacyKey (0.00s) === RUN TestListKeys ---- PASS: TestListKeys (0.07s) +--- PASS: TestListKeys (0.05s) === RUN TestAddGetKeyMemStore --- PASS: TestAddGetKeyMemStore (0.01s) === RUN TestAddGetKeyInfoMemStore ---- PASS: TestAddGetKeyInfoMemStore (0.05s) +--- PASS: TestAddGetKeyInfoMemStore (0.02s) === RUN TestGetDecryptedWithTamperedCipherText -time="2025-05-16T04:10:08Z" level=error msg="PEM block is empty" +time="2024-04-12T21:51:25Z" level=error msg="PEM block is empty" --- PASS: TestGetDecryptedWithTamperedCipherText (0.01s) === RUN TestGetDecryptedWithInvalidPassphrase ---- PASS: TestGetDecryptedWithInvalidPassphrase (0.06s) +--- PASS: TestGetDecryptedWithInvalidPassphrase (0.03s) === RUN TestGetDecryptedWithConsistentlyInvalidPassphrase --- PASS: TestGetDecryptedWithConsistentlyInvalidPassphrase (0.06s) === RUN TestRemoveKey --- PASS: TestRemoveKey (0.04s) === RUN TestKeysAreCached ---- PASS: TestKeysAreCached (0.02s) +--- PASS: TestKeysAreCached (0.01s) PASS -ok github.com/theupdateframework/notary/trustmanager 0.760s +ok github.com/theupdateframework/notary/trustmanager 0.404s === RUN TestRemoteStore -time="2025-05-16T04:10:08Z" level=info msg="listing files from localhost:9888" -time="2025-05-16T04:10:08Z" level=info msg="listing files from localhost:9888" ---- PASS: TestRemoteStore (0.29s) +time="2024-04-12T21:51:25Z" level=info msg="listing files from localhost:9888" +time="2024-04-12T21:51:25Z" level=info msg="listing files from localhost:9888" +--- PASS: TestRemoteStore (0.14s) === RUN TestErrors -time="2025-05-16T04:10:08Z" level=error msg="failed to store: test error" ---- PASS: TestErrors (0.28s) +time="2024-04-12T21:51:25Z" level=error msg="failed to store: test error" +--- PASS: TestErrors (0.14s) === RUN TestNewGRPCStorage --- PASS: TestNewGRPCStorage (0.00s) === RUN TestGRPCStorage --- PASS: TestGRPCStorage (0.00s) PASS -ok github.com/theupdateframework/notary/trustmanager/remoteks 0.648s +ok github.com/theupdateframework/notary/trustmanager/remoteks 0.288s === RUN TestWildcardMatch --- PASS: TestWildcardMatch (0.00s) === RUN TestValidateRoot -2025/05/16 04:10:08 [INFO] generate received request -2025/05/16 04:10:08 [INFO] received CSR -2025/05/16 04:10:08 [INFO] generating key: ecdsa-256 -2025/05/16 04:10:08 [INFO] encoded CSR -2025/05/16 04:10:08 [INFO] signed certificate with serial number 599646542850581310657507833428440459984040377557 -2025/05/16 04:10:08 [INFO] received CSR -2025/05/16 04:10:08 [INFO] generating key: ecdsa-256 -2025/05/16 04:10:08 [INFO] encoded CSR -2025/05/16 04:10:08 [INFO] signed certificate with serial number 35131631409423798229480562687082280486850001752 -2025/05/16 04:10:08 [INFO] received CSR -2025/05/16 04:10:08 [INFO] generating key: ecdsa-256 -2025/05/16 04:10:08 [INFO] encoded CSR -2025/05/16 04:10:08 [INFO] signed certificate with serial number 715875672298794711561402759062079722285028932573 ---- PASS: TestValidateRoot (0.40s) +2024/04/12 21:51:27 [INFO] generate received request +2024/04/12 21:51:27 [INFO] received CSR +2024/04/12 21:51:27 [INFO] generating key: ecdsa-256 +2024/04/12 21:51:27 [INFO] encoded CSR +2024/04/12 21:51:27 [INFO] signed certificate with serial number 203101106360240732728916257959828857524065364970 +2024/04/12 21:51:27 [INFO] received CSR +2024/04/12 21:51:27 [INFO] generating key: ecdsa-256 +2024/04/12 21:51:27 [INFO] encoded CSR +2024/04/12 21:51:27 [INFO] signed certificate with serial number 475673658727459506725638141444170111739314036879 +2024/04/12 21:51:27 [INFO] received CSR +2024/04/12 21:51:27 [INFO] generating key: ecdsa-256 +2024/04/12 21:51:27 [INFO] encoded CSR +2024/04/12 21:51:27 [INFO] signed certificate with serial number 260688175935864670460243489351062058890239734831 +--- PASS: TestValidateRoot (0.13s) === RUN TestValidateRootWithoutTOFUS --- PASS: TestValidateRootWithoutTOFUS (0.00s) === RUN TestValidateRootWithPinnedCert ---- PASS: TestValidateRootWithPinnedCert (0.03s) +--- PASS: TestValidateRootWithPinnedCert (0.01s) === RUN TestValidateRootWithPinnedCertAndIntermediates ---- PASS: TestValidateRootWithPinnedCertAndIntermediates (0.16s) +--- PASS: TestValidateRootWithPinnedCertAndIntermediates (0.05s) === RUN TestValidateRootFailuresWithPinnedCert ---- PASS: TestValidateRootFailuresWithPinnedCert (0.02s) +--- PASS: TestValidateRootFailuresWithPinnedCert (0.01s) === RUN TestValidateRootWithPinnedCA ---- PASS: TestValidateRootWithPinnedCA (0.28s) +--- PASS: TestValidateRootWithPinnedCA (0.09s) === RUN TestValidateSuccessfulRootRotation ---- PASS: TestValidateSuccessfulRootRotation (0.32s) +--- PASS: TestValidateSuccessfulRootRotation (0.13s) === RUN TestValidateRootRotationMissingOrigSig ---- PASS: TestValidateRootRotationMissingOrigSig (0.20s) +--- PASS: TestValidateRootRotationMissingOrigSig (0.12s) === RUN TestValidateRootRotationMissingNewSig ---- PASS: TestValidateRootRotationMissingNewSig (0.21s) +--- PASS: TestValidateRootRotationMissingNewSig (0.12s) === RUN TestValidateRootRotationTrustPinning ---- PASS: TestValidateRootRotationTrustPinning (0.23s) +--- PASS: TestValidateRootRotationTrustPinning (0.10s) === RUN TestValidateRootRotationTrustPinningInvalidCA ---- PASS: TestValidateRootRotationTrustPinningInvalidCA (0.09s) +--- PASS: TestValidateRootRotationTrustPinningInvalidCA (0.08s) === RUN TestParsePEMPublicKey -time="2025-05-16T04:10:09Z" level=warning msg="certificate with CN notary is near expiry" ---- PASS: TestParsePEMPublicKey (0.05s) +time="2024-04-12T21:51:28Z" level=warning msg="certificate with CN notary is near expiry" +--- PASS: TestParsePEMPublicKey (0.02s) === RUN TestCheckingCertExpiry -time="2025-05-16T04:10:09Z" level=warning msg="certificate with CN notary is near expiry" +time="2024-04-12T21:51:28Z" level=warning msg="certificate with CN notary is near expiry" --- PASS: TestCheckingCertExpiry (0.03s) === RUN TestValidateRootWithExpiredIntermediate ---- PASS: TestValidateRootWithExpiredIntermediate (0.01s) +--- PASS: TestValidateRootWithExpiredIntermediate (0.02s) === RUN TestCheckingWildcardCert ---- PASS: TestCheckingWildcardCert (0.01s) +--- PASS: TestCheckingWildcardCert (0.02s) === RUN TestWildcardMatching --- PASS: TestWildcardMatching (0.00s) PASS -ok github.com/theupdateframework/notary/trustpinning 2.132s +ok github.com/theupdateframework/notary/trustpinning 0.926s === RUN TestInitSnapshotNoTargets ---- PASS: TestInitSnapshotNoTargets (0.09s) +--- PASS: TestInitSnapshotNoTargets (0.03s) === RUN TestInitRepo ---- PASS: TestInitRepo (0.06s) +--- PASS: TestInitRepo (0.02s) === RUN TestUpdateDelegations ---- PASS: TestUpdateDelegations (0.01s) +--- PASS: TestUpdateDelegations (0.00s) === RUN TestPurgeDelegationsKeyFromTop -time="2025-05-16T04:10:07Z" 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-05-16T04:10:07Z" 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.01s) +time="2024-04-12T21:51:27Z" 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-04-12T21:51:27Z" 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-05-16T04:10:08Z" 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.01s) +time="2024-04-12T21:51:27Z" 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) === RUN TestUpdateDelegationsParentMissing --- PASS: TestUpdateDelegationsParentMissing (0.00s) === RUN TestUpdateDelegationsMissingParentKey ---- PASS: TestUpdateDelegationsMissingParentKey (0.01s) +--- PASS: TestUpdateDelegationsMissingParentKey (0.00s) === RUN TestUpdateDelegationsInvalidRole --- PASS: TestUpdateDelegationsInvalidRole (0.00s) === RUN TestUpdateDelegationsRoleThatIsMissingDelegationKey --- PASS: TestUpdateDelegationsRoleThatIsMissingDelegationKey (0.00s) === RUN TestUpdateDelegationsNotEnoughKeys -time="2025-05-16T04:10:08Z" 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.01s) +time="2024-04-12T21:51:27Z" 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) +--- PASS: TestUpdateDelegationsAddKeyToRole (0.01s) === RUN TestDeleteDelegations ---- PASS: TestDeleteDelegations (0.01s) +--- PASS: TestDeleteDelegations (0.00s) === RUN TestDeleteDelegationsRoleNotExistBecauseNoParentMeta --- PASS: TestDeleteDelegationsRoleNotExistBecauseNoParentMeta (0.00s) === RUN TestDeleteDelegationsRoleNotExist ---- PASS: TestDeleteDelegationsRoleNotExist (0.01s) +--- PASS: TestDeleteDelegationsRoleNotExist (0.00s) === RUN TestDeleteDelegationsInvalidRole --- PASS: TestDeleteDelegationsInvalidRole (0.00s) === RUN TestDeleteDelegationsParentMissing ---- PASS: TestDeleteDelegationsParentMissing (0.01s) +--- PASS: TestDeleteDelegationsParentMissing (0.00s) === RUN TestDeleteDelegationsMissingParentSigningKey ---- PASS: TestDeleteDelegationsMissingParentSigningKey (0.01s) +--- PASS: TestDeleteDelegationsMissingParentSigningKey (0.00s) === RUN TestDeleteDelegationsMidSliceRole --- PASS: TestDeleteDelegationsMidSliceRole (0.00s) === RUN TestGetDelegationRoleAndMetadataExistDelegationExists --- PASS: TestGetDelegationRoleAndMetadataExistDelegationExists (0.00s) === RUN TestGetDelegationRoleAndMetadataExistDelegationDoesntExists ---- PASS: TestGetDelegationRoleAndMetadataExistDelegationDoesntExists (0.01s) +--- PASS: TestGetDelegationRoleAndMetadataExistDelegationDoesntExists (0.00s) === RUN TestGetDelegationRoleAndMetadataDoesntExists ---- PASS: TestGetDelegationRoleAndMetadataDoesntExists (0.01s) +--- PASS: TestGetDelegationRoleAndMetadataDoesntExists (0.00s) === RUN TestGetDelegationParentMissing --- PASS: TestGetDelegationParentMissing (0.00s) === RUN TestAddTargetsRoleAndMetadataExist ---- PASS: TestAddTargetsRoleAndMetadataExist (0.01s) +--- PASS: TestAddTargetsRoleAndMetadataExist (0.00s) === RUN TestAddTargetsRoleExistsAndMetadataDoesntExist ---- PASS: TestAddTargetsRoleExistsAndMetadataDoesntExist (0.01s) +--- PASS: TestAddTargetsRoleExistsAndMetadataDoesntExist (0.00s) === RUN TestAddTargetsRoleDoesntExist --- PASS: TestAddTargetsRoleDoesntExist (0.00s) === RUN TestAddTargetsNoSigningKeys ---- PASS: TestAddTargetsNoSigningKeys (0.01s) +--- PASS: TestAddTargetsNoSigningKeys (0.00s) === RUN TestRemoveExistingAndNonexistingTargets ---- PASS: TestRemoveExistingAndNonexistingTargets (0.01s) +--- PASS: TestRemoveExistingAndNonexistingTargets (0.00s) === RUN TestRemoveTargetsRoleDoesntExist --- PASS: TestRemoveTargetsRoleDoesntExist (0.00s) === RUN TestRemoveTargetsNoSigningKeys --- PASS: TestRemoveTargetsNoSigningKeys (0.00s) === RUN TestAddBaseKeysToRoot ---- PASS: TestAddBaseKeysToRoot (0.06s) +--- PASS: TestAddBaseKeysToRoot (0.01s) === RUN TestRemoveBaseKeysFromRoot ---- PASS: TestRemoveBaseKeysFromRoot (0.02s) +--- PASS: TestRemoveBaseKeysFromRoot (0.01s) === RUN TestReplaceBaseKeysInRoot ---- PASS: TestReplaceBaseKeysInRoot (0.05s) +--- PASS: TestReplaceBaseKeysInRoot (0.03s) === RUN TestGetAllRoles --- PASS: TestGetAllRoles (0.00s) === RUN TestGetBaseRoles ---- PASS: TestGetBaseRoles (0.01s) +--- PASS: TestGetBaseRoles (0.00s) === RUN TestGetBaseRolesInvalidName --- PASS: TestGetBaseRolesInvalidName (0.00s) === RUN TestGetDelegationValidRoles ---- PASS: TestGetDelegationValidRoles (0.01s) +--- PASS: TestGetDelegationValidRoles (0.00s) === RUN TestGetDelegationRolesInvalidName --- PASS: TestGetDelegationRolesInvalidName (0.00s) === RUN TestGetDelegationRolesInvalidPaths ---- PASS: TestGetDelegationRolesInvalidPaths (0.01s) +--- PASS: TestGetDelegationRolesInvalidPaths (0.00s) === RUN TestDelegationRolesParent --- PASS: TestDelegationRolesParent (0.00s) === RUN TestGetBaseRoleEmptyRepo @@ -3378,15 +3414,15 @@ === RUN TestGetBaseRoleKeyMissing --- PASS: TestGetBaseRoleKeyMissing (0.00s) === RUN TestGetDelegationRoleKeyMissing ---- PASS: TestGetDelegationRoleKeyMissing (0.01s) +--- PASS: TestGetDelegationRoleKeyMissing (0.00s) === RUN TestSignRootOldKeyCertExists ---- PASS: TestSignRootOldKeyCertExists (0.15s) +--- PASS: TestSignRootOldKeyCertExists (0.10s) === RUN TestSignRootOldKeyCertMissing ---- PASS: TestSignRootOldKeyCertMissing (0.20s) +--- PASS: TestSignRootOldKeyCertMissing (0.06s) === RUN TestRootKeyRotation ---- PASS: TestRootKeyRotation (0.56s) +--- PASS: TestRootKeyRotation (0.26s) === RUN TestBuilderLoadsValidRolesOnly ---- PASS: TestBuilderLoadsValidRolesOnly (0.07s) +--- PASS: TestBuilderLoadsValidRolesOnly (0.08s) === RUN TestBuilderOnlyAcceptsRootFirstWhenLoading --- PASS: TestBuilderOnlyAcceptsRootFirstWhenLoading (0.01s) === RUN TestBuilderOnlyAcceptsDelegationsAfterParent @@ -3394,27 +3430,27 @@ === RUN TestMarkingIsValid --- PASS: TestMarkingIsValid (0.04s) === RUN TestBuilderLoadInvalidDelegations ---- PASS: TestBuilderLoadInvalidDelegations (0.27s) +--- PASS: TestBuilderLoadInvalidDelegations (0.06s) === RUN TestBuilderLoadInvalidDelegationsOldVersion ---- PASS: TestBuilderLoadInvalidDelegationsOldVersion (0.16s) +--- PASS: TestBuilderLoadInvalidDelegationsOldVersion (0.06s) === RUN TestBuilderAcceptRoleOnce ---- PASS: TestBuilderAcceptRoleOnce (0.04s) +--- PASS: TestBuilderAcceptRoleOnce (0.03s) === RUN TestBuilderStopsAcceptingOrProducingDataOnceDone --- PASS: TestBuilderStopsAcceptingOrProducingDataOnceDone (0.02s) === RUN TestGenerateSnapshotInvalidOperations ---- PASS: TestGenerateSnapshotInvalidOperations (0.30s) +--- PASS: TestGenerateSnapshotInvalidOperations (0.27s) === RUN TestGenerateTimestampInvalidOperations ---- PASS: TestGenerateTimestampInvalidOperations (0.20s) +--- PASS: TestGenerateTimestampInvalidOperations (0.19s) === RUN TestGetConsistentInfo ---- PASS: TestGetConsistentInfo (0.07s) +--- PASS: TestGetConsistentInfo (0.06s) === RUN TestTimestampPreAndPostChecksumming --- PASS: TestTimestampPreAndPostChecksumming (0.11s) === RUN TestSnapshotLoadedFirstChecksumsOthers ---- PASS: TestSnapshotLoadedFirstChecksumsOthers (0.19s) +--- PASS: TestSnapshotLoadedFirstChecksumsOthers (0.09s) === RUN TestSnapshotLoadedAfterChecksumsOthersRetroactively ---- PASS: TestSnapshotLoadedAfterChecksumsOthersRetroactively (0.33s) +--- PASS: TestSnapshotLoadedAfterChecksumsOthersRetroactively (0.20s) PASS -ok github.com/theupdateframework/notary/tuf 3.310s +ok github.com/theupdateframework/notary/tuf 1.890s === RUN TestMergeStrSlicesExclusive --- PASS: TestMergeStrSlicesExclusive (0.00s) === RUN TestMergeStrSlicesOverlap @@ -3462,9 +3498,9 @@ === RUN TestRootFromSignedCopiesSignatures --- PASS: TestRootFromSignedCopiesSignatures (0.00s) === RUN TestRootFromSignedValidatesRoleData ---- PASS: TestRootFromSignedValidatesRoleData (0.02s) +--- PASS: TestRootFromSignedValidatesRoleData (0.01s) === RUN TestRootFromSignedValidatesRoleType ---- PASS: TestRootFromSignedValidatesRoleType (0.01s) +--- PASS: TestRootFromSignedValidatesRoleType (0.00s) === RUN TestRootFromSignedValidatesVersion --- PASS: TestRootFromSignedValidatesVersion (0.00s) === RUN TestSnapshotToSignedMarshalsSignedPortionWithCanonicalJSON @@ -3504,7 +3540,7 @@ === RUN TestTargetsFromSignedCopiesSignatures --- PASS: TestTargetsFromSignedCopiesSignatures (0.00s) === RUN TestTargetsFromSignedValidatesDelegations ---- PASS: TestTargetsFromSignedValidatesDelegations (0.01s) +--- PASS: TestTargetsFromSignedValidatesDelegations (0.00s) === RUN TestTargetsFromSignedValidatesRoleType --- PASS: TestTargetsFromSignedValidatesRoleType (0.00s) === RUN TestTargetsFromSignedValidatesRoleName @@ -3548,39 +3584,39 @@ === RUN TestFileMetaEquals --- PASS: TestFileMetaEquals (0.00s) PASS -ok github.com/theupdateframework/notary/tuf/data 0.140s +ok github.com/theupdateframework/notary/tuf/data 0.033s === RUN TestListKeys ---- PASS: TestListKeys (0.09s) +--- PASS: TestListKeys (0.03s) === RUN TestGetKeys --- PASS: TestGetKeys (0.00s) === RUN TestBasicSign --- PASS: TestBasicSign (0.00s) === RUN TestReSign ---- PASS: TestReSign (0.01s) +--- PASS: TestReSign (0.00s) === RUN TestMultiSign ---- PASS: TestMultiSign (0.04s) +--- PASS: TestMultiSign (0.01s) === RUN TestSignReturnsNoSigs --- PASS: TestSignReturnsNoSigs (0.00s) === RUN TestSignWithX509 ---- PASS: TestSignWithX509 (0.02s) +--- PASS: TestSignWithX509 (0.01s) === RUN TestSignRemovesValidSigByInvalidKey ---- PASS: TestSignRemovesValidSigByInvalidKey (0.01s) +--- PASS: TestSignRemovesValidSigByInvalidKey (0.00s) === RUN TestSignRemovesInvalidSig ---- PASS: TestSignRemovesInvalidSig (0.01s) +--- PASS: TestSignRemovesInvalidSig (0.00s) === RUN TestSignMinSignatures ---- PASS: TestSignMinSignatures (0.01s) +--- PASS: TestSignMinSignatures (0.00s) === RUN TestSignFailingKeys ---- PASS: TestSignFailingKeys (0.03s) +--- PASS: TestSignFailingKeys (0.02s) === RUN TestErrInsufficientSignaturesMessaging --- PASS: TestErrInsufficientSignaturesMessaging (0.00s) === RUN TestRSAPSSVerifier ---- PASS: TestRSAPSSVerifier (0.04s) +--- PASS: TestRSAPSSVerifier (0.02s) === RUN TestRSAPSSx509Verifier ---- PASS: TestRSAPSSx509Verifier (0.02s) +--- PASS: TestRSAPSSx509Verifier (0.01s) === RUN TestRSAPSSVerifierWithInvalidKeyType --- PASS: TestRSAPSSVerifierWithInvalidKeyType (0.00s) === RUN TestRSAPSSVerifierWithInvalidKeyLength ---- PASS: TestRSAPSSVerifierWithInvalidKeyLength (0.29s) +--- PASS: TestRSAPSSVerifierWithInvalidKeyLength (0.27s) === RUN TestRSAPSSVerifierWithInvalidKey --- PASS: TestRSAPSSVerifierWithInvalidKey (0.00s) === RUN TestRSAPSSVerifierWithInvalidSignature @@ -3594,14 +3630,14 @@ === RUN TestRSAPKCS1v15VerifierWithInvalidKey --- PASS: TestRSAPKCS1v15VerifierWithInvalidKey (0.00s) === RUN TestRSAPKCS1v15VerifierWithInvalidSignature -time="2025-05-16T04:10:08Z" level=error msg="Failed verification: crypto/rsa: verification error" +time="2024-04-12T21:51:28Z" level=error msg="Failed verification: crypto/rsa: verification error" --- PASS: TestRSAPKCS1v15VerifierWithInvalidSignature (0.02s) === RUN TestECDSAVerifier ---- PASS: TestECDSAVerifier (0.01s) +--- PASS: TestECDSAVerifier (0.02s) === RUN TestECDSAVerifierOtherCurves ---- PASS: TestECDSAVerifierOtherCurves (0.65s) +--- PASS: TestECDSAVerifierOtherCurves (0.44s) === RUN TestECDSAx509Verifier ---- PASS: TestECDSAx509Verifier (0.01s) +--- PASS: TestECDSAx509Verifier (0.00s) === RUN TestECDSAVerifierWithInvalidKeyType --- PASS: TestECDSAVerifierWithInvalidKeyType (0.00s) === RUN TestECDSAVerifierWithInvalidKey @@ -3627,7 +3663,7 @@ === RUN TestIsValidNotExported --- PASS: TestIsValidNotExported (0.00s) === RUN TestMoreThanEnoughSigs ---- PASS: TestMoreThanEnoughSigs (0.01s) +--- PASS: TestMoreThanEnoughSigs (0.00s) === RUN TestValidSigWithIncorrectKeyID --- PASS: TestValidSigWithIncorrectKeyID (0.00s) === RUN TestDuplicateSigs @@ -3637,68 +3673,68 @@ === RUN TestVerifyVersion --- PASS: TestVerifyVersion (0.00s) === RUN TestVerifyExpiry -time="2025-05-16T04:10:09Z" level=error msg="Metadata for root expired" +time="2024-04-12T21:51:28Z" 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 1.412s +ok github.com/theupdateframework/notary/tuf/signed 0.938s === RUN TestNewSwizzler ---- PASS: TestNewSwizzler (0.19s) +--- PASS: TestNewSwizzler (0.10s) === RUN TestSwizzlerSetInvalidJSON ---- PASS: TestSwizzlerSetInvalidJSON (0.12s) +--- PASS: TestSwizzlerSetInvalidJSON (0.06s) === RUN TestSwizzlerAddExtraSpace ---- PASS: TestSwizzlerAddExtraSpace (0.11s) +--- PASS: TestSwizzlerAddExtraSpace (0.08s) === RUN TestSwizzlerSetInvalidSigned ---- PASS: TestSwizzlerSetInvalidSigned (0.10s) +--- PASS: TestSwizzlerSetInvalidSigned (0.08s) === RUN TestSwizzlerSetInvalidSignedMeta --- PASS: TestSwizzlerSetInvalidSignedMeta (0.08s) === RUN TestSwizzlerSetInvalidMetadataType ---- PASS: TestSwizzlerSetInvalidMetadataType (0.13s) +--- PASS: TestSwizzlerSetInvalidMetadataType (0.07s) === RUN TestSwizzlerInvalidateMetadataSignatures ---- PASS: TestSwizzlerInvalidateMetadataSignatures (0.14s) +--- PASS: TestSwizzlerInvalidateMetadataSignatures (0.07s) === RUN TestSwizzlerRemoveMetadata ---- PASS: TestSwizzlerRemoveMetadata (0.09s) +--- PASS: TestSwizzlerRemoveMetadata (0.06s) === RUN TestSwizzlerSignMetadataWithInvalidKey ---- PASS: TestSwizzlerSignMetadataWithInvalidKey (0.13s) +--- PASS: TestSwizzlerSignMetadataWithInvalidKey (0.07s) === RUN TestSwizzlerOffsetMetadataVersion ---- PASS: TestSwizzlerOffsetMetadataVersion (0.10s) +--- PASS: TestSwizzlerOffsetMetadataVersion (0.08s) === RUN TestSwizzlerExpireMetadata ---- PASS: TestSwizzlerExpireMetadata (0.18s) +--- PASS: TestSwizzlerExpireMetadata (0.07s) === RUN TestSwizzlerSetThresholdBaseRole ---- PASS: TestSwizzlerSetThresholdBaseRole (0.20s) +--- PASS: TestSwizzlerSetThresholdBaseRole (0.06s) === RUN TestSwizzlerSetThresholdDelegatedRole ---- PASS: TestSwizzlerSetThresholdDelegatedRole (0.16s) +--- PASS: TestSwizzlerSetThresholdDelegatedRole (0.06s) === RUN TestSwizzlerChangeRootKey ---- PASS: TestSwizzlerChangeRootKey (0.19s) +--- PASS: TestSwizzlerChangeRootKey (0.07s) === RUN TestSwizzlerUpdateSnapshotHashesSpecifiedRoles ---- PASS: TestSwizzlerUpdateSnapshotHashesSpecifiedRoles (0.10s) +--- PASS: TestSwizzlerUpdateSnapshotHashesSpecifiedRoles (0.06s) === RUN TestSwizzlerUpdateSnapshotHashesNoSpecifiedRoles ---- PASS: TestSwizzlerUpdateSnapshotHashesNoSpecifiedRoles (0.08s) +--- PASS: TestSwizzlerUpdateSnapshotHashesNoSpecifiedRoles (0.06s) === RUN TestSwizzlerUpdateTimestamp ---- PASS: TestSwizzlerUpdateTimestamp (0.08s) +--- PASS: TestSwizzlerUpdateTimestamp (0.06s) === RUN TestMissingSigningKey ---- PASS: TestMissingSigningKey (0.08s) +--- PASS: TestMissingSigningKey (0.06s) === RUN TestSwizzlerMutateRoot ---- PASS: TestSwizzlerMutateRoot (0.08s) +--- PASS: TestSwizzlerMutateRoot (0.06s) === RUN TestSwizzlerMutateTimestamp ---- PASS: TestSwizzlerMutateTimestamp (0.08s) +--- PASS: TestSwizzlerMutateTimestamp (0.06s) === RUN TestSwizzlerMutateSnapshot ---- PASS: TestSwizzlerMutateSnapshot (0.10s) +--- PASS: TestSwizzlerMutateSnapshot (0.06s) === RUN TestSwizzlerMutateTargets ---- PASS: TestSwizzlerMutateTargets (0.12s) +--- PASS: TestSwizzlerMutateTargets (0.07s) === RUN TestSwizzlerRotateKeyBaseRole --- PASS: TestSwizzlerRotateKeyBaseRole (0.11s) === RUN TestSwizzlerRotateKeyDelegationRole ---- PASS: TestSwizzlerRotateKeyDelegationRole (0.10s) +--- PASS: TestSwizzlerRotateKeyDelegationRole (0.07s) PASS -ok github.com/theupdateframework/notary/tuf/testutils 2.881s +ok github.com/theupdateframework/notary/tuf/testutils 1.644s === RUN TestConvertTUFKeyToPKCS8 ---- PASS: TestConvertTUFKeyToPKCS8 (0.21s) +--- PASS: TestConvertTUFKeyToPKCS8 (0.08s) === RUN TestParsePKCS8ToTufKey ---- PASS: TestParsePKCS8ToTufKey (0.81s) +--- PASS: TestParsePKCS8ToTufKey (0.39s) === RUN TestPEMtoPEM --- PASS: TestPEMtoPEM (0.00s) === RUN TestRoleListLen @@ -3740,29 +3776,29 @@ === RUN TestRoleNameSliceRemove --- PASS: TestRoleNameSliceRemove (0.00s) === RUN TestCertsToKeys ---- PASS: TestCertsToKeys (0.01s) +--- PASS: TestCertsToKeys (0.00s) === RUN TestNewCertificate --- PASS: TestNewCertificate (0.00s) === RUN TestKeyOperations ---- PASS: TestKeyOperations (0.12s) +--- PASS: TestKeyOperations (0.05s) === RUN TestRSAX509PublickeyID --- PASS: TestRSAX509PublickeyID (0.00s) === RUN TestECDSAX509PublickeyID ---- PASS: TestECDSAX509PublickeyID (0.02s) +--- PASS: TestECDSAX509PublickeyID (0.01s) === RUN TestExtractPrivateKeyAttributes --- PASS: TestExtractPrivateKeyAttributes (0.00s) === RUN TestParsePEMPrivateKeyLegacy ---- PASS: TestParsePEMPrivateKeyLegacy (0.01s) +--- PASS: TestParsePEMPrivateKeyLegacy (0.00s) === RUN TestValidateCertificateWithSHA1 ---- PASS: TestValidateCertificateWithSHA1 (0.02s) +--- PASS: TestValidateCertificateWithSHA1 (0.01s) === RUN TestValidateCertificateWithExpiredCert --- PASS: TestValidateCertificateWithExpiredCert (0.01s) === RUN TestValidateCertificateWithInvalidExpiry --- PASS: TestValidateCertificateWithInvalidExpiry (0.01s) === RUN TestValidateCertificateWithShortKey ---- PASS: TestValidateCertificateWithShortKey (0.21s) +--- PASS: TestValidateCertificateWithShortKey (0.17s) PASS -ok github.com/theupdateframework/notary/tuf/utils 1.513s +ok github.com/theupdateframework/notary/tuf/utils 0.739s === RUN TestNewSerializableErrorNonValidationError --- PASS: TestNewSerializableErrorNonValidationError (0.00s) === RUN TestNewSerializableErrorValidationError @@ -3778,9 +3814,9 @@ === RUN TestUnmarshalInvalidJSON --- PASS: TestUnmarshalInvalidJSON (0.00s) PASS -ok github.com/theupdateframework/notary/tuf/validation 0.065s +ok github.com/theupdateframework/notary/tuf/validation 0.007s === RUN TestSetSignalTrap ---- PASS: TestSetSignalTrap (0.03s) +--- PASS: TestSetSignalTrap (0.00s) === 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 @@ -3844,7 +3880,7 @@ === RUN TestParseTLSWithTLSRelativeToConfigFile --- PASS: TestParseTLSWithTLSRelativeToConfigFile (0.00s) === RUN TestParseTLSWithEnvironmentVariables ---- PASS: TestParseTLSWithEnvironmentVariables (0.01s) +--- PASS: TestParseTLSWithEnvironmentVariables (0.00s) === RUN TestParseViperWithInvalidFile --- PASS: TestParseViperWithInvalidFile (0.00s) === RUN TestParseViperWithValidFile @@ -3852,7 +3888,7 @@ === RUN TestAdjustLogLevel --- PASS: TestAdjustLogLevel (0.00s) === RUN TestRootHandlerFactory ---- PASS: TestRootHandlerFactory (0.04s) +--- PASS: TestRootHandlerFactory (0.00s) === RUN TestRootHandlerError --- PASS: TestRootHandlerError (0.00s) === RUN TestWrapWithCacheHeaderNilCacheControlConfig @@ -3878,7 +3914,7 @@ === RUN TestDoAuthWildcardImage --- PASS: TestDoAuthWildcardImage (0.00s) PASS -ok github.com/theupdateframework/notary/utils 0.127s +ok github.com/theupdateframework/notary/utils 0.021s 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 @@ -3907,8 +3943,8 @@ dh_missing -O--builddirectory=/build/reproducible-path/notary-0.7.0\+ds1/_build -O--buildsystem=golang dh_strip -a -O--builddirectory=/build/reproducible-path/notary-0.7.0\+ds1/_build -O--buildsystem=golang dh_strip: warning: Could not find the BuildID in debian/notary/usr/bin/notary-server -dh_strip: warning: Could not find the BuildID in debian/notary/usr/bin/escrow dh_strip: warning: Could not find the BuildID in debian/notary/usr/bin/notary-signer +dh_strip: warning: Could not find the BuildID in debian/notary/usr/bin/escrow dh_makeshlibs -a -O--builddirectory=/build/reproducible-path/notary-0.7.0\+ds1/_build -O--buildsystem=golang dh_shlibdeps -a -O--builddirectory=/build/reproducible-path/notary-0.7.0\+ds1/_build -O--buildsystem=golang dh_installdeb -O--builddirectory=/build/reproducible-path/notary-0.7.0\+ds1/_build -O--buildsystem=golang @@ -3928,12 +3964,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/25686/tmp/hooks/B01_cleanup starting +I: user script /srv/workspace/pbuilder/25686/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/112815 and its subdirectories -I: Current time: Thu May 15 16:12:10 -12 2025 -I: pbuilder-time-stamp: 1747368730 +I: removing directory /srv/workspace/pbuilder/25686 and its subdirectories +I: Current time: Sat Apr 13 11:53:29 +14 2024 +I: pbuilder-time-stamp: 1712958809