[Bug 79052] [All] igt/kms_flip subcases vblank-vs-suspend and vblank-vs-suspend-interruptible fail

Wed Nov 30 02:18:42 UTC 2016

https://bugs.freedesktop.org/show_bug.cgi?id=79052

--- Comment #36 from Carlos Santa <carlos.santa at intel.com> ---
On BDW, it passed 3 times and failed twice, behavior appears to be sporadic.
I've attached the dmesg of the last failure (read bottom first). This was on
drm-nightly ~11/29/2016

csanta at csanta-bdw:~$ sudo ./kms_flip --run-subtest vblank-vs-suspend
IGT-Version: 1.16-gcb214ef (x86_64) (Linux: 4.9.0-rc6+ x86_64)
Using monotonic timestamps
Beginning vblank-vs-suspend on pipe A, connector HDMI-A-1
  1920x1080 60 1920 1968 2000 2080 1080 1083 1088 1112 0x9 0x48 138780
.rtcwake: assuming RTC uses UTC ...
rtcwake: wakeup from "mem" using /dev/rtc0 at Wed Nov 30 02:07:13 2016
.rtcwake: assuming RTC uses UTC ...
rtcwake: wakeup from "mem" using /dev/rtc0 at Wed Nov 30 02:07:30 2016

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

Beginning vblank-vs-suspend on pipe B, connector HDMI-A-1
  1920x1080 60 1920 1968 2000 2080 1080 1083 1088 1112 0x9 0x48 138780
.rtcwake: assuming RTC uses UTC ...
rtcwake: wakeup from "mem" using /dev/rtc0 at Wed Nov 30 02:07:48 2016
.rtcwake: assuming RTC uses UTC ...
rtcwake: wakeup from "mem" using /dev/rtc0 at Wed Nov 30 02:08:06 2016

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

Beginning vblank-vs-suspend on pipe C, connector HDMI-A-1
  1920x1080 60 1920 1968 2000 2080 1080 1083 1088 1112 0x9 0x48 138780
.rtcwake: assuming RTC uses UTC ...
rtcwake: wakeup from "mem" using /dev/rtc0 at Wed Nov 30 02:08:23 2016
.rtcwake: assuming RTC uses UTC ...
rtcwake: wakeup from "mem" using /dev/rtc0 at Wed Nov 30 02:08:41 2016

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

Subtest vblank-vs-suspend: SUCCESS (10.980s)


csanta at csanta-bdw:~$ sudo ./kms_flip --run-subtest vblank-vs-suspend
IGT-Version: 1.16-gcb214ef (x86_64) (Linux: 4.9.0-rc6+ x86_64)
Using monotonic timestamps
Beginning vblank-vs-suspend on pipe A, connector HDMI-A-1
  1920x1080 60 1920 1968 2000 2080 1080 1083 1088 1112 0x9 0x48 138780
.rtcwake: assuming RTC uses UTC ...
rtcwake: wakeup from "mem" using /dev/rtc0 at Wed Nov 30 02:09:29 2016
.rtcwake: assuming RTC uses UTC ...
rtcwake: wakeup from "mem" using /dev/rtc0 at Wed Nov 30 02:09:46 2016

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

Beginning vblank-vs-suspend on pipe B, connector HDMI-A-1
  1920x1080 60 1920 1968 2000 2080 1080 1083 1088 1112 0x9 0x48 138780
.rtcwake: assuming RTC uses UTC ...
rtcwake: wakeup from "mem" using /dev/rtc0 at Wed Nov 30 02:10:04 2016
.rtcwake: assuming RTC uses UTC ...
rtcwake: wakeup from "mem" using /dev/rtc0 at Wed Nov 30 02:10:22 2016

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

Beginning vblank-vs-suspend on pipe C, connector HDMI-A-1
  1920x1080 60 1920 1968 2000 2080 1080 1083 1088 1112 0x9 0x48 138780
.rtcwake: assuming RTC uses UTC ...
rtcwake: wakeup from "mem" using /dev/rtc0 at Wed Nov 30 02:11:12 2016
.rtcwake: assuming RTC uses UTC ...
rtcwake: wakeup from "mem" using /dev/rtc0 at Wed Nov 30 02:11:29 2016
(kms_flip:1764) CRITICAL: Test assertion failure function check_state, file
kms_flip.c:510:
(kms_flip:1764) CRITICAL: Failed assertion: es->current_seq - es->last_seq <=
150
(kms_flip:1764) CRITICAL: unexpected vblank seq 2309, should be < 487
Stack trace:
  #0 [__igt_fail_assert+0x101]
  #1 [check_state+0x331]
  #2 [<unknown>+0x331]
