[51.253325] Initializing watchdogs
[51.253385]   /dev/watchdog0
[51.268175] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[51.273118] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[51.275506] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[51.277361] [001/130] (960s left) kms_sequence (get-forked)
[51.448865] Starting subtest: get-forked
[51.449611] Starting dynamic subtest: pipe-A-HDMI-A-1
[52.705289] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.256s)
[52.710646] Starting dynamic subtest: pipe-B-HDMI-A-1
[53.953294] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.246s)
[53.958806] Starting dynamic subtest: pipe-C-HDMI-A-1
[55.210009] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.255s)
[55.215189] Starting dynamic subtest: pipe-D-HDMI-A-1
[56.472808] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.261s)
[56.473534] Subtest get-forked: SUCCESS (5.024s)
[56.577909] [002/130] (955s left) prime_busy (after)
[56.622199] Starting subtest: after
[56.628164] Starting dynamic subtest: rcs0
[56.665546] Dynamic subtest rcs0: SUCCESS (0.037s)
[56.672624] Starting dynamic subtest: bcs0
[56.688042] Dynamic subtest bcs0: SUCCESS (0.022s)
[56.696612] Starting dynamic subtest: vcs0
[56.713886] Dynamic subtest vcs0: SUCCESS (0.025s)
[56.724046] Starting dynamic subtest: vcs1
[56.736199] Dynamic subtest vcs1: SUCCESS (0.022s)
[56.746120] Starting dynamic subtest: vecs0
[56.755498] Dynamic subtest vecs0: SUCCESS (0.019s)
[56.875173] Subtest after: SUCCESS (0.244s)
[56.937925] [003/130] (954s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[57.038627] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[57.040043] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[57.120562] [004/130] (954s left) kms_psr (pr-cursor-plane-move)
[57.207352] Subtest pr-cursor-plane-move: SKIP (0.000s)
[57.237472] [005/130] (954s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[57.278210] Starting subtest: untiled-to-tiled
[57.410128] Subtest untiled-to-tiled: SUCCESS (0.122s)
[57.506433] [006/130] (954s left) gem_flink_race (flink_name)
[57.541593] Starting subtest: flink_name
[62.949706] Subtest flink_name: SUCCESS (5.373s)
[63.035384] [007/130] (948s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[63.135174] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[63.143835] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.009s)
[63.206020] [008/130] (948s left) gem_workarounds (basic-read)
[63.253463] Starting subtest: basic-read
[63.260510] Subtest basic-read: SUCCESS (0.006s)
[63.374639] [009/130] (948s left) drm_fdinfo (busy-idle-check-all)
[63.413457] Starting subtest: busy-idle-check-all
[63.414155] Starting dynamic subtest: rcs0
[64.042682] Dynamic subtest rcs0: SUCCESS (0.629s)
[64.049043] Starting dynamic subtest: bcs0
[64.671250] Dynamic subtest bcs0: SUCCESS (0.628s)
[64.678323] Starting dynamic subtest: vcs0
[65.291378] Dynamic subtest vcs0: SUCCESS (0.620s)
[65.301744] Starting dynamic subtest: vcs1
[65.917169] Dynamic subtest vcs1: SUCCESS (0.626s)
[65.924618] Starting dynamic subtest: vecs0
[66.545526] Dynamic subtest vecs0: SUCCESS (0.628s)
[66.546864] Subtest busy-idle-check-all: SUCCESS (3.132s)
[66.605580] [010/130] (945s left) kms_cursor_crc (cursor-alpha-opaque)
[66.695078] Starting subtest: cursor-alpha-opaque
[66.695899] Starting dynamic subtest: pipe-A-HDMI-A-1
[66.993895] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.298s)
[67.001063] Starting dynamic subtest: pipe-D-HDMI-A-1
[67.261422] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.266s)
[67.262436] Subtest cursor-alpha-opaque: SUCCESS (0.568s)
[67.719053] [011/130] (944s left) kms_big_fb (linear-addfb)
[67.838103] Starting subtest: linear-addfb
[67.838942] Subtest linear-addfb: SUCCESS (0.000s)
[67.950014] [012/130] (944s left) gem_readwrite (new-obj)
[68.003866] Starting subtest: new-obj
[68.005394] Subtest new-obj: SUCCESS (0.000s)
[68.083761] [013/130] (944s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[68.172646] Starting subtest: cursor-vs-flip-legacy
[97.269809] Subtest cursor-vs-flip-legacy: SUCCESS (29.063s)
[97.354239] [014/130] (914s left) kms_psr (psr2-cursor-plane-move)
[97.447380] Subtest psr2-cursor-plane-move: SKIP (0.000s)
[97.479393] [015/130] (914s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[97.570836] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[99.233996] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (1.662s)
[99.372516] [016/130] (912s left) perf (non-zero-reason)
[99.445759] Starting subtest: non-zero-reason
[99.446520] Starting dynamic subtest: 0-rcs0
[107.115853] Dynamic subtest 0-rcs0: SUCCESS (7.636s)
[107.116852] Subtest non-zero-reason: SUCCESS (7.636s)
[107.146854] [017/130] (905s left) kms_joiner (invalid-modeset-big-joiner)
[107.238752] Starting subtest: invalid-modeset-big-joiner
[107.240134] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[107.288021] [018/130] (905s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[107.380782] Starting subtest: psr-1p-primscrn-cur-indfb-move
[107.382225] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[107.476592] [019/130] (904s left) gem_exec_capture (capture)
[107.516220] Starting subtest: capture
[107.516960] Starting dynamic subtest: rcs0-smem
[108.793956] Dynamic subtest rcs0-smem: SUCCESS (1.271s)
[108.798757] Starting dynamic subtest: bcs0-smem
[110.065424] Dynamic subtest bcs0-smem: SUCCESS (1.270s)
[110.070177] Starting dynamic subtest: vcs0-smem
[111.337404] Dynamic subtest vcs0-smem: SUCCESS (1.273s)
[111.342234] Starting dynamic subtest: vcs1-smem
[112.609379] Dynamic subtest vcs1-smem: SUCCESS (1.271s)
[112.614148] Starting dynamic subtest: vecs0-smem
[113.881385] Dynamic subtest vecs0-smem: SUCCESS (1.271s)
[113.882103] Subtest capture: SUCCESS (6.357s)
[113.981720] [020/130] (898s left) kms_vrr (lobf)
[114.073921] Starting subtest: lobf
[114.075373] Subtest lobf: SKIP (0.000s)
[114.121328] [021/130] (898s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[114.213755] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[114.248819] [022/130] (898s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[114.339688] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[114.341058] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[114.434717] [023/130] (898s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[114.527902] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[114.529386] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[114.609831] [024/130] (897s left) kms_cursor_crc (cursor-random-256x85)
[114.701885] Starting subtest: cursor-random-256x85
[114.706798] Starting dynamic subtest: pipe-A-HDMI-A-1
[115.941797] Dynamic subtest pipe-A-HDMI-A-1: FAIL (1.060s)
[115.948090] Starting dynamic subtest: pipe-D-HDMI-A-1
[117.760203] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.960s)
[117.760943] Subtest cursor-random-256x85: FAIL (3.059s)
[117.890766] [025/130] (894s left) gem_mmap_gtt (basic-write-read)
[117.931088] Starting subtest: basic-write-read
[117.941611] Subtest basic-write-read: SUCCESS (0.010s)
[118.033632] [026/130] (894s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[118.124180] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[118.124901] Starting dynamic subtest: pipe-A-HDMI-A-1
[118.127696] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[118.132666] Starting dynamic subtest: pipe-B-HDMI-A-1
[118.135387] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[118.140334] Starting dynamic subtest: pipe-C-HDMI-A-1
[118.143067] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[118.147789] Starting dynamic subtest: pipe-D-HDMI-A-1
[118.150501] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[118.151894] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SKIP (0.004s)
[118.348188] [027/130] (894s left) kms_big_fb (linear-16bpp-rotate-90)
[118.444240] Starting subtest: linear-16bpp-rotate-90
[118.515660] Subtest linear-16bpp-rotate-90: SKIP (0.071s)
[118.627797] [028/130] (894s left) gem_mmap_gtt (cpuset-big-copy-odd)
[118.663277] Starting subtest: cpuset-big-copy-odd
[133.405367] Subtest cpuset-big-copy-odd: SUCCESS (14.742s)
[133.497684] [029/130] (879s left) gem_partial_pwrite_pread (write-display)
[133.580072] Starting subtest: write-display
[143.420912] Subtest write-display: SUCCESS (9.841s)
[143.534017] [030/130] (869s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[143.625870] Starting subtest: plane-primary-toggle-with-vblank-wait
[143.626635] Starting dynamic subtest: pipe-A-HDMI-A-1
[143.748972] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.113s)
[143.790069] Starting dynamic subtest: pipe-B-HDMI-A-1
[143.905383] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.120s)
[143.931711] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (0.306s)
[144.061661] [031/130] (868s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[144.156619] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[144.157997] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[144.257265] [032/130] (868s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[144.346525] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[144.347901] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[144.439993] [033/130] (868s left) gem_pxp (hw-rejects-pxp-context)
[144.544397] Starting subtest: hw-rejects-pxp-context
[144.546567] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[144.615675] [034/130] (868s left) i915_pm_rpm (reg-read-ioctl)
[146.034137] Starting subtest: reg-read-ioctl
[148.371395] Subtest reg-read-ioctl: SUCCESS (2.339s)
[148.542379] [035/130] (864s left) gem_ctx_shared (q-independent)
[148.589138] Starting subtest: Q-independent
[148.589881] Starting dynamic subtest: rcs0
[148.618938] Dynamic subtest rcs0: SUCCESS (0.029s)
[148.625199] Starting dynamic subtest: bcs0
[148.635934] Dynamic subtest bcs0: SUCCESS (0.017s)
[148.641937] Starting dynamic subtest: vcs0
[148.652048] Dynamic subtest vcs0: SUCCESS (0.016s)
[148.657902] Starting dynamic subtest: vcs1
[148.667617] Dynamic subtest vcs1: SUCCESS (0.015s)
[148.674056] Starting dynamic subtest: vecs0
[148.684485] Dynamic subtest vecs0: SUCCESS (0.016s)
[148.685721] Subtest Q-independent: SUCCESS (0.095s)
[148.869666] [036/130] (864s left) kms_color (invalid-ctm-matrix-sizes)
[148.957542] Starting subtest: invalid-ctm-matrix-sizes
[148.958256] Starting dynamic subtest: pipe-A
[148.961102] Dynamic subtest pipe-A: SUCCESS (0.004s)
[148.966474] Starting dynamic subtest: pipe-B
[148.967175] Dynamic subtest pipe-B: SUCCESS (0.005s)
[148.972526] Starting dynamic subtest: pipe-C
[148.973217] Dynamic subtest pipe-C: SUCCESS (0.006s)
[148.978624] Starting dynamic subtest: pipe-D
[148.979334] Dynamic subtest pipe-D: SUCCESS (0.006s)
[148.980033] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.022s)
[149.030581] [037/130] (863s left) kms_plane_scaling (invalid-parameters)
[149.127257] Starting subtest: invalid-parameters
[149.128041] Starting dynamic subtest: less-than-1-height-src
[149.143781] Dynamic subtest less-than-1-height-src: SUCCESS (0.016s)
[149.151969] Starting dynamic subtest: less-than-1-width-src
[149.161628] Dynamic subtest less-than-1-width-src: SUCCESS (0.018s)
[149.162380] Subtest invalid-parameters: SUCCESS (0.034s)
[149.237265] [038/130] (863s left) kms_prime (basic-crc-hybrid)
[151.738086] Subtest basic-crc-hybrid: SKIP (0.000s)
[151.818658] [FACT kms_prime (basic-crc-hybrid)] new: kernel.kmod_is_loaded.amdgpu: true
[151.819269] [FACT kms_prime (basic-crc-hybrid)] new: kernel.kmod_is_loaded.vgem: true
[151.819416] [FACT kms_prime (basic-crc-hybrid)] new: kernel.kmod_is_loaded.xe: true
[151.822798] [039/130] (861s left) gem_exec_reloc (basic-wc-read-active)
[151.861518] Starting subtest: basic-wc-read-active
[151.988446] Subtest basic-wc-read-active: SUCCESS (0.118s)
[152.102480] [040/130] (861s left) gem_ccs (block-multicopy-compressed)
[152.142410] Starting subtest: block-multicopy-compressed
[152.143836] Subtest block-multicopy-compressed: SKIP (0.000s)
[152.209589] [041/130] (860s left) syncobj_timeline (wait-any-complex)
[152.245895] Starting subtest: wait-any-complex
[152.309037] Subtest wait-any-complex: SUCCESS (0.062s)
[152.379423] [042/130] (860s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[152.469817] Starting subtest: fbcpsr-tiling-4
[152.471218] Subtest fbcpsr-tiling-4: SKIP (0.000s)
[152.579119] [043/130] (860s left) kms_psr (psr-primary-render)
[152.669417] Subtest psr-primary-render: SKIP (0.000s)
[152.711356] [044/130] (860s left) gem_exec_params (invalid-ring2)
[152.750192] Starting subtest: invalid-ring2
[152.750964] Subtest invalid-ring2: SUCCESS (0.000s)
[152.853230] [045/130] (860s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[154.255088] Starting subtest: dpms-mode-unset-lpsp
[157.933139] Subtest dpms-mode-unset-lpsp: SUCCESS (3.678s)
[158.118969] [046/130] (855s left) gem_request_retire (retire-vma-not-inactive)
[158.159129] Starting subtest: retire-vma-not-inactive
[158.171804] Subtest retire-vma-not-inactive: SUCCESS (0.011s)
[158.285831] [047/130] (855s left) kms_pipe_crc_basic (bad-source)
[158.374700] Starting subtest: bad-source
[158.375392] Subtest bad-source: SUCCESS (0.000s)
[158.430968] [048/130] (854s left) syncobj_wait (single-wait-for-submit-signaled)
[158.469205] Starting subtest: single-wait-for-submit-signaled
[158.469926] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[158.531644] [049/130] (854s left) gem_exec_fence (syncobj-timeline-export)
[158.995590] Starting subtest: syncobj-timeline-export
[158.996453] Subtest syncobj-timeline-export: SUCCESS (0.005s)
[159.171323] [050/130] (854s left) kms_lease (implicit-plane-lease)
[159.258767] Starting subtest: implicit-plane-lease
[159.260704] Subtest implicit-plane-lease: SUCCESS (0.001s)
[159.315379] [051/130] (854s left) kms_plane_lowres (tiling-4)
[159.404911] Starting subtest: tiling-4
[159.406346] Subtest tiling-4: SKIP (0.000s)
[159.456384] [052/130] (854s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[159.492755] Starting subtest: etime-single-wait-for-submit-unsubmitted
[159.608269] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[159.672251] [053/130] (853s left) kms_cursor_crc (cursor-size-hints)
[159.762554] Starting subtest: cursor-size-hints
[159.764387] Starting dynamic subtest: pipe-A-HDMI-A-1
[160.063789] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.300s)
[160.070485] Starting dynamic subtest: pipe-D-HDMI-A-1
[160.333880] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.269s)
[160.334640] Subtest cursor-size-hints: SUCCESS (0.572s)
[160.459784] [054/130] (853s left) gem_tiled_swapping (non-threaded)
[173.106119] Starting subtest: non-threaded
[174.731508] Subtest non-threaded: FAIL (1.613s)
[177.044892] [055/130] (836s left) gem_softpin (overlap)
[177.128154] Starting subtest: overlap
[177.890304] Subtest overlap: SUCCESS (0.754s)
[178.026776] [056/130] (835s left) vgem_basic (busy-fence)
[178.071306] Starting subtest: busy-fence
[178.072039] Subtest busy-fence: SUCCESS (0.000s)
[178.126452] [057/130] (835s left) prime_busy (hang)
[178.165633] Starting subtest: hang
[178.166382] Starting dynamic subtest: rcs0
[191.618055] Dynamic subtest rcs0: SUCCESS (13.442s)
[191.624641] Starting dynamic subtest: bcs0
[198.619318] Dynamic subtest bcs0: SUCCESS (6.975s)
[198.628377] Starting dynamic subtest: vcs0
[205.569082] Dynamic subtest vcs0: SUCCESS (6.976s)
[205.575232] Starting dynamic subtest: vcs1
[212.608846] Dynamic subtest vcs1: SUCCESS (7.039s)
[212.615251] Starting dynamic subtest: vecs0
[219.585302] Dynamic subtest vecs0: SUCCESS (6.976s)
[219.585988] Subtest hang: SUCCESS (41.411s)
[219.693820] [058/130] (794s left) gem_userptr_blits (unsync-unmap)
[219.735616] Subtest unsync-unmap: SKIP (0.000s)
[219.869403] [059/130] (793s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[219.971291] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[220.013146] [060/130] (793s left) gem_exec_schedule (preempt-engines)
[220.071346] Starting subtest: preempt-engines
[220.072083] Starting dynamic subtest: rcs0
[220.138591] Dynamic subtest rcs0: SUCCESS (0.066s)
[220.148853] Starting dynamic subtest: bcs0
[220.208741] Dynamic subtest bcs0: SUCCESS (0.070s)
[220.215855] Starting dynamic subtest: vcs0
[220.280747] Dynamic subtest vcs0: SUCCESS (0.072s)
[220.288582] Starting dynamic subtest: vcs1
[220.358115] Dynamic subtest vcs1: SUCCESS (0.077s)
[220.366480] Starting dynamic subtest: vecs0
[220.427111] Dynamic subtest vecs0: SUCCESS (0.068s)
[220.427991] Subtest preempt-engines: SUCCESS (0.356s)
[220.739979] [061/130] (793s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[220.835458] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[220.836850] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[220.939361] [062/130] (792s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[221.031889] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.000s)
[221.070802] [063/130] (792s left) gem_lmem_swapping (verify-random)
[221.110958] Subtest verify-random: SKIP (0.000s)
[221.158263] [064/130] (792s left) kms_cursor_legacy (single-move)
[221.247829] Starting subtest: single-move
[221.248578] Starting dynamic subtest: pipe-A
[226.638955] Dynamic subtest pipe-A: SUCCESS (5.382s)
[226.645631] Starting dynamic subtest: pipe-B
[232.044952] Dynamic subtest pipe-B: SUCCESS (5.381s)
[232.051643] Starting dynamic subtest: pipe-C
[237.427196] Dynamic subtest pipe-C: SUCCESS (5.382s)
[237.433854] Starting dynamic subtest: pipe-D
[242.808429] Dynamic subtest pipe-D: SUCCESS (5.381s)
[242.815629] Starting dynamic subtest: all-pipes
[248.190355] Dynamic subtest all-pipes: SUCCESS (5.382s)
[248.191172] Subtest single-move: SUCCESS (26.909s)
[248.223928] [065/130] (765s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[248.315779] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[248.316483] Starting dynamic subtest: pipe-A
[248.464362] Dynamic subtest pipe-A: SUCCESS (0.149s)
[248.471283] Starting dynamic subtest: pipe-B
[248.607306] Dynamic subtest pipe-B: SUCCESS (0.143s)
[248.614134] Starting dynamic subtest: pipe-C
[248.757333] Dynamic subtest pipe-C: SUCCESS (0.150s)
[248.766255] Starting dynamic subtest: pipe-D
[248.916401] Dynamic subtest pipe-D: SUCCESS (0.159s)
[248.917122] Subtest planes-upscale-20x20-downscale-factor-0-5: SUCCESS (0.601s)
[249.109603] [066/130] (764s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[249.205743] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[250.575905] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (1.370s)
[250.716255] [067/130] (763s left) syncobj_wait (invalid-signal-illegal-handle)
[250.754723] Starting subtest: invalid-signal-illegal-handle
[250.755425] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[250.814824] [068/130] (763s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[250.962164] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[251.056161] [069/130] (763s left) api_intel_bb (object-reloc-keep-cache)
[251.095821] Starting subtest: object-reloc-keep-cache
[251.099218] Subtest object-reloc-keep-cache: SUCCESS (0.004s)
[251.213650] [070/130] (763s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[251.307031] Starting subtest: fbcpsr-shrfb-scaledprimary
[251.308440] Subtest fbcpsr-shrfb-scaledprimary: SKIP (0.000s)
[251.404123] [071/130] (762s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[251.498834] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[252.817172] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (1.319s)
[252.953748] [072/130] (761s left) kms_addfb_basic (basic-x-tiled-legacy)
[252.991268] Starting subtest: basic-x-tiled-legacy
[252.992023] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[253.136593] [073/130] (761s left) kms_tv_load_detect (load-detect)
[253.174063] Subtest load-detect: SKIP (0.000s)
[253.211365] [074/130] (761s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[253.303967] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[253.305358] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[253.463255] [075/130] (760s left) gem_exec_params (readonly)
[253.506734] Starting subtest: readonly
[253.508424] Subtest readonly: SUCCESS (0.001s)
[253.622611] [076/130] (760s left) gem_exec_params (dr1-dirt)
[253.662364] Starting subtest: DR1-dirt
[253.663087] Subtest DR1-dirt: SUCCESS (0.000s)
[253.753626] [077/130] (760s left) perf (create-destroy-userspace-config)
[253.840589] Starting subtest: create-destroy-userspace-config
[253.868588] Subtest create-destroy-userspace-config: SUCCESS (0.027s)
[253.909538] [078/130] (760s left) gem_mmap_offset (bad-flags)
[253.946870] Starting subtest: bad-flags
[253.947577] Subtest bad-flags: SUCCESS (0.000s)
[254.037463] [079/130] (760s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[254.083311] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[254.084078] Starting dynamic subtest: smem
[254.170091] Dynamic subtest smem: SUCCESS (0.086s)
[254.170902] Subtest y-tiled-ccs-to-yf-tiled-ccs: SUCCESS (0.087s)
[254.352561] [080/130] (760s left) kms_async_flips (alternate-sync-async-flip)
[254.447011] Starting subtest: alternate-sync-async-flip
[254.582075] Starting dynamic subtest: pipe-A-HDMI-A-1
[256.722731] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.132s)
[256.850759] Starting dynamic subtest: pipe-B-HDMI-A-1
[258.924996] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.071s)
[259.052321] Starting dynamic subtest: pipe-C-HDMI-A-1
[261.129378] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.074s)
[261.250399] Starting dynamic subtest: pipe-D-HDMI-A-1
[263.330145] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.077s)
[263.330907] Subtest alternate-sync-async-flip: SUCCESS (8.876s)
[263.542121] [081/130] (751s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[263.636888] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[263.637595] Starting dynamic subtest: pipe-A-HDMI-A-1
[264.435819] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.795s)
[264.446243] Starting dynamic subtest: pipe-B-HDMI-A-1
[264.836790] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.396s)
[264.851152] Starting dynamic subtest: pipe-C-HDMI-A-1
[265.236986] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.397s)
[265.251746] Starting dynamic subtest: pipe-D-HDMI-A-1
[265.638922] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.398s)
[265.640194] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SUCCESS (2.000s)
[265.842007] [082/130] (748s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[265.931957] Starting subtest: cursorB-vs-flipB-varying-size
[265.934373] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[265.995075] [083/130] (748s left) kms_dp_link_training (uhbr-sst)
[266.082809] Starting subtest: uhbr-sst
[266.084234] Subtest uhbr-sst: SKIP (0.000s)
[266.144906] [084/130] (748s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[266.239045] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[266.240476] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[266.347874] [085/130] (748s left) gem_exec_reloc (basic-write-cpu)
[266.388131] Starting subtest: basic-write-cpu
[266.393184] Subtest basic-write-cpu: SUCCESS (0.005s)
[266.501694] [086/130] (748s left) sw_sync (sync_multi_consumer)
[266.537577] Starting subtest: sync_multi_consumer
[267.137106] Subtest sync_multi_consumer: SUCCESS (0.591s)
[267.186131] [087/130] (747s left) gem_vm_create (create-ext)
[267.225009] Starting subtest: create-ext
[267.226778] Subtest create-ext: SUCCESS (0.002s)
[267.319855] [088/130] (747s left) gem_ctx_engines (invalid-engines)
[267.364891] Starting subtest: invalid-engines
[267.369532] Subtest invalid-engines: SUCCESS (0.005s)
[267.555801] [089/130] (747s left) kms_feature_discovery (chamelium)
[267.649980] Starting subtest: chamelium
[267.651479] Subtest chamelium: SKIP (0.000s)
[267.709646] [090/130] (747s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[267.810322] Starting subtest: 4-tiled-16bpp-rotate-90
[267.811726] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.000s)
[267.891985] [091/130] (747s left) gem_exec_balancer (hang)
[268.062716] Starting subtest: hang
[269.102192] Subtest hang: SUCCESS (1.047s)
[269.166728] [092/130] (745s left) gem_spin_batch (legacy-resubmit)
[269.210752] Starting subtest: legacy-resubmit
[269.211505] Starting dynamic subtest: default
[269.213223] Dynamic subtest default: SUCCESS (0.001s)
[269.220907] Starting dynamic subtest: render
[269.221683] Dynamic subtest render: SUCCESS (0.001s)
[269.229068] Starting dynamic subtest: bsd
[269.229775] Dynamic subtest bsd: SUCCESS (0.001s)
[269.236466] Starting dynamic subtest: bsd1
[269.237168] Dynamic subtest bsd1: SUCCESS (0.001s)
[269.243316] Starting dynamic subtest: bsd2
[269.244024] Dynamic subtest bsd2: SUCCESS (0.001s)
[269.250143] Starting dynamic subtest: blt
[269.250825] Dynamic subtest blt: SUCCESS (0.001s)
[269.256821] Starting dynamic subtest: vebox
[269.257500] Dynamic subtest vebox: SUCCESS (0.001s)
[269.258176] Subtest legacy-resubmit: SUCCESS (0.015s)
[269.413678] [093/130] (745s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[269.507609] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[269.509012] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[269.592860] [094/130] (745s left) syncobj_timeline (invalid-signal-illegal-point)
[269.631622] Starting subtest: invalid-signal-illegal-point
[269.632352] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[269.685529] [095/130] (745s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[269.774977] Starting subtest: cursorB-vs-flipA-legacy
[269.777919] Subtest cursorB-vs-flipA-legacy: SKIP (0.002s)
[269.834462] [096/130] (745s left) gem_exec_flush (basic-uc-set-default)
[269.882304] Starting subtest: basic-uc-set-default
[275.318848] Subtest basic-uc-set-default: SUCCESS (5.437s)
[275.529063] [097/130] (739s left) gem_exec_schedule (smoketest)
[275.706971] Starting subtest: smoketest
[275.707919] Starting dynamic subtest: rcs0
[281.177347] Dynamic subtest rcs0: SUCCESS (5.430s)
[281.186991] Starting dynamic subtest: bcs0
[286.582251] Dynamic subtest bcs0: SUCCESS (5.429s)
[286.592079] Starting dynamic subtest: vcs0
[292.038836] Dynamic subtest vcs0: SUCCESS (5.431s)
[292.047186] Starting dynamic subtest: vcs1
[297.467225] Dynamic subtest vcs1: SUCCESS (5.428s)
[297.475345] Starting dynamic subtest: vecs0
[302.869076] Dynamic subtest vecs0: SUCCESS (5.427s)
[302.869775] Subtest smoketest: SUCCESS (27.149s)
[303.037436] [098/130] (712s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[303.074566] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[303.176327] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.101s)
[303.254703] [099/130] (712s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[303.353993] Starting subtest: x-tiled-8bpp-rotate-270
[303.426812] Subtest x-tiled-8bpp-rotate-270: SKIP (0.072s)
[303.538312] [100/130] (711s left) gem_ctx_persistence (engines-mixed-process)
[303.579145] Starting subtest: engines-mixed-process
[303.579951] Starting dynamic subtest: rcs0
[303.966789] Dynamic subtest rcs0: SUCCESS (0.387s)
[303.976999] Starting dynamic subtest: bcs0
[304.331372] Dynamic subtest bcs0: SUCCESS (0.364s)
[304.341984] Starting dynamic subtest: vcs0
[304.705253] Dynamic subtest vcs0: SUCCESS (0.372s)
[304.723037] Starting dynamic subtest: vcs1
[305.087847] Dynamic subtest vcs1: SUCCESS (0.381s)
[305.104670] Starting dynamic subtest: vecs0
[305.470063] Dynamic subtest vecs0: SUCCESS (0.380s)
[305.471247] Subtest engines-mixed-process: SUCCESS (1.891s)
[305.541561] [101/130] (709s left) gem_pwrite_snooped
[305.712106] [102/130] (709s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[305.812983] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[305.814423] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[305.915884] [103/130] (709s left) kms_vblank (query-forked-hang)
[306.005279] Starting subtest: query-forked-hang
[306.006019] Starting dynamic subtest: pipe-A-HDMI-A-1
[319.664410] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (13.658s)
[319.675591] Starting dynamic subtest: pipe-D-HDMI-A-1
[333.476195] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.807s)
[333.476954] Subtest query-forked-hang: SUCCESS (27.472s)
[333.614658] [104/130] (681s left) gem_linear_blits (normal)
[333.740627] Starting subtest: normal
[337.259179] Subtest normal: SUCCESS (3.517s)
[337.360151] [105/130] (678s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[337.499790] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[337.501214] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[337.630364] [106/130] (677s left) api_intel_allocator (reopen)
[337.668138] Starting subtest: reopen
[337.670872] Subtest reopen: SUCCESS (0.002s)
[337.769257] [107/130] (677s left) dumb_buffer (create-clear)
[337.808073] Starting subtest: create-clear
[373.997064] Subtest create-clear: SUCCESS (36.188s)
[374.104197] [108/130] (641s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[374.203052] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[374.204409] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[374.293972] [109/130] (641s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[374.383852] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[374.385619] Starting dynamic subtest: pipe-A-valid-mode
[375.563945] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.178s)
[375.564698] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (1.180s)
[375.691030] [110/130] (640s left) gem_mmap_gtt (basic-read)
[375.730837] Starting subtest: basic-read
[375.759968] Subtest basic-read: SUCCESS (0.030s)
[375.865740] [111/130] (639s left) perf_pmu (frequency)
[375.905704] Starting subtest: frequency
[375.907493] Starting dynamic subtest: gt0
[378.016319] Dynamic subtest gt0: SUCCESS (2.106s)
[378.027367] Starting dynamic subtest: idle-gt0
[378.530366] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[378.531411] Subtest frequency: SUCCESS (2.616s)
[378.589228] [112/130] (637s left) gen9_exec_parse (bb-large)
[378.630798] Subtest bb-large: SKIP (0.000s)
[378.675473] [113/130] (637s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[378.772696] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[380.529939] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SUCCESS (1.757s)
[380.649126] [114/130] (635s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[380.745545] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[380.747038] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[380.841861] [115/130] (635s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[380.882167] Starting subtest: verify-pxp-key-change-after-suspend-resume
[387.440840] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (6.558s)
[396.568259] [116/130] (628s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[396.673034] Starting subtest: yf-tiled-8bpp-rotate-90
[396.674463] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[396.781938] [117/130] (628s left) kms_psr (fbc-psr2-cursor-blt)
[396.874705] Subtest fbc-psr2-cursor-blt: SKIP (0.000s)
[396.948853] [118/130] (628s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[397.045211] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[397.657534] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.612s)
[397.793152] [119/130] (627s left) kms_plane_scaling (planes-downscale-factor-0-25-unity-scaling)
[397.882049] Starting subtest: planes-downscale-factor-0-25-unity-scaling
[397.882958] Starting dynamic subtest: pipe-A
[399.407460] Dynamic subtest pipe-A: SKIP (1.524s)
[399.415869] Starting dynamic subtest: pipe-B
[401.763412] Dynamic subtest pipe-B: SKIP (2.355s)
[401.772129] Starting dynamic subtest: pipe-C
[404.052979] Dynamic subtest pipe-C: SKIP (2.289s)
[404.061405] Starting dynamic subtest: pipe-D
[406.423072] Dynamic subtest pipe-D: SKIP (2.369s)
[406.424539] Subtest planes-downscale-factor-0-25-unity-scaling: SKIP (8.540s)
[406.518563] [120/130] (618s left) kms_chamelium_frames (dp-crc-fast)
[406.691589] Subtest dp-crc-fast: SKIP (0.000s)
[406.794410] [121/130] (618s left) kms_flip (absolute-wf_vblank-interruptible)
[406.894943] Starting subtest: absolute-wf_vblank-interruptible
[406.896900] Starting dynamic subtest: A-HDMI-A1
[414.554163] Dynamic subtest A-HDMI-A1: SUCCESS (7.657s)
[414.565797] Starting dynamic subtest: B-HDMI-A1
[422.184631] Dynamic subtest B-HDMI-A1: SUCCESS (7.625s)
[422.193770] Starting dynamic subtest: C-HDMI-A1
[429.848976] Dynamic subtest C-HDMI-A1: SUCCESS (7.637s)
[429.857432] Starting dynamic subtest: D-HDMI-A1
[437.502306] Dynamic subtest D-HDMI-A1: SUCCESS (7.650s)
[437.503031] Subtest absolute-wf_vblank-interruptible: SUCCESS (30.583s)
[437.638525] [122/130] (587s left) kms_chamelium_audio (hdmi-audio)
[437.794635] Subtest hdmi-audio: SKIP (0.000s)
[437.882987] [123/130] (587s left) kms_flip (plain-flip-fb-recreate-interruptible)
[437.981589] Starting subtest: plain-flip-fb-recreate-interruptible
[437.984446] Starting dynamic subtest: A-HDMI-A1
[445.777541] Dynamic subtest A-HDMI-A1: SUCCESS (7.792s)
[445.798395] Starting dynamic subtest: B-HDMI-A1
[453.565222] Dynamic subtest B-HDMI-A1: SUCCESS (7.784s)
[453.583201] Starting dynamic subtest: C-HDMI-A1
[461.344116] Dynamic subtest C-HDMI-A1: SUCCESS (7.776s)
[461.364390] Starting dynamic subtest: D-HDMI-A1
[469.149615] Dynamic subtest D-HDMI-A1: SUCCESS (7.803s)
[469.153455] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (31.171s)
[469.352789] [124/130] (555s left) syncobj_timeline (signal-point-0)
[469.398011] Starting subtest: signal-point-0
[469.398760] Subtest signal-point-0: SUCCESS (0.000s)
[469.468755] [125/130] (555s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[469.559974] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[469.561360] Subtest plane-all-modeset-transition-fencing-internal-panels: SKIP (0.000s)
[469.618624] [126/130] (555s left) core_setmaster_vs_auth
[469.717108] [127/130] (555s left) gem_exec_whisper (basic-forked-all)
[469.764672] Starting subtest: basic-forked-all
[472.040210] Subtest basic-forked-all: SUCCESS (2.275s)
[472.244935] [128/130] (553s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[472.283765] Starting subtest: wait-all-for-submit-delayed-submit
[472.386909] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[472.471480] [129/130] (553s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[472.565060] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[472.565763] Starting dynamic subtest: pipe-A-HDMI-A-1
[472.572533] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[472.581015] Starting dynamic subtest: pipe-B-HDMI-A-1
[472.588235] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[472.596726] Starting dynamic subtest: pipe-C-HDMI-A-1
[472.603825] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[472.611853] Starting dynamic subtest: pipe-D-HDMI-A-1
[472.619295] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[472.620767] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SKIP (0.006s)
[472.797980] [130/130] (552s left) i915_pm_rpm (debugfs-read)
[474.209668] Starting subtest: debugfs-read
[475.411210] Subtest debugfs-read: SUCCESS (1.200s)
[475.572767] Closing watchdogs
Done.