[58.761841] Initializing watchdogs
[58.761890]   /dev/watchdog0
[58.777151] [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]
[58.781946] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.784351] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.786209] [001/133] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[58.889839] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[63.413707] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.542s)
[64.603485] [002/133] (954s left) kms_cursor_crc (cursor-offscreen-32x32)
[64.750079] Starting subtest: cursor-offscreen-32x32
[64.798254] Subtest cursor-offscreen-32x32: SKIP (0.048s)
[65.070559] [003/133] (954s left) gem_exec_reloc (basic-gtt-read-noreloc)
[65.123985] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[65.181750] [004/133] (954s left) core_setmaster (master-drop-set-user)
[65.256977] Starting subtest: master-drop-set-user
[65.271260] Subtest master-drop-set-user: SUCCESS (0.014s)
[65.297899] [005/133] (954s left) gem_userptr_blits (invalid-null-pointer)
[65.351077] Starting subtest: invalid-null-pointer
[65.351850] Subtest invalid-null-pointer: SUCCESS (0.001s)
[65.471654] [006/133] (953s left) gem_exec_capture (capture-recoverable)
[65.526360] Starting subtest: capture-recoverable
[65.528590] Subtest capture-recoverable: SUCCESS (0.002s)
[65.657252] [007/133] (953s left) kms_flip (flip-vs-fences)
[65.736888] Starting subtest: flip-vs-fences
[65.738612] Subtest flip-vs-fences: SKIP (0.000s)
[65.856777] [008/133] (953s left) kms_async_flips (test-time-stamp)
[65.955338] Starting subtest: test-time-stamp
[66.332549] Starting dynamic subtest: pipe-A-eDP-1
[67.089359] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.757s)
[67.486975] Starting dynamic subtest: pipe-B-eDP-1
[68.236818] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.757s)
[68.608923] Starting dynamic subtest: pipe-C-eDP-1
[69.374475] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.771s)
[69.736947] Starting dynamic subtest: pipe-D-eDP-1
[70.500563] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.769s)
[70.501741] Subtest test-time-stamp: SUCCESS (4.551s)
[71.658072] [009/133] (947s left) gem_lmem_swapping (parallel-random-verify-ccs)
[71.695191] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[71.727537] [010/133] (947s left) gem_exec_params (invalid-batch-start-offset)
[71.771914] Starting subtest: invalid-batch-start-offset
[71.773953] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[71.875279] [011/133] (947s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[71.934788] Starting subtest: yf-tiled-ccs-to-yf-tiled
[71.936712] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[72.128164] [012/133] (947s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[72.233973] Starting subtest: y-tiled-addfb-size-offset-overflow
[72.235924] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[72.314965] [013/133] (947s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[72.383327] Starting subtest: y-tiled-to-vebox-yf-tiled
[72.385265] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[72.568725] [014/133] (947s left) kms_draw_crc (draw-method-mmap-wc)
[72.656679] Starting subtest: draw-method-mmap-wc
[72.657903] Starting dynamic subtest: xrgb8888-untiled
[72.876199] Dynamic subtest xrgb8888-untiled: SUCCESS (0.222s)
[72.881862] Starting dynamic subtest: rgb565-untiled
[73.087442] Dynamic subtest rgb565-untiled: SUCCESS (0.211s)
[73.094773] Starting dynamic subtest: xrgb2101010-untiled
[73.309971] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[73.317565] Starting dynamic subtest: xbgr16161616f-untiled
[73.531410] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.222s)
[73.538045] Starting dynamic subtest: xrgb8888-xtiled
[73.664635] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[73.670931] Starting dynamic subtest: rgb565-xtiled
[73.786738] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[73.792776] Starting dynamic subtest: xrgb2101010-xtiled
[73.909127] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[73.915734] Starting dynamic subtest: xbgr16161616f-xtiled
[74.042089] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[74.048243] Starting dynamic subtest: xrgb8888-4tiled
[74.208693] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.166s)
[74.214802] Starting dynamic subtest: rgb565-4tiled
[74.375106] Dynamic subtest rgb565-4tiled: SUCCESS (0.166s)
[74.382578] Starting dynamic subtest: xrgb2101010-4tiled
[74.530756] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.155s)
[74.538053] Starting dynamic subtest: xbgr16161616f-4tiled
[74.719505] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.188s)
[74.720540] Subtest draw-method-mmap-wc: SUCCESS (2.067s)
[74.831616] [015/133] (944s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[74.918389] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[76.062696] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.145s)
[76.189126] [016/133] (943s left) kms_plane_cursor (viewport)
[76.284016] Starting subtest: viewport
[76.285886] Starting dynamic subtest: pipe-A-eDP-1-size-64
[78.872959] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.590s)
[78.935944] Starting dynamic subtest: pipe-A-eDP-1-size-128
[81.477581] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.550s)
[81.533943] Starting dynamic subtest: pipe-A-eDP-1-size-256
[84.076500] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.549s)
[84.423296] Starting dynamic subtest: pipe-B-eDP-1-size-64
[87.727911] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.314s)
[87.789459] Starting dynamic subtest: pipe-B-eDP-1-size-128
[90.374061] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.594s)
[90.433231] Starting dynamic subtest: pipe-B-eDP-1-size-256
[92.941917] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.516s)
[93.295829] Starting dynamic subtest: pipe-C-eDP-1-size-64
[96.243735] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.957s)
[96.279748] Starting dynamic subtest: pipe-C-eDP-1-size-128
[98.466268] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.192s)
[98.503253] Starting dynamic subtest: pipe-C-eDP-1-size-256
[100.699937] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.203s)
[101.024781] Starting dynamic subtest: pipe-D-eDP-1-size-64
[103.920554] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.902s)
[103.956990] Starting dynamic subtest: pipe-D-eDP-1-size-128
[106.131710] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.180s)
[106.168347] Starting dynamic subtest: pipe-D-eDP-1-size-256
[108.354220] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.192s)
[108.678195] Subtest viewport: SUCCESS (32.390s)
[109.467298] [017/133] (910s left) gem_userptr_blits (stress-purge)
[109.524959] Starting subtest: stress-purge
[114.942818] Subtest stress-purge: SUCCESS (5.418s)
[115.069643] [018/133] (904s left) gem_exec_balancer (bonded-true-hang)
[115.375280] Starting subtest: bonded-true-hang
[115.377263] Subtest bonded-true-hang: SKIP (0.000s)
[115.469394] [019/133] (904s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[115.579501] Starting subtest: plane-downscale-factor-0-75-with-rotation
[115.580342] Starting dynamic subtest: pipe-A
[115.810151] Dynamic subtest pipe-A: SUCCESS (0.231s)
[115.822490] Starting dynamic subtest: pipe-B
[117.088973] Dynamic subtest pipe-B: SUCCESS (1.278s)
[117.095175] Starting dynamic subtest: pipe-C
[118.401101] Dynamic subtest pipe-C: SUCCESS (1.311s)
[118.407868] Starting dynamic subtest: pipe-D
[119.724496] Dynamic subtest pipe-D: SUCCESS (1.323s)
[119.725512] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.146s)
[120.892353] [020/133] (898s left) syncobj_timeline (single-wait-available-submitted)
[120.952516] Starting subtest: single-wait-available-submitted
[120.953575] Subtest single-wait-available-submitted: SUCCESS (0.001s)
[121.037281] [021/133] (898s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[121.440676] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[122.199801] [022/133] (897s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[122.299929] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[129.811096] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.512s)
[129.925588] [023/133] (890s left) kms_display_modes (extended-mode-basic)
[130.021367] Starting subtest: extended-mode-basic
[130.022948] Subtest extended-mode-basic: SKIP (0.000s)
[130.058613] [024/133] (889s left) kms_content_protection (dp-mst-type-0)
[130.190700] Starting subtest: dp-mst-type-0
[130.192390] Subtest dp-mst-type-0: SKIP (0.000s)
[130.288826] [025/133] (889s left) kms_setmode (invalid-clone-single-crtc-stealing)
[130.336100] Starting subtest: invalid-clone-single-crtc-stealing
[130.338522] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[130.424360] [026/133] (889s left) kms_psr (pr-suspend)
[130.507577] Starting subtest: pr-suspend
[130.509346] Subtest pr-suspend: SKIP (0.000s)
[130.573970] [027/133] (889s left) gem_tiled_partial_pwrite_pread (writes)
[130.635290] Subtest writes: SKIP (0.000s)
[130.696431] [028/133] (889s left) gem_softpin (evict-prime-sanity-check)
[130.760650] Starting subtest: evict-prime-sanity-check
[130.761836] Starting dynamic subtest: rcs0
[131.912912] Dynamic subtest rcs0: SUCCESS (1.151s)
[131.923020] Starting dynamic subtest: bcs0
[133.026436] Dynamic subtest bcs0: SUCCESS (1.111s)
[133.035529] Starting dynamic subtest: vcs0
[134.859545] Dynamic subtest vcs0: SUCCESS (1.822s)
[134.868604] Starting dynamic subtest: vcs1
[136.838786] Dynamic subtest vcs1: SUCCESS (1.977s)
[136.849302] Starting dynamic subtest: vecs0
[138.885882] Dynamic subtest vecs0: SUCCESS (2.044s)
[138.894850] Starting dynamic subtest: ccs0
[140.027362] Dynamic subtest ccs0: SUCCESS (1.149s)
[140.035811] Starting dynamic subtest: all
[141.141197] Dynamic subtest all: SUCCESS (1.113s)
[141.143569] Subtest evict-prime-sanity-check: SUCCESS (10.382s)
[141.214036] [029/133] (878s left) kms_flip (bo-too-big-interruptible)
[141.316289] Starting subtest: bo-too-big-interruptible
[141.318587] Starting dynamic subtest: A-eDP1
[142.612055] Dynamic subtest A-eDP1: SUCCESS (1.293s)
[142.620510] Starting dynamic subtest: B-eDP1
[143.845587] Dynamic subtest B-eDP1: SUCCESS (1.231s)
[143.851983] Starting dynamic subtest: C-eDP1
[145.083331] Dynamic subtest C-eDP1: SUCCESS (1.237s)
[145.092611] Starting dynamic subtest: D-eDP1
[146.323559] Dynamic subtest D-eDP1: SUCCESS (1.237s)
[146.326598] Subtest bo-too-big-interruptible: SUCCESS (5.009s)
[147.523530] [030/133] (872s left) sriov_basic (enable-vfs-autoprobe-off)
[147.574579] Starting subtest: enable-vfs-autoprobe-off
[147.575548] Starting dynamic subtest: numvfs-1
[147.608882] Dynamic subtest numvfs-1: FAIL (0.015s)
[147.615348] Starting dynamic subtest: numvfs-2
[147.643521] Dynamic subtest numvfs-2: FAIL (0.004s)
[147.649670] Starting dynamic subtest: numvfs-3
[147.676455] Dynamic subtest numvfs-3: FAIL (0.003s)
[147.682454] Starting dynamic subtest: numvfs-4
[147.707868] Dynamic subtest numvfs-4: FAIL (0.004s)
[147.713791] Starting dynamic subtest: numvfs-5
[147.739407] Dynamic subtest numvfs-5: FAIL (0.004s)
[147.745241] Starting dynamic subtest: numvfs-6
[147.770891] Dynamic subtest numvfs-6: FAIL (0.004s)
[147.776676] Starting dynamic subtest: numvfs-7
[147.802109] Dynamic subtest numvfs-7: FAIL (0.004s)
[147.808270] Starting dynamic subtest: numvfs-random
[147.833731] Dynamic subtest numvfs-random: FAIL (0.004s)
[147.839506] Starting dynamic subtest: numvfs-all
[147.864659] Dynamic subtest numvfs-all: FAIL (0.004s)
[147.865428] Subtest enable-vfs-autoprobe-off: FAIL (0.051s)
[147.891394] [031/133] (872s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[148.012507] Starting subtest: cursorB-vs-flipA-atomic
[148.016771] Subtest cursorB-vs-flipA-atomic: SKIP (0.003s)
[148.154841] [032/133] (872s left) kms_atomic_interruptible (atomic-setmode)
[148.252646] Starting subtest: atomic-setmode
[148.253520] Starting dynamic subtest: pipe-A-eDP-1
[155.125394] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.871s)
[155.126273] Subtest atomic-setmode: SUCCESS (6.873s)
[155.909878] [033/133] (864s left) gem_lmem_swapping (basic)
[155.951189] Subtest basic: SKIP (0.000s)
[155.982725] [034/133] (864s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[158.017070] Starting subtest: gem-execbuf-stress-pc8
[158.054869] Subtest gem-execbuf-stress-pc8: SKIP (0.037s)
[158.410536] [035/133] (861s left) kms_pm_lpsp (kms-lpsp)
[159.511435] Starting subtest: kms-lpsp
[159.512376] Starting dynamic subtest: pipe-A-eDP-1
[159.662367] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.150s)
[159.957684] Subtest kms-lpsp: SUCCESS (0.446s)
[160.818659] [036/133] (859s left) gem_render_copy (y-tiled-ccs-to-linear)
[160.866891] Starting subtest: y-tiled-ccs-to-linear
[160.868713] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[161.041292] [037/133] (859s left) gem_workarounds (suspend-resume)
[161.106660] Starting subtest: suspend-resume
[177.981882] Subtest suspend-resume: SUCCESS (2.484s)
[185.143245] [038/133] (842s left) syncobj_wait (wait-delayed-signal)
[185.199915] Starting subtest: wait-delayed-signal
[185.302756] Subtest wait-delayed-signal: SUCCESS (0.104s)
[185.370025] [039/133] (842s left) i915_hangman (gt-error-state-capture)
[185.428816] Starting subtest: gt-error-state-capture
[185.429610] Starting dynamic subtest: rcs0
[196.277628] Dynamic subtest rcs0: SUCCESS (10.965s)
[196.287864] Starting dynamic subtest: bcs0
[207.285276] Dynamic subtest bcs0: SUCCESS (11.039s)
[207.294541] Starting dynamic subtest: vcs0
[219.253352] Dynamic subtest vcs0: SUCCESS (11.971s)
[219.263634] Starting dynamic subtest: vcs1
[230.199634] Dynamic subtest vcs1: SUCCESS (10.939s)
[230.209946] Starting dynamic subtest: vecs0
[239.285388] Dynamic subtest vecs0: SUCCESS (9.083s)
[239.295778] Starting dynamic subtest: ccs0
[251.254327] Dynamic subtest ccs0: SUCCESS (11.968s)
[251.256040] Subtest gt-error-state-capture: SUCCESS (65.981s)
[251.385908] [040/133] (776s left) kms_color_pipeline (plane-lut1d)
[251.487927] Starting subtest: plane-lut1d
[251.613297] Starting dynamic subtest: pipe-A-plane-0
[251.779683] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[251.787257] Starting dynamic subtest: pipe-A-plane-1
[251.924042] Dynamic subtest pipe-A-plane-1: SUCCESS (0.144s)
[251.931636] Starting dynamic subtest: pipe-A-plane-2
[252.090713] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[253.261297] Starting dynamic subtest: pipe-B-plane-0
[253.444185] Dynamic subtest pipe-B-plane-0: SUCCESS (0.188s)
[253.456049] Starting dynamic subtest: pipe-B-plane-1
[253.609686] Dynamic subtest pipe-B-plane-1: SUCCESS (0.164s)
[253.617735] Starting dynamic subtest: pipe-B-plane-2
[253.776384] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[254.991527] Starting dynamic subtest: pipe-C-plane-0
[255.139239] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[255.147180] Starting dynamic subtest: pipe-C-plane-1
[255.294854] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[255.302720] Starting dynamic subtest: pipe-C-plane-2
[255.439244] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[256.643059] Starting dynamic subtest: pipe-D-plane-0
[256.791100] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[256.799036] Starting dynamic subtest: pipe-D-plane-1
[256.946782] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[256.954923] Starting dynamic subtest: pipe-D-plane-2
[257.091135] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[257.388677] Subtest plane-lut1d: SUCCESS (5.902s)
[258.182276] [041/133] (769s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[258.248071] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[258.311041] [042/133] (769s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[258.391911] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[258.392787] Starting dynamic subtest: pipe-A-default-mode
[259.549578] Dynamic subtest pipe-A-default-mode: SKIP (1.156s)
[259.551380] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.158s)
[259.677038] [043/133] (767s left) kms_invalid_mode (bad-vsync-end)
[259.771084] Starting subtest: bad-vsync-end
[259.772056] Starting dynamic subtest: pipe-A-eDP-1
[260.057034] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[260.065691] Starting dynamic subtest: pipe-B-eDP-1
[260.066598] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[260.073562] Starting dynamic subtest: pipe-C-eDP-1
[260.074400] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[260.081406] Starting dynamic subtest: pipe-D-eDP-1
[260.082252] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[260.083107] Subtest bad-vsync-end: SUCCESS (0.292s)
[260.854606] [044/133] (766s left) gem_ctx_persistence (engines-queued)
[260.922516] Starting subtest: engines-queued
[260.923455] Starting dynamic subtest: rcs0
[261.014146] Dynamic subtest rcs0: SUCCESS (0.091s)
[261.027014] Starting dynamic subtest: bcs0
[261.034279] Dynamic subtest bcs0: SUCCESS (0.019s)
[261.042033] Starting dynamic subtest: vcs0
[262.262841] Dynamic subtest vcs0: SUCCESS (1.219s)
[262.271739] Starting dynamic subtest: vcs1
[264.310998] Dynamic subtest vcs1: SUCCESS (2.047s)
[264.320045] Starting dynamic subtest: vecs0
[266.293326] Dynamic subtest vecs0: SUCCESS (1.980s)
[266.301062] Starting dynamic subtest: ccs0
[266.456174] Dynamic subtest ccs0: SUCCESS (0.169s)
[266.457692] Subtest engines-queued: SUCCESS (5.536s)
[266.561048] [045/133] (761s left) perf_pmu (render-node-busy)
[266.632077] Starting subtest: render-node-busy
[266.633785] Starting dynamic subtest: rcs0
[267.225674] Dynamic subtest rcs0: SUCCESS (0.593s)
[267.236628] Starting dynamic subtest: bcs0
[267.794616] Dynamic subtest bcs0: SUCCESS (0.566s)
[267.806675] Starting dynamic subtest: vcs0
[269.334989] Dynamic subtest vcs0: SUCCESS (1.529s)
[269.344014] Starting dynamic subtest: vcs1
[271.320175] Dynamic subtest vcs1: SUCCESS (1.983s)
[271.329905] Starting dynamic subtest: vecs0
[273.303393] Dynamic subtest vecs0: SUCCESS (1.981s)
[273.314926] Starting dynamic subtest: ccs0
[273.857283] Dynamic subtest ccs0: SUCCESS (0.560s)
[273.858776] Subtest render-node-busy: SUCCESS (7.229s)
[273.927033] [046/133] (753s left) kms_vrr (seamless-rr-switch-vrr)
[274.013640] Starting subtest: seamless-rr-switch-vrr
[274.016463] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[274.081751] [047/133] (753s left) kms_hdmi_inject (inject-audio)
[274.412178] Starting subtest: inject-audio
[274.688412] Subtest inject-audio: SUCCESS (0.278s)
[275.316514] [048/133] (752s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[275.402810] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[275.405435] Starting dynamic subtest: A-eDP1
[279.001960] Dynamic subtest A-eDP1: SUCCESS (3.598s)
[279.012549] Starting dynamic subtest: B-eDP1
[282.312284] Dynamic subtest B-eDP1: SUCCESS (3.307s)
[282.320105] Starting dynamic subtest: C-eDP1
[285.613839] Dynamic subtest C-eDP1: SUCCESS (3.299s)
[285.624634] Starting dynamic subtest: D-eDP1
[288.911346] Dynamic subtest D-eDP1: SUCCESS (3.296s)
[288.914329] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.508s)
[289.776816] [049/133] (737s left) vgem_basic (dmabuf-export)
[289.881074] Starting subtest: dmabuf-export
[289.918294] Subtest dmabuf-export: SUCCESS (0.037s)
[290.013256] [FACT vgem_basic (dmabuf-export)] new: kernel.kmod_is_loaded.vgem: true
[290.016260] [050/133] (737s left) gem_exec_params (no-bsd)
[290.063799] Starting subtest: no-bsd
[290.066507] Subtest no-bsd: SUCCESS (0.003s)
[291.337808] [051/133] (736s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[291.385852] Starting subtest: invalid-single-wait-all-unsubmitted
[291.386751] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[291.479993] [052/133] (736s left) gem_exec_fence (keep-in-fence)
[291.671906] Starting subtest: keep-in-fence
[291.672821] Starting dynamic subtest: rcs0
[291.735946] Dynamic subtest rcs0: SUCCESS (0.070s)
[291.754172] Starting dynamic subtest: bcs0
[291.791233] Dynamic subtest bcs0: SUCCESS (0.052s)
[291.803776] Starting dynamic subtest: vcs0
[293.338108] Dynamic subtest vcs0: SUCCESS (1.534s)
[293.348734] Starting dynamic subtest: vcs1
[295.322062] Dynamic subtest vcs1: SUCCESS (1.980s)
[295.332875] Starting dynamic subtest: vecs0
[297.305468] Dynamic subtest vecs0: SUCCESS (1.980s)
[297.316344] Starting dynamic subtest: ccs0
[297.524156] Dynamic subtest ccs0: SUCCESS (0.226s)
[297.525772] Subtest keep-in-fence: SUCCESS (5.858s)
[299.351831] [053/133] (728s left) vgem_basic (second-client)
[299.388577] Starting subtest: second-client
[299.409484] Subtest second-client: SUCCESS (0.022s)
[299.462586] [054/133] (728s left) gen9_exec_parse (cmd-crossing-page)
[299.521257] Subtest cmd-crossing-page: SKIP (0.000s)
[299.598156] [055/133] (728s left) kms_vblank (query-busy-hang)
[299.695729] Starting subtest: query-busy-hang
[299.696646] Starting dynamic subtest: pipe-A-eDP-1
[326.104191] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.406s)
[326.118372] Starting dynamic subtest: pipe-D-eDP-1
[341.151392] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.041s)
[341.152450] Subtest query-busy-hang: SUCCESS (41.457s)
[341.976199] [056/133] (686s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[342.063240] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[342.064993] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[342.152121] [057/133] (685s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[342.259393] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[342.261285] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[342.372065] [058/133] (685s left) kms_cursor_crc (cursor-random-512x170)
[342.680874] Starting subtest: cursor-random-512x170
[342.682869] Subtest cursor-random-512x170: SKIP (0.001s)
[342.812309] [059/133] (685s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[342.902011] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[346.963781] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.063s)
[348.193138] [060/133] (679s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[348.298331] Starting subtest: 4-tiled-32bpp-rotate-0
[349.777313] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.479s)
[349.908316] [061/133] (678s left) kms_cursor_crc (cursor-sliding-64x21)
[350.104862] Starting subtest: cursor-sliding-64x21
[350.150288] Subtest cursor-sliding-64x21: SKIP (0.043s)
[350.401164] [062/133] (677s left) kms_plane_scaling (planes-downscale-factor-0-75)
[350.491618] Starting subtest: planes-downscale-factor-0-75
[350.492458] Starting dynamic subtest: pipe-A
[350.513108] Dynamic subtest pipe-A: SKIP (0.019s)
[350.521656] Starting dynamic subtest: pipe-B
[350.549973] Dynamic subtest pipe-B: SKIP (0.037s)
[350.558602] Starting dynamic subtest: pipe-C
[350.584735] Dynamic subtest pipe-C: SKIP (0.033s)
[350.592854] Starting dynamic subtest: pipe-D
[350.618357] Dynamic subtest pipe-D: SKIP (0.033s)
[350.619992] Subtest planes-downscale-factor-0-75: SKIP (0.126s)
[350.723788] [063/133] (677s left) kms_chamelium_hpd (common-hpd-after-suspend)
[351.112432] Subtest common-hpd-after-suspend: SKIP (0.000s)
[351.938436] [064/133] (676s left) syncobj_eventfd (timeline-wait-before-signal)
[351.995590] Starting subtest: timeline-wait-before-signal
[352.025594] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[352.098725] [065/133] (676s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[352.181764] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[352.182670] Starting dynamic subtest: pipe-A-eDP-1
[352.687234] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.495s)
[352.699830] Starting dynamic subtest: pipe-B-eDP-1
[354.184846] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.496s)
[354.194099] Starting dynamic subtest: pipe-C-eDP-1
[355.604907] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.418s)
[355.615835] Starting dynamic subtest: pipe-D-eDP-1
[357.009671] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.401s)
[357.010604] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.817s)
[358.155095] [066/133] (670s left) gem_exec_whisper (basic-normal-all)
[358.212718] Starting subtest: basic-normal-all
[360.528356] Subtest basic-normal-all: SUCCESS (2.314s)
[360.721543] [067/133] (667s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[360.811250] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[367.436299] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.627s)
[367.548105] [068/133] (660s left) syncobj_timeline (wait-for-submit-complex)
[367.595560] Starting subtest: wait-for-submit-complex
[367.656675] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[367.727651] [069/133] (660s left) kms_addfb_basic (basic-x-tiled-legacy)
[367.788376] Starting subtest: basic-x-tiled-legacy
[367.790180] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[367.909293] [070/133] (660s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[367.998613] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[368.000411] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[368.099834] [071/133] (660s left) gem_pread (self)
[368.153568] Subtest self: SKIP (0.000s)
[368.208107] [072/133] (660s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[368.313619] Starting subtest: extended-modeset-hang-oldfb-with-reset
[368.315706] Starting dynamic subtest: pipe-A
[379.895671] Dynamic subtest pipe-A: SUCCESS (11.582s)
[379.914113] Starting dynamic subtest: pipe-D
[392.198385] Dynamic subtest pipe-D: SUCCESS (12.302s)
[392.199313] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.890s)
[393.055094] [073/133] (635s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[393.179669] Starting subtest: 2x-long-cursor-vs-flip-atomic
[393.182688] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[393.321517] [074/133] (635s left) gem_exec_schedule (submit-late-slice)
[393.390798] Starting subtest: submit-late-slice
[393.391832] Starting dynamic subtest: rcs0
[393.427995] Dynamic subtest rcs0: SUCCESS (0.038s)
[393.442075] Starting dynamic subtest: bcs0
[393.465700] Dynamic subtest bcs0: SUCCESS (0.037s)
[393.474042] Starting dynamic subtest: vcs0
[393.507624] Dynamic subtest vcs0: SUCCESS (0.041s)
[393.517516] Starting dynamic subtest: vcs1
[393.546129] Dynamic subtest vcs1: SUCCESS (0.038s)
[393.555565] Starting dynamic subtest: vecs0
[393.580291] Dynamic subtest vecs0: SUCCESS (0.033s)
[393.588799] Starting dynamic subtest: ccs0
[393.619781] Dynamic subtest ccs0: SUCCESS (0.038s)
[393.620849] Subtest submit-late-slice: SUCCESS (0.231s)
[395.358490] [075/133] (633s left) kms_force_connector_basic (force-load-detect)
[395.430652] Starting subtest: force-load-detect
[395.432402] Subtest force-load-detect: SKIP (0.000s)
[395.554376] [076/133] (633s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[395.660652] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[399.614695] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (3.954s)
[400.768876] [077/133] (627s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[400.848833] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[400.849774] Starting dynamic subtest: pipe-A-eDP-1
[402.160203] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.312s)
[402.170675] Starting dynamic subtest: pipe-B-eDP-1
[404.584942] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.424s)
[404.597882] Starting dynamic subtest: pipe-C-eDP-1
[406.999562] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.414s)
[407.010272] Starting dynamic subtest: pipe-D-eDP-1
[409.400467] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.399s)
[409.401587] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.554s)
[410.555810] [078/133] (618s left) gem_caching (reads)
[410.608704] Subtest reads: SKIP (0.000s)
[410.663602] [079/133] (618s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[410.752719] Starting subtest: invalidate-primary-flip-overlay
[421.535706] Subtest invalidate-primary-flip-overlay: SUCCESS (10.779s)
[421.648742] [080/133] (607s left) gem_exec_params (invalid-ring)
[421.723387] Starting subtest: invalid-ring
[421.724185] Subtest invalid-ring: SUCCESS (0.000s)
[421.835064] [081/133] (607s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[421.928852] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[421.930735] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[422.015893] [082/133] (606s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[422.076095] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[422.077102] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[422.185956] [083/133] (606s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[422.275436] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[422.303966] Starting dynamic subtest: pipe-A-plane-0
[422.725822] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[422.734221] Starting dynamic subtest: pipe-A-plane-3
[422.981456] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[424.116293] Starting dynamic subtest: pipe-B-plane-0
[424.541339] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[424.552309] Starting dynamic subtest: pipe-B-plane-3
[424.796947] Dynamic subtest pipe-B-plane-3: SUCCESS (0.253s)
[425.105655] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.828s)
[425.951938] [084/133] (603s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[426.056850] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[426.057740] Starting dynamic subtest: pipe-A-eDP-1
[426.136097] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s)
[426.145658] Starting dynamic subtest: pipe-B-eDP-1
[427.299765] Dynamic subtest pipe-B-eDP-1: SKIP (1.162s)
[427.301459] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.243s)
[428.546792] [085/133] (600s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[428.602196] Subtest writes-after-reads-snoop: SKIP (0.000s)
[428.675075] [086/133] (600s left) kms_vrr (flip-dpms)
[428.762735] Starting subtest: flip-dpms
[428.765183] Subtest flip-dpms: SKIP (0.000s)
[428.832170] [087/133] (600s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[428.882157] Starting subtest: y-tiled-ccs-to-y-tiled
[428.883949] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[429.057410] [088/133] (600s left) gem_ctx_engines (execute-allforone)
[429.115457] Starting subtest: execute-allforone
[429.131501] Subtest execute-allforone: SUCCESS (0.016s)
[430.350487] [089/133] (598s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[430.441759] Starting subtest: fbc-psr2-sprite-mmap-gtt
[430.442613] Starting dynamic subtest: eDP-1
[430.444276] Dynamic subtest eDP-1: SKIP (0.000s)
[430.446090] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[430.509753] [090/133] (598s left) api_intel_bb (destroy-bb)
[430.562345] Starting subtest: destroy-bb
[430.569239] Subtest destroy-bb: SUCCESS (0.008s)
[430.685288] [091/133] (598s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[430.783081] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[430.785298] Starting dynamic subtest: A-eDP1
[434.386792] Dynamic subtest A-eDP1: SUCCESS (3.600s)
[434.395545] Starting dynamic subtest: B-eDP1
[437.676392] Dynamic subtest B-eDP1: SUCCESS (3.286s)
[437.685229] Starting dynamic subtest: C-eDP1
[440.993742] Dynamic subtest C-eDP1: SUCCESS (3.316s)
[441.002906] Starting dynamic subtest: D-eDP1
[444.286554] Dynamic subtest D-eDP1: SUCCESS (3.292s)
[444.288758] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.502s)
[445.153100] [092/133] (584s left) gem_basic (multigpu-create-close)
[445.201944] Starting subtest: multigpu-create-close
[445.203815] Subtest multigpu-create-close: SKIP (0.000s)
[445.297891] [093/133] (584s left) kms_lease (cursor-implicit-plane)
[445.391543] Starting subtest: cursor-implicit-plane
[445.392416] Starting dynamic subtest: pipe-A-eDP-1
[445.851390] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.460s)
[445.865712] Starting dynamic subtest: pipe-B-eDP-1
[446.935592] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.082s)
[446.944660] Starting dynamic subtest: pipe-C-eDP-1
[448.027745] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.091s)
[448.037813] Starting dynamic subtest: pipe-D-eDP-1
[449.116996] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.087s)
[449.117991] Subtest cursor-implicit-plane: SUCCESS (3.726s)
[449.964215] [094/133] (579s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[450.020678] Starting subtest: invalid-multi-wait-all-unsubmitted
[450.022309] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[450.127698] [095/133] (579s left) i915_drm_fdinfo (all-busy-idle-check-all)
[450.163528] Starting subtest: all-busy-idle-check-all
[450.168492] Subtest all-busy-idle-check-all: SKIP (0.004s)
[450.238236] [096/133] (579s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[450.355958] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[450.356868] Starting dynamic subtest: pipe-A-eDP-1
[467.169851] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.769s)
[467.179602] Starting dynamic subtest: pipe-B-eDP-1
[485.184178] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.800s)
[485.194014] Starting dynamic subtest: pipe-C-eDP-1
[503.155265] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.756s)
[503.171026] Starting dynamic subtest: pipe-D-eDP-1
[521.136557] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.800s)
[521.137418] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (10.130s)
[528.343754] [097/133] (507s left) gem_mmap_offset (partial-remap)
[528.398506] Starting subtest: partial-remap
[528.399378] Starting dynamic subtest: smem0
[528.404085] Dynamic subtest smem0: SUCCESS (0.004s)
[528.404803] Subtest partial-remap: SUCCESS (0.004s)
[528.517695] [098/133] (507s left) kms_psr (fbc-psr2-cursor-blt)
[528.595754] Starting subtest: fbc-psr2-cursor-blt
[528.596894] Starting dynamic subtest: eDP-1
[528.599345] Dynamic subtest eDP-1: SKIP (0.000s)
[528.601380] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[528.668115] [099/133] (506s left) gem_ctx_shared (q-out-order)
[528.735927] Starting subtest: Q-out-order
[528.736968] Starting dynamic subtest: rcs0
[528.854065] Dynamic subtest rcs0: SUCCESS (0.117s)
[528.868746] Starting dynamic subtest: vcs0
[528.946590] Dynamic subtest vcs0: SUCCESS (0.090s)
[528.965530] Starting dynamic subtest: vcs1
[529.036197] Dynamic subtest vcs1: SUCCESS (0.087s)
[529.065008] Starting dynamic subtest: vecs0
[529.114464] Dynamic subtest vecs0: SUCCESS (0.078s)
[529.131363] Starting dynamic subtest: ccs0
[529.192821] Dynamic subtest ccs0: SUCCESS (0.079s)
[529.194592] Subtest Q-out-order: SUCCESS (0.461s)
[530.075752] [100/133] (505s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[530.175426] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[530.177147] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[530.263187] [101/133] (505s left) sw_sync (alloc_fence_invalid_timeline)
[530.291448] Starting subtest: alloc_fence_invalid_timeline
[530.292305] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[530.337704] [102/133] (505s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[530.421465] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[530.422467] Starting dynamic subtest: pipe-A-default-mode
[533.162297] Dynamic subtest pipe-A-default-mode: SUCCESS (2.781s)
[533.163315] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.782s)
[533.950034] [103/133] (501s left) kms_big_fb (linear-64bpp-rotate-270)
[534.039155] Starting subtest: linear-64bpp-rotate-270
[534.057901] Subtest linear-64bpp-rotate-270: SKIP (0.018s)
[534.158770] [104/133] (501s left) gem_workarounds (reset-fd)
[534.222497] Starting subtest: reset-fd
[534.410722] Subtest reset-fd: SUCCESS (0.190s)
[534.535880] [105/133] (501s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[534.619796] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[534.629254] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[534.702847] [106/133] (501s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[534.795333] Starting subtest: plane-all-transition-nonblocking-fencing
[534.796180] Starting dynamic subtest: pipe-A-eDP-1
[537.269496] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[537.590881] Starting dynamic subtest: pipe-B-eDP-1
[540.799424] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.235s)
[541.097141] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.347s)
[541.903535] [107/133] (493s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[541.995547] Starting subtest: fbcpsr-shrfb-scaledprimary
[547.656024] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.678s)
[547.799067] [108/133] (488s left) gem_render_copy (x-tiled)
[547.866309] Starting subtest: x-tiled
[547.867352] Starting dynamic subtest: smem
[547.911043] Dynamic subtest smem: SUCCESS (0.044s)
[547.912772] Subtest x-tiled: SUCCESS (0.045s)
[548.135232] [109/133] (487s left) gem_mmap_gtt (big-bo)
[548.184782] Subtest big-bo: SKIP (0.000s)
[548.242708] [110/133] (487s left) kms_hdr (bpc-switch-dpms)
[548.355311] Starting subtest: bpc-switch-dpms
[549.413369] Starting dynamic subtest: pipe-A-eDP-1
[553.815449] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.410s)
[553.816452] Subtest bpc-switch-dpms: SUCCESS (5.470s)
[553.913776] [111/133] (482s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[554.005257] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[554.006096] Starting dynamic subtest: pipe-A-eDP-1
[554.433013] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.427s)
[554.444605] Starting dynamic subtest: pipe-B-eDP-1
[554.452615] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[554.461319] Starting dynamic subtest: pipe-C-eDP-1
[554.469074] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[554.477363] Starting dynamic subtest: pipe-D-eDP-1
[554.484786] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[554.485628] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.443s)
[556.650844] [112/133] (479s left) gem_madvise (dontneed-before-pwrite)
[556.682865] Starting subtest: dontneed-before-pwrite
[556.705903] Subtest dontneed-before-pwrite: SKIP (0.022s)
[556.763915] [113/133] (479s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[556.866694] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[556.868578] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[556.971421] [114/133] (479s left) gem_exec_schedule (preempt-other)
[557.040118] Starting subtest: preempt-other
[557.041124] Starting dynamic subtest: rcs0
[557.112658] Dynamic subtest rcs0: SUCCESS (0.072s)
[557.124397] Starting dynamic subtest: bcs0
[557.183487] Dynamic subtest bcs0: SUCCESS (0.070s)
[557.195999] Starting dynamic subtest: vcs0
[557.251564] Dynamic subtest vcs0: SUCCESS (0.067s)
[557.261294] Starting dynamic subtest: vcs1
[557.325622] Dynamic subtest vcs1: SUCCESS (0.073s)
[557.339118] Starting dynamic subtest: vecs0
[557.398859] Dynamic subtest vecs0: SUCCESS (0.071s)
[557.413686] Starting dynamic subtest: ccs0
[557.465800] Dynamic subtest ccs0: SUCCESS (0.067s)
[557.467494] Subtest preempt-other: SUCCESS (0.426s)
[559.046969] [115/133] (477s left) gem_exec_reloc (basic-write-gtt-noreloc)
[559.108158] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[559.183024] [116/133] (476s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[559.279052] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[559.982056] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.704s)
[560.143701] [117/133] (476s left) kms_psr2_su (frontbuffer-xrgb8888)
[560.193364] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[560.256041] [118/133] (475s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[560.354361] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[567.161708] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.795s)
[567.296442] [119/133] (468s left) kms_draw_crc (fill-fb)
[567.392684] Starting subtest: fill-fb
[567.860214] Subtest fill-fb: SUCCESS (0.468s)
[567.954840] [120/133] (468s left) api_intel_allocator (two-level-inception)
[568.005325] Starting subtest: two-level-inception
[573.452035] Subtest two-level-inception: SUCCESS (5.400s)
[573.552393] [121/133] (462s left) gem_exec_params (cliprects-invalid)
[573.608485] Starting subtest: cliprects-invalid
[573.609553] Subtest cliprects-invalid: SUCCESS (0.000s)
[573.712848] [122/133] (462s left) kms_fbcon_fbt (psr-suspend)
[573.773875] Starting subtest: psr-suspend
[625.050911] Subtest psr-suspend: SUCCESS (23.292s)
[627.099889] [123/133] (411s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[627.195056] Starting subtest: pr-overlay-plane-update-continuous-sf
[627.196824] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[627.262255] [124/133] (411s left) gem_ctx_persistence (legacy-engines-hang)
[627.312371] Starting subtest: legacy-engines-hang
[627.313752] Starting dynamic subtest: render
[627.433789] Dynamic subtest render: SUCCESS (0.121s)
[627.446817] Starting dynamic subtest: bsd1
[627.524468] Dynamic subtest bsd1: SUCCESS (0.089s)
[627.538355] Starting dynamic subtest: bsd2
[627.628683] Dynamic subtest bsd2: SUCCESS (0.101s)
[627.643081] Starting dynamic subtest: blt
[627.731045] Dynamic subtest blt: SUCCESS (0.100s)
[627.745470] Starting dynamic subtest: vebox
[627.834874] Dynamic subtest vebox: SUCCESS (0.102s)
[627.836674] Subtest legacy-engines-hang: SUCCESS (0.528s)
[627.920071] [125/133] (410s left) kms_pm_rpm (fences-dpms)
[630.136228] Starting subtest: fences-dpms
[630.139176] Subtest fences-dpms: SKIP (0.000s)
[630.500683] [126/133] (408s left) kms_psr (psr2-cursor-render)
[630.588797] Starting subtest: psr2-cursor-render
[630.589895] Starting dynamic subtest: eDP-1
[632.346308] Dynamic subtest eDP-1: SUCCESS (1.766s)
[632.347299] Subtest psr2-cursor-render: SUCCESS (1.767s)
[633.177900] [127/133] (405s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[633.263745] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[633.265542] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[633.357632] [128/133] (405s left) kms_properties (crtc-properties-legacy)
[633.442998] Starting subtest: crtc-properties-legacy
[633.444118] Starting dynamic subtest: pipe-A-eDP-1
[633.888033] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.447s)
[633.897083] Starting dynamic subtest: pipe-B-eDP-1
[635.026247] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.141s)
[635.035198] Starting dynamic subtest: pipe-C-eDP-1
[636.190122] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.166s)
[636.199477] Starting dynamic subtest: pipe-D-eDP-1
[637.395143] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.207s)
[637.396164] Subtest crtc-properties-legacy: SUCCESS (3.966s)
[638.261673] [129/133] (400s left) i915_query (test-query-geometry-subslices)
[638.313818] Starting subtest: test-query-geometry-subslices
[638.314798] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[638.406457] [130/133] (400s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[638.487936] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[642.180547] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.702s)
[643.366789] [131/133] (395s left) kms_pipe_crc_basic (hang-read-crc)
[643.454312] Starting subtest: hang-read-crc
[643.455321] Starting dynamic subtest: pipe-A-eDP-1
[645.520090] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.067s)
[645.529733] Starting dynamic subtest: pipe-B-eDP-1
[648.299158] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.780s)
[648.308544] Starting dynamic subtest: pipe-C-eDP-1
[650.969989] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.673s)
[650.979366] Starting dynamic subtest: pipe-D-eDP-1
[653.656184] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.678s)
[653.657446] Subtest hang-read-crc: SUCCESS (10.204s)
[654.441421] [132/133] (384s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[654.540036] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[654.542312] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[654.646725] [133/133] (384s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[654.736059] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[654.737171] Starting dynamic subtest: pipe-A-eDP-1
[654.760451] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.024s)
[654.769553] Starting dynamic subtest: pipe-B-eDP-1
[654.783174] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.023s)
[654.792096] Starting dynamic subtest: pipe-C-eDP-1
[654.805994] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[654.816586] Starting dynamic subtest: pipe-D-eDP-1
[654.830110] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[654.831319] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.096s)
[657.031327] 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.