Build log for notary (0.0~git20150801.0.8e8122e-2) on armhf

notary → 0.0~git20150801.0.8e8122e-2 → armhf → 2016-01-17 22:07:37

sbuild (Debian sbuild) 0.65.2 (24 Mar 2015) on testbuildd.raspbian.org

╔══════════════════════════════════════════════════════════════════════════════╗
║ notary 0.0~git20150801.0.8e8122e-2 (armhf)                 17 Jan 2016 21:45 ║
╚══════════════════════════════════════════════════════════════════════════════╝

Package: notary
Version: 0.0~git20150801.0.8e8122e-2
Source Version: 0.0~git20150801.0.8e8122e-2
Distribution: stretch-staging
Machine Architecture: armhf
Host Architecture: armhf
Build Architecture: armhf

I: NOTICE: Log filtering will replace 'build/notary-bETihD/notary-0.0~git20150801.0.8e8122e' with '«PKGBUILDDIR»'
I: NOTICE: Log filtering will replace 'build/notary-bETihD' with '«BUILDDIR»'
I: NOTICE: Log filtering will replace 'var/lib/schroot/mount/stretch-staging-armhf-sbuild-e0585702-aa27-4115-b958-49d378699a22' with '«CHROOT»'

┌──────────────────────────────────────────────────────────────────────────────┐
│ Update chroot                                                                │
└──────────────────────────────────────────────────────────────────────────────┘

Get:1 http://172.17.0.1/private stretch-staging InRelease [11.3 kB]
Get:2 http://172.17.0.1/private stretch-staging/main Sources [8620 kB]
Get:3 http://172.17.0.1/private stretch-staging/main armhf Packages [10.7 MB]
Fetched 19.3 MB in 22s (840 kB/s)
Reading package lists...
W: No sandbox user '_apt' on the system, can not drop privileges

┌──────────────────────────────────────────────────────────────────────────────┐
│ Fetch source files                                                           │
└──────────────────────────────────────────────────────────────────────────────┘


Check APT
─────────

Checking available source versions...

Download source files with APT
──────────────────────────────

Reading package lists...
Building dependency tree...
Reading state information...
NOTICE: 'notary' packaging is maintained in the 'Git' version control system at:
git://anonscm.debian.org/pkg-go/packages/golang-github-docker-notary.git
Please use:
git clone git://anonscm.debian.org/pkg-go/packages/golang-github-docker-notary.git
to retrieve the latest (possibly unreleased) updates to the package.
Need to get 110 kB of source archives.
Get:1 http://172.17.0.1/private stretch-staging/main notary 0.0~git20150801.0.8e8122e-2 (dsc) [2971 B]
Get:2 http://172.17.0.1/private stretch-staging/main notary 0.0~git20150801.0.8e8122e-2 (tar) [98.0 kB]
Get:3 http://172.17.0.1/private stretch-staging/main notary 0.0~git20150801.0.8e8122e-2 (diff) [9416 B]
Fetched 110 kB in 0s (831 kB/s)
Download complete and in download only mode

Check architectures
───────────────────


Check dependencies
──────────────────

Merged Build-Depends: build-essential, fakeroot
Filtered Build-Depends: build-essential, fakeroot
dpkg-deb: building package 'sbuild-build-depends-core-dummy' in '/«BUILDDIR»/resolver-C9meKZ/apt_archive/sbuild-build-depends-core-dummy.deb'.
OK
Get:1 file:/«BUILDDIR»/resolver-C9meKZ/apt_archive ./ InRelease
Ign:1 file:/«BUILDDIR»/resolver-C9meKZ/apt_archive ./ InRelease
Get:2 file:/«BUILDDIR»/resolver-C9meKZ/apt_archive ./ Release [2119 B]
Get:2 file:/«BUILDDIR»/resolver-C9meKZ/apt_archive ./ Release [2119 B]
Get:3 file:/«BUILDDIR»/resolver-C9meKZ/apt_archive ./ Release.gpg [299 B]
Get:3 file:/«BUILDDIR»/resolver-C9meKZ/apt_archive ./ Release.gpg [299 B]
Get:4 file:/«BUILDDIR»/resolver-C9meKZ/apt_archive ./ Sources [208 B]
Get:5 file:/«BUILDDIR»/resolver-C9meKZ/apt_archive ./ Packages [524 B]
Reading package lists...
W: No sandbox user '_apt' on the system, can not drop privileges
Reading package lists...

┌──────────────────────────────────────────────────────────────────────────────┐
│ Install core build dependencies (apt-based resolver)                         │
└──────────────────────────────────────────────────────────────────────────────┘

Installing build dependencies
Reading package lists...
Building dependency tree...
Reading state information...
The following NEW packages will be installed:
  sbuild-build-depends-core-dummy
0 upgraded, 1 newly installed, 0 to remove and 16 not upgraded.
Need to get 0 B/764 B of archives.
After this operation, 0 B of additional disk space will be used.
Get:1 file:/«BUILDDIR»/resolver-C9meKZ/apt_archive ./ sbuild-build-depends-core-dummy 0.invalid.0 [764 B]
debconf: delaying package configuration, since apt-utils is not installed
Selecting previously unselected package sbuild-build-depends-core-dummy.
(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 ... 12751 files and directories currently installed.)
Preparing to unpack .../sbuild-build-depends-core-dummy.deb ...
Unpacking sbuild-build-depends-core-dummy (0.invalid.0) ...
Setting up sbuild-build-depends-core-dummy (0.invalid.0) ...
W: No sandbox user '_apt' on the system, can not drop privileges
Merged Build-Depends: libc6-dev | libc-dev, gcc (>= 4:4.9.1), g++ (>= 4:4.9.1), make, dpkg-dev (>= 1.17.11), debhelper (>= 9), dh-golang, golang-docker-dev | golang-github-docker-docker-dev, golang-ed25519-dev | golang-github-agl-ed25519-dev, golang-github-data-dog-go-sqlmock-dev, golang-github-docker-distribution-dev, golang-github-dvsekhvalnov-jose2go-dev, golang-github-endophage-gotuf-dev, golang-github-go-sql-driver-mysql-dev, golang-github-gorilla-mux-dev, golang-github-jinzhu-gorm-dev, golang-github-mattn-go-sqlite3-dev, golang-github-miekg-pkcs11-dev, golang-github-sirupsen-logrus-dev | golang-logrus-dev, golang-github-spf13-cobra-dev, golang-github-spf13-viper-dev, golang-github-stretchr-testify-dev | golang-testify-dev, golang-github-tent-canonical-json-go-dev, golang-go, golang-golang-x-net-dev, golang-google-grpc-dev, golang-goprotobuf-dev | golang-github-golang-protobuf-dev
Filtered Build-Depends: libc6-dev, gcc (>= 4:4.9.1), g++ (>= 4:4.9.1), make, dpkg-dev (>= 1.17.11), debhelper (>= 9), dh-golang, golang-docker-dev, golang-ed25519-dev, golang-github-data-dog-go-sqlmock-dev, golang-github-docker-distribution-dev, golang-github-dvsekhvalnov-jose2go-dev, golang-github-endophage-gotuf-dev, golang-github-go-sql-driver-mysql-dev, golang-github-gorilla-mux-dev, golang-github-jinzhu-gorm-dev, golang-github-mattn-go-sqlite3-dev, golang-github-miekg-pkcs11-dev, golang-github-sirupsen-logrus-dev, golang-github-spf13-cobra-dev, golang-github-spf13-viper-dev, golang-github-stretchr-testify-dev, golang-github-tent-canonical-json-go-dev, golang-go, golang-golang-x-net-dev, golang-google-grpc-dev, golang-goprotobuf-dev
dpkg-deb: building package 'sbuild-build-depends-notary-dummy' in '/«BUILDDIR»/resolver-B7VrdK/apt_archive/sbuild-build-depends-notary-dummy.deb'.
OK
Get:1 file:/«BUILDDIR»/resolver-B7VrdK/apt_archive ./ InRelease
Ign:1 file:/«BUILDDIR»/resolver-B7VrdK/apt_archive ./ InRelease
Get:2 file:/«BUILDDIR»/resolver-B7VrdK/apt_archive ./ Release [2119 B]
Get:2 file:/«BUILDDIR»/resolver-B7VrdK/apt_archive ./ Release [2119 B]
Get:3 file:/«BUILDDIR»/resolver-B7VrdK/apt_archive ./ Release.gpg [299 B]
Get:3 file:/«BUILDDIR»/resolver-B7VrdK/apt_archive ./ Release.gpg [299 B]
Get:4 file:/«BUILDDIR»/resolver-B7VrdK/apt_archive ./ Sources [556 B]
Get:5 file:/«BUILDDIR»/resolver-B7VrdK/apt_archive ./ Packages [789 B]
Reading package lists...
W: No sandbox user '_apt' on the system, can not drop privileges
Reading package lists...

┌──────────────────────────────────────────────────────────────────────────────┐
│ Install notary build dependencies (apt-based resolver)                       │
└──────────────────────────────────────────────────────────────────────────────┘

Installing build dependencies
Reading package lists...
Building dependency tree...
Reading state information...
The following additional packages will be installed:
  bsdmainutils debhelper dh-golang dh-strip-nondeterminism file gettext
  gettext-base golang-check.v1-dev golang-context-dev golang-docker-dev
  golang-ed25519-dev golang-etcd-dev golang-github-adroll-goamz-dev
  golang-github-armon-consul-api-dev golang-github-azure-azure-sdk-for-go-dev
  golang-github-azure-go-autorest-dev golang-github-azure-go-pkcs12-dev
  golang-github-bradfitz-http2-dev golang-github-cpuguy83-go-md2man-dev
  golang-github-data-dog-go-sqlmock-dev golang-github-docker-distribution-dev
  golang-github-docker-docker-dev golang-github-docker-libtrust-dev
  golang-github-dvsekhvalnov-jose2go-dev golang-github-endophage-gotuf-dev
  golang-github-garyburd-redigo-dev golang-github-go-fsnotify-fsnotify-dev
  golang-github-go-sql-driver-mysql-dev golang-github-google-gofuzz-dev
  golang-github-gorilla-handlers-dev golang-github-gorilla-mux-dev
  golang-github-hashicorp-hcl-dev golang-github-jfrazelle-go-dev
  golang-github-jinzhu-gorm-dev golang-github-lib-pq-dev
  golang-github-magiconair-properties-dev golang-github-mattn-go-sqlite3-dev
  golang-github-miekg-pkcs11-dev golang-github-mitchellh-mapstructure-dev
  golang-github-ncw-swift-dev golang-github-qor-inflection-dev
  golang-github-russross-blackfriday-dev
  golang-github-shurcool-sanitized-anchor-name-dev
  golang-github-sirupsen-logrus-dev golang-github-spf13-cast-dev
  golang-github-spf13-cobra-dev golang-github-spf13-jwalterweatherman-dev
  golang-github-spf13-pflag-dev golang-github-spf13-viper-dev
  golang-github-stevvooe-resumable-dev golang-github-stretchr-testify-dev
  golang-github-tent-canonical-json-go-dev golang-github-ugorji-go-codec-dev
  golang-github-xordataexchange-crypt-dev golang-glog-dev golang-go
  golang-go.crypto-dev golang-go.net-dev golang-golang-x-crypto-dev
  golang-golang-x-net-dev golang-golang-x-oauth2-dev
  golang-google-appengine-dev golang-google-cloud-compute-metadata-dev
  golang-google-grpc-dev golang-goprotobuf-dev golang-objx-dev golang-pq-dev
  golang-pretty-dev golang-src golang-text-dev golang-toml-dev
  golang-x-text-dev golang-yaml.v2-dev groff-base intltool-debian
  libarchive-zip-perl libcroco3 libffi6 libfile-stripnondeterminism-perl
  libglib2.0-0 libicu55 libltdl-dev libltdl7 libmagic1 libnspr4 libnspr4-dev
  libnss3 libnss3-dev libpipeline1 libprotobuf9v5 libprotoc9v5 libsqlite3-0
  libsqlite3-dev libtimedate-perl libunistring0 libxml2 man-db pkg-config
  po-debconf protobuf-compiler
Suggested packages:
  wamerican | wordlist whois vacation dh-make gettext-doc autopoint
  libasprintf-dev libgettextpo-dev golang-github-xordataexchange-crypt bzr
  ca-certificates git golang-golang-x-tools mercurial subversion groff
  libtool-doc sqlite3-doc less www-browser libmail-box-perl
Recommended packages:
  curl | wget | lynx-cur libglib2.0-data shared-mime-info xdg-user-dirs
  libtool xml-core libmail-sendmail-perl
The following NEW packages will be installed:
  bsdmainutils debhelper dh-golang dh-strip-nondeterminism file gettext
  gettext-base golang-check.v1-dev golang-context-dev golang-docker-dev
  golang-ed25519-dev golang-etcd-dev golang-github-adroll-goamz-dev
  golang-github-armon-consul-api-dev golang-github-azure-azure-sdk-for-go-dev
  golang-github-azure-go-autorest-dev golang-github-azure-go-pkcs12-dev
  golang-github-bradfitz-http2-dev golang-github-cpuguy83-go-md2man-dev
  golang-github-data-dog-go-sqlmock-dev golang-github-docker-distribution-dev
  golang-github-docker-docker-dev golang-github-docker-libtrust-dev
  golang-github-dvsekhvalnov-jose2go-dev golang-github-endophage-gotuf-dev
  golang-github-garyburd-redigo-dev golang-github-go-fsnotify-fsnotify-dev
  golang-github-go-sql-driver-mysql-dev golang-github-google-gofuzz-dev
  golang-github-gorilla-handlers-dev golang-github-gorilla-mux-dev
  golang-github-hashicorp-hcl-dev golang-github-jfrazelle-go-dev
  golang-github-jinzhu-gorm-dev golang-github-lib-pq-dev
  golang-github-magiconair-properties-dev golang-github-mattn-go-sqlite3-dev
  golang-github-miekg-pkcs11-dev golang-github-mitchellh-mapstructure-dev
  golang-github-ncw-swift-dev golang-github-qor-inflection-dev
  golang-github-russross-blackfriday-dev
  golang-github-shurcool-sanitized-anchor-name-dev
  golang-github-sirupsen-logrus-dev golang-github-spf13-cast-dev
  golang-github-spf13-cobra-dev golang-github-spf13-jwalterweatherman-dev
  golang-github-spf13-pflag-dev golang-github-spf13-viper-dev
  golang-github-stevvooe-resumable-dev golang-github-stretchr-testify-dev
  golang-github-tent-canonical-json-go-dev golang-github-ugorji-go-codec-dev
  golang-github-xordataexchange-crypt-dev golang-glog-dev golang-go
  golang-go.crypto-dev golang-go.net-dev golang-golang-x-crypto-dev
  golang-golang-x-net-dev golang-golang-x-oauth2-dev
  golang-google-appengine-dev golang-google-cloud-compute-metadata-dev
  golang-google-grpc-dev golang-goprotobuf-dev golang-objx-dev golang-pq-dev
  golang-pretty-dev golang-src golang-text-dev golang-toml-dev
  golang-x-text-dev golang-yaml.v2-dev groff-base intltool-debian
  libarchive-zip-perl libcroco3 libffi6 libfile-stripnondeterminism-perl
  libglib2.0-0 libicu55 libltdl-dev libltdl7 libmagic1 libnspr4 libnspr4-dev
  libnss3 libnss3-dev libpipeline1 libprotobuf9v5 libprotoc9v5 libsqlite3-0
  libsqlite3-dev libtimedate-perl libunistring0 libxml2 man-db pkg-config
  po-debconf protobuf-compiler sbuild-build-depends-notary-dummy
