[57.370184] Initializing watchdogs
[57.370315]   /dev/watchdog0
[57.385014] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.389474] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.392273] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.395827] [001/155] (960s left) kms_feature_discovery (display)
[57.516297] Starting subtest: display
[57.518889] Subtest display: SUCCESS (0.000s)
[57.598395] [002/155] (960s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc)
[57.696406] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc
[57.700695] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[57.792611] [003/155] (960s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[57.909304] Starting subtest: basic-flip-after-cursor-varying-size
[58.890556] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.978s)
[59.701534] [004/155] (958s left) kms_plane_multiple (tiling-none)
[59.799164] Starting subtest: tiling-none
[59.801568] Starting dynamic subtest: pipe-A-eDP-1
[63.560072] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.761s)
[63.568310] Starting dynamic subtest: pipe-B-eDP-1
[68.019636] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.459s)
[68.028994] Starting dynamic subtest: pipe-C-eDP-1
[72.634555] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.614s)
[72.645682] Starting dynamic subtest: pipe-D-eDP-1
[77.089585] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.455s)
[77.091987] Subtest tiling-none: SUCCESS (17.293s)
[77.902448] [005/155] (940s left) kms_pm_rpm (package-g7)
[79.420332] Starting subtest: package-g7
[79.425947] Subtest package-g7: SKIP (0.000s)
[80.145237] [006/155] (937s left) kms_addfb_basic (invalid-set-prop-any)
[80.206034] Starting subtest: invalid-set-prop-any
[80.208237] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[80.369351] [007/155] (937s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-render)
[80.473978] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-render
[80.478615] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[80.559648] [008/155] (937s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[80.614895] Starting subtest: single-wait-all-for-submit-available-signaled
[80.617171] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[80.743192] [009/155] (937s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[80.829951] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[80.834261] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[80.908279] [010/155] (937s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[81.006194] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[81.010491] Subtest hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[81.101843] [011/155] (937s left) kms_plane_cursor (primary)
[81.196962] Starting subtest: primary
[81.200522] Starting dynamic subtest: pipe-A-eDP-1-size-64
[83.748696] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.551s)
[83.770485] Starting dynamic subtest: pipe-A-eDP-1-size-128
[86.349726] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.583s)
[86.373581] Starting dynamic subtest: pipe-A-eDP-1-size-256
[88.951468] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.584s)
[89.270932] Starting dynamic subtest: pipe-B-eDP-1-size-64
[92.535694] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.277s)
[92.558794] Starting dynamic subtest: pipe-B-eDP-1-size-128
[95.115032] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.561s)
[95.139790] Starting dynamic subtest: pipe-B-eDP-1-size-256
[97.661074] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.528s)
[97.980436] Starting dynamic subtest: pipe-C-eDP-1-size-64
[100.919068] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.947s)
[100.945339] Starting dynamic subtest: pipe-C-eDP-1-size-128
[103.164381] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.226s)
[103.188656] Starting dynamic subtest: pipe-C-eDP-1-size-256
[105.386272] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.203s)
[105.711714] Starting dynamic subtest: pipe-D-eDP-1-size-64
[108.653476] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.954s)
[108.679194] Starting dynamic subtest: pipe-D-eDP-1-size-128
[110.842436] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.170s)
[110.866865] Starting dynamic subtest: pipe-D-eDP-1-size-256
[113.020093] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.159s)
[113.322903] Subtest primary: SUCCESS (32.124s)
[114.199449] [012/155] (904s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[114.305633] Starting subtest: fbcpsr-modesetfrombusy
[120.692624] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.394s)
[120.841891] [013/155] (897s left) gem_linear_blits (interruptible)
[121.249147] Starting subtest: interruptible
[125.427192] Subtest interruptible: SUCCESS (4.177s)
[125.528199] [014/155] (892s left) kms_hdr (brightness-with-hdr)
[125.662035] Starting subtest: brightness-with-hdr
[125.664237] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[125.668154] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s)
[125.676638] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[125.681108] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s)
[125.685876] Subtest brightness-with-hdr: SKIP (0.003s)
[125.732112] [015/155] (892s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[125.829629] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[125.833768] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[125.945254] [016/155] (892s left) kms_addfb_basic (bad-pitch-999)
[125.997220] Starting subtest: bad-pitch-999
[125.999069] Subtest bad-pitch-999: SUCCESS (0.000s)
[126.139241] [017/155] (892s left) gem_pxp (fail-invalid-protected-context)
[126.257590] Starting subtest: fail-invalid-protected-context
[126.260218] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[126.372927] [018/155] (892s left) gem_ctx_param (invalid-param-get)
[126.420760] Starting subtest: invalid-param-get
[126.425542] Subtest invalid-param-get: SUCCESS (0.001s)
[126.539030] [019/155] (892s left) gem_mmap_gtt (big-bo)
[126.594802] Subtest big-bo: SKIP (0.000s)
[126.662833] [020/155] (891s left) kms_psr (fbc-psr2-dpms)
[126.757433] Starting subtest: fbc-psr2-dpms
[126.759426] Starting dynamic subtest: eDP-1
[126.762929] Dynamic subtest eDP-1: SKIP (0.000s)
[126.766540] Subtest fbc-psr2-dpms: SKIP (0.001s)
[126.826479] [021/155] (891s left) gem_ctx_persistence (hang)
[126.883140] Starting subtest: hang
[126.886950] Subtest hang: SKIP (0.000s)
[126.994516] [022/155] (891s left) gem_eio (in-flight-contexts-10ms)
[127.227348] Starting subtest: in-flight-contexts-10ms
[141.346724] Subtest in-flight-contexts-10ms: SUCCESS (14.117s)
[141.528388] [023/155] (877s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[141.623630] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[141.627808] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[141.702510] [024/155] (877s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[141.802965] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[141.807430] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[141.898301] [025/155] (876s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[141.995567] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[141.999736] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[142.083958] [026/155] (876s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-blt)
[142.182648] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-blt
[142.187039] Subtest hdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[142.271196] [027/155] (876s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[142.365107] Starting subtest: psr-rgb565-draw-blt
[149.681518] Subtest psr-rgb565-draw-blt: SUCCESS (7.321s)
[149.795652] [028/155] (869s left) gem_mmap_gtt (cpuset-basic-small-copy)
[149.842293] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[149.905910] [029/155] (869s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[150.003951] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[157.032909] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.033s)
[157.143424] [030/155] (861s left) kms_lease (lease-invalid-crtc)
[157.235053] Starting subtest: lease-invalid-crtc
[157.237370] Starting dynamic subtest: pipe-A-eDP-1
[157.239698] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[157.248336] Starting dynamic subtest: pipe-B-eDP-1
[157.250689] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[157.259102] Starting dynamic subtest: pipe-C-eDP-1
[157.261418] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[157.269354] Starting dynamic subtest: pipe-D-eDP-1
[157.271316] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[157.273261] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[157.308734] [031/155] (861s left) gem_workarounds (suspend-resume-context)
[157.376653] Starting subtest: suspend-resume-context
[173.750064] Subtest suspend-resume-context: SUCCESS (1.335s)
[173.904826] [032/155] (845s left) kms_addfb_basic (bo-too-small)
[174.009460] Starting subtest: bo-too-small
[174.011326] Subtest bo-too-small: SUCCESS (0.000s)
[174.123073] [033/155] (845s left) perf (disabled-read-error)
[174.276437] Starting subtest: disabled-read-error
[174.287926] Subtest disabled-read-error: SUCCESS (0.015s)
[174.329474] [034/155] (844s left) gen7_exec_parse (load-register-reg)
[174.390071] Subtest load-register-reg: SKIP (0.000s)
[174.450193] [035/155] (844s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[174.559754] Starting subtest: 2x-long-cursor-vs-flip-atomic
[174.564259] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[174.705861] [036/155] (844s left) gem_exec_whisper (basic-forked-all)
[174.778571] Starting subtest: basic-forked-all
[188.349783] Subtest basic-forked-all: SUCCESS (13.568s)
[188.563682] [037/155] (830s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[188.680539] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[188.685114] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[188.781175] [038/155] (830s left) kms_joiner (basic-force-ultra-joiner)
[188.877261] Starting subtest: basic-force-ultra-joiner
[188.881566] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[188.945772] [039/155] (830s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[189.046912] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[189.049098] Starting dynamic subtest: pipe-A
[189.174559] Dynamic subtest pipe-A: SKIP (0.124s)
[189.186022] Starting dynamic subtest: pipe-B
[190.391916] Dynamic subtest pipe-B: SKIP (1.216s)
[190.401796] Starting dynamic subtest: pipe-C
[191.627417] Dynamic subtest pipe-C: SUCCESS (1.240s)
[191.645038] Starting dynamic subtest: pipe-D
[192.858804] Dynamic subtest pipe-D: SUCCESS (1.230s)
[192.861004] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.814s)
[194.061234] [040/155] (825s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier)
[194.166220] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier
[194.170610] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier: SKIP (0.000s)
[194.247101] [041/155] (825s left) kms_properties (crtc-properties-atomic)
[194.338070] Starting subtest: crtc-properties-atomic
[194.339975] Starting dynamic subtest: pipe-A-eDP-1
[194.803443] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.465s)
[194.815751] Starting dynamic subtest: pipe-B-eDP-1
[196.021520] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.216s)
[196.032413] Starting dynamic subtest: pipe-C-eDP-1
[197.146722] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.126s)
[197.157604] Starting dynamic subtest: pipe-D-eDP-1
[198.281766] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.132s)
[198.283709] Subtest crtc-properties-atomic: SUCCESS (3.944s)
[199.097187] [042/155] (820s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[199.206494] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[206.555508] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.353s)
[206.665947] [043/155] (812s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[206.829459] Starting subtest: cursor-rapid-movement-32x10
[206.871166] Subtest cursor-rapid-movement-32x10: SKIP (0.040s)
[207.137780] [044/155] (812s left) syncobj_timeline (signal)
[207.198936] Starting subtest: signal
[207.201091] Subtest signal: SUCCESS (0.000s)
[207.308774] [045/155] (812s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[207.368824] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[207.373501] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[207.554974] [046/155] (812s left) kms_psr (psr-cursor-render)
[207.650517] Starting subtest: psr-cursor-render
[207.652887] Starting dynamic subtest: eDP-1
[209.428471] Dynamic subtest eDP-1: SUCCESS (1.777s)
[209.430654] Subtest psr-cursor-render: SUCCESS (1.778s)
[210.288252] [047/155] (809s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[210.391867] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[210.395855] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[210.485415] [048/155] (809s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[210.600869] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[210.605448] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[210.754758] [049/155] (809s left) kms_cursor_edge_walk (64x64-right-edge)
[210.851442] Starting subtest: 64x64-right-edge
[210.853791] Starting dynamic subtest: pipe-A-eDP-1
[214.364777] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.513s)
[214.375009] Starting dynamic subtest: pipe-D-eDP-1
[217.503824] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.137s)
[217.506319] Subtest 64x64-right-edge: SUCCESS (6.654s)
[218.326198] [050/155] (801s left) gen3_mixed_blits
[218.442520] [051/155] (801s left) gem_exec_fence (keep-in-fence)
[218.618169] Starting subtest: keep-in-fence
[218.620607] Starting dynamic subtest: rcs0
[218.671675] Dynamic subtest rcs0: SUCCESS (0.053s)
[218.684310] Starting dynamic subtest: bcs0
[218.725645] Dynamic subtest bcs0: SUCCESS (0.051s)
[218.743712] Starting dynamic subtest: vcs0
[220.352075] Dynamic subtest vcs0: SUCCESS (1.622s)
[220.365006] Starting dynamic subtest: vcs1
[222.333495] Dynamic subtest vcs1: SUCCESS (1.979s)
[222.347494] Starting dynamic subtest: vecs0
[224.317525] Dynamic subtest vecs0: SUCCESS (1.981s)
[224.331892] Starting dynamic subtest: ccs0
[224.557042] Dynamic subtest ccs0: SUCCESS (0.238s)
[224.559959] Subtest keep-in-fence: SUCCESS (5.938s)
[226.376712] [FACT gem_exec_fence (keep-in-fence)] new: kernel.kmod_is_loaded.vgem: true
[226.380364] [052/155] (793s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite)
[226.485936] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite
[226.490069] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[226.599318] [053/155] (793s left) kms_vblank (wait-busy-hang)
[226.699325] Starting subtest: wait-busy-hang
[226.701228] Starting dynamic subtest: pipe-A-eDP-1
[253.115402] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.412s)
[253.132893] Starting dynamic subtest: pipe-D-eDP-1
[278.073518] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.953s)
[278.075889] Subtest wait-busy-hang: SUCCESS (51.371s)
[278.975767] [054/155] (740s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[279.075469] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-mmap-wc
[279.079853] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[279.169472] [055/155] (740s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-render)
[279.270697] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-render
[279.275071] Subtest hdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[279.378654] [056/155] (740s left) api_intel_allocator (reloc-allocator)
[279.427575] Starting subtest: reloc-allocator
[279.430052] Starting dynamic subtest: basic
[279.434582] Dynamic subtest basic: SUCCESS (0.005s)
[279.444651] Starting dynamic subtest: parallel-one
[279.446796] Dynamic subtest parallel-one: SUCCESS (0.008s)
[279.456556] Starting dynamic subtest: print
[279.458931] Dynamic subtest print: SUCCESS (0.000s)
[279.468704] Starting dynamic subtest: reuse
[279.470888] Dynamic subtest reuse: SUCCESS (0.000s)
[279.480523] Starting dynamic subtest: fork-reopen-allocator
[279.482654] Dynamic subtest fork-reopen-allocator: SUCCESS (0.014s)
[279.484841] Subtest reloc-allocator: SUCCESS (0.031s)
[279.599654] [057/155] (740s left) gem_ctx_persistence (engines-cleanup)
[279.656914] Starting subtest: engines-cleanup
[279.659295] Starting dynamic subtest: rcs0
[279.692671] Dynamic subtest rcs0: SUCCESS (0.036s)
[279.703269] Starting dynamic subtest: bcs0
[279.768761] Dynamic subtest bcs0: SUCCESS (0.075s)
[279.781523] Starting dynamic subtest: vcs0
[279.809930] Dynamic subtest vcs0: SUCCESS (0.039s)
[279.823317] Starting dynamic subtest: vcs1
[279.848905] Dynamic subtest vcs1: SUCCESS (0.037s)
[279.860312] Starting dynamic subtest: vecs0
[279.886441] Dynamic subtest vecs0: SUCCESS (0.036s)
[279.899090] Starting dynamic subtest: ccs0
[279.936374] Dynamic subtest ccs0: SUCCESS (0.048s)
[279.938510] Subtest engines-cleanup: SUCCESS (0.281s)
[280.016664] [058/155] (740s left) perf_pmu (rc6-suspend)
[280.058479] Starting subtest: rc6-suspend
[302.895262] Subtest rc6-suspend: SUCCESS (8.189s)
[303.810644] [059/155] (716s left) gem_partial_pwrite_pread (reads-uncached)
[303.883009] Subtest reads-uncached: SKIP (0.000s)
[303.964711] [060/155] (716s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[304.062145] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[304.065921] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[304.168072] [061/155] (716s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[304.273372] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[304.276856] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[304.370430] [062/155] (715s left) gem_exec_reloc (basic-wc-cpu-active)
[304.430002] Subtest basic-wc-cpu-active: SKIP (0.000s)
[304.502327] [063/155] (715s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[304.885328] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[305.709901] [064/155] (714s left) kms_scaling_modes (scaling-mode-full-aspect)
[305.809775] Starting subtest: scaling-mode-full-aspect
[305.812167] Starting dynamic subtest: pipe-A-eDP-1
[305.903746] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.096s)
[305.914352] Starting dynamic subtest: pipe-B-eDP-1
[307.053415] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.147s)
[307.070670] Starting dynamic subtest: pipe-C-eDP-1
[308.262051] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.205s)
[308.273426] Starting dynamic subtest: pipe-D-eDP-1
[309.406794] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.143s)
[309.409175] Subtest scaling-mode-full-aspect: SUCCESS (3.598s)
[310.559414] [065/155] (709s left) gem_exec_schedule (u-independent)
[310.637020] Starting subtest: u-independent
[310.638928] Starting dynamic subtest: rcs0
[311.982739] Dynamic subtest rcs0: SUCCESS (1.354s)
[311.996094] Starting dynamic subtest: vcs0
[313.964449] Dynamic subtest vcs0: SUCCESS (1.978s)
[313.985008] Starting dynamic subtest: vcs1
[315.962789] Dynamic subtest vcs1: SUCCESS (1.997s)
[315.976839] Starting dynamic subtest: vecs0
[318.020378] Dynamic subtest vecs0: SUCCESS (2.054s)
[318.033018] Starting dynamic subtest: ccs0
[319.981647] Dynamic subtest ccs0: SUCCESS (1.958s)
[319.984333] Subtest u-independent: SUCCESS (9.352s)
[320.289154] [066/155] (700s left) kms_vblank (crtc-id)
[320.382404] Starting subtest: crtc-id
[320.384348] Starting dynamic subtest: pipe-A-eDP-1
[320.833823] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.453s)
[320.849695] Starting dynamic subtest: pipe-D-eDP-1
[321.989521] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.152s)
[321.991933] Subtest crtc-id: SUCCESS (1.608s)
[322.830760] [067/155] (697s left) kms_frontbuffer_tracking (fbchdr-tiling-4)
[322.933886] Starting subtest: fbchdr-tiling-4
[322.938125] Subtest fbchdr-tiling-4: SKIP (0.000s)
[323.039140] [068/155] (697s left) kms_color_pipeline (plane-lut1d)
[323.141126] Starting subtest: plane-lut1d
[323.290509] Starting dynamic subtest: pipe-A-plane-0
[323.443568] Dynamic subtest pipe-A-plane-0: SUCCESS (0.155s)
[323.456819] Starting dynamic subtest: pipe-A-plane-1
[323.576763] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[323.587885] Starting dynamic subtest: pipe-A-plane-2
[323.722502] Dynamic subtest pipe-A-plane-2: SUCCESS (0.143s)
[324.967008] Starting dynamic subtest: pipe-B-plane-0
[325.146623] Dynamic subtest pipe-B-plane-0: SUCCESS (0.188s)
[325.157665] Starting dynamic subtest: pipe-B-plane-1
[325.335749] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s)
[325.346701] Starting dynamic subtest: pipe-B-plane-2
[325.513826] Dynamic subtest pipe-B-plane-2: SUCCESS (0.177s)
[326.754011] Starting dynamic subtest: pipe-C-plane-0
[326.889697] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[326.901059] Starting dynamic subtest: pipe-C-plane-1
[327.056294] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[327.067424] Starting dynamic subtest: pipe-C-plane-2
[327.201405] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[328.396532] Starting dynamic subtest: pipe-D-plane-0
[328.554879] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[328.575274] Starting dynamic subtest: pipe-D-plane-1
[328.687050] Dynamic subtest pipe-D-plane-1: SUCCESS (0.132s)
[328.698400] Starting dynamic subtest: pipe-D-plane-2
[328.842735] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[329.140201] Subtest plane-lut1d: SUCCESS (5.996s)
[329.977786] [069/155] (690s left) gem_ccs (large-ctrl-surf-copy)
[330.035403] Starting subtest: large-ctrl-surf-copy
[330.040156] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[330.135658] [070/155] (690s left) kms_chamelium_frames (dp-crc-fast)
[330.538835] Subtest dp-crc-fast: SKIP (0.000s)
[331.392951] [071/155] (689s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[331.489517] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[331.491795] Starting dynamic subtest: pipe-A-eDP-1
[331.515060] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[331.528374] Starting dynamic subtest: pipe-B-eDP-1
[331.550154] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[331.562552] Starting dynamic subtest: pipe-C-eDP-1
[331.584090] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[331.594064] Starting dynamic subtest: pipe-D-eDP-1
[331.615378] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[331.619569] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.007s)
[333.774842] [072/155] (686s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-pwrite)
[333.878298] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-pwrite
[333.882366] Subtest hdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[333.965575] [073/155] (686s left) gem_exec_balancer (persistence)
[334.223667] Starting subtest: persistence
[335.133184] Subtest persistence: SUCCESS (0.909s)
[335.259064] [074/155] (685s left) gem_softpin (evict-prime-sanity-check)
[335.318814] Starting subtest: evict-prime-sanity-check
[335.321197] Starting dynamic subtest: rcs0
[336.475389] Dynamic subtest rcs0: SUCCESS (1.156s)
[336.485983] Starting dynamic subtest: bcs0
[337.592802] Dynamic subtest bcs0: SUCCESS (1.114s)
[337.605189] Starting dynamic subtest: vcs0
[338.984011] Dynamic subtest vcs0: SUCCESS (1.389s)
[338.999972] Starting dynamic subtest: vcs1
[340.991070] Dynamic subtest vcs1: SUCCESS (2.005s)
[341.005703] Starting dynamic subtest: vecs0
[342.947908] Dynamic subtest vecs0: SUCCESS (1.953s)
[342.960578] Starting dynamic subtest: ccs0
[344.078049] Dynamic subtest ccs0: SUCCESS (1.128s)
[344.094122] Starting dynamic subtest: all
[345.185475] Dynamic subtest all: SUCCESS (1.105s)
[345.188088] Subtest evict-prime-sanity-check: SUCCESS (9.865s)
[345.270040] [075/155] (675s left) gem_ctx_exec (basic-nohangcheck)
[345.331826] Starting subtest: basic-nohangcheck
[345.678407] Subtest basic-nohangcheck: SUCCESS (0.349s)
[345.810631] [076/155] (675s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[345.904665] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[345.906953] Starting dynamic subtest: pipe-A-eDP-1
[352.565539] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.666s)
[352.576372] Starting dynamic subtest: pipe-B-eDP-1
[359.778906] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.209s)
[359.781185] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.878s)
[360.644405] [077/155] (660s left) kms_cursor_crc (cursor-size-change)
[360.741371] Starting subtest: cursor-size-change
[360.743688] Starting dynamic subtest: pipe-A-eDP-1
[361.545168] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.804s)
[361.555485] Starting dynamic subtest: pipe-D-eDP-1
[362.992812] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.446s)
[362.995377] Subtest cursor-size-change: SUCCESS (2.252s)
[363.829823] [078/155] (657s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[363.936705] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc
[363.940697] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[364.029153] [079/155] (656s left) kms_psr (pr-sprite-render)
[364.121692] Starting subtest: pr-sprite-render
[364.126016] Subtest pr-sprite-render: SKIP (0.000s)
[364.210764] [080/155] (656s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[364.296581] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[364.298894] Starting dynamic subtest: pipe-A-eDP-1
[364.321468] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[364.333817] Starting dynamic subtest: pipe-B-eDP-1
[364.354576] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[364.364240] Starting dynamic subtest: pipe-C-eDP-1
[364.385450] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[364.395379] Starting dynamic subtest: pipe-D-eDP-1
[364.417829] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[364.422202] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.007s)
[366.564961] [081/155] (654s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[366.684371] Starting subtest: cursorB-vs-flipB-varying-size
[366.689066] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[366.844723] [082/155] (654s left) gem_exec_reloc (basic-cpu-noreloc)
[366.902679] Subtest basic-cpu-noreloc: SKIP (0.000s)
[366.984053] [083/155] (654s left) kms_content_protection (dp-mst-type-0)
[367.122287] Starting subtest: dp-mst-type-0
[367.127023] Subtest dp-mst-type-0: SKIP (0.000s)
[367.250177] [084/155] (653s left) kms_big_fb (x-tiled-addfb)
[367.354681] Starting subtest: x-tiled-addfb
[367.356884] Subtest x-tiled-addfb: SUCCESS (0.000s)
[367.454267] [085/155] (653s left) gem_exec_fence (syncobj-timeline-unused-fence)
[368.022806] Starting subtest: syncobj-timeline-unused-fence
[368.029376] Subtest syncobj-timeline-unused-fence: SUCCESS (0.007s)
[369.030831] [086/155] (652s left) gem_render_copy (linear-to-vebox-yf-tiled)
[369.093970] Starting subtest: linear-to-vebox-yf-tiled
[369.098198] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[369.273023] [087/155] (652s left) kms_flip (flip-vs-expired-vblank)
[369.366586] Starting subtest: flip-vs-expired-vblank
[369.368947] Starting dynamic subtest: A-eDP1
[378.071866] Dynamic subtest A-eDP1: SUCCESS (8.703s)
[378.085464] Starting dynamic subtest: B-eDP1
[386.713257] Dynamic subtest B-eDP1: SUCCESS (8.636s)
[386.725062] Starting dynamic subtest: C-eDP1
[395.338273] Dynamic subtest C-eDP1: SUCCESS (8.622s)
[395.351246] Starting dynamic subtest: D-eDP1
[403.973093] Dynamic subtest D-eDP1: SUCCESS (8.636s)
[403.975462] Subtest flip-vs-expired-vblank: SUCCESS (34.607s)
[405.133382] [088/155] (616s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[405.244093] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[406.248471] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.004s)
[406.385188] [089/155] (615s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[406.478160] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[407.464539] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.987s)
[407.601333] [090/155] (613s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-blt)
[407.700035] Starting subtest: fbcpsrhdr-rgb101010-draw-blt
[407.704476] Subtest fbcpsrhdr-rgb101010-draw-blt: SKIP (0.000s)
[407.805725] [091/155] (613s left) kms_atomic_transition (modeset-transition-fencing)
[407.907164] Starting subtest: modeset-transition-fencing
[407.908822] Starting dynamic subtest: 1x-outputs
[419.044955] Dynamic subtest 1x-outputs: SUCCESS (11.140s)
[419.047555] Subtest modeset-transition-fencing: SUCCESS (11.142s)
[419.897898] [092/155] (601s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[419.960808] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[420.019349] [093/155] (601s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[420.114652] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[425.486184] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.379s)
[426.693903] [094/155] (594s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-plflip-blt)
[426.799878] Starting subtest: fbchdr-2p-primscrn-shrfb-plflip-blt
[426.804174] Subtest fbchdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[426.914489] [095/155] (594s left) kms_chamelium_color (ctm-limited-range)
[427.002263] Subtest ctm-limited-range: SKIP (0.000s)
[427.048132] [096/155] (594s left) gem_gpgpu_fill (offset-16x16)
[427.102562] Starting subtest: offset-16x16
[427.107623] Subtest offset-16x16: SUCCESS (0.007s)
[427.259119] [097/155] (594s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[427.356646] Starting subtest: y-tiled-8bpp-rotate-270
[427.360976] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[427.455668] [098/155] (594s left) i915_module_load (reload)
[427.489327] Starting subtest: reload
[433.596778] Subtest reload: SUCCESS (6.109s)
[433.639497] [099/155] (588s left) gem_exec_schedule (preempt)
[434.983411] Starting subtest: preempt
[434.985759] Starting dynamic subtest: rcs0
[435.007396] Dynamic subtest rcs0: SUCCESS (0.024s)
[435.021033] Starting dynamic subtest: bcs0
[435.028433] Dynamic subtest bcs0: SUCCESS (0.020s)
[435.041878] Starting dynamic subtest: vcs0
[435.049456] Dynamic subtest vcs0: SUCCESS (0.019s)
[435.062429] Starting dynamic subtest: vcs1
[435.068483] Dynamic subtest vcs1: SUCCESS (0.020s)
[435.080124] Starting dynamic subtest: vecs0
[435.092344] Dynamic subtest vecs0: SUCCESS (0.023s)
[435.103278] Starting dynamic subtest: ccs0
[435.113926] Dynamic subtest ccs0: SUCCESS (0.021s)
[435.116241] Subtest preempt: SUCCESS (0.131s)
[437.078027] [100/155] (584s left) vgem_basic (busy-fence)
[437.122736] Starting subtest: busy-fence
[437.124685] Subtest busy-fence: SUCCESS (0.000s)
[437.184105] [101/155] (584s left) gem_userptr_blits (usage-restrictions)
[437.256075] Starting subtest: usage-restrictions
[437.257951] Subtest usage-restrictions: SUCCESS (0.000s)
[437.413778] [102/155] (584s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[437.514009] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[438.137848] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.625s)
[438.311856] [103/155] (583s left) kms_flip (plain-flip-ts-check)
[438.400249] Starting subtest: plain-flip-ts-check
[438.402721] Starting dynamic subtest: A-eDP1
[447.348475] Dynamic subtest A-eDP1: SUCCESS (8.951s)
[447.361694] Starting dynamic subtest: B-eDP1
[456.194156] Dynamic subtest B-eDP1: SUCCESS (8.843s)
[456.206924] Starting dynamic subtest: C-eDP1
[465.012940] Dynamic subtest C-eDP1: SUCCESS (8.818s)
[465.024787] Starting dynamic subtest: D-eDP1
[473.846297] Dynamic subtest D-eDP1: SUCCESS (8.832s)
[473.848638] Subtest plain-flip-ts-check: SUCCESS (35.453s)
[475.044638] [104/155] (547s left) syncobj_timeline (host-signal-points)
[475.108878] Starting subtest: host-signal-points
[475.111380] Subtest host-signal-points: SUCCESS (0.004s)
[475.216937] [105/155] (546s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[475.278333] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[475.358568] [106/155] (546s left) prime_vgem (shrink)
[475.442150] Starting subtest: shrink
[475.457772] Subtest shrink: SUCCESS (0.016s)
[475.566961] [107/155] (546s left) kms_frontbuffer_tracking (fbchdr-2p-shrfb-fliptrack-mmap-gtt)
[475.661574] Starting subtest: fbchdr-2p-shrfb-fliptrack-mmap-gtt
[475.665676] Subtest fbchdr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[475.767179] [108/155] (546s left) gem_ctx_param (non-root-set)
[475.820404] Starting subtest: non-root-set
[475.837664] Subtest non-root-set: SUCCESS (0.017s)
[475.962589] [109/155] (546s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[476.061324] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[476.064857] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[476.164544] [110/155] (546s left) kms_frontbuffer_tracking (fbchdr-2p-pri-indfb-multidraw)
[476.258674] Starting subtest: fbchdr-2p-pri-indfb-multidraw
[476.262090] Subtest fbchdr-2p-pri-indfb-multidraw: SKIP (0.000s)
[476.352072] [111/155] (546s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-msflip-blt)
[476.452735] Starting subtest: hdr-2p-primscrn-shrfb-msflip-blt
[476.456405] Subtest hdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[476.561679] [112/155] (545s left) perf_pmu (busy-accuracy-50)
[476.601404] Starting subtest: busy-accuracy-50
[476.603301] Starting dynamic subtest: rcs0
[478.137381] Dynamic subtest rcs0: SUCCESS (1.532s)
[478.148184] Starting dynamic subtest: bcs0
[479.683960] Dynamic subtest bcs0: SUCCESS (1.544s)
[479.696631] Starting dynamic subtest: vcs0
[481.227690] Dynamic subtest vcs0: SUCCESS (1.541s)
[481.238643] Starting dynamic subtest: vcs1
[482.772197] Dynamic subtest vcs1: SUCCESS (1.542s)
[482.784574] Starting dynamic subtest: vecs0
[484.311017] Dynamic subtest vecs0: SUCCESS (1.537s)
[484.324252] Starting dynamic subtest: ccs0
[485.862299] Dynamic subtest ccs0: SUCCESS (1.547s)
[485.864843] Subtest busy-accuracy-50: SUCCESS (9.259s)
[485.990735] [113/155] (536s left) gem_exec_reloc (basic-gtt-active)
[486.045757] Subtest basic-gtt-active: SKIP (0.000s)
[486.114013] [114/155] (536s left) gem_userptr_blits (create-destroy-sync)
[486.191202] Starting subtest: create-destroy-sync
[491.205944] Subtest create-destroy-sync: SUCCESS (5.014s)
[491.341783] [115/155] (531s left) kms_pm_dc (dc5-dpms-negative)
[492.445694] Starting subtest: dc5-dpms-negative
[492.450279] Subtest dc5-dpms-negative: SKIP (0.000s)
[492.519367] [116/155] (530s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[492.617756] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[492.620001] Starting dynamic subtest: pipe-A-eDP-1
[492.639761] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[492.650747] Starting dynamic subtest: pipe-B-eDP-1
[492.670765] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.025s)
[492.680532] Starting dynamic subtest: pipe-C-eDP-1
[492.701084] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.019s)
[492.712992] Starting dynamic subtest: pipe-D-eDP-1
[492.733675] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s)
[492.735933] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.091s)
[495.002076] [117/155] (527s left) sw_sync (alloc_fence)
[495.051712] Starting subtest: alloc_fence
[495.053635] Subtest alloc_fence: SUCCESS (0.000s)
[495.110956] [118/155] (527s left) kms_cursor_crc (cursor-offscreen-512x170)
[495.392041] Starting subtest: cursor-offscreen-512x170
[495.396319] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[495.542822] [119/155] (527s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[495.641818] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-mmap-wc
[495.645780] Subtest fbchdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[495.726485] [120/155] (527s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-move)
[495.825587] Starting subtest: psrhdr-1p-primscrn-cur-indfb-move
[495.829783] Subtest psrhdr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[495.923416] [121/155] (526s left) kms_universal_plane (universal-plane-pageflip-windowed)
[496.020005] Starting subtest: universal-plane-pageflip-windowed
[496.021825] Starting dynamic subtest: pipe-A-eDP-1
[496.565180] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.543s)
[496.578741] Starting dynamic subtest: pipe-B-eDP-1
[497.805146] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.239s)
[497.815630] Starting dynamic subtest: pipe-C-eDP-1
[499.005111] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.200s)
[499.016782] Starting dynamic subtest: pipe-D-eDP-1
[500.252048] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.244s)
[500.254468] Subtest universal-plane-pageflip-windowed: SUCCESS (4.231s)
[501.125467] [122/155] (521s left) gem_mmap_gtt (zero-extend)
[501.191263] Subtest zero-extend: SKIP (0.000s)
[501.252566] [123/155] (521s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[501.348683] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[501.352794] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[501.456758] [124/155] (521s left) kms_psr (fbc-psr-sprite-plane-move)
[501.548880] Starting subtest: fbc-psr-sprite-plane-move
[501.551297] Starting dynamic subtest: eDP-1
[501.555565] Dynamic subtest eDP-1: SKIP (0.000s)
[501.559933] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[501.638238] [125/155] (521s left) gem_exec_reloc (basic-write-wc-active)
[501.693538] Subtest basic-write-wc-active: SKIP (0.000s)
[501.768409] [126/155] (521s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[501.821928] Starting subtest: etime-multi-wait-all-available-unsubmitted
[501.929658] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.107s)
[502.017677] [127/155] (521s left) gem_ctx_sseu (invalid-args)
[502.078300] Subtest invalid-args: SKIP (0.000s)
[502.154036] [128/155] (520s left) i915_drm_fdinfo (memory-info-active)
[502.194382] Starting subtest: memory-info-active
[502.196927] Starting dynamic subtest: smem0
[504.826674] Dynamic subtest smem0: SUCCESS (2.634s)
[504.829134] Subtest memory-info-active: SUCCESS (2.636s)
[504.917480] [129/155] (518s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-move)
[505.017020] Starting subtest: psrhdr-2p-primscrn-cur-indfb-move
[505.020648] Subtest psrhdr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[505.123735] [130/155] (518s left) kms_pm_dc (dc3co-after-dc6)
[506.212694] Starting subtest: dc3co-after-dc6
[506.215077] Starting dynamic subtest: psr2
[506.219717] Dynamic subtest psr2: SKIP (0.000s)
[506.230481] Starting dynamic subtest: pr
[506.234780] Dynamic subtest pr: SKIP (0.000s)
[506.239107] Subtest dc3co-after-dc6: SKIP (0.001s)
[506.285838] [131/155] (516s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[506.392834] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[506.396888] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[506.465232] [132/155] (516s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[506.564772] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[506.568992] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[506.663240] [133/155] (516s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[506.753698] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[506.758131] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[506.839012] [134/155] (516s left) gem_exec_balancer (fairslice)
[506.894119] Starting subtest: fairslice
[509.820058] Subtest fairslice: SUCCESS (2.924s)
[511.029588] [135/155] (512s left) api_intel_bb (lot-of-buffers)
[511.083539] Starting subtest: lot-of-buffers
[512.144352] Subtest lot-of-buffers: SUCCESS (1.062s)
[513.015493] [136/155] (510s left) kms_properties (plane-properties-legacy)
[513.111368] Starting subtest: plane-properties-legacy
[513.113500] Starting dynamic subtest: pipe-A-eDP-1
[513.658929] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.548s)
[513.670701] Starting dynamic subtest: pipe-B-eDP-1
[514.909953] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.248s)
[514.920872] Starting dynamic subtest: pipe-C-eDP-1
[516.155177] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.244s)
[516.165725] Starting dynamic subtest: pipe-D-eDP-1
[517.399799] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.245s)
[517.402360] Subtest plane-properties-legacy: SUCCESS (4.290s)
[518.218459] [137/155] (505s left) i915_pm_rps (min-max-config-loaded)
[518.279813] Starting subtest: min-max-config-loaded
[518.284231] Subtest min-max-config-loaded: SKIP (0.001s)
[518.407124] [138/155] (505s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[518.512286] Starting subtest: psr-2p-pri-indfb-multidraw
[518.516764] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[518.636282] [139/155] (504s left) dmabuf_sync_file (export-multiwait)
[518.685732] Starting subtest: export-multiwait
[518.688025] Subtest export-multiwait: SUCCESS (0.001s)
[518.744213] [140/155] (504s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[518.856112] Starting subtest: yf-tiled-addfb-size-offset-overflow
[518.860199] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[518.949319] [141/155] (504s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[519.054577] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[526.070580] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (7.020s)
[526.208575] [142/155] (497s left) core_auth (basic-auth)
[526.267360] Starting subtest: basic-auth
[526.269873] Subtest basic-auth: SUCCESS (0.001s)
[526.372556] [143/155] (497s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[526.480414] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[526.484629] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[526.586437] [144/155] (497s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[526.675809] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[526.677704] Starting dynamic subtest: pipe-A-eDP-1
[558.974691] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.545s)
[558.985287] Starting dynamic subtest: pipe-B-eDP-1
[591.897980] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.723s)
[591.909039] Starting dynamic subtest: pipe-C-eDP-1
[624.892728] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.602s)
[624.904300] Starting dynamic subtest: pipe-D-eDP-1
[657.884199] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.633s)
[657.887077] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (14.508s)
[659.049878] [145/155] (364s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[659.162973] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[659.167480] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[659.268686] [146/155] (364s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[659.363955] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[659.368955] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[659.432394] [147/155] (364s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-y)
[659.536971] Starting subtest: fbcpsrhdr-tiling-y
[659.541974] Subtest fbcpsrhdr-tiling-y: SKIP (0.000s)
[659.636821] [148/155] (364s left) syncobj_wait (wait-for-submit-snapshot)
[659.695794] Starting subtest: wait-for-submit-snapshot
[659.776746] Subtest wait-for-submit-snapshot: SUCCESS (0.083s)
[659.870000] [149/155] (364s left) kms_cursor_legacy (single-bo)
[660.000815] Starting subtest: single-bo
[660.002904] Starting dynamic subtest: pipe-A
[665.392520] Dynamic subtest pipe-A: SUCCESS (5.380s)
[665.405798] Starting dynamic subtest: pipe-B
[670.779801] Dynamic subtest pipe-B: SUCCESS (5.380s)
[670.792488] Starting dynamic subtest: pipe-C
[676.167154] Dynamic subtest pipe-C: SUCCESS (5.380s)
[676.179511] Starting dynamic subtest: pipe-D
[681.550469] Dynamic subtest pipe-D: SUCCESS (5.378s)
[681.560798] Starting dynamic subtest: all-pipes
[686.940106] Dynamic subtest all-pipes: SUCCESS (5.386s)
[686.942951] Subtest single-bo: SUCCESS (26.915s)
[687.089427] [150/155] (336s left) i915_query (query-topology-garbage-items)
[687.148639] Starting subtest: query-topology-garbage-items
[687.151139] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[687.260608] [151/155] (336s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[687.354105] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[687.357083] Starting dynamic subtest: pipe-A-default-mode
[688.539225] Dynamic subtest pipe-A-default-mode: SKIP (1.182s)
[688.543827] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.183s)
[688.682488] [152/155] (335s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[688.772696] Starting subtest: addfb25-y-tiled-small-legacy
[688.777203] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[688.864099] [153/155] (335s left) syncobj_timeline (invalid-transfer-bad-pad)
[688.922503] Starting subtest: invalid-transfer-bad-pad
[688.925023] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[689.030691] [154/155] (335s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[689.130373] Starting subtest: fbc-rgb565-draw-mmap-cpu
[693.103189] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (3.983s)
[694.315546] [155/155] (329s left) gem_userptr_blits (probe)
[694.387988] Starting subtest: probe
[694.461943] Subtest probe: SUCCESS (0.074s)
[694.561144] Closing watchdogs
results: parsing output: 0/ for test: kms_feature_discovery
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_cursor_legacy
results: parsing output: 3/ for test: kms_plane_multiple
results: parsing output: 4/ for test: kms_pm_rpm
results: parsing output: 5/ for test: kms_addfb_basic
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_flip_scaled_crc
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_plane_cursor
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_linear_blits
results: parsing output: 13/ for test: kms_hdr
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_addfb_basic
results: parsing output: 16/ for test: gem_pxp
results: parsing output: 17/ for test: gem_ctx_param
results: parsing output: 18/ for test: gem_mmap_gtt
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: gem_ctx_persistence
results: parsing output: 21/ for test: gem_eio
results: parsing output: 22/ for test: kms_psr2_sf
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_mmap_gtt
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_lease
results: parsing output: 30/ for test: gem_workarounds
results: parsing output: 31/ for test: kms_addfb_basic
results: parsing output: 32/ for test: perf
results: parsing output: 33/ for test: gen7_exec_parse
results: parsing output: 34/ for test: kms_cursor_legacy
results: parsing output: 35/ for test: gem_exec_whisper
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_joiner
results: parsing output: 38/ for test: kms_plane_scaling
results: parsing output: 39/ for test: kms_plane
results: parsing output: 40/ for test: kms_properties
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: gem_render_copy
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_cursor_legacy
results: parsing output: 48/ for test: kms_cursor_edge_walk
results: parsing output: 49/ for test: gen3_mixed_blits
results: parsing output: 50/ for test: gem_exec_fence
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_vblank
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: api_intel_allocator
results: parsing output: 56/ for test: gem_ctx_persistence
results: parsing output: 57/ for test: perf_pmu
results: parsing output: 58/ for test: gem_partial_pwrite_pread
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_exec_reloc
results: parsing output: 62/ for test: kms_chamelium_hpd
results: parsing output: 63/ for test: kms_scaling_modes
results: parsing output: 64/ for test: gem_exec_schedule
results: parsing output: 65/ for test: kms_vblank
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_color_pipeline
results: parsing output: 68/ for test: gem_ccs
results: parsing output: 69/ for test: kms_chamelium_frames
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_exec_balancer
results: parsing output: 73/ for test: gem_softpin
results: parsing output: 74/ for test: gem_ctx_exec
results: parsing output: 75/ for test: kms_psr2_sf
results: parsing output: 76/ for test: kms_cursor_crc
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: gem_exec_reloc
results: parsing output: 82/ for test: kms_content_protection
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: gem_exec_fence
results: parsing output: 85/ for test: gem_render_copy
results: parsing output: 86/ for test: kms_flip
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_atomic_transition
results: parsing output: 91/ for test: kms_pipe_b_c_ivb
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_chamelium_color
results: parsing output: 95/ for test: gem_gpgpu_fill
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: i915_module_load
results: parsing output: 98/ for test: gem_exec_schedule
results: parsing output: 99/ for test: vgem_basic
results: parsing output: 100/ for test: gem_userptr_blits
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_flip
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: gem_fenced_exec_thrash
results: parsing output: 105/ for test: prime_vgem
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_ctx_param
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: perf_pmu
results: parsing output: 112/ for test: gem_exec_reloc
results: parsing output: 113/ for test: gem_userptr_blits
results: parsing output: 114/ for test: kms_pm_dc
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: sw_sync
results: parsing output: 117/ for test: kms_cursor_crc
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_universal_plane
results: parsing output: 121/ for test: gem_mmap_gtt
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: gem_exec_reloc
results: parsing output: 125/ for test: syncobj_timeline
results: parsing output: 126/ for test: gem_ctx_sseu
results: parsing output: 127/ for test: i915_drm_fdinfo
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_pm_dc
results: parsing output: 130/ for test: kms_flip_scaled_crc
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: gem_exec_balancer
results: parsing output: 134/ for test: api_intel_bb
results: parsing output: 135/ for test: kms_properties
results: parsing output: 136/ for test: i915_pm_rps
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: dmabuf_sync_file
results: parsing output: 139/ for test: kms_big_fb
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: core_auth
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: kms_ccs
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: kms_psr2_sf
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: syncobj_wait
results: parsing output: 148/ for test: kms_cursor_legacy
results: parsing output: 149/ for test: i915_query
results: parsing output: 150/ for test: kms_flip_scaled_crc
results: parsing output: 151/ for test: kms_addfb_basic
results: parsing output: 152/ for test: syncobj_timeline
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: gem_userptr_blits
Done.