[64.170835] Initializing watchdogs [64.170881] /dev/watchdog0 [64.185434] [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] [64.189916] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [64.192221] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [64.195531] [001/133] (960s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size) [64.354130] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size [66.078765] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (1.723s) [66.463453] [002/133] (958s left) kms_hdr (brightness-with-hdr) [66.577426] Starting subtest: brightness-with-hdr [66.584486] Subtest brightness-with-hdr: SKIP (0.000s) [66.644642] [003/133] (958s left) gem_sync (basic-store-all) [66.777315] Starting subtest: basic-store-all [69.976150] Subtest basic-store-all: SUCCESS (3.208s) [70.161197] [004/133] (954s left) gem_ctx_persistence (heartbeat-stop) [70.226527] Starting subtest: heartbeat-stop [70.231125] Subtest heartbeat-stop: SKIP (0.000s) [70.348855] [005/133] (954s left) gem_ctx_shared (q-smoketest) [70.427719] Starting subtest: Q-smoketest [70.430016] Starting dynamic subtest: rcs0 [75.991079] Dynamic subtest rcs0: SUCCESS (5.518s) [76.003790] Starting dynamic subtest: bcs0 [81.476272] Dynamic subtest bcs0: SUCCESS (5.481s) [81.489707] Starting dynamic subtest: vcs0 [86.963388] Dynamic subtest vcs0: SUCCESS (5.487s) [86.972770] Starting dynamic subtest: vcs1 [92.458589] Dynamic subtest vcs1: SUCCESS (5.484s) [92.467179] Starting dynamic subtest: vecs0 [97.933924] Dynamic subtest vecs0: SUCCESS (5.485s) [97.941846] Starting dynamic subtest: ccs0 [103.424583] Dynamic subtest ccs0: SUCCESS (5.489s) [103.426650] Subtest Q-smoketest: SUCCESS (32.948s) [103.563157] [006/133] (921s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode) [103.958886] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s) [104.767914] [007/133] (920s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions) [104.913446] Starting subtest: cursorA-vs-flipA-atomic-transitions [116.095226] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.180s) [116.914545] [008/133] (908s left) gem_pread (display) [116.995691] Subtest display: SKIP (0.000s) [117.093589] [009/133] (907s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180) [117.202769] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180 [118.226536] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.024s) [118.356235] [010/133] (906s left) gen3_render_tiledy_blits [118.472967] [011/133] (906s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [118.562458] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [118.564383] Starting dynamic subtest: pipe-A-default-mode [119.687756] Dynamic subtest pipe-A-default-mode: SKIP (1.123s) [119.692351] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.124s) [119.844514] [012/133] (905s left) gem_mmap_gtt (big-bo-tiledy) [119.912043] Subtest big-bo-tiledY: SKIP (0.000s) [119.971738] [013/133] (905s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible) [120.074999] Starting subtest: flip-vs-absolute-wf_vblank-interruptible [120.077310] Starting dynamic subtest: A-eDP1 [129.001865] Dynamic subtest A-eDP1: SUCCESS (8.926s) [129.013090] Starting dynamic subtest: B-eDP1 [137.941147] Dynamic subtest B-eDP1: SUCCESS (8.938s) [137.950527] Starting dynamic subtest: C-eDP1 [146.859245] Dynamic subtest C-eDP1: SUCCESS (8.915s) [146.871942] Starting dynamic subtest: D-eDP1 [155.783528] Dynamic subtest D-eDP1: SUCCESS (8.921s) [155.788985] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.711s) [157.015561] [014/133] (868s left) kms_atomic_transition (plane-all-transition-nonblocking) [157.121564] Starting subtest: plane-all-transition-nonblocking [157.124036] Starting dynamic subtest: pipe-A-eDP-1 [159.647550] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.525s) [159.953229] Starting dynamic subtest: pipe-B-eDP-1 [163.147183] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.202s) [163.448924] Subtest plane-all-transition-nonblocking: SUCCESS (6.325s) [164.265978] [015/133] (861s left) gem_softpin (allocator-fork) [164.335364] Starting subtest: allocator-fork [166.550458] Subtest allocator-fork: SUCCESS (2.213s) [166.677520] [016/133] (858s left) kms_big_fb (x-tiled-8bpp-rotate-180) [166.783654] Starting subtest: x-tiled-8bpp-rotate-180 [167.986496] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.204s) [168.094776] [017/133] (857s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render) [168.215804] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render [168.219431] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [168.314050] [018/133] (857s left) gem_create (create-clear) [168.368615] Starting subtest: create-clear [168.370644] Starting dynamic subtest: smem0 [201.035921] Dynamic subtest smem0: SUCCESS (32.662s) [201.038431] Subtest create-clear: SUCCESS (32.664s) [201.238991] [019/133] (824s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180) [201.357712] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180 [201.361830] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [201.450414] [020/133] (824s left) kms_chamelium_color (ctm-max) [201.544260] Subtest ctm-max: SKIP (0.000s) [201.588423] [021/133] (823s left) gem_render_copy (yf-tiled-ccs-to-linear) [201.649487] Starting subtest: yf-tiled-ccs-to-linear [201.653800] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s) [201.846517] [022/133] (823s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary) [201.939176] Starting subtest: fbc-shrfb-scaledprimary [205.243787] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.307s) [206.445833] [023/133] (819s left) kms_big_fb (y-tiled-64bpp-rotate-180) [206.550962] Starting subtest: y-tiled-64bpp-rotate-180 [206.555611] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s) [206.647364] [024/133] (819s left) gem_userptr_blits (unsync-overlap) [206.724458] Subtest unsync-overlap: SKIP (0.000s) [206.837512] [025/133] (818s left) syncobj_timeline (invalid-signal-illegal-handle) [206.900865] Starting subtest: invalid-signal-illegal-handle [206.903104] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [207.008017] [026/133] (818s left) gem_exec_schedule (timeslicing) [207.071106] Starting subtest: timeslicing [207.072939] Starting dynamic subtest: rcs0 [207.083662] Dynamic subtest rcs0: SUCCESS (0.022s) [207.092135] Starting dynamic subtest: bcs0 [207.105648] Dynamic subtest bcs0: SUCCESS (0.021s) [207.113745] Starting dynamic subtest: vcs0 [207.126639] Dynamic subtest vcs0: SUCCESS (0.020s) [207.140856] Starting dynamic subtest: vcs1 [207.150023] Dynamic subtest vcs1: SUCCESS (0.022s) [207.160650] Starting dynamic subtest: vecs0 [207.170589] Dynamic subtest vecs0: SUCCESS (0.020s) [207.178319] Starting dynamic subtest: ccs0 [207.191130] Dynamic subtest ccs0: SUCCESS (0.020s) [207.193438] Subtest timeslicing: SUCCESS (0.130s) [208.956171] [027/133] (816s left) kms_lease (lease-unleased-crtc) [209.055221] Starting subtest: lease-unleased-crtc [209.057515] Starting dynamic subtest: pipe-A-eDP-1 [209.350302] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s) [209.357634] Starting dynamic subtest: pipe-B-eDP-1 [210.081936] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.730s) [210.090880] Starting dynamic subtest: pipe-C-eDP-1 [210.093182] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s) [210.101091] Starting dynamic subtest: pipe-D-eDP-1 [210.103420] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s) [210.105766] Subtest lease-unleased-crtc: SUCCESS (1.049s) [210.477029] [028/133] (815s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt) [210.564056] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt [217.332913] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.772s) [217.465414] [029/133] (808s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [217.562231] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu [217.566579] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [217.653583] [030/133] (808s left) kms_cursor_crc (cursor-offscreen-64x21) [217.842337] Starting subtest: cursor-offscreen-64x21 [217.901274] Subtest cursor-offscreen-64x21: SKIP (0.053s) [218.140850] [031/133] (807s left) kms_vrr (negative-basic) [218.237196] Starting subtest: negative-basic [218.243500] Starting dynamic subtest: pipe-A-eDP-1 [223.669208] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.425s) [223.966874] Subtest negative-basic: SUCCESS (5.731s) [224.804196] [032/133] (801s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180) [224.940079] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180 [224.944992] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s) [225.066840] [033/133] (800s left) gem_wait (write-wait) [225.136601] Starting subtest: write-wait [225.138894] Starting dynamic subtest: all-engines [226.310286] Dynamic subtest all-engines: SUCCESS (1.173s) [226.325935] Starting dynamic subtest: rcs0 [227.366884] Dynamic subtest rcs0: SUCCESS (1.054s) [227.385660] Starting dynamic subtest: bcs0 [228.426222] Dynamic subtest bcs0: SUCCESS (1.057s) [228.441477] Starting dynamic subtest: vcs0 [229.480208] Dynamic subtest vcs0: SUCCESS (1.052s) [229.495185] Starting dynamic subtest: vcs1 [230.533471] Dynamic subtest vcs1: SUCCESS (1.051s) [230.548392] Starting dynamic subtest: vecs0 [231.587542] Dynamic subtest vecs0: SUCCESS (1.051s) [231.606036] Starting dynamic subtest: ccs0 [232.644691] Dynamic subtest ccs0: SUCCESS (1.055s) [232.647334] Subtest write-wait: SUCCESS (7.509s) [232.847591] [FACT gem_wait (write-wait)] new: kernel.kmod_is_loaded.vgem: true [232.851268] [034/133] (793s left) gem_exec_fence (basic-busy) [233.041167] Starting subtest: basic-busy [233.043710] Starting dynamic subtest: rcs0 [233.114649] Dynamic subtest rcs0: SUCCESS (0.070s) [233.124865] Starting dynamic subtest: bcs0 [233.181175] Dynamic subtest bcs0: SUCCESS (0.067s) [233.191396] Starting dynamic subtest: vcs0 [233.240183] Dynamic subtest vcs0: SUCCESS (0.057s) [233.250259] Starting dynamic subtest: vcs1 [233.300342] Dynamic subtest vcs1: SUCCESS (0.058s) [233.310833] Starting dynamic subtest: vecs0 [233.365321] Dynamic subtest vecs0: SUCCESS (0.063s) [233.374874] Starting dynamic subtest: ccs0 [233.430834] Dynamic subtest ccs0: SUCCESS (0.064s) [233.433295] Subtest basic-busy: SUCCESS (0.391s) [234.994233] [035/133] (791s left) gem_tiled_wc [235.135609] [036/133] (790s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping) [235.241692] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping [235.245655] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s) [235.331511] [037/133] (790s left) gem_exec_fence (submit) [235.537069] Starting subtest: submit [235.542035] Subtest submit: SKIP (0.000s) [236.966523] [038/133] (789s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [237.073696] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [237.075640] Starting dynamic subtest: pipe-A-eDP-1 [237.133765] Dynamic subtest pipe-A-eDP-1: SKIP (0.002s) [237.143420] Starting dynamic subtest: pipe-B-eDP-1 [237.197693] Dynamic subtest pipe-B-eDP-1: SKIP (0.002s) [237.205899] Starting dynamic subtest: pipe-C-eDP-1 [237.260391] Dynamic subtest pipe-C-eDP-1: SKIP (0.002s) [237.268279] Starting dynamic subtest: pipe-D-eDP-1 [237.321959] Dynamic subtest pipe-D-eDP-1: SKIP (0.002s) [237.326246] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.016s) [239.367144] [039/133] (786s left) vgem_basic (bad-handle) [239.407304] Starting subtest: bad-handle [239.409231] Subtest bad-handle: SUCCESS (0.000s) [239.462504] [040/133] (786s left) gem_exec_reloc (basic-cpu-wc-active) [239.530556] Subtest basic-cpu-wc-active: SKIP (0.000s) [239.612051] [041/133] (786s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k) [240.005282] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s) [240.784992] [042/133] (785s left) gem_exec_reloc (basic-gtt-cpu-noreloc) [240.845738] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s) [240.908116] [043/133] (785s left) gem_readwrite (new-obj) [240.962323] Subtest new-obj: SKIP (0.000s) [241.015294] [044/133] (785s left) gem_exec_reloc (basic-wc-cpu-active) [241.063786] Subtest basic-wc-cpu-active: SKIP (0.000s) [241.134226] [045/133] (785s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt) [241.218719] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt [248.704479] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.488s) [248.837410] [046/133] (777s left) gem_pxp (fail-invalid-protected-context) [248.984032] Starting subtest: fail-invalid-protected-context [248.986592] Subtest fail-invalid-protected-context: SUCCESS (0.000s) [249.107405] [047/133] (777s left) kms_psr (fbc-psr-primary-page-flip) [249.202810] Starting subtest: fbc-psr-primary-page-flip [249.205069] Starting dynamic subtest: eDP-1 [249.209276] Dynamic subtest eDP-1: SKIP (0.000s) [249.213158] Subtest fbc-psr-primary-page-flip: SKIP (0.002s) [249.284542] [048/133] (777s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions) [249.400846] Starting subtest: short-flip-before-cursor-atomic-transitions [250.358932] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.957s) [251.159077] [049/133] (775s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [251.254261] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [251.878619] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.626s) [252.051967] [050/133] (774s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [252.158738] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc [252.163209] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [252.263885] [051/133] (774s left) gem_exec_schedule (noreorder-priority) [252.441606] Starting subtest: noreorder-priority [252.444273] Starting dynamic subtest: rcs0 [253.592422] Dynamic subtest rcs0: SUCCESS (1.151s) [253.602437] Starting dynamic subtest: vcs0 [254.907479] Dynamic subtest vcs0: SUCCESS (1.312s) [254.917799] Starting dynamic subtest: vcs1 [256.910448] Dynamic subtest vcs1: SUCCESS (2.000s) [256.924287] Starting dynamic subtest: vecs0 [258.895705] Dynamic subtest vecs0: SUCCESS (1.982s) [258.908760] Starting dynamic subtest: ccs0 [260.043060] Dynamic subtest ccs0: SUCCESS (1.147s) [260.045882] Subtest noreorder-priority: SUCCESS (7.603s) [260.230245] [052/133] (766s left) gem_lmem_swapping (verify-ccs) [260.276316] Subtest verify-ccs: SKIP (0.000s) [260.319058] [053/133] (766s left) gem_ctx_isolation (dirty-create) [260.382774] Starting subtest: dirty-create [260.385048] Starting dynamic subtest: rcs0 [260.622570] Dynamic subtest rcs0: SUCCESS (0.239s) [260.632614] Starting dynamic subtest: bcs0 [260.873578] Dynamic subtest bcs0: SUCCESS (0.250s) [260.884183] Starting dynamic subtest: vcs0 [261.113085] Dynamic subtest vcs0: SUCCESS (0.238s) [261.123849] Starting dynamic subtest: vcs1 [263.147550] Dynamic subtest vcs1: SUCCESS (2.033s) [263.155975] Starting dynamic subtest: vecs0 [265.137569] Dynamic subtest vecs0: SUCCESS (1.989s) [265.149744] Starting dynamic subtest: ccs0 [267.116167] Dynamic subtest ccs0: SUCCESS (1.977s) [267.118638] Subtest dirty-create: SUCCESS (6.734s) [267.368019] [054/133] (759s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area) [267.477764] Starting subtest: fbc-pr-plane-move-sf-dmg-area [267.481884] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s) [267.545514] [055/133] (759s left) dmabuf (all-tests) [267.583760] Starting subtest: all-tests [267.585988] Starting dynamic subtest: sanitycheck [267.706316] Dynamic subtest sanitycheck: SUCCESS (0.124s) [267.718640] Starting dynamic subtest: dma_fence [267.914367] Dynamic subtest dma_fence: SUCCESS (0.205s) [267.926080] Starting dynamic subtest: dma_fence_chain [277.073993] Dynamic subtest dma_fence_chain: SUCCESS (9.155s) [277.084753] Starting dynamic subtest: dma_fence_unwrap [277.162694] Dynamic subtest dma_fence_unwrap: SUCCESS (0.088s) [277.174065] Starting dynamic subtest: dma_resv [277.266337] Dynamic subtest dma_resv: SUCCESS (0.102s) [277.268835] Subtest all-tests: SUCCESS (9.686s) [277.333961] [056/133] (749s left) syncobj_timeline (reset-unsignaled) [277.383979] Starting subtest: reset-unsignaled [277.386296] Subtest reset-unsignaled: SUCCESS (0.000s) [277.475702] [057/133] (749s left) syncobj_wait (multi-wait-signaled) [277.526851] Starting subtest: multi-wait-signaled [277.529127] Subtest multi-wait-signaled: SUCCESS (0.000s) [277.637296] [058/133] (749s left) kms_flip (2x-flip-vs-absolute-wf_vblank) [277.745262] Starting subtest: 2x-flip-vs-absolute-wf_vblank [277.754407] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s) [277.844650] [059/133] (749s left) kms_psr (pr-cursor-mmap-cpu) [277.939237] Starting subtest: pr-cursor-mmap-cpu [277.943631] Subtest pr-cursor-mmap-cpu: SKIP (0.000s) [278.013129] [060/133] (749s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled) [278.080264] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled [278.184533] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.104s) [278.260942] [061/133] (748s left) kms_atomic_transition (modeset-transition-fencing) [278.352927] Starting subtest: modeset-transition-fencing [278.354968] Starting dynamic subtest: 1x-outputs [289.228305] Dynamic subtest 1x-outputs: SUCCESS (10.875s) [289.230893] Subtest modeset-transition-fencing: SUCCESS (10.877s) [290.086337] [062/133] (737s left) kms_psr (fbc-psr2-cursor-plane-onoff) [290.179076] Starting subtest: fbc-psr2-cursor-plane-onoff [290.180975] Starting dynamic subtest: eDP-1 [290.185106] Dynamic subtest eDP-1: SKIP (0.000s) [290.189300] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s) [290.265456] [063/133] (736s left) i915_hangman (error-state-basic) [290.334714] Starting subtest: error-state-basic [290.472009] Subtest error-state-basic: SUCCESS (0.137s) [290.555184] [064/133] (736s left) gem_tiled_fence_blits (basic) [290.610985] Subtest basic: SKIP (0.000s) [290.679949] [065/133] (736s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu) [290.773346] Starting subtest: fbc-rgb565-draw-mmap-cpu [294.813055] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.042s) [295.993385] [066/133] (731s left) gem_gpgpu_fill (offset-16x16) [296.057788] Starting subtest: offset-16x16 [296.063652] Subtest offset-16x16: SUCCESS (0.008s) [296.209377] [067/133] (731s left) perf_pmu (all-busy-check-all) [296.245409] Starting subtest: all-busy-check-all [297.876440] Subtest all-busy-check-all: SUCCESS (1.630s) [297.977328] [068/133] (729s left) gen9_exec_parse (unaligned-jump) [298.042324] Subtest unaligned-jump: SKIP (0.000s) [298.129883] [069/133] (729s left) i915_pm_rpm (system-suspend-execbuf) [300.048053] Starting subtest: system-suspend-execbuf [358.458202] Subtest system-suspend-execbuf: SUCCESS (43.026s) [358.849939] [070/133] (668s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt) [358.946190] Starting subtest: fbc-farfromfence-mmap-gtt [358.950500] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s) [359.042040] [071/133] (668s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render) [359.137191] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render [359.141345] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [359.231107] [072/133] (668s left) kms_psr (psr2-sprite-render) [359.330873] Starting subtest: psr2-sprite-render [359.333039] Starting dynamic subtest: eDP-1 [361.038027] Dynamic subtest eDP-1: SUCCESS (1.704s) [361.039965] Subtest psr2-sprite-render: SUCCESS (1.705s) [361.903408] [073/133] (665s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs) [362.020484] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs [362.022839] Starting dynamic subtest: pipe-A-eDP-1 [362.043537] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [362.054526] Starting dynamic subtest: pipe-B-eDP-1 [362.074312] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [362.083408] Starting dynamic subtest: pipe-C-eDP-1 [362.102873] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [362.112168] Starting dynamic subtest: pipe-D-eDP-1 [362.131331] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [362.133561] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.006s) [364.166887] [074/133] (663s left) perf_pmu (idle-no-semaphores) [364.209418] Starting subtest: idle-no-semaphores [364.211762] Starting dynamic subtest: rcs0 [364.728699] Dynamic subtest rcs0: SUCCESS (0.519s) [364.744379] Starting dynamic subtest: bcs0 [365.242759] Dynamic subtest bcs0: SUCCESS (0.511s) [365.254391] Starting dynamic subtest: vcs0 [365.761956] Dynamic subtest vcs0: SUCCESS (0.516s) [365.774507] Starting dynamic subtest: vcs1 [366.278583] Dynamic subtest vcs1: SUCCESS (0.514s) [366.292117] Starting dynamic subtest: vecs0 [366.797632] Dynamic subtest vecs0: SUCCESS (0.514s) [366.817232] Starting dynamic subtest: ccs0 [367.322615] Dynamic subtest ccs0: SUCCESS (0.521s) [367.325800] Subtest idle-no-semaphores: SUCCESS (3.115s) [367.440121] [075/133] (660s left) gem_exec_fence (syncobj-timeline-signal) [367.991510] Starting subtest: syncobj-timeline-signal [368.005521] Subtest syncobj-timeline-signal: SUCCESS (0.016s) [369.392207] [076/133] (658s left) kms_plane_multiple (tiling-yf) [369.493821] Starting subtest: tiling-yf [369.497977] Subtest tiling-yf: SKIP (0.000s) [369.569337] [077/133] (658s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format) [369.683046] Starting subtest: plane-upscale-factor-0-25-with-pixel-format [369.685453] Starting dynamic subtest: pipe-A [370.731468] Dynamic subtest pipe-A: SUCCESS (1.050s) [370.746891] Starting dynamic subtest: pipe-B [372.864898] Dynamic subtest pipe-B: SUCCESS (2.132s) [372.874228] Starting dynamic subtest: pipe-C [374.071012] Dynamic subtest pipe-C: SUCCESS (1.205s) [374.081227] Starting dynamic subtest: pipe-D [375.303872] Dynamic subtest pipe-D: SUCCESS (1.231s) [375.306127] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.624s) [376.490481] [078/133] (651s left) kms_flip (flip-vs-expired-vblank) [376.597996] Starting subtest: flip-vs-expired-vblank [376.600375] Starting dynamic subtest: A-eDP1 [385.286760] Dynamic subtest A-eDP1: SUCCESS (8.687s) [385.295862] Starting dynamic subtest: B-eDP1 [394.024220] Dynamic subtest B-eDP1: SUCCESS (8.736s) [394.036223] Starting dynamic subtest: C-eDP1 [402.651949] Dynamic subtest C-eDP1: SUCCESS (8.624s) [402.671269] Starting dynamic subtest: D-eDP1 [411.285120] Dynamic subtest D-eDP1: SUCCESS (8.630s) [411.290483] Subtest flip-vs-expired-vblank: SUCCESS (34.689s) [412.455317] [079/133] (615s left) syncobj_timeline (single-wait-for-submit-available-signaled) [412.519387] Starting subtest: single-wait-for-submit-available-signaled [412.521755] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s) [412.615675] [080/133] (615s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [412.713727] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [413.504679] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.792s) [413.659428] [081/133] (614s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite) [413.760533] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite [423.119910] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.361s) [423.249203] [082/133] (604s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc) [423.345870] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc [423.348196] Starting dynamic subtest: pipe-A-eDP-1 [423.368598] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [423.383890] Starting dynamic subtest: pipe-B-eDP-1 [423.403290] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [423.415579] Starting dynamic subtest: pipe-C-eDP-1 [423.434903] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [423.443768] Starting dynamic subtest: pipe-D-eDP-1 [423.464175] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [423.466162] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s) [425.668392] [083/133] (602s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw) [425.757417] Starting subtest: fbc-2p-pri-indfb-multidraw [425.761606] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s) [425.879958] [084/133] (602s left) gem_render_tiled_blits (basic) [425.940819] Subtest basic: SKIP (0.000s) [426.019688] [085/133] (602s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [426.111915] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [426.114224] Starting dynamic subtest: pipe-A-eDP-1 [426.137640] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [426.149239] Starting dynamic subtest: pipe-B-eDP-1 [426.171141] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [426.180200] Starting dynamic subtest: pipe-C-eDP-1 [426.202011] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [426.210947] Starting dynamic subtest: pipe-D-eDP-1 [426.232954] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [426.236993] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s) [428.444755] [086/133] (599s left) kms_vblank (ts-continuation-dpms-rpm) [428.533824] Starting subtest: ts-continuation-dpms-rpm [428.535943] Starting dynamic subtest: pipe-A-eDP-1 [431.027143] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.493s) [431.050952] Starting dynamic subtest: pipe-D-eDP-1 [433.279537] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.248s) [433.281927] Subtest ts-continuation-dpms-rpm: SUCCESS (4.746s) [434.091102] [087/133] (594s left) gem_exec_whisper (basic-fds-priority) [434.155563] Starting subtest: basic-fds-priority [458.205493] Subtest basic-fds-priority: SUCCESS (24.048s) [458.393745] [088/133] (569s left) kms_pm_rpm (legacy-planes-dpms) [460.424526] Starting subtest: legacy-planes-dpms [460.429020] Starting dynamic subtest: plane-64 [468.724493] Dynamic subtest plane-64: SUCCESS (8.299s) [468.737199] Starting dynamic subtest: plane-94 [477.164790] Dynamic subtest plane-94: SUCCESS (8.437s) [477.177305] Starting dynamic subtest: plane-124 [485.591425] Dynamic subtest plane-124: SUCCESS (8.423s) [485.604509] Starting dynamic subtest: plane-134 [494.290977] Dynamic subtest plane-134: SUCCESS (8.696s) [494.293680] Subtest legacy-planes-dpms: SUCCESS (33.866s) [494.658210] [089/133] (533s left) intel_hwmon (hwmon-write) [494.719125] Subtest hwmon-write: SKIP (0.000s) [494.781731] [090/133] (533s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite) [494.875515] Starting subtest: fbcpsr-rgb101010-draw-pwrite [501.865105] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (6.992s) [501.993677] [091/133] (526s left) syncobj_basic (bad-pad-fd-to-handle) [502.060326] Starting subtest: bad-pad-fd-to-handle [502.062690] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [502.174468] [092/133] (526s left) gen9_exec_parse (bb-chained) [502.222112] Subtest bb-chained: SKIP (0.000s) [502.289501] [093/133] (526s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt) [502.382768] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt [509.789018] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.409s) [509.930320] [094/133] (518s left) gem_exec_params (rel-constants-invalid-ring) [509.983223] Starting subtest: rel-constants-invalid-ring [509.985621] Subtest rel-constants-invalid-ring: SUCCESS (0.000s) [510.086765] [095/133] (518s left) gem_workarounds (suspend-resume-fd) [510.167535] Starting subtest: suspend-resume-fd [526.620509] Subtest suspend-resume-fd: SUCCESS (1.196s) [526.759019] [096/133] (501s left) kms_color (ctm-signed) [526.862672] Starting subtest: ctm-signed [526.864650] Starting dynamic subtest: pipe-A-eDP-1 [528.957473] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.094s) [528.967097] Starting dynamic subtest: pipe-B-eDP-1 [531.750681] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.788s) [531.763458] Starting dynamic subtest: pipe-C-eDP-1 [534.389598] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.635s) [534.401679] Starting dynamic subtest: pipe-D-eDP-1 [537.039299] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.648s) [537.041475] Subtest ctm-signed: SUCCESS (10.170s) [537.864117] [097/133] (490s left) kms_cursor_crc (cursor-random-256x256) [538.122250] Starting subtest: cursor-random-256x256 [538.127545] Starting dynamic subtest: pipe-A-eDP-1 [541.507742] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.379s) [541.537475] Starting dynamic subtest: pipe-D-eDP-1 [545.486197] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.953s) [545.488356] Subtest cursor-random-256x256: SUCCESS (7.359s) [546.329990] [098/133] (482s left) gem_mmap_gtt (ptrace) [546.398903] Subtest ptrace: SKIP (0.000s) [546.465011] [099/133] (482s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu) [546.573377] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu [550.072489] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.501s) [551.232841] [100/133] (477s left) gem_exec_balancer (parallel-balancer) [551.505202] Starting subtest: parallel-balancer [552.410565] Subtest parallel-balancer: SUCCESS (0.905s) [552.516004] [101/133] (476s left) syncobj_timeline (etime-single-wait-all-submitted) [552.569380] Starting subtest: etime-single-wait-all-submitted [552.670899] Subtest etime-single-wait-all-submitted: SUCCESS (0.102s) [552.761830] [102/133] (476s left) api_intel_bb (crc32) [552.811873] Starting subtest: crc32 [552.813819] Starting dynamic subtest: rcs0-smem0 [553.096820] Dynamic subtest rcs0-smem0: SUCCESS (0.285s) [553.109652] Starting dynamic subtest: bcs0-smem0 [553.406719] Dynamic subtest bcs0-smem0: SUCCESS (0.307s) [553.419245] Starting dynamic subtest: vcs0-smem0 [553.732551] Dynamic subtest vcs0-smem0: SUCCESS (0.324s) [553.745049] Starting dynamic subtest: vcs1-smem0 [554.090690] Dynamic subtest vcs1-smem0: SUCCESS (0.354s) [554.102886] Starting dynamic subtest: vecs0-smem0 [554.468529] Dynamic subtest vecs0-smem0: SUCCESS (0.375s) [554.480606] Starting dynamic subtest: ccs0-smem0 [554.804869] Dynamic subtest ccs0-smem0: SUCCESS (0.334s) [554.807507] Subtest crc32: SUCCESS (1.995s) [554.923795] [103/133] (474s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt) [555.031293] Starting subtest: psr-rgb565-draw-mmap-gtt [555.035407] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s) [555.139626] [104/133] (473s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted) [555.192500] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted [555.296900] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.103s) [555.388209] [105/133] (473s left) gem_exec_reloc (basic-cpu-wc) [555.447757] Subtest basic-cpu-wc: SKIP (0.000s) [555.519216] [106/133] (473s left) api_intel_bb (purge-bb) [555.580124] Starting subtest: purge-bb [555.582533] Subtest purge-bb: SUCCESS (0.004s) [555.716361] [107/133] (473s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers) [555.805458] Starting subtest: plane-scaler-with-clipping-clamping-modifiers [555.807781] Starting dynamic subtest: pipe-A [556.157288] Dynamic subtest pipe-A: SUCCESS (0.352s) [556.167237] Starting dynamic subtest: pipe-B [557.619427] Dynamic subtest pipe-B: SUCCESS (1.460s) [557.635215] Starting dynamic subtest: pipe-C [559.085193] Dynamic subtest pipe-C: SUCCESS (1.463s) [559.097148] Starting dynamic subtest: pipe-D [560.493915] Dynamic subtest pipe-D: SUCCESS (1.407s) [560.496251] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.688s) [561.665063] [108/133] (467s left) gem_mmap_gtt (basic-write-read-distinct) [561.721320] Subtest basic-write-read-distinct: SKIP (0.000s) [561.783692] [109/133] (467s left) kms_feature_discovery (psr1) [561.873290] Starting subtest: psr1 [561.875837] Subtest psr1: SUCCESS (0.000s) [561.946444] [110/133] (467s left) kms_cursor_crc (cursor-tearing-position-change) [562.060429] Starting subtest: cursor-tearing-position-change [562.062793] Starting dynamic subtest: pipe-A-eDP-1 [562.629906] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.566s) [562.640305] Starting dynamic subtest: pipe-D-eDP-1 [563.888905] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.260s) [563.891212] Subtest cursor-tearing-position-change: SUCCESS (1.829s) [564.728513] [111/133] (464s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt) [564.839088] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt [564.843134] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [564.945852] [112/133] (464s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [565.037686] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [565.041696] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s) [565.109814] [113/133] (464s left) gem_bad_reloc (negative-reloc) [565.173134] Subtest negative-reloc: SKIP (0.000s) [565.261419] [114/133] (464s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180) [565.355469] Starting subtest: primary-yf-tiled-reflect-x-180 [565.415399] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s) [565.517802] [115/133] (463s left) drm_read (empty-block) [565.657590] Starting subtest: empty-block [566.659267] Subtest empty-block: SUCCESS (1.001s) [566.808939] [116/133] (462s left) gem_render_copy (yf-tiled-to-vebox-linear) [566.869032] Starting subtest: yf-tiled-to-vebox-linear [566.873442] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s) [567.065672] [117/133] (462s left) kms_pm_rpm (dpms-lpsp) [568.698942] Starting subtest: dpms-lpsp [569.299678] Subtest dpms-lpsp: SUCCESS (0.605s) [569.388473] [118/133] (460s left) kms_cursor_legacy (forked-move) [569.516394] Starting subtest: forked-move [569.518781] Starting dynamic subtest: pipe-A [574.964867] Dynamic subtest pipe-A: SUCCESS (5.445s) [574.977440] Starting dynamic subtest: pipe-B [580.438233] Dynamic subtest pipe-B: SUCCESS (5.471s) [580.449200] Starting dynamic subtest: pipe-C [585.923310] Dynamic subtest pipe-C: SUCCESS (5.481s) [585.935631] Starting dynamic subtest: pipe-D [591.391108] Dynamic subtest pipe-D: SUCCESS (5.464s) [591.402823] Starting dynamic subtest: all-pipes [596.896884] Dynamic subtest all-pipes: SUCCESS (5.503s) [596.899418] Subtest forked-move: SUCCESS (27.377s) [597.046812] [119/133] (432s left) kms_psr_stress_test (flip-primary-invalidate-overlay) [597.140981] Starting subtest: flip-primary-invalidate-overlay [608.812180] Subtest flip-primary-invalidate-overlay: SUCCESS (11.672s) [608.954443] [120/133] (420s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [609.056030] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt [609.059481] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [609.174868] [121/133] (420s left) kms_content_protection (srm) [609.304563] Starting subtest: srm [609.311080] Subtest srm: SKIP (0.002s) [609.415085] [122/133] (420s left) prime_busy (after-wait) [609.473955] Starting subtest: after-wait [609.478787] Starting dynamic subtest: rcs0 [609.505237] Dynamic subtest rcs0: SUCCESS (0.028s) [609.515730] Starting dynamic subtest: bcs0 [609.560394] Dynamic subtest bcs0: SUCCESS (0.054s) [609.572900] Starting dynamic subtest: vcs0 [609.601439] Dynamic subtest vcs0: SUCCESS (0.039s) [609.610804] Starting dynamic subtest: vcs1 [609.642473] Dynamic subtest vcs1: SUCCESS (0.040s) [609.652048] Starting dynamic subtest: vecs0 [609.683851] Dynamic subtest vecs0: SUCCESS (0.040s) [609.693442] Starting dynamic subtest: ccs0 [609.725666] Dynamic subtest ccs0: SUCCESS (0.040s) [609.836176] Subtest after-wait: SUCCESS (0.360s) [609.913234] [123/133] (419s left) kms_pipe_crc_basic (disable-crc-after-crtc) [610.009826] Starting subtest: disable-crc-after-crtc [610.011740] Starting dynamic subtest: pipe-A-eDP-1 [611.712962] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.702s) [611.723148] Starting dynamic subtest: pipe-B-eDP-1 [613.954916] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.241s) [613.967862] Starting dynamic subtest: pipe-C-eDP-1 [616.218601] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.263s) [616.228687] Starting dynamic subtest: pipe-D-eDP-1 [618.488933] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.269s) [618.491175] Subtest disable-crc-after-crtc: SUCCESS (8.480s) [619.312364] [124/133] (410s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [619.422805] Starting subtest: psr2-overlay-primary-update-sf-dmg-area [619.425132] Starting dynamic subtest: pipe-A-eDP-1 [625.282100] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.864s) [625.293026] Starting dynamic subtest: pipe-B-eDP-1 [631.952273] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.667s) [631.954671] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.535s) [632.828892] [125/133] (397s left) kms_universal_plane (universal-plane-sanity) [632.925797] Starting subtest: universal-plane-sanity [632.927837] Starting dynamic subtest: pipe-A-eDP-1 [633.520353] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.596s) [633.530020] Starting dynamic subtest: pipe-B-eDP-1 [634.755916] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.233s) [634.766679] Starting dynamic subtest: pipe-C-eDP-1 [635.953528] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.196s) [635.964046] Starting dynamic subtest: pipe-D-eDP-1 [637.187695] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.232s) [637.190272] Subtest universal-plane-sanity: SUCCESS (4.263s) [638.045721] [126/133] (391s left) kms_invalid_mode (clock-too-high) [638.149751] Starting subtest: clock-too-high [638.152014] Starting dynamic subtest: pipe-A-eDP-1 [638.156214] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [638.166727] Starting dynamic subtest: pipe-B-eDP-1 [638.170649] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [638.182829] Starting dynamic subtest: pipe-C-eDP-1 [638.187127] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [638.196940] Starting dynamic subtest: pipe-D-eDP-1 [638.201275] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [638.205643] Subtest clock-too-high: SKIP (0.005s) [638.243347] [127/133] (391s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf) [638.333988] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf [638.337929] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [638.404257] [128/133] (391s left) gem_eio (wait-immediate) [638.626245] Starting subtest: wait-immediate [638.992936] Subtest wait-immediate: SUCCESS (0.368s) [639.107475] [129/133] (390s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt) [639.201817] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt [639.205490] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [639.317984] [130/133] (390s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted) [639.372273] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted [639.480153] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.107s) [639.574282] [131/133] (390s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt) [639.671178] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt [646.948061] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.288s) [647.074664] [132/133] (383s left) i915_suspend (basic-s2idle-without-i915) [647.110762] Starting subtest: basic-s2idle-without-i915 [668.092748] Subtest basic-s2idle-without-i915: SUCCESS (5.629s) [668.196351] [133/133] (362s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [668.309478] Starting subtest: fbc-rgb565-draw-blt [672.528984] Subtest fbc-rgb565-draw-blt: SUCCESS (4.214s) [673.727180] Closing watchdogs results: parsing output: 0/ for test: kms_cursor_legacy results: parsing output: 1/ for test: kms_hdr results: parsing output: 2/ for test: gem_sync results: parsing output: 3/ for test: gem_ctx_persistence results: parsing output: 4/ for test: gem_ctx_shared results: parsing output: 5/ for test: kms_chamelium_hpd results: parsing output: 6/ for test: kms_cursor_legacy results: parsing output: 7/ for test: gem_pread results: parsing output: 8/ for test: kms_big_fb results: parsing output: 9/ for test: gen3_render_tiledy_blits results: parsing output: 10/ for test: kms_flip_scaled_crc results: parsing output: 11/ for test: gem_mmap_gtt results: parsing output: 12/ for test: kms_flip results: parsing output: 13/ for test: kms_atomic_transition results: parsing output: 14/ for test: gem_softpin results: parsing output: 15/ for test: kms_big_fb results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: gem_create results: parsing output: 18/ for test: kms_big_fb results: parsing output: 19/ for test: kms_chamelium_color results: parsing output: 20/ for test: gem_render_copy results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: kms_big_fb results: parsing output: 23/ for test: gem_userptr_blits results: parsing output: 24/ for test: syncobj_timeline results: parsing output: 25/ for test: gem_exec_schedule results: parsing output: 26/ for test: kms_lease results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: kms_cursor_crc results: parsing output: 30/ for test: kms_vrr results: parsing output: 31/ for test: kms_big_fb results: parsing output: 32/ for test: gem_wait results: parsing output: 33/ for test: gem_exec_fence results: parsing output: 34/ for test: gem_tiled_wc results: parsing output: 35/ for test: kms_plane results: parsing output: 36/ for test: gem_exec_fence results: parsing output: 37/ for test: kms_ccs results: parsing output: 38/ for test: vgem_basic results: parsing output: 39/ for test: gem_exec_reloc results: parsing output: 40/ for test: kms_chamelium_edid results: parsing output: 41/ for test: gem_exec_reloc results: parsing output: 42/ for test: gem_readwrite results: parsing output: 43/ for test: gem_exec_reloc results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: gem_pxp results: parsing output: 46/ for test: kms_psr results: parsing output: 47/ for test: kms_cursor_legacy results: parsing output: 48/ for test: kms_big_fb results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: gem_exec_schedule results: parsing output: 51/ for test: gem_lmem_swapping results: parsing output: 52/ for test: gem_ctx_isolation results: parsing output: 53/ for test: kms_psr2_sf results: parsing output: 54/ for test: dmabuf results: parsing output: 55/ for test: syncobj_timeline results: parsing output: 56/ for test: syncobj_wait results: parsing output: 57/ for test: kms_flip results: parsing output: 58/ for test: kms_psr results: parsing output: 59/ for test: syncobj_wait results: parsing output: 60/ for test: kms_atomic_transition results: parsing output: 61/ for test: kms_psr results: parsing output: 62/ for test: i915_hangman results: parsing output: 63/ for test: gem_tiled_fence_blits results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: gem_gpgpu_fill results: parsing output: 66/ for test: perf_pmu results: parsing output: 67/ for test: gen9_exec_parse results: parsing output: 68/ for test: i915_pm_rpm results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: kms_psr results: parsing output: 72/ for test: kms_ccs results: parsing output: 73/ for test: perf_pmu results: parsing output: 74/ for test: gem_exec_fence results: parsing output: 75/ for test: kms_plane_multiple results: parsing output: 76/ for test: kms_plane_scaling results: parsing output: 77/ for test: kms_flip results: parsing output: 78/ for test: syncobj_timeline results: parsing output: 79/ for test: kms_big_fb results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: kms_ccs results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: gem_render_tiled_blits results: parsing output: 84/ for test: kms_ccs results: parsing output: 85/ for test: kms_vblank results: parsing output: 86/ for test: gem_exec_whisper results: parsing output: 87/ for test: kms_pm_rpm results: parsing output: 88/ for test: intel_hwmon results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: syncobj_basic results: parsing output: 91/ for test: gen9_exec_parse results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: gem_exec_params results: parsing output: 94/ for test: gem_workarounds results: parsing output: 95/ for test: kms_color results: parsing output: 96/ for test: kms_cursor_crc results: parsing output: 97/ for test: gem_mmap_gtt results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: gem_exec_balancer results: parsing output: 100/ for test: syncobj_timeline results: parsing output: 101/ for test: api_intel_bb results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: syncobj_wait results: parsing output: 104/ for test: gem_exec_reloc results: parsing output: 105/ for test: api_intel_bb results: parsing output: 106/ for test: kms_plane_scaling results: parsing output: 107/ for test: gem_mmap_gtt results: parsing output: 108/ for test: kms_feature_discovery results: parsing output: 109/ for test: kms_cursor_crc results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: kms_flip_scaled_crc results: parsing output: 112/ for test: gem_bad_reloc results: parsing output: 113/ for test: kms_rotation_crc results: parsing output: 114/ for test: drm_read results: parsing output: 115/ for test: gem_render_copy results: parsing output: 116/ for test: kms_pm_rpm results: parsing output: 117/ for test: kms_cursor_legacy results: parsing output: 118/ for test: kms_psr_stress_test results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: kms_content_protection results: parsing output: 121/ for test: prime_busy results: parsing output: 122/ for test: kms_pipe_crc_basic results: parsing output: 123/ for test: kms_psr2_sf results: parsing output: 124/ for test: kms_universal_plane results: parsing output: 125/ for test: kms_invalid_mode results: parsing output: 126/ for test: kms_psr2_sf results: parsing output: 127/ for test: gem_eio results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: syncobj_timeline results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: i915_suspend results: parsing output: 132/ for test: kms_frontbuffer_tracking Done.