[39.187857] Initializing watchdogs
[39.188132]   /dev/watchdog0
[39.221309] [001/142] (960s left) syncobj_timeline (invalid-wait-illegal-handle)
[39.495214] Starting subtest: invalid-wait-illegal-handle
[39.515664] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[39.613691] [002/142] (960s left) gem_render_copy (x-tiled)
[39.846670] Starting subtest: x-tiled
[39.867716] Starting dynamic subtest: smem
[40.154795] Dynamic subtest smem: SUCCESS (0.321s)
[40.173626] Subtest x-tiled: SUCCESS (0.322s)
[40.375931] [003/142] (959s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[40.674710] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[40.693651] Starting dynamic subtest: pipe-A-valid-mode
[41.382673] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.695s)
[41.404237] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (0.697s)
[41.719480] [004/142] (958s left) gem_mmap_gtt (basic-wc)
[41.955629] Starting subtest: basic-wc
[42.550633] Subtest basic-wc: SUCCESS (0.631s)
[42.674453] [005/142] (957s left) gem_close (basic)
[42.912682] Starting subtest: basic
[42.931304] Subtest basic: SUCCESS (0.000s)
[43.045420] [006/142] (957s left) kms_pm_backlight (fade)
[43.410700] Subtest fade: SKIP (0.000s)
[43.552765] [007/142] (956s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[43.980628] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[44.025678] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[44.122561] [008/142] (956s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[44.368865] Starting subtest: invalid-smem-bo-on-discrete
[44.406774] Subtest invalid-smem-bo-on-discrete: SKIP (0.001s)
[44.599741] [009/142] (955s left) gem_exec_fence (submit3)
[44.992950] Starting subtest: submit3
[45.016137] Starting dynamic subtest: rcs0
[45.037385] Dynamic subtest rcs0: SUCCESS (0.025s)
[45.082247] Starting dynamic subtest: bcs0
[45.103364] Dynamic subtest bcs0: SUCCESS (0.022s)
[45.136479] Starting dynamic subtest: vcs0
[45.156916] Dynamic subtest vcs0: SUCCESS (0.018s)
[45.189282] Starting dynamic subtest: vecs0
[45.208223] Dynamic subtest vecs0: SUCCESS (0.017s)
[45.227237] Subtest submit3: SUCCESS (0.084s)
[45.908755] [010/142] (954s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[46.279977] Starting subtest: psr-indfb-scaledprimary
[46.322297] Subtest psr-indfb-scaledprimary: SKIP (0.000s)
[46.404254] [011/142] (954s left) gem_exec_nop (basic-parallel)
[46.800460] Starting subtest: basic-parallel
[49.792892] Subtest basic-parallel: SUCCESS (3.155s)
[50.040943] [012/142] (950s left) kms_ccs (pipe-c-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc)
[50.554334] Starting subtest: pipe-C-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc
[50.596262] Subtest pipe-C-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[50.915096] [013/142] (949s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_ccs)
[51.358525] Starting subtest: pipe-B-crc-primary-basic-y_tiled_ccs
[52.300142] Subtest pipe-B-crc-primary-basic-y_tiled_ccs: SUCCESS (0.932s)
[52.837578] [014/142] (947s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[53.202848] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[54.630380] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.465s)
[54.871620] [015/142] (946s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[55.302089] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[55.342166] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[55.428830] [016/142] (945s left) gen9_exec_parse (batch-without-end)
[55.659774] Starting subtest: batch-without-end
[55.680285] Subtest batch-without-end: SUCCESS (0.003s)
[55.888719] [017/142] (945s left) v3d/v3d_get_param (base-params)
[56.169468] Subtest base-params: SKIP (0.000s)
[56.260555] [018/142] (944s left) kms_ccs (pipe-a-bad-aux-stride-4_tiled_mtl_rc_ccs_cc)
[56.716880] Starting subtest: pipe-A-bad-aux-stride-4_tiled_mtl_rc_ccs_cc
[56.755246] Subtest pipe-A-bad-aux-stride-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[57.141923] [019/142] (944s left) vc4/vc4_tiling (set-get)
[57.422172] Subtest set-get: SKIP (0.000s)
[57.502644] [020/142] (943s left) v3d/v3d_wait_bo (used-bo)
[57.773665] Subtest used-bo: SKIP (0.000s)
[57.860504] [021/142] (943s left) gem_exec_reloc (basic-write-read-noreloc)
[58.101341] Starting subtest: basic-write-read-noreloc
[58.122962] Subtest basic-write-read-noreloc: SUCCESS (0.006s)
[58.294873] [022/142] (943s left) gem_ctx_param (invalid-set-ringsize)
[58.517664] Starting subtest: invalid-set-ringsize
[58.540698] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[58.628120] [023/142] (942s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[58.982687] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[61.198756] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (2.293s)
[61.362056] [024/142] (940s left) sw_sync (sync_busy_fork_unixsocket)
[61.584125] Starting subtest: sync_busy_fork_unixsocket
[61.605385] Subtest sync_busy_fork_unixsocket: SUCCESS (0.035s)
[61.691725] [025/142] (940s left) gem_ctx_shared (q-independent)
[61.926828] Starting subtest: Q-independent
[61.947071] Starting dynamic subtest: rcs0
[61.995616] Dynamic subtest rcs0: SUCCESS (0.081s)
[62.029050] Starting dynamic subtest: bcs0
[62.077525] Dynamic subtest bcs0: SUCCESS (0.079s)
[62.113971] Starting dynamic subtest: vcs0
[62.155610] Dynamic subtest vcs0: SUCCESS (0.060s)
[62.188556] Starting dynamic subtest: vecs0
[62.207406] Dynamic subtest vecs0: SUCCESS (0.058s)
[62.226197] Subtest Q-independent: SUCCESS (0.280s)
[62.443701] [026/142] (939s left) kms_ccs (pipe-a-crc-primary-rotation-180-yf_tiled_ccs)
[62.835854] Starting subtest: pipe-A-crc-primary-rotation-180-yf_tiled_ccs
[63.476062] Subtest pipe-A-crc-primary-rotation-180-yf_tiled_ccs: SUCCESS (0.638s)
[64.071434] [027/142] (937s left) gem_pread (exhaustion)
[64.537378] Starting subtest: exhaustion
[80.551853] Subtest exhaustion: SUCCESS (16.071s)
[80.674801] [028/142] (921s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[81.019690] Starting subtest: y-tiled-8bpp-rotate-90
[81.123124] Subtest y-tiled-8bpp-rotate-90: SKIP (0.083s)
[81.225830] [029/142] (920s left) prime_mmap (test_forked)
[81.486655] Starting subtest: test_forked
[81.505537] Starting dynamic subtest: test_forked-smem
[81.524237] Dynamic subtest test_forked-smem: SUCCESS (0.041s)
[81.544395] Subtest test_forked: SUCCESS (0.041s)
[81.632089] [030/142] (920s left) kms_flip (absolute-wf_vblank-interruptible)
[81.945722] Starting subtest: absolute-wf_vblank-interruptible
[81.964622] Starting dynamic subtest: A-DP1
[92.447092] Dynamic subtest A-DP1: SUCCESS (10.520s)
[92.479946] Starting dynamic subtest: B-DP1
[103.210755] Dynamic subtest B-DP1: SUCCESS (10.591s)
[103.259434] Starting dynamic subtest: C-DP1
[113.657351] Dynamic subtest C-DP1: SUCCESS (10.445s)
[113.679184] Subtest absolute-wf_vblank-interruptible: SUCCESS (31.562s)
[113.922036] [031/142] (888s left) kms_chamelium_hpd (vga-hpd)
[114.352796] Subtest vga-hpd: SKIP (0.000s)
[114.649895] [032/142] (887s left) kms_getfb (getfb2-handle-zero)
[114.885968] Starting subtest: getfb2-handle-zero
[114.906846] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[114.989609] [033/142] (887s left) kms_cursor_crc (cursor-random-64x64)
[115.313164] Starting subtest: cursor-random-64x64
[115.334546] Starting dynamic subtest: pipe-A-DP-1
[119.137734] Dynamic subtest pipe-A-DP-1: SUCCESS (3.815s)
[119.218043] Starting dynamic subtest: pipe-C-DP-1
[123.115881] Dynamic subtest pipe-C-DP-1: SUCCESS (3.912s)
[123.134821] Subtest cursor-random-64x64: SUCCESS (7.802s)
[123.470234] [034/142] (879s left) kms_ccs (pipe-d-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs)
[124.026129] Subtest pipe-D-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[124.346450] [035/142] (878s left) kms_ccs (pipe-c-bad-rotation-90-y_tiled_gen12_rc_ccs)
[124.832783] Starting subtest: pipe-C-bad-rotation-90-y_tiled_gen12_rc_ccs
[124.869949] Subtest pipe-C-bad-rotation-90-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[125.220576] [036/142] (877s left) gem_eio (banned)
[125.497724] Starting subtest: banned
[125.645149] Subtest banned: SUCCESS (0.156s)
[125.837712] [037/142] (876s left) kms_ccs (pipe-b-bad-pixel-format-y_tiled_gen12_mc_ccs)
[126.268101] Starting subtest: pipe-B-bad-pixel-format-y_tiled_gen12_mc_ccs
[126.309404] Subtest pipe-B-bad-pixel-format-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[126.691495] [038/142] (876s left) vc4/vc4_lookup_fail (bad-color-write)
[126.971927] Subtest bad-color-write: SKIP (0.000s)
[127.053143] [039/142] (875s left) kms_async_flips (test-cursor)
[127.349424] Starting subtest: test-cursor
[127.512420] Starting dynamic subtest: pipe-A-DP-1
[127.855780] Dynamic subtest pipe-A-DP-1: SUCCESS (0.337s)
[128.059688] Starting dynamic subtest: pipe-B-DP-1
[128.304912] Dynamic subtest pipe-B-DP-1: SUCCESS (0.261s)
[128.530849] Starting dynamic subtest: pipe-C-DP-1
[128.783281] Dynamic subtest pipe-C-DP-1: SUCCESS (0.291s)
[128.808739] Subtest test-cursor: SUCCESS (1.427s)
[129.301045] [040/142] (873s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[129.704058] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[129.751334] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[129.863856] [041/142] (873s left) gem_exec_reloc (basic-scanout)
[130.185115] Starting subtest: basic-scanout
[130.203808] Starting dynamic subtest: rcs0
[130.483180] Dynamic subtest rcs0: SUCCESS (0.261s)
[130.516764] Starting dynamic subtest: bcs0
[130.654282] Dynamic subtest bcs0: SUCCESS (0.168s)
[130.688179] Starting dynamic subtest: vcs0
[130.818904] Dynamic subtest vcs0: SUCCESS (0.164s)
[130.854472] Starting dynamic subtest: vecs0
[130.987806] Dynamic subtest vecs0: SUCCESS (0.166s)
[131.008370] Subtest basic-scanout: SUCCESS (0.761s)
[131.092694] [042/142] (872s left) kms_psr (psr2_primary_mmap_gtt)
[131.351286] Subtest psr2_primary_mmap_gtt: SKIP (0.000s)
[131.431512] [043/142] (871s left) gem_pread (display)
[131.652375] Starting subtest: display
[136.274326] Subtest display: SUCCESS (4.460s)
[136.359872] [044/142] (867s left) api_intel_allocator (open-vm)
[136.595536] Starting subtest: open-vm
[136.616078] Subtest open-vm: SUCCESS (0.004s)
[136.697173] [045/142] (866s left) template (b)
[136.929680] Starting subtest: B
[136.948711] Subtest B: SUCCESS (0.000s)
[137.032760] [046/142] (866s left) gem_exec_parallel (userptr)
[137.265515] Starting subtest: userptr
[137.284496] Starting dynamic subtest: rcs0
[140.735977] Dynamic subtest rcs0: SUCCESS (3.293s)
[140.770779] Starting dynamic subtest: bcs0
[144.128875] Dynamic subtest bcs0: SUCCESS (3.401s)
[144.164956] Starting dynamic subtest: vcs0
[147.354151] Dynamic subtest vcs0: SUCCESS (3.216s)
[147.388684] Starting dynamic subtest: vecs0
[150.612437] Dynamic subtest vecs0: SUCCESS (3.241s)
[150.633052] Subtest userptr: SUCCESS (13.154s)
[150.716137] [047/142] (852s left) kms_invalid_mode (bad-vsync-start)
[151.031875] Starting subtest: bad-vsync-start
[151.053525] Starting dynamic subtest: DP-1-pipe-A
[151.100761] Dynamic subtest DP-1-pipe-A: SUCCESS (0.087s)
[151.137774] Starting dynamic subtest: DP-1-pipe-B
[151.157683] Dynamic subtest DP-1-pipe-B: SUCCESS (0.002s)
[151.197276] Starting dynamic subtest: DP-1-pipe-C
[151.216437] Dynamic subtest DP-1-pipe-C: SUCCESS (0.002s)
[151.235212] Subtest bad-vsync-start: SUCCESS (0.097s)
[151.462334] [048/142] (852s left) gem_linear_blits (interruptible)
[152.902477] Starting subtest: interruptible
[168.892684] Subtest interruptible: SUCCESS (15.986s)
[169.116833] [049/142] (834s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[169.698440] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[169.736364] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.001s)
[169.822691] [050/142] (834s left) i915_hangman (detector)
[170.074288] Starting subtest: detector
[170.093581] Starting dynamic subtest: rcs0
[179.437629] Dynamic subtest rcs0: SUCCESS (9.352s)
[179.470495] Starting dynamic subtest: bcs0
[189.417577] Dynamic subtest bcs0: SUCCESS (9.973s)
[189.454392] Starting dynamic subtest: vcs0
[199.399603] Dynamic subtest vcs0: SUCCESS (9.984s)
[199.433681] Starting dynamic subtest: vecs0
[209.383154] Dynamic subtest vecs0: SUCCESS (9.981s)
[209.401946] Subtest detector: SUCCESS (39.294s)
[209.514826] [051/142] (794s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[209.885425] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[209.927560] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[210.014686] [052/142] (794s left) gem_ctx_persistence (engines-queued)
[210.249105] Starting subtest: engines-queued
[210.269862] Starting dynamic subtest: rcs0
[210.289080] Dynamic subtest rcs0: SUCCESS (0.055s)
[210.324849] Starting dynamic subtest: bcs0
[210.434740] Dynamic subtest bcs0: SUCCESS (0.155s)
[210.475959] Starting dynamic subtest: vcs0
[210.496761] Dynamic subtest vcs0: SUCCESS (0.057s)
[210.533760] Starting dynamic subtest: vecs0
[210.574575] Dynamic subtest vecs0: SUCCESS (0.062s)
[210.593494] Subtest engines-queued: SUCCESS (0.334s)
[210.683298] [053/142] (793s left) gem_pxp (protected-raw-src-copy-not-readible)
[213.626745] Subtest protected-raw-src-copy-not-readible: SKIP (0.000s)
[213.751759] [054/142] (790s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs)
[214.239994] Starting subtest: pipe-B-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs
[214.282107] Subtest pipe-B-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs: SKIP (0.005s)
[214.640260] [055/142] (789s left) kms_flip (basic-flip-vs-modeset)
[214.968521] Starting subtest: basic-flip-vs-modeset
[214.986957] Starting dynamic subtest: A-DP1
[216.503324] Dynamic subtest A-DP1: SUCCESS (1.574s)
[216.538689] Starting dynamic subtest: B-DP1
[217.664344] Dynamic subtest B-DP1: SUCCESS (1.154s)
[217.699224] Starting dynamic subtest: C-DP1
[218.817284] Dynamic subtest C-DP1: SUCCESS (1.135s)
[218.844763] Subtest basic-flip-vs-modeset: SUCCESS (3.872s)
[219.155083] [056/142] (785s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[219.533211] Starting subtest: yf-tiled-32bpp-rotate-270
[224.378634] Subtest yf-tiled-32bpp-rotate-270: SUCCESS (4.881s)
[224.944392] [057/142] (779s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted-submitted-sign
[225.205081] Starting subtest: invalid-multi-wait-all-available-unsubmitted-submitted-signaled
[225.224155] Subtest invalid-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[225.331438] [058/142] (779s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[225.706899] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[225.744123] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[225.836797] [059/142] (778s left) kms_plane_multiple (tiling-x)
[226.142317] Starting subtest: tiling-x
[226.161036] Starting dynamic subtest: pipe-A-DP-1
[227.631433] Dynamic subtest pipe-A-DP-1: SUCCESS (1.475s)
[227.668846] Starting dynamic subtest: pipe-B-DP-1
[229.313593] Dynamic subtest pipe-B-DP-1: SUCCESS (1.678s)
[229.351671] Starting dynamic subtest: pipe-C-DP-1
[230.991929] Dynamic subtest pipe-C-DP-1: SUCCESS (1.679s)
[231.014150] Subtest tiling-x: SUCCESS (4.842s)
[231.359263] [060/142] (773s left) kms_color (legacy-gamma-reset)
[231.661832] Starting subtest: legacy-gamma-reset
[231.683100] Starting dynamic subtest: pipe-A
[231.833407] Dynamic subtest pipe-A: SUCCESS (0.161s)
[231.871987] Starting dynamic subtest: pipe-B
[231.895588] Dynamic subtest pipe-B: SUCCESS (0.024s)
[231.933094] Starting dynamic subtest: pipe-C
[231.953668] Dynamic subtest pipe-C: SUCCESS (0.024s)
[231.972600] Subtest legacy-gamma-reset: SUCCESS (0.213s)
[232.223505] [061/142] (772s left) syncobj_timeline (invalid-signal-illegal-point)
[232.455638] Starting subtest: invalid-signal-illegal-point
[232.474566] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[232.559380] [062/142] (772s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[232.903085] Starting subtest: x-tiled-8bpp-rotate-90
[232.981537] Subtest x-tiled-8bpp-rotate-90: SKIP (0.088s)
[233.104407] [063/142] (771s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[233.411504] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[233.449252] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.004s)
[233.537947] [064/142] (771s left) gem_spin_batch (resubmit-new)
[233.771420] Starting subtest: resubmit-new
[233.790437] Starting dynamic subtest: rcs0
[233.811995] Dynamic subtest rcs0: SUCCESS (0.009s)
[233.850409] Starting dynamic subtest: bcs0
[233.870865] Dynamic subtest bcs0: SUCCESS (0.010s)
[233.907209] Starting dynamic subtest: vcs0
[233.926198] Dynamic subtest vcs0: SUCCESS (0.007s)
[233.961365] Starting dynamic subtest: vecs0
[233.980134] Dynamic subtest vecs0: SUCCESS (0.007s)
[233.998894] Subtest resubmit-new: SUCCESS (0.040s)
[234.096775] [065/142] (771s left) gem_exec_whisper (basic-forked-all)
[234.376306] Starting subtest: basic-forked-all
[256.574990] Subtest basic-forked-all: SUCCESS (22.116s)
[256.674286] [066/142] (748s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[257.050895] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[257.091690] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[257.177492] [067/142] (748s left) kms_ccs (pipe-c-bad-aux-stride-yf_tiled_ccs)
[257.699819] Starting subtest: pipe-C-bad-aux-stride-yf_tiled_ccs
[257.738479] Subtest pipe-C-bad-aux-stride-yf_tiled_ccs: SKIP (0.000s)
[258.059103] [068/142] (747s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[258.408282] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[258.445616] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[258.555284] [069/142] (747s left) gem_lmem_swapping (basic)
[258.847314] Subtest basic: SKIP (0.000s)
[258.959703] [070/142] (746s left) gem_flink_basic (flink-lifetime)
[259.219749] Starting subtest: flink-lifetime
[259.245196] Subtest flink-lifetime: SUCCESS (0.003s)
[259.360310] [071/142] (746s left) i915_pm_rpm (debugfs-read)
[261.153488] Starting subtest: debugfs-read
[264.468640] Subtest debugfs-read: SUCCESS (3.287s)
[264.928968] [072/142] (740s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[265.280995] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[265.323906] Subtest psr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[265.415816] [073/142] (740s left) gem_exec_schedule (u-submit-late-slice)
[265.810953] Starting subtest: u-submit-late-slice
[265.830806] Starting dynamic subtest: rcs0
[265.849773] Dynamic subtest rcs0: SUCCESS (0.061s)
[265.887199] Starting dynamic subtest: bcs0
[265.905689] Dynamic subtest bcs0: SUCCESS (0.050s)
[265.943543] Starting dynamic subtest: vcs0
[265.964893] Dynamic subtest vcs0: SUCCESS (0.048s)
[266.005133] Starting dynamic subtest: vecs0
[266.026181] Dynamic subtest vecs0: SUCCESS (0.048s)
[266.050167] Subtest u-submit-late-slice: SUCCESS (0.217s)
[266.247860] [074/142] (739s left) dumb_buffer (invalid-bpp)
[266.460295] Starting subtest: invalid-bpp
[266.480240] Subtest invalid-bpp: SUCCESS (0.000s)
[266.574357] [075/142] (739s left) core_auth (basic-auth)
[266.809985] Starting subtest: basic-auth
[266.830922] Subtest basic-auth: SUCCESS (0.001s)
[266.921500] [076/142] (739s left) perf_pmu (cpu-hotplug)
[267.146806] Starting subtest: cpu-hotplug
[267.187128] Subtest cpu-hotplug: SKIP (0.004s)
[267.294772] [077/142] (739s left) perf_pmu (idle)
[267.520936] Starting subtest: idle
[267.539637] Starting dynamic subtest: rcs0
[268.041404] Dynamic subtest rcs0: SUCCESS (0.518s)
[268.079957] Starting dynamic subtest: bcs0
[268.558191] Dynamic subtest bcs0: SUCCESS (0.518s)
[268.594815] Starting dynamic subtest: vcs0
[269.062497] Dynamic subtest vcs0: SUCCESS (0.518s)
[269.101654] Starting dynamic subtest: vecs0
[269.578194] Dynamic subtest vecs0: SUCCESS (0.515s)
[269.597297] Subtest idle: SUCCESS (2.082s)
[269.708414] [078/142] (736s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[270.081119] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[270.119640] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[270.213524] [079/142] (736s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[270.468962] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[270.558710] [080/142] (736s left) sysfs_defaults (readonly)
[270.789300] Starting subtest: readonly
[270.809144] Starting dynamic subtest: vecs0
[270.827897] Dynamic subtest vecs0: SUCCESS (0.001s)
[270.864817] Starting dynamic subtest: vcs0
[270.883457] Dynamic subtest vcs0: SUCCESS (0.001s)
[270.922086] Starting dynamic subtest: bcs0
[270.943309] Dynamic subtest bcs0: SUCCESS (0.001s)
[270.982335] Starting dynamic subtest: rcs0
[271.003476] Dynamic subtest rcs0: SUCCESS (0.001s)
[271.023089] Subtest readonly: SUCCESS (0.014s)
[271.110237] [081/142] (735s left) kms_ccs (pipe-a-random-ccs-data-4_tiled_dg2_rc_ccs_cc)
[271.518431] Starting subtest: pipe-A-random-ccs-data-4_tiled_dg2_rc_ccs_cc
[271.581117] Subtest pipe-A-random-ccs-data-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[271.986472] [082/142] (734s left) kms_ccs (pipe-a-crc-primary-rotation-180-4_tiled_mtl_rc_ccs)
[272.390085] Starting subtest: pipe-A-crc-primary-rotation-180-4_tiled_mtl_rc_ccs
[272.428204] Subtest pipe-A-crc-primary-rotation-180-4_tiled_mtl_rc_ccs: SKIP (0.001s)
[272.857587] [083/142] (734s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[273.234651] Starting subtest: fbc-rgb565-draw-pwrite
[275.523681] Subtest fbc-rgb565-draw-pwrite: SUCCESS (2.367s)
[275.691706] [084/142] (731s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[275.983822] Starting subtest: 2x-cursor-vs-flip-legacy
[276.021499] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.004s)
[276.114178] [085/142] (731s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[276.417660] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[276.444189] Starting dynamic subtest: pipe-A-valid-mode
[276.855744] Dynamic subtest pipe-A-valid-mode: SKIP (0.409s)
[276.892935] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.413s)
[277.237196] [086/142] (729s left) gem_render_copy (yf-tiled-to-vebox-linear)
[277.465295] Starting subtest: yf-tiled-to-vebox-linear
[277.502593] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[277.690360] [087/142] (729s left) syncobj_wait (single-wait-signaled)
[277.936182] Starting subtest: single-wait-signaled
[277.960406] Subtest single-wait-signaled: SUCCESS (0.000s)
[278.065388] [088/142] (729s left) gem_exec_balancer (busy)
[278.305988] Starting subtest: busy
[280.241220] Subtest busy: SUCCESS (1.935s)
[284.355406] [089/142] (723s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[284.688448] Starting subtest: 4-tiled-16bpp-rotate-90
[284.725234] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.000s)
[284.818713] [090/142] (722s left) gem_mmap_gtt (big-bo)
[285.051541] Starting subtest: big-bo
[285.888089] Subtest big-bo: SUCCESS (0.863s)
[286.126941] [091/142] (721s left) debugfs_test (sysfs)
[286.492434] Starting subtest: sysfs
[286.725046] Subtest sysfs: SUCCESS (0.253s)
[286.968734] [092/142] (720s left) kms_vblank (pipe-a-wait-forked-busy-hang)
[287.271947] Starting subtest: pipe-A-wait-forked-busy-hang
[294.154289] Subtest pipe-A-wait-forked-busy-hang: SUCCESS (6.825s)
[294.463566] [093/142] (713s left) kms_draw_crc (fill-fb)
[294.764985] Starting subtest: fill-fb
[295.199486] Subtest fill-fb: SUCCESS (0.432s)
[295.335894] [094/142] (712s left) kms_chamelium_color (ctm-green-to-red)
[295.659990] Subtest ctm-green-to-red: SKIP (0.000s)
[295.756634] [095/142] (712s left) kms_cursor_crc (cursor-alpha-transparent)
[296.046873] Starting subtest: cursor-alpha-transparent
[296.067861] Starting dynamic subtest: pipe-A-DP-1
[296.830488] Dynamic subtest pipe-A-DP-1: SUCCESS (0.760s)
[296.880130] Starting dynamic subtest: pipe-C-DP-1
[297.438786] Dynamic subtest pipe-C-DP-1: SUCCESS (0.616s)
[297.460116] Subtest cursor-alpha-transparent: SUCCESS (1.386s)
[297.816864] [096/142] (710s left) gem_softpin (evict-single-offset)
[298.059339] Starting subtest: evict-single-offset
[333.571816] Subtest evict-single-offset: SUCCESS (35.535s)
[333.706365] [097/142] (674s left) syncobj_wait (invalid-wait-illegal-handle)
[334.109864] Starting subtest: invalid-wait-illegal-handle
[334.131684] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[334.227176] [098/142] (674s left) gem_exec_schedule (preempt-contexts)
[334.634265] Starting subtest: preempt-contexts
[334.655185] Starting dynamic subtest: rcs0
[334.674415] Dynamic subtest rcs0: SUCCESS (0.131s)
[334.717061] Starting dynamic subtest: bcs0
[334.760296] Dynamic subtest bcs0: SUCCESS (0.152s)
[334.806328] Starting dynamic subtest: vcs0
[334.881832] Dynamic subtest vcs0: SUCCESS (0.120s)
[334.926773] Starting dynamic subtest: vecs0
[334.996864] Dynamic subtest vecs0: SUCCESS (0.119s)
[335.015694] Subtest preempt-contexts: SUCCESS (0.531s)
[335.385335] [099/142] (673s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[335.828533] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[335.867804] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[335.955872] [100/142] (672s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[336.324977] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[336.362266] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[336.456758] [101/142] (672s left) gem_ctx_param (root-set)
[336.693992] Starting subtest: root-set
[336.715716] Subtest root-set: SUCCESS (0.000s)
[336.810331] [102/142] (671s left) i915_pm_rpm (sysfs-read)
[338.821510] Starting subtest: sysfs-read
[339.178162] Subtest sysfs-read: SUCCESS (0.341s)
[339.672661] [103/142] (669s left) kms_rotation_crc (primary-rotation-90)
[339.975075] Starting subtest: primary-rotation-90
[346.175848] Subtest primary-rotation-90: SUCCESS (6.202s)
[346.636583] [104/142] (662s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[347.064038] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[347.362811] [105/142] (661s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[347.742214] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[347.779755] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[347.873632] [106/142] (661s left) i915_pm_rpm (legacy-planes-dpms)
[349.660745] Starting subtest: legacy-planes-dpms
[349.682496] Starting dynamic subtest: plane-39
[351.644645] Dynamic subtest plane-39: SUCCESS (1.967s)
[351.688979] Starting dynamic subtest: plane-47
[353.675707] Dynamic subtest plane-47: SUCCESS (2.031s)
[353.695588] Subtest legacy-planes-dpms: SUCCESS (4.005s)
[354.155425] [107/142] (655s left) kms_vblank (pipe-d-query-busy)
[354.484646] Subtest pipe-D-query-busy: SKIP (0.000s)
[354.658634] [108/142] (654s left) kms_pm_dc (dc3co-vpb-simulation)
[355.994792] Starting subtest: dc3co-vpb-simulation
[356.033558] Subtest dc3co-vpb-simulation: SKIP (0.000s)
[356.172934] [109/142] (653s left) kms_flip (plain-flip-ts-check-interruptible)
[356.472991] Starting subtest: plain-flip-ts-check-interruptible
[356.491769] Starting dynamic subtest: A-DP1
[367.260878] Dynamic subtest A-DP1: SUCCESS (10.780s)
[367.301785] Starting dynamic subtest: B-DP1
[377.966266] Dynamic subtest B-DP1: SUCCESS (10.709s)
[378.007351] Starting dynamic subtest: C-DP1
[388.693175] Dynamic subtest C-DP1: SUCCESS (10.721s)
[388.711998] Subtest plain-flip-ts-check-interruptible: SUCCESS (32.223s)
[389.142810] [110/142] (620s left) kms_ccs (pipe-a-bad-rotation-90-y_tiled_gen12_rc_ccs)
[389.544572] Starting subtest: pipe-A-bad-rotation-90-y_tiled_gen12_rc_ccs
[389.581473] Subtest pipe-A-bad-rotation-90-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[390.029486] [111/142] (619s left) perf (per-context-mode-unprivileged)
[390.412058] Starting subtest: per-context-mode-unprivileged
[390.454465] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[390.563912] [112/142] (619s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-20x20)
[390.863153] Starting subtest: planes-downscale-factor-0-25-upscale-20x20
[390.884634] Starting dynamic subtest: pipe-A-DP-1
[390.927595] Dynamic subtest pipe-A-DP-1: SKIP (0.030s)
[390.968080] Starting dynamic subtest: pipe-B-DP-1
[391.005588] Dynamic subtest pipe-B-DP-1: SKIP (0.080s)
[391.044064] Starting dynamic subtest: pipe-C-DP-1
[391.084138] Dynamic subtest pipe-C-DP-1: SKIP (0.079s)
[391.126088] Subtest planes-downscale-factor-0-25-upscale-20x20: SKIP (0.204s)
[391.243557] [113/142] (618s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[391.546065] Starting subtest: disable-crc-after-crtc
[391.565342] Starting dynamic subtest: pipe-A-DP-1
[392.311754] Dynamic subtest pipe-A-DP-1: SUCCESS (0.734s)
[392.361752] Starting dynamic subtest: pipe-B-DP-1
[393.219800] Dynamic subtest pipe-B-DP-1: SUCCESS (0.901s)
[393.266355] Starting dynamic subtest: pipe-C-DP-1
[394.147476] Dynamic subtest pipe-C-DP-1: SUCCESS (0.921s)
[394.169755] Subtest disable-crc-after-crtc: SUCCESS (2.572s)
[394.494083] [114/142] (615s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[394.859252] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[394.898530] Subtest psr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[394.990118] [115/142] (614s left) kms_big_fb (linear-64bpp-rotate-90)
[395.365779] Starting subtest: linear-64bpp-rotate-90
[395.446124] Subtest linear-64bpp-rotate-90: SKIP (0.076s)
[395.545170] [116/142] (614s left) kms_fbcon_fbt (psr)
[395.778911] Starting subtest: psr
[395.823523] Subtest psr: SKIP (0.000s)
[395.914281] [117/142] (614s left) syncobj_wait (wait-any-interrupted)
[396.145077] Starting subtest: wait-any-interrupted
[396.223158] Subtest wait-any-interrupted: SUCCESS (0.109s)
[396.342531] [118/142] (613s left) perf (gen12-unprivileged-single-ctx-counters)
[396.687605] Subtest gen12-unprivileged-single-ctx-counters: SKIP (0.000s)
[396.779626] [119/142] (613s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[397.138905] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[397.180079] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[397.271378] [120/142] (613s left) api_intel_bb (blit-noreloc-keep-cache)
[397.515150] Starting subtest: blit-noreloc-keep-cache
[397.534302] Subtest blit-noreloc-keep-cache: SUCCESS (0.019s)
[397.638871] [121/142] (612s left) gem_caching (reads)
[397.874736] Starting subtest: reads
[404.290814] Subtest reads: SUCCESS (6.436s)
[404.458997] [122/142] (606s left) gem_ctx_engines (execute-one)
[404.696441] Starting subtest: execute-one
[407.846123] Subtest execute-one: SUCCESS (2.987s)
[407.936173] [123/142] (602s left) kms_ccs (pipe-d-ccs-on-another-bo-y_tiled_gen12_mc_ccs)
[408.526585] Subtest pipe-D-ccs-on-another-bo-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[408.870996] [124/142] (601s left) kms_ccs (pipe-c-random-ccs-data-y_tiled_gen12_mc_ccs)
[409.391236] Starting subtest: pipe-C-random-ccs-data-y_tiled_gen12_mc_ccs
[409.469074] Subtest pipe-C-random-ccs-data-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[409.778569] [125/142] (601s left) perf (invalid-create-userspace-config)
[410.131766] Starting subtest: invalid-create-userspace-config
[410.150520] Subtest invalid-create-userspace-config: SUCCESS (0.007s)
[410.243862] [126/142] (600s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[410.550313] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[410.571052] Starting dynamic subtest: pipe-A-valid-mode
[411.223331] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.656s)
[411.242282] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SUCCESS (0.660s)
[411.570855] [127/142] (599s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[411.873945] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[431.353690] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (19.463s)
[431.704940] [128/142] (579s left) kms_psr (psr2_cursor_plane_onoff)
[431.967515] Subtest psr2_cursor_plane_onoff: SKIP (0.000s)
[432.062935] [129/142] (579s left) syncobj_basic (bad-create-flags)
[432.267339] Starting subtest: bad-create-flags
[432.287587] Subtest bad-create-flags: SUCCESS (0.000s)
[432.385111] [130/142] (578s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[432.679630] Starting subtest: flip-vs-cursor-busy-crc-legacy
[433.482646] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.811s)
[433.861741] [131/142] (577s left) kms_dsc (dsc-basic)
[434.184696] Subtest dsc-basic: SKIP (0.000s)
[434.281709] [132/142] (577s left) kms_cursor_crc (cursor-sliding-256x256)
[434.616989] Starting subtest: cursor-sliding-256x256
[434.635727] Starting dynamic subtest: pipe-A-DP-1
[438.308574] Dynamic subtest pipe-A-DP-1: SUCCESS (3.682s)
[438.392520] Starting dynamic subtest: pipe-C-DP-1
[442.133740] Dynamic subtest pipe-C-DP-1: SUCCESS (3.756s)
[442.153348] Subtest cursor-sliding-256x256: SUCCESS (7.520s)
[442.488668] [133/142] (569s left) gem_mmap_gtt (hang-busy)
[442.725027] Starting subtest: hang-busy
[458.350056] Subtest hang-busy: SUCCESS (15.529s)
[458.468129] [134/142] (553s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[458.700963] Starting subtest: single-wait-all-for-submit-available-submitted
[458.721759] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[458.813060] [135/142] (552s left) prime_busy (before-wait)
[459.036451] Starting subtest: before-wait
[459.056317] Starting dynamic subtest: rcs0
[459.075433] Dynamic subtest rcs0: SUCCESS (0.010s)
[459.115824] Starting dynamic subtest: bcs0
[459.134534] Dynamic subtest bcs0: SUCCESS (0.017s)
[459.173954] Starting dynamic subtest: vcs0
[459.195380] Dynamic subtest vcs0: SUCCESS (0.023s)
[459.237100] Starting dynamic subtest: vecs0
[459.257882] Dynamic subtest vecs0: SUCCESS (0.020s)
[459.277845] Subtest before-wait: SUCCESS (0.212s)
[459.368443] [136/142] (552s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[463.651784] Subtest parallel-dmabuf-import-out-fence: SKIP (0.000s)
[463.750882] [137/142] (548s left) kms_getfb (getfb-addfb-different-handles)
[463.982580] Starting subtest: getfb-addfb-different-handles
[464.003877] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[464.097823] [138/142] (548s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_dg2_rc_ccs)
[464.642547] Subtest pipe-D-bad-rotation-90-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[464.972881] [139/142] (547s left) drm_fdinfo (busy-idle-check-all)
[465.192365] Starting subtest: busy-idle-check-all
[465.211505] Starting dynamic subtest: rcs0
[465.814212] Dynamic subtest rcs0: SUCCESS (0.635s)
[465.853976] Starting dynamic subtest: bcs0
[466.446274] Dynamic subtest bcs0: SUCCESS (0.629s)
[466.484451] Starting dynamic subtest: vcs0
[467.080042] Dynamic subtest vcs0: SUCCESS (0.625s)
[467.120090] Starting dynamic subtest: vecs0
[467.702925] Dynamic subtest vecs0: SUCCESS (0.624s)
[467.721891] Subtest busy-idle-check-all: SUCCESS (2.525s)
[467.818733] [140/142] (544s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-gtt)
[468.195971] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-gtt
[468.237250] Subtest psr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[468.332756] [141/142] (544s left) kms_vblank (pipe-d-ts-continuation-suspend)
[468.649303] Subtest pipe-D-ts-continuation-suspend: SKIP (0.000s)
[468.824675] [142/142] (543s left) v3d/v3d_submit_csd (bad-bo)
[469.110820] Subtest bad-bo: SKIP (0.000s)
[469.179469] Closing watchdogs
Done.