[57.043380] Initializing watchdogs
[57.043430]   /dev/watchdog0
[57.058685] [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.063807] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.066668] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.070326] [001/154] (960s left) gem_exec_flush (basic-wb-pro-default)
[57.168173] Starting subtest: basic-wb-pro-default
[62.662949] Subtest basic-wb-pro-default: SUCCESS (5.472s)
[62.837150] [002/154] (954s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[62.948771] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[62.951134] Starting dynamic subtest: pipe-A
[63.334351] Dynamic subtest pipe-A: SUCCESS (0.388s)
[63.342662] Starting dynamic subtest: pipe-B
[65.019833] Dynamic subtest pipe-B: SUCCESS (1.685s)
[65.029614] Starting dynamic subtest: pipe-C
[66.466549] Dynamic subtest pipe-C: SUCCESS (1.446s)
[66.476118] Starting dynamic subtest: pipe-D
[67.925067] Dynamic subtest pipe-D: SUCCESS (1.458s)
[67.927487] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.979s)
[69.072040] [003/154] (948s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[69.179341] Starting subtest: fbc-rgb565-draw-pwrite
[74.316377] Subtest fbc-rgb565-draw-pwrite: SUCCESS (5.143s)
[75.493460] [004/154] (942s left) gem_exec_reloc (basic-gtt-active)
[75.562514] Subtest basic-gtt-active: SKIP (0.000s)
[75.636622] [005/154] (942s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[75.749015] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[82.470082] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.725s)
[82.619481] [006/154] (935s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[82.716659] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[82.721125] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[82.802912] [007/154] (935s left) gem_exec_reloc (basic-cpu-gtt-active)
[82.859771] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[82.926619] [008/154] (934s left) gem_userptr_blits (forbidden-operations)
[82.993912] Starting subtest: forbidden-operations
[82.998107] Subtest forbidden-operations: SKIP (0.000s)
[83.103728] [009/154] (934s left) kms_flip (blocking-wf_vblank)
[83.197730] Starting subtest: blocking-wf_vblank
[83.200153] Starting dynamic subtest: A-eDP1
[92.157349] Dynamic subtest A-eDP1: SUCCESS (8.958s)
[92.168827] Starting dynamic subtest: B-eDP1
[101.117414] Dynamic subtest B-eDP1: SUCCESS (8.926s)
[101.126351] Starting dynamic subtest: C-eDP1
[110.043107] Dynamic subtest C-eDP1: SUCCESS (8.914s)
[110.050726] Starting dynamic subtest: D-eDP1
[118.924196] Dynamic subtest D-eDP1: SUCCESS (8.925s)
[118.929511] Subtest blocking-wf_vblank: SUCCESS (35.733s)
[120.143968] [010/154] (897s left) gem_exec_schedule (lateslice)
[120.214913] Starting subtest: lateslice
[120.217442] Starting dynamic subtest: rcs0
[120.222930] Dynamic subtest rcs0: SUCCESS (0.020s)
[120.233976] Starting dynamic subtest: bcs0
[120.241049] Dynamic subtest bcs0: SUCCESS (0.018s)
[120.249830] Starting dynamic subtest: vcs0
[120.259072] Dynamic subtest vcs0: SUCCESS (0.018s)
[120.267507] Starting dynamic subtest: vcs1
[120.278339] Dynamic subtest vcs1: SUCCESS (0.019s)
[120.286478] Starting dynamic subtest: vecs0
[120.296903] Dynamic subtest vecs0: SUCCESS (0.018s)
[120.307284] Starting dynamic subtest: ccs0
[120.312996] Dynamic subtest ccs0: SUCCESS (0.016s)
[120.315554] Subtest lateslice: SUCCESS (0.111s)
[122.407930] [011/154] (895s left) kms_psr (psr-cursor-plane-onoff)
[122.512880] Starting subtest: psr-cursor-plane-onoff
[122.515190] Starting dynamic subtest: eDP-1
[124.248370] Dynamic subtest eDP-1: SUCCESS (1.735s)
[124.250693] Subtest psr-cursor-plane-onoff: SUCCESS (1.736s)
[125.150756] [012/154] (892s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[125.256743] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[125.261537] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[125.348874] [013/154] (892s left) prime_mmap (test_reprime)
[125.404612] Starting subtest: test_reprime
[125.406623] Starting dynamic subtest: test_reprime-smem
[125.435895] Dynamic subtest test_reprime-smem: SUCCESS (0.033s)
[125.438386] Subtest test_reprime: SUCCESS (0.034s)
[125.551579] [014/154] (892s left) syncobj_timeline (single-wait-all-available-submitted)
[125.600073] Starting subtest: single-wait-all-available-submitted
[125.602480] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[125.698952] [015/154] (892s left) kms_psr (psr-sprite-mmap-gtt)
[125.803106] Starting subtest: psr-sprite-mmap-gtt
[125.805411] Starting dynamic subtest: eDP-1
[127.233868] Dynamic subtest eDP-1: SKIP (1.427s)
[127.238796] Subtest psr-sprite-mmap-gtt: SKIP (1.429s)
[127.388847] [016/154] (890s left) drm_buddy (drm_buddy)
[127.420796] Starting subtest: drm_buddy
[127.425484] Subtest drm_buddy: SKIP (0.001s)
[127.475169] [017/154] (890s left) i915_pm_rps (thresholds-idle-park)
[127.531078] Starting subtest: thresholds-idle-park
[127.535577] Subtest thresholds-idle-park: SKIP (0.001s)
[127.627618] [018/154] (890s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[127.725893] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[127.729918] Subtest hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[127.808204] [019/154] (890s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[127.901293] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[127.903431] Starting dynamic subtest: pipe-A-default-mode
[130.613528] Dynamic subtest pipe-A-default-mode: SUCCESS (2.712s)
[130.615821] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.713s)
[131.448658] [020/154] (886s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[131.560193] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[131.564851] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[131.651384] [021/154] (886s left) gem_exec_balancer (busy)
[131.712914] Starting subtest: busy
[133.318420] Subtest busy: SUCCESS (1.603s)
[133.624559] [022/154] (884s left) perf (whitelisted-registers-userspace-config)
[133.758924] Starting subtest: whitelisted-registers-userspace-config
[133.760794] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[133.801463] [023/154] (884s left) kms_content_protection (atomic-dpms-hdcp14)
[133.942574] Starting subtest: atomic-dpms-hdcp14
[133.947228] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[134.059169] [024/154] (884s left) gem_exec_fence (basic-busy-all)
[134.133400] Starting subtest: basic-busy-all
[134.234601] Subtest basic-busy-all: SUCCESS (0.101s)
[136.405431] [FACT gem_exec_fence (basic-busy-all)] new: kernel.kmod_is_loaded.vgem: true
[136.408734] [025/154] (882s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[136.512079] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[136.516740] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[137.673584] [026/154] (880s left) gem_render_copy (yf-tiled-to-vebox-linear)
[137.737862] Starting subtest: yf-tiled-to-vebox-linear
[137.741970] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[137.935540] [027/154] (880s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[138.040766] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[139.120510] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.080s)
[139.265798] [028/154] (879s left) gen9_exec_parse (batch-zero-length)
[139.325522] Subtest batch-zero-length: SKIP (0.000s)
[139.398967] [029/154] (879s left) kms_addfb_basic (master-rmfb)
[139.448739] Starting subtest: master-rmfb
[139.450752] Subtest master-rmfb: SUCCESS (0.002s)
[139.607313] [030/154] (879s left) prime_mmap_coherency (ioctl-errors)
[139.659486] Starting subtest: ioctl-errors
[153.872584] Subtest ioctl-errors: SUCCESS (14.212s)
[154.063941] [031/154] (864s left) kms_vrr (flipline)
[154.208282] Starting subtest: flipline
[154.214327] Subtest flipline: SKIP (0.000s)
[154.281571] [032/154] (864s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[154.389389] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-gtt
[154.393726] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[154.495110] [033/154] (864s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[154.562530] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[154.665451] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.101s)
[154.738448] [034/154] (864s left) kms_sequence (queue-idle)
[154.825405] Starting subtest: queue-idle
[154.827817] Starting dynamic subtest: pipe-A-eDP-1
[156.650803] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.823s)
[156.660021] Starting dynamic subtest: pipe-B-eDP-1
[159.141387] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.490s)
[159.151795] Starting dynamic subtest: pipe-C-eDP-1
[161.650388] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.506s)
[161.660757] Starting dynamic subtest: pipe-D-eDP-1
[164.087651] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.435s)
[164.089947] Subtest queue-idle: SUCCESS (9.259s)
[164.894223] [035/154] (854s left) gem_exec_capture (pi)
[164.953053] Starting subtest: pi
[164.955399] Starting dynamic subtest: rcs0
[169.094800] Dynamic subtest rcs0: SUCCESS (4.144s)
[169.105703] Starting dynamic subtest: bcs0
[173.195764] Dynamic subtest bcs0: SUCCESS (4.099s)
[173.206187] Starting dynamic subtest: vcs0
[177.261918] Dynamic subtest vcs0: SUCCESS (4.065s)
[177.271744] Starting dynamic subtest: vcs1
[181.373043] Dynamic subtest vcs1: SUCCESS (4.109s)
[181.385239] Starting dynamic subtest: vecs0
[185.531235] Dynamic subtest vecs0: SUCCESS (4.156s)
[185.542310] Starting dynamic subtest: ccs0
[189.688895] Dynamic subtest ccs0: SUCCESS (4.156s)
[189.691441] Subtest pi: SUCCESS (24.738s)
[189.769491] [036/154] (829s left) perf_pmu (rc6-all-gts)
[189.860150] Starting subtest: rc6-all-gts
[196.280699] Subtest rc6-all-gts: SUCCESS (6.360s)
[197.126291] [037/154] (821s left) kms_plane_multiple (2x-tiling-none)
[197.242069] Starting subtest: 2x-tiling-none
[197.246225] Subtest 2x-tiling-none: SKIP (0.000s)
[197.313032] [038/154] (821s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[197.414983] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[203.985143] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.575s)
[204.113959] [039/154] (815s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[204.214603] Starting subtest: fbc-psr-sprite-mmap-cpu
[204.216585] Starting dynamic subtest: eDP-1
[204.220645] Dynamic subtest eDP-1: SKIP (0.000s)
[204.224707] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[204.288943] [040/154] (814s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[204.395889] Starting subtest: pr-overlay-plane-update-continuous-sf
[204.400602] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[204.463760] [041/154] (814s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[204.569071] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[208.961967] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (4.399s)
[210.112067] [042/154] (809s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[210.207673] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[210.211898] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[210.312103] [043/154] (809s left) kms_addfb_basic (invalid-get-prop)
[210.369692] Starting subtest: invalid-get-prop
[210.371953] Subtest invalid-get-prop: SUCCESS (0.000s)
[210.529546] [044/154] (808s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[210.629620] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[210.633964] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[210.723912] [045/154] (808s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-shrfb-msflip-blt)
[210.829276] Starting subtest: fbcpsrhdr-2p-primscrn-shrfb-msflip-blt
[210.833785] Subtest fbcpsrhdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[210.941515] [046/154] (808s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-pgflip-blt)
[211.047045] Starting subtest: fbchdr-2p-primscrn-shrfb-pgflip-blt
[211.050610] Subtest fbchdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[211.143952] [047/154] (808s left) kms_plane_cursor (overlay)
[211.240052] Starting subtest: overlay
[211.243523] Starting dynamic subtest: pipe-A-eDP-1-size-64
[213.917360] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.678s)
[213.982048] Starting dynamic subtest: pipe-A-eDP-1-size-128
[216.662603] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.694s)
[216.722618] Starting dynamic subtest: pipe-A-eDP-1-size-256
[219.418111] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.705s)
[219.766113] Starting dynamic subtest: pipe-B-eDP-1-size-64
[223.230231] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.475s)
[223.290633] Starting dynamic subtest: pipe-B-eDP-1-size-128
[225.986855] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.705s)
[226.047370] Starting dynamic subtest: pipe-B-eDP-1-size-256
[228.709296] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.671s)
[229.065556] Starting dynamic subtest: pipe-C-eDP-1-size-64
[232.087530] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.034s)
[232.126257] Starting dynamic subtest: pipe-C-eDP-1-size-128
[234.465371] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.347s)
[234.504848] Starting dynamic subtest: pipe-C-eDP-1-size-256
[236.843547] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.348s)
[237.179694] Starting dynamic subtest: pipe-D-eDP-1-size-64
[240.223332] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.055s)
[240.262746] Starting dynamic subtest: pipe-D-eDP-1-size-128
[242.624162] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.369s)
[242.663287] Starting dynamic subtest: pipe-D-eDP-1-size-256
[245.023464] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.369s)
[245.346565] Subtest overlay: SUCCESS (34.105s)
[246.212441] [048/154] (773s left) gem_readwrite (read-bad-handle)
[246.278363] Subtest read-bad-handle: SKIP (0.000s)
[246.347019] [049/154] (773s left) kms_chamelium_frames (dp-crc-multiple)
[246.736329] Subtest dp-crc-multiple: SKIP (0.000s)
[247.558038] [050/154] (772s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[247.663905] Starting subtest: fbcpsr-rgb101010-draw-render
[252.421975] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (4.763s)
[252.563937] [051/154] (767s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-pwrite)
[252.676074] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-pwrite
[252.680144] Subtest hdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[252.788090] [052/154] (766s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-onoff)
[252.883609] Starting subtest: fbchdr-2p-primscrn-cur-indfb-onoff
[252.887731] Subtest fbchdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[252.984317] [053/154] (766s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[253.095900] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[253.100175] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[253.193577] [054/154] (766s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-indfb-msflip-blt)
[253.290020] Starting subtest: psrhdr-1p-primscrn-indfb-msflip-blt
[253.294243] Subtest psrhdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[253.381867] [055/154] (766s left) kms_atomic (plane-invalid-params)
[253.476420] Starting subtest: plane-invalid-params
[253.478403] Starting dynamic subtest: pipe-A-eDP-1
[253.908964] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.432s)
[253.911256] Subtest plane-invalid-params: SUCCESS (0.433s)
[254.807763] [056/154] (765s left) gem_ctx_persistence (legacy-engines-queued)
[254.885276] Starting subtest: legacy-engines-queued
[254.887411] Starting dynamic subtest: render
[254.962679] Dynamic subtest render: SUCCESS (0.080s)
[254.973095] Starting dynamic subtest: bsd1
[256.230638] Dynamic subtest bsd1: SUCCESS (1.263s)
[256.242785] Starting dynamic subtest: bsd2
[258.275194] Dynamic subtest bsd2: SUCCESS (2.041s)
[258.287823] Starting dynamic subtest: blt
[258.311366] Dynamic subtest blt: SUCCESS (0.035s)
[258.320906] Starting dynamic subtest: vebox
[260.260511] Dynamic subtest vebox: SUCCESS (1.945s)
[260.263453] Subtest legacy-engines-queued: SUCCESS (5.379s)
[260.346408] [057/154] (759s left) gem_pxp (create-protected-buffer)
[260.468918] Starting subtest: create-protected-buffer
[260.471768] Subtest create-protected-buffer: SUCCESS (0.000s)
[260.587622] [058/154] (759s left) gem_create (create-ext-placement-sanity-check)
[260.778477] Starting subtest: create-ext-placement-sanity-check
[260.781126] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[260.891852] [059/154] (759s left) kms_frontbuffer_tracking (hdr-1p-pri-indfb-multidraw)
[260.996038] Starting subtest: hdr-1p-pri-indfb-multidraw
[261.000544] Subtest hdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[261.104381] [060/154] (758s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[261.152664] Starting subtest: verify-pxp-stale-buf-optout-execution
[262.218723] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.063s)
[262.364617] [061/154] (757s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[262.463782] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[262.468377] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[262.553842] [062/154] (757s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[262.661550] Starting subtest: random-ccs-data-y-tiled-ccs
[262.663938] Starting dynamic subtest: pipe-A-eDP-1
[262.690223] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[262.703130] Starting dynamic subtest: pipe-B-eDP-1
[262.727510] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[262.737423] Starting dynamic subtest: pipe-C-eDP-1
[262.761669] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[262.771172] Starting dynamic subtest: pipe-D-eDP-1
[262.796426] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[262.800576] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s)
[264.948168] [063/154] (755s left) syncobj_wait (wait-any-snapshot)
[265.006080] Starting subtest: wait-any-snapshot
[265.085083] Subtest wait-any-snapshot: SUCCESS (0.081s)
[265.163756] [064/154] (755s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[265.269245] Starting subtest: psr-rgb101010-draw-blt
[272.732709] Subtest psr-rgb101010-draw-blt: SUCCESS (7.468s)
[272.878558] [065/154] (747s left) i915_hangman (detector)
[272.940832] Starting subtest: detector
[272.942780] Starting dynamic subtest: rcs0
[284.261410] Dynamic subtest rcs0: SUCCESS (11.317s)
[284.276552] Starting dynamic subtest: bcs0
[296.294327] Dynamic subtest bcs0: SUCCESS (12.029s)
[296.307100] Starting dynamic subtest: vcs0
[308.196357] Dynamic subtest vcs0: SUCCESS (11.898s)
[308.209666] Starting dynamic subtest: vcs1
[319.204454] Dynamic subtest vcs1: SUCCESS (11.004s)
[319.217492] Starting dynamic subtest: vecs0
[330.212661] Dynamic subtest vecs0: SUCCESS (11.004s)
[330.225773] Starting dynamic subtest: ccs0
[341.284807] Dynamic subtest ccs0: SUCCESS (11.069s)
[341.287987] Subtest detector: SUCCESS (68.340s)
[341.366659] [066/154] (678s left) kms_lease (empty-lease)
[341.481335] Starting subtest: empty-lease
[341.483757] Starting dynamic subtest: pipe-A-eDP-1
[341.486206] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[341.497229] Starting dynamic subtest: pipe-B-eDP-1
[341.499373] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[341.509114] Starting dynamic subtest: pipe-C-eDP-1
[341.511281] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[341.523239] Starting dynamic subtest: pipe-D-eDP-1
[341.525740] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[341.527909] Subtest empty-lease: SUCCESS (0.009s)
[341.599711] [067/154] (678s left) gem_ccs (block-multicopy-inplace)
[341.661692] Starting subtest: block-multicopy-inplace
[341.665841] Subtest block-multicopy-inplace: SKIP (0.000s)
[341.782810] [068/154] (678s left) gem_sync (basic-each)
[341.855295] Starting subtest: basic-each
[344.333362] Subtest basic-each: SUCCESS (2.489s)
[344.522509] [069/154] (675s left) kms_cursor_crc (cursor-onscreen-32x10)
[344.685957] Starting subtest: cursor-onscreen-32x10
[344.734275] Subtest cursor-onscreen-32x10: SKIP (0.046s)
[345.023062] [070/154] (675s left) i915_pm_rpm (sysfs-read)
[346.559422] Starting subtest: sysfs-read
[347.721783] Subtest sysfs-read: SUCCESS (1.160s)
[348.111589] [071/154] (672s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[348.210799] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[348.213521] Starting dynamic subtest: pipe-A-eDP-1
[348.237485] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[348.249404] Starting dynamic subtest: pipe-B-eDP-1
[348.271076] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[348.280829] Starting dynamic subtest: pipe-C-eDP-1
[348.301924] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[348.313622] Starting dynamic subtest: pipe-D-eDP-1
[348.335633] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[348.340062] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[350.461011] [072/154] (670s left) kms_plane (pixel-format-y-tiled-ccs-modifier)
[350.552133] Starting subtest: pixel-format-y-tiled-ccs-modifier
[350.556440] Subtest pixel-format-y-tiled-ccs-modifier: SKIP (0.000s)
[350.627838] [073/154] (670s left) gem_exec_reloc (basic-cpu)
[350.690080] Subtest basic-cpu: SKIP (0.000s)
[350.764212] [074/154] (669s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[350.861569] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[357.698022] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.841s)
[357.817732] [075/154] (662s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[357.948506] Starting subtest: cursorA-vs-flipA-varying-size
[369.099582] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.151s)
[369.941744] [076/154] (650s left) gem_eio (in-flight-internal-1us)
[370.191165] Starting subtest: in-flight-internal-1us
[371.356219] Subtest in-flight-internal-1us: SUCCESS (1.162s)
[371.484911] [077/154] (649s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[371.577185] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[371.579478] Starting dynamic subtest: pipe-A-default-mode
[374.406331] Dynamic subtest pipe-A-default-mode: SUCCESS (2.829s)
[374.408587] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.831s)
[375.265758] [078/154] (645s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt)
[375.370712] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt
[375.374635] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[375.471829] [079/154] (645s left) gem_pipe_control_store_loop (fresh-buffer)
[375.533039] Starting subtest: fresh-buffer
[377.685999] Subtest fresh-buffer: SUCCESS (2.151s)
[377.793345] [080/154] (643s left) kms_addfb_basic (invalid-set-prop)
[377.852060] Starting subtest: invalid-set-prop
[377.854348] Subtest invalid-set-prop: SUCCESS (0.000s)
[377.989725] [081/154] (642s left) gem_exec_schedule (u-lateslice)
[378.072386] Starting subtest: u-lateslice
[378.074475] Starting dynamic subtest: rcs0
[378.082409] Dynamic subtest rcs0: SUCCESS (0.021s)
[378.094356] Starting dynamic subtest: bcs0
[378.100399] Dynamic subtest bcs0: SUCCESS (0.017s)
[378.112232] Starting dynamic subtest: vcs0
[378.120284] Dynamic subtest vcs0: SUCCESS (0.019s)
[378.130511] Starting dynamic subtest: vcs1
[378.139449] Dynamic subtest vcs1: SUCCESS (0.018s)
[378.150151] Starting dynamic subtest: vecs0
[378.158041] Dynamic subtest vecs0: SUCCESS (0.018s)
[378.167872] Starting dynamic subtest: ccs0
[378.179470] Dynamic subtest ccs0: SUCCESS (0.020s)
[378.181804] Subtest u-lateslice: SUCCESS (0.118s)
[379.344711] [082/154] (641s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[379.740238] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[380.570390] [083/154] (640s left) syncobj_timeline (invalid-wait-illegal-handle)
[380.623826] Starting subtest: invalid-wait-illegal-handle
[380.625801] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[380.724862] [084/154] (640s left) kms_cursor_legacy (forked-move)
[380.844325] Starting subtest: forked-move
[380.846806] Starting dynamic subtest: pipe-A
[386.365330] Dynamic subtest pipe-A: SUCCESS (5.465s)
[386.377625] Starting dynamic subtest: pipe-B
[391.833882] Dynamic subtest pipe-B: SUCCESS (5.470s)
[391.848740] Starting dynamic subtest: pipe-C
[397.308755] Dynamic subtest pipe-C: SUCCESS (5.471s)
[397.320789] Starting dynamic subtest: pipe-D
[402.778763] Dynamic subtest pipe-D: SUCCESS (5.468s)
[402.796197] Starting dynamic subtest: all-pipes
[408.273207] Dynamic subtest all-pipes: SUCCESS (5.492s)
[408.275306] Subtest forked-move: SUCCESS (27.377s)
[408.385051] [085/154] (612s left) kms_pm_rpm (drm-resources-equal)
[410.519481] Starting subtest: drm-resources-equal
[415.549604] Subtest drm-resources-equal: SUCCESS (5.029s)
[415.635586] [086/154] (605s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[415.695548] Subtest writes-after-reads-snoop: SKIP (0.000s)
[415.768989] [087/154] (605s left) kms_psr (fbc-psr2-dpms)
[415.857503] Starting subtest: fbc-psr2-dpms
[415.859851] Starting dynamic subtest: eDP-1
[415.864258] Dynamic subtest eDP-1: SKIP (0.000s)
[415.868629] Subtest fbc-psr2-dpms: SKIP (0.001s)
[415.930957] [088/154] (605s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-fullscreen)
[416.024624] Starting subtest: psrhdr-1p-primscrn-spr-indfb-fullscreen
[416.028773] Subtest psrhdr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[416.157779] [089/154] (605s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[416.263383] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[419.896910] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.640s)
[421.085448] [090/154] (600s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[421.155232] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[421.157317] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[421.262993] [091/154] (600s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[421.375230] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[421.379666] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[421.482631] [092/154] (599s left) syncobj_timeline (wait-any-complex)
[421.546219] Starting subtest: wait-any-complex
[421.606896] Subtest wait-any-complex: SUCCESS (0.061s)
[421.701080] [093/154] (599s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[421.805100] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[421.809222] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[421.908307] [094/154] (599s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[422.006794] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[422.010244] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[422.103258] [095/154] (599s left) kms_hdr (bpc-switch)
[422.201194] Starting subtest: bpc-switch
[422.203066] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[426.738734] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (4.538s)
[426.750089] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[431.294393] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (4.553s)
[431.296842] Subtest bpc-switch: SUCCESS (9.094s)
[431.432660] [096/154] (590s left) core_auth (getclient-simple)
[431.469689] Starting subtest: getclient-simple
[431.489905] Subtest getclient-simple: SUCCESS (0.020s)
[431.608985] [097/154] (590s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[431.707172] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[431.711402] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[431.792062] [098/154] (589s left) gem_spin_batch (spin-each)
[431.854744] Starting subtest: spin-each
[435.213750] Subtest spin-each: SUCCESS (3.358s)
[435.401447] [099/154] (586s left) gem_busy (close-race)
[435.464498] Starting subtest: close-race
[459.333968] Subtest close-race: SUCCESS (23.866s)
[459.666816] [100/154] (562s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite)
[459.809643] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite
[459.814052] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[459.908960] [101/154] (561s left) kms_psr (pr-sprite-render)
[460.021135] Starting subtest: pr-sprite-render
[460.025579] Subtest pr-sprite-render: SKIP (0.000s)
[460.105547] [102/154] (561s left) drm_read (invalid-buffer)
[460.286446] Starting subtest: invalid-buffer
[460.288632] Subtest invalid-buffer: SUCCESS (0.000s)
[460.409487] [103/154] (561s left) gem_ctx_isolation (nonpriv-switch)
[460.472783] Starting subtest: nonpriv-switch
[460.475161] Starting dynamic subtest: rcs0
[460.755718] Dynamic subtest rcs0: SUCCESS (0.282s)
[460.768068] Starting dynamic subtest: bcs0
[461.054203] Dynamic subtest bcs0: SUCCESS (0.298s)
[461.064225] Starting dynamic subtest: vcs0
[461.351097] Dynamic subtest vcs0: SUCCESS (0.296s)
[461.363058] Starting dynamic subtest: vcs1
[462.528230] Dynamic subtest vcs1: SUCCESS (1.176s)
[462.540638] Starting dynamic subtest: vecs0
[464.642139] Dynamic subtest vecs0: SUCCESS (2.113s)
[464.652635] Starting dynamic subtest: ccs0
[466.634538] Dynamic subtest ccs0: SUCCESS (1.991s)
[466.636992] Subtest nonpriv-switch: SUCCESS (6.162s)
[466.861404] [104/154] (555s left) perf (gen12-mi-rpc)
[466.998816] Starting subtest: gen12-mi-rpc
[467.001163] Starting dynamic subtest: rcs0
[467.016425] Dynamic subtest rcs0: SUCCESS (0.018s)
[467.018386] Subtest gen12-mi-rpc: SUCCESS (0.019s)
[467.064154] [105/154] (554s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[467.200049] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[467.202333] Starting dynamic subtest: pipe-A-eDP-1
[467.223636] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[467.236077] Starting dynamic subtest: pipe-B-eDP-1
[467.255985] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[467.266131] Starting dynamic subtest: pipe-C-eDP-1
[467.285997] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[467.296234] Starting dynamic subtest: pipe-D-eDP-1
[467.315766] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[467.318102] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[469.514439] [106/154] (552s left) kms_psr2_su (page_flip-xrgb8888)
[469.564778] Subtest page_flip-XRGB8888: SKIP (0.000s)
[469.628440] [107/154] (552s left) kms_big_fb (linear-32bpp-rotate-270)
[469.741426] Starting subtest: linear-32bpp-rotate-270
[469.760603] Subtest linear-32bpp-rotate-270: SKIP (0.018s)
[469.886912] [108/154] (552s left) kms_pm_dc (dc3co-vpb-simulation)
[470.998460] Starting subtest: dc3co-vpb-simulation
[479.633856] Subtest dc3co-vpb-simulation: SKIP (8.632s)
[479.781589] [109/154] (542s left) kms_addfb_basic (invalid-set-prop-any)
[479.843660] Starting subtest: invalid-set-prop-any
[479.845588] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[479.980388] [110/154] (542s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-blt)
[480.086858] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-blt
[480.090870] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[480.183481] [111/154] (542s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-render)
[480.276784] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-render
[480.280784] Subtest hdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[480.380158] [112/154] (541s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[480.474425] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[480.478745] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[480.588262] [113/154] (541s left) kms_flip (dpms-off-confusion-interruptible)
[480.683536] Starting subtest: dpms-off-confusion-interruptible
[480.685432] Starting dynamic subtest: A-eDP1
[489.359514] Dynamic subtest A-eDP1: SUCCESS (8.638s)
[489.372086] Starting dynamic subtest: B-eDP1
[497.996530] Dynamic subtest B-eDP1: SUCCESS (8.634s)
[498.008761] Starting dynamic subtest: C-eDP1
[506.629312] Dynamic subtest C-eDP1: SUCCESS (8.622s)
[506.642708] Starting dynamic subtest: D-eDP1
[515.266338] Dynamic subtest D-eDP1: SUCCESS (8.631s)
[515.268991] Subtest dpms-off-confusion-interruptible: SUCCESS (34.536s)
[516.394202] [114/154] (505s left) kms_frontbuffer_tracking (psrhdr-2p-rte)
[516.500453] Starting subtest: psrhdr-2p-rte
[516.504409] Subtest psrhdr-2p-rte: SKIP (0.000s)
[516.602807] [115/154] (505s left) gem_exec_schedule (u-submit-late-slice)
[516.674953] Starting subtest: u-submit-late-slice
[516.677162] Starting dynamic subtest: rcs0
[516.705734] Dynamic subtest rcs0: SUCCESS (0.035s)
[516.718793] Starting dynamic subtest: bcs0
[516.749711] Dynamic subtest bcs0: SUCCESS (0.043s)
[516.761227] Starting dynamic subtest: vcs0
[516.788723] Dynamic subtest vcs0: SUCCESS (0.038s)
[516.800015] Starting dynamic subtest: vcs1
[516.826673] Dynamic subtest vcs1: SUCCESS (0.036s)
[516.839120] Starting dynamic subtest: vecs0
[516.857745] Dynamic subtest vecs0: SUCCESS (0.030s)
[516.868166] Starting dynamic subtest: ccs0
[516.899352] Dynamic subtest ccs0: SUCCESS (0.041s)
[516.901637] Subtest u-submit-late-slice: SUCCESS (0.229s)
[518.352702] [116/154] (504s left) kms_color (invalid-gamma-lut-sizes)
[518.451558] Starting subtest: invalid-gamma-lut-sizes
[518.454052] Starting dynamic subtest: pipe-A
[518.753681] Dynamic subtest pipe-A: SUCCESS (0.302s)
[518.768530] Starting dynamic subtest: pipe-B
[518.771065] Dynamic subtest pipe-B: SUCCESS (0.000s)
[518.782146] Starting dynamic subtest: pipe-C
[518.784764] Dynamic subtest pipe-C: SUCCESS (0.000s)
[518.802795] Starting dynamic subtest: pipe-D
[518.804767] Dynamic subtest pipe-D: SUCCESS (0.000s)
[518.806743] Subtest invalid-gamma-lut-sizes: SUCCESS (0.306s)
[519.629694] [117/154] (502s left) gem_pipe_control_store_loop (reused-buffer)
[519.688364] Starting subtest: reused-buffer
[521.894704] Subtest reused-buffer: SUCCESS (2.151s)
[521.961768] [118/154] (500s left) kms_cursor_crc (cursor-random-256x85)
[522.223096] Starting subtest: cursor-random-256x85
[522.272381] Subtest cursor-random-256x85: SKIP (0.046s)
[522.459019] [119/154] (500s left) kms_frontbuffer_tracking (fbcpsrhdr-indfb-scaledprimary)
[522.564597] Starting subtest: fbcpsrhdr-indfb-scaledprimary
[522.568662] Subtest fbcpsrhdr-indfb-scaledprimary: SKIP (0.000s)
[522.667744] [120/154] (499s left) i915_drm_fdinfo (all-busy-check-all)
[522.707461] Starting subtest: all-busy-check-all
[522.715404] Subtest all-busy-check-all: SKIP (0.004s)
[522.787360] [121/154] (499s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[522.925396] Starting subtest: cursorA-vs-flipA-legacy
[534.069914] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.143s)
[534.890644] [122/154] (487s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[534.993061] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[542.064400] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.076s)
[542.210800] [123/154] (480s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[542.322440] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[543.157669] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.837s)
[543.338965] [124/154] (479s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[543.435079] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[543.437379] Starting dynamic subtest: pipe-A-eDP-1
[560.148057] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.341s)
[560.159517] Starting dynamic subtest: pipe-B-eDP-1
[577.106283] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.456s)
[577.119366] Starting dynamic subtest: pipe-C-eDP-1
[594.087214] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.377s)
[594.098845] Starting dynamic subtest: pipe-D-eDP-1
[611.050810] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.338s)
[611.053075] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (9.516s)
[612.206194] [125/154] (410s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-render)
[612.313450] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-render
[612.318373] Subtest fbchdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[612.410075] [126/154] (410s left) kms_cursor_edge_walk (128x128-left-edge)
[612.506935] Starting subtest: 128x128-left-edge
[612.510022] Starting dynamic subtest: pipe-A-eDP-1
[615.985050] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.474s)
[615.997123] Starting dynamic subtest: pipe-D-eDP-1
[619.122867] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.134s)
[619.125330] Subtest 128x128-left-edge: SUCCESS (6.611s)
[619.948671] [127/154] (403s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[621.473883] Starting subtest: modeset-lpsp-stress-no-wait
[631.858484] Subtest modeset-lpsp-stress-no-wait: SUCCESS (10.380s)
[631.935139] [128/154] (391s left) gem_mmap_gtt (basic-write)
[631.995126] Subtest basic-write: SKIP (0.000s)
[632.059429] [129/154] (390s left) kms_feature_discovery (chamelium)
[632.153105] Starting subtest: chamelium
[632.158304] Subtest chamelium: SKIP (0.000s)
[632.228322] [130/154] (390s left) gem_lmem_swapping (verify-random-ccs)
[632.278278] Subtest verify-random-ccs: SKIP (0.000s)
[632.330570] [131/154] (390s left) gem_exec_suspend (basic)
[632.399093] Starting subtest: basic
[632.402189] Starting dynamic subtest: smem
[634.412596] Dynamic subtest smem: SUCCESS (2.011s)
[634.415685] Subtest basic: SUCCESS (2.013s)
[634.603884] [132/154] (388s left) kms_prop_blob (invalid-set-prop-any)
[634.656911] Starting subtest: invalid-set-prop-any
[634.659855] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[634.756485] [133/154] (388s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[635.342116] Starting subtest: syncobj-timeline-invalid-wait
[635.349228] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.007s)
[636.459121] [134/154] (386s left) syncobj_wait (single-wait-all-for-submit-signaled)
[636.510832] Starting subtest: single-wait-all-for-submit-signaled
[636.513306] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[636.639515] [135/154] (386s left) gem_lmem_swapping (heavy-random)
[636.677454] Subtest heavy-random: SKIP (0.000s)
[636.725217] [136/154] (386s left) prime_self_import (basic-llseek-size)
[636.761759] Starting subtest: basic-llseek-size
[636.782309] Subtest basic-llseek-size: SUCCESS (0.020s)
[636.880269] [137/154] (386s left) syncobj_basic (bad-create-flags)
[636.953205] Starting subtest: bad-create-flags
[636.956065] Subtest bad-create-flags: SUCCESS (0.000s)
[637.048313] [138/154] (386s left) kms_lease (lease-uevent)
[637.144063] Starting subtest: lease-uevent
[638.156016] Subtest lease-uevent: SUCCESS (1.012s)
[638.264778] [139/154] (385s left) gem_wait (await)
[638.325597] Starting subtest: await
[638.328293] Starting dynamic subtest: all-engines
[639.430482] Dynamic subtest all-engines: SUCCESS (1.107s)
[639.451146] Starting dynamic subtest: rcs0
[640.493512] Dynamic subtest rcs0: SUCCESS (1.060s)
[640.514571] Starting dynamic subtest: bcs0
[641.557342] Dynamic subtest bcs0: SUCCESS (1.061s)
[641.577221] Starting dynamic subtest: vcs0
[642.617607] Dynamic subtest vcs0: SUCCESS (1.057s)
[642.635137] Starting dynamic subtest: vcs1
[643.679157] Dynamic subtest vcs1: SUCCESS (1.059s)
[643.697790] Starting dynamic subtest: vecs0
[644.736211] Dynamic subtest vecs0: SUCCESS (1.054s)
[644.755348] Starting dynamic subtest: ccs0
[645.799083] Dynamic subtest ccs0: SUCCESS (1.060s)
[645.801820] Subtest await: SUCCESS (7.475s)
[646.001011] [140/154] (377s left) perf_pmu (invalid-init)
[646.039870] Starting subtest: invalid-init
[646.042652] Subtest invalid-init: SUCCESS (0.000s)
[646.143925] [141/154] (377s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-render)
[646.248828] Starting subtest: psrhdr-rgb101010-draw-render
[646.253822] Subtest psrhdr-rgb101010-draw-render: SKIP (0.000s)
[646.336108] [142/154] (377s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[646.430914] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[653.101270] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.672s)
[653.219145] [143/154] (370s left) prime_busy (hang-wait)
[653.283179] Starting subtest: hang-wait
[653.285589] Starting dynamic subtest: rcs0
[666.834570] Dynamic subtest rcs0: SUCCESS (13.538s)
[666.847529] Starting dynamic subtest: bcs0
[673.985324] Dynamic subtest bcs0: SUCCESS (7.149s)
[673.998906] Starting dynamic subtest: vcs0
[681.026575] Dynamic subtest vcs0: SUCCESS (7.030s)
[681.038008] Starting dynamic subtest: vcs1
[688.000331] Dynamic subtest vcs1: SUCCESS (6.977s)
[688.011318] Starting dynamic subtest: vecs0
[694.967653] Dynamic subtest vecs0: SUCCESS (6.963s)
[694.981345] Starting dynamic subtest: ccs0
[708.875170] Dynamic subtest ccs0: SUCCESS (13.897s)
[708.878350] Subtest hang-wait: SUCCESS (55.566s)
[709.016705] [144/154] (314s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[709.070885] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[709.132072] [145/154] (314s left) gem_exec_reloc (basic-write-gtt-noreloc)
[709.194125] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[709.281401] [146/154] (314s left) gem_mmap_offset (partial-mmap)
[709.335453] Starting subtest: partial-mmap
[709.337711] Starting dynamic subtest: smem0
[709.340294] Dynamic subtest smem0: SUCCESS (0.006s)
[709.343234] Subtest partial-mmap: SUCCESS (0.007s)
[709.434667] [147/154] (314s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[709.545857] Starting subtest: x-tiled-64bpp-rotate-90
[709.564947] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[709.669321] [148/154] (314s left) api_intel_allocator (alloc-simple)
[709.734208] Starting subtest: alloc-simple
[709.737163] Subtest alloc-simple: SUCCESS (0.004s)
[709.850597] [149/154] (314s left) kms_frontbuffer_tracking (fbchdr-tiling-linear)
[709.952980] Starting subtest: fbchdr-tiling-linear
[709.957002] Subtest fbchdr-tiling-linear: SKIP (0.000s)
[710.039199] [150/154] (313s left) gem_exec_schedule (implicit-read-write)
[710.103777] Starting subtest: implicit-read-write
[710.105894] Starting dynamic subtest: rcs0
[710.200897] Dynamic subtest rcs0: SUCCESS (0.105s)
[710.212570] Starting dynamic subtest: vcs0
[710.287183] Dynamic subtest vcs0: SUCCESS (0.084s)
[710.298757] Starting dynamic subtest: vcs1
[710.374661] Dynamic subtest vcs1: SUCCESS (0.086s)
[710.388409] Starting dynamic subtest: vecs0
[710.449462] Dynamic subtest vecs0: SUCCESS (0.074s)
[710.468719] Starting dynamic subtest: ccs0
[710.532122] Dynamic subtest ccs0: SUCCESS (0.081s)
[710.534908] Subtest implicit-read-write: SUCCESS (0.437s)
[711.505842] [151/154] (312s left) gem_fenced_exec_thrash (too-many-fences)
[711.564277] Subtest too-many-fences: SKIP (0.000s)
[711.624843] [152/154] (312s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[711.678475] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[711.681164] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[711.775966] [153/154] (312s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-gtt)
[711.877724] Starting subtest: hdr-rgb101010-draw-mmap-gtt
[711.883016] Subtest hdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[711.988835] [154/154] (312s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[712.094291] Starting subtest: yf-tiled-8bpp-rotate-0
[712.099119] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[712.191522] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_flush
results: parsing output: 1/ for test: kms_plane_scaling
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_exec_reloc
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_exec_reloc
results: parsing output: 7/ for test: gem_userptr_blits
results: parsing output: 8/ for test: kms_flip
results: parsing output: 9/ for test: gem_exec_schedule
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: prime_mmap
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: drm_buddy
results: parsing output: 16/ for test: i915_pm_rps
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_flip_scaled_crc
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: gem_exec_balancer
results: parsing output: 21/ for test: perf
results: parsing output: 22/ for test: kms_content_protection
results: parsing output: 23/ for test: gem_exec_fence
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: gem_render_copy
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: gen9_exec_parse
results: parsing output: 28/ for test: kms_addfb_basic
results: parsing output: 29/ for test: prime_mmap_coherency
results: parsing output: 30/ for test: kms_vrr
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: syncobj_timeline
results: parsing output: 33/ for test: kms_sequence
results: parsing output: 34/ for test: gem_exec_capture
results: parsing output: 35/ for test: perf_pmu
results: parsing output: 36/ for test: kms_plane_multiple
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: kms_psr2_sf
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_addfb_basic
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_plane_cursor
results: parsing output: 47/ for test: gem_readwrite
results: parsing output: 48/ for test: kms_chamelium_frames
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_atomic
results: parsing output: 55/ for test: gem_ctx_persistence
results: parsing output: 56/ for test: gem_pxp
results: parsing output: 57/ for test: gem_create
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_pxp
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: i915_hangman
results: parsing output: 65/ for test: kms_lease
results: parsing output: 66/ for test: gem_ccs
results: parsing output: 67/ for test: gem_sync
results: parsing output: 68/ for test: kms_cursor_crc
results: parsing output: 69/ for test: i915_pm_rpm
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: kms_plane
results: parsing output: 72/ for test: gem_exec_reloc
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_cursor_legacy
results: parsing output: 75/ for test: gem_eio
results: parsing output: 76/ for test: kms_flip_scaled_crc
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_pipe_control_store_loop
results: parsing output: 79/ for test: kms_addfb_basic
results: parsing output: 80/ for test: gem_exec_schedule
results: parsing output: 81/ for test: kms_chamelium_hpd
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: kms_cursor_legacy
results: parsing output: 84/ for test: kms_pm_rpm
results: parsing output: 85/ for test: gem_partial_pwrite_pread
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: syncobj_wait
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: syncobj_timeline
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_hdr
results: parsing output: 95/ for test: core_auth
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_spin_batch
results: parsing output: 98/ for test: gem_busy
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: drm_read
results: parsing output: 102/ for test: gem_ctx_isolation
results: parsing output: 103/ for test: perf
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: kms_psr2_su
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: kms_pm_dc
results: parsing output: 108/ for test: kms_addfb_basic
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_exec_schedule
results: parsing output: 115/ for test: kms_color
results: parsing output: 116/ for test: gem_pipe_control_store_loop
results: parsing output: 117/ for test: kms_cursor_crc
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: i915_drm_fdinfo
results: parsing output: 120/ for test: kms_cursor_legacy
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: kms_ccs
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_cursor_edge_walk
results: parsing output: 126/ for test: kms_pm_rpm
results: parsing output: 127/ for test: gem_mmap_gtt
results: parsing output: 128/ for test: kms_feature_discovery
results: parsing output: 129/ for test: gem_lmem_swapping
results: parsing output: 130/ for test: gem_exec_suspend
results: parsing output: 131/ for test: kms_prop_blob
results: parsing output: 132/ for test: gem_exec_fence
results: parsing output: 133/ for test: syncobj_wait
results: parsing output: 134/ for test: gem_lmem_swapping
results: parsing output: 135/ for test: prime_self_import
results: parsing output: 136/ for test: syncobj_basic
results: parsing output: 137/ for test: kms_lease
results: parsing output: 138/ for test: gem_wait
results: parsing output: 139/ for test: perf_pmu
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: prime_busy
results: parsing output: 143/ for test: kms_pipe_b_c_ivb
results: parsing output: 144/ for test: gem_exec_reloc
results: parsing output: 145/ for test: gem_mmap_offset
results: parsing output: 146/ for test: kms_big_fb
results: parsing output: 147/ for test: api_intel_allocator
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: gem_exec_schedule
results: parsing output: 150/ for test: gem_fenced_exec_thrash
results: parsing output: 151/ for test: syncobj_timeline
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: kms_big_fb
Done.