[66.291519] Initializing watchdogs
[66.291566]   /dev/watchdog0
[66.306132] [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]
[66.310396] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[66.312536] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[66.315920] [001/133] (960s left) syncobj_basic (bad-destroy-pad)
[66.394606] Starting subtest: bad-destroy-pad
[66.396785] Subtest bad-destroy-pad: SUCCESS (0.000s)
[66.522700] [002/133] (960s left) gem_ppgtt (blt-vs-render-ctxn)
[66.600543] Starting subtest: blt-vs-render-ctxN
[99.652209] Subtest blt-vs-render-ctxN: SUCCESS (33.048s)
[99.789207] [003/133] (927s left) prime_vgem (fence-write-hang)
[100.001613] Subtest fence-write-hang: SKIP (0.000s)
[100.093353] [FACT prime_vgem (fence-write-hang)] new: kernel.kmod_is_loaded.vgem: true
[100.096347] [004/133] (926s left) kms_async_flips (async-flip-dpms)
[100.203724] Starting subtest: async-flip-dpms
[100.588936] Starting dynamic subtest: pipe-A-eDP-1
[104.402741] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.812s)
[104.771442] Starting dynamic subtest: pipe-B-eDP-1
[107.580732] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.815s)
[107.964569] Starting dynamic subtest: pipe-C-eDP-1
[110.749754] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.792s)
[111.125538] Starting dynamic subtest: pipe-D-eDP-1
[113.919926] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.799s)
[113.922302] Subtest async-flip-dpms: SUCCESS (13.716s)
[115.098424] [005/133] (911s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[115.202401] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[115.206443] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[115.293759] [006/133] (911s left) kms_dp_aux_dev (basic)
[115.345035] Starting subtest: basic
[115.565369] Subtest basic: SUCCESS (0.220s)
[115.650679] [007/133] (911s left) gem_exec_store (cachelines)
[115.706535] Starting subtest: cachelines
[115.708793] Starting dynamic subtest: rcs0
[115.772460] Dynamic subtest rcs0: SUCCESS (0.068s)
[115.782896] Starting dynamic subtest: bcs0
[115.823984] Dynamic subtest bcs0: SUCCESS (0.051s)
[115.832707] Starting dynamic subtest: vcs0
[115.874736] Dynamic subtest vcs0: SUCCESS (0.049s)
[115.884379] Starting dynamic subtest: vcs1
[115.931652] Dynamic subtest vcs1: SUCCESS (0.056s)
[115.941936] Starting dynamic subtest: vecs0
[115.987084] Dynamic subtest vecs0: SUCCESS (0.055s)
[115.996763] Starting dynamic subtest: ccs0
[116.038915] Dynamic subtest ccs0: SUCCESS (0.051s)
[116.041612] Subtest cachelines: SUCCESS (0.335s)
[116.239536] [008/133] (910s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[116.344826] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[116.348958] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[116.406538] [009/133] (910s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[116.548802] Starting subtest: cursorA-vs-flipB-varying-size
[116.553531] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[116.692075] [010/133] (910s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[116.780452] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[116.784724] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[116.870954] [011/133] (910s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[116.966237] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[116.970561] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[117.058129] [012/133] (910s left) gem_pwrite (basic-random)
[117.121175] Subtest basic-random: SKIP (0.000s)
[117.181330] [013/133] (910s left) gem_ctx_shared (q-independent)
[117.240964] Starting subtest: Q-independent
[117.242981] Starting dynamic subtest: rcs0
[117.308911] Dynamic subtest rcs0: SUCCESS (0.068s)
[117.318889] Starting dynamic subtest: vcs0
[117.351848] Dynamic subtest vcs0: SUCCESS (0.043s)
[117.360515] Starting dynamic subtest: vcs1
[117.396068] Dynamic subtest vcs1: SUCCESS (0.044s)
[117.403656] Starting dynamic subtest: vecs0
[117.441885] Dynamic subtest vecs0: SUCCESS (0.046s)
[117.449980] Starting dynamic subtest: ccs0
[117.491906] Dynamic subtest ccs0: SUCCESS (0.049s)
[117.494282] Subtest Q-independent: SUCCESS (0.251s)
[119.023922] [014/133] (908s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[119.072680] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[119.152124] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.029s)
[119.187629] [015/133] (908s left) kms_getfb (getfb2-handle-protection)
[119.292745] Starting subtest: getfb2-handle-protection
[119.306848] Subtest getfb2-handle-protection: SUCCESS (0.015s)
[119.436926] [016/133] (908s left) kms_vblank (wait-forked-hang)
[119.522883] Starting subtest: wait-forked-hang
[119.525223] Starting dynamic subtest: pipe-A-eDP-1
[145.715282] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.188s)
[145.728380] Starting dynamic subtest: pipe-D-eDP-1
[160.670611] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.951s)
[160.672648] Subtest wait-forked-hang: SUCCESS (41.143s)
[161.461879] [017/133] (866s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[161.575272] Starting subtest: 2x-cursor-vs-flip-atomic
[161.579975] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[161.719057] [018/133] (865s left) gen7_exec_parse (oacontrol-tracking)
[161.785125] Subtest oacontrol-tracking: SKIP (0.000s)
[161.857824] [019/133] (865s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[161.950761] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[161.960745] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[162.051912] [020/133] (865s left) kms_psr (fbc-pr-primary-blt)
[162.142872] Starting subtest: fbc-pr-primary-blt
[162.147051] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[162.210159] [021/133] (865s left) kms_dsc (dsc-with-output-formats)
[162.311961] Starting subtest: dsc-with-output-formats
[162.334582] Subtest dsc-with-output-formats: SKIP (0.000s)
[162.416739] [022/133] (865s left) gem_spin_batch (spin-each)
[162.480278] Starting subtest: spin-each
[165.749132] Subtest spin-each: SUCCESS (3.260s)
[165.944387] [023/133] (861s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[165.989637] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[166.096980] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.106s)
[166.173311] [024/133] (861s left) gem_vm_create (execbuf)
[166.230800] Starting subtest: execbuf
[166.241881] Subtest execbuf: SUCCESS (0.011s)
[166.352710] [025/133] (861s left) kms_cursor_crc (cursor-sliding-512x170)
[166.657643] Starting subtest: cursor-sliding-512x170
[166.661776] Subtest cursor-sliding-512x170: SKIP (0.001s)
[166.816809] [026/133] (861s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[166.918874] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[166.923326] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[167.001696] [027/133] (860s left) kms_plane (plane-position-covered)
[167.100081] Starting subtest: plane-position-covered
[167.627357] Starting dynamic subtest: pipe-A-plane-1
[168.936883] Dynamic subtest pipe-A-plane-1: SUCCESS (1.308s)
[168.948740] Starting dynamic subtest: pipe-A-plane-2
[170.171246] Dynamic subtest pipe-A-plane-2: SUCCESS (1.234s)
[170.179852] Starting dynamic subtest: pipe-A-plane-3
[171.394052] Dynamic subtest pipe-A-plane-3: SUCCESS (1.223s)
[171.404852] Starting dynamic subtest: pipe-A-plane-4
[172.630725] Dynamic subtest pipe-A-plane-4: SUCCESS (1.237s)
[172.639714] Starting dynamic subtest: pipe-A-plane-5
[172.657724] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[173.797998] Starting dynamic subtest: pipe-B-plane-1
[175.043850] Dynamic subtest pipe-B-plane-1: SUCCESS (1.252s)
[175.053338] Starting dynamic subtest: pipe-B-plane-2
[176.338669] Dynamic subtest pipe-B-plane-2: SUCCESS (1.292s)
[176.347416] Starting dynamic subtest: pipe-B-plane-3
[177.565280] Dynamic subtest pipe-B-plane-3: SUCCESS (1.228s)
[177.573524] Starting dynamic subtest: pipe-B-plane-4
[178.818898] Dynamic subtest pipe-B-plane-4: SUCCESS (1.254s)
[178.828078] Starting dynamic subtest: pipe-B-plane-5
[178.844375] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[178.846226] Subtest plane-position-covered: SUCCESS (11.744s)
[179.631224] [028/133] (848s left) kms_sequence (queue-idle)
[179.727337] Starting subtest: queue-idle
[179.729591] Starting dynamic subtest: pipe-A-eDP-1
[181.544127] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.816s)
[181.553613] Starting dynamic subtest: pipe-B-eDP-1
[184.001408] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.455s)
[184.010795] Starting dynamic subtest: pipe-C-eDP-1
[186.444488] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.444s)
[186.453963] Starting dynamic subtest: pipe-D-eDP-1
[188.876859] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.430s)
[188.879202] Subtest queue-idle: SUCCESS (9.149s)
[189.680040] [029/133] (838s left) vgem_basic (mmap)
[189.731702] Starting subtest: mmap
[189.740523] Subtest mmap: SUCCESS (0.011s)
[189.806548] [030/133] (838s left) gem_exec_gttfill (basic)
[189.878870] Starting subtest: basic
[192.276087] Subtest basic: SUCCESS (2.397s)
[192.467901] [031/133] (835s left) gem_exec_fence (basic-wait)
[192.700742] Starting subtest: basic-wait
[192.703228] Starting dynamic subtest: rcs0
[192.772140] Dynamic subtest rcs0: SUCCESS (0.071s)
[192.782419] Starting dynamic subtest: bcs0
[192.835732] Dynamic subtest bcs0: SUCCESS (0.062s)
[192.846259] Starting dynamic subtest: vcs0
[192.899371] Dynamic subtest vcs0: SUCCESS (0.062s)
[192.909394] Starting dynamic subtest: vcs1
[192.957873] Dynamic subtest vcs1: SUCCESS (0.058s)
[192.968059] Starting dynamic subtest: vecs0
[193.020728] Dynamic subtest vecs0: SUCCESS (0.061s)
[193.030496] Starting dynamic subtest: ccs0
[193.077159] Dynamic subtest ccs0: SUCCESS (0.055s)
[193.079602] Subtest basic-wait: SUCCESS (0.378s)
[194.930078] [032/133] (833s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[195.046127] Starting subtest: compare-crc-sanitycheck-xr24
[195.048638] Starting dynamic subtest: pipe-A-eDP-1
[195.653446] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.606s)
[195.663300] Starting dynamic subtest: pipe-B-eDP-1
[196.938973] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.285s)
[196.949124] Starting dynamic subtest: pipe-C-eDP-1
[198.113708] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.173s)
[198.122047] Starting dynamic subtest: pipe-D-eDP-1
[199.362157] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.248s)
[199.364363] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.316s)
[200.209720] [033/133] (827s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[200.313071] Starting subtest: fbcpsr-slowdraw
[225.379257] Subtest fbcpsr-slowdraw: SUCCESS (25.069s)
[225.515043] [034/133] (802s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[225.616274] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[225.620399] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[225.718552] [035/133] (802s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[225.783098] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[225.785427] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[225.901985] [036/133] (802s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[225.992604] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[225.996702] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[226.061293] [037/133] (802s left) syncobj_wait (multi-wait-all-signaled)
[226.126931] Starting subtest: multi-wait-all-signaled
[226.129326] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[226.232945] [038/133] (802s left) gem_basic (multigpu-create-close)
[226.294133] Starting subtest: multigpu-create-close
[226.297753] Subtest multigpu-create-close: SKIP (0.000s)
[226.400074] [039/133] (802s left) gem_eio (wait-10ms)
[226.627519] Starting subtest: wait-10ms
[226.968257] Subtest wait-10ms: SUCCESS (0.341s)
[227.133201] [040/133] (801s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[227.215584] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[227.217621] Starting dynamic subtest: pipe-A-eDP-1
[227.235321] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[227.249898] Starting dynamic subtest: pipe-B-eDP-1
[227.266853] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[227.274773] Starting dynamic subtest: pipe-C-eDP-1
[227.290989] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[227.301245] Starting dynamic subtest: pipe-D-eDP-1
[227.318523] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[227.320444] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.007s)
[229.495574] [041/133] (799s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[229.586104] Starting subtest: primary-yf-tiled-reflect-x-90
[229.590582] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[229.657434] [042/133] (798s left) gem_exec_fence (syncobj-channel)
[230.066141] Starting subtest: syncobj-channel
[231.084659] Subtest syncobj-channel: SUCCESS (1.014s)
[231.376230] [043/133] (797s left) kms_invalid_mode (int-max-clock)
[231.473971] Starting subtest: int-max-clock
[231.476106] Starting dynamic subtest: pipe-A-eDP-1
[231.758038] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[231.767738] Starting dynamic subtest: pipe-B-eDP-1
[231.770111] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[231.778759] Starting dynamic subtest: pipe-C-eDP-1
[231.781198] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[231.789726] Starting dynamic subtest: pipe-D-eDP-1
[231.792098] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[231.794424] Subtest int-max-clock: SUCCESS (0.290s)
[232.620787] [044/133] (796s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[232.732695] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[232.736856] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[232.838120] [045/133] (795s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[232.916462] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[232.918738] Starting dynamic subtest: pipe-A-eDP-1
[233.740232] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.820s)
[233.748254] Starting dynamic subtest: pipe-B-eDP-1
[235.224077] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.480s)
[235.232768] Starting dynamic subtest: pipe-C-eDP-1
[236.727261] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.501s)
[236.736841] Starting dynamic subtest: pipe-D-eDP-1
[238.169715] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.441s)
[238.171843] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.247s)
[239.350670] [046/133] (789s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[239.456541] Starting subtest: fbc-rgb101010-draw-mmap-wc
[244.035887] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.580s)
[245.179251] [047/133] (783s left) i915_drm_fdinfo (busy)
[245.221155] Starting subtest: busy
[245.223141] Starting dynamic subtest: rcs0
[245.249485] Dynamic subtest rcs0: SKIP (0.028s)
[245.259966] Starting dynamic subtest: bcs0
[245.264028] Dynamic subtest bcs0: SKIP (0.000s)
[245.272077] Starting dynamic subtest: vcs0
[245.276417] Dynamic subtest vcs0: SKIP (0.000s)
[245.284120] Starting dynamic subtest: vcs1
[245.288138] Dynamic subtest vcs1: SKIP (0.000s)
[245.296309] Starting dynamic subtest: vecs0
[245.300303] Dynamic subtest vecs0: SKIP (0.000s)
[245.308175] Starting dynamic subtest: ccs0
[245.312123] Dynamic subtest ccs0: SKIP (0.000s)
[245.316100] Subtest busy: SKIP (0.032s)
[245.353798] [048/133] (783s left) kms_atomic (plane-cursor-legacy)
[245.446092] Starting subtest: plane-cursor-legacy
[245.448247] Starting dynamic subtest: pipe-A-eDP-1
[245.838059] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.390s)
[245.839956] Subtest plane-cursor-legacy: SUCCESS (0.391s)
[246.671306] [049/133] (782s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[246.763382] Starting subtest: fbc-psr-cursor-mmap-gtt
[246.765531] Starting dynamic subtest: eDP-1
[246.769766] Dynamic subtest eDP-1: SKIP (0.000s)
[246.774062] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[246.833868] [050/133] (782s left) kms_flip (modeset-vs-vblank-race)
[246.925553] Starting subtest: modeset-vs-vblank-race
[246.927513] Starting dynamic subtest: A-eDP1
[251.571417] Dynamic subtest A-eDP1: SUCCESS (4.648s)
[251.582278] Starting dynamic subtest: B-eDP1
[256.317736] Dynamic subtest B-eDP1: SUCCESS (4.744s)
[256.330743] Starting dynamic subtest: C-eDP1
[260.932772] Dynamic subtest C-eDP1: SUCCESS (4.612s)
[260.943077] Starting dynamic subtest: D-eDP1
[265.575391] Dynamic subtest D-eDP1: SUCCESS (4.642s)
[265.580265] Subtest modeset-vs-vblank-race: SUCCESS (18.658s)
[266.741612] [051/133] (762s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[266.833683] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[273.452543] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.621s)
[273.576011] [052/133] (755s left) kms_cursor_crc (cursor-alpha-transparent)
[273.680186] Starting subtest: cursor-alpha-transparent
[273.682098] Starting dynamic subtest: pipe-A-eDP-1
[274.311796] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.633s)
[274.320604] Starting dynamic subtest: pipe-D-eDP-1
[275.619084] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.303s)
[275.621385] Subtest cursor-alpha-transparent: SUCCESS (1.939s)
[276.422095] [053/133] (752s left) vgem_basic (sysfs)
[276.474951] Starting subtest: sysfs
[276.477263] Subtest sysfs: SUCCESS (0.000s)
[276.534537] [054/133] (752s left) kms_big_fb (linear-8bpp-rotate-0)
[276.640691] Starting subtest: linear-8bpp-rotate-0
[277.901339] Subtest linear-8bpp-rotate-0: SUCCESS (1.261s)
[278.046317] [055/133] (751s left) syncobj_timeline (single-wait-available-signaled)
[278.100685] Starting subtest: single-wait-available-signaled
[278.102732] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[278.197615] [056/133] (750s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[278.307881] Starting subtest: yf-tiled-8bpp-rotate-0
[278.311684] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[278.414655] [057/133] (750s left) i915_query (query-topology-unsupported)
[278.463108] Starting subtest: query-topology-unsupported
[278.466820] Subtest query-topology-unsupported: SKIP (0.000s)
[278.562235] [058/133] (750s left) gem_ctx_persistence (legacy-engines-mixed-process)
[278.626058] Starting subtest: legacy-engines-mixed-process
[278.628217] Starting dynamic subtest: render
[279.899670] Dynamic subtest render: SUCCESS (1.272s)
[279.913314] Starting dynamic subtest: bsd1
[281.889841] Dynamic subtest bsd1: SUCCESS (1.987s)
[281.902420] Starting dynamic subtest: bsd2
[283.932645] Dynamic subtest bsd2: SUCCESS (2.039s)
[283.942478] Starting dynamic subtest: blt
[285.893305] Dynamic subtest blt: SUCCESS (1.957s)
[285.902155] Starting dynamic subtest: vebox
[287.902150] Dynamic subtest vebox: SUCCESS (2.008s)
[287.905194] Subtest legacy-engines-mixed-process: SUCCESS (9.276s)
[288.021157] [059/133] (741s left) gem_exec_balancer (hog)
[288.085267] Starting subtest: hog
[288.089747] Subtest hog: SKIP (0.000s)
[288.389398] [060/133] (740s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[288.490352] Starting subtest: yf-tiled-32bpp-rotate-180
[288.494292] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[288.605535] [061/133] (740s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[288.708108] Starting subtest: y-tiled-8bpp-rotate-270
[288.712176] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[288.790097] [062/133] (740s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[288.886616] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[296.150292] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.267s)
[296.273755] [063/133] (733s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[296.367150] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[296.369395] Starting dynamic subtest: pipe-A-eDP-1
[296.427157] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[296.435283] Starting dynamic subtest: pipe-B-eDP-1
[296.492687] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[296.502343] Starting dynamic subtest: pipe-C-eDP-1
[296.559842] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[296.570448] Starting dynamic subtest: pipe-D-eDP-1
[296.628784] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[296.633165] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.008s)
[298.698430] [064/133] (730s left) sysfs_heartbeat_interval (nopreempt)
[298.755096] Starting subtest: nopreempt
[298.757392] Starting dynamic subtest: vecs0
[307.917970] Dynamic subtest vecs0: SUCCESS (9.158s)
[307.928573] Starting dynamic subtest: ccs0
[311.894299] Dynamic subtest ccs0: SUCCESS (3.976s)
[311.904274] Starting dynamic subtest: vcs0
[321.878259] Dynamic subtest vcs0: SUCCESS (9.982s)
[321.891791] Starting dynamic subtest: bcs0
[325.782065] Dynamic subtest bcs0: SUCCESS (3.900s)
[325.791474] Starting dynamic subtest: rcs0
[329.816893] Dynamic subtest rcs0: SUCCESS (4.032s)
[329.828737] Starting dynamic subtest: vcs1
[338.896527] Dynamic subtest vcs1: SUCCESS (9.077s)
[338.899199] Subtest nopreempt: SUCCESS (40.138s)
[338.985687] [065/133] (690s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[339.094793] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[339.098805] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[339.180481] [066/133] (690s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[339.265602] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[339.269961] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[339.336943] [067/133] (690s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[339.427842] Starting subtest: 4-tiled-32bpp-rotate-270
[339.447318] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.019s)
[339.575650] [068/133] (690s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[339.679623] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[339.683752] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[339.793761] [069/133] (689s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[339.876377] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[339.880890] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[339.960364] [070/133] (689s left) kms_flip (nonexisting-fb-interruptible)
[340.057323] Starting subtest: nonexisting-fb-interruptible
[340.058927] Starting dynamic subtest: A-eDP1
[341.176691] Dynamic subtest A-eDP1: SUCCESS (1.117s)
[341.189599] Starting dynamic subtest: B-eDP1
[342.309225] Dynamic subtest B-eDP1: SUCCESS (1.130s)
[342.321736] Starting dynamic subtest: C-eDP1
[343.432568] Dynamic subtest C-eDP1: SUCCESS (1.120s)
[343.445211] Starting dynamic subtest: D-eDP1
[344.566106] Dynamic subtest D-eDP1: SUCCESS (1.130s)
[344.571375] Subtest nonexisting-fb-interruptible: SUCCESS (4.514s)
[345.740717] [071/133] (684s left) kms_plane_lowres (tiling-none)
[345.828990] Starting subtest: tiling-none
[345.831132] Starting dynamic subtest: pipe-A-eDP-1
[345.835462] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[346.121955] Starting dynamic subtest: pipe-B-eDP-1
[346.126294] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[346.134624] Starting dynamic subtest: pipe-C-eDP-1
[346.139156] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[346.147746] Starting dynamic subtest: pipe-D-eDP-1
[346.152107] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[346.156094] Subtest tiling-none: SKIP (0.292s)
[346.962706] [072/133] (682s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[347.073054] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[378.845328] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.771s)
[379.700051] [073/133] (650s left) gem_exec_schedule (manyslice)
[379.776726] Starting subtest: manyslice
[379.779036] Starting dynamic subtest: rcs0
[384.954629] Dynamic subtest rcs0: SUCCESS (5.135s)
[384.965709] Starting dynamic subtest: bcs0
[391.537582] Dynamic subtest bcs0: SUCCESS (6.632s)
[391.550519] Starting dynamic subtest: vcs0
[397.172525] Dynamic subtest vcs0: SUCCESS (5.582s)
[397.184044] Starting dynamic subtest: vcs1
[403.759841] Dynamic subtest vcs1: SUCCESS (6.585s)
[403.770205] Starting dynamic subtest: vecs0
[409.824140] Dynamic subtest vecs0: SUCCESS (6.061s)
[409.835813] Starting dynamic subtest: ccs0
[415.940968] Dynamic subtest ccs0: SUCCESS (6.170s)
[415.943396] Subtest manyslice: SUCCESS (36.174s)
[416.254557] [074/133] (613s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[416.353867] Starting subtest: plane-upscale-20x20-with-pixel-format
[416.356061] Starting dynamic subtest: pipe-A
[417.424690] Dynamic subtest pipe-A: SUCCESS (1.072s)
[417.432896] Starting dynamic subtest: pipe-B
[419.503501] Dynamic subtest pipe-B: SUCCESS (2.077s)
[419.512729] Starting dynamic subtest: pipe-C
[420.914345] Dynamic subtest pipe-C: SUCCESS (1.410s)
[420.924737] Starting dynamic subtest: pipe-D
[422.063259] Dynamic subtest pipe-D: SUCCESS (1.148s)
[422.065610] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.711s)
[423.263633] [075/133] (606s left) kms_addfb_basic (unused-handle)
[423.322634] Starting subtest: unused-handle
[423.324539] Subtest unused-handle: SUCCESS (0.000s)
[423.446306] [076/133] (606s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[423.541597] Starting subtest: random-ccs-data-y-tiled-ccs
[423.543913] Starting dynamic subtest: pipe-A-eDP-1
[423.568311] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[423.584350] Starting dynamic subtest: pipe-B-eDP-1
[423.607364] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[423.616386] Starting dynamic subtest: pipe-C-eDP-1
[423.639797] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[423.647765] Starting dynamic subtest: pipe-D-eDP-1
[423.671534] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[423.675872] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.006s)
[425.744023] [077/133] (604s left) gem_exec_reloc (basic-cpu-noreloc)
[425.803636] Subtest basic-cpu-noreloc: SKIP (0.000s)
[425.884041] [078/133] (604s left) vgem_basic (unload)
[425.921675] Starting subtest: unload
[455.010844] Subtest unload: SUCCESS (29.042s)
[455.056045] [079/133] (575s left) perf_pmu (idle)
[455.114531] Starting subtest: idle
[455.116725] Starting dynamic subtest: rcs0
[455.662965] Dynamic subtest rcs0: SUCCESS (0.548s)
[455.674872] Starting dynamic subtest: bcs0
[456.189672] Dynamic subtest bcs0: SUCCESS (0.524s)
[456.200893] Starting dynamic subtest: vcs0
[456.705244] Dynamic subtest vcs0: SUCCESS (0.513s)
[456.715590] Starting dynamic subtest: vcs1
[457.221826] Dynamic subtest vcs1: SUCCESS (0.513s)
[457.234049] Starting dynamic subtest: vecs0
[457.741403] Dynamic subtest vecs0: SUCCESS (0.516s)
[457.752968] Starting dynamic subtest: ccs0
[458.260429] Dynamic subtest ccs0: SUCCESS (0.516s)
[458.263257] Subtest idle: SUCCESS (3.147s)
[458.385099] [080/133] (571s left) i915_query (query-regions-garbage-items)
[458.437363] Starting subtest: query-regions-garbage-items
[458.439349] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[458.558200] [081/133] (571s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[458.624623] Starting subtest: y-tiled-to-vebox-x-tiled
[458.629589] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[458.810231] [082/133] (571s left) gem_ctx_exec (basic)
[458.879636] Starting subtest: basic
[458.889205] Subtest basic: SUCCESS (0.010s)
[459.019256] [083/133] (571s left) kms_chamelium_color (gamma)
[459.128193] Subtest gamma: SKIP (0.000s)
[459.175027] [084/133] (571s left) gem_mmap_offset (partial-mmap)
[459.228044] Starting subtest: partial-mmap
[459.230288] Starting dynamic subtest: smem0
[459.232584] Dynamic subtest smem0: SUCCESS (0.004s)
[459.234506] Subtest partial-mmap: SUCCESS (0.004s)
[459.358436] [085/133] (571s left) gem_exec_fence (syncobj-unused-fence)
[459.762642] Starting subtest: syncobj-unused-fence
[459.768709] Subtest syncobj-unused-fence: SUCCESS (0.004s)
[460.979011] [086/133] (569s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[461.086629] Starting subtest: x-tiled-8bpp-rotate-270
[461.108108] Subtest x-tiled-8bpp-rotate-270: SKIP (0.021s)
[461.223496] [087/133] (569s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[461.319775] Starting subtest: fbc-rgb565-draw-pwrite
[465.931262] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.615s)
[467.056620] [088/133] (563s left) api_intel_bb (reset-flags)
[467.115610] Starting subtest: reset-flags
[467.125485] Subtest reset-flags: SUCCESS (0.013s)
[467.267396] [089/133] (563s left) gem_mmap_gtt (cpuset-big-copy)
[467.328147] Subtest cpuset-big-copy: SKIP (0.000s)
[467.385926] [090/133] (563s left) kms_psr (psr2-cursor-blt)
[467.484830] Starting subtest: psr2-cursor-blt
[467.487034] Starting dynamic subtest: eDP-1
[469.223638] Dynamic subtest eDP-1: SUCCESS (1.740s)
[469.226062] Subtest psr2-cursor-blt: SUCCESS (1.741s)
[470.019928] [091/133] (560s left) i915_query (query-garbage)
[470.078447] Starting subtest: query-garbage
[470.080712] Subtest query-garbage: SUCCESS (0.000s)
[470.202507] [092/133] (560s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[470.305623] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[470.309738] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[470.412475] [093/133] (560s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[470.497414] Starting subtest: invalidate-primary-flip-overlay
[481.351706] Subtest invalidate-primary-flip-overlay: SUCCESS (10.857s)
[481.479284] [094/133] (549s left) gem_lmem_swapping (heavy-multi)
[481.519486] Subtest heavy-multi: SKIP (0.000s)
[481.564075] [095/133] (549s left) gem_pxp (reject-modify-context-protection-off-2)
[481.690064] Starting subtest: reject-modify-context-protection-off-2
[481.692129] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[481.793431] [096/133] (549s left) core_setmaster_vs_auth
[481.957049] [097/133] (548s left) gem_exec_suspend (basic-s4-devices)
[482.025529] Starting subtest: basic-S4-devices
[482.027601] Starting dynamic subtest: smem
[493.910569] Dynamic subtest smem: SUCCESS (11.881s)
[493.914740] Subtest basic-S4-devices: SUCCESS (11.884s)
[501.115107] [098/133] (536s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[501.231067] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[508.460495] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.233s)
[508.580879] [099/133] (529s left) gem_exec_parallel (fds)
[508.640864] Starting subtest: fds
[508.643124] Starting dynamic subtest: rcs0
[511.443495] Dynamic subtest rcs0: SUCCESS (2.800s)
[511.454935] Starting dynamic subtest: bcs0
[515.145751] Dynamic subtest bcs0: SUCCESS (3.699s)
[515.158117] Starting dynamic subtest: vcs0
[519.166420] Dynamic subtest vcs0: SUCCESS (4.019s)
[519.181514] Starting dynamic subtest: vcs1
[523.156110] Dynamic subtest vcs1: SUCCESS (3.987s)
[523.169348] Starting dynamic subtest: vecs0
[527.235046] Dynamic subtest vecs0: SUCCESS (4.077s)
[527.248887] Starting dynamic subtest: ccs0
[530.802204] Dynamic subtest ccs0: SUCCESS (3.567s)
[530.804598] Subtest fds: SUCCESS (22.160s)
[530.997141] [100/133] (507s left) gem_exec_schedule (preempt-user)
[531.072735] Starting subtest: preempt-user
[531.075064] Starting dynamic subtest: rcs0
[531.101505] Dynamic subtest rcs0: SUCCESS (0.035s)
[531.113162] Starting dynamic subtest: bcs0
[531.133267] Dynamic subtest bcs0: SUCCESS (0.031s)
[531.144055] Starting dynamic subtest: vcs0
[531.160862] Dynamic subtest vcs0: SUCCESS (0.027s)
[531.171086] Starting dynamic subtest: vcs1
[531.188686] Dynamic subtest vcs1: SUCCESS (0.027s)
[531.199583] Starting dynamic subtest: vecs0
[531.211451] Dynamic subtest vecs0: SUCCESS (0.022s)
[531.222094] Starting dynamic subtest: ccs0
[531.241685] Dynamic subtest ccs0: SUCCESS (0.030s)
[531.244051] Subtest preempt-user: SUCCESS (0.176s)
[532.964899] [101/133] (505s left) gem_ctx_persistence (engines-persistence)
[533.022174] Starting subtest: engines-persistence
[533.024440] Starting dynamic subtest: rcs0
[533.847282] Dynamic subtest rcs0: SUCCESS (0.824s)
[533.860479] Starting dynamic subtest: bcs0
[534.587173] Dynamic subtest bcs0: SUCCESS (0.738s)
[534.599823] Starting dynamic subtest: vcs0
[535.387436] Dynamic subtest vcs0: SUCCESS (0.799s)
[535.398182] Starting dynamic subtest: vcs1
[536.151837] Dynamic subtest vcs1: SUCCESS (0.763s)
[536.165067] Starting dynamic subtest: vecs0
[536.911725] Dynamic subtest vecs0: SUCCESS (0.757s)
[536.923892] Starting dynamic subtest: ccs0
[537.681787] Dynamic subtest ccs0: SUCCESS (0.768s)
[537.684295] Subtest engines-persistence: SUCCESS (4.661s)
[537.763562] [102/133] (500s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[537.890042] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[537.894516] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[538.036253] [103/133] (500s left) kms_psr (psr2-cursor-plane-move)
[538.138907] Starting subtest: psr2-cursor-plane-move
[538.141165] Starting dynamic subtest: eDP-1
[539.815142] Dynamic subtest eDP-1: SUCCESS (1.675s)
[539.817304] Subtest psr2-cursor-plane-move: SUCCESS (1.676s)
[540.618883] [104/133] (497s left) kms_pm_rpm (i2c)
[542.153744] Starting subtest: i2c
[547.487399] Subtest i2c: SUCCESS (5.336s)
[547.593168] [105/133] (490s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[547.683720] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[547.688132] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[547.776796] [106/133] (490s left) syncobj_basic (bad-handle-to-fd)
[547.831191] Starting subtest: bad-handle-to-fd
[547.833063] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[547.923733] [107/133] (490s left) gem_userptr_blits (sync-unmap-cycles)
[547.998829] Starting subtest: sync-unmap-cycles
[553.371262] Subtest sync-unmap-cycles: SUCCESS (5.372s)
[553.488847] [108/133] (484s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[553.804290] Starting subtest: cursor-rapid-movement-max-size
[553.809587] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[553.939377] [109/133] (484s left) gem_userptr_blits (usage-restrictions)
[553.996670] Starting subtest: usage-restrictions
[553.998344] Subtest usage-restrictions: SUCCESS (0.000s)
[554.122379] [110/133] (484s left) syncobj_timeline (invalid-signal-illegal-handle)
[554.171259] Starting subtest: invalid-signal-illegal-handle
[554.173184] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[554.253790] [111/133] (484s left) perf (global-sseu-config-invalid)
[554.372276] Starting subtest: global-sseu-config-invalid
[554.375872] Subtest global-sseu-config-invalid: SKIP (0.000s)
[554.419538] [112/133] (484s left) kms_pm_backlight (fade)
[554.506758] Starting subtest: fade
[554.554778] Starting dynamic subtest: eDP-1
[557.026310] Dynamic subtest eDP-1: SUCCESS (2.470s)
[557.029264] Subtest fade: SUCCESS (2.520s)
[557.895886] [113/133] (480s left) kms_force_connector_basic (force-edid)
[557.974887] Starting subtest: force-edid
[558.342789] Subtest force-edid: SUCCESS (0.368s)
[558.480077] [114/133] (480s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[558.574907] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[558.579053] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[558.680452] [115/133] (480s left) dumb_buffer (invalid-bpp)
[558.740097] Starting subtest: invalid-bpp
[558.742228] Subtest invalid-bpp: SUCCESS (0.000s)
[558.838382] [116/133] (479s left) syncobj_timeline (multi-wait-available-submitted)
[558.904343] Starting subtest: multi-wait-available-submitted
[558.906642] Subtest multi-wait-available-submitted: SUCCESS (0.001s)
[559.022779] [117/133] (479s left) kms_chamelium_hpd (hdmi-hpd)
[559.409343] Subtest hdmi-hpd: SKIP (0.000s)
[560.198371] [118/133] (478s left) i915_pm_freq_api (freq-reset)
[560.255435] Starting subtest: freq-reset
[560.257901] Starting dynamic subtest: gt0
[560.446312] Dynamic subtest gt0: SUCCESS (0.190s)
[560.456268] Starting dynamic subtest: gt1
[560.603762] Dynamic subtest gt1: SUCCESS (0.154s)
[560.606262] Subtest freq-reset: SUCCESS (0.347s)
[560.676728] [119/133] (478s left) prime_self_import (basic-with_two_bos)
[560.712986] Starting subtest: basic-with_two_bos
[560.729223] Subtest basic-with_two_bos: SUCCESS (0.017s)
[560.827907] [120/133] (478s left) kms_psr (fbc-pr-sprite-blt)
[560.926707] Starting subtest: fbc-pr-sprite-blt
[560.931060] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[561.014397] [121/133] (477s left) gem_close_race (multigpu-basic-process)
[561.081716] Starting subtest: multigpu-basic-process
[561.086176] Subtest multigpu-basic-process: SKIP (0.000s)
[561.311378] [122/133] (477s left) gem_mmap_wc (close)
[561.372983] Subtest close: SKIP (0.000s)
[561.444089] [123/133] (477s left) kms_content_protection (uevent-hdcp14)
[561.569998] Starting subtest: uevent-hdcp14
[561.574781] Subtest uevent-hdcp14: SKIP (0.000s)
[561.700538] [124/133] (477s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[561.799571] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[561.801803] Starting dynamic subtest: pipe-A-eDP-1
[561.919947] Dynamic subtest pipe-A-eDP-1: SKIP (0.122s)
[561.932283] Starting dynamic subtest: pipe-B-eDP-1
[563.067709] Dynamic subtest pipe-B-eDP-1: SKIP (1.146s)
[563.072116] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.270s)
[564.314538] [125/133] (474s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[564.422618] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[564.426996] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[564.504500] [126/133] (474s left) vgem_basic (create)
[564.555966] Starting subtest: create
[564.558144] Subtest create: SUCCESS (0.000s)
[564.613833] [127/133] (474s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[564.706507] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[564.710719] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[564.799526] [128/133] (474s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[564.892958] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[564.895247] Starting dynamic subtest: pipe-A-eDP-1
[564.916824] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[564.928765] Starting dynamic subtest: pipe-B-eDP-1
[564.948175] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[564.958208] Starting dynamic subtest: pipe-C-eDP-1
[564.978159] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[564.988156] Starting dynamic subtest: pipe-D-eDP-1
[565.009662] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[565.013983] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[567.109388] [129/133] (472s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[567.170896] Starting subtest: etime-multi-wait-all-for-submit-submitted
[567.281579] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.108s)
[567.359815] [130/133] (471s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[567.455624] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[567.459600] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[567.555668] [131/133] (471s left) kms_color (ctm-blue-to-red)
[567.643552] Starting subtest: ctm-blue-to-red
[567.645694] Starting dynamic subtest: pipe-A-eDP-1
[568.332226] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.691s)
[568.342846] Starting dynamic subtest: pipe-B-eDP-1
[569.651475] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.317s)
[569.664538] Starting dynamic subtest: pipe-C-eDP-1
[570.998740] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.348s)
[571.009327] Starting dynamic subtest: pipe-D-eDP-1
[572.298532] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.297s)
[572.300550] Subtest ctm-blue-to-red: SUCCESS (4.656s)
[573.118289] [132/133] (466s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[573.214137] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[573.216562] Starting dynamic subtest: pipe-A-eDP-1
[573.238988] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[573.250779] Starting dynamic subtest: pipe-B-eDP-1
[573.272079] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[573.281824] Starting dynamic subtest: pipe-C-eDP-1
[573.302618] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[573.312601] Starting dynamic subtest: pipe-D-eDP-1
[573.334025] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[573.338296] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[575.415410] [133/133] (464s left) i915_pm_rps (engine-order)
[575.478700] Starting subtest: engine-order
[580.522871] Subtest engine-order: SUCCESS (5.026s)
[580.636672] Closing watchdogs
results: parsing output: 0/ for test: syncobj_basic
results: parsing output: 1/ for test: gem_ppgtt
results: parsing output: 2/ for test: prime_vgem
results: parsing output: 3/ for test: kms_async_flips
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_dp_aux_dev
results: parsing output: 6/ for test: gem_exec_store
results: parsing output: 7/ for test: kms_psr2_sf
results: parsing output: 8/ for test: kms_cursor_legacy
results: parsing output: 9/ for test: kms_flip_scaled_crc
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_pwrite
results: parsing output: 12/ for test: gem_ctx_shared
results: parsing output: 13/ for test: sriov_basic
results: parsing output: 14/ for test: kms_getfb
results: parsing output: 15/ for test: kms_vblank
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: gen7_exec_parse
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: kms_dsc
results: parsing output: 21/ for test: gem_spin_batch
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: gem_vm_create
results: parsing output: 24/ for test: kms_cursor_crc
results: parsing output: 25/ for test: kms_plane
results: parsing output: 26/ for test: kms_plane
results: parsing output: 27/ for test: kms_sequence
results: parsing output: 28/ for test: vgem_basic
results: parsing output: 29/ for test: gem_exec_gttfill
results: parsing output: 30/ for test: gem_exec_fence
results: parsing output: 31/ for test: kms_pipe_crc_basic
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: kms_joiner
results: parsing output: 36/ for test: syncobj_wait
results: parsing output: 37/ for test: gem_basic
results: parsing output: 38/ for test: gem_eio
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: kms_rotation_crc
results: parsing output: 41/ for test: gem_exec_fence
results: parsing output: 42/ for test: kms_invalid_mode
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: i915_drm_fdinfo
results: parsing output: 47/ for test: kms_atomic
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_flip
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: vgem_basic
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: i915_query
results: parsing output: 57/ for test: gem_ctx_persistence
results: parsing output: 58/ for test: gem_exec_balancer
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: sysfs_heartbeat_interval
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_flip_scaled_crc
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_flip_scaled_crc
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: kms_plane_lowres
results: parsing output: 71/ for test: kms_cursor_legacy
results: parsing output: 72/ for test: gem_exec_schedule
results: parsing output: 73/ for test: kms_plane_scaling
results: parsing output: 74/ for test: kms_addfb_basic
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: gem_exec_reloc
results: parsing output: 77/ for test: vgem_basic
results: parsing output: 78/ for test: perf_pmu
results: parsing output: 79/ for test: i915_query
results: parsing output: 80/ for test: gem_render_copy
results: parsing output: 81/ for test: gem_ctx_exec
results: parsing output: 82/ for test: kms_chamelium_color
results: parsing output: 83/ for test: gem_mmap_offset
results: parsing output: 84/ for test: gem_exec_fence
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: api_intel_bb
results: parsing output: 88/ for test: gem_mmap_gtt
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: i915_query
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_psr_stress_test
results: parsing output: 93/ for test: gem_lmem_swapping
results: parsing output: 94/ for test: gem_pxp
results: parsing output: 95/ for test: core_setmaster_vs_auth
results: parsing output: 96/ for test: gem_exec_suspend
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_exec_parallel
results: parsing output: 99/ for test: gem_exec_schedule
results: parsing output: 100/ for test: gem_ctx_persistence
results: parsing output: 101/ for test: kms_cursor_legacy
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: kms_pm_rpm
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: syncobj_basic
results: parsing output: 106/ for test: gem_userptr_blits
results: parsing output: 107/ for test: kms_cursor_crc
results: parsing output: 108/ for test: gem_userptr_blits
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: perf
results: parsing output: 111/ for test: kms_pm_backlight
results: parsing output: 112/ for test: kms_force_connector_basic
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: dumb_buffer
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: kms_chamelium_hpd
results: parsing output: 117/ for test: i915_pm_freq_api
results: parsing output: 118/ for test: prime_self_import
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: gem_close_race
results: parsing output: 121/ for test: gem_mmap_wc
results: parsing output: 122/ for test: kms_content_protection
results: parsing output: 123/ for test: kms_psr2_sf
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: vgem_basic
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_color
results: parsing output: 131/ for test: kms_ccs
results: parsing output: 132/ for test: i915_pm_rps
Done.