[63.848998] Initializing watchdogs
[63.849110]   /dev/watchdog0
[63.868390] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[63.878744] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[63.883148] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.885572] [001/133] (960s left) kms_joiner (basic-ultra-joiner)
[64.068311] Starting subtest: basic-ultra-joiner
[64.070029] Subtest basic-ultra-joiner: SKIP (0.000s)
[64.218762] [002/133] (960s left) i915_query (test-query-geometry-subslices)
[64.288806] Starting subtest: test-query-geometry-subslices
[64.289638] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[64.472878] [003/133] (960s left) core_getclient (basic)
[64.537996] Starting subtest: basic
[64.539025] Subtest basic: SUCCESS (0.000s)
[64.672533] [004/133] (959s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[64.850363] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[64.852055] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[65.029503] [005/133] (959s left) vgem_basic (bad-handle)
[65.123110] Starting subtest: bad-handle
[65.124020] Subtest bad-handle: SUCCESS (0.000s)
[65.255910] [FACT vgem_basic (bad-handle)] new: kernel.kmod_is_loaded.vgem: true
[65.257939] [006/133] (959s left) kms_pm_lpsp (screens-disabled)
[66.455980] Starting subtest: screens-disabled
[66.457755] Subtest screens-disabled: SKIP (0.000s)
[66.593469] [007/133] (958s left) kms_dsc (dsc-with-output-formats)
[66.818570] Starting subtest: dsc-with-output-formats
[66.827164] Subtest dsc-with-output-formats: SKIP (0.001s)
[66.947495] [008/133] (957s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[67.461191] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[67.463178] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[67.772695] [009/133] (957s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[67.894611] Starting subtest: multi-wait-all-for-submit-available-signaled
[67.895546] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.001s)
[68.157972] [010/133] (956s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[68.341858] Starting subtest: basic-modeset-with-all-modifiers-formats
[68.585099] Starting dynamic subtest: pipe-A-DP-3-4-RGB565
[68.873229] Dynamic subtest pipe-A-DP-3-4-RGB565: SUCCESS (0.287s)
[68.903992] Starting dynamic subtest: pipe-A-DP-3-4-XRGB8888
[68.905313] Dynamic subtest pipe-A-DP-3-4-XRGB8888: SUCCESS (0.030s)
[68.920066] Starting dynamic subtest: pipe-A-DP-3-4-XRGB2101010
[68.936520] Dynamic subtest pipe-A-DP-3-4-XRGB2101010: SUCCESS (0.033s)
[68.946387] Starting dynamic subtest: pipe-A-DP-3-4-XRGB16161616F
[68.969660] Dynamic subtest pipe-A-DP-3-4-XRGB16161616F: SUCCESS (0.033s)
[68.979171] Starting dynamic subtest: pipe-A-DP-3-4-YUYV
[69.003073] Dynamic subtest pipe-A-DP-3-4-YUYV: SUCCESS (0.033s)
[69.014559] Starting dynamic subtest: pipe-A-DP-3-4-Y210
[69.036627] Dynamic subtest pipe-A-DP-3-4-Y210: SUCCESS (0.033s)
[69.053503] Starting dynamic subtest: pipe-A-DP-3-4-XYUV8888
[69.070198] Dynamic subtest pipe-A-DP-3-4-XYUV8888: SUCCESS (0.033s)
[69.094298] Starting dynamic subtest: pipe-A-DP-3-4-XV30
[69.103408] Dynamic subtest pipe-A-DP-3-4-XV30: SUCCESS (0.033s)
[69.120692] Starting dynamic subtest: pipe-A-DP-3-4-XV36
[69.136557] Dynamic subtest pipe-A-DP-3-4-XV36: SUCCESS (0.033s)
[69.152736] Starting dynamic subtest: pipe-A-DP-3-x-RGB565
[69.336397] Dynamic subtest pipe-A-DP-3-x-RGB565: SUCCESS (0.200s)
[69.344472] Starting dynamic subtest: pipe-A-DP-3-x-XRGB8888
[69.369662] Dynamic subtest pipe-A-DP-3-x-XRGB8888: SUCCESS (0.033s)
[69.381182] Starting dynamic subtest: pipe-A-DP-3-x-XRGB2101010
[69.403279] Dynamic subtest pipe-A-DP-3-x-XRGB2101010: SUCCESS (0.033s)
[69.421191] Starting dynamic subtest: pipe-A-DP-3-x-XRGB16161616F
[69.436633] Dynamic subtest pipe-A-DP-3-x-XRGB16161616F: SUCCESS (0.033s)
[69.455035] Starting dynamic subtest: pipe-A-DP-3-x-YUYV
[69.470097] Dynamic subtest pipe-A-DP-3-x-YUYV: SUCCESS (0.033s)
[69.487101] Starting dynamic subtest: pipe-A-DP-3-x-Y210
[69.503126] Dynamic subtest pipe-A-DP-3-x-Y210: SUCCESS (0.033s)
[69.514227] Starting dynamic subtest: pipe-A-DP-3-x-XYUV8888
[69.536707] Dynamic subtest pipe-A-DP-3-x-XYUV8888: SUCCESS (0.033s)
[69.550570] Starting dynamic subtest: pipe-A-DP-3-x-XV30
[69.569940] Dynamic subtest pipe-A-DP-3-x-XV30: SUCCESS (0.033s)
[69.584848] Starting dynamic subtest: pipe-A-DP-3-x-XV36
[69.603398] Dynamic subtest pipe-A-DP-3-x-XV36: SUCCESS (0.033s)
[69.614784] Starting dynamic subtest: pipe-A-DP-3-linear-RGB565
[69.787694] Dynamic subtest pipe-A-DP-3-linear-RGB565: SUCCESS (0.184s)
[69.795660] Starting dynamic subtest: pipe-A-DP-3-linear-XRGB8888
[69.821765] Dynamic subtest pipe-A-DP-3-linear-XRGB8888: SUCCESS (0.034s)
[69.831704] Starting dynamic subtest: pipe-A-DP-3-linear-XRGB2101010
[69.855363] Dynamic subtest pipe-A-DP-3-linear-XRGB2101010: SUCCESS (0.033s)
[69.865647] Starting dynamic subtest: pipe-A-DP-3-linear-XRGB16161616F
[69.888326] Dynamic subtest pipe-A-DP-3-linear-XRGB16161616F: SUCCESS (0.033s)
[69.896502] Starting dynamic subtest: pipe-A-DP-3-linear-YUYV
[69.921780] Dynamic subtest pipe-A-DP-3-linear-YUYV: SUCCESS (0.033s)
[69.929811] Starting dynamic subtest: pipe-A-DP-3-linear-Y210
[69.955099] Dynamic subtest pipe-A-DP-3-linear-Y210: SUCCESS (0.033s)
[69.964808] Starting dynamic subtest: pipe-A-DP-3-linear-XYUV8888
[69.988540] Dynamic subtest pipe-A-DP-3-linear-XYUV8888: SUCCESS (0.033s)
[69.999192] Starting dynamic subtest: pipe-A-DP-3-linear-XV30
[70.022038] Dynamic subtest pipe-A-DP-3-linear-XV30: SUCCESS (0.033s)
[70.035025] Starting dynamic subtest: pipe-A-DP-3-linear-XV36
[70.055237] Dynamic subtest pipe-A-DP-3-linear-XV36: SUCCESS (0.033s)
[70.331566] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (1.990s)
[70.643074] [011/133] (954s left) gem_softpin (evict-active)
[70.732590] Starting subtest: evict-active
[70.751274] Subtest evict-active: SUCCESS (0.019s)
[70.958431] [012/133] (954s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[71.146525] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[71.147444] Starting dynamic subtest: pipe-A-DP-3
[71.155786] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[71.163743] Starting dynamic subtest: pipe-B-DP-3
[71.171962] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[71.179865] Starting dynamic subtest: pipe-C-DP-3
[71.187977] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[71.195748] Starting dynamic subtest: pipe-D-DP-3
[71.204906] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[71.207130] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SKIP (0.006s)
[71.645240] [013/133] (953s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[71.832578] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[71.834265] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[72.025910] [014/133] (953s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[72.225209] Starting subtest: 4-tiled-8bpp-rotate-270
[72.279908] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.054s)
[72.490527] [015/133] (952s left) kms_psr (fbc-psr2-cursor-plane-move)
[72.679570] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[72.735130] [016/133] (952s left) i915_query (query-topology-kernel-writes)
[72.812638] Starting subtest: query-topology-kernel-writes
[72.813476] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[73.007738] [017/133] (952s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[73.193095] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[73.193948] Starting dynamic subtest: pipe-A-DP-3
[73.203021] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[73.211083] Starting dynamic subtest: pipe-B-DP-3
[73.219947] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[73.228496] Starting dynamic subtest: pipe-C-DP-3
[73.237120] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[73.244762] Starting dynamic subtest: pipe-D-DP-3
[73.255306] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[73.257334] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SKIP (0.004s)
[73.649730] [018/133] (951s left) gem_exec_nop (basic-parallel)
[73.743927] Starting subtest: basic-parallel
[78.146756] Subtest basic-parallel: SUCCESS (4.403s)
[78.443508] [019/133] (947s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[78.627621] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[78.629321] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[78.753793] [020/133] (946s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[78.828960] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[78.935952] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.104s)
[79.114055] [021/133] (946s left) gem_pread (self)
[79.188999] Subtest self: SKIP (0.000s)
[79.262045] [022/133] (946s left) kms_flip (2x-nonexisting-fb-interruptible)
[79.453780] Starting subtest: 2x-nonexisting-fb-interruptible
[79.471239] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.017s)
[79.607684] [023/133] (946s left) kms_cursor_crc (cursor-onscreen-32x32)
[79.885207] Starting subtest: cursor-onscreen-32x32
[79.936450] Subtest cursor-onscreen-32x32: SKIP (0.050s)
[80.415664] [024/133] (945s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[80.609448] Starting subtest: y-tiled-8bpp-rotate-0
[80.611204] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[80.774549] [025/133] (945s left) gem_exec_schedule (fifo)
[80.873917] Starting subtest: fifo
[80.874810] Starting dynamic subtest: rcs0
[81.153322] Dynamic subtest rcs0: SUCCESS (0.280s)
[81.161573] Starting dynamic subtest: bcs0
[81.356689] Dynamic subtest bcs0: SUCCESS (0.203s)
[81.364879] Starting dynamic subtest: vcs0
[81.560771] Dynamic subtest vcs0: SUCCESS (0.204s)
[81.569155] Starting dynamic subtest: vcs1
[81.770420] Dynamic subtest vcs1: SUCCESS (0.209s)
[81.778521] Starting dynamic subtest: vecs0
[81.976230] Dynamic subtest vecs0: SUCCESS (0.205s)
[81.984412] Starting dynamic subtest: vecs1
[82.181390] Dynamic subtest vecs1: SUCCESS (0.205s)
[82.189581] Starting dynamic subtest: ccs0
[82.390130] Dynamic subtest ccs0: SUCCESS (0.208s)
[82.390999] Subtest fifo: SUCCESS (1.517s)
[82.920484] [026/133] (943s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[83.108574] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[83.110214] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[83.304165] [027/133] (942s left) api_intel_allocator (reserve-simple)
[83.382987] Starting subtest: reserve-simple
[83.410424] Subtest reserve-simple: SUCCESS (0.028s)
[83.599943] [028/133] (942s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[83.786753] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[83.846294] [029/133] (942s left) gem_userptr_blits (create-destroy-unsync)
[83.931212] Subtest create-destroy-unsync: SKIP (0.000s)
[84.137461] [030/133] (942s left) syncobj_timeline (etime-multi-wait-submitted)
[84.219086] Starting subtest: etime-multi-wait-submitted
[84.326654] Subtest etime-multi-wait-submitted: SUCCESS (0.106s)
[84.503705] [031/133] (942s left) kms_color (invalid-gamma-lut-sizes)
[84.690909] Starting subtest: invalid-gamma-lut-sizes
[84.691821] Starting dynamic subtest: pipe-A
[84.765283] Dynamic subtest pipe-A: SUCCESS (0.074s)
[84.774659] Starting dynamic subtest: pipe-B
[84.775528] Dynamic subtest pipe-B: SUCCESS (0.001s)
[84.784523] Starting dynamic subtest: pipe-C
[84.785396] Dynamic subtest pipe-C: SUCCESS (0.001s)
[84.793427] Starting dynamic subtest: pipe-D
[84.794297] Dynamic subtest pipe-D: SUCCESS (0.000s)
[84.795206] Subtest invalid-gamma-lut-sizes: SUCCESS (0.076s)
[85.003785] [032/133] (941s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[85.185971] Starting subtest: cursor-vs-flip-toggle
[118.028495] Subtest cursor-vs-flip-toggle: SUCCESS (32.838s)
[118.334531] [033/133] (908s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[118.525162] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[118.526884] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[118.716993] [034/133] (908s left) kms_content_protection (mei-interface)
[118.968119] Starting subtest: mei-interface
[118.974236] Subtest mei-interface: SKIP (0.004s)
[119.183241] [035/133] (907s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[119.365178] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[119.366108] Starting dynamic subtest: pipe-A-DP-3
[119.374397] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[119.382489] Starting dynamic subtest: pipe-B-DP-3
[119.391157] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[119.399761] Starting dynamic subtest: pipe-C-DP-3
[119.407993] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[119.415867] Starting dynamic subtest: pipe-D-DP-3
[119.425385] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[119.427383] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s)
[119.846991] [036/133] (907s left) gem_busy (parallel)
[120.079504] Starting subtest: parallel
[120.080458] Starting dynamic subtest: rcs0
[120.184276] Dynamic subtest rcs0: SUCCESS (0.105s)
[120.195256] Starting dynamic subtest: bcs0
[120.247647] Dynamic subtest bcs0: SUCCESS (0.063s)
[120.267326] Starting dynamic subtest: vcs0
[120.327985] Dynamic subtest vcs0: SUCCESS (0.080s)
[120.342314] Starting dynamic subtest: vcs1
[120.400473] Dynamic subtest vcs1: SUCCESS (0.072s)
[120.409107] Starting dynamic subtest: vecs0
[120.457789] Dynamic subtest vecs0: SUCCESS (0.057s)
[120.470805] Starting dynamic subtest: vecs1
[120.529588] Dynamic subtest vecs1: SUCCESS (0.071s)
[120.543561] Starting dynamic subtest: ccs0
[120.597020] Dynamic subtest ccs0: SUCCESS (0.067s)
[120.598187] Subtest parallel: SUCCESS (0.518s)
[120.913736] [037/133] (906s left) gen3_render_linear_blits
[121.058693] [038/133] (905s left) perf_pmu (all-busy-idle-check-all)
[121.128582] Starting subtest: all-busy-idle-check-all
[121.818837] Subtest all-busy-idle-check-all: SUCCESS (0.690s)
[122.013939] [039/133] (905s left) kms_plane_lowres (tiling-yf)
[122.195285] Starting subtest: tiling-yf
[122.197057] Subtest tiling-yf: SKIP (0.000s)
[122.317330] [040/133] (904s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[122.505048] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[122.506793] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.000s)
[122.671574] [041/133] (904s left) gem_exec_balancer (invalid-balancer)
[122.761576] Starting subtest: invalid-balancer
[124.249552] Subtest invalid-balancer: SUCCESS (1.487s)
[124.648103] [042/133] (902s left) gem_ctx_param (root-set)
[124.722440] Starting subtest: root-set
[124.724275] Subtest root-set: SUCCESS (0.001s)
[124.911102] [043/133] (902s left) kms_dirtyfb (default-dirtyfb-ioctl)
[125.105917] Starting subtest: default-dirtyfb-ioctl
[125.106875] Starting dynamic subtest: A-DP-3
[126.577286] Dynamic subtest A-DP-3: SUCCESS (1.470s)
[126.578467] Subtest default-dirtyfb-ioctl: SUCCESS (1.471s)
[126.849006] [044/133] (900s left) kms_flip_event_leak (basic)
[127.031530] Starting subtest: basic
[127.032413] Starting dynamic subtest: pipe-A-DP-3
[127.376650] Dynamic subtest pipe-A-DP-3: SUCCESS (0.344s)
[127.400630] Starting dynamic subtest: pipe-B-DP-3
[127.681532] Dynamic subtest pipe-B-DP-3: SUCCESS (0.297s)
[127.696322] Starting dynamic subtest: pipe-C-DP-3
[127.959793] Dynamic subtest pipe-C-DP-3: SUCCESS (0.280s)
[127.973205] Starting dynamic subtest: pipe-D-DP-3
[128.260989] Dynamic subtest pipe-D-DP-3: SUCCESS (0.299s)
[128.262155] Subtest basic: SUCCESS (1.229s)
[128.548513] [045/133] (898s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[128.743826] Starting subtest: yf-tiled-32bpp-rotate-0
[128.745481] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[128.966217] [046/133] (898s left) kms_big_fb (linear-32bpp-rotate-90)
[129.167565] Starting subtest: linear-32bpp-rotate-90
[129.218382] Subtest linear-32bpp-rotate-90: SKIP (0.050s)
[129.465319] [047/133] (898s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[129.657968] Starting subtest: cursorA-vs-flipA-varying-size
[140.616558] Subtest cursorA-vs-flipA-varying-size: SUCCESS (10.958s)
[140.950128] [048/133] (886s left) i915_pm_freq_api (freq-reset-multiple)
[141.034434] Starting subtest: freq-reset-multiple
[141.035360] Starting dynamic subtest: gt0
[161.704997] Dynamic subtest gt0: SUCCESS (20.668s)
[161.705959] Subtest freq-reset-multiple: SUCCESS (20.669s)
[161.820437] [049/133] (866s left) syncobj_wait (reset-signaled)
[161.895170] Starting subtest: reset-signaled
[161.896134] Subtest reset-signaled: SUCCESS (0.000s)
[162.083090] [050/133] (865s left) gem_exec_schedule (u-semaphore-resolve)
[162.175370] Starting subtest: u-semaphore-resolve
[162.259597] Subtest u-semaphore-resolve: SUCCESS (0.084s)
[162.715736] [051/133] (865s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[162.796475] Starting subtest: y-tiled-ccs-to-y-tiled
[162.798459] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[163.081985] [052/133] (865s left) gem_ctx_shared (detached-shared-gtt)
[163.170509] Starting subtest: detached-shared-gtt
[165.321962] Subtest detached-shared-gtt: SUCCESS (2.151s)
[167.756721] [053/133] (860s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[167.948500] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[167.950172] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[168.125170] [054/133] (860s left) perf_pmu (busy-accuracy-2)
[168.195353] Starting subtest: busy-accuracy-2
[168.196281] Starting dynamic subtest: rcs0
[171.258124] Dynamic subtest rcs0: SUCCESS (3.062s)
[171.268272] Starting dynamic subtest: bcs0
[174.320237] Dynamic subtest bcs0: SUCCESS (3.061s)
[174.330396] Starting dynamic subtest: vcs0
[177.381895] Dynamic subtest vcs0: SUCCESS (3.061s)
[177.392166] Starting dynamic subtest: vcs1
[180.449583] Dynamic subtest vcs1: SUCCESS (3.067s)
[180.459683] Starting dynamic subtest: vecs0
[183.517445] Dynamic subtest vecs0: SUCCESS (3.067s)
[183.527561] Starting dynamic subtest: vecs1
[186.583053] Dynamic subtest vecs1: SUCCESS (3.065s)
[186.593293] Starting dynamic subtest: ccs0
[189.648402] Dynamic subtest ccs0: SUCCESS (3.065s)
[189.649272] Subtest busy-accuracy-2: SUCCESS (21.452s)
[189.817762] [055/133] (838s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[189.896072] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[189.960415] [056/133] (838s left) kms_vblank (query-idle)
[190.146633] Starting subtest: query-idle
[190.148525] Starting dynamic subtest: pipe-A-DP-3
[192.462522] Dynamic subtest pipe-A-DP-3: SUCCESS (2.314s)
[192.477289] Starting dynamic subtest: pipe-D-DP-3
[194.705841] Dynamic subtest pipe-D-DP-3: SUCCESS (2.239s)
[194.706799] Subtest query-idle: SUCCESS (4.559s)
[194.955150] [057/133] (833s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[195.148009] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[195.149573] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[195.340902] [058/133] (833s left) gem_exec_whisper (basic-normal-all)
[195.427446] Starting subtest: basic-normal-all
[197.850919] Subtest basic-normal-all: SUCCESS (2.421s)
[198.145416] [059/133] (830s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[198.328766] Starting subtest: plane-upscale-20x20-with-rotation
[198.329527] Starting dynamic subtest: pipe-A
[198.716409] Dynamic subtest pipe-A: SUCCESS (0.387s)
[198.732982] Starting dynamic subtest: pipe-B
[199.195819] Dynamic subtest pipe-B: SUCCESS (0.478s)
[199.221901] Starting dynamic subtest: pipe-C
[199.675961] Dynamic subtest pipe-C: SUCCESS (0.479s)
[199.701860] Starting dynamic subtest: pipe-D
[200.155754] Dynamic subtest pipe-D: SUCCESS (0.478s)
[200.156977] Subtest plane-upscale-20x20-with-rotation: SUCCESS (1.828s)
[200.502816] [060/133] (828s left) gem_softpin (allocator-basic)
[200.583016] Starting subtest: allocator-basic
[200.814445] Subtest allocator-basic: SUCCESS (0.231s)
[201.023647] [061/133] (827s left) syncobj_basic (test-valid-cycle)
[201.099330] Starting subtest: test-valid-cycle
[201.100248] Subtest test-valid-cycle: SUCCESS (0.000s)
[201.249170] [062/133] (827s left) kms_rotation_crc (bad-pixel-format)
[201.432118] Starting subtest: bad-pixel-format
[201.433878] Subtest bad-pixel-format: SKIP (0.001s)
[201.547585] [063/133] (827s left) gem_mmap_offset (blt-coherency)
[201.628146] Starting subtest: blt-coherency
[201.665624] Subtest blt-coherency: SUCCESS (0.037s)
[201.899619] [064/133] (827s left) kms_pm_rpm (modeset-non-lpsp)
[204.011176] Starting subtest: modeset-non-lpsp
[204.655331] Subtest modeset-non-lpsp: SUCCESS (0.643s)
[204.919782] [065/133] (824s left) kms_lease (cursor-implicit-plane)
[205.102427] Starting subtest: cursor-implicit-plane
[205.104638] Starting dynamic subtest: pipe-A-DP-3
[205.478042] Dynamic subtest pipe-A-DP-3: SUCCESS (0.373s)
[205.498070] Starting dynamic subtest: pipe-B-DP-3
[205.819564] Dynamic subtest pipe-B-DP-3: SUCCESS (0.340s)
[205.834976] Starting dynamic subtest: pipe-C-DP-3
[206.121928] Dynamic subtest pipe-C-DP-3: SUCCESS (0.300s)
[206.136180] Starting dynamic subtest: pipe-D-DP-3
[206.437504] Dynamic subtest pipe-D-DP-3: SUCCESS (0.314s)
[206.438411] Subtest cursor-implicit-plane: SUCCESS (1.335s)
[206.774230] [066/133] (822s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[207.472936] Starting subtest: syncobj-timeline-invalid-wait
[207.475162] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.002s)
[207.836533] [067/133] (821s left) kms_cursor_crc (cursor-random-256x85)
[208.272103] Starting subtest: cursor-random-256x85
[208.276613] Starting dynamic subtest: pipe-A-DP-3
[212.853022] Dynamic subtest pipe-A-DP-3: SUCCESS (4.576s)
[212.898469] Starting dynamic subtest: pipe-D-DP-3
[217.380507] Dynamic subtest pipe-D-DP-3: SUCCESS (4.491s)
[217.381507] Subtest cursor-random-256x85: SUCCESS (9.108s)
[217.769826] [068/133] (811s left) kms_cursor_edge_walk (64x64-top-edge)
[217.956074] Starting subtest: 64x64-top-edge
[217.956958] Starting dynamic subtest: pipe-A-DP-3
[221.443247] Dynamic subtest pipe-A-DP-3: SUCCESS (3.486s)
[221.459016] Starting dynamic subtest: pipe-D-DP-3
[224.770806] Dynamic subtest pipe-D-DP-3: SUCCESS (3.325s)
[224.771677] Subtest 64x64-top-edge: SUCCESS (6.816s)
[225.099944] [069/133] (804s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[225.292779] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[228.116545] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.825s)
[228.348103] [070/133] (801s left) gem_exec_suspend (basic-s3)
[228.434485] Starting subtest: basic-S3
[228.435340] Starting dynamic subtest: smem
[251.132975] Dynamic subtest smem: SUCCESS (7.259s)
[251.145299] Starting dynamic subtest: lmem0
[273.400228] Dynamic subtest lmem0: SUCCESS (7.239s)
[273.401328] Subtest basic-S3: SUCCESS (14.500s)
[273.713852] [071/133] (755s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[273.909595] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[273.911322] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[274.099796] [072/133] (755s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[274.291913] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[277.032477] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (2.741s)
[277.281766] [073/133] (752s left) kms_plane_scaling (invalid-num-scalers)
[277.463700] Starting subtest: invalid-num-scalers
[277.470849] Starting dynamic subtest: pipe-A-DP-3-invalid-num-scalers
[277.492453] Dynamic subtest pipe-A-DP-3-invalid-num-scalers: SUCCESS (0.022s)
[277.510959] Starting dynamic subtest: pipe-B-DP-3-invalid-num-scalers
[277.538029] Dynamic subtest pipe-B-DP-3-invalid-num-scalers: SUCCESS (0.037s)
[277.555837] Starting dynamic subtest: pipe-C-DP-3-invalid-num-scalers
[277.583258] Dynamic subtest pipe-C-DP-3-invalid-num-scalers: SUCCESS (0.037s)
[277.600593] Starting dynamic subtest: pipe-D-DP-3-invalid-num-scalers
[277.627228] Dynamic subtest pipe-D-DP-3-invalid-num-scalers: SUCCESS (0.037s)
[277.627999] Subtest invalid-num-scalers: SUCCESS (0.164s)
[277.817120] [074/133] (752s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[278.002414] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[278.003295] Starting dynamic subtest: pipe-A-DP-3
[278.012318] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[278.024522] Starting dynamic subtest: pipe-B-DP-3
[278.033700] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[278.045552] Starting dynamic subtest: pipe-C-DP-3
[278.054329] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[278.066201] Starting dynamic subtest: pipe-D-DP-3
[278.076847] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[278.078770] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[278.492938] [075/133] (751s left) kms_psr (psr2-suspend)
[278.671276] Subtest psr2-suspend: SKIP (0.000s)
[278.739387] [076/133] (751s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[278.929778] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.000s)
[278.989227] [077/133] (751s left) gem_render_copy (x-tiled)
[279.072516] Starting subtest: x-tiled
[279.073426] Starting dynamic subtest: smem
[279.180343] Dynamic subtest smem: SUCCESS (0.107s)
[279.192430] Starting dynamic subtest: lmem0
[280.667550] Dynamic subtest lmem0: SUCCESS (1.487s)
[280.668676] Subtest x-tiled: SUCCESS (1.595s)
[280.941800] [078/133] (749s left) kms_getfb (getfb2-handle-protection)
[281.142334] Starting subtest: getfb2-handle-protection
[281.158500] Subtest getfb2-handle-protection: SUCCESS (0.016s)
[281.339334] [079/133] (748s left) gem_madvise (dontneed-before-pwrite)
[281.384340] Starting subtest: dontneed-before-pwrite
[281.422337] Subtest dontneed-before-pwrite: SKIP (0.037s)
[281.488192] [080/133] (748s left) kms_psr (pr-cursor-plane-onoff)
[281.674227] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[281.738838] [081/133] (748s left) gem_ctx_param (invalid-get-no-zeromap)
[281.816746] Starting subtest: invalid-get-no-zeromap
[281.818991] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[282.008547] [082/133] (748s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[282.087567] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[282.089472] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[282.315872] [083/133] (748s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier)
[282.500035] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier
[282.526552] Starting dynamic subtest: pipe-A-plane-0
[282.528336] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[282.540722] Starting dynamic subtest: pipe-A-plane-3
[282.542534] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[282.554461] Starting dynamic subtest: pipe-A-plane-5
[282.556219] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[282.763202] Starting dynamic subtest: pipe-B-plane-0
[282.765370] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[282.786253] Starting dynamic subtest: pipe-B-plane-3
[282.788212] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[282.801515] Starting dynamic subtest: pipe-B-plane-5
[282.803280] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[282.832557] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier: SKIP (0.331s)
[283.114094] [084/133] (747s left) gem_exec_schedule (independent)
[283.202084] Starting subtest: independent
[283.202986] Starting dynamic subtest: rcs0
[283.655976] Dynamic subtest rcs0: SUCCESS (0.453s)
[283.702628] Starting dynamic subtest: bcs0
[284.068452] Dynamic subtest bcs0: SUCCESS (0.410s)
[284.084256] Starting dynamic subtest: vcs0
[284.459456] Dynamic subtest vcs0: SUCCESS (0.390s)
[284.476684] Starting dynamic subtest: vcs1
[284.852415] Dynamic subtest vcs1: SUCCESS (0.392s)
[284.867620] Starting dynamic subtest: vecs0
[285.234461] Dynamic subtest vecs0: SUCCESS (0.381s)
[285.248529] Starting dynamic subtest: vecs1
[285.641052] Dynamic subtest vecs1: SUCCESS (0.405s)
[285.660938] Starting dynamic subtest: ccs0
[285.989367] Dynamic subtest ccs0: SUCCESS (0.346s)
[285.990243] Subtest independent: SUCCESS (2.788s)
[286.473119] [085/133] (744s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[286.663047] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[286.664700] Subtest fbcpsr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[286.899218] [086/133] (743s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[289.502756] Starting subtest: verify-pxp-key-change-after-suspend-resume
[289.505025] Subtest verify-pxp-key-change-after-suspend-resume: SKIP (0.000s)
[289.653923] [087/133] (741s left) kms_rotation_crc (bad-tiling)
[289.839319] Starting subtest: bad-tiling
[289.841100] Subtest bad-tiling: SKIP (0.001s)
[290.015612] [088/133] (740s left) syncobj_wait (single-wait-all-for-submit-submitted)
[290.091588] Starting subtest: single-wait-all-for-submit-submitted
[290.195275] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.103s)
[290.385422] [089/133] (740s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[290.569268] Starting subtest: read-crc-frame-sequence
[290.570160] Starting dynamic subtest: pipe-A-DP-3
[291.246714] Dynamic subtest pipe-A-DP-3: SUCCESS (0.677s)
[291.265184] Starting dynamic subtest: pipe-B-DP-3
[291.825074] Dynamic subtest pipe-B-DP-3: SUCCESS (0.576s)
[291.846616] Starting dynamic subtest: pipe-C-DP-3
[292.392479] Dynamic subtest pipe-C-DP-3: SUCCESS (0.564s)
[292.417681] Starting dynamic subtest: pipe-D-DP-3
[292.935062] Dynamic subtest pipe-D-DP-3: SUCCESS (0.539s)
[292.936143] Subtest read-crc-frame-sequence: SUCCESS (2.367s)
[293.275310] [090/133] (737s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[293.461505] Starting subtest: basic-flip-after-cursor-legacy
[294.516012] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.055s)
[294.852673] [091/133] (736s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[294.929447] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[294.930410] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[295.070886] [092/133] (736s left) gen7_exec_parse (basic-rejected)
[295.151534] Subtest basic-rejected: SKIP (0.000s)
[295.229945] [093/133] (735s left) syncobj_wait (wait-all-for-submit-snapshot)
[295.306566] Starting subtest: wait-all-for-submit-snapshot
[295.389916] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[295.570539] [094/133] (735s left) perf_pmu (rc6-suspend)
[295.638667] Starting subtest: rc6-suspend
[320.583019] Subtest rc6-suspend: SUCCESS (10.015s)
[321.237309] [095/133] (710s left) syncobj_wait (wait-all-interrupted)
[321.319080] Starting subtest: wait-all-interrupted
[321.421326] Subtest wait-all-interrupted: SUCCESS (0.101s)
[321.595746] [096/133] (709s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[321.785752] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[321.801257] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.015s)
[321.965116] [097/133] (709s left) prime_busy (hang)
[322.050966] Starting subtest: hang
[322.053228] Starting dynamic subtest: rcs0
[347.903667] Dynamic subtest rcs0: SUCCESS (25.849s)
[347.915958] Starting dynamic subtest: bcs0
[354.997934] Dynamic subtest bcs0: SUCCESS (7.093s)
[355.010246] Starting dynamic subtest: vcs0
[362.040394] Dynamic subtest vcs0: SUCCESS (7.041s)
[362.052846] Starting dynamic subtest: vcs1
[369.011953] Dynamic subtest vcs1: SUCCESS (6.970s)
[369.024627] Starting dynamic subtest: vecs0
[375.987958] Dynamic subtest vecs0: SUCCESS (6.977s)
[376.000472] Starting dynamic subtest: vecs1
[383.021997] Dynamic subtest vecs1: SUCCESS (7.033s)
[383.034474] Starting dynamic subtest: ccs0
[396.863576] Dynamic subtest ccs0: SUCCESS (13.840s)
[396.864475] Subtest hang: SUCCESS (74.813s)
[397.025896] [098/133] (634s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[397.212984] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[397.214737] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[397.418279] [099/133] (634s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[397.613044] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[397.614740] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[397.810768] [100/133] (633s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[397.996779] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[397.998411] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[398.210058] [101/133] (633s left) gem_softpin (evict-active-interruptible)
[398.296283] Starting subtest: evict-active-interruptible
[398.312505] Subtest evict-active-interruptible: SUCCESS (0.016s)
[398.524767] [102/133] (633s left) gem_softpin (noreloc)
[398.619691] Starting subtest: noreloc
[404.046689] Subtest noreloc: SUCCESS (5.427s)
[404.210834] [103/133] (627s left) kms_universal_plane (cursor-fb-leak)
[404.401074] Starting subtest: cursor-fb-leak
[404.401998] Starting dynamic subtest: pipe-A-DP-3
[404.931020] Dynamic subtest pipe-A-DP-3: SUCCESS (0.529s)
[404.953339] Starting dynamic subtest: pipe-B-DP-3
[405.556757] Dynamic subtest pipe-B-DP-3: SUCCESS (0.618s)
[405.599009] Starting dynamic subtest: pipe-C-DP-3
[406.208081] Dynamic subtest pipe-C-DP-3: SUCCESS (0.644s)
[406.250376] Starting dynamic subtest: pipe-D-DP-3
[406.861056] Dynamic subtest pipe-D-DP-3: SUCCESS (0.645s)
[406.866383] Subtest cursor-fb-leak: SUCCESS (2.462s)
[407.270833] [104/133] (624s left) syncobj_timeline (single-wait-all-available-submitted)
[407.349051] Starting subtest: single-wait-all-available-submitted
[407.350036] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[407.490759] [105/133] (624s left) gem_exec_flush (basic-uc-pro-default)
[407.578905] Subtest basic-uc-pro-default: SKIP (0.000s)
[407.668612] [106/133] (624s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[407.855082] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[407.855934] Starting dynamic subtest: pipe-A-DP-3
[407.863989] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[407.876466] Starting dynamic subtest: pipe-B-DP-3
[407.884946] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[407.897243] Starting dynamic subtest: pipe-C-DP-3
[407.905363] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[407.917635] Starting dynamic subtest: pipe-D-DP-3
[407.928276] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[407.930336] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.007s)
[408.342148] [107/133] (623s left) i915_drm_fdinfo (virtual-busy-all)
[408.411755] Starting subtest: virtual-busy-all
[408.413621] Subtest virtual-busy-all: SKIP (0.000s)
[408.529842] [108/133] (623s left) gem_exec_params (invalid-ring)
[408.611516] Starting subtest: invalid-ring
[408.612388] Subtest invalid-ring: SUCCESS (0.000s)
[408.791424] [109/133] (623s left) gem_ctx_persistence (legacy-engines-mixed-process)
[408.876100] Starting subtest: legacy-engines-mixed-process
[408.877086] Starting dynamic subtest: render
[410.332870] Dynamic subtest render: SUCCESS (1.456s)
[410.347720] Starting dynamic subtest: bsd1
[412.309512] Dynamic subtest bsd1: SUCCESS (1.975s)
[412.324362] Starting dynamic subtest: bsd2
[414.291386] Dynamic subtest bsd2: SUCCESS (1.980s)
[414.306707] Starting dynamic subtest: blt
[416.265447] Dynamic subtest blt: SUCCESS (1.972s)
[416.279710] Starting dynamic subtest: vebox
[418.265341] Dynamic subtest vebox: SUCCESS (1.998s)
[418.266429] Subtest legacy-engines-mixed-process: SUCCESS (9.390s)
[418.444667] [110/133] (614s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[418.753253] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[418.924776] [111/133] (613s left) kms_atomic (plane-immutable-zpos)
[419.108191] Starting subtest: plane-immutable-zpos
[419.109078] Starting dynamic subtest: pipe-A-DP-3
[420.058065] Dynamic subtest pipe-A-DP-3: SUCCESS (0.948s)
[420.058948] Subtest plane-immutable-zpos: SUCCESS (0.950s)
[420.373691] [112/133] (612s left) drm_read (empty-nonblock)
[420.643118] Starting subtest: empty-nonblock
[420.644036] Subtest empty-nonblock: SUCCESS (0.000s)
[420.909285] [113/133] (611s left) gem_exec_whisper (basic-queues-priority)
[421.002390] Starting subtest: basic-queues-priority
[443.514051] Subtest basic-queues-priority: SUCCESS (22.509s)
[443.768061] [114/133] (589s left) kms_psr (psr-sprite-mmap-cpu)
[443.963289] Subtest psr-sprite-mmap-cpu: SKIP (0.000s)
[444.022525] [115/133] (588s left) kms_busy (extended-pageflip-hang-newfb)
[444.217095] Starting subtest: extended-pageflip-hang-newfb
[444.217988] Starting dynamic subtest: pipe-A
[452.087760] Dynamic subtest pipe-A: SUCCESS (7.868s)
[452.104594] Starting dynamic subtest: pipe-D
[460.006058] Dynamic subtest pipe-D: SUCCESS (7.912s)
[460.007279] Subtest extended-pageflip-hang-newfb: SUCCESS (15.790s)
[460.322748] [116/133] (572s left) i915_pm_rpm (system-suspend-devices)
[462.430767] Starting subtest: system-suspend-devices
[470.227851] Subtest system-suspend-devices: SUCCESS (7.801s)
[470.666833] [117/133] (562s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[470.864241] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[472.184889] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.319s)
[472.436200] [118/133] (560s left) kms_psr (fbc-pr-cursor-blt)
[472.622102] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[472.680948] [119/133] (560s left) gem_fenced_exec_thrash (too-many-fences)
[472.763600] Subtest too-many-fences: SKIP (0.000s)
[472.845905] [120/133] (560s left) gem_exec_balancer (parallel-ordering)
[473.187064] Starting subtest: parallel-ordering
[474.827674] Subtest parallel-ordering: SUCCESS (1.640s)
[475.018085] [121/133] (558s left) gem_cs_tlb (engines)
[475.100682] Starting subtest: engines
[475.101601] Starting dynamic subtest: rcs0
[477.255916] Dynamic subtest rcs0: SUCCESS (2.154s)
[477.269338] Starting dynamic subtest: bcs0
[479.409376] Dynamic subtest bcs0: SUCCESS (2.152s)
[479.422609] Starting dynamic subtest: vcs0
[481.562364] Dynamic subtest vcs0: SUCCESS (2.152s)
[481.575254] Starting dynamic subtest: vcs1
[483.715365] Dynamic subtest vcs1: SUCCESS (2.152s)
[483.730354] Starting dynamic subtest: vecs0
[485.871097] Dynamic subtest vecs0: SUCCESS (2.154s)
[485.884168] Starting dynamic subtest: vecs1
[488.025066] Dynamic subtest vecs1: SUCCESS (2.153s)
[488.038210] Starting dynamic subtest: ccs0
[490.178352] Dynamic subtest ccs0: SUCCESS (2.152s)
[490.179224] Subtest engines: SUCCESS (15.077s)
[490.365608] [122/133] (542s left) drm_read (short-buffer-wakeup)
[490.620318] Starting subtest: short-buffer-wakeup
[522.832971] Subtest short-buffer-wakeup: SUCCESS (32.213s)
[523.077633] [123/133] (510s left) gem_mmap_gtt (basic-wc)
[523.153844] Subtest basic-wc: SKIP (0.000s)
[523.237738] [124/133] (510s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[523.429609] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[523.431208] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[523.631154] [125/133] (509s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[523.818735] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[523.820356] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[523.997555] [126/133] (509s left) syncobj_basic (bad-flags-handle-to-fd)
[524.078067] Starting subtest: bad-flags-handle-to-fd
[524.078985] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[524.216660] [127/133] (509s left) gem_exec_fence (basic-wait-all)
[524.303219] Starting subtest: basic-wait-all
[524.436193] Subtest basic-wait-all: SUCCESS (0.133s)
[525.382704] [128/133] (508s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[525.572344] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[525.633339] [129/133] (508s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[525.897385] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[526.047298] [130/133] (507s left) gem_render_linear_blits (basic)
[526.128437] Starting subtest: basic
[526.207985] Subtest basic: SUCCESS (0.079s)
[526.306059] [131/133] (507s left) gem_media_vme
[526.472661] [132/133] (507s left) gem_vm_create (invalid-create)
[526.555680] Starting subtest: invalid-create
[526.560528] Subtest invalid-create: SUCCESS (0.005s)
[526.706020] [133/133] (507s left) gem_exec_suspend (basic-s4-devices)
[526.792814] Starting subtest: basic-S4-devices
[526.793787] Starting dynamic subtest: smem
[537.409955] Dynamic subtest smem: SUCCESS (10.617s)
[537.425143] Starting dynamic subtest: lmem0
[548.046735] Dynamic subtest lmem0: SUCCESS (10.636s)
[548.047850] Subtest basic-S4-devices: SUCCESS (21.255s)
[557.338262] Closing watchdogs
results: parsing output: 0/ for test: kms_joiner
results: parsing output: 1/ for test: i915_query
results: parsing output: 2/ for test: core_getclient
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: vgem_basic
results: parsing output: 5/ for test: kms_pm_lpsp
results: parsing output: 6/ for test: kms_dsc
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: kms_async_flips
results: parsing output: 10/ for test: gem_softpin
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: i915_query
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: gem_exec_nop
results: parsing output: 18/ for test: kms_flip_scaled_crc
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: gem_pread
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: kms_cursor_crc
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: gem_exec_schedule
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: api_intel_allocator
results: parsing output: 27/ for test: kms_psr2_sf
results: parsing output: 28/ for test: gem_userptr_blits
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: kms_color
results: parsing output: 31/ for test: kms_cursor_legacy
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_content_protection
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: gem_busy
results: parsing output: 36/ for test: gen3_render_linear_blits
results: parsing output: 37/ for test: perf_pmu
results: parsing output: 38/ for test: kms_plane_lowres
results: parsing output: 39/ for test: kms_flip_scaled_crc
results: parsing output: 40/ for test: gem_exec_balancer
results: parsing output: 41/ for test: gem_ctx_param
results: parsing output: 42/ for test: kms_dirtyfb
results: parsing output: 43/ for test: kms_flip_event_leak
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_cursor_legacy
results: parsing output: 47/ for test: i915_pm_freq_api
results: parsing output: 48/ for test: syncobj_wait
results: parsing output: 49/ for test: gem_exec_schedule
results: parsing output: 50/ for test: gem_render_copy
results: parsing output: 51/ for test: gem_ctx_shared
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: perf_pmu
results: parsing output: 54/ for test: kms_pipe_b_c_ivb
results: parsing output: 55/ for test: kms_vblank
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_exec_whisper
results: parsing output: 58/ for test: kms_plane_scaling
results: parsing output: 59/ for test: gem_softpin
results: parsing output: 60/ for test: syncobj_basic
results: parsing output: 61/ for test: kms_rotation_crc
results: parsing output: 62/ for test: gem_mmap_offset
results: parsing output: 63/ for test: kms_pm_rpm
results: parsing output: 64/ for test: kms_lease
results: parsing output: 65/ for test: gem_exec_fence
results: parsing output: 66/ for test: kms_cursor_crc
results: parsing output: 67/ for test: kms_cursor_edge_walk
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_exec_suspend
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_plane_scaling
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: gem_render_copy
results: parsing output: 77/ for test: kms_getfb
results: parsing output: 78/ for test: gem_madvise
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: gem_ctx_param
results: parsing output: 81/ for test: gem_render_copy
results: parsing output: 82/ for test: kms_plane
results: parsing output: 83/ for test: gem_exec_schedule
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_pxp
results: parsing output: 86/ for test: kms_rotation_crc
results: parsing output: 87/ for test: syncobj_wait
results: parsing output: 88/ for test: kms_pipe_crc_basic
results: parsing output: 89/ for test: kms_cursor_legacy
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: gen7_exec_parse
results: parsing output: 92/ for test: syncobj_wait
results: parsing output: 93/ for test: perf_pmu
results: parsing output: 94/ for test: syncobj_wait
results: parsing output: 95/ for test: kms_flip
results: parsing output: 96/ for test: prime_busy
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_softpin
results: parsing output: 101/ for test: gem_softpin
results: parsing output: 102/ for test: kms_universal_plane
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: gem_exec_flush
results: parsing output: 105/ for test: kms_ccs
results: parsing output: 106/ for test: i915_drm_fdinfo
results: parsing output: 107/ for test: gem_exec_params
results: parsing output: 108/ for test: gem_ctx_persistence
results: parsing output: 109/ for test: kms_chamelium_edid
results: parsing output: 110/ for test: kms_atomic
results: parsing output: 111/ for test: drm_read
results: parsing output: 112/ for test: gem_exec_whisper
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: kms_busy
results: parsing output: 115/ for test: i915_pm_rpm
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: gem_fenced_exec_thrash
results: parsing output: 119/ for test: gem_exec_balancer
results: parsing output: 120/ for test: gem_cs_tlb
results: parsing output: 121/ for test: drm_read
results: parsing output: 122/ for test: gem_mmap_gtt
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: syncobj_basic
results: parsing output: 126/ for test: gem_exec_fence
results: parsing output: 127/ for test: kms_psr2_sf
results: parsing output: 128/ for test: kms_chamelium_hpd
results: parsing output: 129/ for test: gem_render_linear_blits
results: parsing output: 130/ for test: gem_media_vme
results: parsing output: 131/ for test: gem_vm_create
results: parsing output: 132/ for test: gem_exec_suspend
Done.