0 upgraded, 101 newly installed, 0 to remove and 16 not upgraded.
Need to get 52.7 MB/52.8 MB of archives.
After this operation, 290 MB of additional disk space will be used.
Get:1 file:/«BUILDDIR»/resolver-B7VrdK/apt_archive ./ sbuild-build-depends-notary-dummy 0.invalid.0 [1030 B]
Get:2 http://172.17.0.1/private stretch-staging/main armhf groff-base armhf 1.22.3-5 [1083 kB]
Get:3 http://172.17.0.1/private stretch-staging/main armhf bsdmainutils armhf 9.0.6 [177 kB]
Get:4 http://172.17.0.1/private stretch-staging/main armhf libpipeline1 armhf 1.4.1-2 [23.7 kB]
Get:5 http://172.17.0.1/private stretch-staging/main armhf man-db armhf 2.7.5-1 [975 kB]
Get:6 http://172.17.0.1/private stretch-staging/main armhf libltdl7 armhf 2.4.2-1.11 [42.5 kB]
Get:7 http://172.17.0.1/private stretch-staging/main armhf libunistring0 armhf 0.9.3-5.2 [253 kB]
Get:8 http://172.17.0.1/private stretch-staging/main armhf libmagic1 armhf 1:5.25-2 [250 kB]
Get:9 http://172.17.0.1/private stretch-staging/main armhf file armhf 1:5.25-2 [61.2 kB]
Get:10 http://172.17.0.1/private stretch-staging/main armhf gettext-base armhf 0.19.7-2 [111 kB]
Get:11 http://172.17.0.1/private stretch-staging/main armhf libsqlite3-0 armhf 3.9.2-1 [404 kB]
Get:12 http://172.17.0.1/private stretch-staging/main armhf libicu55 armhf 55.1-7 [7380 kB]
Get:13 http://172.17.0.1/private stretch-staging/main armhf libxml2 armhf 2.9.3+dfsg1-1 [800 kB]
Get:14 http://172.17.0.1/private stretch-staging/main armhf libffi6 armhf 3.2.1-4 [18.5 kB]
Get:15 http://172.17.0.1/private stretch-staging/main armhf libglib2.0-0 armhf 2.46.2-3 [2482 kB]
Get:16 http://172.17.0.1/private stretch-staging/main armhf libcroco3 armhf 0.6.11-1 [131 kB]
Get:17 http://172.17.0.1/private stretch-staging/main armhf gettext armhf 0.19.7-2 [1400 kB]
Get:18 http://172.17.0.1/private stretch-staging/main armhf intltool-debian all 0.35.0+20060710.4 [26.3 kB]
Get:19 http://172.17.0.1/private stretch-staging/main armhf po-debconf all 1.0.18 [248 kB]
Get:20 http://172.17.0.1/private stretch-staging/main armhf libarchive-zip-perl all 1.56-2 [94.9 kB]
Get:21 http://172.17.0.1/private stretch-staging/main armhf libfile-stripnondeterminism-perl all 0.014-1 [10.6 kB]
Get:22 http://172.17.0.1/private stretch-staging/main armhf libtimedate-perl all 2.3000-2 [42.2 kB]
Get:23 http://172.17.0.1/private stretch-staging/main armhf dh-strip-nondeterminism all 0.014-1 [7472 B]
Get:24 http://172.17.0.1/private stretch-staging/main armhf debhelper all 9.20151225 [830 kB]
Get:25 http://172.17.0.1/private stretch-staging/main armhf golang-github-docker-docker-dev all 1.8.3~ds1-2 [223 kB]
Get:26 http://172.17.0.1/private stretch-staging/main armhf golang-docker-dev all 1.8.3~ds1-2 [32.2 kB]
Get:27 http://172.17.0.1/private stretch-staging/main armhf golang-src armhf 2:1.5.1-4 [6418 kB]
Get:28 http://172.17.0.1/private stretch-staging/main armhf golang-go armhf 2:1.5.1-4 [20.2 MB]
Get:29 http://172.17.0.1/private stretch-staging/main armhf libltdl-dev armhf 2.4.2-1.11 [155 kB]
Get:30 http://172.17.0.1/private stretch-staging/main armhf libnspr4 armhf 2:4.11-1 [94.6 kB]
Get:31 http://172.17.0.1/private stretch-staging/main armhf libnspr4-dev armhf 2:4.11-1 [197 kB]
Get:32 http://172.17.0.1/private stretch-staging/main armhf libnss3 armhf 2:3.21-1 [928 kB]
Get:33 http://172.17.0.1/private stretch-staging/main armhf libnss3-dev armhf 2:3.21-1 [223 kB]
Get:34 http://172.17.0.1/private stretch-staging/main armhf libprotobuf9v5 armhf 2.6.1-1.3 [292 kB]
Get:35 http://172.17.0.1/private stretch-staging/main armhf libprotoc9v5 armhf 2.6.1-1.3 [241 kB]
Get:36 http://172.17.0.1/private stretch-staging/main armhf libsqlite3-dev armhf 3.9.2-1 [525 kB]
Get:37 http://172.17.0.1/private stretch-staging/main armhf pkg-config armhf 0.29-2 [58.8 kB]
Get:38 http://172.17.0.1/private stretch-staging/main armhf protobuf-compiler armhf 2.6.1-1.3 [35.8 kB]
Get:39 http://172.17.0.1/private stretch-staging/main armhf dh-golang all 1.12 [9402 B]
Get:40 http://172.17.0.1/private stretch-staging/main armhf golang-check.v1-dev all 0.0+git20150729.11d3bc7-2 [29.0 kB]
Get:41 http://172.17.0.1/private stretch-staging/main armhf golang-context-dev all 0.0~git20140604.1.14f550f-1 [6280 B]
Get:42 http://172.17.0.1/private stretch-staging/main armhf golang-ed25519-dev all 0~20140907.d2b94fd-2 [98.8 kB]
Get:43 http://172.17.0.1/private stretch-staging/main armhf golang-etcd-dev all 2.0.0-1 [16.6 kB]
Get:44 http://172.17.0.1/private stretch-staging/main armhf golang-github-adroll-goamz-dev all 0.0~git20150909.0.74fd457-2 [185 kB]
Get:45 http://172.17.0.1/private stretch-staging/main armhf golang-github-armon-consul-api-dev all 0.0~git20150107.0.dcfedd5-1 [17.8 kB]
Get:46 http://172.17.0.1/private stretch-staging/main armhf golang-github-azure-go-autorest-dev all 0.1~alpha-2 [21.8 kB]
Get:47 http://172.17.0.1/private stretch-staging/main armhf golang-github-azure-go-pkcs12-dev all 0.0~git20150623.0.a635c06-1 [18.4 kB]
Get:48 http://172.17.0.1/private stretch-staging/main armhf golang-github-azure-azure-sdk-for-go-dev all 1.2~git20150611.0.97d9593-2 [274 kB]
Get:49 http://172.17.0.1/private stretch-staging/main armhf golang-golang-x-crypto-dev all 1:0.0~git20151201.0.7b85b09-2 [802 kB]
Get:50 http://172.17.0.1/private stretch-staging/main armhf golang-go.crypto-dev all 1:0.0~git20151201.0.7b85b09-2 [2640 B]
Get:51 http://172.17.0.1/private stretch-staging/main armhf golang-github-bradfitz-http2-dev all 0.0~git20150509-1 [111 kB]
Get:52 http://172.17.0.1/private stretch-staging/main armhf golang-github-shurcool-sanitized-anchor-name-dev all 0.0~git20151028.0.10ef21a-1 [3064 B]
Get:53 http://172.17.0.1/private stretch-staging/main armhf golang-github-russross-blackfriday-dev all 1.4-1 [59.8 kB]
Get:54 http://172.17.0.1/private stretch-staging/main armhf golang-github-cpuguy83-go-md2man-dev all 1.0.4-3 [4610 B]
Get:55 http://172.17.0.1/private stretch-staging/main armhf golang-github-data-dog-go-sqlmock-dev all 1.0.0-1 [15.7 kB]
Get:56 http://172.17.0.1/private stretch-staging/main armhf golang-github-docker-libtrust-dev all 0.0~git20150526.0.9cbd2a1-1 [30.6 kB]
Get:57 http://172.17.0.1/private stretch-staging/main armhf golang-github-garyburd-redigo-dev all 0.0~git20150901.0.d8dbe4d-1 [27.8 kB]
Get:58 http://172.17.0.1/private stretch-staging/main armhf golang-github-gorilla-handlers-dev all 0.0~git20150820.0.40694b4-1 [12.1 kB]
Get:59 http://172.17.0.1/private stretch-staging/main armhf golang-github-gorilla-mux-dev all 0.0~git20150814.0.f7b6aaa-1 [25.0 kB]
Get:60 http://172.17.0.1/private stretch-staging/main armhf golang-github-mitchellh-mapstructure-dev all 0.0~git20150717.0.281073e-1 [14.2 kB]
Get:61 http://172.17.0.1/private stretch-staging/main armhf golang-github-ncw-swift-dev all 0.0~git20150901.0.ca8cbbd-1 [36.9 kB]
Get:62 http://172.17.0.1/private stretch-staging/main armhf golang-github-sirupsen-logrus-dev all 0.8.7-2 [25.1 kB]
Get:63 http://172.17.0.1/private stretch-staging/main armhf golang-github-stevvooe-resumable-dev all 0.0~git20150521.0.51ad441-1 [19.1 kB]
Get:64 http://172.17.0.1/private stretch-staging/main armhf golang-x-text-dev all 0+git20150518.c93e7c9-1 [1968 kB]
Get:65 http://172.17.0.1/private stretch-staging/main armhf golang-golang-x-net-dev all 1:0.0+git20150817.66f0418-1 [417 kB]
Get:66 http://172.17.0.1/private stretch-staging/main armhf golang-yaml.v2-dev all 0.0+git20150627.7ad95dd-1 [51.9 kB]
Get:67 http://172.17.0.1/private stretch-staging/main armhf golang-github-docker-distribution-dev all 2.1.1~ds1-4 [191 kB]
Get:68 http://172.17.0.1/private stretch-staging/main armhf golang-github-dvsekhvalnov-jose2go-dev all 1.2-1 [58.2 kB]
Get:69 http://172.17.0.1/private stretch-staging/main armhf golang-github-google-gofuzz-dev all 0.0~git20150903.0.e4af62d-1 [8206 B]
Get:70 http://172.17.0.1/private stretch-staging/main armhf golang-github-jfrazelle-go-dev all 0.0~git20150906.0.a8e3e21-1 [39.7 kB]
Get:71 http://172.17.0.1/private stretch-staging/main armhf golang-github-mattn-go-sqlite3-dev all 1.1.0~dfsg1-1 [24.8 kB]
Get:72 http://172.17.0.1/private stretch-staging/main armhf golang-objx-dev all 0.0~git20140527-4 [20.1 kB]
Get:73 http://172.17.0.1/private stretch-staging/main armhf golang-github-stretchr-testify-dev all 1.0-2 [27.8 kB]
Get:74 http://172.17.0.1/private stretch-staging/main armhf golang-github-endophage-gotuf-dev all 0.0~git20151020.0.2df1c8e-1 [48.5 kB]
Get:75 http://172.17.0.1/private stretch-staging/main armhf golang-github-go-fsnotify-fsnotify-dev all 1.2.1-1 [22.0 kB]
Get:76 http://172.17.0.1/private stretch-staging/main armhf golang-github-go-sql-driver-mysql-dev all 1.2-1 [37.7 kB]
Get:77 http://172.17.0.1/private stretch-staging/main armhf golang-github-hashicorp-hcl-dev all 0.0~git20151110.0.fa160f1-1 [42.7 kB]
Get:78 http://172.17.0.1/private stretch-staging/main armhf golang-github-qor-inflection-dev all 0.0~git20151009.0.3272df6-1 [4406 B]
Get:79 http://172.17.0.1/private stretch-staging/main armhf golang-github-lib-pq-dev all 0.0~git20151007.0.ffe986a-1 [53.3 kB]
Get:80 http://172.17.0.1/private stretch-staging/main armhf golang-pq-dev all 0.0~git20151007.0.ffe986a-1 [2604 B]
Get:81 http://172.17.0.1/private stretch-staging/main armhf golang-github-jinzhu-gorm-dev all 0.0~git20151012.0.20e37a0-1 [46.7 kB]
Get:82 http://172.17.0.1/private stretch-staging/main armhf golang-github-magiconair-properties-dev all 1.6.0-2 [46.9 kB]
Get:83 http://172.17.0.1/private stretch-staging/main armhf golang-github-miekg-pkcs11-dev all 0.0~git20151009.0.793689b-1 [22.3 kB]
Get:84 http://172.17.0.1/private stretch-staging/main armhf golang-github-spf13-jwalterweatherman-dev all 0.0~git20151231.0.d006540-1 [4890 B]
Get:85 http://172.17.0.1/private stretch-staging/main armhf golang-github-spf13-cast-dev all 0.0~git20150803.0.ee815aa-1 [5682 B]
Get:86 http://172.17.0.1/private stretch-staging/main armhf golang-github-spf13-pflag-dev all 0.0~git20151218.0.7f60f83-1 [26.7 kB]
Get:87 http://172.17.0.1/private stretch-staging/main armhf golang-toml-dev all 0.1.0+git20150501.21.056c9bc-1 [33.4 kB]
Get:88 http://172.17.0.1/private stretch-staging/main armhf golang-text-dev all 0.0~git20130502-1 [6246 B]
Get:89 http://172.17.0.1/private stretch-staging/main armhf golang-pretty-dev all 0.0~git20130613-1 [7220 B]
Get:90 http://172.17.0.1/private stretch-staging/main armhf golang-github-xordataexchange-crypt-dev all 0.0.2+git20150523.17.749e360-2 [11.4 kB]
Get:91 http://172.17.0.1/private stretch-staging/main armhf golang-github-spf13-viper-dev all 0.0~git20151224.0.110492b-1 [17.4 kB]
Get:92 http://172.17.0.1/private stretch-staging/main armhf golang-github-spf13-cobra-dev all 0.0~git20151224.0.b3f29e9-1 [43.8 kB]
Get:93 http://172.17.0.1/private stretch-staging/main armhf golang-github-tent-canonical-json-go-dev all 0.0~git20130607.0.96e4ba3-1 [7374 B]
Get:94 http://172.17.0.1/private stretch-staging/main armhf golang-github-ugorji-go-codec-dev all 0.0~git20151130.0.357a44b-1 [127 kB]
Get:95 http://172.17.0.1/private stretch-staging/main armhf golang-glog-dev all 0+git20150801.fca8c88-1 [16.5 kB]
Get:96 http://172.17.0.1/private stretch-staging/main armhf golang-go.net-dev all 1:0.0+git20150817.66f0418-1 [9842 B]
Get:97 http://172.17.0.1/private stretch-staging/main armhf golang-goprotobuf-dev armhf 0.0~git20150526-2 [700 kB]
Get:98 http://172.17.0.1/private stretch-staging/main armhf golang-google-appengine-dev all 0.0~git20150606-2 [128 kB]
Get:99 http://172.17.0.1/private stretch-staging/main armhf golang-google-cloud-compute-metadata-dev all 0.0~git20150613-1 [5564 B]
Get:100 http://172.17.0.1/private stretch-staging/main armhf golang-golang-x-oauth2-dev all 0.0~git20150527-2 [28.0 kB]
Get:101 http://172.17.0.1/private stretch-staging/main armhf golang-google-grpc-dev all 0.0~git20150514.0.f5ebd86-2 [58.0 kB]
debconf: delaying package configuration, since apt-utils is not installed
Fetched 52.7 MB in 17s (3003 kB/s)
Selecting previously unselected package groff-base.
(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 ... 12751 files and directories currently installed.)
Preparing to unpack .../groff-base_1.22.3-5_armhf.deb ...
Unpacking groff-base (1.22.3-5) ...
Selecting previously unselected package bsdmainutils.
Preparing to unpack .../bsdmainutils_9.0.6_armhf.deb ...
Unpacking bsdmainutils (9.0.6) ...
Selecting previously unselected package libpipeline1:armhf.
Preparing to unpack .../libpipeline1_1.4.1-2_armhf.deb ...
Unpacking libpipeline1:armhf (1.4.1-2) ...
Selecting previously unselected package man-db.
Preparing to unpack .../man-db_2.7.5-1_armhf.deb ...
Unpacking man-db (2.7.5-1) ...
Selecting previously unselected package libltdl7:armhf.
Preparing to unpack .../libltdl7_2.4.2-1.11_armhf.deb ...
Unpacking libltdl7:armhf (2.4.2-1.11) ...
Selecting previously unselected package libunistring0:armhf.
Preparing to unpack .../libunistring0_0.9.3-5.2_armhf.deb ...
Unpacking libunistring0:armhf (0.9.3-5.2) ...
Selecting previously unselected package libmagic1:armhf.
Preparing to unpack .../libmagic1_1%3a5.25-2_armhf.deb ...
Unpacking libmagic1:armhf (1:5.25-2) ...
Selecting previously unselected package file.
Preparing to unpack .../file_1%3a5.25-2_armhf.deb ...
Unpacking file (1:5.25-2) ...
Selecting previously unselected package gettext-base.
Preparing to unpack .../gettext-base_0.19.7-2_armhf.deb ...
Unpacking gettext-base (0.19.7-2) ...
Selecting previously unselected package libsqlite3-0:armhf.
Preparing to unpack .../libsqlite3-0_3.9.2-1_armhf.deb ...
Unpacking libsqlite3-0:armhf (3.9.2-1) ...
Selecting previously unselected package libicu55:armhf.
Preparing to unpack .../libicu55_55.1-7_armhf.deb ...
Unpacking libicu55:armhf (55.1-7) ...
Selecting previously unselected package libxml2:armhf.
Preparing to unpack .../libxml2_2.9.3+dfsg1-1_armhf.deb ...
Unpacking libxml2:armhf (2.9.3+dfsg1-1) ...
Selecting previously unselected package libffi6:armhf.
Preparing to unpack .../libffi6_3.2.1-4_armhf.deb ...
Unpacking libffi6:armhf (3.2.1-4) ...
Selecting previously unselected package libglib2.0-0:armhf.
Preparing to unpack .../libglib2.0-0_2.46.2-3_armhf.deb ...
Unpacking libglib2.0-0:armhf (2.46.2-3) ...
Selecting previously unselected package libcroco3:armhf.
Preparing to unpack .../libcroco3_0.6.11-1_armhf.deb ...
Unpacking libcroco3:armhf (0.6.11-1) ...
Selecting previously unselected package gettext.
Preparing to unpack .../gettext_0.19.7-2_armhf.deb ...
Unpacking gettext (0.19.7-2) ...
Selecting previously unselected package intltool-debian.
Preparing to unpack .../intltool-debian_0.35.0+20060710.4_all.deb ...
Unpacking intltool-debian (0.35.0+20060710.4) ...
Selecting previously unselected package po-debconf.
Preparing to unpack .../po-debconf_1.0.18_all.deb ...
Unpacking po-debconf (1.0.18) ...
Selecting previously unselected package libarchive-zip-perl.
Preparing to unpack .../libarchive-zip-perl_1.56-2_all.deb ...
Unpacking libarchive-zip-perl (1.56-2) ...
Selecting previously unselected package libfile-stripnondeterminism-perl.
Preparing to unpack .../libfile-stripnondeterminism-perl_0.014-1_all.deb ...
Unpacking libfile-stripnondeterminism-perl (0.014-1) ...
Selecting previously unselected package libtimedate-perl.
Preparing to unpack .../libtimedate-perl_2.3000-2_all.deb ...
Unpacking libtimedate-perl (2.3000-2) ...
Selecting previously unselected package dh-strip-nondeterminism.
Preparing to unpack .../dh-strip-nondeterminism_0.014-1_all.deb ...
Unpacking dh-strip-nondeterminism (0.014-1) ...
Selecting previously unselected package debhelper.
Preparing to unpack .../debhelper_9.20151225_all.deb ...
Unpacking debhelper (9.20151225) ...
Selecting previously unselected package golang-github-docker-docker-dev.
Preparing to unpack .../golang-github-docker-docker-dev_1.8.3~ds1-2_all.deb ...
Unpacking golang-github-docker-docker-dev (1.8.3~ds1-2) ...
Selecting previously unselected package golang-docker-dev.
Preparing to unpack .../golang-docker-dev_1.8.3~ds1-2_all.deb ...
Unpacking golang-docker-dev (1.8.3~ds1-2) ...
Selecting previously unselected package golang-src.
Preparing to unpack .../golang-src_2%3a1.5.1-4_armhf.deb ...
Unpacking golang-src (2:1.5.1-4) ...
Selecting previously unselected package golang-go.
Preparing to unpack .../golang-go_2%3a1.5.1-4_armhf.deb ...
Unpacking golang-go (2:1.5.1-4) ...
Selecting previously unselected package libltdl-dev:armhf.
Preparing to unpack .../libltdl-dev_2.4.2-1.11_armhf.deb ...
Unpacking libltdl-dev:armhf (2.4.2-1.11) ...
Selecting previously unselected package libnspr4:armhf.
Preparing to unpack .../libnspr4_2%3a4.11-1_armhf.deb ...
Unpacking libnspr4:armhf (2:4.11-1) ...
Selecting previously unselected package libnspr4-dev.
Preparing to unpack .../libnspr4-dev_2%3a4.11-1_armhf.deb ...
Unpacking libnspr4-dev (2:4.11-1) ...
Selecting previously unselected package libnss3:armhf.
Preparing to unpack .../libnss3_2%3a3.21-1_armhf.deb ...
Unpacking libnss3:armhf (2:3.21-1) ...
Selecting previously unselected package libnss3-dev:armhf.
Preparing to unpack .../libnss3-dev_2%3a3.21-1_armhf.deb ...
Unpacking libnss3-dev:armhf (2:3.21-1) ...
Selecting previously unselected package libprotobuf9v5:armhf.
Preparing to unpack .../libprotobuf9v5_2.6.1-1.3_armhf.deb ...
Unpacking libprotobuf9v5:armhf (2.6.1-1.3) ...
Selecting previously unselected package libprotoc9v5:armhf.
Preparing to unpack .../libprotoc9v5_2.6.1-1.3_armhf.deb ...
Unpacking libprotoc9v5:armhf (2.6.1-1.3) ...
Selecting previously unselected package libsqlite3-dev:armhf.
Preparing to unpack .../libsqlite3-dev_3.9.2-1_armhf.deb ...
Unpacking libsqlite3-dev:armhf (3.9.2-1) ...
Selecting previously unselected package pkg-config.
Preparing to unpack .../pkg-config_0.29-2_armhf.deb ...
Unpacking pkg-config (0.29-2) ...
Selecting previously unselected package protobuf-compiler.
Preparing to unpack .../protobuf-compiler_2.6.1-1.3_armhf.deb ...
Unpacking protobuf-compiler (2.6.1-1.3) ...
Selecting previously unselected package dh-golang.
Preparing to unpack .../dh-golang_1.12_all.deb ...
Unpacking dh-golang (1.12) ...
Selecting previously unselected package golang-check.v1-dev.
Preparing to unpack .../golang-check.v1-dev_0.0+git20150729.11d3bc7-2_all.deb ...
Unpacking golang-check.v1-dev (0.0+git20150729.11d3bc7-2) ...
Selecting previously unselected package golang-context-dev.
Preparing to unpack .../golang-context-dev_0.0~git20140604.1.14f550f-1_all.deb ...
Unpacking golang-context-dev (0.0~git20140604.1.14f550f-1) ...
Selecting previously unselected package golang-ed25519-dev.
Preparing to unpack .../golang-ed25519-dev_0~20140907.d2b94fd-2_all.deb ...
Unpacking golang-ed25519-dev (0~20140907.d2b94fd-2) ...
Selecting previously unselected package golang-etcd-dev.
Preparing to unpack .../golang-etcd-dev_2.0.0-1_all.deb ...
Unpacking golang-etcd-dev (2.0.0-1) ...
Selecting previously unselected package golang-github-adroll-goamz-dev.
Preparing to unpack .../golang-github-adroll-goamz-dev_0.0~git20150909.0.74fd457-2_all.deb ...
Unpacking golang-github-adroll-goamz-dev (0.0~git20150909.0.74fd457-2) ...
Selecting previously unselected package golang-github-armon-consul-api-dev.
Preparing to unpack .../golang-github-armon-consul-api-dev_0.0~git20150107.0.dcfedd5-1_all.deb ...
Unpacking golang-github-armon-consul-api-dev (0.0~git20150107.0.dcfedd5-1) ...
Selecting previously unselected package golang-github-azure-go-autorest-dev.
Preparing to unpack .../golang-github-azure-go-autorest-dev_0.1~alpha-2_all.deb ...
Unpacking golang-github-azure-go-autorest-dev (0.1~alpha-2) ...
Selecting previously unselected package golang-github-azure-go-pkcs12-dev.
Preparing to unpack .../golang-github-azure-go-pkcs12-dev_0.0~git20150623.0.a635c06-1_all.deb ...
Unpacking golang-github-azure-go-pkcs12-dev (0.0~git20150623.0.a635c06-1) ...
Selecting previously unselected package golang-github-azure-azure-sdk-for-go-dev.
Preparing to unpack .../golang-github-azure-azure-sdk-for-go-dev_1.2~git20150611.0.97d9593-2_all.deb ...
Unpacking golang-github-azure-azure-sdk-for-go-dev (1.2~git20150611.0.97d9593-2) ...
Selecting previously unselected package golang-golang-x-crypto-dev.
Preparing to unpack .../golang-golang-x-crypto-dev_1%3a0.0~git20151201.0.7b85b09-2_all.deb ...
Unpacking golang-golang-x-crypto-dev (1:0.0~git20151201.0.7b85b09-2) ...
Selecting previously unselected package golang-go.crypto-dev.
Preparing to unpack .../golang-go.crypto-dev_1%3a0.0~git20151201.0.7b85b09-2_all.deb ...
Unpacking golang-go.crypto-dev (1:0.0~git20151201.0.7b85b09-2) ...
Selecting previously unselected package golang-github-bradfitz-http2-dev.
Preparing to unpack .../golang-github-bradfitz-http2-dev_0.0~git20150509-1_all.deb ...
Unpacking golang-github-bradfitz-http2-dev (0.0~git20150509-1) ...
Selecting previously unselected package golang-github-shurcool-sanitized-anchor-name-dev.
Preparing to unpack .../golang-github-shurcool-sanitized-anchor-name-dev_0.0~git20151028.0.10ef21a-1_all.deb ...
Unpacking golang-github-shurcool-sanitized-anchor-name-dev (0.0~git20151028.0.10ef21a-1) ...
Selecting previously unselected package golang-github-russross-blackfriday-dev.
Preparing to unpack .../golang-github-russross-blackfriday-dev_1.4-1_all.deb ...
Unpacking golang-github-russross-blackfriday-dev (1.4-1) ...
Selecting previously unselected package golang-github-cpuguy83-go-md2man-dev.
Preparing to unpack .../golang-github-cpuguy83-go-md2man-dev_1.0.4-3_all.deb ...
Unpacking golang-github-cpuguy83-go-md2man-dev (1.0.4-3) ...
Selecting previously unselected package golang-github-data-dog-go-sqlmock-dev.
Preparing to unpack .../golang-github-data-dog-go-sqlmock-dev_1.0.0-1_all.deb ...
Unpacking golang-github-data-dog-go-sqlmock-dev (1.0.0-1) ...
Selecting previously unselected package golang-github-docker-libtrust-dev.
Preparing to unpack .../golang-github-docker-libtrust-dev_0.0~git20150526.0.9cbd2a1-1_all.deb ...
Unpacking golang-github-docker-libtrust-dev (0.0~git20150526.0.9cbd2a1-1) ...
Selecting previously unselected package golang-github-garyburd-redigo-dev.
Preparing to unpack .../golang-github-garyburd-redigo-dev_0.0~git20150901.0.d8dbe4d-1_all.deb ...
Unpacking golang-github-garyburd-redigo-dev (0.0~git20150901.0.d8dbe4d-1) ...
Selecting previously unselected package golang-github-gorilla-handlers-dev.
Preparing to unpack .../golang-github-gorilla-handlers-dev_0.0~git20150820.0.40694b4-1_all.deb ...
Unpacking golang-github-gorilla-handlers-dev (0.0~git20150820.0.40694b4-1) ...
Selecting previously unselected package golang-github-gorilla-mux-dev.
Preparing to unpack .../golang-github-gorilla-mux-dev_0.0~git20150814.0.f7b6aaa-1_all.deb ...
Unpacking golang-github-gorilla-mux-dev (0.0~git20150814.0.f7b6aaa-1) ...
Selecting previously unselected package golang-github-mitchellh-mapstructure-dev.
Preparing to unpack .../golang-github-mitchellh-mapstructure-dev_0.0~git20150717.0.281073e-1_all.deb ...
Unpacking golang-github-mitchellh-mapstructure-dev (0.0~git20150717.0.281073e-1) ...
Selecting previously unselected package golang-github-ncw-swift-dev.
Preparing to unpack .../golang-github-ncw-swift-dev_0.0~git20150901.0.ca8cbbd-1_all.deb ...
Unpacking golang-github-ncw-swift-dev (0.0~git20150901.0.ca8cbbd-1) ...
Selecting previously unselected package golang-github-sirupsen-logrus-dev.
Preparing to unpack .../golang-github-sirupsen-logrus-dev_0.8.7-2_all.deb ...
Unpacking golang-github-sirupsen-logrus-dev (0.8.7-2) ...
Selecting previously unselected package golang-github-stevvooe-resumable-dev.
Preparing to unpack .../golang-github-stevvooe-resumable-dev_0.0~git20150521.0.51ad441-1_all.deb ...
Unpacking golang-github-stevvooe-resumable-dev (0.0~git20150521.0.51ad441-1) ...
Selecting previously unselected package golang-x-text-dev.
Preparing to unpack .../golang-x-text-dev_0+git20150518.c93e7c9-1_all.deb ...
Unpacking golang-x-text-dev (0+git20150518.c93e7c9-1) ...
Selecting previously unselected package golang-golang-x-net-dev.
Preparing to unpack .../golang-golang-x-net-dev_1%3a0.0+git20150817.66f0418-1_all.deb ...
Unpacking golang-golang-x-net-dev (1:0.0+git20150817.66f0418-1) ...
Selecting previously unselected package golang-yaml.v2-dev.
Preparing to unpack .../golang-yaml.v2-dev_0.0+git20150627.7ad95dd-1_all.deb ...
Unpacking golang-yaml.v2-dev (0.0+git20150627.7ad95dd-1) ...
Selecting previously unselected package golang-github-docker-distribution-dev.
Preparing to unpack .../golang-github-docker-distribution-dev_2.1.1~ds1-4_all.deb ...
Unpacking golang-github-docker-distribution-dev (2.1.1~ds1-4) ...
Selecting previously unselected package golang-github-dvsekhvalnov-jose2go-dev.
Preparing to unpack .../golang-github-dvsekhvalnov-jose2go-dev_1.2-1_all.deb ...
Unpacking golang-github-dvsekhvalnov-jose2go-dev (1.2-1) ...
Selecting previously unselected package golang-github-google-gofuzz-dev.
Preparing to unpack .../golang-github-google-gofuzz-dev_0.0~git20150903.0.e4af62d-1_all.deb ...
Unpacking golang-github-google-gofuzz-dev (0.0~git20150903.0.e4af62d-1) ...
Selecting previously unselected package golang-github-jfrazelle-go-dev.
Preparing to unpack .../golang-github-jfrazelle-go-dev_0.0~git20150906.0.a8e3e21-1_all.deb ...
Unpacking golang-github-jfrazelle-go-dev (0.0~git20150906.0.a8e3e21-1) ...
Selecting previously unselected package golang-github-mattn-go-sqlite3-dev.
Preparing to unpack .../golang-github-mattn-go-sqlite3-dev_1.1.0~dfsg1-1_all.deb ...
Unpacking golang-github-mattn-go-sqlite3-dev (1.1.0~dfsg1-1) ...
Selecting previously unselected package golang-objx-dev.
Preparing to unpack .../golang-objx-dev_0.0~git20140527-4_all.deb ...
Unpacking golang-objx-dev (0.0~git20140527-4) ...
Selecting previously unselected package golang-github-stretchr-testify-dev.
Preparing to unpack .../golang-github-stretchr-testify-dev_1.0-2_all.deb ...
Unpacking golang-github-stretchr-testify-dev (1.0-2) ...
Selecting previously unselected package golang-github-endophage-gotuf-dev.
Preparing to unpack .../golang-github-endophage-gotuf-dev_0.0~git20151020.0.2df1c8e-1_all.deb ...
Unpacking golang-github-endophage-gotuf-dev (0.0~git20151020.0.2df1c8e-1) ...
Selecting previously unselected package golang-github-go-fsnotify-fsnotify-dev.
Preparing to unpack .../golang-github-go-fsnotify-fsnotify-dev_1.2.1-1_all.deb ...
Unpacking golang-github-go-fsnotify-fsnotify-dev (1.2.1-1) ...
Selecting previously unselected package golang-github-go-sql-driver-mysql-dev.
Preparing to unpack .../golang-github-go-sql-driver-mysql-dev_1.2-1_all.deb ...
Unpacking golang-github-go-sql-driver-mysql-dev (1.2-1) ...
Selecting previously unselected package golang-github-hashicorp-hcl-dev.
Preparing to unpack .../golang-github-hashicorp-hcl-dev_0.0~git20151110.0.fa160f1-1_all.deb ...
Unpacking golang-github-hashicorp-hcl-dev (0.0~git20151110.0.fa160f1-1) ...
Selecting previously unselected package golang-github-qor-inflection-dev.
Preparing to unpack .../golang-github-qor-inflection-dev_0.0~git20151009.0.3272df6-1_all.deb ...
Unpacking golang-github-qor-inflection-dev (0.0~git20151009.0.3272df6-1) ...
Selecting previously unselected package golang-github-lib-pq-dev.
Preparing to unpack .../golang-github-lib-pq-dev_0.0~git20151007.0.ffe986a-1_all.deb ...
Unpacking golang-github-lib-pq-dev (0.0~git20151007.0.ffe986a-1) ...
Selecting previously unselected package golang-pq-dev.
Preparing to unpack .../golang-pq-dev_0.0~git20151007.0.ffe986a-1_all.deb ...
Unpacking golang-pq-dev (0.0~git20151007.0.ffe986a-1) ...
Selecting previously unselected package golang-github-jinzhu-gorm-dev.
Preparing to unpack .../golang-github-jinzhu-gorm-dev_0.0~git20151012.0.20e37a0-1_all.deb ...
Unpacking golang-github-jinzhu-gorm-dev (0.0~git20151012.0.20e37a0-1) ...
Selecting previously unselected package golang-github-magiconair-properties-dev.
Preparing to unpack .../golang-github-magiconair-properties-dev_1.6.0-2_all.deb ...
Unpacking golang-github-magiconair-properties-dev (1.6.0-2) ...
Selecting previously unselected package golang-github-miekg-pkcs11-dev.
Preparing to unpack .../golang-github-miekg-pkcs11-dev_0.0~git20151009.0.793689b-1_all.deb ...
Unpacking golang-github-miekg-pkcs11-dev (0.0~git20151009.0.793689b-1) ...
Selecting previously unselected package golang-github-spf13-jwalterweatherman-dev.
Preparing to unpack .../golang-github-spf13-jwalterweatherman-dev_0.0~git20151231.0.d006540-1_all.deb ...
Unpacking golang-github-spf13-jwalterweatherman-dev (0.0~git20151231.0.d006540-1) ...
Selecting previously unselected package golang-github-spf13-cast-dev.
Preparing to unpack .../golang-github-spf13-cast-dev_0.0~git20150803.0.ee815aa-1_all.deb ...
Unpacking golang-github-spf13-cast-dev (0.0~git20150803.0.ee815aa-1) ...
Selecting previously unselected package golang-github-spf13-pflag-dev.
Preparing to unpack .../golang-github-spf13-pflag-dev_0.0~git20151218.0.7f60f83-1_all.deb ...
Unpacking golang-github-spf13-pflag-dev (0.0~git20151218.0.7f60f83-1) ...
Selecting previously unselected package golang-toml-dev.
Preparing to unpack .../golang-toml-dev_0.1.0+git20150501.21.056c9bc-1_all.deb ...
Unpacking golang-toml-dev (0.1.0+git20150501.21.056c9bc-1) ...
Selecting previously unselected package golang-text-dev.
Preparing to unpack .../golang-text-dev_0.0~git20130502-1_all.deb ...
Unpacking golang-text-dev (0.0~git20130502-1) ...
Selecting previously unselected package golang-pretty-dev.
Preparing to unpack .../golang-pretty-dev_0.0~git20130613-1_all.deb ...
Unpacking golang-pretty-dev (0.0~git20130613-1) ...
Selecting previously unselected package golang-github-xordataexchange-crypt-dev.
Preparing to unpack .../golang-github-xordataexchange-crypt-dev_0.0.2+git20150523.17.749e360-2_all.deb ...
Unpacking golang-github-xordataexchange-crypt-dev (0.0.2+git20150523.17.749e360-2) ...
Selecting previously unselected package golang-github-spf13-viper-dev.
Preparing to unpack .../golang-github-spf13-viper-dev_0.0~git20151224.0.110492b-1_all.deb ...
Unpacking golang-github-spf13-viper-dev (0.0~git20151224.0.110492b-1) ...
Selecting previously unselected package golang-github-spf13-cobra-dev.
Preparing to unpack .../golang-github-spf13-cobra-dev_0.0~git20151224.0.b3f29e9-1_all.deb ...
Unpacking golang-github-spf13-cobra-dev (0.0~git20151224.0.b3f29e9-1) ...
Selecting previously unselected package golang-github-tent-canonical-json-go-dev.
Preparing to unpack .../golang-github-tent-canonical-json-go-dev_0.0~git20130607.0.96e4ba3-1_all.deb ...
Unpacking golang-github-tent-canonical-json-go-dev (0.0~git20130607.0.96e4ba3-1) ...
Selecting previously unselected package golang-github-ugorji-go-codec-dev.
Preparing to unpack .../golang-github-ugorji-go-codec-dev_0.0~git20151130.0.357a44b-1_all.deb ...
Unpacking golang-github-ugorji-go-codec-dev (0.0~git20151130.0.357a44b-1) ...
Selecting previously unselected package golang-glog-dev.
Preparing to unpack .../golang-glog-dev_0+git20150801.fca8c88-1_all.deb ...
Unpacking golang-glog-dev (0+git20150801.fca8c88-1) ...
Selecting previously unselected package golang-go.net-dev.
Preparing to unpack .../golang-go.net-dev_1%3a0.0+git20150817.66f0418-1_all.deb ...
Unpacking golang-go.net-dev (1:0.0+git20150817.66f0418-1) ...
Selecting previously unselected package golang-goprotobuf-dev.
Preparing to unpack .../golang-goprotobuf-dev_0.0~git20150526-2_armhf.deb ...
Unpacking golang-goprotobuf-dev (0.0~git20150526-2) ...
Selecting previously unselected package golang-google-appengine-dev.
Preparing to unpack .../golang-google-appengine-dev_0.0~git20150606-2_all.deb ...
Unpacking golang-google-appengine-dev (0.0~git20150606-2) ...
Selecting previously unselected package golang-google-cloud-compute-metadata-dev.
Preparing to unpack .../golang-google-cloud-compute-metadata-dev_0.0~git20150613-1_all.deb ...
Unpacking golang-google-cloud-compute-metadata-dev (0.0~git20150613-1) ...
Selecting previously unselected package golang-golang-x-oauth2-dev.
Preparing to unpack .../golang-golang-x-oauth2-dev_0.0~git20150527-2_all.deb ...
Unpacking golang-golang-x-oauth2-dev (0.0~git20150527-2) ...
Selecting previously unselected package golang-google-grpc-dev.
Preparing to unpack .../golang-google-grpc-dev_0.0~git20150514.0.f5ebd86-2_all.deb ...
Unpacking golang-google-grpc-dev (0.0~git20150514.0.f5ebd86-2) ...
Selecting previously unselected package sbuild-build-depends-notary-dummy.
Preparing to unpack .../sbuild-build-depends-notary-dummy.deb ...
Unpacking sbuild-build-depends-notary-dummy (0.invalid.0) ...
Processing triggers for libc-bin (2.21-6) ...
Setting up groff-base (1.22.3-5) ...
Setting up bsdmainutils (9.0.6) ...
update-alternatives: using /usr/bin/bsd-write to provide /usr/bin/write (write) in auto mode
update-alternatives: using /usr/bin/bsd-from to provide /usr/bin/from (from) in auto mode
Setting up libpipeline1:armhf (1.4.1-2) ...
Setting up man-db (2.7.5-1) ...
Not building database; man-db/auto-update is not 'true'.
Setting up libltdl7:armhf (2.4.2-1.11) ...
Setting up libunistring0:armhf (0.9.3-5.2) ...
Setting up libmagic1:armhf (1:5.25-2) ...
Setting up file (1:5.25-2) ...
Setting up gettext-base (0.19.7-2) ...
Setting up libsqlite3-0:armhf (3.9.2-1) ...
Setting up libicu55:armhf (55.1-7) ...
Setting up libxml2:armhf (2.9.3+dfsg1-1) ...
Setting up libffi6:armhf (3.2.1-4) ...
Setting up libglib2.0-0:armhf (2.46.2-3) ...
No schema files found: doing nothing.
Setting up libcroco3:armhf (0.6.11-1) ...
Setting up gettext (0.19.7-2) ...
Setting up intltool-debian (0.35.0+20060710.4) ...
Setting up po-debconf (1.0.18) ...
Setting up libarchive-zip-perl (1.56-2) ...
Setting up libfile-stripnondeterminism-perl (0.014-1) ...
Setting up libtimedate-perl (2.3000-2) ...
Setting up golang-github-docker-docker-dev (1.8.3~ds1-2) ...
Setting up golang-docker-dev (1.8.3~ds1-2) ...
Setting up golang-src (2:1.5.1-4) ...
Setting up golang-go (2:1.5.1-4) ...
update-alternatives: using /usr/lib/go/bin/go to provide /usr/bin/go (go) in auto mode
Setting up libltdl-dev:armhf (2.4.2-1.11) ...
Setting up libnspr4:armhf (2:4.11-1) ...
Setting up libnspr4-dev (2:4.11-1) ...
Setting up libnss3:armhf (2:3.21-1) ...
Setting up libnss3-dev:armhf (2:3.21-1) ...
Setting up libprotobuf9v5:armhf (2.6.1-1.3) ...
Setting up libprotoc9v5:armhf (2.6.1-1.3) ...
Setting up libsqlite3-dev:armhf (3.9.2-1) ...
Setting up pkg-config (0.29-2) ...
Setting up protobuf-compiler (2.6.1-1.3) ...
Setting up golang-check.v1-dev (0.0+git20150729.11d3bc7-2) ...
Setting up golang-context-dev (0.0~git20140604.1.14f550f-1) ...
Setting up golang-ed25519-dev (0~20140907.d2b94fd-2) ...
Setting up golang-etcd-dev (2.0.0-1) ...
Setting up golang-github-adroll-goamz-dev (0.0~git20150909.0.74fd457-2) ...
Setting up golang-github-armon-consul-api-dev (0.0~git20150107.0.dcfedd5-1) ...
Setting up golang-github-azure-go-autorest-dev (0.1~alpha-2) ...
Setting up golang-github-azure-go-pkcs12-dev (0.0~git20150623.0.a635c06-1) ...
Setting up golang-github-azure-azure-sdk-for-go-dev (1.2~git20150611.0.97d9593-2) ...
Setting up golang-golang-x-crypto-dev (1:0.0~git20151201.0.7b85b09-2) ...
Setting up golang-go.crypto-dev (1:0.0~git20151201.0.7b85b09-2) ...
Setting up golang-github-bradfitz-http2-dev (0.0~git20150509-1) ...
Setting up golang-github-shurcool-sanitized-anchor-name-dev (0.0~git20151028.0.10ef21a-1) ...
Setting up golang-github-russross-blackfriday-dev (1.4-1) ...
Setting up golang-github-cpuguy83-go-md2man-dev (1.0.4-3) ...
Setting up golang-github-data-dog-go-sqlmock-dev (1.0.0-1) ...
Setting up golang-github-docker-libtrust-dev (0.0~git20150526.0.9cbd2a1-1) ...
Setting up golang-github-garyburd-redigo-dev (0.0~git20150901.0.d8dbe4d-1) ...
Setting up golang-github-gorilla-handlers-dev (0.0~git20150820.0.40694b4-1) ...
Setting up golang-github-gorilla-mux-dev (0.0~git20150814.0.f7b6aaa-1) ...
Setting up golang-github-mitchellh-mapstructure-dev (0.0~git20150717.0.281073e-1) ...
Setting up golang-github-ncw-swift-dev (0.0~git20150901.0.ca8cbbd-1) ...
Setting up golang-github-sirupsen-logrus-dev (0.8.7-2) ...
Setting up golang-github-stevvooe-resumable-dev (0.0~git20150521.0.51ad441-1) ...
Setting up golang-x-text-dev (0+git20150518.c93e7c9-1) ...
Setting up golang-golang-x-net-dev (1:0.0+git20150817.66f0418-1) ...
Setting up golang-yaml.v2-dev (0.0+git20150627.7ad95dd-1) ...
Setting up golang-github-docker-distribution-dev (2.1.1~ds1-4) ...
Setting up golang-github-dvsekhvalnov-jose2go-dev (1.2-1) ...
Setting up golang-github-google-gofuzz-dev (0.0~git20150903.0.e4af62d-1) ...
Setting up golang-github-jfrazelle-go-dev (0.0~git20150906.0.a8e3e21-1) ...
Setting up golang-github-mattn-go-sqlite3-dev (1.1.0~dfsg1-1) ...
Setting up golang-objx-dev (0.0~git20140527-4) ...
Setting up golang-github-stretchr-testify-dev (1.0-2) ...
Setting up golang-github-endophage-gotuf-dev (0.0~git20151020.0.2df1c8e-1) ...
Setting up golang-github-go-fsnotify-fsnotify-dev (1.2.1-1) ...
Setting up golang-github-go-sql-driver-mysql-dev (1.2-1) ...
Setting up golang-github-hashicorp-hcl-dev (0.0~git20151110.0.fa160f1-1) ...
Setting up golang-github-qor-inflection-dev (0.0~git20151009.0.3272df6-1) ...
Setting up golang-github-lib-pq-dev (0.0~git20151007.0.ffe986a-1) ...
Setting up golang-pq-dev (0.0~git20151007.0.ffe986a-1) ...
Setting up golang-github-jinzhu-gorm-dev (0.0~git20151012.0.20e37a0-1) ...
Setting up golang-github-magiconair-properties-dev (1.6.0-2) ...
Setting up golang-github-miekg-pkcs11-dev (0.0~git20151009.0.793689b-1) ...
Setting up golang-github-spf13-jwalterweatherman-dev (0.0~git20151231.0.d006540-1) ...
Setting up golang-github-spf13-cast-dev (0.0~git20150803.0.ee815aa-1) ...
Setting up golang-github-spf13-pflag-dev (0.0~git20151218.0.7f60f83-1) ...
Setting up golang-toml-dev (0.1.0+git20150501.21.056c9bc-1) ...
Setting up golang-text-dev (0.0~git20130502-1) ...
Setting up golang-pretty-dev (0.0~git20130613-1) ...
Setting up golang-github-xordataexchange-crypt-dev (0.0.2+git20150523.17.749e360-2) ...
Setting up golang-github-spf13-viper-dev (0.0~git20151224.0.110492b-1) ...
Setting up golang-github-spf13-cobra-dev (0.0~git20151224.0.b3f29e9-1) ...
Setting up golang-github-tent-canonical-json-go-dev (0.0~git20130607.0.96e4ba3-1) ...
Setting up golang-github-ugorji-go-codec-dev (0.0~git20151130.0.357a44b-1) ...
Setting up golang-glog-dev (0+git20150801.fca8c88-1) ...
Setting up golang-go.net-dev (1:0.0+git20150817.66f0418-1) ...
Setting up golang-goprotobuf-dev (0.0~git20150526-2) ...
Setting up golang-google-appengine-dev (0.0~git20150606-2) ...
Setting up golang-google-cloud-compute-metadata-dev (0.0~git20150613-1) ...
Setting up golang-golang-x-oauth2-dev (0.0~git20150527-2) ...
Setting up golang-google-grpc-dev (0.0~git20150514.0.f5ebd86-2) ...
Setting up debhelper (9.20151225) ...
Setting up dh-golang (1.12) ...
Setting up sbuild-build-depends-notary-dummy (0.invalid.0) ...
Setting up dh-strip-nondeterminism (0.014-1) ...
Processing triggers for libc-bin (2.21-6) ...
W: No sandbox user '_apt' on the system, can not drop privileges

