[62.530063] Initializing watchdogs
[62.530113]   /dev/watchdog0
[62.544229] [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.548699] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.551613] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.554879] [001/133] (960s left) gem_exec_schedule (u-fairslice-all)
[62.653025] Starting subtest: u-fairslice-all
[64.729161] Subtest u-fairslice-all: SUCCESS (2.082s)
[66.315737] [002/133] (956s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[66.712075] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[67.543254] [003/133] (955s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[67.648875] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[67.652982] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[67.747091] [004/133] (955s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[67.855244] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[71.843074] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (3.996s)
[73.085715] [005/133] (950s left) kms_setmode (invalid-clone-single-crtc-stealing)
[73.214389] Starting subtest: invalid-clone-single-crtc-stealing
[73.221404] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[73.330092] [006/133] (949s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[73.462093] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[73.464471] Starting dynamic subtest: pipe-A-eDP-1
[73.929722] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.442s)
[73.937578] Starting dynamic subtest: pipe-B-eDP-1
[75.378778] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.448s)
[75.386809] Starting dynamic subtest: pipe-C-eDP-1
[76.761175] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.381s)
[76.770588] Starting dynamic subtest: pipe-D-eDP-1
[78.096113] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.337s)
[78.098188] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.611s)
[79.279270] [007/133] (944s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[79.371512] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[79.375973] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[79.443230] [008/133] (943s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[79.543370] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[86.630395] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.094s)
[86.750828] [009/133] (936s left) gem_pread (self)
[86.816808] Subtest self: SKIP (0.000s)
[86.879998] [010/133] (936s left) kms_frontbuffer_tracking (psr-suspend)
[86.983754] Starting subtest: psr-suspend
[125.894969] Subtest psr-suspend: SUCCESS (8.874s)
[126.005445] [011/133] (897s left) kms_flip (basic-flip-vs-dpms)
[126.128531] Starting subtest: basic-flip-vs-dpms
[126.130448] Starting dynamic subtest: A-eDP1
[128.766118] Dynamic subtest A-eDP1: SUCCESS (2.641s)
[128.776056] Starting dynamic subtest: B-eDP1
[130.940420] Dynamic subtest B-eDP1: SUCCESS (2.175s)
[130.950991] Starting dynamic subtest: C-eDP1
[133.006523] Dynamic subtest C-eDP1: SUCCESS (2.069s)
[133.016444] Starting dynamic subtest: D-eDP1
[135.071993] Dynamic subtest D-eDP1: SUCCESS (2.065s)
[135.077487] Subtest basic-flip-vs-dpms: SUCCESS (8.961s)
[135.878103] [012/133] (887s left) kms_cdclk (mode-transition-all-outputs)
[135.983515] Starting subtest: mode-transition-all-outputs
[136.272018] Subtest mode-transition-all-outputs: SKIP (0.288s)
[137.096026] [013/133] (886s left) prime_mmap (test_dup)
[137.155236] Starting subtest: test_dup
[137.157196] Starting dynamic subtest: test_dup-smem
[137.188026] Dynamic subtest test_dup-smem: SUCCESS (0.034s)
[137.190499] Subtest test_dup: SUCCESS (0.035s)
[137.260249] [014/133] (886s left) kms_cursor_crc (cursor-suspend)
[137.386930] Starting subtest: cursor-suspend
[137.389265] Starting dynamic subtest: pipe-A-eDP-1
[169.844369] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.191s)
[169.854702] Starting dynamic subtest: pipe-D-eDP-1
[203.815757] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.726s)
[203.817954] Subtest cursor-suspend: SUCCESS (6.920s)
[204.657087] [015/133] (819s left) i915_hangman (engine-engine-hang)
[204.722041] Starting subtest: engine-engine-hang
[204.723968] Starting dynamic subtest: rcs0
[205.823716] Dynamic subtest rcs0: SUCCESS (1.101s)
[205.836186] Starting dynamic subtest: bcs0
[207.805416] Dynamic subtest bcs0: SUCCESS (1.980s)
[207.817122] Starting dynamic subtest: vcs0
[209.854599] Dynamic subtest vcs0: SUCCESS (2.048s)
[209.871776] Starting dynamic subtest: vcs1
[211.839946] Dynamic subtest vcs1: SUCCESS (1.983s)
[211.851479] Starting dynamic subtest: vecs0
[213.823984] Dynamic subtest vecs0: SUCCESS (1.983s)
[213.836182] Starting dynamic subtest: ccs0
[215.806962] Dynamic subtest ccs0: SUCCESS (1.982s)
[215.809882] Subtest engine-engine-hang: SUCCESS (11.092s)
[215.945492] [016/133] (807s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[216.049155] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[216.053744] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[216.156379] [017/133] (807s left) kms_vblank (ts-continuation-modeset-rpm)
[216.261333] Starting subtest: ts-continuation-modeset-rpm
[216.263638] Starting dynamic subtest: pipe-A-eDP-1
[218.844711] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.582s)
[218.859198] Starting dynamic subtest: pipe-D-eDP-1
[221.096108] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.251s)
[221.098171] Subtest ts-continuation-modeset-rpm: SUCCESS (4.837s)
[221.974333] [018/133] (801s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[222.082678] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[222.086713] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[222.179728] [019/133] (801s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[222.276063] Starting subtest: psr2-cursor-plane-update-sf
[222.278326] Starting dynamic subtest: pipe-A-eDP-1
[222.851755] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.578s)
[222.861905] Starting dynamic subtest: pipe-B-eDP-1
[224.178840] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.325s)
[224.180740] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.905s)
[225.061006] [020/133] (798s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[225.158960] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[225.546045] Starting dynamic subtest: pipe-A-eDP-1
[228.336007] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.790s)
[228.702043] Starting dynamic subtest: pipe-B-eDP-1
[231.461964] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.766s)
[231.829096] Starting dynamic subtest: pipe-C-eDP-1
[234.596005] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.777s)
[234.961634] Starting dynamic subtest: pipe-D-eDP-1
[237.717936] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.765s)
[237.720504] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.571s)
[238.898816] [021/133] (784s left) template (b)
[238.951271] Starting subtest: B
[238.953185] Subtest B: SUCCESS (0.000s)
[239.044767] [022/133] (784s left) gem_ctx_param (basic)
[239.107350] Starting subtest: basic
[239.109750] Subtest basic: SUCCESS (0.001s)
[239.242906] [023/133] (784s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[239.359759] Starting subtest: 4-tiled-16bpp-rotate-180
[240.603161] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.245s)
[240.742073] [024/133] (783s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[240.844713] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[240.846487] Starting dynamic subtest: pipe-A-eDP-1
[240.853834] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[240.863280] Starting dynamic subtest: pipe-B-eDP-1
[240.870986] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[240.879663] Starting dynamic subtest: pipe-C-eDP-1
[240.886710] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[240.897011] Starting dynamic subtest: pipe-D-eDP-1
[240.904094] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[240.907556] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[243.170104] [025/133] (780s left) syncobj_wait (invalid-reset-bad-pad)
[243.221928] Starting subtest: invalid-reset-bad-pad
[243.223970] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[243.309797] [026/133] (780s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[243.408391] Starting subtest: psr-indfb-scaledprimary
[249.115300] Subtest psr-indfb-scaledprimary: SUCCESS (5.715s)
[249.224982] [027/133] (774s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[249.332032] Starting subtest: 4-tiled-16bpp-rotate-270
[249.351332] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.019s)
[249.475311] [028/133] (774s left) kms_draw_crc (draw-method-pwrite)
[249.561307] Starting subtest: draw-method-pwrite
[249.563205] Starting dynamic subtest: xrgb8888-untiled
[250.225508] Dynamic subtest xrgb8888-untiled: SUCCESS (0.667s)
[250.234598] Starting dynamic subtest: rgb565-untiled
[250.747148] Dynamic subtest rgb565-untiled: SUCCESS (0.521s)
[250.756022] Starting dynamic subtest: xrgb2101010-untiled
[251.413623] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.666s)
[251.422704] Starting dynamic subtest: xbgr16161616f-untiled
[252.257723] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.843s)
[252.266993] Starting dynamic subtest: xrgb8888-xtiled
[254.401620] Dynamic subtest xrgb8888-xtiled: SUCCESS (2.144s)
[254.410504] Starting dynamic subtest: rgb565-xtiled
[255.799929] Dynamic subtest rgb565-xtiled: SUCCESS (1.397s)
[255.810459] Starting dynamic subtest: xrgb2101010-xtiled
[257.954394] Dynamic subtest xrgb2101010-xtiled: SUCCESS (2.155s)
[257.963789] Starting dynamic subtest: xbgr16161616f-xtiled
[261.774867] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.821s)
[261.786876] Starting dynamic subtest: xrgb8888-4tiled
[263.084798] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.310s)
[263.094160] Starting dynamic subtest: rgb565-4tiled
[263.839908] Dynamic subtest rgb565-4tiled: SUCCESS (0.755s)
[263.849514] Starting dynamic subtest: xrgb2101010-4tiled
[265.272423] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.431s)
[265.281659] Starting dynamic subtest: xbgr16161616f-4tiled
[268.684399] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.410s)
[268.686746] Subtest draw-method-pwrite: SUCCESS (19.134s)
[268.781448] [029/133] (755s left) gem_ccs (ctrl-surf-copy)
[268.839092] Starting subtest: ctrl-surf-copy
[268.843752] Subtest ctrl-surf-copy: SKIP (0.000s)
[268.940747] [030/133] (755s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[269.169121] Starting subtest: cursor-rapid-movement-128x42
[269.213116] Subtest cursor-rapid-movement-128x42: SKIP (0.042s)
[269.417028] [031/133] (754s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[269.514981] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[269.519049] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[269.594430] [032/133] (754s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[269.647354] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[269.649025] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[269.768880] [033/133] (754s left) gem_exec_reloc (basic-gtt-cpu-active)
[269.828477] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[269.894941] [034/133] (754s left) gem_tiled_pread_pwrite
[270.012492] [035/133] (754s left) kms_psr (fbc-pr-sprite-blt)
[270.121289] Starting subtest: fbc-pr-sprite-blt
[270.125161] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[270.201744] [036/133] (754s left) kms_psr (fbc-psr-primary-page-flip)
[270.294895] Starting subtest: fbc-psr-primary-page-flip
[270.296834] Starting dynamic subtest: eDP-1
[270.300257] Dynamic subtest eDP-1: SKIP (0.000s)
[270.303810] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[270.366847] [037/133] (754s left) kms_pipe_stress (stress-xrgb8888-4tiled)
[270.462388] Starting subtest: stress-xrgb8888-4tiled
[276.348728] Subtest stress-xrgb8888-4tiled: SUCCESS (5.884s)
[276.408724] [038/133] (748s left) kms_hdr (invalid-hdr)
[276.513471] Starting subtest: invalid-hdr
[278.573485] Starting dynamic subtest: pipe-A-eDP-1
[281.588047] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.011s)
[281.590615] Subtest invalid-hdr: SUCCESS (5.073s)
[281.715820] [039/133] (742s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[282.121770] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[282.905434] [040/133] (741s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[283.016293] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[284.106125] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.090s)
[284.229892] [041/133] (740s left) perf_pmu (busy-accuracy-2)
[284.271620] Starting subtest: busy-accuracy-2
[284.273598] Starting dynamic subtest: rcs0
[287.315069] Dynamic subtest rcs0: SUCCESS (3.039s)
[287.325258] Starting dynamic subtest: bcs0
[290.374673] Dynamic subtest bcs0: SUCCESS (3.058s)
[290.385156] Starting dynamic subtest: vcs0
[293.420425] Dynamic subtest vcs0: SUCCESS (3.044s)
[293.430050] Starting dynamic subtest: vcs1
[296.466689] Dynamic subtest vcs1: SUCCESS (3.044s)
[296.476883] Starting dynamic subtest: vecs0
[299.512303] Dynamic subtest vecs0: SUCCESS (3.045s)
[299.522545] Starting dynamic subtest: ccs0
[302.574280] Dynamic subtest ccs0: SUCCESS (3.061s)
[302.576729] Subtest busy-accuracy-2: SUCCESS (18.304s)
[302.690120] [042/133] (722s left) gem_mmap_gtt (fault-concurrent)
[302.755210] Subtest fault-concurrent: SKIP (0.000s)
[302.825060] [043/133] (721s left) gem_lmem_swapping (verify-random-ccs)
[302.868276] Subtest verify-random-ccs: SKIP (0.000s)
[302.914858] [044/133] (721s left) gem_mmap_offset (partial-unmap)
[302.977691] Starting subtest: partial-unmap
[302.979643] Starting dynamic subtest: smem0
[303.475215] Dynamic subtest smem0: SUCCESS (0.496s)
[303.478066] Subtest partial-unmap: SUCCESS (0.498s)
[303.604859] [045/133] (721s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[303.713034] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[310.384402] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.677s)
[310.513755] [046/133] (714s left) gem_exec_fence (syncobj-timeline-wait)
[311.196711] Starting subtest: syncobj-timeline-wait
[312.878262] Subtest syncobj-timeline-wait: SUCCESS (1.685s)
[313.127931] [FACT gem_exec_fence (syncobj-timeline-wait)] new: kernel.kmod_is_loaded.vgem: true
[313.131804] [047/133] (711s left) gem_ctx_param (invalid-param-get)
[313.204658] Starting subtest: invalid-param-get
[313.207134] Subtest invalid-param-get: SUCCESS (0.002s)
[313.312894] [048/133] (711s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[313.421715] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[313.426216] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[313.529678] [049/133] (711s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[313.625455] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[318.284323] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.663s)
[319.459110] [050/133] (705s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[319.584401] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[319.588817] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[319.733190] [051/133] (705s left) gem_exec_flush (basic-uc-pro-default)
[319.785698] Starting subtest: basic-uc-pro-default
[325.270743] Subtest basic-uc-pro-default: SUCCESS (5.487s)
[325.460757] [052/133] (699s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[325.573766] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[325.577993] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[325.668864] [053/133] (699s left) perf (i915-ref-count)
[325.738022] Starting subtest: i915-ref-count
[325.809092] Subtest i915-ref-count: SUCCESS (0.070s)
[325.867865] [054/133] (699s left) gem_exec_params (rel-constants-invalid)
[325.936189] Starting subtest: rel-constants-invalid
[325.938415] Subtest rel-constants-invalid: SUCCESS (0.000s)
[326.036250] [055/133] (699s left) gem_reg_read (timestamp-monotonic)
[326.104701] Starting subtest: timestamp-monotonic
[330.795690] Subtest timestamp-monotonic: SUCCESS (4.693s)
[330.871810] [056/133] (694s left) kms_flip (flip-vs-rmfb)
[330.968414] Starting subtest: flip-vs-rmfb
[330.970659] Starting dynamic subtest: A-eDP1
[339.629291] Dynamic subtest A-eDP1: SUCCESS (8.656s)
[339.640874] Starting dynamic subtest: B-eDP1
[348.264684] Dynamic subtest B-eDP1: SUCCESS (8.630s)
[348.276386] Starting dynamic subtest: C-eDP1
[356.879750] Dynamic subtest C-eDP1: SUCCESS (8.612s)
[356.892782] Starting dynamic subtest: D-eDP1
[365.513622] Dynamic subtest D-eDP1: SUCCESS (8.631s)
[365.517983] Subtest flip-vs-rmfb: SUCCESS (34.543s)
[366.706250] [057/133] (658s left) kms_invalid_mode (clock-too-high)
[366.811988] Starting subtest: clock-too-high
[366.814310] Starting dynamic subtest: pipe-A-eDP-1
[366.818904] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[366.829442] Starting dynamic subtest: pipe-B-eDP-1
[366.833562] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[366.842941] Starting dynamic subtest: pipe-C-eDP-1
[366.847091] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[366.856446] Starting dynamic subtest: pipe-D-eDP-1
[366.860639] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[366.864787] Subtest clock-too-high: SKIP (0.005s)
[366.907428] [058/133] (658s left) gem_exec_params (invalid-flag)
[366.964020] Starting subtest: invalid-flag
[366.966378] Subtest invalid-flag: SUCCESS (0.000s)
[367.068723] [059/133] (658s left) kms_flip (2x-modeset-vs-vblank-race)
[367.166493] Starting subtest: 2x-modeset-vs-vblank-race
[367.178163] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[367.261094] [060/133] (658s left) dmabuf_sync_file (export-basic)
[367.301358] Starting subtest: export-basic
[367.303525] Subtest export-basic: SUCCESS (0.001s)
[367.366978] [061/133] (658s left) gem_softpin (noreloc)
[367.421094] Starting subtest: noreloc
[372.804416] Subtest noreloc: SUCCESS (5.382s)
[372.932701] [062/133] (652s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[372.993070] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[372.997512] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[373.181190] [063/133] (652s left) gem_exec_fence (basic-wait)
[373.368367] Starting subtest: basic-wait
[373.370869] Starting dynamic subtest: rcs0
[373.438012] Dynamic subtest rcs0: SUCCESS (0.069s)
[373.450222] Starting dynamic subtest: bcs0
[373.495584] Dynamic subtest bcs0: SUCCESS (0.055s)
[373.507132] Starting dynamic subtest: vcs0
[373.548149] Dynamic subtest vcs0: SUCCESS (0.051s)
[373.559712] Starting dynamic subtest: vcs1
[373.603438] Dynamic subtest vcs1: SUCCESS (0.053s)
[373.617667] Starting dynamic subtest: vecs0
[373.661166] Dynamic subtest vecs0: SUCCESS (0.056s)
[373.672944] Starting dynamic subtest: ccs0
[373.723961] Dynamic subtest ccs0: SUCCESS (0.060s)
[373.726737] Subtest basic-wait: SUCCESS (0.356s)
[375.925039] [064/133] (649s left) gem_exec_reloc (basic-cpu-wc)
[375.992036] Subtest basic-cpu-wc: SKIP (0.000s)
[376.068112] [065/133] (649s left) kms_plane_multiple (tiling-none)
[376.164166] Starting subtest: tiling-none
[376.166401] Starting dynamic subtest: pipe-A-eDP-1
[379.930642] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.766s)
[379.940864] Starting dynamic subtest: pipe-B-eDP-1
[384.261934] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.331s)
[384.272286] Starting dynamic subtest: pipe-C-eDP-1
[388.580750] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.317s)
[388.591302] Starting dynamic subtest: pipe-D-eDP-1
[392.912008] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.331s)
[392.914118] Subtest tiling-none: SUCCESS (16.750s)
[393.727752] [066/133] (632s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[393.826920] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[393.831008] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[393.922434] [067/133] (631s left) core_auth (getclient-simple)
[393.956812] Starting subtest: getclient-simple
[393.983822] Subtest getclient-simple: SUCCESS (0.028s)
[394.086759] [068/133] (631s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[394.198952] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[395.175707] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.974s)
[396.048781] [069/133] (629s left) perf (invalid-open-flags)
[396.144954] Starting subtest: invalid-open-flags
[396.147326] Subtest invalid-open-flags: SUCCESS (0.000s)
[396.195715] [070/133] (629s left) gem_ctx_persistence (engines-mixed)
[396.262275] Starting subtest: engines-mixed
[396.264454] Starting dynamic subtest: rcs0
[396.354407] Dynamic subtest rcs0: SUCCESS (0.094s)
[396.372899] Starting dynamic subtest: bcs0
[396.416911] Dynamic subtest bcs0: SUCCESS (0.060s)
[396.428845] Starting dynamic subtest: vcs0
[396.475293] Dynamic subtest vcs0: SUCCESS (0.056s)
[396.486834] Starting dynamic subtest: vcs1
[396.524110] Dynamic subtest vcs1: SUCCESS (0.047s)
[396.535700] Starting dynamic subtest: vecs0
[396.544748] Dynamic subtest vecs0: SUCCESS (0.019s)
[396.553864] Starting dynamic subtest: ccs0
[396.642531] Dynamic subtest ccs0: SUCCESS (0.096s)
[396.645406] Subtest engines-mixed: SUCCESS (0.383s)
[396.739095] [071/133] (629s left) kms_lease (lease-uevent)
[396.821386] Starting subtest: lease-uevent
[397.838967] Subtest lease-uevent: SUCCESS (1.019s)
[397.946845] [072/133] (628s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[398.045716] Starting subtest: fbcpsr-modesetfrombusy
[404.234806] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.193s)
[404.374310] [073/133] (621s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[404.471219] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[404.472821] Starting dynamic subtest: pipe-A-eDP-1
[405.290056] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.813s)
[405.299562] Starting dynamic subtest: pipe-B-eDP-1
[406.933919] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.642s)
[406.943600] Starting dynamic subtest: pipe-C-eDP-1
[408.436584] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.500s)
[408.447633] Starting dynamic subtest: pipe-D-eDP-1
[410.014738] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.578s)
[410.017086] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.538s)
[411.228653] [074/133] (614s left) gem_ctx_engines (independent)
[411.310367] Starting subtest: independent
[411.313134] Starting dynamic subtest: rcs0
[411.452579] Dynamic subtest rcs0: SUCCESS (0.140s)
[411.462848] Starting dynamic subtest: bcs0
[411.570048] Dynamic subtest bcs0: SUCCESS (0.117s)
[411.582669] Starting dynamic subtest: vcs0
[411.688781] Dynamic subtest vcs0: SUCCESS (0.118s)
[411.701846] Starting dynamic subtest: vcs1
[411.806749] Dynamic subtest vcs1: SUCCESS (0.116s)
[411.819075] Starting dynamic subtest: vecs0
[411.939211] Dynamic subtest vecs0: SUCCESS (0.132s)
[411.950710] Starting dynamic subtest: ccs0
[412.062387] Dynamic subtest ccs0: SUCCESS (0.122s)
[412.072916] Starting dynamic subtest: all-engines
[412.476466] Dynamic subtest all-engines: SUCCESS (0.413s)
[412.478891] Subtest independent: SUCCESS (1.166s)
[412.961936] [075/133] (613s left) gem_pxp (regular-baseline-src-copy-readible)
[413.082254] Starting subtest: regular-baseline-src-copy-readible
[413.140629] Subtest regular-baseline-src-copy-readible: SUCCESS (0.061s)
[413.260984] [076/133] (612s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[413.358213] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[417.520768] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.166s)
[418.653354] [077/133] (607s left) gem_eio (in-flight-1us)
[418.892501] Starting subtest: in-flight-1us
[427.850674] Subtest in-flight-1us: SUCCESS (8.958s)
[427.969142] [078/133] (598s left) perf (missing-sample-flags)
[428.064381] Starting subtest: missing-sample-flags
[428.066797] Subtest missing-sample-flags: SUCCESS (0.001s)
[428.113693] [079/133] (598s left) i915_pm_rpm (gem-idle)
[430.056005] Starting subtest: gem-idle
[436.265564] Subtest gem-idle: SUCCESS (6.216s)
[436.606805] [080/133] (589s left) gem_exec_balancer (bonded-semaphore)
[437.769074] Starting subtest: bonded-semaphore
[437.773632] Subtest bonded-semaphore: SKIP (0.000s)
[438.088238] [081/133] (588s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[438.192248] Starting subtest: flip-vs-dpms-on-nop-interruptible
[438.194494] Starting dynamic subtest: A-eDP1
[440.016429] Dynamic subtest A-eDP1: SUCCESS (1.823s)
[440.033863] Starting dynamic subtest: B-eDP1
[441.840985] Dynamic subtest B-eDP1: SUCCESS (1.822s)
[441.854926] Starting dynamic subtest: C-eDP1
[443.656822] Dynamic subtest C-eDP1: SUCCESS (1.813s)
[443.670556] Starting dynamic subtest: D-eDP1
[445.482763] Dynamic subtest D-eDP1: SUCCESS (1.824s)
[445.485313] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.296s)
[446.675059] [082/133] (579s left) kms_getfb (getfb-handle-valid)
[446.781534] Starting subtest: getfb-handle-valid
[446.783865] Subtest getfb-handle-valid: SUCCESS (0.000s)
[446.890733] [083/133] (579s left) syncobj_timeline (invalid-signal-zero-handles)
[446.963699] Starting subtest: invalid-signal-zero-handles
[446.966063] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[447.075881] [084/133] (579s left) kms_fbcon_fbt (psr)
[447.151063] Starting subtest: psr
[454.471949] Subtest psr: SUCCESS (7.319s)
[454.562110] [085/133] (572s left) kms_psr (psr-primary-mmap-gtt)
[454.663638] Starting subtest: psr-primary-mmap-gtt
[454.665926] Starting dynamic subtest: eDP-1
[456.087619] Dynamic subtest eDP-1: SKIP (1.421s)
[456.092555] Subtest psr-primary-mmap-gtt: SKIP (1.423s)
[456.235199] [086/133] (570s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[456.291392] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[456.395868] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.104s)
[456.474566] [087/133] (570s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[456.577701] Starting subtest: pr-cursor-plane-update-sf
[456.582000] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[456.646332] [088/133] (570s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[456.749537] Starting subtest: fbcpsr-1p-rte
[463.737322] Subtest fbcpsr-1p-rte: SUCCESS (6.990s)
[463.897337] [089/133] (562s left) kms_content_protection (atomic-dpms)
[464.041756] Starting subtest: atomic-dpms
[464.045726] Subtest atomic-dpms: SKIP (0.000s)
[464.153722] [090/133] (562s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[464.246408] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[464.250585] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[464.352587] [091/133] (562s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[464.447473] Starting subtest: plane-ctm3x4-lut1d
[464.592112] Starting dynamic subtest: pipe-A-plane-0
[464.769197] Dynamic subtest pipe-A-plane-0: SUCCESS (0.177s)
[464.781422] Starting dynamic subtest: pipe-A-plane-1
[464.902872] Dynamic subtest pipe-A-plane-1: SUCCESS (0.132s)
[464.913410] Starting dynamic subtest: pipe-A-plane-2
[465.069320] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[466.251154] Starting dynamic subtest: pipe-B-plane-0
[466.442740] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s)
[466.453646] Starting dynamic subtest: pipe-B-plane-1
[466.576457] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[466.587254] Starting dynamic subtest: pipe-B-plane-2
[466.765412] Dynamic subtest pipe-B-plane-2: SUCCESS (0.188s)
[467.977280] Starting dynamic subtest: pipe-C-plane-0
[468.112383] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[468.123521] Starting dynamic subtest: pipe-C-plane-1
[468.256625] Dynamic subtest pipe-C-plane-1: SUCCESS (0.143s)
[468.267131] Starting dynamic subtest: pipe-C-plane-2
[468.390334] Dynamic subtest pipe-C-plane-2: SUCCESS (0.133s)
[469.599028] Starting dynamic subtest: pipe-D-plane-0
[469.734466] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[469.745116] Starting dynamic subtest: pipe-D-plane-1
[469.901005] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[469.911690] Starting dynamic subtest: pipe-D-plane-2
[470.056798] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[470.344605] Subtest plane-ctm3x4-lut1d: SUCCESS (5.897s)
[471.191575] [092/133] (555s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[471.288590] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[471.292595] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[471.380751] [093/133] (555s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[471.472165] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[472.595709] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.123s)
[472.731322] [094/133] (554s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[472.795824] Starting subtest: multi-wait-all-for-submit-signaled
[472.797717] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[472.910177] [095/133] (554s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[472.984053] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[473.049876] [096/133] (554s left) kms_big_fb (x-tiled-addfb)
[473.142529] Starting subtest: x-tiled-addfb
[473.144264] Subtest x-tiled-addfb: SUCCESS (0.000s)
[473.241934] [097/133] (553s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[473.338686] Starting subtest: y-tiled-8bpp-rotate-0
[473.342105] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[473.433713] [098/133] (553s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[473.528613] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[496.311670] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.780s)
[496.463145] [099/133] (530s left) gen7_exec_parse (basic-allocation)
[496.533319] Subtest basic-allocation: SKIP (0.000s)
[496.610532] [100/133] (530s left) gem_ctx_param (invalid-ctx-set)
[496.659697] Starting subtest: invalid-ctx-set
[496.661517] Subtest invalid-ctx-set: SUCCESS (0.002s)
[496.773807] [101/133] (530s left) syncobj_timeline (wait-all-delayed-signal)
[496.830813] Starting subtest: wait-all-delayed-signal
[496.932976] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[497.012235] [102/133] (530s left) i915_drm_fdinfo (most-busy-idle-check-all)
[497.052630] Starting subtest: most-busy-idle-check-all
[497.055013] Starting dynamic subtest: rcs0
[497.062182] Dynamic subtest rcs0: SKIP (0.006s)
[497.073154] Starting dynamic subtest: bcs0
[497.077278] Dynamic subtest bcs0: SKIP (0.001s)
[497.087561] Starting dynamic subtest: vcs0
[497.091958] Dynamic subtest vcs0: SKIP (0.000s)
[497.101882] Starting dynamic subtest: vcs1
[497.106004] Dynamic subtest vcs1: SKIP (0.000s)
[497.115659] Starting dynamic subtest: vecs0
[497.119711] Dynamic subtest vecs0: SKIP (0.000s)
[497.129677] Starting dynamic subtest: ccs0
[497.133694] Dynamic subtest ccs0: SKIP (0.000s)
[497.137802] Subtest most-busy-idle-check-all: SKIP (0.016s)
[497.177710] [103/133] (530s left) gem_lmem_swapping (massive-random)
[497.220525] Subtest massive-random: SKIP (0.000s)
[497.267492] [104/133] (530s left) kms_flip (plain-flip-ts-check)
[497.389836] Starting subtest: plain-flip-ts-check
[497.392170] Starting dynamic subtest: A-eDP1
[506.298649] Dynamic subtest A-eDP1: SUCCESS (8.907s)
[506.309792] Starting dynamic subtest: B-eDP1
[515.133144] Dynamic subtest B-eDP1: SUCCESS (8.832s)
[515.146598] Starting dynamic subtest: C-eDP1
[523.959075] Dynamic subtest C-eDP1: SUCCESS (8.822s)
[523.969660] Starting dynamic subtest: D-eDP1
[532.794294] Dynamic subtest D-eDP1: SUCCESS (8.833s)
[532.798851] Subtest plain-flip-ts-check: SUCCESS (35.408s)
[533.982480] [105/133] (493s left) kms_cursor_crc (cursor-onscreen-128x42)
[534.205913] Starting subtest: cursor-onscreen-128x42
[534.258218] Subtest cursor-onscreen-128x42: SKIP (0.046s)
[534.486139] [106/133] (493s left) gem_ctx_persistence (legacy-engines-hang)
[534.554709] Starting subtest: legacy-engines-hang
[534.557055] Starting dynamic subtest: render
[534.680987] Dynamic subtest render: SUCCESS (0.125s)
[534.696408] Starting dynamic subtest: bsd1
[534.782286] Dynamic subtest bsd1: SUCCESS (0.098s)
[534.794687] Starting dynamic subtest: bsd2
[534.874173] Dynamic subtest bsd2: SUCCESS (0.090s)
[534.887382] Starting dynamic subtest: blt
[534.967646] Dynamic subtest blt: SUCCESS (0.091s)
[534.981554] Starting dynamic subtest: vebox
[535.039518] Dynamic subtest vebox: SUCCESS (0.069s)
[535.041598] Subtest legacy-engines-hang: SUCCESS (0.486s)
[535.160082] [107/133] (492s left) kms_prime (basic-crc-hybrid)
[535.244410] Subtest basic-crc-hybrid: SKIP (0.000s)
[535.339379] [108/133] (492s left) gem_mmap_gtt (coherency)
[535.394233] Subtest coherency: SKIP (0.000s)
[535.460769] [109/133] (492s left) i915_pm_sseu (full-enable)
[535.514021] Subtest full-enable: SKIP (0.000s)
[535.623272] [110/133] (492s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[535.712023] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[535.715512] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[535.805311] [111/133] (491s left) perf_pmu (all-busy-idle-check-all)
[535.848171] Starting subtest: all-busy-idle-check-all
[537.889400] Subtest all-busy-idle-check-all: SUCCESS (2.040s)
[538.003865] [112/133] (489s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[538.116337] Starting subtest: yf-tiled-8bpp-rotate-90
[538.120621] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[538.231359] [113/133] (489s left) gem_exec_schedule (preempt-hang)
[538.409096] Starting subtest: preempt-hang
[538.411148] Starting dynamic subtest: rcs0
[538.632107] Dynamic subtest rcs0: SUCCESS (0.226s)
[538.642987] Starting dynamic subtest: bcs0
[538.854333] Dynamic subtest bcs0: SUCCESS (0.221s)
[538.865571] Starting dynamic subtest: vcs0
[539.071980] Dynamic subtest vcs0: SUCCESS (0.216s)
[539.084138] Starting dynamic subtest: vcs1
[539.289586] Dynamic subtest vcs1: SUCCESS (0.217s)
[539.301533] Starting dynamic subtest: vecs0
[539.507587] Dynamic subtest vecs0: SUCCESS (0.217s)
[539.519429] Starting dynamic subtest: ccs0
[539.729831] Dynamic subtest ccs0: SUCCESS (0.221s)
[539.731791] Subtest preempt-hang: SUCCESS (1.324s)
[540.925565] [114/133] (486s left) kms_psr (fbc-psr-sprite-render)
[541.023289] Starting subtest: fbc-psr-sprite-render
[541.025620] Starting dynamic subtest: eDP-1
[541.029891] Dynamic subtest eDP-1: SKIP (0.000s)
[541.034085] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[541.099439] [115/133] (486s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[541.193446] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[541.195585] Starting dynamic subtest: pipe-A-eDP-1
[541.217552] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[541.230195] Starting dynamic subtest: pipe-B-eDP-1
[541.250440] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[541.260636] Starting dynamic subtest: pipe-C-eDP-1
[541.281138] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[541.291204] Starting dynamic subtest: pipe-D-eDP-1
[541.312673] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[541.317066] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[543.365006] [116/133] (484s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[543.466192] Starting subtest: plane-upscale-20x20-with-rotation
[543.468600] Starting dynamic subtest: pipe-A
[543.690912] Dynamic subtest pipe-A: SUCCESS (0.227s)
[543.701565] Starting dynamic subtest: pipe-B
[544.943424] Dynamic subtest pipe-B: SUCCESS (1.252s)
[544.954432] Starting dynamic subtest: pipe-C
[546.276431] Dynamic subtest pipe-C: SUCCESS (1.331s)
[546.288544] Starting dynamic subtest: pipe-D
[547.614546] Dynamic subtest pipe-D: SUCCESS (1.337s)
[547.616724] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.151s)
[548.792204] [117/133] (479s left) kms_pm_dc (dc3co-vpb-simulation)
[549.901600] Starting subtest: dc3co-vpb-simulation
[559.047223] Subtest dc3co-vpb-simulation: SKIP (9.143s)
[559.171813] [118/133] (468s left) sysfs_timeslice_duration (timeout)
[559.231481] Starting subtest: timeout
[559.233745] Starting dynamic subtest: vecs0
[568.852128] Dynamic subtest vecs0: SUCCESS (9.618s)
[568.864999] Starting dynamic subtest: ccs0
[570.107181] Dynamic subtest ccs0: SUCCESS (1.254s)
[570.119843] Starting dynamic subtest: vcs0
[579.864178] Dynamic subtest vcs0: SUCCESS (9.754s)
[579.877953] Starting dynamic subtest: bcs0
[580.486501] Dynamic subtest bcs0: SUCCESS (0.620s)
[580.497071] Starting dynamic subtest: rcs0
[581.676307] Dynamic subtest rcs0: SUCCESS (1.188s)
[581.686573] Starting dynamic subtest: vcs1
[590.873064] Dynamic subtest vcs1: SUCCESS (9.193s)
[590.875661] Subtest timeout: SUCCESS (31.642s)
[590.952321] [119/133] (437s left) kms_sequence (get-busy)
[591.052414] Starting subtest: get-busy
[591.054761] Starting dynamic subtest: pipe-A-eDP-1
[592.988925] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.936s)
[593.002774] Starting dynamic subtest: pipe-B-eDP-1
[595.568993] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.581s)
[595.581093] Starting dynamic subtest: pipe-C-eDP-1
[598.225247] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.653s)
[598.238393] Starting dynamic subtest: pipe-D-eDP-1
[600.818514] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.594s)
[600.820744] Subtest get-busy: SUCCESS (9.769s)
[601.621143] [120/133] (426s left) sw_sync (sync_expired_merge)
[601.653804] Starting subtest: sync_expired_merge
[602.728273] Subtest sync_expired_merge: SUCCESS (1.074s)
[602.794477] [121/133] (425s left) gen9_exec_parse (allowed-all)
[602.852070] Subtest allowed-all: SKIP (0.000s)
[602.923691] [122/133] (425s left) syncobj_basic (create-signaled)
[602.991124] Starting subtest: create-signaled
[602.993423] Subtest create-signaled: SUCCESS (0.000s)
[603.100690] [123/133] (425s left) prime_vgem (shrink)
[603.172048] Starting subtest: shrink
[603.195379] Subtest shrink: SUCCESS (0.022s)
[603.328293] [124/133] (424s left) gem_exec_async (forked-writes)
[603.381114] Starting subtest: forked-writes
[603.383471] Starting dynamic subtest: rcs0
[603.408875] Dynamic subtest rcs0: SUCCESS (0.027s)
[603.421896] Starting dynamic subtest: bcs0
[603.432634] Dynamic subtest bcs0: SUCCESS (0.023s)
[603.446584] Starting dynamic subtest: vcs0
[603.456191] Dynamic subtest vcs0: SUCCESS (0.023s)
[603.468224] Starting dynamic subtest: vcs1
[603.480608] Dynamic subtest vcs1: SUCCESS (0.023s)
[603.491365] Starting dynamic subtest: vecs0
[603.504575] Dynamic subtest vecs0: SUCCESS (0.023s)
[603.517269] Starting dynamic subtest: ccs0
[603.528535] Dynamic subtest ccs0: SUCCESS (0.023s)
[603.530741] Subtest forked-writes: SUCCESS (0.148s)
[603.784808] [125/133] (424s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[603.889822] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[603.916008] Starting dynamic subtest: pipe-A-plane-0
[604.349268] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[604.362532] Starting dynamic subtest: pipe-A-plane-3
[604.615684] Dynamic subtest pipe-A-plane-3: SUCCESS (0.266s)
[604.626726] Starting dynamic subtest: pipe-A-plane-5
[604.631323] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[605.707863] Starting dynamic subtest: pipe-B-plane-0
[606.242152] Dynamic subtest pipe-B-plane-0: SUCCESS (0.543s)
[606.252792] Starting dynamic subtest: pipe-B-plane-3
[606.542510] Dynamic subtest pipe-B-plane-3: SUCCESS (0.299s)
[606.553684] Starting dynamic subtest: pipe-B-plane-5
[606.558224] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[606.864147] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.974s)
[607.695791] [126/133] (420s left) gem_softpin (allocator-basic-reserve)
[607.754119] Starting subtest: allocator-basic-reserve
[607.822181] Subtest allocator-basic-reserve: SUCCESS (0.068s)
[607.956402] [127/133] (420s left) gem_exec_whisper (basic-contexts-priority)
[608.020111] Starting subtest: basic-contexts-priority
[633.006941] Subtest basic-contexts-priority: SUCCESS (24.990s)
[633.203168] [128/133] (395s left) gem_exec_fence (syncobj-timeline-chain-engines)
[633.807142] Starting subtest: syncobj-timeline-chain-engines
[634.005629] Subtest syncobj-timeline-chain-engines: SUCCESS (0.199s)
[634.966883] [129/133] (393s left) gem_ctx_create (basic-files)
[635.024337] Starting subtest: basic-files
[637.033714] Subtest basic-files: SUCCESS (2.010s)
[638.923049] [130/133] (389s left) perf_pmu (render-node-busy-idle)
[639.006024] Starting subtest: render-node-busy-idle
[639.008508] Starting dynamic subtest: rcs0
[639.691853] Dynamic subtest rcs0: SUCCESS (0.688s)
[639.705239] Starting dynamic subtest: bcs0
[640.356990] Dynamic subtest bcs0: SUCCESS (0.663s)
[640.369699] Starting dynamic subtest: vcs0
[641.824324] Dynamic subtest vcs0: SUCCESS (1.464s)
[641.837838] Starting dynamic subtest: vcs1
[643.872444] Dynamic subtest vcs1: SUCCESS (2.045s)
[643.885774] Starting dynamic subtest: vecs0
[645.856608] Dynamic subtest vecs0: SUCCESS (1.981s)
[645.868601] Starting dynamic subtest: ccs0
[646.527582] Dynamic subtest ccs0: SUCCESS (0.670s)
[646.530083] Subtest render-node-busy-idle: SUCCESS (7.528s)
[646.607237] [131/133] (382s left) kms_psr (psr2-primary-blt)
[646.705304] Starting subtest: psr2-primary-blt
[646.707675] Starting dynamic subtest: eDP-1
[648.461413] Dynamic subtest eDP-1: SUCCESS (1.757s)
[648.463856] Subtest psr2-primary-blt: SUCCESS (1.758s)
[649.338113] [132/133] (379s left) api_intel_allocator (two-level-inception-interruptible)
[649.405918] Starting subtest: two-level-inception-interruptible
[654.814484] Subtest two-level-inception-interruptible: SUCCESS (5.409s)
[654.946737] [133/133] (373s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[655.048770] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[655.053204] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[655.179675] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_schedule
results: parsing output: 1/ for test: kms_chamelium_frames
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_setmode
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: kms_plane
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_pread
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: kms_cdclk
results: parsing output: 12/ for test: prime_mmap
results: parsing output: 13/ for test: kms_cursor_crc
results: parsing output: 14/ for test: i915_hangman
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_vblank
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_psr2_sf
results: parsing output: 19/ for test: kms_async_flips
results: parsing output: 20/ for test: template
results: parsing output: 21/ for test: gem_ctx_param
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: syncobj_wait
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: kms_draw_crc
results: parsing output: 28/ for test: gem_ccs
results: parsing output: 29/ for test: kms_cursor_crc
results: parsing output: 30/ for test: kms_psr2_sf
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: gem_exec_reloc
results: parsing output: 33/ for test: gem_tiled_pread_pwrite
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: kms_psr
results: parsing output: 36/ for test: kms_pipe_stress
results: parsing output: 37/ for test: kms_hdr
results: parsing output: 38/ for test: kms_chamelium_hpd
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: perf_pmu
results: parsing output: 41/ for test: gem_mmap_gtt
results: parsing output: 42/ for test: gem_lmem_swapping
results: parsing output: 43/ for test: gem_mmap_offset
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_exec_fence
results: parsing output: 46/ for test: gem_ctx_param
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_cursor_legacy
results: parsing output: 50/ for test: gem_exec_flush
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: perf
results: parsing output: 53/ for test: gem_exec_params
results: parsing output: 54/ for test: gem_reg_read
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: kms_invalid_mode
results: parsing output: 57/ for test: gem_exec_params
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: dmabuf_sync_file
results: parsing output: 60/ for test: gem_softpin
results: parsing output: 61/ for test: gem_render_copy
results: parsing output: 62/ for test: gem_exec_fence
results: parsing output: 63/ for test: gem_exec_reloc
results: parsing output: 64/ for test: kms_plane_multiple
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: core_auth
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: perf
results: parsing output: 69/ for test: gem_ctx_persistence
results: parsing output: 70/ for test: kms_lease
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: gem_ctx_engines
results: parsing output: 74/ for test: gem_pxp
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_eio
results: parsing output: 77/ for test: perf
results: parsing output: 78/ for test: i915_pm_rpm
results: parsing output: 79/ for test: gem_exec_balancer
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_getfb
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: kms_fbcon_fbt
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: kms_psr2_sf
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_content_protection
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_color_pipeline
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: gem_fenced_exec_thrash
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gen7_exec_parse
results: parsing output: 99/ for test: gem_ctx_param
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: i915_drm_fdinfo
results: parsing output: 102/ for test: gem_lmem_swapping
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: kms_cursor_crc
results: parsing output: 105/ for test: gem_ctx_persistence
results: parsing output: 106/ for test: kms_prime
results: parsing output: 107/ for test: gem_mmap_gtt
results: parsing output: 108/ for test: i915_pm_sseu
results: parsing output: 109/ for test: kms_flip_scaled_crc
results: parsing output: 110/ for test: perf_pmu
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: gem_exec_schedule
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: kms_plane_scaling
results: parsing output: 116/ for test: kms_pm_dc
results: parsing output: 117/ for test: sysfs_timeslice_duration
results: parsing output: 118/ for test: kms_sequence
results: parsing output: 119/ for test: sw_sync
results: parsing output: 120/ for test: gen9_exec_parse
results: parsing output: 121/ for test: syncobj_basic
results: parsing output: 122/ for test: prime_vgem
results: parsing output: 123/ for test: gem_exec_async
results: parsing output: 124/ for test: kms_plane
results: parsing output: 125/ for test: gem_softpin
results: parsing output: 126/ for test: gem_exec_whisper
results: parsing output: 127/ for test: gem_exec_fence
results: parsing output: 128/ for test: gem_ctx_create
results: parsing output: 129/ for test: perf_pmu
results: parsing output: 130/ for test: kms_psr
results: parsing output: 131/ for test: api_intel_allocator
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.