app-admin:consul-template-0.18.5-r1:20171004-183619.log

app-admin:consul-template-0.18.5-r1:20171004-183619.log (text/plain), 18.59 KB, created by Toralf Förster on 2017-10-04 18:48:55 UTC

 * Package:    app-admin/consul-template-0.18.5-r1
 * Repository: gentoo
 * Maintainer: [e-mail]
 * USE:        abi_x86_64 amd64 elibc_glibc kernel_linux userland_GNU
 * FEATURES:   network-sandbox preserve-libs sandbox test userpriv usersandbox
 * Adding group 'consul-template' to your system ...
 *  - Groupid: next available
 * Adding user 'consul-template' to your system ...
 *  - Userid: 198
 *  - Shell: /sbin/nologin
 *  - Home: /dev/null
 *  - Groups: consul-template
 *  - GECOS: added by portage for consul-template
>>> Unpacking source...
>>> Source unpacked in /var/tmp/portage/app-admin/consul-template-0.18.5-r1/work
>>> Preparing source in /var/tmp/portage/app-admin/consul-template-0.18.5-r1/work/consul-template-0.18.5 ...
>>> Source prepared.
>>> Configuring source in /var/tmp/portage/app-admin/consul-template-0.18.5-r1/work/consul-template-0.18.5 ...
>>> Source configured.
>>> Compiling source in /var/tmp/portage/app-admin/consul-template-0.18.5-r1/work/consul-template-0.18.5 ...
make -j1 bin-local 
==> Building github.com/hashicorp/consul-template (locally)...
-->        linux/amd64: github.com/hashicorp/consul-template
>>> Source compiled.
>>> Test phase: app-admin/consul-template-0.18.5-r1
make -j1 test 
==> Testing github.com/hashicorp/consul-template...
ok  	github.com/hashicorp/consul-template	3.113s
ok  	github.com/hashicorp/consul-template/child	1.240s
ok  	github.com/hashicorp/consul-template/config	0.290s
2017-10-04 20:37:31.271931 I | [TRACE] health.service(consul|passing): GET /v1/health/service/consul
2017-10-04 20:37:31.272650 I | [TRACE] file(/not/a/real/path/ever): READ /not/a/real/path/ever
2017-10-04 20:37:31.272722 I | [TRACE] file(/var/tmp/portage/app-admin/consul-template-0.18.5-r1/temp/221070963): READ /var/tmp/portage/app-admin/consul-template-0.18.5-r1/temp/221070963
2017-10-04 20:37:31.272767 I | [TRACE] file(/var/tmp/portage/app-admin/consul-template-0.18.5-r1/temp/221070963): reported change
2017-10-04 20:37:31.272861 I | [TRACE] file(/var/tmp/portage/app-admin/consul-template-0.18.5-r1/temp/540539702): READ /var/tmp/portage/app-admin/consul-template-0.18.5-r1/temp/540539702
2017-10-04 20:37:31.272876 I | [TRACE] file(/var/tmp/portage/app-admin/consul-template-0.18.5-r1/temp/540539702): stopped
2017-10-04 20:37:31.272958 I | [TRACE] file(/var/tmp/portage/app-admin/consul-template-0.18.5-r1/temp/255973149): READ /var/tmp/portage/app-admin/consul-template-0.18.5-r1/temp/255973149
2017-10-04 20:37:31.272985 I | [TRACE] file(/var/tmp/portage/app-admin/consul-template-0.18.5-r1/temp/255973149): reported change
2017-10-04 20:37:31.273018 I | [TRACE] file(/var/tmp/portage/app-admin/consul-template-0.18.5-r1/temp/255973149): READ /var/tmp/portage/app-admin/consul-template-0.18.5-r1/temp/255973149
2017-10-04 20:37:31.289170 I | [TRACE] catalog.services: GET /v1/catalog/services
2017-10-04 20:37:31.289868 I | [TRACE] catalog.service(consul): GET /v1/catalog/service/consul
2017-10-04 20:37:31.290612 I | [TRACE] catalog.nodes: GET /v1/catalog/nodes
2017-10-04 20:37:31.291077 I | [TRACE] catalog.node: getting local agent name
2017-10-04 20:37:31.291460 I | [TRACE] catalog.datacenters: GET /v1/catalog/datacenters
2017-10-04 20:37:31.330459 I | [TRACE] file(/var/tmp/portage/app-admin/consul-template-0.18.5-r1/temp/255973149): reported change
2017-10-04 20:37:31.330535 I | [TRACE] file(/var/tmp/portage/app-admin/consul-template-0.18.5-r1/temp/255973149): READ /var/tmp/portage/app-admin/consul-template-0.18.5-r1/temp/255973149
2017-10-04 20:37:31.364509 I | [TRACE] vault.read(secret/foo/bar): GET /v1/secret/foo/bar
2017-10-04 20:37:31.366183 I | [TRACE] vault.list(secret): LIST /v1/secret
2017-10-04 20:37:31.379433 I | [TRACE] file(/var/tmp/portage/app-admin/consul-template-0.18.5-r1/temp/255973149): stopped
2017-10-04 20:37:31.380372 I | [TRACE] health.service(consul|passing): returned 1 results
2017-10-04 20:37:31.380396 I | [TRACE] health.service(consul|passing): returned 1 results after filtering
2017-10-04 20:37:31.381084 I | [TRACE] health.service(consul|warning): GET /v1/health/service/consul
2017-10-04 20:37:31.382943 I | [TRACE] catalog.datacenters: returned 1 results
2017-10-04 20:37:31.383046 I | [TRACE] catalog.datacenters: GET /v1/catalog/datacenters?index=10
2017-10-04 20:37:31.383065 I | [TRACE] catalog.datacenters: long polling for 50ms
2017-10-04 20:37:31.383696 I | [TRACE] catalog.node: GET /v1/catalog/node/node39593
2017-10-04 20:37:31.383927 I | [TRACE] catalog.nodes: returned 1 results
--- FAIL: TestCatalogNodesQuery_Fetch (0.09s)
    --- FAIL: TestCatalogNodesQuery_Fetch/0_all (0.09s)
    	assertions.go:226: 
                          
	Error Trace:	catalog_nodes_test.go:118
    		
	Error:      	Not equal: 
    		
	            	expected: []*dependency.Node{(*dependency.Node)(0xc420081310)}
    		
	            	received: []*dependency.Node{(*dependency.Node)(0xc420080d70)}
    		
	            	
    		
	            	Diff:
    		
	            	--- Expected
    		
	            	+++ Actual
    		
	            	@@ -10,3 +10,4 @@
    		
	            	   },
    		
	            	-  Meta: (map[string]string) {
    		
	            	+  Meta: (map[string]string) (len=1) {
    		
	            	+   (string) (len=22) "consul-network-segment": (string) ""
    		
	            	   }
2017-10-04 20:37:31.384869 I | [TRACE] catalog.service(consul): returned 1 results
--- FAIL: TestCatalogServiceQuery_Fetch (0.10s)
    --- FAIL: TestCatalogServiceQuery_Fetch/0_consul (0.10s)
    	assertions.go:226: 
                          
	Error Trace:	catalog_service_test.go:186
    		
	Error:      	Not equal: 
    		
	            	expected: []*dependency.CatalogService{(*dependency.CatalogService)(0xc4200a60a0)}
    		
	            	received: []*dependency.CatalogService{(*dependency.CatalogService)(0xc4201d7900)}
    		
	            	
    		
	            	Diff:
    		
	            	--- Expected
    		
	            	+++ Actual
    		
	            	@@ -10,3 +10,4 @@
    		
	            	   },
    		
	            	-  NodeMeta: (map[string]string) {
    		
	            	+  NodeMeta: (map[string]string) (len=1) {
    		
	            	+   (string) (len=22) "consul-network-segment": (string) ""
    		
	            	   },
2017-10-04 20:37:31.385176 I | [TRACE] catalog.services: returned 1 results
2017-10-04 20:37:31.385376 I | [TRACE] catalog.node: returned response
2017-10-04 20:37:31.385701 I | [TRACE] catalog.node(not_a_real_node): GET /v1/catalog/node/not_a_real_node
2017-10-04 20:37:31.396800 I | [TRACE] health.service(consul|warning): returned 1 results
2017-10-04 20:37:31.396831 I | [TRACE] health.service(consul|warning): returned 0 results after filtering
2017-10-04 20:37:31.396931 I | [TRACE] health.service(consul|passing,warning): GET /v1/health/service/consul
2017-10-04 20:37:31.397370 I | [TRACE] catalog.node(not_a_real_node): returned response
2017-10-04 20:37:31.397392 I | [WARN] catalog.node(not_a_real_node): no node exists with the name "not_a_real_node"
--- FAIL: TestCatalogNodeQuery_Fetch (0.11s)
    --- FAIL: TestCatalogNodeQuery_Fetch/0_local (0.09s)
    	assertions.go:226: 
                          
	Error Trace:	catalog_node_test.go:129
    		
	Error:      	Not equal: 
    		
	            	expected: &dependency.CatalogNode{Node:(*dependency.Node)(0xc420081590), Services:[]*dependency.CatalogNodeService{(*dependency.CatalogNodeService)(0xc420075ec0)}}
    		
	            	received: &dependency.CatalogNode{Node:(*dependency.Node)(0xc420080e10), Services:[]*dependency.CatalogNodeService{(*dependency.CatalogNodeService)(0xc4205f2600)}}
    		
	            	
    		
	            	Diff:
    		
	            	--- Expected
    		
	            	+++ Actual
    		
	            	@@ -10,3 +10,4 @@
    		
	            	   },
    		
	            	-  Meta: (map[string]string) {
    		
	            	+  Meta: (map[string]string) (len=1) {
    		
	            	+   (string) (len=22) "consul-network-segment": (string) ""
    		
	            	   }
2017-10-04 20:37:31.399506 I | [TRACE] vault.token: GET /v1/auth/token/renew-self
2017-10-04 20:37:31.399822 I | [TRACE] vault.list(secret): returned 1 results
2017-10-04 20:37:31.399889 I | [TRACE] vault.list(not/a/real/path/like/ever): LIST /v1/not/a/real/path/like/ever
2017-10-04 20:37:31.400062 I | [TRACE] vault.read(not/a/real/path/like/ever): GET /v1/not/a/real/path/like/ever
2017-10-04 20:37:31.400254 I | [TRACE] health.service(consul|passing,warning): returned 1 results
2017-10-04 20:37:31.400272 I | [TRACE] health.service(consul|passing,warning): returned 1 results after filtering
--- FAIL: TestHealthServiceQuery_Fetch (0.13s)
    --- FAIL: TestHealthServiceQuery_Fetch/0_consul (0.11s)
    	assertions.go:226: 
                          
	Error Trace:	health_service_test.go:221
    		
	Error:      	Not equal: 
    		
	            	expected: []*dependency.HealthService{(*dependency.HealthService)(0xc420112240)}
    		
	            	received: []*dependency.HealthService{(*dependency.HealthService)(0xc420112540)}
    		
	            	
    		
	            	Diff:
    		
	            	--- Expected
    		
	            	+++ Actual
    		
	            	@@ -9,3 +9,4 @@
    		
	            	   },
    		
	            	-  NodeMeta: (map[string]string) {
    		
	            	+  NodeMeta: (map[string]string) (len=1) {
    		
	            	+   (string) (len=22) "consul-network-segment": (string) ""
    		
	            	   },
    --- FAIL: TestHealthServiceQuery_Fetch/2_multifilter (0.00s)
    	assertions.go:226: 
                          
	Error Trace:	health_service_test.go:221
    		
	Error:      	Not equal: 
    		
	            	expected: []*dependency.HealthService{(*dependency.HealthService)(0xc420112300)}
    		
	            	received: []*dependency.HealthService{(*dependency.HealthService)(0xc420112840)}
    		
	            	
    		
	            	Diff:
    		
	            	--- Expected
    		
	            	+++ Actual
    		
	            	@@ -9,3 +9,4 @@
    		
	            	   },
    		
	            	-  NodeMeta: (map[string]string) {
    		
	            	+  NodeMeta: (map[string]string) (len=1) {
    		
	            	+   (string) (len=22) "consul-network-segment": (string) ""
    		
	            	   },
2017-10-04 20:37:31.402873 I | [TRACE] kv.list(test-kv-list/prefix): GET /v1/kv/test-kv-list/prefix
2017-10-04 20:37:31.403781 I | [TRACE] vault.write(transit/encrypt/test -> de193cf9): PUT /v1/transit/encrypt/test
2017-10-04 20:37:31.404127 I | [TRACE] kv.get(test-kv-get/key): GET /v1/kv/test-kv-get/key
2017-10-04 20:37:31.405632 I | [DEBUG] vault.token: renewed token
2017-10-04 20:37:31.405719 I | [TRACE] vault.token: GET /v1/auth/token/renew-self
2017-10-04 20:37:31.405902 I | [TRACE] kv.list(test-kv-list/prefix): returned 3 pairs
2017-10-04 20:37:31.405997 I | [TRACE] kv.list(test-kv-list/prefix/): GET /v1/kv/test-kv-list/prefix/
2017-10-04 20:37:31.406386 I | [TRACE] vault.list(not/a/real/path/like/ever): no data
2017-10-04 20:37:31.406457 I | [TRACE] vault.list(secret/foo/bar): LIST /v1/secret/foo/bar
2017-10-04 20:37:31.406623 I | [TRACE] vault.read(secret/foo/bar): GET /v1/secret/foo/bar
2017-10-04 20:37:31.408682 I | [TRACE] kv.list(test-kv-list/prefix/): returned 3 pairs
2017-10-04 20:37:31.408812 I | [TRACE] kv.list(test-kv-list/not/a/real/prefix/like/ever): GET /v1/kv/test-kv-list/not/a/real/prefix/like/ever
2017-10-04 20:37:31.409089 I | [TRACE] vault.write(not/a/real/path/like/ever -> da39a3ee): PUT /v1/not/a/real/path/like/ever
2017-10-04 20:37:31.409202 I | [TRACE] kv.get(test-kv-get/key): returned "value"
2017-10-04 20:37:31.409265 I | [TRACE] kv.get(test-kv-get/key_empty): GET /v1/kv/test-kv-get/key_empty
2017-10-04 20:37:31.410232 I | [TRACE] kv.list(test-kv-list/not/a/real/prefix/like/ever): returned 0 pairs
2017-10-04 20:37:31.410343 I | [TRACE] kv.list(test-kv-list/prefix): GET /v1/kv/test-kv-list/prefix
2017-10-04 20:37:31.410586 I | [DEBUG] vault.token: renewed token
2017-10-04 20:37:31.410613 I | [TRACE] vault.token: GET /v1/auth/token/renew-self
2017-10-04 20:37:31.417821 I | [TRACE] vault.list(secret/foo/bar): no data
2017-10-04 20:37:31.417868 I | [TRACE] vault.list(secret/foo/bar): LIST /v1/secret/foo/bar
2017-10-04 20:37:31.418032 I | [TRACE] vault.read(secret/foo/bar): GET /v1/secret/foo/bar
2017-10-04 20:37:31.418163 I | [TRACE] kv.keys(test-kv-keys/prefix): GET /v1/kv/test-kv-keys/prefix
2017-10-04 20:37:31.418781 I | [TRACE] kv.list(test-kv-list/prefix): returned 3 pairs
2017-10-04 20:37:31.418810 I | [TRACE] kv.list(test-kv-list/prefix): GET /v1/kv/test-kv-list/prefix
2017-10-04 20:37:31.419253 I | [TRACE] vault.write(transit/encrypt/test -> de193cf9): PUT /v1/transit/encrypt/test
2017-10-04 20:37:31.419370 I | [TRACE] kv.get(test-kv-get/key_empty): returned ""
2017-10-04 20:37:31.419439 I | [TRACE] kv.get(test-kv-get/not/a/real/key/like/ever): GET /v1/kv/test-kv-get/not/a/real/key/like/ever
2017-10-04 20:37:31.420313 I | [TRACE] kv.list(test-kv-list/prefix): returned 3 pairs
2017-10-04 20:37:31.420404 I | [TRACE] kv.list(test-kv-list/prefix/): GET /v1/kv/test-kv-list/prefix/
2017-10-04 20:37:31.422035 I | [TRACE] kv.keys(test-kv-keys/prefix): returned 3 results
2017-10-04 20:37:31.422133 I | [TRACE] kv.keys(test-kv-keys/prefix/): GET /v1/kv/test-kv-keys/prefix/
2017-10-04 20:37:31.423849 I | [TRACE] kv.get(test-kv-get/not/a/real/key/like/ever): returned nil
2017-10-04 20:37:31.423953 I | [TRACE] kv.get(test-kv-get/key): GET /v1/kv/test-kv-get/key
2017-10-04 20:37:31.424177 I | [TRACE] kv.list(test-kv-list/prefix/): returned 3 pairs
2017-10-04 20:37:31.424388 I | [TRACE] kv.list(test-kv-list/prefix/): GET /v1/kv/test-kv-list/prefix/?index=13
2017-10-04 20:37:31.424580 I | [DEBUG] vault.token: renewed token
2017-10-04 20:37:31.424647 I | [TRACE] vault.token: GET /v1/auth/token/renew-self
2017-10-04 20:37:31.424813 I | [TRACE] vault.list(secret/foo/bar): no data
2017-10-04 20:37:31.424874 I | [TRACE] vault.list(secret): LIST /v1/secret
2017-10-04 20:37:31.425020 I | [TRACE] vault.read(secret/foo/bar): GET /v1/secret/foo/bar
2017-10-04 20:37:31.425106 I | [TRACE] kv.keys(test-kv-keys/prefix/): returned 3 results
2017-10-04 20:37:31.425184 I | [TRACE] kv.keys(test-kv-keys/not/a/real/prefix/like/ever): GET /v1/kv/test-kv-keys/not/a/real/prefix/like/ever
2017-10-04 20:37:31.425390 I | [TRACE] vault.write(transit/encrypt/test -> de193cf9): PUT /v1/transit/encrypt/test
2017-10-04 20:37:31.427772 I | [TRACE] kv.keys(test-kv-keys/not/a/real/prefix/like/ever): returned 0 results
2017-10-04 20:37:31.427878 I | [TRACE] kv.keys(test-kv-keys/prefix): GET /v1/kv/test-kv-keys/prefix
2017-10-04 20:37:31.428117 I | [TRACE] kv.get(test-kv-get/key): returned "value"
2017-10-04 20:37:31.428136 I | [TRACE] kv.get(test-kv-get/key): GET /v1/kv/test-kv-get/key
2017-10-04 20:37:31.428387 I | [DEBUG] vault.token: renewed token
2017-10-04 20:37:31.428428 I | [TRACE] vault.token: GET /v1/auth/token/renew-self?index=1507142251
2017-10-04 20:37:31.428442 I | [TRACE] vault.token: long polling for 1s
2017-10-04 20:37:31.428555 I | [TRACE] vault.list(secret): returned 1 results
2017-10-04 20:37:31.428584 I | [TRACE] vault.list(secret): long polling for 0s
2017-10-04 20:37:31.428803 I | [TRACE] vault.read(secret/foo/bar): GET /v1/secret/foo/bar?index=1507142251
2017-10-04 20:37:31.428976 I | [TRACE] vault.write(transit/encrypt/test -> de193cf9): PUT /v1/transit/encrypt/test
2017-10-04 20:37:31.429275 I | [TRACE] vault.list(secret): LIST /v1/secret?index=1507142251
2017-10-04 20:37:31.430673 I | [TRACE] kv.list(test-kv-list/prefix/): returned 3 pairs
2017-10-04 20:37:31.430911 I | [TRACE] kv.keys(test-kv-keys/prefix): returned 3 results
2017-10-04 20:37:31.430936 I | [TRACE] kv.keys(test-kv-keys/prefix): GET /v1/kv/test-kv-keys/prefix
2017-10-04 20:37:31.431338 I | [TRACE] vault.write(transit/encrypt/test -> de193cf9): PUT /v1/transit/encrypt/test?index=1507142251
2017-10-04 20:37:31.431478 I | [TRACE] vault.list(secret): returned 1 results
2017-10-04 20:37:31.431605 I | [TRACE] kv.get(test-kv-get/key): returned "value"
2017-10-04 20:37:31.431680 I | [TRACE] kv.get(test-kv-get/key): GET /v1/kv/test-kv-get/key
2017-10-04 20:37:31.433640 I | [TRACE] kv.keys(test-kv-keys/prefix): returned 3 results
2017-10-04 20:37:31.433767 I | [TRACE] kv.keys(test-kv-keys/prefix/): GET /v1/kv/test-kv-keys/prefix/
2017-10-04 20:37:31.433988 I | [TRACE] kv.get(test-kv-get/key): returned "value"
2017-10-04 20:37:31.434196 I | [TRACE] kv.get(test-kv-get/key): GET /v1/kv/test-kv-get/key?index=8
2017-10-04 20:37:31.434671 I | [TRACE] kv.keys(test-kv-keys/prefix/): returned 3 results
2017-10-04 20:37:31.434849 I | [TRACE] kv.keys(test-kv-keys/prefix/): GET /v1/kv/test-kv-keys/prefix/?index=14
2017-10-04 20:37:31.435079 I | [TRACE] catalog.datacenters: returned 1 results
2017-10-04 20:37:31.435102 I | [TRACE] catalog.datacenters: GET /v1/catalog/datacenters?index=10
2017-10-04 20:37:31.435115 I | [TRACE] catalog.datacenters: long polling for 50ms
2017-10-04 20:37:31.435180 I | [TRACE] catalog.datacenters: GET /v1/catalog/datacenters
2017-10-04 20:37:31.435655 I | [TRACE] kv.get(test-kv-get/key): returned "new-value"
2017-10-04 20:37:31.435803 I | [TRACE] catalog.datacenters: returned 1 results
2017-10-04 20:37:31.435850 I | [TRACE] catalog.datacenters: GET /v1/catalog/datacenters?index=1507142251
2017-10-04 20:37:31.435863 I | [TRACE] catalog.datacenters: long polling for 50ms
2017-10-04 20:37:31.436595 I | [TRACE] kv.keys(test-kv-keys/prefix/): returned 4 results
2017-10-04 20:37:31.486568 I | [TRACE] catalog.datacenters: returned 1 results
2017-10-04 20:37:32.429763 I | [DEBUG] vault.token: renewed token
FAIL
FAIL	github.com/hashicorp/consul-template/dependency	2.777s
ok  	github.com/hashicorp/consul-template/logging	0.047s
ok  	github.com/hashicorp/consul-template/manager	17.898s
ok  	github.com/hashicorp/consul-template/signals	0.017s
ok  	github.com/hashicorp/consul-template/template	0.068s
?   	github.com/hashicorp/consul-template/test	[no test files]
ok  	github.com/hashicorp/consul-template/watch	0.457s
make: *** [Makefile:168: test] Error 1
 * ERROR: app-admin/consul-template-0.18.5-r1::gentoo failed (test phase):
 *   emake failed
 * 
 * If you need support, post the output of `emerge --info '=app-admin/consul-template-0.18.5-r1::gentoo'`,
 * the complete build log and the output of `emerge -pqv '=app-admin/consul-template-0.18.5-r1::gentoo'`.
 * The complete build log is located at '/var/log/portage/app-admin:consul-template-0.18.5-r1:20171004-183619.log'.
 * For convenience, a symlink to the build log is located at '/var/tmp/portage/app-admin/consul-template-0.18.5-r1/temp/build.log'.
 * The ebuild environment file is located at '/var/tmp/portage/app-admin/consul-template-0.18.5-r1/temp/environment'.
 * Working directory: '/var/tmp/portage/app-admin/consul-template-0.18.5-r1/work/consul-template-0.18.5/src/github.com/hashicorp/consul-template'
 * S: '/var/tmp/portage/app-admin/consul-template-0.18.5-r1/work/consul-template-0.18.5'