[68.631711] Initializing watchdogs
[68.631798]   /dev/watchdog0
[68.662613] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[68.677239] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[68.682496] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[68.686226] [001/156] (960s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[70.231300] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[70.359805] [002/156] (958s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[70.410656] Starting subtest: multi-wait-for-submit-unsubmitted
[70.519471] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[70.729659] [003/156] (958s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-render)
[72.232791] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-render
[72.235765] Subtest fbchdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[72.454262] [004/156] (956s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[73.944900] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[73.946688] Starting dynamic subtest: pipe-A-HDMI-A-4
[73.970764] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.001s)
[73.979962] Starting dynamic subtest: pipe-B-HDMI-A-4
[73.992822] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.001s)
[74.001803] Starting dynamic subtest: pipe-C-HDMI-A-4
[74.014934] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.001s)
[74.024056] Starting dynamic subtest: pipe-D-HDMI-A-4
[74.040801] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.001s)
[74.042592] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.008s)
[74.239416] [005/156] (955s left) kms_flip (basic-flip-vs-modeset)
[75.732155] Starting subtest: basic-flip-vs-modeset
[75.738115] Starting dynamic subtest: A-HDMI-A4
[76.529997] Dynamic subtest A-HDMI-A4: SUCCESS (0.792s)
[76.540873] Starting dynamic subtest: B-HDMI-A4
[77.228464] Dynamic subtest B-HDMI-A4: SUCCESS (0.698s)
[77.239488] Starting dynamic subtest: C-HDMI-A4
[77.935894] Dynamic subtest C-HDMI-A4: SUCCESS (0.705s)
[77.945887] Starting dynamic subtest: D-HDMI-A4
[78.637173] Dynamic subtest D-HDMI-A4: SUCCESS (0.705s)
[78.639107] Subtest basic-flip-vs-modeset: SUCCESS (2.911s)
[78.847938] [006/156] (950s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[80.351706] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[80.354559] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[80.496238] [007/156] (949s left) kms_frontbuffer_tracking (fbchdr-2p-shrfb-fliptrack-mmap-gtt)
[82.005952] Starting subtest: fbchdr-2p-shrfb-fliptrack-mmap-gtt
[82.008719] Subtest fbchdr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[82.176861] [008/156] (947s left) kms_psr (psr2-sprite-render)
[83.675446] Subtest psr2-sprite-render: SKIP (0.000s)
[83.743753] [009/156] (946s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[85.237983] Starting subtest: cursor-vs-flip-legacy
[116.912453] Subtest cursor-vs-flip-legacy: SUCCESS (31.675s)
[117.117992] [010/156] (912s left) kms_vblank (invalid)
[118.612197] Starting subtest: invalid
[118.613720] Starting dynamic subtest: pipe-A-HDMI-A-4
[118.961127] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.347s)
[118.962932] Subtest invalid: SUCCESS (0.348s)
[119.139893] [011/156] (910s left) syncobj_timeline (invalid-wait-illegal-handle)
[119.190906] Starting subtest: invalid-wait-illegal-handle
[119.192769] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[119.325320] [012/156] (910s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[120.824580] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[120.827626] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[120.999931] [013/156] (909s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[122.533649] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[122.536807] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[122.710516] [014/156] (907s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[124.225122] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[124.835481] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.611s)
[125.034694] [015/156] (905s left) kms_draw_crc (draw-method-mmap-gtt)
[126.528777] Starting subtest: draw-method-mmap-gtt
[126.531906] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[126.715825] [016/156] (903s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[128.208966] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[128.210535] Starting dynamic subtest: pipe-A
[128.968730] Dynamic subtest pipe-A: SUCCESS (0.761s)
[128.983400] Starting dynamic subtest: pipe-B
[129.759141] Dynamic subtest pipe-B: SUCCESS (0.790s)
[129.770021] Starting dynamic subtest: pipe-C
[130.533442] Dynamic subtest pipe-C: SUCCESS (0.773s)
[130.545593] Starting dynamic subtest: pipe-D
[131.308204] Dynamic subtest pipe-D: SUCCESS (0.774s)
[131.310130] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (3.101s)
[131.535434] [017/156] (899s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[133.039667] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[133.042685] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[133.237611] [018/156] (897s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[134.751730] Starting subtest: x-tiled-32bpp-rotate-180
[136.802802] Subtest x-tiled-32bpp-rotate-180: SUCCESS (2.050s)
[136.995520] [019/156] (893s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[138.495789] Starting subtest: psr-rgb101010-draw-mmap-gtt
[138.499487] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[138.754573] [020/156] (892s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[140.277091] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[140.358069] [021/156] (890s left) syncobj_wait (wait-all-for-submit-snapshot)
[140.408588] Starting subtest: wait-all-for-submit-snapshot
[140.490319] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[140.662610] [022/156] (890s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-mmap-cpu)
[142.160688] Starting subtest: psrhdr-rgb565-draw-mmap-cpu
[142.163933] Subtest psrhdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[142.358759] [023/156] (888s left) gem_tiled_blits (basic)
[142.419893] Subtest basic: SKIP (0.000s)
[142.488472] [024/156] (888s left) gem_exec_balancer (semaphore)
[142.548509] Starting subtest: semaphore
[144.578874] Subtest semaphore: SUCCESS (2.030s)
[145.049570] [025/156] (886s left) kms_chamelium_color (ctm-negative)
[146.544143] Subtest ctm-negative: SKIP (0.000s)
[146.621876] [026/156] (884s left) gem_barrier_race (remote-request)
[146.677234] Starting subtest: remote-request
[146.678983] Starting dynamic subtest: rcs0
[151.757931] Dynamic subtest rcs0: SUCCESS (5.079s)
[151.760045] Subtest remote-request: SUCCESS (5.080s)
[151.993396] [027/156] (879s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[153.505415] Starting subtest: 4-tiled-64bpp-rotate-90
[153.508870] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.000s)
[153.705062] [028/156] (877s left) gem_ctx_exec (basic-nohangcheck)
[153.756172] Starting subtest: basic-nohangcheck
[153.894505] Subtest basic-nohangcheck: SUCCESS (0.139s)
[154.064207] [029/156] (877s left) kms_flip (flip-vs-blocking-wf-vblank)
[155.557493] Starting subtest: flip-vs-blocking-wf-vblank
[155.562713] Starting dynamic subtest: A-HDMI-A4
[163.764343] Dynamic subtest A-HDMI-A4: SUCCESS (8.202s)
[163.776193] Starting dynamic subtest: B-HDMI-A4
[171.745875] Dynamic subtest B-HDMI-A4: SUCCESS (7.980s)
[171.757600] Starting dynamic subtest: C-HDMI-A4
[179.730701] Dynamic subtest C-HDMI-A4: SUCCESS (7.983s)
[179.741924] Starting dynamic subtest: D-HDMI-A4
[187.715848] Dynamic subtest D-HDMI-A4: SUCCESS (7.984s)
[187.717237] Subtest flip-vs-blocking-wf-vblank: SUCCESS (32.162s)
[187.936133] [030/156] (843s left) gem_exec_gttfill (engines)
[187.998106] Starting subtest: engines
[187.999636] Starting dynamic subtest: rcs0
[215.538891] Dynamic subtest rcs0: SUCCESS (27.537s)
[215.549904] Starting dynamic subtest: bcs0
[243.344526] Dynamic subtest bcs0: SUCCESS (27.805s)
[243.355147] Starting dynamic subtest: vcs0
[271.092201] Dynamic subtest vcs0: SUCCESS (27.747s)
[271.102945] Starting dynamic subtest: vcs1
[298.916185] Dynamic subtest vcs1: SUCCESS (27.823s)
[298.927127] Starting dynamic subtest: vecs0
[326.740747] Dynamic subtest vecs0: SUCCESS (27.824s)
[326.742635] Subtest engines: SUCCESS (138.740s)
[327.006082] [031/156] (704s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[328.548236] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[328.551567] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[328.711287] [032/156] (703s left) gem_exec_schedule (u-semaphore-user)
[328.791349] Starting subtest: u-semaphore-user
[328.821289] Subtest u-semaphore-user: SUCCESS (0.030s)
[329.242575] [033/156] (702s left) gem_ctx_bad_destroy (invalid-default-ctx)
[329.289168] Starting subtest: invalid-default-ctx
[329.290468] Subtest invalid-default-ctx: SUCCESS (0.000s)
[329.468171] [034/156] (702s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[330.969905] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[330.973223] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[331.165999] [035/156] (701s left) gem_eio (in-flight-contexts-1us)
[331.362153] Starting subtest: in-flight-contexts-1us
[344.888374] Subtest in-flight-contexts-1us: SUCCESS (13.530s)
[346.445170] [036/156] (685s left) kms_getfb (getfb2-into-addfb2)
[347.946857] Starting subtest: getfb2-into-addfb2
[347.948468] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[348.112891] [037/156] (684s left) api_intel_bb (intel-bb-blit-x)
[348.166854] Starting subtest: intel-bb-blit-x
[348.845266] Subtest intel-bb-blit-x: SUCCESS (0.679s)
[349.050090] [038/156] (683s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[350.585495] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[350.714679] [039/156] (681s left) syncobj_wait (wait-for-submit-snapshot)
[350.766048] Starting subtest: wait-for-submit-snapshot
[350.848825] Subtest wait-for-submit-snapshot: SUCCESS (0.083s)
[351.057785] [040/156] (681s left) gem_exec_reloc (basic-gtt-read)
[351.114095] Subtest basic-gtt-read: SKIP (0.000s)
[351.209251] [041/156] (681s left) kms_psr (fbc-psr2-suspend)
[352.701207] Subtest fbc-psr2-suspend: SKIP (0.000s)
[352.774772] [042/156] (680s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[354.267699] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[354.272736] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[354.397921] [043/156] (678s left) gem_spin_batch (spin-all)
[354.473891] Starting subtest: spin-all
[354.509388] Subtest spin-all: SUCCESS (0.035s)
[354.842256] [044/156] (678s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[356.341891] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-wc
[356.345547] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[356.493599] [045/156] (676s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[358.003961] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[358.005632] Starting dynamic subtest: pipe-A-HDMI-A-4
[358.021849] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[358.034102] Starting dynamic subtest: pipe-B-HDMI-A-4
[358.050767] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[358.062503] Starting dynamic subtest: pipe-C-HDMI-A-4
[358.083175] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[358.095281] Starting dynamic subtest: pipe-D-HDMI-A-4
[358.123014] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[358.126046] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SKIP (0.007s)
[358.307199] [046/156] (674s left) gem_exec_fence (syncobj-timeline-chain-engines)
[358.916351] Starting subtest: syncobj-timeline-chain-engines
[359.059586] Subtest syncobj-timeline-chain-engines: SUCCESS (0.146s)
[359.419816] [FACT gem_exec_fence (syncobj-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[359.423483] [047/156] (673s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-msflip-blt)
[360.922465] Starting subtest: hdr-1p-primscrn-shrfb-msflip-blt
[360.925742] Subtest hdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[361.187641] [048/156] (672s left) kms_vblank (wait-forked-busy)
[362.679751] Starting subtest: wait-forked-busy
[362.681360] Starting dynamic subtest: pipe-A-HDMI-A-4
[365.238161] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.555s)
[365.253486] Starting dynamic subtest: pipe-D-HDMI-A-4
[367.649180] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.407s)
[367.650997] Subtest wait-forked-busy: SUCCESS (4.969s)
[367.842032] [049/156] (665s left) gen3_render_tiledx_blits
[367.962397] [050/156] (665s left) gen9_exec_parse (cmd-crossing-page)
[368.015739] Subtest cmd-crossing-page: SKIP (0.000s)
[368.096858] [051/156] (665s left) kms_async_flips (test-cursor-atomic)
[369.589803] Starting subtest: test-cursor-atomic
[369.823533] Starting dynamic subtest: pipe-A-HDMI-A-4
[370.197274] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.374s)
[370.407108] Starting dynamic subtest: pipe-B-HDMI-A-4
[370.487374] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.091s)
[370.677634] Starting dynamic subtest: pipe-C-HDMI-A-4
[370.754111] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.087s)
[370.939145] Starting dynamic subtest: pipe-D-HDMI-A-4
[371.015932] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.087s)
[371.017578] Subtest test-cursor-atomic: SUCCESS (1.428s)
[371.432783] [052/156] (662s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-blt)
[372.965461] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-blt
[372.968751] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[373.138299] [053/156] (660s left) gem_mmap_gtt (cpuset-basic-small-copy)
[373.192930] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[373.285754] [054/156] (660s left) sysfs_heartbeat_interval (idempotent)
[373.339747] Starting subtest: idempotent
[373.341423] Starting dynamic subtest: vecs0
[373.343132] Dynamic subtest vecs0: SUCCESS (0.002s)
[373.356062] Starting dynamic subtest: vcs0
[373.358164] Dynamic subtest vcs0: SUCCESS (0.001s)
[373.370454] Starting dynamic subtest: bcs0
[373.372181] Dynamic subtest bcs0: SUCCESS (0.001s)
[373.383965] Starting dynamic subtest: rcs0
[373.385600] Dynamic subtest rcs0: SUCCESS (0.001s)
[373.397519] Starting dynamic subtest: vcs1
[373.399143] Dynamic subtest vcs1: SUCCESS (0.001s)
[373.400757] Subtest idempotent: SUCCESS (0.011s)
[373.480418] [055/156] (660s left) kms_psr (fbc-pr-primary-mmap-gtt)
[374.973027] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[375.061825] [056/156] (659s left) syncobj_wait (wait-all-snapshot)
[375.115156] Starting subtest: wait-all-snapshot
[375.195125] Subtest wait-all-snapshot: SUCCESS (0.082s)
[375.407501] [057/156] (658s left) syncobj_eventfd (binary-wait-signaled)
[375.460811] Starting subtest: binary-wait-signaled
[375.472975] Subtest binary-wait-signaled: SUCCESS (0.000s)
[375.599914] [058/156] (658s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[377.102687] Starting subtest: fbcpsr-rgb565-draw-pwrite
[377.105256] Subtest fbcpsr-rgb565-draw-pwrite: SKIP (0.000s)
[377.278441] [059/156] (657s left) gem_readwrite (write-bad-handle)
[377.331674] Subtest write-bad-handle: SKIP (0.000s)
[377.410088] [060/156] (657s left) kms_psr (psr-sprite-blt)
[378.902480] Subtest psr-sprite-blt: SKIP (0.000s)
[378.978557] [061/156] (655s left) syncobj_basic (create-signaled)
[379.033153] Starting subtest: create-signaled
[379.035233] Subtest create-signaled: SUCCESS (0.000s)
[379.164756] [062/156] (655s left) i915_pm_rpm (system-suspend-execbuf)
[383.046183] Starting subtest: system-suspend-execbuf
[445.744281] Subtest system-suspend-execbuf: SUCCESS (51.656s)
[446.830693] [063/156] (588s left) syncobj_basic (bad-create-flags)
[446.877834] Starting subtest: bad-create-flags
[446.879303] Subtest bad-create-flags: SUCCESS (0.000s)
[447.078109] [064/156] (587s left) gem_lmem_swapping (heavy-random)
[451.602585] Starting subtest: heavy-random
[451.605481] Starting dynamic subtest: lmem0
[458.233455] Dynamic subtest lmem0: SUCCESS (6.632s)
[458.234992] Subtest heavy-random: SUCCESS (6.635s)
[459.476293] [FACT gem_lmem_swapping (heavy-random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[459.477420] [FACT gem_lmem_swapping (heavy-random)] deleted: kernel.kmod_is_loaded.i915: true
[459.480191] [065/156] (575s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[464.360932] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[464.364350] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s)
[464.595374] [FACT kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[464.598884] [FACT kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)] new: kernel.kmod_is_loaded.i915: true
[464.603112] [066/156] (570s left) perf_pmu (render-node-busy-idle)
[464.668583] Starting subtest: render-node-busy-idle
[464.670094] Starting dynamic subtest: rcs0
[465.386857] Dynamic subtest rcs0: SUCCESS (0.716s)
[465.406424] Starting dynamic subtest: bcs0
[466.051546] Dynamic subtest bcs0: SUCCESS (0.660s)
[466.064867] Starting dynamic subtest: vcs0
[466.712717] Dynamic subtest vcs0: SUCCESS (0.659s)
[466.726817] Starting dynamic subtest: vcs1
[467.365937] Dynamic subtest vcs1: SUCCESS (0.652s)
[467.378907] Starting dynamic subtest: vecs0
[468.028539] Dynamic subtest vecs0: SUCCESS (0.659s)
[468.030474] Subtest render-node-busy-idle: SUCCESS (3.358s)
[468.142928] [067/156] (567s left) kms_invalid_mode (bad-vsync-start)
[470.118577] Starting subtest: bad-vsync-start
[470.120149] Starting dynamic subtest: pipe-A-HDMI-A-4
[470.167482] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.048s)
[470.181513] Starting dynamic subtest: pipe-B-HDMI-A-4
[470.183369] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.001s)
[470.196782] Starting dynamic subtest: pipe-C-HDMI-A-4
[470.199126] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.001s)
[470.213137] Starting dynamic subtest: pipe-D-HDMI-A-4
[470.214678] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.001s)
[470.216201] Subtest bad-vsync-start: SUCCESS (0.059s)
[470.377869] [068/156] (565s left) gem_exec_schedule (u-submit-late-slice)
[470.461772] Starting subtest: u-submit-late-slice
[470.463442] Starting dynamic subtest: rcs0
[470.524082] Dynamic subtest rcs0: SUCCESS (0.062s)
[470.539556] Starting dynamic subtest: bcs0
[470.568849] Dynamic subtest bcs0: SUCCESS (0.044s)
[470.583629] Starting dynamic subtest: vcs0
[470.612806] Dynamic subtest vcs0: SUCCESS (0.042s)
[470.626947] Starting dynamic subtest: vcs1
[470.656725] Dynamic subtest vcs1: SUCCESS (0.043s)
[470.671596] Starting dynamic subtest: vecs0
[470.701049] Dynamic subtest vecs0: SUCCESS (0.043s)
[470.703181] Subtest u-submit-late-slice: SUCCESS (0.240s)
[471.158664] [069/156] (564s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[472.669631] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[472.672808] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[472.841595] [070/156] (562s left) gem_pwrite (basic-exhaustion)
[472.894779] Subtest basic-exhaustion: SKIP (0.000s)
[472.979364] [071/156] (562s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt)
[474.482405] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt
[474.485825] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[474.666578] [072/156] (561s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[476.168309] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[476.171405] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[476.346848] [073/156] (559s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[477.844994] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[477.848119] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[477.957272] [074/156] (558s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[479.461372] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[479.549847] [075/156] (556s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[481.042762] Starting subtest: async-flip-with-page-flip-events-linear
[481.307823] Starting dynamic subtest: pipe-A-HDMI-A-4
[483.637857] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.327s)
[483.846860] Starting dynamic subtest: pipe-B-HDMI-A-4
[485.914145] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (2.078s)
[486.121562] Starting dynamic subtest: pipe-C-HDMI-A-4
[488.193112] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (2.083s)
[488.395395] Starting dynamic subtest: pipe-D-HDMI-A-4
[490.467252] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.082s)
[490.469617] Subtest async-flip-with-page-flip-events-linear: SUCCESS (9.423s)
[490.863435] [076/156] (545s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[492.378544] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[492.382204] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[492.565328] [077/156] (543s left) sw_sync (alloc_merge_fence)
[492.613286] Starting subtest: alloc_merge_fence
[492.614577] Subtest alloc_merge_fence: SUCCESS (0.000s)
[492.720584] [078/156] (543s left) gem_ctx_persistence (legacy-engines-hang)
[492.778009] Starting subtest: legacy-engines-hang
[492.779418] Starting dynamic subtest: render
[492.836349] Dynamic subtest render: SUCCESS (0.059s)
[492.854768] Starting dynamic subtest: bsd1
[492.928469] Dynamic subtest bsd1: SUCCESS (0.089s)
[492.978675] Starting dynamic subtest: bsd2
[492.995240] Dynamic subtest bsd2: SUCCESS (0.060s)
[493.013789] Starting dynamic subtest: blt
[493.083886] Dynamic subtest blt: SUCCESS (0.086s)
[493.133221] Starting dynamic subtest: vebox
[493.142328] Dynamic subtest vebox: SUCCESS (0.054s)
[493.144119] Subtest legacy-engines-hang: SUCCESS (0.367s)
[493.293195] [079/156] (543s left) gem_fence_thrash (bo-write-verify-threaded-y)
[493.340237] Starting subtest: bo-write-verify-threaded-y
[493.345437] Subtest bo-write-verify-threaded-y: SKIP (0.003s)
[493.492419] [080/156] (543s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[494.992847] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[494.995748] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[495.154277] [081/156] (541s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-indfb-fliptrack-mmap-gtt)
[496.658450] Starting subtest: fbcpsrhdr-2p-indfb-fliptrack-mmap-gtt
[496.661296] Subtest fbcpsrhdr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[496.821614] [082/156] (539s left) i915_hangman (gt-error-state-capture)
[496.889570] Starting subtest: gt-error-state-capture
[496.891149] Starting dynamic subtest: rcs0
[506.744675] Dynamic subtest rcs0: SUCCESS (9.856s)
[506.766519] Starting dynamic subtest: bcs0
[516.699092] Dynamic subtest bcs0: SUCCESS (9.955s)
[516.714849] Starting dynamic subtest: vcs0
[525.714683] Dynamic subtest vcs0: SUCCESS (9.015s)
[525.730625] Starting dynamic subtest: vcs1
[535.699326] Dynamic subtest vcs1: SUCCESS (9.983s)
[535.714432] Starting dynamic subtest: vecs0
[545.753412] Dynamic subtest vecs0: SUCCESS (10.051s)
[545.754943] Subtest gt-error-state-capture: SUCCESS (48.869s)
[545.944989] [083/156] (490s left) kms_prop_blob (blob-prop-lifetime)
[545.996301] Starting subtest: blob-prop-lifetime
[545.997819] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[546.132570] [084/156] (490s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[547.627862] Starting subtest: cursorA-vs-flipB-legacy
[547.630753] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[547.780485] [085/156] (489s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[549.285139] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[549.288619] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[549.467613] [086/156] (487s left) kms_cursor_crc (cursor-random-512x512)
[551.238913] Starting subtest: cursor-random-512x512
[551.241892] Subtest cursor-random-512x512: SKIP (0.001s)
[551.486933] [087/156] (485s left) gem_ctx_bad_destroy (invalid-ctx)
[551.536318] Starting subtest: invalid-ctx
[551.537969] Subtest invalid-ctx: SUCCESS (0.000s)
[551.659891] [088/156] (485s left) syncobj_timeline (multi-wait-for-submit-signaled)
[551.711662] Starting subtest: multi-wait-for-submit-signaled
[551.713499] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[551.822334] [089/156] (485s left) kms_pm_rpm (modeset-lpsp)
[555.756638] Starting subtest: modeset-lpsp
[556.758433] Subtest modeset-lpsp: SKIP (1.002s)
[557.853273] [090/156] (479s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[559.353558] Starting subtest: plane-upscale-20x20-with-rotation
[559.355320] Starting dynamic subtest: pipe-A
[559.800222] Dynamic subtest pipe-A: SKIP (0.440s)
[559.815213] Starting dynamic subtest: pipe-B
[560.258595] Dynamic subtest pipe-B: SKIP (0.457s)
[560.273612] Starting dynamic subtest: pipe-C
[560.732939] Dynamic subtest pipe-C: SKIP (0.474s)
[560.747545] Starting dynamic subtest: pipe-D
[561.189404] Dynamic subtest pipe-D: SKIP (0.455s)
[561.192581] Subtest plane-upscale-20x20-with-rotation: SKIP (1.832s)
[561.385930] [091/156] (476s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-onoff)
[562.892178] Starting subtest: hdr-2p-scndscrn-spr-indfb-onoff
[562.895218] Subtest hdr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[563.035865] [092/156] (474s left) kms_flip (2x-plain-flip)
[564.530074] Starting subtest: 2x-plain-flip
[564.548064] Subtest 2x-plain-flip: SKIP (0.017s)
[564.673097] [093/156] (473s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-wc)
[566.178681] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-wc
[566.181568] Subtest fbcpsrhdr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[566.370972] [094/156] (471s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[566.421534] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[566.528264] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s)
[566.765299] [095/156] (471s left) kms_content_protection (uevent-hdcp14)
[568.319166] Starting subtest: uevent-hdcp14
[568.325855] Subtest uevent-hdcp14: SKIP (0.002s)
[568.548714] [096/156] (469s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[568.606103] Subtest untiled-to-tiled: SKIP (0.000s)
[568.696614] [097/156] (469s left) gem_exec_schedule (pi-distinct-iova)
[568.902227] Starting subtest: pi-distinct-iova
[568.903773] Starting dynamic subtest: rcs0
[569.073895] Dynamic subtest rcs0: SUCCESS (0.169s)
[569.088861] Starting dynamic subtest: bcs0
[569.180883] Dynamic subtest bcs0: SUCCESS (0.108s)
[569.196216] Starting dynamic subtest: vcs0
[569.307312] Dynamic subtest vcs0: SUCCESS (0.122s)
[569.322452] Starting dynamic subtest: vcs1
[569.428468] Dynamic subtest vcs1: SUCCESS (0.122s)
[569.443797] Starting dynamic subtest: vecs0
[569.555915] Dynamic subtest vecs0: SUCCESS (0.123s)
[569.557713] Subtest pi-distinct-iova: SUCCESS (0.652s)
[569.890337] [098/156] (468s left) kms_lease (page-flip-implicit-plane)
[571.384839] Starting subtest: page-flip-implicit-plane
[571.386332] Starting dynamic subtest: pipe-A-HDMI-A-4
[571.805101] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.421s)
[571.823169] Starting dynamic subtest: pipe-B-HDMI-A-4
[572.085935] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.277s)
[572.102970] Starting dynamic subtest: pipe-C-HDMI-A-4
[572.367195] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.279s)
[572.386258] Starting dynamic subtest: pipe-D-HDMI-A-4
[572.641730] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.270s)
[572.643294] Subtest page-flip-implicit-plane: SUCCESS (1.257s)
[572.849998] [099/156] (465s left) i915_suspend (basic-s3-without-i915)
[572.901324] Starting subtest: basic-s3-without-i915
[598.633147] Subtest basic-s3-without-i915: SUCCESS (14.052s)
[600.756802] [100/156] (439s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[602.314981] Starting subtest: read-crc-frame-sequence
[602.319293] Starting dynamic subtest: pipe-A-HDMI-A-4
[602.949122] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.610s)
[602.966436] Starting dynamic subtest: pipe-B-HDMI-A-4
[603.511133] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.542s)
[603.527859] Starting dynamic subtest: pipe-C-HDMI-A-4
[603.993253] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.465s)
[604.009786] Starting dynamic subtest: pipe-D-HDMI-A-4
[604.571125] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.558s)
[604.575119] Subtest read-crc-frame-sequence: SUCCESS (2.185s)
[604.790516] [101/156] (435s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[607.128104] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[607.129651] Starting dynamic subtest: pipe-A-HDMI-A-4
[607.147321] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[607.162166] Starting dynamic subtest: pipe-B-HDMI-A-4
[607.177279] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[607.191503] Starting dynamic subtest: pipe-C-HDMI-A-4
[607.206842] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[607.221005] Starting dynamic subtest: pipe-D-HDMI-A-4
[607.240888] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[607.244154] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SKIP (0.010s)
[607.440041] [102/156] (433s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-pwrite)
[608.971844] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-pwrite
[608.975717] Subtest hdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[609.197336] [103/156] (431s left) prime_mmap_coherency (read)
[609.259868] Starting subtest: read
[614.720335] Subtest read: SUCCESS (5.399s)
[614.880586] [104/156] (425s left) kms_color (ctm-negative)
[616.382759] Starting subtest: ctm-negative
[616.384409] Starting dynamic subtest: pipe-A-HDMI-A-4
[617.087652] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.700s)
[617.102245] Starting dynamic subtest: pipe-B-HDMI-A-4
[617.616834] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.525s)
[617.631124] Starting dynamic subtest: pipe-C-HDMI-A-4
[618.142950] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.521s)
[618.157392] Starting dynamic subtest: pipe-D-HDMI-A-4
[618.711072] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.563s)
[618.712843] Subtest ctm-negative: SUCCESS (2.315s)
[618.922891] [105/156] (421s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[620.430232] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[620.433519] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[620.595499] [106/156] (420s left) dmabuf_sync_file (export-multiwait)
[620.655654] Starting subtest: export-multiwait
[620.657423] Subtest export-multiwait: SUCCESS (0.000s)
[620.787759] [107/156] (420s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[622.308648] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[622.894009] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.584s)
[623.153710] [108/156] (418s left) gem_exec_balancer (noheartbeat)
[623.528842] Starting subtest: noheartbeat
[623.531834] Subtest noheartbeat: SKIP (0.000s)
[623.649709] [109/156] (417s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[625.163715] Starting subtest: yf-tiled-64bpp-rotate-180
[625.166589] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[625.351388] [110/156] (416s left) syncobj_timeline (single-wait-available-submitted)
[625.408382] Starting subtest: single-wait-available-submitted
[625.411851] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[625.540355] [111/156] (415s left) kms_flip (modeset-vs-vblank-race)
[627.036975] Starting subtest: modeset-vs-vblank-race
[627.043643] Starting dynamic subtest: A-HDMI-A4
[630.101019] Dynamic subtest A-HDMI-A4: SUCCESS (3.052s)
[630.119240] Starting dynamic subtest: B-HDMI-A4
[633.094655] Dynamic subtest B-HDMI-A4: SUCCESS (2.987s)
[633.115385] Starting dynamic subtest: C-HDMI-A4
[636.123277] Dynamic subtest C-HDMI-A4: SUCCESS (3.026s)
[636.141233] Starting dynamic subtest: D-HDMI-A4
[639.112222] Dynamic subtest D-HDMI-A4: SUCCESS (2.986s)
[639.113797] Subtest modeset-vs-vblank-race: SUCCESS (12.068s)
[639.447628] [112/156] (402s left) kms_frontbuffer_tracking (psr-1p-rte)
[640.966461] Starting subtest: psr-1p-rte
[640.979712] Subtest psr-1p-rte: SKIP (0.000s)
[641.163105] [113/156] (400s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[642.664361] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[642.667195] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[642.833580] [114/156] (399s left) prime_self_import (basic-llseek-bad)
[642.883515] Starting subtest: basic-llseek-bad
[642.886500] Subtest basic-llseek-bad: SUCCESS (0.003s)
[643.069432] [115/156] (398s left) kms_big_fb (linear-8bpp-rotate-180)
[644.584286] Starting subtest: linear-8bpp-rotate-180
[646.257245] Subtest linear-8bpp-rotate-180: SUCCESS (1.673s)
[646.465108] [116/156] (395s left) kms_dp_linktrain_fallback (dsc-fallback)
[647.960416] Starting subtest: dsc-fallback
[647.964329] Subtest dsc-fallback: SKIP (0.000s)
[648.083823] [117/156] (394s left) gem_exec_capture (userptr)
[648.159690] Starting subtest: userptr
[649.072286] Subtest userptr: SUCCESS (0.914s)
[649.256158] [118/156] (393s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[650.756587] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[650.771495] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[650.931726] [119/156] (391s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-pgflip-blt)
[652.433244] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-pgflip-blt
[652.435861] Subtest fbcpsrhdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[652.595644] [120/156] (389s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-linear)
[654.097712] Starting subtest: fbcpsrhdr-tiling-linear
[654.100875] Subtest fbcpsrhdr-tiling-linear: SKIP (0.000s)
[654.266438] [121/156] (388s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[655.764037] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[655.765850] Starting dynamic subtest: pipe-A-HDMI-A-4
[655.775503] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[655.790823] Starting dynamic subtest: pipe-B-HDMI-A-4
[655.798478] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[655.813295] Starting dynamic subtest: pipe-C-HDMI-A-4
[655.820546] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[655.835165] Starting dynamic subtest: pipe-D-HDMI-A-4
[655.842572] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[655.846341] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SKIP (0.011s)
[656.072763] [122/156] (386s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[657.569556] Starting subtest: cursor-vs-flip-varying-size
[692.794063] Subtest cursor-vs-flip-varying-size: SUCCESS (35.211s)
[693.060953] [123/156] (349s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[693.111756] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[693.213864] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[693.389662] [124/156] (349s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[694.889755] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[694.892941] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[695.062258] [125/156] (347s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[696.566582] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[696.570332] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[696.751133] [126/156] (346s left) api_intel_allocator (reopen-fork)
[696.802232] Starting subtest: reopen-fork
[700.073440] Subtest reopen-fork: SUCCESS (3.270s)
[700.228397] [127/156] (342s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite)
[701.738182] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite
[701.741301] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[701.919136] [128/156] (341s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[703.420508] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[703.424023] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[703.609252] [129/156] (339s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-render)
[705.109167] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-render
[705.112163] Subtest hdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[705.273042] [130/156] (338s left) perf (gen12-group-concurrent-oa-buffer-read)
[705.438457] Starting subtest: gen12-group-concurrent-oa-buffer-read
[715.498151] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.061s)
[715.582317] [131/156] (328s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[717.076007] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[717.079065] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[717.232870] [132/156] (326s left) gem_ctx_persistence (engines-hang)
[717.288643] Starting subtest: engines-hang
[717.290303] Starting dynamic subtest: rcs0
[717.350400] Dynamic subtest rcs0: SUCCESS (0.061s)
[717.365438] Starting dynamic subtest: bcs0
[717.444855] Dynamic subtest bcs0: SUCCESS (0.092s)
[717.502127] Starting dynamic subtest: vcs0
[717.514385] Dynamic subtest vcs0: SUCCESS (0.063s)
[717.533554] Starting dynamic subtest: vcs1
[717.610995] Dynamic subtest vcs1: SUCCESS (0.094s)
[717.666702] Starting dynamic subtest: vecs0
[717.677479] Dynamic subtest vecs0: SUCCESS (0.062s)
[717.679366] Subtest engines-hang: SUCCESS (0.390s)
[717.889865] [133/156] (325s left) kms_cursor_crc (cursor-suspend)
[719.448763] Starting subtest: cursor-suspend
[719.452715] Starting dynamic subtest: pipe-A-HDMI-A-4
[762.619779] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (20.805s)
[762.637985] Starting dynamic subtest: pipe-D-HDMI-A-4
[806.589303] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (20.370s)
[806.590798] Subtest cursor-suspend: SUCCESS (41.180s)
[812.102539] [134/156] (236s left) kms_properties (plane-properties-atomic)
[813.598318] Starting subtest: plane-properties-atomic
[813.602267] Starting dynamic subtest: pipe-A-HDMI-A-4
[814.069861] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.470s)
[814.087375] Starting dynamic subtest: pipe-B-HDMI-A-4
[814.534060] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.461s)
[814.550330] Starting dynamic subtest: pipe-C-HDMI-A-4
[815.002228] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.465s)
[815.017512] Starting dynamic subtest: pipe-D-HDMI-A-4
[815.471400] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.467s)
[815.472978] Subtest plane-properties-atomic: SUCCESS (1.872s)
[815.735474] [135/156] (233s left) gem_ctx_shared (q-independent)
[815.801713] Starting subtest: Q-independent
[815.803229] Starting dynamic subtest: rcs0
[815.954442] Dynamic subtest rcs0: SUCCESS (0.152s)
[815.969817] Starting dynamic subtest: bcs0
[816.047447] Dynamic subtest bcs0: SUCCESS (0.091s)
[816.062850] Starting dynamic subtest: vcs0
[816.143911] Dynamic subtest vcs0: SUCCESS (0.095s)
[816.161634] Starting dynamic subtest: vcs1
[816.242915] Dynamic subtest vcs1: SUCCESS (0.097s)
[816.260183] Starting dynamic subtest: vecs0
[816.350760] Dynamic subtest vecs0: SUCCESS (0.106s)
[816.352082] Subtest Q-independent: SUCCESS (0.550s)
[816.800204] [136/156] (232s left) kms_psr (fbc-psr-sprite-plane-move)
[819.410137] Subtest fbc-psr-sprite-plane-move: SKIP (0.000s)
[819.491435] [137/156] (229s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-indfb-plflip-blt)
[821.491914] Starting subtest: fbchdr-2p-scndscrn-indfb-plflip-blt
[821.495477] Subtest fbchdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[821.673011] [138/156] (227s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[823.198087] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[823.201341] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[823.442102] [139/156] (226s left) kms_psr (pr-sprite-render)
[824.939412] Subtest pr-sprite-render: SKIP (0.000s)
[825.026714] [140/156] (224s left) gem_fence_thrash (bo-write-verify-y)
[825.073850] Starting subtest: bo-write-verify-y
[825.079830] Subtest bo-write-verify-y: SKIP (0.002s)
[825.159224] [141/156] (224s left) gem_watchdog (default-virtual)
[825.249734] Starting subtest: default-virtual
[830.564057] Subtest default-virtual: SUCCESS (5.312s)
[830.694364] [142/156] (219s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-onoff)
[832.197538] Starting subtest: psrhdr-2p-primscrn-cur-indfb-onoff
[832.201147] Subtest psrhdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[832.379417] [143/156] (217s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[832.433833] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[832.546856] [144/156] (217s left) gem_pxp (reject-modify-context-protection-off-2)
[835.116861] Starting subtest: reject-modify-context-protection-off-2
[835.119802] Subtest reject-modify-context-protection-off-2: SKIP (0.000s)
[835.244844] [145/156] (214s left) gem_mmap_gtt (flink-race)
[835.294616] Subtest flink-race: SKIP (0.000s)
[835.378911] [146/156] (214s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[836.871820] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[836.873172] Starting dynamic subtest: pipe-A-HDMI-A-4
[836.886591] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[836.901975] Starting dynamic subtest: pipe-B-HDMI-A-4
[836.915141] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[836.929803] Starting dynamic subtest: pipe-C-HDMI-A-4
[836.943832] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[836.959137] Starting dynamic subtest: pipe-D-HDMI-A-4
[836.978862] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[836.982148] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SKIP (0.010s)
[837.193242] [147/156] (212s left) kms_cursor_crc (cursor-onscreen-64x64)
[838.817281] Starting subtest: cursor-onscreen-64x64
[838.824367] Starting dynamic subtest: pipe-A-HDMI-A-4
[841.484090] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.657s)
[841.521355] Starting dynamic subtest: pipe-D-HDMI-A-4
[843.945642] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.437s)
[843.947182] Subtest cursor-onscreen-64x64: SUCCESS (5.127s)
[844.478484] [148/156] (205s left) gem_mmap_wc (write)
[844.528696] Subtest write: SKIP (0.000s)
[844.606415] [149/156] (205s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[844.664067] Starting subtest: y-tiled-to-vebox-y-tiled
[844.665657] Starting dynamic subtest: smem
[844.747466] Dynamic subtest smem: SUCCESS (0.083s)
[844.762469] Starting dynamic subtest: lmem0
[845.497315] Dynamic subtest lmem0: SUCCESS (0.748s)
[845.498781] Subtest y-tiled-to-vebox-y-tiled: SUCCESS (0.834s)
[845.822011] [150/156] (204s left) i915_drm_fdinfo (virtual-busy)
[845.873362] Starting subtest: virtual-busy
[845.876481] Subtest virtual-busy: SKIP (0.000s)
[846.015624] [151/156] (204s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[847.509451] Starting subtest: primary-y-tiled-reflect-x-180
[858.117032] Subtest primary-y-tiled-reflect-x-180: SUCCESS (10.610s)
[858.429205] [152/156] (192s left) gem_userptr_blits (stress-mm-invalidate-close)
[858.493479] Starting subtest: stress-mm-invalidate-close
[860.641758] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[860.809435] [153/156] (189s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-shrfb-pgflip-blt)
[862.321211] Starting subtest: psrhdr-2p-primscrn-shrfb-pgflip-blt
[862.324901] Subtest psrhdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[862.488850] [154/156] (188s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[863.988741] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[863.991269] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[864.176262] [155/156] (186s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[865.678467] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[865.682306] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[865.850379] [156/156] (185s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[867.356544] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc
[867.360339] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[867.536818] Closing watchdogs
results: parsing output: 0/ for test: kms_chamelium_frames
results: parsing output: 1/ for test: syncobj_wait
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: kms_cursor_legacy
results: parsing output: 9/ for test: kms_vblank
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: kms_draw_crc
results: parsing output: 15/ for test: kms_plane_scaling
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_psr2_sf
results: parsing output: 20/ for test: syncobj_wait
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_tiled_blits
results: parsing output: 23/ for test: gem_exec_balancer
results: parsing output: 24/ for test: kms_chamelium_color
results: parsing output: 25/ for test: gem_barrier_race
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: gem_ctx_exec
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: gem_exec_gttfill
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_exec_schedule
results: parsing output: 32/ for test: gem_ctx_bad_destroy
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_eio
results: parsing output: 35/ for test: kms_getfb
results: parsing output: 36/ for test: api_intel_bb
results: parsing output: 37/ for test: kms_chamelium_hpd
results: parsing output: 38/ for test: syncobj_wait
results: parsing output: 39/ for test: gem_exec_reloc
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: kms_flip_scaled_crc
results: parsing output: 42/ for test: gem_spin_batch
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: gem_exec_fence
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_vblank
results: parsing output: 48/ for test: gen3_render_tiledx_blits
results: parsing output: 49/ for test: gen9_exec_parse
results: parsing output: 50/ for test: kms_async_flips
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_mmap_gtt
results: parsing output: 53/ for test: sysfs_heartbeat_interval
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: syncobj_wait
results: parsing output: 56/ for test: syncobj_eventfd
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_readwrite
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: syncobj_basic
results: parsing output: 61/ for test: i915_pm_rpm
results: parsing output: 62/ for test: syncobj_basic
results: parsing output: 63/ for test: gem_lmem_swapping
results: parsing output: 64/ for test: kms_plane
results: parsing output: 65/ for test: perf_pmu
results: parsing output: 66/ for test: kms_invalid_mode
results: parsing output: 67/ for test: gem_exec_schedule
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_pwrite
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_flip_scaled_crc
results: parsing output: 73/ for test: kms_psr2_sf
results: parsing output: 74/ for test: kms_async_flips
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: sw_sync
results: parsing output: 77/ for test: gem_ctx_persistence
results: parsing output: 78/ for test: gem_fence_thrash
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: i915_hangman
results: parsing output: 82/ for test: kms_prop_blob
results: parsing output: 83/ for test: kms_cursor_legacy
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_cursor_crc
results: parsing output: 86/ for test: gem_ctx_bad_destroy
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: kms_pm_rpm
results: parsing output: 89/ for test: kms_plane_scaling
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_content_protection
results: parsing output: 95/ for test: gem_set_tiling_vs_blt
results: parsing output: 96/ for test: gem_exec_schedule
results: parsing output: 97/ for test: kms_lease
results: parsing output: 98/ for test: i915_suspend
results: parsing output: 99/ for test: kms_pipe_crc_basic
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: prime_mmap_coherency
results: parsing output: 103/ for test: kms_color
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: dmabuf_sync_file
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: gem_exec_balancer
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: prime_self_import
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: kms_dp_linktrain_fallback
results: parsing output: 116/ for test: gem_exec_capture
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: kms_cursor_legacy
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: api_intel_allocator
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: perf
results: parsing output: 130/ for test: kms_plane
results: parsing output: 131/ for test: gem_ctx_persistence
results: parsing output: 132/ for test: kms_cursor_crc
results: parsing output: 133/ for test: kms_properties
results: parsing output: 134/ for test: gem_ctx_shared
results: parsing output: 135/ for test: kms_psr
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: kms_psr
results: parsing output: 139/ for test: gem_fence_thrash
results: parsing output: 140/ for test: gem_watchdog
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: gem_exec_reloc
results: parsing output: 143/ for test: gem_pxp
results: parsing output: 144/ for test: gem_mmap_gtt
results: parsing output: 145/ for test: kms_ccs
results: parsing output: 146/ for test: kms_cursor_crc
results: parsing output: 147/ for test: gem_mmap_wc
results: parsing output: 148/ for test: gem_render_copy
results: parsing output: 149/ for test: i915_drm_fdinfo
results: parsing output: 150/ for test: kms_rotation_crc
results: parsing output: 151/ for test: gem_userptr_blits
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: kms_frontbuffer_tracking
results: parsing output: 155/ for test: kms_frontbuffer_tracking
Done.