┌──────────────────────────────────────────────────────────────────────────────┐
│ Build environment                                                            │
└──────────────────────────────────────────────────────────────────────────────┘

Kernel: Linux 3.19.0-trunk-armmp armhf (armv7l)
Toolchain package versions: binutils_2.25.90.20160101-1 dpkg-dev_1.18.4 g++-5_5.3.1-5+rpi1 gcc-5_5.3.1-5+rpi1 libc6-dev_2.21-6 libstdc++-5-dev_5.3.1-5+rpi1 libstdc++6_5.3.1-5+rpi1 linux-libc-dev_3.18.5-1~exp1+rpi19+stretch
Package versions: adduser_3.113+nmu3 apt_1.1.10 base-files_9.4+rpi1 base-passwd_3.5.39 bash_4.3-14 binutils_2.25.90.20160101-1 bsdmainutils_9.0.6 bsdutils_1:2.27.1-1 build-essential_11.7 bzip2_1.0.6-8 coreutils_8.23-4 cpio_2.11+dfsg-4.1 cpp_4:5.3.1-1+rpi1 cpp-5_5.3.1-5+rpi1 dash_0.5.7-4 debconf_1.5.58 debfoster_2.7-2 debhelper_9.20151225 debianutils_4.5.1 dh-golang_1.12 dh-strip-nondeterminism_0.014-1 diffutils_1:3.3-3 dmsetup_2:1.02.114-1 dpkg_1.18.4 dpkg-dev_1.18.4 e2fslibs_1.42.13-1 e2fsprogs_1.42.13-1 fakeroot_1.20.2-1 file_1:5.25-2 findutils_4.4.2-10 g++_4:5.3.1-1+rpi1 g++-5_5.3.1-5+rpi1 gcc_4:5.3.1-1+rpi1 gcc-4.6-base_4.6.4-5+rpi1 gcc-4.7-base_4.7.3-11+rpi1 gcc-4.8-base_4.8.5-3 gcc-4.9-base_4.9.3-10 gcc-5_5.3.1-5+rpi1 gcc-5-base_5.3.1-5+rpi1 gettext_0.19.7-2 gettext-base_0.19.7-2 gnupg_1.4.20-1 golang-check.v1-dev_0.0+git20150729.11d3bc7-2 golang-context-dev_0.0~git20140604.1.14f550f-1 golang-docker-dev_1.8.3~ds1-2 golang-ed25519-dev_0~20140907.d2b94fd-2 golang-etcd-dev_2.0.0-1 golang-github-adroll-goamz-dev_0.0~git20150909.0.74fd457-2 golang-github-armon-consul-api-dev_0.0~git20150107.0.dcfedd5-1 golang-github-azure-azure-sdk-for-go-dev_1.2~git20150611.0.97d9593-2 golang-github-azure-go-autorest-dev_0.1~alpha-2 golang-github-azure-go-pkcs12-dev_0.0~git20150623.0.a635c06-1 golang-github-bradfitz-http2-dev_0.0~git20150509-1 golang-github-cpuguy83-go-md2man-dev_1.0.4-3 golang-github-data-dog-go-sqlmock-dev_1.0.0-1 golang-github-docker-distribution-dev_2.1.1~ds1-4 golang-github-docker-docker-dev_1.8.3~ds1-2 golang-github-docker-libtrust-dev_0.0~git20150526.0.9cbd2a1-1 golang-github-dvsekhvalnov-jose2go-dev_1.2-1 golang-github-endophage-gotuf-dev_0.0~git20151020.0.2df1c8e-1 golang-github-garyburd-redigo-dev_0.0~git20150901.0.d8dbe4d-1 golang-github-go-fsnotify-fsnotify-dev_1.2.1-1 golang-github-go-sql-driver-mysql-dev_1.2-1 golang-github-google-gofuzz-dev_0.0~git20150903.0.e4af62d-1 golang-github-gorilla-handlers-dev_0.0~git20150820.0.40694b4-1 golang-github-gorilla-mux-dev_0.0~git20150814.0.f7b6aaa-1 golang-github-hashicorp-hcl-dev_0.0~git20151110.0.fa160f1-1 golang-github-jfrazelle-go-dev_0.0~git20150906.0.a8e3e21-1 golang-github-jinzhu-gorm-dev_0.0~git20151012.0.20e37a0-1 golang-github-lib-pq-dev_0.0~git20151007.0.ffe986a-1 golang-github-magiconair-properties-dev_1.6.0-2 golang-github-mattn-go-sqlite3-dev_1.1.0~dfsg1-1 golang-github-miekg-pkcs11-dev_0.0~git20151009.0.793689b-1 golang-github-mitchellh-mapstructure-dev_0.0~git20150717.0.281073e-1 golang-github-ncw-swift-dev_0.0~git20150901.0.ca8cbbd-1 golang-github-qor-inflection-dev_0.0~git20151009.0.3272df6-1 golang-github-russross-blackfriday-dev_1.4-1 golang-github-shurcool-sanitized-anchor-name-dev_0.0~git20151028.0.10ef21a-1 golang-github-sirupsen-logrus-dev_0.8.7-2 golang-github-spf13-cast-dev_0.0~git20150803.0.ee815aa-1 golang-github-spf13-cobra-dev_0.0~git20151224.0.b3f29e9-1 golang-github-spf13-jwalterweatherman-dev_0.0~git20151231.0.d006540-1 golang-github-spf13-pflag-dev_0.0~git20151218.0.7f60f83-1 golang-github-spf13-viper-dev_0.0~git20151224.0.110492b-1 golang-github-stevvooe-resumable-dev_0.0~git20150521.0.51ad441-1 golang-github-stretchr-testify-dev_1.0-2 golang-github-tent-canonical-json-go-dev_0.0~git20130607.0.96e4ba3-1 golang-github-ugorji-go-codec-dev_0.0~git20151130.0.357a44b-1 golang-github-xordataexchange-crypt-dev_0.0.2+git20150523.17.749e360-2 golang-glog-dev_0+git20150801.fca8c88-1 golang-go_2:1.5.1-4 golang-go.crypto-dev_1:0.0~git20151201.0.7b85b09-2 golang-go.net-dev_1:0.0+git20150817.66f0418-1 golang-golang-x-crypto-dev_1:0.0~git20151201.0.7b85b09-2 golang-golang-x-net-dev_1:0.0+git20150817.66f0418-1 golang-golang-x-oauth2-dev_0.0~git20150527-2 golang-google-appengine-dev_0.0~git20150606-2 golang-google-cloud-compute-metadata-dev_0.0~git20150613-1 golang-google-grpc-dev_0.0~git20150514.0.f5ebd86-2 golang-goprotobuf-dev_0.0~git20150526-2 golang-objx-dev_0.0~git20140527-4 golang-pq-dev_0.0~git20151007.0.ffe986a-1 golang-pretty-dev_0.0~git20130613-1 golang-src_2:1.5.1-4 golang-text-dev_0.0~git20130502-1 golang-toml-dev_0.1.0+git20150501.21.056c9bc-1 golang-x-text-dev_0+git20150518.c93e7c9-1 golang-yaml.v2-dev_0.0+git20150627.7ad95dd-1 gpgv_1.4.20-1 grep_2.22-1 groff-base_1.22.3-5 gzip_1.6-4 hostname_3.16 init_1.24 init-system-helpers_1.24 initramfs-tools_0.120 initscripts_2.88dsf-59.2 insserv_1.14.0-5 intltool-debian_0.35.0+20060710.4 klibc-utils_2.0.4-4+rpi1 kmod_21-1 libacl1_2.2.52-2 libapparmor1_2.10-2+b3 libapt-pkg4.16_1.0.10.2 libapt-pkg5.0_1.1.10 libarchive-zip-perl_1.56-2 libasan2_5.3.1-5+rpi1 libatomic1_5.3.1-5+rpi1 libattr1_1:2.4.47-2 libaudit-common_1:2.4.5-1 libaudit1_1:2.4.5-1 libblkid1_2.27.1-1 libbz2-1.0_1.0.6-8 libc-bin_2.21-6 libc-dev-bin_2.21-6 libc6_2.21-6 libc6-dev_2.21-6 libcap2_1:2.24-12 libcap2-bin_1:2.24-12 libcc1-0_5.3.1-5+rpi1 libcomerr2_1.42.13-1 libcroco3_0.6.11-1 libcryptsetup4_2:1.6.6-5 libdb5.3_5.3.28-11 libdbus-1-3_1.10.6-1 libdebconfclient0_0.201 libdevmapper1.02.1_2:1.02.114-1 libdpkg-perl_1.18.4 libdrm2_2.4.65-3 libfakeroot_1.20.2-1 libfdisk1_2.27.1-1 libffi6_3.2.1-4 libfile-stripnondeterminism-perl_0.014-1 libgc1c2_1:7.4.2-7.3 libgcc-5-dev_5.3.1-5+rpi1 libgcc1_1:5.3.1-5+rpi1 libgcrypt20_1.6.4-4 libgdbm3_1.8.3-13.1 libglib2.0-0_2.46.2-3 libgmp10_2:6.1.0+dfsg-2 libgomp1_5.3.1-5+rpi1 libgpg-error0_1.21-1 libicu55_55.1-7 libisl13_0.14-2 libisl15_0.15-3 libklibc_2.0.4-4+rpi1 libkmod2_21-1 libltdl-dev_2.4.2-1.11 libltdl7_2.4.2-1.11 liblzma5_5.1.1alpha+20120614-2.1 libmagic1_1:5.25-2 libmount1_2.27.1-1 libmpc3_1.0.3-1 libmpfr4_3.1.3-2 libncurses5_6.0+20151024-2 libncursesw5_6.0+20151024-2 libnspr4_2:4.11-1 libnspr4-dev_2:4.11-1 libnss3_2:3.21-1 libnss3-dev_2:3.21-1 libpam-modules_1.1.8-3.1 libpam-modules-bin_1.1.8-3.1 libpam-runtime_1.1.8-3.1 libpam0g_1.1.8-3.1 libpcre3_2:8.35-8 libperl5.22_5.22.1-3 libpipeline1_1.4.1-2 libpng12-0_1.2.54-1 libprocps4_2:3.3.10-2 libprocps5_2:3.3.11-3 libprotobuf9v5_2.6.1-1.3 libprotoc9v5_2.6.1-1.3 libreadline6_6.3-8+b3 libseccomp2_2.2.3-2 libselinux1_2.4-3 libsemanage-common_2.4-3 libsemanage1_2.4-3 libsepol1_2.4-2 libsmartcols1_2.27.1-1 libsqlite3-0_3.9.2-1 libsqlite3-dev_3.9.2-1 libss2_1.42.13-1 libstdc++-5-dev_5.3.1-5+rpi1 libstdc++6_5.3.1-5+rpi1 libsystemd0_228-2 libtext-charwidth-perl_0.04-7+b6 libtext-iconv-perl_1.7-5+b7 libtext-wrapi18n-perl_0.06-7.1 libtimedate-perl_2.3000-2 libtinfo5_6.0+20151024-2 libubsan0_5.3.1-5+rpi1 libudev1_228-2 libunistring0_0.9.3-5.2 libusb-0.1-4_2:0.1.12-27 libustr-1.0-1_1.0.4-5 libuuid1_2.27.1-1 libxml2_2.9.3+dfsg1-1 linux-libc-dev_3.18.5-1~exp1+rpi19+stretch login_1:4.2-3.1 lsb-base_4.1+Debian13+rpi1+nmu1 make_4.0-8.2 makedev_2.3.1-93 man-db_2.7.5-1 manpages_3.74-1 mawk_1.3.3-17 mount_2.27.1-1 multiarch-support_2.21-6 nano_2.4.2-1 ncurses-base_6.0+20151024-2 ncurses-bin_6.0+20151024-2 passwd_1:4.2-3.1 patch_2.7.5-1 perl_5.22.1-3 perl-base_5.22.1-3 perl-modules-5.22_5.22.1-3 pkg-config_0.29-2 po-debconf_1.0.18 procps_2:3.3.11-3 protobuf-compiler_2.6.1-1.3 raspbian-archive-keyring_20120528.2 readline-common_6.3-8 sbuild-build-depends-core-dummy_0.invalid.0 sbuild-build-depends-notary-dummy_0.invalid.0 sed_4.2.2-6.1 sensible-utils_0.0.9 startpar_0.59-3 systemd_228-2 systemd-sysv_228-2 sysv-rc_2.88dsf-59.2 sysvinit-utils_2.88dsf-59.2 tar_1.28-2.1 tzdata_2015g-1 udev_228-2 util-linux_2.27.1-1 xz-utils_5.1.1alpha+20120614-2.1 zlib1g_1:1.2.8.dfsg-2+b1

┌──────────────────────────────────────────────────────────────────────────────┐
│ Build                                                                        │
└──────────────────────────────────────────────────────────────────────────────┘


Unpack source
─────────────