Subtest vblank-vs-suspend failed.
**** DEBUG ****
(kms_flip:1764) DEBUG: Test requirement passed: (flags & TEST_HANG) == 0 ||
!is_wedged(drm_fd)
(kms_flip:1764) DEBUG: Test requirement passed: modes
(kms_flip:1764) INFO: Beginning vblank-vs-suspend on pipe A, connector HDMI-A-1
(kms_flip:1764) igt-fb-DEBUG: igt_create_fb_with_bo_size(width=1920,
height=1080, format=0x34325258, tiling=0x0, size=0)
(kms_flip:1764) igt-fb-DEBUG: igt_create_fb_with_bo_size(handle=2, pitch=7680)
(kms_flip:1764) igt-fb-DEBUG: igt_create_fb_with_bo_size(width=1920,
height=1080, format=0x34325258, tiling=0x0, size=0)
(kms_flip:1764) igt-fb-DEBUG: igt_create_fb_with_bo_size(handle=3, pitch=7680)
(kms_flip:1764) igt-kms-INFO:   1920x1080 60 1920 1968 2000 2080 1080 1083 1088
1112 0x9 0x48 138780
(kms_flip:1764) igt-core-DEBUG: Test requirement passed:
!igt_run_in_simulation()
(kms_flip:1764) igt-aux-DEBUG: Test requirement passed: (power_dir =
open("/sys/power", O_RDONLY)) >= 0
(kms_flip:1764) igt-aux-DEBUG: Test requirement passed:
get_supported_suspend_states(power_dir) & (1 << state)
(kms_flip:1764) igt-aux-DEBUG: Test requirement passed: test ==
SUSPEND_TEST_NONE || faccessat(power_dir, "pm_test", R_OK | W_OK, 0) == 0
(kms_flip:1764) igt-aux-DEBUG: Test requirement passed: system(cmd) == 0
(kms_flip:1764) DEBUG: name = vblank
last_ts = 0.000000
last_received_ts = 0.000000
last_seq = 0
current_ts = 177.945129
current_received_ts = 178.617435
current_seq = 9699
count = 0
seq_step = 10
(kms_flip:1764) igt-core-DEBUG: Test requirement passed:
!igt_run_in_simulation()
(kms_flip:1764) igt-aux-DEBUG: Test requirement passed: (power_dir =
open("/sys/power", O_RDONLY)) >= 0
(kms_flip:1764) igt-aux-DEBUG: Test requirement passed:
get_supported_suspend_states(power_dir) & (1 << state)
(kms_flip:1764) igt-aux-DEBUG: Test requirement passed: test ==
SUSPEND_TEST_NONE || faccessat(power_dir, "pm_test", R_OK | W_OK, 0) == 0
(kms_flip:1764) igt-aux-DEBUG: Test requirement passed: system(cmd) == 0
(kms_flip:1764) DEBUG: name = vblank
last_ts = 177.945129
last_received_ts = 178.617435
last_seq = 9699
current_ts = 178.783608
current_received_ts = 181.087330
current_seq = 9734
count = 1
seq_step = 10
(kms_flip:1764) DEBUG: testing ts continuity: Current frame 9734, old frame
9699
(kms_flip:1764) INFO: 
vblank-vs-suspend on pipe A, connector HDMI-A-1: PASSED

(kms_flip:1764) INFO: Beginning vblank-vs-suspend on pipe B, connector HDMI-A-1
(kms_flip:1764) igt-fb-DEBUG: igt_create_fb_with_bo_size(width=1920,
height=1080, format=0x34325258, tiling=0x0, size=0)
(kms_flip:1764) igt-fb-DEBUG: igt_create_fb_with_bo_size(handle=2, pitch=7680)
(kms_flip:1764) igt-fb-DEBUG: igt_create_fb_with_bo_size(width=1920,
height=1080, format=0x34325258, tiling=0x0, size=0)
(kms_flip:1764) igt-fb-DEBUG: igt_create_fb_with_bo_size(handle=3, pitch=7680)
(kms_flip:1764) igt-kms-INFO:   1920x1080 60 1920 1968 2000 2080 1080 1083 1088
1112 0x9 0x48 138780
(kms_flip:1764) igt-core-DEBUG: Test requirement passed:
!igt_run_in_simulation()
(kms_flip:1764) igt-aux-DEBUG: Test requirement passed: (power_dir =
open("/sys/power", O_RDONLY)) >= 0
(kms_flip:1764) igt-aux-DEBUG: Test requirement passed:
get_supported_suspend_states(power_dir) & (1 << state)
(kms_flip:1764) igt-aux-DEBUG: Test requirement passed: test ==
SUSPEND_TEST_NONE || faccessat(power_dir, "pm_test", R_OK | W_OK, 0) == 0
(kms_flip:1764) igt-aux-DEBUG: Test requirement passed: system(cmd) == 0
(kms_flip:1764) DEBUG: name = vblank
last_ts = 0.000000
last_received_ts = 0.000000
last_seq = 0
current_ts = 181.332199
current_received_ts = 183.546924
current_seq = 416
count = 0
seq_step = 10
(kms_flip:1764) igt-core-DEBUG: Test requirement passed:
!igt_run_in_simulation()
(kms_flip:1764) igt-aux-DEBUG: Test requirement passed: (power_dir =
open("/sys/power", O_RDONLY)) >= 0
(kms_flip:1764) igt-aux-DEBUG: Test requirement passed:
get_supported_suspend_states(power_dir) & (1 << state)
(kms_flip:1764) igt-aux-DEBUG: Test requirement passed: test ==
SUSPEND_TEST_NONE || faccessat(power_dir, "pm_test", R_OK | W_OK, 0) == 0
(kms_flip:1764) igt-aux-DEBUG: Test requirement passed: system(cmd) == 0
(kms_flip:1764) DEBUG: name = vblank
last_ts = 181.332199
last_received_ts = 183.546924
last_seq = 416
current_ts = 183.707285
current_received_ts = 186.016916
current_seq = 543
count = 1
seq_step = 10
(kms_flip:1764) DEBUG: testing ts continuity: Current frame 543, old frame 416
(kms_flip:1764) INFO: 
vblank-vs-suspend on pipe B, connector HDMI-A-1: PASSED

