Skip to content

Instantly share code, notes, and snippets.

@remilapeyre

remilapeyre/test.log

Created November 20, 2022 21:32
Show Gist options
  • Save remilapeyre/8b246d7956410e6404928d77b83bccdd to your computer and use it in GitHub Desktop.
Save remilapeyre/8b246d7956410e6404928d77b83bccdd to your computer and use it in GitHub Desktop.
Download ZIP
Raw
test.log
➜ terraform-provider-consul git:(master) ✗ TF_ACC_CONSUL_LOG=1 make testacc TESTARGS=-run=TestAccDataConsulPeerings_basic
==> Checking that code complies with gofmt requirements...
TF_ACC=1 go test $(go list ./... | grep -v 'vendor') -v -run=TestAccDataConsulPeerings_basic -timeout 2m
? github.com/hashicorp/terraform-provider-consul [no test files]
=== RUN TestAccDataConsulPeerings_basic
==> Starting Consul agent...
Version: '1.14.0'
Build Date: '2022-11-15 16:39:54 +0000 UTC'
Node ID: '44a4fd95-14f6-4f1d-8b17-f2b1ed90e09e'
Node name: 'primary'
Datacenter: 'dc1' (Segment: '<all>')
Server: true (Bootstrap: false)
Client Addr: [127.0.0.1] (HTTP: 8500, HTTPS: -1, gRPC: 8502, gRPC-TLS: -1, DNS: 8600)
Cluster Addr: 127.0.0.1 (LAN: 8301, WAN: 8302)
Gossip Encryption: false
Auto-Encrypt-TLS: false
HTTPS TLS: Verify Incoming: false, Verify Outgoing: false, Min Version: TLSv1_2
gRPC TLS: Verify Incoming: false, Min Version: TLSv1_2
Internal RPC TLS: Verify Incoming: false, Verify Outgoing: false (Verify Hostname: false), Min Version: TLSv1_2
==> Log data will now stream in as it occurs:
==> Starting Consul agent...
Version: '1.14.0'
Build Date: '2022-11-15 16:39:54 +0000 UTC'
Node ID: '64cbd46f-99b0-43fc-97fa-4ce61b3edaee'
Node name: 'secondary'
Datacenter: 'dc2' (Segment: '<all>')
Server: true (Bootstrap: false)
Client Addr: [127.0.0.1] (HTTP: 8501, HTTPS: -1, gRPC: 8508, gRPC-TLS: 8510, DNS: -1)
Cluster Addr: 127.0.0.1 (LAN: 8306, WAN: 8307)
Gossip Encryption: false
Auto-Encrypt-TLS: false
HTTPS TLS: Verify Incoming: false, Verify Outgoing: false, Min Version: TLSv1_2
gRPC TLS: Verify Incoming: false, Min Version: TLSv1_2
Internal RPC TLS: Verify Incoming: false, Verify Outgoing: false (Verify Hostname: false), Min Version: TLSv1_2
==> Log data will now stream in as it occurs:
2022-11-20T22:28:23.400+0100 [INFO] agent.server.raft: initial configuration: index=1 servers="[{Suffrage:Voter ID:44a4fd95-14f6-4f1d-8b17-f2b1ed90e09e Address:127.0.0.1:8300}]"
2022-11-20T22:28:23.400+0100 [INFO] agent.server.raft: initial configuration: index=1 servers="[{Suffrage:Voter ID:64cbd46f-99b0-43fc-97fa-4ce61b3edaee Address:127.0.0.1:8305}]"
2022-11-20T22:28:23.401+0100 [INFO] agent.server.raft: entering follower state: follower="Node at 127.0.0.1:8305 [Follower]" leader-address= leader-id=
2022-11-20T22:28:23.401+0100 [INFO] agent.server.raft: entering follower state: follower="Node at 127.0.0.1:8300 [Follower]" leader-address= leader-id=
2022-11-20T22:28:23.401+0100 [INFO] agent.server.serf.wan: serf: EventMemberJoin: primary.dc1 127.0.0.1
2022-11-20T22:28:23.401+0100 [INFO] agent.server.serf.wan: serf: EventMemberJoin: secondary.dc2 127.0.0.1
2022-11-20T22:28:23.402+0100 [INFO] agent.server.serf.lan: serf: EventMemberJoin: primary 127.0.0.1
2022-11-20T22:28:23.402+0100 [INFO] agent.server.serf.lan: serf: EventMemberJoin: secondary 127.0.0.1
2022-11-20T22:28:23.402+0100 [INFO] agent.router: Initializing LAN area manager
2022-11-20T22:28:23.402+0100 [INFO] agent.router: Initializing LAN area manager
2022-11-20T22:28:23.402+0100 [INFO] agent.server: Adding LAN server: server="primary (Addr: tcp/127.0.0.1:8300) (DC: dc1)"
2022-11-20T22:28:23.402+0100 [INFO] agent.server: Adding LAN server: server="secondary (Addr: tcp/127.0.0.1:8305) (DC: dc2)"
2022-11-20T22:28:23.402+0100 [INFO] agent.server.autopilot: reconciliation now disabled
2022-11-20T22:28:23.402+0100 [INFO] agent.server.autopilot: reconciliation now disabled
2022-11-20T22:28:23.403+0100 [INFO] agent.server: Handled event for server in area: event=member-join server=secondary.dc2 area=wan
2022-11-20T22:28:23.403+0100 [INFO] agent.server: Handled event for server in area: event=member-join server=primary.dc1 area=wan
2022-11-20T22:28:23.404+0100 [DEBUG] agent.server.autopilot: autopilot is now running
2022-11-20T22:28:23.404+0100 [DEBUG] agent.server.autopilot: autopilot is now running
2022-11-20T22:28:23.404+0100 [DEBUG] agent.server.autopilot: state update routine is now running
2022-11-20T22:28:23.404+0100 [DEBUG] agent.server.autopilot: state update routine is now running
2022-11-20T22:28:23.404+0100 [INFO] agent.server.cert-manager: initialized server certificate management
2022-11-20T22:28:23.404+0100 [INFO] agent.server.cert-manager: initialized server certificate management
2022-11-20T22:28:23.404+0100 [DEBUG] agent.hcp_manager: HCP manager starting
2022-11-20T22:28:23.404+0100 [DEBUG] agent.hcp_manager: HCP manager starting
2022-11-20T22:28:23.405+0100 [INFO] agent: Starting server: address=127.0.0.1:8501 network=tcp protocol=http
2022-11-20T22:28:23.405+0100 [INFO] agent: Started DNS server: address=127.0.0.1:8600 network=tcp
2022-11-20T22:28:23.405+0100 [INFO] agent: Started DNS server: address=127.0.0.1:8600 network=udp
2022-11-20T22:28:23.405+0100 [INFO] agent: Started gRPC listeners: port_name=grpc address=127.0.0.1:8508 network=tcp
2022-11-20T22:28:23.405+0100 [INFO] agent: Started gRPC listeners: port_name=grpc_tls address=127.0.0.1:8510 network=tcp
2022-11-20T22:28:23.405+0100 [INFO] agent: Starting server: address=127.0.0.1:8500 network=tcp protocol=http
2022-11-20T22:28:23.405+0100 [INFO] agent: started state syncer
2022-11-20T22:28:23.405+0100 [INFO] agent: Consul agent running!
2022-11-20T22:28:23.405+0100 [INFO] agent: Started gRPC listeners: port_name=grpc address=127.0.0.1:8502 network=tcp
2022-11-20T22:28:23.405+0100 [INFO] agent: started state syncer
2022-11-20T22:28:23.405+0100 [INFO] agent: Consul agent running!
2022-11-20T22:28:23.405+0100 [INFO] agent: Retry join is supported for the following discovery methods: cluster=WAN discovery_methods="aliyun aws azure digitalocean gce hcp k8s linode mdns os packet scaleway softlayer tencentcloud triton vsphere"
2022-11-20T22:28:23.405+0100 [INFO] agent: Joining cluster...: cluster=WAN
2022-11-20T22:28:23.405+0100 [INFO] agent: (WAN) joining: wan_addresses=["127.0.0.1:8307"]
2022-11-20T22:28:23.405+0100 [DEBUG] agent.server.memberlist.wan: memberlist: Initiating push/pull sync with: 127.0.0.1:8307
2022-11-20T22:28:23.405+0100 [DEBUG] agent.server.memberlist.wan: memberlist: Stream connection from=127.0.0.1:62001
2022-11-20T22:28:23.405+0100 [INFO] agent.server.serf.wan: serf: EventMemberJoin: primary.dc1 127.0.0.1
2022-11-20T22:28:23.405+0100 [INFO] agent.server: Handled event for server in area: event=member-join server=primary.dc1 area=wan
2022-11-20T22:28:23.405+0100 [INFO] agent.server.serf.wan: serf: EventMemberJoin: secondary.dc2 127.0.0.1
2022-11-20T22:28:23.405+0100 [INFO] agent: (WAN) joined: number_of_nodes=1
2022-11-20T22:28:23.405+0100 [INFO] agent: Join cluster completed. Synced with initial agents: cluster=WAN num_agents=1
2022-11-20T22:28:23.405+0100 [INFO] agent.server: Handled event for server in area: event=member-join server=secondary.dc2 area=wan
2022-11-20T22:28:23.459+0100 [WARN] agent.server.raft: heartbeat timeout reached, starting election: last-leader-addr= last-leader-id=
2022-11-20T22:28:23.459+0100 [INFO] agent.server.raft: entering candidate state: node="Node at 127.0.0.1:8305 [Candidate]" term=2
2022-11-20T22:28:23.459+0100 [DEBUG] agent.server.raft: voting for self: term=2 id=64cbd46f-99b0-43fc-97fa-4ce61b3edaee
2022-11-20T22:28:23.459+0100 [DEBUG] agent.server.raft: calculated votes needed: needed=1 term=2
2022-11-20T22:28:23.459+0100 [DEBUG] agent.server.raft: vote granted: from=64cbd46f-99b0-43fc-97fa-4ce61b3edaee term=2 tally=1
2022-11-20T22:28:23.459+0100 [INFO] agent.server.raft: election won: term=2 tally=1
2022-11-20T22:28:23.459+0100 [INFO] agent.server.raft: entering leader state: leader="Node at 127.0.0.1:8305 [Leader]"
2022-11-20T22:28:23.459+0100 [DEBUG] agent.hcp_manager: HCP triggering status update
2022-11-20T22:28:23.459+0100 [INFO] agent.server: cluster leadership acquired
2022-11-20T22:28:23.459+0100 [INFO] agent.server: New leader elected: payload=secondary
2022-11-20T22:28:23.459+0100 [INFO] agent.leader: started routine: routine="ACL policy replication"
2022-11-20T22:28:23.460+0100 [INFO] agent.leader: started routine: routine="ACL role replication"
2022-11-20T22:28:23.460+0100 [INFO] agent.server.replication.acl.role: started ACL Role replication
2022-11-20T22:28:23.460+0100 [INFO] agent.server.replication.acl.policy: started ACL Policy replication
2022-11-20T22:28:23.461+0100 [INFO] agent.server.autopilot: reconciliation now enabled
2022-11-20T22:28:23.461+0100 [INFO] agent.leader: started routine: routine="config entry replication"
2022-11-20T22:28:23.461+0100 [INFO] agent.leader: started routine: routine="federation state replication"
2022-11-20T22:28:23.461+0100 [INFO] agent.leader: started routine: routine="federation state anti-entropy"
2022-11-20T22:28:23.461+0100 [INFO] agent.leader: started routine: routine="streaming peering resources"
2022-11-20T22:28:23.461+0100 [INFO] agent.leader: started routine: routine="metrics for streaming peering resources"
2022-11-20T22:28:23.461+0100 [INFO] agent.leader: started routine: routine="peering deferred deletion"
2022-11-20T22:28:23.469+0100 [WARN] agent.server.raft: heartbeat timeout reached, starting election: last-leader-addr= last-leader-id=
2022-11-20T22:28:23.469+0100 [INFO] agent.server.raft: entering candidate state: node="Node at 127.0.0.1:8300 [Candidate]" term=2
2022-11-20T22:28:23.469+0100 [DEBUG] agent.server.raft: voting for self: term=2 id=44a4fd95-14f6-4f1d-8b17-f2b1ed90e09e
2022-11-20T22:28:23.469+0100 [DEBUG] agent.server.raft: calculated votes needed: needed=1 term=2
2022-11-20T22:28:23.469+0100 [DEBUG] agent.server.raft: vote granted: from=44a4fd95-14f6-4f1d-8b17-f2b1ed90e09e term=2 tally=1
2022-11-20T22:28:23.469+0100 [INFO] agent.server.raft: election won: term=2 tally=1
2022-11-20T22:28:23.469+0100 [INFO] agent.server.raft: entering leader state: leader="Node at 127.0.0.1:8300 [Leader]"
2022-11-20T22:28:23.469+0100 [DEBUG] agent.hcp_manager: HCP triggering status update
2022-11-20T22:28:23.469+0100 [INFO] agent.server: cluster leadership acquired
2022-11-20T22:28:23.469+0100 [INFO] agent.server: New leader elected: payload=primary
2022-11-20T22:28:23.469+0100 [INFO] agent.server: initializing acls
2022-11-20T22:28:23.469+0100 [INFO] agent.server: Created ACL 'global-management' policy
2022-11-20T22:28:23.469+0100 [WARN] agent.server: Configuring a non-UUID initial management token is deprecated
2022-11-20T22:28:23.469+0100 [INFO] agent.server: Bootstrapped ACL initial management token from configuration
2022-11-20T22:28:23.469+0100 [INFO] agent.server: Created ACL anonymous token from configuration
2022-11-20T22:28:23.469+0100 [INFO] agent.leader: started routine: routine="legacy ACL token upgrade"
2022-11-20T22:28:23.469+0100 [INFO] agent.leader: started routine: routine="acl token reaping"
2022-11-20T22:28:23.469+0100 [INFO] agent.leader: stopping routine: routine="legacy ACL token upgrade"
2022-11-20T22:28:23.469+0100 [INFO] agent.leader: stopped routine: routine="legacy ACL token upgrade"
2022-11-20T22:28:23.469+0100 [INFO] agent.server.autopilot: reconciliation now enabled
2022-11-20T22:28:23.469+0100 [INFO] agent.leader: started routine: routine="federation state anti-entropy"
2022-11-20T22:28:23.469+0100 [INFO] agent.leader: started routine: routine="federation state pruning"
2022-11-20T22:28:23.469+0100 [INFO] agent.leader: started routine: routine="streaming peering resources"
2022-11-20T22:28:23.469+0100 [INFO] agent.leader: started routine: routine="metrics for streaming peering resources"
2022-11-20T22:28:23.469+0100 [INFO] agent.leader: started routine: routine="peering deferred deletion"
2022-11-20T22:28:23.469+0100 [DEBUG] connect.ca.consul: consul CA provider configured: id=fb:50:9b:45:1a:65:15:c1:68:57:73:5f:da:cd:b8:0d:0f:e2:26:eb:68:66:43:11:85:9d:67:a9:7a:56:9c:b9 is_primary=true
2022-11-20T22:28:23.471+0100 [INFO] connect.ca: updated root certificates from primary datacenter
2022-11-20T22:28:23.471+0100 [INFO] connect.ca: initialized primary datacenter CA with provider: provider=consul
2022-11-20T22:28:23.471+0100 [INFO] agent.leader: started routine: routine="intermediate cert renew watch"
2022-11-20T22:28:23.471+0100 [INFO] agent.leader: started routine: routine="CA root pruning"
2022-11-20T22:28:23.471+0100 [INFO] agent.leader: started routine: routine="CA root expiration metric"
2022-11-20T22:28:23.471+0100 [INFO] agent.leader: started routine: routine="CA signing expiration metric"
2022-11-20T22:28:23.471+0100 [INFO] agent.leader: started routine: routine="virtual IP version check"
2022-11-20T22:28:23.471+0100 [DEBUG] agent.server: successfully established leadership: duration=2.352583ms
2022-11-20T22:28:23.471+0100 [INFO] agent.server: member joined, marking health alive: member=primary partition=default
2022-11-20T22:28:23.471+0100 [INFO] agent.leader: stopping routine: routine="virtual IP version check"
2022-11-20T22:28:23.471+0100 [INFO] agent.leader: stopped routine: routine="virtual IP version check"
2022-11-20T22:28:23.472+0100 [DEBUG] agent.server.xds_capacity_controller: updating drain rate limit: rate_limit=1
2022-11-20T22:28:23.501+0100 [DEBUG] agent.server.serf.wan: serf: messageJoinType: primary.dc1
2022-11-20T22:28:23.502+0100 [DEBUG] agent.server.serf.wan: serf: messageJoinType: primary.dc1
2022-11-20T22:28:23.502+0100 [DEBUG] agent.server.serf.wan: serf: messageJoinType: primary.dc1
2022-11-20T22:28:23.525+0100 [DEBUG] agent: Skipping remote check since it is managed automatically: check=serfHealth
2022-11-20T22:28:23.526+0100 [INFO] agent: Synced node info
2022-11-20T22:28:23.526+0100 [DEBUG] agent: Node info in sync
2022-11-20T22:28:23.544+0100 [DEBUG] agent.server.replication.federation_state: finished fetching remote objects: amount=0
2022-11-20T22:28:23.544+0100 [DEBUG] agent.server.replication.federation_state: diffing replication state: local_amount=0 remote_amount=0
2022-11-20T22:28:23.544+0100 [DEBUG] agent.server.replication.federation_state: diffed replication state: deletions=0 updates=0
2022-11-20T22:28:23.544+0100 [DEBUG] agent.server.replication.federation_state: replication completed through remote index: index=1
2022-11-20T22:28:23.586+0100 [DEBUG] agent.server.replication.acl.policy: finished fetching acls: amount=1
2022-11-20T22:28:23.586+0100 [DEBUG] agent.server.replication.acl.policy: acl replication: local=0 remote=1
2022-11-20T22:28:23.586+0100 [DEBUG] agent.server.replication.acl.policy: acl replication: deletions=0 updates=1
2022-11-20T22:28:23.586+0100 [DEBUG] agent.server.replication.acl.policy: acl replication - downloaded updates: amount=1
2022-11-20T22:28:23.586+0100 [DEBUG] agent.server.replication.acl.policy: acl replication - performing updates
2022-11-20T22:28:23.586+0100 [DEBUG] agent.server.replication.acl.policy: acl replication - upserted batch: number_upserted=1 batch_size=497
2022-11-20T22:28:23.586+0100 [DEBUG] agent.server.replication.acl.policy: acl replication - finished updates
2022-11-20T22:28:23.586+0100 [DEBUG] agent.server.replication.acl.policy: ACL replication completed through remote index: index=4
2022-11-20T22:28:23.595+0100 [INFO] agent.server: federation state anti-entropy synced
2022-11-20T22:28:23.595+0100 [DEBUG] agent.server.replication.federation_state: finished fetching remote objects: amount=1
2022-11-20T22:28:23.595+0100 [DEBUG] agent.server.replication.federation_state: diffing replication state: local_amount=0 remote_amount=1
2022-11-20T22:28:23.595+0100 [DEBUG] agent.server.replication.federation_state: diffed replication state: deletions=0 updates=1
2022-11-20T22:28:23.595+0100 [DEBUG] agent.server.replication.federation_state: performing updates: updates=1
2022-11-20T22:28:23.595+0100 [DEBUG] agent.server.replication.federation_state: finished updates
2022-11-20T22:28:23.595+0100 [DEBUG] agent.server.replication.federation_state: replication completed through remote index: index=19
2022-11-20T22:28:23.602+0100 [DEBUG] agent.server.serf.wan: serf: messageJoinType: primary.dc1
2022-11-20T22:28:23.613+0100 [DEBUG] connect.ca.consul: consul CA provider configured: id=ca:49:15:76:89:95:8d:cd:ed:16:56:8a:4b:60:1b:db:e6:84:d0:47:ee:7c:c5:10:99:78:8e:08:f9:55:1c:ca is_primary=false
2022-11-20T22:28:23.615+0100 [INFO] connect.ca: received new intermediate certificate from primary datacenter
2022-11-20T22:28:23.615+0100 [INFO] connect.ca: updated root certificates from primary datacenter
2022-11-20T22:28:23.615+0100 [INFO] connect.ca: initialized secondary datacenter CA with provider: provider=consul
2022-11-20T22:28:23.615+0100 [INFO] agent.leader: started routine: routine="secondary CA roots watch"
2022-11-20T22:28:23.615+0100 [INFO] agent.leader: started routine: routine="intermediate cert renew watch"
2022-11-20T22:28:23.615+0100 [DEBUG] connect.ca: starting Connect CA root replication from primary datacenter: primary=dc1
2022-11-20T22:28:23.615+0100 [INFO] agent.leader: started routine: routine="CA root pruning"
2022-11-20T22:28:23.615+0100 [INFO] agent.leader: started routine: routine="CA root expiration metric"
2022-11-20T22:28:23.615+0100 [INFO] agent.leader: started routine: routine="CA signing expiration metric"
2022-11-20T22:28:23.615+0100 [INFO] agent.leader: started routine: routine="virtual IP version check"
2022-11-20T22:28:23.615+0100 [INFO] agent.leader: started routine: routine="intention config entry migration"
2022-11-20T22:28:23.615+0100 [DEBUG] agent.server: successfully established leadership: duration=156.316917ms
2022-11-20T22:28:23.615+0100 [INFO] agent.server: member joined, marking health alive: member=secondary partition=default
2022-11-20T22:28:23.616+0100 [DEBUG] agent.server.connect: intention migration in secondary status: last_primary_index=14
2022-11-20T22:28:23.616+0100 [DEBUG] agent.server.connect: intention migration in secondary status: last_primary_intention_index=14 last_primary_replicated_config_index=0
2022-11-20T22:28:23.616+0100 [DEBUG] agent.server.connect: intention migration in secondary status: last_primary_intention_index=14 last_primary_replicated_config_index=0
2022-11-20T22:28:23.616+0100 [DEBUG] agent.server.connect: intention migration in secondary status: last_primary_intention_index=14 last_primary_replicated_config_index=0
2022-11-20T22:28:23.616+0100 [DEBUG] agent.server.connect: intention migration in secondary status: last_primary_intention_index=14 last_primary_replicated_config_index=0
2022-11-20T22:28:23.616+0100 [DEBUG] agent.server.connect: intention migration in secondary status: last_primary_intention_index=14 last_primary_replicated_config_index=0
2022-11-20T22:28:23.616+0100 [INFO] agent.leader: stopping routine: routine="virtual IP version check"
2022-11-20T22:28:23.616+0100 [INFO] agent.leader: stopped routine: routine="virtual IP version check"
2022-11-20T22:28:23.616+0100 [DEBUG] agent.server.xds_capacity_controller: updating drain rate limit: rate_limit=1
2022-11-20T22:28:23.702+0100 [DEBUG] agent.server.serf.wan: serf: messageJoinType: primary.dc1
2022-11-20T22:28:23.702+0100 [DEBUG] agent.server.serf.wan: serf: messageJoinType: primary.dc1
2022-11-20T22:28:23.702+0100 [DEBUG] agent.server.serf.wan: serf: messageJoinType: primary.dc1
2022-11-20T22:28:23.704+0100 [DEBUG] agent.server.replication.config_entry: finished fetching config entries: amount=0
2022-11-20T22:28:23.704+0100 [DEBUG] agent.server.replication.config_entry: Config Entry replication: local=0 remote=0
2022-11-20T22:28:23.704+0100 [DEBUG] agent.server.replication.config_entry: Config Entry replication: deletions=0 updates=0
2022-11-20T22:28:23.704+0100 [DEBUG] agent.server.replication.config_entry: replication completed through remote index: index=14
2022-11-20T22:28:23.757+0100 [INFO] agent.server: federation state anti-entropy synced
2022-11-20T22:28:23.757+0100 [DEBUG] agent.server.replication.federation_state: finished fetching remote objects: amount=2
2022-11-20T22:28:23.757+0100 [DEBUG] agent.server.replication.federation_state: diffing replication state: local_amount=1 remote_amount=2
2022-11-20T22:28:23.757+0100 [DEBUG] agent.server.replication.federation_state: diffed replication state: deletions=0 updates=1
2022-11-20T22:28:23.757+0100 [DEBUG] agent.server.replication.federation_state: performing updates: updates=1
2022-11-20T22:28:23.757+0100 [DEBUG] agent.server.replication.federation_state: finished updates
2022-11-20T22:28:23.757+0100 [DEBUG] agent.server.replication.federation_state: replication completed through remote index: index=21
2022-11-20T22:28:23.769+0100 [DEBUG] agent.server: server management token has not been initialized
2022-11-20T22:28:23.771+0100 [DEBUG] agent.server: server management token has not been initialized
2022-11-20T22:28:23.771+0100 [DEBUG] agent.server: server management token has not been initialized
2022-11-20T22:28:23.771+0100 [DEBUG] agent.server: server management token has not been initialized
2022-11-20T22:28:23.771+0100 [DEBUG] agent: Skipping remote check since it is managed automatically: check=serfHealth
2022-11-20T22:28:23.771+0100 [DEBUG] agent.server: server management token has not been initialized
2022-11-20T22:28:23.772+0100 [INFO] agent: Synced node info
2022-11-20T22:28:23.803+0100 [DEBUG] agent.server.serf.wan: serf: messageJoinType: primary.dc1
2022-11-20T22:28:23.830+0100 [DEBUG] agent.server.replication.acl.role: finished fetching acls: amount=0
2022-11-20T22:28:23.830+0100 [DEBUG] agent.server.replication.acl.role: acl replication: local=0 remote=0
2022-11-20T22:28:23.830+0100 [DEBUG] agent.server.replication.acl.role: acl replication: deletions=0 updates=0
2022-11-20T22:28:23.830+0100 [DEBUG] agent.server.replication.acl.role: ACL replication completed through remote index: index=1
2022-11-20T22:28:23.851+0100 [DEBUG] agent.http: Request finished: method=GET url=/v1/health/service/consul?passing=1 from=127.0.0.1:62003 latency=416.3595ms
2022-11-20T22:28:23.856+0100 [DEBUG] agent.server: server management token has not been initialized
2022-11-20T22:28:23.858+0100 [DEBUG] agent.server: server management token has not been initialized
2022-11-20T22:28:23.860+0100 [DEBUG] agent.http: Request finished: method=GET url=/v1/health/service/consul?passing=1 from=127.0.0.1:62006 latency=3.803ms
2022-11-20T22:28:23.863+0100 [DEBUG] agent.http: Request finished: method=GET url=/v1/catalog/datacenters from=127.0.0.1:62003 latency="147.833µs"
2022-11-20T22:28:23.891+0100 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/self from=127.0.0.1:62008 latency=1.245041ms
2022-11-20T22:28:23.894+0100 [DEBUG] agent.http: Request finished: method=GET url=/v1/peerings?dc=dc1 from=127.0.0.1:62008 latency=1.191ms
2022-11-20T22:28:23.909+0100 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/self from=127.0.0.1:62010 latency="443µs"
2022-11-20T22:28:23.910+0100 [DEBUG] agent.http: Request finished: method=GET url=/v1/peerings?dc=dc1 from=127.0.0.1:62010 latency="225.917µs"
2022-11-20T22:28:23.938+0100 [DEBUG] agent.server: server management token has not been initialized
2022-11-20T22:28:23.938+0100 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/self from=127.0.0.1:62012 latency="480.042µs"
2022-11-20T22:28:23.940+0100 [DEBUG] agent.server: server management token has not been initialized
2022-11-20T22:28:23.940+0100 [DEBUG] agent.http: Request finished: method=POST url=/v1/peering/token?dc=dc2 from=127.0.0.1:62012 latency=1.303583ms
2022-11-20T22:28:23.942+0100 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/self from=127.0.0.1:62014 latency="400.625µs"
2022-11-20T22:28:23.945+0100 [WARN] agent: [core][Channel #9 SubChannel #10] grpc: addrConn.createTransport failed to connect to {
"Addr": "127.0.0.1:8510",
"ServerName": "server.dc2.peering.b87a33c8-fb2a-f455-a4d7-51730fd92dd9.consul",
"Attributes": null,
"BalancerAttributes": null,
"Type": 0,
"Metadata": null
}. Err: connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
2022-11-20T22:28:24.116+0100 [WARN] agent: [core][Channel #11 SubChannel #12] grpc: addrConn.createTransport failed to connect to {
"Addr": "127.0.0.1:8510",
"ServerName": "server.dc2.peering.b87a33c8-fb2a-f455-a4d7-51730fd92dd9.consul",
"Attributes": null,
"BalancerAttributes": null,
"Type": 0,
"Metadata": null
}. Err: connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
2022-11-20T22:28:24.300+0100 [WARN] agent: [core][Channel #13 SubChannel #14] grpc: addrConn.createTransport failed to connect to {
"Addr": "127.0.0.1:8510",
"ServerName": "server.dc2.peering.b87a33c8-fb2a-f455-a4d7-51730fd92dd9.consul",
"Attributes": null,
"BalancerAttributes": null,
"Type": 0,
"Metadata": null
}. Err: connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
2022-11-20T22:28:24.404+0100 [DEBUG] agent.server.cert-manager: CA config watch fired - updating auto TLS server name: name=server.dc2.peering.b87a33c8-fb2a-f455-a4d7-51730fd92dd9.consul
2022-11-20T22:28:24.404+0100 [DEBUG] agent.server.cert-manager: ACLs have not finished initializing
2022-11-20T22:28:24.404+0100 [DEBUG] agent.server.cert-manager: CA config watch fired - updating auto TLS server name: name=server.dc1.peering.b87a33c8-fb2a-f455-a4d7-51730fd92dd9.consul
2022-11-20T22:28:24.404+0100 [DEBUG] agent.server.cert-manager: server management token watch fired - resetting leaf cert watch
2022-11-20T22:28:24.407+0100 [DEBUG] agent.server.cert-manager: got cache update event: correlationID=leaf error=<nil>
2022-11-20T22:28:24.407+0100 [DEBUG] agent.server.cert-manager: leaf certificate watch fired - updating auto TLS certificate: uri=spiffe://b87a33c8-fb2a-f455-a4d7-51730fd92dd9.consul/agent/server/dc/dc1
2022-11-20T22:28:24.479+0100 [WARN] agent: [core][Channel #15 SubChannel #16] grpc: addrConn.createTransport failed to connect to {
"Addr": "127.0.0.1:8510",
"ServerName": "server.dc2.peering.b87a33c8-fb2a-f455-a4d7-51730fd92dd9.consul",
"Attributes": null,
"BalancerAttributes": null,
"Type": 0,
"Metadata": null
}. Err: connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
2022-11-20T22:28:24.660+0100 [WARN] agent: [core][Channel #17 SubChannel #18] grpc: addrConn.createTransport failed to connect to {
"Addr": "127.0.0.1:8510",
"ServerName": "server.dc2.peering.b87a33c8-fb2a-f455-a4d7-51730fd92dd9.consul",
"Attributes": null,
"BalancerAttributes": null,
"Type": 0,
"Metadata": null
}. Err: connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
2022-11-20T22:28:24.828+0100 [WARN] agent: [core][Channel #19 SubChannel #20] grpc: addrConn.createTransport failed to connect to {
"Addr": "127.0.0.1:8510",
"ServerName": "server.dc2.peering.b87a33c8-fb2a-f455-a4d7-51730fd92dd9.consul",
"Attributes": null,
"BalancerAttributes": null,
"Type": 0,
"Metadata": null
}. Err: connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
2022-11-20T22:28:24.990+0100 [WARN] agent: [core][Channel #21 SubChannel #22] grpc: addrConn.createTransport failed to connect to {
"Addr": "127.0.0.1:8510",
"ServerName": "server.dc2.peering.b87a33c8-fb2a-f455-a4d7-51730fd92dd9.consul",
"Attributes": null,
"BalancerAttributes": null,
"Type": 0,
"Metadata": null
}. Err: connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
2022-11-20T22:28:25.170+0100 [WARN] agent: [core][Channel #23 SubChannel #24] grpc: addrConn.createTransport failed to connect to {
"Addr": "127.0.0.1:8510",
"ServerName": "server.dc2.peering.b87a33c8-fb2a-f455-a4d7-51730fd92dd9.consul",
"Attributes": null,
"BalancerAttributes": null,
"Type": 0,
"Metadata": null
}. Err: connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
2022-11-20T22:28:25.336+0100 [WARN] agent: [core][Channel #25 SubChannel #26] grpc: addrConn.createTransport failed to connect to {
"Addr": "127.0.0.1:8510",
"ServerName": "server.dc2.peering.b87a33c8-fb2a-f455-a4d7-51730fd92dd9.consul",
"Attributes": null,
"BalancerAttributes": null,
"Type": 0,
"Metadata": null
}. Err: connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
2022-11-20T22:28:25.404+0100 [DEBUG] agent.server.cert-manager: ACLs have not finished initializing
2022-11-20T22:28:25.498+0100 [WARN] agent: [core][Channel #27 SubChannel #28] grpc: addrConn.createTransport failed to connect to {
"Addr": "127.0.0.1:8510",
"ServerName": "server.dc2.peering.b87a33c8-fb2a-f455-a4d7-51730fd92dd9.consul",
"Attributes": null,
"BalancerAttributes": null,
"Type": 0,
"Metadata": null
}. Err: connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
2022-11-20T22:28:25.683+0100 [WARN] agent: [core][Channel #29 SubChannel #30] grpc: addrConn.createTransport failed to connect to {
"Addr": "127.0.0.1:8510",
"ServerName": "server.dc2.peering.b87a33c8-fb2a-f455-a4d7-51730fd92dd9.consul",
"Attributes": null,
"BalancerAttributes": null,
"Type": 0,
"Metadata": null
}. Err: connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
2022-11-20T22:28:25.834+0100 [DEBUG] agent: Skipping remote check since it is managed automatically: check=serfHealth
2022-11-20T22:28:25.834+0100 [DEBUG] agent: Node info in sync
2022-11-20T22:28:25.842+0100 [WARN] agent: [core][Channel #31 SubChannel #32] grpc: addrConn.createTransport failed to connect to {
"Addr": "127.0.0.1:8510",
"ServerName": "server.dc2.peering.b87a33c8-fb2a-f455-a4d7-51730fd92dd9.consul",
"Attributes": null,
"BalancerAttributes": null,
"Type": 0,
"Metadata": null
}. Err: connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
2022-11-20T22:28:25.999+0100 [WARN] agent: [core][Channel #33 SubChannel #34] grpc: addrConn.createTransport failed to connect to {
"Addr": "127.0.0.1:8510",
"ServerName": "server.dc2.peering.b87a33c8-fb2a-f455-a4d7-51730fd92dd9.consul",
"Attributes": null,
"BalancerAttributes": null,
"Type": 0,
"Metadata": null
}. Err: connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
2022-11-20T22:28:26.186+0100 [WARN] agent: [core][Channel #35 SubChannel #36] grpc: addrConn.createTransport failed to connect to {
"Addr": "127.0.0.1:8510",
"ServerName": "server.dc2.peering.b87a33c8-fb2a-f455-a4d7-51730fd92dd9.consul",
"Attributes": null,
"BalancerAttributes": null,
"Type": 0,
"Metadata": null
}. Err: connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
2022-11-20T22:28:26.359+0100 [WARN] agent: [core][Channel #37 SubChannel #38] grpc: addrConn.createTransport failed to connect to {
"Addr": "127.0.0.1:8510",
"ServerName": "server.dc2.peering.b87a33c8-fb2a-f455-a4d7-51730fd92dd9.consul",
"Attributes": null,
"BalancerAttributes": null,
"Type": 0,
"Metadata": null
}. Err: connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
2022-11-20T22:28:26.404+0100 [DEBUG] agent.server.cert-manager: ACLs have not finished initializing
2022-11-20T22:28:26.518+0100 [WARN] agent: [core][Channel #39 SubChannel #40] grpc: addrConn.createTransport failed to connect to {
"Addr": "127.0.0.1:8510",
"ServerName": "server.dc2.peering.b87a33c8-fb2a-f455-a4d7-51730fd92dd9.consul",
"Attributes": null,
"BalancerAttributes": null,
"Type": 0,
"Metadata": null
}. Err: connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
2022-11-20T22:28:26.538+0100 [DEBUG] agent.server: server management token has not been initialized
2022-11-20T22:28:26.538+0100 [DEBUG] agent.server: server management token has not been initialized
2022-11-20T22:28:26.538+0100 [DEBUG] agent.server: server management token has not been initialized
2022-11-20T22:28:26.539+0100 [DEBUG] agent.server: server management token has not been initialized
2022-11-20T22:28:26.539+0100 [DEBUG] agent: Skipping remote check since it is managed automatically: check=serfHealth
2022-11-20T22:28:26.539+0100 [DEBUG] agent: Node info in sync
2022-11-20T22:28:26.539+0100 [DEBUG] agent: Node info in sync
2022-11-20T22:28:26.687+0100 [WARN] agent: [core][Channel #41 SubChannel #42] grpc: addrConn.createTransport failed to connect to {
"Addr": "127.0.0.1:8510",
"ServerName": "server.dc2.peering.b87a33c8-fb2a-f455-a4d7-51730fd92dd9.consul",
"Attributes": null,
"BalancerAttributes": null,
"Type": 0,
"Metadata": null
}. Err: connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
2022-11-20T22:28:26.852+0100 [WARN] agent: [core][Channel #43 SubChannel #44] grpc: addrConn.createTransport failed to connect to {
"Addr": "127.0.0.1:8510",
"ServerName": "server.dc2.peering.b87a33c8-fb2a-f455-a4d7-51730fd92dd9.consul",
"Attributes": null,
"BalancerAttributes": null,
"Type": 0,
"Metadata": null
}. Err: connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
2022-11-20T22:28:27.038+0100 [ERROR] agent.http: Request error: method=POST url=/v1/peering/establish?dc=dc1 from=127.0.0.1:62014
error=
| rpc error: code = Unknown desc = 18 errors occurred:
| * failed to exchange peering secret through address "127.0.0.1:8510": rpc error: code = Unavailable desc = connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
| * failed to exchange peering secret through address "127.0.0.1:8510": rpc error: code = Unavailable desc = connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
| * failed to exchange peering secret through address "127.0.0.1:8510": rpc error: code = Unavailable desc = connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
| * failed to exchange peering secret through address "127.0.0.1:8510": rpc error: code = Unavailable desc = connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
| * failed to exchange peering secret through address "127.0.0.1:8510": rpc error: code = Unavailable desc = connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
| * failed to exchange peering secret through address "127.0.0.1:8510": rpc error: code = Unavailable desc = connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
| * failed to exchange peering secret through address "127.0.0.1:8510": rpc error: code = Unavailable desc = connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
| * failed to exchange peering secret through address "127.0.0.1:8510": rpc error: code = Unavailable desc = connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
| * failed to exchange peering secret through address "127.0.0.1:8510": rpc error: code = Unavailable desc = connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
| * failed to exchange peering secret through address "127.0.0.1:8510": rpc error: code = Unavailable desc = connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
| * failed to exchange peering secret through address "127.0.0.1:8510": rpc error: code = Unavailable desc = connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
| * failed to exchange peering secret through address "127.0.0.1:8510": rpc error: code = Unavailable desc = connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
| * failed to exchange peering secret through address "127.0.0.1:8510": rpc error: code = Unavailable desc = connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
| * failed to exchange peering secret through address "127.0.0.1:8510": rpc error: code = Unavailable desc = connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
| * failed to exchange peering secret through address "127.0.0.1:8510": rpc error: code = Unavailable desc = connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
| * failed to exchange peering secret through address "127.0.0.1:8510": rpc error: code = Unavailable desc = connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
| * failed to exchange peering secret through address "127.0.0.1:8510": rpc error: code = Unavailable desc = connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
| * failed to exchange peering secret through address "127.0.0.1:8510": rpc error: code = Unavailable desc = connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
|
2022-11-20T22:28:27.039+0100 [DEBUG] agent.http: Request finished: method=POST url=/v1/peering/establish?dc=dc1 from=127.0.0.1:62014 latency=3.095552209s
testing.go:705: Step 1 error: errors during apply:
Error: failed to create peering: Unexpected response code: 500 (rpc error: code = Unknown desc = 18 errors occurred:
* failed to exchange peering secret through address "127.0.0.1:8510": rpc error: code = Unavailable desc = connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
* failed to exchange peering secret through address "127.0.0.1:8510": rpc error: code = Unavailable desc = connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
* failed to exchange peering secret through address "127.0.0.1:8510": rpc error: code = Unavailable desc = connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
* failed to exchange peering secret through address "127.0.0.1:8510": rpc error: code = Unavailable desc = connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
* failed to exchange peering secret through address "127.0.0.1:8510": rpc error: code = Unavailable desc = connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
* failed to exchange peering secret through address "127.0.0.1:8510": rpc error: code = Unavailable desc = connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
* failed to exchange peering secret through address "127.0.0.1:8510": rpc error: code = Unavailable desc = connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
* failed to exchange peering secret through address "127.0.0.1:8510": rpc error: code = Unavailable desc = connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
* failed to exchange peering secret through address "127.0.0.1:8510": rpc error: code = Unavailable desc = connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
* failed to exchange peering secret through address "127.0.0.1:8510": rpc error: code = Unavailable desc = connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
* failed to exchange peering secret through address "127.0.0.1:8510": rpc error: code = Unavailable desc = connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
* failed to exchange peering secret through address "127.0.0.1:8510": rpc error: code = Unavailable desc = connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
* failed to exchange peering secret through address "127.0.0.1:8510": rpc error: code = Unavailable desc = connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
* failed to exchange peering secret through address "127.0.0.1:8510": rpc error: code = Unavailable desc = connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
* failed to exchange peering secret through address "127.0.0.1:8510": rpc error: code = Unavailable desc = connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
* failed to exchange peering secret through address "127.0.0.1:8510": rpc error: code = Unavailable desc = connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
* failed to exchange peering secret through address "127.0.0.1:8510": rpc error: code = Unavailable desc = connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name"
* failed to exchange peering secret through address "127.0.0.1:8510": rpc error: code = Unavailable desc = connection error: desc = "transport: authentication handshake failed: remote error: tls: unrecognized name")
on /var/folders/6m/22_tqdgs4cz1zb957s51tcyh0000gp/T/tf-test538023211/main.tf line 13:
(source code not available)
2022-11-20T22:28:27.073+0100 [DEBUG] agent.server: server management token has not been initialized
2022-11-20T22:28:27.074+0100 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/self from=127.0.0.1:62034 latency="691.709µs"
2022-11-20T22:28:27.075+0100 [DEBUG] agent.server: server management token has not been initialized
2022-11-20T22:28:27.075+0100 [WARN] agent.grpc-api.peering: did not find peer in stream tracker; cannot populate imported and exported services count or reconcile peering state: peerID=06878708-461a-7a70-3401-7bd9a3077318
2022-11-20T22:28:27.075+0100 [DEBUG] agent.http: Request finished: method=GET url=/v1/peering/hello-world?dc=dc2 from=127.0.0.1:62034 latency="439.667µs"
2022-11-20T22:28:27.086+0100 [DEBUG] agent.server: server management token has not been initialized
2022-11-20T22:28:27.086+0100 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/self from=127.0.0.1:62036 latency="558.334µs"
2022-11-20T22:28:27.088+0100 [DEBUG] agent.server: server management token has not been initialized
2022-11-20T22:28:27.088+0100 [DEBUG] agent.http: Request finished: method=DELETE url=/v1/peering/hello-world?dc=dc2 from=127.0.0.1:62036 latency="375.792µs"
--- FAIL: TestAccDataConsulPeerings_basic (3.87s)
FAIL
FAIL github.com/hashicorp/terraform-provider-consul/consul 4.153s
FAIL
make: *** [testacc] Error 1
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment