[57.286253] Initializing watchdogs
[57.286300]   /dev/watchdog0
[57.300877] [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.305380] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.307735] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.311202] [001/132] (960s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[57.430999] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[57.433452] Starting dynamic subtest: pipe-A-eDP-1
[57.454664] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[57.463626] Starting dynamic subtest: pipe-B-eDP-1
[57.483727] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[57.490884] Starting dynamic subtest: pipe-C-eDP-1
[57.510425] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[57.518909] Starting dynamic subtest: pipe-D-eDP-1
[57.538388] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[57.540585] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[59.633589] [002/132] (958s left) perf_pmu (enable-race)
[59.676926] Starting subtest: enable-race
[59.679283] Starting dynamic subtest: rcs0
[72.445800] Dynamic subtest rcs0: SUCCESS (12.726s)
[72.454099] Starting dynamic subtest: bcs0
[85.191629] Dynamic subtest bcs0: SUCCESS (12.734s)
[85.198724] Starting dynamic subtest: vcs0
[100.888849] Dynamic subtest vcs0: SUCCESS (15.689s)
[100.898399] Starting dynamic subtest: vcs1
[116.890493] Dynamic subtest vcs1: SUCCESS (15.997s)
[116.900640] Starting dynamic subtest: vecs0
[132.888787] Dynamic subtest vecs0: SUCCESS (15.994s)
[132.898741] Starting dynamic subtest: ccs0
[145.633140] Dynamic subtest ccs0: SUCCESS (12.745s)
[145.635622] Subtest enable-race: SUCCESS (85.893s)
[145.730680] [003/132] (872s left) kms_frontbuffer_tracking (psr-suspend)
[145.849483] Starting subtest: psr-suspend
[183.878155] Subtest psr-suspend: SUCCESS (8.102s)
[183.988228] [004/132] (833s left) gem_exec_whisper (basic-fds-all)
[184.061702] Starting subtest: basic-fds-all
[195.751278] Subtest basic-fds-all: SUCCESS (11.490s)
[195.937855] [005/132] (822s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[196.032445] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[196.037056] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[196.104303] [006/132] (821s left) gem_ctx_param (non-root-set)
[196.157849] Starting subtest: non-root-set
[196.191042] Subtest non-root-set: SUCCESS (0.033s)
[196.310336] [007/132] (821s left) syncobj_timeline (invalid-query-illegal-handle)
[196.378748] Starting subtest: invalid-query-illegal-handle
[196.381276] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[196.493854] [008/132] (821s left) kms_cursor_edge_walk (128x128-top-edge)
[196.590181] Starting subtest: 128x128-top-edge
[196.592479] Starting dynamic subtest: pipe-A-eDP-1
[200.049654] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.441s)
[200.058260] Starting dynamic subtest: pipe-D-eDP-1
[203.193421] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.129s)
[203.195745] Subtest 128x128-top-edge: SUCCESS (6.572s)
[203.998812] [009/132] (814s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[204.095959] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[204.100364] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[204.196495] [010/132] (813s left) gem_ppgtt (blt-vs-render-ctx0)
[204.249453] Starting subtest: blt-vs-render-ctx0
[237.172760] Subtest blt-vs-render-ctx0: SUCCESS (32.918s)
[237.294455] [011/132] (780s left) i915_query (engine-info)
[237.388364] Starting subtest: engine-info
[237.390782] Subtest engine-info: SUCCESS (0.004s)
[237.501783] [012/132] (780s left) kms_psr (fbc-psr-primary-blt)
[237.614160] Starting subtest: fbc-psr-primary-blt
[237.616398] Starting dynamic subtest: eDP-1
[237.620635] Dynamic subtest eDP-1: SKIP (0.000s)
[237.624839] Subtest fbc-psr-primary-blt: SKIP (0.000s)
[237.691740] [013/132] (780s left) dumb_buffer (create-valid-dumb)
[237.746588] Starting subtest: create-valid-dumb
[237.748603] Subtest create-valid-dumb: SUCCESS (0.000s)
[237.838117] [014/132] (780s left) syncobj_wait (single-wait-for-submit-submitted)
[237.914197] Starting subtest: single-wait-for-submit-submitted
[238.019589] Subtest single-wait-for-submit-submitted: SUCCESS (0.105s)
[238.094184] [015/132] (780s left) kms_hdr (static-swap)
[238.201643] Starting subtest: static-swap
[238.208453] Subtest static-swap: SKIP (0.000s)
[238.274948] [016/132] (780s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[238.335987] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[238.443487] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.108s)
[238.528861] [017/132] (779s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[238.620628] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[245.696251] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.079s)
[245.823153] [018/132] (772s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[245.920928] Starting subtest: psr-modesetfrombusy
[252.054690] Subtest psr-modesetfrombusy: SUCCESS (6.136s)
[252.178081] [019/132] (766s left) gem_exec_params (cliprects_ptr-dirt)
[252.238675] Starting subtest: cliprects_ptr-dirt
[252.240445] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[252.328347] [020/132] (766s left) gem_exec_schedule (implicit-write-read)
[252.396309] Starting subtest: implicit-write-read
[252.398171] Starting dynamic subtest: rcs0
[252.498437] Dynamic subtest rcs0: SUCCESS (0.110s)
[252.509507] Starting dynamic subtest: vcs0
[252.578815] Dynamic subtest vcs0: SUCCESS (0.079s)
[252.590408] Starting dynamic subtest: vcs1
[252.658296] Dynamic subtest vcs1: SUCCESS (0.080s)
[252.670196] Starting dynamic subtest: vecs0
[252.743846] Dynamic subtest vecs0: SUCCESS (0.084s)
[252.754169] Starting dynamic subtest: ccs0
[252.822494] Dynamic subtest ccs0: SUCCESS (0.079s)
[252.824726] Subtest implicit-write-read: SUCCESS (0.434s)
[253.850325] [021/132] (764s left) kms_psr (psr2-sprite-mmap-gtt)
[253.948361] Starting subtest: psr2-sprite-mmap-gtt
[253.950822] Starting dynamic subtest: eDP-1
[255.340460] Dynamic subtest eDP-1: SKIP (1.390s)
[255.345380] Subtest psr2-sprite-mmap-gtt: SKIP (1.391s)
[255.498527] [022/132] (763s left) gem_exec_params (cliprects-invalid)
[255.551334] Starting subtest: cliprects-invalid
[255.553746] Subtest cliprects-invalid: SUCCESS (0.000s)
[255.642395] [023/132] (763s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[255.725374] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[255.727682] Starting dynamic subtest: pipe-A
[255.986089] Dynamic subtest pipe-A: SUCCESS (0.262s)
[255.994805] Starting dynamic subtest: pipe-B
[257.256621] Dynamic subtest pipe-B: SUCCESS (1.269s)
[257.266277] Starting dynamic subtest: pipe-C
[258.582324] Dynamic subtest pipe-C: SUCCESS (1.325s)
[258.593601] Starting dynamic subtest: pipe-D
[259.917220] Dynamic subtest pipe-D: SUCCESS (1.334s)
[259.919460] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.193s)
[261.117007] [024/132] (757s left) gem_lmem_swapping (heavy-verify-random-ccs)
[261.168877] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[261.214520] [025/132] (757s left) gem_userptr_blits (mmap-offset-banned)
[261.276836] Starting subtest: mmap-offset-banned
[261.279144] Starting dynamic subtest: wb
[261.281073] Dynamic subtest wb: SUCCESS (0.000s)
[261.291294] Starting dynamic subtest: wc
[261.293553] Dynamic subtest wc: SUCCESS (0.000s)
[261.302203] Starting dynamic subtest: uc
[261.304522] Dynamic subtest uc: SUCCESS (0.000s)
[261.306759] Subtest mmap-offset-banned: SUCCESS (0.002s)
[261.409615] [026/132] (757s left) kms_mmap_write_crc (main)
[261.510946] Starting subtest: main
[261.513596] Starting dynamic subtest: pipe-A-eDP-1
[265.067320] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.556s)
[265.069329] Subtest main: SUCCESS (3.557s)
[265.948852] [027/132] (752s left) perf_pmu (busy-accuracy-2)
[266.000258] Starting subtest: busy-accuracy-2
[266.002445] Starting dynamic subtest: rcs0
[269.038529] Dynamic subtest rcs0: SUCCESS (3.036s)
[269.048417] Starting dynamic subtest: bcs0
[272.095276] Dynamic subtest bcs0: SUCCESS (3.054s)
[272.104527] Starting dynamic subtest: vcs0
[275.137068] Dynamic subtest vcs0: SUCCESS (3.038s)
[275.146749] Starting dynamic subtest: vcs1
[278.183411] Dynamic subtest vcs1: SUCCESS (3.044s)
[278.194599] Starting dynamic subtest: vecs0
[281.228201] Dynamic subtest vecs0: SUCCESS (3.043s)
[281.238951] Starting dynamic subtest: ccs0
[284.285824] Dynamic subtest ccs0: SUCCESS (3.056s)
[284.288192] Subtest busy-accuracy-2: SUCCESS (18.284s)
[284.400690] [028/132] (734s left) prime_mmap (test_userptr)
[284.464636] Starting subtest: test_userptr
[284.466846] Starting dynamic subtest: test_userptr-smem
[284.468804] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[284.470706] Subtest test_userptr: SUCCESS (0.001s)
[284.555859] [029/132] (734s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[284.609776] Starting subtest: multi-wait-available-submitted-signaled
[284.612110] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s)
[284.706439] [030/132] (734s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[284.829139] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[292.168608] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.344s)
[292.295340] [031/132] (726s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[292.400146] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[292.402393] Starting dynamic subtest: pipe-A-eDP-1
[292.460792] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[292.469755] Starting dynamic subtest: pipe-B-eDP-1
[292.524265] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[292.536011] Starting dynamic subtest: pipe-C-eDP-1
[292.593053] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[292.603636] Starting dynamic subtest: pipe-D-eDP-1
[292.660428] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[292.664619] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.008s)
[294.573079] [032/132] (724s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[294.633955] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[294.708437] [033/132] (724s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[294.804873] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[301.384367] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.582s)
[301.494792] [034/132] (717s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[301.600620] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[301.604840] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[301.692749] [035/132] (717s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[301.800258] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[301.802577] Starting dynamic subtest: pipe-A-default-mode
[302.948064] Dynamic subtest pipe-A-default-mode: SKIP (1.145s)
[302.952151] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.146s)
[303.086930] [036/132] (716s left) gem_exec_fence (basic-busy-all)
[303.149350] Starting subtest: basic-busy-all
[303.239187] Subtest basic-busy-all: SUCCESS (0.090s)
[304.849758] [FACT gem_exec_fence (basic-busy-all)] new: kernel.kmod_is_loaded.vgem: true
[304.853151] [037/132] (714s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[304.952821] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[304.957137] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[305.053339] [038/132] (714s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[305.117978] Starting subtest: y-tiled-to-vebox-y-tiled
[305.122768] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[305.319765] [039/132] (714s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[305.424648] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[305.428767] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[305.513464] [040/132] (713s left) gem_busy (close-race)
[305.583749] Starting subtest: close-race
[328.711268] Subtest close-race: SUCCESS (23.124s)
[329.080981] [041/132] (690s left) gem_close (basic)
[329.198647] Starting subtest: basic
[329.200811] Subtest basic: SUCCESS (0.000s)
[329.300131] [042/132] (690s left) syncobj_timeline (wait-delayed-signal)
[329.358082] Starting subtest: wait-delayed-signal
[329.462547] Subtest wait-delayed-signal: SUCCESS (0.102s)
[329.556002] [043/132] (689s left) prime_vgem (basic-blt)
[329.632702] Starting subtest: basic-blt
[329.672019] Subtest basic-blt: SUCCESS (0.040s)
[329.812028] [044/132] (689s left) kms_psr (psr-sprite-mmap-gtt)
[329.912508] Starting subtest: psr-sprite-mmap-gtt
[329.914783] Starting dynamic subtest: eDP-1
[331.349595] Dynamic subtest eDP-1: SKIP (1.434s)
[331.354840] Subtest psr-sprite-mmap-gtt: SKIP (1.436s)
[331.541885] [045/132] (688s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[331.597739] Starting subtest: yf-tiled-ccs-to-x-tiled
[331.602379] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[331.795645] [046/132] (687s left) kms_color (ctm-red-to-blue)
[331.896669] Starting subtest: ctm-red-to-blue
[331.898828] Starting dynamic subtest: pipe-A-eDP-1
[332.618909] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.721s)
[332.628652] Starting dynamic subtest: pipe-B-eDP-1
[334.062297] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.442s)
[334.072418] Starting dynamic subtest: pipe-C-eDP-1
[335.437030] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.375s)
[335.447205] Starting dynamic subtest: pipe-D-eDP-1
[336.768104] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s)
[336.770339] Subtest ctm-red-to-blue: SUCCESS (4.872s)
[337.570015] [047/132] (682s left) kms_getfb (getfb-handle-closed)
[337.679628] Starting subtest: getfb-handle-closed
[337.681998] Subtest getfb-handle-closed: SUCCESS (0.000s)
[337.775840] [048/132] (681s left) kms_draw_crc (draw-method-mmap-wc)
[337.871646] Starting subtest: draw-method-mmap-wc
[337.873490] Starting dynamic subtest: xrgb8888-untiled
[338.137167] Dynamic subtest xrgb8888-untiled: SUCCESS (0.266s)
[338.146275] Starting dynamic subtest: rgb565-untiled
[338.359691] Dynamic subtest rgb565-untiled: SUCCESS (0.221s)
[338.371707] Starting dynamic subtest: xrgb2101010-untiled
[338.581365] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.220s)
[338.590857] Starting dynamic subtest: xbgr16161616f-untiled
[338.804050] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[338.822470] Starting dynamic subtest: xrgb8888-xtiled
[338.948034] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.142s)
[338.957135] Starting dynamic subtest: rgb565-xtiled
[339.081248] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[339.091326] Starting dynamic subtest: xrgb2101010-xtiled
[339.214836] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.132s)
[339.223554] Starting dynamic subtest: xbgr16161616f-xtiled
[339.348213] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[339.357841] Starting dynamic subtest: xrgb8888-4tiled
[339.514815] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.166s)
[339.526760] Starting dynamic subtest: rgb565-4tiled
[339.648356] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[339.657550] Starting dynamic subtest: xrgb2101010-4tiled
[339.803690] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.155s)
[339.812772] Starting dynamic subtest: xbgr16161616f-4tiled
[339.970544] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.166s)
[339.972428] Subtest draw-method-mmap-wc: SUCCESS (2.102s)
[340.090023] [049/132] (679s left) syncobj_wait (wait-for-submit-delayed-submit)
[340.142019] Starting subtest: wait-for-submit-delayed-submit
[340.242391] Subtest wait-for-submit-delayed-submit: SUCCESS (0.101s)
[340.318152] [050/132] (679s left) kms_cursor_crc (cursor-alpha-transparent)
[340.408631] Starting subtest: cursor-alpha-transparent
[340.410238] Starting dynamic subtest: pipe-A-eDP-1
[341.038265] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.627s)
[341.050820] Starting dynamic subtest: pipe-D-eDP-1
[342.334963] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.297s)
[342.337186] Subtest cursor-alpha-transparent: SUCCESS (1.927s)
[343.147174] [051/132] (676s left) gem_exec_fence (syncobj-timeline-wait)
[343.708145] Starting subtest: syncobj-timeline-wait
[344.791711] Subtest syncobj-timeline-wait: SUCCESS (1.083s)
[346.806102] [052/132] (673s left) kms_cursor_crc (cursor-random-512x170)
[347.137051] Starting subtest: cursor-random-512x170
[347.141368] Subtest cursor-random-512x170: SKIP (0.001s)
[347.286040] [053/132] (672s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[347.383086] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[347.387153] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[347.466315] [054/132] (672s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[347.531687] Starting subtest: invalid-smem-bo-on-discrete
[347.536238] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[347.673991] [055/132] (672s left) gem_exec_reloc (basic-cpu)
[347.731234] Subtest basic-cpu: SKIP (0.000s)
[347.802428] [056/132] (672s left) kms_universal_plane (universal-plane-pageflip-windowed)
[347.888239] Starting subtest: universal-plane-pageflip-windowed
[347.890177] Starting dynamic subtest: pipe-A-eDP-1
[348.485420] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.596s)
[348.496371] Starting dynamic subtest: pipe-B-eDP-1
[349.696836] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.209s)
[349.709689] Starting dynamic subtest: pipe-C-eDP-1
[350.898758] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.200s)
[350.908191] Starting dynamic subtest: pipe-D-eDP-1
[352.128130] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.229s)
[352.130533] Subtest universal-plane-pageflip-windowed: SUCCESS (4.239s)
[352.989332] [057/132] (667s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[353.083699] Starting subtest: fbcpsr-indfb-scaledprimary
[358.882947] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.801s)
[359.019535] [058/132] (661s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[359.089525] Starting subtest: single-wait-for-submit-unsubmitted
[359.196002] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[359.285335] [059/132] (660s left) gem_exec_params (sol-reset-not-gen7)
[359.342210] Starting subtest: sol-reset-not-gen7
[359.344545] Subtest sol-reset-not-gen7: SUCCESS (0.002s)
[359.464475] [060/132] (660s left) kms_content_protection (mei-interface)
[359.603347] Starting subtest: mei-interface
[359.607985] Subtest mei-interface: SKIP (0.001s)
[359.732062] [061/132] (660s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[359.825791] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[359.851877] Starting dynamic subtest: pipe-A-plane-0
[360.284545] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[360.293906] Starting dynamic subtest: pipe-A-plane-3
[360.551530] Dynamic subtest pipe-A-plane-3: SUCCESS (0.266s)
[360.562949] Starting dynamic subtest: pipe-A-plane-5
[360.566551] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[361.706386] Starting dynamic subtest: pipe-B-plane-0
[362.137932] Dynamic subtest pipe-B-plane-0: SUCCESS (0.444s)
[362.147674] Starting dynamic subtest: pipe-B-plane-3
[362.393298] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[362.405264] Starting dynamic subtest: pipe-B-plane-5
[362.409683] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[362.708898] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.882s)
[363.579067] [062/132] (656s left) gem_exec_gttfill (basic)
[363.643322] Starting subtest: basic
[366.729987] Subtest basic: SUCCESS (3.084s)
[366.923734] [063/132] (653s left) api_intel_bb (object-reloc-purge-cache)
[367.029277] Starting subtest: object-reloc-purge-cache
[367.033878] Subtest object-reloc-purge-cache: SKIP (0.005s)
[367.158090] [064/132] (653s left) kms_debugfs (display-on-read-all)
[367.257996] Starting subtest: display-on-read-all
[367.452832] Subtest display-on-read-all: SUCCESS (0.198s)
[367.577969] [065/132] (652s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[367.683892] Starting subtest: yf-tiled-32bpp-rotate-270
[367.688357] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[367.778664] [066/132] (652s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[367.886831] Starting subtest: extended-modeset-hang-newfb-with-reset
[367.888800] Starting dynamic subtest: pipe-A
[381.898025] Dynamic subtest pipe-A: SUCCESS (14.006s)
[381.908655] Starting dynamic subtest: pipe-D
[397.670080] Dynamic subtest pipe-D: SUCCESS (15.767s)
[397.672279] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (29.778s)
[398.472374] [067/132] (622s left) kms_flip (2x-flip-vs-suspend)
[398.573816] Starting subtest: 2x-flip-vs-suspend
[398.578077] Subtest 2x-flip-vs-suspend: SKIP (0.002s)
[398.683295] [068/132] (621s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[398.811816] Starting subtest: basic-flip-before-cursor-varying-size
[399.750153] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.937s)
[400.584593] [069/132] (620s left) kms_flip (2x-plain-flip-interruptible)
[400.685957] Starting subtest: 2x-plain-flip-interruptible
[400.698302] Subtest 2x-plain-flip-interruptible: SKIP (0.011s)
[400.778807] [070/132] (619s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[400.881717] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[401.994345] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.112s)
[402.116835] [071/132] (618s left) gem_userptr_blits (unsync-overlap)
[402.195302] Subtest unsync-overlap: SKIP (0.000s)
[402.311197] [072/132] (618s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[402.412377] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[402.416081] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[402.528007] [073/132] (618s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[402.619582] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[402.632055] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s)
[402.712512] [074/132] (618s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[402.767261] Subtest writes-after-reads-snoop: SKIP (0.000s)
[402.841662] [075/132] (618s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[402.944654] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[402.946519] Starting dynamic subtest: pipe-A-eDP-1
[403.094062] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.141s)
[403.105642] Starting dynamic subtest: pipe-B-eDP-1
[403.121947] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[403.132739] Starting dynamic subtest: pipe-C-eDP-1
[403.150088] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[403.159149] Starting dynamic subtest: pipe-D-eDP-1
[403.175140] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[403.176687] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.176s)
[405.341937] [076/132] (615s left) kms_psr (fbc-psr2-cursor-render)
[405.443978] Starting subtest: fbc-psr2-cursor-render
[405.445883] Starting dynamic subtest: eDP-1
[405.449871] Dynamic subtest eDP-1: SKIP (0.000s)
[405.453930] Subtest fbc-psr2-cursor-render: SKIP (0.001s)
[405.515667] [077/132] (615s left) perf_pmu (all-busy-idle-check-all)
[405.559473] Starting subtest: all-busy-idle-check-all
[406.791033] Subtest all-busy-idle-check-all: SUCCESS (1.230s)
[406.896449] [078/132] (614s left) kms_addfb_basic (small-bo)
[406.989504] Starting subtest: small-bo
[406.991724] Subtest small-bo: SUCCESS (0.000s)
[407.086581] [079/132] (613s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[407.188272] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[411.222260] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.038s)
[412.372196] [080/132] (608s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[412.473691] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[419.935696] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.469s)
[420.097170] [081/132] (601s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[420.201120] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[420.203525] Starting dynamic subtest: pipe-A-eDP-1
[420.288399] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[420.299011] Starting dynamic subtest: pipe-B-eDP-1
[421.473951] Dynamic subtest pipe-B-eDP-1: SKIP (1.183s)
[421.478199] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.275s)
[422.660991] [082/132] (598s left) kms_psr (pr-sprite-render)
[422.753197] Starting subtest: pr-sprite-render
[422.757708] Subtest pr-sprite-render: SKIP (0.000s)
[422.842092] [083/132] (598s left) gem_exec_balancer (waits)
[422.910264] Starting subtest: waits
[429.413628] Subtest waits: SUCCESS (6.502s)
[429.709691] [084/132] (591s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[429.848252] Starting subtest: cursorB-vs-flipB-toggle
[429.852844] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[429.997282] [085/132] (591s left) gem_exec_schedule (reorder-wide)
[430.195246] Subtest reorder-wide: SKIP (0.000s)
[430.377740] [086/132] (590s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[430.467768] Starting subtest: fbc-rgb101010-draw-pwrite
[435.821887] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.357s)
[436.941255] [087/132] (584s left) kms_setmode (clone-exclusive-crtc)
[437.010668] Starting subtest: clone-exclusive-crtc
[437.017210] Subtest clone-exclusive-crtc: SKIP (0.000s)
[437.124673] [088/132] (584s left) gem_softpin (evict-prime-sanity-check)
[437.191904] Starting subtest: evict-prime-sanity-check
[437.193894] Starting dynamic subtest: rcs0
[438.340143] Dynamic subtest rcs0: SUCCESS (1.152s)
[438.350011] Starting dynamic subtest: bcs0
[439.479477] Dynamic subtest bcs0: SUCCESS (1.138s)
[439.490326] Starting dynamic subtest: vcs0
[440.750438] Dynamic subtest vcs0: SUCCESS (1.268s)
[440.761336] Starting dynamic subtest: vcs1
[442.750995] Dynamic subtest vcs1: SUCCESS (1.998s)
[442.763741] Starting dynamic subtest: vecs0
[444.734603] Dynamic subtest vecs0: SUCCESS (1.981s)
[444.752277] Starting dynamic subtest: ccs0
[445.861363] Dynamic subtest ccs0: SUCCESS (1.126s)
[445.873555] Starting dynamic subtest: all
[446.991445] Dynamic subtest all: SUCCESS (1.127s)
[446.993946] Subtest evict-prime-sanity-check: SUCCESS (9.805s)
[447.072409] [089/132] (574s left) gem_lmem_swapping (verify-random-ccs)
[447.118884] Subtest verify-random-ccs: SKIP (0.000s)
[447.158067] [090/132] (574s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k)
[447.558633] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s)
[448.332605] [091/132] (573s left) gem_render_copy (linear)
[448.395196] Starting subtest: linear
[448.397513] Starting dynamic subtest: smem
[448.444634] Dynamic subtest smem: SUCCESS (0.049s)
[448.447051] Subtest linear: SUCCESS (0.049s)
[448.633866] [092/132] (572s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[448.754064] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[480.631649] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.876s)
[481.482435] [093/132] (540s left) kms_psr2_su (page_flip-p010)
[481.544711] Subtest page_flip-P010: SKIP (0.000s)
[481.610803] [094/132] (540s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[481.705867] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[485.862356] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.159s)
[487.009863] [095/132] (534s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[487.110643] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[487.114582] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[487.176905] [096/132] (534s left) gem_tiled_partial_pwrite_pread (reads)
[487.231340] Subtest reads: SKIP (0.000s)
[487.299429] [097/132] (534s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[487.401702] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[487.405665] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[487.490865] [098/132] (534s left) gen9_exec_parse (secure-batches)
[487.556807] Subtest secure-batches: SKIP (0.000s)
[487.628335] [099/132] (534s left) gem_exec_flush (basic-wb-rw-default)
[487.684872] Starting subtest: basic-wb-rw-default
[493.144681] Subtest basic-wb-rw-default: SUCCESS (5.460s)
[493.341377] [100/132] (528s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[493.388196] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[493.390647] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[493.474195] [101/132] (528s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[493.575198] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[493.579352] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[493.663521] [102/132] (528s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[494.045801] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[494.821092] [103/132] (527s left) api_intel_allocator (fork-simple-stress)
[494.868392] Starting subtest: fork-simple-stress
[500.267385] Subtest fork-simple-stress: SUCCESS (5.400s)
[500.392359] [104/132] (521s left) gem_ctx_persistence (engines-cleanup)
[500.450605] Starting subtest: engines-cleanup
[500.452915] Starting dynamic subtest: rcs0
[500.602712] Dynamic subtest rcs0: SUCCESS (0.151s)
[500.615491] Starting dynamic subtest: bcs0
[500.678835] Dynamic subtest bcs0: SUCCESS (0.073s)
[500.691079] Starting dynamic subtest: vcs0
[500.726886] Dynamic subtest vcs0: SUCCESS (0.046s)
[500.738794] Starting dynamic subtest: vcs1
[500.786463] Dynamic subtest vcs1: SUCCESS (0.057s)
[500.799512] Starting dynamic subtest: vecs0
[500.817604] Dynamic subtest vecs0: SUCCESS (0.029s)
[500.827517] Starting dynamic subtest: ccs0
[500.917762] Dynamic subtest ccs0: SUCCESS (0.099s)
[500.920173] Subtest engines-cleanup: SUCCESS (0.469s)
[501.003103] [105/132] (521s left) gem_mmap_wc (read-write-distinct)
[501.071254] Subtest read-write-distinct: SKIP (0.000s)
[501.147192] [106/132] (521s left) kms_vblank (wait-forked-busy-hang)
[501.242521] Starting subtest: wait-forked-busy-hang
[501.244797] Starting dynamic subtest: pipe-A-eDP-1
[527.555196] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.307s)
[527.571838] Starting dynamic subtest: pipe-D-eDP-1
[552.537432] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.977s)
[552.539836] Subtest wait-forked-busy-hang: SUCCESS (51.289s)
[553.419777] [107/132] (468s left) kms_big_fb (linear-32bpp-rotate-270)
[553.513658] Starting subtest: linear-32bpp-rotate-270
[553.536830] Subtest linear-32bpp-rotate-270: SKIP (0.022s)
[553.676818] [108/132] (468s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[553.791394] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[553.795540] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[553.904923] [109/132] (468s left) gem_mmap_offset (oob-read)
[553.960356] Starting subtest: oob-read
[553.962621] Subtest oob-read: SUCCESS (0.000s)
[554.053033] [110/132] (468s left) gem_ctx_persistence (legacy-engines-persistence)
[554.114470] Starting subtest: legacy-engines-persistence
[554.116790] Starting dynamic subtest: render
[554.883425] Dynamic subtest render: SUCCESS (0.768s)
[554.899249] Starting dynamic subtest: bsd1
[555.646270] Dynamic subtest bsd1: SUCCESS (0.759s)
[555.662885] Starting dynamic subtest: bsd2
[556.418588] Dynamic subtest bsd2: SUCCESS (0.769s)
[556.431206] Starting dynamic subtest: blt
[557.165834] Dynamic subtest blt: SUCCESS (0.744s)
[557.177716] Starting dynamic subtest: vebox
[557.952834] Dynamic subtest vebox: SUCCESS (0.785s)
[557.955656] Subtest legacy-engines-persistence: SUCCESS (3.839s)
[558.052093] [111/132] (464s left) kms_flip (flip-vs-panning-interruptible)
[558.150760] Starting subtest: flip-vs-panning-interruptible
[558.153101] Starting dynamic subtest: A-eDP1
[566.822992] Dynamic subtest A-eDP1: SUCCESS (8.669s)
[566.842841] Starting dynamic subtest: B-eDP1
[575.565029] Dynamic subtest B-eDP1: SUCCESS (8.738s)
[575.577643] Starting dynamic subtest: C-eDP1
[584.290878] Dynamic subtest C-eDP1: SUCCESS (8.723s)
[584.303105] Starting dynamic subtest: D-eDP1
[593.025422] Dynamic subtest D-eDP1: SUCCESS (8.731s)
[593.029519] Subtest flip-vs-panning-interruptible: SUCCESS (34.872s)
[594.200949] [112/132] (428s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[594.289210] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[594.293629] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[595.428583] [113/132] (427s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[595.540029] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[595.544485] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[595.639432] [114/132] (426s left) gen9_exec_parse (shadow-peek)
[595.698713] Subtest shadow-peek: SKIP (0.000s)
[595.784459] [115/132] (426s left) kms_pm_rpm (system-suspend-idle)
[597.933678] Starting subtest: system-suspend-idle
[617.889368] Subtest system-suspend-idle: SUCCESS (4.627s)
[618.302027] [116/132] (404s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[618.395415] Starting subtest: plane-downscale-factor-0-75-with-rotation
[618.397742] Starting dynamic subtest: pipe-A
[618.654082] Dynamic subtest pipe-A: SUCCESS (0.253s)
[618.665232] Starting dynamic subtest: pipe-B
[619.998466] Dynamic subtest pipe-B: SUCCESS (1.310s)
[620.028824] Starting dynamic subtest: pipe-C
[621.381587] Dynamic subtest pipe-C: SUCCESS (1.354s)
[621.394800] Starting dynamic subtest: pipe-D
[622.702050] Dynamic subtest pipe-D: SUCCESS (1.297s)
[622.704500] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.219s)
[623.907760] [117/132] (398s left) kms_atomic_interruptible (universal-setplane-cursor)
[624.000957] Starting subtest: universal-setplane-cursor
[624.003343] Starting dynamic subtest: pipe-A-eDP-1
[631.447600] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.383s)
[631.449913] Subtest universal-setplane-cursor: SUCCESS (7.384s)
[632.261259] [118/132] (390s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[632.353694] Starting subtest: x-tiled-64bpp-rotate-180
[633.918272] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.558s)
[634.087588] [119/132] (388s left) gem_userptr_blits (dmabuf-unsync)
[634.155953] Subtest dmabuf-unsync: SKIP (0.000s)
[634.294006] [120/132] (388s left) gem_barrier_race (remote-request)
[634.351307] Starting subtest: remote-request
[634.353134] Starting dynamic subtest: rcs0
[639.564083] Dynamic subtest rcs0: SUCCESS (5.199s)
[639.566586] Subtest remote-request: SUCCESS (5.200s)
[639.715439] [121/132] (383s left) kms_async_flips (invalid-async-flip)
[639.800646] Starting subtest: invalid-async-flip
[640.179897] Starting dynamic subtest: pipe-A-eDP-1
[640.995401] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.815s)
[641.356464] Starting dynamic subtest: pipe-B-eDP-1
[642.148068] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.798s)
[642.506031] Starting dynamic subtest: pipe-C-eDP-1
[643.352288] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.854s)
[643.710283] Starting dynamic subtest: pipe-D-eDP-1
[644.488257] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.787s)
[644.490572] Subtest invalid-async-flip: SUCCESS (4.682s)
[645.654552] [122/132] (377s left) syncobj_timeline (wait-all-snapshot)
[645.713160] Starting subtest: wait-all-snapshot
[645.793922] Subtest wait-all-snapshot: SUCCESS (0.081s)
[645.871532] [123/132] (377s left) gem_pxp (create-valid-protected-context)
[646.006579] Starting subtest: create-valid-protected-context
[646.008933] Subtest create-valid-protected-context: SUCCESS (0.002s)
[646.125594] [124/132] (376s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[646.222662] Starting subtest: yf-tiled-8bpp-rotate-90
[646.226919] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[646.331216] [125/132] (376s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[646.858018] Starting subtest: syncobj-timeline-invalid-wait
[646.860226] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s)
[648.093342] [126/132] (374s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[648.198289] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[648.200552] Starting dynamic subtest: pipe-A-eDP-1
[648.226914] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[648.239060] Starting dynamic subtest: pipe-B-eDP-1
[648.261815] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[648.271756] Starting dynamic subtest: pipe-C-eDP-1
[648.297294] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[648.308968] Starting dynamic subtest: pipe-D-eDP-1
[648.330595] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[648.334875] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s)
[650.497382] [127/132] (372s left) i915_hangman (error-state-basic)
[650.564013] Starting subtest: error-state-basic
[650.720382] Subtest error-state-basic: SUCCESS (0.157s)
[650.804956] [128/132] (372s left) kms_getfb (getfb-reject-nv12)
[650.895557] Starting subtest: getfb-reject-nv12
[650.897854] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[651.008956] [129/132] (372s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[653.132688] Starting subtest: dpms-mode-unset-non-lpsp
[654.292360] Subtest dpms-mode-unset-non-lpsp: SKIP (1.155s)
[654.682462] [130/132] (368s left) i915_pm_rps (min-max-config-idle)
[654.740267] Starting subtest: min-max-config-idle
[654.744330] Subtest min-max-config-idle: SKIP (0.001s)
[654.841110] [131/132] (368s left) gem_exec_balancer (bonded-chain)
[654.904395] Starting subtest: bonded-chain
[661.981946] Subtest bonded-chain: SUCCESS (7.076s)
[662.308149] [132/132] (361s left) gem_ctx_exec (basic-close-race)
[662.370555] Starting subtest: basic-close-race
[668.193298] Subtest basic-close-race: SUCCESS (5.821s)
[668.321283] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: perf_pmu
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_exec_whisper
results: parsing output: 4/ for test: kms_plane
results: parsing output: 5/ for test: gem_ctx_param
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: kms_cursor_edge_walk
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_ppgtt
results: parsing output: 10/ for test: i915_query
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: dumb_buffer
results: parsing output: 13/ for test: syncobj_wait
results: parsing output: 14/ for test: kms_hdr
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gem_exec_params
results: parsing output: 19/ for test: gem_exec_schedule
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: gem_exec_params
results: parsing output: 22/ for test: kms_plane_scaling
results: parsing output: 23/ for test: gem_lmem_swapping
results: parsing output: 24/ for test: gem_userptr_blits
results: parsing output: 25/ for test: kms_mmap_write_crc
results: parsing output: 26/ for test: perf_pmu
results: parsing output: 27/ for test: prime_mmap
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_ccs
results: parsing output: 31/ for test: gem_fenced_exec_thrash
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_flip_scaled_crc
results: parsing output: 35/ for test: gem_exec_fence
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_render_copy
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_busy
results: parsing output: 40/ for test: gem_close
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: prime_vgem
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: gem_render_copy
results: parsing output: 45/ for test: kms_color
results: parsing output: 46/ for test: kms_getfb
results: parsing output: 47/ for test: kms_draw_crc
results: parsing output: 48/ for test: syncobj_wait
results: parsing output: 49/ for test: kms_cursor_crc
results: parsing output: 50/ for test: gem_exec_fence
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_addfb_basic
results: parsing output: 54/ for test: gem_exec_reloc
results: parsing output: 55/ for test: kms_universal_plane
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: syncobj_wait
results: parsing output: 58/ for test: gem_exec_params
results: parsing output: 59/ for test: kms_content_protection
results: parsing output: 60/ for test: kms_plane
results: parsing output: 61/ for test: gem_exec_gttfill
results: parsing output: 62/ for test: api_intel_bb
results: parsing output: 63/ for test: kms_debugfs
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: kms_busy
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: kms_flip
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: gem_userptr_blits
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: kms_flip
results: parsing output: 73/ for test: gem_partial_pwrite_pread
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: perf_pmu
results: parsing output: 77/ for test: kms_addfb_basic
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_psr2_sf
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: gem_exec_balancer
results: parsing output: 83/ for test: kms_cursor_legacy
results: parsing output: 84/ for test: gem_exec_schedule
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_setmode
results: parsing output: 87/ for test: gem_softpin
results: parsing output: 88/ for test: gem_lmem_swapping
results: parsing output: 89/ for test: kms_chamelium_edid
results: parsing output: 90/ for test: gem_render_copy
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: kms_psr2_su
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_joiner
results: parsing output: 95/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gen9_exec_parse
results: parsing output: 98/ for test: gem_exec_flush
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: kms_psr2_sf
results: parsing output: 101/ for test: kms_chamelium_hpd
results: parsing output: 102/ for test: api_intel_allocator
results: parsing output: 103/ for test: gem_ctx_persistence
results: parsing output: 104/ for test: gem_mmap_wc
results: parsing output: 105/ for test: kms_vblank
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_mmap_offset
results: parsing output: 109/ for test: gem_ctx_persistence
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: kms_ccs
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gen9_exec_parse
results: parsing output: 114/ for test: kms_pm_rpm
results: parsing output: 115/ for test: kms_plane_scaling
results: parsing output: 116/ for test: kms_atomic_interruptible
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: gem_userptr_blits
results: parsing output: 119/ for test: gem_barrier_race
results: parsing output: 120/ for test: kms_async_flips
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: gem_pxp
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: gem_exec_fence
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: i915_hangman
results: parsing output: 127/ for test: kms_getfb
results: parsing output: 128/ for test: kms_pm_rpm
results: parsing output: 129/ for test: i915_pm_rps
results: parsing output: 130/ for test: gem_exec_balancer
results: parsing output: 131/ for test: gem_ctx_exec
Done.