[43.557827] Initializing watchdogs
[43.557888]   /dev/watchdog0
[43.572918] [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]
[43.578428] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[43.580880] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[43.583134] [001/130] (960s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[43.672604] Starting subtest: bad-pixel-format-yf-tiled-ccs
[43.673304] Starting dynamic subtest: pipe-A-HDMI-A-1
[43.679955] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[43.684976] Starting dynamic subtest: pipe-B-HDMI-A-1
[43.691730] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[43.696638] Starting dynamic subtest: pipe-C-HDMI-A-1
[43.703274] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[43.708427] Starting dynamic subtest: pipe-D-HDMI-A-1
[43.715113] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[43.716421] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s)
[43.910953] [002/130] (960s left) kms_content_protection (dp-mst-type-0)
[44.004451] Starting subtest: dp-mst-type-0
[44.005893] Subtest dp-mst-type-0: SKIP (0.000s)
[44.125932] [003/130] (960s left) gem_exec_reloc (basic-cpu-read-active)
[44.165641] Starting subtest: basic-cpu-read-active
[44.295706] Subtest basic-cpu-read-active: SUCCESS (0.121s)
[44.419597] [004/130] (959s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[44.502751] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[44.503463] Starting dynamic subtest: pipe-A-HDMI-A-1
[44.510559] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[44.516970] Starting dynamic subtest: pipe-B-HDMI-A-1
[44.524256] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[44.530582] Starting dynamic subtest: pipe-C-HDMI-A-1
[44.537728] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[44.544116] Starting dynamic subtest: pipe-D-HDMI-A-1
[44.551025] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[44.552382] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.007s)
[44.754613] [005/130] (959s left) gem_mmap_offset (clear)
[44.790036] Starting subtest: clear
[44.792563] Starting dynamic subtest: smem0
[66.785265] Dynamic subtest smem0: SUCCESS (21.985s)
[66.785962] Subtest clear: SUCCESS (21.985s)
[66.925580] [006/130] (937s left) kms_feature_discovery (psr1)
[67.205817] Starting subtest: psr1
[67.207458] Subtest psr1: SKIP (0.000s)
[67.297602] [007/130] (937s left) kms_cursor_legacy (torture-move)
[67.399694] Starting subtest: torture-move
[67.400453] Starting dynamic subtest: pipe-A
[72.994369] Dynamic subtest pipe-A: SUCCESS (5.560s)
[73.003753] Starting dynamic subtest: pipe-B
[78.434423] Dynamic subtest pipe-B: SUCCESS (5.474s)
[78.440447] Starting dynamic subtest: pipe-C
[83.898329] Dynamic subtest pipe-C: SUCCESS (5.456s)
[83.906181] Starting dynamic subtest: pipe-D
[89.375179] Dynamic subtest pipe-D: SUCCESS (5.451s)
[89.382525] Starting dynamic subtest: all-pipes
[94.857469] Dynamic subtest all-pipes: SUCCESS (5.488s)
[94.858467] Subtest torture-move: SUCCESS (27.429s)
[94.910226] [008/130] (909s left) gem_softpin (evict-snoop)
[94.969064] Starting subtest: evict-snoop
[94.970679] Subtest evict-snoop: SKIP (0.000s)
[95.044646] [009/130] (909s left) gem_ppgtt (blt-vs-render-ctxn)
[95.080564] Starting subtest: blt-vs-render-ctxN
[127.560864] Subtest blt-vs-render-ctxN: SUCCESS (32.471s)
[127.702476] [010/130] (876s left) prime_vgem (fence-read-hang)
[127.858205] Subtest fence-read-hang: SKIP (0.000s)
[127.984359] [FACT prime_vgem (fence-read-hang)] new: kernel.kmod_is_loaded.vgem: true
[127.985915] [011/130] (876s left) i915_drm_fdinfo (memory-info-shared)
[128.020539] Starting subtest: memory-info-shared
[128.021321] Starting dynamic subtest: smem0
[128.067705] Dynamic subtest smem0: SUCCESS (0.048s)
[128.068423] Subtest memory-info-shared: SUCCESS (0.048s)
[128.151452] [012/130] (876s left) gem_exec_schedule (timeslicing)
[128.193547] Starting subtest: timeslicing
[128.194347] Starting dynamic subtest: rcs0
[128.197122] Dynamic subtest rcs0: SUCCESS (0.003s)
[128.204389] Starting dynamic subtest: bcs0
[128.205120] Dynamic subtest bcs0: SUCCESS (0.003s)
[128.211460] Starting dynamic subtest: vcs0
[128.212136] Dynamic subtest vcs0: SUCCESS (0.002s)
[128.218194] Starting dynamic subtest: vcs1
[128.218866] Dynamic subtest vcs1: SUCCESS (0.002s)
[128.224912] Starting dynamic subtest: vecs0
[128.225584] Dynamic subtest vecs0: SUCCESS (0.002s)
[128.226244] Subtest timeslicing: SUCCESS (0.015s)
[128.521530] [013/130] (876s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[128.615617] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[128.617012] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[128.744354] [014/130] (875s left) kms_async_flips (alternate-sync-async-flip-atomic)
[128.829482] Starting subtest: alternate-sync-async-flip-atomic
[128.959519] Starting dynamic subtest: pipe-A-HDMI-A-1
[131.063737] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.095s)
[131.188207] Starting dynamic subtest: pipe-B-HDMI-A-1
[133.266489] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.075s)
[133.383286] Starting dynamic subtest: pipe-C-HDMI-A-1
[135.478055] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.091s)
[135.602706] Starting dynamic subtest: pipe-D-HDMI-A-1
[137.694184] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.090s)
[137.695148] Subtest alternate-sync-async-flip-atomic: SUCCESS (8.857s)
[137.962464] [015/130] (866s left) api_intel_bb (simple-bb)
[137.998359] Starting subtest: simple-bb
[138.002386] Subtest simple-bb: SUCCESS (0.004s)
[138.136620] [016/130] (866s left) i915_hangman (engine-engine-error)
[138.177288] Starting subtest: engine-engine-error
[138.177992] Starting dynamic subtest: rcs0
[138.252938] Dynamic subtest rcs0: SUCCESS (0.075s)
[138.268280] Starting dynamic subtest: bcs0
[138.332845] Dynamic subtest bcs0: SUCCESS (0.079s)
[138.347967] Starting dynamic subtest: vcs0
[138.425121] Dynamic subtest vcs0: SUCCESS (0.091s)
[138.440723] Starting dynamic subtest: vcs1
[138.504712] Dynamic subtest vcs1: SUCCESS (0.079s)
[138.519621] Starting dynamic subtest: vecs0
[138.586857] Dynamic subtest vecs0: SUCCESS (0.081s)
[138.587926] Subtest engine-engine-error: SUCCESS (0.410s)
[138.685669] [017/130] (866s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[138.787335] Starting subtest: verify-pxp-execution-after-suspend-resume
[145.948843] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.163s)
[155.118195] [018/130] (858s left) syncobj_eventfd (timeline-wait)
[155.163342] Starting subtest: timeline-wait
[155.173927] Subtest timeline-wait: SUCCESS (0.010s)
[155.256848] [019/130] (858s left) gem_busy (extended)
[155.429287] Starting subtest: extended
[155.430314] Starting dynamic subtest: rcs0
[155.463550] Dynamic subtest rcs0: SUCCESS (0.043s)
[155.480369] Starting dynamic subtest: bcs0
[155.482911] Dynamic subtest bcs0: SUCCESS (0.019s)
[155.491595] Starting dynamic subtest: vcs0
[155.505040] Dynamic subtest vcs0: SUCCESS (0.022s)
[155.516550] Starting dynamic subtest: vcs1
[155.530712] Dynamic subtest vcs1: SUCCESS (0.025s)
[155.543501] Starting dynamic subtest: vecs0
[155.557398] Dynamic subtest vecs0: SUCCESS (0.026s)
[155.558403] Subtest extended: SUCCESS (0.137s)
[155.824347] [020/130] (858s left) syncobj_timeline (invalid-transfer-illegal-handle)
[155.857157] Starting subtest: invalid-transfer-illegal-handle
[155.857935] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[155.948863] [021/130] (858s left) gem_ctx_freq (sysfs)
[155.985453] Starting subtest: sysfs
[155.986153] Starting dynamic subtest: gt0
[161.061238] Dynamic subtest gt0: SUCCESS (5.076s)
[161.062187] Subtest sysfs: SUCCESS (5.076s)
[161.149378] [022/130] (852s left) kms_chamelium_edid (hdmi-edid-read)
[161.290901] Subtest hdmi-edid-read: SKIP (0.000s)
[161.380280] [023/130] (852s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[161.465894] Starting subtest: short-flip-before-cursor-toggle
[162.019256] Subtest short-flip-before-cursor-toggle: SUCCESS (0.553s)
[162.171223] [024/130] (851s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[162.259925] Starting subtest: cursor-rapid-movement-64x64
[162.264666] Starting dynamic subtest: pipe-A-HDMI-A-1
[162.517524] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.253s)
[162.549689] Starting dynamic subtest: pipe-D-HDMI-A-1
[162.747742] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.205s)
[162.748460] Subtest cursor-rapid-movement-64x64: SUCCESS (0.488s)
[162.921937] [025/130] (851s left) gem_exec_flush (basic-wb-prw-default)
[162.963948] Starting subtest: basic-wb-prw-default
[168.395876] Subtest basic-wb-prw-default: SUCCESS (5.432s)
[168.610022] [026/130] (845s left) kms_invalid_mode (bad-vtotal)
[168.696220] Starting subtest: bad-vtotal
[168.696918] Starting dynamic subtest: pipe-A-HDMI-A-1
[168.743990] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.047s)
[168.753040] Starting dynamic subtest: pipe-B-HDMI-A-1
[168.753726] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[168.762636] Starting dynamic subtest: pipe-C-HDMI-A-1
[168.763331] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[168.771897] Starting dynamic subtest: pipe-D-HDMI-A-1
[168.772635] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[168.773372] Subtest bad-vtotal: SUCCESS (0.053s)
[168.916354] [027/130] (845s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[168.951379] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[168.952119] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[169.038910] [028/130] (845s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[169.128322] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[169.129719] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[169.238568] [029/130] (845s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[169.322644] Starting subtest: primary-yf-tiled-reflect-x-270
[169.373446] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.049s)
[169.480318] [030/130] (844s left) gem_exec_schedule (preempt-queue-chain)
[169.522802] Starting subtest: preempt-queue-chain
[169.523478] Starting dynamic subtest: rcs0
[169.660927] Dynamic subtest rcs0: SUCCESS (0.131s)
[169.671329] Starting dynamic subtest: bcs0
[169.798368] Dynamic subtest bcs0: SUCCESS (0.134s)
[169.808654] Starting dynamic subtest: vcs0
[169.933977] Dynamic subtest vcs0: SUCCESS (0.134s)
[169.942734] Starting dynamic subtest: vcs1
[170.068298] Dynamic subtest vcs1: SUCCESS (0.133s)
[170.077577] Starting dynamic subtest: vecs0
[170.204215] Dynamic subtest vecs0: SUCCESS (0.136s)
[170.204986] Subtest preempt-queue-chain: SUCCESS (0.670s)
[170.498763] [031/130] (843s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[170.587816] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[170.589244] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[170.703651] [032/130] (843s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[170.787707] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[170.789032] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[170.959857] [033/130] (843s left) gem_exec_reloc (basic-cpu-active)
[170.999275] Starting subtest: basic-cpu-active
[171.131387] Subtest basic-cpu-active: SUCCESS (0.120s)
[171.270119] [034/130] (843s left) kms_lease (multimaster-lease)
[171.353775] Starting subtest: multimaster-lease
[171.355410] Subtest multimaster-lease: SUCCESS (0.002s)
[171.440419] [035/130] (843s left) kms_dp_linktrain_fallback (dsc-fallback)
[171.525715] Starting subtest: dsc-fallback
[171.527757] Subtest dsc-fallback: SKIP (0.000s)
[171.608436] [036/130] (843s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[171.691663] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[171.692346] Starting dynamic subtest: pipe-A-HDMI-A-1
[171.698949] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[171.706648] Starting dynamic subtest: pipe-B-HDMI-A-1
[171.713214] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[171.720991] Starting dynamic subtest: pipe-C-HDMI-A-1
[171.727589] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[171.735061] Starting dynamic subtest: pipe-D-HDMI-A-1
[171.741886] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[171.743241] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SKIP (0.005s)
[171.945937] [037/130] (842s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[172.032729] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[172.034148] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[172.160552] [038/130] (842s left) kms_psr (psr-primary-page-flip)
[172.245367] Subtest psr-primary-page-flip: SKIP (0.000s)
[172.283973] [039/130] (842s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[172.380849] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[172.382216] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[172.502088] [040/130] (842s left) kms_getfb (getfb2-handle-closed)
[172.586453] Starting subtest: getfb2-handle-closed
[172.587153] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[172.696252] [041/130] (842s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[172.784424] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[172.785756] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[172.910403] [042/130] (841s left) gem_lmem_swapping (heavy-verify-random)
[172.946953] Subtest heavy-verify-random: SKIP (0.000s)
[172.990929] [043/130] (841s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[173.077631] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[173.079056] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[173.176752] [044/130] (841s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[173.263487] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[173.264836] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[173.367446] [045/130] (841s left) gem_exec_gttfill (basic)
[173.408435] Starting subtest: basic
[176.664638] Subtest basic: SUCCESS (3.256s)
[176.881374] [046/130] (838s left) prime_busy (hang)
[176.972823] Starting subtest: hang
[176.973566] Starting dynamic subtest: rcs0
[190.586396] Dynamic subtest rcs0: SUCCESS (13.578s)
[190.593887] Starting dynamic subtest: bcs0
[197.562351] Dynamic subtest bcs0: SUCCESS (6.975s)
[197.571185] Starting dynamic subtest: vcs0
[204.603098] Dynamic subtest vcs0: SUCCESS (7.040s)
[204.612112] Starting dynamic subtest: vcs1
[211.577571] Dynamic subtest vcs1: SUCCESS (6.975s)
[211.586774] Starting dynamic subtest: vecs0
[218.554626] Dynamic subtest vecs0: SUCCESS (6.975s)
[218.555593] Subtest hang: SUCCESS (41.546s)
[218.661673] [047/130] (796s left) kms_psr (fbc-psr2-no-drrs)
[218.753541] Subtest fbc-psr2-no-drrs: SKIP (0.000s)
[218.800299] [048/130] (796s left) kms_vrr (flip-suspend)
[218.886863] Starting subtest: flip-suspend
[218.888980] Subtest flip-suspend: SKIP (0.000s)
[218.969071] [049/130] (796s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[219.007200] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[219.007935] Starting dynamic subtest: smem
[219.111892] Dynamic subtest smem: SUCCESS (0.104s)
[219.112584] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SUCCESS (0.105s)
[219.312062] [050/130] (795s left) kms_prime (basic-crc-hybrid)
[219.416595] Subtest basic-crc-hybrid: SKIP (0.000s)
[219.515748] [051/130] (795s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[219.605479] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[219.606827] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[219.727195] [052/130] (795s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[219.870138] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[219.962499] [053/130] (795s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[220.050359] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[221.345159] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (1.295s)
[221.502268] [054/130] (793s left) kms_flip (2x-flip-vs-panning)
[221.590265] Starting subtest: 2x-flip-vs-panning
[221.599229] Subtest 2x-flip-vs-panning: SKIP (0.009s)
[221.691330] [055/130] (793s left) gem_mmap_wc (write-gtt-read-wc)
[221.723859] Starting subtest: write-gtt-read-wc
[222.042028] Subtest write-gtt-read-wc: SUCCESS (0.310s)
[222.137816] [056/130] (793s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[222.234030] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[222.928898] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.694s)
[223.079923] [057/130] (792s left) kms_flip (2x-flip-vs-wf_vblank)
[223.165446] Starting subtest: 2x-flip-vs-wf_vblank
[223.174582] Subtest 2x-flip-vs-wf_vblank: SKIP (0.009s)
[223.312926] [058/130] (792s left) perf_pmu (semaphore-wait-idle)
[223.347540] Starting subtest: semaphore-wait-idle
[223.348225] Starting dynamic subtest: rcs0
[223.865226] Dynamic subtest rcs0: SUCCESS (0.509s)
[223.880120] Starting dynamic subtest: bcs0
[224.376490] Dynamic subtest bcs0: SUCCESS (0.510s)
[224.391607] Starting dynamic subtest: vcs0
[224.887865] Dynamic subtest vcs0: SUCCESS (0.510s)
[224.903218] Starting dynamic subtest: vcs1
[225.398974] Dynamic subtest vcs1: SUCCESS (0.510s)
[225.414153] Starting dynamic subtest: vecs0
[225.909888] Dynamic subtest vecs0: SUCCESS (0.510s)
[225.910823] Subtest semaphore-wait-idle: SUCCESS (2.554s)
[226.014747] [059/130] (789s left) i915_pm_rpm (gem-pread)
[227.407035] Starting subtest: gem-pread
[228.791256] Subtest gem-pread: SUCCESS (1.384s)
[228.927609] [060/130] (786s left) gem_exec_fence (long-history)
[229.256599] Starting subtest: long-history
[235.051549] Subtest long-history: SUCCESS (5.786s)
[235.541267] [061/130] (780s left) gem_lmem_swapping (parallel-random-engines)
[235.577818] Subtest parallel-random-engines: SKIP (0.000s)
[235.622749] [062/130] (780s left) syncobj_basic (bad-destroy)
[235.657294] Starting subtest: bad-destroy
[235.657984] Subtest bad-destroy: SUCCESS (0.000s)
[235.744829] [063/130] (779s left) kms_cursor_crc (cursor-offscreen-512x170)
[235.838372] Starting subtest: cursor-offscreen-512x170
[235.840521] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[235.965142] [064/130] (779s left) gem_ctx_persistence (hostile)
[236.000674] Starting subtest: hostile
[246.625866] Subtest hostile: SUCCESS (10.616s)
[246.735788] [065/130] (769s left) gem_exec_reloc (basic-cpu-read)
[246.772130] Starting subtest: basic-cpu-read
[246.777057] Subtest basic-cpu-read: SUCCESS (0.005s)
[246.918089] [066/130] (768s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[247.007302] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[247.050239] [067/130] (768s left) gem_exec_fence (syncobj-timeline-wait)
[247.506801] Starting subtest: syncobj-timeline-wait
[247.525129] Subtest syncobj-timeline-wait: SUCCESS (0.027s)
[247.720819] [068/130] (768s left) prime_mmap (test_userptr)
[247.752572] Starting subtest: test_userptr
[247.753260] Starting dynamic subtest: test_userptr-smem
[247.753958] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[247.754643] Subtest test_userptr: SUCCESS (0.001s)
[247.866409] [069/130] (768s left) gem_exec_store (dword)
[247.907154] Starting subtest: dword
[247.907920] Starting dynamic subtest: rcs0
[247.956952] Dynamic subtest rcs0: SUCCESS (0.049s)
[247.974673] Starting dynamic subtest: bcs0
[247.979044] Dynamic subtest bcs0: SUCCESS (0.021s)
[247.988429] Starting dynamic subtest: vcs0
[247.998193] Dynamic subtest vcs0: SUCCESS (0.018s)
[248.014438] Starting dynamic subtest: vcs1
[248.019048] Dynamic subtest vcs1: SUCCESS (0.020s)
[248.028504] Starting dynamic subtest: vecs0
[248.034922] Dynamic subtest vecs0: SUCCESS (0.015s)
[248.035639] Subtest dword: SUCCESS (0.128s)
[248.225870] [070/130] (767s left) kms_pm_rpm (legacy-planes)
[249.617468] Starting subtest: legacy-planes
[249.618607] Starting dynamic subtest: plane-63
[258.164809] Dynamic subtest plane-63: SUCCESS (8.547s)
[258.178274] Starting dynamic subtest: plane-93
[266.896017] Dynamic subtest plane-93: SUCCESS (8.729s)
[266.911813] Starting dynamic subtest: plane-123
[275.361541] Dynamic subtest plane-123: SUCCESS (8.455s)
[275.381638] Starting dynamic subtest: plane-133
[283.791383] Dynamic subtest plane-133: SUCCESS (8.437s)
[283.804563] Starting dynamic subtest: plane-143
[292.318337] Dynamic subtest plane-143: SUCCESS (8.525s)
[292.330979] Starting dynamic subtest: plane-153
[300.662592] Dynamic subtest plane-153: SUCCESS (8.342s)
[300.663593] Subtest legacy-planes: SUCCESS (51.046s)
[300.864247] [071/130] (715s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[300.953587] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[300.954934] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[301.082571] [072/130] (715s left) kms_psr (fbc-psr-suspend)
[301.165652] Subtest fbc-psr-suspend: SKIP (0.000s)
[301.204858] [073/130] (714s left) kms_big_fb (linear-32bpp-rotate-270)
[301.298011] Starting subtest: linear-32bpp-rotate-270
[301.385886] Subtest linear-32bpp-rotate-270: SKIP (0.086s)
[301.524363] [074/130] (714s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[301.560626] Starting subtest: basic-wc-gtt-noreloc
[301.563468] Subtest basic-wc-gtt-noreloc: SUCCESS (0.003s)
[301.703544] [075/130] (714s left) prime_mmap (test_correct)
[301.734184] Starting subtest: test_correct
[301.734862] Starting dynamic subtest: test_correct-smem
[301.737174] Dynamic subtest test_correct-smem: SUCCESS (0.003s)
[301.737844] Subtest test_correct: SUCCESS (0.004s)
[301.847887] [076/130] (714s left) kms_vblank (accuracy-idle)
[301.932873] Starting subtest: accuracy-idle
[301.934530] Starting dynamic subtest: pipe-A-HDMI-A-1
[303.113877] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.180s)
[303.124779] Starting dynamic subtest: pipe-D-HDMI-A-1
[304.271235] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.154s)
[304.271966] Subtest accuracy-idle: SUCCESS (2.339s)
[304.437212] [077/130] (711s left) perf (invalid-remove-userspace-config)
[304.546107] Starting subtest: invalid-remove-userspace-config
[304.556025] Subtest invalid-remove-userspace-config: SUCCESS (0.010s)
[304.600342] [078/130] (711s left) gem_madvise (dontneed-before-exec)
[304.633898] Starting subtest: dontneed-before-exec
[304.636822] Subtest dontneed-before-exec: SUCCESS (0.003s)
[304.774614] [079/130] (711s left) kms_chamelium_color (ctm-negative)
[304.864037] Subtest ctm-negative: SKIP (0.000s)
[304.905655] [080/130] (711s left) gem_mmap_wc (invalid-flags)
[304.938440] Starting subtest: invalid-flags
[304.939153] Subtest invalid-flags: SUCCESS (0.000s)
[305.038870] [081/130] (711s left) gem_exec_reloc (basic-gtt-wc)
[305.075530] Starting subtest: basic-gtt-wc
[305.082823] Subtest basic-gtt-wc: SUCCESS (0.007s)
[305.212714] [082/130] (711s left) syncobj_timeline (single-wait-all-available-signaled)
[305.246645] Starting subtest: single-wait-all-available-signaled
[305.247349] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[305.338722] [083/130] (711s left) gem_ctx_exec (basic-close-race)
[305.373998] Starting subtest: basic-close-race
[310.897605] Subtest basic-close-race: SUCCESS (5.489s)
[310.983913] [084/130] (705s left) gem_exec_balancer (parallel-out-fence)
[311.142573] Subtest parallel-out-fence: SKIP (0.000s)
[311.241661] [085/130] (705s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[311.330717] Starting subtest: flip-vs-cursor-legacy
[317.609712] Subtest flip-vs-cursor-legacy: SUCCESS (6.279s)
[317.757289] [086/130] (698s left) drm_read (fault-buffer)
[317.871630] Starting subtest: fault-buffer
[317.872394] Subtest fault-buffer: SUCCESS (0.001s)
[318.021803] [087/130] (698s left) gem_mmap_wc (pf-nonblock)
[318.053921] Starting subtest: pf-nonblock
[318.055176] Subtest pf-nonblock: SUCCESS (0.002s)
[318.195579] [088/130] (698s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[318.283663] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[318.285005] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[318.396120] [089/130] (698s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[318.483569] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[318.484890] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[318.603580] [090/130] (698s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[318.687900] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[318.689563] Starting dynamic subtest: pipe-A-valid-mode
[318.736822] Dynamic subtest pipe-A-valid-mode: SKIP (0.047s)
[318.738191] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.048s)
[318.852559] [091/130] (698s left) gem_spin_batch (spin-all-new)
[318.892956] Starting subtest: spin-all-new
[318.904082] Subtest spin-all-new: SUCCESS (0.011s)
[319.109251] [092/130] (697s left) core_sysfs (read-all-entries)
[319.141665] Starting subtest: read-all-entries
[319.144905] Subtest read-all-entries: SUCCESS (0.004s)
[319.229583] [093/130] (697s left) gem_exec_reloc (basic-range-active)
[319.265643] Starting subtest: basic-range-active
[319.302880] Subtest basic-range-active: SUCCESS (0.037s)
[319.435236] [094/130] (697s left) syncobj_timeline (single-wait-all-signaled)
[319.468828] Starting subtest: single-wait-all-signaled
[319.469565] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[319.550855] [095/130] (697s left) gen7_exec_parse (basic-offset)
[319.586847] Subtest basic-offset: SKIP (0.000s)
[319.633310] [096/130] (697s left) gem_ctx_shared (q-out-order)
[319.674847] Starting subtest: Q-out-order
[319.675549] Starting dynamic subtest: rcs0
[319.724744] Dynamic subtest rcs0: SUCCESS (0.049s)
[319.737046] Starting dynamic subtest: bcs0
[319.777335] Dynamic subtest bcs0: SUCCESS (0.051s)
[319.790293] Starting dynamic subtest: vcs0
[319.829825] Dynamic subtest vcs0: SUCCESS (0.051s)
[319.842845] Starting dynamic subtest: vcs1
[319.881064] Dynamic subtest vcs1: SUCCESS (0.049s)
[319.894574] Starting dynamic subtest: vecs0
[319.933455] Dynamic subtest vecs0: SUCCESS (0.051s)
[319.934634] Subtest Q-out-order: SUCCESS (0.259s)
[320.143775] [097/130] (697s left) gem_exec_flush (basic-batch-kernel-default-wb)
[320.185116] Starting subtest: basic-batch-kernel-default-wb
[325.780364] Subtest basic-batch-kernel-default-wb: SUCCESS (5.595s)
[325.999468] [098/130] (691s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[326.091593] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[326.092930] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[326.199863] [099/130] (691s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[326.287819] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[326.324717] [100/130] (690s left) kms_psr2_su (page_flip-xrgb8888)
[326.358325] Subtest page_flip-XRGB8888: SKIP (0.000s)
[326.412995] [101/130] (690s left) kms_psr (psr-basic)
[326.498600] Subtest psr-basic: SKIP (0.000s)
[326.542643] [102/130] (690s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[326.633093] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[326.634492] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[326.767720] [103/130] (690s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[326.861982] Starting subtest: yf-tiled-8bpp-rotate-90
[326.863461] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[326.975333] [104/130] (690s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[327.068957] Starting subtest: yf-tiled-16bpp-rotate-90
[327.070291] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[327.184750] [105/130] (690s left) kms_flip (flip-vs-blocking-wf-vblank)
[327.269553] Starting subtest: flip-vs-blocking-wf-vblank
[327.271784] Starting dynamic subtest: A-HDMI-A1
[335.099624] Dynamic subtest A-HDMI-A1: SUCCESS (7.809s)
[335.107917] Starting dynamic subtest: B-HDMI-A1
[342.902205] Dynamic subtest B-HDMI-A1: SUCCESS (7.815s)
[342.913657] Starting dynamic subtest: C-HDMI-A1
[350.733911] Dynamic subtest C-HDMI-A1: SUCCESS (7.804s)
[350.742459] Starting dynamic subtest: D-HDMI-A1
[358.501897] Dynamic subtest D-HDMI-A1: SUCCESS (7.790s)
[358.502617] Subtest flip-vs-blocking-wf-vblank: SUCCESS (31.231s)
[358.702817] [106/130] (658s left) gem_userptr_blits (stress-purge)
[358.749743] Starting subtest: stress-purge
[364.137733] Subtest stress-purge: SUCCESS (5.388s)
[364.296545] [107/130] (653s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[364.376536] Starting subtest: no-spare-fences-busy-interruptible
[366.568231] Subtest no-spare-fences-busy-interruptible: SUCCESS (2.191s)
[366.701474] [108/130] (650s left) gem_exec_balancer (nop)
[366.742646] Starting subtest: nop
[404.921520] Subtest nop: SUCCESS (38.178s)
[405.123910] [109/130] (612s left) gem_eio (in-flight-external)
[405.166894] Starting subtest: in-flight-external
[405.424654] Subtest in-flight-external: SUCCESS (0.258s)
[405.570629] [110/130] (612s left) kms_flip (2x-blocking-absolute-wf_vblank)
[405.655584] Starting subtest: 2x-blocking-absolute-wf_vblank
[405.664844] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.009s)
[405.799011] [111/130] (611s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[405.887174] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[405.896727] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.009s)
[405.987876] [112/130] (611s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[406.078586] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[406.079995] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[406.189816] [113/130] (611s left) kms_atomic (plane-cursor-legacy)
[406.275409] Starting subtest: plane-cursor-legacy
[406.277848] Starting dynamic subtest: pipe-A-HDMI-A-1
[406.431652] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.155s)
[406.432411] Subtest plane-cursor-legacy: SUCCESS (0.157s)
[406.588749] [114/130] (611s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[406.675549] Starting subtest: bad-aux-stride-y-tiled-ccs
[406.677687] Starting dynamic subtest: pipe-A-HDMI-A-1
[406.684545] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[406.697021] Starting dynamic subtest: pipe-B-HDMI-A-1
[406.703858] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[406.715450] Starting dynamic subtest: pipe-C-HDMI-A-1
[406.722011] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[406.730269] Starting dynamic subtest: pipe-D-HDMI-A-1
[406.736928] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[406.738203] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.008s)
[406.933580] [115/130] (610s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[407.020944] Starting subtest: stress-xrgb8888-xtiled
[413.373112] Subtest stress-xrgb8888-xtiled: SUCCESS (6.353s)
[413.508265] [116/130] (604s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[413.595971] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[413.597410] Starting dynamic subtest: pipe-A
[413.722452] Dynamic subtest pipe-A: SUCCESS (0.127s)
[413.731579] Starting dynamic subtest: pipe-B
[413.864798] Dynamic subtest pipe-B: SUCCESS (0.141s)
[413.876212] Starting dynamic subtest: pipe-C
[413.990665] Dynamic subtest pipe-C: SUCCESS (0.125s)
[414.002559] Starting dynamic subtest: pipe-D
[414.116347] Dynamic subtest pipe-D: SUCCESS (0.125s)
[414.117093] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SUCCESS (0.522s)
[414.302920] [117/130] (603s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[414.391039] Starting subtest: fbc-shrfb-scaledprimary
[417.233792] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.844s)
[417.403573] [118/130] (600s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[417.502568] Starting subtest: x-tiled-64bpp-rotate-270
[417.548702] Subtest x-tiled-64bpp-rotate-270: SKIP (0.045s)
[417.692151] [119/130] (600s left) kms_flip (nonexisting-fb-interruptible)
[417.782233] Starting subtest: nonexisting-fb-interruptible
[417.784993] Starting dynamic subtest: A-HDMI-A1
[417.935427] Dynamic subtest A-HDMI-A1: SUCCESS (0.150s)
[417.945576] Starting dynamic subtest: B-HDMI-A1
[418.078600] Dynamic subtest B-HDMI-A1: SUCCESS (0.142s)
[418.088668] Starting dynamic subtest: C-HDMI-A1
[418.209035] Dynamic subtest C-HDMI-A1: SUCCESS (0.129s)
[418.218739] Starting dynamic subtest: D-HDMI-A1
[418.330883] Dynamic subtest D-HDMI-A1: SUCCESS (0.121s)
[418.333142] Subtest nonexisting-fb-interruptible: SUCCESS (0.551s)
[418.521215] [120/130] (599s left) kms_plane_lowres (tiling-4)
[418.607066] Starting subtest: tiling-4
[418.608430] Subtest tiling-4: SKIP (0.000s)
[418.693420] [121/130] (599s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[418.781907] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[418.783289] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[418.894574] [122/130] (599s left) kms_psr (pr-cursor-render)
[418.979551] Subtest pr-cursor-render: SKIP (0.000s)
[419.024989] [123/130] (599s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[419.112970] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[420.221043] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (1.108s)
[420.360657] [124/130] (597s left) kms_cursor_crc (cursor-onscreen-64x21)
[420.451953] Starting subtest: cursor-onscreen-64x21
[420.456937] Starting dynamic subtest: pipe-A-HDMI-A-1
[421.634457] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.177s)
[421.670830] Starting dynamic subtest: pipe-D-HDMI-A-1
[422.798078] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.138s)
[422.798875] Subtest cursor-onscreen-64x21: SUCCESS (2.347s)
[422.947037] [125/130] (595s left) perf_pmu (busy-idle-no-semaphores)
[422.986138] Starting subtest: busy-idle-no-semaphores
[422.986856] Starting dynamic subtest: rcs0
[423.641921] Dynamic subtest rcs0: SUCCESS (0.646s)
[423.654062] Starting dynamic subtest: bcs0
[424.264562] Dynamic subtest bcs0: SUCCESS (0.620s)
[424.276151] Starting dynamic subtest: vcs0
[424.905729] Dynamic subtest vcs0: SUCCESS (0.638s)
[424.917021] Starting dynamic subtest: vcs1
[425.536642] Dynamic subtest vcs1: SUCCESS (0.628s)
[425.547798] Starting dynamic subtest: vecs0
[426.172365] Dynamic subtest vecs0: SUCCESS (0.632s)
[426.173092] Subtest busy-idle-no-semaphores: SUCCESS (3.179s)
[426.273986] [126/130] (592s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[426.362047] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[426.362737] Starting dynamic subtest: pipe-A
[427.391155] Dynamic subtest pipe-A: SKIP (1.028s)
[427.400104] Starting dynamic subtest: pipe-B
[428.492011] Dynamic subtest pipe-B: SKIP (1.099s)
[428.500679] Starting dynamic subtest: pipe-C
[429.587931] Dynamic subtest pipe-C: SKIP (1.095s)
[429.596774] Starting dynamic subtest: pipe-D
[430.681628] Dynamic subtest pipe-D: SKIP (1.093s)
[430.683079] Subtest plane-scaler-with-clipping-clamping-rotation: SKIP (4.319s)
[430.859814] [127/130] (587s left) gem_mmap (short-mmap)
[430.901409] Starting subtest: short-mmap
[430.902125] Subtest short-mmap: SUCCESS (0.000s)
[431.005663] [128/130] (587s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[431.095662] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[431.097029] Subtest psr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[431.198266] [129/130] (587s left) gem_ctx_param (invalid-ctx-set)
[431.232780] Starting subtest: invalid-ctx-set
[431.233448] Subtest invalid-ctx-set: SUCCESS (0.000s)
[431.305479] [130/130] (587s left) i915_suspend (basic-s3-without-i915)
[431.337172] Starting subtest: basic-s3-without-i915