[62.639191] Initializing watchdogs
[62.639238]   /dev/watchdog0
[62.653500] [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]
[62.658193] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.660801] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.664365] [001/133] (960s left) gem_softpin (noreloc-s3)
[62.754014] Starting subtest: noreloc-S3
[83.349432] Subtest noreloc-S3: SUCCESS (5.430s)
[83.466115] [002/133] (939s left) perf_pmu (gt-awake)
[83.518562] Starting subtest: gt-awake
[91.983968] Subtest gt-awake: SUCCESS (8.394s)
[92.073759] [003/133] (931s left) kms_invalid_mode (zero-hdisplay)
[92.177914] Starting subtest: zero-hdisplay
[92.182695] Starting dynamic subtest: pipe-A-eDP-1
[92.485096] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.305s)
[92.494412] Starting dynamic subtest: pipe-B-eDP-1
[92.496938] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[92.504407] Starting dynamic subtest: pipe-C-eDP-1
[92.506261] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[92.513387] Starting dynamic subtest: pipe-D-eDP-1
[92.515256] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[92.517521] Subtest zero-hdisplay: SUCCESS (0.310s)
[93.288610] [004/133] (929s left) kms_prop_blob (invalid-set-prop-any)
[93.359356] Starting subtest: invalid-set-prop-any
[93.361863] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[93.474811] [005/133] (929s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[93.569836] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[101.165982] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.581s)
[101.305354] [006/133] (922s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[101.412012] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[101.416094] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[101.571100] [007/133] (921s left) kms_cursor_legacy (torture-move)
[101.694208] Starting subtest: torture-move
[101.696510] Starting dynamic subtest: pipe-A
[107.931977] Dynamic subtest pipe-A: SUCCESS (6.226s)
[107.954029] Starting dynamic subtest: pipe-B
[114.517843] Dynamic subtest pipe-B: SUCCESS (6.583s)
[114.527879] Starting dynamic subtest: pipe-C
[121.292663] Dynamic subtest pipe-C: SUCCESS (6.776s)
[121.306626] Starting dynamic subtest: pipe-D
[129.347206] Dynamic subtest pipe-D: SUCCESS (8.054s)
[129.355801] Starting dynamic subtest: all-pipes
[135.320594] Dynamic subtest all-pipes: SUCCESS (5.971s)
[135.323084] Subtest torture-move: SUCCESS (33.615s)
[135.471454] [008/133] (888s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[135.578208] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[139.170157] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.595s)
[140.342845] [009/133] (883s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[140.435109] Starting subtest: fbc-rgb101010-draw-blt
[145.051928] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.618s)
[146.239294] [010/133] (877s left) gem_pxp (create-regular-context-2)
[146.363927] Starting subtest: create-regular-context-2
[146.366666] Subtest create-regular-context-2: SUCCESS (0.002s)
[146.466117] [011/133] (877s left) kms_flip (2x-flip-vs-panning-interruptible)
[146.554296] Starting subtest: 2x-flip-vs-panning-interruptible
[146.565352] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.010s)
[146.638768] [012/133] (876s left) kms_plane_alpha_blend (constant-alpha-max)
[146.727308] Starting subtest: constant-alpha-max
[147.003048] Starting dynamic subtest: pipe-A-eDP-1
[148.035039] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.031s)
[148.044252] Starting dynamic subtest: pipe-D-eDP-1
[149.669911] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.631s)
[149.672301] Subtest constant-alpha-max: SUCCESS (2.941s)
[150.494309] [013/133] (873s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[150.587409] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[150.613672] Starting dynamic subtest: pipe-A-plane-0
[150.913447] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[150.922291] Starting dynamic subtest: pipe-A-plane-3
[151.146917] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[151.154996] Starting dynamic subtest: pipe-A-plane-5
[151.159153] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[152.287954] Starting dynamic subtest: pipe-B-plane-0
[152.548103] Dynamic subtest pipe-B-plane-0: SUCCESS (0.266s)
[152.557747] Starting dynamic subtest: pipe-B-plane-3
[152.770203] Dynamic subtest pipe-B-plane-3: SUCCESS (0.222s)
[152.779418] Starting dynamic subtest: pipe-B-plane-5
[152.783946] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[153.093041] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.504s)
[153.990860] [014/133] (869s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[154.056575] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[154.135380] [015/133] (869s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[154.202628] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[154.282737] [016/133] (869s left) gem_vm_create (invalid-destroy)
[154.343106] Starting subtest: invalid-destroy
[154.345557] Subtest invalid-destroy: SUCCESS (0.002s)
[154.478738] [017/133] (869s left) gem_lmem_swapping (heavy-verify-random-ccs)
[154.528393] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[154.572291] [018/133] (869s left) kms_feature_discovery (display-2x)
[154.666200] Starting subtest: display-2x
[154.670717] Subtest display-2x: SKIP (0.000s)
[154.751845] [019/133] (869s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[154.847209] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[154.849433] Starting dynamic subtest: pipe-A-eDP-1
[154.871952] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[154.881646] Starting dynamic subtest: pipe-B-eDP-1
[154.901888] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[154.909654] Starting dynamic subtest: pipe-C-eDP-1
[154.927392] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[154.934800] Starting dynamic subtest: pipe-D-eDP-1
[154.952936] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[154.956282] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[157.080190] [020/133] (866s left) gem_mmap_offset (blt-coherency)
[157.137443] Starting subtest: blt-coherency
[157.142230] Subtest blt-coherency: SUCCESS (0.006s)
[157.285355] [021/133] (866s left) gem_pxp (hw-rejects-pxp-context)
[157.354525] Starting subtest: hw-rejects-pxp-context
[157.359114] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[157.450868] [022/133] (866s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[157.561046] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[164.135210] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.576s)
[164.246453] [023/133] (859s left) kms_psr (pr-sprite-mmap-gtt)
[164.337204] Starting subtest: pr-sprite-mmap-gtt
[164.341305] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[164.411450] [024/133] (859s left) gem_exec_reloc (basic-write-gtt-noreloc)
[164.471669] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[164.534091] [025/133] (859s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[164.624452] Starting subtest: plane-lut1d-ctm3x4
[164.774061] Starting dynamic subtest: pipe-A-plane-0
[164.941657] Dynamic subtest pipe-A-plane-0: SUCCESS (0.167s)
[164.951782] Starting dynamic subtest: pipe-A-plane-1
[165.072296] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[165.081281] Starting dynamic subtest: pipe-A-plane-2
[165.205747] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[166.364216] Starting dynamic subtest: pipe-B-plane-0
[166.501964] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[166.511453] Starting dynamic subtest: pipe-B-plane-1
[166.680220] Dynamic subtest pipe-B-plane-1: SUCCESS (0.177s)
[166.688782] Starting dynamic subtest: pipe-B-plane-2
[166.813754] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[168.036347] Starting dynamic subtest: pipe-C-plane-0
[168.173667] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[168.182734] Starting dynamic subtest: pipe-C-plane-1
[168.317920] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[168.327369] Starting dynamic subtest: pipe-C-plane-2
[168.451210] Dynamic subtest pipe-C-plane-2: SUCCESS (0.133s)
[169.653399] Starting dynamic subtest: pipe-D-plane-0
[169.789213] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[169.798185] Starting dynamic subtest: pipe-D-plane-1
[169.934378] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[169.942916] Starting dynamic subtest: pipe-D-plane-2
[170.067094] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[170.353493] Subtest plane-lut1d-ctm3x4: SUCCESS (5.724s)
[171.212069] [026/133] (853s left) gem_exec_schedule (preempt-hang)
[171.388184] Starting subtest: preempt-hang
[171.390985] Starting dynamic subtest: rcs0
[171.634099] Dynamic subtest rcs0: SUCCESS (0.246s)
[171.646718] Starting dynamic subtest: bcs0
[171.867092] Dynamic subtest bcs0: SUCCESS (0.230s)
[171.877205] Starting dynamic subtest: vcs0
[172.090075] Dynamic subtest vcs0: SUCCESS (0.220s)
[172.101314] Starting dynamic subtest: vcs1
[172.320008] Dynamic subtest vcs1: SUCCESS (0.231s)
[172.332858] Starting dynamic subtest: vecs0
[172.551066] Dynamic subtest vecs0: SUCCESS (0.230s)
[172.562316] Starting dynamic subtest: ccs0
[172.779477] Dynamic subtest ccs0: SUCCESS (0.227s)
[172.781425] Subtest preempt-hang: SUCCESS (1.391s)
[173.099087] [027/133] (851s left) kms_psr (psr-cursor-mmap-cpu)
[173.201215] Starting subtest: psr-cursor-mmap-cpu
[173.203552] Starting dynamic subtest: eDP-1
[174.913433] Dynamic subtest eDP-1: SUCCESS (1.711s)
[174.915793] Subtest psr-cursor-mmap-cpu: SUCCESS (1.712s)
[175.767290] [028/133] (848s left) gem_exec_whisper (basic-contexts-priority-all)
[175.821710] Starting subtest: basic-contexts-priority-all
[198.045037] Subtest basic-contexts-priority-all: SUCCESS (22.226s)
[198.227057] [029/133] (826s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[198.277194] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[198.349367] [030/133] (826s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[198.468595] Starting subtest: cursorB-vs-flipA-atomic-transitions
[198.473285] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[198.609064] [031/133] (825s left) gem_exec_params (rel-constants-invalid)
[198.682284] Starting subtest: rel-constants-invalid
[198.684169] Subtest rel-constants-invalid: SUCCESS (0.000s)
[198.770424] [032/133] (825s left) kms_joiner (invalid-modeset-ultra-joiner)
[198.874776] Starting subtest: invalid-modeset-ultra-joiner
[198.878994] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[198.936465] [033/133] (825s left) syncobj_wait (invalid-signal-bad-pad)
[198.992112] Starting subtest: invalid-signal-bad-pad
[198.994322] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[199.108300] [034/133] (825s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[199.203532] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[199.215249] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[199.312050] [035/133] (825s left) gem_eio (in-flight-contexts-1us)
[199.531119] Starting subtest: in-flight-contexts-1us
[211.044190] Subtest in-flight-contexts-1us: SUCCESS (11.509s)
[211.210490] [036/133] (813s left) kms_pm_lpsp (kms-lpsp)
[212.310391] Starting subtest: kms-lpsp
[212.313365] Starting dynamic subtest: pipe-A-eDP-1
[212.486530] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.180s)
[212.794890] Subtest kms-lpsp: SUCCESS (0.488s)
[213.600918] [037/133] (811s left) i915_drm_fdinfo (busy-check-all)
[213.645576] Starting subtest: busy-check-all
[213.647343] Starting dynamic subtest: rcs0
[213.651743] Dynamic subtest rcs0: SKIP (0.003s)
[213.661498] Starting dynamic subtest: bcs0
[213.665730] Dynamic subtest bcs0: SKIP (0.000s)
[213.674430] Starting dynamic subtest: vcs0
[213.678725] Dynamic subtest vcs0: SKIP (0.000s)
[213.687193] Starting dynamic subtest: vcs1
[213.691278] Dynamic subtest vcs1: SKIP (0.000s)
[213.699755] Starting dynamic subtest: vecs0
[213.703851] Dynamic subtest vecs0: SKIP (0.000s)
[213.712296] Starting dynamic subtest: ccs0
[213.716360] Dynamic subtest ccs0: SKIP (0.000s)
[213.720581] Subtest busy-check-all: SKIP (0.007s)
[213.756532] [038/133] (811s left) drm_read (fault-buffer)
[213.898070] Starting subtest: fault-buffer
[213.900476] Subtest fault-buffer: SUCCESS (0.000s)
[214.054608] [039/133] (810s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[214.155621] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[215.123891] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.968s)
[215.241706] [040/133] (809s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[215.337419] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[215.339568] Starting dynamic subtest: pipe-A-eDP-1
[216.282126] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.937s)
[216.293257] Starting dynamic subtest: pipe-B-eDP-1
[217.801915] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.518s)
[217.811283] Starting dynamic subtest: pipe-C-eDP-1
[219.307907] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.506s)
[219.318428] Starting dynamic subtest: pipe-D-eDP-1
[220.843359] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.533s)
[220.845829] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.498s)
[222.031446] [041/133] (802s left) gem_ctx_shared (create-shared-gtt)
[222.093888] Starting subtest: create-shared-gtt
[224.299520] Subtest create-shared-gtt: SUCCESS (2.151s)
[224.590943] [042/133] (800s left) gem_sync (basic-store-each)
[224.654796] Starting subtest: basic-store-each
[227.330947] Subtest basic-store-each: SUCCESS (2.685s)
[227.521271] [043/133] (797s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[227.613391] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[227.615735] Starting dynamic subtest: A-eDP1
[236.479072] Dynamic subtest A-eDP1: SUCCESS (8.864s)
[236.489892] Starting dynamic subtest: B-eDP1
[245.411274] Dynamic subtest B-eDP1: SUCCESS (8.927s)
[245.422423] Starting dynamic subtest: C-eDP1
[254.384529] Dynamic subtest C-eDP1: SUCCESS (8.924s)
[254.395367] Starting dynamic subtest: D-eDP1
[263.182920] Dynamic subtest D-eDP1: SUCCESS (8.839s)
[263.188795] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.566s)
[264.414956] [044/133] (760s left) i915_pm_freq_api (freq-basic-api)
[264.480745] Starting subtest: freq-basic-api
[264.483103] Starting dynamic subtest: gt0
[264.485355] Dynamic subtest gt0: SUCCESS (0.003s)
[264.496835] Starting dynamic subtest: gt1
[264.498974] Dynamic subtest gt1: SUCCESS (0.002s)
[264.501181] Subtest freq-basic-api: SUCCESS (0.007s)
[264.585846] [045/133] (760s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[264.684752] Starting subtest: plane-use-after-nonblocking-unbind
[264.687791] Starting dynamic subtest: pipe-A-eDP-1
[264.742156] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.061s)
[265.050211] Starting dynamic subtest: pipe-B-eDP-1
[265.818983] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.778s)
[266.111252] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.429s)
[266.972494] [046/133] (758s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[267.077902] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[267.081877] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[267.168435] [047/133] (757s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[267.273037] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[267.277234] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[267.367223] [048/133] (757s left) kms_getfb (getfb2-handle-closed)
[267.467300] Starting subtest: getfb2-handle-closed
[267.469477] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[267.566238] [049/133] (757s left) kms_psr (fbc-pr-no-drrs)
[267.662200] Starting subtest: fbc-pr-no-drrs
[267.666766] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[267.732689] [050/133] (757s left) drm_read (short-buffer-nonblock)
[267.865024] Starting subtest: short-buffer-nonblock
[267.867363] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[267.979410] [051/133] (757s left) gen9_exec_parse (bb-secure)
[268.032401] Subtest bb-secure: SKIP (0.000s)
[268.095044] [052/133] (757s left) kms_psr (fbc-pr-sprite-render)
[268.194609] Starting subtest: fbc-pr-sprite-render
[268.198258] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[268.264097] [053/133] (757s left) kms_big_fb (linear-64bpp-rotate-0)
[268.361200] Starting subtest: linear-64bpp-rotate-0
[269.862749] Subtest linear-64bpp-rotate-0: SUCCESS (1.501s)
[270.045896] [054/133] (755s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[270.142992] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[270.147119] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[270.215444] [055/133] (755s left) gem_exec_balancer (full)
[270.295970] Starting subtest: full
[274.828690] Subtest full: SUCCESS (4.534s)
[275.197874] [056/133] (750s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[275.304230] Starting subtest: plane-upscale-20x20-with-pixel-format
[275.306525] Starting dynamic subtest: pipe-A
[276.352242] Dynamic subtest pipe-A: SUCCESS (1.050s)
[276.361755] Starting dynamic subtest: pipe-B
[278.479786] Dynamic subtest pipe-B: SUCCESS (2.126s)
[278.497148] Starting dynamic subtest: pipe-C
[279.666060] Dynamic subtest pipe-C: SUCCESS (1.183s)
[279.676450] Starting dynamic subtest: pipe-D
[280.803195] Dynamic subtest pipe-D: SUCCESS (1.135s)
[280.805508] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.501s)
[281.987747] [057/133] (743s left) kms_flip (modeset-vs-vblank-race-interruptible)
[282.091673] Starting subtest: modeset-vs-vblank-race-interruptible
[282.094056] Starting dynamic subtest: A-eDP1
[286.801979] Dynamic subtest A-eDP1: SUCCESS (4.708s)
[286.814822] Starting dynamic subtest: B-eDP1
[291.429666] Dynamic subtest B-eDP1: SUCCESS (4.624s)
[291.445273] Starting dynamic subtest: C-eDP1
[296.033882] Dynamic subtest C-eDP1: SUCCESS (4.600s)
[296.046351] Starting dynamic subtest: D-eDP1
[300.657206] Dynamic subtest D-eDP1: SUCCESS (4.621s)
[300.662396] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.566s)
[301.823370] [058/133] (723s left) i915_pm_rps (engine-order)
[301.879191] Starting subtest: engine-order
[307.039977] Subtest engine-order: SUCCESS (5.158s)
[307.160870] [059/133] (718s left) kms_plane_cursor (overlay)
[307.252197] Starting subtest: overlay
[307.256818] Starting dynamic subtest: pipe-A-eDP-1-size-64
[309.724586] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.474s)
[309.785342] Starting dynamic subtest: pipe-A-eDP-1-size-128
[312.215195] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.438s)
[312.273601] Starting dynamic subtest: pipe-A-eDP-1-size-256
[314.669732] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.405s)
[315.026065] Starting dynamic subtest: pipe-B-eDP-1-size-64
[318.245078] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.231s)
[318.304965] Starting dynamic subtest: pipe-B-eDP-1-size-128
[320.735247] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.438s)
[320.795993] Starting dynamic subtest: pipe-B-eDP-1-size-256
[323.202010] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.415s)
[323.557336] Starting dynamic subtest: pipe-C-eDP-1-size-64
[326.334026] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.792s)
[326.372875] Starting dynamic subtest: pipe-C-eDP-1-size-128
[328.466780] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.103s)
[328.505626] Starting dynamic subtest: pipe-C-eDP-1-size-256
[330.622432] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.125s)
[330.952329] Starting dynamic subtest: pipe-D-eDP-1-size-64
[333.757586] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.818s)
[333.795804] Starting dynamic subtest: pipe-D-eDP-1-size-128
[335.845680] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.058s)
[335.883957] Starting dynamic subtest: pipe-D-eDP-1-size-256
[337.945595] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.069s)
[338.267543] Subtest overlay: SUCCESS (31.022s)
[339.138223] [060/133] (686s left) kms_sequence (queue-busy)
[339.244600] Starting subtest: queue-busy
[339.246994] Starting dynamic subtest: pipe-A-eDP-1
[341.175349] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.932s)
[341.187246] Starting dynamic subtest: pipe-B-eDP-1
[343.777180] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.598s)
[343.804535] Starting dynamic subtest: pipe-C-eDP-1
[346.350489] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.572s)
[346.360444] Starting dynamic subtest: pipe-D-eDP-1
[348.900794] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.548s)
[348.903091] Subtest queue-busy: SUCCESS (9.659s)
[349.690695] [061/133] (676s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[349.784523] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[349.786805] Starting dynamic subtest: A-eDP1
[353.412528] Dynamic subtest A-eDP1: SUCCESS (3.630s)
[353.423195] Starting dynamic subtest: B-eDP1
[356.602663] Dynamic subtest B-eDP1: SUCCESS (3.188s)
[356.614022] Starting dynamic subtest: C-eDP1
[359.713654] Dynamic subtest C-eDP1: SUCCESS (3.111s)
[359.724615] Starting dynamic subtest: D-eDP1
[362.913190] Dynamic subtest D-eDP1: SUCCESS (3.195s)
[362.915307] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.131s)
[363.716566] [062/133] (662s left) gem_flink_basic (double-flink)
[363.791580] Starting subtest: double-flink
[363.793517] Subtest double-flink: SUCCESS (0.000s)
[363.880754] [063/133] (661s left) gem_ctx_isolation (dirty-switch)
[363.946577] Starting subtest: dirty-switch
[363.948883] Starting dynamic subtest: rcs0
[364.136246] Dynamic subtest rcs0: SUCCESS (0.189s)
[364.147862] Starting dynamic subtest: bcs0
[364.345894] Dynamic subtest bcs0: SUCCESS (0.209s)
[364.355729] Starting dynamic subtest: vcs0
[364.566916] Dynamic subtest vcs0: SUCCESS (0.220s)
[364.578237] Starting dynamic subtest: vcs1
[366.226820] Dynamic subtest vcs1: SUCCESS (1.659s)
[366.236672] Starting dynamic subtest: vecs0
[368.223289] Dynamic subtest vecs0: SUCCESS (1.995s)
[368.235310] Starting dynamic subtest: ccs0
[370.211598] Dynamic subtest ccs0: SUCCESS (1.987s)
[370.213984] Subtest dirty-switch: SUCCESS (6.266s)
[370.460288] [064/133] (655s left) kms_cursor_edge_walk (64x64-top-edge)
[370.550931] Starting subtest: 64x64-top-edge
[370.553109] Starting dynamic subtest: pipe-A-eDP-1
[373.982343] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.430s)
[373.994583] Starting dynamic subtest: pipe-D-eDP-1
[377.102701] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.121s)
[377.104995] Subtest 64x64-top-edge: SUCCESS (6.554s)
[377.911092] [065/133] (647s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[377.999410] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[378.001609] Starting dynamic subtest: pipe-A-eDP-1
[378.025725] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[378.036682] Starting dynamic subtest: pipe-B-eDP-1
[378.059537] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[378.068715] Starting dynamic subtest: pipe-C-eDP-1
[378.092195] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[378.101541] Starting dynamic subtest: pipe-D-eDP-1
[378.125733] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[378.129857] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[380.307232] [066/133] (645s left) gem_eio (hibernate)
[380.539782] Starting subtest: hibernate
[395.296495] Subtest hibernate: SUCCESS (14.753s)
[403.457059] [067/133] (630s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[403.577071] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[403.591033] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.014s)
[403.683163] [068/133] (630s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[403.791437] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[403.795746] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[403.892119] [069/133] (630s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[403.994303] Starting subtest: extended-modeset-hang-newfb-with-reset
[403.996613] Starting dynamic subtest: pipe-A
[418.077661] Dynamic subtest pipe-A: SUCCESS (14.078s)
[418.088160] Starting dynamic subtest: pipe-D
[434.073332] Dynamic subtest pipe-D: SUCCESS (15.991s)
[434.075251] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (30.073s)
[434.869692] [070/133] (599s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[434.989451] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[434.993970] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[435.063101] [071/133] (599s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[435.154041] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[438.868735] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.719s)
[440.080563] [072/133] (594s left) sysfs_preempt_timeout (invalid)
[440.137419] Starting subtest: invalid
[440.139955] Starting dynamic subtest: vecs0
[440.142287] Dynamic subtest vecs0: SUCCESS (0.000s)
[440.154558] Starting dynamic subtest: ccs0
[440.156749] Dynamic subtest ccs0: SUCCESS (0.000s)
[440.166767] Starting dynamic subtest: vcs0
[440.169050] Dynamic subtest vcs0: SUCCESS (0.000s)
[440.178606] Starting dynamic subtest: bcs0
[440.180575] Dynamic subtest bcs0: SUCCESS (0.000s)
[440.190175] Starting dynamic subtest: rcs0
[440.192427] Dynamic subtest rcs0: SUCCESS (0.000s)
[440.202094] Starting dynamic subtest: vcs1
[440.204412] Dynamic subtest vcs1: SUCCESS (0.000s)
[440.206675] Subtest invalid: SUCCESS (0.005s)
[440.243517] [073/133] (594s left) gem_exec_big (single)
[440.301896] Starting subtest: single
[445.305190] Subtest single: SUCCESS (4.951s)
[445.508260] [074/133] (588s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[445.651193] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[445.653426] Starting dynamic subtest: pipe-A-eDP-1
[445.711914] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[445.724522] Starting dynamic subtest: pipe-B-eDP-1
[445.783090] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[445.795287] Starting dynamic subtest: pipe-C-eDP-1
[445.855552] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[445.867192] Starting dynamic subtest: pipe-D-eDP-1
[445.923740] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[445.927950] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.010s)
[447.927503] [075/133] (586s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[448.029029] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[449.031412] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.001s)
[449.166063] [076/133] (585s left) kms_chamelium_hpd (dp-hpd-storm)
[449.552940] Subtest dp-hpd-storm: SKIP (0.000s)
[450.330411] [077/133] (584s left) i915_query (query-topology-kernel-writes)
[450.390031] Starting subtest: query-topology-kernel-writes
[450.392115] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[450.488848] [078/133] (583s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[450.589210] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[450.593553] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[450.661331] [079/133] (583s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[450.730468] Starting subtest: invalid-bsd2-flag-on-blt
[450.732823] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[450.834254] [080/133] (583s left) sw_sync (sync_busy_fork)
[450.885110] Starting subtest: sync_busy_fork
[451.897984] Subtest sync_busy_fork: SUCCESS (1.011s)
[451.965467] [081/133] (582s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[452.025365] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[452.027631] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[452.130387] [082/133] (582s left) kms_chamelium_frames (hdmi-crc-fast)
[452.520248] Subtest hdmi-crc-fast: SKIP (0.000s)
[453.357327] [083/133] (581s left) gem_flink_basic (flink-lifetime)
[453.415989] Starting subtest: flink-lifetime
[453.418475] Subtest flink-lifetime: SUCCESS (0.002s)
[453.532206] [084/133] (581s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[453.630630] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[453.634728] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[453.753587] [085/133] (581s left) kms_prop_blob (basic)
[453.807237] Starting subtest: basic
[453.809182] Subtest basic: SUCCESS (0.000s)
[453.914651] [086/133] (580s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[453.967620] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[454.074693] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s)
[454.147272] [087/133] (580s left) perf (blocking-parameterized)
[454.291804] Starting subtest: blocking-parameterized
[474.361646] Subtest blocking-parameterized: SUCCESS (20.018s)
[474.400805] [088/133] (560s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[474.462211] Starting subtest: etime-multi-wait-all-submitted-signaled
[474.569656] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.109s)
[474.646947] [089/133] (560s left) gem_exec_fence (submit-chain)
[474.834249] Starting subtest: submit-chain
[474.864374] Subtest submit-chain: SUCCESS (0.033s)
[477.087243] [FACT gem_exec_fence (submit-chain)] new: kernel.kmod_is_loaded.vgem: true
[477.091106] [090/133] (557s left) gem_exec_params (mmapped)
[477.157763] Starting subtest: mmapped
[477.163745] Subtest mmapped: SUCCESS (0.005s)
[477.298280] [091/133] (557s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[477.403330] Starting subtest: x-tiled-32bpp-rotate-180
[478.917076] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.513s)
[479.037116] [092/133] (556s left) sw_sync (sync_expired_merge)
[479.077411] Starting subtest: sync_expired_merge
[480.149459] Subtest sync_expired_merge: SUCCESS (1.074s)
[480.224778] [093/133] (554s left) prime_vgem (basic-fence-mmap)
[480.304728] Starting subtest: basic-fence-mmap
[480.309112] Subtest basic-fence-mmap: SKIP (0.000s)
[480.406122] [094/133] (554s left) gem_ctx_shared (disjoint-timelines)
[480.483024] Starting subtest: disjoint-timelines
[480.502680] Subtest disjoint-timelines: SUCCESS (0.020s)
[480.741557] [095/133] (554s left) kms_psr (psr-dpms)
[480.834560] Starting subtest: psr-dpms
[480.836918] Starting dynamic subtest: eDP-1
[483.822782] Dynamic subtest eDP-1: SUCCESS (2.987s)
[483.825185] Subtest psr-dpms: SUCCESS (2.988s)
[484.687900] [096/133] (550s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[484.797576] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[492.096166] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.299s)
[492.200311] [097/133] (543s left) gem_softpin (allocator-nopin)
[492.265171] Starting subtest: allocator-nopin
[492.367228] Subtest allocator-nopin: SUCCESS (0.101s)
[492.486705] [098/133] (542s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[492.570121] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[492.572269] Starting dynamic subtest: pipe-A-default-mode
[493.768382] Dynamic subtest pipe-A-default-mode: SKIP (1.197s)
[493.773020] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.198s)
[493.914091] [099/133] (541s left) gem_exec_flush (basic-wb-pro-default)
[493.988636] Starting subtest: basic-wb-pro-default
[499.473972] Subtest basic-wb-pro-default: SUCCESS (5.470s)
[499.642123] [100/133] (535s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[499.747479] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[499.749758] Starting dynamic subtest: pipe-A-eDP-1
[499.838099] Dynamic subtest pipe-A-eDP-1: SKIP (0.092s)
[499.854852] Starting dynamic subtest: pipe-B-eDP-1
[501.009165] Dynamic subtest pipe-B-eDP-1: SKIP (1.170s)
[501.013954] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.265s)
[502.200342] [101/133] (533s left) syncobj_timeline (single-wait-available-submitted)
[502.248107] Starting subtest: single-wait-available-submitted
[502.250415] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[502.333889] [102/133] (533s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[502.389424] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[502.393651] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[502.565964] [103/133] (532s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[502.658074] Starting subtest: psr-rgb101010-draw-pwrite
[510.297478] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.641s)
[510.416635] [104/133] (525s left) perf (gen8-unprivileged-single-ctx-counters)
[510.510201] Starting subtest: gen8-unprivileged-single-ctx-counters
[510.514760] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[510.557580] [105/133] (525s left) api_intel_allocator (standalone)
[510.610164] Starting subtest: standalone
[510.625804] Subtest standalone: SUCCESS (0.017s)
[510.732867] [106/133] (524s left) kms_getfb (getfb-handle-closed)
[510.817313] Starting subtest: getfb-handle-closed
[510.819570] Subtest getfb-handle-closed: SUCCESS (0.000s)
[510.918985] [107/133] (524s left) perf (mi-rpc)
[511.001206] Starting subtest: mi-rpc
[511.005853] Subtest mi-rpc: SKIP (0.000s)
[511.048958] [108/133] (524s left) kms_async_flips (async-flip-dpms)
[511.140837] Starting subtest: async-flip-dpms
[511.530721] Starting dynamic subtest: pipe-A-eDP-1
[515.383346] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.851s)
[515.751845] Starting dynamic subtest: pipe-B-eDP-1
[518.554304] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.810s)
[518.921564] Starting dynamic subtest: pipe-C-eDP-1
[521.726743] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.813s)
[522.103045] Starting dynamic subtest: pipe-D-eDP-1
[524.884291] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.789s)
[524.886804] Subtest async-flip-dpms: SUCCESS (13.743s)
[526.068622] [109/133] (509s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[526.180752] Starting subtest: y-tiled-64bpp-rotate-180
[526.185233] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[526.265001] [110/133] (509s left) gem_close_race (multigpu-basic-process)
[526.329149] Starting subtest: multigpu-basic-process
[526.333246] Subtest multigpu-basic-process: SKIP (0.000s)
[526.549366] [111/133] (509s left) kms_cursor_crc (cursor-offscreen-32x10)
[526.728359] Starting subtest: cursor-offscreen-32x10
[526.776707] Subtest cursor-offscreen-32x10: SKIP (0.042s)
[527.052933] [112/133] (508s left) gem_exec_flush (basic-wb-rw-default)
[527.112685] Starting subtest: basic-wb-rw-default
[532.599870] Subtest basic-wb-rw-default: SUCCESS (5.456s)
[532.761985] [113/133] (503s left) dmabuf_sync_file (export-before-signal)
[532.809282] Starting subtest: export-before-signal
[532.811493] Subtest export-before-signal: SUCCESS (0.000s)
[532.869239] [114/133] (503s left) gem_exec_schedule (preempt-queue-contexts-chain)
[532.950913] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[533.246443] [115/133] (502s left) perf_pmu (semaphore-wait)
[533.284930] Starting subtest: semaphore-wait
[533.287306] Starting dynamic subtest: rcs0
[533.798208] Dynamic subtest rcs0: SUCCESS (0.512s)
[533.812852] Starting dynamic subtest: bcs0
[534.314499] Dynamic subtest bcs0: SUCCESS (0.513s)
[534.328625] Starting dynamic subtest: vcs0
[534.830753] Dynamic subtest vcs0: SUCCESS (0.513s)
[534.844276] Starting dynamic subtest: vcs1
[535.347680] Dynamic subtest vcs1: SUCCESS (0.512s)
[535.361402] Starting dynamic subtest: vecs0
[535.863175] Dynamic subtest vecs0: SUCCESS (0.512s)
[535.877844] Starting dynamic subtest: ccs0
[536.379562] Dynamic subtest ccs0: SUCCESS (0.513s)
[536.382784] Subtest semaphore-wait: SUCCESS (3.095s)
[536.521153] [116/133] (499s left) gem_basic (multigpu-create-close)
[536.580516] Starting subtest: multigpu-create-close
[536.584668] Subtest multigpu-create-close: SKIP (0.000s)
[536.718917] [117/133] (499s left) kms_vblank (query-idle)
[536.812411] Starting subtest: query-idle
[536.814722] Starting dynamic subtest: pipe-A-eDP-1
[538.556325] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.744s)
[538.572829] Starting dynamic subtest: pipe-D-eDP-1
[541.007975] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.446s)
[541.010272] Subtest query-idle: SUCCESS (4.194s)
[541.849406] [118/133] (494s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[541.944037] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[541.948210] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[542.044967] [119/133] (494s left) syncobj_timeline (reset-during-wait-for-submit)
[542.095388] Starting subtest: reset-during-wait-for-submit
[542.199856] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[542.290079] [120/133] (494s left) i915_suspend (basic-s3-without-i915)
[542.331040] Starting subtest: basic-s3-without-i915
[545.607921] Subtest basic-s3-without-i915: SKIP (3.273s)
[547.202018] [121/133] (489s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[547.311382] Starting subtest: plane-primary-toggle-with-vblank-wait
[547.313631] Starting dynamic subtest: pipe-A-eDP-1
[547.482545] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.172s)
[547.791159] Starting dynamic subtest: pipe-B-eDP-1
[548.685905] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.904s)
[548.994955] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.685s)
[549.866665] [122/133] (486s left) kms_psr (fbc-psr-primary-blt)
[549.959426] Starting subtest: fbc-psr-primary-blt
[549.961301] Starting dynamic subtest: eDP-1
[549.965376] Dynamic subtest eDP-1: SKIP (0.000s)
[549.969426] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[550.033286] [123/133] (486s left) gem_mmap (bad-offset)
[550.095742] Subtest bad-offset: SKIP (0.000s)
[550.157107] [124/133] (486s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[550.253340] Starting subtest: yf-tiled-8bpp-rotate-0
[550.257828] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[550.350570] [125/133] (486s left) gem_exec_flush (basic-batch-kernel-default-wb)
[550.412183] Starting subtest: basic-batch-kernel-default-wb
[557.849513] Subtest basic-batch-kernel-default-wb: SUCCESS (7.436s)
[558.052776] [126/133] (478s left) perf (invalid-oa-format-id)
[558.189696] Starting subtest: invalid-oa-format-id
[558.201886] Subtest invalid-oa-format-id: SUCCESS (0.012s)
[558.242580] [127/133] (478s left) kms_async_flips (test-time-stamp)
[558.330173] Starting subtest: test-time-stamp
[558.701962] Starting dynamic subtest: pipe-A-eDP-1
[559.468185] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.764s)
[559.856822] Starting dynamic subtest: pipe-B-eDP-1
[560.613525] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.762s)
[561.004250] Starting dynamic subtest: pipe-C-eDP-1
[561.753606] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.755s)
[562.117909] Starting dynamic subtest: pipe-D-eDP-1
[562.890291] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.779s)
[562.892812] Subtest test-time-stamp: SUCCESS (4.560s)
[564.064642] [128/133] (472s left) kms_content_protection (legacy-hdcp14)
[564.228767] Starting subtest: legacy-hdcp14
[564.233436] Subtest legacy-hdcp14: SKIP (0.000s)
[564.350305] [129/133] (472s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[564.435354] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[564.437721] Starting dynamic subtest: pipe-A-eDP-1
[580.484070] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.421s)
[580.495263] Starting dynamic subtest: pipe-B-eDP-1
[597.425989] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.400s)
[597.436942] Starting dynamic subtest: pipe-C-eDP-1
[614.419231] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.340s)
[614.429211] Starting dynamic subtest: pipe-D-eDP-1
[631.396538] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.315s)
[631.399025] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.481s)
[632.577152] [130/133] (404s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[632.680677] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[639.483473] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.721s)
[639.612550] [131/133] (397s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[639.935663] Starting subtest: cursor-rapid-movement-max-size
[639.942723] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[640.055204] [132/133] (396s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[640.149942] Starting subtest: fbcpsr-suspend
[680.944559] Subtest fbcpsr-suspend: SUCCESS (10.046s)
[681.084953] [133/133] (355s left) api_intel_bb (reset-flags)
[681.143664] Starting subtest: reset-flags
[681.149333] Subtest reset-flags: SUCCESS (0.008s)
[681.273633] Closing watchdogs
results: parsing output: 0/ for test: gem_softpin
results: parsing output: 1/ for test: perf_pmu
results: parsing output: 2/ for test: kms_invalid_mode
results: parsing output: 3/ for test: kms_prop_blob
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_cursor_legacy
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_pxp
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: kms_plane_alpha_blend
results: parsing output: 12/ for test: kms_plane
results: parsing output: 13/ for test: gem_mmap_gtt
results: parsing output: 14/ for test: kms_pipe_b_c_ivb
results: parsing output: 15/ for test: gem_vm_create
results: parsing output: 16/ for test: gem_lmem_swapping
results: parsing output: 17/ for test: kms_feature_discovery
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: gem_mmap_offset
results: parsing output: 20/ for test: gem_pxp
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: gem_exec_reloc
results: parsing output: 24/ for test: kms_color_pipeline
results: parsing output: 25/ for test: gem_exec_schedule
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: gem_exec_whisper
results: parsing output: 28/ for test: gem_exec_reloc
results: parsing output: 29/ for test: kms_cursor_legacy
results: parsing output: 30/ for test: gem_exec_params
results: parsing output: 31/ for test: kms_joiner
results: parsing output: 32/ for test: syncobj_wait
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: gem_eio
results: parsing output: 35/ for test: kms_pm_lpsp
results: parsing output: 36/ for test: i915_drm_fdinfo
results: parsing output: 37/ for test: drm_read
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: gem_ctx_shared
results: parsing output: 41/ for test: gem_sync
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: i915_pm_freq_api
results: parsing output: 44/ for test: kms_atomic_transition
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_getfb
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: drm_read
results: parsing output: 50/ for test: gen9_exec_parse
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_flip_scaled_crc
results: parsing output: 54/ for test: gem_exec_balancer
results: parsing output: 55/ for test: kms_plane_scaling
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: i915_pm_rps
results: parsing output: 58/ for test: kms_plane_cursor
results: parsing output: 59/ for test: kms_sequence
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: gem_flink_basic
results: parsing output: 62/ for test: gem_ctx_isolation
results: parsing output: 63/ for test: kms_cursor_edge_walk
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: gem_eio
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_busy
results: parsing output: 69/ for test: kms_flip_scaled_crc
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: sysfs_preempt_timeout
results: parsing output: 72/ for test: gem_exec_big
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: kms_chamelium_hpd
results: parsing output: 76/ for test: i915_query
results: parsing output: 77/ for test: kms_plane
results: parsing output: 78/ for test: gem_exec_params
results: parsing output: 79/ for test: sw_sync
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: kms_chamelium_frames
results: parsing output: 82/ for test: gem_flink_basic
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_prop_blob
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: perf
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: gem_exec_fence
results: parsing output: 89/ for test: gem_exec_params
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: sw_sync
results: parsing output: 92/ for test: prime_vgem
results: parsing output: 93/ for test: gem_ctx_shared
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_softpin
results: parsing output: 97/ for test: kms_flip_scaled_crc
results: parsing output: 98/ for test: gem_exec_flush
results: parsing output: 99/ for test: kms_psr2_sf
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: gem_render_copy
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: perf
results: parsing output: 104/ for test: api_intel_allocator
results: parsing output: 105/ for test: kms_getfb
results: parsing output: 106/ for test: perf
results: parsing output: 107/ for test: kms_async_flips
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: gem_close_race
results: parsing output: 110/ for test: kms_cursor_crc
results: parsing output: 111/ for test: gem_exec_flush
results: parsing output: 112/ for test: dmabuf_sync_file
results: parsing output: 113/ for test: gem_exec_schedule
results: parsing output: 114/ for test: perf_pmu
results: parsing output: 115/ for test: gem_basic
results: parsing output: 116/ for test: kms_vblank
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: i915_suspend
results: parsing output: 120/ for test: kms_atomic_transition
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: gem_mmap
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: gem_exec_flush
results: parsing output: 125/ for test: perf
results: parsing output: 126/ for test: kms_async_flips
results: parsing output: 127/ for test: kms_content_protection
results: parsing output: 128/ for test: kms_ccs
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_cursor_crc
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: api_intel_bb
Done.