[59.199338] Initializing watchdogs
[59.199385]   /dev/watchdog0
[59.213423] [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]
[59.217849] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.220306] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.223645] [001/133] (960s left) kms_pm_rpm (fences)
[61.021588] Starting subtest: fences
[61.026448] Subtest fences: SKIP (0.000s)
[61.546590] [002/133] (958s left) i915_query (query-topology-coherent-slice-mask)
[61.607841] Starting subtest: query-topology-coherent-slice-mask
[61.612164] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[61.716866] [003/133] (958s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[61.800989] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[61.803429] Starting dynamic subtest: pipe-A-eDP-1
[61.829498] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[61.837315] Starting dynamic subtest: pipe-B-eDP-1
[61.861365] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[61.868412] Starting dynamic subtest: pipe-C-eDP-1
[61.892530] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[61.899635] Starting dynamic subtest: pipe-D-eDP-1
[61.924067] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[61.928238] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[63.984155] [004/133] (955s left) gem_exec_schedule (fairslice)
[64.051105] Starting subtest: fairslice
[64.053114] Starting dynamic subtest: rcs0
[66.069482] Dynamic subtest rcs0: SUCCESS (2.021s)
[66.078872] Starting dynamic subtest: bcs0
[68.086525] Dynamic subtest bcs0: SUCCESS (2.018s)
[68.096057] Starting dynamic subtest: vcs0
[70.109113] Dynamic subtest vcs0: SUCCESS (2.021s)
[70.116276] Starting dynamic subtest: vcs1
[72.127559] Dynamic subtest vcs1: SUCCESS (2.019s)
[72.137549] Starting dynamic subtest: vecs0
[74.148536] Dynamic subtest vecs0: SUCCESS (2.018s)
[74.157468] Starting dynamic subtest: ccs0
[76.167854] Dynamic subtest ccs0: SUCCESS (2.019s)
[76.169965] Subtest fairslice: SUCCESS (12.120s)
[76.463666] [005/133] (943s left) kms_cursor_edge_walk (256x256-right-edge)
[76.568132] Starting subtest: 256x256-right-edge
[76.570399] Starting dynamic subtest: pipe-A-eDP-1
[80.065489] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.497s)
[80.074183] Starting dynamic subtest: pipe-D-eDP-1
[83.191600] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[83.193549] Subtest 256x256-right-edge: SUCCESS (6.623s)
[83.986439] [006/133] (935s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[84.084841] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[90.970458] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.888s)
[91.092519] [007/133] (928s left) gem_eio (in-flight-immediate)
[91.315964] Starting subtest: in-flight-immediate
[99.569605] Subtest in-flight-immediate: SUCCESS (8.253s)
[99.714985] [FACT gem_eio (in-flight-immediate)] new: kernel.kmod_is_loaded.vgem: true
[99.718168] [008/133] (920s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[99.808659] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[99.810802] Starting dynamic subtest: pipe-A-eDP-1
[99.833563] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[99.842545] Starting dynamic subtest: pipe-B-eDP-1
[99.863173] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[99.870463] Starting dynamic subtest: pipe-C-eDP-1
[99.891458] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[99.899199] Starting dynamic subtest: pipe-D-eDP-1
[99.920780] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[99.924879] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[102.094702] [009/133] (917s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[102.165762] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[102.227483] [010/133] (917s left) kms_rotation_crc (exhaust-fences)
[102.328345] Starting subtest: exhaust-fences
[102.332830] Subtest exhaust-fences: SKIP (0.000s)
[102.402195] [011/133] (917s left) gem_close (basic)
[102.466763] Starting subtest: basic
[102.468997] Subtest basic: SUCCESS (0.000s)
[102.562776] [012/133] (917s left) kms_chamelium_hpd (common-hpd-after-suspend)
[102.943342] Subtest common-hpd-after-suspend: SKIP (0.000s)
[103.802486] [013/133] (916s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[103.929065] Starting subtest: short-flip-before-cursor-toggle
[104.863559] Subtest short-flip-before-cursor-toggle: SUCCESS (0.936s)
[105.684390] [014/133] (914s left) core_setmaster_vs_auth
[105.829519] [015/133] (914s left) gem_pwrite (basic-random)
[105.886032] Subtest basic-random: SKIP (0.000s)
[105.943481] [016/133] (914s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[106.043255] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[106.047325] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[106.135909] [017/133] (914s left) kms_pm_rpm (modeset-non-lpsp-stress)
[108.054847] Starting subtest: modeset-non-lpsp-stress
[109.223645] Subtest modeset-non-lpsp-stress: SKIP (1.166s)
[109.615196] [018/133] (910s left) kms_flip (2x-flip-vs-expired-vblank)
[109.717478] Starting subtest: 2x-flip-vs-expired-vblank
[109.728030] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s)
[109.817338] [019/133] (910s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[109.916625] Starting subtest: plane-lut1d-ctm3x4-lut1d
[110.039475] Starting dynamic subtest: pipe-A-plane-0
[110.194665] Dynamic subtest pipe-A-plane-0: SUCCESS (0.156s)
[110.202931] Starting dynamic subtest: pipe-A-plane-1
[110.328307] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[110.336797] Starting dynamic subtest: pipe-A-plane-2
[110.461984] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[111.688077] Starting dynamic subtest: pipe-B-plane-0
[111.838690] Dynamic subtest pipe-B-plane-0: SUCCESS (0.155s)
[111.847365] Starting dynamic subtest: pipe-B-plane-1
[111.981347] Dynamic subtest pipe-B-plane-1: SUCCESS (0.144s)
[111.989722] Starting dynamic subtest: pipe-B-plane-2
[112.125393] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[113.308845] Starting dynamic subtest: pipe-C-plane-0
[113.447435] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[113.455850] Starting dynamic subtest: pipe-C-plane-1
[113.580960] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s)
[113.590455] Starting dynamic subtest: pipe-C-plane-2
[113.726197] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[114.972265] Starting dynamic subtest: pipe-D-plane-0
[115.120491] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[115.128993] Starting dynamic subtest: pipe-D-plane-1
[115.264986] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[115.273813] Starting dynamic subtest: pipe-D-plane-2
[115.420730] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[115.711714] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (5.795s)
[116.517945] [020/133] (903s left) gem_spin_batch (spin-all-new)
[116.575866] Starting subtest: spin-all-new
[116.590493] Subtest spin-all-new: SUCCESS (0.014s)
[117.960299] [021/133] (902s left) kms_psr (psr-primary-render)
[118.060317] Starting subtest: psr-primary-render
[118.062710] Starting dynamic subtest: eDP-1
[119.824652] Dynamic subtest eDP-1: SUCCESS (1.763s)
[119.827019] Subtest psr-primary-render: SUCCESS (1.764s)
[120.688998] [022/133] (899s left) kms_plane_cursor (overlay)
[120.780327] Starting subtest: overlay
[120.784776] Starting dynamic subtest: pipe-A-eDP-1-size-64
[123.256309] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.478s)
[123.315560] Starting dynamic subtest: pipe-A-eDP-1-size-128
[125.713827] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.405s)
[125.773306] Starting dynamic subtest: pipe-A-eDP-1-size-256
[128.225451] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.461s)
[128.571059] Starting dynamic subtest: pipe-B-eDP-1-size-64
[131.720794] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.158s)
[131.779548] Starting dynamic subtest: pipe-B-eDP-1-size-128
[134.221919] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.449s)
[134.281210] Starting dynamic subtest: pipe-B-eDP-1-size-256
[136.766972] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.494s)
[137.114824] Starting dynamic subtest: pipe-C-eDP-1-size-64
[139.953022] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.849s)
[139.990121] Starting dynamic subtest: pipe-C-eDP-1-size-128
[142.120368] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.136s)
[142.156355] Starting dynamic subtest: pipe-C-eDP-1-size-256
[144.253655] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.103s)
[144.586928] Starting dynamic subtest: pipe-D-eDP-1-size-64
[147.428581] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.852s)
[147.465816] Starting dynamic subtest: pipe-D-eDP-1-size-128
[149.484712] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.025s)
[149.521068] Starting dynamic subtest: pipe-D-eDP-1-size-256
[151.595431] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.080s)
[151.919638] Subtest overlay: SUCCESS (31.140s)
[152.728979] [023/133] (867s left) gen9_exec_parse (batch-zero-length)
[152.792819] Subtest batch-zero-length: SKIP (0.000s)
[152.854641] [024/133] (867s left) gem_exec_balancer (parallel-contexts)
[153.111962] Starting subtest: parallel-contexts
[156.258125] Subtest parallel-contexts: SUCCESS (3.150s)
[157.100719] [025/133] (863s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[157.199655] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[157.204077] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[157.283108] [026/133] (863s left) gem_mmap_gtt (big-bo-tiledy)
[157.335405] Subtest big-bo-tiledY: SKIP (0.000s)
[157.396462] [027/133] (863s left) gem_wait (write-wait)
[157.460647] Starting subtest: write-wait
[157.462464] Starting dynamic subtest: all-engines
[158.564454] Dynamic subtest all-engines: SUCCESS (1.106s)
[158.577058] Starting dynamic subtest: rcs0
[159.632543] Dynamic subtest rcs0: SUCCESS (1.064s)
[159.650903] Starting dynamic subtest: bcs0
[160.693303] Dynamic subtest bcs0: SUCCESS (1.058s)
[160.710060] Starting dynamic subtest: vcs0
[161.750737] Dynamic subtest vcs0: SUCCESS (1.055s)
[161.766463] Starting dynamic subtest: vcs1
[162.805942] Dynamic subtest vcs1: SUCCESS (1.053s)
[162.822060] Starting dynamic subtest: vecs0
[163.859567] Dynamic subtest vecs0: SUCCESS (1.051s)
[163.875246] Starting dynamic subtest: ccs0
[164.916729] Dynamic subtest ccs0: SUCCESS (1.055s)
[164.919676] Subtest write-wait: SUCCESS (7.459s)
[165.124563] [028/133] (855s left) kms_psr (fbc-psr-sprite-plane-move)
[165.221218] Starting subtest: fbc-psr-sprite-plane-move
[165.223562] Starting dynamic subtest: eDP-1
[165.227684] Dynamic subtest eDP-1: SKIP (0.000s)
[165.231830] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[165.293348] [029/133] (855s left) sysfs_timeslice_duration (invalid)
[165.352439] Starting subtest: invalid
[165.354725] Starting dynamic subtest: vecs0
[165.357068] Dynamic subtest vecs0: SUCCESS (0.000s)
[165.366255] Starting dynamic subtest: ccs0
[165.368082] Dynamic subtest ccs0: SUCCESS (0.000s)
[165.375546] Starting dynamic subtest: vcs0
[165.377460] Dynamic subtest vcs0: SUCCESS (0.000s)
[165.384726] Starting dynamic subtest: bcs0
[165.386585] Dynamic subtest bcs0: SUCCESS (0.000s)
[165.393839] Starting dynamic subtest: rcs0
[165.395661] Dynamic subtest rcs0: SUCCESS (0.000s)
[165.402808] Starting dynamic subtest: vcs1
[165.405123] Dynamic subtest vcs1: SUCCESS (0.000s)
[165.407277] Subtest invalid: SUCCESS (0.006s)
[165.460763] [030/133] (855s left) kms_psr (pr-sprite-plane-onoff)
[165.557899] Starting subtest: pr-sprite-plane-onoff
[165.562157] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[165.633176] [031/133] (855s left) kms_cursor_crc (cursor-offscreen-256x256)
[165.898710] Starting subtest: cursor-offscreen-256x256
[165.904030] Starting dynamic subtest: pipe-A-eDP-1
[167.859168] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.954s)
[167.887646] Starting dynamic subtest: pipe-D-eDP-1
[170.458216] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.577s)
[170.460404] Subtest cursor-offscreen-256x256: SUCCESS (4.559s)
[171.285500] [032/133] (849s left) gem_ctx_persistence (engines-hostile)
[171.346897] Starting subtest: engines-hostile
[171.349232] Starting dynamic subtest: rcs0
[171.404816] Dynamic subtest rcs0: SUCCESS (0.057s)
[171.415975] Starting dynamic subtest: bcs0
[171.491224] Dynamic subtest bcs0: SUCCESS (0.085s)
[171.503091] Starting dynamic subtest: vcs0
[171.572599] Dynamic subtest vcs0: SUCCESS (0.079s)
[171.582438] Starting dynamic subtest: vcs1
[171.706417] Dynamic subtest vcs1: SUCCESS (0.132s)
[171.716091] Starting dynamic subtest: vecs0
[171.823756] Dynamic subtest vecs0: SUCCESS (0.115s)
[171.835139] Starting dynamic subtest: ccs0
[171.926737] Dynamic subtest ccs0: SUCCESS (0.101s)
[171.929302] Subtest engines-hostile: SUCCESS (0.581s)
[172.004473] [033/133] (848s left) gem_exec_reloc (basic-gtt-read-active)
[172.076268] Subtest basic-gtt-read-active: SKIP (0.000s)
[172.160462] [034/133] (848s left) gem_workarounds (basic-read)
[172.227063] Starting subtest: basic-read
[172.235327] Subtest basic-read: SUCCESS (0.011s)
[172.337018] [035/133] (848s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[172.402663] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[172.404753] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s)
[172.503063] [036/133] (848s left) i915_drm_fdinfo (context-close-stress)
[172.551598] Starting subtest: context-close-stress
[183.298963] Subtest context-close-stress: SUCCESS (10.745s)
[183.370721] [037/133] (837s left) gem_ctx_persistence (legacy-engines-hang)
[183.569285] Starting subtest: legacy-engines-hang
[183.571653] Starting dynamic subtest: render
[183.704330] Dynamic subtest render: SUCCESS (0.134s)
[183.715657] Starting dynamic subtest: bsd1
[183.803951] Dynamic subtest bsd1: SUCCESS (0.097s)
[183.817607] Starting dynamic subtest: bsd2
[183.890706] Dynamic subtest bsd2: SUCCESS (0.084s)
[183.901076] Starting dynamic subtest: blt
[183.982875] Dynamic subtest blt: SUCCESS (0.089s)
[183.993828] Starting dynamic subtest: vebox
[184.079457] Dynamic subtest vebox: SUCCESS (0.093s)
[184.083042] Subtest legacy-engines-hang: SUCCESS (0.512s)
[184.166103] [038/133] (837s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[184.250065] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[184.254210] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[184.325158] [039/133] (836s left) syncobj_wait (wait-delayed-signal)
[184.390468] Starting subtest: wait-delayed-signal
[184.494825] Subtest wait-delayed-signal: SUCCESS (0.102s)
[184.577788] [040/133] (836s left) gem_exec_schedule (noreorder)
[184.749749] Starting subtest: noreorder
[184.752166] Starting dynamic subtest: rcs0
[184.813242] Dynamic subtest rcs0: SUCCESS (0.064s)
[184.824708] Starting dynamic subtest: vcs0
[185.879430] Dynamic subtest vcs0: SUCCESS (1.063s)
[185.891056] Starting dynamic subtest: vcs1
[187.928530] Dynamic subtest vcs1: SUCCESS (2.046s)
[187.939666] Starting dynamic subtest: vecs0
[189.906566] Dynamic subtest vecs0: SUCCESS (1.975s)
[189.918356] Starting dynamic subtest: ccs0
[189.971850] Dynamic subtest ccs0: SUCCESS (0.064s)
[189.975059] Subtest noreorder: SUCCESS (5.224s)
[190.157571] [041/133] (831s left) gem_exec_schedule (preempt-self)
[190.239160] Starting subtest: preempt-self
[190.241607] Starting dynamic subtest: rcs0
[190.275982] Dynamic subtest rcs0: SUCCESS (0.036s)
[190.286476] Starting dynamic subtest: bcs0
[190.314244] Dynamic subtest bcs0: SUCCESS (0.037s)
[190.323166] Starting dynamic subtest: vcs0
[190.343073] Dynamic subtest vcs0: SUCCESS (0.028s)
[190.351056] Starting dynamic subtest: vcs1
[190.373406] Dynamic subtest vcs1: SUCCESS (0.030s)
[190.382251] Starting dynamic subtest: vecs0
[190.408231] Dynamic subtest vecs0: SUCCESS (0.034s)
[190.416183] Starting dynamic subtest: ccs0
[190.440970] Dynamic subtest ccs0: SUCCESS (0.032s)
[190.443250] Subtest preempt-self: SUCCESS (0.202s)
[191.981491] [042/133] (829s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[192.079075] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[192.081291] Starting dynamic subtest: pipe-A-default-mode
[193.249214] Dynamic subtest pipe-A-default-mode: SKIP (1.168s)
[193.253845] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.170s)
[193.393948] [043/133] (828s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[193.507078] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[194.331614] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.826s)
[194.509188] [044/133] (826s left) api_intel_bb (delta-check)
[194.566048] Starting subtest: delta-check
[194.570566] Subtest delta-check: SUCCESS (0.007s)
[194.689491] [045/133] (826s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[194.752904] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[194.755238] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[194.847814] [046/133] (826s left) kms_dp_aux_dev (basic)
[194.904108] Starting subtest: basic
[195.127538] Subtest basic: SUCCESS (0.223s)
[195.198669] [047/133] (826s left) kms_psr (fbc-psr2-primary-blt)
[195.293220] Starting subtest: fbc-psr2-primary-blt
[195.295363] Starting dynamic subtest: eDP-1
[195.299689] Dynamic subtest eDP-1: SKIP (0.000s)
[195.304070] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[195.364078] [048/133] (826s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[195.465585] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[195.469606] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[195.566969] [049/133] (826s left) gem_render_copy (yf-tiled)
[195.631409] Starting subtest: yf-tiled
[195.635787] Subtest yf-tiled: SKIP (0.000s)
[195.824038] [050/133] (825s left) kms_content_protection (dp-mst-type-0)
[195.969508] Starting subtest: dp-mst-type-0
[195.974098] Subtest dp-mst-type-0: SKIP (0.000s)
[196.105532] [051/133] (825s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[196.215036] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[196.219201] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[196.321241] [052/133] (825s left) kms_hdr (bpc-switch-dpms)
[196.421666] Starting subtest: bpc-switch-dpms
[197.481309] Starting dynamic subtest: pipe-A-eDP-1
[202.015216] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.534s)
[202.017622] Subtest bpc-switch-dpms: SUCCESS (5.597s)
[202.130520] [053/133] (819s left) gem_request_retire (retire-vma-not-inactive)
[202.202396] Starting subtest: retire-vma-not-inactive
[202.267251] Subtest retire-vma-not-inactive: SUCCESS (0.061s)
[202.368565] [054/133] (819s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[202.460389] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[202.464612] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[202.568952] [055/133] (819s left) gem_mmap_gtt (basic-write-gtt)
[202.618955] Subtest basic-write-gtt: SKIP (0.000s)
[202.679045] [056/133] (819s left) kms_lease (lease-unleased-connector)
[202.773291] Starting subtest: lease-unleased-connector
[202.775563] Starting dynamic subtest: pipe-A-eDP-1
[202.780661] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[202.789578] Starting dynamic subtest: pipe-B-eDP-1
[202.791696] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s)
[202.801524] Starting dynamic subtest: pipe-C-eDP-1
[202.803793] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[202.812371] Starting dynamic subtest: pipe-D-eDP-1
[202.814630] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[202.816736] Subtest lease-unleased-connector: SUCCESS (0.030s)
[202.909811] [057/133] (819s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[202.964820] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[203.064646] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.101s)
[203.143592] [058/133] (818s left) kms_flip (blocking-wf_vblank)
[203.239024] Starting subtest: blocking-wf_vblank
[203.240696] Starting dynamic subtest: A-eDP1
[212.128343] Dynamic subtest A-eDP1: SUCCESS (8.889s)
[212.141085] Starting dynamic subtest: B-eDP1
[221.070672] Dynamic subtest B-eDP1: SUCCESS (8.940s)
[221.080402] Starting dynamic subtest: C-eDP1
[229.992541] Dynamic subtest C-eDP1: SUCCESS (8.919s)
[230.002066] Starting dynamic subtest: D-eDP1
[238.908836] Dynamic subtest D-eDP1: SUCCESS (8.915s)
[238.914681] Subtest blocking-wf_vblank: SUCCESS (35.676s)
[240.142770] [059/133] (781s left) gem_exec_store (cachelines)
[240.218593] Starting subtest: cachelines
[240.220961] Starting dynamic subtest: rcs0
[240.278536] Dynamic subtest rcs0: SUCCESS (0.061s)
[240.289523] Starting dynamic subtest: bcs0
[240.342315] Dynamic subtest bcs0: SUCCESS (0.061s)
[240.352455] Starting dynamic subtest: vcs0
[240.400409] Dynamic subtest vcs0: SUCCESS (0.056s)
[240.410604] Starting dynamic subtest: vcs1
[240.458640] Dynamic subtest vcs1: SUCCESS (0.056s)
[240.470840] Starting dynamic subtest: vecs0
[240.517507] Dynamic subtest vecs0: SUCCESS (0.057s)
[240.527967] Starting dynamic subtest: ccs0
[240.571771] Dynamic subtest ccs0: SUCCESS (0.052s)
[240.574562] Subtest cachelines: SUCCESS (0.356s)
[240.753417] [060/133] (781s left) perf (invalid-oa-metric-set-id)
[240.870892] Starting subtest: invalid-oa-metric-set-id
[240.883882] Subtest invalid-oa-metric-set-id: SUCCESS (0.013s)
[240.928228] [061/133] (781s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[241.040775] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[241.044871] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[241.106831] [062/133] (781s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[241.206298] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[241.584685] Starting dynamic subtest: pipe-A-eDP-1
[244.313607] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.728s)
[244.674531] Starting dynamic subtest: pipe-B-eDP-1
[247.441569] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.773s)
[247.799678] Starting dynamic subtest: pipe-C-eDP-1
[250.570676] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.776s)
[250.943101] Starting dynamic subtest: pipe-D-eDP-1
[253.697086] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.759s)
[253.699230] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.491s)
[254.893167] [063/133] (767s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[254.987274] Starting subtest: 4-tiled-64bpp-rotate-0
[256.445040] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.458s)
[256.649220] [064/133] (765s left) prime_busy (before-wait)
[256.705737] Starting subtest: before-wait
[256.711845] Starting dynamic subtest: rcs0
[256.755392] Dynamic subtest rcs0: SUCCESS (0.047s)
[256.763975] Starting dynamic subtest: bcs0
[256.805350] Dynamic subtest bcs0: SUCCESS (0.049s)
[256.813761] Starting dynamic subtest: vcs0
[256.846031] Dynamic subtest vcs0: SUCCESS (0.040s)
[256.854189] Starting dynamic subtest: vcs1
[256.885701] Dynamic subtest vcs1: SUCCESS (0.038s)
[256.895716] Starting dynamic subtest: vecs0
[256.926130] Dynamic subtest vecs0: SUCCESS (0.041s)
[256.935219] Starting dynamic subtest: ccs0
[256.967159] Dynamic subtest ccs0: SUCCESS (0.040s)
[257.075604] Subtest before-wait: SUCCESS (0.368s)
[257.151612] [065/133] (765s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[257.248384] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[257.250463] Starting dynamic subtest: pipe-A-eDP-1
[263.071162] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.826s)
[263.080460] Starting dynamic subtest: pipe-B-eDP-1
[269.633555] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.558s)
[269.635728] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.387s)
[270.436862] [066/133] (751s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[270.531145] Starting subtest: plane-primary-overlay-mutable-zpos
[273.970506] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.437s)
[275.151367] [067/133] (747s left) kms_draw_crc (draw-method-mmap-wc)
[275.255264] Starting subtest: draw-method-mmap-wc
[275.257523] Starting dynamic subtest: xrgb8888-untiled
[275.486859] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s)
[275.495677] Starting dynamic subtest: rgb565-untiled
[275.698330] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[275.709485] Starting dynamic subtest: xrgb2101010-untiled
[275.909118] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s)
[275.917510] Starting dynamic subtest: xbgr16161616f-untiled
[276.130755] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[276.139026] Starting dynamic subtest: xrgb8888-xtiled
[276.253337] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[276.261053] Starting dynamic subtest: rgb565-xtiled
[276.375606] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[276.384166] Starting dynamic subtest: xrgb2101010-xtiled
[276.497575] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[276.505901] Starting dynamic subtest: xbgr16161616f-xtiled
[276.609922] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.110s)
[276.625453] Starting dynamic subtest: xrgb8888-4tiled
[276.764083] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.153s)
[276.771955] Starting dynamic subtest: rgb565-4tiled
[276.897560] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[276.908019] Starting dynamic subtest: xrgb2101010-4tiled
[277.075605] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.177s)
[277.086114] Starting dynamic subtest: xbgr16161616f-4tiled
[277.242820] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.164s)
[277.244585] Subtest draw-method-mmap-wc: SUCCESS (1.991s)
[277.358979] [068/133] (745s left) perf (blocking-parameterized)
[277.450522] Starting subtest: blocking-parameterized
[297.466492] Subtest blocking-parameterized: SUCCESS (20.015s)
[297.518577] [069/133] (724s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[297.611410] Starting subtest: psr-2p-pri-indfb-multidraw
[297.615971] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[297.709117] [070/133] (724s left) prime_vgem (fence-write-hang)
[297.790473] Subtest fence-write-hang: SKIP (0.000s)
[297.890314] [071/133] (724s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[297.997428] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[298.799515] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.803s)
[298.962876] [072/133] (723s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[299.060310] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[299.064346] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[299.143872] [073/133] (723s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[299.244754] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[303.658468] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.418s)
[304.834228] [074/133] (717s left) kms_plane (plane-position-covered)
[304.922287] Starting subtest: plane-position-covered
[305.438655] Starting dynamic subtest: pipe-A-plane-1
[306.692501] Dynamic subtest pipe-A-plane-1: SUCCESS (1.254s)
[306.701781] Starting dynamic subtest: pipe-A-plane-2
[307.926134] Dynamic subtest pipe-A-plane-2: SUCCESS (1.232s)
[307.936048] Starting dynamic subtest: pipe-A-plane-3
[309.159836] Dynamic subtest pipe-A-plane-3: SUCCESS (1.235s)
[309.168330] Starting dynamic subtest: pipe-A-plane-4
[310.387710] Dynamic subtest pipe-A-plane-4: SUCCESS (1.228s)
[310.397758] Starting dynamic subtest: pipe-A-plane-5
[310.414511] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[311.545275] Starting dynamic subtest: pipe-B-plane-1
[312.802207] Dynamic subtest pipe-B-plane-1: SUCCESS (1.264s)
[312.818543] Starting dynamic subtest: pipe-B-plane-2
[314.134304] Dynamic subtest pipe-B-plane-2: SUCCESS (1.329s)
[314.143477] Starting dynamic subtest: pipe-B-plane-3
[315.459713] Dynamic subtest pipe-B-plane-3: SUCCESS (1.327s)
[315.469780] Starting dynamic subtest: pipe-B-plane-4
[316.760357] Dynamic subtest pipe-B-plane-4: SUCCESS (1.298s)
[316.769818] Starting dynamic subtest: pipe-B-plane-5
[316.786086] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[316.788573] Subtest plane-position-covered: SUCCESS (11.863s)
[317.568559] [075/133] (705s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[317.782443] Starting subtest: cursor-rapid-movement-128x128
[317.787598] Starting dynamic subtest: pipe-A-eDP-1
[318.333897] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.546s)
[318.361312] Starting dynamic subtest: pipe-D-eDP-1
[319.593464] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.236s)
[319.595444] Subtest cursor-rapid-movement-128x128: SUCCESS (1.809s)
[320.432932] [076/133] (702s left) gem_ctx_param (invalid-param-get)
[320.491599] Starting subtest: invalid-param-get
[320.494042] Subtest invalid-param-get: SUCCESS (0.001s)
[320.580781] [077/133] (702s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[320.677221] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[320.681168] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[320.771729] [078/133] (702s left) kms_flip (2x-flip-vs-dpms-on-nop)
[320.869376] Starting subtest: 2x-flip-vs-dpms-on-nop
[320.877894] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.010s)
[320.956675] [079/133] (701s left) gem_ppgtt (blt-vs-render-ctxn)
[321.020512] Starting subtest: blt-vs-render-ctxN
[354.018283] Subtest blt-vs-render-ctxN: SUCCESS (32.992s)
[354.152365] [080/133] (668s left) perf (oa-exponents)
[354.296106] Starting subtest: oa-exponents
[354.298352] Starting dynamic subtest: 0-rcs0
[356.106556] Dynamic subtest 0-rcs0: SUCCESS (1.808s)
[356.116628] Starting dynamic subtest: 1-vcs0
[357.934827] Dynamic subtest 1-vcs0: SUCCESS (1.827s)
[357.937388] Subtest oa-exponents: SUCCESS (3.638s)
[357.993076] [081/133] (664s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[358.098586] Starting subtest: pr-cursor-plane-move-continuous-sf
[358.102603] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[358.171163] [082/133] (664s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[358.269850] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[358.274236] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[358.370224] [083/133] (664s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[358.492195] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[375.867561] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.372s)
[376.664338] [084/133] (646s left) gem_close_race (multigpu-basic-process)
[376.749092] Starting subtest: multigpu-basic-process
[376.753577] Subtest multigpu-basic-process: SKIP (0.000s)
[376.967848] [085/133] (646s left) perf_pmu (pmu-read)
[377.012526] Starting subtest: pmu-read
[377.014889] Subtest pmu-read: SUCCESS (0.002s)
[377.137829] [086/133] (646s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[377.202560] Starting subtest: invalid-multi-wait-unsubmitted
[377.204879] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[377.315738] [087/133] (645s left) gem_exec_fence (syncobj-import)
[377.752996] Starting subtest: syncobj-import
[377.759208] Subtest syncobj-import: SUCCESS (0.005s)
[378.990539] [088/133] (644s left) gem_mmap_offset (mmap-unmap)
[379.050337] Starting subtest: mmap-unmap
[379.052526] Starting dynamic subtest: smem0
[401.585760] Dynamic subtest smem0: SUCCESS (22.534s)
[401.588464] Subtest mmap-unmap: SUCCESS (22.535s)
[401.711077] [089/133] (621s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[401.813362] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[401.817769] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[401.902337] [090/133] (621s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[402.012649] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[409.621301] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.615s)
[409.731983] [091/133] (613s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[409.836714] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[414.664385] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.831s)
[415.806519] [092/133] (607s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[415.903290] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[415.907301] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[416.012899] [093/133] (607s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[416.113260] Starting subtest: bad-pixel-format-y-tiled-ccs
[416.115482] Starting dynamic subtest: pipe-A-eDP-1
[416.136694] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[416.145709] Starting dynamic subtest: pipe-B-eDP-1
[416.166632] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[416.174951] Starting dynamic subtest: pipe-C-eDP-1
[416.195829] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[416.204215] Starting dynamic subtest: pipe-D-eDP-1
[416.225824] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[416.229874] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.005s)
[418.353101] [094/133] (605s left) gem_exec_flush (basic-uc-rw-default)
[418.417348] Starting subtest: basic-uc-rw-default
[423.868347] Subtest basic-uc-rw-default: SUCCESS (5.451s)
[424.055691] [095/133] (599s left) drm_read (short-buffer-block)
[424.212705] Starting subtest: short-buffer-block
[424.214739] Subtest short-buffer-block: SUCCESS (0.000s)
[424.336479] [096/133] (599s left) syncobj_timeline (wait-all-for-submit-snapshot)
[424.392069] Starting subtest: wait-all-for-submit-snapshot
[424.472236] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[424.548471] [097/133] (599s left) kms_getfb (getfb-handle-not-fb)
[424.629411] Starting subtest: getfb-handle-not-fb
[424.631617] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[424.723411] [098/133] (598s left) i915_pm_rps (basic-api)
[424.790831] Starting subtest: basic-api
[424.795350] Subtest basic-api: SKIP (0.000s)
[424.891718] [099/133] (598s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[424.984133] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[424.986471] Starting dynamic subtest: pipe-A-eDP-1
[425.412652] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.406s)
[425.425395] Starting dynamic subtest: pipe-B-eDP-1
[426.894190] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.474s)
[426.904225] Starting dynamic subtest: pipe-C-eDP-1
[428.296704] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.401s)
[428.306706] Starting dynamic subtest: pipe-D-eDP-1
[429.684974] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.389s)
[429.686828] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.677s)
[430.868971] [100/133] (592s left) sw_sync (sync_random_merge)
[430.912101] Starting subtest: sync_random_merge
[430.953361] Subtest sync_random_merge: SUCCESS (0.043s)
[431.022067] [101/133] (592s left) gem_userptr_blits (map-fixed-invalidate-busy)
[431.080262] Starting subtest: map-fixed-invalidate-busy
[431.085215] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[431.203418] [102/133] (592s left) kms_sequence (queue-idle)
[431.287202] Starting subtest: queue-idle
[431.289517] Starting dynamic subtest: pipe-A-eDP-1
[433.098571] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.813s)
[433.108492] Starting dynamic subtest: pipe-B-eDP-1
[435.551773] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.451s)
[435.562358] Starting dynamic subtest: pipe-C-eDP-1
[437.992296] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.437s)
[438.001186] Starting dynamic subtest: pipe-D-eDP-1
[440.421303] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.429s)
[440.423665] Subtest queue-idle: SUCCESS (9.136s)
[441.236532] [103/133] (582s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[441.326844] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[441.328701] Starting dynamic subtest: pipe-A-eDP-1
[441.351227] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.023s)
[441.361224] Starting dynamic subtest: pipe-B-eDP-1
[441.380258] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[441.389384] Starting dynamic subtest: pipe-C-eDP-1
[441.408747] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s)
[441.417711] Starting dynamic subtest: pipe-D-eDP-1
[441.436945] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s)
[441.439073] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.092s)
[443.601705] [104/133] (580s left) kms_getfb (getfb-handle-closed)
[443.704333] Starting subtest: getfb-handle-closed
[443.706596] Subtest getfb-handle-closed: SUCCESS (0.000s)
[443.810605] [105/133] (580s left) gem_caching (read-writes)
[443.877605] Subtest read-writes: SKIP (0.000s)
[443.954046] [106/133] (580s left) gem_mmap_gtt (basic-small-copy-xy)
[444.009606] Subtest basic-small-copy-XY: SKIP (0.000s)
[444.076650] [107/133] (579s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[444.175565] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[448.790807] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.618s)
[449.913665] [108/133] (574s left) kms_joiner (invalid-modeset-force-big-joiner)
[450.005637] Starting subtest: invalid-modeset-force-big-joiner
[450.009883] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[450.077955] [109/133] (574s left) gem_eio (suspend)
[450.316662] Starting subtest: suspend
[462.635575] Subtest suspend: SUCCESS (12.317s)
[462.746386] [110/133] (561s left) gem_fence_thrash (bo-write-verify-threaded-x)
[462.794472] Starting subtest: bo-write-verify-threaded-x
[462.816603] Subtest bo-write-verify-threaded-x: SKIP (0.019s)
[462.875313] [111/133] (561s left) i915_pm_rps (thresholds)
[462.934206] Starting subtest: thresholds
[462.938799] Subtest thresholds: SKIP (0.001s)
[463.030534] [112/133] (561s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[463.129955] Starting subtest: yf-tiled-64bpp-rotate-0
[463.134361] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[463.238124] [113/133] (561s left) kms_vblank (wait-forked-busy)
[463.322082] Starting subtest: wait-forked-busy
[463.324169] Starting dynamic subtest: pipe-A-eDP-1
[465.193830] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.873s)
[465.209252] Starting dynamic subtest: pipe-D-eDP-1
[467.760914] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.563s)
[467.763246] Subtest wait-forked-busy: SUCCESS (4.440s)
[468.574502] [114/133] (555s left) gem_exec_balancer (nop)
[468.632284] Starting subtest: nop
[515.347864] Subtest nop: SUCCESS (46.714s)
[515.654128] [115/133] (508s left) i915_pm_freq_api (freq-basic-api)
[515.722567] Starting subtest: freq-basic-api
[515.725322] Starting dynamic subtest: gt0
[515.728161] Dynamic subtest gt0: SUCCESS (0.005s)
[515.741661] Starting dynamic subtest: gt1
[515.743629] Dynamic subtest gt1: SUCCESS (0.003s)
[515.745535] Subtest freq-basic-api: SUCCESS (0.009s)
[515.806900] [116/133] (508s left) gem_basic (multigpu-create-close)
[515.864042] Starting subtest: multigpu-create-close
[515.868500] Subtest multigpu-create-close: SKIP (0.000s)
[515.981669] [117/133] (508s left) kms_psr (psr2-cursor-render)
[516.078138] Starting subtest: psr2-cursor-render
[516.080438] Starting dynamic subtest: eDP-1
[517.834120] Dynamic subtest eDP-1: SUCCESS (1.754s)
[517.836539] Subtest psr2-cursor-render: SUCCESS (1.755s)
[518.629110] [118/133] (505s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[518.735861] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[518.740405] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[518.834612] [119/133] (505s left) kms_chamelium_frames (hdmi-crc-multiple)
[519.222729] Subtest hdmi-crc-multiple: SKIP (0.000s)
[520.038580] [120/133] (504s left) gem_ctx_shared (q-in-order)
[520.106244] Starting subtest: Q-in-order
[520.108415] Starting dynamic subtest: rcs0
[520.203895] Dynamic subtest rcs0: SUCCESS (0.100s)
[520.221936] Starting dynamic subtest: vcs0
[520.291220] Dynamic subtest vcs0: SUCCESS (0.086s)
[520.307981] Starting dynamic subtest: vcs1
[520.381021] Dynamic subtest vcs1: SUCCESS (0.089s)
[520.397948] Starting dynamic subtest: vecs0
[520.459533] Dynamic subtest vecs0: SUCCESS (0.078s)
[520.476512] Starting dynamic subtest: ccs0
[520.550113] Dynamic subtest ccs0: SUCCESS (0.089s)
[520.552606] Subtest Q-in-order: SUCCESS (0.446s)
[522.042621] [121/133] (502s left) drm_buddy (drm_buddy)
[522.082797] Starting subtest: drm_buddy
[522.086793] Subtest drm_buddy: SKIP (0.001s)
[522.135381] [122/133] (502s left) kms_pipe_stress (stress-xrgb8888-4tiled)
[522.222682] Starting subtest: stress-xrgb8888-4tiled
[528.017300] Subtest stress-xrgb8888-4tiled: SUCCESS (5.797s)
[528.066949] [123/133] (496s left) kms_frontbuffer_tracking (psr-suspend)
[528.174034] Starting subtest: psr-suspend
[566.223880] Subtest psr-suspend: SUCCESS (7.847s)
[566.348939] [124/133] (458s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[566.450965] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[566.455872] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[566.544769] [125/133] (458s left) gem_fence_thrash (bo-write-verify-none)
[566.580010] Starting subtest: bo-write-verify-none
[566.601736] Subtest bo-write-verify-none: SKIP (0.020s)
[566.662451] [126/133] (458s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[566.766609] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[566.771556] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[566.856213] [127/133] (457s left) perf (disabled-read-error)
[566.959218] Starting subtest: disabled-read-error
[566.970467] Subtest disabled-read-error: SUCCESS (0.013s)
[567.013185] [128/133] (457s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[567.114207] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[567.119312] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[567.206637] [129/133] (457s left) gem_huc_copy (huc-copy)
[567.263992] Starting subtest: huc-copy
[567.268637] Subtest huc-copy: SUCCESS (0.004s)
[567.384619] [130/133] (457s left) gem_userptr_blits (relocations)
[567.440939] Starting subtest: relocations
[567.445342] Subtest relocations: SKIP (0.000s)
[567.562272] [131/133] (457s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[567.641960] Starting subtest: plane-upscale-20x20-with-pixel-format
[567.644340] Starting dynamic subtest: pipe-A
[568.690714] Dynamic subtest pipe-A: SUCCESS (1.050s)
[568.707435] Starting dynamic subtest: pipe-B
[570.822671] Dynamic subtest pipe-B: SUCCESS (2.128s)
[570.832808] Starting dynamic subtest: pipe-C
[572.016191] Dynamic subtest pipe-C: SUCCESS (1.191s)
[572.026138] Starting dynamic subtest: pipe-D
[573.247930] Dynamic subtest pipe-D: SUCCESS (1.229s)
[573.250623] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.604s)
[574.443485] [132/133] (450s left) gem_render_copy (y-tiled-to-vebox-linear)
[574.512162] Starting subtest: y-tiled-to-vebox-linear
[574.518183] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[574.708531] [133/133] (450s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[574.764497] Starting subtest: single-wait-for-submit-unsubmitted
[574.865193] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[574.939837] Closing watchdogs
results: parsing output: 0/ for test: kms_pm_rpm
results: parsing output: 1/ for test: i915_query
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: gem_exec_schedule
results: parsing output: 4/ for test: kms_cursor_edge_walk
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_eio
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: gem_mmap_gtt
results: parsing output: 9/ for test: kms_rotation_crc
results: parsing output: 10/ for test: gem_close
results: parsing output: 11/ for test: kms_chamelium_hpd
results: parsing output: 12/ for test: kms_cursor_legacy
results: parsing output: 13/ for test: core_setmaster_vs_auth
results: parsing output: 14/ for test: gem_pwrite
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_pm_rpm
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: kms_color_pipeline
results: parsing output: 19/ for test: gem_spin_batch
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_plane_cursor
results: parsing output: 22/ for test: gen9_exec_parse
results: parsing output: 23/ for test: gem_exec_balancer
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_mmap_gtt
results: parsing output: 26/ for test: gem_wait
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: sysfs_timeslice_duration
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: kms_cursor_crc
results: parsing output: 31/ for test: gem_ctx_persistence
results: parsing output: 32/ for test: gem_exec_reloc
results: parsing output: 33/ for test: gem_workarounds
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: i915_drm_fdinfo
results: parsing output: 36/ for test: gem_ctx_persistence
results: parsing output: 37/ for test: kms_plane
results: parsing output: 38/ for test: syncobj_wait
results: parsing output: 39/ for test: gem_exec_schedule
results: parsing output: 40/ for test: gem_exec_schedule
results: parsing output: 41/ for test: kms_flip_scaled_crc
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: api_intel_bb
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: kms_dp_aux_dev
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_render_copy
results: parsing output: 49/ for test: kms_content_protection
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_hdr
results: parsing output: 52/ for test: gem_request_retire
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_mmap_gtt
results: parsing output: 55/ for test: kms_lease
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: gem_exec_store
results: parsing output: 59/ for test: perf
results: parsing output: 60/ for test: kms_psr2_sf
results: parsing output: 61/ for test: kms_async_flips
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: prime_busy
results: parsing output: 64/ for test: kms_psr2_sf
results: parsing output: 65/ for test: kms_atomic
results: parsing output: 66/ for test: kms_draw_crc
results: parsing output: 67/ for test: perf
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: prime_vgem
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_plane
results: parsing output: 74/ for test: kms_cursor_crc
results: parsing output: 75/ for test: gem_ctx_param
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_flip
results: parsing output: 78/ for test: gem_ppgtt
results: parsing output: 79/ for test: perf
results: parsing output: 80/ for test: kms_psr2_sf
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_cursor_legacy
results: parsing output: 83/ for test: gem_close_race
results: parsing output: 84/ for test: perf_pmu
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: gem_exec_fence
results: parsing output: 87/ for test: gem_mmap_offset
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: gem_exec_flush
results: parsing output: 94/ for test: drm_read
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: kms_getfb
results: parsing output: 97/ for test: i915_pm_rps
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: sw_sync
results: parsing output: 100/ for test: gem_userptr_blits
results: parsing output: 101/ for test: kms_sequence
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: kms_getfb
results: parsing output: 104/ for test: gem_caching
results: parsing output: 105/ for test: gem_mmap_gtt
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_joiner
results: parsing output: 108/ for test: gem_eio
results: parsing output: 109/ for test: gem_fence_thrash
results: parsing output: 110/ for test: i915_pm_rps
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: kms_vblank
results: parsing output: 113/ for test: gem_exec_balancer
results: parsing output: 114/ for test: i915_pm_freq_api
results: parsing output: 115/ for test: gem_basic
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_chamelium_frames
results: parsing output: 119/ for test: gem_ctx_shared
results: parsing output: 120/ for test: drm_buddy
results: parsing output: 121/ for test: kms_pipe_stress
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_fence_thrash
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: perf
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: gem_huc_copy
results: parsing output: 129/ for test: gem_userptr_blits
results: parsing output: 130/ for test: kms_plane_scaling
results: parsing output: 131/ for test: gem_render_copy
results: parsing output: 132/ for test: syncobj_wait
Done.