Skip to content

Instantly share code, notes, and snippets.

@Toady00

Toady00/assorted docker logs from tail -f

Last active April 14, 2016 01:01
Show Gist options
  • Save Toady00/980dd5b8b5e6d94c04e60bf8acf649c1 to your computer and use it in GitHub Desktop.
Save Toady00/980dd5b8b5e6d94c04e60bf8acf649c1 to your computer and use it in GitHub Desktop.
Download ZIP
Raw
assorted docker logs from tail -f
==> /Users/brandon/Library/Containers/com.docker.docker/Data/logs/2016-04-13/com.docker.driver.amd64-linux.log <==
2016-04-13T20:48:58.715775-04 Info - proxy >> POST /images/create?fromImage=redis&tag=latest
2016-04-13T20:48:58.715879-04 Info - Dial /tmp/u.socket
2016-04-13T20:48:58.715950-04 Info - Dial IP /tmp/u.socket
==> /Users/brandon/Library/Containers/com.docker.docker/Data/logs/2016-04-13/com.docker.slirp.log <==
2016-04-13T20:48:58.727232-04 Error - com.docker.slirp: [INFO] unix:/tmp/u2.socket:192.168.64.2:2375: connected
==> /Users/brandon/Library/Containers/com.docker.docker/Data/logs/2016-04-13/com.docker.driver.amd64-linux.log <==
2016-04-13T20:49:00.088432-04 Info - proxy << POST /images/create?fromImage=redis&tag=latest
==> /Users/brandon/Library/Containers/com.docker.docker/Data/logs/2016-04-13/com.docker.slirp.log <==
2016-04-13T20:49:00.099052-04 Error - com.docker.slirp: [INFO] unix:/tmp/u2.socket:192.168.64.2:2375 completed: l2r = 1.6 KiB bytes at 1.2 KiB/sec and 14.6 IOPS/sec; r2l = 164 bytes bytes at 119 bytes/sec and 0.7 IOPS/sec
2016-04-13T20:49:00.099197-04 Error - com.docker.slirp: [INFO] unix:/tmp/u2.socket:192.168.64.2:2375: connected
2016-04-13T20:49:00.099299-04 Error - com.docker.slirp: [INFO] unix:/tmp/u2.socket:192.168.64.2:2375 completed: l2r = 3.2 KiB bytes at 1.2 MiB/sec and 398.5 IOPS/sec; r2l = 111 bytes bytes at 54.0 KiB/sec and 498.5 IOPS/sec
==> /Users/brandon/Library/Containers/com.docker.docker/Data/logs/2016-04-13/com.docker.driver.amd64-linux.log <==
2016-04-13T20:49:00.109665-04 Info - proxy >> GET /images/redis:latest/json
2016-04-13T20:49:00.109755-04 Info - Dial /tmp/u.socket
2016-04-13T20:49:00.109814-04 Info - Dial IP /tmp/u.socket
2016-04-13T20:49:00.109864-04 Info - proxy << GET /images/redis:latest/json
2016-04-13T20:49:00.109919-04 Info - proxy >> POST /containers/create?name=redis-40a81f2f-4a82-0415-dc0f-91b1912f32d5 [rewriteBinds]
2016-04-13T20:49:00.109978-04 Info - proxy >> POST /containers/create?name=redis-40a81f2f-4a82-0415-dc0f-91b1912f32d5
2016-04-13T20:49:00.110032-04 Info - Dial /tmp/u.socket
2016-04-13T20:49:00.110080-04 Info - Dial IP /tmp/u.socket
==> /Users/brandon/Library/Containers/com.docker.docker/Data/logs/2016-04-13/com.docker.slirp.log <==
2016-04-13T20:49:00.119922-04 Error - com.docker.slirp: [INFO] unix:/tmp/u2.socket:192.168.64.2:2375: connected
==> /Users/brandon/Library/Containers/com.docker.docker/Data/logs/2016-04-13/com.docker.driver.amd64-linux.log <==
2016-04-13T20:49:00.237573-04 Info - proxy << POST /containers/create?name=redis-40a81f2f-4a82-0415-dc0f-91b1912f32d5
==> /Users/brandon/Library/Containers/com.docker.docker/Data/logs/2016-04-13/com.docker.slirp.log <==
2016-04-13T20:49:00.247816-04 Error - com.docker.slirp: [INFO] unix:/tmp/u2.socket:192.168.64.2:2375 completed: l2r = 238 bytes bytes at 1.8 KiB/sec and 7.8 IOPS/sec; r2l = 2.0 KiB bytes at 15.8 KiB/sec and 7.9 IOPS/sec
2016-04-13T20:49:00.247950-04 Error - com.docker.slirp: [INFO] unix:/tmp/u2.socket:192.168.64.2:2375: connected
==> /Users/brandon/Library/Containers/com.docker.docker/Data/logs/2016-04-13/com.docker.osxfs.log <==
2016-04-13T20:49:00.258108-04 Error - com.docker.osxfs: [ERROR] Volume.start db06a8a475749d7853c9bcab1a6fd21189bdf60c2e48de6efa27a269cb06b24f (paths = [/tmp/NomadClient725463834/40a81f2f-4a82-0415-dc0f-91b1912f32d5/alloc, /tmp/NomadClient725463834/40a81f2f-4a82-0415-dc0f-91b1912f32d5/redis])
2016-04-13T20:49:00.258262-04 Error - Adding watch for /tmp/NomadClient725463834/40a81f2f-4a82-0415-dc0f-91b1912f32d5/alloc
2016-04-13T20:49:00.258358-04 Error - Volume: watching /tmp/NomadClient725463834/40a81f2f-4a82-0415-dc0f-91b1912f32d5/alloc since now
2016-04-13T20:49:00.258446-04 Error - Adding watch for /tmp/NomadClient725463834/40a81f2f-4a82-0415-dc0f-91b1912f32d5/redis
2016-04-13T20:49:00.258534-04 Error - Volume: watching /tmp/NomadClient725463834/40a81f2f-4a82-0415-dc0f-91b1912f32d5/redis since now
==> /Users/brandon/Library/Containers/com.docker.docker/Data/logs/2016-04-13/com.docker.driver.amd64-linux.log <==
2016-04-13T20:49:00.268469-04 Info - proxy >> POST /containers/db06a8a475749d7853c9bcab1a6fd21189bdf60c2e48de6efa27a269cb06b24f/start [start]
2016-04-13T20:49:00.268567-04 Info - approve db06a8a475749d7853c9bcab1a6fd21189bdf60c2e48de6efa27a269cb06b24f:/tmp/NomadClient725463834/40a81f2f-4a82-0415-dc0f-91b1912f32d5/alloc:/tmp/NomadClient725463834/40a81f2f-4a82-0415-dc0f-91b1912f32d5/redis
2016-04-13T20:49:00.268665-04 Info - Approve db06a8a475749d7853c9bcab1a6fd21189bdf60c2e48de6efa27a269cb06b24f:/tmp/NomadClient725463834/40a81f2f-4a82-0415-dc0f-91b1912f32d5/alloc:/tmp/NomadClient725463834/40a81f2f-4a82-0415-dc0f-91b1912f32d5/redis: succeeded
2016-04-13T20:49:00.268739-04 Info - proxy >> POST /containers/db06a8a475749d7853c9bcab1a6fd21189bdf60c2e48de6efa27a269cb06b24f/start
2016-04-13T20:49:00.268803-04 Info - Dial /tmp/u.socket
2016-04-13T20:49:00.268865-04 Info - Dial IP /tmp/u.socket
2016-04-13T20:49:00.571680-04 Info - eventCallback container die: db06a8a475749d7853c9bcab1a6fd21189bdf60c2e48de6efa27a269cb06b24f (#watchers: 1)
2016-04-13T20:49:00.571854-04 Info - remove db06a8a475749d7853c9bcab1a6fd21189bdf60c2e48de6efa27a269cb06b24f
==> /Users/brandon/Library/Containers/com.docker.docker/Data/logs/2016-04-13/com.docker.slirp.log <==
2016-04-13T20:49:00.583158-04 Error - com.docker.slirp: [INFO] unix:/tmp/u2.socket:192.168.64.2:2375 completed: l2r = 297 bytes bytes at 900 bytes/sec and 3.0 IOPS/sec; r2l = 220 bytes bytes at 669 bytes/sec and 3.0 IOPS/sec
==> /Users/brandon/Library/Containers/com.docker.docker/Data/logs/2016-04-13/com.docker.osxfs.log <==
2016-04-13T20:49:00.593932-04 Error - com.docker.osxfs: [ERROR] Volume.stop db06a8a475749d7853c9bcab1a6fd21189bdf60c2e48de6efa27a269cb06b24f (paths = [/tmp/NomadClient725463834/40a81f2f-4a82-0415-dc0f-91b1912f32d5/alloc, /tmp/NomadClient725463834/40a81f2f-4a82-0415-dc0f-91b1912f32d5/redis])
2016-04-13T20:49:00.594114-04 Error - Removing watch for /tmp/NomadClient725463834/40a81f2f-4a82-0415-dc0f-91b1912f32d5/alloc
2016-04-13T20:49:00.594263-04 Error - about to flush watcher for /tmp/NomadClient725463834/40a81f2f-4a82-0415-dc0f-91b1912f32d5/alloc
2016-04-13T20:49:00.594405-04 Error - stopped watching /tmp/NomadClient725463834/40a81f2f-4a82-0415-dc0f-91b1912f32d5/alloc
2016-04-13T20:49:00.594541-04 Error - Removing watch for /tmp/NomadClient725463834/40a81f2f-4a82-0415-dc0f-91b1912f32d5/redis
2016-04-13T20:49:00.594672-04 Error - about to flush watcher for /tmp/NomadClient725463834/40a81f2f-4a82-0415-dc0f-91b1912f32d5/redis
2016-04-13T20:49:00.594798-04 Error - Stream ended (start)
2016-04-13T20:49:00.594939-04 Error - stopped watching /tmp/NomadClient725463834/40a81f2f-4a82-0415-dc0f-91b1912f32d5/redis
2016-04-13T20:49:00.595066-04 Error - removed last watch
2016-04-13T20:49:00.595187-04 Error - Stream ended (start)
==> /Users/brandon/Library/Containers/com.docker.docker/Data/logs/2016-04-13/com.docker.driver.amd64-linux.log <==
2016-04-13T20:49:00.605437-04 Info - proxy << POST /containers/db06a8a475749d7853c9bcab1a6fd21189bdf60c2e48de6efa27a269cb06b24f/start
2016-04-13T20:49:00.605596-04 Info - remove db06a8a475749d7853c9bcab1a6fd21189bdf60c2e48de6efa27a269cb06b24f: succeeded
Raw
bash
$ nomad run example.nomad
==> Monitoring evaluation "195e9d44"
Evaluation triggered by job "example"
Allocation "40a81f2f" created: node "f2f29ff4", group "cache"
Evaluation status changed: "pending" -> "complete"
==> Evaluation "195e9d44" finished with status "complete"
$ nomad status
ID Type Priority Status
example service 50 dead
$ nomad status example
ID = example
Name = example
Type = service
Priority = 50
Datacenters = dc1
Status = dead
Periodic = false
==> Evaluations
ID Priority Triggered By Status
195e9d44 50 job-register complete
==> Allocations
ID Eval ID Node ID Task Group Desired Status
40a81f2f 195e9d44 f2f29ff4 cache run failed
$ nomad alloc-status 40a81f2f
ID = 40a81f2f
Eval ID = 195e9d44
Name = example.cache[0]
Node ID = f2f29ff4
Job ID = example
Client Status = failed
Evaluated Nodes = 1
Filtered Nodes = 0
Exhausted Nodes = 0
Allocation Time = 81.184µs
Failures = 0
==> Task "redis" is "dead"
Recent Events:
Time Type Description
13/04/16 20:49:00 EDT Restarts Exceeded Task exceeded restart policy
13/04/16 20:49:00 EDT Driver Failure Failed to start container db06a8a475749d7853c9bcab1a6fd21189bdf60c2e48de6efa27a269cb06b24f: API error (500): stat /tmp/NomadClient725463834/40a81f2f-4a82-0415-dc0f-91b1912f32d5/alloc: permission denied
13/04/16 20:48:58 EDT Received Task received by client
==> Status
Allocation "40a81f2f" status "failed" (0/1 nodes filtered)
* Score "f2f29ff4-ee2d-a0c7-7edd-f138e6ae973f.binpack" = 3.566715
==> Task Resources
Task: "redis"
CPU Memory MB Disk MB IOPS Addresses
500 256 300 0 db: 127.0.0.1:51423
Raw
example.nomad
# There can only be a single job definition per file.
# Create a job with ID and Name 'example'
job "example" {
# Run the job in the global region, which is the default.
# region = "global"
# Specify the datacenters within the region this job can run in.
datacenters = ["dc1"]
# Service type jobs optimize for long-lived services. This is
# the default but we can change to batch for short-lived tasks.
# type = "service"
# Priority controls our access to resources and scheduling priority.
# This can be 1 to 100, inclusively, and defaults to 50.
# priority = 50
# Restrict our job to only linux. We can specify multiple
# constraints as needed.
constraint {
attribute = "${attr.kernel.name}"
value = "darwin"
}
# Configure the job to do rolling updates
update {
# Stagger updates every 10 seconds
stagger = "10s"
# Update a single task at a time
max_parallel = 1
}
# Create a 'cache' group. Each task in the group will be
# scheduled onto the same machine.
group "cache" {
# Control the number of instances of this groups.
# Defaults to 1
# count = 1
# Configure the restart policy for the task group. If not provided, a
# default is used based on the job type.
restart {
# The number of attempts to run the job within the specified interval.
attempts = 10
interval = "5m"
# A delay between a task failing and a restart occurring.
delay = "25s"
# Mode controls what happens when a task has restarted "attempts"
# times within the interval. "delay" mode delays the next restart
# till the next interval. "fail" mode does not restart the task if
# "attempts" has been hit within the interval.
mode = "delay"
}
# Define a task to run
task "redis" {
# Use Docker to run the task.
driver = "docker"
# Configure Docker driver with the image
config {
image = "redis:latest"
port_map {
db = 6379
}
}
service {
name = "${TASKGROUP}-redis"
tags = ["global", "cache"]
port = "db"
check {
name = "alive"
type = "tcp"
interval = "10s"
timeout = "2s"
}
}
# We must specify the resources required for
# this task to ensure it runs on a machine with
# enough capacity.
resources {
cpu = 500 # 500 Mhz
memory = 256 # 256MB
network {
mbits = 10
port "db" {
}
}
}
# The artifact block can be specified one or more times to download
# artifacts prior to the task being started. This is convenient for
# shipping configs or data needed by the task.
# artifact {
# source = "http://foo.com/artifact.tar.gz"
# options {
# checksum = "md5:c4aa853ad2215426eb7d70a21922e794"
# }
# }
# Specify configuration related to log rotation
# logs {
# max_files = 10
# max_file_size = 15
# }
# Controls the timeout between signalling a task it will be killed
# and killing the task. If not set a default is used.
# kill_timeout = "20s"
}
}
}
Raw
nomad.out
2016/04/13 20:48:58 [DEBUG] http: Request /v1/jobs (1.684107ms) 2016/04/13 20:48:58 [DEBUG] worker: dequeued evaluation 195e9d44-4374-d4e1-0bb5-9688a814d0ca
2016/04/13 20:48:58 [DEBUG] sched: <Eval '195e9d44-4374-d4e1-0bb5-9688a814d0ca' JobID: 'example'>: allocs: (place 1) (update 0) (migrate 0) (stop 0) (ignore 0)
2016/04/13 20:48:58 [DEBUG] http: Request /v1/evaluation/195e9d44-4374-d4e1-0bb5-9688a814d0ca (140.086µs)
2016/04/13 20:48:58 [DEBUG] client: updated allocations at index 8 (pulled 1) (filtered 0)
2016/04/13 20:48:58 [DEBUG] worker: submitted plan for evaluation 195e9d44-4374-d4e1-0bb5-9688a814d0ca
2016/04/13 20:48:58 [DEBUG] sched: <Eval '195e9d44-4374-d4e1-0bb5-9688a814d0ca' JobID: 'example'>: setting status to complete
2016/04/13 20:48:58 [DEBUG] worker: updated evaluation <Eval '195e9d44-4374-d4e1-0bb5-9688a814d0ca' JobID: 'example'>
2016/04/13 20:48:58 [DEBUG] worker: ack for evaluation 195e9d44-4374-d4e1-0bb5-9688a814d0ca
2016/04/13 20:48:58 [DEBUG] client: allocs: (added 1) (removed 0) (updated 0) (ignore 0)
2016/04/13 20:48:58 [DEBUG] http: Request /v1/evaluation/195e9d44-4374-d4e1-0bb5-9688a814d0ca/allocations (247.69µs)
2016/04/13 20:48:58 [DEBUG] client: starting task runners for alloc '40a81f2f-4a82-0415-dc0f-91b1912f32d5'
2016/04/13 20:48:58 [DEBUG] client: starting task context for 'redis' (alloc '40a81f2f-4a82-0415-dc0f-91b1912f32d5')
2016/04/13 20:48:59 [DEBUG] http: Request /v1/evaluation/195e9d44-4374-d4e1-0bb5-9688a814d0ca (108.002µs)
2016/04/13 20:48:59 [DEBUG] http: Request /v1/evaluation/195e9d44-4374-d4e1-0bb5-9688a814d0ca/allocations (120.821µs)
2016/04/13 20:49:00 [DEBUG] driver.docker: docker pull redis:latest succeeded
2016/04/13 20:49:00 [DEBUG] driver.docker: identified image redis:latest as sha256:4f5f397d4b7ca414891bd2959ef71c83bb7010d095efb2497f0b2f407cb50f0d
2016/04/13 20:49:00 [DEBUG] plugin: starting plugin: /usr/local/Cellar/nomad/0.3.1/bin/nomad []string{"/usr/local/Cellar/nomad/0.3.1/bin/nomad", "syslog", "/tmp/NomadClient725463834/40a81f2f-4a82-0415-dc0f-91b1912f32d5/redis/redis-syslog-collector.out"}
2016/04/13 20:49:00 [DEBUG] plugin: waiting for RPC address for: /usr/local/Cellar/nomad/0.3.1/bin/nomad
2016/04/13 20:49:00 [DEBUG] plugin: nomad: 2016/04/13 20:49:00 [DEBUG] plugin: plugin address: unix /tmp/plugin512310033
2016/04/13 20:49:00 [DEBUG] driver.docker: using 268435456 bytes memory for redis:latest
2016/04/13 20:49:00 [DEBUG] driver.docker: using 500 cpu shares for redis:latest
2016/04/13 20:49:00 [DEBUG] driver.docker: binding directories []string{"/tmp/NomadClient725463834/40a81f2f-4a82-0415-dc0f-91b1912f32d5/alloc:/alloc:rw,z", "/tmp/NomadClient725463834/40a81f2f-4a82-0415-dc0f-91b1912f32d5/redis:/local:rw,Z"} for redis:latest
2016/04/13 20:49:00 [DEBUG] driver.docker: networking mode not specified; defaulting to bridge
2016/04/13 20:49:00 [DEBUG] driver.docker: allocated port 127.0.0.1:51423 -> 6379 (mapped)
2016/04/13 20:49:00 [DEBUG] driver.docker: exposed port 6379
2016/04/13 20:49:00 [DEBUG] driver.docker: setting container name to: redis-40a81f2f-4a82-0415-dc0f-91b1912f32d5
2016/04/13 20:49:00 [INFO] driver.docker: created container db06a8a475749d7853c9bcab1a6fd21189bdf60c2e48de6efa27a269cb06b24f
2016/04/13 20:49:00 [ERR] driver.docker: failed to start container db06a8a475749d7853c9bcab1a6fd21189bdf60c2e48de6efa27a269cb06b24f: API error (500): stat /tmp/NomadClient725463834/40a81f2f-4a82-0415-dc0f-91b1912f32d5/alloc: permission denied
2016/04/13 20:49:00 [DEBUG] plugin: /usr/local/Cellar/nomad/0.3.1/bin/nomad: plugin process exited
2016/04/13 20:49:00 [ERR] client: failed to start task 'redis' for alloc '40a81f2f-4a82-0415-dc0f-91b1912f32d5': Failed to start container db06a8a475749d7853c9bcab1a6fd21189bdf60c2e48de6efa27a269cb06b24f: API error (500): stat /tmp/NomadClient725463834/40a81f2f-4a82-0415-dc0f-91b1912f32d5/alloc: permission denied
2016/04/13 20:49:00 [INFO] client: Not restarting task: redis for alloc: 40a81f2f-4a82-0415-dc0f-91b1912f32d5
2016/04/13 20:49:00 [DEBUG] client: updated allocations at index 10 (pulled 0) (filtered 1)
2016/04/13 20:49:00 [DEBUG] client: allocs: (added 0) (removed 0) (updated 0) (ignore 1)
2016/04/13 20:49:11 [DEBUG] http: Request /v1/jobs (76.275µs)
2016/04/13 20:49:18 [DEBUG] http: Request /v1/job/example (159.055µs)
2016/04/13 20:49:18 [DEBUG] http: Request /v1/job/example/evaluations (83.297µs)
2016/04/13 20:49:18 [DEBUG] http: Request /v1/job/example/allocations (80.946µs)
2016/04/13 20:49:41 [ERR] http: Request /v1/allocation/40a81f2f, error: alloc lookup failed: index error: UUID must be 36 characters
2016/04/13 20:49:41 [DEBUG] http: Request /v1/allocation/40a81f2f (200.087µs)
2016/04/13 20:49:41 [DEBUG] http: Request /v1/allocations?prefix=40a81f2f (131.433µs)
2016/04/13 20:49:41 [DEBUG] http: Request /v1/allocation/40a81f2f-4a82-0415-dc0f-91b1912f32d5 (236.115µs)
2016/04/13 20:53:34 [DEBUG] worker: dequeued evaluation 43f9d7ac-3233-07c7-8e92-4f0560c9c030
2016/04/13 20:53:34 [DEBUG] sched.core: eval GC: scanning before index 0 (1h0m0s)
2016/04/13 20:53:34 [DEBUG] worker: ack for evaluation 43f9d7ac-3233-07c7-8e92-4f0560c9c030
2016/04/13 20:53:34 [DEBUG] worker: dequeued evaluation b2977dd8-b8f5-d8ed-8849-e5a7a94f33cc
2016/04/13 20:53:34 [DEBUG] sched.core: job GC: scanning before index 0 (4h0m0s)
2016/04/13 20:53:34 [DEBUG] worker: ack for evaluation b2977dd8-b8f5-d8ed-8849-e5a7a94f33cc
2016/04/13 20:53:34 [DEBUG] worker: dequeued evaluation 15ef8bba-da26-b053-2613-618c03e0491a
2016/04/13 20:53:34 [DEBUG] sched.core: node GC: scanning before index 0 (24h0m0s)
2016/04/13 20:53:34 [DEBUG] worker: ack for evaluation 15ef8bba-da26-b053-2613-618c03e0491a
2016/04/13 20:54:19 [DEBUG] client: updated allocations at index 10 (pulled 0) (filtered 1)
2016/04/13 20:54:19 [DEBUG] client: allocs: (added 0) (removed 0) (updated 0) (ignore 1)
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment