[97.604652] Initializing watchdogs
[97.604713]   /dev/watchdog0
[97.620287] [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]
[97.626261] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[97.628903] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[97.630847] [001/130] (960s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[97.721518] Starting subtest: bad-pixel-format-yf-tiled-ccs
[97.722267] Starting dynamic subtest: pipe-A-HDMI-A-1
[97.729145] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[97.735815] Starting dynamic subtest: pipe-B-HDMI-A-1
[97.742643] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[97.749382] Starting dynamic subtest: pipe-C-HDMI-A-1
[97.756138] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[97.762466] Starting dynamic subtest: pipe-D-HDMI-A-1
[97.769308] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[97.770652] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.005s)
[97.977538] [002/130] (960s left) kms_content_protection (dp-mst-type-0)
[98.069059] Starting subtest: dp-mst-type-0
[98.071448] Subtest dp-mst-type-0: SKIP (0.000s)
[98.201558] [003/130] (960s left) gem_exec_reloc (basic-cpu-read-active)
[98.241328] Starting subtest: basic-cpu-read-active
[98.372165] Subtest basic-cpu-read-active: SUCCESS (0.122s)
[98.507612] [004/130] (959s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[98.590395] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[98.591088] Starting dynamic subtest: pipe-A-HDMI-A-1
[98.597675] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[98.602542] Starting dynamic subtest: pipe-B-HDMI-A-1
[98.609030] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[98.613913] Starting dynamic subtest: pipe-C-HDMI-A-1
[98.627795] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[98.632594] Starting dynamic subtest: pipe-D-HDMI-A-1
[98.639289] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[98.640650] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s)
[98.829779] [005/130] (959s left) gem_mmap_offset (clear)
[98.862662] Starting subtest: clear
[98.863396] Starting dynamic subtest: smem0
[121.022781] Dynamic subtest smem0: SUCCESS (22.152s)
[121.023520] Subtest clear: SUCCESS (22.160s)
[121.169837] [006/130] (937s left) kms_feature_discovery (psr1)
[121.326050] Starting subtest: psr1
[121.327407] Subtest psr1: SKIP (0.000s)
[121.401922] [007/130] (936s left) kms_cursor_legacy (torture-move)
[121.486273] Starting subtest: torture-move
[121.486955] Starting dynamic subtest: pipe-A
[126.985794] Dynamic subtest pipe-A: SUCCESS (5.490s)
[126.991740] Starting dynamic subtest: pipe-B
[132.466422] Dynamic subtest pipe-B: SUCCESS (5.480s)
[132.474573] Starting dynamic subtest: pipe-C
[138.033835] Dynamic subtest pipe-C: SUCCESS (5.542s)
[138.040328] Starting dynamic subtest: pipe-D
[143.525279] Dynamic subtest pipe-D: SUCCESS (5.491s)
[143.536644] Starting dynamic subtest: all-pipes
[149.014860] Dynamic subtest all-pipes: SUCCESS (5.489s)
[149.015804] Subtest torture-move: SUCCESS (27.494s)
[149.094377] [008/130] (909s left) gem_softpin (evict-snoop)
[149.138777] Starting subtest: evict-snoop
[149.140109] Subtest evict-snoop: SKIP (0.000s)
[149.224707] [009/130] (909s left) gem_ppgtt (blt-vs-render-ctxn)
[149.259081] Starting subtest: blt-vs-render-ctxN
[181.803158] Subtest blt-vs-render-ctxN: SUCCESS (32.534s)
[181.932606] [010/130] (876s left) prime_vgem (fence-read-hang)
[182.063091] Subtest fence-read-hang: SKIP (0.000s)
[182.183018] [FACT prime_vgem (fence-read-hang)] new: kernel.kmod_is_loaded.vgem: true
[182.184612] [011/130] (876s left) i915_drm_fdinfo (memory-info-shared)
[182.218911] Starting subtest: memory-info-shared
[182.219698] Starting dynamic subtest: smem0
[182.263659] Dynamic subtest smem0: SUCCESS (0.044s)
[182.264458] Subtest memory-info-shared: SUCCESS (0.045s)
[182.349194] [012/130] (876s left) gem_exec_schedule (timeslicing)
[182.391170] Starting subtest: timeslicing
[182.391884] Starting dynamic subtest: rcs0
[182.394332] Dynamic subtest rcs0: SUCCESS (0.003s)
[182.401720] Starting dynamic subtest: bcs0
[182.402482] Dynamic subtest bcs0: SUCCESS (0.002s)
[182.408853] Starting dynamic subtest: vcs0
[182.409530] Dynamic subtest vcs0: SUCCESS (0.002s)
[182.415653] Starting dynamic subtest: vcs1
[182.416325] Dynamic subtest vcs1: SUCCESS (0.003s)
[182.422726] Starting dynamic subtest: vecs0
[182.423392] Dynamic subtest vecs0: SUCCESS (0.002s)
[182.424054] Subtest timeslicing: SUCCESS (0.014s)
[182.711535] [013/130] (875s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[182.805779] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[182.807126] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[182.934667] [014/130] (875s left) kms_async_flips (alternate-sync-async-flip-atomic)
[183.018617] Starting subtest: alternate-sync-async-flip-atomic
[183.146192] Starting dynamic subtest: pipe-A-HDMI-A-1
[185.259690] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.104s)
[185.389320] Starting dynamic subtest: pipe-B-HDMI-A-1
[187.477463] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.085s)
[187.595552] Starting dynamic subtest: pipe-C-HDMI-A-1
[189.685559] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.087s)
[189.824969] Starting dynamic subtest: pipe-D-HDMI-A-1
[191.908365] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.081s)
[191.909419] Subtest alternate-sync-async-flip-atomic: SUCCESS (8.882s)
[192.149174] [015/130] (866s left) api_intel_bb (simple-bb)
[192.185444] Starting subtest: simple-bb
[192.187852] Subtest simple-bb: SUCCESS (0.003s)
[192.319434] [016/130] (866s left) i915_hangman (engine-engine-error)
[192.360670] Starting subtest: engine-engine-error
[192.361330] Starting dynamic subtest: rcs0
[192.426753] Dynamic subtest rcs0: SUCCESS (0.065s)
[192.441436] Starting dynamic subtest: bcs0
[192.504946] Dynamic subtest bcs0: SUCCESS (0.077s)
[192.520247] Starting dynamic subtest: vcs0
[192.598921] Dynamic subtest vcs0: SUCCESS (0.093s)
[192.614421] Starting dynamic subtest: vcs1
[192.670822] Dynamic subtest vcs1: SUCCESS (0.071s)
[192.684809] Starting dynamic subtest: vecs0
[192.744711] Dynamic subtest vecs0: SUCCESS (0.073s)
[192.745726] Subtest engine-engine-error: SUCCESS (0.384s)
[192.885294] [017/130] (865s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[192.985659] Starting subtest: verify-pxp-execution-after-suspend-resume
[200.083976] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.100s)
[210.246459] [018/130] (858s left) syncobj_eventfd (timeline-wait)
[210.291987] Starting subtest: timeline-wait
[210.302099] Subtest timeline-wait: SUCCESS (0.011s)
[210.387525] [019/130] (858s left) gem_busy (extended)
[210.562459] Starting subtest: extended
[210.563460] Starting dynamic subtest: rcs0
[210.586616] Dynamic subtest rcs0: SUCCESS (0.033s)
[210.601713] Starting dynamic subtest: bcs0
[210.607062] Dynamic subtest bcs0: SUCCESS (0.020s)
[210.618163] Starting dynamic subtest: vcs0
[210.623911] Dynamic subtest vcs0: SUCCESS (0.017s)
[210.631974] Starting dynamic subtest: vcs1
[210.643191] Dynamic subtest vcs1: SUCCESS (0.019s)
[210.652648] Starting dynamic subtest: vecs0
[210.663014] Dynamic subtest vecs0: SUCCESS (0.018s)
[210.663792] Subtest extended: SUCCESS (0.108s)
[210.914311] [020/130] (858s left) syncobj_timeline (invalid-transfer-illegal-handle)
[210.946099] Starting subtest: invalid-transfer-illegal-handle
[210.946817] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[211.036960] [021/130] (857s left) gem_ctx_freq (sysfs)
[211.072478] Starting subtest: sysfs
[211.073176] Starting dynamic subtest: gt0
[216.033225] Dynamic subtest gt0: SUCCESS (4.958s)
[216.034315] Subtest sysfs: SUCCESS (4.959s)
[216.117353] [022/130] (852s left) kms_chamelium_edid (hdmi-edid-read)
[216.257551] Subtest hdmi-edid-read: SKIP (0.000s)
[216.349160] [023/130] (852s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[216.434326] Starting subtest: short-flip-before-cursor-toggle
[216.987463] Subtest short-flip-before-cursor-toggle: SUCCESS (0.553s)
[217.151785] [024/130] (851s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[217.239219] Starting subtest: cursor-rapid-movement-64x64
[217.244644] Starting dynamic subtest: pipe-A-HDMI-A-1
[217.498058] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.253s)
[217.529914] Starting dynamic subtest: pipe-D-HDMI-A-1
[217.725827] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.203s)
[217.726533] Subtest cursor-rapid-movement-64x64: SUCCESS (0.487s)
[217.882454] [025/130] (851s left) gem_exec_flush (basic-wb-prw-default)
[217.923031] Starting subtest: basic-wb-prw-default
[223.346082] Subtest basic-wb-prw-default: SUCCESS (5.423s)
[223.568228] [026/130] (845s left) kms_invalid_mode (bad-vtotal)
[223.657858] Starting subtest: bad-vtotal
[223.658539] Starting dynamic subtest: pipe-A-HDMI-A-1
[223.705721] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.047s)
[223.715969] Starting dynamic subtest: pipe-B-HDMI-A-1
[223.716680] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[223.724201] Starting dynamic subtest: pipe-C-HDMI-A-1
[223.724916] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[223.732397] Starting dynamic subtest: pipe-D-HDMI-A-1
[223.733132] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[223.733812] Subtest bad-vtotal: SUCCESS (0.056s)
[223.864610] [027/130] (845s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[223.898783] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[223.899508] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[223.984835] [028/130] (845s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[224.071671] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[224.073068] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[224.187574] [029/130] (845s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[224.271727] Starting subtest: primary-yf-tiled-reflect-x-270
[224.321445] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.050s)
[224.419704] [030/130] (844s left) gem_exec_schedule (preempt-queue-chain)
[224.465392] Starting subtest: preempt-queue-chain
[224.466061] Starting dynamic subtest: rcs0
[224.606267] Dynamic subtest rcs0: SUCCESS (0.134s)
[224.616865] Starting dynamic subtest: bcs0
[224.747737] Dynamic subtest bcs0: SUCCESS (0.141s)
[224.756304] Starting dynamic subtest: vcs0
[224.882817] Dynamic subtest vcs0: SUCCESS (0.134s)
[224.891314] Starting dynamic subtest: vcs1
[225.006455] Dynamic subtest vcs1: SUCCESS (0.131s)
[225.015445] Starting dynamic subtest: vecs0
[225.145952] Dynamic subtest vecs0: SUCCESS (0.132s)
[225.146668] Subtest preempt-queue-chain: SUCCESS (0.674s)
[225.455079] [031/130] (843s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[225.545772] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[225.547179] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[225.643806] [032/130] (843s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[225.731481] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[225.732782] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[225.911287] [033/130] (843s left) gem_exec_reloc (basic-cpu-active)
[225.950137] Starting subtest: basic-cpu-active
[226.080821] Subtest basic-cpu-active: SUCCESS (0.122s)
[226.218868] [034/130] (843s left) kms_lease (multimaster-lease)
[226.302688] Starting subtest: multimaster-lease
[226.304226] Subtest multimaster-lease: SUCCESS (0.002s)
[226.390190] [035/130] (843s left) kms_dp_linktrain_fallback (dsc-fallback)
[226.472784] Starting subtest: dsc-fallback
[226.474838] Subtest dsc-fallback: SKIP (0.000s)
[226.550744] [036/130] (843s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[226.636593] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[226.638051] Starting dynamic subtest: pipe-A-HDMI-A-1
[226.644376] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[226.651995] Starting dynamic subtest: pipe-B-HDMI-A-1
[226.658315] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[226.665691] Starting dynamic subtest: pipe-C-HDMI-A-1
[226.672041] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[226.679274] Starting dynamic subtest: pipe-D-HDMI-A-1
[226.685935] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[226.687286] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SKIP (0.005s)
[226.882764] [037/130] (842s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[226.970545] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[226.971951] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[227.082127] [038/130] (842s left) kms_psr (psr-primary-page-flip)
[227.165477] Subtest psr-primary-page-flip: SKIP (0.000s)
[227.204587] [039/130] (842s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[227.299351] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[227.300734] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[227.415768] [040/130] (842s left) kms_getfb (getfb2-handle-closed)
[227.500628] Starting subtest: getfb2-handle-closed
[227.501335] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[227.621708] [041/130] (842s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[227.710682] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[227.712031] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[227.823808] [042/130] (842s left) gem_lmem_swapping (heavy-verify-random)
[227.859452] Subtest heavy-verify-random: SKIP (0.000s)
[227.904290] [043/130] (842s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[227.991709] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[227.993105] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[228.096475] [044/130] (841s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[228.187329] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[228.188677] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[228.315582] [045/130] (841s left) gem_exec_gttfill (basic)
[228.356064] Starting subtest: basic
[231.852106] Subtest basic: SUCCESS (3.496s)
[232.059523] [046/130] (838s left) prime_busy (hang)
[232.141376] Starting subtest: hang
[232.142093] Starting dynamic subtest: rcs0
[245.856712] Dynamic subtest rcs0: SUCCESS (13.705s)
[245.863803] Starting dynamic subtest: bcs0
[252.601774] Dynamic subtest bcs0: SUCCESS (6.719s)
[252.609169] Starting dynamic subtest: vcs0
[259.577945] Dynamic subtest vcs0: SUCCESS (6.976s)
[259.585325] Starting dynamic subtest: vcs1
[266.591720] Dynamic subtest vcs1: SUCCESS (7.040s)
[266.598932] Starting dynamic subtest: vecs0
[273.594655] Dynamic subtest vecs0: SUCCESS (6.974s)
[273.595584] Subtest hang: SUCCESS (41.417s)
[273.701763] [047/130] (796s left) kms_psr (fbc-psr2-no-drrs)
[273.793127] Subtest fbc-psr2-no-drrs: SKIP (0.000s)
[273.836201] [048/130] (796s left) kms_vrr (flip-suspend)
[273.921660] Starting subtest: flip-suspend
[273.923681] Subtest flip-suspend: SKIP (0.000s)
[274.011931] [049/130] (796s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[274.049711] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[274.050387] Starting dynamic subtest: smem
[274.152206] Dynamic subtest smem: SUCCESS (0.102s)
[274.152932] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SUCCESS (0.103s)
[274.357856] [050/130] (795s left) kms_prime (basic-crc-hybrid)
[274.460536] Subtest basic-crc-hybrid: SKIP (0.000s)
[274.562362] [051/130] (795s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[274.650294] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[274.651700] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[274.772100] [052/130] (795s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[274.908429] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[275.006096] [053/130] (795s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[275.096591] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[276.404700] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (1.308s)
[276.563642] [054/130] (793s left) kms_flip (2x-flip-vs-panning)
[276.655322] Starting subtest: 2x-flip-vs-panning
[276.664300] Subtest 2x-flip-vs-panning: SKIP (0.009s)
[276.760358] [055/130] (793s left) gem_mmap_wc (write-gtt-read-wc)
[276.792605] Starting subtest: write-gtt-read-wc
[277.108433] Subtest write-gtt-read-wc: SUCCESS (0.308s)
[277.199995] [056/130] (793s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[277.295950] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[278.013399] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.717s)
[278.171785] [057/130] (792s left) kms_flip (2x-flip-vs-wf_vblank)
[278.256970] Starting subtest: 2x-flip-vs-wf_vblank
[278.266726] Subtest 2x-flip-vs-wf_vblank: SKIP (0.009s)
[278.351409] [058/130] (792s left) perf_pmu (semaphore-wait-idle)
[278.387161] Starting subtest: semaphore-wait-idle
[278.387869] Starting dynamic subtest: rcs0
[278.904748] Dynamic subtest rcs0: SUCCESS (0.509s)
[278.915179] Starting dynamic subtest: bcs0
[279.407856] Dynamic subtest bcs0: SUCCESS (0.510s)
[279.418535] Starting dynamic subtest: vcs0
[279.928625] Dynamic subtest vcs0: SUCCESS (0.511s)
[279.944174] Starting dynamic subtest: vcs1
[280.439593] Dynamic subtest vcs1: SUCCESS (0.510s)
[280.455162] Starting dynamic subtest: vecs0
[280.951219] Dynamic subtest vecs0: SUCCESS (0.510s)
[280.952143] Subtest semaphore-wait-idle: SUCCESS (2.556s)
[281.076177] [059/130] (789s left) i915_pm_rpm (gem-pread)
[282.468082] Starting subtest: gem-pread
[283.869369] Subtest gem-pread: SUCCESS (1.398s)
[284.010909] [060/130] (786s left) gem_exec_fence (long-history)
[284.346324] Starting subtest: long-history
[290.125578] Subtest long-history: SUCCESS (5.770s)
[290.616463] [061/130] (780s left) gem_lmem_swapping (parallel-random-engines)
[290.652700] Subtest parallel-random-engines: SKIP (0.000s)
[290.695228] [062/130] (780s left) syncobj_basic (bad-destroy)
[290.727269] Starting subtest: bad-destroy
[290.727951] Subtest bad-destroy: SUCCESS (0.000s)
[290.808869] [063/130] (779s left) kms_cursor_crc (cursor-offscreen-512x170)
[290.902599] Starting subtest: cursor-offscreen-512x170
[290.904754] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[291.022548] [064/130] (779s left) gem_ctx_persistence (hostile)
[291.058231] Starting subtest: hostile
[301.409358] Subtest hostile: SUCCESS (10.342s)
[301.545916] [065/130] (769s left) gem_exec_reloc (basic-cpu-read)
[301.581853] Starting subtest: basic-cpu-read
[301.587330] Subtest basic-cpu-read: SUCCESS (0.005s)
[301.732892] [066/130] (769s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[301.823743] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[301.864096] [067/130] (769s left) gem_exec_fence (syncobj-timeline-wait)
[302.318796] Starting subtest: syncobj-timeline-wait
[302.342458] Subtest syncobj-timeline-wait: SUCCESS (0.033s)
[302.557862] [068/130] (768s left) prime_mmap (test_userptr)
[302.590469] Starting subtest: test_userptr
[302.591188] Starting dynamic subtest: test_userptr-smem
[302.591889] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[302.592583] Subtest test_userptr: SUCCESS (0.001s)
[302.699423] [069/130] (768s left) gem_exec_store (dword)
[302.738491] Starting subtest: dword
[302.739219] Starting dynamic subtest: rcs0
[302.799738] Dynamic subtest rcs0: SUCCESS (0.060s)
[302.818565] Starting dynamic subtest: bcs0
[302.819327] Dynamic subtest bcs0: SUCCESS (0.017s)
[302.828030] Starting dynamic subtest: vcs0
[302.836015] Dynamic subtest vcs0: SUCCESS (0.017s)
[302.844194] Starting dynamic subtest: vcs1
[302.855036] Dynamic subtest vcs1: SUCCESS (0.018s)
[302.864311] Starting dynamic subtest: vecs0
[302.872839] Dynamic subtest vecs0: SUCCESS (0.017s)
[302.873516] Subtest dword: SUCCESS (0.135s)
[303.075532] [070/130] (768s left) kms_pm_rpm (legacy-planes)
[304.470094] Starting subtest: legacy-planes
[304.471165] Starting dynamic subtest: plane-63
[313.016855] Dynamic subtest plane-63: SUCCESS (8.546s)
[313.027745] Starting dynamic subtest: plane-93
[321.556448] Dynamic subtest plane-93: SUCCESS (8.538s)
[321.567127] Starting dynamic subtest: plane-123
[330.101677] Dynamic subtest plane-123: SUCCESS (8.544s)
[330.113084] Starting dynamic subtest: plane-133
[338.626514] Dynamic subtest plane-133: SUCCESS (8.523s)
[338.639071] Starting dynamic subtest: plane-143
[347.340869] Dynamic subtest plane-143: SUCCESS (8.713s)
[347.354422] Starting dynamic subtest: plane-153
[355.892093] Dynamic subtest plane-153: SUCCESS (8.549s)
[355.893137] Subtest legacy-planes: SUCCESS (51.423s)
[356.093319] [071/130] (715s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[356.181750] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[356.183108] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[356.301892] [072/130] (714s left) kms_psr (fbc-psr-suspend)
[356.384455] Subtest fbc-psr-suspend: SKIP (0.000s)
[356.430441] [073/130] (714s left) kms_big_fb (linear-32bpp-rotate-270)
[356.522514] Starting subtest: linear-32bpp-rotate-270
[356.595578] Subtest linear-32bpp-rotate-270: SKIP (0.072s)
[356.748623] [074/130] (714s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[356.784284] Starting subtest: basic-wc-gtt-noreloc
[356.787482] Subtest basic-wc-gtt-noreloc: SUCCESS (0.003s)
[356.920093] [075/130] (714s left) prime_mmap (test_correct)
[356.951599] Starting subtest: test_correct
[356.952288] Starting dynamic subtest: test_correct-smem
[356.954016] Dynamic subtest test_correct-smem: SUCCESS (0.002s)
[356.954708] Subtest test_correct: SUCCESS (0.003s)
[357.072746] [076/130] (714s left) kms_vblank (accuracy-idle)
[357.159691] Starting subtest: accuracy-idle
[357.161648] Starting dynamic subtest: pipe-A-HDMI-A-1
[358.338661] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.178s)
[358.349777] Starting dynamic subtest: pipe-D-HDMI-A-1
[359.489665] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.147s)
[359.490322] Subtest accuracy-idle: SUCCESS (2.331s)
[359.662619] [077/130] (711s left) perf (invalid-remove-userspace-config)
[359.777119] Starting subtest: invalid-remove-userspace-config
[359.786596] Subtest invalid-remove-userspace-config: SUCCESS (0.010s)
[359.827043] [078/130] (711s left) gem_madvise (dontneed-before-exec)
[359.857242] Starting subtest: dontneed-before-exec
[359.859704] Subtest dontneed-before-exec: SUCCESS (0.003s)
[359.993610] [079/130] (711s left) kms_chamelium_color (ctm-negative)
[360.080422] Subtest ctm-negative: SKIP (0.000s)
[360.124999] [080/130] (711s left) gem_mmap_wc (invalid-flags)
[360.157030] Starting subtest: invalid-flags
[360.157727] Subtest invalid-flags: SUCCESS (0.000s)
[360.284714] [081/130] (711s left) gem_exec_reloc (basic-gtt-wc)
[360.320643] Starting subtest: basic-gtt-wc
[360.327078] Subtest basic-gtt-wc: SUCCESS (0.006s)
[360.462829] [082/130] (711s left) syncobj_timeline (single-wait-all-available-signaled)
[360.502995] Starting subtest: single-wait-all-available-signaled
[360.503710] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[360.591639] [083/130] (711s left) gem_ctx_exec (basic-close-race)
[360.626224] Starting subtest: basic-close-race
[366.334035] Subtest basic-close-race: SUCCESS (5.673s)
[366.461920] [084/130] (705s left) gem_exec_balancer (parallel-out-fence)
[366.618939] Subtest parallel-out-fence: SKIP (0.000s)
[366.718151] [085/130] (704s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[366.805202] Starting subtest: flip-vs-cursor-legacy
[373.101557] Subtest flip-vs-cursor-legacy: SUCCESS (6.296s)
[373.259930] [086/130] (698s left) drm_read (fault-buffer)
[373.364647] Starting subtest: fault-buffer
[373.365377] Subtest fault-buffer: SUCCESS (0.001s)
[373.505373] [087/130] (698s left) gem_mmap_wc (pf-nonblock)
[373.538474] Starting subtest: pf-nonblock
[373.539740] Subtest pf-nonblock: SUCCESS (0.002s)
[373.673034] [088/130] (698s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[373.759711] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[373.761059] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[373.896370] [089/130] (697s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[373.983714] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[373.985067] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[374.123569] [090/130] (697s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[374.207871] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[374.209530] Starting dynamic subtest: pipe-A-valid-mode
[374.264541] Dynamic subtest pipe-A-valid-mode: SKIP (0.055s)
[374.265879] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.057s)
[374.396628] [091/130] (697s left) gem_spin_batch (spin-all-new)
[374.439050] Starting subtest: spin-all-new
[374.450652] Subtest spin-all-new: SUCCESS (0.012s)
[374.654219] [092/130] (697s left) core_sysfs (read-all-entries)
[374.684713] Starting subtest: read-all-entries
[374.688530] Subtest read-all-entries: SUCCESS (0.004s)
[374.778180] [093/130] (697s left) gem_exec_reloc (basic-range-active)
[374.814638] Starting subtest: basic-range-active
[374.851238] Subtest basic-range-active: SUCCESS (0.037s)
[374.988546] [094/130] (697s left) syncobj_timeline (single-wait-all-signaled)
[375.022071] Starting subtest: single-wait-all-signaled
[375.022792] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[375.112019] [095/130] (697s left) gen7_exec_parse (basic-offset)
[375.147973] Subtest basic-offset: SKIP (0.000s)
[375.196828] [096/130] (697s left) gem_ctx_shared (q-out-order)
[375.237196] Starting subtest: Q-out-order
[375.237911] Starting dynamic subtest: rcs0
[375.286901] Dynamic subtest rcs0: SUCCESS (0.049s)
[375.299336] Starting dynamic subtest: bcs0
[375.340400] Dynamic subtest bcs0: SUCCESS (0.052s)
[375.357938] Starting dynamic subtest: vcs0
[375.396989] Dynamic subtest vcs0: SUCCESS (0.055s)
[375.411132] Starting dynamic subtest: vcs1
[375.449499] Dynamic subtest vcs1: SUCCESS (0.051s)
[375.462876] Starting dynamic subtest: vecs0
[375.500841] Dynamic subtest vecs0: SUCCESS (0.049s)
[375.501871] Subtest Q-out-order: SUCCESS (0.264s)
[375.704681] [097/130] (696s left) gem_exec_flush (basic-batch-kernel-default-wb)
[375.744302] Starting subtest: basic-batch-kernel-default-wb
[381.304140] Subtest basic-batch-kernel-default-wb: SUCCESS (5.560s)
[381.514101] [098/130] (690s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[381.605917] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[381.607296] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[381.712770] [099/130] (690s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[381.799894] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[381.844452] [100/130] (690s left) kms_psr2_su (page_flip-xrgb8888)
[381.876963] Subtest page_flip-XRGB8888: SKIP (0.000s)
[381.918278] [101/130] (690s left) kms_psr (psr-basic)
[382.003425] Subtest psr-basic: SKIP (0.000s)
[382.043994] [102/130] (690s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[382.131590] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[382.132919] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[382.255174] [103/130] (690s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[382.347953] Starting subtest: yf-tiled-8bpp-rotate-90
[382.349328] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[382.472163] [104/130] (690s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[382.566055] Starting subtest: yf-tiled-16bpp-rotate-90
[382.567379] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[382.679940] [105/130] (689s left) kms_flip (flip-vs-blocking-wf-vblank)
[382.766740] Starting subtest: flip-vs-blocking-wf-vblank
[382.769204] Starting dynamic subtest: A-HDMI-A1
[390.601381] Dynamic subtest A-HDMI-A1: SUCCESS (7.813s)
[390.609325] Starting dynamic subtest: B-HDMI-A1
[398.406122] Dynamic subtest B-HDMI-A1: SUCCESS (7.793s)
[398.413773] Starting dynamic subtest: C-HDMI-A1
[406.194982] Dynamic subtest C-HDMI-A1: SUCCESS (7.787s)
[406.203035] Starting dynamic subtest: D-HDMI-A1
[413.973397] Dynamic subtest D-HDMI-A1: SUCCESS (7.801s)
[413.974079] Subtest flip-vs-blocking-wf-vblank: SUCCESS (31.206s)
[414.149779] [106/130] (658s left) gem_userptr_blits (stress-purge)
[414.194213] Starting subtest: stress-purge
[419.606478] Subtest stress-purge: SUCCESS (5.412s)
[419.766482] [107/130] (652s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[419.845487] Starting subtest: no-spare-fences-busy-interruptible
[422.028464] Subtest no-spare-fences-busy-interruptible: SUCCESS (2.182s)
[422.163740] [108/130] (650s left) gem_exec_balancer (nop)
[422.205228] Starting subtest: nop
[460.297898] Subtest nop: SUCCESS (38.093s)
[460.505362] [109/130] (612s left) gem_eio (in-flight-external)
[460.547032] Starting subtest: in-flight-external
[460.810918] Subtest in-flight-external: SUCCESS (0.263s)
[460.955042] [110/130] (611s left) kms_flip (2x-blocking-absolute-wf_vblank)
[461.041080] Starting subtest: 2x-blocking-absolute-wf_vblank
[461.050031] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.009s)
[461.134080] [111/130] (611s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[461.222530] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[461.232228] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.009s)
[461.323587] [112/130] (611s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[461.413780] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[461.415085] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[461.522999] [113/130] (611s left) kms_atomic (plane-cursor-legacy)
[461.608925] Starting subtest: plane-cursor-legacy
[461.610653] Starting dynamic subtest: pipe-A-HDMI-A-1
[461.769037] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.158s)
[461.769784] Subtest plane-cursor-legacy: SUCCESS (0.160s)
[461.914841] [114/130] (611s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[462.001013] Starting subtest: bad-aux-stride-y-tiled-ccs
[462.001731] Starting dynamic subtest: pipe-A-HDMI-A-1
[462.008504] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[462.016897] Starting dynamic subtest: pipe-B-HDMI-A-1
[462.023485] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[462.032561] Starting dynamic subtest: pipe-C-HDMI-A-1
[462.039119] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[462.048482] Starting dynamic subtest: pipe-D-HDMI-A-1
[462.055218] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[462.056546] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.007s)
[462.253118] [115/130] (610s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[462.341918] Starting subtest: stress-xrgb8888-xtiled
[468.646959] Subtest stress-xrgb8888-xtiled: SUCCESS (6.306s)
[468.781894] [116/130] (604s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[468.871406] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[468.872319] Starting dynamic subtest: pipe-A
[468.999374] Dynamic subtest pipe-A: SUCCESS (0.128s)
[469.009087] Starting dynamic subtest: pipe-B
[469.125211] Dynamic subtest pipe-B: SUCCESS (0.125s)
[469.134822] Starting dynamic subtest: pipe-C
[469.260782] Dynamic subtest pipe-C: SUCCESS (0.135s)
[469.270970] Starting dynamic subtest: pipe-D
[469.393759] Dynamic subtest pipe-D: SUCCESS (0.132s)
[469.394480] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SUCCESS (0.523s)
[469.596875] [117/130] (603s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[469.687659] Starting subtest: fbc-shrfb-scaledprimary
[472.569894] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.882s)
[472.746191] [118/130] (600s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[472.845507] Starting subtest: x-tiled-64bpp-rotate-270
[472.894543] Subtest x-tiled-64bpp-rotate-270: SKIP (0.047s)
[473.045888] [119/130] (600s left) kms_flip (nonexisting-fb-interruptible)
[473.135714] Starting subtest: nonexisting-fb-interruptible
[473.137467] Starting dynamic subtest: A-HDMI-A1
[473.296312] Dynamic subtest A-HDMI-A1: SUCCESS (0.159s)
[473.306702] Starting dynamic subtest: B-HDMI-A1
[473.437327] Dynamic subtest B-HDMI-A1: SUCCESS (0.140s)
[473.447494] Starting dynamic subtest: C-HDMI-A1
[473.566631] Dynamic subtest C-HDMI-A1: SUCCESS (0.128s)
[473.576427] Starting dynamic subtest: D-HDMI-A1
[473.695288] Dynamic subtest D-HDMI-A1: SUCCESS (0.127s)
[473.697740] Subtest nonexisting-fb-interruptible: SUCCESS (0.563s)
[473.850142] [120/130] (599s left) kms_plane_lowres (tiling-4)
[473.934487] Starting subtest: tiling-4
[473.935912] Subtest tiling-4: SKIP (0.000s)
[474.047549] [121/130] (599s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[474.135722] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[474.137084] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[474.253996] [122/130] (599s left) kms_psr (pr-cursor-render)
[474.339783] Subtest pr-cursor-render: SKIP (0.000s)
[474.386015] [123/130] (598s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[474.474702] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[475.581459] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (1.107s)
[475.729799] [124/130] (597s left) kms_cursor_crc (cursor-onscreen-64x21)
[475.825215] Starting subtest: cursor-onscreen-64x21
[475.830393] Starting dynamic subtest: pipe-A-HDMI-A-1
[476.686048] Dynamic subtest pipe-A-HDMI-A-1: FAIL (0.683s)
[476.694855] Starting dynamic subtest: pipe-D-HDMI-A-1
[477.802176] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.250s)
[477.802895] Subtest cursor-onscreen-64x21: FAIL (1.978s)
[477.983254] [125/130] (595s left) perf_pmu (busy-idle-no-semaphores)
[478.019604] Starting subtest: busy-idle-no-semaphores
[478.020303] Starting dynamic subtest: rcs0
[478.680026] Dynamic subtest rcs0: SUCCESS (0.651s)
[478.691738] Starting dynamic subtest: bcs0
[479.311124] Dynamic subtest bcs0: SUCCESS (0.629s)
[479.323210] Starting dynamic subtest: vcs0
[479.934062] Dynamic subtest vcs0: SUCCESS (0.621s)
[479.945107] Starting dynamic subtest: vcs1
[480.572695] Dynamic subtest vcs1: SUCCESS (0.636s)
[480.584367] Starting dynamic subtest: vecs0
[481.194979] Dynamic subtest vecs0: SUCCESS (0.620s)
[481.196027] Subtest busy-idle-no-semaphores: SUCCESS (3.168s)
[481.295227] [126/130] (592s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[481.381920] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[481.382608] Starting dynamic subtest: pipe-A
[482.441414] Dynamic subtest pipe-A: SKIP (1.058s)
[482.450150] Starting dynamic subtest: pipe-B
[483.528826] Dynamic subtest pipe-B: SKIP (1.087s)
[483.537558] Starting dynamic subtest: pipe-C
[484.642338] Dynamic subtest pipe-C: SKIP (1.112s)
[484.650829] Starting dynamic subtest: pipe-D
[485.769842] Dynamic subtest pipe-D: SKIP (1.126s)
[485.771376] Subtest plane-scaler-with-clipping-clamping-rotation: SKIP (4.387s)
[485.966908] [127/130] (587s left) gem_mmap (short-mmap)
[486.009896] Starting subtest: short-mmap
[486.010637] Subtest short-mmap: SUCCESS (0.000s)
[486.122776] [128/130] (587s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[486.212687] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[486.214019] Subtest psr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[486.313408] [129/130] (587s left) gem_ctx_param (invalid-ctx-set)
[486.346809] Starting subtest: invalid-ctx-set
[486.347470] Subtest invalid-ctx-set: SUCCESS (0.000s)
[486.422568] [130/130] (587s left) i915_suspend (basic-s3-without-i915)
[486.454031] Starting subtest: basic-s3-without-i915