github.com/flavio/docker@v0.1.3-0.20170117145210-f63d1a6eec47/integration-cli/docker_cli_events_test.go (about) 1 package main 2 3 import ( 4 "bufio" 5 "encoding/json" 6 "fmt" 7 "io" 8 "io/ioutil" 9 "net/http" 10 "os" 11 "os/exec" 12 "strings" 13 "time" 14 15 eventtypes "github.com/docker/docker/api/types/events" 16 eventstestutils "github.com/docker/docker/daemon/events/testutils" 17 "github.com/docker/docker/integration-cli/checker" 18 "github.com/docker/docker/integration-cli/request" 19 "github.com/docker/docker/pkg/testutil" 20 icmd "github.com/docker/docker/pkg/testutil/cmd" 21 "github.com/go-check/check" 22 ) 23 24 func (s *DockerSuite) TestEventsTimestampFormats(c *check.C) { 25 name := "events-time-format-test" 26 27 // Start stopwatch, generate an event 28 start := daemonTime(c) 29 time.Sleep(1100 * time.Millisecond) // so that first event occur in different second from since (just for the case) 30 dockerCmd(c, "run", "--rm", "--name", name, "busybox", "true") 31 time.Sleep(1100 * time.Millisecond) // so that until > since 32 end := daemonTime(c) 33 34 // List of available time formats to --since 35 unixTs := func(t time.Time) string { return fmt.Sprintf("%v", t.Unix()) } 36 rfc3339 := func(t time.Time) string { return t.Format(time.RFC3339) } 37 duration := func(t time.Time) string { return time.Now().Sub(t).String() } 38 39 // --since=$start must contain only the 'untag' event 40 for _, f := range []func(time.Time) string{unixTs, rfc3339, duration} { 41 since, until := f(start), f(end) 42 out, _ := dockerCmd(c, "events", "--since="+since, "--until="+until) 43 events := strings.Split(out, "\n") 44 events = events[:len(events)-1] 45 46 nEvents := len(events) 47 c.Assert(nEvents, checker.GreaterOrEqualThan, 5) //Missing expected event 48 containerEvents := eventActionsByIDAndType(c, events, name, "container") 49 c.Assert(containerEvents, checker.HasLen, 5, check.Commentf("events: %v", events)) 50 51 c.Assert(containerEvents[0], checker.Equals, "create", check.Commentf(out)) 52 c.Assert(containerEvents[1], checker.Equals, "attach", check.Commentf(out)) 53 c.Assert(containerEvents[2], checker.Equals, "start", check.Commentf(out)) 54 c.Assert(containerEvents[3], checker.Equals, "die", check.Commentf(out)) 55 c.Assert(containerEvents[4], checker.Equals, "destroy", check.Commentf(out)) 56 } 57 } 58 59 func (s *DockerSuite) TestEventsUntag(c *check.C) { 60 image := "busybox" 61 dockerCmd(c, "tag", image, "utest:tag1") 62 dockerCmd(c, "tag", image, "utest:tag2") 63 dockerCmd(c, "rmi", "utest:tag1") 64 dockerCmd(c, "rmi", "utest:tag2") 65 66 result := icmd.RunCmd(icmd.Cmd{ 67 Command: []string{dockerBinary, "events", "--since=1"}, 68 Timeout: time.Millisecond * 2500, 69 }) 70 c.Assert(result, icmd.Matches, icmd.Expected{Timeout: true}) 71 72 events := strings.Split(result.Stdout(), "\n") 73 nEvents := len(events) 74 // The last element after the split above will be an empty string, so we 75 // get the two elements before the last, which are the untags we're 76 // looking for. 77 for _, v := range events[nEvents-3 : nEvents-1] { 78 c.Assert(v, checker.Contains, "untag", check.Commentf("event should be untag")) 79 } 80 } 81 82 func (s *DockerSuite) TestEventsLimit(c *check.C) { 83 // Limit to 8 goroutines creating containers in order to prevent timeouts 84 // creating so many containers simultaneously on Windows 85 sem := make(chan bool, 8) 86 numContainers := 17 87 errChan := make(chan error, numContainers) 88 89 args := []string{"run", "--rm", "busybox", "true"} 90 for i := 0; i < numContainers; i++ { 91 sem <- true 92 go func() { 93 defer func() { <-sem }() 94 out, err := exec.Command(dockerBinary, args...).CombinedOutput() 95 if err != nil { 96 err = fmt.Errorf("%v: %s", err, string(out)) 97 } 98 errChan <- err 99 }() 100 } 101 102 // Wait for all goroutines to finish 103 for i := 0; i < cap(sem); i++ { 104 sem <- true 105 } 106 close(errChan) 107 108 for err := range errChan { 109 c.Assert(err, checker.IsNil, check.Commentf("%q failed with error", strings.Join(args, " "))) 110 } 111 112 out, _ := dockerCmd(c, "events", "--since=0", "--until", daemonUnixTime(c)) 113 events := strings.Split(out, "\n") 114 nEvents := len(events) - 1 115 c.Assert(nEvents, checker.Equals, 64, check.Commentf("events should be limited to 64, but received %d", nEvents)) 116 } 117 118 func (s *DockerSuite) TestEventsContainerEvents(c *check.C) { 119 dockerCmd(c, "run", "--rm", "--name", "container-events-test", "busybox", "true") 120 121 out, _ := dockerCmd(c, "events", "--until", daemonUnixTime(c)) 122 events := strings.Split(out, "\n") 123 events = events[:len(events)-1] 124 125 nEvents := len(events) 126 c.Assert(nEvents, checker.GreaterOrEqualThan, 5) //Missing expected event 127 containerEvents := eventActionsByIDAndType(c, events, "container-events-test", "container") 128 c.Assert(containerEvents, checker.HasLen, 5, check.Commentf("events: %v", events)) 129 130 c.Assert(containerEvents[0], checker.Equals, "create", check.Commentf(out)) 131 c.Assert(containerEvents[1], checker.Equals, "attach", check.Commentf(out)) 132 c.Assert(containerEvents[2], checker.Equals, "start", check.Commentf(out)) 133 c.Assert(containerEvents[3], checker.Equals, "die", check.Commentf(out)) 134 c.Assert(containerEvents[4], checker.Equals, "destroy", check.Commentf(out)) 135 } 136 137 func (s *DockerSuite) TestEventsContainerEventsAttrSort(c *check.C) { 138 since := daemonUnixTime(c) 139 dockerCmd(c, "run", "--rm", "--name", "container-events-test", "busybox", "true") 140 141 out, _ := dockerCmd(c, "events", "--filter", "container=container-events-test", "--since", since, "--until", daemonUnixTime(c)) 142 events := strings.Split(out, "\n") 143 144 nEvents := len(events) 145 c.Assert(nEvents, checker.GreaterOrEqualThan, 3) //Missing expected event 146 matchedEvents := 0 147 for _, event := range events { 148 matches := eventstestutils.ScanMap(event) 149 if matches["eventType"] == "container" && matches["action"] == "create" { 150 matchedEvents++ 151 c.Assert(out, checker.Contains, "(image=busybox, name=container-events-test)", check.Commentf("Event attributes not sorted")) 152 } else if matches["eventType"] == "container" && matches["action"] == "start" { 153 matchedEvents++ 154 c.Assert(out, checker.Contains, "(image=busybox, name=container-events-test)", check.Commentf("Event attributes not sorted")) 155 } 156 } 157 c.Assert(matchedEvents, checker.Equals, 2, check.Commentf("missing events for container container-events-test:\n%s", out)) 158 } 159 160 func (s *DockerSuite) TestEventsContainerEventsSinceUnixEpoch(c *check.C) { 161 dockerCmd(c, "run", "--rm", "--name", "since-epoch-test", "busybox", "true") 162 timeBeginning := time.Unix(0, 0).Format(time.RFC3339Nano) 163 timeBeginning = strings.Replace(timeBeginning, "Z", ".000000000Z", -1) 164 out, _ := dockerCmd(c, "events", "--since", timeBeginning, "--until", daemonUnixTime(c)) 165 events := strings.Split(out, "\n") 166 events = events[:len(events)-1] 167 168 nEvents := len(events) 169 c.Assert(nEvents, checker.GreaterOrEqualThan, 5) //Missing expected event 170 containerEvents := eventActionsByIDAndType(c, events, "since-epoch-test", "container") 171 c.Assert(containerEvents, checker.HasLen, 5, check.Commentf("events: %v", events)) 172 173 c.Assert(containerEvents[0], checker.Equals, "create", check.Commentf(out)) 174 c.Assert(containerEvents[1], checker.Equals, "attach", check.Commentf(out)) 175 c.Assert(containerEvents[2], checker.Equals, "start", check.Commentf(out)) 176 c.Assert(containerEvents[3], checker.Equals, "die", check.Commentf(out)) 177 c.Assert(containerEvents[4], checker.Equals, "destroy", check.Commentf(out)) 178 } 179 180 func (s *DockerSuite) TestEventsImageTag(c *check.C) { 181 time.Sleep(1 * time.Second) // because API has seconds granularity 182 since := daemonUnixTime(c) 183 image := "testimageevents:tag" 184 dockerCmd(c, "tag", "busybox", image) 185 186 out, _ := dockerCmd(c, "events", 187 "--since", since, "--until", daemonUnixTime(c)) 188 189 events := strings.Split(strings.TrimSpace(out), "\n") 190 c.Assert(events, checker.HasLen, 1, check.Commentf("was expecting 1 event. out=%s", out)) 191 event := strings.TrimSpace(events[0]) 192 193 matches := eventstestutils.ScanMap(event) 194 c.Assert(matchEventID(matches, image), checker.True, check.Commentf("matches: %v\nout:\n%s", matches, out)) 195 c.Assert(matches["action"], checker.Equals, "tag") 196 } 197 198 func (s *DockerSuite) TestEventsImagePull(c *check.C) { 199 // TODO Windows: Enable this test once pull and reliable image names are available 200 testRequires(c, DaemonIsLinux) 201 since := daemonUnixTime(c) 202 testRequires(c, Network) 203 204 dockerCmd(c, "pull", "hello-world") 205 206 out, _ := dockerCmd(c, "events", 207 "--since", since, "--until", daemonUnixTime(c)) 208 209 events := strings.Split(strings.TrimSpace(out), "\n") 210 event := strings.TrimSpace(events[len(events)-1]) 211 matches := eventstestutils.ScanMap(event) 212 c.Assert(matches["id"], checker.Equals, "hello-world:latest") 213 c.Assert(matches["action"], checker.Equals, "pull") 214 215 } 216 217 func (s *DockerSuite) TestEventsImageImport(c *check.C) { 218 // TODO Windows CI. This should be portable once export/import are 219 // more reliable (@swernli) 220 testRequires(c, DaemonIsLinux) 221 222 out, _ := dockerCmd(c, "run", "-d", "busybox", "true") 223 cleanedContainerID := strings.TrimSpace(out) 224 225 since := daemonUnixTime(c) 226 out, _, err := testutil.RunCommandPipelineWithOutput( 227 exec.Command(dockerBinary, "export", cleanedContainerID), 228 exec.Command(dockerBinary, "import", "-"), 229 ) 230 c.Assert(err, checker.IsNil, check.Commentf("import failed with output: %q", out)) 231 imageRef := strings.TrimSpace(out) 232 233 out, _ = dockerCmd(c, "events", "--since", since, "--until", daemonUnixTime(c), "--filter", "event=import") 234 events := strings.Split(strings.TrimSpace(out), "\n") 235 c.Assert(events, checker.HasLen, 1) 236 matches := eventstestutils.ScanMap(events[0]) 237 c.Assert(matches["id"], checker.Equals, imageRef, check.Commentf("matches: %v\nout:\n%s\n", matches, out)) 238 c.Assert(matches["action"], checker.Equals, "import", check.Commentf("matches: %v\nout:\n%s\n", matches, out)) 239 } 240 241 func (s *DockerSuite) TestEventsImageLoad(c *check.C) { 242 testRequires(c, DaemonIsLinux) 243 myImageName := "footest:v1" 244 dockerCmd(c, "tag", "busybox", myImageName) 245 since := daemonUnixTime(c) 246 247 out, _ := dockerCmd(c, "images", "-q", "--no-trunc", myImageName) 248 longImageID := strings.TrimSpace(out) 249 c.Assert(longImageID, checker.Not(check.Equals), "", check.Commentf("Id should not be empty")) 250 251 dockerCmd(c, "save", "-o", "saveimg.tar", myImageName) 252 dockerCmd(c, "rmi", myImageName) 253 out, _ = dockerCmd(c, "images", "-q", myImageName) 254 noImageID := strings.TrimSpace(out) 255 c.Assert(noImageID, checker.Equals, "", check.Commentf("Should not have any image")) 256 dockerCmd(c, "load", "-i", "saveimg.tar") 257 258 result := icmd.RunCommand("rm", "-rf", "saveimg.tar") 259 c.Assert(result, icmd.Matches, icmd.Success) 260 261 out, _ = dockerCmd(c, "images", "-q", "--no-trunc", myImageName) 262 imageID := strings.TrimSpace(out) 263 c.Assert(imageID, checker.Equals, longImageID, check.Commentf("Should have same image id as before")) 264 265 out, _ = dockerCmd(c, "events", "--since", since, "--until", daemonUnixTime(c), "--filter", "event=load") 266 events := strings.Split(strings.TrimSpace(out), "\n") 267 c.Assert(events, checker.HasLen, 1) 268 matches := eventstestutils.ScanMap(events[0]) 269 c.Assert(matches["id"], checker.Equals, imageID, check.Commentf("matches: %v\nout:\n%s\n", matches, out)) 270 c.Assert(matches["action"], checker.Equals, "load", check.Commentf("matches: %v\nout:\n%s\n", matches, out)) 271 272 out, _ = dockerCmd(c, "events", "--since", since, "--until", daemonUnixTime(c), "--filter", "event=save") 273 events = strings.Split(strings.TrimSpace(out), "\n") 274 c.Assert(events, checker.HasLen, 1) 275 matches = eventstestutils.ScanMap(events[0]) 276 c.Assert(matches["id"], checker.Equals, imageID, check.Commentf("matches: %v\nout:\n%s\n", matches, out)) 277 c.Assert(matches["action"], checker.Equals, "save", check.Commentf("matches: %v\nout:\n%s\n", matches, out)) 278 } 279 280 func (s *DockerSuite) TestEventsPluginOps(c *check.C) { 281 testRequires(c, DaemonIsLinux, IsAmd64, Network) 282 283 since := daemonUnixTime(c) 284 285 dockerCmd(c, "plugin", "install", pNameWithTag, "--grant-all-permissions") 286 dockerCmd(c, "plugin", "disable", pNameWithTag) 287 dockerCmd(c, "plugin", "remove", pNameWithTag) 288 289 out, _ := dockerCmd(c, "events", "--since", since, "--until", daemonUnixTime(c)) 290 events := strings.Split(out, "\n") 291 events = events[:len(events)-1] 292 293 nEvents := len(events) 294 c.Assert(nEvents, checker.GreaterOrEqualThan, 4) 295 296 pluginEvents := eventActionsByIDAndType(c, events, pNameWithTag, "plugin") 297 c.Assert(pluginEvents, checker.HasLen, 4, check.Commentf("events: %v", events)) 298 299 c.Assert(pluginEvents[0], checker.Equals, "pull", check.Commentf(out)) 300 c.Assert(pluginEvents[1], checker.Equals, "enable", check.Commentf(out)) 301 c.Assert(pluginEvents[2], checker.Equals, "disable", check.Commentf(out)) 302 c.Assert(pluginEvents[3], checker.Equals, "remove", check.Commentf(out)) 303 } 304 305 func (s *DockerSuite) TestEventsFilters(c *check.C) { 306 since := daemonUnixTime(c) 307 dockerCmd(c, "run", "--rm", "busybox", "true") 308 dockerCmd(c, "run", "--rm", "busybox", "true") 309 out, _ := dockerCmd(c, "events", "--since", since, "--until", daemonUnixTime(c), "--filter", "event=die") 310 parseEvents(c, out, "die") 311 312 out, _ = dockerCmd(c, "events", "--since", since, "--until", daemonUnixTime(c), "--filter", "event=die", "--filter", "event=start") 313 parseEvents(c, out, "die|start") 314 315 // make sure we at least got 2 start events 316 count := strings.Count(out, "start") 317 c.Assert(strings.Count(out, "start"), checker.GreaterOrEqualThan, 2, check.Commentf("should have had 2 start events but had %d, out: %s", count, out)) 318 319 } 320 321 func (s *DockerSuite) TestEventsFilterImageName(c *check.C) { 322 since := daemonUnixTime(c) 323 324 out, _ := dockerCmd(c, "run", "--name", "container_1", "-d", "busybox:latest", "true") 325 container1 := strings.TrimSpace(out) 326 327 out, _ = dockerCmd(c, "run", "--name", "container_2", "-d", "busybox", "true") 328 container2 := strings.TrimSpace(out) 329 330 name := "busybox" 331 out, _ = dockerCmd(c, "events", "--since", since, "--until", daemonUnixTime(c), "--filter", fmt.Sprintf("image=%s", name)) 332 events := strings.Split(out, "\n") 333 events = events[:len(events)-1] 334 c.Assert(events, checker.Not(checker.HasLen), 0) //Expected events but found none for the image busybox:latest 335 count1 := 0 336 count2 := 0 337 338 for _, e := range events { 339 if strings.Contains(e, container1) { 340 count1++ 341 } else if strings.Contains(e, container2) { 342 count2++ 343 } 344 } 345 c.Assert(count1, checker.Not(checker.Equals), 0, check.Commentf("Expected event from container but got %d from %s", count1, container1)) 346 c.Assert(count2, checker.Not(checker.Equals), 0, check.Commentf("Expected event from container but got %d from %s", count2, container2)) 347 348 } 349 350 func (s *DockerSuite) TestEventsFilterLabels(c *check.C) { 351 since := daemonUnixTime(c) 352 label := "io.docker.testing=foo" 353 354 out, _ := dockerCmd(c, "run", "-d", "-l", label, "busybox:latest", "true") 355 container1 := strings.TrimSpace(out) 356 357 out, _ = dockerCmd(c, "run", "-d", "busybox", "true") 358 container2 := strings.TrimSpace(out) 359 360 out, _ = dockerCmd( 361 c, 362 "events", 363 "--since", since, 364 "--until", daemonUnixTime(c), 365 "--filter", fmt.Sprintf("label=%s", label)) 366 367 events := strings.Split(strings.TrimSpace(out), "\n") 368 c.Assert(len(events), checker.Equals, 3) 369 370 for _, e := range events { 371 c.Assert(e, checker.Contains, container1) 372 c.Assert(e, checker.Not(checker.Contains), container2) 373 } 374 } 375 376 func (s *DockerSuite) TestEventsFilterImageLabels(c *check.C) { 377 since := daemonUnixTime(c) 378 name := "labelfiltertest" 379 label := "io.docker.testing=image" 380 381 // Build a test image. 382 _, err := buildImage(name, fmt.Sprintf(` 383 FROM busybox:latest 384 LABEL %s`, label), true) 385 c.Assert(err, checker.IsNil, check.Commentf("Couldn't create image")) 386 387 dockerCmd(c, "tag", name, "labelfiltertest:tag1") 388 dockerCmd(c, "tag", name, "labelfiltertest:tag2") 389 dockerCmd(c, "tag", "busybox:latest", "labelfiltertest:tag3") 390 391 out, _ := dockerCmd( 392 c, 393 "events", 394 "--since", since, 395 "--until", daemonUnixTime(c), 396 "--filter", fmt.Sprintf("label=%s", label), 397 "--filter", "type=image") 398 399 events := strings.Split(strings.TrimSpace(out), "\n") 400 401 // 2 events from the "docker tag" command, another one is from "docker build" 402 c.Assert(events, checker.HasLen, 3, check.Commentf("Events == %s", events)) 403 for _, e := range events { 404 c.Assert(e, checker.Contains, "labelfiltertest") 405 } 406 } 407 408 func (s *DockerSuite) TestEventsFilterContainer(c *check.C) { 409 since := daemonUnixTime(c) 410 nameID := make(map[string]string) 411 412 for _, name := range []string{"container_1", "container_2"} { 413 dockerCmd(c, "run", "--name", name, "busybox", "true") 414 id := inspectField(c, name, "Id") 415 nameID[name] = id 416 } 417 418 until := daemonUnixTime(c) 419 420 checkEvents := func(id string, events []string) error { 421 if len(events) != 4 { // create, attach, start, die 422 return fmt.Errorf("expected 4 events, got %v", events) 423 } 424 for _, event := range events { 425 matches := eventstestutils.ScanMap(event) 426 if !matchEventID(matches, id) { 427 return fmt.Errorf("expected event for container id %s: %s - parsed container id: %s", id, event, matches["id"]) 428 } 429 } 430 return nil 431 } 432 433 for name, ID := range nameID { 434 // filter by names 435 out, _ := dockerCmd(c, "events", "--since", since, "--until", until, "--filter", "container="+name) 436 events := strings.Split(strings.TrimSuffix(out, "\n"), "\n") 437 c.Assert(checkEvents(ID, events), checker.IsNil) 438 439 // filter by ID's 440 out, _ = dockerCmd(c, "events", "--since", since, "--until", until, "--filter", "container="+ID) 441 events = strings.Split(strings.TrimSuffix(out, "\n"), "\n") 442 c.Assert(checkEvents(ID, events), checker.IsNil) 443 } 444 } 445 446 func (s *DockerSuite) TestEventsCommit(c *check.C) { 447 // Problematic on Windows as cannot commit a running container 448 testRequires(c, DaemonIsLinux) 449 450 out, _ := runSleepingContainer(c) 451 cID := strings.TrimSpace(out) 452 c.Assert(waitRun(cID), checker.IsNil) 453 454 dockerCmd(c, "commit", "-m", "test", cID) 455 dockerCmd(c, "stop", cID) 456 c.Assert(waitExited(cID, 5*time.Second), checker.IsNil) 457 458 until := daemonUnixTime(c) 459 out, _ = dockerCmd(c, "events", "-f", "container="+cID, "--until="+until) 460 c.Assert(out, checker.Contains, "commit", check.Commentf("Missing 'commit' log event")) 461 } 462 463 func (s *DockerSuite) TestEventsCopy(c *check.C) { 464 // Build a test image. 465 id, err := buildImage("cpimg", ` 466 FROM busybox 467 RUN echo HI > /file`, true) 468 c.Assert(err, checker.IsNil, check.Commentf("Couldn't create image")) 469 470 // Create an empty test file. 471 tempFile, err := ioutil.TempFile("", "test-events-copy-") 472 c.Assert(err, checker.IsNil) 473 defer os.Remove(tempFile.Name()) 474 475 c.Assert(tempFile.Close(), checker.IsNil) 476 477 dockerCmd(c, "create", "--name=cptest", id) 478 479 dockerCmd(c, "cp", "cptest:/file", tempFile.Name()) 480 481 until := daemonUnixTime(c) 482 out, _ := dockerCmd(c, "events", "--since=0", "-f", "container=cptest", "--until="+until) 483 c.Assert(out, checker.Contains, "archive-path", check.Commentf("Missing 'archive-path' log event\n")) 484 485 dockerCmd(c, "cp", tempFile.Name(), "cptest:/filecopy") 486 487 until = daemonUnixTime(c) 488 out, _ = dockerCmd(c, "events", "-f", "container=cptest", "--until="+until) 489 c.Assert(out, checker.Contains, "extract-to-dir", check.Commentf("Missing 'extract-to-dir' log event")) 490 } 491 492 func (s *DockerSuite) TestEventsResize(c *check.C) { 493 out, _ := runSleepingContainer(c, "-d") 494 cID := strings.TrimSpace(out) 495 c.Assert(waitRun(cID), checker.IsNil) 496 497 endpoint := "/containers/" + cID + "/resize?h=80&w=24" 498 status, _, err := request.SockRequest("POST", endpoint, nil, daemonHost()) 499 c.Assert(status, checker.Equals, http.StatusOK) 500 c.Assert(err, checker.IsNil) 501 502 dockerCmd(c, "stop", cID) 503 504 until := daemonUnixTime(c) 505 out, _ = dockerCmd(c, "events", "-f", "container="+cID, "--until="+until) 506 c.Assert(out, checker.Contains, "resize", check.Commentf("Missing 'resize' log event")) 507 } 508 509 func (s *DockerSuite) TestEventsAttach(c *check.C) { 510 // TODO Windows CI: Figure out why this test fails intermittently (TP5). 511 testRequires(c, DaemonIsLinux) 512 513 out, _ := dockerCmd(c, "run", "-di", "busybox", "cat") 514 cID := strings.TrimSpace(out) 515 c.Assert(waitRun(cID), checker.IsNil) 516 517 cmd := exec.Command(dockerBinary, "attach", cID) 518 stdin, err := cmd.StdinPipe() 519 c.Assert(err, checker.IsNil) 520 defer stdin.Close() 521 stdout, err := cmd.StdoutPipe() 522 c.Assert(err, checker.IsNil) 523 defer stdout.Close() 524 c.Assert(cmd.Start(), checker.IsNil) 525 defer cmd.Process.Kill() 526 527 // Make sure we're done attaching by writing/reading some stuff 528 _, err = stdin.Write([]byte("hello\n")) 529 c.Assert(err, checker.IsNil) 530 out, err = bufio.NewReader(stdout).ReadString('\n') 531 c.Assert(err, checker.IsNil) 532 c.Assert(strings.TrimSpace(out), checker.Equals, "hello", check.Commentf("expected 'hello'")) 533 534 c.Assert(stdin.Close(), checker.IsNil) 535 536 dockerCmd(c, "kill", cID) 537 c.Assert(waitExited(cID, 5*time.Second), checker.IsNil) 538 539 until := daemonUnixTime(c) 540 out, _ = dockerCmd(c, "events", "-f", "container="+cID, "--until="+until) 541 c.Assert(out, checker.Contains, "attach", check.Commentf("Missing 'attach' log event")) 542 } 543 544 func (s *DockerSuite) TestEventsRename(c *check.C) { 545 out, _ := dockerCmd(c, "run", "--name", "oldName", "busybox", "true") 546 cID := strings.TrimSpace(out) 547 dockerCmd(c, "rename", "oldName", "newName") 548 549 until := daemonUnixTime(c) 550 // filter by the container id because the name in the event will be the new name. 551 out, _ = dockerCmd(c, "events", "-f", "container="+cID, "--until", until) 552 c.Assert(out, checker.Contains, "rename", check.Commentf("Missing 'rename' log event\n")) 553 } 554 555 func (s *DockerSuite) TestEventsTop(c *check.C) { 556 // Problematic on Windows as Windows does not support top 557 testRequires(c, DaemonIsLinux) 558 559 out, _ := runSleepingContainer(c, "-d") 560 cID := strings.TrimSpace(out) 561 c.Assert(waitRun(cID), checker.IsNil) 562 563 dockerCmd(c, "top", cID) 564 dockerCmd(c, "stop", cID) 565 566 until := daemonUnixTime(c) 567 out, _ = dockerCmd(c, "events", "-f", "container="+cID, "--until="+until) 568 c.Assert(out, checker.Contains, " top", check.Commentf("Missing 'top' log event")) 569 } 570 571 // #14316 572 func (s *DockerRegistrySuite) TestEventsImageFilterPush(c *check.C) { 573 // Problematic to port for Windows CI during TP5 timeframe until 574 // supporting push 575 testRequires(c, DaemonIsLinux) 576 testRequires(c, Network) 577 repoName := fmt.Sprintf("%v/dockercli/testf", privateRegistryURL) 578 579 out, _ := dockerCmd(c, "run", "-d", "busybox", "top") 580 cID := strings.TrimSpace(out) 581 c.Assert(waitRun(cID), checker.IsNil) 582 583 dockerCmd(c, "commit", cID, repoName) 584 dockerCmd(c, "stop", cID) 585 dockerCmd(c, "push", repoName) 586 587 until := daemonUnixTime(c) 588 out, _ = dockerCmd(c, "events", "-f", "image="+repoName, "-f", "event=push", "--until", until) 589 c.Assert(out, checker.Contains, repoName, check.Commentf("Missing 'push' log event for %s", repoName)) 590 } 591 592 func (s *DockerSuite) TestEventsFilterType(c *check.C) { 593 since := daemonUnixTime(c) 594 name := "labelfiltertest" 595 label := "io.docker.testing=image" 596 597 // Build a test image. 598 _, err := buildImage(name, fmt.Sprintf(` 599 FROM busybox:latest 600 LABEL %s`, label), true) 601 c.Assert(err, checker.IsNil, check.Commentf("Couldn't create image")) 602 603 dockerCmd(c, "tag", name, "labelfiltertest:tag1") 604 dockerCmd(c, "tag", name, "labelfiltertest:tag2") 605 dockerCmd(c, "tag", "busybox:latest", "labelfiltertest:tag3") 606 607 out, _ := dockerCmd( 608 c, 609 "events", 610 "--since", since, 611 "--until", daemonUnixTime(c), 612 "--filter", fmt.Sprintf("label=%s", label), 613 "--filter", "type=image") 614 615 events := strings.Split(strings.TrimSpace(out), "\n") 616 617 // 2 events from the "docker tag" command, another one is from "docker build" 618 c.Assert(events, checker.HasLen, 3, check.Commentf("Events == %s", events)) 619 for _, e := range events { 620 c.Assert(e, checker.Contains, "labelfiltertest") 621 } 622 623 out, _ = dockerCmd( 624 c, 625 "events", 626 "--since", since, 627 "--until", daemonUnixTime(c), 628 "--filter", fmt.Sprintf("label=%s", label), 629 "--filter", "type=container") 630 events = strings.Split(strings.TrimSpace(out), "\n") 631 632 // Events generated by the container that builds the image 633 c.Assert(events, checker.HasLen, 3, check.Commentf("Events == %s", events)) 634 635 out, _ = dockerCmd( 636 c, 637 "events", 638 "--since", since, 639 "--until", daemonUnixTime(c), 640 "--filter", "type=network") 641 events = strings.Split(strings.TrimSpace(out), "\n") 642 c.Assert(len(events), checker.GreaterOrEqualThan, 1, check.Commentf("Events == %s", events)) 643 } 644 645 // #25798 646 func (s *DockerSuite) TestEventsSpecialFiltersWithExecCreate(c *check.C) { 647 since := daemonUnixTime(c) 648 runSleepingContainer(c, "--name", "test-container", "-d") 649 waitRun("test-container") 650 651 dockerCmd(c, "exec", "test-container", "echo", "hello-world") 652 653 out, _ := dockerCmd( 654 c, 655 "events", 656 "--since", since, 657 "--until", daemonUnixTime(c), 658 "--filter", 659 "event='exec_create: echo hello-world'", 660 ) 661 662 events := strings.Split(strings.TrimSpace(out), "\n") 663 c.Assert(len(events), checker.Equals, 1, check.Commentf(out)) 664 665 out, _ = dockerCmd( 666 c, 667 "events", 668 "--since", since, 669 "--until", daemonUnixTime(c), 670 "--filter", 671 "event=exec_create", 672 ) 673 c.Assert(len(events), checker.Equals, 1, check.Commentf(out)) 674 } 675 676 func (s *DockerSuite) TestEventsFilterImageInContainerAction(c *check.C) { 677 since := daemonUnixTime(c) 678 dockerCmd(c, "run", "--name", "test-container", "-d", "busybox", "true") 679 waitRun("test-container") 680 681 out, _ := dockerCmd(c, "events", "--filter", "image=busybox", "--since", since, "--until", daemonUnixTime(c)) 682 events := strings.Split(strings.TrimSpace(out), "\n") 683 c.Assert(len(events), checker.GreaterThan, 1, check.Commentf(out)) 684 } 685 686 func (s *DockerSuite) TestEventsContainerRestart(c *check.C) { 687 dockerCmd(c, "run", "-d", "--name=testEvent", "--restart=on-failure:3", "busybox", "false") 688 689 // wait until test2 is auto removed. 690 waitTime := 10 * time.Second 691 if testEnv.DaemonPlatform() == "windows" { 692 // Windows takes longer... 693 waitTime = 90 * time.Second 694 } 695 696 err := waitInspect("testEvent", "{{ .State.Restarting }} {{ .State.Running }}", "false false", waitTime) 697 c.Assert(err, checker.IsNil) 698 699 var ( 700 createCount int 701 startCount int 702 dieCount int 703 ) 704 out, _ := dockerCmd(c, "events", "--since=0", "--until", daemonUnixTime(c), "-f", "container=testEvent") 705 events := strings.Split(strings.TrimSpace(out), "\n") 706 707 nEvents := len(events) 708 c.Assert(nEvents, checker.GreaterOrEqualThan, 1) //Missing expected event 709 actions := eventActionsByIDAndType(c, events, "testEvent", "container") 710 711 for _, a := range actions { 712 switch a { 713 case "create": 714 createCount++ 715 case "start": 716 startCount++ 717 case "die": 718 dieCount++ 719 } 720 } 721 c.Assert(createCount, checker.Equals, 1, check.Commentf("testEvent should be created 1 times: %v", actions)) 722 c.Assert(startCount, checker.Equals, 4, check.Commentf("testEvent should start 4 times: %v", actions)) 723 c.Assert(dieCount, checker.Equals, 4, check.Commentf("testEvent should die 4 times: %v", actions)) 724 } 725 726 func (s *DockerSuite) TestEventsSinceInTheFuture(c *check.C) { 727 dockerCmd(c, "run", "--name", "test-container", "-d", "busybox", "true") 728 waitRun("test-container") 729 730 since := daemonTime(c) 731 until := since.Add(time.Duration(-24) * time.Hour) 732 out, _, err := dockerCmdWithError("events", "--filter", "image=busybox", "--since", parseEventTime(since), "--until", parseEventTime(until)) 733 734 c.Assert(err, checker.NotNil) 735 c.Assert(out, checker.Contains, "cannot be after `until`") 736 } 737 738 func (s *DockerSuite) TestEventsUntilInThePast(c *check.C) { 739 since := daemonUnixTime(c) 740 741 dockerCmd(c, "run", "--name", "test-container", "-d", "busybox", "true") 742 waitRun("test-container") 743 744 until := daemonUnixTime(c) 745 746 dockerCmd(c, "run", "--name", "test-container2", "-d", "busybox", "true") 747 waitRun("test-container2") 748 749 out, _ := dockerCmd(c, "events", "--filter", "image=busybox", "--since", since, "--until", until) 750 751 c.Assert(out, checker.Not(checker.Contains), "test-container2") 752 c.Assert(out, checker.Contains, "test-container") 753 } 754 755 func (s *DockerSuite) TestEventsFormat(c *check.C) { 756 since := daemonUnixTime(c) 757 dockerCmd(c, "run", "--rm", "busybox", "true") 758 dockerCmd(c, "run", "--rm", "busybox", "true") 759 out, _ := dockerCmd(c, "events", "--since", since, "--until", daemonUnixTime(c), "--format", "{{json .}}") 760 dec := json.NewDecoder(strings.NewReader(out)) 761 // make sure we got 2 start events 762 startCount := 0 763 for { 764 var err error 765 var ev eventtypes.Message 766 if err = dec.Decode(&ev); err == io.EOF { 767 break 768 } 769 c.Assert(err, checker.IsNil) 770 if ev.Status == "start" { 771 startCount++ 772 } 773 } 774 775 c.Assert(startCount, checker.Equals, 2, check.Commentf("should have had 2 start events but had %d, out: %s", startCount, out)) 776 } 777 778 func (s *DockerSuite) TestEventsFormatBadFunc(c *check.C) { 779 // make sure it fails immediately, without receiving any event 780 result := dockerCmdWithResult("events", "--format", "{{badFuncString .}}") 781 c.Assert(result, icmd.Matches, icmd.Expected{ 782 Error: "exit status 64", 783 ExitCode: 64, 784 Err: "Error parsing format: template: :1: function \"badFuncString\" not defined", 785 }) 786 } 787 788 func (s *DockerSuite) TestEventsFormatBadField(c *check.C) { 789 // make sure it fails immediately, without receiving any event 790 result := dockerCmdWithResult("events", "--format", "{{.badFieldString}}") 791 c.Assert(result, icmd.Matches, icmd.Expected{ 792 Error: "exit status 64", 793 ExitCode: 64, 794 Err: "Error parsing format: template: :1:2: executing \"\" at <.badFieldString>: can't evaluate field badFieldString in type *events.Message", 795 }) 796 }