# ./kms_flip --run-subtest vblank-vs-suspend-interruptible
IGT-Version: 1.14-NOT-GIT (x86_64) (Linux: 4.5.0-nightly+ x86_64)
Using monotonic timestamps
Beginning vblank-vs-suspend-interruptible on pipe A, connector HDMI-A-1
  1920x1080 60 1920 2008 2052 2200 1080 1084 1089 1125 0x5 0x48 148500
.rtcwake: assuming RTC uses UTC ...
rtcwake: wakeup from "mem" using /dev/rtc0 at Thu Mar 24 14:31:33 2016
.rtcwake: assuming RTC uses UTC ...
rtcwake: wakeup from "mem" using /dev/rtc0 at Thu Mar 24 14:32:09 2016

vblank-vs-suspend-interruptible on pipe A, connector HDMI-A-1: PASSED

Beginning vblank-vs-suspend-interruptible on pipe B, connector HDMI-A-1
  1920x1080 60 1920 2008 2052 2200 1080 1084 1089 1125 0x5 0x48 148500
.rtcwake: assuming RTC uses UTC ...
rtcwake: wakeup from "mem" using /dev/rtc0 at Thu Mar 24 14:32:45 2016
.rtcwake: assuming RTC uses UTC ...
rtcwake: wakeup from "mem" using /dev/rtc0 at Thu Mar 24 14:33:21 2016
(kms_flip:1605) CRITICAL: Test assertion failure function check_state, file kms_flip.c:679:
(kms_flip:1605) CRITICAL: Failed assertion: es->current_seq - es->last_seq <= 150
(kms_flip:1605) CRITICAL: Last errno: 4, Interrupted system call
(kms_flip:1605) CRITICAL: unexpected vblank seq 262, should be < 163
Stack trace:
  #0 [__igt_fail_assert+0xf1]
  #1 [check_state+0x32d]
  #2 [run_test_on_crtc_set.constprop.13+0xbed]
  #3 [run_test+0x25a]
  #4 [main+0x500]
  #5 [__libc_start_main+0xf5]
  #6 [_start+0x29]
  #7 [<unknown>+0x29]
Subtest vblank-vs-suspend-interruptible failed.
**** DEBUG ****
(kms_flip:1605) DEBUG: Test requirement passed: (flags & TEST_HANG) == 0 || !is_hung(drm_fd)
(kms_flip:1605) DEBUG: Test requirement passed: modes
(kms_flip:1605) INFO: Beginning vblank-vs-suspend-interruptible on pipe A, connector HDMI-A-1
(kms_flip:1605) igt-fb-DEBUG: igt_create_fb_with_bo_size(width=1920, height=1080, format=0x34325258 [bpp=32], tiling=0x0, size=0)
(kms_flip:1605) igt-fb-DEBUG: igt_create_fb_with_bo_size(handle=2, pitch=7680)
(kms_flip:1605) igt-fb-DEBUG: igt_create_fb_with_bo_size(width=1920, height=1080, format=0x34325258 [bpp=32], tiling=0x0, size=0)
(kms_flip:1605) igt-fb-DEBUG: igt_create_fb_with_bo_size(handle=3, pitch=7680)
(kms_flip:1605) igt-fb-DEBUG: igt_create_fb_with_bo_size(width=1920, height=1080, format=0x34325258 [bpp=32], tiling=0x100000000000001, size=0)
(kms_flip:1605) igt-fb-DEBUG: igt_create_fb_with_bo_size(handle=4, pitch=7680)
(kms_flip:1605) igt-kms-INFO:   1920x1080 60 1920 2008 2052 2200 1080 1084 1089 1125 0x5 0x48 148500
(kms_flip:1605) igt-core-DEBUG: Test requirement passed: !igt_run_in_simulation()
(kms_flip:1605) igt-aux-DEBUG: Test requirement passed: system("rtcwake -n -s 30 -m mem" SQUELCH) == 0
(kms_flip:1605) DEBUG: name = vblank
last_ts = 0.0 usec
last_received_ts = 0.0 usec
last_seq = 0
current_ts = 68.929116 usec
current_received_ts = 70.377476 usec
current_seq = 3414
count = 0
seq_step = 10
(kms_flip:1605) igt-core-DEBUG: Test requirement passed: !igt_run_in_simulation()
(kms_flip:1605) igt-aux-DEBUG: Test requirement passed: system("rtcwake -n -s 30 -m mem" SQUELCH) == 0
(kms_flip:1605) DEBUG: name = vblank
last_ts = 68.929116 usec
last_received_ts = 70.377476 usec
last_seq = 3414
current_ts = 70.539816 usec
current_received_ts = 76.33373 usec
current_seq = 3456
count = 1
seq_step = 10
(kms_flip:1605) DEBUG: testing ts continuity: Current frame 3456, old frame 3414
(kms_flip:1605) INFO:
vblank-vs-suspend-interruptible on pipe A, connector HDMI-A-1: PASSED

