[57.097061] Initializing watchdogs
[57.097122]   /dev/watchdog0
[57.111581] [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.116093] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.118302] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.121697] [001/133] (960s left) gem_exec_reloc (basic-wc-gtt-active)
[57.212144] Subtest basic-wc-gtt-active: SKIP (0.000s)
[57.279102] [002/133] (960s left) gem_busy (close-race)
[57.356849] Starting subtest: close-race
[80.918515] Subtest close-race: SUCCESS (23.597s)
[81.323691] [FACT gem_busy (close-race)] new: kernel.kmod_is_loaded.vgem: true
[81.328951] [003/133] (936s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[81.484188] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[81.488481] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[81.609610] [004/133] (936s left) kms_vrr (flip-dpms)
[81.709710] Starting subtest: flip-dpms
[81.716939] Subtest flip-dpms: SKIP (0.000s)
[81.794238] [005/133] (935s left) gem_exec_alignment (forked)
[81.868859] Starting subtest: forked
[119.944897] Subtest forked: SUCCESS (38.075s)
[120.036730] [006/133] (897s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[120.162585] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[120.164456] Starting dynamic subtest: pipe-A-eDP-1
[120.324369] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.154s)
[120.335378] Starting dynamic subtest: pipe-B-eDP-1
[120.354659] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[120.364290] Starting dynamic subtest: pipe-C-eDP-1
[120.385668] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[120.394626] Starting dynamic subtest: pipe-D-eDP-1
[120.414269] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[120.416344] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.188s)
[122.632219] [007/133] (895s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[122.734973] Starting subtest: psr-rgb565-draw-pwrite
[129.713861] Subtest psr-rgb565-draw-pwrite: SUCCESS (6.984s)
[129.838198] [008/133] (888s left) kms_pipe_crc_basic (hang-read-crc)
[129.947755] Starting subtest: hang-read-crc
[129.950110] Starting dynamic subtest: pipe-A-eDP-1
[132.040483] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.092s)
[132.051920] Starting dynamic subtest: pipe-B-eDP-1
[134.803511] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.762s)
[134.813099] Starting dynamic subtest: pipe-C-eDP-1
[137.431376] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.626s)
[137.440605] Starting dynamic subtest: pipe-D-eDP-1
[140.091360] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.660s)
[140.093795] Subtest hang-read-crc: SUCCESS (10.144s)
[140.944084] [009/133] (877s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[141.008039] Starting subtest: framebuffer-vs-set-tiling
[141.012253] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[141.183325] [010/133] (876s left) gem_mmap_offset (blt-coherency)
[141.240636] Starting subtest: blt-coherency
[141.248901] Subtest blt-coherency: SUCCESS (0.010s)
[141.411231] [011/133] (876s left) gem_exec_flush (basic-wb-ro-default)
[141.488383] Starting subtest: basic-wb-ro-default
[146.940903] Subtest basic-wb-ro-default: SUCCESS (5.452s)
[147.134403] [012/133] (870s left) gem_exec_params (invalid-batch-start-offset)
[147.191066] Starting subtest: invalid-batch-start-offset
[147.195944] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[147.329582] [013/133] (870s left) i915_pm_rps (thresholds)
[147.394973] Starting subtest: thresholds
[147.399243] Subtest thresholds: SKIP (0.001s)
[147.510261] [014/133] (870s left) syncobj_basic (illegal-fd-to-handle)
[147.565790] Starting subtest: illegal-fd-to-handle
[147.568128] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[147.696427] [015/133] (870s left) kms_flip (flip-vs-fences)
[147.796675] Starting subtest: flip-vs-fences
[147.800678] Subtest flip-vs-fences: SKIP (0.000s)
[147.919939] [016/133] (870s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[148.014125] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[148.040552] Starting dynamic subtest: pipe-A-plane-0
[148.045547] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[148.055802] Starting dynamic subtest: pipe-A-plane-3
[148.060312] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[148.068374] Starting dynamic subtest: pipe-A-plane-5
[148.072642] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[149.108830] Starting dynamic subtest: pipe-B-plane-0
[149.113093] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[149.121557] Starting dynamic subtest: pipe-B-plane-3
[149.126276] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[149.134521] Starting dynamic subtest: pipe-B-plane-5
[149.139179] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[149.436424] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (1.420s)
[150.294952] [017/133] (867s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[150.412293] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[150.416495] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[150.532130] [018/133] (867s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[150.652451] Starting subtest: cursorA-vs-flipB-toggle
[150.656959] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[150.821717] [019/133] (867s left) kms_big_fb (x-tiled-addfb)
[150.924371] Starting subtest: x-tiled-addfb
[150.926673] Subtest x-tiled-addfb: SUCCESS (0.000s)
[151.017059] [020/133] (867s left) i915_drm_fdinfo (virtual-busy-all)
[151.064567] Starting subtest: virtual-busy-all
[151.069295] Subtest virtual-busy-all: SKIP (0.000s)
[151.138042] [021/133] (867s left) kms_lease (cursor-implicit-plane)
[151.239414] Starting subtest: cursor-implicit-plane
[151.241466] Starting dynamic subtest: pipe-A-eDP-1
[151.717535] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.476s)
[151.727295] Starting dynamic subtest: pipe-B-eDP-1
[152.808841] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.087s)
[152.817251] Starting dynamic subtest: pipe-C-eDP-1
[153.924926] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.115s)
[153.933419] Starting dynamic subtest: pipe-D-eDP-1
[155.062550] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.139s)
[155.064873] Subtest cursor-implicit-plane: SUCCESS (3.823s)
[155.932862] [022/133] (862s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[156.029068] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[157.096471] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.068s)
[157.244675] [023/133] (861s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[157.355515] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[157.359452] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[157.488872] [024/133] (861s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[157.595189] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[164.366079] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.772s)
[164.539219] [025/133] (854s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[164.649820] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[164.654329] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[164.752038] [026/133] (853s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[164.839922] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[164.842252] Starting dynamic subtest: pipe-A-eDP-1
[164.865818] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[164.877358] Starting dynamic subtest: pipe-B-eDP-1
[164.900177] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[164.910313] Starting dynamic subtest: pipe-C-eDP-1
[164.932357] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[164.940878] Starting dynamic subtest: pipe-D-eDP-1
[164.964315] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[164.968582] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[167.126037] [027/133] (851s left) kms_flip (flip-vs-rmfb-interruptible)
[167.237502] Starting subtest: flip-vs-rmfb-interruptible
[167.239923] Starting dynamic subtest: A-eDP1
[175.882301] Dynamic subtest A-eDP1: SUCCESS (8.643s)
[175.892356] Starting dynamic subtest: B-eDP1
[184.513083] Dynamic subtest B-eDP1: SUCCESS (8.630s)
[184.522347] Starting dynamic subtest: C-eDP1
[193.133122] Dynamic subtest C-eDP1: SUCCESS (8.618s)
[193.142268] Starting dynamic subtest: D-eDP1
[201.755710] Dynamic subtest D-eDP1: SUCCESS (8.621s)
[201.760029] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.520s)
[202.952216] [028/133] (815s left) core_setmaster (master-drop-set-root)
[203.030431] Starting subtest: master-drop-set-root
[203.043676] Subtest master-drop-set-root: SUCCESS (0.014s)
[203.097054] [029/133] (815s left) kms_big_fb (linear-16bpp-rotate-90)
[203.205803] Starting subtest: linear-16bpp-rotate-90
[203.224872] Subtest linear-16bpp-rotate-90: SKIP (0.019s)
[203.384298] [030/133] (815s left) kms_draw_crc (draw-method-mmap-cpu)
[203.484441] Starting subtest: draw-method-mmap-cpu
[203.486388] Starting dynamic subtest: xrgb8888-untiled
[203.726845] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s)
[203.739708] Starting dynamic subtest: rgb565-untiled
[203.970660] Dynamic subtest rgb565-untiled: SUCCESS (0.243s)
[203.978425] Starting dynamic subtest: xrgb2101010-untiled
[204.192883] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[204.201266] Starting dynamic subtest: xbgr16161616f-untiled
[204.471128] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.277s)
[204.479916] Starting dynamic subtest: xrgb8888-xtiled
[204.637773] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.164s)
[204.645715] Starting dynamic subtest: rgb565-xtiled
[204.781865] Dynamic subtest rgb565-xtiled: SUCCESS (0.143s)
[204.789970] Starting dynamic subtest: xrgb2101010-xtiled
[204.915836] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.133s)
[204.924169] Starting dynamic subtest: xbgr16161616f-xtiled
[205.048639] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[205.058975] Starting dynamic subtest: xrgb8888-4tiled
[205.205498] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.153s)
[205.213556] Starting dynamic subtest: rgb565-4tiled
[205.348560] Dynamic subtest rgb565-4tiled: SUCCESS (0.143s)
[205.356917] Starting dynamic subtest: xrgb2101010-4tiled
[205.492899] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.144s)
[205.500813] Starting dynamic subtest: xbgr16161616f-4tiled
[205.627446] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[205.629385] Subtest draw-method-mmap-cpu: SUCCESS (2.145s)
[205.766517] [031/133] (813s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[205.893933] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[205.897678] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[206.074687] [032/133] (812s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[206.173311] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[206.177073] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[206.257386] [033/133] (812s left) gem_exec_balancer (busy)
[206.330567] Starting subtest: busy
[207.876651] Subtest busy: SUCCESS (1.544s)
[208.208114] [034/133] (810s left) gem_exec_schedule (u-semaphore-resolve)
[208.272321] Starting subtest: u-semaphore-resolve
[208.303997] Subtest u-semaphore-resolve: SUCCESS (0.039s)
[208.660414] [035/133] (810s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[208.764271] Starting subtest: 4-tiled-32bpp-rotate-0
[210.164406] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.401s)
[210.312137] [036/133] (808s left) sw_sync (sync_busy)
[210.345722] Starting subtest: sync_busy
[210.347634] Subtest sync_busy: SUCCESS (0.002s)
[210.415661] [037/133] (808s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[210.479023] Starting subtest: basic-batch-kernel-default-cmd
[210.482625] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[210.673588] [038/133] (808s left) gem_exec_schedule (preempt-engines)
[210.753950] Starting subtest: preempt-engines
[210.755936] Starting dynamic subtest: rcs0
[212.993565] Dynamic subtest rcs0: SUCCESS (2.246s)
[213.008897] Starting dynamic subtest: bcs0
[215.286658] Dynamic subtest bcs0: SUCCESS (2.291s)
[215.301546] Starting dynamic subtest: vcs0
[217.555194] Dynamic subtest vcs0: SUCCESS (2.266s)
[217.571219] Starting dynamic subtest: vcs1
[219.830064] Dynamic subtest vcs1: SUCCESS (2.272s)
[219.846185] Starting dynamic subtest: vecs0
[222.086841] Dynamic subtest vecs0: SUCCESS (2.255s)
[222.099135] Starting dynamic subtest: ccs0
[224.402065] Dynamic subtest ccs0: SUCCESS (2.313s)
[224.404770] Subtest preempt-engines: SUCCESS (13.655s)
[224.735790] [039/133] (794s left) gem_mmap_wc (bad-size)
[224.802631] Subtest bad-size: SKIP (0.000s)
[224.875407] [040/133] (794s left) gem_media_vme
[225.017848] [041/133] (794s left) kms_addfb_basic (basic-y-tiled-legacy)
[225.085952] Starting subtest: basic-y-tiled-legacy
[225.090585] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[225.246064] [042/133] (794s left) sw_sync (timeline_closed_signaled)
[225.294615] Starting subtest: timeline_closed_signaled
[225.296740] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[225.381404] [043/133] (793s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[225.494617] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[225.498814] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[225.602824] [044/133] (793s left) gem_ctx_param (non-root-set)
[225.669134] Starting subtest: non-root-set
[225.698247] Subtest non-root-set: SUCCESS (0.029s)
[225.808252] [045/133] (793s left) kms_cursor_crc (cursor-onscreen-128x42)
[226.039724] Starting subtest: cursor-onscreen-128x42
[226.083774] Subtest cursor-onscreen-128x42: SKIP (0.042s)
[226.312919] [046/133] (793s left) api_intel_bb (intel-bb-blit-y)
[226.365270] Starting subtest: intel-bb-blit-y
[230.016402] Subtest intel-bb-blit-y: SUCCESS (3.651s)
[230.163606] [047/133] (789s left) kms_plane_multiple (2x-tiling-x)
[230.268854] Starting subtest: 2x-tiling-x
[230.273227] Subtest 2x-tiling-x: SKIP (0.000s)
[230.366911] [048/133] (789s left) syncobj_timeline (single-wait-available-signaled)
[230.429163] Starting subtest: single-wait-available-signaled
[230.431501] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[230.557172] [049/133] (789s left) vgem_basic (busy-fence)
[230.601646] Starting subtest: busy-fence
[230.603996] Subtest busy-fence: SUCCESS (0.000s)
[230.668952] [050/133] (788s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[230.769726] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[234.914561] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.148s)
[236.064338] [051/133] (783s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[236.164550] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[236.166726] Starting dynamic subtest: pipe-A
[236.184578] Dynamic subtest pipe-A: SKIP (0.017s)
[236.194159] Starting dynamic subtest: pipe-B
[236.216275] Dynamic subtest pipe-B: SKIP (0.031s)
[236.224662] Starting dynamic subtest: pipe-C
[236.246919] Dynamic subtest pipe-C: SKIP (0.030s)
[236.255366] Starting dynamic subtest: pipe-D
[236.277182] Dynamic subtest pipe-D: SKIP (0.030s)
[236.280990] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.111s)
[236.382908] [052/133] (783s left) kms_pm_rpm (modeset-non-lpsp-stress)
[238.122870] Starting subtest: modeset-non-lpsp-stress
[239.267486] Subtest modeset-non-lpsp-stress: SKIP (1.148s)
[239.650300] [053/133] (780s left) kms_psr (fbc-psr2-primary-blt)
[239.751306] Starting subtest: fbc-psr2-primary-blt
[239.753481] Starting dynamic subtest: eDP-1
[239.757863] Dynamic subtest eDP-1: SKIP (0.000s)
[239.762230] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[239.837403] [054/133] (779s left) kms_pm_rpm (basic-pci-d3-state)
[242.066457] Starting subtest: basic-pci-d3-state
[243.555816] Subtest basic-pci-d3-state: SUCCESS (1.488s)
[243.669081] [055/133] (776s left) gem_cs_tlb (engines)
[243.734773] Starting subtest: engines
[243.737164] Starting dynamic subtest: rcs0
[245.891342] Dynamic subtest rcs0: SUCCESS (2.152s)
[245.902572] Starting dynamic subtest: bcs0
[248.044085] Dynamic subtest bcs0: SUCCESS (2.151s)
[248.055437] Starting dynamic subtest: vcs0
[250.197852] Dynamic subtest vcs0: SUCCESS (2.153s)
[250.206055] Starting dynamic subtest: vcs1
[252.352653] Dynamic subtest vcs1: SUCCESS (2.153s)
[252.361688] Starting dynamic subtest: vecs0
[254.507094] Dynamic subtest vecs0: SUCCESS (2.154s)
[254.517653] Starting dynamic subtest: ccs0
[256.661603] Dynamic subtest ccs0: SUCCESS (2.154s)
[256.663809] Subtest engines: SUCCESS (12.924s)
[256.817127] [056/133] (763s left) sw_sync (sync_busy_fork_unixsocket)
[256.853647] Starting subtest: sync_busy_fork_unixsocket
[256.858919] Subtest sync_busy_fork_unixsocket: SUCCESS (0.006s)
[256.943774] [057/133] (762s left) kms_psr (pr-cursor-render)
[257.041989] Starting subtest: pr-cursor-render
[257.046340] Subtest pr-cursor-render: SKIP (0.000s)
[257.134062] [058/133] (762s left) kms_psr (fbc-psr-cursor-plane-onoff)
[257.220996] Starting subtest: fbc-psr-cursor-plane-onoff
[257.223270] Starting dynamic subtest: eDP-1
[257.227276] Dynamic subtest eDP-1: SKIP (0.000s)
[257.231315] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[257.308862] [059/133] (762s left) gem_softpin (noreloc-s3)
[257.368240] Starting subtest: noreloc-S3
[277.172634] Subtest noreloc-S3: SUCCESS (5.384s)
[277.392295] [060/133] (742s left) gem_exec_fence (syncobj-timeline-chain-engines)
[278.000786] Starting subtest: syncobj-timeline-chain-engines
[278.167966] Subtest syncobj-timeline-chain-engines: SUCCESS (0.168s)
[279.484822] [061/133] (740s left) kms_content_protection (uevent-hdcp14)
[279.619571] Starting subtest: uevent-hdcp14
[279.623658] Subtest uevent-hdcp14: SKIP (0.000s)
[279.764209] [062/133] (740s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[279.863827] Starting subtest: psr2-overlay-plane-move-continuous-sf
[279.866043] Starting dynamic subtest: pipe-A-eDP-1
[285.803769] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.981s)
[285.815506] Starting dynamic subtest: pipe-B-eDP-1
[292.433784] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.651s)
[292.436280] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (12.636s)
[293.248341] [063/133] (726s left) drm_read (invalid-buffer)
[293.391300] Starting subtest: invalid-buffer
[293.393769] Subtest invalid-buffer: SUCCESS (0.000s)
[293.554391] [064/133] (726s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[293.678142] Starting subtest: cursor-vs-flip-varying-size
[324.581205] Subtest cursor-vs-flip-varying-size: SUCCESS (30.912s)
[325.464833] [065/133] (694s left) gem_ccs (block-copy-compressed)
[325.523821] Starting subtest: block-copy-compressed
[325.530284] Subtest block-copy-compressed: SKIP (0.000s)
[325.650754] [066/133] (694s left) i915_hangman (gt-error-state-capture)
[325.733219] Starting subtest: gt-error-state-capture
[325.735527] Starting dynamic subtest: rcs0
[337.344986] Dynamic subtest rcs0: SUCCESS (11.615s)
[337.357203] Starting dynamic subtest: bcs0
[349.376452] Dynamic subtest bcs0: SUCCESS (12.032s)
[349.388935] Starting dynamic subtest: vcs0
[361.281510] Dynamic subtest vcs0: SUCCESS (11.906s)
[361.294163] Starting dynamic subtest: vcs1
[372.289163] Dynamic subtest vcs1: SUCCESS (11.005s)
[372.301825] Starting dynamic subtest: vecs0
[383.296684] Dynamic subtest vecs0: SUCCESS (11.001s)
[383.309810] Starting dynamic subtest: ccs0
[394.369531] Dynamic subtest ccs0: SUCCESS (11.068s)
[394.372338] Subtest gt-error-state-capture: SUCCESS (68.645s)
[394.538641] [067/133] (625s left) gem_exec_suspend (basic-s4-devices)
[394.626096] Starting subtest: basic-S4-devices
[394.628459] Starting dynamic subtest: smem
[406.371983] Dynamic subtest smem: SUCCESS (11.743s)
[406.376195] Subtest basic-S4-devices: SUCCESS (11.745s)
[412.599370] [068/133] (613s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[412.712569] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[412.716670] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[412.852621] [069/133] (613s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[412.954157] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[412.958602] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[413.063943] [070/133] (613s left) gem_userptr_blits (relocations)
[413.127905] Starting subtest: relocations
[413.132075] Subtest relocations: SKIP (0.001s)
[413.280948] [071/133] (613s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[413.379577] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[417.819777] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.444s)
[418.957668] [072/133] (607s left) gem_userptr_blits (set-cache-level)
[419.035387] Starting subtest: set-cache-level
[419.039522] Subtest set-cache-level: SKIP (0.000s)
[419.193638] [073/133] (607s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[419.253675] Starting subtest: etime-single-wait-for-submit-unsubmitted
[419.359036] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[419.449506] [074/133] (607s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[419.546335] Starting subtest: bo-too-small-due-to-tiling
[419.550764] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[419.679085] [075/133] (607s left) gem_ctx_persistence (engines-hostile-preempt)
[419.744957] Starting subtest: engines-hostile-preempt
[419.747285] Starting dynamic subtest: rcs0
[419.839135] Dynamic subtest rcs0: SUCCESS (0.093s)
[419.855874] Starting dynamic subtest: bcs0
[419.911085] Dynamic subtest bcs0: SUCCESS (0.070s)
[419.924146] Starting dynamic subtest: vcs0
[421.359761] Dynamic subtest vcs0: SUCCESS (1.445s)
[421.372652] Starting dynamic subtest: vcs1
[423.369002] Dynamic subtest vcs1: SUCCESS (2.006s)
[423.382038] Starting dynamic subtest: vecs0
[425.362042] Dynamic subtest vecs0: SUCCESS (1.990s)
[425.374413] Starting dynamic subtest: ccs0
[425.441689] Dynamic subtest ccs0: SUCCESS (0.079s)
[425.444154] Subtest engines-hostile-preempt: SUCCESS (5.698s)
[425.609446] [076/133] (601s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[425.718527] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[425.722870] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[425.847340] [077/133] (600s left) kms_chamelium_color (ctm-0-25)
[425.955759] Subtest ctm-0-25: SKIP (0.000s)
[426.001242] [078/133] (600s left) syncobj_timeline (invalid-signal-bad-pad)
[426.062680] Starting subtest: invalid-signal-bad-pad
[426.065085] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[426.198020] [079/133] (600s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[426.304753] Starting subtest: multiplane-rotation-cropping-top
[443.694123] Subtest multiplane-rotation-cropping-top: SUCCESS (17.393s)
[443.859334] [080/133] (583s left) kms_psr (psr2-dpms)
[443.973567] Starting subtest: psr2-dpms
[443.975508] Starting dynamic subtest: eDP-1
[446.865732] Dynamic subtest eDP-1: SUCCESS (2.892s)
[446.868048] Subtest psr2-dpms: SUCCESS (2.893s)
[447.758691] [081/133] (579s left) prime_mmap_coherency (write)
[447.826523] Starting subtest: write
[453.202579] Subtest write: SUCCESS (5.378s)
[453.411043] [082/133] (573s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[453.516363] Starting subtest: flip-vs-dpms-on-nop-interruptible
[453.518676] Starting dynamic subtest: A-eDP1
[455.338821] Dynamic subtest A-eDP1: SUCCESS (1.822s)
[455.353951] Starting dynamic subtest: B-eDP1
[457.157418] Dynamic subtest B-eDP1: SUCCESS (1.817s)
[457.172923] Starting dynamic subtest: C-eDP1
[458.969468] Dynamic subtest C-eDP1: SUCCESS (1.810s)
[458.981034] Starting dynamic subtest: D-eDP1
[460.794348] Dynamic subtest D-eDP1: SUCCESS (1.824s)
[460.796771] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.283s)
[461.989640] [083/133] (565s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[462.094434] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[462.096674] Starting dynamic subtest: pipe-A-eDP-1
[478.458075] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.397s)
[478.469191] Starting dynamic subtest: pipe-B-eDP-1
[497.724361] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.764s)
[497.734811] Starting dynamic subtest: pipe-C-eDP-1
[515.396017] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.387s)
[515.406874] Starting dynamic subtest: pipe-D-eDP-1
[532.375014] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.313s)
[532.377711] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (10.866s)
[533.549427] [084/133] (493s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[533.644790] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[533.647462] Starting dynamic subtest: pipe-A
[533.664719] Dynamic subtest pipe-A: SKIP (0.016s)
[533.675398] Starting dynamic subtest: pipe-B
[533.695757] Dynamic subtest pipe-B: SKIP (0.029s)
[533.705941] Starting dynamic subtest: pipe-C
[533.722927] Dynamic subtest pipe-C: SKIP (0.029s)
[533.732654] Starting dynamic subtest: pipe-D
[533.753645] Dynamic subtest pipe-D: SKIP (0.029s)
[533.758177] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.107s)
[533.864593] [085/133] (493s left) perf_pmu (init-busy)
[533.906753] Starting subtest: init-busy
[533.909229] Starting dynamic subtest: rcs0
[533.911601] Dynamic subtest rcs0: SUCCESS (0.001s)
[533.922489] Starting dynamic subtest: bcs0
[533.924871] Dynamic subtest bcs0: SUCCESS (0.001s)
[533.934652] Starting dynamic subtest: vcs0
[533.937211] Dynamic subtest vcs0: SUCCESS (0.001s)
[533.946727] Starting dynamic subtest: vcs1
[533.949447] Dynamic subtest vcs1: SUCCESS (0.001s)
[533.959358] Starting dynamic subtest: vecs0
[533.961891] Dynamic subtest vecs0: SUCCESS (0.001s)
[533.971947] Starting dynamic subtest: ccs0
[533.974257] Dynamic subtest ccs0: SUCCESS (0.000s)
[533.976462] Subtest init-busy: SUCCESS (0.008s)
[534.051103] [086/133] (493s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[534.155271] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[534.160516] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[534.281653] [087/133] (493s left) gem_flink_basic (bad-flink)
[534.347754] Starting subtest: bad-flink
[534.350565] Subtest bad-flink: SUCCESS (0.000s)
[534.452784] [088/133] (492s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[534.542720] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[543.826195] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.366s)
[543.956306] [089/133] (483s left) perf (gen12-mi-rpc)
[544.099692] Starting subtest: gen12-mi-rpc
[544.101935] Starting dynamic subtest: rcs0
[544.120797] Dynamic subtest rcs0: SUCCESS (0.020s)
[544.123000] Subtest gen12-mi-rpc: SUCCESS (0.021s)
[544.166132] [090/133] (483s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[544.264672] Starting subtest: psr2-cursor-plane-update-sf
[544.266995] Starting dynamic subtest: pipe-A-eDP-1
[544.820446] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.561s)
[544.830716] Starting dynamic subtest: pipe-B-eDP-1
[546.160505] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.346s)
[546.163120] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.911s)
[547.038002] [091/133] (480s left) i915_pm_rpm (gem-execbuf-stress)
[549.063401] Starting subtest: gem-execbuf-stress
[549.065827] Starting dynamic subtest: smem0
[561.990953] Dynamic subtest smem0: SUCCESS (12.949s)
[562.004872] Starting dynamic subtest: extra-wait-smem0
[624.092687] Dynamic subtest extra-wait-smem0: SUCCESS (62.108s)
[624.095750] Subtest gem-execbuf-stress: SUCCESS (75.064s)
[624.517910] [092/133] (403s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[624.645103] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[631.220782] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.577s)
[631.370104] [093/133] (396s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[631.430962] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[631.433896] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[631.529378] [094/133] (396s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[631.594660] Subtest tiled-to-untiled: SKIP (0.000s)
[631.674711] [095/133] (395s left) gem_exercise_blt (fast-copy-emit)
[631.731705] Starting subtest: fast-copy-emit
[631.734508] Starting dynamic subtest: linear-smem-smem-emit
[631.760192] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.027s)
[631.770859] Starting dynamic subtest: xmajor-smem-smem-emit
[631.778163] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.017s)
[631.788824] Starting dynamic subtest: tile4-smem-smem-emit
[631.798098] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.019s)
[631.808119] Starting dynamic subtest: tile64-smem-smem-emit
[631.815355] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.016s)
[631.818062] Subtest fast-copy-emit: SUCCESS (0.083s)
[631.951233] [096/133] (395s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[632.013906] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[632.116560] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.103s)
[632.210030] [097/133] (395s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[632.307836] Starting subtest: y-tiled-8bpp-rotate-180
[632.313361] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[632.432787] [098/133] (395s left) gem_ringfill (engines-basic)
[637.934146] Starting subtest: engines-basic
[637.936990] Starting dynamic subtest: rcs0
[638.020459] Dynamic subtest rcs0: SUCCESS (0.087s)
[638.033281] Starting dynamic subtest: bcs0
[638.067742] Dynamic subtest bcs0: SUCCESS (0.045s)
[638.078983] Starting dynamic subtest: vcs0
[638.111393] Dynamic subtest vcs0: SUCCESS (0.041s)
[638.122363] Starting dynamic subtest: vcs1
[638.155373] Dynamic subtest vcs1: SUCCESS (0.042s)
[638.166579] Starting dynamic subtest: vecs0
[638.198328] Dynamic subtest vecs0: SUCCESS (0.041s)
[638.209127] Starting dynamic subtest: ccs0
[638.244993] Dynamic subtest ccs0: SUCCESS (0.045s)
[638.247971] Subtest engines-basic: SUCCESS (0.313s)
[638.337263] [099/133] (389s left) gem_exec_big (single)
[638.397878] Starting subtest: single
[640.677525] Subtest single: SUCCESS (2.279s)
[640.911215] [100/133] (386s left) gem_softpin (allocator-fork)
[641.022497] Starting subtest: allocator-fork
[643.243774] Subtest allocator-fork: SUCCESS (2.222s)
[643.419154] [101/133] (384s left) perf (create-destroy-userspace-config)
[643.543944] Starting subtest: create-destroy-userspace-config
[643.565818] Subtest create-destroy-userspace-config: SUCCESS (0.020s)
[643.616454] [102/133] (384s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[643.730701] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[643.733134] Starting dynamic subtest: pipe-A-eDP-1
[643.800439] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[643.811947] Starting dynamic subtest: pipe-B-eDP-1
[643.880993] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[643.892252] Starting dynamic subtest: pipe-C-eDP-1
[643.958725] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[643.969751] Starting dynamic subtest: pipe-D-eDP-1
[644.035865] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[644.041525] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[646.063804] [103/133] (381s left) gem_mmap_gtt (basic-write-gtt)
[646.126998] Subtest basic-write-gtt: SKIP (0.000s)
[646.191213] [104/133] (381s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[646.297973] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[646.302901] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[646.424179] [105/133] (381s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[646.531840] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[655.131838] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.601s)
[655.255219] [106/133] (372s left) kms_atomic (plane-primary-legacy)
[655.355548] Starting subtest: plane-primary-legacy
[655.358052] Starting dynamic subtest: pipe-A-eDP-1
[655.845175] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.489s)
[655.847680] Subtest plane-primary-legacy: SUCCESS (0.491s)
[656.676940] [107/133] (371s left) kms_chamelium_hpd (hdmi-hpd-storm)
[657.058588] Subtest hdmi-hpd-storm: SKIP (0.000s)
[657.874254] [108/133] (370s left) gem_pxp (reject-modify-context-protection-off-1)
[658.003477] Starting subtest: reject-modify-context-protection-off-1
[658.006606] Subtest reject-modify-context-protection-off-1: SUCCESS (0.001s)
[658.143836] [109/133] (370s left) sriov_basic (enable-vfs-bind-unbind-each)
[658.206328] Starting subtest: enable-vfs-bind-unbind-each
[658.208852] Starting dynamic subtest: numvfs-1
[658.291744] Dynamic subtest numvfs-1: FAIL (0.030s)
[658.302096] Starting dynamic subtest: numvfs-2
[658.386437] Dynamic subtest numvfs-2: FAIL (0.004s)
[658.398178] Starting dynamic subtest: numvfs-3
[658.483089] Dynamic subtest numvfs-3: FAIL (0.004s)
[658.493600] Starting dynamic subtest: numvfs-4
[658.578571] Dynamic subtest numvfs-4: FAIL (0.006s)
[658.589988] Starting dynamic subtest: numvfs-5
[658.675598] Dynamic subtest numvfs-5: FAIL (0.004s)
[658.686534] Starting dynamic subtest: numvfs-6
[658.771355] Dynamic subtest numvfs-6: FAIL (0.004s)
[658.781958] Starting dynamic subtest: numvfs-7
[658.861252] Dynamic subtest numvfs-7: FAIL (0.004s)
[658.872093] Starting dynamic subtest: numvfs-random
[658.943682] Dynamic subtest numvfs-random: FAIL (0.004s)
[658.945901] Subtest enable-vfs-bind-unbind-each: FAIL (0.065s)
[658.987301] [110/133] (369s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[659.057213] Starting subtest: y-tiled-ccs-to-x-tiled
[659.061077] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[659.254586] [111/133] (369s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[659.314504] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[659.317029] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[659.442258] [112/133] (368s left) gem_exec_parallel (basic)
[659.501475] Starting subtest: basic
[659.503811] Starting dynamic subtest: rcs0
[661.258848] Dynamic subtest rcs0: SUCCESS (1.757s)
[661.270001] Starting dynamic subtest: bcs0
[663.059907] Dynamic subtest bcs0: SUCCESS (1.799s)
[663.071990] Starting dynamic subtest: vcs0
[664.937746] Dynamic subtest vcs0: SUCCESS (1.876s)
[664.948778] Starting dynamic subtest: vcs1
[666.858467] Dynamic subtest vcs1: SUCCESS (1.919s)
[666.872711] Starting dynamic subtest: vecs0
[668.842201] Dynamic subtest vecs0: SUCCESS (1.981s)
[668.856015] Starting dynamic subtest: ccs0
[670.643695] Dynamic subtest ccs0: SUCCESS (1.799s)
[670.646308] Subtest basic: SUCCESS (11.142s)
[670.844244] [113/133] (357s left) gen9_exec_parse (allowed-single)
[670.910241] Subtest allowed-single: SKIP (0.000s)
[670.986425] [114/133] (357s left) kms_frontbuffer_tracking (fbc-tiling-4)
[671.087953] Starting subtest: fbc-tiling-4
[675.340547] Subtest fbc-tiling-4: SUCCESS (4.257s)
[676.538600] [115/133] (352s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[676.650123] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[680.962181] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.318s)
[682.177232] [116/133] (346s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[682.282341] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[682.286990] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[682.350167] [117/133] (346s left) kms_invalid_mode (zero-clock)
[682.438197] Starting subtest: zero-clock
[682.440348] Starting dynamic subtest: pipe-A-eDP-1
[682.726747] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[682.737785] Starting dynamic subtest: pipe-B-eDP-1
[682.740344] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[682.750846] Starting dynamic subtest: pipe-C-eDP-1
[682.753643] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[682.764806] Starting dynamic subtest: pipe-D-eDP-1
[682.767277] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[682.769700] Subtest zero-clock: SUCCESS (0.294s)
[683.602689] [118/133] (345s left) sw_sync (sync_merge_same)
[683.641624] Starting subtest: sync_merge_same
[683.644509] Subtest sync_merge_same: SUCCESS (0.000s)
[683.722447] [119/133] (345s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[683.850723] Starting subtest: basic-busy-flip-before-cursor-legacy
[683.855358] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[684.006292] [120/133] (344s left) kms_vblank (invalid)
[684.104469] Starting subtest: invalid
[684.106637] Starting dynamic subtest: pipe-A-eDP-1
[684.505262] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.401s)
[684.507870] Subtest invalid: SUCCESS (0.403s)
[685.329668] [121/133] (343s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[685.718906] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[686.523840] [122/133] (342s left) kms_dp_linktrain_fallback (dsc-fallback)
[686.633117] Starting subtest: dsc-fallback
[686.640476] Subtest dsc-fallback: SKIP (0.000s)
[686.717605] [123/133] (342s left) gem_exec_whisper (basic-fds-forked-all)
[686.786145] Starting subtest: basic-fds-forked-all
[708.990879] Subtest basic-fds-forked-all: SUCCESS (22.205s)
[709.192339] [124/133] (319s left) kms_cursor_edge_walk (64x64-top-edge)
[709.287745] Starting subtest: 64x64-top-edge
[709.290552] Starting dynamic subtest: pipe-A-eDP-1
[712.714469] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.426s)
[712.729612] Starting dynamic subtest: pipe-D-eDP-1
[715.839622] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.127s)
[715.842221] Subtest 64x64-top-edge: SUCCESS (6.556s)
[716.662183] [125/133] (312s left) gem_readwrite (new-obj)
[716.725754] Subtest new-obj: SKIP (0.000s)
[716.796946] [126/133] (312s left) api_intel_bb (bb-with-allocator)
[716.859266] Starting subtest: bb-with-allocator
[716.863164] Subtest bb-with-allocator: SUCCESS (0.007s)
[716.975361] [127/133] (312s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[717.072700] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[717.077506] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[717.198272] [128/133] (311s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[717.306085] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[721.353829] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (4.053s)
[722.575573] [129/133] (306s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[722.677733] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[729.953890] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.282s)
[730.080626] [130/133] (299s left) kms_color_pipeline (plane-ctm3x4)
[730.193021] Starting subtest: plane-ctm3x4
[730.205897] Starting dynamic subtest: pipe-A-eDP-1
[730.948943] Dynamic subtest pipe-A-eDP-1: FAIL (0.283s)
[731.542801] Starting dynamic subtest: pipe-B-eDP-1
[732.439709] Dynamic subtest pipe-B-eDP-1: FAIL (0.291s)
[732.885132] Starting dynamic subtest: pipe-C-eDP-1
[733.805841] Dynamic subtest pipe-C-eDP-1: FAIL (0.246s)
[734.216048] Starting dynamic subtest: pipe-D-eDP-1
[735.151728] Dynamic subtest pipe-D-eDP-1: FAIL (0.236s)
[735.154590] Subtest plane-ctm3x4: FAIL (4.547s)
[735.602305] [131/133] (293s left) kms_fbcon_fbt (psr)
[735.659774] Starting subtest: psr
[743.014912] Subtest psr: SUCCESS (7.354s)
[743.093693] [132/133] (286s left) gem_ctx_persistence (legacy-engines-hostile)
[743.161742] Starting subtest: legacy-engines-hostile
[743.164827] Starting dynamic subtest: render
[743.320094] Dynamic subtest render: SUCCESS (0.158s)
[743.333971] Starting dynamic subtest: bsd1
[743.439072] Dynamic subtest bsd1: SUCCESS (0.116s)
[743.453904] Starting dynamic subtest: bsd2
[743.563348] Dynamic subtest bsd2: SUCCESS (0.120s)
[743.582758] Starting dynamic subtest: blt
[743.665343] Dynamic subtest blt: SUCCESS (0.099s)
[743.678109] Starting dynamic subtest: vebox
[743.781487] Dynamic subtest vebox: SUCCESS (0.113s)
[743.784470] Subtest legacy-engines-hostile: SUCCESS (0.621s)
[743.876354] [133/133] (285s left) kms_cursor_crc (cursor-sliding-128x42)
[744.091477] Starting subtest: cursor-sliding-128x42
[744.137534] Subtest cursor-sliding-128x42: SKIP (0.041s)
[744.369155] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_reloc
results: parsing output: 1/ for test: gem_busy
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_vrr
results: parsing output: 4/ for test: gem_exec_alignment
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_pipe_crc_basic
results: parsing output: 8/ for test: kms_addfb_basic
results: parsing output: 9/ for test: gem_mmap_offset
results: parsing output: 10/ for test: gem_exec_flush
results: parsing output: 11/ for test: gem_exec_params
results: parsing output: 12/ for test: i915_pm_rps
results: parsing output: 13/ for test: syncobj_basic
results: parsing output: 14/ for test: kms_flip
results: parsing output: 15/ for test: kms_plane
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_cursor_legacy
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: i915_drm_fdinfo
results: parsing output: 20/ for test: kms_lease
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: core_setmaster
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: kms_draw_crc
results: parsing output: 30/ for test: kms_cursor_legacy
results: parsing output: 31/ for test: kms_flip_scaled_crc
results: parsing output: 32/ for test: gem_exec_balancer
results: parsing output: 33/ for test: gem_exec_schedule
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: sw_sync
results: parsing output: 36/ for test: gem_exec_flush
results: parsing output: 37/ for test: gem_exec_schedule
results: parsing output: 38/ for test: gem_mmap_wc
results: parsing output: 39/ for test: gem_media_vme
results: parsing output: 40/ for test: kms_addfb_basic
results: parsing output: 41/ for test: sw_sync
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_ctx_param
results: parsing output: 44/ for test: kms_cursor_crc
results: parsing output: 45/ for test: api_intel_bb
results: parsing output: 46/ for test: kms_plane_multiple
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: vgem_basic
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_plane_scaling
results: parsing output: 51/ for test: kms_pm_rpm
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: kms_pm_rpm
results: parsing output: 54/ for test: gem_cs_tlb
results: parsing output: 55/ for test: sw_sync
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: gem_softpin
results: parsing output: 59/ for test: gem_exec_fence
results: parsing output: 60/ for test: kms_content_protection
results: parsing output: 61/ for test: kms_psr2_sf
results: parsing output: 62/ for test: drm_read
results: parsing output: 63/ for test: kms_cursor_legacy
results: parsing output: 64/ for test: gem_ccs
results: parsing output: 65/ for test: i915_hangman
results: parsing output: 66/ for test: gem_exec_suspend
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: gem_userptr_blits
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_userptr_blits
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_addfb_basic
results: parsing output: 74/ for test: gem_ctx_persistence
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_chamelium_color
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_rotation_crc
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: prime_mmap_coherency
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: kms_plane_scaling
results: parsing output: 84/ for test: perf_pmu
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_flink_basic
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: perf
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: i915_pm_rpm
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: syncobj_wait
results: parsing output: 93/ for test: gem_set_tiling_vs_blt
results: parsing output: 94/ for test: gem_exercise_blt
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: gem_ringfill
results: parsing output: 98/ for test: gem_exec_big
results: parsing output: 99/ for test: gem_softpin
results: parsing output: 100/ for test: perf
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: gem_mmap_gtt
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_atomic
results: parsing output: 106/ for test: kms_chamelium_hpd
results: parsing output: 107/ for test: gem_pxp
results: parsing output: 108/ for test: sriov_basic
results: parsing output: 109/ for test: gem_render_copy
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: gem_exec_parallel
results: parsing output: 112/ for test: gen9_exec_parse
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_psr2_sf
results: parsing output: 116/ for test: kms_invalid_mode
results: parsing output: 117/ for test: sw_sync
results: parsing output: 118/ for test: kms_cursor_legacy
results: parsing output: 119/ for test: kms_vblank
results: parsing output: 120/ for test: kms_chamelium_edid
results: parsing output: 121/ for test: kms_dp_linktrain_fallback
results: parsing output: 122/ for test: gem_exec_whisper
results: parsing output: 123/ for test: kms_cursor_edge_walk
results: parsing output: 124/ for test: gem_readwrite
results: parsing output: 125/ for test: api_intel_bb
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_color_pipeline
results: parsing output: 130/ for test: kms_fbcon_fbt
results: parsing output: 131/ for test: gem_ctx_persistence
results: parsing output: 132/ for test: kms_cursor_crc
Done.