[57.939563] Initializing watchdogs
[57.939618]   /dev/watchdog0
[57.955290] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.959539] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.961813] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.965200] [001/156] (960s left) gem_exec_reloc (basic-range-active)
[58.049049] Subtest basic-range-active: SKIP (0.000s)
[58.119264] [002/156] (960s left) kms_vblank (ts-continuation-modeset-hang)
[58.223255] Starting subtest: ts-continuation-modeset-hang
[58.225540] Starting dynamic subtest: pipe-A-eDP-1
[86.093652] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.867s)
[86.105404] Starting dynamic subtest: pipe-D-eDP-1
[101.072063] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.975s)
[101.074124] Subtest ts-continuation-modeset-hang: SUCCESS (42.846s)
[101.951377] [003/156] (916s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[102.056311] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-mmap-wc
[102.060944] Subtest hdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[102.155303] [004/156] (916s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[102.209996] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[102.319059] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.108s)
[102.391910] [005/156] (916s left) kms_lease (atomic-implicit-crtc)
[102.478980] Starting subtest: atomic-implicit-crtc
[102.481417] Starting dynamic subtest: pipe-A-eDP-1
[102.494708] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[102.505230] Starting dynamic subtest: pipe-B-eDP-1
[102.516854] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[102.524992] Starting dynamic subtest: pipe-C-eDP-1
[102.544642] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[102.553027] Starting dynamic subtest: pipe-D-eDP-1
[102.563509] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[102.565701] Subtest atomic-implicit-crtc: SUCCESS (0.037s)
[102.621229] [006/156] (916s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[102.715832] Starting subtest: 2x-plain-flip-ts-check-interruptible
[102.728908] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.010s)
[102.802137] [007/156] (915s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[102.903249] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-mmap-gtt
[102.907304] Subtest fbchdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[103.003291] [008/156] (915s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-pwrite)
[103.110087] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-pwrite
[103.114059] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[103.231490] [009/156] (915s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[103.337040] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[103.338609] Starting dynamic subtest: pipe-A-eDP-1
[104.056709] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.713s)
[104.065963] Starting dynamic subtest: pipe-B-eDP-1
[105.859896] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.803s)
[105.867125] Starting dynamic subtest: pipe-C-eDP-1
[107.686201] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.825s)
[107.693565] Starting dynamic subtest: pipe-D-eDP-1
[109.462326] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.774s)
[109.464977] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.119s)
[110.609604] [010/156] (908s left) gem_wait (await)
[110.678208] Starting subtest: await
[110.680546] Starting dynamic subtest: all-engines
[111.813856] Dynamic subtest all-engines: SUCCESS (1.135s)
[111.829747] Starting dynamic subtest: rcs0
[112.869965] Dynamic subtest rcs0: SUCCESS (1.055s)
[112.885051] Starting dynamic subtest: bcs0
[113.927713] Dynamic subtest bcs0: SUCCESS (1.056s)
[113.943572] Starting dynamic subtest: vcs0
[114.982502] Dynamic subtest vcs0: SUCCESS (1.054s)
[114.997325] Starting dynamic subtest: vcs1
[116.035548] Dynamic subtest vcs1: SUCCESS (1.052s)
[116.051073] Starting dynamic subtest: vecs0
[117.089275] Dynamic subtest vecs0: SUCCESS (1.053s)
[117.104191] Starting dynamic subtest: ccs0
[118.145366] Dynamic subtest ccs0: SUCCESS (1.056s)
[118.147851] Subtest await: SUCCESS (7.468s)
[118.357194] [FACT gem_wait (await)] new: kernel.kmod_is_loaded.vgem: true
[118.360216] [011/156] (900s left) kms_frontbuffer_tracking (fbcpsrhdr-farfromfence-mmap-gtt)
[118.456054] Starting subtest: fbcpsrhdr-farfromfence-mmap-gtt
[118.460283] Subtest fbcpsrhdr-farfromfence-mmap-gtt: SKIP (0.000s)
[118.571467] [012/156] (900s left) gem_gpgpu_fill (basic)
[118.628153] Starting subtest: basic
[118.630418] Starting dynamic subtest: smem
[118.635144] Dynamic subtest smem: SUCCESS (0.007s)
[118.637092] Subtest basic: SUCCESS (0.007s)
[118.767159] [013/156] (900s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[118.816791] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[118.819084] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[118.907015] [014/156] (900s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[119.011848] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[126.078057] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.073s)
[126.211705] [015/156] (892s left) gem_exec_fence (nb-await)
[126.393278] Starting subtest: nb-await
[126.395867] Starting dynamic subtest: rcs0
[126.458195] Dynamic subtest rcs0: SUCCESS (0.065s)
[126.469261] Starting dynamic subtest: bcs0
[126.517473] Dynamic subtest bcs0: SUCCESS (0.058s)
[126.527831] Starting dynamic subtest: vcs0
[126.576857] Dynamic subtest vcs0: SUCCESS (0.059s)
[126.587194] Starting dynamic subtest: vcs1
[126.641956] Dynamic subtest vcs1: SUCCESS (0.064s)
[126.652556] Starting dynamic subtest: vecs0
[126.700946] Dynamic subtest vecs0: SUCCESS (0.058s)
[126.711614] Starting dynamic subtest: ccs0
[126.758719] Dynamic subtest ccs0: SUCCESS (0.057s)
[126.761748] Subtest nb-await: SUCCESS (0.366s)
[128.394428] [016/156] (890s left) gem_exec_create (madvise)
[128.448380] Starting subtest: madvise
[128.450710] Starting dynamic subtest: smem
[150.408207] Dynamic subtest smem: SUCCESS (21.956s)
[150.411045] Subtest madvise: SUCCESS (21.957s)
[151.226751] [017/156] (867s left) kms_setmode (basic-clone-single-crtc)
[151.296157] Starting subtest: basic-clone-single-crtc
[151.303381] Subtest basic-clone-single-crtc: SKIP (0.001s)
[151.413246] [018/156] (867s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[151.514951] Starting subtest: multiplane-rotation-cropping-bottom
[168.984640] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.471s)
[169.110743] [019/156] (850s left) kms_lease (lease-unleased-crtc)
[169.209217] Starting subtest: lease-unleased-crtc
[169.211246] Starting dynamic subtest: pipe-A-eDP-1
[169.497262] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[169.505639] Starting dynamic subtest: pipe-B-eDP-1
[170.267968] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.770s)
[170.278205] Starting dynamic subtest: pipe-C-eDP-1
[170.280552] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[170.289130] Starting dynamic subtest: pipe-D-eDP-1
[170.291297] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.005s)
[170.293507] Subtest lease-unleased-crtc: SUCCESS (1.072s)
[170.632814] [020/156] (848s left) perf_pmu (busy-no-semaphores)
[170.670396] Starting subtest: busy-no-semaphores
[170.672719] Starting dynamic subtest: rcs0
[171.223710] Dynamic subtest rcs0: SUCCESS (0.554s)
[171.235075] Starting dynamic subtest: bcs0
[171.770430] Dynamic subtest bcs0: SUCCESS (0.545s)
[171.783440] Starting dynamic subtest: vcs0
[172.323239] Dynamic subtest vcs0: SUCCESS (0.550s)
[172.333607] Starting dynamic subtest: vcs1
[173.830406] Dynamic subtest vcs1: SUCCESS (1.504s)
[173.840644] Starting dynamic subtest: vecs0
[175.814940] Dynamic subtest vecs0: SUCCESS (1.982s)
[175.826558] Starting dynamic subtest: ccs0
[177.801381] Dynamic subtest ccs0: SUCCESS (1.984s)
[177.804588] Subtest busy-no-semaphores: SUCCESS (7.133s)
[177.922321] [021/156] (841s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[178.019357] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[184.637815] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.622s)
[184.774942] [022/156] (834s left) syncobj_wait (wait-all-for-submit-complex)
[184.826733] Starting subtest: wait-all-for-submit-complex
[185.041468] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[185.130877] [023/156] (834s left) i915_fb_tiling (basic-x-tiling)
[185.183737] Subtest basic-x-tiling: SKIP (0.000s)
[185.241508] [024/156] (834s left) kms_psr (psr-cursor-blt)
[185.332280] Starting subtest: psr-cursor-blt
[185.334579] Starting dynamic subtest: eDP-1
[187.058638] Dynamic subtest eDP-1: SUCCESS (1.725s)
[187.060935] Subtest psr-cursor-blt: SUCCESS (1.726s)
[187.921195] [025/156] (831s left) gen7_exec_parse (batch-without-end)
[187.974970] Subtest batch-without-end: SKIP (0.000s)
[188.068257] [026/156] (831s left) sysfs_preempt_timeout (invalid)
[188.113596] Starting subtest: invalid
[188.115889] Starting dynamic subtest: vecs0
[188.118239] Dynamic subtest vecs0: SUCCESS (0.000s)
[188.126654] Starting dynamic subtest: ccs0
[188.128610] Dynamic subtest ccs0: SUCCESS (0.000s)
[188.143785] Starting dynamic subtest: vcs0
[188.146070] Dynamic subtest vcs0: SUCCESS (0.000s)
[188.153884] Starting dynamic subtest: bcs0
[188.155754] Dynamic subtest bcs0: SUCCESS (0.000s)
[188.163410] Starting dynamic subtest: rcs0
[188.165318] Dynamic subtest rcs0: SUCCESS (0.000s)
[188.172962] Starting dynamic subtest: vcs1
[188.174874] Dynamic subtest vcs1: SUCCESS (0.000s)
[188.176745] Subtest invalid: SUCCESS (0.005s)
[188.212111] [027/156] (831s left) gem_mmap_gtt (flink-race)
[188.265110] Subtest flink-race: SKIP (0.000s)
[188.319627] [028/156] (831s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[188.375783] Subtest untiled-to-tiled: SKIP (0.000s)
[188.439227] [029/156] (831s left) kms_addfb_basic (tile-pitch-mismatch)
[188.501624] Starting subtest: tile-pitch-mismatch
[188.506359] Subtest tile-pitch-mismatch: SKIP (0.000s)
[188.626113] [030/156] (831s left) gem_tiled_blits (basic)
[188.681173] Subtest basic: SKIP (0.000s)
[188.734653] [031/156] (830s left) i915_drm_fdinfo (busy-hang)
[188.767435] Starting subtest: busy-hang
[188.769830] Starting dynamic subtest: rcs0
[188.798118] Dynamic subtest rcs0: SKIP (0.029s)
[188.809381] Starting dynamic subtest: bcs0
[188.813805] Dynamic subtest bcs0: SKIP (0.001s)
[188.822118] Starting dynamic subtest: vcs0
[188.826259] Dynamic subtest vcs0: SKIP (0.000s)
[188.834243] Starting dynamic subtest: vcs1
[188.838571] Dynamic subtest vcs1: SKIP (0.000s)
[188.846217] Starting dynamic subtest: vecs0
[188.849816] Dynamic subtest vecs0: SKIP (0.000s)
[188.857480] Starting dynamic subtest: ccs0
[188.861097] Dynamic subtest ccs0: SKIP (0.000s)
[188.864688] Subtest busy-hang: SKIP (0.034s)
[188.898213] [032/156] (830s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[188.995938] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[188.999333] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[189.094166] [033/156] (830s left) kms_psr (pr-sprite-mmap-gtt)
[189.193443] Starting subtest: pr-sprite-mmap-gtt
[189.197133] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[189.262766] [034/156] (830s left) gem_softpin (noreloc)
[189.323068] Starting subtest: noreloc
[194.795372] Subtest noreloc: SUCCESS (5.417s)
[194.852634] [035/156] (824s left) gem_exec_flush (basic-uc-ro-default)
[194.912066] Starting subtest: basic-uc-ro-default
[200.399704] Subtest basic-uc-ro-default: SUCCESS (5.455s)
[200.553778] [036/156] (819s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-mmap-gtt)
[200.651676] Starting subtest: psrhdr-rgb101010-draw-mmap-gtt
[200.655788] Subtest psrhdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[200.745278] [037/156] (819s left) kms_psr (fbc-psr2-no-drrs)
[200.839803] Starting subtest: fbc-psr2-no-drrs
[200.842112] Starting dynamic subtest: eDP-1
[200.846175] Dynamic subtest eDP-1: SKIP (0.000s)
[200.850228] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[200.915826] [038/156] (819s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[201.017673] Starting subtest: fbcpsr-rgb565-draw-blt
[208.070623] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.058s)
[208.225936] [039/156] (811s left) gem_exec_store (dword)
[208.282334] Starting subtest: dword
[208.284599] Starting dynamic subtest: rcs0
[208.361461] Dynamic subtest rcs0: SUCCESS (0.081s)
[208.370667] Starting dynamic subtest: bcs0
[208.401358] Dynamic subtest bcs0: SUCCESS (0.040s)
[208.410928] Starting dynamic subtest: vcs0
[208.442141] Dynamic subtest vcs0: SUCCESS (0.039s)
[208.453538] Starting dynamic subtest: vcs1
[208.484168] Dynamic subtest vcs1: SUCCESS (0.040s)
[208.497414] Starting dynamic subtest: vecs0
[208.528863] Dynamic subtest vecs0: SUCCESS (0.042s)
[208.542078] Starting dynamic subtest: ccs0
[208.571419] Dynamic subtest ccs0: SUCCESS (0.041s)
[208.573799] Subtest dword: SUCCESS (0.294s)
[208.769854] [040/156] (811s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[208.870489] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[208.895509] Starting dynamic subtest: pipe-A-plane-0
[209.195794] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[209.204279] Starting dynamic subtest: pipe-A-plane-3
[209.428869] Dynamic subtest pipe-A-plane-3: SUCCESS (0.231s)
[209.437352] Starting dynamic subtest: pipe-A-plane-5
[209.441571] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[210.551521] Starting dynamic subtest: pipe-B-plane-0
[210.841770] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[210.852099] Starting dynamic subtest: pipe-B-plane-3
[211.075235] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[211.085262] Starting dynamic subtest: pipe-B-plane-5
[211.089822] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[211.385194] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.514s)
[212.238052] [041/156] (807s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[212.332057] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[212.334359] Starting dynamic subtest: pipe-A
[212.394920] Dynamic subtest pipe-A: SUCCESS (0.065s)
[212.403502] Starting dynamic subtest: pipe-B
[213.545600] Dynamic subtest pipe-B: SUCCESS (1.149s)
[213.557192] Starting dynamic subtest: pipe-C
[214.655366] Dynamic subtest pipe-C: SUCCESS (1.110s)
[214.665097] Starting dynamic subtest: pipe-D
[215.787564] Dynamic subtest pipe-D: SUCCESS (1.131s)
[215.789941] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.458s)
[216.955758] [042/156] (803s left) gem_mmap_wc (bad-object)
[217.014131] Subtest bad-object: SKIP (0.000s)
[217.073080] [043/156] (803s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[217.157089] Starting subtest: dsc-fractional-bpp-with-bpc
[217.188582] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s)
[217.236413] [044/156] (802s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[217.333296] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[217.337615] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[217.425991] [045/156] (802s left) dumb_buffer (map-valid)
[217.477054] Starting subtest: map-valid
[217.479415] Subtest map-valid: SUCCESS (0.000s)
[217.581277] [046/156] (802s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[217.671860] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[217.676499] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[217.755500] [047/156] (802s left) gem_exec_balancer (parallel-bb-first)
[218.015257] Starting subtest: parallel-bb-first
[218.961082] Subtest parallel-bb-first: SUCCESS (0.946s)
[219.306748] [048/156] (801s left) gem_exec_balancer (parallel-keep-submit-fence)
[219.564882] Starting subtest: parallel-keep-submit-fence
[220.650094] Subtest parallel-keep-submit-fence: SUCCESS (1.089s)
[220.757869] [049/156] (799s left) gem_ctx_exec (basic-norecovery)
[220.818915] Starting subtest: basic-norecovery
[221.195641] Subtest basic-norecovery: SUCCESS (0.378s)
[221.337697] [050/156] (799s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[221.400978] Starting subtest: single-wait-all-for-submit-available-submitted
[221.403435] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[221.504277] [051/156] (798s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-mmap-cpu)
[221.606675] Starting subtest: fbchdr-rgb101010-draw-mmap-cpu
[221.611086] Subtest fbchdr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[221.699567] [052/156] (798s left) kms_pm_dc (dc5-retention-flops)
[222.798736] Starting subtest: dc5-retention-flops
[222.803246] Subtest dc5-retention-flops: SKIP (0.000s)
[222.870375] [053/156] (797s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[222.975161] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[224.110071] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.137s)
[224.219610] [054/156] (796s left) kms_tiled_display (basic-test-pattern)
[224.329206] Subtest basic-test-pattern: SKIP (0.000s)
[224.374962] [055/156] (796s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-render)
[224.462257] Starting subtest: psrhdr-rgb565-draw-render
[224.465766] Subtest psrhdr-rgb565-draw-render: SKIP (0.000s)
[224.554179] [056/156] (796s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[224.636182] Starting subtest: plane-lut1d-post-ctm3x4
[224.762066] Starting dynamic subtest: pipe-A-plane-0
[224.948302] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s)
[224.958085] Starting dynamic subtest: pipe-A-plane-1
[225.126227] Dynamic subtest pipe-A-plane-1: SUCCESS (0.177s)
[225.135155] Starting dynamic subtest: pipe-A-plane-2
[225.315232] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s)
[226.555911] Starting dynamic subtest: pipe-B-plane-0
[226.725579] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s)
[226.735553] Starting dynamic subtest: pipe-B-plane-1
[226.858864] Dynamic subtest pipe-B-plane-1: SUCCESS (0.132s)
[226.868249] Starting dynamic subtest: pipe-B-plane-2
[227.027088] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[228.294295] Starting dynamic subtest: pipe-C-plane-0
[228.430312] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[228.441145] Starting dynamic subtest: pipe-C-plane-1
[228.597050] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[228.613516] Starting dynamic subtest: pipe-C-plane-2
[228.741281] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[229.947980] Starting dynamic subtest: pipe-D-plane-0
[230.085352] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[230.095473] Starting dynamic subtest: pipe-D-plane-1
[230.218632] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s)
[230.228222] Starting dynamic subtest: pipe-D-plane-2
[230.352591] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[230.655428] Subtest plane-lut1d-post-ctm3x4: SUCCESS (6.018s)
[231.506437] [057/156] (789s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[231.599064] Starting subtest: primary-y-tiled-reflect-x-270
[231.603390] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[231.683695] [058/156] (789s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[231.787060] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[231.791537] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[231.875280] [059/156] (788s left) gem_exec_reloc (basic-cpu-gtt)
[231.932544] Subtest basic-cpu-gtt: SKIP (0.000s)
[232.017940] [060/156] (788s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[232.116516] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[232.120882] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[232.217445] [061/156] (788s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[232.316529] Starting subtest: psr-rgb565-draw-pwrite
[239.302889] Subtest psr-rgb565-draw-pwrite: SUCCESS (6.992s)
[239.405096] [062/156] (781s left) kms_plane_multiple (tiling-4)
[239.506747] Starting subtest: tiling-4
[239.509181] Starting dynamic subtest: pipe-A-eDP-1
[243.390183] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.883s)
[243.400722] Starting dynamic subtest: pipe-B-eDP-1
[247.930791] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.541s)
[247.941505] Starting dynamic subtest: pipe-C-eDP-1
[252.294502] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.363s)
[252.304852] Starting dynamic subtest: pipe-D-eDP-1
[256.647638] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.350s)
[256.649556] Subtest tiling-4: SUCCESS (17.142s)
[257.459039] [063/156] (763s left) kms_psr (pr-basic)
[257.554181] Starting subtest: pr-basic
[257.558501] Subtest pr-basic: SKIP (0.000s)
[257.632399] [064/156] (763s left) gen3_render_mixed_blits
[257.744645] [065/156] (763s left) gem_render_linear_blits (basic)
[257.795192] Starting subtest: basic
[257.815808] Subtest basic: SUCCESS (0.020s)
[257.901812] [066/156] (763s left) i915_pm_rpm (gem-mmap-type)
[259.530977] Starting subtest: gem-mmap-type
[259.533764] Starting dynamic subtest: wb-smem0
[263.022903] Dynamic subtest wb-smem0: SUCCESS (3.495s)
[263.033376] Starting dynamic subtest: wc-smem0
[265.893755] Dynamic subtest wc-smem0: SUCCESS (2.868s)
[265.905576] Starting dynamic subtest: uc-smem0
[269.090976] Dynamic subtest uc-smem0: SUCCESS (3.195s)
[269.093409] Subtest gem-mmap-type: SUCCESS (9.563s)
[269.187826] [067/156] (752s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[269.294643] Starting subtest: pr-primary-plane-update-sf-dmg-area
[269.298800] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[269.361966] [068/156] (751s left) kms_cursor_edge_walk (64x64-left-edge)
[269.448836] Starting subtest: 64x64-left-edge
[269.451161] Starting dynamic subtest: pipe-A-eDP-1
[272.903594] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.454s)
[272.912832] Starting dynamic subtest: pipe-D-eDP-1
[276.029023] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[276.031285] Subtest 64x64-left-edge: SUCCESS (6.582s)
[276.849780] [069/156] (744s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-move)
[276.957743] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-move
[276.961838] Subtest fbchdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[277.071111] [070/156] (744s left) kms_setmode (invalid-clone-single-crtc-stealing)
[277.115698] Starting subtest: invalid-clone-single-crtc-stealing
[277.121968] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[277.200588] [071/156] (744s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[277.320411] Starting subtest: basic-flip-before-cursor-atomic
[278.235024] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.913s)
[279.067932] [072/156] (742s left) kms_flip (dpms-vs-vblank-race-interruptible)
[279.177963] Starting subtest: dpms-vs-vblank-race-interruptible
[279.179862] Starting dynamic subtest: A-eDP1
[283.107089] Dynamic subtest A-eDP1: SUCCESS (3.925s)
[283.119380] Starting dynamic subtest: B-eDP1
[286.707356] Dynamic subtest B-eDP1: SUCCESS (3.596s)
[286.716630] Starting dynamic subtest: C-eDP1
[291.320556] Dynamic subtest C-eDP1: SUCCESS (4.612s)
[291.330228] Starting dynamic subtest: D-eDP1
[295.959466] Dynamic subtest D-eDP1: SUCCESS (4.634s)
[295.962891] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (16.783s)
[296.825337] [073/156] (724s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[296.926297] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[296.930306] Subtest hdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[297.030452] [074/156] (724s left) gem_ctx_shared (disjoint-timelines)
[297.103498] Starting subtest: disjoint-timelines
[297.134706] Subtest disjoint-timelines: SUCCESS (0.034s)
[297.369587] [075/156] (724s left) kms_cursor_crc (cursor-alpha-transparent)
[297.470874] Starting subtest: cursor-alpha-transparent
[297.473138] Starting dynamic subtest: pipe-A-eDP-1
[298.081700] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.611s)
[298.091338] Starting dynamic subtest: pipe-D-eDP-1
[299.400695] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.317s)
[299.403139] Subtest cursor-alpha-transparent: SUCCESS (1.931s)
[300.286871] [076/156] (721s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[300.386090] Starting subtest: psr2-plane-move-sf-dmg-area
[300.388318] Starting dynamic subtest: pipe-A-eDP-1
[304.930818] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.548s)
[304.940499] Starting dynamic subtest: pipe-B-eDP-1
[310.259164] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.326s)
[310.261288] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.877s)
[311.123507] [077/156] (710s left) kms_pm_rpm (modeset-non-lpsp)
[312.646293] Starting subtest: modeset-non-lpsp
[313.810974] Subtest modeset-non-lpsp: SKIP (1.165s)
[314.211172] [078/156] (707s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[314.281184] Starting subtest: x-tiled-to-vebox-y-tiled
[314.285650] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[314.477120] [079/156] (707s left) kms_dp_linktrain_fallback (dp-fallback)
[314.573301] Starting subtest: dp-fallback
[314.579233] Subtest dp-fallback: SKIP (0.000s)
[314.648710] [080/156] (707s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-onoff)
[314.746633] Starting subtest: hdr-2p-scndscrn-spr-indfb-onoff
[314.751251] Subtest hdr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[314.824956] [081/156] (706s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render)
[314.924142] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render
[314.928279] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[315.033465] [082/156] (706s left) kms_content_protection (atomic)
[315.165314] Starting subtest: atomic
[315.169712] Subtest atomic: SKIP (0.000s)
[315.311263] [083/156] (706s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-onoff)
[315.415054] Starting subtest: hdr-1p-primscrn-spr-indfb-onoff
[315.418643] Subtest hdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[315.523955] [084/156] (706s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-pgflip-blt)
[315.623208] Starting subtest: fbchdr-2p-scndscrn-shrfb-pgflip-blt
[315.626864] Subtest fbchdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[315.731609] [085/156] (706s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[315.778415] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[315.782228] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[315.962321] [086/156] (706s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[316.058562] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[316.063079] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[316.178918] [087/156] (705s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[316.279603] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[316.283813] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[316.364239] [088/156] (705s left) gem_exec_schedule (submit-early-slice)
[316.431780] Starting subtest: submit-early-slice
[316.434068] Starting dynamic subtest: rcs0
[316.471389] Dynamic subtest rcs0: SUCCESS (0.045s)
[316.482762] Starting dynamic subtest: bcs0
[316.513179] Dynamic subtest bcs0: SUCCESS (0.041s)
[316.523849] Starting dynamic subtest: vcs0
[316.555191] Dynamic subtest vcs0: SUCCESS (0.041s)
[316.565432] Starting dynamic subtest: vcs1
[316.595471] Dynamic subtest vcs1: SUCCESS (0.039s)
[316.605929] Starting dynamic subtest: vecs0
[316.638838] Dynamic subtest vecs0: SUCCESS (0.043s)
[316.650781] Starting dynamic subtest: ccs0
[316.680642] Dynamic subtest ccs0: SUCCESS (0.041s)
[316.682999] Subtest submit-early-slice: SUCCESS (0.255s)
[318.355433] [089/156] (703s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[318.449742] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[318.451919] Starting dynamic subtest: pipe-A-eDP-1
[318.510446] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[318.521989] Starting dynamic subtest: pipe-B-eDP-1
[318.580265] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[318.590901] Starting dynamic subtest: pipe-C-eDP-1
[318.647684] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[318.658120] Starting dynamic subtest: pipe-D-eDP-1
[318.715629] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[318.719808] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.008s)
[320.760774] [090/156] (701s left) gem_mmap_gtt (big-bo-tiledx)
[320.824864] Subtest big-bo-tiledX: SKIP (0.000s)
[320.882997] [091/156] (701s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[320.937610] Starting subtest: etime-single-wait-all-available-unsubmitted
[321.037811] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.101s)
[321.118749] [092/156] (701s left) gem_mmap_wc (fault-concurrent)
[321.175582] Subtest fault-concurrent: SKIP (0.000s)
[321.230847] [093/156] (701s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[321.324092] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[328.122412] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.804s)
[328.261791] [094/156] (694s left) gem_eio (in-flight-internal-immediate)
[328.480037] Starting subtest: in-flight-internal-immediate
[330.378570] Subtest in-flight-internal-immediate: SUCCESS (1.896s)
[330.544164] [095/156] (691s left) gem_partial_pwrite_pread (reads)
[330.595391] Subtest reads: SKIP (0.000s)
[330.669698] [096/156] (691s left) kms_chamelium_hpd (vga-hpd-fast)
[331.042772] Subtest vga-hpd-fast: SKIP (0.000s)
[331.881573] [097/156] (690s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[331.993365] Starting subtest: x-tiled-16bpp-rotate-270
[332.016065] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[332.151332] [098/156] (690s left) api_intel_allocator (reserve-simple)
[332.196333] Starting subtest: reserve-simple
[332.201027] Subtest reserve-simple: SUCCESS (0.004s)
[332.317378] [099/156] (690s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-move)
[332.425635] Starting subtest: psrhdr-1p-primscrn-spr-indfb-move
[332.429841] Subtest psrhdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[332.527073] [100/156] (690s left) kms_cursor_crc (cursor-random-128x42)
[332.775643] Starting subtest: cursor-random-128x42
[332.817220] Subtest cursor-random-128x42: SKIP (0.040s)
[333.027717] [101/156] (689s left) kms_plane_cursor (viewport)
[333.112481] Starting subtest: viewport
[333.116272] Starting dynamic subtest: pipe-A-eDP-1-size-64
[335.586514] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.474s)
[335.645966] Starting dynamic subtest: pipe-A-eDP-1-size-128
[338.110604] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.472s)
[338.173502] Starting dynamic subtest: pipe-A-eDP-1-size-256
[340.589526] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.427s)
[340.954824] Starting dynamic subtest: pipe-B-eDP-1-size-64
[344.139333] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.199s)
[344.200258] Starting dynamic subtest: pipe-B-eDP-1-size-128
[346.695640] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.505s)
[346.755775] Starting dynamic subtest: pipe-B-eDP-1-size-256
[349.264602] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.516s)
[349.615096] Starting dynamic subtest: pipe-C-eDP-1-size-64
[352.498435] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.898s)
[352.536684] Starting dynamic subtest: pipe-C-eDP-1-size-128
[354.676249] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.148s)
[354.714502] Starting dynamic subtest: pipe-C-eDP-1-size-256
[356.843253] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.136s)
[357.171595] Starting dynamic subtest: pipe-D-eDP-1-size-64
[360.076391] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.915s)
[360.115334] Starting dynamic subtest: pipe-D-eDP-1-size-128
[362.242458] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.136s)
[362.281282] Starting dynamic subtest: pipe-D-eDP-1-size-256
[364.420995] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.147s)
[364.736879] Subtest viewport: SUCCESS (31.624s)
[365.536690] [102/156] (657s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-blt)
[365.647918] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-blt
[365.652103] Subtest psrhdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[365.756587] [103/156] (656s left) dmabuf_sync_file (import-multiple-read-write)
[365.795292] Starting subtest: import-multiple-read-write
[365.797439] Subtest import-multiple-read-write: SUCCESS (0.003s)
[365.848583] [104/156] (656s left) kms_big_fb (linear-8bpp-rotate-270)
[365.945347] Starting subtest: linear-8bpp-rotate-270
[365.966132] Subtest linear-8bpp-rotate-270: SKIP (0.020s)
[366.092750] [105/156] (656s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[366.185168] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[366.189122] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[366.285532] [106/156] (656s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-rte)
[366.377243] Starting subtest: fbcpsrhdr-2p-rte
[366.381334] Subtest fbcpsrhdr-2p-rte: SKIP (0.000s)
[366.465607] [107/156] (656s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[366.558328] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[366.561729] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[366.650864] [108/156] (656s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[366.758497] Starting subtest: 4-tiled-8bpp-rotate-0
[367.972475] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.214s)
[368.082757] [109/156] (654s left) sw_sync (sync_random_merge)
[368.119607] Starting subtest: sync_random_merge
[368.160757] Subtest sync_random_merge: SUCCESS (0.043s)
[368.221405] [110/156] (654s left) gem_mmap_gtt (bad-object)
[368.268075] Subtest bad-object: SKIP (0.000s)
[368.337164] [111/156] (654s left) syncobj_timeline (single-wait-all-available-submitted)
[368.393575] Starting subtest: single-wait-all-available-submitted
[368.395488] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[368.514705] [112/156] (654s left) core_getclient (basic)
[368.566078] Starting subtest: basic
[368.567846] Subtest basic: SUCCESS (0.000s)
[368.667023] [113/156] (654s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[368.758803] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[368.762664] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[368.853169] [114/156] (654s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[368.942363] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[368.946043] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[369.042245] [115/156] (654s left) gem_partial_pwrite_pread (writes-after-reads)
[369.093042] Subtest writes-after-reads: SKIP (0.000s)
[369.170618] [116/156] (654s left) i915_pm_rps (thresholds-idle-park)
[369.220999] Starting subtest: thresholds-idle-park
[369.224801] Subtest thresholds-idle-park: SKIP (0.001s)
[369.309904] [117/156] (653s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[369.406044] Starting subtest: y-tiled-8bpp-rotate-0
[369.409836] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[369.519954] [118/156] (653s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[369.608207] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[369.620124] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[369.700518] [119/156] (653s left) kms_rotation_crc (bad-pixel-format)
[369.777446] Starting subtest: bad-pixel-format
[369.781229] Subtest bad-pixel-format: SKIP (0.001s)
[369.852601] [120/156] (653s left) kms_atomic (plane-overlay-legacy)
[369.938559] Starting subtest: plane-overlay-legacy
[369.940722] Starting dynamic subtest: pipe-A-eDP-1
[370.328074] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.387s)
[370.330411] Subtest plane-overlay-legacy: SUCCESS (0.388s)
[371.165681] [121/156] (652s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[371.261276] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[377.884704] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.630s)
[378.037369] [122/156] (645s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[378.144311] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[385.468923] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.330s)
[385.615925] [123/156] (637s left) gem_spin_batch (legacy-resubmit)
[385.676597] Starting subtest: legacy-resubmit
[385.678881] Starting dynamic subtest: default
[385.683856] Dynamic subtest default: SUCCESS (0.007s)
[385.697541] Starting dynamic subtest: render
[385.699827] Dynamic subtest render: SUCCESS (0.001s)
[385.710768] Starting dynamic subtest: bsd
[385.712697] Dynamic subtest bsd: SUCCESS (0.003s)
[385.721807] Starting dynamic subtest: bsd1
[385.723690] Dynamic subtest bsd1: SUCCESS (0.001s)
[385.732812] Starting dynamic subtest: bsd2
[385.734673] Dynamic subtest bsd2: SUCCESS (0.003s)
[385.743818] Starting dynamic subtest: blt
[385.745767] Dynamic subtest blt: SUCCESS (0.002s)
[385.754793] Starting dynamic subtest: vebox
[385.756724] Dynamic subtest vebox: SUCCESS (0.003s)
[385.758609] Subtest legacy-resubmit: SUCCESS (0.025s)
[385.947656] [124/156] (637s left) prime_mmap (test_userptr)
[385.999538] Starting subtest: test_userptr
[386.001915] Starting dynamic subtest: test_userptr-smem
[386.004188] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[386.006398] Subtest test_userptr: SUCCESS (0.001s)
[386.122299] [125/156] (637s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[386.217496] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[386.221752] Subtest fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[386.315470] [126/156] (637s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[386.407473] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[386.501929] [127/156] (637s left) kms_force_connector_basic (force-connector-state)
[386.565665] Starting subtest: force-connector-state
[387.177618] Subtest force-connector-state: SUCCESS (0.612s)
[388.204599] [128/156] (635s left) kms_chamelium_frames (hdmi-crc-single)
[388.590185] Subtest hdmi-crc-single: SKIP (0.000s)
[389.426411] [129/156] (634s left) gem_ctx_engines (none)
[389.485745] Starting subtest: none
[389.491028] Subtest none: SUCCESS (0.003s)
[389.687593] [130/156] (634s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[389.780777] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[389.782973] Starting dynamic subtest: pipe-A-eDP-1
[405.702051] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.311s)
[405.712961] Starting dynamic subtest: pipe-B-eDP-1
[422.626484] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.356s)
[422.637984] Starting dynamic subtest: pipe-C-eDP-1
[439.603346] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.408s)
[439.614895] Starting dynamic subtest: pipe-D-eDP-1
[456.617370] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.320s)
[456.619860] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (9.400s)
[457.841520] [131/156] (565s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[457.949517] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[457.954566] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[458.049258] [132/156] (565s left) gem_exec_params (readonly)
[458.100865] Starting subtest: readonly
[458.103732] Subtest readonly: SUCCESS (0.002s)
[458.205981] [133/156] (565s left) gem_eio (in-flight-10ms)
[458.424835] Starting subtest: in-flight-10ms
[466.644539] Subtest in-flight-10ms: SUCCESS (8.210s)
[466.777717] [134/156] (557s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[466.866861] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[466.869714] Starting dynamic subtest: pipe-A-eDP-1
[466.896542] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[466.908636] Starting dynamic subtest: pipe-B-eDP-1
[466.933480] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[466.944587] Starting dynamic subtest: pipe-C-eDP-1
[466.970038] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[466.980761] Starting dynamic subtest: pipe-D-eDP-1
[467.007133] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[467.012053] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[469.156378] [135/156] (554s left) gem_exec_nop (basic-sequential)
[469.224862] Starting subtest: basic-sequential
[485.865410] Subtest basic-sequential: SUCCESS (16.619s)
[486.065691] [136/156] (538s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[486.164255] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[486.166738] Starting dynamic subtest: pipe-A-eDP-1
[486.192137] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[486.203993] Starting dynamic subtest: pipe-B-eDP-1
[486.229443] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[486.239344] Starting dynamic subtest: pipe-C-eDP-1
[486.264461] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[486.274619] Starting dynamic subtest: pipe-D-eDP-1
[486.300316] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[486.305546] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[488.464352] [137/156] (535s left) kms_frontbuffer_tracking (fbc-1p-rte)
[488.568153] Starting subtest: fbc-1p-rte
[493.988218] Subtest fbc-1p-rte: SUCCESS (5.425s)
[495.182948] [138/156] (528s left) gem_pwrite_snooped
[495.334550] [139/156] (528s left) kms_frontbuffer_tracking (psrhdr-2p-rte)
[495.430663] Starting subtest: psrhdr-2p-rte
[495.435572] Subtest psrhdr-2p-rte: SKIP (0.000s)
[495.531104] [140/156] (528s left) gem_ctx_param (get-priority-new-ctx)
[495.578244] Starting subtest: get-priority-new-ctx
[495.580764] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[495.689241] [141/156] (528s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-pgflip-blt)
[495.783850] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-pgflip-blt
[495.788914] Subtest fbcpsrhdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[495.892452] [142/156] (528s left) perf_pmu (rc6-all-gts)
[495.933859] Starting subtest: rc6-all-gts
[502.352011] Subtest rc6-all-gts: SUCCESS (6.361s)
[503.348447] [143/156] (521s left) gem_ctx_persistence (legacy-engines-cleanup)
[503.407007] Starting subtest: legacy-engines-cleanup
[503.409049] Starting dynamic subtest: render
[503.458488] Dynamic subtest render: SUCCESS (0.051s)
[503.471514] Starting dynamic subtest: bsd1
[503.504608] Dynamic subtest bsd1: SUCCESS (0.044s)
[503.515253] Starting dynamic subtest: bsd2
[503.548523] Dynamic subtest bsd2: SUCCESS (0.042s)
[503.559221] Starting dynamic subtest: blt
[503.608687] Dynamic subtest blt: SUCCESS (0.058s)
[503.624621] Starting dynamic subtest: vebox
[503.658576] Dynamic subtest vebox: SUCCESS (0.047s)
[503.661209] Subtest legacy-engines-cleanup: SUCCESS (0.253s)
[503.773912] [144/156] (520s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[503.883822] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[503.887865] Subtest hdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[503.979134] [145/156] (520s left) syncobj_timeline (invalid-wait-bad-flags)
[504.030576] Starting subtest: invalid-wait-bad-flags
[504.032558] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[504.134131] [146/156] (520s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[504.234619] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[504.238834] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[504.332603] [147/156] (520s left) gem_fenced_exec_thrash (too-many-fences)
[504.392633] Subtest too-many-fences: SKIP (0.000s)
[504.462140] [148/156] (520s left) gem_userptr_blits (readonly-unsync)
[504.515101] Subtest readonly-unsync: SKIP (0.000s)
[504.628556] [149/156] (520s left) gem_create (create-valid-nonaligned)
[504.676838] Starting subtest: create-valid-nonaligned
[504.679012] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[504.868674] [150/156] (519s left) syncobj_eventfd (invalid-bad-flags)
[504.911461] Starting subtest: invalid-bad-flags
[504.914353] Subtest invalid-bad-flags: SUCCESS (0.000s)
[505.006863] [151/156] (519s left) kms_rotation_crc (bad-tiling)
[505.091100] Starting subtest: bad-tiling
[505.095859] Subtest bad-tiling: SKIP (0.001s)
[505.169808] [152/156] (519s left) gem_exec_reloc (basic-cpu-read-noreloc)
[505.227370] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[505.300231] [153/156] (519s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[505.383957] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[505.388985] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[505.458748] [154/156] (519s left) kms_plane (plane-panning-bottom-right-suspend)
[505.536834] Starting subtest: plane-panning-bottom-right-suspend
[505.539602] Starting dynamic subtest: pipe-A
[522.867618] Dynamic subtest pipe-A: SUCCESS (2.800s)
[522.878779] Starting dynamic subtest: pipe-B
[541.875142] Dynamic subtest pipe-B: SUCCESS (3.520s)
[541.877664] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.323s)
[542.738811] [155/156] (482s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[542.844887] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[542.849898] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[542.936469] [156/156] (482s left) gem_exec_schedule (lateslice)
[543.009378] Starting subtest: lateslice
[543.011475] Starting dynamic subtest: rcs0
[543.017782] Dynamic subtest rcs0: SUCCESS (0.021s)
[543.029021] Starting dynamic subtest: bcs0
[543.036711] Dynamic subtest bcs0: SUCCESS (0.018s)
[543.047057] Starting dynamic subtest: vcs0
[543.055540] Dynamic subtest vcs0: SUCCESS (0.018s)
[543.066455] Starting dynamic subtest: vcs1
[543.074927] Dynamic subtest vcs1: SUCCESS (0.018s)
[543.085617] Starting dynamic subtest: vecs0
[543.093750] Dynamic subtest vecs0: SUCCESS (0.017s)
[543.105942] Starting dynamic subtest: ccs0
[543.111746] Dynamic subtest ccs0: SUCCESS (0.018s)
[543.114257] Subtest lateslice: SUCCESS (0.115s)
[544.781624] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_reloc
results: parsing output: 1/ for test: kms_vblank
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: kms_lease
results: parsing output: 5/ for test: kms_flip
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: gem_wait
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_gpgpu_fill
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_exec_fence
results: parsing output: 15/ for test: gem_exec_create
results: parsing output: 16/ for test: kms_setmode
results: parsing output: 17/ for test: kms_rotation_crc
results: parsing output: 18/ for test: kms_lease
results: parsing output: 19/ for test: perf_pmu
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: syncobj_wait
results: parsing output: 22/ for test: i915_fb_tiling
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: gen7_exec_parse
results: parsing output: 25/ for test: sysfs_preempt_timeout
results: parsing output: 26/ for test: gem_mmap_gtt
results: parsing output: 27/ for test: gem_set_tiling_vs_blt
results: parsing output: 28/ for test: kms_addfb_basic
results: parsing output: 29/ for test: gem_tiled_blits
results: parsing output: 30/ for test: i915_drm_fdinfo
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: gem_softpin
results: parsing output: 34/ for test: gem_exec_flush
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_exec_store
results: parsing output: 39/ for test: kms_plane
results: parsing output: 40/ for test: kms_plane_scaling
results: parsing output: 41/ for test: gem_mmap_wc
results: parsing output: 42/ for test: kms_dsc
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: dumb_buffer
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: gem_exec_balancer
results: parsing output: 47/ for test: gem_exec_balancer
results: parsing output: 48/ for test: gem_ctx_exec
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_pm_dc
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_tiled_display
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_color_pipeline
results: parsing output: 56/ for test: kms_rotation_crc
results: parsing output: 57/ for test: kms_flip_scaled_crc
results: parsing output: 58/ for test: gem_exec_reloc
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_plane_multiple
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: gen3_render_mixed_blits
results: parsing output: 64/ for test: gem_render_linear_blits
results: parsing output: 65/ for test: i915_pm_rpm
results: parsing output: 66/ for test: kms_psr2_sf
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: kms_setmode
results: parsing output: 70/ for test: kms_cursor_legacy
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_ctx_shared
results: parsing output: 74/ for test: kms_cursor_crc
results: parsing output: 75/ for test: kms_psr2_sf
results: parsing output: 76/ for test: kms_pm_rpm
results: parsing output: 77/ for test: gem_render_copy
results: parsing output: 78/ for test: kms_dp_linktrain_fallback
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_content_protection
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_render_copy
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_exec_schedule
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: gem_mmap_gtt
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: gem_mmap_wc
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_eio
results: parsing output: 94/ for test: gem_partial_pwrite_pread
results: parsing output: 95/ for test: kms_chamelium_hpd
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: api_intel_allocator
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_cursor_crc
results: parsing output: 100/ for test: kms_plane_cursor
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: dmabuf_sync_file
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_psr2_sf
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: sw_sync
results: parsing output: 109/ for test: gem_mmap_gtt
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: core_getclient
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_partial_pwrite_pread
results: parsing output: 115/ for test: i915_pm_rps
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_flip
results: parsing output: 118/ for test: kms_rotation_crc
results: parsing output: 119/ for test: kms_atomic
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_spin_batch
results: parsing output: 123/ for test: prime_mmap
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_addfb_basic
results: parsing output: 126/ for test: kms_force_connector_basic
results: parsing output: 127/ for test: kms_chamelium_frames
results: parsing output: 128/ for test: gem_ctx_engines
results: parsing output: 129/ for test: kms_ccs
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_exec_params
results: parsing output: 132/ for test: gem_eio
results: parsing output: 133/ for test: kms_ccs
results: parsing output: 134/ for test: gem_exec_nop
results: parsing output: 135/ for test: kms_ccs
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: gem_pwrite_snooped
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: gem_ctx_param
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: perf_pmu
results: parsing output: 142/ for test: gem_ctx_persistence
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: syncobj_timeline
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: gem_fenced_exec_thrash
results: parsing output: 147/ for test: gem_userptr_blits
results: parsing output: 148/ for test: gem_create
results: parsing output: 149/ for test: syncobj_eventfd
results: parsing output: 150/ for test: kms_rotation_crc
results: parsing output: 151/ for test: gem_exec_reloc
results: parsing output: 152/ for test: kms_flip_scaled_crc
results: parsing output: 153/ for test: kms_plane
results: parsing output: 154/ for test: kms_frontbuffer_tracking
results: parsing output: 155/ for test: gem_exec_schedule
Done.