[52.611069] Initializing watchdogs
[52.611134]   /dev/watchdog0
[52.626622] [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.632706] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[52.635221] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[52.637014] [001/130] (960s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[52.730262] Starting subtest: bad-pixel-format-yf-tiled-ccs
[52.730977] Starting dynamic subtest: pipe-A-HDMI-A-1
[52.737703] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[52.742578] Starting dynamic subtest: pipe-B-HDMI-A-1
[52.749223] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[52.753984] Starting dynamic subtest: pipe-C-HDMI-A-1
[52.760469] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[52.765146] Starting dynamic subtest: pipe-D-HDMI-A-1
[52.771860] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[52.773209] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s)
[52.972523] [002/130] (960s left) kms_content_protection (dp-mst-type-0)
[53.064108] Starting subtest: dp-mst-type-0
[53.065422] Subtest dp-mst-type-0: SKIP (0.000s)
[53.169631] [003/130] (960s left) gem_exec_reloc (basic-cpu-read-active)
[53.208184] Starting subtest: basic-cpu-read-active
[53.338094] Subtest basic-cpu-read-active: SUCCESS (0.121s)
[53.475429] [004/130] (959s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[53.558630] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[53.560095] Starting dynamic subtest: pipe-A-HDMI-A-1
[53.566607] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[53.571500] Starting dynamic subtest: pipe-B-HDMI-A-1
[53.577948] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[53.582922] Starting dynamic subtest: pipe-C-HDMI-A-1
[53.589472] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[53.594316] Starting dynamic subtest: pipe-D-HDMI-A-1
[53.600976] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[53.602287] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s)
[53.802989] [005/130] (959s left) gem_mmap_offset (clear)
[53.835737] Starting subtest: clear
[53.838480] Starting dynamic subtest: smem0
[76.763235] Dynamic subtest smem0: SUCCESS (22.918s)
[76.763967] Subtest clear: SUCCESS (22.927s)
[76.906969] [006/130] (936s left) kms_feature_discovery (psr1)
[77.042115] Starting subtest: psr1
[77.043549] Subtest psr1: SKIP (0.000s)
[77.115423] [007/130] (936s left) kms_cursor_legacy (torture-move)
[77.201429] Starting subtest: torture-move
[77.202155] Starting dynamic subtest: pipe-A
[82.712196] Dynamic subtest pipe-A: SUCCESS (5.476s)
[82.719307] Starting dynamic subtest: pipe-B
[88.167497] Dynamic subtest pipe-B: SUCCESS (5.452s)
[88.173908] Starting dynamic subtest: pipe-C
[93.619910] Dynamic subtest pipe-C: SUCCESS (5.454s)
[93.626114] Starting dynamic subtest: pipe-D
[99.087599] Dynamic subtest pipe-D: SUCCESS (5.467s)
[99.096292] Starting dynamic subtest: all-pipes
[104.539442] Dynamic subtest all-pipes: SUCCESS (5.451s)
[104.540416] Subtest torture-move: SUCCESS (27.302s)
[104.615571] [008/130] (908s left) gem_softpin (evict-snoop)
[104.660830] Starting subtest: evict-snoop
[104.662337] Subtest evict-snoop: SKIP (0.000s)
[104.748495] [009/130] (908s left) gem_ppgtt (blt-vs-render-ctxn)
[104.783962] Starting subtest: blt-vs-render-ctxN
[137.237272] Subtest blt-vs-render-ctxN: SUCCESS (32.442s)
[137.367306] [010/130] (876s left) prime_vgem (fence-read-hang)
[137.523233] Subtest fence-read-hang: SKIP (0.000s)
[137.638436] [FACT prime_vgem (fence-read-hang)] new: kernel.kmod_is_loaded.vgem: true
[137.639890] [011/130] (875s left) i915_drm_fdinfo (memory-info-shared)
[137.675311] Starting subtest: memory-info-shared
[137.676126] Starting dynamic subtest: smem0
[137.731221] Dynamic subtest smem0: SUCCESS (0.056s)
[137.732060] Subtest memory-info-shared: SUCCESS (0.056s)
[137.814190] [012/130] (875s left) gem_exec_schedule (timeslicing)
[137.856184] Starting subtest: timeslicing
[137.856944] Starting dynamic subtest: rcs0
[137.859513] Dynamic subtest rcs0: SUCCESS (0.003s)
[137.869465] Starting dynamic subtest: bcs0
[137.870199] Dynamic subtest bcs0: SUCCESS (0.004s)
[137.877755] Starting dynamic subtest: vcs0
[137.878445] Dynamic subtest vcs0: SUCCESS (0.004s)
[137.884655] Starting dynamic subtest: vcs1
[137.885332] Dynamic subtest vcs1: SUCCESS (0.003s)
[137.891409] Starting dynamic subtest: vecs0
[137.892085] Dynamic subtest vecs0: SUCCESS (0.004s)
[137.892757] Subtest timeslicing: SUCCESS (0.020s)
[138.187611] [013/130] (875s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[138.281592] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[138.283029] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[138.398876] [014/130] (875s left) kms_async_flips (alternate-sync-async-flip-atomic)
[138.481439] Starting subtest: alternate-sync-async-flip-atomic
[138.604539] Starting dynamic subtest: pipe-A-HDMI-A-1
[140.722662] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.109s)
[140.847320] Starting dynamic subtest: pipe-B-HDMI-A-1
[142.931952] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.083s)
[143.056866] Starting dynamic subtest: pipe-C-HDMI-A-1
[145.133815] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.074s)
[145.266686] Starting dynamic subtest: pipe-D-HDMI-A-1
[147.344508] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.076s)
[147.345671] Subtest alternate-sync-async-flip-atomic: SUCCESS (8.855s)
[147.574412] [015/130] (866s left) api_intel_bb (simple-bb)
[147.611187] Starting subtest: simple-bb
[147.614216] Subtest simple-bb: SUCCESS (0.004s)
[147.745943] [016/130] (866s left) i915_hangman (engine-engine-error)
[147.786961] Starting subtest: engine-engine-error
[147.787733] Starting dynamic subtest: rcs0
[147.863751] Dynamic subtest rcs0: SUCCESS (0.076s)
[147.878647] Starting dynamic subtest: bcs0
[147.941666] Dynamic subtest bcs0: SUCCESS (0.077s)
[147.956537] Starting dynamic subtest: vcs0
[148.024570] Dynamic subtest vcs0: SUCCESS (0.082s)
[148.039309] Starting dynamic subtest: vcs1
[148.099510] Dynamic subtest vcs1: SUCCESS (0.074s)
[148.113748] Starting dynamic subtest: vecs0
[148.186604] Dynamic subtest vecs0: SUCCESS (0.087s)
[148.187564] Subtest engine-engine-error: SUCCESS (0.400s)
[148.288100] [017/130] (865s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[148.388313] Starting subtest: verify-pxp-execution-after-suspend-resume
[155.492499] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.105s)
[163.629623] [018/130] (858s left) syncobj_eventfd (timeline-wait)
[163.664331] Starting subtest: timeline-wait
[163.674237] Subtest timeline-wait: SUCCESS (0.010s)
[163.757965] [019/130] (858s left) gem_busy (extended)
[163.921064] Starting subtest: extended
[163.921884] Starting dynamic subtest: rcs0
[163.955391] Dynamic subtest rcs0: SUCCESS (0.042s)
[163.966058] Starting dynamic subtest: bcs0
[163.983422] Dynamic subtest bcs0: SUCCESS (0.028s)
[163.997870] Starting dynamic subtest: vcs0
[163.999437] Dynamic subtest vcs0: SUCCESS (0.015s)
[164.006947] Starting dynamic subtest: vcs1
[164.012795] Dynamic subtest vcs1: SUCCESS (0.014s)
[164.020189] Starting dynamic subtest: vecs0
[164.028526] Dynamic subtest vecs0: SUCCESS (0.013s)
[164.029219] Subtest extended: SUCCESS (0.114s)
[164.276693] [020/130] (857s left) syncobj_timeline (invalid-transfer-illegal-handle)
[164.308834] Starting subtest: invalid-transfer-illegal-handle
[164.309538] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[164.398664] [021/130] (857s left) gem_ctx_freq (sysfs)
[164.435226] Starting subtest: sysfs
[164.435934] Starting dynamic subtest: gt0
[169.504349] Dynamic subtest gt0: SUCCESS (5.069s)
[169.505265] Subtest sysfs: SUCCESS (5.069s)
[169.593409] [022/130] (852s left) kms_chamelium_edid (hdmi-edid-read)
[169.733321] Subtest hdmi-edid-read: SKIP (0.000s)
[169.820763] [023/130] (852s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[169.905592] Starting subtest: short-flip-before-cursor-toggle
[170.451590] Subtest short-flip-before-cursor-toggle: SUCCESS (0.546s)
[170.597801] [024/130] (851s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[170.683891] Starting subtest: cursor-rapid-movement-64x64
[170.688465] Starting dynamic subtest: pipe-A-HDMI-A-1
[170.943014] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.254s)
[170.980376] Starting dynamic subtest: pipe-D-HDMI-A-1
[171.178449] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.208s)
[171.179123] Subtest cursor-rapid-movement-64x64: SUCCESS (0.494s)
[171.350818] [025/130] (850s left) gem_exec_flush (basic-wb-prw-default)
[171.392469] Starting subtest: basic-wb-prw-default
[176.821377] Subtest basic-wb-prw-default: SUCCESS (5.430s)
[177.044214] [026/130] (845s left) kms_invalid_mode (bad-vtotal)
[177.130057] Starting subtest: bad-vtotal
[177.130747] Starting dynamic subtest: pipe-A-HDMI-A-1
[177.184110] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.054s)
[177.192905] Starting dynamic subtest: pipe-B-HDMI-A-1
[177.193606] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[177.201361] Starting dynamic subtest: pipe-C-HDMI-A-1
[177.202076] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[177.209652] Starting dynamic subtest: pipe-D-HDMI-A-1
[177.210368] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[177.211054] Subtest bad-vtotal: SUCCESS (0.064s)
[177.347071] [027/130] (844s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[177.381098] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[177.381884] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[177.462807] [028/130] (844s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[177.550694] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[177.552077] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[177.674990] [029/130] (844s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[177.758753] Starting subtest: primary-yf-tiled-reflect-x-270
[177.809565] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.050s)
[177.903302] [030/130] (844s left) gem_exec_schedule (preempt-queue-chain)
[177.945606] Starting subtest: preempt-queue-chain
[177.946334] Starting dynamic subtest: rcs0
[178.089425] Dynamic subtest rcs0: SUCCESS (0.135s)
[178.097960] Starting dynamic subtest: bcs0
[178.224975] Dynamic subtest bcs0: SUCCESS (0.133s)
[178.233676] Starting dynamic subtest: vcs0
[178.355968] Dynamic subtest vcs0: SUCCESS (0.129s)
[178.364407] Starting dynamic subtest: vcs1
[178.487501] Dynamic subtest vcs1: SUCCESS (0.132s)
[178.495590] Starting dynamic subtest: vecs0
[178.615462] Dynamic subtest vecs0: SUCCESS (0.130s)
[178.620449] Subtest preempt-queue-chain: SUCCESS (0.661s)
[178.926454] [031/130] (843s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[179.015339] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[179.016661] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[179.126305] [032/130] (843s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[179.210068] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[179.211424] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[179.376185] [033/130] (843s left) gem_exec_reloc (basic-cpu-active)
[179.415929] Starting subtest: basic-cpu-active
[179.542592] Subtest basic-cpu-active: SUCCESS (0.120s)
[179.680558] [034/130] (842s left) kms_lease (multimaster-lease)
[179.764747] Starting subtest: multimaster-lease
[179.767120] Subtest multimaster-lease: SUCCESS (0.002s)
[179.848403] [035/130] (842s left) kms_dp_linktrain_fallback (dsc-fallback)
[179.933520] Starting subtest: dsc-fallback
[179.935532] Subtest dsc-fallback: SKIP (0.000s)
[180.010335] [036/130] (842s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[180.095062] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[180.095798] Starting dynamic subtest: pipe-A-HDMI-A-1
[180.102819] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[180.114566] Starting dynamic subtest: pipe-B-HDMI-A-1
[180.121642] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[180.129613] Starting dynamic subtest: pipe-C-HDMI-A-1
[180.136344] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[180.143812] Starting dynamic subtest: pipe-D-HDMI-A-1
[180.150701] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[180.152089] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SKIP (0.005s)
[180.344930] [037/130] (842s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[180.432708] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[180.434125] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[180.558337] [038/130] (842s left) kms_psr (psr-primary-page-flip)
[180.646077] Subtest psr-primary-page-flip: SKIP (0.000s)
[180.690707] [039/130] (842s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[180.786325] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[180.787665] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[180.916483] [040/130] (841s left) kms_getfb (getfb2-handle-closed)
[180.999920] Starting subtest: getfb2-handle-closed
[181.000620] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[181.125787] [041/130] (841s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[181.213395] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[181.214714] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[181.333750] [042/130] (841s left) gem_lmem_swapping (heavy-verify-random)
[181.369263] Subtest heavy-verify-random: SKIP (0.000s)
[181.415068] [043/130] (841s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[181.502175] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[181.503520] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[181.625869] [044/130] (841s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[181.713558] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[181.714920] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[181.835293] [045/130] (841s left) gem_exec_gttfill (basic)
[181.876847] Starting subtest: basic
[185.364673] Subtest basic: SUCCESS (3.488s)
[185.573421] [046/130] (837s left) prime_busy (hang)
[185.662470] Starting subtest: hang
[185.663154] Starting dynamic subtest: rcs0
[199.783058] Dynamic subtest rcs0: SUCCESS (14.112s)
[199.790664] Starting dynamic subtest: bcs0
[206.592076] Dynamic subtest bcs0: SUCCESS (6.783s)
[206.599333] Starting dynamic subtest: vcs0
[213.568182] Dynamic subtest vcs0: SUCCESS (6.976s)
[213.575413] Starting dynamic subtest: vcs1
[220.608292] Dynamic subtest vcs1: SUCCESS (7.040s)
[220.615657] Starting dynamic subtest: vecs0
[227.584603] Dynamic subtest vecs0: SUCCESS (6.976s)
[227.585525] Subtest hang: SUCCESS (41.889s)
[227.694800] [047/130] (795s left) kms_psr (fbc-psr2-no-drrs)
[227.785271] Subtest fbc-psr2-no-drrs: SKIP (0.000s)
[227.830557] [048/130] (795s left) kms_vrr (flip-suspend)
[227.916545] Starting subtest: flip-suspend
[227.918488] Subtest flip-suspend: SKIP (0.000s)
[228.001447] [049/130] (795s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[228.039495] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[228.040188] Starting dynamic subtest: smem
[228.142165] Dynamic subtest smem: SUCCESS (0.103s)
[228.142867] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SUCCESS (0.103s)
[228.342345] [050/130] (794s left) kms_prime (basic-crc-hybrid)
[228.447067] Subtest basic-crc-hybrid: SKIP (0.000s)
[228.537614] [051/130] (794s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[228.630332] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[228.631771] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[228.757797] [052/130] (794s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[228.891718] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[228.983921] [053/130] (794s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[229.074568] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[230.360722] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (1.286s)
[230.518844] [054/130] (792s left) kms_flip (2x-flip-vs-panning)
[230.607337] Starting subtest: 2x-flip-vs-panning
[230.616730] Subtest 2x-flip-vs-panning: SKIP (0.009s)
[230.703601] [055/130] (792s left) gem_mmap_wc (write-gtt-read-wc)
[230.735572] Starting subtest: write-gtt-read-wc
[231.051218] Subtest write-gtt-read-wc: SUCCESS (0.307s)
[231.153200] [056/130] (792s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[231.249929] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[231.944419] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.694s)
[232.096714] [057/130] (791s left) kms_flip (2x-flip-vs-wf_vblank)
[232.182159] Starting subtest: 2x-flip-vs-wf_vblank
[232.191067] Subtest 2x-flip-vs-wf_vblank: SKIP (0.009s)
[232.283122] [058/130] (791s left) perf_pmu (semaphore-wait-idle)
[232.318025] Starting subtest: semaphore-wait-idle
[232.318744] Starting dynamic subtest: rcs0
[232.835458] Dynamic subtest rcs0: SUCCESS (0.508s)
[232.845996] Starting dynamic subtest: bcs0
[233.338145] Dynamic subtest bcs0: SUCCESS (0.510s)
[233.347970] Starting dynamic subtest: vcs0
[233.857664] Dynamic subtest vcs0: SUCCESS (0.510s)
[233.868130] Starting dynamic subtest: vcs1
[234.369416] Dynamic subtest vcs1: SUCCESS (0.510s)
[234.379879] Starting dynamic subtest: vecs0
[234.880586] Dynamic subtest vecs0: SUCCESS (0.510s)
[234.881481] Subtest semaphore-wait-idle: SUCCESS (2.555s)
[234.996453] [059/130] (788s left) i915_pm_rpm (gem-pread)
[236.388477] Starting subtest: gem-pread
[237.760452] Subtest gem-pread: SUCCESS (1.373s)
[237.884306] [060/130] (785s left) gem_exec_fence (long-history)
[238.210872] Starting subtest: long-history
[243.995316] Subtest long-history: SUCCESS (5.776s)
[244.466780] [061/130] (779s left) gem_lmem_swapping (parallel-random-engines)
[244.502548] Subtest parallel-random-engines: SKIP (0.000s)
[244.548944] [062/130] (779s left) syncobj_basic (bad-destroy)
[244.581652] Starting subtest: bad-destroy
[244.582350] Subtest bad-destroy: SUCCESS (0.000s)
[244.671450] [063/130] (779s left) kms_cursor_crc (cursor-offscreen-512x170)
[244.765350] Starting subtest: cursor-offscreen-512x170
[244.767518] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[244.890088] [064/130] (778s left) gem_ctx_persistence (hostile)
[244.925572] Starting subtest: hostile
[255.335305] Subtest hostile: SUCCESS (10.401s)
[255.486166] [065/130] (768s left) gem_exec_reloc (basic-cpu-read)
[255.522052] Starting subtest: basic-cpu-read
[255.527274] Subtest basic-cpu-read: SUCCESS (0.005s)
[255.665104] [066/130] (768s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[255.755804] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[255.848899] [067/130] (768s left) gem_exec_fence (syncobj-timeline-wait)
[256.310389] Starting subtest: syncobj-timeline-wait
[256.338509] Subtest syncobj-timeline-wait: SUCCESS (0.038s)
[256.573829] [068/130] (767s left) prime_mmap (test_userptr)
[256.605320] Starting subtest: test_userptr
[256.605994] Starting dynamic subtest: test_userptr-smem
[256.606695] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[256.607350] Subtest test_userptr: SUCCESS (0.001s)
[256.725469] [069/130] (767s left) gem_exec_store (dword)
[256.764130] Starting subtest: dword
[256.764819] Starting dynamic subtest: rcs0
[256.809641] Dynamic subtest rcs0: SUCCESS (0.045s)
[256.828401] Starting dynamic subtest: bcs0
[256.848490] Dynamic subtest bcs0: SUCCESS (0.037s)
[256.864864] Starting dynamic subtest: vcs0
[256.868970] Dynamic subtest vcs0: SUCCESS (0.020s)
[256.879041] Starting dynamic subtest: vcs1
[256.884937] Dynamic subtest vcs1: SUCCESS (0.015s)
[256.893235] Starting dynamic subtest: vecs0
[256.900901] Dynamic subtest vecs0: SUCCESS (0.015s)
[256.901597] Subtest dword: SUCCESS (0.137s)
[257.101134] [070/130] (767s left) kms_pm_rpm (legacy-planes)
[258.494793] Starting subtest: legacy-planes
[258.495682] Starting dynamic subtest: plane-63
[267.038863] Dynamic subtest plane-63: SUCCESS (8.536s)
[267.058568] Starting dynamic subtest: plane-93
[275.256188] Dynamic subtest plane-93: SUCCESS (8.225s)
[275.269044] Starting dynamic subtest: plane-123
[283.386040] Dynamic subtest plane-123: SUCCESS (8.129s)
[283.398861] Starting dynamic subtest: plane-133
[291.713402] Dynamic subtest plane-133: SUCCESS (8.326s)
[291.726149] Starting dynamic subtest: plane-143
[300.124789] Dynamic subtest plane-143: SUCCESS (8.401s)
[300.136897] Starting dynamic subtest: plane-153
[308.449431] Dynamic subtest plane-153: SUCCESS (8.324s)
[308.450153] Subtest legacy-planes: SUCCESS (49.949s)
[308.628966] [071/130] (715s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[308.716581] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[308.717967] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[308.836924] [072/130] (715s left) kms_psr (fbc-psr-suspend)
[308.920448] Subtest fbc-psr-suspend: SKIP (0.000s)
[308.966484] [073/130] (715s left) kms_big_fb (linear-32bpp-rotate-270)
[309.058304] Starting subtest: linear-32bpp-rotate-270
[309.129376] Subtest linear-32bpp-rotate-270: SKIP (0.070s)
[309.261140] [074/130] (715s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[309.297241] Starting subtest: basic-wc-gtt-noreloc
[309.300279] Subtest basic-wc-gtt-noreloc: SUCCESS (0.003s)
[309.440578] [075/130] (714s left) prime_mmap (test_correct)
[309.472497] Starting subtest: test_correct
[309.473205] Starting dynamic subtest: test_correct-smem
[309.473881] Dynamic subtest test_correct-smem: SUCCESS (0.002s)
[309.474585] Subtest test_correct: SUCCESS (0.003s)
[309.585802] [076/130] (714s left) kms_vblank (accuracy-idle)
[309.671930] Starting subtest: accuracy-idle
[309.673695] Starting dynamic subtest: pipe-A-HDMI-A-1
[310.850278] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.177s)
[310.863894] Starting dynamic subtest: pipe-D-HDMI-A-1
[311.999081] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.145s)
[311.999818] Subtest accuracy-idle: SUCCESS (2.327s)
[312.163767] [077/130] (712s left) perf (invalid-remove-userspace-config)
[312.266137] Starting subtest: invalid-remove-userspace-config
[312.275454] Subtest invalid-remove-userspace-config: SUCCESS (0.010s)
[312.320209] [078/130] (712s left) gem_madvise (dontneed-before-exec)
[312.351712] Starting subtest: dontneed-before-exec
[312.354161] Subtest dontneed-before-exec: SUCCESS (0.003s)
[312.478068] [079/130] (711s left) kms_chamelium_color (ctm-negative)
[312.565557] Subtest ctm-negative: SKIP (0.000s)
[312.607599] [080/130] (711s left) gem_mmap_wc (invalid-flags)
[312.640735] Starting subtest: invalid-flags
[312.641410] Subtest invalid-flags: SUCCESS (0.000s)
[312.769214] [081/130] (711s left) gem_exec_reloc (basic-gtt-wc)
[312.805286] Starting subtest: basic-gtt-wc
[312.812029] Subtest basic-gtt-wc: SUCCESS (0.007s)
[312.958161] [082/130] (711s left) syncobj_timeline (single-wait-all-available-signaled)
[312.992909] Starting subtest: single-wait-all-available-signaled
[312.993654] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[313.083114] [083/130] (711s left) gem_ctx_exec (basic-close-race)
[313.117284] Starting subtest: basic-close-race
[318.861440] Subtest basic-close-race: SUCCESS (5.708s)
[318.955691] [084/130] (705s left) gem_exec_balancer (parallel-out-fence)
[319.112141] Subtest parallel-out-fence: SKIP (0.000s)
[319.211274] [085/130] (705s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[319.298805] Starting subtest: flip-vs-cursor-legacy
[325.577873] Subtest flip-vs-cursor-legacy: SUCCESS (6.280s)
[325.727427] [086/130] (699s left) drm_read (fault-buffer)
[325.839747] Starting subtest: fault-buffer
[325.840464] Subtest fault-buffer: SUCCESS (0.001s)
[325.956477] [087/130] (698s left) gem_mmap_wc (pf-nonblock)
[325.988217] Starting subtest: pf-nonblock
[325.989130] Subtest pf-nonblock: SUCCESS (0.002s)
[326.122597] [088/130] (698s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[326.209436] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[326.210878] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[326.339816] [089/130] (698s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[326.427458] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[326.428832] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[326.548878] [090/130] (698s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[326.632953] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[326.634591] Starting dynamic subtest: pipe-A-valid-mode
[326.692648] Dynamic subtest pipe-A-valid-mode: SKIP (0.058s)
[326.694034] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.060s)
[326.823873] [091/130] (698s left) gem_spin_batch (spin-all-new)
[326.867116] Starting subtest: spin-all-new
[326.877876] Subtest spin-all-new: SUCCESS (0.011s)
[327.078894] [092/130] (697s left) core_sysfs (read-all-entries)
[327.111670] Starting subtest: read-all-entries
[327.114744] Subtest read-all-entries: SUCCESS (0.004s)
[327.201126] [093/130] (697s left) gem_exec_reloc (basic-range-active)
[327.238713] Starting subtest: basic-range-active
[327.275601] Subtest basic-range-active: SUCCESS (0.038s)
[327.412280] [094/130] (697s left) syncobj_timeline (single-wait-all-signaled)
[327.445492] Starting subtest: single-wait-all-signaled
[327.446183] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[327.534361] [095/130] (697s left) gen7_exec_parse (basic-offset)
[327.569777] Subtest basic-offset: SKIP (0.000s)
[327.617764] [096/130] (697s left) gem_ctx_shared (q-out-order)
[327.659824] Starting subtest: Q-out-order
[327.660568] Starting dynamic subtest: rcs0
[327.709600] Dynamic subtest rcs0: SUCCESS (0.049s)
[327.725557] Starting dynamic subtest: bcs0
[327.769626] Dynamic subtest bcs0: SUCCESS (0.057s)
[327.781982] Starting dynamic subtest: vcs0
[327.821734] Dynamic subtest vcs0: SUCCESS (0.049s)
[327.834912] Starting dynamic subtest: vcs1
[327.871643] Dynamic subtest vcs1: SUCCESS (0.048s)
[327.885939] Starting dynamic subtest: vecs0
[327.923406] Dynamic subtest vecs0: SUCCESS (0.050s)
[327.924499] Subtest Q-out-order: SUCCESS (0.264s)
[328.129469] [097/130] (697s left) gem_exec_flush (basic-batch-kernel-default-wb)
[328.169701] Starting subtest: basic-batch-kernel-default-wb
[333.738758] Subtest basic-batch-kernel-default-wb: SUCCESS (5.569s)
[333.954649] [098/130] (691s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[334.045757] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[334.047127] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[334.156934] [099/130] (691s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[334.246016] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[334.285117] [100/130] (691s left) kms_psr2_su (page_flip-xrgb8888)
[334.318402] Subtest page_flip-XRGB8888: SKIP (0.000s)
[334.358421] [101/130] (691s left) kms_psr (psr-basic)
[334.443561] Subtest psr-basic: SKIP (0.000s)
[334.485536] [102/130] (690s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[334.574772] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[334.576142] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[334.695560] [103/130] (690s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[334.788318] Starting subtest: yf-tiled-8bpp-rotate-90
[334.789739] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[334.902995] [104/130] (690s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[334.996545] Starting subtest: yf-tiled-16bpp-rotate-90
[334.997929] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[335.104106] [105/130] (690s left) kms_flip (flip-vs-blocking-wf-vblank)
[335.197941] Starting subtest: flip-vs-blocking-wf-vblank
[335.199960] Starting dynamic subtest: A-HDMI-A1
[343.025674] Dynamic subtest A-HDMI-A1: SUCCESS (7.807s)
[343.033897] Starting dynamic subtest: B-HDMI-A1
[350.829396] Dynamic subtest B-HDMI-A1: SUCCESS (7.792s)
[350.838078] Starting dynamic subtest: C-HDMI-A1
[358.633386] Dynamic subtest C-HDMI-A1: SUCCESS (7.803s)
[358.641497] Starting dynamic subtest: D-HDMI-A1
[366.412247] Dynamic subtest D-HDMI-A1: SUCCESS (7.800s)
[366.412994] Subtest flip-vs-blocking-wf-vblank: SUCCESS (31.214s)
[366.622377] [106/130] (659s left) gem_userptr_blits (stress-purge)
[366.666433] Starting subtest: stress-purge
[372.062835] Subtest stress-purge: SUCCESS (5.396s)
[372.225725] [107/130] (653s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[372.305349] Starting subtest: no-spare-fences-busy-interruptible
[374.498315] Subtest no-spare-fences-busy-interruptible: SUCCESS (2.193s)
[374.633333] [108/130] (651s left) gem_exec_balancer (nop)
[374.676287] Starting subtest: nop
[412.836988] Subtest nop: SUCCESS (38.161s)
[413.044854] [109/130] (612s left) gem_eio (in-flight-external)
[413.090082] Starting subtest: in-flight-external
[413.348547] Subtest in-flight-external: SUCCESS (0.257s)
[413.492483] [110/130] (612s left) kms_flip (2x-blocking-absolute-wf_vblank)
[413.579689] Starting subtest: 2x-blocking-absolute-wf_vblank
[413.588290] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.009s)
[413.682126] [111/130] (612s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[413.770448] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[413.780102] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.009s)
[413.874061] [112/130] (612s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[413.963101] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[413.964454] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[414.093276] [113/130] (611s left) kms_atomic (plane-cursor-legacy)
[414.180034] Starting subtest: plane-cursor-legacy
[414.180730] Starting dynamic subtest: pipe-A-HDMI-A-1
[414.333051] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.152s)
[414.333757] Subtest plane-cursor-legacy: SUCCESS (0.154s)
[414.484376] [114/130] (611s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[414.571912] Starting subtest: bad-aux-stride-y-tiled-ccs
[414.572692] Starting dynamic subtest: pipe-A-HDMI-A-1
[414.579578] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[414.591992] Starting dynamic subtest: pipe-B-HDMI-A-1
[414.598841] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[414.610829] Starting dynamic subtest: pipe-C-HDMI-A-1
[414.617297] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[414.625742] Starting dynamic subtest: pipe-D-HDMI-A-1
[414.632340] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[414.633649] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.007s)
[414.823697] [115/130] (611s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[414.910298] Starting subtest: stress-xrgb8888-xtiled
[421.379462] Subtest stress-xrgb8888-xtiled: SUCCESS (6.469s)
[421.517782] [116/130] (604s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[421.605898] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[421.606818] Starting dynamic subtest: pipe-A
[421.731588] Dynamic subtest pipe-A: SUCCESS (0.126s)
[421.741677] Starting dynamic subtest: pipe-B
[421.857089] Dynamic subtest pipe-B: SUCCESS (0.125s)
[421.869658] Starting dynamic subtest: pipe-C
[421.990199] Dynamic subtest pipe-C: SUCCESS (0.132s)
[422.001485] Starting dynamic subtest: pipe-D
[422.124451] Dynamic subtest pipe-D: SUCCESS (0.133s)
[422.125130] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SUCCESS (0.519s)
[422.320753] [117/130] (603s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[422.408978] Starting subtest: fbc-shrfb-scaledprimary
[425.241540] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.833s)
[425.394160] [118/130] (600s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[425.494783] Starting subtest: x-tiled-64bpp-rotate-270
[425.539502] Subtest x-tiled-64bpp-rotate-270: SKIP (0.043s)
[425.692469] [119/130] (600s left) kms_flip (nonexisting-fb-interruptible)
[425.782743] Starting subtest: nonexisting-fb-interruptible
[425.785754] Starting dynamic subtest: A-HDMI-A1
[425.935036] Dynamic subtest A-HDMI-A1: SUCCESS (0.150s)
[425.945394] Starting dynamic subtest: B-HDMI-A1
[426.063760] Dynamic subtest B-HDMI-A1: SUCCESS (0.127s)
[426.074171] Starting dynamic subtest: C-HDMI-A1
[426.204739] Dynamic subtest C-HDMI-A1: SUCCESS (0.140s)
[426.215323] Starting dynamic subtest: D-HDMI-A1
[426.339764] Dynamic subtest D-HDMI-A1: SUCCESS (0.134s)
[426.342473] Subtest nonexisting-fb-interruptible: SUCCESS (0.561s)
[426.497715] [120/130] (599s left) kms_plane_lowres (tiling-4)
[426.584104] Starting subtest: tiling-4
[426.585475] Subtest tiling-4: SKIP (0.000s)
[426.674837] [121/130] (599s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[426.761645] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[426.763069] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[426.885251] [122/130] (599s left) kms_psr (pr-cursor-render)
[426.970971] Subtest pr-cursor-render: SKIP (0.000s)
[427.018670] [123/130] (599s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[427.107727] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[428.211442] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (1.104s)
[428.343999] [124/130] (598s left) kms_cursor_crc (cursor-onscreen-64x21)
[428.437453] Starting subtest: cursor-onscreen-64x21
[428.443028] Starting dynamic subtest: pipe-A-HDMI-A-1
[429.330475] Dynamic subtest pipe-A-HDMI-A-1: FAIL (0.695s)
[429.340678] Starting dynamic subtest: pipe-D-HDMI-A-1
[430.407487] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.234s)
[430.408218] Subtest cursor-onscreen-64x21: FAIL (1.970s)
[430.584786] [125/130] (595s left) perf_pmu (busy-idle-no-semaphores)
[430.621704] Starting subtest: busy-idle-no-semaphores
[430.622389] Starting dynamic subtest: rcs0
[431.275065] Dynamic subtest rcs0: SUCCESS (0.644s)
[431.286875] Starting dynamic subtest: bcs0
[431.899289] Dynamic subtest bcs0: SUCCESS (0.622s)
[431.910949] Starting dynamic subtest: vcs0
[432.522830] Dynamic subtest vcs0: SUCCESS (0.621s)
[432.534799] Starting dynamic subtest: vcs1
[433.150024] Dynamic subtest vcs1: SUCCESS (0.625s)
[433.162231] Starting dynamic subtest: vecs0
[433.773848] Dynamic subtest vecs0: SUCCESS (0.622s)
[433.774671] Subtest busy-idle-no-semaphores: SUCCESS (3.145s)
[433.858911] [126/130] (592s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[433.945862] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[433.946537] Starting dynamic subtest: pipe-A
[435.006489] Dynamic subtest pipe-A: SKIP (1.059s)
[435.018697] Starting dynamic subtest: pipe-B
[436.123578] Dynamic subtest pipe-B: SKIP (1.116s)
[436.135633] Starting dynamic subtest: pipe-C
[437.190768] Dynamic subtest pipe-C: SKIP (1.066s)
[437.199861] Starting dynamic subtest: pipe-D
[438.259396] Dynamic subtest pipe-D: SKIP (1.067s)
[438.260841] Subtest plane-scaler-with-clipping-clamping-rotation: SKIP (4.313s)
[438.445739] [127/130] (588s left) gem_mmap (short-mmap)
[438.493291] Starting subtest: short-mmap
[438.493991] Subtest short-mmap: SUCCESS (0.000s)
[438.602314] [128/130] (587s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[438.693735] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[438.695076] Subtest psr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[438.802379] [129/130] (587s left) gem_ctx_param (invalid-ctx-set)
[438.837047] Starting subtest: invalid-ctx-set
[438.837846] Subtest invalid-ctx-set: SUCCESS (0.000s)
[438.920393] [130/130] (587s left) i915_suspend (basic-s3-without-i915)
[438.951972] Starting subtest: basic-s3-without-i915