[59.286732] Initializing watchdogs [59.286778] /dev/watchdog0 [59.300335] [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] [59.304551] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.306782] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.310227] [001/133] (960s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size) [59.465870] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size [60.482657] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (1.009s) [61.349201] [002/133] (958s left) kms_hdr (brightness-with-hdr) [61.435938] Starting subtest: brightness-with-hdr [61.442189] Subtest brightness-with-hdr: SKIP (0.000s) [61.504471] [003/133] (958s left) gem_sync (basic-store-all) [61.573117] Starting subtest: basic-store-all [63.919367] Subtest basic-store-all: SUCCESS (2.345s) [64.109711] [004/133] (955s left) gem_ctx_persistence (heartbeat-stop) [64.174642] Starting subtest: heartbeat-stop [64.179138] Subtest heartbeat-stop: SKIP (0.000s) [64.264583] [005/133] (955s left) gem_ctx_shared (q-smoketest) [64.332072] Starting subtest: Q-smoketest [64.335292] Starting dynamic subtest: rcs0 [69.894747] Dynamic subtest rcs0: SUCCESS (5.496s) [69.903293] Starting dynamic subtest: bcs0 [75.413591] Dynamic subtest bcs0: SUCCESS (5.516s) [75.422051] Starting dynamic subtest: vcs0 [80.886094] Dynamic subtest vcs0: SUCCESS (5.463s) [80.894122] Starting dynamic subtest: vcs1 [86.368871] Dynamic subtest vcs1: SUCCESS (5.477s) [86.377653] Starting dynamic subtest: vecs0 [91.872158] Dynamic subtest vecs0: SUCCESS (5.495s) [91.882232] Starting dynamic subtest: ccs0 [97.366394] Dynamic subtest ccs0: SUCCESS (5.492s) [97.368677] Subtest Q-smoketest: SUCCESS (32.943s) [97.503181] [006/133] (922s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode) [97.904602] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s) [98.709967] [007/133] (921s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions) [98.831549] Starting subtest: cursorA-vs-flipA-atomic-transitions [110.004653] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.170s) [110.888539] [008/133] (909s left) gem_pread (display) [110.954538] Subtest display: SKIP (0.000s) [111.015931] [009/133] (909s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180) [111.122100] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180 [112.112425] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (0.990s) [112.243047] [010/133] (907s left) gen3_render_tiledy_blits [112.369714] [011/133] (907s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [112.456377] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [112.458293] Starting dynamic subtest: pipe-A-default-mode [113.637680] Dynamic subtest pipe-A-default-mode: SKIP (1.179s) [113.642130] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.180s) [113.793052] [012/133] (906s left) gem_mmap_gtt (big-bo-tiledy) [113.850268] Subtest big-bo-tiledY: SKIP (0.000s) [113.911182] [013/133] (906s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible) [114.010995] Starting subtest: flip-vs-absolute-wf_vblank-interruptible [114.013397] Starting dynamic subtest: A-eDP1 [122.950734] Dynamic subtest A-eDP1: SUCCESS (8.938s) [122.961739] Starting dynamic subtest: B-eDP1 [131.876563] Dynamic subtest B-eDP1: SUCCESS (8.922s) [131.885496] Starting dynamic subtest: C-eDP1 [140.797734] Dynamic subtest C-eDP1: SUCCESS (8.918s) [140.807844] Starting dynamic subtest: D-eDP1 [149.637183] Dynamic subtest D-eDP1: SUCCESS (8.839s) [149.642027] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.629s) [150.857322] [014/133] (869s left) kms_atomic_transition (plane-all-transition-nonblocking) [150.941450] Starting subtest: plane-all-transition-nonblocking [150.943672] Starting dynamic subtest: pipe-A-eDP-1 [153.435098] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s) [153.747647] Starting dynamic subtest: pipe-B-eDP-1 [156.999917] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.261s) [157.316790] Subtest plane-all-transition-nonblocking: SUCCESS (6.375s) [158.140815] [015/133] (862s left) gem_softpin (allocator-fork) [158.209331] Starting subtest: allocator-fork [160.417397] Subtest allocator-fork: SUCCESS (2.209s) [160.545545] [016/133] (859s left) kms_big_fb (x-tiled-8bpp-rotate-180) [160.639671] Starting subtest: x-tiled-8bpp-rotate-180 [161.855306] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.217s) [161.949727] [017/133] (858s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render) [162.044405] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render [162.047884] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [162.140316] [018/133] (858s left) gem_create (create-clear) [162.189778] Starting subtest: create-clear [162.192201] Starting dynamic subtest: smem0 [195.080051] Dynamic subtest smem0: SUCCESS (32.886s) [195.082351] Subtest create-clear: SUCCESS (32.887s) [195.276981] [019/133] (825s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180) [195.385210] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180 [195.389667] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [195.476163] [020/133] (825s left) kms_chamelium_color (ctm-max) [195.573660] Subtest ctm-max: SKIP (0.000s) [195.619387] [021/133] (824s left) gem_render_copy (yf-tiled-ccs-to-linear) [195.670811] Starting subtest: yf-tiled-ccs-to-linear [195.674989] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s) [195.861871] [022/133] (824s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary) [195.966731] Starting subtest: fbc-shrfb-scaledprimary [198.892250] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.929s) [200.046549] [023/133] (820s left) kms_big_fb (y-tiled-64bpp-rotate-180) [200.155271] Starting subtest: y-tiled-64bpp-rotate-180 [200.159568] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s) [200.291606] [024/133] (820s left) gem_userptr_blits (unsync-overlap) [200.361601] Subtest unsync-overlap: SKIP (0.000s) [200.490545] [025/133] (820s left) syncobj_timeline (invalid-signal-illegal-handle) [200.544609] Starting subtest: invalid-signal-illegal-handle [200.546855] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [200.629057] [026/133] (820s left) gem_exec_schedule (timeslicing) [200.696257] Starting subtest: timeslicing [200.698266] Starting dynamic subtest: rcs0 [200.705407] Dynamic subtest rcs0: SUCCESS (0.021s) [200.715708] Starting dynamic subtest: bcs0 [200.726650] Dynamic subtest bcs0: SUCCESS (0.021s) [200.734335] Starting dynamic subtest: vcs0 [200.747110] Dynamic subtest vcs0: SUCCESS (0.020s) [200.754590] Starting dynamic subtest: vcs1 [200.767054] Dynamic subtest vcs1: SUCCESS (0.019s) [200.774631] Starting dynamic subtest: vecs0 [200.787581] Dynamic subtest vecs0: SUCCESS (0.020s) [200.794916] Starting dynamic subtest: ccs0 [200.807630] Dynamic subtest ccs0: SUCCESS (0.019s) [200.809848] Subtest timeslicing: SUCCESS (0.124s) [201.928097] [027/133] (818s left) kms_lease (lease-unleased-crtc) [202.015094] Starting subtest: lease-unleased-crtc [202.017323] Starting dynamic subtest: pipe-A-eDP-1 [202.304196] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s) [202.312150] Starting dynamic subtest: pipe-B-eDP-1 [203.081808] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.775s) [203.090316] Starting dynamic subtest: pipe-C-eDP-1 [203.092521] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.005s) [203.100391] Starting dynamic subtest: pipe-D-eDP-1 [203.102284] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s) [203.104151] Subtest lease-unleased-crtc: SUCCESS (1.083s) [203.459388] [028/133] (817s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt) [203.568606] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt [210.446422] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.881s) [210.604182] [029/133] (810s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [210.720922] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu [210.725542] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [210.818073] [030/133] (810s left) kms_cursor_crc (cursor-offscreen-64x21) [211.033854] Starting subtest: cursor-offscreen-64x21 [211.079823] Subtest cursor-offscreen-64x21: SKIP (0.044s) [211.310488] [031/133] (809s left) kms_vrr (negative-basic) [211.386905] Starting subtest: negative-basic [211.392467] Starting dynamic subtest: pipe-A-eDP-1 [216.825560] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.428s) [217.102276] Subtest negative-basic: SUCCESS (5.712s) [217.943909] [032/133] (803s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180) [218.034859] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180 [218.039189] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s) [218.123712] [033/133] (802s left) gem_wait (write-wait) [218.188351] Starting subtest: write-wait [218.190744] Starting dynamic subtest: all-engines [219.363084] Dynamic subtest all-engines: SUCCESS (1.174s) [219.378956] Starting dynamic subtest: rcs0 [220.418296] Dynamic subtest rcs0: SUCCESS (1.053s) [220.434558] Starting dynamic subtest: bcs0 [221.474810] Dynamic subtest bcs0: SUCCESS (1.055s) [221.490307] Starting dynamic subtest: vcs0 [222.529241] Dynamic subtest vcs0: SUCCESS (1.052s) [222.543826] Starting dynamic subtest: vcs1 [223.582414] Dynamic subtest vcs1: SUCCESS (1.051s) [223.596917] Starting dynamic subtest: vecs0 [224.635661] Dynamic subtest vecs0: SUCCESS (1.051s) [224.650998] Starting dynamic subtest: ccs0 [225.693569] Dynamic subtest ccs0: SUCCESS (1.055s) [225.696255] Subtest write-wait: SUCCESS (7.505s) [225.889267] [FACT gem_wait (write-wait)] new: kernel.kmod_is_loaded.vgem: true [225.892940] [034/133] (795s left) gem_exec_fence (basic-busy) [226.068749] Starting subtest: basic-busy [226.071375] Starting dynamic subtest: rcs0 [226.166615] Dynamic subtest rcs0: SUCCESS (0.097s) [226.176339] Starting dynamic subtest: bcs0 [226.232936] Dynamic subtest bcs0: SUCCESS (0.065s) [226.242529] Starting dynamic subtest: vcs0 [226.294888] Dynamic subtest vcs0: SUCCESS (0.060s) [226.304355] Starting dynamic subtest: vcs1 [226.358548] Dynamic subtest vcs1: SUCCESS (0.062s) [226.368413] Starting dynamic subtest: vecs0 [226.423855] Dynamic subtest vecs0: SUCCESS (0.063s) [226.433394] Starting dynamic subtest: ccs0 [226.488575] Dynamic subtest ccs0: SUCCESS (0.062s) [226.491023] Subtest basic-busy: SUCCESS (0.421s) [228.001937] [035/133] (793s left) gem_tiled_wc [228.118659] [036/133] (793s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping) [228.205933] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping [228.210086] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s) [228.274443] [037/133] (792s left) gem_exec_fence (submit) [228.442272] Starting subtest: submit [228.447110] Subtest submit: SKIP (0.000s) [229.987202] [038/133] (791s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [230.085489] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [230.087608] Starting dynamic subtest: pipe-A-eDP-1 [230.143688] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [230.152705] Starting dynamic subtest: pipe-B-eDP-1 [230.208521] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [230.217391] Starting dynamic subtest: pipe-C-eDP-1 [230.274318] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [230.283142] Starting dynamic subtest: pipe-D-eDP-1 [230.339052] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [230.343385] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s) [232.318034] [039/133] (789s left) vgem_basic (bad-handle) [232.359873] Starting subtest: bad-handle [232.361854] Subtest bad-handle: SUCCESS (0.000s) [232.418709] [040/133] (788s left) gem_exec_reloc (basic-cpu-wc-active) [232.468198] Subtest basic-cpu-wc-active: SKIP (0.000s) [232.533064] [041/133] (788s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k) [232.925955] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s) [233.722900] [042/133] (787s left) gem_exec_reloc (basic-gtt-cpu-noreloc) [233.786913] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s) [233.853357] [043/133] (787s left) gem_readwrite (new-obj) [233.911177] Subtest new-obj: SKIP (0.000s) [233.969477] [044/133] (787s left) gem_exec_reloc (basic-wc-cpu-active) [234.019910] Subtest basic-wc-cpu-active: SKIP (0.000s) [234.091357] [045/133] (787s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt) [234.183683] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt [241.654347] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.472s) [241.798532] [046/133] (779s left) gem_pxp (fail-invalid-protected-context) [241.926441] Starting subtest: fail-invalid-protected-context [241.928815] Subtest fail-invalid-protected-context: SUCCESS (0.000s) [242.039274] [047/133] (779s left) kms_psr (fbc-psr-primary-page-flip) [242.129442] Starting subtest: fbc-psr-primary-page-flip [242.131659] Starting dynamic subtest: eDP-1 [242.135836] Dynamic subtest eDP-1: SKIP (0.000s) [242.139646] Subtest fbc-psr-primary-page-flip: SKIP (0.002s) [242.206084] [048/133] (779s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions) [242.323269] Starting subtest: short-flip-before-cursor-atomic-transitions [243.262048] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.938s) [244.101748] [049/133] (777s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [244.220149] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [244.857532] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.638s) [245.006199] [050/133] (776s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [245.101282] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc [245.105600] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [245.218990] [051/133] (776s left) gem_exec_schedule (noreorder-priority) [245.401748] Starting subtest: noreorder-priority [245.403907] Starting dynamic subtest: rcs0 [246.528772] Dynamic subtest rcs0: SUCCESS (1.128s) [246.538810] Starting dynamic subtest: vcs0 [247.893496] Dynamic subtest vcs0: SUCCESS (1.361s) [247.904074] Starting dynamic subtest: vcs1 [249.873485] Dynamic subtest vcs1: SUCCESS (1.978s) [249.884350] Starting dynamic subtest: vecs0 [251.922582] Dynamic subtest vecs0: SUCCESS (2.047s) [251.935617] Starting dynamic subtest: ccs0 [253.066041] Dynamic subtest ccs0: SUCCESS (1.142s) [253.068717] Subtest noreorder-priority: SUCCESS (7.666s) [253.266382] [052/133] (768s left) gem_lmem_swapping (verify-ccs) [253.314444] Subtest verify-ccs: SKIP (0.000s) [253.356843] [053/133] (768s left) gem_ctx_isolation (dirty-create) [253.413768] Starting subtest: dirty-create [253.416535] Starting dynamic subtest: rcs0 [253.672616] Dynamic subtest rcs0: SUCCESS (0.259s) [253.682969] Starting dynamic subtest: bcs0 [253.941856] Dynamic subtest bcs0: SUCCESS (0.268s) [253.953155] Starting dynamic subtest: vcs0 [254.181025] Dynamic subtest vcs0: SUCCESS (0.238s) [254.189084] Starting dynamic subtest: vcs1 [256.093099] Dynamic subtest vcs1: SUCCESS (1.911s) [256.102508] Starting dynamic subtest: vecs0 [258.179474] Dynamic subtest vecs0: SUCCESS (2.085s) [258.187588] Starting dynamic subtest: ccs0 [260.141220] Dynamic subtest ccs0: SUCCESS (1.961s) [260.143694] Subtest dirty-create: SUCCESS (6.727s) [260.388783] [054/133] (761s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area) [260.507797] Starting subtest: fbc-pr-plane-move-sf-dmg-area [260.511752] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s) [260.576310] [055/133] (761s left) dmabuf (all-tests) [260.624927] Starting subtest: all-tests [260.627148] Starting dynamic subtest: sanitycheck [260.730507] Dynamic subtest sanitycheck: SUCCESS (0.105s) [260.738883] Starting dynamic subtest: dma_fence [260.926401] Dynamic subtest dma_fence: SUCCESS (0.194s) [260.937476] Starting dynamic subtest: dma_fence_chain [270.250699] Dynamic subtest dma_fence_chain: SUCCESS (9.320s) [270.261726] Starting dynamic subtest: dma_fence_unwrap [270.334307] Dynamic subtest dma_fence_unwrap: SUCCESS (0.082s) [270.349423] Starting dynamic subtest: dma_resv [270.430418] Dynamic subtest dma_resv: SUCCESS (0.094s) [270.433183] Subtest all-tests: SUCCESS (9.807s) [270.492646] [056/133] (751s left) syncobj_timeline (reset-unsignaled) [270.550085] Starting subtest: reset-unsignaled [270.552412] Subtest reset-unsignaled: SUCCESS (0.000s) [270.642697] [057/133] (751s left) syncobj_wait (multi-wait-signaled) [270.703695] Starting subtest: multi-wait-signaled [270.705884] Subtest multi-wait-signaled: SUCCESS (0.000s) [270.819949] [058/133] (751s left) kms_flip (2x-flip-vs-absolute-wf_vblank) [270.912091] Starting subtest: 2x-flip-vs-absolute-wf_vblank [270.923529] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s) [271.003266] [059/133] (751s left) kms_psr (pr-cursor-mmap-cpu) [271.088142] Starting subtest: pr-cursor-mmap-cpu [271.092632] Subtest pr-cursor-mmap-cpu: SKIP (0.000s) [271.158862] [060/133] (750s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled) [271.213103] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled [271.321976] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.108s) [271.397661] [061/133] (750s left) kms_atomic_transition (modeset-transition-fencing) [271.492199] Starting subtest: modeset-transition-fencing [271.494072] Starting dynamic subtest: 1x-outputs [282.350941] Dynamic subtest 1x-outputs: SUCCESS (10.858s) [282.353561] Subtest modeset-transition-fencing: SUCCESS (10.860s) [283.221474] [062/133] (739s left) kms_psr (fbc-psr2-cursor-plane-onoff) [283.327099] Starting subtest: fbc-psr2-cursor-plane-onoff [283.329408] Starting dynamic subtest: eDP-1 [283.333599] Dynamic subtest eDP-1: SKIP (0.000s) [283.337750] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s) [283.401950] [063/133] (738s left) i915_hangman (error-state-basic) [283.481548] Starting subtest: error-state-basic [283.638961] Subtest error-state-basic: SUCCESS (0.159s) [283.710738] [064/133] (738s left) gem_tiled_fence_blits (basic) [283.772587] Subtest basic: SKIP (0.000s) [283.822295] [065/133] (738s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu) [283.925668] Starting subtest: fbc-rgb565-draw-mmap-cpu [287.889448] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (3.967s) [289.020547] [066/133] (733s left) gem_gpgpu_fill (offset-16x16) [289.066137] Starting subtest: offset-16x16 [289.071822] Subtest offset-16x16: SUCCESS (0.008s) [289.202203] [067/133] (733s left) perf_pmu (all-busy-check-all) [289.245540] Starting subtest: all-busy-check-all [290.839236] Subtest all-busy-check-all: SUCCESS (1.594s) [290.934468] [068/133] (731s left) gen9_exec_parse (unaligned-jump) [290.995324] Subtest unaligned-jump: SKIP (0.000s) [291.104414] [069/133] (731s left) i915_pm_rpm (system-suspend-execbuf) [293.037090] Starting subtest: system-suspend-execbuf [357.858740] Subtest system-suspend-execbuf: SUCCESS (49.821s) [358.250709] [070/133] (664s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt) [358.360054] Starting subtest: fbc-farfromfence-mmap-gtt [358.364988] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s) [358.471154] [071/133] (664s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render) [358.567772] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render [358.572353] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [358.662005] [072/133] (664s left) kms_psr (psr2-sprite-render) [358.759085] Starting subtest: psr2-sprite-render [358.761758] Starting dynamic subtest: eDP-1 [360.529563] Dynamic subtest eDP-1: SUCCESS (1.768s) [360.532200] Subtest psr2-sprite-render: SUCCESS (1.770s) [361.395814] [073/133] (661s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs) [361.496345] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs [361.499253] Starting dynamic subtest: pipe-A-eDP-1 [361.523291] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [361.538706] Starting dynamic subtest: pipe-B-eDP-1 [361.562153] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [361.571854] Starting dynamic subtest: pipe-C-eDP-1 [361.595333] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [361.604252] Starting dynamic subtest: pipe-D-eDP-1 [361.628007] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [361.630432] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.005s) [363.672806] [074/133] (659s left) perf_pmu (idle-no-semaphores) [363.725507] Starting subtest: idle-no-semaphores [363.728162] Starting dynamic subtest: rcs0 [364.270647] Dynamic subtest rcs0: SUCCESS (0.546s) [364.283321] Starting dynamic subtest: bcs0 [364.795048] Dynamic subtest bcs0: SUCCESS (0.521s) [364.807462] Starting dynamic subtest: vcs0 [365.316604] Dynamic subtest vcs0: SUCCESS (0.518s) [365.329308] Starting dynamic subtest: vcs1 [365.843233] Dynamic subtest vcs1: SUCCESS (0.523s) [365.855199] Starting dynamic subtest: vecs0 [366.359649] Dynamic subtest vecs0: SUCCESS (0.513s) [366.377229] Starting dynamic subtest: ccs0 [366.877680] Dynamic subtest ccs0: SUCCESS (0.514s) [366.880625] Subtest idle-no-semaphores: SUCCESS (3.155s) [366.996620] [075/133] (655s left) gem_exec_fence (syncobj-timeline-signal) [367.532732] Starting subtest: syncobj-timeline-signal [367.546771] Subtest syncobj-timeline-signal: SUCCESS (0.015s) [368.655434] [076/133] (654s left) kms_plane_multiple (tiling-yf) [368.747114] Starting subtest: tiling-yf [368.751787] Subtest tiling-yf: SKIP (0.000s) [368.824064] [077/133] (654s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format) [368.911082] Starting subtest: plane-upscale-factor-0-25-with-pixel-format [368.913902] Starting dynamic subtest: pipe-A [369.959111] Dynamic subtest pipe-A: SUCCESS (1.050s) [369.968119] Starting dynamic subtest: pipe-B [372.081883] Dynamic subtest pipe-B: SUCCESS (2.121s) [372.090553] Starting dynamic subtest: pipe-C [373.263889] Dynamic subtest pipe-C: SUCCESS (1.179s) [373.275824] Starting dynamic subtest: pipe-D [374.410717] Dynamic subtest pipe-D: SUCCESS (1.143s) [374.413425] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.501s) [375.609570] [078/133] (647s left) kms_flip (flip-vs-expired-vblank) [375.715450] Starting subtest: flip-vs-expired-vblank [375.718317] Starting dynamic subtest: A-eDP1 [384.396827] Dynamic subtest A-eDP1: SUCCESS (8.677s) [384.407121] Starting dynamic subtest: B-eDP1 [393.036245] Dynamic subtest B-eDP1: SUCCESS (8.635s) [393.046545] Starting dynamic subtest: C-eDP1 [401.648351] Dynamic subtest C-eDP1: SUCCESS (8.607s) [401.659294] Starting dynamic subtest: D-eDP1 [410.288507] Dynamic subtest D-eDP1: SUCCESS (8.640s) [410.293581] Subtest flip-vs-expired-vblank: SUCCESS (34.569s) [411.443404] [079/133] (611s left) syncobj_timeline (single-wait-for-submit-available-signaled) [411.507254] Starting subtest: single-wait-for-submit-available-signaled [411.510004] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s) [411.619198] [080/133] (611s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [411.717463] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [412.508335] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.792s) [412.646694] [081/133] (610s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite) [412.750392] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite [422.012152] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.268s) [422.137359] [082/133] (600s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc) [422.231451] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc [422.234130] Starting dynamic subtest: pipe-A-eDP-1 [422.259286] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s) [422.274841] Starting dynamic subtest: pipe-B-eDP-1 [422.297139] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.003s) [422.307075] Starting dynamic subtest: pipe-C-eDP-1 [422.330065] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [422.339325] Starting dynamic subtest: pipe-D-eDP-1 [422.362121] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [422.364353] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.016s) [424.523297] [083/133] (598s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw) [424.627207] Starting subtest: fbc-2p-pri-indfb-multidraw [424.632106] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s) [424.729901] [084/133] (598s left) gem_render_tiled_blits (basic) [424.792207] Subtest basic: SKIP (0.000s) [424.859737] [085/133] (598s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [424.945288] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [424.947730] Starting dynamic subtest: pipe-A-eDP-1 [424.969011] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [424.978737] Starting dynamic subtest: pipe-B-eDP-1 [425.003227] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [425.012346] Starting dynamic subtest: pipe-C-eDP-1 [425.038068] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [425.046740] Starting dynamic subtest: pipe-D-eDP-1 [425.072874] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [425.078089] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s) [427.118603] [086/133] (596s left) kms_vblank (ts-continuation-dpms-rpm) [427.212218] Starting subtest: ts-continuation-dpms-rpm [427.215058] Starting dynamic subtest: pipe-A-eDP-1 [429.700064] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.487s) [429.716313] Starting dynamic subtest: pipe-D-eDP-1 [431.946290] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.246s) [431.949232] Subtest ts-continuation-dpms-rpm: SUCCESS (4.737s) [432.837910] [087/133] (590s left) gem_exec_whisper (basic-fds-priority) [432.905735] Starting subtest: basic-fds-priority [457.396807] Subtest basic-fds-priority: SUCCESS (24.483s) [457.581650] [088/133] (565s left) kms_pm_rpm (legacy-planes-dpms) [459.710727] Starting subtest: legacy-planes-dpms [459.713896] Starting dynamic subtest: plane-64 [468.094632] Dynamic subtest plane-64: SUCCESS (8.382s) [468.106322] Starting dynamic subtest: plane-94 [476.787381] Dynamic subtest plane-94: SUCCESS (8.688s) [476.799183] Starting dynamic subtest: plane-124 [485.103592] Dynamic subtest plane-124: SUCCESS (8.311s) [485.116830] Starting dynamic subtest: plane-134 [493.498210] Dynamic subtest plane-134: SUCCESS (8.390s) [493.501250] Subtest legacy-planes-dpms: SUCCESS (33.782s) [493.881376] [089/133] (529s left) intel_hwmon (hwmon-write) [493.940187] Subtest hwmon-write: SKIP (0.000s) [494.001101] [090/133] (529s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite) [494.099034] Starting subtest: fbcpsr-rgb101010-draw-pwrite [501.062377] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (6.964s) [501.177800] [091/133] (522s left) syncobj_basic (bad-pad-fd-to-handle) [501.229870] Starting subtest: bad-pad-fd-to-handle [501.232578] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [501.324691] [092/133] (522s left) gen9_exec_parse (bb-chained) [501.381871] Subtest bb-chained: SKIP (0.000s) [501.453582] [093/133] (522s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt) [501.558257] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt [508.836768] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.281s) [508.962139] [094/133] (514s left) gem_exec_params (rel-constants-invalid-ring) [509.025763] Starting subtest: rel-constants-invalid-ring [509.028338] Subtest rel-constants-invalid-ring: SUCCESS (0.000s) [509.139636] [095/133] (514s left) gem_workarounds (suspend-resume-fd) [509.206343] Starting subtest: suspend-resume-fd [524.938531] Subtest suspend-resume-fd: SUCCESS (1.167s) [525.099944] [096/133] (498s left) kms_color (ctm-signed) [525.194128] Starting subtest: ctm-signed [525.196217] Starting dynamic subtest: pipe-A-eDP-1 [527.346985] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.088s) [527.358316] Starting dynamic subtest: pipe-B-eDP-1 [530.266322] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.847s) [530.278013] Starting dynamic subtest: pipe-C-eDP-1 [532.952450] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.636s) [532.962396] Starting dynamic subtest: pipe-D-eDP-1 [535.652817] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.668s) [535.655148] Subtest ctm-signed: SUCCESS (10.243s) [536.482162] [097/133] (487s left) kms_cursor_crc (cursor-random-256x256) [536.749377] Starting subtest: cursor-random-256x256 [536.754206] Starting dynamic subtest: pipe-A-eDP-1 [540.164132] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.385s) [540.192544] Starting dynamic subtest: pipe-D-eDP-1 [544.258176] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.052s) [544.260418] Subtest cursor-random-256x256: SUCCESS (7.463s) [545.106627] [098/133] (478s left) gem_mmap_gtt (ptrace) [545.165410] Subtest ptrace: SKIP (0.000s) [545.224636] [099/133] (478s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu) [545.331341] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu [548.915529] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.577s) [550.124682] [100/133] (473s left) gem_exec_balancer (parallel-balancer) [550.377522] Starting subtest: parallel-balancer [551.279803] Subtest parallel-balancer: SUCCESS (0.901s) [551.383085] [101/133] (472s left) syncobj_timeline (etime-single-wait-all-submitted) [551.434044] Starting subtest: etime-single-wait-all-submitted [551.540733] Subtest etime-single-wait-all-submitted: SUCCESS (0.106s) [551.618745] [102/133] (472s left) api_intel_bb (crc32) [551.663425] Starting subtest: crc32 [551.665595] Starting dynamic subtest: rcs0-smem0 [551.957286] Dynamic subtest rcs0-smem0: SUCCESS (0.293s) [551.969307] Starting dynamic subtest: bcs0-smem0 [552.268888] Dynamic subtest bcs0-smem0: SUCCESS (0.308s) [552.280600] Starting dynamic subtest: vcs0-smem0 [552.594443] Dynamic subtest vcs0-smem0: SUCCESS (0.323s) [552.605230] Starting dynamic subtest: vcs1-smem0 [552.971115] Dynamic subtest vcs1-smem0: SUCCESS (0.372s) [552.981924] Starting dynamic subtest: vecs0-smem0 [553.288490] Dynamic subtest vecs0-smem0: SUCCESS (0.315s) [553.299849] Starting dynamic subtest: ccs0-smem0 [553.653856] Dynamic subtest ccs0-smem0: SUCCESS (0.362s) [553.656396] Subtest crc32: SUCCESS (1.989s) [553.785109] [103/133] (470s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt) [553.888032] Starting subtest: psr-rgb565-draw-mmap-gtt [553.892001] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s) [553.991427] [104/133] (470s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted) [554.037438] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted [554.139018] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.102s) [554.215803] [105/133] (469s left) gem_exec_reloc (basic-cpu-wc) [554.283482] Subtest basic-cpu-wc: SKIP (0.000s) [554.411244] [106/133] (469s left) api_intel_bb (purge-bb) [554.470416] Starting subtest: purge-bb [554.472739] Subtest purge-bb: SUCCESS (0.004s) [554.590438] [107/133] (469s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers) [554.683747] Starting subtest: plane-scaler-with-clipping-clamping-modifiers [554.685623] Starting dynamic subtest: pipe-A [555.022278] Dynamic subtest pipe-A: SUCCESS (0.340s) [555.031663] Starting dynamic subtest: pipe-B [556.451618] Dynamic subtest pipe-B: SUCCESS (1.426s) [556.461665] Starting dynamic subtest: pipe-C [557.888241] Dynamic subtest pipe-C: SUCCESS (1.433s) [557.899965] Starting dynamic subtest: pipe-D [559.297619] Dynamic subtest pipe-D: SUCCESS (1.408s) [559.299868] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.612s) [560.468958] [108/133] (463s left) gem_mmap_gtt (basic-write-read-distinct) [560.533827] Subtest basic-write-read-distinct: SKIP (0.000s) [560.595888] [109/133] (463s left) kms_feature_discovery (psr1) [560.691571] Starting subtest: psr1 [560.693885] Subtest psr1: SUCCESS (0.000s) [560.762902] [110/133] (463s left) kms_cursor_crc (cursor-tearing-position-change) [560.873486] Starting subtest: cursor-tearing-position-change [560.875331] Starting dynamic subtest: pipe-A-eDP-1 [561.436330] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.564s) [561.447275] Starting dynamic subtest: pipe-D-eDP-1 [562.692155] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.252s) [562.694487] Subtest cursor-tearing-position-change: SUCCESS (1.819s) [563.531636] [111/133] (460s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt) [563.620556] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt [563.624913] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [563.717140] [112/133] (460s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [563.803342] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [563.807748] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s) [563.882010] [113/133] (460s left) gem_bad_reloc (negative-reloc) [563.945029] Subtest negative-reloc: SKIP (0.000s) [564.016616] [114/133] (460s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180) [564.104274] Starting subtest: primary-yf-tiled-reflect-x-180 [564.164374] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s) [564.267892] [115/133] (460s left) drm_read (empty-block) [564.396923] Starting subtest: empty-block [565.397295] Subtest empty-block: SUCCESS (1.000s) [565.530137] [116/133] (459s left) gem_render_copy (yf-tiled-to-vebox-linear) [565.584219] Starting subtest: yf-tiled-to-vebox-linear [565.588708] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s) [565.770304] [117/133] (458s left) kms_pm_rpm (dpms-lpsp) [567.286961] Starting subtest: dpms-lpsp [568.002955] Subtest dpms-lpsp: SUCCESS (0.720s) [568.091564] [118/133] (456s left) kms_cursor_legacy (forked-move) [568.229725] Starting subtest: forked-move [568.231560] Starting dynamic subtest: pipe-A [573.685031] Dynamic subtest pipe-A: SUCCESS (5.451s) [573.702934] Starting dynamic subtest: pipe-B [579.154944] Dynamic subtest pipe-B: SUCCESS (5.465s) [579.166406] Starting dynamic subtest: pipe-C [584.626087] Dynamic subtest pipe-C: SUCCESS (5.467s) [584.638514] Starting dynamic subtest: pipe-D [590.106214] Dynamic subtest pipe-D: SUCCESS (5.474s) [590.119098] Starting dynamic subtest: all-pipes [595.599321] Dynamic subtest all-pipes: SUCCESS (5.488s) [595.601942] Subtest forked-move: SUCCESS (27.357s) [595.742895] [119/133] (428s left) kms_psr_stress_test (flip-primary-invalidate-overlay) [595.838694] Starting subtest: flip-primary-invalidate-overlay [607.432414] Subtest flip-primary-invalidate-overlay: SUCCESS (11.590s) [607.594922] [120/133] (417s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [607.697106] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt [607.700672] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [607.791449] [121/133] (416s left) kms_content_protection (srm) [607.936942] Starting subtest: srm [607.943535] Subtest srm: SKIP (0.002s) [608.049845] [122/133] (416s left) prime_busy (after-wait) [608.111776] Starting subtest: after-wait [608.113693] Starting dynamic subtest: rcs0 [608.134525] Dynamic subtest rcs0: SUCCESS (0.022s) [608.144827] Starting dynamic subtest: bcs0 [608.187141] Dynamic subtest bcs0: SUCCESS (0.052s) [608.199584] Starting dynamic subtest: vcs0 [608.228743] Dynamic subtest vcs0: SUCCESS (0.039s) [608.239756] Starting dynamic subtest: vcs1 [608.269285] Dynamic subtest vcs1: SUCCESS (0.039s) [608.278376] Starting dynamic subtest: vecs0 [608.310176] Dynamic subtest vecs0: SUCCESS (0.040s) [608.319380] Starting dynamic subtest: ccs0 [608.350341] Dynamic subtest ccs0: SUCCESS (0.039s) [608.458890] Subtest after-wait: SUCCESS (0.347s) [608.534130] [123/133] (416s left) kms_pipe_crc_basic (disable-crc-after-crtc) [608.625755] Starting subtest: disable-crc-after-crtc [608.627705] Starting dynamic subtest: pipe-A-eDP-1 [610.324937] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.699s) [610.337274] Starting dynamic subtest: pipe-B-eDP-1 [612.589963] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.261s) [612.599971] Starting dynamic subtest: pipe-C-eDP-1 [614.948972] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.355s) [614.960000] Starting dynamic subtest: pipe-D-eDP-1 [617.199201] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.250s) [617.201384] Subtest disable-crc-after-crtc: SUCCESS (8.570s) [618.036997] [124/133] (406s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [618.150040] Starting subtest: psr2-overlay-primary-update-sf-dmg-area [618.152213] Starting dynamic subtest: pipe-A-eDP-1 [624.027533] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.879s) [624.037639] Starting dynamic subtest: pipe-B-eDP-1 [630.687220] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.662s) [630.689314] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.544s) [631.571838] [125/133] (393s left) kms_universal_plane (universal-plane-sanity) [631.672168] Starting subtest: universal-plane-sanity [631.674282] Starting dynamic subtest: pipe-A-eDP-1 [632.274165] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.602s) [632.286530] Starting dynamic subtest: pipe-B-eDP-1 [633.483406] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.209s) [633.494231] Starting dynamic subtest: pipe-C-eDP-1 [634.703756] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.216s) [634.714812] Starting dynamic subtest: pipe-D-eDP-1 [635.936034] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.234s) [635.938304] Subtest universal-plane-sanity: SUCCESS (4.267s) [636.808850] [126/133] (388s left) kms_invalid_mode (clock-too-high) [636.902440] Starting subtest: clock-too-high [636.904732] Starting dynamic subtest: pipe-A-eDP-1 [636.909065] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [636.919408] Starting dynamic subtest: pipe-B-eDP-1 [636.923771] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [636.932676] Starting dynamic subtest: pipe-C-eDP-1 [636.936783] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [636.945517] Starting dynamic subtest: pipe-D-eDP-1 [636.949683] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [636.953681] Subtest clock-too-high: SKIP (0.004s) [636.991101] [127/133] (388s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf) [637.091243] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf [637.095608] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [637.161675] [128/133] (387s left) gem_eio (wait-immediate) [637.393149] Starting subtest: wait-immediate [637.757486] Subtest wait-immediate: SUCCESS (0.365s) [637.874282] [129/133] (387s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt) [637.970506] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt [637.973941] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [638.066770] [130/133] (387s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted) [638.114762] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted [638.220327] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.105s) [638.315775] [131/133] (386s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt) [638.435725] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt [645.679238] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.246s) [645.831052] [132/133] (379s left) i915_suspend (basic-s2idle-without-i915) [645.865034] Starting subtest: basic-s2idle-without-i915 [664.371783] Subtest basic-s2idle-without-i915: SUCCESS (3.984s) [664.492527] [133/133] (360s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [664.605575] Starting subtest: fbc-rgb565-draw-blt [669.110968] Subtest fbc-rgb565-draw-blt: SUCCESS (4.376s) [670.332109] 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.