[61.331281] Initializing watchdogs
[61.331327]   /dev/watchdog0
[61.344606] [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.349103] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.352064] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.355754] [001/133] (960s left) syncobj_wait (wait-for-submit-snapshot)
[61.429952] Starting subtest: wait-for-submit-snapshot
[61.511939] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[61.586850] [002/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[61.682185] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[61.686138] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[61.767723] [003/133] (960s left) gem_fenced_exec_thrash (too-many-fences)
[61.832761] Subtest too-many-fences: SKIP (0.000s)
[61.891515] [004/133] (960s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[61.958751] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[61.961108] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[62.036742] [005/133] (959s left) gem_exec_balancer (hang)
[62.302966] Starting subtest: hang
[63.913911] Subtest hang: SUCCESS (1.613s)
[64.041891] [006/133] (957s left) gem_workarounds (basic-read-fd)
[64.142177] Starting subtest: basic-read-fd
[64.159081] Subtest basic-read-fd: SUCCESS (0.018s)
[64.289181] [007/133] (957s left) gem_workarounds (suspend-resume-fd)
[64.360030] Starting subtest: suspend-resume-fd
[80.144389] Subtest suspend-resume-fd: SUCCESS (1.324s)
[80.281828] [008/133] (941s left) kms_atomic_transition (modeset-transition-fencing)
[80.382001] Starting subtest: modeset-transition-fencing
[80.384098] Starting dynamic subtest: 1x-outputs
[91.560444] Dynamic subtest 1x-outputs: SUCCESS (11.195s)
[91.562774] Subtest modeset-transition-fencing: SUCCESS (11.196s)
[92.414040] [009/133] (929s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[92.512067] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[93.467228] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.956s)
[93.595251] [010/133] (928s left) gem_lmem_swapping (basic)
[93.637185] Subtest basic: SKIP (0.000s)
[93.673169] [011/133] (928s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[93.764034] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[93.767773] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[93.859694] [012/133] (928s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[93.950985] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[93.954424] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[94.051644] [013/133] (928s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[94.143903] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[94.145878] Starting dynamic subtest: pipe-A-eDP-1
[96.221726] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.080s)
[96.230483] Starting dynamic subtest: pipe-B-eDP-1
[98.456134] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.235s)
[98.464130] Starting dynamic subtest: pipe-C-eDP-1
[100.522775] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.066s)
[100.534860] Starting dynamic subtest: pipe-D-eDP-1
[102.627720] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.103s)
[102.629948] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.488s)
[103.846140] [014/133] (918s left) kms_hdmi_inject (inject-4k)
[104.210286] Starting subtest: inject-4k
[104.524118] Subtest inject-4k: SUCCESS (0.316s)
[105.112869] [015/133] (917s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[105.213157] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[105.217215] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[105.297449] [016/133] (917s left) kms_properties (get_properties-sanity-non-atomic)
[105.393877] Starting subtest: get_properties-sanity-non-atomic
[105.396243] Subtest get_properties-sanity-non-atomic: SUCCESS (0.001s)
[105.466285] [017/133] (916s left) gem_userptr_blits (nohangcheck)
[105.537057] Starting subtest: nohangcheck
[105.788165] Subtest nohangcheck: SUCCESS (0.248s)
[105.909183] [018/133] (916s left) perf_pmu (busy-start)
[105.961703] Starting subtest: busy-start
[105.963998] Starting dynamic subtest: rcs0
[108.514487] Dynamic subtest rcs0: SUCCESS (2.554s)
[108.525738] Starting dynamic subtest: bcs0
[111.063852] Dynamic subtest bcs0: SUCCESS (2.549s)
[111.073809] Starting dynamic subtest: vcs0
[113.656929] Dynamic subtest vcs0: FAIL (2.545s)
[113.667128] Starting dynamic subtest: vcs1
[116.193675] Dynamic subtest vcs1: FAIL (2.517s)
[116.203711] Starting dynamic subtest: vecs0
[119.376232] Dynamic subtest vecs0: SUCCESS (3.245s)
[119.387061] Starting dynamic subtest: ccs0
[121.926453] Dynamic subtest ccs0: SUCCESS (2.550s)
[121.929114] Subtest busy-start: FAIL (15.966s)
[122.042245] [019/133] (900s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[122.107704] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[122.212838] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[122.296036] [020/133] (900s left) kms_vblank (query-forked-busy)
[122.398913] Starting subtest: query-forked-busy
[122.401242] Starting dynamic subtest: pipe-A-eDP-1
[124.273981] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.875s)
[124.287298] Starting dynamic subtest: pipe-D-eDP-1
[126.798300] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.523s)
[126.800844] Subtest query-forked-busy: SUCCESS (4.401s)
[127.679815] [021/133] (894s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[127.778227] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[134.824518] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.049s)
[134.967430] [022/133] (887s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[135.056394] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[135.061323] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[136.185864] [023/133] (886s left) i915_pm_rps (reset)
[136.257036] Starting subtest: reset
[144.712371] Subtest reset: SUCCESS (8.458s)
[144.832919] [024/133] (877s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[144.949984] Starting subtest: cursorB-vs-flipB-atomic
[144.954384] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[145.109997] [025/133] (877s left) gem_create (create-ext-placement-sanity-check)
[145.276071] Starting subtest: create-ext-placement-sanity-check
[145.278288] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[145.386575] [026/133] (877s left) gem_eio (in-flight-contexts-immediate)
[145.618265] Starting subtest: in-flight-contexts-immediate
[159.405146] Subtest in-flight-contexts-immediate: SUCCESS (13.789s)
[159.518919] [027/133] (863s left) sysfs_preempt_timeout (invalid)
[159.574349] Starting subtest: invalid
[159.577051] Starting dynamic subtest: vecs0
[159.579092] Dynamic subtest vecs0: SUCCESS (0.000s)
[159.597007] Starting dynamic subtest: ccs0
[159.599694] Dynamic subtest ccs0: SUCCESS (0.000s)
[159.612690] Starting dynamic subtest: vcs0
[159.614585] Dynamic subtest vcs0: SUCCESS (0.000s)
[159.624921] Starting dynamic subtest: bcs0
[159.627068] Dynamic subtest bcs0: SUCCESS (0.000s)
[159.635408] Starting dynamic subtest: rcs0
[159.637571] Dynamic subtest rcs0: SUCCESS (0.000s)
[159.645381] Starting dynamic subtest: vcs1
[159.647446] Dynamic subtest vcs1: SUCCESS (0.000s)
[159.649557] Subtest invalid: SUCCESS (0.005s)
[159.683563] [028/133] (863s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[159.777751] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[159.779988] Starting dynamic subtest: A-eDP1
[163.395143] Dynamic subtest A-eDP1: SUCCESS (3.614s)
[163.413484] Starting dynamic subtest: B-eDP1
[166.697075] Dynamic subtest B-eDP1: SUCCESS (3.303s)
[166.707308] Starting dynamic subtest: C-eDP1
[169.997075] Dynamic subtest C-eDP1: SUCCESS (3.298s)
[170.005828] Starting dynamic subtest: D-eDP1
[173.295364] Dynamic subtest D-eDP1: SUCCESS (3.298s)
[173.297838] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.521s)
[174.180046] [029/133] (848s left) syncobj_wait (wait-all-for-submit-snapshot)
[174.247070] Starting subtest: wait-all-for-submit-snapshot
[174.327366] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[174.400695] [030/133] (848s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[174.499056] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[174.503182] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[174.607275] [031/133] (848s left) kms_flip (bo-too-big)
[174.708646] Starting subtest: bo-too-big
[174.712987] Starting dynamic subtest: A-eDP1
[175.997392] Dynamic subtest A-eDP1: SUCCESS (1.290s)
[176.011936] Starting dynamic subtest: B-eDP1
[177.287564] Dynamic subtest B-eDP1: SUCCESS (1.287s)
[177.296394] Starting dynamic subtest: C-eDP1
[178.576335] Dynamic subtest C-eDP1: SUCCESS (1.286s)
[178.589537] Starting dynamic subtest: D-eDP1
[179.888896] Dynamic subtest D-eDP1: SUCCESS (1.311s)
[179.893705] Subtest bo-too-big: SUCCESS (5.185s)
[181.064758] [032/133] (841s left) gem_exec_flush (basic-batch-kernel-default-wb)
[181.125477] Starting subtest: basic-batch-kernel-default-wb
[188.325727] Subtest basic-batch-kernel-default-wb: SUCCESS (7.199s)
[188.558238] [033/133] (834s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[188.937656] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[189.758098] [034/133] (833s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[189.861598] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[189.863991] Starting dynamic subtest: pipe-A-eDP-1
[189.922994] Dynamic subtest pipe-A-eDP-1: SKIP (0.003s)
[189.931412] Starting dynamic subtest: pipe-B-eDP-1
[189.989913] Dynamic subtest pipe-B-eDP-1: SKIP (0.004s)
[190.000372] Starting dynamic subtest: pipe-C-eDP-1
[190.057329] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[190.066788] Starting dynamic subtest: pipe-D-eDP-1
[190.123809] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[190.128082] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.017s)
[192.063998] [035/133] (831s left) fbdev (unaligned-write)
[192.110578] Starting subtest: unaligned-write
[192.208249] Subtest unaligned-write: SUCCESS (0.099s)
[192.265945] [036/133] (830s left) gem_ctx_param (invalid-set-no-zeromap)
[192.312440] Starting subtest: invalid-set-no-zeromap
[192.314840] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[192.395859] [037/133] (830s left) gem_exec_schedule (pi-ringfull)
[192.587813] Starting subtest: pi-ringfull
[192.590167] Starting dynamic subtest: rcs0
[192.673311] Dynamic subtest rcs0: SUCCESS (0.088s)
[192.686166] Starting dynamic subtest: bcs0
[192.702085] Dynamic subtest bcs0: SUCCESS (0.028s)
[192.713744] Starting dynamic subtest: vcs0
[192.730445] Dynamic subtest vcs0: SUCCESS (0.028s)
[192.742839] Starting dynamic subtest: vcs1
[192.758427] Dynamic subtest vcs1: SUCCESS (0.027s)
[192.769744] Starting dynamic subtest: vecs0
[192.785658] Dynamic subtest vecs0: SUCCESS (0.026s)
[192.798638] Starting dynamic subtest: ccs0
[192.811737] Dynamic subtest ccs0: SUCCESS (0.025s)
[192.813936] Subtest pi-ringfull: SUCCESS (0.227s)
[193.043347] [FACT gem_exec_schedule (pi-ringfull)] new: kernel.kmod_is_loaded.vgem: true
[193.046827] [038/133] (830s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[193.141769] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[194.131077] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (0.990s)
[194.257749] [039/133] (829s left) i915_drm_fdinfo (virtual-busy-idle)
[194.297804] Starting subtest: virtual-busy-idle
[194.302181] Subtest virtual-busy-idle: SKIP (0.000s)
[194.363482] [040/133] (829s left) kms_prop_blob (basic)
[194.422119] Starting subtest: basic
[194.424101] Subtest basic: SUCCESS (0.000s)
[194.541422] [041/133] (828s left) kms_psr (psr-dpms)
[194.639939] Starting subtest: psr-dpms
[194.641908] Starting dynamic subtest: eDP-1
[197.533818] Dynamic subtest eDP-1: SUCCESS (2.893s)
[197.536228] Subtest psr-dpms: SUCCESS (2.894s)
[198.372923] [042/133] (825s left) i915_suspend (sysfs-reader)
[198.434716] Starting subtest: sysfs-reader
[216.116417] Subtest sysfs-reader: SUCCESS (3.135s)
[216.183619] [043/133] (807s left) kms_draw_crc (draw-method-mmap-cpu)
[216.284486] Starting subtest: draw-method-mmap-cpu
[216.286440] Starting dynamic subtest: xrgb8888-untiled
[216.526592] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s)
[216.537558] Starting dynamic subtest: rgb565-untiled
[216.748942] Dynamic subtest rgb565-untiled: SUCCESS (0.220s)
[216.764989] Starting dynamic subtest: xrgb2101010-untiled
[216.970236] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.219s)
[216.982661] Starting dynamic subtest: xbgr16161616f-untiled
[217.214677] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.244s)
[217.224995] Starting dynamic subtest: xrgb8888-xtiled
[217.347860] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.132s)
[217.356483] Starting dynamic subtest: rgb565-xtiled
[217.480214] Dynamic subtest rgb565-xtiled: SUCCESS (0.131s)
[217.490984] Starting dynamic subtest: xrgb2101010-xtiled
[217.613552] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.131s)
[217.624674] Starting dynamic subtest: xbgr16161616f-xtiled
[217.746573] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.131s)
[217.754974] Starting dynamic subtest: xrgb8888-4tiled
[217.879898] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.132s)
[217.888711] Starting dynamic subtest: rgb565-4tiled
[218.013042] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[218.023033] Starting dynamic subtest: xrgb2101010-4tiled
[218.146743] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[218.155822] Starting dynamic subtest: xbgr16161616f-4tiled
[218.290537] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.143s)
[218.292536] Subtest draw-method-mmap-cpu: SUCCESS (2.011s)
[218.393408] [044/133] (805s left) kms_rotation_crc (primary-rotation-180)
[218.472184] Starting subtest: primary-rotation-180
[225.489381] Subtest primary-rotation-180: SUCCESS (7.025s)
[226.678113] [045/133] (796s left) syncobj_wait (multi-wait-all-submitted-signaled)
[226.742380] Starting subtest: multi-wait-all-submitted-signaled
[226.848545] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.104s)
[226.925589] [046/133] (796s left) kms_getfb (getfb-handle-zero)
[227.016415] Starting subtest: getfb-handle-zero
[227.018685] Subtest getfb-handle-zero: SUCCESS (0.000s)
[227.116969] [047/133] (796s left) gem_mmap_gtt (flink-race)
[227.175697] Subtest flink-race: SKIP (0.000s)
[227.236404] [048/133] (796s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[227.319944] Starting subtest: stress-xrgb8888-xtiled
[233.208948] Subtest stress-xrgb8888-xtiled: SUCCESS (5.892s)
[233.266152] [049/133] (790s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[233.350593] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[233.361672] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.010s)
[233.468941] [050/133] (790s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[233.564861] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[233.566747] Starting dynamic subtest: pipe-A-eDP-1
[233.574313] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[233.583661] Starting dynamic subtest: pipe-B-eDP-1
[233.591196] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[233.600215] Starting dynamic subtest: pipe-C-eDP-1
[233.607268] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[233.615851] Starting dynamic subtest: pipe-D-eDP-1
[233.623121] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[233.626758] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[235.767220] [051/133] (788s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[235.824550] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[235.928999] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[236.021062] [052/133] (787s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[236.125153] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[236.129567] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[236.247391] [053/133] (787s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[236.484293] Starting subtest: cursor-rapid-movement-256x256
[236.492029] Starting dynamic subtest: pipe-A-eDP-1
[237.033154] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.540s)
[237.058590] Starting dynamic subtest: pipe-D-eDP-1
[238.238558] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.185s)
[238.240799] Subtest cursor-rapid-movement-256x256: SUCCESS (1.754s)
[239.075715] [054/133] (784s left) kms_tiled_display (basic-test-pattern)
[239.190770] Subtest basic-test-pattern: SKIP (0.000s)
[239.236554] [055/133] (784s left) gem_pxp (fail-invalid-protected-context)
[239.364137] Starting subtest: fail-invalid-protected-context
[239.366563] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[239.471928] [056/133] (784s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[239.569465] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[239.571578] Starting dynamic subtest: pipe-A-eDP-1
[239.593701] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[239.604294] Starting dynamic subtest: pipe-B-eDP-1
[239.624564] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[239.633655] Starting dynamic subtest: pipe-C-eDP-1
[239.654792] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[239.663989] Starting dynamic subtest: pipe-D-eDP-1
[239.685821] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[239.689869] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[241.773558] [057/133] (782s left) gem_ctx_shared (create-shared-gtt)
[241.843900] Starting subtest: create-shared-gtt
[243.995481] Subtest create-shared-gtt: SUCCESS (2.151s)
[244.401117] [058/133] (779s left) gem_caching (reads)
[244.464913] Subtest reads: SKIP (0.000s)
[244.538122] [059/133] (779s left) prime_vgem (fence-wait)
[244.611226] Starting subtest: fence-wait
[244.613544] Starting dynamic subtest: rcs0
[245.664621] Dynamic subtest rcs0: SUCCESS (1.052s)
[245.677057] Starting dynamic subtest: bcs0
[246.723487] Dynamic subtest bcs0: SUCCESS (1.057s)
[246.735086] Starting dynamic subtest: vcs0
[247.767207] Dynamic subtest vcs0: SUCCESS (1.043s)
[247.779061] Starting dynamic subtest: vcs1
[248.809375] Dynamic subtest vcs1: SUCCESS (1.041s)
[248.821566] Starting dynamic subtest: vecs0
[249.852448] Dynamic subtest vecs0: SUCCESS (1.042s)
[249.863133] Starting dynamic subtest: ccs0
[250.894228] Dynamic subtest ccs0: SUCCESS (1.040s)
[250.897219] Subtest fence-wait: SUCCESS (6.285s)
[251.025302] [060/133] (773s left) kms_psr (psr-cursor-plane-move)
[251.115304] Starting subtest: psr-cursor-plane-move
[251.117484] Starting dynamic subtest: eDP-1
[252.819330] Dynamic subtest eDP-1: SUCCESS (1.703s)
[252.822154] Subtest psr-cursor-plane-move: SUCCESS (1.704s)
[253.672831] [061/133] (770s left) kms_vrr (max-min)
[253.757424] Starting subtest: max-min
[253.763392] Subtest max-min: SKIP (0.000s)
[253.845360] [062/133] (770s left) prime_mmap_kms (buffer-sharing)
[253.944918] Starting subtest: buffer-sharing
[254.381924] Subtest buffer-sharing: SUCCESS (0.439s)
[255.180664] [063/133] (769s left) kms_content_protection (lic-type-0-hdcp14)
[255.316679] Starting subtest: lic-type-0-hdcp14
[255.321565] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[255.439178] [064/133] (768s left) api_intel_allocator (reopen-fork)
[255.495128] Starting subtest: reopen-fork
[258.784711] Subtest reopen-fork: SUCCESS (3.291s)
[258.861250] [065/133] (765s left) gen9_exec_parse (bb-large)
[258.936153] Subtest bb-large: SKIP (0.000s)
[258.996162] [066/133] (765s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[259.392947] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[260.254927] [067/133] (764s left) kms_invalid_mode (int-max-clock)
[260.345825] Starting subtest: int-max-clock
[260.348064] Starting dynamic subtest: pipe-A-eDP-1
[260.630772] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[260.640647] Starting dynamic subtest: pipe-B-eDP-1
[260.642535] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[260.651606] Starting dynamic subtest: pipe-C-eDP-1
[260.653842] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[260.662667] Starting dynamic subtest: pipe-D-eDP-1
[260.665015] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[260.667320] Subtest int-max-clock: SUCCESS (0.291s)
[261.498453] [068/133] (763s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[261.627969] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[262.587756] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.962s)
[263.471267] [069/133] (761s left) gem_userptr_blits (process-exit)
[263.539504] Starting subtest: process-exit
[263.547045] Subtest process-exit: SUCCESS (0.008s)
[263.663927] [070/133] (761s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[263.767762] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[263.794189] Starting dynamic subtest: pipe-A-plane-0
[264.082223] Dynamic subtest pipe-A-plane-0: SUCCESS (0.288s)
[264.094422] Starting dynamic subtest: pipe-A-plane-3
[264.315360] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[265.425918] Starting dynamic subtest: pipe-B-plane-0
[265.726718] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[265.738256] Starting dynamic subtest: pipe-B-plane-3
[265.959958] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[266.272968] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.507s)
[267.082829] [071/133] (757s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[267.182163] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[267.193050] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.010s)
[267.271756] [072/133] (757s left) gem_exec_flush (basic-uc-pro-default)
[267.337401] Starting subtest: basic-uc-pro-default
[272.796545] Subtest basic-uc-pro-default: SUCCESS (5.463s)
[272.986436] [073/133] (751s left) kms_psr (pr-sprite-mmap-gtt)
[273.081375] Starting subtest: pr-sprite-mmap-gtt
[273.085723] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[273.153352] [074/133] (751s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[273.244018] Starting subtest: 4-tiled-16bpp-rotate-90
[273.264181] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.019s)
[273.387390] [075/133] (751s left) gem_softpin (evict-single-offset)
[273.451113] Starting subtest: evict-single-offset
[300.900919] Subtest evict-single-offset: SUCCESS (27.454s)
[300.984951] [076/133] (723s left) gem_userptr_blits (sync-overlap)
[301.091790] Starting subtest: sync-overlap
[301.094191] Subtest sync-overlap: SUCCESS (0.000s)
[301.198220] [077/133] (723s left) gem_exec_capture (capture-recoverable)
[301.260443] Starting subtest: capture-recoverable
[301.265919] Subtest capture-recoverable: SUCCESS (0.005s)
[301.382575] [078/133] (723s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[301.484070] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[308.753610] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.273s)
[308.861654] [079/133] (716s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[308.927542] Starting subtest: yf-tiled-to-vebox-yf-tiled
[308.932017] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[309.107290] [080/133] (716s left) device_reset (cold-reset-bound)
[309.157655] Starting subtest: cold-reset-bound
[309.162222] Subtest cold-reset-bound: SKIP (0.000s)
[309.231760] [081/133] (715s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[309.357974] Starting subtest: 2x-flip-vs-cursor-atomic
[309.362476] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[309.518349] [082/133] (715s left) gem_exec_schedule (fairslice-all)
[309.600661] Starting subtest: fairslice-all
[311.660046] Subtest fairslice-all: SUCCESS (2.067s)
[312.912548] [083/133] (712s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[313.028437] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[313.032960] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[313.118867] [084/133] (712s left) kms_lease (lease-invalid-plane)
[313.221747] Starting subtest: lease-invalid-plane
[313.224014] Starting dynamic subtest: pipe-A-eDP-1
[313.226398] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[313.236833] Starting dynamic subtest: pipe-B-eDP-1
[313.239379] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[313.249289] Starting dynamic subtest: pipe-C-eDP-1
[313.251523] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[313.261227] Starting dynamic subtest: pipe-D-eDP-1
[313.263470] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[313.265703] Subtest lease-invalid-plane: SUCCESS (0.004s)
[313.306513] [085/133] (712s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[313.417577] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[313.421936] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[313.520485] [086/133] (711s left) kms_cursor_crc (cursor-offscreen-64x21)
[313.699701] Starting subtest: cursor-offscreen-64x21
[313.744756] Subtest cursor-offscreen-64x21: SKIP (0.042s)
[313.987839] [087/133] (711s left) gem_exec_store (basic)
[314.045152] Starting subtest: basic
[314.145318] Subtest basic: SUCCESS (0.101s)
[314.345359] [088/133] (711s left) gem_ppgtt (blt-vs-render-ctxn)
[314.400394] Starting subtest: blt-vs-render-ctxN
[347.116132] Subtest blt-vs-render-ctxN: SUCCESS (32.708s)
[347.269565] [089/133] (678s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[347.405112] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[347.409558] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[347.510630] [090/133] (678s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[347.577797] Starting subtest: multi-wait-for-submit-available-signaled
[347.579665] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.001s)
[347.684710] [091/133] (677s left) kms_addfb_basic (master-rmfb)
[347.750095] Starting subtest: master-rmfb
[347.752253] Subtest master-rmfb: SUCCESS (0.001s)
[347.893694] [092/133] (677s left) kms_flip (plain-flip-fb-recreate)
[347.983367] Starting subtest: plain-flip-fb-recreate
[347.985753] Starting dynamic subtest: A-eDP1
[356.905588] Dynamic subtest A-eDP1: SUCCESS (8.925s)
[356.918145] Starting dynamic subtest: B-eDP1
[365.811801] Dynamic subtest B-eDP1: SUCCESS (8.904s)
[365.825200] Starting dynamic subtest: C-eDP1
[374.694608] Dynamic subtest C-eDP1: SUCCESS (8.880s)
[374.706834] Starting dynamic subtest: D-eDP1
[383.501556] Dynamic subtest D-eDP1: SUCCESS (8.804s)
[383.505957] Subtest plain-flip-fb-recreate: SUCCESS (35.527s)
[384.752531] [093/133] (640s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[384.837370] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[384.944534] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.107s)
[385.051768] [094/133] (640s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[385.145188] Starting subtest: yf-tiled-64bpp-rotate-270
[385.149482] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[385.237468] [095/133] (640s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[385.336769] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[385.339004] Starting dynamic subtest: pipe-A-eDP-1
[385.433696] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[385.450404] Starting dynamic subtest: pipe-B-eDP-1
[386.591907] Dynamic subtest pipe-B-eDP-1: SKIP (1.156s)
[386.596503] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.259s)
[387.845227] [096/133] (637s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[387.942906] Starting subtest: psr-rgb565-draw-pwrite
[394.820935] Subtest psr-rgb565-draw-pwrite: SUCCESS (6.880s)
[394.921719] [097/133] (630s left) kms_busy (extended-modeset-hang-oldfb)
[395.022551] Starting subtest: extended-modeset-hang-oldfb
[395.024824] Starting dynamic subtest: pipe-A
[406.789053] Dynamic subtest pipe-A: SUCCESS (11.764s)
[406.799984] Starting dynamic subtest: pipe-D
[419.082968] Dynamic subtest pipe-D: SUCCESS (12.296s)
[419.085359] Subtest extended-modeset-hang-oldfb: SUCCESS (24.065s)
[419.933737] [098/133] (605s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[419.987627] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[419.989946] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[420.076960] [099/133] (605s left) gem_exec_fence (invalid-timeline-fence-array)
[420.760566] Starting subtest: invalid-timeline-fence-array
[420.771484] Subtest invalid-timeline-fence-array: SUCCESS (0.010s)
[422.002271] [100/133] (603s left) syncobj_eventfd (invalid-bad-pad)
[422.069094] Starting subtest: invalid-bad-pad
[422.071557] Subtest invalid-bad-pad: SUCCESS (0.000s)
[422.182590] [101/133] (603s left) api_intel_bb (render)
[422.245134] Starting subtest: render
[422.247319] Starting dynamic subtest: render-none-512
[422.344945] Dynamic subtest render-none-512: SUCCESS (0.101s)
[422.357383] Starting dynamic subtest: render-none-1024
[422.729711] Dynamic subtest render-none-1024: SUCCESS (0.382s)
[422.740345] Starting dynamic subtest: render-x-512
[422.816686] Dynamic subtest render-x-512: SUCCESS (0.087s)
[422.828975] Starting dynamic subtest: render-x-1024
[423.157983] Dynamic subtest render-x-1024: SUCCESS (0.339s)
[423.170372] Starting dynamic subtest: render-y-512
[423.244203] Dynamic subtest render-y-512: SUCCESS (0.086s)
[423.256205] Starting dynamic subtest: render-y-1024
[423.606706] Dynamic subtest render-y-1024: SUCCESS (0.361s)
[423.609340] Subtest render: SUCCESS (1.363s)
[423.716903] [102/133] (602s left) gem_softpin (evict-active-interruptible)
[423.780187] Starting subtest: evict-active-interruptible
[423.787817] Subtest evict-active-interruptible: SUCCESS (0.010s)
[423.931958] [103/133] (602s left) kms_big_fb (linear-16bpp-rotate-0)
[424.044013] Starting subtest: linear-16bpp-rotate-0
[425.344155] Subtest linear-16bpp-rotate-0: SUCCESS (1.302s)
[425.482072] [104/133] (600s left) kms_psr (fbc-psr-cursor-blt)
[425.574896] Starting subtest: fbc-psr-cursor-blt
[425.576759] Starting dynamic subtest: eDP-1
[425.580121] Dynamic subtest eDP-1: SKIP (0.000s)
[425.583479] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[425.662697] [105/133] (600s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[425.765932] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[425.769629] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[425.867412] [106/133] (600s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[425.925809] Starting subtest: invalid-bsd1-flag-on-vebox
[425.927654] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[426.027711] [107/133] (600s left) kms_plane_multiple (tiling-y)
[426.110679] Starting subtest: tiling-y
[426.114107] Subtest tiling-y: SKIP (0.000s)
[426.197037] [108/133] (600s left) prime_mmap (test_map_unmap)
[426.249457] Starting subtest: test_map_unmap
[426.251076] Starting dynamic subtest: test_map_unmap-smem
[426.284275] Dynamic subtest test_map_unmap-smem: SUCCESS (0.036s)
[426.286446] Subtest test_map_unmap: SUCCESS (0.036s)
[426.381704] [109/133] (599s left) gem_ctx_param (non-root-set)
[426.441692] Starting subtest: non-root-set
[426.463590] Subtest non-root-set: SUCCESS (0.023s)
[426.561417] [110/133] (599s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[426.651071] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[426.653136] Starting dynamic subtest: pipe-A-eDP-1
[432.384448] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.736s)
[432.395675] Starting dynamic subtest: pipe-B-eDP-1
[438.911075] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.525s)
[438.913403] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.263s)
[439.730406] [111/133] (586s left) gem_mmap_gtt (cpuset-medium-copy)
[439.782688] Subtest cpuset-medium-copy: SKIP (0.000s)
[439.853239] [112/133] (586s left) prime_self_import (reimport-vs-gem_close-race)
[439.887658] Starting subtest: reimport-vs-gem_close-race
[444.984594] Subtest reimport-vs-gem_close-race: SUCCESS (5.095s)
[445.077451] [113/133] (581s left) gem_ctx_sseu (mmap-args)
[445.140919] Subtest mmap-args: SKIP (0.000s)
[445.212805] [114/133] (581s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[445.319254] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[448.825966] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.511s)
[449.950566] [115/133] (576s left) kms_color (legacy-gamma)
[450.049884] Starting subtest: legacy-gamma
[450.052282] Starting dynamic subtest: pipe-A-eDP-1
[450.780358] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.728s)
[450.790641] Starting dynamic subtest: pipe-B-eDP-1
[452.204586] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.424s)
[452.215125] Starting dynamic subtest: pipe-C-eDP-1
[453.569724] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.366s)
[453.580792] Starting dynamic subtest: pipe-D-eDP-1
[454.942186] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.372s)
[454.944552] Subtest legacy-gamma: SUCCESS (4.893s)
[455.741880] [116/133] (570s left) syncobj_timeline (single-wait-available-signaled)
[455.803666] Starting subtest: single-wait-available-signaled
[455.806032] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[455.918426] [117/133] (570s left) kms_cursor_edge_walk (64x64-right-edge)
[456.023298] Starting subtest: 64x64-right-edge
[456.025638] Starting dynamic subtest: pipe-A-eDP-1
[459.478557] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.451s)
[459.494339] Starting dynamic subtest: pipe-D-eDP-1
[462.654463] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.176s)
[462.656686] Subtest 64x64-right-edge: SUCCESS (6.631s)
[463.528625] [118/133] (563s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[463.633768] Starting subtest: fbc-pr-sprite-mmap-cpu
[463.637662] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[463.717856] [119/133] (563s left) kms_cursor_legacy (forked-bo)
[463.844657] Starting subtest: forked-bo
[463.846485] Starting dynamic subtest: pipe-A
[469.318092] Dynamic subtest pipe-A: SUCCESS (5.472s)
[469.329426] Starting dynamic subtest: pipe-B
[474.816778] Dynamic subtest pipe-B: SUCCESS (5.469s)
[474.831435] Starting dynamic subtest: pipe-C
[480.276557] Dynamic subtest pipe-C: SUCCESS (5.484s)
[480.289295] Starting dynamic subtest: pipe-D
[485.741993] Dynamic subtest pipe-D: SUCCESS (5.466s)
[485.754326] Starting dynamic subtest: all-pipes
[491.248781] Dynamic subtest all-pipes: SUCCESS (5.505s)
[491.251411] Subtest forked-bo: SUCCESS (27.407s)
[491.399829] [120/133] (535s left) gen9_exec_parse (shadow-peek)
[491.467246] Subtest shadow-peek: SKIP (0.000s)
[491.542409] [121/133] (535s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[491.648586] Starting subtest: plane-upscale-factor-0-25-with-rotation
[491.650775] Starting dynamic subtest: pipe-A
[491.873404] Dynamic subtest pipe-A: SUCCESS (0.227s)
[491.891175] Starting dynamic subtest: pipe-B
[493.164921] Dynamic subtest pipe-B: SUCCESS (1.291s)
[493.175059] Starting dynamic subtest: pipe-C
[494.467854] Dynamic subtest pipe-C: SUCCESS (1.302s)
[494.478459] Starting dynamic subtest: pipe-D
[495.764695] Dynamic subtest pipe-D: SUCCESS (1.296s)
[495.767038] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.120s)
[496.918900] [122/133] (529s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[497.019826] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[497.023954] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[497.119726] [123/133] (529s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[497.216104] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[497.220259] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[497.319723] [124/133] (529s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[497.433424] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[504.251697] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.823s)
[504.387864] [125/133] (522s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[504.488301] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[504.492561] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[504.559820] [126/133] (522s left) prime_mmap (test_aperture_limit)
[504.617433] Starting subtest: test_aperture_limit
[504.619268] Starting dynamic subtest: test_aperture_limit-smem
[504.625904] Dynamic subtest test_aperture_limit-smem: SKIP (0.007s)
[504.629815] Subtest test_aperture_limit: SKIP (0.008s)
[504.699719] [127/133] (522s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[504.797709] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[511.555381] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.762s)
[511.674505] [128/133] (515s left) kms_hdr (bpc-switch-suspend)
[511.769867] Starting subtest: bpc-switch-suspend
[512.856530] Starting dynamic subtest: pipe-A-eDP-1
[532.306788] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.631s)
[532.309126] Subtest bpc-switch-suspend: SUCCESS (5.718s)
[532.419987] [129/133] (494s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[532.476561] Starting subtest: x-tiled-to-vebox-yf-tiled
[532.481150] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[532.700136] [130/133] (494s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[532.804604] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[532.806999] Starting dynamic subtest: pipe-A
[532.939967] Dynamic subtest pipe-A: SKIP (0.130s)
[532.950167] Starting dynamic subtest: pipe-B
[534.117871] Dynamic subtest pipe-B: SKIP (1.178s)
[534.128398] Starting dynamic subtest: pipe-C
[535.285188] Dynamic subtest pipe-C: SUCCESS (1.175s)
[535.295763] Starting dynamic subtest: pipe-D
[536.486268] Dynamic subtest pipe-D: SUCCESS (1.201s)
[536.489021] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.689s)
[537.644790] [131/133] (489s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[539.880302] Starting subtest: dpms-mode-unset-non-lpsp
[541.044853] Subtest dpms-mode-unset-non-lpsp: SKIP (1.167s)
[541.421780] [132/133] (485s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[541.527544] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[541.531997] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[541.598786] [133/133] (485s left) gem_exec_schedule (u-fairslice)
[541.675204] Starting subtest: u-fairslice
[541.677236] Starting dynamic subtest: rcs0
[543.685745] Dynamic subtest rcs0: SUCCESS (2.020s)
[543.708432] Starting dynamic subtest: bcs0
[545.705449] Dynamic subtest bcs0: SUCCESS (2.020s)
[545.716790] Starting dynamic subtest: vcs0
[547.725073] Dynamic subtest vcs0: SUCCESS (2.019s)
[547.736499] Starting dynamic subtest: vcs1
[549.757236] Dynamic subtest vcs1: SUCCESS (2.015s)
[549.767743] Starting dynamic subtest: vecs0
[551.755647] Dynamic subtest vecs0: SUCCESS (2.018s)
[551.768190] Starting dynamic subtest: ccs0
[553.776424] Dynamic subtest ccs0: SUCCESS (2.019s)
[553.778469] Subtest u-fairslice: SUCCESS (12.116s)
[554.087548] Closing watchdogs
results: parsing output: 0/ for test: syncobj_wait
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_fenced_exec_thrash
results: parsing output: 3/ for test: syncobj_wait
results: parsing output: 4/ for test: gem_exec_balancer
results: parsing output: 5/ for test: gem_workarounds
results: parsing output: 6/ for test: gem_workarounds
results: parsing output: 7/ for test: kms_atomic_transition
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: gem_lmem_swapping
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: kms_hdmi_inject
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_properties
results: parsing output: 16/ for test: gem_userptr_blits
results: parsing output: 17/ for test: perf_pmu
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: kms_vblank
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: i915_pm_rps
results: parsing output: 23/ for test: kms_cursor_legacy
results: parsing output: 24/ for test: gem_create
results: parsing output: 25/ for test: gem_eio
results: parsing output: 26/ for test: sysfs_preempt_timeout
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: syncobj_wait
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_flip
results: parsing output: 31/ for test: gem_exec_flush
results: parsing output: 32/ for test: kms_chamelium_hpd
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: fbdev
results: parsing output: 35/ for test: gem_ctx_param
results: parsing output: 36/ for test: gem_exec_schedule
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: i915_drm_fdinfo
results: parsing output: 39/ for test: kms_prop_blob
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: i915_suspend
results: parsing output: 42/ for test: kms_draw_crc
results: parsing output: 43/ for test: kms_rotation_crc
results: parsing output: 44/ for test: syncobj_wait
results: parsing output: 45/ for test: kms_getfb
results: parsing output: 46/ for test: gem_mmap_gtt
results: parsing output: 47/ for test: kms_pipe_stress
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: syncobj_wait
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_cursor_crc
results: parsing output: 53/ for test: kms_tiled_display
results: parsing output: 54/ for test: gem_pxp
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: gem_ctx_shared
results: parsing output: 57/ for test: gem_caching
results: parsing output: 58/ for test: prime_vgem
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: kms_vrr
results: parsing output: 61/ for test: prime_mmap_kms
results: parsing output: 62/ for test: kms_content_protection
results: parsing output: 63/ for test: api_intel_allocator
results: parsing output: 64/ for test: gen9_exec_parse
results: parsing output: 65/ for test: kms_chamelium_edid
results: parsing output: 66/ for test: kms_invalid_mode
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: gem_userptr_blits
results: parsing output: 69/ for test: kms_plane
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: gem_exec_flush
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: gem_softpin
results: parsing output: 75/ for test: gem_userptr_blits
results: parsing output: 76/ for test: gem_exec_capture
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_render_copy
results: parsing output: 79/ for test: device_reset
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: gem_exec_schedule
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_lease
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_cursor_crc
results: parsing output: 86/ for test: gem_exec_store
results: parsing output: 87/ for test: gem_ppgtt
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: kms_addfb_basic
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: syncobj_wait
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_psr2_sf
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_busy
results: parsing output: 97/ for test: syncobj_timeline
results: parsing output: 98/ for test: gem_exec_fence
results: parsing output: 99/ for test: syncobj_eventfd
results: parsing output: 100/ for test: api_intel_bb
results: parsing output: 101/ for test: gem_softpin
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: kms_psr
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_exec_params
results: parsing output: 106/ for test: kms_plane_multiple
results: parsing output: 107/ for test: prime_mmap
results: parsing output: 108/ for test: gem_ctx_param
results: parsing output: 109/ for test: kms_psr2_sf
results: parsing output: 110/ for test: gem_mmap_gtt
results: parsing output: 111/ for test: prime_self_import
results: parsing output: 112/ for test: gem_ctx_sseu
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_color
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: kms_cursor_edge_walk
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: kms_cursor_legacy
results: parsing output: 119/ for test: gen9_exec_parse
results: parsing output: 120/ for test: kms_plane_scaling
results: parsing output: 121/ for test: kms_flip_scaled_crc
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_flip_scaled_crc
results: parsing output: 125/ for test: prime_mmap
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_hdr
results: parsing output: 128/ for test: gem_render_copy
results: parsing output: 129/ for test: kms_plane_scaling
results: parsing output: 130/ for test: kms_pm_rpm
results: parsing output: 131/ for test: kms_psr2_sf
results: parsing output: 132/ for test: gem_exec_schedule
Done.