[40.568402] Initializing watchdogs
[40.568462]   /dev/watchdog0
[40.583647] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[40.589624] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[40.591980] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[40.593921] [001/131] (960s left) kms_pm_rpm (pm-caching)
[42.031550] Starting subtest: pm-caching
[48.056629] Subtest pm-caching: SUCCESS (6.044s)
[48.179995] [002/131] (952s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[48.319698] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[48.398378] [003/131] (952s left) kms_lease (lease-invalid-connector)
[48.480293] Starting subtest: lease-invalid-connector
[48.480957] Starting dynamic subtest: pipe-A-HDMI-A-1
[48.481628] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.000s)
[48.486900] Starting dynamic subtest: pipe-B-HDMI-A-1
[48.487566] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[48.492602] Starting dynamic subtest: pipe-C-HDMI-A-1
[48.493249] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.000s)
[48.497918] Starting dynamic subtest: pipe-D-HDMI-A-1
[48.498637] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.000s)
[48.499302] Subtest lease-invalid-connector: SUCCESS (0.004s)
[48.562503] [004/131] (952s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[48.646320] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[49.813424] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (1.206s)
[49.945518] [005/131] (951s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[50.039811] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[50.338761] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.307s)
[50.489023] [006/131] (950s left) gem_eio (hibernate)
[50.531070] Starting subtest: hibernate
[63.533246] Subtest hibernate: SUCCESS (13.171s)
[72.706714] [007/131] (937s left) gem_close (many-handles-one-vma)
[72.755479] Starting subtest: many-handles-one-vma
[72.778871] Subtest many-handles-one-vma: SUCCESS (0.024s)
[72.893322] [008/131] (937s left) kms_getfb (getfb2-into-addfb2)
[72.978739] Starting subtest: getfb2-into-addfb2
[72.979481] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[73.075713] [009/131] (937s left) gem_userptr_blits (sync-unmap-after-close)
[73.121171] Starting subtest: sync-unmap-after-close
[73.134400] Subtest sync-unmap-after-close: SUCCESS (0.013s)
[73.252925] [010/131] (937s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[73.337480] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[73.376122] [011/131] (937s left) kms_psr (pr-no-drrs)
[73.460316] Subtest pr-no-drrs: SKIP (0.000s)
[73.500970] [012/131] (937s left) sw_sync (sync_busy_fork_unixsocket)
[73.531691] Starting subtest: sync_busy_fork_unixsocket
[73.541025] Subtest sync_busy_fork_unixsocket: SUCCESS (0.009s)
[73.604994] [013/131] (936s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[73.691669] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[73.693137] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[73.803057] [014/131] (936s left) gen9_exec_parse (cmd-crossing-page)
[73.839167] Subtest cmd-crossing-page: SKIP (0.000s)
[73.889159] [015/131] (936s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[74.051175] Subtest parallel-dmabuf-import-out-fence: SKIP (0.000s)
[74.138765] [016/131] (936s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[74.221475] Starting subtest: bo-too-small-due-to-tiling
[74.222238] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[74.327717] [017/131] (936s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[74.360351] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[74.461741] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[74.544938] [018/131] (936s left) kms_psr (fbc-psr2-sprite-plane-move)
[74.644454] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s)
[74.684194] [019/131] (936s left) kms_addfb_basic (clobberred-modifier)
[74.717368] Starting subtest: clobberred-modifier
[74.718204] Subtest clobberred-modifier: SUCCESS (0.000s)
[74.885642] [020/131] (935s left) kms_invalid_mode (overflow-vrefresh)
[74.969332] Starting subtest: overflow-vrefresh
[74.970059] Starting dynamic subtest: pipe-A-HDMI-A-1
[75.040761] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.071s)
[75.048200] Starting dynamic subtest: pipe-B-HDMI-A-1
[75.048925] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[75.056056] Starting dynamic subtest: pipe-C-HDMI-A-1
[75.056769] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[75.063729] Starting dynamic subtest: pipe-D-HDMI-A-1
[75.064445] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[75.065152] Subtest overflow-vrefresh: SUCCESS (0.081s)
[75.193757] [021/131] (935s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[75.283789] Starting subtest: psr-rgb565-draw-pwrite
[75.285182] Subtest psr-rgb565-draw-pwrite: SKIP (0.000s)
[75.416234] [022/131] (935s left) gem_pwrite (basic-self)
[75.448297] Starting subtest: basic-self
[75.488298] Subtest basic-self: SUCCESS (0.040s)
[75.577852] [023/131] (935s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[75.670551] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[75.671952] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[75.774635] [024/131] (935s left) syncobj_wait (invalid-signal-one-illegal-handle)
[75.808296] Starting subtest: invalid-signal-one-illegal-handle
[75.809036] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[75.900412] [025/131] (935s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[75.992126] Starting subtest: y-tiled-8bpp-rotate-270
[76.067701] Subtest y-tiled-8bpp-rotate-270: SKIP (0.074s)
[76.197169] [026/131] (934s left) kms_cursor_crc (cursor-suspend)
[76.282555] Starting subtest: cursor-suspend
[76.284128] Starting dynamic subtest: pipe-A-HDMI-A-1
[108.801587] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.704s)
[108.809144] Starting dynamic subtest: pipe-D-HDMI-A-1
[141.793410] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.584s)
[141.794207] Subtest cursor-suspend: SUCCESS (5.291s)
[154.993893] [027/131] (869s left) perf (blocking-parameterized)
[155.093201] Starting subtest: blocking-parameterized
[175.145486] Subtest blocking-parameterized: SUCCESS (20.261s)
[175.205681] [028/131] (849s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[175.303443] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[175.304888] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[175.374520] [029/131] (848s left) kms_atomic_transition (plane-toggle-modeset-transition)
[175.461802] Starting subtest: plane-toggle-modeset-transition
[175.463085] Starting dynamic subtest: pipe-A-HDMI-A-1
[176.315524] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.860s)
[176.323618] Starting dynamic subtest: pipe-B-HDMI-A-1
[177.011720] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.700s)
[177.012547] Subtest plane-toggle-modeset-transition: SUCCESS (1.564s)
[177.141181] [030/131] (847s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[177.228556] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[177.229265] Starting dynamic subtest: pipe-A-HDMI-A-1
[177.236236] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[177.243525] Starting dynamic subtest: pipe-B-HDMI-A-1
[177.257656] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[177.264526] Starting dynamic subtest: pipe-C-HDMI-A-1
[177.271438] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[177.277873] Starting dynamic subtest: pipe-D-HDMI-A-1
[177.285092] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[177.286526] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[177.470556] [031/131] (846s left) kms_flip (2x-blocking-wf_vblank)
[177.554393] Starting subtest: 2x-blocking-wf_vblank
[177.563528] Subtest 2x-blocking-wf_vblank: SKIP (0.009s)
[177.659614] [032/131] (846s left) perf_pmu (event-wait)
[177.694517] Starting subtest: event-wait
[177.695206] Starting dynamic subtest: rcs0
[177.696590] Dynamic subtest rcs0: SKIP (0.000s)
[177.698047] Subtest event-wait: SKIP (0.000s)
[177.783491] [033/131] (846s left) kms_content_protection (atomic-dpms)
[177.870069] Starting subtest: atomic-dpms
[177.883794] Subtest atomic-dpms: SKIP (0.012s)
[177.990296] [034/131] (846s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[178.076313] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[178.078589] Starting dynamic subtest: pipe-A-HDMI-A-1
[178.085114] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[178.091925] Starting dynamic subtest: pipe-B-HDMI-A-1
[178.098502] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[178.105207] Starting dynamic subtest: pipe-C-HDMI-A-1
[178.111781] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[178.118655] Starting dynamic subtest: pipe-D-HDMI-A-1
[178.125794] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[178.127158] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.009s)
[178.339165] [035/131] (846s left) gen7_exec_parse (basic-allowed)
[178.375294] Subtest basic-allowed: SKIP (0.000s)
[178.410410] [036/131] (846s left) gem_lmem_swapping (verify-random)
[178.446517] Subtest verify-random: SKIP (0.000s)
[178.485727] [037/131] (846s left) gem_userptr_blits (process-exit)
[178.528372] Starting subtest: process-exit
[178.538140] Subtest process-exit: SUCCESS (0.010s)
[178.653455] [038/131] (845s left) kms_cursor_crc (cursor-onscreen-512x512)
[178.740519] Starting subtest: cursor-onscreen-512x512
[178.741889] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[178.852384] [039/131] (845s left) gem_mmap_wc (close)
[178.885118] Starting subtest: close
[178.887992] Subtest close: SUCCESS (0.003s)
[178.992207] [040/131] (845s left) gem_exec_schedule (wide)
[179.156998] Starting subtest: wide
[179.158001] Starting dynamic subtest: rcs0
[189.360363] Dynamic subtest rcs0: SUCCESS (10.203s)
[189.367675] Starting dynamic subtest: bcs0
[200.256607] Dynamic subtest bcs0: SUCCESS (10.902s)
[200.268880] Starting dynamic subtest: vcs0
[211.424701] Dynamic subtest vcs0: SUCCESS (11.189s)
[211.434747] Starting dynamic subtest: vcs1
[222.415664] Dynamic subtest vcs1: SUCCESS (10.966s)
[222.425262] Starting dynamic subtest: vecs0
[233.940162] Dynamic subtest vecs0: SUCCESS (11.526s)
[233.941018] Subtest wide: SUCCESS (54.791s)
[236.010699] [FACT gem_exec_schedule (wide)] new: kernel.kmod_is_loaded.vgem: true
[236.013037] [041/131] (788s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[236.044994] Starting subtest: etime-multi-wait-available-unsubmitted
[236.147615] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.102s)
[236.238629] [042/131] (788s left) kms_big_fb (yf-tiled-addfb)
[236.333739] Starting subtest: yf-tiled-addfb
[236.335097] Subtest yf-tiled-addfb: SKIP (0.000s)
[236.444671] [043/131] (788s left) kms_chamelium_audio (dp-audio-edid)
[236.596215] Subtest dp-audio-edid: SKIP (0.000s)
[236.689791] [044/131] (788s left) kms_flip (flip-vs-panning-vs-hang)
[236.778227] Starting subtest: flip-vs-panning-vs-hang
[236.779847] Starting dynamic subtest: A-HDMI-A1
[275.894947] Dynamic subtest A-HDMI-A1: SUCCESS (39.103s)
[275.902465] Starting dynamic subtest: D-HDMI-A1
[304.029720] Dynamic subtest D-HDMI-A1: SUCCESS (28.143s)
[304.030687] Subtest flip-vs-panning-vs-hang: SUCCESS (67.252s)
[304.285741] [045/131] (720s left) gem_exec_schedule (implicit-read-write)
[304.327378] Starting subtest: implicit-read-write
[304.328086] Starting dynamic subtest: rcs0
[304.385024] Dynamic subtest rcs0: SUCCESS (0.058s)
[304.394457] Starting dynamic subtest: bcs0
[304.443847] Dynamic subtest bcs0: SUCCESS (0.058s)
[304.454000] Starting dynamic subtest: vcs0
[304.507879] Dynamic subtest vcs0: SUCCESS (0.063s)
[304.519030] Starting dynamic subtest: vcs1
[304.571948] Dynamic subtest vcs1: SUCCESS (0.063s)
[304.583006] Starting dynamic subtest: vecs0
[304.634952] Dynamic subtest vecs0: SUCCESS (0.062s)
[304.635998] Subtest implicit-read-write: SUCCESS (0.309s)
[304.937852] [046/131] (719s left) kms_chamelium_frames (vga-frame-dump)
[305.079907] Subtest vga-frame-dump: SKIP (0.000s)
[305.175976] [047/131] (719s left) gem_fence_thrash (bo-write-verify-threaded-none)
[305.208515] Starting subtest: bo-write-verify-threaded-none
[309.667142] Subtest bo-write-verify-threaded-none: SUCCESS (4.425s)
[309.753405] [048/131] (715s left) gem_softpin (evict-prime-sanity-check)
[309.788314] Starting subtest: evict-prime-sanity-check
[309.789078] Starting dynamic subtest: rcs0
[310.902630] Dynamic subtest rcs0: SUCCESS (1.114s)
[310.914780] Starting dynamic subtest: bcs0
[312.027556] Dynamic subtest bcs0: SUCCESS (1.123s)
[312.046114] Starting dynamic subtest: vcs0
[313.158712] Dynamic subtest vcs0: SUCCESS (1.130s)
[313.172155] Starting dynamic subtest: vcs1
[314.295623] Dynamic subtest vcs1: SUCCESS (1.135s)
[314.306427] Starting dynamic subtest: vecs0
[315.421681] Dynamic subtest vecs0: SUCCESS (1.125s)
[315.432520] Starting dynamic subtest: all
[316.547606] Dynamic subtest all: SUCCESS (1.125s)
[316.548856] Subtest evict-prime-sanity-check: SUCCESS (6.760s)
[316.644624] [049/131] (708s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[316.735590] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[316.736973] Subtest psr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[316.831210] [050/131] (708s left) kms_flip (2x-flip-vs-fences)
[316.915197] Starting subtest: 2x-flip-vs-fences
[316.924610] Subtest 2x-flip-vs-fences: SKIP (0.009s)
[317.001468] [051/131] (708s left) gem_compute (compute-square)
[317.032609] Starting subtest: compute-square
[317.035738] Subtest compute-square: SUCCESS (0.004s)
[317.152072] [052/131] (707s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[317.239411] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[317.248107] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[317.367754] [053/131] (707s left) kms_plane_alpha_blend (alpha-opaque-fb)
[317.453578] Starting subtest: alpha-opaque-fb
[317.518698] Starting dynamic subtest: pipe-A-HDMI-A-1
[317.808416] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.289s)
[317.816921] Starting dynamic subtest: pipe-D-HDMI-A-1
[318.112419] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.302s)
[318.113195] Subtest alpha-opaque-fb: SUCCESS (0.660s)
[318.263537] [054/131] (706s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[318.302471] Starting subtest: yf-tiled-to-vebox-y-tiled
[318.303234] Starting dynamic subtest: smem
[318.399103] Dynamic subtest smem: SUCCESS (0.096s)
[318.399818] Subtest yf-tiled-to-vebox-y-tiled: SUCCESS (0.097s)
[318.634045] [055/131] (706s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[319.081296] Starting subtest: syncobj-timeline-multiple-ext-nodes
[319.082256] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s)
[319.278644] [056/131] (706s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[319.312094] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[319.312859] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[319.394875] [057/131] (706s left) gem_exec_schedule (submit-late-slice)
[319.437878] Starting subtest: submit-late-slice
[319.438632] Starting dynamic subtest: rcs0
[319.462100] Dynamic subtest rcs0: SUCCESS (0.024s)
[319.470026] Starting dynamic subtest: bcs0
[319.488952] Dynamic subtest bcs0: SUCCESS (0.026s)
[319.496688] Starting dynamic subtest: vcs0
[319.515781] Dynamic subtest vcs0: SUCCESS (0.026s)
[319.524121] Starting dynamic subtest: vcs1
[319.541925] Dynamic subtest vcs1: SUCCESS (0.026s)
[319.550371] Starting dynamic subtest: vecs0
[319.564933] Dynamic subtest vecs0: SUCCESS (0.023s)
[319.565701] Subtest submit-late-slice: SUCCESS (0.127s)
[319.888708] [058/131] (705s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[319.974661] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[319.976338] Starting dynamic subtest: pipe-A-HDMI-A-1
[319.979196] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[319.986753] Starting dynamic subtest: pipe-B-HDMI-A-1
[319.989670] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[319.997067] Starting dynamic subtest: pipe-C-HDMI-A-1
[319.999953] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[320.007191] Starting dynamic subtest: pipe-D-HDMI-A-1
[320.010046] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[320.011515] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[320.239509] [059/131] (705s left) api_intel_allocator (standalone)
[320.271347] Starting subtest: standalone
[320.287691] Subtest standalone: SUCCESS (0.016s)
[320.395991] [060/131] (705s left) kms_vblank (query-forked-hang)
[320.482517] Starting subtest: query-forked-hang
[320.483207] Starting dynamic subtest: pipe-A-HDMI-A-1
[334.812079] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.331s)
[334.821661] Starting dynamic subtest: pipe-D-HDMI-A-1
[349.118612] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (14.306s)
[349.119382] Subtest query-forked-hang: SUCCESS (28.643s)
[349.277507] [061/131] (676s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[349.375184] Starting subtest: 4-tiled-16bpp-rotate-270
[349.376595] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.000s)
[349.491749] [062/131] (676s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[349.580222] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[349.622508] [063/131] (676s left) gem_exec_balancer (parallel)
[349.782191] Subtest parallel: SKIP (0.000s)
[349.866568] [064/131] (675s left) gem_pxp (fail-invalid-protected-context)
[349.968511] Starting subtest: fail-invalid-protected-context
[349.969529] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[350.049576] [065/131] (675s left) syncobj_timeline (single-wait-available-signaled)
[350.082213] Starting subtest: single-wait-available-signaled
[350.082926] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[350.169102] [066/131] (675s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[350.262557] Starting subtest: x-tiled-8bpp-rotate-90
[350.342118] Subtest x-tiled-8bpp-rotate-90: SKIP (0.078s)
[350.490996] [067/131] (675s left) gem_exec_whisper (basic-queues)
[350.534622] Starting subtest: basic-queues
[352.226153] Subtest basic-queues: SUCCESS (1.691s)
[352.418633] [068/131] (673s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[352.508133] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[352.509532] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[352.625277] [069/131] (673s left) gem_ctx_persistence (userptr)
[352.659762] Starting subtest: userptr
[352.752232] Subtest userptr: SUCCESS (0.090s)
[352.850312] [070/131] (673s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[352.934584] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[352.935258] Starting dynamic subtest: pipe-A-valid-mode
[353.777781] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.842s)
[353.778568] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (0.844s)
[353.927275] [071/131] (672s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[354.020914] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[354.021664] Starting dynamic subtest: pipe-A-valid-mode
[354.762688] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.741s)
[354.763392] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SUCCESS (0.743s)
[354.923162] [072/131] (671s left) gem_mmap_offset (blt-coherency)
[354.956696] Starting subtest: blt-coherency
[354.961178] Subtest blt-coherency: SUCCESS (0.005s)
[355.073862] [073/131] (670s left) gem_ccs (ctrl-surf-copy)
[355.110138] Starting subtest: ctrl-surf-copy
[355.111584] Subtest ctrl-surf-copy: SKIP (0.000s)
[355.193598] [074/131] (670s left) kms_atomic (plane-cursor-legacy)
[355.279689] Starting subtest: plane-cursor-legacy
[355.281430] Starting dynamic subtest: pipe-A-HDMI-A-1
[355.417626] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.136s)
[355.418328] Subtest plane-cursor-legacy: SUCCESS (0.138s)
[355.560311] [075/131] (670s left) kms_plane_lowres (tiling-yf)
[355.644677] Starting subtest: tiling-yf
[355.646093] Subtest tiling-yf: SKIP (0.000s)
[355.729256] [076/131] (670s left) syncobj_eventfd (binary-wait)
[355.762586] Starting subtest: binary-wait
[355.772243] Subtest binary-wait: SUCCESS (0.010s)
[355.855609] [077/131] (670s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[355.942480] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[355.943853] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[356.040154] [078/131] (670s left) kms_psr (psr-cursor-render)
[356.124393] Subtest psr-cursor-render: SKIP (0.000s)
[356.164796] [079/131] (670s left) gem_mmap_gtt (fault-concurrent)
[356.197668] Starting subtest: fault-concurrent
[358.777697] Subtest fault-concurrent: SUCCESS (2.573s)
[358.896194] [080/131] (667s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[358.986588] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[358.987990] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[359.089081] [081/131] (667s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[359.177901] Subtest psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[359.214074] [082/131] (667s left) syncobj_basic (bad-handle-to-fd)
[359.246638] Starting subtest: bad-handle-to-fd
[359.247347] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[359.332640] [083/131] (667s left) kms_busy (extended-pageflip-hang-oldfb)
[359.420934] Starting subtest: extended-pageflip-hang-oldfb
[359.422704] Starting dynamic subtest: pipe-A
[359.555846] Dynamic subtest pipe-A: SUCCESS (0.133s)
[359.566767] Starting dynamic subtest: pipe-D
[359.712206] Dynamic subtest pipe-D: SUCCESS (0.151s)
[359.713007] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.291s)
[359.851306] [084/131] (666s left) gem_exec_schedule (fairslice)
[359.897898] Starting subtest: fairslice
[359.898674] Starting dynamic subtest: rcs0
[361.921375] Dynamic subtest rcs0: SUCCESS (2.015s)
[361.932499] Starting dynamic subtest: bcs0
[363.932940] Dynamic subtest bcs0: SUCCESS (2.011s)
[363.949477] Starting dynamic subtest: vcs0
[365.944290] Dynamic subtest vcs0: SUCCESS (2.011s)
[365.955508] Starting dynamic subtest: vcs1
[367.955557] Dynamic subtest vcs1: SUCCESS (2.011s)
[367.966203] Starting dynamic subtest: vecs0
[369.966312] Dynamic subtest vecs0: SUCCESS (2.010s)
[369.967214] Subtest fairslice: SUCCESS (10.062s)
[370.259639] [085/131] (656s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[370.350323] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[370.351701] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[370.465188] [086/131] (656s left) gem_madvise (dontneed-before-exec)
[370.496028] Starting subtest: dontneed-before-exec
[370.498498] Subtest dontneed-before-exec: SUCCESS (0.003s)
[370.614557] [087/131] (656s left) gem_exec_create (basic)
[370.653902] Starting subtest: basic
[370.654630] Starting dynamic subtest: smem
[372.714929] Dynamic subtest smem: SUCCESS (2.061s)
[372.715728] Subtest basic: SUCCESS (2.062s)
[372.907560] [088/131] (653s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[372.993642] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[372.994329] Starting dynamic subtest: pipe-A-HDMI-A-1
[373.001698] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[373.009868] Starting dynamic subtest: pipe-B-HDMI-A-1
[373.017181] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[373.025188] Starting dynamic subtest: pipe-C-HDMI-A-1
[373.032473] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[373.040204] Starting dynamic subtest: pipe-D-HDMI-A-1
[373.047685] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[373.049034] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SKIP (0.006s)
[373.277133] [089/131] (653s left) gem_ctx_shared (q-promotion)
[373.318257] Starting subtest: Q-promotion
[373.318982] Starting dynamic subtest: rcs0
[373.370005] Dynamic subtest rcs0: SUCCESS (0.051s)
[373.384904] Starting dynamic subtest: bcs0
[373.426693] Dynamic subtest bcs0: SUCCESS (0.055s)
[373.442749] Starting dynamic subtest: vcs0
[373.483661] Dynamic subtest vcs0: SUCCESS (0.054s)
[373.499441] Starting dynamic subtest: vcs1
[373.540102] Dynamic subtest vcs1: SUCCESS (0.054s)
[373.555949] Starting dynamic subtest: vecs0
[373.596066] Dynamic subtest vecs0: SUCCESS (0.053s)
[373.597279] Subtest Q-promotion: SUCCESS (0.279s)
[373.795269] [090/131] (653s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[373.888857] Starting subtest: cursor-vs-flip-toggle
[405.681355] Subtest cursor-vs-flip-toggle: SUCCESS (31.792s)
[405.828735] [091/131] (621s left) gem_exec_params (cliprects_ptr-dirt)
[405.866098] Starting subtest: cliprects_ptr-dirt
[405.866826] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[405.970200] [092/131] (620s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[406.054658] Starting subtest: multiplane-rotation-cropping-top
[416.642325] Subtest multiplane-rotation-cropping-top: SUCCESS (10.587s)
[416.791318] [093/131] (610s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[416.885437] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[416.886795] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[416.989337] [094/131] (609s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[417.075607] Starting subtest: cursorB-vs-flipB-varying-size
[417.078524] Subtest cursorB-vs-flipB-varying-size: SKIP (0.002s)
[417.147702] [095/131] (609s left) sw_sync (alloc_merge_fence)
[417.179264] Starting subtest: alloc_merge_fence
[417.180023] Subtest alloc_merge_fence: SUCCESS (0.000s)
[417.240357] [096/131] (609s left) i915_pm_rpm (gem-execbuf-stress)
[418.629882] Starting subtest: gem-execbuf-stress
[418.630873] Starting dynamic subtest: smem0
[432.165959] Dynamic subtest smem0: SUCCESS (13.536s)
[432.180239] Starting dynamic subtest: extra-wait-smem0
[494.126477] Dynamic subtest extra-wait-smem0: SUCCESS (61.951s)
[494.127205] Subtest gem-execbuf-stress: SUCCESS (75.493s)
[494.309460] [097/131] (532s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[494.392916] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[494.393649] Starting dynamic subtest: pipe-A
[494.515353] Dynamic subtest pipe-A: SUCCESS (0.122s)
[494.525273] Starting dynamic subtest: pipe-B
[494.659354] Dynamic subtest pipe-B: SUCCESS (0.142s)
[494.669565] Starting dynamic subtest: pipe-C
[494.803985] Dynamic subtest pipe-C: SUCCESS (0.144s)
[494.813402] Starting dynamic subtest: pipe-D
[494.945489] Dynamic subtest pipe-D: SUCCESS (0.140s)
[494.946197] Subtest planes-downscale-factor-0-5-upscale-20x20: SUCCESS (0.553s)
[495.148472] [098/131] (531s left) core_auth (basic-auth)
[495.181535] Starting subtest: basic-auth
[495.182217] Subtest basic-auth: SUCCESS (0.001s)
[495.269464] [099/131] (531s left) kms_feature_discovery (display)
[495.352841] Starting subtest: display
[495.353645] Subtest display: SUCCESS (0.000s)
[495.428631] [100/131] (531s left) sysfs_timeslice_duration (timeout)
[495.463779] Starting subtest: timeout
[495.465849] Starting dynamic subtest: vecs0
[496.391507] Dynamic subtest vecs0: SUCCESS (0.926s)
[496.409377] Starting dynamic subtest: vcs0
[497.315938] Dynamic subtest vcs0: SUCCESS (0.921s)
[497.326939] Starting dynamic subtest: bcs0
[498.234357] Dynamic subtest bcs0: SUCCESS (0.916s)
[498.245983] Starting dynamic subtest: rcs0
[499.179492] Dynamic subtest rcs0: SUCCESS (0.942s)
[499.190636] Starting dynamic subtest: vcs1
[500.081489] Dynamic subtest vcs1: SUCCESS (0.898s)
[500.082935] Subtest timeout: SUCCESS (4.619s)
[500.169414] [101/131] (527s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[500.256859] Starting subtest: flip-vs-cursor-crc-atomic
[500.559890] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.302s)
[500.718364] [102/131] (526s left) kms_frontbuffer_tracking (fbc-tiling-y)
[500.808530] Starting subtest: fbc-tiling-y
[502.105599] Subtest fbc-tiling-y: SUCCESS (1.298s)
[502.264627] [103/131] (525s left) kms_psr (fbc-psr-primary-render)
[502.352902] Subtest fbc-psr-primary-render: SKIP (0.000s)
[502.399307] [104/131] (524s left) prime_self_import (reimport-vs-gem_close-race)
[502.429966] Starting subtest: reimport-vs-gem_close-race
[507.473086] Subtest reimport-vs-gem_close-race: SUCCESS (5.043s)
[507.583448] [105/131] (519s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[507.674549] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[507.675930] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[507.789133] [106/131] (519s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[507.874753] Starting subtest: addfb25-y-tiled-legacy
[507.875486] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[507.989570] [107/131] (519s left) prime_mmap (test_map_unmap)
[508.022029] Starting subtest: test_map_unmap
[508.022747] Starting dynamic subtest: test_map_unmap-smem
[508.024543] Dynamic subtest test_map_unmap-smem: SUCCESS (0.002s)
[508.025235] Subtest test_map_unmap: SUCCESS (0.003s)
[508.140275] [108/131] (519s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[508.172520] Starting subtest: invalid-multi-wait-all-unsubmitted
[508.173208] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[508.262252] [109/131] (519s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[508.351342] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[508.352709] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[508.464556] [110/131] (519s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[508.497412] Starting subtest: framebuffer-vs-set-tiling
[508.498117] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[508.657039] [111/131] (519s left) kms_vrr (seamless-rr-switch-vrr)
[508.741893] Starting subtest: seamless-rr-switch-vrr
[508.743897] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[508.826562] [112/131] (518s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[508.915781] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[508.917208] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[509.010656] [113/131] (518s left) gem_flink_basic (bad-flink)
[509.042822] Starting subtest: bad-flink
[509.043567] Subtest bad-flink: SUCCESS (0.000s)
[509.129678] [114/131] (518s left) api_intel_bb (intel-bb-blit-x)
[509.161800] Starting subtest: intel-bb-blit-x
[512.328338] Subtest intel-bb-blit-x: SUCCESS (3.133s)
[512.438642] [115/131] (515s left) kms_big_fb (linear-32bpp-rotate-0)
[512.534963] Starting subtest: linear-32bpp-rotate-0
[513.747698] Subtest linear-32bpp-rotate-0: SUCCESS (1.212s)
[513.892262] [116/131] (514s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[513.926797] Starting subtest: invalid-single-wait-unsubmitted
[513.927531] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[513.987650] [117/131] (514s left) kms_cursor_crc (cursor-random-32x10)
[514.077087] Starting subtest: cursor-random-32x10
[514.128459] Subtest cursor-random-32x10: SKIP (0.049s)
[514.235837] [118/131] (513s left) gem_ctx_isolation (dirty-create)
[514.275601] Starting subtest: dirty-create
[514.276312] Starting dynamic subtest: rcs0
[514.446321] Dynamic subtest rcs0: SUCCESS (0.161s)
[514.454384] Starting dynamic subtest: bcs0
[514.649028] Dynamic subtest bcs0: SUCCESS (0.201s)
[514.657087] Starting dynamic subtest: vcs0
[514.852402] Dynamic subtest vcs0: SUCCESS (0.202s)
[514.860643] Starting dynamic subtest: vcs1
[515.063516] Dynamic subtest vcs1: SUCCESS (0.210s)
[515.072114] Starting dynamic subtest: vecs0
[515.267859] Dynamic subtest vecs0: SUCCESS (0.203s)
[515.268590] Subtest dirty-create: SUCCESS (0.984s)
[515.452299] [119/131] (512s left) i915_suspend (basic-s3-without-i915)
[515.483224] Starting subtest: basic-s3-without-i915