[Bug 98289] [BDW] kms_flip / vblank-vs-suspend-interruptible is failing

bugzilla-daemon at freedesktop.org bugzilla-daemon at freedesktop.org
Thu Dec 1 01:10:31 UTC 2016 

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

--- Comment #6 from Carlos Santa <carlos.santa at intel.com> ---
I am seeing this when it fails:

csanta at csanta-bdw:~$ sudo ./kms_flip --r vblank-vs-suspend-interruptible
[sudo] password for csanta: 
IGT-Version: 1.16-gcb214ef (x86_64) (Linux: 4.9.0-rc6+ x86_64)
Using monotonic timestamps
Beginning vblank-vs-suspend-interruptible 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 Thu Dec  1 01:01:31 2016
.rtcwake: assuming RTC uses UTC ...
rtcwake: wakeup from "mem" using /dev/rtc0 at Thu Dec  1 01:01:49 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 1968 2000 2080 1080 1083 1088 1112 0x9 0x48 138780
.rtcwake: assuming RTC uses UTC ...
rtcwake: wakeup from "mem" using /dev/rtc0 at Thu Dec  1 01:02:07 2016
.rtcwake: assuming RTC uses UTC ...
rtcwake: wakeup from "mem" using /dev/rtc0 at Thu Dec  1 01:02:25 2016

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

Beginning vblank-vs-suspend-interruptible 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 Thu Dec  1 01:03:16 2016
.rtcwake: assuming RTC uses UTC ...
rtcwake: wakeup from "mem" using /dev/rtc0 at Thu Dec  1 01:03:33 2016
(kms_flip:1128) CRITICAL: Test assertion failure function check_state, file
kms_flip.c:510:
(kms_flip:1128) CRITICAL: Failed assertion: es->current_seq - es->last_seq <=
150
(kms_flip:1128) CRITICAL: Last errno: 4, Interrupted system call
(kms_flip:1128) CRITICAL: unexpected vblank seq 2022, should be < 164
Stack trace:
  #0 [__igt_fail_assert+0x101]
  #1 [check_state+0x331]
  #2 [<unknown>+0x331]
Subtest vblank-vs-suspend-interruptible failed.
**** DEBUG ****
(kms_flip:1128) DEBUG: Test requirement passed: (flags & TEST_HANG) == 0 ||
!is_wedged(drm_fd)
(kms_flip:1128) DEBUG: Test requirement passed: modes
(kms_flip:1128) INFO: Beginning vblank-vs-suspend-interruptible on pipe A,
connector HDMI-A-1
(kms_flip:1128) igt-fb-DEBUG: igt_create_fb_with_bo_size(width=1920,
height=1080, format=0x34325258, tiling=0x0, size=0)
(kms_flip:1128) igt-fb-DEBUG: igt_create_fb_with_bo_size(handle=2, pitch=7680)
(kms_flip:1128) igt-fb-DEBUG: igt_create_fb_with_bo_size(width=1920,
height=1080, format=0x34325258, tiling=0x0, size=0)
(kms_flip:1128) igt-fb-DEBUG: igt_create_fb_with_bo_size(handle=3, pitch=7680)
(kms_flip:1128) igt-kms-INFO:   1920x1080 60 1920 1968 2000 2080 1080 1083 1088
1112 0x9 0x48 138780
(kms_flip:1128) igt-core-DEBUG: Test requirement passed:
!igt_run_in_simulation()
(kms_flip:1128) igt-aux-DEBUG: Test requirement passed: (power_dir =
open("/sys/power", O_RDONLY)) >= 0
(kms_flip:1128) igt-aux-DEBUG: Test requirement passed:
get_supported_suspend_states(power_dir) & (1 << state)
(kms_flip:1128) igt-aux-DEBUG: Test requirement passed: test ==
SUSPEND_TEST_NONE || faccessat(power_dir, "pm_test", R_OK | W_OK, 0) == 0
(kms_flip:1128) igt-aux-DEBUG: Test requirement passed: system(cmd) == 0
(kms_flip:1128) DEBUG: name = vblank
last_ts = 0.000000
last_received_ts = 0.000000
last_seq = 0
current_ts = 73.711808
current_received_ts = 75.530334
current_seq = 4357
count = 0
seq_step = 10
(kms_flip:1128) igt-core-DEBUG: Test requirement passed:
!igt_run_in_simulation()
(kms_flip:1128) igt-aux-DEBUG: Test requirement passed: (power_dir =
open("/sys/power", O_RDONLY)) >= 0
(kms_flip:1128) igt-aux-DEBUG: Test requirement passed:
get_supported_suspend_states(power_dir) & (1 << state)
(kms_flip:1128) igt-aux-DEBUG: Test requirement passed: test ==
SUSPEND_TEST_NONE || faccessat(power_dir, "pm_test", R_OK | W_OK, 0) == 0
(kms_flip:1128) igt-aux-DEBUG: Test requirement passed: system(cmd) == 0
(kms_flip:1128) DEBUG: name = vblank
last_ts = 73.711808
last_received_ts = 75.530334
last_seq = 4357
current_ts = 75.682263
current_received_ts = 78.011187
current_seq = 4461
count = 1
seq_step = 10
(kms_flip:1128) DEBUG: testing ts continuity: Current frame 4461, old frame
4357
(kms_flip:1128) INFO: 
vblank-vs-suspend-interruptible on pipe A, connector HDMI-A-1: PASSED

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

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

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

More information about the intel-gfx-bugs mailing list