Diff of the two buildlogs: -- --- b1/build.log 2024-01-06 11:07:13.332355230 +0000 +++ b2/build.log 2024-01-06 11:11:53.797379536 +0000 @@ -1,6 +1,6 @@ I: pbuilder: network access will be disabled during build -I: Current time: Fri Jan 5 23:05:05 -12 2024 -I: pbuilder-time-stamp: 1704539105 +I: Current time: Sat Feb 8 07:30:17 +14 2025 +I: pbuilder-time-stamp: 1738949417 I: Building the build Environment I: extracting base tarball [/var/cache/pbuilder/bookworm-reproducible-base.tgz] I: copying local configuration @@ -31,49 +31,81 @@ dpkg-source: info: applying 0004-Use-github.com-golang-protobuf-ptypes-empty.patch I: Not using root during the build. I: Installing the build-deps -I: user script /srv/workspace/pbuilder/1554838/tmp/hooks/D02_print_environment starting +I: user script /srv/workspace/pbuilder/2477182/tmp/hooks/D01_modify_environment starting +debug: Running on codethink01-arm64. +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 7 17:30 /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/2477182/tmp/hooks/D01_modify_environment finished +I: user script /srv/workspace/pbuilder/2477182/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='arm64' - DEBIAN_FRONTEND='noninteractive' + BASH=/bin/sh + BASHOPTS=checkwinsize:cmdhist:complete_fullquote:extquote:force_fignore:globasciiranges:globskipdots:hostcomplete:interactive_comments:patsub_replacement:progcomp:promptvars:sourcepath + BASH_ALIASES=() + BASH_ARGC=() + BASH_ARGV=() + BASH_CMDS=() + BASH_LINENO=([0]="12" [1]="0") + BASH_LOADABLES_PATH=/usr/local/lib/bash:/usr/lib/bash:/opt/local/lib/bash:/usr/pkg/lib/bash:/opt/pkg/lib/bash:. + BASH_SOURCE=([0]="/tmp/hooks/D02_print_environment" [1]="/tmp/hooks/D02_print_environment") + BASH_VERSINFO=([0]="5" [1]="2" [2]="15" [3]="1" [4]="release" [5]="aarch64-unknown-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=arm64 + DEBIAN_FRONTEND=noninteractive DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all parallel=12 ' - DISTRIBUTION='bookworm' - HOME='/root' - HOST_ARCH='arm64' + DIRSTACK=() + DISTRIBUTION=bookworm + EUID=0 + FUNCNAME=([0]="Echo" [1]="main") + GROUPS=() + HOME=/root + HOSTNAME=i-capture-the-hostname + HOSTTYPE=aarch64 + HOST_ARCH=arm64 IFS=' ' - INVOCATION_ID='1c7d91f72b3c49fc95d5ae484f602f30' - LANG='C' - LANGUAGE='en_US:en' - LC_ALL='C' - MAIL='/var/mail/root' - OPTIND='1' - PATH='/usr/sbin:/usr/bin:/sbin:/bin:/usr/games' - PBCURRENTCOMMANDLINEOPERATION='build' - PBUILDER_OPERATION='build' - PBUILDER_PKGDATADIR='/usr/share/pbuilder' - PBUILDER_PKGLIBDIR='/usr/lib/pbuilder' - PBUILDER_SYSCONFDIR='/etc' - PPID='1554838' - PS1='# ' - PS2='> ' + INVOCATION_ID=fa17fdfdb24b4df7aa23fe732f8044f5 + LANG=C + LANGUAGE=nl_BE:nl + LC_ALL=C + MACHTYPE=aarch64-unknown-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=2477182 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.6D70l7h3/pbuilderrc_Elfz --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.6D70l7h3/b1 --logfile b1/build.log notary_0.7.0+ds1-2.dsc' - SUDO_GID='109' - SUDO_UID='104' - SUDO_USER='jenkins' - TERM='unknown' - TZ='/usr/share/zoneinfo/Etc/GMT+12' - USER='root' - _='/usr/bin/systemd-run' - http_proxy='http://192.168.101.104: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.6D70l7h3/pbuilderrc_597G --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.6D70l7h3/b2 --logfile b2/build.log notary_0.7.0+ds1-2.dsc' + SUDO_GID=109 + SUDO_UID=104 + SUDO_USER=jenkins + TERM=unknown + TZ=/usr/share/zoneinfo/Etc/GMT-14 + UID=0 + USER=root + _='I: set' + http_proxy=http://192.168.101.104:3128 I: uname -a - Linux codethink04-arm64 6.1.0-17-cloud-arm64 #1 SMP Debian 6.1.69-1 (2023-12-30) aarch64 GNU/Linux + Linux i-capture-the-hostname 6.1.0-17-cloud-arm64 #1 SMP Debian 6.1.69-1 (2023-12-30) aarch64 GNU/Linux I: ls -l /bin total 7104 -rwxr-xr-x 1 root root 1346480 Apr 23 2023 bash @@ -131,15 +163,15 @@ -rwxr-xr-x 1 root root 68456 Sep 20 2022 readlink -rwxr-xr-x 1 root root 68592 Sep 20 2022 rm -rwxr-xr-x 1 root root 68480 Sep 20 2022 rmdir - -rwxr-xr-x 1 root root 68392 Jul 28 23:46 run-parts + -rwxr-xr-x 1 root root 68392 Jul 28 2023 run-parts -rwxr-xr-x 1 root root 134536 Jan 5 2023 sed - lrwxrwxrwx 1 root root 4 Jan 5 2023 sh -> dash + lrwxrwxrwx 1 root root 9 Feb 7 17:30 sh -> /bin/bash -rwxr-xr-x 1 root root 68432 Sep 20 2022 sleep -rwxr-xr-x 1 root root 134088 Sep 20 2022 stty -rwsr-xr-x 1 root root 133312 Mar 23 2023 su -rwxr-xr-x 1 root root 68448 Sep 20 2022 sync -rwxr-xr-x 1 root root 539896 Apr 6 2023 tar - -rwxr-xr-x 1 root root 67904 Jul 28 23:46 tempfile + -rwxr-xr-x 1 root root 67904 Jul 28 2023 tempfile -rwxr-xr-x 1 root root 134160 Sep 20 2022 touch -rwxr-xr-x 1 root root 68384 Sep 20 2022 true -rwxr-xr-x 1 root root 67664 Mar 23 2023 ulockmgr_server @@ -159,7 +191,7 @@ -rwxr-xr-x 1 root root 2206 Apr 10 2022 zless -rwxr-xr-x 1 root root 1842 Apr 10 2022 zmore -rwxr-xr-x 1 root root 4577 Apr 10 2022 znew -I: user script /srv/workspace/pbuilder/1554838/tmp/hooks/D02_print_environment finished +I: user script /srv/workspace/pbuilder/2477182/tmp/hooks/D02_print_environment finished -> Attempting to satisfy build-dependencies -> Creating pbuilder-satisfydepends-dummy package Package: pbuilder-satisfydepends-dummy @@ -435,7 +467,7 @@ Get: 184 http://deb.debian.org/debian bookworm/main arm64 golang-goprotobuf-dev arm64 1.3.5-4+b3 [3432 B] Get: 185 http://deb.debian.org/debian bookworm/main arm64 golang-gopkg-rethinkdb-rethinkdb-go.v6-dev all 6.2.1-2 [106 kB] Get: 186 http://deb.debian.org/debian bookworm/main arm64 openssl arm64 3.0.11-1~deb12u2 [1385 kB] -Fetched 132 MB in 1s (90.4 MB/s) +Fetched 132 MB in 2s (67.6 MB/s) debconf: delaying package configuration, since apt-utils is not installed Selecting previously unselected package golang-golang-x-sys-dev. (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 18171 files and directories currently installed.) @@ -1194,7 +1226,11 @@ Building tag database... -> Finished parsing the build-deps I: Building the package -I: Running cd /build/reproducible-path/notary-0.7.0+ds1/ && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games" HOME="/nonexistent/first-build" dpkg-buildpackage -us -uc -b && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games" HOME="/nonexistent/first-build" dpkg-genchanges -S > ../notary_0.7.0+ds1-2_source.changes +I: user script /srv/workspace/pbuilder/2477182/tmp/hooks/A99_set_merged_usr starting +Not re-configuring usrmerge for bookworm +I: user script /srv/workspace/pbuilder/2477182/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 @@ -1475,26 +1511,26 @@ src/github.com/theupdateframework/notary/version/version.go cd _build && go install -trimpath -v -p 12 -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/goos -internal/itoa +internal/unsafeheader internal/goexperiment +internal/goos +internal/cpu internal/race +runtime/internal/syscall +sync/atomic math/bits -internal/unsafeheader unicode/utf8 +internal/itoa unicode -internal/cpu -sync/atomic -runtime/internal/syscall -encoding internal/abi runtime/internal/math +encoding runtime/internal/sys unicode/utf16 +math crypto/internal/subtle crypto/subtle crypto/internal/boring/sig -math vendor/golang.org/x/crypto/cryptobyte/asn1 internal/nettrace container/list @@ -1504,16 +1540,16 @@ google.golang.org/protobuf/internal/set github.com/theupdateframework/notary/version github.com/lib/pq/oid -runtime/internal/atomic internal/bytealg +runtime/internal/atomic runtime internal/reflectlite -runtime/metrics sync +runtime/metrics internal/testlog +math/rand internal/singleflight github.com/spf13/viper/internal/encoding -math/rand google.golang.org/grpc/internal/buffer google.golang.org/grpc/internal/grpcsync google.golang.org/protobuf/internal/pragma @@ -1522,19 +1558,19 @@ errors sort io -vendor/golang.org/x/net/dns/dnsmessage -internal/oserror -github.com/hashicorp/hcl/hcl/strconv -path strconv +internal/oserror internal/safefilepath +path crypto/internal/nistec/fiat -syscall +vendor/golang.org/x/net/dns/dnsmessage +github.com/hashicorp/hcl/hcl/strconv github.com/beorn7/perks/quantile +syscall hash bytes -strings crypto/internal/randutil +strings text/tabwriter hash/crc32 hash/fnv @@ -1547,8 +1583,8 @@ golang.org/x/text/transform github.com/dvsekhvalnov/jose2go/padding bufio -regexp/syntax net/http/internal/ascii +regexp/syntax html google.golang.org/grpc/encoding github.com/prometheus/common/internal/bitbucket.org/ww/goautoneg @@ -1559,198 +1595,201 @@ internal/syscall/execenv regexp github.com/jinzhu/inflection -google.golang.org/grpc/backoff -context +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 -internal/poll google.golang.org/grpc/internal/backoff +encoding/binary +embed +github.com/spf13/afero/internal/common +internal/fmtsort golang.org/x/net/context google.golang.org/grpc/tap gopkg.in/rethinkdb/rethinkdb-go.v6/vendor/gopkg.in/cenkalti/backoff.v2 -embed -github.com/spf13/afero/internal/common os -encoding/binary -internal/fmtsort crypto/md5 encoding/base64 -crypto/internal/edwards25519/field -github.com/cespare/xxhash -vendor/golang.org/x/crypto/internal/poly1305 -crypto/cipher -vendor/golang.org/x/crypto/curve25519/internal/field crypto/internal/nistec golang.org/x/sys/unix +vendor/golang.org/x/crypto/internal/poly1305 +crypto/internal/edwards25519/field +vendor/golang.org/x/crypto/curve25519/internal/field +crypto/cipher +github.com/cespare/xxhash encoding/pem github.com/dvsekhvalnov/jose2go/base64url github.com/dvsekhvalnov/jose2go/compact crypto/internal/edwards25519 crypto/internal/boring -vendor/golang.org/x/crypto/chacha20 crypto/des -crypto/sha512 -crypto/aes -crypto/sha256 -crypto/hmac -crypto/sha1 +vendor/golang.org/x/crypto/chacha20 github.com/theupdateframework/notary fmt internal/godebug path/filepath +google.golang.org/grpc/internal/envconfig io/ioutil +crypto/aes +crypto/sha512 +crypto/sha256 +crypto/sha1 internal/intern -golang.org/x/crypto/pbkdf2 -vendor/golang.org/x/crypto/chacha20poly1305 +crypto/hmac net/netip -vendor/golang.org/x/crypto/hkdf -google.golang.org/grpc/internal/envconfig github.com/bugsnag/bugsnag-go/device os/signal -google.golang.org/protobuf/internal/detrand -github.com/prometheus/procfs/internal/util +golang.org/x/crypto/pbkdf2 +vendor/golang.org/x/crypto/hkdf +vendor/golang.org/x/crypto/chacha20poly1305 github.com/spf13/afero/mem os/exec -net +google.golang.org/protobuf/internal/detrand +github.com/prometheus/procfs/internal/util +encoding/json +github.com/docker/go/canonical/json log +math/big encoding/hex -github.com/docker/go/canonical/json net/url -encoding/json -mime/quotedprintable mime +mime/quotedprintable compress/flate -math/big +net vendor/golang.org/x/crypto/curve25519 vendor/golang.org/x/text/unicode/norm +vendor/golang.org/x/text/unicode/bidi vendor/golang.org/x/net/http2/hpack net/http/internal -vendor/golang.org/x/text/unicode/bidi github.com/miekg/pkcs11 flag encoding/csv -golang.org/x/text/unicode/norm github.com/fsnotify/fsnotify -compress/gzip +golang.org/x/text/unicode/norm text/template/parse +compress/gzip github.com/spf13/jwalterweatherman -github.com/hashicorp/hcl/hcl/token vendor/golang.org/x/text/secure/bidirule +github.com/hashicorp/hcl/hcl/token +github.com/subosito/gotenv +gopkg.in/ini.v1 +gopkg.in/yaml.v2 +golang.org/x/net/internal/timeseries github.com/sirupsen/logrus github.com/theupdateframework/notary/tuf/validation github.com/hashicorp/hcl/hcl/ast github.com/hashicorp/hcl/hcl/scanner github.com/hashicorp/hcl/json/token github.com/spf13/viper/internal/encoding/json -gopkg.in/yaml.v2 -github.com/subosito/gotenv -gopkg.in/ini.v1 -github.com/hashicorp/hcl/json/scanner github.com/hashicorp/hcl/hcl/parser -vendor/golang.org/x/net/idna github.com/golang/protobuf/proto +vendor/golang.org/x/net/idna +github.com/hashicorp/hcl/json/scanner +text/template github.com/hashicorp/hcl/json/parser github.com/hashicorp/hcl/hcl/printer -text/template -github.com/hashicorp/hcl crypto/rand crypto/elliptic crypto/internal/boring/bbig encoding/asn1 +crypto/dsa +github.com/hashicorp/hcl github.com/docker/distribution/uuid crypto/rsa -crypto/dsa crypto/ed25519 -github.com/spf13/viper/internal/encoding/hcl github.com/pelletier/go-toml -golang.org/x/net/internal/timeseries google.golang.org/grpc/internal/grpclog golang.org/x/crypto/ed25519 google.golang.org/grpc/attributes -vendor/golang.org/x/crypto/cryptobyte -crypto/x509/pkix -google.golang.org/grpc/grpclog google.golang.org/grpc/metadata google.golang.org/grpc/codes +github.com/spf13/viper/internal/encoding/hcl +google.golang.org/grpc/grpclog golang.org/x/text/unicode/bidi golang.org/x/net/http2/hpack -html/template -google.golang.org/grpc/internal/balancerload github.com/pkg/errors +google.golang.org/grpc/internal/balancerload +html/template +vendor/golang.org/x/crypto/cryptobyte +crypto/x509/pkix +google.golang.org/grpc/connectivity +github.com/bugsnag/bugsnag-go/errors github.com/spf13/viper/internal/encoding/yaml +google.golang.org/grpc/internal github.com/bugsnag/panicwrap -google.golang.org/grpc/connectivity database/sql/driver -google.golang.org/grpc/internal github.com/opencontainers/go-digest -github.com/bugsnag/bugsnag-go/errors -crypto/ecdsa github.com/opencontainers/image-spec/specs-go github.com/prometheus/common/model google.golang.org/protobuf/internal/errors -github.com/docker/distribution/digestset -golang.org/x/text/secure/bidirule -github.com/opencontainers/image-spec/specs-go/v1 go/token -google.golang.org/protobuf/encoding/protowire +golang.org/x/text/secure/bidirule database/sql -google.golang.org/protobuf/internal/version +google.golang.org/protobuf/encoding/protowire +crypto/ecdsa +github.com/docker/distribution/digestset golang.org/x/net/idna +github.com/opencontainers/image-spec/specs-go/v1 +google.golang.org/protobuf/reflect/protoreflect github.com/docker/distribution/reference +google.golang.org/protobuf/internal/version github.com/prometheus/procfs/internal/fs runtime/debug -github.com/spf13/cast -google.golang.org/protobuf/reflect/protoreflect golang.org/x/term +github.com/spf13/cast golang.org/x/crypto/bcrypt github.com/lib/pq/scram os/user -go/scanner -github.com/spf13/viper/internal/encoding/toml -github.com/hailocab/go-hostpool -github.com/opentracing/opentracing-go/log 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 +google.golang.org/genproto/googleapis/rpc/status github.com/matttproud/golang_protobuf_extensions/pbutil +github.com/spf13/viper/internal/encoding/toml google.golang.org/protobuf/internal/descfmt google.golang.org/protobuf/internal/descopts +github.com/golang/protobuf/ptypes +google.golang.org/grpc/binarylog/grpc_binarylog_v1 +github.com/prometheus/client_model/go google.golang.org/protobuf/internal/strs google.golang.org/protobuf/internal/encoding/messageset google.golang.org/protobuf/internal/genid google.golang.org/protobuf/internal/order -google.golang.org/genproto/googleapis/rpc/status google.golang.org/protobuf/runtime/protoiface +google.golang.org/grpc/internal/status +google.golang.org/protobuf/internal/encoding/text github.com/theupdateframework/notary/passphrase -github.com/golang/protobuf/ptypes -google.golang.org/grpc/binarylog/grpc_binarylog_v1 -github.com/prometheus/client_model/go +go/scanner +github.com/hailocab/go-hostpool +github.com/opentracing/opentracing-go/log google.golang.org/protobuf/reflect/protoregistry -google.golang.org/protobuf/internal/encoding/text -go/ast gopkg.in/rethinkdb/rethinkdb-go.v6/encoding +github.com/prometheus/client_golang/prometheus/internal gopkg.in/rethinkdb/rethinkdb-go.v6/ql2 -google.golang.org/grpc/internal/status -gopkg.in/rethinkdb/rethinkdb-go.v6/types google.golang.org/grpc/status +go/ast +gopkg.in/rethinkdb/rethinkdb-go.v6/types internal/profile runtime/pprof -google.golang.org/protobuf/proto -github.com/prometheus/client_golang/prometheus/internal runtime/trace +google.golang.org/protobuf/proto github.com/dvsekhvalnov/jose2go/arrays github.com/davecgh/go-spew/spew google.golang.org/protobuf/internal/encoding/defval -github.com/pmezard/go-difflib/difflib github.com/dvsekhvalnov/jose2go/aes github.com/dvsekhvalnov/jose2go/kdf +github.com/pmezard/go-difflib/difflib gopkg.in/yaml.v3 -crypto/x509 +testing github.com/jinzhu/gorm +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 @@ -1761,27 +1800,24 @@ mime/multipart vendor/golang.org/x/net/http/httpguts golang.org/x/net/http/httpguts -google.golang.org/protobuf/internal/filedesc -google.golang.org/protobuf/encoding/prototext github.com/prometheus/procfs -testing +google.golang.org/protobuf/internal/encoding/tag github.com/theupdateframework/notary/tuf/data -crypto/tls github.com/dvsekhvalnov/jose2go/keys/ecc +crypto/tls +google.golang.org/protobuf/internal/impl github.com/dvsekhvalnov/jose2go -google.golang.org/protobuf/internal/encoding/tag github.com/spf13/cobra -google.golang.org/protobuf/internal/impl 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 github.com/go-sql-driver/mysql github.com/docker/libtrust -google.golang.org/grpc/internal/credentials github.com/lib/pq -google.golang.org/grpc/credentials net/http +google.golang.org/grpc/credentials google.golang.org/grpc/resolver google.golang.org/grpc/internal/channelz google.golang.org/grpc/peer @@ -1789,81 +1825,81 @@ google.golang.org/grpc/internal/grpcutil google.golang.org/grpc/balancer/grpclb/state google.golang.org/grpc/internal/resolver/passthrough +google.golang.org/protobuf/internal/filetype +google.golang.org/grpc/internal/resolver/dns google.golang.org/grpc/balancer/base google.golang.org/grpc/internal/serviceconfig -google.golang.org/grpc/internal/resolver/dns google.golang.org/grpc/internal/binarylog 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 -github.com/docker/distribution/registry/auth -golang.org/x/net/trace github.com/theupdateframework/notary/storage +github.com/magiconair/properties +github.com/spf13/afero +golang.org/x/net/trace +github.com/docker/distribution/registry/client/auth/challenge net/http/httputil +github.com/bugsnag/bugsnag-go/sessions +github.com/gorilla/mux github.com/docker/distribution/registry/api/errcode -github.com/docker/distribution/registry/client/auth/challenge +github.com/docker/distribution/registry/auth github.com/docker/distribution -github.com/magiconair/properties -github.com/gorilla/mux -github.com/bugsnag/bugsnag-go/sessions -github.com/spf13/afero golang.org/x/net/http2 github.com/docker/distribution/registry/client/transport expvar -github.com/bugsnag/bugsnag-go github.com/prometheus/common/expfmt +github.com/theupdateframework/notary/trustmanager github.com/theupdateframework/notary/server/errors +github.com/bugsnag/bugsnag-go github.com/opentracing/opentracing-go net/http/pprof net/http/httptest github.com/docker/distribution/context -github.com/theupdateframework/notary/trustmanager github.com/docker/distribution/registry/api/v2 -github.com/opentracing/opentracing-go/ext -gopkg.in/rethinkdb/rethinkdb-go.v6 github.com/theupdateframework/notary/cryptoservice github.com/theupdateframework/notary/tuf/signed +github.com/opentracing/opentracing-go/ext +gopkg.in/rethinkdb/rethinkdb-go.v6 github.com/stretchr/testify/assert -github.com/docker/distribution/health -github.com/docker/distribution/registry/auth/htpasswd -github.com/docker/distribution/registry/auth/token -github.com/theupdateframework/notary/vendor/github.com/prometheus/client_golang/prometheus github.com/prometheus/client_golang/prometheus -github.com/Shopify/logrus-bugsnag -github.com/spf13/viper +github.com/theupdateframework/notary/vendor/github.com/prometheus/client_golang/prometheus github.com/theupdateframework/notary/trustmanager/yubikey github.com/theupdateframework/notary/trustpinning github.com/theupdateframework/notary/tuf/testutils/keys +github.com/docker/distribution/health +github.com/Shopify/logrus-bugsnag +github.com/docker/distribution/registry/auth/htpasswd +github.com/spf13/viper +github.com/docker/distribution/registry/auth/token github.com/theupdateframework/notary/tuf github.com/theupdateframework/notary/utils github.com/stretchr/testify/require -github.com/theupdateframework/notary/tuf/testutils github.com/theupdateframework/notary/client +github.com/theupdateframework/notary/tuf/testutils google.golang.org/grpc/internal/transport github.com/prometheus/client_golang/prometheus/promhttp github.com/theupdateframework/notary/tuf/testutils/interfaces github.com/theupdateframework/notary/storage/rethinkdb -github.com/theupdateframework/notary/signer/keydbstore github.com/theupdateframework/notary/server/storage +github.com/theupdateframework/notary/signer/keydbstore github.com/docker/go-metrics github.com/docker/distribution/metrics -github.com/docker/distribution/registry/storage/cache google.golang.org/grpc github.com/theupdateframework/notary/server/snapshot -github.com/docker/distribution/registry/storage/cache/memory +github.com/docker/distribution/registry/storage/cache github.com/theupdateframework/notary/server/timestamp -github.com/docker/distribution/registry/client +github.com/docker/distribution/registry/storage/cache/memory github.com/theupdateframework/notary/server/handlers -github.com/docker/distribution/registry/client/auth +github.com/docker/distribution/registry/client github.com/theupdateframework/notary/server +github.com/docker/distribution/registry/client/auth github.com/theupdateframework/notary/cmd/notary -github.com/theupdateframework/notary/proto github.com/theupdateframework/notary/trustmanager/remoteks +github.com/theupdateframework/notary/proto google.golang.org/grpc/health/grpc_health_v1 -google.golang.org/grpc/health -github.com/theupdateframework/notary/signer/client github.com/theupdateframework/notary/signer +github.com/theupdateframework/notary/signer/client +google.golang.org/grpc/health github.com/theupdateframework/notary/cmd/escrow github.com/theupdateframework/notary/signer/api github.com/theupdateframework/notary/cmd/notary-server @@ -1873,27 +1909,27 @@ cd _build && go test -vet=off -v -p 12 github.com/theupdateframework/notary github.com/theupdateframework/notary/client github.com/theupdateframework/notary/client/changelist github.com/theupdateframework/notary/cmd/escrow github.com/theupdateframework/notary/cmd/notary github.com/theupdateframework/notary/cmd/notary-server github.com/theupdateframework/notary/cmd/notary-signer github.com/theupdateframework/notary/cryptoservice github.com/theupdateframework/notary/passphrase github.com/theupdateframework/notary/proto github.com/theupdateframework/notary/server github.com/theupdateframework/notary/server/errors github.com/theupdateframework/notary/server/handlers github.com/theupdateframework/notary/server/snapshot github.com/theupdateframework/notary/server/storage github.com/theupdateframework/notary/server/timestamp github.com/theupdateframework/notary/signer github.com/theupdateframework/notary/signer/api github.com/theupdateframework/notary/signer/client github.com/theupdateframework/notary/signer/keydbstore github.com/theupdateframework/notary/storage github.com/theupdateframework/notary/storage/rethinkdb github.com/theupdateframework/notary/trustmanager github.com/theupdateframework/notary/trustmanager/remoteks github.com/theupdateframework/notary/trustmanager/yubikey github.com/theupdateframework/notary/trustpinning github.com/theupdateframework/notary/tuf github.com/theupdateframework/notary/tuf/data github.com/theupdateframework/notary/tuf/signed github.com/theupdateframework/notary/tuf/testutils github.com/theupdateframework/notary/tuf/testutils/interfaces github.com/theupdateframework/notary/tuf/testutils/keys github.com/theupdateframework/notary/tuf/utils github.com/theupdateframework/notary/tuf/validation github.com/theupdateframework/notary/utils github.com/theupdateframework/notary/version ? github.com/theupdateframework/notary [no test files] === RUN Test0Dot1Migration ---- PASS: Test0Dot1Migration (0.01s) +--- PASS: Test0Dot1Migration (0.04s) === RUN Test0Dot3Migration ---- PASS: Test0Dot3Migration (0.01s) +--- PASS: Test0Dot3Migration (0.00s) === RUN Test0Dot1RepoFormat -time="2024-01-06T11:06:11Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" ---- PASS: Test0Dot1RepoFormat (0.18s) +time="2025-02-07T17:33:17Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" +--- PASS: Test0Dot1RepoFormat (0.21s) === RUN Test0Dot3RepoFormat -time="2024-01-06T11:06:11Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" ---- PASS: Test0Dot3RepoFormat (0.23s) +time="2025-02-07T17:33:17Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" +--- PASS: Test0Dot3RepoFormat (0.20s) === RUN TestDownloading0Dot1RepoFormat ---- PASS: TestDownloading0Dot1RepoFormat (0.01s) +--- PASS: TestDownloading0Dot1RepoFormat (0.02s) === RUN TestDownloading0Dot3RepoFormat ---- PASS: TestDownloading0Dot3RepoFormat (0.01s) +--- PASS: TestDownloading0Dot3RepoFormat (0.00s) === RUN TestInitRepositoryManagedRolesIncludingRoot --- PASS: TestInitRepositoryManagedRolesIncludingRoot (0.00s) === RUN TestInitRepositoryManagedRolesInvalidRole --- PASS: TestInitRepositoryManagedRolesInvalidRole (0.00s) === RUN TestInitRepositoryManagedRolesIncludingTargets ---- PASS: TestInitRepositoryManagedRolesIncludingTargets (0.00s) +--- PASS: TestInitRepositoryManagedRolesIncludingTargets (0.01s) === RUN TestInitRepositoryManagedRolesIncludingTimestamp ---- PASS: TestInitRepositoryManagedRolesIncludingTimestamp (0.02s) +--- PASS: TestInitRepositoryManagedRolesIncludingTimestamp (0.01s) === RUN TestInitRepositoryWithCerts --- PASS: TestInitRepositoryWithCerts (0.02s) === RUN TestMatchKeyIDsWithPublicKeys @@ -1901,119 +1937,119 @@ === RUN TestInitRepositoryNeedsRemoteTimestampKey --- PASS: TestInitRepositoryNeedsRemoteTimestampKey (0.01s) === RUN TestInitRepositoryNeedsRemoteSnapshotKey ---- PASS: TestInitRepositoryNeedsRemoteSnapshotKey (0.01s) +--- PASS: TestInitRepositoryNeedsRemoteSnapshotKey (0.00s) === RUN TestInitRepoServerOnlyManagesTimestampKey ---- PASS: TestInitRepoServerOnlyManagesTimestampKey (0.12s) +--- PASS: TestInitRepoServerOnlyManagesTimestampKey (0.10s) === RUN TestInitRepoServerManagesTimestampAndSnapshotKeys ---- PASS: TestInitRepoServerManagesTimestampAndSnapshotKeys (0.10s) +--- PASS: TestInitRepoServerManagesTimestampAndSnapshotKeys (0.07s) === RUN TestInitRepoAttemptsExceeded ---- PASS: TestInitRepoAttemptsExceeded (0.07s) +--- PASS: TestInitRepoAttemptsExceeded (0.06s) === RUN TestInitRepoPasswordInvalid --- PASS: TestInitRepoPasswordInvalid (0.01s) === RUN TestAddTargetToTargetRoleByDefault ---- PASS: TestAddTargetToTargetRoleByDefault (0.03s) +--- PASS: TestAddTargetToTargetRoleByDefault (0.04s) === RUN TestAddTargetToSpecifiedValidRoles ---- PASS: TestAddTargetToSpecifiedValidRoles (0.04s) +--- PASS: TestAddTargetToSpecifiedValidRoles (0.03s) === RUN TestAddTargetToSpecifiedInvalidRoles ---- PASS: TestAddTargetToSpecifiedInvalidRoles (0.04s) +--- PASS: TestAddTargetToSpecifiedInvalidRoles (0.03s) === RUN TestAddTargetWithInvalidTarget ---- PASS: TestAddTargetWithInvalidTarget (0.02s) +--- PASS: TestAddTargetWithInvalidTarget (0.01s) === RUN TestAddTargetErrorWritingChanges ---- PASS: TestAddTargetErrorWritingChanges (0.02s) +--- PASS: TestAddTargetErrorWritingChanges (0.01s) === RUN TestRemoveTargetToTargetRoleByDefault ---- PASS: TestRemoveTargetToTargetRoleByDefault (0.04s) +--- PASS: TestRemoveTargetToTargetRoleByDefault (0.03s) === RUN TestRemoveTargetFromSpecifiedValidRoles ---- PASS: TestRemoveTargetFromSpecifiedValidRoles (0.04s) +--- PASS: TestRemoveTargetFromSpecifiedValidRoles (0.03s) === RUN TestRemoveTargetToSpecifiedInvalidRoles ---- PASS: TestRemoveTargetToSpecifiedInvalidRoles (0.04s) +--- PASS: TestRemoveTargetToSpecifiedInvalidRoles (0.03s) === RUN TestRemoveTargetErrorWritingChanges ---- PASS: TestRemoveTargetErrorWritingChanges (0.02s) +--- PASS: TestRemoveTargetErrorWritingChanges (0.01s) === RUN TestListTarget ---- PASS: TestListTarget (0.52s) +--- PASS: TestListTarget (0.45s) === RUN TestListTargetRestrictsDelegationPaths ---- PASS: TestListTargetRestrictsDelegationPaths (0.08s) +--- PASS: TestListTargetRestrictsDelegationPaths (0.03s) === RUN TestValidateRootKey ---- PASS: TestValidateRootKey (0.06s) +--- PASS: TestValidateRootKey (0.03s) === RUN TestGetChangelist ---- PASS: TestGetChangelist (0.06s) +--- PASS: TestGetChangelist (0.03s) === RUN TestPublishBareRepo ---- PASS: TestPublishBareRepo (0.50s) +--- PASS: TestPublishBareRepo (0.47s) === RUN TestPublishUninitializedRepo -time="2024-01-06T11:06:13Z" level=info msg="No TUF data found locally or remotely - initializing repository docker.com/notary for the first time" ---- PASS: TestPublishUninitializedRepo (0.03s) +time="2025-02-07T17:33:18Z" level=info msg="No TUF data found locally or remotely - initializing repository docker.com/notary for the first time" +--- PASS: TestPublishUninitializedRepo (0.04s) === RUN TestPublishClientHasSnapshotKey ---- PASS: TestPublishClientHasSnapshotKey (0.44s) +--- PASS: TestPublishClientHasSnapshotKey (0.37s) === RUN TestPublishAfterInitServerHasSnapshotKey ---- PASS: TestPublishAfterInitServerHasSnapshotKey (0.42s) +--- PASS: TestPublishAfterInitServerHasSnapshotKey (0.36s) === RUN TestPublishAfterPullServerHasSnapshotKey ---- PASS: TestPublishAfterPullServerHasSnapshotKey (0.16s) +--- PASS: TestPublishAfterPullServerHasSnapshotKey (0.10s) === RUN TestPublishNoOneHasSnapshotKey ---- PASS: TestPublishNoOneHasSnapshotKey (0.10s) +--- PASS: TestPublishNoOneHasSnapshotKey (0.07s) === RUN TestPublishSnapshotCorrupt ---- PASS: TestPublishSnapshotCorrupt (0.22s) +--- PASS: TestPublishSnapshotCorrupt (0.10s) === RUN TestPublishTargetsCorrupt ---- PASS: TestPublishTargetsCorrupt (0.11s) +--- PASS: TestPublishTargetsCorrupt (0.08s) === RUN TestPublishRootCorrupt -time="2024-01-06T11:06:15Z" level=error msg="Could not publish Repository since we could not update: invalid character 'h' in literal true (expecting 'r')" -time="2024-01-06T11:06:15Z" level=error msg="Could not publish Repository since we could not update: invalid character 'h' in literal true (expecting 'r')" ---- PASS: TestPublishRootCorrupt (0.08s) +time="2025-02-07T17:33:20Z" level=error msg="Could not publish Repository since we could not update: invalid character 'h' in literal true (expecting 'r')" +time="2025-02-07T17:33:20Z" level=error msg="Could not publish Repository since we could not update: invalid character 'h' in literal true (expecting 'r')" +--- PASS: TestPublishRootCorrupt (0.05s) === RUN TestPublishSnapshotLocalKeysCreatedFirst ---- PASS: TestPublishSnapshotLocalKeysCreatedFirst (0.01s) +--- PASS: TestPublishSnapshotLocalKeysCreatedFirst (0.00s) === RUN TestPublishDelegations ---- PASS: TestPublishDelegations (0.16s) +--- PASS: TestPublishDelegations (0.11s) === RUN TestPublishDelegationsX509 ---- PASS: TestPublishDelegationsX509 (0.17s) +--- PASS: TestPublishDelegationsX509 (0.13s) === RUN TestPublishTargetsDelegationScopeFailIfNoKeys -time="2024-01-06T11:06:15Z" level=error msg="couldn't add target to targets/a/b: tuf: invalid role targets/a/b. delegation does not exist" -time="2024-01-06T11:06:15Z" level=error msg="couldn't add target to targets/a/b: tuf: invalid role targets/a/b. delegation does not exist" ---- PASS: TestPublishTargetsDelegationScopeFailIfNoKeys (0.13s) +time="2025-02-07T17:33:20Z" level=error msg="couldn't add target to targets/a/b: tuf: invalid role targets/a/b. delegation does not exist" +time="2025-02-07T17:33:20Z" level=error msg="couldn't add target to targets/a/b: tuf: invalid role targets/a/b. delegation does not exist" +--- PASS: TestPublishTargetsDelegationScopeFailIfNoKeys (0.10s) === RUN TestPublishTargetsDelegationSuccessLocallyHasRoles ---- PASS: TestPublishTargetsDelegationSuccessLocallyHasRoles (0.14s) +--- PASS: TestPublishTargetsDelegationSuccessLocallyHasRoles (0.12s) === RUN TestPublishTargetsDelegationNoTargetsKeyNeeded --- PASS: TestPublishTargetsDelegationNoTargetsKeyNeeded (0.16s) === RUN TestPublishTargetsDelegationSuccessNeedsToDownloadRoles ---- PASS: TestPublishTargetsDelegationSuccessNeedsToDownloadRoles (0.16s) +--- PASS: TestPublishTargetsDelegationSuccessNeedsToDownloadRoles (0.14s) === RUN TestPublishTargetsDelegationFromTwoRepos ---- PASS: TestPublishTargetsDelegationFromTwoRepos (0.15s) +--- PASS: TestPublishTargetsDelegationFromTwoRepos (0.12s) === RUN TestPublishRemoveDelegationKeyFromDelegationRole -time="2024-01-06T11:06:16Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2024-01-06T11:06:16Z" 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: 2ee4923067c025ca2620d2a261758b58e3c4b4d16f128512a30f007f6e67f9de" ---- PASS: TestPublishRemoveDelegationKeyFromDelegationRole (0.10s) +time="2025-02-07T17:33:21Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2025-02-07T17:33:21Z" 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: 126d0400917e06829ea237ae410ae68449e17623ddf63f59cd8f2302f7d42b54" +--- PASS: TestPublishRemoveDelegationKeyFromDelegationRole (0.09s) === RUN TestPublishRemoveDelegation -time="2024-01-06T11:06:16Z" 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-06T11:06:16Z" 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-06T11:06:16Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2024-01-06T11:06:16Z" 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.10s) +time="2025-02-07T17:33:21Z" 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-07T17:33:21Z" 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-07T17:33:21Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2025-02-07T17:33:21Z" 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.09s) === RUN TestPublishSucceedsDespiteDelegationCorrupt ---- PASS: TestPublishSucceedsDespiteDelegationCorrupt (0.12s) +--- PASS: TestPublishSucceedsDespiteDelegationCorrupt (0.11s) === RUN TestRotateKeyInvalidRole ---- PASS: TestRotateKeyInvalidRole (0.06s) +--- PASS: TestRotateKeyInvalidRole (0.04s) === RUN TestRemoteRotationError --- PASS: TestRemoteRotationError (0.01s) === RUN TestRemoteRotationEndpointError ---- PASS: TestRemoteRotationEndpointError (0.04s) +--- PASS: TestRemoteRotationEndpointError (0.03s) === RUN TestRemoteRotationNoRootKey ---- PASS: TestRemoteRotationNoRootKey (0.06s) +--- PASS: TestRemoteRotationNoRootKey (0.04s) === RUN TestRemoteRotationNoInit -time="2024-01-06T11:06:16Z" level=info msg="No TUF data found locally or remotely - initializing repository docker.com/notary for the first time" ---- PASS: TestRemoteRotationNoInit (0.04s) +time="2025-02-07T17:33:21Z" level=info msg="No TUF data found locally or remotely - initializing repository docker.com/notary for the first time" +--- PASS: TestRemoteRotationNoInit (0.03s) === RUN TestRotateBeforePublishFromRemoteKeyToLocalKey ---- PASS: TestRotateBeforePublishFromRemoteKeyToLocalKey (0.18s) +--- PASS: TestRotateBeforePublishFromRemoteKeyToLocalKey (0.19s) === RUN TestRotateKeyAfterPublishNoServerManagementChange ---- PASS: TestRotateKeyAfterPublishNoServerManagementChange (0.49s) +--- PASS: TestRotateKeyAfterPublishNoServerManagementChange (0.40s) === RUN TestRotateKeyAfterPublishServerManagementChange ---- PASS: TestRotateKeyAfterPublishServerManagementChange (0.55s) +--- PASS: TestRotateKeyAfterPublishServerManagementChange (0.50s) === RUN TestRotateRootKey ---- PASS: TestRotateRootKey (0.16s) +--- PASS: TestRotateRootKey (0.13s) === RUN TestRotateRootMultiple ---- PASS: TestRotateRootMultiple (0.22s) +--- PASS: TestRotateRootMultiple (0.24s) === RUN TestRotateRootKeyProvided ---- PASS: TestRotateRootKeyProvided (0.16s) +--- PASS: TestRotateRootKeyProvided (0.19s) === RUN TestRotateRootKeyLegacySupport ---- PASS: TestRotateRootKeyLegacySupport (0.24s) +--- PASS: TestRotateRootKeyLegacySupport (0.27s) === RUN TestRemoteServerUnavailableNoLocalCache -time="2024-01-06T11:06:18Z" level=error msg="Could not publish Repository since we could not update: unable to reach trust server at this time: 500." +time="2025-02-07T17:33:23Z" 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.02s) @@ -2022,185 +2058,185 @@ === RUN TestAddDelegationErrorWritingChanges --- PASS: TestAddDelegationErrorWritingChanges (0.02s) === RUN TestRemoveDelegationChangefileValid ---- PASS: TestRemoveDelegationChangefileValid (0.02s) +--- PASS: TestRemoveDelegationChangefileValid (0.01s) === RUN TestRemoveDelegationChangefileApplicable -time="2024-01-06T11:06:18Z" 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-06T11:06:18Z" 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-07T17:33:23Z" 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-07T17:33:23Z" 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.02s) === RUN TestClearAllPathsDelegationChangefileApplicable ---- PASS: TestClearAllPathsDelegationChangefileApplicable (0.02s) +--- PASS: TestClearAllPathsDelegationChangefileApplicable (0.01s) === RUN TestFullAddDelegationChangefileApplicable --- PASS: TestFullAddDelegationChangefileApplicable (0.02s) === RUN TestFullRemoveDelegationChangefileApplicable ---- PASS: TestFullRemoveDelegationChangefileApplicable (0.02s) +--- PASS: TestFullRemoveDelegationChangefileApplicable (0.04s) === RUN TestRemoveDelegationErrorWritingChanges --- PASS: TestRemoveDelegationErrorWritingChanges (0.02s) === RUN TestClientInvalidURL --- PASS: TestClientInvalidURL (0.00s) === RUN TestPublishTargetsDelegationCanUseUserKeyWithArbitraryRole ---- PASS: TestPublishTargetsDelegationCanUseUserKeyWithArbitraryRole (0.31s) +--- PASS: TestPublishTargetsDelegationCanUseUserKeyWithArbitraryRole (0.29s) === RUN TestDeleteRepo --- PASS: TestDeleteRepo (0.04s) === RUN TestDeleteRemoteRepo ---- PASS: TestDeleteRemoteRepo (0.11s) +--- PASS: TestDeleteRemoteRepo (0.12s) === RUN TestListRoles ---- PASS: TestListRoles (0.21s) +--- PASS: TestListRoles (0.23s) === RUN TestGetAllTargetInfo ---- PASS: TestGetAllTargetInfo (0.13s) +--- PASS: TestGetAllTargetInfo (0.11s) === RUN TestUpdateSucceedsEvenIfCannotWriteNewRepo -time="2024-01-06T11:06:19Z" level=error msg="could not save root to cache: Non-writable" ---- PASS: TestUpdateSucceedsEvenIfCannotWriteNewRepo (0.11s) +time="2025-02-07T17:33:24Z" level=error msg="could not save root to cache: Non-writable" +--- PASS: TestUpdateSucceedsEvenIfCannotWriteNewRepo (0.13s) === RUN TestUpdateSucceedsEvenIfCannotWriteExistingRepo ---- PASS: TestUpdateSucceedsEvenIfCannotWriteExistingRepo (0.47s) +--- PASS: TestUpdateSucceedsEvenIfCannotWriteExistingRepo (0.58s) === RUN TestUpdateInOfflineMode -time="2024-01-06T11:06:20Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" -time="2024-01-06T11:06:20Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" ---- PASS: TestUpdateInOfflineMode (0.04s) +time="2025-02-07T17:33:25Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" +time="2025-02-07T17:33:25Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" +--- PASS: TestUpdateInOfflineMode (0.07s) === RUN TestUpdateReplacesCorruptOrMissingMetadata -time="2024-01-06T11:06:21Z" level=error msg="Metadata for root expired" -time="2024-01-06T11:06:21Z" level=error msg="Metadata for root expired" ---- PASS: TestUpdateReplacesCorruptOrMissingMetadata (0.84s) +time="2025-02-07T17:33:25Z" level=error msg="Metadata for root expired" +time="2025-02-07T17:33:25Z" level=error msg="Metadata for root expired" +--- PASS: TestUpdateReplacesCorruptOrMissingMetadata (1.13s) === RUN TestUpdateFailsIfServerRootKeyChangedWithoutMultiSign -time="2024-01-06T11:06:21Z" level=error msg="Metadata for root expired" -time="2024-01-06T11:06:21Z" level=error msg="Metadata for root expired" ---- PASS: TestUpdateFailsIfServerRootKeyChangedWithoutMultiSign (0.08s) +time="2025-02-07T17:33:26Z" level=error msg="Metadata for root expired" +time="2025-02-07T17:33:26Z" level=error msg="Metadata for root expired" +--- PASS: TestUpdateFailsIfServerRootKeyChangedWithoutMultiSign (0.14s) === RUN TestUpdateRemoteRootNotExistNoLocalCache ---- PASS: TestUpdateRemoteRootNotExistNoLocalCache (0.03s) +--- PASS: TestUpdateRemoteRootNotExistNoLocalCache (0.06s) === RUN TestUpdateRemoteRootNotExistCanUseLocalCache ---- PASS: TestUpdateRemoteRootNotExistCanUseLocalCache (0.07s) +--- PASS: TestUpdateRemoteRootNotExistCanUseLocalCache (0.11s) === RUN TestUpdateRemoteRootNotExistCannotUseLocalCache ---- PASS: TestUpdateRemoteRootNotExistCannotUseLocalCache (0.08s) +--- PASS: TestUpdateRemoteRootNotExistCannotUseLocalCache (0.13s) === RUN TestUpdateRemoteRoot50XNoLocalCache ---- PASS: TestUpdateRemoteRoot50XNoLocalCache (0.03s) +--- PASS: TestUpdateRemoteRoot50XNoLocalCache (0.05s) === RUN TestUpdateRemoteRoot50XCanUseLocalCache ---- PASS: TestUpdateRemoteRoot50XCanUseLocalCache (0.07s) +--- PASS: TestUpdateRemoteRoot50XCanUseLocalCache (0.10s) === RUN TestUpdateRemoteRoot50XCannotUseLocalCache ---- PASS: TestUpdateRemoteRoot50XCannotUseLocalCache (0.08s) +--- PASS: TestUpdateRemoteRoot50XCannotUseLocalCache (0.09s) === RUN TestUpdateNonRootRemoteMissingMetadataNoLocalCache ---- PASS: TestUpdateNonRootRemoteMissingMetadataNoLocalCache (0.17s) +--- PASS: TestUpdateNonRootRemoteMissingMetadataNoLocalCache (0.19s) === RUN TestUpdateNonRootRemoteMissingMetadataCanUseLocalCache -time="2024-01-06T11:06:21Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" ---- PASS: TestUpdateNonRootRemoteMissingMetadataCanUseLocalCache (0.23s) +time="2025-02-07T17:33:27Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" +--- PASS: TestUpdateNonRootRemoteMissingMetadataCanUseLocalCache (0.18s) === RUN TestUpdateNonRootRemoteMissingMetadataCannotUseLocalCache -time="2024-01-06T11:06:22Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" ---- PASS: TestUpdateNonRootRemoteMissingMetadataCannotUseLocalCache (0.30s) +time="2025-02-07T17:33:27Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" +--- PASS: TestUpdateNonRootRemoteMissingMetadataCannotUseLocalCache (0.17s) === RUN TestUpdateNonRootRemote50XNoLocalCache ---- PASS: TestUpdateNonRootRemote50XNoLocalCache (0.17s) +--- PASS: TestUpdateNonRootRemote50XNoLocalCache (0.08s) === RUN TestUpdateNonRootRemote50XCanUseLocalCache -time="2024-01-06T11:06:22Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" ---- PASS: TestUpdateNonRootRemote50XCanUseLocalCache (0.23s) +time="2025-02-07T17:33:27Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" +--- PASS: TestUpdateNonRootRemote50XCanUseLocalCache (0.15s) === RUN TestUpdateNonRootRemote50XCannotUseLocalCache -time="2024-01-06T11:06:22Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" ---- PASS: TestUpdateNonRootRemote50XCannotUseLocalCache (0.30s) +time="2025-02-07T17:33:27Z" level=warning msg="Error while downloading remote metadata, using cached timestamp - this might not be the latest version available remotely" +--- PASS: TestUpdateNonRootRemote50XCannotUseLocalCache (0.26s) === RUN TestUpdateRemoteChecksumWrongNoLocalCache ---- PASS: TestUpdateRemoteChecksumWrongNoLocalCache (0.22s) +--- PASS: TestUpdateRemoteChecksumWrongNoLocalCache (0.14s) === RUN TestUpdateRemoteChecksumWrongCanUseLocalCache ---- PASS: TestUpdateRemoteChecksumWrongCanUseLocalCache (0.31s) +--- PASS: TestUpdateRemoteChecksumWrongCanUseLocalCache (0.16s) === RUN TestUpdateRemoteChecksumWrongCannotUseLocalCache ---- PASS: TestUpdateRemoteChecksumWrongCannotUseLocalCache (0.40s) +--- PASS: TestUpdateRemoteChecksumWrongCannotUseLocalCache (0.28s) === RUN TestUpdateRootRemoteCorruptedNoLocalCache -time="2024-01-06T11:06:24Z" level=error msg="Metadata for root expired" -time="2024-01-06T11:06:24Z" level=error msg="Metadata for root expired" ---- PASS: TestUpdateRootRemoteCorruptedNoLocalCache (0.66s) +time="2025-02-07T17:33:28Z" level=error msg="Metadata for root expired" +time="2025-02-07T17:33:28Z" level=error msg="Metadata for root expired" +--- PASS: TestUpdateRootRemoteCorruptedNoLocalCache (0.57s) === RUN TestUpdateRootRemoteCorruptedCanUseLocalCache ---- PASS: TestUpdateRootRemoteCorruptedCanUseLocalCache (1.36s) +--- PASS: TestUpdateRootRemoteCorruptedCanUseLocalCache (1.13s) === RUN TestUpdateRootRemoteCorruptedCannotUseLocalCache -time="2024-01-06T11:06:26Z" level=error msg="Metadata for root expired" -time="2024-01-06T11:06:26Z" level=error msg="Metadata for root expired" ---- PASS: TestUpdateRootRemoteCorruptedCannotUseLocalCache (1.58s) +time="2025-02-07T17:33:30Z" level=error msg="Metadata for root expired" +time="2025-02-07T17:33:30Z" level=error msg="Metadata for root expired" +--- PASS: TestUpdateRootRemoteCorruptedCannotUseLocalCache (1.37s) === RUN TestUpdateNonRootRemoteCorruptedNoLocalCache -time="2024-01-06T11:06:27Z" level=error msg="Metadata for targets expired" -time="2024-01-06T11:06:27Z" level=error msg="Metadata for targets expired" -time="2024-01-06T11:06:28Z" level=error msg="Metadata for snapshot expired" -time="2024-01-06T11:06:28Z" level=error msg="Metadata for snapshot expired" -time="2024-01-06T11:06:28Z" level=error msg="Metadata for timestamp expired" -time="2024-01-06T11:06:28Z" level=error msg="Metadata for timestamp expired" -time="2024-01-06T11:06:28Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2024-01-06T11:06:28Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2024-01-06T11:06:28Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2024-01-06T11:06:28Z" level=error msg="Metadata for targets/a expired" -time="2024-01-06T11:06:28Z" level=warning msg="Error getting targets/a: targets/a expired at Mon Dec 5 11:06:28 UTC 2022" -time="2024-01-06T11:06:28Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" -time="2024-01-06T11:06:28Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" -time="2024-01-06T11:06:28Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" -time="2024-01-06T11:06:28Z" level=error msg="Metadata for targets/a/b expired" -time="2024-01-06T11:06:28Z" level=warning msg="Error getting targets/a/b: targets/a/b expired at Mon Dec 5 11:06:28 UTC 2022" -time="2024-01-06T11:06:29Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" -time="2024-01-06T11:06:29Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" -time="2024-01-06T11:06:29Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" -time="2024-01-06T11:06:29Z" level=error msg="Metadata for targets/b expired" -time="2024-01-06T11:06:29Z" level=warning msg="Error getting targets/b: targets/b expired at Mon Dec 5 11:06:29 UTC 2022" ---- PASS: TestUpdateNonRootRemoteCorruptedNoLocalCache (1.71s) +time="2025-02-07T17:33:31Z" level=error msg="Metadata for targets expired" +time="2025-02-07T17:33:31Z" level=error msg="Metadata for targets expired" +time="2025-02-07T17:33:31Z" level=error msg="Metadata for snapshot expired" +time="2025-02-07T17:33:31Z" level=error msg="Metadata for snapshot expired" +time="2025-02-07T17:33:32Z" level=error msg="Metadata for timestamp expired" +time="2025-02-07T17:33:32Z" level=error msg="Metadata for timestamp expired" +time="2025-02-07T17:33:32Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2025-02-07T17:33:32Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2025-02-07T17:33:32Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2025-02-07T17:33:32Z" level=error msg="Metadata for targets/a expired" +time="2025-02-07T17:33:32Z" level=warning msg="Error getting targets/a: targets/a expired at Sat Jan 6 17:33:32 UTC 2024" +time="2025-02-07T17:33:32Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" +time="2025-02-07T17:33:32Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" +time="2025-02-07T17:33:32Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" +time="2025-02-07T17:33:32Z" level=error msg="Metadata for targets/a/b expired" +time="2025-02-07T17:33:32Z" level=warning msg="Error getting targets/a/b: targets/a/b expired at Sat Jan 6 17:33:32 UTC 2024" +time="2025-02-07T17:33:32Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" +time="2025-02-07T17:33:32Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" +time="2025-02-07T17:33:32Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" +time="2025-02-07T17:33:32Z" level=error msg="Metadata for targets/b expired" +time="2025-02-07T17:33:32Z" level=warning msg="Error getting targets/b: targets/b expired at Sat Jan 6 17:33:32 UTC 2024" +--- PASS: TestUpdateNonRootRemoteCorruptedNoLocalCache (1.24s) === RUN TestUpdateNonRootRemoteCorruptedCanUseLocalCache -time="2024-01-06T11:06:30Z" level=error msg="Metadata for timestamp expired" -time="2024-01-06T11:06:30Z" level=error msg="Metadata for timestamp expired" ---- PASS: TestUpdateNonRootRemoteCorruptedCanUseLocalCache (2.27s) +time="2025-02-07T17:33:33Z" level=error msg="Metadata for timestamp expired" +time="2025-02-07T17:33:33Z" level=error msg="Metadata for timestamp expired" +--- PASS: TestUpdateNonRootRemoteCorruptedCanUseLocalCache (2.04s) === RUN TestUpdateNonRootRemoteCorruptedCannotUseLocalCache -time="2024-01-06T11:06:32Z" level=error msg="Metadata for targets expired" -time="2024-01-06T11:06:32Z" level=error msg="Metadata for snapshot expired" -time="2024-01-06T11:06:32Z" level=error msg="Metadata for snapshot expired" -time="2024-01-06T11:06:32Z" level=error msg="Metadata for timestamp expired" -time="2024-01-06T11:06:32Z" level=error msg="Metadata for timestamp expired" -time="2024-01-06T11:06:33Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2024-01-06T11:06:33Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2024-01-06T11:06:33Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2024-01-06T11:06:33Z" level=error msg="Metadata for targets/a expired" -time="2024-01-06T11:06:33Z" level=warning msg="Error getting targets/a: targets/a expired at Mon Dec 5 11:06:33 UTC 2022" -time="2024-01-06T11:06:33Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" -time="2024-01-06T11:06:33Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" -time="2024-01-06T11:06:33Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" -time="2024-01-06T11:06:33Z" level=error msg="Metadata for targets/a/b expired" -time="2024-01-06T11:06:33Z" level=warning msg="Error getting targets/a/b: targets/a/b expired at Mon Dec 5 11:06:33 UTC 2022" -time="2024-01-06T11:06:34Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" -time="2024-01-06T11:06:34Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" -time="2024-01-06T11:06:34Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" -time="2024-01-06T11:06:34Z" level=error msg="Metadata for targets/b expired" -time="2024-01-06T11:06:34Z" level=warning msg="Error getting targets/b: targets/b expired at Mon Dec 5 11:06:34 UTC 2022" ---- PASS: TestUpdateNonRootRemoteCorruptedCannotUseLocalCache (3.08s) +time="2025-02-07T17:33:35Z" level=error msg="Metadata for targets expired" +time="2025-02-07T17:33:35Z" level=error msg="Metadata for snapshot expired" +time="2025-02-07T17:33:35Z" level=error msg="Metadata for snapshot expired" +time="2025-02-07T17:33:35Z" level=error msg="Metadata for timestamp expired" +time="2025-02-07T17:33:35Z" level=error msg="Metadata for timestamp expired" +time="2025-02-07T17:33:36Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2025-02-07T17:33:36Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2025-02-07T17:33:36Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2025-02-07T17:33:36Z" level=error msg="Metadata for targets/a expired" +time="2025-02-07T17:33:36Z" level=warning msg="Error getting targets/a: targets/a expired at Sat Jan 6 17:33:36 UTC 2024" +time="2025-02-07T17:33:36Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" +time="2025-02-07T17:33:36Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" +time="2025-02-07T17:33:36Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" +time="2025-02-07T17:33:36Z" level=error msg="Metadata for targets/a/b expired" +time="2025-02-07T17:33:36Z" level=warning msg="Error getting targets/a/b: targets/a/b expired at Sat Jan 6 17:33:36 UTC 2024" +time="2025-02-07T17:33:37Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" +time="2025-02-07T17:33:37Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" +time="2025-02-07T17:33:37Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" +time="2025-02-07T17:33:37Z" level=error msg="Metadata for targets/b expired" +time="2025-02-07T17:33:37Z" level=warning msg="Error getting targets/b: targets/b expired at Sat Jan 6 17:33:37 UTC 2024" +--- PASS: TestUpdateNonRootRemoteCorruptedCannotUseLocalCache (2.49s) === RUN TestUpdateLocalAndRemoteRootCorrupt -time="2024-01-06T11:06:35Z" level=error msg="Metadata for root expired" -time="2024-01-06T11:06:35Z" level=error msg="Metadata for root expired" -time="2024-01-06T11:06:37Z" level=error msg="Metadata for root expired" -time="2024-01-06T11:06:37Z" level=error msg="Metadata for root expired" -time="2024-01-06T11:06:37Z" level=error msg="Metadata for root expired" -time="2024-01-06T11:06:37Z" level=error msg="Metadata for root expired" -time="2024-01-06T11:06:37Z" level=error msg="Metadata for root expired" -time="2024-01-06T11:06:37Z" level=error msg="Metadata for root expired" -time="2024-01-06T11:06:37Z" level=error msg="Metadata for root expired" -time="2024-01-06T11:06:37Z" level=error msg="Metadata for root expired" -time="2024-01-06T11:06:37Z" level=error msg="Metadata for root expired" -time="2024-01-06T11:06:37Z" level=error msg="Metadata for root expired" -time="2024-01-06T11:06:37Z" level=error msg="Metadata for root expired" -time="2024-01-06T11:06:37Z" level=error msg="Metadata for root expired" -time="2024-01-06T11:06:37Z" level=error msg="Metadata for root expired" -time="2024-01-06T11:06:37Z" level=error msg="Metadata for root expired" -time="2024-01-06T11:06:37Z" level=error msg="Metadata for root expired" -time="2024-01-06T11:06:37Z" level=error msg="Metadata for root expired" -time="2024-01-06T11:06:38Z" level=error msg="Metadata for root expired" -time="2024-01-06T11:06:38Z" level=error msg="Metadata for root expired" -time="2024-01-06T11:06:38Z" level=error msg="Metadata for root expired" -time="2024-01-06T11:06:38Z" level=error msg="Metadata for root expired" ---- PASS: TestUpdateLocalAndRemoteRootCorrupt (3.38s) +time="2025-02-07T17:33:38Z" level=error msg="Metadata for root expired" +time="2025-02-07T17:33:38Z" level=error msg="Metadata for root expired" +time="2025-02-07T17:33:39Z" level=error msg="Metadata for root expired" +time="2025-02-07T17:33:39Z" level=error msg="Metadata for root expired" +time="2025-02-07T17:33:39Z" level=error msg="Metadata for root expired" +time="2025-02-07T17:33:39Z" level=error msg="Metadata for root expired" +time="2025-02-07T17:33:39Z" level=error msg="Metadata for root expired" +time="2025-02-07T17:33:39Z" level=error msg="Metadata for root expired" +time="2025-02-07T17:33:39Z" level=error msg="Metadata for root expired" +time="2025-02-07T17:33:39Z" level=error msg="Metadata for root expired" +time="2025-02-07T17:33:39Z" level=error msg="Metadata for root expired" +time="2025-02-07T17:33:39Z" level=error msg="Metadata for root expired" +time="2025-02-07T17:33:39Z" level=error msg="Metadata for root expired" +time="2025-02-07T17:33:39Z" level=error msg="Metadata for root expired" +time="2025-02-07T17:33:39Z" level=error msg="Metadata for root expired" +time="2025-02-07T17:33:39Z" level=error msg="Metadata for root expired" +time="2025-02-07T17:33:39Z" level=error msg="Metadata for root expired" +time="2025-02-07T17:33:39Z" level=error msg="Metadata for root expired" +time="2025-02-07T17:33:40Z" level=error msg="Metadata for root expired" +time="2025-02-07T17:33:40Z" level=error msg="Metadata for root expired" +time="2025-02-07T17:33:40Z" level=error msg="Metadata for root expired" +time="2025-02-07T17:33:40Z" level=error msg="Metadata for root expired" +--- PASS: TestUpdateLocalAndRemoteRootCorrupt (2.67s) === RUN TestUpdateRemoteKeyRotated -time="2024-01-06T11:06:38Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" -time="2024-01-06T11:06:38Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" -time="2024-01-06T11:06:38Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" ---- PASS: TestUpdateRemoteKeyRotated (0.32s) +time="2025-02-07T17:33:40Z" level=warning msg="Error getting targets/a: valid signatures did not meet threshold for targets/a" +time="2025-02-07T17:33:40Z" level=warning msg="Error getting targets/a/b: valid signatures did not meet threshold for targets/a/b" +time="2025-02-07T17:33:40Z" level=warning msg="Error getting targets/b: valid signatures did not meet threshold for targets/b" +--- PASS: TestUpdateRemoteKeyRotated (0.27s) === RUN TestValidateRootRotationWithOldRole ---- PASS: TestValidateRootRotationWithOldRole (0.16s) +--- PASS: TestValidateRootRotationWithOldRole (0.13s) === RUN TestRootRoleInvariant ---- PASS: TestRootRoleInvariant (0.14s) +--- PASS: TestRootRoleInvariant (0.12s) === RUN TestBadIntermediateTransitions --- PASS: TestBadIntermediateTransitions (0.05s) === RUN TestExpiredIntermediateTransitions -time="2024-01-06T11:06:38Z" level=warning msg="root is nearing expiry, you should re-sign the role metadata" ---- PASS: TestExpiredIntermediateTransitions (0.06s) +time="2025-02-07T17:33:40Z" level=warning msg="root is nearing expiry, you should re-sign the role metadata" +--- PASS: TestExpiredIntermediateTransitions (0.05s) === RUN TestDownloadTargetsLarge ---- PASS: TestDownloadTargetsLarge (3.19s) +--- PASS: TestDownloadTargetsLarge (5.24s) === RUN TestDownloadTargetsDeep --- PASS: TestDownloadTargetsDeep (0.03s) === RUN TestDownloadSnapshotLargeDelegationsMany ---- PASS: TestDownloadSnapshotLargeDelegationsMany (2.52s) +--- PASS: TestDownloadSnapshotLargeDelegationsMany (4.17s) === RUN TestRootOnDiskTrustPinning --- PASS: TestRootOnDiskTrustPinning (0.03s) === RUN TestLoadTUFRepoBadURL @@ -2216,25 +2252,25 @@ === RUN TestApplyTargetsDelegationCreateDelete --- PASS: TestApplyTargetsDelegationCreateDelete (0.00s) === RUN TestApplyTargetsDelegationCreate2SharedKey ---- PASS: TestApplyTargetsDelegationCreate2SharedKey (0.00s) +--- PASS: TestApplyTargetsDelegationCreate2SharedKey (0.01s) === RUN TestApplyTargetsDelegationCreateEdit --- PASS: TestApplyTargetsDelegationCreateEdit (0.00s) === RUN TestApplyTargetsDelegationEditNonExisting --- PASS: TestApplyTargetsDelegationEditNonExisting (0.00s) === RUN TestApplyTargetsDelegationCreateAlreadyExisting ---- PASS: TestApplyTargetsDelegationCreateAlreadyExisting (0.00s) +--- PASS: TestApplyTargetsDelegationCreateAlreadyExisting (0.01s) === RUN TestApplyTargetsDelegationAlreadyExistingMergePaths --- PASS: TestApplyTargetsDelegationAlreadyExistingMergePaths (0.00s) === RUN TestApplyTargetsDelegationInvalidRole --- PASS: TestApplyTargetsDelegationInvalidRole (0.00s) === RUN TestApplyTargetsDelegationInvalidJSONContent ---- PASS: TestApplyTargetsDelegationInvalidJSONContent (0.00s) +--- PASS: TestApplyTargetsDelegationInvalidJSONContent (0.01s) === RUN TestApplyTargetsDelegationInvalidAction --- PASS: TestApplyTargetsDelegationInvalidAction (0.00s) === RUN TestApplyTargetsChangeInvalidType --- PASS: TestApplyTargetsChangeInvalidType (0.00s) === RUN TestApplyTargetsDelegationCreate2Deep ---- PASS: TestApplyTargetsDelegationCreate2Deep (0.00s) +--- PASS: TestApplyTargetsDelegationCreate2Deep (0.01s) === RUN TestApplyTargetsDelegationParentDoesntExist --- PASS: TestApplyTargetsDelegationParentDoesntExist (0.00s) === RUN TestApplyChangelistCreatesDelegation @@ -2242,15 +2278,15 @@ === RUN TestApplyChangelistTargetsToMultipleRoles --- PASS: TestApplyChangelistTargetsToMultipleRoles (0.00s) === RUN TestApplyChangelistTargetsFailsNonexistentRole -time="2024-01-06T11:06:44Z" level=error msg="couldn't add target to targets/level1/level2/level3/level4: tuf: invalid role targets/level1/level2/level3/level4. delegation does not exist" -time="2024-01-06T11:06:44Z" level=error msg="couldn't remove target from targets/level1/level2/level3/level4: tuf: invalid role targets/level1/level2/level3/level4. delegation does not exist" +time="2025-02-07T17:33:50Z" 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-07T17:33:50Z" level=error msg="couldn't remove target from targets/level1/level2/level3/level4: tuf: invalid role targets/level1/level2/level3/level4. delegation does not exist" --- PASS: TestApplyChangelistTargetsFailsNonexistentRole (0.00s) === RUN TestChangeTargetMetaFailsInvalidRole -time="2024-01-06T11:06:44Z" level=error msg="couldn't add target to ruhroh: tuf: invalid role ruhroh. does not exist" +time="2025-02-07T17:33:50Z" level=error msg="couldn't add target to ruhroh: tuf: invalid role ruhroh. does not exist" --- PASS: TestChangeTargetMetaFailsInvalidRole (0.00s) === RUN TestChangeTargetMetaFailsIfPrefixError -time="2024-01-06T11:06:44Z" level=error msg="couldn't add target to targets/level1: Could not add all targets" ---- PASS: TestChangeTargetMetaFailsIfPrefixError (0.00s) +time="2025-02-07T17:33:50Z" level=error msg="couldn't add target to targets/level1: Could not add all targets" +--- PASS: TestChangeTargetMetaFailsIfPrefixError (0.01s) === RUN TestAllNearExpiry --- PASS: TestAllNearExpiry (0.00s) === RUN TestAllNotNearExpiry @@ -2258,7 +2294,7 @@ === RUN TestRotateRemoteKeyOffline --- PASS: TestRotateRemoteKeyOffline (0.00s) PASS -ok github.com/theupdateframework/notary/client 33.340s +ok github.com/theupdateframework/notary/client 33.379s === RUN TestTUFDelegation --- PASS: TestTUFDelegation (0.00s) === RUN TestMemChangelist @@ -2270,14 +2306,14 @@ === RUN TestAdd --- PASS: TestAdd (0.00s) === RUN TestErrorConditions -time="2024-01-06T11:06:08Z" level=warning msg="invalid character '\\x05' looking for beginning of value" +time="2025-02-07T17:33:10Z" level=warning msg="invalid character '\\x05' looking for beginning of value" --- PASS: TestErrorConditions (0.00s) === RUN TestListOrder --- PASS: TestListOrder (0.00s) === RUN TestFileChangeIterator --- PASS: TestFileChangeIterator (0.00s) PASS -ok github.com/theupdateframework/notary/client/changelist 0.021s +ok github.com/theupdateframework/notary/client/changelist 0.047s === RUN TestParseConfigError --- PASS: TestParseConfigError (0.00s) === RUN TestSetupGRPCServer @@ -2287,7 +2323,7 @@ === RUN TestSetupNetListener --- PASS: TestSetupNetListener (0.00s) PASS -ok github.com/theupdateframework/notary/cmd/escrow 0.034s +ok github.com/theupdateframework/notary/cmd/escrow 0.105s === RUN TestPurgeDelegationKeys Usage: delegation [command] @@ -2311,15 +2347,15 @@ Use "delegation [command] --help" for more information about a command. Removal of the following keys from all delegations in gun staged for next publish: - abc ---- PASS: TestPurgeDelegationKeys (0.01s) +--- PASS: TestPurgeDelegationKeys (0.04s) === RUN TestAddInvalidDelegationName --- PASS: TestAddInvalidDelegationName (0.00s) === RUN TestAddInvalidDelegationCert --- PASS: TestAddInvalidDelegationCert (0.00s) === RUN TestAddInvalidShortPubkeyCert ---- PASS: TestAddInvalidShortPubkeyCert (0.00s) +--- PASS: TestAddInvalidShortPubkeyCert (0.01s) === RUN TestRemoveInvalidDelegationName ---- PASS: TestRemoveInvalidDelegationName (0.00s) +--- PASS: TestRemoveInvalidDelegationName (0.01s) === RUN TestRemoveAllInvalidDelegationName --- PASS: TestRemoveAllInvalidDelegationName (0.00s) === RUN TestAddInvalidNumArgs @@ -2359,77 +2395,77 @@ Use "delegation [command] --help" for more information about a command. --- PASS: TestRemoveInvalidNumArgs (0.00s) === RUN TestInitWithRootKey ---- PASS: TestInitWithRootKey (0.12s) +--- PASS: TestInitWithRootKey (0.13s) === RUN TestInitWithRootCert ---- PASS: TestInitWithRootCert (0.08s) +--- PASS: TestInitWithRootCert (0.06s) === RUN TestClientTUFInteraction ---- PASS: TestClientTUFInteraction (0.19s) +--- PASS: TestClientTUFInteraction (0.26s) === RUN TestClientDeleteTUFInteraction -time="2024-01-06T11:06:11Z" 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]:43413->[::1]:53: read: connection refused" ---- PASS: TestClientDeleteTUFInteraction (0.21s) +time="2025-02-07T17:33:18Z" 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]:44599->[::1]:53: read: connection refused" +--- PASS: TestClientDeleteTUFInteraction (0.26s) === RUN TestClientTUFAddByHashInteraction --- PASS: TestClientTUFAddByHashInteraction (0.35s) === RUN TestClientDelegationsInteraction -time="2024-01-06T11:06:12Z" level=warning msg="role targets/delegation has fewer keys than its threshold of 1; it will not be usable until keys are added to it" -time="2024-01-06T11:06:12Z" level=warning msg="role targets/delegation has fewer keys than its threshold of 1; it will not be usable until keys are added to it" ---- PASS: TestClientDelegationsInteraction (0.81s) +time="2025-02-07T17:33:18Z" 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-07T17:33:18Z" level=warning msg="role targets/delegation has fewer keys than its threshold of 1; it will not be usable until keys are added to it" +--- PASS: TestClientDelegationsInteraction (0.89s) === RUN TestClientDelegationsPublishing ---- PASS: TestClientDelegationsPublishing (1.07s) +--- PASS: TestClientDelegationsPublishing (1.09s) === RUN TestClientKeyGenerationRotation ---- PASS: TestClientKeyGenerationRotation (0.97s) +--- PASS: TestClientKeyGenerationRotation (0.88s) === RUN TestKeyRotation ---- PASS: TestKeyRotation (0.14s) +--- PASS: TestKeyRotation (0.12s) === RUN TestKeyRotationNonRoot ---- PASS: TestKeyRotationNonRoot (0.18s) +--- PASS: TestKeyRotationNonRoot (0.16s) === RUN TestDefaultRootKeyGeneration ---- PASS: TestDefaultRootKeyGeneration (0.01s) +--- PASS: TestDefaultRootKeyGeneration (0.00s) === RUN TestLogLevelFlags --- PASS: TestLogLevelFlags (0.00s) === RUN TestClientKeyPassphraseChange ---- PASS: TestClientKeyPassphraseChange (0.15s) +--- PASS: TestClientKeyPassphraseChange (0.13s) === RUN TestPurgeSingleKey Removal of the following keys from all delegations in gun staged for next publish: - - ab7d3f5bc10a38d69514cb02f152a1633f3383281375faf82dbfdd7253eff0c2 ---- PASS: TestPurgeSingleKey (0.15s) + - 92e3180f9a7f254e83ef3b61e003c16c929145486bb7a2efec263e5bd701b333 +--- PASS: TestPurgeSingleKey (0.13s) === RUN TestWitness -time="2024-01-06T11:06:16Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" -time="2024-01-06T11:06:16Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" -time="2024-01-06T11:06:16Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" -time="2024-01-06T11:06:16Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" -time="2024-01-06T11:06:16Z" level=warning msg="role targets/delegation has fewer keys than its threshold of 1; it will not be usable until keys are added to it" -time="2024-01-06T11:06:16Z" level=warning msg="role targets/delegation has fewer keys than its threshold of 1; it will not be usable until keys are added to it" -time="2024-01-06T11:06:16Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" ---- PASS: TestWitness (0.46s) +time="2025-02-07T17:33:22Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" +time="2025-02-07T17:33:22Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" +time="2025-02-07T17:33:22Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" +time="2025-02-07T17:33:22Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" +time="2025-02-07T17:33: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="2025-02-07T17:33: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="2025-02-07T17:33:22Z" level=warning msg="Error getting targets/delegation: valid signatures did not meet threshold for targets/delegation" +--- PASS: TestWitness (0.40s) === RUN TestClientTUFInitWithAutoPublish -time="2024-01-06T11:06:16Z" 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]:35040->[::1]:53: read: connection refused" +time="2025-02-07T17:33:22Z" 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]:40076->[::1]:53: read: connection refused" --- PASS: TestClientTUFInitWithAutoPublish (0.11s) === RUN TestClientTUFAddWithAutoPublish -time="2024-01-06T11:06:16Z" 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]:41794->[::1]:53: read: connection refused" -time="2024-01-06T11:06:16Z" level=error msg="Could not publish Repository since we could not update: client is offline" -time="2024-01-06T11:06:16Z" 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]:50367->[::1]:53: read: connection refused" -time="2024-01-06T11:06:16Z" level=error msg="Could not publish Repository since we could not update: client is offline" ---- PASS: TestClientTUFAddWithAutoPublish (0.12s) +time="2025-02-07T17:33:22Z" 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]:44309->[::1]:53: read: connection refused" +time="2025-02-07T17:33:22Z" level=error msg="Could not publish Repository since we could not update: client is offline" +time="2025-02-07T17:33:22Z" 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]:34205->[::1]:53: read: connection refused" +time="2025-02-07T17:33:22Z" level=error msg="Could not publish Repository since we could not update: client is offline" +--- PASS: TestClientTUFAddWithAutoPublish (0.11s) === RUN TestClientTUFRemoveWithAutoPublish ---- PASS: TestClientTUFRemoveWithAutoPublish (0.23s) +--- PASS: TestClientTUFRemoveWithAutoPublish (0.22s) === RUN TestClientDelegationAddWithAutoPublish ---- PASS: TestClientDelegationAddWithAutoPublish (0.11s) +--- PASS: TestClientDelegationAddWithAutoPublish (0.10s) === RUN TestClientDelegationRemoveWithAutoPublish -time="2024-01-06T11:06:17Z" 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-06T11:06:17Z" 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.23s) +time="2025-02-07T17:33:23Z" 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-07T17:33:23Z" 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.18s) === RUN TestClientTUFAddByHashWithAutoPublish ---- PASS: TestClientTUFAddByHashWithAutoPublish (0.10s) +--- PASS: TestClientTUFAddByHashWithAutoPublish (0.09s) === RUN TestClientKeyImport -time="2024-01-06T11:06:17Z" 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-06T11:06:17Z" 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.05s) +time="2025-02-07T17:33:23Z" 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-07T17:33:23Z" 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.04s) === RUN TestAddDelImportKeyPublishFlow -time="2024-01-06T11:06:17Z" 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.27s) +time="2025-02-07T17:33:23Z" 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.20s) === RUN TestExportImportFlow --- PASS: TestExportImportFlow (0.07s) === RUN TestDelegationKeyImportExport ---- PASS: TestDelegationKeyImportExport (0.01s) +--- PASS: TestDelegationKeyImportExport (0.00s) === RUN TestImportKeysNoYubikey --- PASS: TestImportKeysNoYubikey (0.01s) === RUN TestExportImportKeysNoYubikey @@ -2439,24 +2475,24 @@ === RUN TestRemoveOneKeyAbort --- PASS: TestRemoveOneKeyAbort (0.01s) === RUN TestRemoveOneKeyConfirm ---- PASS: TestRemoveOneKeyConfirm (0.01s) +--- PASS: TestRemoveOneKeyConfirm (0.00s) === RUN TestRemoveMultikeysInvalidInput --- PASS: TestRemoveMultikeysInvalidInput (0.01s) === RUN TestRemoveMultikeysAbortChoice --- PASS: TestRemoveMultikeysAbortChoice (0.01s) === RUN TestRemoveMultikeysRemoveOnlyChosenKey ---- PASS: TestRemoveMultikeysRemoveOnlyChosenKey (0.01s) +--- PASS: TestRemoveMultikeysRemoveOnlyChosenKey (0.00s) === RUN TestRotateKeyInvalidRoles -time="2024-01-06T11:06:17Z" 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]:47725->[::1]:53: read: connection refused" -time="2024-01-06T11:06:17Z" 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]:47359->[::1]:53: read: connection refused" -time="2024-01-06T11:06:17Z" 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]:54187->[::1]:53: read: connection refused" -time="2024-01-06T11:06:17Z" 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]:52748->[::1]:53: read: connection refused" ---- PASS: TestRotateKeyInvalidRoles (0.00s) +time="2025-02-07T17:33:23Z" 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]:57397->[::1]:53: read: connection refused" +time="2025-02-07T17:33:23Z" 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]:58854->[::1]:53: read: connection refused" +time="2025-02-07T17:33:23Z" 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]:49347->[::1]:53: read: connection refused" +time="2025-02-07T17:33:23Z" 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]:58938->[::1]:53: read: connection refused" +--- PASS: TestRotateKeyInvalidRoles (0.01s) === RUN TestRotateKeyTargetCannotBeServerManaged -time="2024-01-06T11:06:17Z" 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]:58843->[::1]:53: read: connection refused" +time="2025-02-07T17:33:23Z" 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]:53592->[::1]:53: read: connection refused" --- PASS: TestRotateKeyTargetCannotBeServerManaged (0.00s) === RUN TestRotateKeyTimestampCannotBeLocallyManaged -time="2024-01-06T11:06:17Z" 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]:56966->[::1]:53: read: connection refused" +time="2025-02-07T17:33:23Z" 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]:51312->[::1]:53: read: connection refused" --- PASS: TestRotateKeyTimestampCannotBeLocallyManaged (0.00s) === RUN TestRotateKeyNoGUN Usage: @@ -2464,13 +2500,13 @@ === RUN TestRotateKeyRemoteServerManagesKey Successfully rotated snapshot key for repository docker.com/notary Successfully rotated timestamp key for repository docker.com/notary ---- PASS: TestRotateKeyRemoteServerManagesKey (0.12s) +--- PASS: TestRotateKeyRemoteServerManagesKey (0.10s) === RUN TestRotateKeyBothKeys Successfully rotated targets key for repository docker.com/notary Successfully rotated snapshot key for repository docker.com/notary ---- PASS: TestRotateKeyBothKeys (0.10s) +--- PASS: TestRotateKeyBothKeys (0.08s) === RUN TestRotateKeyRootIsInteractive ---- PASS: TestRotateKeyRootIsInteractive (0.03s) +--- PASS: TestRotateKeyRootIsInteractive (0.01s) === RUN TestChangeKeyPassphraseInvalidID --- PASS: TestChangeKeyPassphraseInvalidID (0.00s) === RUN TestChangeKeyPassphraseInvalidNumArgs @@ -2489,7 +2525,7 @@ === RUN TestImportKeysNonexistentFile --- PASS: TestImportKeysNonexistentFile (0.00s) === RUN TestKeyGeneration -time="2024-01-06T11:06:17Z" 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" +time="2025-02-07T17:33:23Z" level=warning msg="failed to import key () to store: Cannot have canonical role key without a gun, don't know what gun it belongs to" --- PASS: TestKeyGeneration (0.01s) === RUN TestNotaryConfigFileDefault --- PASS: TestNotaryConfigFileDefault (0.00s) @@ -2500,19 +2536,19 @@ === RUN TestRemoteServerCommandLineFlagOverridesConfig --- PASS: TestRemoteServerCommandLineFlagOverridesConfig (0.00s) === RUN TestInvalidAddHashCommands ---- PASS: TestInvalidAddHashCommands (0.01s) +--- PASS: TestInvalidAddHashCommands (0.00s) === RUN TestConfigParsingErrorsPropagatedByCommands ---- PASS: TestConfigParsingErrorsPropagatedByCommands (0.00s) +--- PASS: TestConfigParsingErrorsPropagatedByCommands (0.01s) === RUN TestInsufficientArgumentsReturnsErrorAndPrintsUsage --- PASS: TestInsufficientArgumentsReturnsErrorAndPrintsUsage (0.02s) === RUN TestBareCommandPrintsUsageAndNoError --- PASS: TestBareCommandPrintsUsageAndNoError (0.01s) === RUN TestConfigFileTLSCannotBeRelativeToCWD ---- PASS: TestConfigFileTLSCannotBeRelativeToCWD (0.01s) +--- PASS: TestConfigFileTLSCannotBeRelativeToCWD (0.00s) === RUN TestConfigFileTLSCanBeRelativeToConfigOrAbsolute ---- PASS: TestConfigFileTLSCanBeRelativeToConfigOrAbsolute (0.07s) +--- PASS: TestConfigFileTLSCanBeRelativeToConfigOrAbsolute (0.05s) === RUN TestConfigFileOverridenByCmdLineFlags ---- PASS: TestConfigFileOverridenByCmdLineFlags (0.07s) +--- PASS: TestConfigFileOverridenByCmdLineFlags (0.05s) === RUN TestConfigFileTrustPinning --- PASS: TestConfigFileTrustPinning (0.00s) === RUN TestPassphraseRetrieverCaching @@ -2526,7 +2562,7 @@ === RUN TestPrettyPrintZeroKeys --- PASS: TestPrettyPrintZeroKeys (0.00s) === RUN TestPrettyPrintRootAndSigningKeys ---- PASS: TestPrettyPrintRootAndSigningKeys (0.02s) +--- PASS: TestPrettyPrintRootAndSigningKeys (0.01s) === RUN TestPrettyPrintZeroTargets --- PASS: TestPrettyPrintZeroTargets (0.00s) === RUN TestPrettyPrintSortedTargets @@ -2538,10 +2574,10 @@ === RUN TestImportRootCert --- PASS: TestImportRootCert (0.00s) === RUN TestTokenAuth -time="2024-01-06T11:06:18Z" 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-07T17:33:23Z" 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-06T11:06:18Z" 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-07T17:33:23Z" 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) @@ -2552,18 +2588,18 @@ === RUN TestAdminTokenAuth401Status --- PASS: TestAdminTokenAuth401Status (0.00s) === RUN TestTokenAuthNon200Non401Status -time="2024-01-06T11:06:18Z" level=error msg="could not reach http://127.0.0.1:37191: 404" +time="2025-02-07T17:33:23Z" level=error msg="could not reach http://127.0.0.1:33217: 404" --- PASS: TestTokenAuthNon200Non401Status (0.00s) === RUN TestAdminTokenAuthNon200Non401Status -time="2024-01-06T11:06:18Z" level=error msg="could not reach http://127.0.0.1:46527: 404" +time="2025-02-07T17:33:23Z" level=error msg="could not reach http://127.0.0.1:41917: 404" --- PASS: TestAdminTokenAuthNon200Non401Status (0.00s) === RUN TestConfigureRepo ---- PASS: TestConfigureRepo (0.00s) +--- PASS: TestConfigureRepo (0.01s) === RUN TestConfigureRepoRW -Enter username: time="2024-01-06T11:06:18Z" level=error msg="error processing username input: EOF" +Enter username: time="2025-02-07T17:33:23Z" level=error msg="error processing username input: EOF" --- PASS: TestConfigureRepoRW (0.00s) === RUN TestConfigureRepoAdmin -Enter username: time="2024-01-06T11:06:18Z" level=error msg="error processing username input: EOF" +Enter username: time="2025-02-07T17:33:23Z" level=error msg="error processing username input: EOF" --- PASS: TestConfigureRepoAdmin (0.00s) === RUN TestStatusUnstageAndReset Successfully reset specified changes for repository gun @@ -2571,16 +2607,16 @@ Addition of target "test2" by sha256 hash to repository "gun" staged for next publish. Addition of target "test3" by sha256 hash to repository "gun" staged for next publish. Addition of target "test4" by sha256 hash to repository "gun" staged for next publish. ---- PASS: TestStatusUnstageAndReset (0.00s) +--- PASS: TestStatusUnstageAndReset (0.01s) === RUN TestGetTrustPinningErrors Pushing changes to gun --- PASS: TestGetTrustPinningErrors (0.00s) === RUN TestPasswordStore -Enter username: time="2024-01-06T11:06:18Z" level=error msg="error processing username input: EOF" +Enter username: time="2025-02-07T17:33:23Z" level=error msg="error processing username input: EOF" --- PASS: TestPasswordStore (0.00s) === RUN TestPasswordStoreWithEnvvar -time="2024-01-06T11:06:18Z" level=error msg="Authentication string with zero-length username" -time="2024-01-06T11:06:18Z" level=error msg="Could not base64-decode authentication string" +time="2025-02-07T17:33:23Z" level=error msg="Authentication string with zero-length username" +time="2025-02-07T17:33:23Z" level=error msg="Could not base64-decode authentication string" --- PASS: TestPasswordStoreWithEnvvar (0.00s) === RUN TestGetPayload --- PASS: TestGetPayload (0.00s) @@ -2589,11 +2625,11 @@ === RUN TestHomeExpand --- PASS: TestHomeExpand (0.00s) PASS -ok github.com/theupdateframework/notary/cmd/notary 6.787s +ok github.com/theupdateframework/notary/cmd/notary 6.595s === RUN TestBootstrap --- PASS: TestBootstrap (0.00s) === RUN TestGetAddrAndTLSConfigInvalidTLS ---- PASS: TestGetAddrAndTLSConfigInvalidTLS (0.00s) +--- PASS: TestGetAddrAndTLSConfigInvalidTLS (0.02s) === RUN TestGetAddrAndTLSConfigNoHTTPAddr --- PASS: TestGetAddrAndTLSConfigNoHTTPAddr (0.00s) === RUN TestGetAddrAndTLSConfigSuccessWithTLS @@ -2605,42 +2641,42 @@ === RUN TestGetInvalidTrustService --- PASS: TestGetInvalidTrustService (0.00s) === RUN TestGetLocalTrustService -time="2024-01-06T11:06:11Z" level=info msg="Using local signing service, which requires ED25519. Ignoring all other trust_service parameters, including keyAlgorithm" +time="2025-02-07T17:33:17Z" 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-06T11:06:11Z" level=info msg="Using remote signing service" +time="2025-02-07T17:33:17Z" level=info msg="Using remote signing service" --- PASS: TestGetTrustServiceNoTLSConfig (0.00s) === RUN TestGetTrustServiceTLSSuccess -time="2024-01-06T11:06:11Z" level=info msg="Using remote signing service" +time="2025-02-07T17:33:17Z" level=info msg="Using remote signing service" --- PASS: TestGetTrustServiceTLSSuccess (0.00s) === RUN TestGetTrustServiceTLSFailure --- PASS: TestGetTrustServiceTLSFailure (0.00s) === RUN TestGetStoreInvalid -time="2024-01-06T11:06:11Z" level=info msg="Using asdf backend" +time="2025-02-07T17:33:17Z" level=info msg="Using asdf backend" --- PASS: TestGetStoreInvalid (0.00s) === RUN TestGetStoreDBStore -time="2024-01-06T11:06:11Z" level=info msg="Using sqlite3 backend" +time="2025-02-07T17:33:17Z" level=info msg="Using sqlite3 backend" --- PASS: TestGetStoreDBStore (0.00s) === RUN TestGetStoreRethinkDBStoreConnectionFails -time="2024-01-06T11:06:11Z" level=info msg="Using rethinkdb backend" +time="2025-02-07T17:33:17Z" level=info msg="Using rethinkdb backend" --- PASS: TestGetStoreRethinkDBStoreConnectionFails (0.00s) === RUN TestGetMemoryStore -time="2024-01-06T11:06:11Z" level=info msg="Using memory backend" +time="2025-02-07T17:33:17Z" 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-06T11:06:11Z" level=info msg="Using remote signing service" -time="2024-01-06T11:06:11Z" level=info msg="Using sqlite3 backend" ---- PASS: TestSampleConfig (0.00s) +time="2025-02-07T17:33:17Z" level=info msg="Using remote signing service" +time="2025-02-07T17:33:17Z" level=info msg="Using sqlite3 backend" +--- PASS: TestSampleConfig (0.01s) PASS -ok github.com/theupdateframework/notary/cmd/notary-server 0.033s +ok github.com/theupdateframework/notary/cmd/notary-server 0.114s === RUN TestGetAddrAndTLSConfigInvalidTLS --- PASS: TestGetAddrAndTLSConfigInvalidTLS (0.00s) === RUN TestGetAddrAndTLSConfigNoGRPCAddr @@ -2655,7 +2691,7 @@ main_test.go:121: DM - skipping malfunctioning test, fails on sbuild --- SKIP: TestSetupCryptoServicesRethinkDBStoreConnectionFails (0.00s) === RUN TestSetupCryptoServicesDBStoreSuccess ---- PASS: TestSetupCryptoServicesDBStoreSuccess (0.01s) +--- PASS: TestSetupCryptoServicesDBStoreSuccess (0.03s) === RUN TestSetupCryptoServicesMemoryStore --- PASS: TestSetupCryptoServicesMemoryStore (0.00s) === RUN TestSetupCryptoServicesInvalidStore @@ -2673,17 +2709,17 @@ === RUN TestSampleConfig --- PASS: TestSampleConfig (0.00s) PASS -ok github.com/theupdateframework/notary/cmd/notary-signer 0.042s +ok github.com/theupdateframework/notary/cmd/notary-signer 0.148s === RUN TestGenerateCertificate --- PASS: TestGenerateCertificate (0.00s) === RUN TestCryptoServiceWithNonEmptyGUN ---- PASS: TestCryptoServiceWithNonEmptyGUN (0.24s) +--- PASS: TestCryptoServiceWithNonEmptyGUN (0.79s) === RUN TestCryptoServiceWithEmptyGUN ---- PASS: TestCryptoServiceWithEmptyGUN (0.30s) +--- PASS: TestCryptoServiceWithEmptyGUN (0.90s) === RUN TestCryptoSignerInterfaceBehavior --- PASS: TestCryptoSignerInterfaceBehavior (0.00s) PASS -ok github.com/theupdateframework/notary/cryptoservice 0.563s +ok github.com/theupdateframework/notary/cryptoservice 1.758s === RUN TestGetPassphraseForUsingDelegationKey --- PASS: TestGetPassphraseForUsingDelegationKey (0.00s) === RUN TestGetPassphraseLimitsShortPassphrases @@ -2699,144 +2735,144 @@ === RUN TestGetPassphrase --- PASS: TestGetPassphrase (0.00s) PASS -ok github.com/theupdateframework/notary/passphrase 0.035s +ok github.com/theupdateframework/notary/passphrase 0.049s ? github.com/theupdateframework/notary/proto [no test files] === RUN TestValidationErrorFormat -time="2024-01-06T11:06:10Z" 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=78ae4174c52315c83b230aec29ec97bd068621621d29aeb38d4c198a8192" http.request.host="127.0.0.1:43853" http.request.id=c9270630-9951-4946-8ca3-5d0512983fa2 http.request.method=POST http.request.remoteaddr="127.0.0.1:35698" http.request.uri=/v2/docker.com/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 -time="2024-01-06T11:06:10Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype="multipart/form-data; boundary=78ae4174c52315c83b230aec29ec97bd068621621d29aeb38d4c198a8192" http.request.host="127.0.0.1:43853" http.request.id=c9270630-9951-4946-8ca3-5d0512983fa2 http.request.method=POST http.request.remoteaddr="127.0.0.1:35698" http.request.uri=/v2/docker.com/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 http.response.contenttype="application/json; charset=utf-8" http.response.duration=1.614768ms http.response.status=400 http.response.written=260 ---- PASS: TestValidationErrorFormat (0.01s) +time="2025-02-07T17:33:14Z" 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=b2e2358d3f9c98c366ebf25cda1a05f9d77adf579041b76fa5352bf2528e" http.request.host="127.0.0.1:36521" http.request.id=230697b8-3bda-433a-983b-4fbbe3e265be http.request.method=POST http.request.remoteaddr="127.0.0.1:49228" http.request.uri=/v2/docker.com/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 +time="2025-02-07T17:33:14Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype="multipart/form-data; boundary=b2e2358d3f9c98c366ebf25cda1a05f9d77adf579041b76fa5352bf2528e" http.request.host="127.0.0.1:36521" http.request.id=230697b8-3bda-433a-983b-4fbbe3e265be http.request.method=POST http.request.remoteaddr="127.0.0.1:49228" http.request.uri=/v2/docker.com/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 http.response.contenttype="application/json; charset=utf-8" http.response.duration=1.68096ms http.response.status=400 http.response.written=260 +--- PASS: TestValidationErrorFormat (0.06s) === RUN TestRunBadAddr --- PASS: TestRunBadAddr (0.00s) === RUN TestRunReservedPort --- PASS: TestRunReservedPort (0.00s) === RUN TestRepoPrefixMatches -time="2024-01-06T11:06:10Z" level=info msg="updated docker.io/notary to timestamp version 1, checksum 1166a2a5f26e827b91ef1e5da57f73cfcdfcfdde60a2cc528bfe01f1a63b9c07" docker.io/notary=gun go.version=go1.19.8 http.request.contenttype="multipart/form-data; boundary=da3f4c60d4b6cdc687310d8e2b00b4fec2ad4c954f0da79489fcb595d5db" http.request.host="127.0.0.1:35301" http.request.id=499d3f9f-c5d3-4207-aa66-b4b5a6425f2a http.request.method=POST http.request.remoteaddr="127.0.0.1:44910" http.request.uri=/v2/docker.io/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 -time="2024-01-06T11:06:10Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype="multipart/form-data; boundary=da3f4c60d4b6cdc687310d8e2b00b4fec2ad4c954f0da79489fcb595d5db" http.request.host="127.0.0.1:35301" http.request.id=499d3f9f-c5d3-4207-aa66-b4b5a6425f2a http.request.method=POST http.request.remoteaddr="127.0.0.1:44910" http.request.uri=/v2/docker.io/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 http.response.duration=3.530898ms http.response.status=0 http.response.written=0 -time="2024-01-06T11:06:10Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:35301" http.request.id=f64306e9-7d90-4a42-aff6-410a56bced96 http.request.method=GET http.request.remoteaddr="127.0.0.1:44910" http.request.uri=/v2/docker.io/notary/_trust/tuf/snapshot.json http.request.useragent=Go-http-client/1.1 http.response.duration="462.202µs" http.response.status=200 http.response.written=683 -time="2024-01-06T11:06:10Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:35301" http.request.id=48cfdfdf-1d10-4beb-a4aa-5972fe5df783 http.request.method=GET http.request.remoteaddr="127.0.0.1:44910" http.request.uri=/v2/docker.io/notary/_trust/tuf/snapshot.89a06bf533a8d5f7f1ee99995055f33f0e317523ec61bfc63d0c6574a0b34a78.json http.request.useragent=Go-http-client/1.1 http.response.duration="38.04µs" http.response.status=200 http.response.written=683 -time="2024-01-06T11:06:10Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:35301" http.request.id=6b3a52e2-1d27-4060-9a53-6e77d0af6dd5 http.request.method=GET http.request.remoteaddr="127.0.0.1:44910" http.request.uri=/v2/docker.io/notary/_trust/tuf/timestamp.key http.request.useragent=Go-http-client/1.1 http.response.duration="287.962µs" http.response.status=200 http.response.written=181 -time="2024-01-06T11:06:10Z" 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:35301" http.request.id=928d9034-e82a-4917-8f15-b76e183b3b6e http.request.method=DELETE http.request.remoteaddr="127.0.0.1:44910" http.request.uri=/v2/docker.io/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 -time="2024-01-06T11:06:10Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:35301" http.request.id=928d9034-e82a-4917-8f15-b76e183b3b6e http.request.method=DELETE http.request.remoteaddr="127.0.0.1:44910" http.request.uri=/v2/docker.io/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 http.response.duration="42.96µs" http.response.status=0 http.response.written=0 ---- PASS: TestRepoPrefixMatches (0.02s) +time="2025-02-07T17:33:14Z" level=info msg="updated docker.io/notary to timestamp version 1, checksum 27818029e69a978b3ee4a95bb887e10c12613d5951707b85c669ca6e1aa97a59" docker.io/notary=gun go.version=go1.19.8 http.request.contenttype="multipart/form-data; boundary=4fa3a7862bd1d1d1e0fe729187ec20c0a7a3bb1807f89b051ba86b8482fa" http.request.host="127.0.0.1:36311" http.request.id=a84a8112-8030-44d8-a31e-b557261f60bc http.request.method=POST http.request.remoteaddr="127.0.0.1:60694" http.request.uri=/v2/docker.io/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 +time="2025-02-07T17:33:14Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype="multipart/form-data; boundary=4fa3a7862bd1d1d1e0fe729187ec20c0a7a3bb1807f89b051ba86b8482fa" http.request.host="127.0.0.1:36311" http.request.id=a84a8112-8030-44d8-a31e-b557261f60bc http.request.method=POST http.request.remoteaddr="127.0.0.1:60694" http.request.uri=/v2/docker.io/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 http.response.duration=2.03644ms http.response.status=0 http.response.written=0 +time="2025-02-07T17:33:14Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:36311" http.request.id=875ec981-6514-4e7e-a9fe-abfe11a8b7b1 http.request.method=GET http.request.remoteaddr="127.0.0.1:60694" http.request.uri=/v2/docker.io/notary/_trust/tuf/snapshot.json http.request.useragent=Go-http-client/1.1 http.response.duration="328.48µs" http.response.status=200 http.response.written=683 +time="2025-02-07T17:33:14Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:36311" http.request.id=71fb8ade-e586-4bf8-a8b3-90a164794b30 http.request.method=GET http.request.remoteaddr="127.0.0.1:60694" http.request.uri=/v2/docker.io/notary/_trust/tuf/snapshot.b001f70a81a91d61cc7cf027e3802544b016b13ebbbea38eabedb349c74d4771.json http.request.useragent=Go-http-client/1.1 http.response.duration="20.84µs" http.response.status=200 http.response.written=683 +time="2025-02-07T17:33:14Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:36311" http.request.id=c0b87865-9999-404d-b899-06d8e227dea7 http.request.method=GET http.request.remoteaddr="127.0.0.1:60694" http.request.uri=/v2/docker.io/notary/_trust/tuf/timestamp.key http.request.useragent=Go-http-client/1.1 http.response.duration="227.6µs" http.response.status=200 http.response.written=181 +time="2025-02-07T17:33:14Z" 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:36311" http.request.id=bd4c3955-1044-45ef-81ce-b6747e20221b http.request.method=DELETE http.request.remoteaddr="127.0.0.1:60694" http.request.uri=/v2/docker.io/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 +time="2025-02-07T17:33:14Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:36311" http.request.id=bd4c3955-1044-45ef-81ce-b6747e20221b http.request.method=DELETE http.request.remoteaddr="127.0.0.1:60694" http.request.uri=/v2/docker.io/notary/_trust/tuf/ http.request.useragent=Go-http-client/1.1 http.response.duration="28.52µs" http.response.status=0 http.response.written=0 +--- PASS: TestRepoPrefixMatches (0.03s) === RUN TestRepoPrefixDoesNotMatch ---- PASS: TestRepoPrefixDoesNotMatch (0.01s) +--- PASS: TestRepoPrefixDoesNotMatch (0.04s) === RUN TestMetricsEndpoint ---- PASS: TestMetricsEndpoint (0.02s) +--- PASS: TestMetricsEndpoint (0.05s) === RUN TestGetKeysEndpoint -time="2024-01-06T11:06:10Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:46035" http.request.id=a92f02ae-6da7-44a2-abbf-0b291bea467a http.request.method=GET http.request.remoteaddr="127.0.0.1:49364" http.request.uri=/v2/gun/_trust/tuf/snapshot.key http.request.useragent=Go-http-client/1.1 http.response.duration=4.0417ms http.response.status=200 http.response.written=103 -time="2024-01-06T11:06:10Z" 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:46035" http.request.id=3874ff57-d416-46af-ad17-4c8e305b3711 http.request.method=GET http.request.remoteaddr="127.0.0.1:49378" http.request.uri=/v2/gun/_trust/tuf/targets.key http.request.useragent=Go-http-client/1.1 -time="2024-01-06T11:06:10Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:46035" http.request.id=3874ff57-d416-46af-ad17-4c8e305b3711 http.request.method=GET http.request.remoteaddr="127.0.0.1:49378" 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="69.761µs" http.response.status=404 http.response.written=104 -time="2024-01-06T11:06:10Z" 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:46035" http.request.id=271c58f2-8f56-4c51-b1c5-7c6acf107760 http.request.method=GET http.request.remoteaddr="127.0.0.1:49380" http.request.uri=/v2/gun/_trust/tuf/root.key http.request.useragent=Go-http-client/1.1 -time="2024-01-06T11:06:10Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:46035" http.request.id=271c58f2-8f56-4c51-b1c5-7c6acf107760 http.request.method=GET http.request.remoteaddr="127.0.0.1:49380" 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="47.44µs" http.response.status=404 http.response.written=104 -time="2024-01-06T11:06:10Z" 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:46035" http.request.id=9f1b6776-174e-4a7b-86ec-6d60f43afa25 http.request.method=GET http.request.remoteaddr="127.0.0.1:49384" http.request.uri=/v2/gun/_trust/tuf/somerandomrole.key http.request.useragent=Go-http-client/1.1 -time="2024-01-06T11:06:10Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:46035" http.request.id=9f1b6776-174e-4a7b-86ec-6d60f43afa25 http.request.method=GET http.request.remoteaddr="127.0.0.1:49384" 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="50.76µs" http.response.status=404 http.response.written=104 -time="2024-01-06T11:06:10Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:46035" http.request.id=7e950465-4941-4643-960d-46ba4a0dd82a http.request.method=GET http.request.remoteaddr="127.0.0.1:49400" http.request.uri=/v2/gun/_trust/tuf/timestamp.key http.request.useragent=Go-http-client/1.1 http.response.duration="143.681µs" http.response.status=200 http.response.written=103 ---- PASS: TestGetKeysEndpoint (0.02s) +time="2025-02-07T17:33:14Z" 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:41997" http.request.id=3b5e1740-2ba7-41fa-a762-b15bc46be9b2 http.request.method=GET http.request.remoteaddr="127.0.0.1:60374" http.request.uri=/v2/gun/_trust/tuf/root.key http.request.useragent=Go-http-client/1.1 +time="2025-02-07T17:33:14Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:41997" http.request.id=3b5e1740-2ba7-41fa-a762-b15bc46be9b2 http.request.method=GET http.request.remoteaddr="127.0.0.1:60374" 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="138.76µs" http.response.status=404 http.response.written=104 +time="2025-02-07T17:33:14Z" 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:41997" http.request.id=a738bf50-badc-461d-bedb-4a8df07118f7 http.request.method=GET http.request.remoteaddr="127.0.0.1:60390" http.request.uri=/v2/gun/_trust/tuf/somerandomrole.key http.request.useragent=Go-http-client/1.1 +time="2025-02-07T17:33:14Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:41997" http.request.id=a738bf50-badc-461d-bedb-4a8df07118f7 http.request.method=GET http.request.remoteaddr="127.0.0.1:60390" 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="94.8µs" http.response.status=404 http.response.written=104 +time="2025-02-07T17:33:14Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:41997" http.request.id=1e714516-a9e7-4784-aeff-7e27e4e70f8d http.request.method=GET http.request.remoteaddr="127.0.0.1:60396" http.request.uri=/v2/gun/_trust/tuf/timestamp.key http.request.useragent=Go-http-client/1.1 http.response.duration=20.47052ms http.response.status=200 http.response.written=103 +time="2025-02-07T17:33:14Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:41997" http.request.id=5e868212-7ec2-4570-af4c-addfd0a4fac7 http.request.method=GET http.request.remoteaddr="127.0.0.1:60400" http.request.uri=/v2/gun/_trust/tuf/snapshot.key http.request.useragent=Go-http-client/1.1 http.response.duration="152.76µs" http.response.status=200 http.response.written=103 +time="2025-02-07T17:33:14Z" 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:41997" http.request.id=4d10e66f-bb69-43e0-adde-2c1a7046b825 http.request.method=GET http.request.remoteaddr="127.0.0.1:60404" http.request.uri=/v2/gun/_trust/tuf/targets.key http.request.useragent=Go-http-client/1.1 +time="2025-02-07T17:33:14Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:41997" http.request.id=4d10e66f-bb69-43e0-adde-2c1a7046b825 http.request.method=GET http.request.remoteaddr="127.0.0.1:60404" 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="99.04µs" http.response.status=404 http.response.written=104 +--- PASS: TestGetKeysEndpoint (0.05s) === RUN TestGetRoleByHash -time="2024-01-06T11:06:10Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:40201" http.request.id=15eeb94f-57cf-414d-827b-337424c67d1d http.request.method=GET http.request.remoteaddr="127.0.0.1:60992" http.request.uri=/v2/gun/_trust/tuf/timestamp.c540d1a387a257318622c687fb2fd07d966d28a6b273cd56d43d385657c4c7c9.json http.request.useragent=Go-http-client/1.1 http.response.duration="62µs" http.response.status=200 http.response.written=115 +time="2025-02-07T17:33:14Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:34815" http.request.id=c71dc8a5-4592-4cd7-b271-4cbce2c52e5e http.request.method=GET http.request.remoteaddr="127.0.0.1:47476" http.request.uri=/v2/gun/_trust/tuf/timestamp.96178bcd10d77ae2b48556d2b0e3afe27e0442a93c92f847a4a8d1972e0a8dc9.json http.request.useragent=Go-http-client/1.1 http.response.duration="56.32µs" http.response.status=200 http.response.written=115 --- PASS: TestGetRoleByHash (0.00s) === RUN TestGetRoleByVersion -time="2024-01-06T11:06:10Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:39463" http.request.id=5e5ac439-b5c2-4b8d-9c5d-9f048a65529e http.request.method=GET http.request.remoteaddr="127.0.0.1:60382" http.request.uri=/v2/gun/_trust/tuf/1.timestamp.json http.request.useragent=Go-http-client/1.1 http.response.duration="60.76µs" http.response.status=200 http.response.written=115 ---- PASS: TestGetRoleByVersion (0.00s) +time="2025-02-07T17:33:14Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:34661" http.request.id=e9cafe7e-3a09-4fd7-98c8-95b44ce94bc6 http.request.method=GET http.request.remoteaddr="127.0.0.1:33262" http.request.uri=/v2/gun/_trust/tuf/1.timestamp.json http.request.useragent=Go-http-client/1.1 http.response.duration="46.08µs" http.response.status=200 http.response.written=115 +--- PASS: TestGetRoleByVersion (0.04s) === RUN TestGetCurrentRole -time="2024-01-06T11:06:10Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:45883" http.request.id=40b88911-59b2-4f0a-ba97-abd848b4d7af http.request.method=GET http.request.remoteaddr="127.0.0.1:50566" http.request.uri=/v2/gun/_trust/tuf/timestamp.json http.request.useragent=Go-http-client/1.1 http.response.duration="314.081µs" http.response.status=200 http.response.written=495 +time="2025-02-07T17:33:14Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:42327" http.request.id=6b49b42e-c193-4ced-8261-159caba22f8f http.request.method=GET http.request.remoteaddr="127.0.0.1:33322" http.request.uri=/v2/gun/_trust/tuf/timestamp.json http.request.useragent=Go-http-client/1.1 http.response.duration="345.32µs" http.response.status=200 http.response.written=495 --- PASS: TestGetCurrentRole (0.02s) === RUN TestRotateKeyEndpoint -time="2024-01-06T11:06:10Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:36751" http.request.id=3bcd269e-8d0d-4f14-a45b-1644c3a67692 http.request.method=POST http.request.remoteaddr="127.0.0.1:32940" http.request.uri=/v2/gun/_trust/tuf/timestamp.key http.request.useragent=Go-http-client/1.1 http.response.duration="164.561µs" http.response.status=200 http.response.written=103 -time="2024-01-06T11:06:10Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:36751" http.request.id=96a836c6-73fd-4aad-bece-3166462865ad http.request.method=POST http.request.remoteaddr="127.0.0.1:32944" http.request.uri=/v2/gun/_trust/tuf/snapshot.key http.request.useragent=Go-http-client/1.1 http.response.duration="124.441µs" http.response.status=200 http.response.written=103 -time="2024-01-06T11:06:10Z" 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:36751" http.request.id=b32ef75d-0a4f-45a3-9c38-2184e51bc5ef http.request.method=POST http.request.remoteaddr="127.0.0.1:32956" http.request.uri=/v2/gun/_trust/tuf/targets.key http.request.useragent=Go-http-client/1.1 -time="2024-01-06T11:06:10Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:36751" http.request.id=b32ef75d-0a4f-45a3-9c38-2184e51bc5ef http.request.method=POST http.request.remoteaddr="127.0.0.1:32956" 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="97.641µs" http.response.status=404 http.response.written=104 -time="2024-01-06T11:06:10Z" 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:36751" http.request.id=3983a6b8-cee3-40ab-91e1-212e3177c388 http.request.method=POST http.request.remoteaddr="127.0.0.1:32970" http.request.uri=/v2/gun/_trust/tuf/root.key http.request.useragent=Go-http-client/1.1 -time="2024-01-06T11:06:10Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:36751" http.request.id=3983a6b8-cee3-40ab-91e1-212e3177c388 http.request.method=POST http.request.remoteaddr="127.0.0.1:32970" 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="94.881µs" http.response.status=404 http.response.written=104 -time="2024-01-06T11:06:10Z" 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:36751" http.request.id=a158cff7-935a-4df7-b05f-15ad6b7780c9 http.request.method=POST http.request.remoteaddr="127.0.0.1:32984" http.request.uri=/v2/gun/_trust/tuf/targets/delegation.key http.request.useragent=Go-http-client/1.1 -time="2024-01-06T11:06:10Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:36751" http.request.id=a158cff7-935a-4df7-b05f-15ad6b7780c9 http.request.method=POST http.request.remoteaddr="127.0.0.1:32984" 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="65.96µs" http.response.status=404 http.response.written=104 -time="2024-01-06T11:06:10Z" 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:36751" http.request.id=22bb468a-6abc-4269-bfe6-dbff620f0637 http.request.method=POST http.request.remoteaddr="127.0.0.1:32998" http.request.uri=/v2/gun/_trust/tuf/somerandomrole.key http.request.useragent=Go-http-client/1.1 -time="2024-01-06T11:06:10Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:36751" http.request.id=22bb468a-6abc-4269-bfe6-dbff620f0637 http.request.method=POST http.request.remoteaddr="127.0.0.1:32998" 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="49.721µs" http.response.status=404 http.response.written=104 +time="2025-02-07T17:33:14Z" 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:38579" http.request.id=566f1d51-939b-405b-b28c-168ef9e37b23 http.request.method=POST http.request.remoteaddr="127.0.0.1:50972" http.request.uri=/v2/gun/_trust/tuf/targets/delegation.key http.request.useragent=Go-http-client/1.1 +time="2025-02-07T17:33:14Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:38579" http.request.id=566f1d51-939b-405b-b28c-168ef9e37b23 http.request.method=POST http.request.remoteaddr="127.0.0.1:50972" http.request.uri=/v2/gun/_trust/tuf/targets/delegation.key http.request.useragent=Go-http-client/1.1 http.response.contenttype="application/json; charset=utf-8" http.response.duration="90.36µs" http.response.status=404 http.response.written=104 +time="2025-02-07T17:33:14Z" 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:38579" http.request.id=9b3cb4d3-52c3-4922-b89a-9131a3b99039 http.request.method=POST http.request.remoteaddr="127.0.0.1:50976" http.request.uri=/v2/gun/_trust/tuf/somerandomrole.key http.request.useragent=Go-http-client/1.1 +time="2025-02-07T17:33:14Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:38579" http.request.id=9b3cb4d3-52c3-4922-b89a-9131a3b99039 http.request.method=POST http.request.remoteaddr="127.0.0.1:50976" 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="56.64µs" http.response.status=404 http.response.written=104 +time="2025-02-07T17:33:14Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:38579" http.request.id=8d9b4822-0ff4-4c0d-b8f1-88b90cbcefa3 http.request.method=POST http.request.remoteaddr="127.0.0.1:50988" http.request.uri=/v2/gun/_trust/tuf/timestamp.key http.request.useragent=Go-http-client/1.1 http.response.duration="127.72µs" http.response.status=200 http.response.written=103 +time="2025-02-07T17:33:14Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:38579" http.request.id=f3bb241e-c675-49b9-a272-6790e1cf1085 http.request.method=POST http.request.remoteaddr="127.0.0.1:51002" http.request.uri=/v2/gun/_trust/tuf/snapshot.key http.request.useragent=Go-http-client/1.1 http.response.duration="104.92µs" http.response.status=200 http.response.written=103 +time="2025-02-07T17:33:14Z" 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:38579" http.request.id=14698214-14e1-446e-aad6-300f357a7ade http.request.method=POST http.request.remoteaddr="127.0.0.1:51012" http.request.uri=/v2/gun/_trust/tuf/targets.key http.request.useragent=Go-http-client/1.1 +time="2025-02-07T17:33:14Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:38579" http.request.id=14698214-14e1-446e-aad6-300f357a7ade http.request.method=POST http.request.remoteaddr="127.0.0.1:51012" http.request.uri=/v2/gun/_trust/tuf/targets.key http.request.useragent=Go-http-client/1.1 http.response.contenttype="application/json; charset=utf-8" http.response.duration="197.76µs" http.response.status=404 http.response.written=104 +time="2025-02-07T17:33:14Z" 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:38579" http.request.id=b4b8fa84-da8a-4929-86ce-b6629469ebef http.request.method=POST http.request.remoteaddr="127.0.0.1:51024" http.request.uri=/v2/gun/_trust/tuf/root.key http.request.useragent=Go-http-client/1.1 +time="2025-02-07T17:33:14Z" level=info msg="response completed" go.version=go1.19.8 http.request.contenttype=text/plain http.request.host="127.0.0.1:38579" http.request.id=b4b8fa84-da8a-4929-86ce-b6629469ebef http.request.method=POST http.request.remoteaddr="127.0.0.1:51024" 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="116.24µs" http.response.status=404 http.response.written=104 --- PASS: TestRotateKeyEndpoint (0.02s) PASS -ok github.com/theupdateframework/notary/server 0.153s +ok github.com/theupdateframework/notary/server 0.391s ? github.com/theupdateframework/notary/server/errors [no test files] === RUN Test_changefeed --- PASS: Test_changefeed (0.00s) === RUN Test_checkChangefeedInputs -time="2024-01-06T11:06:10Z" level=error msg="500 GET unable to retrieve storage" -time="2024-01-06T11:06:10Z" level=error msg="400 GET invalid pageSize: not_a_number" +time="2025-02-07T17:33:14Z" level=error msg="500 GET unable to retrieve storage" +time="2025-02-07T17:33:14Z" level=error msg="400 GET invalid pageSize: not_a_number" --- PASS: Test_checkChangefeedInputs (0.00s) === RUN TestMainHandlerGet -time="2024-01-06T11:06:10Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:35391" http.request.id=3b98b7f6-27e7-46a0-93df-92db8cd5c66c http.request.method=GET http.request.remoteaddr="127.0.0.1:54540" http.request.uri=/ http.request.useragent=Go-http-client/1.1 http.response.duration="33.16µs" http.response.status=200 http.response.written=2 +time="2025-02-07T17:33:14Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:44001" http.request.id=9b3b6bab-4409-4fc7-90b1-c153e98327ff http.request.method=GET http.request.remoteaddr="127.0.0.1:58336" http.request.uri=/ http.request.useragent=Go-http-client/1.1 http.response.duration="26.52µs" http.response.status=200 http.response.written=2 --- PASS: TestMainHandlerGet (0.00s) === RUN TestMainHandlerNotGet -time="2024-01-06T11:06: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:41169" http.request.id=0a730fd3-f438-4413-b038-33fd2e27e309 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:53588" http.request.uri=/ http.request.useragent=Go-http-client/1.1 -time="2024-01-06T11:06:10Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:41169" http.request.id=0a730fd3-f438-4413-b038-33fd2e27e309 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:53588" http.request.uri=/ http.request.useragent=Go-http-client/1.1 http.response.contenttype="application/json; charset=utf-8" http.response.duration="264.722µs" http.response.status=404 http.response.written=105 +time="2025-02-07T17:33:14Z" 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:34557" http.request.id=8f85f848-39ec-4371-818f-44940c411297 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:42220" http.request.uri=/ http.request.useragent=Go-http-client/1.1 +time="2025-02-07T17:33:14Z" level=info msg="response completed" go.version=go1.19.8 http.request.host="127.0.0.1:34557" http.request.id=8f85f848-39ec-4371-818f-44940c411297 http.request.method=HEAD http.request.remoteaddr="127.0.0.1:42220" http.request.uri=/ http.request.useragent=Go-http-client/1.1 http.response.contenttype="application/json; charset=utf-8" http.response.duration="479.96µs" http.response.status=404 http.response.written=105 --- PASS: TestMainHandlerNotGet (0.00s) === RUN TestKeyHandlersInvalidConfiguration -time="2024-01-06T11:06:10Z" level=error msg="500 GET key algorithm not configured" go.version=go1.19.8 gun=gun -time="2024-01-06T11:06:10Z" level=error msg="500 GET key algorithm not configured" go.version=go1.19.8 gun=gun -time="2024-01-06T11:06:10Z" level=error msg="500 GET storage not configured" go.version=go1.19.8 gun=gun -time="2024-01-06T11:06:10Z" level=error msg="500 GET storage not configured" go.version=go1.19.8 gun=gun -time="2024-01-06T11:06:10Z" level=error msg="500 GET crypto service not configured" go.version=go1.19.8 gun=gun -time="2024-01-06T11:06:10Z" level=error msg="500 GET crypto service not configured" go.version=go1.19.8 gun=gun -time="2024-01-06T11:06:10Z" level=error msg="500 POST storage not configured" go.version=go1.19.8 gun=gun -time="2024-01-06T11:06:10Z" level=error msg="500 POST storage not configured" go.version=go1.19.8 gun=gun -time="2024-01-06T11:06:10Z" level=error msg="500 POST crypto service not configured" go.version=go1.19.8 gun=gun -time="2024-01-06T11:06:10Z" level=error msg="500 POST crypto service not configured" go.version=go1.19.8 gun=gun -time="2024-01-06T11:06:10Z" level=error msg="500 POST key algorithm not configured" go.version=go1.19.8 gun=gun -time="2024-01-06T11:06:10Z" level=error msg="500 POST key algorithm not configured" go.version=go1.19.8 gun=gun +time="2025-02-07T17:33:14Z" level=error msg="500 GET key algorithm not configured" go.version=go1.19.8 gun=gun +time="2025-02-07T17:33:14Z" level=error msg="500 GET key algorithm not configured" go.version=go1.19.8 gun=gun +time="2025-02-07T17:33:14Z" level=error msg="500 GET storage not configured" go.version=go1.19.8 gun=gun +time="2025-02-07T17:33:14Z" level=error msg="500 GET storage not configured" go.version=go1.19.8 gun=gun +time="2025-02-07T17:33:14Z" level=error msg="500 GET crypto service not configured" go.version=go1.19.8 gun=gun +time="2025-02-07T17:33:14Z" level=error msg="500 GET crypto service not configured" go.version=go1.19.8 gun=gun +time="2025-02-07T17:33:14Z" level=error msg="500 POST storage not configured" go.version=go1.19.8 gun=gun +time="2025-02-07T17:33:14Z" level=error msg="500 POST storage not configured" go.version=go1.19.8 gun=gun +time="2025-02-07T17:33:14Z" level=error msg="500 POST crypto service not configured" go.version=go1.19.8 gun=gun +time="2025-02-07T17:33:14Z" level=error msg="500 POST crypto service not configured" go.version=go1.19.8 gun=gun +time="2025-02-07T17:33:14Z" level=error msg="500 POST key algorithm not configured" go.version=go1.19.8 gun=gun +time="2025-02-07T17:33:14Z" 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-06T11:06:10Z" level=info msg="400 GET no gun in request" =gun go.version=go1.19.8 -time="2024-01-06T11:06:10Z" level=info msg="400 GET no gun in request" =gun go.version=go1.19.8 -time="2024-01-06T11:06:10Z" level=info msg="400 GET no role in request" go.version=go1.19.8 gun=gun -time="2024-01-06T11:06:10Z" level=info msg="400 GET no role in request" go.version=go1.19.8 gun=gun -time="2024-01-06T11:06:10Z" level=info msg="400 POST no gun in request" =gun go.version=go1.19.8 -time="2024-01-06T11:06:10Z" level=info msg="400 POST no gun in request" =gun go.version=go1.19.8 -time="2024-01-06T11:06:10Z" level=info msg="400 POST no role in request" go.version=go1.19.8 gun=gun -time="2024-01-06T11:06:10Z" level=info msg="400 POST no role in request" go.version=go1.19.8 gun=gun +time="2025-02-07T17:33:14Z" level=info msg="400 GET no gun in request" =gun go.version=go1.19.8 +time="2025-02-07T17:33:14Z" level=info msg="400 GET no gun in request" =gun go.version=go1.19.8 +time="2025-02-07T17:33:14Z" level=info msg="400 GET no role in request" go.version=go1.19.8 gun=gun +time="2025-02-07T17:33:14Z" level=info msg="400 GET no role in request" go.version=go1.19.8 gun=gun +time="2025-02-07T17:33:14Z" level=info msg="400 POST no gun in request" =gun go.version=go1.19.8 +time="2025-02-07T17:33:14Z" level=info msg="400 POST no gun in request" =gun go.version=go1.19.8 +time="2025-02-07T17:33:14Z" level=info msg="400 POST no role in request" go.version=go1.19.8 gun=gun +time="2025-02-07T17:33:14Z" 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-06T11:06:10Z" level=info msg="400 GET root key: " go.version=go1.19.8 gun=gun -time="2024-01-06T11:06:10Z" level=info msg="400 GET targets key: " go.version=go1.19.8 gun=gun -time="2024-01-06T11:06:10Z" level=info msg="400 GET targets/a key: " go.version=go1.19.8 gun=gun -time="2024-01-06T11:06:10Z" level=info msg="400 GET invalidrole key: " go.version=go1.19.8 gun=gun -time="2024-01-06T11:06:10Z" level=info msg="400 POST root key: " go.version=go1.19.8 gun=gun -time="2024-01-06T11:06:10Z" level=info msg="400 POST targets key: " go.version=go1.19.8 gun=gun -time="2024-01-06T11:06:10Z" level=info msg="400 POST targets/a key: " go.version=go1.19.8 gun=gun -time="2024-01-06T11:06:10Z" level=info msg="400 POST invalidrole key: " go.version=go1.19.8 gun=gun +time="2025-02-07T17:33:14Z" level=info msg="400 GET root key: " go.version=go1.19.8 gun=gun +time="2025-02-07T17:33:14Z" level=info msg="400 GET targets key: " go.version=go1.19.8 gun=gun +time="2025-02-07T17:33:14Z" level=info msg="400 GET targets/a key: " go.version=go1.19.8 gun=gun +time="2025-02-07T17:33:14Z" level=info msg="400 GET invalidrole key: " go.version=go1.19.8 gun=gun +time="2025-02-07T17:33:14Z" level=info msg="400 POST root key: " go.version=go1.19.8 gun=gun +time="2025-02-07T17:33:14Z" level=info msg="400 POST targets key: " go.version=go1.19.8 gun=gun +time="2025-02-07T17:33:14Z" level=info msg="400 POST targets/a key: " go.version=go1.19.8 gun=gun +time="2025-02-07T17:33:14Z" level=info msg="400 POST invalidrole key: " go.version=go1.19.8 gun=gun --- PASS: TestKeyHandlersInvalidRole (0.00s) === RUN TestGetKeyHandlerCreatesOnce ---- PASS: TestGetKeyHandlerCreatesOnce (0.00s) +--- PASS: TestGetKeyHandlerCreatesOnce (0.02s) === RUN TestKeyHandlersInvalidKeyAlgo -time="2024-01-06T11:06:10Z" level=error msg="500 GET timestamp key: only ED25519 supported by this cryptoservice" go.version=go1.19.8 gun=gun -time="2024-01-06T11:06:10Z" level=error msg="500 GET snapshot key: only ED25519 supported by this cryptoservice" go.version=go1.19.8 gun=gun -time="2024-01-06T11:06:10Z" level=error msg="500 POST timestamp key: only ED25519 supported by this cryptoservice" go.version=go1.19.8 gun=gun -time="2024-01-06T11:06:10Z" level=error msg="500 POST snapshot key: only ED25519 supported by this cryptoservice" go.version=go1.19.8 gun=gun +time="2025-02-07T17:33:14Z" level=error msg="500 GET timestamp key: only ED25519 supported by this cryptoservice" go.version=go1.19.8 gun=gun +time="2025-02-07T17:33:14Z" level=error msg="500 GET snapshot key: only ED25519 supported by this cryptoservice" go.version=go1.19.8 gun=gun +time="2025-02-07T17:33:14Z" level=error msg="500 POST timestamp key: only ED25519 supported by this cryptoservice" go.version=go1.19.8 gun=gun +time="2025-02-07T17:33:14Z" 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-06T11:06:10Z" level=info msg="404 GET root role" go.version=go1.19.8 gun=gun +time="2025-02-07T17:33:14Z" level=info msg="404 GET root role" go.version=go1.19.8 gun=gun --- PASS: TestGetHandlerRoot (0.00s) === RUN TestGetHandlerTimestamp --- PASS: TestGetHandlerTimestamp (0.00s) === RUN TestGetHandlerSnapshot ---- PASS: TestGetHandlerSnapshot (0.00s) +--- PASS: TestGetHandlerSnapshot (0.02s) === RUN TestGetHandler404 -time="2024-01-06T11:06:10Z" level=info msg="404 GET root role" go.version=go1.19.8 gun=gun +time="2025-02-07T17:33:14Z" level=info msg="404 GET root role" go.version=go1.19.8 gun=gun --- PASS: TestGetHandler404 (0.00s) === RUN TestGetHandlerNilData -time="2024-01-06T11:06:10Z" level=info msg="404 GET root role" go.version=go1.19.8 gun=gun +time="2025-02-07T17:33:14Z" level=info msg="404 GET root role" go.version=go1.19.8 gun=gun --- PASS: TestGetHandlerNilData (0.00s) === RUN TestGetHandlerNoStorage -time="2024-01-06T11:06:10Z" level=error msg="500 GET: no storage exists" =gun go.version=go1.19.8 +time="2025-02-07T17:33:14Z" level=error msg="500 GET: no storage exists" =gun go.version=go1.19.8 --- PASS: TestGetHandlerNoStorage (0.00s) === RUN TestAtomicUpdateValidationFailurePropagated ---- PASS: TestAtomicUpdateValidationFailurePropagated (0.01s) +--- PASS: TestAtomicUpdateValidationFailurePropagated (0.02s) === RUN TestAtomicUpdateNonValidationFailureNotPropagated -time="2024-01-06T11:06:10Z" level=info msg="400 POST error validating update" go.version=go1.19.8 testGUN=gun +time="2025-02-07T17:33:14Z" level=info msg="400 POST error validating update" go.version=go1.19.8 testGUN=gun --- PASS: TestAtomicUpdateNonValidationFailureNotPropagated (0.00s) === RUN TestAtomicUpdateVersionErrorPropagated -time="2024-01-06T11:06:10Z" level=info msg="400 POST old version error" go.version=go1.19.8 testGUN=gun ---- PASS: TestAtomicUpdateVersionErrorPropagated (0.01s) +time="2025-02-07T17:33:14Z" level=info msg="400 POST old version error" go.version=go1.19.8 testGUN=gun +--- PASS: TestAtomicUpdateVersionErrorPropagated (0.03s) === RUN TestGetMaybeServerSignedNoCrypto --- PASS: TestGetMaybeServerSignedNoCrypto (0.00s) === RUN TestGetMaybeServerSignedNoKey @@ -2844,16 +2880,16 @@ === RUN TestValidateEmptyNew --- PASS: TestValidateEmptyNew (0.01s) === RUN TestValidateRootCanContainOnlyx509KeysWithRightGun ---- PASS: TestValidateRootCanContainOnlyx509KeysWithRightGun (0.01s) +--- PASS: TestValidateRootCanContainOnlyx509KeysWithRightGun (0.03s) === RUN TestValidatePrevTimestamp ---- PASS: TestValidatePrevTimestamp (0.01s) +--- PASS: TestValidatePrevTimestamp (0.02s) === RUN TestValidatePreviousTimestampCorrupt -time="2024-01-06T11:06:10Z" level=error msg="Failed to unmarshal existing timestamp for GUN docker.com/notary" +time="2025-02-07T17:33:15Z" level=error msg="Failed to unmarshal existing timestamp for GUN docker.com/notary" --- PASS: TestValidatePreviousTimestampCorrupt (0.01s) === RUN TestValidateGetCurrentTimestampBroken ---- PASS: TestValidateGetCurrentTimestampBroken (0.01s) +--- PASS: TestValidateGetCurrentTimestampBroken (0.03s) === RUN TestValidateNoNewRoot ---- PASS: TestValidateNoNewRoot (0.01s) +--- PASS: TestValidateNoNewRoot (0.03s) === RUN TestValidateNoNewTargets --- PASS: TestValidateNoNewTargets (0.01s) === RUN TestValidateOnlySnapshot @@ -2863,118 +2899,118 @@ === RUN TestValidateOldRootCorrupt --- PASS: TestValidateOldRootCorrupt (0.00s) === RUN TestValidateOldRootCorruptRootRole ---- PASS: TestValidateOldRootCorruptRootRole (0.01s) +--- PASS: TestValidateOldRootCorruptRootRole (0.02s) === RUN TestValidateRootGetCurrentRootBroken ---- PASS: TestValidateRootGetCurrentRootBroken (0.00s) +--- PASS: TestValidateRootGetCurrentRootBroken (0.01s) === RUN TestValidateRootRotationWithOldSigs ---- PASS: TestValidateRootRotationWithOldSigs (0.02s) +--- PASS: TestValidateRootRotationWithOldSigs (0.06s) === RUN TestValidateRootRotationMultipleKeysThreshold1 ---- PASS: TestValidateRootRotationMultipleKeysThreshold1 (0.02s) +--- PASS: TestValidateRootRotationMultipleKeysThreshold1 (0.05s) === RUN TestRootRotationNotSignedWithOldKeysForOldRole ---- PASS: TestRootRotationNotSignedWithOldKeysForOldRole (0.01s) +--- PASS: TestRootRotationNotSignedWithOldKeysForOldRole (0.04s) === RUN TestRootRotationVersionIncrement ---- PASS: TestRootRotationVersionIncrement (0.01s) +--- PASS: TestRootRotationVersionIncrement (0.02s) === RUN TestValidateNoRoot ---- PASS: TestValidateNoRoot (0.00s) +--- PASS: TestValidateNoRoot (0.01s) === RUN TestValidateSnapshotMissingNoSnapshotKey --- PASS: TestValidateSnapshotMissingNoSnapshotKey (0.01s) === RUN TestValidateSnapshotGenerateNoPrev ---- PASS: TestValidateSnapshotGenerateNoPrev (0.01s) +--- PASS: TestValidateSnapshotGenerateNoPrev (0.02s) === RUN TestValidateSnapshotGenerateWithPrev ---- PASS: TestValidateSnapshotGenerateWithPrev (0.01s) +--- PASS: TestValidateSnapshotGenerateWithPrev (0.03s) === RUN TestValidateSnapshotGeneratePrevCorrupt -time="2024-01-06T11:06:10Z" level=error msg="Failed to unmarshal existing snapshot for GUN docker.com/notary" +time="2025-02-07T17:33:15Z" level=error msg="Failed to unmarshal existing snapshot for GUN docker.com/notary" --- PASS: TestValidateSnapshotGeneratePrevCorrupt (0.01s) === RUN TestValidateSnapshotGenerateStoreGetCurrentSnapshotBroken --- PASS: TestValidateSnapshotGenerateStoreGetCurrentSnapshotBroken (0.01s) === RUN TestValidateSnapshotGenerateNoTargets --- PASS: TestValidateSnapshotGenerateNoTargets (0.01s) === RUN TestValidateSnapshotGenerate ---- PASS: TestValidateSnapshotGenerate (0.01s) +--- PASS: TestValidateSnapshotGenerate (0.02s) === RUN TestValidateRootNoTimestampKey --- PASS: TestValidateRootNoTimestampKey (0.00s) === RUN TestValidateRootInvalidTimestampKey ---- PASS: TestValidateRootInvalidTimestampKey (0.00s) +--- PASS: TestValidateRootInvalidTimestampKey (0.02s) === RUN TestValidateRootInvalidTimestampThreshold ---- PASS: TestValidateRootInvalidTimestampThreshold (0.01s) +--- PASS: TestValidateRootInvalidTimestampThreshold (0.02s) === RUN TestValidateRootInvalidZeroThreshold ---- PASS: TestValidateRootInvalidZeroThreshold (0.02s) +--- PASS: TestValidateRootInvalidZeroThreshold (0.04s) === RUN TestValidateRootRoleMissing ---- PASS: TestValidateRootRoleMissing (0.00s) +--- PASS: TestValidateRootRoleMissing (0.01s) === RUN TestValidateTargetsRoleMissing ---- PASS: TestValidateTargetsRoleMissing (0.00s) +--- PASS: TestValidateTargetsRoleMissing (0.01s) === RUN TestValidateSnapshotRoleMissing ---- PASS: TestValidateSnapshotRoleMissing (0.00s) +--- PASS: TestValidateSnapshotRoleMissing (0.01s) === RUN TestValidateRootSigMissing ---- PASS: TestValidateRootSigMissing (0.00s) +--- PASS: TestValidateRootSigMissing (0.01s) === RUN TestValidateTargetsSigMissing -time="2024-01-06T11:06:10Z" level=error msg="ErrBadTargets: tuf: data has no signatures" ---- PASS: TestValidateTargetsSigMissing (0.00s) +time="2025-02-07T17:33:15Z" level=error msg="ErrBadTargets: tuf: data has no signatures" +--- PASS: TestValidateTargetsSigMissing (0.01s) === RUN TestValidateSnapshotSigMissing ---- PASS: TestValidateSnapshotSigMissing (0.00s) +--- PASS: TestValidateSnapshotSigMissing (0.01s) === RUN TestValidateRootCorrupt ---- PASS: TestValidateRootCorrupt (0.00s) +--- PASS: TestValidateRootCorrupt (0.01s) === RUN TestValidateTargetsCorrupt -time="2024-01-06T11:06:10Z" level=error msg="ErrBadTargets: invalid character '\\u0084' looking for beginning of value" ---- PASS: TestValidateTargetsCorrupt (0.01s) +time="2025-02-07T17:33:15Z" level=error msg="ErrBadTargets: invalid character '\\u0084' looking for beginning of value" +--- PASS: TestValidateTargetsCorrupt (0.02s) === RUN TestValidateSnapshotCorrupt ---- PASS: TestValidateSnapshotCorrupt (0.01s) +--- PASS: TestValidateSnapshotCorrupt (0.00s) === RUN TestValidateRootModifiedSize --- PASS: TestValidateRootModifiedSize (0.01s) === RUN TestValidateTargetsModifiedSize ---- PASS: TestValidateTargetsModifiedSize (0.01s) +--- PASS: TestValidateTargetsModifiedSize (0.02s) === RUN TestValidateRootModifiedHash ---- PASS: TestValidateRootModifiedHash (0.01s) +--- PASS: TestValidateRootModifiedHash (0.02s) === RUN TestValidateTargetsModifiedHash --- PASS: TestValidateTargetsModifiedHash (0.01s) === RUN TestGenerateSnapshotRootNotLoaded --- PASS: TestGenerateSnapshotRootNotLoaded (0.00s) === RUN TestGenerateSnapshotNoKey ---- PASS: TestGenerateSnapshotNoKey (0.00s) +--- PASS: TestGenerateSnapshotNoKey (0.01s) === RUN TestLoadTargetsLoadsNothingIfNoUpdates ---- PASS: TestLoadTargetsLoadsNothingIfNoUpdates (0.00s) +--- PASS: TestLoadTargetsLoadsNothingIfNoUpdates (0.01s) === RUN TestValidateTargetsRequiresStoredParent -time="2024-01-06T11:06:10Z" level=error msg="ErrBadTargets: targets must be loaded first" ---- PASS: TestValidateTargetsRequiresStoredParent (0.01s) +time="2025-02-07T17:33:15Z" level=error msg="ErrBadTargets: targets must be loaded first" +--- PASS: TestValidateTargetsRequiresStoredParent (0.02s) === RUN TestValidateTargetsParentInUpdate -time="2024-01-06T11:06:10Z" level=error msg="ErrBadTargets: invalid character 'I' looking for beginning of value" +time="2025-02-07T17:33:15Z" level=error msg="ErrBadTargets: invalid character 'I' looking for beginning of value" --- PASS: TestValidateTargetsParentInUpdate (0.01s) === RUN TestValidateTargetsRoleNotInParent -time="2024-01-06T11:06:10Z" level=error msg="ErrBadTargets: tuf: invalid role targets/level1. delegation does not exist" -time="2024-01-06T11:06:10Z" level=error msg="ErrBadTargets: targets has already been loaded" -time="2024-01-06T11:06:10Z" level=error msg="ErrBadTargets: tuf: invalid role targets/level1. delegation does not exist" ---- PASS: TestValidateTargetsRoleNotInParent (0.01s) +time="2025-02-07T17:33:15Z" level=error msg="ErrBadTargets: tuf: invalid role targets/level1. delegation does not exist" +time="2025-02-07T17:33:15Z" level=error msg="ErrBadTargets: targets has already been loaded" +time="2025-02-07T17:33:15Z" level=error msg="ErrBadTargets: tuf: invalid role targets/level1. delegation does not exist" +--- PASS: TestValidateTargetsRoleNotInParent (0.03s) PASS -ok github.com/theupdateframework/notary/server/handlers 0.463s +ok github.com/theupdateframework/notary/server/handlers 1.038s === RUN TestSnapshotExpired --- PASS: TestSnapshotExpired (0.00s) === RUN TestSnapshotNotExpired --- PASS: TestSnapshotNotExpired (0.00s) === RUN TestGetSnapshotKeyCreate ---- PASS: TestGetSnapshotKeyCreate (0.00s) +--- PASS: TestGetSnapshotKeyCreate (0.01s) === RUN TestGetSnapshotKeyCreateWithFailingStore -time="2024-01-06T11:06:09Z" level=error msg="Error when retrieving root role for GUN gun: failing store failed" +time="2025-02-07T17:33:12Z" level=error msg="Error when retrieving root role for GUN gun: failing store failed" --- PASS: TestGetSnapshotKeyCreateWithFailingStore (0.00s) === RUN TestGetSnapshotKeyCreateWithCorruptedStore -time="2024-01-06T11:06:09Z" level=error msg="Failed to unmarshal existing root for GUN gun to retrieve snapshot key ID" +time="2025-02-07T17:33:12Z" level=error msg="Failed to unmarshal existing root for GUN gun to retrieve snapshot key ID" --- PASS: TestGetSnapshotKeyCreateWithCorruptedStore (0.00s) === RUN TestGetSnapshotKeyCreateWithInvalidAlgo --- PASS: TestGetSnapshotKeyCreateWithInvalidAlgo (0.00s) === RUN TestGetSnapshotKeyExistingMetadata ---- PASS: TestGetSnapshotKeyExistingMetadata (0.00s) +--- PASS: TestGetSnapshotKeyExistingMetadata (0.01s) === RUN TestGetSnapshotNoPreviousSnapshot -time="2024-01-06T11:06:09Z" level=error msg="Failed to unmarshal existing snapshot for GUN gun" +time="2025-02-07T17:33:12Z" level=error msg="Failed to unmarshal existing snapshot for GUN gun" --- PASS: TestGetSnapshotNoPreviousSnapshot (0.00s) === RUN TestGetSnapshotReturnsPreviousSnapshotIfUnexpired ---- PASS: TestGetSnapshotReturnsPreviousSnapshotIfUnexpired (0.00s) +--- PASS: TestGetSnapshotReturnsPreviousSnapshotIfUnexpired (0.01s) === RUN TestGetSnapshotOldSnapshotExpired ---- PASS: TestGetSnapshotOldSnapshotExpired (0.00s) +--- PASS: TestGetSnapshotOldSnapshotExpired (0.01s) === RUN TestCannotMakeNewSnapshotIfNoRoot --- PASS: TestCannotMakeNewSnapshotIfNoRoot (0.00s) === RUN TestCreateSnapshotNoKeyInCrypto ---- PASS: TestCreateSnapshotNoKeyInCrypto (0.00s) +--- PASS: TestCreateSnapshotNoKeyInCrypto (0.01s) PASS -ok github.com/theupdateframework/notary/server/snapshot 0.053s +ok github.com/theupdateframework/notary/server/snapshot 0.150s === RUN TestMemoryUpdateCurrentEmpty --- PASS: TestMemoryUpdateCurrentEmpty (0.00s) === RUN TestMemoryUpdateCurrentVersionCheckOldVersionExists @@ -3000,67 +3036,67 @@ === RUN TestRDBTUFFileJSONUnmarshallingFailure --- PASS: TestRDBTUFFileJSONUnmarshallingFailure (0.00s) === RUN TestSQLUpdateCurrentEmpty ---- PASS: TestSQLUpdateCurrentEmpty (0.01s) +--- PASS: TestSQLUpdateCurrentEmpty (0.03s) === RUN TestSQLUpdateCurrentVersionCheckOldVersionExists ---- PASS: TestSQLUpdateCurrentVersionCheckOldVersionExists (0.00s) +--- PASS: TestSQLUpdateCurrentVersionCheckOldVersionExists (0.01s) === RUN TestSQLUpdateCurrentVersionCheckOldVersionNotExist --- PASS: TestSQLUpdateCurrentVersionCheckOldVersionNotExist (0.00s) === RUN TestSQLUpdateManyNoConflicts ---- PASS: TestSQLUpdateManyNoConflicts (0.01s) +--- PASS: TestSQLUpdateManyNoConflicts (0.04s) === RUN TestSQLUpdateManyConflictRollback ---- PASS: TestSQLUpdateManyConflictRollback (0.03s) +--- PASS: TestSQLUpdateManyConflictRollback (0.04s) === RUN TestSQLDelete ---- PASS: TestSQLDelete (0.02s) +--- PASS: TestSQLDelete (0.06s) === RUN TestSQLDBCheckHealthTableMissing ---- PASS: TestSQLDBCheckHealthTableMissing (0.00s) +--- PASS: TestSQLDBCheckHealthTableMissing (0.01s) === RUN TestSQLDBCheckHealthDBConnectionFail --- PASS: TestSQLDBCheckHealthDBConnectionFail (0.00s) === RUN TestSQLDBCheckHealthSucceeds --- PASS: TestSQLDBCheckHealthSucceeds (0.00s) === RUN TestSQLDBGetChecksum ---- PASS: TestSQLDBGetChecksum (0.00s) +--- PASS: TestSQLDBGetChecksum (0.01s) === RUN TestSQLDBGetChecksumNotFound --- PASS: TestSQLDBGetChecksumNotFound (0.00s) === RUN TestSQLTUFMetaStoreGetCurrent ---- PASS: TestSQLTUFMetaStoreGetCurrent (0.04s) +--- PASS: TestSQLTUFMetaStoreGetCurrent (0.06s) === RUN TestSQLGetChanges ---- PASS: TestSQLGetChanges (0.01s) +--- PASS: TestSQLGetChanges (0.02s) === RUN TestSQLDBGetVersion --- PASS: TestSQLDBGetVersion (0.00s) PASS -ok github.com/theupdateframework/notary/server/storage 0.159s +ok github.com/theupdateframework/notary/server/storage 0.358s === RUN TestTimestampExpired --- PASS: TestTimestampExpired (0.00s) === RUN TestTimestampNotExpired --- PASS: TestTimestampNotExpired (0.00s) === RUN TestGetTimestampKey ---- PASS: TestGetTimestampKey (0.00s) +--- PASS: TestGetTimestampKey (0.01s) === RUN TestGetTimestampNoPreviousTimestamp -time="2024-01-06T11:06:10Z" level=error msg="Failed to unmarshal existing timestamp" ---- PASS: TestGetTimestampNoPreviousTimestamp (0.00s) +time="2025-02-07T17:33:13Z" level=error msg="Failed to unmarshal existing timestamp" +--- PASS: TestGetTimestampNoPreviousTimestamp (0.02s) === RUN TestGetTimestampReturnsPreviousTimestampIfUnexpired --- PASS: TestGetTimestampReturnsPreviousTimestampIfUnexpired (0.01s) === RUN TestGetTimestampOldTimestampExpired ---- PASS: TestGetTimestampOldTimestampExpired (0.01s) +--- PASS: TestGetTimestampOldTimestampExpired (0.00s) === RUN TestCannotMakeNewTimestampIfNoRootOrSnapshot -time="2024-01-06T11:06:10Z" level=error msg="Failed to create a new timestamp" -time="2024-01-06T11:06:10Z" level=error msg="Failed to create a new timestamp" ---- PASS: TestCannotMakeNewTimestampIfNoRootOrSnapshot (0.01s) +time="2025-02-07T17:33:13Z" level=error msg="Failed to create a new timestamp" +time="2025-02-07T17:33:13Z" level=error msg="Failed to create a new timestamp" +--- PASS: TestCannotMakeNewTimestampIfNoRootOrSnapshot (0.02s) === RUN TestCreateTimestampNoKeyInCrypto -time="2024-01-06T11:06:10Z" level=error msg="Failed to create a new timestamp" ---- PASS: TestCreateTimestampNoKeyInCrypto (0.01s) +time="2025-02-07T17:33:13Z" level=error msg="Failed to create a new timestamp" +--- PASS: TestCreateTimestampNoKeyInCrypto (0.00s) === RUN TestGetTimestampKeyCreateWithFailingStore -time="2024-01-06T11:06:10Z" level=error msg="Error when retrieving root role for GUN gun: failing store failed" +time="2025-02-07T17:33:13Z" level=error msg="Error when retrieving root role for GUN gun: failing store failed" --- PASS: TestGetTimestampKeyCreateWithFailingStore (0.00s) === RUN TestGetTimestampKeyCreateWithCorruptedStore -time="2024-01-06T11:06:10Z" level=error msg="Failed to unmarshal existing root for GUN gun to retrieve timestamp key ID" +time="2025-02-07T17:33:13Z" level=error msg="Failed to unmarshal existing root for GUN gun to retrieve timestamp key ID" --- PASS: TestGetTimestampKeyCreateWithCorruptedStore (0.00s) === RUN TestGetTimestampKeyCreateWithInvalidAlgo --- PASS: TestGetTimestampKeyCreateWithInvalidAlgo (0.00s) === RUN TestGetTimestampKeyExistingMetadata ---- PASS: TestGetTimestampKeyExistingMetadata (0.00s) +--- PASS: TestGetTimestampKeyExistingMetadata (0.01s) PASS -ok github.com/theupdateframework/notary/server/timestamp 0.076s +ok github.com/theupdateframework/notary/server/timestamp 0.180s === RUN TestHealthCheckKMUnhealthy --- PASS: TestHealthCheckKMUnhealthy (0.00s) === RUN TestHealthCheckSignerUnhealthy @@ -3082,27 +3118,27 @@ === RUN TestHealthCheckNonexistentService --- PASS: TestHealthCheckNonexistentService (0.00s) === RUN TestGetPrivateKeyAndSignWithExistingKey -time="2024-01-06T11:06:11Z" level=info msg="Sign: Signed message! with KeyID cfcaad7c06379893344dccafc4396247bd2453f3b86fd5667ab5cf79af24334b" go.version=go1.19.8 +time="2025-02-07T17:33:16Z" level=info msg="Sign: Signed message! with KeyID 34aff272a21b82beb36730807f80b92498c58f231104d5850655b49cf7558f50" go.version=go1.19.8 --- PASS: TestGetPrivateKeyAndSignWithExistingKey (0.00s) === RUN TestCannotSignWithKeyThatDoesntExist -time="2024-01-06T11:06:11Z" level=error msg="Sign: key 99e773a27ba58aa2a7d6c2f00f3fabe00710a8fb1394e5db65d18a9d7261d42f not found" go.version=go1.19.8 +time="2025-02-07T17:33:16Z" level=error msg="Sign: key af60455e811c018978e46cf0fcc497d590aea8a98504959f0f35ad1ac3c6e70c not found" go.version=go1.19.8 --- PASS: TestCannotSignWithKeyThatDoesntExist (0.00s) === RUN TestCryptoSignerInterfaceBehavior -time="2024-01-06T11:06:11Z" level=error msg="GetKeyInfo: key nonexistent not found" go.version=go1.19.8 -time="2024-01-06T11:06:11Z" level=error msg="GetKeyInfo: key nonexistent not found" go.version=go1.19.8 -time="2024-01-06T11:06:11Z" level=info msg="CreateKey: Created KeyID f9ceda8960d0b653df9e4fad1d55897be3b6b8025716e5b33dcb29be5436ee23" go.version=go1.19.8 -time="2024-01-06T11:06:11Z" level=info msg="CreateKey: Created KeyID 306d84868d75915f053695c8fe42fbc1c697423a3397a709d111007822c46034" go.version=go1.19.8 -time="2024-01-06T11:06:11Z" level=error msg="GetKeyInfo: key f9ceda8960d0b653df9e4fad1d55897be3b6b8025716e5b33dcb29be5436ee23 not found" go.version=go1.19.8 -time="2024-01-06T11:06:11Z" level=error msg="GetKeyInfo: key 306d84868d75915f053695c8fe42fbc1c697423a3397a709d111007822c46034 not found" go.version=go1.19.8 +time="2025-02-07T17:33:16Z" level=error msg="GetKeyInfo: key nonexistent not found" go.version=go1.19.8 +time="2025-02-07T17:33:16Z" level=error msg="GetKeyInfo: key nonexistent not found" go.version=go1.19.8 +time="2025-02-07T17:33:16Z" level=info msg="CreateKey: Created KeyID ed7de4afb85aa7834645d643d25e23ae6cfe03b942f4dc83ea5616023c15ad3b" go.version=go1.19.8 +time="2025-02-07T17:33:16Z" level=info msg="CreateKey: Created KeyID 8ac933588287f2d42be1e9a62794b687568481d98dc92f74b43358510583a399" go.version=go1.19.8 +time="2025-02-07T17:33:16Z" level=error msg="GetKeyInfo: key ed7de4afb85aa7834645d643d25e23ae6cfe03b942f4dc83ea5616023c15ad3b not found" go.version=go1.19.8 +time="2025-02-07T17:33:16Z" level=error msg="GetKeyInfo: key 8ac933588287f2d42be1e9a62794b687568481d98dc92f74b43358510583a399 not found" go.version=go1.19.8 --- PASS: TestCryptoSignerInterfaceBehavior (0.01s) PASS -ok github.com/theupdateframework/notary/signer 0.038s +ok github.com/theupdateframework/notary/signer 0.113s ? github.com/theupdateframework/notary/signer/api [no test files] ? github.com/theupdateframework/notary/signer/client [no test files] === RUN TestGetSuccessPopulatesCache --- PASS: TestGetSuccessPopulatesCache (0.00s) === RUN TestAddKeyPopulatesCacheIfSuccessful ---- PASS: TestAddKeyPopulatesCacheIfSuccessful (0.00s) +--- PASS: TestAddKeyPopulatesCacheIfSuccessful (0.01s) === RUN TestDeleteKeyRemovesKeyFromCache --- PASS: TestDeleteKeyRemovesKeyFromCache (0.00s) === RUN TestRDBPrivateKeyJSONUnmarshalling @@ -3113,32 +3149,32 @@ `nodb` is not officially supported, running under compatibility mode. --- PASS: TestNewSQLKeyDBStorePropagatesDBError (0.00s) === RUN TestSQLDBHealthCheckMissingTable ---- PASS: TestSQLDBHealthCheckMissingTable (0.00s) +--- PASS: TestSQLDBHealthCheckMissingTable (0.02s) === RUN TestSQLDBHealthCheckNoConnection ---- PASS: TestSQLDBHealthCheckNoConnection (0.00s) +--- PASS: TestSQLDBHealthCheckNoConnection (0.02s) === RUN TestSQLKeyCanOnlyBeAddedOnce ---- PASS: TestSQLKeyCanOnlyBeAddedOnce (0.02s) -=== RUN TestSQLCreateDelete (/build/reproducible-path/notary-0.7.0+ds1/_build/src/github.com/theupdateframework/notary/signer/keydbstore/sql_keydbstore.go:98) -[2024-01-06 11:06:09]  UNIQUE constraint failed: private_keys.key_id  ---- PASS: TestSQLCreateDelete (0.05s) +[2025-02-07 17:33:12]  UNIQUE constraint failed: private_keys.key_id  +--- PASS: TestSQLKeyCanOnlyBeAddedOnce (0.12s) +=== RUN TestSQLCreateDelete +--- PASS: TestSQLCreateDelete (0.10s) === RUN TestSQLKeyRotation ---- PASS: TestSQLKeyRotation (0.04s) +--- PASS: TestSQLKeyRotation (0.14s) === RUN TestSQLSigningMarksKeyActive -time="2024-01-06T11:06:09Z" level=error msg="Key 5a85fbf01098ca61f74440bae840cd6b7d2e60d6ab9005df19f8f25c1af17438 was just used to sign hash successful, db closed, error when trying to mark key as active: sql: database is closed" +time="2025-02-07T17:33:13Z" level=error msg="Key 96d10f4f5866b9a1d878edb22607379b740cd0fd6ff4e02b7ea7ac8e4330e360 was just used to sign hash successful, db closed, error when trying to mark key as active: sql: database is closed" +--- PASS: TestSQLSigningMarksKeyActive (0.17s) +=== RUN TestSQLCreateKey (/build/reproducible-path/notary-0.7.0+ds1/_build/src/github.com/theupdateframework/notary/signer/keydbstore/sql_keydbstore.go:197) -[2024-01-06 11:06:09]  sql: database is closed  ---- PASS: TestSQLSigningMarksKeyActive (0.05s) -=== RUN TestSQLCreateKey ---- PASS: TestSQLCreateKey (0.04s) +[2025-02-07 17:33:13]  sql: database is closed  +--- PASS: TestSQLCreateKey (0.10s) === RUN TestSQLUnimplementedInterfaceBehavior ---- PASS: TestSQLUnimplementedInterfaceBehavior (0.01s) +--- PASS: TestSQLUnimplementedInterfaceBehavior (0.03s) PASS -ok github.com/theupdateframework/notary/signer/keydbstore 0.250s +ok github.com/theupdateframework/notary/signer/keydbstore 0.820s === RUN TestSet ---- PASS: TestSet (0.00s) +--- PASS: TestSet (0.01s) === RUN TestSetWithNoParentDirectory --- PASS: TestSetWithNoParentDirectory (0.00s) === RUN TestSetRemovesExistingFileBeforeWriting @@ -3170,7 +3206,7 @@ === RUN TestFileStoreConsistency --- PASS: TestFileStoreConsistency (0.00s) === RUN TestHTTPStoreGetSized ---- PASS: TestHTTPStoreGetSized (0.00s) +--- PASS: TestHTTPStoreGetSized (0.01s) === RUN TestHTTPStoreGetAllMeta --- PASS: TestHTTPStoreGetAllMeta (0.00s) === RUN TestSetSingleAndSetMultiMeta @@ -3178,9 +3214,9 @@ === RUN Test404Error --- PASS: Test404Error (0.00s) === RUN Test50XErrors ---- PASS: Test50XErrors (0.00s) +--- PASS: Test50XErrors (0.01s) === RUN Test400Error ---- PASS: Test400Error (0.01s) +--- PASS: Test400Error (0.00s) === RUN TestTranslateErrorsParse400Errors --- PASS: TestTranslateErrorsParse400Errors (0.00s) === RUN TestTranslateErrorsWhenCannotParse400 @@ -3194,7 +3230,7 @@ === RUN TestHTTPStoreGetKey --- PASS: TestHTTPStoreGetKey (0.00s) === RUN TestHTTPStoreGetRotateKeySizeLimited ---- PASS: TestHTTPStoreGetRotateKeySizeLimited (0.00s) +--- PASS: TestHTTPStoreGetRotateKeySizeLimited (0.05s) === RUN TestHTTPOffline --- PASS: TestHTTPOffline (0.00s) === RUN TestErrServerUnavailable @@ -3215,7 +3251,7 @@ === RUN TestMemoryStoreMetadata --- PASS: TestMemoryStoreMetadata (0.00s) PASS -ok github.com/theupdateframework/notary/storage 0.042s +ok github.com/theupdateframework/notary/storage 0.126s ? github.com/theupdateframework/notary/storage/rethinkdb [no test files] === RUN TestExportKeys --- PASS: TestExportKeys (0.00s) @@ -3230,131 +3266,131 @@ === RUN TestImportNoPath --- PASS: TestImportNoPath (0.00s) === RUN TestNonRootPathInference ---- PASS: TestNonRootPathInference (0.00s) +--- PASS: TestNonRootPathInference (0.01s) === RUN TestBlockHeaderPrecedenceRoleAndGun --- PASS: TestBlockHeaderPrecedenceRoleAndGun (0.00s) === RUN TestBlockHeaderPrecedenceGunFromPath ---- PASS: TestBlockHeaderPrecedenceGunFromPath (0.00s) +--- PASS: TestBlockHeaderPrecedenceGunFromPath (0.01s) === RUN TestImportKeys2InOneFile --- PASS: TestImportKeys2InOneFile (0.00s) === RUN TestImportKeys2InOneFileNoPath --- PASS: TestImportKeys2InOneFileNoPath (0.00s) === RUN TestEncryptedKeyImportFail -time="2024-01-06T11:06:09Z" level=warning msg="failed to import key to store: Invalid key generated, key may be encrypted and does not contain path header" ---- PASS: TestEncryptedKeyImportFail (0.00s) +time="2025-02-07T17:33:10Z" level=warning msg="failed to import key to store: Invalid key generated, key may be encrypted and does not contain path header" +--- PASS: TestEncryptedKeyImportFail (0.01s) === RUN TestEncryptedKeyImportSuccess --- PASS: TestEncryptedKeyImportSuccess (0.00s) === RUN TestEncryption ---- PASS: TestEncryption (0.00s) +--- PASS: TestEncryption (0.02s) === RUN TestAddKey ---- PASS: TestAddKey (0.01s) +--- PASS: TestAddKey (0.04s) === RUN TestKeyStoreInternalState --- PASS: TestKeyStoreInternalState (0.00s) === RUN TestGet ---- PASS: TestGet (0.00s) +--- PASS: TestGet (0.01s) === RUN TestGetLegacyKey --- PASS: TestGetLegacyKey (0.00s) === RUN TestListKeys ---- PASS: TestListKeys (0.01s) +--- PASS: TestListKeys (0.03s) === RUN TestAddGetKeyMemStore --- PASS: TestAddGetKeyMemStore (0.00s) === RUN TestAddGetKeyInfoMemStore ---- PASS: TestAddGetKeyInfoMemStore (0.00s) +--- PASS: TestAddGetKeyInfoMemStore (0.01s) === RUN TestGetDecryptedWithTamperedCipherText -time="2024-01-06T11:06:09Z" level=error msg="PEM block is empty" +time="2025-02-07T17:33:10Z" level=error msg="PEM block is empty" --- PASS: TestGetDecryptedWithTamperedCipherText (0.00s) === RUN TestGetDecryptedWithInvalidPassphrase ---- PASS: TestGetDecryptedWithInvalidPassphrase (0.01s) +--- PASS: TestGetDecryptedWithInvalidPassphrase (0.03s) === RUN TestGetDecryptedWithConsistentlyInvalidPassphrase ---- PASS: TestGetDecryptedWithConsistentlyInvalidPassphrase (0.01s) +--- PASS: TestGetDecryptedWithConsistentlyInvalidPassphrase (0.07s) === RUN TestRemoveKey --- PASS: TestRemoveKey (0.01s) === RUN TestKeysAreCached ---- PASS: TestKeysAreCached (0.00s) +--- PASS: TestKeysAreCached (0.01s) PASS -ok github.com/theupdateframework/notary/trustmanager 0.093s +ok github.com/theupdateframework/notary/trustmanager 0.311s === RUN TestRemoteStore -time="2024-01-06T11:06:11Z" level=info msg="listing files from localhost:9888" -time="2024-01-06T11:06:11Z" level=info msg="listing files from localhost:9888" ---- PASS: TestRemoteStore (0.04s) +time="2025-02-07T17:33:15Z" level=info msg="listing files from localhost:9888" +time="2025-02-07T17:33:15Z" level=info msg="listing files from localhost:9888" +--- PASS: TestRemoteStore (0.08s) === RUN TestErrors -time="2024-01-06T11:06:11Z" level=error msg="failed to store: test error" ---- PASS: TestErrors (0.03s) +time="2025-02-07T17:33:16Z" level=error msg="failed to store: test error" +--- PASS: TestErrors (0.10s) === RUN TestNewGRPCStorage --- PASS: TestNewGRPCStorage (0.00s) === RUN TestGRPCStorage --- PASS: TestGRPCStorage (0.00s) PASS -ok github.com/theupdateframework/notary/trustmanager/remoteks 0.086s +ok github.com/theupdateframework/notary/trustmanager/remoteks 0.256s ? github.com/theupdateframework/notary/trustmanager/yubikey [no test files] === RUN TestWildcardMatch --- PASS: TestWildcardMatch (0.00s) === RUN TestValidateRoot -2024/01/06 11:06:10 [INFO] generate received request -2024/01/06 11:06:10 [INFO] received CSR -2024/01/06 11:06:10 [INFO] generating key: ecdsa-256 -2024/01/06 11:06:10 [INFO] encoded CSR -2024/01/06 11:06:10 [INFO] signed certificate with serial number 405214562281304034334700769165425290147290893177 -2024/01/06 11:06:10 [INFO] received CSR -2024/01/06 11:06:10 [INFO] generating key: ecdsa-256 -2024/01/06 11:06:10 [INFO] encoded CSR -2024/01/06 11:06:10 [INFO] signed certificate with serial number 67148408665661534586121383491614703091333875018 -2024/01/06 11:06:10 [INFO] received CSR -2024/01/06 11:06:10 [INFO] generating key: ecdsa-256 -2024/01/06 11:06:10 [INFO] encoded CSR -2024/01/06 11:06:10 [INFO] signed certificate with serial number 177739030340933749941040409907993848724372546225 ---- PASS: TestValidateRoot (0.01s) +2025/02/07 17:33:13 [INFO] generate received request +2025/02/07 17:33:13 [INFO] received CSR +2025/02/07 17:33:13 [INFO] generating key: ecdsa-256 +2025/02/07 17:33:13 [INFO] encoded CSR +2025/02/07 17:33:13 [INFO] signed certificate with serial number 405971371620490995660788158520593469949071520472 +2025/02/07 17:33:13 [INFO] received CSR +2025/02/07 17:33:13 [INFO] generating key: ecdsa-256 +2025/02/07 17:33:13 [INFO] encoded CSR +2025/02/07 17:33:13 [INFO] signed certificate with serial number 284212632569172978687218532216790365141027380376 +2025/02/07 17:33:13 [INFO] received CSR +2025/02/07 17:33:13 [INFO] generating key: ecdsa-256 +2025/02/07 17:33:13 [INFO] encoded CSR +2025/02/07 17:33:13 [INFO] signed certificate with serial number 308717296213754573184578754647697403136971435725 +--- PASS: TestValidateRoot (0.06s) === RUN TestValidateRootWithoutTOFUS --- PASS: TestValidateRootWithoutTOFUS (0.00s) === RUN TestValidateRootWithPinnedCert --- PASS: TestValidateRootWithPinnedCert (0.00s) === RUN TestValidateRootWithPinnedCertAndIntermediates ---- PASS: TestValidateRootWithPinnedCertAndIntermediates (0.01s) +--- PASS: TestValidateRootWithPinnedCertAndIntermediates (0.04s) === RUN TestValidateRootFailuresWithPinnedCert ---- PASS: TestValidateRootFailuresWithPinnedCert (0.00s) +--- PASS: TestValidateRootFailuresWithPinnedCert (0.01s) === RUN TestValidateRootWithPinnedCA ---- PASS: TestValidateRootWithPinnedCA (0.03s) +--- PASS: TestValidateRootWithPinnedCA (0.07s) === RUN TestValidateSuccessfulRootRotation ---- PASS: TestValidateSuccessfulRootRotation (0.04s) +--- PASS: TestValidateSuccessfulRootRotation (0.14s) === RUN TestValidateRootRotationMissingOrigSig ---- PASS: TestValidateRootRotationMissingOrigSig (0.03s) +--- PASS: TestValidateRootRotationMissingOrigSig (0.10s) === RUN TestValidateRootRotationMissingNewSig ---- PASS: TestValidateRootRotationMissingNewSig (0.04s) +--- PASS: TestValidateRootRotationMissingNewSig (0.07s) === RUN TestValidateRootRotationTrustPinning ---- PASS: TestValidateRootRotationTrustPinning (0.03s) +--- PASS: TestValidateRootRotationTrustPinning (0.06s) === RUN TestValidateRootRotationTrustPinningInvalidCA --- PASS: TestValidateRootRotationTrustPinningInvalidCA (0.04s) === RUN TestParsePEMPublicKey -time="2024-01-06T11:06:10Z" level=warning msg="certificate with CN notary is near expiry" ---- PASS: TestParsePEMPublicKey (0.00s) +time="2025-02-07T17:33:13Z" level=warning msg="certificate with CN notary is near expiry" +--- PASS: TestParsePEMPublicKey (0.01s) === RUN TestCheckingCertExpiry -time="2024-01-06T11:06:10Z" level=warning msg="certificate with CN notary is near expiry" +time="2025-02-07T17:33:13Z" level=warning msg="certificate with CN notary is near expiry" --- PASS: TestCheckingCertExpiry (0.00s) === RUN TestValidateRootWithExpiredIntermediate --- PASS: TestValidateRootWithExpiredIntermediate (0.01s) === RUN TestCheckingWildcardCert ---- PASS: TestCheckingWildcardCert (0.00s) +--- PASS: TestCheckingWildcardCert (0.01s) === RUN TestWildcardMatching --- PASS: TestWildcardMatching (0.00s) PASS -ok github.com/theupdateframework/notary/trustpinning 0.279s +ok github.com/theupdateframework/notary/trustpinning 0.715s === RUN TestInitSnapshotNoTargets ---- PASS: TestInitSnapshotNoTargets (0.01s) +--- PASS: TestInitSnapshotNoTargets (0.02s) === RUN TestInitRepo ---- PASS: TestInitRepo (0.00s) +--- PASS: TestInitRepo (0.02s) === RUN TestUpdateDelegations --- PASS: TestUpdateDelegations (0.00s) === RUN TestPurgeDelegationsKeyFromTop -time="2024-01-06T11:06:10Z" 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-06T11:06:10Z" level=warning msg="role targets/vimes/carrot has fewer keys than its threshold of 1; it will not be usable until keys are added to it" +time="2025-02-07T17:33:13Z" 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-07T17:33:13Z" 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-06T11:06:10Z" level=warning msg="role targets/vimes/carrot has fewer keys than its threshold of 1; it will not be usable until keys are added to it" +time="2025-02-07T17:33:13Z" level=warning msg="role targets/vimes/carrot has fewer keys than its threshold of 1; it will not be usable until keys are added to it" --- PASS: TestPurgeDelegationsKeyFromDeep (0.00s) === RUN TestPurgeDelegationsKeyBadWildRole --- PASS: TestPurgeDelegationsKeyBadWildRole (0.00s) === RUN TestUpdateDelegationsParentMissing ---- PASS: TestUpdateDelegationsParentMissing (0.00s) +--- PASS: TestUpdateDelegationsParentMissing (0.01s) === RUN TestUpdateDelegationsMissingParentKey --- PASS: TestUpdateDelegationsMissingParentKey (0.00s) === RUN TestUpdateDelegationsInvalidRole @@ -3362,7 +3398,7 @@ === RUN TestUpdateDelegationsRoleThatIsMissingDelegationKey --- PASS: TestUpdateDelegationsRoleThatIsMissingDelegationKey (0.00s) === RUN TestUpdateDelegationsNotEnoughKeys -time="2024-01-06T11:06:10Z" 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-07T17:33:13Z" level=warning msg="role targets/role has fewer keys than its threshold of 2; it will not be usable until keys are added to it" --- PASS: TestUpdateDelegationsNotEnoughKeys (0.00s) === RUN TestUpdateDelegationsAddKeyToRole --- PASS: TestUpdateDelegationsAddKeyToRole (0.00s) @@ -3373,7 +3409,7 @@ === RUN TestDeleteDelegationsRoleNotExist --- PASS: TestDeleteDelegationsRoleNotExist (0.00s) === RUN TestDeleteDelegationsInvalidRole ---- PASS: TestDeleteDelegationsInvalidRole (0.00s) +--- PASS: TestDeleteDelegationsInvalidRole (0.01s) === RUN TestDeleteDelegationsParentMissing --- PASS: TestDeleteDelegationsParentMissing (0.00s) === RUN TestDeleteDelegationsMissingParentSigningKey @@ -3407,7 +3443,7 @@ === RUN TestRemoveBaseKeysFromRoot --- PASS: TestRemoveBaseKeysFromRoot (0.00s) === RUN TestReplaceBaseKeysInRoot ---- PASS: TestReplaceBaseKeysInRoot (0.00s) +--- PASS: TestReplaceBaseKeysInRoot (0.01s) === RUN TestGetAllRoles --- PASS: TestGetAllRoles (0.00s) === RUN TestGetBaseRoles @@ -3419,7 +3455,7 @@ === RUN TestGetDelegationRolesInvalidName --- PASS: TestGetDelegationRolesInvalidName (0.00s) === RUN TestGetDelegationRolesInvalidPaths ---- PASS: TestGetDelegationRolesInvalidPaths (0.00s) +--- PASS: TestGetDelegationRolesInvalidPaths (0.01s) === RUN TestDelegationRolesParent --- PASS: TestDelegationRolesParent (0.00s) === RUN TestGetBaseRoleEmptyRepo @@ -3429,41 +3465,41 @@ === RUN TestGetDelegationRoleKeyMissing --- PASS: TestGetDelegationRoleKeyMissing (0.00s) === RUN TestSignRootOldKeyCertExists ---- PASS: TestSignRootOldKeyCertExists (0.01s) +--- PASS: TestSignRootOldKeyCertExists (0.03s) === RUN TestSignRootOldKeyCertMissing ---- PASS: TestSignRootOldKeyCertMissing (0.01s) +--- PASS: TestSignRootOldKeyCertMissing (0.03s) === RUN TestRootKeyRotation ---- PASS: TestRootKeyRotation (0.03s) +--- PASS: TestRootKeyRotation (0.08s) === RUN TestBuilderLoadsValidRolesOnly ---- PASS: TestBuilderLoadsValidRolesOnly (0.00s) +--- PASS: TestBuilderLoadsValidRolesOnly (0.02s) === RUN TestBuilderOnlyAcceptsRootFirstWhenLoading --- PASS: TestBuilderOnlyAcceptsRootFirstWhenLoading (0.00s) === RUN TestBuilderOnlyAcceptsDelegationsAfterParent ---- PASS: TestBuilderOnlyAcceptsDelegationsAfterParent (0.00s) +--- PASS: TestBuilderOnlyAcceptsDelegationsAfterParent (0.02s) === RUN TestMarkingIsValid --- PASS: TestMarkingIsValid (0.00s) === RUN TestBuilderLoadInvalidDelegations ---- PASS: TestBuilderLoadInvalidDelegations (0.00s) +--- PASS: TestBuilderLoadInvalidDelegations (0.01s) === RUN TestBuilderLoadInvalidDelegationsOldVersion ---- PASS: TestBuilderLoadInvalidDelegationsOldVersion (0.00s) +--- PASS: TestBuilderLoadInvalidDelegationsOldVersion (0.02s) === RUN TestBuilderAcceptRoleOnce ---- PASS: TestBuilderAcceptRoleOnce (0.00s) +--- PASS: TestBuilderAcceptRoleOnce (0.01s) === RUN TestBuilderStopsAcceptingOrProducingDataOnceDone --- PASS: TestBuilderStopsAcceptingOrProducingDataOnceDone (0.00s) === RUN TestGenerateSnapshotInvalidOperations ---- PASS: TestGenerateSnapshotInvalidOperations (0.03s) +--- PASS: TestGenerateSnapshotInvalidOperations (0.08s) === RUN TestGenerateTimestampInvalidOperations ---- PASS: TestGenerateTimestampInvalidOperations (0.02s) +--- PASS: TestGenerateTimestampInvalidOperations (0.08s) === RUN TestGetConsistentInfo ---- PASS: TestGetConsistentInfo (0.00s) +--- PASS: TestGetConsistentInfo (0.02s) === RUN TestTimestampPreAndPostChecksumming ---- PASS: TestTimestampPreAndPostChecksumming (0.01s) +--- PASS: TestTimestampPreAndPostChecksumming (0.02s) === RUN TestSnapshotLoadedFirstChecksumsOthers ---- PASS: TestSnapshotLoadedFirstChecksumsOthers (0.01s) +--- PASS: TestSnapshotLoadedFirstChecksumsOthers (0.03s) === RUN TestSnapshotLoadedAfterChecksumsOthersRetroactively ---- PASS: TestSnapshotLoadedAfterChecksumsOthersRetroactively (0.01s) +--- PASS: TestSnapshotLoadedAfterChecksumsOthersRetroactively (0.04s) PASS -ok github.com/theupdateframework/notary/tuf 0.200s +ok github.com/theupdateframework/notary/tuf 0.669s === RUN TestMergeStrSlicesExclusive --- PASS: TestMergeStrSlicesExclusive (0.00s) === RUN TestMergeStrSlicesOverlap @@ -3513,7 +3549,7 @@ === RUN TestRootFromSignedValidatesRoleData --- PASS: TestRootFromSignedValidatesRoleData (0.00s) === RUN TestRootFromSignedValidatesRoleType ---- PASS: TestRootFromSignedValidatesRoleType (0.00s) +--- PASS: TestRootFromSignedValidatesRoleType (0.01s) === RUN TestRootFromSignedValidatesVersion --- PASS: TestRootFromSignedValidatesVersion (0.00s) === RUN TestSnapshotToSignedMarshalsSignedPortionWithCanonicalJSON @@ -3555,7 +3591,7 @@ === RUN TestTargetsFromSignedValidatesDelegations --- PASS: TestTargetsFromSignedValidatesDelegations (0.00s) === RUN TestTargetsFromSignedValidatesRoleType ---- PASS: TestTargetsFromSignedValidatesRoleType (0.01s) +--- PASS: TestTargetsFromSignedValidatesRoleType (0.00s) === RUN TestTargetsFromSignedValidatesRoleName --- PASS: TestTargetsFromSignedValidatesRoleName (0.00s) === RUN TestTargetsFromSignedValidatesVersion @@ -3597,9 +3633,9 @@ === RUN TestFileMetaEquals --- PASS: TestFileMetaEquals (0.00s) PASS -ok github.com/theupdateframework/notary/tuf/data 0.064s +ok github.com/theupdateframework/notary/tuf/data 0.069s === RUN TestListKeys ---- PASS: TestListKeys (0.00s) +--- PASS: TestListKeys (0.01s) === RUN TestGetKeys --- PASS: TestGetKeys (0.00s) === RUN TestBasicSign @@ -3611,7 +3647,7 @@ === RUN TestSignReturnsNoSigs --- PASS: TestSignReturnsNoSigs (0.00s) === RUN TestSignWithX509 ---- PASS: TestSignWithX509 (0.00s) +--- PASS: TestSignWithX509 (0.01s) === RUN TestSignRemovesValidSigByInvalidKey --- PASS: TestSignRemovesValidSigByInvalidKey (0.00s) === RUN TestSignRemovesInvalidSig @@ -3623,17 +3659,17 @@ === RUN TestErrInsufficientSignaturesMessaging --- PASS: TestErrInsufficientSignaturesMessaging (0.00s) === RUN TestRSAPSSVerifier ---- PASS: TestRSAPSSVerifier (0.00s) +--- PASS: TestRSAPSSVerifier (0.03s) === RUN TestRSAPSSx509Verifier --- PASS: TestRSAPSSx509Verifier (0.00s) === RUN TestRSAPSSVerifierWithInvalidKeyType --- PASS: TestRSAPSSVerifierWithInvalidKeyType (0.00s) === RUN TestRSAPSSVerifierWithInvalidKeyLength ---- PASS: TestRSAPSSVerifierWithInvalidKeyLength (0.02s) +--- PASS: TestRSAPSSVerifierWithInvalidKeyLength (0.10s) === RUN TestRSAPSSVerifierWithInvalidKey --- PASS: TestRSAPSSVerifierWithInvalidKey (0.00s) === RUN TestRSAPSSVerifierWithInvalidSignature ---- PASS: TestRSAPSSVerifierWithInvalidSignature (0.00s) +--- PASS: TestRSAPSSVerifierWithInvalidSignature (0.01s) === RUN TestRSAPKCS1v15Verifier --- PASS: TestRSAPKCS1v15Verifier (0.00s) === RUN TestRSAPKCS1v15x509Verifier @@ -3643,12 +3679,12 @@ === RUN TestRSAPKCS1v15VerifierWithInvalidKey --- PASS: TestRSAPKCS1v15VerifierWithInvalidKey (0.00s) === RUN TestRSAPKCS1v15VerifierWithInvalidSignature -time="2024-01-06T11:06:11Z" level=error msg="Failed verification: crypto/rsa: verification error" ---- PASS: TestRSAPKCS1v15VerifierWithInvalidSignature (0.00s) +time="2025-02-07T17:33:16Z" level=error msg="Failed verification: crypto/rsa: verification error" +--- PASS: TestRSAPKCS1v15VerifierWithInvalidSignature (0.01s) === RUN TestECDSAVerifier --- PASS: TestECDSAVerifier (0.00s) === RUN TestECDSAVerifierOtherCurves ---- PASS: TestECDSAVerifierOtherCurves (0.04s) +--- PASS: TestECDSAVerifierOtherCurves (0.06s) === RUN TestECDSAx509Verifier --- PASS: TestECDSAx509Verifier (0.00s) === RUN TestECDSAVerifierWithInvalidKeyType @@ -3686,70 +3722,70 @@ === RUN TestVerifyVersion --- PASS: TestVerifyVersion (0.00s) === RUN TestVerifyExpiry -time="2024-01-06T11:06:11Z" level=error msg="Metadata for root expired" +time="2025-02-07T17:33:16Z" level=error msg="Metadata for root expired" --- PASS: TestVerifyExpiry (0.00s) === RUN TestVerifyPublicKeyMatchesPrivateKeyHappyCase --- PASS: TestVerifyPublicKeyMatchesPrivateKeyHappyCase (0.00s) === RUN TestVerifyPublicKeyMatchesPrivateKeyFails --- PASS: TestVerifyPublicKeyMatchesPrivateKeyFails (0.00s) PASS -ok github.com/theupdateframework/notary/tuf/signed 0.127s +ok github.com/theupdateframework/notary/tuf/signed 0.302s === RUN TestNewSwizzler ---- PASS: TestNewSwizzler (0.01s) +--- PASS: TestNewSwizzler (0.03s) === RUN TestSwizzlerSetInvalidJSON ---- PASS: TestSwizzlerSetInvalidJSON (0.00s) +--- PASS: TestSwizzlerSetInvalidJSON (0.02s) === RUN TestSwizzlerAddExtraSpace ---- PASS: TestSwizzlerAddExtraSpace (0.00s) +--- PASS: TestSwizzlerAddExtraSpace (0.02s) === RUN TestSwizzlerSetInvalidSigned ---- PASS: TestSwizzlerSetInvalidSigned (0.00s) +--- PASS: TestSwizzlerSetInvalidSigned (0.02s) === RUN TestSwizzlerSetInvalidSignedMeta ---- PASS: TestSwizzlerSetInvalidSignedMeta (0.01s) +--- PASS: TestSwizzlerSetInvalidSignedMeta (0.03s) === RUN TestSwizzlerSetInvalidMetadataType ---- PASS: TestSwizzlerSetInvalidMetadataType (0.00s) +--- PASS: TestSwizzlerSetInvalidMetadataType (0.02s) === RUN TestSwizzlerInvalidateMetadataSignatures ---- PASS: TestSwizzlerInvalidateMetadataSignatures (0.00s) +--- PASS: TestSwizzlerInvalidateMetadataSignatures (0.02s) === RUN TestSwizzlerRemoveMetadata ---- PASS: TestSwizzlerRemoveMetadata (0.00s) +--- PASS: TestSwizzlerRemoveMetadata (0.02s) === RUN TestSwizzlerSignMetadataWithInvalidKey ---- PASS: TestSwizzlerSignMetadataWithInvalidKey (0.00s) +--- PASS: TestSwizzlerSignMetadataWithInvalidKey (0.02s) === RUN TestSwizzlerOffsetMetadataVersion ---- PASS: TestSwizzlerOffsetMetadataVersion (0.02s) +--- PASS: TestSwizzlerOffsetMetadataVersion (0.01s) === RUN TestSwizzlerExpireMetadata --- PASS: TestSwizzlerExpireMetadata (0.01s) === RUN TestSwizzlerSetThresholdBaseRole ---- PASS: TestSwizzlerSetThresholdBaseRole (0.00s) +--- PASS: TestSwizzlerSetThresholdBaseRole (0.02s) === RUN TestSwizzlerSetThresholdDelegatedRole ---- PASS: TestSwizzlerSetThresholdDelegatedRole (0.00s) +--- PASS: TestSwizzlerSetThresholdDelegatedRole (0.01s) === RUN TestSwizzlerChangeRootKey --- PASS: TestSwizzlerChangeRootKey (0.01s) === RUN TestSwizzlerUpdateSnapshotHashesSpecifiedRoles ---- PASS: TestSwizzlerUpdateSnapshotHashesSpecifiedRoles (0.00s) +--- PASS: TestSwizzlerUpdateSnapshotHashesSpecifiedRoles (0.01s) === RUN TestSwizzlerUpdateSnapshotHashesNoSpecifiedRoles --- PASS: TestSwizzlerUpdateSnapshotHashesNoSpecifiedRoles (0.00s) === RUN TestSwizzlerUpdateTimestamp ---- PASS: TestSwizzlerUpdateTimestamp (0.00s) +--- PASS: TestSwizzlerUpdateTimestamp (0.01s) === RUN TestMissingSigningKey --- PASS: TestMissingSigningKey (0.00s) === RUN TestSwizzlerMutateRoot --- PASS: TestSwizzlerMutateRoot (0.01s) === RUN TestSwizzlerMutateTimestamp ---- PASS: TestSwizzlerMutateTimestamp (0.00s) +--- PASS: TestSwizzlerMutateTimestamp (0.01s) === RUN TestSwizzlerMutateSnapshot ---- PASS: TestSwizzlerMutateSnapshot (0.00s) +--- PASS: TestSwizzlerMutateSnapshot (0.01s) === RUN TestSwizzlerMutateTargets ---- PASS: TestSwizzlerMutateTargets (0.00s) +--- PASS: TestSwizzlerMutateTargets (0.01s) === RUN TestSwizzlerRotateKeyBaseRole ---- PASS: TestSwizzlerRotateKeyBaseRole (0.01s) +--- PASS: TestSwizzlerRotateKeyBaseRole (0.02s) === RUN TestSwizzlerRotateKeyDelegationRole ---- PASS: TestSwizzlerRotateKeyDelegationRole (0.00s) +--- PASS: TestSwizzlerRotateKeyDelegationRole (0.02s) PASS -ok github.com/theupdateframework/notary/tuf/testutils 0.149s +ok github.com/theupdateframework/notary/tuf/testutils 0.449s ? github.com/theupdateframework/notary/tuf/testutils/interfaces [no test files] ? github.com/theupdateframework/notary/tuf/testutils/keys [no test files] === RUN TestConvertTUFKeyToPKCS8 --- PASS: TestConvertTUFKeyToPKCS8 (0.03s) === RUN TestParsePKCS8ToTufKey ---- PASS: TestParsePKCS8ToTufKey (0.06s) +--- PASS: TestParsePKCS8ToTufKey (0.11s) === RUN TestPEMtoPEM --- PASS: TestPEMtoPEM (0.00s) === RUN TestRoleListLen @@ -3795,7 +3831,7 @@ === RUN TestNewCertificate --- PASS: TestNewCertificate (0.00s) === RUN TestKeyOperations ---- PASS: TestKeyOperations (0.01s) +--- PASS: TestKeyOperations (0.03s) === RUN TestRSAX509PublickeyID --- PASS: TestRSAX509PublickeyID (0.00s) === RUN TestECDSAX509PublickeyID @@ -3811,9 +3847,9 @@ === RUN TestValidateCertificateWithInvalidExpiry --- PASS: TestValidateCertificateWithInvalidExpiry (0.00s) === RUN TestValidateCertificateWithShortKey ---- PASS: TestValidateCertificateWithShortKey (0.03s) +--- PASS: TestValidateCertificateWithShortKey (0.05s) PASS -ok github.com/theupdateframework/notary/tuf/utils 0.144s +ok github.com/theupdateframework/notary/tuf/utils 0.303s === RUN TestNewSerializableErrorNonValidationError --- PASS: TestNewSerializableErrorNonValidationError (0.00s) === RUN TestNewSerializableErrorValidationError @@ -3829,7 +3865,7 @@ === RUN TestUnmarshalInvalidJSON --- PASS: TestUnmarshalInvalidJSON (0.00s) PASS -ok github.com/theupdateframework/notary/tuf/validation 0.008s +ok github.com/theupdateframework/notary/tuf/validation 0.049s === RUN TestSetSignalTrap --- PASS: TestSetSignalTrap (0.00s) === RUN TestLogLevelSignalHandle @@ -3903,7 +3939,7 @@ === RUN TestAdjustLogLevel --- PASS: TestAdjustLogLevel (0.00s) === RUN TestRootHandlerFactory ---- PASS: TestRootHandlerFactory (0.00s) +--- PASS: TestRootHandlerFactory (0.01s) === RUN TestRootHandlerError --- PASS: TestRootHandlerError (0.00s) === RUN TestWrapWithCacheHeaderNilCacheControlConfig @@ -3929,7 +3965,7 @@ === RUN TestDoAuthWildcardImage --- PASS: TestDoAuthWildcardImage (0.00s) PASS -ok github.com/theupdateframework/notary/utils 0.027s +ok github.com/theupdateframework/notary/utils 0.067s ? 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 @@ -3967,9 +4003,9 @@ dpkg-gencontrol: warning: package notary: substitution variable ${misc:Static-Built-Using} unused, but is defined dh_md5sums -O--builddirectory=/build/reproducible-path/notary-0.7.0\+ds1/_build -O--buildsystem=golang dh_builddeb -O--builddirectory=/build/reproducible-path/notary-0.7.0\+ds1/_build -O--buildsystem=golang +dpkg-deb: building package 'golang-github-docker-notary-dev' in '../golang-github-docker-notary-dev_0.7.0+ds1-2_all.deb'. dpkg-deb: building package 'notary' in '../notary_0.7.0+ds1-2_arm64.deb'. dpkg-deb: building package 'notary-dbgsym' in '../notary-dbgsym_0.7.0+ds1-2_arm64.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_arm64.buildinfo dpkg-genchanges --build=binary -O../notary_0.7.0+ds1-2_arm64.changes dpkg-genchanges: info: binary-only upload (no source code included) @@ -3977,12 +4013,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/2477182/tmp/hooks/B01_cleanup starting +I: user script /srv/workspace/pbuilder/2477182/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/1554838 and its subdirectories -I: Current time: Fri Jan 5 23:07:12 -12 2024 -I: pbuilder-time-stamp: 1704539232 +I: removing directory /srv/workspace/pbuilder/2477182 and its subdirectories +I: Current time: Sat Feb 8 07:34:52 +14 2025 +I: pbuilder-time-stamp: 1738949692