[60.336330] Initializing watchdogs [60.336380] /dev/watchdog0 [60.351222] [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] [60.355954] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [60.358977] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [60.362581] [001/133] (960s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size) [60.499186] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size [61.514472] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (1.015s) [62.381628] [002/133] (958s left) kms_hdr (brightness-with-hdr) [62.473088] Starting subtest: brightness-with-hdr [62.479695] Subtest brightness-with-hdr: SKIP (0.000s) [62.540386] [003/133] (958s left) gem_sync (basic-store-all) [62.609362] Starting subtest: basic-store-all [65.379458] Subtest basic-store-all: SUCCESS (2.782s) [65.564778] [004/133] (955s left) gem_ctx_persistence (heartbeat-stop) [65.621156] Starting subtest: heartbeat-stop [65.625965] Subtest heartbeat-stop: SKIP (0.000s) [65.734684] [005/133] (955s left) gem_ctx_shared (q-smoketest) [65.791638] Starting subtest: Q-smoketest [65.794059] Starting dynamic subtest: rcs0 [71.345355] Dynamic subtest rcs0: SUCCESS (5.508s) [71.355694] Starting dynamic subtest: bcs0 [76.835383] Dynamic subtest bcs0: SUCCESS (5.487s) [76.844900] Starting dynamic subtest: vcs0 [82.305324] Dynamic subtest vcs0: SUCCESS (5.476s) [82.314110] Starting dynamic subtest: vcs1 [87.788236] Dynamic subtest vcs1: SUCCESS (5.474s) [87.800594] Starting dynamic subtest: vecs0 [93.259912] Dynamic subtest vecs0: SUCCESS (5.475s) [93.269169] Starting dynamic subtest: ccs0 [98.739188] Dynamic subtest ccs0: SUCCESS (5.478s) [98.741592] Subtest Q-smoketest: SUCCESS (32.902s) [98.877086] [006/133] (922s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode) [99.267177] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s) [100.071566] [007/133] (921s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions) [100.194940] Starting subtest: cursorA-vs-flipA-atomic-transitions [111.348728] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.155s) [112.221370] [008/133] (908s left) gem_pread (display) [112.290432] Subtest display: SKIP (0.000s) [112.346322] [009/133] (908s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180) [112.441044] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180 [113.430512] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (0.990s) [113.560302] [010/133] (907s left) gen3_render_tiledy_blits [113.686661] [011/133] (907s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [113.785797] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [113.787765] Starting dynamic subtest: pipe-A-default-mode [114.905535] Dynamic subtest pipe-A-default-mode: SKIP (1.118s) [114.910097] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.120s) [115.045365] [012/133] (906s left) gem_mmap_gtt (big-bo-tiledy) [115.112112] Subtest big-bo-tiledY: SKIP (0.000s) [115.173447] [013/133] (906s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible) [115.268298] Starting subtest: flip-vs-absolute-wf_vblank-interruptible [115.270449] Starting dynamic subtest: A-eDP1 [124.214833] Dynamic subtest A-eDP1: SUCCESS (8.944s) [124.227157] Starting dynamic subtest: B-eDP1 [133.143336] Dynamic subtest B-eDP1: SUCCESS (8.926s) [133.152991] Starting dynamic subtest: C-eDP1 [142.066072] Dynamic subtest C-eDP1: SUCCESS (8.920s) [142.073193] Starting dynamic subtest: D-eDP1 [150.909862] Dynamic subtest D-eDP1: SUCCESS (8.842s) [150.914569] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.645s) [152.131535] [014/133] (869s left) kms_atomic_transition (plane-all-transition-nonblocking) [152.219560] Starting subtest: plane-all-transition-nonblocking [152.221726] Starting dynamic subtest: pipe-A-eDP-1 [154.713647] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s) [155.024070] Starting dynamic subtest: pipe-B-eDP-1 [158.259431] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.242s) [158.560393] Subtest plane-all-transition-nonblocking: SUCCESS (6.341s) [159.380306] [015/133] (861s left) gem_softpin (allocator-fork) [159.454636] Starting subtest: allocator-fork [161.666413] Subtest allocator-fork: SUCCESS (2.211s) [161.790810] [016/133] (859s left) kms_big_fb (x-tiled-8bpp-rotate-180) [161.892104] Starting subtest: x-tiled-8bpp-rotate-180 [163.106723] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.215s) [163.218736] [017/133] (858s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render) [163.313389] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render [163.316814] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [163.405316] [018/133] (858s left) gem_create (create-clear) [163.454950] Starting subtest: create-clear [163.456966] Starting dynamic subtest: smem0 [196.151886] Dynamic subtest smem0: SUCCESS (32.694s) [196.153765] Subtest create-clear: SUCCESS (32.695s) [196.336862] [019/133] (825s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180) [196.439679] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180 [196.444065] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [196.529199] [020/133] (825s left) kms_chamelium_color (ctm-max) [196.625936] Subtest ctm-max: SKIP (0.000s) [196.668767] [021/133] (824s left) gem_render_copy (yf-tiled-ccs-to-linear) [196.737095] Starting subtest: yf-tiled-ccs-to-linear [196.740989] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s) [196.923251] [022/133] (824s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary) [197.028062] Starting subtest: fbc-shrfb-scaledprimary [200.297572] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.271s) [201.413963] [023/133] (820s left) kms_big_fb (y-tiled-64bpp-rotate-180) [201.510441] Starting subtest: y-tiled-64bpp-rotate-180 [201.514772] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s) [201.599052] [024/133] (820s left) gem_userptr_blits (unsync-overlap) [201.665932] Subtest unsync-overlap: SKIP (0.000s) [201.797170] [025/133] (819s left) syncobj_timeline (invalid-signal-illegal-handle) [201.853568] Starting subtest: invalid-signal-illegal-handle [201.855738] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [201.961057] [026/133] (819s left) gem_exec_schedule (timeslicing) [202.042249] Starting subtest: timeslicing [202.044295] Starting dynamic subtest: rcs0 [202.050982] Dynamic subtest rcs0: SUCCESS (0.021s) [202.059493] Starting dynamic subtest: bcs0 [202.071236] Dynamic subtest bcs0: SUCCESS (0.020s) [202.078271] Starting dynamic subtest: vcs0 [202.092059] Dynamic subtest vcs0: SUCCESS (0.020s) [202.099111] Starting dynamic subtest: vcs1 [202.113354] Dynamic subtest vcs1: SUCCESS (0.021s) [202.120120] Starting dynamic subtest: vecs0 [202.133836] Dynamic subtest vecs0: SUCCESS (0.020s) [202.140820] Starting dynamic subtest: ccs0 [202.154338] Dynamic subtest ccs0: SUCCESS (0.020s) [202.156524] Subtest timeslicing: SUCCESS (0.125s) [203.967910] [027/133] (817s left) kms_lease (lease-unleased-crtc) [204.072041] Starting subtest: lease-unleased-crtc [204.074438] Starting dynamic subtest: pipe-A-eDP-1 [204.363369] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s) [204.370865] Starting dynamic subtest: pipe-B-eDP-1 [205.161765] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.796s) [205.169142] Starting dynamic subtest: pipe-C-eDP-1 [205.171400] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s) [205.178549] Starting dynamic subtest: pipe-D-eDP-1 [205.180380] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s) [205.182233] Subtest lease-unleased-crtc: SUCCESS (1.107s) [205.533257] [028/133] (816s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt) [205.640317] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt [212.494676] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.857s) [212.637191] [029/133] (809s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [212.737140] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu [212.741100] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [212.819977] [030/133] (809s left) kms_cursor_crc (cursor-offscreen-64x21) [213.021754] Starting subtest: cursor-offscreen-64x21 [213.068625] Subtest cursor-offscreen-64x21: SKIP (0.041s) [213.285833] [031/133] (808s left) kms_vrr (negative-basic) [213.369931] Starting subtest: negative-basic [213.376632] Starting dynamic subtest: pipe-A-eDP-1 [218.787176] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.410s) [219.076112] Subtest negative-basic: SUCCESS (5.707s) [219.913255] [032/133] (802s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180) [220.012091] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180 [220.017363] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s) [220.106326] [033/133] (801s left) gem_wait (write-wait) [220.166043] Starting subtest: write-wait [220.168369] Starting dynamic subtest: all-engines [221.398808] Dynamic subtest all-engines: SUCCESS (1.233s) [221.413884] Starting dynamic subtest: rcs0 [222.451816] Dynamic subtest rcs0: SUCCESS (1.050s) [222.466574] Starting dynamic subtest: bcs0 [223.508055] Dynamic subtest bcs0: SUCCESS (1.054s) [223.523561] Starting dynamic subtest: vcs0 [224.561934] Dynamic subtest vcs0: SUCCESS (1.051s) [224.575786] Starting dynamic subtest: vcs1 [225.615065] Dynamic subtest vcs1: SUCCESS (1.051s) [225.628958] Starting dynamic subtest: vecs0 [226.667086] Dynamic subtest vecs0: SUCCESS (1.050s) [226.681248] Starting dynamic subtest: ccs0 [227.724805] Dynamic subtest ccs0: SUCCESS (1.055s) [227.727629] Subtest write-wait: SUCCESS (7.560s) [227.930563] [FACT gem_wait (write-wait)] new: kernel.kmod_is_loaded.vgem: true [227.934240] [034/133] (794s left) gem_exec_fence (basic-busy) [228.111947] Starting subtest: basic-busy [228.114390] Starting dynamic subtest: rcs0 [228.218167] Dynamic subtest rcs0: SUCCESS (0.106s) [228.229162] Starting dynamic subtest: bcs0 [228.280928] Dynamic subtest bcs0: SUCCESS (0.061s) [228.290869] Starting dynamic subtest: vcs0 [228.348057] Dynamic subtest vcs0: SUCCESS (0.065s) [228.357932] Starting dynamic subtest: vcs1 [228.415811] Dynamic subtest vcs1: SUCCESS (0.066s) [228.425868] Starting dynamic subtest: vecs0 [228.476826] Dynamic subtest vecs0: SUCCESS (0.059s) [228.486686] Starting dynamic subtest: ccs0 [228.544959] Dynamic subtest ccs0: SUCCESS (0.066s) [228.547869] Subtest basic-busy: SUCCESS (0.434s) [229.986916] [035/133] (792s left) gem_tiled_wc [230.104909] [036/133] (792s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping) [230.196877] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping [230.201088] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s) [230.268239] [037/133] (791s left) gem_exec_fence (submit) [230.443640] Starting subtest: submit [230.448611] Subtest submit: SKIP (0.000s) [231.943764] [038/133] (790s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [232.037757] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [232.039981] Starting dynamic subtest: pipe-A-eDP-1 [232.099149] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [232.106301] Starting dynamic subtest: pipe-B-eDP-1 [232.163175] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [232.171867] Starting dynamic subtest: pipe-C-eDP-1 [232.228486] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [232.236795] Starting dynamic subtest: pipe-D-eDP-1 [232.293357] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [232.297467] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s) [234.278384] [039/133] (788s left) vgem_basic (bad-handle) [234.319668] Starting subtest: bad-handle [234.321879] Subtest bad-handle: SUCCESS (0.000s) [234.372842] [040/133] (787s left) gem_exec_reloc (basic-cpu-wc-active) [234.433501] Subtest basic-cpu-wc-active: SKIP (0.000s) [234.520835] [041/133] (787s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k) [234.905079] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s) [235.680777] [042/133] (786s left) gem_exec_reloc (basic-gtt-cpu-noreloc) [235.746718] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s) [235.823838] [043/133] (786s left) gem_readwrite (new-obj) [235.888711] Subtest new-obj: SKIP (0.000s) [235.957537] [044/133] (786s left) gem_exec_reloc (basic-wc-cpu-active) [236.017655] Subtest basic-wc-cpu-active: SKIP (0.000s) [236.079107] [045/133] (786s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt) [236.167926] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt [243.562613] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.396s) [243.707043] [046/133] (778s left) gem_pxp (fail-invalid-protected-context) [243.839632] Starting subtest: fail-invalid-protected-context [243.842049] Subtest fail-invalid-protected-context: SUCCESS (0.000s) [243.942138] [047/133] (778s left) kms_psr (fbc-psr-primary-page-flip) [244.029904] Starting subtest: fbc-psr-primary-page-flip [244.032191] Starting dynamic subtest: eDP-1 [244.036258] Dynamic subtest eDP-1: SKIP (0.000s) [244.040318] Subtest fbc-psr-primary-page-flip: SKIP (0.001s) [244.100795] [048/133] (778s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions) [244.218435] Starting subtest: short-flip-before-cursor-atomic-transitions [245.193879] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.975s) [246.076440] [049/133] (776s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [246.178125] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [246.780294] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.603s) [246.959970] [050/133] (775s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [247.050532] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc [247.054669] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [247.143564] [051/133] (775s left) gem_exec_schedule (noreorder-priority) [247.331790] Starting subtest: noreorder-priority [247.334287] Starting dynamic subtest: rcs0 [248.467261] Dynamic subtest rcs0: SUCCESS (1.135s) [248.477606] Starting dynamic subtest: vcs0 [249.882463] Dynamic subtest vcs0: SUCCESS (1.412s) [249.894362] Starting dynamic subtest: vcs1 [251.857334] Dynamic subtest vcs1: SUCCESS (1.972s) [251.868093] Starting dynamic subtest: vecs0 [253.915384] Dynamic subtest vecs0: SUCCESS (2.055s) [253.926268] Starting dynamic subtest: ccs0 [255.059066] Dynamic subtest ccs0: SUCCESS (1.142s) [255.062068] Subtest noreorder-priority: SUCCESS (7.728s) [255.256512] [052/133] (767s left) gem_lmem_swapping (verify-ccs) [255.306240] Subtest verify-ccs: SKIP (0.000s) [255.386412] [053/133] (767s left) gem_ctx_isolation (dirty-create) [255.458902] Starting subtest: dirty-create [255.461382] Starting dynamic subtest: rcs0 [255.690642] Dynamic subtest rcs0: SUCCESS (0.231s) [255.701742] Starting dynamic subtest: bcs0 [255.945923] Dynamic subtest bcs0: SUCCESS (0.254s) [255.954332] Starting dynamic subtest: vcs0 [256.209188] Dynamic subtest vcs0: SUCCESS (0.263s) [256.216491] Starting dynamic subtest: vcs1 [258.177844] Dynamic subtest vcs1: SUCCESS (1.967s) [258.185485] Starting dynamic subtest: vecs0 [260.049561] Dynamic subtest vecs0: SUCCESS (1.870s) [260.059310] Starting dynamic subtest: ccs0 [262.118511] Dynamic subtest ccs0: SUCCESS (2.067s) [262.120981] Subtest dirty-create: SUCCESS (6.659s) [262.347137] [054/133] (760s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area) [262.448587] Starting subtest: fbc-pr-plane-move-sf-dmg-area [262.453111] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s) [262.550000] [055/133] (760s left) dmabuf (all-tests) [262.588861] Starting subtest: all-tests [262.591273] Starting dynamic subtest: sanitycheck [262.695351] Dynamic subtest sanitycheck: SUCCESS (0.112s) [262.706815] Starting dynamic subtest: dma_fence [262.910593] Dynamic subtest dma_fence: SUCCESS (0.212s) [262.920854] Starting dynamic subtest: dma_fence_chain [272.403743] Dynamic subtest dma_fence_chain: SUCCESS (9.490s) [272.414141] Starting dynamic subtest: dma_fence_unwrap [272.487725] Dynamic subtest dma_fence_unwrap: SUCCESS (0.082s) [272.498230] Starting dynamic subtest: dma_resv [272.580476] Dynamic subtest dma_resv: SUCCESS (0.090s) [272.582896] Subtest all-tests: SUCCESS (9.998s) [272.641998] [056/133] (750s left) syncobj_timeline (reset-unsignaled) [272.696991] Starting subtest: reset-unsignaled [272.699283] Subtest reset-unsignaled: SUCCESS (0.000s) [272.783197] [057/133] (750s left) syncobj_wait (multi-wait-signaled) [272.842263] Starting subtest: multi-wait-signaled [272.844477] Subtest multi-wait-signaled: SUCCESS (0.000s) [272.931157] [058/133] (750s left) kms_flip (2x-flip-vs-absolute-wf_vblank) [273.020170] Starting subtest: 2x-flip-vs-absolute-wf_vblank [273.029376] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s) [273.119619] [059/133] (750s left) kms_psr (pr-cursor-mmap-cpu) [273.207972] Starting subtest: pr-cursor-mmap-cpu [273.212047] Subtest pr-cursor-mmap-cpu: SKIP (0.000s) [273.289913] [060/133] (749s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled) [273.358897] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled [273.465861] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.106s) [273.552237] [061/133] (749s left) kms_atomic_transition (modeset-transition-fencing) [273.638994] Starting subtest: modeset-transition-fencing [273.640942] Starting dynamic subtest: 1x-outputs [284.505077] Dynamic subtest 1x-outputs: SUCCESS (10.867s) [284.507241] Subtest modeset-transition-fencing: SUCCESS (10.869s) [285.355887] [062/133] (737s left) kms_psr (fbc-psr2-cursor-plane-onoff) [285.448446] Starting subtest: fbc-psr2-cursor-plane-onoff [285.450839] Starting dynamic subtest: eDP-1 [285.455188] Dynamic subtest eDP-1: SKIP (0.000s) [285.459594] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s) [285.521323] [063/133] (737s left) i915_hangman (error-state-basic) [285.590256] Starting subtest: error-state-basic [285.722410] Subtest error-state-basic: SUCCESS (0.132s) [285.800192] [064/133] (737s left) gem_tiled_fence_blits (basic) [285.862417] Subtest basic: SKIP (0.000s) [285.931380] [065/133] (737s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu) [286.033522] Starting subtest: fbc-rgb565-draw-mmap-cpu [290.039987] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.009s) [291.171734] [066/133] (732s left) gem_gpgpu_fill (offset-16x16) [291.227821] Starting subtest: offset-16x16 [291.235050] Subtest offset-16x16: SUCCESS (0.007s) [291.352295] [067/133] (732s left) perf_pmu (all-busy-check-all) [291.391346] Starting subtest: all-busy-check-all [292.886474] Subtest all-busy-check-all: SUCCESS (1.495s) [292.981437] [068/133] (730s left) gen9_exec_parse (unaligned-jump) [293.055126] Subtest unaligned-jump: SKIP (0.000s) [293.127333] [069/133] (730s left) i915_pm_rpm (system-suspend-execbuf) [295.052792] Starting subtest: system-suspend-execbuf [353.183501] Subtest system-suspend-execbuf: SUCCESS (43.139s) [353.572099] [070/133] (669s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt) [353.681691] Starting subtest: fbc-farfromfence-mmap-gtt [353.686121] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s) [353.800126] [071/133] (669s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render) [353.893361] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render [353.897660] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [353.996049] [072/133] (669s left) kms_psr (psr2-sprite-render) [354.084881] Starting subtest: psr2-sprite-render [354.087109] Starting dynamic subtest: eDP-1 [355.834710] Dynamic subtest eDP-1: SUCCESS (1.750s) [355.836992] Subtest psr2-sprite-render: SUCCESS (1.751s) [356.703892] [073/133] (666s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs) [356.796680] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs [356.798820] Starting dynamic subtest: pipe-A-eDP-1 [356.818375] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [356.827705] Starting dynamic subtest: pipe-B-eDP-1 [356.846789] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [356.856968] Starting dynamic subtest: pipe-C-eDP-1 [356.875531] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [356.885560] Starting dynamic subtest: pipe-D-eDP-1 [356.904125] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [356.905903] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.006s) [359.075465] [074/133] (664s left) perf_pmu (idle-no-semaphores) [359.113899] Starting subtest: idle-no-semaphores [359.116218] Starting dynamic subtest: rcs0 [359.658433] Dynamic subtest rcs0: SUCCESS (0.542s) [359.669154] Starting dynamic subtest: bcs0 [360.175115] Dynamic subtest bcs0: SUCCESS (0.514s) [360.185326] Starting dynamic subtest: vcs0 [360.694851] Dynamic subtest vcs0: SUCCESS (0.517s) [360.705865] Starting dynamic subtest: vcs1 [361.219448] Dynamic subtest vcs1: SUCCESS (0.522s) [361.231134] Starting dynamic subtest: vecs0 [361.737092] Dynamic subtest vecs0: SUCCESS (0.514s) [361.749052] Starting dynamic subtest: ccs0 [362.270160] Dynamic subtest ccs0: SUCCESS (0.530s) [362.273313] Subtest idle-no-semaphores: SUCCESS (3.157s) [362.381333] [075/133] (661s left) gem_exec_fence (syncobj-timeline-signal) [362.924274] Starting subtest: syncobj-timeline-signal [362.934849] Subtest syncobj-timeline-signal: SUCCESS (0.012s) [363.953401] [076/133] (659s left) kms_plane_multiple (tiling-yf) [364.058005] Starting subtest: tiling-yf [364.062324] Subtest tiling-yf: SKIP (0.000s) [364.137817] [077/133] (659s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format) [364.233985] Starting subtest: plane-upscale-factor-0-25-with-pixel-format [364.236287] Starting dynamic subtest: pipe-A [365.282038] Dynamic subtest pipe-A: SUCCESS (1.051s) [365.290588] Starting dynamic subtest: pipe-B [367.364743] Dynamic subtest pipe-B: SUCCESS (2.081s) [367.381774] Starting dynamic subtest: pipe-C [368.564505] Dynamic subtest pipe-C: SUCCESS (1.197s) [368.574271] Starting dynamic subtest: pipe-D [369.700921] Dynamic subtest pipe-D: SUCCESS (1.136s) [369.703182] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.471s) [370.902492] [078/133] (652s left) kms_flip (flip-vs-expired-vblank) [371.003234] Starting subtest: flip-vs-expired-vblank [371.005549] Starting dynamic subtest: A-eDP1 [379.720873] Dynamic subtest A-eDP1: SUCCESS (8.718s) [379.730581] Starting dynamic subtest: B-eDP1 [388.363168] Dynamic subtest B-eDP1: SUCCESS (8.642s) [388.372438] Starting dynamic subtest: C-eDP1 [396.999740] Dynamic subtest C-eDP1: SUCCESS (8.636s) [397.008347] Starting dynamic subtest: D-eDP1 [405.639936] Dynamic subtest D-eDP1: SUCCESS (8.641s) [405.644908] Subtest flip-vs-expired-vblank: SUCCESS (34.648s) [406.808260] [079/133] (617s left) syncobj_timeline (single-wait-for-submit-available-signaled) [406.867452] Starting subtest: single-wait-for-submit-available-signaled [406.869641] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s) [406.957225] [080/133] (617s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [407.052943] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [407.821561] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.770s) [408.032860] [081/133] (616s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite) [408.135279] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite [417.231268] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.096s) [417.368806] [082/133] (606s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc) [417.461692] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc [417.463882] Starting dynamic subtest: pipe-A-eDP-1 [417.483344] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [417.493526] Starting dynamic subtest: pipe-B-eDP-1 [417.512299] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [417.520324] Starting dynamic subtest: pipe-C-eDP-1 [417.538696] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [417.546635] Starting dynamic subtest: pipe-D-eDP-1 [417.565683] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [417.567857] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s) [419.781538] [083/133] (604s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw) [419.883802] Starting subtest: fbc-2p-pri-indfb-multidraw [419.887933] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s) [419.983318] [084/133] (604s left) gem_render_tiled_blits (basic) [420.048118] Subtest basic: SKIP (0.000s) [420.120369] [085/133] (604s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [420.211803] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [420.213918] Starting dynamic subtest: pipe-A-eDP-1 [420.236296] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [420.247217] Starting dynamic subtest: pipe-B-eDP-1 [420.268217] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [420.277188] Starting dynamic subtest: pipe-C-eDP-1 [420.301021] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [420.309577] Starting dynamic subtest: pipe-D-eDP-1 [420.338120] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [420.342623] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s) [422.429486] [086/133] (601s left) kms_vblank (ts-continuation-dpms-rpm) [422.522112] Starting subtest: ts-continuation-dpms-rpm [422.523975] Starting dynamic subtest: pipe-A-eDP-1 [425.023239] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.501s) [425.038035] Starting dynamic subtest: pipe-D-eDP-1 [427.273548] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.248s) [427.275981] Subtest ts-continuation-dpms-rpm: SUCCESS (4.752s) [428.068892] [087/133] (596s left) gem_exec_whisper (basic-fds-priority) [428.139414] Starting subtest: basic-fds-priority [452.429236] Subtest basic-fds-priority: SUCCESS (24.290s) [452.616013] [088/133] (571s left) kms_pm_rpm (legacy-planes-dpms) [454.150561] Starting subtest: legacy-planes-dpms [454.152790] Starting dynamic subtest: plane-64 [462.745425] Dynamic subtest plane-64: SUCCESS (8.597s) [462.758125] Starting dynamic subtest: plane-94 [471.576404] Dynamic subtest plane-94: SUCCESS (8.827s) [471.588095] Starting dynamic subtest: plane-124 [480.171210] Dynamic subtest plane-124: SUCCESS (8.593s) [480.182846] Starting dynamic subtest: plane-134 [488.591103] Dynamic subtest plane-134: SUCCESS (8.418s) [488.593931] Subtest legacy-planes-dpms: SUCCESS (34.448s) [488.979372] [089/133] (535s left) intel_hwmon (hwmon-write) [489.046582] Subtest hwmon-write: SKIP (0.000s) [489.102846] [090/133] (535s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite) [489.194820] Starting subtest: fbcpsr-rgb101010-draw-pwrite [496.131223] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (6.940s) [496.244818] [091/133] (528s left) syncobj_basic (bad-pad-fd-to-handle) [496.308157] Starting subtest: bad-pad-fd-to-handle [496.310380] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [496.397717] [092/133] (528s left) gen9_exec_parse (bb-chained) [496.454584] Subtest bb-chained: SKIP (0.000s) [496.529509] [093/133] (528s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt) [496.632273] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt [503.843101] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.215s) [503.989828] [094/133] (520s left) gem_exec_params (rel-constants-invalid-ring) [504.046828] Starting subtest: rel-constants-invalid-ring [504.049209] Subtest rel-constants-invalid-ring: SUCCESS (0.000s) [504.152170] [095/133] (520s left) gem_workarounds (suspend-resume-fd) [504.211718] Starting subtest: suspend-resume-fd [520.232350] Subtest suspend-resume-fd: SUCCESS (1.169s) [520.399432] [096/133] (504s left) kms_color (ctm-signed) [520.502477] Starting subtest: ctm-signed [520.504719] Starting dynamic subtest: pipe-A-eDP-1 [522.586877] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.085s) [522.596066] Starting dynamic subtest: pipe-B-eDP-1 [525.467458] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.883s) [525.477104] Starting dynamic subtest: pipe-C-eDP-1 [528.178522] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.713s) [528.187095] Starting dynamic subtest: pipe-D-eDP-1 [530.843040] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.667s) [530.845214] Subtest ctm-signed: SUCCESS (10.350s) [531.705725] [097/133] (493s left) kms_cursor_crc (cursor-random-256x256) [531.988494] Starting subtest: cursor-random-256x256 [531.994707] Starting dynamic subtest: pipe-A-eDP-1 [535.411302] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.417s) [535.437637] Starting dynamic subtest: pipe-D-eDP-1 [539.359714] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.930s) [539.362019] Subtest cursor-random-256x256: SUCCESS (7.373s) [540.234666] [098/133] (484s left) gem_mmap_gtt (ptrace) [540.289457] Subtest ptrace: SKIP (0.000s) [540.344272] [099/133] (484s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu) [540.429039] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu [543.991900] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.567s) [545.147272] [100/133] (479s left) gem_exec_balancer (parallel-balancer) [545.419520] Starting subtest: parallel-balancer [546.275485] Subtest parallel-balancer: SUCCESS (0.860s) [546.376165] [101/133] (478s left) syncobj_timeline (etime-single-wait-all-submitted) [546.437855] Starting subtest: etime-single-wait-all-submitted [546.543667] Subtest etime-single-wait-all-submitted: SUCCESS (0.104s) [546.619209] [102/133] (478s left) api_intel_bb (crc32) [546.666465] Starting subtest: crc32 [546.668807] Starting dynamic subtest: rcs0-smem0 [546.954224] Dynamic subtest rcs0-smem0: SUCCESS (0.285s) [546.964721] Starting dynamic subtest: bcs0-smem0 [547.273435] Dynamic subtest bcs0-smem0: SUCCESS (0.317s) [547.285417] Starting dynamic subtest: vcs0-smem0 [547.605426] Dynamic subtest vcs0-smem0: SUCCESS (0.329s) [547.615469] Starting dynamic subtest: vcs1-smem0 [547.983079] Dynamic subtest vcs1-smem0: SUCCESS (0.375s) [547.995336] Starting dynamic subtest: vecs0-smem0 [548.319424] Dynamic subtest vecs0-smem0: SUCCESS (0.334s) [548.329320] Starting dynamic subtest: ccs0-smem0 [548.644231] Dynamic subtest ccs0-smem0: SUCCESS (0.322s) [548.647170] Subtest crc32: SUCCESS (1.979s) [548.755578] [103/133] (476s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt) [548.859859] Starting subtest: psr-rgb565-draw-mmap-gtt [548.864168] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s) [548.957717] [104/133] (476s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted) [549.016894] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted [549.118821] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.102s) [549.229915] [105/133] (475s left) gem_exec_reloc (basic-cpu-wc) [549.281464] Subtest basic-cpu-wc: SKIP (0.000s) [549.363160] [106/133] (475s left) api_intel_bb (purge-bb) [549.434410] Starting subtest: purge-bb [549.439693] Subtest purge-bb: SUCCESS (0.007s) [549.556419] [107/133] (475s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers) [549.653426] Starting subtest: plane-scaler-with-clipping-clamping-modifiers [549.655717] Starting dynamic subtest: pipe-A [549.991066] Dynamic subtest pipe-A: SUCCESS (0.340s) [550.004385] Starting dynamic subtest: pipe-B [551.428631] Dynamic subtest pipe-B: SUCCESS (1.436s) [551.441496] Starting dynamic subtest: pipe-C [552.868951] Dynamic subtest pipe-C: SUCCESS (1.439s) [552.880508] Starting dynamic subtest: pipe-D [554.286366] Dynamic subtest pipe-D: SUCCESS (1.416s) [554.289130] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.637s) [555.445198] [108/133] (469s left) gem_mmap_gtt (basic-write-read-distinct) [555.505804] Subtest basic-write-read-distinct: SKIP (0.000s) [555.582661] [109/133] (469s left) kms_feature_discovery (psr1) [555.687006] Starting subtest: psr1 [555.689288] Subtest psr1: SUCCESS (0.000s) [555.763042] [110/133] (469s left) kms_cursor_crc (cursor-tearing-position-change) [555.882184] Starting subtest: cursor-tearing-position-change [555.884436] Starting dynamic subtest: pipe-A-eDP-1 [556.448650] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.563s) [556.457758] Starting dynamic subtest: pipe-D-eDP-1 [557.673080] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.224s) [557.675488] Subtest cursor-tearing-position-change: SUCCESS (1.790s) [558.512904] [111/133] (466s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt) [558.613037] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt [558.617394] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [558.714772] [112/133] (466s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [558.820830] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [558.825046] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s) [558.891930] [113/133] (466s left) gem_bad_reloc (negative-reloc) [558.958268] Subtest negative-reloc: SKIP (0.000s) [559.033315] [114/133] (466s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180) [559.122616] Starting subtest: primary-yf-tiled-reflect-x-180 [559.181304] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s) [559.284449] [115/133] (466s left) drm_read (empty-block) [559.425563] Starting subtest: empty-block [560.426839] Subtest empty-block: SUCCESS (1.001s) [560.563575] [116/133] (465s left) gem_render_copy (yf-tiled-to-vebox-linear) [560.632337] Starting subtest: yf-tiled-to-vebox-linear [560.636651] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s) [560.816909] [117/133] (464s left) kms_pm_rpm (dpms-lpsp) [562.942124] Starting subtest: dpms-lpsp [563.241666] Subtest dpms-lpsp: SUCCESS (0.304s) [563.341828] [118/133] (462s left) kms_cursor_legacy (forked-move) [563.458233] Starting subtest: forked-move [563.460410] Starting dynamic subtest: pipe-A [568.941844] Dynamic subtest pipe-A: SUCCESS (5.479s) [568.953741] Starting dynamic subtest: pipe-B [574.407449] Dynamic subtest pipe-B: SUCCESS (5.463s) [574.418666] Starting dynamic subtest: pipe-C [579.885114] Dynamic subtest pipe-C: SUCCESS (5.475s) [579.896456] Starting dynamic subtest: pipe-D [585.364929] Dynamic subtest pipe-D: SUCCESS (5.461s) [585.379149] Starting dynamic subtest: all-pipes [590.833039] Dynamic subtest all-pipes: SUCCESS (5.483s) [590.835460] Subtest forked-move: SUCCESS (27.372s) [590.980047] [119/133] (434s left) kms_psr_stress_test (flip-primary-invalidate-overlay) [591.078473] Starting subtest: flip-primary-invalidate-overlay [602.657115] Subtest flip-primary-invalidate-overlay: SUCCESS (11.582s) [602.814874] [120/133] (422s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [602.904816] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt [602.908134] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [602.993806] [121/133] (422s left) kms_content_protection (srm) [603.119739] Starting subtest: srm [603.126292] Subtest srm: SKIP (0.002s) [603.258500] [122/133] (422s left) prime_busy (after-wait) [603.312596] Starting subtest: after-wait [603.317068] Starting dynamic subtest: rcs0 [603.342324] Dynamic subtest rcs0: SUCCESS (0.026s) [603.356074] Starting dynamic subtest: bcs0 [603.382246] Dynamic subtest bcs0: SUCCESS (0.039s) [603.391113] Starting dynamic subtest: vcs0 [603.422630] Dynamic subtest vcs0: SUCCESS (0.040s) [603.433534] Starting dynamic subtest: vcs1 [603.464567] Dynamic subtest vcs1: SUCCESS (0.041s) [603.473764] Starting dynamic subtest: vecs0 [603.505467] Dynamic subtest vecs0: SUCCESS (0.040s) [603.516089] Starting dynamic subtest: ccs0 [603.545262] Dynamic subtest ccs0: SUCCESS (0.039s) [603.654062] Subtest after-wait: SUCCESS (0.339s) [603.729991] [123/133] (422s left) kms_pipe_crc_basic (disable-crc-after-crtc) [603.821786] Starting subtest: disable-crc-after-crtc [603.824097] Starting dynamic subtest: pipe-A-eDP-1 [605.539870] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.717s) [605.548871] Starting dynamic subtest: pipe-B-eDP-1 [607.926223] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.387s) [607.938147] Starting dynamic subtest: pipe-C-eDP-1 [610.145234] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.216s) [610.155397] Starting dynamic subtest: pipe-D-eDP-1 [612.511447] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.362s) [612.513393] Subtest disable-crc-after-crtc: SUCCESS (8.690s) [613.329501] [124/133] (412s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [613.427871] Starting subtest: psr2-overlay-primary-update-sf-dmg-area [613.430250] Starting dynamic subtest: pipe-A-eDP-1 [619.333581] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.909s) [619.343153] Starting dynamic subtest: pipe-B-eDP-1 [625.972225] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.635s) [625.974514] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.547s) [626.847871] [125/133] (399s left) kms_universal_plane (universal-plane-sanity) [626.954654] Starting subtest: universal-plane-sanity [626.956967] Starting dynamic subtest: pipe-A-eDP-1 [627.549013] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.593s) [627.558654] Starting dynamic subtest: pipe-B-eDP-1 [628.770362] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.218s) [628.780672] Starting dynamic subtest: pipe-C-eDP-1 [629.976045] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.204s) [629.986298] Starting dynamic subtest: pipe-D-eDP-1 [631.200070] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.225s) [631.202423] Subtest universal-plane-sanity: SUCCESS (4.246s) [632.059911] [126/133] (393s left) kms_invalid_mode (clock-too-high) [632.162183] Starting subtest: clock-too-high [632.164524] Starting dynamic subtest: pipe-A-eDP-1 [632.169039] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [632.181691] Starting dynamic subtest: pipe-B-eDP-1 [632.186048] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [632.195352] Starting dynamic subtest: pipe-C-eDP-1 [632.199891] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [632.208504] Starting dynamic subtest: pipe-D-eDP-1 [632.213013] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [632.217546] Subtest clock-too-high: SKIP (0.004s) [632.254190] [127/133] (393s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf) [632.362530] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf [632.366688] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [632.456017] [128/133] (393s left) gem_eio (wait-immediate) [632.679901] Starting subtest: wait-immediate [633.037070] Subtest wait-immediate: SUCCESS (0.358s) [633.175260] [129/133] (392s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt) [633.276869] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt [633.280498] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [633.391282] [130/133] (392s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted) [633.448026] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted [633.551947] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.102s) [633.626053] [131/133] (392s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt) [633.724227] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt [640.961968] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.239s) [641.098319] [132/133] (385s left) i915_suspend (basic-s2idle-without-i915) [641.130340] Starting subtest: basic-s2idle-without-i915 [660.656503] Subtest basic-s2idle-without-i915: SUCCESS (3.993s) [660.770276] [133/133] (365s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [660.864627] Starting subtest: fbc-rgb565-draw-blt [665.030951] Subtest fbc-rgb565-draw-blt: SUCCESS (4.173s) [666.175569] 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.