[60.969749] Initializing watchdogs
[60.969814]   /dev/watchdog0
[60.989565] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[61.000227] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[61.004637] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.007262] [001/132] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[61.196607] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[61.198273] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[61.360142] [002/132] (960s left) kms_psr (fbc-pr-sprite-plane-move)
[61.540341] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[61.591875] [003/132] (960s left) kms_cursor_crc (cursor-onscreen-512x170)
[62.103899] Starting subtest: cursor-onscreen-512x170
[62.105623] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[62.342586] [004/132] (959s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[62.531599] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[62.533276] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[62.706060] [005/132] (959s left) prime_mmap (test_invalid_sync_flags)
[62.775639] Starting subtest: test_invalid_sync_flags
[62.776661] Starting dynamic subtest: test_invalid_sync_flags-smem
[62.777511] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[62.785407] Starting dynamic subtest: test_invalid_sync_flags-lmem0
[62.786295] Dynamic subtest test_invalid_sync_flags-lmem0: SUCCESS (0.000s)
[62.787542] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[62.958996] [006/132] (958s left) gem_softpin (allocator-evict)
[63.044275] Starting subtest: allocator-evict
[63.045162] Starting dynamic subtest: rcs0
[90.269453] Dynamic subtest rcs0: SUCCESS (27.244s)
[90.277841] Starting dynamic subtest: bcs0
[117.573477] Dynamic subtest bcs0: SUCCESS (27.303s)
[117.581956] Starting dynamic subtest: vcs0
[145.004538] Dynamic subtest vcs0: SUCCESS (27.431s)
[145.012853] Starting dynamic subtest: vcs1
[172.577441] Dynamic subtest vcs1: SUCCESS (27.573s)
[172.586133] Starting dynamic subtest: vecs0
[199.635278] Dynamic subtest vecs0: SUCCESS (27.058s)
[199.643812] Starting dynamic subtest: vecs1
[226.776482] Dynamic subtest vecs1: SUCCESS (27.141s)
[226.784928] Starting dynamic subtest: ccs0
[254.044447] Dynamic subtest ccs0: SUCCESS (27.268s)
[254.045394] Subtest allocator-evict: SUCCESS (191.020s)
[254.229862] [007/132] (767s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[254.428753] Starting subtest: plane-all-transition-nonblocking-fencing
[254.429580] Starting dynamic subtest: pipe-A-DP-3
[258.220094] Dynamic subtest pipe-A-DP-3: SUCCESS (3.789s)
[258.358524] Starting dynamic subtest: pipe-B-DP-3
[262.244754] Dynamic subtest pipe-B-DP-3: SUCCESS (3.897s)
[262.350237] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (7.921s)
[262.635672] [008/132] (759s left) api_intel_bb (render)
[262.708965] Starting subtest: render
[262.709936] Starting dynamic subtest: render-none-512
[262.761469] Dynamic subtest render-none-512: SUCCESS (0.053s)
[262.770550] Starting dynamic subtest: render-none-1024
[262.833802] Dynamic subtest render-none-1024: SUCCESS (0.072s)
[262.843537] Starting dynamic subtest: render-x-512
[262.852378] Dynamic subtest render-x-512: SUCCESS (0.018s)
[262.861309] Starting dynamic subtest: render-x-1024
[262.927237] Dynamic subtest render-x-1024: SUCCESS (0.075s)
[262.936141] Starting dynamic subtest: render-y-512
[262.945612] Dynamic subtest render-y-512: SUCCESS (0.018s)
[262.954584] Starting dynamic subtest: render-y-1024
[263.008528] Dynamic subtest render-y-1024: SUCCESS (0.062s)
[263.009485] Subtest render: SUCCESS (0.301s)
[263.184250] [009/132] (758s left) gem_userptr_blits (relocations)
[263.262255] Starting subtest: relocations
[263.263961] Subtest relocations: SKIP (0.001s)
[263.470985] [010/132] (758s left) kms_cursor_legacy (single-move)
[263.651420] Starting subtest: single-move
[263.652311] Starting dynamic subtest: pipe-A
[269.032158] Dynamic subtest pipe-A: SUCCESS (5.380s)
[269.041425] Starting dynamic subtest: pipe-B
[274.411169] Dynamic subtest pipe-B: SUCCESS (5.379s)
[274.420264] Starting dynamic subtest: pipe-C
[279.789939] Dynamic subtest pipe-C: SUCCESS (5.379s)
[279.799068] Starting dynamic subtest: pipe-D
[285.174559] Dynamic subtest pipe-D: SUCCESS (5.378s)
[285.183499] Starting dynamic subtest: all-pipes
[290.548334] Dynamic subtest all-pipes: SUCCESS (5.379s)
[290.549278] Subtest single-move: SUCCESS (26.896s)
[290.654732] [011/132] (731s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[290.834585] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[290.835425] Starting dynamic subtest: pipe-A-DP-3
[290.857376] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[290.866255] Starting dynamic subtest: pipe-B-DP-3
[290.887507] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[290.896432] Starting dynamic subtest: pipe-C-DP-3
[290.922311] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[290.931186] Starting dynamic subtest: pipe-D-DP-3
[290.953274] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[290.954824] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.011s)
[291.323710] [012/132] (730s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[291.507670] Starting subtest: psr-1p-primscrn-cur-indfb-move
[291.509318] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[291.672198] [013/132] (730s left) kms_atomic_interruptible (atomic-setmode)
[291.848158] Starting subtest: atomic-setmode
[291.848992] Starting dynamic subtest: pipe-A-DP-3
[298.192478] Dynamic subtest pipe-A-DP-3: SUCCESS (6.342s)
[298.193897] Subtest atomic-setmode: SUCCESS (6.344s)
[298.472634] [014/132] (723s left) kms_prop_blob (invalid-get-prop-any)
[298.541994] Starting subtest: invalid-get-prop-any
[298.542952] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[298.722478] [015/132] (723s left) gem_exec_schedule (preempt-other-chain)
[298.806490] Starting subtest: preempt-other-chain
[298.807404] Starting dynamic subtest: rcs0
[299.446889] Dynamic subtest rcs0: SUCCESS (0.640s)
[299.456266] Starting dynamic subtest: bcs0
[300.069500] Dynamic subtest bcs0: SUCCESS (0.622s)
[300.078819] Starting dynamic subtest: vcs0
[300.684584] Dynamic subtest vcs0: SUCCESS (0.615s)
[300.693954] Starting dynamic subtest: vcs1
[301.332436] Dynamic subtest vcs1: SUCCESS (0.647s)
[301.341983] Starting dynamic subtest: vecs0
[302.016418] Dynamic subtest vecs0: SUCCESS (0.684s)
[302.025868] Starting dynamic subtest: vecs1
[302.637377] Dynamic subtest vecs1: SUCCESS (0.621s)
[302.646683] Starting dynamic subtest: ccs0
[303.277673] Dynamic subtest ccs0: SUCCESS (0.640s)
[303.278727] Subtest preempt-other-chain: SUCCESS (4.471s)
[303.729591] [016/132] (718s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[303.914410] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[303.916131] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[304.100857] [017/132] (718s left) kms_content_protection (uevent)
[304.346200] Starting subtest: uevent
[304.374179] Starting dynamic subtest: pipe-A-DP-3
[338.612672] Dynamic subtest pipe-A-DP-3: FAIL (34.187s)
[338.682493] Subtest uevent: FAIL (34.336s)
[338.987606] [018/132] (683s left) gem_exec_fence (syncobj-signal)
[339.617357] Starting subtest: syncobj-signal
[339.648248] Subtest syncobj-signal: SUCCESS (0.031s)
[340.084160] [FACT gem_exec_fence (syncobj-signal)] new: kernel.kmod_is_loaded.vgem: true
[340.086131] [019/132] (682s left) gem_exec_schedule (semaphore-resolve)
[340.175368] Starting subtest: semaphore-resolve
[340.258849] Subtest semaphore-resolve: SUCCESS (0.080s)
[340.683161] [020/132] (682s left) syncobj_basic (bad-handle-to-fd)
[340.761027] Starting subtest: bad-handle-to-fd
[340.761949] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[340.954078] [021/132] (682s left) gem_ctx_exec (basic-norecovery)
[341.036962] Starting subtest: basic-norecovery
[341.413174] Subtest basic-norecovery: SUCCESS (0.376s)
[341.602144] [022/132] (681s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[341.803067] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[343.137953] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.334s)
[343.373789] [023/132] (679s left) gem_mmap_wc (fault-concurrent)
[343.450116] Subtest fault-concurrent: SKIP (0.000s)
[343.529704] [024/132] (679s left) kms_flip (2x-flip-vs-wf_vblank)
[343.717865] Starting subtest: 2x-flip-vs-wf_vblank
[343.732628] Subtest 2x-flip-vs-wf_vblank: SKIP (0.014s)
[343.879361] [025/132] (679s left) syncobj_wait (reset-signaled)
[343.957282] Starting subtest: reset-signaled
[343.958244] Subtest reset-signaled: SUCCESS (0.000s)
[344.100322] [026/132] (679s left) gen3_render_tiledy_blits
[344.246141] [027/132] (679s left) kms_psr2_su (page_flip-nv12)
[344.323880] Subtest page_flip-NV12: SKIP (0.000s)
[344.400167] [028/132] (678s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[344.599417] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[344.601119] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[344.781940] [029/132] (678s left) gem_pxp (hw-rejects-pxp-buffer)
[347.386526] Starting subtest: hw-rejects-pxp-buffer
[347.387385] Subtest hw-rejects-pxp-buffer: SUCCESS (0.000s)
[347.556540] [030/132] (675s left) gem_render_copy (linear)
[347.641441] Starting subtest: linear
[347.642416] Starting dynamic subtest: smem
[347.746466] Dynamic subtest smem: SUCCESS (0.105s)
[347.758666] Starting dynamic subtest: lmem0
[348.050747] Dynamic subtest lmem0: SUCCESS (0.304s)
[348.051573] Subtest linear: SUCCESS (0.409s)
[348.338246] [031/132] (675s left) kms_psr (fbc-psr-sprite-render)
[348.522588] Subtest fbc-psr-sprite-render: SKIP (0.000s)
[348.579088] [032/132] (675s left) api_intel_allocator (reserve-simple)
[348.656067] Starting subtest: reserve-simple
[348.683591] Subtest reserve-simple: SUCCESS (0.028s)
[348.920605] [033/132] (674s left) kms_plane (plane-panning-bottom-right-suspend)
[349.113481] Starting subtest: plane-panning-bottom-right-suspend
[349.115385] Starting dynamic subtest: pipe-A
[368.666957] Dynamic subtest pipe-A: SUCCESS (4.714s)
[368.679867] Starting dynamic subtest: pipe-B
[389.102661] Dynamic subtest pipe-B: SUCCESS (4.220s)
[389.103587] Subtest plane-panning-bottom-right-suspend: SUCCESS (8.937s)
[389.373085] [034/132] (634s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[389.564226] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[389.565975] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[389.753597] [035/132] (634s left) gem_ctx_persistence (legacy-engines-hang)
[389.849889] Starting subtest: legacy-engines-hang
[389.851128] Starting dynamic subtest: render
[390.020984] Dynamic subtest render: SUCCESS (0.171s)
[390.068031] Starting dynamic subtest: bsd1
[390.074964] Dynamic subtest bsd1: SUCCESS (0.052s)
[390.089507] Starting dynamic subtest: bsd2
[390.164111] Dynamic subtest bsd2: SUCCESS (0.088s)
[390.190443] Starting dynamic subtest: blt
[390.221448] Dynamic subtest blt: SUCCESS (0.056s)
[390.257313] Starting dynamic subtest: vebox
[390.258568] Dynamic subtest vebox: SUCCESS (0.024s)
[390.259605] Subtest legacy-engines-hang: SUCCESS (0.399s)
[390.451330] [036/132] (633s left) gem_userptr_blits (process-exit)
[390.541306] Starting subtest: process-exit
[390.550862] Subtest process-exit: SUCCESS (0.009s)
[390.738377] [037/132] (633s left) gem_pipe_control_store_loop (fresh-buffer)
[390.828402] Starting subtest: fresh-buffer
[393.005470] Subtest fresh-buffer: SUCCESS (2.177s)
[393.185561] [038/132] (630s left) gem_exec_schedule (fifo)
[393.274899] Starting subtest: fifo
[393.275763] Starting dynamic subtest: rcs0
[393.553005] Dynamic subtest rcs0: SUCCESS (0.279s)
[393.565200] Starting dynamic subtest: bcs0
[393.753718] Dynamic subtest bcs0: SUCCESS (0.200s)
[393.765978] Starting dynamic subtest: vcs0
[393.959474] Dynamic subtest vcs0: SUCCESS (0.205s)
[393.971848] Starting dynamic subtest: vcs1
[394.166714] Dynamic subtest vcs1: SUCCESS (0.207s)
[394.178705] Starting dynamic subtest: vecs0
[394.371607] Dynamic subtest vecs0: SUCCESS (0.204s)
[394.384026] Starting dynamic subtest: vecs1
[394.578016] Dynamic subtest vecs1: SUCCESS (0.206s)
[394.590027] Starting dynamic subtest: ccs0
[394.784810] Dynamic subtest ccs0: SUCCESS (0.206s)
[394.785814] Subtest fifo: SUCCESS (1.511s)
[395.254431] [039/132] (628s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[395.443332] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[395.445002] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[395.639365] [040/132] (628s left) syncobj_timeline (single-wait-all-available-submitted)
[395.724950] Starting subtest: single-wait-all-available-submitted
[395.725880] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[395.859059] [041/132] (628s left) syncobj_timeline (etime-multi-wait-all-submitted)
[395.935399] Starting subtest: etime-multi-wait-all-submitted
[396.043294] Subtest etime-multi-wait-all-submitted: SUCCESS (0.107s)
[396.219473] [042/132] (628s left) kms_frontbuffer_tracking (psr-suspend)
[396.408625] Starting subtest: psr-suspend
[396.410286] Subtest psr-suspend: SKIP (0.000s)
[396.573625] [043/132] (627s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[396.770213] Starting subtest: yf-tiled-64bpp-rotate-270
[396.772009] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[396.967464] [044/132] (627s left) kms_vblank (query-idle-hang)
[397.150690] Starting subtest: query-idle-hang
[397.152871] Starting dynamic subtest: pipe-A-DP-3
[423.613095] Dynamic subtest pipe-A-DP-3: SUCCESS (26.461s)
[423.628316] Starting dynamic subtest: pipe-D-DP-3
[448.572197] Dynamic subtest pipe-D-DP-3: SUCCESS (24.955s)
[448.573024] Subtest query-idle-hang: SUCCESS (51.420s)
[448.887440] [045/132] (575s left) gem_eio (wait-1us)
[449.124002] Starting subtest: wait-1us
[449.714488] Subtest wait-1us: SUCCESS (0.590s)
[449.992286] [046/132] (574s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[450.180031] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[450.180944] Starting dynamic subtest: pipe-A-valid-mode
[450.259138] Dynamic subtest pipe-A-valid-mode: SKIP (0.078s)
[450.261014] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.080s)
[450.499935] [047/132] (574s left) kms_psr (fbc-psr2-sprite-render)
[450.687312] Subtest fbc-psr2-sprite-render: SKIP (0.000s)
[450.740844] [048/132] (574s left) gem_exec_balancer (nop)
[450.828143] Starting subtest: nop
[500.233124] Subtest nop: SUCCESS (49.405s)
[500.646494] [049/132] (524s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[500.835484] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[506.266102] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (5.431s)
[506.531509] [050/132] (518s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[506.608926] Starting subtest: invalid-multi-wait-unsubmitted
[506.609973] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[506.764224] [051/132] (518s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[506.957544] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[506.959160] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[507.149075] [052/132] (518s left) gem_exec_create (basic)
[507.234334] Starting subtest: basic
[507.235265] Starting dynamic subtest: smem
[509.335255] Dynamic subtest smem: SUCCESS (2.100s)
[509.348608] Starting dynamic subtest: lmem0
[511.434966] Dynamic subtest lmem0: SUCCESS (2.099s)
[511.436153] Subtest basic: SUCCESS (4.201s)
[511.713499] [053/132] (513s left) kms_sequence (get-busy)
[511.898235] Starting subtest: get-busy
[511.899158] Starting dynamic subtest: pipe-A-DP-3
[514.471294] Dynamic subtest pipe-A-DP-3: SUCCESS (2.572s)
[514.485434] Starting dynamic subtest: pipe-B-DP-3
[516.957653] Dynamic subtest pipe-B-DP-3: SUCCESS (2.485s)
[516.970236] Starting dynamic subtest: pipe-C-DP-3
[519.425221] Dynamic subtest pipe-C-DP-3: SUCCESS (2.466s)
[519.443053] Starting dynamic subtest: pipe-D-DP-3
[521.904915] Dynamic subtest pipe-D-DP-3: SUCCESS (2.478s)
[521.905948] Subtest get-busy: SUCCESS (10.006s)
[522.224055] [054/132] (503s left) gem_exec_reloc (basic-gtt-read)
[522.316211] Subtest basic-gtt-read: SKIP (0.000s)
[522.426780] [055/132] (502s left) kms_pm_rpm (cursor)
[524.045976] Starting subtest: cursor
[524.049413] Subtest cursor: SKIP (0.000s)
[524.491905] [056/132] (501s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[524.748026] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[524.899649] [057/132] (500s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[525.094605] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[525.096210] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[525.263488] [058/132] (500s left) kms_flip (flip-vs-dpms-on-nop)
[525.452116] Starting subtest: flip-vs-dpms-on-nop
[525.456459] Starting dynamic subtest: A-DP3
[526.586268] Dynamic subtest A-DP3: SUCCESS (1.130s)
[526.602646] Starting dynamic subtest: B-DP3
[527.650985] Dynamic subtest B-DP3: SUCCESS (1.063s)
[527.664301] Starting dynamic subtest: C-DP3
[528.715943] Dynamic subtest C-DP3: SUCCESS (1.064s)
[528.729279] Starting dynamic subtest: D-DP3
[529.760308] Dynamic subtest D-DP3: SUCCESS (1.043s)
[529.768035] Subtest flip-vs-dpms-on-nop: SUCCESS (4.315s)
[530.125642] [059/132] (495s left) kms_psr (psr2-primary-page-flip)
[530.316516] Subtest psr2-primary-page-flip: SKIP (0.000s)
[530.384039] [060/132] (495s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-mmap-gtt)
[530.574637] Starting subtest: fbcpsr-abgr161616f-draw-mmap-gtt
[530.576260] Subtest fbcpsr-abgr161616f-draw-mmap-gtt: SKIP (0.000s)
[530.748987] [061/132] (495s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[530.954460] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[530.956023] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[531.159594] [062/132] (494s left) gem_exec_reloc (basic-cpu-read-noreloc)
[531.244570] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[531.335635] [063/132] (494s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[531.519661] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[531.520526] Starting dynamic subtest: pipe-A
[531.604860] Dynamic subtest pipe-A: SUCCESS (0.085s)
[531.622020] Starting dynamic subtest: pipe-B
[531.818128] Dynamic subtest pipe-B: SUCCESS (0.212s)
[531.832385] Starting dynamic subtest: pipe-C
[532.014806] Dynamic subtest pipe-C: SUCCESS (0.196s)
[532.036597] Starting dynamic subtest: pipe-D
[532.250077] Dynamic subtest pipe-D: SUCCESS (0.234s)
[532.250982] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (0.731s)
[532.580233] [064/132] (493s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[532.767670] Starting subtest: cursorB-vs-flipB-legacy
[532.770759] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[532.932566] [065/132] (493s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[533.121586] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[533.123702] Starting dynamic subtest: pipe-A-DP-3
[533.126987] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[533.139399] Starting dynamic subtest: pipe-B-DP-3
[533.142884] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[533.155115] Starting dynamic subtest: pipe-C-DP-3
[533.158586] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[533.170738] Starting dynamic subtest: pipe-D-DP-3
[533.174072] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[533.175741] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.006s)
[533.574767] [066/132] (492s left) fbdev (nullptr)
[533.641381] Starting subtest: nullptr
[533.642246] Subtest nullptr: SUCCESS (0.000s)
[533.744414] [067/132] (492s left) kms_chamelium_color (ctm-0-75)
[533.932189] Subtest ctm-0-75: SKIP (0.000s)
[534.036158] [068/132] (492s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[534.225720] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[534.227448] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[534.444964] [069/132] (492s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[534.631357] Starting subtest: plane-primary-overlay-mutable-zpos
[536.686287] Subtest plane-primary-overlay-mutable-zpos: SKIP (2.053s)
[537.080065] [070/132] (489s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[537.266632] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[538.367351] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (1.100s)
[538.673321] [071/132] (488s left) kms_pm_backlight (basic-brightness)
[538.859720] Subtest basic-brightness: SKIP (0.000s)
[538.931383] [072/132] (487s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[539.121963] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[539.122876] Starting dynamic subtest: pipe-A-DP-3
[539.131125] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[539.143807] Starting dynamic subtest: pipe-B-DP-3
[539.152295] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[539.164808] Starting dynamic subtest: pipe-C-DP-3
[539.173007] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[539.185493] Starting dynamic subtest: pipe-D-DP-3
[539.196219] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[539.198204] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.008s)
[539.595609] [073/132] (487s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[539.961337] Starting subtest: cursor-rapid-movement-128x128
[539.966061] Starting dynamic subtest: pipe-A-DP-3
[540.456066] Dynamic subtest pipe-A-DP-3: SUCCESS (0.490s)
[540.504275] Starting dynamic subtest: pipe-D-DP-3
[540.862164] Dynamic subtest pipe-D-DP-3: SUCCESS (0.370s)
[540.863155] Subtest cursor-rapid-movement-128x128: SUCCESS (0.901s)
[541.326322] [074/132] (485s left) gem_vm_create (create-ext)
[541.410962] Starting subtest: create-ext
[541.414943] Subtest create-ext: SUCCESS (0.004s)
[541.607150] [075/132] (485s left) kms_feature_discovery (chamelium)
[541.801523] Starting subtest: chamelium
[541.803188] Subtest chamelium: SKIP (0.000s)
[541.947056] [076/132] (485s left) gem_exec_whisper (basic-queues-priority)
[542.037229] Starting subtest: basic-queues-priority
[564.524331] Subtest basic-queues-priority: SUCCESS (22.486s)
[564.799647] [077/132] (462s left) kms_big_fb (linear-8bpp-rotate-270)
[564.994665] Starting subtest: linear-8bpp-rotate-270
[565.055943] Subtest linear-8bpp-rotate-270: SKIP (0.059s)
[565.270649] [078/132] (461s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[565.462002] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (0.000s)
[565.516650] [079/132] (461s left) kms_cursor_edge_walk (128x128-top-bottom)
[565.708994] Starting subtest: 128x128-top-bottom
[565.709912] Starting dynamic subtest: pipe-A-DP-3
[569.207710] Dynamic subtest pipe-A-DP-3: SUCCESS (3.497s)
[569.224926] Starting dynamic subtest: pipe-D-DP-3
[572.553589] Dynamic subtest pipe-D-DP-3: SUCCESS (3.344s)
[572.555110] Subtest 128x128-top-bottom: SUCCESS (6.846s)
[572.897424] [080/132] (454s left) syncobj_eventfd (timeline-wait-before-signal)
[572.976204] Starting subtest: timeline-wait-before-signal
[573.007178] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[573.134296] [081/132] (454s left) core_setmaster (master-drop-set-user)
[573.284799] Starting subtest: master-drop-set-user
[573.321533] Subtest master-drop-set-user: SUCCESS (0.037s)
[573.371419] [082/132] (454s left) gen9_exec_parse (batch-invalid-length)
[573.458171] Subtest batch-invalid-length: SKIP (0.000s)
[573.547548] [083/132] (454s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[573.735979] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[573.737677] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[573.942471] [084/132] (453s left) gem_exec_fence (basic-await)
[574.180387] Starting subtest: basic-await
[574.185043] Starting dynamic subtest: rcs0
[574.296478] Dynamic subtest rcs0: SUCCESS (0.115s)
[574.311880] Starting dynamic subtest: bcs0
[574.384526] Dynamic subtest bcs0: SUCCESS (0.087s)
[574.401889] Starting dynamic subtest: vcs0
[574.474117] Dynamic subtest vcs0: SUCCESS (0.088s)
[574.490374] Starting dynamic subtest: vcs1
[574.561014] Dynamic subtest vcs1: SUCCESS (0.086s)
[574.579430] Starting dynamic subtest: vecs0
[574.652215] Dynamic subtest vecs0: SUCCESS (0.090s)
[574.669422] Starting dynamic subtest: vecs1
[574.740865] Dynamic subtest vecs1: SUCCESS (0.087s)
[574.755282] Starting dynamic subtest: ccs0
[574.828382] Dynamic subtest ccs0: SUCCESS (0.086s)
[574.829296] Subtest basic-await: SUCCESS (0.649s)
[575.619974] [085/132] (452s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[575.805187] Starting subtest: compare-crc-sanitycheck-xr24
[575.806077] Starting dynamic subtest: pipe-A-DP-3
[576.376931] Dynamic subtest pipe-A-DP-3: SUCCESS (0.571s)
[576.396187] Starting dynamic subtest: pipe-B-DP-3
[576.849320] Dynamic subtest pipe-B-DP-3: SUCCESS (0.469s)
[576.864814] Starting dynamic subtest: pipe-C-DP-3
[577.306017] Dynamic subtest pipe-C-DP-3: SUCCESS (0.455s)
[577.322265] Starting dynamic subtest: pipe-D-DP-3
[577.766011] Dynamic subtest pipe-D-DP-3: SUCCESS (0.458s)
[577.766888] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.962s)
[578.057932] [086/132] (449s left) kms_flip (flip-vs-rmfb-interruptible)
[578.247016] Starting subtest: flip-vs-rmfb-interruptible
[578.250537] Starting dynamic subtest: A-DP3
[586.075221] Dynamic subtest A-DP3: SUCCESS (7.824s)
[586.118949] Starting dynamic subtest: B-DP3
[593.819886] Dynamic subtest B-DP3: SUCCESS (7.739s)
[593.861145] Starting dynamic subtest: C-DP3
[601.559832] Dynamic subtest C-DP3: SUCCESS (7.734s)
[601.600021] Starting dynamic subtest: D-DP3
[609.298442] Dynamic subtest D-DP3: SUCCESS (7.733s)
[609.304684] Subtest flip-vs-rmfb-interruptible: SUCCESS (31.058s)
[609.700196] [087/132] (418s left) gem_create (create-valid-nonaligned)
[609.775099] Starting subtest: create-valid-nonaligned
[609.775999] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[610.064479] [088/132] (417s left) intel_hwmon (hwmon-read)
[610.144606] Starting subtest: hwmon-read
[610.146961] Subtest hwmon-read: SUCCESS (0.001s)
[610.333827] [089/132] (417s left) gem_ctx_shared (detached-shared-gtt)
[610.422504] Starting subtest: detached-shared-gtt
[612.572853] Subtest detached-shared-gtt: SUCCESS (2.150s)
[614.705440] [090/132] (413s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[614.893028] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[614.893925] Starting dynamic subtest: pipe-A-valid-mode
[614.972716] Dynamic subtest pipe-A-valid-mode: SKIP (0.077s)
[614.974642] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.079s)
[615.226094] [091/132] (413s left) prime_self_import (export-vs-gem_close-race)
[615.274227] Starting subtest: export-vs-gem_close-race
[620.360065] Subtest export-vs-gem_close-race: SUCCESS (5.086s)
[620.558928] [092/132] (407s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[620.758186] Starting subtest: flip-vs-cursor-legacy
[630.340660] Subtest flip-vs-cursor-legacy: SUCCESS (9.582s)
[630.648134] [093/132] (397s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[630.845024] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[632.163649] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.317s)
[632.417798] [094/132] (396s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[632.604117] Starting subtest: cursorA-vs-flipA-varying-size
[643.572412] Subtest cursorA-vs-flipA-varying-size: SUCCESS (10.967s)
[643.894992] [095/132] (384s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[644.092178] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[644.093056] Starting dynamic subtest: pipe-A-DP-3
[644.101432] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[644.114238] Starting dynamic subtest: pipe-B-DP-3
[644.122643] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[644.135187] Starting dynamic subtest: pipe-C-DP-3
[644.143439] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[644.156096] Starting dynamic subtest: pipe-D-DP-3
[644.166811] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[644.168962] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.007s)
[644.586048] [096/132] (384s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[644.770132] Starting subtest: 2x-long-cursor-vs-flip-atomic
[644.771951] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.002s)
[644.905731] [097/132] (383s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[645.097874] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[645.100041] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[645.281412] [098/132] (383s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[645.475896] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[646.149104] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.673s)
[646.372147] [099/132] (382s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[646.566885] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[646.568651] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[646.750472] [100/132] (382s left) gen9_exec_parse (shadow-peek)
[646.835175] Subtest shadow-peek: SKIP (0.000s)
[646.938290] [101/132] (382s left) perf_pmu (multi-client)
[647.008498] Starting subtest: multi-client
[647.009349] Starting dynamic subtest: rcs0
[648.100516] Dynamic subtest rcs0: SUCCESS (1.090s)
[648.118009] Starting dynamic subtest: bcs0
[649.153825] Dynamic subtest bcs0: SUCCESS (1.048s)
[649.170554] Starting dynamic subtest: vcs0
[650.206830] Dynamic subtest vcs0: SUCCESS (1.048s)
[650.223803] Starting dynamic subtest: vcs1
[651.260019] Dynamic subtest vcs1: SUCCESS (1.049s)
[651.277937] Starting dynamic subtest: vecs0
[652.314096] Dynamic subtest vecs0: SUCCESS (1.049s)
[652.332125] Starting dynamic subtest: vecs1
[653.367098] Dynamic subtest vecs1: SUCCESS (1.048s)
[653.385170] Starting dynamic subtest: ccs0
[654.421743] Dynamic subtest ccs0: SUCCESS (1.049s)
[654.425998] Subtest multi-client: SUCCESS (7.415s)
[654.587305] [102/132] (374s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[654.781577] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[654.783227] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[654.972179] [103/132] (374s left) syncobj_timeline (transfer-timeline-point)
[655.047278] Starting subtest: transfer-timeline-point
[655.048184] Subtest transfer-timeline-point: SUCCESS (0.001s)
[655.237408] [104/132] (374s left) i915_pm_freq_api (freq-reset)
[655.325221] Starting subtest: freq-reset
[655.326222] Starting dynamic subtest: gt0
[655.744756] Dynamic subtest gt0: SUCCESS (0.418s)
[655.745788] Subtest freq-reset: SUCCESS (0.420s)
[655.876584] [105/132] (373s left) kms_psr (psr-cursor-render)
[656.063103] Subtest psr-cursor-render: SKIP (0.000s)
[656.130694] [106/132] (373s left) kms_properties (plane-properties-legacy)
[656.319062] Starting subtest: plane-properties-legacy
[656.319953] Starting dynamic subtest: pipe-A-DP-3
[656.825854] Dynamic subtest pipe-A-DP-3: SUCCESS (0.506s)
[656.845892] Starting dynamic subtest: pipe-B-DP-3
[657.368093] Dynamic subtest pipe-B-DP-3: SUCCESS (0.540s)
[657.383485] Starting dynamic subtest: pipe-C-DP-3
[657.902760] Dynamic subtest pipe-C-DP-3: SUCCESS (0.533s)
[657.918185] Starting dynamic subtest: pipe-D-DP-3
[658.408605] Dynamic subtest pipe-D-DP-3: SUCCESS (0.504s)
[658.409531] Subtest plane-properties-legacy: SUCCESS (2.090s)
[658.635199] [107/132] (370s left) kms_flip (wf_vblank-ts-check)
[658.825788] Starting subtest: wf_vblank-ts-check
[658.830469] Starting dynamic subtest: A-DP3
[666.968733] Dynamic subtest A-DP3: SUCCESS (8.138s)
[666.986955] Starting dynamic subtest: B-DP3
[675.021700] Dynamic subtest B-DP3: SUCCESS (8.051s)
[675.037639] Starting dynamic subtest: C-DP3
[683.074813] Dynamic subtest C-DP3: SUCCESS (8.051s)
[683.090933] Starting dynamic subtest: D-DP3
[691.127712] Dynamic subtest D-DP3: SUCCESS (8.051s)
[691.130154] Subtest wf_vblank-ts-check: SUCCESS (32.303s)
[691.494405] [108/132] (338s left) gem_ringfill (engines-basic)
[691.952880] Starting subtest: engines-basic
[691.954708] Starting dynamic subtest: rcs0
[692.067151] Dynamic subtest rcs0: SUCCESS (0.117s)
[692.090223] Starting dynamic subtest: bcs0
[692.110427] Dynamic subtest bcs0: SUCCESS (0.042s)
[692.137219] Starting dynamic subtest: vcs0
[692.155172] Dynamic subtest vcs0: SUCCESS (0.043s)
[692.175708] Starting dynamic subtest: vcs1
[692.198240] Dynamic subtest vcs1: SUCCESS (0.042s)
[692.218216] Starting dynamic subtest: vecs0
[692.240419] Dynamic subtest vecs0: SUCCESS (0.041s)
[692.265416] Starting dynamic subtest: vecs1
[692.284305] Dynamic subtest vecs1: SUCCESS (0.042s)
[692.309182] Starting dynamic subtest: ccs0
[692.330286] Dynamic subtest ccs0: SUCCESS (0.044s)
[692.331256] Subtest engines-basic: SUCCESS (0.383s)
[692.512203] [109/132] (337s left) i915_power (sanity)
[692.593212] Starting subtest: sanity
[696.656126] Subtest sanity: SUCCESS (4.063s)
[696.827211] [110/132] (332s left) kms_color_pipeline (plane-ctm3x4)
[697.024017] Starting subtest: plane-ctm3x4
[697.058387] Starting dynamic subtest: pipe-A-DP-3
[697.424348] Dynamic subtest pipe-A-DP-3: SUCCESS (0.366s)
[697.624571] Starting dynamic subtest: pipe-B-DP-3
[697.944207] Dynamic subtest pipe-B-DP-3: SUCCESS (0.332s)
[698.150977] Starting dynamic subtest: pipe-C-DP-3
[698.467748] Dynamic subtest pipe-C-DP-3: SUCCESS (0.331s)
[698.647520] Starting dynamic subtest: pipe-D-DP-3
[698.964706] Dynamic subtest pipe-D-DP-3: SUCCESS (0.331s)
[699.040943] Subtest plane-ctm3x4: SUCCESS (2.017s)
[699.375238] [111/132] (330s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[699.453106] Starting subtest: multi-wait-all-for-submit-available-submitted
[699.454029] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[699.602073] [112/132] (330s left) kms_invalid_mode (zero-vdisplay)
[699.792441] Starting subtest: zero-vdisplay
[699.793298] Starting dynamic subtest: pipe-A-DP-3
[699.877744] Dynamic subtest pipe-A-DP-3: SUCCESS (0.083s)
[699.898321] Starting dynamic subtest: pipe-B-DP-3
[699.899276] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[699.917342] Starting dynamic subtest: pipe-C-DP-3
[699.918498] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[699.932185] Starting dynamic subtest: pipe-D-DP-3
[699.933066] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[699.933938] Subtest zero-vdisplay: SUCCESS (0.095s)
[700.163900] [113/132] (329s left) sw_sync (alloc_fence_invalid_timeline)
[700.211404] Starting subtest: alloc_fence_invalid_timeline
[700.212272] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[700.364212] [114/132] (329s left) i915_pm_rpm (reg-read-ioctl)
[702.085611] Starting subtest: reg-read-ioctl
[702.872908] Subtest reg-read-ioctl: SUCCESS (0.787s)
[703.356160] [115/132] (326s left) perf_pmu (init-busy)
[703.425929] Starting subtest: init-busy
[703.426885] Starting dynamic subtest: rcs0
[703.429036] Dynamic subtest rcs0: SUCCESS (0.002s)
[703.443264] Starting dynamic subtest: bcs0
[703.444157] Dynamic subtest bcs0: SUCCESS (0.001s)
[703.458045] Starting dynamic subtest: vcs0
[703.459248] Dynamic subtest vcs0: SUCCESS (0.001s)
[703.473304] Starting dynamic subtest: vcs1
[703.474384] Dynamic subtest vcs1: SUCCESS (0.001s)
[703.488115] Starting dynamic subtest: vecs0
[703.489367] Dynamic subtest vecs0: SUCCESS (0.001s)
[703.503896] Starting dynamic subtest: vecs1
[703.505000] Dynamic subtest vecs1: SUCCESS (0.001s)
[703.519145] Starting dynamic subtest: ccs0
[703.520410] Dynamic subtest ccs0: SUCCESS (0.001s)
[703.521549] Subtest init-busy: SUCCESS (0.014s)
[703.593303] [116/132] (326s left) syncobj_wait (wait-any-interrupted)
[703.674126] Starting subtest: wait-any-interrupted
[703.776255] Subtest wait-any-interrupted: SUCCESS (0.101s)
[703.943881] [117/132] (326s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[704.132898] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[704.134623] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[704.330379] [118/132] (326s left) gem_exec_parallel (contexts)
[704.419128] Starting subtest: contexts
[704.420083] Starting dynamic subtest: rcs0
[709.329675] Dynamic subtest rcs0: SUCCESS (4.910s)
[709.343959] Starting dynamic subtest: bcs0
[714.083350] Dynamic subtest bcs0: SUCCESS (4.752s)
[714.097405] Starting dynamic subtest: vcs0
[719.043918] Dynamic subtest vcs0: SUCCESS (4.959s)
[719.057696] Starting dynamic subtest: vcs1
[723.897798] Dynamic subtest vcs1: SUCCESS (4.853s)
[723.912251] Starting dynamic subtest: vecs0
[729.328393] Dynamic subtest vecs0: SUCCESS (5.429s)
[729.342538] Starting dynamic subtest: vecs1
[734.307657] Dynamic subtest vecs1: SUCCESS (4.978s)
[734.321795] Starting dynamic subtest: ccs0
[739.120669] Dynamic subtest ccs0: SUCCESS (4.812s)
[739.121676] Subtest contexts: SUCCESS (34.701s)
[739.444989] [119/132] (291s left) gem_exec_whisper (basic-fds)
[739.535401] Starting subtest: basic-fds
[750.730512] Subtest basic-fds: SUCCESS (11.193s)
[751.024915] [120/132] (279s left) gem_mmap_gtt (ptrace)
[751.101967] Subtest ptrace: SKIP (0.000s)
[751.174221] [121/132] (279s left) kms_vrr (max-min)
[751.361204] Starting subtest: max-min
[751.363872] Subtest max-min: SKIP (0.000s)
[751.500402] [122/132] (279s left) perf (invalid-open-flags)
[751.935674] Starting subtest: invalid-open-flags
[751.936528] Subtest invalid-open-flags: SUCCESS (0.000s)
[751.996574] [123/132] (278s left) gem_exec_reloc (basic-write-cpu-active)
[752.083953] Subtest basic-write-cpu-active: SKIP (0.000s)
[752.178319] [124/132] (278s left) kms_plane_alpha_blend (alpha-opaque-fb)
[752.366002] Starting subtest: alpha-opaque-fb
[752.627117] Starting dynamic subtest: pipe-A-DP-3
[753.136248] Dynamic subtest pipe-A-DP-3: SUCCESS (0.509s)
[753.154421] Starting dynamic subtest: pipe-D-DP-3
[753.730925] Dynamic subtest pipe-D-DP-3: SUCCESS (0.592s)
[753.731889] Subtest alpha-opaque-fb: SUCCESS (1.365s)
[754.067496] [125/132] (276s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[754.142374] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[754.250158] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.107s)
[754.422515] [126/132] (276s left) gem_lmem_swapping (verify-ccs)
[757.300048] Starting subtest: verify-ccs
[757.301788] Starting dynamic subtest: lmem0
[801.720470] Dynamic subtest lmem0: SUCCESS (44.420s)
[801.721386] Subtest verify-ccs: SUCCESS (44.421s)
[803.711361] [FACT gem_lmem_swapping (verify-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[803.712687] [FACT gem_lmem_swapping (verify-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[803.715045] [127/132] (227s left) gem_pxp (display-protected-crc)
[807.844191] Starting subtest: display-protected-crc
[807.846052] Subtest display-protected-crc: SKIP (0.000s)
[807.889351] [FACT gem_pxp (display-protected-crc)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[807.891638] [FACT gem_pxp (display-protected-crc)] new: kernel.kmod_is_loaded.i915: true
[807.894246] [128/132] (223s left) kms_big_fb (y-tiled-addfb)
[808.097328] Starting subtest: y-tiled-addfb
[808.099054] Subtest y-tiled-addfb: SKIP (0.000s)
[808.332942] [129/132] (222s left) kms_hdr (static-toggle-dpms)
[808.524549] Starting subtest: static-toggle-dpms
[809.050208] Starting dynamic subtest: pipe-A-DP-3
[810.317356] Dynamic subtest pipe-A-DP-3: SUCCESS (1.268s)
[810.318548] Subtest static-toggle-dpms: SUCCESS (1.794s)
[810.681703] [130/132] (220s left) kms_chamelium_color (degamma)
[810.869009] Subtest degamma: SKIP (0.000s)
[810.927014] [131/132] (220s left) gem_ctx_engines (execute-oneforall)
[811.014630] Starting subtest: execute-oneforall
[811.784803] Subtest execute-oneforall: SUCCESS (0.770s)
[812.512859] [132/132] (218s left) syncobj_wait (single-wait-all-for-submit-submitted)
[812.594317] Starting subtest: single-wait-all-for-submit-submitted
[812.698176] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.103s)
[812.880591] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: kms_cursor_crc
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: prime_mmap
results: parsing output: 5/ for test: gem_softpin
results: parsing output: 6/ for test: kms_atomic_transition
results: parsing output: 7/ for test: api_intel_bb
results: parsing output: 8/ for test: gem_userptr_blits
results: parsing output: 9/ for test: kms_cursor_legacy
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_atomic_interruptible
results: parsing output: 13/ for test: kms_prop_blob
results: parsing output: 14/ for test: gem_exec_schedule
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_content_protection
results: parsing output: 17/ for test: gem_exec_fence
results: parsing output: 18/ for test: gem_exec_schedule
results: parsing output: 19/ for test: syncobj_basic
results: parsing output: 20/ for test: gem_ctx_exec
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: gem_mmap_wc
results: parsing output: 23/ for test: kms_flip
results: parsing output: 24/ for test: syncobj_wait
results: parsing output: 25/ for test: gen3_render_tiledy_blits
results: parsing output: 26/ for test: kms_psr2_su
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_pxp
results: parsing output: 29/ for test: gem_render_copy
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: api_intel_allocator
results: parsing output: 32/ for test: kms_plane
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_ctx_persistence
results: parsing output: 35/ for test: gem_userptr_blits
results: parsing output: 36/ for test: gem_pipe_control_store_loop
results: parsing output: 37/ for test: gem_exec_schedule
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: kms_vblank
results: parsing output: 44/ for test: gem_eio
results: parsing output: 45/ for test: kms_flip_scaled_crc
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: gem_exec_balancer
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_exec_create
results: parsing output: 52/ for test: kms_sequence
results: parsing output: 53/ for test: gem_exec_reloc
results: parsing output: 54/ for test: kms_pm_rpm
results: parsing output: 55/ for test: kms_chamelium_hpd
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_exec_reloc
results: parsing output: 62/ for test: kms_plane_scaling
results: parsing output: 63/ for test: kms_cursor_legacy
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: fbdev
results: parsing output: 66/ for test: kms_chamelium_color
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_atomic
results: parsing output: 69/ for test: kms_cursor_legacy
results: parsing output: 70/ for test: kms_pm_backlight
results: parsing output: 71/ for test: kms_ccs
results: parsing output: 72/ for test: kms_cursor_crc
results: parsing output: 73/ for test: gem_vm_create
results: parsing output: 74/ for test: kms_feature_discovery
results: parsing output: 75/ for test: gem_exec_whisper
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_psr2_sf
results: parsing output: 78/ for test: kms_cursor_edge_walk
results: parsing output: 79/ for test: syncobj_eventfd
results: parsing output: 80/ for test: core_setmaster
results: parsing output: 81/ for test: gen9_exec_parse
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_exec_fence
results: parsing output: 84/ for test: kms_pipe_crc_basic
results: parsing output: 85/ for test: kms_flip
results: parsing output: 86/ for test: gem_create
results: parsing output: 87/ for test: intel_hwmon
results: parsing output: 88/ for test: gem_ctx_shared
results: parsing output: 89/ for test: kms_flip_scaled_crc
results: parsing output: 90/ for test: prime_self_import
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: kms_cursor_legacy
results: parsing output: 94/ for test: kms_ccs
results: parsing output: 95/ for test: kms_cursor_legacy
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gen9_exec_parse
results: parsing output: 100/ for test: perf_pmu
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: i915_pm_freq_api
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: kms_properties
results: parsing output: 106/ for test: kms_flip
results: parsing output: 107/ for test: gem_ringfill
results: parsing output: 108/ for test: i915_power
results: parsing output: 109/ for test: kms_color_pipeline
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: kms_invalid_mode
results: parsing output: 112/ for test: sw_sync
results: parsing output: 113/ for test: i915_pm_rpm
results: parsing output: 114/ for test: perf_pmu
results: parsing output: 115/ for test: syncobj_wait
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: gem_exec_parallel
results: parsing output: 118/ for test: gem_exec_whisper
results: parsing output: 119/ for test: gem_mmap_gtt
results: parsing output: 120/ for test: kms_vrr
results: parsing output: 121/ for test: perf
results: parsing output: 122/ for test: gem_exec_reloc
results: parsing output: 123/ for test: kms_plane_alpha_blend
results: parsing output: 124/ for test: syncobj_wait
results: parsing output: 125/ for test: gem_lmem_swapping
results: parsing output: 126/ for test: gem_pxp
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: kms_hdr
results: parsing output: 129/ for test: kms_chamelium_color
results: parsing output: 130/ for test: gem_ctx_engines
results: parsing output: 131/ for test: syncobj_wait
Done.