[63.071045] Initializing watchdogs
[63.071093]   /dev/watchdog0
[63.086168] [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]
[63.090636] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[63.093438] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.097741] [001/133] (960s left) syncobj_basic (bad-flags-handle-to-fd)
[63.184819] Starting subtest: bad-flags-handle-to-fd
[63.187122] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[63.281855] [002/133] (960s left) i915_query (engine-info)
[63.334077] Starting subtest: engine-info
[63.337310] Subtest engine-info: SUCCESS (0.005s)
[63.459218] [003/133] (960s left) gem_ctx_create (basic-files)
[63.531384] Starting subtest: basic-files
[65.887531] Subtest basic-files: SUCCESS (2.338s)
[67.368596] [004/133] (956s left) kms_psr (fbc-pr-suspend)
[67.464921] Starting subtest: fbc-pr-suspend
[67.469173] Subtest fbc-pr-suspend: SKIP (0.000s)
[67.537279] [005/133] (956s left) vgem_basic (dmabuf-export)
[67.623889] Starting subtest: dmabuf-export
[67.644651] Subtest dmabuf-export: SUCCESS (0.022s)
[67.732858] [FACT vgem_basic (dmabuf-export)] new: kernel.kmod_is_loaded.vgem: true
[67.735953] [006/133] (956s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[67.830970] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[67.835259] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[67.926175] [007/133] (955s left) gem_ctx_isolation (nonpriv)
[67.994359] Starting subtest: nonpriv
[67.996855] Starting dynamic subtest: rcs0
[68.252734] Dynamic subtest rcs0: SUCCESS (0.257s)
[68.263107] Starting dynamic subtest: bcs0
[68.501655] Dynamic subtest bcs0: SUCCESS (0.247s)
[68.511549] Starting dynamic subtest: vcs0
[68.744366] Dynamic subtest vcs0: SUCCESS (0.242s)
[68.754741] Starting dynamic subtest: vcs1
[70.498087] Dynamic subtest vcs1: SUCCESS (1.746s)
[70.507863] Starting dynamic subtest: vecs0
[72.676744] Dynamic subtest vecs0: SUCCESS (2.171s)
[72.684710] Starting dynamic subtest: ccs0
[74.577762] Dynamic subtest ccs0: SUCCESS (1.896s)
[74.579999] Subtest nonpriv: SUCCESS (6.561s)
[74.796789] [008/133] (949s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[74.904975] Starting subtest: psr2-overlay-plane-update-continuous-sf
[74.907440] Starting dynamic subtest: pipe-A-eDP-1
[76.044896] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.140s)
[76.055101] Starting dynamic subtest: pipe-B-eDP-1
[77.839499] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.793s)
[77.842048] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (2.935s)
[78.676332] [009/133] (945s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[78.729738] Starting subtest: multi-wait-for-submit-unsubmitted
[78.831985] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[78.919634] [010/133] (945s left) i915_query (query-topology-unsupported)
[78.967592] Starting subtest: query-topology-unsupported
[78.971589] Subtest query-topology-unsupported: SKIP (0.000s)
[79.055696] [011/133] (944s left) kms_flip (flip-vs-rmfb)
[79.144407] Starting subtest: flip-vs-rmfb
[79.146778] Starting dynamic subtest: A-eDP1
[87.851341] Dynamic subtest A-eDP1: SUCCESS (8.699s)
[87.859443] Starting dynamic subtest: B-eDP1
[96.504088] Dynamic subtest B-eDP1: SUCCESS (8.645s)
[96.512406] Starting dynamic subtest: C-eDP1
[105.121128] Dynamic subtest C-eDP1: SUCCESS (8.612s)
[105.133760] Starting dynamic subtest: D-eDP1
[113.746694] Dynamic subtest D-eDP1: SUCCESS (8.621s)
[113.751277] Subtest flip-vs-rmfb: SUCCESS (34.590s)
[114.923854] [012/133] (909s left) gen7_exec_parse (basic-allocation)
[114.988277] Subtest basic-allocation: SKIP (0.000s)
[115.062158] [013/133] (909s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[115.157800] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[122.677077] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.521s)
[122.814966] [014/133] (901s left) gem_basic (create-fd-close)
[122.880080] Starting subtest: create-fd-close
[122.884583] Subtest create-fd-close: SUCCESS (0.000s)
[122.999250] [015/133] (901s left) gem_eio (throttle)
[123.228830] Starting subtest: throttle
[123.577479] Subtest throttle: SUCCESS (0.347s)
[123.705142] [016/133] (900s left) perf (blocking-parameterized)
[123.835599] Starting subtest: blocking-parameterized
[143.857411] Subtest blocking-parameterized: SUCCESS (20.018s)
[143.911425] [017/133] (880s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[144.017816] Starting subtest: yf-tiled-16bpp-rotate-180
[144.022268] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[144.120032] [018/133] (880s left) gem_ctx_shared (exec-single-timeline)
[144.189399] Starting subtest: exec-single-timeline
[144.191823] Starting dynamic subtest: rcs0
[145.241020] Dynamic subtest rcs0: SUCCESS (1.050s)
[145.253548] Starting dynamic subtest: bcs0
[146.329390] Dynamic subtest bcs0: SUCCESS (1.085s)
[146.341077] Starting dynamic subtest: vcs0
[147.420046] Dynamic subtest vcs0: SUCCESS (1.088s)
[147.431635] Starting dynamic subtest: vcs1
[148.507014] Dynamic subtest vcs1: SUCCESS (1.083s)
[148.519495] Starting dynamic subtest: vecs0
[149.593265] Dynamic subtest vecs0: SUCCESS (1.084s)
[149.605981] Starting dynamic subtest: ccs0
[150.682399] Dynamic subtest ccs0: SUCCESS (1.086s)
[150.685224] Subtest exec-single-timeline: SUCCESS (6.493s)
[151.293276] [019/133] (873s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[151.394214] Starting subtest: fbc-psr-sprite-mmap-gtt
[151.396093] Starting dynamic subtest: eDP-1
[151.400128] Dynamic subtest eDP-1: SKIP (0.000s)
[151.404188] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[151.467060] [020/133] (872s left) kms_flip (nonexisting-fb-interruptible)
[151.570783] Starting subtest: nonexisting-fb-interruptible
[151.573095] Starting dynamic subtest: A-eDP1
[152.761439] Dynamic subtest A-eDP1: SUCCESS (1.190s)
[152.773033] Starting dynamic subtest: B-eDP1
[153.886171] Dynamic subtest B-eDP1: SUCCESS (1.121s)
[153.898230] Starting dynamic subtest: C-eDP1
[155.020717] Dynamic subtest C-eDP1: SUCCESS (1.132s)
[155.030069] Starting dynamic subtest: D-eDP1
[156.149984] Dynamic subtest D-eDP1: SUCCESS (1.127s)
[156.156846] Subtest nonexisting-fb-interruptible: SUCCESS (4.584s)
[157.314445] [021/133] (867s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[157.422796] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[164.105082] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.684s)
[164.249398] [022/133] (860s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[164.354083] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[164.356165] Starting dynamic subtest: pipe-A-eDP-1
[164.375355] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s)
[164.385135] Starting dynamic subtest: pipe-B-eDP-1
[164.404478] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[164.415199] Starting dynamic subtest: pipe-C-eDP-1
[164.434467] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.024s)
[164.442989] Starting dynamic subtest: pipe-D-eDP-1
[164.463055] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.023s)
[164.465328] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.096s)
[166.698423] [023/133] (857s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[166.799482] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[166.803893] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[166.873852] [024/133] (857s left) kms_setmode (basic-clone-single-crtc)
[166.919891] Starting subtest: basic-clone-single-crtc
[166.926095] Subtest basic-clone-single-crtc: SKIP (0.000s)
[167.007360] [025/133] (857s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[167.107677] Starting subtest: fbc-1p-pri-indfb-multidraw
[180.038362] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (12.936s)
[181.401470] [026/133] (843s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[181.491999] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[181.583604] [027/133] (843s left) i915_module_load (reload-no-display)
[181.620057] Starting subtest: reload-no-display
[187.436299] Subtest reload-no-display: SUCCESS (5.820s)
[187.464996] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[187.465750] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[187.469254] [028/133] (837s left) syncobj_timeline (single-wait-available-submitted)
[188.990139] Starting subtest: single-wait-available-submitted
[188.992515] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[189.061871] [FACT syncobj_timeline (single-wait-available-submitted)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[189.063707] [FACT syncobj_timeline (single-wait-available-submitted)] new: kernel.kmod_is_loaded.i915: true
[189.067290] [029/133] (835s left) gem_exec_suspend (basic)
[189.132503] Starting subtest: basic
[189.134985] Starting dynamic subtest: smem
[190.269363] Dynamic subtest smem: SUCCESS (1.136s)
[190.271689] Subtest basic: SUCCESS (1.138s)
[190.461223] [030/133] (834s left) i915_pm_rpm (gem-evict-pwrite)
[192.498180] Starting subtest: gem-evict-pwrite
[192.503198] Subtest gem-evict-pwrite: SKIP (0.000s)
[192.865940] [031/133] (831s left) kms_chamelium_frames (dp-crc-multiple)
[193.258504] Subtest dp-crc-multiple: SKIP (0.000s)
[194.061209] [032/133] (830s left) perf (non-sampling-read-error)
[194.194314] Starting subtest: non-sampling-read-error
[194.204097] Subtest non-sampling-read-error: SUCCESS (0.010s)
[194.244395] [033/133] (830s left) gem_exec_whisper (basic-queues-all)
[194.313062] Starting subtest: basic-queues-all
[206.237707] Subtest basic-queues-all: SUCCESS (11.922s)
[206.422604] [034/133] (818s left) kms_flip (2x-nonexisting-fb-interruptible)
[206.524175] Starting subtest: 2x-nonexisting-fb-interruptible
[206.536443] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.011s)
[206.616923] [035/133] (818s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[206.723895] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[206.728218] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[206.822373] [036/133] (818s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[206.927835] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[206.931975] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[207.021546] [037/133] (818s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[207.115201] Starting subtest: compare-crc-sanitycheck-xr24
[207.117417] Starting dynamic subtest: pipe-A-eDP-1
[207.762978] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.648s)
[207.771807] Starting dynamic subtest: pipe-B-eDP-1
[209.037372] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.270s)
[209.046216] Starting dynamic subtest: pipe-C-eDP-1
[210.227806] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.188s)
[210.240452] Starting dynamic subtest: pipe-D-eDP-1
[211.481112] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.254s)
[211.483590] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.367s)
[212.310686] [038/133] (812s left) gen9_exec_parse (bb-start-out)
[212.383688] Subtest bb-start-out: SKIP (0.000s)
[212.443507] [039/133] (812s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[212.539572] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[212.543867] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[212.637981] [040/133] (812s left) sw_sync (sync_multi_producer_single_consumer)
[212.678423] Starting subtest: sync_multi_producer_single_consumer
[213.755107] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[213.816647] [041/133] (811s left) gem_exec_balancer (full-late)
[213.879908] Starting subtest: full-late
[218.171668] Subtest full-late: SUCCESS (4.291s)
[218.482389] [042/133] (806s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[218.529074] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[218.631873] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.103s)
[218.710419] [043/133] (806s left) api_intel_allocator (reloc-allocator)
[218.769177] Starting subtest: reloc-allocator
[218.771096] Starting dynamic subtest: basic
[218.773410] Dynamic subtest basic: SUCCESS (0.005s)
[218.786104] Starting dynamic subtest: parallel-one
[218.787956] Dynamic subtest parallel-one: SUCCESS (0.008s)
[218.796501] Starting dynamic subtest: print
[218.798876] Dynamic subtest print: SUCCESS (0.000s)
[218.806931] Starting dynamic subtest: reuse
[218.808738] Dynamic subtest reuse: SUCCESS (0.000s)
[218.816724] Starting dynamic subtest: fork-reopen-allocator
[218.818520] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[218.820347] Subtest reloc-allocator: SUCCESS (0.028s)
[218.942931] [044/133] (806s left) kms_content_protection (atomic-dpms)
[219.080608] Starting subtest: atomic-dpms
[219.085241] Subtest atomic-dpms: SKIP (0.000s)
[219.197516] [045/133] (806s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[221.420400] Starting subtest: modeset-lpsp-stress-no-wait
[231.443519] Subtest modeset-lpsp-stress-no-wait: SUCCESS (10.021s)
[231.519675] [046/133] (793s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[231.618189] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[231.622157] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[231.718416] [047/133] (793s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[231.836435] Starting subtest: basic-flip-before-cursor-atomic
[232.764341] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.928s)
[233.630375] [048/133] (791s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[233.728317] Starting subtest: y-tiled-64bpp-rotate-0
[233.732668] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[233.856183] [049/133] (791s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[233.925612] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[233.993355] [050/133] (791s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[234.088876] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[234.092656] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[234.199520] [051/133] (791s left) perf (stress-open-close)
[234.298927] Starting subtest: stress-open-close
[234.301438] Starting dynamic subtest: 0-rcs0
[236.465438] Dynamic subtest 0-rcs0: SUCCESS (2.166s)
[236.475271] Starting dynamic subtest: 1-vcs0
[238.629901] Dynamic subtest 1-vcs0: SUCCESS (2.164s)
[238.631828] Subtest stress-open-close: SUCCESS (4.332s)
[238.678438] [052/133] (787s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[238.777128] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[238.780651] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[238.873961] [053/133] (786s left) fbdev (unaligned-write)
[238.910061] Starting subtest: unaligned-write
[239.013038] Subtest unaligned-write: SUCCESS (0.101s)
[239.077494] [054/133] (786s left) perf_pmu (idle)
[239.116403] Starting subtest: idle
[239.118778] Starting dynamic subtest: rcs0
[239.648567] Dynamic subtest rcs0: SUCCESS (0.533s)
[239.658727] Starting dynamic subtest: bcs0
[240.167763] Dynamic subtest bcs0: SUCCESS (0.516s)
[240.177861] Starting dynamic subtest: vcs0
[240.688090] Dynamic subtest vcs0: SUCCESS (0.517s)
[240.699578] Starting dynamic subtest: vcs1
[241.205816] Dynamic subtest vcs1: SUCCESS (0.515s)
[241.217059] Starting dynamic subtest: vecs0
[241.734547] Dynamic subtest vecs0: SUCCESS (0.526s)
[241.744076] Starting dynamic subtest: ccs0
[242.259368] Dynamic subtest ccs0: SUCCESS (0.522s)
[242.262114] Subtest idle: SUCCESS (3.146s)
[242.370779] [055/133] (783s left) kms_pm_backlight (basic-brightness)
[242.468023] Starting subtest: basic-brightness
[242.519093] Starting dynamic subtest: eDP-1
[243.023753] Dynamic subtest eDP-1: SUCCESS (0.501s)
[243.026556] Subtest basic-brightness: SUCCESS (0.554s)
[243.876658] [056/133] (781s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[243.972392] Starting subtest: fbc-psr2-cursor-plane-update-sf
[243.974762] Starting dynamic subtest: pipe-A-eDP-1
[244.047809] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[244.058182] Starting dynamic subtest: pipe-B-eDP-1
[245.144304] Dynamic subtest pipe-B-eDP-1: SKIP (1.094s)
[245.148653] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.174s)
[246.333322] [057/133] (779s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[246.437240] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[246.441198] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[246.549749] [058/133] (779s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[246.663622] Starting subtest: short-busy-flip-before-cursor-toggle
[246.668356] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[246.810723] [059/133] (779s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[246.906559] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[250.945582] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (4.044s)
[252.138891] [060/133] (773s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[252.264431] Starting subtest: 2x-cursor-vs-flip-atomic
[252.269064] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[252.411475] [061/133] (773s left) gem_lmem_swapping (verify-random)
[252.449971] Subtest verify-random: SKIP (0.000s)
[252.501149] [062/133] (773s left) gem_tiled_wb
[252.630068] [063/133] (773s left) kms_draw_crc (draw-method-mmap-wc)
[252.721403] Starting subtest: draw-method-mmap-wc
[252.723319] Starting dynamic subtest: xrgb8888-untiled
[252.987721] Dynamic subtest xrgb8888-untiled: SUCCESS (0.267s)
[253.001589] Starting dynamic subtest: rgb565-untiled
[253.209573] Dynamic subtest rgb565-untiled: SUCCESS (0.220s)
[253.218495] Starting dynamic subtest: xrgb2101010-untiled
[253.432065] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[253.440967] Starting dynamic subtest: xbgr16161616f-untiled
[253.654094] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[253.664352] Starting dynamic subtest: xrgb8888-xtiled
[253.776197] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[253.785054] Starting dynamic subtest: rgb565-xtiled
[253.909711] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[253.920836] Starting dynamic subtest: xrgb2101010-xtiled
[254.042930] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.131s)
[254.051513] Starting dynamic subtest: xbgr16161616f-xtiled
[254.176065] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.131s)
[254.185075] Starting dynamic subtest: xrgb8888-4tiled
[254.320673] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[254.329246] Starting dynamic subtest: rgb565-4tiled
[254.476077] Dynamic subtest rgb565-4tiled: SUCCESS (0.155s)
[254.484966] Starting dynamic subtest: xrgb2101010-4tiled
[254.621614] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.144s)
[254.630614] Starting dynamic subtest: xbgr16161616f-4tiled
[254.798811] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.175s)
[254.800700] Subtest draw-method-mmap-wc: SUCCESS (2.080s)
[254.892352] [064/133] (771s left) kms_color (ctm-negative)
[254.990446] Starting subtest: ctm-negative
[254.992229] Starting dynamic subtest: pipe-A-eDP-1
[255.703779] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.713s)
[255.713461] Starting dynamic subtest: pipe-B-eDP-1
[257.128143] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.425s)
[257.139630] Starting dynamic subtest: pipe-C-eDP-1
[258.503772] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.375s)
[258.513822] Starting dynamic subtest: pipe-D-eDP-1
[259.828223] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.321s)
[259.830474] Subtest ctm-negative: SUCCESS (4.837s)
[260.623884] [065/133] (765s left) vgem_basic (create)
[260.674826] Starting subtest: create
[260.677114] Subtest create: SUCCESS (0.000s)
[260.733525] [066/133] (765s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[260.839781] Starting subtest: 4-tiled-8bpp-rotate-0
[262.033833] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.195s)
[262.179458] [067/133] (764s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[262.285357] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[262.288808] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[262.374813] [068/133] (764s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[262.464353] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[262.466247] Starting dynamic subtest: pipe-A
[262.485780] Dynamic subtest pipe-A: SKIP (0.017s)
[262.494716] Starting dynamic subtest: pipe-B
[262.516289] Dynamic subtest pipe-B: SKIP (0.030s)
[262.524928] Starting dynamic subtest: pipe-C
[262.546920] Dynamic subtest pipe-C: SKIP (0.031s)
[262.555672] Starting dynamic subtest: pipe-D
[262.577893] Dynamic subtest pipe-D: SKIP (0.031s)
[262.581365] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.111s)
[262.680593] [069/133] (763s left) kms_vblank (wait-busy-hang)
[262.770721] Starting subtest: wait-busy-hang
[262.772663] Starting dynamic subtest: pipe-A-eDP-1
[289.086300] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.312s)
[289.101060] Starting dynamic subtest: pipe-D-eDP-1
[304.130741] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.043s)
[304.133177] Subtest wait-busy-hang: SUCCESS (41.360s)
[304.995251] [070/133] (721s left) kms_flip (flip-vs-wf_vblank-interruptible)
[305.082495] Starting subtest: flip-vs-wf_vblank-interruptible
[305.084770] Starting dynamic subtest: A-eDP1
[306.945873] Dynamic subtest A-eDP1: SUCCESS (1.862s)
[306.959167] Starting dynamic subtest: B-eDP1
[308.877654] Dynamic subtest B-eDP1: SUCCESS (1.929s)
[308.890879] Starting dynamic subtest: C-eDP1
[310.796422] Dynamic subtest C-eDP1: SUCCESS (1.916s)
[310.805797] Starting dynamic subtest: D-eDP1
[312.724208] Dynamic subtest D-eDP1: SUCCESS (1.927s)
[312.726570] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.645s)
[313.960632] [071/133] (712s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[314.064087] Starting subtest: primary-4-tiled-reflect-x-180
[321.194830] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.131s)
[322.431710] [072/133] (704s left) gem_softpin (allocator-nopin)
[322.497806] Starting subtest: allocator-nopin
[322.594045] Subtest allocator-nopin: SUCCESS (0.095s)
[322.713939] [073/133] (703s left) kms_big_fb (linear-8bpp-rotate-0)
[322.816871] Starting subtest: linear-8bpp-rotate-0
[324.087145] Subtest linear-8bpp-rotate-0: SUCCESS (1.270s)
[324.224741] [074/133] (702s left) kms_atomic_interruptible (legacy-setmode)
[324.313435] Starting subtest: legacy-setmode
[324.315523] Starting dynamic subtest: pipe-A-eDP-1
[331.186397] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.870s)
[331.188743] Subtest legacy-setmode: SUCCESS (6.872s)
[331.997851] [075/133] (694s left) gem_exec_fence (syncobj-channel)
[332.433817] Starting subtest: syncobj-channel
[333.455979] Subtest syncobj-channel: SUCCESS (1.018s)
[334.355126] [076/133] (692s left) i915_drm_fdinfo (virtual-busy)
[334.396095] Starting subtest: virtual-busy
[334.400574] Subtest virtual-busy: SKIP (0.000s)
[334.465542] [077/133] (692s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[334.645858] Starting subtest: cursor-rapid-movement-64x64
[334.650727] Starting dynamic subtest: pipe-A-eDP-1
[335.204711] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.553s)
[335.235035] Starting dynamic subtest: pipe-D-eDP-1
[336.405282] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.177s)
[336.407571] Subtest cursor-rapid-movement-64x64: SUCCESS (1.759s)
[337.248901] [078/133] (689s left) api_intel_bb (reset-bb)
[337.310799] Starting subtest: reset-bb
[337.313231] Subtest reset-bb: SUCCESS (0.004s)
[337.431788] [079/133] (689s left) gem_exec_schedule (timeslicing)
[337.518609] Starting subtest: timeslicing
[337.520586] Starting dynamic subtest: rcs0
[337.530709] Dynamic subtest rcs0: SUCCESS (0.020s)
[337.542900] Starting dynamic subtest: bcs0
[337.550505] Dynamic subtest bcs0: SUCCESS (0.019s)
[337.560073] Starting dynamic subtest: vcs0
[337.571403] Dynamic subtest vcs0: SUCCESS (0.020s)
[337.580621] Starting dynamic subtest: vcs1
[337.592633] Dynamic subtest vcs1: SUCCESS (0.021s)
[337.601647] Starting dynamic subtest: vecs0
[337.613546] Dynamic subtest vecs0: SUCCESS (0.020s)
[337.622549] Starting dynamic subtest: ccs0
[337.632794] Dynamic subtest ccs0: SUCCESS (0.018s)
[337.635023] Subtest timeslicing: SUCCESS (0.124s)
[339.370744] [080/133] (687s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[339.461092] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[339.465211] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[339.533424] [081/133] (687s left) syncobj_eventfd (timeline-wait)
[339.598912] Starting subtest: timeline-wait
[339.607359] Subtest timeline-wait: SUCCESS (0.011s)
[339.684127] [082/133] (687s left) gem_ctx_persistence (heartbeat-close)
[339.739695] Starting subtest: heartbeat-close
[339.744323] Subtest heartbeat-close: SKIP (0.000s)
[339.851112] [083/133] (687s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[339.948690] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[339.952715] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[340.066732] [084/133] (687s left) kms_addfb_basic (no-handle)
[340.130676] Starting subtest: no-handle
[340.132666] Subtest no-handle: SUCCESS (0.000s)
[340.254776] [085/133] (686s left) syncobj_wait (single-wait-for-submit-signaled)
[340.314459] Starting subtest: single-wait-for-submit-signaled
[340.316698] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[340.413668] [086/133] (686s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[340.510476] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[340.536714] Starting dynamic subtest: pipe-A-plane-0
[340.825447] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[340.834971] Starting dynamic subtest: pipe-A-plane-3
[341.058707] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[341.070161] Starting dynamic subtest: pipe-A-plane-5
[341.073940] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[342.145838] Starting dynamic subtest: pipe-B-plane-0
[342.460360] Dynamic subtest pipe-B-plane-0: SUCCESS (0.322s)
[342.476055] Starting dynamic subtest: pipe-B-plane-3
[342.693321] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[342.703298] Starting dynamic subtest: pipe-B-plane-5
[342.707869] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[343.005957] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.494s)
[343.818060] [087/133] (683s left) gem_exec_whisper (basic-fds-all)
[343.886542] Starting subtest: basic-fds-all
[355.067728] Subtest basic-fds-all: SUCCESS (11.183s)
[355.254188] [088/133] (672s left) gem_eio (in-flight-suspend)
[355.517298] Starting subtest: in-flight-suspend
[398.394371] Subtest in-flight-suspend: SUCCESS (13.822s)
[398.537320] [089/133] (628s left) kms_cursor_crc (cursor-suspend)
[398.688321] Starting subtest: cursor-suspend
[398.691169] Starting dynamic subtest: pipe-A-eDP-1
[431.579135] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.071s)
[431.593252] Starting dynamic subtest: pipe-D-eDP-1
[465.555717] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.755s)
[465.558609] Subtest cursor-suspend: SUCCESS (6.829s)
[466.434670] [090/133] (560s left) gem_exec_parallel (engines)
[466.528337] Starting subtest: engines
[466.530652] Starting dynamic subtest: basic
[468.117948] Dynamic subtest basic: SUCCESS (1.545s)
[468.130316] Starting dynamic subtest: contexts
[472.158205] Dynamic subtest contexts: SUCCESS (3.958s)
[472.171844] Starting dynamic subtest: fds
[476.152077] Dynamic subtest fds: SUCCESS (3.943s)
[476.166933] Starting dynamic subtest: userptr
[478.102944] Dynamic subtest userptr: SUCCESS (1.933s)
[478.105792] Subtest engines: SUCCESS (11.384s)
[478.297145] [091/133] (549s left) perf (create-destroy-userspace-config)
[478.413605] Starting subtest: create-destroy-userspace-config
[478.432148] Subtest create-destroy-userspace-config: SUCCESS (0.020s)
[478.479900] [092/133] (548s left) kms_async_flips (test-time-stamp-atomic)
[478.573840] Starting subtest: test-time-stamp-atomic
[478.969298] Starting dynamic subtest: pipe-A-eDP-1
[479.736630] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.761s)
[480.123197] Starting dynamic subtest: pipe-B-eDP-1
[480.881389] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.764s)
[481.252805] Starting dynamic subtest: pipe-C-eDP-1
[482.014285] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.763s)
[482.382729] Starting dynamic subtest: pipe-D-eDP-1
[483.144100] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.765s)
[483.146599] Subtest test-time-stamp-atomic: SUCCESS (4.547s)
[484.311416] [093/133] (543s left) testdisplay
[484.634192] [094/133] (542s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[484.729439] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[484.731771] Starting dynamic subtest: pipe-A-eDP-1
[484.755906] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[484.768298] Starting dynamic subtest: pipe-B-eDP-1
[484.789772] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[484.800140] Starting dynamic subtest: pipe-C-eDP-1
[484.821811] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[484.832229] Starting dynamic subtest: pipe-D-eDP-1
[484.854337] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[484.858750] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[486.973769] [095/133] (540s left) gem_exec_schedule (pi-common)
[487.166974] Starting subtest: pi-common
[487.169695] Starting dynamic subtest: rcs0
[487.217287] Dynamic subtest rcs0: SUCCESS (0.052s)
[487.229737] Starting dynamic subtest: bcs0
[487.271927] Dynamic subtest bcs0: SUCCESS (0.054s)
[487.284626] Starting dynamic subtest: vcs0
[487.318908] Dynamic subtest vcs0: SUCCESS (0.046s)
[487.335355] Starting dynamic subtest: vcs1
[487.358438] Dynamic subtest vcs1: SUCCESS (0.039s)
[487.373100] Starting dynamic subtest: vecs0
[487.392468] Dynamic subtest vecs0: SUCCESS (0.033s)
[487.408248] Starting dynamic subtest: ccs0
[487.423732] Dynamic subtest ccs0: SUCCESS (0.030s)
[487.425927] Subtest pi-common: SUCCESS (0.260s)
[487.648800] [096/133] (539s left) gem_shrink (reclaim)
[487.701111] Starting subtest: reclaim
[490.183457] Subtest reclaim: SUCCESS (2.473s)
[490.330825] [097/133] (537s left) syncobj_wait (invalid-wait-bad-flags)
[490.379185] Starting subtest: invalid-wait-bad-flags
[490.381428] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[490.478649] [098/133] (537s left) kms_chamelium_audio (hdmi-audio-edid)
[490.859763] Subtest hdmi-audio-edid: SKIP (0.000s)
[491.689021] [099/133] (536s left) i915_query (query-topology-kernel-writes)
[491.745023] Starting subtest: query-topology-kernel-writes
[491.747331] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[491.874353] [100/133] (535s left) gem_create (create-ext-cpu-access-sanity-check)
[492.042523] Starting subtest: create-ext-cpu-access-sanity-check
[492.047442] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[492.120238] [101/133] (535s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[492.210104] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[496.480785] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.270s)
[497.613580] [102/133] (530s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[497.715269] Starting subtest: x-tiled-32bpp-rotate-90
[497.735122] Subtest x-tiled-32bpp-rotate-90: SKIP (0.019s)
[497.854226] [103/133] (530s left) kms_cursor_crc (cursor-onscreen-256x85)
[498.090429] Starting subtest: cursor-onscreen-256x85
[498.138972] Subtest cursor-onscreen-256x85: SKIP (0.043s)
[498.313086] [104/133] (529s left) gem_pxp (verify-pxp-stale-ctx-execution)
[498.427918] Starting subtest: verify-pxp-stale-ctx-execution
[499.494656] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.065s)
[499.631345] [105/133] (528s left) kms_lease (lease-invalid-plane)
[499.716078] Starting subtest: lease-invalid-plane
[499.718381] Starting dynamic subtest: pipe-A-eDP-1
[499.720594] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[499.733214] Starting dynamic subtest: pipe-B-eDP-1
[499.735706] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[499.749034] Starting dynamic subtest: pipe-C-eDP-1
[499.750952] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[499.761444] Starting dynamic subtest: pipe-D-eDP-1
[499.763379] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[499.765533] Subtest lease-invalid-plane: SUCCESS (0.004s)
[499.806936] [106/133] (528s left) syncobj_wait (multi-wait-all-signaled)
[499.865603] Starting subtest: multi-wait-all-signaled
[499.867842] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[500.001279] [107/133] (528s left) dmabuf_sync_file (export-before-signal)
[500.055720] Starting subtest: export-before-signal
[500.057982] Subtest export-before-signal: SUCCESS (0.001s)
[500.127142] [108/133] (528s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[500.219385] Starting subtest: fbc-rgb565-draw-render
[504.411421] Subtest fbc-rgb565-draw-render: SUCCESS (4.197s)
[505.596158] [109/133] (522s left) kms_chamelium_hpd (hdmi-hpd-fast)
[505.980849] Subtest hdmi-hpd-fast: SKIP (0.000s)
[506.791400] [110/133] (521s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[506.894251] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[506.898437] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[507.023780] [111/133] (521s left) gem_mmap_offset (blt-coherency)
[507.084899] Starting subtest: blt-coherency
[507.090566] Subtest blt-coherency: SUCCESS (0.008s)
[507.226951] [112/133] (521s left) gem_exec_fence (expired-history)
[507.651986] Starting subtest: expired-history
[514.850636] Subtest expired-history: SUCCESS (7.199s)
[515.512415] [113/133] (512s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[515.609437] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[515.614065] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[515.681594] [114/133] (512s left) gem_create (create-valid-nonaligned)
[515.739376] Starting subtest: create-valid-nonaligned
[515.741556] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[515.936886] [115/133] (512s left) gem_eio (suspend)
[516.172608] Starting subtest: suspend
[528.441417] Subtest suspend: SUCCESS (12.267s)
[528.604384] [116/133] (499s left) gem_ringfill (engines-basic)
[533.145519] Starting subtest: engines-basic
[533.148031] Starting dynamic subtest: rcs0
[533.208512] Dynamic subtest rcs0: SUCCESS (0.062s)
[533.222454] Starting dynamic subtest: bcs0
[533.252687] Dynamic subtest bcs0: SUCCESS (0.043s)
[533.267783] Starting dynamic subtest: vcs0
[533.293799] Dynamic subtest vcs0: SUCCESS (0.040s)
[533.306034] Starting dynamic subtest: vcs1
[533.336587] Dynamic subtest vcs1: SUCCESS (0.041s)
[533.348324] Starting dynamic subtest: vecs0
[533.380973] Dynamic subtest vecs0: SUCCESS (0.042s)
[533.393124] Starting dynamic subtest: ccs0
[533.426565] Dynamic subtest ccs0: SUCCESS (0.043s)
[533.429264] Subtest engines-basic: SUCCESS (0.283s)
[533.521900] [117/133] (495s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[533.577643] Starting subtest: multi-wait-for-submit-available-signaled
[533.579915] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[533.676319] [118/133] (494s left) syncobj_timeline (invalid-signal-illegal-handle)
[533.734688] Starting subtest: invalid-signal-illegal-handle
[533.737053] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[533.839241] [119/133] (494s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[533.945498] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[533.949547] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[534.050193] [120/133] (494s left) kms_psr (pr-basic)
[534.137969] Starting subtest: pr-basic
[534.142488] Subtest pr-basic: SKIP (0.000s)
[534.248100] [121/133] (494s left) kms_sequence (get-busy)
[534.343635] Starting subtest: get-busy
[534.345312] Starting dynamic subtest: pipe-A-eDP-1
[536.277718] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.934s)
[536.290751] Starting dynamic subtest: pipe-B-eDP-1
[538.884529] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.605s)
[538.897910] Starting dynamic subtest: pipe-C-eDP-1
[541.500613] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.612s)
[541.512353] Starting dynamic subtest: pipe-D-eDP-1
[544.121025] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.620s)
[544.123310] Subtest get-busy: SUCCESS (9.777s)
[544.926690] [122/133] (483s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[545.019906] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[545.022160] Starting dynamic subtest: pipe-A-eDP-1
[545.080909] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s)
[545.377599] Starting dynamic subtest: pipe-B-eDP-1
[546.223635] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.858s)
[546.513563] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.496s)
[547.385963] [123/133] (481s left) kms_psr (psr2-cursor-plane-onoff)
[547.497138] Starting subtest: psr2-cursor-plane-onoff
[547.499251] Starting dynamic subtest: eDP-1
[549.158149] Dynamic subtest eDP-1: SUCCESS (1.659s)
[549.160073] Subtest psr2-cursor-plane-onoff: SUCCESS (1.660s)
[549.945720] [124/133] (478s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[550.031051] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[550.035213] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[550.108079] [125/133] (478s left) gem_exec_reloc (basic-gtt-noreloc)
[550.166941] Subtest basic-gtt-noreloc: SKIP (0.000s)
[550.236804] [126/133] (478s left) vgem_basic (dmabuf-fence-before)
[550.277774] Starting subtest: dmabuf-fence-before
[550.279956] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[550.335906] [127/133] (478s left) sysfs_timeslice_duration (timeout)
[550.395059] Starting subtest: timeout
[550.397385] Starting dynamic subtest: vecs0
[560.147521] Dynamic subtest vecs0: SUCCESS (9.747s)
[560.161311] Starting dynamic subtest: ccs0
[561.465625] Dynamic subtest ccs0: SUCCESS (1.318s)
[561.479016] Starting dynamic subtest: vcs0
[571.153557] Dynamic subtest vcs0: SUCCESS (9.680s)
[571.167678] Starting dynamic subtest: bcs0
[571.826672] Dynamic subtest bcs0: SUCCESS (0.673s)
[571.840415] Starting dynamic subtest: rcs0
[573.132196] Dynamic subtest rcs0: SUCCESS (1.302s)
[573.146635] Starting dynamic subtest: vcs1
[583.126954] Dynamic subtest vcs1: SUCCESS (9.989s)
[583.129906] Subtest timeout: SUCCESS (32.723s)
[583.208697] [128/133] (445s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[583.308380] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[583.310360] Starting dynamic subtest: pipe-A-eDP-1
[599.275517] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.389s)
[599.287829] Starting dynamic subtest: pipe-B-eDP-1
[616.269295] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.432s)
[616.282046] Starting dynamic subtest: pipe-C-eDP-1
[633.236971] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.326s)
[633.249258] Starting dynamic subtest: pipe-D-eDP-1
[650.222623] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.306s)
[650.225364] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.459s)
[651.406445] [129/133] (377s left) kms_joiner (basic-ultra-joiner)
[651.518522] Starting subtest: basic-ultra-joiner
[651.523627] Subtest basic-ultra-joiner: SKIP (0.000s)
[651.613747] [130/133] (377s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[651.701173] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[651.703797] Starting dynamic subtest: pipe-A-eDP-1
[651.729149] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[651.743364] Starting dynamic subtest: pipe-B-eDP-1
[651.769353] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[651.781230] Starting dynamic subtest: pipe-C-eDP-1
[651.808127] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[651.821548] Starting dynamic subtest: pipe-D-eDP-1
[651.850906] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[651.856493] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[653.931859] [131/133] (375s left) gem_pread (exhaustion)
[653.992293] Subtest exhaustion: SKIP (0.000s)
[654.056428] [132/133] (375s left) kms_plane_cursor (primary)
[654.145688] Starting subtest: primary
[654.150149] Starting dynamic subtest: pipe-A-eDP-1-size-64
[657.162367] Dynamic subtest pipe-A-eDP-1-size-64: FAIL (2.454s)
[657.175180] Starting dynamic subtest: pipe-A-eDP-1-size-128
[659.276105] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.550s)
[659.303014] Starting dynamic subtest: pipe-A-eDP-1-size-256
[662.010306] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.686s)
[662.327353] Starting dynamic subtest: pipe-B-eDP-1-size-64
[665.696155] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.361s)
[665.722347] Starting dynamic subtest: pipe-B-eDP-1-size-128
[668.233770] Dynamic subtest pipe-B-eDP-1-size-128: FAIL (1.936s)
[668.257692] Starting dynamic subtest: pipe-B-eDP-1-size-256
[670.320079] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.605s)
[670.640322] Starting dynamic subtest: pipe-C-eDP-1-size-64
[673.536345] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.903s)
[673.565729] Starting dynamic subtest: pipe-C-eDP-1-size-128
[675.741101] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.181s)
[675.769922] Starting dynamic subtest: pipe-C-eDP-1-size-256
[678.563805] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.799s)
[678.886668] Starting dynamic subtest: pipe-D-eDP-1-size-64
[681.962343] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.087s)
[681.990677] Starting dynamic subtest: pipe-D-eDP-1-size-128
[684.558837] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.578s)
[684.587759] Starting dynamic subtest: pipe-D-eDP-1-size-256
[687.155123] Dynamic subtest pipe-D-eDP-1-size-256: FAIL (1.990s)
[687.157339] Subtest primary: FAIL (32.539s)
[687.730041] [133/133] (341s left) kms_properties (colorop-properties-atomic)
[687.819038] Starting subtest: colorop-properties-atomic
[687.821562] Starting dynamic subtest: pipe-A-eDP-1
[688.158316] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.339s)
[688.174375] Starting dynamic subtest: pipe-B-eDP-1
[689.200358] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.040s)
[689.213718] Starting dynamic subtest: pipe-C-eDP-1
[690.225999] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.022s)
[690.239040] Starting dynamic subtest: pipe-D-eDP-1
[691.251832] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.025s)
[691.254650] Subtest colorop-properties-atomic: SUCCESS (3.433s)
[692.042405] Closing watchdogs
results: parsing output: 0/ for test: syncobj_basic
results: parsing output: 1/ for test: i915_query
results: parsing output: 2/ for test: gem_ctx_create
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: vgem_basic
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: gem_ctx_isolation
results: parsing output: 7/ for test: kms_psr2_sf
results: parsing output: 8/ for test: syncobj_wait
results: parsing output: 9/ for test: i915_query
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: gen7_exec_parse
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: gem_basic
results: parsing output: 14/ for test: gem_eio
results: parsing output: 15/ for test: perf
results: parsing output: 16/ for test: kms_big_fb
results: parsing output: 17/ for test: gem_ctx_shared
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: kms_flip_scaled_crc
results: parsing output: 23/ for test: kms_setmode
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_addfb_basic
results: parsing output: 26/ for test: i915_module_load
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: gem_exec_suspend
results: parsing output: 29/ for test: i915_pm_rpm
results: parsing output: 30/ for test: kms_chamelium_frames
results: parsing output: 31/ for test: perf
results: parsing output: 32/ for test: gem_exec_whisper
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_pipe_crc_basic
results: parsing output: 37/ for test: gen9_exec_parse
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: sw_sync
results: parsing output: 40/ for test: gem_exec_balancer
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: api_intel_allocator
results: parsing output: 43/ for test: kms_content_protection
results: parsing output: 44/ for test: kms_pm_rpm
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_cursor_legacy
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: kms_pipe_b_c_ivb
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: perf
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: fbdev
results: parsing output: 53/ for test: perf_pmu
results: parsing output: 54/ for test: kms_pm_backlight
results: parsing output: 55/ for test: kms_psr2_sf
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_cursor_legacy
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_cursor_legacy
results: parsing output: 60/ for test: gem_lmem_swapping
results: parsing output: 61/ for test: gem_tiled_wb
results: parsing output: 62/ for test: kms_draw_crc
results: parsing output: 63/ for test: kms_color
results: parsing output: 64/ for test: vgem_basic
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_plane_scaling
results: parsing output: 68/ for test: kms_vblank
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: kms_rotation_crc
results: parsing output: 71/ for test: gem_softpin
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_atomic_interruptible
results: parsing output: 74/ for test: gem_exec_fence
results: parsing output: 75/ for test: i915_drm_fdinfo
results: parsing output: 76/ for test: kms_cursor_crc
results: parsing output: 77/ for test: api_intel_bb
results: parsing output: 78/ for test: gem_exec_schedule
results: parsing output: 79/ for test: kms_flip_scaled_crc
results: parsing output: 80/ for test: syncobj_eventfd
results: parsing output: 81/ for test: gem_ctx_persistence
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_addfb_basic
results: parsing output: 84/ for test: syncobj_wait
results: parsing output: 85/ for test: kms_plane
results: parsing output: 86/ for test: gem_exec_whisper
results: parsing output: 87/ for test: gem_eio
results: parsing output: 88/ for test: kms_cursor_crc
results: parsing output: 89/ for test: gem_exec_parallel
results: parsing output: 90/ for test: perf
results: parsing output: 91/ for test: kms_async_flips
results: parsing output: 92/ for test: testdisplay
results: parsing output: 93/ for test: kms_ccs
results: parsing output: 94/ for test: gem_exec_schedule
results: parsing output: 95/ for test: gem_shrink
results: parsing output: 96/ for test: syncobj_wait
results: parsing output: 97/ for test: kms_chamelium_audio
results: parsing output: 98/ for test: i915_query
results: parsing output: 99/ for test: gem_create
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_cursor_crc
results: parsing output: 103/ for test: gem_pxp
results: parsing output: 104/ for test: kms_lease
results: parsing output: 105/ for test: syncobj_wait
results: parsing output: 106/ for test: dmabuf_sync_file
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_chamelium_hpd
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: gem_mmap_offset
results: parsing output: 111/ for test: gem_exec_fence
results: parsing output: 112/ for test: kms_flip_scaled_crc
results: parsing output: 113/ for test: gem_create
results: parsing output: 114/ for test: gem_eio
results: parsing output: 115/ for test: gem_ringfill
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: kms_sequence
results: parsing output: 121/ for test: kms_atomic_transition
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: kms_plane
results: parsing output: 124/ for test: gem_exec_reloc
results: parsing output: 125/ for test: vgem_basic
results: parsing output: 126/ for test: sysfs_timeslice_duration
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: kms_joiner
results: parsing output: 129/ for test: kms_ccs
results: parsing output: 130/ for test: gem_pread
results: parsing output: 131/ for test: kms_plane_cursor
results: parsing output: 132/ for test: kms_properties
Done.