Stdout
Starting dynamic subtest: B-DP3
3840x2160: 60 533250 3840 3888 3920 4000 2160 2163 2168 2222 0x48 0x9
Stack trace:
#0 ../../../usr/src/igt-gpu-tools/lib/igt_core.c:2051 __igt_fail_assert()
#1 [kmstest_set_connector_dpms+0x12b]
#2 ../../../usr/src/igt-gpu-tools/tests/kms_flip.c:484 run_test_on_crtc_set()
#3 ../../../usr/src/igt-gpu-tools/tests/kms_flip.c:1845 run_test()
#4 ../../../usr/src/igt-gpu-tools/tests/kms_flip.c:2078 __igt_unique____real_main2001()
#5 ../../../usr/src/igt-gpu-tools/tests/kms_flip.c:2001 main()
#6 [__libc_start_main+0xf3]
#7 [_start+0x2e]
Dynamic subtest B-DP3: FAIL (0.633s)
Stderr
Starting dynamic subtest: B-DP3
(kms_flip:5353) igt_kms-CRITICAL: Test assertion failure function kmstest_set_connector_dpms, file ../../../usr/src/igt-gpu-tools/lib/igt_kms.c:2212:
(kms_flip:5353) igt_kms-CRITICAL: Failed assertion: drmModeConnectorSetProperty(fd, connector->connector_id, dpms, mode) == 0
(kms_flip:5353) igt_kms-CRITICAL: Last errno: 22, Invalid argument
Dynamic subtest B-DP3 failed.
**** DEBUG ****
(kms_flip:5353) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=3840, height=2160, format=XR24(0x34325258), modifier=0x0, size=0)
(kms_flip:5353) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=1, pitch=15360)
(kms_flip:5353) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd)
(kms_flip:5353) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=3840, height=2160, format=XR24(0x34325258), modifier=0x0, size=0)
(kms_flip:5353) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=2, pitch=15360)
(kms_flip:5353) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd)
(kms_flip:5353) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:5353) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:5353) igt_fb-DEBUG: Test requirement passed: gem_has_contexts(fb->fd)
(kms_flip:5353) intel_allocator_reloc-DEBUG: Using reloc allocator
(kms_flip:5353) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:5353) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:5353) igt_fb-DEBUG: Test requirement passed: gem_has_contexts(fb->fd)
(kms_flip:5353) intel_allocator_reloc-DEBUG: Using reloc allocator
(kms_flip:5353) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:5353) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:5353) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:5353) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:5353) igt_fb-DEBUG: Test requirement passed: gem_has_contexts(fb->fd)
(kms_flip:5353) intel_allocator_reloc-DEBUG: Using reloc allocator
(kms_flip:5353) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:5353) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:5353) igt_fb-DEBUG: Test requirement passed: gem_has_contexts(fb->fd)
(kms_flip:5353) intel_allocator_reloc-DEBUG: Using reloc allocator
(kms_flip:5353) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:5353) intel_blt-DEBUG: Test requirement passed: cmds_info
(kms_flip:5353) igt_kms-INFO: 3840x2160: 60 533250 3840 3888 3920 4000 2160 2163 2168 2222 0x48 0x9
(kms_flip:5353) DEBUG: No stale events found
(kms_flip:5353) i915/intel_drrs-DEBUG: Manually disabling DRRS. 0
(kms_flip:5353) i915/intel_drrs-DEBUG: Test requirement passed: dir >= 0
(kms_flip:5353) DEBUG: name = flip
last_ts = 0.000000
last_received_ts = 0.000000
last_seq = 0
current_ts = 126.206123
current_received_ts = 126.284668
current_seq = 6
count = 0
seq_step = 1
(kms_flip:5353) DEBUG: name = flip
last_ts = 126.206123
last_received_ts = 126.284668
last_seq = 6
current_ts = 126.387779
current_received_ts = 126.461662
current_seq = 13
count = 1
seq_step = 1
(kms_flip:5353) igt_kms-CRITICAL: Test assertion failure function kmstest_set_connector_dpms, file ../../../usr/src/igt-gpu-tools/lib/igt_kms.c:2212:
(kms_flip:5353) igt_kms-CRITICAL: Failed assertion: drmModeConnectorSetProperty(fd, connector->connector_id, dpms, mode) == 0
(kms_flip:5353) igt_kms-CRITICAL: Last errno: 22, Invalid argument
(kms_flip:5353) igt_core-INFO: Stack trace:
(kms_flip:5353) igt_core-INFO: #0 ../../../usr/src/igt-gpu-tools/lib/igt_core.c:2051 __igt_fail_assert()
(kms_flip:5353) igt_core-INFO: #1 [kmstest_set_connector_dpms+0x12b]
(kms_flip:5353) igt_core-INFO: #2 ../../../usr/src/igt-gpu-tools/tests/kms_flip.c:484 run_test_on_crtc_set()
(kms_flip:5353) igt_core-INFO: #3 ../../../usr/src/igt-gpu-tools/tests/kms_flip.c:1845 run_test()
(kms_flip:5353) igt_core-INFO: #4 ../../../usr/src/igt-gpu-tools/tests/kms_flip.c:2078 __igt_unique____real_main2001()
(kms_flip:5353) igt_core-INFO: #5 ../../../usr/src/igt-gpu-tools/tests/kms_flip.c:2001 main()
(kms_flip:5353) igt_core-INFO: #6 [__libc_start_main+0xf3]
(kms_flip:5353) igt_core-INFO: #7 [_start+0x2e]
**** END ****
Dynamic subtest B-DP3: FAIL (0.633s)
Dmesg
<6> [126.239270] [IGT] kms_flip: starting dynamic subtest B-DP3
<7> [126.240825] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:284]
<7> [126.240853] i915 0000:00:02.0: [drm:drm_mode_addfb2] [FB:285]
<7> [126.244619] [drm:eb_lookup_vmas [i915]] EINVAL at eb_validate_vma:509
<7> [126.244814] [drm:eb_lookup_vmas [i915]] EINVAL at eb_validate_vma:509
<7> [126.256152] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [126.256519] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [126.256829] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [126.264446] [drm:eb_lookup_vmas [i915]] EINVAL at eb_validate_vma:509
<7> [126.264610] [drm:eb_lookup_vmas [i915]] EINVAL at eb_validate_vma:509
<7> [126.278282] [drm:eb_lookup_vmas [i915]] EINVAL at eb_validate_vma:509
<7> [126.278461] [drm:eb_lookup_vmas [i915]] EINVAL at eb_validate_vma:509
<7> [126.298221] [drm:eb_lookup_vmas [i915]] EINVAL at eb_validate_vma:509
<7> [126.298396] [drm:eb_lookup_vmas [i915]] EINVAL at eb_validate_vma:509
<7> [126.300058] i915 0000:00:02.0: [drm:intel_tc_port_update_mode [i915]] Port G/TC#4: TC port mode reset (legacy -> disconnected)
<7> [126.325505] i915 0000:00:02.0: [drm:drm_mode_setcrtc] [CRTC:82:pipe A]
<7> [126.325586] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.enable (expected yes, found no)
<7> [126.325692] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in cpu_transcoder (expected 0, found -1)
<7> [126.325784] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in lane_count (expected 4, found 0)
<7> [126.325868] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in dp_m_n (expected tu 64 data 7766017/8388608 link 517734/524288, found tu 0, data 0/0 link 0/0)
<7> [126.325950] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in output_types (expected 0x00000080, found 0x00000000)
<7> [126.326043] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in framestart_delay (expected 1, found 0)
<7> [126.326119] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hdisplay (expected 3840, found 0)
<7> [126.326195] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_htotal (expected 4000, found 0)
<7> [126.326268] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_start (expected 3840, found 0)
<7> [126.326340] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hblank_end (expected 4000, found 0)
<7> [126.326411] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_start (expected 3888, found 0)
<7> [126.326482] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_hsync_end (expected 3920, found 0)
<7> [126.326552] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vdisplay (expected 2160, found 0)
<7> [126.326620] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_start (expected 2160, found 0)
<7> [126.326688] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_start (expected 2163, found 0)
<7> [126.326756] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vsync_end (expected 2168, found 0)
<7> [126.326830] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vtotal (expected 2222, found 0)
<7> [126.326906] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.pipe_mode.crtc_vblank_end (expected 2222, found 0)
<7> [126.326981] i915 0000:00:02.0: [drm:intel_pipe_config_compare [i915]] [CRTC:82:pipe A] fastset requirement not met in hw.adjusted_mode.crtc_hdisplay (expected 3840, found 0)