[57.174514] Initializing watchdogs
[57.174559]   /dev/watchdog0
[57.189382] [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.193964] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.196769] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.200161] [001/156] (960s left) gem_eio (execbuf)
[57.371055] Starting subtest: execbuf
[57.538749] Subtest execbuf: SUCCESS (0.166s)
[57.668512] [002/156] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[57.775555] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[57.779746] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[57.861364] [003/156] (959s left) gem_mmap_gtt (basic-read)
[57.922330] Subtest basic-read: SKIP (0.000s)
[57.985663] [004/156] (959s left) i915_hangman (engine-engine-hang)
[58.048694] Starting subtest: engine-engine-hang
[58.050636] Starting dynamic subtest: rcs0
[59.296457] Dynamic subtest rcs0: SUCCESS (1.238s)
[59.312381] Starting dynamic subtest: bcs0
[61.279615] Dynamic subtest bcs0: SUCCESS (1.972s)
[61.289587] Starting dynamic subtest: vcs0
[63.262999] Dynamic subtest vcs0: SUCCESS (1.974s)
[63.273292] Starting dynamic subtest: vcs1
[65.247217] Dynamic subtest vcs1: SUCCESS (1.976s)
[65.257479] Starting dynamic subtest: vecs0
[67.295817] Dynamic subtest vecs0: SUCCESS (2.043s)
[67.306085] Starting dynamic subtest: ccs0
[69.278564] Dynamic subtest ccs0: SUCCESS (1.978s)
[69.281781] Subtest engine-engine-hang: SUCCESS (11.189s)
[69.359409] [005/156] (948s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[69.465329] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[74.204397] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (4.740s)
[74.313621] [006/156] (943s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[74.423377] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[78.931160] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.511s)
[80.109283] [007/156] (937s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[80.206691] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[80.209076] Starting dynamic subtest: pipe-A-default-mode
[82.937840] Dynamic subtest pipe-A-default-mode: SUCCESS (2.729s)
[82.940412] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.730s)
[83.785949] [008/156] (934s left) gem_exec_parallel (engines)
[83.853371] Starting subtest: engines
[83.855598] Starting dynamic subtest: basic
[87.299227] Dynamic subtest basic: SUCCESS (3.443s)
[87.308518] Starting dynamic subtest: contexts
[91.749531] Dynamic subtest contexts: SUCCESS (4.448s)
[91.761047] Starting dynamic subtest: fds
[95.512749] Dynamic subtest fds: SUCCESS (3.762s)
[95.521751] Starting dynamic subtest: userptr
[97.300359] Dynamic subtest userptr: SUCCESS (1.787s)
[97.302934] Subtest engines: SUCCESS (13.444s)
[97.490584] [009/156] (920s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[97.554820] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[97.559474] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[97.748197] [010/156] (920s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-pwrite)
[97.859649] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-pwrite
[97.863768] Subtest hdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[97.955258] [011/156] (920s left) gem_exec_balancer (parallel-keep-in-fence)
[98.212343] Starting subtest: parallel-keep-in-fence
[99.375867] Subtest parallel-keep-in-fence: SUCCESS (1.164s)
[99.494217] [012/156] (918s left) kms_prime (d3hot)
[99.576628] Subtest D3hot: SKIP (0.000s)
[99.739721] [FACT kms_prime (d3hot)] new: kernel.kmod_is_loaded.vgem: true
[99.742929] [013/156] (918s left) gem_ppgtt (shrink-vs-evict-any)
[99.802178] Starting subtest: shrink-vs-evict-any
[105.237077] Subtest shrink-vs-evict-any: SUCCESS (5.432s)
[105.328487] [014/156] (912s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-move)
[105.426120] Starting subtest: fbchdr-1p-primscrn-cur-indfb-move
[105.430674] Subtest fbchdr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[105.525407] [015/156] (912s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[105.624449] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[114.980324] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.360s)
[115.105633] [016/156] (903s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[115.202963] Starting subtest: y-tiled-8bpp-rotate-0
[115.207450] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[115.298060] [017/156] (903s left) vgem_basic (busy-fence)
[115.340919] Starting subtest: busy-fence
[115.342742] Subtest busy-fence: SUCCESS (0.000s)
[115.407246] [018/156] (902s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[115.498372] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[115.500677] Starting dynamic subtest: pipe-A-eDP-1
[115.525674] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[115.534410] Starting dynamic subtest: pipe-B-eDP-1
[115.557632] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[115.565850] Starting dynamic subtest: pipe-C-eDP-1
[115.589801] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[115.597996] Starting dynamic subtest: pipe-D-eDP-1
[115.621782] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[115.626099] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[117.793684] [019/156] (900s left) kms_cursor_crc (cursor-sliding-128x42)
[118.018415] Starting subtest: cursor-sliding-128x42
[118.067209] Subtest cursor-sliding-128x42: SKIP (0.043s)
[118.293482] [020/156] (900s left) syncobj_timeline (multi-wait-all-signaled)
[118.344955] Starting subtest: multi-wait-all-signaled
[118.347092] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[118.438192] [021/156] (900s left) gem_partial_pwrite_pread (write-display)
[118.492676] Subtest write-display: SKIP (0.000s)
[118.557339] [022/156] (899s left) perf (global-sseu-config-invalid)
[118.679778] Starting subtest: global-sseu-config-invalid
[118.683744] Subtest global-sseu-config-invalid: SKIP (0.000s)
[118.724376] [023/156] (899s left) kms_dp_link_training (non-uhbr-mst)
[118.821735] Starting subtest: non-uhbr-mst
[118.828660] Subtest non-uhbr-mst: SKIP (0.000s)
[118.891760] [024/156] (899s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[118.984454] Starting subtest: fbc-psr-sprite-mmap-gtt
[118.986118] Starting dynamic subtest: eDP-1
[118.989654] Dynamic subtest eDP-1: SKIP (0.000s)
[118.993161] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.000s)
[119.054851] [025/156] (899s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[119.102493] Starting subtest: etime-multi-wait-all-submitted-signaled
[119.211772] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.108s)
[119.297763] [026/156] (899s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[119.421878] Starting subtest: short-flip-after-cursor-atomic-transitions
[120.412458] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.989s)
[121.222219] [027/156] (897s left) dmabuf (all-tests)
[121.257646] Starting subtest: all-tests
[121.261980] Subtest all-tests: SKIP (0.000s)
[121.307493] [028/156] (897s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[121.415300] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[128.381749] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.972s)
[128.536985] [029/156] (890s left) gem_eio (in-flight-internal-10ms)
[128.761485] Starting subtest: in-flight-internal-10ms
[130.388596] Subtest in-flight-internal-10ms: SUCCESS (1.626s)
[130.522329] [030/156] (888s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[130.911300] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[131.770085] [031/156] (887s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[131.861626] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-wc
[131.866098] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[131.985179] [032/156] (886s left) gem_exec_whisper (basic-queues-forked-all)
[132.041081] Starting subtest: basic-queues-forked-all
[153.632750] Subtest basic-queues-forked-all: SUCCESS (21.591s)
[153.816696] [033/156] (865s left) kms_frontbuffer_tracking (psr-slowdraw)
[153.934335] Starting subtest: psr-slowdraw
[179.265182] Subtest psr-slowdraw: SUCCESS (25.337s)
[179.392380] [034/156] (839s left) kms_frontbuffer_tracking (fbchdr-2p-indfb-fliptrack-mmap-gtt)
[179.498517] Starting subtest: fbchdr-2p-indfb-fliptrack-mmap-gtt
[179.502850] Subtest fbchdr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[179.615211] [035/156] (839s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[179.730847] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[187.120113] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.395s)
[187.281333] [036/156] (831s left) gen7_exec_parse (basic-rejected)
[187.341207] Subtest basic-rejected: SKIP (0.000s)
[187.413170] [037/156] (831s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[187.514730] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[187.519263] Subtest hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[187.633473] [038/156] (831s left) gem_exec_schedule (preempt)
[187.708195] Starting subtest: preempt
[187.710169] Starting dynamic subtest: rcs0
[187.727860] Dynamic subtest rcs0: SUCCESS (0.023s)
[187.736691] Starting dynamic subtest: bcs0
[187.751323] Dynamic subtest bcs0: SUCCESS (0.024s)
[187.759897] Starting dynamic subtest: vcs0
[187.772646] Dynamic subtest vcs0: SUCCESS (0.021s)
[187.781697] Starting dynamic subtest: vcs1
[187.793699] Dynamic subtest vcs1: SUCCESS (0.021s)
[187.802549] Starting dynamic subtest: vecs0
[187.815256] Dynamic subtest vecs0: SUCCESS (0.021s)
[187.825847] Starting dynamic subtest: ccs0
[187.842256] Dynamic subtest ccs0: SUCCESS (0.026s)
[187.844460] Subtest preempt: SUCCESS (0.139s)
[189.397074] [039/156] (829s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-onoff)
[189.503804] Starting subtest: psrhdr-1p-primscrn-spr-indfb-onoff
[189.508237] Subtest psrhdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[189.591781] [040/156] (829s left) vgem_basic (unload)
[189.628595] Starting subtest: unload
[218.678901] Subtest unload: SUCCESS (29.049s)
[218.777346] [041/156] (800s left) gem_fence_thrash (bo-write-verify-y)
[218.811401] Starting subtest: bo-write-verify-y
[218.831504] Subtest bo-write-verify-y: SKIP (0.017s)
[218.891306] [042/156] (800s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[218.991935] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[222.647956] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.662s)
[223.863347] [043/156] (795s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[223.957708] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[223.962125] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[224.061798] [044/156] (795s left) gem_ctx_param (invalid-get-ringsize)
[224.105621] Starting subtest: invalid-get-ringsize
[224.108029] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[224.203020] [045/156] (795s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[224.310318] Starting subtest: cursorB-vs-flipA-atomic-transitions
[224.315328] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[224.453773] [046/156] (795s left) kms_invalid_mode (zero-hdisplay)
[224.550341] Starting subtest: zero-hdisplay
[224.552838] Starting dynamic subtest: pipe-A-eDP-1
[224.840743] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s)
[224.850726] Starting dynamic subtest: pipe-B-eDP-1
[224.853037] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[224.861783] Starting dynamic subtest: pipe-C-eDP-1
[224.864076] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[224.872671] Starting dynamic subtest: pipe-D-eDP-1
[224.875077] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[224.877321] Subtest zero-hdisplay: SUCCESS (0.298s)
[225.676381] [047/156] (793s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[225.772353] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[233.106282] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.338s)
[233.229924] [048/156] (786s left) kms_flip (nonblocking-read)
[233.324579] Starting subtest: nonblocking-read
[233.326524] Subtest nonblocking-read: SUCCESS (0.000s)
[233.427731] [049/156] (786s left) kms_vblank (wait-idle)
[233.511095] Starting subtest: wait-idle
[233.512987] Starting dynamic subtest: pipe-A-eDP-1
[235.268988] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.757s)
[235.282774] Starting dynamic subtest: pipe-D-eDP-1
[237.726365] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.457s)
[237.728900] Subtest wait-idle: SUCCESS (4.217s)
[238.544209] [050/156] (781s left) gem_spin_batch (legacy-resubmit-new)
[238.601676] Starting subtest: legacy-resubmit-new
[238.604153] Starting dynamic subtest: default
[238.609387] Dynamic subtest default: SUCCESS (0.006s)
[238.620363] Starting dynamic subtest: render
[238.622658] Dynamic subtest render: SUCCESS (0.003s)
[238.631745] Starting dynamic subtest: bsd
[238.633915] Dynamic subtest bsd: SUCCESS (0.005s)
[238.643100] Starting dynamic subtest: bsd1
[238.645399] Dynamic subtest bsd1: SUCCESS (0.002s)
[238.654121] Starting dynamic subtest: bsd2
[238.656186] Dynamic subtest bsd2: SUCCESS (0.006s)
[238.664832] Starting dynamic subtest: blt
[238.667117] Dynamic subtest blt: SUCCESS (0.007s)
[238.676582] Starting dynamic subtest: vebox
[238.678857] Dynamic subtest vebox: SUCCESS (0.005s)
[238.681199] Subtest legacy-resubmit-new: SUCCESS (0.041s)
[240.357952] [051/156] (779s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-linear)
[240.469402] Starting subtest: fbcpsrhdr-tiling-linear
[240.473975] Subtest fbcpsrhdr-tiling-linear: SKIP (0.000s)
[240.561258] [052/156] (779s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[240.665753] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[240.669828] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[240.756406] [053/156] (779s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[240.849214] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[240.853317] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[240.949303] [054/156] (778s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[241.047399] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[241.051830] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[241.173485] [055/156] (778s left) kms_flip (2x-flip-vs-suspend)
[241.258482] Starting subtest: 2x-flip-vs-suspend
[241.262958] Subtest 2x-flip-vs-suspend: SKIP (0.002s)
[241.363859] [056/156] (778s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[241.477559] Starting subtest: cursorA-vs-flipA-atomic-transitions
[252.653994] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.174s)
[253.483192] [057/156] (766s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[253.584181] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[253.586447] Starting dynamic subtest: pipe-A
[253.919717] Dynamic subtest pipe-A: SUCCESS (0.337s)
[253.928767] Starting dynamic subtest: pipe-B
[255.377332] Dynamic subtest pipe-B: SUCCESS (1.456s)
[255.386321] Starting dynamic subtest: pipe-C
[256.808747] Dynamic subtest pipe-C: SUCCESS (1.430s)
[256.818020] Starting dynamic subtest: pipe-D
[258.242808] Dynamic subtest pipe-D: SUCCESS (1.433s)
[258.245136] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.661s)
[259.423973] [058/156] (760s left) gem_render_copy (y-tiled-ccs-to-linear)
[259.488587] Starting subtest: y-tiled-ccs-to-linear
[259.493589] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[259.683037] [059/156] (760s left) gem_linear_blits (interruptible)
[260.085549] Starting subtest: interruptible
[264.612611] Subtest interruptible: SUCCESS (4.526s)
[264.758816] [060/156] (755s left) gem_mmap_offset (bad-extensions)
[264.850804] Starting subtest: bad-extensions
[264.853252] Subtest bad-extensions: SUCCESS (0.000s)
[264.951874] [061/156] (755s left) kms_psr (psr-dpms)
[265.062609] Starting subtest: psr-dpms
[265.064766] Starting dynamic subtest: eDP-1
[268.046734] Dynamic subtest eDP-1: SUCCESS (2.983s)
[268.049303] Subtest psr-dpms: SUCCESS (2.985s)
[268.896611] [062/156] (751s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[268.990243] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[268.992534] Starting dynamic subtest: pipe-A-eDP-1
[269.016031] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[269.030682] Starting dynamic subtest: pipe-B-eDP-1
[269.052776] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[269.061828] Starting dynamic subtest: pipe-C-eDP-1
[269.083215] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[269.092161] Starting dynamic subtest: pipe-D-eDP-1
[269.114296] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[269.118284] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[271.262636] [063/156] (748s left) kms_psr (pr-no-drrs)
[271.351149] Starting subtest: pr-no-drrs
[271.355261] Subtest pr-no-drrs: SKIP (0.000s)
[271.457795] [064/156] (748s left) gem_exec_create (madvise)
[271.526226] Starting subtest: madvise
[271.528673] Starting dynamic subtest: smem
[291.678114] Dynamic subtest smem: SUCCESS (20.150s)
[291.685035] Subtest madvise: SUCCESS (20.151s)
[292.443209] [065/156] (727s left) kms_content_protection (mei-interface)
[292.580925] Starting subtest: mei-interface
[292.591845] Subtest mei-interface: SKIP (0.009s)
[292.713940] [066/156] (727s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[292.815158] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[292.819400] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[292.898757] [067/156] (727s left) perf_pmu (most-busy-idle-check-all)
[292.938172] Starting subtest: most-busy-idle-check-all
[292.940608] Starting dynamic subtest: rcs0
[294.272107] Dynamic subtest rcs0: SUCCESS (1.333s)
[294.284989] Starting dynamic subtest: bcs0
[296.319654] Dynamic subtest bcs0: SUCCESS (2.045s)
[296.333909] Starting dynamic subtest: vcs0
[298.304817] Dynamic subtest vcs0: SUCCESS (1.981s)
[298.318357] Starting dynamic subtest: vcs1
[300.288457] Dynamic subtest vcs1: SUCCESS (1.981s)
[300.301389] Starting dynamic subtest: vecs0
[302.272746] Dynamic subtest vecs0: SUCCESS (1.981s)
[302.285798] Starting dynamic subtest: ccs0
[304.320218] Dynamic subtest ccs0: SUCCESS (2.044s)
[304.323095] Subtest most-busy-idle-check-all: SUCCESS (11.382s)
[304.418352] [068/156] (716s left) i915_pm_rpm (gem-evict-pwrite)
[306.484091] Starting subtest: gem-evict-pwrite
[306.489067] Subtest gem-evict-pwrite: SKIP (0.000s)
[306.885434] [069/156] (713s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-render)
[306.987476] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-render
[306.992234] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[307.089166] [070/156] (713s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-render)
[307.199522] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-render
[307.203686] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[307.319123] [071/156] (713s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[307.424619] Starting subtest: 4-tiled-32bpp-rotate-90
[307.444380] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[307.548514] [072/156] (713s left) syncobj_timeline (signal)
[307.607825] Starting subtest: signal
[307.610258] Subtest signal: SUCCESS (0.000s)
[307.700398] [073/156] (712s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[307.791874] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[308.859277] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.067s)
[309.007979] [074/156] (711s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[309.133055] Starting subtest: cursorB-vs-flipB-atomic-transitions
[309.136998] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[309.287321] [075/156] (711s left) gem_exec_flush (basic-batch-kernel-default-uc)
[309.348251] Starting subtest: basic-batch-kernel-default-uc
[316.383066] Subtest basic-batch-kernel-default-uc: SUCCESS (7.034s)
[316.577134] [076/156] (704s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[316.705421] Starting subtest: fbc-rgb101010-draw-mmap-wc
[319.179919] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (2.480s)
[320.301598] [077/156] (700s left) syncobj_wait (multi-wait-for-submit-signaled)
[320.366820] Starting subtest: multi-wait-for-submit-signaled
[320.369199] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[320.466195] [078/156] (700s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[320.519806] Starting subtest: invalid-bsd2-flag-on-vebox
[320.522174] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[320.631677] [079/156] (700s left) i915_pm_sseu (full-enable)
[320.693800] Subtest full-enable: SKIP (0.000s)
[320.800602] [080/156] (700s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[320.905053] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc
[320.909141] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[321.011894] [081/156] (699s left) kms_sequence (get-forked-busy)
[321.102202] Starting subtest: get-forked-busy
[321.104483] Starting dynamic subtest: pipe-A-eDP-1
[323.023788] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.923s)
[323.034770] Starting dynamic subtest: pipe-B-eDP-1
[325.604482] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.579s)
[325.615256] Starting dynamic subtest: pipe-C-eDP-1
[328.239714] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.634s)
[328.249507] Starting dynamic subtest: pipe-D-eDP-1
[330.860954] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.618s)
[330.862985] Subtest get-forked-busy: SUCCESS (9.759s)
[331.744712] [082/156] (689s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[331.847242] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[331.849670] Starting dynamic subtest: pipe-A-eDP-1
[331.931501] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[331.941803] Starting dynamic subtest: pipe-B-eDP-1
[333.125843] Dynamic subtest pipe-B-eDP-1: SKIP (1.194s)
[333.130539] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.285s)
[334.320319] [083/156] (686s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[334.374913] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[334.476053] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.101s)
[334.552221] [084/156] (686s left) kms_flip (blocking-absolute-wf_vblank)
[334.644621] Starting subtest: blocking-absolute-wf_vblank
[334.646547] Starting dynamic subtest: A-eDP1
[343.383769] Dynamic subtest A-eDP1: SUCCESS (8.740s)
[343.400389] Starting dynamic subtest: B-eDP1
[352.124212] Dynamic subtest B-eDP1: SUCCESS (8.737s)
[352.136092] Starting dynamic subtest: C-eDP1
[360.833730] Dynamic subtest C-eDP1: SUCCESS (8.707s)
[360.845187] Starting dynamic subtest: D-eDP1
[369.570084] Dynamic subtest D-eDP1: SUCCESS (8.735s)
[369.575039] Subtest blocking-absolute-wf_vblank: SUCCESS (34.932s)
[370.794621] [085/156] (650s left) gem_exec_schedule (u-submit-early-slice)
[370.864312] Starting subtest: u-submit-early-slice
[370.866591] Starting dynamic subtest: rcs0
[370.897363] Dynamic subtest rcs0: SUCCESS (0.041s)
[370.909371] Starting dynamic subtest: bcs0
[370.940998] Dynamic subtest bcs0: SUCCESS (0.041s)
[370.955638] Starting dynamic subtest: vcs0
[370.983071] Dynamic subtest vcs0: SUCCESS (0.042s)
[370.995845] Starting dynamic subtest: vcs1
[371.032809] Dynamic subtest vcs1: SUCCESS (0.047s)
[371.044505] Starting dynamic subtest: vecs0
[371.073953] Dynamic subtest vecs0: SUCCESS (0.041s)
[371.087172] Starting dynamic subtest: ccs0
[371.115224] Dynamic subtest ccs0: SUCCESS (0.040s)
[371.117612] Subtest u-submit-early-slice: SUCCESS (0.259s)
[372.378641] [086/156] (648s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[372.467097] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[372.469382] Starting dynamic subtest: pipe-A-eDP-1
[372.526096] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.061s)
[372.535872] Starting dynamic subtest: pipe-B-eDP-1
[372.586449] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.058s)
[372.596524] Starting dynamic subtest: pipe-C-eDP-1
[372.648103] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.062s)
[372.657758] Starting dynamic subtest: pipe-D-eDP-1
[372.713276] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.064s)
[372.715382] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.250s)
[374.949208] [087/156] (646s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[374.998044] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[375.100557] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.101s)
[375.176723] [088/156] (646s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[375.753085] Starting subtest: syncobj-timeline-invalid-wait
[375.755528] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s)
[377.358300] [089/156] (643s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[377.467662] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[377.475774] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.010s)
[377.554166] [090/156] (643s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[377.619529] Starting subtest: yf-tiled-ccs-to-yf-tiled
[377.623436] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[377.830672] [091/156] (643s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[377.928395] Starting subtest: x-tiled-8bpp-rotate-0
[379.174983] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.248s)
[379.288919] [092/156] (642s left) gem_ctx_persistence (many-contexts)
[379.344881] Starting subtest: many-contexts
[424.536040] Subtest many-contexts: SUCCESS (45.191s)
[424.628326] [093/156] (596s left) kms_lease (possible-crtcs-filtering)
[424.729545] Starting subtest: possible-crtcs-filtering
[424.731534] Subtest possible-crtcs-filtering: SUCCESS (0.005s)
[424.832773] [094/156] (596s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[424.947792] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt
[424.952244] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[425.061134] [095/156] (596s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[425.441791] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[426.253148] [096/156] (595s left) syncobj_wait (wait-any-snapshot)
[426.299713] Starting subtest: wait-any-snapshot
[426.383414] Subtest wait-any-snapshot: SUCCESS (0.083s)
[426.463408] [097/156] (595s left) core_getstats (basic)
[426.537248] Starting subtest: basic
[426.539966] Subtest basic: SUCCESS (0.000s)
[426.644721] [098/156] (595s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[426.730085] Starting subtest: crc-primary-basic-y-tiled-ccs
[426.732370] Starting dynamic subtest: pipe-A-eDP-1
[426.754635] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[426.767730] Starting dynamic subtest: pipe-B-eDP-1
[426.789291] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[426.799080] Starting dynamic subtest: pipe-C-eDP-1
[426.820782] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[426.830079] Starting dynamic subtest: pipe-D-eDP-1
[426.852147] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[426.856287] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.005s)
[429.038887] [099/156] (592s left) gem_userptr_blits (sd-probe)
[429.104291] Starting subtest: sd-probe
[429.106224] Subtest sd-probe: SUCCESS (0.000s)
[429.220388] [100/156] (592s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[429.324441] Starting subtest: psr-rgb565-draw-pwrite
[436.329651] Subtest psr-rgb565-draw-pwrite: SUCCESS (7.008s)
[436.457036] [101/156] (585s left) gem_exec_balancer (fairslice)
[436.512421] Starting subtest: fairslice
[439.429506] Subtest fairslice: SUCCESS (2.915s)
[439.754086] [102/156] (582s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-rte)
[439.851739] Starting subtest: fbcpsrhdr-2p-rte
[439.855823] Subtest fbcpsrhdr-2p-rte: SKIP (0.000s)
[439.954941] [103/156] (581s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[440.046730] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[444.038062] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (3.996s)
[445.174665] [104/156] (576s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[445.281791] Starting subtest: cursor-tearing-framebuffer-change
[445.283845] Starting dynamic subtest: pipe-A-eDP-1
[445.844020] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s)
[445.854929] Starting dynamic subtest: pipe-D-eDP-1
[447.106532] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.259s)
[447.108818] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.827s)
[447.953495] [105/156] (574s left) gem_exec_fence (basic-busy-all)
[448.005723] Starting subtest: basic-busy-all
[448.099961] Subtest basic-busy-all: SUCCESS (0.094s)
[450.382497] [106/156] (571s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[450.470157] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[450.472444] Starting dynamic subtest: pipe-A-eDP-1
[450.495388] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[450.507094] Starting dynamic subtest: pipe-B-eDP-1
[450.528642] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[450.538121] Starting dynamic subtest: pipe-C-eDP-1
[450.559792] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[450.569123] Starting dynamic subtest: pipe-D-eDP-1
[450.591189] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[450.595557] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[452.805326] [107/156] (569s left) gem_exec_whisper (basic-queues-all)
[452.873734] Starting subtest: basic-queues-all
[463.807342] Subtest basic-queues-all: SUCCESS (10.933s)
[463.994124] [108/156] (558s left) syncobj_wait (multi-wait-signaled)
[464.056447] Starting subtest: multi-wait-signaled
[464.058852] Subtest multi-wait-signaled: SUCCESS (0.000s)
[464.155109] [109/156] (558s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[464.258597] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[464.262876] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[464.334162] [110/156] (557s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[464.400549] Starting subtest: y-tiled-ccs-to-x-tiled
[464.405455] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[464.610329] [111/156] (557s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[464.701182] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[464.705327] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[464.793842] [112/156] (557s left) kms_plane_multiple (2x-tiling-none)
[464.888292] Starting subtest: 2x-tiling-none
[464.892410] Subtest 2x-tiling-none: SKIP (0.000s)
[464.973169] [113/156] (557s left) kms_pm_rpm (basic-rte)
[465.007865] Starting subtest: basic-rte
[467.978426] Subtest basic-rte: SUCCESS (2.970s)
[469.493021] [114/156] (552s left) gem_close_race (multigpu-basic-threads)
[469.552486] Starting subtest: multigpu-basic-threads
[469.556791] Subtest multigpu-basic-threads: SKIP (0.000s)
[469.788529] [115/156] (552s left) gem_ccs (block-multicopy-inplace)
[469.848820] Starting subtest: block-multicopy-inplace
[469.852959] Subtest block-multicopy-inplace: SKIP (0.000s)
[469.943427] [116/156] (552s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite)
[470.033581] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite
[470.037739] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[470.137823] [117/156] (552s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-onoff)
[470.237580] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-onoff
[470.241459] Subtest psrhdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[470.346379] [118/156] (552s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[470.439097] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[470.441346] Starting dynamic subtest: pipe-A-eDP-1
[471.383498] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.938s)
[471.396714] Starting dynamic subtest: pipe-B-eDP-1
[472.990622] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.604s)
[473.000659] Starting dynamic subtest: pipe-C-eDP-1
[474.498940] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.505s)
[474.509925] Starting dynamic subtest: pipe-D-eDP-1
[476.034318] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.535s)
[476.036228] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.588s)
[477.235211] [119/156] (545s left) gem_ctx_shared (q-out-order)
[477.303459] Starting subtest: Q-out-order
[477.305900] Starting dynamic subtest: rcs0
[477.404610] Dynamic subtest rcs0: SUCCESS (0.100s)
[477.423870] Starting dynamic subtest: vcs0
[477.488656] Dynamic subtest vcs0: SUCCESS (0.083s)
[477.507320] Starting dynamic subtest: vcs1
[477.568629] Dynamic subtest vcs1: SUCCESS (0.078s)
[477.585638] Starting dynamic subtest: vecs0
[477.648508] Dynamic subtest vecs0: SUCCESS (0.079s)
[477.665038] Starting dynamic subtest: ccs0
[477.741345] Dynamic subtest ccs0: SUCCESS (0.092s)
[477.743887] Subtest Q-out-order: SUCCESS (0.437s)
[479.399562] [120/156] (543s left) i915_drm_fdinfo (memory-info-active)
[479.440149] Starting subtest: memory-info-active
[479.442430] Starting dynamic subtest: smem0
[482.307441] Dynamic subtest smem0: SUCCESS (2.868s)
[482.309742] Subtest memory-info-active: SUCCESS (2.869s)
[482.398678] [121/156] (540s left) syncobj_timeline (single-wait-available-signaled)
[482.446686] Starting subtest: single-wait-available-signaled
[482.448587] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[482.543411] [122/156] (540s left) kms_psr (fbc-psr2-dpms)
[482.632922] Starting subtest: fbc-psr2-dpms
[482.634891] Starting dynamic subtest: eDP-1
[482.638335] Dynamic subtest eDP-1: SKIP (0.000s)
[482.641824] Subtest fbc-psr2-dpms: SKIP (0.001s)
[482.718127] [123/156] (540s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-render)
[482.817541] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-render
[482.820918] Subtest fbchdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[482.913763] [124/156] (539s left) kms_feature_discovery (chamelium)
[483.017338] Starting subtest: chamelium
[483.020913] Subtest chamelium: SKIP (0.000s)
[483.093244] [125/156] (539s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[483.190979] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[483.194505] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[483.280805] [126/156] (539s left) gem_partial_pwrite_pread (writes-after-reads-display)
[483.340868] Subtest writes-after-reads-display: SKIP (0.000s)
[483.425012] [127/156] (539s left) prime_mmap (test_correct_cpu_write)
[483.488992] Starting subtest: test_correct_cpu_write
[483.490996] Starting dynamic subtest: test_correct_cpu_write-smem
[483.492821] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[483.494663] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[483.589168] [128/156] (539s left) perf (rc6-disable)
[483.683928] Starting subtest: rc6-disable
[483.856595] Subtest rc6-disable: SUCCESS (0.175s)
[483.910467] [129/156] (539s left) kms_cursor_crc (cursor-dpms)
[484.045417] Starting subtest: cursor-dpms
[484.047413] Starting dynamic subtest: pipe-A-eDP-1
[487.092949] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.046s)
[487.103356] Starting dynamic subtest: pipe-D-eDP-1
[490.753673] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.656s)
[490.755831] Subtest cursor-dpms: SUCCESS (6.705s)
[491.609462] [130/156] (531s left) prime_busy (before)
[491.671884] Starting subtest: before
[491.674205] Starting dynamic subtest: rcs0
[491.705912] Dynamic subtest rcs0: SUCCESS (0.033s)
[491.718894] Starting dynamic subtest: bcs0
[491.763211] Dynamic subtest bcs0: SUCCESS (0.057s)
[491.772766] Starting dynamic subtest: vcs0
[491.803811] Dynamic subtest vcs0: SUCCESS (0.038s)
[491.815557] Starting dynamic subtest: vcs1
[491.845537] Dynamic subtest vcs1: SUCCESS (0.042s)
[491.858688] Starting dynamic subtest: vecs0
[491.886683] Dynamic subtest vecs0: SUCCESS (0.040s)
[491.897264] Starting dynamic subtest: ccs0
[491.927229] Dynamic subtest ccs0: SUCCESS (0.040s)
[492.036755] Subtest before: SUCCESS (0.365s)
[492.125110] [131/156] (530s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-pgflip-blt)
[492.234643] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-pgflip-blt
[492.238666] Subtest fbcpsrhdr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[492.336591] [132/156] (530s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[492.444784] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[493.268952] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.826s)
[493.443046] [133/156] (529s left) kms_rotation_crc (multiplane-rotation)
[493.542376] Starting subtest: multiplane-rotation
[511.144124] Subtest multiplane-rotation: SUCCESS (17.604s)
[511.274423] [134/156] (511s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[511.385242] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu
[511.388527] Subtest psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[511.494038] [135/156] (511s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[511.599180] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[511.601075] Starting dynamic subtest: pipe-A-eDP-1
[518.234114] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.637s)
[518.245612] Starting dynamic subtest: pipe-B-eDP-1
[525.293753] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.060s)
[525.296101] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.699s)
[526.170328] [136/156] (497s left) kms_color (deep-color)
[526.264881] Starting subtest: deep-color
[527.344629] Starting dynamic subtest: pipe-A-eDP-1-gamma
[528.064941] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.722s)
[528.075693] Starting dynamic subtest: pipe-A-eDP-1-degamma
[529.536612] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.472s)
[529.547826] Starting dynamic subtest: pipe-A-eDP-1-ctm
[530.968358] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.430s)
[531.756571] Starting dynamic subtest: pipe-B-eDP-1-gamma
[532.455298] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.710s)
[532.465502] Starting dynamic subtest: pipe-B-eDP-1-degamma
[533.938209] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.479s)
[533.949278] Starting dynamic subtest: pipe-B-eDP-1-ctm
[535.350976] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.415s)
[536.133431] Starting dynamic subtest: pipe-C-eDP-1-gamma
[536.815291] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.692s)
[536.827030] Starting dynamic subtest: pipe-C-eDP-1-degamma
[538.306870] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.488s)
[538.316974] Starting dynamic subtest: pipe-C-eDP-1-ctm
[539.703951] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.397s)
[540.520084] Starting dynamic subtest: pipe-D-eDP-1-gamma
[541.207842] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.692s)
[541.218775] Starting dynamic subtest: pipe-D-eDP-1-degamma
[542.684737] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.477s)
[542.696918] Starting dynamic subtest: pipe-D-eDP-1-ctm
[544.094679] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.411s)
[544.097140] Subtest deep-color: SUCCESS (17.832s)
[544.965920] [137/156] (478s left) kms_flip (basic-flip-vs-modeset)
[545.069917] Starting subtest: basic-flip-vs-modeset
[545.072409] Starting dynamic subtest: A-eDP1
[547.654280] Dynamic subtest A-eDP1: SUCCESS (2.585s)
[547.669256] Starting dynamic subtest: B-eDP1
[549.811936] Dynamic subtest B-eDP1: SUCCESS (2.155s)
[549.822593] Starting dynamic subtest: C-eDP1
[551.983845] Dynamic subtest C-eDP1: SUCCESS (2.171s)
[551.996871] Starting dynamic subtest: D-eDP1
[554.162829] Dynamic subtest D-eDP1: SUCCESS (2.178s)
[554.164762] Subtest basic-flip-vs-modeset: SUCCESS (9.096s)
[554.973924] [138/156] (468s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[555.084388] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[555.088845] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[555.182524] [139/156] (468s left) prime_vgem (basic-read)
[555.262367] Starting subtest: basic-read
[555.278748] Subtest basic-read: SKIP (0.014s)
[555.413579] [140/156] (468s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[555.502983] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[555.594429] [141/156] (467s left) gem_readwrite (beyond-eob)
[555.661609] Subtest beyond-EOB: SKIP (0.000s)
[555.731621] [142/156] (467s left) kms_plane (plane-panning-bottom-right)
[555.830290] Starting subtest: plane-panning-bottom-right
[555.832603] Starting dynamic subtest: pipe-A
[557.537283] Dynamic subtest pipe-A: SUCCESS (1.707s)
[557.548560] Starting dynamic subtest: pipe-B
[560.028072] Dynamic subtest pipe-B: SUCCESS (2.490s)
[560.030513] Subtest plane-panning-bottom-right: SUCCESS (4.200s)
[560.901294] [143/156] (462s left) kms_async_flips (test-cursor)
[560.999358] Starting subtest: test-cursor
[561.373213] Starting dynamic subtest: pipe-A-eDP-1
[562.196797] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.826s)
[562.590294] Starting dynamic subtest: pipe-B-eDP-1
[563.342915] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.762s)
[563.733062] Starting dynamic subtest: pipe-C-eDP-1
[564.476754] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.752s)
[564.845614] Starting dynamic subtest: pipe-D-eDP-1
[565.605021] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.769s)
[565.607246] Subtest test-cursor: SUCCESS (4.606s)
[566.779735] [144/156] (456s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[566.881724] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[566.886140] Subtest hdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[566.985857] [145/156] (456s left) kms_pipe_crc_basic (nonblocking-crc)
[567.081299] Starting subtest: nonblocking-crc
[567.083222] Starting dynamic subtest: pipe-A-eDP-1
[567.825547] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.744s)
[567.837670] Starting dynamic subtest: pipe-B-eDP-1
[569.331908] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.504s)
[569.345781] Starting dynamic subtest: pipe-C-eDP-1
[570.686794] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.353s)
[570.698429] Starting dynamic subtest: pipe-D-eDP-1
[572.098579] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.410s)
[572.100749] Subtest nonblocking-crc: SUCCESS (5.017s)
[572.913881] [146/156] (450s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[573.009895] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[579.766539] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.761s)
[579.913240] [147/156] (443s left) kms_fbcon_fbt (psr-suspend)
[579.965048] Starting subtest: psr-suspend
[629.941293] Subtest psr-suspend: SUCCESS (19.896s)
[630.021273] [148/156] (393s left) kms_addfb_basic (too-wide)
[630.126284] Starting subtest: too-wide
[630.128553] Subtest too-wide: SUCCESS (0.000s)
[630.256488] [149/156] (393s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[630.358916] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[630.361206] Starting dynamic subtest: pipe-A
[631.582065] Dynamic subtest pipe-A: SUCCESS (1.218s)
[631.592807] Starting dynamic subtest: pipe-B
[633.856542] Dynamic subtest pipe-B: SUCCESS (2.261s)
[633.870644] Starting dynamic subtest: pipe-C
[635.075940] Dynamic subtest pipe-C: SUCCESS (1.211s)
[635.090105] Starting dynamic subtest: pipe-D
[636.308108] Dynamic subtest pipe-D: SUCCESS (1.227s)
[636.310388] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.921s)
[637.495402] [150/156] (386s left) api_intel_allocator (reopen)
[637.545663] Starting subtest: reopen
[637.547983] Subtest reopen: SUCCESS (0.004s)
[637.672865] [151/156] (386s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[637.779416] Starting subtest: psr-1p-pri-indfb-multidraw
[660.898257] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (23.097s)
[661.013654] [152/156] (362s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-pwrite)
[661.113104] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-pwrite
[661.116513] Subtest hdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[661.237579] [153/156] (362s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[661.324340] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[661.328060] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[661.418802] [154/156] (362s left) gem_mmap_gtt (close-race)
[661.463267] Subtest close-race: SKIP (0.000s)
[661.531332] [155/156] (362s left) gem_ctx_param (set-priority-invalid-size)
[661.581127] Starting subtest: set-priority-invalid-size
[661.583264] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[661.656716] [156/156] (362s left) kms_invalid_mode (bad-hsync-end)
[661.746734] Starting subtest: bad-hsync-end
[661.748697] Starting dynamic subtest: pipe-A-eDP-1
[662.044486] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.297s)
[662.055843] Starting dynamic subtest: pipe-B-eDP-1
[662.058109] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[662.068654] Starting dynamic subtest: pipe-C-eDP-1
[662.071032] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[662.082198] Starting dynamic subtest: pipe-D-eDP-1
[662.084475] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[662.086652] Subtest bad-hsync-end: SUCCESS (0.304s)
[662.886086] Closing watchdogs
results: parsing output: 0/ for test: gem_eio
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_mmap_gtt
results: parsing output: 3/ for test: i915_hangman
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_flip_scaled_crc
results: parsing output: 7/ for test: gem_exec_parallel
results: parsing output: 8/ for test: gem_render_copy
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_exec_balancer
results: parsing output: 11/ for test: kms_prime
results: parsing output: 12/ for test: gem_ppgtt
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: vgem_basic
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: kms_cursor_crc
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: gem_partial_pwrite_pread
results: parsing output: 21/ for test: perf
results: parsing output: 22/ for test: kms_dp_link_training
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: kms_cursor_legacy
results: parsing output: 26/ for test: dmabuf
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_eio
results: parsing output: 29/ for test: kms_chamelium_edid
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_exec_whisper
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gen7_exec_parse
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_exec_schedule
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: vgem_basic
results: parsing output: 40/ for test: gem_fence_thrash
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_ctx_param
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: kms_invalid_mode
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: kms_vblank
results: parsing output: 49/ for test: gem_spin_batch
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_flip
results: parsing output: 55/ for test: kms_cursor_legacy
results: parsing output: 56/ for test: kms_plane_scaling
results: parsing output: 57/ for test: gem_render_copy
results: parsing output: 58/ for test: gem_linear_blits
results: parsing output: 59/ for test: gem_mmap_offset
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: gem_exec_create
results: parsing output: 64/ for test: kms_content_protection
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: perf_pmu
results: parsing output: 67/ for test: i915_pm_rpm
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_cursor_legacy
results: parsing output: 74/ for test: gem_exec_flush
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: syncobj_wait
results: parsing output: 77/ for test: gem_exec_params
results: parsing output: 78/ for test: i915_pm_sseu
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_sequence
results: parsing output: 81/ for test: kms_psr2_sf
results: parsing output: 82/ for test: syncobj_wait
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: gem_exec_schedule
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: gem_exec_fence
results: parsing output: 88/ for test: kms_flip
results: parsing output: 89/ for test: gem_render_copy
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: gem_ctx_persistence
results: parsing output: 92/ for test: kms_lease
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_chamelium_hpd
results: parsing output: 95/ for test: syncobj_wait
results: parsing output: 96/ for test: core_getstats
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: gem_userptr_blits
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_exec_balancer
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_cursor_crc
results: parsing output: 104/ for test: gem_exec_fence
results: parsing output: 105/ for test: kms_ccs
results: parsing output: 106/ for test: gem_exec_whisper
results: parsing output: 107/ for test: syncobj_wait
results: parsing output: 108/ for test: kms_psr2_sf
results: parsing output: 109/ for test: gem_render_copy
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_plane_multiple
results: parsing output: 112/ for test: kms_pm_rpm
results: parsing output: 113/ for test: gem_close_race
results: parsing output: 114/ for test: gem_ccs
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: gem_ctx_shared
results: parsing output: 119/ for test: i915_drm_fdinfo
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_feature_discovery
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_partial_pwrite_pread
results: parsing output: 126/ for test: prime_mmap
results: parsing output: 127/ for test: perf
results: parsing output: 128/ for test: kms_cursor_crc
results: parsing output: 129/ for test: prime_busy
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: kms_rotation_crc
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: kms_psr2_sf
results: parsing output: 135/ for test: kms_color
results: parsing output: 136/ for test: kms_flip
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: prime_vgem
results: parsing output: 139/ for test: kms_addfb_basic
results: parsing output: 140/ for test: gem_readwrite
results: parsing output: 141/ for test: kms_plane
results: parsing output: 142/ for test: kms_async_flips
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: kms_pipe_crc_basic
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: kms_fbcon_fbt
results: parsing output: 147/ for test: kms_addfb_basic
results: parsing output: 148/ for test: kms_plane_scaling
results: parsing output: 149/ for test: api_intel_allocator
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: kms_big_fb
results: parsing output: 153/ for test: gem_mmap_gtt
results: parsing output: 154/ for test: gem_ctx_param
results: parsing output: 155/ for test: kms_invalid_mode
Done.