[56.569971] Initializing watchdogs
[56.570157]   /dev/watchdog0
[56.585526] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[56.589577] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.592077] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.595262] [001/156] (960s left) gem_exec_suspend (basic-s0)
[56.672370] Starting subtest: basic-S0
[56.674776] Starting dynamic subtest: smem
[77.515381] Dynamic subtest smem: SUCCESS (6.555s)
[77.518488] Subtest basic-S0: SUCCESS (6.557s)
[77.715418] [002/156] (939s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[77.807574] Starting subtest: plane-lut1d-ctm3x4-lut1d
[77.953923] Starting dynamic subtest: pipe-A-plane-0
[78.143623] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s)
[78.153636] Starting dynamic subtest: pipe-A-plane-1
[78.276653] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[78.285868] Starting dynamic subtest: pipe-A-plane-2
[78.409774] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[79.656477] Starting dynamic subtest: pipe-B-plane-0
[79.804661] Dynamic subtest pipe-B-plane-0: SUCCESS (0.156s)
[79.816538] Starting dynamic subtest: pipe-B-plane-1
[79.949344] Dynamic subtest pipe-B-plane-1: SUCCESS (0.144s)
[79.959485] Starting dynamic subtest: pipe-B-plane-2
[80.127487] Dynamic subtest pipe-B-plane-2: SUCCESS (0.177s)
[81.412971] Starting dynamic subtest: pipe-C-plane-0
[81.548569] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[81.559067] Starting dynamic subtest: pipe-C-plane-1
[81.682089] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s)
[81.690638] Starting dynamic subtest: pipe-C-plane-2
[81.815391] Dynamic subtest pipe-C-plane-2: SUCCESS (0.133s)
[83.018726] Starting dynamic subtest: pipe-D-plane-0
[83.157256] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[83.166778] Starting dynamic subtest: pipe-D-plane-1
[83.290441] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s)
[83.299760] Starting dynamic subtest: pipe-D-plane-2
[83.424102] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[83.715217] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (5.902s)
[84.583402] [003/156] (932s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[84.664977] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[84.667385] Starting dynamic subtest: pipe-A-eDP-1
[84.691023] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[84.701764] Starting dynamic subtest: pipe-B-eDP-1
[84.723498] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[84.732175] Starting dynamic subtest: pipe-C-eDP-1
[84.754765] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[84.765062] Starting dynamic subtest: pipe-D-eDP-1
[84.786162] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[84.790128] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.002s)
[86.947979] [004/156] (930s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[87.100915] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[87.105236] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[87.333668] [005/156] (929s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[87.506094] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[87.510741] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[87.609166] [006/156] (929s left) dumb_buffer (create-clear)
[87.721055] Starting subtest: create-clear
[122.363828] Subtest create-clear: SUCCESS (34.640s)
[122.468557] [007/156] (894s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[122.529515] Starting subtest: multi-wait-for-submit-available-signaled
[122.532025] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.001s)
[122.641110] [008/156] (894s left) gem_mmap_gtt (basic-write-read-distinct)
[122.702995] Subtest basic-write-read-distinct: SKIP (0.000s)
[122.766147] [009/156] (894s left) gem_exec_reloc (basic-cpu-gtt)
[122.822868] Subtest basic-cpu-gtt: SKIP (0.000s)
[122.883484] [010/156] (894s left) gem_exec_params (no-vebox)
[122.938934] Starting subtest: no-vebox
[122.941137] Subtest no-vebox: SUCCESS (0.002s)
[124.560048] [011/156] (892s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[124.648089] Starting subtest: multiplane-rotation-cropping-bottom
[142.014988] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.371s)
[142.127790] [012/156] (875s left) kms_frontbuffer_tracking (fbc-1p-rte)
[142.224276] Starting subtest: fbc-1p-rte
[147.690063] Subtest fbc-1p-rte: SUCCESS (5.472s)
[148.846533] [013/156] (868s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[148.927989] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[148.932309] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[149.028032] [014/156] (868s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[149.111829] Starting subtest: psr-rgb101010-draw-mmap-gtt
[149.115851] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[149.213650] [015/156] (868s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[149.300558] Starting subtest: y-tiled-32bpp-rotate-180
[149.304824] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[149.392961] [016/156] (868s left) gem_linear_blits (basic)
[149.764045] Starting subtest: basic
[149.770161] Subtest basic: SUCCESS (0.005s)
[149.897711] [017/156] (867s left) kms_3d (basic)
[149.989267] Starting subtest: basic
[149.993337] Subtest basic: SKIP (0.000s)
[150.077339] [018/156] (867s left) kms_pm_rpm (pm-caching)
[151.614596] Starting subtest: pm-caching
[151.619440] Subtest pm-caching: SKIP (0.000s)
[152.383733] [019/156] (865s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-mmap-cpu)
[152.465728] Starting subtest: psrhdr-rgb101010-draw-mmap-cpu
[152.469799] Subtest psrhdr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[152.565355] [020/156] (865s left) gem_exec_schedule (u-semaphore-resolve)
[152.638561] Starting subtest: u-semaphore-resolve
[152.669431] Subtest u-semaphore-resolve: SUCCESS (0.038s)
[153.016230] [021/156] (864s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[153.097620] Starting subtest: pr-overlay-plane-move-continuous-sf
[153.101863] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[153.164805] [022/156] (864s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[153.241812] Starting subtest: primary-yf-tiled-reflect-x-0
[153.313240] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.071s)
[153.417300] [023/156] (864s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[153.544343] Starting subtest: dp-mst-type-0-suspend-resume
[153.548628] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[153.685913] [024/156] (864s left) gem_sync (basic-all)
[153.765716] Starting subtest: basic-all
[155.844504] Subtest basic-all: SUCCESS (2.089s)
[156.025964] [025/156] (862s left) gem_exec_balancer (full-late)
[156.089950] Starting subtest: full-late
[160.341471] Subtest full-late: SUCCESS (4.251s)
[160.667365] [026/156] (857s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[160.748743] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[167.939579] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.196s)
[169.072800] [027/156] (849s left) gem_tiled_blits (normal)
[169.135847] Subtest normal: SKIP (0.000s)
[169.208755] [028/156] (848s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-pwrite)
[169.285843] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-pwrite
[169.290163] Subtest hdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[169.382652] [029/156] (848s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[171.687677] Starting subtest: dpms-mode-unset-non-lpsp
[172.838079] Subtest dpms-mode-unset-non-lpsp: SKIP (1.148s)
[173.249525] [030/156] (845s left) prime_mmap (test_userptr)
[173.302872] Starting subtest: test_userptr
[173.305164] Starting dynamic subtest: test_userptr-smem
[173.307288] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[173.309455] Subtest test_userptr: SUCCESS (0.001s)
[173.402301] [031/156] (844s left) gem_exec_alignment (many)
[173.456557] Starting subtest: many
[195.417223] Subtest many: SUCCESS (21.955s)
[198.037126] [032/156] (820s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[198.175685] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[198.180054] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[198.271957] [033/156] (820s left) gem_tiled_partial_pwrite_pread (writes)
[198.328918] Subtest writes: SKIP (0.000s)
[198.396147] [034/156] (820s left) i915_pm_rps (thresholds-idle-park)
[198.456350] Starting subtest: thresholds-idle-park
[198.460626] Subtest thresholds-idle-park: SKIP (0.001s)
[198.565339] [035/156] (819s left) gem_pwrite (basic-self)
[198.616116] Subtest basic-self: SKIP (0.000s)
[198.677749] [036/156] (819s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[198.763080] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[198.767339] Subtest hdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[198.848802] [037/156] (819s left) kms_psr (fbc-pr-basic)
[198.927441] Starting subtest: fbc-pr-basic
[198.931864] Subtest fbc-pr-basic: SKIP (0.000s)
[198.996974] [038/156] (819s left) kms_plane_cursor (overlay)
[199.065075] Starting subtest: overlay
[199.068582] Starting dynamic subtest: pipe-A-eDP-1-size-64
[201.491127] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.425s)
[201.554516] Starting dynamic subtest: pipe-A-eDP-1-size-128
[204.080714] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.538s)
[204.141610] Starting dynamic subtest: pipe-A-eDP-1-size-256
[206.582778] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.449s)
[206.938238] Starting dynamic subtest: pipe-B-eDP-1-size-64
[210.097200] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.171s)
[210.160103] Starting dynamic subtest: pipe-B-eDP-1-size-128
[212.665076] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.515s)
[212.727260] Starting dynamic subtest: pipe-B-eDP-1-size-256
[215.202104] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.483s)
[215.557433] Starting dynamic subtest: pipe-C-eDP-1-size-64
[218.375070] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.830s)
[218.416345] Starting dynamic subtest: pipe-C-eDP-1-size-128
[220.509684] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.103s)
[220.548773] Starting dynamic subtest: pipe-C-eDP-1-size-256
[222.653879] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.114s)
[222.986937] Starting dynamic subtest: pipe-D-eDP-1-size-64
[225.856722] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.885s)
[225.895300] Starting dynamic subtest: pipe-D-eDP-1-size-128
[227.978612] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.092s)
[228.016881] Starting dynamic subtest: pipe-D-eDP-1-size-256
[230.123126] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.114s)
[230.441375] Subtest overlay: SUCCESS (31.374s)
[231.318024] [039/156] (787s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-onoff)
[231.407222] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-onoff
[231.411729] Subtest psrhdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[231.515309] [040/156] (787s left) i915_pciid
[231.669101] [041/156] (787s left) gem_userptr_blits (dmabuf-unsync)
[231.727267] Subtest dmabuf-unsync: SKIP (0.000s)
[231.831637] [042/156] (786s left) kms_frontbuffer_tracking (hdr-1p-pri-indfb-multidraw)
[231.908451] Starting subtest: hdr-1p-pri-indfb-multidraw
[231.912632] Subtest hdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[231.988408] [043/156] (786s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[232.063099] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[232.067635] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s)
[232.138536] [044/156] (786s left) gem_ctx_persistence (heartbeat-hang)
[232.198304] Starting subtest: heartbeat-hang
[232.202940] Subtest heartbeat-hang: SKIP (0.000s)
[232.320599] [045/156] (786s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-render)
[232.393952] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-render
[232.397752] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[232.477451] [046/156] (786s left) gem_exec_balancer (parallel-out-fence)
[232.749723] Starting subtest: parallel-out-fence
[233.930070] Subtest parallel-out-fence: SUCCESS (1.183s)
[234.042464] [047/156] (784s left) gem_exec_gttfill (basic)
[234.107480] Starting subtest: basic
[236.661309] Subtest basic: SUCCESS (2.553s)
[236.850627] [048/156] (782s left) kms_flip (flip-vs-dpms-on-nop)
[236.980469] Starting subtest: flip-vs-dpms-on-nop
[236.983088] Starting dynamic subtest: A-eDP1
[238.905629] Dynamic subtest A-eDP1: SUCCESS (1.928s)
[238.918523] Starting dynamic subtest: B-eDP1
[240.740596] Dynamic subtest B-eDP1: SUCCESS (1.834s)
[240.753431] Starting dynamic subtest: C-eDP1
[242.579690] Dynamic subtest C-eDP1: SUCCESS (1.838s)
[242.589953] Starting dynamic subtest: D-eDP1
[244.402666] Dynamic subtest D-eDP1: SUCCESS (1.822s)
[244.405090] Subtest flip-vs-dpms-on-nop: SUCCESS (7.429s)
[245.588444] [049/156] (773s left) perf_pmu (busy-double-start)
[245.633255] Starting subtest: busy-double-start
[245.635090] Starting dynamic subtest: rcs0
[249.203878] Dynamic subtest rcs0: SUCCESS (3.571s)
[249.215243] Starting dynamic subtest: bcs0
[252.796609] Dynamic subtest bcs0: SUCCESS (3.591s)
[252.808413] Starting dynamic subtest: vcs0
[257.061752] Dynamic subtest vcs0: SUCCESS (4.263s)
[257.074535] Starting dynamic subtest: vcs1
[261.007893] Dynamic subtest vcs1: SUCCESS (3.944s)
[261.020020] Starting dynamic subtest: vecs0
[264.972876] Dynamic subtest vecs0: SUCCESS (3.963s)
[264.985460] Starting dynamic subtest: ccs0
[268.541904] Dynamic subtest ccs0: SUCCESS (3.567s)
[268.544482] Subtest busy-double-start: SUCCESS (22.911s)
[268.650321] [050/156] (750s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[268.734739] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[268.739168] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[268.828184] [051/156] (750s left) syncobj_wait (wait-any-snapshot)
[268.884222] Starting subtest: wait-any-snapshot
[268.964035] Subtest wait-any-snapshot: SUCCESS (0.081s)
[269.039851] [052/156] (750s left) gem_render_copy_redux (flink)
[269.102710] Starting subtest: flink
[269.782740] Subtest flink: SUCCESS (0.680s)
[269.901136] [053/156] (749s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[269.973286] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[269.975161] Starting dynamic subtest: pipe-A-eDP-1
[270.047842] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[270.057721] Starting dynamic subtest: pipe-B-eDP-1
[271.163951] Dynamic subtest pipe-B-eDP-1: SKIP (1.110s)
[271.168400] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.191s)
[272.355866] [054/156] (746s left) kms_flip (dpms-off-confusion-interruptible)
[272.439596] Starting subtest: dpms-off-confusion-interruptible
[272.444625] Starting dynamic subtest: A-eDP1
[281.154295] Dynamic subtest A-eDP1: SUCCESS (8.712s)
[281.164824] Starting dynamic subtest: B-eDP1
[289.776646] Dynamic subtest B-eDP1: SUCCESS (8.621s)
[289.787377] Starting dynamic subtest: C-eDP1
[298.387699] Dynamic subtest C-eDP1: SUCCESS (8.610s)
[298.401898] Starting dynamic subtest: D-eDP1
[307.014597] Dynamic subtest D-eDP1: SUCCESS (8.623s)
[307.019903] Subtest dpms-off-confusion-interruptible: SUCCESS (34.578s)
[308.179523] [055/156] (711s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[308.248821] Starting subtest: crc-primary-basic-yf-tiled-ccs
[308.251159] Starting dynamic subtest: pipe-A-eDP-1
[308.274104] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[308.288850] Starting dynamic subtest: pipe-B-eDP-1
[308.311664] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[308.322868] Starting dynamic subtest: pipe-C-eDP-1
[308.344718] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[308.354051] Starting dynamic subtest: pipe-D-eDP-1
[308.376075] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[308.380407] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.005s)
[310.540037] [056/156] (708s left) perf (per-context-mode-unprivileged)
[310.665443] Starting subtest: per-context-mode-unprivileged
[310.669798] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[310.706806] [057/156] (708s left) kms_frontbuffer_tracking (psrhdr-suspend)
[310.791111] Starting subtest: psrhdr-suspend
[310.795109] Subtest psrhdr-suspend: SKIP (0.000s)
[310.883244] [058/156] (708s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[310.949206] Starting subtest: x-tiled-to-vebox-yf-tiled
[310.953668] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[311.142389] [059/156] (708s left) gem_mmap_offset (partial-unmap)
[311.189161] Starting subtest: partial-unmap
[311.191043] Starting dynamic subtest: smem0
[311.688457] Dynamic subtest smem0: SUCCESS (0.498s)
[311.691106] Subtest partial-unmap: SUCCESS (0.500s)
[311.802400] [060/156] (707s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-blt)
[311.886108] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-blt
[311.890615] Subtest hdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[311.989415] [061/156] (707s left) kms_psr (psr2-sprite-mmap-cpu)
[312.070813] Starting subtest: psr2-sprite-mmap-cpu
[312.073127] Starting dynamic subtest: eDP-1
[313.825957] Dynamic subtest eDP-1: SUCCESS (1.754s)
[313.828434] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.755s)
[314.702910] [062/156] (704s left) api_intel_bb (object-reloc-keep-cache)
[314.753108] Starting subtest: object-reloc-keep-cache
[314.757742] Subtest object-reloc-keep-cache: SKIP (0.002s)
[314.874369] [063/156] (704s left) kms_psr (pr-primary-blt)
[314.950982] Starting subtest: pr-primary-blt
[314.955436] Subtest pr-primary-blt: SKIP (0.000s)
[315.028395] [064/156] (704s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[315.108870] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[315.113100] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[315.216945] [065/156] (704s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-blt)
[315.308877] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-blt
[315.313239] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[315.397714] [066/156] (704s left) i915_pm_rpm (debugfs-read)
[317.711654] Starting subtest: debugfs-read
[318.851955] Subtest debugfs-read: SUCCESS (1.142s)
[319.233742] [067/156] (700s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[319.294862] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[319.297489] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[319.395153] [068/156] (700s left) gem_exec_reloc (basic-gtt-cpu)
[319.448840] Subtest basic-gtt-cpu: SKIP (0.000s)
[319.519042] [069/156] (700s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[319.597537] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[319.599848] Starting dynamic subtest: pipe-A-eDP-1
[319.624448] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[319.635964] Starting dynamic subtest: pipe-B-eDP-1
[319.658406] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[319.669123] Starting dynamic subtest: pipe-C-eDP-1
[319.691838] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[319.702415] Starting dynamic subtest: pipe-D-eDP-1
[319.724581] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[319.728725] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[321.897767] [070/156] (697s left) gem_mmap_gtt (close-race)
[321.955593] Subtest close-race: SKIP (0.000s)
[322.018342] [071/156] (697s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[322.104847] Starting subtest: x-tiled-addfb-size-offset-overflow
[322.106975] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[322.201643] [072/156] (697s left) kms_feature_discovery (psr2)
[322.285140] Starting subtest: psr2
[322.287411] Subtest psr2: SUCCESS (0.001s)
[322.357754] [073/156] (697s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[322.467591] Starting subtest: basic-flip-after-cursor-atomic
[323.392872] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.924s)
[324.221901] [074/156] (695s left) kms_psr (fbc-pr-sprite-plane-onoff)
[324.306725] Starting subtest: fbc-pr-sprite-plane-onoff
[324.310648] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[324.379725] [075/156] (695s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-move)
[324.463053] Starting subtest: psrhdr-2p-primscrn-spr-indfb-move
[324.467087] Subtest psrhdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[324.557217] [076/156] (695s left) gem_exec_reloc (basic-cpu-read-active)
[324.622402] Subtest basic-cpu-read-active: SKIP (0.000s)
[324.680442] [077/156] (695s left) perf_pmu (idle)
[324.719067] Starting subtest: idle
[324.721593] Starting dynamic subtest: rcs0
[325.273469] Dynamic subtest rcs0: SUCCESS (0.554s)
[325.287922] Starting dynamic subtest: bcs0
[325.796072] Dynamic subtest bcs0: SUCCESS (0.520s)
[325.808664] Starting dynamic subtest: vcs0
[326.320805] Dynamic subtest vcs0: SUCCESS (0.517s)
[326.332335] Starting dynamic subtest: vcs1
[326.839265] Dynamic subtest vcs1: SUCCESS (0.520s)
[326.852589] Starting dynamic subtest: vecs0
[327.363716] Dynamic subtest vecs0: SUCCESS (0.519s)
[327.375710] Starting dynamic subtest: ccs0
[327.876104] Dynamic subtest ccs0: SUCCESS (0.513s)
[327.879731] Subtest idle: SUCCESS (3.159s)
[327.994147] [078/156] (692s left) kms_atomic_interruptible (universal-setplane-primary)
[328.075072] Starting subtest: universal-setplane-primary
[328.077238] Starting dynamic subtest: pipe-A-eDP-1
[335.532783] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.455s)
[335.535082] Subtest universal-setplane-primary: SUCCESS (7.457s)
[336.377047] [079/156] (683s left) kms_chamelium_hpd (dp-hpd-fast)
[336.764617] Subtest dp-hpd-fast: SKIP (0.000s)
[337.588747] [080/156] (682s left) gem_exec_reloc (basic-write-cpu-noreloc)
[337.637274] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[337.709180] [081/156] (682s left) kms_big_fb (linear-16bpp-rotate-270)
[337.792148] Starting subtest: linear-16bpp-rotate-270
[337.810832] Subtest linear-16bpp-rotate-270: SKIP (0.018s)
[337.934421] [082/156] (682s left) prime_mmap (test_aperture_limit)
[337.991099] Starting subtest: test_aperture_limit
[337.992981] Starting dynamic subtest: test_aperture_limit-smem
[338.000063] Dynamic subtest test_aperture_limit-smem: SKIP (0.009s)
[338.004514] Subtest test_aperture_limit: SKIP (0.009s)
[338.069903] [083/156] (682s left) gem_ctx_persistence (engines-cleanup)
[338.129060] Starting subtest: engines-cleanup
[338.130940] Starting dynamic subtest: rcs0
[338.200028] Dynamic subtest rcs0: SUCCESS (0.073s)
[338.214342] Starting dynamic subtest: bcs0
[338.246463] Dynamic subtest bcs0: SUCCESS (0.045s)
[338.257873] Starting dynamic subtest: vcs0
[338.296708] Dynamic subtest vcs0: SUCCESS (0.048s)
[338.308914] Starting dynamic subtest: vcs1
[338.333450] Dynamic subtest vcs1: SUCCESS (0.035s)
[338.343711] Starting dynamic subtest: vecs0
[338.354295] Dynamic subtest vecs0: SUCCESS (0.019s)
[338.364306] Starting dynamic subtest: ccs0
[338.410567] Dynamic subtest ccs0: SUCCESS (0.055s)
[338.412935] Subtest engines-cleanup: SUCCESS (0.285s)
[338.486414] [084/156] (681s left) api_intel_bb (delta-check)
[338.542084] Starting subtest: delta-check
[338.546602] Subtest delta-check: SUCCESS (0.005s)
[338.672895] [085/156] (681s left) gem_exec_reloc (basic-cpu-wc)
[338.734087] Subtest basic-cpu-wc: SKIP (0.000s)
[338.802479] [086/156] (681s left) gem_lmem_swapping (heavy-multi)
[338.844235] Subtest heavy-multi: SKIP (0.000s)
[338.886427] [087/156] (681s left) gem_fenced_exec_thrash (no-spare-fences)
[338.940317] Subtest no-spare-fences: SKIP (0.000s)
[339.008215] [088/156] (681s left) kms_dp_link_training (non-uhbr-mst)
[339.085216] Starting subtest: non-uhbr-mst
[339.092258] Subtest non-uhbr-mst: SKIP (0.000s)
[339.154122] [089/156] (681s left) kms_lease (empty-lease)
[339.226181] Starting subtest: empty-lease
[339.228178] Starting dynamic subtest: pipe-A-eDP-1
[339.230115] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[339.240930] Starting dynamic subtest: pipe-B-eDP-1
[339.242874] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[339.253125] Starting dynamic subtest: pipe-C-eDP-1
[339.254890] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.003s)
[339.264250] Starting dynamic subtest: pipe-D-eDP-1
[339.266033] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[339.267910] Subtest empty-lease: SUCCESS (0.013s)
[339.349282] [090/156] (681s left) kms_cursor_crc (cursor-sliding-128x128)
[339.518870] Starting subtest: cursor-sliding-128x128
[339.523204] Starting dynamic subtest: pipe-A-eDP-1
[342.743055] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.220s)
[342.774648] Starting dynamic subtest: pipe-D-eDP-1
[346.629389] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.863s)
[346.631223] Subtest cursor-sliding-128x128: SUCCESS (7.109s)
[347.486380] [091/156] (673s left) kms_psr (fbc-psr-primary-render)
[347.564296] Starting subtest: fbc-psr-primary-render
[347.566418] Starting dynamic subtest: eDP-1
[347.570759] Dynamic subtest eDP-1: SKIP (0.000s)
[347.575079] Subtest fbc-psr-primary-render: SKIP (0.001s)
[347.651304] [092/156] (673s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[347.740770] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[347.744912] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[347.836681] [093/156] (672s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[347.899059] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[348.006893] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.108s)
[348.080732] [094/156] (672s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[348.162856] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[355.453276] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.295s)
[355.577310] [095/156] (665s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[355.663833] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-wc
[355.668300] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[355.757179] [096/156] (665s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[355.830024] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[355.834416] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[355.960900] [097/156] (664s left) syncobj_timeline (single-wait-available-submitted)
[356.020598] Starting subtest: single-wait-available-submitted
[356.022594] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[356.121838] [098/156] (664s left) kms_plane_multiple (tiling-none)
[356.205320] Starting subtest: tiling-none
[356.207700] Starting dynamic subtest: pipe-A-eDP-1
[360.057743] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.850s)
[360.068699] Starting dynamic subtest: pipe-B-eDP-1
[364.549080] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.492s)
[364.562075] Starting dynamic subtest: pipe-C-eDP-1
[368.878050] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.327s)
[368.889126] Starting dynamic subtest: pipe-D-eDP-1
[373.223820] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.345s)
[373.226183] Subtest tiling-none: SUCCESS (17.020s)
[374.031866] [099/156] (646s left) gem_unref_active_buffers
[374.237244] [100/156] (646s left) kms_lease (lease-invalid-plane)
[374.318921] Starting subtest: lease-invalid-plane
[374.321875] Starting dynamic subtest: pipe-A-eDP-1
[374.324070] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[374.334179] Starting dynamic subtest: pipe-B-eDP-1
[374.336460] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[374.346374] Starting dynamic subtest: pipe-C-eDP-1
[374.348148] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[374.357557] Starting dynamic subtest: pipe-D-eDP-1
[374.359524] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[374.361451] Subtest lease-invalid-plane: SUCCESS (0.004s)
[374.399245] [101/156] (646s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[374.473684] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt
[374.478157] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[374.583423] [102/156] (646s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[374.652585] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[374.657288] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[375.759382] [103/156] (645s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[375.846746] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[375.851157] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[375.937011] [104/156] (645s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[376.015591] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[376.019927] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[376.111361] [105/156] (645s left) gem_exec_schedule (preempt-engines)
[376.183046] Starting subtest: preempt-engines
[376.185206] Starting dynamic subtest: rcs0
[378.435872] Dynamic subtest rcs0: SUCCESS (2.259s)
[378.447596] Starting dynamic subtest: bcs0
[380.699734] Dynamic subtest bcs0: SUCCESS (2.262s)
[380.710164] Starting dynamic subtest: vcs0
[382.967191] Dynamic subtest vcs0: SUCCESS (2.265s)
[382.978300] Starting dynamic subtest: vcs1
[385.239514] Dynamic subtest vcs1: SUCCESS (2.269s)
[385.252021] Starting dynamic subtest: vecs0
[387.492641] Dynamic subtest vecs0: SUCCESS (2.251s)
[387.503052] Starting dynamic subtest: ccs0
[389.781656] Dynamic subtest ccs0: SUCCESS (2.286s)
[389.784096] Subtest preempt-engines: SUCCESS (13.606s)
[390.083567] [106/156] (631s left) tools_test (tools_test)
[390.138512] Starting subtest: tools_test
[390.193279] Subtest tools_test: SUCCESS (0.073s)
[390.257692] [107/156] (631s left) gem_madvise (dontneed-before-mmap)
[390.299675] Starting subtest: dontneed-before-mmap
[390.317195] Subtest dontneed-before-mmap: SUCCESS (0.020s)
[390.427640] [108/156] (630s left) gem_exec_parallel (basic)
[390.489058] Starting subtest: basic
[390.491449] Starting dynamic subtest: rcs0
[392.020410] Dynamic subtest rcs0: SUCCESS (1.531s)
[392.034716] Starting dynamic subtest: bcs0
[393.516076] Dynamic subtest bcs0: SUCCESS (1.492s)
[393.530205] Starting dynamic subtest: vcs0
[395.466253] Dynamic subtest vcs0: SUCCESS (1.945s)
[395.477936] Starting dynamic subtest: vcs1
[397.450590] Dynamic subtest vcs1: SUCCESS (1.982s)
[397.464352] Starting dynamic subtest: vecs0
[399.498430] Dynamic subtest vecs0: SUCCESS (2.044s)
[399.512667] Starting dynamic subtest: ccs0
[400.987669] Dynamic subtest ccs0: SUCCESS (1.488s)
[400.990147] Subtest basic: SUCCESS (10.499s)
[401.172379] [109/156] (620s left) kms_vrr (flip-suspend)
[401.241077] Starting subtest: flip-suspend
[401.247693] Subtest flip-suspend: SKIP (0.000s)
[401.311385] [110/156] (620s left) kms_chamelium_frames (dp-frame-dump)
[401.673670] Subtest dp-frame-dump: SKIP (0.000s)
[402.471116] [111/156] (619s left) sysfs_timeslice_duration (timeout)
[402.536760] Starting subtest: timeout
[402.539070] Starting dynamic subtest: vecs0
[412.489482] Dynamic subtest vecs0: SUCCESS (9.949s)
[412.501527] Starting dynamic subtest: ccs0
[413.762436] Dynamic subtest ccs0: SUCCESS (1.271s)
[413.775107] Starting dynamic subtest: vcs0
[423.498849] Dynamic subtest vcs0: SUCCESS (9.735s)
[423.509765] Starting dynamic subtest: bcs0
[424.103648] Dynamic subtest bcs0: SUCCESS (0.602s)
[424.114885] Starting dynamic subtest: rcs0
[425.322062] Dynamic subtest rcs0: SUCCESS (1.220s)
[425.334094] Starting dynamic subtest: vcs1
[434.497637] Dynamic subtest vcs1: SUCCESS (9.171s)
[434.500059] Subtest timeout: SUCCESS (31.957s)
[434.585903] [112/156] (586s left) gem_workarounds (reset-context)
[434.656286] Starting subtest: reset-context
[434.823677] Subtest reset-context: SUCCESS (0.169s)
[434.944352] [113/156] (586s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[435.034340] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[443.743497] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.715s)
[443.869565] [114/156] (577s left) kms_cursor_crc (cursor-offscreen-32x10)
[444.015876] Starting subtest: cursor-offscreen-32x10
[444.057429] Subtest cursor-offscreen-32x10: SKIP (0.042s)
[444.327284] [115/156] (577s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[444.417193] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[444.421480] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[444.509504] [116/156] (577s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[444.616519] Starting subtest: short-flip-after-cursor-toggle
[445.532970] Subtest short-flip-after-cursor-toggle: SUCCESS (0.914s)
[446.398282] [117/156] (575s left) gem_exec_schedule (fifo)
[446.468592] Starting subtest: fifo
[446.470601] Starting dynamic subtest: rcs0
[446.556050] Dynamic subtest rcs0: SUCCESS (0.097s)
[446.570686] Starting dynamic subtest: vcs0
[446.632416] Dynamic subtest vcs0: SUCCESS (0.075s)
[446.646424] Starting dynamic subtest: vcs1
[446.706878] Dynamic subtest vcs1: SUCCESS (0.074s)
[446.718939] Starting dynamic subtest: vecs0
[446.781839] Dynamic subtest vecs0: SUCCESS (0.074s)
[446.794141] Starting dynamic subtest: ccs0
[446.872734] Dynamic subtest ccs0: SUCCESS (0.090s)
[446.875320] Subtest fifo: SUCCESS (0.416s)
[448.614856] [118/156] (573s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite)
[448.706392] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite
[448.710828] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[448.845256] [119/156] (573s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[448.919031] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[456.202347] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.288s)
[456.323695] [120/156] (565s left) prime_busy (before)
[456.390018] Starting subtest: before
[456.392310] Starting dynamic subtest: rcs0
[456.424976] Dynamic subtest rcs0: SUCCESS (0.036s)
[456.436350] Starting dynamic subtest: bcs0
[456.470994] Dynamic subtest bcs0: SUCCESS (0.046s)
[456.481951] Starting dynamic subtest: vcs0
[456.511626] Dynamic subtest vcs0: SUCCESS (0.040s)
[456.522261] Starting dynamic subtest: vcs1
[456.551828] Dynamic subtest vcs1: SUCCESS (0.039s)
[456.562549] Starting dynamic subtest: vecs0
[456.592581] Dynamic subtest vecs0: SUCCESS (0.039s)
[456.603596] Starting dynamic subtest: ccs0
[456.633590] Dynamic subtest ccs0: SUCCESS (0.041s)
[456.742518] Subtest before: SUCCESS (0.355s)
[456.829743] [121/156] (565s left) kms_flip (nonexisting-fb)
[456.918450] Starting subtest: nonexisting-fb
[456.920817] Starting dynamic subtest: A-eDP1
[458.097440] Dynamic subtest A-eDP1: SUCCESS (1.181s)
[458.109562] Starting dynamic subtest: B-eDP1
[459.228550] Dynamic subtest B-eDP1: SUCCESS (1.130s)
[459.240858] Starting dynamic subtest: C-eDP1
[460.368086] Dynamic subtest C-eDP1: SUCCESS (1.139s)
[460.379687] Starting dynamic subtest: D-eDP1
[461.513233] Dynamic subtest D-eDP1: SUCCESS (1.142s)
[461.515625] Subtest nonexisting-fb: SUCCESS (4.600s)
[462.688117] [122/156] (559s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-mmap-wc)
[462.767806] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-mmap-wc
[462.772035] Subtest fbchdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[462.862281] [123/156] (559s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[462.944746] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[463.613146] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.670s)
[463.788982] [124/156] (558s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[463.877080] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[463.881045] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[463.966124] [125/156] (558s left) gem_exec_reloc (basic-cpu)
[464.016225] Subtest basic-cpu: SKIP (0.000s)
[464.089126] [126/156] (558s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[464.158142] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[464.160458] Starting dynamic subtest: pipe-A-eDP-1
[464.181352] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[464.195659] Starting dynamic subtest: pipe-B-eDP-1
[464.214686] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[464.226229] Starting dynamic subtest: pipe-C-eDP-1
[464.245631] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[464.255847] Starting dynamic subtest: pipe-D-eDP-1
[464.275336] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[464.277232] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.007s)
[466.460666] [127/156] (555s left) gem_ctx_exec (basic-invalid-context)
[466.510572] Starting subtest: basic-invalid-context
[466.515245] Subtest basic-invalid-context: SUCCESS (0.004s)
[466.645878] [128/156] (555s left) kms_plane (plane-position-hole)
[466.721785] Starting subtest: plane-position-hole
[467.255298] Starting dynamic subtest: pipe-A-plane-1
[468.508662] Dynamic subtest pipe-A-plane-1: SUCCESS (1.254s)
[468.522056] Starting dynamic subtest: pipe-A-plane-2
[469.783325] Dynamic subtest pipe-A-plane-2: SUCCESS (1.273s)
[469.795710] Starting dynamic subtest: pipe-A-plane-3
[471.044862] Dynamic subtest pipe-A-plane-3: SUCCESS (1.259s)
[471.055981] Starting dynamic subtest: pipe-A-plane-4
[472.282425] Dynamic subtest pipe-A-plane-4: SUCCESS (1.238s)
[472.294987] Starting dynamic subtest: pipe-A-plane-5
[472.307572] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[473.475898] Starting dynamic subtest: pipe-B-plane-1
[474.756542] Dynamic subtest pipe-B-plane-1: SUCCESS (1.289s)
[474.767493] Starting dynamic subtest: pipe-B-plane-2
[475.992078] Dynamic subtest pipe-B-plane-2: SUCCESS (1.236s)
[476.004904] Starting dynamic subtest: pipe-B-plane-3
[477.239985] Dynamic subtest pipe-B-plane-3: SUCCESS (1.246s)
[477.251956] Starting dynamic subtest: pipe-B-plane-4
[478.433147] Dynamic subtest pipe-B-plane-4: SUCCESS (1.192s)
[478.444572] Starting dynamic subtest: pipe-B-plane-5
[478.459663] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[478.461849] Subtest plane-position-hole: SUCCESS (11.736s)
[479.256370] [129/156] (543s left) syncobj_basic (bad-handle-to-fd)
[479.310835] Starting subtest: bad-handle-to-fd
[479.312928] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[479.416383] [130/156] (542s left) kms_pm_backlight (fade-with-suspend)
[479.486934] Starting subtest: fade-with-suspend
[495.668034] Starting dynamic subtest: eDP-1
[498.692753] Dynamic subtest eDP-1: SUCCESS (3.022s)
[498.694998] Subtest fade-with-suspend: SUCCESS (4.263s)
[499.507735] [131/156] (522s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[499.574555] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[499.579151] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[499.759416] [132/156] (522s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[499.829521] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[499.831796] Starting dynamic subtest: pipe-A-eDP-1
[501.956345] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.123s)
[501.966878] Starting dynamic subtest: pipe-B-eDP-1
[504.284242] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.324s)
[504.295791] Starting dynamic subtest: pipe-C-eDP-1
[506.368920] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.082s)
[506.380498] Starting dynamic subtest: pipe-D-eDP-1
[508.442355] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.070s)
[508.444278] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.603s)
[509.638788] [133/156] (512s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[509.736363] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu
[509.740582] Subtest fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[509.835257] [134/156] (512s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-cpu)
[509.925096] Starting subtest: fbchdr-rgb565-draw-mmap-cpu
[509.929914] Subtest fbchdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[510.025536] [135/156] (512s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[510.114228] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[514.541195] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.429s)
[515.728540] [136/156] (506s left) gem_ccs (block-multicopy-inplace)
[515.792479] Starting subtest: block-multicopy-inplace
[515.796443] Subtest block-multicopy-inplace: SKIP (0.000s)
[515.897051] [137/156] (506s left) kms_big_fb (4-tiled-addfb)
[515.983599] Starting subtest: 4-tiled-addfb
[515.985453] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[516.082870] [138/156] (506s left) gem_userptr_blits (sync-unmap-cycles)
[516.141017] Starting subtest: sync-unmap-cycles
[521.511551] Subtest sync-unmap-cycles: SUCCESS (5.370s)
[521.627404] [139/156] (501s left) syncobj_timeline (multi-wait-all-available-signaled)
[521.678829] Starting subtest: multi-wait-all-available-signaled
[521.680674] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[521.804839] [140/156] (500s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[521.877347] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[521.880771] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[521.961692] [141/156] (500s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[522.050299] Starting subtest: fbcpsr-tiling-linear
[528.601628] Subtest fbcpsr-tiling-linear: SUCCESS (6.555s)
[528.712199] [142/156] (494s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[528.794525] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[528.798929] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[528.888455] [143/156] (493s left) gem_spin_batch (spin-all)
[528.955911] Starting subtest: spin-all
[528.969312] Subtest spin-all: SUCCESS (0.013s)
[530.512003] [144/156] (492s left) gen9_exec_parse (secure-batches)
[530.570097] Subtest secure-batches: SKIP (0.000s)
[530.652009] [145/156] (492s left) kms_rotation_crc (bad-tiling)
[530.736258] Starting subtest: bad-tiling
[530.740795] Subtest bad-tiling: SKIP (0.000s)
[530.809936] [146/156] (492s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[530.893901] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[530.938623] [147/156] (492s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[531.007233] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[531.009596] Starting dynamic subtest: pipe-A-default-mode
[532.199765] Dynamic subtest pipe-A-default-mode: SKIP (1.190s)
[532.203883] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.192s)
[532.345806] [148/156] (490s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[532.434218] Starting subtest: cursor-tearing-framebuffer-change
[532.436449] Starting dynamic subtest: pipe-A-eDP-1
[533.015380] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.579s)
[533.026334] Starting dynamic subtest: pipe-D-eDP-1
[534.293044] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.276s)
[534.295465] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.857s)
[535.114585] [149/156] (487s left) kms_async_flips (test-cursor)
[535.198276] Starting subtest: test-cursor
[535.572272] Starting dynamic subtest: pipe-A-eDP-1
[536.410395] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.838s)
[536.805890] Starting dynamic subtest: pipe-B-eDP-1
[537.633257] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.837s)
[538.020825] Starting dynamic subtest: pipe-C-eDP-1
[538.767211] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.755s)
[539.137501] Starting dynamic subtest: pipe-D-eDP-1
[539.906409] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.778s)
[539.908849] Subtest test-cursor: SUCCESS (4.710s)
[541.076906] [150/156] (482s left) gem_exec_fence (syncobj-import)
[541.570390] Starting subtest: syncobj-import
[541.575582] Subtest syncobj-import: SUCCESS (0.005s)
[543.547612] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[543.554589] [151/156] (479s left) i915_drm_fdinfo (most-busy-check-all)
[543.594124] Starting subtest: most-busy-check-all
[543.595999] Starting dynamic subtest: rcs0
[543.600447] Dynamic subtest rcs0: SKIP (0.004s)
[543.612323] Starting dynamic subtest: bcs0
[543.617090] Dynamic subtest bcs0: SKIP (0.000s)
[543.630383] Starting dynamic subtest: vcs0
[543.634443] Dynamic subtest vcs0: SKIP (0.000s)
[543.645041] Starting dynamic subtest: vcs1
[543.649178] Dynamic subtest vcs1: SKIP (0.000s)
[543.663270] Starting dynamic subtest: vecs0
[543.667666] Dynamic subtest vecs0: SKIP (0.000s)
[543.678029] Starting dynamic subtest: ccs0
[543.682454] Dynamic subtest ccs0: SKIP (0.000s)
[543.686750] Subtest most-busy-check-all: SKIP (0.009s)
[543.724409] [152/156] (479s left) gem_wait (write-wait)
[543.828697] Starting subtest: write-wait
[543.831347] Starting dynamic subtest: all-engines
[544.920863] Dynamic subtest all-engines: SUCCESS (1.092s)
[544.939635] Starting dynamic subtest: rcs0
[545.978768] Dynamic subtest rcs0: SUCCESS (1.056s)
[545.998064] Starting dynamic subtest: bcs0
[547.037532] Dynamic subtest bcs0: SUCCESS (1.056s)
[547.056176] Starting dynamic subtest: vcs0
[548.092621] Dynamic subtest vcs0: SUCCESS (1.053s)
[548.110388] Starting dynamic subtest: vcs1
[549.148088] Dynamic subtest vcs1: SUCCESS (1.052s)
[549.166690] Starting dynamic subtest: vecs0
[550.201778] Dynamic subtest vecs0: SUCCESS (1.051s)
[550.220704] Starting dynamic subtest: ccs0
[551.258429] Dynamic subtest ccs0: SUCCESS (1.054s)
[551.260929] Subtest write-wait: SUCCESS (7.430s)
[551.456218] [153/156] (471s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[551.549124] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[551.553605] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[551.663031] [154/156] (471s left) kms_frontbuffer_tracking (fbchdr-1p-rte)
[551.737797] Starting subtest: fbchdr-1p-rte
[551.742009] Subtest fbchdr-1p-rte: SKIP (0.000s)
[551.845086] [155/156] (471s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[551.922798] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[551.926878] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[552.033991] [156/156] (471s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[552.118164] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[558.761615] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.647s)
[558.878847] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_suspend
results: parsing output: 1/ for test: kms_color_pipeline
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: dumb_buffer
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: gem_mmap_gtt
results: parsing output: 8/ for test: gem_exec_reloc
results: parsing output: 9/ for test: gem_exec_params
results: parsing output: 10/ for test: kms_rotation_crc
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: gem_linear_blits
results: parsing output: 16/ for test: kms_3d
results: parsing output: 17/ for test: kms_pm_rpm
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_exec_schedule
results: parsing output: 20/ for test: kms_psr2_sf
results: parsing output: 21/ for test: kms_rotation_crc
results: parsing output: 22/ for test: kms_content_protection
results: parsing output: 23/ for test: gem_sync
results: parsing output: 24/ for test: gem_exec_balancer
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_tiled_blits
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_pm_rpm
results: parsing output: 29/ for test: prime_mmap
results: parsing output: 30/ for test: gem_exec_alignment
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 33/ for test: i915_pm_rps
results: parsing output: 34/ for test: gem_pwrite
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: kms_plane_cursor
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: i915_pciid
results: parsing output: 40/ for test: gem_userptr_blits
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_plane
results: parsing output: 43/ for test: gem_ctx_persistence
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_exec_balancer
results: parsing output: 46/ for test: gem_exec_gttfill
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: perf_pmu
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: syncobj_wait
results: parsing output: 51/ for test: gem_render_copy_redux
results: parsing output: 52/ for test: kms_psr2_sf
results: parsing output: 53/ for test: kms_flip
results: parsing output: 54/ for test: kms_ccs
results: parsing output: 55/ for test: perf
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_render_copy
results: parsing output: 58/ for test: gem_mmap_offset
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: api_intel_bb
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: i915_pm_rpm
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: gem_exec_reloc
results: parsing output: 68/ for test: kms_ccs
results: parsing output: 69/ for test: gem_mmap_gtt
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_feature_discovery
results: parsing output: 72/ for test: kms_cursor_legacy
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_exec_reloc
results: parsing output: 76/ for test: perf_pmu
results: parsing output: 77/ for test: kms_atomic_interruptible
results: parsing output: 78/ for test: kms_chamelium_hpd
results: parsing output: 79/ for test: gem_exec_reloc
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: prime_mmap
results: parsing output: 82/ for test: gem_ctx_persistence
results: parsing output: 83/ for test: api_intel_bb
results: parsing output: 84/ for test: gem_exec_reloc
results: parsing output: 85/ for test: gem_lmem_swapping
results: parsing output: 86/ for test: gem_fenced_exec_thrash
results: parsing output: 87/ for test: kms_dp_link_training
results: parsing output: 88/ for test: kms_lease
results: parsing output: 89/ for test: kms_cursor_crc
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: kms_plane_multiple
results: parsing output: 98/ for test: gem_unref_active_buffers
results: parsing output: 99/ for test: kms_lease
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: tools_test
results: parsing output: 106/ for test: gem_madvise
results: parsing output: 107/ for test: gem_exec_parallel
results: parsing output: 108/ for test: kms_vrr
results: parsing output: 109/ for test: kms_chamelium_frames
results: parsing output: 110/ for test: sysfs_timeslice_duration
results: parsing output: 111/ for test: gem_workarounds
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_cursor_crc
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_cursor_legacy
results: parsing output: 116/ for test: gem_exec_schedule
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: prime_busy
results: parsing output: 120/ for test: kms_flip
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_exec_reloc
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: gem_ctx_exec
results: parsing output: 127/ for test: kms_plane
results: parsing output: 128/ for test: syncobj_basic
results: parsing output: 129/ for test: kms_pm_backlight
results: parsing output: 130/ for test: gem_render_copy
results: parsing output: 131/ for test: kms_ccs
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: gem_ccs
results: parsing output: 136/ for test: kms_big_fb
results: parsing output: 137/ for test: gem_userptr_blits
results: parsing output: 138/ for test: syncobj_timeline
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: gem_spin_batch
results: parsing output: 143/ for test: gen9_exec_parse
results: parsing output: 144/ for test: kms_rotation_crc
results: parsing output: 145/ for test: kms_tiled_display
results: parsing output: 146/ for test: kms_flip_scaled_crc
results: parsing output: 147/ for test: kms_cursor_crc
results: parsing output: 148/ for test: kms_async_flips
results: parsing output: 149/ for test: gem_exec_fence
results: parsing output: 150/ for test: i915_drm_fdinfo
results: parsing output: 151/ for test: gem_wait
results: parsing output: 152/ for test: kms_big_fb
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: kms_frontbuffer_tracking
results: parsing output: 155/ for test: kms_frontbuffer_tracking
Done.