[36.393051] Initializing watchdogs
[36.393116]   /dev/watchdog0
[36.399134] [001/141] (960s left) kms_ccs (pipe-b-ccs-on-another-bo-4_tiled_mtl_rc_ccs)
[36.669277] Starting subtest: pipe-B-ccs-on-another-bo-4_tiled_mtl_rc_ccs
[36.670884] Subtest pipe-B-ccs-on-another-bo-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[36.889798] [002/141] (960s left) gem_exec_schedule (pi-shared-iova)
[37.083066] Starting subtest: pi-shared-iova
[37.084025] Starting dynamic subtest: rcs0
[37.336589] Dynamic subtest rcs0: SUCCESS (0.254s)
[37.340912] Starting dynamic subtest: bcs0
[37.495509] Dynamic subtest bcs0: SUCCESS (0.159s)
[37.500083] Starting dynamic subtest: vcs0
[37.661891] Dynamic subtest vcs0: SUCCESS (0.166s)
[37.666221] Starting dynamic subtest: vcs1
[37.825923] Dynamic subtest vcs1: SUCCESS (0.164s)
[37.830296] Starting dynamic subtest: vecs0
[37.990523] Dynamic subtest vecs0: SUCCESS (0.163s)
[37.994974] Starting dynamic subtest: vecs1
[38.152631] Dynamic subtest vecs1: SUCCESS (0.165s)
[38.157098] Starting dynamic subtest: ccs0
[38.324198] Dynamic subtest ccs0: SUCCESS (0.169s)
[38.328573] Starting dynamic subtest: ccs1
[38.550722] Dynamic subtest ccs1: SUCCESS (0.227s)
[38.555146] Starting dynamic subtest: ccs2
[38.720968] Dynamic subtest ccs2: SUCCESS (0.170s)
[38.725415] Starting dynamic subtest: ccs3
[38.877428] Dynamic subtest ccs3: SUCCESS (0.165s)
[38.878227] Subtest pi-shared-iova: SUCCESS (1.804s)
[39.160414] [003/141] (957s left) gem_exec_parallel (contexts)
[39.227307] Starting subtest: contexts
[39.228253] Starting dynamic subtest: rcs0
[42.299636] Dynamic subtest rcs0: SUCCESS (3.072s)
[42.304540] Starting dynamic subtest: bcs0
[45.136012] Dynamic subtest bcs0: SUCCESS (2.827s)
[45.140871] Starting dynamic subtest: vcs0
[48.065856] Dynamic subtest vcs0: SUCCESS (2.930s)
[48.070569] Starting dynamic subtest: vcs1
[51.061338] Dynamic subtest vcs1: SUCCESS (2.995s)
[51.065970] Starting dynamic subtest: vecs0
[54.139467] Dynamic subtest vecs0: SUCCESS (3.078s)
[54.144476] Starting dynamic subtest: vecs1
[57.151206] Dynamic subtest vecs1: SUCCESS (3.012s)
[57.156945] Starting dynamic subtest: ccs0
[59.964512] Dynamic subtest ccs0: SUCCESS (2.813s)
[59.969241] Starting dynamic subtest: ccs1
[62.939856] Dynamic subtest ccs1: SUCCESS (2.974s)
[62.944613] Starting dynamic subtest: ccs2
[65.864473] Dynamic subtest ccs2: SUCCESS (2.925s)
[65.869354] Starting dynamic subtest: ccs3
[68.803879] Dynamic subtest ccs3: SUCCESS (2.939s)
[68.804988] Subtest contexts: SUCCESS (29.568s)
[69.013459] [004/141] (927s left) gem_exec_fence (syncobj-timeline-unused-fence)
[69.543034] Starting subtest: syncobj-timeline-unused-fence
[69.559568] Subtest syncobj-timeline-unused-fence: SUCCESS (0.025s)
[69.774730] [005/141] (927s left) i915_suspend (sysfs-reader)
[69.840880] Starting subtest: sysfs-reader
[89.516827] Subtest sysfs-reader: SUCCESS (4.183s)
[89.554341] [006/141] (922s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[89.690650] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[89.692451] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[89.782624] [007/141] (922s left) gem_exec_params (rel-constants-invalid-ring)
[89.847263] Starting subtest: rel-constants-invalid-ring
[89.848210] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[89.948513] [008/141] (922s left) gem_exec_fair (basic-sync)
[90.034522] Subtest basic-sync: SKIP (0.000s)
[90.075182] [009/141] (922s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[90.216830] Starting subtest: x-tiled-64bpp-rotate-270
[90.267413] Subtest x-tiled-64bpp-rotate-270: SKIP (0.051s)
[90.368240] [010/141] (922s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[90.518341] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[90.519903] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[90.598958] [011/141] (921s left) gem_softpin (reverse)
[90.662655] Starting subtest: reverse
[90.671417] Subtest reverse: SUCCESS (0.009s)
[90.788234] [012/141] (921s left) kms_ccs (pipe-c-bad-aux-stride-yf_tiled_ccs)
[91.104136] Starting subtest: pipe-C-bad-aux-stride-yf_tiled_ccs
[91.106027] Subtest pipe-C-bad-aux-stride-yf_tiled_ccs: SKIP (0.000s)
[91.281766] [013/141] (921s left) kms_plane_scaling (plane-upscale-with-modifiers-20x20)
[91.413212] Starting subtest: plane-upscale-with-modifiers-20x20
[91.414164] Starting dynamic subtest: pipe-A-DP-4
[91.965569] Dynamic subtest pipe-A-DP-4: SUCCESS (0.551s)
[91.973006] Starting dynamic subtest: pipe-B-DP-4
[92.586764] Dynamic subtest pipe-B-DP-4: SUCCESS (0.620s)
[92.593973] Starting dynamic subtest: pipe-C-DP-4
[93.208305] Dynamic subtest pipe-C-DP-4: SUCCESS (0.620s)
[93.214859] Starting dynamic subtest: pipe-D-DP-4
[93.829405] Dynamic subtest pipe-D-DP-4: SUCCESS (0.620s)
[93.830327] Subtest plane-upscale-with-modifiers-20x20: SUCCESS (2.417s)
[94.084718] [014/141] (918s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[94.292338] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[94.393293] [015/141] (918s left) drm_read (short-buffer-wakeup)
[94.666592] Starting subtest: short-buffer-wakeup
[126.888149] Subtest short-buffer-wakeup: SUCCESS (32.213s)
[126.999528] [016/141] (885s left) gem_exec_params (sol-reset-invalid)
[127.104320] Starting subtest: sol-reset-invalid
[127.106120] Subtest sol-reset-invalid: SUCCESS (0.001s)
[127.227371] [017/141] (885s left) kms_selftest (drm_format)
[127.312467] Starting subtest: drm_format
[127.314416] Subtest drm_format: SKIP (0.001s)
[127.350140] [018/141] (885s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[127.469312] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[127.488387] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.019s)
[127.550135] [019/141] (885s left) kms_hdr (invalid-hdr)
[127.683956] Starting subtest: invalid-hdr
[127.685790] Subtest invalid-hdr: SKIP (0.000s)
[127.750031] [020/141] (884s left) kms_properties (plane-properties-legacy)
[127.877346] Starting subtest: plane-properties-legacy
[129.846877] Subtest plane-properties-legacy: SUCCESS (1.969s)
[130.007261] [021/141] (882s left) kms_cursor_crc (cursor-offscreen-512x512)
[130.294896] Starting subtest: cursor-offscreen-512x512
[130.296582] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[130.493825] [022/141] (882s left) perf_pmu (render-node-busy)
[130.589235] Starting subtest: render-node-busy
[130.590044] Starting dynamic subtest: rcs0
[131.186178] Dynamic subtest rcs0: SUCCESS (0.596s)
[131.196916] Starting dynamic subtest: bcs0
[131.737256] Dynamic subtest bcs0: SUCCESS (0.550s)
[131.748644] Starting dynamic subtest: vcs0
[132.290354] Dynamic subtest vcs0: SUCCESS (0.552s)
[132.302011] Starting dynamic subtest: vcs1
[132.849209] Dynamic subtest vcs1: SUCCESS (0.558s)
[132.861050] Starting dynamic subtest: vecs0
[133.412338] Dynamic subtest vecs0: SUCCESS (0.562s)
[133.423418] Starting dynamic subtest: vecs1
[133.965401] Dynamic subtest vecs1: SUCCESS (0.553s)
[133.976790] Starting dynamic subtest: ccs0
[134.523504] Dynamic subtest ccs0: SUCCESS (0.557s)
[134.535111] Starting dynamic subtest: ccs1
[135.085494] Dynamic subtest ccs1: SUCCESS (0.561s)
[135.097120] Starting dynamic subtest: ccs2
[135.642535] Dynamic subtest ccs2: SUCCESS (0.556s)
[135.653249] Starting dynamic subtest: ccs3
[136.199302] Dynamic subtest ccs3: SUCCESS (0.556s)
[136.201277] Subtest render-node-busy: SUCCESS (5.610s)
[136.264000] [023/141] (876s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[136.333805] Starting subtest: map-fixed-invalidate-overlap
[136.335535] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[136.442199] [024/141] (876s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[136.588161] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[136.589984] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[136.673751] [025/141] (876s left) kms_atomic_transition (plane-all-transition)
[136.804304] Starting subtest: plane-all-transition
[136.805064] Starting dynamic subtest: pipe-A-DP-4
[140.541320] Dynamic subtest pipe-A-DP-4: SUCCESS (3.736s)
[140.637459] Starting dynamic subtest: pipe-B-DP-4
[144.464779] Dynamic subtest pipe-B-DP-4: SUCCESS (3.833s)
[144.537570] Subtest plane-all-transition: SUCCESS (7.733s)
[144.685770] [026/141] (868s left) kms_ccs (pipe-c-bad-rotation-90-4_tiled_mtl_rc_ccs)
[144.965480] Starting subtest: pipe-C-bad-rotation-90-4_tiled_mtl_rc_ccs
[144.966999] Subtest pipe-C-bad-rotation-90-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[145.168385] [027/141] (867s left) gem_exec_balancer (indices)
[145.235310] Starting subtest: indices
[146.114588] Subtest indices: SUCCESS (0.879s)
[146.371216] [028/141] (866s left) gem_mmap_offset (bad-extensions)
[146.436333] Starting subtest: bad-extensions
[146.437134] Subtest bad-extensions: SUCCESS (0.000s)
[146.539871] [029/141] (866s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[146.637206] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[146.660940] [030/141] (866s left) syncobj_basic (bad-fd-to-handle)
[146.719297] Starting subtest: bad-fd-to-handle
[146.720218] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[146.794984] [031/141] (866s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[146.940571] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[146.942324] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[147.018294] [032/141] (865s left) v3d/v3d_submit_cl (single-in-sync)
[147.102649] Subtest single-in-sync: SKIP (0.000s)
[147.153524] [033/141] (865s left) kms_addfb_basic (bo-too-small)
[147.295535] Starting subtest: bo-too-small
[147.296344] Subtest bo-too-small: SUCCESS (0.000s)
[147.384210] [034/141] (865s left) kms_plane_scaling (plane-downscale-with-pixel-format-factor-0-75)
[147.513476] Starting subtest: plane-downscale-with-pixel-format-factor-0-75
[147.515606] Starting dynamic subtest: pipe-A-DP-4
[177.502302] Dynamic subtest pipe-A-DP-4: SUCCESS (29.988s)
[177.510662] Starting dynamic subtest: pipe-B-DP-4
[207.175688] Dynamic subtest pipe-B-DP-4: SUCCESS (29.672s)
[207.184167] Starting dynamic subtest: pipe-C-DP-4
[207.463000] Dynamic subtest pipe-C-DP-4: SUCCESS (0.286s)
[207.471128] Starting dynamic subtest: pipe-D-DP-4
[207.753053] Dynamic subtest pipe-D-DP-4: SUCCESS (0.289s)
[207.753966] Subtest plane-downscale-with-pixel-format-factor-0-75: SUCCESS (60.240s)
[207.960631] [035/141] (805s left) gem_vm_create (invalid-destroy)
[208.025997] Starting subtest: invalid-destroy
[208.027931] Subtest invalid-destroy: SUCCESS (0.001s)
[208.133720] [036/141] (804s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[208.291369] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[208.308803] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.017s)
[208.375704] [037/141] (804s left) gem_shrink (reclaim)
[208.440087] Starting subtest: reclaim
[210.753176] Subtest reclaim: SUCCESS (2.280s)
[210.832673] [038/141] (802s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_mtl_rc_ccs)
[211.160775] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_mtl_rc_ccs
[211.162344] Subtest pipe-B-crc-primary-rotation-180-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[211.394849] [039/141] (801s left) gem_ctx_shared (q-in-order)
[211.462684] Starting subtest: Q-in-order
[211.463615] Starting dynamic subtest: rcs0
[211.712978] Dynamic subtest rcs0: SUCCESS (0.241s)
[211.720509] Starting dynamic subtest: bcs0
[211.878809] Dynamic subtest bcs0: SUCCESS (0.174s)
[211.886584] Starting dynamic subtest: vcs0
[212.068450] Dynamic subtest vcs0: SUCCESS (0.180s)
[212.076104] Starting dynamic subtest: vcs1
[212.246494] Dynamic subtest vcs1: SUCCESS (0.177s)
[212.253922] Starting dynamic subtest: vecs0
[212.427321] Dynamic subtest vecs0: SUCCESS (0.180s)
[212.434548] Starting dynamic subtest: vecs1
[212.608221] Dynamic subtest vecs1: SUCCESS (0.180s)
[212.615544] Starting dynamic subtest: ccs0
[212.788857] Dynamic subtest ccs0: SUCCESS (0.180s)
[212.796255] Starting dynamic subtest: ccs1
[213.030900] Dynamic subtest ccs1: SUCCESS (0.241s)
[213.038143] Starting dynamic subtest: ccs2
[213.213200] Dynamic subtest ccs2: SUCCESS (0.182s)
[213.220532] Starting dynamic subtest: ccs3
[213.395951] Dynamic subtest ccs3: SUCCESS (0.182s)
[213.396793] Subtest Q-in-order: SUCCESS (1.925s)
[213.631471] [040/141] (799s left) kms_prop_blob (invalid-set-prop)
[213.693550] Starting subtest: invalid-set-prop
[213.694483] Subtest invalid-set-prop: SUCCESS (0.000s)
[213.772796] [041/141] (799s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-render)
[213.934394] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-render
[216.165120] Subtest fbc-1p-offscren-pri-shrfb-draw-render: SUCCESS (2.232s)
[216.280112] [042/141] (796s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_mtl_rc_ccs_cc)
[216.597790] Starting subtest: pipe-D-crc-primary-basic-4_tiled_mtl_rc_ccs_cc
[216.599586] Subtest pipe-D-crc-primary-basic-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[216.760261] [043/141] (796s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[216.894550] Starting subtest: fbc-rgb565-draw-mmap-wc
[216.896234] Subtest fbc-rgb565-draw-mmap-wc: SKIP (0.000s)
[216.976442] [044/141] (796s left) gem_mmap_wc (read)
[217.034920] Subtest read: SKIP (0.000s)
[217.068978] [045/141] (796s left) kms_big_fb (4-tiled-addfb)
[217.219459] Starting subtest: 4-tiled-addfb
[217.220507] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[217.310007] [046/141] (795s left) gem_pread (exhaustion)
[217.368986] Subtest exhaustion: SKIP (0.000s)
[217.402836] [047/141] (795s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[217.544574] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[217.546418] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[217.626351] [048/141] (795s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[217.755773] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[228.716836] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (10.961s)
[228.878002] [049/141] (784s left) gem_exec_reloc (basic-wc)
[228.946770] Subtest basic-wc: SKIP (0.000s)
[228.985405] [050/141] (784s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[229.120546] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[229.122025] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[229.209938] [051/141] (784s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[229.342839] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[229.344562] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[229.429128] [052/141] (783s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[229.524202] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[229.640964] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.109s)
[229.727947] [053/141] (783s left) kms_cursor_crc (cursor-size-change)
[229.867114] Starting subtest: cursor-size-change
[229.868005] Starting dynamic subtest: pipe-A-DP-4
[230.650097] Dynamic subtest pipe-A-DP-4: SUCCESS (0.781s)
[230.657404] Starting dynamic subtest: pipe-D-DP-4
[231.452769] Dynamic subtest pipe-D-DP-4: SUCCESS (0.802s)
[231.453673] Subtest cursor-size-change: SUCCESS (1.587s)
[231.873650] [054/141] (781s left) gem_exec_gttfill (all-engines)
[231.941720] Starting subtest: all-engines
[257.309248] Subtest all-engines: SUCCESS (25.359s)
[257.542272] [055/141] (755s left) gem_exec_schedule (thriceslice)
[257.655943] Starting subtest: thriceslice
[257.656785] Starting dynamic subtest: rcs0
[257.713950] Dynamic subtest rcs0: SUCCESS (0.057s)
[257.721888] Starting dynamic subtest: bcs0
[257.739312] Dynamic subtest bcs0: SUCCESS (0.024s)
[257.747469] Starting dynamic subtest: vcs0
[257.789870] Dynamic subtest vcs0: SUCCESS (0.050s)
[257.798028] Starting dynamic subtest: vcs1
[257.844445] Dynamic subtest vcs1: SUCCESS (0.054s)
[257.852582] Starting dynamic subtest: vecs0
[257.874591] Dynamic subtest vecs0: SUCCESS (0.029s)
[257.882578] Starting dynamic subtest: vecs1
[257.902535] Dynamic subtest vecs1: SUCCESS (0.027s)
[257.910690] Starting dynamic subtest: ccs0
[257.949624] Dynamic subtest ccs0: SUCCESS (0.046s)
[257.957564] Starting dynamic subtest: ccs1
[257.996470] Dynamic subtest ccs1: SUCCESS (0.046s)
[258.004661] Starting dynamic subtest: ccs2
[258.024307] Dynamic subtest ccs2: SUCCESS (0.027s)
[258.032203] Starting dynamic subtest: ccs3
[258.074524] Dynamic subtest ccs3: SUCCESS (0.049s)
[258.075877] Subtest thriceslice: SUCCESS (0.419s)
[258.444249] [056/141] (754s left) kms_ccs (pipe-a-ccs-on-another-bo-yf_tiled_ccs)
[258.685133] Starting subtest: pipe-A-ccs-on-another-bo-yf_tiled_ccs
[258.686876] Subtest pipe-A-ccs-on-another-bo-yf_tiled_ccs: SKIP (0.000s)
[258.940694] [057/141] (754s left) kms_cdclk (mode-transition-all-outputs)
[259.070555] Starting subtest: mode-transition-all-outputs
[259.148254] Subtest mode-transition-all-outputs: SKIP (0.075s)
[259.283004] [058/141] (754s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[259.421305] Starting subtest: primary-y-tiled-reflect-x-0
[259.515489] Subtest primary-y-tiled-reflect-x-0: SKIP (0.100s)
[259.600360] [059/141] (753s left) kms_fbcon_fbt (fbc)
[259.679939] Starting subtest: fbc
[263.231647] Subtest fbc: SUCCESS (3.543s)
[263.254692] [060/141] (750s left) vc4/vc4_dmabuf_poll (poll-read-waits-until-write-done)
[263.340802] Subtest poll-read-waits-until-write-done: SKIP (0.000s)
[263.391878] [061/141] (750s left) kms_ccs (pipe-a-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc)
[263.622441] Starting subtest: pipe-A-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc
[263.986634] Subtest pipe-A-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc: SUCCESS (0.363s)
[264.342954] [062/141] (749s left) i915_module_load (resize-bar)
[264.391712] Starting subtest: resize-bar
[294.024875] Subtest resize-bar: SUCCESS (29.623s)
[294.050258] [063/141] (719s left) gem_userptr_blits (relocations)
[294.768516] Starting subtest: relocations
[294.769968] Subtest relocations: SKIP (0.001s)
[294.860028] [064/141] (718s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[294.994375] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[294.995195] Starting dynamic subtest: pipe-A-DP-4
[295.091773] Dynamic subtest pipe-A-DP-4: SUCCESS (0.097s)
[295.171396] Starting dynamic subtest: pipe-B-DP-4
[295.346980] Dynamic subtest pipe-B-DP-4: SUCCESS (0.182s)
[295.402622] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (0.409s)
[295.570787] [065/141] (718s left) kms_busy (extended-modeset-hang-oldfb)
[295.708388] Starting subtest: extended-modeset-hang-oldfb
[295.709366] Starting dynamic subtest: pipe-A
[309.725463] Dynamic subtest pipe-A: SUCCESS (14.016s)
[309.735249] Starting dynamic subtest: pipe-D
[335.671204] Dynamic subtest pipe-D: SUCCESS (25.942s)
[335.672001] Subtest extended-modeset-hang-oldfb: SUCCESS (39.964s)
[335.869859] [066/141] (677s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[336.002883] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[336.003803] Starting dynamic subtest: pipe-A-valid-mode
[339.765904] Dynamic subtest pipe-A-valid-mode: SUCCESS (3.762s)
[339.766896] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SUCCESS (3.764s)
[339.932044] [067/141] (673s left) syncobj_timeline (invalid-signal-bad-pad)
[339.991597] Starting subtest: invalid-signal-bad-pad
[339.992491] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[340.057648] [068/141] (673s left) kms_ccs (pipe-c-crc-primary-rotation-180-y_tiled_gen12_mc_ccs)
[340.352918] Starting subtest: pipe-C-crc-primary-rotation-180-y_tiled_gen12_mc_ccs
[340.354634] Subtest pipe-C-crc-primary-rotation-180-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[340.552333] [069/141] (673s left) kms_ccs (pipe-b-bad-pixel-format-y_tiled_gen12_rc_ccs)
[340.790826] Starting subtest: pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs
[340.792611] Subtest pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[341.036396] [070/141] (672s left) kms_invalid_mode (zero-clock)
[341.169011] Starting subtest: zero-clock
[341.169886] Starting dynamic subtest: DP-4-pipe-A
[341.245728] Dynamic subtest DP-4-pipe-A: SUCCESS (0.076s)
[341.253837] Starting dynamic subtest: DP-4-pipe-B
[341.254726] Dynamic subtest DP-4-pipe-B: SUCCESS (0.007s)
[341.262904] Starting dynamic subtest: DP-4-pipe-C
[341.263849] Dynamic subtest DP-4-pipe-C: SUCCESS (0.007s)
[341.271388] Starting dynamic subtest: DP-4-pipe-D
[341.272331] Dynamic subtest DP-4-pipe-D: SUCCESS (0.006s)
[341.273228] Subtest zero-clock: SUCCESS (0.103s)
[341.418869] [071/141] (672s left) prime_vgem (basic-gtt)
[341.513345] Starting subtest: basic-gtt
[341.515163] Subtest basic-gtt: SKIP (0.000s)
[341.606967] [072/141] (672s left) kms_universal_plane (universal-plane-pipe-a-sanity)
[341.736912] Starting subtest: universal-plane-pipe-A-sanity
[342.275045] Subtest universal-plane-pipe-A-sanity: SUCCESS (0.537s)
[342.450208] [073/141] (671s left) kms_big_fb (linear-8bpp-rotate-0)
[342.596226] Starting subtest: linear-8bpp-rotate-0
[344.008043] Subtest linear-8bpp-rotate-0: SUCCESS (1.403s)
[344.116747] [074/141] (669s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[344.287694] Starting subtest: 2x-long-cursor-vs-flip-legacy
[344.290635] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.002s)
[344.350342] [075/141] (669s left) dumb_buffer (map-invalid-size)
[344.409960] Starting subtest: map-invalid-size
[344.410769] Subtest map-invalid-size: SUCCESS (0.000s)
[344.490531] [076/141] (669s left) kms_addfb_basic (unused-pitches)
[344.568927] Starting subtest: unused-pitches
[344.569862] Subtest unused-pitches: SUCCESS (0.000s)
[344.732720] [077/141] (669s left) kms_chamelium_color (ctm-red-to-blue)
[344.866957] Subtest ctm-red-to-blue: SKIP (0.000s)
[344.892478] [078/141] (668s left) gem_unref_active_buffers
[345.169201] [079/141] (668s left) kms_ccs (pipe-d-bad-aux-stride-yf_tiled_ccs)
[345.539827] Starting subtest: pipe-D-bad-aux-stride-yf_tiled_ccs
[345.541600] Subtest pipe-D-bad-aux-stride-yf_tiled_ccs: SKIP (0.000s)
[345.683062] [080/141] (668s left) debugfs_test (read_all_entries)
[345.747725] Starting subtest: read_all_entries
[346.219486] Subtest read_all_entries: SUCCESS (0.470s)
[346.350485] [081/141] (667s left) gem_flink_basic (bad-flink)
[346.408646] Starting subtest: bad-flink
[346.409648] Subtest bad-flink: SUCCESS (0.000s)
[346.475770] [082/141] (667s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[346.637712] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[346.639408] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[346.700183] [083/141] (667s left) kms_concurrent (pipe-b)
[346.831172] Starting subtest: pipe-B
[346.833166] Starting dynamic subtest: DP-4
[347.313457] Dynamic subtest DP-4: SUCCESS (0.480s)
[347.314263] Subtest pipe-B: SUCCESS (0.483s)
[347.501277] [084/141] (666s left) api_intel_bb (simple-bb-ctx)
[347.561277] Starting subtest: simple-bb-ctx
[347.586708] Subtest simple-bb-ctx: SUCCESS (0.026s)
[347.683697] [085/141] (666s left) kms_content_protection (dp-mst-type-0)
[347.875407] Starting subtest: dp-mst-type-0
[347.881687] Subtest dp-mst-type-0: SKIP (0.000s)
[347.969767] [086/141] (665s left) gem_exec_balancer (sequential)
[348.051694] Starting subtest: sequential
[355.445670] Subtest sequential: SUCCESS (7.394s)
[355.702803] [087/141] (658s left) vc4/vc4_tiling (set-get)
[355.783975] Subtest set-get: SKIP (0.000s)
[355.836207] [088/141] (658s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[358.456340] Subtest verify-pxp-stale-buf-optout-execution: SKIP (0.000s)
[358.495853] [089/141] (655s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[358.629872] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[358.631569] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[358.717361] [090/141] (655s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[358.776373] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[358.934203] [091/141] (655s left) kms_addfb_basic (clobberred-modifier)
[358.993478] Starting subtest: clobberred-modifier
[358.994979] Subtest clobberred-modifier: SKIP (0.000s)
[359.151051] [092/141] (654s left) gem_exec_schedule (smoketest-all)
[359.221732] Starting subtest: smoketest-all
[391.523551] Subtest smoketest-all: SUCCESS (32.283s)
[391.921670] [093/141] (622s left) gem_exec_reloc (basic-write-read)
[391.987809] Subtest basic-write-read: SKIP (0.000s)
[392.027796] [094/141] (622s left) kms_ccs (pipe-a-random-ccs-data-4_tiled_dg2_mc_ccs)
[392.254243] Starting subtest: pipe-A-random-ccs-data-4_tiled_dg2_mc_ccs
[392.784706] Subtest pipe-A-random-ccs-data-4_tiled_dg2_mc_ccs: SUCCESS (0.530s)
[393.116630] [095/141] (620s left) gem_busy (parallel)
[393.354974] Starting subtest: parallel
[393.356029] Starting dynamic subtest: rcs0
[393.467193] Dynamic subtest rcs0: SUCCESS (0.112s)
[393.478385] Starting dynamic subtest: bcs0
[393.533131] Dynamic subtest bcs0: SUCCESS (0.065s)
[393.543067] Starting dynamic subtest: vcs0
[393.601757] Dynamic subtest vcs0: SUCCESS (0.068s)
[393.611284] Starting dynamic subtest: vcs1
[393.672131] Dynamic subtest vcs1: SUCCESS (0.069s)
[393.683058] Starting dynamic subtest: vecs0
[393.740559] Dynamic subtest vecs0: SUCCESS (0.067s)
[393.757344] Starting dynamic subtest: vecs1
[393.819970] Dynamic subtest vecs1: SUCCESS (0.078s)
[393.832836] Starting dynamic subtest: ccs0
[393.896496] Dynamic subtest ccs0: SUCCESS (0.076s)
[393.909806] Starting dynamic subtest: ccs1
[393.968570] Dynamic subtest ccs1: SUCCESS (0.071s)
[393.977199] Starting dynamic subtest: ccs2
[394.035247] Dynamic subtest ccs2: SUCCESS (0.066s)
[394.047249] Starting dynamic subtest: ccs3
[394.106550] Dynamic subtest ccs3: SUCCESS (0.070s)
[394.107708] Subtest parallel: SUCCESS (0.752s)
[394.366578] [096/141] (619s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[394.431399] Starting subtest: single-wait-all-for-submit-available-submitted
[394.432437] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[394.525272] [097/141] (619s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[394.674376] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[394.676223] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[394.766754] [098/141] (619s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[394.897668] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[394.898475] Starting dynamic subtest: pipe-A-valid-mode
[394.973337] Dynamic subtest pipe-A-valid-mode: SKIP (0.074s)
[394.974933] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.076s)
[395.109764] [099/141] (619s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[395.240149] Starting subtest: read-crc-frame-sequence
[395.241010] Starting dynamic subtest: pipe-A-DP-4
[395.847933] Dynamic subtest pipe-A-DP-4: SUCCESS (0.607s)
[395.860363] Starting dynamic subtest: pipe-B-DP-4
[396.421801] Dynamic subtest pipe-B-DP-4: SUCCESS (0.571s)
[396.430247] Starting dynamic subtest: pipe-C-DP-4
[397.047408] Dynamic subtest pipe-C-DP-4: SUCCESS (0.624s)
[397.056990] Starting dynamic subtest: pipe-D-DP-4
[397.733401] Dynamic subtest pipe-D-DP-4: SUCCESS (0.684s)
[397.734632] Subtest read-crc-frame-sequence: SUCCESS (2.494s)
[397.911714] [100/141] (616s left) gem_exec_reloc (basic-write-wc)
[397.976437] Subtest basic-write-wc: SKIP (0.000s)
[398.020322] [101/141] (616s left) kms_cursor_legacy (forked-move)
[398.151309] Starting subtest: forked-move
[398.152237] Starting dynamic subtest: pipe-A
[419.775529] Dynamic subtest pipe-A: SUCCESS (21.590s)
[419.787748] Starting dynamic subtest: pipe-B
[441.311654] Dynamic subtest pipe-B: SUCCESS (21.535s)
[441.324823] Starting dynamic subtest: pipe-C
[462.840267] Dynamic subtest pipe-C: SUCCESS (21.527s)
[462.854609] Starting dynamic subtest: pipe-D
[484.365337] Dynamic subtest pipe-D: SUCCESS (21.547s)
[484.385692] Starting dynamic subtest: all-pipes
[505.922658] Dynamic subtest all-pipes: SUCCESS (21.531s)
[505.924072] Subtest forked-move: SUCCESS (107.739s)
[505.960010] [102/141] (508s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[506.124856] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[506.126677] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[506.198708] [103/141] (508s left) kms_cursor_crc (cursor-sliding-128x128)
[506.432744] Starting subtest: cursor-sliding-128x128
[506.437197] Starting dynamic subtest: pipe-A-DP-4
[510.754481] Dynamic subtest pipe-A-DP-4: SUCCESS (4.317s)
[510.778794] Starting dynamic subtest: pipe-D-DP-4
[515.038877] Dynamic subtest pipe-D-DP-4: SUCCESS (4.268s)
[515.039725] Subtest cursor-sliding-128x128: SUCCESS (8.605s)
[515.322201] [104/141] (498s left) kms_psr (psr2_cursor_blt)
[515.382792] Subtest psr2_cursor_blt: SKIP (0.000s)
[515.414239] [105/141] (498s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[515.556750] Starting subtest: y-tiled-32bpp-rotate-270
[515.558349] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[515.638065] [106/141] (498s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[515.771377] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[515.772888] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[515.854553] [107/141] (498s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[515.987659] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[515.989356] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[516.071501] [108/141] (498s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[516.205208] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[516.206927] Subtest fbcpsr-rgb565-draw-mmap-wc: SKIP (0.000s)
[516.305267] [109/141] (498s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_dg2_mc_ccs)
[516.629132] Starting subtest: pipe-D-crc-primary-rotation-180-4_tiled_dg2_mc_ccs
[520.526683] Subtest pipe-D-crc-primary-rotation-180-4_tiled_dg2_mc_ccs: SUCCESS (3.898s)
[520.781872] [110/141] (493s left) i915_pm_rpm (dpms-lpsp)
[523.010400] Starting subtest: dpms-lpsp
[523.013005] Subtest dpms-lpsp: SKIP (0.000s)
[523.302041] [111/141] (491s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[523.437610] Starting subtest: yf-tiled-addfb-size-overflow
[523.439496] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[523.517109] [112/141] (490s left) kms_vrr (negative-basic)
[523.645883] Starting subtest: negative-basic
[523.648412] Starting dynamic subtest: pipe-A-DP-4
[529.122907] Dynamic subtest pipe-A-DP-4: SUCCESS (5.475s)
[529.124052] Subtest negative-basic: SUCCESS (5.477s)
[529.249958] [113/141] (485s left) api_intel_allocator (reserve-simple)
[529.310530] Starting subtest: reserve-simple
[529.331825] Subtest reserve-simple: SUCCESS (0.022s)
[529.449452] [114/141] (485s left) i915_hangman (engine-engine-hang)
[529.552146] Starting subtest: engine-engine-hang
[529.553105] Starting dynamic subtest: rcs0
[530.508854] Dynamic subtest rcs0: SUCCESS (0.956s)
[530.518947] Starting dynamic subtest: bcs0
[531.294680] Dynamic subtest bcs0: SUCCESS (0.785s)
[531.303240] Starting dynamic subtest: vcs0
[532.070802] Dynamic subtest vcs0: SUCCESS (0.775s)
[532.081008] Starting dynamic subtest: vcs1
[532.840608] Dynamic subtest vcs1: SUCCESS (0.769s)
[532.849683] Starting dynamic subtest: vecs0
[533.693672] Dynamic subtest vecs0: SUCCESS (0.852s)
[533.702490] Starting dynamic subtest: vecs1
[534.500727] Dynamic subtest vecs1: SUCCESS (0.806s)
[534.510196] Starting dynamic subtest: ccs0
[537.918745] Dynamic subtest ccs0: SUCCESS (3.417s)
[537.928276] Starting dynamic subtest: ccs1
[541.939963] Dynamic subtest ccs1: SUCCESS (4.019s)
[541.953861] Starting dynamic subtest: ccs2
[545.961750] Dynamic subtest ccs2: SUCCESS (4.019s)
[545.972622] Starting dynamic subtest: ccs3
[549.937791] Dynamic subtest ccs3: SUCCESS (3.975s)
[549.938831] Subtest engine-engine-hang: SUCCESS (20.386s)
[550.066373] [115/141] (464s left) gem_userptr_blits (usage-restrictions)
[550.148229] Starting subtest: usage-restrictions
[550.148990] Subtest usage-restrictions: SUCCESS (0.000s)
[550.295171] [116/141] (464s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[550.444376] Starting subtest: cursorB-vs-flipB-toggle
[550.446152] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[550.505654] [117/141] (464s left) gem_ctx_isolation (nonpriv-switch)
[550.572874] Starting subtest: nonpriv-switch
[550.573789] Starting dynamic subtest: rcs0
[551.254701] Dynamic subtest rcs0: SUCCESS (0.680s)
[551.263185] Starting dynamic subtest: bcs0
[551.967053] Dynamic subtest bcs0: SUCCESS (0.713s)
[551.975659] Starting dynamic subtest: vcs0
[552.736722] Dynamic subtest vcs0: SUCCESS (0.769s)
[552.745290] Starting dynamic subtest: vcs1
[553.514461] Dynamic subtest vcs1: SUCCESS (0.777s)
[553.523203] Starting dynamic subtest: vecs0
[554.277609] Dynamic subtest vecs0: SUCCESS (0.762s)
[554.286160] Starting dynamic subtest: vecs1
[555.039840] Dynamic subtest vecs1: SUCCESS (0.762s)
[555.048392] Starting dynamic subtest: ccs0
[555.804458] Dynamic subtest ccs0: SUCCESS (0.764s)
[555.813251] Starting dynamic subtest: ccs1
[556.556461] Dynamic subtest ccs1: SUCCESS (0.751s)
[556.565173] Starting dynamic subtest: ccs2
[557.298726] Dynamic subtest ccs2: SUCCESS (0.741s)
[557.307505] Starting dynamic subtest: ccs3
[558.045885] Dynamic subtest ccs3: SUCCESS (0.746s)
[558.046844] Subtest nonpriv-switch: SUCCESS (7.473s)
[558.323729] [118/141] (456s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[558.458654] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[558.460372] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[558.538760] [119/141] (456s left) i915_pm_rpm (pm-tiling)
[559.967995] Starting subtest: pm-tiling
[559.970690] Subtest pm-tiling: SKIP (0.000s)
[560.287314] [120/141] (454s left) gem_exercise_blt (fast-copy-emit)
[560.351620] Starting subtest: fast-copy-emit
[560.352571] Starting dynamic subtest: linear-smem-smem-emit
[560.386383] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.034s)
[560.394634] Starting dynamic subtest: linear-smem-lmem0-emit
[560.398591] Dynamic subtest linear-smem-lmem0-emit: SUCCESS (0.012s)
[560.406725] Starting dynamic subtest: linear-lmem0-smem-emit
[560.491881] Dynamic subtest linear-lmem0-smem-emit: SUCCESS (0.093s)
[560.500002] Starting dynamic subtest: linear-lmem0-lmem0-emit
[560.587175] Dynamic subtest linear-lmem0-lmem0-emit: SUCCESS (0.094s)
[560.595618] Starting dynamic subtest: xmajor-smem-smem-emit
[560.600253] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.012s)
[560.608491] Starting dynamic subtest: xmajor-smem-lmem0-emit
[560.612834] Dynamic subtest xmajor-smem-lmem0-emit: SUCCESS (0.012s)
[560.621097] Starting dynamic subtest: xmajor-lmem0-smem-emit
[560.714762] Dynamic subtest xmajor-lmem0-smem-emit: SUCCESS (0.101s)
[560.722797] Starting dynamic subtest: xmajor-lmem0-lmem0-emit
[560.817213] Dynamic subtest xmajor-lmem0-lmem0-emit: SUCCESS (0.102s)
[560.825408] Starting dynamic subtest: tile4-smem-smem-emit
[560.836750] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.014s)
[560.844935] Starting dynamic subtest: tile4-smem-lmem0-emit
[560.845807] Dynamic subtest tile4-smem-lmem0-emit: SUCCESS (0.011s)
[560.853913] Starting dynamic subtest: tile4-lmem0-smem-emit
[560.946522] Dynamic subtest tile4-lmem0-smem-emit: SUCCESS (0.101s)
[560.954955] Starting dynamic subtest: tile4-lmem0-lmem0-emit
[561.048298] Dynamic subtest tile4-lmem0-lmem0-emit: SUCCESS (0.101s)
[561.056479] Starting dynamic subtest: tile64-smem-smem-emit
[561.063252] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.014s)
[561.071461] Starting dynamic subtest: tile64-smem-lmem0-emit
[561.075643] Dynamic subtest tile64-smem-lmem0-emit: SUCCESS (0.012s)
[561.083758] Starting dynamic subtest: tile64-lmem0-smem-emit
[561.179695] Dynamic subtest tile64-lmem0-smem-emit: SUCCESS (0.103s)
[561.187776] Starting dynamic subtest: tile64-lmem0-lmem0-emit
[561.281695] Dynamic subtest tile64-lmem0-lmem0-emit: SUCCESS (0.101s)
[561.282598] Subtest fast-copy-emit: SUCCESS (0.930s)
[561.401803] [121/141] (453s left) gem_spin_batch (legacy-resubmit-new)
[561.469713] Starting subtest: legacy-resubmit-new
[561.470512] Starting dynamic subtest: default
[561.496277] Dynamic subtest default: SUCCESS (0.026s)
[561.504770] Starting dynamic subtest: render
[561.505558] Dynamic subtest render: SUCCESS (0.003s)
[561.514131] Starting dynamic subtest: bsd
[561.514923] Dynamic subtest bsd: SUCCESS (0.003s)
[561.523444] Starting dynamic subtest: bsd1
[561.524242] Dynamic subtest bsd1: SUCCESS (0.002s)
[561.532325] Starting dynamic subtest: bsd2
[561.533146] Dynamic subtest bsd2: SUCCESS (0.003s)
[561.541371] Starting dynamic subtest: blt
[561.542242] Dynamic subtest blt: SUCCESS (0.004s)
[561.550254] Starting dynamic subtest: vebox
[561.551022] Dynamic subtest vebox: SUCCESS (0.006s)
[561.551818] Subtest legacy-resubmit-new: SUCCESS (0.053s)
[561.784162] [122/141] (452s left) i915_query (test-query-geometry-subslices)
[561.848686] Starting subtest: test-query-geometry-subslices
[561.849639] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[561.909185] [123/141] (452s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[561.984281] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[562.090625] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.105s)
[562.175316] [124/141] (452s left) kms_universal_plane (universal-plane-pageflip-windowed-pipe-c)
[562.304735] Starting subtest: universal-plane-pageflip-windowed-pipe-C
[563.010479] Subtest universal-plane-pageflip-windowed-pipe-C: SUCCESS (0.706s)
[563.194004] [125/141] (451s left) gem_exec_params (rsvd2-dirt)
[563.257629] Starting subtest: rsvd2-dirt
[563.259264] Subtest rsvd2-dirt: SKIP (0.000s)
[563.383289] [126/141] (451s left) kms_atomic (plane-primary-legacy)
[563.871150] Starting subtest: plane-primary-legacy
[564.312973] Subtest plane-primary-legacy: SUCCESS (0.448s)
[564.583989] [127/141] (450s left) gem_exec_whisper (basic-contexts-priority-all)
[564.654594] Starting subtest: basic-contexts-priority-all
[590.548860] Subtest basic-contexts-priority-all: SUCCESS (25.894s)
[590.754246] [128/141] (424s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[590.893964] Starting subtest: psr-2p-pri-indfb-multidraw
[590.895558] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[590.967746] [129/141] (423s left) kms_psr (primary_mmap_gtt)
[591.026914] Subtest primary_mmap_gtt: SKIP (0.000s)
[591.059918] [130/141] (423s left) syncobj_wait (wait-delayed-signal)
[591.122748] Starting subtest: wait-delayed-signal
[591.224778] Subtest wait-delayed-signal: SUCCESS (0.102s)
[591.322575] [131/141] (423s left) gem_mmap_gtt (isolation)
[591.403226] Subtest isolation: SKIP (0.000s)
[591.426247] [132/141] (423s left) kms_color (ctm-red-to-blue)
[591.562072] Starting subtest: ctm-red-to-blue
[591.563196] Starting dynamic subtest: pipe-A
[592.155900] Dynamic subtest pipe-A: SUCCESS (0.593s)
[592.165167] Starting dynamic subtest: pipe-B
[592.728705] Dynamic subtest pipe-B: SUCCESS (0.572s)
[592.737191] Starting dynamic subtest: pipe-C
[593.326580] Dynamic subtest pipe-C: SUCCESS (0.598s)
[593.335237] Starting dynamic subtest: pipe-D
[593.981869] Dynamic subtest pipe-D: SUCCESS (0.654s)
[593.982832] Subtest ctm-red-to-blue: SUCCESS (2.419s)
[594.157382] [133/141] (420s left) v3d/v3d_perfmon (get-values-valid-perfmon)
[594.239672] Subtest get-values-valid-perfmon: SKIP (0.000s)
[594.295606] [134/141] (420s left) gem_ctx_persistence (engines-hang)
[594.380956] Starting subtest: engines-hang
[594.381798] Starting dynamic subtest: rcs0
[594.441529] Dynamic subtest rcs0: SUCCESS (0.060s)
[594.450781] Starting dynamic subtest: bcs0
[594.524702] Dynamic subtest bcs0: SUCCESS (0.081s)
[594.563802] Starting dynamic subtest: vcs0
[594.564955] Dynamic subtest vcs0: SUCCESS (0.028s)
[594.579968] Starting dynamic subtest: vcs1
[594.660370] Dynamic subtest vcs1: SUCCESS (0.102s)
[594.698778] Starting dynamic subtest: vecs0
[594.699916] Dynamic subtest vecs0: SUCCESS (0.027s)
[594.714862] Starting dynamic subtest: vecs1
[594.793568] Dynamic subtest vecs1: SUCCESS (0.101s)
[594.806492] Starting dynamic subtest: ccs0
[594.887860] Dynamic subtest ccs0: SUCCESS (0.092s)
[594.928387] Starting dynamic subtest: ccs1
[594.929663] Dynamic subtest ccs1: SUCCESS (0.024s)
[594.944815] Starting dynamic subtest: ccs2
[594.997771] Dynamic subtest ccs2: SUCCESS (0.081s)
[595.017977] Starting dynamic subtest: ccs3
[595.106952] Dynamic subtest ccs3: SUCCESS (0.108s)
[595.108066] Subtest engines-hang: SUCCESS (0.726s)
[595.239426] [135/141] (419s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_dg2_rc_ccs_cc)
[595.568006] Starting subtest: pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs_cc
[595.727543] Subtest pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs_cc: SUCCESS (0.161s)
[595.990299] [136/141] (419s left) kms_plane_lowres (tiling-y)
[596.123914] Starting subtest: tiling-y
[596.125482] Subtest tiling-y: SKIP (0.000s)
[596.190092] [137/141] (418s left) gem_exec_flush (basic-wb-rw-default)
[596.253905] Subtest basic-wb-rw-default: SKIP (0.000s)
[596.298590] [138/141] (418s left) sysfs_heartbeat_interval (precise)
[596.361311] Starting subtest: precise
[596.362064] Starting dynamic subtest: ccs2
[597.838942] Dynamic subtest ccs2: SUCCESS (1.477s)
[597.848105] Starting dynamic subtest: vecs0
[599.283531] Dynamic subtest vecs0: SUCCESS (1.443s)
[599.297109] Starting dynamic subtest: ccs0
[602.036617] Dynamic subtest ccs0: SUCCESS (2.751s)
[602.045440] Starting dynamic subtest: vcs0
[605.036987] Dynamic subtest vcs0: SUCCESS (2.999s)
[605.049317] Starting dynamic subtest: bcs0
[608.023193] Dynamic subtest bcs0: SUCCESS (2.984s)
[608.034317] Starting dynamic subtest: ccs3
[609.404908] Dynamic subtest ccs3: SUCCESS (1.380s)
[609.415278] Starting dynamic subtest: vecs1
[612.024572] Dynamic subtest vecs1: SUCCESS (2.618s)
[612.039131] Starting dynamic subtest: ccs1
[613.391958] Dynamic subtest ccs1: SUCCESS (1.365s)
[613.405073] Starting dynamic subtest: rcs0
[616.046500] Dynamic subtest rcs0: SUCCESS (2.653s)
[616.061190] Starting dynamic subtest: vcs1
[617.404590] Dynamic subtest vcs1: SUCCESS (1.356s)
[617.405796] Subtest precise: SUCCESS (21.044s)
[617.511968] [139/141] (397s left) syncobj_timeline (multi-wait-all-signaled)
[617.571868] Starting subtest: multi-wait-all-signaled
[617.572777] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[617.643706] [140/141] (397s left) gem_linear_blits (basic)
[617.952621] Starting subtest: basic
[617.978180] Subtest basic: SUCCESS (0.026s)
[618.119058] [141/141] (397s left) perf_pmu (busy-accuracy-2)
[618.223100] Starting subtest: busy-accuracy-2
[618.223916] Starting dynamic subtest: rcs0
[621.279695] Dynamic subtest rcs0: SUCCESS (3.052s)
[621.288828] Starting dynamic subtest: bcs0
[624.330484] Dynamic subtest bcs0: SUCCESS (3.051s)
[624.339329] Starting dynamic subtest: vcs0
[627.390959] Dynamic subtest vcs0: SUCCESS (3.061s)
[627.399984] Starting dynamic subtest: vcs1
[630.441487] Dynamic subtest vcs1: SUCCESS (3.050s)
[630.450552] Starting dynamic subtest: vecs0
[633.500194] Dynamic subtest vecs0: SUCCESS (3.055s)
[633.509484] Starting dynamic subtest: vecs1
[636.553032] Dynamic subtest vecs1: SUCCESS (3.055s)
[636.562623] Starting dynamic subtest: ccs0
[639.611830] Dynamic subtest ccs0: SUCCESS (3.056s)
[639.621188] Starting dynamic subtest: ccs1
[642.667893] Dynamic subtest ccs1: SUCCESS (3.057s)
[642.676993] Starting dynamic subtest: ccs2
[645.721936] Dynamic subtest ccs2: SUCCESS (3.051s)
[645.731081] Starting dynamic subtest: ccs3
[648.778485] Dynamic subtest ccs3: SUCCESS (3.057s)
[648.779517] Subtest busy-accuracy-2: SUCCESS (30.553s)
[648.920677] Closing watchdogs
Done.