[61.504127] Initializing watchdogs
[61.504172]   /dev/watchdog0
[61.518847] [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]
[61.523281] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.525477] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.529055] [001/133] (960s left) kms_psr (psr-primary-mmap-gtt)
[61.652977] Starting subtest: psr-primary-mmap-gtt
[61.655357] Starting dynamic subtest: eDP-1
[63.144270] Dynamic subtest eDP-1: SKIP (1.480s)
[63.149206] Subtest psr-primary-mmap-gtt: SKIP (1.482s)
[63.305170] [002/133] (958s left) kms_atomic_interruptible (universal-setplane-cursor)
[63.409997] Starting subtest: universal-setplane-cursor
[63.412369] Starting dynamic subtest: pipe-A-eDP-1
[70.793896] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.362s)
[70.796130] Subtest universal-setplane-cursor: SUCCESS (7.363s)
[71.661227] [003/133] (950s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[71.753420] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[79.078749] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.322s)
[79.222172] [004/133] (942s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[79.331368] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[80.180769] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.850s)
[80.328819] [005/133] (941s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[80.447821] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[80.452222] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[80.529239] [006/133] (941s left) kms_getfb (getfb2-handle-closed)
[80.618127] Starting subtest: getfb2-handle-closed
[80.620489] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[80.717410] [007/133] (941s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[80.817974] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[80.820445] Starting dynamic subtest: pipe-A
[81.869480] Dynamic subtest pipe-A: SUCCESS (1.052s)
[81.877805] Starting dynamic subtest: pipe-B
[83.996455] Dynamic subtest pipe-B: SUCCESS (2.125s)
[84.004975] Starting dynamic subtest: pipe-C
[85.186841] Dynamic subtest pipe-C: SUCCESS (1.189s)
[85.197775] Starting dynamic subtest: pipe-D
[86.422895] Dynamic subtest pipe-D: SUCCESS (1.235s)
[86.425347] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.603s)
[87.614578] [008/133] (934s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[87.713922] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[87.718175] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[87.805796] [009/133] (934s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[87.894182] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[87.896477] Starting dynamic subtest: pipe-A-eDP-1
[88.376381] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.450s)
[88.386065] Starting dynamic subtest: pipe-B-eDP-1
[89.802447] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.426s)
[89.812124] Starting dynamic subtest: pipe-C-eDP-1
[91.176536] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.373s)
[91.186275] Starting dynamic subtest: pipe-D-eDP-1
[92.609549] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.430s)
[92.611558] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.684s)
[93.768314] [010/133] (928s left) kms_psr (psr2-sprite-mmap-cpu)
[93.864943] Starting subtest: psr2-sprite-mmap-cpu
[93.867397] Starting dynamic subtest: eDP-1
[95.593271] Dynamic subtest eDP-1: SUCCESS (1.727s)
[95.595806] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.728s)
[96.422795] [011/133] (925s left) gem_ctx_param (vm)
[96.469935] Starting subtest: vm
[96.544046] Subtest vm: SUCCESS (0.073s)
[96.675198] [012/133] (925s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[96.768945] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[100.431518] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.664s)
[101.653256] [013/133] (920s left) vgem_basic (setversion)
[101.726594] Starting subtest: setversion
[101.731077] Subtest setversion: SUCCESS (0.000s)
[101.780799] [FACT vgem_basic (setversion)] new: kernel.kmod_is_loaded.vgem: true
[101.784145] [014/133] (920s left) kms_plane (plane-position-hole)
[101.880769] Starting subtest: plane-position-hole
[102.405053] Starting dynamic subtest: pipe-A-plane-1
[103.682876] Dynamic subtest pipe-A-plane-1: SUCCESS (1.277s)
[103.690731] Starting dynamic subtest: pipe-A-plane-2
[104.900774] Dynamic subtest pipe-A-plane-2: SUCCESS (1.218s)
[104.908900] Starting dynamic subtest: pipe-A-plane-3
[106.189233] Dynamic subtest pipe-A-plane-3: SUCCESS (1.288s)
[106.198248] Starting dynamic subtest: pipe-A-plane-4
[107.466370] Dynamic subtest pipe-A-plane-4: SUCCESS (1.275s)
[107.474762] Starting dynamic subtest: pipe-A-plane-5
[107.495327] Dynamic subtest pipe-A-plane-5: SUCCESS (0.028s)
[108.627927] Starting dynamic subtest: pipe-B-plane-1
[109.944753] Dynamic subtest pipe-B-plane-1: SUCCESS (1.322s)
[109.953170] Starting dynamic subtest: pipe-B-plane-2
[111.181679] Dynamic subtest pipe-B-plane-2: SUCCESS (1.235s)
[111.190188] Starting dynamic subtest: pipe-B-plane-3
[112.421563] Dynamic subtest pipe-B-plane-3: SUCCESS (1.239s)
[112.432590] Starting dynamic subtest: pipe-B-plane-4
[113.636504] Dynamic subtest pipe-B-plane-4: SUCCESS (1.214s)
[113.645179] Starting dynamic subtest: pipe-B-plane-5
[113.660897] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[113.662848] Subtest plane-position-hole: SUCCESS (11.776s)
[114.437630] [015/133] (908s left) i915_drm_fdinfo (memory-info-active)
[114.490341] Starting subtest: memory-info-active
[114.492355] Starting dynamic subtest: smem0
[117.079900] Dynamic subtest smem0: SUCCESS (2.590s)
[117.082393] Subtest memory-info-active: SUCCESS (2.591s)
[117.153254] [016/133] (905s left) gem_exec_reloc (basic-wc-cpu)
[117.211620] Subtest basic-wc-cpu: SKIP (0.000s)
[117.276901] [017/133] (905s left) gem_exec_schedule (fifo)
[117.340452] Starting subtest: fifo
[117.342226] Starting dynamic subtest: rcs0
[117.507208] Dynamic subtest rcs0: SUCCESS (0.172s)
[117.517651] Starting dynamic subtest: vcs0
[117.605891] Dynamic subtest vcs0: SUCCESS (0.099s)
[117.615507] Starting dynamic subtest: vcs1
[117.708766] Dynamic subtest vcs1: SUCCESS (0.103s)
[117.718502] Starting dynamic subtest: vecs0
[117.820391] Dynamic subtest vecs0: SUCCESS (0.110s)
[117.830856] Starting dynamic subtest: ccs0
[117.937415] Dynamic subtest ccs0: SUCCESS (0.117s)
[117.939840] Subtest fifo: SUCCESS (0.604s)
[119.022541] [018/133] (903s left) gem_eio (in-flight-internal-1us)
[119.262685] Starting subtest: in-flight-internal-1us
[121.008269] Subtest in-flight-internal-1us: SUCCESS (1.745s)
[121.137494] [019/133] (901s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[121.227861] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[121.232349] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[121.333084] [020/133] (901s left) gem_lmem_evict (dontneed-evict-race)
[121.382026] Subtest dontneed-evict-race: SKIP (0.000s)
[121.432707] [021/133] (901s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[121.532479] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[121.536661] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[121.635902] [022/133] (901s left) i915_hangman (engine-error-state-capture)
[121.704685] Starting subtest: engine-error-state-capture
[121.706570] Starting dynamic subtest: rcs0
[124.852039] Dynamic subtest rcs0: SUCCESS (3.146s)
[124.862903] Starting dynamic subtest: bcs0
[130.866610] Dynamic subtest bcs0: SUCCESS (6.011s)
[130.877089] Starting dynamic subtest: vcs0
[136.819587] Dynamic subtest vcs0: SUCCESS (5.950s)
[136.831547] Starting dynamic subtest: vcs1
[141.810883] Dynamic subtest vcs1: SUCCESS (4.988s)
[141.822138] Starting dynamic subtest: vecs0
[147.828340] Dynamic subtest vecs0: SUCCESS (6.015s)
[147.845161] Starting dynamic subtest: ccs0
[153.843943] Dynamic subtest ccs0: SUCCESS (6.013s)
[153.846928] Subtest engine-error-state-capture: SUCCESS (32.137s)
[154.008320] [023/133] (868s left) gem_exec_async (concurrent-writes)
[154.096204] Starting subtest: concurrent-writes
[154.099015] Starting dynamic subtest: rcs0
[154.126988] Dynamic subtest rcs0: SUCCESS (0.031s)
[154.137813] Starting dynamic subtest: bcs0
[154.139759] Dynamic subtest bcs0: SUCCESS (0.008s)
[154.148073] Starting dynamic subtest: vcs0
[154.150380] Dynamic subtest vcs0: SUCCESS (0.006s)
[154.158552] Starting dynamic subtest: vcs1
[154.160784] Dynamic subtest vcs1: SUCCESS (0.008s)
[154.168898] Starting dynamic subtest: vecs0
[154.170870] Dynamic subtest vecs0: SUCCESS (0.007s)
[154.178327] Starting dynamic subtest: ccs0
[154.180238] Dynamic subtest ccs0: SUCCESS (0.008s)
[154.182166] Subtest concurrent-writes: SUCCESS (0.071s)
[154.394443] [024/133] (868s left) perf (gen8-unprivileged-single-ctx-counters)
[154.516153] Starting subtest: gen8-unprivileged-single-ctx-counters
[154.520640] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[154.557712] [025/133] (868s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[154.649064] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[154.653256] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s)
[154.742095] [026/133] (868s left) gem_exec_schedule (thriceslice)
[154.818568] Starting subtest: thriceslice
[154.820824] Starting dynamic subtest: rcs0
[154.843037] Dynamic subtest rcs0: SUCCESS (0.034s)
[154.853307] Starting dynamic subtest: bcs0
[154.874118] Dynamic subtest bcs0: SUCCESS (0.030s)
[154.886364] Starting dynamic subtest: vcs0
[154.904124] Dynamic subtest vcs0: SUCCESS (0.029s)
[154.911505] Starting dynamic subtest: vcs1
[154.933146] Dynamic subtest vcs1: SUCCESS (0.028s)
[154.940564] Starting dynamic subtest: vecs0
[154.984605] Dynamic subtest vecs0: SUCCESS (0.050s)
[154.995753] Starting dynamic subtest: ccs0
[155.016532] Dynamic subtest ccs0: SUCCESS (0.031s)
[155.018619] Subtest thriceslice: SUCCESS (0.209s)
[155.338780] [027/133] (867s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[155.429214] Starting subtest: disable-crc-after-crtc
[155.431621] Starting dynamic subtest: pipe-A-eDP-1
[157.094926] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.666s)
[157.103548] Starting dynamic subtest: pipe-B-eDP-1
[159.443806] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.346s)
[159.453264] Starting dynamic subtest: pipe-C-eDP-1
[161.719928] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.274s)
[161.729068] Starting dynamic subtest: pipe-D-eDP-1
[163.992234] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.273s)
[163.994436] Subtest disable-crc-after-crtc: SUCCESS (8.565s)
[164.805381] [028/133] (858s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[164.890250] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[164.892474] Starting dynamic subtest: pipe-A-eDP-1
[164.915080] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[164.925634] Starting dynamic subtest: pipe-B-eDP-1
[164.947209] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[164.954934] Starting dynamic subtest: pipe-C-eDP-1
[164.976204] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[164.984139] Starting dynamic subtest: pipe-D-eDP-1
[165.005527] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[165.009542] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[167.076246] [029/133] (856s left) gem_render_copy_redux (normal)
[167.152295] Starting subtest: normal
[167.458469] Subtest normal: SUCCESS (0.309s)
[167.586667] [030/133] (855s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[167.685408] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[167.689975] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[167.774673] [031/133] (855s left) kms_big_fb (linear-32bpp-rotate-180)
[167.864056] Starting subtest: linear-32bpp-rotate-180
[169.431695] Subtest linear-32bpp-rotate-180: SUCCESS (1.568s)
[169.561083] [032/133] (853s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[169.622385] Starting subtest: etime-multi-wait-all-for-submit-submitted
[169.729288] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.106s)
[169.818061] [033/133] (853s left) gem_mmap_wc (write-wc-read-gtt)
[169.877382] Subtest write-wc-read-gtt: SKIP (0.000s)
[169.943952] [034/133] (853s left) gem_exec_capture (capture)
[169.995768] Starting subtest: capture
[169.998050] Starting dynamic subtest: rcs0-smem
[170.829596] Dynamic subtest rcs0-smem: SUCCESS (0.830s)
[170.837752] Starting dynamic subtest: bcs0-smem
[171.654636] Dynamic subtest bcs0-smem: SUCCESS (0.824s)
[171.664099] Starting dynamic subtest: vcs0-smem
[172.471825] Dynamic subtest vcs0-smem: SUCCESS (0.816s)
[172.481539] Starting dynamic subtest: vcs1-smem
[173.789966] Dynamic subtest vcs1-smem: SUCCESS (1.318s)
[173.799902] Starting dynamic subtest: vecs0-smem
[174.675514] Dynamic subtest vecs0-smem: FAIL (0.826s)
[174.685166] Starting dynamic subtest: ccs0-smem
[175.935467] Dynamic subtest ccs0-smem: SUCCESS (1.320s)
[175.937635] Subtest capture: FAIL (5.938s)
[176.053041] [035/133] (847s left) kms_pwrite_crc
[177.707292] [036/133] (845s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[177.822463] Starting subtest: cursorB-vs-flipB-atomic-transitions
[177.827066] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[177.963840] [037/133] (845s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[178.069949] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[178.074373] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[178.155307] [038/133] (845s left) kms_dp_aux_dev (basic)
[178.203870] Starting subtest: basic
[178.424932] Subtest basic: SUCCESS (0.221s)
[178.499830] [039/133] (845s left) syncobj_wait (wait-any-complex)
[178.557545] Starting subtest: wait-any-complex
[178.617234] Subtest wait-any-complex: SUCCESS (0.061s)
[178.707540] [040/133] (844s left) i915_query (query-topology-coherent-slice-mask)
[178.760042] Starting subtest: query-topology-coherent-slice-mask
[178.764402] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[178.850375] [041/133] (844s left) kms_flip (flip-vs-panning)
[178.944755] Starting subtest: flip-vs-panning
[178.947071] Starting dynamic subtest: A-eDP1
[187.641803] Dynamic subtest A-eDP1: SUCCESS (8.698s)
[187.649942] Starting dynamic subtest: B-eDP1
[196.372100] Dynamic subtest B-eDP1: SUCCESS (8.728s)
[196.381903] Starting dynamic subtest: C-eDP1
[205.096989] Dynamic subtest C-eDP1: SUCCESS (8.723s)
[205.105093] Starting dynamic subtest: D-eDP1
[213.832978] Dynamic subtest D-eDP1: SUCCESS (8.734s)
[213.835294] Subtest flip-vs-panning: SUCCESS (34.891s)
[214.999843] [042/133] (808s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[215.094290] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[215.098662] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[215.193197] [043/133] (808s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[215.296868] Starting subtest: fbc-psr-sprite-mmap-gtt
[215.299178] Starting dynamic subtest: eDP-1
[215.303675] Dynamic subtest eDP-1: SKIP (0.000s)
[215.308150] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.002s)
[215.384493] [044/133] (808s left) gem_mmap_wc (close)
[215.438541] Subtest close: SKIP (0.000s)
[215.505062] [045/133] (808s left) gem_busy (extended)
[215.684052] Starting subtest: extended
[215.686499] Starting dynamic subtest: rcs0
[215.758616] Dynamic subtest rcs0: SUCCESS (0.074s)
[215.769044] Starting dynamic subtest: bcs0
[215.800554] Dynamic subtest bcs0: SUCCESS (0.040s)
[215.810274] Starting dynamic subtest: vcs0
[216.917380] Dynamic subtest vcs0: SUCCESS (1.112s)
[216.928733] Starting dynamic subtest: vcs1
[218.900298] Dynamic subtest vcs1: SUCCESS (1.980s)
[218.911027] Starting dynamic subtest: vecs0
[220.885335] Dynamic subtest vecs0: SUCCESS (1.982s)
[220.896530] Starting dynamic subtest: ccs0
[220.931865] Dynamic subtest ccs0: SUCCESS (0.045s)
[220.934406] Subtest extended: SUCCESS (5.249s)
[221.156058] [046/133] (802s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[221.262701] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[221.266934] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[221.359894] [047/133] (802s left) perf_pmu (rc6-all-gts)
[221.404151] Starting subtest: rc6-all-gts
[227.791657] Subtest rc6-all-gts: SUCCESS (6.387s)
[228.693904] [048/133] (795s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[228.801128] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[228.805252] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[228.882848] [049/133] (795s left) kms_flip (flip-vs-expired-vblank)
[228.970512] Starting subtest: flip-vs-expired-vblank
[228.972176] Starting dynamic subtest: A-eDP1
[237.700823] Dynamic subtest A-eDP1: SUCCESS (8.727s)
[237.710263] Starting dynamic subtest: B-eDP1
[246.352440] Dynamic subtest B-eDP1: SUCCESS (8.648s)
[246.365506] Starting dynamic subtest: C-eDP1
[254.992516] Dynamic subtest C-eDP1: SUCCESS (8.637s)
[255.004141] Starting dynamic subtest: D-eDP1
[263.610523] Dynamic subtest D-eDP1: SUCCESS (8.616s)
[263.613249] Subtest flip-vs-expired-vblank: SUCCESS (34.640s)
[264.782724] [050/133] (759s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[264.872963] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[268.754271] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.885s)
[269.879055] [051/133] (754s left) gem_exec_await (wide-all)
[270.093871] Starting subtest: wide-all
[293.816196] Subtest wide-all: SUCCESS (23.721s)
[294.023121] [052/133] (730s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[294.160591] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[301.686368] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.528s)
[301.812682] [053/133] (722s left) kms_color (invalid-ctm-matrix-sizes)
[301.913734] Starting subtest: invalid-ctm-matrix-sizes
[301.915921] Starting dynamic subtest: pipe-A
[301.918244] Dynamic subtest pipe-A: SUCCESS (0.002s)
[301.927860] Starting dynamic subtest: pipe-B
[301.930142] Dynamic subtest pipe-B: SUCCESS (0.003s)
[301.939053] Starting dynamic subtest: pipe-C
[301.941258] Dynamic subtest pipe-C: SUCCESS (0.004s)
[301.949727] Starting dynamic subtest: pipe-D
[301.951642] Dynamic subtest pipe-D: SUCCESS (0.004s)
[301.953917] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.016s)
[301.999972] [054/133] (722s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[302.102193] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[306.692342] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.593s)
[307.906399] [055/133] (716s left) perf (gen12-unprivileged-single-ctx-counters)
[308.029766] Starting subtest: gen12-unprivileged-single-ctx-counters
[308.032186] Starting dynamic subtest: rcs0
[308.066605] Dynamic subtest rcs0: SUCCESS (0.036s)
[308.069079] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.037s)
[308.114011] [056/133] (716s left) kms_chamelium_hpd (dp-hpd)
[308.525774] Subtest dp-hpd: SKIP (0.000s)
[309.303106] [057/133] (715s left) kms_lease (empty-lease)
[309.404059] Starting subtest: empty-lease
[309.406533] Starting dynamic subtest: pipe-A-eDP-1
[309.408655] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[309.420077] Starting dynamic subtest: pipe-B-eDP-1
[309.422233] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.003s)
[309.431311] Starting dynamic subtest: pipe-C-eDP-1
[309.433456] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[309.442525] Starting dynamic subtest: pipe-D-eDP-1
[309.444671] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[309.446885] Subtest empty-lease: SUCCESS (0.021s)
[309.534106] [058/133] (714s left) kms_vblank (ts-continuation-idle)
[309.631299] Starting subtest: ts-continuation-idle
[309.633562] Starting dynamic subtest: pipe-A-eDP-1
[310.040132] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.407s)
[310.054367] Starting dynamic subtest: pipe-D-eDP-1
[311.114103] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.071s)
[311.116468] Subtest ts-continuation-idle: SUCCESS (1.483s)
[311.980502] [059/133] (712s left) i915_query (query-regions-unallocated)
[312.044624] Starting subtest: query-regions-unallocated
[312.047099] Subtest query-regions-unallocated: SUCCESS (0.000s)
[312.155426] [060/133] (712s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[312.269658] Starting subtest: 4-tiled-64bpp-rotate-0
[313.748760] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.480s)
[313.940374] [061/133] (710s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[314.039881] Starting subtest: psr-rgb565-draw-pwrite
[321.142711] Subtest psr-rgb565-draw-pwrite: SUCCESS (7.107s)
[321.268965] [062/133] (703s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[321.362983] Starting subtest: 2x-absolute-wf_vblank-interruptible
[321.374430] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.010s)
[321.464452] [063/133] (703s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[321.557363] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[321.561754] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[321.641323] [064/133] (703s left) kms_vblank (accuracy-idle)
[321.739949] Starting subtest: accuracy-idle
[321.742196] Starting dynamic subtest: pipe-A-eDP-1
[323.492060] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.753s)
[323.510020] Starting dynamic subtest: pipe-D-eDP-1
[325.928365] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.434s)
[325.930774] Subtest accuracy-idle: SUCCESS (4.190s)
[326.744717] [065/133] (697s left) gem_flink_basic (basic)
[326.801533] Starting subtest: basic
[326.803503] Subtest basic: SUCCESS (0.000s)
[326.894053] [066/133] (697s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[326.994753] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[326.998903] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[327.110940] [067/133] (697s left) kms_properties (colorop-properties-legacy)
[327.196950] Starting subtest: colorop-properties-legacy
[327.199270] Starting dynamic subtest: pipe-A-eDP-1
[327.536975] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.339s)
[327.546158] Starting dynamic subtest: pipe-B-eDP-1
[328.610962] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.074s)
[328.620788] Starting dynamic subtest: pipe-C-eDP-1
[329.655413] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.042s)
[329.664770] Starting dynamic subtest: pipe-D-eDP-1
[330.691786] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.037s)
[330.694214] Subtest colorop-properties-legacy: SUCCESS (3.496s)
[331.499643] [068/133] (693s left) syncobj_timeline (wait-any-snapshot)
[331.557041] Starting subtest: wait-any-snapshot
[331.640907] Subtest wait-any-snapshot: SUCCESS (0.083s)
[331.742477] [069/133] (693s left) gem_linear_blits (interruptible)
[331.935573] Starting subtest: interruptible
[336.328029] Subtest interruptible: SUCCESS (4.393s)
[336.455688] [070/133] (688s left) gem_pxp (protected-raw-src-copy-not-readible)
[336.605030] Starting subtest: protected-raw-src-copy-not-readible
[336.684395] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.082s)
[336.788932] [071/133] (688s left) gem_exec_fence (syncobj-repeat)
[337.268036] Starting subtest: syncobj-repeat
[337.458402] Subtest syncobj-repeat: SUCCESS (0.188s)
[338.977833] [072/133] (686s left) gem_exec_params (rel-constants-invalid)
[339.041575] Starting subtest: rel-constants-invalid
[339.043887] Subtest rel-constants-invalid: SUCCESS (0.000s)
[339.145417] [073/133] (685s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[339.248490] Starting subtest: yf-tiled-addfb-size-offset-overflow
[339.252659] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[339.362494] [074/133] (685s left) kms_pm_rpm (fences)
[341.027079] Starting subtest: fences
[341.032633] Subtest fences: SKIP (0.000s)
[341.647553] [075/133] (683s left) gen9_exec_parse (basic-rejected)
[341.715721] Subtest basic-rejected: SKIP (0.000s)
[341.792654] [076/133] (683s left) gem_exec_params (dr4-dirt)
[341.855205] Starting subtest: DR4-dirt
[341.857586] Subtest DR4-dirt: SUCCESS (0.000s)
[341.956488] [077/133] (683s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[342.016722] Starting subtest: map-fixed-invalidate-overlap-busy
[342.021235] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[342.138543] [078/133] (683s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[342.382785] Starting subtest: cursor-rapid-movement-256x256
[342.390254] Starting dynamic subtest: pipe-A-eDP-1
[342.936653] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.548s)
[342.967327] Starting dynamic subtest: pipe-D-eDP-1
[344.173197] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.213s)
[344.174998] Subtest cursor-rapid-movement-256x256: SUCCESS (1.789s)
[345.005508] [079/133] (680s left) kms_flip (bo-too-big-interruptible)
[345.105987] Starting subtest: bo-too-big-interruptible
[345.108240] Starting dynamic subtest: A-eDP1
[346.390558] Dynamic subtest A-eDP1: SUCCESS (1.282s)
[346.402083] Starting dynamic subtest: B-eDP1
[347.707477] Dynamic subtest B-eDP1: SUCCESS (1.316s)
[347.720967] Starting dynamic subtest: C-eDP1
[349.046556] Dynamic subtest C-eDP1: SUCCESS (1.337s)
[349.060171] Starting dynamic subtest: D-eDP1
[350.373061] Dynamic subtest D-eDP1: SUCCESS (1.324s)
[350.375669] Subtest bo-too-big-interruptible: SUCCESS (5.269s)
[351.581352] [080/133] (673s left) gem_userptr_blits (nohangcheck)
[351.649862] Starting subtest: nohangcheck
[351.891704] Subtest nohangcheck: SUCCESS (0.239s)
[351.994719] [081/133] (673s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[352.094653] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[352.096912] Starting dynamic subtest: pipe-A-eDP-1
[368.583277] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.490s)
[368.593581] Starting dynamic subtest: pipe-B-eDP-1
[385.739493] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.156s)
[385.741879] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.649s)
[386.553581] [082/133] (638s left) gem_exec_schedule (preemptive-hang)
[386.742713] Starting subtest: preemptive-hang
[386.744962] Starting dynamic subtest: rcs0
[396.034562] Dynamic subtest rcs0: SUCCESS (9.294s)
[396.046080] Starting dynamic subtest: bcs0
[405.051929] Dynamic subtest bcs0: SUCCESS (9.018s)
[405.061118] Starting dynamic subtest: vcs0
[414.012258] Dynamic subtest vcs0: SUCCESS (8.957s)
[414.027813] Starting dynamic subtest: vcs1
[423.036906] Dynamic subtest vcs1: SUCCESS (9.021s)
[423.047444] Starting dynamic subtest: vecs0
[431.993530] Dynamic subtest vecs0: SUCCESS (8.952s)
[432.004503] Starting dynamic subtest: ccs0
[441.093250] Dynamic subtest ccs0: SUCCESS (9.099s)
[441.095453] Subtest preemptive-hang: SUCCESS (54.350s)
[441.332597] [083/133] (584s left) gem_partial_pwrite_pread (reads-snoop)
[441.392778] Subtest reads-snoop: SKIP (0.000s)
[441.459266] [084/133] (584s left) kms_dsc (dsc-with-formats)
[441.568048] Starting subtest: dsc-with-formats
[441.608089] Subtest dsc-with-formats: SKIP (0.001s)
[441.648980] [085/133] (583s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[441.758852] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[441.763272] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[441.867067] [086/133] (583s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[441.961773] Starting subtest: fbcpsr-tiling-y
[441.965999] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[442.062766] [087/133] (583s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[442.173503] Starting subtest: cursorB-vs-flipA-toggle
[442.178071] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[442.335452] [088/133] (583s left) drm_mm (drm_mm)
[442.378112] Starting subtest: drm_mm
[442.395309] Starting dynamic subtest: drm_test_mm_init
[442.487190] Dynamic subtest drm_test_mm_init: SUCCESS (0.091s)
[442.497400] Starting dynamic subtest: drm_test_mm_debug
[442.573601] Dynamic subtest drm_test_mm_debug: SUCCESS (0.083s)
[442.584159] Starting dynamic subtest: drm_test_mm_align32
[442.664474] Dynamic subtest drm_test_mm_align32: SUCCESS (0.091s)
[442.674471] Starting dynamic subtest: drm_test_mm_align64
[442.759459] Dynamic subtest drm_test_mm_align64: SUCCESS (0.095s)
[442.769771] Starting dynamic subtest: drm_test_mm_lowest
[442.870223] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.109s)
[442.880554] Starting dynamic subtest: drm_test_mm_highest
[442.970361] Dynamic subtest drm_test_mm_highest: SUCCESS (0.097s)
[442.972033] Subtest drm_mm: SUCCESS (0.590s)
[443.133623] [089/133] (582s left) gem_mmap_offset (blt-coherency)
[443.184881] Starting subtest: blt-coherency
[443.191185] Subtest blt-coherency: SUCCESS (0.008s)
[443.321827] [090/133] (582s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[443.425031] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[450.508782] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.085s)
[450.609938] [091/133] (575s left) gem_exec_reloc (basic-wc)
[450.667767] Subtest basic-wc: SKIP (0.000s)
[450.743684] [092/133] (575s left) kms_cdclk (mode-transition-all-outputs)
[450.839149] Starting subtest: mode-transition-all-outputs
[451.126417] Subtest mode-transition-all-outputs: SKIP (0.286s)
[451.981512] [093/133] (573s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[452.082041] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[452.086543] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[452.175210] [094/133] (573s left) kms_plane (pixel-format-4-tiled-modifier)
[452.266201] Starting subtest: pixel-format-4-tiled-modifier
[452.292555] Starting dynamic subtest: pipe-A-plane-0
[452.969566] Dynamic subtest pipe-A-plane-0: SUCCESS (0.677s)
[452.978825] Starting dynamic subtest: pipe-A-plane-3
[453.414066] Dynamic subtest pipe-A-plane-3: SUCCESS (0.443s)
[453.425427] Starting dynamic subtest: pipe-A-plane-5
[453.429279] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[454.473130] Starting dynamic subtest: pipe-B-plane-0
[455.165323] Dynamic subtest pipe-B-plane-0: SUCCESS (0.700s)
[455.177085] Starting dynamic subtest: pipe-B-plane-3
[455.619983] Dynamic subtest pipe-B-plane-3: SUCCESS (0.455s)
[455.631821] Starting dynamic subtest: pipe-B-plane-5
[455.635534] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[455.928408] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.664s)
[456.752055] [095/133] (569s left) syncobj_timeline (wait-all-for-submit-complex)
[456.812204] Starting subtest: wait-all-for-submit-complex
[457.026025] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[457.100890] [096/133] (568s left) prime_mmap_coherency (read)
[457.156333] Starting subtest: read
[462.532468] Subtest read: SUCCESS (5.374s)
[462.674897] [097/133] (563s left) gem_exec_whisper (basic-normal-all)
[462.734951] Starting subtest: basic-normal-all
[466.142454] Subtest basic-normal-all: SUCCESS (3.407s)
[466.333808] [098/133] (559s left) gem_ctx_engines (execute-oneforall)
[466.402610] Starting subtest: execute-oneforall
[467.622838] Subtest execute-oneforall: SUCCESS (1.218s)
[468.072995] [099/133] (558s left) gem_mmap (bad-offset)
[468.133472] Subtest bad-offset: SKIP (0.000s)
[468.195219] [100/133] (558s left) kms_content_protection (lic-type-1)
[468.342554] Starting subtest: lic-type-1
[468.347081] Subtest lic-type-1: SKIP (0.000s)
[468.465729] [101/133] (557s left) core_auth (many-magics)
[468.515815] Starting subtest: many-magics
[469.432615] Subtest many-magics: SUCCESS (0.919s)
[469.551151] [102/133] (556s left) syncobj_wait (single-wait-all-signaled)
[469.610473] Starting subtest: single-wait-all-signaled
[469.612452] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[469.701236] [103/133] (556s left) gem_ctx_persistence (legacy-engines-hostile)
[469.765671] Starting subtest: legacy-engines-hostile
[469.767576] Starting dynamic subtest: render
[469.909188] Dynamic subtest render: SUCCESS (0.143s)
[469.920860] Starting dynamic subtest: bsd1
[470.014597] Dynamic subtest bsd1: SUCCESS (0.102s)
[470.028710] Starting dynamic subtest: bsd2
[470.120298] Dynamic subtest bsd2: SUCCESS (0.103s)
[470.133502] Starting dynamic subtest: blt
[470.220605] Dynamic subtest blt: SUCCESS (0.097s)
[470.235324] Starting dynamic subtest: vebox
[470.335654] Dynamic subtest vebox: SUCCESS (0.112s)
[470.338253] Subtest legacy-engines-hostile: SUCCESS (0.571s)
[470.426677] [104/133] (555s left) kms_joiner (basic-max-non-joiner)
[470.530464] Starting subtest: basic-max-non-joiner
[470.534085] Subtest basic-max-non-joiner: SKIP (0.000s)
[470.615692] [105/133] (555s left) core_auth (getclient-master-drop)
[470.652900] Starting subtest: getclient-master-drop
[470.672458] Subtest getclient-master-drop: SUCCESS (0.022s)
[470.780005] [106/133] (555s left) kms_psr (fbc-psr2-cursor-plane-move)
[470.878164] Starting subtest: fbc-psr2-cursor-plane-move
[470.880036] Starting dynamic subtest: eDP-1
[470.883519] Dynamic subtest eDP-1: SKIP (0.000s)
[470.886975] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[470.951132] [107/133] (555s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[471.044220] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[471.046052] Starting dynamic subtest: pipe-A-default-mode
[473.816355] Dynamic subtest pipe-A-default-mode: SUCCESS (2.771s)
[473.818859] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.773s)
[474.650817] [108/133] (551s left) kms_cursor_crc (cursor-sliding-512x170)
[474.946950] Starting subtest: cursor-sliding-512x170
[474.951422] Subtest cursor-sliding-512x170: SKIP (0.001s)
[475.082163] [109/133] (551s left) kms_chamelium_edid (dp-mode-timings)
[475.477662] Subtest dp-mode-timings: SKIP (0.000s)
[476.271869] [110/133] (550s left) gem_exec_balancer (noheartbeat)
[476.538540] Starting subtest: noheartbeat
[476.543530] Subtest noheartbeat: SKIP (0.000s)
[476.639939] [111/133] (550s left) i915_pm_rpm (system-suspend)
[478.184833] Starting subtest: system-suspend
[496.074098] Subtest system-suspend: SUCCESS (3.013s)
[496.481823] [112/133] (530s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[496.569505] Starting subtest: y-tiled-ccs-to-y-tiled
[496.574528] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[496.771682] [113/133] (529s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[496.863738] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[496.866025] Starting dynamic subtest: pipe-A-eDP-1
[496.887477] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[496.901862] Starting dynamic subtest: pipe-B-eDP-1
[496.920850] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[496.930691] Starting dynamic subtest: pipe-C-eDP-1
[496.950035] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[496.959902] Starting dynamic subtest: pipe-D-eDP-1
[496.978854] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[496.980725] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[499.132649] [114/133] (527s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[499.183441] Starting subtest: etime-multi-wait-for-submit-submitted
[499.286490] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.101s)
[499.370375] [115/133] (527s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[499.472212] Starting subtest: x-tiled-8bpp-rotate-0
[500.730812] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.226s)
[500.849253] [116/133] (526s left) syncobj_basic (bad-destroy-pad)
[500.905135] Starting subtest: bad-destroy-pad
[500.907074] Subtest bad-destroy-pad: SUCCESS (0.000s)
[501.029561] [117/133] (525s left) kms_cursor_crc (cursor-size-change)
[501.130771] Starting subtest: cursor-size-change
[501.132696] Starting dynamic subtest: pipe-A-eDP-1
[501.938297] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.788s)
[501.948955] Starting dynamic subtest: pipe-D-eDP-1
[503.385781] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.419s)
[503.387958] Subtest cursor-size-change: SUCCESS (2.210s)
[504.203399] [118/133] (522s left) syncobj_timeline (invalid-transfer-bad-pad)
[504.268084] Starting subtest: invalid-transfer-bad-pad
[504.270364] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[504.373719] [119/133] (522s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[504.470902] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[504.474817] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[504.578444] [120/133] (522s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[504.679991] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[504.764099] [121/133] (522s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[504.869915] Starting subtest: modeset-transition-nonblocking-fencing
[504.871844] Starting dynamic subtest: 1x-outputs
[515.982226] Dynamic subtest 1x-outputs: SUCCESS (11.029s)
[515.985057] Subtest modeset-transition-nonblocking-fencing: SUCCESS (11.030s)
[516.853202] [122/133] (510s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[518.871029] Starting subtest: modeset-non-lpsp-stress-no-wait
[518.913260] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.040s)
[519.269227] [123/133] (507s left) gem_softpin (allocator-evict)
[519.319880] Starting subtest: allocator-evict
[519.322168] Starting dynamic subtest: rcs0
[542.637844] Dynamic subtest rcs0: SUCCESS (23.293s)
[542.649938] Starting dynamic subtest: bcs0
[566.627806] Dynamic subtest bcs0: SUCCESS (23.974s)
[566.639763] Starting dynamic subtest: vcs0
[590.446962] Dynamic subtest vcs0: SUCCESS (23.806s)
[590.457767] Starting dynamic subtest: vcs1
[613.886556] Dynamic subtest vcs1: SUCCESS (23.443s)
[613.899199] Starting dynamic subtest: vecs0
[637.373420] Dynamic subtest vecs0: SUCCESS (23.484s)
[637.384830] Starting dynamic subtest: ccs0
[661.144068] Dynamic subtest ccs0: SUCCESS (23.764s)
[661.146764] Subtest allocator-evict: SUCCESS (141.773s)
[661.229502] [124/133] (366s left) gem_eio (execbuf)
[661.528115] Starting subtest: execbuf
[661.901038] Subtest execbuf: SUCCESS (0.372s)
[662.025893] [125/133] (365s left) kms_psr (pr-sprite-mmap-gtt)
[662.126176] Starting subtest: pr-sprite-mmap-gtt
[662.129741] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[662.199643] [126/133] (365s left) prime_busy (after-wait)
[662.260653] Starting subtest: after-wait
[662.265164] Starting dynamic subtest: rcs0
[662.297810] Dynamic subtest rcs0: SUCCESS (0.034s)
[662.310007] Starting dynamic subtest: bcs0
[662.338639] Dynamic subtest bcs0: SUCCESS (0.040s)
[662.348643] Starting dynamic subtest: vcs0
[662.379750] Dynamic subtest vcs0: SUCCESS (0.040s)
[662.390215] Starting dynamic subtest: vcs1
[662.419728] Dynamic subtest vcs1: SUCCESS (0.039s)
[662.429394] Starting dynamic subtest: vecs0
[662.460096] Dynamic subtest vecs0: SUCCESS (0.040s)
[662.470103] Starting dynamic subtest: ccs0
[662.500822] Dynamic subtest ccs0: SUCCESS (0.040s)
[662.610160] Subtest after-wait: SUCCESS (0.347s)
[662.687863] [127/133] (364s left) kms_cursor_crc (cursor-offscreen-256x256)
[662.948542] Starting subtest: cursor-offscreen-256x256
[662.950834] Starting dynamic subtest: pipe-A-eDP-1
[664.906358] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.956s)
[664.961191] Starting dynamic subtest: pipe-D-eDP-1
[667.486459] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.533s)
[667.488870] Subtest cursor-offscreen-256x256: SUCCESS (4.538s)
[668.342651] [128/133] (359s left) kms_fbcon_fbt (psr)
[668.402254] Starting subtest: psr
[675.785643] Subtest psr: SUCCESS (7.379s)
[675.865808] [129/133] (351s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[675.957920] Starting subtest: crc-primary-basic-y-tiled-ccs
[675.960300] Starting dynamic subtest: pipe-A-eDP-1
[675.983390] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[675.996290] Starting dynamic subtest: pipe-B-eDP-1
[676.017900] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[676.027747] Starting dynamic subtest: pipe-C-eDP-1
[676.050054] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[676.059806] Starting dynamic subtest: pipe-D-eDP-1
[676.081650] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[676.085976] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s)
[678.281988] [130/133] (349s left) api_intel_allocator (fork-simple-stress)
[678.337620] Starting subtest: fork-simple-stress
[683.737573] Subtest fork-simple-stress: SUCCESS (5.399s)
[683.911310] [131/133] (343s left) gem_exec_reloc (basic-write-gtt)
[683.991212] Subtest basic-write-gtt: SKIP (0.000s)
[684.081164] [132/133] (343s left) syncobj_timeline (multi-wait-for-submit-signaled)
[684.155275] Starting subtest: multi-wait-for-submit-signaled
[684.157817] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[684.290730] [133/133] (343s left) gem_ringfill (legacy-basic)
[689.778515] Starting subtest: legacy-basic
[689.781122] Starting dynamic subtest: default
[689.860184] Dynamic subtest default: SUCCESS (0.082s)
[689.875104] Starting dynamic subtest: render
[689.903198] Dynamic subtest render: SUCCESS (0.040s)
[689.915833] Starting dynamic subtest: bsd
[689.947007] Dynamic subtest bsd: SUCCESS (0.041s)
[689.957875] Starting dynamic subtest: bsd1
[689.987997] Dynamic subtest bsd1: SUCCESS (0.038s)
[689.999271] Starting dynamic subtest: bsd2
[690.033514] Dynamic subtest bsd2: SUCCESS (0.043s)
[690.044717] Starting dynamic subtest: blt
[690.079437] Dynamic subtest blt: SUCCESS (0.044s)
[690.092357] Starting dynamic subtest: vebox
[690.123403] Dynamic subtest vebox: SUCCESS (0.042s)
[690.128426] Subtest legacy-basic: SUCCESS (0.347s)
[690.215695] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_atomic_interruptible
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_getfb
results: parsing output: 6/ for test: kms_plane_scaling
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: gem_ctx_param
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: vgem_basic
results: parsing output: 13/ for test: kms_plane
results: parsing output: 14/ for test: i915_drm_fdinfo
results: parsing output: 15/ for test: gem_exec_reloc
results: parsing output: 16/ for test: gem_exec_schedule
results: parsing output: 17/ for test: gem_eio
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_lmem_evict
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: i915_hangman
results: parsing output: 22/ for test: gem_exec_async
results: parsing output: 23/ for test: perf
results: parsing output: 24/ for test: kms_plane
results: parsing output: 25/ for test: gem_exec_schedule
results: parsing output: 26/ for test: kms_pipe_crc_basic
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: gem_render_copy_redux
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: gem_mmap_wc
results: parsing output: 33/ for test: gem_exec_capture
results: parsing output: 34/ for test: kms_pwrite_crc
results: parsing output: 35/ for test: kms_cursor_legacy
results: parsing output: 36/ for test: kms_flip_scaled_crc
results: parsing output: 37/ for test: kms_dp_aux_dev
results: parsing output: 38/ for test: syncobj_wait
results: parsing output: 39/ for test: i915_query
results: parsing output: 40/ for test: kms_flip
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: gem_mmap_wc
results: parsing output: 44/ for test: gem_busy
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: perf_pmu
results: parsing output: 47/ for test: kms_psr2_sf
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_exec_await
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_color
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: perf
results: parsing output: 55/ for test: kms_chamelium_hpd
results: parsing output: 56/ for test: kms_lease
results: parsing output: 57/ for test: kms_vblank
results: parsing output: 58/ for test: i915_query
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_flip
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_vblank
results: parsing output: 64/ for test: gem_flink_basic
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_properties
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: gem_linear_blits
results: parsing output: 69/ for test: gem_pxp
results: parsing output: 70/ for test: gem_exec_fence
results: parsing output: 71/ for test: gem_exec_params
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_pm_rpm
results: parsing output: 74/ for test: gen9_exec_parse
results: parsing output: 75/ for test: gem_exec_params
results: parsing output: 76/ for test: gem_userptr_blits
results: parsing output: 77/ for test: kms_cursor_crc
results: parsing output: 78/ for test: kms_flip
results: parsing output: 79/ for test: gem_userptr_blits
results: parsing output: 80/ for test: kms_psr2_sf
results: parsing output: 81/ for test: gem_exec_schedule
results: parsing output: 82/ for test: gem_partial_pwrite_pread
results: parsing output: 83/ for test: kms_dsc
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_cursor_legacy
results: parsing output: 87/ for test: drm_mm
results: parsing output: 88/ for test: gem_mmap_offset
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gem_exec_reloc
results: parsing output: 91/ for test: kms_cdclk
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_plane
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: prime_mmap_coherency
results: parsing output: 96/ for test: gem_exec_whisper
results: parsing output: 97/ for test: gem_ctx_engines
results: parsing output: 98/ for test: gem_mmap
results: parsing output: 99/ for test: kms_content_protection
results: parsing output: 100/ for test: core_auth
results: parsing output: 101/ for test: syncobj_wait
results: parsing output: 102/ for test: gem_ctx_persistence
results: parsing output: 103/ for test: kms_joiner
results: parsing output: 104/ for test: core_auth
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: kms_flip_scaled_crc
results: parsing output: 107/ for test: kms_cursor_crc
results: parsing output: 108/ for test: kms_chamelium_edid
results: parsing output: 109/ for test: gem_exec_balancer
results: parsing output: 110/ for test: i915_pm_rpm
results: parsing output: 111/ for test: gem_render_copy
results: parsing output: 112/ for test: kms_ccs
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: syncobj_basic
results: parsing output: 116/ for test: kms_cursor_crc
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: kms_addfb_basic
results: parsing output: 120/ for test: kms_atomic_transition
results: parsing output: 121/ for test: kms_pm_rpm
results: parsing output: 122/ for test: gem_softpin
results: parsing output: 123/ for test: gem_eio
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: prime_busy
results: parsing output: 126/ for test: kms_cursor_crc
results: parsing output: 127/ for test: kms_fbcon_fbt
results: parsing output: 128/ for test: kms_ccs
results: parsing output: 129/ for test: api_intel_allocator
results: parsing output: 130/ for test: gem_exec_reloc
results: parsing output: 131/ for test: syncobj_timeline
results: parsing output: 132/ for test: gem_ringfill
Done.