[63.621289] Initializing watchdogs
[63.621354]   /dev/watchdog0
[63.641080] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[63.651665] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[63.656333] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.658815] [001/133] (960s left) gem_create (busy-create)
[63.736052] Starting subtest: busy-create
[63.743962] Starting dynamic subtest: lmem0
[96.006253] Dynamic subtest lmem0: SUCCESS (32.287s)
[96.014241] Starting dynamic subtest: smem0
[128.261274] Dynamic subtest smem0: SUCCESS (32.255s)
[128.262172] Subtest busy-create: SUCCESS (64.542s)
[128.523371] [002/133] (895s left) kms_vrr (seamless-rr-switch-vrr)
[128.703223] Starting subtest: seamless-rr-switch-vrr
[128.705906] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[128.802908] [003/133] (895s left) kms_fb_coherency (memset-crc)
[128.981934] Starting subtest: memset-crc
[128.982875] Starting dynamic subtest: mmap-offset-fixed
[129.550670] Dynamic subtest mmap-offset-fixed: SUCCESS (0.568s)
[129.661431] Subtest memset-crc: SUCCESS (0.679s)
[129.922796] [004/133] (894s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[130.102071] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[130.102986] Starting dynamic subtest: pipe-A-valid-mode
[132.525720] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.421s)
[132.527401] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.423s)
[132.783481] [005/133] (891s left) gem_render_copy (yf-tiled-to-vebox-linear)
[132.860505] Starting subtest: yf-tiled-to-vebox-linear
[132.862677] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[133.117142] [006/133] (891s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[133.186167] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[133.287278] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.101s)
[133.465539] [007/133] (891s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[133.657034] Starting subtest: nonblocking-crc-frame-sequence
[133.659054] Starting dynamic subtest: pipe-A-DP-3
[134.397334] Dynamic subtest pipe-A-DP-3: SUCCESS (0.739s)
[134.408396] Starting dynamic subtest: pipe-B-DP-3
[135.002829] Dynamic subtest pipe-B-DP-3: SUCCESS (0.604s)
[135.018456] Starting dynamic subtest: pipe-C-DP-3
[135.651544] Dynamic subtest pipe-C-DP-3: SUCCESS (0.646s)
[135.665592] Starting dynamic subtest: pipe-D-DP-3
[136.302818] Dynamic subtest pipe-D-DP-3: SUCCESS (0.649s)
[136.303707] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.645s)
[136.576123] [008/133] (888s left) gem_exec_schedule (preempt-engines)
[136.671577] Starting subtest: preempt-engines
[136.672507] Starting dynamic subtest: rcs0
[138.902597] Dynamic subtest rcs0: SUCCESS (2.230s)
[138.915101] Starting dynamic subtest: bcs0
[141.073917] Dynamic subtest bcs0: SUCCESS (2.170s)
[141.085467] Starting dynamic subtest: vcs0
[143.346589] Dynamic subtest vcs0: SUCCESS (2.272s)
[143.357525] Starting dynamic subtest: vcs1
[145.622466] Dynamic subtest vcs1: SUCCESS (2.275s)
[145.633580] Starting dynamic subtest: vecs0
[147.900510] Dynamic subtest vecs0: SUCCESS (2.277s)
[147.911601] Starting dynamic subtest: vecs1
[150.179064] Dynamic subtest vecs1: SUCCESS (2.277s)
[150.190611] Starting dynamic subtest: ccs0
[152.389663] Dynamic subtest ccs0: SUCCESS (2.209s)
[152.391408] Subtest preempt-engines: SUCCESS (15.717s)
[152.739306] [009/133] (871s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[152.928586] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[154.145216] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.216s)
[154.304624] [010/133] (870s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[154.560380] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[154.614679] [011/133] (870s left) gem_wait (write-wait)
[154.704731] Starting subtest: write-wait
[154.705586] Starting dynamic subtest: all-engines
[155.872589] Dynamic subtest all-engines: SUCCESS (1.167s)
[155.884897] Starting dynamic subtest: rcs0
[156.933753] Dynamic subtest rcs0: SUCCESS (1.060s)
[156.946465] Starting dynamic subtest: bcs0
[157.990927] Dynamic subtest bcs0: SUCCESS (1.056s)
[158.004387] Starting dynamic subtest: vcs0
[159.050658] Dynamic subtest vcs0: SUCCESS (1.059s)
[159.064200] Starting dynamic subtest: vcs1
[160.110628] Dynamic subtest vcs1: SUCCESS (1.059s)
[160.123472] Starting dynamic subtest: vecs0
[161.170656] Dynamic subtest vecs0: SUCCESS (1.059s)
[161.182048] Starting dynamic subtest: vecs1
[162.229623] Dynamic subtest vecs1: SUCCESS (1.058s)
[162.242541] Starting dynamic subtest: ccs0
[163.289717] Dynamic subtest ccs0: SUCCESS (1.059s)
[163.291418] Subtest write-wait: SUCCESS (8.585s)
[163.590712] [FACT gem_wait (write-wait)] new: kernel.kmod_is_loaded.vgem: true
[163.592671] [012/133] (861s left) kms_plane_multiple (2x-tiling-4)
[163.780614] Starting subtest: 2x-tiling-4
[163.782393] Subtest 2x-tiling-4: SKIP (0.000s)
[163.884205] [013/133] (860s left) kms_chamelium_hpd (dp-hpd-fast)
[164.155591] Subtest dp-hpd-fast: SKIP (0.000s)
[164.306643] [014/133] (860s left) prime_self_import (export-vs-gem_close-race)
[164.354798] Starting subtest: export-vs-gem_close-race
[169.436344] Subtest export-vs-gem_close-race: SUCCESS (5.082s)
[169.557702] [015/133] (855s left) kms_joiner (invalid-modeset-force-big-joiner)
[169.792470] Starting subtest: invalid-modeset-force-big-joiner
[169.793191] Starting dynamic subtest: big_joiner_on_last_pipe
[170.003026] Dynamic subtest big_joiner_on_last_pipe: SUCCESS (0.212s)
[170.004053] Subtest invalid-modeset-force-big-joiner: SUCCESS (0.212s)
[170.203660] [016/133] (854s left) i915_selftest (perf)
[171.231036] Starting subtest: perf
[171.232129] Starting dynamic subtest: engine_cs
[172.829892] Dynamic subtest engine_cs: SUCCESS (1.599s)
[172.837537] Starting dynamic subtest: request
[177.496031] Dynamic subtest request: SUCCESS (4.666s)
[177.503489] Starting dynamic subtest: migrate
[179.171959] Dynamic subtest migrate: SUCCESS (1.676s)
[179.179685] Starting dynamic subtest: region
[207.590995] Dynamic subtest region: SUCCESS (28.418s)
[207.591925] Subtest perf: SUCCESS (36.360s)
[207.622089] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[207.623186] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[207.624701] [017/133] (817s left) kms_rotation_crc (bad-tiling)
[209.277957] Starting subtest: bad-tiling
[209.279776] Subtest bad-tiling: SKIP (0.001s)
[209.465724] [FACT kms_rotation_crc (bad-tiling)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[209.467994] [FACT kms_rotation_crc (bad-tiling)] new: kernel.kmod_is_loaded.i915: true
[209.470294] [018/133] (815s left) kms_pm_rpm (modeset-lpsp)
[211.079720] Starting subtest: modeset-lpsp
[211.465684] Subtest modeset-lpsp: SKIP (0.385s)
[211.844854] [019/133] (813s left) perf_pmu (init-busy)
[211.920837] Starting subtest: init-busy
[211.921688] Starting dynamic subtest: rcs0
[211.923440] Dynamic subtest rcs0: SUCCESS (0.002s)
[211.932043] Starting dynamic subtest: bcs0
[211.932940] Dynamic subtest bcs0: SUCCESS (0.001s)
[211.941272] Starting dynamic subtest: vcs0
[211.942179] Dynamic subtest vcs0: SUCCESS (0.001s)
[211.950982] Starting dynamic subtest: vcs1
[211.952137] Dynamic subtest vcs1: SUCCESS (0.001s)
[211.960495] Starting dynamic subtest: vecs0
[211.961585] Dynamic subtest vecs0: SUCCESS (0.000s)
[211.970056] Starting dynamic subtest: vecs1
[211.971185] Dynamic subtest vecs1: SUCCESS (0.001s)
[211.979500] Starting dynamic subtest: ccs0
[211.980410] Dynamic subtest ccs0: SUCCESS (0.000s)
[211.981246] Subtest init-busy: SUCCESS (0.008s)
[212.103608] [020/133] (813s left) kms_chamelium_frames (dp-frame-dump)
[212.376628] Subtest dp-frame-dump: SKIP (0.000s)
[212.524763] [021/133] (812s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[212.721603] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[212.780660] [022/133] (812s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[212.974503] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[212.976222] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[213.112794] [023/133] (812s left) api_intel_allocator (reopen-fork)
[213.191219] Starting subtest: reopen-fork
[216.499389] Subtest reopen-fork: SUCCESS (3.308s)
[216.620151] [024/133] (808s left) syncobj_timeline (wait-all-complex)
[216.701172] Starting subtest: wait-all-complex
[216.919142] Subtest wait-all-complex: SUCCESS (0.217s)
[217.026955] [025/133] (808s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[217.219125] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[217.220882] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[217.376707] [026/133] (808s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[217.560957] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[217.561911] Starting dynamic subtest: pipe-A-DP-3
[217.570274] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[217.579105] Starting dynamic subtest: pipe-B-DP-3
[217.587437] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[217.596104] Starting dynamic subtest: pipe-C-DP-3
[217.604258] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[217.612749] Starting dynamic subtest: pipe-D-DP-3
[217.622776] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[217.624907] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SKIP (0.004s)
[218.011176] [027/133] (807s left) vgem_slow (nohang)
[218.065365] Starting subtest: nohang
[228.441848] Subtest nohang: SUCCESS (10.376s)
[228.551665] [028/133] (797s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[228.740471] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[228.742188] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[228.932553] [029/133] (796s left) kms_psr (psr-no-drrs)
[229.118348] Subtest psr-no-drrs: SKIP (0.000s)
[229.174095] [030/133] (796s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[229.361566] Starting subtest: 2x-flip-vs-modeset-vs-hang
[229.376788] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.015s)
[229.488401] [031/133] (796s left) kms_rotation_crc (exhaust-fences)
[229.678274] Starting subtest: exhaust-fences
[229.680065] Subtest exhaust-fences: SKIP (0.000s)
[229.763203] [032/133] (796s left) gem_userptr_blits (access-control)
[229.859299] Starting subtest: access-control
[229.861168] Subtest access-control: SKIP (0.000s)
[230.027695] [033/133] (796s left) kms_content_protection (lic-type-0)
[230.284885] Starting subtest: lic-type-0
[230.314933] Starting dynamic subtest: pipe-A-DP-3
[351.396661] Dynamic subtest pipe-A-DP-3: FAIL (120.908s)
[351.397537] Subtest lic-type-0: FAIL (121.028s)
[351.572168] [034/133] (674s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[351.771418] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[351.773233] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[351.920125] [035/133] (674s left) prime_self_import (basic-with_two_bos)
[351.966936] Starting subtest: basic-with_two_bos
[352.013585] Subtest basic-with_two_bos: SUCCESS (0.047s)
[352.127051] [036/133] (674s left) gem_ctx_isolation (clean)
[352.221770] Starting subtest: clean
[352.222640] Starting dynamic subtest: rcs0
[352.324543] Dynamic subtest rcs0: SUCCESS (0.103s)
[352.334538] Starting dynamic subtest: bcs0
[352.444639] Dynamic subtest bcs0: SUCCESS (0.120s)
[352.454350] Starting dynamic subtest: vcs0
[352.552467] Dynamic subtest vcs0: SUCCESS (0.107s)
[352.561528] Starting dynamic subtest: vcs1
[352.664885] Dynamic subtest vcs1: SUCCESS (0.112s)
[352.674010] Starting dynamic subtest: vecs0
[352.772921] Dynamic subtest vecs0: SUCCESS (0.108s)
[352.782207] Starting dynamic subtest: vecs1
[352.875097] Dynamic subtest vecs1: SUCCESS (0.102s)
[352.888127] Starting dynamic subtest: ccs0
[352.985132] Dynamic subtest ccs0: SUCCESS (0.110s)
[352.986059] Subtest clean: SUCCESS (0.764s)
[353.279855] [037/133] (673s left) gem_exec_whisper (basic-sync-all)
[353.369171] Starting subtest: basic-sync-all
[358.362110] Subtest basic-sync-all: SUCCESS (4.992s)
[358.649192] [038/133] (667s left) gem_mmap_offset (partial-mmap)
[358.732151] Starting subtest: partial-mmap
[358.733059] Starting dynamic subtest: lmem0
[358.735905] Dynamic subtest lmem0: SUCCESS (0.005s)
[358.745558] Starting dynamic subtest: smem0
[358.746667] Dynamic subtest smem0: SUCCESS (0.004s)
[358.747697] Subtest partial-mmap: SUCCESS (0.010s)
[358.895638] [039/133] (667s left) gem_exec_params (cliprects-invalid)
[358.974994] Starting subtest: cliprects-invalid
[358.976249] Subtest cliprects-invalid: SUCCESS (0.000s)
[359.117332] [040/133] (667s left) kms_pm_lpsp (kms-lpsp)
[360.307811] Starting subtest: kms-lpsp
[360.309474] Subtest kms-lpsp: SKIP (0.000s)
[360.442808] [041/133] (666s left) gem_workarounds (suspend-resume-fd)
[360.537164] Starting subtest: suspend-resume-fd
[379.718527] Subtest suspend-resume-fd: SUCCESS (3.834s)
[379.842860] [042/133] (646s left) kms_chamelium_color (ctm-green-to-red)
[380.033509] Subtest ctm-green-to-red: SKIP (0.000s)
[380.089294] [043/133] (646s left) kms_cursor_crc (cursor-random-64x64)
[380.419227] Starting subtest: cursor-random-64x64
[380.423344] Starting dynamic subtest: pipe-A-DP-3
[384.959752] Dynamic subtest pipe-A-DP-3: SUCCESS (4.535s)
[385.011021] Starting dynamic subtest: pipe-D-DP-3
[389.505136] Dynamic subtest pipe-D-DP-3: SUCCESS (4.505s)
[389.506151] Subtest cursor-random-64x64: SUCCESS (9.086s)
[389.999193] [044/133] (636s left) kms_flip (flip-vs-blocking-wf-vblank)
[390.185815] Starting subtest: flip-vs-blocking-wf-vblank
[390.190020] Starting dynamic subtest: A-DP3
[398.308964] Dynamic subtest A-DP3: SUCCESS (8.119s)
[398.322058] Starting dynamic subtest: B-DP3
[406.360682] Dynamic subtest B-DP3: SUCCESS (8.051s)
[406.372852] Starting dynamic subtest: C-DP3
[414.579888] Dynamic subtest C-DP3: SUCCESS (8.219s)
[414.592408] Starting dynamic subtest: D-DP3
[422.802506] Dynamic subtest D-DP3: SUCCESS (8.223s)
[422.804497] Subtest flip-vs-blocking-wf-vblank: SUCCESS (32.620s)
[423.115750] [045/133] (603s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[423.306195] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[423.359075] [046/133] (603s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[423.551650] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[423.553300] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[423.693248] [047/133] (603s left) kms_lease (atomic-implicit-crtc)
[423.881917] Starting subtest: atomic-implicit-crtc
[423.882841] Starting dynamic subtest: pipe-A-DP-3
[423.887159] Dynamic subtest pipe-A-DP-3: SUCCESS (0.002s)
[423.898417] Starting dynamic subtest: pipe-B-DP-3
[423.902804] Dynamic subtest pipe-B-DP-3: SUCCESS (0.011s)
[423.914050] Starting dynamic subtest: pipe-C-DP-3
[423.918239] Dynamic subtest pipe-C-DP-3: SUCCESS (0.010s)
[423.929688] Starting dynamic subtest: pipe-D-DP-3
[423.934711] Dynamic subtest pipe-D-DP-3: SUCCESS (0.010s)
[423.935845] Subtest atomic-implicit-crtc: SUCCESS (0.039s)
[424.088631] [048/133] (603s left) syncobj_basic (bad-pad-handle-to-fd)
[424.166008] Starting subtest: bad-pad-handle-to-fd
[424.166901] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[424.270465] [049/133] (602s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[424.350402] Starting subtest: etime-multi-wait-all-available-unsubmitted
[424.457439] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.106s)
[424.581619] [050/133] (602s left) i915_drm_fdinfo (virtual-idle)
[424.652331] Starting subtest: virtual-idle
[428.246020] Subtest virtual-idle: SUCCESS (3.593s)
[428.360123] [051/133] (599s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[428.562023] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[428.563783] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[428.707065] [052/133] (598s left) kms_cursor_edge_walk (256x256-top-bottom)
[428.897949] Starting subtest: 256x256-top-bottom
[428.898865] Starting dynamic subtest: pipe-A-DP-3
[432.347505] Dynamic subtest pipe-A-DP-3: SUCCESS (3.449s)
[432.361704] Starting dynamic subtest: pipe-D-DP-3
[435.676797] Dynamic subtest pipe-D-DP-3: SUCCESS (3.328s)
[435.677873] Subtest 256x256-top-bottom: SUCCESS (6.781s)
[435.939605] [053/133] (591s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[436.127487] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[436.129501] Starting dynamic subtest: pipe-A-DP-3
[436.150929] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[436.162109] Starting dynamic subtest: pipe-B-DP-3
[436.183682] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[436.194872] Starting dynamic subtest: pipe-C-DP-3
[436.220414] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[436.231179] Starting dynamic subtest: pipe-D-DP-3
[436.254698] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[436.256881] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SKIP (0.013s)
[436.562993] [054/133] (591s left) dmabuf_sync_file (export-multiwait)
[436.630804] Starting subtest: export-multiwait
[436.631792] Subtest export-multiwait: SUCCESS (0.000s)
[436.723356] [055/133] (590s left) gem_exec_params (invalid-ring2)
[436.810111] Starting subtest: invalid-ring2
[436.811305] Subtest invalid-ring2: SUCCESS (0.000s)
[436.935193] [056/133] (590s left) gem_mmap_gtt (basic-write-read-distinct)
[437.012950] Subtest basic-write-read-distinct: SKIP (0.000s)
[437.093905] [057/133] (590s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[437.285843] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[440.031012] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (2.746s)
[440.237002] [058/133] (587s left) gem_ccs (block-copy-uncompressed)
[440.324112] Starting subtest: block-copy-uncompressed
[440.325037] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[440.368818] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.044s)
[440.380269] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-lmem0
[440.384346] Dynamic subtest linear-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.015s)
[440.395445] Starting dynamic subtest: linear-uncompressed-compfmt0-lmem0-smem
[440.486261] Dynamic subtest linear-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.101s)
[440.497653] Starting dynamic subtest: linear-uncompressed-compfmt0-lmem0-lmem0
[440.586454] Dynamic subtest linear-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.099s)
[440.599232] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[440.602989] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.015s)
[440.614562] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-lmem0
[440.618289] Dynamic subtest xmajor-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.015s)
[440.629718] Starting dynamic subtest: xmajor-uncompressed-compfmt0-lmem0-smem
[440.723017] Dynamic subtest xmajor-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.104s)
[440.734273] Starting dynamic subtest: xmajor-uncompressed-compfmt0-lmem0-lmem0
[440.821625] Dynamic subtest xmajor-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.098s)
[440.833106] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[440.838154] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[440.849483] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-lmem0
[440.853360] Dynamic subtest tile4-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.014s)
[440.864919] Starting dynamic subtest: tile4-uncompressed-compfmt0-lmem0-smem
[440.963111] Dynamic subtest tile4-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.109s)
[440.974472] Starting dynamic subtest: tile4-uncompressed-compfmt0-lmem0-lmem0
[441.063953] Dynamic subtest tile4-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.100s)
[441.075412] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[441.080359] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.015s)
[441.091754] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-lmem0
[441.095703] Dynamic subtest tile64-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.015s)
[441.107178] Starting dynamic subtest: tile64-uncompressed-compfmt0-lmem0-smem
[441.199268] Dynamic subtest tile64-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.103s)
[441.210878] Starting dynamic subtest: tile64-uncompressed-compfmt0-lmem0-lmem0
[441.303163] Dynamic subtest tile64-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.103s)
[441.304215] Subtest block-copy-uncompressed: SUCCESS (0.980s)
[441.465257] [059/133] (586s left) gem_exec_params (dr1-dirt)
[441.554686] Starting subtest: DR1-dirt
[441.555698] Subtest DR1-dirt: SUCCESS (0.000s)
[441.740184] [060/133] (586s left) gem_eio (create)
[442.077359] Starting subtest: create
[442.615200] Subtest create: SUCCESS (0.538s)
[442.913116] [061/133] (585s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[443.101479] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[443.103527] Starting dynamic subtest: pipe-A-DP-3
[443.106952] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[443.118791] Starting dynamic subtest: pipe-B-DP-3
[443.122171] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[443.133772] Starting dynamic subtest: pipe-C-DP-3
[443.137170] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[443.148630] Starting dynamic subtest: pipe-D-DP-3
[443.152032] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[443.153730] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[443.580637] [062/133] (584s left) i915_drm_fdinfo (busy-idle-check-all)
[443.652255] Starting subtest: busy-idle-check-all
[443.653176] Starting dynamic subtest: rcs0
[443.680949] Dynamic subtest rcs0: SKIP (0.030s)
[443.693053] Starting dynamic subtest: bcs0
[443.694930] Dynamic subtest bcs0: SKIP (0.000s)
[443.706740] Starting dynamic subtest: vcs0
[443.709027] Dynamic subtest vcs0: SKIP (0.000s)
[443.720620] Starting dynamic subtest: vcs1
[443.722901] Dynamic subtest vcs1: SKIP (0.000s)
[443.734755] Starting dynamic subtest: vecs0
[443.736663] Dynamic subtest vecs0: SKIP (0.000s)
[443.748357] Starting dynamic subtest: vecs1
[443.750699] Dynamic subtest vecs1: SKIP (0.000s)
[443.764622] Starting dynamic subtest: ccs0
[443.766323] Dynamic subtest ccs0: SKIP (0.000s)
[443.768405] Subtest busy-idle-check-all: SKIP (0.037s)
[443.815288] [063/133] (584s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[444.040851] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[444.042584] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[444.195572] [064/133] (584s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[444.386821] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[444.388452] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[444.577142] [065/133] (583s left) gem_exec_balancer (individual)
[444.668363] Starting subtest: individual
[446.761504] Subtest individual: SUCCESS (2.093s)
[447.196534] [066/133] (581s left) gem_userptr_blits (dmabuf-sync)
[447.294253] Starting subtest: dmabuf-sync
[447.313145] Subtest dmabuf-sync: SKIP (0.018s)
[447.517198] [067/133] (581s left) vgem_basic (bad-fence)
[447.579151] Starting subtest: bad-fence
[447.580074] Subtest bad-fence: SUCCESS (0.000s)
[447.663834] [068/133] (580s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[447.849857] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[447.851949] Starting dynamic subtest: pipe-A-valid-mode
[449.702036] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.849s)
[449.703747] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (1.852s)
[449.984726] [069/133] (578s left) i915_pm_rpm (sysfs-read)
[452.405552] Starting subtest: sysfs-read
[452.813887] Subtest sysfs-read: SUCCESS (0.404s)
[453.099743] [070/133] (575s left) gem_mmap_gtt (big-bo)
[453.185132] Subtest big-bo: SKIP (0.000s)
[453.268679] [071/133] (575s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[453.469067] Starting subtest: 4-tiled-64bpp-rotate-270
[453.518958] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.049s)
[453.757119] [072/133] (575s left) gen9_exec_parse (batch-invalid-length)
[453.843717] Subtest batch-invalid-length: SKIP (0.000s)
[453.913864] [073/133] (575s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[454.109089] Starting subtest: x-tiled-32bpp-rotate-180
[455.952817] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.843s)
[456.146573] [074/133] (572s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[456.336240] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[456.399512] [075/133] (572s left) kms_cursor_crc (cursor-offscreen-32x32)
[456.688339] Starting subtest: cursor-offscreen-32x32
[456.737148] Subtest cursor-offscreen-32x32: SKIP (0.047s)
[457.173518] [076/133] (572s left) syncobj_timeline (invalid-signal-illegal-handle)
[457.253170] Starting subtest: invalid-signal-illegal-handle
[457.254326] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[457.402200] [077/133] (571s left) kms_flip (2x-nonexisting-fb)
[457.588948] Starting subtest: 2x-nonexisting-fb
[457.604382] Subtest 2x-nonexisting-fb: SKIP (0.015s)
[457.707706] [078/133] (571s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[457.899743] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[457.901368] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[458.016864] [079/133] (571s left) gem_mmap_gtt (big-bo-tiledy)
[458.093951] Subtest big-bo-tiledY: SKIP (0.000s)
[458.163159] [080/133] (571s left) gem_exec_schedule (u-submit-late-slice)
[458.258919] Starting subtest: u-submit-late-slice
[458.259839] Starting dynamic subtest: rcs0
[458.339829] Dynamic subtest rcs0: SUCCESS (0.080s)
[458.352667] Starting dynamic subtest: bcs0
[458.389430] Dynamic subtest bcs0: SUCCESS (0.049s)
[458.402203] Starting dynamic subtest: vcs0
[458.441792] Dynamic subtest vcs0: SUCCESS (0.051s)
[458.454677] Starting dynamic subtest: vcs1
[458.490059] Dynamic subtest vcs1: SUCCESS (0.047s)
[458.502938] Starting dynamic subtest: vecs0
[458.542198] Dynamic subtest vecs0: SUCCESS (0.051s)
[458.555115] Starting dynamic subtest: vecs1
[458.591035] Dynamic subtest vecs1: SUCCESS (0.048s)
[458.604073] Starting dynamic subtest: ccs0
[458.644995] Dynamic subtest ccs0: SUCCESS (0.053s)
[458.646042] Subtest u-submit-late-slice: SUCCESS (0.387s)
[459.072701] [081/133] (570s left) gem_close_race (basic-process)
[459.186479] Starting subtest: basic-process
[459.263644] Subtest basic-process: SUCCESS (0.077s)
[459.556185] [082/133] (570s left) kms_atomic (test-only)
[459.744091] Starting subtest: test-only
[460.187203] Starting dynamic subtest: pipe-A-DP-3
[461.075249] Dynamic subtest pipe-A-DP-3: SUCCESS (0.889s)
[461.076213] Subtest test-only: SUCCESS (1.332s)
[461.343888] [083/133] (568s left) gem_exec_reloc (basic-gtt-read-active)
[461.430686] Subtest basic-gtt-read-active: SKIP (0.000s)
[461.507632] [084/133] (568s left) gem_exec_fence (basic-await)
[461.715318] Starting subtest: basic-await
[461.716314] Starting dynamic subtest: rcs0
[461.831415] Dynamic subtest rcs0: SUCCESS (0.117s)
[461.846074] Starting dynamic subtest: bcs0
[461.919955] Dynamic subtest bcs0: SUCCESS (0.087s)
[461.936478] Starting dynamic subtest: vcs0
[462.012130] Dynamic subtest vcs0: SUCCESS (0.091s)
[462.029062] Starting dynamic subtest: vcs1
[462.105810] Dynamic subtest vcs1: SUCCESS (0.093s)
[462.122269] Starting dynamic subtest: vecs0
[462.195788] Dynamic subtest vecs0: SUCCESS (0.089s)
[462.212907] Starting dynamic subtest: vecs1
[462.288115] Dynamic subtest vecs1: SUCCESS (0.091s)
[462.304852] Starting dynamic subtest: ccs0
[462.380644] Dynamic subtest ccs0: SUCCESS (0.091s)
[462.381699] Subtest basic-await: SUCCESS (0.667s)
[463.149634] [085/133] (566s left) kms_psr (fbc-pr-cursor-render)
[463.336304] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[463.407738] [086/133] (566s left) syncobj_wait (single-wait-all-for-submit-submitted)
[463.489385] Starting subtest: single-wait-all-for-submit-submitted
[463.593198] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.103s)
[463.781237] [087/133] (566s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[463.971864] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[463.973477] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[464.129869] [088/133] (565s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[464.325362] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[465.111265] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.785s)
[465.379761] [089/133] (564s left) gem_spin_batch (user-each)
[465.470295] Starting subtest: user-each
[468.898153] Subtest user-each: SUCCESS (3.427s)
[469.213636] [090/133] (560s left) gem_exec_flush (basic-wb-set-default)
[469.298305] Subtest basic-wb-set-default: SKIP (0.000s)
[469.419173] [091/133] (560s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[469.608041] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[469.609730] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[469.764255] [092/133] (560s left) perf (i915-ref-count)
[469.861368] Starting subtest: i915-ref-count
[470.145190] Subtest i915-ref-count: SUCCESS (0.283s)
[470.337746] [093/133] (560s left) gem_pwrite (basic-self)
[470.418056] Subtest basic-self: SKIP (0.000s)
[470.541147] [094/133] (559s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[470.636883] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[470.639289] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[470.843655] [095/133] (559s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[470.923386] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[470.924485] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[471.130420] [096/133] (559s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[471.316256] Starting subtest: bad-aux-stride-y-tiled-ccs
[471.317154] Starting dynamic subtest: pipe-A-DP-3
[471.325551] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[471.338524] Starting dynamic subtest: pipe-B-DP-3
[471.346933] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[471.359811] Starting dynamic subtest: pipe-C-DP-3
[471.368031] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[471.381118] Starting dynamic subtest: pipe-D-DP-3
[471.392431] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[471.394107] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.007s)
[471.719044] [097/133] (559s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[471.796355] Starting subtest: multi-wait-all-for-submit-signaled
[471.797462] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[471.929962] [098/133] (558s left) kms_psr (psr2-sprite-mmap-cpu)
[472.119413] Subtest psr2-sprite-mmap-cpu: SKIP (0.000s)
[472.185109] [099/133] (558s left) kms_vblank (ts-continuation-dpms-rpm)
[472.378282] Starting subtest: ts-continuation-dpms-rpm
[472.379194] Starting dynamic subtest: pipe-A-DP-3
[474.304192] Dynamic subtest pipe-A-DP-3: SUCCESS (1.925s)
[474.335160] Starting dynamic subtest: pipe-D-DP-3
[475.153335] Dynamic subtest pipe-D-DP-3: SUCCESS (0.841s)
[475.154326] Subtest ts-continuation-dpms-rpm: SUCCESS (2.775s)
[475.385641] [100/133] (555s left) gem_userptr_blits (coherency-unsync)
[475.470855] Subtest coherency-unsync: SKIP (0.000s)
[475.640714] [101/133] (555s left) kms_color (invalid-ctm-matrix-sizes)
[475.827490] Starting subtest: invalid-ctm-matrix-sizes
[475.828374] Starting dynamic subtest: pipe-A
[475.830933] Dynamic subtest pipe-A: SUCCESS (0.003s)
[475.844027] Starting dynamic subtest: pipe-B
[475.844971] Dynamic subtest pipe-B: SUCCESS (0.005s)
[475.858038] Starting dynamic subtest: pipe-C
[475.859260] Dynamic subtest pipe-C: SUCCESS (0.006s)
[475.872277] Starting dynamic subtest: pipe-D
[475.873377] Dynamic subtest pipe-D: SUCCESS (0.007s)
[475.874489] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.025s)
[475.952212] [102/133] (555s left) gem_exec_fence (syncobj-signal)
[476.507789] Starting subtest: syncobj-signal
[476.539431] Subtest syncobj-signal: SUCCESS (0.032s)
[476.973209] [103/133] (554s left) gem_exec_reloc (basic-cpu-gtt)
[477.055959] Subtest basic-cpu-gtt: SKIP (0.000s)
[477.152579] [104/133] (554s left) api_intel_bb (object-reloc-keep-cache)
[477.230381] Starting subtest: object-reloc-keep-cache
[477.233627] Subtest object-reloc-keep-cache: SKIP (0.002s)
[477.414689] [105/133] (553s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[477.610337] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[477.626189] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.015s)
[477.722828] [106/133] (553s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[477.917889] Starting subtest: y-tiled-16bpp-rotate-90
[477.919845] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[478.058235] [107/133] (553s left) gem_exec_fence (syncobj-wait)
[478.553321] Starting subtest: syncobj-wait
[478.641046] Subtest syncobj-wait: SUCCESS (0.088s)
[479.058964] [108/133] (552s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[479.243554] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[479.244425] Starting dynamic subtest: pipe-A
[479.333499] Dynamic subtest pipe-A: SUCCESS (0.089s)
[479.357189] Starting dynamic subtest: pipe-B
[479.568189] Dynamic subtest pipe-B: SUCCESS (0.233s)
[479.585073] Starting dynamic subtest: pipe-C
[479.764801] Dynamic subtest pipe-C: SUCCESS (0.195s)
[479.788073] Starting dynamic subtest: pipe-D
[479.994294] Dynamic subtest pipe-D: SUCCESS (0.228s)
[479.995269] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (0.751s)
[480.310520] [109/133] (551s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[480.502191] Starting subtest: modeset-atomic-cursor-hotspot
[480.503967] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[480.592511] [110/133] (551s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[480.787784] Starting subtest: fbcpsr-tiling-4
[480.789359] Subtest fbcpsr-tiling-4: SKIP (0.000s)
[480.911161] [111/133] (550s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[480.988091] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[481.053417] [112/133] (550s left) perf_pmu (all-busy-idle-check-all)
[481.126268] Starting subtest: all-busy-idle-check-all
[481.826319] Subtest all-busy-idle-check-all: SUCCESS (0.700s)
[481.999241] [113/133] (549s left) gem_basic (bad-close)
[482.075671] Starting subtest: bad-close
[482.077321] Subtest bad-close: SUCCESS (0.000s)
[482.244239] [114/133] (549s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[482.432673] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.000s)
[482.504831] [115/133] (549s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[482.589359] Starting subtest: etime-single-wait-for-submit-unsubmitted
[482.697464] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[482.875540] [116/133] (549s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[483.068833] Starting subtest: psr-farfromfence-mmap-gtt
[483.070469] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[483.225541] [117/133] (548s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[483.319656] Starting subtest: map-fixed-invalidate-overlap-busy
[483.321369] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[483.547949] [118/133] (548s left) kms_plane (pixel-format-x-tiled-modifier)
[483.733521] Starting subtest: pixel-format-x-tiled-modifier
[483.757142] Starting dynamic subtest: pipe-A-plane-0
[484.823744] Dynamic subtest pipe-A-plane-0: SUCCESS (1.066s)
[484.842448] Starting dynamic subtest: pipe-A-plane-3
[485.440456] Dynamic subtest pipe-A-plane-3: SUCCESS (0.615s)
[485.479088] Starting dynamic subtest: pipe-A-plane-5
[485.481190] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[485.696930] Starting dynamic subtest: pipe-B-plane-0
[486.602965] Dynamic subtest pipe-B-plane-0: SUCCESS (0.932s)
[486.641890] Starting dynamic subtest: pipe-B-plane-3
[487.286264] Dynamic subtest pipe-B-plane-3: SUCCESS (0.681s)
[487.300990] Starting dynamic subtest: pipe-B-plane-5
[487.302780] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[487.376791] Subtest pixel-format-x-tiled-modifier: SUCCESS (3.642s)
[487.642826] [119/133] (544s left) gem_exec_params (rsvd2-dirt)
[487.724974] Starting subtest: rsvd2-dirt
[487.726785] Subtest rsvd2-dirt: SKIP (0.000s)
[487.910777] [120/133] (544s left) gem_exec_schedule (thriceslice)
[488.000266] Starting subtest: thriceslice
[488.001166] Starting dynamic subtest: rcs0
[488.033273] Dynamic subtest rcs0: SUCCESS (0.032s)
[488.048220] Starting dynamic subtest: bcs0
[488.063591] Dynamic subtest bcs0: SUCCESS (0.029s)
[488.082243] Starting dynamic subtest: vcs0
[488.120296] Dynamic subtest vcs0: SUCCESS (0.055s)
[488.149536] Starting dynamic subtest: vcs1
[488.185157] Dynamic subtest vcs1: SUCCESS (0.063s)
[488.205101] Starting dynamic subtest: vecs0
[488.244774] Dynamic subtest vecs0: SUCCESS (0.057s)
[488.265307] Starting dynamic subtest: vecs1
[488.304714] Dynamic subtest vecs1: SUCCESS (0.058s)
[488.329462] Starting dynamic subtest: ccs0
[488.367994] Dynamic subtest ccs0: SUCCESS (0.061s)
[488.369013] Subtest thriceslice: SUCCESS (0.368s)
[488.806555] [121/133] (543s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[488.998844] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[489.000558] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[489.153393] [122/133] (543s left) prime_vgem (busy)
[489.258320] Starting subtest: busy
[489.259256] Starting dynamic subtest: rcs0
[489.325047] Dynamic subtest rcs0: SUCCESS (0.066s)
[489.340416] Starting dynamic subtest: bcs0
[489.379824] Dynamic subtest bcs0: SUCCESS (0.053s)
[489.397443] Starting dynamic subtest: vcs0
[489.421954] Dynamic subtest vcs0: SUCCESS (0.041s)
[489.442713] Starting dynamic subtest: vcs1
[489.463553] Dynamic subtest vcs1: SUCCESS (0.040s)
[489.484462] Starting dynamic subtest: vecs0
[489.506807] Dynamic subtest vecs0: SUCCESS (0.042s)
[489.527460] Starting dynamic subtest: vecs1
[489.549557] Dynamic subtest vecs1: SUCCESS (0.041s)
[489.570469] Starting dynamic subtest: ccs0
[489.590544] Dynamic subtest ccs0: SUCCESS (0.039s)
[489.591492] Subtest busy: SUCCESS (0.333s)
[489.773505] [123/133] (542s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[489.958418] Starting subtest: addfb25-yf-tiled-legacy
[489.959320] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[490.089803] [124/133] (542s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[490.283042] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[490.284747] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[490.455100] [125/133] (542s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[490.650098] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[490.651883] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[490.805907] [126/133] (542s left) gem_mmap_gtt (medium-copy-xy)
[490.884090] Subtest medium-copy-XY: SKIP (0.000s)
[490.973008] [127/133] (541s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[491.165777] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[491.167402] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[491.325427] [128/133] (541s left) kms_psr (pr-sprite-plane-move)
[491.516235] Subtest pr-sprite-plane-move: SKIP (0.000s)
[491.584221] [129/133] (541s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[491.782457] Starting subtest: yf-tiled-8bpp-rotate-90
[491.784194] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[491.990433] [130/133] (541s left) gem_mmap_gtt (close-race)
[492.074075] Subtest close-race: SKIP (0.000s)
[492.152353] [131/133] (541s left) kms_flip (dpms-off-confusion-interruptible)
[492.345274] Starting subtest: dpms-off-confusion-interruptible
[492.350260] Starting dynamic subtest: A-DP3
[500.178888] Dynamic subtest A-DP3: SUCCESS (7.828s)
[500.201699] Starting dynamic subtest: B-DP3
[507.948272] Dynamic subtest B-DP3: SUCCESS (7.766s)
[507.965356] Starting dynamic subtest: C-DP3
[515.687828] Dynamic subtest C-DP3: SUCCESS (7.735s)
[515.704089] Starting dynamic subtest: D-DP3
[523.435810] Dynamic subtest D-DP3: SUCCESS (7.745s)
[523.441182] Subtest dpms-off-confusion-interruptible: SUCCESS (31.094s)
[523.751713] [132/133] (509s left) gem_ctx_persistence (legacy-engines-hostile)
[523.837812] Starting subtest: legacy-engines-hostile
[523.838848] Starting dynamic subtest: render
[523.928117] Dynamic subtest render: SUCCESS (0.089s)
[523.944383] Starting dynamic subtest: bsd1
[524.019027] Dynamic subtest bsd1: SUCCESS (0.089s)
[524.055390] Starting dynamic subtest: bsd2
[524.079215] Dynamic subtest bsd2: SUCCESS (0.055s)
[524.094126] Starting dynamic subtest: blt
[524.175125] Dynamic subtest blt: SUCCESS (0.094s)
[524.224330] Starting dynamic subtest: vebox
[524.237149] Dynamic subtest vebox: SUCCESS (0.057s)
[524.238164] Subtest legacy-engines-hostile: SUCCESS (0.400s)
[524.453480] [133/133] (508s left) kms_plane (plane-position-covered)
[524.641279] Starting subtest: plane-position-covered
[525.090068] Starting dynamic subtest: pipe-A-plane-1
[525.559597] Dynamic subtest pipe-A-plane-1: SUCCESS (0.471s)
[525.575712] Starting dynamic subtest: pipe-A-plane-2
[526.018453] Dynamic subtest pipe-A-plane-2: SUCCESS (0.457s)
[526.033449] Starting dynamic subtest: pipe-A-plane-3
[526.478344] Dynamic subtest pipe-A-plane-3: SUCCESS (0.459s)
[526.495056] Starting dynamic subtest: pipe-A-plane-4
[526.939915] Dynamic subtest pipe-A-plane-4: SUCCESS (0.460s)
[526.956562] Starting dynamic subtest: pipe-A-plane-5
[526.963043] Dynamic subtest pipe-A-plane-5: SUCCESS (0.022s)
[527.328521] Starting dynamic subtest: pipe-B-plane-1
[527.735144] Dynamic subtest pipe-B-plane-1: SUCCESS (0.422s)
[527.749437] Starting dynamic subtest: pipe-B-plane-2
[528.188910] Dynamic subtest pipe-B-plane-2: SUCCESS (0.453s)
[528.202939] Starting dynamic subtest: pipe-B-plane-3
[528.632132] Dynamic subtest pipe-B-plane-3: SUCCESS (0.442s)
[528.645905] Starting dynamic subtest: pipe-B-plane-4
[529.090870] Dynamic subtest pipe-B-plane-4: SUCCESS (0.458s)
[529.104883] Starting dynamic subtest: pipe-B-plane-5
[529.111905] Dynamic subtest pipe-B-plane-5: SUCCESS (0.020s)
[529.112900] Subtest plane-position-covered: SUCCESS (4.471s)
[529.361437] Closing watchdogs
results: parsing output: 0/ for test: gem_create
results: parsing output: 1/ for test: kms_vrr
results: parsing output: 2/ for test: kms_fb_coherency
results: parsing output: 3/ for test: kms_flip_scaled_crc
results: parsing output: 4/ for test: gem_render_copy
results: parsing output: 5/ for test: syncobj_wait
results: parsing output: 6/ for test: kms_pipe_crc_basic
results: parsing output: 7/ for test: gem_exec_schedule
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: kms_tiled_display
results: parsing output: 10/ for test: gem_wait
results: parsing output: 11/ for test: kms_plane_multiple
results: parsing output: 12/ for test: kms_chamelium_hpd
results: parsing output: 13/ for test: prime_self_import
results: parsing output: 14/ for test: kms_joiner
results: parsing output: 15/ for test: i915_selftest
results: parsing output: 16/ for test: kms_rotation_crc
results: parsing output: 17/ for test: kms_pm_rpm
results: parsing output: 18/ for test: perf_pmu
results: parsing output: 19/ for test: kms_chamelium_frames
results: parsing output: 20/ for test: kms_psr2_sf
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: api_intel_allocator
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: vgem_slow
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: kms_rotation_crc
results: parsing output: 31/ for test: gem_userptr_blits
results: parsing output: 32/ for test: kms_content_protection
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: prime_self_import
results: parsing output: 35/ for test: gem_ctx_isolation
results: parsing output: 36/ for test: gem_exec_whisper
results: parsing output: 37/ for test: gem_mmap_offset
results: parsing output: 38/ for test: gem_exec_params
results: parsing output: 39/ for test: kms_pm_lpsp
results: parsing output: 40/ for test: gem_workarounds
results: parsing output: 41/ for test: kms_chamelium_color
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: kms_psr2_sf
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_lease
results: parsing output: 47/ for test: syncobj_basic
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: i915_drm_fdinfo
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_cursor_edge_walk
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: dmabuf_sync_file
results: parsing output: 54/ for test: gem_exec_params
results: parsing output: 55/ for test: gem_mmap_gtt
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_ccs
results: parsing output: 58/ for test: gem_exec_params
results: parsing output: 59/ for test: gem_eio
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: i915_drm_fdinfo
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_exec_balancer
results: parsing output: 65/ for test: gem_userptr_blits
results: parsing output: 66/ for test: vgem_basic
results: parsing output: 67/ for test: kms_flip_scaled_crc
results: parsing output: 68/ for test: i915_pm_rpm
results: parsing output: 69/ for test: gem_mmap_gtt
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: gen9_exec_parse
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: kms_cursor_crc
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: kms_flip
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_mmap_gtt
results: parsing output: 79/ for test: gem_exec_schedule
results: parsing output: 80/ for test: gem_close_race
results: parsing output: 81/ for test: kms_atomic
results: parsing output: 82/ for test: gem_exec_reloc
results: parsing output: 83/ for test: gem_exec_fence
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: syncobj_wait
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: gem_spin_batch
results: parsing output: 89/ for test: gem_exec_flush
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: perf
results: parsing output: 92/ for test: gem_pwrite
results: parsing output: 93/ for test: gem_render_copy
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: syncobj_wait
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: kms_vblank
results: parsing output: 99/ for test: gem_userptr_blits
results: parsing output: 100/ for test: kms_color
results: parsing output: 101/ for test: gem_exec_fence
results: parsing output: 102/ for test: gem_exec_reloc
results: parsing output: 103/ for test: api_intel_bb
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: gem_exec_fence
results: parsing output: 107/ for test: kms_plane_scaling
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_pipe_b_c_ivb
results: parsing output: 111/ for test: perf_pmu
results: parsing output: 112/ for test: gem_basic
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_userptr_blits
results: parsing output: 117/ for test: kms_plane
results: parsing output: 118/ for test: gem_exec_params
results: parsing output: 119/ for test: gem_exec_schedule
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: prime_vgem
results: parsing output: 122/ for test: kms_addfb_basic
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_mmap_gtt
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: gem_mmap_gtt
results: parsing output: 130/ for test: kms_flip
results: parsing output: 131/ for test: gem_ctx_persistence
results: parsing output: 132/ for test: kms_plane
Done.