[42.972351] Initializing watchdogs
[42.972430]   /dev/watchdog0
[42.988033] [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]
[42.993571] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[42.996058] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[42.997886] [001/130] (960s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[43.086690] Starting subtest: bad-pixel-format-yf-tiled-ccs
[43.087397] Starting dynamic subtest: pipe-A-HDMI-A-1
[43.094190] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[43.099257] Starting dynamic subtest: pipe-B-HDMI-A-1
[43.105880] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[43.111086] Starting dynamic subtest: pipe-C-HDMI-A-1
[43.117720] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[43.123147] Starting dynamic subtest: pipe-D-HDMI-A-1
[43.129753] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[43.131071] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s)
[43.330824] [002/130] (960s left) kms_content_protection (dp-mst-type-0)
[43.423389] Starting subtest: dp-mst-type-0
[43.424718] Subtest dp-mst-type-0: SKIP (0.000s)
[43.535277] [003/130] (960s left) gem_exec_reloc (basic-cpu-read-active)
[43.574547] Starting subtest: basic-cpu-read-active
[43.706272] Subtest basic-cpu-read-active: SUCCESS (0.123s)
[43.837941] [004/130] (959s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[43.921728] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[43.922414] Starting dynamic subtest: pipe-A-HDMI-A-1
[43.929103] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[43.934239] Starting dynamic subtest: pipe-B-HDMI-A-1
[43.940975] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[43.945999] Starting dynamic subtest: pipe-C-HDMI-A-1
[43.952835] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[43.959128] Starting dynamic subtest: pipe-D-HDMI-A-1
[43.966157] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[43.967537] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s)
[44.162641] [005/130] (959s left) gem_mmap_offset (clear)
[44.194093] Starting subtest: clear
[44.195186] Starting dynamic subtest: smem0
[67.448690] Dynamic subtest smem0: SUCCESS (23.203s)
[67.449402] Subtest clear: SUCCESS (23.203s)
[67.662668] [006/130] (936s left) kms_feature_discovery (psr1)
[67.823530] Starting subtest: psr1
[67.824986] Subtest psr1: SKIP (0.000s)
[67.895877] [007/130] (935s left) kms_cursor_legacy (torture-move)
[67.982617] Starting subtest: torture-move
[67.983343] Starting dynamic subtest: pipe-A
[73.746077] Dynamic subtest pipe-A: SUCCESS (5.761s)
[73.752344] Starting dynamic subtest: pipe-B
[79.285536] Dynamic subtest pipe-B: SUCCESS (5.530s)
[79.291490] Starting dynamic subtest: pipe-C
[84.767856] Dynamic subtest pipe-C: SUCCESS (5.482s)
[84.774183] Starting dynamic subtest: pipe-D
[90.256141] Dynamic subtest pipe-D: SUCCESS (5.462s)
[90.263949] Starting dynamic subtest: all-pipes
[95.713145] Dynamic subtest all-pipes: SUCCESS (5.457s)
[95.714056] Subtest torture-move: SUCCESS (27.694s)
[95.788543] [008/130] (907s left) gem_softpin (evict-snoop)
[95.834913] Starting subtest: evict-snoop
[95.836404] Subtest evict-snoop: SKIP (0.000s)
[95.919918] [009/130] (907s left) gem_ppgtt (blt-vs-render-ctxn)
[95.955412] Starting subtest: blt-vs-render-ctxN
[128.413928] Subtest blt-vs-render-ctxN: SUCCESS (32.447s)
[128.560067] [010/130] (875s left) prime_vgem (fence-read-hang)
[128.737866] Subtest fence-read-hang: SKIP (0.000s)
[128.870551] [FACT prime_vgem (fence-read-hang)] new: kernel.kmod_is_loaded.vgem: true
[128.871959] [011/130] (875s left) i915_drm_fdinfo (memory-info-shared)
[128.906433] Starting subtest: memory-info-shared
[128.907129] Starting dynamic subtest: smem0
[128.949806] Dynamic subtest smem0: SUCCESS (0.043s)
[128.950497] Subtest memory-info-shared: SUCCESS (0.044s)
[129.037122] [012/130] (874s left) gem_exec_schedule (timeslicing)
[129.077578] Starting subtest: timeslicing
[129.078316] Starting dynamic subtest: rcs0
[129.081194] Dynamic subtest rcs0: SUCCESS (0.004s)
[129.089179] Starting dynamic subtest: bcs0
[129.089930] Dynamic subtest bcs0: SUCCESS (0.003s)
[129.097127] Starting dynamic subtest: vcs0
[129.097789] Dynamic subtest vcs0: SUCCESS (0.003s)
[129.103712] Starting dynamic subtest: vcs1
[129.104379] Dynamic subtest vcs1: SUCCESS (0.003s)
[129.110308] Starting dynamic subtest: vecs0
[129.110973] Dynamic subtest vecs0: SUCCESS (0.003s)
[129.111627] Subtest timeslicing: SUCCESS (0.016s)
[129.412208] [013/130] (874s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[129.505506] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[129.506875] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[129.613322] [014/130] (874s left) kms_async_flips (alternate-sync-async-flip-atomic)
[129.696371] Starting subtest: alternate-sync-async-flip-atomic
[129.810716] Starting dynamic subtest: pipe-A-HDMI-A-1
[131.934020] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.114s)
[132.062421] Starting dynamic subtest: pipe-B-HDMI-A-1
[134.150993] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.086s)
[134.277716] Starting dynamic subtest: pipe-C-HDMI-A-1
[136.360861] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.083s)
[136.496152] Starting dynamic subtest: pipe-D-HDMI-A-1
[138.589845] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.091s)
[138.591800] Subtest alternate-sync-async-flip-atomic: SUCCESS (8.885s)
[138.820454] [015/130] (865s left) api_intel_bb (simple-bb)
[138.856750] Starting subtest: simple-bb
[138.859440] Subtest simple-bb: SUCCESS (0.003s)
[138.981355] [016/130] (865s left) i915_hangman (engine-engine-error)
[139.022138] Starting subtest: engine-engine-error
[139.022836] Starting dynamic subtest: rcs0
[139.094994] Dynamic subtest rcs0: SUCCESS (0.072s)
[139.112155] Starting dynamic subtest: bcs0
[139.189856] Dynamic subtest bcs0: SUCCESS (0.094s)
[139.208133] Starting dynamic subtest: vcs0
[139.270855] Dynamic subtest vcs0: SUCCESS (0.080s)
[139.288238] Starting dynamic subtest: vcs1
[139.364030] Dynamic subtest vcs1: SUCCESS (0.092s)
[139.382135] Starting dynamic subtest: vecs0
[139.447085] Dynamic subtest vecs0: SUCCESS (0.082s)
[139.448245] Subtest engine-engine-error: SUCCESS (0.425s)
[139.581859] [017/130] (864s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[139.681457] Starting subtest: verify-pxp-execution-after-suspend-resume
[146.776424] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.096s)
[155.959485] [018/130] (857s left) syncobj_eventfd (timeline-wait)
[156.016445] Starting subtest: timeline-wait
[156.027189] Subtest timeline-wait: SUCCESS (0.011s)
[156.119019] [019/130] (857s left) gem_busy (extended)
[156.292911] Starting subtest: extended
[156.293878] Starting dynamic subtest: rcs0
[156.311285] Dynamic subtest rcs0: SUCCESS (0.028s)
[156.324939] Starting dynamic subtest: bcs0
[156.336065] Dynamic subtest bcs0: SUCCESS (0.024s)
[156.346730] Starting dynamic subtest: vcs0
[156.361413] Dynamic subtest vcs0: SUCCESS (0.025s)
[156.372953] Starting dynamic subtest: vcs1
[156.390503] Dynamic subtest vcs1: SUCCESS (0.028s)
[156.403477] Starting dynamic subtest: vecs0
[156.421690] Dynamic subtest vecs0: SUCCESS (0.030s)
[156.423052] Subtest extended: SUCCESS (0.139s)
[156.662205] [020/130] (856s left) syncobj_timeline (invalid-transfer-illegal-handle)
[156.694980] Starting subtest: invalid-transfer-illegal-handle
[156.695741] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[156.784697] [021/130] (856s left) gem_ctx_freq (sysfs)
[156.821424] Starting subtest: sysfs
[156.822152] Starting dynamic subtest: gt0
[161.814259] Dynamic subtest gt0: SUCCESS (4.993s)
[161.815318] Subtest sysfs: SUCCESS (4.993s)
[161.905731] [022/130] (851s left) kms_chamelium_edid (hdmi-edid-read)
[162.046711] Subtest hdmi-edid-read: SKIP (0.000s)
[162.145738] [023/130] (851s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[162.231492] Starting subtest: short-flip-before-cursor-toggle
[162.776081] Subtest short-flip-before-cursor-toggle: SUCCESS (0.545s)
[162.918530] [024/130] (850s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[163.007800] Starting subtest: cursor-rapid-movement-64x64
[163.012530] Starting dynamic subtest: pipe-A-HDMI-A-1
[163.263376] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.251s)
[163.297768] Starting dynamic subtest: pipe-D-HDMI-A-1
[163.499289] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.209s)
[163.499948] Subtest cursor-rapid-movement-64x64: SUCCESS (0.492s)
[163.679482] [025/130] (849s left) gem_exec_flush (basic-wb-prw-default)
[163.720122] Starting subtest: basic-wb-prw-default
[169.150345] Subtest basic-wb-prw-default: SUCCESS (5.430s)
[169.367552] [026/130] (844s left) kms_invalid_mode (bad-vtotal)
[169.452975] Starting subtest: bad-vtotal
[169.453681] Starting dynamic subtest: pipe-A-HDMI-A-1
[169.502532] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.049s)
[169.513223] Starting dynamic subtest: pipe-B-HDMI-A-1
[169.513958] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[169.521653] Starting dynamic subtest: pipe-C-HDMI-A-1
[169.522396] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[169.529743] Starting dynamic subtest: pipe-D-HDMI-A-1
[169.530442] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[169.531153] Subtest bad-vtotal: SUCCESS (0.056s)
[169.656409] [027/130] (843s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[169.690156] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[169.690863] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[169.777300] [028/130] (843s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[169.864420] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[169.865770] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[169.978499] [029/130] (843s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[170.062353] Starting subtest: primary-yf-tiled-reflect-x-270
[170.113501] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.050s)
[170.220637] [030/130] (843s left) gem_exec_schedule (preempt-queue-chain)
[170.264587] Starting subtest: preempt-queue-chain
[170.265324] Starting dynamic subtest: rcs0
[170.410837] Dynamic subtest rcs0: SUCCESS (0.137s)
[170.419155] Starting dynamic subtest: bcs0
[170.540771] Dynamic subtest bcs0: SUCCESS (0.130s)
[170.548669] Starting dynamic subtest: vcs0
[170.672277] Dynamic subtest vcs0: SUCCESS (0.131s)
[170.680741] Starting dynamic subtest: vcs1
[170.809817] Dynamic subtest vcs1: SUCCESS (0.137s)
[170.817939] Starting dynamic subtest: vecs0
[170.936576] Dynamic subtest vecs0: SUCCESS (0.127s)
[170.937314] Subtest preempt-queue-chain: SUCCESS (0.664s)
[171.253977] [031/130] (842s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[171.343577] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[171.344943] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[171.461647] [032/130] (842s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[171.545583] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[171.546930] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[171.730861] [033/130] (842s left) gem_exec_reloc (basic-cpu-active)
[171.770073] Starting subtest: basic-cpu-active
[171.898489] Subtest basic-cpu-active: SUCCESS (0.119s)
[172.028905] [034/130] (841s left) kms_lease (multimaster-lease)
[172.113651] Starting subtest: multimaster-lease
[172.115164] Subtest multimaster-lease: SUCCESS (0.002s)
[172.198738] [035/130] (841s left) kms_dp_linktrain_fallback (dsc-fallback)
[172.281681] Starting subtest: dsc-fallback
[172.283655] Subtest dsc-fallback: SKIP (0.000s)
[172.369658] [036/130] (841s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[172.453667] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[172.454374] Starting dynamic subtest: pipe-A-HDMI-A-1
[172.461086] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[172.468860] Starting dynamic subtest: pipe-B-HDMI-A-1
[172.475565] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[172.483246] Starting dynamic subtest: pipe-C-HDMI-A-1
[172.490032] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[172.497507] Starting dynamic subtest: pipe-D-HDMI-A-1
[172.511230] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[172.512661] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SKIP (0.005s)
[172.693672] [037/130] (841s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[172.782534] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[172.783924] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[172.901822] [038/130] (841s left) kms_psr (psr-primary-page-flip)
[172.987223] Subtest psr-primary-page-flip: SKIP (0.000s)
[173.029945] [039/130] (841s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[173.126428] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[173.127769] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[173.240801] [040/130] (840s left) kms_getfb (getfb2-handle-closed)
[173.323650] Starting subtest: getfb2-handle-closed
[173.324312] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[173.442664] [041/130] (840s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[173.529659] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[173.531043] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[173.643962] [042/130] (840s left) gem_lmem_swapping (heavy-verify-random)
[173.680112] Subtest heavy-verify-random: SKIP (0.000s)
[173.722110] [043/130] (840s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[173.808338] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[173.809727] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[173.906346] [044/130] (840s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[173.993679] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[173.995079] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[174.107448] [045/130] (840s left) gem_exec_gttfill (basic)
[174.148769] Starting subtest: basic
[177.509996] Subtest basic: SUCCESS (3.362s)
[177.711882] [046/130] (836s left) prime_busy (hang)
[177.800598] Starting subtest: hang
[177.801314] Starting dynamic subtest: rcs0
[191.583835] Dynamic subtest rcs0: SUCCESS (13.774s)
[191.590958] Starting dynamic subtest: bcs0
[198.585141] Dynamic subtest bcs0: SUCCESS (6.975s)
[198.592158] Starting dynamic subtest: vcs0
[205.535580] Dynamic subtest vcs0: SUCCESS (6.975s)
[205.542621] Starting dynamic subtest: vcs1
[212.575630] Dynamic subtest vcs1: SUCCESS (7.040s)
[212.583007] Starting dynamic subtest: vecs0
[219.578885] Dynamic subtest vecs0: SUCCESS (6.976s)
[219.579797] Subtest hang: SUCCESS (41.742s)
[219.667524] [047/130] (794s left) kms_psr (fbc-psr2-no-drrs)
[219.758077] Subtest fbc-psr2-no-drrs: SKIP (0.000s)
[219.796083] [048/130] (794s left) kms_vrr (flip-suspend)
[219.880914] Starting subtest: flip-suspend
[219.882951] Subtest flip-suspend: SKIP (0.000s)
[219.963998] [049/130] (794s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[220.002527] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[220.003221] Starting dynamic subtest: smem
[220.105425] Dynamic subtest smem: SUCCESS (0.103s)
[220.106155] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SUCCESS (0.104s)
[220.308526] [050/130] (794s left) kms_prime (basic-crc-hybrid)
[220.410368] Subtest basic-crc-hybrid: SKIP (0.000s)
[220.509432] [051/130] (794s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[220.599440] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[220.600761] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[220.722903] [052/130] (793s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[220.859259] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[220.948851] [053/130] (793s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[221.036333] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[222.346717] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (1.310s)
[222.507663] [054/130] (792s left) kms_flip (2x-flip-vs-panning)
[222.597025] Starting subtest: 2x-flip-vs-panning
[222.605947] Subtest 2x-flip-vs-panning: SKIP (0.009s)
[222.702417] [055/130] (792s left) gem_mmap_wc (write-gtt-read-wc)
[222.734593] Starting subtest: write-gtt-read-wc
[223.049809] Subtest write-gtt-read-wc: SUCCESS (0.307s)
[223.149346] [056/130] (791s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[223.247993] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[223.905361] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.657s)
[224.080063] [057/130] (790s left) kms_flip (2x-flip-vs-wf_vblank)
[224.166284] Starting subtest: 2x-flip-vs-wf_vblank
[224.175527] Subtest 2x-flip-vs-wf_vblank: SKIP (0.009s)
[224.267973] [058/130] (790s left) perf_pmu (semaphore-wait-idle)
[224.303020] Starting subtest: semaphore-wait-idle
[224.303738] Starting dynamic subtest: rcs0
[224.820320] Dynamic subtest rcs0: SUCCESS (0.508s)
[224.831342] Starting dynamic subtest: bcs0
[225.331700] Dynamic subtest bcs0: SUCCESS (0.510s)
[225.342221] Starting dynamic subtest: vcs0
[225.842983] Dynamic subtest vcs0: SUCCESS (0.510s)
[225.853301] Starting dynamic subtest: vcs1
[226.354568] Dynamic subtest vcs1: SUCCESS (0.510s)
[226.365135] Starting dynamic subtest: vecs0
[226.866137] Dynamic subtest vecs0: SUCCESS (0.511s)
[226.866835] Subtest semaphore-wait-idle: SUCCESS (2.555s)
[226.965909] [059/130] (787s left) i915_pm_rpm (gem-pread)
[228.367749] Starting subtest: gem-pread
[229.759908] Subtest gem-pread: SUCCESS (1.393s)
[229.886811] [060/130] (785s left) gem_exec_fence (long-history)
[230.216037] Starting subtest: long-history
[236.009722] Subtest long-history: SUCCESS (5.785s)
[236.559832] [061/130] (778s left) gem_lmem_swapping (parallel-random-engines)
[236.596354] Subtest parallel-random-engines: SKIP (0.000s)
[236.640666] [062/130] (778s left) syncobj_basic (bad-destroy)
[236.672136] Starting subtest: bad-destroy
[236.672826] Subtest bad-destroy: SUCCESS (0.000s)
[236.762382] [063/130] (778s left) kms_cursor_crc (cursor-offscreen-512x170)
[236.852684] Starting subtest: cursor-offscreen-512x170
[236.854828] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[236.965326] [064/130] (778s left) gem_ctx_persistence (hostile)
[237.000253] Starting subtest: hostile
[247.648476] Subtest hostile: SUCCESS (10.639s)
[247.777173] [065/130] (767s left) gem_exec_reloc (basic-cpu-read)
[247.813693] Starting subtest: basic-cpu-read
[247.818630] Subtest basic-cpu-read: SUCCESS (0.005s)
[247.958042] [066/130] (767s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[248.050052] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[248.091408] [067/130] (767s left) gem_exec_fence (syncobj-timeline-wait)
[248.551650] Starting subtest: syncobj-timeline-wait
[248.570456] Subtest syncobj-timeline-wait: SUCCESS (0.028s)
[248.761431] [068/130] (766s left) prime_mmap (test_userptr)
[248.794368] Starting subtest: test_userptr
[248.795059] Starting dynamic subtest: test_userptr-smem
[248.795728] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[248.796399] Subtest test_userptr: SUCCESS (0.001s)
[248.901918] [069/130] (766s left) gem_exec_store (dword)
[248.940986] Starting subtest: dword
[248.941726] Starting dynamic subtest: rcs0
[248.990895] Dynamic subtest rcs0: SUCCESS (0.049s)
[249.009922] Starting dynamic subtest: bcs0
[249.029700] Dynamic subtest bcs0: SUCCESS (0.037s)
[249.045797] Starting dynamic subtest: vcs0
[249.052109] Dynamic subtest vcs0: SUCCESS (0.021s)
[249.061015] Starting dynamic subtest: vcs1
[249.077658] Dynamic subtest vcs1: SUCCESS (0.025s)
[249.090142] Starting dynamic subtest: vecs0
[249.101166] Dynamic subtest vecs0: SUCCESS (0.023s)
[249.102045] Subtest dword: SUCCESS (0.161s)
[249.303605] [070/130] (766s left) kms_pm_rpm (legacy-planes)
[250.697865] Starting subtest: legacy-planes
[250.698835] Starting dynamic subtest: plane-63
[259.252288] Dynamic subtest plane-63: SUCCESS (8.555s)
[259.263145] Starting dynamic subtest: plane-93
[267.507925] Dynamic subtest plane-93: SUCCESS (8.254s)
[267.525906] Starting dynamic subtest: plane-123
[275.928847] Dynamic subtest plane-123: SUCCESS (8.411s)
[275.949544] Starting dynamic subtest: plane-133
[284.556108] Dynamic subtest plane-133: SUCCESS (8.634s)
[284.578065] Starting dynamic subtest: plane-143
[293.214953] Dynamic subtest plane-143: SUCCESS (8.648s)
[293.240155] Starting dynamic subtest: plane-153
[301.648669] Dynamic subtest plane-153: SUCCESS (8.440s)
[301.649790] Subtest legacy-planes: SUCCESS (50.953s)
[301.842543] [071/130] (713s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[301.933346] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[301.934777] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[302.042840] [072/130] (713s left) kms_psr (fbc-psr-suspend)
[302.125469] Subtest fbc-psr-suspend: SKIP (0.000s)
[302.167122] [073/130] (713s left) kms_big_fb (linear-32bpp-rotate-270)
[302.258642] Starting subtest: linear-32bpp-rotate-270
[302.329429] Subtest linear-32bpp-rotate-270: SKIP (0.070s)
[302.476007] [074/130] (713s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[302.513560] Starting subtest: basic-wc-gtt-noreloc
[302.517305] Subtest basic-wc-gtt-noreloc: SUCCESS (0.004s)
[302.647911] [075/130] (712s left) prime_mmap (test_correct)
[302.679646] Starting subtest: test_correct
[302.680339] Starting dynamic subtest: test_correct-smem
[302.681915] Dynamic subtest test_correct-smem: SUCCESS (0.002s)
[302.682605] Subtest test_correct: SUCCESS (0.003s)
[302.810147] [076/130] (712s left) kms_vblank (accuracy-idle)
[302.894849] Starting subtest: accuracy-idle
[302.896470] Starting dynamic subtest: pipe-A-HDMI-A-1
[304.078067] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.181s)
[304.090678] Starting dynamic subtest: pipe-D-HDMI-A-1
[305.229286] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.147s)
[305.230039] Subtest accuracy-idle: SUCCESS (2.334s)
[305.390135] [077/130] (710s left) perf (invalid-remove-userspace-config)
[305.492093] Starting subtest: invalid-remove-userspace-config
[305.502223] Subtest invalid-remove-userspace-config: SUCCESS (0.010s)
[305.547728] [078/130] (710s left) gem_madvise (dontneed-before-exec)
[305.578729] Starting subtest: dontneed-before-exec
[305.581101] Subtest dontneed-before-exec: SUCCESS (0.003s)
[305.713783] [079/130] (710s left) kms_chamelium_color (ctm-negative)
[305.800408] Subtest ctm-negative: SKIP (0.000s)
[305.845178] [080/130] (709s left) gem_mmap_wc (invalid-flags)
[305.877988] Starting subtest: invalid-flags
[305.878706] Subtest invalid-flags: SUCCESS (0.000s)
[305.998529] [081/130] (709s left) gem_exec_reloc (basic-gtt-wc)
[306.033307] Starting subtest: basic-gtt-wc
[306.039797] Subtest basic-gtt-wc: SUCCESS (0.006s)
[306.185398] [082/130] (709s left) syncobj_timeline (single-wait-all-available-signaled)
[306.219376] Starting subtest: single-wait-all-available-signaled
[306.220109] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[306.310333] [083/130] (709s left) gem_ctx_exec (basic-close-race)
[306.345448] Starting subtest: basic-close-race
[312.092941] Subtest basic-close-race: SUCCESS (5.713s)
[312.197895] [084/130] (703s left) gem_exec_balancer (parallel-out-fence)
[312.356321] Subtest parallel-out-fence: SKIP (0.000s)
[312.448691] [085/130] (703s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[312.537266] Starting subtest: flip-vs-cursor-legacy
[318.830500] Subtest flip-vs-cursor-legacy: SUCCESS (6.293s)
[318.988562] [086/130] (697s left) drm_read (fault-buffer)
[319.102954] Starting subtest: fault-buffer
[319.103702] Subtest fault-buffer: SUCCESS (0.001s)
[319.218439] [087/130] (696s left) gem_mmap_wc (pf-nonblock)
[319.250309] Starting subtest: pf-nonblock
[319.251981] Subtest pf-nonblock: SUCCESS (0.002s)
[319.376948] [088/130] (696s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[319.464721] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[319.466090] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[319.601771] [089/130] (696s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[319.691470] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[319.692813] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[319.800764] [090/130] (696s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[319.885836] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[319.887501] Starting dynamic subtest: pipe-A-valid-mode
[319.943752] Dynamic subtest pipe-A-valid-mode: SKIP (0.056s)
[319.945161] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.058s)
[320.065518] [091/130] (696s left) gem_spin_batch (spin-all-new)
[320.106438] Starting subtest: spin-all-new
[320.117022] Subtest spin-all-new: SUCCESS (0.011s)
[320.316281] [092/130] (696s left) core_sysfs (read-all-entries)
[320.353977] Starting subtest: read-all-entries
[320.354661] Subtest read-all-entries: SUCCESS (0.004s)
[320.444330] [093/130] (695s left) gem_exec_reloc (basic-range-active)
[320.480073] Starting subtest: basic-range-active
[320.517539] Subtest basic-range-active: SUCCESS (0.037s)
[320.658315] [094/130] (695s left) syncobj_timeline (single-wait-all-signaled)
[320.690973] Starting subtest: single-wait-all-signaled
[320.691755] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[320.777326] [095/130] (695s left) gen7_exec_parse (basic-offset)
[320.815307] Subtest basic-offset: SKIP (0.000s)
[320.864147] [096/130] (695s left) gem_ctx_shared (q-out-order)
[320.905243] Starting subtest: Q-out-order
[320.905952] Starting dynamic subtest: rcs0
[320.956362] Dynamic subtest rcs0: SUCCESS (0.050s)
[320.971212] Starting dynamic subtest: bcs0
[321.016265] Dynamic subtest bcs0: SUCCESS (0.056s)
[321.030317] Starting dynamic subtest: vcs0
[321.068475] Dynamic subtest vcs0: SUCCESS (0.050s)
[321.082916] Starting dynamic subtest: vcs1
[321.119806] Dynamic subtest vcs1: SUCCESS (0.049s)
[321.135117] Starting dynamic subtest: vecs0
[321.171672] Dynamic subtest vecs0: SUCCESS (0.050s)
[321.172738] Subtest Q-out-order: SUCCESS (0.267s)
[321.380810] [097/130] (695s left) gem_exec_flush (basic-batch-kernel-default-wb)
[321.420702] Starting subtest: basic-batch-kernel-default-wb
[327.028619] Subtest basic-batch-kernel-default-wb: SUCCESS (5.607s)
[327.241365] [098/130] (689s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[327.331578] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[327.332891] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[327.460166] [099/130] (689s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[327.547920] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[327.586806] [100/130] (689s left) kms_psr2_su (page_flip-xrgb8888)
[327.619690] Subtest page_flip-XRGB8888: SKIP (0.000s)
[327.659991] [101/130] (689s left) kms_psr (psr-basic)
[327.744552] Subtest psr-basic: SKIP (0.000s)
[327.786227] [102/130] (688s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[327.874740] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[327.876085] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[328.005820] [103/130] (688s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[328.100407] Starting subtest: yf-tiled-8bpp-rotate-90
[328.101841] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[328.204566] [104/130] (688s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[328.298328] Starting subtest: yf-tiled-16bpp-rotate-90
[328.299694] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[328.421943] [105/130] (688s left) kms_flip (flip-vs-blocking-wf-vblank)
[328.507693] Starting subtest: flip-vs-blocking-wf-vblank
[328.510230] Starting dynamic subtest: A-HDMI-A1
[336.349627] Dynamic subtest A-HDMI-A1: SUCCESS (7.820s)
[336.357836] Starting dynamic subtest: B-HDMI-A1
[344.169695] Dynamic subtest B-HDMI-A1: SUCCESS (7.808s)
[344.177822] Starting dynamic subtest: C-HDMI-A1
[351.958772] Dynamic subtest C-HDMI-A1: SUCCESS (7.788s)
[351.966896] Starting dynamic subtest: D-HDMI-A1
[359.743086] Dynamic subtest D-HDMI-A1: SUCCESS (7.807s)
[359.744201] Subtest flip-vs-blocking-wf-vblank: SUCCESS (31.235s)
[359.908734] [106/130] (657s left) gem_userptr_blits (stress-purge)
[359.955131] Starting subtest: stress-purge
[365.327260] Subtest stress-purge: SUCCESS (5.373s)
[365.475707] [107/130] (651s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[365.553228] Starting subtest: no-spare-fences-busy-interruptible
[367.706223] Subtest no-spare-fences-busy-interruptible: SUCCESS (2.153s)
[367.834049] [108/130] (649s left) gem_exec_balancer (nop)
[367.874515] Starting subtest: nop
[406.082519] Subtest nop: SUCCESS (38.208s)
[406.299593] [109/130] (610s left) gem_eio (in-flight-external)
[406.342424] Starting subtest: in-flight-external
[406.603345] Subtest in-flight-external: SUCCESS (0.260s)
[406.753123] [110/130] (610s left) kms_flip (2x-blocking-absolute-wf_vblank)
[406.838561] Starting subtest: 2x-blocking-absolute-wf_vblank
[406.847482] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.009s)
[406.944370] [111/130] (610s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[407.033438] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[407.043156] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.009s)
[407.138874] [112/130] (610s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[407.228488] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[407.229839] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[407.339296] [113/130] (609s left) kms_atomic (plane-cursor-legacy)
[407.428903] Starting subtest: plane-cursor-legacy
[407.430537] Starting dynamic subtest: pipe-A-HDMI-A-1
[407.597482] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.167s)
[407.599264] Subtest plane-cursor-legacy: SUCCESS (0.170s)
[407.750328] [114/130] (609s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[407.836408] Starting subtest: bad-aux-stride-y-tiled-ccs
[407.837127] Starting dynamic subtest: pipe-A-HDMI-A-1
[407.843962] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[407.854954] Starting dynamic subtest: pipe-B-HDMI-A-1
[407.861463] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[407.869839] Starting dynamic subtest: pipe-C-HDMI-A-1
[407.876384] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[407.884636] Starting dynamic subtest: pipe-D-HDMI-A-1
[407.891526] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[407.892849] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.007s)
[408.092461] [115/130] (609s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[408.181098] Starting subtest: stress-xrgb8888-xtiled
[414.516422] Subtest stress-xrgb8888-xtiled: SUCCESS (6.335s)
[414.655117] [116/130] (602s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[414.747425] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[414.748273] Starting dynamic subtest: pipe-A
[414.869427] Dynamic subtest pipe-A: SUCCESS (0.122s)
[414.879152] Starting dynamic subtest: pipe-B
[415.004404] Dynamic subtest pipe-B: SUCCESS (0.134s)
[415.022284] Starting dynamic subtest: pipe-C
[415.138282] Dynamic subtest pipe-C: SUCCESS (0.133s)
[415.148844] Starting dynamic subtest: pipe-D
[415.272696] Dynamic subtest pipe-D: SUCCESS (0.133s)
[415.273401] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SUCCESS (0.526s)
[415.441766] [117/130] (601s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[415.531420] Starting subtest: fbc-shrfb-scaledprimary
[418.381829] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.851s)
[418.541625] [118/130] (598s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[418.641693] Starting subtest: x-tiled-64bpp-rotate-270
[418.687419] Subtest x-tiled-64bpp-rotate-270: SKIP (0.045s)
[418.840365] [119/130] (598s left) kms_flip (nonexisting-fb-interruptible)
[418.934452] Starting subtest: nonexisting-fb-interruptible
[418.937372] Starting dynamic subtest: A-HDMI-A1
[419.083393] Dynamic subtest A-HDMI-A1: SUCCESS (0.146s)
[419.093102] Starting dynamic subtest: B-HDMI-A1
[419.209843] Dynamic subtest B-HDMI-A1: SUCCESS (0.125s)
[419.219852] Starting dynamic subtest: C-HDMI-A1
[419.331886] Dynamic subtest C-HDMI-A1: SUCCESS (0.121s)
[419.341984] Starting dynamic subtest: D-HDMI-A1
[419.454807] Dynamic subtest D-HDMI-A1: SUCCESS (0.121s)
[419.457985] Subtest nonexisting-fb-interruptible: SUCCESS (0.524s)
[419.660334] [120/130] (597s left) kms_plane_lowres (tiling-4)
[419.746125] Starting subtest: tiling-4
[419.747491] Subtest tiling-4: SKIP (0.000s)
[419.838218] [121/130] (597s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[419.925756] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[419.927143] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[420.049503] [122/130] (597s left) kms_psr (pr-cursor-render)
[420.134722] Subtest pr-cursor-render: SKIP (0.000s)
[420.179788] [123/130] (597s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[420.267804] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[421.392770] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (1.125s)
[421.540164] [124/130] (596s left) kms_cursor_crc (cursor-onscreen-64x21)
[421.631281] Starting subtest: cursor-onscreen-64x21
[421.636378] Starting dynamic subtest: pipe-A-HDMI-A-1
[422.494625] Dynamic subtest pipe-A-HDMI-A-1: FAIL (0.683s)
[422.503423] Starting dynamic subtest: pipe-D-HDMI-A-1
[423.582738] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.229s)
[423.583428] Subtest cursor-onscreen-64x21: FAIL (1.952s)
[423.758742] [125/130] (593s left) perf_pmu (busy-idle-no-semaphores)
[423.796445] Starting subtest: busy-idle-no-semaphores
[423.797147] Starting dynamic subtest: rcs0
[424.442726] Dynamic subtest rcs0: SUCCESS (0.637s)
[424.454283] Starting dynamic subtest: bcs0
[425.071190] Dynamic subtest bcs0: SUCCESS (0.626s)
[425.082893] Starting dynamic subtest: vcs0
[425.693917] Dynamic subtest vcs0: SUCCESS (0.620s)
[425.705339] Starting dynamic subtest: vcs1
[426.322672] Dynamic subtest vcs1: SUCCESS (0.626s)
[426.341677] Starting dynamic subtest: vecs0
[426.954724] Dynamic subtest vecs0: SUCCESS (0.630s)
[426.955735] Subtest busy-idle-no-semaphores: SUCCESS (3.151s)
[427.073455] [126/130] (590s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[427.165881] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[427.166561] Starting dynamic subtest: pipe-A
[428.223730] Dynamic subtest pipe-A: SKIP (1.057s)
[428.232441] Starting dynamic subtest: pipe-B
[429.321687] Dynamic subtest pipe-B: SKIP (1.096s)
[429.332793] Starting dynamic subtest: pipe-C
[430.397781] Dynamic subtest pipe-C: SKIP (1.076s)
[430.406498] Starting dynamic subtest: pipe-D
[431.494778] Dynamic subtest pipe-D: SKIP (1.096s)
[431.496172] Subtest plane-scaler-with-clipping-clamping-rotation: SKIP (4.329s)
[431.663465] [127/130] (586s left) gem_mmap (short-mmap)
[431.706044] Starting subtest: short-mmap
[431.706737] Subtest short-mmap: SUCCESS (0.000s)
[431.816690] [128/130] (586s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[431.906753] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[431.908135] Subtest psr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[432.016672] [129/130] (585s left) gem_ctx_param (invalid-ctx-set)
[432.049815] Starting subtest: invalid-ctx-set
[432.050509] Subtest invalid-ctx-set: SUCCESS (0.000s)
[432.126882] [130/130] (585s left) i915_suspend (basic-s3-without-i915)
[432.157991] Starting subtest: basic-s3-without-i915