github.com/walkingsparrow/docker@v1.4.2-0.20151218153551-b708a2249bfa/integration-cli/docker_cli_events_test.go (about)

     1  package main
     2  
     3  import (
     4  	"bufio"
     5  	"bytes"
     6  	"fmt"
     7  	"io/ioutil"
     8  	"net/http"
     9  	"os"
    10  	"os/exec"
    11  	"regexp"
    12  	"strconv"
    13  	"strings"
    14  	"sync"
    15  	"time"
    16  
    17  	"github.com/docker/docker/pkg/integration/checker"
    18  	"github.com/go-check/check"
    19  )
    20  
    21  func (s *DockerSuite) TestEventsTimestampFormats(c *check.C) {
    22  	testRequires(c, DaemonIsLinux)
    23  	image := "busybox"
    24  
    25  	// Start stopwatch, generate an event
    26  	time.Sleep(1 * time.Second) // so that we don't grab events from previous test occured in the same second
    27  	start := daemonTime(c)
    28  	dockerCmd(c, "tag", image, "timestamptest:1")
    29  	dockerCmd(c, "rmi", "timestamptest:1")
    30  	time.Sleep(1 * time.Second) // so that until > since
    31  	end := daemonTime(c)
    32  
    33  	// List of available time formats to --since
    34  	unixTs := func(t time.Time) string { return fmt.Sprintf("%v", t.Unix()) }
    35  	rfc3339 := func(t time.Time) string { return t.Format(time.RFC3339) }
    36  	duration := func(t time.Time) string { return time.Now().Sub(t).String() }
    37  
    38  	// --since=$start must contain only the 'untag' event
    39  	for _, f := range []func(time.Time) string{unixTs, rfc3339, duration} {
    40  		since, until := f(start), f(end)
    41  		out, _ := dockerCmd(c, "events", "--since="+since, "--until="+until)
    42  		events := strings.Split(strings.TrimSpace(out), "\n")
    43  		c.Assert(events, checker.HasLen, 2, check.Commentf("unexpected events, was expecting only 2 events tag/untag (since=%s, until=%s) out=%s", since, until, out))
    44  		c.Assert(out, checker.Contains, "untag", check.Commentf("expected 'untag' event not found (since=%s, until=%s)", since, until))
    45  	}
    46  
    47  }
    48  
    49  func (s *DockerSuite) TestEventsUntag(c *check.C) {
    50  	testRequires(c, DaemonIsLinux)
    51  	image := "busybox"
    52  	dockerCmd(c, "tag", image, "utest:tag1")
    53  	dockerCmd(c, "tag", image, "utest:tag2")
    54  	dockerCmd(c, "rmi", "utest:tag1")
    55  	dockerCmd(c, "rmi", "utest:tag2")
    56  	eventsCmd := exec.Command(dockerBinary, "events", "--since=1")
    57  	out, exitCode, _, err := runCommandWithOutputForDuration(eventsCmd, time.Duration(time.Millisecond*2500))
    58  	c.Assert(err, checker.IsNil)
    59  	c.Assert(exitCode, checker.Equals, 0, check.Commentf("Failed to get events"))
    60  	events := strings.Split(out, "\n")
    61  	nEvents := len(events)
    62  	// The last element after the split above will be an empty string, so we
    63  	// get the two elements before the last, which are the untags we're
    64  	// looking for.
    65  	for _, v := range events[nEvents-3 : nEvents-1] {
    66  		c.Assert(v, checker.Contains, "untag", check.Commentf("event should be untag"))
    67  	}
    68  }
    69  
    70  func (s *DockerSuite) TestEventsContainerFailStartDie(c *check.C) {
    71  
    72  	out, _ := dockerCmd(c, "images", "-q")
    73  	image := strings.Split(out, "\n")[0]
    74  	_, _, err := dockerCmdWithError("run", "--name", "testeventdie", image, "blerg")
    75  	c.Assert(err, checker.NotNil, check.Commentf("Container run with command blerg should have failed, but it did not, out=%s", out))
    76  
    77  	out, _ = dockerCmd(c, "events", "--since=0", fmt.Sprintf("--until=%d", daemonTime(c).Unix()))
    78  	events := strings.Split(out, "\n")
    79  	c.Assert(len(events), checker.GreaterThan, 1) //Missing expected event
    80  
    81  	startEvent := strings.Fields(events[len(events)-3])
    82  	dieEvent := strings.Fields(events[len(events)-2])
    83  
    84  	c.Assert(startEvent[len(startEvent)-1], checker.Equals, "start", check.Commentf("event should be start, not %#v", startEvent))
    85  	c.Assert(dieEvent[len(dieEvent)-1], checker.Equals, "die", check.Commentf("event should be die, not %#v", dieEvent))
    86  
    87  }
    88  
    89  func (s *DockerSuite) TestEventsLimit(c *check.C) {
    90  	testRequires(c, DaemonIsLinux)
    91  	var waitGroup sync.WaitGroup
    92  	errChan := make(chan error, 17)
    93  
    94  	args := []string{"run", "--rm", "busybox", "true"}
    95  	for i := 0; i < 17; i++ {
    96  		waitGroup.Add(1)
    97  		go func() {
    98  			defer waitGroup.Done()
    99  			errChan <- exec.Command(dockerBinary, args...).Run()
   100  		}()
   101  	}
   102  
   103  	waitGroup.Wait()
   104  	close(errChan)
   105  
   106  	for err := range errChan {
   107  		c.Assert(err, checker.IsNil, check.Commentf("%q failed with error", strings.Join(args, " ")))
   108  	}
   109  
   110  	out, _ := dockerCmd(c, "events", "--since=0", fmt.Sprintf("--until=%d", daemonTime(c).Unix()))
   111  	events := strings.Split(out, "\n")
   112  	nEvents := len(events) - 1
   113  	c.Assert(nEvents, checker.Equals, 64, check.Commentf("events should be limited to 64, but received %d", nEvents))
   114  }
   115  
   116  func (s *DockerSuite) TestEventsContainerEvents(c *check.C) {
   117  	testRequires(c, DaemonIsLinux)
   118  	dockerCmd(c, "run", "--rm", "busybox", "true")
   119  	out, _ := dockerCmd(c, "events", "--since=0", fmt.Sprintf("--until=%d", daemonTime(c).Unix()))
   120  	events := strings.Split(out, "\n")
   121  	events = events[:len(events)-1]
   122  	c.Assert(len(events), checker.GreaterOrEqualThan, 5) //Missing expected event
   123  	createEvent := strings.Fields(events[len(events)-5])
   124  	attachEvent := strings.Fields(events[len(events)-4])
   125  	startEvent := strings.Fields(events[len(events)-3])
   126  	dieEvent := strings.Fields(events[len(events)-2])
   127  	destroyEvent := strings.Fields(events[len(events)-1])
   128  	c.Assert(createEvent[len(createEvent)-1], checker.Equals, "create", check.Commentf("event should be create, not %#v", createEvent))
   129  	c.Assert(attachEvent[len(attachEvent)-1], checker.Equals, "attach", check.Commentf("event should be attach, not %#v", attachEvent))
   130  	c.Assert(startEvent[len(startEvent)-1], checker.Equals, "start", check.Commentf("event should be start, not %#v", startEvent))
   131  	c.Assert(dieEvent[len(dieEvent)-1], checker.Equals, "die", check.Commentf("event should be die, not %#v", dieEvent))
   132  	c.Assert(destroyEvent[len(destroyEvent)-1], checker.Equals, "destroy", check.Commentf("event should be destroy, not %#v", destroyEvent))
   133  
   134  }
   135  
   136  func (s *DockerSuite) TestEventsContainerEventsSinceUnixEpoch(c *check.C) {
   137  	testRequires(c, DaemonIsLinux)
   138  	dockerCmd(c, "run", "--rm", "busybox", "true")
   139  	timeBeginning := time.Unix(0, 0).Format(time.RFC3339Nano)
   140  	timeBeginning = strings.Replace(timeBeginning, "Z", ".000000000Z", -1)
   141  	out, _ := dockerCmd(c, "events", fmt.Sprintf("--since='%s'", timeBeginning),
   142  		fmt.Sprintf("--until=%d", daemonTime(c).Unix()))
   143  	events := strings.Split(out, "\n")
   144  	events = events[:len(events)-1]
   145  	c.Assert(len(events), checker.GreaterOrEqualThan, 5) //Missing expected event
   146  	createEvent := strings.Fields(events[len(events)-5])
   147  	attachEvent := strings.Fields(events[len(events)-4])
   148  	startEvent := strings.Fields(events[len(events)-3])
   149  	dieEvent := strings.Fields(events[len(events)-2])
   150  	destroyEvent := strings.Fields(events[len(events)-1])
   151  	c.Assert(createEvent[len(createEvent)-1], checker.Equals, "create", check.Commentf("event should be create, not %#v", createEvent))
   152  	c.Assert(attachEvent[len(attachEvent)-1], checker.Equals, "attach", check.Commentf("event should be attach, not %#v", attachEvent))
   153  	c.Assert(startEvent[len(startEvent)-1], checker.Equals, "start", check.Commentf("event should be start, not %#v", startEvent))
   154  	c.Assert(dieEvent[len(dieEvent)-1], checker.Equals, "die", check.Commentf("event should be die, not %#v", dieEvent))
   155  	c.Assert(destroyEvent[len(destroyEvent)-1], checker.Equals, "destroy", check.Commentf("event should be destroy, not %#v", destroyEvent))
   156  
   157  }
   158  
   159  func (s *DockerSuite) TestEventsImageUntagDelete(c *check.C) {
   160  	testRequires(c, DaemonIsLinux)
   161  	name := "testimageevents"
   162  	_, err := buildImage(name,
   163  		`FROM scratch
   164  		MAINTAINER "docker"`,
   165  		true)
   166  	c.Assert(err, checker.IsNil)
   167  	c.Assert(deleteImages(name), checker.IsNil)
   168  	out, _ := dockerCmd(c, "events", "--since=0", fmt.Sprintf("--until=%d", daemonTime(c).Unix()))
   169  	events := strings.Split(out, "\n")
   170  
   171  	events = events[:len(events)-1]
   172  	c.Assert(len(events), checker.GreaterOrEqualThan, 2) //Missing expected event
   173  	untagEvent := strings.Fields(events[len(events)-2])
   174  	deleteEvent := strings.Fields(events[len(events)-1])
   175  	c.Assert(untagEvent[len(untagEvent)-1], checker.Equals, "untag", check.Commentf("untag should be untag, not %#v", untagEvent))
   176  	c.Assert(deleteEvent[len(deleteEvent)-1], checker.Equals, "delete", check.Commentf("untag should be delete, not %#v", untagEvent))
   177  }
   178  
   179  func (s *DockerSuite) TestEventsImageTag(c *check.C) {
   180  	testRequires(c, DaemonIsLinux)
   181  	time.Sleep(1 * time.Second) // because API has seconds granularity
   182  	since := daemonTime(c).Unix()
   183  	image := "testimageevents:tag"
   184  	dockerCmd(c, "tag", "busybox", image)
   185  
   186  	out, _ := dockerCmd(c, "events",
   187  		fmt.Sprintf("--since=%d", since),
   188  		fmt.Sprintf("--until=%d", daemonTime(c).Unix()))
   189  
   190  	events := strings.Split(strings.TrimSpace(out), "\n")
   191  	c.Assert(events, checker.HasLen, 1, check.Commentf("was expecting 1 event. out=%s", out))
   192  	event := strings.TrimSpace(events[0])
   193  	expectedStr := image + ": tag"
   194  
   195  	c.Assert(event, checker.HasSuffix, expectedStr, check.Commentf("wrong event format. expected='%s' got=%s", expectedStr, event))
   196  
   197  }
   198  
   199  func (s *DockerSuite) TestEventsImagePull(c *check.C) {
   200  	testRequires(c, DaemonIsLinux)
   201  	since := daemonTime(c).Unix()
   202  	testRequires(c, Network)
   203  
   204  	dockerCmd(c, "pull", "hello-world")
   205  
   206  	out, _ := dockerCmd(c, "events",
   207  		fmt.Sprintf("--since=%d", since),
   208  		fmt.Sprintf("--until=%d", daemonTime(c).Unix()))
   209  
   210  	events := strings.Split(strings.TrimSpace(out), "\n")
   211  	event := strings.TrimSpace(events[len(events)-1])
   212  
   213  	c.Assert(event, checker.HasSuffix, "hello-world:latest: pull", check.Commentf("Missing pull event - got:%q", event))
   214  
   215  }
   216  
   217  func (s *DockerSuite) TestEventsImageImport(c *check.C) {
   218  	testRequires(c, DaemonIsLinux)
   219  	since := daemonTime(c).Unix()
   220  
   221  	id := make(chan string)
   222  	eventImport := make(chan struct{})
   223  	eventsCmd := exec.Command(dockerBinary, "events", "--since", strconv.FormatInt(since, 10))
   224  	stdout, err := eventsCmd.StdoutPipe()
   225  	c.Assert(err, checker.IsNil)
   226  	c.Assert(eventsCmd.Start(), checker.IsNil)
   227  	defer eventsCmd.Process.Kill()
   228  
   229  	go func() {
   230  		containerID := <-id
   231  
   232  		matchImport := regexp.MustCompile(containerID + `: import$`)
   233  		scanner := bufio.NewScanner(stdout)
   234  		for scanner.Scan() {
   235  			if matchImport.MatchString(scanner.Text()) {
   236  				close(eventImport)
   237  			}
   238  		}
   239  	}()
   240  
   241  	out, _ := dockerCmd(c, "run", "-d", "busybox", "true")
   242  	cleanedContainerID := strings.TrimSpace(out)
   243  
   244  	out, _, err = runCommandPipelineWithOutput(
   245  		exec.Command(dockerBinary, "export", cleanedContainerID),
   246  		exec.Command(dockerBinary, "import", "-"),
   247  	)
   248  	c.Assert(err, checker.IsNil, check.Commentf("import failed with output: %q", out))
   249  	newContainerID := strings.TrimSpace(out)
   250  	id <- newContainerID
   251  
   252  	select {
   253  	case <-time.After(5 * time.Second):
   254  		c.Fatal("failed to observe image import in timely fashion")
   255  	case <-eventImport:
   256  		// ignore, done
   257  	}
   258  }
   259  
   260  func (s *DockerSuite) TestEventsFilters(c *check.C) {
   261  	testRequires(c, DaemonIsLinux)
   262  	parseEvents := func(out, match string) {
   263  		events := strings.Split(out, "\n")
   264  		events = events[:len(events)-1]
   265  		for _, event := range events {
   266  			eventFields := strings.Fields(event)
   267  			eventName := eventFields[len(eventFields)-1]
   268  			c.Assert(eventName, checker.Matches, match)
   269  		}
   270  	}
   271  
   272  	since := daemonTime(c).Unix()
   273  	dockerCmd(c, "run", "--rm", "busybox", "true")
   274  	dockerCmd(c, "run", "--rm", "busybox", "true")
   275  	out, _ := dockerCmd(c, "events", fmt.Sprintf("--since=%d", since), fmt.Sprintf("--until=%d", daemonTime(c).Unix()), "--filter", "event=die")
   276  	parseEvents(out, "die")
   277  
   278  	out, _ = dockerCmd(c, "events", fmt.Sprintf("--since=%d", since), fmt.Sprintf("--until=%d", daemonTime(c).Unix()), "--filter", "event=die", "--filter", "event=start")
   279  	parseEvents(out, "((die)|(start))")
   280  
   281  	// make sure we at least got 2 start events
   282  	count := strings.Count(out, "start")
   283  	c.Assert(strings.Count(out, "start"), checker.GreaterOrEqualThan, 2, check.Commentf("should have had 2 start events but had %d, out: %s", count, out))
   284  
   285  }
   286  
   287  func (s *DockerSuite) TestEventsFilterImageName(c *check.C) {
   288  	testRequires(c, DaemonIsLinux)
   289  	since := daemonTime(c).Unix()
   290  
   291  	out, _ := dockerCmd(c, "run", "--name", "container_1", "-d", "busybox:latest", "true")
   292  	container1 := strings.TrimSpace(out)
   293  
   294  	out, _ = dockerCmd(c, "run", "--name", "container_2", "-d", "busybox", "true")
   295  	container2 := strings.TrimSpace(out)
   296  
   297  	name := "busybox"
   298  	out, _ = dockerCmd(c, "events", fmt.Sprintf("--since=%d", since), fmt.Sprintf("--until=%d", daemonTime(c).Unix()), "--filter", fmt.Sprintf("image=%s", name))
   299  	events := strings.Split(out, "\n")
   300  	events = events[:len(events)-1]
   301  	c.Assert(events, checker.Not(checker.HasLen), 0) //Expected events but found none for the image busybox:latest
   302  	count1 := 0
   303  	count2 := 0
   304  
   305  	for _, e := range events {
   306  		if strings.Contains(e, container1) {
   307  			count1++
   308  		} else if strings.Contains(e, container2) {
   309  			count2++
   310  		}
   311  	}
   312  	c.Assert(count1, checker.Not(checker.Equals), 0, check.Commentf("Expected event from container but got %d from %s", count1, container1))
   313  	c.Assert(count2, checker.Not(checker.Equals), 0, check.Commentf("Expected event from container but got %d from %s", count2, container2))
   314  
   315  }
   316  
   317  func (s *DockerSuite) TestEventsFilterLabels(c *check.C) {
   318  	testRequires(c, DaemonIsLinux)
   319  	since := daemonTime(c).Unix()
   320  	label := "io.docker.testing=foo"
   321  
   322  	out, _ := dockerCmd(c, "run", "-d", "-l", label, "busybox:latest", "true")
   323  	container1 := strings.TrimSpace(out)
   324  
   325  	out, _ = dockerCmd(c, "run", "-d", "busybox", "true")
   326  	container2 := strings.TrimSpace(out)
   327  
   328  	out, _ = dockerCmd(
   329  		c,
   330  		"events",
   331  		fmt.Sprintf("--since=%d", since),
   332  		fmt.Sprintf("--until=%d", daemonTime(c).Unix()),
   333  		"--filter", fmt.Sprintf("label=%s", label))
   334  
   335  	events := strings.Split(strings.TrimSpace(out), "\n")
   336  	c.Assert(len(events), checker.Equals, 3)
   337  
   338  	for _, e := range events {
   339  		c.Assert(e, checker.Contains, container1)
   340  		c.Assert(e, checker.Not(checker.Contains), container2)
   341  	}
   342  }
   343  
   344  func (s *DockerSuite) TestEventsFilterImageLabels(c *check.C) {
   345  	testRequires(c, DaemonIsLinux)
   346  	since := daemonTime(c).Unix()
   347  	name := "labelfiltertest"
   348  	label := "io.docker.testing=image"
   349  
   350  	// Build a test image.
   351  	_, err := buildImage(name, fmt.Sprintf(`
   352  		FROM busybox:latest
   353  		LABEL %s`, label), true)
   354  	c.Assert(err, checker.IsNil, check.Commentf("Couldn't create image"))
   355  
   356  	dockerCmd(c, "tag", name, "labelfiltertest:tag1")
   357  	dockerCmd(c, "tag", name, "labelfiltertest:tag2")
   358  	dockerCmd(c, "tag", "busybox:latest", "labelfiltertest:tag3")
   359  
   360  	out, _ := dockerCmd(
   361  		c,
   362  		"events",
   363  		fmt.Sprintf("--since=%d", since),
   364  		fmt.Sprintf("--until=%d", daemonTime(c).Unix()),
   365  		"--filter", fmt.Sprintf("label=%s", label))
   366  
   367  	events := strings.Split(strings.TrimSpace(out), "\n")
   368  
   369  	// 2 events from the "docker tag" command, another one is from "docker build"
   370  	c.Assert(events, checker.HasLen, 3, check.Commentf("Events == %s", events))
   371  	for _, e := range events {
   372  		c.Assert(e, checker.Contains, "labelfiltertest")
   373  	}
   374  }
   375  
   376  func (s *DockerSuite) TestEventsFilterContainer(c *check.C) {
   377  	testRequires(c, DaemonIsLinux)
   378  	since := fmt.Sprintf("%d", daemonTime(c).Unix())
   379  	nameID := make(map[string]string)
   380  
   381  	for _, name := range []string{"container_1", "container_2"} {
   382  		dockerCmd(c, "run", "--name", name, "busybox", "true")
   383  		id, err := inspectField(name, "Id")
   384  		c.Assert(err, checker.IsNil)
   385  		nameID[name] = id
   386  	}
   387  
   388  	until := fmt.Sprintf("%d", daemonTime(c).Unix())
   389  
   390  	checkEvents := func(id string, events []string) error {
   391  		if len(events) != 4 { // create, attach, start, die
   392  			return fmt.Errorf("expected 4 events, got %v", events)
   393  		}
   394  		for _, event := range events {
   395  			e := strings.Fields(event)
   396  			if len(e) < 3 {
   397  				return fmt.Errorf("got malformed event: %s", event)
   398  			}
   399  
   400  			// Check the id
   401  			parsedID := strings.TrimSuffix(e[1], ":")
   402  			if parsedID != id {
   403  				return fmt.Errorf("expected event for container id %s: %s - parsed container id: %s", id, event, parsedID)
   404  			}
   405  		}
   406  		return nil
   407  	}
   408  
   409  	for name, ID := range nameID {
   410  		// filter by names
   411  		out, _ := dockerCmd(c, "events", "--since", since, "--until", until, "--filter", "container="+name)
   412  		events := strings.Split(strings.TrimSuffix(out, "\n"), "\n")
   413  		c.Assert(checkEvents(ID, events), checker.IsNil)
   414  
   415  		// filter by ID's
   416  		out, _ = dockerCmd(c, "events", "--since", since, "--until", until, "--filter", "container="+ID)
   417  		events = strings.Split(strings.TrimSuffix(out, "\n"), "\n")
   418  		c.Assert(checkEvents(ID, events), checker.IsNil)
   419  	}
   420  }
   421  
   422  func (s *DockerSuite) TestEventsStreaming(c *check.C) {
   423  	testRequires(c, DaemonIsLinux)
   424  	start := daemonTime(c).Unix()
   425  
   426  	id := make(chan string)
   427  	eventCreate := make(chan struct{})
   428  	eventStart := make(chan struct{})
   429  	eventDie := make(chan struct{})
   430  	eventDestroy := make(chan struct{})
   431  
   432  	eventsCmd := exec.Command(dockerBinary, "events", "--since", strconv.FormatInt(start, 10))
   433  	stdout, err := eventsCmd.StdoutPipe()
   434  	c.Assert(err, checker.IsNil)
   435  	c.Assert(eventsCmd.Start(), checker.IsNil, check.Commentf("failed to start 'docker events'"))
   436  	defer eventsCmd.Process.Kill()
   437  
   438  	buffer := new(bytes.Buffer)
   439  	go func() {
   440  		containerID := <-id
   441  
   442  		matchCreate := regexp.MustCompile(containerID + `: \(from busybox:latest\) create\z`)
   443  		matchStart := regexp.MustCompile(containerID + `: \(from busybox:latest\) start\z`)
   444  		matchDie := regexp.MustCompile(containerID + `: \(from busybox:latest\) die\z`)
   445  		matchDestroy := regexp.MustCompile(containerID + `: \(from busybox:latest\) destroy\z`)
   446  
   447  		scanner := bufio.NewScanner(stdout)
   448  		for scanner.Scan() {
   449  			text := scanner.Text()
   450  			buffer.WriteString(text + "\n")
   451  			switch {
   452  			case matchCreate.MatchString(text):
   453  				close(eventCreate)
   454  			case matchStart.MatchString(text):
   455  				close(eventStart)
   456  			case matchDie.MatchString(text):
   457  				close(eventDie)
   458  			case matchDestroy.MatchString(text):
   459  				close(eventDestroy)
   460  			}
   461  		}
   462  	}()
   463  
   464  	out, _ := dockerCmd(c, "run", "-d", "busybox:latest", "true")
   465  	cleanedContainerID := strings.TrimSpace(out)
   466  	id <- cleanedContainerID
   467  
   468  	select {
   469  	case <-time.After(5 * time.Second):
   470  		c.Fatal("failed to observe container create in timely fashion", "\n", buffer.String())
   471  	case <-eventCreate:
   472  		// ignore, done
   473  	}
   474  
   475  	select {
   476  	case <-time.After(5 * time.Second):
   477  		c.Fatal("failed to observe container start in timely fashion", "\n", buffer.String())
   478  	case <-eventStart:
   479  		// ignore, done
   480  	}
   481  
   482  	select {
   483  	case <-time.After(5 * time.Second):
   484  		c.Fatal("failed to observe container die in timely fashion", "\n", buffer.String())
   485  	case <-eventDie:
   486  		// ignore, done
   487  	}
   488  
   489  	dockerCmd(c, "rm", cleanedContainerID)
   490  
   491  	select {
   492  	case <-time.After(5 * time.Second):
   493  		c.Fatal("failed to observe container destroy in timely fashion", "\n", buffer.String())
   494  	case <-eventDestroy:
   495  		// ignore, done
   496  	}
   497  }
   498  
   499  func (s *DockerSuite) TestEventsCommit(c *check.C) {
   500  	testRequires(c, DaemonIsLinux)
   501  	since := daemonTime(c).Unix()
   502  
   503  	out, _ := dockerCmd(c, "run", "-d", "busybox", "top")
   504  	cID := strings.TrimSpace(out)
   505  	c.Assert(waitRun(cID), checker.IsNil)
   506  
   507  	dockerCmd(c, "commit", "-m", "test", cID)
   508  	dockerCmd(c, "stop", cID)
   509  
   510  	out, _ = dockerCmd(c, "events", "--since=0", "-f", "container="+cID, "--until="+strconv.Itoa(int(since)))
   511  	c.Assert(out, checker.Contains, " commit\n", check.Commentf("Missing 'commit' log event"))
   512  }
   513  
   514  func (s *DockerSuite) TestEventsCopy(c *check.C) {
   515  	testRequires(c, DaemonIsLinux)
   516  	since := daemonTime(c).Unix()
   517  
   518  	// Build a test image.
   519  	id, err := buildImage("cpimg", `
   520  		  FROM busybox
   521  		  RUN echo HI > /tmp/file`, true)
   522  	c.Assert(err, checker.IsNil, check.Commentf("Couldn't create image"))
   523  
   524  	// Create an empty test file.
   525  	tempFile, err := ioutil.TempFile("", "test-events-copy-")
   526  	c.Assert(err, checker.IsNil)
   527  	defer os.Remove(tempFile.Name())
   528  
   529  	c.Assert(tempFile.Close(), checker.IsNil)
   530  
   531  	dockerCmd(c, "create", "--name=cptest", id)
   532  
   533  	dockerCmd(c, "cp", "cptest:/tmp/file", tempFile.Name())
   534  
   535  	out, _ := dockerCmd(c, "events", "--since=0", "-f", "container=cptest", "--until="+strconv.Itoa(int(since)))
   536  	c.Assert(out, checker.Contains, " archive-path\n", check.Commentf("Missing 'archive-path' log event\n"))
   537  
   538  	dockerCmd(c, "cp", tempFile.Name(), "cptest:/tmp/filecopy")
   539  
   540  	out, _ = dockerCmd(c, "events", "--since=0", "-f", "container=cptest", "--until="+strconv.Itoa(int(since)))
   541  	c.Assert(out, checker.Contains, " extract-to-dir\n", check.Commentf("Missing 'extract-to-dir' log event"))
   542  }
   543  
   544  func (s *DockerSuite) TestEventsResize(c *check.C) {
   545  	testRequires(c, DaemonIsLinux)
   546  	since := daemonTime(c).Unix()
   547  
   548  	out, _ := dockerCmd(c, "run", "-d", "busybox", "top")
   549  	cID := strings.TrimSpace(out)
   550  	c.Assert(waitRun(cID), checker.IsNil)
   551  
   552  	endpoint := "/containers/" + cID + "/resize?h=80&w=24"
   553  	status, _, err := sockRequest("POST", endpoint, nil)
   554  	c.Assert(status, checker.Equals, http.StatusOK)
   555  	c.Assert(err, checker.IsNil)
   556  
   557  	dockerCmd(c, "stop", cID)
   558  
   559  	out, _ = dockerCmd(c, "events", "--since=0", "-f", "container="+cID, "--until="+strconv.Itoa(int(since)))
   560  	c.Assert(out, checker.Contains, " resize\n", check.Commentf("Missing 'resize' log event"))
   561  }
   562  
   563  func (s *DockerSuite) TestEventsAttach(c *check.C) {
   564  	testRequires(c, DaemonIsLinux)
   565  	since := daemonTime(c).Unix()
   566  
   567  	out, _ := dockerCmd(c, "run", "-di", "busybox", "/bin/cat")
   568  	cID := strings.TrimSpace(out)
   569  
   570  	cmd := exec.Command(dockerBinary, "attach", cID)
   571  	stdin, err := cmd.StdinPipe()
   572  	c.Assert(err, checker.IsNil)
   573  	defer stdin.Close()
   574  	stdout, err := cmd.StdoutPipe()
   575  	c.Assert(err, checker.IsNil)
   576  	defer stdout.Close()
   577  	c.Assert(cmd.Start(), checker.IsNil)
   578  	defer cmd.Process.Kill()
   579  
   580  	// Make sure we're done attaching by writing/reading some stuff
   581  	_, err = stdin.Write([]byte("hello\n"))
   582  	c.Assert(err, checker.IsNil)
   583  	out, err = bufio.NewReader(stdout).ReadString('\n')
   584  	c.Assert(err, checker.IsNil)
   585  	c.Assert(strings.TrimSpace(out), checker.Equals, "hello", check.Commentf("expected 'hello'"))
   586  
   587  	c.Assert(stdin.Close(), checker.IsNil)
   588  
   589  	dockerCmd(c, "stop", cID)
   590  
   591  	out, _ = dockerCmd(c, "events", "--since=0", "-f", "container="+cID, "--until="+strconv.Itoa(int(since)))
   592  	c.Assert(out, checker.Contains, " attach\n", check.Commentf("Missing 'attach' log event"))
   593  }
   594  
   595  func (s *DockerSuite) TestEventsRename(c *check.C) {
   596  	testRequires(c, DaemonIsLinux)
   597  	since := daemonTime(c).Unix()
   598  
   599  	dockerCmd(c, "run", "--name", "oldName", "busybox", "true")
   600  	dockerCmd(c, "rename", "oldName", "newName")
   601  
   602  	out, _ := dockerCmd(c, "events", "--since=0", "-f", "container=newName", "--until="+strconv.Itoa(int(since)))
   603  	c.Assert(out, checker.Contains, " rename\n", check.Commentf("Missing 'rename' log event\n"))
   604  }
   605  
   606  func (s *DockerSuite) TestEventsTop(c *check.C) {
   607  	testRequires(c, DaemonIsLinux)
   608  	since := daemonTime(c).Unix()
   609  
   610  	out, _ := dockerCmd(c, "run", "-d", "busybox", "top")
   611  	cID := strings.TrimSpace(out)
   612  	c.Assert(waitRun(cID), checker.IsNil)
   613  
   614  	dockerCmd(c, "top", cID)
   615  	dockerCmd(c, "stop", cID)
   616  
   617  	out, _ = dockerCmd(c, "events", "--since=0", "-f", "container="+cID, "--until="+strconv.Itoa(int(since)))
   618  	c.Assert(out, checker.Contains, " top\n", check.Commentf("Missing 'top' log event"))
   619  }
   620  
   621  // #13753
   622  func (s *DockerSuite) TestEventsDefaultEmpty(c *check.C) {
   623  	testRequires(c, DaemonIsLinux)
   624  	dockerCmd(c, "run", "busybox")
   625  	out, _ := dockerCmd(c, "events", fmt.Sprintf("--until=%d", daemonTime(c).Unix()))
   626  	c.Assert(strings.TrimSpace(out), checker.Equals, "")
   627  }
   628  
   629  // #14316
   630  func (s *DockerRegistrySuite) TestEventsImageFilterPush(c *check.C) {
   631  	testRequires(c, DaemonIsLinux)
   632  	testRequires(c, Network)
   633  	since := daemonTime(c).Unix()
   634  	repoName := fmt.Sprintf("%v/dockercli/testf", privateRegistryURL)
   635  
   636  	out, _ := dockerCmd(c, "run", "-d", "busybox", "top")
   637  	cID := strings.TrimSpace(out)
   638  	c.Assert(waitRun(cID), checker.IsNil)
   639  
   640  	dockerCmd(c, "commit", cID, repoName)
   641  	dockerCmd(c, "stop", cID)
   642  	dockerCmd(c, "push", repoName)
   643  
   644  	out, _ = dockerCmd(c, "events", "--since=0", "-f", "image="+repoName, "-f", "event=push", "--until="+strconv.Itoa(int(since)))
   645  	c.Assert(out, checker.Contains, repoName+": push\n", check.Commentf("Missing 'push' log event"))
   646  }