[57.431214] Initializing watchdogs
[57.431262]   /dev/watchdog0
[57.445968] [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]
[57.450701] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.453089] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.456534] [001/132] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[57.594919] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[64.889943] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.262s)
[65.000013] [002/132] (952s left) syncobj_timeline (host-signal-points)
[65.064362] Starting subtest: host-signal-points
[65.068838] Subtest host-signal-points: SUCCESS (0.005s)
[65.180511] [003/132] (952s left) gem_softpin (full)
[65.239452] Starting subtest: full
[65.247552] Subtest full: SUCCESS (0.008s)
[65.376337] [004/132] (952s left) gem_exec_gttfill (multigpu-basic)
[65.536048] Starting subtest: multigpu-basic
[80.011353] Subtest multigpu-basic: SUCCESS (14.464s)
[80.107187] [005/132] (938s left) gem_ctx_persistence (heartbeat-many)
[80.204930] Starting subtest: heartbeat-many
[80.209754] Subtest heartbeat-many: SKIP (0.000s)
[80.323212] [006/132] (937s left) kms_flip (2x-wf_vblank-ts-check)
[80.425772] Starting subtest: 2x-wf_vblank-ts-check
[80.435282] Subtest 2x-wf_vblank-ts-check: SKIP (0.011s)
[80.509526] [007/132] (937s left) prime_mmap_coherency (read)
[80.576784] Starting subtest: read
[85.944931] Subtest read: SUCCESS (5.378s)
[86.053331] [008/132] (932s left) i915_power (sanity)
[86.105758] Starting subtest: sanity
[90.158371] Subtest sanity: SUCCESS (4.052s)
[90.977469] [009/132] (927s left) gem_blits (basic)
[91.055626] Starting subtest: basic
[93.311369] Subtest basic: SUCCESS (2.257s)
[93.436722] [010/132] (924s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[93.492904] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[93.495309] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[93.586676] [011/132] (924s left) core_auth (many-magics)
[93.639642] Starting subtest: many-magics
[94.555375] Subtest many-magics: SUCCESS (0.919s)
[94.727507] [012/132] (923s left) gem_ringfill (legacy-basic)
[100.895974] Starting subtest: legacy-basic
[100.898950] Starting dynamic subtest: default
[100.955198] Dynamic subtest default: SUCCESS (0.060s)
[100.963870] Starting dynamic subtest: render
[100.996931] Dynamic subtest render: SUCCESS (0.041s)
[101.006982] Starting dynamic subtest: bsd
[101.040529] Dynamic subtest bsd: SUCCESS (0.042s)
[101.049854] Starting dynamic subtest: bsd1
[101.082211] Dynamic subtest bsd1: SUCCESS (0.040s)
[101.093624] Starting dynamic subtest: bsd2
[101.128528] Dynamic subtest bsd2: SUCCESS (0.044s)
[101.147221] Starting dynamic subtest: blt
[101.180066] Dynamic subtest blt: SUCCESS (0.050s)
[101.198585] Starting dynamic subtest: vebox
[101.225020] Dynamic subtest vebox: SUCCESS (0.042s)
[101.227604] Subtest legacy-basic: SUCCESS (0.332s)
[101.301506] [FACT gem_ringfill (legacy-basic)] new: kernel.kmod_is_loaded.vgem: true
[101.304846] [013/132] (917s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[101.402814] Starting subtest: primary-yf-tiled-reflect-x-180
[101.462902] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s)
[101.568131] [014/132] (916s left) gem_mmap_gtt (cpuset-basic-small-copy)
[101.633094] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[101.697474] [015/132] (916s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[101.790064] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[101.794830] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[102.920170] [016/132] (915s left) gem_mmap_gtt (basic-short)
[102.988438] Subtest basic-short: SKIP (0.000s)
[103.052445] [017/132] (915s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[103.140239] Starting subtest: 2x-plain-flip-ts-check-interruptible
[103.152347] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.010s)
[103.273727] [018/132] (915s left) gem_mmap_gtt (basic-write)
[103.325595] Subtest basic-write: SKIP (0.000s)
[103.404851] [019/132] (915s left) gem_eio (in-flight-10ms)
[103.638327] Starting subtest: in-flight-10ms
[111.604141] Subtest in-flight-10ms: SUCCESS (7.971s)
[111.773211] [020/132] (906s left) api_intel_allocator (simple-allocator)
[111.832788] Starting subtest: simple-allocator
[111.835289] Starting dynamic subtest: basic
[111.837494] Dynamic subtest basic: SUCCESS (0.003s)
[111.849390] Starting dynamic subtest: parallel-one
[112.017307] Dynamic subtest parallel-one: SUCCESS (0.182s)
[112.026295] Starting dynamic subtest: print
[112.028525] Dynamic subtest print: SUCCESS (0.000s)
[112.037337] Starting dynamic subtest: reuse
[112.039263] Dynamic subtest reuse: SUCCESS (0.000s)
[112.047563] Starting dynamic subtest: reserve
[112.049542] Dynamic subtest reserve: SUCCESS (0.000s)
[112.057874] Starting dynamic subtest: fork-reopen-allocator
[112.059832] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[112.061818] Subtest simple-allocator: SUCCESS (0.199s)
[112.144422] [021/132] (906s left) gem_render_copy (linear-to-vebox-yf-tiled)
[112.197437] Starting subtest: linear-to-vebox-yf-tiled
[112.202191] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[112.376599] [022/132] (906s left) syncobj_eventfd (timeline-wait-signaled)
[112.426975] Starting subtest: timeline-wait-signaled
[112.429393] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[112.537677] [023/132] (906s left) kms_vblank (wait-busy)
[112.644368] Starting subtest: wait-busy
[112.646297] Starting dynamic subtest: pipe-A-eDP-1
[114.535463] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.892s)
[114.550815] Starting dynamic subtest: pipe-D-eDP-1
[117.087070] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.550s)
[117.089454] Subtest wait-busy: SUCCESS (4.445s)
[117.878540] [024/132] (901s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[117.976938] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[117.981182] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[118.080913] [025/132] (900s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[118.170429] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[118.172614] Starting dynamic subtest: pipe-A-default-mode
[119.344537] Dynamic subtest pipe-A-default-mode: SKIP (1.171s)
[119.349213] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.173s)
[119.490109] [026/132] (899s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[119.599887] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[124.174540] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.580s)
[125.324677] [027/132] (893s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[125.409265] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[125.413912] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[125.483304] [028/132] (893s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[125.572044] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[133.226035] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.660s)
[133.353975] [029/132] (885s left) kms_cursor_edge_walk (128x128-right-edge)
[133.444368] Starting subtest: 128x128-right-edge
[133.446723] Starting dynamic subtest: pipe-A-eDP-1
[136.920784] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.474s)
[136.933277] Starting dynamic subtest: pipe-D-eDP-1
[140.052598] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.133s)
[140.055102] Subtest 128x128-right-edge: SUCCESS (6.609s)
[140.860133] [030/132] (878s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[140.952370] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[140.954744] Starting dynamic subtest: pipe-A-eDP-1
[140.977968] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[140.988267] Starting dynamic subtest: pipe-B-eDP-1
[141.009953] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[141.019037] Starting dynamic subtest: pipe-C-eDP-1
[141.041014] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[141.050051] Starting dynamic subtest: pipe-D-eDP-1
[141.071833] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[141.075891] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[143.224843] [031/132] (875s left) kms_psr (pr-dpms)
[143.332955] Starting subtest: pr-dpms
[143.337495] Subtest pr-dpms: SKIP (0.000s)
[143.426421] [032/132] (875s left) kms_lease (lease-revoke)
[143.509359] Starting subtest: lease-revoke
[143.511736] Starting dynamic subtest: pipe-A-eDP-1
[143.541203] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.032s)
[143.552144] Starting dynamic subtest: pipe-B-eDP-1
[143.569291] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.029s)
[143.578948] Starting dynamic subtest: pipe-C-eDP-1
[143.597900] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.026s)
[143.607074] Starting dynamic subtest: pipe-D-eDP-1
[143.623758] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.027s)
[143.626157] Subtest lease-revoke: SUCCESS (0.118s)
[143.752322] [033/132] (875s left) gem_ctx_exec (basic)
[143.809766] Starting subtest: basic
[143.814341] Subtest basic: SUCCESS (0.005s)
[143.953096] [034/132] (875s left) gen9_exec_parse (basic-rejected-ctx-param)
[144.022218] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[144.110619] [035/132] (875s left) kms_big_fb (linear-16bpp-rotate-0)
[144.220690] Starting subtest: linear-16bpp-rotate-0
[145.699673] Subtest linear-16bpp-rotate-0: SUCCESS (1.479s)
[145.822815] [036/132] (873s left) gem_exec_params (secure-non-root)
[145.889167] Starting subtest: secure-non-root
[145.893071] Subtest secure-non-root: SKIP (0.000s)
[146.006727] [037/132] (873s left) kms_pm_rpm (basic-pci-d3-state)
[148.040114] Starting subtest: basic-pci-d3-state
[149.503304] Subtest basic-pci-d3-state: SUCCESS (1.463s)
[149.589322] [038/132] (869s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[149.688815] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[153.673366] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (3.990s)
[154.872845] [039/132] (864s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[154.986577] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[154.990959] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[155.084126] [040/132] (864s left) perf (gen12-mi-rpc)
[155.232674] Starting subtest: gen12-mi-rpc
[155.234878] Starting dynamic subtest: rcs0
[155.249789] Dynamic subtest rcs0: SUCCESS (0.017s)
[155.251709] Subtest gen12-mi-rpc: SUCCESS (0.017s)
[155.297034] [041/132] (864s left) gem_eio (create-ext)
[155.556834] Starting subtest: create-ext
[155.881314] Subtest create-ext: SUCCESS (0.324s)
[156.036975] [042/132] (863s left) kms_addfb_basic (master-rmfb)
[156.084552] Starting subtest: master-rmfb
[156.086841] Subtest master-rmfb: SUCCESS (0.001s)
[156.216305] [043/132] (863s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[156.339300] Starting subtest: flip-vs-cursor-legacy
[163.557067] Subtest flip-vs-cursor-legacy: SUCCESS (7.216s)
[164.396230] [044/132] (855s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[164.496185] Starting subtest: psr-rgb565-draw-mmap-wc
[171.358733] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.866s)
[171.485521] [045/132] (848s left) gem_close_race (multigpu-basic-process)
[171.553238] Starting subtest: multigpu-basic-process
[171.557736] Subtest multigpu-basic-process: SKIP (0.000s)
[171.782427] [046/132] (848s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[171.879053] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[172.867469] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.990s)
[172.982332] [047/132] (846s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[173.077466] Starting subtest: y-tiled-64bpp-rotate-180
[173.081889] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[173.177096] [048/132] (846s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[173.232849] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[173.234658] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[173.347940] [049/132] (846s left) gem_mmap_offset (pf-nonblock)
[173.394718] Starting subtest: pf-nonblock
[173.403842] Subtest pf-nonblock: SUCCESS (0.011s)
[173.519052] [050/132] (846s left) gem_exec_whisper (basic-queues-forked)
[173.576518] Starting subtest: basic-queues-forked
[197.976205] Subtest basic-queues-forked: SUCCESS (24.393s)
[198.159774] [051/132] (821s left) kms_flip (flip-vs-expired-vblank)
[198.257499] Starting subtest: flip-vs-expired-vblank
[198.259793] Starting dynamic subtest: A-eDP1
[206.914777] Dynamic subtest A-eDP1: SUCCESS (8.658s)
[206.924954] Starting dynamic subtest: B-eDP1
[215.556505] Dynamic subtest B-eDP1: SUCCESS (8.642s)
[215.570881] Starting dynamic subtest: C-eDP1
[224.269805] Dynamic subtest C-eDP1: SUCCESS (8.712s)
[224.279254] Starting dynamic subtest: D-eDP1
[232.904616] Dynamic subtest D-eDP1: SUCCESS (8.635s)
[232.909171] Subtest flip-vs-expired-vblank: SUCCESS (34.660s)
[234.069616] [052/132] (786s left) kms_addfb_basic (small-bo)
[234.173750] Starting subtest: small-bo
[234.175681] Subtest small-bo: SUCCESS (0.000s)
[234.301301] [053/132] (785s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[234.393107] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[234.395216] Starting dynamic subtest: pipe-A
[234.414534] Dynamic subtest pipe-A: SKIP (0.018s)
[234.424529] Starting dynamic subtest: pipe-B
[234.447630] Dynamic subtest pipe-B: SKIP (0.032s)
[234.457107] Starting dynamic subtest: pipe-C
[234.480255] Dynamic subtest pipe-C: SKIP (0.032s)
[234.489574] Starting dynamic subtest: pipe-D
[234.510479] Dynamic subtest pipe-D: SKIP (0.032s)
[234.514637] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.115s)
[234.626328] [054/132] (785s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[234.726647] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[234.730792] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[234.839316] [055/132] (785s left) kms_chamelium_frames (vga-frame-dump)
[235.211629] Subtest vga-frame-dump: SKIP (0.000s)
[235.991320] [056/132] (784s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[236.102859] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[236.107157] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[236.205488] [057/132] (784s left) prime_vgem (shrink)
[236.275248] Starting subtest: shrink
[236.297077] Subtest shrink: SUCCESS (0.019s)
[236.392391] [058/132] (783s left) kms_psr (psr-sprite-blt)
[236.482352] Starting subtest: psr-sprite-blt
[236.484601] Starting dynamic subtest: eDP-1
[238.238681] Dynamic subtest eDP-1: SUCCESS (1.758s)
[238.241076] Subtest psr-sprite-blt: SUCCESS (1.758s)
[239.107542] [059/132] (781s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[239.239228] Starting subtest: cursorB-vs-flipA-legacy
[239.243710] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[239.386863] [060/132] (781s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[239.478535] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[246.949441] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.472s)
[247.066371] [061/132] (773s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[247.181277] Starting subtest: 2x-long-flip-vs-cursor-atomic
[247.185646] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[247.332689] [062/132] (773s left) gem_exec_fence (submit3)
[247.516880] Starting subtest: submit3
[247.521225] Subtest submit3: SKIP (0.000s)
[248.911494] [063/132] (771s left) vgem_basic (dmabuf-fence)
[248.951756] Starting subtest: dmabuf-fence
[248.954184] Subtest dmabuf-fence: SUCCESS (0.001s)
[249.008928] [064/132] (771s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[249.104177] Starting subtest: fbc-pr-sprite-mmap-cpu
[249.108495] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[249.183551] [065/132] (771s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[249.277448] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[249.281725] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[249.350087] [066/132] (771s left) i915_drm_fdinfo (most-busy-idle-check-all)
[249.390668] Starting subtest: most-busy-idle-check-all
[249.392896] Starting dynamic subtest: rcs0
[249.397473] Dynamic subtest rcs0: SKIP (0.005s)
[249.411457] Starting dynamic subtest: bcs0
[249.415872] Dynamic subtest bcs0: SKIP (0.000s)
[249.426178] Starting dynamic subtest: vcs0
[249.430375] Dynamic subtest vcs0: SKIP (0.000s)
[249.439595] Starting dynamic subtest: vcs1
[249.443875] Dynamic subtest vcs1: SKIP (0.000s)
[249.455765] Starting dynamic subtest: vecs0
[249.460482] Dynamic subtest vecs0: SKIP (0.000s)
[249.469188] Starting dynamic subtest: ccs0
[249.474079] Dynamic subtest ccs0: SKIP (0.000s)
[249.478658] Subtest most-busy-idle-check-all: SKIP (0.010s)
[249.519571] [067/132] (771s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[249.624244] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[249.626582] Starting dynamic subtest: pipe-A-eDP-1
[249.648891] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[249.660681] Starting dynamic subtest: pipe-B-eDP-1
[249.682150] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[249.691257] Starting dynamic subtest: pipe-C-eDP-1
[249.713048] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[249.721960] Starting dynamic subtest: pipe-D-eDP-1
[249.743992] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[249.748174] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[251.852373] [068/132] (768s left) gem_vm_create (execbuf)
[251.921644] Starting subtest: execbuf
[251.929627] Subtest execbuf: SUCCESS (0.008s)
[252.058524] [069/132] (768s left) gem_mmap_gtt (big-copy-xy)
[252.114714] Subtest big-copy-XY: SKIP (0.000s)
[252.176100] [070/132] (768s left) gem_mmap_gtt (basic-small-bo-tiledy)
[252.231531] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[252.290662] [071/132] (768s left) gem_render_copy_redux (flink)
[252.362204] Starting subtest: flink
[253.198778] Subtest flink: SUCCESS (0.840s)
[253.318741] [072/132] (767s left) gem_pipe_control_store_loop (fresh-buffer)
[253.374185] Starting subtest: fresh-buffer
[255.529512] Subtest fresh-buffer: SUCCESS (2.153s)
[255.652567] [073/132] (765s left) gem_mmap_gtt (basic-small-bo-tiledx)
[255.718678] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[255.785348] [074/132] (765s left) gem_exec_params (rsvd2-dirt)
[255.853406] Starting subtest: rsvd2-dirt
[255.858093] Subtest rsvd2-dirt: SKIP (0.000s)
[255.960282] [075/132] (765s left) kms_atomic (plane-immutable-zpos)
[256.062810] Starting subtest: plane-immutable-zpos
[256.064680] Starting dynamic subtest: pipe-A-eDP-1
[256.695677] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.632s)
[256.698076] Subtest plane-immutable-zpos: SUCCESS (0.634s)
[257.503605] [076/132] (763s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[257.600464] Starting subtest: fbc-pr-cursor-plane-update-sf
[257.604480] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[257.675777] [077/132] (763s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[257.772909] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[257.775215] Starting dynamic subtest: pipe-A-eDP-1
[257.831897] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[257.842959] Starting dynamic subtest: pipe-B-eDP-1
[257.899588] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[257.912841] Starting dynamic subtest: pipe-C-eDP-1
[257.971504] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[257.981998] Starting dynamic subtest: pipe-D-eDP-1
[258.037565] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[258.042161] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[259.965713] [078/132] (761s left) kms_flip (2x-flip-vs-panning-vs-hang)
[260.068390] Starting subtest: 2x-flip-vs-panning-vs-hang
[260.080769] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.011s)
[260.170444] [079/132] (761s left) kms_atomic_interruptible (legacy-dpms)
[260.257053] Starting subtest: legacy-dpms
[260.259263] Starting dynamic subtest: pipe-A-eDP-1
[267.695978] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.437s)
[267.698146] Subtest legacy-dpms: SUCCESS (7.438s)
[268.517136] [080/132] (752s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[268.620418] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[268.624324] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[268.721939] [081/132] (752s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[268.821866] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[268.826212] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[268.932815] [082/132] (752s left) kms_psr (fbc-pr-cursor-plane-move)
[269.025046] Starting subtest: fbc-pr-cursor-plane-move
[269.029148] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[269.101699] [083/132] (752s left) core_getversion (basic)
[269.138106] Starting subtest: basic
[269.142322] Subtest basic: SUCCESS (0.000s)
[269.197609] [084/132] (752s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[269.301604] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[269.305693] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[269.399535] [085/132] (752s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[269.495622] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[270.542493] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.046s)
[270.680361] [086/132] (750s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[270.772319] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[278.174983] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.404s)
[278.337186] [087/132] (743s left) kms_getfb (getfb2-accept-nv12)
[278.450269] Starting subtest: getfb2-accept-nv12
[278.452572] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[278.560452] [088/132] (743s left) gem_basic (create-close)
[278.616159] Starting subtest: create-close
[278.620361] Subtest create-close: SUCCESS (0.000s)
[278.709349] [089/132] (743s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[278.758999] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[278.761618] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[278.852156] [090/132] (742s left) gem_ctx_persistence (engines-queued)
[278.905879] Starting subtest: engines-queued
[278.907759] Starting dynamic subtest: rcs0
[278.985444] Dynamic subtest rcs0: SUCCESS (0.082s)
[278.997445] Starting dynamic subtest: bcs0
[279.031466] Dynamic subtest bcs0: SUCCESS (0.044s)
[279.043594] Starting dynamic subtest: vcs0
[280.891499] Dynamic subtest vcs0: SUCCESS (1.857s)
[280.904538] Starting dynamic subtest: vcs1
[282.873439] Dynamic subtest vcs1: SUCCESS (1.979s)
[282.886050] Starting dynamic subtest: vecs0
[284.857024] Dynamic subtest vecs0: SUCCESS (1.980s)
[284.869371] Starting dynamic subtest: ccs0
[285.054595] Dynamic subtest ccs0: SUCCESS (0.196s)
[285.057064] Subtest engines-queued: SUCCESS (6.152s)
[285.137878] [091/132] (736s left) i915_hangman (gt-error-state-capture)
[285.199145] Starting subtest: gt-error-state-capture
[285.201237] Starting dynamic subtest: rcs0
[296.888350] Dynamic subtest rcs0: SUCCESS (11.690s)
[296.900554] Starting dynamic subtest: bcs0
[308.858906] Dynamic subtest bcs0: SUCCESS (11.969s)
[308.870844] Starting dynamic subtest: vcs0
[320.824534] Dynamic subtest vcs0: SUCCESS (11.964s)
[320.836864] Starting dynamic subtest: vcs1
[331.833390] Dynamic subtest vcs1: SUCCESS (11.008s)
[331.846290] Starting dynamic subtest: vecs0
[342.840973] Dynamic subtest vecs0: SUCCESS (11.006s)
[342.853338] Starting dynamic subtest: ccs0
[354.874737] Dynamic subtest ccs0: SUCCESS (12.032s)
[354.878233] Subtest gt-error-state-capture: SUCCESS (69.687s)
[354.966328] [092/132] (666s left) gem_exec_schedule (wide)
[355.155401] Starting subtest: wide
[355.157968] Starting dynamic subtest: rcs0
[366.778983] Dynamic subtest rcs0: SUCCESS (11.623s)
[366.791731] Starting dynamic subtest: vcs0
[379.152217] Dynamic subtest vcs0: SUCCESS (12.370s)
[379.164235] Starting dynamic subtest: vcs1
[391.461020] Dynamic subtest vcs1: SUCCESS (12.306s)
[391.473416] Starting dynamic subtest: vecs0
[403.236393] Dynamic subtest vecs0: SUCCESS (11.775s)
[403.248565] Starting dynamic subtest: ccs0
[417.684897] Dynamic subtest ccs0: SUCCESS (14.448s)
[417.687515] Subtest wide: SUCCESS (62.531s)
[419.120347] [093/132] (602s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k)
[419.514767] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s)
[420.317840] [094/132] (601s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[420.424500] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[427.312553] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.890s)
[427.463146] [095/132] (594s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[427.573602] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[427.577669] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[427.642304] [096/132] (594s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[427.703924] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[427.706235] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[427.802077] [097/132] (594s left) kms_dp_link_training (non-uhbr-sst)
[427.898070] Starting subtest: non-uhbr-sst
[427.906313] Subtest non-uhbr-sst: SKIP (0.000s)
[427.969669] [098/132] (594s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[428.227761] Starting subtest: cursor-rapid-movement-256x256
[428.233060] Starting dynamic subtest: pipe-A-eDP-1
[428.773997] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.541s)
[428.802621] Starting dynamic subtest: pipe-D-eDP-1
[429.978547] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.180s)
[429.980530] Subtest cursor-rapid-movement-256x256: SUCCESS (1.748s)
[430.842651] [099/132] (591s left) kms_setmode (invalid-clone-single-crtc)
[430.894571] Starting subtest: invalid-clone-single-crtc
[430.901209] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[430.994204] [100/132] (591s left) gem_close_race (basic-threads)
[431.057089] Starting subtest: basic-threads
[432.396769] Subtest basic-threads: SUCCESS (1.340s)
[432.597134] [101/132] (589s left) gem_mmap_gtt (isolation)
[432.654856] Subtest isolation: SKIP (0.000s)
[432.716440] [102/132] (589s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[432.824322] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[432.828642] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[432.906244] [103/132] (589s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[432.993068] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[432.995381] Starting dynamic subtest: pipe-A-eDP-1
[433.140744] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.139s)
[433.151699] Starting dynamic subtest: pipe-B-eDP-1
[433.174059] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[433.183724] Starting dynamic subtest: pipe-C-eDP-1
[433.202894] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[433.212279] Starting dynamic subtest: pipe-D-eDP-1
[433.232566] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[433.234900] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.149s)
[435.392446] [104/132] (586s left) kms_invalid_mode (bad-hsync-start)
[435.485074] Starting subtest: bad-hsync-start
[435.487296] Starting dynamic subtest: pipe-A-eDP-1
[435.786080] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.302s)
[435.796509] Starting dynamic subtest: pipe-B-eDP-1
[435.798524] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[435.811941] Starting dynamic subtest: pipe-C-eDP-1
[435.814383] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[435.834032] Starting dynamic subtest: pipe-D-eDP-1
[435.836590] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[435.838916] Subtest bad-hsync-start: SUCCESS (0.308s)
[436.627745] [105/132] (585s left) template (b)
[436.693516] Starting subtest: B
[436.695781] Subtest B: SUCCESS (0.000s)
[436.800401] [106/132] (585s left) sysfs_timeslice_duration (invalid)
[436.857783] Starting subtest: invalid
[436.860300] Starting dynamic subtest: vecs0
[436.863451] Dynamic subtest vecs0: SUCCESS (0.000s)
[436.872703] Starting dynamic subtest: ccs0
[436.874947] Dynamic subtest ccs0: SUCCESS (0.000s)
[436.884289] Starting dynamic subtest: vcs0
[436.886501] Dynamic subtest vcs0: SUCCESS (0.000s)
[436.895715] Starting dynamic subtest: bcs0
[436.897967] Dynamic subtest bcs0: SUCCESS (0.000s)
[436.907306] Starting dynamic subtest: rcs0
[436.909620] Dynamic subtest rcs0: SUCCESS (0.000s)
[436.919029] Starting dynamic subtest: vcs1
[436.921314] Dynamic subtest vcs1: SUCCESS (0.000s)
[436.923641] Subtest invalid: SUCCESS (0.006s)
[436.994410] [107/132] (585s left) kms_content_protection (lic-type-0-hdcp14)
[437.181789] Starting subtest: lic-type-0-hdcp14
[437.186461] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[437.303163] [108/132] (585s left) gem_exec_schedule (independent)
[437.368831] Starting subtest: independent
[437.371236] Starting dynamic subtest: rcs0
[438.939024] Dynamic subtest rcs0: SUCCESS (1.579s)
[438.948972] Starting dynamic subtest: vcs0
[440.931745] Dynamic subtest vcs0: SUCCESS (1.991s)
[440.945213] Starting dynamic subtest: vcs1
[442.914303] Dynamic subtest vcs1: SUCCESS (1.980s)
[442.927065] Starting dynamic subtest: vecs0
[444.904672] Dynamic subtest vecs0: SUCCESS (1.988s)
[444.917668] Starting dynamic subtest: ccs0
[446.939294] Dynamic subtest ccs0: SUCCESS (2.032s)
[446.942249] Subtest independent: SUCCESS (9.582s)
[447.239254] [109/132] (575s left) kms_addfb_basic (invalid-set-prop-any)
[447.298095] Starting subtest: invalid-set-prop-any
[447.300433] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[447.435229] [110/132] (575s left) kms_color (ctm-red-to-blue)
[447.536147] Starting subtest: ctm-red-to-blue
[447.537982] Starting dynamic subtest: pipe-A-eDP-1
[448.255441] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.718s)
[448.265592] Starting dynamic subtest: pipe-B-eDP-1
[449.628650] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.375s)
[449.640347] Starting dynamic subtest: pipe-C-eDP-1
[451.004963] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.373s)
[451.016291] Starting dynamic subtest: pipe-D-eDP-1
[452.338168] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.333s)
[452.340646] Subtest ctm-red-to-blue: SUCCESS (4.803s)
[453.139412] [111/132] (569s left) kms_flip_event_leak (basic)
[453.243333] Starting subtest: basic
[453.245324] Starting dynamic subtest: pipe-A-eDP-1
[453.671017] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.426s)
[453.681014] Starting dynamic subtest: pipe-B-eDP-1
[454.760701] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.088s)
[454.771150] Starting dynamic subtest: pipe-C-eDP-1
[455.865519] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.105s)
[455.878983] Starting dynamic subtest: pipe-D-eDP-1
[456.987379] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.120s)
[456.989829] Subtest basic: SUCCESS (3.745s)
[457.867455] [112/132] (564s left) perf_pmu (render-node-busy)
[457.931898] Starting subtest: render-node-busy
[457.934236] Starting dynamic subtest: rcs0
[458.521303] Dynamic subtest rcs0: SUCCESS (0.588s)
[458.533696] Starting dynamic subtest: bcs0
[459.078743] Dynamic subtest bcs0: SUCCESS (0.556s)
[459.091425] Starting dynamic subtest: vcs0
[460.890874] Dynamic subtest vcs0: SUCCESS (1.808s)
[460.903352] Starting dynamic subtest: vcs1
[462.939266] Dynamic subtest vcs1: SUCCESS (2.045s)
[462.951883] Starting dynamic subtest: vecs0
[464.922813] Dynamic subtest vecs0: SUCCESS (1.981s)
[464.933990] Starting dynamic subtest: ccs0
[465.484368] Dynamic subtest ccs0: SUCCESS (0.561s)
[465.487068] Subtest render-node-busy: SUCCESS (7.554s)
[465.564641] [113/132] (557s left) gem_exec_balancer (parallel)
[465.825250] Starting subtest: parallel
[466.822052] Subtest parallel: SUCCESS (0.996s)
[467.921864] [114/132] (554s left) kms_busy (extended-pageflip-hang-newfb)
[468.016965] Starting subtest: extended-pageflip-hang-newfb
[468.019199] Starting dynamic subtest: pipe-A
[494.707338] Dynamic subtest pipe-A: SUCCESS (26.692s)
[494.719513] Starting dynamic subtest: pipe-D
[509.674447] Dynamic subtest pipe-D: SUCCESS (14.969s)
[509.677068] Subtest extended-pageflip-hang-newfb: SUCCESS (41.665s)
[510.491465] [115/132] (512s left) kms_cursor_crc (cursor-dpms)
[510.611265] Starting subtest: cursor-dpms
[510.613846] Starting dynamic subtest: pipe-A-eDP-1
[513.645228] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.030s)
[513.655402] Starting dynamic subtest: pipe-D-eDP-1
[517.241737] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.595s)
[517.243953] Subtest cursor-dpms: SUCCESS (6.629s)
[518.084442] [116/132] (504s left) kms_plane_alpha_blend (alpha-basic)
[518.181214] Starting subtest: alpha-basic
[518.472715] Starting dynamic subtest: pipe-A-eDP-1
[520.399642] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.926s)
[520.427464] Starting dynamic subtest: pipe-D-eDP-1
[523.032629] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.613s)
[523.035129] Subtest alpha-basic: SUCCESS (4.854s)
[523.839456] [117/132] (499s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[523.945549] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[523.950114] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[524.044806] [118/132] (498s left) i915_pm_rps (basic-api)
[524.098586] Starting subtest: basic-api
[524.102950] Subtest basic-api: SKIP (0.001s)
[524.203732] [119/132] (498s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[524.298584] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[528.682505] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.389s)
[529.862977] [120/132] (493s left) syncobj_wait (single-wait-all-for-submit-submitted)
[529.932805] Starting subtest: single-wait-all-for-submit-submitted
[530.038300] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.106s)
[530.116289] [121/132] (492s left) gem_mmap_gtt (basic-read-write-distinct)
[530.174869] Subtest basic-read-write-distinct: SKIP (0.000s)
[530.246680] [122/132] (492s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[530.340718] Starting subtest: fbcpsr-rgb101010-draw-render
[537.117456] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.781s)
[537.243689] [123/132] (485s left) gem_exec_fence (basic-busy)
[537.424729] Starting subtest: basic-busy
[537.427339] Starting dynamic subtest: rcs0
[537.501072] Dynamic subtest rcs0: SUCCESS (0.076s)
[537.513164] Starting dynamic subtest: bcs0
[537.561481] Dynamic subtest bcs0: SUCCESS (0.059s)
[537.573149] Starting dynamic subtest: vcs0
[537.620080] Dynamic subtest vcs0: SUCCESS (0.057s)
[537.631239] Starting dynamic subtest: vcs1
[537.681773] Dynamic subtest vcs1: SUCCESS (0.060s)
[537.693998] Starting dynamic subtest: vecs0
[537.733178] Dynamic subtest vecs0: SUCCESS (0.049s)
[537.745050] Starting dynamic subtest: ccs0
[537.788787] Dynamic subtest ccs0: SUCCESS (0.053s)
[537.791362] Subtest basic-busy: SUCCESS (0.366s)
[540.045298] [124/132] (483s left) kms_feature_discovery (chamelium)
[540.160718] Starting subtest: chamelium
[540.165205] Subtest chamelium: SKIP (0.000s)
[540.260859] [125/132] (483s left) kms_universal_plane (universal-plane-sanity)
[540.353238] Starting subtest: universal-plane-sanity
[540.355195] Starting dynamic subtest: pipe-A-eDP-1
[540.955717] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.603s)
[540.967144] Starting dynamic subtest: pipe-B-eDP-1
[542.192241] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.233s)
[542.202859] Starting dynamic subtest: pipe-C-eDP-1
[543.402183] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.210s)
[543.413029] Starting dynamic subtest: pipe-D-eDP-1
[544.616756] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.215s)
[544.619072] Subtest universal-plane-sanity: SUCCESS (4.267s)
[545.483452] [126/132] (477s left) kms_psr (fbc-psr-sprite-plane-move)
[545.578373] Starting subtest: fbc-psr-sprite-plane-move
[545.580730] Starting dynamic subtest: eDP-1
[545.584882] Dynamic subtest eDP-1: SKIP (0.000s)
[545.589036] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[545.654850] [127/132] (477s left) perf (short-reads)
[545.753165] Starting subtest: short-reads
[545.766940] Subtest short-reads: SUCCESS (0.014s)
[545.819308] [128/132] (477s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[545.909320] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[545.911525] Starting dynamic subtest: pipe-A
[545.928692] Dynamic subtest pipe-A: SKIP (0.016s)
[545.940344] Starting dynamic subtest: pipe-B
[545.957558] Dynamic subtest pipe-B: SKIP (0.029s)
[545.967820] Starting dynamic subtest: pipe-C
[545.991497] Dynamic subtest pipe-C: SKIP (0.031s)
[546.003668] Starting dynamic subtest: pipe-D
[546.021588] Dynamic subtest pipe-D: SKIP (0.031s)
[546.025941] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.109s)
[546.098330] [129/132] (477s left) kms_psr (psr-basic)
[546.199539] Starting subtest: psr-basic
[546.201824] Starting dynamic subtest: eDP-1
[547.850796] Dynamic subtest eDP-1: SUCCESS (1.651s)
[547.853067] Subtest psr-basic: SUCCESS (1.652s)
[548.746010] [130/132] (474s left) api_intel_bb (intel-bb-blit-x)
[548.808499] Starting subtest: intel-bb-blit-x
[552.780796] Subtest intel-bb-blit-x: SUCCESS (3.972s)
[552.894343] [131/132] (470s left) gem_exec_schedule (submit-early-slice)
[552.977386] Starting subtest: submit-early-slice
[552.980065] Starting dynamic subtest: rcs0
[553.034641] Dynamic subtest rcs0: SUCCESS (0.064s)
[553.046705] Starting dynamic subtest: bcs0
[553.096851] Dynamic subtest bcs0: SUCCESS (0.062s)
[553.108845] Starting dynamic subtest: vcs0
[553.162253] Dynamic subtest vcs0: SUCCESS (0.064s)
[553.174055] Starting dynamic subtest: vcs1
[553.219984] Dynamic subtest vcs1: SUCCESS (0.056s)
[553.231169] Starting dynamic subtest: vecs0
[553.278013] Dynamic subtest vecs0: SUCCESS (0.055s)
[553.290165] Starting dynamic subtest: ccs0
[553.344353] Dynamic subtest ccs0: SUCCESS (0.066s)
[553.347186] Subtest submit-early-slice: SUCCESS (0.374s)
[555.000500] [132/132] (468s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[555.066177] Starting subtest: wait-all-for-submit-delayed-submit
[555.169827] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[555.264995] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: gem_softpin
results: parsing output: 3/ for test: gem_exec_gttfill
results: parsing output: 4/ for test: gem_ctx_persistence
results: parsing output: 5/ for test: kms_flip
results: parsing output: 6/ for test: prime_mmap_coherency
results: parsing output: 7/ for test: i915_power
results: parsing output: 8/ for test: gem_blits
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: core_auth
results: parsing output: 11/ for test: gem_ringfill
results: parsing output: 12/ for test: kms_rotation_crc
results: parsing output: 13/ for test: gem_mmap_gtt
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: gem_mmap_gtt
results: parsing output: 16/ for test: kms_flip
results: parsing output: 17/ for test: gem_mmap_gtt
results: parsing output: 18/ for test: gem_eio
results: parsing output: 19/ for test: api_intel_allocator
results: parsing output: 20/ for test: gem_render_copy
results: parsing output: 21/ for test: syncobj_eventfd
results: parsing output: 22/ for test: kms_vblank
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_flip_scaled_crc
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_plane
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_cursor_edge_walk
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: kms_lease
results: parsing output: 32/ for test: gem_ctx_exec
results: parsing output: 33/ for test: gen9_exec_parse
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: gem_exec_params
results: parsing output: 36/ for test: kms_pm_rpm
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: perf
results: parsing output: 40/ for test: gem_eio
results: parsing output: 41/ for test: kms_addfb_basic
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_close_race
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: syncobj_wait
results: parsing output: 48/ for test: gem_mmap_offset
results: parsing output: 49/ for test: gem_exec_whisper
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: kms_addfb_basic
results: parsing output: 52/ for test: kms_plane_scaling
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_chamelium_frames
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: prime_vgem
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: kms_cursor_legacy
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_cursor_legacy
results: parsing output: 61/ for test: gem_exec_fence
results: parsing output: 62/ for test: vgem_basic
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: kms_plane
results: parsing output: 65/ for test: i915_drm_fdinfo
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: gem_vm_create
results: parsing output: 68/ for test: gem_mmap_gtt
results: parsing output: 69/ for test: gem_mmap_gtt
results: parsing output: 70/ for test: gem_render_copy_redux
results: parsing output: 71/ for test: gem_pipe_control_store_loop
results: parsing output: 72/ for test: gem_mmap_gtt
results: parsing output: 73/ for test: gem_exec_params
results: parsing output: 74/ for test: kms_atomic
results: parsing output: 75/ for test: kms_psr2_sf
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: kms_flip
results: parsing output: 78/ for test: kms_atomic_interruptible
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: core_getversion
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_getfb
results: parsing output: 87/ for test: gem_basic
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: gem_ctx_persistence
results: parsing output: 90/ for test: i915_hangman
results: parsing output: 91/ for test: gem_exec_schedule
results: parsing output: 92/ for test: kms_chamelium_edid
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_psr2_sf
results: parsing output: 95/ for test: syncobj_wait
results: parsing output: 96/ for test: kms_dp_link_training
results: parsing output: 97/ for test: kms_cursor_crc
results: parsing output: 98/ for test: kms_setmode
results: parsing output: 99/ for test: gem_close_race
results: parsing output: 100/ for test: gem_mmap_gtt
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: kms_invalid_mode
results: parsing output: 104/ for test: template
results: parsing output: 105/ for test: sysfs_timeslice_duration
results: parsing output: 106/ for test: kms_content_protection
results: parsing output: 107/ for test: gem_exec_schedule
results: parsing output: 108/ for test: kms_addfb_basic
results: parsing output: 109/ for test: kms_color
results: parsing output: 110/ for test: kms_flip_event_leak
results: parsing output: 111/ for test: perf_pmu
results: parsing output: 112/ for test: gem_exec_balancer
results: parsing output: 113/ for test: kms_busy
results: parsing output: 114/ for test: kms_cursor_crc
results: parsing output: 115/ for test: kms_plane_alpha_blend
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: i915_pm_rps
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: syncobj_wait
results: parsing output: 120/ for test: gem_mmap_gtt
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_exec_fence
results: parsing output: 123/ for test: kms_feature_discovery
results: parsing output: 124/ for test: kms_universal_plane
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: perf
results: parsing output: 127/ for test: kms_plane_scaling
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: api_intel_bb
results: parsing output: 130/ for test: gem_exec_schedule
results: parsing output: 131/ for test: syncobj_timeline
Done.