[63.062588] Initializing watchdogs
[63.062633]   /dev/watchdog0
[63.075802] [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]
[63.080029] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[63.082208] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.085391] [001/133] (960s left) syncobj_wait (wait-for-submit-snapshot)
[63.168927] Starting subtest: wait-for-submit-snapshot
[63.250742] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[63.319975] [002/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[63.424776] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[63.428655] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[63.522792] [003/133] (960s left) gem_fenced_exec_thrash (too-many-fences)
[63.593302] Subtest too-many-fences: SKIP (0.000s)
[63.662864] [004/133] (960s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[63.719625] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[63.721888] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[63.835590] [005/133] (959s left) gem_exec_balancer (hang)
[64.109764] Starting subtest: hang
[65.943649] Subtest hang: SUCCESS (1.835s)
[66.073965] [006/133] (957s left) gem_workarounds (basic-read-fd)
[66.144021] Starting subtest: basic-read-fd
[66.162170] Subtest basic-read-fd: SUCCESS (0.018s)
[66.287014] [007/133] (957s left) gem_workarounds (suspend-resume-fd)
[66.353909] Starting subtest: suspend-resume-fd
[82.679864] Subtest suspend-resume-fd: SUCCESS (2.285s)
[82.806237] [008/133] (941s left) kms_atomic_transition (modeset-transition-fencing)
[82.914831] Starting subtest: modeset-transition-fencing
[82.917091] Starting dynamic subtest: 1x-outputs
[93.995897] Dynamic subtest 1x-outputs: SUCCESS (11.077s)
[93.998501] Subtest modeset-transition-fencing: SUCCESS (11.078s)
[94.861760] [009/133] (929s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[94.961244] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[95.919144] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.956s)
[96.094478] [010/133] (927s left) gem_lmem_swapping (basic)
[96.139617] Subtest basic: SKIP (0.000s)
[96.195091] [011/133] (927s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[96.304867] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[96.308474] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[96.406255] [012/133] (927s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[96.498443] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[96.502132] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[96.575256] [013/133] (927s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[96.663669] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[96.665710] Starting dynamic subtest: pipe-A-eDP-1
[98.833094] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.171s)
[98.841211] Starting dynamic subtest: pipe-B-eDP-1
[101.087955] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.252s)
[101.096988] Starting dynamic subtest: pipe-C-eDP-1
[103.186596] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.099s)
[103.195404] Starting dynamic subtest: pipe-D-eDP-1
[105.254617] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.065s)
[105.257052] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.591s)
[106.480753] [014/133] (917s left) kms_hdmi_inject (inject-4k)
[106.832811] Starting subtest: inject-4k
[107.152905] Subtest inject-4k: SUCCESS (0.323s)
[107.651783] [015/133] (916s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[107.738688] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[107.742745] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[107.844274] [016/133] (916s left) kms_properties (get_properties-sanity-non-atomic)
[107.948423] Starting subtest: get_properties-sanity-non-atomic
[107.950703] Subtest get_properties-sanity-non-atomic: SUCCESS (0.001s)
[108.019096] [017/133] (916s left) gem_userptr_blits (nohangcheck)
[108.089373] Starting subtest: nohangcheck
[108.310183] Subtest nohangcheck: SUCCESS (0.222s)
[108.421777] [018/133] (915s left) perf_pmu (busy-start)
[108.462024] Starting subtest: busy-start
[108.464012] Starting dynamic subtest: rcs0
[111.010246] Dynamic subtest rcs0: SUCCESS (2.550s)
[111.020292] Starting dynamic subtest: bcs0
[113.560592] Dynamic subtest bcs0: SUCCESS (2.548s)
[113.571391] Starting dynamic subtest: vcs0
[116.145287] Dynamic subtest vcs0: FAIL (2.537s)
[116.154903] Starting dynamic subtest: vcs1
[118.676227] Dynamic subtest vcs1: FAIL (2.516s)
[118.685835] Starting dynamic subtest: vecs0
[121.966027] Dynamic subtest vecs0: SUCCESS (3.348s)
[121.975355] Starting dynamic subtest: ccs0
[124.516111] Dynamic subtest ccs0: SUCCESS (2.549s)
[124.518774] Subtest busy-start: FAIL (16.055s)
[124.615685] [019/133] (899s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[124.673584] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[124.778368] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[124.849871] [020/133] (899s left) kms_vblank (query-forked-busy)
[124.949504] Starting subtest: query-forked-busy
[124.951744] Starting dynamic subtest: pipe-A-eDP-1
[126.824518] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[126.840522] Starting dynamic subtest: pipe-D-eDP-1
[129.364220] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.537s)
[129.366567] Subtest query-forked-busy: SUCCESS (4.414s)
[130.217719] [021/133] (894s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[130.328369] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[137.332441] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.006s)
[137.463483] [022/133] (886s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[137.575866] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[137.580528] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[138.715918] [023/133] (885s left) i915_pm_rps (reset)
[138.778528] Starting subtest: reset
[147.210894] Subtest reset: SUCCESS (8.434s)
[147.324003] [024/133] (877s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[147.443869] Starting subtest: cursorB-vs-flipB-atomic
[147.448162] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[147.590057] [025/133] (876s left) gem_create (create-ext-placement-sanity-check)
[147.767278] Starting subtest: create-ext-placement-sanity-check
[147.769573] Subtest create-ext-placement-sanity-check: SUCCESS (0.002s)
[147.843343] [026/133] (876s left) gem_eio (in-flight-contexts-immediate)
[148.060990] Starting subtest: in-flight-contexts-immediate
[161.984878] Subtest in-flight-contexts-immediate: SUCCESS (13.922s)
[162.131576] [027/133] (862s left) sysfs_preempt_timeout (invalid)
[162.180922] Starting subtest: invalid
[162.183382] Starting dynamic subtest: vecs0
[162.185760] Dynamic subtest vecs0: SUCCESS (0.000s)
[162.196208] Starting dynamic subtest: ccs0
[162.198484] Dynamic subtest ccs0: SUCCESS (0.000s)
[162.206535] Starting dynamic subtest: vcs0
[162.208886] Dynamic subtest vcs0: SUCCESS (0.000s)
[162.217201] Starting dynamic subtest: bcs0
[162.219376] Dynamic subtest bcs0: SUCCESS (0.000s)
[162.227703] Starting dynamic subtest: rcs0
[162.229896] Dynamic subtest rcs0: SUCCESS (0.000s)
[162.238421] Starting dynamic subtest: vcs1
[162.240666] Dynamic subtest vcs1: SUCCESS (0.000s)
[162.242833] Subtest invalid: SUCCESS (0.004s)
[162.279404] [028/133] (862s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[162.377037] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[162.379387] Starting dynamic subtest: A-eDP1
[166.046046] Dynamic subtest A-eDP1: SUCCESS (3.665s)
[166.057550] Starting dynamic subtest: B-eDP1
[169.347821] Dynamic subtest B-eDP1: SUCCESS (3.303s)
[169.358507] Starting dynamic subtest: C-eDP1
[172.572130] Dynamic subtest C-eDP1: SUCCESS (3.224s)
[172.582600] Starting dynamic subtest: D-eDP1
[175.837738] Dynamic subtest D-eDP1: SUCCESS (3.263s)
[175.840036] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.462s)
[176.709997] [029/133] (847s left) syncobj_wait (wait-all-for-submit-snapshot)
[176.784014] Starting subtest: wait-all-for-submit-snapshot
[176.864721] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[176.955893] [030/133] (847s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[177.057957] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[177.062373] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[177.161788] [031/133] (847s left) kms_flip (bo-too-big)
[177.262681] Starting subtest: bo-too-big
[177.264723] Starting dynamic subtest: A-eDP1
[178.524188] Dynamic subtest A-eDP1: SUCCESS (1.264s)
[178.538894] Starting dynamic subtest: B-eDP1
[179.834098] Dynamic subtest B-eDP1: SUCCESS (1.307s)
[179.846232] Starting dynamic subtest: C-eDP1
[181.143149] Dynamic subtest C-eDP1: SUCCESS (1.308s)
[181.159104] Starting dynamic subtest: D-eDP1
[182.431718] Dynamic subtest D-eDP1: SUCCESS (1.287s)
[182.434059] Subtest bo-too-big: SUCCESS (5.176s)
[183.616333] [032/133] (841s left) gem_exec_flush (basic-batch-kernel-default-wb)
[183.676389] Starting subtest: basic-batch-kernel-default-wb
[191.015532] Subtest basic-batch-kernel-default-wb: SUCCESS (7.339s)
[191.205126] [033/133] (833s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[191.587456] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[192.391017] [034/133] (832s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[192.479337] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[192.481525] Starting dynamic subtest: pipe-A-eDP-1
[192.539971] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[192.550613] Starting dynamic subtest: pipe-B-eDP-1
[192.607535] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[192.618900] Starting dynamic subtest: pipe-C-eDP-1
[192.675625] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[192.689806] Starting dynamic subtest: pipe-D-eDP-1
[192.755326] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[192.759436] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.008s)
[194.714991] [035/133] (830s left) fbdev (unaligned-write)
[194.770390] Starting subtest: unaligned-write
[194.882247] Subtest unaligned-write: SUCCESS (0.110s)
[194.939746] [036/133] (829s left) gem_ctx_param (invalid-set-no-zeromap)
[194.998602] Starting subtest: invalid-set-no-zeromap
[195.000819] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[195.069967] [037/133] (829s left) gem_exec_schedule (pi-ringfull)
[195.252084] Starting subtest: pi-ringfull
[195.254282] Starting dynamic subtest: rcs0
[195.340093] Dynamic subtest rcs0: SUCCESS (0.092s)
[195.353587] Starting dynamic subtest: bcs0
[195.367373] Dynamic subtest bcs0: SUCCESS (0.027s)
[195.382364] Starting dynamic subtest: vcs0
[195.394505] Dynamic subtest vcs0: SUCCESS (0.027s)
[195.406708] Starting dynamic subtest: vcs1
[195.422116] Dynamic subtest vcs1: SUCCESS (0.027s)
[195.434959] Starting dynamic subtest: vecs0
[195.448316] Dynamic subtest vecs0: SUCCESS (0.026s)
[195.457044] Starting dynamic subtest: ccs0
[195.478554] Dynamic subtest ccs0: SUCCESS (0.029s)
[195.480757] Subtest pi-ringfull: SUCCESS (0.231s)
[195.711483] [FACT gem_exec_schedule (pi-ringfull)] new: kernel.kmod_is_loaded.vgem: true
[195.714843] [038/133] (829s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[195.812206] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[196.790498] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (0.978s)
[196.937183] [039/133] (828s left) i915_drm_fdinfo (virtual-busy-idle)
[196.987390] Starting subtest: virtual-busy-idle
[196.991581] Subtest virtual-busy-idle: SKIP (0.000s)
[197.065409] [040/133] (828s left) kms_prop_blob (basic)
[197.113872] Starting subtest: basic
[197.115443] Subtest basic: SUCCESS (0.000s)
[197.202264] [041/133] (827s left) kms_psr (psr-dpms)
[197.292728] Starting subtest: psr-dpms
[197.294614] Starting dynamic subtest: eDP-1
[200.274202] Dynamic subtest eDP-1: SUCCESS (2.982s)
[200.276666] Subtest psr-dpms: SUCCESS (2.983s)
[201.116568] [042/133] (824s left) i915_suspend (sysfs-reader)
[201.174948] Starting subtest: sysfs-reader
[219.609747] Subtest sysfs-reader: SUCCESS (3.115s)
[219.674296] [043/133] (805s left) kms_draw_crc (draw-method-mmap-cpu)
[219.784754] Starting subtest: draw-method-mmap-cpu
[219.786351] Starting dynamic subtest: xrgb8888-untiled
[220.027219] Dynamic subtest xrgb8888-untiled: SUCCESS (0.243s)
[220.035900] Starting dynamic subtest: rgb565-untiled
[220.249087] Dynamic subtest rgb565-untiled: SUCCESS (0.221s)
[220.258506] Starting dynamic subtest: xrgb2101010-untiled
[220.449608] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.200s)
[220.458382] Starting dynamic subtest: xbgr16161616f-untiled
[220.682708] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.232s)
[220.691930] Starting dynamic subtest: xrgb8888-xtiled
[220.805231] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[220.814115] Starting dynamic subtest: rgb565-xtiled
[220.927045] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[220.936444] Starting dynamic subtest: xrgb2101010-xtiled
[221.038723] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[221.047284] Starting dynamic subtest: xbgr16161616f-xtiled
[221.171872] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[221.183391] Starting dynamic subtest: xrgb8888-4tiled
[221.316348] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[221.327489] Starting dynamic subtest: rgb565-4tiled
[221.460637] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[221.469778] Starting dynamic subtest: xrgb2101010-4tiled
[221.582960] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.122s)
[221.592146] Starting dynamic subtest: xbgr16161616f-4tiled
[221.727444] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s)
[221.729338] Subtest draw-method-mmap-cpu: SUCCESS (1.944s)
[221.845066] [044/133] (803s left) kms_rotation_crc (primary-rotation-180)
[221.938582] Starting subtest: primary-rotation-180
[228.885317] Subtest primary-rotation-180: SUCCESS (6.945s)
[230.098509] [045/133] (795s left) syncobj_wait (multi-wait-all-submitted-signaled)
[230.170164] Starting subtest: multi-wait-all-submitted-signaled
[230.275810] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.104s)
[230.352445] [046/133] (795s left) kms_getfb (getfb-handle-zero)
[230.442610] Starting subtest: getfb-handle-zero
[230.444906] Subtest getfb-handle-zero: SUCCESS (0.000s)
[230.543540] [047/133] (794s left) gem_mmap_gtt (flink-race)
[230.591909] Subtest flink-race: SKIP (0.000s)
[230.646163] [048/133] (794s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[230.737916] Starting subtest: stress-xrgb8888-xtiled
[236.678188] Subtest stress-xrgb8888-xtiled: SUCCESS (5.940s)
[236.734873] [049/133] (788s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[236.839578] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[236.850241] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.010s)
[236.926123] [050/133] (788s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[237.018303] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[237.020616] Starting dynamic subtest: pipe-A-eDP-1
[237.029392] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[237.038231] Starting dynamic subtest: pipe-B-eDP-1
[237.047172] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[237.058938] Starting dynamic subtest: pipe-C-eDP-1
[237.067927] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[237.076631] Starting dynamic subtest: pipe-D-eDP-1
[237.085232] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[237.089577] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[239.295489] [051/133] (786s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[239.362002] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[239.467509] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[239.547779] [052/133] (786s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[239.633794] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[239.638087] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[239.734092] [053/133] (785s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[239.974099] Starting subtest: cursor-rapid-movement-256x256
[239.979997] Starting dynamic subtest: pipe-A-eDP-1
[240.534495] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.555s)
[240.562588] Starting dynamic subtest: pipe-D-eDP-1
[241.806772] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.250s)
[241.809052] Subtest cursor-rapid-movement-256x256: SUCCESS (1.831s)
[242.610385] [054/133] (783s left) kms_tiled_display (basic-test-pattern)
[242.727994] Subtest basic-test-pattern: SKIP (0.000s)
[242.775474] [055/133] (782s left) gem_pxp (fail-invalid-protected-context)
[242.894594] Starting subtest: fail-invalid-protected-context
[242.897285] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[243.011068] [056/133] (782s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[243.097632] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[243.099941] Starting dynamic subtest: pipe-A-eDP-1
[243.121714] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[243.131798] Starting dynamic subtest: pipe-B-eDP-1
[243.152202] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[243.161055] Starting dynamic subtest: pipe-C-eDP-1
[243.181771] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[243.192721] Starting dynamic subtest: pipe-D-eDP-1
[243.214166] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[243.218570] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[245.299017] [057/133] (780s left) gem_ctx_shared (create-shared-gtt)
[245.371522] Starting subtest: create-shared-gtt
[247.523658] Subtest create-shared-gtt: SUCCESS (2.151s)
[248.321231] [058/133] (777s left) gem_caching (reads)
[248.385782] Subtest reads: SKIP (0.000s)
[248.453210] [059/133] (777s left) prime_vgem (fence-wait)
[248.527229] Starting subtest: fence-wait
[248.529606] Starting dynamic subtest: rcs0
[249.581444] Dynamic subtest rcs0: SUCCESS (1.052s)
[249.590728] Starting dynamic subtest: bcs0
[250.668134] Dynamic subtest bcs0: SUCCESS (1.086s)
[250.679325] Starting dynamic subtest: vcs0
[251.714891] Dynamic subtest vcs0: SUCCESS (1.045s)
[251.726455] Starting dynamic subtest: vcs1
[253.243632] Dynamic subtest vcs1: SUCCESS (1.527s)
[253.254391] Starting dynamic subtest: vecs0
[254.285025] Dynamic subtest vecs0: SUCCESS (1.039s)
[254.297389] Starting dynamic subtest: ccs0
[255.331891] Dynamic subtest ccs0: SUCCESS (1.044s)
[255.334717] Subtest fence-wait: SUCCESS (6.805s)
[255.451649] [060/133] (770s left) kms_psr (psr-cursor-plane-move)
[255.550334] Starting subtest: psr-cursor-plane-move
[255.552444] Starting dynamic subtest: eDP-1
[257.260985] Dynamic subtest eDP-1: SUCCESS (1.710s)
[257.263264] Subtest psr-cursor-plane-move: SUCCESS (1.711s)
[258.096221] [061/133] (767s left) kms_vrr (max-min)
[258.193844] Starting subtest: max-min
[258.200146] Subtest max-min: SKIP (0.000s)
[258.267217] [062/133] (767s left) prime_mmap_kms (buffer-sharing)
[258.356720] Starting subtest: buffer-sharing
[258.820361] Subtest buffer-sharing: SUCCESS (0.462s)
[259.707575] [063/133] (766s left) kms_content_protection (lic-type-0-hdcp14)
[259.855294] Starting subtest: lic-type-0-hdcp14
[259.859856] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[259.974238] [064/133] (766s left) api_intel_allocator (reopen-fork)
[260.035134] Starting subtest: reopen-fork
[263.484224] Subtest reopen-fork: SUCCESS (3.450s)
[263.566168] [065/133] (762s left) gen9_exec_parse (bb-large)
[263.624374] Subtest bb-large: SKIP (0.000s)
[263.688674] [066/133] (762s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[264.061187] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[264.876886] [067/133] (761s left) kms_invalid_mode (int-max-clock)
[264.985148] Starting subtest: int-max-clock
[264.987343] Starting dynamic subtest: pipe-A-eDP-1
[265.269270] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[265.279344] Starting dynamic subtest: pipe-B-eDP-1
[265.281492] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[265.290689] Starting dynamic subtest: pipe-C-eDP-1
[265.292934] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[265.305048] Starting dynamic subtest: pipe-D-eDP-1
[265.307474] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[265.309832] Subtest int-max-clock: SUCCESS (0.291s)
[266.096912] [068/133] (760s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[266.220089] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[267.195180] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.974s)
[268.006980] [069/133] (758s left) gem_userptr_blits (process-exit)
[268.075605] Starting subtest: process-exit
[268.082444] Subtest process-exit: SUCCESS (0.009s)
[268.202929] [070/133] (758s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[268.300588] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[268.327150] Starting dynamic subtest: pipe-A-plane-0
[268.615072] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[268.625062] Starting dynamic subtest: pipe-A-plane-3
[268.848366] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[269.961408] Starting dynamic subtest: pipe-B-plane-0
[270.265348] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[270.280469] Starting dynamic subtest: pipe-B-plane-3
[270.498286] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[270.812089] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.512s)
[271.614333] [071/133] (754s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[271.707689] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[271.718737] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.010s)
[271.839274] [072/133] (754s left) gem_exec_flush (basic-uc-pro-default)
[271.893072] Starting subtest: basic-uc-pro-default
[277.366745] Subtest basic-uc-pro-default: SUCCESS (5.474s)
[277.559659] [073/133] (748s left) kms_psr (pr-sprite-mmap-gtt)
[277.655297] Starting subtest: pr-sprite-mmap-gtt
[277.659290] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[277.725509] [074/133] (748s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[277.825221] Starting subtest: 4-tiled-16bpp-rotate-90
[277.845821] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.020s)
[277.948430] [075/133] (748s left) gem_softpin (evict-single-offset)
[278.007803] Starting subtest: evict-single-offset
[306.249037] Subtest evict-single-offset: SUCCESS (28.238s)
[306.338136] [076/133] (720s left) gem_userptr_blits (sync-overlap)
[306.439370] Starting subtest: sync-overlap
[306.441805] Subtest sync-overlap: SUCCESS (0.000s)
[306.568315] [077/133] (720s left) gem_exec_capture (capture-recoverable)
[306.637923] Starting subtest: capture-recoverable
[306.640639] Subtest capture-recoverable: SUCCESS (0.006s)
[306.751260] [078/133] (719s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[306.856939] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[314.082860] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.229s)
[314.222879] [079/133] (712s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[314.285413] Starting subtest: yf-tiled-to-vebox-yf-tiled
[314.289863] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[314.471438] [080/133] (712s left) device_reset (cold-reset-bound)
[314.521197] Starting subtest: cold-reset-bound
[314.525354] Subtest cold-reset-bound: SKIP (0.000s)
[314.592834] [081/133] (712s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[314.705628] Starting subtest: 2x-flip-vs-cursor-atomic
[314.709844] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.002s)
[314.849578] [082/133] (712s left) gem_exec_schedule (fairslice-all)
[314.932973] Starting subtest: fairslice-all
[316.988518] Subtest fairslice-all: SUCCESS (2.062s)
[317.301084] [083/133] (709s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[317.404599] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[317.408678] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[317.521325] [084/133] (709s left) kms_lease (lease-invalid-plane)
[317.612553] Starting subtest: lease-invalid-plane
[317.614786] Starting dynamic subtest: pipe-A-eDP-1
[317.617033] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[317.626463] Starting dynamic subtest: pipe-B-eDP-1
[317.628762] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[317.637969] Starting dynamic subtest: pipe-C-eDP-1
[317.640120] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[317.648920] Starting dynamic subtest: pipe-D-eDP-1
[317.650721] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[317.652587] Subtest lease-invalid-plane: SUCCESS (0.004s)
[317.690154] [085/133] (709s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[317.776511] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[317.780668] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[317.885939] [086/133] (709s left) kms_cursor_crc (cursor-offscreen-64x21)
[318.066648] Starting subtest: cursor-offscreen-64x21
[318.113904] Subtest cursor-offscreen-64x21: SKIP (0.042s)
[318.331458] [087/133] (708s left) gem_exec_store (basic)
[318.385468] Starting subtest: basic
[318.483048] Subtest basic: SUCCESS (0.099s)
[318.671178] [088/133] (708s left) gem_ppgtt (blt-vs-render-ctxn)
[318.730769] Starting subtest: blt-vs-render-ctxN
[351.401888] Subtest blt-vs-render-ctxN: SUCCESS (32.666s)
[351.524672] [089/133] (675s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[351.650970] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[351.655065] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[351.735220] [090/133] (675s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[351.807143] Starting subtest: multi-wait-for-submit-available-signaled
[351.808992] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.001s)
[351.899889] [091/133] (675s left) kms_addfb_basic (master-rmfb)
[351.968571] Starting subtest: master-rmfb
[351.970479] Subtest master-rmfb: SUCCESS (0.002s)
[352.091155] [092/133] (675s left) kms_flip (plain-flip-fb-recreate)
[352.193752] Starting subtest: plain-flip-fb-recreate
[352.196068] Starting dynamic subtest: A-eDP1
[361.049038] Dynamic subtest A-eDP1: SUCCESS (8.855s)
[361.059640] Starting dynamic subtest: B-eDP1
[369.946998] Dynamic subtest B-eDP1: SUCCESS (8.896s)
[369.959517] Starting dynamic subtest: C-eDP1
[378.745067] Dynamic subtest C-eDP1: SUCCESS (8.795s)
[378.759512] Starting dynamic subtest: D-eDP1
[387.642139] Dynamic subtest D-eDP1: SUCCESS (8.895s)
[387.646614] Subtest plain-flip-fb-recreate: SUCCESS (35.453s)
[388.886886] [093/133] (638s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[388.943678] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[389.051310] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.108s)
[389.127687] [094/133] (638s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[389.224563] Starting subtest: yf-tiled-64bpp-rotate-270
[389.228959] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[389.331572] [095/133] (638s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[389.422203] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[389.424493] Starting dynamic subtest: pipe-A-eDP-1
[389.509265] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[389.523501] Starting dynamic subtest: pipe-B-eDP-1
[390.639195] Dynamic subtest pipe-B-eDP-1: SKIP (1.127s)
[390.643511] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.219s)
[391.889514] [096/133] (635s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[391.982747] Starting subtest: psr-rgb565-draw-pwrite
[398.943764] Subtest psr-rgb565-draw-pwrite: SUCCESS (6.963s)
[399.045082] [097/133] (628s left) kms_busy (extended-modeset-hang-oldfb)
[399.146393] Starting subtest: extended-modeset-hang-oldfb
[399.148989] Starting dynamic subtest: pipe-A
[410.718640] Dynamic subtest pipe-A: SUCCESS (11.569s)
[410.729164] Starting dynamic subtest: pipe-D
[423.032425] Dynamic subtest pipe-D: SUCCESS (12.311s)
[423.034793] Subtest extended-modeset-hang-oldfb: SUCCESS (23.884s)
[423.885702] [098/133] (603s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[423.937802] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[423.940151] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[424.033714] [099/133] (603s left) gem_exec_fence (invalid-timeline-fence-array)
[424.615973] Starting subtest: invalid-timeline-fence-array
[424.622259] Subtest invalid-timeline-fence-array: SUCCESS (0.005s)
[426.320170] [100/133] (601s left) syncobj_eventfd (invalid-bad-pad)
[426.382781] Starting subtest: invalid-bad-pad
[426.385074] Subtest invalid-bad-pad: SUCCESS (0.000s)
[426.503165] [101/133] (601s left) api_intel_bb (render)
[426.562184] Starting subtest: render
[426.564501] Starting dynamic subtest: render-none-512
[426.666707] Dynamic subtest render-none-512: SUCCESS (0.106s)
[426.679449] Starting dynamic subtest: render-none-1024
[427.045112] Dynamic subtest render-none-1024: SUCCESS (0.376s)
[427.059822] Starting dynamic subtest: render-x-512
[427.129900] Dynamic subtest render-x-512: SUCCESS (0.085s)
[427.142464] Starting dynamic subtest: render-x-1024
[427.465842] Dynamic subtest render-x-1024: SUCCESS (0.334s)
[427.476894] Starting dynamic subtest: render-y-512
[427.555582] Dynamic subtest render-y-512: SUCCESS (0.090s)
[427.565224] Starting dynamic subtest: render-y-1024
[428.136055] Dynamic subtest render-y-1024: SUCCESS (0.578s)
[428.138636] Subtest render: SUCCESS (1.575s)
[428.250518] [102/133] (599s left) gem_softpin (evict-active-interruptible)
[428.317715] Starting subtest: evict-active-interruptible
[428.327353] Subtest evict-active-interruptible: SUCCESS (0.010s)
[428.455605] [103/133] (599s left) kms_big_fb (linear-16bpp-rotate-0)
[428.581612] Starting subtest: linear-16bpp-rotate-0
[429.872688] Subtest linear-16bpp-rotate-0: SUCCESS (1.292s)
[430.006966] [104/133] (597s left) kms_psr (fbc-psr-cursor-blt)
[430.100137] Starting subtest: fbc-psr-cursor-blt
[430.102179] Starting dynamic subtest: eDP-1
[430.105635] Dynamic subtest eDP-1: SKIP (0.000s)
[430.109098] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[430.171601] [105/133] (597s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[430.273152] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[430.276672] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[430.373403] [106/133] (597s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[430.442201] Starting subtest: invalid-bsd1-flag-on-vebox
[430.444082] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[430.563776] [107/133] (597s left) kms_plane_multiple (tiling-y)
[430.667120] Starting subtest: tiling-y
[430.670830] Subtest tiling-y: SKIP (0.000s)
[430.742015] [108/133] (597s left) prime_mmap (test_map_unmap)
[430.799470] Starting subtest: test_map_unmap
[430.801405] Starting dynamic subtest: test_map_unmap-smem
[430.832487] Dynamic subtest test_map_unmap-smem: SUCCESS (0.035s)
[430.834562] Subtest test_map_unmap: SUCCESS (0.036s)
[430.927875] [109/133] (597s left) gem_ctx_param (non-root-set)
[430.983188] Starting subtest: non-root-set
[431.012413] Subtest non-root-set: SUCCESS (0.031s)
[431.119505] [110/133] (596s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[431.213896] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[431.215889] Starting dynamic subtest: pipe-A-eDP-1
[436.942513] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.730s)
[436.955894] Starting dynamic subtest: pipe-B-eDP-1
[443.439346] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.497s)
[443.441755] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.229s)
[444.300898] [111/133] (583s left) gem_mmap_gtt (cpuset-medium-copy)
[444.369157] Subtest cpuset-medium-copy: SKIP (0.000s)
[444.430293] [112/133] (583s left) prime_self_import (reimport-vs-gem_close-race)
[444.461697] Starting subtest: reimport-vs-gem_close-race
[449.565957] Subtest reimport-vs-gem_close-race: SUCCESS (5.103s)
[449.657471] [113/133] (578s left) gem_ctx_sseu (mmap-args)
[449.722119] Subtest mmap-args: SKIP (0.000s)
[449.798702] [114/133] (578s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[449.902868] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[453.387575] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.489s)
[454.590923] [115/133] (573s left) kms_color (legacy-gamma)
[454.687694] Starting subtest: legacy-gamma
[454.689633] Starting dynamic subtest: pipe-A-eDP-1
[455.410625] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.723s)
[455.420799] Starting dynamic subtest: pipe-B-eDP-1
[456.893368] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.480s)
[456.904092] Starting dynamic subtest: pipe-C-eDP-1
[458.205570] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.314s)
[458.216297] Starting dynamic subtest: pipe-D-eDP-1
[459.615139] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.408s)
[459.617790] Subtest legacy-gamma: SUCCESS (4.929s)
[460.483793] [116/133] (567s left) syncobj_timeline (single-wait-available-signaled)
[460.536167] Starting subtest: single-wait-available-signaled
[460.538392] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[460.633327] [117/133] (567s left) kms_cursor_edge_walk (64x64-right-edge)
[460.719624] Starting subtest: 64x64-right-edge
[460.721863] Starting dynamic subtest: pipe-A-eDP-1
[464.226848] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.506s)
[464.237946] Starting dynamic subtest: pipe-D-eDP-1
[467.403240] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.177s)
[467.405630] Subtest 64x64-right-edge: SUCCESS (6.685s)
[468.292539] [118/133] (560s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[468.376342] Starting subtest: fbc-pr-sprite-mmap-cpu
[468.380754] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[468.449833] [119/133] (559s left) kms_cursor_legacy (forked-bo)
[468.565807] Starting subtest: forked-bo
[468.567603] Starting dynamic subtest: pipe-A
[474.021612] Dynamic subtest pipe-A: SUCCESS (5.453s)
[474.037917] Starting dynamic subtest: pipe-B
[479.492451] Dynamic subtest pipe-B: SUCCESS (5.468s)
[479.506518] Starting dynamic subtest: pipe-C
[484.962055] Dynamic subtest pipe-C: SUCCESS (5.467s)
[484.981307] Starting dynamic subtest: pipe-D
[490.432163] Dynamic subtest pipe-D: SUCCESS (5.468s)
[490.443444] Starting dynamic subtest: all-pipes
[495.933057] Dynamic subtest all-pipes: SUCCESS (5.497s)
[495.935480] Subtest forked-bo: SUCCESS (27.365s)
[496.077970] [120/133] (532s left) gen9_exec_parse (shadow-peek)
[496.138988] Subtest shadow-peek: SKIP (0.000s)
[496.209809] [121/133] (532s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[496.302554] Starting subtest: plane-upscale-factor-0-25-with-rotation
[496.305332] Starting dynamic subtest: pipe-A
[496.527020] Dynamic subtest pipe-A: SUCCESS (0.227s)
[496.541066] Starting dynamic subtest: pipe-B
[497.819749] Dynamic subtest pipe-B: SUCCESS (1.292s)
[497.829329] Starting dynamic subtest: pipe-C
[499.127098] Dynamic subtest pipe-C: SUCCESS (1.307s)
[499.136743] Starting dynamic subtest: pipe-D
[500.421937] Dynamic subtest pipe-D: SUCCESS (1.294s)
[500.424335] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.123s)
[501.583409] [122/133] (526s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[501.678234] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[501.682707] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[501.759423] [123/133] (526s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[501.850677] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[501.854935] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[501.954349] [124/133] (526s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[502.056789] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[509.001758] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.947s)
[509.136677] [125/133] (519s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[509.230314] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[509.234758] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[509.304339] [126/133] (519s left) prime_mmap (test_aperture_limit)
[509.350898] Starting subtest: test_aperture_limit
[509.353136] Starting dynamic subtest: test_aperture_limit-smem
[509.359714] Dynamic subtest test_aperture_limit-smem: SKIP (0.007s)
[509.363751] Subtest test_aperture_limit: SKIP (0.008s)
[509.454064] [127/133] (519s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[509.549410] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[516.348677] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.802s)
[516.496654] [128/133] (512s left) kms_hdr (bpc-switch-suspend)
[516.591329] Starting subtest: bpc-switch-suspend
[517.625298] Starting dynamic subtest: pipe-A-eDP-1
[536.715854] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.534s)
[536.718199] Subtest bpc-switch-suspend: SUCCESS (5.567s)
[536.828910] [129/133] (492s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[536.891404] Starting subtest: x-tiled-to-vebox-yf-tiled
[536.896055] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[537.080532] [130/133] (491s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[537.176999] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[537.179318] Starting dynamic subtest: pipe-A
[537.298359] Dynamic subtest pipe-A: SKIP (0.119s)
[537.308755] Starting dynamic subtest: pipe-B
[538.496600] Dynamic subtest pipe-B: SKIP (1.195s)
[538.506998] Starting dynamic subtest: pipe-C
[539.708407] Dynamic subtest pipe-C: SUCCESS (1.214s)
[539.719644] Starting dynamic subtest: pipe-D
[540.917540] Dynamic subtest pipe-D: SUCCESS (1.206s)
[540.919759] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.738s)
[542.089161] [131/133] (486s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[544.033019] Starting subtest: dpms-mode-unset-non-lpsp
[545.189368] Subtest dpms-mode-unset-non-lpsp: SKIP (1.153s)
[545.560938] [132/133] (483s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[545.654660] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[545.659260] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[545.726333] [133/133] (483s left) gem_exec_schedule (u-fairslice)
[545.801644] Starting subtest: u-fairslice
[545.803572] Starting dynamic subtest: rcs0
[547.817041] Dynamic subtest rcs0: SUCCESS (2.019s)
[547.831191] Starting dynamic subtest: bcs0
[549.837063] Dynamic subtest bcs0: SUCCESS (2.018s)
[549.847379] Starting dynamic subtest: vcs0
[551.857043] Dynamic subtest vcs0: SUCCESS (2.017s)
[551.867912] Starting dynamic subtest: vcs1
[553.877357] Dynamic subtest vcs1: SUCCESS (2.016s)
[553.888197] Starting dynamic subtest: vecs0
[555.894139] Dynamic subtest vecs0: SUCCESS (2.018s)
[555.906795] Starting dynamic subtest: ccs0
[557.918831] Dynamic subtest ccs0: SUCCESS (2.022s)
[557.920884] Subtest u-fairslice: SUCCESS (12.116s)
[558.219063] 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.