[58.285517] Initializing watchdogs
[58.285580]   /dev/watchdog0
[58.306018] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[58.311527] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.314125] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.315965] [001/133] (960s left) gem_tiled_pread_pwrite
[59.016334] [002/133] (959s left) gem_mmap_gtt (cpuset-medium-copy)
[59.093589] Starting subtest: cpuset-medium-copy
[65.164367] Subtest cpuset-medium-copy: SUCCESS (6.071s)
[65.283052] [003/133] (953s left) kms_debugfs (display-on-read-all)
[65.415524] Starting subtest: display-on-read-all
[65.584392] Subtest display-on-read-all: SUCCESS (0.168s)
[65.741105] [004/133] (953s left) kms_flip (2x-flip-vs-modeset)
[65.827163] Starting subtest: 2x-flip-vs-modeset
[65.835357] Subtest 2x-flip-vs-modeset: SKIP (0.008s)
[65.929925] [005/133] (953s left) gem_ctx_param (invalid-ctx-set)
[65.961645] Starting subtest: invalid-ctx-set
[65.962438] Subtest invalid-ctx-set: SUCCESS (0.000s)
[66.057780] [006/133] (952s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[66.145666] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[66.147077] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[66.272580] [007/133] (952s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[66.312132] Starting subtest: single-wait-for-submit-available-submitted
[66.313114] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.001s)
[66.422960] [008/133] (952s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[66.516536] Starting subtest: 4-tiled-64bpp-rotate-90
[66.517877] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.000s)
[66.633020] [009/133] (952s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[66.665958] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[66.666744] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[66.768964] [010/133] (952s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[66.802150] Starting subtest: multi-wait-available-unsubmitted-signaled
[66.802844] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[66.997520] [011/133] (952s left) kms_sequence (get-idle)
[67.107414] Starting subtest: get-idle
[67.108306] Starting dynamic subtest: pipe-A-HDMI-A-1
[69.708845] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.600s)
[69.716805] Starting dynamic subtest: pipe-B-HDMI-A-1
[72.200653] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.491s)
[72.206544] Starting dynamic subtest: pipe-C-HDMI-A-1
[74.696203] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.495s)
[74.704808] Starting dynamic subtest: pipe-D-HDMI-A-1
[77.181640] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.484s)
[77.182333] Subtest get-idle: SUCCESS (10.075s)
[77.305691] [012/133] (942s left) api_intel_bb (destroy-bb)
[77.340376] Starting subtest: destroy-bb
[77.348092] Subtest destroy-bb: SUCCESS (0.008s)
[77.479080] [013/133] (941s left) kms_flip (2x-flip-vs-rmfb)
[77.563990] Starting subtest: 2x-flip-vs-rmfb
[77.572327] Subtest 2x-flip-vs-rmfb: SKIP (0.008s)
[77.688895] [014/133] (941s left) gen9_exec_parse (cmd-crossing-page)
[77.727733] Subtest cmd-crossing-page: SKIP (0.000s)
[77.764736] [015/133] (941s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[77.900123] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[77.979640] [016/133] (941s left) kms_cursor_edge_walk (256x256-top-edge)
[78.062626] Starting subtest: 256x256-top-edge
[78.063299] Starting dynamic subtest: pipe-A-HDMI-A-1
[81.761350] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.697s)
[81.767946] Starting dynamic subtest: pipe-D-HDMI-A-1
[85.394492] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (3.632s)
[85.395194] Subtest 256x256-top-edge: SUCCESS (7.332s)
[85.522348] [017/133] (934s left) gem_exec_nop (basic-parallel)
[85.564820] Starting subtest: basic-parallel
[88.864588] Subtest basic-parallel: SUCCESS (3.300s)
[89.112339] [018/133] (930s left) kms_lease (lease-uevent)
[89.197638] Starting subtest: lease-uevent
[90.235290] Subtest lease-uevent: SUCCESS (1.038s)
[90.337441] [019/133] (929s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[90.422442] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[90.423888] Starting dynamic subtest: pipe-A-HDMI-A-1
[90.430369] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[90.436331] Starting dynamic subtest: pipe-B-HDMI-A-1
[90.442873] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[90.448743] Starting dynamic subtest: pipe-C-HDMI-A-1
[90.455284] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[90.461060] Starting dynamic subtest: pipe-D-HDMI-A-1
[90.467610] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[90.468928] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SKIP (0.006s)
[90.657818] [020/133] (928s left) gem_pxp (regular-baseline-src-copy-readible)
[90.759206] Starting subtest: regular-baseline-src-copy-readible
[90.803791] Subtest regular-baseline-src-copy-readible: SUCCESS (0.046s)
[90.959286] [021/133] (928s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[91.045560] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[91.046915] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[91.171378] [022/133] (928s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[91.255257] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[91.263707] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.008s)
[91.361171] [023/133] (928s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[91.446554] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[91.447960] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[91.570678] [024/133] (928s left) perf_pmu (busy-idle-check-all)
[91.604676] Starting subtest: busy-idle-check-all
[91.605347] Starting dynamic subtest: rcs0
[92.226033] Dynamic subtest rcs0: SUCCESS (0.621s)
[92.235678] Starting dynamic subtest: bcs0
[92.853258] Dynamic subtest bcs0: SUCCESS (0.627s)
[92.864198] Starting dynamic subtest: vcs0
[93.480328] Dynamic subtest vcs0: SUCCESS (0.625s)
[93.491013] Starting dynamic subtest: vcs1
[94.106032] Dynamic subtest vcs1: SUCCESS (0.625s)
[94.116682] Starting dynamic subtest: vecs0
[94.736325] Dynamic subtest vecs0: SUCCESS (0.631s)
[94.737352] Subtest busy-idle-check-all: SUCCESS (3.132s)
[94.829876] [025/133] (925s left) kms_flip (flip-vs-panning-interruptible)
[94.919431] Starting subtest: flip-vs-panning-interruptible
[94.921228] Starting dynamic subtest: A-HDMI-A1
[102.622936] Dynamic subtest A-HDMI-A1: SUCCESS (7.701s)
[102.635980] Starting dynamic subtest: B-HDMI-A1
[110.279863] Dynamic subtest B-HDMI-A1: SUCCESS (7.656s)
[110.296094] Starting dynamic subtest: C-HDMI-A1
[117.936969] Dynamic subtest C-HDMI-A1: SUCCESS (7.656s)
[117.953910] Starting dynamic subtest: D-HDMI-A1
[125.598679] Dynamic subtest D-HDMI-A1: SUCCESS (7.660s)
[125.600720] Subtest flip-vs-panning-interruptible: SUCCESS (30.681s)
[125.803456] [026/133] (894s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[125.888815] Starting subtest: primary-yf-tiled-reflect-x-0
[126.005745] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.116s)
[126.135365] [027/133] (893s left) kms_pm_rpm (fences-dpms)
[127.531583] Starting subtest: fences-dpms
[132.241555] Subtest fences-dpms: SUCCESS (4.703s)
[132.375553] [028/133] (887s left) syncobj_wait (invalid-signal-one-illegal-handle)
[132.410120] Starting subtest: invalid-signal-one-illegal-handle
[132.410888] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[132.524724] [029/133] (887s left) kms_psr (fbc-pr-primary-page-flip)
[132.610322] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[132.664595] [030/133] (887s left) gem_ctx_persistence (engines-mixed-process)
[132.701305] Starting subtest: engines-mixed-process
[132.701999] Starting dynamic subtest: rcs0
[133.065696] Dynamic subtest rcs0: SUCCESS (0.364s)
[133.078811] Starting dynamic subtest: bcs0
[133.429524] Dynamic subtest bcs0: SUCCESS (0.363s)
[133.442519] Starting dynamic subtest: vcs0
[133.791319] Dynamic subtest vcs0: SUCCESS (0.359s)
[133.805508] Starting dynamic subtest: vcs1
[134.146834] Dynamic subtest vcs1: SUCCESS (0.356s)
[134.163094] Starting dynamic subtest: vecs0
[134.516745] Dynamic subtest vecs0: SUCCESS (0.368s)
[134.517779] Subtest engines-mixed-process: SUCCESS (1.816s)
[134.613092] [031/133] (885s left) syncobj_wait (invalid-wait-illegal-handle)
[134.647848] Starting subtest: invalid-wait-illegal-handle
[134.648562] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[134.762998] [032/133] (885s left) perf_pmu (semaphore-wait-idle)
[134.798971] Starting subtest: semaphore-wait-idle
[134.799784] Starting dynamic subtest: rcs0
[135.317111] Dynamic subtest rcs0: SUCCESS (0.509s)
[135.326545] Starting dynamic subtest: bcs0
[135.828198] Dynamic subtest bcs0: SUCCESS (0.510s)
[135.837809] Starting dynamic subtest: vcs0
[136.339609] Dynamic subtest vcs0: SUCCESS (0.510s)
[136.348834] Starting dynamic subtest: vcs1
[136.850436] Dynamic subtest vcs1: SUCCESS (0.510s)
[136.860080] Starting dynamic subtest: vecs0
[137.361355] Dynamic subtest vecs0: SUCCESS (0.510s)
[137.362228] Subtest semaphore-wait-idle: SUCCESS (2.554s)
[137.501226] [033/133] (882s left) gem_mmap_wc (read)
[137.534628] Starting subtest: read
[137.543201] Subtest read: SUCCESS (0.009s)
[137.649560] [034/133] (882s left) gem_exec_schedule (pi-ringfull)
[137.815436] Starting subtest: pi-ringfull
[137.816452] Starting dynamic subtest: rcs0
[137.873221] Dynamic subtest rcs0: SUCCESS (0.057s)
[137.881061] Starting dynamic subtest: bcs0
[137.898707] Dynamic subtest bcs0: SUCCESS (0.025s)
[137.906591] Starting dynamic subtest: vcs0
[137.924618] Dynamic subtest vcs0: SUCCESS (0.025s)
[137.931847] Starting dynamic subtest: vcs1
[137.950431] Dynamic subtest vcs1: SUCCESS (0.025s)
[137.957658] Starting dynamic subtest: vecs0
[137.976135] Dynamic subtest vecs0: SUCCESS (0.025s)
[137.976870] Subtest pi-ringfull: SUCCESS (0.162s)
[138.182181] [FACT gem_exec_schedule (pi-ringfull)] new: kernel.kmod_is_loaded.vgem: true
[138.183884] [035/133] (882s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[138.270122] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[138.270849] Starting dynamic subtest: pipe-A-HDMI-A-1
[138.277762] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[138.286832] Starting dynamic subtest: pipe-B-HDMI-A-1
[138.293702] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[138.302379] Starting dynamic subtest: pipe-C-HDMI-A-1
[138.309297] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[138.317484] Starting dynamic subtest: pipe-D-HDMI-A-1
[138.324468] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[138.325861] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.006s)
[138.500891] [036/133] (881s left) kms_content_protection (dp-mst-lic-type-0)
[138.595093] Starting subtest: dp-mst-lic-type-0
[138.596408] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[138.709128] [037/133] (881s left) gem_pxp (fail-invalid-protected-context)
[138.745625] Starting subtest: fail-invalid-protected-context
[138.746320] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[138.841259] [038/133] (881s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[138.875316] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[138.876063] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[138.994700] [039/133] (881s left) kms_invalid_mode (zero-clock)
[139.079474] Starting subtest: zero-clock
[139.080177] Starting dynamic subtest: pipe-A-HDMI-A-1
[139.125144] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.045s)
[139.134114] Starting dynamic subtest: pipe-B-HDMI-A-1
[139.134803] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[139.141793] Starting dynamic subtest: pipe-C-HDMI-A-1
[139.142473] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[139.148889] Starting dynamic subtest: pipe-D-HDMI-A-1
[139.149576] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[139.150240] Subtest zero-clock: SUCCESS (0.053s)
[139.277982] [040/133] (881s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[139.364623] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[141.719034] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SUCCESS (2.354s)
[141.880594] [041/133] (878s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[141.976406] Starting subtest: x-tiled-32bpp-rotate-90
[142.057883] Subtest x-tiled-32bpp-rotate-90: SKIP (0.080s)
[142.207161] [042/133] (878s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[142.296584] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[142.297906] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[142.411477] [043/133] (878s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[142.495768] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[142.496433] Starting dynamic subtest: pipe-A-valid-mode
[143.361578] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.865s)
[143.362318] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SUCCESS (0.867s)
[143.527391] [044/133] (877s left) perf (gen12-group-exclusive-stream-sample-oa)
[143.631580] Starting subtest: gen12-group-exclusive-stream-sample-oa
[143.641909] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.010s)
[143.690281] [045/133] (876s left) gem_exec_schedule (thriceslice)
[143.732013] Starting subtest: thriceslice
[143.732782] Starting dynamic subtest: rcs0
[143.738157] Dynamic subtest rcs0: SUCCESS (0.006s)
[143.748879] Starting dynamic subtest: bcs0
[143.749590] Dynamic subtest bcs0: SUCCESS (0.005s)
[143.757338] Starting dynamic subtest: vcs0
[143.758060] Dynamic subtest vcs0: SUCCESS (0.005s)
[143.765686] Starting dynamic subtest: vcs1
[143.766370] Dynamic subtest vcs1: SUCCESS (0.004s)
[143.773289] Starting dynamic subtest: vecs0
[143.773967] Dynamic subtest vecs0: SUCCESS (0.004s)
[143.774633] Subtest thriceslice: SUCCESS (0.029s)
[144.084973] [046/133] (876s left) gem_ctx_create (basic)
[144.126759] Starting subtest: basic
[144.127432] Subtest basic: SUCCESS (0.000s)
[144.331254] [047/133] (876s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[144.417815] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[144.419153] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[144.553842] [048/133] (876s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[144.640563] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[144.641903] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[144.766069] [049/133] (876s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[144.849848] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[144.850562] Starting dynamic subtest: pipe-A
[145.773981] Dynamic subtest pipe-A: SUCCESS (0.924s)
[145.788658] Starting dynamic subtest: pipe-B
[146.635053] Dynamic subtest pipe-B: SUCCESS (0.859s)
[146.651227] Starting dynamic subtest: pipe-C
[147.496068] Dynamic subtest pipe-C: SUCCESS (0.859s)
[147.511942] Starting dynamic subtest: pipe-D
[148.358176] Dynamic subtest pipe-D: SUCCESS (0.860s)
[148.359133] Subtest plane-downscale-factor-0-5-with-modifiers: SUCCESS (3.509s)
[148.543781] [050/133] (872s left) kms_psr2_su (page_flip-nv12)
[148.579496] Subtest page_flip-NV12: SKIP (0.000s)
[148.625708] [051/133] (872s left) kms_psr (fbc-psr-basic)
[148.713064] Subtest fbc-psr-basic: SKIP (0.000s)
[148.756721] [052/133] (872s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[148.850764] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[148.852197] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[148.963785] [053/133] (872s left) kms_vblank (wait-forked-busy-hang)
[149.048124] Starting subtest: wait-forked-busy-hang
[149.048797] Starting dynamic subtest: pipe-A-HDMI-A-1
[162.434388] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (13.384s)
[162.444102] Starting dynamic subtest: pipe-D-HDMI-A-1
[176.761928] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (14.318s)
[176.762626] Subtest wait-forked-busy-hang: SUCCESS (27.709s)
[176.933101] [054/133] (844s left) sw_sync (timeline_closed_signaled)
[176.966975] Starting subtest: timeline_closed_signaled
[176.967766] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[177.045643] [055/133] (844s left) perf (per-context-mode-unprivileged)
[177.163312] Starting subtest: per-context-mode-unprivileged
[177.164743] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[177.205962] [056/133] (843s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[177.293384] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[177.295506] Starting dynamic subtest: pipe-A-valid-mode
[179.001659] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.707s)
[179.002364] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SUCCESS (1.709s)
[179.152804] [057/133] (842s left) syncobj_timeline (device-signal-unordered)
[179.187995] Starting subtest: device-signal-unordered
[179.190190] Subtest device-signal-unordered: SUCCESS (0.001s)
[179.280722] [058/133] (841s left) kms_async_flips (alternate-sync-async-flip)
[179.366865] Starting subtest: alternate-sync-async-flip
[179.556674] Starting dynamic subtest: pipe-A-HDMI-A-1
[181.641962] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.076s)
[181.820514] Starting dynamic subtest: pipe-B-HDMI-A-1
[183.885707] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.062s)
[184.036008] Starting dynamic subtest: pipe-C-HDMI-A-1
[186.109748] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.072s)
[186.256727] Starting dynamic subtest: pipe-D-HDMI-A-1
[188.323103] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.064s)
[188.324083] Subtest alternate-sync-async-flip: SUCCESS (8.949s)
[188.640430] [059/133] (832s left) gem_exec_balancer (bonded-dual)
[188.684307] Starting subtest: bonded-dual
[221.115728] Subtest bonded-dual: SUCCESS (32.423s)
[221.334766] [060/133] (799s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[221.426341] Starting subtest: cursor-rapid-movement-256x85
[221.431197] Starting dynamic subtest: pipe-A-HDMI-A-1
[221.824377] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.393s)
[221.854071] Starting dynamic subtest: pipe-D-HDMI-A-1
[222.143489] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.295s)
[222.144235] Subtest cursor-rapid-movement-256x85: SUCCESS (0.717s)
[222.322873] [061/133] (799s left) kms_frontbuffer_tracking (fbc-suspend)
[222.412473] Starting subtest: fbc-suspend
[259.123343] Subtest fbc-suspend: SUCCESS (5.879s)
[265.383575] [062/133] (762s left) prime_vgem (basic-fence-read)
[265.455390] Starting subtest: basic-fence-read
[265.502159] Subtest basic-fence-read: SUCCESS (0.047s)
[265.642600] [063/133] (761s left) kms_fence_pin_leak
[267.407154] [064/133] (760s left) gem_exec_fence (basic-busy)
[267.569076] Starting subtest: basic-busy
[267.570098] Starting dynamic subtest: rcs0
[267.596862] Dynamic subtest rcs0: SUCCESS (0.027s)
[267.613000] Starting dynamic subtest: bcs0
[267.630882] Dynamic subtest bcs0: SUCCESS (0.032s)
[267.648464] Starting dynamic subtest: vcs0
[267.665071] Dynamic subtest vcs0: SUCCESS (0.032s)
[267.680857] Starting dynamic subtest: vcs1
[267.699155] Dynamic subtest vcs1: SUCCESS (0.032s)
[267.714369] Starting dynamic subtest: vecs0
[267.732269] Dynamic subtest vecs0: SUCCESS (0.031s)
[267.733275] Subtest basic-busy: SUCCESS (0.164s)
[268.202756] [065/133] (759s left) kms_chamelium_frames (hdmi-frame-dump)
[268.335222] Subtest hdmi-frame-dump: SKIP (0.000s)
[268.419918] [066/133] (759s left) kms_atomic (crtc-invalid-params-fence)
[268.505892] Starting subtest: crtc-invalid-params-fence
[268.506602] Starting dynamic subtest: pipe-A-HDMI-A-1
[268.735920] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.229s)
[268.736636] Subtest crtc-invalid-params-fence: SUCCESS (0.231s)
[268.892603] [067/133] (758s left) gem_exec_capture (userptr)
[268.930849] Starting subtest: userptr
[270.210081] Subtest userptr: SUCCESS (1.276s)
[270.340959] [068/133] (757s left) gem_workarounds (reset)
[270.390947] Starting subtest: reset
[270.402975] Subtest reset: SUCCESS (0.012s)
[270.545207] [069/133] (757s left) kms_atomic_interruptible (legacy-dpms)
[270.633854] Starting subtest: legacy-dpms
[270.634542] Starting dynamic subtest: pipe-A-HDMI-A-1
[276.837561] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.200s)
[276.838325] Subtest legacy-dpms: SUCCESS (6.202s)
[276.997886] [070/133] (750s left) gem_wait (await)
[277.046233] Starting subtest: await
[277.046968] Starting dynamic subtest: all-engines
[278.095851] Dynamic subtest all-engines: SUCCESS (1.048s)
[278.108670] Starting dynamic subtest: rcs0
[279.128841] Dynamic subtest rcs0: SUCCESS (1.030s)
[279.140485] Starting dynamic subtest: bcs0
[280.163997] Dynamic subtest bcs0: SUCCESS (1.033s)
[280.175895] Starting dynamic subtest: vcs0
[281.196846] Dynamic subtest vcs0: SUCCESS (1.031s)
[281.215407] Starting dynamic subtest: vcs1
[282.229157] Dynamic subtest vcs1: SUCCESS (1.027s)
[282.239416] Starting dynamic subtest: vecs0
[283.255860] Dynamic subtest vecs0: SUCCESS (1.027s)
[283.259241] Subtest await: SUCCESS (6.209s)
[283.483624] [071/133] (744s left) i915_power (sanity)
[283.516243] Starting subtest: sanity
[287.536635] Subtest sanity: SUCCESS (4.011s)
[287.658082] [072/133] (740s left) gem_ctx_shared (q-independent)
[287.699674] Starting subtest: Q-independent
[287.700440] Starting dynamic subtest: rcs0
[287.722304] Dynamic subtest rcs0: SUCCESS (0.022s)
[287.732332] Starting dynamic subtest: bcs0
[287.741700] Dynamic subtest bcs0: SUCCESS (0.018s)
[287.751845] Starting dynamic subtest: vcs0
[287.763409] Dynamic subtest vcs0: SUCCESS (0.020s)
[287.773621] Starting dynamic subtest: vcs1
[287.782397] Dynamic subtest vcs1: SUCCESS (0.018s)
[287.792491] Starting dynamic subtest: vecs0
[287.801855] Dynamic subtest vecs0: SUCCESS (0.018s)
[287.802578] Subtest Q-independent: SUCCESS (0.103s)
[288.044491] [073/133] (739s left) gem_busy (extended)
[288.215322] Starting subtest: extended
[288.216280] Starting dynamic subtest: rcs0
[288.256228] Dynamic subtest rcs0: SUCCESS (0.048s)
[288.274838] Starting dynamic subtest: bcs0
[288.276896] Dynamic subtest bcs0: SUCCESS (0.018s)
[288.285513] Starting dynamic subtest: vcs0
[288.292539] Dynamic subtest vcs0: SUCCESS (0.016s)
[288.302355] Starting dynamic subtest: vcs1
[288.306493] Dynamic subtest vcs1: SUCCESS (0.013s)
[288.318319] Starting dynamic subtest: vecs0
[288.323512] Dynamic subtest vecs0: SUCCESS (0.016s)
[288.324256] Subtest extended: SUCCESS (0.118s)
[288.563938] [074/133] (739s left) perf (unprivileged-single-ctx-counters)
[288.663754] Starting subtest: unprivileged-single-ctx-counters
[288.665196] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[288.711850] [075/133] (739s left) kms_draw_crc (draw-method-blt)
[288.805862] Starting subtest: draw-method-blt
[288.806560] Starting dynamic subtest: xrgb8888-untiled
[289.132369] Dynamic subtest xrgb8888-untiled: SUCCESS (0.325s)
[289.150454] Starting dynamic subtest: rgb565-untiled
[289.473911] Dynamic subtest rgb565-untiled: SUCCESS (0.339s)
[289.492030] Starting dynamic subtest: xrgb2101010-untiled
[289.758493] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.282s)
[289.775901] Starting dynamic subtest: xbgr16161616f-untiled
[290.062160] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.301s)
[290.079972] Starting dynamic subtest: xrgb8888-xtiled
[290.233198] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.169s)
[290.247118] Starting dynamic subtest: rgb565-xtiled
[290.403821] Dynamic subtest rgb565-xtiled: SUCCESS (0.167s)
[290.422593] Starting dynamic subtest: xrgb2101010-xtiled
[290.555564] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.149s)
[290.576374] Starting dynamic subtest: xbgr16161616f-xtiled
[290.707371] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.149s)
[290.726302] Starting dynamic subtest: xrgb8888-ytiled
[290.878277] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.169s)
[290.897308] Starting dynamic subtest: rgb565-ytiled
[291.049047] Dynamic subtest rgb565-ytiled: SUCCESS (0.169s)
[291.061943] Starting dynamic subtest: xrgb2101010-ytiled
[291.200673] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.149s)
[291.217346] Starting dynamic subtest: xbgr16161616f-ytiled
[291.371552] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.169s)
[291.374997] Subtest draw-method-blt: SUCCESS (2.566s)
[291.516356] [076/133] (736s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[291.608551] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[291.609945] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[291.724692] [077/133] (736s left) kms_plane_alpha_blend (alpha-7efc)
[291.811425] Starting subtest: alpha-7efc
[291.879414] Starting dynamic subtest: pipe-A-HDMI-A-1
[292.405173] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.526s)
[292.443888] Starting dynamic subtest: pipe-D-HDMI-A-1
[293.079138] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.647s)
[293.079834] Subtest alpha-7efc: SUCCESS (1.268s)
[293.226119] [078/133] (734s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[293.317427] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[295.247514] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (1.930s)
[295.409001] [079/133] (732s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[296.805667] Starting subtest: gem-execbuf-stress-pc8
[296.879362] Subtest gem-execbuf-stress-pc8: SKIP (0.075s)
[297.027089] [080/133] (731s left) gem_exec_store (pages)
[297.070692] Starting subtest: pages
[297.071448] Starting dynamic subtest: rcs0
[297.153767] Dynamic subtest rcs0: SUCCESS (0.082s)
[297.172521] Starting dynamic subtest: bcs0
[297.206356] Dynamic subtest bcs0: SUCCESS (0.051s)
[297.221084] Starting dynamic subtest: vcs0
[297.269433] Dynamic subtest vcs0: SUCCESS (0.062s)
[297.286291] Starting dynamic subtest: vcs1
[297.341420] Dynamic subtest vcs1: SUCCESS (0.070s)
[297.359525] Starting dynamic subtest: vecs0
[297.402081] Dynamic subtest vecs0: SUCCESS (0.059s)
[297.402848] Subtest pages: SUCCESS (0.332s)
[297.615290] [081/133] (730s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[297.699948] Starting subtest: cursorA-vs-flipA-atomic-transitions
[308.554818] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (10.858s)
[308.736171] [082/133] (719s left) gem_ctx_bad_destroy (invalid-pad)
[308.781082] Starting subtest: invalid-pad
[308.781820] Subtest invalid-pad: SUCCESS (0.000s)
[308.880509] [083/133] (719s left) api_intel_bb (blit-reloc-keep-cache)
[308.914593] Starting subtest: blit-reloc-keep-cache
[308.920787] Subtest blit-reloc-keep-cache: SUCCESS (0.007s)
[309.059474] [084/133] (719s left) kms_psr (pr-basic)
[309.146285] Subtest pr-basic: SKIP (0.000s)
[309.194089] [085/133] (719s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[309.287740] Starting subtest: y-tiled-16bpp-rotate-90
[310.925265] Subtest y-tiled-16bpp-rotate-90: SUCCESS (1.637s)
[311.088137] [086/133] (717s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[311.188414] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[311.645920] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.458s)
[311.846915] [087/133] (716s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[311.935423] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[311.936776] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[312.075692] [088/133] (716s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[312.159846] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[312.161641] Starting dynamic subtest: pipe-A-HDMI-A-1
[312.168269] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[312.176834] Starting dynamic subtest: pipe-B-HDMI-A-1
[312.183436] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[312.191905] Starting dynamic subtest: pipe-C-HDMI-A-1
[312.198354] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[312.206441] Starting dynamic subtest: pipe-D-HDMI-A-1
[312.213017] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[312.214342] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[312.389584] [089/133] (716s left) gem_exec_fence (nb-await)
[312.564631] Starting subtest: nb-await
[312.565413] Starting dynamic subtest: rcs0
[312.615360] Dynamic subtest rcs0: SUCCESS (0.063s)
[312.628924] Starting dynamic subtest: bcs0
[312.676737] Dynamic subtest bcs0: SUCCESS (0.059s)
[312.696088] Starting dynamic subtest: vcs0
[312.744973] Dynamic subtest vcs0: SUCCESS (0.066s)
[312.764923] Starting dynamic subtest: vcs1
[312.813833] Dynamic subtest vcs1: SUCCESS (0.066s)
[312.832879] Starting dynamic subtest: vecs0
[312.882234] Dynamic subtest vecs0: SUCCESS (0.066s)
[312.885727] Subtest nb-await: SUCCESS (0.332s)
[313.360272] [090/133] (715s left) kms_color (gamma)
[313.447855] Starting subtest: gamma
[313.448549] Starting dynamic subtest: pipe-A-HDMI-A-1
[314.002231] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.555s)
[314.012465] Starting dynamic subtest: pipe-B-HDMI-A-1
[314.468891] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.465s)
[314.477349] Starting dynamic subtest: pipe-C-HDMI-A-1
[314.921800] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.447s)
[314.930277] Starting dynamic subtest: pipe-D-HDMI-A-1
[315.373769] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.451s)
[315.374475] Subtest gamma: SUCCESS (1.923s)
[315.558815] [091/133] (713s left) gem_exec_reloc (basic-gtt-read)
[315.597038] Starting subtest: basic-gtt-read
[315.604199] Subtest basic-gtt-read: SUCCESS (0.007s)
[315.763445] [092/133] (712s left) gem_spin_batch (spin-each)
[315.806166] Starting subtest: spin-each
[319.166761] Subtest spin-each: SUCCESS (3.361s)
[319.390226] [093/133] (709s left) kms_psr (psr2-sprite-plane-onoff)
[319.476224] Subtest psr2-sprite-plane-onoff: SKIP (0.000s)
[319.521481] [094/133] (709s left) kms_plane_cursor (overlay)
[319.606773] Starting subtest: overlay
[319.608095] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64
[322.355102] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (2.747s)
[322.447343] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128
[325.182304] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (2.750s)
[325.274659] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256
[328.009066] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (2.750s)
[328.142136] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64
[330.921302] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (2.786s)
[330.994401] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128
[333.729528] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (2.750s)
[333.800229] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256
[336.537613] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (2.750s)
[336.651009] Starting dynamic subtest: pipe-C-HDMI-A-1-size-64
[339.427200] Dynamic subtest pipe-C-HDMI-A-1-size-64: SUCCESS (2.783s)
[339.497837] Starting dynamic subtest: pipe-C-HDMI-A-1-size-128
[342.235480] Dynamic subtest pipe-C-HDMI-A-1-size-128: SUCCESS (2.750s)
[342.309973] Starting dynamic subtest: pipe-C-HDMI-A-1-size-256
[345.043703] Dynamic subtest pipe-C-HDMI-A-1-size-256: SUCCESS (2.750s)
[345.136447] Starting dynamic subtest: pipe-D-HDMI-A-1-size-64
[347.911980] Dynamic subtest pipe-D-HDMI-A-1-size-64: SUCCESS (2.783s)
[347.985271] Starting dynamic subtest: pipe-D-HDMI-A-1-size-128
[350.720189] Dynamic subtest pipe-D-HDMI-A-1-size-128: SUCCESS (2.750s)
[350.793317] Starting dynamic subtest: pipe-D-HDMI-A-1-size-256
[353.528397] Dynamic subtest pipe-D-HDMI-A-1-size-256: SUCCESS (2.750s)
[353.633262] Subtest overlay: SUCCESS (34.026s)
[353.767794] [095/133] (675s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[353.863544] Starting subtest: yf-tiled-16bpp-rotate-180
[353.864919] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[353.976849] [096/133] (674s left) kms_psr (psr-primary-render)
[354.061303] Subtest psr-primary-render: SKIP (0.000s)
[354.112640] [097/133] (674s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[354.199952] Starting subtest: fbcpsr-2p-rte
[354.201370] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[354.318620] [098/133] (674s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[354.403227] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[354.403942] Starting dynamic subtest: pipe-A-HDMI-A-1
[371.066046] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.522s)
[371.077980] Starting dynamic subtest: pipe-B-HDMI-A-1
[388.026029] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.449s)
[388.039957] Starting dynamic subtest: pipe-C-HDMI-A-1
[405.060966] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.455s)
[405.070998] Starting dynamic subtest: pipe-D-HDMI-A-1
[422.037291] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.441s)
[422.038470] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SUCCESS (5.875s)
[430.259871] [099/133] (606s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[430.350190] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[430.350912] Starting dynamic subtest: pipe-A-HDMI-A-1
[430.358548] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[430.369522] Starting dynamic subtest: pipe-B-HDMI-A-1
[430.377037] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[430.387925] Starting dynamic subtest: pipe-C-HDMI-A-1
[430.395228] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[430.405724] Starting dynamic subtest: pipe-D-HDMI-A-1
[430.413246] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[430.414654] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[430.582988] [100/133] (606s left) kms_frontbuffer_tracking (fbc-1p-rte)
[430.673224] Starting subtest: fbc-1p-rte
[433.954073] Subtest fbc-1p-rte: SUCCESS (3.283s)
[434.155702] [101/133] (602s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[434.248480] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[434.249835] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[434.401355] [102/133] (602s left) kms_getfb (getfb2-handle-protection)
[434.487255] Starting subtest: getfb2-handle-protection
[434.502867] Subtest getfb2-handle-protection: SUCCESS (0.016s)
[434.630741] [103/133] (602s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[434.718009] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[434.718733] Starting dynamic subtest: pipe-A
[434.845558] Dynamic subtest pipe-A: SUCCESS (0.127s)
[434.864747] Starting dynamic subtest: pipe-B
[435.005494] Dynamic subtest pipe-B: SUCCESS (0.158s)
[435.024793] Starting dynamic subtest: pipe-C
[435.164474] Dynamic subtest pipe-C: SUCCESS (0.157s)
[435.183651] Starting dynamic subtest: pipe-D
[435.323555] Dynamic subtest pipe-D: SUCCESS (0.157s)
[435.326456] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (0.607s)
[435.531870] [104/133] (601s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[435.621951] Starting subtest: psr-rgb101010-draw-mmap-cpu
[435.623387] Subtest psr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[435.740717] [105/133] (601s left) core_getversion (basic)
[435.773641] Starting subtest: basic
[435.775043] Subtest basic: SUCCESS (0.000s)
[435.868080] [106/133] (601s left) i915_getparams_basic (basic-subslice-total)
[435.901666] Starting subtest: basic-subslice-total
[435.903004] Subtest basic-subslice-total: SUCCESS (0.000s)
[436.006452] [107/133] (601s left) kms_flip (wf_vblank-ts-check)
[436.091536] Starting subtest: wf_vblank-ts-check
[436.093060] Starting dynamic subtest: A-HDMI-A1
[444.202949] Dynamic subtest A-HDMI-A1: SUCCESS (8.109s)
[444.213718] Starting dynamic subtest: B-HDMI-A1
[452.296457] Dynamic subtest B-HDMI-A1: SUCCESS (8.075s)
[452.304937] Starting dynamic subtest: C-HDMI-A1
[460.378605] Dynamic subtest C-HDMI-A1: SUCCESS (8.078s)
[460.386792] Starting dynamic subtest: D-HDMI-A1
[468.439814] Dynamic subtest D-HDMI-A1: SUCCESS (8.074s)
[468.442153] Subtest wf_vblank-ts-check: SUCCESS (32.351s)
[468.610432] [108/133] (568s left) gem_softpin (evict-snoop)
[468.653634] Starting subtest: evict-snoop
[468.655025] Subtest evict-snoop: SKIP (0.000s)
[468.762170] [109/133] (568s left) kms_flip (dpms-vs-vblank-race)
[468.851427] Starting subtest: dpms-vs-vblank-race
[468.853070] Starting dynamic subtest: A-HDMI-A1
[471.909584] Dynamic subtest A-HDMI-A1: SUCCESS (3.055s)
[471.927653] Starting dynamic subtest: B-HDMI-A1
[474.970747] Dynamic subtest B-HDMI-A1: SUCCESS (3.059s)
[474.979482] Starting dynamic subtest: C-HDMI-A1
[478.002757] Dynamic subtest C-HDMI-A1: SUCCESS (3.030s)
[478.012858] Starting dynamic subtest: D-HDMI-A1
[481.037190] Dynamic subtest D-HDMI-A1: SUCCESS (3.033s)
[481.038558] Subtest dpms-vs-vblank-race: SUCCESS (12.188s)
[481.210660] [110/133] (556s left) sysfs_timeslice_duration (idempotent)
[481.253523] Starting subtest: idempotent
[481.254225] Starting dynamic subtest: vecs0
[481.254894] Dynamic subtest vecs0: SUCCESS (0.000s)
[481.263698] Starting dynamic subtest: vcs0
[481.264379] Dynamic subtest vcs0: SUCCESS (0.000s)
[481.272707] Starting dynamic subtest: bcs0
[481.273384] Dynamic subtest bcs0: SUCCESS (0.001s)
[481.281570] Starting dynamic subtest: rcs0
[481.282227] Dynamic subtest rcs0: SUCCESS (0.000s)
[481.290048] Starting dynamic subtest: vcs1
[481.290701] Dynamic subtest vcs1: SUCCESS (0.000s)
[481.291361] Subtest idempotent: SUCCESS (0.008s)
[481.354739] [111/133] (556s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[481.449445] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[481.450795] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[481.574564] [112/133] (556s left) gem_create (create-clear)
[481.613805] Starting subtest: create-clear
[481.617866] Starting dynamic subtest: smem0
[513.945406] Dynamic subtest smem0: SUCCESS (32.324s)
[513.946094] Subtest create-clear: SUCCESS (32.325s)
[514.151509] [113/133] (523s left) gen9_exec_parse (shadow-peek)
[514.188016] Subtest shadow-peek: SKIP (0.000s)
[514.252513] [114/133] (523s left) perf_pmu (all-busy-check-all)
[514.287336] Starting subtest: all-busy-check-all
[514.804630] Subtest all-busy-check-all: SUCCESS (0.516s)
[514.904447] [115/133] (522s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[514.995419] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[514.996816] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[515.116597] [116/133] (522s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[515.204641] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[515.206045] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[515.343279] [117/133] (522s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[515.432615] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[515.434009] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[515.571697] [118/133] (522s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[515.660289] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[515.661687] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[515.780888] [119/133] (522s left) kms_big_fb (linear-8bpp-rotate-270)
[515.874754] Starting subtest: linear-8bpp-rotate-270
[515.980494] Subtest linear-8bpp-rotate-270: SKIP (0.105s)
[516.121580] [120/133] (521s left) gem_exec_whisper (basic-sync)
[516.164749] Starting subtest: basic-sync
[518.745544] Subtest basic-sync: SUCCESS (2.580s)
[518.944902] [121/133] (519s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[519.036609] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[519.038012] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[519.157968] [122/133] (518s left) gem_exec_fence (syncobj-wait)
[519.478533] Starting subtest: syncobj-wait
[519.525004] Subtest syncobj-wait: SUCCESS (0.046s)
[519.895760] [123/133] (518s left) kms_cursor_crc (cursor-onscreen-128x42)
[519.986319] Starting subtest: cursor-onscreen-128x42
[519.990691] Starting dynamic subtest: pipe-A-HDMI-A-1
[521.615734] Dynamic subtest pipe-A-HDMI-A-1: FAIL (1.458s)
[521.624652] Starting dynamic subtest: pipe-D-HDMI-A-1
[524.057176] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.575s)
[524.057873] Subtest cursor-onscreen-128x42: FAIL (4.071s)
[524.231910] [124/133] (513s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[524.324529] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[524.325903] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[524.440680] [125/133] (513s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[524.528158] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[524.575721] [126/133] (513s left) gem_tiling_max_stride
[524.760504] [127/133] (513s left) gem_ctx_persistence (hostile)
[524.797439] Starting subtest: hostile
[535.312850] Subtest hostile: SUCCESS (10.506s)
[535.439003] [128/133] (502s left) gem_mmap_offset (open-flood)
[535.472018] Starting subtest: open-flood
[556.971446] Subtest open-flood: SUCCESS (21.500s)
[557.116666] [129/133] (481s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[557.152039] Starting subtest: invalid-signal-one-illegal-handle
[557.152722] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[557.244986] [130/133] (481s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[557.283075] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[557.283755] Starting dynamic subtest: smem
[557.364060] Dynamic subtest smem: SUCCESS (0.080s)
[557.364798] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SUCCESS (0.081s)
[557.569647] [131/133] (480s left) kms_properties (plane-properties-legacy)
[557.657789] Starting subtest: plane-properties-legacy
[557.659504] Starting dynamic subtest: pipe-A-HDMI-A-1
[558.099440] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.440s)
[558.111710] Starting dynamic subtest: pipe-B-HDMI-A-1
[558.547570] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.446s)
[558.557577] Starting dynamic subtest: pipe-C-HDMI-A-1
[558.988607] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.440s)
[558.998380] Starting dynamic subtest: pipe-D-HDMI-A-1
[559.449912] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.459s)
[559.450598] Subtest plane-properties-legacy: SUCCESS (1.792s)
[559.611278] [132/133] (478s left) kms_pm_lpsp (kms-lpsp)
[560.703167] Starting subtest: kms-lpsp
[560.704489] Subtest kms-lpsp: SKIP (0.000s)
[560.800866] [133/133] (477s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[560.886487] Subtest psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[560.940019] Closing watchdogs
results: parsing output: 0/ for test: gem_tiled_pread_pwrite
results: parsing output: 1/ for test: gem_mmap_gtt
results: parsing output: 2/ for test: kms_debugfs
results: parsing output: 3/ for test: kms_flip
results: parsing output: 4/ for test: gem_ctx_param
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: syncobj_wait
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: kms_sequence
results: parsing output: 11/ for test: api_intel_bb
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: gen9_exec_parse
results: parsing output: 14/ for test: kms_chamelium_hpd
results: parsing output: 15/ for test: kms_cursor_edge_walk
results: parsing output: 16/ for test: gem_exec_nop
results: parsing output: 17/ for test: kms_lease
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: gem_pxp
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: perf_pmu
results: parsing output: 24/ for test: kms_flip
results: parsing output: 25/ for test: kms_rotation_crc
results: parsing output: 26/ for test: kms_pm_rpm
results: parsing output: 27/ for test: syncobj_wait
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: gem_ctx_persistence
results: parsing output: 30/ for test: syncobj_wait
results: parsing output: 31/ for test: perf_pmu
results: parsing output: 32/ for test: gem_mmap_wc
results: parsing output: 33/ for test: gem_exec_schedule
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: kms_content_protection
results: parsing output: 36/ for test: gem_pxp
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: kms_invalid_mode
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_flip_scaled_crc
results: parsing output: 43/ for test: perf
results: parsing output: 44/ for test: gem_exec_schedule
results: parsing output: 45/ for test: gem_ctx_create
results: parsing output: 46/ for test: kms_plane
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_plane_scaling
results: parsing output: 49/ for test: kms_psr2_su
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: kms_vblank
results: parsing output: 53/ for test: sw_sync
results: parsing output: 54/ for test: perf
results: parsing output: 55/ for test: kms_flip_scaled_crc
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: kms_async_flips
results: parsing output: 58/ for test: gem_exec_balancer
results: parsing output: 59/ for test: kms_cursor_crc
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: prime_vgem
results: parsing output: 62/ for test: kms_fence_pin_leak
results: parsing output: 63/ for test: gem_exec_fence
results: parsing output: 64/ for test: kms_chamelium_frames
results: parsing output: 65/ for test: kms_atomic
results: parsing output: 66/ for test: gem_exec_capture
results: parsing output: 67/ for test: gem_workarounds
results: parsing output: 68/ for test: kms_atomic_interruptible
results: parsing output: 69/ for test: gem_wait
results: parsing output: 70/ for test: i915_power
results: parsing output: 71/ for test: gem_ctx_shared
results: parsing output: 72/ for test: gem_busy
results: parsing output: 73/ for test: perf
results: parsing output: 74/ for test: kms_draw_crc
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_plane_alpha_blend
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: i915_pm_rpm
results: parsing output: 79/ for test: gem_exec_store
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: gem_ctx_bad_destroy
results: parsing output: 82/ for test: api_intel_bb
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: gem_exec_fence
results: parsing output: 89/ for test: kms_color
results: parsing output: 90/ for test: gem_exec_reloc
results: parsing output: 91/ for test: gem_spin_batch
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: kms_plane_cursor
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_getfb
results: parsing output: 102/ for test: kms_plane_scaling
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: core_getversion
results: parsing output: 105/ for test: i915_getparams_basic
results: parsing output: 106/ for test: kms_flip
results: parsing output: 107/ for test: gem_softpin
results: parsing output: 108/ for test: kms_flip
results: parsing output: 109/ for test: sysfs_timeslice_duration
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_create
results: parsing output: 112/ for test: gen9_exec_parse
results: parsing output: 113/ for test: perf_pmu
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: gem_exec_whisper
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_exec_fence
results: parsing output: 122/ for test: kms_cursor_crc
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_psr2_sf
results: parsing output: 125/ for test: gem_tiling_max_stride
results: parsing output: 126/ for test: gem_ctx_persistence
results: parsing output: 127/ for test: gem_mmap_offset
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: gem_render_copy
results: parsing output: 130/ for test: kms_properties
results: parsing output: 131/ for test: kms_pm_lpsp
results: parsing output: 132/ for test: kms_psr2_sf
Done.