IGT-Version: 1.15-gb0658ce (x86_64) (Linux: 4.8.0-rc3-nightly+ x86_64)
(kms_cursor_legacy:8973) igt-core-DEBUG: Test requirement passed: !igt_run_in_simulation()
(kms_cursor_legacy:8973) drmtest-DEBUG: Test requirement passed: !(fd<0)
(kms_cursor_legacy:8973) drmtest-DEBUG: Test requirement passed: drmSetMaster(fd) == 0
(kms_cursor_legacy:8973) igt-kms-DEBUG: VT: graphics mode set (mode was 0x0)
(kms_cursor_legacy:8973) igt-kms-DEBUG: display: init {
(kms_cursor_legacy:8973) igt-kms-DEBUG: display: }
(kms_cursor_legacy:8973) DEBUG: Test requirement passed: display.n_pipes > 0
(kms_cursor_legacy:8973) DEBUG: Test requirement passed: !(n >= display.n_pipes)
(kms_cursor_legacy:8973) DEBUG: Test requirement passed: !(n >= display.n_pipes)
(kms_cursor_legacy:8973) DEBUG: Test requirement passed: !(n >= display.n_pipes)
(kms_cursor_legacy:8973) igt-core-DEBUG: Starting subtest: long-flip-vs-cursor-varying-size
(kms_cursor_legacy:8973) DEBUG: Test requirement passed: found
(kms_cursor_legacy:8973) igt-kms-DEBUG: display: HDMI-A-3: set_pipe(C)
(kms_cursor_legacy:8973) igt-fb-DEBUG: igt_create_fb_with_bo_size(width=1920, height=1080, format=0x34325258, tiling=0x0, size=0)
(kms_cursor_legacy:8973) igt-fb-DEBUG: igt_create_fb_with_bo_size(handle=1, pitch=7680)
(kms_cursor_legacy:8973) igt-kms-DEBUG: display: C.0: plane_set_fb(81)
(kms_cursor_legacy:8973) DEBUG: Test requirement passed: set_fb_on_crtc(display, pipe, &fb_info)
(kms_cursor_legacy:8973) igt-fb-DEBUG: igt_create_fb_with_bo_size(width=64, height=64, format=0x34325241, tiling=0x0, size=0)
(kms_cursor_legacy:8973) igt-fb-DEBUG: igt_create_fb_with_bo_size(handle=2, pitch=256)
(kms_cursor_legacy:8973) DEBUG: Test requirement passed: cursor
(kms_cursor_legacy:8973) igt-kms-DEBUG: display: C.3: plane_set_fb(82)
(kms_cursor_legacy:8973) DEBUG: Test requirement passed: !(width <= 64 && height <= 64)
(kms_cursor_legacy:8973) igt-fb-DEBUG: igt_create_fb_with_bo_size(width=256, height=256, format=0x34325241, tiling=0x0, size=0)
(kms_cursor_legacy:8973) igt-fb-DEBUG: igt_create_fb_with_bo_size(handle=3, pitch=1024)
(kms_cursor_legacy:8973) igt-kms-DEBUG: display: commit {
(kms_cursor_legacy:8973) igt-kms-DEBUG: display:     HDMI-A-3: Selecting pipe C
(kms_cursor_legacy:8973) igt-kms-DEBUG: display:     SetCrtc pipe A, disabling
(kms_cursor_legacy:8973) igt-kms-DEBUG: display:     SetPlane pipe A, plane 1, disabling
(kms_cursor_legacy:8973) igt-kms-DEBUG: display:     SetPlane pipe A, plane 2, disabling
(kms_cursor_legacy:8973) igt-kms-DEBUG: display:     SetCursor pipe A, disabling
(kms_cursor_legacy:8973) igt-kms-DEBUG: display:     SetCrtc pipe B, disabling
(kms_cursor_legacy:8973) igt-kms-DEBUG: display:     SetPlane pipe B, plane 1, disabling
(kms_cursor_legacy:8973) igt-kms-DEBUG: display:     SetPlane pipe B, plane 2, disabling
(kms_cursor_legacy:8973) igt-kms-DEBUG: display:     SetCursor pipe B, disabling
(kms_cursor_legacy:8973) igt-kms-DEBUG: display:     HDMI-A-3: SetCrtc pipe C, fb 81, src (0, 0), mode 1920x1080
(kms_cursor_legacy:8973) igt-kms-DEBUG: display:     SetPlane pipe C, plane 1, disabling
(kms_cursor_legacy:8973) igt-kms-DEBUG: display:     SetPlane pipe C, plane 2, disabling
(kms_cursor_legacy:8973) igt-kms-DEBUG: display:     SetCursor pipe C, fb 2 64x64
(kms_cursor_legacy:8973) igt-kms-DEBUG: display: }
(kms_cursor_legacy:8973) DEBUG: Test requirement passed: target > 1
(kms_cursor_legacy:8973) DEBUG: Using a target of 256 cursor updates per half-vblank
(kms_cursor_legacy:8973) CRITICAL: Test assertion failure function basic_flip_vs_cursor, file kms_cursor_legacy.c:513:
(kms_cursor_legacy:8973) CRITICAL: Failed assertion: get_vblank(display->drm_fd, pipe, 0) == vblank_start
(kms_cursor_legacy:8973) CRITICAL: error: 46610 != 46609
Stack trace:
  #0 [__igt_fail_assert+0xf1]
  #1 [basic_flip_vs_cursor+0x60a]
  #2 [__real_main864+0xb9d]
  #3 [main+0x29]
  #4 [__libc_start_main+0xf0]
  #5 [_start+0x29]
  #6 [<unknown>+0x29]
