[61.461939] Initializing watchdogs
[61.461995]   /dev/watchdog0
[61.487865] [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]
[61.492058] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.494330] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.498196] [001/133] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[61.626192] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[66.035710] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.410s)
[67.215046] [002/133] (954s left) kms_cursor_crc (cursor-offscreen-32x32)
[67.420801] Starting subtest: cursor-offscreen-32x32
[67.481603] Subtest cursor-offscreen-32x32: SKIP (0.058s)
[67.897368] [003/133] (954s left) gem_exec_reloc (basic-gtt-read-noreloc)
[68.043628] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[68.094436] [004/133] (954s left) core_setmaster (master-drop-set-user)
[68.173720] Starting subtest: master-drop-set-user
[68.188846] Subtest master-drop-set-user: SUCCESS (0.015s)
[68.222367] [005/133] (953s left) gem_userptr_blits (invalid-null-pointer)
[68.282755] Starting subtest: invalid-null-pointer
[68.285084] Subtest invalid-null-pointer: SUCCESS (0.001s)
[68.389389] [006/133] (953s left) gem_exec_capture (capture-recoverable)
[68.444840] Starting subtest: capture-recoverable
[68.450347] Subtest capture-recoverable: SUCCESS (0.006s)
[68.567689] [007/133] (953s left) kms_flip (flip-vs-fences)
[68.658040] Starting subtest: flip-vs-fences
[68.662627] Subtest flip-vs-fences: SKIP (0.000s)
[68.782100] [008/133] (953s left) kms_async_flips (test-time-stamp)
[68.882196] Starting subtest: test-time-stamp
[69.265819] Starting dynamic subtest: pipe-A-eDP-1
[70.078728] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.811s)
[70.473224] Starting dynamic subtest: pipe-B-eDP-1
[71.229425] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.759s)
[71.597392] Starting dynamic subtest: pipe-C-eDP-1
[72.359264] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.766s)
[72.720061] Starting dynamic subtest: pipe-D-eDP-1
[73.496118] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.780s)
[73.498667] Subtest test-time-stamp: SUCCESS (4.610s)
[74.645311] [009/133] (947s left) gem_lmem_swapping (parallel-random-verify-ccs)
[74.696407] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[74.731435] [010/133] (947s left) gem_exec_params (invalid-batch-start-offset)
[74.790614] Starting subtest: invalid-batch-start-offset
[74.793022] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[74.911570] [011/133] (947s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[74.970632] Starting subtest: yf-tiled-ccs-to-yf-tiled
[74.975195] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[75.150131] [012/133] (947s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[75.242778] Starting subtest: y-tiled-addfb-size-offset-overflow
[75.247436] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[75.338322] [013/133] (947s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[75.400496] Starting subtest: y-tiled-to-vebox-yf-tiled
[75.404721] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[75.577618] [014/133] (946s left) kms_draw_crc (draw-method-mmap-wc)
[75.672879] Starting subtest: draw-method-mmap-wc
[75.674724] Starting dynamic subtest: xrgb8888-untiled
[75.936804] Dynamic subtest xrgb8888-untiled: SUCCESS (0.266s)
[75.944420] Starting dynamic subtest: rgb565-untiled
[76.170461] Dynamic subtest rgb565-untiled: SUCCESS (0.233s)
[76.178792] Starting dynamic subtest: xrgb2101010-untiled
[76.392990] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[76.401829] Starting dynamic subtest: xbgr16161616f-untiled
[76.614909] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.222s)
[76.622727] Starting dynamic subtest: xrgb8888-xtiled
[76.737036] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[76.743529] Starting dynamic subtest: rgb565-xtiled
[76.870326] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[76.880824] Starting dynamic subtest: xrgb2101010-xtiled
[76.992950] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[77.003549] Starting dynamic subtest: xbgr16161616f-xtiled
[77.126039] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[77.134514] Starting dynamic subtest: xrgb8888-4tiled
[77.270497] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[77.278261] Starting dynamic subtest: rgb565-4tiled
[77.404112] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[77.411677] Starting dynamic subtest: xrgb2101010-4tiled
[77.559474] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.154s)
[77.566898] Starting dynamic subtest: xbgr16161616f-4tiled
[77.726234] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.166s)
[77.728147] Subtest draw-method-mmap-wc: SUCCESS (2.056s)
[77.838411] [015/133] (944s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[77.942788] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[79.054032] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.111s)
[79.180843] [016/133] (943s left) kms_plane_cursor (viewport)
[79.273799] Starting subtest: viewport
[79.277761] Starting dynamic subtest: pipe-A-eDP-1-size-64
[81.761721] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.486s)
[81.819646] Starting dynamic subtest: pipe-A-eDP-1-size-128
[84.340065] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.527s)
[84.399513] Starting dynamic subtest: pipe-A-eDP-1-size-256
[86.864365] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.471s)
[87.216063] Starting dynamic subtest: pipe-B-eDP-1-size-64
[90.347503] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.140s)
[90.405982] Starting dynamic subtest: pipe-B-eDP-1-size-128
[92.916087] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.516s)
[92.974548] Starting dynamic subtest: pipe-B-eDP-1-size-256
[95.483501] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.516s)
[95.832614] Starting dynamic subtest: pipe-C-eDP-1-size-64
[98.617362] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.794s)
[98.654411] Starting dynamic subtest: pipe-C-eDP-1-size-128
[100.817238] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.169s)
[100.854485] Starting dynamic subtest: pipe-C-eDP-1-size-256
[102.906641] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.058s)
[103.233973] Starting dynamic subtest: pipe-D-eDP-1-size-64
[106.085150] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.859s)
[106.120513] Starting dynamic subtest: pipe-D-eDP-1-size-128
[108.195309] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.080s)
[108.231911] Starting dynamic subtest: pipe-D-eDP-1-size-256
[110.295368] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.069s)
[110.614298] Subtest viewport: SUCCESS (31.334s)
[111.489570] [017/133] (911s left) gem_userptr_blits (stress-purge)
[111.562160] Starting subtest: stress-purge
[116.944462] Subtest stress-purge: SUCCESS (5.385s)
[117.062242] [018/133] (905s left) gem_exec_balancer (bonded-true-hang)
[117.350117] Starting subtest: bonded-true-hang
[117.355293] Subtest bonded-true-hang: SKIP (0.000s)
[117.452023] [019/133] (905s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[117.550068] Starting subtest: plane-downscale-factor-0-75-with-rotation
[117.552415] Starting dynamic subtest: pipe-A
[117.778131] Dynamic subtest pipe-A: SUCCESS (0.230s)
[117.785869] Starting dynamic subtest: pipe-B
[119.085168] Dynamic subtest pipe-B: SUCCESS (1.306s)
[119.094811] Starting dynamic subtest: pipe-C
[120.405380] Dynamic subtest pipe-C: SUCCESS (1.318s)
[120.413749] Starting dynamic subtest: pipe-D
[121.763407] Dynamic subtest pipe-D: SUCCESS (1.356s)
[121.765718] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.217s)
[122.941626] [020/133] (899s left) syncobj_timeline (single-wait-available-submitted)
[123.001570] Starting subtest: single-wait-available-submitted
[123.003581] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[123.071886] [021/133] (899s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[123.455644] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[124.235636] [022/133] (898s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[124.358973] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[131.816024] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.460s)
[131.948257] [023/133] (890s left) kms_display_modes (extended-mode-basic)
[132.033781] Starting subtest: extended-mode-basic
[132.038169] Subtest extended-mode-basic: SKIP (0.000s)
[132.077710] [024/133] (890s left) kms_content_protection (dp-mst-type-0)
[132.223705] Starting subtest: dp-mst-type-0
[132.228164] Subtest dp-mst-type-0: SKIP (0.000s)
[132.364961] [025/133] (890s left) kms_setmode (invalid-clone-single-crtc-stealing)
[132.419069] Starting subtest: invalid-clone-single-crtc-stealing
[132.425224] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[132.512798] [026/133] (890s left) kms_psr (pr-suspend)
[132.598969] Starting subtest: pr-suspend
[132.603169] Subtest pr-suspend: SKIP (0.000s)
[132.667624] [027/133] (890s left) gem_tiled_partial_pwrite_pread (writes)
[132.733505] Subtest writes: SKIP (0.000s)
[132.793302] [028/133] (890s left) gem_softpin (evict-prime-sanity-check)
[132.844141] Starting subtest: evict-prime-sanity-check
[132.846244] Starting dynamic subtest: rcs0
[133.984908] Dynamic subtest rcs0: SUCCESS (1.140s)
[133.993157] Starting dynamic subtest: bcs0
[135.117710] Dynamic subtest bcs0: SUCCESS (1.132s)
[135.128534] Starting dynamic subtest: vcs0
[136.893811] Dynamic subtest vcs0: SUCCESS (1.772s)
[136.902667] Starting dynamic subtest: vcs1
[138.813177] Dynamic subtest vcs1: SUCCESS (1.917s)
[138.822190] Starting dynamic subtest: vecs0
[140.884187] Dynamic subtest vecs0: SUCCESS (2.069s)
[140.894397] Starting dynamic subtest: ccs0
[142.019292] Dynamic subtest ccs0: SUCCESS (1.134s)
[142.029797] Starting dynamic subtest: all
[143.141026] Dynamic subtest all: SUCCESS (1.120s)
[143.143536] Subtest evict-prime-sanity-check: SUCCESS (10.297s)
[143.220383] [029/133] (879s left) kms_flip (bo-too-big-interruptible)
[143.314898] Starting subtest: bo-too-big-interruptible
[143.317279] Starting dynamic subtest: A-eDP1
[144.631940] Dynamic subtest A-eDP1: SUCCESS (1.317s)
[144.641089] Starting dynamic subtest: B-eDP1
[145.874613] Dynamic subtest B-eDP1: SUCCESS (1.241s)
[145.888559] Starting dynamic subtest: C-eDP1
[147.139448] Dynamic subtest C-eDP1: SUCCESS (1.262s)
[147.149911] Starting dynamic subtest: D-eDP1
[148.375136] Dynamic subtest D-eDP1: SUCCESS (1.233s)
[148.380928] Subtest bo-too-big-interruptible: SUCCESS (5.065s)
[149.587359] [030/133] (873s left) sriov_basic (enable-vfs-autoprobe-off)
[149.643162] Starting subtest: enable-vfs-autoprobe-off
[149.645536] Starting dynamic subtest: numvfs-1
[149.727926] Dynamic subtest numvfs-1: FAIL (0.029s)
[149.737481] Starting dynamic subtest: numvfs-2
[149.811781] Dynamic subtest numvfs-2: FAIL (0.003s)
[149.821900] Starting dynamic subtest: numvfs-3
[149.898300] Dynamic subtest numvfs-3: FAIL (0.003s)
[149.907149] Starting dynamic subtest: numvfs-4
[149.980807] Dynamic subtest numvfs-4: FAIL (0.003s)
[149.989415] Starting dynamic subtest: numvfs-5
[150.062793] Dynamic subtest numvfs-5: FAIL (0.003s)
[150.072211] Starting dynamic subtest: numvfs-6
[150.146304] Dynamic subtest numvfs-6: FAIL (0.003s)
[150.156931] Starting dynamic subtest: numvfs-7
[150.229777] Dynamic subtest numvfs-7: FAIL (0.003s)
[150.238646] Starting dynamic subtest: numvfs-random
[150.311301] Dynamic subtest numvfs-random: FAIL (0.003s)
[150.321042] Starting dynamic subtest: numvfs-all
[150.393288] Dynamic subtest numvfs-all: FAIL (0.515s)
[150.395584] Subtest enable-vfs-autoprobe-off: FAIL (0.575s)
[150.431171] [031/133] (872s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[150.559038] Starting subtest: cursorB-vs-flipA-atomic
[150.562685] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[150.701229] [032/133] (872s left) kms_atomic_interruptible (atomic-setmode)
[150.799694] Starting subtest: atomic-setmode
[150.801596] Starting dynamic subtest: pipe-A-eDP-1
[157.700806] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.898s)
[157.703136] Subtest atomic-setmode: SUCCESS (6.899s)
[158.561418] [033/133] (864s left) gem_lmem_swapping (basic)
[158.606355] Subtest basic: SKIP (0.000s)
[158.654513] [034/133] (864s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[160.185228] Starting subtest: gem-execbuf-stress-pc8
[160.227495] Subtest gem-execbuf-stress-pc8: SKIP (0.039s)
[160.919877] [035/133] (862s left) kms_pm_lpsp (kms-lpsp)
[162.033420] Starting subtest: kms-lpsp
[162.035746] Starting dynamic subtest: pipe-A-eDP-1
[162.166703] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.137s)
[162.461630] Subtest kms-lpsp: SUCCESS (0.432s)
[163.347196] [036/133] (860s left) gem_render_copy (y-tiled-ccs-to-linear)
[163.403637] Starting subtest: y-tiled-ccs-to-linear
[163.408575] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[163.582804] [037/133] (859s left) gem_workarounds (suspend-resume)
[163.664797] Starting subtest: suspend-resume
[180.395182] Subtest suspend-resume: SUCCESS (2.254s)
[180.495200] [038/133] (842s left) syncobj_wait (wait-delayed-signal)
[180.558569] Starting subtest: wait-delayed-signal
[180.662033] Subtest wait-delayed-signal: SUCCESS (0.102s)
[180.750945] [039/133] (842s left) i915_hangman (gt-error-state-capture)
[180.819810] Starting subtest: gt-error-state-capture
[180.821979] Starting dynamic subtest: rcs0
[192.387876] Dynamic subtest rcs0: SUCCESS (11.492s)
[192.400196] Starting dynamic subtest: bcs0
[204.354868] Dynamic subtest bcs0: SUCCESS (11.943s)
[204.365404] Starting dynamic subtest: vcs0
[216.324721] Dynamic subtest vcs0: SUCCESS (11.959s)
[216.336912] Starting dynamic subtest: vcs1
[228.291445] Dynamic subtest vcs1: SUCCESS (11.962s)
[228.303904] Starting dynamic subtest: vecs0
[239.362871] Dynamic subtest vecs0: SUCCESS (11.064s)
[239.374978] Starting dynamic subtest: ccs0
[250.371957] Dynamic subtest ccs0: SUCCESS (11.002s)
[250.375098] Subtest gt-error-state-capture: SUCCESS (69.440s)
[250.452562] [040/133] (773s left) kms_color_pipeline (plane-lut1d)
[250.551941] Starting subtest: plane-lut1d
[250.687849] Starting dynamic subtest: pipe-A-plane-0
[250.854249] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[250.863820] Starting dynamic subtest: pipe-A-plane-1
[251.043309] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s)
[251.052126] Starting dynamic subtest: pipe-A-plane-2
[251.232765] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s)
[252.492765] Starting dynamic subtest: pipe-B-plane-0
[252.674859] Dynamic subtest pipe-B-plane-0: SUCCESS (0.189s)
[252.684006] Starting dynamic subtest: pipe-B-plane-1
[252.823253] Dynamic subtest pipe-B-plane-1: SUCCESS (0.143s)
[252.832176] Starting dynamic subtest: pipe-B-plane-2
[253.041541] Dynamic subtest pipe-B-plane-2: SUCCESS (0.219s)
[254.193531] Starting dynamic subtest: pipe-C-plane-0
[254.319566] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[254.328882] Starting dynamic subtest: pipe-C-plane-1
[254.464218] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[254.473311] Starting dynamic subtest: pipe-C-plane-2
[254.608704] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[255.857033] Starting dynamic subtest: pipe-D-plane-0
[256.015932] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[256.025167] Starting dynamic subtest: pipe-D-plane-1
[256.171738] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[256.181064] Starting dynamic subtest: pipe-D-plane-2
[256.305190] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[256.595293] Subtest plane-lut1d: SUCCESS (6.039s)
[257.412798] [041/133] (766s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[257.473417] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[257.538047] [042/133] (766s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[257.637859] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[257.640161] Starting dynamic subtest: pipe-A-default-mode
[258.778751] Dynamic subtest pipe-A-default-mode: SKIP (1.137s)
[258.783006] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.138s)
[258.907272] [043/133] (764s left) kms_invalid_mode (bad-vsync-end)
[258.999187] Starting subtest: bad-vsync-end
[259.001292] Starting dynamic subtest: pipe-A-eDP-1
[259.286871] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[259.296211] Starting dynamic subtest: pipe-B-eDP-1
[259.298088] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[259.306583] Starting dynamic subtest: pipe-C-eDP-1
[259.308477] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[259.316604] Starting dynamic subtest: pipe-D-eDP-1
[259.318783] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[259.320900] Subtest bad-vsync-end: SUCCESS (0.295s)
[260.083685] [044/133] (763s left) gem_ctx_persistence (engines-queued)
[260.148459] Starting subtest: engines-queued
[260.150716] Starting dynamic subtest: rcs0
[260.213971] Dynamic subtest rcs0: SUCCESS (0.068s)
[260.225084] Starting dynamic subtest: bcs0
[260.237074] Dynamic subtest bcs0: SUCCESS (0.021s)
[260.245606] Starting dynamic subtest: vcs0
[261.316621] Dynamic subtest vcs0: SUCCESS (1.076s)
[261.328754] Starting dynamic subtest: vcs1
[263.300550] Dynamic subtest vcs1: SUCCESS (1.978s)
[263.313174] Starting dynamic subtest: vecs0
[265.283686] Dynamic subtest vecs0: SUCCESS (1.979s)
[265.304525] Starting dynamic subtest: ccs0
[265.541098] Dynamic subtest ccs0: SUCCESS (0.255s)
[265.543781] Subtest engines-queued: SUCCESS (5.393s)
[265.660878] [045/133] (758s left) perf_pmu (render-node-busy)
[265.757172] Starting subtest: render-node-busy
[265.760066] Starting dynamic subtest: rcs0
[266.352972] Dynamic subtest rcs0: SUCCESS (0.600s)
[266.364238] Starting dynamic subtest: bcs0
[266.919218] Dynamic subtest bcs0: SUCCESS (0.564s)
[266.940049] Starting dynamic subtest: vcs0
[268.388924] Dynamic subtest vcs0: SUCCESS (1.465s)
[268.399638] Starting dynamic subtest: vcs1
[270.373614] Dynamic subtest vcs1: SUCCESS (1.980s)
[270.384530] Starting dynamic subtest: vecs0
[272.357082] Dynamic subtest vecs0: SUCCESS (1.980s)
[272.369032] Starting dynamic subtest: ccs0
[272.924823] Dynamic subtest ccs0: SUCCESS (0.566s)
[272.927563] Subtest render-node-busy: SUCCESS (7.171s)
[272.999796] [046/133] (750s left) kms_vrr (seamless-rr-switch-vrr)
[273.092918] Starting subtest: seamless-rr-switch-vrr
[273.100024] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[273.180917] [047/133] (750s left) kms_hdmi_inject (inject-audio)
[273.529607] Starting subtest: inject-audio
[273.806980] Subtest inject-audio: SUCCESS (0.280s)
[274.365265] [048/133] (749s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[274.468028] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[274.470362] Starting dynamic subtest: A-eDP1
[278.036094] Dynamic subtest A-eDP1: SUCCESS (3.565s)
[278.045806] Starting dynamic subtest: B-eDP1
[281.340093] Dynamic subtest B-eDP1: SUCCESS (3.306s)
[281.352080] Starting dynamic subtest: C-eDP1
[284.635773] Dynamic subtest C-eDP1: SUCCESS (3.294s)
[284.646104] Starting dynamic subtest: D-eDP1
[287.950108] Dynamic subtest D-eDP1: SUCCESS (3.314s)
[287.952530] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.487s)
[288.815288] [049/133] (735s left) vgem_basic (dmabuf-export)
[288.937368] Starting subtest: dmabuf-export
[288.955232] Subtest dmabuf-export: SUCCESS (0.020s)
[289.063375] [FACT vgem_basic (dmabuf-export)] new: kernel.kmod_is_loaded.vgem: true
[289.067469] [050/133] (734s left) gem_exec_params (no-bsd)
[289.119737] Starting subtest: no-bsd
[289.122057] Subtest no-bsd: SUCCESS (0.002s)
[290.450964] [051/133] (733s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[290.520065] Starting subtest: invalid-single-wait-all-unsubmitted
[290.522481] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[290.622029] [052/133] (733s left) gem_exec_fence (keep-in-fence)
[290.804697] Starting subtest: keep-in-fence
[290.807050] Starting dynamic subtest: rcs0
[290.870250] Dynamic subtest rcs0: SUCCESS (0.065s)
[290.881873] Starting dynamic subtest: bcs0
[290.924971] Dynamic subtest bcs0: SUCCESS (0.053s)
[290.939781] Starting dynamic subtest: vcs0
[292.326500] Dynamic subtest vcs0: SUCCESS (1.397s)
[292.338854] Starting dynamic subtest: vcs1
[294.371668] Dynamic subtest vcs1: SUCCESS (2.043s)
[294.383663] Starting dynamic subtest: vecs0
[296.421419] Dynamic subtest vecs0: SUCCESS (2.047s)
[296.433992] Starting dynamic subtest: ccs0
[296.652791] Dynamic subtest ccs0: SUCCESS (0.230s)
[296.655347] Subtest keep-in-fence: SUCCESS (5.849s)
[298.496685] [053/133] (725s left) vgem_basic (second-client)
[298.545498] Starting subtest: second-client
[298.567873] Subtest second-client: SUCCESS (0.022s)
[298.628631] [054/133] (725s left) gen9_exec_parse (cmd-crossing-page)
[298.687831] Subtest cmd-crossing-page: SKIP (0.000s)
[298.757669] [055/133] (725s left) kms_vblank (query-busy-hang)
[298.847191] Starting subtest: query-busy-hang
[298.849407] Starting dynamic subtest: pipe-A-eDP-1
[325.165558] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.317s)
[325.180962] Starting dynamic subtest: pipe-D-eDP-1
[350.111520] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.937s)
[350.113967] Subtest query-busy-hang: SUCCESS (51.259s)
[350.916500] [056/133] (673s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[351.012845] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[351.017036] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[351.107861] [057/133] (673s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[351.204261] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[351.208572] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[351.303532] [058/133] (672s left) kms_cursor_crc (cursor-random-512x170)
[351.608198] Starting subtest: cursor-random-512x170
[351.613107] Subtest cursor-random-512x170: SKIP (0.001s)
[351.762262] [059/133] (672s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[351.867096] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[355.895386] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.028s)
[357.030440] [060/133] (667s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[357.138414] Starting subtest: 4-tiled-32bpp-rotate-0
[358.618954] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.480s)
[358.728062] [061/133] (665s left) kms_cursor_crc (cursor-sliding-64x21)
[358.936625] Starting subtest: cursor-sliding-64x21
[358.983642] Subtest cursor-sliding-64x21: SKIP (0.043s)
[359.234802] [062/133] (665s left) kms_plane_scaling (planes-downscale-factor-0-75)
[359.327005] Starting subtest: planes-downscale-factor-0-75
[359.329132] Starting dynamic subtest: pipe-A
[359.347844] Dynamic subtest pipe-A: SKIP (0.018s)
[359.362115] Starting dynamic subtest: pipe-B
[359.380065] Dynamic subtest pipe-B: SKIP (0.031s)
[359.389263] Starting dynamic subtest: pipe-C
[359.411950] Dynamic subtest pipe-C: SKIP (0.031s)
[359.420954] Starting dynamic subtest: pipe-D
[359.441129] Dynamic subtest pipe-D: SKIP (0.030s)
[359.444319] Subtest planes-downscale-factor-0-75: SKIP (0.114s)
[359.522507] [063/133] (664s left) kms_chamelium_hpd (common-hpd-after-suspend)
[359.898820] Subtest common-hpd-after-suspend: SKIP (0.000s)
[360.695772] [064/133] (663s left) syncobj_eventfd (timeline-wait-before-signal)
[360.753005] Starting subtest: timeline-wait-before-signal
[360.783100] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[360.866121] [065/133] (663s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[360.961165] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[360.963518] Starting dynamic subtest: pipe-A-eDP-1
[361.431471] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.440s)
[361.443372] Starting dynamic subtest: pipe-B-eDP-1
[362.775257] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.343s)
[362.786026] Starting dynamic subtest: pipe-C-eDP-1
[364.144033] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.366s)
[364.154924] Starting dynamic subtest: pipe-D-eDP-1
[365.461596] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.316s)
[365.463887] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.471s)
[366.619022] [066/133] (658s left) gem_exec_whisper (basic-normal-all)
[366.676460] Starting subtest: basic-normal-all
[369.099022] Subtest basic-normal-all: SUCCESS (2.420s)
[369.283352] [067/133] (655s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[369.391087] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[375.984056] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.594s)
[376.100877] [068/133] (648s left) syncobj_timeline (wait-for-submit-complex)
[376.158391] Starting subtest: wait-for-submit-complex
[376.220045] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[376.310525] [069/133] (648s left) kms_addfb_basic (basic-x-tiled-legacy)
[376.363029] Starting subtest: basic-x-tiled-legacy
[376.366954] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[376.500331] [070/133] (648s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[376.583227] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[376.587509] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[376.667843] [071/133] (648s left) gem_pread (self)
[376.721235] Subtest self: SKIP (0.000s)
[376.777210] [072/133] (648s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[376.868456] Starting subtest: extended-modeset-hang-oldfb-with-reset
[376.870775] Starting dynamic subtest: pipe-A
[388.976420] Dynamic subtest pipe-A: SUCCESS (12.102s)
[389.004177] Starting dynamic subtest: pipe-D
[401.454502] Dynamic subtest pipe-D: SUCCESS (12.466s)
[401.456863] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.576s)
[402.332424] [073/133] (622s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[402.455457] Starting subtest: 2x-long-cursor-vs-flip-atomic
[402.462103] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.004s)
[402.624988] [074/133] (622s left) gem_exec_schedule (submit-late-slice)
[402.701675] Starting subtest: submit-late-slice
[402.703884] Starting dynamic subtest: rcs0
[402.734722] Dynamic subtest rcs0: SUCCESS (0.040s)
[402.747058] Starting dynamic subtest: bcs0
[402.773757] Dynamic subtest bcs0: SUCCESS (0.038s)
[402.783814] Starting dynamic subtest: vcs0
[402.808763] Dynamic subtest vcs0: SUCCESS (0.034s)
[402.818418] Starting dynamic subtest: vcs1
[402.840199] Dynamic subtest vcs1: SUCCESS (0.033s)
[402.850174] Starting dynamic subtest: vecs0
[402.872178] Dynamic subtest vecs0: SUCCESS (0.031s)
[402.881724] Starting dynamic subtest: ccs0
[402.911324] Dynamic subtest ccs0: SUCCESS (0.038s)
[402.913640] Subtest submit-late-slice: SUCCESS (0.219s)
[404.484530] [075/133] (620s left) kms_force_connector_basic (force-load-detect)
[404.574741] Starting subtest: force-load-detect
[404.579201] Subtest force-load-detect: SKIP (0.000s)
[404.695643] [076/133] (620s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[404.802623] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[408.804920] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (4.008s)
[409.933943] [077/133] (615s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[410.031572] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[410.033519] Starting dynamic subtest: pipe-A-eDP-1
[411.241255] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.211s)
[411.251339] Starting dynamic subtest: pipe-B-eDP-1
[413.502541] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.261s)
[413.514233] Starting dynamic subtest: pipe-C-eDP-1
[415.783177] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.280s)
[415.792624] Starting dynamic subtest: pipe-D-eDP-1
[418.089795] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.306s)
[418.092081] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.063s)
[419.209403] [078/133] (605s left) gem_caching (reads)
[419.279066] Subtest reads: SKIP (0.000s)
[419.358325] [079/133] (605s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[419.450187] Starting subtest: invalidate-primary-flip-overlay
[430.227234] Subtest invalidate-primary-flip-overlay: SUCCESS (10.782s)
[430.344426] [080/133] (594s left) gem_exec_params (invalid-ring)
[430.416086] Starting subtest: invalid-ring
[430.418031] Subtest invalid-ring: SUCCESS (0.000s)
[430.508742] [081/133] (594s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[430.600093] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[430.603714] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[430.696522] [082/133] (594s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[430.745502] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[430.747440] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[430.850849] [083/133] (594s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[430.944039] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[430.971015] Starting dynamic subtest: pipe-A-plane-0
[431.392604] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[431.402125] Starting dynamic subtest: pipe-A-plane-3
[431.647910] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[432.765265] Starting dynamic subtest: pipe-B-plane-0
[433.190675] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[433.200899] Starting dynamic subtest: pipe-B-plane-3
[433.445574] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[433.758333] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.813s)
[434.600219] [084/133] (590s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[434.705056] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[434.707265] Starting dynamic subtest: pipe-A-eDP-1
[434.780551] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[434.792395] Starting dynamic subtest: pipe-B-eDP-1
[435.957545] Dynamic subtest pipe-B-eDP-1: SKIP (1.175s)
[435.962215] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.255s)
[437.216957] [085/133] (588s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[437.273351] Subtest writes-after-reads-snoop: SKIP (0.000s)
[437.371906] [086/133] (588s left) kms_vrr (flip-dpms)
[437.467055] Starting subtest: flip-dpms
[437.473178] Subtest flip-dpms: SKIP (0.000s)
[437.563735] [087/133] (587s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[437.611586] Starting subtest: y-tiled-ccs-to-y-tiled
[437.615747] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[437.796538] [088/133] (587s left) gem_ctx_engines (execute-allforone)
[437.856295] Starting subtest: execute-allforone
[437.870337] Subtest execute-allforone: SUCCESS (0.014s)
[439.471069] [089/133] (586s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[439.576416] Starting subtest: fbc-psr2-sprite-mmap-gtt
[439.578230] Starting dynamic subtest: eDP-1
[439.582374] Dynamic subtest eDP-1: SKIP (0.000s)
[439.586460] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[439.648325] [090/133] (585s left) api_intel_bb (destroy-bb)
[439.708332] Starting subtest: destroy-bb
[439.717203] Subtest destroy-bb: SUCCESS (0.009s)
[439.799571] [091/133] (585s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[439.904504] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[439.906730] Starting dynamic subtest: A-eDP1
[443.540499] Dynamic subtest A-eDP1: SUCCESS (3.634s)
[443.550902] Starting dynamic subtest: B-eDP1
[446.842403] Dynamic subtest B-eDP1: SUCCESS (3.301s)
[446.852824] Starting dynamic subtest: C-eDP1
[450.126338] Dynamic subtest C-eDP1: SUCCESS (3.282s)
[450.136637] Starting dynamic subtest: D-eDP1
[453.431632] Dynamic subtest D-eDP1: SUCCESS (3.303s)
[453.433842] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.528s)
[454.322319] [092/133] (571s left) gem_basic (multigpu-create-close)
[454.392196] Starting subtest: multigpu-create-close
[454.396556] Subtest multigpu-create-close: SKIP (0.000s)
[454.500085] [093/133] (571s left) kms_lease (cursor-implicit-plane)
[454.597029] Starting subtest: cursor-implicit-plane
[454.599329] Starting dynamic subtest: pipe-A-eDP-1
[455.052654] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.456s)
[455.063014] Starting dynamic subtest: pipe-B-eDP-1
[456.191325] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.138s)
[456.201407] Starting dynamic subtest: pipe-C-eDP-1
[457.276232] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.080s)
[457.286837] Starting dynamic subtest: pipe-D-eDP-1
[458.374226] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.095s)
[458.375992] Subtest cursor-implicit-plane: SUCCESS (3.777s)
[459.201234] [094/133] (566s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[459.265626] Starting subtest: invalid-multi-wait-all-unsubmitted
[459.267601] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[459.386037] [095/133] (566s left) i915_drm_fdinfo (all-busy-idle-check-all)
[459.429809] Starting subtest: all-busy-idle-check-all
[459.437329] Subtest all-busy-idle-check-all: SKIP (0.004s)
[459.510371] [096/133] (566s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[459.631112] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[459.633386] Starting dynamic subtest: pipe-A-eDP-1
[475.379658] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.439s)
[475.389948] Starting dynamic subtest: pipe-B-eDP-1
[492.359150] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.444s)
[492.369733] Starting dynamic subtest: pipe-C-eDP-1
[509.368765] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.345s)
[509.386018] Starting dynamic subtest: pipe-D-eDP-1
[526.371060] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.348s)
[526.373047] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.581s)
[527.586965] [097/133] (498s left) gem_mmap_offset (partial-remap)
[527.660560] Starting subtest: partial-remap
[527.662718] Starting dynamic subtest: smem0
[527.673675] Dynamic subtest smem0: SUCCESS (0.005s)
[527.675608] Subtest partial-remap: SUCCESS (0.007s)
[527.798441] [098/133] (498s left) kms_psr (fbc-psr2-cursor-blt)
[527.893688] Starting subtest: fbc-psr2-cursor-blt
[527.895925] Starting dynamic subtest: eDP-1
[527.899946] Dynamic subtest eDP-1: SKIP (0.000s)
[527.903881] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[527.980793] [099/133] (498s left) gem_ctx_shared (q-out-order)
[528.050825] Starting subtest: Q-out-order
[528.053143] Starting dynamic subtest: rcs0
[528.168229] Dynamic subtest rcs0: SUCCESS (0.115s)
[528.181381] Starting dynamic subtest: vcs0
[528.264278] Dynamic subtest vcs0: SUCCESS (0.094s)
[528.281527] Starting dynamic subtest: vcs1
[528.354393] Dynamic subtest vcs1: SUCCESS (0.088s)
[528.372904] Starting dynamic subtest: vecs0
[528.439279] Dynamic subtest vecs0: SUCCESS (0.083s)
[528.456541] Starting dynamic subtest: ccs0
[528.527470] Dynamic subtest ccs0: SUCCESS (0.086s)
[528.529979] Subtest Q-out-order: SUCCESS (0.473s)
[529.575475] [100/133] (496s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[529.680844] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[529.685218] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[529.785405] [101/133] (496s left) sw_sync (alloc_fence_invalid_timeline)
[529.823688] Starting subtest: alloc_fence_invalid_timeline
[529.825530] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[529.880785] [102/133] (496s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[529.966632] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[529.968802] Starting dynamic subtest: pipe-A-default-mode
[532.721260] Dynamic subtest pipe-A-default-mode: SUCCESS (2.733s)
[532.723521] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.735s)
[533.759600] [103/133] (492s left) kms_big_fb (linear-64bpp-rotate-270)
[533.870279] Starting subtest: linear-64bpp-rotate-270
[533.890524] Subtest linear-64bpp-rotate-270: SKIP (0.019s)
[534.030810] [104/133] (492s left) gem_workarounds (reset-fd)
[534.099424] Starting subtest: reset-fd
[534.291097] Subtest reset-fd: SUCCESS (0.191s)
[534.416129] [105/133] (491s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[534.522793] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[534.530769] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.010s)
[534.648623] [106/133] (491s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[534.746065] Starting subtest: plane-all-transition-nonblocking-fencing
[534.747997] Starting dynamic subtest: pipe-A-eDP-1
[537.250877] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[537.559036] Starting dynamic subtest: pipe-B-eDP-1
[540.764756] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.207s)
[541.064039] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.296s)
[541.860426] [107/133] (484s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[541.955788] Starting subtest: fbcpsr-shrfb-scaledprimary
[547.653293] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.691s)
[547.810601] [108/133] (478s left) gem_render_copy (x-tiled)
[547.872792] Starting subtest: x-tiled
[547.875085] Starting dynamic subtest: smem
[547.913355] Dynamic subtest smem: SUCCESS (0.040s)
[547.915746] Subtest x-tiled: SUCCESS (0.041s)
[548.098807] [109/133] (478s left) gem_mmap_gtt (big-bo)
[548.152931] Subtest big-bo: SKIP (0.000s)
[548.213739] [110/133] (478s left) kms_hdr (bpc-switch-dpms)
[548.307671] Starting subtest: bpc-switch-dpms
[549.424681] Starting dynamic subtest: pipe-A-eDP-1
[553.916828] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.490s)
[553.919377] Subtest bpc-switch-dpms: SUCCESS (5.607s)
[554.080572] [111/133] (472s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[554.180625] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[554.182585] Starting dynamic subtest: pipe-A-eDP-1
[554.599190] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.419s)
[554.612407] Starting dynamic subtest: pipe-B-eDP-1
[554.632776] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[554.643221] Starting dynamic subtest: pipe-C-eDP-1
[554.662654] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[554.672504] Starting dynamic subtest: pipe-D-eDP-1
[554.691905] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[554.694118] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.434s)
[556.886590] [112/133] (469s left) gem_madvise (dontneed-before-pwrite)
[556.926155] Starting subtest: dontneed-before-pwrite
[556.941176] Subtest dontneed-before-pwrite: SKIP (0.013s)
[557.008065] [113/133] (469s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[557.104173] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[557.108416] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[557.205938] [114/133] (469s left) gem_exec_schedule (preempt-other)
[557.274429] Starting subtest: preempt-other
[557.276705] Starting dynamic subtest: rcs0
[557.340476] Dynamic subtest rcs0: SUCCESS (0.073s)
[557.355323] Starting dynamic subtest: bcs0
[557.406487] Dynamic subtest bcs0: SUCCESS (0.066s)
[557.419386] Starting dynamic subtest: vcs0
[557.479842] Dynamic subtest vcs0: SUCCESS (0.072s)
[557.496896] Starting dynamic subtest: vcs1
[557.548279] Dynamic subtest vcs1: SUCCESS (0.067s)
[557.559547] Starting dynamic subtest: vecs0
[557.622900] Dynamic subtest vecs0: SUCCESS (0.074s)
[557.638968] Starting dynamic subtest: ccs0
[557.690859] Dynamic subtest ccs0: SUCCESS (0.066s)
[557.693295] Subtest preempt-other: SUCCESS (0.424s)
[558.503739] [115/133] (468s left) gem_exec_reloc (basic-write-gtt-noreloc)
[558.574285] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[558.649364] [116/133] (468s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[558.742292] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[559.421826] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.681s)
[559.587118] [117/133] (467s left) kms_psr2_su (frontbuffer-xrgb8888)
[559.647703] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[559.714525] [118/133] (467s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[559.797662] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[566.564859] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.770s)
[566.705533] [119/133] (460s left) kms_draw_crc (fill-fb)
[566.794299] Starting subtest: fill-fb
[567.223732] Subtest fill-fb: SUCCESS (0.431s)
[567.324094] [120/133] (459s left) api_intel_allocator (two-level-inception)
[567.383430] Starting subtest: two-level-inception
[572.780841] Subtest two-level-inception: SUCCESS (5.399s)
[572.916023] [121/133] (454s left) gem_exec_params (cliprects-invalid)
[572.983323] Starting subtest: cliprects-invalid
[572.985696] Subtest cliprects-invalid: SUCCESS (0.000s)
[573.115887] [122/133] (453s left) kms_fbcon_fbt (psr-suspend)
[573.180354] Starting subtest: psr-suspend
[622.325892] Subtest psr-suspend: SUCCESS (23.323s)
[622.418647] [123/133] (404s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[622.527665] Starting subtest: pr-overlay-plane-update-continuous-sf
[622.532815] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[622.599105] [124/133] (404s left) gem_ctx_persistence (legacy-engines-hang)
[622.655969] Starting subtest: legacy-engines-hang
[622.658773] Starting dynamic subtest: render
[622.780158] Dynamic subtest render: SUCCESS (0.125s)
[622.792266] Starting dynamic subtest: bsd1
[622.883126] Dynamic subtest bsd1: SUCCESS (0.100s)
[622.896172] Starting dynamic subtest: bsd2
[622.984347] Dynamic subtest bsd2: SUCCESS (0.098s)
[622.995677] Starting dynamic subtest: blt
[623.086453] Dynamic subtest blt: SUCCESS (0.098s)
[623.100856] Starting dynamic subtest: vebox
[623.197565] Dynamic subtest vebox: SUCCESS (0.108s)
[623.200420] Subtest legacy-engines-hang: SUCCESS (0.543s)
[623.278105] [125/133] (403s left) kms_pm_rpm (fences-dpms)
[625.312387] Starting subtest: fences-dpms
[625.317806] Subtest fences-dpms: SKIP (0.000s)
[625.705436] [126/133] (401s left) kms_psr (psr2-cursor-render)
[625.808372] Starting subtest: psr2-cursor-render
[625.810652] Starting dynamic subtest: eDP-1
[627.478018] Dynamic subtest eDP-1: SUCCESS (1.660s)
[627.480549] Subtest psr2-cursor-render: SUCCESS (1.661s)
[628.336478] [127/133] (398s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[628.436367] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[628.441812] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[628.526913] [128/133] (398s left) kms_properties (crtc-properties-legacy)
[628.617722] Starting subtest: crtc-properties-legacy
[628.620438] Starting dynamic subtest: pipe-A-eDP-1
[629.059165] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.440s)
[629.072048] Starting dynamic subtest: pipe-B-eDP-1
[630.270873] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.205s)
[630.282058] Starting dynamic subtest: pipe-C-eDP-1
[631.473119] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.197s)
[631.483514] Starting dynamic subtest: pipe-D-eDP-1
[632.675989] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.198s)
[632.678745] Subtest crtc-properties-legacy: SUCCESS (4.046s)
[633.550373] [129/133] (393s left) i915_query (test-query-geometry-subslices)
[633.609898] Starting subtest: test-query-geometry-subslices
[633.612229] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[633.703292] [130/133] (393s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[633.794771] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[637.520406] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.723s)
[638.669809] [131/133] (388s left) kms_pipe_crc_basic (hang-read-crc)
[638.772927] Starting subtest: hang-read-crc
[638.775299] Starting dynamic subtest: pipe-A-eDP-1
[640.910156] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.135s)
[640.920411] Starting dynamic subtest: pipe-B-eDP-1
[643.697898] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.784s)
[643.709133] Starting dynamic subtest: pipe-C-eDP-1
[646.358683] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.658s)
[646.369587] Starting dynamic subtest: pipe-D-eDP-1
[648.966413] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.604s)
[648.969171] Subtest hang-read-crc: SUCCESS (10.186s)
[649.768278] [132/133] (377s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[649.869554] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[649.875143] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[649.950311] [133/133] (377s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[650.036050] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[650.038878] Starting dynamic subtest: pipe-A-eDP-1
[650.062744] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s)
[650.074638] Starting dynamic subtest: pipe-B-eDP-1
[650.097991] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.021s)
[650.108913] Starting dynamic subtest: pipe-C-eDP-1
[650.132595] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.023s)
[650.142892] Starting dynamic subtest: pipe-D-eDP-1
[650.165980] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s)
[650.168551] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.093s)
[652.366384] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_cursor_crc
results: parsing output: 2/ for test: gem_exec_reloc
results: parsing output: 3/ for test: core_setmaster
results: parsing output: 4/ for test: gem_userptr_blits
results: parsing output: 5/ for test: gem_exec_capture
results: parsing output: 6/ for test: kms_flip
results: parsing output: 7/ for test: kms_async_flips
results: parsing output: 8/ for test: gem_lmem_swapping
results: parsing output: 9/ for test: gem_exec_params
results: parsing output: 10/ for test: gem_render_copy
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: gem_render_copy
results: parsing output: 13/ for test: kms_draw_crc
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: kms_plane_cursor
results: parsing output: 16/ for test: gem_userptr_blits
results: parsing output: 17/ for test: gem_exec_balancer
results: parsing output: 18/ for test: kms_plane_scaling
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: kms_chamelium_edid
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_display_modes
results: parsing output: 23/ for test: kms_content_protection
results: parsing output: 24/ for test: kms_setmode
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 27/ for test: gem_softpin
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: sriov_basic
results: parsing output: 30/ for test: kms_cursor_legacy
results: parsing output: 31/ for test: kms_atomic_interruptible
results: parsing output: 32/ for test: gem_lmem_swapping
results: parsing output: 33/ for test: i915_pm_rpm
results: parsing output: 34/ for test: kms_pm_lpsp
results: parsing output: 35/ for test: gem_render_copy
results: parsing output: 36/ for test: gem_workarounds
results: parsing output: 37/ for test: syncobj_wait
results: parsing output: 38/ for test: i915_hangman
results: parsing output: 39/ for test: kms_color_pipeline
results: parsing output: 40/ for test: kms_pipe_b_c_ivb
results: parsing output: 41/ for test: kms_flip_scaled_crc
results: parsing output: 42/ for test: kms_invalid_mode
results: parsing output: 43/ for test: gem_ctx_persistence
results: parsing output: 44/ for test: perf_pmu
results: parsing output: 45/ for test: kms_vrr
results: parsing output: 46/ for test: kms_hdmi_inject
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: vgem_basic
results: parsing output: 49/ for test: gem_exec_params
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: gem_exec_fence
results: parsing output: 52/ for test: vgem_basic
results: parsing output: 53/ for test: gen9_exec_parse
results: parsing output: 54/ for test: kms_vblank
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_cursor_crc
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_cursor_crc
results: parsing output: 61/ for test: kms_plane_scaling
results: parsing output: 62/ for test: kms_chamelium_hpd
results: parsing output: 63/ for test: syncobj_eventfd
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: gem_exec_whisper
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: kms_addfb_basic
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_pread
results: parsing output: 71/ for test: kms_busy
results: parsing output: 72/ for test: kms_cursor_legacy
results: parsing output: 73/ for test: gem_exec_schedule
results: parsing output: 74/ for test: kms_force_connector_basic
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: gem_caching
results: parsing output: 78/ for test: kms_psr_stress_test
results: parsing output: 79/ for test: gem_exec_params
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: kms_plane
results: parsing output: 83/ for test: kms_psr2_sf
results: parsing output: 84/ for test: gem_partial_pwrite_pread
results: parsing output: 85/ for test: kms_vrr
results: parsing output: 86/ for test: gem_render_copy
results: parsing output: 87/ for test: gem_ctx_engines
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: api_intel_bb
results: parsing output: 90/ for test: kms_flip
results: parsing output: 91/ for test: gem_basic
results: parsing output: 92/ for test: kms_lease
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: i915_drm_fdinfo
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: gem_mmap_offset
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: gem_ctx_shared
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: sw_sync
results: parsing output: 101/ for test: kms_flip_scaled_crc
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: gem_workarounds
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: kms_atomic_transition
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_render_copy
results: parsing output: 108/ for test: gem_mmap_gtt
results: parsing output: 109/ for test: kms_hdr
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: gem_madvise
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_exec_schedule
results: parsing output: 114/ for test: gem_exec_reloc
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_psr2_su
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_draw_crc
results: parsing output: 119/ for test: api_intel_allocator
results: parsing output: 120/ for test: gem_exec_params
results: parsing output: 121/ for test: kms_fbcon_fbt
results: parsing output: 122/ for test: kms_psr2_sf
results: parsing output: 123/ for test: gem_ctx_persistence
results: parsing output: 124/ for test: kms_pm_rpm
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_properties
results: parsing output: 128/ for test: i915_query
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_pipe_crc_basic
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_ccs
Done.