gpgv: keyblock resource `/sbuild-nonexistent/.gnupg/trustedkeys.gpg': file open error
gpgv: Signature made Wed Oct 28 17:35:49 2015 UTC using RSA key ID BF357DD4
gpgv: Can't check signature: public key not found
dpkg-source: warning: failed to verify signature on ./notary_0.0~git20150801.0.8e8122e-2.dsc
dpkg-source: info: extracting notary in notary-0.0~git20150801.0.8e8122e
dpkg-source: info: unpacking notary_0.0~git20150801.0.8e8122e.orig.tar.xz
dpkg-source: info: unpacking notary_0.0~git20150801.0.8e8122e-2.debian.tar.xz
dpkg-source: info: applying 178.patch
dpkg-source: info: applying 205.patch
dpkg-source: info: applying distribution-2.1.1.patch
dpkg-source: info: applying no-bugsnag.patch

Check disc space
────────────────

Sufficient free space for build

User Environment
────────────────

DEB_BUILD_OPTIONS=parallel=4
HOME=/sbuild-nonexistent
LOGNAME=buildd
PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games
SCHROOT_ALIAS_NAME=stretch-staging-armhf-sbuild
SCHROOT_CHROOT_NAME=stretch-staging-armhf-sbuild
SCHROOT_COMMAND=env
SCHROOT_GID=111
SCHROOT_GROUP=buildd
SCHROOT_SESSION_ID=stretch-staging-armhf-sbuild-e0585702-aa27-4115-b958-49d378699a22
SCHROOT_UID=106
SCHROOT_USER=buildd
SHELL=/bin/sh
TERM=linux
USER=buildd

dpkg-buildpackage
─────────────────

dpkg-buildpackage: source package notary
dpkg-buildpackage: source version 0.0~git20150801.0.8e8122e-2
dpkg-buildpackage: source distribution unstable
 dpkg-source --before-build notary-0.0~git20150801.0.8e8122e
dpkg-buildpackage: host architecture armhf
 fakeroot debian/rules clean
dh clean --buildsystem=golang --with=golang
   dh_testdir -O--buildsystem=golang
   dh_auto_clean -O--buildsystem=golang
   dh_clean -O--buildsystem=golang
 debian/rules build-arch
dh build-arch --buildsystem=golang --with=golang
   dh_testdir -a -O--buildsystem=golang
   dh_auto_configure -a -O--buildsystem=golang
   dh_auto_build -a -O--buildsystem=golang
	go install -v github.com/docker/notary/client github.com/docker/notary/client/changelist github.com/docker/notary/cmd/notary github.com/docker/notary/cmd/notary-server github.com/docker/notary/cmd/notary-signer github.com/docker/notary/cryptoservice github.com/docker/notary/errors github.com/docker/notary/keystoremanager github.com/docker/notary/pkg/passphrase github.com/docker/notary/proto github.com/docker/notary/server github.com/docker/notary/server/handlers github.com/docker/notary/server/storage github.com/docker/notary/server/timestamp github.com/docker/notary/signer github.com/docker/notary/signer/api github.com/docker/notary/signer/keys github.com/docker/notary/trustmanager github.com/docker/notary/utils github.com/docker/notary/version
github.com/docker/distribution/uuid
github.com/Sirupsen/logrus
github.com/agl/ed25519/edwards25519
github.com/docker/docker/pkg/term
github.com/endophage/gotuf/errors
github.com/jfrazelle/go/canonical/json
github.com/docker/notary/client/changelist
github.com/docker/notary/version
github.com/docker/notary/pkg/passphrase
github.com/spf13/pflag
github.com/BurntSushi/toml
github.com/endophage/gotuf/data
github.com/agl/ed25519
github.com/hashicorp/hcl/hcl/strconv
github.com/docker/notary/trustmanager
github.com/endophage/gotuf/keys
github.com/endophage/gotuf/utils
github.com/endophage/gotuf/signed
github.com/spf13/cobra
github.com/endophage/gotuf/store
github.com/endophage/gotuf
github.com/docker/notary/cryptoservice
github.com/hashicorp/hcl/hcl/token
github.com/kr/text
github.com/hashicorp/hcl/hcl/ast
github.com/hashicorp/hcl/hcl/scanner
github.com/endophage/gotuf/client
github.com/docker/notary/keystoremanager
github.com/hashicorp/hcl/json/token
github.com/hashicorp/hcl/hcl/parser
github.com/hashicorp/hcl/json/scanner
github.com/kr/pretty
github.com/hashicorp/hcl/json/parser
github.com/hashicorp/hcl
github.com/magiconair/properties
github.com/mitchellh/mapstructure
github.com/docker/notary/client
github.com/spf13/jwalterweatherman
github.com/spf13/cast
gopkg.in/fsnotify.v1
gopkg.in/yaml.v2
github.com/gorilla/context
golang.org/x/net/context
github.com/gorilla/mux
golang.org/x/crypto/blowfish
github.com/docker/libtrust
golang.org/x/crypto/bcrypt
github.com/docker/distribution/registry/api/errcode
github.com/docker/distribution/context
github.com/docker/notary/errors
github.com/go-sql-driver/mysql
github.com/docker/distribution/registry/auth
github.com/docker/distribution/registry/auth/htpasswd
github.com/docker/distribution/registry/auth/token
github.com/tent/canonical-json-go
github.com/docker/notary/server/storage
github.com/spf13/viper
github.com/docker/notary/utils
github.com/docker/notary/server/timestamp
github.com/golang/protobuf/proto
google.golang.org/grpc/codes
golang.org/x/oauth2/internal
github.com/docker/notary/server/handlers
github.com/docker/notary/cmd/notary
golang.org/x/oauth2
github.com/docker/notary/server
golang.org/x/oauth2/jws
golang.org/x/oauth2/jwt
google.golang.org/cloud/internal
google.golang.org/cloud/compute/metadata
github.com/golang/glog
golang.org/x/oauth2/google
google.golang.org/grpc/metadata
google.golang.org/grpc/grpclog
github.com/bradfitz/http2/hpack
github.com/dvsekhvalnov/jose2go/base64url
github.com/dvsekhvalnov/jose2go/arrays
github.com/dvsekhvalnov/jose2go/aes
github.com/dvsekhvalnov/jose2go/compact
github.com/dvsekhvalnov/jose2go/kdf
github.com/dvsekhvalnov/jose2go/keys/ecc
github.com/bradfitz/http2
github.com/dvsekhvalnov/jose2go/padding
google.golang.org/grpc/credentials
github.com/dvsekhvalnov/jose2go
github.com/lib/pq/hstore
github.com/qor/inflection
github.com/jinzhu/gorm
github.com/docker/distribution/health
github.com/miekg/pkcs11
google.golang.org/grpc/transport
google.golang.org/grpc
github.com/docker/notary/proto
github.com/docker/notary/signer
github.com/docker/notary/cmd/notary-server
github.com/docker/notary/signer/keys
github.com/docker/notary/signer/api
github.com/docker/notary/cmd/notary-signer
   debian/rules override_dh_auto_test
make[1]: Entering directory '/«PKGBUILDDIR»'
# TODO figure out why these tests fail to compile
DH_GOLANG_EXCLUDES='server/storage' \
	dh_auto_test
	go test -v github.com/docker/notary/client github.com/docker/notary/client/changelist github.com/docker/notary/cmd/notary github.com/docker/notary/cmd/notary-server github.com/docker/notary/cmd/notary-signer github.com/docker/notary/cryptoservice github.com/docker/notary/errors github.com/docker/notary/keystoremanager github.com/docker/notary/pkg/passphrase github.com/docker/notary/proto github.com/docker/notary/server github.com/docker/notary/server/handlers github.com/docker/notary/server/timestamp github.com/docker/notary/signer github.com/docker/notary/signer/api github.com/docker/notary/signer/keys github.com/docker/notary/trustmanager github.com/docker/notary/utils github.com/docker/notary/version
=== RUN   TestValidateRoot
time="2016-01-17T21:57:12Z" level=debug msg="generated ECDSA key with keyID: 5347f84e02b8d3815d4aa42cde51c0563bf34d6fda297e07a9f85d946cedd094" 
time="2016-01-17T21:57:12Z" level=debug msg="Adding cert with certID: e413a69e0d5fa6541621a1ea674b13f0deec7151b008c5bc4c70372c37fde791" 
time="2016-01-17T21:57:12Z" level=debug msg="Linking e413a69e0d5fa6541621a1ea674b13f0deec7151b008c5bc4c70372c37fde791 to 5347f84e02b8d3815d4aa42cde51c0563bf34d6fda297e07a9f85d946cedd094." 
time="2016-01-17T21:57:12Z" level=debug msg="got remote ecdsa timestamp key with keyID: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T21:57:12Z" level=debug msg="generated ECDSA key with keyID: cb995feea0523349500dc324913b0add283216dafd44b99bd3e7ddb83e078349" 
time="2016-01-17T21:57:12Z" level=debug msg="generated new ecdsa key for role: targets and keyID: cb995feea0523349500dc324913b0add283216dafd44b99bd3e7ddb83e078349" 
time="2016-01-17T21:57:12Z" level=debug msg="generated ECDSA key with keyID: 1f01d94124c36db48bcc6f0280145fc3b5c1aeb0cf417b7d718826923f20513e" 
time="2016-01-17T21:57:12Z" level=debug msg="generated new ecdsa key for role: snapshot and keyID: 1f01d94124c36db48bcc6f0280145fc3b5c1aeb0cf417b7d718826923f20513e" 
time="2016-01-17T21:57:12Z" level=debug msg="generating new snapshot..." 
time="2016-01-17T21:57:12Z" level=debug msg="Saving changes to Trusted Collection." 
time="2016-01-17T21:57:12Z" level=debug msg="signing root..." 
time="2016-01-17T21:57:12Z" level=debug msg="sign called with 1 keys" 
time="2016-01-17T21:57:12Z" level=debug msg="Generated list of signing IDs: e413a69e0d5fa6541621a1ea674b13f0deec7151b008c5bc4c70372c37fde791" 
time="2016-01-17T21:57:12Z" level=debug msg="appending ecdsa signature with Key ID: e413a69e0d5fa6541621a1ea674b13f0deec7151b008c5bc4c70372c37fde791" 
time="2016-01-17T21:57:12Z" level=debug msg="appending 1 new signatures" 
time="2016-01-17T21:57:12Z" level=debug msg="sign targets called for role targets" 
time="2016-01-17T21:57:12Z" level=debug msg="sign called with 1 keys" 
time="2016-01-17T21:57:12Z" level=debug msg="Generated list of signing IDs: cb995feea0523349500dc324913b0add283216dafd44b99bd3e7ddb83e078349" 
time="2016-01-17T21:57:12Z" level=debug msg="appending ecdsa signature with Key ID: cb995feea0523349500dc324913b0add283216dafd44b99bd3e7ddb83e078349" 
time="2016-01-17T21:57:12Z" level=debug msg="appending 1 new signatures" 
time="2016-01-17T21:57:12Z" level=debug msg="signing snapshot..." 
time="2016-01-17T21:57:12Z" level=debug msg="sign called with 1 keys" 
time="2016-01-17T21:57:12Z" level=debug msg="Generated list of signing IDs: 1f01d94124c36db48bcc6f0280145fc3b5c1aeb0cf417b7d718826923f20513e" 
time="2016-01-17T21:57:12Z" level=debug msg="appending ecdsa signature with Key ID: 1f01d94124c36db48bcc6f0280145fc3b5c1aeb0cf417b7d718826923f20513e" 
time="2016-01-17T21:57:12Z" level=debug msg="appending 1 new signatures" 
time="2016-01-17T21:57:12Z" level=debug msg="sign targets called for role targets" 
time="2016-01-17T21:57:12Z" level=debug msg="sign called with 1 keys" 
time="2016-01-17T21:57:12Z" level=debug msg="Generated list of signing IDs: cb995feea0523349500dc324913b0add283216dafd44b99bd3e7ddb83e078349" 
time="2016-01-17T21:57:12Z" level=debug msg="appending ecdsa signature with Key ID: cb995feea0523349500dc324913b0add283216dafd44b99bd3e7ddb83e078349" 
time="2016-01-17T21:57:12Z" level=debug msg="appending 1 new signatures" 
time="2016-01-17T21:57:12Z" level=debug msg="signing snapshot..." 
time="2016-01-17T21:57:12Z" level=debug msg="sign called with 1 keys" 
time="2016-01-17T21:57:12Z" level=debug msg="Generated list of signing IDs: 1f01d94124c36db48bcc6f0280145fc3b5c1aeb0cf417b7d718826923f20513e" 
time="2016-01-17T21:57:12Z" level=debug msg="appending ecdsa signature with Key ID: 1f01d94124c36db48bcc6f0280145fc3b5c1aeb0cf417b7d718826923f20513e" 
time="2016-01-17T21:57:12Z" level=debug msg="appending 1 new signatures" 
time="2016-01-17T21:57:12Z" level=debug msg=SignTimestamp 
time="2016-01-17T21:57:12Z" level=debug msg="sign called with 1 keys" 
time="2016-01-17T21:57:12Z" level=debug msg="Generated list of signing IDs: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T21:57:12Z" level=debug msg="appending ecdsa signature with Key ID: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T21:57:12Z" level=debug msg="appending 1 new signatures" 
time="2016-01-17T21:57:12Z" level=debug msg="200 when retrieving metadata for root" 
time="2016-01-17T21:57:12Z" level=debug msg="entered ValidateRoot with dns: docker.com/notary" 
time="2016-01-17T21:57:12Z" level=debug msg="found the following root keys: [e413a69e0d5fa6541621a1ea674b13f0deec7151b008c5bc4c70372c37fde791]" 
time="2016-01-17T21:57:12Z" level=debug msg="found 1 valid leaf certificates for docker.com/notary" 
time="2016-01-17T21:57:12Z" level=debug msg="found 1 valid root certificates for docker.com/notary" 
time="2016-01-17T21:57:12Z" level=debug msg="entering root certificate rotation for: docker.com/notary" 
time="2016-01-17T21:57:12Z" level=debug msg="Adding cert with certID: e413a69e0d5fa6541621a1ea674b13f0deec7151b008c5bc4c70372c37fde791" 
time="2016-01-17T21:57:12Z" level=debug msg="ignoring certificate addition to: docker.com/notary" 
time="2016-01-17T21:57:12Z" level=debug msg="Root validation succeeded for docker.com/notary" 
time="2016-01-17T21:57:12Z" level=debug msg="Adding key 1f01d94124c36db48bcc6f0280145fc3b5c1aeb0cf417b7d718826923f20513e" 
time="2016-01-17T21:57:12Z" level=debug msg="Adding key cb995feea0523349500dc324913b0add283216dafd44b99bd3e7ddb83e078349" 
time="2016-01-17T21:57:12Z" level=debug msg="Adding key e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T21:57:12Z" level=debug msg="Adding key e413a69e0d5fa6541621a1ea674b13f0deec7151b008c5bc4c70372c37fde791" 
time="2016-01-17T21:57:12Z" level=debug msg="Adding role root with keys e413a69e0d5fa6541621a1ea674b13f0deec7151b008c5bc4c70372c37fde791" 
time="2016-01-17T21:57:12Z" level=debug msg="Adding role snapshot with keys 1f01d94124c36db48bcc6f0280145fc3b5c1aeb0cf417b7d718826923f20513e" 
time="2016-01-17T21:57:12Z" level=debug msg="Adding role targets with keys cb995feea0523349500dc324913b0add283216dafd44b99bd3e7ddb83e078349" 
time="2016-01-17T21:57:12Z" level=debug msg="Adding role timestamp with keys e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T21:57:12Z" level=debug msg="updating TUF client" 
time="2016-01-17T21:57:12Z" level=debug msg=downloadTimestamp 
time="2016-01-17T21:57:12Z" level=debug msg="200 when retrieving metadata for timestamp" 
time="2016-01-17T21:57:12Z" level=debug msg="timestamp role has key IDs: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T21:57:12Z" level=debug msg="verifying signature for key ID: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T21:57:12Z" level=debug msg="successfully verified timestamp" 
time="2016-01-17T21:57:12Z" level=debug msg=downloadSnapshot 
time="2016-01-17T21:57:12Z" level=debug msg="hash of snapshot in cache did not match expected hash, must download" 
time="2016-01-17T21:57:12Z" level=debug msg="200 when retrieving metadata for snapshot" 
time="2016-01-17T21:57:12Z" level=debug msg="snapshot role has key IDs: 1f01d94124c36db48bcc6f0280145fc3b5c1aeb0cf417b7d718826923f20513e" 
time="2016-01-17T21:57:12Z" level=debug msg="verifying signature for key ID: 1f01d94124c36db48bcc6f0280145fc3b5c1aeb0cf417b7d718826923f20513e" 
time="2016-01-17T21:57:12Z" level=debug msg="successfully verified snapshot" 
time="2016-01-17T21:57:12Z" level=debug msg="200 when retrieving metadata for targets" 
time="2016-01-17T21:57:12Z" level=debug msg="targets role has key IDs: cb995feea0523349500dc324913b0add283216dafd44b99bd3e7ddb83e078349" 
time="2016-01-17T21:57:12Z" level=debug msg="verifying signature for key ID: cb995feea0523349500dc324913b0add283216dafd44b99bd3e7ddb83e078349" 
time="2016-01-17T21:57:12Z" level=debug msg="successfully verified targets" 
time="2016-01-17T21:57:12Z" level=debug msg="200 when retrieving metadata for root" 
time="2016-01-17T21:57:12Z" level=debug msg="entered ValidateRoot with dns: docker.com/notary" 
time="2016-01-17T21:57:12Z" level=debug msg="found the following root keys: [e413a69e0d5fa6541621a1ea674b13f0deec7151b008c5bc4c70372c37fde791]" 
time="2016-01-17T21:57:12Z" level=debug msg="found 1 valid leaf certificates for docker.com/notary" 
time="2016-01-17T21:57:12Z" level=debug msg="found no currently valid root certificates for docker.com/notary" 
time="2016-01-17T21:57:12Z" level=debug msg="entering root certificate rotation for: docker.com/notary" 
time="2016-01-17T21:57:12Z" level=debug msg="Adding cert with certID: e413a69e0d5fa6541621a1ea674b13f0deec7151b008c5bc4c70372c37fde791" 
time="2016-01-17T21:57:12Z" level=debug msg="Root validation succeeded for docker.com/notary" 
time="2016-01-17T21:57:12Z" level=debug msg="Adding key e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T21:57:12Z" level=debug msg="Adding key e413a69e0d5fa6541621a1ea674b13f0deec7151b008c5bc4c70372c37fde791" 
time="2016-01-17T21:57:12Z" level=debug msg="Adding key 1f01d94124c36db48bcc6f0280145fc3b5c1aeb0cf417b7d718826923f20513e" 
time="2016-01-17T21:57:12Z" level=debug msg="Adding key cb995feea0523349500dc324913b0add283216dafd44b99bd3e7ddb83e078349" 
time="2016-01-17T21:57:12Z" level=debug msg="Adding role root with keys e413a69e0d5fa6541621a1ea674b13f0deec7151b008c5bc4c70372c37fde791" 
time="2016-01-17T21:57:12Z" level=debug msg="Adding role snapshot with keys 1f01d94124c36db48bcc6f0280145fc3b5c1aeb0cf417b7d718826923f20513e" 
time="2016-01-17T21:57:12Z" level=debug msg="Adding role targets with keys cb995feea0523349500dc324913b0add283216dafd44b99bd3e7ddb83e078349" 
time="2016-01-17T21:57:12Z" level=debug msg="Adding role timestamp with keys e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T21:57:12Z" level=debug msg="updating TUF client" 
time="2016-01-17T21:57:12Z" level=debug msg=downloadTimestamp 
time="2016-01-17T21:57:12Z" level=debug msg="200 when retrieving metadata for timestamp" 
time="2016-01-17T21:57:12Z" level=debug msg="timestamp role has key IDs: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T21:57:12Z" level=debug msg="verifying signature for key ID: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T21:57:12Z" level=debug msg="successfully verified timestamp" 
time="2016-01-17T21:57:12Z" level=debug msg=downloadSnapshot 
time="2016-01-17T21:57:12Z" level=debug msg="using cached snapshot" 
time="2016-01-17T21:57:12Z" level=debug msg="snapshot role has key IDs: 1f01d94124c36db48bcc6f0280145fc3b5c1aeb0cf417b7d718826923f20513e" 
time="2016-01-17T21:57:12Z" level=debug msg="verifying signature for key ID: 1f01d94124c36db48bcc6f0280145fc3b5c1aeb0cf417b7d718826923f20513e" 
time="2016-01-17T21:57:12Z" level=debug msg="successfully verified snapshot" 
time="2016-01-17T21:57:12Z" level=debug msg="using cached targets" 
time="2016-01-17T21:57:12Z" level=debug msg="targets role has key IDs: cb995feea0523349500dc324913b0add283216dafd44b99bd3e7ddb83e078349" 
time="2016-01-17T21:57:12Z" level=debug msg="verifying signature for key ID: cb995feea0523349500dc324913b0add283216dafd44b99bd3e7ddb83e078349" 
time="2016-01-17T21:57:13Z" level=debug msg="successfully verified targets" 
time="2016-01-17T21:57:13Z" level=debug msg="Adding cert with certID: 6cf217b914676bd9e71daabf0a5a75f6c71114bce0801fbd17e63f827435968c" 
time="2016-01-17T21:57:13Z" level=debug msg="200 when retrieving metadata for root" 
time="2016-01-17T21:57:13Z" level=debug msg="entered ValidateRoot with dns: docker.com/notary" 
time="2016-01-17T21:57:13Z" level=debug msg="found the following root keys: [e413a69e0d5fa6541621a1ea674b13f0deec7151b008c5bc4c70372c37fde791]" 
time="2016-01-17T21:57:13Z" level=debug msg="found 1 valid leaf certificates for docker.com/notary" 
time="2016-01-17T21:57:13Z" level=debug msg="found 1 valid root certificates for docker.com/notary" 
time="2016-01-17T21:57:13Z" level=debug msg="continuing b/c signing key isn't present in keys: e413a69e0d5fa6541621a1ea674b13f0deec7151b008c5bc4c70372c37fde791\n" 
time="2016-01-17T21:57:13Z" level=debug msg="failed to verify TUF data for: docker.com/notary, valid signatures did not meet threshold" 
time="2016-01-17T21:59:25Z" level=debug msg="generated RSA key with keyID: 5565e198654d1cbfd8de405454fc892cde0c5b755504c031ead6ca982ea0eaaa" 
time="2016-01-17T21:59:26Z" level=debug msg="Adding cert with certID: 96ed34d2bf9d055fd29e789929da15f782535c10bb305a38cd509076ad86b5d4" 
time="2016-01-17T21:59:26Z" level=debug msg="Linking 96ed34d2bf9d055fd29e789929da15f782535c10bb305a38cd509076ad86b5d4 to 5565e198654d1cbfd8de405454fc892cde0c5b755504c031ead6ca982ea0eaaa." 
time="2016-01-17T21:59:26Z" level=debug msg="got remote ecdsa timestamp key with keyID: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T21:59:26Z" level=debug msg="generated ECDSA key with keyID: cf659cf8cbdf16b904d27abcf0ec3f8e8259dc2d2190bc33941d3a7b1f9458df" 
time="2016-01-17T21:59:26Z" level=debug msg="generated new ecdsa key for role: targets and keyID: cf659cf8cbdf16b904d27abcf0ec3f8e8259dc2d2190bc33941d3a7b1f9458df" 
time="2016-01-17T21:59:26Z" level=debug msg="generated ECDSA key with keyID: e31fb7c60bebe96910122035ddbf5148b0814036fef849aded8b78b5d1f4487b" 
time="2016-01-17T21:59:26Z" level=debug msg="generated new ecdsa key for role: snapshot and keyID: e31fb7c60bebe96910122035ddbf5148b0814036fef849aded8b78b5d1f4487b" 
time="2016-01-17T21:59:26Z" level=debug msg="generating new snapshot..." 
time="2016-01-17T21:59:26Z" level=debug msg="Saving changes to Trusted Collection." 
time="2016-01-17T21:59:26Z" level=debug msg="signing root..." 
time="2016-01-17T21:59:26Z" level=debug msg="sign called with 1 keys" 
time="2016-01-17T21:59:26Z" level=debug msg="Generated list of signing IDs: 96ed34d2bf9d055fd29e789929da15f782535c10bb305a38cd509076ad86b5d4" 
time="2016-01-17T21:59:27Z" level=debug msg="appending rsa signature with Key ID: 96ed34d2bf9d055fd29e789929da15f782535c10bb305a38cd509076ad86b5d4" 
time="2016-01-17T21:59:27Z" level=debug msg="appending 1 new signatures" 
time="2016-01-17T21:59:27Z" level=debug msg="sign targets called for role targets" 
time="2016-01-17T21:59:27Z" level=debug msg="sign called with 1 keys" 
time="2016-01-17T21:59:27Z" level=debug msg="Generated list of signing IDs: cf659cf8cbdf16b904d27abcf0ec3f8e8259dc2d2190bc33941d3a7b1f9458df" 
time="2016-01-17T21:59:27Z" level=debug msg="appending ecdsa signature with Key ID: cf659cf8cbdf16b904d27abcf0ec3f8e8259dc2d2190bc33941d3a7b1f9458df" 
time="2016-01-17T21:59:27Z" level=debug msg="appending 1 new signatures" 
time="2016-01-17T21:59:27Z" level=debug msg="signing snapshot..." 
time="2016-01-17T21:59:27Z" level=debug msg="sign called with 1 keys" 
time="2016-01-17T21:59:27Z" level=debug msg="Generated list of signing IDs: e31fb7c60bebe96910122035ddbf5148b0814036fef849aded8b78b5d1f4487b" 
time="2016-01-17T21:59:27Z" level=debug msg="appending ecdsa signature with Key ID: e31fb7c60bebe96910122035ddbf5148b0814036fef849aded8b78b5d1f4487b" 
time="2016-01-17T21:59:27Z" level=debug msg="appending 1 new signatures" 
time="2016-01-17T21:59:27Z" level=debug msg="sign targets called for role targets" 
time="2016-01-17T21:59:27Z" level=debug msg="sign called with 1 keys" 
time="2016-01-17T21:59:27Z" level=debug msg="Generated list of signing IDs: cf659cf8cbdf16b904d27abcf0ec3f8e8259dc2d2190bc33941d3a7b1f9458df" 
time="2016-01-17T21:59:27Z" level=debug msg="appending ecdsa signature with Key ID: cf659cf8cbdf16b904d27abcf0ec3f8e8259dc2d2190bc33941d3a7b1f9458df" 
time="2016-01-17T21:59:27Z" level=debug msg="appending 1 new signatures" 
time="2016-01-17T21:59:27Z" level=debug msg="signing snapshot..." 
time="2016-01-17T21:59:27Z" level=debug msg="sign called with 1 keys" 
time="2016-01-17T21:59:27Z" level=debug msg="Generated list of signing IDs: e31fb7c60bebe96910122035ddbf5148b0814036fef849aded8b78b5d1f4487b" 
time="2016-01-17T21:59:27Z" level=debug msg="appending ecdsa signature with Key ID: e31fb7c60bebe96910122035ddbf5148b0814036fef849aded8b78b5d1f4487b" 
time="2016-01-17T21:59:27Z" level=debug msg="appending 1 new signatures" 
time="2016-01-17T21:59:27Z" level=debug msg=SignTimestamp 
time="2016-01-17T21:59:27Z" level=debug msg="sign called with 1 keys" 
time="2016-01-17T21:59:27Z" level=debug msg="Generated list of signing IDs: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T21:59:27Z" level=debug msg="appending ecdsa signature with Key ID: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T21:59:27Z" level=debug msg="appending 1 new signatures" 
time="2016-01-17T21:59:27Z" level=debug msg="200 when retrieving metadata for root" 
time="2016-01-17T21:59:27Z" level=debug msg="entered ValidateRoot with dns: docker.com/notary" 
time="2016-01-17T21:59:27Z" level=debug msg="found the following root keys: [96ed34d2bf9d055fd29e789929da15f782535c10bb305a38cd509076ad86b5d4]" 
time="2016-01-17T21:59:27Z" level=debug msg="found 1 valid leaf certificates for docker.com/notary" 
time="2016-01-17T21:59:27Z" level=debug msg="found 1 valid root certificates for docker.com/notary" 
time="2016-01-17T21:59:27Z" level=debug msg="entering root certificate rotation for: docker.com/notary" 
time="2016-01-17T21:59:27Z" level=debug msg="Adding cert with certID: 96ed34d2bf9d055fd29e789929da15f782535c10bb305a38cd509076ad86b5d4" 
time="2016-01-17T21:59:27Z" level=debug msg="ignoring certificate addition to: docker.com/notary" 
time="2016-01-17T21:59:27Z" level=debug msg="Root validation succeeded for docker.com/notary" 
time="2016-01-17T21:59:27Z" level=debug msg="Adding key e31fb7c60bebe96910122035ddbf5148b0814036fef849aded8b78b5d1f4487b" 
time="2016-01-17T21:59:27Z" level=debug msg="Adding key e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T21:59:27Z" level=debug msg="Adding key 96ed34d2bf9d055fd29e789929da15f782535c10bb305a38cd509076ad86b5d4" 
time="2016-01-17T21:59:27Z" level=debug msg="Adding key cf659cf8cbdf16b904d27abcf0ec3f8e8259dc2d2190bc33941d3a7b1f9458df" 
time="2016-01-17T21:59:27Z" level=debug msg="Adding role snapshot with keys e31fb7c60bebe96910122035ddbf5148b0814036fef849aded8b78b5d1f4487b" 
time="2016-01-17T21:59:27Z" level=debug msg="Adding role targets with keys cf659cf8cbdf16b904d27abcf0ec3f8e8259dc2d2190bc33941d3a7b1f9458df" 
time="2016-01-17T21:59:27Z" level=debug msg="Adding role timestamp with keys e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T21:59:27Z" level=debug msg="Adding role root with keys 96ed34d2bf9d055fd29e789929da15f782535c10bb305a38cd509076ad86b5d4" 
time="2016-01-17T21:59:27Z" level=debug msg="updating TUF client" 
time="2016-01-17T21:59:27Z" level=debug msg=downloadTimestamp 
time="2016-01-17T21:59:27Z" level=debug msg="200 when retrieving metadata for timestamp" 
time="2016-01-17T21:59:27Z" level=debug msg="timestamp role has key IDs: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T21:59:27Z" level=debug msg="verifying signature for key ID: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T21:59:27Z" level=debug msg="successfully verified timestamp" 
time="2016-01-17T21:59:27Z" level=debug msg=downloadSnapshot 
time="2016-01-17T21:59:27Z" level=debug msg="hash of snapshot in cache did not match expected hash, must download" 
time="2016-01-17T21:59:27Z" level=debug msg="200 when retrieving metadata for snapshot" 
time="2016-01-17T21:59:27Z" level=debug msg="snapshot role has key IDs: e31fb7c60bebe96910122035ddbf5148b0814036fef849aded8b78b5d1f4487b" 
time="2016-01-17T21:59:27Z" level=debug msg="verifying signature for key ID: e31fb7c60bebe96910122035ddbf5148b0814036fef849aded8b78b5d1f4487b" 
time="2016-01-17T21:59:27Z" level=debug msg="successfully verified snapshot" 
time="2016-01-17T21:59:27Z" level=debug msg="200 when retrieving metadata for targets" 
time="2016-01-17T21:59:27Z" level=debug msg="targets role has key IDs: cf659cf8cbdf16b904d27abcf0ec3f8e8259dc2d2190bc33941d3a7b1f9458df" 
time="2016-01-17T21:59:27Z" level=debug msg="verifying signature for key ID: cf659cf8cbdf16b904d27abcf0ec3f8e8259dc2d2190bc33941d3a7b1f9458df" 
time="2016-01-17T21:59:27Z" level=debug msg="successfully verified targets" 
time="2016-01-17T21:59:27Z" level=debug msg="200 when retrieving metadata for root" 
time="2016-01-17T21:59:27Z" level=debug msg="entered ValidateRoot with dns: docker.com/notary" 
time="2016-01-17T21:59:27Z" level=debug msg="found the following root keys: [96ed34d2bf9d055fd29e789929da15f782535c10bb305a38cd509076ad86b5d4]" 
time="2016-01-17T21:59:27Z" level=debug msg="found 1 valid leaf certificates for docker.com/notary" 
time="2016-01-17T21:59:27Z" level=debug msg="found no currently valid root certificates for docker.com/notary" 
time="2016-01-17T21:59:27Z" level=debug msg="entering root certificate rotation for: docker.com/notary" 
time="2016-01-17T21:59:27Z" level=debug msg="Adding cert with certID: 96ed34d2bf9d055fd29e789929da15f782535c10bb305a38cd509076ad86b5d4" 
time="2016-01-17T21:59:27Z" level=debug msg="Root validation succeeded for docker.com/notary" 
time="2016-01-17T21:59:27Z" level=debug msg="Adding key e31fb7c60bebe96910122035ddbf5148b0814036fef849aded8b78b5d1f4487b" 
time="2016-01-17T21:59:27Z" level=debug msg="Adding key e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T21:59:27Z" level=debug msg="Adding key 96ed34d2bf9d055fd29e789929da15f782535c10bb305a38cd509076ad86b5d4" 
time="2016-01-17T21:59:27Z" level=debug msg="Adding key cf659cf8cbdf16b904d27abcf0ec3f8e8259dc2d2190bc33941d3a7b1f9458df" 
time="2016-01-17T21:59:27Z" level=debug msg="Adding role root with keys 96ed34d2bf9d055fd29e789929da15f782535c10bb305a38cd509076ad86b5d4" 
time="2016-01-17T21:59:27Z" level=debug msg="Adding role snapshot with keys e31fb7c60bebe96910122035ddbf5148b0814036fef849aded8b78b5d1f4487b" 
time="2016-01-17T21:59:27Z" level=debug msg="Adding role targets with keys cf659cf8cbdf16b904d27abcf0ec3f8e8259dc2d2190bc33941d3a7b1f9458df" 
time="2016-01-17T21:59:27Z" level=debug msg="Adding role timestamp with keys e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T21:59:27Z" level=debug msg="updating TUF client" 
time="2016-01-17T21:59:27Z" level=debug msg=downloadTimestamp 
time="2016-01-17T21:59:27Z" level=debug msg="200 when retrieving metadata for timestamp" 
time="2016-01-17T21:59:27Z" level=debug msg="timestamp role has key IDs: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T21:59:27Z" level=debug msg="verifying signature for key ID: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T21:59:27Z" level=debug msg="successfully verified timestamp" 
time="2016-01-17T21:59:27Z" level=debug msg=downloadSnapshot 
time="2016-01-17T21:59:27Z" level=debug msg="using cached snapshot" 
time="2016-01-17T21:59:27Z" level=debug msg="snapshot role has key IDs: e31fb7c60bebe96910122035ddbf5148b0814036fef849aded8b78b5d1f4487b" 
time="2016-01-17T21:59:27Z" level=debug msg="verifying signature for key ID: e31fb7c60bebe96910122035ddbf5148b0814036fef849aded8b78b5d1f4487b" 
time="2016-01-17T21:59:27Z" level=debug msg="successfully verified snapshot" 
time="2016-01-17T21:59:27Z" level=debug msg="using cached targets" 
time="2016-01-17T21:59:27Z" level=debug msg="targets role has key IDs: cf659cf8cbdf16b904d27abcf0ec3f8e8259dc2d2190bc33941d3a7b1f9458df" 
time="2016-01-17T21:59:27Z" level=debug msg="verifying signature for key ID: cf659cf8cbdf16b904d27abcf0ec3f8e8259dc2d2190bc33941d3a7b1f9458df" 
time="2016-01-17T21:59:27Z" level=debug msg="successfully verified targets" 
time="2016-01-17T21:59:27Z" level=debug msg="Adding cert with certID: 6cf217b914676bd9e71daabf0a5a75f6c71114bce0801fbd17e63f827435968c" 
time="2016-01-17T21:59:27Z" level=debug msg="200 when retrieving metadata for root" 
time="2016-01-17T21:59:27Z" level=debug msg="entered ValidateRoot with dns: docker.com/notary" 
time="2016-01-17T21:59:27Z" level=debug msg="found the following root keys: [96ed34d2bf9d055fd29e789929da15f782535c10bb305a38cd509076ad86b5d4]" 
time="2016-01-17T21:59:27Z" level=debug msg="found 1 valid leaf certificates for docker.com/notary" 
time="2016-01-17T21:59:27Z" level=debug msg="found 1 valid root certificates for docker.com/notary" 
time="2016-01-17T21:59:27Z" level=debug msg="continuing b/c signing key isn't present in keys: 96ed34d2bf9d055fd29e789929da15f782535c10bb305a38cd509076ad86b5d4\n" 
time="2016-01-17T21:59:27Z" level=debug msg="failed to verify TUF data for: docker.com/notary, valid signatures did not meet threshold" 
--- PASS: TestValidateRoot (135.59s)
=== RUN   TestInitRepo
time="2016-01-17T21:59:27Z" level=debug msg="generated ECDSA key with keyID: 6b739fb00974945a727322ec7ed9b4388e7af4e00b45d53eb19e5777f014da8d" 
time="2016-01-17T21:59:27Z" level=debug msg="Adding cert with certID: 6d1288761dd9c67684a89208327f43e8b00332cf584837f440dc638e37f054cd" 
time="2016-01-17T21:59:27Z" level=debug msg="Linking 6d1288761dd9c67684a89208327f43e8b00332cf584837f440dc638e37f054cd to 6b739fb00974945a727322ec7ed9b4388e7af4e00b45d53eb19e5777f014da8d." 
time="2016-01-17T21:59:27Z" level=debug msg="got remote ecdsa timestamp key with keyID: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T21:59:27Z" level=debug msg="generated ECDSA key with keyID: e5781c2a62c8640b957a1e5b6a1335bf17cfaa34e810d6344326dc7034213ad8" 
time="2016-01-17T21:59:27Z" level=debug msg="generated new ecdsa key for role: targets and keyID: e5781c2a62c8640b957a1e5b6a1335bf17cfaa34e810d6344326dc7034213ad8" 
time="2016-01-17T21:59:27Z" level=debug msg="generated ECDSA key with keyID: 8575b943c770a0000389196aaefce77dc351657b9c481dc480bbf8d5c8650679" 
time="2016-01-17T21:59:27Z" level=debug msg="generated new ecdsa key for role: snapshot and keyID: 8575b943c770a0000389196aaefce77dc351657b9c481dc480bbf8d5c8650679" 
time="2016-01-17T21:59:27Z" level=debug msg="generating new snapshot..." 
time="2016-01-17T21:59:27Z" level=debug msg="Saving changes to Trusted Collection." 
time="2016-01-17T21:59:27Z" level=debug msg="signing root..." 
time="2016-01-17T21:59:27Z" level=debug msg="sign called with 1 keys" 
time="2016-01-17T21:59:27Z" level=debug msg="Generated list of signing IDs: 6d1288761dd9c67684a89208327f43e8b00332cf584837f440dc638e37f054cd" 
time="2016-01-17T21:59:27Z" level=debug msg="appending ecdsa signature with Key ID: 6d1288761dd9c67684a89208327f43e8b00332cf584837f440dc638e37f054cd" 
time="2016-01-17T21:59:27Z" level=debug msg="appending 1 new signatures" 
time="2016-01-17T21:59:27Z" level=debug msg="sign targets called for role targets" 
time="2016-01-17T21:59:27Z" level=debug msg="sign called with 1 keys" 
time="2016-01-17T21:59:27Z" level=debug msg="Generated list of signing IDs: e5781c2a62c8640b957a1e5b6a1335bf17cfaa34e810d6344326dc7034213ad8" 
time="2016-01-17T21:59:27Z" level=debug msg="appending ecdsa signature with Key ID: e5781c2a62c8640b957a1e5b6a1335bf17cfaa34e810d6344326dc7034213ad8" 
time="2016-01-17T21:59:27Z" level=debug msg="appending 1 new signatures" 
time="2016-01-17T21:59:27Z" level=debug msg="signing snapshot..." 
time="2016-01-17T21:59:27Z" level=debug msg="sign called with 1 keys" 
time="2016-01-17T21:59:27Z" level=debug msg="Generated list of signing IDs: 8575b943c770a0000389196aaefce77dc351657b9c481dc480bbf8d5c8650679" 
time="2016-01-17T21:59:27Z" level=debug msg="appending ecdsa signature with Key ID: 8575b943c770a0000389196aaefce77dc351657b9c481dc480bbf8d5c8650679" 
time="2016-01-17T21:59:27Z" level=debug msg="appending 1 new signatures" 
time="2016-01-17T22:00:39Z" level=debug msg="generated RSA key with keyID: cf2b4bdcac269b5aba3343b1a42fde6e34764c5aacfb95e25a54124b0da2300d" 
time="2016-01-17T22:00:40Z" level=debug msg="Adding cert with certID: c0d7a6fe74327418b922db8cc868abbe0a8a333ee55c5db1c37bc18feb8600c8" 
time="2016-01-17T22:00:40Z" level=debug msg="Linking c0d7a6fe74327418b922db8cc868abbe0a8a333ee55c5db1c37bc18feb8600c8 to cf2b4bdcac269b5aba3343b1a42fde6e34764c5aacfb95e25a54124b0da2300d." 
time="2016-01-17T22:00:40Z" level=debug msg="got remote ecdsa timestamp key with keyID: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T22:00:40Z" level=debug msg="generated ECDSA key with keyID: 284567e4430f1c57514b25b08ab166d3b626cb0c075cae5e53aebbf7a52e2de0" 
time="2016-01-17T22:00:40Z" level=debug msg="generated new ecdsa key for role: targets and keyID: 284567e4430f1c57514b25b08ab166d3b626cb0c075cae5e53aebbf7a52e2de0" 
time="2016-01-17T22:00:40Z" level=debug msg="generated ECDSA key with keyID: 1cbe114b2f63db229706c425f0ddecfd3b919e7741ef52c564ca0ed1fc17f7e4" 
time="2016-01-17T22:00:40Z" level=debug msg="generated new ecdsa key for role: snapshot and keyID: 1cbe114b2f63db229706c425f0ddecfd3b919e7741ef52c564ca0ed1fc17f7e4" 
time="2016-01-17T22:00:40Z" level=debug msg="generating new snapshot..." 
time="2016-01-17T22:00:40Z" level=debug msg="Saving changes to Trusted Collection." 
time="2016-01-17T22:00:40Z" level=debug msg="signing root..." 
time="2016-01-17T22:00:40Z" level=debug msg="sign called with 1 keys" 
time="2016-01-17T22:00:40Z" level=debug msg="Generated list of signing IDs: c0d7a6fe74327418b922db8cc868abbe0a8a333ee55c5db1c37bc18feb8600c8" 
time="2016-01-17T22:00:41Z" level=debug msg="appending rsa signature with Key ID: c0d7a6fe74327418b922db8cc868abbe0a8a333ee55c5db1c37bc18feb8600c8" 
time="2016-01-17T22:00:41Z" level=debug msg="appending 1 new signatures" 
time="2016-01-17T22:00:41Z" level=debug msg="sign targets called for role targets" 
time="2016-01-17T22:00:41Z" level=debug msg="sign called with 1 keys" 
time="2016-01-17T22:00:41Z" level=debug msg="Generated list of signing IDs: 284567e4430f1c57514b25b08ab166d3b626cb0c075cae5e53aebbf7a52e2de0" 
time="2016-01-17T22:00:41Z" level=debug msg="appending ecdsa signature with Key ID: 284567e4430f1c57514b25b08ab166d3b626cb0c075cae5e53aebbf7a52e2de0" 
time="2016-01-17T22:00:41Z" level=debug msg="appending 1 new signatures" 
time="2016-01-17T22:00:41Z" level=debug msg="signing snapshot..." 
time="2016-01-17T22:00:41Z" level=debug msg="sign called with 1 keys" 
time="2016-01-17T22:00:41Z" level=debug msg="Generated list of signing IDs: 1cbe114b2f63db229706c425f0ddecfd3b919e7741ef52c564ca0ed1fc17f7e4" 
time="2016-01-17T22:00:41Z" level=debug msg="appending ecdsa signature with Key ID: 1cbe114b2f63db229706c425f0ddecfd3b919e7741ef52c564ca0ed1fc17f7e4" 
time="2016-01-17T22:00:41Z" level=debug msg="appending 1 new signatures" 
--- PASS: TestInitRepo (73.83s)
=== RUN   TestAddListTarget
time="2016-01-17T22:00:41Z" level=debug msg="generated ECDSA key with keyID: 1a7f6b1c3334042b486f137fd86e598984ab504d7d9d599ff01149da7e2609c4" 
time="2016-01-17T22:00:41Z" level=debug msg="Adding cert with certID: bc61c9b69f33042db07f9ace68feb167dbbb385462032a84cade8961852644db" 
time="2016-01-17T22:00:41Z" level=debug msg="Linking bc61c9b69f33042db07f9ace68feb167dbbb385462032a84cade8961852644db to 1a7f6b1c3334042b486f137fd86e598984ab504d7d9d599ff01149da7e2609c4." 
time="2016-01-17T22:00:41Z" level=debug msg="got remote ecdsa timestamp key with keyID: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T22:00:41Z" level=debug msg="generated ECDSA key with keyID: cb8ef282a7856f9b8a4a26f33fe794c0e4c0cea5904d74cf809e407e73458afd" 
time="2016-01-17T22:00:41Z" level=debug msg="generated new ecdsa key for role: targets and keyID: cb8ef282a7856f9b8a4a26f33fe794c0e4c0cea5904d74cf809e407e73458afd" 
time="2016-01-17T22:00:41Z" level=debug msg="generated ECDSA key with keyID: c50f7c2865cdfcc9fe3699dbe9c597887fe71340c0f8f066012468f14c224bdb" 
time="2016-01-17T22:00:41Z" level=debug msg="generated new ecdsa key for role: snapshot and keyID: c50f7c2865cdfcc9fe3699dbe9c597887fe71340c0f8f066012468f14c224bdb" 
time="2016-01-17T22:00:41Z" level=debug msg="generating new snapshot..." 
time="2016-01-17T22:00:41Z" level=debug msg="Saving changes to Trusted Collection." 
time="2016-01-17T22:00:41Z" level=debug msg="signing root..." 
time="2016-01-17T22:00:41Z" level=debug msg="sign called with 1 keys" 
time="2016-01-17T22:00:41Z" level=debug msg="Generated list of signing IDs: bc61c9b69f33042db07f9ace68feb167dbbb385462032a84cade8961852644db" 
time="2016-01-17T22:00:41Z" level=debug msg="appending ecdsa signature with Key ID: bc61c9b69f33042db07f9ace68feb167dbbb385462032a84cade8961852644db" 
time="2016-01-17T22:00:41Z" level=debug msg="appending 1 new signatures" 
time="2016-01-17T22:00:41Z" level=debug msg="sign targets called for role targets" 
time="2016-01-17T22:00:41Z" level=debug msg="sign called with 1 keys" 
time="2016-01-17T22:00:41Z" level=debug msg="Generated list of signing IDs: cb8ef282a7856f9b8a4a26f33fe794c0e4c0cea5904d74cf809e407e73458afd" 
time="2016-01-17T22:00:41Z" level=debug msg="appending ecdsa signature with Key ID: cb8ef282a7856f9b8a4a26f33fe794c0e4c0cea5904d74cf809e407e73458afd" 
time="2016-01-17T22:00:41Z" level=debug msg="appending 1 new signatures" 
time="2016-01-17T22:00:41Z" level=debug msg="signing snapshot..." 
time="2016-01-17T22:00:41Z" level=debug msg="sign called with 1 keys" 
time="2016-01-17T22:00:41Z" level=debug msg="Generated list of signing IDs: c50f7c2865cdfcc9fe3699dbe9c597887fe71340c0f8f066012468f14c224bdb" 
time="2016-01-17T22:00:41Z" level=debug msg="appending ecdsa signature with Key ID: c50f7c2865cdfcc9fe3699dbe9c597887fe71340c0f8f066012468f14c224bdb" 
time="2016-01-17T22:00:41Z" level=debug msg="appending 1 new signatures" 
time="2016-01-17T22:00:41Z" level=debug msg="Making dir path: /tmp/notary-test-467192572/tuf/docker.com/notary/changelist" 
time="2016-01-17T22:00:41Z" level=debug msg="Adding target \"latest\" with sha256 \"6a25d3ec9106e843b34d7ef4af13b6300c320f9aa008269b49ef629a604b943c\" and size 2213 bytes.\n" 
time="2016-01-17T22:00:41Z" level=debug msg="Making dir path: /tmp/notary-test-467192572/tuf/docker.com/notary/changelist" 
time="2016-01-17T22:00:41Z" level=debug msg="Adding target \"current\" with sha256 \"6a25d3ec9106e843b34d7ef4af13b6300c320f9aa008269b49ef629a604b943c\" and size 2213 bytes.\n" 
time="2016-01-17T22:00:41Z" level=debug msg="Making dir path: /tmp/notary-test-467192572/tuf/docker.com/notary/changelist" 
time="2016-01-17T22:00:41Z" level=debug msg="applying 2 changes" 
time="2016-01-17T22:00:41Z" level=debug msg="changelist add: latest" 
time="2016-01-17T22:00:41Z" level=debug msg="changelist add: current" 
time="2016-01-17T22:00:41Z" level=debug msg="sign targets called for role targets" 
time="2016-01-17T22:00:41Z" level=debug msg="sign called with 1 keys" 
time="2016-01-17T22:00:41Z" level=debug msg="Generated list of signing IDs: cb8ef282a7856f9b8a4a26f33fe794c0e4c0cea5904d74cf809e407e73458afd" 
time="2016-01-17T22:00:41Z" level=debug msg="appending ecdsa signature with Key ID: cb8ef282a7856f9b8a4a26f33fe794c0e4c0cea5904d74cf809e407e73458afd" 
time="2016-01-17T22:00:41Z" level=debug msg="appending 1 new signatures" 
time="2016-01-17T22:00:41Z" level=debug msg="signing snapshot..." 
time="2016-01-17T22:00:41Z" level=debug msg="sign called with 1 keys" 
time="2016-01-17T22:00:41Z" level=debug msg="Generated list of signing IDs: c50f7c2865cdfcc9fe3699dbe9c597887fe71340c0f8f066012468f14c224bdb" 
time="2016-01-17T22:00:41Z" level=debug msg="appending ecdsa signature with Key ID: c50f7c2865cdfcc9fe3699dbe9c597887fe71340c0f8f066012468f14c224bdb" 
time="2016-01-17T22:00:41Z" level=debug msg="appending 1 new signatures" 
time="2016-01-17T22:00:41Z" level=debug msg=SignTimestamp 
time="2016-01-17T22:00:41Z" level=debug msg="sign called with 1 keys" 
time="2016-01-17T22:00:41Z" level=debug msg="Generated list of signing IDs: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T22:00:41Z" level=debug msg="appending ecdsa signature with Key ID: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T22:00:41Z" level=debug msg="appending 1 new signatures" 
time="2016-01-17T22:00:41Z" level=debug msg="200 when retrieving metadata for root" 
time="2016-01-17T22:00:41Z" level=debug msg="entered ValidateRoot with dns: docker.com/notary" 
time="2016-01-17T22:00:41Z" level=debug msg="found the following root keys: [bc61c9b69f33042db07f9ace68feb167dbbb385462032a84cade8961852644db]" 
time="2016-01-17T22:00:41Z" level=debug msg="found 1 valid leaf certificates for docker.com/notary" 
time="2016-01-17T22:00:41Z" level=debug msg="found 1 valid root certificates for docker.com/notary" 
time="2016-01-17T22:00:41Z" level=debug msg="entering root certificate rotation for: docker.com/notary" 
time="2016-01-17T22:00:41Z" level=debug msg="Adding cert with certID: bc61c9b69f33042db07f9ace68feb167dbbb385462032a84cade8961852644db" 
time="2016-01-17T22:00:41Z" level=debug msg="ignoring certificate addition to: docker.com/notary" 
time="2016-01-17T22:00:41Z" level=debug msg="Root validation succeeded for docker.com/notary" 
time="2016-01-17T22:00:41Z" level=debug msg="Adding key bc61c9b69f33042db07f9ace68feb167dbbb385462032a84cade8961852644db" 
time="2016-01-17T22:00:41Z" level=debug msg="Adding key c50f7c2865cdfcc9fe3699dbe9c597887fe71340c0f8f066012468f14c224bdb" 
time="2016-01-17T22:00:41Z" level=debug msg="Adding key cb8ef282a7856f9b8a4a26f33fe794c0e4c0cea5904d74cf809e407e73458afd" 
time="2016-01-17T22:00:41Z" level=debug msg="Adding key e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T22:00:41Z" level=debug msg="Adding role timestamp with keys e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T22:00:41Z" level=debug msg="Adding role root with keys bc61c9b69f33042db07f9ace68feb167dbbb385462032a84cade8961852644db" 
time="2016-01-17T22:00:41Z" level=debug msg="Adding role snapshot with keys c50f7c2865cdfcc9fe3699dbe9c597887fe71340c0f8f066012468f14c224bdb" 
time="2016-01-17T22:00:41Z" level=debug msg="Adding role targets with keys cb8ef282a7856f9b8a4a26f33fe794c0e4c0cea5904d74cf809e407e73458afd" 
time="2016-01-17T22:00:41Z" level=debug msg="updating TUF client" 
time="2016-01-17T22:00:41Z" level=debug msg=downloadTimestamp 
time="2016-01-17T22:00:41Z" level=debug msg="200 when retrieving metadata for timestamp" 
time="2016-01-17T22:00:41Z" level=debug msg="timestamp role has key IDs: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T22:00:41Z" level=debug msg="verifying signature for key ID: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T22:00:41Z" level=debug msg="successfully verified timestamp" 
time="2016-01-17T22:00:41Z" level=debug msg=downloadSnapshot 
time="2016-01-17T22:00:41Z" level=debug msg="hash of snapshot in cache did not match expected hash, must download" 
time="2016-01-17T22:00:41Z" level=debug msg="200 when retrieving metadata for snapshot" 
time="2016-01-17T22:00:41Z" level=debug msg="snapshot role has key IDs: c50f7c2865cdfcc9fe3699dbe9c597887fe71340c0f8f066012468f14c224bdb" 
time="2016-01-17T22:00:41Z" level=debug msg="verifying signature for key ID: c50f7c2865cdfcc9fe3699dbe9c597887fe71340c0f8f066012468f14c224bdb" 
time="2016-01-17T22:00:41Z" level=debug msg="successfully verified snapshot" 
time="2016-01-17T22:00:41Z" level=debug msg="200 when retrieving metadata for targets" 
time="2016-01-17T22:00:41Z" level=debug msg="targets role has key IDs: cb8ef282a7856f9b8a4a26f33fe794c0e4c0cea5904d74cf809e407e73458afd" 
time="2016-01-17T22:00:41Z" level=debug msg="verifying signature for key ID: cb8ef282a7856f9b8a4a26f33fe794c0e4c0cea5904d74cf809e407e73458afd" 
time="2016-01-17T22:00:41Z" level=debug msg="successfully verified targets" 
time="2016-01-17T22:00:41Z" level=debug msg="200 when retrieving metadata for root" 
time="2016-01-17T22:00:41Z" level=debug msg="entered ValidateRoot with dns: docker.com/notary" 
time="2016-01-17T22:00:41Z" level=debug msg="found the following root keys: [bc61c9b69f33042db07f9ace68feb167dbbb385462032a84cade8961852644db]" 
time="2016-01-17T22:00:41Z" level=debug msg="found 1 valid leaf certificates for docker.com/notary" 
time="2016-01-17T22:00:41Z" level=debug msg="found 1 valid root certificates for docker.com/notary" 
time="2016-01-17T22:00:42Z" level=debug msg="entering root certificate rotation for: docker.com/notary" 
time="2016-01-17T22:00:42Z" level=debug msg="Adding cert with certID: bc61c9b69f33042db07f9ace68feb167dbbb385462032a84cade8961852644db" 
time="2016-01-17T22:00:42Z" level=debug msg="ignoring certificate addition to: docker.com/notary" 
time="2016-01-17T22:00:42Z" level=debug msg="Root validation succeeded for docker.com/notary" 
time="2016-01-17T22:00:42Z" level=debug msg="Adding key bc61c9b69f33042db07f9ace68feb167dbbb385462032a84cade8961852644db" 
time="2016-01-17T22:00:42Z" level=debug msg="Adding key c50f7c2865cdfcc9fe3699dbe9c597887fe71340c0f8f066012468f14c224bdb" 
time="2016-01-17T22:00:42Z" level=debug msg="Adding key cb8ef282a7856f9b8a4a26f33fe794c0e4c0cea5904d74cf809e407e73458afd" 
time="2016-01-17T22:00:42Z" level=debug msg="Adding key e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T22:00:42Z" level=debug msg="Adding role root with keys bc61c9b69f33042db07f9ace68feb167dbbb385462032a84cade8961852644db" 
time="2016-01-17T22:00:42Z" level=debug msg="Adding role snapshot with keys c50f7c2865cdfcc9fe3699dbe9c597887fe71340c0f8f066012468f14c224bdb" 
time="2016-01-17T22:00:42Z" level=debug msg="Adding role targets with keys cb8ef282a7856f9b8a4a26f33fe794c0e4c0cea5904d74cf809e407e73458afd" 
time="2016-01-17T22:00:42Z" level=debug msg="Adding role timestamp with keys e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T22:00:42Z" level=debug msg="updating TUF client" 
time="2016-01-17T22:00:42Z" level=debug msg=downloadTimestamp 
time="2016-01-17T22:00:42Z" level=debug msg="200 when retrieving metadata for timestamp" 
time="2016-01-17T22:00:42Z" level=debug msg="timestamp role has key IDs: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T22:00:42Z" level=debug msg="verifying signature for key ID: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T22:00:42Z" level=debug msg="successfully verified timestamp" 
time="2016-01-17T22:00:42Z" level=debug msg=downloadSnapshot 
time="2016-01-17T22:00:42Z" level=debug msg="using cached snapshot" 
time="2016-01-17T22:00:42Z" level=debug msg="snapshot role has key IDs: c50f7c2865cdfcc9fe3699dbe9c597887fe71340c0f8f066012468f14c224bdb" 
time="2016-01-17T22:00:42Z" level=debug msg="verifying signature for key ID: c50f7c2865cdfcc9fe3699dbe9c597887fe71340c0f8f066012468f14c224bdb" 
time="2016-01-17T22:00:42Z" level=debug msg="successfully verified snapshot" 
time="2016-01-17T22:00:42Z" level=debug msg="using cached targets" 
time="2016-01-17T22:00:42Z" level=debug msg="targets role has key IDs: cb8ef282a7856f9b8a4a26f33fe794c0e4c0cea5904d74cf809e407e73458afd" 
time="2016-01-17T22:00:42Z" level=debug msg="verifying signature for key ID: cb8ef282a7856f9b8a4a26f33fe794c0e4c0cea5904d74cf809e407e73458afd" 
time="2016-01-17T22:00:42Z" level=debug msg="successfully verified targets" 
time="2016-01-17T22:00:42Z" level=debug msg="updating TUF client" 
time="2016-01-17T22:00:42Z" level=debug msg=downloadTimestamp 
time="2016-01-17T22:00:42Z" level=debug msg="200 when retrieving metadata for timestamp" 
time="2016-01-17T22:00:42Z" level=debug msg="timestamp role has key IDs: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T22:00:42Z" level=debug msg="verifying signature for key ID: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T22:00:42Z" level=debug msg="successfully verified timestamp" 
time="2016-01-17T22:00:42Z" level=debug msg=downloadSnapshot 
time="2016-01-17T22:00:42Z" level=debug msg="using cached snapshot" 
time="2016-01-17T22:00:42Z" level=debug msg="snapshot role has key IDs: c50f7c2865cdfcc9fe3699dbe9c597887fe71340c0f8f066012468f14c224bdb" 
time="2016-01-17T22:00:42Z" level=debug msg="verifying signature for key ID: c50f7c2865cdfcc9fe3699dbe9c597887fe71340c0f8f066012468f14c224bdb" 
time="2016-01-17T22:00:42Z" level=debug msg="successfully verified snapshot" 
time="2016-01-17T22:00:42Z" level=debug msg="using cached targets" 
time="2016-01-17T22:00:42Z" level=debug msg="targets role has key IDs: cb8ef282a7856f9b8a4a26f33fe794c0e4c0cea5904d74cf809e407e73458afd" 
time="2016-01-17T22:00:42Z" level=debug msg="verifying signature for key ID: cb8ef282a7856f9b8a4a26f33fe794c0e4c0cea5904d74cf809e407e73458afd" 
time="2016-01-17T22:00:42Z" level=debug msg="successfully verified targets" 
time="2016-01-17T22:00:42Z" level=debug msg="using cached targets" 
time="2016-01-17T22:00:42Z" level=debug msg="targets role has key IDs: cb8ef282a7856f9b8a4a26f33fe794c0e4c0cea5904d74cf809e407e73458afd" 
time="2016-01-17T22:00:42Z" level=debug msg="verifying signature for key ID: cb8ef282a7856f9b8a4a26f33fe794c0e4c0cea5904d74cf809e407e73458afd" 
time="2016-01-17T22:00:42Z" level=debug msg="successfully verified targets" 
time="2016-01-17T22:00:42Z" level=debug msg="200 when retrieving metadata for root" 
time="2016-01-17T22:00:42Z" level=debug msg="entered ValidateRoot with dns: docker.com/notary" 
time="2016-01-17T22:00:42Z" level=debug msg="found the following root keys: [bc61c9b69f33042db07f9ace68feb167dbbb385462032a84cade8961852644db]" 
time="2016-01-17T22:00:42Z" level=debug msg="found 1 valid leaf certificates for docker.com/notary" 
time="2016-01-17T22:00:42Z" level=debug msg="found 1 valid root certificates for docker.com/notary" 
time="2016-01-17T22:00:42Z" level=debug msg="entering root certificate rotation for: docker.com/notary" 
time="2016-01-17T22:00:42Z" level=debug msg="Adding cert with certID: bc61c9b69f33042db07f9ace68feb167dbbb385462032a84cade8961852644db" 
time="2016-01-17T22:00:42Z" level=debug msg="ignoring certificate addition to: docker.com/notary" 
time="2016-01-17T22:00:42Z" level=debug msg="Root validation succeeded for docker.com/notary" 
time="2016-01-17T22:00:42Z" level=debug msg="Adding key e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T22:00:42Z" level=debug msg="Adding key bc61c9b69f33042db07f9ace68feb167dbbb385462032a84cade8961852644db" 
time="2016-01-17T22:00:42Z" level=debug msg="Adding key c50f7c2865cdfcc9fe3699dbe9c597887fe71340c0f8f066012468f14c224bdb" 
time="2016-01-17T22:00:42Z" level=debug msg="Adding key cb8ef282a7856f9b8a4a26f33fe794c0e4c0cea5904d74cf809e407e73458afd" 
time="2016-01-17T22:00:42Z" level=debug msg="Adding role root with keys bc61c9b69f33042db07f9ace68feb167dbbb385462032a84cade8961852644db" 
time="2016-01-17T22:00:42Z" level=debug msg="Adding role snapshot with keys c50f7c2865cdfcc9fe3699dbe9c597887fe71340c0f8f066012468f14c224bdb" 
time="2016-01-17T22:00:42Z" level=debug msg="Adding role targets with keys cb8ef282a7856f9b8a4a26f33fe794c0e4c0cea5904d74cf809e407e73458afd" 
time="2016-01-17T22:00:42Z" level=debug msg="Adding role timestamp with keys e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T22:00:42Z" level=debug msg="updating TUF client" 
time="2016-01-17T22:00:42Z" level=debug msg=downloadTimestamp 
time="2016-01-17T22:00:42Z" level=debug msg="200 when retrieving metadata for timestamp" 
time="2016-01-17T22:00:42Z" level=debug msg="timestamp role has key IDs: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T22:00:42Z" level=debug msg="verifying signature for key ID: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T22:00:42Z" level=debug msg="successfully verified timestamp" 
time="2016-01-17T22:00:42Z" level=debug msg=downloadSnapshot 
time="2016-01-17T22:00:42Z" level=debug msg="using cached snapshot" 
time="2016-01-17T22:00:42Z" level=debug msg="snapshot role has key IDs: c50f7c2865cdfcc9fe3699dbe9c597887fe71340c0f8f066012468f14c224bdb" 
time="2016-01-17T22:00:42Z" level=debug msg="verifying signature for key ID: c50f7c2865cdfcc9fe3699dbe9c597887fe71340c0f8f066012468f14c224bdb" 
time="2016-01-17T22:00:42Z" level=debug msg="successfully verified snapshot" 
time="2016-01-17T22:00:42Z" level=debug msg="using cached targets" 
time="2016-01-17T22:00:42Z" level=debug msg="targets role has key IDs: cb8ef282a7856f9b8a4a26f33fe794c0e4c0cea5904d74cf809e407e73458afd" 
time="2016-01-17T22:00:42Z" level=debug msg="verifying signature for key ID: cb8ef282a7856f9b8a4a26f33fe794c0e4c0cea5904d74cf809e407e73458afd" 
time="2016-01-17T22:00:42Z" level=debug msg="successfully verified targets" 
time="2016-01-17T22:00:42Z" level=debug msg="updating TUF client" 
time="2016-01-17T22:00:42Z" level=debug msg=downloadTimestamp 
time="2016-01-17T22:00:42Z" level=debug msg="200 when retrieving metadata for timestamp" 
time="2016-01-17T22:00:42Z" level=debug msg="timestamp role has key IDs: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T22:00:42Z" level=debug msg="verifying signature for key ID: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T22:00:42Z" level=debug msg="successfully verified timestamp" 
time="2016-01-17T22:00:42Z" level=debug msg=downloadSnapshot 
time="2016-01-17T22:00:42Z" level=debug msg="using cached snapshot" 
time="2016-01-17T22:00:42Z" level=debug msg="snapshot role has key IDs: c50f7c2865cdfcc9fe3699dbe9c597887fe71340c0f8f066012468f14c224bdb" 
time="2016-01-17T22:00:42Z" level=debug msg="verifying signature for key ID: c50f7c2865cdfcc9fe3699dbe9c597887fe71340c0f8f066012468f14c224bdb" 
time="2016-01-17T22:00:42Z" level=debug msg="successfully verified snapshot" 
time="2016-01-17T22:00:42Z" level=debug msg="using cached targets" 
time="2016-01-17T22:00:42Z" level=debug msg="targets role has key IDs: cb8ef282a7856f9b8a4a26f33fe794c0e4c0cea5904d74cf809e407e73458afd" 
time="2016-01-17T22:00:42Z" level=debug msg="verifying signature for key ID: cb8ef282a7856f9b8a4a26f33fe794c0e4c0cea5904d74cf809e407e73458afd" 
time="2016-01-17T22:00:42Z" level=debug msg="successfully verified targets" 
time="2016-01-17T22:00:42Z" level=debug msg="using cached targets" 
time="2016-01-17T22:00:42Z" level=debug msg="targets role has key IDs: cb8ef282a7856f9b8a4a26f33fe794c0e4c0cea5904d74cf809e407e73458afd" 
time="2016-01-17T22:00:42Z" level=debug msg="verifying signature for key ID: cb8ef282a7856f9b8a4a26f33fe794c0e4c0cea5904d74cf809e407e73458afd" 
time="2016-01-17T22:00:42Z" level=debug msg="successfully verified targets" 
time="2016-01-17T22:03:05Z" level=debug msg="generated RSA key with keyID: 9bcd2258b683abc267b99f943a1d4aef8f02ecc4c52b70ebec3b6be0fbf4e424" 
time="2016-01-17T22:03:06Z" level=debug msg="Adding cert with certID: 98833858c58f7294b531a284ca49c188395855bf2bbb21bda52daef07ef74758" 
time="2016-01-17T22:03:06Z" level=debug msg="Linking 98833858c58f7294b531a284ca49c188395855bf2bbb21bda52daef07ef74758 to 9bcd2258b683abc267b99f943a1d4aef8f02ecc4c52b70ebec3b6be0fbf4e424." 
time="2016-01-17T22:03:06Z" level=debug msg="got remote ecdsa timestamp key with keyID: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T22:03:06Z" level=debug msg="generated ECDSA key with keyID: 42ea8148f0bc1584f175cb1dcf8fa4e3f5694f3be51b1cb27e9fecee5816406d" 
time="2016-01-17T22:03:06Z" level=debug msg="generated new ecdsa key for role: targets and keyID: 42ea8148f0bc1584f175cb1dcf8fa4e3f5694f3be51b1cb27e9fecee5816406d" 
time="2016-01-17T22:03:06Z" level=debug msg="generated ECDSA key with keyID: 4bc4a4af048285b879f4e1b96f55faa5d67e1931542fe2c841eed63e5e7408c2" 
time="2016-01-17T22:03:06Z" level=debug msg="generated new ecdsa key for role: snapshot and keyID: 4bc4a4af048285b879f4e1b96f55faa5d67e1931542fe2c841eed63e5e7408c2" 
time="2016-01-17T22:03:06Z" level=debug msg="generating new snapshot..." 
time="2016-01-17T22:03:06Z" level=debug msg="Saving changes to Trusted Collection." 
time="2016-01-17T22:03:06Z" level=debug msg="signing root..." 
time="2016-01-17T22:03:06Z" level=debug msg="sign called with 1 keys" 
time="2016-01-17T22:03:06Z" level=debug msg="Generated list of signing IDs: 98833858c58f7294b531a284ca49c188395855bf2bbb21bda52daef07ef74758" 
time="2016-01-17T22:03:07Z" level=debug msg="appending rsa signature with Key ID: 98833858c58f7294b531a284ca49c188395855bf2bbb21bda52daef07ef74758" 
time="2016-01-17T22:03:07Z" level=debug msg="appending 1 new signatures" 
time="2016-01-17T22:03:07Z" level=debug msg="sign targets called for role targets" 
time="2016-01-17T22:03:07Z" level=debug msg="sign called with 1 keys" 
time="2016-01-17T22:03:07Z" level=debug msg="Generated list of signing IDs: 42ea8148f0bc1584f175cb1dcf8fa4e3f5694f3be51b1cb27e9fecee5816406d" 
time="2016-01-17T22:03:07Z" level=debug msg="appending ecdsa signature with Key ID: 42ea8148f0bc1584f175cb1dcf8fa4e3f5694f3be51b1cb27e9fecee5816406d" 
time="2016-01-17T22:03:07Z" level=debug msg="appending 1 new signatures" 
time="2016-01-17T22:03:07Z" level=debug msg="signing snapshot..." 
time="2016-01-17T22:03:07Z" level=debug msg="sign called with 1 keys" 
time="2016-01-17T22:03:07Z" level=debug msg="Generated list of signing IDs: 4bc4a4af048285b879f4e1b96f55faa5d67e1931542fe2c841eed63e5e7408c2" 
time="2016-01-17T22:03:07Z" level=debug msg="appending ecdsa signature with Key ID: 4bc4a4af048285b879f4e1b96f55faa5d67e1931542fe2c841eed63e5e7408c2" 
time="2016-01-17T22:03:07Z" level=debug msg="appending 1 new signatures" 
time="2016-01-17T22:03:07Z" level=debug msg="Making dir path: /tmp/notary-test-656231467/tuf/docker.com/notary/changelist" 
time="2016-01-17T22:03:07Z" level=debug msg="Adding target \"latest\" with sha256 \"6a25d3ec9106e843b34d7ef4af13b6300c320f9aa008269b49ef629a604b943c\" and size 2213 bytes.\n" 
time="2016-01-17T22:03:07Z" level=debug msg="Making dir path: /tmp/notary-test-656231467/tuf/docker.com/notary/changelist" 
time="2016-01-17T22:03:07Z" level=debug msg="Adding target \"current\" with sha256 \"6a25d3ec9106e843b34d7ef4af13b6300c320f9aa008269b49ef629a604b943c\" and size 2213 bytes.\n" 
time="2016-01-17T22:03:07Z" level=debug msg="Making dir path: /tmp/notary-test-656231467/tuf/docker.com/notary/changelist" 
time="2016-01-17T22:03:07Z" level=debug msg="applying 2 changes" 
time="2016-01-17T22:03:07Z" level=debug msg="changelist add: latest" 
time="2016-01-17T22:03:07Z" level=debug msg="changelist add: current" 
time="2016-01-17T22:03:07Z" level=debug msg="sign targets called for role targets" 
time="2016-01-17T22:03:07Z" level=debug msg="sign called with 1 keys" 
time="2016-01-17T22:03:07Z" level=debug msg="Generated list of signing IDs: 42ea8148f0bc1584f175cb1dcf8fa4e3f5694f3be51b1cb27e9fecee5816406d" 
time="2016-01-17T22:03:07Z" level=debug msg="appending ecdsa signature with Key ID: 42ea8148f0bc1584f175cb1dcf8fa4e3f5694f3be51b1cb27e9fecee5816406d" 
time="2016-01-17T22:03:07Z" level=debug msg="appending 1 new signatures" 
time="2016-01-17T22:03:07Z" level=debug msg="signing snapshot..." 
time="2016-01-17T22:03:07Z" level=debug msg="sign called with 1 keys" 
time="2016-01-17T22:03:07Z" level=debug msg="Generated list of signing IDs: 4bc4a4af048285b879f4e1b96f55faa5d67e1931542fe2c841eed63e5e7408c2" 
time="2016-01-17T22:03:07Z" level=debug msg="appending ecdsa signature with Key ID: 4bc4a4af048285b879f4e1b96f55faa5d67e1931542fe2c841eed63e5e7408c2" 
time="2016-01-17T22:03:07Z" level=debug msg="appending 1 new signatures" 
time="2016-01-17T22:03:07Z" level=debug msg=SignTimestamp 
time="2016-01-17T22:03:07Z" level=debug msg="sign called with 1 keys" 
time="2016-01-17T22:03:07Z" level=debug msg="Generated list of signing IDs: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T22:03:07Z" level=debug msg="appending ecdsa signature with Key ID: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T22:03:07Z" level=debug msg="appending 1 new signatures" 
time="2016-01-17T22:03:07Z" level=debug msg="200 when retrieving metadata for root" 
time="2016-01-17T22:03:07Z" level=debug msg="entered ValidateRoot with dns: docker.com/notary" 
time="2016-01-17T22:03:07Z" level=debug msg="found the following root keys: [98833858c58f7294b531a284ca49c188395855bf2bbb21bda52daef07ef74758]" 
time="2016-01-17T22:03:07Z" level=debug msg="found 1 valid leaf certificates for docker.com/notary" 
time="2016-01-17T22:03:07Z" level=debug msg="found 1 valid root certificates for docker.com/notary" 
time="2016-01-17T22:03:07Z" level=debug msg="entering root certificate rotation for: docker.com/notary" 
time="2016-01-17T22:03:07Z" level=debug msg="Adding cert with certID: 98833858c58f7294b531a284ca49c188395855bf2bbb21bda52daef07ef74758" 
time="2016-01-17T22:03:07Z" level=debug msg="ignoring certificate addition to: docker.com/notary" 
time="2016-01-17T22:03:07Z" level=debug msg="Root validation succeeded for docker.com/notary" 
time="2016-01-17T22:03:07Z" level=debug msg="Adding key 98833858c58f7294b531a284ca49c188395855bf2bbb21bda52daef07ef74758" 
time="2016-01-17T22:03:07Z" level=debug msg="Adding key e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T22:03:07Z" level=debug msg="Adding key 42ea8148f0bc1584f175cb1dcf8fa4e3f5694f3be51b1cb27e9fecee5816406d" 
time="2016-01-17T22:03:07Z" level=debug msg="Adding key 4bc4a4af048285b879f4e1b96f55faa5d67e1931542fe2c841eed63e5e7408c2" 
time="2016-01-17T22:03:07Z" level=debug msg="Adding role root with keys 98833858c58f7294b531a284ca49c188395855bf2bbb21bda52daef07ef74758" 
time="2016-01-17T22:03:07Z" level=debug msg="Adding role snapshot with keys 4bc4a4af048285b879f4e1b96f55faa5d67e1931542fe2c841eed63e5e7408c2" 
time="2016-01-17T22:03:07Z" level=debug msg="Adding role targets with keys 42ea8148f0bc1584f175cb1dcf8fa4e3f5694f3be51b1cb27e9fecee5816406d" 
time="2016-01-17T22:03:07Z" level=debug msg="Adding role timestamp with keys e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T22:03:07Z" level=debug msg="updating TUF client" 
time="2016-01-17T22:03:07Z" level=debug msg=downloadTimestamp 
time="2016-01-17T22:03:07Z" level=debug msg="200 when retrieving metadata for timestamp" 
time="2016-01-17T22:03:07Z" level=debug msg="timestamp role has key IDs: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T22:03:07Z" level=debug msg="verifying signature for key ID: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T22:03:07Z" level=debug msg="successfully verified timestamp" 
time="2016-01-17T22:03:07Z" level=debug msg=downloadSnapshot 
time="2016-01-17T22:03:07Z" level=debug msg="hash of snapshot in cache did not match expected hash, must download" 
time="2016-01-17T22:03:07Z" level=debug msg="200 when retrieving metadata for snapshot" 
time="2016-01-17T22:03:07Z" level=debug msg="snapshot role has key IDs: 4bc4a4af048285b879f4e1b96f55faa5d67e1931542fe2c841eed63e5e7408c2" 
time="2016-01-17T22:03:07Z" level=debug msg="verifying signature for key ID: 4bc4a4af048285b879f4e1b96f55faa5d67e1931542fe2c841eed63e5e7408c2" 
time="2016-01-17T22:03:07Z" level=debug msg="successfully verified snapshot" 
time="2016-01-17T22:03:07Z" level=debug msg="200 when retrieving metadata for targets" 
time="2016-01-17T22:03:07Z" level=debug msg="targets role has key IDs: 42ea8148f0bc1584f175cb1dcf8fa4e3f5694f3be51b1cb27e9fecee5816406d" 
time="2016-01-17T22:03:07Z" level=debug msg="verifying signature for key ID: 42ea8148f0bc1584f175cb1dcf8fa4e3f5694f3be51b1cb27e9fecee5816406d" 
time="2016-01-17T22:03:07Z" level=debug msg="successfully verified targets" 
time="2016-01-17T22:03:07Z" level=debug msg="200 when retrieving metadata for root" 
time="2016-01-17T22:03:07Z" level=debug msg="entered ValidateRoot with dns: docker.com/notary" 
time="2016-01-17T22:03:07Z" level=debug msg="found the following root keys: [98833858c58f7294b531a284ca49c188395855bf2bbb21bda52daef07ef74758]" 
time="2016-01-17T22:03:07Z" level=debug msg="found 1 valid leaf certificates for docker.com/notary" 
time="2016-01-17T22:03:07Z" level=debug msg="found 1 valid root certificates for docker.com/notary" 
time="2016-01-17T22:03:07Z" level=debug msg="entering root certificate rotation for: docker.com/notary" 
time="2016-01-17T22:03:07Z" level=debug msg="Adding cert with certID: 98833858c58f7294b531a284ca49c188395855bf2bbb21bda52daef07ef74758" 
time="2016-01-17T22:03:07Z" level=debug msg="ignoring certificate addition to: docker.com/notary" 
time="2016-01-17T22:03:07Z" level=debug msg="Root validation succeeded for docker.com/notary" 
time="2016-01-17T22:03:07Z" level=debug msg="Adding key 42ea8148f0bc1584f175cb1dcf8fa4e3f5694f3be51b1cb27e9fecee5816406d" 
time="2016-01-17T22:03:07Z" level=debug msg="Adding key 4bc4a4af048285b879f4e1b96f55faa5d67e1931542fe2c841eed63e5e7408c2" 
time="2016-01-17T22:03:07Z" level=debug msg="Adding key 98833858c58f7294b531a284ca49c188395855bf2bbb21bda52daef07ef74758" 
time="2016-01-17T22:03:07Z" level=debug msg="Adding key e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T22:03:07Z" level=debug msg="Adding role timestamp with keys e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T22:03:07Z" level=debug msg="Adding role root with keys 98833858c58f7294b531a284ca49c188395855bf2bbb21bda52daef07ef74758" 
time="2016-01-17T22:03:07Z" level=debug msg="Adding role snapshot with keys 4bc4a4af048285b879f4e1b96f55faa5d67e1931542fe2c841eed63e5e7408c2" 
time="2016-01-17T22:03:07Z" level=debug msg="Adding role targets with keys 42ea8148f0bc1584f175cb1dcf8fa4e3f5694f3be51b1cb27e9fecee5816406d" 
time="2016-01-17T22:03:07Z" level=debug msg="updating TUF client" 
time="2016-01-17T22:03:07Z" level=debug msg=downloadTimestamp 
time="2016-01-17T22:03:07Z" level=debug msg="200 when retrieving metadata for timestamp" 
time="2016-01-17T22:03:07Z" level=debug msg="timestamp role has key IDs: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T22:03:07Z" level=debug msg="verifying signature for key ID: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T22:03:07Z" level=debug msg="successfully verified timestamp" 
time="2016-01-17T22:03:07Z" level=debug msg=downloadSnapshot 
time="2016-01-17T22:03:07Z" level=debug msg="using cached snapshot" 
time="2016-01-17T22:03:07Z" level=debug msg="snapshot role has key IDs: 4bc4a4af048285b879f4e1b96f55faa5d67e1931542fe2c841eed63e5e7408c2" 
time="2016-01-17T22:03:07Z" level=debug msg="verifying signature for key ID: 4bc4a4af048285b879f4e1b96f55faa5d67e1931542fe2c841eed63e5e7408c2" 
time="2016-01-17T22:03:07Z" level=debug msg="successfully verified snapshot" 
time="2016-01-17T22:03:07Z" level=debug msg="using cached targets" 
time="2016-01-17T22:03:07Z" level=debug msg="targets role has key IDs: 42ea8148f0bc1584f175cb1dcf8fa4e3f5694f3be51b1cb27e9fecee5816406d" 
time="2016-01-17T22:03:07Z" level=debug msg="verifying signature for key ID: 42ea8148f0bc1584f175cb1dcf8fa4e3f5694f3be51b1cb27e9fecee5816406d" 
time="2016-01-17T22:03:07Z" level=debug msg="successfully verified targets" 
time="2016-01-17T22:03:07Z" level=debug msg="updating TUF client" 
time="2016-01-17T22:03:07Z" level=debug msg=downloadTimestamp 
time="2016-01-17T22:03:07Z" level=debug msg="200 when retrieving metadata for timestamp" 
time="2016-01-17T22:03:07Z" level=debug msg="timestamp role has key IDs: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T22:03:07Z" level=debug msg="verifying signature for key ID: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T22:03:07Z" level=debug msg="successfully verified timestamp" 
time="2016-01-17T22:03:07Z" level=debug msg=downloadSnapshot 
time="2016-01-17T22:03:07Z" level=debug msg="using cached snapshot" 
time="2016-01-17T22:03:07Z" level=debug msg="snapshot role has key IDs: 4bc4a4af048285b879f4e1b96f55faa5d67e1931542fe2c841eed63e5e7408c2" 
time="2016-01-17T22:03:07Z" level=debug msg="verifying signature for key ID: 4bc4a4af048285b879f4e1b96f55faa5d67e1931542fe2c841eed63e5e7408c2" 
time="2016-01-17T22:03:07Z" level=debug msg="successfully verified snapshot" 
time="2016-01-17T22:03:07Z" level=debug msg="using cached targets" 
time="2016-01-17T22:03:07Z" level=debug msg="targets role has key IDs: 42ea8148f0bc1584f175cb1dcf8fa4e3f5694f3be51b1cb27e9fecee5816406d" 
time="2016-01-17T22:03:07Z" level=debug msg="verifying signature for key ID: 42ea8148f0bc1584f175cb1dcf8fa4e3f5694f3be51b1cb27e9fecee5816406d" 
time="2016-01-17T22:03:07Z" level=debug msg="successfully verified targets" 
time="2016-01-17T22:03:07Z" level=debug msg="using cached targets" 
time="2016-01-17T22:03:07Z" level=debug msg="targets role has key IDs: 42ea8148f0bc1584f175cb1dcf8fa4e3f5694f3be51b1cb27e9fecee5816406d" 
time="2016-01-17T22:03:07Z" level=debug msg="verifying signature for key ID: 42ea8148f0bc1584f175cb1dcf8fa4e3f5694f3be51b1cb27e9fecee5816406d" 
time="2016-01-17T22:03:08Z" level=debug msg="successfully verified targets" 
time="2016-01-17T22:03:08Z" level=debug msg="200 when retrieving metadata for root" 
time="2016-01-17T22:03:08Z" level=debug msg="entered ValidateRoot with dns: docker.com/notary" 
time="2016-01-17T22:03:08Z" level=debug msg="found the following root keys: [98833858c58f7294b531a284ca49c188395855bf2bbb21bda52daef07ef74758]" 
time="2016-01-17T22:03:08Z" level=debug msg="found 1 valid leaf certificates for docker.com/notary" 
time="2016-01-17T22:03:08Z" level=debug msg="found 1 valid root certificates for docker.com/notary" 
time="2016-01-17T22:03:08Z" level=debug msg="entering root certificate rotation for: docker.com/notary" 
time="2016-01-17T22:03:08Z" level=debug msg="Adding cert with certID: 98833858c58f7294b531a284ca49c188395855bf2bbb21bda52daef07ef74758" 
time="2016-01-17T22:03:08Z" level=debug msg="ignoring certificate addition to: docker.com/notary" 
time="2016-01-17T22:03:08Z" level=debug msg="Root validation succeeded for docker.com/notary" 
time="2016-01-17T22:03:08Z" level=debug msg="Adding key 4bc4a4af048285b879f4e1b96f55faa5d67e1931542fe2c841eed63e5e7408c2" 
time="2016-01-17T22:03:08Z" level=debug msg="Adding key 98833858c58f7294b531a284ca49c188395855bf2bbb21bda52daef07ef74758" 
time="2016-01-17T22:03:08Z" level=debug msg="Adding key e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T22:03:08Z" level=debug msg="Adding key 42ea8148f0bc1584f175cb1dcf8fa4e3f5694f3be51b1cb27e9fecee5816406d" 
time="2016-01-17T22:03:08Z" level=debug msg="Adding role targets with keys 42ea8148f0bc1584f175cb1dcf8fa4e3f5694f3be51b1cb27e9fecee5816406d" 
time="2016-01-17T22:03:08Z" level=debug msg="Adding role timestamp with keys e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T22:03:08Z" level=debug msg="Adding role root with keys 98833858c58f7294b531a284ca49c188395855bf2bbb21bda52daef07ef74758" 
time="2016-01-17T22:03:08Z" level=debug msg="Adding role snapshot with keys 4bc4a4af048285b879f4e1b96f55faa5d67e1931542fe2c841eed63e5e7408c2" 
time="2016-01-17T22:03:08Z" level=debug msg="updating TUF client" 
time="2016-01-17T22:03:08Z" level=debug msg=downloadTimestamp 
time="2016-01-17T22:03:08Z" level=debug msg="200 when retrieving metadata for timestamp" 
time="2016-01-17T22:03:08Z" level=debug msg="timestamp role has key IDs: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T22:03:08Z" level=debug msg="verifying signature for key ID: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T22:03:08Z" level=debug msg="successfully verified timestamp" 
time="2016-01-17T22:03:08Z" level=debug msg=downloadSnapshot 
time="2016-01-17T22:03:08Z" level=debug msg="using cached snapshot" 
time="2016-01-17T22:03:08Z" level=debug msg="snapshot role has key IDs: 4bc4a4af048285b879f4e1b96f55faa5d67e1931542fe2c841eed63e5e7408c2" 
time="2016-01-17T22:03:08Z" level=debug msg="verifying signature for key ID: 4bc4a4af048285b879f4e1b96f55faa5d67e1931542fe2c841eed63e5e7408c2" 
time="2016-01-17T22:03:08Z" level=debug msg="successfully verified snapshot" 
time="2016-01-17T22:03:08Z" level=debug msg="using cached targets" 
time="2016-01-17T22:03:08Z" level=debug msg="targets role has key IDs: 42ea8148f0bc1584f175cb1dcf8fa4e3f5694f3be51b1cb27e9fecee5816406d" 
time="2016-01-17T22:03:08Z" level=debug msg="verifying signature for key ID: 42ea8148f0bc1584f175cb1dcf8fa4e3f5694f3be51b1cb27e9fecee5816406d" 
time="2016-01-17T22:03:08Z" level=debug msg="successfully verified targets" 
time="2016-01-17T22:03:08Z" level=debug msg="updating TUF client" 
time="2016-01-17T22:03:08Z" level=debug msg=downloadTimestamp 
time="2016-01-17T22:03:08Z" level=debug msg="200 when retrieving metadata for timestamp" 
time="2016-01-17T22:03:08Z" level=debug msg="timestamp role has key IDs: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T22:03:08Z" level=debug msg="verifying signature for key ID: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T22:03:08Z" level=debug msg="successfully verified timestamp" 
time="2016-01-17T22:03:08Z" level=debug msg=downloadSnapshot 
time="2016-01-17T22:03:08Z" level=debug msg="using cached snapshot" 
time="2016-01-17T22:03:08Z" level=debug msg="snapshot role has key IDs: 4bc4a4af048285b879f4e1b96f55faa5d67e1931542fe2c841eed63e5e7408c2" 
time="2016-01-17T22:03:08Z" level=debug msg="verifying signature for key ID: 4bc4a4af048285b879f4e1b96f55faa5d67e1931542fe2c841eed63e5e7408c2" 
time="2016-01-17T22:03:08Z" level=debug msg="successfully verified snapshot" 
time="2016-01-17T22:03:08Z" level=debug msg="using cached targets" 
time="2016-01-17T22:03:08Z" level=debug msg="targets role has key IDs: 42ea8148f0bc1584f175cb1dcf8fa4e3f5694f3be51b1cb27e9fecee5816406d" 
time="2016-01-17T22:03:08Z" level=debug msg="verifying signature for key ID: 42ea8148f0bc1584f175cb1dcf8fa4e3f5694f3be51b1cb27e9fecee5816406d" 
time="2016-01-17T22:03:08Z" level=debug msg="successfully verified targets" 
time="2016-01-17T22:03:08Z" level=debug msg="using cached targets" 
time="2016-01-17T22:03:08Z" level=debug msg="targets role has key IDs: 42ea8148f0bc1584f175cb1dcf8fa4e3f5694f3be51b1cb27e9fecee5816406d" 
time="2016-01-17T22:03:08Z" level=debug msg="verifying signature for key ID: 42ea8148f0bc1584f175cb1dcf8fa4e3f5694f3be51b1cb27e9fecee5816406d" 
time="2016-01-17T22:03:08Z" level=debug msg="successfully verified targets" 
--- PASS: TestAddListTarget (146.98s)
=== RUN   TestValidateRootKey
time="2016-01-17T22:03:08Z" level=debug msg="generated ECDSA key with keyID: 21b908152ed466af2a067b966a76d9f6c2a6a927a7ce2f2475989488137d56ba" 
time="2016-01-17T22:03:08Z" level=debug msg="Adding cert with certID: 11ec551be72f9eae238c0d4f2f4076a82d4546170c6476baf3b89437818d96dd" 
time="2016-01-17T22:03:08Z" level=debug msg="Linking 11ec551be72f9eae238c0d4f2f4076a82d4546170c6476baf3b89437818d96dd to 21b908152ed466af2a067b966a76d9f6c2a6a927a7ce2f2475989488137d56ba." 
time="2016-01-17T22:03:08Z" level=debug msg="got remote ecdsa timestamp key with keyID: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T22:03:08Z" level=debug msg="generated ECDSA key with keyID: 6083029c9b0353c6e05d54627db753d31c54d5a2615136848fa800092da837d7" 
time="2016-01-17T22:03:08Z" level=debug msg="generated new ecdsa key for role: targets and keyID: 6083029c9b0353c6e05d54627db753d31c54d5a2615136848fa800092da837d7" 
time="2016-01-17T22:03:08Z" level=debug msg="generated ECDSA key with keyID: dafce254f42bb7b5cf5dbff25279b6d51c4a6ab22fed782f984a68179225d477" 
time="2016-01-17T22:03:08Z" level=debug msg="generated new ecdsa key for role: snapshot and keyID: dafce254f42bb7b5cf5dbff25279b6d51c4a6ab22fed782f984a68179225d477" 
time="2016-01-17T22:03:08Z" level=debug msg="generating new snapshot..." 
time="2016-01-17T22:03:08Z" level=debug msg="Saving changes to Trusted Collection." 
time="2016-01-17T22:03:08Z" level=debug msg="signing root..." 
time="2016-01-17T22:03:08Z" level=debug msg="sign called with 1 keys" 
time="2016-01-17T22:03:08Z" level=debug msg="Generated list of signing IDs: 11ec551be72f9eae238c0d4f2f4076a82d4546170c6476baf3b89437818d96dd" 
time="2016-01-17T22:03:08Z" level=debug msg="appending ecdsa signature with Key ID: 11ec551be72f9eae238c0d4f2f4076a82d4546170c6476baf3b89437818d96dd" 
time="2016-01-17T22:03:08Z" level=debug msg="appending 1 new signatures" 
time="2016-01-17T22:03:08Z" level=debug msg="sign targets called for role targets" 
time="2016-01-17T22:03:08Z" level=debug msg="sign called with 1 keys" 
time="2016-01-17T22:03:08Z" level=debug msg="Generated list of signing IDs: 6083029c9b0353c6e05d54627db753d31c54d5a2615136848fa800092da837d7" 
time="2016-01-17T22:03:08Z" level=debug msg="appending ecdsa signature with Key ID: 6083029c9b0353c6e05d54627db753d31c54d5a2615136848fa800092da837d7" 
time="2016-01-17T22:03:08Z" level=debug msg="appending 1 new signatures" 
time="2016-01-17T22:03:08Z" level=debug msg="signing snapshot..." 
time="2016-01-17T22:03:08Z" level=debug msg="sign called with 1 keys" 
time="2016-01-17T22:03:08Z" level=debug msg="Generated list of signing IDs: dafce254f42bb7b5cf5dbff25279b6d51c4a6ab22fed782f984a68179225d477" 
time="2016-01-17T22:03:08Z" level=debug msg="appending ecdsa signature with Key ID: dafce254f42bb7b5cf5dbff25279b6d51c4a6ab22fed782f984a68179225d477" 
time="2016-01-17T22:03:08Z" level=debug msg="appending 1 new signatures" 
time="2016-01-17T22:04:01Z" level=debug msg="generated RSA key with keyID: 8425e9b40dcfec4dc140f5bb6264016b4845ed2b10b182936342b71456d63a6d" 
time="2016-01-17T22:04:02Z" level=debug msg="Adding cert with certID: b1a7731f966ca9a791c2629de74be0eea3077afe3244191463129284e7e89e7b" 
time="2016-01-17T22:04:02Z" level=debug msg="Linking b1a7731f966ca9a791c2629de74be0eea3077afe3244191463129284e7e89e7b to 8425e9b40dcfec4dc140f5bb6264016b4845ed2b10b182936342b71456d63a6d." 
time="2016-01-17T22:04:02Z" level=debug msg="got remote ecdsa timestamp key with keyID: e3a5a4fdaf11ea1ec58f5efed6f3639b39cd4cfa1418c8b55c9a8c2447ace5d9" 
time="2016-01-17T22:04:02Z" level=debug msg="generated ECDSA key with keyID: a731c6b586c22f5facda7a29777162277af6aa2cb19d16cb7ef4f731d67763a2" 
time="2016-01-17T22:04:02Z" level=debug msg="generated new ecdsa key for role: targets and keyID: a731c6b586c22f5facda7a29777162277af6aa2cb19d16cb7ef4f731d67763a2" 
time="2016-01-17T22:04:02Z" level=debug msg="generated ECDSA key with keyID: 4d9e8fd519ace76964b2aaa0c6923e756e8f22e309b5ae50ac4a2b7e8b48654e" 
time="2016-01-17T22:04:02Z" level=debug msg="generated new ecdsa key for role: snapshot and keyID: 4d9e8fd519ace76964b2aaa0c6923e756e8f22e309b5ae50ac4a2b7e8b48654e" 
time="2016-01-17T22:04:02Z" level=debug msg="generating new snapshot..." 
time="2016-01-17T22:04:02Z" level=debug msg="Saving changes to Trusted Collection." 
time="2016-01-17T22:04:02Z" level=debug msg="signing root..." 
time="2016-01-17T22:04:02Z" level=debug msg="sign called with 1 keys" 
time="2016-01-17T22:04:02Z" level=debug msg="Generated list of signing IDs: b1a7731f966ca9a791c2629de74be0eea3077afe3244191463129284e7e89e7b" 
time="2016-01-17T22:04:03Z" level=debug msg="appending rsa signature with Key ID: b1a7731f966ca9a791c2629de74be0eea3077afe3244191463129284e7e89e7b" 
time="2016-01-17T22:04:03Z" level=debug msg="appending 1 new signatures" 
time="2016-01-17T22:04:03Z" level=debug msg="sign targets called for role targets" 
time="2016-01-17T22:04:03Z" level=debug msg="sign called with 1 keys" 
time="2016-01-17T22:04:03Z" level=debug msg="Generated list of signing IDs: a731c6b586c22f5facda7a29777162277af6aa2cb19d16cb7ef4f731d67763a2" 
time="2016-01-17T22:04:03Z" level=debug msg="appending ecdsa signature with Key ID: a731c6b586c22f5facda7a29777162277af6aa2cb19d16cb7ef4f731d67763a2" 
time="2016-01-17T22:04:03Z" level=debug msg="appending 1 new signatures" 
time="2016-01-17T22:04:03Z" level=debug msg="signing snapshot..." 
time="2016-01-17T22:04:03Z" level=debug msg="sign called with 1 keys" 
time="2016-01-17T22:04:03Z" level=debug msg="Generated list of signing IDs: 4d9e8fd519ace76964b2aaa0c6923e756e8f22e309b5ae50ac4a2b7e8b48654e" 
time="2016-01-17T22:04:03Z" level=debug msg="appending ecdsa signature with Key ID: 4d9e8fd519ace76964b2aaa0c6923e756e8f22e309b5ae50ac4a2b7e8b48654e" 
time="2016-01-17T22:04:03Z" level=debug msg="appending 1 new signatures" 
--- PASS: TestValidateRootKey (55.06s)
=== RUN   TestPublish
time="2016-01-17T22:04:03Z" level=debug msg="generated ECDSA key with keyID: 40a4d3251d9ecf8760f491812d5df39a4573a3b401ee6c096febf36ee9e6e71a" 
time="2016-01-17T22:04:03Z" level=debug msg="Adding cert with certID: 79ab3407ad27e3c20fa578b1c0aafb5298d8fa90eccb15368c746d0d5f3b7003" 
time="2016-01-17T22:04:03Z" level=debug msg="Linking 79ab3407ad27e3c20fa578b1c0aafb5298d8fa90eccb15368c746d0d5f3b7003 to 40a4d3251d9ecf8760f491812d5df39a4573a3b401ee6c096febf36ee9e6e71a." 
time="2016-01-17T22:04:03Z" level=debug msg="generated ECDSA key with keyID: cbb282db337e59cf02c62b33a3fe3f327e8b772fa2d611273f5b5cf9dc33b5b0" 
time="2016-01-17T22:04:03Z" level=debug msg="generated new ecdsa key for role: timestamp and keyID: cbb282db337e59cf02c62b33a3fe3f327e8b772fa2d611273f5b5cf9dc33b5b0" 
time="2016-01-17T22:04:03Z" level=debug msg="Creating new timestamp key for docker.com/notary. With algo: ecdsa" 
time="2016-01-17T22:04:03Z" level=debug msg="[Notary Server] 200 GET timestamp key: docker.com/notary" 
time="2016-01-17T22:04:03Z" level=info msg="[Notary Server] 200 GET /v2/docker.com/notary/_trust/tuf/timestamp.key" 
time="2016-01-17T22:04:03Z" level=debug msg="got remote ecdsa timestamp key with keyID: cbb282db337e59cf02c62b33a3fe3f327e8b772fa2d611273f5b5cf9dc33b5b0" 
time="2016-01-17T22:04:03Z" level=debug msg="generated ECDSA key with keyID: 9ab536b34054f392e268b9bf9f5e983d600518d2d2ce465657a221b4a68cb5c5" 
time="2016-01-17T22:04:03Z" level=debug msg="generated new ecdsa key for role: targets and keyID: 9ab536b34054f392e268b9bf9f5e983d600518d2d2ce465657a221b4a68cb5c5" 
time="2016-01-17T22:04:03Z" level=debug msg="generated ECDSA key with keyID: e84bb34ed1599ae11f43b687a7ff226cddf20af2671909a2295919f86a970250" 
time="2016-01-17T22:04:03Z" level=debug msg="generated new ecdsa key for role: snapshot and keyID: e84bb34ed1599ae11f43b687a7ff226cddf20af2671909a2295919f86a970250" 
time="2016-01-17T22:04:03Z" level=debug msg="generating new snapshot..." 
time="2016-01-17T22:04:03Z" level=debug msg="Saving changes to Trusted Collection." 
time="2016-01-17T22:04:03Z" level=debug msg="signing root..." 
time="2016-01-17T22:04:03Z" level=debug msg="sign called with 1 keys" 
time="2016-01-17T22:04:03Z" level=debug msg="Generated list of signing IDs: 79ab3407ad27e3c20fa578b1c0aafb5298d8fa90eccb15368c746d0d5f3b7003" 
time="2016-01-17T22:04:03Z" level=debug msg="appending ecdsa signature with Key ID: 79ab3407ad27e3c20fa578b1c0aafb5298d8fa90eccb15368c746d0d5f3b7003" 
time="2016-01-17T22:04:03Z" level=debug msg="appending 1 new signatures" 
time="2016-01-17T22:04:03Z" level=debug msg="sign targets called for role targets" 
time="2016-01-17T22:04:03Z" level=debug msg="sign called with 1 keys" 
time="2016-01-17T22:04:03Z" level=debug msg="Generated list of signing IDs: 9ab536b34054f392e268b9bf9f5e983d600518d2d2ce465657a221b4a68cb5c5" 
time="2016-01-17T22:04:03Z" level=debug msg="appending ecdsa signature with Key ID: 9ab536b34054f392e268b9bf9f5e983d600518d2d2ce465657a221b4a68cb5c5" 
time="2016-01-17T22:04:03Z" level=debug msg="appending 1 new signatures" 
time="2016-01-17T22:04:03Z" level=debug msg="signing snapshot..." 
time="2016-01-17T22:04:03Z" level=debug msg="sign called with 1 keys" 
time="2016-01-17T22:04:03Z" level=debug msg="Generated list of signing IDs: e84bb34ed1599ae11f43b687a7ff226cddf20af2671909a2295919f86a970250" 
time="2016-01-17T22:04:03Z" level=debug msg="appending ecdsa signature with Key ID: e84bb34ed1599ae11f43b687a7ff226cddf20af2671909a2295919f86a970250" 
time="2016-01-17T22:04:03Z" level=debug msg="appending 1 new signatures" 
time="2016-01-17T22:04:03Z" level=debug msg="Making dir path: /tmp/notary-test-708399600/tuf/docker.com/notary/changelist" 
time="2016-01-17T22:04:03Z" level=debug msg="Adding target \"latest\" with sha256 \"6a25d3ec9106e843b34d7ef4af13b6300c320f9aa008269b49ef629a604b943c\" and size 2213 bytes.\n" 
time="2016-01-17T22:04:03Z" level=debug msg="Making dir path: /tmp/notary-test-708399600/tuf/docker.com/notary/changelist" 
time="2016-01-17T22:04:03Z" level=debug msg="Adding target \"current\" with sha256 \"6a25d3ec9106e843b34d7ef4af13b6300c320f9aa008269b49ef629a604b943c\" and size 2213 bytes.\n" 
time="2016-01-17T22:04:03Z" level=error msg="[Notary Server] 404 GET /v2/docker.com/notary/_trust/tuf/root.json" 
time="2016-01-17T22:04:03Z" level=debug msg="Loading trusted collection." 
time="2016-01-17T22:04:03Z" level=debug msg="Adding key e84bb34ed1599ae11f43b687a7ff226cddf20af2671909a2295919f86a970250" 
time="2016-01-17T22:04:03Z" level=debug msg="Adding key 79ab3407ad27e3c20fa578b1c0aafb5298d8fa90eccb15368c746d0d5f3b7003" 
time="2016-01-17T22:04:03Z" level=debug msg="Adding key 9ab536b34054f392e268b9bf9f5e983d600518d2d2ce465657a221b4a68cb5c5" 
time="2016-01-17T22:04:03Z" level=debug msg="Adding key cbb282db337e59cf02c62b33a3fe3f327e8b772fa2d611273f5b5cf9dc33b5b0" 
time="2016-01-17T22:04:03Z" level=debug msg="Adding role targets with keys 9ab536b34054f392e268b9bf9f5e983d600518d2d2ce465657a221b4a68cb5c5" 
time="2016-01-17T22:04:03Z" level=debug msg="Adding role timestamp with keys cbb282db337e59cf02c62b33a3fe3f327e8b772fa2d611273f5b5cf9dc33b5b0" 
time="2016-01-17T22:04:03Z" level=debug msg="Adding role root with keys 79ab3407ad27e3c20fa578b1c0aafb5298d8fa90eccb15368c746d0d5f3b7003" 
time="2016-01-17T22:04:03Z" level=debug msg="Adding role snapshot with keys e84bb34ed1599ae11f43b687a7ff226cddf20af2671909a2295919f86a970250" 
time="2016-01-17T22:04:03Z" level=debug msg="Making dir path: /tmp/notary-test-708399600/tuf/docker.com/notary/changelist" 
time="2016-01-17T22:04:03Z" level=debug msg="applying 2 changes" 
time="2016-01-17T22:04:03Z" level=debug msg="changelist add: latest" 
time="2016-01-17T22:04:03Z" level=debug msg="changelist add: current" 
time="2016-01-17T22:04:03Z" level=debug msg="sign targets called for role targets" 
time="2016-01-17T22:04:03Z" level=debug msg="sign called with 1 keys" 
time="2016-01-17T22:04:03Z" level=debug msg="Generated list of signing IDs: 9ab536b34054f392e268b9bf9f5e983d600518d2d2ce465657a221b4a68cb5c5" 
time="2016-01-17T22:04:03Z" level=debug msg="appending ecdsa signature with Key ID: 9ab536b34054f392e268b9bf9f5e983d600518d2d2ce465657a221b4a68cb5c5" 
time="2016-01-17T22:04:03Z" level=debug msg="appending 1 new signatures" 
time="2016-01-17T22:04:03Z" level=debug msg="signing snapshot..." 
time="2016-01-17T22:04:03Z" level=debug msg="sign called with 1 keys" 
time="2016-01-17T22:04:03Z" level=debug msg="Generated list of signing IDs: e84bb34ed1599ae11f43b687a7ff226cddf20af2671909a2295919f86a970250" 
time="2016-01-17T22:04:03Z" level=debug msg="appending ecdsa signature with Key ID: e84bb34ed1599ae11f43b687a7ff226cddf20af2671909a2295919f86a970250" 
time="2016-01-17T22:04:03Z" level=debug msg="appending 1 new signatures" 
time="2016-01-17T22:04:03Z" level=debug msg="Successfully validated hierarchy" 
time="2016-01-17T22:04:03Z" level=debug msg="Adding key 9ab536b34054f392e268b9bf9f5e983d600518d2d2ce465657a221b4a68cb5c5" 
time="2016-01-17T22:04:03Z" level=debug msg="Adding key cbb282db337e59cf02c62b33a3fe3f327e8b772fa2d611273f5b5cf9dc33b5b0" 
time="2016-01-17T22:04:03Z" level=debug msg="Adding key e84bb34ed1599ae11f43b687a7ff226cddf20af2671909a2295919f86a970250" 
time="2016-01-17T22:04:03Z" level=debug msg="Adding key 79ab3407ad27e3c20fa578b1c0aafb5298d8fa90eccb15368c746d0d5f3b7003" 
time="2016-01-17T22:04:03Z" level=debug msg="Adding role snapshot with keys e84bb34ed1599ae11f43b687a7ff226cddf20af2671909a2295919f86a970250" 
time="2016-01-17T22:04:03Z" level=debug msg="Adding role targets with keys 9ab536b34054f392e268b9bf9f5e983d600518d2d2ce465657a221b4a68cb5c5" 
time="2016-01-17T22:04:03Z" level=debug msg="Adding role timestamp with keys cbb282db337e59cf02c62b33a3fe3f327e8b772fa2d611273f5b5cf9dc33b5b0" 
time="2016-01-17T22:04:03Z" level=debug msg="Adding role root with keys 79ab3407ad27e3c20fa578b1c0aafb5298d8fa90eccb15368c746d0d5f3b7003" 
time="2016-01-17T22:04:03Z" level=debug msg="Successfully validated root" 
time="2016-01-17T22:04:03Z" level=debug msg="targets role has key IDs: 9ab536b34054f392e268b9bf9f5e983d600518d2d2ce465657a221b4a68cb5c5" 
time="2016-01-17T22:04:03Z" level=debug msg="verifying signature for key ID: 9ab536b34054f392e268b9bf9f5e983d600518d2d2ce465657a221b4a68cb5c5" 
time="2016-01-17T22:04:03Z" level=debug msg="Successfully validated targets" 
time="2016-01-17T22:04:03Z" level=debug msg="snapshot role has key IDs: e84bb34ed1599ae11f43b687a7ff226cddf20af2671909a2295919f86a970250" 
time="2016-01-17T22:04:03Z" level=debug msg="verifying signature for key ID: e84bb34ed1599ae11f43b687a7ff226cddf20af2671909a2295919f86a970250" 
time="2016-01-17T22:04:03Z" level=debug msg="Successfully validated snapshot" 
time="2016-01-17T22:04:03Z" level=info msg="[Notary Server] 200 POST /v2/docker.com/notary/_trust/tuf/" 
time="2016-01-17T22:04:03Z" level=debug msg="ignoring certificate, did not pass validation: docker.com/notary/79ab3407ad27e3c20fa578b1c0aafb5298d8fa90eccb15368c746d0d5f3b7003.crt" 
time="2016-01-17T22:04:03Z" level=debug msg="Adding cert with certID: 79ab3407ad27e3c20fa578b1c0aafb5298d8fa90eccb15368c746d0d5f3b7003" 
time="2016-01-17T22:04:03Z" level=info msg="[Notary Server] 200 GET /v2/docker.com/notary/_trust/tuf/root.json" 
time="2016-01-17T22:04:03Z" level=debug msg="200 when retrieving metadata for root" 
time="2016-01-17T22:04:03Z" level=debug msg="entered ValidateRoot with dns: docker.com/notary" 
time="2016-01-17T22:04:03Z" level=debug msg="found the following root keys: [79ab3407ad27e3c20fa578b1c0aafb5298d8fa90eccb15368c746d0d5f3b7003]" 
time="2016-01-17T22:04:03Z" level=debug msg="found 1 valid leaf certificates for docker.com/notary" 
time="2016-01-17T22:04:03Z" level=debug msg="found 1 valid root certificates for docker.com/notary" 
time="2016-01-17T22:04:03Z" level=debug msg="entering root certificate rotation for: docker.com/notary" 
time="2016-01-17T22:04:03Z" level=debug msg="Adding cert with certID: 79ab3407ad27e3c20fa578b1c0aafb5298d8fa90eccb15368c746d0d5f3b7003" 
time="2016-01-17T22:04:03Z" level=debug msg="ignoring certificate addition to: docker.com/notary" 
time="2016-01-17T22:04:03Z" level=debug msg="Root validation succeeded for docker.com/notary" 
time="2016-01-17T22:04:03Z" level=debug msg="Adding key 79ab3407ad27e3c20fa578b1c0aafb5298d8fa90eccb15368c746d0d5f3b7003" 
time="2016-01-17T22:04:03Z" level=debug msg="Adding key 9ab536b34054f392e268b9bf9f5e983d600518d2d2ce465657a221b4a68cb5c5" 
time="2016-01-17T22:04:03Z" level=debug msg="Adding key cbb282db337e59cf02c62b33a3fe3f327e8b772fa2d611273f5b5cf9dc33b5b0" 
time="2016-01-17T22:04:03Z" level=debug msg="Adding key e84bb34ed1599ae11f43b687a7ff226cddf20af2671909a2295919f86a970250" 
time="2016-01-17T22:04:03Z" level=debug msg="Adding role targets with keys 9ab536b34054f392e268b9bf9f5e983d600518d2d2ce465657a221b4a68cb5c5" 
time="2016-01-17T22:04:03Z" level=debug msg="Adding role timestamp with keys cbb282db337e59cf02c62b33a3fe3f327e8b772fa2d611273f5b5cf9dc33b5b0" 
time="2016-01-17T22:04:03Z" level=debug msg="Adding role root with keys 79ab3407ad27e3c20fa578b1c0aafb5298d8fa90eccb15368c746d0d5f3b7003" 
time="2016-01-17T22:04:03Z" level=debug msg="Adding role snapshot with keys e84bb34ed1599ae11f43b687a7ff226cddf20af2671909a2295919f86a970250" 
time="2016-01-17T22:04:04Z" level=debug msg="updating TUF client" 
time="2016-01-17T22:04:04Z" level=debug msg=downloadTimestamp 
time="2016-01-17T22:04:04Z" level=debug msg="No timestamp found, will proceed to create first timestamp" 
time="2016-01-17T22:04:04Z" level=debug msg="sign called with 1 keys" 
time="2016-01-17T22:04:04Z" level=debug msg="Generated list of signing IDs: cbb282db337e59cf02c62b33a3fe3f327e8b772fa2d611273f5b5cf9dc33b5b0" 
time="2016-01-17T22:04:04Z" level=debug msg="appending ecdsa signature with Key ID: cbb282db337e59cf02c62b33a3fe3f327e8b772fa2d611273f5b5cf9dc33b5b0" 
time="2016-01-17T22:04:04Z" level=debug msg="appending 1 new signatures" 
time="2016-01-17T22:04:04Z" level=debug msg="[Notary Server] 200 GET timestamp: docker.com/notary" 
time="2016-01-17T22:04:04Z" level=info msg="[Notary Server] 200 GET /v2/docker.com/notary/_trust/tuf/timestamp.json" 
time="2016-01-17T22:04:04Z" level=debug msg="200 when retrieving metadata for timestamp" 
time="2016-01-17T22:04:04Z" level=debug msg="timestamp role has key IDs: cbb282db337e59cf02c62b33a3fe3f327e8b772fa2d611273f5b5cf9dc33b5b0" 
time="2016-01-17T22:04:04Z" level=debug msg="verifying signature for key ID: cbb282db337e59cf02c62b33a3fe3f327e8b772fa2d611273f5b5cf9dc33b5b0" 
time="2016-01-17T22:04:04Z" level=debug msg="successfully verified timestamp" 
time="2016-01-17T22:04:04Z" level=debug msg=downloadSnapshot 
time="2016-01-17T22:04:04Z" level=debug msg="hash of snapshot in cache did not match expected hash, must download" 
time="2016-01-17T22:04:04Z" level=info msg="[Notary Server] 200 GET /v2/docker.com/notary/_trust/tuf/snapshot.json" 
time="2016-01-17T22:04:04Z" level=debug msg="200 when retrieving metadata for snapshot" 
time="2016-01-17T22:04:04Z" level=debug msg="snapshot role has key IDs: e84bb34ed1599ae11f43b687a7ff226cddf20af2671909a2295919f86a970250" 
time="2016-01-17T22:04:04Z" level=debug msg="verifying signature for key ID: e84bb34ed1599ae11f43b687a7ff226cddf20af2671909a2295919f86a970250" 
time="2016-01-17T22:04:04Z" level=debug msg="successfully verified snapshot" 
time="2016-01-17T22:04:04Z" level=info msg="[Notary Server] 200 GET /v2/docker.com/notary/_trust/tuf/targets.json" 
time="2016-01-17T22:04:04Z" level=debug msg="200 when retrieving metadata for targets" 
time="2016-01-17T22:04:04Z" level=debug msg="targets role has key IDs: 9ab536b34054f392e268b9bf9f5e983d600518d2d2ce465657a221b4a68cb5c5" 
time="2016-01-17T22:04:04Z" level=debug msg="verifying signature for key ID: 9ab536b34054f392e268b9bf9f5e983d600518d2d2ce465657a221b4a68cb5c5" 
time="2016-01-17T22:04:04Z" level=debug msg="successfully verified targets" 
time="2016-01-17T22:04:04Z" level=info msg="[Notary Server] 200 GET /v2/docker.com/notary/_trust/tuf/root.json" 
time="2016-01-17T22:04:04Z" level=debug msg="200 when retrieving metadata for root" 
time="2016-01-17T22:04:04Z" level=debug msg="entered ValidateRoot with dns: docker.com/notary" 
time="2016-01-17T22:04:04Z" level=debug msg="found the following root keys: [79ab3407ad27e3c20fa578b1c0aafb5298d8fa90eccb15368c746d0d5f3b7003]" 
time="2016-01-17T22:04:04Z" level=debug msg="found 1 valid leaf certificates for docker.com/notary" 
time="2016-01-17T22:04:04Z" level=debug msg="found 1 valid root certificates for docker.com/notary" 
time="2016-01-17T22:04:04Z" level=debug msg="entering root certificate rotation for: docker.com/notary" 
time="2016-01-17T22:04:04Z" level=debug msg="Adding cert with certID: 79ab3407ad27e3c20fa578b1c0aafb5298d8fa90eccb15368c746d0d5f3b7003" 
time="2016-01-17T22:04:04Z" level=debug msg="ignoring certificate addition to: docker.com/notary" 
time="2016-01-17T22:04:04Z" level=debug msg="Root validation succeeded for docker.com/notary" 
time="2016-01-17T22:04:04Z" level=debug msg="Adding key 79ab3407ad27e3c20fa578b1c0aafb5298d8fa90eccb15368c746d0d5f3b7003" 
time="2016-01-17T22:04:04Z" level=debug msg="Adding key 9ab536b34054f392e268b9bf9f5e983d600518d2d2ce465657a221b4a68cb5c5" 
time="2016-01-17T22:04:04Z" level=debug msg="Adding key cbb282db337e59cf02c62b33a3fe3f327e8b772fa2d611273f5b5cf9dc33b5b0" 
time="2016-01-17T22:04:04Z" level=debug msg="Adding key e84bb34ed1599ae11f43b687a7ff226cddf20af2671909a2295919f86a970250" 
time="2016-01-17T22:04:04Z" level=debug msg="Adding role timestamp with keys cbb282db337e59cf02c62b33a3fe3f327e8b772fa2d611273f5b5cf9dc33b5b0" 
time="2016-01-17T22:04:04Z" level=debug msg="Adding role root with keys 79ab3407ad27e3c20fa578b1c0aafb5298d8fa90eccb15368c746d0d5f3b7003" 
time="2016-01-17T22:04:04Z" level=debug msg="Adding role snapshot with keys e84bb34ed1599ae11f43b687a7ff226cddf20af2671909a2295919f86a970250" 
time="2016-01-17T22:04:04Z" level=debug msg="Adding role targets with keys 9ab536b34054f392e268b9bf9f5e983d600518d2d2ce465657a221b4a68cb5c5" 
time="2016-01-17T22:04:04Z" level=debug msg="updating TUF client" 
time="2016-01-17T22:04:04Z" level=debug msg=downloadTimestamp 
time="2016-01-17T22:04:04Z" level=debug msg="[Notary Server] 200 GET timestamp: docker.com/notary" 
time="2016-01-17T22:04:04Z" level=info msg="[Notary Server] 200 GET /v2/docker.com/notary/_trust/tuf/timestamp.json" 
time="2016-01-17T22:04:04Z" level=debug msg="200 when retrieving metadata for timestamp" 
time="2016-01-17T22:04:04Z" level=debug msg="timestamp role has key IDs: cbb282db337e59cf02c62b33a3fe3f327e8b772fa2d611273f5b5cf9dc33b5b0" 
time="2016-01-17T22:04:04Z" level=debug msg="verifying signature for key ID: cbb282db337e59cf02c62b33a3fe3f327e8b772fa2d611273f5b5cf9dc33b5b0" 
time="2016-01-17T22:04:04Z" level=debug msg="successfully verified timestamp" 
time="2016-01-17T22:04:04Z" level=debug msg=downloadSnapshot 
time="2016-01-17T22:04:04Z" level=debug msg="using cached snapshot" 
time="2016-01-17T22:04:04Z" level=debug msg="snapshot role has key IDs: e84bb34ed1599ae11f43b687a7ff226cddf20af2671909a2295919f86a970250" 
time="2016-01-17T22:04:04Z" level=debug msg="verifying signature for key ID: e84bb34ed1599ae11f43b687a7ff226cddf20af2671909a2295919f86a970250" 
time="2016-01-17T22:04:04Z" level=debug msg="successfully verified snapshot" 
time="2016-01-17T22:04:04Z" level=debug msg="using cached targets" 
time="2016-01-17T22:04:04Z" level=debug msg="targets role has key IDs: 9ab536b34054f392e268b9bf9f5e983d600518d2d2ce465657a221b4a68cb5c5" 
time="2016-01-17T22:04:04Z" level=debug msg="verifying signature for key ID: 9ab536b34054f392e268b9bf9f5e983d600518d2d2ce465657a221b4a68cb5c5" 
time="2016-01-17T22:04:04Z" level=debug msg="successfully verified targets" 
time="2016-01-17T22:04:04Z" level=debug msg="updating TUF client" 
time="2016-01-17T22:04:04Z" level=debug msg=downloadTimestamp 
time="2016-01-17T22:04:04Z" level=debug msg="[Notary Server] 200 GET timestamp: docker.com/notary" 
time="2016-01-17T22:04:04Z" level=info msg="[Notary Server] 200 GET /v2/docker.com/notary/_trust/tuf/timestamp.json" 
time="2016-01-17T22:04:04Z" level=debug msg="200 when retrieving metadata for timestamp" 
time="2016-01-17T22:04:04Z" level=debug msg="timestamp role has key IDs: cbb282db337e59cf02c62b33a3fe3f327e8b772fa2d611273f5b5cf9dc33b5b0" 
time="2016-01-17T22:04:04Z" level=debug msg="verifying signature for key ID: cbb282db337e59cf02c62b33a3fe3f327e8b772fa2d611273f5b5cf9dc33b5b0" 
time="2016-01-17T22:04:04Z" level=debug msg="successfully verified timestamp" 
time="2016-01-17T22:04:04Z" level=debug msg=downloadSnapshot 
time="2016-01-17T22:04:04Z" level=debug msg="using cached snapshot" 
time="2016-01-17T22:04:04Z" level=debug msg="snapshot role has key IDs: e84bb34ed1599ae11f43b687a7ff226cddf20af2671909a2295919f86a970250" 
time="2016-01-17T22:04:04Z" level=debug msg="verifying signature for key ID: e84bb34ed1599ae11f43b687a7ff226cddf20af2671909a2295919f86a970250" 
time="2016-01-17T22:04:04Z" level=debug msg="successfully verified snapshot" 
time="2016-01-17T22:04:04Z" level=debug msg="using cached targets" 
time="2016-01-17T22:04:04Z" level=debug msg="targets role has key IDs: 9ab536b34054f392e268b9bf9f5e983d600518d2d2ce465657a221b4a68cb5c5" 
time="2016-01-17T22:04:04Z" level=debug msg="verifying signature for key ID: 9ab536b34054f392e268b9bf9f5e983d600518d2d2ce465657a221b4a68cb5c5" 
time="2016-01-17T22:04:04Z" level=debug msg="successfully verified targets" 
time="2016-01-17T22:04:04Z" level=debug msg="using cached targets" 
time="2016-01-17T22:04:04Z" level=debug msg="targets role has key IDs: 9ab536b34054f392e268b9bf9f5e983d600518d2d2ce465657a221b4a68cb5c5" 
time="2016-01-17T22:04:04Z" level=debug msg="verifying signature for key ID: 9ab536b34054f392e268b9bf9f5e983d600518d2d2ce465657a221b4a68cb5c5" 
dh_auto_test: go test -v github.com/docker/notary/client github.com/docker/notary/client/changelist github.com/docker/notary/cmd/notary github.com/docker/notary/cmd/notary-server github.com/docker/notary/cmd/notary-signer github.com/docker/notary/cryptoservice github.com/docker/notary/errors github.com/docker/notary/keystoremanager github.com/docker/notary/pkg/passphrase github.com/docker/notary/proto github.com/docker/notary/server github.com/docker/notary/server/handlers github.com/docker/notary/server/timestamp github.com/docker/notary/signer github.com/docker/notary/signer/api github.com/docker/notary/signer/keys github.com/docker/notary/trustmanager github.com/docker/notary/utils github.com/docker/notary/version returned exit code 1
time="2016-01-17T22:04:04Z" level=debug msg="successfully verified targets" 
time="2016-01-17T22:04:04Z" level=info msg="[Notary Server] 200 GET /v2/docker.com/notary/_trust/tuf/root.json" 
time="2016-01-17T22:04:04Z" level=debug msg="200 when retrieving metadata for root" 
time="2016-01-17T22:04:04Z" level=debug msg="entered ValidateRoot with dns: docker.com/notary" 
time="2016-01-17T22:04:04Z" level=debug msg="found the following root keys: [79ab3407ad27e3c20fa578b1c0aafb5298d8fa90eccb15368c746d0d5f3b7003]" 
time="2016-01-17T22:04:04Z" level=debug msg="found 1 valid leaf certificates for docker.com/notary" 
time="2016-01-17T22:04:04Z" level=debug msg="found 1 valid root certificates for docker.com/notary" 
time="2016-01-17T22:04:04Z" level=debug msg="entering root certificate rotation for: docker.com/notary" 
time="2016-01-17T22:04:04Z" level=debug msg="Adding cert with certID: 79ab3407ad27e3c20fa578b1c0aafb5298d8fa90eccb15368c746d0d5f3b7003" 
time="2016-01-17T22:04:04Z" level=debug msg="ignoring certificate addition to: docker.com/notary" 
time="2016-01-17T22:04:04Z" level=debug msg="Root validation succeeded for docker.com/notary" 
time="2016-01-17T22:04:04Z" level=debug msg="Adding key 79ab3407ad27e3c20fa578b1c0aafb5298d8fa90eccb15368c746d0d5f3b7003" 
time="2016-01-17T22:04:04Z" level=debug msg="Adding key 9ab536b34054f392e268b9bf9f5e983d600518d2d2ce465657a221b4a68cb5c5" 
time="2016-01-17T22:04:04Z" level=debug msg="Adding key cbb282db337e59cf02c62b33a3fe3f327e8b772fa2d611273f5b5cf9dc33b5b0" 
time="2016-01-17T22:04:04Z" level=debug msg="Adding key e84bb34ed1599ae11f43b687a7ff226cddf20af2671909a2295919f86a970250" 
time="2016-01-17T22:04:04Z" level=debug msg="Adding role snapshot with keys e84bb34ed1599ae11f43b687a7ff226cddf20af2671909a2295919f86a970250" 
time="2016-01-17T22:04:04Z" level=debug msg="Adding role targets with keys 9ab536b34054f392e268b9bf9f5e983d600518d2d2ce465657a221b4a68cb5c5" 
time="2016-01-17T22:04:04Z" level=debug msg="Adding role timestamp with keys cbb282db337e59cf02c62b33a3fe3f327e8b772fa2d611273f5b5cf9dc33b5b0" 
time="2016-01-17T22:04:04Z" level=debug msg="Adding role root with keys 79ab3407ad27e3c20fa578b1c0aafb5298d8fa90eccb15368c746d0d5f3b7003" 
time="2016-01-17T22:04:04Z" level=debug msg="updating TUF client" 
time="2016-01-17T22:04:04Z" level=debug msg=downloadTimestamp 
time="2016-01-17T22:04:04Z" level=debug msg="[Notary Server] 200 GET timestamp: docker.com/notary" 
time="2016-01-17T22:04:04Z" level=info msg="[Notary Server] 200 GET /v2/docker.com/notary/_trust/tuf/timestamp.json" 
time="2016-01-17T22:04:04Z" level=debug msg="200 when retrieving metadata for timestamp" 
time="2016-01-17T22:04:04Z" level=debug msg="timestamp role has key IDs: cbb282db337e59cf02c62b33a3fe3f327e8b772fa2d611273f5b5cf9dc33b5b0" 
time="2016-01-17T22:04:04Z" level=debug msg="verifying signature for key ID: cbb282db337e59cf02c62b33a3fe3f327e8b772fa2d611273f5b5cf9dc33b5b0" 
time="2016-01-17T22:04:04Z" level=debug msg="successfully verified timestamp" 
time="2016-01-17T22:04:04Z" level=debug msg=downloadSnapshot 
time="2016-01-17T22:04:04Z" level=debug msg="using cached snapshot" 
time="2016-01-17T22:04:04Z" level=debug msg="snapshot role has key IDs: e84bb34ed1599ae11f43b687a7ff226cddf20af2671909a2295919f86a970250" 
time="2016-01-17T22:04:04Z" level=debug msg="verifying signature for key ID: e84bb34ed1599ae11f43b687a7ff226cddf20af2671909a2295919f86a970250" 
time="2016-01-17T22:04:04Z" level=debug msg="successfully verified snapshot" 
time="2016-01-17T22:04:04Z" level=debug msg="using cached targets" 
time="2016-01-17T22:04:04Z" level=debug msg="targets role has key IDs: 9ab536b34054f392e268b9bf9f5e983d600518d2d2ce465657a221b4a68cb5c5" 
time="2016-01-17T22:04:04Z" level=debug msg="verifying signature for key ID: 9ab536b34054f392e268b9bf9f5e983d600518d2d2ce465657a221b4a68cb5c5" 
time="2016-01-17T22:04:04Z" level=debug msg="successfully verified targets" 
time="2016-01-17T22:04:04Z" level=debug msg="updating TUF client" 
time="2016-01-17T22:04:04Z" level=debug msg=downloadTimestamp 
time="2016-01-17T22:04:04Z" level=debug msg="[Notary Server] 200 GET timestamp: docker.com/notary" 
make[1]: *** [override_dh_auto_test] Error 1
time="2016-01-17T22:04:04Z" level=info msg="[Notary Server] 200 GET /v2/docker.com/notary/_trust/tuf/timestamp.json" 
time="2016-01-17T22:04:04Z" level=debug msg="200 when retrieving metadata for timestamp" 
time="2016-01-17T22:04:04Z" level=debug msg="timestamp role has key IDs: cbb282db337e59cf02c62b33a3fe3f327e8b772fa2d611273f5b5cf9dc33b5b0" 
time="2016-01-17T22:04:04Z" level=debug msg="verifying signature for key ID: cbb282db337e59cf02c62b33a3fe3f327e8b772fa2d611273f5b5cf9dc33b5b0" 
time="2016-01-17T22:04:04Z" level=debug msg="successfully verified timestamp" 
time="2016-01-17T22:04:04Z" level=debug msg=downloadSnapshot 
time="2016-01-17T22:04:04Z" level=debug msg="using cached snapshot" 
time="2016-01-17T22:04:04Z" level=debug msg="snapshot role has key IDs: e84bb34ed1599ae11f43b687a7ff226cddf20af2671909a2295919f86a970250" 
time="2016-01-17T22:04:04Z" level=debug msg="verifying signature for key ID: e84bb34ed1599ae11f43b687a7ff226cddf20af2671909a2295919f86a970250" 
time="2016-01-17T22:04:04Z" level=debug msg="successfully verified snapshot" 
time="2016-01-17T22:04:04Z" level=debug msg="using cached targets" 
time="2016-01-17T22:04:04Z" level=debug msg="targets role has key IDs: 9ab536b34054f392e268b9bf9f5e983d600518d2d2ce465657a221b4a68cb5c5" 
time="2016-01-17T22:04:04Z" level=debug msg="verifying signature for key ID: 9ab536b34054f392e268b9bf9f5e983d600518d2d2ce465657a221b4a68cb5c5" 
time="2016-01-17T22:04:05Z" level=debug msg="successfully verified targets" 
time="2016-01-17T22:04:05Z" level=debug msg="using cached targets" 
time="2016-01-17T22:04:05Z" level=debug msg="targets role has key IDs: 9ab536b34054f392e268b9bf9f5e983d600518d2d2ce465657a221b4a68cb5c5" 
time="2016-01-17T22:04:05Z" level=debug msg="verifying signature for key ID: 9ab536b34054f392e268b9bf9f5e983d600518d2d2ce465657a221b4a68cb5c5" 
time="2016-01-17T22:04:05Z" level=debug msg="successfully verified targets" 
SIGQUIT: quit
PC=0x72140 m=0

goroutine 0 [idle]:
runtime.futex(0x5f7c98, 0x0, 0x0, 0x0, 0x0, 0x0, 0x1f214, 0x0, 0x0, 0x0, ...)
	/usr/lib/go/src/runtime/sys_linux_arm.s:246 +0x1c
runtime.futexsleep(0x5f7c98, 0x0, 0xffffffff, 0xffffffff)
	/usr/lib/go/src/runtime/os1_linux.go:39 +0x68
runtime.notesleep(0x5f7c98)
	/usr/lib/go/src/runtime/lock_futex.go:142 +0xa4
runtime.stopm()
	/usr/lib/go/src/runtime/proc1.go:1128 +0xfc
runtime.findrunnable(0x1081a000, 0x0)
	/usr/lib/go/src/runtime/proc1.go:1530 +0x6d0
runtime.schedule()
	/usr/lib/go/src/runtime/proc1.go:1639 +0x274
runtime.goschedImpl(0x10800a80)
	/usr/lib/go/src/runtime/proc1.go:1713 +0x120
runtime.gosched_m(0x10800a80)
	/usr/lib/go/src/runtime/proc1.go:1721 +0x30
runtime.mcall(0x5f76f0)
	/usr/lib/go/src/runtime/asm_arm.s:178 +0x5c

goroutine 1 [chan receive, 3 minutes]:
testing.RunTests(0x4c04f8, 0x5d6e00, 0x8, 0x8, 0x10866c01)
	/usr/lib/go/src/testing/testing.go:562 +0x618
testing.(*M).Run(0x10832f7c, 0x130ec)
	/usr/lib/go/src/testing/testing.go:494 +0x6c
main.main()
	github.com/docker/notary/client/_test/_testmain.go:68 +0x118

goroutine 17 [syscall, 8 minutes, locked to thread]:
runtime.goexit()
	/usr/lib/go/src/runtime/asm_arm.s:1036 +0x4

goroutine 19 [syscall, 8 minutes]:
os/signal.loop()
	/usr/lib/go/src/os/signal/signal_unix.go:22 +0x14
created by os/signal.init.1
	/usr/lib/go/src/os/signal/signal_unix.go:28 +0x30

goroutine 66 [runnable]:
math/big.nat.montgomery(0x10b25440, 0x40, 0x86, 0x10c1cc60, 0x40, 0x44, 0x10c1dd40, 0x40, 0x44, 0x10b4f440, ...)
	/usr/lib/go/src/math/big/nat.go:223
math/big.nat.expNNMontgomery(0x10c1cc60, 0x40, 0x44, 0x10c1cb40, 0x40, 0x44, 0x10c1c900, 0x40, 0x44, 0x10b4f440, ...)
	/usr/lib/go/src/math/big/nat.go:1134 +0x850
math/big.nat.expNN(0x10c1cc60, 0x40, 0x44, 0x10c1cb40, 0x40, 0x44, 0x10c1c900, 0x40, 0x44, 0x10b4f440, ...)
	/usr/lib/go/src/math/big/nat.go:939 +0x528
math/big.nat.probablyPrime(0x10b4f440, 0x40, 0x44, 0x14, 0x371a84e)
	/usr/lib/go/src/math/big/nat.go:1211 +0x668
math/big.(*Int).ProbablyPrime(0x10b26b10, 0x14, 0x35)
	/usr/lib/go/src/math/big/int.go:560 +0xa4
make: *** [build-arch] Error 2
dpkg-buildpackage: error: debian/rules build-arch gave error exit status 2
crypto/rand.Prime(0xb5b6c398, 0x108606c0, 0x800, 0x10b26b10, 0x0, 0x0)
	/usr/lib/go/src/crypto/rand/util.go:99 +0x584
crypto/rsa.GenerateMultiPrimeKey(0xb5b6c398, 0x108606c0, 0x2, 0x1000, 0x10a4b6b0, 0x0, 0x0)
	/usr/lib/go/src/crypto/rsa/rsa.go:222 +0x1ec
crypto/rsa.GenerateKey(0xb5b6c398, 0x108606c0, 0x1000, 0x0, 0x0, 0x0)
	/usr/lib/go/src/crypto/rsa/rsa.go:180 +0x4c
github.com/docker/notary/trustmanager.GenerateRSAKey(0xb5b6c398, 0x108606c0, 0x1000, 0x0, 0x0, 0x0, 0x0)
	/«PKGBUILDDIR»/obj-arm-linux-gnueabihf/src/github.com/docker/notary/trustmanager/x509utils.go:304 +0x44
github.com/docker/notary/keystoremanager.(*KeyStoreManager).GenRootKey(0x10c840e0, 0x4191fc, 0x3, 0x0, 0x0, 0x0, 0x0)
	/«PKGBUILDDIR»/obj-arm-linux-gnueabihf/src/github.com/docker/notary/keystoremanager/keystoremanager.go:156 +0xcc
github.com/docker/notary/client.testPublish(0x10817560, 0x4191fc, 0x3)
	/«PKGBUILDDIR»/obj-arm-linux-gnueabihf/src/github.com/docker/notary/client/client_test.go:481 +0x16b8
github.com/docker/notary/client.TestPublish(0x10817560)
	/«PKGBUILDDIR»/obj-arm-linux-gnueabihf/src/github.com/docker/notary/client/client_test.go:444 +0x68
testing.tRunner(0x10817560, 0x5d6e30)
	/usr/lib/go/src/testing/testing.go:456 +0xa8
created by testing.RunTests
	/usr/lib/go/src/testing/testing.go:561 +0x5ec

goroutine 72 [IO wait, 3 minutes]:
net.runtime_pollWait(0xb5b6d6b0, 0x72, 0x1085e000)
	/usr/lib/go/src/runtime/netpoll.go:157 +0x60
net.(*pollDesc).Wait(0x108589b8, 0x72, 0x0, 0x0)
	/usr/lib/go/src/net/fd_poll_runtime.go:73 +0x34
net.(*pollDesc).WaitRead(0x108589b8, 0x0, 0x0)
	/usr/lib/go/src/net/fd_poll_runtime.go:78 +0x30
net.(*netFD).Read(0x10858980, 0x10b33000, 0x1000, 0x1000, 0x0, 0xb5b68018, 0x1085e000)
	/usr/lib/go/src/net/fd_unix.go:232 +0x1c4
net.(*conn).Read(0x1085bf60, 0x10b33000, 0x1000, 0x1000, 0x0, 0x0, 0x0)
	/usr/lib/go/src/net/net.go:172 +0xc8
net/http.noteEOFReader.Read(0xb5b28030, 0x1085bf60, 0x10dfe1ac, 0x10b33000, 0x1000, 0x1000, 0x16d868, 0x0, 0x0)
	/usr/lib/go/src/net/http/transport.go:1370 +0x5c
net/http.(*noteEOFReader).Read(0x10c788a0, 0x10b33000, 0x1000, 0x1000, 0x0, 0x0, 0x0)
	<autogenerated>:126 +0xd0
bufio.(*Reader).fill(0x10ba03f0)
	/usr/lib/go/src/bufio/bufio.go:97 +0x1c4
bufio.(*Reader).Peek(0x10ba03f0, 0x1, 0x0, 0x0, 0x0, 0x0, 0x0)
	/usr/lib/go/src/bufio/bufio.go:132 +0xcc
net/http.(*persistConn).readLoop(0x10dfe180)
	/usr/lib/go/src/net/http/transport.go:876 +0xe4
created by net/http.(*Transport).dialConn
	/usr/lib/go/src/net/http/transport.go:685 +0xab4

goroutine 65 [IO wait, 3 minutes]:
net.runtime_pollWait(0xb5b6d638, 0x72, 0x1085e000)
	/usr/lib/go/src/runtime/netpoll.go:157 +0x60
net.(*pollDesc).Wait(0x108a65f8, 0x72, 0x0, 0x0)
	/usr/lib/go/src/net/fd_poll_runtime.go:73 +0x34
net.(*pollDesc).WaitRead(0x108a65f8, 0x0, 0x0)
	/usr/lib/go/src/net/fd_poll_runtime.go:78 +0x30
net.(*netFD).Read(0x108a65c0, 0x10c24000, 0x1000, 0x1000, 0x0, 0xb5b68018, 0x1085e000)
	/usr/lib/go/src/net/fd_unix.go:232 +0x1c4
net.(*conn).Read(0x108243f0, 0x10c24000, 0x1000, 0x1000, 0x0, 0x0, 0x0)
	/usr/lib/go/src/net/net.go:172 +0xc8
net/http.(*liveSwitchReader).Read(0x10c7a384, 0x10c24000, 0x1000, 0x1000, 0x2, 0x0, 0x0)
	/usr/lib/go/src/net/http/server.go:219 +0x9c
io.(*LimitedReader).Read(0x1085f670, 0x10c24000, 0x1000, 0x1000, 0xb5b76c28, 0x0, 0x0)
	/usr/lib/go/src/io/io.go:427 +0x104
bufio.(*Reader).fill(0x109b0060)
	/usr/lib/go/src/bufio/bufio.go:97 +0x1c4
bufio.(*Reader).ReadSlice(0x109b0060, 0xa, 0x0, 0x0, 0x0, 0x0, 0x0)
	/usr/lib/go/src/bufio/bufio.go:328 +0x264
bufio.(*Reader).ReadLine(0x109b0060, 0x0, 0x0, 0x0, 0x40b700, 0x0, 0x0)
	/usr/lib/go/src/bufio/bufio.go:357 +0x60
net/textproto.(*Reader).readLineSlice(0x1091d280, 0x0, 0x0, 0x0, 0x0, 0x0)
	/usr/lib/go/src/net/textproto/reader.go:55 +0x58
net/textproto.(*Reader).ReadLine(0x1091d280, 0x0, 0x0, 0x0, 0x0)
	/usr/lib/go/src/net/textproto/reader.go:36 +0x34
net/http.ReadRequest(0x109b0060, 0x10bbbce0, 0x0, 0x0)
	/usr/lib/go/src/net/http/request.go:653 +0x80
net/http.(*conn).readRequest(0x10c7a360, 0x0, 0x0, 0x0)
	/usr/lib/go/src/net/http/server.go:633 +0x3a8
net/http.(*conn).serve(0x10c7a360)
	/usr/lib/go/src/net/http/server.go:1319 +0x724
created by net/http.(*Server).Serve
	/usr/lib/go/src/net/http/server.go:1910 +0x360

goroutine 82 [IO wait, 3 minutes]:
net.runtime_pollWait(0xb5b6d548, 0x72, 0x1085e000)
	/usr/lib/go/src/runtime/netpoll.go:157 +0x60
net.(*pollDesc).Wait(0x10a815f8, 0x72, 0x0, 0x0)
	/usr/lib/go/src/net/fd_poll_runtime.go:73 +0x34
net.(*pollDesc).WaitRead(0x10a815f8, 0x0, 0x0)
	/usr/lib/go/src/net/fd_poll_runtime.go:78 +0x30
net.(*netFD).accept(0x10a815c0, 0x0, 0xb5b28000, 0x10dc4d40)
	/usr/lib/go/src/net/fd_unix.go:408 +0x21c
net.(*TCPListener).AcceptTCP(0x10825fe8, 0x8, 0x0, 0x0)
	/usr/lib/go/src/net/tcpsock_posix.go:254 +0x4c
net.(*TCPListener).Accept(0x10825fe8, 0x0, 0x0, 0x0, 0x0)
	/usr/lib/go/src/net/tcpsock_posix.go:264 +0x34
net/http/httptest.(*historyListener).Accept(0x10a41da0, 0x0, 0x0, 0x0, 0x0)
	/usr/lib/go/src/net/http/httptest/server.go:48 +0x5c
net/http.(*Server).Serve(0x10a81600, 0xb5b6d728, 0x10a41da0, 0x0, 0x0)
	/usr/lib/go/src/net/http/server.go:1887 +0x88
created by net/http/httptest.(*Server).Start
	/usr/lib/go/src/net/http/httptest/server.go:109 +0x364

goroutine 67 [IO wait, 3 minutes]:
net.runtime_pollWait(0xb5b6d5c0, 0x72, 0x1085e000)
	/usr/lib/go/src/runtime/netpoll.go:157 +0x60
net.(*pollDesc).Wait(0x10b95a38, 0x72, 0x0, 0x0)
	/usr/lib/go/src/net/fd_poll_runtime.go:73 +0x34
net.(*pollDesc).WaitRead(0x10b95a38, 0x0, 0x0)
	/usr/lib/go/src/net/fd_poll_runtime.go:78 +0x30
net.(*netFD).accept(0x10b95a00, 0x0, 0xb5b28000, 0x1085f680)
	/usr/lib/go/src/net/fd_unix.go:408 +0x21c
net.(*TCPListener).AcceptTCP(0x1085af58, 0x1091c120, 0x0, 0x0)
	/usr/lib/go/src/net/tcpsock_posix.go:254 +0x4c
net.(*TCPListener).Accept(0x1085af58, 0x0, 0x0, 0x0, 0x0)
	/usr/lib/go/src/net/tcpsock_posix.go:264 +0x34
net/http/httptest.(*historyListener).Accept(0x109450c0, 0x0, 0x0, 0x0, 0x0)
	/usr/lib/go/src/net/http/httptest/server.go:48 +0x5c
net/http.(*Server).Serve(0x10b95a80, 0xb5b6d728, 0x109450c0, 0x0, 0x0)
	/usr/lib/go/src/net/http/server.go:1887 +0x88
created by net/http/httptest.(*Server).Start
	/usr/lib/go/src/net/http/httptest/server.go:109 +0x364

goroutine 73 [select, 3 minutes]:
net/http.(*persistConn).writeLoop(0x10dfe180)
	/usr/lib/go/src/net/http/transport.go:1009 +0x314
created by net/http.(*Transport).dialConn
	/usr/lib/go/src/net/http/transport.go:686 +0xad0

trap    0x0
error   0x0
oldmask 0x0
r0      0x5f7c98
r1      0x0
r2      0x0
r3      0x0
r4      0x0
r5      0x0
r6      0xd65cb
r7      0xf0
r8      0xbeea9
r9      0x0
r10     0x5f76d0
fp      0x5f74e4
ip      0x107f39fd
sp      0xbebdd238
lr      0x3bca0
pc      0x72140
cpsr    0xa0000010
fault   0x0
*** Test killed with quit: ran too long (10m0s).
FAIL	github.com/docker/notary/client	600.031s
=== RUN   TestMemChangelist
--- PASS: TestMemChangelist (0.00s)
=== RUN   TestAdd
--- PASS: TestAdd (0.01s)
=== RUN   TestListOrder
--- PASS: TestListOrder (0.00s)
PASS
ok  	github.com/docker/notary/client/changelist	0.071s
?   	github.com/docker/notary/cmd/notary	[no test files]
?   	github.com/docker/notary/cmd/notary-server	[no test files]
testing: warning: no tests to run
PASS
ok  	github.com/docker/notary/cmd/notary-signer	0.091s
=== RUN   TestCryptoService
--- PASS: TestCryptoService (19.71s)
=== RUN   TestUnlockedSigner
--- PASS: TestUnlockedSigner (0.05s)
PASS
ok  	github.com/docker/notary/cryptoservice	19.844s
?   	github.com/docker/notary/errors	[no test files]
=== RUN   TestCertsToRemove
--- PASS: TestCertsToRemove (0.02s)
=== RUN   TestValidateRoot
--- PASS: TestValidateRoot (0.08s)
=== RUN   TestValidateSuccessfulRootRotation
--- PASS: TestValidateSuccessfulRootRotation (252.72s)
=== RUN   TestValidateRootRotationMissingOrigSig
--- PASS: TestValidateRootRotationMissingOrigSig (128.18s)
=== RUN   TestValidateRootRotationMissingNewSig
--- PASS: TestValidateRootRotationMissingNewSig (129.17s)
=== RUN   TestImportExportZip
--- PASS: TestImportExportZip (0.40s)
=== RUN   TestImportExportGUN
--- PASS: TestImportExportGUN (0.37s)
=== RUN   TestImportExportRootKey
--- PASS: TestImportExportRootKey (0.37s)
=== RUN   TestImportExportRootKeyReencrypt
--- PASS: TestImportExportRootKeyReencrypt (0.36s)
PASS
ok  	github.com/docker/notary/keystoremanager	511.723s
?   	github.com/docker/notary/pkg/passphrase	[no test files]
?   	github.com/docker/notary/proto	[no test files]
=== RUN   TestRunBadAddr
--- PASS: TestRunBadAddr (0.00s)
=== RUN   TestRunReservedPort
--- PASS: TestRunReservedPort (0.00s)
PASS
ok  	github.com/docker/notary/server	0.035s
=== RUN   TestMainHandlerGet
time="2016-01-17T21:57:47Z" level=info msg="[Notary Server] 200 GET /" 
--- PASS: TestMainHandlerGet (0.02s)
=== RUN   TestMainHandlerNotGet
time="2016-01-17T21:57:47Z" level=error msg="[Notary Server] 404 HEAD /" 
--- PASS: TestMainHandlerNotGet (0.00s)
=== RUN   TestValidateEmptyNew
--- PASS: TestValidateEmptyNew (0.14s)
=== RUN   TestValidateNoNewRoot
--- PASS: TestValidateNoNewRoot (0.10s)
=== RUN   TestValidateNoNewTargets
--- PASS: TestValidateNoNewTargets (0.12s)
=== RUN   TestValidateOnlySnapshot
--- PASS: TestValidateOnlySnapshot (0.08s)
=== RUN   TestValidateOldRoot
--- PASS: TestValidateOldRoot (0.13s)
=== RUN   TestValidateRootRotation
--- PASS: TestValidateRootRotation (0.14s)
=== RUN   TestValidateNoRoot
--- PASS: TestValidateNoRoot (0.05s)
=== RUN   TestValidateSnapshotMissing
time="2016-01-17T21:57:48Z" level=error msg="ErrBadHierarchy: snapshot missing from update" 
--- PASS: TestValidateSnapshotMissing (0.05s)
=== RUN   TestValidateRootRoleMissing
time="2016-01-17T21:57:48Z" level=error msg="ErrBadRoot: new root is missing role entry for root role" 
--- PASS: TestValidateRootRoleMissing (0.07s)
=== RUN   TestValidateTargetsRoleMissing
time="2016-01-17T21:57:48Z" level=error msg="ErrBadRoot: missing required targets role from root" 
--- PASS: TestValidateTargetsRoleMissing (0.05s)
=== RUN   TestValidateSnapshotRoleMissing
time="2016-01-17T21:57:48Z" level=error msg="ErrBadRoot: missing required snapshot role from root" 
--- PASS: TestValidateSnapshotRoleMissing (0.05s)
=== RUN   TestValidateRootSigMissing
time="2016-01-17T21:57:48Z" level=error msg="ErrBadRoot: tuf: data has no signatures" 
--- PASS: TestValidateRootSigMissing (0.04s)
=== RUN   TestValidateTargetsSigMissing
time="2016-01-17T21:57:48Z" level=error msg="ErrBadTargets: tuf: data has no signatures" 
--- PASS: TestValidateTargetsSigMissing (0.05s)
=== RUN   TestValidateSnapshotSigMissing
time="2016-01-17T21:57:48Z" level=error msg="ErrBadSnapshot: tuf: data has no signatures" 
--- PASS: TestValidateSnapshotSigMissing (0.06s)
=== RUN   TestValidateRootCorrupt
time="2016-01-17T21:57:48Z" level=error msg="ErrBadRoot: invalid character '\\u0084' looking for beginning of value" 
--- PASS: TestValidateRootCorrupt (0.03s)
=== RUN   TestValidateTargetsCorrupt
time="2016-01-17T21:57:48Z" level=error msg="ErrBadTargets: could not parse targets" 
--- PASS: TestValidateTargetsCorrupt (0.05s)
=== RUN   TestValidateSnapshotCorrupt
time="2016-01-17T21:57:48Z" level=error msg="ErrBadSnapshot: could not parse snapshot" 
--- PASS: TestValidateSnapshotCorrupt (0.06s)
=== RUN   TestValidateRootModifiedSize
time="2016-01-17T21:57:48Z" level=error msg="ErrBadRoot: invalid character '\\u0084' looking for beginning of value" 
--- PASS: TestValidateRootModifiedSize (0.03s)
=== RUN   TestValidateTargetsModifiedSize
time="2016-01-17T21:57:48Z" level=error msg="ErrBadSnapshot: snapshot has incorrect length for targets" 
--- PASS: TestValidateTargetsModifiedSize (0.08s)
=== RUN   TestValidateRootModifiedHash
time="2016-01-17T21:57:48Z" level=info msg="failed ed25519 verification" 
time="2016-01-17T21:57:48Z" level=error msg="ErrBadSnapshot: valid signatures did not meet threshold" 
--- PASS: TestValidateRootModifiedHash (0.07s)
=== RUN   TestValidateTargetsModifiedHash
time="2016-01-17T21:57:48Z" level=info msg="failed ed25519 verification" 
time="2016-01-17T21:57:48Z" level=error msg="ErrBadSnapshot: valid signatures did not meet threshold" 
--- PASS: TestValidateTargetsModifiedHash (0.07s)
PASS
ok  	github.com/docker/notary/server/handlers	1.652s
=== RUN   TestTimestampExpired
--- PASS: TestTimestampExpired (0.00s)
=== RUN   TestGetTimestampKey
--- PASS: TestGetTimestampKey (0.01s)
=== RUN   TestGetTimestamp
--- PASS: TestGetTimestamp (0.01s)
=== RUN   TestGetTimestampNewSnapshot
--- PASS: TestGetTimestampNewSnapshot (0.01s)
PASS
ok  	github.com/docker/notary/server/timestamp	0.065s
=== RUN   TestCreateRead
--- PASS: TestCreateRead (1.41s)
=== RUN   TestDoubleCreate

[35m(UNIQUE constraint failed: private_keys.key_id)[0m 
[33m[2016-01-17 21:57:56][0m [31;1m [0m
--- PASS: TestDoubleCreate (1.96s)
=== RUN   TestCreateDelete
--- PASS: TestCreateDelete (1.19s)
=== RUN   TestKeyRotation
--- PASS: TestKeyRotation (2.49s)
PASS
ok  	github.com/docker/notary/signer	7.122s
=== RUN   TestDeleteKeyHandlerReturns404WithNonexistentKey
--- PASS: TestDeleteKeyHandlerReturns404WithNonexistentKey (0.01s)
=== RUN   TestDeleteKeyHandler
--- PASS: TestDeleteKeyHandler (0.01s)
=== RUN   TestKeyInfoHandler
--- PASS: TestKeyInfoHandler (0.01s)
=== RUN   TestKeyInfoHandlerReturns404WithNonexistentKey
--- PASS: TestKeyInfoHandlerReturns404WithNonexistentKey (0.00s)
=== RUN   TestHSMCreateKeyHandler
--- SKIP: TestHSMCreateKeyHandler (0.00s)
	api_test.go:38: Skipping test. Library path: /usr/local/lib/softhsm/libsofthsm2.so does not exist
=== RUN   TestSoftwareCreateKeyHandler
--- PASS: TestSoftwareCreateKeyHandler (0.01s)
=== RUN   TestHSMSignHandler
--- SKIP: TestHSMSignHandler (0.00s)
	api_test.go:38: Skipping test. Library path: /usr/local/lib/softhsm/libsofthsm2.so does not exist
=== RUN   TestSoftwareSignHandler
--- PASS: TestSoftwareSignHandler (0.02s)
=== RUN   TestSoftwareSignWithInvalidRequestHandler
--- PASS: TestSoftwareSignWithInvalidRequestHandler (0.00s)
=== RUN   TestSignHandlerReturns404WithNonexistentKey
--- PASS: TestSignHandlerReturns404WithNonexistentKey (0.01s)
=== RUN   TestDeleteKeyHandlerReturnsNotFoundWithNonexistentKey
--- PASS: TestDeleteKeyHandlerReturnsNotFoundWithNonexistentKey (0.00s)
=== RUN   TestCreateKeyHandlerCreatesKey
2016/01/17 21:58:10 [Notary-signer CreateKey] : Created KeyID  4e52d2abcecf4e745fd3006467bc6882848130489bf56fc8a8ad5597b2e2efab
--- PASS: TestCreateKeyHandlerCreatesKey (0.01s)
=== RUN   TestDeleteKeyHandlerDeletesCreatedKey
2016/01/17 21:58:10 [Notary-signer CreateKey] : Created KeyID  7afc57899fc0c476f0713e18719fcf4634e6f9088e98fee28fff62f8d1496b3a
2016/01/17 21:58:10 [Notary-signer DeleteKey] : Deleted KeyID  7afc57899fc0c476f0713e18719fcf4634e6f9088e98fee28fff62f8d1496b3a
--- PASS: TestDeleteKeyHandlerDeletesCreatedKey (0.01s)
=== RUN   TestKeyInfoReturnsCreatedKeys
2016/01/17 21:58:10 [Notary-signer CreateKey] : Created KeyID  146a3a9a830642611c6b8301bab9862586306edb567806acc82d0012bc15c6f7
Pubkey ID: 146a3a9a830642611c6b8301bab9862586306edb567806acc82d0012bc15c6f7
2016/01/17 21:58:10 [Notary-signer GetKeyInfo] : Returning PublicKey for KeyID  146a3a9a830642611c6b8301bab9862586306edb567806acc82d0012bc15c6f7
returnedPublicKey ID: 146a3a9a830642611c6b8301bab9862586306edb567806acc82d0012bc15c6f7
--- PASS: TestKeyInfoReturnsCreatedKeys (0.01s)
=== RUN   TestCreateKeyCreatesNewKeys
2016/01/17 21:58:10 [Notary-signer CreateKey] : Created KeyID  48ee52538073c19310cdaad9d958384d0623768ecafa1abfa9d97517e0a829d0
2016/01/17 21:58:10 [Notary-signer CreateKey] : Created KeyID  4768fab161a71a662f98b21d8021a19516323c0eada1df1c9cb9e4d56837dd2f
--- PASS: TestCreateKeyCreatesNewKeys (0.01s)
=== RUN   TestGetKeyInfoReturnsNotFoundOnNonexistKeys
--- PASS: TestGetKeyInfoReturnsNotFoundOnNonexistKeys (0.01s)
=== RUN   TestCreatedKeysCanBeUsedToSign
2016/01/17 21:58:10 [Notary-signer CreateKey] : Created KeyID  3ed3b2dba8774994e218819abaa23d583dfd4dcfc7580858e15c1e13935c0328
2016/01/17 21:58:10 [Notary-signer Sign] : Signing    with KeyID  3ed3b2dba8774994e218819abaa23d583dfd4dcfc7580858e15c1e13935c0328
--- PASS: TestCreatedKeysCanBeUsedToSign (0.01s)
=== RUN   TestSignReturnsNotFoundOnNonexistKeys
--- PASS: TestSignReturnsNotFoundOnNonexistKeys (0.00s)
PASS
ok  	github.com/docker/notary/signer/api	0.211s
?   	github.com/docker/notary/signer/keys	[no test files]
=== RUN   TestAddFile
--- PASS: TestAddFile (0.01s)
=== RUN   TestRemoveFile
--- PASS: TestRemoveFile (0.00s)
=== RUN   TestRemoveDir
--- PASS: TestRemoveDir (0.00s)
=== RUN   TestListFiles
--- PASS: TestListFiles (0.02s)
=== RUN   TestListDir
--- PASS: TestListDir (0.01s)
=== RUN   TestLink
--- PASS: TestLink (0.01s)
=== RUN   TestGetPath
--- PASS: TestGetPath (0.00s)
=== RUN   TestGetPathProtection
--- PASS: TestGetPathProtection (0.00s)
=== RUN   TestGetData
--- PASS: TestGetData (0.00s)
=== RUN   TestCreateDirectory
--- PASS: TestCreateDirectory (0.00s)
=== RUN   TestCreatePrivateDirectory
--- PASS: TestCreatePrivateDirectory (0.00s)
=== RUN   TestAddKey
--- PASS: TestAddKey (0.02s)
=== RUN   TestGet
--- PASS: TestGet (0.02s)
=== RUN   TestAddGetKeyMemStore
--- PASS: TestAddGetKeyMemStore (0.02s)
=== RUN   TestGetDecryptedWithTamperedCipherText
--- PASS: TestGetDecryptedWithTamperedCipherText (0.02s)
=== RUN   TestGetDecryptedWithInvalidPassphrase
--- PASS: TestGetDecryptedWithInvalidPassphrase (0.02s)
=== RUN   TestGetDecryptedWithConsistentlyInvalidPassphrase
--- PASS: TestGetDecryptedWithConsistentlyInvalidPassphrase (0.02s)
=== RUN   TestRemoveKey
--- PASS: TestRemoveKey (0.02s)
=== RUN   TestKeysAreCached
--- PASS: TestKeysAreCached (0.03s)
=== RUN   TestNewX509FileStore
--- PASS: TestNewX509FileStore (0.00s)
=== RUN   TestAddCertX509FileStore
--- PASS: TestAddCertX509FileStore (0.01s)
=== RUN   TestAddCertFromFileX509FileStore
--- PASS: TestAddCertFromFileX509FileStore (0.01s)
=== RUN   TestAddCertFromPEMX509FileStore
--- PASS: TestAddCertFromPEMX509FileStore (0.00s)
=== RUN   TestRemoveCertX509FileStore
--- PASS: TestRemoveCertX509FileStore (0.00s)
=== RUN   TestRemoveAllX509FileStore
--- PASS: TestRemoveAllX509FileStore (0.01s)
=== RUN   TestInexistentGetCertificateByKeyIDX509FileStore
--- PASS: TestInexistentGetCertificateByKeyIDX509FileStore (0.00s)
=== RUN   TestGetCertificateByKeyIDX509FileStore
--- PASS: TestGetCertificateByKeyIDX509FileStore (0.00s)
=== RUN   TestGetVerifyOpsErrorsWithoutCertsX509FileStore
--- PASS: TestGetVerifyOpsErrorsWithoutCertsX509FileStore (0.00s)
=== RUN   TestVerifyLeafCertFromIntermediateX509FileStore
--- PASS: TestVerifyLeafCertFromIntermediateX509FileStore (0.02s)
=== RUN   TestVerifyIntermediateFromRootX509FileStore
--- PASS: TestVerifyIntermediateFromRootX509FileStore (0.02s)
=== RUN   TestNewX509FilteredFileStore
--- PASS: TestNewX509FilteredFileStore (0.01s)
=== RUN   TestGetCertificatePoolX509FileStore
--- PASS: TestGetCertificatePoolX509FileStore (0.00s)
=== RUN   TestAddCert
--- PASS: TestAddCert (0.00s)
=== RUN   TestAddCertFromFile
--- PASS: TestAddCertFromFile (0.00s)
=== RUN   TestAddCertFromPEM
--- PASS: TestAddCertFromPEM (0.00s)
=== RUN   TestRemoveCert
--- PASS: TestRemoveCert (0.00s)
=== RUN   TestRemoveAllX509MemStore
--- PASS: TestRemoveAllX509MemStore (0.01s)
=== RUN   TestInexistentGetCertificateByCertID
--- PASS: TestInexistentGetCertificateByCertID (0.00s)
=== RUN   TestGetCertificateByKeyID
--- PASS: TestGetCertificateByKeyID (0.00s)
=== RUN   TestGetVerifyOpsErrorsWithoutCerts
--- PASS: TestGetVerifyOpsErrorsWithoutCerts (0.00s)
=== RUN   TestVerifyLeafCertFromIntermediate
--- PASS: TestVerifyLeafCertFromIntermediate (0.02s)
=== RUN   TestVerifyIntermediateFromRoot
--- PASS: TestVerifyIntermediateFromRoot (0.02s)
=== RUN   TestNewX509FilteredMemStore
--- PASS: TestNewX509FilteredMemStore (0.01s)
=== RUN   TestGetCertificatePool
--- PASS: TestGetCertificatePool (0.00s)
=== RUN   TestVerifyLeafSuccessfully
--- PASS: TestVerifyLeafSuccessfully (0.03s)
=== RUN   TestVerifyLeafSuccessfullyWithMultipleIntermediates
--- PASS: TestVerifyLeafSuccessfullyWithMultipleIntermediates (0.06s)
=== RUN   TestVerifyLeafWithNoIntermediate
--- PASS: TestVerifyLeafWithNoIntermediate (0.01s)
=== RUN   TestVerifyLeafWithNoLeaf
--- PASS: TestVerifyLeafWithNoLeaf (0.00s)
=== RUN   TestCertsToKeys
--- PASS: TestCertsToKeys (0.01s)
=== RUN   TestNewCertificate
--- PASS: TestNewCertificate (0.00s)
=== RUN   TestKeyOperations
--- PASS: TestKeyOperations (0.15s)
PASS
ok  	github.com/docker/notary/trustmanager	0.706s
=== RUN   TestRootHandlerFactory
time="2016-01-17T21:58:22Z" level=info msg="[Notary Server] 200 GET /" 
--- PASS: TestRootHandlerFactory (0.00s)
=== RUN   TestRootHandlerError
time="2016-01-17T21:58:22Z" level=error msg="[Notary Server] 500 GET /" 
--- PASS: TestRootHandlerError (0.00s)
PASS
ok  	github.com/docker/notary/utils	0.043s
?   	github.com/docker/notary/version	[no test files]
debian/rules:7: recipe for target 'override_dh_auto_test' failed
make[1]: Leaving directory '/«PKGBUILDDIR»'
debian/rules:12: recipe for target 'build-arch' failed
────────────────────────────────────────────────────────────────────────────────
Build finished at 20160117-2207

Finished
────────

E: Build failure (dpkg-buildpackage died)

┌──────────────────────────────────────────────────────────────────────────────┐
│ Cleanup                                                                      │
└──────────────────────────────────────────────────────────────────────────────┘

Purging /«BUILDDIR»
Not cleaning session: cloned chroot in use

┌──────────────────────────────────────────────────────────────────────────────┐
│ Summary                                                                      │
└──────────────────────────────────────────────────────────────────────────────┘

Build Architecture: armhf
Build-Space: 58840
Build-Time: 758
Distribution: stretch-staging
Fail-Stage: build
Host Architecture: armhf
Install-Time: 500
Job: notary_0.0~git20150801.0.8e8122e-2
Machine Architecture: armhf
Package: notary
Package-Time: 1302
Source-Version: 0.0~git20150801.0.8e8122e-2
Space: 58840
Status: attempted
Version: 0.0~git20150801.0.8e8122e-2
────────────────────────────────────────────────────────────────────────────────
Finished at 20160117-2207
Build needed 00:21:42, 58840k disc space
Raspbian Package Auto-Building

Build log for notary (0.0~git20150801.0.8e8122e-2) on armhf
