[38.334817] Initializing watchdogs
[38.334882]   /dev/watchdog0
[38.341085] [001/142] (960s left) gem_exec_schedule (noreorder-corked)
[38.542777] Starting subtest: noreorder-corked
[38.543659] Starting dynamic subtest: rcs0
[39.655521] Dynamic subtest rcs0: SUCCESS (1.121s)
[39.660229] Starting dynamic subtest: bcs0
[40.781258] Dynamic subtest bcs0: SUCCESS (1.125s)
[40.785913] Starting dynamic subtest: vcs0
[41.902244] Dynamic subtest vcs0: SUCCESS (1.121s)
[41.906823] Starting dynamic subtest: vcs1
[43.021599] Dynamic subtest vcs1: SUCCESS (1.119s)
[43.029420] Starting dynamic subtest: vecs0
[44.145233] Dynamic subtest vecs0: SUCCESS (1.124s)
[44.149875] Starting dynamic subtest: vecs1
[45.270319] Dynamic subtest vecs1: SUCCESS (1.125s)
[45.275078] Starting dynamic subtest: ccs0
[46.395280] Dynamic subtest ccs0: SUCCESS (1.125s)
[46.400292] Starting dynamic subtest: ccs1
[47.520238] Dynamic subtest ccs1: SUCCESS (1.125s)
[47.524783] Starting dynamic subtest: ccs2
[48.623160] Dynamic subtest ccs2: SUCCESS (1.103s)
[48.627908] Starting dynamic subtest: ccs3
[49.728203] Dynamic subtest ccs3: SUCCESS (1.105s)
[49.729193] Subtest noreorder-corked: SUCCESS (11.194s)
[49.928596] [002/142] (948s left) kms_plane_alpha_blend (constant-alpha-min)
[50.060018] Starting subtest: constant-alpha-min
[50.261779] Starting dynamic subtest: pipe-A-DP-4
[50.929980] Dynamic subtest pipe-A-DP-4: SUCCESS (0.667s)
[50.934509] Starting dynamic subtest: pipe-D-DP-4
[51.677197] Dynamic subtest pipe-D-DP-4: SUCCESS (0.746s)
[51.678015] Subtest constant-alpha-min: SUCCESS (1.617s)
[51.847814] [003/142] (947s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[51.985466] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[54.385435] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (2.401s)
[54.531384] [004/142] (944s left) kms_ccs (pipe-a-crc-primary-basic-y_tiled_gen12_rc_ccs)
[54.744523] Starting subtest: pipe-A-crc-primary-basic-y_tiled_gen12_rc_ccs
[54.746328] Subtest pipe-A-crc-primary-basic-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[55.002368] [005/142] (943s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[55.131922] Starting subtest: primary-y-tiled-reflect-x-180
[55.221581] Subtest primary-y-tiled-reflect-x-180: SKIP (0.089s)
[55.294843] [006/142] (943s left) perf (gen12-mi-rpc)
[55.617205] Starting subtest: gen12-mi-rpc
[55.617982] Starting dynamic subtest: rcs0
[55.656485] Dynamic subtest rcs0: SUCCESS (0.040s)
[55.657376] Subtest gen12-mi-rpc: SUCCESS (0.040s)
[55.682060] [007/142] (943s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu)
[55.867105] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu
[55.868790] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[55.935558] [008/142] (942s left) i915_pm_rpm (dpms-mode-unset-non-lpsp)
[57.534597] Starting subtest: dpms-mode-unset-non-lpsp
[59.716333] Subtest dpms-mode-unset-non-lpsp: SUCCESS (2.182s)
[60.047498] [009/142] (938s left) syncobj_timeline (invalid-query-one-illegal-handle)
[60.106365] Starting subtest: invalid-query-one-illegal-handle
[60.107201] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[60.169349] [010/142] (938s left) kms_ccs (pipe-c-crc-primary-basic-y_tiled_gen12_rc_ccs)
[60.476679] Starting subtest: pipe-C-crc-primary-basic-y_tiled_gen12_rc_ccs
[60.478272] Subtest pipe-C-crc-primary-basic-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[60.671095] [011/142] (938s left) gem_ctx_persistence (engines-mixed-process)
[60.733503] Starting subtest: engines-mixed-process
[60.734410] Starting dynamic subtest: rcs0
[62.381976] Dynamic subtest rcs0: SUCCESS (1.648s)
[62.389427] Starting dynamic subtest: bcs0
[64.372459] Dynamic subtest bcs0: SUCCESS (1.990s)
[64.379491] Starting dynamic subtest: vcs0
[66.412988] Dynamic subtest vcs0: SUCCESS (2.041s)
[66.420198] Starting dynamic subtest: vcs1
[68.397191] Dynamic subtest vcs1: SUCCESS (1.984s)
[68.405497] Starting dynamic subtest: vecs0
[70.376494] Dynamic subtest vecs0: SUCCESS (1.979s)
[70.382040] Starting dynamic subtest: vecs1
[72.360805] Dynamic subtest vecs1: SUCCESS (1.984s)
[72.367880] Starting dynamic subtest: ccs0
[74.343955] Dynamic subtest ccs0: SUCCESS (1.983s)
[74.351146] Starting dynamic subtest: ccs1
[76.396122] Dynamic subtest ccs1: SUCCESS (2.052s)
[76.403219] Starting dynamic subtest: ccs2
[78.377872] Dynamic subtest ccs2: SUCCESS (1.982s)
[78.384857] Starting dynamic subtest: ccs3
[80.366410] Dynamic subtest ccs3: SUCCESS (1.988s)
[80.367530] Subtest engines-mixed-process: SUCCESS (19.633s)
[80.433224] [012/142] (918s left) kms_ccs (pipe-c-bad-rotation-90-y_tiled_gen12_mc_ccs)
[80.712626] Starting subtest: pipe-C-bad-rotation-90-y_tiled_gen12_mc_ccs
[80.714221] Subtest pipe-C-bad-rotation-90-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[80.909154] [013/142] (918s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[81.041279] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[81.042977] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[81.125740] [014/142] (917s left) syncobj_timeline (wait-all-delayed-signal)
[81.182992] Starting subtest: wait-all-delayed-signal
[81.285728] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[81.380141] [015/142] (917s left) i915_pm_rpm (i2c)
[83.542325] Starting subtest: i2c
[89.196875] Subtest i2c: SUCCESS (5.655s)
[89.346817] [016/142] (909s left) kms_cursor_crc (cursor-offscreen-max-size)
[89.688283] Starting subtest: cursor-offscreen-max-size
[89.690722] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[89.867494] [017/142] (909s left) kms_lease (lease_invalid_connector)
[90.011075] Starting subtest: lease_invalid_connector
[90.011978] Starting dynamic subtest: pipe-A-DP-4
[90.012875] Dynamic subtest pipe-A-DP-4: SUCCESS (0.000s)
[90.018522] Starting dynamic subtest: pipe-B-DP-4
[90.019406] Dynamic subtest pipe-B-DP-4: SUCCESS (0.000s)
[90.024794] Starting dynamic subtest: pipe-C-DP-4
[90.025695] Dynamic subtest pipe-C-DP-4: SUCCESS (0.000s)
[90.031296] Starting dynamic subtest: pipe-D-DP-4
[90.032174] Dynamic subtest pipe-D-DP-4: SUCCESS (0.000s)
[90.033009] Subtest lease_invalid_connector: SUCCESS (0.003s)
[90.077140] [018/142] (909s left) gem_exec_fence (nb-await)
[90.267898] Starting subtest: nb-await
[90.269293] Starting dynamic subtest: rcs0
[90.371361] Dynamic subtest rcs0: SUCCESS (0.109s)
[90.378269] Starting dynamic subtest: bcs0
[90.437132] Dynamic subtest bcs0: SUCCESS (0.065s)
[90.450994] Starting dynamic subtest: vcs0
[90.515755] Dynamic subtest vcs0: SUCCESS (0.077s)
[90.540371] Starting dynamic subtest: vcs1
[90.606523] Dynamic subtest vcs1: SUCCESS (0.090s)
[90.631522] Starting dynamic subtest: vecs0
[90.697137] Dynamic subtest vecs0: SUCCESS (0.090s)
[90.719642] Starting dynamic subtest: vecs1
[90.785072] Dynamic subtest vecs1: SUCCESS (0.087s)
[90.806903] Starting dynamic subtest: ccs0
[90.873635] Dynamic subtest ccs0: SUCCESS (0.088s)
[90.898197] Starting dynamic subtest: ccs1
[90.967179] Dynamic subtest ccs1: SUCCESS (0.093s)
[90.992112] Starting dynamic subtest: ccs2
[91.056883] Dynamic subtest ccs2: SUCCESS (0.089s)
[91.079450] Starting dynamic subtest: ccs3
[91.145873] Dynamic subtest ccs3: SUCCESS (0.088s)
[91.147317] Subtest nb-await: SUCCESS (0.884s)
[92.109956] [019/142] (907s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[92.246351] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[92.248057] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[92.326751] [020/142] (906s left) kms_atomic_transition (modeset-transition)
[92.456987] Starting subtest: modeset-transition
[92.457848] Starting dynamic subtest: 1x-outputs
[98.084994] Dynamic subtest 1x-outputs: SUCCESS (5.628s)
[98.144352] Subtest modeset-transition: SUCCESS (5.688s)
[98.315762] [021/142] (900s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_dg2_rc_ccs)
[98.628495] Starting subtest: pipe-D-crc-primary-basic-4_tiled_dg2_rc_ccs
[99.011264] Subtest pipe-D-crc-primary-basic-4_tiled_dg2_rc_ccs: SUCCESS (0.383s)
[99.260531] [022/142] (899s left) syncobj_wait (wait-all-complex)
[99.319525] Starting subtest: wait-all-complex
[99.543124] Subtest wait-all-complex: SUCCESS (0.212s)
[99.595405] [023/142] (899s left) kms_lease (implicit-plane-lease)
[99.728241] Starting subtest: implicit-plane-lease
[99.730427] Subtest implicit-plane-lease: SUCCESS (0.002s)
[99.793268] [024/142] (899s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs)
[100.059173] Starting subtest: pipe-B-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs
[100.064018] Subtest pipe-B-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs: SKIP (0.002s)
[100.265448] [025/142] (898s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[100.402179] Starting subtest: psr-1p-primscrn-cur-indfb-move
[100.403905] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[100.481813] [026/142] (898s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[100.603456] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[100.619970] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.015s)
[100.681668] [027/142] (898s left) gem_exec_reloc (basic-cpu-wc)
[100.746077] Subtest basic-cpu-wc: SKIP (0.000s)
[100.790304] [028/142] (898s left) gen9_exec_parse (bb-secure)
[100.859914] Subtest bb-secure: SKIP (0.000s)
[100.890137] [029/142] (898s left) gem_render_copy (yf-tiled-ccs-to-linear)
[100.954419] Starting subtest: yf-tiled-ccs-to-linear
[100.956457] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[101.141700] [030/142] (898s left) gem_pread (exhaustion)
[101.250652] Subtest exhaustion: SKIP (0.000s)
[101.289893] [031/142] (898s left) vc4/vc4_wait_bo (used-bo-1ns)
[101.366462] Subtest used-bo-1ns: SKIP (0.000s)
[101.419820] [032/142] (897s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[101.563192] Starting subtest: x-tiled-32bpp-rotate-270
[101.600179] Subtest x-tiled-32bpp-rotate-270: SKIP (0.039s)
[101.699065] [033/142] (897s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[101.848444] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[101.849963] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[101.932513] [034/142] (897s left) kms_plane_scaling (planes-upscale-factor-0-25)
[102.064426] Starting subtest: planes-upscale-factor-0-25
[102.065247] Starting dynamic subtest: pipe-A-DP-4
[102.148876] Dynamic subtest pipe-A-DP-4: SUCCESS (0.084s)
[102.155583] Starting dynamic subtest: pipe-B-DP-4
[102.337572] Dynamic subtest pipe-B-DP-4: SUCCESS (0.187s)
[102.344561] Starting dynamic subtest: pipe-C-DP-4
[102.526824] Dynamic subtest pipe-C-DP-4: SUCCESS (0.188s)
[102.535737] Starting dynamic subtest: pipe-D-DP-4
[102.715864] Dynamic subtest pipe-D-DP-4: SUCCESS (0.188s)
[102.716867] Subtest planes-upscale-factor-0-25: SUCCESS (0.652s)
[102.920997] [035/142] (896s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[103.058296] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[103.059835] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[103.137566] [036/142] (896s left) kms_universal_plane (universal-plane-pipe-a-functional)
[103.268187] Starting subtest: universal-plane-pipe-A-functional
[105.475542] Subtest universal-plane-pipe-A-functional: SUCCESS (2.208s)
[105.642810] [037/142] (893s left) gem_exec_balancer (invalid-balancer)
[105.711461] Starting subtest: invalid-balancer
[106.604490] Subtest invalid-balancer: SUCCESS (0.884s)
[106.883317] [038/142] (892s left) kms_addfb_basic (tile-pitch-mismatch)
[106.943219] Starting subtest: tile-pitch-mismatch
[106.944835] Subtest tile-pitch-mismatch: SKIP (0.000s)
[107.092949] [039/142] (892s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[107.227219] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[108.359623] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.133s)
[108.504758] [040/142] (890s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[108.645678] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[108.647364] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[108.725696] [041/142] (890s left) kms_psr (psr2_sprite_mmap_gtt)
[108.791610] Subtest psr2_sprite_mmap_gtt: SKIP (0.000s)
[108.817913] [042/142] (890s left) gem_exec_parallel (engines)
[108.887591] Starting subtest: engines
[108.888489] Starting dynamic subtest: basic
[110.637491] Dynamic subtest basic: SUCCESS (1.749s)
[110.663339] Starting dynamic subtest: contexts
[113.899558] Dynamic subtest contexts: SUCCESS (3.252s)
[113.905661] Starting dynamic subtest: fds
[118.120026] Dynamic subtest fds: SUCCESS (4.220s)
[118.126349] Starting dynamic subtest: userptr
[119.765465] Dynamic subtest userptr: SUCCESS (1.654s)
[119.766526] Subtest engines: SUCCESS (10.878s)
[120.022352] [043/142] (879s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[120.128050] Starting subtest: etime-multi-wait-for-submit-submitted
[120.234752] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.107s)
[120.322636] [044/142] (879s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_dg2_rc_ccs)
[120.616368] Starting subtest: pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs
[120.780438] Subtest pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs: SUCCESS (0.165s)
[121.036179] [045/142] (878s left) kms_ccs (pipe-a-bad-pixel-format-4_tiled_mtl_rc_ccs_cc)
[121.169501] Starting subtest: pipe-A-bad-pixel-format-4_tiled_mtl_rc_ccs_cc
[121.171198] Subtest pipe-A-bad-pixel-format-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[121.511614] [046/142] (878s left) gem_create (hog-create)
[121.575215] Starting subtest: hog-create
[121.576050] Starting dynamic subtest: lmem0
[153.858415] Dynamic subtest lmem0: SUCCESS (32.283s)
[153.864655] Starting dynamic subtest: smem0
[186.122884] Dynamic subtest smem0: SUCCESS (32.247s)
[186.124403] Subtest hog-create: SUCCESS (64.531s)
[186.348873] [047/142] (813s left) gem_exec_schedule (u-fairslice-all)
[186.429894] Starting subtest: u-fairslice-all
[188.533712] Subtest u-fairslice-all: SUCCESS (2.104s)
[188.908464] [048/142] (810s left) kms_psr (sprite_mmap_cpu)
[188.980677] Subtest sprite_mmap_cpu: SKIP (0.000s)
[189.006006] [049/142] (810s left) gem_eio (in-flight-10ms)
[189.298185] Starting subtest: in-flight-10ms
[194.844704] Subtest in-flight-10ms: SUCCESS (5.547s)
[194.985490] [050/142] (804s left) kms_vblank (pipe-a-ts-continuation-modeset-rpm)
[195.119538] Starting subtest: pipe-A-ts-continuation-modeset-rpm
[196.799716] Subtest pipe-A-ts-continuation-modeset-rpm: SUCCESS (1.680s)
[197.129172] [051/142] (802s left) kms_plane_scaling (2x-scaler-multi-pipe)
[197.261420] Starting subtest: 2x-scaler-multi-pipe
[197.264155] Subtest 2x-scaler-multi-pipe: SKIP (0.002s)
[197.328795] [052/142] (802s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs)
[197.628404] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs
[197.631251] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs: SKIP (0.002s)
[197.804567] [053/142] (801s left) gem_ctx_param (invalid-set-ringsize)
[197.864820] Starting subtest: invalid-set-ringsize
[197.865618] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[197.921604] [054/142] (801s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[197.982244] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[198.013642] [055/142] (801s left) prime_mmap_coherency (read)
[198.084411] Starting subtest: read
[203.495307] Subtest read: SUCCESS (5.403s)
[203.593571] [056/142] (796s left) perf_pmu (gt-awake)
[203.657433] Starting subtest: gt-awake
[209.675029] Subtest gt-awake: SUCCESS (6.017s)
[209.759327] [057/142] (790s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[209.895822] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[212.490083] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (2.596s)
[212.628156] [058/142] (787s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[212.764832] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[212.766620] Subtest psr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[212.855769] [059/142] (786s left) kms_ccs (pipe-d-random-ccs-data-y_tiled_gen12_rc_ccs)
[213.172377] Starting subtest: pipe-D-random-ccs-data-y_tiled_gen12_rc_ccs
[213.174850] Subtest pipe-D-random-ccs-data-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[213.328148] [060/142] (786s left) syncobj_wait (reset-multiple-signaled)
[213.388467] Starting subtest: reset-multiple-signaled
[213.389289] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[213.444416] [061/142] (786s left) gem_mmap_gtt (hang)
[213.504461] Subtest hang: SKIP (0.000s)
[213.536946] [062/142] (786s left) kms_ccs (pipe-a-missing-ccs-buffer-4_tiled_mtl_mc_ccs)
[213.766420] Starting subtest: pipe-A-missing-ccs-buffer-4_tiled_mtl_mc_ccs
[213.768211] Subtest pipe-A-missing-ccs-buffer-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[214.018812] [063/142] (785s left) kms_rotation_crc (bad-tiling)
[214.149652] Starting subtest: bad-tiling
[214.151466] Subtest bad-tiling: SKIP (0.001s)
[214.217442] [064/142] (785s left) kms_flip (wf_vblank-ts-check-interruptible)
[214.338868] Starting subtest: wf_vblank-ts-check-interruptible
[214.345050] Starting dynamic subtest: A-DP4
[222.433493] Dynamic subtest A-DP4: SUCCESS (8.084s)
[222.441741] Starting dynamic subtest: B-DP4
[230.442925] Dynamic subtest B-DP4: SUCCESS (8.012s)
[230.450163] Starting dynamic subtest: C-DP4
[238.475873] Dynamic subtest C-DP4: SUCCESS (8.009s)
[238.482930] Starting dynamic subtest: D-DP4
[246.461841] Dynamic subtest D-DP4: SUCCESS (8.008s)
[246.462653] Subtest wf_vblank-ts-check-interruptible: SUCCESS (32.124s)
[246.701696] [065/142] (753s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[246.835934] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[246.837505] Subtest fbcpsr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[246.917632] [066/142] (753s left) kms_plane_scaling (plane-upscale-with-rotation-20x20)
[247.048653] Starting subtest: plane-upscale-with-rotation-20x20
[247.049586] Starting dynamic subtest: pipe-A-DP-4
[247.417139] Dynamic subtest pipe-A-DP-4: SUCCESS (0.368s)
[247.425361] Starting dynamic subtest: pipe-B-DP-4
[247.871524] Dynamic subtest pipe-B-DP-4: SUCCESS (0.453s)
[247.879882] Starting dynamic subtest: pipe-C-DP-4
[248.326230] Dynamic subtest pipe-C-DP-4: SUCCESS (0.453s)
[248.334844] Starting dynamic subtest: pipe-D-DP-4
[248.781179] Dynamic subtest pipe-D-DP-4: SUCCESS (0.453s)
[248.782051] Subtest plane-upscale-with-rotation-20x20: SUCCESS (1.734s)
[249.019729] [067/142] (750s left) kms_color (ctm-0-25)
[249.152372] Starting subtest: ctm-0-25
[249.153179] Starting dynamic subtest: pipe-A
[250.754434] Dynamic subtest pipe-A: SUCCESS (1.602s)
[250.761546] Starting dynamic subtest: pipe-B
[252.240864] Dynamic subtest pipe-B: SUCCESS (1.486s)
[252.248409] Starting dynamic subtest: pipe-C
[253.788846] Dynamic subtest pipe-C: SUCCESS (1.547s)
[253.795729] Starting dynamic subtest: pipe-D
[255.412983] Dynamic subtest pipe-D: SUCCESS (1.623s)
[255.413841] Subtest ctm-0-25: SUCCESS (6.261s)
[255.580908] [068/142] (744s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[255.716581] Starting subtest: fbc-farfromfence-mmap-gtt
[255.718262] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[255.797504] [069/142] (744s left) kms_plane_scaling (invalid-num-scalers)
[255.926524] Starting subtest: invalid-num-scalers
[255.927405] Starting dynamic subtest: pipe-A-DP-4-invalid-num-scalers
[255.941535] Dynamic subtest pipe-A-DP-4-invalid-num-scalers: SUCCESS (0.014s)
[255.949782] Starting dynamic subtest: pipe-B-DP-4-invalid-num-scalers
[255.970052] Dynamic subtest pipe-B-DP-4-invalid-num-scalers: SUCCESS (0.027s)
[255.978361] Starting dynamic subtest: pipe-C-DP-4-invalid-num-scalers
[256.000166] Dynamic subtest pipe-C-DP-4-invalid-num-scalers: SUCCESS (0.027s)
[256.007164] Starting dynamic subtest: pipe-D-DP-4-invalid-num-scalers
[256.028921] Dynamic subtest pipe-D-DP-4-invalid-num-scalers: SUCCESS (0.027s)
[256.029748] Subtest invalid-num-scalers: SUCCESS (0.103s)
[256.114505] [070/142] (743s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_mtl_rc_ccs_cc)
[256.359398] Starting subtest: pipe-B-crc-primary-basic-4_tiled_mtl_rc_ccs_cc
[256.360964] Subtest pipe-B-crc-primary-basic-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[256.589831] [071/142] (743s left) gem_close (many-handles-one-vma)
[256.654568] Starting subtest: many-handles-one-vma
[256.678888] Subtest many-handles-one-vma: SUCCESS (0.024s)
[256.756471] [072/142] (743s left) kms_content_protection (srm)
[256.936791] Starting subtest: srm
[256.973987] Starting dynamic subtest: pipe-A-DP-4
[377.245363] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[377.573076] Closing watchdogs
[377.574415] Initializing watchdogs
[377.574459]   /dev/watchdog0
[377.583525] [073/142] (622s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[377.717398] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[377.718327] Starting dynamic subtest: pipe-A-valid-mode
[377.802617] Dynamic subtest pipe-A-valid-mode: SKIP (0.084s)
[377.804241] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.085s)
[377.940804] [074/142] (622s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[378.072352] Starting subtest: cursorB-vs-flipB-atomic-transitions
[378.074055] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[378.140507] [075/142] (621s left) kms_ccs (pipe-a-bad-pixel-format-4_tiled_dg2_mc_ccs)
[378.272436] Starting subtest: pipe-A-bad-pixel-format-4_tiled_dg2_mc_ccs
[378.273254] Subtest pipe-A-bad-pixel-format-4_tiled_dg2_mc_ccs: SUCCESS (0.002s)
[378.612148] [076/142] (621s left) gem_exec_whisper (basic-contexts)
[378.682812] Starting subtest: basic-contexts
[392.335782] Subtest basic-contexts: SUCCESS (13.641s)
[392.498599] [077/142] (607s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_gen12_rc_ccs)
[392.739477] Starting subtest: pipe-B-crc-primary-basic-y_tiled_gen12_rc_ccs
[392.741089] Subtest pipe-B-crc-primary-basic-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[392.975322] [078/142] (607s left) gem_mmap_wc (read-write-distinct)
[393.037182] Subtest read-write-distinct: SKIP (0.000s)
[393.068270] [079/142] (607s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[393.203378] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[394.484290] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.272s)
[394.586160] [080/142] (605s left) gem_flink_basic (bad-open)
[394.646573] Starting subtest: bad-open
[394.647444] Subtest bad-open: SUCCESS (0.000s)
[394.710973] [081/142] (605s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[394.846336] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[394.847910] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[394.925385] [082/142] (605s left) drm_fdinfo (most-busy-check-all)
[394.990237] Starting subtest: most-busy-check-all
[394.991138] Starting dynamic subtest: rcs0
[395.008669] Dynamic subtest rcs0: SKIP (0.017s)
[395.016139] Starting dynamic subtest: bcs0
[395.017684] Dynamic subtest bcs0: SKIP (0.000s)
[395.024825] Starting dynamic subtest: vcs0
[395.027210] Dynamic subtest vcs0: SKIP (0.000s)
[395.034015] Starting dynamic subtest: vcs1
[395.035592] Dynamic subtest vcs1: SKIP (0.000s)
[395.042429] Starting dynamic subtest: vecs0
[395.043968] Dynamic subtest vecs0: SKIP (0.000s)
[395.050765] Starting dynamic subtest: vecs1
[395.052291] Dynamic subtest vecs1: SKIP (0.000s)
[395.061762] Starting dynamic subtest: ccs0
[395.063544] Dynamic subtest ccs0: SKIP (0.000s)
[395.070697] Starting dynamic subtest: ccs1
[395.073066] Dynamic subtest ccs1: SKIP (0.000s)
[395.079836] Starting dynamic subtest: ccs2
[395.081368] Dynamic subtest ccs2: SKIP (0.000s)
[395.088384] Starting dynamic subtest: ccs3
[395.090533] Dynamic subtest ccs3: SKIP (0.000s)
[395.092715] Subtest most-busy-check-all: SKIP (0.025s)
[395.104561] [083/142] (605s left) kms_vblank (pipe-d-ts-continuation-idle-hang)
[395.271300] Starting subtest: pipe-D-ts-continuation-idle-hang
[409.055280] Subtest pipe-D-ts-continuation-idle-hang: SUCCESS (13.783s)
[409.230511] [084/142] (590s left) kms_universal_plane (universal-plane-pageflip-windowed-pipe-b)
[409.361441] Starting subtest: universal-plane-pageflip-windowed-pipe-B
[410.018945] Subtest universal-plane-pageflip-windowed-pipe-B: SUCCESS (0.658s)
[410.193417] [085/142] (590s left) kms_big_fb (linear-8bpp-rotate-270)
[410.328382] Starting subtest: linear-8bpp-rotate-270
[410.376590] Subtest linear-8bpp-rotate-270: SKIP (0.048s)
[410.479244] [086/142] (589s left) v3d/v3d_submit_csd (single-in-sync)
[410.576457] Subtest single-in-sync: SKIP (0.000s)
[410.630921] [087/142] (589s left) kms_addfb_basic (clobberred-modifier)
[410.708025] Starting subtest: clobberred-modifier
[410.709582] Subtest clobberred-modifier: SKIP (0.000s)
[410.859545] [088/142] (589s left) gem_lmem_swapping (heavy-multi)
[413.576432] Starting subtest: heavy-multi
[413.577204] Starting dynamic subtest: lmem0
[418.342880] Dynamic subtest lmem0: SUCCESS (4.732s)
[418.343838] Subtest heavy-multi: SUCCESS (4.733s)
[419.974849] [089/142] (580s left) prime_vgem (basic-blt)
[420.688587] Starting subtest: basic-blt
[420.743728] Subtest basic-blt: SUCCESS (0.055s)
[420.816983] [090/142] (579s left) gem_readwrite (beyond-eob)
[420.880354] Subtest beyond-EOB: SKIP (0.000s)
[420.912540] [091/142] (579s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[420.973014] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[420.973830] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[421.036561] [092/142] (579s left) gem_ctx_param (invalid-ctx-get)
[421.095092] Starting subtest: invalid-ctx-get
[421.096145] Subtest invalid-ctx-get: SUCCESS (0.000s)
[421.159198] [093/142] (579s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[421.318613] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[432.295339] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (10.976s)
[432.454113] [094/142] (567s left) v3d/v3d_perfmon (create-perfmon-invalid-counters)
[432.537807] Subtest create-perfmon-invalid-counters: SKIP (0.000s)
[432.588126] [095/142] (567s left) gem_mmap (pf-nonblock)
[432.653131] Subtest pf-nonblock: SKIP (0.000s)
[432.678710] [096/142] (567s left) sysfs_timeslice_duration (duration)
[432.742039] Starting subtest: duration
[432.743047] Starting dynamic subtest: ccs2
[445.860494] Dynamic subtest ccs2: SUCCESS (13.097s)
[445.866980] Starting dynamic subtest: vecs0
[458.981988] Dynamic subtest vecs0: SUCCESS (13.117s)
[458.989281] Starting dynamic subtest: ccs0
[472.127556] Dynamic subtest ccs0: SUCCESS (13.162s)
[472.137647] Starting dynamic subtest: vcs0
[485.254516] Dynamic subtest vcs0: SUCCESS (13.123s)
[485.264571] Starting dynamic subtest: bcs0
[498.375511] Dynamic subtest bcs0: SUCCESS (13.116s)
[498.384667] Starting dynamic subtest: ccs3
[511.508386] Dynamic subtest ccs3: SUCCESS (13.123s)
[511.514736] Starting dynamic subtest: vecs1
[524.626264] Dynamic subtest vecs1: SUCCESS (13.121s)
[524.632730] Starting dynamic subtest: ccs1
[537.743387] Dynamic subtest ccs1: SUCCESS (13.116s)
[537.753145] Starting dynamic subtest: rcs0
[550.882513] Dynamic subtest rcs0: SUCCESS (13.135s)
[550.892464] Starting dynamic subtest: vcs1
[564.016611] Dynamic subtest vcs1: SUCCESS (13.127s)
[564.017793] Subtest duration: SUCCESS (131.272s)
[564.083194] [097/142] (436s left) gem_mmap_wc (invalid-flags)
[564.143993] Subtest invalid-flags: SKIP (0.000s)
[564.166667] [098/142] (436s left) kms_vblank (pipe-c-wait-idle)
[564.297622] Starting subtest: pipe-C-wait-idle
[566.818245] Subtest pipe-C-wait-idle: SUCCESS (2.521s)
[566.971196] [099/142] (433s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[567.113513] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[567.115141] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[567.187671] [100/142] (433s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[567.319796] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[567.320749] Starting dynamic subtest: pipe-A-valid-mode
[567.397293] Dynamic subtest pipe-A-valid-mode: SKIP (0.076s)
[567.399016] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.078s)
[567.533122] [101/142] (432s left) gem_exec_async (forked-writes)
[567.603183] Starting subtest: forked-writes
[567.603989] Starting dynamic subtest: rcs0
[567.667189] Dynamic subtest rcs0: SUCCESS (0.063s)
[567.675553] Starting dynamic subtest: bcs0
[567.712655] Dynamic subtest bcs0: SUCCESS (0.045s)
[567.719128] Starting dynamic subtest: vcs0
[567.754198] Dynamic subtest vcs0: SUCCESS (0.041s)
[567.760437] Starting dynamic subtest: vcs1
[567.795586] Dynamic subtest vcs1: SUCCESS (0.041s)
[567.801889] Starting dynamic subtest: vecs0
[567.835974] Dynamic subtest vecs0: SUCCESS (0.040s)
[567.842239] Starting dynamic subtest: vecs1
[567.876599] Dynamic subtest vecs1: SUCCESS (0.040s)
[567.882969] Starting dynamic subtest: ccs0
[567.917106] Dynamic subtest ccs0: SUCCESS (0.040s)
[567.923745] Starting dynamic subtest: ccs1
[567.958177] Dynamic subtest ccs1: SUCCESS (0.040s)
[567.964616] Starting dynamic subtest: ccs2
[568.000220] Dynamic subtest ccs2: SUCCESS (0.041s)
[568.006538] Starting dynamic subtest: ccs3
[568.041221] Dynamic subtest ccs3: SUCCESS (0.040s)
[568.042039] Subtest forked-writes: SUCCESS (0.438s)
[568.276166] [102/142] (432s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[568.441418] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[568.442971] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[568.516111] [103/142] (432s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[568.635702] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[568.652177] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.016s)
[568.716128] [104/142] (431s left) gem_userptr_blits (sd-probe)
[568.781913] Starting subtest: sd-probe
[568.783479] Subtest sd-probe: SKIP (0.000s)
[568.926377] [105/142] (431s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[569.084355] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[569.086030] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[569.166382] [106/142] (431s left) kms_cursor_edge_walk (64x64-left-edge)
[569.298463] Starting subtest: 64x64-left-edge
[569.299275] Starting dynamic subtest: pipe-A-DP-4
[572.709287] Dynamic subtest pipe-A-DP-4: SUCCESS (3.408s)
[572.716208] Starting dynamic subtest: pipe-D-DP-4
[575.992322] Dynamic subtest pipe-D-DP-4: SUCCESS (3.283s)
[575.993165] Subtest 64x64-left-edge: SUCCESS (6.694s)
[576.163490] [107/142] (424s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[576.298605] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[576.300311] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[576.379632] [108/142] (424s left) gem_exec_endless (dispatch)
[576.451221] Starting subtest: dispatch
[576.452060] Starting dynamic subtest: rcs0
[576.457416] Dynamic subtest rcs0: SUCCESS (0.005s)
[576.463708] Starting dynamic subtest: bcs0
[576.465229] Dynamic subtest bcs0: SUCCESS (0.005s)
[576.471482] Starting dynamic subtest: vcs0
[576.473153] Dynamic subtest vcs0: SUCCESS (0.004s)
[576.479427] Starting dynamic subtest: vcs1
[576.480986] Dynamic subtest vcs1: SUCCESS (0.004s)
[576.487130] Starting dynamic subtest: vecs0
[576.488780] Dynamic subtest vecs0: SUCCESS (0.004s)
[576.495129] Starting dynamic subtest: vecs1
[576.496706] Dynamic subtest vecs1: SUCCESS (0.006s)
[576.503044] Starting dynamic subtest: ccs0
[576.504555] Dynamic subtest ccs0: SUCCESS (0.006s)
[576.511618] Starting dynamic subtest: ccs1
[576.513196] Dynamic subtest ccs1: SUCCESS (0.004s)
[576.519595] Starting dynamic subtest: ccs2
[576.521250] Dynamic subtest ccs2: SUCCESS (0.004s)
[576.527639] Starting dynamic subtest: ccs3
[576.529176] Dynamic subtest ccs3: SUCCESS (0.004s)
[576.529961] Subtest dispatch: SUCCESS (0.053s)
[576.605580] [109/142] (424s left) kms_getfb (getfb-handle-not-fb)
[576.693269] Starting subtest: getfb-handle-not-fb
[576.764836] Subtest getfb-handle-not-fb: SUCCESS (0.071s)
[576.829883] [110/142] (423s left) kms_rotation_crc (primary-rotation-270)
[576.960073] Starting subtest: primary-rotation-270
[576.961767] Subtest primary-rotation-270: SKIP (0.001s)
[577.029723] [111/142] (423s left) gem_ctx_shared (single-timeline)
[577.097781] Starting subtest: single-timeline
[577.126717] Subtest single-timeline: SUCCESS (0.026s)
[577.390458] [112/142] (423s left) kms_fb_coherency (memset-crc)
[577.548517] Starting subtest: memset-crc
[577.549474] Starting dynamic subtest: mmap-offset-fixed
[578.013837] Dynamic subtest mmap-offset-fixed: SUCCESS (0.465s)
[578.086186] Subtest memset-crc: SUCCESS (0.538s)
[578.273568] [113/142] (422s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[578.333459] Starting subtest: multi-wait-available-submitted-signaled
[578.334272] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s)
[578.392465] [114/142] (422s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[578.462363] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[578.498894] [115/142] (422s left) gem_vm_create (isolation)
[578.569568] Starting subtest: isolation
[578.578358] Subtest isolation: SUCCESS (0.009s)
[578.690239] [116/142] (422s left) kms_chamelium_frames (hdmi-crc-multiple)
[578.932316] Subtest hdmi-crc-multiple: SKIP (0.000s)
[579.038516] [117/142] (421s left) i915_query (query-topology-known-pci-ids)
[579.110221] Starting subtest: query-topology-known-pci-ids
[579.111872] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[579.160363] [118/142] (421s left) syncobj_wait (multi-wait-signaled)
[579.219315] Starting subtest: multi-wait-signaled
[579.220133] Subtest multi-wait-signaled: SUCCESS (0.000s)
[579.277641] [119/142] (421s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_dg2_mc_ccs)
[579.586433] Starting subtest: pipe-D-crc-primary-basic-4_tiled_dg2_mc_ccs
[584.574472] Subtest pipe-D-crc-primary-basic-4_tiled_dg2_mc_ccs: SUCCESS (4.988s)
[584.867091] [120/142] (415s left) kms_flip (2x-flip-vs-modeset)
[584.983488] Starting subtest: 2x-flip-vs-modeset
[584.998802] Subtest 2x-flip-vs-modeset: SKIP (0.015s)
[585.065540] [121/142] (415s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[585.195689] Starting subtest: flip-vs-cursor-busy-crc-atomic
[586.005380] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.810s)
[586.196741] [122/142] (414s left) i915_pciid
[586.317176] [123/142] (414s left) v3d/v3d_submit_csd (bad-multisync-in-sync)
[586.429843] Subtest bad-multisync-in-sync: SKIP (0.000s)
[586.480647] [124/142] (414s left) i915_pm_rps (min-max-config-idle)
[586.555535] Starting subtest: min-max-config-idle
[586.557438] Subtest min-max-config-idle: SKIP (0.001s)
[586.612716] [125/142] (414s left) gem_softpin (32b-excludes-last-page)
[586.682830] Starting subtest: 32b-excludes-last-page
[586.687772] Subtest 32b-excludes-last-page: SUCCESS (0.005s)
[586.795259] [126/142] (414s left) kms_cursor_crc (cursor-sliding-32x32)
[586.983205] Starting subtest: cursor-sliding-32x32
[587.020417] Subtest cursor-sliding-32x32: SKIP (0.036s)
[587.278440] [127/142] (413s left) kms_chamelium_color (ctm-negative)
[587.410616] Subtest ctm-negative: SKIP (0.000s)
[587.438099] [128/142] (413s left) kms_ccs (pipe-a-random-ccs-data-y_tiled_gen12_rc_ccs_cc)
[587.648396] Starting subtest: pipe-A-random-ccs-data-y_tiled_gen12_rc_ccs_cc
[587.650967] Subtest pipe-A-random-ccs-data-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[587.901946] [129/142] (413s left) kms_addfb_basic (master-rmfb)
[587.961696] Starting subtest: master-rmfb
[587.962544] Subtest master-rmfb: SUCCESS (0.001s)
[588.118577] [130/142] (412s left) api_intel_bb (add-remove-objects)
[588.178690] Starting subtest: add-remove-objects
[588.200354] Subtest add-remove-objects: SUCCESS (0.022s)
[588.338593] [131/142] (412s left) perf_pmu (invalid-init)
[588.434997] Starting subtest: invalid-init
[588.435986] Subtest invalid-init: SUCCESS (0.000s)
[588.508944] [132/142] (412s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[588.665186] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[588.666955] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[588.751869] [133/142] (412s left) kms_atomic_interruptible (atomic-setmode)
[588.882794] Starting subtest: atomic-setmode
[588.883696] Starting dynamic subtest: DP-4-pipe-A
[595.150182] Dynamic subtest DP-4-pipe-A: SUCCESS (6.267s)
[595.150954] Subtest atomic-setmode: SUCCESS (6.268s)
[595.306089] [134/142] (405s left) gem_basic (multigpu-create-close)
[595.367171] Starting subtest: multigpu-create-close
[595.370842] Subtest multigpu-create-close: SKIP (0.000s)
[595.422714] [135/142] (405s left) gem_exec_suspend (basic-s3)
[595.491577] Starting subtest: basic-S3
[595.492479] Starting dynamic subtest: smem
[615.503697] Dynamic subtest smem: SUCCESS (5.334s)
[615.511382] Starting dynamic subtest: lmem0
[636.522533] Dynamic subtest lmem0: SUCCESS (4.878s)
[636.523912] Subtest basic-S3: SUCCESS (10.214s)
[636.713945] [136/142] (395s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[636.854869] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[636.856725] Subtest fbcpsr-rgb565-draw-mmap-wc: SKIP (0.000s)
[636.935293] [137/142] (395s left) kms_psr2_sf (overlay-plane-update-sf-dmg-area)
[636.997582] Subtest overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[637.027921] [138/142] (394s left) core_auth (getclient-master-drop)
[637.089745] Starting subtest: getclient-master-drop
[637.092868] Subtest getclient-master-drop: SUCCESS (0.002s)
[637.157189] [139/142] (394s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[637.231835] Starting subtest: multi-wait-all-for-submit-signaled
[637.232684] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[637.285062] [140/142] (394s left) kms_big_fb (y-tiled-addfb)
[637.431426] Starting subtest: y-tiled-addfb
[637.433067] Subtest y-tiled-addfb: SKIP (0.000s)
[637.518776] [141/142] (394s left) vc4/vc4_perfmon (create-two-perfmon)
[637.601208] Subtest create-two-perfmon: SKIP (0.000s)
[637.653532] [142/142] (394s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[637.720273] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[637.829103] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[637.889115] Closing watchdogs
Done.