Diff of the two buildlogs: -- --- b1/build.log 2024-01-06 13:09:42.320426469 +0000 +++ b2/build.log 2024-01-06 13:19:36.251420960 +0000 @@ -1,6 +1,6 @@ I: pbuilder: network access will be disabled during build -I: Current time: Fri Feb 7 07:30:36 -12 2025 -I: pbuilder-time-stamp: 1738956636 +I: Current time: Sun Jan 7 03:09:45 +14 2024 +I: pbuilder-time-stamp: 1704546585 I: Building the build Environment I: extracting base tarball [/var/cache/pbuilder/bookworm-reproducible-base.tgz] I: copying local configuration @@ -31,49 +31,81 @@ 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/4175658/tmp/hooks/D02_print_environment starting +I: user script /srv/workspace/pbuilder/2339407/tmp/hooks/D01_modify_environment starting +debug: Running on ionos11-amd64. +I: Changing host+domainname to test build reproducibility +I: Adding a custom variable just for the fun of it... +I: Changing /bin/sh to bash +'/bin/sh' -> '/bin/bash' +lrwxrwxrwx 1 root root 9 Jan 6 13:09 /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/2339407/tmp/hooks/D01_modify_environment finished +I: user script /srv/workspace/pbuilder/2339407/tmp/hooks/D02_print_environment starting I: set - BUILDDIR='/build/reproducible-path' - BUILDUSERGECOS='first user,first room,first work-phone,first home-phone,first other' - BUILDUSERNAME='pbuilder1' - BUILD_ARCH='amd64' - DEBIAN_FRONTEND='noninteractive' - DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all parallel=16 ' - DISTRIBUTION='bookworm' - HOME='/root' - HOST_ARCH='amd64' + BASH=/bin/sh + BASHOPTS=checkwinsize:cmdhist:complete_fullquote:extquote:force_fignore:globasciiranges:globskipdots:hostcomplete:interactive_comments:patsub_replacement:progcomp:promptvars:sourcepath + BASH_ALIASES=() + BASH_ARGC=() + BASH_ARGV=() + BASH_CMDS=() + BASH_LINENO=([0]="12" [1]="0") + BASH_LOADABLES_PATH=/usr/local/lib/bash:/usr/lib/bash:/opt/local/lib/bash:/usr/pkg/lib/bash:/opt/pkg/lib/bash:. + BASH_SOURCE=([0]="/tmp/hooks/D02_print_environment" [1]="/tmp/hooks/D02_print_environment") + BASH_VERSINFO=([0]="5" [1]="2" [2]="15" [3]="1" [4]="release" [5]="x86_64-pc-linux-gnu") + BASH_VERSION='5.2.15(1)-release' + BUILDDIR=/build/reproducible-path + BUILDUSERGECOS='second user,second room,second work-phone,second home-phone,second other' + BUILDUSERNAME=pbuilder2 + BUILD_ARCH=amd64 + DEBIAN_FRONTEND=noninteractive + DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all parallel=15 ' + DIRSTACK=() + DISTRIBUTION=bookworm + EUID=0 + FUNCNAME=([0]="Echo" [1]="main") + GROUPS=() + HOME=/root + HOSTNAME=i-capture-the-hostname + HOSTTYPE=x86_64 + HOST_ARCH=amd64 IFS=' ' - INVOCATION_ID='ed33f8b5644a42c9b76f492b0d94d8c5' - LANG='C' - LANGUAGE='en_US:en' - LC_ALL='C' - MAIL='/var/mail/root' - OPTIND='1' - PATH='/usr/sbin:/usr/bin:/sbin:/bin:/usr/games' - PBCURRENTCOMMANDLINEOPERATION='build' - PBUILDER_OPERATION='build' - PBUILDER_PKGDATADIR='/usr/share/pbuilder' - PBUILDER_PKGLIBDIR='/usr/lib/pbuilder' - PBUILDER_SYSCONFDIR='/etc' - PPID='4175658' - PS1='# ' - PS2='> ' + INVOCATION_ID=07f8bf7d741a4b259a8bc1c8ffb87e48 + LANG=C + LANGUAGE=et_EE:et + LC_ALL=C + MACHTYPE=x86_64-pc-linux-gnu + MAIL=/var/mail/root + OPTERR=1 + OPTIND=1 + OSTYPE=linux-gnu + PATH=/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/i/capture/the/path + PBCURRENTCOMMANDLINEOPERATION=build + PBUILDER_OPERATION=build + PBUILDER_PKGDATADIR=/usr/share/pbuilder + PBUILDER_PKGLIBDIR=/usr/lib/pbuilder + PBUILDER_SYSCONFDIR=/etc + PIPESTATUS=([0]="0") + POSIXLY_CORRECT=y + PPID=2339407 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.LMArVOaq/pbuilderrc_1DiN --distribution bookworm --hookdir /etc/pbuilder/first-build-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/bookworm-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/r-b-build.LMArVOaq/b1 --logfile b1/build.log notary_0.7.0+ds1-2.dsc' - SUDO_GID='111' - SUDO_UID='106' - SUDO_USER='jenkins' - TERM='unknown' - TZ='/usr/share/zoneinfo/Etc/GMT+12' - USER='root' - _='/usr/bin/systemd-run' - http_proxy='http://85.184.249.68:3128' + PWD=/ + SHELL=/bin/bash + SHELLOPTS=braceexpand:errexit:hashall:interactive-comments:posix + SHLVL=3 + SUDO_COMMAND='/usr/bin/timeout -k 24.1h 24h /usr/bin/ionice -c 3 /usr/bin/nice -n 11 /usr/bin/unshare --uts -- /usr/sbin/pbuilder --build --configfile /srv/reproducible-results/rbuild-debian/r-b-build.LMArVOaq/pbuilderrc_5vRg --distribution bookworm --hookdir /etc/pbuilder/rebuild-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/bookworm-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/r-b-build.LMArVOaq/b2 --logfile b2/build.log notary_0.7.0+ds1-2.dsc' + SUDO_GID=111 + SUDO_UID=106 + SUDO_USER=jenkins + TERM=unknown + TZ=/usr/share/zoneinfo/Etc/GMT-14 + UID=0 + USER=root + _='I: set' + http_proxy=http://78.137.99.97:3128 I: uname -a - Linux ionos15-amd64 6.5.0-0.deb12.4-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.5.10-1~bpo12+1 (2023-11-23) x86_64 GNU/Linux + Linux i-capture-the-hostname 6.1.0-17-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.1.69-1 (2023-12-30) x86_64 GNU/Linux I: ls -l /bin total 5632 -rwxr-xr-x 1 root root 1265648 Apr 23 2023 bash @@ -131,15 +163,15 @@ -rwxr-xr-x 1 root root 52112 Sep 20 2022 readlink -rwxr-xr-x 1 root root 72752 Sep 20 2022 rm -rwxr-xr-x 1 root root 56240 Sep 20 2022 rmdir - -rwxr-xr-x 1 root root 27560 Jul 28 2023 run-parts + -rwxr-xr-x 1 root root 27560 Jul 28 23:46 run-parts -rwxr-xr-x 1 root root 126424 Jan 5 2023 sed - lrwxrwxrwx 1 root root 4 Jan 5 2023 sh -> dash + lrwxrwxrwx 1 root root 9 Jan 6 13:09 sh -> /bin/bash -rwxr-xr-x 1 root root 43888 Sep 20 2022 sleep -rwxr-xr-x 1 root root 85008 Sep 20 2022 stty -rwsr-xr-x 1 root root 72000 Mar 23 2023 su -rwxr-xr-x 1 root root 39824 Sep 20 2022 sync -rwxr-xr-x 1 root root 531984 Apr 6 2023 tar - -rwxr-xr-x 1 root root 14520 Jul 28 2023 tempfile + -rwxr-xr-x 1 root root 14520 Jul 28 23:46 tempfile -rwxr-xr-x 1 root root 109616 Sep 20 2022 touch -rwxr-xr-x 1 root root 35664 Sep 20 2022 true -rwxr-xr-x 1 root root 14568 Mar 23 2023 ulockmgr_server @@ -159,7 +191,7 @@ -rwxr-xr-x 1 root root 2206 Apr 10 2022 zless -rwxr-xr-x 1 root root 1842 Apr 10 2022 zmore -rwxr-xr-x 1 root root 4577 Apr 10 2022 znew -I: user script /srv/workspace/pbuilder/4175658/tmp/hooks/D02_print_environment finished +I: user script /srv/workspace/pbuilder/2339407/tmp/hooks/D02_print_environment finished -> Attempting to satisfy build-dependencies -> Creating pbuilder-satisfydepends-dummy package Package: pbuilder-satisfydepends-dummy @@ -435,7 +467,7 @@ Get: 184 http://deb.debian.org/debian bookworm/main amd64 golang-goprotobuf-dev amd64 1.3.5-4+b3 [3436 B] Get: 185 http://deb.debian.org/debian bookworm/main amd64 golang-gopkg-rethinkdb-rethinkdb-go.v6-dev all 6.2.1-2 [106 kB] Get: 186 http://deb.debian.org/debian bookworm/main amd64 openssl amd64 3.0.11-1~deb12u2 [1419 kB] -Fetched 139 MB in 2s (76.4 MB/s) +Fetched 139 MB in 13s (11.1 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 ... 18148 files and directories currently installed.) @@ -1194,7 +1226,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/2339407/tmp/hooks/A99_set_merged_usr starting +Not re-configuring usrmerge for bookworm +I: user script /srv/workspace/pbuilder/2339407/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 @@ -1473,27 +1509,27 @@ 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 16 -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/goarch -internal/race + cd _build && go install -trimpath -v -p 15 -tags pkcs11 github.com/theupdateframework/notary github.com/theupdateframework/notary/client github.com/theupdateframework/notary/client/changelist github.com/theupdateframework/notary/cmd/escrow github.com/theupdateframework/notary/cmd/notary github.com/theupdateframework/notary/cmd/notary-server github.com/theupdateframework/notary/cmd/notary-signer github.com/theupdateframework/notary/cryptoservice github.com/theupdateframework/notary/passphrase github.com/theupdateframework/notary/proto github.com/theupdateframework/notary/server github.com/theupdateframework/notary/server/errors github.com/theupdateframework/notary/server/handlers github.com/theupdateframework/notary/server/snapshot github.com/theupdateframework/notary/server/storage github.com/theupdateframework/notary/server/timestamp github.com/theupdateframework/notary/signer github.com/theupdateframework/notary/signer/api github.com/theupdateframework/notary/signer/client github.com/theupdateframework/notary/signer/keydbstore github.com/theupdateframework/notary/storage github.com/theupdateframework/notary/storage/rethinkdb github.com/theupdateframework/notary/trustmanager github.com/theupdateframework/notary/trustmanager/remoteks github.com/theupdateframework/notary/trustmanager/yubikey github.com/theupdateframework/notary/trustpinning github.com/theupdateframework/notary/tuf github.com/theupdateframework/notary/tuf/data github.com/theupdateframework/notary/tuf/signed github.com/theupdateframework/notary/tuf/testutils github.com/theupdateframework/notary/tuf/testutils/interfaces github.com/theupdateframework/notary/tuf/testutils/keys github.com/theupdateframework/notary/tuf/utils github.com/theupdateframework/notary/tuf/validation github.com/theupdateframework/notary/utils github.com/theupdateframework/notary/version +internal/unsafeheader internal/goexperiment internal/goos +internal/goarch +internal/race math/bits unicode/utf8 -internal/unsafeheader -runtime/internal/syscall -internal/cpu -sync/atomic -internal/abi -runtime/internal/atomic -runtime/internal/math -unicode/utf16 -internal/itoa encoding -crypto/internal/subtle +internal/itoa unicode +unicode/utf16 +crypto/internal/subtle +internal/cpu +runtime/internal/atomic crypto/subtle +runtime/internal/syscall crypto/internal/boring/sig +internal/abi +sync/atomic +runtime/internal/math runtime/internal/sys vendor/golang.org/x/crypto/cryptobyte/asn1 internal/nettrace @@ -1501,709 +1537,709 @@ vendor/golang.org/x/crypto/internal/subtle google.golang.org/grpc/serviceconfig google.golang.org/protobuf/internal/flags +google.golang.org/protobuf/internal/set github.com/theupdateframework/notary/version github.com/lib/pq/oid -google.golang.org/protobuf/internal/set internal/bytealg math runtime -runtime/metrics internal/reflectlite +runtime/metrics sync internal/testlog -math/rand internal/singleflight +math/rand +google.golang.org/grpc/internal/buffer +github.com/spf13/viper/internal/encoding google.golang.org/grpc/internal/grpcsync google.golang.org/protobuf/internal/pragma -google.golang.org/grpc/internal/buffer internal/sysinfo -github.com/spf13/viper/internal/encoding runtime/cgo errors sort io -strconv internal/oserror internal/safefilepath path +strconv github.com/hashicorp/hcl/hcl/strconv -vendor/golang.org/x/net/dns/dnsmessage crypto/internal/nistec/fiat +vendor/golang.org/x/net/dns/dnsmessage syscall github.com/beorn7/perks/quantile hash bytes crypto/internal/randutil -text/tabwriter strings +text/tabwriter hash/crc32 hash/fnv -crypto -crypto/rc4 -encoding/base32 -golang.org/x/crypto/blowfish -reflect vendor/golang.org/x/text/transform github.com/dvsekhvalnov/jose2go/padding golang.org/x/text/transform +reflect +crypto/rc4 +encoding/base32 +golang.org/x/crypto/blowfish +crypto +bufio net/http/internal/ascii -google.golang.org/grpc/encoding -net/http/internal/testcert html -github.com/prometheus/common/internal/bitbucket.org/ww/goautoneg -bufio regexp/syntax +google.golang.org/grpc/encoding +github.com/prometheus/common/internal/bitbucket.org/ww/goautoneg +net/http/internal/testcert golang.org/x/text/runes -internal/syscall/unix -internal/syscall/execenv time +internal/syscall/execenv +internal/syscall/unix regexp internal/poll google.golang.org/grpc/backoff google.golang.org/grpc/internal/grpcrand +context google.golang.org/grpc/keepalive github.com/bugsnag/bugsnag-go/headers io/fs -context -github.com/jinzhu/inflection google.golang.org/grpc/internal/backoff golang.org/x/net/context google.golang.org/grpc/tap gopkg.in/rethinkdb/rethinkdb-go.v6/vendor/gopkg.in/cenkalti/backoff.v2 -github.com/spf13/afero/internal/common +github.com/jinzhu/inflection embed +github.com/spf13/afero/internal/common os -internal/fmtsort encoding/binary +internal/fmtsort crypto/md5 encoding/base64 -crypto/internal/edwards25519/field -github.com/cespare/xxhash crypto/cipher -vendor/golang.org/x/crypto/internal/poly1305 crypto/internal/nistec +crypto/internal/edwards25519/field vendor/golang.org/x/crypto/curve25519/internal/field +github.com/cespare/xxhash golang.org/x/sys/unix +vendor/golang.org/x/crypto/internal/poly1305 encoding/pem github.com/dvsekhvalnov/jose2go/base64url github.com/dvsekhvalnov/jose2go/compact github.com/theupdateframework/notary +fmt internal/godebug path/filepath io/ioutil +google.golang.org/grpc/internal/envconfig github.com/bugsnag/bugsnag-go/device -fmt -google.golang.org/protobuf/internal/detrand +internal/intern os/signal -google.golang.org/grpc/internal/envconfig +google.golang.org/protobuf/internal/detrand crypto/internal/edwards25519 github.com/prometheus/procfs/internal/util -internal/intern crypto/internal/boring crypto/des vendor/golang.org/x/crypto/chacha20 vendor/golang.org/x/sys/cpu +net/netip crypto/aes crypto/sha512 crypto/sha256 -crypto/hmac crypto/sha1 -net/netip +crypto/hmac github.com/spf13/afero/mem os/exec golang.org/x/crypto/pbkdf2 vendor/golang.org/x/crypto/hkdf vendor/golang.org/x/crypto/chacha20poly1305 -github.com/bugsnag/panicwrap net encoding/json log github.com/docker/go/canonical/json encoding/hex net/url -vendor/golang.org/x/crypto/curve25519 -mime/quotedprintable mime -compress/flate -net/http/internal -vendor/golang.org/x/net/http2/hpack math/big +mime/quotedprintable +vendor/golang.org/x/crypto/curve25519 +compress/flate vendor/golang.org/x/text/unicode/norm +vendor/golang.org/x/net/http2/hpack +net/http/internal github.com/miekg/pkcs11 flag encoding/csv +vendor/golang.org/x/text/unicode/bidi golang.org/x/text/unicode/norm text/template/parse -vendor/golang.org/x/text/unicode/bidi github.com/spf13/jwalterweatherman github.com/hashicorp/hcl/hcl/token gopkg.in/yaml.v2 +github.com/subosito/gotenv +gopkg.in/ini.v1 github.com/hashicorp/hcl/hcl/ast +compress/gzip github.com/hashicorp/hcl/hcl/scanner +vendor/golang.org/x/text/secure/bidirule github.com/hashicorp/hcl/json/token -compress/gzip -github.com/subosito/gotenv +golang.org/x/net/internal/timeseries github.com/hashicorp/hcl/json/scanner +google.golang.org/grpc/internal/grpclog github.com/fsnotify/fsnotify -gopkg.in/ini.v1 github.com/hashicorp/hcl/hcl/parser -golang.org/x/net/internal/timeseries -vendor/golang.org/x/text/secure/bidirule -github.com/hashicorp/hcl/json/parser -google.golang.org/grpc/internal/grpclog -google.golang.org/grpc/attributes github.com/sirupsen/logrus github.com/theupdateframework/notary/tuf/validation github.com/spf13/viper/internal/encoding/json -github.com/hashicorp/hcl/hcl/printer +github.com/hashicorp/hcl/json/parser github.com/golang/protobuf/proto google.golang.org/grpc/grpclog +google.golang.org/grpc/attributes google.golang.org/grpc/metadata -github.com/hashicorp/hcl +github.com/hashicorp/hcl/hcl/printer google.golang.org/grpc/codes -golang.org/x/text/unicode/bidi google.golang.org/grpc/internal/balancerload +github.com/hashicorp/hcl +golang.org/x/text/unicode/bidi text/template golang.org/x/net/http2/hpack google.golang.org/grpc/connectivity -github.com/pkg/errors -database/sql/driver -github.com/spf13/viper/internal/encoding/hcl vendor/golang.org/x/net/idna google.golang.org/grpc/internal +github.com/pkg/errors +github.com/bugsnag/panicwrap +database/sql/driver +github.com/bugsnag/bugsnag-go/errors github.com/opencontainers/go-digest github.com/opencontainers/image-spec/specs-go -github.com/bugsnag/bugsnag-go/errors +github.com/spf13/viper/internal/encoding/hcl github.com/prometheus/common/model -crypto/elliptic crypto/rand +crypto/elliptic crypto/internal/boring/bbig encoding/asn1 crypto/dsa github.com/pelletier/go-toml golang.org/x/text/secure/bidirule -database/sql github.com/docker/distribution/digestset +database/sql github.com/opencontainers/image-spec/specs-go/v1 -google.golang.org/protobuf/internal/errors github.com/docker/distribution/uuid crypto/rsa crypto/ed25519 -github.com/docker/distribution/reference +github.com/spf13/viper/internal/encoding/yaml golang.org/x/net/idna -google.golang.org/protobuf/encoding/protowire +github.com/docker/distribution/reference +google.golang.org/protobuf/internal/errors golang.org/x/crypto/ed25519 +google.golang.org/protobuf/encoding/protowire go/token -github.com/spf13/viper/internal/encoding/yaml google.golang.org/protobuf/internal/version -vendor/golang.org/x/crypto/cryptobyte -crypto/x509/pkix -google.golang.org/protobuf/reflect/protoreflect +html/template github.com/prometheus/procfs/internal/fs runtime/debug golang.org/x/term golang.org/x/crypto/bcrypt +google.golang.org/protobuf/reflect/protoreflect github.com/lib/pq/scram -html/template os/user +go/scanner github.com/hailocab/go-hostpool +vendor/golang.org/x/crypto/cryptobyte +crypto/x509/pkix github.com/opentracing/opentracing-go/log -go/scanner gopkg.in/rethinkdb/rethinkdb-go.v6/encoding +go/ast gopkg.in/rethinkdb/rethinkdb-go.v6/types +github.com/theupdateframework/notary/passphrase internal/profile runtime/pprof runtime/trace -crypto/ecdsa -go/ast -github.com/theupdateframework/notary/passphrase github.com/dvsekhvalnov/jose2go/arrays github.com/davecgh/go-spew/spew github.com/pmezard/go-difflib/difflib +crypto/ecdsa +github.com/dvsekhvalnov/jose2go/aes google.golang.org/protobuf/internal/descfmt -gopkg.in/yaml.v3 +github.com/spf13/cast 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 +github.com/spf13/viper/internal/encoding/toml google.golang.org/protobuf/internal/genid +google.golang.org/protobuf/internal/encoding/text google.golang.org/protobuf/internal/order google.golang.org/protobuf/reflect/protoregistry google.golang.org/protobuf/runtime/protoiface -github.com/dvsekhvalnov/jose2go/aes -github.com/spf13/viper/internal/encoding/toml github.com/dvsekhvalnov/jose2go/kdf -github.com/spf13/cast +gopkg.in/yaml.v3 testing +github.com/jinzhu/gorm google.golang.org/protobuf/proto google.golang.org/protobuf/internal/encoding/defval -github.com/jinzhu/gorm github.com/golang/protobuf/ptypes/empty google.golang.org/grpc/encoding/proto +github.com/golang/protobuf/ptypes/any github.com/golang/protobuf/ptypes/duration github.com/golang/protobuf/ptypes/timestamp -github.com/golang/protobuf/ptypes/any github.com/matttproud/golang_protobuf_extensions/pbutil gopkg.in/rethinkdb/rethinkdb-go.v6/ql2 google.golang.org/genproto/googleapis/rpc/status -github.com/prometheus/client_model/go github.com/golang/protobuf/ptypes google.golang.org/grpc/binarylog/grpc_binarylog_v1 +github.com/prometheus/client_model/go google.golang.org/grpc/internal/status google.golang.org/protobuf/encoding/prototext google.golang.org/protobuf/internal/filedesc google.golang.org/grpc/status github.com/prometheus/client_golang/prometheus/internal -vendor/golang.org/x/net/http/httpproxy net/textproto +vendor/golang.org/x/net/http/httpproxy github.com/mitchellh/mapstructure -crypto/x509 google.golang.org/grpc/internal/syscall google.golang.org/grpc/stats -github.com/spf13/pflag github.com/gofrs/uuid +github.com/spf13/pflag +crypto/x509 github.com/prometheus/procfs +google.golang.org/protobuf/internal/encoding/tag +mime/multipart vendor/golang.org/x/net/http/httpguts golang.org/x/net/http/httpguts -mime/multipart -google.golang.org/protobuf/internal/encoding/tag google.golang.org/protobuf/internal/impl -github.com/dvsekhvalnov/jose2go/keys/ecc github.com/theupdateframework/notary/tuf/data +github.com/dvsekhvalnov/jose2go/keys/ecc crypto/tls -github.com/dvsekhvalnov/jose2go github.com/spf13/cobra +github.com/dvsekhvalnov/jose2go github.com/theupdateframework/notary/client/changelist github.com/theupdateframework/notary/tuf/utils +google.golang.org/protobuf/internal/filetype +google.golang.org/protobuf/runtime/protoimpl net/http/httptrace -google.golang.org/grpc/internal/credentials +github.com/lib/pq github.com/docker/go-connections/tlsconfig -github.com/docker/libtrust github.com/go-sql-driver/mysql -github.com/lib/pq -google.golang.org/protobuf/internal/filetype -net/http +google.golang.org/grpc/internal/credentials +github.com/docker/libtrust +google.golang.org/protobuf/types/known/timestamppb google.golang.org/grpc/credentials -google.golang.org/protobuf/runtime/protoimpl +net/http google.golang.org/grpc/resolver google.golang.org/grpc/peer google.golang.org/grpc/internal/channelz -google.golang.org/protobuf/types/known/timestamppb google.golang.org/grpc/balancer -google.golang.org/grpc/balancer/grpclb/state google.golang.org/grpc/internal/grpcutil +google.golang.org/grpc/balancer/grpclb/state google.golang.org/grpc/internal/resolver/passthrough -google.golang.org/grpc/internal/resolver/dns google.golang.org/grpc/internal/binarylog +google.golang.org/grpc/internal/resolver/dns google.golang.org/grpc/balancer/base google.golang.org/grpc/internal/serviceconfig google.golang.org/grpc/balancer/roundrobin github.com/theupdateframework/notary/storage -golang.org/x/net/trace -net/http/httputil github.com/magiconair/properties +github.com/spf13/afero +golang.org/x/net/trace github.com/bugsnag/bugsnag-go/sessions +net/http/httputil github.com/docker/distribution/registry/api/errcode -github.com/gorilla/mux github.com/docker/distribution/registry/auth +github.com/docker/distribution/registry/client/auth/challenge +github.com/docker/distribution/registry/client/transport github.com/docker/distribution +github.com/gorilla/mux expvar -github.com/docker/distribution/registry/client/transport -github.com/spf13/afero -github.com/docker/distribution/registry/client/auth/challenge -github.com/opentracing/opentracing-go -golang.org/x/net/http2 github.com/prometheus/common/expfmt +golang.org/x/net/http2 +github.com/opentracing/opentracing-go net/http/pprof net/http/httptest -github.com/bugsnag/bugsnag-go github.com/theupdateframework/notary/server/errors +github.com/bugsnag/bugsnag-go github.com/opentracing/opentracing-go/ext github.com/theupdateframework/notary/trustmanager gopkg.in/rethinkdb/rethinkdb-go.v6 -github.com/stretchr/testify/assert github.com/docker/distribution/context github.com/docker/distribution/registry/api/v2 +github.com/stretchr/testify/assert +github.com/theupdateframework/notary/vendor/github.com/prometheus/client_golang/prometheus +github.com/prometheus/client_golang/prometheus github.com/theupdateframework/notary/tuf/signed github.com/theupdateframework/notary/cryptoservice github.com/Shopify/logrus-bugsnag -github.com/theupdateframework/notary/vendor/github.com/prometheus/client_golang/prometheus -github.com/prometheus/client_golang/prometheus github.com/docker/distribution/health github.com/docker/distribution/registry/auth/htpasswd github.com/docker/distribution/registry/auth/token -github.com/theupdateframework/notary/trustpinning -github.com/theupdateframework/notary/tuf/testutils/keys github.com/theupdateframework/notary/trustmanager/yubikey -github.com/theupdateframework/notary/tuf +github.com/theupdateframework/notary/tuf/testutils/keys +github.com/theupdateframework/notary/trustpinning github.com/spf13/viper +github.com/theupdateframework/notary/tuf github.com/stretchr/testify/require +github.com/prometheus/client_golang/prometheus/promhttp +github.com/theupdateframework/notary/utils github.com/theupdateframework/notary/client github.com/theupdateframework/notary/tuf/testutils -github.com/theupdateframework/notary/utils github.com/theupdateframework/notary/tuf/testutils/interfaces github.com/theupdateframework/notary/storage/rethinkdb -github.com/prometheus/client_golang/prometheus/promhttp google.golang.org/grpc/internal/transport -github.com/theupdateframework/notary/signer/keydbstore github.com/theupdateframework/notary/server/storage -github.com/theupdateframework/notary/server/snapshot -github.com/theupdateframework/notary/server/timestamp +github.com/theupdateframework/notary/signer/keydbstore github.com/docker/go-metrics -github.com/theupdateframework/notary/server/handlers github.com/docker/distribution/metrics github.com/docker/distribution/registry/storage/cache -google.golang.org/grpc github.com/docker/distribution/registry/storage/cache/memory github.com/docker/distribution/registry/client -github.com/theupdateframework/notary/server +github.com/theupdateframework/notary/server/snapshot +github.com/theupdateframework/notary/server/timestamp +github.com/theupdateframework/notary/server/handlers github.com/docker/distribution/registry/client/auth github.com/theupdateframework/notary/cmd/notary -github.com/theupdateframework/notary/trustmanager/remoteks +github.com/theupdateframework/notary/server +google.golang.org/grpc github.com/theupdateframework/notary/proto google.golang.org/grpc/health/grpc_health_v1 +github.com/theupdateframework/notary/trustmanager/remoteks google.golang.org/grpc/health +github.com/theupdateframework/notary/cmd/escrow github.com/theupdateframework/notary/signer/client github.com/theupdateframework/notary/signer -github.com/theupdateframework/notary/cmd/escrow github.com/theupdateframework/notary/signer/api -github.com/theupdateframework/notary/cmd/notary-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 16 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 15 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] === RUN Test0Dot1Migration ---- PASS: Test0Dot1Migration (0.01s) +--- PASS: Test0Dot1Migration (0.03s) === RUN Test0Dot3Migration ---- PASS: Test0Dot3Migration (0.01s) +--- PASS: Test0Dot3Migration (0.07s) === RUN Test0Dot1RepoFormat -time="2025-02-07T19:31:51Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" ---- PASS: Test0Dot1RepoFormat (0.10s) +time="2024-01-06T13:15:11Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" +--- PASS: Test0Dot1RepoFormat (0.49s) === RUN Test0Dot3RepoFormat -time="2025-02-07T19:31:52Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" ---- PASS: Test0Dot3RepoFormat (0.14s) +time="2024-01-06T13:15:11Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" +--- PASS: Test0Dot3RepoFormat (0.55s) === RUN TestDownloading0Dot1RepoFormat --- PASS: TestDownloading0Dot1RepoFormat (0.01s) === RUN TestDownloading0Dot3RepoFormat ---- PASS: TestDownloading0Dot3RepoFormat (0.01s) +--- PASS: TestDownloading0Dot3RepoFormat (0.02s) === RUN TestInitRepositoryManagedRolesIncludingRoot ---- PASS: TestInitRepositoryManagedRolesIncludingRoot (0.00s) +--- PASS: TestInitRepositoryManagedRolesIncludingRoot (0.02s) === RUN TestInitRepositoryManagedRolesInvalidRole ---- PASS: TestInitRepositoryManagedRolesInvalidRole (0.00s) +--- PASS: TestInitRepositoryManagedRolesInvalidRole (0.03s) === RUN TestInitRepositoryManagedRolesIncludingTargets ---- PASS: TestInitRepositoryManagedRolesIncludingTargets (0.00s) +--- PASS: TestInitRepositoryManagedRolesIncludingTargets (0.02s) === RUN TestInitRepositoryManagedRolesIncludingTimestamp ---- PASS: TestInitRepositoryManagedRolesIncludingTimestamp (0.01s) +--- PASS: TestInitRepositoryManagedRolesIncludingTimestamp (0.04s) === RUN TestInitRepositoryWithCerts ---- PASS: TestInitRepositoryWithCerts (0.02s) +--- PASS: TestInitRepositoryWithCerts (0.09s) === RUN TestMatchKeyIDsWithPublicKeys ---- PASS: TestMatchKeyIDsWithPublicKeys (0.01s) +--- PASS: TestMatchKeyIDsWithPublicKeys (0.07s) === RUN TestInitRepositoryNeedsRemoteTimestampKey ---- PASS: TestInitRepositoryNeedsRemoteTimestampKey (0.01s) +--- PASS: TestInitRepositoryNeedsRemoteTimestampKey (0.09s) === RUN TestInitRepositoryNeedsRemoteSnapshotKey ---- PASS: TestInitRepositoryNeedsRemoteSnapshotKey (0.01s) +--- PASS: TestInitRepositoryNeedsRemoteSnapshotKey (0.04s) === RUN TestInitRepoServerOnlyManagesTimestampKey ---- PASS: TestInitRepoServerOnlyManagesTimestampKey (0.08s) +--- PASS: TestInitRepoServerOnlyManagesTimestampKey (0.28s) === RUN TestInitRepoServerManagesTimestampAndSnapshotKeys ---- PASS: TestInitRepoServerManagesTimestampAndSnapshotKeys (0.07s) +--- PASS: TestInitRepoServerManagesTimestampAndSnapshotKeys (0.37s) === RUN TestInitRepoAttemptsExceeded ---- PASS: TestInitRepoAttemptsExceeded (0.07s) +--- PASS: TestInitRepoAttemptsExceeded (0.27s) === RUN TestInitRepoPasswordInvalid ---- PASS: TestInitRepoPasswordInvalid (0.01s) +--- PASS: TestInitRepoPasswordInvalid (0.03s) === RUN TestAddTargetToTargetRoleByDefault ---- PASS: TestAddTargetToTargetRoleByDefault (0.03s) +--- PASS: TestAddTargetToTargetRoleByDefault (0.08s) === RUN TestAddTargetToSpecifiedValidRoles ---- PASS: TestAddTargetToSpecifiedValidRoles (0.03s) +--- PASS: TestAddTargetToSpecifiedValidRoles (0.12s) === RUN TestAddTargetToSpecifiedInvalidRoles ---- PASS: TestAddTargetToSpecifiedInvalidRoles (0.02s) +--- PASS: TestAddTargetToSpecifiedInvalidRoles (0.15s) === RUN TestAddTargetWithInvalidTarget ---- PASS: TestAddTargetWithInvalidTarget (0.01s) +--- PASS: TestAddTargetWithInvalidTarget (0.03s) === RUN TestAddTargetErrorWritingChanges ---- PASS: TestAddTargetErrorWritingChanges (0.01s) +--- PASS: TestAddTargetErrorWritingChanges (0.06s) === RUN TestRemoveTargetToTargetRoleByDefault ---- PASS: TestRemoveTargetToTargetRoleByDefault (0.03s) +--- PASS: TestRemoveTargetToTargetRoleByDefault (0.14s) === RUN TestRemoveTargetFromSpecifiedValidRoles ---- PASS: TestRemoveTargetFromSpecifiedValidRoles (0.03s) +--- PASS: TestRemoveTargetFromSpecifiedValidRoles (0.11s) === RUN TestRemoveTargetToSpecifiedInvalidRoles ---- PASS: TestRemoveTargetToSpecifiedInvalidRoles (0.03s) +--- PASS: TestRemoveTargetToSpecifiedInvalidRoles (0.12s) === RUN TestRemoveTargetErrorWritingChanges ---- PASS: TestRemoveTargetErrorWritingChanges (0.01s) +--- PASS: TestRemoveTargetErrorWritingChanges (0.07s) === RUN TestListTarget ---- PASS: TestListTarget (0.30s) +--- PASS: TestListTarget (1.32s) === RUN TestListTargetRestrictsDelegationPaths ---- PASS: TestListTargetRestrictsDelegationPaths (0.05s) +--- PASS: TestListTargetRestrictsDelegationPaths (0.20s) === RUN TestValidateRootKey ---- PASS: TestValidateRootKey (0.03s) +--- PASS: TestValidateRootKey (0.17s) === RUN TestGetChangelist ---- PASS: TestGetChangelist (0.04s) +--- PASS: TestGetChangelist (0.19s) === RUN TestPublishBareRepo ---- PASS: TestPublishBareRepo (0.32s) +--- PASS: TestPublishBareRepo (1.55s) === RUN TestPublishUninitializedRepo -time="2025-02-07T19:31:53Z" level=info msg="No TUF data found locally or remotely - initializing repository docker.com/notary for the first time" ---- PASS: TestPublishUninitializedRepo (0.02s) +time="2024-01-06T13:15:18Z" level=info msg="No TUF data found locally or remotely - initializing repository docker.com/notary for the first time" +--- PASS: TestPublishUninitializedRepo (0.09s) === RUN TestPublishClientHasSnapshotKey ---- PASS: TestPublishClientHasSnapshotKey (0.26s) +--- PASS: TestPublishClientHasSnapshotKey (1.27s) === RUN TestPublishAfterInitServerHasSnapshotKey ---- PASS: TestPublishAfterInitServerHasSnapshotKey (0.26s) +--- PASS: TestPublishAfterInitServerHasSnapshotKey (1.23s) === RUN TestPublishAfterPullServerHasSnapshotKey ---- PASS: TestPublishAfterPullServerHasSnapshotKey (0.09s) +--- PASS: TestPublishAfterPullServerHasSnapshotKey (0.40s) === RUN TestPublishNoOneHasSnapshotKey ---- PASS: TestPublishNoOneHasSnapshotKey (0.06s) +--- PASS: TestPublishNoOneHasSnapshotKey (0.31s) === RUN TestPublishSnapshotCorrupt ---- PASS: TestPublishSnapshotCorrupt (0.15s) +--- PASS: TestPublishSnapshotCorrupt (0.66s) === RUN TestPublishTargetsCorrupt ---- PASS: TestPublishTargetsCorrupt (0.08s) +--- PASS: TestPublishTargetsCorrupt (0.38s) === RUN TestPublishRootCorrupt -time="2025-02-07T19:31:54Z" level=error msg="Could not publish Repository since we could not update: invalid character 'h' in literal true (expecting 'r')" -time="2025-02-07T19:31:54Z" level=error msg="Could not publish Repository since we could not update: invalid character 'h' in literal true (expecting 'r')" ---- PASS: TestPublishRootCorrupt (0.06s) +time="2024-01-06T13:15:22Z" level=error msg="Could not publish Repository since we could not update: invalid character 'h' in literal true (expecting 'r')" +time="2024-01-06T13:15:22Z" level=error msg="Could not publish Repository since we could not update: invalid character 'h' in literal true (expecting 'r')" +--- PASS: TestPublishRootCorrupt (0.29s) === RUN TestPublishSnapshotLocalKeysCreatedFirst ---- PASS: TestPublishSnapshotLocalKeysCreatedFirst (0.00s) +--- PASS: TestPublishSnapshotLocalKeysCreatedFirst (0.01s) === RUN TestPublishDelegations ---- PASS: TestPublishDelegations (0.12s) +--- PASS: TestPublishDelegations (0.61s) === RUN TestPublishDelegationsX509 ---- PASS: TestPublishDelegationsX509 (0.11s) +--- PASS: TestPublishDelegationsX509 (0.58s) === RUN TestPublishTargetsDelegationScopeFailIfNoKeys -time="2025-02-07T19:31:54Z" level=error msg="couldn't add target to targets/a/b: tuf: invalid role targets/a/b. delegation does not exist" -time="2025-02-07T19:31:54Z" level=error msg="couldn't add target to targets/a/b: tuf: invalid role targets/a/b. delegation does not exist" ---- PASS: TestPublishTargetsDelegationScopeFailIfNoKeys (0.09s) +time="2024-01-06T13:15:24Z" level=error msg="couldn't add target to targets/a/b: tuf: invalid role targets/a/b. delegation does not exist" +time="2024-01-06T13:15: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.36s) === RUN TestPublishTargetsDelegationSuccessLocallyHasRoles ---- PASS: TestPublishTargetsDelegationSuccessLocallyHasRoles (0.10s) +--- PASS: TestPublishTargetsDelegationSuccessLocallyHasRoles (0.53s) === RUN TestPublishTargetsDelegationNoTargetsKeyNeeded ---- PASS: TestPublishTargetsDelegationNoTargetsKeyNeeded (0.10s) +--- PASS: TestPublishTargetsDelegationNoTargetsKeyNeeded (0.47s) === RUN TestPublishTargetsDelegationSuccessNeedsToDownloadRoles ---- PASS: TestPublishTargetsDelegationSuccessNeedsToDownloadRoles (0.12s) +--- PASS: TestPublishTargetsDelegationSuccessNeedsToDownloadRoles (0.34s) === RUN TestPublishTargetsDelegationFromTwoRepos ---- PASS: TestPublishTargetsDelegationFromTwoRepos (0.09s) +--- PASS: TestPublishTargetsDelegationFromTwoRepos (0.35s) === RUN TestPublishRemoveDelegationKeyFromDelegationRole -time="2025-02-07T19:31:55Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2025-02-07T19:31:55Z" 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: bac53b994f56eea112995b83a557aef3910800eca393dc8d03c6dd5ca66050dc" ---- PASS: TestPublishRemoveDelegationKeyFromDelegationRole (0.06s) +time="2024-01-06T13:15:26Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2024-01-06T13:15:26Z" 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: b4a0b7453bb8fd5e10b1608afcdb8ccc4161d71b8eb969870dc110c2af1f8a58" +--- PASS: TestPublishRemoveDelegationKeyFromDelegationRole (0.26s) === RUN TestPublishRemoveDelegation -time="2025-02-07T19:31:55Z" level=warning msg="role targets/a has fewer keys than its threshold of 1; it will not be usable until keys are added to it" -time="2025-02-07T19:31:55Z" level=warning msg="role targets/a has fewer keys than its threshold of 1; it will not be usable until keys are added to it" -time="2025-02-07T19:31:55Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2025-02-07T19:31:55Z" 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.07s) +time="2024-01-06T13:15:26Z" 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-01-06T13:15:26Z" 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-01-06T13:15:26Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2024-01-06T13:15:26Z" 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.23s) === RUN TestPublishSucceedsDespiteDelegationCorrupt ---- PASS: TestPublishSucceedsDespiteDelegationCorrupt (0.08s) +--- PASS: TestPublishSucceedsDespiteDelegationCorrupt (0.29s) === RUN TestRotateKeyInvalidRole ---- PASS: TestRotateKeyInvalidRole (0.04s) +--- PASS: TestRotateKeyInvalidRole (0.17s) === RUN TestRemoteRotationError ---- PASS: TestRemoteRotationError (0.01s) +--- PASS: TestRemoteRotationError (0.04s) === RUN TestRemoteRotationEndpointError ---- PASS: TestRemoteRotationEndpointError (0.02s) +--- PASS: TestRemoteRotationEndpointError (0.12s) === RUN TestRemoteRotationNoRootKey ---- PASS: TestRemoteRotationNoRootKey (0.04s) +--- PASS: TestRemoteRotationNoRootKey (0.23s) === RUN TestRemoteRotationNoInit -time="2025-02-07T19:31:55Z" level=info msg="No TUF data found locally or remotely - initializing repository docker.com/notary for the first time" ---- PASS: TestRemoteRotationNoInit (0.03s) +time="2024-01-06T13:15:27Z" level=info msg="No TUF data found locally or remotely - initializing repository docker.com/notary for the first time" +--- PASS: TestRemoteRotationNoInit (0.20s) === RUN TestRotateBeforePublishFromRemoteKeyToLocalKey ---- PASS: TestRotateBeforePublishFromRemoteKeyToLocalKey (0.12s) +--- PASS: TestRotateBeforePublishFromRemoteKeyToLocalKey (0.54s) === RUN TestRotateKeyAfterPublishNoServerManagementChange ---- PASS: TestRotateKeyAfterPublishNoServerManagementChange (0.31s) +--- PASS: TestRotateKeyAfterPublishNoServerManagementChange (1.25s) === RUN TestRotateKeyAfterPublishServerManagementChange ---- PASS: TestRotateKeyAfterPublishServerManagementChange (0.35s) +--- PASS: TestRotateKeyAfterPublishServerManagementChange (1.57s) === RUN TestRotateRootKey ---- PASS: TestRotateRootKey (0.12s) +--- PASS: TestRotateRootKey (0.51s) === RUN TestRotateRootMultiple ---- PASS: TestRotateRootMultiple (0.13s) +--- PASS: TestRotateRootMultiple (0.62s) === RUN TestRotateRootKeyProvided ---- PASS: TestRotateRootKeyProvided (0.09s) +--- PASS: TestRotateRootKeyProvided (0.62s) === RUN TestRotateRootKeyLegacySupport ---- PASS: TestRotateRootKeyLegacySupport (0.13s) +--- PASS: TestRotateRootKeyLegacySupport (0.82s) === RUN TestRemoteServerUnavailableNoLocalCache -time="2025-02-07T19:31:56Z" level=error msg="Could not publish Repository since we could not update: unable to reach trust server at this time: 500." ---- PASS: TestRemoteServerUnavailableNoLocalCache (0.00s) +time="2024-01-06T13:15:33Z" level=error msg="Could not publish Repository since we could not update: unable to reach trust server at this time: 500." +--- PASS: TestRemoteServerUnavailableNoLocalCache (0.02s) === RUN TestAddDelegationChangefileValid ---- PASS: TestAddDelegationChangefileValid (0.01s) +--- PASS: TestAddDelegationChangefileValid (0.08s) === RUN TestAddDelegationChangefileApplicable ---- PASS: TestAddDelegationChangefileApplicable (0.01s) +--- PASS: TestAddDelegationChangefileApplicable (0.06s) === RUN TestAddDelegationErrorWritingChanges ---- PASS: TestAddDelegationErrorWritingChanges (0.01s) +--- PASS: TestAddDelegationErrorWritingChanges (0.09s) === RUN TestRemoveDelegationChangefileValid ---- PASS: TestRemoveDelegationChangefileValid (0.01s) +--- PASS: TestRemoveDelegationChangefileValid (0.06s) === RUN TestRemoveDelegationChangefileApplicable -time="2025-02-07T19:31:56Z" 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-02-07T19:31:56Z" level=warning msg="role targets/a has fewer keys than its threshold of 1; it will not be usable until keys are added to it" ---- PASS: TestRemoveDelegationChangefileApplicable (0.01s) +time="2024-01-06T13:15: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-01-06T13:15: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.11s) === RUN TestClearAllPathsDelegationChangefileApplicable ---- PASS: TestClearAllPathsDelegationChangefileApplicable (0.01s) +--- PASS: TestClearAllPathsDelegationChangefileApplicable (0.04s) === RUN TestFullAddDelegationChangefileApplicable ---- PASS: TestFullAddDelegationChangefileApplicable (0.02s) +--- PASS: TestFullAddDelegationChangefileApplicable (0.09s) === RUN TestFullRemoveDelegationChangefileApplicable ---- PASS: TestFullRemoveDelegationChangefileApplicable (0.02s) +--- PASS: TestFullRemoveDelegationChangefileApplicable (0.10s) === RUN TestRemoveDelegationErrorWritingChanges ---- PASS: TestRemoveDelegationErrorWritingChanges (0.01s) +--- PASS: TestRemoveDelegationErrorWritingChanges (0.07s) === RUN TestClientInvalidURL --- PASS: TestClientInvalidURL (0.00s) === RUN TestPublishTargetsDelegationCanUseUserKeyWithArbitraryRole ---- PASS: TestPublishTargetsDelegationCanUseUserKeyWithArbitraryRole (0.20s) +--- PASS: TestPublishTargetsDelegationCanUseUserKeyWithArbitraryRole (1.06s) === RUN TestDeleteRepo ---- PASS: TestDeleteRepo (0.03s) +--- PASS: TestDeleteRepo (0.17s) === RUN TestDeleteRemoteRepo ---- PASS: TestDeleteRemoteRepo (0.08s) +--- PASS: TestDeleteRemoteRepo (0.40s) === RUN TestListRoles ---- PASS: TestListRoles (0.12s) +--- PASS: TestListRoles (0.55s) === RUN TestGetAllTargetInfo ---- PASS: TestGetAllTargetInfo (0.07s) +--- PASS: TestGetAllTargetInfo (0.29s) === RUN TestUpdateSucceedsEvenIfCannotWriteNewRepo -time="2025-02-07T19:31:57Z" level=error msg="could not save root to cache: Non-writable" ---- PASS: TestUpdateSucceedsEvenIfCannotWriteNewRepo (0.05s) +time="2024-01-06T13:15:36Z" level=error msg="could not save root to cache: Non-writable" +--- PASS: TestUpdateSucceedsEvenIfCannotWriteNewRepo (0.22s) === RUN TestUpdateSucceedsEvenIfCannotWriteExistingRepo ---- PASS: TestUpdateSucceedsEvenIfCannotWriteExistingRepo (0.23s) +--- PASS: TestUpdateSucceedsEvenIfCannotWriteExistingRepo (1.49s) === RUN TestUpdateInOfflineMode -time="2025-02-07T19:31:57Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" -time="2025-02-07T19:31:57Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" ---- PASS: TestUpdateInOfflineMode (0.02s) +time="2024-01-06T13:15:38Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" +time="2024-01-06T13:15:38Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" +--- PASS: TestUpdateInOfflineMode (0.11s) === RUN TestUpdateReplacesCorruptOrMissingMetadata -time="2025-02-07T19:31:57Z" level=error msg="Metadata for root expired" -time="2025-02-07T19:31:57Z" level=error msg="Metadata for root expired" ---- PASS: TestUpdateReplacesCorruptOrMissingMetadata (0.44s) +time="2024-01-06T13:15:40Z" level=error msg="Metadata for root expired" +time="2024-01-06T13:15:40Z" level=error msg="Metadata for root expired" +--- PASS: TestUpdateReplacesCorruptOrMissingMetadata (2.37s) === RUN TestUpdateFailsIfServerRootKeyChangedWithoutMultiSign -time="2025-02-07T19:31:58Z" level=error msg="Metadata for root expired" -time="2025-02-07T19:31:58Z" level=error msg="Metadata for root expired" ---- PASS: TestUpdateFailsIfServerRootKeyChangedWithoutMultiSign (0.05s) +time="2024-01-06T13:15:41Z" level=error msg="Metadata for root expired" +time="2024-01-06T13:15:41Z" level=error msg="Metadata for root expired" +--- PASS: TestUpdateFailsIfServerRootKeyChangedWithoutMultiSign (0.25s) === RUN TestUpdateRemoteRootNotExistNoLocalCache ---- PASS: TestUpdateRemoteRootNotExistNoLocalCache (0.01s) +--- PASS: TestUpdateRemoteRootNotExistNoLocalCache (0.06s) === RUN TestUpdateRemoteRootNotExistCanUseLocalCache ---- PASS: TestUpdateRemoteRootNotExistCanUseLocalCache (0.03s) +--- PASS: TestUpdateRemoteRootNotExistCanUseLocalCache (0.20s) === RUN TestUpdateRemoteRootNotExistCannotUseLocalCache ---- PASS: TestUpdateRemoteRootNotExistCannotUseLocalCache (0.04s) +--- PASS: TestUpdateRemoteRootNotExistCannotUseLocalCache (0.24s) === RUN TestUpdateRemoteRoot50XNoLocalCache ---- PASS: TestUpdateRemoteRoot50XNoLocalCache (0.01s) +--- PASS: TestUpdateRemoteRoot50XNoLocalCache (0.08s) === RUN TestUpdateRemoteRoot50XCanUseLocalCache ---- PASS: TestUpdateRemoteRoot50XCanUseLocalCache (0.03s) +--- PASS: TestUpdateRemoteRoot50XCanUseLocalCache (0.24s) === RUN TestUpdateRemoteRoot50XCannotUseLocalCache ---- PASS: TestUpdateRemoteRoot50XCannotUseLocalCache (0.04s) +--- PASS: TestUpdateRemoteRoot50XCannotUseLocalCache (0.23s) === RUN TestUpdateNonRootRemoteMissingMetadataNoLocalCache ---- PASS: TestUpdateNonRootRemoteMissingMetadataNoLocalCache (0.08s) +--- PASS: TestUpdateNonRootRemoteMissingMetadataNoLocalCache (0.59s) === RUN TestUpdateNonRootRemoteMissingMetadataCanUseLocalCache -time="2025-02-07T19:31:58Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" ---- PASS: TestUpdateNonRootRemoteMissingMetadataCanUseLocalCache (0.11s) +time="2024-01-06T13:15:43Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" +--- PASS: TestUpdateNonRootRemoteMissingMetadataCanUseLocalCache (0.75s) === RUN TestUpdateNonRootRemoteMissingMetadataCannotUseLocalCache -time="2025-02-07T19:31:58Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" ---- PASS: TestUpdateNonRootRemoteMissingMetadataCannotUseLocalCache (0.16s) +time="2024-01-06T13:15:44Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" +--- PASS: TestUpdateNonRootRemoteMissingMetadataCannotUseLocalCache (1.01s) === RUN TestUpdateNonRootRemote50XNoLocalCache ---- PASS: TestUpdateNonRootRemote50XNoLocalCache (0.08s) +--- PASS: TestUpdateNonRootRemote50XNoLocalCache (0.53s) === RUN TestUpdateNonRootRemote50XCanUseLocalCache -time="2025-02-07T19:31:58Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" ---- PASS: TestUpdateNonRootRemote50XCanUseLocalCache (0.11s) +time="2024-01-06T13:15:45Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" +--- PASS: TestUpdateNonRootRemote50XCanUseLocalCache (0.68s) === RUN TestUpdateNonRootRemote50XCannotUseLocalCache -time="2025-02-07T19:31:58Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" ---- PASS: TestUpdateNonRootRemote50XCannotUseLocalCache (0.15s) +time="2024-01-06T13:15:46Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" +--- PASS: TestUpdateNonRootRemote50XCannotUseLocalCache (0.94s) === RUN TestUpdateRemoteChecksumWrongNoLocalCache ---- PASS: TestUpdateRemoteChecksumWrongNoLocalCache (0.10s) +--- PASS: TestUpdateRemoteChecksumWrongNoLocalCache (0.50s) === RUN TestUpdateRemoteChecksumWrongCanUseLocalCache ---- PASS: TestUpdateRemoteChecksumWrongCanUseLocalCache (0.15s) +--- PASS: TestUpdateRemoteChecksumWrongCanUseLocalCache (0.85s) === RUN TestUpdateRemoteChecksumWrongCannotUseLocalCache ---- PASS: TestUpdateRemoteChecksumWrongCannotUseLocalCache (0.20s) +--- PASS: TestUpdateRemoteChecksumWrongCannotUseLocalCache (1.11s) === RUN TestUpdateRootRemoteCorruptedNoLocalCache -time="2025-02-07T19:31:59Z" level=error msg="Metadata for root expired" -time="2025-02-07T19:31:59Z" level=error msg="Metadata for root expired" ---- PASS: TestUpdateRootRemoteCorruptedNoLocalCache (0.32s) +time="2024-01-06T13:15:49Z" level=error msg="Metadata for root expired" +time="2024-01-06T13:15:49Z" level=error msg="Metadata for root expired" +--- PASS: TestUpdateRootRemoteCorruptedNoLocalCache (1.65s) === RUN TestUpdateRootRemoteCorruptedCanUseLocalCache ---- PASS: TestUpdateRootRemoteCorruptedCanUseLocalCache (0.66s) +--- PASS: TestUpdateRootRemoteCorruptedCanUseLocalCache (2.94s) === RUN TestUpdateRootRemoteCorruptedCannotUseLocalCache -time="2025-02-07T19:32:00Z" level=error msg="Metadata for root expired" -time="2025-02-07T19:32:00Z" level=error msg="Metadata for root expired" ---- PASS: TestUpdateRootRemoteCorruptedCannotUseLocalCache (0.80s) +time="2024-01-06T13:15:55Z" level=error msg="Metadata for root expired" +time="2024-01-06T13:15:56Z" level=error msg="Metadata for root expired" +--- PASS: TestUpdateRootRemoteCorruptedCannotUseLocalCache (4.76s) === RUN TestUpdateNonRootRemoteCorruptedNoLocalCache -time="2025-02-07T19:32:01Z" level=error msg="Metadata for targets expired" -time="2025-02-07T19:32:01Z" level=error msg="Metadata for targets expired" -time="2025-02-07T19:32:01Z" level=error msg="Metadata for snapshot expired" -time="2025-02-07T19:32:01Z" level=error msg="Metadata for snapshot expired" -time="2025-02-07T19:32:01Z" level=error msg="Metadata for timestamp expired" -time="2025-02-07T19:32:01Z" level=error msg="Metadata for timestamp expired" -time="2025-02-07T19:32:01Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2025-02-07T19:32:01Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2025-02-07T19:32:01Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2025-02-07T19:32:01Z" level=error msg="Metadata for targets/a expired" -time="2025-02-07T19:32:01Z" level=warning msg="Error getting targets/a: targets/a expired at Sat Jan 6 19:32:01 UTC 2024" -time="2025-02-07T19:32:01Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" -time="2025-02-07T19:32:01Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" -time="2025-02-07T19:32:01Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" -time="2025-02-07T19:32:01Z" level=error msg="Metadata for targets/a/b expired" -time="2025-02-07T19:32:01Z" level=warning msg="Error getting targets/a/b: targets/a/b expired at Sat Jan 6 19:32:01 UTC 2024" -time="2025-02-07T19:32:01Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" -time="2025-02-07T19:32:01Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" -time="2025-02-07T19:32:01Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" -time="2025-02-07T19:32:01Z" level=error msg="Metadata for targets/b expired" -time="2025-02-07T19:32:01Z" level=warning msg="Error getting targets/b: targets/b expired at Sat Jan 6 19:32:01 UTC 2024" ---- PASS: TestUpdateNonRootRemoteCorruptedNoLocalCache (0.84s) +time="2024-01-06T13:15:59Z" level=error msg="Metadata for targets expired" +time="2024-01-06T13:15:59Z" level=error msg="Metadata for targets expired" +time="2024-01-06T13:15:59Z" level=error msg="Metadata for snapshot expired" +time="2024-01-06T13:15:59Z" level=error msg="Metadata for snapshot expired" +time="2024-01-06T13:16:00Z" level=error msg="Metadata for timestamp expired" +time="2024-01-06T13:16:00Z" level=error msg="Metadata for timestamp expired" +time="2024-01-06T13:16:00Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2024-01-06T13:16:00Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2024-01-06T13:16:00Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2024-01-06T13:16:01Z" level=error msg="Metadata for targets/a expired" +time="2024-01-06T13:16:01Z" level=warning msg="Error getting targets/a: targets/a expired at Mon Dec 5 13:16:01 UTC 2022" +time="2024-01-06T13:16:01Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" +time="2024-01-06T13:16:01Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" +time="2024-01-06T13:16:01Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" +time="2024-01-06T13:16:01Z" level=error msg="Metadata for targets/a/b expired" +time="2024-01-06T13:16:01Z" level=warning msg="Error getting targets/a/b: targets/a/b expired at Mon Dec 5 13:16:01 UTC 2022" +time="2024-01-06T13:16:02Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" +time="2024-01-06T13:16:02Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" +time="2024-01-06T13:16:02Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" +time="2024-01-06T13:16:02Z" level=error msg="Metadata for targets/b expired" +time="2024-01-06T13:16:02Z" level=warning msg="Error getting targets/b: targets/b expired at Mon Dec 5 13:16:02 UTC 2022" +--- PASS: TestUpdateNonRootRemoteCorruptedNoLocalCache (4.42s) === RUN TestUpdateNonRootRemoteCorruptedCanUseLocalCache -time="2025-02-07T19:32:02Z" level=error msg="Metadata for timestamp expired" -time="2025-02-07T19:32:02Z" level=error msg="Metadata for timestamp expired" ---- PASS: TestUpdateNonRootRemoteCorruptedCanUseLocalCache (1.10s) +time="2024-01-06T13:16:05Z" level=error msg="Metadata for timestamp expired" +time="2024-01-06T13:16:05Z" level=error msg="Metadata for timestamp expired" +--- PASS: TestUpdateNonRootRemoteCorruptedCanUseLocalCache (5.47s) === RUN TestUpdateNonRootRemoteCorruptedCannotUseLocalCache -time="2025-02-07T19:32:03Z" level=error msg="Metadata for targets expired" -time="2025-02-07T19:32:03Z" level=error msg="Metadata for snapshot expired" -time="2025-02-07T19:32:03Z" level=error msg="Metadata for snapshot expired" -time="2025-02-07T19:32:03Z" level=error msg="Metadata for timestamp expired" -time="2025-02-07T19:32:03Z" level=error msg="Metadata for timestamp expired" -time="2025-02-07T19:32:03Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2025-02-07T19:32:03Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2025-02-07T19:32:03Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2025-02-07T19:32:04Z" level=error msg="Metadata for targets/a expired" -time="2025-02-07T19:32:04Z" level=warning msg="Error getting targets/a: targets/a expired at Sat Jan 6 19:32:04 UTC 2024" -time="2025-02-07T19:32:04Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" -time="2025-02-07T19:32:04Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" -time="2025-02-07T19:32:04Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" -time="2025-02-07T19:32:04Z" level=error msg="Metadata for targets/a/b expired" -time="2025-02-07T19:32:04Z" level=warning msg="Error getting targets/a/b: targets/a/b expired at Sat Jan 6 19:32:04 UTC 2024" -time="2025-02-07T19:32:04Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" -time="2025-02-07T19:32:04Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" -time="2025-02-07T19:32:04Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" -time="2025-02-07T19:32:04Z" level=error msg="Metadata for targets/b expired" -time="2025-02-07T19:32:04Z" level=warning msg="Error getting targets/b: targets/b expired at Sat Jan 6 19:32:04 UTC 2024" ---- PASS: TestUpdateNonRootRemoteCorruptedCannotUseLocalCache (1.55s) +time="2024-01-06T13:16:09Z" level=error msg="Metadata for targets expired" +time="2024-01-06T13:16:10Z" level=error msg="Metadata for snapshot expired" +time="2024-01-06T13:16:10Z" level=error msg="Metadata for snapshot expired" +time="2024-01-06T13:16:12Z" level=error msg="Metadata for timestamp expired" +time="2024-01-06T13:16:12Z" level=error msg="Metadata for timestamp expired" +time="2024-01-06T13:16:13Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2024-01-06T13:16:13Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2024-01-06T13:16:13Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2024-01-06T13:16:13Z" level=error msg="Metadata for targets/a expired" +time="2024-01-06T13:16:13Z" level=warning msg="Error getting targets/a: targets/a expired at Mon Dec 5 13:16:13 UTC 2022" +time="2024-01-06T13:16:14Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" +time="2024-01-06T13:16:14Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" +time="2024-01-06T13:16:15Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" +time="2024-01-06T13:16:15Z" level=error msg="Metadata for targets/a/b expired" +time="2024-01-06T13:16:15Z" level=warning msg="Error getting targets/a/b: targets/a/b expired at Mon Dec 5 13:16:15 UTC 2022" +time="2024-01-06T13:16:16Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" +time="2024-01-06T13:16:16Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" +time="2024-01-06T13:16:16Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" +time="2024-01-06T13:16:16Z" level=error msg="Metadata for targets/b expired" +time="2024-01-06T13:16:16Z" level=warning msg="Error getting targets/b: targets/b expired at Mon Dec 5 13:16:16 UTC 2022" +--- PASS: TestUpdateNonRootRemoteCorruptedCannotUseLocalCache (9.23s) === RUN TestUpdateLocalAndRemoteRootCorrupt -time="2025-02-07T19:32:05Z" level=error msg="Metadata for root expired" -time="2025-02-07T19:32:05Z" level=error msg="Metadata for root expired" -time="2025-02-07T19:32:06Z" level=error msg="Metadata for root expired" -time="2025-02-07T19:32:06Z" level=error msg="Metadata for root expired" -time="2025-02-07T19:32:06Z" level=error msg="Metadata for root expired" -time="2025-02-07T19:32:06Z" level=error msg="Metadata for root expired" -time="2025-02-07T19:32:06Z" level=error msg="Metadata for root expired" -time="2025-02-07T19:32:06Z" level=error msg="Metadata for root expired" -time="2025-02-07T19:32:06Z" level=error msg="Metadata for root expired" -time="2025-02-07T19:32:06Z" level=error msg="Metadata for root expired" -time="2025-02-07T19:32:06Z" level=error msg="Metadata for root expired" -time="2025-02-07T19:32:06Z" level=error msg="Metadata for root expired" -time="2025-02-07T19:32:06Z" level=error msg="Metadata for root expired" -time="2025-02-07T19:32:06Z" level=error msg="Metadata for root expired" -time="2025-02-07T19:32:06Z" level=error msg="Metadata for root expired" -time="2025-02-07T19:32:06Z" level=error msg="Metadata for root expired" -time="2025-02-07T19:32:06Z" level=error msg="Metadata for root expired" -time="2025-02-07T19:32:06Z" level=error msg="Metadata for root expired" -time="2025-02-07T19:32:06Z" level=error msg="Metadata for root expired" -time="2025-02-07T19:32:06Z" level=error msg="Metadata for root expired" -time="2025-02-07T19:32:06Z" level=error msg="Metadata for root expired" -time="2025-02-07T19:32:06Z" level=error msg="Metadata for root expired" ---- PASS: TestUpdateLocalAndRemoteRootCorrupt (1.71s) +time="2024-01-06T13:16:21Z" level=error msg="Metadata for root expired" +time="2024-01-06T13:16:21Z" level=error msg="Metadata for root expired" +time="2024-01-06T13:16:25Z" level=error msg="Metadata for root expired" +time="2024-01-06T13:16:25Z" level=error msg="Metadata for root expired" +time="2024-01-06T13:16:25Z" level=error msg="Metadata for root expired" +time="2024-01-06T13:16:25Z" level=error msg="Metadata for root expired" +time="2024-01-06T13:16:26Z" level=error msg="Metadata for root expired" +time="2024-01-06T13:16:26Z" level=error msg="Metadata for root expired" +time="2024-01-06T13:16:26Z" level=error msg="Metadata for root expired" +time="2024-01-06T13:16:26Z" level=error msg="Metadata for root expired" +time="2024-01-06T13:16:26Z" level=error msg="Metadata for root expired" +time="2024-01-06T13:16:26Z" level=error msg="Metadata for root expired" +time="2024-01-06T13:16:26Z" level=error msg="Metadata for root expired" +time="2024-01-06T13:16:26Z" level=error msg="Metadata for root expired" +time="2024-01-06T13:16:26Z" level=error msg="Metadata for root expired" +time="2024-01-06T13:16:27Z" level=error msg="Metadata for root expired" +time="2024-01-06T13:16:27Z" level=error msg="Metadata for root expired" +time="2024-01-06T13:16:27Z" level=error msg="Metadata for root expired" +time="2024-01-06T13:16:27Z" level=error msg="Metadata for root expired" +time="2024-01-06T13:16:27Z" level=error msg="Metadata for root expired" +time="2024-01-06T13:16:27Z" level=error msg="Metadata for root expired" +time="2024-01-06T13:16:27Z" level=error msg="Metadata for root expired" +--- PASS: TestUpdateLocalAndRemoteRootCorrupt (9.91s) === RUN TestUpdateRemoteKeyRotated -time="2025-02-07T19:32:06Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2025-02-07T19:32:06Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" -time="2025-02-07T19:32:06Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" ---- PASS: TestUpdateRemoteKeyRotated (0.16s) +time="2024-01-06T13:16:28Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2024-01-06T13:16:28Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" +time="2024-01-06T13:16:28Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" +--- PASS: TestUpdateRemoteKeyRotated (0.80s) === RUN TestValidateRootRotationWithOldRole ---- PASS: TestValidateRootRotationWithOldRole (0.09s) +--- PASS: TestValidateRootRotationWithOldRole (0.40s) === RUN TestRootRoleInvariant ---- PASS: TestRootRoleInvariant (0.07s) +--- PASS: TestRootRoleInvariant (0.49s) === RUN TestBadIntermediateTransitions ---- PASS: TestBadIntermediateTransitions (0.03s) +--- PASS: TestBadIntermediateTransitions (0.18s) === RUN TestExpiredIntermediateTransitions -time="2025-02-07T19:32:06Z" level=warning msg="root is nearing expiry, you should re-sign the role metadata" ---- PASS: TestExpiredIntermediateTransitions (0.03s) +time="2024-01-06T13:16:29Z" level=warning msg="root is nearing expiry, you should re-sign the role metadata" +--- PASS: TestExpiredIntermediateTransitions (0.17s) === RUN TestDownloadTargetsLarge ---- PASS: TestDownloadTargetsLarge (3.61s) +--- PASS: TestDownloadTargetsLarge (23.42s) === RUN TestDownloadTargetsDeep ---- PASS: TestDownloadTargetsDeep (0.02s) +--- PASS: TestDownloadTargetsDeep (0.11s) === RUN TestDownloadSnapshotLargeDelegationsMany ---- PASS: TestDownloadSnapshotLargeDelegationsMany (3.02s) +--- PASS: TestDownloadSnapshotLargeDelegationsMany (18.65s) === RUN TestRootOnDiskTrustPinning ---- PASS: TestRootOnDiskTrustPinning (0.01s) +--- PASS: TestRootOnDiskTrustPinning (0.05s) === RUN TestLoadTUFRepoBadURL --- PASS: TestLoadTUFRepoBadURL (0.00s) === RUN TestApplyTargetsChange @@ -2211,11 +2247,11 @@ === RUN TestApplyAddTargetTwice --- PASS: TestApplyAddTargetTwice (0.00s) === RUN TestApplyChangelist ---- PASS: TestApplyChangelist (0.00s) +--- PASS: TestApplyChangelist (0.01s) === RUN TestApplyChangelistMulti --- PASS: TestApplyChangelistMulti (0.00s) === RUN TestApplyTargetsDelegationCreateDelete ---- PASS: TestApplyTargetsDelegationCreateDelete (0.00s) +--- PASS: TestApplyTargetsDelegationCreateDelete (0.01s) === RUN TestApplyTargetsDelegationCreate2SharedKey --- PASS: TestApplyTargetsDelegationCreate2SharedKey (0.00s) === RUN TestApplyTargetsDelegationCreateEdit @@ -2225,43 +2261,43 @@ === RUN TestApplyTargetsDelegationCreateAlreadyExisting --- PASS: TestApplyTargetsDelegationCreateAlreadyExisting (0.00s) === RUN TestApplyTargetsDelegationAlreadyExistingMergePaths ---- PASS: TestApplyTargetsDelegationAlreadyExistingMergePaths (0.00s) +--- PASS: TestApplyTargetsDelegationAlreadyExistingMergePaths (0.01s) === RUN TestApplyTargetsDelegationInvalidRole --- PASS: TestApplyTargetsDelegationInvalidRole (0.00s) === RUN TestApplyTargetsDelegationInvalidJSONContent --- PASS: TestApplyTargetsDelegationInvalidJSONContent (0.00s) === RUN TestApplyTargetsDelegationInvalidAction ---- PASS: TestApplyTargetsDelegationInvalidAction (0.00s) +--- PASS: TestApplyTargetsDelegationInvalidAction (0.01s) === RUN TestApplyTargetsChangeInvalidType --- PASS: TestApplyTargetsChangeInvalidType (0.00s) === RUN TestApplyTargetsDelegationCreate2Deep ---- PASS: TestApplyTargetsDelegationCreate2Deep (0.00s) +--- PASS: TestApplyTargetsDelegationCreate2Deep (0.01s) === RUN TestApplyTargetsDelegationParentDoesntExist --- PASS: TestApplyTargetsDelegationParentDoesntExist (0.00s) === RUN TestApplyChangelistCreatesDelegation ---- PASS: TestApplyChangelistCreatesDelegation (0.00s) +--- PASS: TestApplyChangelistCreatesDelegation (0.01s) === RUN TestApplyChangelistTargetsToMultipleRoles --- PASS: TestApplyChangelistTargetsToMultipleRoles (0.00s) === RUN TestApplyChangelistTargetsFailsNonexistentRole -time="2025-02-07T19:32:13Z" 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-02-07T19:32:13Z" level=error msg="couldn't remove target from targets/level1/level2/level3/level4: tuf: invalid role targets/level1/level2/level3/level4. delegation does not exist" ---- PASS: TestApplyChangelistTargetsFailsNonexistentRole (0.00s) +time="2024-01-06T13:17:11Z" 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-01-06T13:17:11Z" level=error msg="couldn't remove target from targets/level1/level2/level3/level4: tuf: invalid role targets/level1/level2/level3/level4. delegation does not exist" +--- PASS: TestApplyChangelistTargetsFailsNonexistentRole (0.01s) === RUN TestChangeTargetMetaFailsInvalidRole -time="2025-02-07T19:32:13Z" level=error msg="couldn't add target to ruhroh: tuf: invalid role ruhroh. does not exist" +time="2024-01-06T13:17:11Z" level=error msg="couldn't add target to ruhroh: tuf: invalid role ruhroh. does not exist" --- PASS: TestChangeTargetMetaFailsInvalidRole (0.00s) === RUN TestChangeTargetMetaFailsIfPrefixError -time="2025-02-07T19:32:13Z" level=error msg="couldn't add target to targets/level1: Could not add all targets" ---- PASS: TestChangeTargetMetaFailsIfPrefixError (0.00s) +time="2024-01-06T13:17:11Z" level=error msg="couldn't add target to targets/level1: Could not add all targets" +--- PASS: TestChangeTargetMetaFailsIfPrefixError (0.01s) === RUN TestAllNearExpiry --- PASS: TestAllNearExpiry (0.00s) === RUN TestAllNotNearExpiry ---- PASS: TestAllNotNearExpiry (0.00s) +--- PASS: TestAllNotNearExpiry (0.01s) === RUN TestRotateRemoteKeyOffline --- PASS: TestRotateRemoteKeyOffline (0.00s) PASS -ok github.com/theupdateframework/notary/client 21.626s +ok github.com/theupdateframework/notary/client 120.751s === RUN TestTUFDelegation ---- PASS: TestTUFDelegation (0.01s) +--- PASS: TestTUFDelegation (0.00s) === RUN TestMemChangelist --- PASS: TestMemChangelist (0.00s) === RUN TestMemChangeIterator @@ -2271,14 +2307,14 @@ === RUN TestAdd --- PASS: TestAdd (0.00s) === RUN TestErrorConditions -time="2025-02-07T19:31:47Z" level=warning msg="invalid character '\\x05' looking for beginning of value" +time="2024-01-06T13:14:55Z" 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: TestFileChangeIterator (0.03s) PASS -ok github.com/theupdateframework/notary/client/changelist 0.019s +ok github.com/theupdateframework/notary/client/changelist 0.081s === RUN TestParseConfigError --- PASS: TestParseConfigError (0.00s) === RUN TestSetupGRPCServer @@ -2288,7 +2324,7 @@ === RUN TestSetupNetListener --- PASS: TestSetupNetListener (0.00s) PASS -ok github.com/theupdateframework/notary/cmd/escrow 0.012s +ok github.com/theupdateframework/notary/cmd/escrow 0.066s === RUN TestPurgeDelegationKeys Usage: delegation [command] @@ -2312,7 +2348,7 @@ Use "delegation [command] --help" for more information about a command. Removal of the following keys from all delegations in gun staged for next publish: - abc ---- PASS: TestPurgeDelegationKeys (0.00s) +--- PASS: TestPurgeDelegationKeys (0.01s) === RUN TestAddInvalidDelegationName --- PASS: TestAddInvalidDelegationName (0.00s) === RUN TestAddInvalidDelegationCert @@ -2358,120 +2394,120 @@ remove Remove KeyID(s) from the specified Role delegation. Use "delegation [command] --help" for more information about a command. ---- PASS: TestRemoveInvalidNumArgs (0.00s) +--- PASS: TestRemoveInvalidNumArgs (0.01s) === RUN TestInitWithRootKey ---- PASS: TestInitWithRootKey (0.09s) +--- PASS: TestInitWithRootKey (0.47s) === RUN TestInitWithRootCert ---- PASS: TestInitWithRootCert (0.07s) +--- PASS: TestInitWithRootCert (0.31s) === RUN TestClientTUFInteraction ---- PASS: TestClientTUFInteraction (0.14s) +--- PASS: TestClientTUFInteraction (0.49s) === RUN TestClientDeleteTUFInteraction -time="2025-02-07T19:31:52Z" 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]:45948->[::1]:53: read: connection refused" ---- PASS: TestClientDeleteTUFInteraction (0.14s) +time="2024-01-06T13:15:14Z" 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]:38566->[::1]:53: read: connection refused" +--- PASS: TestClientDeleteTUFInteraction (0.62s) === RUN TestClientTUFAddByHashInteraction ---- PASS: TestClientTUFAddByHashInteraction (0.22s) +--- PASS: TestClientTUFAddByHashInteraction (1.38s) === RUN TestClientDelegationsInteraction -time="2025-02-07T19:31:52Z" 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-02-07T19:31:52Z" level=warning msg="role targets/delegation has fewer keys than its threshold of 1; it will not be usable until keys are added to it" ---- PASS: TestClientDelegationsInteraction (0.53s) +time="2024-01-06T13:15:16Z" 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-01-06T13:15:16Z" 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.65s) === RUN TestClientDelegationsPublishing ---- PASS: TestClientDelegationsPublishing (0.50s) +--- PASS: TestClientDelegationsPublishing (2.62s) === RUN TestClientKeyGenerationRotation ---- PASS: TestClientKeyGenerationRotation (0.59s) +--- PASS: TestClientKeyGenerationRotation (2.51s) === RUN TestKeyRotation ---- PASS: TestKeyRotation (0.12s) +--- PASS: TestKeyRotation (0.57s) === RUN TestKeyRotationNonRoot ---- PASS: TestKeyRotationNonRoot (0.13s) +--- PASS: TestKeyRotationNonRoot (0.61s) === RUN TestDefaultRootKeyGeneration ---- PASS: TestDefaultRootKeyGeneration (0.00s) +--- PASS: TestDefaultRootKeyGeneration (0.03s) === RUN TestLogLevelFlags --- PASS: TestLogLevelFlags (0.00s) === RUN TestClientKeyPassphraseChange ---- PASS: TestClientKeyPassphraseChange (0.13s) +--- PASS: TestClientKeyPassphraseChange (0.58s) === RUN TestPurgeSingleKey Removal of the following keys from all delegations in gun staged for next publish: - - a647c13d35e6b2910fb0d2593e0b314332802ec12ce731f88c8547b031fae721 ---- PASS: TestPurgeSingleKey (0.09s) + - 541dafaef11a281c4253ddfd34e5659d8c716c6968c88ae025f2b8a6a0edf2a9 +--- PASS: TestPurgeSingleKey (0.44s) === RUN TestWitness -time="2025-02-07T19:31:54Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" -time="2025-02-07T19:31:54Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" -time="2025-02-07T19:31:54Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" -time="2025-02-07T19:31:54Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" -time="2025-02-07T19:31:54Z" 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-02-07T19:31:54Z" 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-02-07T19:31:54Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" ---- PASS: TestWitness (0.29s) +time="2024-01-06T13:15:26Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" +time="2024-01-06T13:15:26Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" +time="2024-01-06T13:15:26Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" +time="2024-01-06T13:15:26Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" +time="2024-01-06T13:15: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="2024-01-06T13:15: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="2024-01-06T13:15:27Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" +--- PASS: TestWitness (1.34s) === RUN TestClientTUFInitWithAutoPublish -time="2025-02-07T19:31:54Z" 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]:56412->[::1]:53: read: connection refused" ---- PASS: TestClientTUFInitWithAutoPublish (0.07s) +time="2024-01-06T13:15: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]:54071->[::1]:53: read: connection refused" +--- PASS: TestClientTUFInitWithAutoPublish (0.41s) === RUN TestClientTUFAddWithAutoPublish -time="2025-02-07T19:31:55Z" 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]:58785->[::1]:53: read: connection refused" -time="2025-02-07T19:31:55Z" level=error msg="Could not publish Repository since we could not update: client is offline" -time="2025-02-07T19:31:55Z" 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]:40944->[::1]:53: read: connection refused" -time="2025-02-07T19:31:55Z" level=error msg="Could not publish Repository since we could not update: client is offline" ---- PASS: TestClientTUFAddWithAutoPublish (0.08s) +time="2024-01-06T13:15: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]:51382->[::1]:53: read: connection refused" +time="2024-01-06T13:15:27Z" level=error msg="Could not publish Repository since we could not update: client is offline" +time="2024-01-06T13:15: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]:49137->[::1]:53: read: connection refused" +time="2024-01-06T13:15:27Z" level=error msg="Could not publish Repository since we could not update: client is offline" +--- PASS: TestClientTUFAddWithAutoPublish (0.39s) === RUN TestClientTUFRemoveWithAutoPublish ---- PASS: TestClientTUFRemoveWithAutoPublish (0.15s) +--- PASS: TestClientTUFRemoveWithAutoPublish (0.85s) === RUN TestClientDelegationAddWithAutoPublish ---- PASS: TestClientDelegationAddWithAutoPublish (0.07s) +--- PASS: TestClientDelegationAddWithAutoPublish (0.39s) === RUN TestClientDelegationRemoveWithAutoPublish -time="2025-02-07T19:31:55Z" 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-02-07T19:31:55Z" 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.14s) +time="2024-01-06T13:15: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="2024-01-06T13:15: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.77s) === RUN TestClientTUFAddByHashWithAutoPublish ---- PASS: TestClientTUFAddByHashWithAutoPublish (0.07s) +--- PASS: TestClientTUFAddByHashWithAutoPublish (0.42s) === RUN TestClientKeyImport -time="2025-02-07T19:31:55Z" level=warning msg="failed to import key to store: Invalid key generated, key may be encrypted and does not contain path header" -time="2025-02-07T19:31:55Z" 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.03s) +time="2024-01-06T13:15:30Z" level=warning msg="failed to import key to store: Invalid key generated, key may be encrypted and does not contain path header" +time="2024-01-06T13:15: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.27s) === RUN TestAddDelImportKeyPublishFlow -time="2025-02-07T19:31:55Z" 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.17s) +time="2024-01-06T13:15:31Z" 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.76s) === RUN TestExportImportFlow ---- PASS: TestExportImportFlow (0.05s) +--- PASS: TestExportImportFlow (0.29s) === RUN TestDelegationKeyImportExport ---- PASS: TestDelegationKeyImportExport (0.01s) +--- PASS: TestDelegationKeyImportExport (0.02s) === RUN TestImportKeysNoYubikey ---- PASS: TestImportKeysNoYubikey (0.01s) +--- PASS: TestImportKeysNoYubikey (0.06s) === RUN TestExportImportKeysNoYubikey ---- PASS: TestExportImportKeysNoYubikey (0.01s) +--- PASS: TestExportImportKeysNoYubikey (0.04s) === RUN TestRemoveIfNoKey --- PASS: TestRemoveIfNoKey (0.00s) === RUN TestRemoveOneKeyAbort ---- PASS: TestRemoveOneKeyAbort (0.01s) +--- PASS: TestRemoveOneKeyAbort (0.04s) === RUN TestRemoveOneKeyConfirm ---- PASS: TestRemoveOneKeyConfirm (0.01s) +--- PASS: TestRemoveOneKeyConfirm (0.02s) === RUN TestRemoveMultikeysInvalidInput ---- PASS: TestRemoveMultikeysInvalidInput (0.01s) +--- PASS: TestRemoveMultikeysInvalidInput (0.04s) === RUN TestRemoveMultikeysAbortChoice ---- PASS: TestRemoveMultikeysAbortChoice (0.01s) +--- PASS: TestRemoveMultikeysAbortChoice (0.04s) === RUN TestRemoveMultikeysRemoveOnlyChosenKey ---- PASS: TestRemoveMultikeysRemoveOnlyChosenKey (0.01s) +--- PASS: TestRemoveMultikeysRemoveOnlyChosenKey (0.04s) === RUN TestRotateKeyInvalidRoles -time="2025-02-07T19:31:55Z" 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]:49395->[::1]:53: read: connection refused" -time="2025-02-07T19:31:55Z" 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]:38486->[::1]:53: read: connection refused" -time="2025-02-07T19:31:55Z" 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]:51969->[::1]:53: read: connection refused" -time="2025-02-07T19:31:55Z" 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]:55160->[::1]:53: read: connection refused" ---- PASS: TestRotateKeyInvalidRoles (0.00s) +time="2024-01-06T13:15: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]:59785->[::1]:53: read: connection refused" +time="2024-01-06T13:15: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]:55829->[::1]:53: read: connection refused" +time="2024-01-06T13:15: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]:57477->[::1]:53: read: connection refused" +time="2024-01-06T13:15: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]:50675->[::1]:53: read: connection refused" +--- PASS: TestRotateKeyInvalidRoles (0.02s) === RUN TestRotateKeyTargetCannotBeServerManaged -time="2025-02-07T19:31:55Z" 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]:47710->[::1]:53: read: connection refused" +time="2024-01-06T13:15: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]:53413->[::1]:53: read: connection refused" --- PASS: TestRotateKeyTargetCannotBeServerManaged (0.00s) === RUN TestRotateKeyTimestampCannotBeLocallyManaged -time="2025-02-07T19:31:55Z" 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]:44032->[::1]:53: read: connection refused" ---- PASS: TestRotateKeyTimestampCannotBeLocallyManaged (0.00s) +time="2024-01-06T13:15: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]:55833->[::1]:53: read: connection refused" +--- PASS: TestRotateKeyTimestampCannotBeLocallyManaged (0.02s) === RUN TestRotateKeyNoGUN Usage: --- PASS: TestRotateKeyNoGUN (0.00s) === RUN TestRotateKeyRemoteServerManagesKey Successfully rotated snapshot key for repository docker.com/notary Successfully rotated timestamp key for repository docker.com/notary ---- PASS: TestRotateKeyRemoteServerManagesKey (0.09s) +--- PASS: TestRotateKeyRemoteServerManagesKey (0.49s) === RUN TestRotateKeyBothKeys Successfully rotated targets key for repository docker.com/notary Successfully rotated snapshot key for repository docker.com/notary ---- PASS: TestRotateKeyBothKeys (0.07s) +--- PASS: TestRotateKeyBothKeys (0.31s) === RUN TestRotateKeyRootIsInteractive ---- PASS: TestRotateKeyRootIsInteractive (0.02s) +--- PASS: TestRotateKeyRootIsInteractive (0.14s) === RUN TestChangeKeyPassphraseInvalidID --- PASS: TestChangeKeyPassphraseInvalidID (0.00s) === RUN TestChangeKeyPassphraseInvalidNumArgs @@ -2484,36 +2520,36 @@ === RUN TestExportKeysByGUN --- PASS: TestExportKeysByGUN (0.00s) === RUN TestExportKeysByID ---- PASS: TestExportKeysByID (0.00s) +--- PASS: TestExportKeysByID (0.02s) === RUN TestExportKeysBadFlagCombo --- PASS: TestExportKeysBadFlagCombo (0.00s) === RUN TestImportKeysNonexistentFile --- PASS: TestImportKeysNonexistentFile (0.00s) === RUN TestKeyGeneration -time="2025-02-07T19:31:56Z" level=warning msg="failed to import key () to store: Cannot have canonical role key without a gun, don't know what gun it belongs to" ---- PASS: TestKeyGeneration (0.01s) +time="2024-01-06T13:15: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.10s) === RUN TestNotaryConfigFileDefault --- PASS: TestNotaryConfigFileDefault (0.00s) === RUN TestRemoteServerDefault ---- PASS: TestRemoteServerDefault (0.00s) +--- PASS: TestRemoteServerDefault (0.02s) === RUN TestRemoteServerUsesConfigFile ---- PASS: TestRemoteServerUsesConfigFile (0.00s) +--- PASS: TestRemoteServerUsesConfigFile (0.01s) === RUN TestRemoteServerCommandLineFlagOverridesConfig --- PASS: TestRemoteServerCommandLineFlagOverridesConfig (0.00s) === RUN TestInvalidAddHashCommands ---- PASS: TestInvalidAddHashCommands (0.00s) +--- PASS: TestInvalidAddHashCommands (0.01s) === RUN TestConfigParsingErrorsPropagatedByCommands ---- PASS: TestConfigParsingErrorsPropagatedByCommands (0.01s) +--- PASS: TestConfigParsingErrorsPropagatedByCommands (0.03s) === RUN TestInsufficientArgumentsReturnsErrorAndPrintsUsage ---- PASS: TestInsufficientArgumentsReturnsErrorAndPrintsUsage (0.02s) +--- PASS: TestInsufficientArgumentsReturnsErrorAndPrintsUsage (0.13s) === RUN TestBareCommandPrintsUsageAndNoError --- PASS: TestBareCommandPrintsUsageAndNoError (0.00s) === RUN TestConfigFileTLSCannotBeRelativeToCWD ---- PASS: TestConfigFileTLSCannotBeRelativeToCWD (0.01s) +--- PASS: TestConfigFileTLSCannotBeRelativeToCWD (0.07s) === RUN TestConfigFileTLSCanBeRelativeToConfigOrAbsolute ---- PASS: TestConfigFileTLSCanBeRelativeToConfigOrAbsolute (0.03s) +--- PASS: TestConfigFileTLSCanBeRelativeToConfigOrAbsolute (0.12s) === RUN TestConfigFileOverridenByCmdLineFlags ---- PASS: TestConfigFileOverridenByCmdLineFlags (0.04s) +--- PASS: TestConfigFileOverridenByCmdLineFlags (0.11s) === RUN TestConfigFileTrustPinning --- PASS: TestConfigFileTrustPinning (0.00s) === RUN TestPassphraseRetrieverCaching @@ -2527,7 +2563,7 @@ === RUN TestPrettyPrintZeroKeys --- PASS: TestPrettyPrintZeroKeys (0.00s) === RUN TestPrettyPrintRootAndSigningKeys ---- PASS: TestPrettyPrintRootAndSigningKeys (0.02s) +--- PASS: TestPrettyPrintRootAndSigningKeys (0.08s) === RUN TestPrettyPrintZeroTargets --- PASS: TestPrettyPrintZeroTargets (0.00s) === RUN TestPrettyPrintSortedTargets @@ -2539,10 +2575,10 @@ === RUN TestImportRootCert --- PASS: TestImportRootCert (0.00s) === RUN TestTokenAuth -time="2025-02-07T19:31:56Z" 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) +time="2024-01-06T13:15:33Z" 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.02s) === RUN TestAdminTokenAuth -time="2025-02-07T19:31:56Z" 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-01-06T13:15:33Z" 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) @@ -2553,18 +2589,18 @@ === RUN TestAdminTokenAuth401Status --- PASS: TestAdminTokenAuth401Status (0.00s) === RUN TestTokenAuthNon200Non401Status -time="2025-02-07T19:31:56Z" level=error msg="could not reach http://127.0.0.1:41261: 404" +time="2024-01-06T13:15:33Z" level=error msg="could not reach http://127.0.0.1:35039: 404" --- PASS: TestTokenAuthNon200Non401Status (0.00s) === RUN TestAdminTokenAuthNon200Non401Status -time="2025-02-07T19:31:56Z" level=error msg="could not reach http://127.0.0.1:45097: 404" +time="2024-01-06T13:15:33Z" level=error msg="could not reach http://127.0.0.1:39005: 404" --- PASS: TestAdminTokenAuthNon200Non401Status (0.00s) === RUN TestConfigureRepo ---- PASS: TestConfigureRepo (0.00s) +--- PASS: TestConfigureRepo (0.02s) === RUN TestConfigureRepoRW -Enter username: time="2025-02-07T19:31:56Z" level=error msg="error processing username input: EOF" +Enter username: time="2024-01-06T13:15:33Z" level=error msg="error processing username input: EOF" --- PASS: TestConfigureRepoRW (0.00s) === RUN TestConfigureRepoAdmin -Enter username: time="2025-02-07T19:31:56Z" level=error msg="error processing username input: EOF" +Enter username: time="2024-01-06T13:15:33Z" level=error msg="error processing username input: EOF" --- PASS: TestConfigureRepoAdmin (0.01s) === RUN TestStatusUnstageAndReset Successfully reset specified changes for repository gun @@ -2572,16 +2608,16 @@ 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.00s) +--- PASS: TestStatusUnstageAndReset (0.02s) === RUN TestGetTrustPinningErrors Pushing changes to gun --- PASS: TestGetTrustPinningErrors (0.00s) === RUN TestPasswordStore -Enter username: time="2025-02-07T19:31:56Z" level=error msg="error processing username input: EOF" +Enter username: time="2024-01-06T13:15:33Z" level=error msg="error processing username input: EOF" --- PASS: TestPasswordStore (0.00s) === RUN TestPasswordStoreWithEnvvar -time="2025-02-07T19:31:56Z" level=error msg="Authentication string with zero-length username" -time="2025-02-07T19:31:56Z" level=error msg="Could not base64-decode authentication string" +time="2024-01-06T13:15:33Z" level=error msg="Authentication string with zero-length username" +time="2024-01-06T13:15:33Z" level=error msg="Could not base64-decode authentication string" --- PASS: TestPasswordStoreWithEnvvar (0.00s) === RUN TestGetPayload --- PASS: TestGetPayload (0.00s) @@ -2590,11 +2626,11 @@ === RUN TestHomeExpand --- PASS: TestHomeExpand (0.00s) PASS -ok github.com/theupdateframework/notary/cmd/notary 4.288s +ok github.com/theupdateframework/notary/cmd/notary 21.327s === RUN TestBootstrap --- PASS: TestBootstrap (0.00s) === RUN TestGetAddrAndTLSConfigInvalidTLS ---- PASS: TestGetAddrAndTLSConfigInvalidTLS (0.00s) +--- PASS: TestGetAddrAndTLSConfigInvalidTLS (0.02s) === RUN TestGetAddrAndTLSConfigNoHTTPAddr --- PASS: TestGetAddrAndTLSConfigNoHTTPAddr (0.00s) === RUN TestGetAddrAndTLSConfigSuccessWithTLS @@ -2606,42 +2642,42 @@ === RUN TestGetInvalidTrustService --- PASS: TestGetInvalidTrustService (0.00s) === RUN TestGetLocalTrustService -time="2025-02-07T19:31:51Z" level=info msg="Using local signing service, which requires ED25519. Ignoring all other trust_service parameters, including keyAlgorithm" +time="2024-01-06T13:15:11Z" 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-02-07T19:31:51Z" level=info msg="Using remote signing service" +time="2024-01-06T13:15:11Z" level=info msg="Using remote signing service" --- PASS: TestGetTrustServiceNoTLSConfig (0.00s) === RUN TestGetTrustServiceTLSSuccess -time="2025-02-07T19:31:51Z" level=info msg="Using remote signing service" +time="2024-01-06T13:15:11Z" level=info msg="Using remote signing service" --- PASS: TestGetTrustServiceTLSSuccess (0.00s) === RUN TestGetTrustServiceTLSFailure --- PASS: TestGetTrustServiceTLSFailure (0.00s) === RUN TestGetStoreInvalid -time="2025-02-07T19:31:51Z" level=info msg="Using asdf backend" +time="2024-01-06T13:15:11Z" level=info msg="Using asdf backend" --- PASS: TestGetStoreInvalid (0.00s) === RUN TestGetStoreDBStore -time="2025-02-07T19:31:51Z" level=info msg="Using sqlite3 backend" ---- PASS: TestGetStoreDBStore (0.00s) +time="2024-01-06T13:15:11Z" level=info msg="Using sqlite3 backend" +--- PASS: TestGetStoreDBStore (0.02s) === RUN TestGetStoreRethinkDBStoreConnectionFails -time="2025-02-07T19:31:51Z" level=info msg="Using rethinkdb backend" +time="2024-01-06T13:15:11Z" level=info msg="Using rethinkdb backend" --- PASS: TestGetStoreRethinkDBStoreConnectionFails (0.00s) === RUN TestGetMemoryStore -time="2025-02-07T19:31:51Z" level=info msg="Using memory backend" +time="2024-01-06T13:15:11Z" 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-02-07T19:31:51Z" level=info msg="Using remote signing service" -time="2025-02-07T19:31:51Z" level=info msg="Using sqlite3 backend" +time="2024-01-06T13:15:11Z" level=info msg="Using remote signing service" +time="2024-01-06T13:15:11Z" level=info msg="Using sqlite3 backend" --- PASS: TestSampleConfig (0.00s) PASS -ok github.com/theupdateframework/notary/cmd/notary-server 0.019s +ok github.com/theupdateframework/notary/cmd/notary-server 0.133s === RUN TestGetAddrAndTLSConfigInvalidTLS --- PASS: TestGetAddrAndTLSConfigInvalidTLS (0.00s) === RUN TestGetAddrAndTLSConfigNoGRPCAddr @@ -2656,7 +2692,7 @@ main_test.go:121: DM - skipping malfunctioning test, fails on sbuild --- SKIP: TestSetupCryptoServicesRethinkDBStoreConnectionFails (0.00s) === RUN TestSetupCryptoServicesDBStoreSuccess ---- PASS: TestSetupCryptoServicesDBStoreSuccess (0.01s) +--- PASS: TestSetupCryptoServicesDBStoreSuccess (0.04s) === RUN TestSetupCryptoServicesMemoryStore --- PASS: TestSetupCryptoServicesMemoryStore (0.00s) === RUN TestSetupCryptoServicesInvalidStore @@ -2674,17 +2710,17 @@ === RUN TestSampleConfig --- PASS: TestSampleConfig (0.00s) PASS -ok github.com/theupdateframework/notary/cmd/notary-signer 0.031s +ok github.com/theupdateframework/notary/cmd/notary-signer 0.122s === RUN TestGenerateCertificate --- PASS: TestGenerateCertificate (0.00s) === RUN TestCryptoServiceWithNonEmptyGUN ---- PASS: TestCryptoServiceWithNonEmptyGUN (0.79s) +--- PASS: TestCryptoServiceWithNonEmptyGUN (3.01s) === RUN TestCryptoServiceWithEmptyGUN ---- PASS: TestCryptoServiceWithEmptyGUN (0.63s) +--- PASS: TestCryptoServiceWithEmptyGUN (4.09s) === RUN TestCryptoSignerInterfaceBehavior ---- PASS: TestCryptoSignerInterfaceBehavior (0.00s) +--- PASS: TestCryptoSignerInterfaceBehavior (0.03s) PASS -ok github.com/theupdateframework/notary/cryptoservice 1.451s +ok github.com/theupdateframework/notary/cryptoservice 7.253s === RUN TestGetPassphraseForUsingDelegationKey --- PASS: TestGetPassphraseForUsingDelegationKey (0.00s) === RUN TestGetPassphraseLimitsShortPassphrases @@ -2700,282 +2736,282 @@ === RUN TestGetPassphrase --- PASS: TestGetPassphrase (0.00s) PASS -ok github.com/theupdateframework/notary/passphrase 0.032s +ok github.com/theupdateframework/notary/passphrase 0.065s ? github.com/theupdateframework/notary/proto [no test files] === RUN TestValidationErrorFormat -time="2025-02-07T19:31:50Z" 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.19.8 http.request.contenttype="multipart/form-data; boundary=88e302725125ce82bea29b1e7042b92d8391fb0186a1cf9a73979d1e1826" http.request.host="127.0.0.1:43939" http.request.id=99c1e934-229e-4b45-bc37-ce29591fbe9a http.request.method=POST http.request.remoteaddr="127.0.0.1:54742" http.request.uri=/v2/docker.com/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 -time="2025-02-07T19:31:50Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype="multipart/form-data; boundary=88e302725125ce82bea29b1e7042b92d8391fb0186a1cf9a73979d1e1826" http.request.host="127.0.0.1:43939" http.request.id=99c1e934-229e-4b45-bc37-ce29591fbe9a http.request.method=POST http.request.remoteaddr="127.0.0.1:54742" 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=8.447489ms http.response.status=400 http.response.written=260 ---- PASS: TestValidationErrorFormat (0.02s) +time="2024-01-06T13:15: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.19.8 http.request.contenttype="multipart/form-data; boundary=04b0a751841e8a8c50601a472b48a699b1d36de97ddb565a21249d1c0c9c" http.request.host="127.0.0.1:42323" http.request.id=5a52c0e2-4c82-4d2c-860c-68073d5776d5 http.request.method=POST http.request.remoteaddr="127.0.0.1:38570" http.request.uri=/v2/docker.com/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 +time="2024-01-06T13:15:05Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype="multipart/form-data; boundary=04b0a751841e8a8c50601a472b48a699b1d36de97ddb565a21249d1c0c9c" http.request.host="127.0.0.1:42323" http.request.id=5a52c0e2-4c82-4d2c-860c-68073d5776d5 http.request.method=POST http.request.remoteaddr="127.0.0.1:38570" 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=3.366993ms http.response.status=400 http.response.written=260 +--- PASS: TestValidationErrorFormat (0.10s) === RUN TestRunBadAddr --- PASS: TestRunBadAddr (0.00s) === RUN TestRunReservedPort --- PASS: TestRunReservedPort (0.00s) === RUN TestRepoPrefixMatches -time="2025-02-07T19:31:50Z" level=info msg="updated docker.io/notary to timestamp version 1, checksum 6fa21d6adcbc8faad9d034196d643195e5e121a8a9183c350e8ec4d995f64301" docker.io/notary=gun go.version=go1.19.8 http.request.contenttype="multipart/form-data; boundary=ac5d560f93696f93ce64d20eba2ace50dec9e34864e7bdb2b949b1254057" http.request.host="127.0.0.1:37515" http.request.id=3349a8e5-d0b1-4181-968f-6e581de274af http.request.method=POST http.request.remoteaddr="127.0.0.1:34518" http.request.uri=/v2/docker.io/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 -time="2025-02-07T19:31:50Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype="multipart/form-data; boundary=ac5d560f93696f93ce64d20eba2ace50dec9e34864e7bdb2b949b1254057" http.request.host="127.0.0.1:37515" http.request.id=3349a8e5-d0b1-4181-968f-6e581de274af http.request.method=POST http.request.remoteaddr="127.0.0.1:34518" http.request.uri=/v2/docker.io/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 http.response.duration=7.517169ms http.response.status=0 http.response.written=0 -time="2025-02-07T19:31:50Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:37515" http.request.id=2d4937ce-c386-4424-bd03-e5b80da2bafb http.request.method=GET http.request.remoteaddr="127.0.0.1:34518" http.request.uri=/v2/docker.io/notary/_trust/tuf/snapshot.json http.request.useragent=Go-http-client/1.1 http.response.duration="747.996µs" http.response.status=200 http.response.written=683 -time="2025-02-07T19:31:50Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:37515" http.request.id=d5042d33-5b4e-4881-8a57-ae5915a00f86 http.request.method=GET http.request.remoteaddr="127.0.0.1:34518" http.request.uri=/v2/docker.io/notary/_trust/tuf/snapshot.d2aedd3ef1bcbe99f24d0b64ef180c0bdf98d84ec5f068942d3e928ea46bbefe.json http.request.useragent=Go-http-client/1.1 http.response.duration="55.708µs" http.response.status=200 http.response.written=683 -time="2025-02-07T19:31:50Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:37515" http.request.id=b5ee8c8e-4572-42f5-b07d-81332653614d http.request.method=GET http.request.remoteaddr="127.0.0.1:34518" http.request.uri=/v2/docker.io/notary/_trust/tuf/timestamp.key http.request.useragent=Go-http-client/1.1 http.response.duration="585.602µs" http.response.status=200 http.response.written=181 -time="2025-02-07T19:31:50Z" level=info msg="trust data deleted for docker.io/notary" docker.io/notary=gun go.version=go1.19.8 http.request.host="127.0.0.1:37515" http.request.id=002f4060-f354-42d8-9d19-a8eed07fff2b http.request.method=DELETE http.request.remoteaddr="127.0.0.1:34518" http.request.uri=/v2/docker.io/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 -time="2025-02-07T19:31:50Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:37515" http.request.id=002f4060-f354-42d8-9d19-a8eed07fff2b http.request.method=DELETE http.request.remoteaddr="127.0.0.1:34518" http.request.uri=/v2/docker.io/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 http.response.duration="68.462µs" http.response.status=0 http.response.written=0 ---- PASS: TestRepoPrefixMatches (0.02s) +time="2024-01-06T13:15:05Z" level=info msg="updated docker.io/notary to timestamp version 1, checksum b2ace7959af5b5f7cb6fccc4b8d899d4b1d91ba70d454709e43b407d5092aaad" docker.io/notary=gun go.version=go1.19.8 http.request.contenttype="multipart/form-data; boundary=f7eacec1c2a5409dc08e474b0e75f1d0c3c0af4d889b8f48c41ae7279efa" http.request.host="127.0.0.1:33537" http.request.id=6fee9a0c-6f06-4f04-b257-43daa0feb2e7 http.request.method=POST http.request.remoteaddr="127.0.0.1:33142" http.request.uri=/v2/docker.io/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 +time="2024-01-06T13:15:05Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype="multipart/form-data; boundary=f7eacec1c2a5409dc08e474b0e75f1d0c3c0af4d889b8f48c41ae7279efa" http.request.host="127.0.0.1:33537" http.request.id=6fee9a0c-6f06-4f04-b257-43daa0feb2e7 http.request.method=POST http.request.remoteaddr="127.0.0.1:33142" http.request.uri=/v2/docker.io/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 http.response.duration=2.870518ms http.response.status=0 http.response.written=0 +time="2024-01-06T13:15:05Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:33537" http.request.id=e9c68694-ab35-4573-a6aa-531d6f7b1c43 http.request.method=GET http.request.remoteaddr="127.0.0.1:33142" http.request.uri=/v2/docker.io/notary/_trust/tuf/snapshot.json http.request.useragent=Go-http-client/1.1 http.response.duration="639.896µs" http.response.status=200 http.response.written=683 +time="2024-01-06T13:15:05Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:33537" http.request.id=9c32f1d0-b334-410a-8b13-4d13859507f8 http.request.method=GET http.request.remoteaddr="127.0.0.1:33142" http.request.uri=/v2/docker.io/notary/_trust/tuf/snapshot.484af5412ae64a560832ce9e19c2cfd2d332b79f448224bccd01266b83c490fb.json http.request.useragent=Go-http-client/1.1 http.response.duration="27.86µs" http.response.status=200 http.response.written=683 +time="2024-01-06T13:15:05Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:33537" http.request.id=eaec1862-6a21-4c8d-8369-014587deb593 http.request.method=GET http.request.remoteaddr="127.0.0.1:33142" http.request.uri=/v2/docker.io/notary/_trust/tuf/timestamp.key http.request.useragent=Go-http-client/1.1 http.response.duration="434.65µs" http.response.status=200 http.response.written=181 +time="2024-01-06T13:15:05Z" level=info msg="trust data deleted for docker.io/notary" docker.io/notary=gun go.version=go1.19.8 http.request.host="127.0.0.1:33537" http.request.id=87042727-1d6e-41e1-b844-00dacb451ab4 http.request.method=DELETE http.request.remoteaddr="127.0.0.1:33142" http.request.uri=/v2/docker.io/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 +time="2024-01-06T13:15:05Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:33537" http.request.id=87042727-1d6e-41e1-b844-00dacb451ab4 http.request.method=DELETE http.request.remoteaddr="127.0.0.1:33142" http.request.uri=/v2/docker.io/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 http.response.duration="49.821µs" http.response.status=0 http.response.written=0 +--- PASS: TestRepoPrefixMatches (0.06s) === RUN TestRepoPrefixDoesNotMatch ---- PASS: TestRepoPrefixDoesNotMatch (0.02s) +--- PASS: TestRepoPrefixDoesNotMatch (0.05s) === RUN TestMetricsEndpoint ---- PASS: TestMetricsEndpoint (0.01s) +--- PASS: TestMetricsEndpoint (0.06s) === RUN TestGetKeysEndpoint -time="2025-02-07T19:31:50Z" level=info msg="metadata not found: You have requested metadata that does not exist.: " go.version=go1.19.8 http.request.host="127.0.0.1:44987" http.request.id=a15aa790-75b7-4e8c-97ff-92fbb1042a70 http.request.method=GET http.request.remoteaddr="127.0.0.1:49728" http.request.uri=/v2/gun/_trust/tuf/somerandomrole.key http.request.useragent=Go-http-client/1.1 -time="2025-02-07T19:31:50Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:44987" http.request.id=a15aa790-75b7-4e8c-97ff-92fbb1042a70 http.request.method=GET http.request.remoteaddr="127.0.0.1:49728" 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="198.018µs" http.response.status=404 http.response.written=104 -time="2025-02-07T19:31:50Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:44987" http.request.id=67ae81e5-22b6-470e-9c60-b09713b86d94 http.request.method=GET http.request.remoteaddr="127.0.0.1:49736" http.request.uri=/v2/gun/_trust/tuf/timestamp.key http.request.useragent=Go-http-client/1.1 http.response.duration=4.008523ms http.response.status=200 http.response.written=103 -time="2025-02-07T19:31:50Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:44987" http.request.id=9f6fcb2f-e1c0-494c-b40f-b66764be27a0 http.request.method=GET http.request.remoteaddr="127.0.0.1:49742" http.request.uri=/v2/gun/_trust/tuf/snapshot.key http.request.useragent=Go-http-client/1.1 http.response.duration="163.127µs" http.response.status=200 http.response.written=103 -time="2025-02-07T19:31:50Z" level=info msg="metadata not found: You have requested metadata that does not exist.: " go.version=go1.19.8 http.request.host="127.0.0.1:44987" http.request.id=c83ab258-43aa-401b-8949-e5734b7102c9 http.request.method=GET http.request.remoteaddr="127.0.0.1:49748" http.request.uri=/v2/gun/_trust/tuf/targets.key http.request.useragent=Go-http-client/1.1 -time="2025-02-07T19:31:50Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:44987" http.request.id=c83ab258-43aa-401b-8949-e5734b7102c9 http.request.method=GET http.request.remoteaddr="127.0.0.1:49748" 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="107.539µs" http.response.status=404 http.response.written=104 -time="2025-02-07T19:31:50Z" level=info msg="metadata not found: You have requested metadata that does not exist.: " go.version=go1.19.8 http.request.host="127.0.0.1:44987" http.request.id=c3429220-2804-4e63-a424-81b895b60796 http.request.method=GET http.request.remoteaddr="127.0.0.1:49754" http.request.uri=/v2/gun/_trust/tuf/root.key http.request.useragent=Go-http-client/1.1 -time="2025-02-07T19:31:50Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:44987" http.request.id=c3429220-2804-4e63-a424-81b895b60796 http.request.method=GET http.request.remoteaddr="127.0.0.1:49754" 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="205.826µs" http.response.status=404 http.response.written=104 ---- PASS: TestGetKeysEndpoint (0.02s) +time="2024-01-06T13:15:05Z" level=info msg="metadata not found: You have requested metadata that does not exist.: " go.version=go1.19.8 http.request.host="127.0.0.1:37427" http.request.id=5e992991-ebfb-48c2-b0fc-ede32f72a282 http.request.method=GET http.request.remoteaddr="127.0.0.1:47962" http.request.uri=/v2/gun/_trust/tuf/somerandomrole.key http.request.useragent=Go-http-client/1.1 +time="2024-01-06T13:15:05Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:37427" http.request.id=5e992991-ebfb-48c2-b0fc-ede32f72a282 http.request.method=GET http.request.remoteaddr="127.0.0.1:47962" 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="215.939µs" http.response.status=404 http.response.written=104 +time="2024-01-06T13:15:05Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:37427" http.request.id=55924cc3-cf70-40b3-b713-da52727ed350 http.request.method=GET http.request.remoteaddr="127.0.0.1:47970" http.request.uri=/v2/gun/_trust/tuf/timestamp.key http.request.useragent=Go-http-client/1.1 http.response.duration=24.202924ms http.response.status=200 http.response.written=103 +time="2024-01-06T13:15:06Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:37427" http.request.id=e5a006cf-e95d-48b6-acf6-517334b00e41 http.request.method=GET http.request.remoteaddr="127.0.0.1:47982" http.request.uri=/v2/gun/_trust/tuf/snapshot.key http.request.useragent=Go-http-client/1.1 http.response.duration="260.264µs" http.response.status=200 http.response.written=103 +time="2024-01-06T13:15:06Z" level=info msg="metadata not found: You have requested metadata that does not exist.: " go.version=go1.19.8 http.request.host="127.0.0.1:37427" http.request.id=11523348-0540-4bb9-ad31-c2ac0f2b3ecd http.request.method=GET http.request.remoteaddr="127.0.0.1:47986" http.request.uri=/v2/gun/_trust/tuf/targets.key http.request.useragent=Go-http-client/1.1 +time="2024-01-06T13:15:06Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:37427" http.request.id=11523348-0540-4bb9-ad31-c2ac0f2b3ecd http.request.method=GET http.request.remoteaddr="127.0.0.1:47986" 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="105.099µs" http.response.status=404 http.response.written=104 +time="2024-01-06T13:15:06Z" level=info msg="metadata not found: You have requested metadata that does not exist.: " go.version=go1.19.8 http.request.host="127.0.0.1:37427" http.request.id=08a9b577-c6b6-435e-9efc-b2ec9b108356 http.request.method=GET http.request.remoteaddr="127.0.0.1:48000" http.request.uri=/v2/gun/_trust/tuf/root.key http.request.useragent=Go-http-client/1.1 +time="2024-01-06T13:15:06Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:37427" http.request.id=08a9b577-c6b6-435e-9efc-b2ec9b108356 http.request.method=GET http.request.remoteaddr="127.0.0.1:48000" 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="89.811µs" http.response.status=404 http.response.written=104 +--- PASS: TestGetKeysEndpoint (0.09s) === RUN TestGetRoleByHash -time="2025-02-07T19:31:50Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:34909" http.request.id=d26a10dd-981e-4437-9533-7997c1e16491 http.request.method=GET http.request.remoteaddr="127.0.0.1:44574" http.request.uri=/v2/gun/_trust/tuf/timestamp.bd1fca7660bdedaa26bc4d73aa9cc1fe0b508366a1272dae7f711fb582f99299.json http.request.useragent=Go-http-client/1.1 http.response.duration="78.982µs" http.response.status=200 http.response.written=115 ---- PASS: TestGetRoleByHash (0.00s) +time="2024-01-06T13:15:06Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:40843" http.request.id=ed004c0f-f8b7-4f62-a412-ab0805b0bbf5 http.request.method=GET http.request.remoteaddr="127.0.0.1:49766" http.request.uri=/v2/gun/_trust/tuf/timestamp.9a910b762a06affca6ce3f7decb8fed8e0936c4bfe2aa56aaf1c8ab6f32a2401.json http.request.useragent=Go-http-client/1.1 http.response.duration="101.607µs" http.response.status=200 http.response.written=115 +--- PASS: TestGetRoleByHash (0.03s) === RUN TestGetRoleByVersion -time="2025-02-07T19:31:50Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:38153" http.request.id=bbbf91cf-0f19-4fe9-992d-d28f8aae3c09 http.request.method=GET http.request.remoteaddr="127.0.0.1:53320" http.request.uri=/v2/gun/_trust/tuf/1.timestamp.json http.request.useragent=Go-http-client/1.1 http.response.duration="83.751µs" http.response.status=200 http.response.written=115 ---- PASS: TestGetRoleByVersion (0.01s) +time="2024-01-06T13:15:06Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:43647" http.request.id=3453386e-7d8d-478b-9381-5a9fa1156f6c http.request.method=GET http.request.remoteaddr="127.0.0.1:49818" http.request.uri=/v2/gun/_trust/tuf/1.timestamp.json http.request.useragent=Go-http-client/1.1 http.response.duration="110.109µs" http.response.status=200 http.response.written=114 +--- PASS: TestGetRoleByVersion (0.02s) === RUN TestGetCurrentRole -time="2025-02-07T19:31:50Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:41291" http.request.id=acda6983-9cc5-41d2-8b2e-ad0d577ce1f4 http.request.method=GET http.request.remoteaddr="127.0.0.1:37798" http.request.uri=/v2/gun/_trust/tuf/timestamp.json http.request.useragent=Go-http-client/1.1 http.response.duration="500.336µs" http.response.status=200 http.response.written=495 ---- PASS: TestGetCurrentRole (0.01s) +time="2024-01-06T13:15:06Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:39593" http.request.id=e17eaeeb-83ac-4be3-9a34-df0f75e6c13f http.request.method=GET http.request.remoteaddr="127.0.0.1:33198" http.request.uri=/v2/gun/_trust/tuf/timestamp.json http.request.useragent=Go-http-client/1.1 http.response.duration="627.652µs" http.response.status=200 http.response.written=495 +--- PASS: TestGetCurrentRole (0.05s) === RUN TestRotateKeyEndpoint -time="2025-02-07T19:31:50Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:41525" http.request.id=0ded014c-621e-4b6d-b292-99beab7f2d58 http.request.method=POST http.request.remoteaddr="127.0.0.1:46830" http.request.uri=/v2/gun/_trust/tuf/snapshot.key http.request.useragent=Go-http-client/1.1 http.response.duration="237.2µs" http.response.status=200 http.response.written=103 -time="2025-02-07T19:31:50Z" level=info msg="metadata not found: You have requested metadata that does not exist.: " go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:41525" http.request.id=76a8b371-cafd-4708-b27e-d84c619507b5 http.request.method=POST http.request.remoteaddr="127.0.0.1:46842" http.request.uri=/v2/gun/_trust/tuf/targets.key http.request.useragent=Go-http-client/1.1 -time="2025-02-07T19:31:50Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:41525" http.request.id=76a8b371-cafd-4708-b27e-d84c619507b5 http.request.method=POST http.request.remoteaddr="127.0.0.1:46842" 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="186.077µs" http.response.status=404 http.response.written=104 -time="2025-02-07T19:31:50Z" level=info msg="metadata not found: You have requested metadata that does not exist.: " go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:41525" http.request.id=a51e569a-7624-4294-8f17-a6a3b875fc2e http.request.method=POST http.request.remoteaddr="127.0.0.1:46852" http.request.uri=/v2/gun/_trust/tuf/root.key http.request.useragent=Go-http-client/1.1 -time="2025-02-07T19:31:50Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:41525" http.request.id=a51e569a-7624-4294-8f17-a6a3b875fc2e http.request.method=POST http.request.remoteaddr="127.0.0.1:46852" 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="124.075µs" http.response.status=404 http.response.written=104 -time="2025-02-07T19:31:50Z" level=info msg="metadata not found: You have requested metadata that does not exist.: " go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:41525" http.request.id=865dfa3c-9853-4ec3-b246-18e6ce837def http.request.method=POST http.request.remoteaddr="127.0.0.1:46860" http.request.uri=/v2/gun/_trust/tuf/targets/delegation.key http.request.useragent=Go-http-client/1.1 -time="2025-02-07T19:31:50Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:41525" http.request.id=865dfa3c-9853-4ec3-b246-18e6ce837def http.request.method=POST http.request.remoteaddr="127.0.0.1:46860" 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="145.119µs" http.response.status=404 http.response.written=104 -time="2025-02-07T19:31:50Z" level=info msg="metadata not found: You have requested metadata that does not exist.: " go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:41525" http.request.id=5fd16924-f458-4174-8183-be3787415186 http.request.method=POST http.request.remoteaddr="127.0.0.1:46862" http.request.uri=/v2/gun/_trust/tuf/somerandomrole.key http.request.useragent=Go-http-client/1.1 -time="2025-02-07T19:31:50Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:41525" http.request.id=5fd16924-f458-4174-8183-be3787415186 http.request.method=POST http.request.remoteaddr="127.0.0.1:46862" 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="122.729µs" http.response.status=404 http.response.written=104 -time="2025-02-07T19:31:50Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:41525" http.request.id=c32f23ee-ec51-47a1-8554-e9b9c0f7b607 http.request.method=POST http.request.remoteaddr="127.0.0.1:46872" http.request.uri=/v2/gun/_trust/tuf/timestamp.key http.request.useragent=Go-http-client/1.1 http.response.duration="200.781µs" http.response.status=200 http.response.written=103 ---- PASS: TestRotateKeyEndpoint (0.01s) +time="2024-01-06T13:15:06Z" level=info msg="metadata not found: You have requested metadata that does not exist.: " go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:34705" http.request.id=9bfc9abd-91ab-44ee-aa9c-c81f99b57c9a http.request.method=POST http.request.remoteaddr="127.0.0.1:34582" http.request.uri=/v2/gun/_trust/tuf/targets/delegation.key http.request.useragent=Go-http-client/1.1 +time="2024-01-06T13:15:06Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:34705" http.request.id=9bfc9abd-91ab-44ee-aa9c-c81f99b57c9a http.request.method=POST http.request.remoteaddr="127.0.0.1:34582" 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="244.278µs" http.response.status=404 http.response.written=104 +time="2024-01-06T13:15:06Z" level=info msg="metadata not found: You have requested metadata that does not exist.: " go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:34705" http.request.id=f506c87e-ca09-40b9-926d-c62684c00ad6 http.request.method=POST http.request.remoteaddr="127.0.0.1:34584" http.request.uri=/v2/gun/_trust/tuf/somerandomrole.key http.request.useragent=Go-http-client/1.1 +time="2024-01-06T13:15:06Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:34705" http.request.id=f506c87e-ca09-40b9-926d-c62684c00ad6 http.request.method=POST http.request.remoteaddr="127.0.0.1:34584" 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="109.543µs" http.response.status=404 http.response.written=104 +time="2024-01-06T13:15:06Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:34705" http.request.id=dbb24281-ef10-4846-941f-c939bf0ad2d3 http.request.method=POST http.request.remoteaddr="127.0.0.1:34592" http.request.uri=/v2/gun/_trust/tuf/timestamp.key http.request.useragent=Go-http-client/1.1 http.response.duration="223.331µs" http.response.status=200 http.response.written=103 +time="2024-01-06T13:15:06Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:34705" http.request.id=de45079a-b12f-491c-bd9e-2881913c8684 http.request.method=POST http.request.remoteaddr="127.0.0.1:34602" http.request.uri=/v2/gun/_trust/tuf/snapshot.key http.request.useragent=Go-http-client/1.1 http.response.duration="176.481µs" http.response.status=200 http.response.written=103 +time="2024-01-06T13:15:06Z" level=info msg="metadata not found: You have requested metadata that does not exist.: " go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:34705" http.request.id=65721f32-5938-4a3e-b14c-c3e5072910fd http.request.method=POST http.request.remoteaddr="127.0.0.1:34618" http.request.uri=/v2/gun/_trust/tuf/targets.key http.request.useragent=Go-http-client/1.1 +time="2024-01-06T13:15:06Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:34705" http.request.id=65721f32-5938-4a3e-b14c-c3e5072910fd http.request.method=POST http.request.remoteaddr="127.0.0.1:34618" 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="109.825µs" http.response.status=404 http.response.written=104 +time="2024-01-06T13:15:06Z" level=info msg="metadata not found: You have requested metadata that does not exist.: " go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:34705" http.request.id=df3235c2-33c8-44c1-a692-d9d89a8e3d1f http.request.method=POST http.request.remoteaddr="127.0.0.1:34622" http.request.uri=/v2/gun/_trust/tuf/root.key http.request.useragent=Go-http-client/1.1 +time="2024-01-06T13:15:06Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:34705" http.request.id=df3235c2-33c8-44c1-a692-d9d89a8e3d1f http.request.method=POST http.request.remoteaddr="127.0.0.1:34622" 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="120.723µs" http.response.status=404 http.response.written=104 +--- PASS: TestRotateKeyEndpoint (0.05s) PASS -ok github.com/theupdateframework/notary/server 0.148s +ok github.com/theupdateframework/notary/server 0.531s ? github.com/theupdateframework/notary/server/errors [no test files] === RUN Test_changefeed --- PASS: Test_changefeed (0.00s) === RUN Test_checkChangefeedInputs -time="2025-02-07T19:31:50Z" level=error msg="500 GET unable to retrieve storage" -time="2025-02-07T19:31:50Z" level=error msg="400 GET invalid pageSize: not_a_number" +time="2024-01-06T13:15:06Z" level=error msg="500 GET unable to retrieve storage" +time="2024-01-06T13:15:06Z" level=error msg="400 GET invalid pageSize: not_a_number" --- PASS: Test_checkChangefeedInputs (0.00s) === RUN TestMainHandlerGet -time="2025-02-07T19:31:50Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:34611" http.request.id=037e326b-0579-4b1b-8d7e-8407f28b7efe http.request.method=GET http.request.remoteaddr="127.0.0.1:41710" http.request.uri=/ http.request.useragent=Go-http-client/1.1 http.response.duration="65.261µs" http.response.status=200 http.response.written=2 +time="2024-01-06T13:15:06Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:37289" http.request.id=e2680d10-3da7-46eb-9b93-b8cb4bf79a05 http.request.method=GET http.request.remoteaddr="127.0.0.1:36084" http.request.uri=/ http.request.useragent=Go-http-client/1.1 http.response.duration="38.686µs" http.response.status=200 http.response.written=2 --- PASS: TestMainHandlerGet (0.00s) === RUN TestMainHandlerNotGet -time="2025-02-07T19:31:50Z" level=info msg="generic not found: You have requested a resource that does not exist.: " go.version=go1.19.8 http.request.host="127.0.0.1:39113" http.request.id=d988e383-aa86-4fb9-bf69-5afc0dd88b59 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:50894" http.request.uri=/ http.request.useragent=Go-http-client/1.1 -time="2025-02-07T19:31:50Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:39113" http.request.id=d988e383-aa86-4fb9-bf69-5afc0dd88b59 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:50894" http.request.uri=/ http.request.useragent=Go-http-client/1.1 http.response.contenttype="application/json; charset=utf-8" http.response.duration="214.024µs" http.response.status=404 http.response.written=105 ---- PASS: TestMainHandlerNotGet (0.00s) +time="2024-01-06T13:15:06Z" level=info msg="generic not found: You have requested a resource that does not exist.: " go.version=go1.19.8 http.request.host="127.0.0.1:42549" http.request.id=50e5bebf-9e93-4ddf-b884-1d890e2f293a http.request.method=HEAD http.request.remoteaddr="127.0.0.1:45282" http.request.uri=/ http.request.useragent=Go-http-client/1.1 +time="2024-01-06T13:15:06Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:42549" http.request.id=50e5bebf-9e93-4ddf-b884-1d890e2f293a http.request.method=HEAD http.request.remoteaddr="127.0.0.1:45282" http.request.uri=/ http.request.useragent=Go-http-client/1.1 http.response.contenttype="application/json; charset=utf-8" http.response.duration="367.741µs" http.response.status=404 http.response.written=105 +--- PASS: TestMainHandlerNotGet (0.02s) === RUN TestKeyHandlersInvalidConfiguration -time="2025-02-07T19:31:50Z" level=error msg="500 GET key algorithm not configured" go.version=go1.19.8 gun=gun -time="2025-02-07T19:31:50Z" level=error msg="500 GET key algorithm not configured" go.version=go1.19.8 gun=gun -time="2025-02-07T19:31:50Z" level=error msg="500 GET storage not configured" go.version=go1.19.8 gun=gun -time="2025-02-07T19:31:50Z" level=error msg="500 GET storage not configured" go.version=go1.19.8 gun=gun -time="2025-02-07T19:31:50Z" level=error msg="500 GET crypto service not configured" go.version=go1.19.8 gun=gun -time="2025-02-07T19:31:50Z" level=error msg="500 GET crypto service not configured" go.version=go1.19.8 gun=gun -time="2025-02-07T19:31:50Z" level=error msg="500 POST crypto service not configured" go.version=go1.19.8 gun=gun -time="2025-02-07T19:31:50Z" level=error msg="500 POST crypto service not configured" go.version=go1.19.8 gun=gun -time="2025-02-07T19:31:50Z" level=error msg="500 POST key algorithm not configured" go.version=go1.19.8 gun=gun -time="2025-02-07T19:31:50Z" level=error msg="500 POST key algorithm not configured" go.version=go1.19.8 gun=gun -time="2025-02-07T19:31:50Z" level=error msg="500 POST storage not configured" go.version=go1.19.8 gun=gun -time="2025-02-07T19:31:50Z" level=error msg="500 POST storage not configured" go.version=go1.19.8 gun=gun +time="2024-01-06T13:15:06Z" level=error msg="500 GET storage not configured" go.version=go1.19.8 gun=gun +time="2024-01-06T13:15:06Z" level=error msg="500 GET storage not configured" go.version=go1.19.8 gun=gun +time="2024-01-06T13:15:06Z" level=error msg="500 GET crypto service not configured" go.version=go1.19.8 gun=gun +time="2024-01-06T13:15:06Z" level=error msg="500 GET crypto service not configured" go.version=go1.19.8 gun=gun +time="2024-01-06T13:15:06Z" level=error msg="500 GET key algorithm not configured" go.version=go1.19.8 gun=gun +time="2024-01-06T13:15:06Z" level=error msg="500 GET key algorithm not configured" go.version=go1.19.8 gun=gun +time="2024-01-06T13:15:06Z" level=error msg="500 POST storage not configured" go.version=go1.19.8 gun=gun +time="2024-01-06T13:15:06Z" level=error msg="500 POST storage not configured" go.version=go1.19.8 gun=gun +time="2024-01-06T13:15:06Z" level=error msg="500 POST crypto service not configured" go.version=go1.19.8 gun=gun +time="2024-01-06T13:15:06Z" level=error msg="500 POST crypto service not configured" go.version=go1.19.8 gun=gun +time="2024-01-06T13:15:06Z" level=error msg="500 POST key algorithm not configured" go.version=go1.19.8 gun=gun +time="2024-01-06T13:15:06Z" level=error msg="500 POST key algorithm not configured" go.version=go1.19.8 gun=gun --- PASS: TestKeyHandlersInvalidConfiguration (0.00s) === RUN TestKeyHandlersNoRoleOrRepo -time="2025-02-07T19:31:50Z" level=info msg="400 GET no gun in request" =gun go.version=go1.19.8 -time="2025-02-07T19:31:50Z" level=info msg="400 GET no gun in request" =gun go.version=go1.19.8 -time="2025-02-07T19:31:50Z" level=info msg="400 GET no role in request" go.version=go1.19.8 gun=gun -time="2025-02-07T19:31:50Z" level=info msg="400 GET no role in request" go.version=go1.19.8 gun=gun -time="2025-02-07T19:31:50Z" level=info msg="400 POST no gun in request" =gun go.version=go1.19.8 -time="2025-02-07T19:31:50Z" level=info msg="400 POST no gun in request" =gun go.version=go1.19.8 -time="2025-02-07T19:31:50Z" level=info msg="400 POST no role in request" go.version=go1.19.8 gun=gun -time="2025-02-07T19:31:50Z" level=info msg="400 POST no role in request" go.version=go1.19.8 gun=gun +time="2024-01-06T13:15:06Z" level=info msg="400 GET no gun in request" =gun go.version=go1.19.8 +time="2024-01-06T13:15:06Z" level=info msg="400 GET no gun in request" =gun go.version=go1.19.8 +time="2024-01-06T13:15:06Z" level=info msg="400 GET no role in request" go.version=go1.19.8 gun=gun +time="2024-01-06T13:15:06Z" level=info msg="400 GET no role in request" go.version=go1.19.8 gun=gun +time="2024-01-06T13:15:06Z" level=info msg="400 POST no gun in request" =gun go.version=go1.19.8 +time="2024-01-06T13:15:06Z" level=info msg="400 POST no gun in request" =gun go.version=go1.19.8 +time="2024-01-06T13:15:06Z" level=info msg="400 POST no role in request" go.version=go1.19.8 gun=gun +time="2024-01-06T13:15:06Z" level=info msg="400 POST no role in request" go.version=go1.19.8 gun=gun --- PASS: TestKeyHandlersNoRoleOrRepo (0.00s) === RUN TestKeyHandlersInvalidRole -time="2025-02-07T19:31:50Z" level=info msg="400 GET root key: " go.version=go1.19.8 gun=gun -time="2025-02-07T19:31:50Z" level=info msg="400 GET targets key: " go.version=go1.19.8 gun=gun -time="2025-02-07T19:31:50Z" level=info msg="400 GET targets/a key: " go.version=go1.19.8 gun=gun -time="2025-02-07T19:31:50Z" level=info msg="400 GET invalidrole key: " go.version=go1.19.8 gun=gun -time="2025-02-07T19:31:50Z" level=info msg="400 POST root key: " go.version=go1.19.8 gun=gun -time="2025-02-07T19:31:50Z" level=info msg="400 POST targets key: " go.version=go1.19.8 gun=gun -time="2025-02-07T19:31:50Z" level=info msg="400 POST targets/a key: " go.version=go1.19.8 gun=gun -time="2025-02-07T19:31:50Z" level=info msg="400 POST invalidrole key: " go.version=go1.19.8 gun=gun +time="2024-01-06T13:15:06Z" level=info msg="400 GET root key: " go.version=go1.19.8 gun=gun +time="2024-01-06T13:15:06Z" level=info msg="400 GET targets key: " go.version=go1.19.8 gun=gun +time="2024-01-06T13:15:06Z" level=info msg="400 GET targets/a key: " go.version=go1.19.8 gun=gun +time="2024-01-06T13:15:06Z" level=info msg="400 GET invalidrole key: " go.version=go1.19.8 gun=gun +time="2024-01-06T13:15:06Z" level=info msg="400 POST root key: " go.version=go1.19.8 gun=gun +time="2024-01-06T13:15:06Z" level=info msg="400 POST targets key: " go.version=go1.19.8 gun=gun +time="2024-01-06T13:15:06Z" level=info msg="400 POST targets/a key: " go.version=go1.19.8 gun=gun +time="2024-01-06T13:15:06Z" level=info msg="400 POST invalidrole key: " go.version=go1.19.8 gun=gun --- PASS: TestKeyHandlersInvalidRole (0.00s) === RUN TestGetKeyHandlerCreatesOnce ---- PASS: TestGetKeyHandlerCreatesOnce (0.00s) +--- PASS: TestGetKeyHandlerCreatesOnce (0.02s) === RUN TestKeyHandlersInvalidKeyAlgo -time="2025-02-07T19:31:50Z" level=error msg="500 GET timestamp key: only ED25519 supported by this cryptoservice" go.version=go1.19.8 gun=gun -time="2025-02-07T19:31:50Z" level=error msg="500 GET snapshot key: only ED25519 supported by this cryptoservice" go.version=go1.19.8 gun=gun -time="2025-02-07T19:31:50Z" level=error msg="500 POST timestamp key: only ED25519 supported by this cryptoservice" go.version=go1.19.8 gun=gun -time="2025-02-07T19:31:50Z" level=error msg="500 POST snapshot key: only ED25519 supported by this cryptoservice" go.version=go1.19.8 gun=gun +time="2024-01-06T13:15:06Z" level=error msg="500 GET timestamp key: only ED25519 supported by this cryptoservice" go.version=go1.19.8 gun=gun +time="2024-01-06T13:15:06Z" level=error msg="500 GET snapshot key: only ED25519 supported by this cryptoservice" go.version=go1.19.8 gun=gun +time="2024-01-06T13:15:06Z" level=error msg="500 POST timestamp key: only ED25519 supported by this cryptoservice" go.version=go1.19.8 gun=gun +time="2024-01-06T13:15:06Z" level=error msg="500 POST snapshot key: only ED25519 supported by this cryptoservice" go.version=go1.19.8 gun=gun --- PASS: TestKeyHandlersInvalidKeyAlgo (0.00s) === RUN TestRotateKeyHandlerSuccessfulRotation --- PASS: TestRotateKeyHandlerSuccessfulRotation (0.00s) === RUN TestGetHandlerRoot -time="2025-02-07T19:31:50Z" level=info msg="404 GET root role" go.version=go1.19.8 gun=gun ---- PASS: TestGetHandlerRoot (0.00s) +time="2024-01-06T13:15:06Z" level=info msg="404 GET root role" go.version=go1.19.8 gun=gun +--- PASS: TestGetHandlerRoot (0.02s) === RUN TestGetHandlerTimestamp --- PASS: TestGetHandlerTimestamp (0.00s) === RUN TestGetHandlerSnapshot ---- PASS: TestGetHandlerSnapshot (0.01s) +--- PASS: TestGetHandlerSnapshot (0.04s) === RUN TestGetHandler404 -time="2025-02-07T19:31:50Z" level=info msg="404 GET root role" go.version=go1.19.8 gun=gun +time="2024-01-06T13:15:06Z" level=info msg="404 GET root role" go.version=go1.19.8 gun=gun --- PASS: TestGetHandler404 (0.00s) === RUN TestGetHandlerNilData -time="2025-02-07T19:31:50Z" level=info msg="404 GET root role" go.version=go1.19.8 gun=gun +time="2024-01-06T13:15:06Z" level=info msg="404 GET root role" go.version=go1.19.8 gun=gun --- PASS: TestGetHandlerNilData (0.00s) === RUN TestGetHandlerNoStorage -time="2025-02-07T19:31:50Z" level=error msg="500 GET: no storage exists" =gun go.version=go1.19.8 +time="2024-01-06T13:15:06Z" level=error msg="500 GET: no storage exists" =gun go.version=go1.19.8 --- PASS: TestGetHandlerNoStorage (0.00s) === RUN TestAtomicUpdateValidationFailurePropagated ---- PASS: TestAtomicUpdateValidationFailurePropagated (0.02s) +--- PASS: TestAtomicUpdateValidationFailurePropagated (0.04s) === RUN TestAtomicUpdateNonValidationFailureNotPropagated -time="2025-02-07T19:31:50Z" level=info msg="400 POST error validating update" go.version=go1.19.8 testGUN=gun ---- PASS: TestAtomicUpdateNonValidationFailureNotPropagated (0.01s) +time="2024-01-06T13:15:07Z" level=info msg="400 POST error validating update" go.version=go1.19.8 testGUN=gun +--- PASS: TestAtomicUpdateNonValidationFailureNotPropagated (0.06s) === RUN TestAtomicUpdateVersionErrorPropagated -time="2025-02-07T19:31:50Z" level=info msg="400 POST old version error" go.version=go1.19.8 testGUN=gun ---- PASS: TestAtomicUpdateVersionErrorPropagated (0.01s) +time="2024-01-06T13:15:07Z" level=info msg="400 POST old version error" go.version=go1.19.8 testGUN=gun +--- PASS: TestAtomicUpdateVersionErrorPropagated (0.10s) === RUN TestGetMaybeServerSignedNoCrypto --- PASS: TestGetMaybeServerSignedNoCrypto (0.00s) === RUN TestGetMaybeServerSignedNoKey --- PASS: TestGetMaybeServerSignedNoKey (0.00s) === RUN TestValidateEmptyNew ---- PASS: TestValidateEmptyNew (0.01s) +--- PASS: TestValidateEmptyNew (0.08s) === RUN TestValidateRootCanContainOnlyx509KeysWithRightGun ---- PASS: TestValidateRootCanContainOnlyx509KeysWithRightGun (0.01s) +--- PASS: TestValidateRootCanContainOnlyx509KeysWithRightGun (0.06s) === RUN TestValidatePrevTimestamp ---- PASS: TestValidatePrevTimestamp (0.01s) +--- PASS: TestValidatePrevTimestamp (0.05s) === RUN TestValidatePreviousTimestampCorrupt -time="2025-02-07T19:31:50Z" level=error msg="Failed to unmarshal existing timestamp for GUN docker.com/notary" ---- PASS: TestValidatePreviousTimestampCorrupt (0.01s) +time="2024-01-06T13:15:07Z" level=error msg="Failed to unmarshal existing timestamp for GUN docker.com/notary" +--- PASS: TestValidatePreviousTimestampCorrupt (0.04s) === RUN TestValidateGetCurrentTimestampBroken ---- PASS: TestValidateGetCurrentTimestampBroken (0.01s) +--- PASS: TestValidateGetCurrentTimestampBroken (0.04s) === RUN TestValidateNoNewRoot ---- PASS: TestValidateNoNewRoot (0.01s) +--- PASS: TestValidateNoNewRoot (0.04s) === RUN TestValidateNoNewTargets ---- PASS: TestValidateNoNewTargets (0.01s) +--- PASS: TestValidateNoNewTargets (0.05s) === RUN TestValidateOnlySnapshot ---- PASS: TestValidateOnlySnapshot (0.01s) +--- PASS: TestValidateOnlySnapshot (0.08s) === RUN TestValidateOldRoot ---- PASS: TestValidateOldRoot (0.01s) +--- PASS: TestValidateOldRoot (0.08s) === RUN TestValidateOldRootCorrupt ---- PASS: TestValidateOldRootCorrupt (0.01s) +--- PASS: TestValidateOldRootCorrupt (0.06s) === RUN TestValidateOldRootCorruptRootRole ---- PASS: TestValidateOldRootCorruptRootRole (0.01s) +--- PASS: TestValidateOldRootCorruptRootRole (0.06s) === RUN TestValidateRootGetCurrentRootBroken ---- PASS: TestValidateRootGetCurrentRootBroken (0.01s) +--- PASS: TestValidateRootGetCurrentRootBroken (0.05s) === RUN TestValidateRootRotationWithOldSigs ---- PASS: TestValidateRootRotationWithOldSigs (0.03s) +--- PASS: TestValidateRootRotationWithOldSigs (0.16s) === RUN TestValidateRootRotationMultipleKeysThreshold1 ---- PASS: TestValidateRootRotationMultipleKeysThreshold1 (0.02s) +--- PASS: TestValidateRootRotationMultipleKeysThreshold1 (0.09s) === RUN TestRootRotationNotSignedWithOldKeysForOldRole ---- PASS: TestRootRotationNotSignedWithOldKeysForOldRole (0.02s) +--- PASS: TestRootRotationNotSignedWithOldKeysForOldRole (0.14s) === RUN TestRootRotationVersionIncrement ---- PASS: TestRootRotationVersionIncrement (0.02s) +--- PASS: TestRootRotationVersionIncrement (0.08s) === RUN TestValidateNoRoot ---- PASS: TestValidateNoRoot (0.01s) +--- PASS: TestValidateNoRoot (0.07s) === RUN TestValidateSnapshotMissingNoSnapshotKey ---- PASS: TestValidateSnapshotMissingNoSnapshotKey (0.01s) +--- PASS: TestValidateSnapshotMissingNoSnapshotKey (0.06s) === RUN TestValidateSnapshotGenerateNoPrev ---- PASS: TestValidateSnapshotGenerateNoPrev (0.02s) +--- PASS: TestValidateSnapshotGenerateNoPrev (0.12s) === RUN TestValidateSnapshotGenerateWithPrev ---- PASS: TestValidateSnapshotGenerateWithPrev (0.01s) +--- PASS: TestValidateSnapshotGenerateWithPrev (0.11s) === RUN TestValidateSnapshotGeneratePrevCorrupt -time="2025-02-07T19:31:50Z" level=error msg="Failed to unmarshal existing snapshot for GUN docker.com/notary" ---- PASS: TestValidateSnapshotGeneratePrevCorrupt (0.01s) +time="2024-01-06T13:15:08Z" level=error msg="Failed to unmarshal existing snapshot for GUN docker.com/notary" +--- PASS: TestValidateSnapshotGeneratePrevCorrupt (0.09s) === RUN TestValidateSnapshotGenerateStoreGetCurrentSnapshotBroken ---- PASS: TestValidateSnapshotGenerateStoreGetCurrentSnapshotBroken (0.01s) +--- PASS: TestValidateSnapshotGenerateStoreGetCurrentSnapshotBroken (0.08s) === RUN TestValidateSnapshotGenerateNoTargets ---- PASS: TestValidateSnapshotGenerateNoTargets (0.01s) +--- PASS: TestValidateSnapshotGenerateNoTargets (0.08s) === RUN TestValidateSnapshotGenerate ---- PASS: TestValidateSnapshotGenerate (0.01s) +--- PASS: TestValidateSnapshotGenerate (0.11s) === RUN TestValidateRootNoTimestampKey ---- PASS: TestValidateRootNoTimestampKey (0.01s) +--- PASS: TestValidateRootNoTimestampKey (0.03s) === RUN TestValidateRootInvalidTimestampKey ---- PASS: TestValidateRootInvalidTimestampKey (0.01s) +--- PASS: TestValidateRootInvalidTimestampKey (0.05s) === RUN TestValidateRootInvalidTimestampThreshold ---- PASS: TestValidateRootInvalidTimestampThreshold (0.01s) +--- PASS: TestValidateRootInvalidTimestampThreshold (0.11s) === RUN TestValidateRootInvalidZeroThreshold ---- PASS: TestValidateRootInvalidZeroThreshold (0.06s) +--- PASS: TestValidateRootInvalidZeroThreshold (0.19s) === RUN TestValidateRootRoleMissing ---- PASS: TestValidateRootRoleMissing (0.01s) +--- PASS: TestValidateRootRoleMissing (0.06s) === RUN TestValidateTargetsRoleMissing ---- PASS: TestValidateTargetsRoleMissing (0.01s) +--- PASS: TestValidateTargetsRoleMissing (0.03s) === RUN TestValidateSnapshotRoleMissing --- PASS: TestValidateSnapshotRoleMissing (0.01s) === RUN TestValidateRootSigMissing --- PASS: TestValidateRootSigMissing (0.01s) === RUN TestValidateTargetsSigMissing -time="2025-02-07T19:31:51Z" level=error msg="ErrBadTargets: tuf: data has no signatures" ---- PASS: TestValidateTargetsSigMissing (0.01s) +time="2024-01-06T13:15:09Z" level=error msg="ErrBadTargets: tuf: data has no signatures" +--- PASS: TestValidateTargetsSigMissing (0.02s) === RUN TestValidateSnapshotSigMissing ---- PASS: TestValidateSnapshotSigMissing (0.01s) +--- PASS: TestValidateSnapshotSigMissing (0.03s) === RUN TestValidateRootCorrupt ---- PASS: TestValidateRootCorrupt (0.01s) +--- PASS: TestValidateRootCorrupt (0.03s) === RUN TestValidateTargetsCorrupt -time="2025-02-07T19:31:51Z" level=error msg="ErrBadTargets: invalid character '\\u0084' looking for beginning of value" ---- PASS: TestValidateTargetsCorrupt (0.01s) +time="2024-01-06T13:15:09Z" level=error msg="ErrBadTargets: invalid character '\\u0084' looking for beginning of value" +--- PASS: TestValidateTargetsCorrupt (0.02s) === RUN TestValidateSnapshotCorrupt ---- PASS: TestValidateSnapshotCorrupt (0.01s) +--- PASS: TestValidateSnapshotCorrupt (0.02s) === RUN TestValidateRootModifiedSize ---- PASS: TestValidateRootModifiedSize (0.01s) +--- PASS: TestValidateRootModifiedSize (0.03s) === RUN TestValidateTargetsModifiedSize ---- PASS: TestValidateTargetsModifiedSize (0.01s) +--- PASS: TestValidateTargetsModifiedSize (0.02s) === RUN TestValidateRootModifiedHash ---- PASS: TestValidateRootModifiedHash (0.01s) +--- PASS: TestValidateRootModifiedHash (0.03s) === RUN TestValidateTargetsModifiedHash ---- PASS: TestValidateTargetsModifiedHash (0.03s) +--- PASS: TestValidateTargetsModifiedHash (0.02s) === RUN TestGenerateSnapshotRootNotLoaded --- PASS: TestGenerateSnapshotRootNotLoaded (0.00s) === RUN TestGenerateSnapshotNoKey ---- PASS: TestGenerateSnapshotNoKey (0.01s) +--- PASS: TestGenerateSnapshotNoKey (0.02s) === RUN TestLoadTargetsLoadsNothingIfNoUpdates ---- PASS: TestLoadTargetsLoadsNothingIfNoUpdates (0.01s) +--- PASS: TestLoadTargetsLoadsNothingIfNoUpdates (0.04s) === RUN TestValidateTargetsRequiresStoredParent -time="2025-02-07T19:31:51Z" level=error msg="ErrBadTargets: targets must be loaded first" ---- PASS: TestValidateTargetsRequiresStoredParent (0.01s) +time="2024-01-06T13:15:09Z" level=error msg="ErrBadTargets: targets must be loaded first" +--- PASS: TestValidateTargetsRequiresStoredParent (0.02s) === RUN TestValidateTargetsParentInUpdate -time="2025-02-07T19:31:51Z" level=error msg="ErrBadTargets: invalid character 'I' looking for beginning of value" ---- PASS: TestValidateTargetsParentInUpdate (0.01s) +time="2024-01-06T13:15:09Z" level=error msg="ErrBadTargets: invalid character 'I' looking for beginning of value" +--- PASS: TestValidateTargetsParentInUpdate (0.02s) === RUN TestValidateTargetsRoleNotInParent -time="2025-02-07T19:31:51Z" level=error msg="ErrBadTargets: tuf: invalid role targets/level1. delegation does not exist" -time="2025-02-07T19:31:51Z" level=error msg="ErrBadTargets: targets has already been loaded" -time="2025-02-07T19:31:51Z" level=error msg="ErrBadTargets: tuf: invalid role targets/level1. delegation does not exist" ---- PASS: TestValidateTargetsRoleNotInParent (0.01s) +time="2024-01-06T13:15:09Z" level=error msg="ErrBadTargets: tuf: invalid role targets/level1. delegation does not exist" +time="2024-01-06T13:15:09Z" level=error msg="ErrBadTargets: targets has already been loaded" +time="2024-01-06T13:15:09Z" level=error msg="ErrBadTargets: tuf: invalid role targets/level1. delegation does not exist" +--- PASS: TestValidateTargetsRoleNotInParent (0.03s) PASS -ok github.com/theupdateframework/notary/server/handlers 0.634s +ok github.com/theupdateframework/notary/server/handlers 3.118s === RUN TestSnapshotExpired --- PASS: TestSnapshotExpired (0.00s) === RUN TestSnapshotNotExpired --- PASS: TestSnapshotNotExpired (0.00s) === RUN TestGetSnapshotKeyCreate ---- PASS: TestGetSnapshotKeyCreate (0.01s) +--- PASS: TestGetSnapshotKeyCreate (0.04s) === RUN TestGetSnapshotKeyCreateWithFailingStore -time="2025-02-07T19:31:49Z" level=error msg="Error when retrieving root role for GUN gun: failing store failed" +time="2024-01-06T13:15:02Z" level=error msg="Error when retrieving root role for GUN gun: failing store failed" --- PASS: TestGetSnapshotKeyCreateWithFailingStore (0.00s) === RUN TestGetSnapshotKeyCreateWithCorruptedStore -time="2025-02-07T19:31:49Z" level=error msg="Failed to unmarshal existing root for GUN gun to retrieve snapshot key ID" +time="2024-01-06T13:15:02Z" 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.01s) +--- PASS: TestGetSnapshotKeyExistingMetadata (0.07s) === RUN TestGetSnapshotNoPreviousSnapshot -time="2025-02-07T19:31:49Z" level=error msg="Failed to unmarshal existing snapshot for GUN gun" +time="2024-01-06T13:15:02Z" level=error msg="Failed to unmarshal existing snapshot for GUN gun" --- PASS: TestGetSnapshotNoPreviousSnapshot (0.00s) === RUN TestGetSnapshotReturnsPreviousSnapshotIfUnexpired ---- PASS: TestGetSnapshotReturnsPreviousSnapshotIfUnexpired (0.00s) +--- PASS: TestGetSnapshotReturnsPreviousSnapshotIfUnexpired (0.03s) === RUN TestGetSnapshotOldSnapshotExpired ---- PASS: TestGetSnapshotOldSnapshotExpired (0.00s) +--- PASS: TestGetSnapshotOldSnapshotExpired (0.03s) === RUN TestCannotMakeNewSnapshotIfNoRoot --- PASS: TestCannotMakeNewSnapshotIfNoRoot (0.00s) === RUN TestCreateSnapshotNoKeyInCrypto ---- PASS: TestCreateSnapshotNoKeyInCrypto (0.00s) +--- PASS: TestCreateSnapshotNoKeyInCrypto (0.03s) PASS -ok github.com/theupdateframework/notary/server/snapshot 0.084s +ok github.com/theupdateframework/notary/server/snapshot 0.315s === RUN TestMemoryUpdateCurrentEmpty --- PASS: TestMemoryUpdateCurrentEmpty (0.00s) === RUN TestMemoryUpdateCurrentVersionCheckOldVersionExists @@ -2987,7 +3023,7 @@ === RUN TestMemoryUpdateManyConflictRollback --- PASS: TestMemoryUpdateManyConflictRollback (0.00s) === RUN TestMemoryDeleteSuccess ---- PASS: TestMemoryDeleteSuccess (0.00s) +--- PASS: TestMemoryDeleteSuccess (0.02s) === RUN TestGetCurrent --- PASS: TestGetCurrent (0.00s) === RUN TestGetChecksumNotFound @@ -3001,69 +3037,69 @@ === RUN TestRDBTUFFileJSONUnmarshallingFailure --- PASS: TestRDBTUFFileJSONUnmarshallingFailure (0.00s) === RUN TestSQLUpdateCurrentEmpty ---- PASS: TestSQLUpdateCurrentEmpty (0.02s) +--- PASS: TestSQLUpdateCurrentEmpty (0.09s) === RUN TestSQLUpdateCurrentVersionCheckOldVersionExists ---- PASS: TestSQLUpdateCurrentVersionCheckOldVersionExists (0.01s) +--- PASS: TestSQLUpdateCurrentVersionCheckOldVersionExists (0.07s) === RUN TestSQLUpdateCurrentVersionCheckOldVersionNotExist ---- PASS: TestSQLUpdateCurrentVersionCheckOldVersionNotExist (0.01s) +--- PASS: TestSQLUpdateCurrentVersionCheckOldVersionNotExist (0.05s) === RUN TestSQLUpdateManyNoConflicts ---- PASS: TestSQLUpdateManyNoConflicts (0.02s) +--- PASS: TestSQLUpdateManyNoConflicts (0.17s) === RUN TestSQLUpdateManyConflictRollback ---- PASS: TestSQLUpdateManyConflictRollback (0.05s) +--- PASS: TestSQLUpdateManyConflictRollback (0.14s) === RUN TestSQLDelete ---- PASS: TestSQLDelete (0.06s) +--- PASS: TestSQLDelete (0.16s) === RUN TestSQLDBCheckHealthTableMissing ---- PASS: TestSQLDBCheckHealthTableMissing (0.01s) +--- PASS: TestSQLDBCheckHealthTableMissing (0.03s) === RUN TestSQLDBCheckHealthDBConnectionFail ---- PASS: TestSQLDBCheckHealthDBConnectionFail (0.00s) +--- PASS: TestSQLDBCheckHealthDBConnectionFail (0.01s) === RUN TestSQLDBCheckHealthSucceeds ---- PASS: TestSQLDBCheckHealthSucceeds (0.01s) +--- PASS: TestSQLDBCheckHealthSucceeds (0.00s) === RUN TestSQLDBGetChecksum ---- PASS: TestSQLDBGetChecksum (0.01s) +--- PASS: TestSQLDBGetChecksum (0.02s) === RUN TestSQLDBGetChecksumNotFound ---- PASS: TestSQLDBGetChecksumNotFound (0.01s) +--- PASS: TestSQLDBGetChecksumNotFound (0.00s) === RUN TestSQLTUFMetaStoreGetCurrent ---- PASS: TestSQLTUFMetaStoreGetCurrent (0.03s) +--- PASS: TestSQLTUFMetaStoreGetCurrent (0.15s) === RUN TestSQLGetChanges ---- PASS: TestSQLGetChanges (0.01s) +--- PASS: TestSQLGetChanges (0.08s) === RUN TestSQLDBGetVersion ---- PASS: TestSQLDBGetVersion (0.00s) +--- PASS: TestSQLDBGetVersion (0.02s) PASS -ok github.com/theupdateframework/notary/server/storage 0.266s +ok github.com/theupdateframework/notary/server/storage 1.139s === RUN TestTimestampExpired --- PASS: TestTimestampExpired (0.00s) === RUN TestTimestampNotExpired --- PASS: TestTimestampNotExpired (0.00s) === RUN TestGetTimestampKey ---- PASS: TestGetTimestampKey (0.00s) +--- PASS: TestGetTimestampKey (0.02s) === RUN TestGetTimestampNoPreviousTimestamp -time="2025-02-07T19:31:49Z" level=error msg="Failed to unmarshal existing timestamp" ---- PASS: TestGetTimestampNoPreviousTimestamp (0.00s) +time="2024-01-06T13:15:02Z" level=error msg="Failed to unmarshal existing timestamp" +--- PASS: TestGetTimestampNoPreviousTimestamp (0.03s) === RUN TestGetTimestampReturnsPreviousTimestampIfUnexpired ---- PASS: TestGetTimestampReturnsPreviousTimestampIfUnexpired (0.00s) +--- PASS: TestGetTimestampReturnsPreviousTimestampIfUnexpired (0.03s) === RUN TestGetTimestampOldTimestampExpired --- PASS: TestGetTimestampOldTimestampExpired (0.01s) === RUN TestCannotMakeNewTimestampIfNoRootOrSnapshot -time="2025-02-07T19:31:49Z" level=error msg="Failed to create a new timestamp" -time="2025-02-07T19:31:49Z" level=error msg="Failed to create a new timestamp" ---- PASS: TestCannotMakeNewTimestampIfNoRootOrSnapshot (0.01s) +time="2024-01-06T13:15:02Z" level=error msg="Failed to create a new timestamp" +time="2024-01-06T13:15:02Z" level=error msg="Failed to create a new timestamp" +--- PASS: TestCannotMakeNewTimestampIfNoRootOrSnapshot (0.02s) === RUN TestCreateTimestampNoKeyInCrypto -time="2025-02-07T19:31:49Z" level=error msg="Failed to create a new timestamp" +time="2024-01-06T13:15:02Z" level=error msg="Failed to create a new timestamp" --- PASS: TestCreateTimestampNoKeyInCrypto (0.01s) === RUN TestGetTimestampKeyCreateWithFailingStore -time="2025-02-07T19:31:49Z" level=error msg="Error when retrieving root role for GUN gun: failing store failed" +time="2024-01-06T13:15:02Z" level=error msg="Error when retrieving root role for GUN gun: failing store failed" --- PASS: TestGetTimestampKeyCreateWithFailingStore (0.00s) === RUN TestGetTimestampKeyCreateWithCorruptedStore -time="2025-02-07T19:31:49Z" level=error msg="Failed to unmarshal existing root for GUN gun to retrieve timestamp key ID" +time="2024-01-06T13:15:02Z" 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.00s) +--- PASS: TestGetTimestampKeyExistingMetadata (0.01s) PASS -ok github.com/theupdateframework/notary/server/timestamp 0.057s +ok github.com/theupdateframework/notary/server/timestamp 0.246s === RUN TestHealthCheckKMUnhealthy ---- PASS: TestHealthCheckKMUnhealthy (0.00s) +--- PASS: TestHealthCheckKMUnhealthy (0.01s) === RUN TestHealthCheckSignerUnhealthy --- PASS: TestHealthCheckSignerUnhealthy (0.00s) === RUN TestHealthCheckKMTimeout @@ -3073,39 +3109,39 @@ === RUN TestHealthCheckKMHealthy --- PASS: TestHealthCheckKMHealthy (0.00s) === RUN TestHealthCheckSignerHealthy ---- PASS: TestHealthCheckSignerHealthy (0.00s) +--- PASS: TestHealthCheckSignerHealthy (0.01s) === RUN TestHealthCheckKMConnectionDied --- PASS: TestHealthCheckKMConnectionDied (0.00s) === RUN TestHealthCheckSignerConnectionDied --- PASS: TestHealthCheckSignerConnectionDied (0.00s) === RUN TestHealthCheckForOverallStatus ---- PASS: TestHealthCheckForOverallStatus (0.00s) +--- PASS: TestHealthCheckForOverallStatus (0.01s) === RUN TestHealthCheckNonexistentService --- PASS: TestHealthCheckNonexistentService (0.00s) === RUN TestGetPrivateKeyAndSignWithExistingKey -time="2025-02-07T19:31:51Z" level=info msg="Sign: Signed message! with KeyID 28a57ac22b4bc6ec72f9ace3bbe1d594143e43d2ac619c677aaf7b075420e5d1" go.version=go1.19.8 ---- PASS: TestGetPrivateKeyAndSignWithExistingKey (0.01s) +time="2024-01-06T13:15:09Z" level=info msg="Sign: Signed message! with KeyID f6cd162db8fe08a7a6d8689a09698e86de7869e24801784b1af7cd45c0db8502" go.version=go1.19.8 +--- PASS: TestGetPrivateKeyAndSignWithExistingKey (0.02s) === RUN TestCannotSignWithKeyThatDoesntExist -time="2025-02-07T19:31:51Z" level=error msg="Sign: key ad9a04b443436e8814904c9863c81c03ebcb0cfcab3bbdc0060197f4ac7dce70 not found" go.version=go1.19.8 +time="2024-01-06T13:15:09Z" level=error msg="Sign: key 1360b5244c986ac5abc9c5d1ef0542722f5a886fc7fbb15d6072e6a9a7821346 not found" go.version=go1.19.8 --- PASS: TestCannotSignWithKeyThatDoesntExist (0.00s) === RUN TestCryptoSignerInterfaceBehavior -time="2025-02-07T19:31:51Z" level=error msg="GetKeyInfo: key nonexistent not found" go.version=go1.19.8 -time="2025-02-07T19:31:51Z" level=error msg="GetKeyInfo: key nonexistent not found" go.version=go1.19.8 -time="2025-02-07T19:31:51Z" level=info msg="CreateKey: Created KeyID 7fd59e1ee9d793e6e4a758ab54b246a315d133bc1936d45baa74f32f4c32b69e" go.version=go1.19.8 -time="2025-02-07T19:31:51Z" level=info msg="CreateKey: Created KeyID 81cdfff59c929ab6439cf4d553232a9e2429a38bbf71881eddd69c67c131bbdd" go.version=go1.19.8 -time="2025-02-07T19:31:51Z" level=error msg="GetKeyInfo: key 7fd59e1ee9d793e6e4a758ab54b246a315d133bc1936d45baa74f32f4c32b69e not found" go.version=go1.19.8 -time="2025-02-07T19:31:51Z" level=error msg="GetKeyInfo: key 81cdfff59c929ab6439cf4d553232a9e2429a38bbf71881eddd69c67c131bbdd not found" go.version=go1.19.8 ---- PASS: TestCryptoSignerInterfaceBehavior (0.01s) +time="2024-01-06T13:15:09Z" level=error msg="GetKeyInfo: key nonexistent not found" go.version=go1.19.8 +time="2024-01-06T13:15:09Z" level=error msg="GetKeyInfo: key nonexistent not found" go.version=go1.19.8 +time="2024-01-06T13:15:09Z" level=info msg="CreateKey: Created KeyID 82eba7e15d697af0d0eb3eee13c597e3bbd005128c37452edb883727d5cb6152" go.version=go1.19.8 +time="2024-01-06T13:15:09Z" level=info msg="CreateKey: Created KeyID d62afa668ef01fd5aec9afc21ab3a0c334409aae5018c17eb00a3b6ddbf4110b" go.version=go1.19.8 +time="2024-01-06T13:15:09Z" level=error msg="GetKeyInfo: key 82eba7e15d697af0d0eb3eee13c597e3bbd005128c37452edb883727d5cb6152 not found" go.version=go1.19.8 +time="2024-01-06T13:15:09Z" level=error msg="GetKeyInfo: key d62afa668ef01fd5aec9afc21ab3a0c334409aae5018c17eb00a3b6ddbf4110b not found" go.version=go1.19.8 +--- PASS: TestCryptoSignerInterfaceBehavior (0.12s) PASS -ok github.com/theupdateframework/notary/signer 0.045s +ok github.com/theupdateframework/notary/signer 0.241s ? github.com/theupdateframework/notary/signer/api [no test files] ? github.com/theupdateframework/notary/signer/client [no test files] === RUN TestGetSuccessPopulatesCache ---- PASS: TestGetSuccessPopulatesCache (0.00s) +--- PASS: TestGetSuccessPopulatesCache (0.01s) === RUN TestAddKeyPopulatesCacheIfSuccessful ---- PASS: TestAddKeyPopulatesCacheIfSuccessful (0.00s) +--- PASS: TestAddKeyPopulatesCacheIfSuccessful (0.02s) === RUN TestDeleteKeyRemovesKeyFromCache ---- PASS: TestDeleteKeyRemovesKeyFromCache (0.01s) +--- PASS: TestDeleteKeyRemovesKeyFromCache (0.02s) === RUN TestRDBPrivateKeyJSONUnmarshalling --- PASS: TestRDBPrivateKeyJSONUnmarshalling (0.00s) === RUN TestRDBPrivateKeyJSONUnmarshallingFailure @@ -3114,30 +3150,30 @@ `nodb` is not officially supported, running under compatibility mode. --- PASS: TestNewSQLKeyDBStorePropagatesDBError (0.00s) === RUN TestSQLDBHealthCheckMissingTable ---- PASS: TestSQLDBHealthCheckMissingTable (0.00s) +--- PASS: TestSQLDBHealthCheckMissingTable (0.04s) === RUN TestSQLDBHealthCheckNoConnection --- PASS: TestSQLDBHealthCheckNoConnection (0.00s) === RUN TestSQLKeyCanOnlyBeAddedOnce (/build/reproducible-path/notary-0.7.0+ds1/_build/src/github.com/theupdateframework/notary/signer/keydbstore/sql_keydbstore.go:98) -[2025-02-07 19:31:49]  UNIQUE constraint failed: private_keys.key_id  ---- PASS: TestSQLKeyCanOnlyBeAddedOnce (0.09s) +[2024-01-06 13:15:01]  UNIQUE constraint failed: private_keys.key_id  +--- PASS: TestSQLKeyCanOnlyBeAddedOnce (0.58s) === RUN TestSQLCreateDelete ---- PASS: TestSQLCreateDelete (0.12s) +--- PASS: TestSQLCreateDelete (0.44s) === RUN TestSQLKeyRotation ---- PASS: TestSQLKeyRotation (0.16s) +--- PASS: TestSQLKeyRotation (0.63s) === RUN TestSQLSigningMarksKeyActive -time="2025-02-07T19:31:50Z" level=error msg="Key 5a04124185711b6e200d93d969bd67a46e100d6d780871a09a442b6fadb8f4a5 was just used to sign hash successful, db closed, error when trying to mark key as active: sql: database is closed" ---- PASS: TestSQLSigningMarksKeyActive (0.25s) +time="2024-01-06T13:15:03Z" level=error msg="Key 4f8cff1b6d697544e5579437ed3d1e80aca720529927ddb07284ab39ea874a3a was just used to sign hash successful, db closed, error when trying to mark key as active: sql: database is closed" +--- PASS: TestSQLSigningMarksKeyActive (0.79s) === RUN TestSQLCreateKey (/build/reproducible-path/notary-0.7.0+ds1/_build/src/github.com/theupdateframework/notary/signer/keydbstore/sql_keydbstore.go:197) -[2025-02-07 19:31:50]  sql: database is closed  ---- PASS: TestSQLCreateKey (0.13s) +[2024-01-06 13:15:03]  sql: database is closed  +--- PASS: TestSQLCreateKey (0.63s) === RUN TestSQLUnimplementedInterfaceBehavior ---- PASS: TestSQLUnimplementedInterfaceBehavior (0.03s) +--- PASS: TestSQLUnimplementedInterfaceBehavior (0.18s) PASS -ok github.com/theupdateframework/notary/signer/keydbstore 0.832s +ok github.com/theupdateframework/notary/signer/keydbstore 3.456s === RUN TestSet --- PASS: TestSet (0.00s) === RUN TestSetWithNoParentDirectory @@ -3157,7 +3193,7 @@ === RUN TestRemoveFile --- PASS: TestRemoveFile (0.00s) === RUN TestListFiles ---- PASS: TestListFiles (0.00s) +--- PASS: TestListFiles (0.05s) === RUN TestGetPath --- PASS: TestGetPath (0.00s) === RUN TestGetPathProtection @@ -3179,7 +3215,7 @@ === RUN Test404Error --- PASS: Test404Error (0.01s) === RUN Test50XErrors ---- PASS: Test50XErrors (0.02s) +--- PASS: Test50XErrors (0.01s) === RUN Test400Error --- PASS: Test400Error (0.00s) === RUN TestTranslateErrorsParse400Errors @@ -3189,13 +3225,13 @@ === RUN TestTranslateErrorsLimitsErrorSize --- PASS: TestTranslateErrorsLimitsErrorSize (0.00s) === RUN TestHTTPStoreRemoveAll ---- PASS: TestHTTPStoreRemoveAll (0.01s) +--- PASS: TestHTTPStoreRemoveAll (0.00s) === RUN TestHTTPStoreRotateKey ---- PASS: TestHTTPStoreRotateKey (0.00s) +--- PASS: TestHTTPStoreRotateKey (0.02s) === RUN TestHTTPStoreGetKey --- PASS: TestHTTPStoreGetKey (0.00s) === RUN TestHTTPStoreGetRotateKeySizeLimited ---- PASS: TestHTTPStoreGetRotateKeySizeLimited (0.05s) +--- PASS: TestHTTPStoreGetRotateKeySizeLimited (0.06s) === RUN TestHTTPOffline --- PASS: TestHTTPOffline (0.00s) === RUN TestErrServerUnavailable @@ -3216,7 +3252,7 @@ === RUN TestMemoryStoreMetadata --- PASS: TestMemoryStoreMetadata (0.00s) PASS -ok github.com/theupdateframework/notary/storage 0.109s +ok github.com/theupdateframework/notary/storage 0.316s ? github.com/theupdateframework/notary/storage/rethinkdb [no test files] === RUN TestExportKeys --- PASS: TestExportKeys (0.00s) @@ -3229,133 +3265,133 @@ === RUN TestImportKeys --- PASS: TestImportKeys (0.00s) === RUN TestImportNoPath ---- PASS: TestImportNoPath (0.00s) +--- PASS: TestImportNoPath (0.01s) === RUN TestNonRootPathInference ---- PASS: TestNonRootPathInference (0.00s) +--- PASS: TestNonRootPathInference (0.02s) === RUN TestBlockHeaderPrecedenceRoleAndGun ---- PASS: TestBlockHeaderPrecedenceRoleAndGun (0.01s) +--- PASS: TestBlockHeaderPrecedenceRoleAndGun (0.02s) === RUN TestBlockHeaderPrecedenceGunFromPath ---- PASS: TestBlockHeaderPrecedenceGunFromPath (0.00s) +--- PASS: TestBlockHeaderPrecedenceGunFromPath (0.02s) === RUN TestImportKeys2InOneFile --- PASS: TestImportKeys2InOneFile (0.00s) === RUN TestImportKeys2InOneFileNoPath ---- PASS: TestImportKeys2InOneFileNoPath (0.01s) +--- PASS: TestImportKeys2InOneFileNoPath (0.04s) === RUN TestEncryptedKeyImportFail -time="2025-02-07T19:31:48Z" level=warning msg="failed to import key to store: Invalid key generated, key may be encrypted and does not contain path header" ---- PASS: TestEncryptedKeyImportFail (0.00s) +time="2024-01-06T13:14:56Z" 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.01s) +--- PASS: TestEncryptedKeyImportSuccess (0.03s) === RUN TestEncryption ---- PASS: TestEncryption (0.01s) +--- PASS: TestEncryption (0.04s) === RUN TestAddKey ---- PASS: TestAddKey (0.03s) +--- PASS: TestAddKey (0.10s) === RUN TestKeyStoreInternalState ---- PASS: TestKeyStoreInternalState (0.01s) +--- PASS: TestKeyStoreInternalState (0.02s) === RUN TestGet ---- PASS: TestGet (0.01s) +--- PASS: TestGet (0.03s) === RUN TestGetLegacyKey --- PASS: TestGetLegacyKey (0.00s) === RUN TestListKeys ---- PASS: TestListKeys (0.03s) +--- PASS: TestListKeys (0.09s) === RUN TestAddGetKeyMemStore --- PASS: TestAddGetKeyMemStore (0.00s) === RUN TestAddGetKeyInfoMemStore ---- PASS: TestAddGetKeyInfoMemStore (0.02s) +--- PASS: TestAddGetKeyInfoMemStore (0.04s) === RUN TestGetDecryptedWithTamperedCipherText -time="2025-02-07T19:31:48Z" level=error msg="PEM block is empty" +time="2024-01-06T13:14:56Z" level=error msg="PEM block is empty" --- PASS: TestGetDecryptedWithTamperedCipherText (0.01s) === RUN TestGetDecryptedWithInvalidPassphrase ---- PASS: TestGetDecryptedWithInvalidPassphrase (0.05s) +--- PASS: TestGetDecryptedWithInvalidPassphrase (0.08s) === RUN TestGetDecryptedWithConsistentlyInvalidPassphrase ---- PASS: TestGetDecryptedWithConsistentlyInvalidPassphrase (0.05s) +--- PASS: TestGetDecryptedWithConsistentlyInvalidPassphrase (0.14s) === RUN TestRemoveKey ---- PASS: TestRemoveKey (0.02s) +--- PASS: TestRemoveKey (0.07s) === RUN TestKeysAreCached ---- PASS: TestKeysAreCached (0.01s) +--- PASS: TestKeysAreCached (0.04s) PASS -ok github.com/theupdateframework/notary/trustmanager 0.323s +ok github.com/theupdateframework/notary/trustmanager 0.901s === RUN TestRemoteStore -time="2025-02-07T19:31:51Z" level=info msg="listing files from localhost:9888" -time="2025-02-07T19:31:51Z" level=info msg="listing files from localhost:9888" ---- PASS: TestRemoteStore (0.04s) +time="2024-01-06T13:15:09Z" level=info msg="listing files from localhost:9888" +time="2024-01-06T13:15:09Z" level=info msg="listing files from localhost:9888" +--- PASS: TestRemoteStore (0.20s) === RUN TestErrors -time="2025-02-07T19:31:51Z" level=error msg="failed to store: test error" ---- PASS: TestErrors (0.05s) +time="2024-01-06T13:15:10Z" level=error msg="failed to store: test error" +--- PASS: TestErrors (0.12s) === RUN TestNewGRPCStorage --- PASS: TestNewGRPCStorage (0.00s) === RUN TestGRPCStorage --- PASS: TestGRPCStorage (0.00s) PASS -ok github.com/theupdateframework/notary/trustmanager/remoteks 0.094s +ok github.com/theupdateframework/notary/trustmanager/remoteks 0.363s ? github.com/theupdateframework/notary/trustmanager/yubikey [no test files] === RUN TestWildcardMatch --- PASS: TestWildcardMatch (0.00s) === RUN TestValidateRoot -2025/02/07 19:31:49 [INFO] generate received request -2025/02/07 19:31:49 [INFO] received CSR -2025/02/07 19:31:49 [INFO] generating key: ecdsa-256 -2025/02/07 19:31:49 [INFO] encoded CSR -2025/02/07 19:31:49 [INFO] signed certificate with serial number 563488632273175976411996281966425485666687184867 -2025/02/07 19:31:49 [INFO] received CSR -2025/02/07 19:31:49 [INFO] generating key: ecdsa-256 -2025/02/07 19:31:49 [INFO] encoded CSR -2025/02/07 19:31:49 [INFO] signed certificate with serial number 78750560943396743359093649160790303539767447904 -2025/02/07 19:31:49 [INFO] received CSR -2025/02/07 19:31:49 [INFO] generating key: ecdsa-256 -2025/02/07 19:31:49 [INFO] encoded CSR -2025/02/07 19:31:49 [INFO] signed certificate with serial number 637945677978339662039307257820719827616765429552 ---- PASS: TestValidateRoot (0.02s) +2024/01/06 13:15:00 [INFO] generate received request +2024/01/06 13:15:00 [INFO] received CSR +2024/01/06 13:15:00 [INFO] generating key: ecdsa-256 +2024/01/06 13:15:00 [INFO] encoded CSR +2024/01/06 13:15:00 [INFO] signed certificate with serial number 352503969836809403635724168242009497826923895007 +2024/01/06 13:15:00 [INFO] received CSR +2024/01/06 13:15:00 [INFO] generating key: ecdsa-256 +2024/01/06 13:15:00 [INFO] encoded CSR +2024/01/06 13:15:00 [INFO] signed certificate with serial number 594995981841191670115124130683053626886315689598 +2024/01/06 13:15:00 [INFO] received CSR +2024/01/06 13:15:00 [INFO] generating key: ecdsa-256 +2024/01/06 13:15:00 [INFO] encoded CSR +2024/01/06 13:15:00 [INFO] signed certificate with serial number 435107009265017518836100135463462211980169234377 +--- PASS: TestValidateRoot (0.05s) === RUN TestValidateRootWithoutTOFUS ---- PASS: TestValidateRootWithoutTOFUS (0.00s) +--- PASS: TestValidateRootWithoutTOFUS (0.01s) === RUN TestValidateRootWithPinnedCert --- PASS: TestValidateRootWithPinnedCert (0.00s) === RUN TestValidateRootWithPinnedCertAndIntermediates ---- PASS: TestValidateRootWithPinnedCertAndIntermediates (0.04s) +--- PASS: TestValidateRootWithPinnedCertAndIntermediates (0.05s) === RUN TestValidateRootFailuresWithPinnedCert ---- PASS: TestValidateRootFailuresWithPinnedCert (0.02s) +--- PASS: TestValidateRootFailuresWithPinnedCert (0.01s) === RUN TestValidateRootWithPinnedCA ---- PASS: TestValidateRootWithPinnedCA (0.16s) +--- PASS: TestValidateRootWithPinnedCA (0.15s) === RUN TestValidateSuccessfulRootRotation ---- PASS: TestValidateSuccessfulRootRotation (0.05s) +--- PASS: TestValidateSuccessfulRootRotation (0.24s) === RUN TestValidateRootRotationMissingOrigSig ---- PASS: TestValidateRootRotationMissingOrigSig (0.04s) +--- PASS: TestValidateRootRotationMissingOrigSig (0.13s) === RUN TestValidateRootRotationMissingNewSig ---- PASS: TestValidateRootRotationMissingNewSig (0.09s) +--- PASS: TestValidateRootRotationMissingNewSig (0.14s) === RUN TestValidateRootRotationTrustPinning ---- PASS: TestValidateRootRotationTrustPinning (0.05s) +--- PASS: TestValidateRootRotationTrustPinning (0.18s) === RUN TestValidateRootRotationTrustPinningInvalidCA ---- PASS: TestValidateRootRotationTrustPinningInvalidCA (0.03s) +--- PASS: TestValidateRootRotationTrustPinningInvalidCA (0.24s) === RUN TestParsePEMPublicKey -time="2025-02-07T19:31:50Z" level=warning msg="certificate with CN notary is near expiry" ---- PASS: TestParsePEMPublicKey (0.00s) +time="2024-01-06T13:15:01Z" level=warning msg="certificate with CN notary is near expiry" +--- PASS: TestParsePEMPublicKey (0.02s) === RUN TestCheckingCertExpiry -time="2025-02-07T19:31:50Z" level=warning msg="certificate with CN notary is near expiry" ---- PASS: TestCheckingCertExpiry (0.01s) +time="2024-01-06T13:15:01Z" level=warning msg="certificate with CN notary is near expiry" +--- PASS: TestCheckingCertExpiry (0.04s) === RUN TestValidateRootWithExpiredIntermediate ---- PASS: TestValidateRootWithExpiredIntermediate (0.01s) +--- PASS: TestValidateRootWithExpiredIntermediate (0.05s) === RUN TestCheckingWildcardCert ---- PASS: TestCheckingWildcardCert (0.01s) +--- PASS: TestCheckingWildcardCert (0.05s) === RUN TestWildcardMatching --- PASS: TestWildcardMatching (0.00s) PASS -ok github.com/theupdateframework/notary/trustpinning 0.596s +ok github.com/theupdateframework/notary/trustpinning 1.409s === RUN TestInitSnapshotNoTargets --- PASS: TestInitSnapshotNoTargets (0.01s) === RUN TestInitRepo ---- PASS: TestInitRepo (0.01s) +--- PASS: TestInitRepo (0.02s) === RUN TestUpdateDelegations ---- PASS: TestUpdateDelegations (0.00s) +--- PASS: TestUpdateDelegations (0.01s) === RUN TestPurgeDelegationsKeyFromTop -time="2025-02-07T19:31:49Z" 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-02-07T19:31:49Z" 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-01-06T13:14:58Z" 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-01-06T13:14:58Z" 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-02-07T19:31:49Z" level=warning msg="role targets/vimes/carrot has fewer keys than its threshold of 1; it will not be usable until keys are added to it" +time="2024-01-06T13:14:58Z" 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) +--- PASS: TestUpdateDelegationsParentMissing (0.01s) === RUN TestUpdateDelegationsMissingParentKey --- PASS: TestUpdateDelegationsMissingParentKey (0.00s) === RUN TestUpdateDelegationsInvalidRole @@ -3363,8 +3399,8 @@ === RUN TestUpdateDelegationsRoleThatIsMissingDelegationKey --- PASS: TestUpdateDelegationsRoleThatIsMissingDelegationKey (0.00s) === RUN TestUpdateDelegationsNotEnoughKeys -time="2025-02-07T19:31:49Z" 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) +time="2024-01-06T13:14:59Z" 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) === RUN TestUpdateDelegationsAddKeyToRole --- PASS: TestUpdateDelegationsAddKeyToRole (0.00s) === RUN TestDeleteDelegations @@ -3404,11 +3440,11 @@ === RUN TestRemoveTargetsNoSigningKeys --- PASS: TestRemoveTargetsNoSigningKeys (0.00s) === RUN TestAddBaseKeysToRoot ---- PASS: TestAddBaseKeysToRoot (0.00s) +--- PASS: TestAddBaseKeysToRoot (0.01s) === RUN TestRemoveBaseKeysFromRoot ---- PASS: TestRemoveBaseKeysFromRoot (0.00s) +--- PASS: TestRemoveBaseKeysFromRoot (0.01s) === RUN TestReplaceBaseKeysInRoot ---- PASS: TestReplaceBaseKeysInRoot (0.02s) +--- PASS: TestReplaceBaseKeysInRoot (0.01s) === RUN TestGetAllRoles --- PASS: TestGetAllRoles (0.00s) === RUN TestGetBaseRoles @@ -3416,11 +3452,11 @@ === 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.00s) +--- PASS: TestGetDelegationRolesInvalidPaths (0.01s) === RUN TestDelegationRolesParent --- PASS: TestDelegationRolesParent (0.00s) === RUN TestGetBaseRoleEmptyRepo @@ -3430,41 +3466,41 @@ === RUN TestGetDelegationRoleKeyMissing --- PASS: TestGetDelegationRoleKeyMissing (0.00s) === RUN TestSignRootOldKeyCertExists ---- PASS: TestSignRootOldKeyCertExists (0.06s) +--- PASS: TestSignRootOldKeyCertExists (0.04s) === RUN TestSignRootOldKeyCertMissing ---- PASS: TestSignRootOldKeyCertMissing (0.06s) +--- PASS: TestSignRootOldKeyCertMissing (0.05s) === RUN TestRootKeyRotation ---- PASS: TestRootKeyRotation (0.15s) +--- PASS: TestRootKeyRotation (0.23s) === RUN TestBuilderLoadsValidRolesOnly ---- PASS: TestBuilderLoadsValidRolesOnly (0.01s) +--- PASS: TestBuilderLoadsValidRolesOnly (0.02s) === RUN TestBuilderOnlyAcceptsRootFirstWhenLoading --- PASS: TestBuilderOnlyAcceptsRootFirstWhenLoading (0.00s) === RUN TestBuilderOnlyAcceptsDelegationsAfterParent ---- PASS: TestBuilderOnlyAcceptsDelegationsAfterParent (0.01s) +--- PASS: TestBuilderOnlyAcceptsDelegationsAfterParent (0.00s) === RUN TestMarkingIsValid --- PASS: TestMarkingIsValid (0.01s) === RUN TestBuilderLoadInvalidDelegations --- PASS: TestBuilderLoadInvalidDelegations (0.01s) === RUN TestBuilderLoadInvalidDelegationsOldVersion ---- PASS: TestBuilderLoadInvalidDelegationsOldVersion (0.01s) +--- PASS: TestBuilderLoadInvalidDelegationsOldVersion (0.02s) === RUN TestBuilderAcceptRoleOnce ---- PASS: TestBuilderAcceptRoleOnce (0.00s) +--- PASS: TestBuilderAcceptRoleOnce (0.01s) === RUN TestBuilderStopsAcceptingOrProducingDataOnceDone --- PASS: TestBuilderStopsAcceptingOrProducingDataOnceDone (0.00s) === RUN TestGenerateSnapshotInvalidOperations ---- PASS: TestGenerateSnapshotInvalidOperations (0.06s) +--- PASS: TestGenerateSnapshotInvalidOperations (0.15s) === RUN TestGenerateTimestampInvalidOperations ---- PASS: TestGenerateTimestampInvalidOperations (0.04s) +--- PASS: TestGenerateTimestampInvalidOperations (0.15s) === RUN TestGetConsistentInfo --- PASS: TestGetConsistentInfo (0.02s) === RUN TestTimestampPreAndPostChecksumming ---- PASS: TestTimestampPreAndPostChecksumming (0.03s) +--- PASS: TestTimestampPreAndPostChecksumming (0.07s) === RUN TestSnapshotLoadedFirstChecksumsOthers ---- PASS: TestSnapshotLoadedFirstChecksumsOthers (0.02s) +--- PASS: TestSnapshotLoadedFirstChecksumsOthers (0.06s) === RUN TestSnapshotLoadedAfterChecksumsOthersRetroactively ---- PASS: TestSnapshotLoadedAfterChecksumsOthersRetroactively (0.04s) +--- PASS: TestSnapshotLoadedAfterChecksumsOthersRetroactively (0.13s) PASS -ok github.com/theupdateframework/notary/tuf 0.605s +ok github.com/theupdateframework/notary/tuf 1.135s === RUN TestMergeStrSlicesExclusive --- PASS: TestMergeStrSlicesExclusive (0.00s) === RUN TestMergeStrSlicesOverlap @@ -3512,13 +3548,13 @@ === RUN TestRootFromSignedCopiesSignatures --- PASS: TestRootFromSignedCopiesSignatures (0.00s) === RUN TestRootFromSignedValidatesRoleData ---- PASS: TestRootFromSignedValidatesRoleData (0.01s) +--- PASS: TestRootFromSignedValidatesRoleData (0.03s) === RUN TestRootFromSignedValidatesRoleType --- PASS: TestRootFromSignedValidatesRoleType (0.00s) === RUN TestRootFromSignedValidatesVersion --- PASS: TestRootFromSignedValidatesVersion (0.00s) === RUN TestSnapshotToSignedMarshalsSignedPortionWithCanonicalJSON ---- PASS: TestSnapshotToSignedMarshalsSignedPortionWithCanonicalJSON (0.00s) +--- PASS: TestSnapshotToSignedMarshalsSignedPortionWithCanonicalJSON (0.01s) === RUN TestSnapshotToSignCopiesSignatures --- PASS: TestSnapshotToSignCopiesSignatures (0.00s) === RUN TestSnapshotToSignedMarshallingErrorsPropagated @@ -3554,7 +3590,7 @@ === RUN TestTargetsFromSignedCopiesSignatures --- PASS: TestTargetsFromSignedCopiesSignatures (0.00s) === RUN TestTargetsFromSignedValidatesDelegations ---- PASS: TestTargetsFromSignedValidatesDelegations (0.00s) +--- PASS: TestTargetsFromSignedValidatesDelegations (0.01s) === RUN TestTargetsFromSignedValidatesRoleType --- PASS: TestTargetsFromSignedValidatesRoleType (0.00s) === RUN TestTargetsFromSignedValidatesRoleName @@ -3598,9 +3634,9 @@ === RUN TestFileMetaEquals --- PASS: TestFileMetaEquals (0.00s) PASS -ok github.com/theupdateframework/notary/tuf/data 0.037s +ok github.com/theupdateframework/notary/tuf/data 0.098s === RUN TestListKeys ---- PASS: TestListKeys (0.00s) +--- PASS: TestListKeys (0.01s) === RUN TestGetKeys --- PASS: TestGetKeys (0.00s) === RUN TestBasicSign @@ -3608,13 +3644,13 @@ === RUN TestReSign --- PASS: TestReSign (0.00s) === RUN TestMultiSign ---- PASS: TestMultiSign (0.00s) +--- PASS: TestMultiSign (0.01s) === RUN TestSignReturnsNoSigs --- PASS: TestSignReturnsNoSigs (0.00s) === RUN TestSignWithX509 --- PASS: TestSignWithX509 (0.00s) === RUN TestSignRemovesValidSigByInvalidKey ---- PASS: TestSignRemovesValidSigByInvalidKey (0.00s) +--- PASS: TestSignRemovesValidSigByInvalidKey (0.01s) === RUN TestSignRemovesInvalidSig --- PASS: TestSignRemovesInvalidSig (0.00s) === RUN TestSignMinSignatures @@ -3630,13 +3666,13 @@ === RUN TestRSAPSSVerifierWithInvalidKeyType --- PASS: TestRSAPSSVerifierWithInvalidKeyType (0.00s) === RUN TestRSAPSSVerifierWithInvalidKeyLength ---- PASS: TestRSAPSSVerifierWithInvalidKeyLength (0.05s) +--- PASS: TestRSAPSSVerifierWithInvalidKeyLength (0.15s) === RUN TestRSAPSSVerifierWithInvalidKey --- PASS: TestRSAPSSVerifierWithInvalidKey (0.00s) === RUN TestRSAPSSVerifierWithInvalidSignature --- PASS: TestRSAPSSVerifierWithInvalidSignature (0.01s) === RUN TestRSAPKCS1v15Verifier ---- PASS: TestRSAPKCS1v15Verifier (0.00s) +--- PASS: TestRSAPKCS1v15Verifier (0.01s) === RUN TestRSAPKCS1v15x509Verifier --- PASS: TestRSAPKCS1v15x509Verifier (0.00s) === RUN TestRSAPKCS1v15VerifierWithInvalidKeyType @@ -3644,14 +3680,14 @@ === RUN TestRSAPKCS1v15VerifierWithInvalidKey --- PASS: TestRSAPKCS1v15VerifierWithInvalidKey (0.00s) === RUN TestRSAPKCS1v15VerifierWithInvalidSignature -time="2025-02-07T19:31:48Z" level=error msg="Failed verification: crypto/rsa: verification error" ---- PASS: TestRSAPKCS1v15VerifierWithInvalidSignature (0.01s) +time="2024-01-06T13:14:57Z" level=error msg="Failed verification: crypto/rsa: verification error" +--- PASS: TestRSAPKCS1v15VerifierWithInvalidSignature (0.00s) === RUN TestECDSAVerifier --- PASS: TestECDSAVerifier (0.00s) === RUN TestECDSAVerifierOtherCurves ---- PASS: TestECDSAVerifierOtherCurves (0.10s) +--- PASS: TestECDSAVerifierOtherCurves (0.17s) === RUN TestECDSAx509Verifier ---- PASS: TestECDSAx509Verifier (0.00s) +--- PASS: TestECDSAx509Verifier (0.01s) === RUN TestECDSAVerifierWithInvalidKeyType --- PASS: TestECDSAVerifierWithInvalidKeyType (0.00s) === RUN TestECDSAVerifierWithInvalidKey @@ -3669,7 +3705,7 @@ === RUN TestRoleNoKeys --- PASS: TestRoleNoKeys (0.00s) === RUN TestNotEnoughSigs ---- PASS: TestNotEnoughSigs (0.00s) +--- PASS: TestNotEnoughSigs (0.02s) === RUN TestNoSigs --- PASS: TestNoSigs (0.00s) === RUN TestExactlyEnoughSigs @@ -3683,74 +3719,74 @@ === RUN TestDuplicateSigs --- PASS: TestDuplicateSigs (0.00s) === RUN TestUnknownKeyBelowThreshold ---- PASS: TestUnknownKeyBelowThreshold (0.00s) +--- PASS: TestUnknownKeyBelowThreshold (0.01s) === RUN TestVerifyVersion --- PASS: TestVerifyVersion (0.00s) === RUN TestVerifyExpiry -time="2025-02-07T19:31:48Z" level=error msg="Metadata for root expired" +time="2024-01-06T13:14:57Z" level=error msg="Metadata for root expired" --- PASS: TestVerifyExpiry (0.00s) === RUN TestVerifyPublicKeyMatchesPrivateKeyHappyCase --- PASS: TestVerifyPublicKeyMatchesPrivateKeyHappyCase (0.00s) === RUN TestVerifyPublicKeyMatchesPrivateKeyFails --- PASS: TestVerifyPublicKeyMatchesPrivateKeyFails (0.00s) PASS -ok github.com/theupdateframework/notary/tuf/signed 0.222s +ok github.com/theupdateframework/notary/tuf/signed 0.466s === RUN TestNewSwizzler ---- PASS: TestNewSwizzler (0.01s) +--- PASS: TestNewSwizzler (0.03s) === RUN TestSwizzlerSetInvalidJSON ---- PASS: TestSwizzlerSetInvalidJSON (0.01s) +--- PASS: TestSwizzlerSetInvalidJSON (0.02s) === RUN TestSwizzlerAddExtraSpace ---- PASS: TestSwizzlerAddExtraSpace (0.01s) +--- PASS: TestSwizzlerAddExtraSpace (0.03s) === RUN TestSwizzlerSetInvalidSigned ---- PASS: TestSwizzlerSetInvalidSigned (0.01s) +--- PASS: TestSwizzlerSetInvalidSigned (0.03s) === RUN TestSwizzlerSetInvalidSignedMeta ---- PASS: TestSwizzlerSetInvalidSignedMeta (0.01s) +--- PASS: TestSwizzlerSetInvalidSignedMeta (0.04s) === RUN TestSwizzlerSetInvalidMetadataType ---- PASS: TestSwizzlerSetInvalidMetadataType (0.01s) +--- PASS: TestSwizzlerSetInvalidMetadataType (0.03s) === RUN TestSwizzlerInvalidateMetadataSignatures ---- PASS: TestSwizzlerInvalidateMetadataSignatures (0.02s) +--- PASS: TestSwizzlerInvalidateMetadataSignatures (0.05s) === RUN TestSwizzlerRemoveMetadata ---- PASS: TestSwizzlerRemoveMetadata (0.02s) +--- PASS: TestSwizzlerRemoveMetadata (0.04s) === RUN TestSwizzlerSignMetadataWithInvalidKey ---- PASS: TestSwizzlerSignMetadataWithInvalidKey (0.10s) +--- PASS: TestSwizzlerSignMetadataWithInvalidKey (0.07s) === RUN TestSwizzlerOffsetMetadataVersion ---- PASS: TestSwizzlerOffsetMetadataVersion (0.01s) +--- PASS: TestSwizzlerOffsetMetadataVersion (0.03s) === RUN TestSwizzlerExpireMetadata --- PASS: TestSwizzlerExpireMetadata (0.01s) === RUN TestSwizzlerSetThresholdBaseRole ---- PASS: TestSwizzlerSetThresholdBaseRole (0.01s) +--- PASS: TestSwizzlerSetThresholdBaseRole (0.03s) === RUN TestSwizzlerSetThresholdDelegatedRole ---- PASS: TestSwizzlerSetThresholdDelegatedRole (0.02s) +--- PASS: TestSwizzlerSetThresholdDelegatedRole (0.01s) === RUN TestSwizzlerChangeRootKey ---- PASS: TestSwizzlerChangeRootKey (0.02s) +--- PASS: TestSwizzlerChangeRootKey (0.03s) === RUN TestSwizzlerUpdateSnapshotHashesSpecifiedRoles --- PASS: TestSwizzlerUpdateSnapshotHashesSpecifiedRoles (0.01s) === RUN TestSwizzlerUpdateSnapshotHashesNoSpecifiedRoles ---- PASS: TestSwizzlerUpdateSnapshotHashesNoSpecifiedRoles (0.01s) +--- PASS: TestSwizzlerUpdateSnapshotHashesNoSpecifiedRoles (0.02s) === RUN TestSwizzlerUpdateTimestamp ---- PASS: TestSwizzlerUpdateTimestamp (0.01s) +--- PASS: TestSwizzlerUpdateTimestamp (0.02s) === RUN TestMissingSigningKey ---- PASS: TestMissingSigningKey (0.01s) +--- PASS: TestMissingSigningKey (0.02s) === RUN TestSwizzlerMutateRoot ---- PASS: TestSwizzlerMutateRoot (0.01s) +--- PASS: TestSwizzlerMutateRoot (0.02s) === RUN TestSwizzlerMutateTimestamp --- PASS: TestSwizzlerMutateTimestamp (0.01s) === RUN TestSwizzlerMutateSnapshot ---- PASS: TestSwizzlerMutateSnapshot (0.01s) +--- PASS: TestSwizzlerMutateSnapshot (0.03s) === RUN TestSwizzlerMutateTargets --- PASS: TestSwizzlerMutateTargets (0.02s) === RUN TestSwizzlerRotateKeyBaseRole ---- PASS: TestSwizzlerRotateKeyBaseRole (0.02s) +--- PASS: TestSwizzlerRotateKeyBaseRole (0.04s) === RUN TestSwizzlerRotateKeyDelegationRole --- PASS: TestSwizzlerRotateKeyDelegationRole (0.01s) PASS -ok github.com/theupdateframework/notary/tuf/testutils 0.384s +ok github.com/theupdateframework/notary/tuf/testutils 0.768s ? github.com/theupdateframework/notary/tuf/testutils/interfaces [no test files] ? github.com/theupdateframework/notary/tuf/testutils/keys [no test files] === RUN TestConvertTUFKeyToPKCS8 ---- PASS: TestConvertTUFKeyToPKCS8 (0.03s) +--- PASS: TestConvertTUFKeyToPKCS8 (0.05s) === RUN TestParsePKCS8ToTufKey ---- PASS: TestParsePKCS8ToTufKey (0.12s) +--- PASS: TestParsePKCS8ToTufKey (0.22s) === RUN TestPEMtoPEM --- PASS: TestPEMtoPEM (0.00s) === RUN TestRoleListLen @@ -3780,7 +3816,7 @@ === RUN TestUnusedDelegationKeys --- PASS: TestUnusedDelegationKeys (0.00s) === RUN TestRemoveUnusedKeys ---- PASS: TestRemoveUnusedKeys (0.00s) +--- PASS: TestRemoveUnusedKeys (0.01s) === RUN TestFindRoleIndexFound --- PASS: TestFindRoleIndexFound (0.00s) === RUN TestFindRoleIndexNotFound @@ -3796,7 +3832,7 @@ === RUN TestNewCertificate --- PASS: TestNewCertificate (0.00s) === RUN TestKeyOperations ---- PASS: TestKeyOperations (0.03s) +--- PASS: TestKeyOperations (0.06s) === RUN TestRSAX509PublickeyID --- PASS: TestRSAX509PublickeyID (0.00s) === RUN TestECDSAX509PublickeyID @@ -3812,9 +3848,9 @@ === RUN TestValidateCertificateWithInvalidExpiry --- PASS: TestValidateCertificateWithInvalidExpiry (0.00s) === RUN TestValidateCertificateWithShortKey ---- PASS: TestValidateCertificateWithShortKey (0.10s) +--- PASS: TestValidateCertificateWithShortKey (0.07s) PASS -ok github.com/theupdateframework/notary/tuf/utils 0.298s +ok github.com/theupdateframework/notary/tuf/utils 0.446s === RUN TestNewSerializableErrorNonValidationError --- PASS: TestNewSerializableErrorNonValidationError (0.00s) === RUN TestNewSerializableErrorValidationError @@ -3830,9 +3866,9 @@ === RUN TestUnmarshalInvalidJSON --- PASS: TestUnmarshalInvalidJSON (0.00s) PASS -ok github.com/theupdateframework/notary/tuf/validation 0.050s +ok github.com/theupdateframework/notary/tuf/validation 0.047s === RUN TestSetSignalTrap ---- PASS: TestSetSignalTrap (0.01s) +--- PASS: TestSetSignalTrap (0.02s) === RUN TestLogLevelSignalHandle Attempt to increase log level failed, will remain at debug level, error: log level can not be set higher than Debug Successfully setting log level to debug @@ -3892,7 +3928,7 @@ === RUN TestParseTLSNoTLSNotRequired --- PASS: TestParseTLSNoTLSNotRequired (0.00s) === RUN TestParseTLSWithTLS ---- PASS: TestParseTLSWithTLS (0.00s) +--- PASS: TestParseTLSWithTLS (0.02s) === RUN TestParseTLSWithTLSRelativeToConfigFile --- PASS: TestParseTLSWithTLSRelativeToConfigFile (0.00s) === RUN TestParseTLSWithEnvironmentVariables @@ -3930,7 +3966,7 @@ === RUN TestDoAuthWildcardImage --- PASS: TestDoAuthWildcardImage (0.00s) PASS -ok github.com/theupdateframework/notary/utils 0.027s +ok github.com/theupdateframework/notary/utils 0.135s ? github.com/theupdateframework/notary/version [no test files] create-stamp debian/debhelper-build-stamp dh_testroot -O--builddirectory=/build/reproducible-path/notary-0.7.0\+ds1/_build -O--buildsystem=golang @@ -3968,9 +4004,9 @@ dpkg-gencontrol: warning: package notary: substitution variable ${misc:Static-Built-Using} unused, but is defined dh_md5sums -O--builddirectory=/build/reproducible-path/notary-0.7.0\+ds1/_build -O--buildsystem=golang dh_builddeb -O--builddirectory=/build/reproducible-path/notary-0.7.0\+ds1/_build -O--buildsystem=golang -dpkg-deb: building package 'notary' in '../notary_0.7.0+ds1-2_amd64.deb'. dpkg-deb: building package 'notary-dbgsym' in '../notary-dbgsym_0.7.0+ds1-2_amd64.deb'. dpkg-deb: building package 'golang-github-docker-notary-dev' in '../golang-github-docker-notary-dev_0.7.0+ds1-2_all.deb'. +dpkg-deb: building package 'notary' in '../notary_0.7.0+ds1-2_amd64.deb'. dpkg-genbuildinfo --build=binary -O../notary_0.7.0+ds1-2_amd64.buildinfo dpkg-genchanges --build=binary -O../notary_0.7.0+ds1-2_amd64.changes dpkg-genchanges: info: binary-only upload (no source code included) @@ -3978,12 +4014,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/2339407/tmp/hooks/B01_cleanup starting +I: user script /srv/workspace/pbuilder/2339407/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/4175658 and its subdirectories -I: Current time: Fri Feb 7 07:32:42 -12 2025 -I: pbuilder-time-stamp: 1738956762 +I: removing directory /srv/workspace/pbuilder/2339407 and its subdirectories +I: Current time: Sun Jan 7 03:19:35 +14 2024 +I: pbuilder-time-stamp: 1704547175