Skip to content

Instantly share code, notes, and snippets.

@guce

guce/server.log

Created February 27, 2020 06:35
Show Gist options
  • Save guce/e528b16b6efe4446287cb74af85e6b3c to your computer and use it in GitHub Desktop.
Save guce/e528b16b6efe4446287cb74af85e6b3c to your computer and use it in GitHub Desktop.
Download ZIP
Raw
server.log
==> Loaded configuration from server.hcl
==> Starting Nomad agent...
==> Nomad agent configuration:
Advertise Addrs: HTTP: 10.0.0.31:4646; RPC: 10.0.0.31:4647; Serf: 10.0.0.31:4648
Bind Addrs: HTTP: 0.0.0.0:4646; RPC: 0.0.0.0:4647; Serf: 0.0.0.0:4648
Client: false
Log Level: DEBUG
Region: global (DC: dc1)
Server: true
Version: 0.10.4
==> Nomad agent started! Log data will stream in below:
2020-02-27T03:51:11.134Z [WARN] agent.plugin_loader: skipping external plugins since plugin_dir doesn't exist: plugin_dir=/tmp/server1/plugins
2020-02-27T03:51:11.135Z [DEBUG] agent.plugin_loader.docker: using client connection initialized from environment: plugin_dir=/tmp/server1/plugins
2020-02-27T03:51:11.135Z [DEBUG] agent.plugin_loader.docker: using client connection initialized from environment: plugin_dir=/tmp/server1/plugins
2020-02-27T03:51:11.135Z [INFO] agent: detected plugin: name=java type=driver plugin_version=0.1.0
2020-02-27T03:51:11.135Z [INFO] agent: detected plugin: name=docker type=driver plugin_version=0.1.0
2020-02-27T03:51:11.135Z [INFO] agent: detected plugin: name=rkt type=driver plugin_version=0.1.0
2020-02-27T03:51:11.135Z [INFO] agent: detected plugin: name=raw_exec type=driver plugin_version=0.1.0
2020-02-27T03:51:11.135Z [INFO] agent: detected plugin: name=exec type=driver plugin_version=0.1.0
2020-02-27T03:51:11.135Z [INFO] agent: detected plugin: name=qemu type=driver plugin_version=0.1.0
2020-02-27T03:51:11.135Z [INFO] agent: detected plugin: name=nvidia-gpu type=device plugin_version=0.1.0
2020-02-27T03:51:11.151Z [INFO] nomad: raft: Initial configuration (index=1): [{Suffrage:Voter ID:10.0.0.31:4647 Address:10.0.0.31:4647}]
2020-02-27T03:51:11.152Z [INFO] nomad: serf: EventMemberJoin: ubuntu-a.global 10.0.0.31
2020-02-27T03:51:11.152Z [INFO] nomad: starting scheduling worker(s): num_workers=1 schedulers=[service, batch, system, _core]
2020-02-27T03:51:11.155Z [INFO] nomad: raft: Node at 10.0.0.31:4647 [Follower] entering Follower state (Leader: "")
2020-02-27T03:51:11.155Z [INFO] nomad: adding server: server="ubuntu-a.global (Addr: 10.0.0.31:4647) (DC: dc1)"
2020-02-27T03:51:11.156Z [DEBUG] nomad: lost contact with Nomad quorum, falling back to Consul for server list
2020-02-27T03:51:11.156Z [ERROR] nomad: error looking up Nomad servers in Consul: error="server.nomad: unable to query Consul datacenters: Get http://127.0.0.1:8500/v1/catalog/datacenters: dial tcp 127.0.0.1:8500: connect: connection refused"
2020-02-27T03:51:12.257Z [WARN] nomad: raft: Heartbeat timeout from "" reached, starting election
2020-02-27T03:51:12.257Z [INFO] nomad: raft: Node at 10.0.0.31:4647 [Candidate] entering Candidate state in term 2
2020-02-27T03:51:12.263Z [DEBUG] nomad: raft: Votes needed: 1
2020-02-27T03:51:12.263Z [DEBUG] nomad: raft: Vote granted from 10.0.0.31:4647 in term 2. Tally: 1
2020-02-27T03:51:12.263Z [INFO] nomad: raft: Election won. Tally: 1
2020-02-27T03:51:12.263Z [INFO] nomad: raft: Node at 10.0.0.31:4647 [Leader] entering Leader state
2020-02-27T03:51:12.263Z [INFO] nomad: cluster leadership acquired
2020-02-27T03:51:12.269Z [INFO] nomad.core: established cluster id: cluster_id=3dcd981b-35d6-f39a-683a-e002a57270d2 create_time=1582775472268091149
2020-02-27T03:52:47.503Z [DEBUG] http: request complete: method=GET path=/v1/agent/members duration=264.346µs
2020-02-27T03:52:47.503Z [DEBUG] http: request complete: method=GET path=/v1/status/leader?region=global duration=58.379µs
2020-02-27T03:52:49.285Z [DEBUG] http: request complete: method=GET path=/v1/agent/members duration=135.12µs
2020-02-27T03:52:49.285Z [DEBUG] http: request complete: method=GET path=/v1/status/leader?region=global duration=53.934µs
2020-02-27T03:52:55.893Z [DEBUG] http: request complete: method=GET path=/v1/nodes duration=244.861µs
2020-02-27T03:52:59.508Z [DEBUG] http: request complete: method=GET path=/v1/nodes?prefix=ac98899c duration=286.25µs
2020-02-27T03:52:59.509Z [DEBUG] http: request complete: method=GET path=/v1/node/ac98899c-ea2a-033d-0e42-aae6a11c27ec duration=250.637µs
2020-02-27T03:52:59.512Z [DEBUG] http: request complete: method=GET path=/v1/client/stats?node_id=ac98899c-ea2a-033d-0e42-aae6a11c27ec duration=1.841713ms
2020-02-27T03:52:59.518Z [DEBUG] http: request complete: method=GET path=/v1/node/ac98899c-ea2a-033d-0e42-aae6a11c27ec/allocations duration=184.263µs
2020-02-27T03:52:59.522Z [DEBUG] http: request complete: method=GET path=/v1/node/ac98899c-ea2a-033d-0e42-aae6a11c27ec/allocations duration=102.493µs
2020-02-27T03:53:10.469Z [DEBUG] nomad.job.service_sched: reconciled current state with desired state: eval_id=9808ef25-a0c4-769d-ffa7-6f1433253e37 job_id=example namespace=default results="Total changes: (place 1) (destructive 0) (inplace 0) (stop 0)
Created Deployment: "b5806782-cc39-1a39-5a01-68a11b492f34"
Desired Changes for "cache": (place 1) (inplace 0) (destructive 0) (stop 0) (migrate 0) (ignore 0) (canary 0)"
2020-02-27T03:53:10.469Z [DEBUG] nomad.job.service_sched: failed to place all allocations, blocked eval created: eval_id=9808ef25-a0c4-769d-ffa7-6f1433253e37 job_id=example namespace=default blocked_eval_id=7fac0144-b6fe-8682-1d9e-cfb833486c55
2020-02-27T03:53:10.469Z [DEBUG] nomad.job.service_sched: setting eval status: eval_id=9808ef25-a0c4-769d-ffa7-6f1433253e37 job_id=example namespace=default status=complete
2020-02-27T03:53:10.470Z [DEBUG] http: request complete: method=PUT path=/v1/job/example/plan duration=1.508885ms
2020-02-27T03:53:39.126Z [DEBUG] http: request complete: method=PUT path=/v1/jobs duration=3.503802ms
2020-02-27T03:53:39.126Z [DEBUG] worker: dequeued evaluation: eval_id=44a2ca92-b815-0a56-4b90-8d8eb85f2ae0
2020-02-27T03:53:39.127Z [DEBUG] worker.service_sched: reconciled current state with desired state: eval_id=44a2ca92-b815-0a56-4b90-8d8eb85f2ae0 job_id=example namespace=default results="Total changes: (place 1) (destructive 0) (inplace 0) (stop 0)
Created Deployment: "be8b274d-ff94-afd3-aa14-c20f4e7a061b"
Desired Changes for "cache": (place 1) (inplace 0) (destructive 0) (stop 0) (migrate 0) (ignore 0) (canary 0)"
2020-02-27T03:53:39.128Z [DEBUG] worker: created evaluation: eval="<Eval "a3dc063c-fe1e-ee17-10f9-f97d233a7f7a" JobID: "example" Namespace: "default">"
2020-02-27T03:53:39.128Z [DEBUG] worker.service_sched: failed to place all allocations, blocked eval created: eval_id=44a2ca92-b815-0a56-4b90-8d8eb85f2ae0 job_id=example namespace=default blocked_eval_id=a3dc063c-fe1e-ee17-10f9-f97d233a7f7a
2020-02-27T03:53:39.129Z [DEBUG] http: request complete: method=GET path=/v1/evaluation/44a2ca92-b815-0a56-4b90-8d8eb85f2ae0 duration=233.837µs
2020-02-27T03:53:39.130Z [DEBUG] worker: submitted plan for evaluation: eval_id=44a2ca92-b815-0a56-4b90-8d8eb85f2ae0
2020-02-27T03:53:39.130Z [DEBUG] worker.service_sched: setting eval status: eval_id=44a2ca92-b815-0a56-4b90-8d8eb85f2ae0 job_id=example namespace=default status=complete
2020-02-27T03:53:39.131Z [DEBUG] http: request complete: method=GET path=/v1/evaluation/44a2ca92-b815-0a56-4b90-8d8eb85f2ae0/allocations duration=101.456µs
2020-02-27T03:53:39.133Z [DEBUG] worker: updated evaluation: eval="<Eval "44a2ca92-b815-0a56-4b90-8d8eb85f2ae0" JobID: "example" Namespace: "default">"
2020-02-27T03:53:39.133Z [DEBUG] worker: ack evaluation: eval_id=44a2ca92-b815-0a56-4b90-8d8eb85f2ae0
2020-02-27T03:53:40.133Z [DEBUG] http: request complete: method=GET path=/v1/evaluation/44a2ca92-b815-0a56-4b90-8d8eb85f2ae0 duration=253.333µs
2020-02-27T03:53:40.134Z [DEBUG] http: request complete: method=GET path=/v1/evaluation/44a2ca92-b815-0a56-4b90-8d8eb85f2ae0/allocations duration=144.263µs
2020-02-27T03:53:47.931Z [DEBUG] http: request complete: method=GET path=/v1/jobs?prefix=example duration=319.913µs
2020-02-27T03:53:47.932Z [DEBUG] http: request complete: method=GET path=/v1/job/example duration=252.24µs
2020-02-27T03:53:47.936Z [DEBUG] http: request complete: method=GET path=/v1/job/example/allocations?all=false duration=174.57µs
2020-02-27T03:53:47.936Z [DEBUG] http: request complete: method=GET path=/v1/job/example/evaluations duration=235.162µs
2020-02-27T03:53:47.937Z [DEBUG] http: request complete: method=GET path=/v1/job/example/deployment duration=108.723µs
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment