[57.267032] Initializing watchdogs
[57.267082]   /dev/watchdog0
[57.283054] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.287541] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.289951] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.293740] [001/156] (960s left) kms_busy (basic-hang)
[57.426095] Starting subtest: basic-hang
[57.428453] Starting dynamic subtest: flip-pipe-A
[58.065176] Dynamic subtest flip-pipe-A: SUCCESS (0.638s)
[58.073223] Starting dynamic subtest: modeset-pipe-A
[61.565536] Dynamic subtest modeset-pipe-A: SUCCESS (3.500s)
[61.575431] Starting dynamic subtest: flip-pipe-D
[62.856179] Dynamic subtest flip-pipe-D: SUCCESS (1.287s)
[62.864658] Starting dynamic subtest: modeset-pipe-D
[66.287851] Dynamic subtest modeset-pipe-D: SUCCESS (3.430s)
[66.290711] Subtest basic-hang: SUCCESS (8.862s)
[67.108422] [002/156] (950s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[67.213968] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu
[67.218209] Subtest fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[67.337741] [003/156] (950s left) gem_exec_schedule (pi-distinct-iova)
[67.520503] Starting subtest: pi-distinct-iova
[67.523055] Starting dynamic subtest: rcs0
[67.599390] Dynamic subtest rcs0: SUCCESS (0.081s)
[67.611063] Starting dynamic subtest: vcs0
[67.659612] Dynamic subtest vcs0: SUCCESS (0.060s)
[67.668184] Starting dynamic subtest: vcs1
[67.719768] Dynamic subtest vcs1: SUCCESS (0.060s)
[67.731542] Starting dynamic subtest: vecs0
[67.777835] Dynamic subtest vecs0: SUCCESS (0.057s)
[67.788883] Starting dynamic subtest: ccs0
[67.837885] Dynamic subtest ccs0: SUCCESS (0.059s)
[67.841087] Subtest pi-distinct-iova: SUCCESS (0.321s)
[69.437339] [004/156] (948s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-render)
[69.546992] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-render
[69.551489] Subtest hdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[69.651484] [005/156] (948s left) kms_flip (2x-busy-flip)
[69.742961] Starting subtest: 2x-busy-flip
[69.752319] Subtest 2x-busy-flip: SKIP (0.011s)
[69.837776] [006/156] (948s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[69.928591] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[77.212402] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (7.288s)
[77.374243] [007/156] (940s left) kms_vrr (max-min)
[77.464388] Starting subtest: max-min
[77.470495] Subtest max-min: SKIP (0.000s)
[77.537352] [008/156] (940s left) kms_cursor_crc (cursor-random-max-size)
[77.833189] Starting subtest: cursor-random-max-size
[77.839489] Subtest cursor-random-max-size: SKIP (0.000s)
[77.958560] [009/156] (940s left) kms_flip (flip-vs-suspend-interruptible)
[78.052867] Starting subtest: flip-vs-suspend-interruptible
[78.055270] Starting dynamic subtest: A-eDP1
[193.481349] Dynamic subtest A-eDP1: SUCCESS (11.889s)
[193.484057] Subtest flip-vs-suspend-interruptible: SUCCESS (11.891s)
[200.626159] [010/156] (824s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt)
[200.736363] Starting subtest: fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt
[200.741297] Subtest fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[200.820261] [011/156] (824s left) gem_ccs (block-copy-uncompressed)
[200.872185] Starting subtest: block-copy-uncompressed
[200.874733] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[200.896048] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.023s)
[200.906706] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[200.914153] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[200.923593] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[200.934604] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.020s)
[200.943754] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[200.952400] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[200.955341] Subtest block-copy-uncompressed: SUCCESS (0.080s)
[201.063891] [012/156] (824s left) kms_lease (lessee-list)
[201.153573] Starting subtest: lessee-list
[201.156305] Starting dynamic subtest: pipe-A-eDP-1
[201.158748] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[201.168284] Starting dynamic subtest: pipe-B-eDP-1
[201.170498] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[201.179329] Starting dynamic subtest: pipe-C-eDP-1
[201.181473] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[201.190287] Starting dynamic subtest: pipe-D-eDP-1
[201.192492] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[201.194547] Subtest lessee-list: SUCCESS (0.007s)
[201.260294] [013/156] (824s left) gem_exec_basic (basic)
[201.323125] Starting subtest: basic
[201.325428] Starting dynamic subtest: rcs0-smem
[201.327935] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[201.340704] Starting dynamic subtest: bcs0-smem
[201.342963] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[201.351369] Starting dynamic subtest: vcs0-smem
[201.353723] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[201.366733] Starting dynamic subtest: vcs1-smem
[201.369242] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[201.378508] Starting dynamic subtest: vecs0-smem
[201.380582] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[201.389216] Starting dynamic subtest: ccs0-smem
[201.391569] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[201.396029] Subtest basic: SUCCESS (0.012s)
[202.878131] [014/156] (822s left) syncobj_timeline (wait-all-delayed-signal)
[202.931524] Starting subtest: wait-all-delayed-signal
[203.036104] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[203.139815] [015/156] (822s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[203.225263] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[203.252649] Starting dynamic subtest: pipe-A-plane-0
[203.553475] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[203.563247] Starting dynamic subtest: pipe-A-plane-3
[203.763702] Dynamic subtest pipe-A-plane-3: SUCCESS (0.210s)
[203.773420] Starting dynamic subtest: pipe-A-plane-5
[203.778858] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[204.929570] Starting dynamic subtest: pipe-B-plane-0
[205.222277] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[205.232103] Starting dynamic subtest: pipe-B-plane-3
[205.434558] Dynamic subtest pipe-B-plane-3: SUCCESS (0.211s)
[205.443588] Starting dynamic subtest: pipe-B-plane-5
[205.448569] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[205.750542] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.523s)
[206.608237] [016/156] (818s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[206.714920] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[206.719922] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[206.804064] [017/156] (818s left) kms_rotation_crc (primary-rotation-90)
[206.897319] Starting subtest: primary-rotation-90
[206.901933] Subtest primary-rotation-90: SKIP (0.001s)
[206.968179] [018/156] (818s left) kms_tiled_display (basic-test-pattern)
[207.080449] Subtest basic-test-pattern: SKIP (0.000s)
[207.128474] [019/156] (818s left) kms_flip (basic-flip-vs-wf_vblank)
[207.218599] Starting subtest: basic-flip-vs-wf_vblank
[207.221411] Starting dynamic subtest: A-eDP1
[209.161511] Dynamic subtest A-eDP1: SUCCESS (1.942s)
[209.176264] Starting dynamic subtest: B-eDP1
[211.100193] Dynamic subtest B-eDP1: SUCCESS (1.936s)
[211.112749] Starting dynamic subtest: C-eDP1
[213.023632] Dynamic subtest C-eDP1: SUCCESS (1.920s)
[213.034726] Starting dynamic subtest: D-eDP1
[214.969877] Dynamic subtest D-eDP1: SUCCESS (1.945s)
[214.972200] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.754s)
[216.204254] [020/156] (809s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-plflip-blt)
[216.311629] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-plflip-blt
[216.316691] Subtest fbcpsrhdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[216.415171] [021/156] (809s left) perf_pmu (busy-accuracy-50)
[216.454702] Starting subtest: busy-accuracy-50
[216.457022] Starting dynamic subtest: rcs0
[217.991006] Dynamic subtest rcs0: SUCCESS (1.535s)
[218.001080] Starting dynamic subtest: bcs0
[219.536935] Dynamic subtest bcs0: SUCCESS (1.544s)
[219.547765] Starting dynamic subtest: vcs0
[221.082703] Dynamic subtest vcs0: SUCCESS (1.543s)
[221.094222] Starting dynamic subtest: vcs1
[222.621648] Dynamic subtest vcs1: SUCCESS (1.538s)
[222.633878] Starting dynamic subtest: vecs0
[224.163569] Dynamic subtest vecs0: SUCCESS (1.540s)
[224.175472] Starting dynamic subtest: ccs0
[225.711283] Dynamic subtest ccs0: SUCCESS (1.546s)
[225.713407] Subtest busy-accuracy-50: SUCCESS (9.256s)
[225.825443] [022/156] (799s left) kms_cursor_edge_walk (64x64-top-bottom)
[225.923231] Starting subtest: 64x64-top-bottom
[225.925564] Starting dynamic subtest: pipe-A-eDP-1
[229.377454] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.455s)
[229.387430] Starting dynamic subtest: pipe-D-eDP-1
[232.516313] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.134s)
[232.519157] Subtest 64x64-top-bottom: SUCCESS (6.592s)
[233.331126] [023/156] (792s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[233.432315] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[233.437563] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[233.543773] [024/156] (792s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-pwrite)
[233.634194] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-pwrite
[233.639351] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[233.738994] [025/156] (792s left) gem_softpin (evict-prime-sanity-check)
[233.799699] Starting subtest: evict-prime-sanity-check
[233.802479] Starting dynamic subtest: rcs0
[234.937200] Dynamic subtest rcs0: SUCCESS (1.137s)
[234.947721] Starting dynamic subtest: bcs0
[236.049897] Dynamic subtest bcs0: SUCCESS (1.112s)
[236.059633] Starting dynamic subtest: vcs0
[237.839744] Dynamic subtest vcs0: SUCCESS (1.787s)
[237.850588] Starting dynamic subtest: vcs1
[239.828699] Dynamic subtest vcs1: SUCCESS (1.987s)
[239.841654] Starting dynamic subtest: vecs0
[241.853254] Dynamic subtest vecs0: SUCCESS (2.023s)
[241.866393] Starting dynamic subtest: ccs0
[242.983958] Dynamic subtest ccs0: SUCCESS (1.130s)
[242.994329] Starting dynamic subtest: all
[244.110198] Dynamic subtest all: SUCCESS (1.124s)
[244.112847] Subtest evict-prime-sanity-check: SUCCESS (10.309s)
[244.190306] [026/156] (781s left) kms_frontbuffer_tracking (psrhdr-indfb-scaledprimary)
[244.290330] Starting subtest: psrhdr-indfb-scaledprimary
[244.295244] Subtest psrhdr-indfb-scaledprimary: SKIP (0.000s)
[244.379996] [027/156] (781s left) gem_exec_whisper (basic-forked)
[244.440396] Starting subtest: basic-forked
[251.695131] Subtest basic-forked: SUCCESS (7.246s)
[251.873818] [028/156] (774s left) gem_exec_reloc (basic-gtt-read-active)
[251.935651] Subtest basic-gtt-read-active: SKIP (0.000s)
[252.003986] [029/156] (773s left) kms_async_flips (test-time-stamp-atomic)
[252.100353] Starting subtest: test-time-stamp-atomic
[252.485337] Starting dynamic subtest: pipe-A-eDP-1
[253.325472] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.839s)
[253.704141] Starting dynamic subtest: pipe-B-eDP-1
[254.477538] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.778s)
[254.856513] Starting dynamic subtest: pipe-C-eDP-1
[255.712524] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.864s)
[256.075317] Starting dynamic subtest: pipe-D-eDP-1
[256.847583] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.777s)
[256.850258] Subtest test-time-stamp-atomic: SUCCESS (4.746s)
[258.011263] [030/156] (767s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-pgflip-blt)
[258.110423] Starting subtest: fbchdr-2p-scndscrn-shrfb-pgflip-blt
[258.115427] Subtest fbchdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[258.215114] [031/156] (767s left) gem_vm_create (invalid-create)
[258.272403] Starting subtest: invalid-create
[258.278688] Subtest invalid-create: SUCCESS (0.004s)
[258.410568] [032/156] (767s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-blt)
[258.518984] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-blt
[258.523513] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[258.596699] [033/156] (767s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[258.712443] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[269.889074] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.175s)
[270.752258] [034/156] (755s left) kms_cursor_crc (cursor-offscreen-128x42)
[270.987643] Starting subtest: cursor-offscreen-128x42
[271.038635] Subtest cursor-offscreen-128x42: SKIP (0.045s)
[271.247180] [035/156] (754s left) kms_chamelium_audio (hdmi-audio-edid)
[271.625527] Subtest hdmi-audio-edid: SKIP (0.000s)
[272.471221] [036/156] (753s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[272.566466] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[280.162711] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.603s)
[280.287537] [037/156] (745s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[280.387069] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[280.389496] Starting dynamic subtest: pipe-A-eDP-1
[280.417547] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[280.429340] Starting dynamic subtest: pipe-B-eDP-1
[280.454643] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[280.465447] Starting dynamic subtest: pipe-C-eDP-1
[280.491481] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[280.500858] Starting dynamic subtest: pipe-D-eDP-1
[280.527082] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[280.532080] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[282.692017] [038/156] (743s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[282.798348] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[282.803468] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[282.890400] [039/156] (743s left) kms_lease (cursor-implicit-plane)
[282.980592] Starting subtest: cursor-implicit-plane
[282.983243] Starting dynamic subtest: pipe-A-eDP-1
[283.445126] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.464s)
[283.455418] Starting dynamic subtest: pipe-B-eDP-1
[284.627550] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.183s)
[284.638621] Starting dynamic subtest: pipe-C-eDP-1
[285.750476] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.119s)
[285.761662] Starting dynamic subtest: pipe-D-eDP-1
[286.876040] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s)
[286.878609] Subtest cursor-implicit-plane: SUCCESS (3.898s)
[287.742945] [040/156] (738s left) kms_pm_rpm (basic-rte)
[287.780301] Starting subtest: basic-rte
[291.554092] Subtest basic-rte: SUCCESS (3.775s)
[293.368923] [041/156] (733s left) gem_mmap_gtt (hang-busy)
[293.432556] Subtest hang-busy: SKIP (0.000s)
[293.495348] [042/156] (732s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[293.581256] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[293.583645] Starting dynamic subtest: pipe-A
[293.605002] Dynamic subtest pipe-A: SKIP (0.019s)
[293.615012] Starting dynamic subtest: pipe-B
[293.638255] Dynamic subtest pipe-B: SKIP (0.031s)
[293.648363] Starting dynamic subtest: pipe-C
[293.669444] Dynamic subtest pipe-C: SKIP (0.032s)
[293.679564] Starting dynamic subtest: pipe-D
[293.703907] Dynamic subtest pipe-D: SKIP (0.032s)
[293.708307] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.118s)
[293.792540] [043/156] (732s left) syncobj_timeline (multi-wait-submitted-signaled)
[293.841494] Starting subtest: multi-wait-submitted-signaled
[293.844335] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[293.932183] [044/156] (732s left) i915_drm_fdinfo (most-busy-idle-check-all)
[293.972559] Starting subtest: most-busy-idle-check-all
[293.974973] Starting dynamic subtest: rcs0
[293.979650] Dynamic subtest rcs0: SKIP (0.004s)
[293.989977] Starting dynamic subtest: bcs0
[293.995068] Dynamic subtest bcs0: SKIP (0.000s)
[294.004787] Starting dynamic subtest: vcs0
[294.010490] Dynamic subtest vcs0: SKIP (0.000s)
[294.020564] Starting dynamic subtest: vcs1
[294.025541] Dynamic subtest vcs1: SKIP (0.000s)
[294.035107] Starting dynamic subtest: vecs0
[294.040328] Dynamic subtest vecs0: SKIP (0.000s)
[294.051456] Starting dynamic subtest: ccs0
[294.056522] Dynamic subtest ccs0: SKIP (0.000s)
[294.061604] Subtest most-busy-idle-check-all: SKIP (0.010s)
[294.102196] [045/156] (732s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-pwrite)
[294.199639] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-pwrite
[294.205460] Subtest hdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[294.305083] [046/156] (732s left) gem_mmap_gtt (basic-wc)
[294.360700] Subtest basic-wc: SKIP (0.000s)
[294.428740] [047/156] (732s left) gem_lmem_evict (dontneed-evict-race)
[294.475280] Subtest dontneed-evict-race: SKIP (0.000s)
[294.516075] [048/156] (732s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[294.564419] Starting subtest: multi-wait-for-submit-submitted-signaled
[294.566643] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[294.672194] [049/156] (732s left) kms_psr (fbc-pr-sprite-blt)
[294.762408] Starting subtest: fbc-pr-sprite-blt
[294.767274] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[294.834141] [050/156] (731s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[294.948135] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[295.594386] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.648s)
[295.746108] [051/156] (731s left) gem_exec_schedule (smoketest)
[295.921267] Starting subtest: smoketest
[295.926242] Starting dynamic subtest: rcs0
[301.503261] Dynamic subtest rcs0: SUCCESS (5.518s)
[301.516167] Starting dynamic subtest: bcs0
[307.045060] Dynamic subtest bcs0: SUCCESS (5.534s)
[307.056643] Starting dynamic subtest: vcs0
[312.559048] Dynamic subtest vcs0: SUCCESS (5.516s)
[312.572603] Starting dynamic subtest: vcs1
[318.100966] Dynamic subtest vcs1: SUCCESS (5.530s)
[318.112600] Starting dynamic subtest: vecs0
[323.603564] Dynamic subtest vecs0: SUCCESS (5.513s)
[323.615650] Starting dynamic subtest: ccs0
[329.113605] Dynamic subtest ccs0: SUCCESS (5.509s)
[329.116499] Subtest smoketest: SUCCESS (33.127s)
[329.296328] [052/156] (697s left) gem_render_copy (yf-tiled)
[329.354866] Starting subtest: yf-tiled
[329.359706] Subtest yf-tiled: SKIP (0.000s)
[329.535769] [053/156] (697s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[329.624697] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[329.630457] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[329.712946] [054/156] (697s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[329.819949] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[329.824657] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[329.919038] [055/156] (697s left) core_auth (basic-auth)
[329.972240] Starting subtest: basic-auth
[329.974712] Subtest basic-auth: SUCCESS (0.001s)
[330.068143] [056/156] (697s left) kms_hdmi_inject (inject-4k)
[330.406518] Starting subtest: inject-4k
[330.757567] Subtest inject-4k: SUCCESS (0.351s)
[331.322647] [057/156] (695s left) gen3_mixed_blits
[331.446288] [058/156] (695s left) kms_prop_blob (blob-prop-validate)
[331.493155] Starting subtest: blob-prop-validate
[331.495616] Subtest blob-prop-validate: SUCCESS (0.000s)
[331.591328] [059/156] (695s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[331.684292] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[335.897415] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.220s)
[337.099442] [060/156] (690s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[337.203492] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[338.005499] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.804s)
[338.144818] [061/156] (689s left) kms_frontbuffer_tracking (psr-1p-rte)
[338.254711] Starting subtest: psr-1p-rte
[343.559736] Subtest psr-1p-rte: SUCCESS (5.312s)
[343.696270] [062/156] (683s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[343.799551] Starting subtest: y-tiled-16bpp-rotate-0
[343.804554] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[343.885120] [063/156] (683s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[343.976736] Starting subtest: primary-y-tiled-reflect-x-180
[344.036206] Subtest primary-y-tiled-reflect-x-180: SKIP (0.059s)
[344.140942] [064/156] (683s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt)
[344.247173] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt
[344.252267] Subtest fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[344.338906] [065/156] (683s left) kms_chamelium_edid (vga-edid-read)
[344.728880] Subtest vga-edid-read: SKIP (0.000s)
[345.559509] [066/156] (681s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[345.610765] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[345.616144] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[345.800226] [067/156] (681s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[345.889219] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[345.891811] Starting dynamic subtest: pipe-A-eDP-1
[345.917590] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[345.929610] Starting dynamic subtest: pipe-B-eDP-1
[345.955847] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[345.965473] Starting dynamic subtest: pipe-C-eDP-1
[345.990731] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[346.000090] Starting dynamic subtest: pipe-D-eDP-1
[346.026199] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[346.031444] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[348.188546] [068/156] (679s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[348.299735] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[354.750988] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.457s)
[354.861279] [069/156] (672s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[354.957313] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[354.961859] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[355.045817] [070/156] (672s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[355.129749] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[355.134741] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[355.204927] [071/156] (672s left) kms_psr (psr-suspend)
[355.306712] Starting subtest: psr-suspend
[355.309375] Starting dynamic subtest: eDP-1
[373.930395] Dynamic subtest eDP-1: SUCCESS (3.386s)
[373.932609] Subtest psr-suspend: SUCCESS (3.387s)
[380.786757] [072/156] (652s left) gem_mmap_wc (bad-offset)
[380.846679] Subtest bad-offset: SKIP (0.000s)
[380.909585] [073/156] (652s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt)
[381.014652] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt
[381.018777] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[381.112299] [074/156] (652s left) kms_flip (wf_vblank-ts-check)
[381.200422] Starting subtest: wf_vblank-ts-check
[381.202650] Starting dynamic subtest: A-eDP1
[390.100670] Dynamic subtest A-eDP1: SUCCESS (8.893s)
[390.113277] Starting dynamic subtest: B-eDP1
[399.010421] Dynamic subtest B-eDP1: SUCCESS (8.904s)
[399.020682] Starting dynamic subtest: C-eDP1
[407.903422] Dynamic subtest C-eDP1: SUCCESS (8.887s)
[407.913758] Starting dynamic subtest: D-eDP1
[416.787074] Dynamic subtest D-eDP1: SUCCESS (8.882s)
[416.789565] Subtest wf_vblank-ts-check: SUCCESS (35.576s)
[418.004730] [075/156] (615s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[418.097607] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[418.099921] Starting dynamic subtest: pipe-A-eDP-1
[418.123312] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[418.135370] Starting dynamic subtest: pipe-B-eDP-1
[418.157588] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[418.168258] Starting dynamic subtest: pipe-C-eDP-1
[418.189372] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[418.198867] Starting dynamic subtest: pipe-D-eDP-1
[418.220070] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[418.224086] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[420.377723] [076/156] (613s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[420.477802] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[427.470166] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.995s)
[427.596827] [077/156] (606s left) kms_plane_multiple (tiling-4)
[427.685534] Starting subtest: tiling-4
[427.687445] Starting dynamic subtest: pipe-A-eDP-1
[431.520266] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.833s)
[431.530897] Starting dynamic subtest: pipe-B-eDP-1
[436.129329] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.607s)
[436.140160] Starting dynamic subtest: pipe-C-eDP-1
[440.703504] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.573s)
[440.714502] Starting dynamic subtest: pipe-D-eDP-1
[445.312766] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.608s)
[445.314843] Subtest tiling-4: SUCCESS (17.625s)
[446.178399] [078/156] (587s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[446.286020] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[446.290450] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[446.383361] [079/156] (587s left) i915_query (engine-info-invalid)
[446.431279] Starting subtest: engine-info-invalid
[446.433587] Subtest engine-info-invalid: SUCCESS (0.000s)
[446.540276] [080/156] (587s left) gem_exec_params (invalid-fence-in)
[446.596974] Starting subtest: invalid-fence-in
[446.598852] Subtest invalid-fence-in: SUCCESS (0.000s)
[446.701997] [081/156] (587s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-plflip-blt)
[446.804050] Starting subtest: hdr-2p-primscrn-shrfb-plflip-blt
[446.808201] Subtest hdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[446.913247] [082/156] (587s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[447.004260] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[447.015855] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s)
[447.098541] [083/156] (587s left) kms_addfb_basic (bad-pitch-65536)
[447.151595] Starting subtest: bad-pitch-65536
[447.153200] Subtest bad-pitch-65536: SUCCESS (0.000s)
[447.296287] [084/156] (586s left) gem_ctx_freq (sysfs)
[447.355149] Starting subtest: sysfs
[447.357255] Starting dynamic subtest: gt0
[452.870194] Dynamic subtest gt0: SUCCESS (5.513s)
[452.881961] Starting dynamic subtest: gt1
[494.108879] Dynamic subtest gt1: SUCCESS (41.234s)
[494.112143] Subtest sysfs: SUCCESS (46.750s)
[494.230737] [085/156] (540s left) kms_content_protection (legacy-hdcp14)
[494.385056] Starting subtest: legacy-hdcp14
[494.389860] Subtest legacy-hdcp14: SKIP (0.000s)
[494.505442] [086/156] (539s left) i915_pm_rpm (gem-execbuf)
[496.242729] Starting subtest: gem-execbuf
[496.245300] Starting dynamic subtest: smem0
[497.828498] Dynamic subtest smem0: SUCCESS (1.587s)
[497.830808] Subtest gem-execbuf: SUCCESS (1.589s)
[497.912018] [087/156] (536s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[498.013110] Starting subtest: yf-tiled-16bpp-rotate-90
[498.017690] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[498.107879] [088/156] (536s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[498.212530] Starting subtest: x-tiled-8bpp-rotate-0
[499.414517] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.202s)
[499.560067] [089/156] (534s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[499.663102] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[499.665072] Starting dynamic subtest: pipe-A-eDP-1
[499.753049] Dynamic subtest pipe-A-eDP-1: SKIP (0.092s)
[499.763608] Starting dynamic subtest: pipe-B-eDP-1
[500.931904] Dynamic subtest pipe-B-eDP-1: SKIP (1.176s)
[500.936629] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.271s)
[502.180419] [090/156] (532s left) gem_exec_balancer (invalid-balancer)
[502.238032] Starting subtest: invalid-balancer
[503.172506] Subtest invalid-balancer: SUCCESS (0.932s)
[503.463842] [091/156] (531s left) gem_fenced_exec_thrash (no-spare-fences)
[503.523296] Subtest no-spare-fences: SKIP (0.000s)
[503.592557] [092/156] (531s left) syncobj_timeline (invalid-query-zero-handles)
[503.654908] Starting subtest: invalid-query-zero-handles
[503.656878] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[503.771765] [093/156] (530s left) gem_render_copy (linear)
[503.825382] Starting subtest: linear
[503.827271] Starting dynamic subtest: smem
[503.863608] Dynamic subtest smem: SUCCESS (0.041s)
[503.866132] Subtest linear: SUCCESS (0.042s)
[504.109799] [094/156] (530s left) gem_ctx_persistence (heartbeat-close)
[504.176167] Starting subtest: heartbeat-close
[504.180745] Subtest heartbeat-close: SKIP (0.000s)
[504.274271] [095/156] (530s left) gem_ctx_shared (exec-shared-gtt)
[504.332614] Starting subtest: exec-shared-gtt
[504.334951] Starting dynamic subtest: rcs0
[504.336913] Dynamic subtest rcs0: SUCCESS (0.007s)
[504.348927] Starting dynamic subtest: bcs0
[504.351239] Dynamic subtest bcs0: SUCCESS (0.005s)
[504.361350] Starting dynamic subtest: vcs0
[504.363546] Dynamic subtest vcs0: SUCCESS (0.006s)
[504.373554] Starting dynamic subtest: vcs1
[504.375397] Dynamic subtest vcs1: SUCCESS (0.007s)
[504.385114] Starting dynamic subtest: vecs0
[504.387087] Dynamic subtest vecs0: SUCCESS (0.007s)
[504.396603] Starting dynamic subtest: ccs0
[504.398518] Dynamic subtest ccs0: SUCCESS (0.006s)
[504.400395] Subtest exec-shared-gtt: SUCCESS (0.042s)
[504.572684] [096/156] (530s left) kms_frontbuffer_tracking (hdr-farfromfence-mmap-gtt)
[504.679619] Starting subtest: hdr-farfromfence-mmap-gtt
[504.684092] Subtest hdr-farfromfence-mmap-gtt: SKIP (0.000s)
[504.783404] [097/156] (530s left) kms_psr (psr2-sprite-blt)
[504.883261] Starting subtest: psr2-sprite-blt
[504.885591] Starting dynamic subtest: eDP-1
[506.636904] Dynamic subtest eDP-1: SUCCESS (1.751s)
[506.639676] Subtest psr2-sprite-blt: SUCCESS (1.752s)
[507.474566] [098/156] (527s left) kms_force_connector_basic (force-edid)
[507.556343] Starting subtest: force-edid
[507.922737] Subtest force-edid: SUCCESS (0.366s)
[508.059935] [099/156] (526s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[508.159612] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[508.164213] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[508.268366] [100/156] (526s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[508.365867] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[508.369931] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[508.453266] [101/156] (526s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[508.495749] Starting subtest: invalid-multi-wait-all-unsubmitted
[508.497632] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[508.602535] [102/156] (526s left) gem_exec_reloc (basic-scanout)
[508.656387] Subtest basic-scanout: SKIP (0.000s)
[508.718432] [103/156] (526s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-move)
[508.804042] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-move
[508.807489] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[508.897955] [104/156] (526s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[508.992089] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[508.995680] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[509.089872] [105/156] (526s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[509.188747] Starting subtest: psr-rgb565-draw-mmap-gtt
[509.192296] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[509.269473] [106/156] (525s left) gem_lmem_swapping (verify-random-ccs)
[509.310907] Subtest verify-random-ccs: SKIP (0.000s)
[509.354420] [107/156] (525s left) gem_mmap_gtt (big-copy-odd)
[509.412106] Subtest big-copy-odd: SKIP (0.000s)
[509.473284] [108/156] (525s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[509.519096] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[509.625465] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.105s)
[509.712780] [109/156] (525s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-pwrite)
[509.803385] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-pwrite
[509.807441] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[509.899946] [110/156] (525s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[509.995261] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[509.997546] Starting dynamic subtest: pipe-A-eDP-1
[510.054250] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[510.064555] Starting dynamic subtest: pipe-B-eDP-1
[510.122395] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[510.134534] Starting dynamic subtest: pipe-C-eDP-1
[510.188261] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[510.198173] Starting dynamic subtest: pipe-D-eDP-1
[510.253971] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[510.258757] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.009s)
[512.279973] [111/156] (523s left) gen9_exec_parse (batch-without-end)
[512.338534] Subtest batch-without-end: SKIP (0.000s)
[512.432077] [112/156] (522s left) kms_dsc (dsc-fractional-bpp-bigjoiner)
[512.537343] Starting subtest: dsc-fractional-bpp-bigjoiner
[512.541313] Subtest dsc-fractional-bpp-bigjoiner: SKIP (0.000s)
[512.610170] [113/156] (522s left) kms_invalid_mode (bad-vsync-end)
[512.705404] Starting subtest: bad-vsync-end
[512.707680] Starting dynamic subtest: pipe-A-eDP-1
[512.993571] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[513.004524] Starting dynamic subtest: pipe-B-eDP-1
[513.006490] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[513.016426] Starting dynamic subtest: pipe-C-eDP-1
[513.018616] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[513.035085] Starting dynamic subtest: pipe-D-eDP-1
[513.037940] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[513.040878] Subtest bad-vsync-end: SUCCESS (0.291s)
[513.875652] [114/156] (521s left) kms_psr (fbc-psr-primary-mmap-gtt)
[513.971242] Starting subtest: fbc-psr-primary-mmap-gtt
[513.973556] Starting dynamic subtest: eDP-1
[513.977892] Dynamic subtest eDP-1: SKIP (0.000s)
[513.982300] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[514.045912] [115/156] (521s left) syncobj_basic (bad-destroy)
[514.100656] Starting subtest: bad-destroy
[514.102835] Subtest bad-destroy: SUCCESS (0.000s)
[514.199703] [116/156] (521s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[514.298921] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[514.303297] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[514.389632] [117/156] (521s left) kms_chamelium_hpd (hdmi-hpd)
[514.768324] Subtest hdmi-hpd: SKIP (0.000s)
[515.549523] [118/156] (520s left) kms_flip (flip-vs-modeset-vs-hang)
[515.636229] Starting subtest: flip-vs-modeset-vs-hang
[515.638585] Starting dynamic subtest: A-eDP1
[567.610207] Dynamic subtest A-eDP1: SUCCESS (51.967s)
[567.620564] Starting dynamic subtest: D-eDP1
[617.654704] Dynamic subtest D-eDP1: SUCCESS (50.040s)
[617.657225] Subtest flip-vs-modeset-vs-hang: SUCCESS (102.014s)
[618.031707] [119/156] (417s left) gem_create (create-ext-cpu-access-big)
[618.198872] Starting subtest: create-ext-cpu-access-big
[618.203105] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[618.284042] [120/156] (417s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-4)
[618.383959] Starting subtest: fbcpsrhdr-tiling-4
[618.388349] Subtest fbcpsrhdr-tiling-4: SKIP (0.000s)
[618.478335] [121/156] (417s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[618.573182] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[618.577275] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[618.666761] [122/156] (417s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[618.765331] Starting subtest: psr2-cursor-plane-move-continuous-sf
[618.767562] Starting dynamic subtest: pipe-A-eDP-1
[629.115981] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.352s)
[629.127521] Starting dynamic subtest: pipe-B-eDP-1
[640.218002] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.101s)
[640.220364] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.456s)
[641.068882] [123/156] (394s left) kms_plane_scaling (planes-upscale-factor-0-25)
[641.178030] Starting subtest: planes-upscale-factor-0-25
[641.180388] Starting dynamic subtest: pipe-A
[641.238085] Dynamic subtest pipe-A: SUCCESS (0.063s)
[641.250426] Starting dynamic subtest: pipe-B
[642.356542] Dynamic subtest pipe-B: SUCCESS (1.116s)
[642.371885] Starting dynamic subtest: pipe-C
[643.529381] Dynamic subtest pipe-C: SUCCESS (1.172s)
[643.540059] Starting dynamic subtest: pipe-D
[644.643352] Dynamic subtest pipe-D: SUCCESS (1.113s)
[644.645744] Subtest planes-upscale-factor-0-25: SUCCESS (3.469s)
[645.859033] [124/156] (390s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc)
[645.962965] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc
[645.967138] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[646.077432] [125/156] (389s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[646.188896] Starting subtest: cursorA-vs-flipB-toggle
[646.193484] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[646.331814] [126/156] (389s left) i915_hangman (engine-engine-hang)
[646.393797] Starting subtest: engine-engine-hang
[646.395722] Starting dynamic subtest: rcs0
[648.059162] Dynamic subtest rcs0: SUCCESS (1.665s)
[648.071280] Starting dynamic subtest: bcs0
[650.043420] Dynamic subtest bcs0: SUCCESS (1.982s)
[650.059050] Starting dynamic subtest: vcs0
[652.091659] Dynamic subtest vcs0: SUCCESS (2.045s)
[652.101755] Starting dynamic subtest: vcs1
[654.075666] Dynamic subtest vcs1: SUCCESS (1.982s)
[654.088569] Starting dynamic subtest: vecs0
[656.060167] Dynamic subtest vecs0: SUCCESS (1.982s)
[656.073557] Starting dynamic subtest: ccs0
[658.043151] Dynamic subtest ccs0: SUCCESS (1.978s)
[658.046033] Subtest engine-engine-hang: SUCCESS (11.651s)
[658.129755] [127/156] (377s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-pwrite)
[658.237152] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-pwrite
[658.241372] Subtest fbchdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[658.329427] [128/156] (377s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[658.910531] Starting subtest: syncobj-timeline-invalid-wait
[658.913414] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s)
[660.211873] [FACT gem_exec_fence (syncobj-timeline-invalid-wait)] new: kernel.kmod_is_loaded.vgem: true
[660.216324] [129/156] (375s left) kms_cursor_legacy (torture-bo)
[660.332781] Starting subtest: torture-bo
[660.335153] Starting dynamic subtest: pipe-A
[666.067381] Dynamic subtest pipe-A: SUCCESS (5.730s)
[666.088037] Starting dynamic subtest: pipe-B
[671.876333] Dynamic subtest pipe-B: SUCCESS (5.809s)
[671.894381] Starting dynamic subtest: pipe-C
[678.664150] Dynamic subtest pipe-C: SUCCESS (6.786s)
[678.682781] Starting dynamic subtest: pipe-D
[685.474709] Dynamic subtest pipe-D: SUCCESS (6.807s)
[685.485704] Starting dynamic subtest: all-pipes
[691.475652] Dynamic subtest all-pipes: SUCCESS (6.001s)
[691.477860] Subtest torture-bo: SUCCESS (31.142s)
[691.640294] [130/156] (344s left) perf_pmu (most-busy-check-all)
[691.683180] Starting subtest: most-busy-check-all
[691.685587] Starting dynamic subtest: rcs0
[693.085307] Dynamic subtest rcs0: SUCCESS (1.401s)
[693.100033] Starting dynamic subtest: bcs0
[695.132436] Dynamic subtest bcs0: SUCCESS (2.045s)
[695.146846] Starting dynamic subtest: vcs0
[697.117506] Dynamic subtest vcs0: SUCCESS (1.981s)
[697.131084] Starting dynamic subtest: vcs1
[699.101698] Dynamic subtest vcs1: SUCCESS (1.981s)
[699.115254] Starting dynamic subtest: vecs0
[701.085432] Dynamic subtest vecs0: SUCCESS (1.981s)
[701.099215] Starting dynamic subtest: ccs0
[703.133658] Dynamic subtest ccs0: SUCCESS (2.045s)
[703.136376] Subtest most-busy-check-all: SUCCESS (11.451s)
[703.257298] [131/156] (332s left) kms_psr (psr2-primary-mmap-gtt)
[703.349398] Starting subtest: psr2-primary-mmap-gtt
[703.351780] Starting dynamic subtest: eDP-1
[704.829672] Dynamic subtest eDP-1: SKIP (1.477s)
[704.834556] Subtest psr2-primary-mmap-gtt: SKIP (1.479s)
[704.974277] [132/156] (331s left) syncobj_wait (single-wait-all-signaled)
[705.020723] Starting subtest: single-wait-all-signaled
[705.022974] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[705.118913] [133/156] (331s left) kms_addfb_basic (size-max)
[705.209033] Starting subtest: size-max
[705.211308] Subtest size-max: SUCCESS (0.000s)
[705.321859] [134/156] (331s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[705.423463] Starting subtest: fbc-modesetfrombusy
[709.215596] Subtest fbc-modesetfrombusy: SUCCESS (3.799s)
[710.411723] [135/156] (325s left) sw_sync (sync_busy_fork_unixsocket)
[710.445323] Starting subtest: sync_busy_fork_unixsocket
[710.451304] Subtest sync_busy_fork_unixsocket: SUCCESS (0.008s)
[710.515541] [136/156] (325s left) perf (whitelisted-registers-userspace-config)
[710.648855] Starting subtest: whitelisted-registers-userspace-config
[710.650906] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[710.690440] [137/156] (325s left) gem_basic (create-fd-close)
[710.742892] Starting subtest: create-fd-close
[710.746955] Subtest create-fd-close: SUCCESS (0.000s)
[710.866580] [138/156] (325s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[710.975210] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[710.979309] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[711.071594] [139/156] (325s left) kms_plane (pixel-format-y-tiled-modifier)
[711.173611] Starting subtest: pixel-format-y-tiled-modifier
[711.178142] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s)
[711.250268] [140/156] (325s left) prime_vgem (basic-gtt)
[711.306196] Starting subtest: basic-gtt
[711.310258] Subtest basic-gtt: SKIP (0.000s)
[711.403407] [141/156] (325s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[711.466650] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[711.468661] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[711.573632] [142/156] (325s left) syncobj_timeline (invalid-signal-illegal-point)
[711.633453] Starting subtest: invalid-signal-illegal-point
[711.635298] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[711.747982] [143/156] (324s left) gem_wait (invalid-flags)
[711.802013] Starting subtest: invalid-flags
[711.803839] Subtest invalid-flags: SUCCESS (0.000s)
[712.054552] [144/156] (324s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[712.159650] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[719.637555] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.483s)
[719.766423] [145/156] (317s left) device_reset (unbind-reset-rebind)
[719.816364] Starting subtest: unbind-reset-rebind
[726.093671] Subtest unbind-reset-rebind: SUCCESS (6.271s)
[726.140246] [146/156] (310s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[726.205441] Starting subtest: y-tiled-ccs-to-x-tiled
[726.210021] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[726.401388] [147/156] (310s left) gem_userptr_blits (map-fixed-invalidate-busy)
[726.468114] Starting subtest: map-fixed-invalidate-busy
[726.473350] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[726.585848] [148/156] (310s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[726.676604] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-wc
[726.680776] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[726.773751] [149/156] (310s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[726.864876] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[726.869214] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[726.967941] [150/156] (310s left) kms_color (ctm-red-to-blue)
[727.054322] Starting subtest: ctm-red-to-blue
[727.056195] Starting dynamic subtest: pipe-A-eDP-1
[727.787998] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.733s)
[727.801604] Starting dynamic subtest: pipe-B-eDP-1
[729.243797] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.456s)
[729.255865] Starting dynamic subtest: pipe-C-eDP-1
[730.617800] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.374s)
[730.629478] Starting dynamic subtest: pipe-D-eDP-1
[731.962150] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.343s)
[731.964531] Subtest ctm-red-to-blue: SUCCESS (4.910s)
[732.772256] [151/156] (304s left) api_intel_bb (reset-flags)
[732.821203] Starting subtest: reset-flags
[732.826291] Subtest reset-flags: SUCCESS (0.007s)
[732.953886] [152/156] (304s left) kms_addfb_basic (invalid-set-prop)
[732.995104] Starting subtest: invalid-set-prop
[732.997457] Subtest invalid-set-prop: SUCCESS (0.000s)
[733.158619] [153/156] (304s left) api_intel_allocator (two-level-inception-interruptible)
[733.211645] Starting subtest: two-level-inception-interruptible
[738.616924] Subtest two-level-inception-interruptible: SUCCESS (5.406s)
[738.741014] [154/156] (298s left) kms_psr (fbc-psr2-cursor-blt)
[738.838946] Starting subtest: fbc-psr2-cursor-blt
[738.841101] Starting dynamic subtest: eDP-1
[738.844986] Dynamic subtest eDP-1: SKIP (0.000s)
[738.848889] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[738.918022] [155/156] (298s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[739.021757] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[739.133692] [156/156] (298s left) syncobj_eventfd (timeline-wait-before-signal)
[739.197090] Starting subtest: timeline-wait-before-signal
[739.230650] Subtest timeline-wait-before-signal: SUCCESS (0.032s)
[739.319034] Closing watchdogs
results: parsing output: 0/ for test: kms_busy
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_exec_schedule
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_vrr
results: parsing output: 7/ for test: kms_cursor_crc
results: parsing output: 8/ for test: kms_flip
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_ccs
results: parsing output: 11/ for test: kms_lease
results: parsing output: 12/ for test: gem_exec_basic
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: kms_plane
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_rotation_crc
results: parsing output: 17/ for test: kms_tiled_display
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: perf_pmu
results: parsing output: 21/ for test: kms_cursor_edge_walk
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_softpin
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_exec_whisper
results: parsing output: 27/ for test: gem_exec_reloc
results: parsing output: 28/ for test: kms_async_flips
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_vm_create
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_cursor_legacy
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: kms_chamelium_audio
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_ccs
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_lease
results: parsing output: 39/ for test: kms_pm_rpm
results: parsing output: 40/ for test: gem_mmap_gtt
results: parsing output: 41/ for test: kms_plane_scaling
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: i915_drm_fdinfo
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_mmap_gtt
results: parsing output: 46/ for test: gem_lmem_evict
results: parsing output: 47/ for test: syncobj_wait
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: gem_exec_schedule
results: parsing output: 51/ for test: gem_render_copy
results: parsing output: 52/ for test: kms_flip_scaled_crc
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: core_auth
results: parsing output: 55/ for test: kms_hdmi_inject
results: parsing output: 56/ for test: gen3_mixed_blits
results: parsing output: 57/ for test: kms_prop_blob
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_rotation_crc
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_chamelium_edid
results: parsing output: 65/ for test: gem_render_copy
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_flip_scaled_crc
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: gem_mmap_wc
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_plane_multiple
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: i915_query
results: parsing output: 79/ for test: gem_exec_params
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: kms_addfb_basic
results: parsing output: 83/ for test: gem_ctx_freq
results: parsing output: 84/ for test: kms_content_protection
results: parsing output: 85/ for test: i915_pm_rpm
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: kms_psr2_sf
results: parsing output: 89/ for test: gem_exec_balancer
results: parsing output: 90/ for test: gem_fenced_exec_thrash
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: gem_render_copy
results: parsing output: 93/ for test: gem_ctx_persistence
results: parsing output: 94/ for test: gem_ctx_shared
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: kms_force_connector_basic
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: syncobj_wait
results: parsing output: 101/ for test: gem_exec_reloc
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_lmem_swapping
results: parsing output: 106/ for test: gem_mmap_gtt
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: gen9_exec_parse
results: parsing output: 111/ for test: kms_dsc
results: parsing output: 112/ for test: kms_invalid_mode
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: syncobj_basic
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_chamelium_hpd
results: parsing output: 117/ for test: kms_flip
results: parsing output: 118/ for test: gem_create
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_psr2_sf
results: parsing output: 122/ for test: kms_plane_scaling
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: i915_hangman
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_exec_fence
results: parsing output: 128/ for test: kms_cursor_legacy
results: parsing output: 129/ for test: perf_pmu
results: parsing output: 130/ for test: kms_psr
results: parsing output: 131/ for test: syncobj_wait
results: parsing output: 132/ for test: kms_addfb_basic
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: sw_sync
results: parsing output: 135/ for test: perf
results: parsing output: 136/ for test: gem_basic
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: kms_plane
results: parsing output: 139/ for test: prime_vgem
results: parsing output: 140/ for test: syncobj_wait
results: parsing output: 141/ for test: syncobj_timeline
results: parsing output: 142/ for test: gem_wait
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: device_reset
results: parsing output: 145/ for test: gem_render_copy
results: parsing output: 146/ for test: gem_userptr_blits
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_color
results: parsing output: 150/ for test: api_intel_bb
results: parsing output: 151/ for test: kms_addfb_basic
results: parsing output: 152/ for test: api_intel_allocator
results: parsing output: 153/ for test: kms_psr
results: parsing output: 154/ for test: kms_addfb_basic
results: parsing output: 155/ for test: syncobj_eventfd
Done.