[48.969762] Initializing watchdogs
[48.969820]   /dev/watchdog0
[48.985007] [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]
[48.990402] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[48.992841] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[48.994693] [001/130] (960s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[49.087608] Starting subtest: bad-pixel-format-yf-tiled-ccs
[49.089140] Starting dynamic subtest: pipe-A-HDMI-A-1
[49.096286] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[49.101171] Starting dynamic subtest: pipe-B-HDMI-A-1
[49.107990] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[49.112766] Starting dynamic subtest: pipe-C-HDMI-A-1
[49.119492] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[49.124300] Starting dynamic subtest: pipe-D-HDMI-A-1
[49.131150] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[49.132471] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.005s)
[49.334389] [002/130] (960s left) kms_content_protection (dp-mst-type-0)
[49.427908] Starting subtest: dp-mst-type-0
[49.429252] Subtest dp-mst-type-0: SKIP (0.000s)
[49.528346] [003/130] (960s left) gem_exec_reloc (basic-cpu-read-active)
[49.565974] Starting subtest: basic-cpu-read-active
[49.696620] Subtest basic-cpu-read-active: SUCCESS (0.122s)
[49.825991] [004/130] (959s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[49.912866] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[49.913873] Starting dynamic subtest: pipe-A-HDMI-A-1
[49.927693] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[49.935140] Starting dynamic subtest: pipe-B-HDMI-A-1
[49.941985] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[49.947090] Starting dynamic subtest: pipe-C-HDMI-A-1
[49.953668] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[49.958406] Starting dynamic subtest: pipe-D-HDMI-A-1
[49.965034] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[49.966336] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.007s)
[50.156793] [005/130] (959s left) gem_mmap_offset (clear)
[50.191154] Starting subtest: clear
[50.194564] Starting dynamic subtest: smem0
[72.098803] Dynamic subtest smem0: SUCCESS (21.907s)
[72.099471] Subtest clear: SUCCESS (21.907s)
[72.244341] [006/130] (937s left) kms_feature_discovery (psr1)
[72.375040] Starting subtest: psr1
[72.376381] Subtest psr1: SKIP (0.000s)
[72.450619] [007/130] (937s left) kms_cursor_legacy (torture-move)
[72.536565] Starting subtest: torture-move
[72.537307] Starting dynamic subtest: pipe-A
[78.041154] Dynamic subtest pipe-A: SUCCESS (5.470s)
[78.051378] Starting dynamic subtest: pipe-B
[83.494572] Dynamic subtest pipe-B: SUCCESS (5.478s)
[83.500956] Starting dynamic subtest: pipe-C
[88.967873] Dynamic subtest pipe-C: SUCCESS (5.447s)
[88.974887] Starting dynamic subtest: pipe-D
[94.412308] Dynamic subtest pipe-D: SUCCESS (5.444s)
[94.419907] Starting dynamic subtest: all-pipes
[99.903571] Dynamic subtest all-pipes: SUCCESS (5.490s)
[99.904485] Subtest torture-move: SUCCESS (27.330s)
[99.977718] [008/130] (909s left) gem_softpin (evict-snoop)
[100.020372] Starting subtest: evict-snoop
[100.021851] Subtest evict-snoop: SKIP (0.000s)
[100.104512] [009/130] (909s left) gem_ppgtt (blt-vs-render-ctxn)
[100.141242] Starting subtest: blt-vs-render-ctxN
[132.658232] Subtest blt-vs-render-ctxN: SUCCESS (32.507s)
[132.785997] [010/130] (877s left) prime_vgem (fence-read-hang)
[132.949980] Subtest fence-read-hang: SKIP (0.000s)
[133.079027] [FACT prime_vgem (fence-read-hang)] new: kernel.kmod_is_loaded.vgem: true
[133.080512] [011/130] (876s left) i915_drm_fdinfo (memory-info-shared)
[133.114401] Starting subtest: memory-info-shared
[133.115103] Starting dynamic subtest: smem0
[133.158617] Dynamic subtest smem0: SUCCESS (0.044s)
[133.159311] Subtest memory-info-shared: SUCCESS (0.044s)
[133.240916] [012/130] (876s left) gem_exec_schedule (timeslicing)
[133.282978] Starting subtest: timeslicing
[133.283728] Starting dynamic subtest: rcs0
[133.286081] Dynamic subtest rcs0: SUCCESS (0.003s)
[133.293691] Starting dynamic subtest: bcs0
[133.294372] Dynamic subtest bcs0: SUCCESS (0.003s)
[133.300847] Starting dynamic subtest: vcs0
[133.301531] Dynamic subtest vcs0: SUCCESS (0.002s)
[133.307602] Starting dynamic subtest: vcs1
[133.308282] Dynamic subtest vcs1: SUCCESS (0.002s)
[133.314264] Starting dynamic subtest: vecs0
[133.314939] Dynamic subtest vecs0: SUCCESS (0.003s)
[133.315589] Subtest timeslicing: SUCCESS (0.015s)
[133.615296] [013/130] (876s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[133.708419] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[133.709788] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[133.830511] [014/130] (876s left) kms_async_flips (alternate-sync-async-flip-atomic)
[133.914643] Starting subtest: alternate-sync-async-flip-atomic
[134.047150] Starting dynamic subtest: pipe-A-HDMI-A-1
[136.162244] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.106s)
[136.289294] Starting dynamic subtest: pipe-B-HDMI-A-1
[138.365420] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.075s)
[138.496245] Starting dynamic subtest: pipe-C-HDMI-A-1
[140.584347] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.086s)
[140.719235] Starting dynamic subtest: pipe-D-HDMI-A-1
[142.825299] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.105s)
[142.826517] Subtest alternate-sync-async-flip-atomic: SUCCESS (8.902s)
[143.071501] [015/130] (866s left) api_intel_bb (simple-bb)
[143.106161] Starting subtest: simple-bb
[143.109207] Subtest simple-bb: SUCCESS (0.003s)
[143.237506] [016/130] (866s left) i915_hangman (engine-engine-error)
[143.278635] Starting subtest: engine-engine-error
[143.279392] Starting dynamic subtest: rcs0
[143.363995] Dynamic subtest rcs0: SUCCESS (0.085s)
[143.381144] Starting dynamic subtest: bcs0
[143.458874] Dynamic subtest bcs0: SUCCESS (0.094s)
[143.476140] Starting dynamic subtest: vcs0
[143.550215] Dynamic subtest vcs0: SUCCESS (0.090s)
[143.567503] Starting dynamic subtest: vcs1
[143.631927] Dynamic subtest vcs1: SUCCESS (0.081s)
[143.649333] Starting dynamic subtest: vecs0
[143.723071] Dynamic subtest vecs0: SUCCESS (0.090s)
[143.724262] Subtest engine-engine-error: SUCCESS (0.445s)
[143.855408] [017/130] (866s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[143.954332] Starting subtest: verify-pxp-execution-after-suspend-resume
[151.080956] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.127s)
[160.248572] [018/130] (858s left) syncobj_eventfd (timeline-wait)
[160.292168] Starting subtest: timeline-wait
[160.302787] Subtest timeline-wait: SUCCESS (0.010s)
[160.477622] [019/130] (858s left) gem_busy (extended)
[160.651034] Starting subtest: extended
[160.652037] Starting dynamic subtest: rcs0
[160.688238] Dynamic subtest rcs0: SUCCESS (0.046s)
[160.703751] Starting dynamic subtest: bcs0
[160.710179] Dynamic subtest bcs0: SUCCESS (0.021s)
[160.721819] Starting dynamic subtest: vcs0
[160.733298] Dynamic subtest vcs0: SUCCESS (0.023s)
[160.744637] Starting dynamic subtest: vcs1
[160.759590] Dynamic subtest vcs1: SUCCESS (0.026s)
[160.772156] Starting dynamic subtest: vecs0
[160.789198] Dynamic subtest vecs0: SUCCESS (0.027s)
[160.790261] Subtest extended: SUCCESS (0.145s)
[161.041113] [020/130] (858s left) syncobj_timeline (invalid-transfer-illegal-handle)
[161.073835] Starting subtest: invalid-transfer-illegal-handle
[161.074526] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[161.164803] [021/130] (858s left) gem_ctx_freq (sysfs)
[161.200998] Starting subtest: sysfs
[161.201733] Starting dynamic subtest: gt0
[166.197295] Dynamic subtest gt0: SUCCESS (4.996s)
[166.198206] Subtest sysfs: SUCCESS (4.997s)
[166.281642] [022/130] (853s left) kms_chamelium_edid (hdmi-edid-read)
[166.417911] Subtest hdmi-edid-read: SKIP (0.000s)
[166.508014] [023/130] (853s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[166.594240] Starting subtest: short-flip-before-cursor-toggle
[167.136188] Subtest short-flip-before-cursor-toggle: SUCCESS (0.542s)
[167.283297] [024/130] (852s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[167.371489] Starting subtest: cursor-rapid-movement-64x64
[167.376186] Starting dynamic subtest: pipe-A-HDMI-A-1
[167.632545] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.256s)
[167.669895] Starting dynamic subtest: pipe-D-HDMI-A-1
[167.876615] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.217s)
[167.877358] Subtest cursor-rapid-movement-64x64: SUCCESS (0.506s)
[168.058118] [025/130] (851s left) gem_exec_flush (basic-wb-prw-default)
[168.098104] Starting subtest: basic-wb-prw-default
[173.528229] Subtest basic-wb-prw-default: SUCCESS (5.430s)
[173.745477] [026/130] (845s left) kms_invalid_mode (bad-vtotal)
[173.831376] Starting subtest: bad-vtotal
[173.832111] Starting dynamic subtest: pipe-A-HDMI-A-1
[173.881556] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.050s)
[173.892533] Starting dynamic subtest: pipe-B-HDMI-A-1
[173.893309] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[173.902587] Starting dynamic subtest: pipe-C-HDMI-A-1
[173.903309] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[173.912961] Starting dynamic subtest: pipe-D-HDMI-A-1
[173.913724] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[173.914424] Subtest bad-vtotal: SUCCESS (0.060s)
[174.051254] [027/130] (845s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[174.085506] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[174.086938] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s)
[174.170610] [028/130] (845s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[174.257415] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[174.258760] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[174.353181] [029/130] (845s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[174.444030] Starting subtest: primary-yf-tiled-reflect-x-270
[174.499811] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.055s)
[174.606454] [030/130] (845s left) gem_exec_schedule (preempt-queue-chain)
[174.649862] Starting subtest: preempt-queue-chain
[174.650532] Starting dynamic subtest: rcs0
[174.794040] Dynamic subtest rcs0: SUCCESS (0.135s)
[174.802238] Starting dynamic subtest: bcs0
[174.930612] Dynamic subtest bcs0: SUCCESS (0.136s)
[174.938920] Starting dynamic subtest: vcs0
[175.064758] Dynamic subtest vcs0: SUCCESS (0.133s)
[175.073554] Starting dynamic subtest: vcs1
[175.186898] Dynamic subtest vcs1: SUCCESS (0.131s)
[175.197899] Starting dynamic subtest: vecs0
[175.339403] Dynamic subtest vecs0: SUCCESS (0.144s)
[175.340179] Subtest preempt-queue-chain: SUCCESS (0.681s)
[175.649290] [031/130] (844s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[175.738493] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[175.739865] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[175.848672] [032/130] (844s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[175.932717] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[175.934056] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[176.116801] [033/130] (843s left) gem_exec_reloc (basic-cpu-active)
[176.156176] Starting subtest: basic-cpu-active
[176.283838] Subtest basic-cpu-active: SUCCESS (0.119s)
[176.423524] [034/130] (843s left) kms_lease (multimaster-lease)
[176.508037] Starting subtest: multimaster-lease
[176.510686] Subtest multimaster-lease: SUCCESS (0.003s)
[176.589749] [035/130] (843s left) kms_dp_linktrain_fallback (dsc-fallback)
[176.672641] Starting subtest: dsc-fallback
[176.674651] Subtest dsc-fallback: SKIP (0.000s)
[176.748916] [036/130] (843s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[176.833726] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[176.834413] Starting dynamic subtest: pipe-A-HDMI-A-1
[176.841063] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[176.848974] Starting dynamic subtest: pipe-B-HDMI-A-1
[176.855710] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[176.863366] Starting dynamic subtest: pipe-C-HDMI-A-1
[176.870067] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[176.877576] Starting dynamic subtest: pipe-D-HDMI-A-1
[176.884413] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[176.885844] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SKIP (0.005s)
[177.081632] [037/130] (843s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[177.168367] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[177.169725] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[177.278108] [038/130] (842s left) kms_psr (psr-primary-page-flip)
[177.363364] Subtest psr-primary-page-flip: SKIP (0.000s)
[177.401933] [039/130] (842s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[177.497358] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[177.498773] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[177.611145] [040/130] (842s left) kms_getfb (getfb2-handle-closed)
[177.696057] Starting subtest: getfb2-handle-closed
[177.696797] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[177.813212] [041/130] (842s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[177.900577] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[177.901956] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[178.021126] [042/130] (842s left) gem_lmem_swapping (heavy-verify-random)
[178.056918] Subtest heavy-verify-random: SKIP (0.000s)
[178.101913] [043/130] (842s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[178.189621] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[178.191049] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[178.302961] [044/130] (842s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[178.391658] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[178.393038] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[178.511501] [045/130] (841s left) gem_exec_gttfill (basic)
[178.553045] Starting subtest: basic
[181.822894] Subtest basic: SUCCESS (3.270s)
[182.023699] [046/130] (838s left) prime_busy (hang)
[182.117515] Starting subtest: hang
[182.118222] Starting dynamic subtest: rcs0
[195.708982] Dynamic subtest rcs0: SUCCESS (13.555s)
[195.716767] Starting dynamic subtest: bcs0
[202.618176] Dynamic subtest bcs0: SUCCESS (6.911s)
[202.625742] Starting dynamic subtest: vcs0
[209.594214] Dynamic subtest vcs0: SUCCESS (6.975s)
[209.601694] Starting dynamic subtest: vcs1
[216.572214] Dynamic subtest vcs1: SUCCESS (6.976s)
[216.579792] Starting dynamic subtest: vecs0
[223.610678] Dynamic subtest vecs0: SUCCESS (7.039s)
[223.611608] Subtest hang: SUCCESS (41.460s)
[223.723821] [047/130] (796s left) kms_psr (fbc-psr2-no-drrs)
[223.814355] Subtest fbc-psr2-no-drrs: SKIP (0.000s)
[223.857690] [048/130] (796s left) kms_vrr (flip-suspend)
[223.943393] Starting subtest: flip-suspend
[223.945323] Subtest flip-suspend: SKIP (0.000s)
[224.032770] [049/130] (796s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[224.070271] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[224.070972] Starting dynamic subtest: smem
[224.174510] Dynamic subtest smem: SUCCESS (0.104s)
[224.175211] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SUCCESS (0.104s)
[224.378026] [050/130] (796s left) kms_prime (basic-crc-hybrid)
[224.480190] Subtest basic-crc-hybrid: SKIP (0.000s)
[224.584669] [051/130] (796s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[224.674611] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[224.676006] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[224.793634] [052/130] (795s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[224.931376] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[225.027073] [053/130] (795s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[225.118647] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[226.416485] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (1.298s)
[226.582583] [054/130] (794s left) kms_flip (2x-flip-vs-panning)
[226.669290] Starting subtest: 2x-flip-vs-panning
[226.678716] Subtest 2x-flip-vs-panning: SKIP (0.009s)
[226.771092] [055/130] (794s left) gem_mmap_wc (write-gtt-read-wc)
[226.804508] Starting subtest: write-gtt-read-wc
[227.122018] Subtest write-gtt-read-wc: SUCCESS (0.309s)
[227.220518] [056/130] (793s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[227.316299] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[227.966795] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.650s)
[228.116095] [057/130] (792s left) kms_flip (2x-flip-vs-wf_vblank)
[228.200342] Starting subtest: 2x-flip-vs-wf_vblank
[228.209711] Subtest 2x-flip-vs-wf_vblank: SKIP (0.009s)
[228.306143] [058/130] (792s left) perf_pmu (semaphore-wait-idle)
[228.341459] Starting subtest: semaphore-wait-idle
[228.342183] Starting dynamic subtest: rcs0
[228.858802] Dynamic subtest rcs0: SUCCESS (0.508s)
[228.869471] Starting dynamic subtest: bcs0
[229.370116] Dynamic subtest bcs0: SUCCESS (0.510s)
[229.385686] Starting dynamic subtest: vcs0
[229.880725] Dynamic subtest vcs0: SUCCESS (0.510s)
[229.891498] Starting dynamic subtest: vcs1
[230.391804] Dynamic subtest vcs1: SUCCESS (0.510s)
[230.402428] Starting dynamic subtest: vecs0
[230.902829] Dynamic subtest vecs0: SUCCESS (0.510s)
[230.903771] Subtest semaphore-wait-idle: SUCCESS (2.553s)
[231.016901] [059/130] (790s left) i915_pm_rpm (gem-pread)
[232.411432] Starting subtest: gem-pread
[233.802295] Subtest gem-pread: SUCCESS (1.390s)
[233.923890] [060/130] (787s left) gem_exec_fence (long-history)
[234.252207] Starting subtest: long-history
[240.035485] Subtest long-history: SUCCESS (5.775s)
[240.566300] [061/130] (780s left) gem_lmem_swapping (parallel-random-engines)
[240.601207] Subtest parallel-random-engines: SKIP (0.000s)
[240.645230] [062/130] (780s left) syncobj_basic (bad-destroy)
[240.676702] Starting subtest: bad-destroy
[240.677412] Subtest bad-destroy: SUCCESS (0.000s)
[240.761688] [063/130] (780s left) kms_cursor_crc (cursor-offscreen-512x170)
[240.855069] Starting subtest: cursor-offscreen-512x170
[240.856458] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[240.971860] [064/130] (780s left) gem_ctx_persistence (hostile)
[241.009097] Starting subtest: hostile
[251.745244] Subtest hostile: SUCCESS (10.728s)
[251.860375] [065/130] (769s left) gem_exec_reloc (basic-cpu-read)
[251.896767] Starting subtest: basic-cpu-read
[251.902050] Subtest basic-cpu-read: SUCCESS (0.005s)
[252.044314] [066/130] (769s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[252.132697] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[252.173054] [067/130] (769s left) gem_exec_fence (syncobj-timeline-wait)
[252.630655] Starting subtest: syncobj-timeline-wait
[252.644364] Subtest syncobj-timeline-wait: SUCCESS (0.022s)
[252.841797] [068/130] (768s left) prime_mmap (test_userptr)
[252.874931] Starting subtest: test_userptr
[252.875650] Starting dynamic subtest: test_userptr-smem
[252.876337] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[252.877031] Subtest test_userptr: SUCCESS (0.001s)
[252.982770] [069/130] (768s left) gem_exec_store (dword)
[253.023594] Starting subtest: dword
[253.024296] Starting dynamic subtest: rcs0
[253.075912] Dynamic subtest rcs0: SUCCESS (0.052s)
[253.094441] Starting dynamic subtest: bcs0
[253.103472] Dynamic subtest bcs0: SUCCESS (0.027s)
[253.116422] Starting dynamic subtest: vcs0
[253.125145] Dynamic subtest vcs0: SUCCESS (0.021s)
[253.135372] Starting dynamic subtest: vcs1
[253.148051] Dynamic subtest vcs1: SUCCESS (0.022s)
[253.158814] Starting dynamic subtest: vecs0
[253.166143] Dynamic subtest vecs0: SUCCESS (0.017s)
[253.166892] Subtest dword: SUCCESS (0.144s)
[253.366787] [070/130] (768s left) kms_pm_rpm (legacy-planes)
[254.762807] Starting subtest: legacy-planes
[254.763793] Starting dynamic subtest: plane-63
[263.282337] Dynamic subtest plane-63: SUCCESS (8.521s)
[263.301377] Starting dynamic subtest: plane-93
[271.638044] Dynamic subtest plane-93: SUCCESS (8.354s)
[271.649066] Starting dynamic subtest: plane-123
[279.959079] Dynamic subtest plane-123: SUCCESS (8.320s)
[279.970300] Starting dynamic subtest: plane-133
[288.694200] Dynamic subtest plane-133: SUCCESS (8.734s)
[288.707068] Starting dynamic subtest: plane-143
[297.016213] Dynamic subtest plane-143: SUCCESS (8.320s)
[297.029199] Starting dynamic subtest: plane-153
[305.547806] Dynamic subtest plane-153: SUCCESS (8.530s)
[305.548843] Subtest legacy-planes: SUCCESS (50.789s)
[305.740374] [071/130] (715s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[305.832686] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[305.834037] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[305.953139] [072/130] (715s left) kms_psr (fbc-psr-suspend)
[306.036521] Subtest fbc-psr-suspend: SKIP (0.000s)
[306.075455] [073/130] (715s left) kms_big_fb (linear-32bpp-rotate-270)
[306.168296] Starting subtest: linear-32bpp-rotate-270
[306.239418] Subtest linear-32bpp-rotate-270: SKIP (0.070s)
[306.377675] [074/130] (715s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[306.414202] Starting subtest: basic-wc-gtt-noreloc
[306.416707] Subtest basic-wc-gtt-noreloc: SUCCESS (0.002s)
[306.552779] [075/130] (715s left) prime_mmap (test_correct)
[306.585477] Starting subtest: test_correct
[306.586167] Starting dynamic subtest: test_correct-smem
[306.588604] Dynamic subtest test_correct-smem: SUCCESS (0.003s)
[306.589282] Subtest test_correct: SUCCESS (0.004s)
[306.702101] [076/130] (715s left) kms_vblank (accuracy-idle)
[306.787804] Starting subtest: accuracy-idle
[306.789426] Starting dynamic subtest: pipe-A-HDMI-A-1
[307.969266] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.180s)
[307.982981] Starting dynamic subtest: pipe-D-HDMI-A-1
[309.141774] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.168s)
[309.142506] Subtest accuracy-idle: SUCCESS (2.355s)
[309.316627] [077/130] (712s left) perf (invalid-remove-userspace-config)
[309.426871] Starting subtest: invalid-remove-userspace-config
[309.436615] Subtest invalid-remove-userspace-config: SUCCESS (0.010s)
[309.480850] [078/130] (712s left) gem_madvise (dontneed-before-exec)
[309.511967] Starting subtest: dontneed-before-exec
[309.514459] Subtest dontneed-before-exec: SUCCESS (0.003s)
[309.645419] [079/130] (712s left) kms_chamelium_color (ctm-negative)
[309.732409] Subtest ctm-negative: SKIP (0.000s)
[309.777716] [080/130] (712s left) gem_mmap_wc (invalid-flags)
[309.809495] Starting subtest: invalid-flags
[309.810292] Subtest invalid-flags: SUCCESS (0.000s)
[309.913207] [081/130] (712s left) gem_exec_reloc (basic-gtt-wc)
[309.948760] Starting subtest: basic-gtt-wc
[309.955049] Subtest basic-gtt-wc: SUCCESS (0.006s)
[310.090211] [082/130] (711s left) syncobj_timeline (single-wait-all-available-signaled)
[310.123307] Starting subtest: single-wait-all-available-signaled
[310.123992] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[310.211078] [083/130] (711s left) gem_ctx_exec (basic-close-race)
[310.244655] Starting subtest: basic-close-race
[315.883636] Subtest basic-close-race: SUCCESS (5.604s)
[315.982051] [084/130] (706s left) gem_exec_balancer (parallel-out-fence)
[316.135726] Subtest parallel-out-fence: SKIP (0.000s)
[316.229862] [085/130] (705s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[316.319709] Starting subtest: flip-vs-cursor-legacy
[322.571159] Subtest flip-vs-cursor-legacy: SUCCESS (6.252s)
[322.720713] [086/130] (699s left) drm_read (fault-buffer)
[322.833458] Starting subtest: fault-buffer
[322.834173] Subtest fault-buffer: SUCCESS (0.001s)
[322.973958] [087/130] (699s left) gem_mmap_wc (pf-nonblock)
[323.005685] Starting subtest: pf-nonblock
[323.007368] Subtest pf-nonblock: SUCCESS (0.002s)
[323.157523] [088/130] (699s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[323.244586] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[323.245915] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[323.365465] [089/130] (698s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[323.452546] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[323.453913] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[323.573025] [090/130] (698s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[323.656905] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[323.658631] Starting dynamic subtest: pipe-A-valid-mode
[323.708850] Dynamic subtest pipe-A-valid-mode: SKIP (0.050s)
[323.710169] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.052s)
[323.830422] [091/130] (698s left) gem_spin_batch (spin-all-new)
[323.872339] Starting subtest: spin-all-new
[323.883053] Subtest spin-all-new: SUCCESS (0.011s)
[324.082631] [092/130] (698s left) core_sysfs (read-all-entries)
[324.116427] Starting subtest: read-all-entries
[324.119749] Subtest read-all-entries: SUCCESS (0.004s)
[324.196591] [093/130] (698s left) gem_exec_reloc (basic-range-active)
[324.232700] Starting subtest: basic-range-active
[324.270109] Subtest basic-range-active: SUCCESS (0.037s)
[324.406605] [094/130] (698s left) syncobj_timeline (single-wait-all-signaled)
[324.438624] Starting subtest: single-wait-all-signaled
[324.439315] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[324.531815] [095/130] (697s left) gen7_exec_parse (basic-offset)
[324.567949] Subtest basic-offset: SKIP (0.000s)
[324.614756] [096/130] (697s left) gem_ctx_shared (q-out-order)
[324.655179] Starting subtest: Q-out-order
[324.655889] Starting dynamic subtest: rcs0
[324.703710] Dynamic subtest rcs0: SUCCESS (0.048s)
[324.715865] Starting dynamic subtest: bcs0
[324.753803] Dynamic subtest bcs0: SUCCESS (0.048s)
[324.766625] Starting dynamic subtest: vcs0
[324.805355] Dynamic subtest vcs0: SUCCESS (0.050s)
[324.815625] Starting dynamic subtest: vcs1
[324.853876] Dynamic subtest vcs1: SUCCESS (0.047s)
[324.868233] Starting dynamic subtest: vecs0
[324.906232] Dynamic subtest vecs0: SUCCESS (0.051s)
[324.907300] Subtest Q-out-order: SUCCESS (0.252s)
[325.109068] [097/130] (697s left) gem_exec_flush (basic-batch-kernel-default-wb)
[325.151734] Starting subtest: basic-batch-kernel-default-wb
[330.704588] Subtest basic-batch-kernel-default-wb: SUCCESS (5.554s)
[330.913657] [098/130] (691s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[331.004785] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[331.006146] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[331.126060] [099/130] (691s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[331.216117] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[331.258226] [100/130] (691s left) kms_psr2_su (page_flip-xrgb8888)
[331.291440] Subtest page_flip-XRGB8888: SKIP (0.000s)
[331.331797] [101/130] (691s left) kms_psr (psr-basic)
[331.417650] Subtest psr-basic: SKIP (0.000s)
[331.458446] [102/130] (691s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[331.546937] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[331.548376] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[331.666576] [103/130] (691s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[331.762110] Starting subtest: yf-tiled-8bpp-rotate-90
[331.763464] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[331.876338] [104/130] (691s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[331.970128] Starting subtest: yf-tiled-16bpp-rotate-90
[331.971490] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[332.092912] [105/130] (690s left) kms_flip (flip-vs-blocking-wf-vblank)
[332.177506] Starting subtest: flip-vs-blocking-wf-vblank
[332.180098] Starting dynamic subtest: A-HDMI-A1
[340.008220] Dynamic subtest A-HDMI-A1: SUCCESS (7.810s)
[340.015931] Starting dynamic subtest: B-HDMI-A1
[347.825761] Dynamic subtest B-HDMI-A1: SUCCESS (7.806s)
[347.833993] Starting dynamic subtest: C-HDMI-A1
[355.614268] Dynamic subtest C-HDMI-A1: SUCCESS (7.788s)
[355.622123] Starting dynamic subtest: D-HDMI-A1
[363.384212] Dynamic subtest D-HDMI-A1: SUCCESS (7.791s)
[363.384887] Subtest flip-vs-blocking-wf-vblank: SUCCESS (31.206s)
[363.542816] [106/130] (659s left) gem_userptr_blits (stress-purge)
[363.587966] Starting subtest: stress-purge
[368.993459] Subtest stress-purge: SUCCESS (5.405s)
[369.126468] [107/130] (653s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[369.207992] Starting subtest: no-spare-fences-busy-interruptible
[371.397139] Subtest no-spare-fences-busy-interruptible: SUCCESS (2.189s)
[371.554577] [108/130] (651s left) gem_exec_balancer (nop)
[371.596373] Starting subtest: nop
[409.814534] Subtest nop: SUCCESS (38.218s)
[410.031363] [109/130] (613s left) gem_eio (in-flight-external)
[410.073588] Starting subtest: in-flight-external
[410.332230] Subtest in-flight-external: SUCCESS (0.257s)
[410.486958] [110/130] (612s left) kms_flip (2x-blocking-absolute-wf_vblank)
[410.573672] Starting subtest: 2x-blocking-absolute-wf_vblank
[410.582543] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.009s)
[410.679343] [111/130] (612s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[410.768286] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[410.778143] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.009s)
[410.869573] [112/130] (612s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[410.959892] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[410.961319] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[411.086982] [113/130] (612s left) kms_atomic (plane-cursor-legacy)
[411.173945] Starting subtest: plane-cursor-legacy
[411.175719] Starting dynamic subtest: pipe-A-HDMI-A-1
[411.328323] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.153s)
[411.329070] Subtest plane-cursor-legacy: SUCCESS (0.155s)
[411.486394] [114/130] (611s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[411.575911] Starting subtest: bad-aux-stride-y-tiled-ccs
[411.576612] Starting dynamic subtest: pipe-A-HDMI-A-1
[411.583272] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[411.591631] Starting dynamic subtest: pipe-B-HDMI-A-1
[411.598267] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[411.606529] Starting dynamic subtest: pipe-C-HDMI-A-1
[411.613056] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[411.621574] Starting dynamic subtest: pipe-D-HDMI-A-1
[411.628150] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[411.629451] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.007s)
[411.827240] [115/130] (611s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[411.914709] Starting subtest: stress-xrgb8888-xtiled
[418.302198] Subtest stress-xrgb8888-xtiled: SUCCESS (6.387s)
[418.436942] [116/130] (604s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[418.525916] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[418.526591] Starting dynamic subtest: pipe-A
[418.642221] Dynamic subtest pipe-A: SUCCESS (0.117s)
[418.656268] Starting dynamic subtest: pipe-B
[418.784765] Dynamic subtest pipe-B: SUCCESS (0.142s)
[418.799899] Starting dynamic subtest: pipe-C
[418.911326] Dynamic subtest pipe-C: SUCCESS (0.126s)
[418.929020] Starting dynamic subtest: pipe-D
[419.044642] Dynamic subtest pipe-D: SUCCESS (0.132s)
[419.045397] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SUCCESS (0.520s)
[419.249701] [117/130] (604s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[419.337680] Starting subtest: fbc-shrfb-scaledprimary
[422.171806] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.834s)
[422.324244] [118/130] (601s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[422.423612] Starting subtest: x-tiled-64bpp-rotate-270
[422.469970] Subtest x-tiled-64bpp-rotate-270: SKIP (0.045s)
[422.612715] [119/130] (600s left) kms_flip (nonexisting-fb-interruptible)
[422.704703] Starting subtest: nonexisting-fb-interruptible
[422.706598] Starting dynamic subtest: A-HDMI-A1
[422.860296] Dynamic subtest A-HDMI-A1: SUCCESS (0.154s)
[422.870985] Starting dynamic subtest: B-HDMI-A1
[422.993039] Dynamic subtest B-HDMI-A1: SUCCESS (0.131s)
[423.005843] Starting dynamic subtest: C-HDMI-A1
[423.122610] Dynamic subtest C-HDMI-A1: SUCCESS (0.128s)
[423.132457] Starting dynamic subtest: D-HDMI-A1
[423.251739] Dynamic subtest D-HDMI-A1: SUCCESS (0.128s)
[423.254408] Subtest nonexisting-fb-interruptible: SUCCESS (0.551s)
[423.456927] [120/130] (600s left) kms_plane_lowres (tiling-4)
[423.542051] Starting subtest: tiling-4
[423.543453] Subtest tiling-4: SKIP (0.000s)
[423.627527] [121/130] (599s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[423.715215] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[423.716654] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[423.851892] [122/130] (599s left) kms_psr (pr-cursor-render)
[423.936793] Subtest pr-cursor-render: SKIP (0.000s)
[423.983661] [123/130] (599s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[424.071822] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[425.229171] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (1.157s)
[425.376230] [124/130] (598s left) kms_cursor_crc (cursor-onscreen-64x21)
[425.469913] Starting subtest: cursor-onscreen-64x21
[425.474971] Starting dynamic subtest: pipe-A-HDMI-A-1
[426.381046] Dynamic subtest pipe-A-HDMI-A-1: FAIL (0.734s)
[426.392505] Starting dynamic subtest: pipe-D-HDMI-A-1
[427.481159] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.237s)
[427.481934] Subtest cursor-onscreen-64x21: FAIL (2.012s)
[427.632267] [125/130] (596s left) perf_pmu (busy-idle-no-semaphores)
[427.672099] Starting subtest: busy-idle-no-semaphores
[427.672861] Starting dynamic subtest: rcs0
[428.319937] Dynamic subtest rcs0: SUCCESS (0.638s)
[428.331450] Starting dynamic subtest: bcs0
[428.949070] Dynamic subtest bcs0: SUCCESS (0.627s)
[428.960584] Starting dynamic subtest: vcs0
[429.578877] Dynamic subtest vcs0: SUCCESS (0.628s)
[429.590320] Starting dynamic subtest: vcs1
[430.208682] Dynamic subtest vcs1: SUCCESS (0.627s)
[430.220355] Starting dynamic subtest: vecs0
[430.845851] Dynamic subtest vecs0: SUCCESS (0.635s)
[430.846819] Subtest busy-idle-no-semaphores: SUCCESS (3.166s)
[430.968425] [126/130] (592s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[431.057959] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[431.058791] Starting dynamic subtest: pipe-A
[432.104415] Dynamic subtest pipe-A: SKIP (1.045s)
[432.117707] Starting dynamic subtest: pipe-B
[433.214581] Dynamic subtest pipe-B: SKIP (1.110s)
[433.223092] Starting dynamic subtest: pipe-C
[434.310400] Dynamic subtest pipe-C: SKIP (1.093s)
[434.319078] Starting dynamic subtest: pipe-D
[435.407882] Dynamic subtest pipe-D: SKIP (1.097s)
[435.409381] Subtest plane-scaler-with-clipping-clamping-rotation: SKIP (4.349s)
[435.591753] [127/130] (588s left) gem_mmap (short-mmap)
[435.636472] Starting subtest: short-mmap
[435.637177] Subtest short-mmap: SUCCESS (0.000s)
[435.747392] [128/130] (588s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[435.839731] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[435.841101] Subtest psr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[435.957494] [129/130] (587s left) gem_ctx_param (invalid-ctx-set)
[435.991679] Starting subtest: invalid-ctx-set
[435.992412] Subtest invalid-ctx-set: SUCCESS (0.000s)
[436.074482] [130/130] (587s left) i915_suspend (basic-s3-without-i915)
[436.106045] Starting subtest: basic-s3-without-i915