Subtest long-flip-vs-cursor-varying-size failed.
**** DEBUG ****
(kms_cursor_legacy:8973) DEBUG: Test requirement passed: found
(kms_cursor_legacy:8973) igt-kms-DEBUG: display: HDMI-A-3: set_pipe(C)
(kms_cursor_legacy:8973) igt-fb-DEBUG: igt_create_fb_with_bo_size(width=1920, height=1080, format=0x34325258, tiling=0x0, size=0)
(kms_cursor_legacy:8973) igt-fb-DEBUG: igt_create_fb_with_bo_size(handle=1, pitch=7680)
(kms_cursor_legacy:8973) igt-kms-DEBUG: display: C.0: plane_set_fb(81)
(kms_cursor_legacy:8973) DEBUG: Test requirement passed: set_fb_on_crtc(display, pipe, &fb_info)
(kms_cursor_legacy:8973) igt-fb-DEBUG: igt_create_fb_with_bo_size(width=64, height=64, format=0x34325241, tiling=0x0, size=0)
(kms_cursor_legacy:8973) igt-fb-DEBUG: igt_create_fb_with_bo_size(handle=2, pitch=256)
(kms_cursor_legacy:8973) DEBUG: Test requirement passed: cursor
(kms_cursor_legacy:8973) igt-kms-DEBUG: display: C.3: plane_set_fb(82)
(kms_cursor_legacy:8973) DEBUG: Test requirement passed: !(width <= 64 && height <= 64)
(kms_cursor_legacy:8973) igt-fb-DEBUG: igt_create_fb_with_bo_size(width=256, height=256, format=0x34325241, tiling=0x0, size=0)
(kms_cursor_legacy:8973) igt-fb-DEBUG: igt_create_fb_with_bo_size(handle=3, pitch=1024)
(kms_cursor_legacy:8973) igt-kms-DEBUG: display: commit {
(kms_cursor_legacy:8973) igt-kms-DEBUG: display:     HDMI-A-3: Selecting pipe C
(kms_cursor_legacy:8973) igt-kms-DEBUG: display:     SetCrtc pipe A, disabling
(kms_cursor_legacy:8973) igt-kms-DEBUG: display:     SetPlane pipe A, plane 1, disabling
(kms_cursor_legacy:8973) igt-kms-DEBUG: display:     SetPlane pipe A, plane 2, disabling
(kms_cursor_legacy:8973) igt-kms-DEBUG: display:     SetCursor pipe A, disabling
(kms_cursor_legacy:8973) igt-kms-DEBUG: display:     SetCrtc pipe B, disabling
(kms_cursor_legacy:8973) igt-kms-DEBUG: display:     SetPlane pipe B, plane 1, disabling
(kms_cursor_legacy:8973) igt-kms-DEBUG: display:     SetPlane pipe B, plane 2, disabling
(kms_cursor_legacy:8973) igt-kms-DEBUG: display:     SetCursor pipe B, disabling
(kms_cursor_legacy:8973) igt-kms-DEBUG: display:     HDMI-A-3: SetCrtc pipe C, fb 81, src (0, 0), mode 1920x1080
(kms_cursor_legacy:8973) igt-kms-DEBUG: display:     SetPlane pipe C, plane 1, disabling
(kms_cursor_legacy:8973) igt-kms-DEBUG: display:     SetPlane pipe C, plane 2, disabling
(kms_cursor_legacy:8973) igt-kms-DEBUG: display:     SetCursor pipe C, fb 2 64x64
(kms_cursor_legacy:8973) igt-kms-DEBUG: display: }
(kms_cursor_legacy:8973) DEBUG: Test requirement passed: target > 1
(kms_cursor_legacy:8973) DEBUG: Using a target of 256 cursor updates per half-vblank
(kms_cursor_legacy:8973) CRITICAL: Test assertion failure function basic_flip_vs_cursor, file kms_cursor_legacy.c:513:
(kms_cursor_legacy:8973) CRITICAL: Failed assertion: get_vblank(display->drm_fd, pipe, 0) == vblank_start
(kms_cursor_legacy:8973) CRITICAL: error: 46610 != 46609
****  END  ****
Subtest long-flip-vs-cursor-varying-size: FAIL (0.439s)
(kms_cursor_legacy:8973) igt-core-DEBUG: Exiting with status code 99
(kms_cursor_legacy:8973) igt-kms-DEBUG: VT: original mode 0x0 restored