Diff of the two buildlogs: -- --- b1/build.log 2024-01-07 20:24:25.861120464 +0000 +++ b2/build.log 2024-01-07 20:27:19.573687525 +0000 @@ -1,6 +1,6 @@ I: pbuilder: network access will be disabled during build -I: Current time: Sun Jan 7 08:18:20 -12 2024 -I: pbuilder-time-stamp: 1704658700 +I: Current time: Sun Feb 9 16:47:26 +14 2025 +I: pbuilder-time-stamp: 1739069246 I: Building the build Environment I: extracting base tarball [/var/cache/pbuilder/bookworm-reproducible-base.tgz] I: copying local configuration @@ -32,51 +32,83 @@ 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/403/tmp/hooks/D02_print_environment starting +I: user script /srv/workspace/pbuilder/129746/tmp/hooks/D01_modify_environment starting +debug: Running on ionos16-i386. +I: Changing host+domainname to test build reproducibility +I: Adding a custom variable just for the fun of it... +I: Changing /bin/sh to bash +'/bin/sh' -> '/bin/bash' +lrwxrwxrwx 1 root root 9 Feb 9 02:47 /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/129746/tmp/hooks/D01_modify_environment finished +I: user script /srv/workspace/pbuilder/129746/tmp/hooks/D02_print_environment starting I: set - BUILDDIR='/build/reproducible-path' - BUILDUSERGECOS='first user,first room,first work-phone,first home-phone,first other' - BUILDUSERNAME='pbuilder1' - BUILD_ARCH='i386' - DEBIAN_FRONTEND='noninteractive' - DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all parallel=8 ' - DISTRIBUTION='bookworm' - HOME='/root' - HOST_ARCH='i386' + BASH=/bin/sh + BASHOPTS=checkwinsize:cmdhist:complete_fullquote:extquote:force_fignore:globasciiranges:globskipdots:hostcomplete:interactive_comments:patsub_replacement:progcomp:promptvars:sourcepath + BASH_ALIASES=() + BASH_ARGC=() + BASH_ARGV=() + BASH_CMDS=() + BASH_LINENO=([0]="12" [1]="0") + BASH_LOADABLES_PATH=/usr/local/lib/bash:/usr/lib/bash:/opt/local/lib/bash:/usr/pkg/lib/bash:/opt/pkg/lib/bash:. + BASH_SOURCE=([0]="/tmp/hooks/D02_print_environment" [1]="/tmp/hooks/D02_print_environment") + BASH_VERSINFO=([0]="5" [1]="2" [2]="15" [3]="1" [4]="release" [5]="i686-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=i386 + 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=i686 + HOST_ARCH=i386 IFS=' ' - INVOCATION_ID='e0233b24d41348a3ac1330498851ebe6' - LANG='C' - LANGUAGE='en_US:en' - LC_ALL='C' - LD_LIBRARY_PATH='/usr/lib/libeatmydata' - LD_PRELOAD='libeatmydata.so' - MAIL='/var/mail/root' - OPTIND='1' - PATH='/usr/sbin:/usr/bin:/sbin:/bin:/usr/games' - PBCURRENTCOMMANDLINEOPERATION='build' - PBUILDER_OPERATION='build' - PBUILDER_PKGDATADIR='/usr/share/pbuilder' - PBUILDER_PKGLIBDIR='/usr/lib/pbuilder' - PBUILDER_SYSCONFDIR='/etc' - PPID='403' - PS1='# ' - PS2='> ' + INVOCATION_ID=6a939793a1144119a6d1c8ae1c6ba3ac + LANG=C + LANGUAGE=de_CH:de + LC_ALL=C + LD_LIBRARY_PATH=/usr/lib/libeatmydata + LD_PRELOAD=libeatmydata.so + MACHTYPE=i686-pc-linux-gnu + MAIL=/var/mail/root + OPTERR=1 + OPTIND=1 + OSTYPE=linux-gnu + PATH=/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/i/capture/the/path + PBCURRENTCOMMANDLINEOPERATION=build + PBUILDER_OPERATION=build + PBUILDER_PKGDATADIR=/usr/share/pbuilder + PBUILDER_PKGLIBDIR=/usr/lib/pbuilder + PBUILDER_SYSCONFDIR=/etc + PIPESTATUS=([0]="0") + POSIXLY_CORRECT=y + PPID=129746 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.IG6FxAzr/pbuilderrc_FDSU --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.IG6FxAzr/b1 --logfile b1/build.log notary_0.7.0+ds1-2.dsc' - SUDO_GID='112' - SUDO_UID='107' - SUDO_USER='jenkins' - TERM='unknown' - TZ='/usr/share/zoneinfo/Etc/GMT+12' - USER='root' - _='/usr/bin/systemd-run' - http_proxy='http://78.137.99.97: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.IG6FxAzr/pbuilderrc_zrG8 --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.IG6FxAzr/b2 --logfile b2/build.log notary_0.7.0+ds1-2.dsc' + SUDO_GID=112 + SUDO_UID=107 + SUDO_USER=jenkins + TERM=unknown + TZ=/usr/share/zoneinfo/Etc/GMT-14 + UID=0 + USER=root + _='I: set' + http_proxy=http://85.184.249.68:3128 I: uname -a - Linux ionos2-i386 6.1.0-17-686-pae #1 SMP PREEMPT_DYNAMIC Debian 6.1.69-1 (2023-12-30) i686 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 6036 -rwxr-xr-x 1 root root 1408088 Apr 23 2023 bash @@ -134,15 +166,15 @@ -rwxr-xr-x 1 root root 51080 Sep 20 2022 readlink -rwxr-xr-x 1 root root 75720 Sep 20 2022 rm -rwxr-xr-x 1 root root 51080 Sep 20 2022 rmdir - -rwxr-xr-x 1 root root 22308 Jul 28 23:46 run-parts + -rwxr-xr-x 1 root root 22308 Jul 28 2023 run-parts -rwxr-xr-x 1 root root 133224 Jan 5 2023 sed - lrwxrwxrwx 1 root root 4 Jan 5 2023 sh -> dash + lrwxrwxrwx 1 root root 9 Feb 9 02:47 sh -> /bin/bash -rwxr-xr-x 1 root root 38760 Sep 20 2022 sleep -rwxr-xr-x 1 root root 87976 Sep 20 2022 stty -rwsr-xr-x 1 root root 83492 Mar 23 2023 su -rwxr-xr-x 1 root root 38792 Sep 20 2022 sync -rwxr-xr-x 1 root root 598456 Apr 6 2023 tar - -rwxr-xr-x 1 root root 13860 Jul 28 23:46 tempfile + -rwxr-xr-x 1 root root 13860 Jul 28 2023 tempfile -rwxr-xr-x 1 root root 120776 Sep 20 2022 touch -rwxr-xr-x 1 root root 34664 Sep 20 2022 true -rwxr-xr-x 1 root root 17892 Mar 23 2023 ulockmgr_server @@ -162,7 +194,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/403/tmp/hooks/D02_print_environment finished +I: user script /srv/workspace/pbuilder/129746/tmp/hooks/D02_print_environment finished -> Attempting to satisfy build-dependencies -> Creating pbuilder-satisfydepends-dummy package Package: pbuilder-satisfydepends-dummy @@ -438,7 +470,7 @@ Get: 184 http://deb.debian.org/debian bookworm/main i386 golang-goprotobuf-dev i386 1.3.5-4+b3 [3432 B] Get: 185 http://deb.debian.org/debian bookworm/main i386 golang-gopkg-rethinkdb-rethinkdb-go.v6-dev all 6.2.1-2 [106 kB] Get: 186 http://deb.debian.org/debian bookworm/main i386 openssl i386 3.0.11-1~deb12u2 [1423 kB] -Fetched 138 MB in 13s (10.6 MB/s) +Fetched 138 MB in 3s (45.0 MB/s) debconf: delaying package configuration, since apt-utils is not installed Selecting previously unselected package golang-golang-x-sys-dev. (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 18156 files and directories currently installed.) @@ -1197,7 +1229,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/129746/tmp/hooks/A99_set_merged_usr starting +Not re-configuring usrmerge for bookworm +I: user script /srv/workspace/pbuilder/129746/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 @@ -1476,793 +1512,793 @@ 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 8 -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/unsafeheader -internal/goexperiment -runtime/internal/math -internal/goos + 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 +unicode/utf16 internal/race +internal/goos +internal/unsafeheader +unicode/utf8 +encoding +internal/goarch math/bits internal/cpu +internal/goexperiment +crypto/internal/subtle +runtime/internal/math +runtime/internal/atomic internal/abi -unicode/utf8 -sync/atomic runtime/internal/syscall -runtime/internal/sys -runtime/internal/atomic -math -internal/itoa -encoding +sync/atomic unicode -unicode/utf16 -crypto/internal/subtle crypto/subtle +internal/itoa crypto/internal/boring/sig vendor/golang.org/x/crypto/cryptobyte/asn1 -internal/bytealg +runtime/internal/sys internal/nettrace container/list 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 +math +internal/bytealg runtime internal/reflectlite sync runtime/metrics internal/testlog -math/rand internal/singleflight +math/rand github.com/spf13/viper/internal/encoding google.golang.org/grpc/internal/buffer google.golang.org/grpc/internal/grpcsync -runtime/cgo google.golang.org/protobuf/internal/pragma internal/sysinfo +runtime/cgo errors sort -io -strconv internal/oserror internal/safefilepath +io path +github.com/hashicorp/hcl/hcl/strconv +vendor/golang.org/x/net/dns/dnsmessage +strconv crypto/internal/nistec/fiat syscall -vendor/golang.org/x/net/dns/dnsmessage -github.com/hashicorp/hcl/hcl/strconv +github.com/beorn7/perks/quantile hash -bytes -strings crypto/internal/randutil -hash/crc32 +strings text/tabwriter -github.com/beorn7/perks/quantile +bytes +hash/crc32 +hash/fnv vendor/golang.org/x/text/transform +github.com/dvsekhvalnov/jose2go/padding +golang.org/x/text/transform crypto +golang.org/x/crypto/blowfish +crypto/rc4 +encoding/base32 reflect bufio +html regexp/syntax -crypto/rc4 net/http/internal/ascii -golang.org/x/text/transform -html google.golang.org/grpc/encoding github.com/prometheus/common/internal/bitbucket.org/ww/goautoneg +net/http/internal/testcert golang.org/x/text/runes -hash/fnv +internal/syscall/execenv internal/syscall/unix time -internal/syscall/execenv -golang.org/x/crypto/blowfish -encoding/base32 -github.com/dvsekhvalnov/jose2go/padding -net/http/internal/testcert regexp crypto/internal/nistec -github.com/jinzhu/inflection -internal/poll -io/fs context google.golang.org/grpc/backoff -google.golang.org/grpc/internal/grpcrand google.golang.org/grpc/keepalive github.com/bugsnag/bugsnag-go/headers +google.golang.org/grpc/internal/grpcrand +internal/poll +io/fs google.golang.org/grpc/internal/backoff +github.com/jinzhu/inflection 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 os -internal/fmtsort encoding/binary -crypto/md5 +internal/fmtsort encoding/base64 -crypto/internal/edwards25519/field +crypto/md5 +vendor/golang.org/x/crypto/curve25519/internal/field vendor/golang.org/x/crypto/internal/poly1305 +crypto/internal/edwards25519/field +github.com/cespare/xxhash crypto/cipher -vendor/golang.org/x/crypto/curve25519/internal/field golang.org/x/sys/unix -fmt -internal/godebug -crypto/internal/edwards25519 encoding/pem -internal/intern -path/filepath -github.com/theupdateframework/notary +github.com/dvsekhvalnov/jose2go/base64url +github.com/dvsekhvalnov/jose2go/compact +crypto/internal/edwards25519 crypto/internal/boring +vendor/golang.org/x/crypto/chacha20 crypto/des -net/netip +internal/godebug +github.com/theupdateframework/notary io/ioutil +path/filepath +google.golang.org/grpc/internal/envconfig +fmt +os/signal +github.com/bugsnag/bugsnag-go/device +google.golang.org/protobuf/internal/detrand +github.com/prometheus/procfs/internal/util crypto/aes crypto/sha512 crypto/sha256 crypto/sha1 +internal/intern crypto/hmac -vendor/golang.org/x/crypto/chacha20 +vendor/golang.org/x/crypto/chacha20poly1305 +net/netip golang.org/x/crypto/pbkdf2 vendor/golang.org/x/crypto/hkdf github.com/spf13/afero/mem -google.golang.org/grpc/internal/envconfig -vendor/golang.org/x/crypto/chacha20poly1305 -github.com/bugsnag/bugsnag-go/device os/exec -os/signal net +github.com/bugsnag/panicwrap encoding/json -github.com/docker/go/canonical/json log -math/big +github.com/docker/go/canonical/json encoding/hex net/url mime mime/quotedprintable -compress/flate vendor/golang.org/x/crypto/curve25519 -vendor/golang.org/x/text/unicode/bidi -vendor/golang.org/x/text/unicode/norm +math/big vendor/golang.org/x/net/http2/hpack -compress/gzip -github.com/theupdateframework/notary/tuf/validation +compress/flate +vendor/golang.org/x/text/unicode/norm net/http/internal -github.com/sirupsen/logrus -github.com/miekg/pkcs11 flag -vendor/golang.org/x/text/secure/bidirule +github.com/miekg/pkcs11 encoding/csv -github.com/fsnotify/fsnotify +vendor/golang.org/x/text/unicode/bidi golang.org/x/text/unicode/norm text/template/parse -crypto/rand -crypto/elliptic -github.com/docker/distribution/uuid -crypto/internal/boring/bbig -encoding/asn1 -crypto/rsa -crypto/dsa -crypto/ed25519 -vendor/golang.org/x/net/idna github.com/spf13/jwalterweatherman -golang.org/x/crypto/ed25519 github.com/hashicorp/hcl/hcl/token -text/template -github.com/spf13/viper/internal/encoding/json -github.com/pelletier/go-toml +gopkg.in/yaml.v2 github.com/hashicorp/hcl/hcl/ast -vendor/golang.org/x/crypto/cryptobyte -crypto/x509/pkix github.com/hashicorp/hcl/hcl/scanner github.com/hashicorp/hcl/json/token -github.com/hashicorp/hcl/hcl/parser -gopkg.in/yaml.v2 -github.com/hashicorp/hcl/json/scanner -crypto/ecdsa -github.com/hashicorp/hcl/hcl/printer -github.com/hashicorp/hcl/json/parser -github.com/hashicorp/hcl github.com/subosito/gotenv -html/template +compress/gzip +github.com/hashicorp/hcl/json/scanner +github.com/hashicorp/hcl/hcl/parser +vendor/golang.org/x/text/secure/bidirule gopkg.in/ini.v1 -github.com/golang/protobuf/proto -github.com/spf13/viper/internal/encoding/hcl +github.com/hashicorp/hcl/json/parser golang.org/x/net/internal/timeseries google.golang.org/grpc/internal/grpclog -google.golang.org/grpc/grpclog -github.com/spf13/viper/internal/encoding/toml +github.com/hashicorp/hcl/hcl/printer +github.com/fsnotify/fsnotify google.golang.org/grpc/attributes +google.golang.org/grpc/grpclog +github.com/sirupsen/logrus +github.com/theupdateframework/notary/tuf/validation +github.com/hashicorp/hcl +github.com/spf13/viper/internal/encoding/json google.golang.org/grpc/metadata -google.golang.org/grpc/connectivity -google.golang.org/grpc/internal -github.com/spf13/cast google.golang.org/grpc/codes -google.golang.org/grpc/internal/balancerload +github.com/golang/protobuf/proto +vendor/golang.org/x/net/idna +google.golang.org/grpc/connectivity golang.org/x/text/unicode/bidi golang.org/x/net/http2/hpack +google.golang.org/grpc/internal +google.golang.org/grpc/internal/balancerload +text/template github.com/pkg/errors -crypto/x509 -net/textproto -vendor/golang.org/x/net/http/httpproxy -github.com/mitchellh/mapstructure -mime/multipart -vendor/golang.org/x/net/http/httpguts -github.com/spf13/pflag -github.com/spf13/viper/internal/encoding/yaml -google.golang.org/grpc/internal/syscall -golang.org/x/text/secure/bidirule -google.golang.org/grpc/stats -golang.org/x/net/idna -github.com/bugsnag/bugsnag-go/errors -github.com/bugsnag/panicwrap database/sql/driver github.com/opencontainers/go-digest -github.com/opencontainers/image-spec/specs-go -github.com/cespare/xxhash -github.com/docker/distribution/digestset -github.com/gofrs/uuid +crypto/rand +crypto/elliptic +crypto/internal/boring/bbig +encoding/asn1 +crypto/dsa +github.com/spf13/viper/internal/encoding/hcl +github.com/docker/distribution/uuid +crypto/rsa +crypto/ed25519 +github.com/pelletier/go-toml +github.com/bugsnag/bugsnag-go/errors database/sql -github.com/docker/distribution/reference -github.com/golang/protobuf/ptypes/empty -google.golang.org/grpc/encoding/proto -github.com/golang/protobuf/ptypes/any -github.com/theupdateframework/notary/tuf/data -crypto/tls -github.com/golang/protobuf/ptypes/duration -github.com/golang/protobuf/ptypes/timestamp -google.golang.org/genproto/googleapis/rpc/status -golang.org/x/net/http/httpguts -github.com/golang/protobuf/ptypes -google.golang.org/grpc/binarylog/grpc_binarylog_v1 +github.com/docker/distribution/digestset +golang.org/x/crypto/ed25519 +github.com/opencontainers/image-spec/specs-go +golang.org/x/text/secure/bidirule github.com/opencontainers/image-spec/specs-go/v1 -github.com/prometheus/client_model/go -google.golang.org/grpc/internal/status github.com/prometheus/common/model -google.golang.org/grpc/status -github.com/matttproud/golang_protobuf_extensions/pbutil -google.golang.org/protobuf/internal/detrand -go/token -github.com/theupdateframework/notary/client/changelist -github.com/theupdateframework/notary/tuf/utils +github.com/spf13/viper/internal/encoding/yaml google.golang.org/protobuf/internal/errors +github.com/docker/distribution/reference +go/token google.golang.org/protobuf/internal/version -github.com/prometheus/procfs/internal/fs +golang.org/x/net/idna google.golang.org/protobuf/encoding/protowire -github.com/prometheus/procfs/internal/util +github.com/prometheus/procfs/internal/fs runtime/debug -github.com/prometheus/procfs -github.com/spf13/cobra -github.com/prometheus/client_golang/prometheus/internal -google.golang.org/protobuf/reflect/protoreflect golang.org/x/term golang.org/x/crypto/bcrypt +crypto/x509/pkix +vendor/golang.org/x/crypto/cryptobyte +html/template +google.golang.org/protobuf/reflect/protoreflect github.com/lib/pq/scram os/user -github.com/theupdateframework/notary/passphrase go/scanner +github.com/hailocab/go-hostpool +github.com/theupdateframework/notary/passphrase +github.com/opentracing/opentracing-go/log +gopkg.in/rethinkdb/rethinkdb-go.v6/encoding +gopkg.in/rethinkdb/rethinkdb-go.v6/types +go/ast +internal/profile +runtime/pprof +runtime/trace +crypto/ecdsa +github.com/dvsekhvalnov/jose2go/arrays +github.com/davecgh/go-spew/spew +github.com/pmezard/go-difflib/difflib +gopkg.in/yaml.v3 +github.com/dvsekhvalnov/jose2go/aes google.golang.org/protobuf/internal/descfmt +github.com/spf13/cast google.golang.org/protobuf/internal/descopts google.golang.org/protobuf/internal/strs -google.golang.org/protobuf/internal/encoding/text google.golang.org/protobuf/internal/encoding/messageset google.golang.org/protobuf/internal/genid +google.golang.org/protobuf/internal/encoding/text google.golang.org/protobuf/internal/order +github.com/spf13/viper/internal/encoding/toml +google.golang.org/protobuf/runtime/protoiface +github.com/dvsekhvalnov/jose2go/kdf +google.golang.org/protobuf/reflect/protoregistry +testing +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/matttproud/golang_protobuf_extensions/pbutil +google.golang.org/protobuf/internal/encoding/defval +gopkg.in/rethinkdb/rethinkdb-go.v6/ql2 +google.golang.org/protobuf/proto +github.com/prometheus/client_model/go +google.golang.org/genproto/googleapis/rpc/status +github.com/golang/protobuf/ptypes +google.golang.org/grpc/binarylog/grpc_binarylog_v1 +google.golang.org/grpc/internal/status +google.golang.org/grpc/status +github.com/prometheus/client_golang/prometheus/internal +google.golang.org/protobuf/internal/filedesc +google.golang.org/protobuf/encoding/prototext +crypto/x509 +net/textproto +vendor/golang.org/x/net/http/httpproxy +github.com/mitchellh/mapstructure +google.golang.org/grpc/internal/syscall +google.golang.org/grpc/stats +github.com/gofrs/uuid +github.com/spf13/pflag +github.com/prometheus/procfs +mime/multipart +vendor/golang.org/x/net/http/httpguts +golang.org/x/net/http/httpguts +google.golang.org/protobuf/internal/encoding/tag +google.golang.org/protobuf/internal/impl +github.com/theupdateframework/notary/tuf/data +github.com/dvsekhvalnov/jose2go/keys/ecc +crypto/tls +github.com/dvsekhvalnov/jose2go +github.com/spf13/cobra +github.com/theupdateframework/notary/client/changelist +github.com/theupdateframework/notary/tuf/utils net/http/httptrace -google.golang.org/grpc/internal/credentials github.com/docker/go-connections/tlsconfig +google.golang.org/grpc/internal/credentials +github.com/docker/libtrust github.com/go-sql-driver/mysql +github.com/lib/pq google.golang.org/grpc/credentials net/http -google.golang.org/protobuf/reflect/protoregistry -google.golang.org/protobuf/internal/encoding/defval google.golang.org/grpc/resolver +google.golang.org/grpc/peer google.golang.org/grpc/internal/channelz google.golang.org/grpc/balancer -google.golang.org/grpc/balancer/base -google.golang.org/grpc/internal/grpcutil google.golang.org/grpc/balancer/grpclb/state +google.golang.org/grpc/internal/grpcutil +google.golang.org/grpc/internal/resolver/passthrough google.golang.org/grpc/internal/resolver/dns -google.golang.org/grpc/balancer/roundrobin google.golang.org/grpc/internal/binarylog -google.golang.org/grpc/internal/resolver/passthrough google.golang.org/grpc/internal/serviceconfig -google.golang.org/grpc/peer -google.golang.org/protobuf/runtime/protoiface -github.com/docker/libtrust -go/ast -google.golang.org/protobuf/proto -github.com/hailocab/go-hostpool -github.com/opentracing/opentracing-go/log -gopkg.in/rethinkdb/rethinkdb-go.v6/encoding -gopkg.in/rethinkdb/rethinkdb-go.v6/ql2 -google.golang.org/protobuf/internal/filedesc -google.golang.org/protobuf/encoding/prototext -gopkg.in/rethinkdb/rethinkdb-go.v6/types -github.com/jinzhu/gorm -internal/profile -runtime/pprof -github.com/lib/pq -runtime/trace -github.com/dvsekhvalnov/jose2go/base64url -github.com/dvsekhvalnov/jose2go/arrays -github.com/dvsekhvalnov/jose2go/aes -github.com/dvsekhvalnov/jose2go/compact -github.com/dvsekhvalnov/jose2go/kdf -github.com/dvsekhvalnov/jose2go/keys/ecc -github.com/davecgh/go-spew/spew -google.golang.org/protobuf/internal/encoding/tag -github.com/dvsekhvalnov/jose2go -google.golang.org/protobuf/internal/impl -github.com/pmezard/go-difflib/difflib -gopkg.in/yaml.v3 -testing +google.golang.org/grpc/balancer/base +google.golang.org/grpc/balancer/roundrobin +google.golang.org/protobuf/internal/filetype +google.golang.org/protobuf/runtime/protoimpl +google.golang.org/protobuf/types/known/timestamppb +net/http/httputil +github.com/docker/distribution/registry/client/transport +github.com/docker/distribution/registry/api/errcode +github.com/docker/distribution/registry/auth github.com/theupdateframework/notary/storage +expvar github.com/magiconair/properties +github.com/docker/distribution/registry/client/auth/challenge golang.org/x/net/trace -github.com/spf13/afero +github.com/gorilla/mux +github.com/docker/distribution github.com/bugsnag/bugsnag-go/sessions +github.com/spf13/afero +github.com/prometheus/common/expfmt golang.org/x/net/http2 -net/http/httputil +github.com/opentracing/opentracing-go +net/http/pprof +net/http/httptest +github.com/theupdateframework/notary/server/errors github.com/bugsnag/bugsnag-go +github.com/opentracing/opentracing-go/ext +github.com/docker/distribution/context github.com/theupdateframework/notary/trustmanager -github.com/gorilla/mux -github.com/docker/distribution/registry/api/errcode -github.com/docker/distribution/registry/auth +github.com/docker/distribution/registry/api/v2 +gopkg.in/rethinkdb/rethinkdb-go.v6 +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/cryptoservice github.com/theupdateframework/notary/tuf/signed -github.com/docker/distribution github.com/Shopify/logrus-bugsnag -github.com/docker/distribution/registry/client/auth/challenge -github.com/docker/distribution/registry/client/transport -github.com/docker/distribution/context -github.com/docker/distribution/registry/api/v2 -expvar -github.com/theupdateframework/notary/trustmanager/yubikey -github.com/theupdateframework/notary/trustpinning -github.com/spf13/viper -github.com/theupdateframework/notary/server/errors github.com/docker/distribution/health -github.com/theupdateframework/notary/tuf github.com/docker/distribution/registry/auth/htpasswd github.com/docker/distribution/registry/auth/token -github.com/opentracing/opentracing-go -net/http/pprof +github.com/spf13/viper +github.com/theupdateframework/notary/trustpinning github.com/theupdateframework/notary/tuf/testutils/keys -google.golang.org/protobuf/internal/filetype -net/http/httptest -github.com/opentracing/opentracing-go/ext -google.golang.org/protobuf/runtime/protoimpl -gopkg.in/rethinkdb/rethinkdb-go.v6 +github.com/theupdateframework/notary/trustmanager/yubikey +github.com/theupdateframework/notary/tuf +github.com/stretchr/testify/require github.com/theupdateframework/notary/utils -github.com/theupdateframework/notary/client github.com/theupdateframework/notary/tuf/testutils -google.golang.org/protobuf/types/known/timestamppb -github.com/stretchr/testify/assert -github.com/prometheus/common/expfmt +github.com/theupdateframework/notary/client google.golang.org/grpc/internal/transport -github.com/theupdateframework/notary/vendor/github.com/prometheus/client_golang/prometheus -github.com/prometheus/client_golang/prometheus -github.com/stretchr/testify/require +github.com/prometheus/client_golang/prometheus/promhttp github.com/theupdateframework/notary/tuf/testutils/interfaces -google.golang.org/grpc github.com/theupdateframework/notary/storage/rethinkdb -github.com/theupdateframework/notary/server/storage github.com/theupdateframework/notary/signer/keydbstore -github.com/prometheus/client_golang/prometheus/promhttp +github.com/theupdateframework/notary/server/storage +github.com/docker/go-metrics github.com/theupdateframework/notary/server/snapshot +google.golang.org/grpc +github.com/docker/distribution/metrics github.com/theupdateframework/notary/server/timestamp +github.com/docker/distribution/registry/storage/cache +github.com/docker/distribution/registry/storage/cache/memory +github.com/theupdateframework/notary/server/handlers +github.com/docker/distribution/registry/client +github.com/theupdateframework/notary/server +github.com/docker/distribution/registry/client/auth +github.com/theupdateframework/notary/cmd/notary +google.golang.org/grpc/health/grpc_health_v1 github.com/theupdateframework/notary/trustmanager/remoteks github.com/theupdateframework/notary/proto -google.golang.org/grpc/health/grpc_health_v1 -github.com/docker/go-metrics -github.com/theupdateframework/notary/server/handlers -github.com/theupdateframework/notary/cmd/escrow -github.com/docker/distribution/metrics google.golang.org/grpc/health -github.com/theupdateframework/notary/signer/client +github.com/theupdateframework/notary/cmd/escrow github.com/theupdateframework/notary/signer -github.com/theupdateframework/notary/server -github.com/docker/distribution/registry/storage/cache +github.com/theupdateframework/notary/signer/client github.com/theupdateframework/notary/signer/api -github.com/docker/distribution/registry/storage/cache/memory github.com/theupdateframework/notary/cmd/notary-server -github.com/docker/distribution/registry/client github.com/theupdateframework/notary/cmd/notary-signer -github.com/docker/distribution/registry/client/auth -github.com/theupdateframework/notary/cmd/notary 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 8 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.07s) +--- PASS: Test0Dot1Migration (0.02s) === RUN Test0Dot3Migration ---- PASS: Test0Dot3Migration (0.15s) +--- PASS: Test0Dot3Migration (0.02s) === RUN Test0Dot1RepoFormat -time="2024-01-07T20:21:12Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" ---- PASS: Test0Dot1RepoFormat (1.29s) +time="2025-02-09T02:48:41Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" +--- PASS: Test0Dot1RepoFormat (0.45s) === RUN Test0Dot3RepoFormat -time="2024-01-07T20:21:14Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" ---- PASS: Test0Dot3RepoFormat (1.87s) +time="2025-02-09T02:48:41Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" +--- PASS: Test0Dot3RepoFormat (0.44s) === RUN TestDownloading0Dot1RepoFormat ---- PASS: TestDownloading0Dot1RepoFormat (0.04s) +--- PASS: TestDownloading0Dot1RepoFormat (0.01s) === RUN TestDownloading0Dot3RepoFormat ---- PASS: TestDownloading0Dot3RepoFormat (0.05s) +--- PASS: TestDownloading0Dot3RepoFormat (0.02s) === RUN TestInitRepositoryManagedRolesIncludingRoot ---- PASS: TestInitRepositoryManagedRolesIncludingRoot (0.02s) +--- PASS: TestInitRepositoryManagedRolesIncludingRoot (0.01s) === RUN TestInitRepositoryManagedRolesInvalidRole ---- PASS: TestInitRepositoryManagedRolesInvalidRole (0.05s) +--- PASS: TestInitRepositoryManagedRolesInvalidRole (0.01s) === RUN TestInitRepositoryManagedRolesIncludingTargets ---- PASS: TestInitRepositoryManagedRolesIncludingTargets (0.03s) +--- PASS: TestInitRepositoryManagedRolesIncludingTargets (0.01s) === RUN TestInitRepositoryManagedRolesIncludingTimestamp ---- PASS: TestInitRepositoryManagedRolesIncludingTimestamp (0.14s) +--- PASS: TestInitRepositoryManagedRolesIncludingTimestamp (0.04s) === RUN TestInitRepositoryWithCerts ---- PASS: TestInitRepositoryWithCerts (0.18s) +--- PASS: TestInitRepositoryWithCerts (0.05s) === RUN TestMatchKeyIDsWithPublicKeys ---- PASS: TestMatchKeyIDsWithPublicKeys (0.06s) +--- PASS: TestMatchKeyIDsWithPublicKeys (0.02s) === RUN TestInitRepositoryNeedsRemoteTimestampKey ---- PASS: TestInitRepositoryNeedsRemoteTimestampKey (0.04s) +--- PASS: TestInitRepositoryNeedsRemoteTimestampKey (0.02s) === RUN TestInitRepositoryNeedsRemoteSnapshotKey ---- PASS: TestInitRepositoryNeedsRemoteSnapshotKey (0.09s) +--- PASS: TestInitRepositoryNeedsRemoteSnapshotKey (0.03s) === RUN TestInitRepoServerOnlyManagesTimestampKey ---- PASS: TestInitRepoServerOnlyManagesTimestampKey (0.43s) +--- PASS: TestInitRepoServerOnlyManagesTimestampKey (0.19s) === RUN TestInitRepoServerManagesTimestampAndSnapshotKeys ---- PASS: TestInitRepoServerManagesTimestampAndSnapshotKeys (0.56s) +--- PASS: TestInitRepoServerManagesTimestampAndSnapshotKeys (0.16s) === RUN TestInitRepoAttemptsExceeded ---- PASS: TestInitRepoAttemptsExceeded (0.46s) +--- PASS: TestInitRepoAttemptsExceeded (0.09s) === RUN TestInitRepoPasswordInvalid ---- PASS: TestInitRepoPasswordInvalid (0.08s) +--- PASS: TestInitRepoPasswordInvalid (0.02s) === RUN TestAddTargetToTargetRoleByDefault ---- PASS: TestAddTargetToTargetRoleByDefault (0.34s) +--- PASS: TestAddTargetToTargetRoleByDefault (0.07s) === RUN TestAddTargetToSpecifiedValidRoles ---- PASS: TestAddTargetToSpecifiedValidRoles (0.24s) +--- PASS: TestAddTargetToSpecifiedValidRoles (0.07s) === RUN TestAddTargetToSpecifiedInvalidRoles ---- PASS: TestAddTargetToSpecifiedInvalidRoles (0.16s) +--- PASS: TestAddTargetToSpecifiedInvalidRoles (0.07s) === RUN TestAddTargetWithInvalidTarget ---- PASS: TestAddTargetWithInvalidTarget (0.14s) +--- PASS: TestAddTargetWithInvalidTarget (0.03s) === RUN TestAddTargetErrorWritingChanges ---- PASS: TestAddTargetErrorWritingChanges (0.18s) +--- PASS: TestAddTargetErrorWritingChanges (0.03s) === RUN TestRemoveTargetToTargetRoleByDefault ---- PASS: TestRemoveTargetToTargetRoleByDefault (0.20s) +--- PASS: TestRemoveTargetToTargetRoleByDefault (0.07s) === RUN TestRemoveTargetFromSpecifiedValidRoles ---- PASS: TestRemoveTargetFromSpecifiedValidRoles (0.28s) +--- PASS: TestRemoveTargetFromSpecifiedValidRoles (0.08s) === RUN TestRemoveTargetToSpecifiedInvalidRoles ---- PASS: TestRemoveTargetToSpecifiedInvalidRoles (0.23s) +--- PASS: TestRemoveTargetToSpecifiedInvalidRoles (0.07s) === RUN TestRemoveTargetErrorWritingChanges ---- PASS: TestRemoveTargetErrorWritingChanges (0.20s) +--- PASS: TestRemoveTargetErrorWritingChanges (0.04s) === RUN TestListTarget ---- PASS: TestListTarget (3.51s) +--- PASS: TestListTarget (0.93s) === RUN TestListTargetRestrictsDelegationPaths ---- PASS: TestListTargetRestrictsDelegationPaths (0.71s) +--- PASS: TestListTargetRestrictsDelegationPaths (0.17s) === RUN TestValidateRootKey ---- PASS: TestValidateRootKey (0.24s) +--- PASS: TestValidateRootKey (0.08s) === RUN TestGetChangelist ---- PASS: TestGetChangelist (0.19s) +--- PASS: TestGetChangelist (0.08s) === RUN TestPublishBareRepo ---- PASS: TestPublishBareRepo (1.61s) +--- PASS: TestPublishBareRepo (0.76s) === RUN TestPublishUninitializedRepo -time="2024-01-07T20:21:26Z" level=info msg="No TUF data found locally or remotely - initializing repository docker.com/notary for the first time" ---- PASS: TestPublishUninitializedRepo (0.12s) +time="2025-02-09T02:48:45Z" level=info msg="No TUF data found locally or remotely - initializing repository docker.com/notary for the first time" +--- PASS: TestPublishUninitializedRepo (0.06s) === RUN TestPublishClientHasSnapshotKey ---- PASS: TestPublishClientHasSnapshotKey (1.61s) +--- PASS: TestPublishClientHasSnapshotKey (0.79s) === RUN TestPublishAfterInitServerHasSnapshotKey ---- PASS: TestPublishAfterInitServerHasSnapshotKey (1.82s) +--- PASS: TestPublishAfterInitServerHasSnapshotKey (0.75s) === RUN TestPublishAfterPullServerHasSnapshotKey ---- PASS: TestPublishAfterPullServerHasSnapshotKey (0.68s) +--- PASS: TestPublishAfterPullServerHasSnapshotKey (0.25s) === RUN TestPublishNoOneHasSnapshotKey ---- PASS: TestPublishNoOneHasSnapshotKey (0.31s) +--- PASS: TestPublishNoOneHasSnapshotKey (0.15s) === RUN TestPublishSnapshotCorrupt ---- PASS: TestPublishSnapshotCorrupt (0.97s) +--- PASS: TestPublishSnapshotCorrupt (0.45s) === RUN TestPublishTargetsCorrupt ---- PASS: TestPublishTargetsCorrupt (0.55s) +--- PASS: TestPublishTargetsCorrupt (0.25s) === RUN TestPublishRootCorrupt -time="2024-01-07T20:21:32Z" level=error msg="Could not publish Repository since we could not update: invalid character 'h' in literal true (expecting 'r')" -time="2024-01-07T20:21:32Z" level=error msg="Could not publish Repository since we could not update: invalid character 'h' in literal true (expecting 'r')" ---- PASS: TestPublishRootCorrupt (0.52s) +time="2025-02-09T02:48:48Z" level=error msg="Could not publish Repository since we could not update: invalid character 'h' in literal true (expecting 'r')" +time="2025-02-09T02:48:48Z" level=error msg="Could not publish Repository since we could not update: invalid character 'h' in literal true (expecting 'r')" +--- PASS: TestPublishRootCorrupt (0.16s) === RUN TestPublishSnapshotLocalKeysCreatedFirst ---- PASS: TestPublishSnapshotLocalKeysCreatedFirst (0.03s) +--- PASS: TestPublishSnapshotLocalKeysCreatedFirst (0.01s) === RUN TestPublishDelegations ---- PASS: TestPublishDelegations (0.90s) +--- PASS: TestPublishDelegations (0.35s) === RUN TestPublishDelegationsX509 ---- PASS: TestPublishDelegationsX509 (0.66s) +--- PASS: TestPublishDelegationsX509 (0.32s) === RUN TestPublishTargetsDelegationScopeFailIfNoKeys -time="2024-01-07T20:21:34Z" level=error msg="couldn't add target to targets/a/b: tuf: invalid role targets/a/b. delegation does not exist" -time="2024-01-07T20:21:35Z" level=error msg="couldn't add target to targets/a/b: tuf: invalid role targets/a/b. delegation does not exist" ---- PASS: TestPublishTargetsDelegationScopeFailIfNoKeys (0.70s) +time="2025-02-09T02:48:48Z" level=error msg="couldn't add target to targets/a/b: tuf: invalid role targets/a/b. delegation does not exist" +time="2025-02-09T02:48:49Z" level=error msg="couldn't add target to targets/a/b: tuf: invalid role targets/a/b. delegation does not exist" +--- PASS: TestPublishTargetsDelegationScopeFailIfNoKeys (0.28s) === RUN TestPublishTargetsDelegationSuccessLocallyHasRoles ---- PASS: TestPublishTargetsDelegationSuccessLocallyHasRoles (1.02s) +--- PASS: TestPublishTargetsDelegationSuccessLocallyHasRoles (0.29s) === RUN TestPublishTargetsDelegationNoTargetsKeyNeeded ---- PASS: TestPublishTargetsDelegationNoTargetsKeyNeeded (0.68s) +--- PASS: TestPublishTargetsDelegationNoTargetsKeyNeeded (0.34s) === RUN TestPublishTargetsDelegationSuccessNeedsToDownloadRoles ---- PASS: TestPublishTargetsDelegationSuccessNeedsToDownloadRoles (0.65s) +--- PASS: TestPublishTargetsDelegationSuccessNeedsToDownloadRoles (0.37s) === RUN TestPublishTargetsDelegationFromTwoRepos ---- PASS: TestPublishTargetsDelegationFromTwoRepos (0.64s) +--- PASS: TestPublishTargetsDelegationFromTwoRepos (0.34s) === RUN TestPublishRemoveDelegationKeyFromDelegationRole -time="2024-01-07T20:21:38Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2024-01-07T20:21:38Z" 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: bc603422ef10958599e654c048c2ca9c78f161ddf450564120d5311fe14ece24" ---- PASS: TestPublishRemoveDelegationKeyFromDelegationRole (0.45s) +time="2025-02-09T02:48:50Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2025-02-09T02:48:50Z" 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: 3a199fb5b73797b38504d341d4325cb28b9c2675a3aa4e59f84d4475a305d961" +--- PASS: TestPublishRemoveDelegationKeyFromDelegationRole (0.22s) === RUN TestPublishRemoveDelegation -time="2024-01-07T20:21:39Z" 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-07T20:21:39Z" 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-07T20:21:39Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2024-01-07T20:21:39Z" 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.55s) +time="2025-02-09T02:48:50Z" 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-09T02:48:50Z" 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-09T02:48:50Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2025-02-09T02:48:50Z" 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.18s) === RUN TestPublishSucceedsDespiteDelegationCorrupt ---- PASS: TestPublishSucceedsDespiteDelegationCorrupt (0.61s) +--- PASS: TestPublishSucceedsDespiteDelegationCorrupt (0.25s) === RUN TestRotateKeyInvalidRole ---- PASS: TestRotateKeyInvalidRole (0.20s) +--- PASS: TestRotateKeyInvalidRole (0.12s) === RUN TestRemoteRotationError ---- PASS: TestRemoteRotationError (0.05s) +--- PASS: TestRemoteRotationError (0.03s) === RUN TestRemoteRotationEndpointError ---- PASS: TestRemoteRotationEndpointError (0.13s) +--- PASS: TestRemoteRotationEndpointError (0.08s) === RUN TestRemoteRotationNoRootKey ---- PASS: TestRemoteRotationNoRootKey (0.22s) +--- PASS: TestRemoteRotationNoRootKey (0.11s) === RUN TestRemoteRotationNoInit -time="2024-01-07T20:21:40Z" level=info msg="No TUF data found locally or remotely - initializing repository docker.com/notary for the first time" ---- PASS: TestRemoteRotationNoInit (0.14s) +time="2025-02-09T02:48:51Z" level=info msg="No TUF data found locally or remotely - initializing repository docker.com/notary for the first time" +--- PASS: TestRemoteRotationNoInit (0.07s) === RUN TestRotateBeforePublishFromRemoteKeyToLocalKey ---- PASS: TestRotateBeforePublishFromRemoteKeyToLocalKey (0.67s) +--- PASS: TestRotateBeforePublishFromRemoteKeyToLocalKey (0.36s) === RUN TestRotateKeyAfterPublishNoServerManagementChange ---- PASS: TestRotateKeyAfterPublishNoServerManagementChange (2.05s) +--- PASS: TestRotateKeyAfterPublishNoServerManagementChange (1.05s) === RUN TestRotateKeyAfterPublishServerManagementChange ---- PASS: TestRotateKeyAfterPublishServerManagementChange (2.54s) +--- PASS: TestRotateKeyAfterPublishServerManagementChange (1.15s) === RUN TestRotateRootKey ---- PASS: TestRotateRootKey (0.77s) +--- PASS: TestRotateRootKey (0.34s) === RUN TestRotateRootMultiple ---- PASS: TestRotateRootMultiple (0.93s) +--- PASS: TestRotateRootMultiple (0.46s) === RUN TestRotateRootKeyProvided ---- PASS: TestRotateRootKeyProvided (0.69s) +--- PASS: TestRotateRootKeyProvided (0.34s) === RUN TestRotateRootKeyLegacySupport ---- PASS: TestRotateRootKeyLegacySupport (0.97s) +--- PASS: TestRotateRootKeyLegacySupport (0.50s) === RUN TestRemoteServerUnavailableNoLocalCache -time="2024-01-07T20:21:49Z" level=error msg="Could not publish Repository since we could not update: unable to reach trust server at this time: 500." +time="2025-02-09T02:48:55Z" level=error msg="Could not publish Repository since we could not update: unable to reach trust server at this time: 500." --- PASS: TestRemoteServerUnavailableNoLocalCache (0.00s) === RUN TestAddDelegationChangefileValid ---- PASS: TestAddDelegationChangefileValid (0.07s) +--- PASS: TestAddDelegationChangefileValid (0.04s) === RUN TestAddDelegationChangefileApplicable ---- PASS: TestAddDelegationChangefileApplicable (0.06s) +--- PASS: TestAddDelegationChangefileApplicable (0.04s) === RUN TestAddDelegationErrorWritingChanges ---- PASS: TestAddDelegationErrorWritingChanges (0.07s) +--- PASS: TestAddDelegationErrorWritingChanges (0.03s) === RUN TestRemoveDelegationChangefileValid ---- PASS: TestRemoveDelegationChangefileValid (0.06s) +--- PASS: TestRemoveDelegationChangefileValid (0.03s) === RUN TestRemoveDelegationChangefileApplicable -time="2024-01-07T20:21:49Z" level=warning msg="role targets/a has fewer keys than its threshold of 1; it will not be usable until keys are added to it" -time="2024-01-07T20:21:49Z" level=warning msg="role targets/a has fewer keys than its threshold of 1; it will not be usable until keys are added to it" ---- PASS: TestRemoveDelegationChangefileApplicable (0.06s) +time="2025-02-09T02:48: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-09T02:48:55Z" level=warning msg="role targets/a has fewer keys than its threshold of 1; it will not be usable until keys are added to it" +--- PASS: TestRemoveDelegationChangefileApplicable (0.04s) === RUN TestClearAllPathsDelegationChangefileApplicable ---- PASS: TestClearAllPathsDelegationChangefileApplicable (0.07s) +--- PASS: TestClearAllPathsDelegationChangefileApplicable (0.04s) === RUN TestFullAddDelegationChangefileApplicable ---- PASS: TestFullAddDelegationChangefileApplicable (0.07s) +--- PASS: TestFullAddDelegationChangefileApplicable (0.04s) === RUN TestFullRemoveDelegationChangefileApplicable ---- PASS: TestFullRemoveDelegationChangefileApplicable (0.07s) +--- PASS: TestFullRemoveDelegationChangefileApplicable (0.04s) === RUN TestRemoveDelegationErrorWritingChanges ---- PASS: TestRemoveDelegationErrorWritingChanges (0.07s) +--- PASS: TestRemoveDelegationErrorWritingChanges (0.04s) === RUN TestClientInvalidURL --- PASS: TestClientInvalidURL (0.00s) === RUN TestPublishTargetsDelegationCanUseUserKeyWithArbitraryRole ---- PASS: TestPublishTargetsDelegationCanUseUserKeyWithArbitraryRole (1.22s) +--- PASS: TestPublishTargetsDelegationCanUseUserKeyWithArbitraryRole (0.63s) === RUN TestDeleteRepo ---- PASS: TestDeleteRepo (0.12s) +--- PASS: TestDeleteRepo (0.07s) === RUN TestDeleteRemoteRepo ---- PASS: TestDeleteRemoteRepo (0.38s) +--- PASS: TestDeleteRemoteRepo (0.19s) === RUN TestListRoles ---- PASS: TestListRoles (0.91s) +--- PASS: TestListRoles (0.47s) === RUN TestGetAllTargetInfo ---- PASS: TestGetAllTargetInfo (0.54s) +--- PASS: TestGetAllTargetInfo (0.29s) === RUN TestUpdateSucceedsEvenIfCannotWriteNewRepo -time="2024-01-07T20:21:53Z" level=error msg="could not save root to cache: Non-writable" ---- PASS: TestUpdateSucceedsEvenIfCannotWriteNewRepo (0.41s) +time="2025-02-09T02:48:57Z" level=error msg="could not save root to cache: Non-writable" +--- PASS: TestUpdateSucceedsEvenIfCannotWriteNewRepo (0.23s) === RUN TestUpdateSucceedsEvenIfCannotWriteExistingRepo ---- PASS: TestUpdateSucceedsEvenIfCannotWriteExistingRepo (1.94s) +--- PASS: TestUpdateSucceedsEvenIfCannotWriteExistingRepo (1.02s) === RUN TestUpdateInOfflineMode -time="2024-01-07T20:21:55Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" -time="2024-01-07T20:21:55Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" ---- PASS: TestUpdateInOfflineMode (0.20s) +time="2025-02-09T02:48:58Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" +time="2025-02-09T02:48:59Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" +--- PASS: TestUpdateInOfflineMode (0.10s) === RUN TestUpdateReplacesCorruptOrMissingMetadata -time="2024-01-07T20:21:59Z" level=error msg="Metadata for root expired" -time="2024-01-07T20:21:59Z" level=error msg="Metadata for root expired" ---- PASS: TestUpdateReplacesCorruptOrMissingMetadata (3.92s) +time="2025-02-09T02:49:00Z" level=error msg="Metadata for root expired" +time="2025-02-09T02:49:00Z" level=error msg="Metadata for root expired" +--- PASS: TestUpdateReplacesCorruptOrMissingMetadata (2.07s) === RUN TestUpdateFailsIfServerRootKeyChangedWithoutMultiSign -time="2024-01-07T20:21:59Z" level=error msg="Metadata for root expired" -time="2024-01-07T20:21:59Z" level=error msg="Metadata for root expired" ---- PASS: TestUpdateFailsIfServerRootKeyChangedWithoutMultiSign (0.36s) +time="2025-02-09T02:49:01Z" level=error msg="Metadata for root expired" +time="2025-02-09T02:49:01Z" level=error msg="Metadata for root expired" +--- PASS: TestUpdateFailsIfServerRootKeyChangedWithoutMultiSign (0.18s) === RUN TestUpdateRemoteRootNotExistNoLocalCache ---- PASS: TestUpdateRemoteRootNotExistNoLocalCache (0.19s) +--- PASS: TestUpdateRemoteRootNotExistNoLocalCache (0.10s) === RUN TestUpdateRemoteRootNotExistCanUseLocalCache ---- PASS: TestUpdateRemoteRootNotExistCanUseLocalCache (0.34s) +--- PASS: TestUpdateRemoteRootNotExistCanUseLocalCache (0.19s) === RUN TestUpdateRemoteRootNotExistCannotUseLocalCache ---- PASS: TestUpdateRemoteRootNotExistCannotUseLocalCache (0.36s) +--- PASS: TestUpdateRemoteRootNotExistCannotUseLocalCache (0.20s) === RUN TestUpdateRemoteRoot50XNoLocalCache ---- PASS: TestUpdateRemoteRoot50XNoLocalCache (0.18s) +--- PASS: TestUpdateRemoteRoot50XNoLocalCache (0.10s) === RUN TestUpdateRemoteRoot50XCanUseLocalCache ---- PASS: TestUpdateRemoteRoot50XCanUseLocalCache (0.36s) +--- PASS: TestUpdateRemoteRoot50XCanUseLocalCache (0.19s) === RUN TestUpdateRemoteRoot50XCannotUseLocalCache ---- PASS: TestUpdateRemoteRoot50XCannotUseLocalCache (0.37s) +--- PASS: TestUpdateRemoteRoot50XCannotUseLocalCache (0.20s) === RUN TestUpdateNonRootRemoteMissingMetadataNoLocalCache ---- PASS: TestUpdateNonRootRemoteMissingMetadataNoLocalCache (0.88s) +--- PASS: TestUpdateNonRootRemoteMissingMetadataNoLocalCache (0.47s) === RUN TestUpdateNonRootRemoteMissingMetadataCanUseLocalCache -time="2024-01-07T20:22:02Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" ---- PASS: TestUpdateNonRootRemoteMissingMetadataCanUseLocalCache (1.23s) +time="2025-02-09T02:49:03Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" +--- PASS: TestUpdateNonRootRemoteMissingMetadataCanUseLocalCache (0.62s) === RUN TestUpdateNonRootRemoteMissingMetadataCannotUseLocalCache -time="2024-01-07T20:22:04Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" ---- PASS: TestUpdateNonRootRemoteMissingMetadataCannotUseLocalCache (1.41s) +time="2025-02-09T02:49:03Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" +--- PASS: TestUpdateNonRootRemoteMissingMetadataCannotUseLocalCache (0.74s) === RUN TestUpdateNonRootRemote50XNoLocalCache ---- PASS: TestUpdateNonRootRemote50XNoLocalCache (0.91s) +--- PASS: TestUpdateNonRootRemote50XNoLocalCache (0.47s) === RUN TestUpdateNonRootRemote50XCanUseLocalCache -time="2024-01-07T20:22:06Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" ---- PASS: TestUpdateNonRootRemote50XCanUseLocalCache (1.25s) +time="2025-02-09T02:49:04Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" +--- PASS: TestUpdateNonRootRemote50XCanUseLocalCache (0.62s) === RUN TestUpdateNonRootRemote50XCannotUseLocalCache -time="2024-01-07T20:22:07Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" ---- PASS: TestUpdateNonRootRemote50XCannotUseLocalCache (1.31s) +time="2025-02-09T02:49:05Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" +--- PASS: TestUpdateNonRootRemote50XCannotUseLocalCache (0.74s) === RUN TestUpdateRemoteChecksumWrongNoLocalCache ---- PASS: TestUpdateRemoteChecksumWrongNoLocalCache (0.98s) +--- PASS: TestUpdateRemoteChecksumWrongNoLocalCache (0.60s) === RUN TestUpdateRemoteChecksumWrongCanUseLocalCache ---- PASS: TestUpdateRemoteChecksumWrongCanUseLocalCache (1.35s) +--- PASS: TestUpdateRemoteChecksumWrongCanUseLocalCache (0.83s) === RUN TestUpdateRemoteChecksumWrongCannotUseLocalCache ---- PASS: TestUpdateRemoteChecksumWrongCannotUseLocalCache (1.63s) +--- PASS: TestUpdateRemoteChecksumWrongCannotUseLocalCache (1.01s) === RUN TestUpdateRootRemoteCorruptedNoLocalCache -time="2024-01-07T20:22:14Z" level=error msg="Metadata for root expired" -time="2024-01-07T20:22:14Z" level=error msg="Metadata for root expired" ---- PASS: TestUpdateRootRemoteCorruptedNoLocalCache (3.25s) +time="2025-02-09T02:49:09Z" level=error msg="Metadata for root expired" +time="2025-02-09T02:49:09Z" level=error msg="Metadata for root expired" +--- PASS: TestUpdateRootRemoteCorruptedNoLocalCache (1.93s) === RUN TestUpdateRootRemoteCorruptedCanUseLocalCache ---- PASS: TestUpdateRootRemoteCorruptedCanUseLocalCache (6.00s) +--- PASS: TestUpdateRootRemoteCorruptedCanUseLocalCache (3.58s) === RUN TestUpdateRootRemoteCorruptedCannotUseLocalCache -time="2024-01-07T20:22:25Z" level=error msg="Metadata for root expired" -time="2024-01-07T20:22:25Z" level=error msg="Metadata for root expired" ---- PASS: TestUpdateRootRemoteCorruptedCannotUseLocalCache (7.29s) +time="2025-02-09T02:49:15Z" level=error msg="Metadata for root expired" +time="2025-02-09T02:49:15Z" level=error msg="Metadata for root expired" +--- PASS: TestUpdateRootRemoteCorruptedCannotUseLocalCache (3.84s) === RUN TestUpdateNonRootRemoteCorruptedNoLocalCache -time="2024-01-07T20:22:30Z" level=error msg="Metadata for targets expired" -time="2024-01-07T20:22:30Z" level=error msg="Metadata for targets expired" -time="2024-01-07T20:22:31Z" level=error msg="Metadata for snapshot expired" -time="2024-01-07T20:22:31Z" level=error msg="Metadata for snapshot expired" -time="2024-01-07T20:22:32Z" level=error msg="Metadata for timestamp expired" -time="2024-01-07T20:22:32Z" level=error msg="Metadata for timestamp expired" -time="2024-01-07T20:22:33Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2024-01-07T20:22:33Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2024-01-07T20:22:34Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2024-01-07T20:22:34Z" level=error msg="Metadata for targets/a expired" -time="2024-01-07T20:22:34Z" level=warning msg="Error getting targets/a: targets/a expired at Tue Dec 6 20:22:34 UTC 2022" -time="2024-01-07T20:22:35Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" -time="2024-01-07T20:22:35Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" -time="2024-01-07T20:22:35Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" -time="2024-01-07T20:22:35Z" level=error msg="Metadata for targets/a/b expired" -time="2024-01-07T20:22:35Z" level=warning msg="Error getting targets/a/b: targets/a/b expired at Tue Dec 6 20:22:35 UTC 2022" -time="2024-01-07T20:22:36Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" -time="2024-01-07T20:22:37Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" -time="2024-01-07T20:22:37Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" -time="2024-01-07T20:22:37Z" level=error msg="Metadata for targets/b expired" -time="2024-01-07T20:22:37Z" level=warning msg="Error getting targets/b: targets/b expired at Tue Dec 6 20:22:37 UTC 2022" ---- PASS: TestUpdateNonRootRemoteCorruptedNoLocalCache (9.07s) +time="2025-02-09T02:49:18Z" level=error msg="Metadata for targets expired" +time="2025-02-09T02:49:18Z" level=error msg="Metadata for targets expired" +time="2025-02-09T02:49:19Z" level=error msg="Metadata for snapshot expired" +time="2025-02-09T02:49:19Z" level=error msg="Metadata for snapshot expired" +time="2025-02-09T02:49:19Z" level=error msg="Metadata for timestamp expired" +time="2025-02-09T02:49:19Z" level=error msg="Metadata for timestamp expired" +time="2025-02-09T02:49:20Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2025-02-09T02:49:20Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2025-02-09T02:49:20Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2025-02-09T02:49:20Z" level=error msg="Metadata for targets/a expired" +time="2025-02-09T02:49:20Z" level=warning msg="Error getting targets/a: targets/a expired at Mon Jan 8 02:49:20 UTC 2024" +time="2025-02-09T02:49:20Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" +time="2025-02-09T02:49:21Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" +time="2025-02-09T02:49:21Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" +time="2025-02-09T02:49:21Z" level=error msg="Metadata for targets/a/b expired" +time="2025-02-09T02:49:21Z" level=warning msg="Error getting targets/a/b: targets/a/b expired at Mon Jan 8 02:49:21 UTC 2024" +time="2025-02-09T02:49:21Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" +time="2025-02-09T02:49:21Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" +time="2025-02-09T02:49:21Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" +time="2025-02-09T02:49:22Z" level=error msg="Metadata for targets/b expired" +time="2025-02-09T02:49:22Z" level=warning msg="Error getting targets/b: targets/b expired at Mon Jan 8 02:49:21 UTC 2024" +--- PASS: TestUpdateNonRootRemoteCorruptedNoLocalCache (4.71s) === RUN TestUpdateNonRootRemoteCorruptedCanUseLocalCache -time="2024-01-07T20:22:43Z" level=error msg="Metadata for timestamp expired" -time="2024-01-07T20:22:43Z" level=error msg="Metadata for timestamp expired" ---- PASS: TestUpdateNonRootRemoteCorruptedCanUseLocalCache (11.17s) +time="2025-02-09T02:49:25Z" level=error msg="Metadata for timestamp expired" +time="2025-02-09T02:49:25Z" level=error msg="Metadata for timestamp expired" +--- PASS: TestUpdateNonRootRemoteCorruptedCanUseLocalCache (6.12s) === RUN TestUpdateNonRootRemoteCorruptedCannotUseLocalCache -time="2024-01-07T20:22:51Z" level=error msg="Metadata for targets expired" -time="2024-01-07T20:22:53Z" level=error msg="Metadata for snapshot expired" -time="2024-01-07T20:22:53Z" level=error msg="Metadata for snapshot expired" -time="2024-01-07T20:22:55Z" level=error msg="Metadata for timestamp expired" -time="2024-01-07T20:22:55Z" level=error msg="Metadata for timestamp expired" -time="2024-01-07T20:22:56Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2024-01-07T20:22:56Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2024-01-07T20:22:57Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2024-01-07T20:22:57Z" level=error msg="Metadata for targets/a expired" -time="2024-01-07T20:22:57Z" level=warning msg="Error getting targets/a: targets/a expired at Tue Dec 6 20:22:57 UTC 2022" -time="2024-01-07T20:22:58Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" -time="2024-01-07T20:22:59Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" -time="2024-01-07T20:22:59Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" -time="2024-01-07T20:22:59Z" level=error msg="Metadata for targets/a/b expired" -time="2024-01-07T20:22:59Z" level=warning msg="Error getting targets/a/b: targets/a/b expired at Tue Dec 6 20:22:59 UTC 2022" -time="2024-01-07T20:23:01Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" -time="2024-01-07T20:23:01Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" -time="2024-01-07T20:23:02Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" -time="2024-01-07T20:23:02Z" level=error msg="Metadata for targets/b expired" -time="2024-01-07T20:23:02Z" level=warning msg="Error getting targets/b: targets/b expired at Tue Dec 6 20:23:02 UTC 2022" ---- PASS: TestUpdateNonRootRemoteCorruptedCannotUseLocalCache (14.40s) +time="2025-02-09T02:49:29Z" level=error msg="Metadata for targets expired" +time="2025-02-09T02:49:30Z" level=error msg="Metadata for snapshot expired" +time="2025-02-09T02:49:30Z" level=error msg="Metadata for snapshot expired" +time="2025-02-09T02:49:31Z" level=error msg="Metadata for timestamp expired" +time="2025-02-09T02:49:31Z" level=error msg="Metadata for timestamp expired" +time="2025-02-09T02:49:32Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2025-02-09T02:49:32Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2025-02-09T02:49:32Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2025-02-09T02:49:32Z" level=error msg="Metadata for targets/a expired" +time="2025-02-09T02:49:32Z" level=warning msg="Error getting targets/a: targets/a expired at Mon Jan 8 02:49:32 UTC 2024" +time="2025-02-09T02:49:33Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" +time="2025-02-09T02:49:33Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" +time="2025-02-09T02:49:34Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" +time="2025-02-09T02:49:34Z" level=error msg="Metadata for targets/a/b expired" +time="2025-02-09T02:49:34Z" level=warning msg="Error getting targets/a/b: targets/a/b expired at Mon Jan 8 02:49:34 UTC 2024" +time="2025-02-09T02:49:35Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" +time="2025-02-09T02:49:35Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" +time="2025-02-09T02:49:35Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" +time="2025-02-09T02:49:35Z" level=error msg="Metadata for targets/b expired" +time="2025-02-09T02:49:35Z" level=warning msg="Error getting targets/b: targets/b expired at Mon Jan 8 02:49:35 UTC 2024" +--- PASS: TestUpdateNonRootRemoteCorruptedCannotUseLocalCache (7.59s) === RUN TestUpdateLocalAndRemoteRootCorrupt -time="2024-01-07T20:23:08Z" level=error msg="Metadata for root expired" -time="2024-01-07T20:23:09Z" level=error msg="Metadata for root expired" -time="2024-01-07T20:23:14Z" level=error msg="Metadata for root expired" -time="2024-01-07T20:23:14Z" level=error msg="Metadata for root expired" -time="2024-01-07T20:23:14Z" level=error msg="Metadata for root expired" -time="2024-01-07T20:23:15Z" level=error msg="Metadata for root expired" -time="2024-01-07T20:23:15Z" level=error msg="Metadata for root expired" -time="2024-01-07T20:23:15Z" level=error msg="Metadata for root expired" -time="2024-01-07T20:23:15Z" level=error msg="Metadata for root expired" -time="2024-01-07T20:23:15Z" level=error msg="Metadata for root expired" -time="2024-01-07T20:23:15Z" level=error msg="Metadata for root expired" -time="2024-01-07T20:23:16Z" level=error msg="Metadata for root expired" -time="2024-01-07T20:23:16Z" level=error msg="Metadata for root expired" -time="2024-01-07T20:23:16Z" level=error msg="Metadata for root expired" -time="2024-01-07T20:23:16Z" level=error msg="Metadata for root expired" -time="2024-01-07T20:23:16Z" level=error msg="Metadata for root expired" -time="2024-01-07T20:23:16Z" level=error msg="Metadata for root expired" -time="2024-01-07T20:23:17Z" level=error msg="Metadata for root expired" -time="2024-01-07T20:23:17Z" level=error msg="Metadata for root expired" -time="2024-01-07T20:23:17Z" level=error msg="Metadata for root expired" -time="2024-01-07T20:23:17Z" level=error msg="Metadata for root expired" -time="2024-01-07T20:23:17Z" level=error msg="Metadata for root expired" ---- PASS: TestUpdateLocalAndRemoteRootCorrupt (13.80s) +time="2025-02-09T02:49:39Z" level=error msg="Metadata for root expired" +time="2025-02-09T02:49:39Z" level=error msg="Metadata for root expired" +time="2025-02-09T02:49:42Z" level=error msg="Metadata for root expired" +time="2025-02-09T02:49:42Z" level=error msg="Metadata for root expired" +time="2025-02-09T02:49:42Z" level=error msg="Metadata for root expired" +time="2025-02-09T02:49:43Z" level=error msg="Metadata for root expired" +time="2025-02-09T02:49:43Z" level=error msg="Metadata for root expired" +time="2025-02-09T02:49:43Z" level=error msg="Metadata for root expired" +time="2025-02-09T02:49:43Z" level=error msg="Metadata for root expired" +time="2025-02-09T02:49:43Z" level=error msg="Metadata for root expired" +time="2025-02-09T02:49:43Z" level=error msg="Metadata for root expired" +time="2025-02-09T02:49:43Z" level=error msg="Metadata for root expired" +time="2025-02-09T02:49:43Z" level=error msg="Metadata for root expired" +time="2025-02-09T02:49:43Z" level=error msg="Metadata for root expired" +time="2025-02-09T02:49:43Z" level=error msg="Metadata for root expired" +time="2025-02-09T02:49:44Z" level=error msg="Metadata for root expired" +time="2025-02-09T02:49:44Z" level=error msg="Metadata for root expired" +time="2025-02-09T02:49:44Z" level=error msg="Metadata for root expired" +time="2025-02-09T02:49:44Z" level=error msg="Metadata for root expired" +time="2025-02-09T02:49:44Z" level=error msg="Metadata for root expired" +time="2025-02-09T02:49:44Z" level=error msg="Metadata for root expired" +time="2025-02-09T02:49:44Z" level=error msg="Metadata for root expired" +--- PASS: TestUpdateLocalAndRemoteRootCorrupt (8.34s) === RUN TestUpdateRemoteKeyRotated -time="2024-01-07T20:23:18Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2024-01-07T20:23:18Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" -time="2024-01-07T20:23:18Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" ---- PASS: TestUpdateRemoteKeyRotated (1.31s) +time="2025-02-09T02:49:45Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2025-02-09T02:49:45Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" +time="2025-02-09T02:49:45Z" 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.63s) +--- PASS: TestValidateRootRotationWithOldRole (0.37s) === RUN TestRootRoleInvariant ---- PASS: TestRootRoleInvariant (0.54s) +--- PASS: TestRootRoleInvariant (0.32s) === RUN TestBadIntermediateTransitions ---- PASS: TestBadIntermediateTransitions (0.21s) +--- PASS: TestBadIntermediateTransitions (0.13s) === RUN TestExpiredIntermediateTransitions -time="2024-01-07T20:23:20Z" level=warning msg="root is nearing expiry, you should re-sign the role metadata" ---- PASS: TestExpiredIntermediateTransitions (0.28s) +time="2025-02-09T02:49:46Z" level=warning msg="root is nearing expiry, you should re-sign the role metadata" +--- PASS: TestExpiredIntermediateTransitions (0.16s) === RUN TestDownloadTargetsLarge ---- PASS: TestDownloadTargetsLarge (6.39s) +--- PASS: TestDownloadTargetsLarge (3.34s) === RUN TestDownloadTargetsDeep ---- PASS: TestDownloadTargetsDeep (0.20s) +--- PASS: TestDownloadTargetsDeep (0.11s) === RUN TestDownloadSnapshotLargeDelegationsMany ---- PASS: TestDownloadSnapshotLargeDelegationsMany (6.41s) +--- PASS: TestDownloadSnapshotLargeDelegationsMany (3.46s) === RUN TestRootOnDiskTrustPinning ---- PASS: TestRootOnDiskTrustPinning (0.15s) +--- PASS: TestRootOnDiskTrustPinning (0.08s) === RUN TestLoadTUFRepoBadURL --- PASS: TestLoadTUFRepoBadURL (0.00s) === RUN TestApplyTargetsChange ---- PASS: TestApplyTargetsChange (0.02s) +--- PASS: TestApplyTargetsChange (0.01s) === RUN TestApplyAddTargetTwice ---- PASS: TestApplyAddTargetTwice (0.02s) +--- PASS: TestApplyAddTargetTwice (0.01s) === RUN TestApplyChangelist ---- PASS: TestApplyChangelist (0.02s) +--- PASS: TestApplyChangelist (0.01s) === RUN TestApplyChangelistMulti ---- PASS: TestApplyChangelistMulti (0.02s) +--- PASS: TestApplyChangelistMulti (0.01s) === RUN TestApplyTargetsDelegationCreateDelete ---- PASS: TestApplyTargetsDelegationCreateDelete (0.02s) +--- PASS: TestApplyTargetsDelegationCreateDelete (0.01s) === RUN TestApplyTargetsDelegationCreate2SharedKey ---- PASS: TestApplyTargetsDelegationCreate2SharedKey (0.02s) +--- PASS: TestApplyTargetsDelegationCreate2SharedKey (0.01s) === RUN TestApplyTargetsDelegationCreateEdit ---- PASS: TestApplyTargetsDelegationCreateEdit (0.02s) +--- PASS: TestApplyTargetsDelegationCreateEdit (0.01s) === RUN TestApplyTargetsDelegationEditNonExisting ---- PASS: TestApplyTargetsDelegationEditNonExisting (0.02s) +--- PASS: TestApplyTargetsDelegationEditNonExisting (0.01s) === RUN TestApplyTargetsDelegationCreateAlreadyExisting ---- PASS: TestApplyTargetsDelegationCreateAlreadyExisting (0.02s) +--- PASS: TestApplyTargetsDelegationCreateAlreadyExisting (0.01s) === RUN TestApplyTargetsDelegationAlreadyExistingMergePaths ---- PASS: TestApplyTargetsDelegationAlreadyExistingMergePaths (0.02s) +--- PASS: TestApplyTargetsDelegationAlreadyExistingMergePaths (0.01s) === RUN TestApplyTargetsDelegationInvalidRole ---- PASS: TestApplyTargetsDelegationInvalidRole (0.02s) +--- PASS: TestApplyTargetsDelegationInvalidRole (0.01s) === RUN TestApplyTargetsDelegationInvalidJSONContent ---- PASS: TestApplyTargetsDelegationInvalidJSONContent (0.02s) +--- PASS: TestApplyTargetsDelegationInvalidJSONContent (0.01s) === RUN TestApplyTargetsDelegationInvalidAction ---- PASS: TestApplyTargetsDelegationInvalidAction (0.02s) +--- PASS: TestApplyTargetsDelegationInvalidAction (0.01s) === RUN TestApplyTargetsChangeInvalidType ---- PASS: TestApplyTargetsChangeInvalidType (0.02s) +--- PASS: TestApplyTargetsChangeInvalidType (0.01s) === RUN TestApplyTargetsDelegationCreate2Deep ---- PASS: TestApplyTargetsDelegationCreate2Deep (0.02s) +--- PASS: TestApplyTargetsDelegationCreate2Deep (0.01s) === RUN TestApplyTargetsDelegationParentDoesntExist ---- PASS: TestApplyTargetsDelegationParentDoesntExist (0.02s) +--- PASS: TestApplyTargetsDelegationParentDoesntExist (0.01s) === RUN TestApplyChangelistCreatesDelegation ---- PASS: TestApplyChangelistCreatesDelegation (0.02s) +--- PASS: TestApplyChangelistCreatesDelegation (0.01s) === RUN TestApplyChangelistTargetsToMultipleRoles ---- PASS: TestApplyChangelistTargetsToMultipleRoles (0.02s) +--- PASS: TestApplyChangelistTargetsToMultipleRoles (0.01s) === RUN TestApplyChangelistTargetsFailsNonexistentRole -time="2024-01-07T20:23:34Z" 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-07T20:23:34Z" level=error msg="couldn't remove target from targets/level1/level2/level3/level4: tuf: invalid role targets/level1/level2/level3/level4. delegation does not exist" ---- PASS: TestApplyChangelistTargetsFailsNonexistentRole (0.02s) +time="2025-02-09T02:49:53Z" 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-09T02:49:53Z" 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="2024-01-07T20:23:34Z" level=error msg="couldn't add target to ruhroh: tuf: invalid role ruhroh. does not exist" ---- PASS: TestChangeTargetMetaFailsInvalidRole (0.02s) +time="2025-02-09T02:49:53Z" level=error msg="couldn't add target to ruhroh: tuf: invalid role ruhroh. does not exist" +--- PASS: TestChangeTargetMetaFailsInvalidRole (0.01s) === RUN TestChangeTargetMetaFailsIfPrefixError -time="2024-01-07T20:23:34Z" level=error msg="couldn't add target to targets/level1: Could not add all targets" ---- PASS: TestChangeTargetMetaFailsIfPrefixError (0.02s) +time="2025-02-09T02:49:53Z" level=error msg="couldn't add target to targets/level1: Could not add all targets" +--- PASS: TestChangeTargetMetaFailsIfPrefixError (0.01s) === RUN TestAllNearExpiry ---- PASS: TestAllNearExpiry (0.02s) +--- PASS: TestAllNearExpiry (0.01s) === RUN TestAllNotNearExpiry ---- PASS: TestAllNotNearExpiry (0.02s) +--- PASS: TestAllNotNearExpiry (0.01s) === RUN TestRotateRemoteKeyOffline --- PASS: TestRotateRemoteKeyOffline (0.00s) PASS -ok github.com/theupdateframework/notary/client 141.694s +ok github.com/theupdateframework/notary/client 72.405s === RUN TestTUFDelegation ---- PASS: TestTUFDelegation (0.08s) +--- PASS: TestTUFDelegation (0.04s) === RUN TestMemChangelist --- PASS: TestMemChangelist (0.00s) === RUN TestMemChangeIterator @@ -2272,14 +2308,14 @@ === RUN TestAdd --- PASS: TestAdd (0.00s) === RUN TestErrorConditions -time="2024-01-07T20:21:04Z" level=warning msg="invalid character '\\x05' looking for beginning of value" +time="2025-02-09T02:48:37Z" level=warning msg="invalid character '\\x05' looking for beginning of value" --- PASS: TestErrorConditions (0.00s) === RUN TestListOrder --- PASS: TestListOrder (0.00s) === RUN TestFileChangeIterator ---- PASS: TestFileChangeIterator (0.01s) +--- PASS: TestFileChangeIterator (0.00s) PASS -ok github.com/theupdateframework/notary/client/changelist 0.127s +ok github.com/theupdateframework/notary/client/changelist 0.065s === RUN TestParseConfigError --- PASS: TestParseConfigError (0.00s) === RUN TestSetupGRPCServer @@ -2289,7 +2325,7 @@ === RUN TestSetupNetListener --- PASS: TestSetupNetListener (0.00s) PASS -ok github.com/theupdateframework/notary/cmd/escrow 0.068s +ok github.com/theupdateframework/notary/cmd/escrow 0.015s === RUN TestPurgeDelegationKeys Usage: delegation [command] @@ -2315,7 +2351,7 @@ - abc --- PASS: TestPurgeDelegationKeys (0.00s) === RUN TestAddInvalidDelegationName ---- PASS: TestAddInvalidDelegationName (0.03s) +--- PASS: TestAddInvalidDelegationName (0.01s) === RUN TestAddInvalidDelegationCert --- PASS: TestAddInvalidDelegationCert (0.01s) === RUN TestAddInvalidShortPubkeyCert @@ -2361,104 +2397,104 @@ Use "delegation [command] --help" for more information about a command. --- PASS: TestRemoveInvalidNumArgs (0.00s) === RUN TestInitWithRootKey ---- PASS: TestInitWithRootKey (0.56s) +--- PASS: TestInitWithRootKey (0.16s) === RUN TestInitWithRootCert ---- PASS: TestInitWithRootCert (0.52s) +--- PASS: TestInitWithRootCert (0.15s) === RUN TestClientTUFInteraction ---- PASS: TestClientTUFInteraction (1.33s) +--- PASS: TestClientTUFInteraction (0.39s) === RUN TestClientDeleteTUFInteraction -time="2024-01-07T20:21:16Z" 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]:43217->[::1]:53: read: connection refused" ---- PASS: TestClientDeleteTUFInteraction (1.45s) +time="2025-02-09T02:48:42Z" 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]:45730->[::1]:53: read: connection refused" +--- PASS: TestClientDeleteTUFInteraction (0.38s) === RUN TestClientTUFAddByHashInteraction ---- PASS: TestClientTUFAddByHashInteraction (2.95s) +--- PASS: TestClientTUFAddByHashInteraction (0.65s) === RUN TestClientDelegationsInteraction -time="2024-01-07T20:21:22Z" 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-07T20:21:22Z" 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 (4.76s) +time="2025-02-09T02:48:43Z" 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-09T02:48:43Z" 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 (1.55s) === RUN TestClientDelegationsPublishing ---- PASS: TestClientDelegationsPublishing (2.84s) +--- PASS: TestClientDelegationsPublishing (1.45s) === RUN TestClientKeyGenerationRotation ---- PASS: TestClientKeyGenerationRotation (4.76s) +--- PASS: TestClientKeyGenerationRotation (1.82s) === RUN TestKeyRotation ---- PASS: TestKeyRotation (0.72s) +--- PASS: TestKeyRotation (0.25s) === RUN TestKeyRotationNonRoot ---- PASS: TestKeyRotationNonRoot (0.80s) +--- PASS: TestKeyRotationNonRoot (0.40s) === RUN TestDefaultRootKeyGeneration --- PASS: TestDefaultRootKeyGeneration (0.01s) === RUN TestLogLevelFlags --- PASS: TestLogLevelFlags (0.00s) === RUN TestClientKeyPassphraseChange ---- PASS: TestClientKeyPassphraseChange (0.48s) +--- PASS: TestClientKeyPassphraseChange (0.28s) === RUN TestPurgeSingleKey Removal of the following keys from all delegations in gun staged for next publish: - - fc0db77b7909674dc7dfdee9548a0d6fb9299b23be3c516c379d72f1ee7c4733 ---- PASS: TestPurgeSingleKey (0.68s) + - 83c1d3459a6c02868e97339085f2051723bf6b80f2a1668849aa162cb3db0f17 +--- PASS: TestPurgeSingleKey (0.29s) === RUN TestWitness -time="2024-01-07T20:21:36Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" -time="2024-01-07T20:21:36Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" -time="2024-01-07T20:21:36Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" -time="2024-01-07T20:21:36Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" -time="2024-01-07T20:21:37Z" 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-07T20:21:37Z" 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-07T20:21:37Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" ---- PASS: TestWitness (1.79s) +time="2025-02-09T02:48:49Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" +time="2025-02-09T02:48:49Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" +time="2025-02-09T02:48:49Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" +time="2025-02-09T02:48:49Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" +time="2025-02-09T02:48:49Z" level=warning msg="role targets/delegation has fewer keys than its threshold of 1; it will not be usable until keys are added to it" +time="2025-02-09T02:48:49Z" level=warning msg="role targets/delegation has fewer keys than its threshold of 1; it will not be usable until keys are added to it" +time="2025-02-09T02:48:49Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" +--- PASS: TestWitness (0.85s) === RUN TestClientTUFInitWithAutoPublish -time="2024-01-07T20:21:37Z" 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]:43033->[::1]:53: read: connection refused" ---- PASS: TestClientTUFInitWithAutoPublish (0.34s) +time="2025-02-09T02:48:49Z" level=error msg="could not reach https://notary-server-on-the-moon:12306: Get \"https://notary-server-on-the-moon:12306/v2/\": dial tcp: lookup notary-server-on-the-moon on [::1]:53: read udp [::1]:54929->[::1]:53: read: connection refused" +--- PASS: TestClientTUFInitWithAutoPublish (0.20s) === RUN TestClientTUFAddWithAutoPublish -time="2024-01-07T20:21:37Z" 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]:41034->[::1]:53: read: connection refused" -time="2024-01-07T20:21:37Z" level=error msg="Could not publish Repository since we could not update: client is offline" -time="2024-01-07T20:21:37Z" 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]:41394->[::1]:53: read: connection refused" -time="2024-01-07T20:21:37Z" level=error msg="Could not publish Repository since we could not update: client is offline" ---- PASS: TestClientTUFAddWithAutoPublish (0.43s) +time="2025-02-09T02:48:50Z" 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]:54106->[::1]:53: read: connection refused" +time="2025-02-09T02:48:50Z" level=error msg="Could not publish Repository since we could not update: client is offline" +time="2025-02-09T02:48:50Z" 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]:51797->[::1]:53: read: connection refused" +time="2025-02-09T02:48:50Z" level=error msg="Could not publish Repository since we could not update: client is offline" +--- PASS: TestClientTUFAddWithAutoPublish (0.22s) === RUN TestClientTUFRemoveWithAutoPublish ---- PASS: TestClientTUFRemoveWithAutoPublish (1.09s) +--- PASS: TestClientTUFRemoveWithAutoPublish (0.48s) === RUN TestClientDelegationAddWithAutoPublish ---- PASS: TestClientDelegationAddWithAutoPublish (0.69s) +--- PASS: TestClientDelegationAddWithAutoPublish (0.24s) === RUN TestClientDelegationRemoveWithAutoPublish -time="2024-01-07T20:21:41Z" 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-07T20:21:41Z" 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 (1.41s) +time="2025-02-09T02:48:51Z" 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-09T02:48:51Z" 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.46s) === RUN TestClientTUFAddByHashWithAutoPublish ---- PASS: TestClientTUFAddByHashWithAutoPublish (0.69s) +--- PASS: TestClientTUFAddByHashWithAutoPublish (0.20s) === RUN TestClientKeyImport -time="2024-01-07T20:21:42Z" 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-07T20:21:42Z" 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.22s) +time="2025-02-09T02:48:51Z" 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-09T02:48:51Z" level=warning msg="failed to import key () to store: Cannot have canonical role key without a gun, don't know what gun it belongs to" +--- PASS: TestClientKeyImport (0.07s) === RUN TestAddDelImportKeyPublishFlow -time="2024-01-07T20:21:43Z" 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 (1.43s) +time="2025-02-09T02:48:52Z" 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.47s) === RUN TestExportImportFlow ---- PASS: TestExportImportFlow (0.32s) +--- PASS: TestExportImportFlow (0.12s) === RUN TestDelegationKeyImportExport --- PASS: TestDelegationKeyImportExport (0.01s) === RUN TestImportKeysNoYubikey ---- PASS: TestImportKeysNoYubikey (0.03s) +--- PASS: TestImportKeysNoYubikey (0.01s) === RUN TestExportImportKeysNoYubikey ---- PASS: TestExportImportKeysNoYubikey (0.04s) +--- PASS: TestExportImportKeysNoYubikey (0.01s) === RUN TestRemoveIfNoKey --- PASS: TestRemoveIfNoKey (0.00s) === RUN TestRemoveOneKeyAbort ---- PASS: TestRemoveOneKeyAbort (0.07s) +--- PASS: TestRemoveOneKeyAbort (0.02s) === RUN TestRemoveOneKeyConfirm ---- PASS: TestRemoveOneKeyConfirm (0.02s) +--- PASS: TestRemoveOneKeyConfirm (0.01s) === RUN TestRemoveMultikeysInvalidInput ---- PASS: TestRemoveMultikeysInvalidInput (0.02s) +--- PASS: TestRemoveMultikeysInvalidInput (0.01s) === RUN TestRemoveMultikeysAbortChoice ---- PASS: TestRemoveMultikeysAbortChoice (0.02s) +--- PASS: TestRemoveMultikeysAbortChoice (0.01s) === RUN TestRemoveMultikeysRemoveOnlyChosenKey ---- PASS: TestRemoveMultikeysRemoveOnlyChosenKey (0.02s) +--- PASS: TestRemoveMultikeysRemoveOnlyChosenKey (0.01s) === RUN TestRotateKeyInvalidRoles -time="2024-01-07T20:21:44Z" 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]:36807->[::1]:53: read: connection refused" -time="2024-01-07T20:21:44Z" 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]:51132->[::1]:53: read: connection refused" -time="2024-01-07T20:21:44Z" 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]:51320->[::1]:53: read: connection refused" -time="2024-01-07T20:21:44Z" 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]:37908->[::1]:53: read: connection refused" +time="2025-02-09T02:48:52Z" level=error msg="could not reach https://notary-server:4443: Get \"https://notary-server:4443/v2/\": dial tcp: lookup notary-server on [::1]:53: read udp [::1]:32896->[::1]:53: read: connection refused" +time="2025-02-09T02:48:52Z" level=error msg="could not reach https://notary-server:4443: Get \"https://notary-server:4443/v2/\": dial tcp: lookup notary-server on [::1]:53: read udp [::1]:60590->[::1]:53: read: connection refused" +time="2025-02-09T02:48:52Z" level=error msg="could not reach https://notary-server:4443: Get \"https://notary-server:4443/v2/\": dial tcp: lookup notary-server on [::1]:53: read udp [::1]:43080->[::1]:53: read: connection refused" +time="2025-02-09T02:48:52Z" level=error msg="could not reach https://notary-server:4443: Get \"https://notary-server:4443/v2/\": dial tcp: lookup notary-server on [::1]:53: read udp [::1]:34464->[::1]:53: read: connection refused" --- PASS: TestRotateKeyInvalidRoles (0.00s) === RUN TestRotateKeyTargetCannotBeServerManaged -time="2024-01-07T20:21:44Z" 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]:48724->[::1]:53: read: connection refused" +time="2025-02-09T02:48:52Z" level=error msg="could not reach https://notary-server:4443: Get \"https://notary-server:4443/v2/\": dial tcp: lookup notary-server on [::1]:53: read udp [::1]:48178->[::1]:53: read: connection refused" --- PASS: TestRotateKeyTargetCannotBeServerManaged (0.00s) === RUN TestRotateKeyTimestampCannotBeLocallyManaged -time="2024-01-07T20:21:44Z" 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]:36679->[::1]:53: read: connection refused" +time="2025-02-09T02:48:52Z" level=error msg="could not reach https://notary-server:4443: Get \"https://notary-server:4443/v2/\": dial tcp: lookup notary-server on [::1]:53: read udp [::1]:50331->[::1]:53: read: connection refused" --- PASS: TestRotateKeyTimestampCannotBeLocallyManaged (0.00s) === RUN TestRotateKeyNoGUN Usage: @@ -2466,13 +2502,13 @@ === RUN TestRotateKeyRemoteServerManagesKey Successfully rotated snapshot key for repository docker.com/notary Successfully rotated timestamp key for repository docker.com/notary ---- PASS: TestRotateKeyRemoteServerManagesKey (0.48s) +--- PASS: TestRotateKeyRemoteServerManagesKey (0.20s) === RUN TestRotateKeyBothKeys Successfully rotated targets key for repository docker.com/notary Successfully rotated snapshot key for repository docker.com/notary ---- PASS: TestRotateKeyBothKeys (0.53s) +--- PASS: TestRotateKeyBothKeys (0.18s) === RUN TestRotateKeyRootIsInteractive ---- PASS: TestRotateKeyRootIsInteractive (0.14s) +--- PASS: TestRotateKeyRootIsInteractive (0.04s) === RUN TestChangeKeyPassphraseInvalidID --- PASS: TestChangeKeyPassphraseInvalidID (0.00s) === RUN TestChangeKeyPassphraseInvalidNumArgs @@ -2481,18 +2517,18 @@ === RUN TestChangeKeyPassphraseNonexistentID --- PASS: TestChangeKeyPassphraseNonexistentID (0.00s) === RUN TestExportKeys ---- PASS: TestExportKeys (0.02s) +--- PASS: TestExportKeys (0.04s) === RUN TestExportKeysByGUN ---- PASS: TestExportKeysByGUN (0.00s) +--- PASS: TestExportKeysByGUN (0.01s) === RUN TestExportKeysByID ---- PASS: TestExportKeysByID (0.00s) +--- PASS: TestExportKeysByID (0.06s) === RUN TestExportKeysBadFlagCombo --- PASS: TestExportKeysBadFlagCombo (0.00s) === RUN TestImportKeysNonexistentFile --- PASS: TestImportKeysNonexistentFile (0.00s) === RUN TestKeyGeneration -time="2024-01-07T20:21:45Z" 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.03s) +time="2025-02-09T02:48:52Z" level=warning msg="failed to import key () to store: Cannot have canonical role key without a gun, don't know what gun it belongs to" +--- PASS: TestKeyGeneration (0.02s) === RUN TestNotaryConfigFileDefault --- PASS: TestNotaryConfigFileDefault (0.00s) === RUN TestRemoteServerDefault @@ -2504,17 +2540,17 @@ === RUN TestInvalidAddHashCommands --- PASS: TestInvalidAddHashCommands (0.00s) === RUN TestConfigParsingErrorsPropagatedByCommands ---- PASS: TestConfigParsingErrorsPropagatedByCommands (0.02s) +--- PASS: TestConfigParsingErrorsPropagatedByCommands (0.00s) === RUN TestInsufficientArgumentsReturnsErrorAndPrintsUsage ---- PASS: TestInsufficientArgumentsReturnsErrorAndPrintsUsage (0.03s) +--- PASS: TestInsufficientArgumentsReturnsErrorAndPrintsUsage (0.01s) === RUN TestBareCommandPrintsUsageAndNoError ---- PASS: TestBareCommandPrintsUsageAndNoError (0.01s) +--- PASS: TestBareCommandPrintsUsageAndNoError (0.00s) === RUN TestConfigFileTLSCannotBeRelativeToCWD ---- PASS: TestConfigFileTLSCannotBeRelativeToCWD (0.01s) +--- PASS: TestConfigFileTLSCannotBeRelativeToCWD (0.00s) === RUN TestConfigFileTLSCanBeRelativeToConfigOrAbsolute ---- PASS: TestConfigFileTLSCanBeRelativeToConfigOrAbsolute (0.14s) +--- PASS: TestConfigFileTLSCanBeRelativeToConfigOrAbsolute (0.07s) === RUN TestConfigFileOverridenByCmdLineFlags ---- PASS: TestConfigFileOverridenByCmdLineFlags (0.19s) +--- PASS: TestConfigFileOverridenByCmdLineFlags (0.07s) === RUN TestConfigFileTrustPinning --- PASS: TestConfigFileTrustPinning (0.00s) === RUN TestPassphraseRetrieverCaching @@ -2528,7 +2564,7 @@ === RUN TestPrettyPrintZeroKeys --- PASS: TestPrettyPrintZeroKeys (0.00s) === RUN TestPrettyPrintRootAndSigningKeys ---- PASS: TestPrettyPrintRootAndSigningKeys (0.06s) +--- PASS: TestPrettyPrintRootAndSigningKeys (0.02s) === RUN TestPrettyPrintZeroTargets --- PASS: TestPrettyPrintZeroTargets (0.00s) === RUN TestPrettyPrintSortedTargets @@ -2540,10 +2576,10 @@ === RUN TestImportRootCert --- PASS: TestImportRootCert (0.00s) === RUN TestTokenAuth -time="2024-01-07T20:21:45Z" 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="2025-02-09T02:48:53Z" level=error msg="could not reach https://localhost:9999: Get \"https://localhost:9999/v2/\": dial tcp 127.0.0.1:9999: connect: connection refused" --- PASS: TestTokenAuth (0.00s) === RUN TestAdminTokenAuth -time="2024-01-07T20:21:45Z" 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="2025-02-09T02:48:53Z" level=error msg="could not reach https://localhost:9999: Get \"https://localhost:9999/v2/\": dial tcp 127.0.0.1:9999: connect: connection refused" --- PASS: TestAdminTokenAuth (0.00s) === RUN TestTokenAuth200Status --- PASS: TestTokenAuth200Status (0.00s) @@ -2554,19 +2590,19 @@ === RUN TestAdminTokenAuth401Status --- PASS: TestAdminTokenAuth401Status (0.00s) === RUN TestTokenAuthNon200Non401Status -time="2024-01-07T20:21:45Z" level=error msg="could not reach http://127.0.0.1:37561: 404" +time="2025-02-09T02:48:53Z" level=error msg="could not reach http://127.0.0.1:34877: 404" --- PASS: TestTokenAuthNon200Non401Status (0.00s) === RUN TestAdminTokenAuthNon200Non401Status -time="2024-01-07T20:21:45Z" level=error msg="could not reach http://127.0.0.1:38995: 404" +time="2025-02-09T02:48:53Z" level=error msg="could not reach http://127.0.0.1:39435: 404" --- PASS: TestAdminTokenAuthNon200Non401Status (0.00s) === RUN TestConfigureRepo ---- PASS: TestConfigureRepo (0.01s) +--- PASS: TestConfigureRepo (0.00s) === RUN TestConfigureRepoRW -Enter username: time="2024-01-07T20:21:45Z" level=error msg="error processing username input: EOF" +Enter username: time="2025-02-09T02:48:53Z" level=error msg="error processing username input: EOF" --- PASS: TestConfigureRepoRW (0.00s) === RUN TestConfigureRepoAdmin -Enter username: time="2024-01-07T20:21:45Z" level=error msg="error processing username input: EOF" ---- PASS: TestConfigureRepoAdmin (0.01s) +Enter username: time="2025-02-09T02:48:53Z" level=error msg="error processing username input: EOF" +--- PASS: TestConfigureRepoAdmin (0.00s) === RUN TestStatusUnstageAndReset Successfully reset specified changes for repository gun Addition of target "test1" by sha256 hash to repository "gun" staged for next publish. @@ -2576,13 +2612,13 @@ --- PASS: TestStatusUnstageAndReset (0.00s) === RUN TestGetTrustPinningErrors Pushing changes to gun ---- PASS: TestGetTrustPinningErrors (0.01s) +--- PASS: TestGetTrustPinningErrors (0.00s) === RUN TestPasswordStore -Enter username: time="2024-01-07T20:21:45Z" level=error msg="error processing username input: EOF" +Enter username: time="2025-02-09T02:48:53Z" level=error msg="error processing username input: EOF" --- PASS: TestPasswordStore (0.00s) === RUN TestPasswordStoreWithEnvvar -time="2024-01-07T20:21:45Z" level=error msg="Authentication string with zero-length username" -time="2024-01-07T20:21:45Z" level=error msg="Could not base64-decode authentication string" +time="2025-02-09T02:48:53Z" level=error msg="Authentication string with zero-length username" +time="2025-02-09T02:48:53Z" level=error msg="Could not base64-decode authentication string" --- PASS: TestPasswordStoreWithEnvvar (0.00s) === RUN TestGetPayload --- PASS: TestGetPayload (0.00s) @@ -2591,7 +2627,7 @@ === RUN TestHomeExpand --- PASS: TestHomeExpand (0.00s) PASS -ok github.com/theupdateframework/notary/cmd/notary 32.439s +ok github.com/theupdateframework/notary/cmd/notary 11.966s === RUN TestBootstrap --- PASS: TestBootstrap (0.00s) === RUN TestGetAddrAndTLSConfigInvalidTLS @@ -2607,42 +2643,42 @@ === RUN TestGetInvalidTrustService --- PASS: TestGetInvalidTrustService (0.00s) === RUN TestGetLocalTrustService -time="2024-01-07T20:21:15Z" level=info msg="Using local signing service, which requires ED25519. Ignoring all other trust_service parameters, including keyAlgorithm" +time="2025-02-09T02:48:41Z" 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="2024-01-07T20:21:15Z" level=info msg="Using remote signing service" +time="2025-02-09T02:48:41Z" level=info msg="Using remote signing service" --- PASS: TestGetTrustServiceNoTLSConfig (0.00s) === RUN TestGetTrustServiceTLSSuccess -time="2024-01-07T20:21:15Z" level=info msg="Using remote signing service" ---- PASS: TestGetTrustServiceTLSSuccess (0.01s) +time="2025-02-09T02:48:41Z" level=info msg="Using remote signing service" +--- PASS: TestGetTrustServiceTLSSuccess (0.00s) === RUN TestGetTrustServiceTLSFailure --- PASS: TestGetTrustServiceTLSFailure (0.00s) === RUN TestGetStoreInvalid -time="2024-01-07T20:21:15Z" level=info msg="Using asdf backend" +time="2025-02-09T02:48:41Z" level=info msg="Using asdf backend" --- PASS: TestGetStoreInvalid (0.00s) === RUN TestGetStoreDBStore -time="2024-01-07T20:21:15Z" level=info msg="Using sqlite3 backend" +time="2025-02-09T02:48:41Z" level=info msg="Using sqlite3 backend" --- PASS: TestGetStoreDBStore (0.00s) === RUN TestGetStoreRethinkDBStoreConnectionFails -time="2024-01-07T20:21:15Z" level=info msg="Using rethinkdb backend" +time="2025-02-09T02:48:41Z" level=info msg="Using rethinkdb backend" --- PASS: TestGetStoreRethinkDBStoreConnectionFails (0.00s) === RUN TestGetMemoryStore -time="2024-01-07T20:21:15Z" level=info msg="Using memory backend" +time="2025-02-09T02:48:41Z" 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="2024-01-07T20:21:15Z" level=info msg="Using remote signing service" -time="2024-01-07T20:21:15Z" level=info msg="Using sqlite3 backend" ---- PASS: TestSampleConfig (0.01s) +time="2025-02-09T02:48:41Z" level=info msg="Using remote signing service" +time="2025-02-09T02:48:41Z" level=info msg="Using sqlite3 backend" +--- PASS: TestSampleConfig (0.00s) PASS -ok github.com/theupdateframework/notary/cmd/notary-server 0.097s +ok github.com/theupdateframework/notary/cmd/notary-server 0.019s === RUN TestGetAddrAndTLSConfigInvalidTLS --- PASS: TestGetAddrAndTLSConfigInvalidTLS (0.00s) === RUN TestGetAddrAndTLSConfigNoGRPCAddr @@ -2657,7 +2693,7 @@ main_test.go:121: DM - skipping malfunctioning test, fails on sbuild --- SKIP: TestSetupCryptoServicesRethinkDBStoreConnectionFails (0.00s) === RUN TestSetupCryptoServicesDBStoreSuccess ---- PASS: TestSetupCryptoServicesDBStoreSuccess (0.12s) +--- PASS: TestSetupCryptoServicesDBStoreSuccess (0.04s) === RUN TestSetupCryptoServicesMemoryStore --- PASS: TestSetupCryptoServicesMemoryStore (0.01s) === RUN TestSetupCryptoServicesInvalidStore @@ -2675,17 +2711,17 @@ === RUN TestSampleConfig --- PASS: TestSampleConfig (0.00s) PASS -ok github.com/theupdateframework/notary/cmd/notary-signer 0.174s +ok github.com/theupdateframework/notary/cmd/notary-signer 0.063s === RUN TestGenerateCertificate ---- PASS: TestGenerateCertificate (0.09s) +--- PASS: TestGenerateCertificate (0.03s) === RUN TestCryptoServiceWithNonEmptyGUN ---- PASS: TestCryptoServiceWithNonEmptyGUN (2.55s) +--- PASS: TestCryptoServiceWithNonEmptyGUN (1.51s) === RUN TestCryptoServiceWithEmptyGUN ---- PASS: TestCryptoServiceWithEmptyGUN (2.29s) +--- PASS: TestCryptoServiceWithEmptyGUN (1.37s) === RUN TestCryptoSignerInterfaceBehavior ---- PASS: TestCryptoSignerInterfaceBehavior (0.06s) +--- PASS: TestCryptoSignerInterfaceBehavior (0.03s) PASS -ok github.com/theupdateframework/notary/cryptoservice 5.059s +ok github.com/theupdateframework/notary/cryptoservice 2.967s === RUN TestGetPassphraseForUsingDelegationKey --- PASS: TestGetPassphraseForUsingDelegationKey (0.00s) === RUN TestGetPassphraseLimitsShortPassphrases @@ -2701,282 +2737,282 @@ === RUN TestGetPassphrase --- PASS: TestGetPassphrase (0.00s) PASS -ok github.com/theupdateframework/notary/passphrase 0.048s +ok github.com/theupdateframework/notary/passphrase 0.021s ? github.com/theupdateframework/notary/proto [no test files] === RUN TestValidationErrorFormat -time="2024-01-07T20:21:11Z" 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=21ce74ac1170e8a019e265a2e9d9959adfed63cc364299b72b78b30850f2" http.request.host="127.0.0.1:34757" http.request.id=ef871e27-4e44-4b4f-91c9-f5e7052515d1 http.request.method=POST http.request.remoteaddr="127.0.0.1:50504" http.request.uri=/v2/docker.com/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 -time="2024-01-07T20:21:11Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype="multipart/form-data; boundary=21ce74ac1170e8a019e265a2e9d9959adfed63cc364299b72b78b30850f2" http.request.host="127.0.0.1:34757" http.request.id=ef871e27-4e44-4b4f-91c9-f5e7052515d1 http.request.method=POST http.request.remoteaddr="127.0.0.1:50504" 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=45.103519ms http.response.status=400 http.response.written=260 ---- PASS: TestValidationErrorFormat (0.37s) +time="2025-02-09T02:48:40Z" 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=87bfdf5908dbbb7fa7b75f7393583f883cd52fa5843a71f605f713566f04" http.request.host="127.0.0.1:37435" http.request.id=72c938d4-0d0c-476b-9ccf-851b3f891a76 http.request.method=POST http.request.remoteaddr="127.0.0.1:38126" http.request.uri=/v2/docker.com/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 +time="2025-02-09T02:48:40Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype="multipart/form-data; boundary=87bfdf5908dbbb7fa7b75f7393583f883cd52fa5843a71f605f713566f04" http.request.host="127.0.0.1:37435" http.request.id=72c938d4-0d0c-476b-9ccf-851b3f891a76 http.request.method=POST http.request.remoteaddr="127.0.0.1:38126" 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=17.964519ms 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="2024-01-07T20:21:11Z" level=info msg="updated docker.io/notary to timestamp version 1, checksum e34ec4b5a8f318f242a291b2876d9faeb6521a33b92e0a046477ed19627da998" docker.io/notary=gun go.version=go1.19.8 http.request.contenttype="multipart/form-data; boundary=ec70b727f5523fca9329b74afdb836d1f5faead3a76781fc20950d176eda" http.request.host="127.0.0.1:45365" http.request.id=de06e069-cda7-4154-b8a3-3e6630433329 http.request.method=POST http.request.remoteaddr="127.0.0.1:35446" http.request.uri=/v2/docker.io/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 -time="2024-01-07T20:21:11Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype="multipart/form-data; boundary=ec70b727f5523fca9329b74afdb836d1f5faead3a76781fc20950d176eda" http.request.host="127.0.0.1:45365" http.request.id=de06e069-cda7-4154-b8a3-3e6630433329 http.request.method=POST http.request.remoteaddr="127.0.0.1:35446" http.request.uri=/v2/docker.io/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 http.response.duration=69.607119ms http.response.status=0 http.response.written=0 -time="2024-01-07T20:21:11Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:45365" http.request.id=9ce7f531-5351-4f84-9259-ffa134532389 http.request.method=GET http.request.remoteaddr="127.0.0.1:35446" http.request.uri=/v2/docker.io/notary/_trust/tuf/snapshot.json http.request.useragent=Go-http-client/1.1 http.response.duration="776.655µs" http.response.status=200 http.response.written=683 -time="2024-01-07T20:21:11Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:45365" http.request.id=8e7bb89a-92e4-467b-85c5-96ffb223f489 http.request.method=GET http.request.remoteaddr="127.0.0.1:35446" http.request.uri=/v2/docker.io/notary/_trust/tuf/snapshot.697a7e702c2409820c4c19de15448d8c154c42d03d5ba3e5882c54544d215b24.json http.request.useragent=Go-http-client/1.1 http.response.duration="39.229µs" http.response.status=200 http.response.written=683 -time="2024-01-07T20:21:11Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:45365" http.request.id=570e994f-4d29-41fd-89cd-90d3235f7d87 http.request.method=GET http.request.remoteaddr="127.0.0.1:35446" http.request.uri=/v2/docker.io/notary/_trust/tuf/timestamp.key http.request.useragent=Go-http-client/1.1 http.response.duration="535.866µs" http.response.status=200 http.response.written=181 -time="2024-01-07T20:21:11Z" 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:45365" http.request.id=0bd7ffbf-4313-458f-97a4-f878cde9e423 http.request.method=DELETE http.request.remoteaddr="127.0.0.1:35446" http.request.uri=/v2/docker.io/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 -time="2024-01-07T20:21:11Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:45365" http.request.id=0bd7ffbf-4313-458f-97a4-f878cde9e423 http.request.method=DELETE http.request.remoteaddr="127.0.0.1:35446" http.request.uri=/v2/docker.io/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 http.response.duration="71.434µs" http.response.status=0 http.response.written=0 ---- PASS: TestRepoPrefixMatches (0.15s) +time="2025-02-09T02:48:40Z" level=info msg="updated docker.io/notary to timestamp version 1, checksum f06ee3ea9f38264ad9036cb385284583b9612f9fd982cf52d9a1042bebb61abc" docker.io/notary=gun go.version=go1.19.8 http.request.contenttype="multipart/form-data; boundary=8f57f1c6ead0345f83e3d55de9ff1995c62627e12b72e964b10a96be57fb" http.request.host="127.0.0.1:36965" http.request.id=13feb361-eefb-4144-8c1d-3f627c988d4d http.request.method=POST http.request.remoteaddr="127.0.0.1:59038" http.request.uri=/v2/docker.io/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 +time="2025-02-09T02:48:40Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype="multipart/form-data; boundary=8f57f1c6ead0345f83e3d55de9ff1995c62627e12b72e964b10a96be57fb" http.request.host="127.0.0.1:36965" http.request.id=13feb361-eefb-4144-8c1d-3f627c988d4d http.request.method=POST http.request.remoteaddr="127.0.0.1:59038" http.request.uri=/v2/docker.io/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 http.response.duration=25.379442ms http.response.status=0 http.response.written=0 +time="2025-02-09T02:48:40Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:36965" http.request.id=afa56c60-75c2-4e98-9ddc-58da1567ef00 http.request.method=GET http.request.remoteaddr="127.0.0.1:59038" http.request.uri=/v2/docker.io/notary/_trust/tuf/snapshot.json http.request.useragent=Go-http-client/1.1 http.response.duration="759.71µs" http.response.status=200 http.response.written=683 +time="2025-02-09T02:48:40Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:36965" http.request.id=e3611040-513a-4fc1-accf-584b88aaac20 http.request.method=GET http.request.remoteaddr="127.0.0.1:59038" http.request.uri=/v2/docker.io/notary/_trust/tuf/snapshot.a34b1a520f77cb9cb8ce18480343014277194a20778c242e1dc660899e630397.json http.request.useragent=Go-http-client/1.1 http.response.duration="46.867µs" http.response.status=200 http.response.written=683 +time="2025-02-09T02:48:40Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:36965" http.request.id=d6177c48-1bb4-447c-b852-56ae53d62d9c http.request.method=GET http.request.remoteaddr="127.0.0.1:59038" http.request.uri=/v2/docker.io/notary/_trust/tuf/timestamp.key http.request.useragent=Go-http-client/1.1 http.response.duration="516.903µs" http.response.status=200 http.response.written=181 +time="2025-02-09T02:48:40Z" 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:36965" http.request.id=ebb04d00-a118-4f91-9fe4-d16caef4d0df http.request.method=DELETE http.request.remoteaddr="127.0.0.1:59038" http.request.uri=/v2/docker.io/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 +time="2025-02-09T02:48:40Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:36965" http.request.id=ebb04d00-a118-4f91-9fe4-d16caef4d0df http.request.method=DELETE http.request.remoteaddr="127.0.0.1:59038" http.request.uri=/v2/docker.io/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 http.response.duration="67.924µs" http.response.status=0 http.response.written=0 +--- PASS: TestRepoPrefixMatches (0.09s) === RUN TestRepoPrefixDoesNotMatch ---- PASS: TestRepoPrefixDoesNotMatch (0.09s) +--- PASS: TestRepoPrefixDoesNotMatch (0.07s) === RUN TestMetricsEndpoint ---- PASS: TestMetricsEndpoint (0.02s) +--- PASS: TestMetricsEndpoint (0.05s) === RUN TestGetKeysEndpoint -time="2024-01-07T20:21:12Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:43153" http.request.id=7f70257c-4d86-41ec-bd7e-5ac7cb3125b0 http.request.method=GET http.request.remoteaddr="127.0.0.1:42738" http.request.uri=/v2/gun/_trust/tuf/snapshot.key http.request.useragent=Go-http-client/1.1 http.response.duration=66.828501ms http.response.status=200 http.response.written=103 -time="2024-01-07T20:21:12Z" 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:43153" http.request.id=1a775ed7-c7ae-42bb-b950-570afa056038 http.request.method=GET http.request.remoteaddr="127.0.0.1:42744" http.request.uri=/v2/gun/_trust/tuf/targets.key http.request.useragent=Go-http-client/1.1 -time="2024-01-07T20:21:12Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:43153" http.request.id=1a775ed7-c7ae-42bb-b950-570afa056038 http.request.method=GET http.request.remoteaddr="127.0.0.1:42744" 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="177.972µs" http.response.status=404 http.response.written=104 -time="2024-01-07T20:21:12Z" 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:43153" http.request.id=7b87fac6-383d-4bc6-9208-47e041409e04 http.request.method=GET http.request.remoteaddr="127.0.0.1:42750" http.request.uri=/v2/gun/_trust/tuf/root.key http.request.useragent=Go-http-client/1.1 -time="2024-01-07T20:21:12Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:43153" http.request.id=7b87fac6-383d-4bc6-9208-47e041409e04 http.request.method=GET http.request.remoteaddr="127.0.0.1:42750" 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="83.918µs" http.response.status=404 http.response.written=104 -time="2024-01-07T20:21:12Z" 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:43153" http.request.id=405ddfa8-bd41-41fc-9d6e-5dd4f9ead93e http.request.method=GET http.request.remoteaddr="127.0.0.1:42766" http.request.uri=/v2/gun/_trust/tuf/somerandomrole.key http.request.useragent=Go-http-client/1.1 -time="2024-01-07T20:21:12Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:43153" http.request.id=405ddfa8-bd41-41fc-9d6e-5dd4f9ead93e http.request.method=GET http.request.remoteaddr="127.0.0.1:42766" 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="104.168µs" http.response.status=404 http.response.written=104 -time="2024-01-07T20:21:12Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:43153" http.request.id=878126fb-0511-460a-bd92-bcd994519736 http.request.method=GET http.request.remoteaddr="127.0.0.1:42780" http.request.uri=/v2/gun/_trust/tuf/timestamp.key http.request.useragent=Go-http-client/1.1 http.response.duration="756.998µs" http.response.status=200 http.response.written=103 ---- PASS: TestGetKeysEndpoint (0.09s) +time="2025-02-09T02:48:40Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:38345" http.request.id=8bff6248-5bea-46c0-9007-7533a92b8a3d http.request.method=GET http.request.remoteaddr="127.0.0.1:38282" http.request.uri=/v2/gun/_trust/tuf/timestamp.key http.request.useragent=Go-http-client/1.1 http.response.duration=35.437087ms http.response.status=200 http.response.written=103 +time="2025-02-09T02:48:40Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:38345" http.request.id=0ca2ff62-4f31-499a-bedc-f99649529240 http.request.method=GET http.request.remoteaddr="127.0.0.1:38298" http.request.uri=/v2/gun/_trust/tuf/snapshot.key http.request.useragent=Go-http-client/1.1 http.response.duration="665.955µs" http.response.status=200 http.response.written=103 +time="2025-02-09T02:48:40Z" 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:38345" http.request.id=6d85e660-9bc6-4aa4-8b12-fc01b49c8ff3 http.request.method=GET http.request.remoteaddr="127.0.0.1:38306" http.request.uri=/v2/gun/_trust/tuf/targets.key http.request.useragent=Go-http-client/1.1 +time="2025-02-09T02:48:40Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:38345" http.request.id=6d85e660-9bc6-4aa4-8b12-fc01b49c8ff3 http.request.method=GET http.request.remoteaddr="127.0.0.1:38306" 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="114.187µs" http.response.status=404 http.response.written=104 +time="2025-02-09T02:48:40Z" 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:38345" http.request.id=b88bc697-41d8-4282-9842-d8f9879f63dc http.request.method=GET http.request.remoteaddr="127.0.0.1:38312" http.request.uri=/v2/gun/_trust/tuf/root.key http.request.useragent=Go-http-client/1.1 +time="2025-02-09T02:48:40Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:38345" http.request.id=b88bc697-41d8-4282-9842-d8f9879f63dc http.request.method=GET http.request.remoteaddr="127.0.0.1:38312" 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="87.19µs" http.response.status=404 http.response.written=104 +time="2025-02-09T02:48:40Z" 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:38345" http.request.id=f8ac70b8-d9d3-4177-8f78-df40db1a0268 http.request.method=GET http.request.remoteaddr="127.0.0.1:38318" http.request.uri=/v2/gun/_trust/tuf/somerandomrole.key http.request.useragent=Go-http-client/1.1 +time="2025-02-09T02:48:40Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:38345" http.request.id=f8ac70b8-d9d3-4177-8f78-df40db1a0268 http.request.method=GET http.request.remoteaddr="127.0.0.1:38318" 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="85.637µs" http.response.status=404 http.response.written=104 +--- PASS: TestGetKeysEndpoint (0.05s) === RUN TestGetRoleByHash -time="2024-01-07T20:21:12Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:42887" http.request.id=955ec31b-9e20-476b-bd1a-3b0fa0e40fa4 http.request.method=GET http.request.remoteaddr="127.0.0.1:49258" http.request.uri=/v2/gun/_trust/tuf/timestamp.572a207d677fc5a70bdb57da867ef23398ec195139e22016495e472ecb9c8360.json http.request.useragent=Go-http-client/1.1 http.response.duration="98.637µs" http.response.status=200 http.response.written=115 ---- PASS: TestGetRoleByHash (0.01s) +time="2025-02-09T02:48:40Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:44935" http.request.id=6574d954-7330-4b8a-9cc9-c96fb806eb25 http.request.method=GET http.request.remoteaddr="127.0.0.1:55914" http.request.uri=/v2/gun/_trust/tuf/timestamp.116a835cf0cea1ff0db8dc340686d9cba22f5ea62e30b17e24c3ac37192bc9e6.json http.request.useragent=Go-http-client/1.1 http.response.duration="58.76µs" http.response.status=200 http.response.written=115 +--- PASS: TestGetRoleByHash (0.00s) === RUN TestGetRoleByVersion -time="2024-01-07T20:21:12Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:39661" http.request.id=f9dd17be-0e64-4ca8-8f37-19e072ff2363 http.request.method=GET http.request.remoteaddr="127.0.0.1:33146" http.request.uri=/v2/gun/_trust/tuf/1.timestamp.json http.request.useragent=Go-http-client/1.1 http.response.duration="77.344µs" http.response.status=200 http.response.written=115 +time="2025-02-09T02:48:40Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:33999" http.request.id=82d28242-0c3c-4890-bd37-6dc3cd1eaadd http.request.method=GET http.request.remoteaddr="127.0.0.1:56774" http.request.uri=/v2/gun/_trust/tuf/1.timestamp.json http.request.useragent=Go-http-client/1.1 http.response.duration="49.615µs" http.response.status=200 http.response.written=115 --- PASS: TestGetRoleByVersion (0.01s) === RUN TestGetCurrentRole -time="2024-01-07T20:21:12Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:34035" http.request.id=5c7bd9f6-046a-4e80-ab45-ed29895b5d12 http.request.method=GET http.request.remoteaddr="127.0.0.1:44260" http.request.uri=/v2/gun/_trust/tuf/timestamp.json http.request.useragent=Go-http-client/1.1 http.response.duration=1.639559ms http.response.status=200 http.response.written=495 ---- PASS: TestGetCurrentRole (0.14s) +time="2025-02-09T02:48:40Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:45173" http.request.id=8a32f007-65a0-4974-b25e-3c6bf5c354e1 http.request.method=GET http.request.remoteaddr="127.0.0.1:50018" http.request.uri=/v2/gun/_trust/tuf/timestamp.json http.request.useragent=Go-http-client/1.1 http.response.duration="634.469µs" http.response.status=200 http.response.written=495 +--- PASS: TestGetCurrentRole (0.05s) === RUN TestRotateKeyEndpoint -time="2024-01-07T20:21:12Z" 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:39199" http.request.id=ee0d7a5f-a0e3-458c-a1a4-7fca6464f06a http.request.method=POST http.request.remoteaddr="127.0.0.1:45826" http.request.uri=/v2/gun/_trust/tuf/targets/delegation.key http.request.useragent=Go-http-client/1.1 -time="2024-01-07T20:21:12Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:39199" http.request.id=ee0d7a5f-a0e3-458c-a1a4-7fca6464f06a http.request.method=POST http.request.remoteaddr="127.0.0.1:45826" 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="175.328µs" http.response.status=404 http.response.written=104 -time="2024-01-07T20:21:12Z" 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:39199" http.request.id=248ea836-058f-4ce7-a56f-2ad3e681bf5f http.request.method=POST http.request.remoteaddr="127.0.0.1:45830" http.request.uri=/v2/gun/_trust/tuf/somerandomrole.key http.request.useragent=Go-http-client/1.1 -time="2024-01-07T20:21:12Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:39199" http.request.id=248ea836-058f-4ce7-a56f-2ad3e681bf5f http.request.method=POST http.request.remoteaddr="127.0.0.1:45830" 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="84.959µs" http.response.status=404 http.response.written=104 -time="2024-01-07T20:21:12Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:39199" http.request.id=3627e5aa-b1b2-44a3-a989-580a65c71e44 http.request.method=POST http.request.remoteaddr="127.0.0.1:45840" http.request.uri=/v2/gun/_trust/tuf/timestamp.key http.request.useragent=Go-http-client/1.1 http.response.duration="630.893µs" http.response.status=200 http.response.written=103 -time="2024-01-07T20:21:12Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:39199" http.request.id=ae9a7b05-0f15-4633-98f2-aeaf1f888d6b http.request.method=POST http.request.remoteaddr="127.0.0.1:45844" http.request.uri=/v2/gun/_trust/tuf/snapshot.key http.request.useragent=Go-http-client/1.1 http.response.duration="828.125µs" http.response.status=200 http.response.written=103 -time="2024-01-07T20:21:12Z" 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:39199" http.request.id=4031053d-9511-4627-af07-5bcf3fb15dac http.request.method=POST http.request.remoteaddr="127.0.0.1:45854" http.request.uri=/v2/gun/_trust/tuf/targets.key http.request.useragent=Go-http-client/1.1 -time="2024-01-07T20:21:12Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:39199" http.request.id=4031053d-9511-4627-af07-5bcf3fb15dac http.request.method=POST http.request.remoteaddr="127.0.0.1:45854" 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="118.108µs" http.response.status=404 http.response.written=104 -time="2024-01-07T20:21:12Z" 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:39199" http.request.id=d09ba08a-3300-48eb-ac34-ee59c5bfe1e9 http.request.method=POST http.request.remoteaddr="127.0.0.1:45866" http.request.uri=/v2/gun/_trust/tuf/root.key http.request.useragent=Go-http-client/1.1 -time="2024-01-07T20:21:12Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:39199" http.request.id=d09ba08a-3300-48eb-ac34-ee59c5bfe1e9 http.request.method=POST http.request.remoteaddr="127.0.0.1:45866" 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="82.817µs" http.response.status=404 http.response.written=104 ---- PASS: TestRotateKeyEndpoint (0.04s) +time="2025-02-09T02:48:40Z" 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:36825" http.request.id=7abffeea-853c-457d-bb81-c8f692292ac1 http.request.method=POST http.request.remoteaddr="127.0.0.1:56038" http.request.uri=/v2/gun/_trust/tuf/targets/delegation.key http.request.useragent=Go-http-client/1.1 +time="2025-02-09T02:48:40Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:36825" http.request.id=7abffeea-853c-457d-bb81-c8f692292ac1 http.request.method=POST http.request.remoteaddr="127.0.0.1:56038" 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="202.501µs" http.response.status=404 http.response.written=104 +time="2025-02-09T02:48:40Z" 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:36825" http.request.id=d9f45fbd-bdf1-4a5a-b2a7-1c6c1f0ecb94 http.request.method=POST http.request.remoteaddr="127.0.0.1:56052" http.request.uri=/v2/gun/_trust/tuf/somerandomrole.key http.request.useragent=Go-http-client/1.1 +time="2025-02-09T02:48:40Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:36825" http.request.id=d9f45fbd-bdf1-4a5a-b2a7-1c6c1f0ecb94 http.request.method=POST http.request.remoteaddr="127.0.0.1:56052" http.request.uri=/v2/gun/_trust/tuf/somerandomrole.key http.request.useragent=Go-http-client/1.1 http.response.contenttype="application/json; charset=utf-8" http.response.duration="100.672µs" http.response.status=404 http.response.written=104 +time="2025-02-09T02:48:40Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:36825" http.request.id=2fbfc059-624b-4482-9bc1-8b6048f3360a http.request.method=POST http.request.remoteaddr="127.0.0.1:56058" http.request.uri=/v2/gun/_trust/tuf/timestamp.key http.request.useragent=Go-http-client/1.1 http.response.duration="719.949µs" http.response.status=200 http.response.written=103 +time="2025-02-09T02:48:40Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:36825" http.request.id=350d695c-1d68-45f7-8ff1-33cc823e31ea http.request.method=POST http.request.remoteaddr="127.0.0.1:56072" http.request.uri=/v2/gun/_trust/tuf/snapshot.key http.request.useragent=Go-http-client/1.1 http.response.duration="679.94µs" http.response.status=200 http.response.written=103 +time="2025-02-09T02:48:40Z" 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:36825" http.request.id=0f313057-c081-4a15-bd7f-c634ec0f6e3b http.request.method=POST http.request.remoteaddr="127.0.0.1:56084" http.request.uri=/v2/gun/_trust/tuf/targets.key http.request.useragent=Go-http-client/1.1 +time="2025-02-09T02:48:40Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:36825" http.request.id=0f313057-c081-4a15-bd7f-c634ec0f6e3b http.request.method=POST http.request.remoteaddr="127.0.0.1:56084" 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="93.171µs" http.response.status=404 http.response.written=104 +time="2025-02-09T02:48:40Z" 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:36825" http.request.id=6cbc5443-4158-4e65-bec4-267b1b49e8c2 http.request.method=POST http.request.remoteaddr="127.0.0.1:56100" http.request.uri=/v2/gun/_trust/tuf/root.key http.request.useragent=Go-http-client/1.1 +time="2025-02-09T02:48:40Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:36825" http.request.id=6cbc5443-4158-4e65-bec4-267b1b49e8c2 http.request.method=POST http.request.remoteaddr="127.0.0.1:56100" 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="82.4µs" http.response.status=404 http.response.written=104 +--- PASS: TestRotateKeyEndpoint (0.02s) PASS -ok github.com/theupdateframework/notary/server 1.001s +ok github.com/theupdateframework/notary/server 0.448s ? github.com/theupdateframework/notary/server/errors [no test files] === RUN Test_changefeed --- PASS: Test_changefeed (0.00s) === RUN Test_checkChangefeedInputs -time="2024-01-07T20:21:10Z" level=error msg="500 GET unable to retrieve storage" -time="2024-01-07T20:21:10Z" level=error msg="400 GET invalid pageSize: not_a_number" +time="2025-02-09T02:48:40Z" level=error msg="500 GET unable to retrieve storage" +time="2025-02-09T02:48:40Z" level=error msg="400 GET invalid pageSize: not_a_number" --- PASS: Test_checkChangefeedInputs (0.00s) === RUN TestMainHandlerGet -time="2024-01-07T20:21:10Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:44095" http.request.id=696e0638-26aa-4f56-9e06-122ad5c54f97 http.request.method=GET http.request.remoteaddr="127.0.0.1:43496" http.request.uri=/ http.request.useragent=Go-http-client/1.1 http.response.duration="67.839µs" http.response.status=200 http.response.written=2 ---- PASS: TestMainHandlerGet (0.01s) +time="2025-02-09T02:48:40Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:41583" http.request.id=451227b4-321b-4a63-b221-033adb629e2e http.request.method=GET http.request.remoteaddr="127.0.0.1:41924" http.request.uri=/ http.request.useragent=Go-http-client/1.1 http.response.duration="40.99µs" http.response.status=200 http.response.written=2 +--- PASS: TestMainHandlerGet (0.00s) === RUN TestMainHandlerNotGet -time="2024-01-07T20:21:10Z" 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:46619" http.request.id=0aaa9eeb-1c2a-4e0c-ae36-36dbe8429218 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:53792" http.request.uri=/ http.request.useragent=Go-http-client/1.1 -time="2024-01-07T20:21:10Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:46619" http.request.id=0aaa9eeb-1c2a-4e0c-ae36-36dbe8429218 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:53792" http.request.uri=/ http.request.useragent=Go-http-client/1.1 http.response.contenttype="application/json; charset=utf-8" http.response.duration="312.051µs" http.response.status=404 http.response.written=105 +time="2025-02-09T02:48:40Z" 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:45515" http.request.id=9825da05-5f5c-44bd-b95d-db5fd46819a4 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:45748" http.request.uri=/ http.request.useragent=Go-http-client/1.1 +time="2025-02-09T02:48:40Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:45515" http.request.id=9825da05-5f5c-44bd-b95d-db5fd46819a4 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:45748" http.request.uri=/ http.request.useragent=Go-http-client/1.1 http.response.contenttype="application/json; charset=utf-8" http.response.duration="214.161µs" http.response.status=404 http.response.written=105 --- PASS: TestMainHandlerNotGet (0.00s) === RUN TestKeyHandlersInvalidConfiguration -time="2024-01-07T20:21:10Z" level=error msg="500 GET storage not configured" go.version=go1.19.8 gun=gun -time="2024-01-07T20:21:10Z" level=error msg="500 GET storage not configured" go.version=go1.19.8 gun=gun -time="2024-01-07T20:21:10Z" level=error msg="500 GET crypto service not configured" go.version=go1.19.8 gun=gun -time="2024-01-07T20:21:10Z" level=error msg="500 GET crypto service not configured" go.version=go1.19.8 gun=gun -time="2024-01-07T20:21:10Z" level=error msg="500 GET key algorithm not configured" go.version=go1.19.8 gun=gun -time="2024-01-07T20:21:10Z" level=error msg="500 GET key algorithm not configured" go.version=go1.19.8 gun=gun -time="2024-01-07T20:21:10Z" level=error msg="500 POST storage not configured" go.version=go1.19.8 gun=gun -time="2024-01-07T20:21:10Z" level=error msg="500 POST storage not configured" go.version=go1.19.8 gun=gun -time="2024-01-07T20:21:10Z" level=error msg="500 POST crypto service not configured" go.version=go1.19.8 gun=gun -time="2024-01-07T20:21:10Z" level=error msg="500 POST crypto service not configured" go.version=go1.19.8 gun=gun -time="2024-01-07T20:21:10Z" level=error msg="500 POST key algorithm not configured" go.version=go1.19.8 gun=gun -time="2024-01-07T20:21:10Z" level=error msg="500 POST key algorithm not configured" go.version=go1.19.8 gun=gun +time="2025-02-09T02:48:40Z" level=error msg="500 GET storage not configured" go.version=go1.19.8 gun=gun +time="2025-02-09T02:48:40Z" level=error msg="500 GET storage not configured" go.version=go1.19.8 gun=gun +time="2025-02-09T02:48:40Z" level=error msg="500 GET crypto service not configured" go.version=go1.19.8 gun=gun +time="2025-02-09T02:48:40Z" level=error msg="500 GET crypto service not configured" go.version=go1.19.8 gun=gun +time="2025-02-09T02:48:40Z" level=error msg="500 GET key algorithm not configured" go.version=go1.19.8 gun=gun +time="2025-02-09T02:48:40Z" level=error msg="500 GET key algorithm not configured" go.version=go1.19.8 gun=gun +time="2025-02-09T02:48:40Z" level=error msg="500 POST storage not configured" go.version=go1.19.8 gun=gun +time="2025-02-09T02:48:40Z" level=error msg="500 POST storage not configured" go.version=go1.19.8 gun=gun +time="2025-02-09T02:48:40Z" level=error msg="500 POST crypto service not configured" go.version=go1.19.8 gun=gun +time="2025-02-09T02:48:40Z" level=error msg="500 POST crypto service not configured" go.version=go1.19.8 gun=gun +time="2025-02-09T02:48:40Z" level=error msg="500 POST key algorithm not configured" go.version=go1.19.8 gun=gun +time="2025-02-09T02:48:40Z" level=error msg="500 POST key algorithm not configured" go.version=go1.19.8 gun=gun --- PASS: TestKeyHandlersInvalidConfiguration (0.00s) === RUN TestKeyHandlersNoRoleOrRepo -time="2024-01-07T20:21:10Z" level=info msg="400 GET no gun in request" =gun go.version=go1.19.8 -time="2024-01-07T20:21:10Z" level=info msg="400 GET no gun in request" =gun go.version=go1.19.8 -time="2024-01-07T20:21:10Z" level=info msg="400 GET no role in request" go.version=go1.19.8 gun=gun -time="2024-01-07T20:21:10Z" level=info msg="400 GET no role in request" go.version=go1.19.8 gun=gun -time="2024-01-07T20:21:10Z" level=info msg="400 POST no gun in request" =gun go.version=go1.19.8 -time="2024-01-07T20:21:10Z" level=info msg="400 POST no gun in request" =gun go.version=go1.19.8 -time="2024-01-07T20:21:10Z" level=info msg="400 POST no role in request" go.version=go1.19.8 gun=gun -time="2024-01-07T20:21:10Z" level=info msg="400 POST no role in request" go.version=go1.19.8 gun=gun +time="2025-02-09T02:48:40Z" level=info msg="400 GET no gun in request" =gun go.version=go1.19.8 +time="2025-02-09T02:48:40Z" level=info msg="400 GET no gun in request" =gun go.version=go1.19.8 +time="2025-02-09T02:48:40Z" level=info msg="400 GET no role in request" go.version=go1.19.8 gun=gun +time="2025-02-09T02:48:40Z" level=info msg="400 GET no role in request" go.version=go1.19.8 gun=gun +time="2025-02-09T02:48:40Z" level=info msg="400 POST no gun in request" =gun go.version=go1.19.8 +time="2025-02-09T02:48:40Z" level=info msg="400 POST no gun in request" =gun go.version=go1.19.8 +time="2025-02-09T02:48:40Z" level=info msg="400 POST no role in request" go.version=go1.19.8 gun=gun +time="2025-02-09T02:48:40Z" level=info msg="400 POST no role in request" go.version=go1.19.8 gun=gun --- PASS: TestKeyHandlersNoRoleOrRepo (0.00s) === RUN TestKeyHandlersInvalidRole -time="2024-01-07T20:21:10Z" level=info msg="400 GET root key: " go.version=go1.19.8 gun=gun -time="2024-01-07T20:21:10Z" level=info msg="400 GET targets key: " go.version=go1.19.8 gun=gun -time="2024-01-07T20:21:10Z" level=info msg="400 GET targets/a key: " go.version=go1.19.8 gun=gun -time="2024-01-07T20:21:10Z" level=info msg="400 GET invalidrole key: " go.version=go1.19.8 gun=gun -time="2024-01-07T20:21:10Z" level=info msg="400 POST root key: " go.version=go1.19.8 gun=gun -time="2024-01-07T20:21:10Z" level=info msg="400 POST targets key: " go.version=go1.19.8 gun=gun -time="2024-01-07T20:21:10Z" level=info msg="400 POST targets/a key: " go.version=go1.19.8 gun=gun -time="2024-01-07T20:21:10Z" level=info msg="400 POST invalidrole key: " go.version=go1.19.8 gun=gun +time="2025-02-09T02:48:40Z" level=info msg="400 GET root key: " go.version=go1.19.8 gun=gun +time="2025-02-09T02:48:40Z" level=info msg="400 GET targets key: " go.version=go1.19.8 gun=gun +time="2025-02-09T02:48:40Z" level=info msg="400 GET targets/a key: " go.version=go1.19.8 gun=gun +time="2025-02-09T02:48:40Z" level=info msg="400 GET invalidrole key: " go.version=go1.19.8 gun=gun +time="2025-02-09T02:48:40Z" level=info msg="400 POST root key: " go.version=go1.19.8 gun=gun +time="2025-02-09T02:48:40Z" level=info msg="400 POST targets key: " go.version=go1.19.8 gun=gun +time="2025-02-09T02:48:40Z" level=info msg="400 POST targets/a key: " go.version=go1.19.8 gun=gun +time="2025-02-09T02:48:40Z" level=info msg="400 POST invalidrole key: " go.version=go1.19.8 gun=gun --- PASS: TestKeyHandlersInvalidRole (0.00s) === RUN TestGetKeyHandlerCreatesOnce ---- PASS: TestGetKeyHandlerCreatesOnce (0.11s) +--- PASS: TestGetKeyHandlerCreatesOnce (0.04s) === RUN TestKeyHandlersInvalidKeyAlgo -time="2024-01-07T20:21:10Z" level=error msg="500 GET timestamp key: only ED25519 supported by this cryptoservice" go.version=go1.19.8 gun=gun -time="2024-01-07T20:21:10Z" level=error msg="500 GET snapshot key: only ED25519 supported by this cryptoservice" go.version=go1.19.8 gun=gun -time="2024-01-07T20:21:10Z" level=error msg="500 POST timestamp key: only ED25519 supported by this cryptoservice" go.version=go1.19.8 gun=gun -time="2024-01-07T20:21:10Z" level=error msg="500 POST snapshot key: only ED25519 supported by this cryptoservice" go.version=go1.19.8 gun=gun +time="2025-02-09T02:48:40Z" level=error msg="500 GET timestamp key: only ED25519 supported by this cryptoservice" go.version=go1.19.8 gun=gun +time="2025-02-09T02:48:40Z" level=error msg="500 GET snapshot key: only ED25519 supported by this cryptoservice" go.version=go1.19.8 gun=gun +time="2025-02-09T02:48:40Z" level=error msg="500 POST timestamp key: only ED25519 supported by this cryptoservice" go.version=go1.19.8 gun=gun +time="2025-02-09T02:48:40Z" 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="2024-01-07T20:21:11Z" level=info msg="404 GET root role" go.version=go1.19.8 gun=gun ---- PASS: TestGetHandlerRoot (0.08s) +time="2025-02-09T02:48:40Z" level=info msg="404 GET root role" go.version=go1.19.8 gun=gun +--- PASS: TestGetHandlerRoot (0.04s) === RUN TestGetHandlerTimestamp ---- PASS: TestGetHandlerTimestamp (0.08s) +--- PASS: TestGetHandlerTimestamp (0.04s) === RUN TestGetHandlerSnapshot ---- PASS: TestGetHandlerSnapshot (0.08s) +--- PASS: TestGetHandlerSnapshot (0.04s) === RUN TestGetHandler404 -time="2024-01-07T20:21:11Z" level=info msg="404 GET root role" go.version=go1.19.8 gun=gun +time="2025-02-09T02:48:40Z" level=info msg="404 GET root role" go.version=go1.19.8 gun=gun --- PASS: TestGetHandler404 (0.00s) === RUN TestGetHandlerNilData -time="2024-01-07T20:21:11Z" level=info msg="404 GET root role" go.version=go1.19.8 gun=gun +time="2025-02-09T02:48:40Z" level=info msg="404 GET root role" go.version=go1.19.8 gun=gun --- PASS: TestGetHandlerNilData (0.00s) === RUN TestGetHandlerNoStorage -time="2024-01-07T20:21:11Z" level=error msg="500 GET: no storage exists" =gun go.version=go1.19.8 +time="2025-02-09T02:48:40Z" level=error msg="500 GET: no storage exists" =gun go.version=go1.19.8 --- PASS: TestGetHandlerNoStorage (0.00s) === RUN TestAtomicUpdateValidationFailurePropagated ---- PASS: TestAtomicUpdateValidationFailurePropagated (0.14s) +--- PASS: TestAtomicUpdateValidationFailurePropagated (0.06s) === RUN TestAtomicUpdateNonValidationFailureNotPropagated -time="2024-01-07T20:21:11Z" level=info msg="400 POST error validating update" go.version=go1.19.8 testGUN=gun ---- PASS: TestAtomicUpdateNonValidationFailureNotPropagated (0.14s) +time="2025-02-09T02:48:40Z" level=info msg="400 POST error validating update" go.version=go1.19.8 testGUN=gun +--- PASS: TestAtomicUpdateNonValidationFailureNotPropagated (0.04s) === RUN TestAtomicUpdateVersionErrorPropagated -time="2024-01-07T20:21:11Z" level=info msg="400 POST old version error" go.version=go1.19.8 testGUN=gun ---- PASS: TestAtomicUpdateVersionErrorPropagated (0.28s) +time="2025-02-09T02:48:40Z" level=info msg="400 POST old version error" go.version=go1.19.8 testGUN=gun +--- PASS: TestAtomicUpdateVersionErrorPropagated (0.07s) === RUN TestGetMaybeServerSignedNoCrypto --- PASS: TestGetMaybeServerSignedNoCrypto (0.00s) === RUN TestGetMaybeServerSignedNoKey --- PASS: TestGetMaybeServerSignedNoKey (0.00s) === RUN TestValidateEmptyNew ---- PASS: TestValidateEmptyNew (0.22s) +--- PASS: TestValidateEmptyNew (0.07s) === RUN TestValidateRootCanContainOnlyx509KeysWithRightGun ---- PASS: TestValidateRootCanContainOnlyx509KeysWithRightGun (0.22s) +--- PASS: TestValidateRootCanContainOnlyx509KeysWithRightGun (0.10s) === RUN TestValidatePrevTimestamp ---- PASS: TestValidatePrevTimestamp (0.17s) +--- PASS: TestValidatePrevTimestamp (0.08s) === RUN TestValidatePreviousTimestampCorrupt -time="2024-01-07T20:21:12Z" level=error msg="Failed to unmarshal existing timestamp for GUN docker.com/notary" ---- PASS: TestValidatePreviousTimestampCorrupt (0.15s) +time="2025-02-09T02:48:40Z" level=error msg="Failed to unmarshal existing timestamp for GUN docker.com/notary" +--- PASS: TestValidatePreviousTimestampCorrupt (0.07s) === RUN TestValidateGetCurrentTimestampBroken ---- PASS: TestValidateGetCurrentTimestampBroken (0.15s) +--- PASS: TestValidateGetCurrentTimestampBroken (0.04s) === RUN TestValidateNoNewRoot ---- PASS: TestValidateNoNewRoot (0.16s) +--- PASS: TestValidateNoNewRoot (0.04s) === RUN TestValidateNoNewTargets ---- PASS: TestValidateNoNewTargets (0.18s) +--- PASS: TestValidateNoNewTargets (0.04s) === RUN TestValidateOnlySnapshot ---- PASS: TestValidateOnlySnapshot (0.16s) +--- PASS: TestValidateOnlySnapshot (0.04s) === RUN TestValidateOldRoot ---- PASS: TestValidateOldRoot (0.15s) +--- PASS: TestValidateOldRoot (0.06s) === RUN TestValidateOldRootCorrupt ---- PASS: TestValidateOldRootCorrupt (0.06s) +--- PASS: TestValidateOldRootCorrupt (0.03s) === RUN TestValidateOldRootCorruptRootRole ---- PASS: TestValidateOldRootCorruptRootRole (0.11s) +--- PASS: TestValidateOldRootCorruptRootRole (0.03s) === RUN TestValidateRootGetCurrentRootBroken ---- PASS: TestValidateRootGetCurrentRootBroken (0.11s) +--- PASS: TestValidateRootGetCurrentRootBroken (0.03s) === RUN TestValidateRootRotationWithOldSigs ---- PASS: TestValidateRootRotationWithOldSigs (0.51s) +--- PASS: TestValidateRootRotationWithOldSigs (0.14s) === RUN TestValidateRootRotationMultipleKeysThreshold1 ---- PASS: TestValidateRootRotationMultipleKeysThreshold1 (0.25s) +--- PASS: TestValidateRootRotationMultipleKeysThreshold1 (0.12s) === RUN TestRootRotationNotSignedWithOldKeysForOldRole ---- PASS: TestRootRotationNotSignedWithOldKeysForOldRole (0.33s) +--- PASS: TestRootRotationNotSignedWithOldKeysForOldRole (0.12s) === RUN TestRootRotationVersionIncrement ---- PASS: TestRootRotationVersionIncrement (0.27s) +--- PASS: TestRootRotationVersionIncrement (0.08s) === RUN TestValidateNoRoot ---- PASS: TestValidateNoRoot (0.16s) +--- PASS: TestValidateNoRoot (0.03s) === RUN TestValidateSnapshotMissingNoSnapshotKey ---- PASS: TestValidateSnapshotMissingNoSnapshotKey (0.18s) +--- PASS: TestValidateSnapshotMissingNoSnapshotKey (0.04s) === RUN TestValidateSnapshotGenerateNoPrev ---- PASS: TestValidateSnapshotGenerateNoPrev (0.20s) +--- PASS: TestValidateSnapshotGenerateNoPrev (0.05s) === RUN TestValidateSnapshotGenerateWithPrev ---- PASS: TestValidateSnapshotGenerateWithPrev (0.17s) +--- PASS: TestValidateSnapshotGenerateWithPrev (0.05s) === RUN TestValidateSnapshotGeneratePrevCorrupt -time="2024-01-07T20:21:15Z" level=error msg="Failed to unmarshal existing snapshot for GUN docker.com/notary" ---- PASS: TestValidateSnapshotGeneratePrevCorrupt (0.17s) +time="2025-02-09T02:48:41Z" level=error msg="Failed to unmarshal existing snapshot for GUN docker.com/notary" +--- PASS: TestValidateSnapshotGeneratePrevCorrupt (0.05s) === RUN TestValidateSnapshotGenerateStoreGetCurrentSnapshotBroken ---- PASS: TestValidateSnapshotGenerateStoreGetCurrentSnapshotBroken (0.20s) +--- PASS: TestValidateSnapshotGenerateStoreGetCurrentSnapshotBroken (0.05s) === RUN TestValidateSnapshotGenerateNoTargets ---- PASS: TestValidateSnapshotGenerateNoTargets (0.18s) +--- PASS: TestValidateSnapshotGenerateNoTargets (0.06s) === RUN TestValidateSnapshotGenerate ---- PASS: TestValidateSnapshotGenerate (0.22s) +--- PASS: TestValidateSnapshotGenerate (0.05s) === RUN TestValidateRootNoTimestampKey ---- PASS: TestValidateRootNoTimestampKey (0.18s) +--- PASS: TestValidateRootNoTimestampKey (0.04s) === RUN TestValidateRootInvalidTimestampKey ---- PASS: TestValidateRootInvalidTimestampKey (0.15s) +--- PASS: TestValidateRootInvalidTimestampKey (0.04s) === RUN TestValidateRootInvalidTimestampThreshold ---- PASS: TestValidateRootInvalidTimestampThreshold (0.22s) +--- PASS: TestValidateRootInvalidTimestampThreshold (0.05s) === RUN TestValidateRootInvalidZeroThreshold ---- PASS: TestValidateRootInvalidZeroThreshold (0.63s) +--- PASS: TestValidateRootInvalidZeroThreshold (0.12s) === RUN TestValidateRootRoleMissing ---- PASS: TestValidateRootRoleMissing (0.19s) +--- PASS: TestValidateRootRoleMissing (0.03s) === RUN TestValidateTargetsRoleMissing ---- PASS: TestValidateTargetsRoleMissing (0.14s) +--- PASS: TestValidateTargetsRoleMissing (0.03s) === RUN TestValidateSnapshotRoleMissing ---- PASS: TestValidateSnapshotRoleMissing (0.16s) +--- PASS: TestValidateSnapshotRoleMissing (0.03s) === RUN TestValidateRootSigMissing ---- PASS: TestValidateRootSigMissing (0.11s) +--- PASS: TestValidateRootSigMissing (0.03s) === RUN TestValidateTargetsSigMissing -time="2024-01-07T20:21:18Z" level=error msg="ErrBadTargets: tuf: data has no signatures" ---- PASS: TestValidateTargetsSigMissing (0.17s) +time="2025-02-09T02:48:42Z" level=error msg="ErrBadTargets: tuf: data has no signatures" +--- PASS: TestValidateTargetsSigMissing (0.03s) === RUN TestValidateSnapshotSigMissing ---- PASS: TestValidateSnapshotSigMissing (0.18s) +--- PASS: TestValidateSnapshotSigMissing (0.04s) === RUN TestValidateRootCorrupt ---- PASS: TestValidateRootCorrupt (0.14s) +--- PASS: TestValidateRootCorrupt (0.03s) === RUN TestValidateTargetsCorrupt -time="2024-01-07T20:21:18Z" level=error msg="ErrBadTargets: invalid character '\\u0084' looking for beginning of value" ---- PASS: TestValidateTargetsCorrupt (0.18s) +time="2025-02-09T02:48:42Z" level=error msg="ErrBadTargets: invalid character '\\u0084' looking for beginning of value" +--- PASS: TestValidateTargetsCorrupt (0.03s) === RUN TestValidateSnapshotCorrupt ---- PASS: TestValidateSnapshotCorrupt (0.18s) +--- PASS: TestValidateSnapshotCorrupt (0.04s) === RUN TestValidateRootModifiedSize ---- PASS: TestValidateRootModifiedSize (0.17s) +--- PASS: TestValidateRootModifiedSize (0.03s) === RUN TestValidateTargetsModifiedSize ---- PASS: TestValidateTargetsModifiedSize (0.17s) +--- PASS: TestValidateTargetsModifiedSize (0.04s) === RUN TestValidateRootModifiedHash ---- PASS: TestValidateRootModifiedHash (0.15s) +--- PASS: TestValidateRootModifiedHash (0.04s) === RUN TestValidateTargetsModifiedHash ---- PASS: TestValidateTargetsModifiedHash (0.10s) +--- PASS: TestValidateTargetsModifiedHash (0.04s) === RUN TestGenerateSnapshotRootNotLoaded --- PASS: TestGenerateSnapshotRootNotLoaded (0.00s) === RUN TestGenerateSnapshotNoKey ---- PASS: TestGenerateSnapshotNoKey (0.25s) +--- PASS: TestGenerateSnapshotNoKey (0.03s) === RUN TestLoadTargetsLoadsNothingIfNoUpdates ---- PASS: TestLoadTargetsLoadsNothingIfNoUpdates (0.12s) +--- PASS: TestLoadTargetsLoadsNothingIfNoUpdates (0.03s) === RUN TestValidateTargetsRequiresStoredParent -time="2024-01-07T20:21:20Z" level=error msg="ErrBadTargets: targets must be loaded first" ---- PASS: TestValidateTargetsRequiresStoredParent (0.15s) +time="2025-02-09T02:48:42Z" level=error msg="ErrBadTargets: targets must be loaded first" +--- PASS: TestValidateTargetsRequiresStoredParent (0.04s) === RUN TestValidateTargetsParentInUpdate -time="2024-01-07T20:21:20Z" level=error msg="ErrBadTargets: invalid character 'I' looking for beginning of value" ---- PASS: TestValidateTargetsParentInUpdate (0.16s) +time="2025-02-09T02:48:42Z" level=error msg="ErrBadTargets: invalid character 'I' looking for beginning of value" +--- PASS: TestValidateTargetsParentInUpdate (0.04s) === RUN TestValidateTargetsRoleNotInParent -time="2024-01-07T20:21:20Z" level=error msg="ErrBadTargets: tuf: invalid role targets/level1. delegation does not exist" -time="2024-01-07T20:21:20Z" level=error msg="ErrBadTargets: targets has already been loaded" -time="2024-01-07T20:21:20Z" level=error msg="ErrBadTargets: tuf: invalid role targets/level1. delegation does not exist" ---- PASS: TestValidateTargetsRoleNotInParent (0.15s) +time="2025-02-09T02:48:42Z" level=error msg="ErrBadTargets: tuf: invalid role targets/level1. delegation does not exist" +time="2025-02-09T02:48:42Z" level=error msg="ErrBadTargets: targets has already been loaded" +time="2025-02-09T02:48:42Z" level=error msg="ErrBadTargets: tuf: invalid role targets/level1. delegation does not exist" +--- PASS: TestValidateTargetsRoleNotInParent (0.05s) PASS -ok github.com/theupdateframework/notary/server/handlers 9.742s +ok github.com/theupdateframework/notary/server/handlers 2.697s === RUN TestSnapshotExpired --- PASS: TestSnapshotExpired (0.00s) === RUN TestSnapshotNotExpired --- PASS: TestSnapshotNotExpired (0.00s) === RUN TestGetSnapshotKeyCreate ---- PASS: TestGetSnapshotKeyCreate (0.07s) +--- PASS: TestGetSnapshotKeyCreate (0.04s) === RUN TestGetSnapshotKeyCreateWithFailingStore -time="2024-01-07T20:21:08Z" level=error msg="Error when retrieving root role for GUN gun: failing store failed" +time="2025-02-09T02:48:38Z" level=error msg="Error when retrieving root role for GUN gun: failing store failed" --- PASS: TestGetSnapshotKeyCreateWithFailingStore (0.00s) === RUN TestGetSnapshotKeyCreateWithCorruptedStore -time="2024-01-07T20:21:08Z" level=error msg="Failed to unmarshal existing root for GUN gun to retrieve snapshot key ID" +time="2025-02-09T02:48:38Z" level=error msg="Failed to unmarshal existing root for GUN gun to retrieve snapshot key ID" --- PASS: TestGetSnapshotKeyCreateWithCorruptedStore (0.00s) === RUN TestGetSnapshotKeyCreateWithInvalidAlgo --- PASS: TestGetSnapshotKeyCreateWithInvalidAlgo (0.00s) === RUN TestGetSnapshotKeyExistingMetadata --- PASS: TestGetSnapshotKeyExistingMetadata (0.05s) === RUN TestGetSnapshotNoPreviousSnapshot -time="2024-01-07T20:21:08Z" level=error msg="Failed to unmarshal existing snapshot for GUN gun" +time="2025-02-09T02:48:38Z" level=error msg="Failed to unmarshal existing snapshot for GUN gun" --- PASS: TestGetSnapshotNoPreviousSnapshot (0.04s) === RUN TestGetSnapshotReturnsPreviousSnapshotIfUnexpired ---- PASS: TestGetSnapshotReturnsPreviousSnapshotIfUnexpired (0.09s) +--- PASS: TestGetSnapshotReturnsPreviousSnapshotIfUnexpired (0.02s) === RUN TestGetSnapshotOldSnapshotExpired ---- PASS: TestGetSnapshotOldSnapshotExpired (0.15s) +--- PASS: TestGetSnapshotOldSnapshotExpired (0.05s) === RUN TestCannotMakeNewSnapshotIfNoRoot ---- PASS: TestCannotMakeNewSnapshotIfNoRoot (0.04s) +--- PASS: TestCannotMakeNewSnapshotIfNoRoot (0.03s) === RUN TestCreateSnapshotNoKeyInCrypto ---- PASS: TestCreateSnapshotNoKeyInCrypto (0.07s) +--- PASS: TestCreateSnapshotNoKeyInCrypto (0.04s) PASS -ok github.com/theupdateframework/notary/server/snapshot 0.523s +ok github.com/theupdateframework/notary/server/snapshot 0.289s === RUN TestMemoryUpdateCurrentEmpty --- PASS: TestMemoryUpdateCurrentEmpty (0.00s) === RUN TestMemoryUpdateCurrentVersionCheckOldVersionExists @@ -3002,35 +3038,35 @@ === RUN TestRDBTUFFileJSONUnmarshallingFailure --- PASS: TestRDBTUFFileJSONUnmarshallingFailure (0.00s) === RUN TestSQLUpdateCurrentEmpty ---- PASS: TestSQLUpdateCurrentEmpty (0.20s) +--- PASS: TestSQLUpdateCurrentEmpty (0.07s) === RUN TestSQLUpdateCurrentVersionCheckOldVersionExists ---- PASS: TestSQLUpdateCurrentVersionCheckOldVersionExists (0.08s) +--- PASS: TestSQLUpdateCurrentVersionCheckOldVersionExists (0.04s) === RUN TestSQLUpdateCurrentVersionCheckOldVersionNotExist ---- PASS: TestSQLUpdateCurrentVersionCheckOldVersionNotExist (0.05s) +--- PASS: TestSQLUpdateCurrentVersionCheckOldVersionNotExist (0.09s) === RUN TestSQLUpdateManyNoConflicts ---- PASS: TestSQLUpdateManyNoConflicts (0.18s) +--- PASS: TestSQLUpdateManyNoConflicts (0.09s) === RUN TestSQLUpdateManyConflictRollback ---- PASS: TestSQLUpdateManyConflictRollback (0.04s) +--- PASS: TestSQLUpdateManyConflictRollback (0.11s) === RUN TestSQLDelete ---- PASS: TestSQLDelete (0.18s) +--- PASS: TestSQLDelete (0.07s) === RUN TestSQLDBCheckHealthTableMissing --- PASS: TestSQLDBCheckHealthTableMissing (0.04s) === RUN TestSQLDBCheckHealthDBConnectionFail --- PASS: TestSQLDBCheckHealthDBConnectionFail (0.03s) === RUN TestSQLDBCheckHealthSucceeds ---- PASS: TestSQLDBCheckHealthSucceeds (0.03s) +--- PASS: TestSQLDBCheckHealthSucceeds (0.02s) === RUN TestSQLDBGetChecksum ---- PASS: TestSQLDBGetChecksum (0.09s) +--- PASS: TestSQLDBGetChecksum (0.02s) === RUN TestSQLDBGetChecksumNotFound ---- PASS: TestSQLDBGetChecksumNotFound (0.08s) +--- PASS: TestSQLDBGetChecksumNotFound (0.01s) === RUN TestSQLTUFMetaStoreGetCurrent ---- PASS: TestSQLTUFMetaStoreGetCurrent (0.22s) +--- PASS: TestSQLTUFMetaStoreGetCurrent (0.12s) === RUN TestSQLGetChanges ---- PASS: TestSQLGetChanges (0.20s) +--- PASS: TestSQLGetChanges (0.06s) === RUN TestSQLDBGetVersion ---- PASS: TestSQLDBGetVersion (0.04s) +--- PASS: TestSQLDBGetVersion (0.02s) PASS -ok github.com/theupdateframework/notary/server/storage 1.501s +ok github.com/theupdateframework/notary/server/storage 0.814s === RUN TestTimestampExpired --- PASS: TestTimestampExpired (0.00s) === RUN TestTimestampNotExpired @@ -3038,33 +3074,33 @@ === RUN TestGetTimestampKey --- PASS: TestGetTimestampKey (0.04s) === RUN TestGetTimestampNoPreviousTimestamp -time="2024-01-07T20:21:12Z" level=error msg="Failed to unmarshal existing timestamp" ---- PASS: TestGetTimestampNoPreviousTimestamp (0.11s) +time="2025-02-09T02:48:39Z" level=error msg="Failed to unmarshal existing timestamp" +--- PASS: TestGetTimestampNoPreviousTimestamp (0.08s) === RUN TestGetTimestampReturnsPreviousTimestampIfUnexpired ---- PASS: TestGetTimestampReturnsPreviousTimestampIfUnexpired (0.10s) +--- PASS: TestGetTimestampReturnsPreviousTimestampIfUnexpired (0.06s) === RUN TestGetTimestampOldTimestampExpired ---- PASS: TestGetTimestampOldTimestampExpired (0.12s) +--- PASS: TestGetTimestampOldTimestampExpired (0.15s) === RUN TestCannotMakeNewTimestampIfNoRootOrSnapshot -time="2024-01-07T20:21:12Z" level=error msg="Failed to create a new timestamp" -time="2024-01-07T20:21:12Z" level=error msg="Failed to create a new timestamp" ---- PASS: TestCannotMakeNewTimestampIfNoRootOrSnapshot (0.09s) +time="2025-02-09T02:48:39Z" level=error msg="Failed to create a new timestamp" +time="2025-02-09T02:48:39Z" level=error msg="Failed to create a new timestamp" +--- PASS: TestCannotMakeNewTimestampIfNoRootOrSnapshot (0.05s) === RUN TestCreateTimestampNoKeyInCrypto -time="2024-01-07T20:21:12Z" level=error msg="Failed to create a new timestamp" ---- PASS: TestCreateTimestampNoKeyInCrypto (0.07s) +time="2025-02-09T02:48:39Z" level=error msg="Failed to create a new timestamp" +--- PASS: TestCreateTimestampNoKeyInCrypto (0.06s) === RUN TestGetTimestampKeyCreateWithFailingStore -time="2024-01-07T20:21:12Z" level=error msg="Error when retrieving root role for GUN gun: failing store failed" +time="2025-02-09T02:48:39Z" level=error msg="Error when retrieving root role for GUN gun: failing store failed" --- PASS: TestGetTimestampKeyCreateWithFailingStore (0.00s) === RUN TestGetTimestampKeyCreateWithCorruptedStore -time="2024-01-07T20:21:12Z" level=error msg="Failed to unmarshal existing root for GUN gun to retrieve timestamp key ID" +time="2025-02-09T02:48:39Z" 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.04s) +--- PASS: TestGetTimestampKeyExistingMetadata (0.02s) PASS -ok github.com/theupdateframework/notary/server/timestamp 0.583s +ok github.com/theupdateframework/notary/server/timestamp 0.494s === RUN TestHealthCheckKMUnhealthy ---- PASS: TestHealthCheckKMUnhealthy (0.00s) +--- PASS: TestHealthCheckKMUnhealthy (0.01s) === RUN TestHealthCheckSignerUnhealthy --- PASS: TestHealthCheckSignerUnhealthy (0.00s) === RUN TestHealthCheckKMTimeout @@ -3072,7 +3108,7 @@ === RUN TestHealthCheckSignerTimeout --- PASS: TestHealthCheckSignerTimeout (0.00s) === RUN TestHealthCheckKMHealthy ---- PASS: TestHealthCheckKMHealthy (0.01s) +--- PASS: TestHealthCheckKMHealthy (0.00s) === RUN TestHealthCheckSignerHealthy --- PASS: TestHealthCheckSignerHealthy (0.00s) === RUN TestHealthCheckKMConnectionDied @@ -3080,33 +3116,33 @@ === RUN TestHealthCheckSignerConnectionDied --- PASS: TestHealthCheckSignerConnectionDied (0.00s) === RUN TestHealthCheckForOverallStatus ---- PASS: TestHealthCheckForOverallStatus (0.01s) +--- PASS: TestHealthCheckForOverallStatus (0.00s) === RUN TestHealthCheckNonexistentService --- PASS: TestHealthCheckNonexistentService (0.00s) === RUN TestGetPrivateKeyAndSignWithExistingKey -time="2024-01-07T20:21:15Z" level=info msg="Sign: Signed message! with KeyID f76f9ac80fc50c64cf70ddd89398316431d7c7d5524576206d3581cac73c23d8" go.version=go1.19.8 ---- PASS: TestGetPrivateKeyAndSignWithExistingKey (0.07s) +time="2025-02-09T02:48:40Z" level=info msg="Sign: Signed message! with KeyID aa1421a22b43910f2c94d0c0c166eabb2a0ac5820bb7fe27702cc8c1e706ed0e" go.version=go1.19.8 +--- PASS: TestGetPrivateKeyAndSignWithExistingKey (0.03s) === RUN TestCannotSignWithKeyThatDoesntExist -time="2024-01-07T20:21:15Z" level=error msg="Sign: key cabcb3d6d240f0bff8c9320ba94bea152a37188abe4a4683bc8e8243d34cb217 not found" go.version=go1.19.8 +time="2025-02-09T02:48:40Z" level=error msg="Sign: key 18e380430427c8a3cd37f21940452141b9213694558c0398ac0d6c4fce8effeb not found" go.version=go1.19.8 --- PASS: TestCannotSignWithKeyThatDoesntExist (0.00s) === RUN TestCryptoSignerInterfaceBehavior -time="2024-01-07T20:21:15Z" level=error msg="GetKeyInfo: key nonexistent not found" go.version=go1.19.8 -time="2024-01-07T20:21:15Z" level=error msg="GetKeyInfo: key nonexistent not found" go.version=go1.19.8 -time="2024-01-07T20:21:15Z" level=info msg="CreateKey: Created KeyID acd913055b6a37ba4b153f5c4f814b8d3b84f609789242577ef5418293a4930b" go.version=go1.19.8 -time="2024-01-07T20:21:15Z" level=info msg="CreateKey: Created KeyID a8c1cd798e04122b98af2e033f7e5804bd12da11b0579ce3da5ffce4e54bd8ee" go.version=go1.19.8 -time="2024-01-07T20:21:15Z" level=error msg="GetKeyInfo: key acd913055b6a37ba4b153f5c4f814b8d3b84f609789242577ef5418293a4930b not found" go.version=go1.19.8 -time="2024-01-07T20:21:15Z" level=error msg="GetKeyInfo: key a8c1cd798e04122b98af2e033f7e5804bd12da11b0579ce3da5ffce4e54bd8ee not found" go.version=go1.19.8 ---- PASS: TestCryptoSignerInterfaceBehavior (0.03s) +time="2025-02-09T02:48:40Z" level=error msg="GetKeyInfo: key nonexistent not found" go.version=go1.19.8 +time="2025-02-09T02:48:40Z" level=error msg="GetKeyInfo: key nonexistent not found" go.version=go1.19.8 +time="2025-02-09T02:48:40Z" level=info msg="CreateKey: Created KeyID 8ca8bb7cd0a28c2e1c4c65d204c056f52aa7e9098ec6bcb060f7a553cb722207" go.version=go1.19.8 +time="2025-02-09T02:48:40Z" level=info msg="CreateKey: Created KeyID da5f289d7202a0d64e6f7a021bb979324c4a89435e5aec470b998958ec5f682d" go.version=go1.19.8 +time="2025-02-09T02:48:40Z" level=error msg="GetKeyInfo: key 8ca8bb7cd0a28c2e1c4c65d204c056f52aa7e9098ec6bcb060f7a553cb722207 not found" go.version=go1.19.8 +time="2025-02-09T02:48:40Z" level=error msg="GetKeyInfo: key da5f289d7202a0d64e6f7a021bb979324c4a89435e5aec470b998958ec5f682d not found" go.version=go1.19.8 +--- PASS: TestCryptoSignerInterfaceBehavior (0.02s) PASS -ok github.com/theupdateframework/notary/signer 0.166s +ok github.com/theupdateframework/notary/signer 0.087s ? github.com/theupdateframework/notary/signer/api [no test files] ? github.com/theupdateframework/notary/signer/client [no test files] === RUN TestGetSuccessPopulatesCache ---- PASS: TestGetSuccessPopulatesCache (0.04s) +--- PASS: TestGetSuccessPopulatesCache (0.05s) === RUN TestAddKeyPopulatesCacheIfSuccessful --- PASS: TestAddKeyPopulatesCacheIfSuccessful (0.01s) === RUN TestDeleteKeyRemovesKeyFromCache ---- PASS: TestDeleteKeyRemovesKeyFromCache (0.02s) +--- PASS: TestDeleteKeyRemovesKeyFromCache (0.01s) === RUN TestRDBPrivateKeyJSONUnmarshalling --- PASS: TestRDBPrivateKeyJSONUnmarshalling (0.00s) === RUN TestRDBPrivateKeyJSONUnmarshallingFailure @@ -3115,30 +3151,30 @@ `nodb` is not officially supported, running under compatibility mode. --- PASS: TestNewSQLKeyDBStorePropagatesDBError (0.00s) === RUN TestSQLDBHealthCheckMissingTable ---- PASS: TestSQLDBHealthCheckMissingTable (0.03s) +--- PASS: TestSQLDBHealthCheckMissingTable (0.06s) === RUN TestSQLDBHealthCheckNoConnection ---- PASS: TestSQLDBHealthCheckNoConnection (0.02s) +--- PASS: TestSQLDBHealthCheckNoConnection (0.03s) === RUN TestSQLKeyCanOnlyBeAddedOnce (/build/reproducible-path/notary-0.7.0+ds1/_build/src/github.com/theupdateframework/notary/signer/keydbstore/sql_keydbstore.go:98) -[2024-01-07 20:21:15]  UNIQUE constraint failed: private_keys.key_id  ---- PASS: TestSQLKeyCanOnlyBeAddedOnce (0.14s) +[2025-02-09 02:48:39]  UNIQUE constraint failed: private_keys.key_id  +--- PASS: TestSQLKeyCanOnlyBeAddedOnce (0.11s) === RUN TestSQLCreateDelete ---- PASS: TestSQLCreateDelete (0.42s) +--- PASS: TestSQLCreateDelete (0.26s) === RUN TestSQLKeyRotation ---- PASS: TestSQLKeyRotation (0.36s) +--- PASS: TestSQLKeyRotation (0.23s) === RUN TestSQLSigningMarksKeyActive -time="2024-01-07T20:21:17Z" level=error msg="Key a516bd610555f57e47ff473837563ea3ea2a1a10f05138dd775906dd88e8a8f8 was just used to sign hash successful, db closed, error when trying to mark key as active: sql: database is closed" +time="2025-02-09T02:48:39Z" level=error msg="Key 606c5b5bdb24e9f82d01f0137ac477f8d51ec80598c0c2dac4b1d8da99e72f26 was just used to sign hash successful, db closed, error when trying to mark key as active: sql: database is closed" (/build/reproducible-path/notary-0.7.0+ds1/_build/src/github.com/theupdateframework/notary/signer/keydbstore/sql_keydbstore.go:197) -[2024-01-07 20:21:17]  sql: database is closed  ---- PASS: TestSQLSigningMarksKeyActive (0.59s) +[2025-02-09 02:48:39]  sql: database is closed  +--- PASS: TestSQLSigningMarksKeyActive (0.27s) === RUN TestSQLCreateKey ---- PASS: TestSQLCreateKey (0.33s) +--- PASS: TestSQLCreateKey (0.28s) === RUN TestSQLUnimplementedInterfaceBehavior ---- PASS: TestSQLUnimplementedInterfaceBehavior (0.19s) +--- PASS: TestSQLUnimplementedInterfaceBehavior (0.11s) PASS -ok github.com/theupdateframework/notary/signer/keydbstore 2.202s +ok github.com/theupdateframework/notary/signer/keydbstore 1.435s === RUN TestSet --- PASS: TestSet (0.00s) === RUN TestSetWithNoParentDirectory @@ -3166,13 +3202,13 @@ === RUN TestGetData --- PASS: TestGetData (0.00s) === RUN TestCreateDirectory ---- PASS: TestCreateDirectory (0.01s) +--- PASS: TestCreateDirectory (0.00s) === RUN TestCreatePrivateDirectory --- PASS: TestCreatePrivateDirectory (0.00s) === RUN TestFileStoreConsistency --- PASS: TestFileStoreConsistency (0.00s) === RUN TestHTTPStoreGetSized ---- PASS: TestHTTPStoreGetSized (0.01s) +--- PASS: TestHTTPStoreGetSized (0.00s) === RUN TestHTTPStoreGetAllMeta --- PASS: TestHTTPStoreGetAllMeta (0.00s) === RUN TestSetSingleAndSetMultiMeta @@ -3180,7 +3216,7 @@ === RUN Test404Error --- PASS: Test404Error (0.00s) === RUN Test50XErrors ---- PASS: Test50XErrors (0.01s) +--- PASS: Test50XErrors (0.02s) === RUN Test400Error --- PASS: Test400Error (0.00s) === RUN TestTranslateErrorsParse400Errors @@ -3196,7 +3232,7 @@ === RUN TestHTTPStoreGetKey --- PASS: TestHTTPStoreGetKey (0.00s) === RUN TestHTTPStoreGetRotateKeySizeLimited ---- PASS: TestHTTPStoreGetRotateKeySizeLimited (0.11s) +--- PASS: TestHTTPStoreGetRotateKeySizeLimited (0.00s) === RUN TestHTTPOffline --- PASS: TestHTTPOffline (0.00s) === RUN TestErrServerUnavailable @@ -3217,7 +3253,7 @@ === RUN TestMemoryStoreMetadata --- PASS: TestMemoryStoreMetadata (0.00s) PASS -ok github.com/theupdateframework/notary/storage 0.212s +ok github.com/theupdateframework/notary/storage 0.061s ? github.com/theupdateframework/notary/storage/rethinkdb [no test files] === RUN TestExportKeys --- PASS: TestExportKeys (0.00s) @@ -3232,142 +3268,142 @@ === RUN TestImportNoPath --- PASS: TestImportNoPath (0.01s) === RUN TestNonRootPathInference ---- PASS: TestNonRootPathInference (0.02s) +--- PASS: TestNonRootPathInference (0.01s) === RUN TestBlockHeaderPrecedenceRoleAndGun ---- PASS: TestBlockHeaderPrecedenceRoleAndGun (0.03s) +--- PASS: TestBlockHeaderPrecedenceRoleAndGun (0.01s) === RUN TestBlockHeaderPrecedenceGunFromPath ---- PASS: TestBlockHeaderPrecedenceGunFromPath (0.02s) +--- PASS: TestBlockHeaderPrecedenceGunFromPath (0.00s) === RUN TestImportKeys2InOneFile --- PASS: TestImportKeys2InOneFile (0.00s) === RUN TestImportKeys2InOneFileNoPath ---- PASS: TestImportKeys2InOneFileNoPath (0.04s) +--- PASS: TestImportKeys2InOneFileNoPath (0.01s) === RUN TestEncryptedKeyImportFail -time="2024-01-07T20:21:17Z" 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.06s) +time="2025-02-09T02:48:37Z" 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.03s) +--- PASS: TestEncryptedKeyImportSuccess (0.02s) === RUN TestEncryption ---- PASS: TestEncryption (0.03s) +--- PASS: TestEncryption (0.02s) === RUN TestAddKey ---- PASS: TestAddKey (0.05s) +--- PASS: TestAddKey (0.04s) === RUN TestKeyStoreInternalState --- PASS: TestKeyStoreInternalState (0.02s) === RUN TestGet --- PASS: TestGet (0.01s) === RUN TestGetLegacyKey ---- PASS: TestGetLegacyKey (0.01s) +--- PASS: TestGetLegacyKey (0.00s) === RUN TestListKeys --- PASS: TestListKeys (0.06s) === RUN TestAddGetKeyMemStore ---- PASS: TestAddGetKeyMemStore (0.01s) +--- PASS: TestAddGetKeyMemStore (0.02s) === RUN TestAddGetKeyInfoMemStore ---- PASS: TestAddGetKeyInfoMemStore (0.03s) +--- PASS: TestAddGetKeyInfoMemStore (0.07s) === RUN TestGetDecryptedWithTamperedCipherText -time="2024-01-07T20:21:17Z" level=error msg="PEM block is empty" +time="2025-02-09T02:48:38Z" level=error msg="PEM block is empty" --- PASS: TestGetDecryptedWithTamperedCipherText (0.02s) === RUN TestGetDecryptedWithInvalidPassphrase ---- PASS: TestGetDecryptedWithInvalidPassphrase (0.06s) +--- PASS: TestGetDecryptedWithInvalidPassphrase (0.05s) === RUN TestGetDecryptedWithConsistentlyInvalidPassphrase --- PASS: TestGetDecryptedWithConsistentlyInvalidPassphrase (0.08s) === RUN TestRemoveKey ---- PASS: TestRemoveKey (0.10s) +--- PASS: TestRemoveKey (0.05s) === RUN TestKeysAreCached ---- PASS: TestKeysAreCached (0.05s) +--- PASS: TestKeysAreCached (0.02s) PASS -ok github.com/theupdateframework/notary/trustmanager 0.787s +ok github.com/theupdateframework/notary/trustmanager 0.563s === RUN TestRemoteStore -time="2024-01-07T20:21:18Z" level=info msg="listing files from localhost:9888" -time="2024-01-07T20:21:18Z" level=info msg="listing files from localhost:9888" ---- PASS: TestRemoteStore (0.22s) +time="2025-02-09T02:48:40Z" level=info msg="listing files from localhost:9888" +time="2025-02-09T02:48:40Z" level=info msg="listing files from localhost:9888" +--- PASS: TestRemoteStore (0.08s) === RUN TestErrors -time="2024-01-07T20:21:18Z" level=error msg="failed to store: test error" ---- PASS: TestErrors (0.28s) +time="2025-02-09T02:48:40Z" level=error msg="failed to store: test error" +--- PASS: TestErrors (0.09s) === RUN TestNewGRPCStorage --- PASS: TestNewGRPCStorage (0.00s) === RUN TestGRPCStorage --- PASS: TestGRPCStorage (0.00s) PASS -ok github.com/theupdateframework/notary/trustmanager/remoteks 0.536s +ok github.com/theupdateframework/notary/trustmanager/remoteks 0.172s ? github.com/theupdateframework/notary/trustmanager/yubikey [no test files] === RUN TestWildcardMatch --- PASS: TestWildcardMatch (0.00s) === RUN TestValidateRoot -2024/01/07 20:21:21 [INFO] generate received request -2024/01/07 20:21:21 [INFO] received CSR -2024/01/07 20:21:21 [INFO] generating key: ecdsa-256 -2024/01/07 20:21:21 [INFO] encoded CSR -2024/01/07 20:21:21 [INFO] signed certificate with serial number 492832398854721915900412201485362814678257216714 -2024/01/07 20:21:21 [INFO] received CSR -2024/01/07 20:21:21 [INFO] generating key: ecdsa-256 -2024/01/07 20:21:21 [INFO] encoded CSR -2024/01/07 20:21:21 [INFO] signed certificate with serial number 147931584691757251009281886560929970750313370003 -2024/01/07 20:21:21 [INFO] received CSR -2024/01/07 20:21:21 [INFO] generating key: ecdsa-256 -2024/01/07 20:21:21 [INFO] encoded CSR -2024/01/07 20:21:21 [INFO] signed certificate with serial number 612007071724347546996902463994931801106913838306 ---- PASS: TestValidateRoot (0.37s) +2025/02/09 02:48:39 [INFO] generate received request +2025/02/09 02:48:39 [INFO] received CSR +2025/02/09 02:48:39 [INFO] generating key: ecdsa-256 +2025/02/09 02:48:39 [INFO] encoded CSR +2025/02/09 02:48:39 [INFO] signed certificate with serial number 562459070273170902253179681903447314377611681742 +2025/02/09 02:48:39 [INFO] received CSR +2025/02/09 02:48:39 [INFO] generating key: ecdsa-256 +2025/02/09 02:48:39 [INFO] encoded CSR +2025/02/09 02:48:39 [INFO] signed certificate with serial number 504037186862097022570879776396071255536244235274 +2025/02/09 02:48:39 [INFO] received CSR +2025/02/09 02:48:39 [INFO] generating key: ecdsa-256 +2025/02/09 02:48:39 [INFO] encoded CSR +2025/02/09 02:48:39 [INFO] signed certificate with serial number 418267270604293237458341438309360511553551523525 +--- PASS: TestValidateRoot (0.22s) === RUN TestValidateRootWithoutTOFUS --- PASS: TestValidateRootWithoutTOFUS (0.00s) === RUN TestValidateRootWithPinnedCert ---- PASS: TestValidateRootWithPinnedCert (0.03s) +--- PASS: TestValidateRootWithPinnedCert (0.01s) === RUN TestValidateRootWithPinnedCertAndIntermediates ---- PASS: TestValidateRootWithPinnedCertAndIntermediates (0.18s) +--- PASS: TestValidateRootWithPinnedCertAndIntermediates (0.07s) === RUN TestValidateRootFailuresWithPinnedCert ---- PASS: TestValidateRootFailuresWithPinnedCert (0.02s) +--- PASS: TestValidateRootFailuresWithPinnedCert (0.01s) === RUN TestValidateRootWithPinnedCA ---- PASS: TestValidateRootWithPinnedCA (0.21s) +--- PASS: TestValidateRootWithPinnedCA (0.10s) === RUN TestValidateSuccessfulRootRotation ---- PASS: TestValidateSuccessfulRootRotation (0.45s) +--- PASS: TestValidateSuccessfulRootRotation (0.18s) === RUN TestValidateRootRotationMissingOrigSig ---- PASS: TestValidateRootRotationMissingOrigSig (0.24s) +--- PASS: TestValidateRootRotationMissingOrigSig (0.12s) === RUN TestValidateRootRotationMissingNewSig ---- PASS: TestValidateRootRotationMissingNewSig (0.16s) +--- PASS: TestValidateRootRotationMissingNewSig (0.12s) === RUN TestValidateRootRotationTrustPinning ---- PASS: TestValidateRootRotationTrustPinning (0.21s) +--- PASS: TestValidateRootRotationTrustPinning (0.10s) === RUN TestValidateRootRotationTrustPinningInvalidCA ---- PASS: TestValidateRootRotationTrustPinningInvalidCA (0.10s) +--- PASS: TestValidateRootRotationTrustPinningInvalidCA (0.08s) === RUN TestParsePEMPublicKey -time="2024-01-07T20:21:23Z" level=warning msg="certificate with CN notary is near expiry" ---- PASS: TestParsePEMPublicKey (0.05s) +time="2025-02-09T02:48:40Z" level=warning msg="certificate with CN notary is near expiry" +--- PASS: TestParsePEMPublicKey (0.02s) === RUN TestCheckingCertExpiry -time="2024-01-07T20:21:23Z" level=warning msg="certificate with CN notary is near expiry" ---- PASS: TestCheckingCertExpiry (0.05s) +time="2025-02-09T02:48:40Z" level=warning msg="certificate with CN notary is near expiry" +--- PASS: TestCheckingCertExpiry (0.03s) === RUN TestValidateRootWithExpiredIntermediate --- PASS: TestValidateRootWithExpiredIntermediate (0.02s) === RUN TestCheckingWildcardCert ---- PASS: TestCheckingWildcardCert (0.04s) +--- PASS: TestCheckingWildcardCert (0.03s) === RUN TestWildcardMatching --- PASS: TestWildcardMatching (0.00s) PASS -ok github.com/theupdateframework/notary/trustpinning 2.172s +ok github.com/theupdateframework/notary/trustpinning 1.128s === RUN TestInitSnapshotNoTargets ---- PASS: TestInitSnapshotNoTargets (0.11s) +--- PASS: TestInitSnapshotNoTargets (0.04s) === RUN TestInitRepo ---- PASS: TestInitRepo (0.08s) +--- PASS: TestInitRepo (0.02s) === RUN TestUpdateDelegations ---- PASS: TestUpdateDelegations (0.01s) +--- PASS: TestUpdateDelegations (0.00s) === RUN TestPurgeDelegationsKeyFromTop -time="2024-01-07T20:21:22Z" 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-07T20:21:22Z" 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="2025-02-09T02:48:39Z" 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-09T02:48:39Z" 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="2024-01-07T20:21:22Z" level=warning msg="role targets/vimes/carrot has fewer keys than its threshold of 1; it will not be usable until keys are added to it" ---- PASS: TestPurgeDelegationsKeyFromDeep (0.01s) +time="2025-02-09T02:48:39Z" 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.01s) +--- PASS: TestPurgeDelegationsKeyBadWildRole (0.00s) === RUN TestUpdateDelegationsParentMissing ---- PASS: TestUpdateDelegationsParentMissing (0.01s) +--- PASS: TestUpdateDelegationsParentMissing (0.00s) === RUN TestUpdateDelegationsMissingParentKey --- PASS: TestUpdateDelegationsMissingParentKey (0.00s) === RUN TestUpdateDelegationsInvalidRole ---- PASS: TestUpdateDelegationsInvalidRole (0.01s) +--- PASS: TestUpdateDelegationsInvalidRole (0.00s) === RUN TestUpdateDelegationsRoleThatIsMissingDelegationKey ---- PASS: TestUpdateDelegationsRoleThatIsMissingDelegationKey (0.01s) +--- PASS: TestUpdateDelegationsRoleThatIsMissingDelegationKey (0.00s) === RUN TestUpdateDelegationsNotEnoughKeys -time="2024-01-07T20:21:22Z" level=warning msg="role targets/role has fewer keys than its threshold of 2; it will not be usable until keys are added to it" +time="2025-02-09T02:48:39Z" level=warning msg="role targets/role has fewer keys than its threshold of 2; it will not be usable until keys are added to it" --- PASS: TestUpdateDelegationsNotEnoughKeys (0.00s) === RUN TestUpdateDelegationsAddKeyToRole ---- PASS: TestUpdateDelegationsAddKeyToRole (0.01s) +--- PASS: TestUpdateDelegationsAddKeyToRole (0.00s) === RUN TestDeleteDelegations --- PASS: TestDeleteDelegations (0.00s) === RUN TestDeleteDelegationsRoleNotExistBecauseNoParentMeta @@ -3393,79 +3429,79 @@ === RUN TestAddTargetsRoleAndMetadataExist --- PASS: TestAddTargetsRoleAndMetadataExist (0.00s) === RUN TestAddTargetsRoleExistsAndMetadataDoesntExist ---- PASS: TestAddTargetsRoleExistsAndMetadataDoesntExist (0.00s) +--- PASS: TestAddTargetsRoleExistsAndMetadataDoesntExist (0.01s) === RUN TestAddTargetsRoleDoesntExist --- PASS: TestAddTargetsRoleDoesntExist (0.00s) === RUN TestAddTargetsNoSigningKeys ---- PASS: TestAddTargetsNoSigningKeys (0.00s) +--- PASS: TestAddTargetsNoSigningKeys (0.01s) === RUN TestRemoveExistingAndNonexistingTargets ---- PASS: TestRemoveExistingAndNonexistingTargets (0.00s) +--- PASS: TestRemoveExistingAndNonexistingTargets (0.01s) === RUN TestRemoveTargetsRoleDoesntExist --- PASS: TestRemoveTargetsRoleDoesntExist (0.00s) === RUN TestRemoveTargetsNoSigningKeys ---- PASS: TestRemoveTargetsNoSigningKeys (0.01s) +--- PASS: TestRemoveTargetsNoSigningKeys (0.00s) === RUN TestAddBaseKeysToRoot ---- PASS: TestAddBaseKeysToRoot (0.02s) +--- PASS: TestAddBaseKeysToRoot (0.03s) === RUN TestRemoveBaseKeysFromRoot ---- PASS: TestRemoveBaseKeysFromRoot (0.02s) +--- PASS: TestRemoveBaseKeysFromRoot (0.01s) === RUN TestReplaceBaseKeysInRoot ---- PASS: TestReplaceBaseKeysInRoot (0.06s) +--- PASS: TestReplaceBaseKeysInRoot (0.03s) === RUN TestGetAllRoles --- PASS: TestGetAllRoles (0.00s) === RUN TestGetBaseRoles --- PASS: TestGetBaseRoles (0.00s) === RUN TestGetBaseRolesInvalidName ---- PASS: TestGetBaseRolesInvalidName (0.01s) +--- PASS: TestGetBaseRolesInvalidName (0.00s) === RUN TestGetDelegationValidRoles ---- PASS: TestGetDelegationValidRoles (0.01s) +--- PASS: TestGetDelegationValidRoles (0.00s) === RUN TestGetDelegationRolesInvalidName ---- PASS: TestGetDelegationRolesInvalidName (0.01s) +--- PASS: TestGetDelegationRolesInvalidName (0.00s) === RUN TestGetDelegationRolesInvalidPaths ---- PASS: TestGetDelegationRolesInvalidPaths (0.01s) +--- PASS: TestGetDelegationRolesInvalidPaths (0.00s) === RUN TestDelegationRolesParent --- PASS: TestDelegationRolesParent (0.00s) === RUN TestGetBaseRoleEmptyRepo --- PASS: TestGetBaseRoleEmptyRepo (0.00s) === RUN TestGetBaseRoleKeyMissing ---- PASS: TestGetBaseRoleKeyMissing (0.01s) +--- PASS: TestGetBaseRoleKeyMissing (0.00s) === RUN TestGetDelegationRoleKeyMissing ---- PASS: TestGetDelegationRoleKeyMissing (0.01s) +--- PASS: TestGetDelegationRoleKeyMissing (0.00s) === RUN TestSignRootOldKeyCertExists ---- PASS: TestSignRootOldKeyCertExists (0.21s) +--- PASS: TestSignRootOldKeyCertExists (0.13s) === RUN TestSignRootOldKeyCertMissing ---- PASS: TestSignRootOldKeyCertMissing (0.07s) +--- PASS: TestSignRootOldKeyCertMissing (0.09s) === RUN TestRootKeyRotation ---- PASS: TestRootKeyRotation (0.46s) +--- PASS: TestRootKeyRotation (0.31s) === RUN TestBuilderLoadsValidRolesOnly ---- PASS: TestBuilderLoadsValidRolesOnly (0.15s) +--- PASS: TestBuilderLoadsValidRolesOnly (0.07s) === RUN TestBuilderOnlyAcceptsRootFirstWhenLoading ---- PASS: TestBuilderOnlyAcceptsRootFirstWhenLoading (0.02s) +--- PASS: TestBuilderOnlyAcceptsRootFirstWhenLoading (0.01s) === RUN TestBuilderOnlyAcceptsDelegationsAfterParent ---- PASS: TestBuilderOnlyAcceptsDelegationsAfterParent (0.05s) +--- PASS: TestBuilderOnlyAcceptsDelegationsAfterParent (0.02s) === RUN TestMarkingIsValid ---- PASS: TestMarkingIsValid (0.07s) +--- PASS: TestMarkingIsValid (0.04s) === RUN TestBuilderLoadInvalidDelegations ---- PASS: TestBuilderLoadInvalidDelegations (0.13s) +--- PASS: TestBuilderLoadInvalidDelegations (0.07s) === RUN TestBuilderLoadInvalidDelegationsOldVersion ---- PASS: TestBuilderLoadInvalidDelegationsOldVersion (0.14s) +--- PASS: TestBuilderLoadInvalidDelegationsOldVersion (0.07s) === RUN TestBuilderAcceptRoleOnce ---- PASS: TestBuilderAcceptRoleOnce (0.09s) +--- PASS: TestBuilderAcceptRoleOnce (0.03s) === RUN TestBuilderStopsAcceptingOrProducingDataOnceDone ---- PASS: TestBuilderStopsAcceptingOrProducingDataOnceDone (0.04s) +--- PASS: TestBuilderStopsAcceptingOrProducingDataOnceDone (0.02s) === RUN TestGenerateSnapshotInvalidOperations ---- PASS: TestGenerateSnapshotInvalidOperations (0.53s) +--- PASS: TestGenerateSnapshotInvalidOperations (0.24s) === RUN TestGenerateTimestampInvalidOperations ---- PASS: TestGenerateTimestampInvalidOperations (0.45s) +--- PASS: TestGenerateTimestampInvalidOperations (0.21s) === RUN TestGetConsistentInfo ---- PASS: TestGetConsistentInfo (0.08s) +--- PASS: TestGetConsistentInfo (0.07s) === RUN TestTimestampPreAndPostChecksumming ---- PASS: TestTimestampPreAndPostChecksumming (0.11s) +--- PASS: TestTimestampPreAndPostChecksumming (0.12s) === RUN TestSnapshotLoadedFirstChecksumsOthers ---- PASS: TestSnapshotLoadedFirstChecksumsOthers (0.11s) +--- PASS: TestSnapshotLoadedFirstChecksumsOthers (0.09s) === RUN TestSnapshotLoadedAfterChecksumsOthersRetroactively ---- PASS: TestSnapshotLoadedAfterChecksumsOthersRetroactively (0.25s) +--- PASS: TestSnapshotLoadedAfterChecksumsOthersRetroactively (0.22s) PASS -ok github.com/theupdateframework/notary/tuf 3.507s +ok github.com/theupdateframework/notary/tuf 2.105s === RUN TestMergeStrSlicesExclusive --- PASS: TestMergeStrSlicesExclusive (0.00s) === RUN TestMergeStrSlicesOverlap @@ -3513,9 +3549,9 @@ === RUN TestRootFromSignedCopiesSignatures --- PASS: TestRootFromSignedCopiesSignatures (0.00s) === RUN TestRootFromSignedValidatesRoleData ---- PASS: TestRootFromSignedValidatesRoleData (0.02s) +--- PASS: TestRootFromSignedValidatesRoleData (0.01s) === RUN TestRootFromSignedValidatesRoleType ---- PASS: TestRootFromSignedValidatesRoleType (0.01s) +--- PASS: TestRootFromSignedValidatesRoleType (0.00s) === RUN TestRootFromSignedValidatesVersion --- PASS: TestRootFromSignedValidatesVersion (0.00s) === RUN TestSnapshotToSignedMarshalsSignedPortionWithCanonicalJSON @@ -3555,9 +3591,9 @@ === RUN TestTargetsFromSignedCopiesSignatures --- PASS: TestTargetsFromSignedCopiesSignatures (0.00s) === RUN TestTargetsFromSignedValidatesDelegations ---- PASS: TestTargetsFromSignedValidatesDelegations (0.01s) +--- PASS: TestTargetsFromSignedValidatesDelegations (0.00s) === RUN TestTargetsFromSignedValidatesRoleType ---- PASS: TestTargetsFromSignedValidatesRoleType (0.01s) +--- PASS: TestTargetsFromSignedValidatesRoleType (0.00s) === RUN TestTargetsFromSignedValidatesRoleName --- PASS: TestTargetsFromSignedValidatesRoleName (0.00s) === RUN TestTargetsFromSignedValidatesVersion @@ -3599,9 +3635,9 @@ === RUN TestFileMetaEquals --- PASS: TestFileMetaEquals (0.00s) PASS -ok github.com/theupdateframework/notary/tuf/data 0.099s +ok github.com/theupdateframework/notary/tuf/data 0.030s === RUN TestListKeys ---- PASS: TestListKeys (0.04s) +--- PASS: TestListKeys (0.03s) === RUN TestGetKeys --- PASS: TestGetKeys (0.00s) === RUN TestBasicSign @@ -3617,9 +3653,9 @@ === RUN TestSignRemovesValidSigByInvalidKey --- PASS: TestSignRemovesValidSigByInvalidKey (0.01s) === RUN TestSignRemovesInvalidSig ---- PASS: TestSignRemovesInvalidSig (0.00s) +--- PASS: TestSignRemovesInvalidSig (0.01s) === RUN TestSignMinSignatures ---- PASS: TestSignMinSignatures (0.00s) +--- PASS: TestSignMinSignatures (0.01s) === RUN TestSignFailingKeys --- PASS: TestSignFailingKeys (0.02s) === RUN TestErrInsufficientSignaturesMessaging @@ -3631,13 +3667,13 @@ === RUN TestRSAPSSVerifierWithInvalidKeyType --- PASS: TestRSAPSSVerifierWithInvalidKeyType (0.00s) === RUN TestRSAPSSVerifierWithInvalidKeyLength ---- PASS: TestRSAPSSVerifierWithInvalidKeyLength (0.29s) +--- PASS: TestRSAPSSVerifierWithInvalidKeyLength (0.19s) === RUN TestRSAPSSVerifierWithInvalidKey --- PASS: TestRSAPSSVerifierWithInvalidKey (0.00s) === RUN TestRSAPSSVerifierWithInvalidSignature --- PASS: TestRSAPSSVerifierWithInvalidSignature (0.02s) === RUN TestRSAPKCS1v15Verifier ---- PASS: TestRSAPKCS1v15Verifier (0.02s) +--- PASS: TestRSAPKCS1v15Verifier (0.01s) === RUN TestRSAPKCS1v15x509Verifier --- PASS: TestRSAPKCS1v15x509Verifier (0.00s) === RUN TestRSAPKCS1v15VerifierWithInvalidKeyType @@ -3645,12 +3681,12 @@ === RUN TestRSAPKCS1v15VerifierWithInvalidKey --- PASS: TestRSAPKCS1v15VerifierWithInvalidKey (0.00s) === RUN TestRSAPKCS1v15VerifierWithInvalidSignature -time="2024-01-07T20:21:21Z" level=error msg="Failed verification: crypto/rsa: verification error" +time="2025-02-09T02:48:38Z" level=error msg="Failed verification: crypto/rsa: verification error" --- PASS: TestRSAPKCS1v15VerifierWithInvalidSignature (0.02s) === RUN TestECDSAVerifier --- PASS: TestECDSAVerifier (0.01s) === RUN TestECDSAVerifierOtherCurves ---- PASS: TestECDSAVerifierOtherCurves (0.62s) +--- PASS: TestECDSAVerifierOtherCurves (0.56s) === RUN TestECDSAx509Verifier --- PASS: TestECDSAx509Verifier (0.01s) === RUN TestECDSAVerifierWithInvalidKeyType @@ -3658,7 +3694,7 @@ === RUN TestECDSAVerifierWithInvalidKey --- PASS: TestECDSAVerifierWithInvalidKey (0.00s) === RUN TestECDSAVerifierWithInvalidSignature ---- PASS: TestECDSAVerifierWithInvalidSignature (0.02s) +--- PASS: TestECDSAVerifierWithInvalidSignature (0.01s) === RUN TestED25519VerifierInvalidKeyType --- PASS: TestED25519VerifierInvalidKeyType (0.00s) === RUN TestRSAPyCryptoVerifierInvalidKeyType @@ -3672,86 +3708,86 @@ === RUN TestNotEnoughSigs --- PASS: TestNotEnoughSigs (0.00s) === RUN TestNoSigs ---- PASS: TestNoSigs (0.01s) +--- PASS: TestNoSigs (0.00s) === RUN TestExactlyEnoughSigs ---- PASS: TestExactlyEnoughSigs (0.01s) +--- PASS: TestExactlyEnoughSigs (0.00s) === RUN TestIsValidNotExported --- PASS: TestIsValidNotExported (0.00s) === RUN TestMoreThanEnoughSigs ---- PASS: TestMoreThanEnoughSigs (0.02s) +--- PASS: TestMoreThanEnoughSigs (0.01s) === RUN TestValidSigWithIncorrectKeyID --- PASS: TestValidSigWithIncorrectKeyID (0.00s) === RUN TestDuplicateSigs ---- PASS: TestDuplicateSigs (0.01s) +--- PASS: TestDuplicateSigs (0.00s) === RUN TestUnknownKeyBelowThreshold ---- PASS: TestUnknownKeyBelowThreshold (0.01s) +--- PASS: TestUnknownKeyBelowThreshold (0.00s) === RUN TestVerifyVersion --- PASS: TestVerifyVersion (0.00s) === RUN TestVerifyExpiry -time="2024-01-07T20:21:22Z" level=error msg="Metadata for root expired" +time="2025-02-09T02:48:38Z" level=error msg="Metadata for root expired" --- PASS: TestVerifyExpiry (0.00s) === RUN TestVerifyPublicKeyMatchesPrivateKeyHappyCase --- PASS: TestVerifyPublicKeyMatchesPrivateKeyHappyCase (0.00s) === RUN TestVerifyPublicKeyMatchesPrivateKeyFails ---- PASS: TestVerifyPublicKeyMatchesPrivateKeyFails (0.01s) +--- PASS: TestVerifyPublicKeyMatchesPrivateKeyFails (0.00s) PASS -ok github.com/theupdateframework/notary/tuf/signed 1.241s +ok github.com/theupdateframework/notary/tuf/signed 1.011s === RUN TestNewSwizzler ---- PASS: TestNewSwizzler (0.18s) +--- PASS: TestNewSwizzler (0.09s) === RUN TestSwizzlerSetInvalidJSON ---- PASS: TestSwizzlerSetInvalidJSON (0.18s) +--- PASS: TestSwizzlerSetInvalidJSON (0.07s) === RUN TestSwizzlerAddExtraSpace ---- PASS: TestSwizzlerAddExtraSpace (0.17s) +--- PASS: TestSwizzlerAddExtraSpace (0.07s) === RUN TestSwizzlerSetInvalidSigned ---- PASS: TestSwizzlerSetInvalidSigned (0.15s) +--- PASS: TestSwizzlerSetInvalidSigned (0.11s) === RUN TestSwizzlerSetInvalidSignedMeta ---- PASS: TestSwizzlerSetInvalidSignedMeta (0.19s) +--- PASS: TestSwizzlerSetInvalidSignedMeta (0.08s) === RUN TestSwizzlerSetInvalidMetadataType ---- PASS: TestSwizzlerSetInvalidMetadataType (0.15s) +--- PASS: TestSwizzlerSetInvalidMetadataType (0.07s) === RUN TestSwizzlerInvalidateMetadataSignatures ---- PASS: TestSwizzlerInvalidateMetadataSignatures (0.13s) +--- PASS: TestSwizzlerInvalidateMetadataSignatures (0.07s) === RUN TestSwizzlerRemoveMetadata ---- PASS: TestSwizzlerRemoveMetadata (0.12s) +--- PASS: TestSwizzlerRemoveMetadata (0.07s) === RUN TestSwizzlerSignMetadataWithInvalidKey ---- PASS: TestSwizzlerSignMetadataWithInvalidKey (0.14s) +--- PASS: TestSwizzlerSignMetadataWithInvalidKey (0.06s) === RUN TestSwizzlerOffsetMetadataVersion --- PASS: TestSwizzlerOffsetMetadataVersion (0.09s) === RUN TestSwizzlerExpireMetadata ---- PASS: TestSwizzlerExpireMetadata (0.12s) +--- PASS: TestSwizzlerExpireMetadata (0.07s) === RUN TestSwizzlerSetThresholdBaseRole ---- PASS: TestSwizzlerSetThresholdBaseRole (0.16s) +--- PASS: TestSwizzlerSetThresholdBaseRole (0.12s) === RUN TestSwizzlerSetThresholdDelegatedRole --- PASS: TestSwizzlerSetThresholdDelegatedRole (0.08s) === RUN TestSwizzlerChangeRootKey ---- PASS: TestSwizzlerChangeRootKey (0.08s) +--- PASS: TestSwizzlerChangeRootKey (0.10s) === RUN TestSwizzlerUpdateSnapshotHashesSpecifiedRoles --- PASS: TestSwizzlerUpdateSnapshotHashesSpecifiedRoles (0.07s) === RUN TestSwizzlerUpdateSnapshotHashesNoSpecifiedRoles ---- PASS: TestSwizzlerUpdateSnapshotHashesNoSpecifiedRoles (0.07s) +--- PASS: TestSwizzlerUpdateSnapshotHashesNoSpecifiedRoles (0.08s) === RUN TestSwizzlerUpdateTimestamp ---- PASS: TestSwizzlerUpdateTimestamp (0.07s) +--- PASS: TestSwizzlerUpdateTimestamp (0.09s) === RUN TestMissingSigningKey --- PASS: TestMissingSigningKey (0.11s) === RUN TestSwizzlerMutateRoot ---- PASS: TestSwizzlerMutateRoot (0.07s) +--- PASS: TestSwizzlerMutateRoot (0.08s) === RUN TestSwizzlerMutateTimestamp --- PASS: TestSwizzlerMutateTimestamp (0.07s) === RUN TestSwizzlerMutateSnapshot ---- PASS: TestSwizzlerMutateSnapshot (0.07s) +--- PASS: TestSwizzlerMutateSnapshot (0.08s) === RUN TestSwizzlerMutateTargets --- PASS: TestSwizzlerMutateTargets (0.08s) === RUN TestSwizzlerRotateKeyBaseRole ---- PASS: TestSwizzlerRotateKeyBaseRole (0.10s) +--- PASS: TestSwizzlerRotateKeyBaseRole (0.09s) === RUN TestSwizzlerRotateKeyDelegationRole --- PASS: TestSwizzlerRotateKeyDelegationRole (0.07s) PASS -ok github.com/theupdateframework/notary/tuf/testutils 2.767s +ok github.com/theupdateframework/notary/tuf/testutils 1.991s ? 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.13s) +--- PASS: TestConvertTUFKeyToPKCS8 (0.09s) === RUN TestParsePKCS8ToTufKey ---- PASS: TestParsePKCS8ToTufKey (0.48s) +--- PASS: TestParsePKCS8ToTufKey (0.42s) === RUN TestPEMtoPEM --- PASS: TestPEMtoPEM (0.00s) === RUN TestRoleListLen @@ -3797,7 +3833,7 @@ === RUN TestNewCertificate --- PASS: TestNewCertificate (0.00s) === RUN TestKeyOperations ---- PASS: TestKeyOperations (0.06s) +--- PASS: TestKeyOperations (0.05s) === RUN TestRSAX509PublickeyID --- PASS: TestRSAX509PublickeyID (0.00s) === RUN TestECDSAX509PublickeyID @@ -3811,11 +3847,11 @@ === RUN TestValidateCertificateWithExpiredCert --- PASS: TestValidateCertificateWithExpiredCert (0.01s) === RUN TestValidateCertificateWithInvalidExpiry ---- PASS: TestValidateCertificateWithInvalidExpiry (0.01s) +--- PASS: TestValidateCertificateWithInvalidExpiry (0.00s) === RUN TestValidateCertificateWithShortKey --- PASS: TestValidateCertificateWithShortKey (0.16s) PASS -ok github.com/theupdateframework/notary/tuf/utils 0.897s +ok github.com/theupdateframework/notary/tuf/utils 0.775s === RUN TestNewSerializableErrorNonValidationError --- PASS: TestNewSerializableErrorNonValidationError (0.00s) === RUN TestNewSerializableErrorValidationError @@ -3831,9 +3867,9 @@ === RUN TestUnmarshalInvalidJSON --- PASS: TestUnmarshalInvalidJSON (0.00s) PASS -ok github.com/theupdateframework/notary/tuf/validation 0.037s +ok github.com/theupdateframework/notary/tuf/validation 0.006s === RUN TestSetSignalTrap ---- PASS: TestSetSignalTrap (0.01s) +--- PASS: TestSetSignalTrap (0.00s) === RUN TestLogLevelSignalHandle Attempt to increase log level failed, will remain at debug level, error: log level can not be set higher than Debug Successfully setting log level to debug @@ -3905,7 +3941,7 @@ === RUN TestAdjustLogLevel --- PASS: TestAdjustLogLevel (0.00s) === RUN TestRootHandlerFactory ---- PASS: TestRootHandlerFactory (0.01s) +--- PASS: TestRootHandlerFactory (0.00s) === RUN TestRootHandlerError --- PASS: TestRootHandlerError (0.00s) === RUN TestWrapWithCacheHeaderNilCacheControlConfig @@ -3931,7 +3967,7 @@ === RUN TestDoAuthWildcardImage --- PASS: TestDoAuthWildcardImage (0.00s) PASS -ok github.com/theupdateframework/notary/utils 0.071s +ok github.com/theupdateframework/notary/utils 0.015s ? 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 @@ -3970,8 +4006,8 @@ 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_i386.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-dbgsym' in '../notary-dbgsym_0.7.0+ds1-2_i386.deb'. +dpkg-deb: building package 'golang-github-docker-notary-dev' in '../golang-github-docker-notary-dev_0.7.0+ds1-2_all.deb'. dpkg-genbuildinfo --build=binary -O../notary_0.7.0+ds1-2_i386.buildinfo dpkg-genchanges --build=binary -O../notary_0.7.0+ds1-2_i386.changes dpkg-genchanges: info: binary-only upload (no source code included) @@ -3979,12 +4015,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/129746/tmp/hooks/B01_cleanup starting +I: user script /srv/workspace/pbuilder/129746/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/403 and its subdirectories -I: Current time: Sun Jan 7 08:24:24 -12 2024 -I: pbuilder-time-stamp: 1704659064 +I: removing directory /srv/workspace/pbuilder/129746 and its subdirectories +I: Current time: Sun Feb 9 16:50:17 +14 2025 +I: pbuilder-time-stamp: 1739069417