[37.598744] Initializing watchdogs
[37.598799]   /dev/watchdog0
[37.604560] [001/143] (960s left) gen7_exec_parse (cmd-crossing-page)
[37.659708] Subtest cmd-crossing-page: SKIP (0.000s)
[37.691695] [002/143] (960s left) kms_atomic (atomic-plane-damage)
[37.810203] Starting subtest: atomic-plane-damage
[38.238153] Starting dynamic subtest: pipe-A-DP-4
[39.130253] Dynamic subtest pipe-A-DP-4: SUCCESS (0.892s)
[39.131336] Subtest atomic-plane-damage: SUCCESS (1.320s)
[39.377090] [003/143] (958s left) kms_ccs (pipe-b-random-ccs-data-y-tiled-gen12-mc-ccs)
[39.651070] Starting subtest: pipe-B-random-ccs-data-y-tiled-gen12-mc-ccs
[39.653923] Subtest pipe-B-random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[39.850058] [004/143] (958s left) kms_pm_rpm (legacy-planes)
[41.510097] Starting subtest: legacy-planes
[41.511575] Starting dynamic subtest: plane-40
[45.139398] Dynamic subtest plane-40: SUCCESS (3.628s)
[45.159950] Starting dynamic subtest: plane-49
[47.761211] Dynamic subtest plane-49: SUCCESS (2.620s)
[47.781495] Starting dynamic subtest: plane-58
[50.486345] Dynamic subtest plane-58: SUCCESS (2.726s)
[50.506891] Starting dynamic subtest: plane-67
[53.368056] Dynamic subtest plane-67: SUCCESS (2.881s)
[53.370372] Subtest legacy-planes: SUCCESS (11.858s)
[53.726034] [005/143] (944s left) gem_userptr_blits (sync-unmap-after-close)
[53.803712] Starting subtest: sync-unmap-after-close
[53.821517] Subtest sync-unmap-after-close: SUCCESS (0.018s)
[53.932442] [006/143] (944s left) kms_ccs (pipe-a-bad-pixel-format-4-tiled-dg2-mc-ccs)
[54.055345] Starting subtest: pipe-A-bad-pixel-format-4-tiled-dg2-mc-ccs
[54.057192] Subtest pipe-A-bad-pixel-format-4-tiled-dg2-mc-ccs: SUCCESS (0.002s)
[54.367346] [007/143] (943s left) kms_psr2_sf (cursor-plane-update-sf)
[54.431769] Subtest cursor-plane-update-sf: SKIP (0.000s)
[54.448227] [008/143] (943s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[54.625480] Starting subtest: cursor-rapid-movement-32x10
[54.667312] Subtest cursor-rapid-movement-32x10: SKIP (0.040s)
[54.933385] [009/143] (943s left) gem_exec_schedule (thriceslice)
[55.032676] Starting subtest: thriceslice
[55.033550] Starting dynamic subtest: rcs0
[55.082534] Dynamic subtest rcs0: SUCCESS (0.049s)
[55.089055] Starting dynamic subtest: bcs0
[55.131834] Dynamic subtest bcs0: SUCCESS (0.049s)
[55.154269] Starting dynamic subtest: vcs0
[55.196108] Dynamic subtest vcs0: SUCCESS (0.064s)
[55.217225] Starting dynamic subtest: vcs1
[55.263829] Dynamic subtest vcs1: SUCCESS (0.067s)
[55.285282] Starting dynamic subtest: vecs0
[55.328871] Dynamic subtest vecs0: SUCCESS (0.065s)
[55.349957] Starting dynamic subtest: vecs1
[55.391549] Dynamic subtest vecs1: SUCCESS (0.062s)
[55.413328] Starting dynamic subtest: ccs0
[55.434513] Dynamic subtest ccs0: SUCCESS (0.043s)
[55.455649] Starting dynamic subtest: ccs1
[55.476932] Dynamic subtest ccs1: SUCCESS (0.042s)
[55.497589] Starting dynamic subtest: ccs2
[55.519792] Dynamic subtest ccs2: SUCCESS (0.043s)
[55.534744] Starting dynamic subtest: ccs3
[55.580499] Dynamic subtest ccs3: SUCCESS (0.060s)
[55.582543] Subtest thriceslice: SUCCESS (0.547s)
[55.902706] [010/143] (942s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[56.052304] Starting subtest: 2x-long-flip-vs-cursor-legacy
[56.054861] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.002s)
[56.107186] [011/143] (942s left) syncobj_timeline (wait-for-submit-complex)
[56.151754] Starting subtest: wait-for-submit-complex
[56.215368] Subtest wait-for-submit-complex: SUCCESS (0.063s)
[56.307658] [012/143] (942s left) kms_ccs (pipe-d-bad-aux-stride-y-tiled-gen12-rc-ccs)
[56.590336] Starting subtest: pipe-D-bad-aux-stride-y-tiled-gen12-rc-ccs
[56.592028] Subtest pipe-D-bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[56.744101] [013/143] (941s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[56.894367] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[56.895416] Starting dynamic subtest: pipe-A-valid-mode
[56.980055] Dynamic subtest pipe-A-valid-mode: SKIP (0.083s)
[56.981870] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.084s)
[57.140627] [014/143] (941s left) gem_exec_suspend (basic-s3)
[57.232573] Starting subtest: basic-S3
[57.233619] Starting dynamic subtest: smem
[78.833500] Dynamic subtest smem: SUCCESS (6.646s)
[78.843272] Starting dynamic subtest: lmem0
[101.833421] Dynamic subtest lmem0: SUCCESS (6.535s)
[101.834239] Subtest basic-S3: SUCCESS (13.182s)
[102.006724] [015/143] (927s left) gem_render_copy (yf-tiled-ccs-to-linear)
[102.059907] Starting subtest: yf-tiled-ccs-to-linear
[102.061596] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[102.256778] [016/143] (927s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[102.305004] Starting subtest: y-tiled-ccs-to-x-tiled
[102.307454] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[102.507614] [017/143] (927s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[102.649473] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[103.855304] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.205s)
[103.951948] [018/143] (926s left) core_auth (getclient-simple)
[104.001413] Starting subtest: getclient-simple
[104.003206] Subtest getclient-simple: SUCCESS (0.002s)
[104.075732] [019/143] (925s left) gem_eio (in-flight-internal-immediate)
[104.369354] Starting subtest: in-flight-internal-immediate
[105.834070] Subtest in-flight-internal-immediate: SUCCESS (1.465s)
[105.970247] [020/143] (924s left) gem_exec_balancer (full)
[106.023942] Starting subtest: full
[107.265495] Subtest full: SUCCESS (1.241s)
[107.561531] [021/143] (922s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[107.762802] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[107.876262] [022/143] (922s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[107.940108] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[107.968301] [023/143] (922s left) kms_ccs (pipe-a-crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[108.171762] Starting subtest: pipe-A-crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[108.602229] Subtest pipe-A-crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SUCCESS (0.429s)
[108.976204] [024/143] (921s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[109.136409] Starting subtest: 4-tiled-8bpp-rotate-180
[110.540365] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.398s)
[110.675972] [025/143] (919s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[110.723067] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[110.743116] [026/143] (919s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[110.858535] Starting subtest: pipe-fbc-rte
[110.863132] Subtest pipe-fbc-rte: SKIP (0.000s)
[110.938385] [027/143] (919s left) kms_big_fb (y-tiled-addfb)
[111.070569] Starting subtest: y-tiled-addfb
[111.072340] Subtest y-tiled-addfb: SKIP (0.000s)
[111.135243] [028/143] (919s left) gem_mmap_wc (bad-size)
[111.187783] Subtest bad-size: SKIP (0.000s)
[111.211781] [029/143] (918s left) gem_mmap_wc (fault-concurrent)
[111.271243] Subtest fault-concurrent: SKIP (0.000s)
[111.292958] [030/143] (918s left) gem_exec_schedule (implicit-boths)
[111.344234] Starting subtest: implicit-boths
[111.345208] Starting dynamic subtest: rcs0
[111.619299] Dynamic subtest rcs0: SUCCESS (0.267s)
[111.626939] Starting dynamic subtest: bcs0
[111.803822] Dynamic subtest bcs0: SUCCESS (0.185s)
[111.811589] Starting dynamic subtest: vcs0
[111.995195] Dynamic subtest vcs0: SUCCESS (0.192s)
[112.002780] Starting dynamic subtest: vcs1
[112.191268] Dynamic subtest vcs1: SUCCESS (0.193s)
[112.198952] Starting dynamic subtest: vecs0
[112.376178] Dynamic subtest vecs0: SUCCESS (0.193s)
[112.383794] Starting dynamic subtest: vecs1
[112.571445] Dynamic subtest vecs1: SUCCESS (0.195s)
[112.579186] Starting dynamic subtest: ccs0
[112.768844] Dynamic subtest ccs0: SUCCESS (0.197s)
[112.776802] Starting dynamic subtest: ccs1
[112.995588] Dynamic subtest ccs1: SUCCESS (0.227s)
[113.003084] Starting dynamic subtest: ccs2
[113.187781] Dynamic subtest ccs2: SUCCESS (0.192s)
[113.195288] Starting dynamic subtest: ccs3
[113.380234] Dynamic subtest ccs3: SUCCESS (0.192s)
[113.381119] Subtest implicit-boths: SUCCESS (2.036s)
[113.784804] [031/143] (916s left) gem_ctx_engines (independent)
[113.858125] Starting subtest: independent
[113.859146] Starting dynamic subtest: rcs0
[113.976076] Dynamic subtest rcs0: SUCCESS (0.118s)
[113.983450] Starting dynamic subtest: bcs0
[114.092705] Dynamic subtest bcs0: SUCCESS (0.116s)
[114.100195] Starting dynamic subtest: vcs0
[114.219683] Dynamic subtest vcs0: SUCCESS (0.128s)
[114.226934] Starting dynamic subtest: vcs1
[114.335250] Dynamic subtest vcs1: SUCCESS (0.115s)
[114.342509] Starting dynamic subtest: vecs0
[114.451661] Dynamic subtest vecs0: SUCCESS (0.115s)
[114.458878] Starting dynamic subtest: vecs1
[114.565516] Dynamic subtest vecs1: SUCCESS (0.115s)
[114.572957] Starting dynamic subtest: ccs0
[114.686266] Dynamic subtest ccs0: SUCCESS (0.121s)
[114.693599] Starting dynamic subtest: ccs1
[114.804743] Dynamic subtest ccs1: SUCCESS (0.118s)
[114.812192] Starting dynamic subtest: ccs2
[114.922725] Dynamic subtest ccs2: SUCCESS (0.118s)
[114.930089] Starting dynamic subtest: ccs3
[115.039049] Dynamic subtest ccs3: SUCCESS (0.115s)
[115.046722] Starting dynamic subtest: all-engines
[115.430325] Dynamic subtest all-engines: SUCCESS (0.392s)
[115.431275] Subtest independent: SUCCESS (1.572s)
[116.655834] [032/143] (913s left) gem_render_copy_redux (flink-interruptible)
[116.705704] Starting subtest: flink-interruptible
[118.094156] Subtest flink-interruptible: SUCCESS (1.388s)
[118.251133] [033/143] (912s left) kms_setmode (invalid-clone-single-crtc)
[118.304838] Starting subtest: invalid-clone-single-crtc
[118.307608] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[118.370166] [034/143] (911s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[118.488467] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[118.490080] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[118.596710] [035/143] (911s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[118.676472] Starting subtest: invalid-bsd1-flag-on-blt
[118.677437] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[118.790092] [036/143] (911s left) kms_ccs (pipe-a-ccs-on-another-bo-y-tiled-ccs)
[119.036182] Starting subtest: pipe-A-ccs-on-another-bo-y-tiled-ccs
[119.037830] Subtest pipe-A-ccs-on-another-bo-y-tiled-ccs: SKIP (0.000s)
[119.258114] [037/143] (911s left) gem_exec_reloc (basic-gtt-read-noreloc)
[119.334098] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[119.368425] [038/143] (911s left) gem_softpin (allocator-evict)
[119.415835] Starting subtest: allocator-evict
[119.416819] Starting dynamic subtest: rcs0
[145.687589] Dynamic subtest rcs0: SUCCESS (26.271s)
[145.695845] Starting dynamic subtest: bcs0
[171.928549] Dynamic subtest bcs0: SUCCESS (26.241s)
[171.936637] Starting dynamic subtest: vcs0
[198.524597] Dynamic subtest vcs0: SUCCESS (26.596s)
[198.532522] Starting dynamic subtest: vcs1
[224.956658] Dynamic subtest vcs1: SUCCESS (26.432s)
[224.964697] Starting dynamic subtest: vecs0
[251.264786] Dynamic subtest vecs0: SUCCESS (26.308s)
[251.272702] Starting dynamic subtest: vecs1
[277.589434] Dynamic subtest vecs1: SUCCESS (26.325s)
[277.597339] Starting dynamic subtest: ccs0
[304.263136] Dynamic subtest ccs0: SUCCESS (26.673s)
[304.271262] Starting dynamic subtest: ccs1
[331.131803] Dynamic subtest ccs1: SUCCESS (26.868s)
[331.140237] Starting dynamic subtest: ccs2
[357.882287] Dynamic subtest ccs2: SUCCESS (26.749s)
[357.890379] Starting dynamic subtest: ccs3
[384.146897] Dynamic subtest ccs3: SUCCESS (26.266s)
[384.147745] Subtest allocator-evict: SUCCESS (264.731s)
[384.338753] [039/143] (646s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[384.504541] Starting subtest: fbcpsr-tiling-4
[384.506467] Subtest fbcpsr-tiling-4: SKIP (0.000s)
[384.654377] [040/143] (645s left) gem_exec_fence (syncobj-wait)
[385.424265] Starting subtest: syncobj-wait
[385.556478] Subtest syncobj-wait: SUCCESS (0.132s)
[385.901380] [041/143] (644s left) kms_ccs (pipe-b-ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[386.150553] Starting subtest: pipe-B-ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[386.152553] Subtest pipe-B-ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[386.383777] [042/143] (644s left) kms_ccs (pipe-d-crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[386.697753] Starting subtest: pipe-D-crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[386.699727] Subtest pipe-D-crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[386.892542] [043/143] (643s left) gem_close_race (multigpu-basic-threads)
[386.981003] Starting subtest: multigpu-basic-threads
[386.983104] Subtest multigpu-basic-threads: SKIP (0.000s)
[387.196751] [044/143] (643s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[387.316960] Starting subtest: fbcpsr-indfb-scaledprimary
[387.318594] Subtest fbcpsr-indfb-scaledprimary: SKIP (0.000s)
[387.401791] [045/143] (643s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[387.550693] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[387.552405] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[387.633915] [046/143] (642s left) v3d/v3d_perfmon (get-values-invalid-pad)
[387.712185] Subtest get-values-invalid-pad: SKIP (0.000s)
[387.762286] [047/143] (642s left) v3d/v3d_submit_csd (bad-extension)
[387.828128] Subtest bad-extension: SKIP (0.000s)
[387.879970] [048/143] (642s left) kms_ccs (pipe-c-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[388.147119] Starting subtest: pipe-C-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[388.149932] Subtest pipe-C-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.002s)
[388.337585] [049/143] (642s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[388.467550] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[389.512570] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (1.045s)
[389.647357] [050/143] (641s left) kms_ccs (pipe-d-random-ccs-data-y-tiled-gen12-rc-ccs)
[389.920776] Starting subtest: pipe-D-random-ccs-data-y-tiled-gen12-rc-ccs
[389.923522] Subtest pipe-D-random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[390.102575] [051/143] (640s left) kms_addfb_basic (addfb25-modifier-no-flag)
[390.175374] Starting subtest: addfb25-modifier-no-flag
[390.176323] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[390.308329] [052/143] (640s left) kms_ccs (pipe-c-crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[390.558887] Starting subtest: pipe-C-crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[395.339952] Subtest pipe-C-crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SUCCESS (4.781s)
[395.654476] [053/143] (635s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[395.786942] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[395.788700] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[395.878701] [054/143] (634s left) kms_plane (pixel-format-source-clamping)
[396.001375] Starting subtest: pixel-format-source-clamping
[396.002307] Starting dynamic subtest: pipe-A
[408.825915] Dynamic subtest pipe-A: SUCCESS (12.822s)
[408.850818] Starting dynamic subtest: pipe-B
[421.330932] Dynamic subtest pipe-B: SUCCESS (12.502s)
[421.331776] Subtest pixel-format-source-clamping: SUCCESS (25.330s)
[421.578245] [055/143] (609s left) gem_partial_pwrite_pread (writes-after-reads)
[421.658686] Subtest writes-after-reads: SKIP (0.000s)
[421.698159] [056/143] (609s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[421.813254] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s)
[421.848881] [057/143] (609s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[421.893874] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[421.894700] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[421.957843] [058/143] (608s left) drm_fdinfo (busy)
[422.009226] Starting subtest: busy
[422.010099] Starting dynamic subtest: rcs0
[422.011824] Dynamic subtest rcs0: SKIP (0.000s)
[422.020637] Starting dynamic subtest: bcs0
[422.022328] Dynamic subtest bcs0: SKIP (0.000s)
[422.030626] Starting dynamic subtest: vcs0
[422.033195] Dynamic subtest vcs0: SKIP (0.000s)
[422.042351] Starting dynamic subtest: vcs1
[422.044800] Dynamic subtest vcs1: SKIP (0.000s)
[422.053300] Starting dynamic subtest: vecs0
[422.056730] Dynamic subtest vecs0: SKIP (0.000s)
[422.065451] Starting dynamic subtest: vecs1
[422.068145] Dynamic subtest vecs1: SKIP (0.000s)
[422.077188] Starting dynamic subtest: ccs0
[422.079731] Dynamic subtest ccs0: SKIP (0.000s)
[422.088795] Starting dynamic subtest: ccs1
[422.091438] Dynamic subtest ccs1: SKIP (0.000s)
[422.099956] Starting dynamic subtest: ccs2
[422.101525] Dynamic subtest ccs2: SKIP (0.000s)
[422.110122] Starting dynamic subtest: ccs3
[422.112514] Dynamic subtest ccs3: SKIP (0.000s)
[422.115211] Subtest busy: SKIP (0.005s)
[422.129402] [059/143] (608s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[422.252180] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[422.254087] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[422.346200] [060/143] (608s left) api_intel_bb (delta-check)
[422.402239] Starting subtest: delta-check
[422.423796] Subtest delta-check: SUCCESS (0.022s)
[422.560142] [061/143] (608s left) prime_mmap (test_invalid_sync_flags)
[422.639886] Starting subtest: test_invalid_sync_flags
[422.640949] Starting dynamic subtest: test_invalid_sync_flags-smem
[422.641966] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[422.651448] Starting dynamic subtest: test_invalid_sync_flags-lmem0
[422.652322] Dynamic subtest test_invalid_sync_flags-lmem0: SUCCESS (0.000s)
[422.653413] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[422.741761] [062/143] (608s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[422.894901] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[422.896561] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[422.979961] [063/143] (608s left) gem_eio (suspend)
[423.309068] Starting subtest: suspend
[437.315946] Subtest suspend: SUCCESS (14.007s)
[437.446573] [064/143] (593s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[437.562353] Starting subtest: cursorB-vs-flipA-atomic-transitions
[437.565353] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.002s)
[437.632666] [065/143] (593s left) kms_flip (nonexisting-fb-interruptible)
[437.764068] Starting subtest: nonexisting-fb-interruptible
[437.772608] Starting dynamic subtest: A-DP4
[438.093444] Dynamic subtest A-DP4: SUCCESS (0.320s)
[438.128176] Starting dynamic subtest: B-DP4
[438.363687] Dynamic subtest B-DP4: SUCCESS (0.267s)
[438.396460] Starting dynamic subtest: C-DP4
[438.631339] Dynamic subtest C-DP4: SUCCESS (0.265s)
[438.667454] Starting dynamic subtest: D-DP4
[438.903306] Dynamic subtest D-DP4: SUCCESS (0.269s)
[438.907922] Subtest nonexisting-fb-interruptible: SUCCESS (1.142s)
[439.227079] [066/143] (591s left) gem_exercise_blt (fast-copy-emit)
[439.311630] Starting subtest: fast-copy-emit
[439.312721] Starting dynamic subtest: linear-smem-smem-emit
[439.354334] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.042s)
[439.368823] Starting dynamic subtest: linear-smem-lmem0-emit
[439.374100] Dynamic subtest linear-smem-lmem0-emit: SUCCESS (0.018s)
[439.392487] Starting dynamic subtest: linear-lmem0-smem-emit
[439.495463] Dynamic subtest linear-lmem0-smem-emit: SUCCESS (0.120s)
[439.503854] Starting dynamic subtest: linear-lmem0-lmem0-emit
[439.603536] Dynamic subtest linear-lmem0-lmem0-emit: SUCCESS (0.108s)
[439.612082] Starting dynamic subtest: xmajor-smem-smem-emit
[439.616505] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.012s)
[439.625142] Starting dynamic subtest: xmajor-smem-lmem0-emit
[439.629212] Dynamic subtest xmajor-smem-lmem0-emit: SUCCESS (0.012s)
[439.637873] Starting dynamic subtest: xmajor-lmem0-smem-emit
[439.740710] Dynamic subtest xmajor-lmem0-smem-emit: SUCCESS (0.111s)
[439.749358] Starting dynamic subtest: xmajor-lmem0-lmem0-emit
[439.850558] Dynamic subtest xmajor-lmem0-lmem0-emit: SUCCESS (0.109s)
[439.859189] Starting dynamic subtest: tile4-smem-smem-emit
[439.865297] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.014s)
[439.873884] Starting dynamic subtest: tile4-smem-lmem0-emit
[439.877785] Dynamic subtest tile4-smem-lmem0-emit: SUCCESS (0.012s)
[439.886526] Starting dynamic subtest: tile4-lmem0-smem-emit
[439.987268] Dynamic subtest tile4-lmem0-smem-emit: SUCCESS (0.109s)
[439.995881] Starting dynamic subtest: tile4-lmem0-lmem0-emit
[440.099357] Dynamic subtest tile4-lmem0-lmem0-emit: SUCCESS (0.112s)
[440.108035] Starting dynamic subtest: tile64-smem-smem-emit
[440.113653] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.014s)
[440.122359] Starting dynamic subtest: tile64-smem-lmem0-emit
[440.126311] Dynamic subtest tile64-smem-lmem0-emit: SUCCESS (0.012s)
[440.135043] Starting dynamic subtest: tile64-lmem0-smem-emit
[440.235577] Dynamic subtest tile64-lmem0-smem-emit: SUCCESS (0.109s)
[440.244273] Starting dynamic subtest: tile64-lmem0-lmem0-emit
[440.344555] Dynamic subtest tile64-lmem0-lmem0-emit: SUCCESS (0.108s)
[440.345569] Subtest fast-copy-emit: SUCCESS (1.033s)
[440.445558] [067/143] (590s left) tools_test (sysfs_l3_parity)
[440.498938] Starting subtest: sysfs_l3_parity
[440.543499] Subtest sysfs_l3_parity: SKIP (0.055s)
[440.598701] [068/143] (590s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[440.714859] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[440.727552] Starting dynamic subtest: pipe-A-DP-4
[441.275651] Dynamic subtest pipe-A-DP-4: SUCCESS (0.548s)
[441.297161] Starting dynamic subtest: pipe-B-DP-4
[441.948934] Dynamic subtest pipe-B-DP-4: SUCCESS (0.661s)
[441.971249] Starting dynamic subtest: pipe-C-DP-4
[442.605950] Dynamic subtest pipe-C-DP-4: SUCCESS (0.644s)
[442.627627] Starting dynamic subtest: pipe-D-DP-4
[443.246645] Dynamic subtest pipe-D-DP-4: SUCCESS (0.628s)
[443.247622] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (2.532s)
[443.568187] [069/143] (587s left) gem_exec_fence (basic-wait)
[443.743933] Starting subtest: basic-wait
[443.745280] Starting dynamic subtest: rcs0
[443.848990] Dynamic subtest rcs0: SUCCESS (0.104s)
[443.865508] Starting dynamic subtest: bcs0
[443.905845] Dynamic subtest bcs0: SUCCESS (0.055s)
[443.918735] Starting dynamic subtest: vcs0
[443.962870] Dynamic subtest vcs0: SUCCESS (0.056s)
[444.000220] Starting dynamic subtest: vcs1
[444.024978] Dynamic subtest vcs1: SUCCESS (0.060s)
[444.045042] Starting dynamic subtest: vecs0
[444.081411] Dynamic subtest vecs0: SUCCESS (0.055s)
[444.093571] Starting dynamic subtest: vecs1
[444.135863] Dynamic subtest vecs1: SUCCESS (0.053s)
[444.152595] Starting dynamic subtest: ccs0
[444.191823] Dynamic subtest ccs0: SUCCESS (0.054s)
[444.229792] Starting dynamic subtest: ccs1
[444.250253] Dynamic subtest ccs1: SUCCESS (0.057s)
[444.269690] Starting dynamic subtest: ccs2
[444.299930] Dynamic subtest ccs2: SUCCESS (0.048s)
[444.322498] Starting dynamic subtest: ccs3
[444.356556] Dynamic subtest ccs3: SUCCESS (0.055s)
[444.357941] Subtest basic-wait: SUCCESS (0.614s)
[445.262762] [070/143] (585s left) gem_basic (create-close)
[445.308548] Starting subtest: create-close
[445.310852] Subtest create-close: SUCCESS (0.000s)
[445.395043] [071/143] (585s left) gen9_exec_parse (unaligned-jump)
[445.443761] Subtest unaligned-jump: SKIP (0.000s)
[445.464450] [072/143] (585s left) kms_chamelium_color (ctm-negative)
[445.580761] Subtest ctm-negative: SKIP (0.000s)
[445.614419] [073/143] (585s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[445.657982] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[445.765202] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.105s)
[445.885833] [074/143] (585s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[446.008847] Starting subtest: fb-8bpc-vs-panel-6bpc
[446.009907] Starting dynamic subtest: pipe-A-DP-4
[446.389237] Dynamic subtest pipe-A-DP-4: SUCCESS (0.376s)
[446.391071] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (0.378s)
[446.575696] [075/143] (584s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[446.727115] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[446.728855] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[446.821512] [076/143] (584s left) vgem_basic (setversion)
[446.896640] Starting subtest: setversion
[446.899054] Subtest setversion: SUCCESS (0.000s)
[446.962267] [077/143] (584s left) gem_exec_reloc (basic-cpu-read-noreloc)
[447.038286] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[447.073672] [078/143] (584s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[447.121434] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[447.123567] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[447.319594] [079/143] (584s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[447.432385] Starting subtest: cursor-vs-flip-atomic
[476.038397] Subtest cursor-vs-flip-atomic: SUCCESS (28.606s)
[476.251947] [080/143] (555s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[476.393302] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[476.395256] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[476.464684] [081/143] (555s left) i915_pm_freq_api (freq-reset-multiple)
[476.527757] Starting subtest: freq-reset-multiple
[476.528719] Starting dynamic subtest: gt0
[496.706491] Dynamic subtest gt0: SUCCESS (20.178s)
[496.707507] Subtest freq-reset-multiple: SUCCESS (20.178s)
[496.762569] [082/143] (534s left) kms_ccs (pipe-b-missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[496.977537] Starting subtest: pipe-B-missing-ccs-buffer-4-tiled-mtl-rc-ccs
[496.979490] Subtest pipe-B-missing-ccs-buffer-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[497.196185] [083/143] (534s left) gem_readwrite (beyond-eob)
[497.277264] Subtest beyond-EOB: SKIP (0.000s)
[497.309274] [084/143] (534s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[497.429661] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[497.431289] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[497.524208] [085/143] (534s left) drm_fdinfo (virtual-busy)
[497.592967] Starting subtest: virtual-busy
[497.594661] Subtest virtual-busy: SKIP (0.000s)
[497.655132] [086/143] (533s left) kms_cursor_edge_walk (256x256-top-edge)
[497.797158] Starting subtest: 256x256-top-edge
[497.798034] Starting dynamic subtest: pipe-A-DP-4
[501.229011] Dynamic subtest pipe-A-DP-4: SUCCESS (3.431s)
[501.240971] Starting dynamic subtest: pipe-D-DP-4
[504.521827] Dynamic subtest pipe-D-DP-4: SUCCESS (3.291s)
[504.522789] Subtest 256x256-top-edge: SUCCESS (6.726s)
[504.745452] [087/143] (526s left) gem_eio (in-flight-contexts-10ms)
[505.063907] Starting subtest: in-flight-contexts-10ms
[518.863554] Subtest in-flight-contexts-10ms: SUCCESS (13.801s)
[519.010379] [088/143] (512s left) kms_cursor_crc (cursor-onscreen-128x128)
[519.238330] Starting subtest: cursor-onscreen-128x128
[519.242692] Starting dynamic subtest: pipe-A-DP-4
[521.899050] Dynamic subtest pipe-A-DP-4: SUCCESS (2.656s)
[521.948379] Starting dynamic subtest: pipe-D-DP-4
[524.599629] Dynamic subtest pipe-D-DP-4: SUCCESS (2.659s)
[524.600740] Subtest cursor-onscreen-128x128: SUCCESS (5.361s)
[525.021740] [089/143] (506s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[525.083000] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[525.189110] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[525.274833] [090/143] (506s left) kms_psr2_su (page_flip-nv12)
[525.320666] Subtest page_flip-NV12: SKIP (0.000s)
[525.346059] [091/143] (506s left) gem_exec_schedule (u-semaphore-noskip)
[525.403277] Starting subtest: u-semaphore-noskip
[527.021395] Subtest u-semaphore-noskip: SUCCESS (1.617s)
[527.393965] [092/143] (504s left) gem_lmem_swapping (parallel-random)
[530.164600] Starting subtest: parallel-random
[530.165520] Starting dynamic subtest: lmem0
[562.837809] Dynamic subtest lmem0: SUCCESS (32.673s)
[562.838621] Subtest parallel-random: SUCCESS (32.673s)
[564.012926] [093/143] (467s left) gem_mmap_offset (perf)
[564.775525] Starting subtest: perf
[564.776365] Starting dynamic subtest: lmem0
[565.060167] Dynamic subtest lmem0: SUCCESS (0.284s)
[565.071444] Starting dynamic subtest: smem0
[565.077682] Dynamic subtest smem0: SUCCESS (0.003s)
[565.078882] Subtest perf: SUCCESS (0.288s)
[565.117834] [094/143] (466s left) vc4/vc4_wait_bo (bad-pad)
[565.188197] Subtest bad-pad: SKIP (0.000s)
[565.239340] [095/143] (466s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[565.365726] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[565.367622] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[565.439894] [096/143] (466s left) kms_psr (psr-cursor-render)
[565.572681] Subtest psr-cursor-render: SKIP (0.000s)
[565.596819] [097/143] (466s left) syncobj_wait (invalid-single-wait-unsubmitted)
[565.641630] Starting subtest: invalid-single-wait-unsubmitted
[565.642718] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[565.707667] [098/143] (466s left) gem_madvise (dontneed-before-exec)
[565.761702] Starting subtest: dontneed-before-exec
[565.764489] Subtest dontneed-before-exec: SKIP (0.002s)
[565.797244] [099/143] (466s left) gem_exec_fair (basic-deadline)
[565.853610] Subtest basic-deadline: SKIP (0.000s)
[565.897467] [100/143] (466s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[566.029706] Starting subtest: 4-tiled-16bpp-rotate-270
[566.093348] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.060s)
[566.250665] [101/143] (465s left) i915_suspend (fence-restore-tiled2untiled)
[566.321798] Starting subtest: fence-restore-tiled2untiled
[566.323872] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[566.392238] [102/143] (465s left) sriov_basic (enable-vfs-bind-unbind-each)
[566.440420] Subtest enable-vfs-bind-unbind-each: SKIP (0.000s)
[566.463799] [103/143] (465s left) kms_sequence (get-busy)
[566.578752] Starting subtest: get-busy
[566.579716] Starting dynamic subtest: pipe-A-DP-4
[569.096486] Dynamic subtest pipe-A-DP-4: SUCCESS (2.516s)
[569.108533] Starting dynamic subtest: pipe-B-DP-4
[571.570046] Dynamic subtest pipe-B-DP-4: SUCCESS (2.472s)
[571.578935] Starting dynamic subtest: pipe-C-DP-4
[574.042078] Dynamic subtest pipe-C-DP-4: SUCCESS (2.470s)
[574.051466] Starting dynamic subtest: pipe-D-DP-4
[576.533607] Dynamic subtest pipe-D-DP-4: SUCCESS (2.490s)
[576.534637] Subtest get-busy: SUCCESS (9.954s)
[576.746295] [104/143] (455s left) gem_userptr_blits (mmap-offset-banned)
[576.818155] Starting subtest: mmap-offset-banned
[576.819083] Starting dynamic subtest: fixed
[576.820014] Dynamic subtest fixed: SUCCESS (0.000s)
[576.820973] Subtest mmap-offset-banned: SUCCESS (0.001s)
[576.929365] [105/143] (455s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[577.048887] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[577.050552] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[577.121717] [106/143] (454s left) syncobj_timeline (signal-point-0)
[577.180255] Starting subtest: signal-point-0
[577.181286] Subtest signal-point-0: SUCCESS (0.000s)
[577.254184] [107/143] (454s left) gem_set_tiling_vs_pwrite
[577.363059] [108/143] (454s left) kms_vrr (flip-dpms)
[577.493782] Starting subtest: flip-dpms
[577.495911] Subtest flip-dpms: SKIP (0.000s)
[577.552378] [109/143] (454s left) gem_ctx_param (invalid-param-set)
[577.597245] Starting subtest: invalid-param-set
[577.598090] Subtest invalid-param-set: SUCCESS (0.000s)
[577.653915] [110/143] (454s left) kms_lease (invalid-create-leases)
[577.780729] Starting subtest: invalid-create-leases
[577.785578] Subtest invalid-create-leases: SUCCESS (0.004s)
[577.853904] [111/143] (454s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[577.982245] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[577.983900] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[578.055844] [112/143] (454s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-render)
[578.198559] Starting subtest: psr-1p-offscren-pri-indfb-draw-render
[578.200447] Subtest psr-1p-offscren-pri-indfb-draw-render: SKIP (0.000s)
[578.271908] [113/143] (453s left) kms_ccs (pipe-d-bad-rotation-90-yf-tiled-ccs)
[578.537706] Starting subtest: pipe-D-bad-rotation-90-yf-tiled-ccs
[578.539482] Subtest pipe-D-bad-rotation-90-yf-tiled-ccs: SKIP (0.000s)
[578.714360] [114/143] (453s left) kms_ccs (pipe-c-ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[578.989049] Starting subtest: pipe-C-ccs-on-another-bo-4-tiled-mtl-rc-ccs
[578.991010] Subtest pipe-C-ccs-on-another-bo-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[579.170301] [115/143] (453s left) kms_psr (pr-primary-render)
[579.315497] Subtest pr-primary-render: SKIP (0.000s)
[579.348268] [116/143] (452s left) gem_ctx_shared (single-timeline)
[579.401291] Starting subtest: single-timeline
[579.434522] Subtest single-timeline: SUCCESS (0.029s)
[579.698381] [117/143] (452s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[579.927381] Starting subtest: pipe-A-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[579.930434] Subtest pipe-A-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.002s)
[580.154648] [118/143] (452s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[580.283614] Starting subtest: cursorA-vs-flipB-toggle
[580.285542] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[580.344186] [119/143] (452s left) syncobj_wait (wait-all-complex)
[580.387417] Starting subtest: wait-all-complex
[580.606548] Subtest wait-all-complex: SUCCESS (0.218s)
[580.717184] [120/143] (451s left) gem_ctx_param (invalid-set-no-zeromap)
[580.762177] Starting subtest: invalid-set-no-zeromap
[580.763006] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[580.830358] [121/143] (451s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[580.948268] Starting subtest: flip-vs-cursor-varying-size
[589.617640] Subtest flip-vs-cursor-varying-size: SUCCESS (8.670s)
[589.819304] [122/143] (442s left) kms_content_protection (lic)
[590.006832] Starting subtest: lic
[590.035758] Starting dynamic subtest: pipe-A-DP-4
[710.705640] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[710.991426] Closing watchdogs
[710.992527] Initializing watchdogs
[710.992566]   /dev/watchdog0
[711.002387] [123/143] (321s left) kms_psr (fbc-psr-sprite-blt)
[711.118818] Subtest fbc-psr-sprite-blt: SKIP (0.000s)
[711.148507] [124/143] (321s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[711.263997] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[711.264835] Starting dynamic subtest: pipe-A-valid-mode
[713.693855] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.427s)
[713.695724] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SUCCESS (2.429s)
[713.908893] [125/143] (318s left) kms_universal_plane (disable-primary-vs-flip)
[714.038250] Starting subtest: disable-primary-vs-flip
[714.040434] Starting dynamic subtest: pipe-A-DP-4
[714.564840] Dynamic subtest pipe-A-DP-4: SUCCESS (0.525s)
[714.573943] Starting dynamic subtest: pipe-B-DP-4
[715.012870] Dynamic subtest pipe-B-DP-4: SUCCESS (0.447s)
[715.029335] Starting dynamic subtest: pipe-C-DP-4
[715.473259] Dynamic subtest pipe-C-DP-4: SUCCESS (0.458s)
[715.482666] Starting dynamic subtest: pipe-D-DP-4
[715.946927] Dynamic subtest pipe-D-DP-4: SUCCESS (0.471s)
[715.948220] Subtest disable-primary-vs-flip: SUCCESS (1.908s)
[716.174847] [126/143] (316s left) perf_pmu (busy-double-start)
[716.239017] Starting subtest: busy-double-start
[716.239927] Starting dynamic subtest: rcs0
[719.840244] Dynamic subtest rcs0: SUCCESS (3.600s)
[719.851686] Starting dynamic subtest: bcs0
[723.422147] Dynamic subtest bcs0: SUCCESS (3.579s)
[723.433856] Starting dynamic subtest: vcs0
[726.996548] Dynamic subtest vcs0: SUCCESS (3.572s)
[727.007947] Starting dynamic subtest: vcs1
[730.577319] Dynamic subtest vcs1: SUCCESS (3.578s)
[730.588503] Starting dynamic subtest: vecs0
[734.146393] Dynamic subtest vecs0: SUCCESS (3.567s)
[734.157838] Starting dynamic subtest: vecs1
[737.715376] Dynamic subtest vecs1: SUCCESS (3.566s)
[737.726525] Starting dynamic subtest: ccs0
[741.298233] Dynamic subtest ccs0: SUCCESS (3.580s)
[741.309760] Starting dynamic subtest: ccs1
[744.885263] Dynamic subtest ccs1: SUCCESS (3.584s)
[744.896858] Starting dynamic subtest: ccs2
[748.464296] Dynamic subtest ccs2: SUCCESS (3.576s)
[748.475892] Starting dynamic subtest: ccs3
[752.044387] Dynamic subtest ccs3: SUCCESS (3.577s)
[752.046104] Subtest busy-double-start: SUCCESS (35.806s)
[752.120192] [127/143] (280s left) kms_prop_blob (blob-prop-validate)
[752.164405] Starting subtest: blob-prop-validate
[752.165355] Subtest blob-prop-validate: SUCCESS (0.000s)
[752.235915] [128/143] (280s left) vc4/vc4_perfmon (create-single-perfmon)
[752.309446] Subtest create-single-perfmon: SKIP (0.000s)
[752.360922] [129/143] (280s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[752.480116] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[755.292822] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (2.813s)
[755.453732] [130/143] (277s left) gem_ctx_persistence (userptr)
[755.501607] Starting subtest: userptr
[755.657538] Subtest userptr: SUCCESS (0.155s)
[755.774572] [131/143] (276s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[755.899046] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[755.900674] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[755.979940] [132/143] (276s left) perf_pmu (semaphore-busy)
[756.038961] Starting subtest: semaphore-busy
[756.039807] Starting dynamic subtest: rcs0
[757.687360] Dynamic subtest rcs0: SUCCESS (1.645s)
[757.698709] Starting dynamic subtest: bcs0
[759.326808] Dynamic subtest bcs0: SUCCESS (1.637s)
[759.335472] Starting dynamic subtest: vcs0
[760.957209] Dynamic subtest vcs0: SUCCESS (1.627s)
[760.965699] Starting dynamic subtest: vcs1
[762.591571] Dynamic subtest vcs1: SUCCESS (1.632s)
[762.599842] Starting dynamic subtest: vecs0
[764.228353] Dynamic subtest vecs0: SUCCESS (1.634s)
[764.240661] Starting dynamic subtest: vecs1
[765.865085] Dynamic subtest vecs1: SUCCESS (1.634s)
[765.873538] Starting dynamic subtest: ccs0
[767.500947] Dynamic subtest ccs0: SUCCESS (1.633s)
[767.509339] Starting dynamic subtest: ccs1
[769.135992] Dynamic subtest ccs1: SUCCESS (1.632s)
[769.144449] Starting dynamic subtest: ccs2
[770.771015] Dynamic subtest ccs2: SUCCESS (1.632s)
[770.779414] Starting dynamic subtest: ccs3
[772.409013] Dynamic subtest ccs3: SUCCESS (1.635s)
[772.410301] Subtest semaphore-busy: SUCCESS (16.369s)
[772.531299] [133/143] (260s left) v3d/v3d_create_bo (create-bo-4096)
[772.593197] Subtest create-bo-4096: SKIP (0.000s)
[772.647612] [134/143] (260s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[772.850851] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[772.966371] [135/143] (259s left) gem_pread (snoop)
[773.030928] Subtest snoop: SKIP (0.000s)
[773.078104] [136/143] (259s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[773.200309] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[773.212830] Starting dynamic subtest: pipe-A-DP-4
[773.314516] Dynamic subtest pipe-A-DP-4: SUCCESS (0.101s)
[773.342190] Starting dynamic subtest: pipe-B-DP-4
[773.538841] Dynamic subtest pipe-B-DP-4: SUCCESS (0.211s)
[773.561886] Starting dynamic subtest: pipe-C-DP-4
[773.745835] Dynamic subtest pipe-C-DP-4: SUCCESS (0.194s)
[773.772408] Starting dynamic subtest: pipe-D-DP-4
[773.971451] Dynamic subtest pipe-D-DP-4: SUCCESS (0.212s)
[773.972371] Subtest planes-upscale-20x20-downscale-factor-0-5: SUCCESS (0.773s)
[774.227128] [137/143] (258s left) kms_ccs (pipe-b-bad-pixel-format-4-tiled-dg2-mc-ccs)
[774.457015] Starting subtest: pipe-B-bad-pixel-format-4-tiled-dg2-mc-ccs
[774.459455] Subtest pipe-B-bad-pixel-format-4-tiled-dg2-mc-ccs: SUCCESS (0.002s)
[774.671518] [138/143] (258s left) syncobj_wait (invalid-wait-bad-flags)
[774.723399] Starting subtest: invalid-wait-bad-flags
[774.724307] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[774.796513] [139/143] (258s left) kms_flip (wf_vblank-ts-check)
[774.930989] Starting subtest: wf_vblank-ts-check
[774.936144] Starting dynamic subtest: A-DP4
[783.051496] Dynamic subtest A-DP4: SUCCESS (8.115s)
[783.061242] Starting dynamic subtest: B-DP4
[791.092184] Dynamic subtest B-DP4: SUCCESS (8.040s)
[791.101123] Starting dynamic subtest: C-DP4
[799.135141] Dynamic subtest C-DP4: SUCCESS (8.042s)
[799.144124] Starting dynamic subtest: D-DP4
[807.175980] Dynamic subtest D-DP4: SUCCESS (8.040s)
[807.176926] Subtest wf_vblank-ts-check: SUCCESS (32.247s)
[807.431970] [140/143] (225s left) gem_sync (basic-store-each)
[807.517138] Starting subtest: basic-store-each
[811.871126] Subtest basic-store-each: SUCCESS (4.354s)
[812.100587] [141/143] (220s left) kms_plane_alpha_blend (constant-alpha-min)
[812.234081] Starting subtest: constant-alpha-min
[812.431506] Starting dynamic subtest: pipe-A-DP-4
[813.095397] Dynamic subtest pipe-A-DP-4: SUCCESS (0.662s)
[813.105835] Starting dynamic subtest: pipe-D-DP-4
[813.845398] Dynamic subtest pipe-D-DP-4: SUCCESS (0.749s)
[813.846263] Subtest constant-alpha-min: SUCCESS (1.612s)
[814.052295] [142/143] (218s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[814.134116] Starting subtest: invalid-signal-one-illegal-handle
[814.135142] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[814.202637] [143/143] (218s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[814.345503] Starting subtest: x-tiled-16bpp-rotate-90
[814.397791] Subtest x-tiled-16bpp-rotate-90: SKIP (0.051s)
[814.547547] Closing watchdogs
Done.