[52.761931] Initializing watchdogs
[52.761999]   /dev/watchdog0
[52.777215] [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]
[52.782691] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[52.785184] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[52.786981] [001/130] (960s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[52.878246] Starting subtest: bad-pixel-format-yf-tiled-ccs
[52.879182] Starting dynamic subtest: pipe-A-HDMI-A-1
[52.885761] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[52.890718] Starting dynamic subtest: pipe-B-HDMI-A-1
[52.897360] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[52.902415] Starting dynamic subtest: pipe-C-HDMI-A-1
[52.908970] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[52.914288] Starting dynamic subtest: pipe-D-HDMI-A-1
[52.921013] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[52.922340] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s)
[53.121653] [002/130] (960s left) kms_content_protection (dp-mst-type-0)
[53.213382] Starting subtest: dp-mst-type-0
[53.214820] Subtest dp-mst-type-0: SKIP (0.000s)
[53.318990] [003/130] (960s left) gem_exec_reloc (basic-cpu-read-active)
[53.360693] Starting subtest: basic-cpu-read-active
[53.489446] Subtest basic-cpu-read-active: SUCCESS (0.120s)
[53.616768] [004/130] (959s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[53.700707] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[53.701390] Starting dynamic subtest: pipe-A-HDMI-A-1
[53.708095] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[53.713256] Starting dynamic subtest: pipe-B-HDMI-A-1
[53.720129] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[53.725428] Starting dynamic subtest: pipe-C-HDMI-A-1
[53.732000] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[53.737060] Starting dynamic subtest: pipe-D-HDMI-A-1
[53.743686] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[53.744999] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s)
[53.946558] [005/130] (959s left) gem_mmap_offset (clear)
[53.978605] Starting subtest: clear
[53.981706] Starting dynamic subtest: smem0
[76.312325] Dynamic subtest smem0: SUCCESS (22.270s)
[76.313012] Subtest clear: SUCCESS (22.270s)
[76.449231] [006/130] (937s left) kms_feature_discovery (psr1)
[76.578149] Starting subtest: psr1
[76.579626] Subtest psr1: SKIP (0.000s)
[76.651868] [007/130] (936s left) kms_cursor_legacy (torture-move)
[76.737493] Starting subtest: torture-move
[76.738237] Starting dynamic subtest: pipe-A
[82.247358] Dynamic subtest pipe-A: SUCCESS (5.474s)
[82.253415] Starting dynamic subtest: pipe-B
[87.714775] Dynamic subtest pipe-B: SUCCESS (5.466s)
[87.721906] Starting dynamic subtest: pipe-C
[93.172637] Dynamic subtest pipe-C: SUCCESS (5.457s)
[93.179011] Starting dynamic subtest: pipe-D
[98.626365] Dynamic subtest pipe-D: SUCCESS (5.453s)
[98.632424] Starting dynamic subtest: all-pipes
[104.068860] Dynamic subtest all-pipes: SUCCESS (5.467s)
[104.069554] Subtest torture-move: SUCCESS (27.318s)
[104.162922] [008/130] (909s left) gem_softpin (evict-snoop)
[104.207413] Starting subtest: evict-snoop
[104.208867] Subtest evict-snoop: SKIP (0.000s)
[104.286625] [009/130] (909s left) gem_ppgtt (blt-vs-render-ctxn)
[104.321977] Starting subtest: blt-vs-render-ctxN
[136.835719] Subtest blt-vs-render-ctxN: SUCCESS (32.502s)
[136.979511] [010/130] (876s left) prime_vgem (fence-read-hang)
[137.121588] Subtest fence-read-hang: SKIP (0.000s)
[137.228566] [FACT prime_vgem (fence-read-hang)] new: kernel.kmod_is_loaded.vgem: true
[137.230113] [011/130] (876s left) i915_drm_fdinfo (memory-info-shared)
[137.265146] Starting subtest: memory-info-shared
[137.265871] Starting dynamic subtest: smem0
[137.295480] Dynamic subtest smem0: SUCCESS (0.030s)
[137.296239] Subtest memory-info-shared: SUCCESS (0.030s)
[137.379084] [012/130] (876s left) gem_exec_schedule (timeslicing)
[137.420593] Starting subtest: timeslicing
[137.421345] Starting dynamic subtest: rcs0
[137.425536] Dynamic subtest rcs0: SUCCESS (0.005s)
[137.433576] Starting dynamic subtest: bcs0
[137.434255] Dynamic subtest bcs0: SUCCESS (0.004s)
[137.441269] Starting dynamic subtest: vcs0
[137.441935] Dynamic subtest vcs0: SUCCESS (0.006s)
[137.448942] Starting dynamic subtest: vcs1
[137.449624] Dynamic subtest vcs1: SUCCESS (0.007s)
[137.455688] Starting dynamic subtest: vecs0
[137.456356] Dynamic subtest vecs0: SUCCESS (0.004s)
[137.457014] Subtest timeslicing: SUCCESS (0.027s)
[137.762394] [013/130] (875s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[137.856180] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[137.857539] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[137.971776] [014/130] (875s left) kms_async_flips (alternate-sync-async-flip-atomic)
[138.056633] Starting subtest: alternate-sync-async-flip-atomic
[138.171336] Starting dynamic subtest: pipe-A-HDMI-A-1
[140.276988] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.097s)
[140.393504] Starting dynamic subtest: pipe-B-HDMI-A-1
[142.490824] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.095s)
[142.611849] Starting dynamic subtest: pipe-C-HDMI-A-1
[144.701847] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.088s)
[144.814198] Starting dynamic subtest: pipe-D-HDMI-A-1
[146.907727] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.090s)
[146.908715] Subtest alternate-sync-async-flip-atomic: SUCCESS (8.843s)
[147.151199] [015/130] (866s left) api_intel_bb (simple-bb)
[147.187887] Starting subtest: simple-bb
[147.196609] Subtest simple-bb: SUCCESS (0.003s)
[147.318101] [016/130] (866s left) i915_hangman (engine-engine-error)
[147.359301] Starting subtest: engine-engine-error
[147.360046] Starting dynamic subtest: rcs0
[147.442712] Dynamic subtest rcs0: SUCCESS (0.083s)
[147.456374] Starting dynamic subtest: bcs0
[147.537682] Dynamic subtest bcs0: SUCCESS (0.094s)
[147.551509] Starting dynamic subtest: vcs0
[147.619943] Dynamic subtest vcs0: SUCCESS (0.082s)
[147.636147] Starting dynamic subtest: vcs1
[147.701690] Dynamic subtest vcs1: SUCCESS (0.081s)
[147.715506] Starting dynamic subtest: vecs0
[147.785809] Dynamic subtest vecs0: SUCCESS (0.083s)
[147.786828] Subtest engine-engine-error: SUCCESS (0.426s)
[147.918344] [017/130] (866s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[148.018247] Starting subtest: verify-pxp-execution-after-suspend-resume
[155.130964] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.113s)
[164.320862] [018/130] (858s left) syncobj_eventfd (timeline-wait)
[164.363331] Starting subtest: timeline-wait
[164.373907] Subtest timeline-wait: SUCCESS (0.010s)
[164.463953] [019/130] (858s left) gem_busy (extended)
[164.633765] Starting subtest: extended
[164.634669] Starting dynamic subtest: rcs0
[164.660490] Dynamic subtest rcs0: SUCCESS (0.036s)
[164.675651] Starting dynamic subtest: bcs0
[164.678988] Dynamic subtest bcs0: SUCCESS (0.018s)
[164.688391] Starting dynamic subtest: vcs0
[164.696033] Dynamic subtest vcs0: SUCCESS (0.017s)
[164.704433] Starting dynamic subtest: vcs1
[164.709816] Dynamic subtest vcs1: SUCCESS (0.014s)
[164.717483] Starting dynamic subtest: vecs0
[164.727023] Dynamic subtest vecs0: SUCCESS (0.017s)
[164.727791] Subtest extended: SUCCESS (0.103s)
[164.966386] [020/130] (858s left) syncobj_timeline (invalid-transfer-illegal-handle)
[164.999034] Starting subtest: invalid-transfer-illegal-handle
[164.999756] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[165.086962] [021/130] (858s left) gem_ctx_freq (sysfs)
[165.123432] Starting subtest: sysfs
[165.124160] Starting dynamic subtest: gt0
[170.101231] Dynamic subtest gt0: SUCCESS (4.978s)
[170.102332] Subtest sysfs: SUCCESS (4.979s)
[170.188328] [022/130] (853s left) kms_chamelium_edid (hdmi-edid-read)
[170.325828] Subtest hdmi-edid-read: SKIP (0.000s)
[170.413651] [023/130] (852s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[170.499425] Starting subtest: short-flip-before-cursor-toggle
[171.045968] Subtest short-flip-before-cursor-toggle: SUCCESS (0.547s)
[171.203568] [024/130] (852s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[171.289643] Starting subtest: cursor-rapid-movement-64x64
[171.294497] Starting dynamic subtest: pipe-A-HDMI-A-1
[171.551305] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.257s)
[171.586095] Starting dynamic subtest: pipe-D-HDMI-A-1
[171.783177] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.204s)
[171.783914] Subtest cursor-rapid-movement-64x64: SUCCESS (0.494s)
[171.956759] [025/130] (851s left) gem_exec_flush (basic-wb-prw-default)
[171.998291] Starting subtest: basic-wb-prw-default
[177.424866] Subtest basic-wb-prw-default: SUCCESS (5.426s)
[177.631812] [026/130] (845s left) kms_invalid_mode (bad-vtotal)
[177.717259] Starting subtest: bad-vtotal
[177.717947] Starting dynamic subtest: pipe-A-HDMI-A-1
[177.763212] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.046s)
[177.773387] Starting dynamic subtest: pipe-B-HDMI-A-1
[177.774075] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[177.781313] Starting dynamic subtest: pipe-C-HDMI-A-1
[177.782036] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[177.789312] Starting dynamic subtest: pipe-D-HDMI-A-1
[177.789994] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[177.790678] Subtest bad-vtotal: SUCCESS (0.054s)
[177.935588] [027/130] (845s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[177.969329] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[177.970070] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[178.054386] [028/130] (845s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[178.141552] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[178.142937] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[178.272160] [029/130] (845s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[178.356617] Starting subtest: primary-yf-tiled-reflect-x-270
[178.409204] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.052s)
[178.506083] [030/130] (845s left) gem_exec_schedule (preempt-queue-chain)
[178.549452] Starting subtest: preempt-queue-chain
[178.550226] Starting dynamic subtest: rcs0
[178.696722] Dynamic subtest rcs0: SUCCESS (0.138s)
[178.705015] Starting dynamic subtest: bcs0
[178.835110] Dynamic subtest bcs0: SUCCESS (0.138s)
[178.843273] Starting dynamic subtest: vcs0
[178.970931] Dynamic subtest vcs0: SUCCESS (0.135s)
[178.979432] Starting dynamic subtest: vcs1
[179.110481] Dynamic subtest vcs1: SUCCESS (0.139s)
[179.118851] Starting dynamic subtest: vecs0
[179.243035] Dynamic subtest vecs0: SUCCESS (0.132s)
[179.243764] Subtest preempt-queue-chain: SUCCESS (0.685s)
[179.533973] [031/130] (844s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[179.622402] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[179.623793] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[179.731584] [032/130] (843s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[179.816458] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[179.817828] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[179.992804] [033/130] (843s left) gem_exec_reloc (basic-cpu-active)
[180.032872] Starting subtest: basic-cpu-active
[180.160681] Subtest basic-cpu-active: SUCCESS (0.119s)
[180.300972] [034/130] (843s left) kms_lease (multimaster-lease)
[180.385561] Starting subtest: multimaster-lease
[180.387234] Subtest multimaster-lease: SUCCESS (0.002s)
[180.471572] [035/130] (843s left) kms_dp_linktrain_fallback (dsc-fallback)
[180.554433] Starting subtest: dsc-fallback
[180.556373] Subtest dsc-fallback: SKIP (0.000s)
[180.635879] [036/130] (843s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[180.718601] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[180.720081] Starting dynamic subtest: pipe-A-HDMI-A-1
[180.726485] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[180.734170] Starting dynamic subtest: pipe-B-HDMI-A-1
[180.740636] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[180.748085] Starting dynamic subtest: pipe-C-HDMI-A-1
[180.754499] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[180.761745] Starting dynamic subtest: pipe-D-HDMI-A-1
[180.768436] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[180.769782] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SKIP (0.005s)
[180.967413] [037/130] (842s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[181.055356] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[181.056673] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[181.159697] [038/130] (842s left) kms_psr (psr-primary-page-flip)
[181.242329] Subtest psr-primary-page-flip: SKIP (0.000s)
[181.286250] [039/130] (842s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[181.381904] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[181.383239] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[181.483597] [040/130] (842s left) kms_getfb (getfb2-handle-closed)
[181.567027] Starting subtest: getfb2-handle-closed
[181.567767] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[181.685217] [041/130] (842s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[181.772408] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[181.773731] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[181.876742] [042/130] (842s left) gem_lmem_swapping (heavy-verify-random)
[181.912322] Subtest heavy-verify-random: SKIP (0.000s)
[181.952018] [043/130] (842s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[182.038350] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[182.039787] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[182.161555] [044/130] (841s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[182.249755] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[182.251159] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[182.378228] [045/130] (841s left) gem_exec_gttfill (basic)
[182.423363] Starting subtest: basic
[185.849193] Subtest basic: SUCCESS (3.430s)
[186.048637] [046/130] (838s left) prime_busy (hang)
[186.134932] Starting subtest: hang
[186.135612] Starting dynamic subtest: rcs0
[199.775863] Dynamic subtest rcs0: SUCCESS (13.631s)
[199.782952] Starting dynamic subtest: bcs0
[206.585228] Dynamic subtest bcs0: SUCCESS (6.783s)
[206.592169] Starting dynamic subtest: vcs0
[213.561480] Dynamic subtest vcs0: SUCCESS (6.975s)
[213.568850] Starting dynamic subtest: vcs1
[220.601898] Dynamic subtest vcs1: SUCCESS (7.040s)
[220.609287] Starting dynamic subtest: vecs0
[227.551865] Dynamic subtest vecs0: SUCCESS (6.975s)
[227.552565] Subtest hang: SUCCESS (41.407s)
[227.664941] [047/130] (796s left) kms_psr (fbc-psr2-no-drrs)
[227.757346] Subtest fbc-psr2-no-drrs: SKIP (0.000s)
[227.800849] [048/130] (796s left) kms_vrr (flip-suspend)
[227.886550] Starting subtest: flip-suspend
[227.888479] Subtest flip-suspend: SKIP (0.000s)
[227.973946] [049/130] (796s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[228.010875] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[228.011572] Starting dynamic subtest: smem
[228.114105] Dynamic subtest smem: SUCCESS (0.103s)
[228.114829] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SUCCESS (0.103s)
[228.312016] [050/130] (796s left) kms_prime (basic-crc-hybrid)
[228.414557] Subtest basic-crc-hybrid: SKIP (0.000s)
[228.516653] [051/130] (795s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[228.605535] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[228.606950] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[228.726758] [052/130] (795s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[228.863600] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[228.965184] [053/130] (795s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[229.052610] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[230.329947] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (1.277s)
[230.488793] [054/130] (794s left) kms_flip (2x-flip-vs-panning)
[230.578604] Starting subtest: 2x-flip-vs-panning
[230.587545] Subtest 2x-flip-vs-panning: SKIP (0.009s)
[230.684401] [055/130] (793s left) gem_mmap_wc (write-gtt-read-wc)
[230.715637] Starting subtest: write-gtt-read-wc
[231.031959] Subtest write-gtt-read-wc: SUCCESS (0.308s)
[231.130387] [056/130] (793s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[231.226109] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[231.921938] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.695s)
[232.064972] [057/130] (792s left) kms_flip (2x-flip-vs-wf_vblank)
[232.151284] Starting subtest: 2x-flip-vs-wf_vblank
[232.160770] Subtest 2x-flip-vs-wf_vblank: SKIP (0.009s)
[232.243171] [058/130] (792s left) perf_pmu (semaphore-wait-idle)
[232.278632] Starting subtest: semaphore-wait-idle
[232.279372] Starting dynamic subtest: rcs0
[232.796102] Dynamic subtest rcs0: SUCCESS (0.508s)
[232.806124] Starting dynamic subtest: bcs0
[233.307115] Dynamic subtest bcs0: SUCCESS (0.510s)
[233.317459] Starting dynamic subtest: vcs0
[233.818302] Dynamic subtest vcs0: SUCCESS (0.510s)
[233.828361] Starting dynamic subtest: vcs1
[234.329136] Dynamic subtest vcs1: SUCCESS (0.510s)
[234.339225] Starting dynamic subtest: vecs0
[234.839625] Dynamic subtest vecs0: SUCCESS (0.510s)
[234.840567] Subtest semaphore-wait-idle: SUCCESS (2.553s)
[234.946717] [059/130] (789s left) i915_pm_rpm (gem-pread)
[236.342851] Starting subtest: gem-pread
[237.726032] Subtest gem-pread: SUCCESS (1.380s)
[237.848876] [060/130] (786s left) gem_exec_fence (long-history)
[238.176535] Starting subtest: long-history
[243.972866] Subtest long-history: SUCCESS (5.788s)
[244.474384] [061/130] (780s left) gem_lmem_swapping (parallel-random-engines)
[244.512272] Subtest parallel-random-engines: SKIP (0.000s)
[244.555400] [062/130] (780s left) syncobj_basic (bad-destroy)
[244.586634] Starting subtest: bad-destroy
[244.587399] Subtest bad-destroy: SUCCESS (0.000s)
[244.668980] [063/130] (780s left) kms_cursor_crc (cursor-offscreen-512x170)
[244.763222] Starting subtest: cursor-offscreen-512x170
[244.764690] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[244.888435] [064/130] (780s left) gem_ctx_persistence (hostile)
[244.923879] Starting subtest: hostile
[255.328145] Subtest hostile: SUCCESS (10.395s)
[255.442639] [065/130] (769s left) gem_exec_reloc (basic-cpu-read)
[255.478546] Starting subtest: basic-cpu-read
[255.483321] Subtest basic-cpu-read: SUCCESS (0.005s)
[255.619398] [066/130] (769s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[255.709909] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[255.749750] [067/130] (769s left) gem_exec_fence (syncobj-timeline-wait)
[256.198107] Starting subtest: syncobj-timeline-wait
[256.213867] Subtest syncobj-timeline-wait: SUCCESS (0.025s)
[256.409377] [068/130] (768s left) prime_mmap (test_userptr)
[256.440530] Starting subtest: test_userptr
[256.441237] Starting dynamic subtest: test_userptr-smem
[256.441957] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[256.442642] Subtest test_userptr: SUCCESS (0.001s)
[256.549674] [069/130] (768s left) gem_exec_store (dword)
[256.589336] Starting subtest: dword
[256.590034] Starting dynamic subtest: rcs0
[256.647670] Dynamic subtest rcs0: SUCCESS (0.057s)
[256.659748] Starting dynamic subtest: bcs0
[256.672467] Dynamic subtest bcs0: SUCCESS (0.024s)
[256.686361] Starting dynamic subtest: vcs0
[256.699646] Dynamic subtest vcs0: SUCCESS (0.026s)
[256.712636] Starting dynamic subtest: vcs1
[256.726604] Dynamic subtest vcs1: SUCCESS (0.026s)
[256.739359] Starting dynamic subtest: vecs0
[256.752662] Dynamic subtest vecs0: SUCCESS (0.025s)
[256.753707] Subtest dword: SUCCESS (0.164s)
[256.950635] [070/130] (768s left) kms_pm_rpm (legacy-planes)
[258.345921] Starting subtest: legacy-planes
[258.347167] Starting dynamic subtest: plane-63
[267.088772] Dynamic subtest plane-63: SUCCESS (8.741s)
[267.106772] Starting dynamic subtest: plane-93
[275.694218] Dynamic subtest plane-93: SUCCESS (8.605s)
[275.711925] Starting dynamic subtest: plane-123
[284.337066] Dynamic subtest plane-123: SUCCESS (8.641s)
[284.348105] Starting dynamic subtest: plane-133
[292.847462] Dynamic subtest plane-133: SUCCESS (8.509s)
[292.864531] Starting dynamic subtest: plane-143
[301.372463] Dynamic subtest plane-143: SUCCESS (8.523s)
[301.391380] Starting dynamic subtest: plane-153
[309.907536] Dynamic subtest plane-153: SUCCESS (8.532s)
[309.908595] Subtest legacy-planes: SUCCESS (51.560s)
[310.113688] [071/130] (715s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[310.204603] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[310.205987] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[310.324279] [072/130] (714s left) kms_psr (fbc-psr-suspend)
[310.408923] Subtest fbc-psr-suspend: SKIP (0.000s)
[310.449569] [073/130] (714s left) kms_big_fb (linear-32bpp-rotate-270)
[310.542828] Starting subtest: linear-32bpp-rotate-270
[310.624129] Subtest linear-32bpp-rotate-270: SKIP (0.080s)
[310.756721] [074/130] (714s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[310.793042] Starting subtest: basic-wc-gtt-noreloc
[310.796611] Subtest basic-wc-gtt-noreloc: SUCCESS (0.004s)
[310.939132] [075/130] (714s left) prime_mmap (test_correct)
[310.970364] Starting subtest: test_correct
[310.971086] Starting dynamic subtest: test_correct-smem
[310.972814] Dynamic subtest test_correct-smem: SUCCESS (0.002s)
[310.973491] Subtest test_correct: SUCCESS (0.003s)
[311.091388] [076/130] (714s left) kms_vblank (accuracy-idle)
[311.177144] Starting subtest: accuracy-idle
[311.179084] Starting dynamic subtest: pipe-A-HDMI-A-1
[312.360395] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.181s)
[312.371173] Starting dynamic subtest: pipe-D-HDMI-A-1
[313.518063] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.154s)
[313.518820] Subtest accuracy-idle: SUCCESS (2.341s)
[313.686463] [077/130] (711s left) perf (invalid-remove-userspace-config)
[313.797821] Starting subtest: invalid-remove-userspace-config
[313.807320] Subtest invalid-remove-userspace-config: SUCCESS (0.010s)
[313.851024] [078/130] (711s left) gem_madvise (dontneed-before-exec)
[313.881963] Starting subtest: dontneed-before-exec
[313.884449] Subtest dontneed-before-exec: SUCCESS (0.003s)
[314.015724] [079/130] (711s left) kms_chamelium_color (ctm-negative)
[314.102316] Subtest ctm-negative: SKIP (0.000s)
[314.147070] [080/130] (711s left) gem_mmap_wc (invalid-flags)
[314.178244] Starting subtest: invalid-flags
[314.178932] Subtest invalid-flags: SUCCESS (0.000s)
[314.288789] [081/130] (711s left) gem_exec_reloc (basic-gtt-wc)
[314.324733] Starting subtest: basic-gtt-wc
[314.330875] Subtest basic-gtt-wc: SUCCESS (0.006s)
[314.469577] [082/130] (711s left) syncobj_timeline (single-wait-all-available-signaled)
[314.502724] Starting subtest: single-wait-all-available-signaled
[314.503437] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[314.586829] [083/130] (711s left) gem_ctx_exec (basic-close-race)
[314.620723] Starting subtest: basic-close-race
[320.370631] Subtest basic-close-race: SUCCESS (5.715s)
[320.475179] [084/130] (705s left) gem_exec_balancer (parallel-out-fence)
[320.633993] Subtest parallel-out-fence: SKIP (0.000s)
[320.725182] [085/130] (705s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[320.813319] Starting subtest: flip-vs-cursor-legacy
[327.099365] Subtest flip-vs-cursor-legacy: SUCCESS (6.286s)
[327.271821] [086/130] (698s left) drm_read (fault-buffer)
[327.384792] Starting subtest: fault-buffer
[327.385471] Subtest fault-buffer: SUCCESS (0.000s)
[327.523877] [087/130] (698s left) gem_mmap_wc (pf-nonblock)
[327.555824] Starting subtest: pf-nonblock
[327.556481] Subtest pf-nonblock: SUCCESS (0.002s)
[327.698948] [088/130] (698s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[327.785297] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[327.786610] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[327.906568] [089/130] (698s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[327.994518] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[328.002789] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[328.114057] [090/130] (697s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[328.198902] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[328.199659] Starting dynamic subtest: pipe-A-valid-mode
[328.250630] Dynamic subtest pipe-A-valid-mode: SKIP (0.051s)
[328.251993] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.052s)
[328.368825] [091/130] (697s left) gem_spin_batch (spin-all-new)
[328.408500] Starting subtest: spin-all-new
[328.419374] Subtest spin-all-new: SUCCESS (0.011s)
[328.620493] [092/130] (697s left) core_sysfs (read-all-entries)
[328.652475] Starting subtest: read-all-entries
[328.655989] Subtest read-all-entries: SUCCESS (0.004s)
[328.743621] [093/130] (697s left) gem_exec_reloc (basic-range-active)
[328.779549] Starting subtest: basic-range-active
[328.816630] Subtest basic-range-active: SUCCESS (0.037s)
[328.944547] [094/130] (697s left) syncobj_timeline (single-wait-all-signaled)
[328.977179] Starting subtest: single-wait-all-signaled
[328.977863] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[329.059554] [095/130] (697s left) gen7_exec_parse (basic-offset)
[329.096480] Subtest basic-offset: SKIP (0.000s)
[329.136446] [096/130] (697s left) gem_ctx_shared (q-out-order)
[329.180248] Starting subtest: Q-out-order
[329.180962] Starting dynamic subtest: rcs0
[329.235194] Dynamic subtest rcs0: SUCCESS (0.054s)
[329.247374] Starting dynamic subtest: bcs0
[329.287415] Dynamic subtest bcs0: SUCCESS (0.051s)
[329.301024] Starting dynamic subtest: vcs0
[329.338726] Dynamic subtest vcs0: SUCCESS (0.049s)
[329.352301] Starting dynamic subtest: vcs1
[329.388046] Dynamic subtest vcs1: SUCCESS (0.048s)
[329.401757] Starting dynamic subtest: vecs0
[329.439357] Dynamic subtest vecs0: SUCCESS (0.050s)
[329.441711] Subtest Q-out-order: SUCCESS (0.260s)
[329.646505] [097/130] (696s left) gem_exec_flush (basic-batch-kernel-default-wb)
[329.685864] Starting subtest: basic-batch-kernel-default-wb
[335.281740] Subtest basic-batch-kernel-default-wb: SUCCESS (5.596s)
[335.492521] [098/130] (690s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[335.583791] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[335.585149] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[335.695772] [099/130] (690s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[335.784739] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[335.835063] [100/130] (690s left) kms_psr2_su (page_flip-xrgb8888)
[335.868914] Subtest page_flip-XRGB8888: SKIP (0.000s)
[335.914230] [101/130] (690s left) kms_psr (psr-basic)
[336.000058] Subtest psr-basic: SKIP (0.000s)
[336.049823] [102/130] (690s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[336.139849] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[336.141274] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[336.244552] [103/130] (690s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[336.338949] Starting subtest: yf-tiled-8bpp-rotate-90
[336.340332] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[336.454796] [104/130] (690s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[336.548150] Starting subtest: yf-tiled-16bpp-rotate-90
[336.549498] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[336.659371] [105/130] (689s left) kms_flip (flip-vs-blocking-wf-vblank)
[336.744484] Starting subtest: flip-vs-blocking-wf-vblank
[336.746838] Starting dynamic subtest: A-HDMI-A1
[344.583448] Dynamic subtest A-HDMI-A1: SUCCESS (7.818s)
[344.591737] Starting dynamic subtest: B-HDMI-A1
[352.381011] Dynamic subtest B-HDMI-A1: SUCCESS (7.787s)
[352.389052] Starting dynamic subtest: C-HDMI-A1
[360.159376] Dynamic subtest C-HDMI-A1: SUCCESS (7.798s)
[360.168113] Starting dynamic subtest: D-HDMI-A1
[367.960951] Dynamic subtest D-HDMI-A1: SUCCESS (7.800s)
[367.961685] Subtest flip-vs-blocking-wf-vblank: SUCCESS (31.215s)
[368.122005] [106/130] (658s left) gem_userptr_blits (stress-purge)
[368.167879] Starting subtest: stress-purge
[373.555616] Subtest stress-purge: SUCCESS (5.388s)
[373.696639] [107/130] (653s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[373.774996] Starting subtest: no-spare-fences-busy-interruptible
[375.942211] Subtest no-spare-fences-busy-interruptible: SUCCESS (2.167s)
[376.093120] [108/130] (650s left) gem_exec_balancer (nop)
[376.135208] Starting subtest: nop
[414.363071] Subtest nop: SUCCESS (38.227s)
[414.571594] [109/130] (612s left) gem_eio (in-flight-external)
[414.613880] Starting subtest: in-flight-external
[414.878177] Subtest in-flight-external: SUCCESS (0.263s)
[415.022082] [110/130] (611s left) kms_flip (2x-blocking-absolute-wf_vblank)
[415.107621] Starting subtest: 2x-blocking-absolute-wf_vblank
[415.116987] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.009s)
[415.214896] [111/130] (611s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[415.304242] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[415.313944] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.009s)
[415.424189] [112/130] (611s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[415.513429] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[415.514987] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[415.632662] [113/130] (611s left) kms_atomic (plane-cursor-legacy)
[415.717968] Starting subtest: plane-cursor-legacy
[415.718682] Starting dynamic subtest: pipe-A-HDMI-A-1
[415.874705] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.156s)
[415.875406] Subtest plane-cursor-legacy: SUCCESS (0.158s)
[416.036905] [114/130] (610s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[416.123576] Starting subtest: bad-aux-stride-y-tiled-ccs
[416.125710] Starting dynamic subtest: pipe-A-HDMI-A-1
[416.132568] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[416.145118] Starting dynamic subtest: pipe-B-HDMI-A-1
[416.151998] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[416.164109] Starting dynamic subtest: pipe-C-HDMI-A-1
[416.170896] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[416.179095] Starting dynamic subtest: pipe-D-HDMI-A-1
[416.186282] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[416.187607] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.008s)
[416.379590] [115/130] (610s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[416.466340] Starting subtest: stress-xrgb8888-xtiled
[422.869848] Subtest stress-xrgb8888-xtiled: SUCCESS (6.403s)
[422.997631] [116/130] (604s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[423.086283] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[423.086996] Starting dynamic subtest: pipe-A
[423.223759] Dynamic subtest pipe-A: SUCCESS (0.137s)
[423.234034] Starting dynamic subtest: pipe-B
[423.360117] Dynamic subtest pipe-B: SUCCESS (0.135s)
[423.372532] Starting dynamic subtest: pipe-C
[423.485699] Dynamic subtest pipe-C: SUCCESS (0.124s)
[423.503342] Starting dynamic subtest: pipe-D
[423.621959] Dynamic subtest pipe-D: SUCCESS (0.135s)
[423.623762] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SUCCESS (0.537s)
[423.804842] [117/130] (603s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[423.893821] Starting subtest: fbc-shrfb-scaledprimary
[426.736241] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.842s)
[426.878622] [118/130] (600s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[426.976464] Starting subtest: x-tiled-64bpp-rotate-270
[427.016499] Subtest x-tiled-64bpp-rotate-270: SKIP (0.039s)
[427.151504] [119/130] (600s left) kms_flip (nonexisting-fb-interruptible)
[427.240147] Starting subtest: nonexisting-fb-interruptible
[427.242972] Starting dynamic subtest: A-HDMI-A1
[427.392158] Dynamic subtest A-HDMI-A1: SUCCESS (0.149s)
[427.404141] Starting dynamic subtest: B-HDMI-A1
[427.521136] Dynamic subtest B-HDMI-A1: SUCCESS (0.128s)
[427.533894] Starting dynamic subtest: C-HDMI-A1
[427.651904] Dynamic subtest C-HDMI-A1: SUCCESS (0.129s)
[427.663110] Starting dynamic subtest: D-HDMI-A1
[427.775899] Dynamic subtest D-HDMI-A1: SUCCESS (0.123s)
[427.778278] Subtest nonexisting-fb-interruptible: SUCCESS (0.538s)
[427.928841] [120/130] (599s left) kms_plane_lowres (tiling-4)
[428.012928] Starting subtest: tiling-4
[428.014260] Subtest tiling-4: SKIP (0.000s)
[428.091184] [121/130] (599s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[428.180606] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[428.181929] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[428.298664] [122/130] (599s left) kms_psr (pr-cursor-render)
[428.382584] Subtest pr-cursor-render: SKIP (0.000s)
[428.424968] [123/130] (598s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[428.512800] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[429.628165] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (1.116s)
[429.757501] [124/130] (597s left) kms_cursor_crc (cursor-onscreen-64x21)
[429.848130] Starting subtest: cursor-onscreen-64x21
[429.853047] Starting dynamic subtest: pipe-A-HDMI-A-1
[430.720828] Dynamic subtest pipe-A-HDMI-A-1: FAIL (0.692s)
[430.730037] Starting dynamic subtest: pipe-D-HDMI-A-1
[431.817574] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.234s)
[431.818328] Subtest cursor-onscreen-64x21: FAIL (1.970s)
[431.975311] [125/130] (595s left) perf_pmu (busy-idle-no-semaphores)
[432.013850] Starting subtest: busy-idle-no-semaphores
[432.014550] Starting dynamic subtest: rcs0
[432.659477] Dynamic subtest rcs0: SUCCESS (0.637s)
[432.670705] Starting dynamic subtest: bcs0
[433.288578] Dynamic subtest bcs0: SUCCESS (0.627s)
[433.300013] Starting dynamic subtest: vcs0
[433.920345] Dynamic subtest vcs0: SUCCESS (0.630s)
[433.932412] Starting dynamic subtest: vcs1
[434.543071] Dynamic subtest vcs1: SUCCESS (0.621s)
[434.554144] Starting dynamic subtest: vecs0
[435.172665] Dynamic subtest vecs0: SUCCESS (0.627s)
[435.173661] Subtest busy-idle-no-semaphores: SUCCESS (3.152s)
[435.272628] [126/130] (592s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[435.364946] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[435.365648] Starting dynamic subtest: pipe-A
[436.387550] Dynamic subtest pipe-A: SKIP (1.021s)
[436.399113] Starting dynamic subtest: pipe-B
[437.495077] Dynamic subtest pipe-B: SKIP (1.107s)
[437.503751] Starting dynamic subtest: pipe-C
[438.568802] Dynamic subtest pipe-C: SKIP (1.071s)
[438.577480] Starting dynamic subtest: pipe-D
[439.645771] Dynamic subtest pipe-D: SKIP (1.077s)
[439.647280] Subtest plane-scaler-with-clipping-clamping-rotation: SKIP (4.280s)
[439.848480] [127/130] (587s left) gem_mmap (short-mmap)
[439.890410] Starting subtest: short-mmap
[439.891109] Subtest short-mmap: SUCCESS (0.000s)
[440.012730] [128/130] (587s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[440.102668] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[440.103981] Subtest psr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[440.211621] [129/130] (587s left) gem_ctx_param (invalid-ctx-set)
[440.244855] Starting subtest: invalid-ctx-set
[440.245538] Subtest invalid-ctx-set: SUCCESS (0.000s)
[440.320263] [130/130] (587s left) i915_suspend (basic-s3-without-i915)
[440.352696] Starting subtest: basic-s3-without-i915