[52.141486] Initializing watchdogs
[52.141546]   /dev/watchdog0
[52.157445] [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.163265] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[52.165724] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[52.168417] [001/133] (960s left) kms_properties (connector-properties-legacy)
[52.259347] Starting subtest: connector-properties-legacy
[52.260872] Starting dynamic subtest: pipe-A-HDMI-A-1
[52.811436] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.547s)
[52.817173] Starting dynamic subtest: pipe-None-DP-1
[52.818590] Dynamic subtest pipe-None-DP-1: SUCCESS (0.002s)
[52.824635] Starting dynamic subtest: pipe-None-DP-2
[52.833219] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[52.838490] Starting dynamic subtest: pipe-None-DP-3
[52.840905] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[52.846362] Starting dynamic subtest: pipe-None-DP-4
[52.848071] Dynamic subtest pipe-None-DP-4: SUCCESS (0.002s)
[52.848851] Subtest connector-properties-legacy: SUCCESS (0.556s)
[52.947379] [002/133] (959s left) kms_content_protection (lic-type-0)
[53.041268] Starting subtest: lic-type-0
[53.046230] Subtest lic-type-0: SKIP (0.003s)
[53.131894] [003/133] (959s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[53.218850] Starting subtest: cursorB-vs-flipB-legacy
[53.220319] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[53.276966] [004/133] (959s left) kms_pm_rpm (fences-dpms)
[54.673252] Starting subtest: fences-dpms
[59.302210] Subtest fences-dpms: SUCCESS (4.603s)
[59.378682] [005/133] (953s left) kms_vblank (ts-continuation-modeset-rpm)
[59.466324] Starting subtest: ts-continuation-modeset-rpm
[59.467770] Starting dynamic subtest: pipe-A-HDMI-A-1
[61.047382] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.576s)
[61.055077] Starting dynamic subtest: pipe-D-HDMI-A-1
[62.274814] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.222s)
[62.275520] Subtest ts-continuation-modeset-rpm: SUCCESS (2.802s)
[62.427909] [006/133] (950s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[62.522714] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[62.524093] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[62.611408] [007/133] (950s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[62.645901] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[62.647350] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[62.702985] [008/133] (950s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[62.799159] Starting subtest: yf-tiled-64bpp-rotate-90
[62.800523] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[62.885583] [009/133] (950s left) kms_async_flips (test-cursor)
[62.970395] Starting subtest: test-cursor
[63.089803] Starting dynamic subtest: pipe-A-HDMI-A-1
[63.182260] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.092s)
[63.320042] Starting dynamic subtest: pipe-B-HDMI-A-1
[63.380065] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.067s)
[63.494745] Starting dynamic subtest: pipe-C-HDMI-A-1
[63.568837] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.081s)
[63.685282] Starting dynamic subtest: pipe-D-HDMI-A-1
[63.746525] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.067s)
[63.747217] Subtest test-cursor: SUCCESS (0.775s)
[63.998407] [010/133] (948s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[64.090730] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[64.092096] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s)
[64.145610] [011/133] (948s left) gem_ccs (block-copy-uncompressed)
[64.184293] Starting subtest: block-copy-uncompressed
[64.185043] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[64.205502] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.020s)
[64.211120] Starting dynamic subtest: ymajor-uncompressed-compfmt0-smem-smem
[64.222824] Dynamic subtest ymajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[64.223575] Subtest block-copy-uncompressed: SUCCESS (0.039s)
[64.322393] [012/133] (948s left) sriov_basic (enable-vfs-bind-unbind-each)
[64.356360] Starting subtest: enable-vfs-bind-unbind-each
[64.357063] Starting dynamic subtest: numvfs-1
[64.425869] Dynamic subtest numvfs-1: FAIL (0.057s)
[64.431541] Starting dynamic subtest: numvfs-2
[64.475231] Dynamic subtest numvfs-2: FAIL (0.048s)
[64.480876] Starting dynamic subtest: numvfs-3
[64.516705] Dynamic subtest numvfs-3: FAIL (0.041s)
[64.522357] Starting dynamic subtest: numvfs-4
[64.558093] Dynamic subtest numvfs-4: FAIL (0.041s)
[64.563758] Starting dynamic subtest: numvfs-5
[64.597881] Dynamic subtest numvfs-5: FAIL (0.040s)
[64.604031] Starting dynamic subtest: numvfs-6
[64.638438] Dynamic subtest numvfs-6: FAIL (0.040s)
[64.643938] Starting dynamic subtest: numvfs-7
[64.677216] Dynamic subtest numvfs-7: FAIL (0.038s)
[64.682721] Starting dynamic subtest: numvfs-random
[64.716856] Dynamic subtest numvfs-random: FAIL (0.039s)
[64.717510] Subtest enable-vfs-bind-unbind-each: FAIL (0.347s)
[64.778509] [013/133] (948s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[64.867384] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[64.868717] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[64.956485] [014/133] (948s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[65.044414] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[66.393339] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (1.347s)
[66.501831] [015/133] (946s left) syncobj_wait (invalid-wait-illegal-handle)
[66.536184] Starting subtest: invalid-wait-illegal-handle
[66.536932] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[66.592871] [016/133] (946s left) gem_mmap_gtt (basic-read-write)
[66.625714] Starting subtest: basic-read-write
[66.628904] Subtest basic-read-write: SUCCESS (0.003s)
[66.767301] [017/133] (946s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[66.900723] Starting subtest: fbc-farfromfence-mmap-gtt
[68.562234] Subtest fbc-farfromfence-mmap-gtt: SUCCESS (1.660s)
[68.662894] [018/133] (944s left) kms_psr (pr-primary-blt)
[68.751236] Subtest pr-primary-blt: SKIP (0.000s)
[68.788691] [019/133] (944s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[68.876699] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[68.878080] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[68.945028] [020/133] (944s left) gem_ctx_persistence (heartbeat-close)
[68.982531] Starting subtest: heartbeat-close
[69.187598] Subtest heartbeat-close: SUCCESS (0.204s)
[69.263363] [021/133] (944s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[69.298216] Starting subtest: etime-multi-wait-all-available-unsubmitted
[69.399737] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.101s)
[69.470590] [022/133] (943s left) gem_ctx_exec (basic-invalid-context)
[69.504668] Starting subtest: basic-invalid-context
[69.506692] Subtest basic-invalid-context: SUCCESS (0.002s)
[69.615171] [023/133] (943s left) i915_drm_fdinfo (virtual-busy-hang-all)
[69.649852] Starting subtest: virtual-busy-hang-all
[70.678436] Subtest virtual-busy-hang-all: SUCCESS (1.028s)
[70.748414] [024/133] (942s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[70.834308] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[70.835016] Starting dynamic subtest: pipe-A
[70.956157] Dynamic subtest pipe-A: SUCCESS (0.122s)
[70.962219] Starting dynamic subtest: pipe-B
[71.092931] Dynamic subtest pipe-B: SUCCESS (0.136s)
[71.099499] Starting dynamic subtest: pipe-C
[71.219676] Dynamic subtest pipe-C: SUCCESS (0.126s)
[71.227835] Starting dynamic subtest: pipe-D
[71.352193] Dynamic subtest pipe-D: SUCCESS (0.132s)
[71.352900] Subtest planes-unity-scaling-downscale-factor-0-5: SUCCESS (0.518s)
[71.526214] [025/133] (941s left) gem_render_copy (x-tiled)
[71.566538] Starting subtest: x-tiled
[71.567237] Starting dynamic subtest: smem
[71.664634] Dynamic subtest smem: SUCCESS (0.098s)
[71.665385] Subtest x-tiled: SUCCESS (0.099s)
[71.857771] [026/133] (941s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[71.891907] Starting subtest: multi-wait-all-for-submit-signaled
[71.892667] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[71.980249] [027/133] (941s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[72.066519] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[72.067210] Starting dynamic subtest: pipe-A-HDMI-A-1
[72.073638] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[72.079701] Starting dynamic subtest: pipe-B-HDMI-A-1
[72.086232] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[72.092082] Starting dynamic subtest: pipe-C-HDMI-A-1
[72.098563] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[72.104274] Starting dynamic subtest: pipe-D-HDMI-A-1
[72.110899] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[72.112212] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[72.307282] [028/133] (941s left) gem_userptr_blits (sd-probe)
[72.347548] Starting subtest: sd-probe
[72.348219] Subtest sd-probe: SUCCESS (0.001s)
[72.463487] [029/133] (941s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[72.551598] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[72.552975] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[72.637974] [030/133] (941s left) gem_exec_schedule (independent)
[72.690860] Starting subtest: independent
[72.691528] Starting dynamic subtest: rcs0
[72.790948] Dynamic subtest rcs0: SUCCESS (0.099s)
[72.803746] Starting dynamic subtest: bcs0
[72.900276] Dynamic subtest bcs0: SUCCESS (0.108s)
[72.914315] Starting dynamic subtest: vcs0
[73.006078] Dynamic subtest vcs0: SUCCESS (0.105s)
[73.018960] Starting dynamic subtest: vcs1
[73.111137] Dynamic subtest vcs1: SUCCESS (0.104s)
[73.125489] Starting dynamic subtest: vecs0
[73.224963] Dynamic subtest vecs0: SUCCESS (0.113s)
[73.226158] Subtest independent: SUCCESS (0.534s)
[73.518393] [031/133] (940s left) kms_big_fb (linear-8bpp-rotate-90)
[73.613762] Starting subtest: linear-8bpp-rotate-90
[73.686534] Subtest linear-8bpp-rotate-90: SKIP (0.072s)
[73.786729] [032/133] (939s left) gem_lmem_swapping (parallel-random-verify-ccs)
[73.824422] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[73.866299] [033/133] (939s left) gem_exec_reloc (basic-cpu-read-active)
[73.903936] Starting subtest: basic-cpu-read-active
[74.031686] Subtest basic-cpu-read-active: SUCCESS (0.119s)
[74.135682] [034/133] (939s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[74.228634] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[74.230015] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[74.325586] [035/133] (939s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[74.365554] Starting subtest: yf-tiled-to-vebox-y-tiled
[74.366310] Starting dynamic subtest: smem
[74.461377] Dynamic subtest smem: SUCCESS (0.096s)
[74.462098] Subtest yf-tiled-to-vebox-y-tiled: SUCCESS (0.097s)
[74.634873] [036/133] (939s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[74.718768] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[74.720305] Starting dynamic subtest: pipe-A-HDMI-A-1
[74.726359] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[74.732428] Starting dynamic subtest: pipe-B-HDMI-A-1
[74.738453] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[74.744322] Starting dynamic subtest: pipe-C-HDMI-A-1
[74.750243] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[74.756120] Starting dynamic subtest: pipe-D-HDMI-A-1
[74.761924] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[74.762617] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.007s)
[74.948349] [037/133] (939s left) kms_hdr (brightness-with-hdr)
[75.036500] Starting subtest: brightness-with-hdr
[75.038554] Subtest brightness-with-hdr: SKIP (0.000s)
[75.100833] [038/133] (938s left) i915_pm_rpm (gem-pread)
[76.496720] Starting subtest: gem-pread
[77.859482] Subtest gem-pread: SUCCESS (1.364s)
[77.969430] [039/133] (936s left) gem_exec_fence (basic-busy)
[78.133102] Starting subtest: basic-busy
[78.134127] Starting dynamic subtest: rcs0
[78.164362] Dynamic subtest rcs0: SUCCESS (0.031s)
[78.176646] Starting dynamic subtest: bcs0
[78.203492] Dynamic subtest bcs0: SUCCESS (0.038s)
[78.216440] Starting dynamic subtest: vcs0
[78.241199] Dynamic subtest vcs0: SUCCESS (0.037s)
[78.253215] Starting dynamic subtest: vcs1
[78.282614] Dynamic subtest vcs1: SUCCESS (0.040s)
[78.296156] Starting dynamic subtest: vecs0
[78.312462] Dynamic subtest vecs0: SUCCESS (0.029s)
[78.313377] Subtest basic-busy: SUCCESS (0.180s)
[78.790702] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[78.793188] [040/133] (935s left) gem_exec_reloc (basic-gtt-cpu-active)
[78.829394] Starting subtest: basic-gtt-cpu-active
[78.951141] Subtest basic-gtt-cpu-active: SUCCESS (0.121s)
[79.066540] [041/133] (935s left) kms_plane_lowres (tiling-none)
[79.150731] Starting subtest: tiling-none
[79.151437] Starting dynamic subtest: pipe-A-HDMI-A-1
[84.350350] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (5.199s)
[84.396887] Starting dynamic subtest: pipe-B-HDMI-A-1
[89.382527] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (4.992s)
[89.454924] Starting dynamic subtest: pipe-C-HDMI-A-1
[94.493992] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (5.046s)
[94.541261] Starting dynamic subtest: pipe-D-HDMI-A-1
[99.499137] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (4.963s)
[99.583347] Subtest tiling-none: SUCCESS (20.432s)
[99.733287] [042/133] (914s left) kms_cursor_legacy (forked-move)
[99.832878] Starting subtest: forked-move
[99.833594] Starting dynamic subtest: pipe-A
[105.298022] Dynamic subtest pipe-A: SUCCESS (5.430s)
[105.307999] Starting dynamic subtest: pipe-B
[110.721838] Dynamic subtest pipe-B: SUCCESS (5.423s)
[110.731459] Starting dynamic subtest: pipe-C
[116.142845] Dynamic subtest pipe-C: SUCCESS (5.419s)
[116.151751] Starting dynamic subtest: pipe-D
[121.561377] Dynamic subtest pipe-D: SUCCESS (5.416s)
[121.575938] Starting dynamic subtest: all-pipes
[127.002447] Dynamic subtest all-pipes: SUCCESS (5.439s)
[127.003432] Subtest forked-move: SUCCESS (27.136s)
[127.043885] [043/133] (887s left) gem_pwrite (basic-exhaustion)
[127.078423] Starting subtest: basic-exhaustion
[130.803256] Subtest basic-exhaustion: SUCCESS (3.712s)
[131.214956] [044/133] (883s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[131.307712] Starting subtest: cursor-rapid-movement-512x170
[131.310157] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[131.393407] [045/133] (882s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[131.477455] Starting subtest: multiplane-rotation-cropping-bottom
[156.890278] Subtest multiplane-rotation-cropping-bottom: SUCCESS (25.412s)
[156.997755] [046/133] (857s left) dmabuf_sync_file (import-multiple-read-only)
[157.040828] Starting subtest: import-multiple-read-only
[157.044186] Subtest import-multiple-read-only: SUCCESS (0.005s)
[157.090703] [047/133] (857s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[157.177169] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[157.177888] Starting dynamic subtest: pipe-A
[157.624743] Dynamic subtest pipe-A: SUCCESS (0.448s)
[157.635276] Starting dynamic subtest: pipe-B
[158.059607] Dynamic subtest pipe-B: SUCCESS (0.433s)
[158.067224] Starting dynamic subtest: pipe-C
[158.494490] Dynamic subtest pipe-C: SUCCESS (0.434s)
[158.504864] Starting dynamic subtest: pipe-D
[158.928691] Dynamic subtest pipe-D: SUCCESS (0.433s)
[158.929405] Subtest plane-downscale-factor-0-5-with-modifiers: SUCCESS (1.753s)
[159.081074] [048/133] (855s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[159.173381] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.000s)
[159.217804] [049/133] (855s left) gem_exec_balancer (busy)
[159.259314] Starting subtest: busy
[159.929526] Subtest busy: SUCCESS (0.670s)
[160.121937] [050/133] (854s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[160.575997] Starting subtest: syncobj-timeline-invalid-wait
[160.589387] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s)
[160.749986] [051/133] (853s left) gem_ctx_isolation (preservation-reset)
[160.911024] Starting subtest: preservation-reset
[160.921866] Starting dynamic subtest: rcs0
[161.026085] Dynamic subtest rcs0: SUCCESS (0.126s)
[161.033945] Starting dynamic subtest: bcs0
[161.186149] Dynamic subtest bcs0: SUCCESS (0.159s)
[161.194200] Starting dynamic subtest: vcs0
[161.338175] Dynamic subtest vcs0: SUCCESS (0.151s)
[161.346519] Starting dynamic subtest: vcs1
[161.495112] Dynamic subtest vcs1: SUCCESS (0.156s)
[161.503018] Starting dynamic subtest: vecs0
[161.651733] Dynamic subtest vecs0: SUCCESS (0.156s)
[161.654221] Subtest preservation-reset: SUCCESS (0.754s)
[161.748827] [052/133] (852s left) gem_exec_store (pages)
[161.789289] Starting subtest: pages
[161.789991] Starting dynamic subtest: rcs0
[161.836046] Dynamic subtest rcs0: SUCCESS (0.046s)
[161.843625] Starting dynamic subtest: bcs0
[161.905425] Dynamic subtest bcs0: SUCCESS (0.068s)
[161.919090] Starting dynamic subtest: vcs0
[161.961133] Dynamic subtest vcs0: SUCCESS (0.054s)
[161.968757] Starting dynamic subtest: vcs1
[162.005984] Dynamic subtest vcs1: SUCCESS (0.044s)
[162.014712] Starting dynamic subtest: vecs0
[162.075317] Dynamic subtest vecs0: SUCCESS (0.068s)
[162.076463] Subtest pages: SUCCESS (0.287s)
[162.269155] [053/133] (852s left) api_intel_allocator (default-alignment)
[162.302011] Starting subtest: default-alignment
[162.303932] Subtest default-alignment: SUCCESS (0.001s)
[162.410157] [054/133] (852s left) syncobj_wait (invalid-reset-illegal-handle)
[162.443748] Starting subtest: invalid-reset-illegal-handle
[162.444437] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[162.511152] [055/133] (852s left) kms_flip (2x-flip-vs-fences)
[162.598791] Starting subtest: 2x-flip-vs-fences
[162.607378] Subtest 2x-flip-vs-fences: SKIP (0.009s)
[162.673873] [056/133] (852s left) kms_psr (psr2-cursor-render)
[162.759859] Subtest psr2-cursor-render: SKIP (0.000s)
[162.802023] [057/133] (851s left) gen7_exec_parse (oacontrol-tracking)
[162.838066] Subtest oacontrol-tracking: SKIP (0.000s)
[162.884923] [058/133] (851s left) kms_chamelium_audio (dp-audio)
[163.024797] Subtest dp-audio: SKIP (0.000s)
[163.114255] [059/133] (851s left) gem_userptr_blits (dmabuf-unsync)
[163.156815] Subtest dmabuf-unsync: SKIP (0.000s)
[163.273776] [060/133] (851s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[163.358041] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[163.359386] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[163.413776] [061/133] (851s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[163.507954] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[163.509350] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[163.597352] [062/133] (851s left) perf_pmu (render-node-busy-idle)
[163.636360] Starting subtest: render-node-busy-idle
[163.637086] Starting dynamic subtest: rcs0
[164.284115] Dynamic subtest rcs0: SUCCESS (0.645s)
[164.292117] Starting dynamic subtest: bcs0
[164.914145] Dynamic subtest bcs0: SUCCESS (0.628s)
[164.923089] Starting dynamic subtest: vcs0
[165.545988] Dynamic subtest vcs0: SUCCESS (0.629s)
[165.555228] Starting dynamic subtest: vcs1
[166.176830] Dynamic subtest vcs1: SUCCESS (0.624s)
[166.187061] Starting dynamic subtest: vecs0
[166.803954] Dynamic subtest vecs0: SUCCESS (0.629s)
[166.804973] Subtest render-node-busy-idle: SUCCESS (3.167s)
[166.887431] [063/133] (848s left) gem_exec_schedule (reorder-wide)
[167.054376] Starting subtest: reorder-wide
[167.055319] Starting dynamic subtest: rcs0
[167.126129] Dynamic subtest rcs0: SUCCESS (0.071s)
[167.138405] Starting dynamic subtest: bcs0
[167.198640] Dynamic subtest bcs0: SUCCESS (0.070s)
[167.210275] Starting dynamic subtest: vcs0
[167.271411] Dynamic subtest vcs0: SUCCESS (0.070s)
[167.284117] Starting dynamic subtest: vcs1
[167.343288] Dynamic subtest vcs1: SUCCESS (0.070s)
[167.354905] Starting dynamic subtest: vecs0
[167.420274] Dynamic subtest vecs0: SUCCESS (0.075s)
[167.421678] Subtest reorder-wide: SUCCESS (0.367s)
[167.602055] [064/133] (847s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[167.689680] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.000s)
[167.736094] [065/133] (847s left) kms_dp_link_training (uhbr-sst)
[167.821953] Starting subtest: uhbr-sst
[167.823327] Subtest uhbr-sst: SKIP (0.000s)
[167.882875] [066/133] (847s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[167.978812] Starting subtest: y-tiled-16bpp-rotate-0
[169.097290] Subtest y-tiled-16bpp-rotate-0: SUCCESS (1.119s)
[169.242881] [067/133] (845s left) kms_legacy_colorkey (invalid-plane)
[169.331973] Starting subtest: invalid-plane
[169.332706] Starting dynamic subtest: zero-id
[169.333371] Dynamic subtest zero-id: SUCCESS (0.000s)
[169.340446] Starting dynamic subtest: outrange-id
[169.341126] Dynamic subtest outrange-id: SUCCESS (0.000s)
[169.341800] Subtest invalid-plane: SUCCESS (0.002s)
[169.389726] [068/133] (845s left) gem_softpin (full)
[169.426140] Starting subtest: full
[169.432508] Subtest full: SUCCESS (0.006s)
[169.554282] [069/133] (845s left) sysfs_preempt_timeout (idempotent)
[169.590566] Starting subtest: idempotent
[169.592441] Starting dynamic subtest: vecs0
[169.593184] Dynamic subtest vecs0: SUCCESS (0.001s)
[169.600392] Starting dynamic subtest: vcs0
[169.601132] Dynamic subtest vcs0: SUCCESS (0.001s)
[169.608014] Starting dynamic subtest: bcs0
[169.608715] Dynamic subtest bcs0: SUCCESS (0.001s)
[169.615488] Starting dynamic subtest: rcs0
[169.616173] Dynamic subtest rcs0: SUCCESS (0.001s)
[169.623114] Starting dynamic subtest: vcs1
[169.623854] Dynamic subtest vcs1: SUCCESS (0.001s)
[169.624520] Subtest idempotent: SUCCESS (0.009s)
[169.657921] [070/133] (845s left) gem_exec_schedule (fairslice)
[169.700935] Starting subtest: fairslice
[169.701666] Starting dynamic subtest: rcs0
[171.721509] Dynamic subtest rcs0: SUCCESS (2.011s)
[171.731241] Starting dynamic subtest: bcs0
[173.733650] Dynamic subtest bcs0: SUCCESS (2.011s)
[173.743529] Starting dynamic subtest: vcs0
[175.745682] Dynamic subtest vcs0: SUCCESS (2.010s)
[175.755559] Starting dynamic subtest: vcs1
[177.757859] Dynamic subtest vcs1: SUCCESS (2.011s)
[177.767650] Starting dynamic subtest: vecs0
[179.769766] Dynamic subtest vecs0: SUCCESS (2.011s)
[179.770684] Subtest fairslice: SUCCESS (10.060s)
[180.061295] [071/133] (835s left) kms_cursor_crc (cursor-sliding-256x256)
[180.151281] Starting subtest: cursor-sliding-256x256
[180.156902] Starting dynamic subtest: pipe-A-HDMI-A-1
[182.008572] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.851s)
[182.043487] Starting dynamic subtest: pipe-D-HDMI-A-1
[183.855968] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.819s)
[183.856758] Subtest cursor-sliding-256x256: SUCCESS (3.705s)
[183.988219] [072/133] (831s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[184.082816] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[184.084290] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[184.179961] [073/133] (831s left) kms_addfb_basic (addfb25-4-tiled)
[184.265979] Starting subtest: addfb25-4-tiled
[184.266695] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[184.354874] [074/133] (831s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[184.443550] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[184.444927] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[184.549666] [075/133] (830s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[184.635069] Starting subtest: primary-yf-tiled-reflect-x-0
[184.686144] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.050s)
[184.774367] [076/133] (830s left) syncobj_timeline (invalid-query-zero-handles)
[184.807638] Starting subtest: invalid-query-zero-handles
[184.808330] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[184.875017] [077/133] (830s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[184.960756] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[184.962966] Starting dynamic subtest: pipe-A-HDMI-A-1
[184.969948] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[184.979596] Starting dynamic subtest: pipe-B-HDMI-A-1
[184.986552] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[184.996129] Starting dynamic subtest: pipe-C-HDMI-A-1
[185.003017] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[185.012282] Starting dynamic subtest: pipe-D-HDMI-A-1
[185.026728] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[185.028061] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.011s)
[185.205305] [078/133] (830s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[185.248083] Starting subtest: basic-batch-kernel-default-cmd
[185.249453] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[185.432883] [079/133] (830s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[185.527750] Starting subtest: yf-tiled-32bpp-rotate-180
[185.529106] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[185.632517] [080/133] (830s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[185.720795] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[187.143746] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (1.423s)
[187.264094] [081/133] (828s left) sw_sync (alloc_fence_invalid_timeline)
[187.298110] Starting subtest: alloc_fence_invalid_timeline
[187.298875] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[187.344953] [082/133] (828s left) prime_vgem (coherency-gtt)
[187.390533] Starting subtest: coherency-gtt
[187.391928] Subtest coherency-gtt: SKIP (0.000s)
[187.489601] [083/133] (828s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[187.580807] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[187.582229] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[187.680775] [084/133] (828s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[187.766092] Starting subtest: disable-crc-after-crtc
[187.766804] Starting dynamic subtest: pipe-A-HDMI-A-1
[188.120966] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.354s)
[188.128985] Starting dynamic subtest: pipe-B-HDMI-A-1
[188.444444] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.322s)
[188.454325] Starting dynamic subtest: pipe-C-HDMI-A-1
[188.776413] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.330s)
[188.786272] Starting dynamic subtest: pipe-D-HDMI-A-1
[189.093674] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.315s)
[189.094393] Subtest disable-crc-after-crtc: SUCCESS (1.329s)
[189.234095] [085/133] (826s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[189.338236] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[189.935983] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (0.598s)
[190.049119] [086/133] (825s left) kms_setmode (clone-exclusive-crtc)
[190.083170] Starting subtest: clone-exclusive-crtc
[190.085303] Subtest clone-exclusive-crtc: SKIP (0.000s)
[190.138931] [087/133] (825s left) gem_mmap_offset (clear)
[190.172944] Starting subtest: clear
[190.175835] Starting dynamic subtest: smem0
[212.489712] Dynamic subtest smem0: SUCCESS (22.306s)
[212.490426] Subtest clear: SUCCESS (22.307s)
[212.608237] [088/133] (803s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[212.747226] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[212.748695] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[212.854516] [089/133] (803s left) gem_busy (close-race)
[212.898374] Starting subtest: close-race
[234.601157] Subtest close-race: SUCCESS (21.702s)
[234.963214] [090/133] (781s left) gem_ctx_shared (q-in-order)
[235.056305] Starting subtest: Q-in-order
[235.057053] Starting dynamic subtest: rcs0
[235.102181] Dynamic subtest rcs0: SUCCESS (0.045s)
[235.115635] Starting dynamic subtest: bcs0
[235.151397] Dynamic subtest bcs0: SUCCESS (0.047s)
[235.167170] Starting dynamic subtest: vcs0
[235.206088] Dynamic subtest vcs0: SUCCESS (0.052s)
[235.222120] Starting dynamic subtest: vcs1
[235.260697] Dynamic subtest vcs1: SUCCESS (0.051s)
[235.276453] Starting dynamic subtest: vecs0
[235.315482] Dynamic subtest vecs0: SUCCESS (0.052s)
[235.316490] Subtest Q-in-order: SUCCESS (0.260s)
[235.495964] [091/133] (780s left) perf_pmu (busy-accuracy-50)
[235.533746] Starting subtest: busy-accuracy-50
[235.534416] Starting dynamic subtest: rcs0
[237.058188] Dynamic subtest rcs0: SUCCESS (1.521s)
[237.067881] Starting dynamic subtest: bcs0
[238.583128] Dynamic subtest bcs0: SUCCESS (1.524s)
[238.592324] Starting dynamic subtest: vcs0
[240.106631] Dynamic subtest vcs0: SUCCESS (1.523s)
[240.116201] Starting dynamic subtest: vcs1
[241.631795] Dynamic subtest vcs1: SUCCESS (1.523s)
[241.642092] Starting dynamic subtest: vecs0
[243.155597] Dynamic subtest vecs0: SUCCESS (1.522s)
[243.156316] Subtest busy-accuracy-50: SUCCESS (7.619s)
[243.218990] [092/133] (772s left) kms_selftest (drm_format_helper)
[243.263422] Starting subtest: drm_format_helper
[243.268588] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[243.350605] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.081s)
[243.368673] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[243.420801] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.067s)
[243.439588] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[243.505712] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.080s)
[243.521154] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[243.587805] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.079s)
[243.604901] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[243.662959] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.073s)
[243.681637] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[243.739621] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.072s)
[243.755877] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[243.812943] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.072s)
[243.828891] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[243.883273] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.067s)
[243.898877] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[243.968090] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.082s)
[243.983278] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[244.048257] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.077s)
[244.063069] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[244.125964] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.076s)
[244.140920] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[244.192349] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.063s)
[244.207067] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[244.264436] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.072s)
[244.282653] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[244.336154] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.068s)
[244.353177] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[244.407398] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.069s)
[244.423940] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[244.488492] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.074s)
[244.502644] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[244.575670] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.086s)
[244.576531] Subtest drm_format_helper: SUCCESS (1.313s)
[244.719771] [093/133] (771s left) kms_color (invalid-ctm-matrix-sizes)
[244.813165] Starting subtest: invalid-ctm-matrix-sizes
[244.813856] Starting dynamic subtest: pipe-A
[244.816933] Dynamic subtest pipe-A: SUCCESS (0.004s)
[244.825947] Starting dynamic subtest: pipe-B
[244.826658] Dynamic subtest pipe-B: SUCCESS (0.005s)
[244.834389] Starting dynamic subtest: pipe-C
[244.835068] Dynamic subtest pipe-C: SUCCESS (0.007s)
[244.842814] Starting dynamic subtest: pipe-D
[244.843487] Dynamic subtest pipe-D: SUCCESS (0.007s)
[244.844153] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.027s)
[244.897200] [094/133] (771s left) api_intel_bb (simple-bb-ctx)
[244.931284] Starting subtest: simple-bb-ctx
[244.935654] Subtest simple-bb-ctx: SUCCESS (0.005s)
[245.043720] [095/133] (771s left) kms_addfb_basic (tile-pitch-mismatch)
[245.077914] Starting subtest: tile-pitch-mismatch
[245.078589] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[245.224262] [096/133] (771s left) kms_prop_blob (blob-prop-lifetime)
[245.257582] Starting subtest: blob-prop-lifetime
[245.258296] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[245.320611] [097/133] (771s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[245.411761] Starting subtest: fbcpsr-tiling-y
[245.413097] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[245.509320] [098/133] (770s left) kms_rotation_crc (sprite-rotation-180)
[245.597155] Starting subtest: sprite-rotation-180
[249.093889] Subtest sprite-rotation-180: SUCCESS (3.496s)
[249.271021] [099/133] (767s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[250.690282] Starting subtest: dpms-mode-unset-lpsp
[254.404201] Subtest dpms-mode-unset-lpsp: SUCCESS (3.716s)
[254.578861] [100/133] (761s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[254.673912] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[255.983292] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (1.310s)
[256.104151] [101/133] (760s left) i915_drm_fdinfo (context-close-stress)
[256.143860] Starting subtest: context-close-stress
[266.924210] Subtest context-close-stress: SUCCESS (10.746s)
[266.965823] [102/133] (749s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[267.058877] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[267.060277] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[267.154898] [103/133] (749s left) syncobj_timeline (single-wait-available-signaled)
[267.196628] Starting subtest: single-wait-available-signaled
[267.197401] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[267.263673] [104/133] (749s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[267.352767] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[267.354266] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[267.456640] [105/133] (749s left) gem_request_retire (retire-vma-not-inactive)
[267.494352] Starting subtest: retire-vma-not-inactive
[267.505036] Subtest retire-vma-not-inactive: SUCCESS (0.011s)
[267.617132] [106/133] (749s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[267.710792] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[267.712159] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[267.796106] [107/133] (748s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[267.887885] Starting subtest: fbcpsr-shrfb-scaledprimary
[267.889271] Subtest fbcpsr-shrfb-scaledprimary: SKIP (0.000s)
[267.979731] [108/133] (748s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[268.069012] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[268.071187] Starting dynamic subtest: pipe-A-HDMI-A-1
[268.074062] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[268.084710] Starting dynamic subtest: pipe-B-HDMI-A-1
[268.087535] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[268.095550] Starting dynamic subtest: pipe-C-HDMI-A-1
[268.098239] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[268.105968] Starting dynamic subtest: pipe-D-HDMI-A-1
[268.108700] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[268.110057] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SKIP (0.010s)
[268.309904] [109/133] (748s left) gem_exec_whisper (basic-queues-all)
[268.357918] Starting subtest: basic-queues-all
[269.617471] Subtest basic-queues-all: SUCCESS (1.258s)
[269.819506] [110/133] (747s left) i915_pm_rps (waitboost)
[269.858554] Starting subtest: waitboost
[273.393696] Subtest waitboost: SUCCESS (3.529s)
[273.516812] [111/133] (743s left) kms_cursor_crc (cursor-offscreen-max-size)
[273.610797] Starting subtest: cursor-offscreen-max-size
[273.612904] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[273.721358] [112/133] (743s left) syncobj_wait (invalid-signal-bad-pad)
[273.755586] Starting subtest: invalid-signal-bad-pad
[273.756293] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[273.819161] [113/133] (743s left) gem_pipe_control_store_loop (reused-buffer)
[273.856804] Starting subtest: reused-buffer
[276.015363] Subtest reused-buffer: SUCCESS (2.151s)
[276.115838] [114/133] (740s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[276.149872] Starting subtest: etime-multi-wait-available-unsubmitted
[276.255709] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.106s)
[276.329105] [115/133] (740s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[276.423843] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[276.425233] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[276.517805] [116/133] (740s left) kms_rotation_crc (primary-rotation-270)
[276.602982] Starting subtest: primary-rotation-270
[281.509847] Subtest primary-rotation-270: SUCCESS (4.906s)
[281.708936] [117/133] (735s left) prime_mmap (test_aperture_limit)
[281.746822] Starting subtest: test_aperture_limit
[281.747498] Starting dynamic subtest: test_aperture_limit-smem
[281.758136] Dynamic subtest test_aperture_limit-smem: SUCCESS (0.012s)
[281.758873] Subtest test_aperture_limit: SUCCESS (0.013s)
[281.851696] [118/133] (735s left) kms_hdr (static-toggle)
[281.940981] Starting subtest: static-toggle
[281.943078] Subtest static-toggle: SKIP (0.000s)
[282.000967] [119/133] (735s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[282.087703] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[282.130858] [120/133] (735s left) gem_workarounds (basic-read)
[282.177244] Starting subtest: basic-read
[282.184879] Subtest basic-read: SUCCESS (0.007s)
[282.289605] [121/133] (735s left) perf_pmu (interrupts-sync)
[282.326778] Starting subtest: interrupts-sync
[283.415641] Subtest interrupts-sync: SUCCESS (1.081s)
[283.500902] [122/133] (733s left) gem_partial_pwrite_pread (writes-after-reads-display)
[283.539192] Starting subtest: writes-after-reads-display
[296.059504] Subtest writes-after-reads-display: SUCCESS (12.520s)
[296.163100] [123/133] (721s left) kms_chamelium_color (degamma)
[296.253627] Subtest degamma: SKIP (0.000s)
[296.298357] [124/133] (721s left) kms_addfb_basic (invalid-get-prop)
[296.333369] Starting subtest: invalid-get-prop
[296.334136] Subtest invalid-get-prop: SUCCESS (0.000s)
[296.467710] [125/133] (721s left) kms_flip (2x-plain-flip-interruptible)
[296.559719] Starting subtest: 2x-plain-flip-interruptible
[296.568350] Subtest 2x-plain-flip-interruptible: SKIP (0.009s)
[296.628692] [126/133] (720s left) kms_chamelium_hpd (vga-hpd)
[296.769080] Subtest vga-hpd: SKIP (0.000s)
[296.863955] [127/133] (720s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[296.902599] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[296.903358] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[296.963125] [128/133] (720s left) kms_plane (pixel-format-yf-tiled-modifier)
[297.049554] Starting subtest: pixel-format-yf-tiled-modifier
[297.051020] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[297.112269] [129/133] (720s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[297.204215] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[297.205661] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[297.305812] [130/133] (720s left) syncobj_basic (bad-pad-handle-to-fd)
[297.339267] Starting subtest: bad-pad-handle-to-fd
[297.339953] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[297.398771] [131/133] (720s left) gem_pxp (reject-modify-context-protection-on)
[297.501092] Starting subtest: reject-modify-context-protection-on
[297.502244] Subtest reject-modify-context-protection-on: SUCCESS (0.001s)
[297.573927] [132/133] (720s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[297.660402] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (0.000s)
[297.701334] [133/133] (720s left) kms_busy (extended-modeset-hang-oldfb)
[297.790114] Starting subtest: extended-modeset-hang-oldfb
[297.791918] Starting dynamic subtest: pipe-A
[308.527569] Dynamic subtest pipe-A: SUCCESS (10.736s)
[308.539786] Starting dynamic subtest: pipe-D
[319.263440] Dynamic subtest pipe-D: SUCCESS (10.730s)
[319.264238] Subtest extended-modeset-hang-oldfb: SUCCESS (21.474s)
[319.394924] Closing watchdogs
results: parsing output: 0/ for test: kms_properties
results: parsing output: 1/ for test: kms_content_protection
results: parsing output: 2/ for test: kms_cursor_legacy
results: parsing output: 3/ for test: kms_pm_rpm
results: parsing output: 4/ for test: kms_vblank
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: kms_async_flips
results: parsing output: 9/ for test: kms_flip_scaled_crc
results: parsing output: 10/ for test: gem_ccs
results: parsing output: 11/ for test: sriov_basic
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: syncobj_wait
results: parsing output: 15/ for test: gem_mmap_gtt
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_ctx_persistence
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: gem_ctx_exec
results: parsing output: 22/ for test: i915_drm_fdinfo
results: parsing output: 23/ for test: kms_plane_scaling
results: parsing output: 24/ for test: gem_render_copy
results: parsing output: 25/ for test: syncobj_wait
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: gem_userptr_blits
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_exec_schedule
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: gem_lmem_swapping
results: parsing output: 32/ for test: gem_exec_reloc
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_render_copy
results: parsing output: 35/ for test: kms_ccs
results: parsing output: 36/ for test: kms_hdr
results: parsing output: 37/ for test: i915_pm_rpm
results: parsing output: 38/ for test: gem_exec_fence
results: parsing output: 39/ for test: gem_exec_reloc
results: parsing output: 40/ for test: kms_plane_lowres
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: gem_pwrite
results: parsing output: 43/ for test: kms_cursor_crc
results: parsing output: 44/ for test: kms_rotation_crc
results: parsing output: 45/ for test: dmabuf_sync_file
results: parsing output: 46/ for test: kms_plane_scaling
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: gem_exec_balancer
results: parsing output: 49/ for test: gem_exec_fence
results: parsing output: 50/ for test: gem_ctx_isolation
results: parsing output: 51/ for test: gem_exec_store
results: parsing output: 52/ for test: api_intel_allocator
results: parsing output: 53/ for test: syncobj_wait
results: parsing output: 54/ for test: kms_flip
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: gen7_exec_parse
results: parsing output: 57/ for test: kms_chamelium_audio
results: parsing output: 58/ for test: gem_userptr_blits
results: parsing output: 59/ for test: kms_flip_scaled_crc
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: perf_pmu
results: parsing output: 62/ for test: gem_exec_schedule
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: kms_dp_link_training
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: kms_legacy_colorkey
results: parsing output: 67/ for test: gem_softpin
results: parsing output: 68/ for test: sysfs_preempt_timeout
results: parsing output: 69/ for test: gem_exec_schedule
results: parsing output: 70/ for test: kms_cursor_crc
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_addfb_basic
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_rotation_crc
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: gem_exec_flush
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: sw_sync
results: parsing output: 81/ for test: prime_vgem
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_pipe_crc_basic
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: kms_setmode
results: parsing output: 86/ for test: gem_mmap_offset
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_busy
results: parsing output: 89/ for test: gem_ctx_shared
results: parsing output: 90/ for test: perf_pmu
results: parsing output: 91/ for test: kms_selftest
results: parsing output: 92/ for test: kms_color
results: parsing output: 93/ for test: api_intel_bb
results: parsing output: 94/ for test: kms_addfb_basic
results: parsing output: 95/ for test: kms_prop_blob
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_rotation_crc
results: parsing output: 98/ for test: kms_pm_rpm
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: i915_drm_fdinfo
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_request_retire
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: gem_exec_whisper
results: parsing output: 109/ for test: i915_pm_rps
results: parsing output: 110/ for test: kms_cursor_crc
results: parsing output: 111/ for test: syncobj_wait
results: parsing output: 112/ for test: gem_pipe_control_store_loop
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_rotation_crc
results: parsing output: 116/ for test: prime_mmap
results: parsing output: 117/ for test: kms_hdr
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: gem_workarounds
results: parsing output: 120/ for test: perf_pmu
results: parsing output: 121/ for test: gem_partial_pwrite_pread
results: parsing output: 122/ for test: kms_chamelium_color
results: parsing output: 123/ for test: kms_addfb_basic
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: kms_chamelium_hpd
results: parsing output: 126/ for test: syncobj_wait
results: parsing output: 127/ for test: kms_plane
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: syncobj_basic
results: parsing output: 130/ for test: gem_pxp
results: parsing output: 131/ for test: kms_psr2_sf
results: parsing output: 132/ for test: kms_busy
Done.