Skip to content

Instantly share code, notes, and snippets.

@saez0pub
Created September 11, 2020 08:03
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save saez0pub/b685e80830f269a8697f6f968923f928 to your computer and use it in GitHub Desktop.
Save saez0pub/b685e80830f269a8697f6f968923f928 to your computer and use it in GitHub Desktop.
==> Starting Consul agent...
Version: '1.8.3'
Node ID: '506cf337-31df-4815-01b0-90606fc638f6'
Node name: 'actarus'
Datacenter: 'dc1' (Segment: '<all>')
Server: true (Bootstrap: false)
Client Addr: [127.0.0.1] (HTTP: 8500, HTTPS: -1, gRPC: 8502, DNS: 8600)
Cluster Addr: 127.0.0.1 (LAN: 8301, WAN: 8302)
Encrypt: Gossip: false, TLS-Outgoing: false, TLS-Incoming: false, Auto-Encrypt-TLS: false
==> Log data will now stream in as it occurs:
2020-09-11T09:58:50.865+0200 [TRACE] agent.tlsutil: Update: version=1
2020-09-11T09:58:50.866+0200 [DEBUG] agent: Using random ID as node ID: id=506cf337-31df-4815-01b0-90606fc638f6
2020-09-11T09:58:50.871+0200 [TRACE] agent.tlsutil: Update: version=2
2020-09-11T09:58:50.871+0200 [TRACE] agent.tlsutil: OutgoingRPCWrapper: version=2
2020-09-11T09:58:50.872+0200 [INFO] agent.server.raft: initial configuration: index=1 servers="[{Suffrage:Voter ID:506cf337-31df-4815-01b0-90606fc638f6 Address:127.0.0.1:8300}]"
2020-09-11T09:58:50.872+0200 [INFO] agent.server.raft: entering follower state: follower="Node at 127.0.0.1:8300 [Follower]" leader=
2020-09-11T09:58:50.872+0200 [INFO] agent.server.serf.wan: serf: EventMemberJoin: actarus.dc1 127.0.0.1
2020-09-11T09:58:50.873+0200 [INFO] agent.server.serf.lan: serf: EventMemberJoin: actarus 127.0.0.1
2020-09-11T09:58:50.873+0200 [INFO] agent.server: Adding LAN server: server="actarus (Addr: tcp/127.0.0.1:8300) (DC: dc1)"
2020-09-11T09:58:50.873+0200 [INFO] agent.server: Handled event for server in area: event=member-join server=actarus.dc1 area=wan
2020-09-11T09:58:50.873+0200 [INFO] agent: Started DNS server: address=127.0.0.1:8600 network=tcp
2020-09-11T09:58:50.873+0200 [INFO] agent: Started DNS server: address=127.0.0.1:8600 network=udp
2020-09-11T09:58:50.873+0200 [INFO] agent: Started HTTP server: address=127.0.0.1:8500 network=tcp
2020-09-11T09:58:50.873+0200 [INFO] agent: started state syncer
==> Consul agent running!
2020-09-11T09:58:50.873+0200 [INFO] agent: Started gRPC server: address=127.0.0.1:8502 network=tcp
2020-09-11T09:58:50.930+0200 [WARN] agent.server.raft: heartbeat timeout reached, starting election: last-leader=
2020-09-11T09:58:50.930+0200 [INFO] agent.server.raft: entering candidate state: node="Node at 127.0.0.1:8300 [Candidate]" term=2
2020-09-11T09:58:50.930+0200 [DEBUG] agent.server.raft: votes: needed=1
2020-09-11T09:58:50.930+0200 [DEBUG] agent.server.raft: vote granted: from=506cf337-31df-4815-01b0-90606fc638f6 term=2 tally=1
2020-09-11T09:58:50.930+0200 [INFO] agent.server.raft: election won: tally=1
2020-09-11T09:58:50.930+0200 [INFO] agent.server.raft: entering leader state: leader="Node at 127.0.0.1:8300 [Leader]"
2020-09-11T09:58:50.930+0200 [INFO] agent.server: cluster leadership acquired
2020-09-11T09:58:50.930+0200 [DEBUG] agent.server: Cannot upgrade to new ACLs: leaderMode=0 mode=0 found=true leader=127.0.0.1:8300
2020-09-11T09:58:50.930+0200 [INFO] agent.server: New leader elected: payload=actarus
2020-09-11T09:58:50.932+0200 [DEBUG] connect.ca.consul: consul CA provider configured: id=07:80:c8:de:f6:41:86:29:8f:9c:b8:17:d6:48:c2:d5:c5:5c:7f:0c:03:f7:cf:97:5a:a7:c1:68:aa:23:ae:81 is_primary=true
2020-09-11T09:58:50.962+0200 [INFO] agent.server.connect: initialized primary datacenter CA with provider: provider=consul
2020-09-11T09:58:50.962+0200 [INFO] agent.leader: started routine: routine="federation state anti-entropy"
2020-09-11T09:58:50.962+0200 [INFO] agent.leader: started routine: routine="federation state pruning"
2020-09-11T09:58:50.962+0200 [INFO] agent.leader: started routine: routine="CA root pruning"
2020-09-11T09:58:50.962+0200 [DEBUG] agent.server: Skipping self join check for node since the cluster is too small: node=actarus
2020-09-11T09:58:50.962+0200 [INFO] agent.server: member joined, marking health alive: member=actarus
2020-09-11T09:58:50.962+0200 [INFO] agent.server: federation state anti-entropy synced
2020-09-11T09:58:50.962+0200 [TRACE] agent.server: federation state anti-entropy sync skipped; already up to date
2020-09-11T09:58:51.008+0200 [DEBUG] agent: Skipping remote check since it is managed automatically: check=serfHealth
2020-09-11T09:58:51.008+0200 [INFO] agent: Synced node info
2020-09-11T09:58:52.086+0200 [DEBUG] agent: Skipping remote check since it is managed automatically: check=serfHealth
2020-09-11T09:58:52.086+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:58:52.086+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:58:54.038+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/self from=127.0.0.1:36034 latency=1.983547ms
2020-09-11T09:58:54.042+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/services from=127.0.0.1:36034 latency=584.614µs
2020-09-11T09:58:54.043+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/checks from=127.0.0.1:36034 latency=533.69µs
2020-09-11T09:58:54.043+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/services from=127.0.0.1:36034 latency=63.316µs
2020-09-11T09:58:54.044+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/checks from=127.0.0.1:36034 latency=111.281µs
2020-09-11T09:58:54.044+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:58:54.045+0200 [INFO] agent: Synced service: service=_nomad-server-fz33pagtwooxkqtv6gi3oyjyl24h677x
2020-09-11T09:58:54.045+0200 [DEBUG] agent.http: Request finished: method=PUT url=/v1/agent/service/register from=127.0.0.1:36034 latency=614.701µs
2020-09-11T09:58:54.045+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:58:54.045+0200 [DEBUG] agent: Service in sync: service=_nomad-server-fz33pagtwooxkqtv6gi3oyjyl24h677x
2020-09-11T09:58:54.045+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:58:54.045+0200 [DEBUG] agent: Service in sync: service=_nomad-server-fz33pagtwooxkqtv6gi3oyjyl24h677x
2020-09-11T09:58:54.047+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:58:54.047+0200 [DEBUG] agent: Service in sync: service=_nomad-server-fz33pagtwooxkqtv6gi3oyjyl24h677x
2020-09-11T09:58:54.048+0200 [INFO] agent: Synced service: service=_nomad-server-3sb5sairb37752ririfqx2phxkrlmuyt
2020-09-11T09:58:54.048+0200 [DEBUG] agent.http: Request finished: method=PUT url=/v1/agent/service/register from=127.0.0.1:36034 latency=483.569µs
2020-09-11T09:58:54.048+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:58:54.048+0200 [DEBUG] agent: Service in sync: service=_nomad-server-fz33pagtwooxkqtv6gi3oyjyl24h677x
2020-09-11T09:58:54.048+0200 [DEBUG] agent: Service in sync: service=_nomad-server-3sb5sairb37752ririfqx2phxkrlmuyt
2020-09-11T09:58:54.048+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:58:54.048+0200 [DEBUG] agent: Service in sync: service=_nomad-server-fz33pagtwooxkqtv6gi3oyjyl24h677x
2020-09-11T09:58:54.048+0200 [DEBUG] agent: Service in sync: service=_nomad-server-3sb5sairb37752ririfqx2phxkrlmuyt
2020-09-11T09:58:54.048+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:58:54.048+0200 [DEBUG] agent: Service in sync: service=_nomad-server-fz33pagtwooxkqtv6gi3oyjyl24h677x
2020-09-11T09:58:54.048+0200 [DEBUG] agent: Service in sync: service=_nomad-server-3sb5sairb37752ririfqx2phxkrlmuyt
2020-09-11T09:58:54.048+0200 [INFO] agent: Synced service: service=_nomad-server-jm3k3ijq6qgcymz7xpjnyphrz5qi545i
2020-09-11T09:58:54.048+0200 [DEBUG] agent.http: Request finished: method=PUT url=/v1/agent/service/register from=127.0.0.1:36034 latency=499.227µs
2020-09-11T09:58:54.048+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:58:54.048+0200 [DEBUG] agent: Service in sync: service=_nomad-server-fz33pagtwooxkqtv6gi3oyjyl24h677x
2020-09-11T09:58:54.048+0200 [DEBUG] agent: Service in sync: service=_nomad-server-3sb5sairb37752ririfqx2phxkrlmuyt
2020-09-11T09:58:54.048+0200 [DEBUG] agent: Service in sync: service=_nomad-server-jm3k3ijq6qgcymz7xpjnyphrz5qi545i
2020-09-11T09:58:54.048+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:58:54.049+0200 [DEBUG] agent: Service in sync: service=_nomad-server-fz33pagtwooxkqtv6gi3oyjyl24h677x
2020-09-11T09:58:54.049+0200 [DEBUG] agent: Service in sync: service=_nomad-server-3sb5sairb37752ririfqx2phxkrlmuyt
2020-09-11T09:58:54.049+0200 [DEBUG] agent: Service in sync: service=_nomad-server-jm3k3ijq6qgcymz7xpjnyphrz5qi545i
2020-09-11T09:58:54.049+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:58:54.049+0200 [DEBUG] agent: Service in sync: service=_nomad-server-fz33pagtwooxkqtv6gi3oyjyl24h677x
2020-09-11T09:58:54.049+0200 [DEBUG] agent: Service in sync: service=_nomad-server-3sb5sairb37752ririfqx2phxkrlmuyt
2020-09-11T09:58:54.049+0200 [DEBUG] agent: Service in sync: service=_nomad-server-jm3k3ijq6qgcymz7xpjnyphrz5qi545i
2020-09-11T09:58:54.049+0200 [INFO] agent: Synced check: check=_nomad-check-ed863057181d8943bbd02a7a13e9bbffcad5920b
2020-09-11T09:58:54.049+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/self from=127.0.0.1:36036 latency=1.491363ms
2020-09-11T09:58:54.049+0200 [DEBUG] agent.http: Request finished: method=PUT url=/v1/agent/check/register from=127.0.0.1:36034 latency=558.678µs
2020-09-11T09:58:54.049+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:58:54.050+0200 [DEBUG] agent: Service in sync: service=_nomad-server-fz33pagtwooxkqtv6gi3oyjyl24h677x
2020-09-11T09:58:54.050+0200 [DEBUG] agent: Service in sync: service=_nomad-server-3sb5sairb37752ririfqx2phxkrlmuyt
2020-09-11T09:58:54.050+0200 [DEBUG] agent: Service in sync: service=_nomad-server-jm3k3ijq6qgcymz7xpjnyphrz5qi545i
2020-09-11T09:58:54.050+0200 [DEBUG] agent: Check in sync: check=_nomad-check-ed863057181d8943bbd02a7a13e9bbffcad5920b
2020-09-11T09:58:54.050+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:58:54.050+0200 [DEBUG] agent: Service in sync: service=_nomad-server-fz33pagtwooxkqtv6gi3oyjyl24h677x
2020-09-11T09:58:54.050+0200 [DEBUG] agent: Service in sync: service=_nomad-server-3sb5sairb37752ririfqx2phxkrlmuyt
2020-09-11T09:58:54.050+0200 [DEBUG] agent: Service in sync: service=_nomad-server-jm3k3ijq6qgcymz7xpjnyphrz5qi545i
2020-09-11T09:58:54.050+0200 [DEBUG] agent: Check in sync: check=_nomad-check-ed863057181d8943bbd02a7a13e9bbffcad5920b
2020-09-11T09:58:54.050+0200 [INFO] agent: Synced check: check=_nomad-check-c40ca76a2fbc9326eef8fc932ec8dd5474fb1039
2020-09-11T09:58:54.050+0200 [DEBUG] agent.http: Request finished: method=PUT url=/v1/agent/check/register from=127.0.0.1:36034 latency=404.422µs
2020-09-11T09:58:54.050+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:58:54.050+0200 [DEBUG] agent: Service in sync: service=_nomad-server-3sb5sairb37752ririfqx2phxkrlmuyt
2020-09-11T09:58:54.050+0200 [DEBUG] agent: Service in sync: service=_nomad-server-jm3k3ijq6qgcymz7xpjnyphrz5qi545i
2020-09-11T09:58:54.050+0200 [DEBUG] agent: Service in sync: service=_nomad-server-fz33pagtwooxkqtv6gi3oyjyl24h677x
2020-09-11T09:58:54.050+0200 [DEBUG] agent: Check in sync: check=_nomad-check-ed863057181d8943bbd02a7a13e9bbffcad5920b
2020-09-11T09:58:54.050+0200 [DEBUG] agent: Check in sync: check=_nomad-check-c40ca76a2fbc9326eef8fc932ec8dd5474fb1039
2020-09-11T09:58:54.050+0200 [TRACE] agent.tlsutil: OutgoingTLSConfigForCheck: version=2
2020-09-11T09:58:54.051+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:58:54.051+0200 [DEBUG] agent: Service in sync: service=_nomad-server-fz33pagtwooxkqtv6gi3oyjyl24h677x
2020-09-11T09:58:54.051+0200 [DEBUG] agent: Service in sync: service=_nomad-server-3sb5sairb37752ririfqx2phxkrlmuyt
2020-09-11T09:58:54.051+0200 [DEBUG] agent: Service in sync: service=_nomad-server-jm3k3ijq6qgcymz7xpjnyphrz5qi545i
2020-09-11T09:58:54.051+0200 [INFO] agent: Synced check: check=_nomad-check-524746cf99a9e59f7e67830cd745e33ff9472a5a
2020-09-11T09:58:54.051+0200 [DEBUG] agent: Check in sync: check=_nomad-check-ed863057181d8943bbd02a7a13e9bbffcad5920b
2020-09-11T09:58:54.051+0200 [DEBUG] agent: Check in sync: check=_nomad-check-c40ca76a2fbc9326eef8fc932ec8dd5474fb1039
2020-09-11T09:58:54.051+0200 [DEBUG] agent.http: Request finished: method=PUT url=/v1/agent/check/register from=127.0.0.1:36034 latency=728.288µs
2020-09-11T09:58:54.051+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:58:54.051+0200 [DEBUG] agent: Service in sync: service=_nomad-server-fz33pagtwooxkqtv6gi3oyjyl24h677x
2020-09-11T09:58:54.051+0200 [DEBUG] agent: Service in sync: service=_nomad-server-3sb5sairb37752ririfqx2phxkrlmuyt
2020-09-11T09:58:54.051+0200 [DEBUG] agent: Service in sync: service=_nomad-server-jm3k3ijq6qgcymz7xpjnyphrz5qi545i
2020-09-11T09:58:54.051+0200 [DEBUG] agent: Check in sync: check=_nomad-check-c40ca76a2fbc9326eef8fc932ec8dd5474fb1039
2020-09-11T09:58:54.051+0200 [DEBUG] agent: Check in sync: check=_nomad-check-524746cf99a9e59f7e67830cd745e33ff9472a5a
2020-09-11T09:58:54.051+0200 [DEBUG] agent: Check in sync: check=_nomad-check-ed863057181d8943bbd02a7a13e9bbffcad5920b
2020-09-11T09:58:54.588+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/internal/ui/services?dc=dc1&index=1 from=127.0.0.1:36042 latency=860.65µs
2020-09-11T09:58:55.095+0200 [DEBUG] agent: Check status updated: check=_nomad-check-ed863057181d8943bbd02a7a13e9bbffcad5920b status=passing
2020-09-11T09:58:55.095+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:58:55.095+0200 [DEBUG] agent: Service in sync: service=_nomad-server-3sb5sairb37752ririfqx2phxkrlmuyt
2020-09-11T09:58:55.095+0200 [DEBUG] agent: Service in sync: service=_nomad-server-jm3k3ijq6qgcymz7xpjnyphrz5qi545i
2020-09-11T09:58:55.095+0200 [DEBUG] agent: Service in sync: service=_nomad-server-fz33pagtwooxkqtv6gi3oyjyl24h677x
2020-09-11T09:58:55.096+0200 [INFO] agent: Synced check: check=_nomad-check-ed863057181d8943bbd02a7a13e9bbffcad5920b
2020-09-11T09:58:55.096+0200 [DEBUG] agent: Check in sync: check=_nomad-check-c40ca76a2fbc9326eef8fc932ec8dd5474fb1039
2020-09-11T09:58:55.096+0200 [DEBUG] agent: Check in sync: check=_nomad-check-524746cf99a9e59f7e67830cd745e33ff9472a5a
2020-09-11T09:58:58.588+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/internal/ui/services?dc=dc1&index=18 from=127.0.0.1:36042 latency=640.522µs
2020-09-11T09:58:59.622+0200 [WARN] agent: Check is now critical: check=_nomad-check-524746cf99a9e59f7e67830cd745e33ff9472a5a
2020-09-11T09:59:00.150+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/services from=127.0.0.1:36034 latency=195.241µs
2020-09-11T09:59:00.151+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/checks from=127.0.0.1:36034 latency=328.395µs
2020-09-11T09:59:00.151+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:59:00.151+0200 [DEBUG] agent: Service in sync: service=_nomad-server-fz33pagtwooxkqtv6gi3oyjyl24h677x
2020-09-11T09:59:00.151+0200 [DEBUG] agent: Service in sync: service=_nomad-server-3sb5sairb37752ririfqx2phxkrlmuyt
2020-09-11T09:59:00.151+0200 [DEBUG] agent: Service in sync: service=_nomad-server-jm3k3ijq6qgcymz7xpjnyphrz5qi545i
2020-09-11T09:59:00.151+0200 [INFO] agent: Synced service: service=_nomad-client-t7ol5wcczlsnwgayg7jezx52f477jwuq
2020-09-11T09:59:00.151+0200 [DEBUG] agent: Check in sync: check=_nomad-check-ed863057181d8943bbd02a7a13e9bbffcad5920b
2020-09-11T09:59:00.151+0200 [DEBUG] agent: Check in sync: check=_nomad-check-c40ca76a2fbc9326eef8fc932ec8dd5474fb1039
2020-09-11T09:59:00.151+0200 [DEBUG] agent: Check in sync: check=_nomad-check-524746cf99a9e59f7e67830cd745e33ff9472a5a
2020-09-11T09:59:00.151+0200 [DEBUG] agent.http: Request finished: method=PUT url=/v1/agent/service/register from=127.0.0.1:36034 latency=308.002µs
2020-09-11T09:59:00.151+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:59:00.152+0200 [DEBUG] agent: Service in sync: service=_nomad-server-fz33pagtwooxkqtv6gi3oyjyl24h677x
2020-09-11T09:59:00.152+0200 [DEBUG] agent: Service in sync: service=_nomad-server-3sb5sairb37752ririfqx2phxkrlmuyt
2020-09-11T09:59:00.152+0200 [DEBUG] agent: Service in sync: service=_nomad-server-jm3k3ijq6qgcymz7xpjnyphrz5qi545i
2020-09-11T09:59:00.152+0200 [DEBUG] agent: Service in sync: service=_nomad-client-t7ol5wcczlsnwgayg7jezx52f477jwuq
2020-09-11T09:59:00.152+0200 [DEBUG] agent: Check in sync: check=_nomad-check-ed863057181d8943bbd02a7a13e9bbffcad5920b
2020-09-11T09:59:00.152+0200 [DEBUG] agent: Check in sync: check=_nomad-check-c40ca76a2fbc9326eef8fc932ec8dd5474fb1039
2020-09-11T09:59:00.152+0200 [DEBUG] agent: Check in sync: check=_nomad-check-524746cf99a9e59f7e67830cd745e33ff9472a5a
2020-09-11T09:59:00.152+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:59:00.152+0200 [DEBUG] agent: Service in sync: service=_nomad-server-fz33pagtwooxkqtv6gi3oyjyl24h677x
2020-09-11T09:59:00.152+0200 [DEBUG] agent: Service in sync: service=_nomad-server-3sb5sairb37752ririfqx2phxkrlmuyt
2020-09-11T09:59:00.152+0200 [DEBUG] agent: Service in sync: service=_nomad-server-jm3k3ijq6qgcymz7xpjnyphrz5qi545i
2020-09-11T09:59:00.152+0200 [DEBUG] agent: Service in sync: service=_nomad-client-t7ol5wcczlsnwgayg7jezx52f477jwuq
2020-09-11T09:59:00.152+0200 [DEBUG] agent: Check in sync: check=_nomad-check-c40ca76a2fbc9326eef8fc932ec8dd5474fb1039
2020-09-11T09:59:00.152+0200 [DEBUG] agent: Check in sync: check=_nomad-check-524746cf99a9e59f7e67830cd745e33ff9472a5a
2020-09-11T09:59:00.152+0200 [DEBUG] agent: Check in sync: check=_nomad-check-ed863057181d8943bbd02a7a13e9bbffcad5920b
2020-09-11T09:59:00.152+0200 [TRACE] agent.tlsutil: OutgoingTLSConfigForCheck: version=2
2020-09-11T09:59:00.152+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:59:00.152+0200 [DEBUG] agent: Service in sync: service=_nomad-server-fz33pagtwooxkqtv6gi3oyjyl24h677x
2020-09-11T09:59:00.152+0200 [DEBUG] agent: Service in sync: service=_nomad-server-3sb5sairb37752ririfqx2phxkrlmuyt
2020-09-11T09:59:00.152+0200 [DEBUG] agent: Service in sync: service=_nomad-server-jm3k3ijq6qgcymz7xpjnyphrz5qi545i
2020-09-11T09:59:00.152+0200 [DEBUG] agent: Service in sync: service=_nomad-client-t7ol5wcczlsnwgayg7jezx52f477jwuq
2020-09-11T09:59:00.152+0200 [DEBUG] agent: Check in sync: check=_nomad-check-c40ca76a2fbc9326eef8fc932ec8dd5474fb1039
2020-09-11T09:59:00.152+0200 [DEBUG] agent: Check in sync: check=_nomad-check-524746cf99a9e59f7e67830cd745e33ff9472a5a
2020-09-11T09:59:00.152+0200 [INFO] agent: Synced check: check=_nomad-check-d853f073d50e94c82017c7dd7dc62f1d3586ec0c
2020-09-11T09:59:00.152+0200 [DEBUG] agent: Check in sync: check=_nomad-check-ed863057181d8943bbd02a7a13e9bbffcad5920b
2020-09-11T09:59:00.152+0200 [DEBUG] agent.http: Request finished: method=PUT url=/v1/agent/check/register from=127.0.0.1:36034 latency=293.929µs
2020-09-11T09:59:00.152+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:59:00.152+0200 [DEBUG] agent: Service in sync: service=_nomad-server-fz33pagtwooxkqtv6gi3oyjyl24h677x
2020-09-11T09:59:00.152+0200 [DEBUG] agent: Service in sync: service=_nomad-server-3sb5sairb37752ririfqx2phxkrlmuyt
2020-09-11T09:59:00.152+0200 [DEBUG] agent: Service in sync: service=_nomad-server-jm3k3ijq6qgcymz7xpjnyphrz5qi545i
2020-09-11T09:59:00.152+0200 [DEBUG] agent: Service in sync: service=_nomad-client-t7ol5wcczlsnwgayg7jezx52f477jwuq
2020-09-11T09:59:00.152+0200 [DEBUG] agent: Check in sync: check=_nomad-check-ed863057181d8943bbd02a7a13e9bbffcad5920b
2020-09-11T09:59:00.152+0200 [DEBUG] agent: Check in sync: check=_nomad-check-c40ca76a2fbc9326eef8fc932ec8dd5474fb1039
2020-09-11T09:59:00.152+0200 [DEBUG] agent: Check in sync: check=_nomad-check-524746cf99a9e59f7e67830cd745e33ff9472a5a
2020-09-11T09:59:00.152+0200 [DEBUG] agent: Check in sync: check=_nomad-check-d853f073d50e94c82017c7dd7dc62f1d3586ec0c
2020-09-11T09:59:02.587+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/internal/ui/services?dc=dc1&index=19 from=127.0.0.1:36042 latency=575.313µs
2020-09-11T09:59:03.553+0200 [DEBUG] agent: Check status updated: check=_nomad-check-c40ca76a2fbc9326eef8fc932ec8dd5474fb1039 status=passing
2020-09-11T09:59:03.553+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:59:03.553+0200 [DEBUG] agent: Service in sync: service=_nomad-server-jm3k3ijq6qgcymz7xpjnyphrz5qi545i
2020-09-11T09:59:03.553+0200 [DEBUG] agent: Service in sync: service=_nomad-client-t7ol5wcczlsnwgayg7jezx52f477jwuq
2020-09-11T09:59:03.553+0200 [DEBUG] agent: Service in sync: service=_nomad-server-fz33pagtwooxkqtv6gi3oyjyl24h677x
2020-09-11T09:59:03.553+0200 [DEBUG] agent: Service in sync: service=_nomad-server-3sb5sairb37752ririfqx2phxkrlmuyt
2020-09-11T09:59:03.553+0200 [DEBUG] agent: Check in sync: check=_nomad-check-524746cf99a9e59f7e67830cd745e33ff9472a5a
2020-09-11T09:59:03.553+0200 [DEBUG] agent: Check in sync: check=_nomad-check-d853f073d50e94c82017c7dd7dc62f1d3586ec0c
2020-09-11T09:59:03.553+0200 [DEBUG] agent: Check in sync: check=_nomad-check-ed863057181d8943bbd02a7a13e9bbffcad5920b
2020-09-11T09:59:03.554+0200 [INFO] agent: Synced check: check=_nomad-check-c40ca76a2fbc9326eef8fc932ec8dd5474fb1039
2020-09-11T09:59:04.998+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/services from=127.0.0.1:36034 latency=349.813µs
2020-09-11T09:59:05.000+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/checks from=127.0.0.1:36034 latency=349.623µs
2020-09-11T09:59:05.003+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:59:05.003+0200 [DEBUG] agent: Service in sync: service=_nomad-server-fz33pagtwooxkqtv6gi3oyjyl24h677x
2020-09-11T09:59:05.003+0200 [DEBUG] agent: Service in sync: service=_nomad-server-3sb5sairb37752ririfqx2phxkrlmuyt
2020-09-11T09:59:05.003+0200 [DEBUG] agent: Service in sync: service=_nomad-server-jm3k3ijq6qgcymz7xpjnyphrz5qi545i
2020-09-11T09:59:05.003+0200 [DEBUG] agent: Service in sync: service=_nomad-client-t7ol5wcczlsnwgayg7jezx52f477jwuq
2020-09-11T09:59:05.003+0200 [INFO] agent: Synced service: service=_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001
2020-09-11T09:59:05.004+0200 [INFO] agent: Synced service: service=_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy
2020-09-11T09:59:05.004+0200 [DEBUG] agent: Check in sync: check=_nomad-check-524746cf99a9e59f7e67830cd745e33ff9472a5a
2020-09-11T09:59:05.004+0200 [DEBUG] agent: Check in sync: check=_nomad-check-d853f073d50e94c82017c7dd7dc62f1d3586ec0c
2020-09-11T09:59:05.004+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:1
2020-09-11T09:59:05.004+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:2
2020-09-11T09:59:05.004+0200 [DEBUG] agent: Check in sync: check=_nomad-check-ed863057181d8943bbd02a7a13e9bbffcad5920b
2020-09-11T09:59:05.004+0200 [DEBUG] agent: Check in sync: check=_nomad-check-c40ca76a2fbc9326eef8fc932ec8dd5474fb1039
2020-09-11T09:59:05.004+0200 [DEBUG] agent.http: Request finished: method=PUT url=/v1/agent/service/register from=127.0.0.1:36034 latency=1.867086ms
2020-09-11T09:59:05.004+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:59:05.004+0200 [DEBUG] agent: Service in sync: service=_nomad-client-t7ol5wcczlsnwgayg7jezx52f477jwuq
2020-09-11T09:59:05.004+0200 [DEBUG] agent: Service in sync: service=_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001
2020-09-11T09:59:05.004+0200 [DEBUG] agent: Service in sync: service=_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy
2020-09-11T09:59:05.004+0200 [DEBUG] agent: Service in sync: service=_nomad-server-fz33pagtwooxkqtv6gi3oyjyl24h677x
2020-09-11T09:59:05.004+0200 [DEBUG] agent: Service in sync: service=_nomad-server-3sb5sairb37752ririfqx2phxkrlmuyt
2020-09-11T09:59:05.004+0200 [DEBUG] agent: Service in sync: service=_nomad-server-jm3k3ijq6qgcymz7xpjnyphrz5qi545i
2020-09-11T09:59:05.004+0200 [DEBUG] agent: Check in sync: check=_nomad-check-c40ca76a2fbc9326eef8fc932ec8dd5474fb1039
2020-09-11T09:59:05.004+0200 [DEBUG] agent: Check in sync: check=_nomad-check-524746cf99a9e59f7e67830cd745e33ff9472a5a
2020-09-11T09:59:05.004+0200 [DEBUG] agent: Check in sync: check=_nomad-check-d853f073d50e94c82017c7dd7dc62f1d3586ec0c
2020-09-11T09:59:05.004+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:1
2020-09-11T09:59:05.004+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:2
2020-09-11T09:59:05.004+0200 [DEBUG] agent: Check in sync: check=_nomad-check-ed863057181d8943bbd02a7a13e9bbffcad5920b
2020-09-11T09:59:05.004+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:59:05.004+0200 [DEBUG] agent: Service in sync: service=_nomad-client-t7ol5wcczlsnwgayg7jezx52f477jwuq
2020-09-11T09:59:05.004+0200 [DEBUG] agent: Service in sync: service=_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001
2020-09-11T09:59:05.004+0200 [DEBUG] agent: Service in sync: service=_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy
2020-09-11T09:59:05.004+0200 [DEBUG] agent: Service in sync: service=_nomad-server-fz33pagtwooxkqtv6gi3oyjyl24h677x
2020-09-11T09:59:05.004+0200 [DEBUG] agent: Service in sync: service=_nomad-server-3sb5sairb37752ririfqx2phxkrlmuyt
2020-09-11T09:59:05.004+0200 [DEBUG] agent: Service in sync: service=_nomad-server-jm3k3ijq6qgcymz7xpjnyphrz5qi545i
2020-09-11T09:59:05.005+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:1
2020-09-11T09:59:05.005+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:2
2020-09-11T09:59:05.005+0200 [DEBUG] agent: Check in sync: check=_nomad-check-ed863057181d8943bbd02a7a13e9bbffcad5920b
2020-09-11T09:59:05.005+0200 [DEBUG] agent: Check in sync: check=_nomad-check-c40ca76a2fbc9326eef8fc932ec8dd5474fb1039
2020-09-11T09:59:05.005+0200 [DEBUG] agent: Check in sync: check=_nomad-check-524746cf99a9e59f7e67830cd745e33ff9472a5a
2020-09-11T09:59:05.005+0200 [DEBUG] agent: Check in sync: check=_nomad-check-d853f073d50e94c82017c7dd7dc62f1d3586ec0c
2020-09-11T09:59:05.005+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:59:05.005+0200 [DEBUG] agent: Service in sync: service=_nomad-server-jm3k3ijq6qgcymz7xpjnyphrz5qi545i
2020-09-11T09:59:05.005+0200 [DEBUG] agent: Service in sync: service=_nomad-client-t7ol5wcczlsnwgayg7jezx52f477jwuq
2020-09-11T09:59:05.005+0200 [DEBUG] agent: Service in sync: service=_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001
2020-09-11T09:59:05.005+0200 [DEBUG] agent: Service in sync: service=_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy
2020-09-11T09:59:05.005+0200 [DEBUG] agent: Service in sync: service=_nomad-server-fz33pagtwooxkqtv6gi3oyjyl24h677x
2020-09-11T09:59:05.005+0200 [DEBUG] agent: Service in sync: service=_nomad-server-3sb5sairb37752ririfqx2phxkrlmuyt
2020-09-11T09:59:05.005+0200 [DEBUG] agent: Check in sync: check=_nomad-check-ed863057181d8943bbd02a7a13e9bbffcad5920b
2020-09-11T09:59:05.005+0200 [DEBUG] agent: Check in sync: check=_nomad-check-c40ca76a2fbc9326eef8fc932ec8dd5474fb1039
2020-09-11T09:59:05.005+0200 [DEBUG] agent: Check in sync: check=_nomad-check-524746cf99a9e59f7e67830cd745e33ff9472a5a
2020-09-11T09:59:05.005+0200 [DEBUG] agent: Check in sync: check=_nomad-check-d853f073d50e94c82017c7dd7dc62f1d3586ec0c
2020-09-11T09:59:05.005+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:1
2020-09-11T09:59:05.006+0200 [INFO] agent: Synced check: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:2
2020-09-11T09:59:05.055+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/services from=127.0.0.1:36076 latency=177.537µs
2020-09-11T09:59:05.056+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/service/_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy from=127.0.0.1:36076 latency=241.794µs
2020-09-11T09:59:05.095+0200 [DEBUG] agent: Check status updated: check=_nomad-check-ed863057181d8943bbd02a7a13e9bbffcad5920b status=passing
2020-09-11T09:59:05.144+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/services from=127.0.0.1:36034 latency=260.935µs
2020-09-11T09:59:05.145+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/checks from=127.0.0.1:36034 latency=698.769µs
2020-09-11T09:59:05.644+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/services from=127.0.0.1:36034 latency=195.762µs
2020-09-11T09:59:05.644+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/checks from=127.0.0.1:36034 latency=132.256µs
2020-09-11T09:59:06.145+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/services from=127.0.0.1:36034 latency=917.719µs
2020-09-11T09:59:06.147+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/checks from=127.0.0.1:36034 latency=464.978µs
2020-09-11T09:59:06.590+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/internal/ui/services?dc=dc1&index=21 from=127.0.0.1:36086 latency=870.833µs
2020-09-11T09:59:06.645+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/services from=127.0.0.1:36034 latency=676.275µs
2020-09-11T09:59:06.648+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/checks from=127.0.0.1:36034 latency=598.778µs
2020-09-11T09:59:07.145+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/services from=127.0.0.1:36034 latency=521.412µs
2020-09-11T09:59:07.147+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/checks from=127.0.0.1:36034 latency=449.907µs
2020-09-11T09:59:07.477+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/checks from=127.0.0.1:36088 latency=106.065µs
2020-09-11T09:59:07.645+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/services from=127.0.0.1:36034 latency=795.671µs
2020-09-11T09:59:07.647+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/checks from=127.0.0.1:36034 latency=518.767µs
2020-09-11T09:59:08.145+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/services from=127.0.0.1:36034 latency=585.255µs
2020-09-11T09:59:08.147+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/checks from=127.0.0.1:36034 latency=479.608µs
2020-09-11T09:59:08.645+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/services from=127.0.0.1:36034 latency=526.905µs
2020-09-11T09:59:08.651+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/checks from=127.0.0.1:36034 latency=601.094µs
2020-09-11T09:59:09.056+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/self from=127.0.0.1:36036 latency=2.283019ms
2020-09-11T09:59:09.145+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/services from=127.0.0.1:36034 latency=538.62µs
2020-09-11T09:59:09.147+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/checks from=127.0.0.1:36034 latency=496.159µs
2020-09-11T09:59:09.531+0200 [DEBUG] agent: Check status updated: check=_nomad-check-d853f073d50e94c82017c7dd7dc62f1d3586ec0c status=passing
2020-09-11T09:59:09.531+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:59:09.531+0200 [DEBUG] agent: Service in sync: service=_nomad-server-3sb5sairb37752ririfqx2phxkrlmuyt
2020-09-11T09:59:09.531+0200 [DEBUG] agent: Service in sync: service=_nomad-server-jm3k3ijq6qgcymz7xpjnyphrz5qi545i
2020-09-11T09:59:09.531+0200 [DEBUG] agent: Service in sync: service=_nomad-client-t7ol5wcczlsnwgayg7jezx52f477jwuq
2020-09-11T09:59:09.531+0200 [DEBUG] agent: Service in sync: service=_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001
2020-09-11T09:59:09.531+0200 [DEBUG] agent: Service in sync: service=_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy
2020-09-11T09:59:09.531+0200 [DEBUG] agent: Service in sync: service=_nomad-server-fz33pagtwooxkqtv6gi3oyjyl24h677x
2020-09-11T09:59:09.531+0200 [DEBUG] agent: Check in sync: check=_nomad-check-ed863057181d8943bbd02a7a13e9bbffcad5920b
2020-09-11T09:59:09.531+0200 [DEBUG] agent: Check in sync: check=_nomad-check-c40ca76a2fbc9326eef8fc932ec8dd5474fb1039
2020-09-11T09:59:09.531+0200 [DEBUG] agent: Check in sync: check=_nomad-check-524746cf99a9e59f7e67830cd745e33ff9472a5a
2020-09-11T09:59:09.532+0200 [INFO] agent: Synced check: check=_nomad-check-d853f073d50e94c82017c7dd7dc62f1d3586ec0c
2020-09-11T09:59:09.532+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:1
2020-09-11T09:59:09.532+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:2
2020-09-11T09:59:09.624+0200 [DEBUG] agent: Check status updated: check=_nomad-check-524746cf99a9e59f7e67830cd745e33ff9472a5a status=passing
2020-09-11T09:59:09.625+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:59:09.625+0200 [DEBUG] agent: Service in sync: service=_nomad-server-fz33pagtwooxkqtv6gi3oyjyl24h677x
2020-09-11T09:59:09.625+0200 [DEBUG] agent: Service in sync: service=_nomad-server-3sb5sairb37752ririfqx2phxkrlmuyt
2020-09-11T09:59:09.625+0200 [DEBUG] agent: Service in sync: service=_nomad-server-jm3k3ijq6qgcymz7xpjnyphrz5qi545i
2020-09-11T09:59:09.625+0200 [DEBUG] agent: Service in sync: service=_nomad-client-t7ol5wcczlsnwgayg7jezx52f477jwuq
2020-09-11T09:59:09.625+0200 [DEBUG] agent: Service in sync: service=_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001
2020-09-11T09:59:09.625+0200 [DEBUG] agent: Service in sync: service=_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy
2020-09-11T09:59:09.625+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:2
2020-09-11T09:59:09.625+0200 [DEBUG] agent: Check in sync: check=_nomad-check-ed863057181d8943bbd02a7a13e9bbffcad5920b
2020-09-11T09:59:09.625+0200 [DEBUG] agent: Check in sync: check=_nomad-check-c40ca76a2fbc9326eef8fc932ec8dd5474fb1039
2020-09-11T09:59:09.626+0200 [INFO] agent: Synced check: check=_nomad-check-524746cf99a9e59f7e67830cd745e33ff9472a5a
2020-09-11T09:59:09.626+0200 [DEBUG] agent: Check in sync: check=_nomad-check-d853f073d50e94c82017c7dd7dc62f1d3586ec0c
2020-09-11T09:59:09.626+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:1
2020-09-11T09:59:09.645+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/services from=127.0.0.1:36034 latency=646.758µs
2020-09-11T09:59:09.648+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/checks from=127.0.0.1:36034 latency=632.094µs
2020-09-11T09:59:09.808+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/checks from=127.0.0.1:36096 latency=117.049µs
2020-09-11T09:59:10.145+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/services from=127.0.0.1:36034 latency=502.458µs
2020-09-11T09:59:10.147+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/checks from=127.0.0.1:36034 latency=431.846µs
2020-09-11T09:59:10.587+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/internal/ui/services?dc=dc1&index=26 from=127.0.0.1:36086 latency=634.408µs
2020-09-11T09:59:10.644+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/services from=127.0.0.1:36034 latency=244.873µs
2020-09-11T09:59:10.645+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/checks from=127.0.0.1:36034 latency=175.756µs
2020-09-11T09:59:11.145+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/services from=127.0.0.1:36034 latency=591.853µs
2020-09-11T09:59:11.147+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/checks from=127.0.0.1:36034 latency=464.642µs
2020-09-11T09:59:11.645+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/services from=127.0.0.1:36034 latency=523.516µs
2020-09-11T09:59:11.647+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/checks from=127.0.0.1:36034 latency=501.514µs
2020-09-11T09:59:12.145+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/services from=127.0.0.1:36034 latency=516.432µs
2020-09-11T09:59:12.146+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/checks from=127.0.0.1:36034 latency=433.942µs
2020-09-11T09:59:12.286+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/checks from=127.0.0.1:36098 latency=107.859µs
2020-09-11T09:59:12.645+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/services from=127.0.0.1:36034 latency=555.364µs
2020-09-11T09:59:12.647+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/checks from=127.0.0.1:36034 latency=544.755µs
2020-09-11T09:59:13.145+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/services from=127.0.0.1:36034 latency=536.974µs
2020-09-11T09:59:13.147+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/checks from=127.0.0.1:36034 latency=484.725µs
2020-09-11T09:59:13.554+0200 [DEBUG] agent: Check status updated: check=_nomad-check-c40ca76a2fbc9326eef8fc932ec8dd5474fb1039 status=passing
2020-09-11T09:59:13.645+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/services from=127.0.0.1:36034 latency=713.022µs
2020-09-11T09:59:13.647+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/checks from=127.0.0.1:36034 latency=435.666µs
2020-09-11T09:59:13.821+0200 [DEBUG] agent: Check status updated: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:1 status=passing
2020-09-11T09:59:13.821+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:59:13.821+0200 [DEBUG] agent: Service in sync: service=_nomad-server-fz33pagtwooxkqtv6gi3oyjyl24h677x
2020-09-11T09:59:13.821+0200 [DEBUG] agent: Service in sync: service=_nomad-server-3sb5sairb37752ririfqx2phxkrlmuyt
2020-09-11T09:59:13.821+0200 [DEBUG] agent: Service in sync: service=_nomad-server-jm3k3ijq6qgcymz7xpjnyphrz5qi545i
2020-09-11T09:59:13.821+0200 [DEBUG] agent: Service in sync: service=_nomad-client-t7ol5wcczlsnwgayg7jezx52f477jwuq
2020-09-11T09:59:13.821+0200 [DEBUG] agent: Service in sync: service=_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001
2020-09-11T09:59:13.821+0200 [DEBUG] agent: Service in sync: service=_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy
2020-09-11T09:59:13.821+0200 [DEBUG] agent: Check in sync: check=_nomad-check-d853f073d50e94c82017c7dd7dc62f1d3586ec0c
2020-09-11T09:59:13.823+0200 [INFO] agent: Synced check: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:1
2020-09-11T09:59:13.823+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:2
2020-09-11T09:59:13.823+0200 [DEBUG] agent: Check in sync: check=_nomad-check-ed863057181d8943bbd02a7a13e9bbffcad5920b
2020-09-11T09:59:13.823+0200 [DEBUG] agent: Check in sync: check=_nomad-check-c40ca76a2fbc9326eef8fc932ec8dd5474fb1039
2020-09-11T09:59:13.823+0200 [DEBUG] agent: Check in sync: check=_nomad-check-524746cf99a9e59f7e67830cd745e33ff9472a5a
2020-09-11T09:59:14.145+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/services from=127.0.0.1:36034 latency=538.103µs
2020-09-11T09:59:14.147+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/checks from=127.0.0.1:36034 latency=441.413µs
2020-09-11T09:59:14.590+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/internal/ui/services?dc=dc1&index=29 from=127.0.0.1:36086 latency=657.25µs
2020-09-11T09:59:14.644+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/services from=127.0.0.1:36034 latency=203.256µs
2020-09-11T09:59:14.645+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/checks from=127.0.0.1:36034 latency=187.394µs
2020-09-11T09:59:14.924+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/checks from=127.0.0.1:36106 latency=133.996µs
2020-09-11T09:59:15.096+0200 [DEBUG] agent: Check status updated: check=_nomad-check-ed863057181d8943bbd02a7a13e9bbffcad5920b status=passing
2020-09-11T09:59:15.145+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/services from=127.0.0.1:36034 latency=688.583µs
2020-09-11T09:59:15.148+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/checks from=127.0.0.1:36034 latency=801.23µs
2020-09-11T09:59:15.645+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/services from=127.0.0.1:36034 latency=752.474µs
2020-09-11T09:59:15.647+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/checks from=127.0.0.1:36034 latency=502.061µs
2020-09-11T09:59:19.533+0200 [DEBUG] agent: Check status updated: check=_nomad-check-d853f073d50e94c82017c7dd7dc62f1d3586ec0c status=passing
2020-09-11T09:59:19.626+0200 [DEBUG] agent: Check status updated: check=_nomad-check-524746cf99a9e59f7e67830cd745e33ff9472a5a status=passing
2020-09-11T09:59:23.555+0200 [DEBUG] agent: Check status updated: check=_nomad-check-c40ca76a2fbc9326eef8fc932ec8dd5474fb1039 status=passing
2020-09-11T09:59:23.822+0200 [DEBUG] agent: Check status updated: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:1 status=passing
2020-09-11T09:59:24.057+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/self from=127.0.0.1:36036 latency=2.935164ms
2020-09-11T09:59:25.097+0200 [DEBUG] agent: Check status updated: check=_nomad-check-ed863057181d8943bbd02a7a13e9bbffcad5920b status=passing
2020-09-11T09:59:29.535+0200 [DEBUG] agent: Check status updated: check=_nomad-check-d853f073d50e94c82017c7dd7dc62f1d3586ec0c status=passing
2020-09-11T09:59:29.629+0200 [DEBUG] agent: Check status updated: check=_nomad-check-524746cf99a9e59f7e67830cd745e33ff9472a5a status=passing
2020-09-11T09:59:31.283+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/services from=127.0.0.1:36034 latency=337.636µs
2020-09-11T09:59:31.285+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/checks from=127.0.0.1:36034 latency=257.243µs
2020-09-11T09:59:31.286+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:59:31.287+0200 [INFO] agent: Synced service: service=_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy
2020-09-11T09:59:31.287+0200 [DEBUG] agent: Service in sync: service=_nomad-server-fz33pagtwooxkqtv6gi3oyjyl24h677x
2020-09-11T09:59:31.287+0200 [DEBUG] agent: Service in sync: service=_nomad-server-3sb5sairb37752ririfqx2phxkrlmuyt
2020-09-11T09:59:31.287+0200 [DEBUG] agent: Service in sync: service=_nomad-server-jm3k3ijq6qgcymz7xpjnyphrz5qi545i
2020-09-11T09:59:31.287+0200 [DEBUG] agent: Service in sync: service=_nomad-client-t7ol5wcczlsnwgayg7jezx52f477jwuq
2020-09-11T09:59:31.287+0200 [INFO] agent: Synced service: service=_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001
2020-09-11T09:59:31.287+0200 [DEBUG] agent: Check in sync: check=_nomad-check-d853f073d50e94c82017c7dd7dc62f1d3586ec0c
2020-09-11T09:59:31.287+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:1
2020-09-11T09:59:31.287+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:2
2020-09-11T09:59:31.287+0200 [DEBUG] agent: Check in sync: check=_nomad-check-ed863057181d8943bbd02a7a13e9bbffcad5920b
2020-09-11T09:59:31.287+0200 [DEBUG] agent: Check in sync: check=_nomad-check-c40ca76a2fbc9326eef8fc932ec8dd5474fb1039
2020-09-11T09:59:31.287+0200 [DEBUG] agent: Check in sync: check=_nomad-check-524746cf99a9e59f7e67830cd745e33ff9472a5a
2020-09-11T09:59:31.287+0200 [DEBUG] agent.http: Request finished: method=PUT url=/v1/agent/service/register from=127.0.0.1:36034 latency=1.732965ms
2020-09-11T09:59:31.287+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/internal/ui/services?dc=dc1&index=30 from=127.0.0.1:36086 latency=12.698879427s
2020-09-11T09:59:31.287+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:59:31.287+0200 [DEBUG] agent: Service in sync: service=_nomad-server-jm3k3ijq6qgcymz7xpjnyphrz5qi545i
2020-09-11T09:59:31.287+0200 [DEBUG] agent: Service in sync: service=_nomad-client-t7ol5wcczlsnwgayg7jezx52f477jwuq
2020-09-11T09:59:31.287+0200 [DEBUG] agent: Service in sync: service=_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001
2020-09-11T09:59:31.287+0200 [DEBUG] agent: Service in sync: service=_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy
2020-09-11T09:59:31.287+0200 [DEBUG] agent: Service in sync: service=_nomad-server-fz33pagtwooxkqtv6gi3oyjyl24h677x
2020-09-11T09:59:31.287+0200 [DEBUG] agent: Service in sync: service=_nomad-server-3sb5sairb37752ririfqx2phxkrlmuyt
2020-09-11T09:59:31.287+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:2
2020-09-11T09:59:31.287+0200 [DEBUG] agent: Check in sync: check=_nomad-check-ed863057181d8943bbd02a7a13e9bbffcad5920b
2020-09-11T09:59:31.287+0200 [DEBUG] agent: Check in sync: check=_nomad-check-c40ca76a2fbc9326eef8fc932ec8dd5474fb1039
2020-09-11T09:59:31.287+0200 [DEBUG] agent: Check in sync: check=_nomad-check-524746cf99a9e59f7e67830cd745e33ff9472a5a
2020-09-11T09:59:31.287+0200 [DEBUG] agent: Check in sync: check=_nomad-check-d853f073d50e94c82017c7dd7dc62f1d3586ec0c
2020-09-11T09:59:31.287+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:1
2020-09-11T09:59:31.289+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:59:31.289+0200 [DEBUG] agent: Service in sync: service=_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001
2020-09-11T09:59:31.289+0200 [DEBUG] agent: Service in sync: service=_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy
2020-09-11T09:59:31.289+0200 [INFO] agent: Synced service: service=_nomad-task-4f11511e-782f-27e0-1480-c64812a66525-group-batch_with_connect-count-dashboard-9002
2020-09-11T09:59:31.290+0200 [INFO] agent: Synced service: service=_nomad-task-4f11511e-782f-27e0-1480-c64812a66525-group-batch_with_connect-count-dashboard-9002-sidecar-proxy
2020-09-11T09:59:31.290+0200 [DEBUG] agent: Service in sync: service=_nomad-server-fz33pagtwooxkqtv6gi3oyjyl24h677x
2020-09-11T09:59:31.290+0200 [DEBUG] agent: Service in sync: service=_nomad-server-3sb5sairb37752ririfqx2phxkrlmuyt
2020-09-11T09:59:31.290+0200 [DEBUG] agent: Service in sync: service=_nomad-server-jm3k3ijq6qgcymz7xpjnyphrz5qi545i
2020-09-11T09:59:31.290+0200 [DEBUG] agent: Service in sync: service=_nomad-client-t7ol5wcczlsnwgayg7jezx52f477jwuq
2020-09-11T09:59:31.290+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-4f11511e-782f-27e0-1480-c64812a66525-group-batch_with_connect-count-dashboard-9002-sidecar-proxy:1
2020-09-11T09:59:31.290+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-4f11511e-782f-27e0-1480-c64812a66525-group-batch_with_connect-count-dashboard-9002-sidecar-proxy:2
2020-09-11T09:59:31.290+0200 [DEBUG] agent: Check in sync: check=_nomad-check-ed863057181d8943bbd02a7a13e9bbffcad5920b
2020-09-11T09:59:31.290+0200 [DEBUG] agent: Check in sync: check=_nomad-check-c40ca76a2fbc9326eef8fc932ec8dd5474fb1039
2020-09-11T09:59:31.290+0200 [DEBUG] agent: Check in sync: check=_nomad-check-524746cf99a9e59f7e67830cd745e33ff9472a5a
2020-09-11T09:59:31.290+0200 [DEBUG] agent: Check in sync: check=_nomad-check-d853f073d50e94c82017c7dd7dc62f1d3586ec0c
2020-09-11T09:59:31.290+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:1
2020-09-11T09:59:31.290+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:2
2020-09-11T09:59:31.290+0200 [DEBUG] agent.http: Request finished: method=PUT url=/v1/agent/service/register from=127.0.0.1:36034 latency=2.075265ms
2020-09-11T09:59:31.290+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:59:31.290+0200 [DEBUG] agent: Service in sync: service=_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy
2020-09-11T09:59:31.290+0200 [DEBUG] agent: Service in sync: service=_nomad-task-4f11511e-782f-27e0-1480-c64812a66525-group-batch_with_connect-count-dashboard-9002
2020-09-11T09:59:31.290+0200 [DEBUG] agent: Service in sync: service=_nomad-task-4f11511e-782f-27e0-1480-c64812a66525-group-batch_with_connect-count-dashboard-9002-sidecar-proxy
2020-09-11T09:59:31.290+0200 [DEBUG] agent: Service in sync: service=_nomad-server-fz33pagtwooxkqtv6gi3oyjyl24h677x
2020-09-11T09:59:31.290+0200 [DEBUG] agent: Service in sync: service=_nomad-server-3sb5sairb37752ririfqx2phxkrlmuyt
2020-09-11T09:59:31.290+0200 [DEBUG] agent: Service in sync: service=_nomad-server-jm3k3ijq6qgcymz7xpjnyphrz5qi545i
2020-09-11T09:59:31.290+0200 [DEBUG] agent: Service in sync: service=_nomad-client-t7ol5wcczlsnwgayg7jezx52f477jwuq
2020-09-11T09:59:31.290+0200 [DEBUG] agent: Service in sync: service=_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001
2020-09-11T09:59:31.290+0200 [DEBUG] agent: Check in sync: check=_nomad-check-c40ca76a2fbc9326eef8fc932ec8dd5474fb1039
2020-09-11T09:59:31.290+0200 [DEBUG] agent: Check in sync: check=_nomad-check-524746cf99a9e59f7e67830cd745e33ff9472a5a
2020-09-11T09:59:31.290+0200 [DEBUG] agent: Check in sync: check=_nomad-check-d853f073d50e94c82017c7dd7dc62f1d3586ec0c
2020-09-11T09:59:31.290+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:1
2020-09-11T09:59:31.290+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:2
2020-09-11T09:59:31.290+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-4f11511e-782f-27e0-1480-c64812a66525-group-batch_with_connect-count-dashboard-9002-sidecar-proxy:1
2020-09-11T09:59:31.291+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-4f11511e-782f-27e0-1480-c64812a66525-group-batch_with_connect-count-dashboard-9002-sidecar-proxy:2
2020-09-11T09:59:31.291+0200 [DEBUG] agent: Check in sync: check=_nomad-check-ed863057181d8943bbd02a7a13e9bbffcad5920b
2020-09-11T09:59:31.291+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:59:31.291+0200 [DEBUG] agent: Service in sync: service=_nomad-client-t7ol5wcczlsnwgayg7jezx52f477jwuq
2020-09-11T09:59:31.291+0200 [DEBUG] agent: Service in sync: service=_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001
2020-09-11T09:59:31.291+0200 [DEBUG] agent: Service in sync: service=_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy
2020-09-11T09:59:31.291+0200 [DEBUG] agent: Service in sync: service=_nomad-task-4f11511e-782f-27e0-1480-c64812a66525-group-batch_with_connect-count-dashboard-9002
2020-09-11T09:59:31.291+0200 [DEBUG] agent: Service in sync: service=_nomad-task-4f11511e-782f-27e0-1480-c64812a66525-group-batch_with_connect-count-dashboard-9002-sidecar-proxy
2020-09-11T09:59:31.291+0200 [DEBUG] agent: Service in sync: service=_nomad-server-fz33pagtwooxkqtv6gi3oyjyl24h677x
2020-09-11T09:59:31.291+0200 [DEBUG] agent: Service in sync: service=_nomad-server-3sb5sairb37752ririfqx2phxkrlmuyt
2020-09-11T09:59:31.291+0200 [DEBUG] agent: Service in sync: service=_nomad-server-jm3k3ijq6qgcymz7xpjnyphrz5qi545i
2020-09-11T09:59:31.291+0200 [DEBUG] agent: Check in sync: check=_nomad-check-ed863057181d8943bbd02a7a13e9bbffcad5920b
2020-09-11T09:59:31.291+0200 [DEBUG] agent: Check in sync: check=_nomad-check-c40ca76a2fbc9326eef8fc932ec8dd5474fb1039
2020-09-11T09:59:31.291+0200 [DEBUG] agent: Check in sync: check=_nomad-check-524746cf99a9e59f7e67830cd745e33ff9472a5a
2020-09-11T09:59:31.291+0200 [DEBUG] agent: Check in sync: check=_nomad-check-d853f073d50e94c82017c7dd7dc62f1d3586ec0c
2020-09-11T09:59:31.291+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:1
2020-09-11T09:59:31.291+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:2
2020-09-11T09:59:31.291+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-4f11511e-782f-27e0-1480-c64812a66525-group-batch_with_connect-count-dashboard-9002-sidecar-proxy:1
2020-09-11T09:59:31.291+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-4f11511e-782f-27e0-1480-c64812a66525-group-batch_with_connect-count-dashboard-9002-sidecar-proxy:2
2020-09-11T09:59:31.291+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:59:31.291+0200 [DEBUG] agent: Service in sync: service=_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy
2020-09-11T09:59:31.291+0200 [DEBUG] agent: Service in sync: service=_nomad-task-4f11511e-782f-27e0-1480-c64812a66525-group-batch_with_connect-count-dashboard-9002
2020-09-11T09:59:31.291+0200 [DEBUG] agent: Service in sync: service=_nomad-task-4f11511e-782f-27e0-1480-c64812a66525-group-batch_with_connect-count-dashboard-9002-sidecar-proxy
2020-09-11T09:59:31.291+0200 [DEBUG] agent: Service in sync: service=_nomad-server-fz33pagtwooxkqtv6gi3oyjyl24h677x
2020-09-11T09:59:31.291+0200 [DEBUG] agent: Service in sync: service=_nomad-server-3sb5sairb37752ririfqx2phxkrlmuyt
2020-09-11T09:59:31.291+0200 [DEBUG] agent: Service in sync: service=_nomad-server-jm3k3ijq6qgcymz7xpjnyphrz5qi545i
2020-09-11T09:59:31.291+0200 [DEBUG] agent: Service in sync: service=_nomad-client-t7ol5wcczlsnwgayg7jezx52f477jwuq
2020-09-11T09:59:31.291+0200 [DEBUG] agent: Service in sync: service=_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001
2020-09-11T09:59:31.291+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:2
2020-09-11T09:59:31.291+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-4f11511e-782f-27e0-1480-c64812a66525-group-batch_with_connect-count-dashboard-9002-sidecar-proxy:1
2020-09-11T09:59:31.292+0200 [INFO] agent: Synced check: check=service:_nomad-task-4f11511e-782f-27e0-1480-c64812a66525-group-batch_with_connect-count-dashboard-9002-sidecar-proxy:2
2020-09-11T09:59:31.292+0200 [DEBUG] agent: Check in sync: check=_nomad-check-ed863057181d8943bbd02a7a13e9bbffcad5920b
2020-09-11T09:59:31.292+0200 [DEBUG] agent: Check in sync: check=_nomad-check-c40ca76a2fbc9326eef8fc932ec8dd5474fb1039
2020-09-11T09:59:31.292+0200 [DEBUG] agent: Check in sync: check=_nomad-check-524746cf99a9e59f7e67830cd745e33ff9472a5a
2020-09-11T09:59:31.292+0200 [DEBUG] agent: Check in sync: check=_nomad-check-d853f073d50e94c82017c7dd7dc62f1d3586ec0c
2020-09-11T09:59:31.292+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:1
2020-09-11T09:59:31.292+0200 [TRACE] agent.proxycfg: resetting watches for discovery chain: service_id=_nomad-task-4f11511e-782f-27e0-1480-c64812a66525-group-batch_with_connect-count-dashboard-9002-sidecar-proxy id=count-api
2020-09-11T09:59:31.292+0200 [TRACE] agent.proxycfg: initializing watch of target: service_id=_nomad-task-4f11511e-782f-27e0-1480-c64812a66525-group-batch_with_connect-count-dashboard-9002-sidecar-proxy upstream=count-api chain=count-api target=count-api.default.dc1 mesh-gateway-mode=
2020-09-11T09:59:31.339+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/services from=127.0.0.1:36134 latency=233.95µs
2020-09-11T09:59:31.341+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/service/_nomad-task-4f11511e-782f-27e0-1480-c64812a66525-group-batch_with_connect-count-dashboard-9002-sidecar-proxy from=127.0.0.1:36134 latency=203.509µs
2020-09-11T09:59:31.735+0200 [DEBUG] agent.envoy: generating cluster for: cluster=count-api.default.dc1.internal.14c86771-755a-b5e1-6ae8-626c52e24460.consul
2020-09-11T09:59:31.749+0200 [DEBUG] agent.envoy: generating endpoints for: cluster=count-api.default.dc1.internal.14c86771-755a-b5e1-6ae8-626c52e24460.consul
2020-09-11T09:59:32.221+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/services from=127.0.0.1:36034 latency=255.635µs
2020-09-11T09:59:32.222+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/checks from=127.0.0.1:36034 latency=194.086µs
2020-09-11T09:59:32.223+0200 [DEBUG] agent: removed service: service=_nomad-task-4f11511e-782f-27e0-1480-c64812a66525-group-batch_with_connect-count-dashboard-9002
2020-09-11T09:59:32.223+0200 [DEBUG] agent: removed check: check=service:_nomad-task-4f11511e-782f-27e0-1480-c64812a66525-group-batch_with_connect-count-dashboard-9002-sidecar-proxy:1
2020-09-11T09:59:32.223+0200 [ERROR] agent.proxycfg: watch error: service_id=_nomad-task-4f11511e-782f-27e0-1480-c64812a66525-group-batch_with_connect-count-dashboard-9002-sidecar-proxy id=service-http-checks:_nomad-task-4f11511e-782f-27e0-1480-c64812a66525-group-batch_with_connect-count-dashboard-9002 error="error filling agent cache: Internal cache failure: service '_nomad-task-4f11511e-782f-27e0-1480-c64812a66525-group-batch_with_connect-count-dashboard-9002' not in agent state"
2020-09-11T09:59:32.223+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:59:32.223+0200 [DEBUG] agent: Service in sync: service=_nomad-server-jm3k3ijq6qgcymz7xpjnyphrz5qi545i
2020-09-11T09:59:32.223+0200 [DEBUG] agent: Service in sync: service=_nomad-client-t7ol5wcczlsnwgayg7jezx52f477jwuq
2020-09-11T09:59:32.223+0200 [DEBUG] agent: Service in sync: service=_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001
2020-09-11T09:59:32.223+0200 [DEBUG] agent: Service in sync: service=_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy
2020-09-11T09:59:32.223+0200 [DEBUG] agent: removed check: check=service:_nomad-task-4f11511e-782f-27e0-1480-c64812a66525-group-batch_with_connect-count-dashboard-9002-sidecar-proxy:2
2020-09-11T09:59:32.223+0200 [DEBUG] agent: removed service: service=_nomad-task-4f11511e-782f-27e0-1480-c64812a66525-group-batch_with_connect-count-dashboard-9002-sidecar-proxy
2020-09-11T09:59:32.223+0200 [ERROR] agent.proxycfg: watch error: service_id=_nomad-task-4f11511e-782f-27e0-1480-c64812a66525-group-batch_with_connect-count-dashboard-9002-sidecar-proxy id=service-http-checks:_nomad-task-4f11511e-782f-27e0-1480-c64812a66525-group-batch_with_connect-count-dashboard-9002 error="error filling agent cache: Internal cache failure: service '_nomad-task-4f11511e-782f-27e0-1480-c64812a66525-group-batch_with_connect-count-dashboard-9002' not in agent state"
2020-09-11T09:59:32.223+0200 [INFO] agent: Deregistered service: service=_nomad-task-4f11511e-782f-27e0-1480-c64812a66525-group-batch_with_connect-count-dashboard-9002
2020-09-11T09:59:32.223+0200 [INFO] agent: Deregistered service: service=_nomad-task-4f11511e-782f-27e0-1480-c64812a66525-group-batch_with_connect-count-dashboard-9002-sidecar-proxy
2020-09-11T09:59:32.223+0200 [DEBUG] agent: Service in sync: service=_nomad-server-fz33pagtwooxkqtv6gi3oyjyl24h677x
2020-09-11T09:59:32.223+0200 [DEBUG] agent: Service in sync: service=_nomad-server-3sb5sairb37752ririfqx2phxkrlmuyt
2020-09-11T09:59:32.223+0200 [DEBUG] agent: Check in sync: check=_nomad-check-ed863057181d8943bbd02a7a13e9bbffcad5920b
2020-09-11T09:59:32.223+0200 [DEBUG] agent: Check in sync: check=_nomad-check-c40ca76a2fbc9326eef8fc932ec8dd5474fb1039
2020-09-11T09:59:32.223+0200 [DEBUG] agent: Check in sync: check=_nomad-check-524746cf99a9e59f7e67830cd745e33ff9472a5a
2020-09-11T09:59:32.223+0200 [DEBUG] agent: Check in sync: check=_nomad-check-d853f073d50e94c82017c7dd7dc62f1d3586ec0c
2020-09-11T09:59:32.223+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:1
2020-09-11T09:59:32.223+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:2
2020-09-11T09:59:32.223+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:59:32.223+0200 [DEBUG] agent: Service in sync: service=_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy
2020-09-11T09:59:32.223+0200 [DEBUG] agent: Service in sync: service=_nomad-server-fz33pagtwooxkqtv6gi3oyjyl24h677x
2020-09-11T09:59:32.223+0200 [DEBUG] agent: Service in sync: service=_nomad-server-3sb5sairb37752ririfqx2phxkrlmuyt
2020-09-11T09:59:32.223+0200 [DEBUG] agent: Service in sync: service=_nomad-server-jm3k3ijq6qgcymz7xpjnyphrz5qi545i
2020-09-11T09:59:32.223+0200 [DEBUG] agent: Service in sync: service=_nomad-client-t7ol5wcczlsnwgayg7jezx52f477jwuq
2020-09-11T09:59:32.223+0200 [DEBUG] agent: Service in sync: service=_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001
2020-09-11T09:59:32.223+0200 [DEBUG] agent: Check in sync: check=_nomad-check-c40ca76a2fbc9326eef8fc932ec8dd5474fb1039
2020-09-11T09:59:32.223+0200 [DEBUG] agent: Check in sync: check=_nomad-check-524746cf99a9e59f7e67830cd745e33ff9472a5a
2020-09-11T09:59:32.223+0200 [DEBUG] agent: Check in sync: check=_nomad-check-d853f073d50e94c82017c7dd7dc62f1d3586ec0c
2020-09-11T09:59:32.223+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:1
2020-09-11T09:59:32.223+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:2
2020-09-11T09:59:32.223+0200 [DEBUG] agent: Check in sync: check=_nomad-check-ed863057181d8943bbd02a7a13e9bbffcad5920b
2020-09-11T09:59:32.223+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:59:32.223+0200 [DEBUG] agent: Service in sync: service=_nomad-server-fz33pagtwooxkqtv6gi3oyjyl24h677x
2020-09-11T09:59:32.223+0200 [DEBUG] agent: Service in sync: service=_nomad-server-3sb5sairb37752ririfqx2phxkrlmuyt
2020-09-11T09:59:32.223+0200 [DEBUG] agent: Service in sync: service=_nomad-server-jm3k3ijq6qgcymz7xpjnyphrz5qi545i
2020-09-11T09:59:32.223+0200 [DEBUG] agent: Service in sync: service=_nomad-client-t7ol5wcczlsnwgayg7jezx52f477jwuq
2020-09-11T09:59:32.223+0200 [DEBUG] agent: Service in sync: service=_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001
2020-09-11T09:59:32.223+0200 [DEBUG] agent: Service in sync: service=_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy
2020-09-11T09:59:32.223+0200 [DEBUG] agent: Check in sync: check=_nomad-check-c40ca76a2fbc9326eef8fc932ec8dd5474fb1039
2020-09-11T09:59:32.223+0200 [DEBUG] agent: Check in sync: check=_nomad-check-524746cf99a9e59f7e67830cd745e33ff9472a5a
2020-09-11T09:59:32.223+0200 [DEBUG] agent: Check in sync: check=_nomad-check-d853f073d50e94c82017c7dd7dc62f1d3586ec0c
2020-09-11T09:59:32.223+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:1
2020-09-11T09:59:32.223+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:2
2020-09-11T09:59:32.223+0200 [DEBUG] agent: Check in sync: check=_nomad-check-ed863057181d8943bbd02a7a13e9bbffcad5920b
2020-09-11T09:59:32.223+0200 [DEBUG] agent.http: Request finished: method=PUT url=/v1/agent/service/deregister/_nomad-task-4f11511e-782f-27e0-1480-c64812a66525-group-batch_with_connect-count-dashboard-9002 from=127.0.0.1:36034 latency=880.702µs
2020-09-11T09:59:32.224+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:59:32.224+0200 [INFO] agent: Synced service: service=_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001
2020-09-11T09:59:32.224+0200 [INFO] agent: Synced service: service=_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy
2020-09-11T09:59:32.224+0200 [DEBUG] agent: Service in sync: service=_nomad-server-fz33pagtwooxkqtv6gi3oyjyl24h677x
2020-09-11T09:59:32.224+0200 [DEBUG] agent: Service in sync: service=_nomad-server-3sb5sairb37752ririfqx2phxkrlmuyt
2020-09-11T09:59:32.224+0200 [DEBUG] agent: Service in sync: service=_nomad-server-jm3k3ijq6qgcymz7xpjnyphrz5qi545i
2020-09-11T09:59:32.224+0200 [DEBUG] agent: Service in sync: service=_nomad-client-t7ol5wcczlsnwgayg7jezx52f477jwuq
2020-09-11T09:59:32.224+0200 [DEBUG] agent: Check in sync: check=_nomad-check-524746cf99a9e59f7e67830cd745e33ff9472a5a
2020-09-11T09:59:32.224+0200 [DEBUG] agent: Check in sync: check=_nomad-check-d853f073d50e94c82017c7dd7dc62f1d3586ec0c
2020-09-11T09:59:32.224+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:1
2020-09-11T09:59:32.224+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:2
2020-09-11T09:59:32.224+0200 [DEBUG] agent: Check in sync: check=_nomad-check-ed863057181d8943bbd02a7a13e9bbffcad5920b
2020-09-11T09:59:32.224+0200 [DEBUG] agent: Check in sync: check=_nomad-check-c40ca76a2fbc9326eef8fc932ec8dd5474fb1039
2020-09-11T09:59:32.224+0200 [DEBUG] agent.http: Request finished: method=PUT url=/v1/agent/service/register from=127.0.0.1:36034 latency=637.213µs
2020-09-11T09:59:32.224+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:59:32.224+0200 [DEBUG] agent: Service in sync: service=_nomad-client-t7ol5wcczlsnwgayg7jezx52f477jwuq
2020-09-11T09:59:32.224+0200 [DEBUG] agent: Service in sync: service=_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001
2020-09-11T09:59:32.224+0200 [DEBUG] agent: Service in sync: service=_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy
2020-09-11T09:59:32.224+0200 [DEBUG] agent: Service in sync: service=_nomad-server-fz33pagtwooxkqtv6gi3oyjyl24h677x
2020-09-11T09:59:32.224+0200 [DEBUG] agent: Service in sync: service=_nomad-server-3sb5sairb37752ririfqx2phxkrlmuyt
2020-09-11T09:59:32.224+0200 [DEBUG] agent: Service in sync: service=_nomad-server-jm3k3ijq6qgcymz7xpjnyphrz5qi545i
2020-09-11T09:59:32.224+0200 [DEBUG] agent: Check in sync: check=_nomad-check-524746cf99a9e59f7e67830cd745e33ff9472a5a
2020-09-11T09:59:32.224+0200 [DEBUG] agent: Check in sync: check=_nomad-check-d853f073d50e94c82017c7dd7dc62f1d3586ec0c
2020-09-11T09:59:32.224+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:1
2020-09-11T09:59:32.224+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:2
2020-09-11T09:59:32.224+0200 [DEBUG] agent: Check in sync: check=_nomad-check-ed863057181d8943bbd02a7a13e9bbffcad5920b
2020-09-11T09:59:32.224+0200 [DEBUG] agent: Check in sync: check=_nomad-check-c40ca76a2fbc9326eef8fc932ec8dd5474fb1039
2020-09-11T09:59:32.224+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:59:32.224+0200 [DEBUG] agent: Service in sync: service=_nomad-server-fz33pagtwooxkqtv6gi3oyjyl24h677x
2020-09-11T09:59:32.224+0200 [DEBUG] agent: Service in sync: service=_nomad-server-3sb5sairb37752ririfqx2phxkrlmuyt
2020-09-11T09:59:32.224+0200 [DEBUG] agent: Service in sync: service=_nomad-server-jm3k3ijq6qgcymz7xpjnyphrz5qi545i
2020-09-11T09:59:32.224+0200 [DEBUG] agent: Service in sync: service=_nomad-client-t7ol5wcczlsnwgayg7jezx52f477jwuq
2020-09-11T09:59:32.224+0200 [DEBUG] agent: Service in sync: service=_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001
2020-09-11T09:59:32.224+0200 [DEBUG] agent: Service in sync: service=_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy
2020-09-11T09:59:32.224+0200 [DEBUG] agent: Check in sync: check=_nomad-check-ed863057181d8943bbd02a7a13e9bbffcad5920b
2020-09-11T09:59:32.224+0200 [DEBUG] agent: Check in sync: check=_nomad-check-c40ca76a2fbc9326eef8fc932ec8dd5474fb1039
2020-09-11T09:59:32.224+0200 [DEBUG] agent: Check in sync: check=_nomad-check-524746cf99a9e59f7e67830cd745e33ff9472a5a
2020-09-11T09:59:32.224+0200 [DEBUG] agent: Check in sync: check=_nomad-check-d853f073d50e94c82017c7dd7dc62f1d3586ec0c
2020-09-11T09:59:32.224+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:1
2020-09-11T09:59:32.224+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:2
2020-09-11T09:59:32.225+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/services from=127.0.0.1:36034 latency=208.73µs
2020-09-11T09:59:32.225+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/checks from=127.0.0.1:36034 latency=126.113µs
2020-09-11T09:59:32.226+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:59:32.226+0200 [DEBUG] agent: Service in sync: service=_nomad-server-jm3k3ijq6qgcymz7xpjnyphrz5qi545i
2020-09-11T09:59:32.226+0200 [DEBUG] agent: Service in sync: service=_nomad-client-t7ol5wcczlsnwgayg7jezx52f477jwuq
2020-09-11T09:59:32.226+0200 [INFO] agent: Synced service: service=_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001
2020-09-11T09:59:32.226+0200 [INFO] agent: Synced service: service=_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy
2020-09-11T09:59:32.226+0200 [DEBUG] agent: Service in sync: service=_nomad-server-fz33pagtwooxkqtv6gi3oyjyl24h677x
2020-09-11T09:59:32.226+0200 [DEBUG] agent: Service in sync: service=_nomad-server-3sb5sairb37752ririfqx2phxkrlmuyt
2020-09-11T09:59:32.226+0200 [DEBUG] agent: Check in sync: check=_nomad-check-d853f073d50e94c82017c7dd7dc62f1d3586ec0c
2020-09-11T09:59:32.226+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:1
2020-09-11T09:59:32.226+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:2
2020-09-11T09:59:32.226+0200 [DEBUG] agent: Check in sync: check=_nomad-check-ed863057181d8943bbd02a7a13e9bbffcad5920b
2020-09-11T09:59:32.226+0200 [DEBUG] agent: Check in sync: check=_nomad-check-c40ca76a2fbc9326eef8fc932ec8dd5474fb1039
2020-09-11T09:59:32.226+0200 [DEBUG] agent: Check in sync: check=_nomad-check-524746cf99a9e59f7e67830cd745e33ff9472a5a
2020-09-11T09:59:32.226+0200 [DEBUG] agent.http: Request finished: method=PUT url=/v1/agent/service/register from=127.0.0.1:36034 latency=557.463µs
2020-09-11T09:59:32.226+0200 [DEBUG] agent: Node info in sync
2020-09-11T09:59:32.226+0200 [DEBUG] agent: Service in sync: service=_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001
2020-09-11T09:59:32.226+0200 [DEBUG] agent: Service in sync: service=_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy
2020-09-11T09:59:32.226+0200 [DEBUG] agent: Service in sync: service=_nomad-server-fz33pagtwooxkqtv6gi3oyjyl24h677x
2020-09-11T09:59:32.226+0200 [DEBUG] agent: Service in sync: service=_nomad-server-3sb5sairb37752ririfqx2phxkrlmuyt
2020-09-11T09:59:32.226+0200 [DEBUG] agent: Service in sync: service=_nomad-server-jm3k3ijq6qgcymz7xpjnyphrz5qi545i
2020-09-11T09:59:32.226+0200 [DEBUG] agent: Service in sync: service=_nomad-client-t7ol5wcczlsnwgayg7jezx52f477jwuq
2020-09-11T09:59:32.226+0200 [DEBUG] agent: Check in sync: check=_nomad-check-ed863057181d8943bbd02a7a13e9bbffcad5920b
2020-09-11T09:59:32.226+0200 [DEBUG] agent: Check in sync: check=_nomad-check-c40ca76a2fbc9326eef8fc932ec8dd5474fb1039
2020-09-11T09:59:32.226+0200 [DEBUG] agent: Check in sync: check=_nomad-check-524746cf99a9e59f7e67830cd745e33ff9472a5a
2020-09-11T09:59:32.226+0200 [DEBUG] agent: Check in sync: check=_nomad-check-d853f073d50e94c82017c7dd7dc62f1d3586ec0c
2020-09-11T09:59:32.226+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:1
2020-09-11T09:59:32.226+0200 [DEBUG] agent: Check in sync: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:2
2020-09-11T09:59:33.080+0200 [DEBUG] agent: Check status updated: check=service:_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001-sidecar-proxy:1 status=passing
2020-09-11T09:59:33.555+0200 [DEBUG] agent: Check status updated: check=_nomad-check-c40ca76a2fbc9326eef8fc932ec8dd5474fb1039 status=passing
2020-09-11T09:59:33.802+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/agent/self from=127.0.0.1:36144 latency=752.562µs
2020-09-11T09:59:34.588+0200 [DEBUG] agent.http: Request finished: method=GET url=/v1/internal/ui/services?dc=dc1&index=32 from=127.0.0.1:36152 latency=527.974µs
2020-09-11T09:59:35.098+0200 [DEBUG] agent: Check status updated: check=_nomad-check-ed863057181d8943bbd02a7a13e9bbffcad5920b status=passing
2020-09-11T09:59:37.264+0200 [INFO] agent: transport: loopyWriter.run returning. connection error: desc = "transport is closing"
==> No configuration files loaded
==> Starting Nomad agent...
==> Nomad agent configuration:
Advertise Addrs: HTTP: 192.168.1.19:4646; RPC: 192.168.1.19:4647; Serf: 192.168.1.19:4648
Bind Addrs: HTTP: 0.0.0.0:4646; RPC: 0.0.0.0:4647; Serf: 0.0.0.0:4648
Client: true
Log Level: TRACE
Region: global (DC: dc1)
Server: true
Version: 0.12.4
==> Nomad agent started! Log data will stream in below:
2020-09-11T09:58:54.036+0200 [TRACE] agent.plugin_loader.raw_exec: task event loop shutdown: plugin_dir=
2020-09-11T09:58:54.036+0200 [TRACE] agent.plugin_loader.exec: task event loop shutdown: plugin_dir=
2020-09-11T09:58:54.036+0200 [TRACE] agent.plugin_loader.java: task event loop shutdown: plugin_dir=
2020-09-11T09:58:54.036+0200 [TRACE] agent.plugin_loader.docker: task event loop shutdown: plugin_dir=
2020-09-11T09:58:54.036+0200 [TRACE] agent.plugin_loader.qemu: task event loop shutdown: plugin_dir=
2020-09-11T09:58:54.036+0200 [TRACE] agent.plugin_loader.qemu: task event loop shutdown: plugin_dir=
2020-09-11T09:58:54.036+0200 [TRACE] agent.plugin_loader.java: task event loop shutdown: plugin_dir=
2020-09-11T09:58:54.038+0200 [DEBUG] agent.plugin_loader.docker: using client connection initialized from environment: plugin_dir=
2020-09-11T09:58:54.038+0200 [DEBUG] agent.plugin_loader.docker: using client connection initialized from environment: plugin_dir=
2020-09-11T09:58:54.038+0200 [TRACE] agent.plugin_loader.docker: task event loop shutdown: plugin_dir=
2020-09-11T09:58:54.039+0200 [TRACE] agent.plugin_loader.raw_exec: task event loop shutdown: plugin_dir=
2020-09-11T09:58:54.039+0200 [INFO] agent: detected plugin: name=exec type=driver plugin_version=0.1.0
2020-09-11T09:58:54.039+0200 [INFO] agent: detected plugin: name=qemu type=driver plugin_version=0.1.0
2020-09-11T09:58:54.039+0200 [INFO] agent: detected plugin: name=java type=driver plugin_version=0.1.0
2020-09-11T09:58:54.039+0200 [INFO] agent: detected plugin: name=docker type=driver plugin_version=0.1.0
2020-09-11T09:58:54.039+0200 [TRACE] agent.plugin_loader.exec: task event loop shutdown: plugin_dir=
2020-09-11T09:58:54.039+0200 [INFO] agent: detected plugin: name=raw_exec type=driver plugin_version=0.1.0
2020-09-11T09:58:54.039+0200 [INFO] agent: detected plugin: name=nvidia-gpu type=device plugin_version=0.1.0
2020-09-11T09:58:54.041+0200 [INFO] nomad.raft: initial configuration: index=1 servers="[{Suffrage:Voter ID:192.168.1.19:4647 Address:192.168.1.19:4647}]"
2020-09-11T09:58:54.041+0200 [INFO] nomad.raft: entering follower state: follower="Node at 192.168.1.19:4647 [Follower]" leader=
2020-09-11T09:58:54.041+0200 [TRACE] consul.sync: Consul supports TLSSkipVerify
2020-09-11T09:58:54.041+0200 [TRACE] consul.sync: able to contact Consul
2020-09-11T09:58:54.042+0200 [INFO] nomad: serf: EventMemberJoin: actarus.global 192.168.1.19
2020-09-11T09:58:54.042+0200 [INFO] nomad: starting scheduling worker(s): num_workers=8 schedulers=[service, batch, system, _core]
2020-09-11T09:58:54.042+0200 [INFO] nomad: adding server: server="actarus.global (Addr: 192.168.1.19:4647) (DC: dc1)"
2020-09-11T09:58:54.042+0200 [INFO] client: using state directory: state_dir=/tmp/NomadClient169517970
2020-09-11T09:58:54.042+0200 [INFO] client: using alloc directory: alloc_dir=/tmp/NomadClient446473161
2020-09-11T09:58:54.045+0200 [DEBUG] client.fingerprint_mgr: built-in fingerprints: fingerprinters=[arch, bridge, cgroup, cni, consul, cpu, host, memory, network, nomad, signal, storage, vault, env_aws, env_gce]
2020-09-11T09:58:54.047+0200 [INFO] client.fingerprint_mgr.cgroup: cgroups are available
2020-09-11T09:58:54.047+0200 [DEBUG] client.fingerprint_mgr: CNI config dir is not set or does not exist, skipping: cni_config_dir=
2020-09-11T09:58:54.047+0200 [DEBUG] client.fingerprint_mgr: fingerprinting periodically: fingerprinter=cgroup period=15s
2020-09-11T09:58:54.051+0200 [DEBUG] consul.sync: sync complete: registered_services=3 deregistered_services=0 registered_checks=3 deregistered_checks=0
2020-09-11T09:58:54.053+0200 [INFO] client.fingerprint_mgr.consul: consul agent is available
2020-09-11T09:58:54.053+0200 [DEBUG] client.fingerprint_mgr: fingerprinting periodically: fingerprinter=consul period=15s
2020-09-11T09:58:54.055+0200 [DEBUG] client.fingerprint_mgr.cpu: detected cpu frequency: MHz=4000
2020-09-11T09:58:54.055+0200 [DEBUG] client.fingerprint_mgr.cpu: detected core count: cores=8
2020-09-11T09:58:54.064+0200 [DEBUG] client.fingerprint_mgr.network: link speed detected: interface=enp63s0u1u2 mbits=1000
2020-09-11T09:58:54.064+0200 [DEBUG] client.fingerprint_mgr.network: detected interface IP: interface=enp63s0u1u2 IP=192.168.1.19
2020-09-11T09:58:54.064+0200 [DEBUG] client.fingerprint_mgr.network: detected interface IP: interface=enp63s0u1u2 IP=2a01:cb19:64e:a400:1265:30ff:fed5:d31a
2020-09-11T09:58:54.067+0200 [WARN] client.fingerprint_mgr.network: unable to parse speed: path=/usr/bin/ethtool device=lo
2020-09-11T09:58:54.067+0200 [DEBUG] client.fingerprint_mgr.network: unable to read link speed: path=/sys/class/net/lo/speed
2020-09-11T09:58:54.067+0200 [DEBUG] client.fingerprint_mgr.network: link speed could not be detected, falling back to default speed: mbits=1000
2020-09-11T09:58:54.069+0200 [WARN] client.fingerprint_mgr.network: unable to parse speed: path=/usr/bin/ethtool device=wlp2s0
2020-09-11T09:58:54.069+0200 [DEBUG] client.fingerprint_mgr.network: unable to read link speed: path=/sys/class/net/wlp2s0/speed
2020-09-11T09:58:54.069+0200 [DEBUG] client.fingerprint_mgr.network: link speed could not be detected, falling back to default speed: mbits=1000
2020-09-11T09:58:54.079+0200 [WARN] client.fingerprint_mgr.network: unable to parse speed: path=/usr/bin/ethtool device=docker0
2020-09-11T09:58:54.079+0200 [DEBUG] client.fingerprint_mgr.network: unable to parse link speed: path=/sys/class/net/docker0/speed
2020-09-11T09:58:54.079+0200 [DEBUG] client.fingerprint_mgr.network: link speed could not be detected, falling back to default speed: mbits=1000
2020-09-11T09:58:54.081+0200 [WARN] client.fingerprint_mgr.network: unable to parse speed: path=/usr/bin/ethtool device=nomad
2020-09-11T09:58:54.081+0200 [DEBUG] client.fingerprint_mgr.network: unable to parse link speed: path=/sys/class/net/nomad/speed
2020-09-11T09:58:54.081+0200 [DEBUG] client.fingerprint_mgr.network: link speed could not be detected, falling back to default speed: mbits=1000
2020-09-11T09:58:54.084+0200 [DEBUG] client.fingerprint_mgr: fingerprinting periodically: fingerprinter=vault period=15s
2020-09-11T09:58:55.389+0200 [WARN] nomad.raft: heartbeat timeout reached, starting election: last-leader=
2020-09-11T09:58:55.389+0200 [INFO] nomad.raft: entering candidate state: node="Node at 192.168.1.19:4647 [Candidate]" term=2
2020-09-11T09:58:55.389+0200 [DEBUG] nomad.raft: votes: needed=1
2020-09-11T09:58:55.389+0200 [DEBUG] nomad.raft: vote granted: from=192.168.1.19:4647 term=2 tally=1
2020-09-11T09:58:55.389+0200 [INFO] nomad.raft: election won: tally=1
2020-09-11T09:58:55.389+0200 [INFO] nomad.raft: entering leader state: leader="Node at 192.168.1.19:4647 [Leader]"
2020-09-11T09:58:55.389+0200 [INFO] nomad: cluster leadership acquired
2020-09-11T09:58:55.391+0200 [TRACE] nomad.fsm: ClusterSetMetadata: cluster_id=fd11f8c3-b7c0-dabe-0872-45e33e97bded create_time=1599811135391522887
2020-09-11T09:58:55.392+0200 [INFO] nomad.core: established cluster id: cluster_id=fd11f8c3-b7c0-dabe-0872-45e33e97bded create_time=1599811135391522887
2020-09-11T09:58:55.392+0200 [TRACE] nomad.drain.job_watcher: getting job allocs at index: index=1
2020-09-11T09:59:00.085+0200 [DEBUG] client.fingerprint_mgr.env_gce: could not read value for attribute: attribute=machine-type error="Get "http://169.254.169.254/computeMetadata/v1/instance/machine-type": context deadline exceeded (Client.Timeout exceeded while awaiting headers)"
2020-09-11T09:59:00.085+0200 [DEBUG] client.fingerprint_mgr.env_gce: error querying GCE Metadata URL, skipping
2020-09-11T09:59:00.085+0200 [DEBUG] client.fingerprint_mgr: detected fingerprints: node_attrs=[arch, bridge, cgroup, consul, cpu, host, network, nomad, signal, storage]
2020-09-11T09:59:00.086+0200 [INFO] client.plugin: starting plugin manager: plugin-type=csi
2020-09-11T09:59:00.086+0200 [INFO] client.plugin: starting plugin manager: plugin-type=driver
2020-09-11T09:59:00.086+0200 [INFO] client.plugin: starting plugin manager: plugin-type=device
2020-09-11T09:59:00.086+0200 [DEBUG] client.plugin: waiting on plugin manager initial fingerprint: plugin-type=driver
2020-09-11T09:59:00.086+0200 [DEBUG] client.plugin: waiting on plugin manager initial fingerprint: plugin-type=device
2020-09-11T09:59:00.086+0200 [DEBUG] client.driver_mgr: initial driver fingerprint: driver=raw_exec health=healthy description=Healthy
2020-09-11T09:59:00.088+0200 [TRACE] client.device_mgr: exiting since fingerprinting gracefully shutdown: plugin=nvidia-gpu
2020-09-11T09:59:00.088+0200 [DEBUG] client.plugin: finished plugin manager initial fingerprint: plugin-type=device
2020-09-11T09:59:00.091+0200 [DEBUG] client.driver_mgr: initial driver fingerprint: driver=exec health=healthy description=Healthy
2020-09-11T09:59:00.093+0200 [DEBUG] client.server_mgr: new server list: new_servers=[0.0.0.0:4647, 192.168.1.19:4647] old_servers=[]
2020-09-11T09:59:00.127+0200 [DEBUG] client.driver_mgr: initial driver fingerprint: driver=qemu health=healthy description=Healthy
2020-09-11T09:59:00.145+0200 [DEBUG] client.driver_mgr: initial driver fingerprint: driver=docker health=healthy description=Healthy
2020-09-11T09:59:00.149+0200 [DEBUG] client.driver_mgr: initial driver fingerprint: driver=java health=healthy description=Healthy
2020-09-11T09:59:00.149+0200 [DEBUG] client.driver_mgr: detected drivers: drivers="map[healthy:[raw_exec exec qemu docker java]]"
2020-09-11T09:59:00.149+0200 [DEBUG] client.plugin: finished plugin manager initial fingerprint: plugin-type=driver
2020-09-11T09:59:00.149+0200 [INFO] client: started client: node_id=abd15a12-408f-346e-2a0f-e6c45a185a06
2020-09-11T09:59:00.150+0200 [DEBUG] client: updated allocations: index=1 total=0 pulled=0 filtered=0
2020-09-11T09:59:00.150+0200 [DEBUG] client: allocation updates: added=0 removed=0 updated=0 ignored=0
2020-09-11T09:59:00.150+0200 [DEBUG] client: allocation updates applied: added=0 removed=0 updated=0 ignored=0 errors=0
2020-09-11T09:59:00.150+0200 [INFO] client: node registration complete
2020-09-11T09:59:00.150+0200 [TRACE] client: next heartbeat: period=11.059552242s
2020-09-11T09:59:00.150+0200 [DEBUG] client: state updated: node_status=ready
2020-09-11T09:59:00.150+0200 [DEBUG] client.server_mgr: new server list: new_servers=[192.168.1.19:4647] old_servers=[0.0.0.0:4647, 192.168.1.19:4647]
2020-09-11T09:59:00.152+0200 [DEBUG] consul.sync: sync complete: registered_services=1 deregistered_services=0 registered_checks=1 deregistered_checks=0
2020-09-11T09:59:01.150+0200 [DEBUG] client: state changed, updating node and re-registering
2020-09-11T09:59:01.153+0200 [INFO] client: node registration complete
2020-09-11T09:59:01.153+0200 [TRACE] client: next heartbeat: period=13.128368016s
2020-09-11T09:59:03.553+0200 [DEBUG] nomad: memberlist: Stream connection from=127.0.0.1:52930
2020-09-11T09:59:03.640+0200 [TRACE] nomad.job: job mutate results: mutator=canonicalize warnings=[] error=<nil>
2020-09-11T09:59:03.640+0200 [TRACE] nomad.job: job mutate results: mutator=connect warnings=[] error=<nil>
2020-09-11T09:59:03.640+0200 [TRACE] nomad.job: job mutate results: mutator=expose-check warnings=[] error=<nil>
2020-09-11T09:59:03.640+0200 [TRACE] nomad.job: job mutate results: mutator=constraints warnings=[] error=<nil>
2020-09-11T09:59:03.640+0200 [TRACE] nomad.job: job validate results: validator=connect warnings=[] error=<nil>
2020-09-11T09:59:03.640+0200 [TRACE] nomad.job: job validate results: validator=expose-check warnings=[] error=<nil>
2020-09-11T09:59:03.640+0200 [TRACE] nomad.job: job validate results: validator=validate warnings=[] error=<nil>
2020-09-11T09:59:03.641+0200 [DEBUG] worker: dequeued evaluation: eval_id=95e22d6e-1b54-ab76-3bd3-bce8c6663fd5
2020-09-11T09:59:03.641+0200 [TRACE] worker.service_sched.binpack: NewBinPackIterator created: eval_id=95e22d6e-1b54-ab76-3bd3-bce8c6663fd5 job_id=countdash namespace=default algorithm=binpack
2020-09-11T09:59:03.641+0200 [DEBUG] http: request complete: method=PUT path=/v1/jobs duration=2.25325ms
2020-09-11T09:59:03.641+0200 [DEBUG] worker.service_sched: reconciled current state with desired state: eval_id=95e22d6e-1b54-ab76-3bd3-bce8c6663fd5 job_id=countdash namespace=default results="Total changes: (place 1) (destructive 0) (inplace 0) (stop 0)
Created Deployment: "040aea76-eb1e-a978-4566-b5d34416595e"
Desired Changes for "api": (place 1) (inplace 0) (destructive 0) (stop 0) (migrate 0) (ignore 0) (canary 0)"
2020-09-11T09:59:03.641+0200 [DEBUG] http: request complete: method=GET path=/v1/evaluation/95e22d6e-1b54-ab76-3bd3-bce8c6663fd5 duration=133.207µs
2020-09-11T09:59:03.642+0200 [DEBUG] worker: submitted plan for evaluation: eval_id=95e22d6e-1b54-ab76-3bd3-bce8c6663fd5
2020-09-11T09:59:03.642+0200 [DEBUG] worker.service_sched: setting eval status: eval_id=95e22d6e-1b54-ab76-3bd3-bce8c6663fd5 job_id=countdash namespace=default status=complete
2020-09-11T09:59:03.642+0200 [DEBUG] worker: updated evaluation: eval="<Eval "95e22d6e-1b54-ab76-3bd3-bce8c6663fd5" JobID: "countdash" Namespace: "default">"
2020-09-11T09:59:03.642+0200 [DEBUG] worker: ack evaluation: eval_id=95e22d6e-1b54-ab76-3bd3-bce8c6663fd5
2020-09-11T09:59:03.642+0200 [DEBUG] client: updated allocations: index=11 total=1 pulled=1 filtered=0
2020-09-11T09:59:03.642+0200 [TRACE] client: next heartbeat: period=10.745928481s
2020-09-11T09:59:03.642+0200 [DEBUG] client: allocation updates: added=1 removed=0 updated=0 ignored=0
2020-09-11T09:59:03.642+0200 [DEBUG] http: request complete: method=GET path=/v1/evaluation/95e22d6e-1b54-ab76-3bd3-bce8c6663fd5/allocations duration=153.674µs
2020-09-11T09:59:03.643+0200 [DEBUG] client: allocation updates applied: added=1 removed=0 updated=0 ignored=0 errors=0
2020-09-11T09:59:03.643+0200 [TRACE] client.alloc_runner: running pre-run hooks: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 start="2020-09-11 09:59:03.643491763 +0200 CEST m=+9.717437151"
2020-09-11T09:59:03.643+0200 [TRACE] client.alloc_runner: running pre-run hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 name=alloc_dir start="2020-09-11 09:59:03.643533154 +0200 CEST m=+9.717478526"
2020-09-11T09:59:03.643+0200 [TRACE] client.alloc_runner: finished pre-run hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 name=alloc_dir end="2020-09-11 09:59:03.643669901 +0200 CEST m=+9.717615270" duration=136.744µs
2020-09-11T09:59:03.643+0200 [TRACE] client.alloc_runner: running pre-run hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 name=await_previous_allocations start="2020-09-11 09:59:03.643684961 +0200 CEST m=+9.717630332"
2020-09-11T09:59:03.643+0200 [TRACE] client.alloc_runner: finished pre-run hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 name=await_previous_allocations end="2020-09-11 09:59:03.643695288 +0200 CEST m=+9.717640658" duration=10.326µs
2020-09-11T09:59:03.643+0200 [TRACE] client.alloc_runner: running pre-run hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 name=migrate_disk start="2020-09-11 09:59:03.643705466 +0200 CEST m=+9.717650835"
2020-09-11T09:59:03.643+0200 [TRACE] client.alloc_runner: finished pre-run hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 name=migrate_disk end="2020-09-11 09:59:03.643712669 +0200 CEST m=+9.717658038" duration=7.203µs
2020-09-11T09:59:03.643+0200 [TRACE] client.alloc_runner: running pre-run hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 name=alloc_health_watcher start="2020-09-11 09:59:03.643725845 +0200 CEST m=+9.717671214"
2020-09-11T09:59:03.643+0200 [TRACE] client.alloc_runner.runner_hook.alloc_health_watcher: watching: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 deadline="2020-09-11 10:04:03.643733371 +0200 CEST m=+309.717678741" checks=true min_healthy_time=10s
2020-09-11T09:59:03.643+0200 [TRACE] client.alloc_runner: finished pre-run hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 name=alloc_health_watcher end="2020-09-11 09:59:03.643754104 +0200 CEST m=+9.717699481" duration=28.267µs
2020-09-11T09:59:03.643+0200 [TRACE] client.alloc_runner: running pre-run hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 name=network start="2020-09-11 09:59:03.643764169 +0200 CEST m=+9.717709537"
2020-09-11T09:59:04.229+0200 [DEBUG] client.driver_mgr.docker: docker pull succeeded: driver=docker image_ref=gcr.io/google_containers/pause-amd64:3.0
2020-09-11T09:59:04.231+0200 [DEBUG] client.driver_mgr.docker: image reference count incremented: driver=docker image_name=gcr.io/google_containers/pause-amd64:3.0 image_id=sha256:99e59f495ffaa222bfeb67580213e8c28c1e885f1d245ab2bbe3b1b1ec3bd0b2 references=1
2020-09-11T09:59:04.644+0200 [DEBUG] http: request complete: method=GET path=/v1/evaluation/95e22d6e-1b54-ab76-3bd3-bce8c6663fd5 duration=469.071µs
2020-09-11T09:59:04.645+0200 [DEBUG] http: request complete: method=GET path=/v1/evaluation/95e22d6e-1b54-ab76-3bd3-bce8c6663fd5/allocations duration=169.683µs
2020-09-11T09:59:04.997+0200 [TRACE] client.alloc_runner: finished pre-run hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 name=network end="2020-09-11 09:59:04.997680583 +0200 CEST m=+11.071626015" duration=1.353916478s
2020-09-11T09:59:04.997+0200 [TRACE] client.alloc_runner: running pre-run hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 name=group_services start="2020-09-11 09:59:04.997730119 +0200 CEST m=+11.071675516"
2020-09-11T09:59:04.997+0200 [TRACE] client.alloc_runner: finished pre-run hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 name=group_services end="2020-09-11 09:59:04.997832389 +0200 CEST m=+11.071777785" duration=102.269µs
2020-09-11T09:59:04.997+0200 [TRACE] client.alloc_runner: running pre-run hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 name=consul_grpc_socket start="2020-09-11 09:59:04.997853872 +0200 CEST m=+11.071799270"
2020-09-11T09:59:04.997+0200 [TRACE] client.alloc_runner: finished pre-run hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 name=consul_grpc_socket end="2020-09-11 09:59:04.997960844 +0200 CEST m=+11.071906247" duration=106.977µs
2020-09-11T09:59:04.997+0200 [TRACE] client.alloc_runner: running pre-run hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 name=consul_http_socket start="2020-09-11 09:59:04.99799713 +0200 CEST m=+11.071942536"
2020-09-11T09:59:04.998+0200 [TRACE] client.alloc_runner: finished pre-run hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 name=consul_http_socket end="2020-09-11 09:59:04.998018447 +0200 CEST m=+11.071963848" duration=21.312µs
2020-09-11T09:59:04.998+0200 [TRACE] client.alloc_runner: running pre-run hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 name=csi_hook start="2020-09-11 09:59:04.998037695 +0200 CEST m=+11.071983090"
2020-09-11T09:59:04.998+0200 [TRACE] client.alloc_runner: finished pre-run hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 name=csi_hook end="2020-09-11 09:59:04.998051065 +0200 CEST m=+11.071996462" duration=13.372µs
2020-09-11T09:59:04.998+0200 [TRACE] client.alloc_runner: finished pre-run hooks: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 end="2020-09-11 09:59:04.998063244 +0200 CEST m=+11.072008641" duration=1.35457149s
2020-09-11T09:59:04.998+0200 [TRACE] client.alloc_runner.task_runner: running prestart hooks: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=connect-proxy-count-api start="2020-09-11 09:59:04.998130125 +0200 CEST m=+11.072075548"
2020-09-11T09:59:04.998+0200 [TRACE] client.alloc_runner.task_runner: running prestart hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=connect-proxy-count-api name=validate start="2020-09-11 09:59:04.998235608 +0200 CEST m=+11.072181022"
2020-09-11T09:59:04.998+0200 [TRACE] client.alloc_runner.task_runner: finished prestart hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=connect-proxy-count-api name=validate end="2020-09-11 09:59:04.998287744 +0200 CEST m=+11.072233189" duration=52.167µs
2020-09-11T09:59:04.998+0200 [TRACE] client.alloc_runner.task_runner: running prestart hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=connect-proxy-count-api name=task_dir start="2020-09-11 09:59:04.998360662 +0200 CEST m=+11.072306064"
2020-09-11T09:59:04.998+0200 [TRACE] client.alloc_runner: handling task state update: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 done=false
2020-09-11T09:59:04.998+0200 [TRACE] client.alloc_runner: sending updated alloc: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 client_status=pending desired_status=
2020-09-11T09:59:04.998+0200 [TRACE] client.alloc_runner.task_runner: finished prestart hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=connect-proxy-count-api name=task_dir end="2020-09-11 09:59:04.998940949 +0200 CEST m=+11.072886400" duration=580.336µs
2020-09-11T09:59:04.999+0200 [TRACE] client.alloc_runner.task_runner: running prestart hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=connect-proxy-count-api name=logmon start="2020-09-11 09:59:04.999050805 +0200 CEST m=+11.072996273"
2020-09-11T09:59:04.999+0200 [DEBUG] client.alloc_runner.task_runner.task_hook.logmon: starting plugin: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=connect-proxy-count-api path=/usr/bin/nomad args=[/usr/bin/nomad, logmon]
2020-09-11T09:59:04.999+0200 [DEBUG] client.alloc_runner.task_runner.task_hook.logmon: plugin started: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=connect-proxy-count-api path=/usr/bin/nomad pid=101897
2020-09-11T09:59:04.999+0200 [DEBUG] client.alloc_runner.task_runner.task_hook.logmon: waiting for RPC address: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=connect-proxy-count-api path=/usr/bin/nomad
2020-09-11T09:59:05.007+0200 [DEBUG] consul.sync: sync complete: registered_services=1 deregistered_services=0 registered_checks=0 deregistered_checks=0
2020-09-11T09:59:05.011+0200 [DEBUG] client.alloc_runner.task_runner.task_hook.logmon.nomad: plugin address: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=connect-proxy-count-api @module=logmon address=/tmp/plugin148671332 network=unix timestamp=2020-09-11T09:59:05.010+0200
2020-09-11T09:59:05.011+0200 [DEBUG] client.alloc_runner.task_runner.task_hook.logmon: using plugin: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=connect-proxy-count-api version=2
2020-09-11T09:59:05.013+0200 [INFO] client.alloc_runner.task_runner.task_hook.logmon.nomad: opening fifo: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=connect-proxy-count-api @module=logmon path=/tmp/NomadClient446473161/28986c86-fe5e-e772-e2e6-cc2096d6a1c0/alloc/logs/.connect-proxy-count-api.stdout.fifo timestamp=2020-09-11T09:59:05.013+0200
2020-09-11T09:59:05.013+0200 [INFO] client.alloc_runner.task_runner.task_hook.logmon.nomad: opening fifo: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=connect-proxy-count-api @module=logmon path=/tmp/NomadClient446473161/28986c86-fe5e-e772-e2e6-cc2096d6a1c0/alloc/logs/.connect-proxy-count-api.stderr.fifo timestamp=2020-09-11T09:59:05.013+0200
2020-09-11T09:59:05.013+0200 [TRACE] client.alloc_runner.task_runner: finished prestart hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=connect-proxy-count-api name=logmon end="2020-09-11 09:59:05.013841505 +0200 CEST m=+11.087786939" duration=14.790666ms
2020-09-11T09:59:05.013+0200 [TRACE] client.alloc_runner.task_runner: running prestart hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=connect-proxy-count-api name=dispatch_payload start="2020-09-11 09:59:05.013920027 +0200 CEST m=+11.087865439"
2020-09-11T09:59:05.013+0200 [TRACE] client.alloc_runner.task_runner: finished prestart hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=connect-proxy-count-api name=dispatch_payload end="2020-09-11 09:59:05.013947351 +0200 CEST m=+11.087892762" duration=27.323µs
2020-09-11T09:59:05.013+0200 [TRACE] client.alloc_runner.task_runner: running prestart hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=connect-proxy-count-api name=volumes start="2020-09-11 09:59:05.013987922 +0200 CEST m=+11.087933308"
2020-09-11T09:59:05.014+0200 [TRACE] client.alloc_runner.task_runner: finished prestart hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=connect-proxy-count-api name=volumes end="2020-09-11 09:59:05.014005095 +0200 CEST m=+11.087950479" duration=17.171µs
2020-09-11T09:59:05.014+0200 [TRACE] client.alloc_runner.task_runner: running prestart hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=connect-proxy-count-api name=artifacts start="2020-09-11 09:59:05.014042355 +0200 CEST m=+11.087987745"
2020-09-11T09:59:05.014+0200 [TRACE] client.alloc_runner.task_runner: finished prestart hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=connect-proxy-count-api name=artifacts end="2020-09-11 09:59:05.014056563 +0200 CEST m=+11.088001948" duration=14.203µs
2020-09-11T09:59:05.014+0200 [TRACE] client.alloc_runner.task_runner: running prestart hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=connect-proxy-count-api name=devices start="2020-09-11 09:59:05.014091961 +0200 CEST m=+11.088037345"
2020-09-11T09:59:05.014+0200 [TRACE] client.alloc_runner.task_runner: finished prestart hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=connect-proxy-count-api name=devices end="2020-09-11 09:59:05.014106269 +0200 CEST m=+11.088051655" duration=14.31µs
2020-09-11T09:59:05.014+0200 [TRACE] client.alloc_runner.task_runner: running prestart hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=connect-proxy-count-api name=envoy_bootstrap start="2020-09-11 09:59:05.014142345 +0200 CEST m=+11.088087727"
2020-09-11T09:59:05.014+0200 [DEBUG] client.alloc_runner.task_runner.task_hook.envoy_bootstrap: bootstrapping Consul connect-proxy: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=connect-proxy-count-api task=connect-proxy-count-api service=count-api
2020-09-11T09:59:05.014+0200 [TRACE] client.alloc_runner.task_runner.task_hook.envoy_bootstrap: no SI token to load: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=connect-proxy-count-api task=connect-proxy-count-api
2020-09-11T09:59:05.014+0200 [DEBUG] client.alloc_runner.task_runner.task_hook.envoy_bootstrap: check for SI token for task: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=connect-proxy-count-api task=connect-proxy-count-api exists=false
2020-09-11T09:59:05.014+0200 [DEBUG] client.alloc_runner.task_runner.task_hook.envoy_bootstrap: bootstrapping envoy: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=connect-proxy-count-api sidecar_for=count-api bootstrap_file=/tmp/NomadClient446473161/28986c86-fe5e-e772-e2e6-cc2096d6a1c0/connect-proxy-count-api/secrets/envoy_bootstrap.json sidecar_for_id=_nomad-task-28986c86-fe5e-e772-e2e6-cc2096d6a1c0-group-api-count-api-9001 grpc_addr=unix://alloc/tmp/consul_grpc.sock admin_bind=localhost:19001 gateway=
2020-09-11T09:59:05.058+0200 [TRACE] client.alloc_runner.task_runner: finished prestart hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=connect-proxy-count-api name=envoy_bootstrap end="2020-09-11 09:59:05.058712611 +0200 CEST m=+11.132657980" duration=44.570253ms
2020-09-11T09:59:05.058+0200 [TRACE] client.alloc_runner.task_runner: running prestart hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=connect-proxy-count-api name=script_checks start="2020-09-11 09:59:05.058780458 +0200 CEST m=+11.132725831"
2020-09-11T09:59:05.058+0200 [TRACE] client.alloc_runner.task_runner: finished prestart hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=connect-proxy-count-api name=script_checks end="2020-09-11 09:59:05.058798264 +0200 CEST m=+11.132743631" duration=17.8µs
2020-09-11T09:59:05.058+0200 [TRACE] client.alloc_runner.task_runner: finished prestart hooks: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=connect-proxy-count-api end="2020-09-11 09:59:05.058806421 +0200 CEST m=+11.132751789" duration=60.676241ms
2020-09-11T09:59:05.060+0200 [DEBUG] client.driver_mgr.docker: image reference count incremented: driver=docker image_name=envoyproxy/envoy:v1.11.2@sha256:a7769160c9c1a55bb8d07a3b71ce5d64f72b1f665f10d81aa1581bc3cf850d09 image_id=sha256:72e91d8680d853b874d9aedda3a4b61048630d2043dd490ff36f5b0929f69874 references=1
2020-09-11T09:59:05.060+0200 [TRACE] client.driver_mgr.docker: binding volumes: driver=docker task_name=connect-proxy-count-api volumes=[/tmp/NomadClient446473161/28986c86-fe5e-e772-e2e6-cc2096d6a1c0/alloc:/alloc, /tmp/NomadClient446473161/28986c86-fe5e-e772-e2e6-cc2096d6a1c0/connect-proxy-count-api/local:/local, /tmp/NomadClient446473161/28986c86-fe5e-e772-e2e6-cc2096d6a1c0/connect-proxy-count-api/secrets:/secrets]
2020-09-11T09:59:05.060+0200 [TRACE] client.driver_mgr.docker: no docker log driver provided, defaulting to json-file: driver=docker task_name=connect-proxy-count-api
2020-09-11T09:59:05.060+0200 [DEBUG] client.driver_mgr.docker: configured resources: driver=docker task_name=connect-proxy-count-api memory=134217728 memory_reservation=0 cpu_shares=250 cpu_quota=0 cpu_period=0
2020-09-11T09:59:05.060+0200 [DEBUG] client.driver_mgr.docker: binding directories: driver=docker task_name=connect-proxy-count-api binds="[]string{"/tmp/NomadClient446473161/28986c86-fe5e-e772-e2e6-cc2096d6a1c0/alloc:/alloc", "/tmp/NomadClient446473161/28986c86-fe5e-e772-e2e6-cc2096d6a1c0/connect-proxy-count-api/local:/local", "/tmp/NomadClient446473161/28986c86-fe5e-e772-e2e6-cc2096d6a1c0/connect-proxy-count-api/secrets:/secrets"}"
2020-09-11T09:59:05.060+0200 [DEBUG] client.driver_mgr.docker: configuring network mode for task group: driver=docker task_name=connect-proxy-count-api network_mode=container:665070ee7c936c9ce49e324ea7a2d2f7f1b302c7ecd3d050f4d610edd58c3242
2020-09-11T09:59:05.060+0200 [DEBUG] client.driver_mgr.docker: applied labels on the container: driver=docker task_name=connect-proxy-count-api labels=map[com.hashicorp.nomad.alloc_id:28986c86-fe5e-e772-e2e6-cc2096d6a1c0]
2020-09-11T09:59:05.060+0200 [DEBUG] client.driver_mgr.docker: setting container name: driver=docker task_name=connect-proxy-count-api container_name=connect-proxy-count-api-28986c86-fe5e-e772-e2e6-cc2096d6a1c0
2020-09-11T09:59:05.111+0200 [INFO] client.driver_mgr.docker: created container: driver=docker container_id=c451da8511d933ac8cbd4791aee7226be9d6967e497cc3cf3f5679cd08a32e60
2020-09-11T09:59:05.200+0200 [DEBUG] client: updated allocations: index=13 total=1 pulled=0 filtered=1
2020-09-11T09:59:05.200+0200 [DEBUG] client: allocation updates: added=0 removed=0 updated=0 ignored=1
2020-09-11T09:59:05.200+0200 [DEBUG] client: allocation updates applied: added=0 removed=0 updated=0 ignored=1 errors=0
2020-09-11T09:59:05.200+0200 [TRACE] client: next heartbeat: period=19.335569839s
2020-09-11T09:59:05.394+0200 [INFO] client.driver_mgr.docker: started container: driver=docker container_id=c451da8511d933ac8cbd4791aee7226be9d6967e497cc3cf3f5679cd08a32e60
2020-09-11T09:59:05.394+0200 [DEBUG] client.driver_mgr.docker.docker_logger: starting plugin: driver=docker path=/usr/bin/nomad args=[/usr/bin/nomad, docker_logger]
2020-09-11T09:59:05.394+0200 [DEBUG] client.driver_mgr.docker.docker_logger: plugin started: driver=docker path=/usr/bin/nomad pid=101951
2020-09-11T09:59:05.394+0200 [DEBUG] client.driver_mgr.docker.docker_logger: waiting for RPC address: driver=docker path=/usr/bin/nomad
2020-09-11T09:59:05.399+0200 [DEBUG] client.driver_mgr.docker.docker_logger.nomad: plugin address: driver=docker @module=docker_logger address=/tmp/plugin275887368 network=unix timestamp=2020-09-11T09:59:05.399+0200
2020-09-11T09:59:05.399+0200 [DEBUG] client.driver_mgr.docker.docker_logger: using plugin: driver=docker version=2
2020-09-11T09:59:05.400+0200 [DEBUG] client.driver_mgr.docker.docker_logger.nomad: using client connection initialized from environment: driver=docker @module=docker_logger timestamp=2020-09-11T09:59:05.400+0200
2020-09-11T09:59:05.400+0200 [TRACE] client.alloc_runner.task_runner: setting task state: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=connect-proxy-count-api state=running event=Started
2020-09-11T09:59:05.400+0200 [TRACE] client.alloc_runner.task_runner: running poststart hooks: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=connect-proxy-count-api start="2020-09-11 09:59:05.400331852 +0200 CEST m=+11.474277217"
2020-09-11T09:59:05.400+0200 [TRACE] client.alloc_runner.task_runner: running poststart hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=connect-proxy-count-api name=stats_hook start="2020-09-11 09:59:05.400350161 +0200 CEST m=+11.474295530"
2020-09-11T09:59:05.400+0200 [TRACE] client.alloc_runner.task_runner: finished poststart hooks: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=connect-proxy-count-api name=stats_hook end="2020-09-11 09:59:05.400388766 +0200 CEST m=+11.474334142" duration=38.612µs
2020-09-11T09:59:05.400+0200 [TRACE] client.alloc_runner.task_runner: running poststart hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=connect-proxy-count-api name=script_checks start="2020-09-11 09:59:05.400401228 +0200 CEST m=+11.474346597"
2020-09-11T09:59:05.400+0200 [TRACE] client.alloc_runner.task_runner: finished poststart hooks: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=connect-proxy-count-api name=script_checks end="2020-09-11 09:59:05.400439978 +0200 CEST m=+11.474385343" duration=38.746µs
2020-09-11T09:59:05.400+0200 [TRACE] client.alloc_runner.task_runner: finished poststart hooks: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=connect-proxy-count-api end="2020-09-11 09:59:05.400451153 +0200 CEST m=+11.474396517" duration=119.3µs
2020-09-11T09:59:05.400+0200 [TRACE] client.alloc_runner: handling task state update: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 done=false
2020-09-11T09:59:05.400+0200 [TRACE] client.alloc_runner: sending updated alloc: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 client_status=running desired_status=
2020-09-11T09:59:05.400+0200 [TRACE] client.alloc_runner.task_runner: running prestart hooks: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=web start="2020-09-11 09:59:05.40049832 +0200 CEST m=+11.474443686"
2020-09-11T09:59:05.400+0200 [TRACE] client.alloc_runner.task_runner: running prestart hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=web name=validate start="2020-09-11 09:59:05.400539304 +0200 CEST m=+11.474484689"
2020-09-11T09:59:05.400+0200 [TRACE] client.alloc_runner.task_runner: finished prestart hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=web name=validate end="2020-09-11 09:59:05.400551851 +0200 CEST m=+11.474497215" duration=12.526µs
2020-09-11T09:59:05.400+0200 [TRACE] client.alloc_runner.task_runner: running prestart hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=web name=task_dir start="2020-09-11 09:59:05.40057784 +0200 CEST m=+11.474523216"
2020-09-11T09:59:05.400+0200 [TRACE] client.alloc_runner: handling task state update: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 done=false
2020-09-11T09:59:05.400+0200 [TRACE] client.alloc_runner: sending updated alloc: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 client_status=running desired_status=
2020-09-11T09:59:05.401+0200 [TRACE] client.alloc_runner.task_runner: finished prestart hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=web name=task_dir end="2020-09-11 09:59:05.401301611 +0200 CEST m=+11.475247008" duration=723.792µs
2020-09-11T09:59:05.401+0200 [TRACE] client.alloc_runner.task_runner: running prestart hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=web name=logmon start="2020-09-11 09:59:05.401342016 +0200 CEST m=+11.475287390"
2020-09-11T09:59:05.401+0200 [DEBUG] client.alloc_runner.task_runner.task_hook.logmon: starting plugin: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=web path=/usr/bin/nomad args=[/usr/bin/nomad, logmon]
2020-09-11T09:59:05.401+0200 [DEBUG] client.alloc_runner.task_runner.task_hook.logmon: plugin started: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=web path=/usr/bin/nomad pid=101959
2020-09-11T09:59:05.401+0200 [DEBUG] client.alloc_runner.task_runner.task_hook.logmon: waiting for RPC address: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=web path=/usr/bin/nomad
2020-09-11T09:59:05.407+0200 [DEBUG] client.alloc_runner.task_runner.task_hook.logmon.nomad: plugin address: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=web @module=logmon address=/tmp/plugin933183712 network=unix timestamp=2020-09-11T09:59:05.406+0200
2020-09-11T09:59:05.407+0200 [DEBUG] client.alloc_runner.task_runner.task_hook.logmon: using plugin: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=web version=2
2020-09-11T09:59:05.407+0200 [INFO] client.alloc_runner.task_runner.task_hook.logmon.nomad: opening fifo: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=web path=/tmp/NomadClient446473161/28986c86-fe5e-e772-e2e6-cc2096d6a1c0/alloc/logs/.web.stdout.fifo @module=logmon timestamp=2020-09-11T09:59:05.407+0200
2020-09-11T09:59:05.408+0200 [INFO] client.alloc_runner.task_runner.task_hook.logmon.nomad: opening fifo: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=web @module=logmon path=/tmp/NomadClient446473161/28986c86-fe5e-e772-e2e6-cc2096d6a1c0/alloc/logs/.web.stderr.fifo timestamp=2020-09-11T09:59:05.408+0200
2020-09-11T09:59:05.408+0200 [TRACE] client.alloc_runner.task_runner: finished prestart hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=web name=logmon end="2020-09-11 09:59:05.408428664 +0200 CEST m=+11.482374051" duration=7.086661ms
2020-09-11T09:59:05.408+0200 [TRACE] client.alloc_runner.task_runner: running prestart hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=web name=dispatch_payload start="2020-09-11 09:59:05.408474983 +0200 CEST m=+11.482420354"
2020-09-11T09:59:05.408+0200 [TRACE] client.alloc_runner.task_runner: finished prestart hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=web name=dispatch_payload end="2020-09-11 09:59:05.408492566 +0200 CEST m=+11.482437944" duration=17.59µs
2020-09-11T09:59:05.408+0200 [TRACE] client.alloc_runner.task_runner: running prestart hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=web name=volumes start="2020-09-11 09:59:05.408522068 +0200 CEST m=+11.482467436"
2020-09-11T09:59:05.408+0200 [TRACE] client.alloc_runner.task_runner: finished prestart hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=web name=volumes end="2020-09-11 09:59:05.408538119 +0200 CEST m=+11.482483487" duration=16.051µs
2020-09-11T09:59:05.408+0200 [TRACE] client.alloc_runner.task_runner: running prestart hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=web name=artifacts start="2020-09-11 09:59:05.408564941 +0200 CEST m=+11.482510310"
2020-09-11T09:59:05.408+0200 [TRACE] client.alloc_runner.task_runner: finished prestart hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=web name=artifacts end="2020-09-11 09:59:05.408576078 +0200 CEST m=+11.482521447" duration=11.137µs
2020-09-11T09:59:05.408+0200 [TRACE] client.alloc_runner.task_runner: running prestart hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=web name=devices start="2020-09-11 09:59:05.408599842 +0200 CEST m=+11.482545214"
2020-09-11T09:59:05.408+0200 [TRACE] client.alloc_runner.task_runner: finished prestart hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=web name=devices end="2020-09-11 09:59:05.408608958 +0200 CEST m=+11.482554328" duration=9.114µs
2020-09-11T09:59:05.408+0200 [TRACE] client.alloc_runner.task_runner: running prestart hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=web name=script_checks start="2020-09-11 09:59:05.408634399 +0200 CEST m=+11.482579767"
2020-09-11T09:59:05.408+0200 [TRACE] client.alloc_runner.task_runner: finished prestart hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=web name=script_checks end="2020-09-11 09:59:05.4086444 +0200 CEST m=+11.482589770" duration=10.003µs
2020-09-11T09:59:05.408+0200 [TRACE] client.alloc_runner.task_runner: finished prestart hooks: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=web end="2020-09-11 09:59:05.40865842 +0200 CEST m=+11.482603791" duration=8.160105ms
2020-09-11T09:59:05.409+0200 [DEBUG] client.driver_mgr.docker: image reference count incremented: driver=docker image_name=hashicorpnomad/counter-api:v1 image_id=sha256:920eaa8f01535d374004289a5f728a890114b3bd38ae71859c50a2c447daf1db references=1
2020-09-11T09:59:05.409+0200 [TRACE] client.driver_mgr.docker: binding volumes: driver=docker task_name=web volumes=[/tmp/NomadClient446473161/28986c86-fe5e-e772-e2e6-cc2096d6a1c0/alloc:/alloc, /tmp/NomadClient446473161/28986c86-fe5e-e772-e2e6-cc2096d6a1c0/web/local:/local, /tmp/NomadClient446473161/28986c86-fe5e-e772-e2e6-cc2096d6a1c0/web/secrets:/secrets]
2020-09-11T09:59:05.409+0200 [TRACE] client.driver_mgr.docker: no docker log driver provided, defaulting to json-file: driver=docker task_name=web
2020-09-11T09:59:05.409+0200 [DEBUG] client.driver_mgr.docker: configured resources: driver=docker task_name=web memory=314572800 memory_reservation=0 cpu_shares=100 cpu_quota=0 cpu_period=0
2020-09-11T09:59:05.409+0200 [DEBUG] client.driver_mgr.docker: binding directories: driver=docker task_name=web binds="[]string{"/tmp/NomadClient446473161/28986c86-fe5e-e772-e2e6-cc2096d6a1c0/alloc:/alloc", "/tmp/NomadClient446473161/28986c86-fe5e-e772-e2e6-cc2096d6a1c0/web/local:/local", "/tmp/NomadClient446473161/28986c86-fe5e-e772-e2e6-cc2096d6a1c0/web/secrets:/secrets"}"
2020-09-11T09:59:05.409+0200 [DEBUG] client.driver_mgr.docker: configuring network mode for task group: driver=docker task_name=web network_mode=container:665070ee7c936c9ce49e324ea7a2d2f7f1b302c7ecd3d050f4d610edd58c3242
2020-09-11T09:59:05.409+0200 [DEBUG] client.driver_mgr.docker: applied labels on the container: driver=docker task_name=web labels=map[com.hashicorp.nomad.alloc_id:28986c86-fe5e-e772-e2e6-cc2096d6a1c0]
2020-09-11T09:59:05.409+0200 [DEBUG] client.driver_mgr.docker: setting container name: driver=docker task_name=web container_name=web-28986c86-fe5e-e772-e2e6-cc2096d6a1c0
2020-09-11T09:59:05.463+0200 [INFO] client.driver_mgr.docker: created container: driver=docker container_id=2f0be490418dd449a2174cbe021bc241a9f04531582657ca5d6778fc74ab36ec
2020-09-11T09:59:05.600+0200 [DEBUG] client: updated allocations: index=14 total=1 pulled=0 filtered=1
2020-09-11T09:59:05.600+0200 [DEBUG] client: allocation updates: added=0 removed=0 updated=0 ignored=1
2020-09-11T09:59:05.600+0200 [DEBUG] client: allocation updates applied: added=0 removed=0 updated=0 ignored=1 errors=0
2020-09-11T09:59:05.600+0200 [TRACE] client: next heartbeat: period=16.147939736s
2020-09-11T09:59:05.740+0200 [INFO] client.driver_mgr.docker: started container: driver=docker container_id=2f0be490418dd449a2174cbe021bc241a9f04531582657ca5d6778fc74ab36ec
2020-09-11T09:59:05.740+0200 [DEBUG] client.driver_mgr.docker.docker_logger: starting plugin: driver=docker path=/usr/bin/nomad args=[/usr/bin/nomad, docker_logger]
2020-09-11T09:59:05.740+0200 [DEBUG] client.driver_mgr.docker.docker_logger: plugin started: driver=docker path=/usr/bin/nomad pid=102022
2020-09-11T09:59:05.740+0200 [DEBUG] client.driver_mgr.docker.docker_logger: waiting for RPC address: driver=docker path=/usr/bin/nomad
2020-09-11T09:59:05.744+0200 [DEBUG] client.driver_mgr.docker.docker_logger.nomad: plugin address: driver=docker @module=docker_logger address=/tmp/plugin060889664 network=unix timestamp=2020-09-11T09:59:05.744+0200
2020-09-11T09:59:05.745+0200 [DEBUG] client.driver_mgr.docker.docker_logger: using plugin: driver=docker version=2
2020-09-11T09:59:05.745+0200 [DEBUG] client.driver_mgr.docker.docker_logger.nomad: using client connection initialized from environment: driver=docker @module=docker_logger timestamp=2020-09-11T09:59:05.745+0200
2020-09-11T09:59:05.745+0200 [TRACE] client.alloc_runner.task_runner: setting task state: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=web state=running event=Started
2020-09-11T09:59:05.745+0200 [TRACE] client.alloc_runner.task_runner: running poststart hooks: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=web start="2020-09-11 09:59:05.745845708 +0200 CEST m=+11.819791074"
2020-09-11T09:59:05.745+0200 [TRACE] client.alloc_runner.task_runner: running poststart hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=web name=stats_hook start="2020-09-11 09:59:05.745870518 +0200 CEST m=+11.819815888"
2020-09-11T09:59:05.745+0200 [TRACE] client.alloc_runner.task_runner: finished poststart hooks: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=web name=stats_hook end="2020-09-11 09:59:05.745899766 +0200 CEST m=+11.819845147" duration=29.259µs
2020-09-11T09:59:05.745+0200 [TRACE] client.alloc_runner.task_runner: running poststart hook: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=web name=script_checks start="2020-09-11 09:59:05.745912893 +0200 CEST m=+11.819858270"
2020-09-11T09:59:05.745+0200 [TRACE] client.alloc_runner: handling task state update: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 done=false
2020-09-11T09:59:05.745+0200 [TRACE] client.alloc_runner: sending updated alloc: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 client_status=running desired_status=
2020-09-11T09:59:05.745+0200 [TRACE] client.alloc_runner.task_runner: finished poststart hooks: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=web name=script_checks end="2020-09-11 09:59:05.7459637 +0200 CEST m=+11.819909068" duration=50.798µs
2020-09-11T09:59:05.745+0200 [TRACE] client.alloc_runner.task_runner: finished poststart hooks: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 task=web end="2020-09-11 09:59:05.745972508 +0200 CEST m=+11.819917872" duration=126.798µs
2020-09-11T09:59:05.801+0200 [DEBUG] client: updated allocations: index=15 total=1 pulled=0 filtered=1
2020-09-11T09:59:05.801+0200 [DEBUG] client: allocation updates: added=0 removed=0 updated=0 ignored=1
2020-09-11T09:59:05.802+0200 [DEBUG] client: allocation updates applied: added=0 removed=0 updated=0 ignored=1 errors=0
2020-09-11T09:59:05.802+0200 [TRACE] client: next heartbeat: period=10.490907378s
2020-09-11T09:59:09.530+0200 [DEBUG] http: request complete: method=GET path=/v1/agent/health?type=client duration=605.433µs
2020-09-11T09:59:09.624+0200 [DEBUG] http: request complete: method=GET path=/v1/agent/health?type=server duration=496.389µs
2020-09-11T09:59:13.554+0200 [DEBUG] nomad: memberlist: Stream connection from=127.0.0.1:52972
2020-09-11T09:59:15.746+0200 [TRACE] client.alloc_runner.runner_hook.alloc_health_watcher: health set: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 healthy=true
2020-09-11T09:59:15.746+0200 [TRACE] client.alloc_runner: sending updated alloc: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 client_status=running desired_status=
2020-09-11T09:59:15.802+0200 [DEBUG] client: updated allocations: index=16 total=1 pulled=0 filtered=1
2020-09-11T09:59:15.803+0200 [DEBUG] client: allocation updates: added=0 removed=0 updated=0 ignored=1
2020-09-11T09:59:15.803+0200 [DEBUG] client: allocation updates applied: added=0 removed=0 updated=0 ignored=1 errors=0
2020-09-11T09:59:15.803+0200 [TRACE] client: next heartbeat: period=13.835487019s
2020-09-11T09:59:17.053+0200 [DEBUG] worker: dequeued evaluation: eval_id=81a95c36-1e94-4cc3-6b88-a671a0224097
2020-09-11T09:59:17.053+0200 [TRACE] worker.service_sched.binpack: NewBinPackIterator created: eval_id=81a95c36-1e94-4cc3-6b88-a671a0224097 job_id=countdash namespace=default algorithm=binpack
2020-09-11T09:59:17.054+0200 [DEBUG] worker.service_sched: reconciled current state with desired state: eval_id=81a95c36-1e94-4cc3-6b88-a671a0224097 job_id=countdash namespace=default results="Total changes: (place 0) (destructive 0) (inplace 0) (stop 0)
Deployment Update for ID "040aea76-eb1e-a978-4566-b5d34416595e": Status "successful"; Description "Deployment completed successfully"
Desired Changes for "api": (place 0) (inplace 0) (destructive 0) (stop 0) (migrate 0) (ignore 1) (canary 0)"
2020-09-11T09:59:17.056+0200 [DEBUG] worker: submitted plan for evaluation: eval_id=81a95c36-1e94-4cc3-6b88-a671a0224097
2020-09-11T09:59:17.056+0200 [DEBUG] worker.service_sched: setting eval status: eval_id=81a95c36-1e94-4cc3-6b88-a671a0224097 job_id=countdash namespace=default status=complete
2020-09-11T09:59:17.057+0200 [DEBUG] worker: updated evaluation: eval="<Eval "81a95c36-1e94-4cc3-6b88-a671a0224097" JobID: "countdash" Namespace: "default">"
2020-09-11T09:59:17.057+0200 [DEBUG] worker: ack evaluation: eval_id=81a95c36-1e94-4cc3-6b88-a671a0224097
2020-09-11T09:59:18.925+0200 [TRACE] nomad.job: job mutate results: mutator=canonicalize warnings=[] error=<nil>
2020-09-11T09:59:18.925+0200 [TRACE] nomad.job: job mutate results: mutator=connect warnings=[] error=<nil>
2020-09-11T09:59:18.925+0200 [TRACE] nomad.job: job mutate results: mutator=expose-check warnings=[] error=<nil>
2020-09-11T09:59:18.925+0200 [TRACE] nomad.job: job mutate results: mutator=constraints warnings=[] error=<nil>
2020-09-11T09:59:18.925+0200 [TRACE] nomad.job: job validate results: validator=connect warnings=[] error=<nil>
2020-09-11T09:59:18.925+0200 [TRACE] nomad.job: job validate results: validator=expose-check warnings=[] error=<nil>
2020-09-11T09:59:18.926+0200 [TRACE] nomad.job: job validate results: validator=validate warnings=[] error=<nil>
2020-09-11T09:59:18.926+0200 [DEBUG] nomad.periodic: registered periodic job: job="<ns: "default", id: "batch_with_connect">"
2020-09-11T09:59:18.927+0200 [DEBUG] nomad.periodic: scheduled periodic job launch: launch_delay=11.072999535s job="<ns: "default", id: "batch_with_connect">"
2020-09-11T09:59:18.927+0200 [DEBUG] http: request complete: method=PUT path=/v1/jobs duration=1.880279ms
2020-09-11T09:59:19.532+0200 [DEBUG] http: request complete: method=GET path=/v1/agent/health?type=client duration=249.673µs
2020-09-11T09:59:19.625+0200 [DEBUG] http: request complete: method=GET path=/v1/agent/health?type=server duration=251.8µs
2020-09-11T09:59:23.555+0200 [DEBUG] nomad: memberlist: Stream connection from=127.0.0.1:52988
2020-09-11T09:59:29.534+0200 [DEBUG] http: request complete: method=GET path=/v1/agent/health?type=client duration=336.624µs
2020-09-11T09:59:29.628+0200 [DEBUG] http: request complete: method=GET path=/v1/agent/health?type=server duration=1.044166ms
2020-09-11T09:59:29.640+0200 [TRACE] client: next heartbeat: period=14.727396251s
2020-09-11T09:59:30.000+0200 [DEBUG] nomad.periodic: launching job: job="<ns: "default", id: "batch_with_connect">" launch_time="2020-09-11 07:59:30 +0000 UTC"
2020-09-11T09:59:30.003+0200 [DEBUG] nomad.periodic: scheduled periodic job launch: launch_delay=14.996896966s job="<ns: "default", id: "batch_with_connect">"
2020-09-11T09:59:30.003+0200 [DEBUG] worker: dequeued evaluation: eval_id=aa1cf492-496a-bb65-e405-cd74d62adfa9
2020-09-11T09:59:30.003+0200 [TRACE] worker.batch_sched.binpack: NewBinPackIterator created: eval_id=aa1cf492-496a-bb65-e405-cd74d62adfa9 job_id=batch_with_connect/periodic-1599811170 namespace=default algorithm=binpack
2020-09-11T09:59:30.003+0200 [DEBUG] worker.batch_sched: reconciled current state with desired state: eval_id=aa1cf492-496a-bb65-e405-cd74d62adfa9 job_id=batch_with_connect/periodic-1599811170 namespace=default results="Total changes: (place 1) (destructive 0) (inplace 0) (stop 0)
Desired Changes for "batch_with_connect": (place 1) (inplace 0) (destructive 0) (stop 0) (migrate 0) (ignore 0) (canary 0)"
2020-09-11T09:59:30.006+0200 [DEBUG] worker: submitted plan for evaluation: eval_id=aa1cf492-496a-bb65-e405-cd74d62adfa9
2020-09-11T09:59:30.006+0200 [DEBUG] worker.batch_sched: setting eval status: eval_id=aa1cf492-496a-bb65-e405-cd74d62adfa9 job_id=batch_with_connect/periodic-1599811170 namespace=default status=complete
2020-09-11T09:59:30.007+0200 [DEBUG] worker: updated evaluation: eval="<Eval "aa1cf492-496a-bb65-e405-cd74d62adfa9" JobID: "batch_with_connect/periodic-1599811170" Namespace: "default">"
2020-09-11T09:59:30.007+0200 [TRACE] client: next heartbeat: period=16.534804863s
2020-09-11T09:59:30.007+0200 [DEBUG] worker: ack evaluation: eval_id=aa1cf492-496a-bb65-e405-cd74d62adfa9
2020-09-11T09:59:30.008+0200 [DEBUG] client: updated allocations: index=22 total=2 pulled=1 filtered=1
2020-09-11T09:59:30.008+0200 [DEBUG] client: allocation updates: added=1 removed=0 updated=0 ignored=1
2020-09-11T09:59:30.008+0200 [TRACE] client: next heartbeat: period=17.462546332s
2020-09-11T09:59:30.011+0200 [DEBUG] client: allocation updates applied: added=1 removed=0 updated=0 ignored=1 errors=0
2020-09-11T09:59:30.012+0200 [TRACE] client.alloc_runner: running pre-run hooks: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 start="2020-09-11 09:59:30.012043818 +0200 CEST m=+36.085989380"
2020-09-11T09:59:30.012+0200 [TRACE] client.alloc_runner: running pre-run hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 name=alloc_dir start="2020-09-11 09:59:30.01221479 +0200 CEST m=+36.086160267"
2020-09-11T09:59:30.012+0200 [TRACE] client.alloc_runner: finished pre-run hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 name=alloc_dir end="2020-09-11 09:59:30.012766713 +0200 CEST m=+36.086712197" duration=551.93µs
2020-09-11T09:59:30.012+0200 [TRACE] client.alloc_runner: running pre-run hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 name=await_previous_allocations start="2020-09-11 09:59:30.012819349 +0200 CEST m=+36.086764785"
2020-09-11T09:59:30.012+0200 [TRACE] client.alloc_runner: finished pre-run hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 name=await_previous_allocations end="2020-09-11 09:59:30.012849671 +0200 CEST m=+36.086795104" duration=30.319µs
2020-09-11T09:59:30.012+0200 [TRACE] client.alloc_runner: running pre-run hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 name=migrate_disk start="2020-09-11 09:59:30.01287421 +0200 CEST m=+36.086819642"
2020-09-11T09:59:30.012+0200 [TRACE] client.alloc_runner: finished pre-run hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 name=migrate_disk end="2020-09-11 09:59:30.012893546 +0200 CEST m=+36.086838972" duration=19.33µs
2020-09-11T09:59:30.012+0200 [TRACE] client.alloc_runner: running pre-run hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 name=network start="2020-09-11 09:59:30.012920254 +0200 CEST m=+36.086865684"
2020-09-11T09:59:30.610+0200 [DEBUG] client.driver_mgr.docker: docker pull succeeded: driver=docker image_ref=gcr.io/google_containers/pause-amd64:3.0
2020-09-11T09:59:30.612+0200 [DEBUG] client.driver_mgr.docker: image reference count incremented: driver=docker image_name=gcr.io/google_containers/pause-amd64:3.0 image_id=sha256:99e59f495ffaa222bfeb67580213e8c28c1e885f1d245ab2bbe3b1b1ec3bd0b2 references=2
2020-09-11T09:59:30.615+0200 [TRACE] client.driver_mgr.docker: listed container: driver=docker names=[/web-28986c86-fe5e-e772-e2e6-cc2096d6a1c0]
2020-09-11T09:59:30.615+0200 [TRACE] client.driver_mgr.docker: listed container: driver=docker names=[/connect-proxy-count-api-28986c86-fe5e-e772-e2e6-cc2096d6a1c0]
2020-09-11T09:59:30.615+0200 [TRACE] client.driver_mgr.docker: listed container: driver=docker names=[/nomad_init_28986c86-fe5e-e772-e2e6-cc2096d6a1c0]
2020-09-11T09:59:31.282+0200 [TRACE] client.alloc_runner: finished pre-run hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 name=network end="2020-09-11 09:59:31.282894207 +0200 CEST m=+37.356839626" duration=1.269973942s
2020-09-11T09:59:31.282+0200 [TRACE] client.alloc_runner: running pre-run hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 name=group_services start="2020-09-11 09:59:31.282939188 +0200 CEST m=+37.356884577"
2020-09-11T09:59:31.283+0200 [TRACE] client.alloc_runner: finished pre-run hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 name=group_services end="2020-09-11 09:59:31.283047695 +0200 CEST m=+37.356993121" duration=108.544µs
2020-09-11T09:59:31.283+0200 [TRACE] client.alloc_runner: running pre-run hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 name=consul_grpc_socket start="2020-09-11 09:59:31.283068567 +0200 CEST m=+37.357013956"
2020-09-11T09:59:31.283+0200 [TRACE] client.alloc_runner: finished pre-run hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 name=consul_grpc_socket end="2020-09-11 09:59:31.283167722 +0200 CEST m=+37.357113120" duration=99.164µs
2020-09-11T09:59:31.283+0200 [TRACE] client.alloc_runner: running pre-run hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 name=consul_http_socket start="2020-09-11 09:59:31.283189437 +0200 CEST m=+37.357134831"
2020-09-11T09:59:31.283+0200 [TRACE] client.alloc_runner: finished pre-run hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 name=consul_http_socket end="2020-09-11 09:59:31.283205915 +0200 CEST m=+37.357151305" duration=16.474µs
2020-09-11T09:59:31.283+0200 [TRACE] client.alloc_runner: running pre-run hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 name=csi_hook start="2020-09-11 09:59:31.283225337 +0200 CEST m=+37.357170732"
2020-09-11T09:59:31.283+0200 [TRACE] client.alloc_runner: finished pre-run hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 name=csi_hook end="2020-09-11 09:59:31.283244701 +0200 CEST m=+37.357190102" duration=19.37µs
2020-09-11T09:59:31.283+0200 [TRACE] client.alloc_runner: finished pre-run hooks: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 end="2020-09-11 09:59:31.283263227 +0200 CEST m=+37.357208619" duration=1.271219239s
2020-09-11T09:59:31.283+0200 [TRACE] client.alloc_runner.task_runner: running prestart hooks: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard start="2020-09-11 09:59:31.283307832 +0200 CEST m=+37.357253235"
2020-09-11T09:59:31.283+0200 [TRACE] client.alloc_runner.task_runner: running prestart hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard name=validate start="2020-09-11 09:59:31.283395581 +0200 CEST m=+37.357340974"
2020-09-11T09:59:31.283+0200 [TRACE] client.alloc_runner.task_runner: finished prestart hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard name=validate end="2020-09-11 09:59:31.283432945 +0200 CEST m=+37.357378391" duration=37.417µs
2020-09-11T09:59:31.283+0200 [TRACE] client.alloc_runner.task_runner: running prestart hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard name=task_dir start="2020-09-11 09:59:31.283483024 +0200 CEST m=+37.357428417"
2020-09-11T09:59:31.283+0200 [TRACE] client.alloc_runner: handling task state update: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 done=false
2020-09-11T09:59:31.284+0200 [TRACE] client.alloc_runner: sending updated alloc: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 client_status=pending desired_status=
2020-09-11T09:59:31.288+0200 [TRACE] client.alloc_runner.task_runner: finished prestart hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard name=task_dir end="2020-09-11 09:59:31.288559099 +0200 CEST m=+37.362504491" duration=5.076074ms
2020-09-11T09:59:31.288+0200 [TRACE] client.alloc_runner.task_runner: running prestart hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard name=logmon start="2020-09-11 09:59:31.288651831 +0200 CEST m=+37.362597242"
2020-09-11T09:59:31.288+0200 [DEBUG] client.alloc_runner.task_runner.task_hook.logmon: starting plugin: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard path=/usr/bin/nomad args=[/usr/bin/nomad, logmon]
2020-09-11T09:59:31.289+0200 [DEBUG] client.alloc_runner.task_runner.task_hook.logmon: plugin started: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard path=/usr/bin/nomad pid=102298
2020-09-11T09:59:31.289+0200 [DEBUG] client.alloc_runner.task_runner.task_hook.logmon: waiting for RPC address: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard path=/usr/bin/nomad
2020-09-11T09:59:31.290+0200 [DEBUG] consul.sync: sync complete: registered_services=2 deregistered_services=0 registered_checks=0 deregistered_checks=0
2020-09-11T09:59:31.296+0200 [DEBUG] client.alloc_runner.task_runner.task_hook.logmon.nomad: plugin address: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard @module=logmon address=/tmp/plugin116621487 network=unix timestamp=2020-09-11T09:59:31.295+0200
2020-09-11T09:59:31.296+0200 [DEBUG] client.alloc_runner.task_runner.task_hook.logmon: using plugin: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard version=2
2020-09-11T09:59:31.297+0200 [INFO] client.alloc_runner.task_runner.task_hook.logmon.nomad: opening fifo: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard @module=logmon path=/tmp/NomadClient446473161/4f11511e-782f-27e0-1480-c64812a66525/alloc/logs/.connect-proxy-count-dashboard.stdout.fifo timestamp=2020-09-11T09:59:31.297+0200
2020-09-11T09:59:31.297+0200 [INFO] client.alloc_runner.task_runner.task_hook.logmon.nomad: opening fifo: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard @module=logmon path=/tmp/NomadClient446473161/4f11511e-782f-27e0-1480-c64812a66525/alloc/logs/.connect-proxy-count-dashboard.stderr.fifo timestamp=2020-09-11T09:59:31.297+0200
2020-09-11T09:59:31.297+0200 [TRACE] client.alloc_runner.task_runner: finished prestart hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard name=logmon end="2020-09-11 09:59:31.29749879 +0200 CEST m=+37.371444192" duration=8.84695ms
2020-09-11T09:59:31.297+0200 [TRACE] client.alloc_runner.task_runner: running prestart hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard name=dispatch_payload start="2020-09-11 09:59:31.297547699 +0200 CEST m=+37.371493074"
2020-09-11T09:59:31.297+0200 [TRACE] client.alloc_runner.task_runner: finished prestart hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard name=dispatch_payload end="2020-09-11 09:59:31.297561649 +0200 CEST m=+37.371507020" duration=13.946µs
2020-09-11T09:59:31.297+0200 [TRACE] client.alloc_runner.task_runner: running prestart hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard name=volumes start="2020-09-11 09:59:31.297592983 +0200 CEST m=+37.371538355"
2020-09-11T09:59:31.297+0200 [TRACE] client.alloc_runner.task_runner: finished prestart hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard name=volumes end="2020-09-11 09:59:31.297605697 +0200 CEST m=+37.371551066" duration=12.711µs
2020-09-11T09:59:31.297+0200 [TRACE] client.alloc_runner.task_runner: running prestart hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard name=artifacts start="2020-09-11 09:59:31.297632747 +0200 CEST m=+37.371578117"
2020-09-11T09:59:31.297+0200 [TRACE] client.alloc_runner.task_runner: finished prestart hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard name=artifacts end="2020-09-11 09:59:31.297640836 +0200 CEST m=+37.371586209" duration=8.092µs
2020-09-11T09:59:31.297+0200 [TRACE] client.alloc_runner.task_runner: running prestart hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard name=devices start="2020-09-11 09:59:31.297665544 +0200 CEST m=+37.371610915"
2020-09-11T09:59:31.297+0200 [TRACE] client.alloc_runner.task_runner: finished prestart hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard name=devices end="2020-09-11 09:59:31.297673522 +0200 CEST m=+37.371618894" duration=7.979µs
2020-09-11T09:59:31.297+0200 [TRACE] client.alloc_runner.task_runner: running prestart hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard name=envoy_bootstrap start="2020-09-11 09:59:31.297698859 +0200 CEST m=+37.371644229"
2020-09-11T09:59:31.297+0200 [DEBUG] client.alloc_runner.task_runner.task_hook.envoy_bootstrap: bootstrapping Consul connect-proxy: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard task=connect-proxy-count-dashboard service=count-dashboard
2020-09-11T09:59:31.297+0200 [TRACE] client.alloc_runner.task_runner.task_hook.envoy_bootstrap: no SI token to load: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard task=connect-proxy-count-dashboard
2020-09-11T09:59:31.297+0200 [DEBUG] client.alloc_runner.task_runner.task_hook.envoy_bootstrap: check for SI token for task: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard task=connect-proxy-count-dashboard exists=false
2020-09-11T09:59:31.297+0200 [DEBUG] client.alloc_runner.task_runner.task_hook.envoy_bootstrap: bootstrapping envoy: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard sidecar_for=count-dashboard bootstrap_file=/tmp/NomadClient446473161/4f11511e-782f-27e0-1480-c64812a66525/connect-proxy-count-dashboard/secrets/envoy_bootstrap.json sidecar_for_id=_nomad-task-4f11511e-782f-27e0-1480-c64812a66525-group-batch_with_connect-count-dashboard-9002 grpc_addr=unix://alloc/tmp/consul_grpc.sock admin_bind=localhost:19001 gateway=
2020-09-11T09:59:31.344+0200 [TRACE] client.alloc_runner.task_runner: finished prestart hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard name=envoy_bootstrap end="2020-09-11 09:59:31.344081825 +0200 CEST m=+37.418027215" duration=46.382986ms
2020-09-11T09:59:31.344+0200 [TRACE] client.alloc_runner.task_runner: running prestart hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard name=script_checks start="2020-09-11 09:59:31.344159618 +0200 CEST m=+37.418104985"
2020-09-11T09:59:31.344+0200 [TRACE] client.alloc_runner.task_runner: finished prestart hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard name=script_checks end="2020-09-11 09:59:31.34418159 +0200 CEST m=+37.418126961" duration=21.976µs
2020-09-11T09:59:31.344+0200 [TRACE] client.alloc_runner.task_runner: finished prestart hooks: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard end="2020-09-11 09:59:31.344194238 +0200 CEST m=+37.418139607" duration=60.886372ms
2020-09-11T09:59:31.346+0200 [DEBUG] client.driver_mgr.docker: image reference count incremented: driver=docker image_name=envoyproxy/envoy:v1.11.2@sha256:a7769160c9c1a55bb8d07a3b71ce5d64f72b1f665f10d81aa1581bc3cf850d09 image_id=sha256:72e91d8680d853b874d9aedda3a4b61048630d2043dd490ff36f5b0929f69874 references=2
2020-09-11T09:59:31.346+0200 [TRACE] client.driver_mgr.docker: binding volumes: driver=docker task_name=connect-proxy-count-dashboard volumes=[/tmp/NomadClient446473161/4f11511e-782f-27e0-1480-c64812a66525/alloc:/alloc, /tmp/NomadClient446473161/4f11511e-782f-27e0-1480-c64812a66525/connect-proxy-count-dashboard/local:/local, /tmp/NomadClient446473161/4f11511e-782f-27e0-1480-c64812a66525/connect-proxy-count-dashboard/secrets:/secrets]
2020-09-11T09:59:31.346+0200 [TRACE] client.driver_mgr.docker: no docker log driver provided, defaulting to json-file: driver=docker task_name=connect-proxy-count-dashboard
2020-09-11T09:59:31.346+0200 [DEBUG] client.driver_mgr.docker: configured resources: driver=docker task_name=connect-proxy-count-dashboard memory=134217728 memory_reservation=0 cpu_shares=250 cpu_quota=0 cpu_period=0
2020-09-11T09:59:31.346+0200 [DEBUG] client.driver_mgr.docker: binding directories: driver=docker task_name=connect-proxy-count-dashboard binds="[]string{"/tmp/NomadClient446473161/4f11511e-782f-27e0-1480-c64812a66525/alloc:/alloc", "/tmp/NomadClient446473161/4f11511e-782f-27e0-1480-c64812a66525/connect-proxy-count-dashboard/local:/local", "/tmp/NomadClient446473161/4f11511e-782f-27e0-1480-c64812a66525/connect-proxy-count-dashboard/secrets:/secrets"}"
2020-09-11T09:59:31.346+0200 [DEBUG] client.driver_mgr.docker: configuring network mode for task group: driver=docker task_name=connect-proxy-count-dashboard network_mode=container:dfce277e13b1175f1d55aa41600bea96027732a35cb667cde94df495f61e4aff
2020-09-11T09:59:31.346+0200 [DEBUG] client.driver_mgr.docker: applied labels on the container: driver=docker task_name=connect-proxy-count-dashboard labels=map[com.hashicorp.nomad.alloc_id:4f11511e-782f-27e0-1480-c64812a66525]
2020-09-11T09:59:31.346+0200 [DEBUG] client.driver_mgr.docker: setting container name: driver=docker task_name=connect-proxy-count-dashboard container_name=connect-proxy-count-dashboard-4f11511e-782f-27e0-1480-c64812a66525
2020-09-11T09:59:31.400+0200 [DEBUG] client: updated allocations: index=24 total=2 pulled=0 filtered=2
2020-09-11T09:59:31.400+0200 [DEBUG] client: allocation updates: added=0 removed=0 updated=0 ignored=2
2020-09-11T09:59:31.400+0200 [DEBUG] client: allocation updates applied: added=0 removed=0 updated=0 ignored=2 errors=0
2020-09-11T09:59:31.400+0200 [TRACE] client: next heartbeat: period=10.406653197s
2020-09-11T09:59:31.400+0200 [INFO] client.driver_mgr.docker: created container: driver=docker container_id=e15769083631113043c329f03756aaa000b2455c0c9194b40ec9f30346e24c71
2020-09-11T09:59:31.668+0200 [INFO] client.driver_mgr.docker: started container: driver=docker container_id=e15769083631113043c329f03756aaa000b2455c0c9194b40ec9f30346e24c71
2020-09-11T09:59:31.668+0200 [DEBUG] client.driver_mgr.docker.docker_logger: starting plugin: driver=docker path=/usr/bin/nomad args=[/usr/bin/nomad, docker_logger]
2020-09-11T09:59:31.668+0200 [DEBUG] client.driver_mgr.docker.docker_logger: plugin started: driver=docker path=/usr/bin/nomad pid=102351
2020-09-11T09:59:31.668+0200 [DEBUG] client.driver_mgr.docker.docker_logger: waiting for RPC address: driver=docker path=/usr/bin/nomad
2020-09-11T09:59:31.672+0200 [DEBUG] client.driver_mgr.docker.docker_logger.nomad: plugin address: driver=docker @module=docker_logger address=/tmp/plugin021996661 network=unix timestamp=2020-09-11T09:59:31.672+0200
2020-09-11T09:59:31.672+0200 [DEBUG] client.driver_mgr.docker.docker_logger: using plugin: driver=docker version=2
2020-09-11T09:59:31.673+0200 [DEBUG] client.driver_mgr.docker.docker_logger.nomad: using client connection initialized from environment: driver=docker @module=docker_logger timestamp=2020-09-11T09:59:31.673+0200
2020-09-11T09:59:31.673+0200 [TRACE] client.alloc_runner.task_runner: setting task state: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard state=running event=Started
2020-09-11T09:59:31.673+0200 [TRACE] client.alloc_runner.task_runner: running poststart hooks: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard start="2020-09-11 09:59:31.673558491 +0200 CEST m=+37.747503860"
2020-09-11T09:59:31.673+0200 [TRACE] client.alloc_runner.task_runner: running poststart hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard name=stats_hook start="2020-09-11 09:59:31.673593517 +0200 CEST m=+37.747538893"
2020-09-11T09:59:31.673+0200 [TRACE] client.alloc_runner: handling task state update: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 done=false
2020-09-11T09:59:31.673+0200 [TRACE] client.alloc_runner: sending updated alloc: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 client_status=running desired_status=
2020-09-11T09:59:31.673+0200 [TRACE] client.alloc_runner.task_runner: finished poststart hooks: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard name=stats_hook end="2020-09-11 09:59:31.673642828 +0200 CEST m=+37.747588203" duration=49.31µs
2020-09-11T09:59:31.673+0200 [TRACE] client.alloc_runner.task_runner: running poststart hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard name=script_checks start="2020-09-11 09:59:31.673656497 +0200 CEST m=+37.747601861"
2020-09-11T09:59:31.673+0200 [TRACE] client.alloc_runner.task_runner: finished poststart hooks: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard name=script_checks end="2020-09-11 09:59:31.673687973 +0200 CEST m=+37.747633338" duration=31.477µs
2020-09-11T09:59:31.673+0200 [TRACE] client.alloc_runner.task_runner: finished poststart hooks: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard end="2020-09-11 09:59:31.673697739 +0200 CEST m=+37.747643111" duration=139.251µs
2020-09-11T09:59:31.673+0200 [TRACE] client.alloc_runner.task_runner: running prestart hooks: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo start="2020-09-11 09:59:31.673643934 +0200 CEST m=+37.747589304"
2020-09-11T09:59:31.673+0200 [TRACE] client.alloc_runner.task_runner: running prestart hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo name=validate start="2020-09-11 09:59:31.673757392 +0200 CEST m=+37.747702765"
2020-09-11T09:59:31.673+0200 [TRACE] client.alloc_runner.task_runner: finished prestart hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo name=validate end="2020-09-11 09:59:31.673775847 +0200 CEST m=+37.747721216" duration=18.451µs
2020-09-11T09:59:31.673+0200 [TRACE] client.alloc_runner.task_runner: running prestart hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo name=task_dir start="2020-09-11 09:59:31.673805627 +0200 CEST m=+37.747750999"
2020-09-11T09:59:31.673+0200 [TRACE] client.alloc_runner: handling task state update: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 done=false
2020-09-11T09:59:31.673+0200 [TRACE] client.alloc_runner: sending updated alloc: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 client_status=running desired_status=
2020-09-11T09:59:31.674+0200 [TRACE] client.alloc_runner.task_runner: finished prestart hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo name=task_dir end="2020-09-11 09:59:31.674052297 +0200 CEST m=+37.747997668" duration=246.669µs
2020-09-11T09:59:31.674+0200 [TRACE] client.alloc_runner.task_runner: running prestart hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo name=logmon start="2020-09-11 09:59:31.674092794 +0200 CEST m=+37.748038161"
2020-09-11T09:59:31.674+0200 [DEBUG] client.alloc_runner.task_runner.task_hook.logmon: starting plugin: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo path=/usr/bin/nomad args=[/usr/bin/nomad, logmon]
2020-09-11T09:59:31.674+0200 [DEBUG] client.alloc_runner.task_runner.task_hook.logmon: plugin started: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo path=/usr/bin/nomad pid=102361
2020-09-11T09:59:31.674+0200 [DEBUG] client.alloc_runner.task_runner.task_hook.logmon: waiting for RPC address: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo path=/usr/bin/nomad
2020-09-11T09:59:31.678+0200 [DEBUG] client.alloc_runner.task_runner.task_hook.logmon.nomad: plugin address: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo @module=logmon address=/tmp/plugin449028361 network=unix timestamp=2020-09-11T09:59:31.678+0200
2020-09-11T09:59:31.678+0200 [DEBUG] client.alloc_runner.task_runner.task_hook.logmon: using plugin: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo version=2
2020-09-11T09:59:31.679+0200 [INFO] client.alloc_runner.task_runner.task_hook.logmon.nomad: opening fifo: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo @module=logmon path=/tmp/NomadClient446473161/4f11511e-782f-27e0-1480-c64812a66525/alloc/logs/.echo.stdout.fifo timestamp=2020-09-11T09:59:31.679+0200
2020-09-11T09:59:31.680+0200 [INFO] client.alloc_runner.task_runner.task_hook.logmon.nomad: opening fifo: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo @module=logmon path=/tmp/NomadClient446473161/4f11511e-782f-27e0-1480-c64812a66525/alloc/logs/.echo.stderr.fifo timestamp=2020-09-11T09:59:31.680+0200
2020-09-11T09:59:31.680+0200 [TRACE] client.alloc_runner.task_runner: finished prestart hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo name=logmon end="2020-09-11 09:59:31.680204564 +0200 CEST m=+37.754149954" duration=6.111793ms
2020-09-11T09:59:31.680+0200 [TRACE] client.alloc_runner.task_runner: running prestart hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo name=dispatch_payload start="2020-09-11 09:59:31.680257484 +0200 CEST m=+37.754202849"
2020-09-11T09:59:31.680+0200 [TRACE] client.alloc_runner.task_runner: finished prestart hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo name=dispatch_payload end="2020-09-11 09:59:31.680271841 +0200 CEST m=+37.754217206" duration=14.357µs
2020-09-11T09:59:31.680+0200 [TRACE] client.alloc_runner.task_runner: running prestart hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo name=volumes start="2020-09-11 09:59:31.680296144 +0200 CEST m=+37.754241509"
2020-09-11T09:59:31.680+0200 [TRACE] client.alloc_runner.task_runner: finished prestart hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo name=volumes end="2020-09-11 09:59:31.680305283 +0200 CEST m=+37.754250648" duration=9.139µs
2020-09-11T09:59:31.680+0200 [TRACE] client.alloc_runner.task_runner: running prestart hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo name=artifacts start="2020-09-11 09:59:31.680328348 +0200 CEST m=+37.754273712"
2020-09-11T09:59:31.680+0200 [TRACE] client.alloc_runner.task_runner: finished prestart hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo name=artifacts end="2020-09-11 09:59:31.680334463 +0200 CEST m=+37.754279829" duration=6.117µs
2020-09-11T09:59:31.680+0200 [TRACE] client.alloc_runner.task_runner: running prestart hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo name=devices start="2020-09-11 09:59:31.680354044 +0200 CEST m=+37.754299409"
2020-09-11T09:59:31.680+0200 [TRACE] client.alloc_runner.task_runner: finished prestart hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo name=devices end="2020-09-11 09:59:31.680359931 +0200 CEST m=+37.754305295" duration=5.886µs
2020-09-11T09:59:31.680+0200 [TRACE] client.alloc_runner.task_runner: running prestart hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo name=script_checks start="2020-09-11 09:59:31.680387344 +0200 CEST m=+37.754332715"
2020-09-11T09:59:31.680+0200 [TRACE] client.alloc_runner.task_runner: finished prestart hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo name=script_checks end="2020-09-11 09:59:31.680393117 +0200 CEST m=+37.754338482" duration=5.767µs
2020-09-11T09:59:31.680+0200 [TRACE] client.alloc_runner.task_runner: finished prestart hooks: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo end="2020-09-11 09:59:31.680397977 +0200 CEST m=+37.754343342" duration=6.754038ms
2020-09-11T09:59:31.681+0200 [DEBUG] client.driver_mgr.docker: image reference count incremented: driver=docker image_name=debian:10 image_id=sha256:f6dcff9b59af55f031c7fe19a19930aa54ac9213986f4def36cee02811758337 references=1
2020-09-11T09:59:31.681+0200 [TRACE] client.driver_mgr.docker: binding volumes: driver=docker task_name=echo volumes=[/tmp/NomadClient446473161/4f11511e-782f-27e0-1480-c64812a66525/alloc:/alloc, /tmp/NomadClient446473161/4f11511e-782f-27e0-1480-c64812a66525/echo/local:/local, /tmp/NomadClient446473161/4f11511e-782f-27e0-1480-c64812a66525/echo/secrets:/secrets]
2020-09-11T09:59:31.681+0200 [TRACE] client.driver_mgr.docker: no docker log driver provided, defaulting to json-file: driver=docker task_name=echo
2020-09-11T09:59:31.681+0200 [DEBUG] client.driver_mgr.docker: configured resources: driver=docker task_name=echo memory=314572800 memory_reservation=0 cpu_shares=100 cpu_quota=0 cpu_period=0
2020-09-11T09:59:31.681+0200 [DEBUG] client.driver_mgr.docker: binding directories: driver=docker task_name=echo binds="[]string{"/tmp/NomadClient446473161/4f11511e-782f-27e0-1480-c64812a66525/alloc:/alloc", "/tmp/NomadClient446473161/4f11511e-782f-27e0-1480-c64812a66525/echo/local:/local", "/tmp/NomadClient446473161/4f11511e-782f-27e0-1480-c64812a66525/echo/secrets:/secrets"}"
2020-09-11T09:59:31.681+0200 [DEBUG] client.driver_mgr.docker: configuring network mode for task group: driver=docker task_name=echo network_mode=container:dfce277e13b1175f1d55aa41600bea96027732a35cb667cde94df495f61e4aff
2020-09-11T09:59:31.681+0200 [DEBUG] client.driver_mgr.docker: applied labels on the container: driver=docker task_name=echo labels=map[com.hashicorp.nomad.alloc_id:4f11511e-782f-27e0-1480-c64812a66525]
2020-09-11T09:59:31.681+0200 [DEBUG] client.driver_mgr.docker: setting container name: driver=docker task_name=echo container_name=echo-4f11511e-782f-27e0-1480-c64812a66525
2020-09-11T09:59:31.733+0200 [INFO] client.driver_mgr.docker: created container: driver=docker container_id=dc95ffa0c38a66c06162e3370b03c1a1ad2f1fc97777aa91676007017281d03e
2020-09-11T09:59:31.800+0200 [DEBUG] client: updated allocations: index=25 total=2 pulled=0 filtered=2
2020-09-11T09:59:31.800+0200 [DEBUG] client: allocation updates: added=0 removed=0 updated=0 ignored=2
2020-09-11T09:59:31.800+0200 [DEBUG] client: allocation updates applied: added=0 removed=0 updated=0 ignored=2 errors=0
2020-09-11T09:59:31.800+0200 [TRACE] client: next heartbeat: period=19.254957153s
2020-09-11T09:59:32.001+0200 [INFO] client.driver_mgr.docker: started container: driver=docker container_id=dc95ffa0c38a66c06162e3370b03c1a1ad2f1fc97777aa91676007017281d03e
2020-09-11T09:59:32.001+0200 [DEBUG] client.driver_mgr.docker.docker_logger: starting plugin: driver=docker path=/usr/bin/nomad args=[/usr/bin/nomad, docker_logger]
2020-09-11T09:59:32.001+0200 [DEBUG] client.driver_mgr.docker.docker_logger: plugin started: driver=docker path=/usr/bin/nomad pid=102425
2020-09-11T09:59:32.001+0200 [DEBUG] client.driver_mgr.docker.docker_logger: waiting for RPC address: driver=docker path=/usr/bin/nomad
2020-09-11T09:59:32.005+0200 [DEBUG] client.driver_mgr.docker.docker_logger.nomad: plugin address: driver=docker address=/tmp/plugin629659568 network=unix @module=docker_logger timestamp=2020-09-11T09:59:32.005+0200
2020-09-11T09:59:32.005+0200 [DEBUG] client.driver_mgr.docker.docker_logger: using plugin: driver=docker version=2
2020-09-11T09:59:32.006+0200 [DEBUG] client.driver_mgr.docker.docker_logger.nomad: using client connection initialized from environment: driver=docker @module=docker_logger timestamp=2020-09-11T09:59:32.006+0200
2020-09-11T09:59:32.006+0200 [TRACE] client.alloc_runner.task_runner: setting task state: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo state=running event=Started
2020-09-11T09:59:32.006+0200 [TRACE] client.alloc_runner.task_runner: running poststart hooks: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo start="2020-09-11 09:59:32.006247223 +0200 CEST m=+38.080192589"
2020-09-11T09:59:32.006+0200 [TRACE] client.alloc_runner.task_runner: running poststart hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo name=stats_hook start="2020-09-11 09:59:32.006260237 +0200 CEST m=+38.080205602"
2020-09-11T09:59:32.006+0200 [TRACE] client.alloc_runner.task_runner: finished poststart hooks: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo name=stats_hook end="2020-09-11 09:59:32.006305998 +0200 CEST m=+38.080251362" duration=45.76µs
2020-09-11T09:59:32.006+0200 [TRACE] client.alloc_runner.task_runner: running poststart hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo name=script_checks start="2020-09-11 09:59:32.0063144 +0200 CEST m=+38.080259765"
2020-09-11T09:59:32.006+0200 [TRACE] client.alloc_runner.task_runner: finished poststart hooks: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo name=script_checks end="2020-09-11 09:59:32.006365891 +0200 CEST m=+38.080311268" duration=51.503µs
2020-09-11T09:59:32.006+0200 [TRACE] client.alloc_runner.task_runner: finished poststart hooks: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo end="2020-09-11 09:59:32.006373703 +0200 CEST m=+38.080319068" duration=126.479µs
2020-09-11T09:59:32.006+0200 [TRACE] client.alloc_runner: handling task state update: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 done=false
2020-09-11T09:59:32.006+0200 [TRACE] client.alloc_runner: sending updated alloc: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 client_status=running desired_status=
2020-09-11T09:59:32.065+0200 [TRACE] client.alloc_runner: handling task state update: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 done=false
2020-09-11T09:59:32.065+0200 [TRACE] client.alloc_runner: sending updated alloc: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 client_status=running desired_status=
2020-09-11T09:59:32.069+0200 [DEBUG] client.alloc_runner.task_runner.task_hook.stats_hook: failed to start stats collection for task with unrecoverable error: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo error="container stopped"
2020-09-11T09:59:32.070+0200 [DEBUG] client.driver_mgr.docker.docker_logger: plugin process exited: driver=docker path=/usr/bin/nomad pid=102425
2020-09-11T09:59:32.070+0200 [DEBUG] client.driver_mgr.docker.docker_logger: plugin exited: driver=docker
2020-09-11T09:59:32.200+0200 [DEBUG] client: updated allocations: index=26 total=2 pulled=0 filtered=2
2020-09-11T09:59:32.200+0200 [DEBUG] client: allocation updates: added=0 removed=0 updated=0 ignored=2
2020-09-11T09:59:32.200+0200 [DEBUG] client: allocation updates applied: added=0 removed=0 updated=0 ignored=2 errors=0
2020-09-11T09:59:32.200+0200 [TRACE] client: next heartbeat: period=14.81531528s
2020-09-11T09:59:32.220+0200 [DEBUG] client.driver_mgr.docker: image id reference count decremented: driver=docker image_id=sha256:f6dcff9b59af55f031c7fe19a19930aa54ac9213986f4def36cee02811758337 references=0
2020-09-11T09:59:32.220+0200 [TRACE] client.alloc_runner.task_runner: running exited hooks: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo start="2020-09-11 09:59:32.220910353 +0200 CEST m=+38.294855729"
2020-09-11T09:59:32.220+0200 [TRACE] client.alloc_runner.task_runner: running exited hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo name=stats_hook start="2020-09-11 09:59:32.220925902 +0200 CEST m=+38.294871271"
2020-09-11T09:59:32.220+0200 [TRACE] client.alloc_runner.task_runner: finished exited hooks: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo name=stats_hook end="2020-09-11 09:59:32.220932651 +0200 CEST m=+38.294878019" duration=6.748µs
2020-09-11T09:59:32.220+0200 [TRACE] client.alloc_runner.task_runner: finished exited hooks: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo end="2020-09-11 09:59:32.220944274 +0200 CEST m=+38.294889648" duration=33.919µs
2020-09-11T09:59:32.220+0200 [INFO] client.alloc_runner.task_runner: not restarting task: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo reason="Restart unnecessary as task terminated successfully"
2020-09-11T09:59:32.221+0200 [TRACE] client.alloc_runner.task_runner: running stop hooks: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo start="2020-09-11 09:59:32.221007154 +0200 CEST m=+38.294952521"
2020-09-11T09:59:32.221+0200 [TRACE] client.alloc_runner: handling task state update: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 done=false
2020-09-11T09:59:32.221+0200 [DEBUG] client.alloc_runner: main tasks dead, destroying all sidecar tasks: alloc_id=4f11511e-782f-27e0-1480-c64812a66525
2020-09-11T09:59:32.221+0200 [TRACE] client.alloc_runner: running alloc pre shutdown hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 name=group_services start="2020-09-11 09:59:32.221063671 +0200 CEST m=+38.295009047"
2020-09-11T09:59:32.221+0200 [TRACE] client.alloc_runner.task_runner: running stop hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo name=logmon start="2020-09-11 09:59:32.221018558 +0200 CEST m=+38.294963933"
2020-09-11T09:59:32.221+0200 [TRACE] client.alloc_runner: finished alloc pre shutdown hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 name=group_services end="2020-09-11 09:59:32.221140301 +0200 CEST m=+38.295085674" duration=76.627µs
2020-09-11T09:59:32.221+0200 [TRACE] client.alloc_runner.task_runner: Kill requested: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard event_type=Killing event_reason=
2020-09-11T09:59:32.221+0200 [TRACE] client.alloc_runner.task_runner: Kill requested: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo event_type=Killing event_reason=
2020-09-11T09:59:32.221+0200 [TRACE] client.alloc_runner.task_runner: running pre kill hooks: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard start="2020-09-11 09:59:32.221219548 +0200 CEST m=+38.295164930"
2020-09-11T09:59:32.221+0200 [TRACE] client.alloc_runner.task_runner: finished pre kill hooks: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard end="2020-09-11 09:59:32.221255426 +0200 CEST m=+38.295200794" duration=35.864µs
2020-09-11T09:59:32.221+0200 [DEBUG] client.alloc_runner.task_runner: waiting before killing task: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard shutdown_delay=5s
2020-09-11T09:59:32.222+0200 [DEBUG] client.alloc_runner.task_runner.task_hook.logmon: plugin process exited: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo path=/usr/bin/nomad pid=102361
2020-09-11T09:59:32.222+0200 [DEBUG] client.alloc_runner.task_runner.task_hook.logmon: plugin exited: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo
2020-09-11T09:59:32.222+0200 [TRACE] client.alloc_runner.task_runner: finished stop hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo name=logmon end="2020-09-11 09:59:32.222627853 +0200 CEST m=+38.296573225" duration=1.609292ms
2020-09-11T09:59:32.222+0200 [TRACE] client.alloc_runner.task_runner: running stop hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo name=script_checks start="2020-09-11 09:59:32.222646573 +0200 CEST m=+38.296591946"
2020-09-11T09:59:32.222+0200 [TRACE] client.alloc_runner.task_runner: finished stop hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo name=script_checks end="2020-09-11 09:59:32.22266413 +0200 CEST m=+38.296609502" duration=17.556µs
2020-09-11T09:59:32.222+0200 [TRACE] client.alloc_runner.task_runner: finished stop hooks: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo end="2020-09-11 09:59:32.222676358 +0200 CEST m=+38.296621737" duration=1.669216ms
2020-09-11T09:59:32.222+0200 [DEBUG] client.alloc_runner.task_runner: task run loop exiting: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=echo
2020-09-11T09:59:32.224+0200 [DEBUG] consul.sync: sync complete: registered_services=1 deregistered_services=1 registered_checks=0 deregistered_checks=0
2020-09-11T09:59:32.226+0200 [DEBUG] consul.sync: sync complete: registered_services=1 deregistered_services=0 registered_checks=0 deregistered_checks=0
2020-09-11T09:59:33.556+0200 [DEBUG] nomad: memberlist: Stream connection from=127.0.0.1:53014
2020-09-11T09:59:37.264+0200 [TRACE] client.alloc_runner.runner_hook: proxy to Consul complete: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 src_local=/tmp/NomadClient446473161/4f11511e-782f-27e0-1480-c64812a66525/alloc/tmp/consul_grpc.sock src_remote=@ bytes=2403
2020-09-11T09:59:37.264+0200 [TRACE] client.alloc_runner.runner_hook: proxy from Consul complete: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 src_local=/tmp/NomadClient446473161/4f11511e-782f-27e0-1480-c64812a66525/alloc/tmp/consul_grpc.sock src_remote=@ bytes=5390
2020-09-11T09:59:37.345+0200 [DEBUG] client.alloc_runner.task_runner.task_hook.stats_hook: failed to start stats collection for task with unrecoverable error: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard error="container stopped"
2020-09-11T09:59:37.347+0200 [DEBUG] client.driver_mgr.docker.docker_logger: plugin process exited: driver=docker path=/usr/bin/nomad pid=102351
2020-09-11T09:59:37.347+0200 [DEBUG] client.driver_mgr.docker.docker_logger: plugin exited: driver=docker
2020-09-11T09:59:37.501+0200 [DEBUG] client.driver_mgr.docker: image id reference count decremented: driver=docker image_id=sha256:72e91d8680d853b874d9aedda3a4b61048630d2043dd490ff36f5b0929f69874 references=1
2020-09-11T09:59:37.501+0200 [TRACE] client.alloc_runner.task_runner: running exited hooks: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard start="2020-09-11 09:59:37.501637543 +0200 CEST m=+43.575582917"
2020-09-11T09:59:37.501+0200 [TRACE] client.alloc_runner.task_runner: running exited hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard name=stats_hook start="2020-09-11 09:59:37.501653541 +0200 CEST m=+43.575598910"
2020-09-11T09:59:37.501+0200 [TRACE] client.alloc_runner.task_runner: finished exited hooks: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard name=stats_hook end="2020-09-11 09:59:37.501662596 +0200 CEST m=+43.575607965" duration=9.055µs
2020-09-11T09:59:37.501+0200 [TRACE] client.alloc_runner.task_runner: finished exited hooks: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard end="2020-09-11 09:59:37.501679927 +0200 CEST m=+43.575625295" duration=42.378µs
2020-09-11T09:59:37.501+0200 [TRACE] client.alloc_runner.task_runner: running stop hooks: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard start="2020-09-11 09:59:37.501729435 +0200 CEST m=+43.575674802"
2020-09-11T09:59:37.501+0200 [TRACE] client.alloc_runner.task_runner: running stop hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard name=logmon start="2020-09-11 09:59:37.501737619 +0200 CEST m=+43.575682985"
2020-09-11T09:59:37.502+0200 [DEBUG] client.alloc_runner.task_runner.task_hook.logmon: plugin process exited: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard path=/usr/bin/nomad pid=102298
2020-09-11T09:59:37.502+0200 [DEBUG] client.alloc_runner.task_runner.task_hook.logmon: plugin exited: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard
2020-09-11T09:59:37.502+0200 [TRACE] client.alloc_runner.task_runner: finished stop hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard name=logmon end="2020-09-11 09:59:37.502998371 +0200 CEST m=+43.576943750" duration=1.260765ms
2020-09-11T09:59:37.503+0200 [TRACE] client.alloc_runner.task_runner: running stop hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard name=script_checks start="2020-09-11 09:59:37.503018991 +0200 CEST m=+43.576964369"
2020-09-11T09:59:37.503+0200 [TRACE] client.alloc_runner.task_runner: finished stop hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard name=script_checks end="2020-09-11 09:59:37.503029212 +0200 CEST m=+43.576974580" duration=10.211µs
2020-09-11T09:59:37.503+0200 [TRACE] client.alloc_runner.task_runner: finished stop hooks: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard end="2020-09-11 09:59:37.503035471 +0200 CEST m=+43.576980837" duration=1.306035ms
2020-09-11T09:59:37.503+0200 [DEBUG] client.alloc_runner.task_runner: task run loop exiting: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 task=connect-proxy-count-dashboard
2020-09-11T09:59:37.503+0200 [TRACE] client.alloc_runner: running post-run hooks: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 start="2020-09-11 09:59:37.503056147 +0200 CEST m=+43.577001535"
2020-09-11T09:59:37.503+0200 [INFO] client.gc: marking allocation for GC: alloc_id=4f11511e-782f-27e0-1480-c64812a66525
2020-09-11T09:59:37.503+0200 [TRACE] client.alloc_runner: running post-run hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 name=network start="2020-09-11 09:59:37.503072568 +0200 CEST m=+43.577017941"
2020-09-11T09:59:37.503+0200 [TRACE] client.alloc_runner: sending updated alloc: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 client_status=complete desired_status=
2020-09-11T09:59:37.503+0200 [TRACE] client.alloc_runner: handling task state update: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 done=false
2020-09-11T09:59:37.503+0200 [TRACE] client.alloc_runner: sending updated alloc: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 client_status=complete desired_status=
2020-09-11T09:59:37.601+0200 [DEBUG] client: updated allocations: index=27 total=2 pulled=0 filtered=2
2020-09-11T09:59:37.601+0200 [DEBUG] client: allocation updates: added=0 removed=0 updated=0 ignored=2
2020-09-11T09:59:37.601+0200 [DEBUG] client: allocation updates applied: added=0 removed=0 updated=0 ignored=2 errors=0
2020-09-11T09:59:37.602+0200 [TRACE] client: next heartbeat: period=18.074968497s
2020-09-11T09:59:37.734+0200 [TRACE] client.alloc_runner: finished post-run hooks: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 name=network end="2020-09-11 09:59:37.734066045 +0200 CEST m=+43.808011444" duration=230.993503ms
2020-09-11T09:59:37.734+0200 [TRACE] client.alloc_runner: running post-run hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 name=group_services start="2020-09-11 09:59:37.734106158 +0200 CEST m=+43.808051549"
2020-09-11T09:59:37.734+0200 [TRACE] client.alloc_runner: finished post-run hooks: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 name=group_services end="2020-09-11 09:59:37.734121545 +0200 CEST m=+43.808066927" duration=15.378µs
2020-09-11T09:59:37.734+0200 [TRACE] client.alloc_runner: running post-run hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 name=consul_grpc_socket start="2020-09-11 09:59:37.734131873 +0200 CEST m=+43.808077252"
2020-09-11T09:59:37.734+0200 [TRACE] client.alloc_runner: finished post-run hooks: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 name=consul_grpc_socket end="2020-09-11 09:59:37.734184968 +0200 CEST m=+43.808130346" duration=53.094µs
2020-09-11T09:59:37.734+0200 [TRACE] client.alloc_runner: running post-run hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 name=consul_http_socket start="2020-09-11 09:59:37.734203775 +0200 CEST m=+43.808149154"
2020-09-11T09:59:37.734+0200 [TRACE] client.alloc_runner: finished post-run hooks: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 name=consul_http_socket end="2020-09-11 09:59:37.734211863 +0200 CEST m=+43.808157240" duration=8.086µs
2020-09-11T09:59:37.734+0200 [TRACE] client.alloc_runner: running post-run hook: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 name=csi_hook start="2020-09-11 09:59:37.734220638 +0200 CEST m=+43.808166016"
2020-09-11T09:59:37.734+0200 [TRACE] client.alloc_runner: finished post-run hooks: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 name=csi_hook end="2020-09-11 09:59:37.734229015 +0200 CEST m=+43.808174395" duration=8.379µs
2020-09-11T09:59:37.734+0200 [TRACE] client.alloc_runner: finished post-run hooks: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 end="2020-09-11 09:59:37.734236806 +0200 CEST m=+43.808182182" duration=231.180647ms
2020-09-11T09:59:37.734+0200 [TRACE] client.alloc_runner: handling task state update: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 done=true
2020-09-11T09:59:37.734+0200 [TRACE] client.alloc_runner: sending updated alloc: alloc_id=4f11511e-782f-27e0-1480-c64812a66525 client_status=complete desired_status=
2020-09-11T09:59:37.802+0200 [DEBUG] client: updated allocations: index=28 total=2 pulled=0 filtered=2
2020-09-11T09:59:37.802+0200 [DEBUG] client: allocation updates: added=0 removed=0 updated=0 ignored=2
2020-09-11T09:59:37.803+0200 [DEBUG] client: allocation updates applied: added=0 removed=0 updated=0 ignored=2 errors=0
2020-09-11T09:59:37.803+0200 [TRACE] client: next heartbeat: period=19.290852226s
2020-09-11T09:59:38.715+0200 [TRACE] client.alloc_runner.runner_hook: proxy from Consul complete: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 src_local=/tmp/NomadClient446473161/28986c86-fe5e-e772-e2e6-cc2096d6a1c0/alloc/tmp/consul_grpc.sock src_remote=@ bytes=2644
2020-09-11T09:59:38.716+0200 [TRACE] client.alloc_runner.runner_hook: proxy to Consul complete: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 src_local=/tmp/NomadClient446473161/28986c86-fe5e-e772-e2e6-cc2096d6a1c0/alloc/tmp/consul_grpc.sock src_remote=@ bytes=1450
2020-09-11T09:59:39.054+0200 [INFO] client.fingerprint_mgr.consul: consul agent is unavailable
2020-09-11T09:59:39.073+0200 [ERROR] client.alloc_runner.runner_hook: error connecting to grpc: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 error="dial tcp 127.0.0.1:8502: connect: connection refused" dest=127.0.0.1:8502
2020-09-11T09:59:39.706+0200 [ERROR] client.alloc_runner.runner_hook: error connecting to grpc: alloc_id=28986c86-fe5e-e772-e2e6-cc2096d6a1c0 error="dial tcp 127.0.0.1:8502: connect: connection refused" dest=127.0.0.1:8502
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment