[59.459726] Initializing watchdogs
[59.459844]   /dev/watchdog0
[59.474797] [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]
[59.479224] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.481914] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.485386] [001/156] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[59.606256] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[67.412519] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.836s)
[67.534162] [002/156] (952s left) kms_psr (fbc-psr-primary-mmap-gtt)
[67.642410] Starting subtest: fbc-psr-primary-mmap-gtt
[67.644402] Starting dynamic subtest: eDP-1
[67.648587] Dynamic subtest eDP-1: SKIP (0.000s)
[67.652835] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.000s)
[67.716129] [003/156] (952s left) dmabuf_sync_file (import-multiple-read-only)
[67.788510] Starting subtest: import-multiple-read-only
[67.790845] Subtest import-multiple-read-only: SUCCESS (0.003s)
[67.844786] [FACT dmabuf_sync_file (import-multiple-read-only)] new: kernel.kmod_is_loaded.vgem: true
[67.848213] [004/156] (952s left) kms_plane_scaling (planes-downscale-factor-0-5)
[67.930366] Starting subtest: planes-downscale-factor-0-5
[67.932751] Starting dynamic subtest: pipe-A
[67.954633] Dynamic subtest pipe-A: SKIP (0.019s)
[67.962899] Starting dynamic subtest: pipe-B
[67.991766] Dynamic subtest pipe-B: SKIP (0.035s)
[67.999477] Starting dynamic subtest: pipe-C
[68.028765] Dynamic subtest pipe-C: SKIP (0.037s)
[68.036165] Starting dynamic subtest: pipe-D
[68.064796] Dynamic subtest pipe-D: SKIP (0.036s)
[68.069153] Subtest planes-downscale-factor-0-5: SKIP (0.129s)
[68.167809] [005/156] (951s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[68.550610] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[69.343663] [006/156] (950s left) api_intel_allocator (reserve-simple)
[69.400441] Starting subtest: reserve-simple
[69.404162] Subtest reserve-simple: SUCCESS (0.006s)
[69.524915] [007/156] (950s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[69.670632] Starting subtest: cursor-rapid-movement-32x32
[69.723175] Subtest cursor-rapid-movement-32x32: SKIP (0.049s)
[69.990644] [008/156] (950s left) prime_mmap (test_correct)
[70.049716] Starting subtest: test_correct
[70.051581] Starting dynamic subtest: test_correct-smem
[70.081358] Dynamic subtest test_correct-smem: SUCCESS (0.033s)
[70.083800] Subtest test_correct: SUCCESS (0.034s)
[70.192630] [009/156] (950s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[70.289160] Starting subtest: compare-crc-sanitycheck-xr24
[70.290750] Starting dynamic subtest: pipe-A-eDP-1
[70.935934] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.645s)
[70.945681] Starting dynamic subtest: pipe-B-eDP-1
[72.233917] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.301s)
[72.244212] Starting dynamic subtest: pipe-C-eDP-1
[73.534547] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.297s)
[73.544048] Starting dynamic subtest: pipe-D-eDP-1
[74.759122] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.227s)
[74.761530] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.474s)
[75.590800] [010/156] (944s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[75.705543] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[76.772839] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.069s)
[76.892867] [011/156] (943s left) gem_ctx_param (set-priority-not-supported)
[76.947674] Starting subtest: set-priority-not-supported
[76.952257] Subtest set-priority-not-supported: SKIP (0.000s)
[77.017701] [012/156] (943s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[77.119502] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu
[77.122882] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[77.222335] [013/156] (943s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[77.311802] Starting subtest: 2x-absolute-wf_vblank-interruptible
[77.324588] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.011s)
[77.408984] [014/156] (943s left) prime_self_import (basic-llseek-size)
[77.440519] Starting subtest: basic-llseek-size
[77.458831] Subtest basic-llseek-size: SUCCESS (0.016s)
[77.562385] [015/156] (942s left) kms_invalid_mode (bad-htotal)
[77.658546] Starting subtest: bad-htotal
[77.660450] Starting dynamic subtest: pipe-A-eDP-1
[77.946090] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[77.954548] Starting dynamic subtest: pipe-B-eDP-1
[77.956516] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[77.963319] Starting dynamic subtest: pipe-C-eDP-1
[77.965680] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[77.972855] Starting dynamic subtest: pipe-D-eDP-1
[77.975217] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[77.977515] Subtest bad-htotal: SUCCESS (0.291s)
[78.851360] [016/156] (941s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[78.947044] Starting subtest: plane-lut1d-post-ctm3x4
[79.091962] Starting dynamic subtest: pipe-A-plane-0
[79.258772] Dynamic subtest pipe-A-plane-0: SUCCESS (0.167s)
[79.268273] Starting dynamic subtest: pipe-A-plane-1
[79.425073] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[79.434081] Starting dynamic subtest: pipe-A-plane-2
[79.613401] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s)
[80.823563] Starting dynamic subtest: pipe-B-plane-0
[80.994310] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s)
[81.003441] Starting dynamic subtest: pipe-B-plane-1
[81.149575] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s)
[81.158701] Starting dynamic subtest: pipe-B-plane-2
[81.316128] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[82.546022] Starting dynamic subtest: pipe-C-plane-0
[82.672679] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[82.681870] Starting dynamic subtest: pipe-C-plane-1
[82.829885] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[82.838087] Starting dynamic subtest: pipe-C-plane-2
[82.974232] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[84.188363] Starting dynamic subtest: pipe-D-plane-0
[84.333147] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[84.343377] Starting dynamic subtest: pipe-D-plane-1
[84.499543] Dynamic subtest pipe-D-plane-1: SUCCESS (0.165s)
[84.508081] Starting dynamic subtest: pipe-D-plane-2
[84.656166] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[84.937795] Subtest plane-lut1d-post-ctm3x4: SUCCESS (5.995s)
[85.758456] [017/156] (934s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[85.872426] Starting subtest: cursorB-vs-flipB-toggle
[85.877100] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[86.030565] [018/156] (934s left) kms_flip (flip-vs-rmfb-interruptible)
[86.128473] Starting subtest: flip-vs-rmfb-interruptible
[86.130317] Starting dynamic subtest: A-eDP1
[94.756955] Dynamic subtest A-eDP1: SUCCESS (8.628s)
[94.766776] Starting dynamic subtest: B-eDP1
[103.394697] Dynamic subtest B-eDP1: SUCCESS (8.637s)
[103.404383] Starting dynamic subtest: C-eDP1
[112.054205] Dynamic subtest C-eDP1: SUCCESS (8.659s)
[112.064608] Starting dynamic subtest: D-eDP1
[120.686220] Dynamic subtest D-eDP1: SUCCESS (8.631s)
[120.690926] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.564s)
[121.843927] [019/156] (898s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[121.947499] Starting subtest: psr-rgb565-draw-render
[129.074327] Subtest psr-rgb565-draw-render: SUCCESS (7.131s)
[129.186089] [020/156] (891s left) syncobj_eventfd (binary-wait)
[129.235084] Starting subtest: binary-wait
[129.244753] Subtest binary-wait: SUCCESS (0.010s)
[129.351062] [021/156] (891s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[129.449618] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[129.453638] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[129.543437] [022/156] (891s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-blt)
[129.640861] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-blt
[129.644890] Subtest hdr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[129.729097] [023/156] (891s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-pgflip-blt)
[129.821652] Starting subtest: fbchdr-2p-primscrn-shrfb-pgflip-blt
[129.825689] Subtest fbchdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[129.901470] [024/156] (891s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[129.995445] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[129.999500] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[130.073233] [025/156] (890s left) gem_spin_batch (resubmit-new)
[130.135111] Starting subtest: resubmit-new
[130.137190] Starting dynamic subtest: rcs0
[130.142499] Dynamic subtest rcs0: SUCCESS (0.007s)
[130.151456] Starting dynamic subtest: bcs0
[130.153354] Dynamic subtest bcs0: SUCCESS (0.004s)
[130.161167] Starting dynamic subtest: vcs0
[130.162686] Dynamic subtest vcs0: SUCCESS (0.005s)
[130.170246] Starting dynamic subtest: vcs1
[130.171770] Dynamic subtest vcs1: SUCCESS (0.005s)
[130.178847] Starting dynamic subtest: vecs0
[130.180375] Dynamic subtest vecs0: SUCCESS (0.005s)
[130.187184] Starting dynamic subtest: ccs0
[130.188713] Dynamic subtest ccs0: SUCCESS (0.004s)
[130.190321] Subtest resubmit-new: SUCCESS (0.034s)
[131.348821] [026/156] (889s left) prime_mmap_coherency (ioctl-errors)
[131.406825] Starting subtest: ioctl-errors
[146.610589] Subtest ioctl-errors: SUCCESS (15.203s)
[146.729087] [027/156] (874s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[146.867995] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[151.171586] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.308s)
[152.378656] [028/156] (868s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt)
[152.492115] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt
[152.496064] Subtest fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[152.603884] [029/156] (868s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[152.702057] Starting subtest: 2x-flip-vs-modeset-vs-hang
[152.706478] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.002s)
[152.799455] [030/156] (868s left) perf_pmu (enable-race)
[152.838772] Starting subtest: enable-race
[152.841192] Starting dynamic subtest: rcs0
[165.607089] Dynamic subtest rcs0: SUCCESS (12.765s)
[165.616262] Starting dynamic subtest: bcs0
[178.353186] Dynamic subtest bcs0: SUCCESS (12.742s)
[178.364958] Starting dynamic subtest: vcs0
[194.271071] Dynamic subtest vcs0: SUCCESS (15.912s)
[194.281763] Starting dynamic subtest: vcs1
[210.336058] Dynamic subtest vcs1: SUCCESS (16.061s)
[210.347844] Starting dynamic subtest: vecs0
[226.336820] Dynamic subtest vecs0: SUCCESS (15.998s)
[226.346912] Starting dynamic subtest: ccs0
[239.083093] Dynamic subtest ccs0: SUCCESS (12.745s)
[239.085452] Subtest enable-race: SUCCESS (86.238s)
[239.192279] [031/156] (782s left) kms_getfb (getfb-handle-closed)
[239.285713] Starting subtest: getfb-handle-closed
[239.287872] Subtest getfb-handle-closed: SUCCESS (0.000s)
[239.397933] [032/156] (781s left) core_getclient (basic)
[239.456453] Starting subtest: basic
[239.458673] Subtest basic: SUCCESS (0.000s)
[239.559733] [033/156] (781s left) gem_exec_schedule (pi-userfault)
[239.743689] Starting subtest: pi-userfault
[239.745824] Starting dynamic subtest: rcs0
[239.753065] Dynamic subtest rcs0: SUCCESS (0.012s)
[239.762079] Starting dynamic subtest: bcs0
[239.764278] Dynamic subtest bcs0: SUCCESS (0.010s)
[239.773021] Starting dynamic subtest: vcs0
[239.775288] Dynamic subtest vcs0: SUCCESS (0.011s)
[239.783975] Starting dynamic subtest: vcs1
[239.786303] Dynamic subtest vcs1: SUCCESS (0.011s)
[239.795168] Starting dynamic subtest: vecs0
[239.797520] Dynamic subtest vecs0: SUCCESS (0.009s)
[239.806312] Starting dynamic subtest: ccs0
[239.808208] Dynamic subtest ccs0: SUCCESS (0.008s)
[239.810080] Subtest pi-userfault: SUCCESS (0.065s)
[239.987352] [034/156] (781s left) gem_pxp (create-protected-buffer)
[240.116822] Starting subtest: create-protected-buffer
[240.119475] Subtest create-protected-buffer: SUCCESS (0.000s)
[240.234576] [035/156] (781s left) syncobj_timeline (invalid-transfer-illegal-handle)
[240.283395] Starting subtest: invalid-transfer-illegal-handle
[240.285504] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[240.369984] [036/156] (781s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[240.460678] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[240.463063] Starting dynamic subtest: pipe-A-eDP-1
[240.484467] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[240.499253] Starting dynamic subtest: pipe-B-eDP-1
[240.519176] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[240.529664] Starting dynamic subtest: pipe-C-eDP-1
[240.548202] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[240.556838] Starting dynamic subtest: pipe-D-eDP-1
[240.576179] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[240.578400] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.009s)
[242.721961] [037/156] (778s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[242.821112] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[242.833640] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.011s)
[242.919289] [038/156] (778s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[242.974551] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[243.037221] [039/156] (778s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-onoff)
[243.139524] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-onoff
[243.143745] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[243.231960] [040/156] (778s left) i915_pm_rps (thresholds-idle-park)
[243.305607] Starting subtest: thresholds-idle-park
[243.309949] Subtest thresholds-idle-park: SKIP (0.001s)
[243.418230] [041/156] (778s left) kms_psr (fbc-psr2-primary-render)
[243.507033] Starting subtest: fbc-psr2-primary-render
[243.509269] Starting dynamic subtest: eDP-1
[243.513612] Dynamic subtest eDP-1: SKIP (0.000s)
[243.517799] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[243.597734] [042/156] (778s left) gem_pxp (verify-pxp-stale-buf-execution)
[243.656063] Starting subtest: verify-pxp-stale-buf-execution
[244.722675] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.065s)
[244.858165] [043/156] (776s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[244.956932] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[251.775283] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.824s)
[251.887449] [044/156] (769s left) kms_prime (basic-crc-vgem)
[251.980233] Starting subtest: basic-crc-vgem
[251.982218] Starting dynamic subtest: second-to-first
[253.002588] Dynamic subtest second-to-first: SUCCESS (1.027s)
[253.004469] Subtest basic-crc-vgem: SUCCESS (1.027s)
[253.112339] [045/156] (768s left) kms_async_flips (test-time-stamp)
[253.227329] Starting subtest: test-time-stamp
[253.600495] Starting dynamic subtest: pipe-A-eDP-1
[254.371851] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.770s)
[254.749692] Starting dynamic subtest: pipe-B-eDP-1
[255.596191] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.851s)
[255.968781] Starting dynamic subtest: pipe-C-eDP-1
[256.821479] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.857s)
[257.192658] Starting dynamic subtest: pipe-D-eDP-1
[257.962811] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.775s)
[257.965179] Subtest test-time-stamp: SUCCESS (4.737s)
[259.139592] [046/156] (762s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite)
[259.240428] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite
[259.245071] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[259.320831] [047/156] (762s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[259.421872] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[259.426044] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[259.518586] [048/156] (762s left) vgem_basic (dmabuf-fence)
[259.562031] Starting subtest: dmabuf-fence
[259.564238] Subtest dmabuf-fence: SUCCESS (0.001s)
[259.618178] [049/156] (762s left) i915_pm_rpm (gem-pread)
[261.477460] Starting subtest: gem-pread
[263.334663] Subtest gem-pread: SUCCESS (1.857s)
[263.454501] [050/156] (758s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-plflip-blt)
[263.564529] Starting subtest: hdr-2p-scndscrn-indfb-plflip-blt
[263.569098] Subtest hdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[263.659888] [051/156] (758s left) gem_tiled_wb
[263.781080] [052/156] (758s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-onoff)
[263.875589] Starting subtest: fbchdr-1p-primscrn-cur-indfb-onoff
[263.879871] Subtest fbchdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[263.971322] [053/156] (758s left) gem_exec_suspend (basic-s0)
[264.022891] Starting subtest: basic-S0
[264.025219] Starting dynamic subtest: smem
[284.134471] Dynamic subtest smem: SUCCESS (7.303s)
[284.137360] Subtest basic-S0: SUCCESS (7.305s)
[291.343836] [054/156] (737s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[291.479249] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-mmap-wc
[291.483336] Subtest hdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[291.574422] [055/156] (737s left) sw_sync (sync_multi_timeline_wait)
[291.611453] Starting subtest: sync_multi_timeline_wait
[291.613408] Subtest sync_multi_timeline_wait: SUCCESS (0.001s)
[291.670709] [056/156] (737s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[291.768141] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[291.770536] Starting dynamic subtest: pipe-A-eDP-1
[291.793240] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[291.804243] Starting dynamic subtest: pipe-B-eDP-1
[291.825588] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[291.835264] Starting dynamic subtest: pipe-C-eDP-1
[291.857019] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[291.866262] Starting dynamic subtest: pipe-D-eDP-1
[291.888074] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[291.892105] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[294.067605] [057/156] (735s left) core_setmaster_vs_auth
[294.233097] [058/156] (735s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[294.327744] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[294.332108] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[294.440038] [059/156] (734s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[294.550268] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt
[294.554199] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[294.657164] [060/156] (734s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[294.756867] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[294.760995] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[294.840041] [061/156] (734s left) gem_mmap_gtt (medium-copy)
[294.899084] Subtest medium-copy: SKIP (0.000s)
[294.961023] [062/156] (734s left) dumb_buffer (map-valid)
[295.015887] Starting subtest: map-valid
[295.017972] Subtest map-valid: SUCCESS (0.000s)
[295.116536] [063/156] (734s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[295.208227] Starting subtest: 4-tiled-16bpp-rotate-90
[295.230161] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.019s)
[295.364976] [064/156] (734s left) kms_content_protection (lic-type-1)
[295.503905] Starting subtest: lic-type-1
[295.507829] Subtest lic-type-1: SKIP (0.000s)
[295.626454] [065/156] (734s left) syncobj_timeline (host-signal-ordered)
[295.676540] Starting subtest: host-signal-ordered
[295.678193] Subtest host-signal-ordered: SUCCESS (0.000s)
[295.788622] [066/156] (733s left) gem_exec_reloc (basic-range-active)
[295.838896] Subtest basic-range-active: SKIP (0.000s)
[295.916297] [067/156] (733s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[296.016916] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[296.020407] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[296.117838] [068/156] (733s left) gem_mmap_gtt (cpuset-big-copy)
[296.170658] Subtest cpuset-big-copy: SKIP (0.000s)
[296.230133] [069/156] (733s left) kms_chamelium_color (ctm-0-25)
[296.314252] Subtest ctm-0-25: SKIP (0.000s)
[296.360222] [070/156] (733s left) sysfs_heartbeat_interval (nopreempt)
[296.407259] Starting subtest: nopreempt
[296.409272] Starting dynamic subtest: vecs0
[306.148522] Dynamic subtest vecs0: SUCCESS (9.789s)
[306.161315] Starting dynamic subtest: ccs0
[310.195826] Dynamic subtest ccs0: SUCCESS (4.053s)
[310.207395] Starting dynamic subtest: vcs0
[320.108074] Dynamic subtest vcs0: SUCCESS (9.915s)
[320.120664] Starting dynamic subtest: bcs0
[324.080213] Dynamic subtest bcs0: SUCCESS (3.973s)
[324.093074] Starting dynamic subtest: rcs0
[328.139839] Dynamic subtest rcs0: SUCCESS (4.058s)
[328.154090] Starting dynamic subtest: vcs1
[338.147648] Dynamic subtest vcs1: SUCCESS (10.007s)
[338.150687] Subtest nopreempt: SUCCESS (41.806s)
[338.232952] [071/156] (691s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[338.416133] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[338.420577] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[338.489370] [072/156] (691s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[338.584789] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[345.204759] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.626s)
[345.321260] [073/156] (684s left) gem_eio (wait-1us)
[345.531400] Starting subtest: wait-1us
[345.835512] Subtest wait-1us: SUCCESS (0.304s)
[345.997897] [074/156] (684s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[346.086427] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[346.089087] Starting dynamic subtest: pipe-A-eDP-1
[346.111964] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[346.124857] Starting dynamic subtest: pipe-B-eDP-1
[346.145779] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[346.155778] Starting dynamic subtest: pipe-C-eDP-1
[346.176321] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[346.186021] Starting dynamic subtest: pipe-D-eDP-1
[346.206762] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[346.210882] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s)
[348.366175] [075/156] (681s left) gem_sync (basic-store-all)
[348.440431] Starting subtest: basic-store-all
[352.646599] Subtest basic-store-all: SUCCESS (4.218s)
[352.834780] [076/156] (677s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[352.948823] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[352.952880] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[353.062465] [077/156] (677s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[353.163581] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[353.167888] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[353.283569] [078/156] (676s left) gem_exec_schedule (u-submit-early-slice)
[353.348766] Starting subtest: u-submit-early-slice
[353.350738] Starting dynamic subtest: rcs0
[353.385207] Dynamic subtest rcs0: SUCCESS (0.043s)
[353.398709] Starting dynamic subtest: bcs0
[353.424961] Dynamic subtest bcs0: SUCCESS (0.039s)
[353.438148] Starting dynamic subtest: vcs0
[353.464896] Dynamic subtest vcs0: SUCCESS (0.039s)
[353.478543] Starting dynamic subtest: vcs1
[353.512433] Dynamic subtest vcs1: SUCCESS (0.047s)
[353.524450] Starting dynamic subtest: vecs0
[353.552225] Dynamic subtest vecs0: SUCCESS (0.039s)
[353.563771] Starting dynamic subtest: ccs0
[353.594927] Dynamic subtest ccs0: SUCCESS (0.042s)
[353.597317] Subtest u-submit-early-slice: SUCCESS (0.254s)
[355.204228] [079/156] (675s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[355.307279] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[355.311290] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[355.380590] [080/156] (674s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-blt)
[355.487333] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-blt
[355.491528] Subtest psrhdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[355.591858] [081/156] (674s left) kms_vrr (seamless-rr-switch-virtual)
[355.688521] Starting subtest: seamless-rr-switch-virtual
[355.695264] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[355.762906] [082/156] (674s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[355.817163] Starting subtest: single-wait-all-for-submit-signaled
[355.819225] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[355.926193] [083/156] (674s left) kms_scaling_modes (scaling-mode-full-aspect)
[356.026436] Starting subtest: scaling-mode-full-aspect
[356.028698] Starting dynamic subtest: pipe-A-eDP-1
[356.119684] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.095s)
[356.131277] Starting dynamic subtest: pipe-B-eDP-1
[357.284938] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.164s)
[357.298185] Starting dynamic subtest: pipe-C-eDP-1
[358.426183] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.140s)
[358.438186] Starting dynamic subtest: pipe-D-eDP-1
[359.559961] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.133s)
[359.562321] Subtest scaling-mode-full-aspect: SUCCESS (3.539s)
[360.733194] [084/156] (669s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-msflip-blt)
[360.838933] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-msflip-blt
[360.843357] Subtest fbcpsrhdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[360.931243] [085/156] (669s left) gem_basic (create-fd-close)
[360.991566] Starting subtest: create-fd-close
[360.995732] Subtest create-fd-close: SUCCESS (0.000s)
[361.096664] [086/156] (669s left) kms_psr (psr2-primary-blt)
[361.186320] Starting subtest: psr2-primary-blt
[361.188624] Starting dynamic subtest: eDP-1
[362.928770] Dynamic subtest eDP-1: SUCCESS (1.743s)
[362.931093] Subtest psr2-primary-blt: SUCCESS (1.744s)
[363.800596] [087/156] (666s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[363.908721] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc
[363.912725] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[364.006735] [088/156] (666s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[364.069980] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[364.180399] [089/156] (666s left) kms_chamelium_hpd (dp-hpd-storm)
[364.554985] Subtest dp-hpd-storm: SKIP (0.000s)
[365.409269] [090/156] (665s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[365.521983] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[365.526434] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[365.594586] [091/156] (665s left) syncobj_timeline (multi-wait-signaled)
[365.644212] Starting subtest: multi-wait-signaled
[365.646487] Subtest multi-wait-signaled: SUCCESS (0.000s)
[365.741241] [092/156] (665s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[365.836606] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[365.840799] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[365.935929] [093/156] (664s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-pwrite)
[366.032906] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-pwrite
[366.037032] Subtest fbchdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[366.132373] [094/156] (664s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[366.234315] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[370.751209] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.521s)
[371.934414] [095/156] (658s left) kms_frontbuffer_tracking (hdr-2p-primscrn-indfb-plflip-blt)
[372.033941] Starting subtest: hdr-2p-primscrn-indfb-plflip-blt
[372.038043] Subtest hdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[372.134063] [096/156] (658s left) kms_frontbuffer_tracking (fbchdr-suspend)
[372.238509] Starting subtest: fbchdr-suspend
[372.242768] Subtest fbchdr-suspend: SKIP (0.000s)
[372.324305] [097/156] (658s left) gem_exec_balancer (bonded-false-hang)
[372.586321] Starting subtest: bonded-false-hang
[372.590816] Subtest bonded-false-hang: SKIP (0.000s)
[372.696045] [098/156] (658s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[372.813901] Starting subtest: 2x-flip-vs-cursor-legacy
[372.818561] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[372.972255] [099/156] (658s left) kms_getfb (getfb2-handle-protection)
[373.063212] Starting subtest: getfb2-handle-protection
[373.078873] Subtest getfb2-handle-protection: SUCCESS (0.017s)
[373.207668] [100/156] (657s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[373.310210] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[373.314540] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[374.455372] [101/156] (656s left) kms_pm_backlight (fade)
[374.546631] Starting subtest: fade
[374.601951] Starting dynamic subtest: eDP-1
[377.625872] Dynamic subtest eDP-1: SUCCESS (3.026s)
[377.628265] Subtest fade: SUCCESS (3.082s)
[378.465720] [102/156] (652s left) gem_ctx_persistence (processes)
[378.529820] Starting subtest: processes
[380.142716] Subtest processes: SUCCESS (1.613s)
[380.222226] [103/156] (651s left) kms_prop_blob (invalid-set-prop)
[380.274121] Starting subtest: invalid-set-prop
[380.276258] Subtest invalid-set-prop: SUCCESS (0.000s)
[380.372952] [104/156] (650s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-mmap-wc)
[380.478189] Starting subtest: psrhdr-rgb101010-draw-mmap-wc
[380.482389] Subtest psrhdr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[380.570110] [105/156] (650s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[380.667659] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[380.671849] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[380.762672] [106/156] (650s left) kms_pm_rpm (legacy-planes-dpms)
[382.300860] Starting subtest: legacy-planes-dpms
[382.303098] Starting dynamic subtest: plane-65
[390.930424] Dynamic subtest plane-65: SUCCESS (8.628s)
[390.946616] Starting dynamic subtest: plane-95
[399.285149] Dynamic subtest plane-95: SUCCESS (8.350s)
[399.298213] Starting dynamic subtest: plane-125
[407.617002] Dynamic subtest plane-125: SUCCESS (8.328s)
[407.631813] Starting dynamic subtest: plane-135
[416.249061] Dynamic subtest plane-135: SUCCESS (8.629s)
[416.251734] Subtest legacy-planes-dpms: SUCCESS (33.946s)
[416.645468] [107/156] (614s left) kms_flip (flip-vs-fences-interruptible)
[416.741695] Starting subtest: flip-vs-fences-interruptible
[416.745849] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[416.870326] [108/156] (614s left) gem_exec_fence (syncobj-timeline-export)
[417.447356] Starting subtest: syncobj-timeline-export
[417.454055] Subtest syncobj-timeline-export: SUCCESS (0.007s)
[419.192423] [109/156] (612s left) gen9_exec_parse (unaligned-access)
[419.251890] Subtest unaligned-access: SKIP (0.000s)
[419.322166] [110/156] (612s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[419.420229] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[419.424575] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[419.493209] [111/156] (612s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-indfb-pgflip-blt)
[419.595525] Starting subtest: psrhdr-2p-primscrn-indfb-pgflip-blt
[419.599943] Subtest psrhdr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[419.690166] [112/156] (611s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[419.793191] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[424.924825] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (5.138s)
[425.032659] [113/156] (606s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-render)
[425.128835] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-render
[425.133392] Subtest psrhdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[425.225016] [114/156] (606s left) gem_exec_reloc (basic-gtt-cpu)
[425.283001] Subtest basic-gtt-cpu: SKIP (0.000s)
[425.353285] [115/156] (606s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[425.449420] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[425.451584] Starting dynamic subtest: pipe-A-eDP-1
[425.473580] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[425.484991] Starting dynamic subtest: pipe-B-eDP-1
[425.505882] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[425.516791] Starting dynamic subtest: pipe-C-eDP-1
[425.537507] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[425.547855] Starting dynamic subtest: pipe-D-eDP-1
[425.569418] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[425.573379] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[427.778145] [116/156] (604s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[427.872461] Starting subtest: fb-8bpc-vs-panel-8bpc
[427.874718] Starting dynamic subtest: pipe-A-eDP-1
[429.243783] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.370s)
[429.245887] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.371s)
[430.064939] [117/156] (601s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[430.163518] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[431.032231] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.870s)
[431.211718] [118/156] (600s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-pwrite)
[431.324668] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-pwrite
[431.328873] Subtest hdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[431.432269] [119/156] (600s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-move)
[431.538273] Starting subtest: fbchdr-1p-primscrn-spr-indfb-move
[431.542774] Subtest fbchdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[431.635442] [120/156] (600s left) kms_3d (basic)
[431.685350] Starting subtest: basic
[433.993895] Subtest basic: SUCCESS (2.311s)
[434.507667] [121/156] (597s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[434.570897] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[434.674232] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.103s)
[434.751863] [122/156] (597s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[434.853415] Starting subtest: yf-tiled-64bpp-rotate-0
[434.857970] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[434.954491] [123/156] (597s left) syncobj_wait (wait-for-submit-complex)
[435.005767] Starting subtest: wait-for-submit-complex
[435.067203] Subtest wait-for-submit-complex: SUCCESS (0.061s)
[435.157441] [124/156] (597s left) gem_exec_params (rel-constants-invalid-ring)
[435.216126] Starting subtest: rel-constants-invalid-ring
[435.218508] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[435.341472] [125/156] (596s left) syncobj_wait (multi-wait-for-submit-signaled)
[435.396137] Starting subtest: multi-wait-for-submit-signaled
[435.398324] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[435.511242] [126/156] (596s left) syncobj_wait (wait-all-snapshot)
[435.571077] Starting subtest: wait-all-snapshot
[435.652249] Subtest wait-all-snapshot: SUCCESS (0.082s)
[435.730758] [127/156] (596s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[435.842695] Starting subtest: flip-vs-cursor-crc-legacy
[436.541872] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.699s)
[437.375621] [128/156] (594s left) drm_read (empty-block)
[437.520187] Starting subtest: empty-block
[438.524689] Subtest empty-block: SUCCESS (1.002s)
[438.661618] [129/156] (593s left) kms_plane_alpha_blend (constant-alpha-mid)
[438.758286] Starting subtest: constant-alpha-mid
[439.046903] Starting dynamic subtest: pipe-A-eDP-1
[440.013255] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.966s)
[440.024314] Starting dynamic subtest: pipe-D-eDP-1
[441.585209] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.571s)
[441.587531] Subtest constant-alpha-mid: SUCCESS (2.830s)
[442.439729] [130/156] (589s left) kms_frontbuffer_tracking (fbc-stridechange)
[442.540612] Starting subtest: fbc-stridechange
[445.805988] Subtest fbc-stridechange: SUCCESS (3.270s)
[446.954316] [131/156] (585s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[447.051086] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[448.185599] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.134s)
[448.324344] [132/156] (584s left) gem_mmap_offset (partial-mmap)
[448.374890] Starting subtest: partial-mmap
[448.376554] Starting dynamic subtest: smem0
[448.378617] Dynamic subtest smem0: SUCCESS (0.004s)
[448.380493] Subtest partial-mmap: SUCCESS (0.005s)
[448.498297] [133/156] (584s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[448.590505] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[448.594238] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[448.667682] [134/156] (583s left) kms_psr (fbc-pr-cursor-blt)
[448.758246] Starting subtest: fbc-pr-cursor-blt
[448.761760] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[448.845632] [135/156] (583s left) gem_ctx_sseu (invalid-sseu)
[448.916527] Subtest invalid-sseu: SKIP (0.000s)
[448.988190] [136/156] (583s left) kms_frontbuffer_tracking (psr-1p-rte)
[449.096317] Starting subtest: psr-1p-rte
[454.564577] Subtest psr-1p-rte: SUCCESS (5.475s)
[454.702165] [137/156] (578s left) gem_exec_reloc (basic-gtt-wc)
[454.755733] Subtest basic-gtt-wc: SKIP (0.000s)
[454.828010] [138/156] (577s left) gem_softpin (allocator-basic)
[454.884057] Starting subtest: allocator-basic
[454.957762] Subtest allocator-basic: SUCCESS (0.073s)
[455.087617] [139/156] (577s left) prime_self_import (export-vs-gem_close-race)
[455.125929] Starting subtest: export-vs-gem_close-race
[460.228599] Subtest export-vs-gem_close-race: SUCCESS (5.103s)
[460.314476] [140/156] (572s left) gem_lmem_swapping (parallel-random-engines)
[460.361980] Subtest parallel-random-engines: SKIP (0.000s)
[460.416529] [141/156] (572s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[460.526507] Starting subtest: fbc-2p-pri-indfb-multidraw
[460.530635] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[460.636242] [142/156] (572s left) kms_sequence (get-idle)
[460.756456] Starting subtest: get-idle
[460.758370] Starting dynamic subtest: pipe-A-eDP-1
[462.571372] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.815s)
[462.584520] Starting dynamic subtest: pipe-B-eDP-1
[465.058928] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.487s)
[465.072096] Starting dynamic subtest: pipe-C-eDP-1
[467.561621] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.502s)
[467.573121] Starting dynamic subtest: pipe-D-eDP-1
[469.987009] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.422s)
[469.988970] Subtest get-idle: SUCCESS (9.232s)
[470.800884] [143/156] (562s left) gem_exec_gttfill (engines)
[470.860540] Starting subtest: engines
[470.862965] Starting dynamic subtest: rcs0
[493.715018] Dynamic subtest rcs0: SUCCESS (22.860s)
[493.725395] Starting dynamic subtest: bcs0
[517.031346] Dynamic subtest bcs0: SUCCESS (23.316s)
[517.044497] Starting dynamic subtest: vcs0
[540.361881] Dynamic subtest vcs0: SUCCESS (23.323s)
[540.375652] Starting dynamic subtest: vcs1
[563.677918] Dynamic subtest vcs1: SUCCESS (23.310s)
[563.691077] Starting dynamic subtest: vecs0
[587.045123] Dynamic subtest vecs0: SUCCESS (23.365s)
[587.058894] Starting dynamic subtest: ccs0
[610.446826] Dynamic subtest ccs0: SUCCESS (23.400s)
[610.449457] Subtest engines: SUCCESS (139.586s)
[610.652585] [144/156] (422s left) gem_exec_capture (pi)
[610.761469] Starting subtest: pi
[610.764051] Starting dynamic subtest: rcs0
[614.873234] Dynamic subtest rcs0: SUCCESS (4.111s)
[614.885020] Starting dynamic subtest: bcs0
[618.921615] Dynamic subtest bcs0: SUCCESS (4.047s)
[618.932806] Starting dynamic subtest: vcs0
[622.970416] Dynamic subtest vcs0: SUCCESS (4.049s)
[622.980833] Starting dynamic subtest: vcs1
[627.019760] Dynamic subtest vcs1: SUCCESS (4.048s)
[627.032023] Starting dynamic subtest: vecs0
[631.104202] Dynamic subtest vecs0: SUCCESS (4.082s)
[631.115423] Starting dynamic subtest: ccs0
[635.207347] Dynamic subtest ccs0: SUCCESS (4.103s)
[635.209744] Subtest pi: SUCCESS (24.449s)
[635.300413] [145/156] (397s left) kms_getfb (getfb-handle-not-fb)
[635.450007] Starting subtest: getfb-handle-not-fb
[635.452418] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[635.565920] [146/156] (397s left) kms_cursor_crc (cursor-onscreen-256x85)
[635.836109] Starting subtest: cursor-onscreen-256x85
[635.886020] Subtest cursor-onscreen-256x85: SKIP (0.043s)
[636.074505] [147/156] (397s left) gem_ctx_persistence (engines-hostile-preempt)
[636.133488] Starting subtest: engines-hostile-preempt
[636.135775] Starting dynamic subtest: rcs0
[636.200673] Dynamic subtest rcs0: SUCCESS (0.067s)
[636.215795] Starting dynamic subtest: bcs0
[636.276683] Dynamic subtest bcs0: SUCCESS (0.073s)
[636.288191] Starting dynamic subtest: vcs0
[638.121312] Dynamic subtest vcs0: SUCCESS (1.841s)
[638.133731] Starting dynamic subtest: vcs1
[640.095538] Dynamic subtest vcs1: SUCCESS (1.971s)
[640.107782] Starting dynamic subtest: vecs0
[642.152595] Dynamic subtest vecs0: SUCCESS (2.054s)
[642.167265] Starting dynamic subtest: ccs0
[642.187960] Dynamic subtest ccs0: SUCCESS (0.034s)
[642.190230] Subtest engines-hostile-preempt: SUCCESS (6.056s)
[642.298617] [148/156] (390s left) kms_big_fb (y-tiled-addfb)
[642.420668] Starting subtest: y-tiled-addfb
[642.424779] Subtest y-tiled-addfb: SKIP (0.000s)
[642.529638] [149/156] (390s left) gem_create (create-ext-set-pat)
[642.700974] Starting subtest: create-ext-set-pat
[642.703146] Subtest create-ext-set-pat: SUCCESS (0.000s)
[642.789555] [150/156] (390s left) i915_getparams_basic (basic-subslice-total)
[642.835797] Starting subtest: basic-subslice-total
[642.840474] Subtest basic-subslice-total: SUCCESS (0.000s)
[642.924550] [151/156] (390s left) kms_feature_discovery (display-4x)
[643.015946] Starting subtest: display-4x
[643.020251] Subtest display-4x: SKIP (0.000s)
[643.104389] [152/156] (390s left) kms_vblank (wait-busy-hang)
[643.195411] Starting subtest: wait-busy-hang
[643.197223] Starting dynamic subtest: pipe-A-eDP-1
[669.928636] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.738s)
[669.945812] Starting dynamic subtest: pipe-D-eDP-1
[684.973324] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.042s)
[684.975637] Subtest wait-busy-hang: SUCCESS (41.784s)
[685.825326] [153/156] (347s left) kms_psr (pr-sprite-render)
[685.924102] Starting subtest: pr-sprite-render
[685.928535] Subtest pr-sprite-render: SKIP (0.000s)
[686.016453] [154/156] (347s left) gen9_exec_parse (cmd-crossing-page)
[686.083077] Subtest cmd-crossing-page: SKIP (0.000s)
[686.179363] [155/156] (347s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[686.297654] Starting subtest: basic-busy-flip-before-cursor-varying-size
[686.302259] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[686.447637] [156/156] (347s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[686.552127] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[686.556119] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[686.651329] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: dmabuf_sync_file
results: parsing output: 3/ for test: kms_plane_scaling
results: parsing output: 4/ for test: kms_chamelium_frames
results: parsing output: 5/ for test: api_intel_allocator
results: parsing output: 6/ for test: kms_cursor_crc
results: parsing output: 7/ for test: prime_mmap
results: parsing output: 8/ for test: kms_pipe_crc_basic
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: gem_ctx_param
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: prime_self_import
results: parsing output: 14/ for test: kms_invalid_mode
results: parsing output: 15/ for test: kms_color_pipeline
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: syncobj_eventfd
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_spin_batch
results: parsing output: 25/ for test: prime_mmap_coherency
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: perf_pmu
results: parsing output: 30/ for test: kms_getfb
results: parsing output: 31/ for test: core_getclient
results: parsing output: 32/ for test: gem_exec_schedule
results: parsing output: 33/ for test: gem_pxp
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: kms_ccs
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: gem_fenced_exec_thrash
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: i915_pm_rps
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: gem_pxp
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_prime
results: parsing output: 44/ for test: kms_async_flips
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: vgem_basic
results: parsing output: 48/ for test: i915_pm_rpm
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_tiled_wb
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_exec_suspend
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: sw_sync
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: core_setmaster_vs_auth
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_mmap_gtt
results: parsing output: 61/ for test: dumb_buffer
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: kms_content_protection
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: gem_exec_reloc
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_mmap_gtt
results: parsing output: 68/ for test: kms_chamelium_color
results: parsing output: 69/ for test: sysfs_heartbeat_interval
results: parsing output: 70/ for test: kms_plane
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_eio
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: gem_sync
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_exec_schedule
results: parsing output: 78/ for test: kms_plane
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_vrr
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: kms_scaling_modes
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_basic
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_userptr_blits
results: parsing output: 88/ for test: kms_chamelium_hpd
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_frontbuffer_tracking
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_frontbuffer_tracking
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_exec_balancer
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: kms_getfb
results: parsing output: 99/ for test: kms_ccs
results: parsing output: 100/ for test: kms_pm_backlight
results: parsing output: 101/ for test: gem_ctx_persistence
results: parsing output: 102/ for test: kms_prop_blob
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_pm_rpm
results: parsing output: 106/ for test: kms_flip
results: parsing output: 107/ for test: gem_exec_fence
results: parsing output: 108/ for test: gen9_exec_parse
results: parsing output: 109/ for test: kms_flip_scaled_crc
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_frontbuffer_tracking
results: parsing output: 113/ for test: gem_exec_reloc
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: kms_dither
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_3d
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: gem_exec_params
results: parsing output: 124/ for test: syncobj_wait
results: parsing output: 125/ for test: syncobj_wait
results: parsing output: 126/ for test: kms_cursor_legacy
results: parsing output: 127/ for test: drm_read
results: parsing output: 128/ for test: kms_plane_alpha_blend
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: gem_mmap_offset
results: parsing output: 132/ for test: kms_flip_scaled_crc
results: parsing output: 133/ for test: kms_psr
results: parsing output: 134/ for test: gem_ctx_sseu
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: gem_exec_reloc
results: parsing output: 137/ for test: gem_softpin
results: parsing output: 138/ for test: prime_self_import
results: parsing output: 139/ for test: gem_lmem_swapping
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: kms_sequence
results: parsing output: 142/ for test: gem_exec_gttfill
results: parsing output: 143/ for test: gem_exec_capture
results: parsing output: 144/ for test: kms_getfb
results: parsing output: 145/ for test: kms_cursor_crc
results: parsing output: 146/ for test: gem_ctx_persistence
results: parsing output: 147/ for test: kms_big_fb
results: parsing output: 148/ for test: gem_create
results: parsing output: 149/ for test: i915_getparams_basic
results: parsing output: 150/ for test: kms_feature_discovery
results: parsing output: 151/ for test: kms_vblank
results: parsing output: 152/ for test: kms_psr
results: parsing output: 153/ for test: gen9_exec_parse
results: parsing output: 154/ for test: kms_cursor_legacy
results: parsing output: 155/ for test: kms_frontbuffer_tracking
Done.