[57.390217] Initializing watchdogs [57.390261] /dev/watchdog0 [57.404091] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [57.408294] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.410422] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.413796] [001/132] (960s left) kms_pipe_crc_basic (read-crc-frame-sequence) [57.535837] Starting subtest: read-crc-frame-sequence [57.538087] Starting dynamic subtest: pipe-A-eDP-1 [59.024226] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.500s) [59.033821] Starting dynamic subtest: pipe-B-eDP-1 [59.923657] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.905s) [59.930649] Starting dynamic subtest: pipe-C-eDP-1 [61.244255] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.330s) [61.252825] Starting dynamic subtest: pipe-D-eDP-1 [62.544853] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.307s) [62.547333] Subtest read-crc-frame-sequence: SUCCESS (5.048s) [63.363544] [002/132] (954s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu) [63.464824] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu [63.469142] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [63.556889] [003/132] (954s left) kms_big_fb (linear-16bpp-rotate-180) [63.672260] Starting subtest: linear-16bpp-rotate-180 [65.110596] Subtest linear-16bpp-rotate-180: SUCCESS (1.444s) [65.217160] [004/132] (952s left) gem_render_copy (y-tiled-ccs-to-y-tiled) [65.281992] Starting subtest: y-tiled-ccs-to-y-tiled [65.286074] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s) [65.465659] [005/132] (952s left) kms_async_flips (test-time-stamp) [65.569225] Starting subtest: test-time-stamp [65.951400] Starting dynamic subtest: pipe-A-eDP-1 [66.761704] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.810s) [67.141228] Starting dynamic subtest: pipe-B-eDP-1 [67.883175] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.748s) [68.269108] Starting dynamic subtest: pipe-C-eDP-1 [69.013040] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.749s) [69.378197] Starting dynamic subtest: pipe-D-eDP-1 [70.142838] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.771s) [70.145427] Subtest test-time-stamp: SUCCESS (4.586s) [71.301901] [006/132] (946s left) gem_pxp (verify-pxp-stale-buf-optout-execution) [71.437768] Starting subtest: verify-pxp-stale-buf-optout-execution [72.500101] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.065s) [72.633755] [007/132] (945s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled) [72.701646] Starting subtest: multi-wait-all-for-submit-submitted-signaled [72.812058] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.109s) [72.886274] [008/132] (945s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite) [72.983614] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite [79.181529] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.207s) [80.307774] [009/132] (937s left) kms_big_fb (x-tiled-addfb-size-overflow) [80.405842] Starting subtest: x-tiled-addfb-size-overflow [80.408097] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s) [80.496244] [010/132] (937s left) kms_flip (flip-vs-dpms-on-nop-interruptible) [80.591568] Starting subtest: flip-vs-dpms-on-nop-interruptible [80.593920] Starting dynamic subtest: A-eDP1 [82.405338] Dynamic subtest A-eDP1: SUCCESS (1.813s) [82.414348] Starting dynamic subtest: B-eDP1 [84.242097] Dynamic subtest B-eDP1: SUCCESS (1.834s) [84.251994] Starting dynamic subtest: C-eDP1 [86.063444] Dynamic subtest C-eDP1: SUCCESS (1.820s) [86.073374] Starting dynamic subtest: D-eDP1 [87.894804] Dynamic subtest D-eDP1: SUCCESS (1.830s) [87.900223] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.307s) [89.076392] [011/132] (929s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary) [89.177953] Starting subtest: fbcpsr-shrfb-scaledprimary [95.031812] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.857s) [95.175098] [012/132] (923s left) gem_softpin (allocator-basic) [95.229201] Starting subtest: allocator-basic [95.305304] Subtest allocator-basic: SUCCESS (0.078s) [95.430709] [013/132] (922s left) kms_flip (flip-vs-panning-vs-hang) [95.518616] Starting subtest: flip-vs-panning-vs-hang [95.520944] Starting dynamic subtest: A-eDP1 [146.366824] Dynamic subtest A-eDP1: SUCCESS (50.847s) [146.383026] Starting dynamic subtest: D-eDP1 [196.415509] Dynamic subtest D-eDP1: SUCCESS (50.047s) [196.417821] Subtest flip-vs-panning-vs-hang: SUCCESS (100.897s) [197.616586] [014/132] (820s left) kms_plane_lowres (tiling-x) [197.719191] Starting subtest: tiling-x [197.721581] Starting dynamic subtest: pipe-A-eDP-1 [197.726336] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [198.011483] Starting dynamic subtest: pipe-B-eDP-1 [198.016238] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [198.023544] Starting dynamic subtest: pipe-C-eDP-1 [198.028248] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [198.035501] Starting dynamic subtest: pipe-D-eDP-1 [198.040249] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [198.045026] Subtest tiling-x: SKIP (0.293s) [198.846990] [015/132] (819s left) perf (non-zero-reason) [198.971021] Starting subtest: non-zero-reason [198.972894] Starting dynamic subtest: 0-rcs0 [204.364615] Dynamic subtest 0-rcs0: SUCCESS (5.341s) [204.374522] Starting dynamic subtest: 1-vcs0 [208.198525] Dynamic subtest 1-vcs0: SUCCESS (3.885s) [208.201896] Subtest non-zero-reason: SUCCESS (9.227s) [208.242195] [016/132] (810s left) gem_exec_params (no-vebox) [208.303923] Starting subtest: no-vebox [208.308264] Subtest no-vebox: SUCCESS (0.003s) [209.956950] [017/132] (808s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt) [210.058390] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt [210.062640] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [210.151301] [018/132] (808s left) kms_psr (fbc-psr-primary-page-flip) [210.240250] Starting subtest: fbc-psr-primary-page-flip [210.242549] Starting dynamic subtest: eDP-1 [210.246973] Dynamic subtest eDP-1: SKIP (0.000s) [210.251418] Subtest fbc-psr-primary-page-flip: SKIP (0.001s) [210.328194] [019/132] (808s left) gem_render_copy (x-tiled) [210.377073] Starting subtest: x-tiled [210.379445] Starting dynamic subtest: smem [210.417677] Dynamic subtest smem: SUCCESS (0.041s) [210.419973] Subtest x-tiled: SUCCESS (0.041s) [210.600292] [020/132] (808s left) gem_exec_schedule (u-fairslice-all) [210.664521] Starting subtest: u-fairslice-all [212.720036] Subtest u-fairslice-all: SUCCESS (2.062s) [213.926436] [021/132] (804s left) perf (short-reads) [214.005886] Starting subtest: short-reads [214.019622] Subtest short-reads: SUCCESS (0.014s) [214.060358] [022/132] (804s left) sysfs_preempt_timeout (idempotent) [214.118580] Starting subtest: idempotent [214.120935] Starting dynamic subtest: vecs0 [214.123191] Dynamic subtest vecs0: SUCCESS (0.000s) [214.131589] Starting dynamic subtest: ccs0 [214.133678] Dynamic subtest ccs0: SUCCESS (0.000s) [214.140615] Starting dynamic subtest: vcs0 [214.142709] Dynamic subtest vcs0: SUCCESS (0.000s) [214.149769] Starting dynamic subtest: bcs0 [214.151592] Dynamic subtest bcs0: SUCCESS (0.000s) [214.158168] Starting dynamic subtest: rcs0 [214.160422] Dynamic subtest rcs0: SUCCESS (0.000s) [214.167140] Starting dynamic subtest: vcs1 [214.169202] Dynamic subtest vcs1: SUCCESS (0.000s) [214.171386] Subtest idempotent: SUCCESS (0.005s) [214.231149] [023/132] (804s left) gem_exec_whisper (basic-contexts-priority) [214.298094] Starting subtest: basic-contexts-priority [239.381817] Subtest basic-contexts-priority: SUCCESS (25.029s) [239.508384] [024/132] (779s left) gem_mmap_gtt (hang-busy) [239.562923] Subtest hang-busy: SKIP (0.000s) [239.618470] [025/132] (779s left) gem_ctx_persistence (legacy-engines-persistence) [239.671861] Starting subtest: legacy-engines-persistence [239.673801] Starting dynamic subtest: render [240.482538] Dynamic subtest render: SUCCESS (0.812s) [240.494055] Starting dynamic subtest: bsd1 [241.249270] Dynamic subtest bsd1: SUCCESS (0.765s) [241.260256] Starting dynamic subtest: bsd2 [241.985133] Dynamic subtest bsd2: SUCCESS (0.734s) [241.995139] Starting dynamic subtest: blt [242.753444] Dynamic subtest blt: SUCCESS (0.766s) [242.763061] Starting dynamic subtest: vebox [243.542977] Dynamic subtest vebox: SUCCESS (0.788s) [243.545779] Subtest legacy-engines-persistence: SUCCESS (3.874s) [243.632043] [026/132] (775s left) kms_psr (pr-sprite-blt) [243.725995] Starting subtest: pr-sprite-blt [243.730511] Subtest pr-sprite-blt: SKIP (0.000s) [243.802506] [027/132] (775s left) gem_mmap_gtt (basic-wc) [243.857844] Subtest basic-wc: SKIP (0.000s) [243.908779] [028/132] (775s left) i915_suspend (fence-restore-untiled) [243.967576] Starting subtest: fence-restore-untiled [243.971656] Subtest fence-restore-untiled: SKIP (0.000s) [244.067676] [029/132] (774s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt) [244.164659] Starting subtest: fbc-farfromfence-mmap-gtt [244.168721] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s) [244.255912] [030/132] (774s left) syncobj_timeline (reset-unsignaled) [244.312103] Starting subtest: reset-unsignaled [244.314307] Subtest reset-unsignaled: SUCCESS (0.000s) [244.398231] [031/132] (774s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff) [244.493212] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff [244.497178] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [244.586536] [032/132] (774s left) kms_cdclk (mode-transition) [244.692241] Starting subtest: mode-transition [244.693982] Starting dynamic subtest: pipe-A-eDP-1 [244.999056] Dynamic subtest pipe-A-eDP-1: SKIP (0.301s) [245.008903] Starting dynamic subtest: pipe-B-eDP-1 [245.013556] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [245.021683] Starting dynamic subtest: pipe-C-eDP-1 [245.026489] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [245.034203] Starting dynamic subtest: pipe-D-eDP-1 [245.038189] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [245.042245] Subtest mode-transition: SKIP (0.308s) [245.788037] [033/132] (773s left) kms_psr (psr2-cursor-mmap-cpu) [245.887073] Starting subtest: psr2-cursor-mmap-cpu [245.889256] Starting dynamic subtest: eDP-1 [247.582555] Dynamic subtest eDP-1: SUCCESS (1.695s) [247.584445] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.696s) [248.374877] [034/132] (770s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite) [248.474554] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite [248.479048] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [248.570665] [035/132] (770s left) kms_psr (psr-suspend) [248.653875] Starting subtest: psr-suspend [248.656242] Starting dynamic subtest: eDP-1 [266.513779] Dynamic subtest eDP-1: SUCCESS (3.860s) [266.516313] Subtest psr-suspend: SUCCESS (3.860s) [267.349761] [036/132] (751s left) syncobj_timeline (single-wait-all-for-submit-available-signaled) [267.425990] Starting subtest: single-wait-all-for-submit-available-signaled [267.428265] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.001s) [267.518797] [037/132] (751s left) gem_exec_balancer (parallel-balancer) [267.769149] Starting subtest: parallel-balancer [268.625933] Subtest parallel-balancer: SUCCESS (0.886s) [268.725299] [038/132] (750s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt) [268.823819] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt [268.828913] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [268.911297] [039/132] (750s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite) [269.018380] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite [276.464198] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.596s) [276.572930] [040/132] (742s left) perf_pmu (render-node-busy-idle) [276.650857] Starting subtest: render-node-busy-idle [276.653713] Starting dynamic subtest: rcs0 [277.348123] Dynamic subtest rcs0: SUCCESS (0.704s) [277.360040] Starting dynamic subtest: bcs0 [278.083905] Dynamic subtest bcs0: FAIL (0.679s) [278.093264] Starting dynamic subtest: vcs0 [278.756606] Dynamic subtest vcs0: FAIL (0.658s) [278.766930] Starting dynamic subtest: vcs1 [280.644482] Dynamic subtest vcs1: FAIL (1.903s) [280.654195] Starting dynamic subtest: vecs0 [282.628772] Dynamic subtest vecs0: FAIL (1.995s) [282.638732] Starting dynamic subtest: ccs0 [284.612024] Dynamic subtest ccs0: FAIL (1.993s) [284.614442] Subtest render-node-busy-idle: FAIL (7.937s) [284.651805] [041/132] (734s left) kms_color (invalid-degamma-lut-sizes) [284.748567] Starting subtest: invalid-degamma-lut-sizes [284.751127] Starting dynamic subtest: pipe-A [285.033528] Dynamic subtest pipe-A: SUCCESS (0.286s) [285.043421] Starting dynamic subtest: pipe-B [285.045717] Dynamic subtest pipe-B: SUCCESS (0.000s) [285.054181] Starting dynamic subtest: pipe-C [285.056477] Dynamic subtest pipe-C: SUCCESS (0.000s) [285.065445] Starting dynamic subtest: pipe-D [285.067691] Dynamic subtest pipe-D: SUCCESS (0.000s) [285.069839] Subtest invalid-degamma-lut-sizes: SUCCESS (0.290s) [285.840031] [042/132] (733s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt) [285.952902] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt [285.957849] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [286.061375] [043/132] (733s left) drm_read (short-buffer-nonblock) [286.202740] Starting subtest: short-buffer-nonblock [286.205527] Subtest short-buffer-nonblock: SUCCESS (0.000s) [286.326337] [044/132] (733s left) kms_cursor_legacy (cursora-vs-flipb-toggle) [286.457236] Starting subtest: cursorA-vs-flipB-toggle [286.462139] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s) [286.598480] [045/132] (732s left) gen9_exec_parse (shadow-peek) [286.666755] Subtest shadow-peek: SKIP (0.000s) [286.741819] [046/132] (732s left) kms_flip (2x-dpms-vs-vblank-race) [286.835464] Starting subtest: 2x-dpms-vs-vblank-race [286.847006] Subtest 2x-dpms-vs-vblank-race: SKIP (0.010s) [286.927227] [047/132] (732s left) syncobj_eventfd (invalid-bad-flags) [286.974694] Starting subtest: invalid-bad-flags [286.976923] Subtest invalid-bad-flags: SUCCESS (0.000s) [287.062709] [048/132] (732s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu) [287.159155] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu [287.163193] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [287.247096] [049/132] (732s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c) [287.303054] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s) [287.360804] [050/132] (732s left) gem_exec_params (rel-constants-invalid-ring) [287.412011] Starting subtest: rel-constants-invalid-ring [287.414033] Subtest rel-constants-invalid-ring: SUCCESS (0.000s) [287.507107] [051/132] (732s left) drm_mm (drm_mm) [287.539612] Starting subtest: drm_mm [287.594672] Starting dynamic subtest: drm_test_mm_init [287.696223] Dynamic subtest drm_test_mm_init: SUCCESS (0.101s) [287.706695] Starting dynamic subtest: drm_test_mm_debug [287.791762] Dynamic subtest drm_test_mm_debug: SUCCESS (0.094s) [287.799739] Starting dynamic subtest: drm_test_mm_align32 [287.894452] Dynamic subtest drm_test_mm_align32: SUCCESS (0.100s) [287.904414] Starting dynamic subtest: drm_test_mm_align64 [287.992453] Dynamic subtest drm_test_mm_align64: SUCCESS (0.100s) [288.000749] Starting dynamic subtest: drm_test_mm_lowest [288.078747] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.084s) [288.086778] Starting dynamic subtest: drm_test_mm_highest [288.170642] Dynamic subtest drm_test_mm_highest: SUCCESS (0.092s) [288.172788] Subtest drm_mm: SUCCESS (0.632s) [288.301449] [052/132] (731s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs) [288.395632] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs [288.399433] Starting dynamic subtest: pipe-A-eDP-1 [305.215449] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.451s) [305.228386] Starting dynamic subtest: pipe-B-eDP-1 [322.215184] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.454s) [322.224328] Starting dynamic subtest: pipe-C-eDP-1 [339.149698] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.391s) [339.159916] Starting dynamic subtest: pipe-D-eDP-1 [356.132298] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.323s) [356.135337] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.624s) [357.278982] [053/132] (662s left) gem_exec_whisper (basic-sync) [357.343745] Starting subtest: basic-sync [364.710080] Subtest basic-sync: SUCCESS (7.358s) [364.880191] [054/132] (655s left) i915_pm_rpm (sysfs-read) [367.254465] Starting subtest: sysfs-read [368.419396] Subtest sysfs-read: SUCCESS (1.167s) [368.789782] [055/132] (651s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [368.891176] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt [368.896299] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [368.982696] [056/132] (651s left) gem_exec_suspend (basic-s4-devices) [369.038932] Starting subtest: basic-S4-devices [369.041668] Starting dynamic subtest: smem [381.057890] Dynamic subtest smem: SUCCESS (12.024s) [381.060881] Subtest basic-S4-devices: SUCCESS (12.026s) [388.259618] [057/132] (638s left) kms_chamelium_edid (dp-edid-stress-resolution-4k) [388.664357] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s) [389.465853] [058/132] (637s left) kms_cursor_crc (cursor-onscreen-32x10) [389.624122] Starting subtest: cursor-onscreen-32x10 [389.675264] Subtest cursor-onscreen-32x10: SKIP (0.044s) [389.949697] [059/132] (637s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render) [390.061127] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render [390.065846] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [390.174252] [060/132] (637s left) kms_vrr (flip-basic) [390.261175] Starting subtest: flip-basic [390.268476] Subtest flip-basic: SKIP (0.000s) [390.329140] [061/132] (636s left) kms_pm_dc (dc6-psr) [391.429189] Starting subtest: dc6-psr [394.417266] Subtest dc6-psr: SUCCESS (3.054s) [395.273669] [062/132] (631s left) gem_mmap_gtt (cpuset-medium-copy) [395.328370] Subtest cpuset-medium-copy: SKIP (0.000s) [395.388233] [063/132] (631s left) gem_exec_fence (syncobj-wait) [395.875194] Starting subtest: syncobj-wait [397.079804] Subtest syncobj-wait: SUCCESS (1.221s) [399.078175] [FACT gem_exec_fence (syncobj-wait)] new: kernel.kmod_is_loaded.vgem: true [399.081776] [064/132] (628s left) gem_wait (write-wait) [399.155454] Starting subtest: write-wait [399.158493] Starting dynamic subtest: all-engines [400.283487] Dynamic subtest all-engines: SUCCESS (1.138s) [400.301080] Starting dynamic subtest: rcs0 [401.344345] Dynamic subtest rcs0: SUCCESS (1.067s) [401.361853] Starting dynamic subtest: bcs0 [402.406265] Dynamic subtest bcs0: SUCCESS (1.067s) [402.424520] Starting dynamic subtest: vcs0 [403.462476] Dynamic subtest vcs0: SUCCESS (1.061s) [403.478711] Starting dynamic subtest: vcs1 [404.520453] Dynamic subtest vcs1: SUCCESS (1.062s) [404.536960] Starting dynamic subtest: vecs0 [405.577431] Dynamic subtest vecs0: SUCCESS (1.060s) [405.594331] Starting dynamic subtest: ccs0 [406.636122] Dynamic subtest ccs0: SUCCESS (1.061s) [406.638735] Subtest write-wait: SUCCESS (7.530s) [406.837235] [065/132] (620s left) gem_pread (snoop) [406.897369] Subtest snoop: SKIP (0.000s) [406.955950] [066/132] (620s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc) [407.061533] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc [407.067107] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [407.175467] [067/132] (620s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping) [407.265503] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping [407.270491] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s) [407.339005] [068/132] (620s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip) [407.434515] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip [408.445460] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.013s) [408.559374] [069/132] (619s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf) [408.655222] Starting subtest: psr2-overlay-plane-update-continuous-sf [408.657272] Starting dynamic subtest: pipe-A-eDP-1 [409.790242] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.143s) [409.799355] Starting dynamic subtest: pipe-B-eDP-1 [411.516450] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.727s) [411.518848] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (2.873s) [412.321809] [070/132] (615s left) gem_eio (kms) [412.580383] Starting subtest: kms [431.183725] Subtest kms: SUCCESS (18.611s) [432.354342] [071/132] (595s left) kms_content_protection (suspend-resume) [432.499490] Starting subtest: suspend-resume [432.505458] Subtest suspend-resume: SKIP (0.000s) [432.623611] [072/132] (595s left) kms_busy (extended-modeset-hang-oldfb-with-reset) [432.725047] Starting subtest: extended-modeset-hang-oldfb-with-reset [432.727642] Starting dynamic subtest: pipe-A [444.534742] Dynamic subtest pipe-A: SUCCESS (11.810s) [444.546325] Starting dynamic subtest: pipe-D [457.113364] Dynamic subtest pipe-D: SUCCESS (12.578s) [457.116509] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.392s) [457.912961] [073/132] (569s left) gem_exec_create (legacy) [457.977254] Starting subtest: legacy [457.980278] Starting dynamic subtest: smem [460.082481] Dynamic subtest smem: SUCCESS (2.088s) [460.085337] Subtest legacy: SUCCESS (2.089s) [460.254919] [074/132] (567s left) gem_mmap_wc (bad-offset) [460.313703] Subtest bad-offset: SKIP (0.000s) [460.376144] [075/132] (567s left) tools_test (tools_test) [460.434201] Starting subtest: tools_test [460.483324] Subtest tools_test: SUCCESS (0.066s) [460.562806] [076/132] (567s left) kms_chamelium_hpd (vga-hpd-fast) [460.955186] Subtest vga-hpd-fast: SKIP (0.000s) [461.745134] [077/132] (566s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled) [461.796492] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled [461.799100] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s) [461.886862] [078/132] (566s left) gem_exec_schedule (lateslice) [461.962341] Starting subtest: lateslice [461.965056] Starting dynamic subtest: rcs0 [461.971982] Dynamic subtest rcs0: SUCCESS (0.023s) [461.986455] Starting dynamic subtest: bcs0 [461.992277] Dynamic subtest bcs0: SUCCESS (0.020s) [462.002345] Starting dynamic subtest: vcs0 [462.014727] Dynamic subtest vcs0: SUCCESS (0.022s) [462.024725] Starting dynamic subtest: vcs1 [462.033358] Dynamic subtest vcs1: SUCCESS (0.018s) [462.043347] Starting dynamic subtest: vecs0 [462.053720] Dynamic subtest vecs0: SUCCESS (0.020s) [462.063730] Starting dynamic subtest: ccs0 [462.074899] Dynamic subtest ccs0: SUCCESS (0.020s) [462.077757] Subtest lateslice: SUCCESS (0.127s) [464.149760] [079/132] (563s left) kms_rotation_crc (primary-rotation-90) [464.250293] Starting subtest: primary-rotation-90 [464.255340] Subtest primary-rotation-90: SKIP (0.001s) [464.322814] [080/132] (563s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite) [464.416846] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite [464.422407] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [464.514487] [081/132] (563s left) kms_draw_crc (draw-method-mmap-cpu) [464.605222] Starting subtest: draw-method-mmap-cpu [464.608032] Starting dynamic subtest: xrgb8888-untiled [464.824449] Dynamic subtest xrgb8888-untiled: SUCCESS (0.222s) [464.835039] Starting dynamic subtest: rgb565-untiled [465.048492] Dynamic subtest rgb565-untiled: SUCCESS (0.221s) [465.059174] Starting dynamic subtest: xrgb2101010-untiled [465.268498] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.219s) [465.283889] Starting dynamic subtest: xbgr16161616f-untiled [465.501925] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s) [465.517149] Starting dynamic subtest: xrgb8888-xtiled [465.624287] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s) [465.637303] Starting dynamic subtest: rgb565-xtiled [465.758064] Dynamic subtest rgb565-xtiled: SUCCESS (0.131s) [465.767883] Starting dynamic subtest: xrgb2101010-xtiled [465.868207] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s) [465.878074] Starting dynamic subtest: xbgr16161616f-xtiled [466.002110] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s) [466.012985] Starting dynamic subtest: xrgb8888-4tiled [466.135090] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s) [466.147185] Starting dynamic subtest: rgb565-4tiled [466.268215] Dynamic subtest rgb565-4tiled: SUCCESS (0.131s) [466.278014] Starting dynamic subtest: xrgb2101010-4tiled [466.390518] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.122s) [466.400843] Starting dynamic subtest: xbgr16161616f-4tiled [466.534930] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s) [466.537186] Subtest draw-method-mmap-cpu: SUCCESS (1.934s) [466.641968] [082/132] (561s left) kms_cursor_crc (cursor-rapid-movement-256x85) [466.904965] Starting subtest: cursor-rapid-movement-256x85 [466.950845] Subtest cursor-rapid-movement-256x85: SKIP (0.039s) [467.130095] [083/132] (561s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move) [467.219283] Starting subtest: fbc-1p-primscrn-cur-indfb-move [471.320354] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.105s) [472.445137] [084/132] (555s left) gem_mmap_gtt (basic-read) [472.514323] Subtest basic-read: SKIP (0.000s) [472.579179] [085/132] (555s left) gen7_exec_parse (basic-offset) [472.633828] Subtest basic-offset: SKIP (0.000s) [472.708337] [086/132] (555s left) kms_cursor_edge_walk (128x128-left-edge) [472.790031] Starting subtest: 128x128-left-edge [472.792490] Starting dynamic subtest: pipe-A-eDP-1 [476.218262] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.428s) [476.231486] Starting dynamic subtest: pipe-D-eDP-1 [479.334761] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.117s) [479.337348] Subtest 128x128-left-edge: SUCCESS (6.548s) [480.141046] [087/132] (548s left) gem_render_copy (y-tiled-to-vebox-yf-tiled) [480.200632] Starting subtest: y-tiled-to-vebox-yf-tiled [480.206311] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s) [480.389679] [088/132] (548s left) gem_exec_reloc (basic-write-read-active) [480.453847] Subtest basic-write-read-active: SKIP (0.000s) [480.531526] [089/132] (547s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs) [480.622134] Starting subtest: ccs-on-another-bo-yf-tiled-ccs [480.624742] Starting dynamic subtest: pipe-A-eDP-1 [480.651525] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [480.662506] Starting dynamic subtest: pipe-B-eDP-1 [480.688214] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [480.698450] Starting dynamic subtest: pipe-C-eDP-1 [480.724472] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [480.734323] Starting dynamic subtest: pipe-D-eDP-1 [480.761073] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [480.766069] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.005s) [482.822994] [090/132] (545s left) gem_madvise (dontneed-before-mmap) [482.857956] Starting subtest: dontneed-before-mmap [482.883135] Subtest dontneed-before-mmap: SUCCESS (0.026s) [482.978396] [091/132] (545s left) kms_plane_scaling (planes-downscale-factor-0-75) [483.073528] Starting subtest: planes-downscale-factor-0-75 [483.076115] Starting dynamic subtest: pipe-A [483.098250] Dynamic subtest pipe-A: SKIP (0.021s) [483.109444] Starting dynamic subtest: pipe-B [483.127958] Dynamic subtest pipe-B: SKIP (0.030s) [483.138536] Starting dynamic subtest: pipe-C [483.160165] Dynamic subtest pipe-C: SKIP (0.030s) [483.170435] Starting dynamic subtest: pipe-D [483.188170] Dynamic subtest pipe-D: SKIP (0.029s) [483.193185] Subtest planes-downscale-factor-0-75: SKIP (0.113s) [483.283032] [092/132] (545s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move) [483.380359] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move [483.385408] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [483.470301] [093/132] (545s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs) [483.564859] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs [483.567110] Starting dynamic subtest: pipe-A-eDP-1 [483.588028] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [483.602016] Starting dynamic subtest: pipe-B-eDP-1 [483.622973] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [483.632233] Starting dynamic subtest: pipe-C-eDP-1 [483.652963] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [483.662388] Starting dynamic subtest: pipe-D-eDP-1 [483.682905] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [483.685136] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s) [485.799025] [094/132] (542s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible) [485.918547] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible [485.921278] Starting dynamic subtest: A-eDP1 [489.528489] Dynamic subtest A-eDP1: SUCCESS (3.605s) [489.538913] Starting dynamic subtest: B-eDP1 [492.717604] Dynamic subtest B-eDP1: SUCCESS (3.187s) [492.732495] Starting dynamic subtest: C-eDP1 [495.852312] Dynamic subtest C-eDP1: SUCCESS (3.130s) [495.863359] Starting dynamic subtest: D-eDP1 [498.955768] Dynamic subtest D-eDP1: SUCCESS (3.104s) [498.958199] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.035s) [499.759375] [095/132] (528s left) kms_psr (fbc-psr2-primary-mmap-cpu) [499.848357] Starting subtest: fbc-psr2-primary-mmap-cpu [499.851278] Starting dynamic subtest: eDP-1 [499.856114] Dynamic subtest eDP-1: SKIP (0.000s) [499.860997] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s) [499.929726] [096/132] (528s left) kms_big_fb (y-tiled-addfb-size-overflow) [500.027491] Starting subtest: y-tiled-addfb-size-overflow [500.032820] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s) [500.123280] [097/132] (528s left) i915_drm_fdinfo (virtual-busy-idle-all) [500.171435] Starting subtest: virtual-busy-idle-all [500.176357] Subtest virtual-busy-idle-all: SKIP (0.000s) [500.246772] [098/132] (528s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs) [500.346507] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs [500.349237] Starting dynamic subtest: pipe-A-eDP-1 [500.378369] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [500.388107] Starting dynamic subtest: pipe-B-eDP-1 [500.416887] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [500.426402] Starting dynamic subtest: pipe-C-eDP-1 [500.455467] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [500.465091] Starting dynamic subtest: pipe-D-eDP-1 [500.493156] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [500.498141] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.005s) [502.532572] [099/132] (526s left) gem_exec_fence (submit67) [502.724750] Starting subtest: submit67 [502.730122] Subtest submit67: SKIP (0.000s) [504.147958] [100/132] (524s left) kms_invalid_mode (bad-htotal) [504.255028] Starting subtest: bad-htotal [504.257230] Starting dynamic subtest: pipe-A-eDP-1 [504.536288] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s) [504.546596] Starting dynamic subtest: pipe-B-eDP-1 [504.549333] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [504.559525] Starting dynamic subtest: pipe-C-eDP-1 [504.561960] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [504.571632] Starting dynamic subtest: pipe-D-eDP-1 [504.573917] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [504.576514] Subtest bad-htotal: SUCCESS (0.290s) [505.383050] [101/132] (523s left) kms_universal_plane (cursor-fb-leak) [505.470207] Starting subtest: cursor-fb-leak [505.473479] Starting dynamic subtest: pipe-A-eDP-1 [505.826274] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.359s) [505.837400] Starting dynamic subtest: pipe-B-eDP-1 [507.200406] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.371s) [507.213869] Starting dynamic subtest: pipe-C-eDP-1 [508.615249] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.412s) [508.628505] Starting dynamic subtest: pipe-D-eDP-1 [510.044464] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.428s) [510.047299] Subtest cursor-fb-leak: SUCCESS (4.578s) [511.183077] [102/132] (517s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180) [511.284721] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180 [511.289330] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [511.404213] [103/132] (517s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy) [511.484243] Starting subtest: map-fixed-invalidate-overlap-busy [511.489469] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s) [511.606569] [104/132] (517s left) prime_mmap (test_aperture_limit) [511.662228] Starting subtest: test_aperture_limit [511.664706] Starting dynamic subtest: test_aperture_limit-smem [511.672293] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s) [511.677441] Subtest test_aperture_limit: SKIP (0.008s) [511.769819] [105/132] (517s left) kms_dp_link_training (non-uhbr-mst) [511.857728] Starting subtest: non-uhbr-mst [511.866520] Subtest non-uhbr-mst: SKIP (0.000s) [511.931661] [106/132] (517s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render) [512.030681] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render [512.034847] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [512.124605] [107/132] (517s left) kms_flip (2x-flip-vs-wf_vblank) [512.229621] Starting subtest: 2x-flip-vs-wf_vblank [512.238464] Subtest 2x-flip-vs-wf_vblank: SKIP (0.010s) [512.322471] [108/132] (516s left) fbdev (info) [512.359548] Starting subtest: info [512.361794] Subtest info: SUCCESS (0.000s) [512.427374] [109/132] (516s left) kms_lease (lease-invalid-plane) [512.529709] Starting subtest: lease-invalid-plane [512.532038] Starting dynamic subtest: pipe-A-eDP-1 [512.534226] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [512.544727] Starting dynamic subtest: pipe-B-eDP-1 [512.547338] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [512.558177] Starting dynamic subtest: pipe-C-eDP-1 [512.560217] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [512.569292] Starting dynamic subtest: pipe-D-eDP-1 [512.571388] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [512.573680] Subtest lease-invalid-plane: SUCCESS (0.004s) [512.612845] [110/132] (516s left) kms_flip (flip-vs-fences-interruptible) [512.701990] Starting subtest: flip-vs-fences-interruptible [512.706208] Subtest flip-vs-fences-interruptible: SKIP (0.000s) [512.808994] [111/132] (516s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0) [512.901604] Starting subtest: linear-max-hw-stride-32bpp-rotate-0 [513.981232] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.079s) [514.094356] [112/132] (515s left) gem_ctx_engines (execute-oneforall) [514.149943] Starting subtest: execute-oneforall [514.887004] Subtest execute-oneforall: SUCCESS (0.735s) [516.166929] [113/132] (513s left) gem_exec_params (secure-non-master) [516.229723] Starting subtest: secure-non-master [516.235274] Subtest secure-non-master: SKIP (0.000s) [516.337536] [114/132] (513s left) kms_async_flips (alternate-sync-async-flip) [516.442297] Starting subtest: alternate-sync-async-flip [516.827361] Starting dynamic subtest: pipe-A-eDP-1 [519.580808] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.755s) [519.965609] Starting dynamic subtest: pipe-B-eDP-1 [522.712362] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.755s) [523.082128] Starting dynamic subtest: pipe-C-eDP-1 [525.851214] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.780s) [526.224468] Starting dynamic subtest: pipe-D-eDP-1 [528.983065] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.770s) [528.986029] Subtest alternate-sync-async-flip: SUCCESS (12.544s) [530.151576] [115/132] (499s left) gem_ctx_create (basic) [530.217484] Starting subtest: basic [530.220444] Subtest basic: SUCCESS (0.000s) [530.401561] [116/132] (499s left) gem_exec_reloc (basic-wc-read-active) [530.469298] Subtest basic-wc-read-active: SKIP (0.000s) [530.546864] [117/132] (499s left) syncobj_timeline (invalid-single-wait-unsubmitted) [530.599722] Starting subtest: invalid-single-wait-unsubmitted [530.602231] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [530.697532] [118/132] (498s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf) [530.784284] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf [530.789325] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [530.852220] [119/132] (498s left) api_intel_allocator (reopen) [530.910462] Starting subtest: reopen [530.913183] Subtest reopen: SUCCESS (0.005s) [531.037598] [120/132] (498s left) prime_busy (hang-wait) [531.093920] Starting subtest: hang-wait [531.096543] Starting dynamic subtest: rcs0 [557.540725] Dynamic subtest rcs0: SUCCESS (26.438s) [557.553498] Starting dynamic subtest: bcs0 [564.630391] Dynamic subtest bcs0: SUCCESS (7.097s) [564.642848] Starting dynamic subtest: vcs0 [571.665512] Dynamic subtest vcs0: SUCCESS (7.031s) [571.676082] Starting dynamic subtest: vcs1 [578.648623] Dynamic subtest vcs1: SUCCESS (6.974s) [578.661303] Starting dynamic subtest: vecs0 [585.623691] Dynamic subtest vecs0: SUCCESS (6.976s) [585.636498] Starting dynamic subtest: ccs0 [599.512445] Dynamic subtest ccs0: SUCCESS (13.899s) [599.515370] Subtest hang-wait: SUCCESS (68.428s) [599.630311] [121/132] (430s left) gem_workarounds (reset-fd) [599.698298] Starting subtest: reset-fd [599.830919] Subtest reset-fd: SUCCESS (0.136s) [599.968299] [122/132] (429s left) kms_flip (basic-flip-vs-wf_vblank) [600.075542] Starting subtest: basic-flip-vs-wf_vblank [600.078041] Starting dynamic subtest: A-eDP1 [601.977521] Dynamic subtest A-eDP1: SUCCESS (1.904s) [601.989074] Starting dynamic subtest: B-eDP1 [603.904972] Dynamic subtest B-eDP1: SUCCESS (1.927s) [603.920076] Starting dynamic subtest: C-eDP1 [605.837432] Dynamic subtest C-eDP1: SUCCESS (1.929s) [605.848061] Starting dynamic subtest: D-eDP1 [607.767978] Dynamic subtest D-eDP1: SUCCESS (1.929s) [607.770462] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.700s) [608.987605] [123/132] (420s left) gem_ctx_persistence (engines-hostile-preempt) [609.050309] Starting subtest: engines-hostile-preempt [609.053500] Starting dynamic subtest: rcs0 [609.134380] Dynamic subtest rcs0: SUCCESS (0.084s) [609.147741] Starting dynamic subtest: bcs0 [609.179498] Dynamic subtest bcs0: SUCCESS (0.044s) [609.190471] Starting dynamic subtest: vcs0 [611.003633] Dynamic subtest vcs0: SUCCESS (1.821s) [611.017219] Starting dynamic subtest: vcs1 [613.053159] Dynamic subtest vcs1: SUCCESS (2.047s) [613.067507] Starting dynamic subtest: vecs0 [615.094204] Dynamic subtest vecs0: SUCCESS (1.980s) [615.108472] Starting dynamic subtest: ccs0 [615.111027] Dynamic subtest ccs0: SUCCESS (0.059s) [615.113346] Subtest engines-hostile-preempt: SUCCESS (6.048s) [615.176012] [124/132] (414s left) api_intel_bb (offset-control) [615.238462] Starting subtest: offset-control [615.250011] Subtest offset-control: SUCCESS (0.014s) [615.377682] [125/132] (414s left) kms_plane (plane-panning-bottom-right-suspend) [615.473171] Starting subtest: plane-panning-bottom-right-suspend [615.475941] Starting dynamic subtest: pipe-A [633.384397] Dynamic subtest pipe-A: SUCCESS (2.849s) [633.395183] Starting dynamic subtest: pipe-B [652.372605] Dynamic subtest pipe-B: SUCCESS (3.519s) [652.375111] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.372s) [653.214632] [126/132] (376s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf) [653.339124] Starting subtest: fbc-psr2-cursor-plane-update-sf [653.341634] Starting dynamic subtest: pipe-A-eDP-1 [653.409691] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s) [653.419669] Starting dynamic subtest: pipe-B-eDP-1 [654.549162] Dynamic subtest pipe-B-eDP-1: SKIP (1.173s) [654.554064] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.255s) [655.720758] [127/132] (374s left) perf_pmu (interrupts-sync) [655.767684] Starting subtest: interrupts-sync [656.843154] Subtest interrupts-sync: SUCCESS (1.102s) [656.955102] [128/132] (373s left) kms_frontbuffer_tracking (fbc-tiling-4) [657.051509] Starting subtest: fbc-tiling-4 [661.244542] Subtest fbc-tiling-4: SUCCESS (4.268s) [662.415342] [129/132] (367s left) kms_getfb (getfb-repeated-different-handles) [662.498901] Starting subtest: getfb-repeated-different-handles [662.501829] Subtest getfb-repeated-different-handles: SUCCESS (0.000s) [662.593723] [130/132] (367s left) vgem_basic (dmabuf-export) [662.642765] Starting subtest: dmabuf-export [662.658366] Subtest dmabuf-export: SUCCESS (0.018s) [662.745903] [131/132] (367s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite) [662.836880] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite [672.031562] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.254s) [672.170970] [132/132] (358s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling) [672.274687] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling [672.279590] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s) [672.344353] Closing watchdogs results: parsing output: 0/ for test: kms_pipe_crc_basic results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: kms_big_fb results: parsing output: 3/ for test: gem_render_copy results: parsing output: 4/ for test: kms_async_flips results: parsing output: 5/ for test: gem_pxp results: parsing output: 6/ for test: syncobj_wait results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: kms_big_fb results: parsing output: 9/ for test: kms_flip results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: gem_softpin results: parsing output: 12/ for test: kms_flip results: parsing output: 13/ for test: kms_plane_lowres results: parsing output: 14/ for test: perf results: parsing output: 15/ for test: gem_exec_params results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: kms_psr results: parsing output: 18/ for test: gem_render_copy results: parsing output: 19/ for test: gem_exec_schedule results: parsing output: 20/ for test: perf results: parsing output: 21/ for test: sysfs_preempt_timeout results: parsing output: 22/ for test: gem_exec_whisper results: parsing output: 23/ for test: gem_mmap_gtt results: parsing output: 24/ for test: gem_ctx_persistence results: parsing output: 25/ for test: kms_psr results: parsing output: 26/ for test: gem_mmap_gtt results: parsing output: 27/ for test: i915_suspend results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: syncobj_timeline results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: kms_cdclk results: parsing output: 32/ for test: kms_psr results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: kms_psr results: parsing output: 35/ for test: syncobj_timeline results: parsing output: 36/ for test: gem_exec_balancer results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: perf_pmu results: parsing output: 40/ for test: kms_color results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: drm_read results: parsing output: 43/ for test: kms_cursor_legacy results: parsing output: 44/ for test: gen9_exec_parse results: parsing output: 45/ for test: kms_flip results: parsing output: 46/ for test: syncobj_eventfd results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: kms_pipe_b_c_ivb results: parsing output: 49/ for test: gem_exec_params results: parsing output: 50/ for test: drm_mm results: parsing output: 51/ for test: kms_ccs results: parsing output: 52/ for test: gem_exec_whisper results: parsing output: 53/ for test: i915_pm_rpm results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: gem_exec_suspend results: parsing output: 56/ for test: kms_chamelium_edid results: parsing output: 57/ for test: kms_cursor_crc results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: kms_vrr results: parsing output: 60/ for test: kms_pm_dc results: parsing output: 61/ for test: gem_mmap_gtt results: parsing output: 62/ for test: gem_exec_fence results: parsing output: 63/ for test: gem_wait results: parsing output: 64/ for test: gem_pread results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: kms_plane results: parsing output: 67/ for test: kms_big_fb results: parsing output: 68/ for test: kms_psr2_sf results: parsing output: 69/ for test: gem_eio results: parsing output: 70/ for test: kms_content_protection results: parsing output: 71/ for test: kms_busy results: parsing output: 72/ for test: gem_exec_create results: parsing output: 73/ for test: gem_mmap_wc results: parsing output: 74/ for test: tools_test results: parsing output: 75/ for test: kms_chamelium_hpd results: parsing output: 76/ for test: syncobj_timeline results: parsing output: 77/ for test: gem_exec_schedule results: parsing output: 78/ for test: kms_rotation_crc results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: kms_draw_crc results: parsing output: 81/ for test: kms_cursor_crc results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: gem_mmap_gtt results: parsing output: 84/ for test: gen7_exec_parse results: parsing output: 85/ for test: kms_cursor_edge_walk results: parsing output: 86/ for test: gem_render_copy results: parsing output: 87/ for test: gem_exec_reloc results: parsing output: 88/ for test: kms_ccs results: parsing output: 89/ for test: gem_madvise results: parsing output: 90/ for test: kms_plane_scaling results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: kms_ccs results: parsing output: 93/ for test: kms_flip results: parsing output: 94/ for test: kms_psr results: parsing output: 95/ for test: kms_big_fb results: parsing output: 96/ for test: i915_drm_fdinfo results: parsing output: 97/ for test: kms_ccs results: parsing output: 98/ for test: gem_exec_fence results: parsing output: 99/ for test: kms_invalid_mode results: parsing output: 100/ for test: kms_universal_plane results: parsing output: 101/ for test: kms_big_fb results: parsing output: 102/ for test: gem_userptr_blits results: parsing output: 103/ for test: prime_mmap results: parsing output: 104/ for test: kms_dp_link_training results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: kms_flip results: parsing output: 107/ for test: fbdev results: parsing output: 108/ for test: kms_lease results: parsing output: 109/ for test: kms_flip results: parsing output: 110/ for test: kms_big_fb results: parsing output: 111/ for test: gem_ctx_engines results: parsing output: 112/ for test: gem_exec_params results: parsing output: 113/ for test: kms_async_flips results: parsing output: 114/ for test: gem_ctx_create results: parsing output: 115/ for test: gem_exec_reloc results: parsing output: 116/ for test: syncobj_timeline results: parsing output: 117/ for test: kms_psr2_sf results: parsing output: 118/ for test: api_intel_allocator results: parsing output: 119/ for test: prime_busy results: parsing output: 120/ for test: gem_workarounds results: parsing output: 121/ for test: kms_flip results: parsing output: 122/ for test: gem_ctx_persistence results: parsing output: 123/ for test: api_intel_bb results: parsing output: 124/ for test: kms_plane results: parsing output: 125/ for test: kms_psr2_sf results: parsing output: 126/ for test: perf_pmu results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: kms_getfb results: parsing output: 129/ for test: vgem_basic results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: kms_flip_scaled_crc Done.