(kms_flip:1764) INFO: Beginning vblank-vs-suspend on pipe C, connector HDMI-A-1
(kms_flip:1764) igt-fb-DEBUG: igt_create_fb_with_bo_size(width=1920,
height=1080, format=0x34325258, tiling=0x0, size=0)
(kms_flip:1764) igt-fb-DEBUG: igt_create_fb_with_bo_size(handle=2, pitch=7680)
(kms_flip:1764) igt-fb-DEBUG: igt_create_fb_with_bo_size(width=1920,
height=1080, format=0x34325258, tiling=0x0, size=0)
(kms_flip:1764) igt-fb-DEBUG: igt_create_fb_with_bo_size(handle=3, pitch=7680)
(kms_flip:1764) igt-kms-INFO:   1920x1080 60 1920 1968 2000 2080 1080 1083 1088
1112 0x9 0x48 138780
(kms_flip:1764) igt-core-DEBUG: Test requirement passed:
!igt_run_in_simulation()
(kms_flip:1764) igt-aux-DEBUG: Test requirement passed: (power_dir =
open("/sys/power", O_RDONLY)) >= 0
(kms_flip:1764) igt-aux-DEBUG: Test requirement passed:
get_supported_suspend_states(power_dir) & (1 << state)
(kms_flip:1764) igt-aux-DEBUG: Test requirement passed: test ==
SUSPEND_TEST_NONE || faccessat(power_dir, "pm_test", R_OK | W_OK, 0) == 0
(kms_flip:1764) igt-aux-DEBUG: Test requirement passed: system(cmd) == 0
(kms_flip:1764) DEBUG: name = vblank
last_ts = 0.000000
last_received_ts = 0.000000
last_seq = 0
current_ts = 186.244780
current_received_ts = 219.213699
current_seq = 337
count = 0
seq_step = 10
(kms_flip:1764) igt-core-DEBUG: Test requirement passed:
!igt_run_in_simulation()
(kms_flip:1764) igt-aux-DEBUG: Test requirement passed: (power_dir =
open("/sys/power", O_RDONLY)) >= 0
(kms_flip:1764) igt-aux-DEBUG: Test requirement passed:
get_supported_suspend_states(power_dir) & (1 << state)
(kms_flip:1764) igt-aux-DEBUG: Test requirement passed: test ==
SUSPEND_TEST_NONE || faccessat(power_dir, "pm_test", R_OK | W_OK, 0) == 0
(kms_flip:1764) igt-aux-DEBUG: Test requirement passed: system(cmd) == 0
(kms_flip:1764) DEBUG: name = vblank
last_ts = 186.244780
last_received_ts = 219.213699
last_seq = 337
current_ts = 219.377694
current_received_ts = 220.648964
current_seq = 2309
count = 1
seq_step = 10
(kms_flip:1764) CRITICAL: Test assertion failure function check_state, file
kms_flip.c:510:
(kms_flip:1764) CRITICAL: Failed assertion: es->current_seq - es->last_seq <=
150
(kms_flip:1764) CRITICAL: unexpected vblank seq 2309, should be < 487
****  END  ****
Subtest vblank-vs-suspend: FAIL (42.825s)

-- 
You are receiving this mail because:
You are on the CC list for the bug.
You are the QA Contact for the bug.
You are the assignee for the bug.
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <https://lists.freedesktop.org/archives/intel-gfx-bugs/attachments/20161130/aba11c48/attachment-0001.html>