[49.951943] Initializing watchdogs
[49.952014]   /dev/watchdog0
[49.967509] [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]
[49.973062] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[49.975510] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[49.977253] [001/130] (960s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[50.065495] Starting subtest: bad-pixel-format-yf-tiled-ccs
[50.066212] Starting dynamic subtest: pipe-A-HDMI-A-1
[50.072928] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[50.079098] Starting dynamic subtest: pipe-B-HDMI-A-1
[50.085859] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[50.091932] Starting dynamic subtest: pipe-C-HDMI-A-1
[50.098731] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[50.105777] Starting dynamic subtest: pipe-D-HDMI-A-1
[50.112648] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[50.114037] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s)
[50.308497] [002/130] (960s left) kms_content_protection (dp-mst-type-0)
[50.400441] Starting subtest: dp-mst-type-0
[50.401794] Subtest dp-mst-type-0: SKIP (0.000s)
[50.515266] [003/130] (960s left) gem_exec_reloc (basic-cpu-read-active)
[50.553643] Starting subtest: basic-cpu-read-active
[50.683125] Subtest basic-cpu-read-active: SUCCESS (0.122s)
[50.805095] [004/130] (959s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[50.888458] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[50.889199] Starting dynamic subtest: pipe-A-HDMI-A-1
[50.896025] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[50.900964] Starting dynamic subtest: pipe-B-HDMI-A-1
[50.907349] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[50.912183] Starting dynamic subtest: pipe-C-HDMI-A-1
[50.918535] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[50.923459] Starting dynamic subtest: pipe-D-HDMI-A-1
[50.929983] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[50.931264] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.007s)
[51.126452] [005/130] (959s left) gem_mmap_offset (clear)
[51.159242] Starting subtest: clear
[51.161698] Starting dynamic subtest: smem0
[74.378474] Dynamic subtest smem0: SUCCESS (23.300s)
[74.379145] Subtest clear: SUCCESS (23.301s)
[74.519052] [006/130] (936s left) kms_feature_discovery (psr1)
[74.659593] Starting subtest: psr1
[74.661049] Subtest psr1: SKIP (0.000s)
[74.737625] [007/130] (935s left) kms_cursor_legacy (torture-move)
[74.822891] Starting subtest: torture-move
[74.823622] Starting dynamic subtest: pipe-A
[80.315606] Dynamic subtest pipe-A: SUCCESS (5.494s)
[80.323036] Starting dynamic subtest: pipe-B
[85.811937] Dynamic subtest pipe-B: SUCCESS (5.462s)
[85.818546] Starting dynamic subtest: pipe-C
[91.265872] Dynamic subtest pipe-C: SUCCESS (5.452s)
[91.273670] Starting dynamic subtest: pipe-D
[96.686162] Dynamic subtest pipe-D: SUCCESS (5.456s)
[96.691996] Starting dynamic subtest: all-pipes
[102.179209] Dynamic subtest all-pipes: SUCCESS (5.459s)
[102.179986] Subtest torture-move: SUCCESS (27.324s)
[102.252989] [008/130] (908s left) gem_softpin (evict-snoop)
[102.298376] Starting subtest: evict-snoop
[102.299811] Subtest evict-snoop: SKIP (0.000s)
[102.379214] [009/130] (908s left) gem_ppgtt (blt-vs-render-ctxn)
[102.414497] Starting subtest: blt-vs-render-ctxN
[134.919709] Subtest blt-vs-render-ctxN: SUCCESS (32.494s)
[135.052768] [010/130] (875s left) prime_vgem (fence-read-hang)
[135.216074] Subtest fence-read-hang: SKIP (0.000s)
[135.336122] [FACT prime_vgem (fence-read-hang)] new: kernel.kmod_is_loaded.vgem: true
[135.337675] [011/130] (875s left) i915_drm_fdinfo (memory-info-shared)
[135.372188] Starting subtest: memory-info-shared
[135.372887] Starting dynamic subtest: smem0
[135.424669] Dynamic subtest smem0: SUCCESS (0.052s)
[135.425460] Subtest memory-info-shared: SUCCESS (0.052s)
[135.510893] [012/130] (875s left) gem_exec_schedule (timeslicing)
[135.556076] Starting subtest: timeslicing
[135.556806] Starting dynamic subtest: rcs0
[135.561265] Dynamic subtest rcs0: SUCCESS (0.005s)
[135.568410] Starting dynamic subtest: bcs0
[135.569098] Dynamic subtest bcs0: SUCCESS (0.003s)
[135.575637] Starting dynamic subtest: vcs0
[135.576378] Dynamic subtest vcs0: SUCCESS (0.003s)
[135.582973] Starting dynamic subtest: vcs1
[135.583744] Dynamic subtest vcs1: SUCCESS (0.003s)
[135.589772] Starting dynamic subtest: vecs0
[135.590435] Dynamic subtest vecs0: SUCCESS (0.003s)
[135.591073] Subtest timeslicing: SUCCESS (0.018s)
[135.897798] [013/130] (875s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[135.995515] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[135.996838] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[136.104178] [014/130] (874s left) kms_async_flips (alternate-sync-async-flip-atomic)
[136.187380] Starting subtest: alternate-sync-async-flip-atomic
[136.308436] Starting dynamic subtest: pipe-A-HDMI-A-1
[138.412079] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.095s)
[138.537721] Starting dynamic subtest: pipe-B-HDMI-A-1
[140.618533] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.080s)
[140.746711] Starting dynamic subtest: pipe-C-HDMI-A-1
[142.845786] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.098s)
[142.959634] Starting dynamic subtest: pipe-D-HDMI-A-1
[145.048455] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.085s)
[145.049495] Subtest alternate-sync-async-flip-atomic: SUCCESS (8.853s)
[145.286515] [015/130] (865s left) api_intel_bb (simple-bb)
[145.319659] Starting subtest: simple-bb
[145.321701] Subtest simple-bb: SUCCESS (0.003s)
[145.451968] [016/130] (865s left) i915_hangman (engine-engine-error)
[145.493474] Starting subtest: engine-engine-error
[145.494168] Starting dynamic subtest: rcs0
[145.560808] Dynamic subtest rcs0: SUCCESS (0.067s)
[145.575284] Starting dynamic subtest: bcs0
[145.646039] Dynamic subtest bcs0: SUCCESS (0.084s)
[145.661521] Starting dynamic subtest: vcs0
[145.723843] Dynamic subtest vcs0: SUCCESS (0.077s)
[145.739315] Starting dynamic subtest: vcs1
[145.810814] Dynamic subtest vcs1: SUCCESS (0.086s)
[145.826442] Starting dynamic subtest: vecs0
[145.896062] Dynamic subtest vecs0: SUCCESS (0.084s)
[145.897206] Subtest engine-engine-error: SUCCESS (0.403s)
[145.984598] [017/130] (865s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[146.085410] Starting subtest: verify-pxp-execution-after-suspend-resume
[153.311334] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.227s)
[162.478076] [018/130] (857s left) syncobj_eventfd (timeline-wait)
[162.525142] Starting subtest: timeline-wait
[162.535749] Subtest timeline-wait: SUCCESS (0.010s)
[162.621546] [019/130] (857s left) gem_busy (extended)
[162.789609] Starting subtest: extended
[162.790684] Starting dynamic subtest: rcs0
[162.817836] Dynamic subtest rcs0: SUCCESS (0.037s)
[162.834905] Starting dynamic subtest: bcs0
[162.844474] Dynamic subtest bcs0: SUCCESS (0.026s)
[162.857275] Starting dynamic subtest: vcs0
[162.862843] Dynamic subtest vcs0: SUCCESS (0.018s)
[162.871436] Starting dynamic subtest: vcs1
[162.879976] Dynamic subtest vcs1: SUCCESS (0.017s)
[162.888672] Starting dynamic subtest: vecs0
[162.901641] Dynamic subtest vecs0: SUCCESS (0.021s)
[162.902716] Subtest extended: SUCCESS (0.121s)
[163.166399] [020/130] (857s left) syncobj_timeline (invalid-transfer-illegal-handle)
[163.199343] Starting subtest: invalid-transfer-illegal-handle
[163.200069] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[163.280924] [021/130] (857s left) gem_ctx_freq (sysfs)
[163.317148] Starting subtest: sysfs
[163.317906] Starting dynamic subtest: gt0
[168.308369] Dynamic subtest gt0: SUCCESS (4.991s)
[168.309449] Subtest sysfs: SUCCESS (4.991s)
[168.393266] [022/130] (851s left) kms_chamelium_edid (hdmi-edid-read)
[168.535772] Subtest hdmi-edid-read: SKIP (0.000s)
[168.633456] [023/130] (851s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[168.718756] Starting subtest: short-flip-before-cursor-toggle
[169.270347] Subtest short-flip-before-cursor-toggle: SUCCESS (0.552s)
[169.439687] [024/130] (851s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[169.526863] Starting subtest: cursor-rapid-movement-64x64
[169.531500] Starting dynamic subtest: pipe-A-HDMI-A-1
[169.785268] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.253s)
[169.822518] Starting dynamic subtest: pipe-D-HDMI-A-1
[170.031494] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.218s)
[170.032221] Subtest cursor-rapid-movement-64x64: SUCCESS (0.505s)
[170.204506] [025/130] (850s left) gem_exec_flush (basic-wb-prw-default)
[170.245675] Starting subtest: basic-wb-prw-default
[175.669430] Subtest basic-wb-prw-default: SUCCESS (5.424s)
[175.888526] [026/130] (844s left) kms_invalid_mode (bad-vtotal)
[175.975366] Starting subtest: bad-vtotal
[175.976110] Starting dynamic subtest: pipe-A-HDMI-A-1
[176.040201] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.053s)
[176.047863] Starting dynamic subtest: pipe-B-HDMI-A-1
[176.048571] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[176.055978] Starting dynamic subtest: pipe-C-HDMI-A-1
[176.056710] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[176.063697] Starting dynamic subtest: pipe-D-HDMI-A-1
[176.064391] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[176.065070] Subtest bad-vtotal: SUCCESS (0.061s)
[176.181230] [027/130] (844s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[176.215152] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[176.215861] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[176.300087] [028/130] (844s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[176.387490] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[176.388882] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[176.507962] [029/130] (844s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[176.591695] Starting subtest: primary-yf-tiled-reflect-x-270
[176.647300] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.055s)
[176.745798] [030/130] (843s left) gem_exec_schedule (preempt-queue-chain)
[176.789066] Starting subtest: preempt-queue-chain
[176.789807] Starting dynamic subtest: rcs0
[176.938642] Dynamic subtest rcs0: SUCCESS (0.138s)
[176.946724] Starting dynamic subtest: bcs0
[177.076496] Dynamic subtest bcs0: SUCCESS (0.138s)
[177.084618] Starting dynamic subtest: vcs0
[177.211747] Dynamic subtest vcs0: SUCCESS (0.136s)
[177.220033] Starting dynamic subtest: vcs1
[177.354593] Dynamic subtest vcs1: SUCCESS (0.140s)
[177.362838] Starting dynamic subtest: vecs0
[177.493141] Dynamic subtest vecs0: SUCCESS (0.136s)
[177.493891] Subtest preempt-queue-chain: SUCCESS (0.691s)
[177.796794] [031/130] (842s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[177.886740] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[177.888138] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[178.004904] [032/130] (842s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[178.087735] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[178.089071] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[178.253585] [033/130] (842s left) gem_exec_reloc (basic-cpu-active)
[178.291874] Starting subtest: basic-cpu-active
[178.424374] Subtest basic-cpu-active: SUCCESS (0.118s)
[178.550736] [034/130] (842s left) kms_lease (multimaster-lease)
[178.635871] Starting subtest: multimaster-lease
[178.638473] Subtest multimaster-lease: SUCCESS (0.003s)
[178.716408] [035/130] (842s left) kms_dp_linktrain_fallback (dsc-fallback)
[178.800662] Starting subtest: dsc-fallback
[178.802643] Subtest dsc-fallback: SKIP (0.000s)
[178.876251] [036/130] (842s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[178.959694] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[178.960387] Starting dynamic subtest: pipe-A-HDMI-A-1
[178.967094] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[178.974678] Starting dynamic subtest: pipe-B-HDMI-A-1
[178.981408] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[178.988974] Starting dynamic subtest: pipe-C-HDMI-A-1
[178.995492] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[179.002876] Starting dynamic subtest: pipe-D-HDMI-A-1
[179.009523] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[179.010848] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SKIP (0.005s)
[179.205562] [037/130] (841s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[179.293571] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[179.294932] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[179.411815] [038/130] (841s left) kms_psr (psr-primary-page-flip)
[179.497381] Subtest psr-primary-page-flip: SKIP (0.000s)
[179.541595] [039/130] (841s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[179.638591] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[179.639982] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[179.769742] [040/130] (841s left) kms_getfb (getfb2-handle-closed)
[179.853729] Starting subtest: getfb2-handle-closed
[179.854431] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[179.969517] [041/130] (841s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[180.056550] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[180.057925] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[180.173968] [042/130] (841s left) gem_lmem_swapping (heavy-verify-random)
[180.211117] Subtest heavy-verify-random: SKIP (0.000s)
[180.249854] [043/130] (840s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[180.336490] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[180.337847] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[180.461057] [044/130] (840s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[180.547384] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[180.548709] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[180.678479] [045/130] (840s left) gem_exec_gttfill (basic)
[180.719464] Starting subtest: basic
[184.163645] Subtest basic: SUCCESS (3.444s)
[184.366215] [046/130] (836s left) prime_busy (hang)
[184.454491] Starting subtest: hang
[184.455206] Starting dynamic subtest: rcs0
[198.752933] Dynamic subtest rcs0: SUCCESS (14.289s)
[198.760087] Starting dynamic subtest: bcs0
[205.562100] Dynamic subtest bcs0: SUCCESS (6.782s)
[205.569463] Starting dynamic subtest: vcs0
[212.602067] Dynamic subtest vcs0: SUCCESS (7.039s)
[212.610595] Starting dynamic subtest: vcs1
[219.579467] Dynamic subtest vcs1: SUCCESS (6.975s)
[219.586786] Starting dynamic subtest: vecs0
[226.618717] Dynamic subtest vecs0: SUCCESS (7.039s)
[226.619646] Subtest hang: SUCCESS (42.129s)
[226.716188] [047/130] (794s left) kms_psr (fbc-psr2-no-drrs)
[226.807148] Subtest fbc-psr2-no-drrs: SKIP (0.000s)
[226.849624] [048/130] (794s left) kms_vrr (flip-suspend)
[226.937143] Starting subtest: flip-suspend
[226.939236] Subtest flip-suspend: SKIP (0.000s)
[227.014045] [049/130] (794s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[227.052702] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[227.053378] Starting dynamic subtest: smem
[227.156291] Dynamic subtest smem: SUCCESS (0.104s)
[227.157067] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SUCCESS (0.105s)
[227.361366] [050/130] (794s left) kms_prime (basic-crc-hybrid)
[227.464803] Subtest basic-crc-hybrid: SKIP (0.000s)
[227.568190] [051/130] (793s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[227.657749] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[227.659151] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[227.775624] [052/130] (793s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[227.912766] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[228.001422] [053/130] (793s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[228.093495] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[229.373671] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (1.280s)
[229.548221] [054/130] (792s left) kms_flip (2x-flip-vs-panning)
[229.636046] Starting subtest: 2x-flip-vs-panning
[229.645359] Subtest 2x-flip-vs-panning: SKIP (0.009s)
[229.731354] [055/130] (791s left) gem_mmap_wc (write-gtt-read-wc)
[229.763506] Starting subtest: write-gtt-read-wc
[230.079763] Subtest write-gtt-read-wc: SUCCESS (0.308s)
[230.184297] [056/130] (791s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[230.280272] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[230.965489] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.685s)
[231.114442] [057/130] (790s left) kms_flip (2x-flip-vs-wf_vblank)
[231.198079] Starting subtest: 2x-flip-vs-wf_vblank
[231.207068] Subtest 2x-flip-vs-wf_vblank: SKIP (0.009s)
[231.304981] [058/130] (790s left) perf_pmu (semaphore-wait-idle)
[231.339993] Starting subtest: semaphore-wait-idle
[231.340698] Starting dynamic subtest: rcs0
[231.857891] Dynamic subtest rcs0: SUCCESS (0.509s)
[231.868640] Starting dynamic subtest: bcs0
[232.369063] Dynamic subtest bcs0: SUCCESS (0.510s)
[232.379444] Starting dynamic subtest: vcs0
[232.880446] Dynamic subtest vcs0: SUCCESS (0.510s)
[232.890476] Starting dynamic subtest: vcs1
[233.391227] Dynamic subtest vcs1: SUCCESS (0.510s)
[233.401447] Starting dynamic subtest: vecs0
[233.902019] Dynamic subtest vecs0: SUCCESS (0.510s)
[233.902924] Subtest semaphore-wait-idle: SUCCESS (2.554s)
[233.984676] [059/130] (787s left) i915_pm_rpm (gem-pread)
[235.376949] Starting subtest: gem-pread
[236.757277] Subtest gem-pread: SUCCESS (1.382s)
[236.901418] [060/130] (785s left) gem_exec_fence (long-history)
[237.235031] Starting subtest: long-history
[243.027519] Subtest long-history: SUCCESS (5.784s)
[243.555226] [061/130] (778s left) gem_lmem_swapping (parallel-random-engines)
[243.590589] Subtest parallel-random-engines: SKIP (0.000s)
[243.627814] [062/130] (778s left) syncobj_basic (bad-destroy)
[243.660900] Starting subtest: bad-destroy
[243.661583] Subtest bad-destroy: SUCCESS (0.000s)
[243.753478] [063/130] (778s left) kms_cursor_crc (cursor-offscreen-512x170)
[243.847550] Starting subtest: cursor-offscreen-512x170
[243.848968] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[243.972438] [064/130] (778s left) gem_ctx_persistence (hostile)
[244.008101] Starting subtest: hostile
[254.817240] Subtest hostile: SUCCESS (10.800s)
[254.937305] [065/130] (767s left) gem_exec_reloc (basic-cpu-read)
[254.973697] Starting subtest: basic-cpu-read
[254.978800] Subtest basic-cpu-read: SUCCESS (0.005s)
[255.119681] [066/130] (767s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[255.212756] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[255.254872] [067/130] (766s left) gem_exec_fence (syncobj-timeline-wait)
[255.717741] Starting subtest: syncobj-timeline-wait
[255.733586] Subtest syncobj-timeline-wait: SUCCESS (0.027s)
[255.935630] [068/130] (766s left) prime_mmap (test_userptr)
[255.968858] Starting subtest: test_userptr
[255.969577] Starting dynamic subtest: test_userptr-smem
[255.970351] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[255.971084] Subtest test_userptr: SUCCESS (0.001s)
[256.082564] [069/130] (766s left) gem_exec_store (dword)
[256.123190] Starting subtest: dword
[256.123952] Starting dynamic subtest: rcs0
[256.161955] Dynamic subtest rcs0: SUCCESS (0.038s)
[256.178248] Starting dynamic subtest: bcs0
[256.186051] Dynamic subtest bcs0: SUCCESS (0.023s)
[256.195893] Starting dynamic subtest: vcs0
[256.211365] Dynamic subtest vcs0: SUCCESS (0.024s)
[256.223410] Starting dynamic subtest: vcs1
[256.227995] Dynamic subtest vcs1: SUCCESS (0.016s)
[256.237108] Starting dynamic subtest: vecs0
[256.255586] Dynamic subtest vecs0: SUCCESS (0.027s)
[256.256618] Subtest dword: SUCCESS (0.133s)
[256.450832] [070/130] (765s left) kms_pm_rpm (legacy-planes)
[257.843167] Starting subtest: legacy-planes
[257.844186] Starting dynamic subtest: plane-63
[266.580604] Dynamic subtest plane-63: SUCCESS (8.735s)
[266.591892] Starting dynamic subtest: plane-93
[274.818534] Dynamic subtest plane-93: SUCCESS (8.238s)
[274.831356] Starting dynamic subtest: plane-123
[283.252472] Dynamic subtest plane-123: SUCCESS (8.432s)
[283.270287] Starting dynamic subtest: plane-133
[291.662465] Dynamic subtest plane-133: SUCCESS (8.408s)
[291.675565] Starting dynamic subtest: plane-143
[300.103876] Dynamic subtest plane-143: SUCCESS (8.439s)
[300.122128] Starting dynamic subtest: plane-153
[308.728117] Dynamic subtest plane-153: SUCCESS (8.623s)
[308.729286] Subtest legacy-planes: SUCCESS (50.885s)
[308.921572] [071/130] (713s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[309.009611] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[309.010966] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[309.133278] [072/130] (713s left) kms_psr (fbc-psr-suspend)
[309.217482] Subtest fbc-psr-suspend: SKIP (0.000s)
[309.267904] [073/130] (713s left) kms_big_fb (linear-32bpp-rotate-270)
[309.361613] Starting subtest: linear-32bpp-rotate-270
[309.438423] Subtest linear-32bpp-rotate-270: SKIP (0.076s)
[309.575762] [074/130] (712s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[309.611552] Starting subtest: basic-wc-gtt-noreloc
[309.614575] Subtest basic-wc-gtt-noreloc: SUCCESS (0.003s)
[309.753861] [075/130] (712s left) prime_mmap (test_correct)
[309.785657] Starting subtest: test_correct
[309.786331] Starting dynamic subtest: test_correct-smem
[309.787944] Dynamic subtest test_correct-smem: SUCCESS (0.002s)
[309.788625] Subtest test_correct: SUCCESS (0.003s)
[309.900438] [076/130] (712s left) kms_vblank (accuracy-idle)
[309.984773] Starting subtest: accuracy-idle
[309.985438] Starting dynamic subtest: pipe-A-HDMI-A-1
[311.160190] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.174s)
[311.172779] Starting dynamic subtest: pipe-D-HDMI-A-1
[312.322047] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.156s)
[312.322745] Subtest accuracy-idle: SUCCESS (2.338s)
[312.467311] [077/130] (710s left) perf (invalid-remove-userspace-config)
[312.587617] Starting subtest: invalid-remove-userspace-config
[312.597733] Subtest invalid-remove-userspace-config: SUCCESS (0.010s)
[312.638937] [078/130] (710s left) gem_madvise (dontneed-before-exec)
[312.669934] Starting subtest: dontneed-before-exec
[312.672857] Subtest dontneed-before-exec: SUCCESS (0.003s)
[312.777901] [079/130] (709s left) kms_chamelium_color (ctm-negative)
[312.865358] Subtest ctm-negative: SKIP (0.000s)
[312.911510] [080/130] (709s left) gem_mmap_wc (invalid-flags)
[312.943636] Starting subtest: invalid-flags
[312.944320] Subtest invalid-flags: SUCCESS (0.000s)
[313.071350] [081/130] (709s left) gem_exec_reloc (basic-gtt-wc)
[313.108923] Starting subtest: basic-gtt-wc
[313.114410] Subtest basic-gtt-wc: SUCCESS (0.006s)
[313.256070] [082/130] (709s left) syncobj_timeline (single-wait-all-available-signaled)
[313.290438] Starting subtest: single-wait-all-available-signaled
[313.291134] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[313.380744] [083/130] (709s left) gem_ctx_exec (basic-close-race)
[313.414840] Starting subtest: basic-close-race
[319.102693] Subtest basic-close-race: SUCCESS (5.653s)
[319.199636] [084/130] (703s left) gem_exec_balancer (parallel-out-fence)
[319.357474] Subtest parallel-out-fence: SKIP (0.000s)
[319.455583] [085/130] (703s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[319.542968] Starting subtest: flip-vs-cursor-legacy
[325.797661] Subtest flip-vs-cursor-legacy: SUCCESS (6.253s)
[325.950305] [086/130] (697s left) drm_read (fault-buffer)
[326.056715] Starting subtest: fault-buffer
[326.057501] Subtest fault-buffer: SUCCESS (0.001s)
[326.207674] [087/130] (696s left) gem_mmap_wc (pf-nonblock)
[326.240860] Starting subtest: pf-nonblock
[326.241812] Subtest pf-nonblock: SUCCESS (0.002s)
[326.380767] [088/130] (696s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[326.467678] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[326.469046] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[326.589766] [089/130] (696s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[326.677637] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[326.678997] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[326.798109] [090/130] (696s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[326.884738] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[326.885410] Starting dynamic subtest: pipe-A-valid-mode
[326.940993] Dynamic subtest pipe-A-valid-mode: SKIP (0.055s)
[326.942366] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.057s)
[327.065997] [091/130] (696s left) gem_spin_batch (spin-all-new)
[327.106390] Starting subtest: spin-all-new
[327.117154] Subtest spin-all-new: SUCCESS (0.011s)
[327.322873] [092/130] (695s left) core_sysfs (read-all-entries)
[327.356407] Starting subtest: read-all-entries
[327.359360] Subtest read-all-entries: SUCCESS (0.004s)
[327.442934] [093/130] (695s left) gem_exec_reloc (basic-range-active)
[327.479067] Starting subtest: basic-range-active
[327.514535] Subtest basic-range-active: SUCCESS (0.035s)
[327.642403] [094/130] (695s left) syncobj_timeline (single-wait-all-signaled)
[327.674673] Starting subtest: single-wait-all-signaled
[327.675367] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[327.759885] [095/130] (695s left) gen7_exec_parse (basic-offset)
[327.795437] Subtest basic-offset: SKIP (0.000s)
[327.835009] [096/130] (695s left) gem_ctx_shared (q-out-order)
[327.875744] Starting subtest: Q-out-order
[327.876483] Starting dynamic subtest: rcs0
[327.923413] Dynamic subtest rcs0: SUCCESS (0.048s)
[327.936373] Starting dynamic subtest: bcs0
[327.978730] Dynamic subtest bcs0: SUCCESS (0.052s)
[327.991820] Starting dynamic subtest: vcs0
[328.033889] Dynamic subtest vcs0: SUCCESS (0.053s)
[328.047380] Starting dynamic subtest: vcs1
[328.087226] Dynamic subtest vcs1: SUCCESS (0.050s)
[328.100465] Starting dynamic subtest: vecs0
[328.138687] Dynamic subtest vecs0: SUCCESS (0.050s)
[328.139629] Subtest Q-out-order: SUCCESS (0.264s)
[328.342838] [097/130] (695s left) gem_exec_flush (basic-batch-kernel-default-wb)
[328.383311] Starting subtest: basic-batch-kernel-default-wb
[333.974213] Subtest basic-batch-kernel-default-wb: SUCCESS (5.591s)
[334.197946] [098/130] (689s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[334.288766] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[334.290158] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[334.397270] [099/130] (689s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[334.485962] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[334.529443] [100/130] (689s left) kms_psr2_su (page_flip-xrgb8888)
[334.563337] Subtest page_flip-XRGB8888: SKIP (0.000s)
[334.603792] [101/130] (689s left) kms_psr (psr-basic)
[334.688598] Subtest psr-basic: SKIP (0.000s)
[334.728458] [102/130] (688s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[334.816578] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[334.817920] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[334.930624] [103/130] (688s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[335.024703] Starting subtest: yf-tiled-8bpp-rotate-90
[335.026103] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[335.155888] [104/130] (688s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[335.252924] Starting subtest: yf-tiled-16bpp-rotate-90
[335.254265] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[335.372539] [105/130] (688s left) kms_flip (flip-vs-blocking-wf-vblank)
[335.456718] Starting subtest: flip-vs-blocking-wf-vblank
[335.459127] Starting dynamic subtest: A-HDMI-A1
[343.274245] Dynamic subtest A-HDMI-A1: SUCCESS (7.815s)
[343.288595] Starting dynamic subtest: B-HDMI-A1
[351.099354] Dynamic subtest B-HDMI-A1: SUCCESS (7.796s)
[351.106764] Starting dynamic subtest: C-HDMI-A1
[358.870533] Dynamic subtest C-HDMI-A1: SUCCESS (7.794s)
[358.879549] Starting dynamic subtest: D-HDMI-A1
[366.681564] Dynamic subtest D-HDMI-A1: SUCCESS (7.806s)
[366.682266] Subtest flip-vs-blocking-wf-vblank: SUCCESS (31.224s)
[366.848013] [106/130] (657s left) gem_userptr_blits (stress-purge)
[366.893098] Starting subtest: stress-purge
[372.292034] Subtest stress-purge: SUCCESS (5.398s)
[372.428154] [107/130] (651s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[372.510389] Starting subtest: no-spare-fences-busy-interruptible
[374.694551] Subtest no-spare-fences-busy-interruptible: SUCCESS (2.184s)
[374.839818] [108/130] (649s left) gem_exec_balancer (nop)
[374.881693] Starting subtest: nop
[413.062426] Subtest nop: SUCCESS (38.181s)
[413.277235] [109/130] (610s left) gem_eio (in-flight-external)
[413.320128] Starting subtest: in-flight-external
[413.588380] Subtest in-flight-external: SUCCESS (0.267s)
[413.742605] [110/130] (610s left) kms_flip (2x-blocking-absolute-wf_vblank)
[413.827669] Starting subtest: 2x-blocking-absolute-wf_vblank
[413.836302] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.009s)
[413.962700] [111/130] (610s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[414.051399] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[414.061089] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.009s)
[414.150512] [112/130] (609s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[414.240807] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[414.242128] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[414.343943] [113/130] (609s left) kms_atomic (plane-cursor-legacy)
[414.430291] Starting subtest: plane-cursor-legacy
[414.431045] Starting dynamic subtest: pipe-A-HDMI-A-1
[414.586248] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.155s)
[414.587014] Subtest plane-cursor-legacy: SUCCESS (0.157s)
[414.743134] [114/130] (609s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[414.829974] Starting subtest: bad-aux-stride-y-tiled-ccs
[414.830764] Starting dynamic subtest: pipe-A-HDMI-A-1
[414.837237] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[414.845559] Starting dynamic subtest: pipe-B-HDMI-A-1
[414.852196] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[414.860387] Starting dynamic subtest: pipe-C-HDMI-A-1
[414.866831] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[414.874990] Starting dynamic subtest: pipe-D-HDMI-A-1
[414.881780] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[414.883110] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.007s)
[415.089675] [115/130] (609s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[415.177876] Starting subtest: stress-xrgb8888-xtiled
[421.713343] Subtest stress-xrgb8888-xtiled: SUCCESS (6.536s)
[421.859928] [116/130] (602s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[421.950953] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[421.951962] Starting dynamic subtest: pipe-A
[422.065660] Dynamic subtest pipe-A: SUCCESS (0.115s)
[422.075322] Starting dynamic subtest: pipe-B
[422.190920] Dynamic subtest pipe-B: SUCCESS (0.124s)
[422.204692] Starting dynamic subtest: pipe-C
[422.316728] Dynamic subtest pipe-C: SUCCESS (0.125s)
[422.326990] Starting dynamic subtest: pipe-D
[422.449745] Dynamic subtest pipe-D: SUCCESS (0.132s)
[422.450425] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SUCCESS (0.500s)
[422.637605] [117/130] (601s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[422.725457] Starting subtest: fbc-shrfb-scaledprimary
[425.577272] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.852s)
[425.735651] [118/130] (598s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[425.835202] Starting subtest: x-tiled-64bpp-rotate-270
[425.875461] Subtest x-tiled-64bpp-rotate-270: SKIP (0.038s)
[426.018500] [119/130] (598s left) kms_flip (nonexisting-fb-interruptible)
[426.108364] Starting subtest: nonexisting-fb-interruptible
[426.111362] Starting dynamic subtest: A-HDMI-A1
[426.262519] Dynamic subtest A-HDMI-A1: SUCCESS (0.151s)
[426.272815] Starting dynamic subtest: B-HDMI-A1
[426.404977] Dynamic subtest B-HDMI-A1: SUCCESS (0.141s)
[426.414710] Starting dynamic subtest: C-HDMI-A1
[426.547315] Dynamic subtest C-HDMI-A1: SUCCESS (0.141s)
[426.556925] Starting dynamic subtest: D-HDMI-A1
[426.680733] Dynamic subtest D-HDMI-A1: SUCCESS (0.132s)
[426.683395] Subtest nonexisting-fb-interruptible: SUCCESS (0.575s)
[426.884763] [120/130] (597s left) kms_plane_lowres (tiling-4)
[426.973067] Starting subtest: tiling-4
[426.974433] Subtest tiling-4: SKIP (0.000s)
[427.058508] [121/130] (597s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[427.146932] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[427.148345] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[427.255623] [122/130] (597s left) kms_psr (pr-cursor-render)
[427.341195] Subtest pr-cursor-render: SKIP (0.000s)
[427.389697] [123/130] (597s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[427.477423] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[428.583842] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (1.106s)
[428.756670] [124/130] (595s left) kms_cursor_crc (cursor-onscreen-64x21)
[428.849142] Starting subtest: cursor-onscreen-64x21
[428.853795] Starting dynamic subtest: pipe-A-HDMI-A-1
[429.724396] Dynamic subtest pipe-A-HDMI-A-1: FAIL (0.690s)
[429.732997] Starting dynamic subtest: pipe-D-HDMI-A-1
[430.831102] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.250s)
[430.831886] Subtest cursor-onscreen-64x21: FAIL (1.983s)
[430.995371] [125/130] (593s left) perf_pmu (busy-idle-no-semaphores)
[431.033735] Starting subtest: busy-idle-no-semaphores
[431.034404] Starting dynamic subtest: rcs0
[431.682612] Dynamic subtest rcs0: SUCCESS (0.640s)
[431.694425] Starting dynamic subtest: bcs0
[432.308889] Dynamic subtest bcs0: SUCCESS (0.624s)
[432.320336] Starting dynamic subtest: vcs0
[432.935054] Dynamic subtest vcs0: SUCCESS (0.624s)
[432.946278] Starting dynamic subtest: vcs1
[433.563086] Dynamic subtest vcs1: SUCCESS (0.626s)
[433.574197] Starting dynamic subtest: vecs0
[434.190931] Dynamic subtest vecs0: SUCCESS (0.625s)
[434.191915] Subtest busy-idle-no-semaphores: SUCCESS (3.150s)
[434.310463] [126/130] (590s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[434.396972] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[434.397708] Starting dynamic subtest: pipe-A
[435.454029] Dynamic subtest pipe-A: SKIP (1.055s)
[435.463122] Starting dynamic subtest: pipe-B
[436.589740] Dynamic subtest pipe-B: SKIP (1.134s)
[436.601098] Starting dynamic subtest: pipe-C
[437.656668] Dynamic subtest pipe-C: SKIP (1.066s)
[437.665180] Starting dynamic subtest: pipe-D
[438.754705] Dynamic subtest pipe-D: SKIP (1.097s)
[438.763370] Subtest plane-scaler-with-clipping-clamping-rotation: SKIP (4.357s)
[438.959775] [127/130] (585s left) gem_mmap (short-mmap)
[439.002564] Starting subtest: short-mmap
[439.003318] Subtest short-mmap: SUCCESS (0.000s)
[439.105671] [128/130] (585s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[439.197233] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[439.198680] Subtest psr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[439.324627] [129/130] (585s left) gem_ctx_param (invalid-ctx-set)
[439.357934] Starting subtest: invalid-ctx-set
[439.358634] Subtest invalid-ctx-set: SUCCESS (0.000s)
[439.438760] [130/130] (585s left) i915_suspend (basic-s3-without-i915)
[439.472126] Starting subtest: basic-s3-without-i915