[57.447840] Initializing watchdogs
[57.447922]   /dev/watchdog0
[57.462716] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.467265] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.469508] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.473039] [001/132] (960s left) gem_ctx_param (set-priority-invalid-size)
[57.549049] Starting subtest: set-priority-invalid-size
[57.551480] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[57.613636] [002/132] (960s left) syncobj_wait (single-wait-for-submit-submitted)
[57.667855] Starting subtest: single-wait-for-submit-submitted
[57.769500] Subtest single-wait-for-submit-submitted: SUCCESS (0.102s)
[57.869924] [003/132] (960s left) kms_vblank (ts-continuation-modeset-hang)
[57.962868] Starting subtest: ts-continuation-modeset-hang
[57.964869] Starting dynamic subtest: pipe-A-eDP-1
[85.662333] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.699s)
[85.676840] Starting dynamic subtest: pipe-D-eDP-1
[110.677718] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.011s)
[110.680107] Subtest ts-continuation-modeset-hang: SUCCESS (52.714s)
[111.521557] [004/132] (906s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[111.615244] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[115.817905] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.207s)
[116.932720] [005/132] (901s left) gem_ctx_isolation (nonpriv)
[116.993709] Starting subtest: nonpriv
[116.996106] Starting dynamic subtest: rcs0
[117.211577] Dynamic subtest rcs0: SUCCESS (0.218s)
[117.221866] Starting dynamic subtest: bcs0
[117.469974] Dynamic subtest bcs0: SUCCESS (0.258s)
[117.479156] Starting dynamic subtest: vcs0
[117.723883] Dynamic subtest vcs0: SUCCESS (0.254s)
[117.734318] Starting dynamic subtest: vcs1
[119.158403] Dynamic subtest vcs1: SUCCESS (1.434s)
[119.166967] Starting dynamic subtest: vecs0
[121.181720] Dynamic subtest vecs0: SUCCESS (2.023s)
[121.189811] Starting dynamic subtest: ccs0
[123.168024] Dynamic subtest ccs0: SUCCESS (1.986s)
[123.170469] Subtest nonpriv: SUCCESS (6.174s)
[123.406949] [006/132] (894s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[123.523529] Starting subtest: psr-rgb565-draw-mmap-wc
[130.452995] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.932s)
[130.565969] [007/132] (887s left) kms_content_protection (mei-interface)
[130.709520] Starting subtest: mei-interface
[130.713980] Subtest mei-interface: SKIP (0.001s)
[130.833847] [008/132] (887s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[130.922793] Starting subtest: fbc-rgb101010-draw-blt
[135.480970] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.563s)
[136.600299] [009/132] (881s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[136.652619] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[136.762527] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.107s)
[136.846952] [010/132] (881s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[136.953904] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[144.049745] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.101s)
[144.161388] [011/132] (874s left) perf_pmu (busy-double-start)
[144.209489] Starting subtest: busy-double-start
[144.211794] Starting dynamic subtest: rcs0
[147.847665] Dynamic subtest rcs0: FAIL (3.582s)
[147.857051] Starting dynamic subtest: bcs0
[151.362843] Dynamic subtest bcs0: SUCCESS (3.575s)
[151.373630] Starting dynamic subtest: vcs0
[155.440868] Dynamic subtest vcs0: SUCCESS (4.078s)
[155.451671] Starting dynamic subtest: vcs1
[159.449232] Dynamic subtest vcs1: SUCCESS (4.008s)
[159.460981] Starting dynamic subtest: vecs0
[163.412804] Dynamic subtest vecs0: SUCCESS (3.964s)
[163.423737] Starting dynamic subtest: ccs0
[167.052210] Dynamic subtest ccs0: FAIL (3.567s)
[167.054398] Subtest busy-double-start: FAIL (22.777s)
[167.094750] [012/132] (851s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[167.203270] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[175.879880] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.681s)
[175.991283] [013/132] (842s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[176.083868] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[176.086199] Starting dynamic subtest: pipe-A-eDP-1
[176.106985] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[176.116769] Starting dynamic subtest: pipe-B-eDP-1
[176.135655] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[176.143865] Starting dynamic subtest: pipe-C-eDP-1
[176.163140] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[176.170886] Starting dynamic subtest: pipe-D-eDP-1
[176.190991] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[176.193332] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.004s)
[178.329958] [014/132] (840s left) gen9_exec_parse (bb-secure)
[178.389607] Subtest bb-secure: SKIP (0.000s)
[178.452841] [015/132] (840s left) kms_psr (psr2-sprite-plane-onoff)
[178.544052] Starting subtest: psr2-sprite-plane-onoff
[178.546377] Starting dynamic subtest: eDP-1
[180.268819] Dynamic subtest eDP-1: SUCCESS (1.724s)
[180.271132] Subtest psr2-sprite-plane-onoff: SUCCESS (1.724s)
[181.103719] [016/132] (837s left) gem_pxp (reject-modify-context-protection-off-1)
[181.226278] Starting subtest: reject-modify-context-protection-off-1
[181.228881] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[181.339969] [017/132] (837s left) gem_ctx_param (non-root-set)
[181.395705] Starting subtest: non-root-set
[181.412511] Subtest non-root-set: SUCCESS (0.017s)
[181.511847] [018/132] (837s left) kms_flip (nonexisting-fb-interruptible)
[181.603022] Starting subtest: nonexisting-fb-interruptible
[181.607885] Starting dynamic subtest: A-eDP1
[182.787530] Dynamic subtest A-eDP1: SUCCESS (1.182s)
[182.798487] Starting dynamic subtest: B-eDP1
[183.922797] Dynamic subtest B-eDP1: SUCCESS (1.134s)
[183.932724] Starting dynamic subtest: C-eDP1
[185.055031] Dynamic subtest C-eDP1: SUCCESS (1.132s)
[185.064478] Starting dynamic subtest: D-eDP1
[186.200567] Dynamic subtest D-eDP1: SUCCESS (1.145s)
[186.202986] Subtest nonexisting-fb-interruptible: SUCCESS (4.600s)
[187.366922] [019/132] (831s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[187.455517] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[187.459973] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[187.546488] [020/132] (831s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[187.610155] Starting subtest: yf-tiled-to-vebox-yf-tiled
[187.614501] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[187.791623] [021/132] (830s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[187.901125] Starting subtest: 2x-long-flip-vs-cursor-atomic
[187.906359] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[188.043761] [022/132] (830s left) kms_flip (plain-flip-interruptible)
[188.134311] Starting subtest: plain-flip-interruptible
[188.136597] Starting dynamic subtest: A-eDP1
[189.780678] Dynamic subtest A-eDP1: SUCCESS (1.645s)
[189.793143] Starting dynamic subtest: B-eDP1
[191.398651] Dynamic subtest B-eDP1: SUCCESS (1.617s)
[191.408741] Starting dynamic subtest: C-eDP1
[193.019511] Dynamic subtest C-eDP1: SUCCESS (1.620s)
[193.029308] Starting dynamic subtest: D-eDP1
[194.653346] Dynamic subtest D-eDP1: SUCCESS (1.632s)
[194.658712] Subtest plain-flip-interruptible: SUCCESS (6.525s)
[195.830950] [023/132] (822s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[195.931479] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[195.936018] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[197.066255] [024/132] (821s left) kms_psr (pr-primary-page-flip)
[197.165877] Starting subtest: pr-primary-page-flip
[197.170178] Subtest pr-primary-page-flip: SKIP (0.000s)
[197.237720] [025/132] (821s left) i915_hangman (engine-engine-hang)
[197.296451] Starting subtest: engine-engine-hang
[197.298318] Starting dynamic subtest: rcs0
[198.901714] Dynamic subtest rcs0: SUCCESS (1.604s)
[198.913791] Starting dynamic subtest: bcs0
[200.883388] Dynamic subtest bcs0: SUCCESS (1.980s)
[200.894988] Starting dynamic subtest: vcs0
[202.868809] Dynamic subtest vcs0: SUCCESS (1.984s)
[202.880536] Starting dynamic subtest: vcs1
[204.851754] Dynamic subtest vcs1: SUCCESS (1.981s)
[204.862864] Starting dynamic subtest: vecs0
[206.900759] Dynamic subtest vecs0: SUCCESS (2.048s)
[206.915603] Starting dynamic subtest: ccs0
[208.820435] Dynamic subtest ccs0: SUCCESS (1.918s)
[208.823336] Subtest engine-engine-hang: SUCCESS (11.525s)
[208.946560] [026/132] (809s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[209.045292] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[209.049683] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[209.131118] [027/132] (809s left) gem_exec_whisper (basic-contexts)
[209.184730] Starting subtest: basic-contexts
[214.965992] Subtest basic-contexts: SUCCESS (5.777s)
[215.154882] [028/132] (803s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[215.260649] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[215.262903] Starting dynamic subtest: pipe-A-eDP-1
[231.714326] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.550s)
[231.725782] Starting dynamic subtest: pipe-B-eDP-1
[248.679707] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.415s)
[248.690074] Starting dynamic subtest: pipe-C-eDP-1
[265.647958] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.318s)
[265.657940] Starting dynamic subtest: pipe-D-eDP-1
[282.654981] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.336s)
[282.657029] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.625s)
[283.892957] [029/132] (735s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[283.991336] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[283.995857] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[285.120763] [030/132] (733s left) kms_debugfs (display-on-read-all)
[285.215943] Starting subtest: display-on-read-all
[285.385260] Subtest display-on-read-all: SUCCESS (0.170s)
[285.493401] [031/132] (733s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[285.873478] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[286.648159] [032/132] (732s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[286.752337] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[286.766692] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.012s)
[286.840529] [033/132] (732s left) gem_spin_batch (resubmit)
[286.895534] Starting subtest: resubmit
[286.897685] Starting dynamic subtest: rcs0
[286.904778] Dynamic subtest rcs0: SUCCESS (0.008s)
[286.917499] Starting dynamic subtest: bcs0
[286.919882] Dynamic subtest bcs0: SUCCESS (0.003s)
[286.932300] Starting dynamic subtest: vcs0
[286.934162] Dynamic subtest vcs0: SUCCESS (0.003s)
[286.942439] Starting dynamic subtest: vcs1
[286.944293] Dynamic subtest vcs1: SUCCESS (0.003s)
[286.952771] Starting dynamic subtest: vecs0
[286.954710] Dynamic subtest vecs0: SUCCESS (0.003s)
[286.963068] Starting dynamic subtest: ccs0
[286.964888] Dynamic subtest ccs0: SUCCESS (0.003s)
[286.966687] Subtest resubmit: SUCCESS (0.028s)
[287.136071] [034/132] (732s left) kms_psr (fbc-psr-sprite-plane-onoff)
[287.219932] Starting subtest: fbc-psr-sprite-plane-onoff
[287.222183] Starting dynamic subtest: eDP-1
[287.226280] Dynamic subtest eDP-1: SKIP (0.000s)
[287.230464] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[287.291172] [035/132] (731s left) kms_addfb_basic (addfb25-bad-modifier)
[287.395587] Starting subtest: addfb25-bad-modifier
[287.397676] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[287.486912] [036/132] (731s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[287.594861] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[287.599273] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[287.669743] [037/132] (731s left) kms_addfb_basic (bo-too-small)
[287.753327] Starting subtest: bo-too-small
[287.755198] Subtest bo-too-small: SUCCESS (0.000s)
[287.849633] [038/132] (731s left) syncobj_timeline (single-wait-all-available-signaled)
[287.905453] Starting subtest: single-wait-all-available-signaled
[287.907260] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[288.007150] [039/132] (731s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[288.099992] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[288.103785] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[288.193184] [040/132] (731s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[288.289301] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[288.292683] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[288.377784] [041/132] (731s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[288.484786] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[288.488263] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[288.579939] [042/132] (730s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[288.681881] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[288.685675] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[288.782125] [043/132] (730s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[288.877020] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[311.673767] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.798s)
[311.799518] [044/132] (707s left) syncobj_timeline (multi-wait-available-submitted)
[311.861565] Starting subtest: multi-wait-available-submitted
[311.863368] Subtest multi-wait-available-submitted: SUCCESS (0.000s)
[311.970120] [045/132] (707s left) kms_cursor_crc (cursor-onscreen-64x21)
[312.159075] Starting subtest: cursor-onscreen-64x21
[312.206484] Subtest cursor-onscreen-64x21: SKIP (0.042s)
[312.445272] [046/132] (707s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[312.488303] Starting subtest: framebuffer-vs-set-tiling
[312.491623] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[312.608876] [047/132] (707s left) gem_exec_balancer (parallel-balancer)
[312.863432] Starting subtest: parallel-balancer
[313.762146] Subtest parallel-balancer: SUCCESS (0.899s)
[313.859761] [048/132] (705s left) i915_pm_rpm (gem-pread)
[315.792165] Starting subtest: gem-pread
[317.853801] Subtest gem-pread: SUCCESS (2.063s)
[317.941560] [049/132] (701s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[318.033058] Starting subtest: fbc-psr2-sprite-mmap-cpu
[318.035331] Starting dynamic subtest: eDP-1
[318.039292] Dynamic subtest eDP-1: SKIP (0.000s)
[318.043365] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[318.105721] [050/132] (701s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[318.201811] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[318.206373] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[318.335428] [051/132] (701s left) i915_drm_fdinfo (busy-check-all)
[318.385492] Starting subtest: busy-check-all
[318.387843] Starting dynamic subtest: rcs0
[318.392695] Dynamic subtest rcs0: SKIP (0.004s)
[318.406281] Starting dynamic subtest: bcs0
[318.410578] Dynamic subtest bcs0: SKIP (0.000s)
[318.419520] Starting dynamic subtest: vcs0
[318.423749] Dynamic subtest vcs0: SKIP (0.000s)
[318.432221] Starting dynamic subtest: vcs1
[318.436590] Dynamic subtest vcs1: SKIP (0.000s)
[318.445069] Starting dynamic subtest: vecs0
[318.449424] Dynamic subtest vecs0: SKIP (0.000s)
[318.457828] Starting dynamic subtest: ccs0
[318.462287] Dynamic subtest ccs0: SKIP (0.000s)
[318.466729] Subtest busy-check-all: SKIP (0.012s)
[318.503078] [052/132] (701s left) gem_create (create-ext-placement-each)
[318.696103] Starting subtest: create-ext-placement-each
[318.698353] Subtest create-ext-placement-each: SUCCESS (0.000s)
[318.778902] [053/132] (701s left) gem_lmem_swapping (basic)
[318.819439] Subtest basic: SKIP (0.000s)
[318.864216] [054/132] (701s left) gem_mmap_offset (basic-uaf)
[318.910135] Starting subtest: basic-uaf
[318.912699] Subtest basic-uaf: SUCCESS (0.001s)
[319.021615] [055/132] (701s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[319.119443] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[319.123906] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[319.219120] [056/132] (700s left) gem_exec_fence (syncobj-invalid-flags)
[319.689299] Starting subtest: syncobj-invalid-flags
[319.691529] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[320.755470] [FACT gem_exec_fence (syncobj-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true
[320.760637] [057/132] (699s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[320.850399] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[320.854711] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[320.950526] [058/132] (699s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[321.050057] Starting subtest: x-tiled-8bpp-rotate-270
[321.072680] Subtest x-tiled-8bpp-rotate-270: SKIP (0.022s)
[321.189193] [059/132] (699s left) gem_exec_schedule (preempt-other-chain)
[321.255574] Starting subtest: preempt-other-chain
[321.257473] Starting dynamic subtest: rcs0
[321.335363] Dynamic subtest rcs0: SUCCESS (0.086s)
[321.348696] Starting dynamic subtest: bcs0
[321.416700] Dynamic subtest bcs0: SUCCESS (0.080s)
[321.426709] Starting dynamic subtest: vcs0
[321.502758] Dynamic subtest vcs0: SUCCESS (0.086s)
[321.514988] Starting dynamic subtest: vcs1
[321.583556] Dynamic subtest vcs1: SUCCESS (0.079s)
[321.597806] Starting dynamic subtest: vecs0
[321.662703] Dynamic subtest vecs0: SUCCESS (0.079s)
[321.672576] Starting dynamic subtest: ccs0
[321.742119] Dynamic subtest ccs0: SUCCESS (0.080s)
[321.744571] Subtest preempt-other-chain: SUCCESS (0.494s)
[322.749453] [060/132] (697s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[322.812816] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[322.878951] [061/132] (697s left) gem_exec_reloc (basic-cpu-read)
[322.934056] Subtest basic-cpu-read: SKIP (0.000s)
[323.017618] [062/132] (697s left) gem_mmap_wc (pf-nonblock)
[323.076414] Subtest pf-nonblock: SKIP (0.000s)
[323.141310] [063/132] (697s left) kms_color (ctm-0-25)
[323.236266] Starting subtest: ctm-0-25
[323.238119] Starting dynamic subtest: pipe-A-eDP-1
[326.717484] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.480s)
[326.727045] Starting dynamic subtest: pipe-B-eDP-1
[330.918545] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.199s)
[330.928209] Starting dynamic subtest: pipe-C-eDP-1
[334.964560] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.047s)
[334.975136] Starting dynamic subtest: pipe-D-eDP-1
[338.953888] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.988s)
[338.956227] Subtest ctm-0-25: SUCCESS (15.718s)
[339.779163] [064/132] (680s left) kms_big_fb (linear-8bpp-rotate-270)
[339.895343] Starting subtest: linear-8bpp-rotate-270
[339.916106] Subtest linear-8bpp-rotate-270: SKIP (0.020s)
[340.060815] [065/132] (680s left) kms_flip (blocking-absolute-wf_vblank)
[340.155840] Starting subtest: blocking-absolute-wf_vblank
[340.158232] Starting dynamic subtest: A-eDP1
[348.854368] Dynamic subtest A-eDP1: SUCCESS (8.698s)
[348.871160] Starting dynamic subtest: B-eDP1
[357.579921] Dynamic subtest B-eDP1: SUCCESS (8.722s)
[357.597830] Starting dynamic subtest: C-eDP1
[366.306402] Dynamic subtest C-eDP1: SUCCESS (8.723s)
[366.316529] Starting dynamic subtest: D-eDP1
[375.037731] Dynamic subtest D-eDP1: SUCCESS (8.728s)
[375.043014] Subtest blocking-absolute-wf_vblank: SUCCESS (34.887s)
[376.264104] [066/132] (644s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[376.363462] Starting subtest: primary-4-tiled-reflect-x-180
[383.359650] Subtest primary-4-tiled-reflect-x-180: SUCCESS (6.997s)
[384.533208] [067/132] (636s left) perf_pmu (busy-idle-check-all)
[384.581419] Starting subtest: busy-idle-check-all
[384.583341] Starting dynamic subtest: rcs0
[385.230564] Dynamic subtest rcs0: SUCCESS (0.650s)
[385.245534] Starting dynamic subtest: bcs0
[385.885567] Dynamic subtest bcs0: SUCCESS (0.652s)
[385.898170] Starting dynamic subtest: vcs0
[387.684646] Dynamic subtest vcs0: SUCCESS (1.795s)
[387.696926] Starting dynamic subtest: vcs1
[389.669532] Dynamic subtest vcs1: SUCCESS (1.982s)
[389.682137] Starting dynamic subtest: vecs0
[391.653467] Dynamic subtest vecs0: SUCCESS (1.980s)
[391.666046] Starting dynamic subtest: ccs0
[392.309853] Dynamic subtest ccs0: SUCCESS (0.655s)
[392.312992] Subtest busy-idle-check-all: SUCCESS (7.730s)
[392.423311] [068/132] (628s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[392.537198] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[392.539417] Starting dynamic subtest: pipe-A
[392.557445] Dynamic subtest pipe-A: SKIP (0.018s)
[392.571114] Starting dynamic subtest: pipe-B
[392.591865] Dynamic subtest pipe-B: SKIP (0.031s)
[392.601326] Starting dynamic subtest: pipe-C
[392.621187] Dynamic subtest pipe-C: SKIP (0.030s)
[392.630428] Starting dynamic subtest: pipe-D
[392.653668] Dynamic subtest pipe-D: SKIP (0.031s)
[392.658336] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.113s)
[392.740948] [069/132] (628s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[392.833921] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[392.838182] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[392.945304] [070/132] (627s left) api_intel_allocator (fork-simple-stress)
[392.993889] Starting subtest: fork-simple-stress
[398.389527] Subtest fork-simple-stress: SUCCESS (5.397s)
[398.511418] [071/132] (622s left) sriov_basic (enable-vfs-bind-unbind-each)
[398.574709] Starting subtest: enable-vfs-bind-unbind-each
[398.577156] Starting dynamic subtest: numvfs-1
[398.652383] Dynamic subtest numvfs-1: FAIL (0.005s)
[398.662554] Starting dynamic subtest: numvfs-2
[398.736575] Dynamic subtest numvfs-2: FAIL (0.004s)
[398.747652] Starting dynamic subtest: numvfs-3
[398.821397] Dynamic subtest numvfs-3: FAIL (0.004s)
[398.832404] Starting dynamic subtest: numvfs-4
[398.905351] Dynamic subtest numvfs-4: FAIL (0.004s)
[398.915864] Starting dynamic subtest: numvfs-5
[398.989149] Dynamic subtest numvfs-5: FAIL (0.004s)
[398.999929] Starting dynamic subtest: numvfs-6
[399.073638] Dynamic subtest numvfs-6: FAIL (0.004s)
[399.084176] Starting dynamic subtest: numvfs-7
[399.157772] Dynamic subtest numvfs-7: FAIL (0.004s)
[399.168357] Starting dynamic subtest: numvfs-random
[399.240998] Dynamic subtest numvfs-random: FAIL (0.004s)
[399.242813] Subtest enable-vfs-bind-unbind-each: FAIL (0.040s)
[399.284397] [072/132] (621s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[399.394215] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[399.398159] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s)
[399.470091] [073/132] (621s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[399.526280] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[399.528258] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[399.632313] [074/132] (621s left) kms_plane_alpha_blend (alpha-transparent-fb)
[399.731491] Starting subtest: alpha-transparent-fb
[400.025670] Starting dynamic subtest: pipe-A-eDP-1
[400.662611] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.633s)
[400.673321] Starting dynamic subtest: pipe-D-eDP-1
[401.997165] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.335s)
[401.999631] Subtest alpha-transparent-fb: SUCCESS (2.266s)
[402.817483] [075/132] (618s left) kms_joiner (invalid-modeset-big-joiner)
[402.926314] Starting subtest: invalid-modeset-big-joiner
[402.930780] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[403.001540] [076/132] (618s left) gem_exec_balancer (smoke)
[403.075542] Starting subtest: smoke
[425.926043] Subtest smoke: SUCCESS (22.848s)
[427.036404] [077/132] (594s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[427.155746] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[428.112522] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.958s)
[428.933125] [078/132] (592s left) api_intel_bb (reset-flags)
[428.985307] Starting subtest: reset-flags
[428.991337] Subtest reset-flags: SUCCESS (0.007s)
[429.110480] [079/132] (592s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[429.212343] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[429.214540] Starting dynamic subtest: pipe-A-eDP-1
[429.302265] Dynamic subtest pipe-A-eDP-1: SKIP (0.090s)
[429.316132] Starting dynamic subtest: pipe-B-eDP-1
[430.401868] Dynamic subtest pipe-B-eDP-1: SKIP (1.099s)
[430.406393] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.193s)
[431.586837] [080/132] (589s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[431.679263] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[431.705227] Starting dynamic subtest: pipe-A-plane-0
[432.360724] Dynamic subtest pipe-A-plane-0: SUCCESS (0.655s)
[432.370363] Starting dynamic subtest: pipe-A-plane-3
[432.770962] Dynamic subtest pipe-A-plane-3: SUCCESS (0.408s)
[433.881698] Starting dynamic subtest: pipe-B-plane-0
[434.529634] Dynamic subtest pipe-B-plane-0: SUCCESS (0.655s)
[434.541701] Starting dynamic subtest: pipe-B-plane-3
[434.928845] Dynamic subtest pipe-B-plane-3: SUCCESS (0.398s)
[435.241220] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.562s)
[436.047221] [081/132] (585s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[436.153535] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[436.527520] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[439.319159] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.790s)
[439.329859] Starting dynamic subtest: pipe-A-eDP-1-4
[441.493927] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s)
[441.506298] Starting dynamic subtest: pipe-A-eDP-1-4
[443.504050] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[443.514629] Starting dynamic subtest: pipe-A-eDP-1-x
[445.682309] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.177s)
[446.062452] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[448.854995] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.800s)
[448.867879] Starting dynamic subtest: pipe-B-eDP-1-4
[451.040326] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[451.050764] Starting dynamic subtest: pipe-B-eDP-1-4
[453.051375] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[453.062875] Starting dynamic subtest: pipe-B-eDP-1-x
[455.240958] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.188s)
[455.623120] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[458.382993] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.768s)
[458.392461] Starting dynamic subtest: pipe-C-eDP-1-4
[460.558659] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[460.570818] Starting dynamic subtest: pipe-C-eDP-1-4
[462.568767] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[462.578328] Starting dynamic subtest: pipe-C-eDP-1-x
[464.748008] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[465.108785] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[467.905924] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.803s)
[467.917301] Starting dynamic subtest: pipe-D-eDP-1-4
[470.079328] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s)
[470.089076] Starting dynamic subtest: pipe-D-eDP-1-4
[472.090144] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.008s)
[472.099649] Starting dynamic subtest: pipe-D-eDP-1-x
[474.280231] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.188s)
[474.282715] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.126s)
[475.494041] [082/132] (545s left) gem_exec_schedule (u-semaphore-resolve)
[475.573281] Starting subtest: u-semaphore-resolve
[475.602733] Subtest u-semaphore-resolve: SUCCESS (0.037s)
[475.959544] [083/132] (545s left) gem_mmap (basic)
[476.025692] Subtest basic: SKIP (0.000s)
[476.093940] [084/132] (545s left) gem_exec_reloc (basic-cpu-wc-active)
[476.151805] Subtest basic-cpu-wc-active: SKIP (0.000s)
[476.225325] [085/132] (545s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[476.322045] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[477.124216] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.804s)
[477.288953] [086/132] (544s left) kms_lease (lease-invalid-crtc)
[477.376591] Starting subtest: lease-invalid-crtc
[477.378754] Starting dynamic subtest: pipe-A-eDP-1
[477.380985] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[477.390616] Starting dynamic subtest: pipe-B-eDP-1
[477.392469] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[477.401605] Starting dynamic subtest: pipe-C-eDP-1
[477.403710] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[477.412825] Starting dynamic subtest: pipe-D-eDP-1
[477.414714] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[477.416586] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[477.454549] [087/132] (544s left) kms_setmode (invalid-clone-single-crtc-stealing)
[477.516707] Starting subtest: invalid-clone-single-crtc-stealing
[477.523185] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[477.618297] [088/132] (543s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[477.672671] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[477.776809] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[477.857247] [089/132] (543s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[477.958264] Starting subtest: 4-tiled-32bpp-rotate-0
[479.348840] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.390s)
[479.485868] [090/132] (542s left) gem_userptr_blits (coherency-sync)
[479.549391] Starting subtest: coherency-sync
[480.032474] Subtest coherency-sync: SKIP (0.444s)
[480.148609] [091/132] (541s left) kms_flip (flip-vs-rmfb)
[480.295241] Starting subtest: flip-vs-rmfb
[480.297461] Starting dynamic subtest: A-eDP1
[489.240381] Dynamic subtest A-eDP1: SUCCESS (8.944s)
[489.255350] Starting dynamic subtest: B-eDP1
[497.867260] Dynamic subtest B-eDP1: SUCCESS (8.624s)
[497.879351] Starting dynamic subtest: C-eDP1
[506.484195] Dynamic subtest C-eDP1: SUCCESS (8.614s)
[506.494717] Starting dynamic subtest: D-eDP1
[515.117327] Dynamic subtest D-eDP1: SUCCESS (8.631s)
[515.122107] Subtest flip-vs-rmfb: SUCCESS (34.825s)
[516.299989] [092/132] (505s left) fbdev (info)
[516.343791] Starting subtest: info
[516.346118] Subtest info: SUCCESS (0.000s)
[516.416429] [093/132] (505s left) gem_ctx_shared (disjoint-timelines)
[516.479974] Starting subtest: disjoint-timelines
[516.505991] Subtest disjoint-timelines: SUCCESS (0.026s)
[516.747181] [094/132] (505s left) kms_flip (2x-flip-vs-dpms)
[516.828295] Starting subtest: 2x-flip-vs-dpms
[516.839732] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[516.938603] [095/132] (504s left) gem_exec_fence (syncobj-timeline-signal)
[517.482874] Starting subtest: syncobj-timeline-signal
[517.489836] Subtest syncobj-timeline-signal: SUCCESS (0.009s)
[518.767011] [096/132] (503s left) gem_mmap_gtt (cpuset-big-copy-odd)
[518.835561] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[518.899313] [097/132] (503s left) kms_cursor_crc (cursor-sliding-32x32)
[519.039893] Starting subtest: cursor-sliding-32x32
[519.088031] Subtest cursor-sliding-32x32: SKIP (0.046s)
[519.389450] [098/132] (502s left) syncobj_basic (bad-destroy-pad)
[519.444028] Starting subtest: bad-destroy-pad
[519.445895] Subtest bad-destroy-pad: SUCCESS (0.000s)
[519.540530] [099/132] (502s left) kms_cursor_crc (cursor-random-512x170)
[519.840111] Starting subtest: cursor-random-512x170
[519.843516] Subtest cursor-random-512x170: SKIP (0.001s)
[519.968610] [100/132] (502s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[520.063102] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[520.066608] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[520.156717] [101/132] (501s left) gem_madvise (dontneed-before-exec)
[520.197631] Starting subtest: dontneed-before-exec
[520.214853] Subtest dontneed-before-exec: SKIP (0.016s)
[520.276484] [102/132] (501s left) syncobj_timeline (invalid-signal-illegal-handle)
[520.321105] Starting subtest: invalid-signal-illegal-handle
[520.323166] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[520.390360] [103/132] (501s left) perf (non-system-wide-paranoid)
[520.519209] Starting subtest: non-system-wide-paranoid
[520.543905] Subtest non-system-wide-paranoid: SUCCESS (0.027s)
[520.593277] [104/132] (501s left) device_reset (unbind-reset-rebind)
[520.638832] Starting subtest: unbind-reset-rebind
[523.732664] Subtest unbind-reset-rebind: SUCCESS (3.092s)
[523.778507] [105/132] (498s left) i915_query (engine-info-invalid)
[523.844529] Starting subtest: engine-info-invalid
[523.846602] Subtest engine-info-invalid: SUCCESS (0.000s)
[523.946038] [106/132] (498s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[524.050732] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[524.055206] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[524.152577] [107/132] (498s left) kms_frontbuffer_tracking (fbc-suspend)
[524.256873] Starting subtest: fbc-suspend
[561.976764] Subtest fbc-suspend: SUCCESS (7.468s)
[563.179286] [108/132] (459s left) gem_exec_reloc (basic-write-wc-noreloc)
[563.258075] Subtest basic-write-wc-noreloc: SKIP (0.000s)
[563.330986] [109/132] (459s left) gem_watchdog (default-virtual)
[563.399478] Starting subtest: default-virtual
[569.671352] Subtest default-virtual: SUCCESS (6.276s)
[569.772824] [110/132] (452s left) gem_ctx_shared (create-shared-gtt)
[569.838764] Starting subtest: create-shared-gtt
[571.998147] Subtest create-shared-gtt: SUCCESS (2.156s)
[572.330130] [111/132] (450s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[572.434572] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[572.437009] Starting dynamic subtest: pipe-A-eDP-1
[573.791952] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.356s)
[574.087106] Starting dynamic subtest: pipe-B-eDP-1
[575.163939] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.085s)
[575.433692] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.998s)
[576.285609] [112/132] (446s left) kms_vblank (query-busy)
[576.393008] Starting subtest: query-busy
[576.395347] Starting dynamic subtest: pipe-A-eDP-1
[578.284345] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.890s)
[578.302926] Starting dynamic subtest: pipe-D-eDP-1
[580.852785] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.565s)
[580.855221] Subtest query-busy: SUCCESS (4.459s)
[581.649656] [113/132] (441s left) kms_feature_discovery (display-2x)
[581.740680] Starting subtest: display-2x
[581.745422] Subtest display-2x: SKIP (0.000s)
[581.827594] [114/132] (440s left) gem_exec_params (sol-reset-not-gen7)
[581.884720] Starting subtest: sol-reset-not-gen7
[581.889957] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[582.018018] [115/132] (440s left) kms_psr (fbc-pr-primary-mmap-cpu)
[582.110601] Starting subtest: fbc-pr-primary-mmap-cpu
[582.115449] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[582.187647] [116/132] (440s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[582.281611] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[582.286654] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[582.382953] [117/132] (440s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[582.469908] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[582.472451] Starting dynamic subtest: pipe-A
[582.707636] Dynamic subtest pipe-A: SUCCESS (0.240s)
[582.718294] Starting dynamic subtest: pipe-B
[584.030396] Dynamic subtest pipe-B: SUCCESS (1.320s)
[584.042136] Starting dynamic subtest: pipe-C
[585.359377] Dynamic subtest pipe-C: SUCCESS (1.328s)
[585.369774] Starting dynamic subtest: pipe-D
[586.714592] Dynamic subtest pipe-D: SUCCESS (1.354s)
[586.717381] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.246s)
[587.859032] [118/132] (435s left) sysfs_preempt_timeout (idempotent)
[587.920424] Starting subtest: idempotent
[587.923447] Starting dynamic subtest: vecs0
[587.926295] Dynamic subtest vecs0: SUCCESS (0.000s)
[587.939204] Starting dynamic subtest: ccs0
[587.941624] Dynamic subtest ccs0: SUCCESS (0.000s)
[587.951792] Starting dynamic subtest: vcs0
[587.954224] Dynamic subtest vcs0: SUCCESS (0.000s)
[587.964943] Starting dynamic subtest: bcs0
[587.967801] Dynamic subtest bcs0: SUCCESS (0.000s)
[587.978555] Starting dynamic subtest: rcs0
[587.980917] Dynamic subtest rcs0: SUCCESS (0.000s)
[587.990942] Starting dynamic subtest: vcs1
[587.993373] Dynamic subtest vcs1: SUCCESS (0.000s)
[587.995795] Subtest idempotent: SUCCESS (0.006s)
[588.037012] [119/132] (434s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[588.139347] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[588.141808] Starting dynamic subtest: pipe-A-eDP-1
[588.168851] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[588.180217] Starting dynamic subtest: pipe-B-eDP-1
[588.205735] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[588.216918] Starting dynamic subtest: pipe-C-eDP-1
[588.242757] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[588.254669] Starting dynamic subtest: pipe-D-eDP-1
[588.281029] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[588.286631] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.004s)
[590.340947] [120/132] (432s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[590.452507] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[590.454839] Starting dynamic subtest: pipe-A-eDP-1
[601.156173] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.703s)
[601.168203] Starting dynamic subtest: pipe-B-eDP-1
[612.570961] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.407s)
[612.573705] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.113s)
[613.399218] [121/132] (409s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[613.520327] Starting subtest: cursorA-vs-flipA-toggle
[624.674775] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.149s)
[625.528201] [122/132] (397s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[625.583831] Starting subtest: y-tiled-ccs-to-x-tiled
[625.590061] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[625.784462] [123/132] (397s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[625.873664] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[632.780570] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.908s)
[632.943336] [124/132] (390s left) kms_pm_dc (dc9-dpms)
[634.044147] Starting subtest: dc9-dpms
[635.484415] Subtest dc9-dpms: SUCCESS (1.442s)
[635.566398] [125/132] (387s left) kms_atomic (atomic-plane-damage)
[635.663749] Starting subtest: atomic-plane-damage
[635.717819] Starting dynamic subtest: pipe-A-eDP-1
[636.255588] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.540s)
[636.258442] Subtest atomic-plane-damage: SUCCESS (0.595s)
[637.054461] [126/132] (386s left) kms_flip (2x-flip-vs-dpms-on-nop)
[637.142522] Starting subtest: 2x-flip-vs-dpms-on-nop
[637.153727] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.012s)
[637.235021] [127/132] (386s left) kms_getfb (getfb2-handle-not-fb)
[637.329931] Starting subtest: getfb2-handle-not-fb
[637.332719] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[637.446773] [128/132] (385s left) kms_pm_rpm (i2c)
[639.073577] Starting subtest: i2c
[644.640740] Subtest i2c: SUCCESS (5.568s)
[644.745365] [129/132] (378s left) kms_chamelium_edid (dp-mode-timings)
[645.137729] Subtest dp-mode-timings: SKIP (0.000s)
[645.936706] [130/132] (377s left) gem_unfence_active_buffers
[646.078585] [131/132] (377s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[646.178560] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[646.183312] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[646.270324] [132/132] (377s left) kms_busy (basic)
[646.383577] Starting subtest: basic
[646.386221] Starting dynamic subtest: flip
[646.973212] Dynamic subtest flip: SUCCESS (0.591s)
[646.985615] Starting dynamic subtest: modeset
[650.391917] Dynamic subtest modeset: SUCCESS (3.414s)
[650.394823] Subtest basic: SUCCESS (4.007s)
[651.194214] Closing watchdogs
results: parsing output: 0/ for test: gem_ctx_param
results: parsing output: 1/ for test: syncobj_wait
results: parsing output: 2/ for test: kms_vblank
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_ctx_isolation
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_content_protection
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: perf_pmu
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: gen9_exec_parse
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: gem_pxp
results: parsing output: 16/ for test: gem_ctx_param
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_render_copy
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: i915_hangman
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_exec_whisper
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: kms_debugfs
results: parsing output: 30/ for test: kms_chamelium_hpd
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: gem_spin_batch
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: kms_addfb_basic
results: parsing output: 35/ for test: kms_flip_scaled_crc
results: parsing output: 36/ for test: kms_addfb_basic
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: kms_cursor_crc
results: parsing output: 45/ for test: kms_addfb_basic
results: parsing output: 46/ for test: gem_exec_balancer
results: parsing output: 47/ for test: i915_pm_rpm
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: i915_drm_fdinfo
results: parsing output: 51/ for test: gem_create
results: parsing output: 52/ for test: gem_lmem_swapping
results: parsing output: 53/ for test: gem_mmap_offset
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: gem_exec_fence
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: gem_exec_schedule
results: parsing output: 59/ for test: kms_pipe_b_c_ivb
results: parsing output: 60/ for test: gem_exec_reloc
results: parsing output: 61/ for test: gem_mmap_wc
results: parsing output: 62/ for test: kms_color
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: kms_rotation_crc
results: parsing output: 66/ for test: perf_pmu
results: parsing output: 67/ for test: kms_plane_scaling
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: api_intel_allocator
results: parsing output: 70/ for test: sriov_basic
results: parsing output: 71/ for test: kms_plane
results: parsing output: 72/ for test: syncobj_wait
results: parsing output: 73/ for test: kms_plane_alpha_blend
results: parsing output: 74/ for test: kms_joiner
results: parsing output: 75/ for test: gem_exec_balancer
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: api_intel_bb
results: parsing output: 78/ for test: kms_psr2_sf
results: parsing output: 79/ for test: kms_plane
results: parsing output: 80/ for test: kms_async_flips
results: parsing output: 81/ for test: gem_exec_schedule
results: parsing output: 82/ for test: gem_mmap
results: parsing output: 83/ for test: gem_exec_reloc
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: kms_lease
results: parsing output: 86/ for test: kms_setmode
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: gem_userptr_blits
results: parsing output: 90/ for test: kms_flip
results: parsing output: 91/ for test: fbdev
results: parsing output: 92/ for test: gem_ctx_shared
results: parsing output: 93/ for test: kms_flip
results: parsing output: 94/ for test: gem_exec_fence
results: parsing output: 95/ for test: gem_mmap_gtt
results: parsing output: 96/ for test: kms_cursor_crc
results: parsing output: 97/ for test: syncobj_basic
results: parsing output: 98/ for test: kms_cursor_crc
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_madvise
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: perf
results: parsing output: 103/ for test: device_reset
results: parsing output: 104/ for test: i915_query
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_exec_reloc
results: parsing output: 108/ for test: gem_watchdog
results: parsing output: 109/ for test: gem_ctx_shared
results: parsing output: 110/ for test: kms_atomic_transition
results: parsing output: 111/ for test: kms_vblank
results: parsing output: 112/ for test: kms_feature_discovery
results: parsing output: 113/ for test: gem_exec_params
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_plane_scaling
results: parsing output: 117/ for test: sysfs_preempt_timeout
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: kms_psr2_sf
results: parsing output: 120/ for test: kms_cursor_legacy
results: parsing output: 121/ for test: gem_render_copy
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_pm_dc
results: parsing output: 124/ for test: kms_atomic
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: kms_getfb
results: parsing output: 127/ for test: kms_pm_rpm
results: parsing output: 128/ for test: kms_chamelium_edid
results: parsing output: 129/ for test: gem_unfence_active_buffers
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_busy
Done.