[59.903356] Initializing watchdogs
[59.903400]   /dev/watchdog0
[59.916837] [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]
[59.921095] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.923397] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.926814] [001/133] (960s left) syncobj_wait (wait-for-submit-snapshot)
[60.006422] Starting subtest: wait-for-submit-snapshot
[60.086508] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[60.175509] [002/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[60.288230] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[60.292336] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[60.386120] [003/133] (960s left) gem_fenced_exec_thrash (too-many-fences)
[60.455857] Subtest too-many-fences: SKIP (0.000s)
[60.497308] [004/133] (960s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[60.545645] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[60.547782] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[60.626865] [005/133] (959s left) gem_exec_balancer (hang)
[60.881508] Starting subtest: hang
[62.943352] Subtest hang: SUCCESS (2.065s)
[63.069989] [006/133] (957s left) gem_workarounds (basic-read-fd)
[63.154347] Starting subtest: basic-read-fd
[63.176947] Subtest basic-read-fd: SUCCESS (0.023s)
[63.316615] [007/133] (957s left) gem_workarounds (suspend-resume-fd)
[63.379630] Starting subtest: suspend-resume-fd
[79.961647] Subtest suspend-resume-fd: SUCCESS (1.262s)
[80.115281] [008/133] (940s left) kms_atomic_transition (modeset-transition-fencing)
[80.226838] Starting subtest: modeset-transition-fencing
[80.229155] Starting dynamic subtest: 1x-outputs
[91.270790] Dynamic subtest 1x-outputs: SUCCESS (11.067s)
[91.273333] Subtest modeset-transition-fencing: SUCCESS (11.067s)
[92.132083] [009/133] (928s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[92.237461] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[93.202932] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.967s)
[93.358658] [010/133] (927s left) gem_lmem_swapping (basic)
[93.413050] Subtest basic: SKIP (0.000s)
[93.452297] [011/133] (927s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[93.547411] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[93.550905] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[93.643929] [012/133] (927s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[93.742636] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[93.746345] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[93.854882] [013/133] (927s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[93.947437] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[93.949383] Starting dynamic subtest: pipe-A-eDP-1
[96.059020] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.112s)
[96.067788] Starting dynamic subtest: pipe-B-eDP-1
[98.205856] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.148s)
[98.214926] Starting dynamic subtest: pipe-C-eDP-1
[100.338430] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.132s)
[100.347165] Starting dynamic subtest: pipe-D-eDP-1
[102.369082] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.031s)
[102.371335] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.426s)
[103.593340] [014/133] (917s left) kms_hdmi_inject (inject-4k)
[103.949613] Starting subtest: inject-4k
[104.261076] Subtest inject-4k: SUCCESS (0.313s)
[104.829482] [015/133] (916s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[104.937980] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[104.942315] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[105.061188] [016/133] (915s left) kms_properties (get_properties-sanity-non-atomic)
[105.150862] Starting subtest: get_properties-sanity-non-atomic
[105.153095] Subtest get_properties-sanity-non-atomic: SUCCESS (0.002s)
[105.222802] [017/133] (915s left) gem_userptr_blits (nohangcheck)
[105.303937] Starting subtest: nohangcheck
[105.547884] Subtest nohangcheck: SUCCESS (0.242s)
[105.657286] [018/133] (915s left) perf_pmu (busy-start)
[105.700745] Starting subtest: busy-start
[105.703020] Starting dynamic subtest: rcs0
[108.251839] Dynamic subtest rcs0: SUCCESS (2.554s)
[108.261573] Starting dynamic subtest: bcs0
[110.801629] Dynamic subtest bcs0: SUCCESS (2.549s)
[110.811971] Starting dynamic subtest: vcs0
[113.386712] Dynamic subtest vcs0: FAIL (2.537s)
[113.394832] Starting dynamic subtest: vcs1
[115.917935] Dynamic subtest vcs1: FAIL (2.515s)
[115.926264] Starting dynamic subtest: vecs0
[119.213415] Dynamic subtest vecs0: SUCCESS (3.350s)
[119.223859] Starting dynamic subtest: ccs0
[121.761221] Dynamic subtest ccs0: SUCCESS (2.547s)
[121.763737] Subtest busy-start: FAIL (16.059s)
[121.861986] [019/133] (899s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[121.918250] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[122.025485] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.107s)
[122.100845] [020/133] (899s left) kms_vblank (query-forked-busy)
[122.191790] Starting subtest: query-forked-busy
[122.194099] Starting dynamic subtest: pipe-A-eDP-1
[124.072532] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.877s)
[124.087247] Starting dynamic subtest: pipe-D-eDP-1
[126.652460] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.579s)
[126.654849] Subtest query-forked-busy: SUCCESS (4.459s)
[127.521632] [021/133] (893s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[127.628437] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[134.625326] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (6.999s)
[134.749090] [022/133] (886s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[134.839551] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[134.843901] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[135.909829] [023/133] (885s left) i915_pm_rps (reset)
[135.969099] Starting subtest: reset
[144.403531] Subtest reset: SUCCESS (8.434s)
[144.527129] [024/133] (876s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[144.645043] Starting subtest: cursorB-vs-flipB-atomic
[144.649549] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[144.788756] [025/133] (876s left) gem_create (create-ext-placement-sanity-check)
[144.939386] Starting subtest: create-ext-placement-sanity-check
[144.941909] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[145.038934] [026/133] (876s left) gem_eio (in-flight-contexts-immediate)
[145.267164] Starting subtest: in-flight-contexts-immediate
[159.227110] Subtest in-flight-contexts-immediate: SUCCESS (13.962s)
[159.375175] [027/133] (862s left) sysfs_preempt_timeout (invalid)
[159.431241] Starting subtest: invalid
[159.433663] Starting dynamic subtest: vecs0
[159.436097] Dynamic subtest vecs0: SUCCESS (0.000s)
[159.445587] Starting dynamic subtest: ccs0
[159.447804] Dynamic subtest ccs0: SUCCESS (0.000s)
[159.456032] Starting dynamic subtest: vcs0
[159.458292] Dynamic subtest vcs0: SUCCESS (0.000s)
[159.466517] Starting dynamic subtest: bcs0
[159.468794] Dynamic subtest bcs0: SUCCESS (0.000s)
[159.476809] Starting dynamic subtest: rcs0
[159.478663] Dynamic subtest rcs0: SUCCESS (0.000s)
[159.486967] Starting dynamic subtest: vcs1
[159.489437] Dynamic subtest vcs1: SUCCESS (0.000s)
[159.491931] Subtest invalid: SUCCESS (0.004s)
[159.529782] [028/133] (861s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[159.618697] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[159.621034] Starting dynamic subtest: A-eDP1
[163.242043] Dynamic subtest A-eDP1: SUCCESS (3.620s)
[163.252366] Starting dynamic subtest: B-eDP1
[166.531469] Dynamic subtest B-eDP1: SUCCESS (3.290s)
[166.540757] Starting dynamic subtest: C-eDP1
[169.835222] Dynamic subtest C-eDP1: SUCCESS (3.303s)
[169.847420] Starting dynamic subtest: D-eDP1
[173.130974] Dynamic subtest D-eDP1: SUCCESS (3.296s)
[173.135879] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.518s)
[174.008644] [029/133] (847s left) syncobj_wait (wait-all-for-submit-snapshot)
[174.068716] Starting subtest: wait-all-for-submit-snapshot
[174.149803] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[174.223647] [030/133] (847s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[174.328188] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[174.332259] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[174.428675] [031/133] (847s left) kms_flip (bo-too-big)
[174.532080] Starting subtest: bo-too-big
[174.533969] Starting dynamic subtest: A-eDP1
[175.819160] Dynamic subtest A-eDP1: SUCCESS (1.288s)
[175.834614] Starting dynamic subtest: B-eDP1
[177.122047] Dynamic subtest B-eDP1: SUCCESS (1.300s)
[177.134979] Starting dynamic subtest: C-eDP1
[178.428365] Dynamic subtest C-eDP1: SUCCESS (1.304s)
[178.436828] Starting dynamic subtest: D-eDP1
[179.726463] Dynamic subtest D-eDP1: SUCCESS (1.296s)
[179.731933] Subtest bo-too-big: SUCCESS (5.201s)
[180.908031] [032/133] (840s left) gem_exec_flush (basic-batch-kernel-default-wb)
[180.974368] Starting subtest: basic-batch-kernel-default-wb
[188.203977] Subtest basic-batch-kernel-default-wb: SUCCESS (7.230s)
[188.388396] [033/133] (833s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[188.777221] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[189.581974] [034/133] (832s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[189.685037] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[189.687344] Starting dynamic subtest: pipe-A-eDP-1
[189.745068] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[189.755362] Starting dynamic subtest: pipe-B-eDP-1
[189.813798] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[189.825499] Starting dynamic subtest: pipe-C-eDP-1
[189.883587] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[189.893196] Starting dynamic subtest: pipe-D-eDP-1
[189.950513] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[189.955112] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.008s)
[191.903244] [035/133] (829s left) fbdev (unaligned-write)
[191.946212] Starting subtest: unaligned-write
[192.127587] Subtest unaligned-write: SUCCESS (0.179s)
[192.216187] [036/133] (829s left) gem_ctx_param (invalid-set-no-zeromap)
[192.267719] Starting subtest: invalid-set-no-zeromap
[192.270151] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[192.352221] [037/133] (829s left) gem_exec_schedule (pi-ringfull)
[192.526422] Starting subtest: pi-ringfull
[192.528440] Starting dynamic subtest: rcs0
[192.611566] Dynamic subtest rcs0: SUCCESS (0.088s)
[192.626105] Starting dynamic subtest: bcs0
[192.639158] Dynamic subtest bcs0: SUCCESS (0.027s)
[192.652687] Starting dynamic subtest: vcs0
[192.666131] Dynamic subtest vcs0: SUCCESS (0.026s)
[192.677806] Starting dynamic subtest: vcs1
[192.693973] Dynamic subtest vcs1: SUCCESS (0.027s)
[192.705839] Starting dynamic subtest: vecs0
[192.722897] Dynamic subtest vecs0: SUCCESS (0.028s)
[192.735896] Starting dynamic subtest: ccs0
[192.749641] Dynamic subtest ccs0: SUCCESS (0.026s)
[192.751794] Subtest pi-ringfull: SUCCESS (0.226s)
[192.966310] [FACT gem_exec_schedule (pi-ringfull)] new: kernel.kmod_is_loaded.vgem: true
[192.969926] [038/133] (828s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[193.058061] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[194.035215] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (0.978s)
[194.156145] [039/133] (827s left) i915_drm_fdinfo (virtual-busy-idle)
[194.195355] Starting subtest: virtual-busy-idle
[194.199464] Subtest virtual-busy-idle: SKIP (0.000s)
[194.254138] [040/133] (827s left) kms_prop_blob (basic)
[194.317623] Starting subtest: basic
[194.320003] Subtest basic: SUCCESS (0.000s)
[194.418371] [041/133] (827s left) kms_psr (psr-dpms)
[194.505181] Starting subtest: psr-dpms
[194.507157] Starting dynamic subtest: eDP-1
[197.481619] Dynamic subtest eDP-1: SUCCESS (2.975s)
[197.483811] Subtest psr-dpms: SUCCESS (2.976s)
[198.316276] [042/133] (823s left) i915_suspend (sysfs-reader)
[198.377292] Starting subtest: sysfs-reader
[216.948903] Subtest sysfs-reader: SUCCESS (3.129s)
[217.028359] [043/133] (805s left) kms_draw_crc (draw-method-mmap-cpu)
[217.119706] Starting subtest: draw-method-mmap-cpu
[217.121480] Starting dynamic subtest: xrgb8888-untiled
[217.339363] Dynamic subtest xrgb8888-untiled: SUCCESS (0.221s)
[217.348379] Starting dynamic subtest: rgb565-untiled
[217.539226] Dynamic subtest rgb565-untiled: SUCCESS (0.200s)
[217.548532] Starting dynamic subtest: xrgb2101010-untiled
[217.760276] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[217.769093] Starting dynamic subtest: xbgr16161616f-untiled
[217.960475] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.199s)
[217.969363] Starting dynamic subtest: xrgb8888-xtiled
[218.092996] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[218.101692] Starting dynamic subtest: rgb565-xtiled
[218.215299] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[218.224229] Starting dynamic subtest: xrgb2101010-xtiled
[218.326083] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.109s)
[218.335101] Starting dynamic subtest: xbgr16161616f-xtiled
[218.458915] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[218.468377] Starting dynamic subtest: xrgb8888-4tiled
[218.591576] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[218.602308] Starting dynamic subtest: rgb565-4tiled
[218.724649] Dynamic subtest rgb565-4tiled: SUCCESS (0.132s)
[218.734072] Starting dynamic subtest: xrgb2101010-4tiled
[218.857614] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.132s)
[218.867147] Starting dynamic subtest: xbgr16161616f-4tiled
[219.001657] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.143s)
[219.003797] Subtest draw-method-mmap-cpu: SUCCESS (1.889s)
[219.097461] [044/133] (802s left) kms_rotation_crc (primary-rotation-180)
[219.189722] Starting subtest: primary-rotation-180
[226.361637] Subtest primary-rotation-180: SUCCESS (7.185s)
[227.546117] [045/133] (794s left) syncobj_wait (multi-wait-all-submitted-signaled)
[227.604807] Starting subtest: multi-wait-all-submitted-signaled
[227.711716] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.107s)
[227.790147] [046/133] (794s left) kms_getfb (getfb-handle-zero)
[227.890611] Starting subtest: getfb-handle-zero
[227.892961] Subtest getfb-handle-zero: SUCCESS (0.000s)
[227.994357] [047/133] (794s left) gem_mmap_gtt (flink-race)
[228.062930] Subtest flink-race: SKIP (0.000s)
[228.124311] [048/133] (794s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[228.218093] Starting subtest: stress-xrgb8888-xtiled
[234.111139] Subtest stress-xrgb8888-xtiled: SUCCESS (5.898s)
[234.169224] [049/133] (788s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[234.267102] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[234.277764] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.010s)
[234.356456] [050/133] (788s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[234.448466] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[234.450700] Starting dynamic subtest: pipe-A-eDP-1
[234.459712] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[234.473796] Starting dynamic subtest: pipe-B-eDP-1
[234.482882] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[234.491958] Starting dynamic subtest: pipe-C-eDP-1
[234.501638] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[234.510894] Starting dynamic subtest: pipe-D-eDP-1
[234.519858] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[234.524102] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[236.707536] [051/133] (785s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[236.773971] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[236.880453] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.107s)
[236.960859] [052/133] (785s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[237.062988] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[237.068242] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[237.172945] [053/133] (785s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[237.423597] Starting subtest: cursor-rapid-movement-256x256
[237.426071] Starting dynamic subtest: pipe-A-eDP-1
[237.971536] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.543s)
[238.002073] Starting dynamic subtest: pipe-D-eDP-1
[239.170568] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.177s)
[239.172963] Subtest cursor-rapid-movement-256x256: SUCCESS (1.746s)
[240.012548] [054/133] (782s left) kms_tiled_display (basic-test-pattern)
[240.126313] Subtest basic-test-pattern: SKIP (0.000s)
[240.175647] [055/133] (782s left) gem_pxp (fail-invalid-protected-context)
[240.302101] Starting subtest: fail-invalid-protected-context
[240.304947] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[240.408955] [056/133] (782s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[240.497466] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[240.499786] Starting dynamic subtest: pipe-A-eDP-1
[240.522741] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[240.533664] Starting dynamic subtest: pipe-B-eDP-1
[240.557983] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[240.566840] Starting dynamic subtest: pipe-C-eDP-1
[240.591858] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[240.600656] Starting dynamic subtest: pipe-D-eDP-1
[240.626834] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[240.632060] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[242.696833] [057/133] (779s left) gem_ctx_shared (create-shared-gtt)
[242.760586] Starting subtest: create-shared-gtt
[244.912356] Subtest create-shared-gtt: SUCCESS (2.152s)
[245.295356] [058/133] (777s left) gem_caching (reads)
[245.356251] Subtest reads: SKIP (0.000s)
[245.472935] [059/133] (777s left) prime_vgem (fence-wait)
[245.549695] Starting subtest: fence-wait
[245.552550] Starting dynamic subtest: rcs0
[246.597231] Dynamic subtest rcs0: SUCCESS (1.048s)
[246.606971] Starting dynamic subtest: bcs0
[247.666412] Dynamic subtest bcs0: SUCCESS (1.069s)
[247.678103] Starting dynamic subtest: vcs0
[248.717954] Dynamic subtest vcs0: SUCCESS (1.051s)
[248.730227] Starting dynamic subtest: vcs1
[249.759911] Dynamic subtest vcs1: SUCCESS (1.040s)
[249.772407] Starting dynamic subtest: vecs0
[250.803510] Dynamic subtest vecs0: SUCCESS (1.041s)
[250.816216] Starting dynamic subtest: ccs0
[251.847023] Dynamic subtest ccs0: SUCCESS (1.041s)
[251.850012] Subtest fence-wait: SUCCESS (6.299s)
[251.974307] [060/133] (770s left) kms_psr (psr-cursor-plane-move)
[252.071627] Starting subtest: psr-cursor-plane-move
[252.074003] Starting dynamic subtest: eDP-1
[253.756898] Dynamic subtest eDP-1: SUCCESS (1.686s)
[253.759787] Subtest psr-cursor-plane-move: SUCCESS (1.687s)
[254.588098] [061/133] (768s left) kms_vrr (max-min)
[254.693887] Starting subtest: max-min
[254.701343] Subtest max-min: SKIP (0.000s)
[254.777258] [062/133] (768s left) prime_mmap_kms (buffer-sharing)
[254.869787] Starting subtest: buffer-sharing
[255.321964] Subtest buffer-sharing: SUCCESS (0.453s)
[256.187765] [063/133] (766s left) kms_content_protection (lic-type-0-hdcp14)
[256.328962] Starting subtest: lic-type-0-hdcp14
[256.334804] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[256.466589] [064/133] (766s left) api_intel_allocator (reopen-fork)
[256.530996] Starting subtest: reopen-fork
[259.809065] Subtest reopen-fork: SUCCESS (3.279s)
[259.889425] [065/133] (763s left) gen9_exec_parse (bb-large)
[259.947379] Subtest bb-large: SKIP (0.000s)
[260.004656] [066/133] (763s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[260.391373] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[261.180117] [067/133] (761s left) kms_invalid_mode (int-max-clock)
[261.275556] Starting subtest: int-max-clock
[261.278109] Starting dynamic subtest: pipe-A-eDP-1
[261.557588] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[261.567961] Starting dynamic subtest: pipe-B-eDP-1
[261.570407] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[261.584614] Starting dynamic subtest: pipe-C-eDP-1
[261.587243] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[261.597007] Starting dynamic subtest: pipe-D-eDP-1
[261.599898] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[261.602668] Subtest int-max-clock: SUCCESS (0.289s)
[262.395984] [068/133] (760s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[262.523496] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[263.480769] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.959s)
[264.305744] [069/133] (758s left) gem_userptr_blits (process-exit)
[264.369995] Starting subtest: process-exit
[264.377103] Subtest process-exit: SUCCESS (0.009s)
[264.497347] [070/133] (758s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[264.593441] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[264.619731] Starting dynamic subtest: pipe-A-plane-0
[264.919005] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[264.928287] Starting dynamic subtest: pipe-A-plane-3
[265.153126] Dynamic subtest pipe-A-plane-3: SUCCESS (0.231s)
[266.243801] Starting dynamic subtest: pipe-B-plane-0
[266.547806] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[266.557996] Starting dynamic subtest: pipe-B-plane-3
[266.782233] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[267.093489] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.502s)
[267.896430] [071/133] (755s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[267.991619] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[268.003021] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.010s)
[268.082517] [072/133] (755s left) gem_exec_flush (basic-uc-pro-default)
[268.140895] Starting subtest: basic-uc-pro-default
[273.609166] Subtest basic-uc-pro-default: SUCCESS (5.469s)
[273.793659] [073/133] (749s left) kms_psr (pr-sprite-mmap-gtt)
[273.886651] Starting subtest: pr-sprite-mmap-gtt
[273.892087] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[273.958123] [074/133] (749s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[274.053209] Starting subtest: 4-tiled-16bpp-rotate-90
[274.073107] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.020s)
[274.187022] [075/133] (749s left) gem_softpin (evict-single-offset)
[274.249889] Starting subtest: evict-single-offset
[301.702553] Subtest evict-single-offset: SUCCESS (27.457s)
[301.785913] [076/133] (721s left) gem_userptr_blits (sync-overlap)
[301.910775] Starting subtest: sync-overlap
[301.912922] Subtest sync-overlap: SUCCESS (0.000s)
[302.055061] [077/133] (721s left) gem_exec_capture (capture-recoverable)
[302.115761] Starting subtest: capture-recoverable
[302.119897] Subtest capture-recoverable: SUCCESS (0.007s)
[302.243974] [078/133] (721s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[302.355624] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[309.572511] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.222s)
[309.684106] [079/133] (713s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[309.745424] Starting subtest: yf-tiled-to-vebox-yf-tiled
[309.750935] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[309.930957] [080/133] (713s left) device_reset (cold-reset-bound)
[309.980325] Starting subtest: cold-reset-bound
[309.985597] Subtest cold-reset-bound: SKIP (0.000s)
[310.051803] [081/133] (713s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[310.167413] Starting subtest: 2x-flip-vs-cursor-atomic
[310.171912] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[310.318576] [082/133] (713s left) gem_exec_schedule (fairslice-all)
[310.398985] Starting subtest: fairslice-all
[312.457971] Subtest fairslice-all: SUCCESS (2.065s)
[313.666623] [083/133] (710s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[313.773895] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[313.778891] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[313.862452] [084/133] (710s left) kms_lease (lease-invalid-plane)
[313.958058] Starting subtest: lease-invalid-plane
[313.961012] Starting dynamic subtest: pipe-A-eDP-1
[313.963838] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[313.974587] Starting dynamic subtest: pipe-B-eDP-1
[313.977609] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[313.988087] Starting dynamic subtest: pipe-C-eDP-1
[313.990503] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[314.000576] Starting dynamic subtest: pipe-D-eDP-1
[314.002821] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[314.004934] Subtest lease-invalid-plane: SUCCESS (0.004s)
[314.043973] [085/133] (709s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[314.148858] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[314.154472] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[314.248519] [086/133] (709s left) kms_cursor_crc (cursor-offscreen-64x21)
[314.444185] Starting subtest: cursor-offscreen-64x21
[314.497758] Subtest cursor-offscreen-64x21: SKIP (0.050s)
[314.740289] [087/133] (709s left) gem_exec_store (basic)
[314.807327] Starting subtest: basic
[314.905635] Subtest basic: SUCCESS (0.100s)
[315.090051] [088/133] (708s left) gem_ppgtt (blt-vs-render-ctxn)
[315.147397] Starting subtest: blt-vs-render-ctxN
[347.863812] Subtest blt-vs-render-ctxN: SUCCESS (32.708s)
[347.989443] [089/133] (676s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[348.117851] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[348.122951] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[348.217457] [090/133] (675s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[348.266895] Starting subtest: multi-wait-for-submit-available-signaled
[348.269869] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.001s)
[348.373460] [091/133] (675s left) kms_addfb_basic (master-rmfb)
[348.423834] Starting subtest: master-rmfb
[348.426121] Subtest master-rmfb: SUCCESS (0.001s)
[348.560276] [092/133] (675s left) kms_flip (plain-flip-fb-recreate)
[348.653253] Starting subtest: plain-flip-fb-recreate
[348.655667] Starting dynamic subtest: A-eDP1
[357.555397] Dynamic subtest A-eDP1: SUCCESS (8.901s)
[357.568355] Starting dynamic subtest: B-eDP1
[366.453235] Dynamic subtest B-eDP1: SUCCESS (8.897s)
[366.466101] Starting dynamic subtest: C-eDP1
[375.334081] Dynamic subtest C-eDP1: SUCCESS (8.878s)
[375.345573] Starting dynamic subtest: D-eDP1
[384.229935] Dynamic subtest D-eDP1: SUCCESS (8.896s)
[384.234257] Subtest plain-flip-fb-recreate: SUCCESS (35.586s)
[385.374732] [093/133] (638s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[385.436557] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[385.543935] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.107s)
[385.633807] [094/133] (638s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[385.741952] Starting subtest: yf-tiled-64bpp-rotate-270
[385.746610] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[385.825947] [095/133] (638s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[385.922669] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[385.924989] Starting dynamic subtest: pipe-A-eDP-1
[386.020959] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[386.034131] Starting dynamic subtest: pipe-B-eDP-1
[387.221877] Dynamic subtest pipe-B-eDP-1: SKIP (1.198s)
[387.226730] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.300s)
[388.475294] [096/133] (635s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[388.573422] Starting subtest: psr-rgb565-draw-pwrite
[395.454912] Subtest psr-rgb565-draw-pwrite: SUCCESS (6.885s)
[395.565310] [097/133] (628s left) kms_busy (extended-modeset-hang-oldfb)
[395.663276] Starting subtest: extended-modeset-hang-oldfb
[395.665709] Starting dynamic subtest: pipe-A
[407.526102] Dynamic subtest pipe-A: SUCCESS (11.863s)
[407.543845] Starting dynamic subtest: pipe-D
[419.809513] Dynamic subtest pipe-D: SUCCESS (12.286s)
[419.812096] Subtest extended-modeset-hang-oldfb: SUCCESS (24.154s)
[420.654910] [098/133] (603s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[420.722915] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[420.725826] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[420.845482] [099/133] (603s left) gem_exec_fence (invalid-timeline-fence-array)
[421.422485] Starting subtest: invalid-timeline-fence-array
[421.428961] Subtest invalid-timeline-fence-array: SUCCESS (0.005s)
[422.714213] [100/133] (601s left) syncobj_eventfd (invalid-bad-pad)
[422.777679] Starting subtest: invalid-bad-pad
[422.780116] Subtest invalid-bad-pad: SUCCESS (0.000s)
[422.858983] [101/133] (601s left) api_intel_bb (render)
[422.907539] Starting subtest: render
[422.910390] Starting dynamic subtest: render-none-512
[423.013999] Dynamic subtest render-none-512: SUCCESS (0.107s)
[423.026819] Starting dynamic subtest: render-none-1024
[423.393516] Dynamic subtest render-none-1024: SUCCESS (0.378s)
[423.404553] Starting dynamic subtest: render-x-512
[423.479560] Dynamic subtest render-x-512: SUCCESS (0.086s)
[423.491731] Starting dynamic subtest: render-x-1024
[423.817081] Dynamic subtest render-x-1024: SUCCESS (0.336s)
[423.832378] Starting dynamic subtest: render-y-512
[423.906971] Dynamic subtest render-y-512: SUCCESS (0.089s)
[423.919193] Starting dynamic subtest: render-y-1024
[424.246823] Dynamic subtest render-y-1024: SUCCESS (0.338s)
[424.250119] Subtest render: SUCCESS (1.341s)
[424.377971] [102/133] (600s left) gem_softpin (evict-active-interruptible)
[424.445166] Starting subtest: evict-active-interruptible
[424.455929] Subtest evict-active-interruptible: SUCCESS (0.011s)
[424.585730] [103/133] (600s left) kms_big_fb (linear-16bpp-rotate-0)
[424.684310] Starting subtest: linear-16bpp-rotate-0
[426.096613] Subtest linear-16bpp-rotate-0: SUCCESS (1.414s)
[426.217601] [104/133] (598s left) kms_psr (fbc-psr-cursor-blt)
[426.302973] Starting subtest: fbc-psr-cursor-blt
[426.305438] Starting dynamic subtest: eDP-1
[426.309730] Dynamic subtest eDP-1: SKIP (0.000s)
[426.314004] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[426.377477] [105/133] (598s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[426.473356] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[426.477982] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[426.587447] [106/133] (598s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[426.645194] Starting subtest: invalid-bsd1-flag-on-vebox
[426.647793] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[426.734674] [107/133] (598s left) kms_plane_multiple (tiling-y)
[426.809480] Starting subtest: tiling-y
[426.813896] Subtest tiling-y: SKIP (0.000s)
[426.884405] [108/133] (598s left) prime_mmap (test_map_unmap)
[426.935739] Starting subtest: test_map_unmap
[426.937833] Starting dynamic subtest: test_map_unmap-smem
[426.967754] Dynamic subtest test_map_unmap-smem: SUCCESS (0.032s)
[426.970101] Subtest test_map_unmap: SUCCESS (0.034s)
[427.072577] [109/133] (597s left) gem_ctx_param (non-root-set)
[427.120050] Starting subtest: non-root-set
[427.141066] Subtest non-root-set: SUCCESS (0.021s)
[427.232597] [110/133] (597s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[427.336754] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[427.338656] Starting dynamic subtest: pipe-A-eDP-1
[433.117951] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.787s)
[433.129979] Starting dynamic subtest: pipe-B-eDP-1
[439.615834] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.498s)
[439.618456] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.288s)
[440.454512] [111/133] (584s left) gem_mmap_gtt (cpuset-medium-copy)
[440.512991] Subtest cpuset-medium-copy: SKIP (0.000s)
[440.570985] [112/133] (584s left) prime_self_import (reimport-vs-gem_close-race)
[440.605476] Starting subtest: reimport-vs-gem_close-race
[445.689912] Subtest reimport-vs-gem_close-race: SUCCESS (5.086s)
[445.778010] [113/133] (579s left) gem_ctx_sseu (mmap-args)
[445.845828] Subtest mmap-args: SKIP (0.000s)
[445.935382] [114/133] (579s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[446.036995] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[449.557102] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.524s)
[450.664968] [115/133] (574s left) kms_color (legacy-gamma)
[450.755936] Starting subtest: legacy-gamma
[450.758314] Starting dynamic subtest: pipe-A-eDP-1
[451.474798] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.719s)
[451.485771] Starting dynamic subtest: pipe-B-eDP-1
[452.954012] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.479s)
[452.967091] Starting dynamic subtest: pipe-C-eDP-1
[454.277519] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.322s)
[454.288255] Starting dynamic subtest: pipe-D-eDP-1
[455.664538] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.386s)
[455.667104] Subtest legacy-gamma: SUCCESS (4.910s)
[456.458799] [116/133] (568s left) syncobj_timeline (single-wait-available-signaled)
[456.528089] Starting subtest: single-wait-available-signaled
[456.530862] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[456.645738] [117/133] (568s left) kms_cursor_edge_walk (64x64-right-edge)
[456.733853] Starting subtest: 64x64-right-edge
[456.736417] Starting dynamic subtest: pipe-A-eDP-1
[460.190096] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.457s)
[460.200982] Starting dynamic subtest: pipe-D-eDP-1
[463.384571] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.191s)
[463.387009] Subtest 64x64-right-edge: SUCCESS (6.651s)
[464.254195] [118/133] (561s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[464.348802] Starting subtest: fbc-pr-sprite-mmap-cpu
[464.353803] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[464.423170] [119/133] (560s left) kms_cursor_legacy (forked-bo)
[464.537910] Starting subtest: forked-bo
[464.540609] Starting dynamic subtest: pipe-A
[470.016725] Dynamic subtest pipe-A: SUCCESS (5.475s)
[470.033070] Starting dynamic subtest: pipe-B
[475.488095] Dynamic subtest pipe-B: SUCCESS (5.470s)
[475.499113] Starting dynamic subtest: pipe-C
[480.952897] Dynamic subtest pipe-C: SUCCESS (5.462s)
[480.964537] Starting dynamic subtest: pipe-D
[486.427539] Dynamic subtest pipe-D: SUCCESS (5.472s)
[486.446044] Starting dynamic subtest: all-pipes
[491.925375] Dynamic subtest all-pipes: SUCCESS (5.495s)
[491.928084] Subtest forked-bo: SUCCESS (27.384s)
[492.087117] [120/133] (533s left) gen9_exec_parse (shadow-peek)
[492.165396] Subtest shadow-peek: SKIP (0.000s)
[492.254761] [121/133] (533s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[492.348831] Starting subtest: plane-upscale-factor-0-25-with-rotation
[492.351555] Starting dynamic subtest: pipe-A
[492.573831] Dynamic subtest pipe-A: SUCCESS (0.227s)
[492.584495] Starting dynamic subtest: pipe-B
[493.906077] Dynamic subtest pipe-B: SUCCESS (1.331s)
[493.917210] Starting dynamic subtest: pipe-C
[495.208740] Dynamic subtest pipe-C: SUCCESS (1.302s)
[495.218719] Starting dynamic subtest: pipe-D
[496.502804] Dynamic subtest pipe-D: SUCCESS (1.293s)
[496.505293] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.157s)
[497.663351] [122/133] (527s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[497.763023] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[497.768361] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[497.835439] [123/133] (527s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[497.930832] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[497.935387] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[498.031245] [124/133] (527s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[498.129976] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[505.055084] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.929s)
[505.184430] [125/133] (520s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[505.275475] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[505.280402] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[505.352621] [126/133] (520s left) prime_mmap (test_aperture_limit)
[505.409960] Starting subtest: test_aperture_limit
[505.412849] Starting dynamic subtest: test_aperture_limit-smem
[505.418268] Dynamic subtest test_aperture_limit-smem: SKIP (0.007s)
[505.423282] Subtest test_aperture_limit: SKIP (0.008s)
[505.501868] [127/133] (520s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[505.600069] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[512.415104] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.819s)
[512.538906] [128/133] (513s left) kms_hdr (bpc-switch-suspend)
[512.633671] Starting subtest: bpc-switch-suspend
[513.700266] Starting dynamic subtest: pipe-A-eDP-1
[533.137211] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.624s)
[533.139556] Subtest bpc-switch-suspend: SUCCESS (5.691s)
[533.261536] [129/133] (492s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[533.317846] Starting subtest: x-tiled-to-vebox-yf-tiled
[533.322249] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[533.501144] [130/133] (492s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[533.605688] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[533.607866] Starting dynamic subtest: pipe-A
[533.734884] Dynamic subtest pipe-A: SKIP (0.124s)
[533.745750] Starting dynamic subtest: pipe-B
[534.949732] Dynamic subtest pipe-B: SKIP (1.216s)
[534.961606] Starting dynamic subtest: pipe-C
[536.118496] Dynamic subtest pipe-C: SUCCESS (1.174s)
[536.128427] Starting dynamic subtest: pipe-D
[537.322743] Dynamic subtest pipe-D: SUCCESS (1.205s)
[537.325055] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.724s)
[538.486356] [131/133] (487s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[540.709813] Starting subtest: dpms-mode-unset-non-lpsp
[541.868156] Subtest dpms-mode-unset-non-lpsp: SKIP (1.161s)
[542.268054] [132/133] (483s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[542.366872] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[542.371197] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[542.436472] [133/133] (483s left) gem_exec_schedule (u-fairslice)
[542.516075] Starting subtest: u-fairslice
[542.517915] Starting dynamic subtest: rcs0
[544.526137] Dynamic subtest rcs0: SUCCESS (2.019s)
[544.537712] Starting dynamic subtest: bcs0
[546.545511] Dynamic subtest bcs0: SUCCESS (2.019s)
[546.557757] Starting dynamic subtest: vcs0
[548.564769] Dynamic subtest vcs0: SUCCESS (2.020s)
[548.576533] Starting dynamic subtest: vcs1
[550.584048] Dynamic subtest vcs1: SUCCESS (2.020s)
[550.594570] Starting dynamic subtest: vecs0
[552.602774] Dynamic subtest vecs0: SUCCESS (2.020s)
[552.612733] Starting dynamic subtest: ccs0
[554.624344] Dynamic subtest ccs0: SUCCESS (2.020s)
[554.626211] Subtest u-fairslice: SUCCESS (12.123s)
[554.920617] 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.