(kms_flip:1605) INFO: Beginning vblank-vs-suspend-interruptible on pipe B, connector HDMI-A-1
(kms_flip:1605) igt-fb-DEBUG: igt_create_fb_with_bo_size(width=1920, height=1080, format=0x34325258 [bpp=32], tiling=0x0, size=0)
(kms_flip:1605) igt-fb-DEBUG: igt_create_fb_with_bo_size(handle=2, pitch=7680)
(kms_flip:1605) igt-fb-DEBUG: igt_create_fb_with_bo_size(width=1920, height=1080, format=0x34325258 [bpp=32], tiling=0x0, size=0)
(kms_flip:1605) igt-fb-DEBUG: igt_create_fb_with_bo_size(handle=3, pitch=7680)
(kms_flip:1605) igt-fb-DEBUG: igt_create_fb_with_bo_size(width=1920, height=1080, format=0x34325258 [bpp=32], tiling=0x100000000000001, size=0)
(kms_flip:1605) igt-fb-DEBUG: igt_create_fb_with_bo_size(handle=4, pitch=7680)
(kms_flip:1605) igt-kms-INFO:   1920x1080 60 1920 2008 2052 2200 1080 1084 1089 1125 0x5 0x48 148500
(kms_flip:1605) igt-core-DEBUG: Test requirement passed: !igt_run_in_simulation()
(kms_flip:1605) igt-aux-DEBUG: Test requirement passed: system("rtcwake -n -s 30 -m mem" SQUELCH) == 0
(kms_flip:1605) DEBUG: name = vblank
last_ts = 0.0 usec
last_received_ts = 0.0 usec
last_seq = 0
current_ts = 76.668106 usec
current_received_ts = 81.619499 usec
current_seq = 13
count = 0
seq_step = 10
(kms_flip:1605) igt-core-DEBUG: Test requirement passed: !igt_run_in_simulation()
(kms_flip:1605) igt-aux-DEBUG: Test requirement passed: system("rtcwake -n -s 30 -m mem" SQUELCH) == 0
(kms_flip:1605) DEBUG: name = vblank
last_ts = 76.668106 usec
last_received_ts = 81.619499 usec
last_seq = 13
current_ts = 81.780785 usec
current_received_ts = 87.102059 usec
current_seq = 262
count = 1
seq_step = 10
(kms_flip:1605) CRITICAL: Test assertion failure function check_state, file kms_flip.c:679:
(kms_flip:1605) CRITICAL: Failed assertion: es->current_seq - es->last_seq <= 150
(kms_flip:1605) CRITICAL: Last errno: 4, Interrupted system call
(kms_flip:1605) CRITICAL: unexpected vblank seq 262, should be < 163
****  END  ****
Subtest vblank-vs-suspend-interruptible: FAIL (22.835s)