Created attachment 137395 [details] dmesg This test has failed on IVB QA Test List igt@gem_exec_suspend@basic-s3 Software: IGT-Version: 1.21-g2b64cac (x86_64) (Linux: 4.16.0-rc1-drm-intel-qa-ww7-commit-8a1ed24+ x86_64) ====================================== output sample ====================================== . . . **** DEBUG **** (gem_exec_suspend:3011) DEBUG: Test requirement passed: nengine (gem_exec_suspend:3011) DEBUG: Test requirement passed: gem_has_ring(fd, engine) (gem_exec_suspend:3011) DEBUG: Test requirement passed: gem_can_store_dword(fd, engine) (gem_exec_suspend:3011) DEBUG: Test requirement passed: nengine (gem_exec_suspend:3011) igt-debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0' (gem_exec_suspend:3011) ioctl-wrappers-DEBUG: Test requirement passed: __gem_set_caching(fd, handle, caching) == 0 (gem_exec_suspend:3011) DEBUG: Test requirement passed: __gem_execbuf(fd, &execbuf) == 0 (gem_exec_suspend:3011) DEBUG: Verifying result (gem_exec_suspend:3011) igt-debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0' (gem_exec_suspend:3011) DEBUG: Test requirement passed: gem_has_ring(fd, engine) (gem_exec_suspend:3011) DEBUG: Test requirement passed: gem_can_store_dword(fd, engine) (gem_exec_suspend:3011) DEBUG: Test requirement passed: nengine (gem_exec_suspend:3011) igt-debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0' (gem_exec_suspend:3011) ioctl-wrappers-DEBUG: Test requirement passed: __gem_set_caching(fd, handle, caching) == 0 (gem_exec_suspend:3011) DEBUG: Test requirement passed: __gem_execbuf(fd, &execbuf) == 0 (gem_exec_suspend:3011) DEBUG: Verifying result (gem_exec_suspend:3011) igt-debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0' (gem_exec_suspend:3011) DEBUG: Test requirement passed: gem_has_ring(fd, engine) (gem_exec_suspend:3011) DEBUG: Test requirement passed: gem_can_store_dword(fd, engine) (gem_exec_suspend:3011) DEBUG: Test requirement passed: nengine (gem_exec_suspend:3011) igt-debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0' (gem_exec_suspend:3011) ioctl-wrappers-DEBUG: Test requirement passed: __gem_set_caching(fd, handle, caching) == 0 (gem_exec_suspend:3011) DEBUG: Test requirement passed: __gem_execbuf(fd, &execbuf) == 0 (gem_exec_suspend:3011) DEBUG: Verifying result (gem_exec_suspend:3011) igt-debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0' (gem_exec_suspend:3011) igt-debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0' (gem_exec_suspend:3011) ioctl-wrappers-DEBUG: Test requirement passed: __gem_set_caching(fd, handle, caching) == 0 (gem_exec_suspend:3011) DEBUG: Test requirement passed: __gem_execbuf(fd, &execbuf) == 0 (gem_exec_suspend:3011) igt-core-DEBUG: Test requirement passed: !igt_run_in_simulation() (gem_exec_suspend:3011) igt-aux-DEBUG: Test requirement passed: (power_dir = open("/sys/power", O_RDONLY)) >= 0 (gem_exec_suspend:3011) igt-aux-DEBUG: Test requirement passed: get_supported_suspend_states(power_dir) & (1 << state) (gem_exec_suspend:3011) igt-aux-DEBUG: Test requirement passed: test == SUSPEND_TEST_NONE || faccessat(power_dir, "pm_test", R_OK | W_OK, 0) == 0 (gem_exec_suspend:3011) igt-aux-DEBUG: Test requirement passed: ret == 0 (gem_exec_suspend:3011) igt-core-INFO: [cmd] rtcwake: wakeup from "mem" using /dev/rtc0 at Mon Jan 22 06:10:56 2018 (gem_exec_suspend:3011) igt-core-WARNING: [cmd] rtcwake: write error (gem_exec_suspend:3011) igt-aux-WARNING: rtcwake failed with 1 Check dmesg for further details. (gem_exec_suspend:3011) igt-aux-DEBUG: suspend_stats: success: 0 fail: 1 failed_freeze: 0 failed_prepare: 0 failed_suspend: 1 failed_suspend_late: 0 failed_suspend_noirq: 0 failed_resume: 0 failed_resume_early: 0 failed_resume_noirq: 0 failures: last_failed_dev: 0000:00:1d.0 last_failed_errno: -16 0 last_failed_step: suspend (gem_exec_suspend:3011) igt-aux-CRITICAL: Test assertion failure function suspend_via_rtcwake, file igt_aux.c:821: (gem_exec_suspend:3011) igt-aux-CRITICAL: Failed assertion: ret == 0 (gem_exec_suspend:3011) igt-aux-CRITICAL: error: 1 != 0 (gem_exec_suspend:3011) igt-core-INFO: Stack trace: (gem_exec_suspend:3011) igt-core-INFO: #0 [__igt_fail_assert+0x101] (gem_exec_suspend:3011) igt-core-INFO: #1 [igt_system_suspend_autoresume+0x52b] (gem_exec_suspend:3011) igt-core-INFO: #2 [<unknown>+0x52b] **** END **** . . . ====================================== Graphic stack ====================================== Component: drm tag: libdrm-2.4.89-67-ge75e0ea commit: e75e0ea2e3e29aa65dff868b1088bd41d9405781 Component: intel-gpu-tools tag: intel-gpu-tools-1.21-99-g2b64cac commit: 2b64cac7d858d0c63b87e7a889a21a36bfcc4138 Component: piglit tag: piglit-v1 commit: 4210d072f1a40fe06c6ca46e985871a384cca514
From dmesg: [ 133.764735] PM: suspend entry (deep) [ 133.764740] PM: Syncing filesystems ... done. [ 133.766519] Freezing user space processes ... (elapsed 0.001 seconds) done. [ 133.767967] OOM killer disabled. [ 133.767968] Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done. [ 133.769298] Suspending console(s) (use no_console_suspend to debug) [ 133.798151] sd 0:0:0:0: [sda] Synchronizing SCSI cache [ 133.798326] sd 0:0:0:0: [sda] Stopping disk [ 133.856853] pci_pm_suspend(): hcd_pci_suspend+0x0/0x30 returns -16 [ 133.856863] dpm_run_callback(): pci_pm_suspend+0x0/0x150 returns -16 [ 133.856873] PM: Device 0000:00:1d.0 failed to suspend async: error -16 [ 133.957621] hp_wmi: Unknown event_id - 14 - 0x0 [ 134.341326] PM: Some devices failed to suspend, or early wake event detected [ 134.342980] sd 0:0:0:0: [sda] Starting disk [ 134.343612] [drm:i915_audio_component_get_eld [i915]] Not valid for port B [ 134.343710] [drm:i915_audio_component_get_eld [i915]] Not valid for port D [ 134.356570] iwlwifi 0000:03:00.0: Radio type=0x2-0x1-0x0 [ 134.627396] hp_wmi: Unknown event_id - 14 - 0x1 [ 134.662615] iwlwifi 0000:03:00.0: Radio type=0x2-0x1-0x0 [ 134.763218] acpi LNXPOWER:02: Turning OFF [ 134.763411] acpi LNXPOWER:01: Turning OFF [ 134.763469] OOM killer enabled. [ 134.763469] Restarting tasks ... done. [ 134.795588] PM: suspend exit
Test outputs: igt@gem_exec_suspend@basic-s3: Out IGT-Version: 1.21-gdd61508 (x86_64) (Linux: 4.16.0-rc1-drm-intel-qa-ww8-commit-67f1480+ x86_64) [cmd] rtcwake: wakeup from "mem" using /dev/rtc0 at Thu Jan 25 06:10:24 2018 Stack trace: #0 [__igt_fail_assert+0x101] #1 [igt_system_suspend_autoresume+0x52b] #2 [<unknown>+0x52b] Subtest basic-S3: FAIL (1.372s) Err (gem_exec_suspend:12804) igt-core-WARNING: [cmd] rtcwake: write error (gem_exec_suspend:12804) igt-aux-WARNING: rtcwake failed with 1 Check dmesg for further details. (gem_exec_suspend:12804) igt-aux-CRITICAL: Test assertion failure function suspend_via_rtcwake, file igt_aux.c:837: (gem_exec_suspend:12804) igt-aux-CRITICAL: Failed assertion: ret == 0 (gem_exec_suspend:12804) igt-aux-CRITICAL: error: 1 != 0 Subtest basic-S3 failed. **** DEBUG **** (gem_exec_suspend:12804) DEBUG: Test requirement passed: nengine (gem_exec_suspend:12804) DEBUG: Test requirement passed: gem_has_ring(fd, engine) (gem_exec_suspend:12804) DEBUG: Test requirement passed: gem_can_store_dword(fd, engine) (gem_exec_suspend:12804) DEBUG: Test requirement passed: nengine (gem_exec_suspend:12804) igt-debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0' (gem_exec_suspend:12804) ioctl-wrappers-DEBUG: Test requirement passed: __gem_set_caching(fd, handle, caching) == 0 (gem_exec_suspend:12804) DEBUG: Test requirement passed: __gem_execbuf(fd, &execbuf) == 0 (gem_exec_suspend:12804) DEBUG: Verifying result (gem_exec_suspend:12804) igt-debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0' (gem_exec_suspend:12804) DEBUG: Test requirement passed: gem_has_ring(fd, engine) (gem_exec_suspend:12804) DEBUG: Test requirement passed: gem_can_store_dword(fd, engine) (gem_exec_suspend:12804) DEBUG: Test requirement passed: nengine (gem_exec_suspend:12804) igt-debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0' (gem_exec_suspend:12804) ioctl-wrappers-DEBUG: Test requirement passed: __gem_set_caching(fd, handle, caching) == 0 (gem_exec_suspend:12804) DEBUG: Test requirement passed: __gem_execbuf(fd, &execbuf) == 0 (gem_exec_suspend:12804) DEBUG: Verifying result (gem_exec_suspend:12804) igt-debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0' (gem_exec_suspend:12804) DEBUG: Test requirement passed: gem_has_ring(fd, engine) (gem_exec_suspend:12804) DEBUG: Test requirement passed: gem_can_store_dword(fd, engine) (gem_exec_suspend:12804) DEBUG: Test requirement passed: nengine (gem_exec_suspend:12804) igt-debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0' (gem_exec_suspend:12804) ioctl-wrappers-DEBUG: Test requirement passed: __gem_set_caching(fd, handle, caching) == 0 (gem_exec_suspend:12804) DEBUG: Test requirement passed: __gem_execbuf(fd, &execbuf) == 0 (gem_exec_suspend:12804) DEBUG: Verifying result (gem_exec_suspend:12804) igt-debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0' (gem_exec_suspend:12804) igt-debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0' (gem_exec_suspend:12804) ioctl-wrappers-DEBUG: Test requirement passed: __gem_set_caching(fd, handle, caching) == 0 (gem_exec_suspend:12804) DEBUG: Test requirement passed: __gem_execbuf(fd, &execbuf) == 0 (gem_exec_suspend:12804) igt-core-DEBUG: Test requirement passed: !igt_run_in_simulation() (gem_exec_suspend:12804) igt-aux-DEBUG: Test requirement passed: (power_dir = open("/sys/power", O_RDONLY)) >= 0 (gem_exec_suspend:12804) igt-aux-DEBUG: Test requirement passed: get_supported_suspend_states(power_dir) & (1 << state) (gem_exec_suspend:12804) igt-aux-DEBUG: Test requirement passed: test == SUSPEND_TEST_NONE || faccessat(power_dir, "pm_test", R_OK | W_OK, 0) == 0 (gem_exec_suspend:12804) igt-aux-DEBUG: Test requirement passed: ret == 0 (gem_exec_suspend:12804) igt-core-INFO: [cmd] rtcwake: wakeup from "mem" using /dev/rtc0 at Thu Jan 25 06:10:24 2018 (gem_exec_suspend:12804) igt-core-WARNING: [cmd] rtcwake: write error (gem_exec_suspend:12804) igt-aux-WARNING: rtcwake failed with 1 Check dmesg for further details. (gem_exec_suspend:12804) igt-aux-DEBUG: suspend_stats: success: 0 fail: 1 failed_freeze: 0 failed_prepare: 0 failed_suspend: 1 failed_suspend_late: 0 failed_suspend_noirq: 0 failed_resume: 0 failed_resume_early: 0 failed_resume_noirq: 0 failures: last_failed_dev: 0000:00:1d.0 last_failed_errno: -16 0 last_failed_step: suspend (gem_exec_suspend:12804) igt-aux-CRITICAL: Test assertion failure function suspend_via_rtcwake, file igt_aux.c:837: (gem_exec_suspend:12804) igt-aux-CRITICAL: Failed assertion: ret == 0 (gem_exec_suspend:12804) igt-aux-CRITICAL: error: 1 != 0 (gem_exec_suspend:12804) igt-core-INFO: Stack trace: (gem_exec_suspend:12804) igt-core-INFO: #0 [__igt_fail_assert+0x101] (gem_exec_suspend:12804) igt-core-INFO: #1 [igt_system_suspend_autoresume+0x52b] (gem_exec_suspend:12804) igt-core-INFO: #2 [<unknown>+0x52b] **** END **** igt@kms_pipe_crc_basic@suspend-read-crc-pipe-a: Out IGT-Version: 1.21-gdd61508 (x86_64) (Linux: 4.16.0-rc1-drm-intel-qa-ww8-commit-67f1480+ x86_64) suspend-read-crc-pipe-A: Testing connector LVDS-1 using pipe A suspend-read-crc-pipe-A: Testing connector VGA-1 using pipe A suspend-read-crc-pipe-A: Testing connector DP-3 using pipe A [cmd] rtcwake: wakeup from "mem" using /dev/rtc0 at Thu Jan 25 06:14:02 2018 Stack trace: #0 [__igt_fail_assert+0x101] #1 [igt_system_suspend_autoresume+0x52b] #2 [<unknown>+0x52b] #3 [<unknown>+0x52b] Subtest suspend-read-crc-pipe-A: FAIL (2.038s) Err (kms_pipe_crc_basic:26906) igt-core-WARNING: [cmd] rtcwake: write error (kms_pipe_crc_basic:26906) igt-aux-WARNING: rtcwake failed with 1 Check dmesg for further details. (kms_pipe_crc_basic:26906) igt-aux-CRITICAL: Test assertion failure function suspend_via_rtcwake, file igt_aux.c:837: (kms_pipe_crc_basic:26906) igt-aux-CRITICAL: Failed assertion: ret == 0 (kms_pipe_crc_basic:26906) igt-aux-CRITICAL: error: 1 != 0 Subtest suspend-read-crc-pipe-A failed. **** DEBUG **** SetProp plane B.1 "rotation" to 0x1/1 (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: Fixing up initial rotation pipe B, plane 2 (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: SetCursor pipe B, disabling (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: MoveCursor pipe B, (0, 0) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: Fixing up initial rotation pipe C, plane 0 (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: SetCrtc pipe C, disabling (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: Fixing up initial rotation pipe C, plane 1 (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: SetPlane pipe C, plane 1, disabling (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: SetProp plane C.1 "rotation" to 0x1/1 (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: Fixing up initial rotation pipe C, plane 2 (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: SetCursor pipe C, disabling (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: MoveCursor pipe C, (0, 0) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: } (kms_pipe_crc_basic:26906) igt-debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0' (kms_pipe_crc_basic:26906) DEBUG: CRC for this fb: 0054a8e3 0013bc54 0054a8e3 0042da39 0054a8e3 (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: plane_set_fb(0) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: plane_set_size (0x0) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: fb_set_position(0,0) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: fb_set_size(0x0) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: LVDS-1: set_pipe(None) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: LVDS-1: Selecting pipe None (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: LVDS-1: set_pipe(A) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: LVDS-1: Selecting pipe A (kms_pipe_crc_basic:26906) DEBUG: Clearing the fb with color (0.00,1.00,1.00) (kms_pipe_crc_basic:26906) igt-fb-DEBUG: igt_create_fb_with_bo_size(width=1366, height=768, format=0x34325258, tiling=0x0, size=0) (kms_pipe_crc_basic:26906) igt-fb-DEBUG: igt_create_fb_with_bo_size(handle=1, pitch=5504) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: Test requirement passed: plane_idx >= 0 && plane_idx < pipe->n_planes (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: plane_set_fb(82) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: plane_set_size (1366x768) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: fb_set_position(0,0) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: fb_set_size(1366x768) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: commit { (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: LVDS-1: SetCrtc pipe A, fb 82, src (0, 0), mode 1366x768 (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: } (kms_pipe_crc_basic:26906) igt-debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0' (kms_pipe_crc_basic:26906) DEBUG: CRC for this fb: 0054a8e3 0013bc54 0013bc54 0042da39 0042da39 (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: plane_set_fb(0) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: plane_set_size (0x0) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: fb_set_position(0,0) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: fb_set_size(0x0) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: LVDS-1: set_pipe(None) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: LVDS-1: Selecting pipe None (kms_pipe_crc_basic:26906) INFO: suspend-read-crc-pipe-A: Testing connector VGA-1 using pipe A (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: VGA-1: set_pipe(A) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: VGA-1: Selecting pipe A (kms_pipe_crc_basic:26906) DEBUG: Clearing the fb with color (0.00,1.00,0.00) (kms_pipe_crc_basic:26906) igt-fb-DEBUG: igt_create_fb_with_bo_size(width=1024, height=768, format=0x34325258, tiling=0x0, size=0) (kms_pipe_crc_basic:26906) igt-fb-DEBUG: igt_create_fb_with_bo_size(handle=1, pitch=4096) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: Test requirement passed: plane_idx >= 0 && plane_idx < pipe->n_planes (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: plane_set_fb(82) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: plane_set_size (1024x768) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: fb_set_position(0,0) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: fb_set_size(1024x768) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: commit { (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: VGA-1: SetCrtc pipe A, fb 82, src (0, 0), mode 1024x768 (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: } (kms_pipe_crc_basic:26906) igt-debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0' (kms_pipe_crc_basic:26906) DEBUG: CRC for this fb: 000feff0 000c17f7 000feff0 006a4c4c 000feff0 (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: plane_set_fb(0) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: plane_set_size (0x0) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: fb_set_position(0,0) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: fb_set_size(0x0) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: VGA-1: set_pipe(None) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: VGA-1: Selecting pipe None (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: VGA-1: set_pipe(A) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: VGA-1: Selecting pipe A (kms_pipe_crc_basic:26906) DEBUG: Clearing the fb with color (0.00,1.00,1.00) (kms_pipe_crc_basic:26906) igt-fb-DEBUG: igt_create_fb_with_bo_size(width=1024, height=768, format=0x34325258, tiling=0x0, size=0) (kms_pipe_crc_basic:26906) igt-fb-DEBUG: igt_create_fb_with_bo_size(handle=1, pitch=4096) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: Test requirement passed: plane_idx >= 0 && plane_idx < pipe->n_planes (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: plane_set_fb(82) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: plane_set_size (1024x768) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: fb_set_position(0,0) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: fb_set_size(1024x768) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: commit { (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: VGA-1: SetCrtc pipe A, fb 82, src (0, 0), mode 1024x768 (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: } (kms_pipe_crc_basic:26906) igt-debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0' (kms_pipe_crc_basic:26906) DEBUG: CRC for this fb: 000feff0 000c17f7 000c17f7 006a4c4c 006a4c4c (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: plane_set_fb(0) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: plane_set_size (0x0) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: fb_set_position(0,0) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: fb_set_size(0x0) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: VGA-1: set_pipe(None) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: VGA-1: Selecting pipe None (kms_pipe_crc_basic:26906) INFO: suspend-read-crc-pipe-A: Testing connector DP-3 using pipe A (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: DP-3: set_pipe(A) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: DP-3: Selecting pipe A (kms_pipe_crc_basic:26906) DEBUG: Clearing the fb with color (0.00,1.00,0.00) (kms_pipe_crc_basic:26906) igt-fb-DEBUG: igt_create_fb_with_bo_size(width=1920, height=1080, format=0x34325258, tiling=0x0, size=0) (kms_pipe_crc_basic:26906) igt-fb-DEBUG: igt_create_fb_with_bo_size(handle=1, pitch=7680) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: Test requirement passed: plane_idx >= 0 && plane_idx < pipe->n_planes (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: plane_set_fb(82) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: plane_set_size (1920x1080) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: fb_set_position(0,0) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: fb_set_size(1920x1080) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: commit { (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: DP-3: SetCrtc pipe A, fb 82, src (0, 0), mode 1920x1080 (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: } (kms_pipe_crc_basic:26906) igt-debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0' (kms_pipe_crc_basic:26906) DEBUG: CRC for this fb: 006189b7 007386c4 006189b7 001c5a5a 006189b7 (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: plane_set_fb(0) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: plane_set_size (0x0) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: fb_set_position(0,0) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: fb_set_size(0x0) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: DP-3: set_pipe(None) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: DP-3: Selecting pipe None (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: DP-3: set_pipe(A) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: DP-3: Selecting pipe A (kms_pipe_crc_basic:26906) DEBUG: Clearing the fb with color (0.00,1.00,1.00) (kms_pipe_crc_basic:26906) igt-fb-DEBUG: igt_create_fb_with_bo_size(width=1920, height=1080, format=0x34325258, tiling=0x0, size=0) (kms_pipe_crc_basic:26906) igt-fb-DEBUG: igt_create_fb_with_bo_size(handle=1, pitch=7680) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: Test requirement passed: plane_idx >= 0 && plane_idx < pipe->n_planes (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: plane_set_fb(82) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: plane_set_size (1920x1080) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: fb_set_position(0,0) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: fb_set_size(1920x1080) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: commit { (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: DP-3: SetCrtc pipe A, fb 82, src (0, 0), mode 1920x1080 (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: } (kms_pipe_crc_basic:26906) igt-debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0' (kms_pipe_crc_basic:26906) DEBUG: CRC for this fb: 006189b7 007386c4 007386c4 001c5a5a 001c5a5a (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: plane_set_fb(0) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: plane_set_size (0x0) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: fb_set_position(0,0) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: A.0: fb_set_size(0x0) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: DP-3: set_pipe(None) (kms_pipe_crc_basic:26906) igt-kms-DEBUG: display: DP-3: Selecting pipe None (kms_pipe_crc_basic:26906) DEBUG: Test requirement passed: valid_connectors (kms_pipe_crc_basic:26906) igt-core-DEBUG: Test requirement passed: !igt_run_in_simulation() (kms_pipe_crc_basic:26906) igt-aux-DEBUG: Test requirement passed: (power_dir = open("/sys/power", O_RDONLY)) >= 0 (kms_pipe_crc_basic:26906) igt-aux-DEBUG: Test requirement passed: get_supported_suspend_states(power_dir) & (1 << state) (kms_pipe_crc_basic:26906) igt-aux-DEBUG: Test requirement passed: test == SUSPEND_TEST_NONE || faccessat(power_dir, "pm_test", R_OK | W_OK, 0) == 0 (kms_pipe_crc_basic:26906) igt-aux-DEBUG: Test requirement passed: ret == 0 (kms_pipe_crc_basic:26906) igt-core-INFO: [cmd] rtcwake: wakeup from "mem" using /dev/rtc0 at Thu Jan 25 06:14:02 2018 (kms_pipe_crc_basic:26906) igt-core-WARNING: [cmd] rtcwake: write error (kms_pipe_crc_basic:26906) igt-aux-WARNING: rtcwake failed with 1 Check dmesg for further details. (kms_pipe_crc_basic:26906) igt-aux-DEBUG: suspend_stats: success: 0 fail: 2 failed_freeze: 0 failed_prepare: 0 failed_suspend: 2 failed_suspend_late: 0 failed_suspend_noirq: 0 failed_resume: 0 failed_resume_early: 0 failed_resume_noirq: 0 failures: last_failed_dev: 0000:00:1d.0 0000:00:1d.0 last_failed_errno: -16 -16 last_failed_step: suspend suspend (kms_pipe_crc_basic:26906) igt-aux-CRITICAL: Test assertion failure function suspend_via_rtcwake, file igt_aux.c:837: (kms_pipe_crc_basic:26906) igt-aux-CRITICAL: Failed assertion: ret == 0 (kms_pipe_crc_basic:26906) igt-aux-CRITICAL: error: 1 != 0 (kms_pipe_crc_basic:26906) igt-core-INFO: Stack trace: (kms_pipe_crc_basic:26906) igt-core-INFO: #0 [__igt_fail_assert+0x101] (kms_pipe_crc_basic:26906) igt-core-INFO: #1 [igt_system_suspend_autoresume+0x52b] (kms_pipe_crc_basic:26906) igt-core-INFO: #2 [<unknown>+0x52b] (kms_pipe_crc_basic:26906) igt-core-INFO: #3 [<unknown>+0x52b] **** END ****
Elizabeth, could you open an upstream USB bug with a comment based on the following and attach the dmesg? Thanks. (In reply to Elizabeth from comment #2) > Test outputs: > > igt@gem_exec_suspend@basic-s3: > [...] > Subtest basic-S3: FAIL (1.372s) > [...] > (gem_exec_suspend:12804) igt-core-INFO: [cmd] rtcwake: wakeup from "mem" > using /dev/rtc0 at Thu Jan 25 06:10:24 2018 > (gem_exec_suspend:12804) igt-core-WARNING: [cmd] rtcwake: write error > (gem_exec_suspend:12804) igt-aux-WARNING: rtcwake failed with 1 > Check dmesg for further details. > (gem_exec_suspend:12804) igt-aux-DEBUG: suspend_stats: > success: 0 > fail: 1 > failed_freeze: 0 > failed_prepare: 0 > failed_suspend: 1 > failed_suspend_late: 0 > failed_suspend_noirq: 0 > failed_resume: 0 > failed_resume_early: 0 > failed_resume_noirq: 0 > failures: > last_failed_dev: 0000:00:1d.0 > > last_failed_errno: -16 > 0 > last_failed_step: suspend based on the above: $ lspci -s 0000:00:1d.0 00:1d.0 USB controller from dmesg: [ 133.856853] pci_pm_suspend(): hcd_pci_suspend+0x0/0x30 returns -16 [ 133.856863] dpm_run_callback(): pci_pm_suspend+0x0/0x150 returns -16 [ 133.856873] PM: Device 0000:00:1d.0 failed to suspend async: error -16 [ 133.957621] hp_wmi: Unknown event_id - 14 - 0x0 [ 134.341326] PM: Some devices failed to suspend, or early wake event detected
Bug opened as requested: https://bugzilla.kernel.org/show_bug.cgi?id=198893 Thanks for your help.
Still present with commit-562dc33+: igt@kms_pipe_crc_basic@suspend-read-crc-pipe-a igt@gem_exec_suspend@basic-s3 Stdout IGT-Version: 1.21-g1fb30f1 (x86_64) (Linux: 4.16.0-rc2-drm-intel-qa-ww8-commit-562dc33+ x86_64) suspend-read-crc-pipe-A: Testing connector LVDS-1 using pipe A suspend-read-crc-pipe-A: Testing connector VGA-1 using pipe A suspend-read-crc-pipe-A: Testing connector DP-3 using pipe A [cmd] rtcwake: wakeup from "mem" using /dev/rtc0 at Sat Jan 27 06:12:20 2018 Stack trace: #0 [__igt_fail_assert+0x101] #1 [igt_system_suspend_autoresume+0x52b] #2 [<unknown>+0x52b] #3 [<unknown>+0x52b] Subtest suspend-read-crc-pipe-A: FAIL (2.070s) Stdout IGT-Version: 1.21-g1fb30f1 (x86_64) (Linux: 4.16.0-rc2-drm-intel-qa-ww8-commit-562dc33+ x86_64) [cmd] rtcwake: wakeup from "mem" using /dev/rtc0 at Sat Jan 27 06:08:46 2018 Stack trace: #0 [__igt_fail_assert+0x101] #1 [igt_system_suspend_autoresume+0x52b] #2 [<unknown>+0x52b] Subtest basic-S3: FAIL (1.425s)
With today's commit-01a067a+ the tests still have the same failure, igt@kms_pipe_crc_basic@suspend-read-crc-pipe-a igt@gem_exec_suspend@basic-s3
Same results with commit-9a02ae1: igt@kms_pipe_crc_basic@suspend-read-crc-pipe-a igt@gem_exec_suspend@basic-s3 (gem_exec_suspend:13174) igt-aux-CRITICAL: Test assertion failure function suspend_via_rtcwake, file igt_aux.c:825: (gem_exec_suspend:13174) igt-aux-CRITICAL: Failed assertion: ret == 0 (gem_exec_suspend:13174) igt-aux-CRITICAL: error: 1 != 0
Keeping track. Still failing: igt@kms_pipe_crc_basic@suspend-read-crc-pipe-a, commit-b2e10fd igt@gem_exec_suspend@basic-s3, commit-b2e10fd
Same status, both test are still failing. IGT-Version: 1.21-ge3a0ed9 (x86_64) (Linux: 4.16.0-rc4-drm-intel-qa-ww10-commit-8a4eb45+ x86_64) [cmd] rtcwake: wakeup from "mem" using /dev/rtc0 at Sat Feb 3 06:08:52 2018 Stack trace: #0 [__igt_fail_assert+0x101] #1 [igt_system_suspend_autoresume+0x52b] #2 [<unknown>+0x52b] Subtest basic-S3: FAIL (1.372s) IGT-Version: 1.21-ge3a0ed9 (x86_64) (Linux: 4.16.0-rc4-drm-intel-qa-ww10-commit-8a4eb45+ x86_64) suspend-read-crc-pipe-A: Testing connector LVDS-1 using pipe A suspend-read-crc-pipe-A: Testing connector VGA-1 using pipe A suspend-read-crc-pipe-A: Testing connector DP-3 using pipe A [cmd] rtcwake: wakeup from "mem" using /dev/rtc0 at Sat Feb 3 06:12:37 2018 Stack trace: #0 [__igt_fail_assert+0x101] #1 [igt_system_suspend_autoresume+0x52b] #2 [<unknown>+0x52b] #3 [<unknown>+0x52b] Subtest suspend-read-crc-pipe-A: FAIL (2.051s)
Same failure on both tests with IGT-Version 1.22-g5d71d77 and kernel 4.16.0-rc4-commit-73f9dfa. (gem_exec_suspend:12917) igt-aux-CRITICAL: Test assertion failure function suspend_via_rtcwake, file igt_aux.c:825: (gem_exec_suspend:12917) igt-aux-CRITICAL: Failed assertion: ret == 0 (gem_exec_suspend:12917) igt-aux-CRITICAL: error: 1 != 0
Same failed results with IGT-Version: 1.22-gb09e979 (x86_64) (Linux: 4.16.0-rc6-drm-intel-qa-ww12-commit-141def2+ x86_64) on both tests.
On today's FF, igt@kms_pipe_crc_basic@suspend-read-crc-pipe-c failed and although igt@gem_exec_suspend@basic-s3 and igt@kms_pipe_crc_basic@suspend-read-crc-pipe-a are SUCCESS, the test writes failed_suspend: 3. Results for igt@gem_exec_suspend@basic-s3 Result: pass Out IGT-Version: 1.22-ga9741da (x86_64) (Linux: 4.16.0-rc6-drm-intel-qa-ww13-commit-94f5d91+ x86_64) [cmd] rtcwake: assuming RTC uses UTC ... rtcwake: wakeup from "mem" using /dev/rtc0 at Sun Feb 18 02:26:21 2018 Subtest basic-S3: SUCCESS (2.927s) Results for igt@kms_pipe_crc_basic@suspend-read-crc-pipe-a Result: pass Out IGT-Version: 1.22-ga9741da (x86_64) (Linux: 4.16.0-rc6-drm-intel-qa-ww13-commit-94f5d91+ x86_64) suspend-read-crc-pipe-A: Testing connector LVDS-1 using pipe A suspend-read-crc-pipe-A: Testing connector VGA-1 using pipe A suspend-read-crc-pipe-A: Testing connector DP-3 using pipe A [cmd] rtcwake: assuming RTC uses UTC ... rtcwake: wakeup from "mem" using /dev/rtc0 at Sun Feb 18 02:26:30 2018 suspend-read-crc-pipe-A: Testing connector LVDS-1 using pipe A suspend-read-crc-pipe-A: Testing connector VGA-1 using pipe A suspend-read-crc-pipe-A: Testing connector DP-3 using pipe A Subtest suspend-read-crc-pipe-A: SUCCESS (5.362s) Results for igt@kms_pipe_crc_basic@suspend-read-crc-pipe-c Result: fail Out IGT-Version: 1.22-ga9741da (x86_64) (Linux: 4.16.0-rc6-drm-intel-qa-ww13-commit-94f5d91+ x86_64) suspend-read-crc-pipe-C: Testing connector LVDS-1 using pipe C suspend-read-crc-pipe-C: Testing connector VGA-1 using pipe C suspend-read-crc-pipe-C: Testing connector DP-3 using pipe C [cmd] rtcwake: assuming RTC uses UTC ... rtcwake: wakeup from "mem" using /dev/rtc0 at Sun Feb 18 02:24:24 2018 Stack trace: #0 [__igt_fail_assert+0x101] #1 [igt_system_suspend_autoresume+0x52b] #2 [<unknown>+0x52b] #3 [<unknown>+0x52b] Subtest suspend-read-crc-pipe-C: FAIL (2.791s) (kms_pipe_crc_basic:27865) igt-core-INFO: [cmd] rtcwake: assuming RTC uses UTC ... rtcwake: wakeup from "mem" using /dev/rtc0 at Sun Feb 18 02:24:24 2018 (kms_pipe_crc_basic:27865) igt-core-WARNING: [cmd] rtcwake: write error (kms_pipe_crc_basic:27865) igt-aux-WARNING: rtcwake failed with 1 Check dmesg for further details. (kms_pipe_crc_basic:27865) igt-aux-DEBUG: suspend_stats: success: 1 fail: 3 failed_freeze: 0 failed_prepare: 0 failed_suspend: 3 failed_suspend_late: 0 failed_suspend_noirq: 0 failed_resume: 0 failed_resume_early: 0 failed_resume_noirq: 0 failures: last_failed_dev: 0000:00:1d.0 0000:00:1d.0 last_failed_errno: -16 -16 last_failed_step: suspend suspend (kms_pipe_crc_basic:27865) igt-aux-CRITICAL: Test assertion failure function suspend_via_rtcwake, file igt_aux.c:825: (kms_pipe_crc_basic:27865) igt-aux-CRITICAL: Failed assertion: ret == 0 (kms_pipe_crc_basic:27865) igt-aux-CRITICAL: error: 1 != 0 (kms_pipe_crc_basic:27865) igt-core-INFO: Stack trace: (kms_pipe_crc_basic:27865) igt-core-INFO: #0 [__igt_fail_assert+0x101] (kms_pipe_crc_basic:27865) igt-core-INFO: #1 [igt_system_suspend_autoresume+0x52b] (kms_pipe_crc_basic:27865) igt-core-INFO: #2 [<unknown>+0x52b] (kms_pipe_crc_basic:27865) igt-core-INFO: #3 [<unknown>+0x52b]
We have gotten the same assertion a couple of times on SNB with test igt@kms_pipe_crc_basic@suspend-read-crc-pipe-[a|b] Once with 4.16.0-rc6-commit-dff9ece+ And the other with 4.16.0-commit-8eb8f6d+ Results for igt@kms_pipe_crc_basic@suspend-read-crc-pipe-a Result: fail Out IGT-Version: 1.22-ga9741da (x86_64) (Linux: 4.16.0-rc7-drm-intel-qa-ww13-commit-8eb8f6d+ x86_64) suspend-read-crc-pipe-A: Testing connector VGA-1 using pipe A suspend-read-crc-pipe-A: Testing connector DP-1 using pipe A [cmd] rtcwake: assuming RTC uses UTC ... rtcwake: wakeup from "mem" using /dev/rtc0 at Wed Mar 14 02:33:34 2018 Stack trace: #0 [__igt_fail_assert+0x101] #1 [igt_system_suspend_autoresume+0x52b] #2 [<unknown>+0x52b] #3 [<unknown>+0x52b] Subtest suspend-read-crc-pipe-A: FAIL (20.817s) Err (kms_pipe_crc_basic:29439) igt-core-WARNING: [cmd] rtcwake: write error (kms_pipe_crc_basic:29439) igt-aux-WARNING: rtcwake failed with 1 Check dmesg for further details. (kms_pipe_crc_basic:29439) igt-aux-CRITICAL: Test assertion failure function suspend_via_rtcwake, file igt_aux.c:825: (kms_pipe_crc_basic:29439) igt-aux-CRITICAL: Failed assertion: ret == 0 (kms_pipe_crc_basic:29439) igt-aux-CRITICAL: error: 1 != 0 Subtest suspend-read-crc-pipe-A failed. **** DEBUG **** (kms_pipe_crc_basic:29439) DEBUG: Test requirement passed: !(i >= data.display.n_pipes) (kms_pipe_crc_basic:29439) DEBUG: Test requirement passed: !(pipe >= data->display.n_pipes) (kms_pipe_crc_basic:29439) INFO: suspend-read-crc-pipe-A: Testing connector VGA-1 using pipe A (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: VGA-1: set_pipe(A) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: VGA-1: Selecting pipe A (kms_pipe_crc_basic:29439) DEBUG: Clearing the fb with color (0.00,1.00,0.00) (kms_pipe_crc_basic:29439) igt-fb-DEBUG: igt_create_fb_with_bo_size(width=1920, height=1200, format=0x34325258, tiling=0x0, size=0) (kms_pipe_crc_basic:29439) igt-fb-DEBUG: igt_create_fb_with_bo_size(handle=1, pitch=7680) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: Test requirement passed: plane_idx >= 0 && plane_idx < pipe->n_planes (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: A.0: plane_set_fb(89) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: A.0: plane_set_size (1920x1200) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: A.0: fb_set_position(0,0) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: A.0: fb_set_size(1920x1200) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: commit { (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: Fixing up initial rotation pipe A, plane 0 (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: VGA-1: SetCrtc pipe A, fb 89, src (0, 0), mode 1920x1200 (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: Fixing up initial rotation pipe A, plane 1 (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: SetPlane pipe A, plane 1, disabling (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: SetProp plane A.1 "rotation" to 0x1/1 (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: Fixing up initial rotation pipe A, plane 2 (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: SetCursor pipe A, disabling (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: MoveCursor pipe A, (0, 0) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: Fixing up initial rotation pipe B, plane 0 (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: SetCrtc pipe B, disabling (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: Fixing up initial rotation pipe B, plane 1 (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: SetPlane pipe B, plane 1, disabling (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: SetProp plane B.1 "rotation" to 0x1/1 (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: Fixing up initial rotation pipe B, plane 2 (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: SetCursor pipe B, disabling (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: MoveCursor pipe B, (0, 0) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: } (kms_pipe_crc_basic:29439) igt-debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0' (kms_pipe_crc_basic:29439) DEBUG: CRC for this fb: 0075d4f5 003750ea 0075d4f5 004448eb 0075d4f5 (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: A.0: plane_set_fb(0) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: A.0: plane_set_size (0x0) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: A.0: fb_set_position(0,0) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: A.0: fb_set_size(0x0) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: VGA-1: set_pipe(None) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: VGA-1: Selecting pipe None (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: VGA-1: set_pipe(A) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: VGA-1: Selecting pipe A (kms_pipe_crc_basic:29439) DEBUG: Clearing the fb with color (0.00,1.00,1.00) (kms_pipe_crc_basic:29439) igt-fb-DEBUG: igt_create_fb_with_bo_size(width=1920, height=1200, format=0x34325258, tiling=0x0, size=0) (kms_pipe_crc_basic:29439) igt-fb-DEBUG: igt_create_fb_with_bo_size(handle=1, pitch=7680) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: Test requirement passed: plane_idx >= 0 && plane_idx < pipe->n_planes (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: A.0: plane_set_fb(89) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: A.0: plane_set_size (1920x1200) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: A.0: fb_set_position(0,0) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: A.0: fb_set_size(1920x1200) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: commit { (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: VGA-1: SetCrtc pipe A, fb 89, src (0, 0), mode 1920x1200 (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: } (kms_pipe_crc_basic:29439) igt-debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0' (kms_pipe_crc_basic:29439) DEBUG: CRC for this fb: 0075d4f5 003750ea 003750ea 004448eb 004448eb (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: A.0: plane_set_fb(0) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: A.0: plane_set_size (0x0) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: A.0: fb_set_position(0,0) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: A.0: fb_set_size(0x0) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: VGA-1: set_pipe(None) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: VGA-1: Selecting pipe None (kms_pipe_crc_basic:29439) INFO: suspend-read-crc-pipe-A: Testing connector DP-1 using pipe A (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: DP-1: set_pipe(A) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: DP-1: Selecting pipe A (kms_pipe_crc_basic:29439) DEBUG: Clearing the fb with color (0.00,1.00,0.00) (kms_pipe_crc_basic:29439) igt-fb-DEBUG: igt_create_fb_with_bo_size(width=1920, height=1080, format=0x34325258, tiling=0x0, size=0) (kms_pipe_crc_basic:29439) igt-fb-DEBUG: igt_create_fb_with_bo_size(handle=1, pitch=7680) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: Test requirement passed: plane_idx >= 0 && plane_idx < pipe->n_planes (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: A.0: plane_set_fb(89) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: A.0: plane_set_size (1920x1080) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: A.0: fb_set_position(0,0) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: A.0: fb_set_size(1920x1080) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: commit { (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: DP-1: SetCrtc pipe A, fb 89, src (0, 0), mode 1920x1080 (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: } (kms_pipe_crc_basic:29439) igt-debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0' (kms_pipe_crc_basic:29439) DEBUG: CRC for this fb: 006189b7 007386c4 006189b7 001c5a5a 006189b7 (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: A.0: plane_set_fb(0) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: A.0: plane_set_size (0x0) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: A.0: fb_set_position(0,0) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: A.0: fb_set_size(0x0) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: DP-1: set_pipe(None) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: DP-1: Selecting pipe None (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: DP-1: set_pipe(A) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: DP-1: Selecting pipe A (kms_pipe_crc_basic:29439) DEBUG: Clearing the fb with color (0.00,1.00,1.00) (kms_pipe_crc_basic:29439) igt-fb-DEBUG: igt_create_fb_with_bo_size(width=1920, height=1080, format=0x34325258, tiling=0x0, size=0) (kms_pipe_crc_basic:29439) igt-fb-DEBUG: igt_create_fb_with_bo_size(handle=1, pitch=7680) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: Test requirement passed: plane_idx >= 0 && plane_idx < pipe->n_planes (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: A.0: plane_set_fb(89) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: A.0: plane_set_size (1920x1080) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: A.0: fb_set_position(0,0) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: A.0: fb_set_size(1920x1080) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: commit { (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: DP-1: SetCrtc pipe A, fb 89, src (0, 0), mode 1920x1080 (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: } (kms_pipe_crc_basic:29439) igt-debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0' (kms_pipe_crc_basic:29439) DEBUG: CRC for this fb: 006189b7 007386c4 007386c4 001c5a5a 001c5a5a (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: A.0: plane_set_fb(0) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: A.0: plane_set_size (0x0) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: A.0: fb_set_position(0,0) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: A.0: fb_set_size(0x0) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: DP-1: set_pipe(None) (kms_pipe_crc_basic:29439) igt-kms-DEBUG: display: DP-1: Selecting pipe None (kms_pipe_crc_basic:29439) DEBUG: Test requirement passed: valid_connectors (kms_pipe_crc_basic:29439) igt-core-DEBUG: Test requirement passed: !igt_run_in_simulation() (kms_pipe_crc_basic:29439) igt-aux-DEBUG: Test requirement passed: (power_dir = open("/sys/power", O_RDONLY)) >= 0 (kms_pipe_crc_basic:29439) igt-aux-DEBUG: Test requirement passed: get_supported_suspend_states(power_dir) & (1 << state) (kms_pipe_crc_basic:29439) igt-aux-DEBUG: Test requirement passed: test == SUSPEND_TEST_NONE || faccessat(power_dir, "pm_test", R_OK | W_OK, 0) == 0 (kms_pipe_crc_basic:29439) igt-aux-DEBUG: Test requirement passed: ret == 0 (kms_pipe_crc_basic:29439) igt-core-INFO: [cmd] rtcwake: assuming RTC uses UTC ... rtcwake: wakeup from "mem" using /dev/rtc0 at Wed Mar 14 02:33:34 2018 (kms_pipe_crc_basic:29439) igt-core-WARNING: [cmd] rtcwake: write error (kms_pipe_crc_basic:29439) igt-aux-WARNING: rtcwake failed with 1 Check dmesg for further details. (kms_pipe_crc_basic:29439) igt-aux-DEBUG: suspend_stats: success: 1 fail: 1 failed_freeze: 1 failed_prepare: 0 failed_suspend: 0 failed_suspend_late: 0 failed_suspend_noirq: 0 failed_resume: 0 failed_resume_early: 0 failed_resume_noirq: 0 failures: last_failed_dev: last_failed_errno: -16 0 last_failed_step: freeze (kms_pipe_crc_basic:29439) igt-aux-CRITICAL: Test assertion failure function suspend_via_rtcwake, file igt_aux.c:825: (kms_pipe_crc_basic:29439) igt-aux-CRITICAL: Failed assertion: ret == 0 (kms_pipe_crc_basic:29439) igt-aux-CRITICAL: error: 1 != 0 (kms_pipe_crc_basic:29439) igt-core-INFO: Stack trace: (kms_pipe_crc_basic:29439) igt-core-INFO: #0 [__igt_fail_assert+0x101] (kms_pipe_crc_basic:29439) igt-core-INFO: #1 [igt_system_suspend_autoresume+0x52b] (kms_pipe_crc_basic:29439) igt-core-INFO: #2 [<unknown>+0x52b] (kms_pipe_crc_basic:29439) igt-core-INFO: #3 [<unknown>+0x52b] **** END ****
Today's FF results: (kms_pipe_crc_basic:27722) igt-aux-CRITICAL: Test assertion failure function suspend_via_rtcwake, file igt_aux.c:825: (kms_pipe_crc_basic:27722) igt-aux-CRITICAL: Failed assertion: ret == 0 (kms_pipe_crc_basic:27722) igt-aux-CRITICAL: error: 1 != 0 IVB, igt@gem_exec_suspend@basic-s3, 4.16.0-rc7-commit-0110d63+ IVB, igt@kms_pipe_crc_basic@suspend-read-crc-pipe-a, 4.16.0-rc7-commit-0110d63+ SNB, igt@kms_pipe_crc_basic@suspend-read-crc-pipe-a, 4.16.0-rc7-commit-0110d63+
First of all. Sorry about spam. This is mass update for our bugs. Sorry if you feel this annoying but with this trying to understand if bug still valid or not. If bug investigation still in progress, please ignore this and I apologize! If you think this is not anymore valid, please comment to the bug that can be closed. If you haven't tested with our latest pre-upstream tree(drm-tip), can you do that also to see if issue is valid there still and if you cannot see issue there, please comment to the bug.
Results for igt@gem_exec_suspend@basic-s3 Result: fail Out IGT-Version: 1.21-ge3a0ed9 (x86_64) (Linux: 4.16.0-rc7-drm-intel-qa-ww14-commit-c46052c+ x86_64) [cmd] rtcwake: assuming RTC uses UTC ... rtcwake: wakeup from "mem" using /dev/rtc0 at Sun Feb 25 05:14:34 2018 Stack trace: #0 [__igt_fail_assert+0x101] #1 [igt_system_suspend_autoresume+0x52b] #2 [<unknown>+0x52b] Subtest basic-S3: FAIL (2.648s) Err (gem_exec_suspend:13258) igt-core-WARNING: [cmd] rtcwake: [cmd] write error (gem_exec_suspend:13258) igt-aux-WARNING: rtcwake failed with 1 Check dmesg for further details. (gem_exec_suspend:13258) igt-aux-CRITICAL: Test assertion failure function suspend_via_rtcwake, file igt_aux.c:825: (gem_exec_suspend:13258) igt-aux-CRITICAL: Failed assertion: ret == 0 (gem_exec_suspend:13258) igt-aux-CRITICAL: error: 1 != 0 Subtest basic-S3 failed. **** DEBUG **** (gem_exec_suspend:13258) DEBUG: Test requirement passed: nengine (gem_exec_suspend:13258) DEBUG: Test requirement passed: gem_has_ring(fd, engine) (gem_exec_suspend:13258) DEBUG: Test requirement passed: gem_can_store_dword(fd, engine) (gem_exec_suspend:13258) DEBUG: Test requirement passed: nengine (gem_exec_suspend:13258) igt-debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0' (gem_exec_suspend:13258) ioctl-wrappers-DEBUG: Test requirement passed: __gem_set_caching(fd, handle, caching) == 0 (gem_exec_suspend:13258) DEBUG: Test requirement passed: __gem_execbuf(fd, &execbuf) == 0 (gem_exec_suspend:13258) DEBUG: Verifying result (gem_exec_suspend:13258) igt-debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0' (gem_exec_suspend:13258) DEBUG: Test requirement passed: gem_has_ring(fd, engine) (gem_exec_suspend:13258) DEBUG: Test requirement passed: gem_can_store_dword(fd, engine) (gem_exec_suspend:13258) DEBUG: Test requirement passed: nengine (gem_exec_suspend:13258) igt-debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0' (gem_exec_suspend:13258) ioctl-wrappers-DEBUG: Test requirement passed: __gem_set_caching(fd, handle, caching) == 0 (gem_exec_suspend:13258) DEBUG: Test requirement passed: __gem_execbuf(fd, &execbuf) == 0 (gem_exec_suspend:13258) DEBUG: Verifying result (gem_exec_suspend:13258) igt-debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0' (gem_exec_suspend:13258) DEBUG: Test requirement passed: gem_has_ring(fd, engine) (gem_exec_suspend:13258) DEBUG: Test requirement passed: gem_can_store_dword(fd, engine) (gem_exec_suspend:13258) DEBUG: Test requirement passed: nengine (gem_exec_suspend:13258) igt-debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0' (gem_exec_suspend:13258) ioctl-wrappers-DEBUG: Test requirement passed: __gem_set_caching(fd, handle, caching) == 0 (gem_exec_suspend:13258) DEBUG: Test requirement passed: __gem_execbuf(fd, &execbuf) == 0 (gem_exec_suspend:13258) DEBUG: Verifying result (gem_exec_suspend:13258) igt-debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0' (gem_exec_suspend:13258) igt-debugfs-DEBUG: Opening debugfs directory '/sys/kernel/debug/dri/0' (gem_exec_suspend:13258) ioctl-wrappers-DEBUG: Test requirement passed: __gem_set_caching(fd, handle, caching) == 0 (gem_exec_suspend:13258) DEBUG: Test requirement passed: __gem_execbuf(fd, &execbuf) == 0 (gem_exec_suspend:13258) igt-core-DEBUG: Test requirement passed: !igt_run_in_simulation() (gem_exec_suspend:13258) igt-aux-DEBUG: Test requirement passed: (power_dir = open("/sys/power", O_RDONLY)) >= 0 (gem_exec_suspend:13258) igt-aux-DEBUG: Test requirement passed: get_supported_suspend_states(power_dir) & (1 << state) (gem_exec_suspend:13258) igt-aux-DEBUG: Test requirement passed: test == SUSPEND_TEST_NONE || faccessat(power_dir, "pm_test", R_OK | W_OK, 0) == 0 (gem_exec_suspend:13258) igt-aux-DEBUG: Test requirement passed: ret == 0 (gem_exec_suspend:13258) igt-core-INFO: [cmd] rtcwake: assuming RTC uses UTC ... rtcwake: wakeup from "mem" using /dev/rtc0 at Sun Feb 25 05:14:34 2018 (gem_exec_suspend:13258) igt-core-WARNING: [cmd] rtcwake: [cmd] write error (gem_exec_suspend:13258) igt-aux-WARNING: rtcwake failed with 1 Check dmesg for further details. (gem_exec_suspend:13258) igt-aux-DEBUG: suspend_stats: success: 0 fail: 1 failed_freeze: 0 failed_prepare: 0 failed_suspend: 1 failed_suspend_late: 0 failed_suspend_noirq: 0 failed_resume: 0 failed_resume_early: 0 failed_resume_noirq: 0 failures: last_failed_dev: 0000:00:1d.0 last_failed_errno: -16 0 last_failed_step: suspend (gem_exec_suspend:13258) igt-aux-CRITICAL: Test assertion failure function suspend_via_rtcwake, file igt_aux.c:825: (gem_exec_suspend:13258) igt-aux-CRITICAL: Failed assertion: ret == 0 (gem_exec_suspend:13258) igt-aux-CRITICAL: error: 1 != 0 (gem_exec_suspend:13258) igt-core-INFO: Stack trace: (gem_exec_suspend:13258) igt-core-INFO: #0 [__igt_fail_assert+0x101] (gem_exec_suspend:13258) igt-core-INFO: #1 [igt_system_suspend_autoresume+0x52b] (gem_exec_suspend:13258) igt-core-INFO: #2 [<unknown>+0x52b] **** END ****
I also happened today with BDW: Results for igt@kms_pipe_crc_basic@suspend-read-crc-pipe-c Result: fail Stdout IGT-Version: 1.22-gcad5fc0 (x86_64) (Linux: 4.16.0-rc7-drm-intel-qa-ww14-commit-1c1f24f+ x86_64) suspend-read-crc-pipe-C: Testing connector DP-1 using pipe C suspend-read-crc-pipe-C: Testing connector DP-2 using pipe C [cmd] rtcwake: assuming RTC uses UTC ... rtcwake: wakeup from "mem" using /dev/rtc0 at Wed Mar 14 01:15:51 2018 Stack trace: #0 [__igt_fail_assert+0x101] #1 [igt_system_suspend_autoresume+0x52b] #2 [<unknown>+0x52b] #3 [<unknown>+0x52b] Subtest suspend-read-crc-pipe-C: FAIL (21.335s) With the same fail suspend trace: ... (rtcwake: wakeup from "mem" using /dev/rtc0 at Wed Mar 14 01:15:51 2018 (kms_pipe_crc_basic:29581) igt-core-WARNING: [cmd] rtcwake: write error (kms_pipe_crc_basic:29581) igt-aux-WARNING: rtcwake failed with 1 Check dmesg for further details. (kms_pipe_crc_basic:29581) igt-aux-DEBUG: suspend_stats: success: 1 fail: 3 failed_freeze: 3 failed_prepare: 0 failed_suspend: 0 failed_suspend_late: 0 failed_suspend_noirq: 0 failed_resume: 0 failed_resume_early: 0 failed_resume_noirq: 0 failures: last_failed_dev: last_failed_errno: -16 -16 last_failed_step: freeze freeze (kms_pipe_crc_basic:29581) igt-aux-CRITICAL: Test assertion failure function suspend_via_rtcwake, file igt_aux.c:825: (kms_pipe_crc_basic:29581) igt-aux-CRITICAL: Failed assertion: ret == 0 (kms_pipe_crc_basic:29581) igt-aux-CRITICAL: error: 1 != 0 (kms_pipe_crc_basic:29581) igt-core-INFO: Stack trace: (kms_pipe_crc_basic:29581) igt-core-INFO: #0 [__igt_fail_assert+0x101] (kms_pipe_crc_basic:29581) igt-core-INFO: #1 [igt_system_suspend_autoresume+0x52b] (kms_pipe_crc_basic:29581) igt-core-INFO: #2 [<unknown>+0x52b] (kms_pipe_crc_basic:29581) igt-core-INFO: #3 [<unknown>+0x52b] **** END ****
Should this be caught by CI? I don't see it in cibuglogger
This issue is not in cibuglog and/or archived issues. This assume this is not our bug and kernel bug is opened as well. Closing this bug.
Use of freedesktop.org services, including Bugzilla, is subject to our Code of Conduct. How we collect and use information is described in our Privacy Policy.