[67.382289] Initializing watchdogs
[67.382349]   /dev/watchdog0
[67.416806] [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]
[67.432176] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[67.438428] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[67.444853] [001/131] (960s left) gem_ppgtt (blt-vs-render-ctxn)
[67.565926] Starting subtest: blt-vs-render-ctxN
[100.678991] Subtest blt-vs-render-ctxN: SUCCESS (33.110s)
[100.800515] [002/131] (927s left) kms_dp_link_training (non-uhbr-sst)
[100.947814] Starting subtest: non-uhbr-sst
[100.956395] Subtest non-uhbr-sst: SKIP (0.000s)
[101.017164] [003/131] (927s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[101.126630] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[101.130599] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[101.200788] [004/131] (926s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[101.272520] Starting subtest: invalid-multi-wait-unsubmitted
[101.275103] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[101.386338] [005/131] (926s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[101.473637] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[101.477665] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[101.559819] [006/131] (926s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[101.648919] Starting subtest: multiplane-rotation-cropping-top
[119.094750] Subtest multiplane-rotation-cropping-top: SUCCESS (17.448s)
[119.199199] [007/131] (908s left) kms_cursor_crc (cursor-sliding-32x32)
[119.346984] Starting subtest: cursor-sliding-32x32
[119.400917] Subtest cursor-sliding-32x32: SKIP (0.050s)
[119.672225] [008/131] (908s left) perf (gen8-unprivileged-single-ctx-counters)
[119.805076] Starting subtest: gen8-unprivileged-single-ctx-counters
[119.808532] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[119.841589] [009/131] (908s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[119.943319] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[119.946814] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[120.049601] [010/131] (908s left) gem_softpin (32b-excludes-last-page)
[120.113443] Starting subtest: 32b-excludes-last-page
[120.118157] Subtest 32b-excludes-last-page: SUCCESS (0.003s)
[120.252762] [011/131] (908s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[120.343050] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[120.344890] Starting dynamic subtest: pipe-A-eDP-1
[122.531226] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.187s)
[122.538797] Starting dynamic subtest: pipe-B-eDP-1
[124.696345] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.164s)
[124.704053] Starting dynamic subtest: pipe-C-eDP-1
[126.715851] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.018s)
[126.724122] Starting dynamic subtest: pipe-D-eDP-1
[128.775758] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.059s)
[128.777813] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.433s)
[129.961656] [012/131] (898s left) core_auth (basic-auth)
[130.020410] Starting subtest: basic-auth
[130.022655] Subtest basic-auth: SUCCESS (0.001s)
[130.110044] [013/131] (898s left) kms_flip (bo-too-big)
[130.196042] Starting subtest: bo-too-big
[130.197941] Starting dynamic subtest: A-eDP1
[131.509928] Dynamic subtest A-eDP1: SUCCESS (1.316s)
[131.517283] Starting dynamic subtest: B-eDP1
[132.846605] Dynamic subtest B-eDP1: SUCCESS (1.336s)
[132.856816] Starting dynamic subtest: C-eDP1
[134.183980] Dynamic subtest C-eDP1: SUCCESS (1.336s)
[134.194707] Starting dynamic subtest: D-eDP1
[135.530718] Dynamic subtest D-eDP1: SUCCESS (1.345s)
[135.532969] Subtest bo-too-big: SUCCESS (5.341s)
[136.751947] [014/131] (891s left) gem_mmap_gtt (fault-concurrent-x)
[136.807851] Subtest fault-concurrent-X: SKIP (0.000s)
[136.862513] [015/131] (891s left) gem_userptr_blits (map-fixed-invalidate)
[136.924215] Starting subtest: map-fixed-invalidate
[136.928502] Subtest map-fixed-invalidate: SKIP (0.000s)
[137.028145] [016/131] (891s left) gem_exec_reloc (basic-cpu-gtt-active)
[137.088621] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[137.156635] [017/131] (891s left) kms_plane_scaling (planes-upscale-factor-0-25)
[137.248150] Starting subtest: planes-upscale-factor-0-25
[137.250415] Starting dynamic subtest: pipe-A
[137.307994] Dynamic subtest pipe-A: SUCCESS (0.062s)
[137.317441] Starting dynamic subtest: pipe-B
[138.474282] Dynamic subtest pipe-B: SUCCESS (1.165s)
[138.484188] Starting dynamic subtest: pipe-C
[139.587601] Dynamic subtest pipe-C: SUCCESS (1.112s)
[139.597563] Starting dynamic subtest: pipe-D
[140.728640] Dynamic subtest pipe-D: SUCCESS (1.140s)
[140.731204] Subtest planes-upscale-factor-0-25: SUCCESS (3.483s)
[141.874290] [018/131] (886s left) kms_pipe_crc_basic (hang-read-crc)
[141.964778] Starting subtest: hang-read-crc
[141.967164] Starting dynamic subtest: pipe-A-eDP-1
[144.085081] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.117s)
[144.093813] Starting dynamic subtest: pipe-B-eDP-1
[146.807540] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.722s)
[146.823829] Starting dynamic subtest: pipe-C-eDP-1
[149.435467] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.628s)
[149.444065] Starting dynamic subtest: pipe-D-eDP-1
[152.121433] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.681s)
[152.123337] Subtest hang-read-crc: SUCCESS (10.154s)
[152.945121] [019/131] (875s left) gem_exec_balancer (smoke)
[153.015272] Starting subtest: smoke
[175.622279] Subtest smoke: SUCCESS (22.598s)
[177.047451] [020/131] (851s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[177.143612] Starting subtest: addfb25-yf-tiled-legacy
[177.145495] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[177.231422] [021/131] (851s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[177.335767] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[177.338036] Starting dynamic subtest: pipe-A-eDP-1
[177.360806] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[177.370146] Starting dynamic subtest: pipe-B-eDP-1
[177.394280] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[177.402639] Starting dynamic subtest: pipe-C-eDP-1
[177.424062] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[177.432371] Starting dynamic subtest: pipe-D-eDP-1
[177.454429] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[177.458501] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[179.617171] [022/131] (849s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[179.714129] Starting subtest: psr-shrfb-scaledprimary
[185.491332] Subtest psr-shrfb-scaledprimary: SUCCESS (5.779s)
[185.615976] [023/131] (843s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[185.707092] Starting subtest: crc-primary-basic-y-tiled-ccs
[185.709369] Starting dynamic subtest: pipe-A-eDP-1
[185.731795] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[185.741450] Starting dynamic subtest: pipe-B-eDP-1
[185.762601] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[185.772880] Starting dynamic subtest: pipe-C-eDP-1
[185.795383] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[185.803346] Starting dynamic subtest: pipe-D-eDP-1
[185.825270] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[185.829625] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s)
[187.933492] [024/131] (840s left) i915_drm_fdinfo (isolation)
[187.975747] Starting subtest: isolation
[187.977962] Starting dynamic subtest: rcs0
[188.007479] Dynamic subtest rcs0: SKIP (0.030s)
[188.019664] Starting dynamic subtest: bcs0
[188.023893] Dynamic subtest bcs0: SKIP (0.000s)
[188.031265] Starting dynamic subtest: vcs0
[188.034855] Dynamic subtest vcs0: SKIP (0.000s)
[188.042382] Starting dynamic subtest: vcs1
[188.046733] Dynamic subtest vcs1: SKIP (0.000s)
[188.054142] Starting dynamic subtest: vecs0
[188.058474] Dynamic subtest vecs0: SKIP (0.000s)
[188.065862] Starting dynamic subtest: ccs0
[188.070351] Dynamic subtest ccs0: SKIP (0.000s)
[188.075210] Subtest isolation: SKIP (0.036s)
[188.112379] [025/131] (840s left) kms_getfb (getfb2-handle-zero)
[188.202441] Starting subtest: getfb2-handle-zero
[188.204307] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[188.303942] [026/131] (840s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[188.403090] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[189.227275] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.826s)
[189.384555] [027/131] (839s left) kms_cursor_crc (cursor-onscreen-64x21)
[189.573935] Starting subtest: cursor-onscreen-64x21
[189.621845] Subtest cursor-onscreen-64x21: SKIP (0.043s)
[189.873254] [028/131] (839s left) gem_exec_balancer (full-pulse)
[189.938521] Starting subtest: full-pulse
[194.779697] Subtest full-pulse: SUCCESS (4.841s)
[195.136949] [029/131] (833s left) gem_render_copy (linear-to-vebox-yf-tiled)
[195.198904] Starting subtest: linear-to-vebox-yf-tiled
[195.203574] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[195.382109] [030/131] (833s left) gem_mmap_wc (write-read-distinct)
[195.445588] Subtest write-read-distinct: SKIP (0.000s)
[195.503499] [031/131] (833s left) gem_ctx_persistence (userptr)
[195.572568] Starting subtest: userptr
[195.761807] Subtest userptr: SUCCESS (0.189s)
[195.851430] [032/131] (833s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[195.977512] Starting subtest: basic-busy-flip-before-cursor-atomic
[195.982066] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[196.130899] [033/131] (833s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[196.230061] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[196.234221] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[196.334609] [034/131] (832s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[196.392970] Starting subtest: multi-wait-for-submit-submitted-signaled
[196.394843] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[196.492085] [035/131] (832s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[196.614343] Starting subtest: 2x-flip-vs-cursor-legacy
[196.620547] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.002s)
[196.755213] [036/131] (832s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[197.153260] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[197.943179] [037/131] (831s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[198.030679] Starting subtest: plane-lut1d-post-ctm3x4
[198.166072] Starting dynamic subtest: pipe-A-plane-0
[198.520970] Dynamic subtest pipe-A-plane-0: FAIL (0.186s)
[198.530664] Starting dynamic subtest: pipe-A-plane-1
[198.744723] Dynamic subtest pipe-A-plane-1: FAIL (0.153s)
[198.754336] Starting dynamic subtest: pipe-A-plane-2
[198.987588] Dynamic subtest pipe-A-plane-2: FAIL (0.166s)
[199.875524] Starting dynamic subtest: pipe-B-plane-0
[200.317518] Dynamic subtest pipe-B-plane-0: FAIL (0.180s)
[200.331097] Starting dynamic subtest: pipe-B-plane-1
[200.639421] Dynamic subtest pipe-B-plane-1: FAIL (0.160s)
[200.649272] Starting dynamic subtest: pipe-B-plane-2
[200.944954] Dynamic subtest pipe-B-plane-2: FAIL (0.177s)
[201.583693] Starting dynamic subtest: pipe-C-plane-0
[202.067561] Dynamic subtest pipe-C-plane-0: FAIL (0.139s)
[202.076605] Starting dynamic subtest: pipe-C-plane-1
[202.465052] Dynamic subtest pipe-C-plane-1: FAIL (0.155s)
[202.474797] Starting dynamic subtest: pipe-C-plane-2
[202.835651] Dynamic subtest pipe-C-plane-2: FAIL (0.163s)
[203.729599] Starting dynamic subtest: pipe-D-plane-0
[204.335492] Dynamic subtest pipe-D-plane-0: FAIL (0.151s)
[204.345581] Starting dynamic subtest: pipe-D-plane-1
[204.801077] Dynamic subtest pipe-D-plane-1: FAIL (0.615s)
[204.810391] Starting dynamic subtest: pipe-D-plane-2
[205.241815] Dynamic subtest pipe-D-plane-2: FAIL (0.546s)
[205.331835] Subtest plane-lut1d-post-ctm3x4: FAIL (7.301s)
[206.205217] [038/131] (823s left) gem_exec_params (invalid-ring2)
[206.273654] Starting subtest: invalid-ring2
[206.275977] Subtest invalid-ring2: SUCCESS (0.000s)
[206.373827] [039/131] (823s left) core_hotunplug (unbind-rebind)
[206.462362] Starting subtest: unbind-rebind
[210.840552] Subtest unbind-rebind: SUCCESS (4.380s)
[210.887776] [040/131] (818s left) gem_mmap_wc (invalid-flags)
[211.904612] Subtest invalid-flags: SKIP (0.000s)
[211.987414] [041/131] (817s left) syncobj_eventfd (timeline-wait)
[212.052801] Starting subtest: timeline-wait
[212.061661] Subtest timeline-wait: SUCCESS (0.011s)
[212.136369] [042/131] (817s left) prime_vgem (basic-fence-blt)
[212.228368] Starting subtest: basic-fence-blt
[212.307125] Subtest basic-fence-blt: SUCCESS (0.078s)
[212.435069] [FACT prime_vgem (basic-fence-blt)] new: kernel.kmod_is_loaded.vgem: true
[212.438687] [043/131] (817s left) kms_psr (psr2-cursor-mmap-cpu)
[212.536938] Starting subtest: psr2-cursor-mmap-cpu
[212.539261] Starting dynamic subtest: eDP-1
[214.238280] Dynamic subtest eDP-1: SUCCESS (1.699s)
[214.240286] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.701s)
[215.108184] [044/131] (814s left) gem_partial_pwrite_pread (write-display)
[215.177838] Subtest write-display: SKIP (0.000s)
[215.236831] [045/131] (814s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[215.323738] Starting subtest: plane-downscale-factor-0-5-with-rotation
[215.325988] Starting dynamic subtest: pipe-A
[215.343028] Dynamic subtest pipe-A: SKIP (0.016s)
[215.352528] Starting dynamic subtest: pipe-B
[215.379307] Dynamic subtest pipe-B: SKIP (0.035s)
[215.388237] Starting dynamic subtest: pipe-C
[215.413428] Dynamic subtest pipe-C: SKIP (0.033s)
[215.422341] Starting dynamic subtest: pipe-D
[215.448603] Dynamic subtest pipe-D: SKIP (0.034s)
[215.452639] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.120s)
[215.555813] [046/131] (814s left) gem_exec_schedule (fairslice-all)
[215.635128] Starting subtest: fairslice-all
[217.684727] Subtest fairslice-all: SUCCESS (2.054s)
[218.927134] [047/131] (810s left) gem_userptr_blits (probe)
[218.999931] Starting subtest: probe
[219.074044] Subtest probe: SUCCESS (0.073s)
[219.175506] [048/131] (810s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[219.283437] Starting subtest: yf-tiled-8bpp-rotate-90
[219.287489] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[219.391321] [049/131] (810s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[219.495573] Starting subtest: extended-modeset-hang-oldfb-with-reset
[219.497454] Starting dynamic subtest: pipe-A
[231.395794] Dynamic subtest pipe-A: SUCCESS (11.900s)
[231.405993] Starting dynamic subtest: pipe-D
[243.681189] Dynamic subtest pipe-D: SUCCESS (12.281s)
[243.683314] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.186s)
[244.545955] [050/131] (785s left) gem_basic (create-fd-close)
[244.615686] Starting subtest: create-fd-close
[244.620400] Subtest create-fd-close: SUCCESS (0.000s)
[244.724893] [051/131] (785s left) kms_cursor_crc (cursor-size-hints)
[244.844837] Starting subtest: cursor-size-hints
[244.847183] Starting dynamic subtest: pipe-A-eDP-1
[245.462534] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.617s)
[245.471612] Starting dynamic subtest: pipe-D-eDP-1
[246.706447] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.241s)
[246.708424] Subtest cursor-size-hints: SUCCESS (1.860s)
[247.506404] [052/131] (782s left) kms_hdmi_inject (inject-4k)
[247.847754] Starting subtest: inject-4k
[248.163677] Subtest inject-4k: SUCCESS (0.315s)
[248.689105] [053/131] (781s left) kms_big_fb (linear-64bpp-rotate-0)
[248.790938] Starting subtest: linear-64bpp-rotate-0
[250.381042] Subtest linear-64bpp-rotate-0: SUCCESS (1.590s)
[250.565167] [054/131] (779s left) i915_query (query-regions-garbage-items)
[250.626303] Starting subtest: query-regions-garbage-items
[250.628672] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[250.722898] [055/131] (779s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[250.821257] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[250.825577] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[250.919747] [056/131] (779s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[251.019041] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[251.023136] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s)
[251.105234] [057/131] (779s left) kms_hdr (static-toggle)
[251.212105] Starting subtest: static-toggle
[251.218867] Subtest static-toggle: SKIP (0.001s)
[251.300333] [058/131] (778s left) perf_pmu (frequency)
[251.343269] Starting subtest: frequency
[251.345597] Starting dynamic subtest: gt0
[253.458392] Dynamic subtest gt0: SUCCESS (2.110s)
[253.468858] Starting dynamic subtest: idle-gt0
[253.964149] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[253.977861] Starting dynamic subtest: gt1
[258.902395] Dynamic subtest gt1: SUCCESS (4.933s)
[258.913986] Starting dynamic subtest: idle-gt1
[259.406497] Dynamic subtest idle-gt1: SUCCESS (0.504s)
[259.409163] Subtest frequency: SUCCESS (8.067s)
[259.508611] [059/131] (770s left) kms_content_protection (uevent-hdcp14)
[259.646698] Starting subtest: uevent-hdcp14
[259.651257] Subtest uevent-hdcp14: SKIP (0.000s)
[259.781109] [060/131] (770s left) gem_exec_fence (syncobj-channel)
[260.224084] Starting subtest: syncobj-channel
[261.238900] Subtest syncobj-channel: SUCCESS (1.014s)
[262.005206] [061/131] (768s left) sw_sync (sync_random_merge)
[262.036744] Starting subtest: sync_random_merge
[262.079078] Subtest sync_random_merge: SUCCESS (0.043s)
[262.156128] [062/131] (768s left) gen9_exec_parse (bb-start-far)
[262.225905] Subtest bb-start-far: SKIP (0.000s)
[262.287127] [063/131] (768s left) core_auth (getclient-master-drop)
[262.325441] Starting subtest: getclient-master-drop
[262.336321] Subtest getclient-master-drop: SUCCESS (0.015s)
[262.445582] [064/131] (768s left) gem_exec_schedule (u-submit-late-slice)
[262.523596] Starting subtest: u-submit-late-slice
[262.526476] Starting dynamic subtest: rcs0
[262.572782] Dynamic subtest rcs0: SUCCESS (0.056s)
[262.585744] Starting dynamic subtest: bcs0
[262.621695] Dynamic subtest bcs0: SUCCESS (0.048s)
[262.638063] Starting dynamic subtest: vcs0
[262.668750] Dynamic subtest vcs0: SUCCESS (0.046s)
[262.684633] Starting dynamic subtest: vcs1
[262.716079] Dynamic subtest vcs1: SUCCESS (0.046s)
[262.729623] Starting dynamic subtest: vecs0
[262.771940] Dynamic subtest vecs0: SUCCESS (0.054s)
[262.781976] Starting dynamic subtest: ccs0
[262.830085] Dynamic subtest ccs0: SUCCESS (0.058s)
[262.832570] Subtest u-submit-late-slice: SUCCESS (0.315s)
[263.983261] [065/131] (766s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[264.093639] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[264.095832] Starting dynamic subtest: pipe-A-default-mode
[266.795368] Dynamic subtest pipe-A-default-mode: SUCCESS (2.702s)
[266.797801] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.703s)
[267.647500] [066/131] (762s left) gem_lmem_swapping (heavy-verify-random)
[267.694268] Subtest heavy-verify-random: SKIP (0.000s)
[267.744915] [067/131] (762s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[267.850442] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[275.110992] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.263s)
[275.238051] [068/131] (755s left) api_intel_allocator (reserve-simple)
[275.299877] Starting subtest: reserve-simple
[275.302345] Subtest reserve-simple: SUCCESS (0.003s)
[275.423030] [069/131] (755s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[275.535322] Starting subtest: fbc-rgb565-draw-mmap-gtt
[275.539887] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[275.639744] [070/131] (755s left) kms_feature_discovery (display-4x)
[275.747710] Starting subtest: display-4x
[275.752119] Subtest display-4x: SKIP (0.000s)
[275.824614] [071/131] (754s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[275.933048] Starting subtest: fbc-psr2-sprite-mmap-gtt
[275.935200] Starting dynamic subtest: eDP-1
[275.939180] Dynamic subtest eDP-1: SKIP (0.000s)
[275.943143] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[276.005289] [072/131] (754s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[276.059760] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[276.061498] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[276.144354] [073/131] (754s left) i915_pm_rpm (gem-evict-pwrite)
[278.076779] Starting subtest: gem-evict-pwrite
[278.082090] Subtest gem-evict-pwrite: SKIP (0.000s)
[278.454289] [074/131] (752s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[278.554374] Starting subtest: fbc-psr2-cursor-mmap-cpu
[278.556275] Starting dynamic subtest: eDP-1
[278.560162] Dynamic subtest eDP-1: SKIP (0.000s)
[278.564187] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[278.627876] [075/131] (752s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[278.725079] Starting subtest: y-tiled-16bpp-rotate-0
[278.729325] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[278.829424] [076/131] (752s left) gem_mmap_gtt (big-copy-xy)
[278.894661] Subtest big-copy-XY: SKIP (0.000s)
[278.950364] [077/131] (752s left) kms_vrr (negative-basic)
[279.049930] Starting subtest: negative-basic
[279.056693] Starting dynamic subtest: pipe-A-eDP-1
[284.471180] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.413s)
[284.751314] Subtest negative-basic: SUCCESS (5.701s)
[285.550938] [078/131] (745s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[285.647035] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[286.614290] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.967s)
[286.737253] [079/131] (744s left) gem_wait (invalid-buf)
[286.804618] Starting subtest: invalid-buf
[286.806867] Subtest invalid-buf: SUCCESS (0.000s)
[287.003790] [080/131] (744s left) kms_psr (psr2-suspend)
[287.096908] Starting subtest: psr2-suspend
[287.099144] Starting dynamic subtest: eDP-1
[305.193356] Dynamic subtest eDP-1: SUCCESS (2.984s)
[305.195512] Subtest psr2-suspend: SUCCESS (2.985s)
[306.041864] [081/131] (725s left) sw_sync (sync_merge)
[306.084903] Starting subtest: sync_merge
[306.087136] Subtest sync_merge: SUCCESS (0.000s)
[306.144756] [082/131] (725s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[306.204371] Starting subtest: multi-wait-available-unsubmitted-submitted
[306.207061] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[306.319958] [083/131] (724s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[306.445160] Starting subtest: cursorB-vs-flipA-atomic
[306.450031] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[306.592385] [084/131] (724s left) gem_exec_fence (basic-busy-all)
[306.643405] Starting subtest: basic-busy-all
[306.722292] Subtest basic-busy-all: SUCCESS (0.080s)
[309.106820] [085/131] (722s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[309.211438] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[309.213638] Starting dynamic subtest: pipe-A-eDP-1
[309.238183] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[309.251909] Starting dynamic subtest: pipe-B-eDP-1
[309.271623] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[309.281316] Starting dynamic subtest: pipe-C-eDP-1
[309.304221] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[309.313371] Starting dynamic subtest: pipe-D-eDP-1
[309.336716] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[309.340993] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[311.450460] [086/131] (719s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[311.545110] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[311.549229] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[311.633167] [087/131] (719s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[311.721322] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[311.723603] Starting dynamic subtest: pipe-A-eDP-1
[312.191823] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.444s)
[312.203635] Starting dynamic subtest: pipe-B-eDP-1
[313.674281] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.480s)
[313.686374] Starting dynamic subtest: pipe-C-eDP-1
[315.099216] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.421s)
[315.111677] Starting dynamic subtest: pipe-D-eDP-1
[316.485464] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.384s)
[316.487623] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.734s)
[317.641242] [088/131] (713s left) sysfs_timeslice_duration (duration)
[317.697211] Starting subtest: duration
[317.699449] Starting dynamic subtest: vecs0
[330.941803] Dynamic subtest vecs0: SUCCESS (13.236s)
[330.954662] Starting dynamic subtest: ccs0
[344.083849] Dynamic subtest ccs0: SUCCESS (13.145s)
[344.096319] Starting dynamic subtest: vcs0
[358.909632] Dynamic subtest vcs0: SUCCESS (14.825s)
[358.922451] Starting dynamic subtest: bcs0
[372.041421] Dynamic subtest bcs0: SUCCESS (13.130s)
[372.054643] Starting dynamic subtest: rcs0
[385.176393] Dynamic subtest rcs0: SUCCESS (13.132s)
[385.189174] Starting dynamic subtest: vcs1
[399.932436] Dynamic subtest vcs1: SUCCESS (14.750s)
[399.935062] Subtest duration: SUCCESS (82.235s)
[400.010443] [089/131] (631s left) gem_tiled_partial_pwrite_pread (reads)
[400.073051] Subtest reads: SKIP (0.000s)
[400.136361] [090/131] (631s left) kms_flip (nonexisting-fb)
[400.230877] Starting subtest: nonexisting-fb
[400.233092] Starting dynamic subtest: A-eDP1
[401.393242] Dynamic subtest A-eDP1: SUCCESS (1.164s)
[401.403975] Starting dynamic subtest: B-eDP1
[402.591940] Dynamic subtest B-eDP1: SUCCESS (1.198s)
[402.602789] Starting dynamic subtest: C-eDP1
[403.793956] Dynamic subtest C-eDP1: SUCCESS (1.201s)
[403.805144] Starting dynamic subtest: D-eDP1
[404.999209] Dynamic subtest D-eDP1: SUCCESS (1.204s)
[405.004023] Subtest nonexisting-fb: SUCCESS (4.777s)
[406.241261] [091/131] (625s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[406.335747] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[406.337981] Starting dynamic subtest: pipe-A-eDP-1
[417.643595] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.314s)
[417.654786] Starting dynamic subtest: pipe-B-eDP-1
[429.611058] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.967s)
[429.613335] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.283s)
[430.439185] [092/131] (601s left) kms_async_flips (test-cursor)
[430.536755] Starting subtest: test-cursor
[430.924965] Starting dynamic subtest: pipe-A-eDP-1
[431.672288] Dynamic subtest pipe-A-eDP-1: SKIP (0.744s)
[432.052062] Starting dynamic subtest: pipe-B-eDP-1
[432.776224] Dynamic subtest pipe-B-eDP-1: SKIP (0.729s)
[433.151290] Starting dynamic subtest: pipe-C-eDP-1
[433.882537] Dynamic subtest pipe-C-eDP-1: SKIP (0.736s)
[434.239401] Starting dynamic subtest: pipe-D-eDP-1
[434.977435] Dynamic subtest pipe-D-eDP-1: SKIP (0.743s)
[434.981418] Subtest test-cursor: SKIP (4.439s)
[436.166097] [093/131] (595s left) gem_mmap_offset (partial-remap)
[436.221590] Starting subtest: partial-remap
[436.223831] Starting dynamic subtest: smem0
[436.232710] Dynamic subtest smem0: SUCCESS (0.004s)
[436.234984] Subtest partial-remap: SUCCESS (0.004s)
[436.345460] [094/131] (595s left) gem_ctx_shared (q-smoketest)
[436.401639] Starting subtest: Q-smoketest
[436.403851] Starting dynamic subtest: rcs0
[441.946714] Dynamic subtest rcs0: SUCCESS (5.499s)
[441.958636] Starting dynamic subtest: bcs0
[447.452129] Dynamic subtest bcs0: SUCCESS (5.500s)
[447.464259] Starting dynamic subtest: vcs0
[452.935507] Dynamic subtest vcs0: SUCCESS (5.483s)
[452.945669] Starting dynamic subtest: vcs1
[458.423241] Dynamic subtest vcs1: SUCCESS (5.483s)
[458.436167] Starting dynamic subtest: vecs0
[463.893913] Dynamic subtest vecs0: SUCCESS (5.472s)
[463.905115] Starting dynamic subtest: ccs0
[469.392069] Dynamic subtest ccs0: SUCCESS (5.495s)
[469.394400] Subtest Q-smoketest: SUCCESS (32.940s)
[469.534970] [095/131] (562s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[469.671075] Starting subtest: cursorA-vs-flipB-legacy
[469.675566] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[469.828672] [096/131] (562s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[469.925249] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[469.929514] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[470.013412] [097/131] (561s left) kms_vblank (query-idle)
[470.102611] Starting subtest: query-idle
[470.104710] Starting dynamic subtest: pipe-A-eDP-1
[471.844783] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.742s)
[471.860636] Starting dynamic subtest: pipe-D-eDP-1
[474.335332] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.484s)
[474.337692] Subtest query-idle: SUCCESS (4.231s)
[475.128117] [098/131] (556s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[475.221676] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[475.225704] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[475.286334] [099/131] (556s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[475.390853] Starting subtest: fbcpsr-suspend
[515.375605] Subtest fbcpsr-suspend: SUCCESS (9.927s)
[515.506620] [100/131] (516s left) gem_mmap_gtt (basic-small-bo)
[515.565853] Subtest basic-small-bo: SKIP (0.000s)
[515.624270] [101/131] (516s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[515.720000] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[515.724852] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[515.786883] [102/131] (516s left) kms_chamelium_color (ctm-red-to-blue)
[515.876945] Subtest ctm-red-to-blue: SKIP (0.000s)
[515.924660] [103/131] (516s left) kms_lease (simple-lease)
[516.009168] Starting subtest: simple-lease
[516.011613] Starting dynamic subtest: pipe-A-eDP-1
[516.515745] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.504s)
[516.527922] Starting dynamic subtest: pipe-B-eDP-1
[517.920319] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.400s)
[517.930947] Starting dynamic subtest: pipe-C-eDP-1
[519.311567] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.388s)
[519.323396] Starting dynamic subtest: pipe-D-eDP-1
[520.728017] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.409s)
[520.730365] Subtest simple-lease: SUCCESS (4.711s)
[521.525697] [104/131] (510s left) gem_eio (in-flight-internal-10ms)
[521.759674] Starting subtest: in-flight-internal-10ms
[523.159131] Subtest in-flight-internal-10ms: SUCCESS (1.398s)
[523.309967] [105/131] (508s left) gem_ctx_isolation (preservation-s3)
[523.370188] Starting subtest: preservation-S3
[523.373170] Starting dynamic subtest: rcs0
[539.786052] Dynamic subtest rcs0: SUCCESS (1.312s)
[539.798017] Starting dynamic subtest: bcs0
[555.788433] Dynamic subtest bcs0: SUCCESS (1.315s)
[555.800138] Starting dynamic subtest: vcs0
[571.779152] Dynamic subtest vcs0: SUCCESS (3.138s)
[571.790265] Starting dynamic subtest: vcs1
[589.793503] Dynamic subtest vcs1: SUCCESS (4.985s)
[589.804498] Starting dynamic subtest: vecs0
[607.799559] Dynamic subtest vecs0: SUCCESS (5.021s)
[607.817474] Starting dynamic subtest: ccs0
[625.790392] Dynamic subtest ccs0: SUCCESS (3.191s)
[625.792858] Subtest preservation-S3: SUCCESS (18.969s)
[626.048078] [106/131] (406s left) kms_pm_rpm (dpms-lpsp)
[627.686661] Starting subtest: dpms-lpsp
[628.249354] Subtest dpms-lpsp: SUCCESS (0.562s)
[628.348837] [107/131] (403s left) gem_bad_reloc (negative-reloc-lut)
[628.419747] Subtest negative-reloc-lut: SKIP (0.000s)
[628.480559] [108/131] (403s left) gem_render_copy (y-tiled)
[628.538705] Starting subtest: y-tiled
[628.543282] Subtest y-tiled: SKIP (0.000s)
[628.730582] [109/131] (403s left) gem_ccs (large-ctrl-surf-copy)
[628.790745] Starting subtest: large-ctrl-surf-copy
[628.795200] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[628.891328] [110/131] (403s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[628.986878] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[635.952197] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (6.958s)
[636.082367] [111/131] (396s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[636.198927] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[642.770235] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.566s)
[642.940290] [112/131] (389s left) perf_pmu (most-busy-idle-check-all)
[642.995795] Starting subtest: most-busy-idle-check-all
[642.998130] Starting dynamic subtest: rcs0
[643.696293] Dynamic subtest rcs0: FAIL (0.624s)
[643.707842] Starting dynamic subtest: bcs0
[644.523495] Dynamic subtest bcs0: SUCCESS (0.901s)
[644.536597] Starting dynamic subtest: vcs0
[646.507733] Dynamic subtest vcs0: SUCCESS (1.980s)
[646.520183] Starting dynamic subtest: vcs1
[648.491517] Dynamic subtest vcs1: SUCCESS (1.980s)
[648.503899] Starting dynamic subtest: vecs0
[650.538990] Dynamic subtest vecs0: SUCCESS (2.043s)
[650.552058] Starting dynamic subtest: ccs0
[652.523711] Dynamic subtest ccs0: SUCCESS (1.980s)
[652.526388] Subtest most-busy-idle-check-all: FAIL (9.523s)
[652.633180] [113/131] (379s left) gem_softpin (allocator-nopin-reserve)
[652.691483] Starting subtest: allocator-nopin-reserve
[652.768086] Subtest allocator-nopin-reserve: SUCCESS (0.079s)
[652.894665] [114/131] (379s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[653.002218] Starting subtest: x-tiled-8bpp-rotate-180
[654.193553] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.191s)
[654.317847] [115/131] (378s left) syncobj_wait (invalid-reset-zero-handles)
[654.375535] Starting subtest: invalid-reset-zero-handles
[654.377531] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[654.458383] [116/131] (378s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[654.560296] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[654.564163] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[654.656880] [117/131] (378s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[654.779780] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[686.228687] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.447s)
[687.030444] [118/131] (345s left) gem_pxp (create-regular-context-1)
[687.169989] Starting subtest: create-regular-context-1
[687.172472] Subtest create-regular-context-1: SUCCESS (0.002s)
[687.288874] [119/131] (345s left) syncobj_wait (single-wait-signaled)
[687.347754] Starting subtest: single-wait-signaled
[687.349674] Subtest single-wait-signaled: SUCCESS (0.000s)
[687.463393] [120/131] (345s left) gem_ctx_param (invalid-ctx-get)
[687.520925] Starting subtest: invalid-ctx-get
[687.523217] Subtest invalid-ctx-get: SUCCESS (0.000s)
[687.598011] [121/131] (345s left) gem_exec_schedule (u-independent)
[687.682603] Starting subtest: u-independent
[687.684605] Starting dynamic subtest: rcs0
[689.517933] Dynamic subtest rcs0: SUCCESS (1.844s)
[689.539434] Starting dynamic subtest: vcs0
[691.507201] Dynamic subtest vcs0: SUCCESS (1.985s)
[691.519785] Starting dynamic subtest: vcs1
[693.499317] Dynamic subtest vcs1: SUCCESS (1.989s)
[693.512158] Starting dynamic subtest: vecs0
[695.542406] Dynamic subtest vecs0: SUCCESS (2.040s)
[695.559418] Starting dynamic subtest: ccs0
[697.514915] Dynamic subtest ccs0: SUCCESS (1.969s)
[697.517752] Subtest u-independent: SUCCESS (9.839s)
[697.820553] [122/131] (335s left) kms_flip (2x-plain-flip-fb-recreate)
[697.924319] Starting subtest: 2x-plain-flip-fb-recreate
[697.934887] Subtest 2x-plain-flip-fb-recreate: SKIP (0.010s)
[698.031634] [123/131] (334s left) syncobj_timeline (wait-any-interrupted)
[698.095406] Starting subtest: wait-any-interrupted
[698.198768] Subtest wait-any-interrupted: SUCCESS (0.103s)
[698.291339] [124/131] (334s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[698.387087] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[698.391213] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[698.497759] [125/131] (334s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[698.609206] Starting subtest: fbcpsr-indfb-scaledprimary
[704.282326] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.674s)
[704.422149] [126/131] (328s left) kms_plane_multiple (2x-tiling-yf)
[704.524911] Starting subtest: 2x-tiling-yf
[704.529331] Subtest 2x-tiling-yf: SKIP (0.000s)
[704.597571] [127/131] (328s left) i915_drm_fdinfo (virtual-busy-hang-all)
[704.644268] Starting subtest: virtual-busy-hang-all
[704.648395] Subtest virtual-busy-hang-all: SKIP (0.000s)
[704.708006] [128/131] (328s left) kms_sequence (get-forked-busy)
[704.803870] Starting subtest: get-forked-busy
[704.805809] Starting dynamic subtest: pipe-A-eDP-1
[706.729778] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.927s)
[706.744260] Starting dynamic subtest: pipe-B-eDP-1
[709.293815] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.559s)
[709.304849] Starting dynamic subtest: pipe-C-eDP-1
[711.876352] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.583s)
[711.887874] Starting dynamic subtest: pipe-D-eDP-1
[714.458207] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.577s)
[714.460345] Subtest get-forked-busy: SUCCESS (9.651s)
[715.319782] [129/131] (317s left) gem_exec_schedule (preempt-engines)
[715.392850] Starting subtest: preempt-engines
[715.395072] Starting dynamic subtest: rcs0
[717.636399] Dynamic subtest rcs0: SUCCESS (2.248s)
[717.650953] Starting dynamic subtest: bcs0
[719.849098] Dynamic subtest bcs0: SUCCESS (2.210s)
[719.861483] Starting dynamic subtest: vcs0
[722.131065] Dynamic subtest vcs0: SUCCESS (2.279s)
[722.144126] Starting dynamic subtest: vcs1
[724.419014] Dynamic subtest vcs1: SUCCESS (2.285s)
[724.437559] Starting dynamic subtest: vecs0
[726.683697] Dynamic subtest vecs0: SUCCESS (2.264s)
[726.700076] Starting dynamic subtest: ccs0
[728.975188] Dynamic subtest ccs0: SUCCESS (2.291s)
[728.977507] Subtest preempt-engines: SUCCESS (13.589s)
[729.280179] [130/131] (304s left) gem_close (basic)
[729.335699] Starting subtest: basic
[729.338012] Subtest basic: SUCCESS (0.000s)
[729.443847] [131/131] (303s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[729.544916] Starting subtest: fbcpsr-tiling-4
[736.615201] Subtest fbcpsr-tiling-4: SUCCESS (7.075s)
[736.739117] Closing watchdogs
results: parsing output: 0/ for test: gem_ppgtt
results: parsing output: 1/ for test: kms_dp_link_training
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_rotation_crc
results: parsing output: 6/ for test: kms_cursor_crc
results: parsing output: 7/ for test: perf
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_softpin
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: core_auth
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: gem_mmap_gtt
results: parsing output: 14/ for test: gem_userptr_blits
results: parsing output: 15/ for test: gem_exec_reloc
results: parsing output: 16/ for test: kms_plane_scaling
results: parsing output: 17/ for test: kms_pipe_crc_basic
results: parsing output: 18/ for test: gem_exec_balancer
results: parsing output: 19/ for test: kms_addfb_basic
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: i915_drm_fdinfo
results: parsing output: 24/ for test: kms_getfb
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_cursor_crc
results: parsing output: 27/ for test: gem_exec_balancer
results: parsing output: 28/ for test: gem_render_copy
results: parsing output: 29/ for test: gem_mmap_wc
results: parsing output: 30/ for test: gem_ctx_persistence
results: parsing output: 31/ for test: kms_cursor_legacy
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: syncobj_wait
results: parsing output: 34/ for test: kms_cursor_legacy
results: parsing output: 35/ for test: kms_chamelium_hpd
results: parsing output: 36/ for test: kms_color_pipeline
results: parsing output: 37/ for test: gem_exec_params
results: parsing output: 38/ for test: core_hotunplug
results: parsing output: 39/ for test: gem_mmap_wc
results: parsing output: 40/ for test: syncobj_eventfd
results: parsing output: 41/ for test: prime_vgem
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: gem_partial_pwrite_pread
results: parsing output: 44/ for test: kms_plane_scaling
results: parsing output: 45/ for test: gem_exec_schedule
results: parsing output: 46/ for test: gem_userptr_blits
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: kms_busy
results: parsing output: 49/ for test: gem_basic
results: parsing output: 50/ for test: kms_cursor_crc
results: parsing output: 51/ for test: kms_hdmi_inject
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: i915_query
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_flip_scaled_crc
results: parsing output: 56/ for test: kms_hdr
results: parsing output: 57/ for test: perf_pmu
results: parsing output: 58/ for test: kms_content_protection
results: parsing output: 59/ for test: gem_exec_fence
results: parsing output: 60/ for test: sw_sync
results: parsing output: 61/ for test: gen9_exec_parse
results: parsing output: 62/ for test: core_auth
results: parsing output: 63/ for test: gem_exec_schedule
results: parsing output: 64/ for test: kms_flip_scaled_crc
results: parsing output: 65/ for test: gem_lmem_swapping
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: api_intel_allocator
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_feature_discovery
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: i915_pm_rpm
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: gem_mmap_gtt
results: parsing output: 76/ for test: kms_vrr
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: gem_wait
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: sw_sync
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: kms_cursor_legacy
results: parsing output: 83/ for test: gem_exec_fence
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: kms_plane
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: sysfs_timeslice_duration
results: parsing output: 88/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: kms_psr2_sf
results: parsing output: 91/ for test: kms_async_flips
results: parsing output: 92/ for test: gem_mmap_offset
results: parsing output: 93/ for test: gem_ctx_shared
results: parsing output: 94/ for test: kms_cursor_legacy
results: parsing output: 95/ for test: kms_flip_scaled_crc
results: parsing output: 96/ for test: kms_vblank
results: parsing output: 97/ for test: kms_psr2_sf
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_mmap_gtt
results: parsing output: 100/ for test: kms_psr2_sf
results: parsing output: 101/ for test: kms_chamelium_color
results: parsing output: 102/ for test: kms_lease
results: parsing output: 103/ for test: gem_eio
results: parsing output: 104/ for test: gem_ctx_isolation
results: parsing output: 105/ for test: kms_pm_rpm
results: parsing output: 106/ for test: gem_bad_reloc
results: parsing output: 107/ for test: gem_render_copy
results: parsing output: 108/ for test: gem_ccs
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: perf_pmu
results: parsing output: 112/ for test: gem_softpin
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: syncobj_wait
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_cursor_legacy
results: parsing output: 117/ for test: gem_pxp
results: parsing output: 118/ for test: syncobj_wait
results: parsing output: 119/ for test: gem_ctx_param
results: parsing output: 120/ for test: gem_exec_schedule
results: parsing output: 121/ for test: kms_flip
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_plane_multiple
results: parsing output: 126/ for test: i915_drm_fdinfo
results: parsing output: 127/ for test: kms_sequence
results: parsing output: 128/ for test: gem_exec_schedule
results: parsing output: 129/ for test: gem_close
results: parsing output: 130/ for test: kms_frontbuffer_tracking
Done.