[58.060033] Initializing watchdogs
[58.060079]   /dev/watchdog0
[58.072946] [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]
[58.077320] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.079457] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.082852] [001/131] (960s left) kms_chamelium_color (degamma)
[58.281256] Subtest degamma: SKIP (0.000s)
[58.318649] [002/131] (960s left) kms_lease (possible-crtcs-filtering)
[58.418027] Starting subtest: possible-crtcs-filtering
[58.423379] Subtest possible-crtcs-filtering: SUCCESS (0.005s)
[58.510242] [003/131] (960s left) kms_cursor_crc (cursor-sliding-256x85)
[58.737668] Starting subtest: cursor-sliding-256x85
[58.781216] Subtest cursor-sliding-256x85: SKIP (0.040s)
[58.936947] [004/131] (959s left) gem_exec_reloc (basic-wc-gtt-active)
[59.000917] Subtest basic-wc-gtt-active: SKIP (0.000s)
[59.053067] [005/131] (959s left) kms_psr (pr-cursor-mmap-gtt)
[59.162280] Starting subtest: pr-cursor-mmap-gtt
[59.166442] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[59.231203] [006/131] (959s left) kms_prop_blob (invalid-set-prop)
[59.283336] Starting subtest: invalid-set-prop
[59.285489] Subtest invalid-set-prop: SUCCESS (0.000s)
[59.376395] [007/131] (959s left) kms_psr (psr-no-drrs)
[59.475716] Starting subtest: psr-no-drrs
[59.477762] Starting dynamic subtest: eDP-1
[61.072178] Dynamic subtest eDP-1: SUCCESS (1.654s)
[61.073930] Subtest psr-no-drrs: SUCCESS (1.654s)
[61.885688] [008/131] (956s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[61.991861] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[61.996071] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[62.082763] [009/131] (956s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[62.145232] Starting subtest: single-wait-for-submit-available-signaled
[62.147175] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[62.241223] [010/131] (956s left) vgem_basic (bad-handle)
[62.299768] Starting subtest: bad-handle
[62.301685] Subtest bad-handle: SUCCESS (0.000s)
[62.343957] [FACT vgem_basic (bad-handle)] new: kernel.kmod_is_loaded.vgem: true
[62.346896] [011/131] (956s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[62.444020] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[62.446390] Starting dynamic subtest: pipe-A-default-mode
[65.094881] Dynamic subtest pipe-A-default-mode: SUCCESS (2.732s)
[65.097322] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.733s)
[65.942311] [012/131] (952s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[66.044846] Starting subtest: x-tiled-16bpp-rotate-270
[66.063110] Subtest x-tiled-16bpp-rotate-270: SKIP (0.018s)
[66.166656] [013/131] (952s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[66.271511] Starting subtest: psr-2p-primscrn-cur-indfb-move
[66.275639] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[66.347713] [014/131] (952s left) i915_pm_rps (thresholds-idle-park)
[66.404910] Starting subtest: thresholds-idle-park
[66.410068] Subtest thresholds-idle-park: SKIP (0.000s)
[66.474105] [015/131] (952s left) syncobj_timeline (invalid-transfer-bad-pad)
[66.526804] Starting subtest: invalid-transfer-bad-pad
[66.529140] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[66.634584] [016/131] (952s left) gem_ctx_persistence (heartbeat-many)
[66.694841] Starting subtest: heartbeat-many
[66.699576] Subtest heartbeat-many: SKIP (0.000s)
[66.798046] [017/131] (952s left) gem_spin_batch (user-each)
[66.863392] Starting subtest: user-each
[70.131444] Subtest user-each: SUCCESS (3.312s)
[71.080870] [018/131] (947s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[71.251858] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[71.256312] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[71.513843] [019/131] (947s left) kms_flip (2x-absolute-wf_vblank)
[71.638290] Starting subtest: 2x-absolute-wf_vblank
[71.649865] Subtest 2x-absolute-wf_vblank: SKIP (0.011s)
[71.767586] [020/131] (947s left) gem_userptr_blits (dmabuf-sync)
[71.865486] Starting subtest: dmabuf-sync
[71.870731] Subtest dmabuf-sync: SKIP (0.002s)
[72.042353] [021/131] (946s left) gem_exec_whisper (basic-fds-priority-all)
[72.131479] Starting subtest: basic-fds-priority-all
[92.670111] Subtest basic-fds-priority-all: SUCCESS (20.606s)
[92.851766] [022/131] (926s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[92.961649] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[92.966260] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[93.069708] [023/131] (925s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[98.122887] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[98.127322] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.002s)
[98.973012] [024/131] (920s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[99.076507] Starting subtest: 4-tiled-8bpp-rotate-90
[99.098144] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.021s)
[99.191672] [025/131] (919s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[99.304676] Starting subtest: psr-rgb101010-draw-mmap-wc
[104.155392] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (4.854s)
[104.261375] [026/131] (914s left) gem_mmap_gtt (hang-busy)
[104.330417] Subtest hang-busy: SKIP (0.000s)
[104.387766] [027/131] (914s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[104.495064] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[109.524825] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (5.032s)
[109.656631] [028/131] (909s left) drm_fdinfo (virtual-busy-idle)
[109.699835] Starting subtest: virtual-busy-idle
[109.704049] Subtest virtual-busy-idle: SKIP (0.000s)
[109.764858] [029/131] (909s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[109.865769] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[109.868091] Starting dynamic subtest: A-eDP1
[118.820540] Dynamic subtest A-eDP1: SUCCESS (8.952s)
[118.828784] Starting dynamic subtest: B-eDP1
[127.751860] Dynamic subtest B-eDP1: SUCCESS (8.929s)
[127.764514] Starting dynamic subtest: C-eDP1
[136.663156] Dynamic subtest C-eDP1: SUCCESS (8.910s)
[136.670619] Starting dynamic subtest: D-eDP1
[145.585902] Dynamic subtest D-eDP1: SUCCESS (8.921s)
[145.588413] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.719s)
[146.804068] [030/131] (872s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[146.922396] Starting subtest: basic-flip-before-cursor-atomic
[147.838091] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.916s)
[148.627576] [031/131] (870s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[148.679232] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[148.778613] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.100s)
[148.846324] [032/131] (870s left) kms_rotation_crc (sprite-rotation-90)
[148.946041] Starting subtest: sprite-rotation-90
[148.950629] Subtest sprite-rotation-90: SKIP (0.001s)
[149.014318] [033/131] (870s left) gem_mmap_offset (partial-unmap)
[149.075750] Starting subtest: partial-unmap
[149.078444] Starting dynamic subtest: smem0
[149.586537] Dynamic subtest smem0: SUCCESS (0.512s)
[149.589222] Subtest partial-unmap: SUCCESS (0.512s)
[149.723704] [034/131] (869s left) kms_content_protection (legacy)
[149.906822] Starting subtest: legacy
[153.737255] Subtest legacy: SKIP (3.827s)
[154.935929] [035/131] (864s left) gen9_exec_parse (allowed-single)
[155.009873] Subtest allowed-single: SKIP (0.000s)
[155.072669] [036/131] (864s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[155.176650] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[155.181267] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[155.251262] [037/131] (864s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[155.362448] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[155.366587] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[155.445389] [038/131] (864s left) gem_exec_balancer (parallel-keep-in-fence)
[155.692427] Starting subtest: parallel-keep-in-fence
[156.754745] Subtest parallel-keep-in-fence: SUCCESS (1.062s)
[156.856685] [039/131] (862s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[156.963168] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[156.967070] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[157.066589] [040/131] (862s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[157.127098] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[157.193414] [041/131] (862s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[157.292520] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[157.296864] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[157.402102] [042/131] (862s left) gem_mmap_gtt (fault-concurrent)
[157.457872] Subtest fault-concurrent: SKIP (0.000s)
[157.523275] [043/131] (862s left) gem_userptr_blits (stress-mm)
[157.597690] Starting subtest: stress-mm
[162.967374] Subtest stress-mm: SUCCESS (5.369s)
[163.104137] [044/131] (856s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[163.203893] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[163.206232] Starting dynamic subtest: pipe-A-eDP-1
[163.351415] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.147s)
[163.360421] Starting dynamic subtest: pipe-B-eDP-1
[163.502982] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.151s)
[163.511882] Starting dynamic subtest: pipe-C-eDP-1
[163.654463] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.151s)
[163.663345] Starting dynamic subtest: pipe-D-eDP-1
[163.803949] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.149s)
[163.806383] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.600s)
[165.976102] [045/131] (853s left) gem_pxp (create-valid-protected-context)
[166.111897] Starting subtest: create-valid-protected-context
[166.114729] Subtest create-valid-protected-context: SUCCESS (0.002s)
[166.211991] [046/131] (853s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[166.326843] Starting subtest: extended-modeset-hang-newfb-with-reset
[166.329054] Starting dynamic subtest: pipe-A
[181.922635] Dynamic subtest pipe-A: SUCCESS (15.594s)
[181.931963] Starting dynamic subtest: pipe-D
[197.784282] Dynamic subtest pipe-D: SUCCESS (15.859s)
[197.786746] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (31.456s)
[198.581680] [047/131] (821s left) syncobj_timeline (invalid-query-one-illegal-handle)
[198.635403] Starting subtest: invalid-query-one-illegal-handle
[198.637336] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[198.717297] [048/131] (821s left) gem_exec_schedule (semaphore-power)
[198.895497] Subtest semaphore-power: SKIP (0.000s)
[199.070211] [049/131] (820s left) kms_vblank (wait-busy-hang)
[199.163955] Starting subtest: wait-busy-hang
[199.166255] Starting dynamic subtest: pipe-A-eDP-1
[225.702631] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.535s)
[225.716191] Starting dynamic subtest: pipe-D-eDP-1
[250.657791] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.952s)
[250.659787] Subtest wait-busy-hang: SUCCESS (51.491s)
[251.523656] [050/131] (768s left) gem_exec_fence (submit-chain)
[251.713382] Starting subtest: submit-chain
[251.733338] Subtest submit-chain: SUCCESS (0.020s)
[254.033301] [051/131] (765s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-wc)
[254.135706] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-wc
[257.157371] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (3.026s)
[257.301669] [052/131] (762s left) gem_ctx_shared (exec-single-timeline)
[257.370573] Starting subtest: exec-single-timeline
[257.372918] Starting dynamic subtest: rcs0
[258.444458] Dynamic subtest rcs0: SUCCESS (1.071s)
[258.456101] Starting dynamic subtest: bcs0
[259.532546] Dynamic subtest bcs0: SUCCESS (1.086s)
[259.542767] Starting dynamic subtest: vcs0
[260.621284] Dynamic subtest vcs0: SUCCESS (1.086s)
[260.632843] Starting dynamic subtest: vcs1
[261.709202] Dynamic subtest vcs1: SUCCESS (1.086s)
[261.720716] Starting dynamic subtest: vecs0
[262.797424] Dynamic subtest vecs0: SUCCESS (1.086s)
[262.808254] Starting dynamic subtest: ccs0
[263.885528] Dynamic subtest ccs0: SUCCESS (1.086s)
[263.888346] Subtest exec-single-timeline: SUCCESS (6.514s)
[264.070342] [053/131] (755s left) gem_lmem_swapping (smem-oom)
[264.115337] Subtest smem-oom: SKIP (0.000s)
[264.153415] [054/131] (755s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[264.255106] Starting subtest: drrs-dirtyfb-ioctl
[264.268215] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[264.345366] [055/131] (755s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[264.452574] Starting subtest: fbcpsr-suspend
[302.582680] Subtest fbcpsr-suspend: SUCCESS (7.704s)
[302.698035] [056/131] (747s left) api_intel_bb (object-noreloc-purge-cache-simple)
[302.752555] Starting subtest: object-noreloc-purge-cache-simple
[302.754788] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.006s)
[302.872375] [057/131] (747s left) gem_exec_balancer (bonded-sync)
[302.929826] Starting subtest: bonded-sync
[302.934416] Subtest bonded-sync: SKIP (0.000s)
[303.206121] [058/131] (747s left) sw_sync (sync_multi_consumer_producer)
[303.242115] Starting subtest: sync_multi_consumer_producer
[303.589275] Subtest sync_multi_consumer_producer: SUCCESS (0.359s)
[303.643041] [059/131] (747s left) dmabuf_sync_file (import-multiple-read-write)
[303.689630] Starting subtest: import-multiple-read-write
[303.691932] Subtest import-multiple-read-write: SUCCESS (0.003s)
[303.740567] [060/131] (746s left) drm_read (fault-buffer)
[303.908773] Starting subtest: fault-buffer
[303.910851] Subtest fault-buffer: SUCCESS (0.000s)
[304.039855] [061/131] (746s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[304.151369] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[307.382111] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (3.313s)
[307.510954] [062/131] (743s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[307.609867] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[307.613081] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[307.711420] [063/131] (742s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[307.810921] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[307.812841] Starting dynamic subtest: pipe-A-eDP-1
[307.831269] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[307.842205] Starting dynamic subtest: pipe-B-eDP-1
[307.858996] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[307.867109] Starting dynamic subtest: pipe-C-eDP-1
[307.885079] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[307.894438] Starting dynamic subtest: pipe-D-eDP-1
[307.912628] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[307.916328] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[309.905992] [064/131] (740s left) gem_ringfill (basic-all)
[315.482780] Starting subtest: basic-all
[316.623448] Subtest basic-all: SUCCESS (1.147s)
[316.766821] [065/131] (733s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[316.894919] Starting subtest: flip-vs-cursor-crc-legacy
[317.506176] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.616s)
[318.355388] [066/131] (732s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[318.459570] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[318.463511] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[318.566320] [067/131] (732s left) perf_pmu (busy-idle)
[318.608175] Starting subtest: busy-idle
[318.610467] Starting dynamic subtest: rcs0
[319.317041] Dynamic subtest rcs0: SUCCESS (0.713s)
[319.327792] Starting dynamic subtest: bcs0
[319.983926] Dynamic subtest bcs0: SUCCESS (0.668s)
[319.995167] Starting dynamic subtest: vcs0
[321.496307] Dynamic subtest vcs0: SUCCESS (1.514s)
[321.507969] Starting dynamic subtest: vcs1
[323.481887] Dynamic subtest vcs1: SUCCESS (1.989s)
[323.491570] Starting dynamic subtest: vecs0
[325.530331] Dynamic subtest vecs0: SUCCESS (2.051s)
[325.541278] Starting dynamic subtest: ccs0
[326.199746] Dynamic subtest ccs0: SUCCESS (0.671s)
[326.202340] Subtest busy-idle: SUCCESS (7.618s)
[326.324016] [068/131] (724s left) kms_joiner (basic-force-big-joiner)
[326.446130] Starting subtest: basic-force-big-joiner
[326.448525] Starting dynamic subtest: single
[329.756013] Dynamic subtest single: SUCCESS (3.323s)
[329.758308] Subtest basic-force-big-joiner: SUCCESS (3.324s)
[330.935281] [069/131] (719s left) kms_draw_crc (draw-method-render)
[331.035577] Starting subtest: draw-method-render
[331.037826] Starting dynamic subtest: xrgb8888-untiled
[331.296324] Dynamic subtest xrgb8888-untiled: SUCCESS (0.262s)
[331.306171] Starting dynamic subtest: rgb565-untiled
[331.508061] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[331.524523] Starting dynamic subtest: xrgb2101010-untiled
[331.730645] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[331.740704] Starting dynamic subtest: xbgr16161616f-untiled
[331.985923] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.255s)
[331.998449] Starting dynamic subtest: xrgb8888-xtiled
[332.108601] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[332.117703] Starting dynamic subtest: rgb565-xtiled
[332.220285] Dynamic subtest rgb565-xtiled: SUCCESS (0.111s)
[332.229298] Starting dynamic subtest: xrgb2101010-xtiled
[332.353724] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.133s)
[332.362857] Starting dynamic subtest: xbgr16161616f-xtiled
[332.509698] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.155s)
[332.521756] Starting dynamic subtest: xrgb8888-4tiled
[332.654304] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[332.665876] Starting dynamic subtest: rgb565-4tiled
[332.765435] Dynamic subtest rgb565-4tiled: SUCCESS (0.111s)
[332.774971] Starting dynamic subtest: xrgb2101010-4tiled
[332.877097] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.111s)
[332.888285] Starting dynamic subtest: xbgr16161616f-4tiled
[333.044020] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.165s)
[333.046019] Subtest draw-method-render: SUCCESS (2.007s)
[333.180826] [070/131] (717s left) gem_pxp (verify-pxp-stale-buf-execution)
[333.286859] Starting subtest: verify-pxp-stale-buf-execution
[334.350193] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.062s)
[334.482457] [071/131] (716s left) kms_addfb_basic (unused-handle)
[334.542970] Starting subtest: unused-handle
[334.545330] Subtest unused-handle: SUCCESS (0.000s)
[334.685226] [072/131] (716s left) kms_async_flips (invalid-async-flip-atomic)
[334.791572] Starting subtest: invalid-async-flip-atomic
[334.795648] Subtest invalid-async-flip-atomic: SKIP (0.000s)
[335.968168] [073/131] (714s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[336.031175] Starting subtest: single-wait-for-submit-unsubmitted
[336.133920] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[336.205659] [074/131] (714s left) gem_userptr_blits (coherency-sync)
[336.276826] Starting subtest: coherency-sync
[336.635047] Subtest coherency-sync: SKIP (0.320s)
[336.751529] [075/131] (714s left) vgem_basic (dmabuf-fence)
[336.852023] Starting subtest: dmabuf-fence
[336.854398] Subtest dmabuf-fence: SUCCESS (0.000s)
[336.903992] [076/131] (714s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[337.020527] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[338.078411] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.057s)
[338.241651] [077/131] (712s left) i915_hangman (gt-engine-error)
[338.307206] Starting subtest: gt-engine-error
[338.309484] Starting dynamic subtest: rcs0
[339.447497] Dynamic subtest rcs0: SUCCESS (1.139s)
[339.459856] Starting dynamic subtest: bcs0
[341.495207] Dynamic subtest bcs0: SUCCESS (2.043s)
[341.508328] Starting dynamic subtest: vcs0
[343.479749] Dynamic subtest vcs0: SUCCESS (1.980s)
[343.492135] Starting dynamic subtest: vcs1
[345.463963] Dynamic subtest vcs1: SUCCESS (1.981s)
[345.480767] Starting dynamic subtest: vecs0
[347.447821] Dynamic subtest vecs0: SUCCESS (1.979s)
[347.460469] Starting dynamic subtest: ccs0
[349.494555] Dynamic subtest ccs0: SUCCESS (2.043s)
[349.497417] Subtest gt-engine-error: SUCCESS (11.178s)
[349.622721] [078/131] (701s left) kms_addfb_basic (size-max)
[349.730664] Starting subtest: size-max
[349.733092] Subtest size-max: SUCCESS (0.000s)
[349.827482] [079/131] (701s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[349.934202] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[349.938370] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[350.026442] [080/131] (701s left) kms_pm_dc (dc5-psr)
[351.146289] Starting subtest: dc5-psr
[354.030547] Subtest dc5-psr: SUCCESS (2.882s)
[354.902996] [081/131] (696s left) kms_fbcon_fbt (psr)
[354.957376] Starting subtest: psr
[360.341584] Subtest psr: SUCCESS (5.382s)
[360.398895] [082/131] (690s left) kms_selftest (drm_plane_helper)
[360.448305] Starting subtest: drm_plane_helper
[360.463644] Starting dynamic subtest: drm_test_check_plane_state
[360.619673] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.156s)
[360.629335] Starting dynamic subtest: drm_test_check_invalid_plane_state
[360.740259] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.121s)
[360.742457] Subtest drm_plane_helper: SUCCESS (0.292s)
[360.880305] [083/131] (690s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[360.999933] Starting subtest: cursorA-vs-flipB-varying-size
[361.003999] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[361.131244] [084/131] (690s left) gem_mmap_gtt (basic-write)
[361.193826] Subtest basic-write: SKIP (0.000s)
[361.250555] [085/131] (690s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[361.642453] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[362.464874] [086/131] (688s left) i915_selftest (perf)
[366.076881] Starting subtest: perf
[366.080055] Starting dynamic subtest: engine_cs
[370.581983] Dynamic subtest engine_cs: SUCCESS (4.504s)
[370.590799] Starting dynamic subtest: request
[377.913985] Dynamic subtest request: SUCCESS (7.331s)
[377.923564] Starting dynamic subtest: migrate
[382.303309] Dynamic subtest migrate: SUCCESS (4.388s)
[382.312808] Starting dynamic subtest: region
[386.782982] Dynamic subtest region: SUCCESS (4.479s)
[386.785506] Subtest perf: SUCCESS (20.708s)
[386.809787] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[386.810601] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[386.813792] [087/131] (664s left) gem_mmap_gtt (big-copy-odd)
[388.182910] Subtest big-copy-odd: SKIP (0.000s)
[388.238644] [FACT gem_mmap_gtt (big-copy-odd)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[388.240712] [FACT gem_mmap_gtt (big-copy-odd)] new: kernel.kmod_is_loaded.i915: true
[388.244533] [088/131] (663s left) syncobj_basic (bad-flags-handle-to-fd)
[388.299124] Starting subtest: bad-flags-handle-to-fd
[388.301346] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[388.404903] [089/131] (663s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[388.474215] Starting subtest: single-wait-all-for-submit-available-submitted
[388.476265] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[388.568048] [090/131] (662s left) kms_chamelium_color (ctm-0-50)
[388.672548] Subtest ctm-0-50: SKIP (0.000s)
[388.712691] [091/131] (662s left) perf_pmu (init-busy)
[388.759455] Starting subtest: init-busy
[388.761599] Starting dynamic subtest: rcs0
[388.763494] Dynamic subtest rcs0: SUCCESS (0.004s)
[388.772313] Starting dynamic subtest: bcs0
[388.774468] Dynamic subtest bcs0: SUCCESS (0.000s)
[388.781983] Starting dynamic subtest: vcs0
[388.783849] Dynamic subtest vcs0: SUCCESS (0.001s)
[388.791450] Starting dynamic subtest: vcs1
[388.793319] Dynamic subtest vcs1: SUCCESS (0.001s)
[388.800820] Starting dynamic subtest: vecs0
[388.802733] Dynamic subtest vecs0: SUCCESS (0.001s)
[388.810253] Starting dynamic subtest: ccs0
[388.812147] Dynamic subtest ccs0: SUCCESS (0.001s)
[388.814065] Subtest init-busy: SUCCESS (0.009s)
[388.876715] [092/131] (662s left) gem_exec_schedule (u-submit-late-slice)
[388.954297] Starting subtest: u-submit-late-slice
[388.956609] Starting dynamic subtest: rcs0
[388.991433] Dynamic subtest rcs0: SUCCESS (0.039s)
[389.003195] Starting dynamic subtest: bcs0
[389.016766] Dynamic subtest bcs0: SUCCESS (0.025s)
[389.025277] Starting dynamic subtest: vcs0
[389.048046] Dynamic subtest vcs0: SUCCESS (0.031s)
[389.056798] Starting dynamic subtest: vcs1
[389.074308] Dynamic subtest vcs1: SUCCESS (0.026s)
[389.082803] Starting dynamic subtest: vecs0
[389.100039] Dynamic subtest vecs0: SUCCESS (0.025s)
[389.108613] Starting dynamic subtest: ccs0
[389.127278] Dynamic subtest ccs0: SUCCESS (0.027s)
[389.129376] Subtest u-submit-late-slice: SUCCESS (0.176s)
[390.565478] [093/131] (661s left) gem_ctx_param (set-priority-not-supported)
[390.619689] Starting subtest: set-priority-not-supported
[390.624290] Subtest set-priority-not-supported: SKIP (0.000s)
[390.688641] [094/131] (660s left) kms_psr (fbc-psr2-cursor-blt)
[390.790014] Starting subtest: fbc-psr2-cursor-blt
[390.792162] Starting dynamic subtest: eDP-1
[390.796221] Dynamic subtest eDP-1: SKIP (0.000s)
[390.800117] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[390.856365] [095/131] (660s left) kms_pm_rpm (i2c)
[392.701863] Starting subtest: i2c
[397.790420] Subtest i2c: SUCCESS (5.086s)
[397.885066] [096/131] (653s left) syncobj_wait (wait-all-for-submit-complex)
[397.945869] Starting subtest: wait-all-for-submit-complex
[398.160437] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[398.228885] [097/131] (653s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[403.218689] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[403.221164] Starting dynamic subtest: pipe-A-eDP-1
[404.027672] Dynamic subtest pipe-A-eDP-1: SKIP (0.804s)
[404.038141] Starting dynamic subtest: pipe-B-eDP-1
[405.251438] Dynamic subtest pipe-B-eDP-1: SKIP (1.222s)
[405.255918] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (2.029s)
[406.426072] [098/131] (645s left) kms_flip_event_leak (basic)
[406.521551] Starting subtest: basic
[406.523883] Starting dynamic subtest: pipe-A-eDP-1
[406.964066] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.440s)
[406.973855] Starting dynamic subtest: pipe-B-eDP-1
[408.045093] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.079s)
[408.053940] Starting dynamic subtest: pipe-C-eDP-1
[409.162326] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.114s)
[409.172215] Starting dynamic subtest: pipe-D-eDP-1
[410.288742] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s)
[410.290703] Subtest basic: SUCCESS (3.764s)
[411.124959] [099/131] (640s left) gem_exec_params (mmapped)
[411.183960] Starting subtest: mmapped
[411.188557] Subtest mmapped: SUCCESS (0.003s)
[411.307597] [100/131] (640s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[411.413559] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[416.098337] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (4.685s)
[416.239791] [101/131] (635s left) gen7_exec_parse (basic-rejected)
[416.296816] Subtest basic-rejected: SKIP (0.000s)
[416.376215] [102/131] (635s left) kms_addfb_basic (invalid-get-prop)
[416.435402] Starting subtest: invalid-get-prop
[416.437556] Subtest invalid-get-prop: SUCCESS (0.000s)
[416.561267] [103/131] (635s left) gem_ccs (large-ctrl-surf-copy)
[416.616486] Starting subtest: large-ctrl-surf-copy
[416.620481] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[416.720321] [104/131] (635s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[416.823380] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[416.825665] Starting dynamic subtest: pipe-A-eDP-1
[416.848036] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[416.859477] Starting dynamic subtest: pipe-B-eDP-1
[416.880808] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[416.891448] Starting dynamic subtest: pipe-C-eDP-1
[416.912475] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[416.921200] Starting dynamic subtest: pipe-D-eDP-1
[416.943357] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[416.947468] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[418.935868] [105/131] (633s left) gem_ctx_exec (basic-norecovery)
[418.996390] Starting subtest: basic-norecovery
[419.325294] Subtest basic-norecovery: SUCCESS (0.329s)
[419.468592] [106/131] (632s left) kms_psr (psr2-primary-mmap-cpu)
[419.568549] Starting subtest: psr2-primary-mmap-cpu
[419.570772] Starting dynamic subtest: eDP-1
[421.312216] Dynamic subtest eDP-1: SUCCESS (1.740s)
[421.314735] Subtest psr2-primary-mmap-cpu: SUCCESS (1.741s)
[422.179723] [107/131] (629s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[422.292415] Starting subtest: fbc-rgb101010-draw-blt
[425.882253] Subtest fbc-rgb101010-draw-blt: SUCCESS (3.594s)
[426.025450] [108/131] (626s left) syncobj_wait (multi-wait-signaled)
[426.091250] Starting subtest: multi-wait-signaled
[426.093379] Subtest multi-wait-signaled: SUCCESS (0.000s)
[426.203022] [109/131] (626s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[426.304374] Starting subtest: 2x-flip-vs-modeset-vs-hang
[426.316075] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.011s)
[426.392372] [110/131] (625s left) kms_chamelium_frames (hdmi-crc-multiple)
[426.778558] Subtest hdmi-crc-multiple: SKIP (0.000s)
[427.610420] [111/131] (624s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[427.680862] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[427.683253] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[427.788296] [112/131] (624s left) sriov_basic (enable-vfs-autoprobe-off)
[427.853465] Starting subtest: enable-vfs-autoprobe-off
[427.855857] Starting dynamic subtest: numvfs-1
[427.934837] Dynamic subtest numvfs-1: FAIL (0.027s)
[427.945432] Starting dynamic subtest: numvfs-2
[428.020479] Dynamic subtest numvfs-2: FAIL (0.003s)
[428.031434] Starting dynamic subtest: numvfs-3
[428.105140] Dynamic subtest numvfs-3: FAIL (0.003s)
[428.115498] Starting dynamic subtest: numvfs-4
[428.188269] Dynamic subtest numvfs-4: FAIL (0.003s)
[428.198793] Starting dynamic subtest: numvfs-5
[428.275109] Dynamic subtest numvfs-5: FAIL (0.003s)
[428.285760] Starting dynamic subtest: numvfs-6
[428.359386] Dynamic subtest numvfs-6: FAIL (0.003s)
[428.369591] Starting dynamic subtest: numvfs-7
[428.445121] Dynamic subtest numvfs-7: FAIL (0.003s)
[428.455835] Starting dynamic subtest: numvfs-random
[428.526445] Dynamic subtest numvfs-random: FAIL (0.004s)
[428.535491] Starting dynamic subtest: numvfs-all
[428.598157] Dynamic subtest numvfs-all: FAIL (0.521s)
[428.600159] Subtest enable-vfs-autoprobe-off: FAIL (0.578s)
[428.631744] [113/131] (623s left) kms_atomic_interruptible (universal-setplane-primary)
[428.722577] Starting subtest: universal-setplane-primary
[428.724538] Starting dynamic subtest: pipe-A-eDP-1
[436.143816] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.419s)
[436.145929] Subtest universal-setplane-primary: SUCCESS (7.420s)
[436.978174] [114/131] (615s left) api_intel_bb (intel-bb-blit-x)
[437.042212] Starting subtest: intel-bb-blit-x
[440.951753] Subtest intel-bb-blit-x: SUCCESS (3.909s)
[441.105421] [115/131] (611s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[441.215869] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[444.743797] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (3.532s)
[444.887550] [116/131] (607s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[444.992447] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[450.410283] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (5.419s)
[450.563338] [117/131] (601s left) gem_create (create-valid-nonaligned)
[450.622461] Starting subtest: create-valid-nonaligned
[450.624886] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[450.803567] [118/131] (601s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[450.902363] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[450.904726] Starting dynamic subtest: pipe-A
[451.406907] Dynamic subtest pipe-A: SUCCESS (0.504s)
[451.417657] Starting dynamic subtest: pipe-B
[453.015739] Dynamic subtest pipe-B: SUCCESS (1.608s)
[453.027546] Starting dynamic subtest: pipe-C
[454.540064] Dynamic subtest pipe-C: SUCCESS (1.524s)
[454.549517] Starting dynamic subtest: pipe-D
[456.077518] Dynamic subtest pipe-D: SUCCESS (1.537s)
[456.079855] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (5.176s)
[457.281775] [119/131] (595s left) kms_pipe_crc_basic (suspend-read-crc)
[457.370488] Starting subtest: suspend-read-crc
[457.372828] Starting dynamic subtest: pipe-A-eDP-1
[475.245468] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.525s)
[475.255348] Starting dynamic subtest: pipe-B-eDP-1
[492.910066] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.759s)
[492.919914] Starting dynamic subtest: pipe-C-eDP-1
[510.907401] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.702s)
[510.917451] Starting dynamic subtest: pipe-D-eDP-1
[528.944006] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.783s)
[528.946207] Subtest suspend-read-crc: SUCCESS (10.775s)
[529.718266] [120/131] (583s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[529.821900] Starting subtest: fbc-psr2-sprite-mmap-cpu
[529.824186] Starting dynamic subtest: eDP-1
[529.828377] Dynamic subtest eDP-1: SKIP (0.000s)
[529.832870] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[529.890262] [121/131] (583s left) gem_exec_capture (capture-recoverable)
[529.954180] Starting subtest: capture-recoverable
[529.960117] Subtest capture-recoverable: SUCCESS (0.004s)
[530.074606] [122/131] (583s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[530.181210] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[530.185991] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[530.278424] [123/131] (583s left) kms_plane_multiple (tiling-y)
[530.378277] Starting subtest: tiling-y
[530.383752] Subtest tiling-y: SKIP (0.000s)
[530.446633] [124/131] (583s left) kms_hdr (bpc-switch)
[530.540915] Starting subtest: bpc-switch
[531.555209] Starting dynamic subtest: pipe-A-eDP-1
[534.865150] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.395s)
[534.867921] Subtest bpc-switch: SUCCESS (4.442s)
[534.994877] [125/131] (578s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[535.055733] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[535.058425] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[535.132637] [126/131] (578s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-render)
[535.242671] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-render
[538.388228] Subtest fbc-1p-offscren-pri-shrfb-draw-render: SUCCESS (3.200s)
[538.549645] [127/131] (574s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[538.657439] Starting subtest: x-tiled-8bpp-rotate-270
[538.679913] Subtest x-tiled-8bpp-rotate-270: SKIP (0.022s)
[538.797142] [128/131] (574s left) kms_cursor_crc (cursor-random-32x10)
[538.942923] Starting subtest: cursor-random-32x10
[538.982731] Subtest cursor-random-32x10: SKIP (0.035s)
[539.233768] [129/131] (574s left) kms_vblank (ts-continuation-suspend)
[539.333780] Starting subtest: ts-continuation-suspend
[539.335869] Starting dynamic subtest: pipe-A-eDP-1
[555.662586] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.538s)
[555.677398] Starting dynamic subtest: pipe-D-eDP-1
[572.592898] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.130s)
[572.595104] Subtest ts-continuation-suspend: SUCCESS (3.673s)
[573.403724] [130/131] (569s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[573.510323] Starting subtest: yf-tiled-16bpp-rotate-180
[573.515120] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[573.605464] [131/131] (569s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[573.710330] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[573.715018] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[574.771384] Closing watchdogs
Done.