[49.882854] Initializing watchdogs
[49.883155]   /dev/watchdog0
[49.917272] [001/136] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[50.395837] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[50.436066] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[50.536319] [002/136] (959s left) kms_psr (psr2_cursor_plane_move)
[50.812200] Subtest psr2_cursor_plane_move: SKIP (0.000s)
[50.889587] [003/136] (959s left) kms_hdr (invalid-hdr)
[51.229339] Starting subtest: invalid-hdr
[53.379029] Starting dynamic subtest: pipe-A-DP-1
[56.822506] Dynamic subtest pipe-A-DP-1: FAIL (2.234s)
[56.843789] Subtest invalid-hdr: FAIL (4.367s)
[56.947603] [004/136] (953s left) syncobj_timeline (multi-wait-for-submit-signaled)
[57.209925] Starting subtest: multi-wait-for-submit-signaled
[57.228829] Subtest multi-wait-for-submit-signaled: SUCCESS (0.002s)
[57.330308] [005/136] (953s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[57.576852] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[57.595706] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.001s)
[57.679538] [006/136] (953s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[58.087217] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[58.129602] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[58.227639] [007/136] (952s left) kms_vblank (pipe-d-query-busy-hang)
[58.586542] Subtest pipe-D-query-busy-hang: SKIP (0.000s)
[58.730852] [008/136] (952s left) perf_pmu (render-node-busy)
[59.009787] Starting subtest: render-node-busy
[59.028867] Starting dynamic subtest: rcs0
[59.547714] Dynamic subtest rcs0: SUCCESS (0.546s)
[59.580414] Starting dynamic subtest: bcs0
[60.082867] Dynamic subtest bcs0: SUCCESS (0.525s)
[60.115981] Starting dynamic subtest: vcs0
[60.602484] Dynamic subtest vcs0: SUCCESS (0.523s)
[60.635288] Starting dynamic subtest: vecs0
[61.125494] Dynamic subtest vecs0: SUCCESS (0.526s)
[61.144414] Subtest render-node-busy: SUCCESS (2.120s)
[61.222309] [009/136] (949s left) gem_mmap_offset (bad-flags)
[61.472355] Starting subtest: bad-flags
[61.491170] Subtest bad-flags: SUCCESS (0.000s)
[61.573360] [010/136] (949s left) kms_flip (2x-flip-vs-suspend)
[61.924612] Starting subtest: 2x-flip-vs-suspend
[61.964058] Subtest 2x-flip-vs-suspend: SKIP (0.003s)
[62.065684] [011/136] (949s left) v3d/v3d_submit_csd (multisync-out-syncs)
[62.414500] Subtest multisync-out-syncs: SKIP (0.000s)
[62.498465] [012/136] (948s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[62.834763] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[62.853268] Starting dynamic subtest: pipe-A-DP-1
[65.382134] Dynamic subtest pipe-A-DP-1: SUCCESS (2.529s)
[65.417103] Starting dynamic subtest: pipe-B-DP-1
[67.959606] Dynamic subtest pipe-B-DP-1: SUCCESS (2.570s)
[67.997755] Starting dynamic subtest: pipe-C-DP-1
[68.330122] Dynamic subtest pipe-C-DP-1: SUCCESS (0.389s)
[68.352086] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (5.495s)
[68.760302] [013/136] (942s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[69.176500] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[71.239283] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (2.139s)
[71.414148] [014/136] (940s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[71.823741] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[71.864502] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[71.965268] [015/136] (939s left) gem_exec_reloc (basic-wc-cpu-active)
[72.214727] Starting subtest: basic-wc-cpu-active
[72.356210] Subtest basic-wc-cpu-active: SUCCESS (0.144s)
[72.620383] [016/136] (939s left) kms_getfb (getfb2-handle-not-fb)
[72.886321] Starting subtest: getfb2-handle-not-fb
[72.995553] Subtest getfb2-handle-not-fb: SUCCESS (0.096s)
[73.118581] [017/136] (938s left) kms_big_fb (linear-32bpp-rotate-0)
[73.528996] Starting subtest: linear-32bpp-rotate-0
[79.225829] Subtest linear-32bpp-rotate-0: SUCCESS (5.732s)
[80.914449] [018/136] (931s left) gem_softpin (evict-active-interruptible)
[81.197816] Starting subtest: evict-active-interruptible
[81.221721] Subtest evict-active-interruptible: SUCCESS (0.015s)
[81.331484] [019/136] (930s left) syncobj_basic (bad-pad-handle-to-fd)
[81.599889] Starting subtest: bad-pad-handle-to-fd
[81.624259] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[81.726762] [020/136] (930s left) gem_ctx_param (invalid-get-ringsize)
[81.998136] Starting subtest: invalid-get-ringsize
[82.024322] Subtest invalid-get-ringsize: SUCCESS (0.000s)
[82.126592] [021/136] (930s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[82.493028] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[82.545531] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.003s)
[82.666654] [022/136] (929s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[84.593523] Starting subtest: gem-execbuf-stress-pc8
[84.660829] Subtest gem-execbuf-stress-pc8: SKIP (0.044s)
[85.114247] [023/136] (927s left) gem_ccs (block-multicopy-compressed)
[85.389483] Subtest block-multicopy-compressed: SKIP (0.000s)
[85.489643] [024/136] (926s left) perf_pmu (busy-check-all)
[85.738198] Starting subtest: busy-check-all
[85.757070] Starting dynamic subtest: rcs0
[86.269934] Dynamic subtest rcs0: SUCCESS (0.530s)
[86.304458] Starting dynamic subtest: bcs0
[86.803398] Dynamic subtest bcs0: SUCCESS (0.535s)
[86.834950] Starting dynamic subtest: vcs0
[87.339497] Dynamic subtest vcs0: SUCCESS (0.533s)
[87.373851] Starting dynamic subtest: vecs0
[87.870167] Dynamic subtest vecs0: SUCCESS (0.528s)
[87.888884] Subtest busy-check-all: SUCCESS (2.127s)
[87.968076] [025/136] (924s left) gem_exec_reloc (basic-write-gtt-noreloc)
[88.213764] Starting subtest: basic-write-gtt-noreloc
[88.232746] Subtest basic-write-gtt-noreloc: SUCCESS (0.009s)
[88.441691] [026/136] (924s left) kms_addfb_basic (bad-pitch-256)
[88.699867] Starting subtest: bad-pitch-256
[88.718676] Subtest bad-pitch-256: SUCCESS (0.000s)
[89.096974] [027/136] (923s left) kms_plane_scaling (plane-downscale-with-rotation-factor-0-5)
[89.425034] Starting subtest: plane-downscale-with-rotation-factor-0-5
[89.443709] Starting dynamic subtest: pipe-A-DP-1
[89.795533] Dynamic subtest pipe-A-DP-1: SKIP (0.333s)
[89.828214] Starting dynamic subtest: pipe-B-DP-1
[90.177918] Dynamic subtest pipe-B-DP-1: SKIP (0.372s)
[90.215815] Starting dynamic subtest: pipe-C-DP-1
[90.533495] Dynamic subtest pipe-C-DP-1: SKIP (0.357s)
[90.572186] Subtest plane-downscale-with-rotation-factor-0-5: SKIP (1.069s)
[90.926991] [028/136] (921s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[91.167124] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[91.189345] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[91.295439] [029/136] (921s left) gem_exec_balancer (parallel-keep-in-fence)
[95.580155] Subtest parallel-keep-in-fence: SKIP (0.000s)
[95.662794] [030/136] (917s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[96.011956] Starting subtest: primary-x-tiled-reflect-x-180
[96.051322] Subtest primary-x-tiled-reflect-x-180: SKIP (0.002s)
[96.154315] [031/136] (916s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[96.563222] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[96.600355] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[96.710286] [032/136] (916s left) gem_gtt_cpu_tlb
[97.089576] [033/136] (916s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[97.334278] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[97.354768] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[97.433745] [034/136] (915s left) gem_mmap_wc (write)
[97.673020] Starting subtest: write
[97.844528] Subtest write: SUCCESS (0.190s)
[97.955485] [035/136] (915s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[98.365509] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[98.402529] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[98.512797] [036/136] (915s left) gen3_render_tiledx_blits
[98.868494] [037/136] (914s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[99.258972] Starting subtest: y-tiled-64bpp-rotate-0
[106.930164] Subtest y-tiled-64bpp-rotate-0: SUCCESS (7.714s)
[107.889894] [038/136] (905s left) syncobj_timeline (device-signal-unordered)
[108.137109] Starting subtest: device-signal-unordered
[108.155778] Subtest device-signal-unordered: SUCCESS (0.002s)
[108.235670] [039/136] (905s left) kms_plane_scaling (plane-upscale-with-pixel-format-20x20)
[108.586841] Starting subtest: plane-upscale-with-pixel-format-20x20
[108.607431] Starting dynamic subtest: pipe-A-DP-1
[109.080348] Dynamic subtest pipe-A-DP-1: SUCCESS (0.494s)
[109.115762] Starting dynamic subtest: pipe-B-DP-1
[109.904123] Dynamic subtest pipe-B-DP-1: SUCCESS (0.820s)
[109.940452] Starting dynamic subtest: pipe-C-DP-1
[110.287785] Dynamic subtest pipe-C-DP-1: SUCCESS (0.369s)
[110.313396] Subtest plane-upscale-with-pixel-format-20x20: SUCCESS (1.692s)
[110.705472] [040/136] (903s left) kms_chamelium_audio (hdmi-audio)
[111.179905] Subtest hdmi-audio: SKIP (0.000s)
[111.514595] [041/136] (902s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[111.953598] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[114.433146] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (2.577s)
[114.605227] [042/136] (899s left) gem_exec_schedule (preempt-engines)
[115.014457] Starting subtest: preempt-engines
[115.033269] Starting dynamic subtest: rcs0
[115.177920] Dynamic subtest rcs0: SUCCESS (0.300s)
[115.215390] Starting dynamic subtest: bcs0
[115.557356] Dynamic subtest bcs0: SUCCESS (0.384s)
[115.594543] Starting dynamic subtest: vcs0
[115.826216] Dynamic subtest vcs0: SUCCESS (0.269s)
[115.862479] Starting dynamic subtest: vecs0
[116.111239] Dynamic subtest vecs0: SUCCESS (0.281s)
[116.131922] Subtest preempt-engines: SUCCESS (1.235s)
[116.489323] [043/136] (897s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[116.880241] Starting subtest: x-tiled-64bpp-rotate-180
[124.230519] Subtest x-tiled-64bpp-rotate-180: SUCCESS (7.383s)
[125.170768] [044/136] (889s left) gem_exec_balancer (bonded-semaphore)
[125.432630] Starting subtest: bonded-semaphore
[129.135595] Subtest bonded-semaphore: SUCCESS (3.538s)
[133.014076] [045/136] (881s left) i915_pm_rc6_residency (media-rc6-accuracy)
[133.429747] Starting subtest: media-rc6-accuracy
[133.467084] Subtest media-rc6-accuracy: SKIP (0.000s)
[133.555183] [046/136] (880s left) kms_chamelium_frames (dp-crc-single)
[134.009220] Subtest dp-crc-single: SKIP (0.000s)
[134.328495] [047/136] (880s left) kms_ccs (pipe-b-bad-rotation-90-4_tiled_dg2_rc_ccs_cc)
[134.801235] Starting subtest: pipe-B-bad-rotation-90-4_tiled_dg2_rc_ccs_cc
[134.840662] Subtest pipe-B-bad-rotation-90-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[135.227724] [048/136] (879s left) i915_power (sanity)
[135.474714] Starting subtest: sanity
[139.516531] Subtest sanity: SUCCESS (4.022s)
[139.609638] [049/136] (875s left) api_intel_allocator (two-level-inception-interruptible)
[139.853462] Starting subtest: two-level-inception-interruptible
[145.521527] Subtest two-level-inception-interruptible: SUCCESS (5.506s)
[145.603594] [050/136] (869s left) gem_ctx_param (vm)
[145.856513] Starting subtest: vm
[145.901344] Subtest vm: SUCCESS (0.064s)
[146.040262] [051/136] (868s left) kms_vblank (pipe-a-wait-forked-busy)
[146.367247] Starting subtest: pipe-A-wait-forked-busy
[148.849143] Subtest pipe-A-wait-forked-busy: SUCCESS (2.466s)
[149.197850] [052/136] (865s left) kms_ccs (pipe-c-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc)
[149.764395] Starting subtest: pipe-C-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc
[149.808778] Subtest pipe-C-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[150.107349] [053/136] (864s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[150.524489] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[150.561632] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[150.670039] [054/136] (864s left) gem_softpin (reverse)
[150.914278] Starting subtest: reverse
[150.936086] Subtest reverse: SUCCESS (0.020s)
[151.089422] [055/136] (864s left) gem_pread (uncached)
[151.344737] Starting subtest: uncached
[155.936748] Subtest uncached: SUCCESS (4.413s)
[156.027484] [056/136] (859s left) kms_ccs (pipe-c-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs)
[156.577278] Starting subtest: pipe-C-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs
[156.619146] Subtest pipe-C-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs: SKIP (0.004s)
[156.938691] [057/136] (858s left) i915_query (query-topology-kernel-writes)
[157.184985] Starting subtest: query-topology-kernel-writes
[157.203472] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[157.310856] [058/136] (858s left) kms_lease (lease_invalid_connector)
[157.651107] Starting subtest: lease_invalid_connector
[157.669924] Starting dynamic subtest: pipe-A-DP-1
[157.688788] Dynamic subtest pipe-A-DP-1: SUCCESS (0.000s)
[157.722177] Starting dynamic subtest: pipe-B-DP-1
[157.742095] Dynamic subtest pipe-B-DP-1: SUCCESS (0.000s)
[157.777726] Starting dynamic subtest: pipe-C-DP-1
[157.798642] Dynamic subtest pipe-C-DP-1: SUCCESS (0.000s)
[157.819249] Subtest lease_invalid_connector: SUCCESS (0.006s)
[157.922397] [059/136] (857s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[158.340878] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[158.377591] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[158.483366] [060/136] (857s left) core_auth (many-magics)
[158.737808] Starting subtest: many-magics
[159.918457] Subtest many-magics: SUCCESS (1.185s)
[160.079731] [061/136] (855s left) kms_frontbuffer_tracking (fbc-suspend)
[160.523182] Starting subtest: fbc-suspend
[197.799045] Subtest fbc-suspend: SUCCESS (6.229s)
[201.222896] [062/136] (849s left) gem_softpin (noreloc-interruptible)
[201.471960] Starting subtest: noreloc-interruptible
[207.039153] Subtest noreloc-interruptible: SUCCESS (5.399s)
[207.129646] [063/136] (843s left) kms_vblank (pipe-b-ts-continuation-modeset)
[207.458894] Starting subtest: pipe-B-ts-continuation-modeset
[208.341775] Subtest pipe-B-ts-continuation-modeset: SUCCESS (0.885s)
[208.705734] [064/136] (841s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[209.069692] Starting subtest: cursorB-vs-flipB-atomic
[209.112519] Subtest cursorB-vs-flipB-atomic: SKIP (0.002s)
[209.220467] [065/136] (841s left) kms_cursor_edge_walk (256x256-left-edge)
[209.558021] Starting subtest: 256x256-left-edge
[209.577049] Starting dynamic subtest: pipe-A-DP-1
[213.193482] Dynamic subtest pipe-A-DP-1: SUCCESS (3.618s)
[213.238518] Starting dynamic subtest: pipe-C-DP-1
[216.632968] Dynamic subtest pipe-C-DP-1: SUCCESS (3.454s)
[216.653177] Subtest 256x256-left-edge: SUCCESS (7.078s)
[216.992293] [066/136] (833s left) gem_exec_whisper (basic-forked)
[217.288183] Starting subtest: basic-forked
[227.397300] Subtest basic-forked: SUCCESS (10.076s)
[227.551129] [067/136] (823s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[227.938862] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[227.981074] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[228.089464] [068/136] (822s left) kms_async_flips (test-cursor)
[228.429023] Starting subtest: test-cursor
[228.450387] Starting dynamic subtest: pipe-A-DP-1
[228.972860] Dynamic subtest pipe-A-DP-1: SUCCESS (0.534s)
[229.011848] Starting dynamic subtest: pipe-B-DP-1
[229.391185] Dynamic subtest pipe-B-DP-1: SUCCESS (0.415s)
[229.429584] Starting dynamic subtest: pipe-C-DP-1
[229.806619] Dynamic subtest pipe-C-DP-1: SUCCESS (0.410s)
[229.827066] Subtest test-cursor: SUCCESS (1.365s)
[230.342486] [069/136] (820s left) gem_exec_capture (pi)
[230.602540] Starting subtest: pi
[230.621503] Starting dynamic subtest: rcs0
[261.468439] Dynamic subtest rcs0: SUCCESS (30.867s)
[261.509487] Starting dynamic subtest: bcs0
[290.452642] Dynamic subtest bcs0: SUCCESS (28.985s)
[290.490568] Starting dynamic subtest: vcs0
[319.777496] Dynamic subtest vcs0: SUCCESS (29.325s)
[319.815002] Starting dynamic subtest: vecs0
[349.189233] Dynamic subtest vecs0: SUCCESS (29.410s)
[349.208178] Subtest pi: SUCCESS (118.591s)
[349.310048] [070/136] (701s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[349.883807] Starting subtest: 4-tiled-32bpp-rotate-90
[349.922259] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.000s)
[350.044723] [071/136] (701s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-blt)
[350.446329] Starting subtest: psr-1p-offscren-pri-shrfb-draw-blt
[350.489954] Subtest psr-1p-offscren-pri-shrfb-draw-blt: SKIP (0.000s)
[350.601978] [072/136] (700s left) kms_ccs (pipe-c-bad-pixel-format-4_tiled_dg2_rc_ccs_cc)
[351.111923] Starting subtest: pipe-C-bad-pixel-format-4_tiled_dg2_rc_ccs_cc
[351.149419] Subtest pipe-C-bad-pixel-format-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[351.508616] [073/136] (699s left) dmabuf_sync_file (export-multiwait)
[351.880969] Starting subtest: export-multiwait
[351.899920] Subtest export-multiwait: SUCCESS (0.004s)
[352.011060] [074/136] (699s left) gem_pxp (create-valid-protected-context)
[354.968777] Subtest create-valid-protected-context: SKIP (0.000s)
[355.116243] [075/136] (696s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[355.514775] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[355.591495] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.029s)
[355.710026] [076/136] (695s left) kms_atomic_interruptible (legacy-dpms)
[356.048382] Starting subtest: legacy-dpms
[356.068903] Starting dynamic subtest: DP-1-pipe-A
[362.586726] Dynamic subtest DP-1-pipe-A: SUCCESS (6.515s)
[362.605863] Subtest legacy-dpms: SUCCESS (6.518s)
[362.946664] [077/136] (688s left) gem_exec_schedule (smoketest-all)
[363.357891] Starting subtest: smoketest-all
[395.594379] Subtest smoketest-all: SUCCESS (32.299s)
[395.892060] [078/136] (655s left) gem_exec_schedule (u-fairslice-all)
[396.285460] Starting subtest: u-fairslice-all
[398.270690] Subtest u-fairslice-all: SUCCESS (2.100s)
[398.625580] [079/136] (653s left) syncobj_wait (multi-wait-for-submit-signaled)
[398.862317] Starting subtest: multi-wait-for-submit-signaled
[398.884561] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[398.978594] [080/136] (652s left) kms_vblank (pipe-b-wait-forked-hang)
[399.317590] Starting subtest: pipe-B-wait-forked-hang
[406.838271] Subtest pipe-B-wait-forked-hang: SUCCESS (7.395s)
[407.065790] [081/136] (645s left) gem_exec_params (invalid-batch-start-offset)
[407.314406] Starting subtest: invalid-batch-start-offset
[407.333297] Subtest invalid-batch-start-offset: SUCCESS (0.010s)
[407.480961] [082/136] (644s left) gem_wait (invalid-buf)
[407.730401] Starting subtest: invalid-buf
[407.750964] Subtest invalid-buf: SUCCESS (0.000s)
[408.000415] [083/136] (644s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[408.407930] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[408.444887] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[408.560633] [084/136] (643s left) kms_psr (cursor_mmap_cpu)
[408.829182] Subtest cursor_mmap_cpu: SKIP (0.000s)
[408.920129] [085/136] (643s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[409.167112] Starting subtest: cpuset-basic-small-copy-odd
[415.103787] Subtest cpuset-basic-small-copy-odd: SUCCESS (5.937s)
[415.202350] [086/136] (637s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[415.670770] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[415.689790] Starting dynamic subtest: pipe-A-valid-mode
[416.370445] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.696s)
[416.389704] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SUCCESS (0.698s)
[416.749671] [087/136] (635s left) gem_exec_fence (nb-await)
[417.135085] Starting subtest: nb-await
[417.154143] Starting dynamic subtest: rcs0
[417.208088] Dynamic subtest rcs0: SUCCESS (0.072s)
[417.250235] Starting dynamic subtest: bcs0
[417.295792] Dynamic subtest bcs0: SUCCESS (0.069s)
[417.340015] Starting dynamic subtest: vcs0
[417.361447] Dynamic subtest vcs0: SUCCESS (0.069s)
[417.403938] Starting dynamic subtest: vecs0
[417.422699] Dynamic subtest vecs0: SUCCESS (0.067s)
[417.441705] Subtest nb-await: SUCCESS (0.281s)
[418.098366] [088/136] (634s left) syncobj_wait (single-wait-all-submitted)
[418.377016] Starting subtest: single-wait-all-submitted
[418.488389] Subtest single-wait-all-submitted: SUCCESS (0.106s)
[418.618396] [089/136] (634s left) gem_eio (in-flight-contexts-1us)
[418.911000] Starting subtest: in-flight-contexts-1us
[430.918903] Subtest in-flight-contexts-1us: SUCCESS (12.024s)
[431.148690] [090/136] (621s left) kms_ccs (pipe-a-bad-pixel-format-4_tiled_dg2_rc_ccs)
[431.509068] Starting subtest: pipe-A-bad-pixel-format-4_tiled_dg2_rc_ccs
[431.552844] Subtest pipe-A-bad-pixel-format-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[432.084426] [091/136] (620s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted-signaled)
[432.349400] Starting subtest: invalid-multi-wait-all-available-unsubmitted-signaled
[432.374336] Subtest invalid-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.001s)
[432.509188] [092/136] (620s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[432.781281] Starting subtest: saturated-hostile-nopreempt
[432.806224] Starting dynamic subtest: rcs0
[432.888729] Dynamic subtest rcs0: SUCCESS (0.116s)
[432.938143] Starting dynamic subtest: bcs0
[433.022108] Dynamic subtest bcs0: SUCCESS (0.124s)
[433.076688] Starting dynamic subtest: vcs0
[433.155001] Dynamic subtest vcs0: SUCCESS (0.120s)
[433.207368] Starting dynamic subtest: vecs0
[433.263037] Dynamic subtest vecs0: SUCCESS (0.120s)
[433.288503] Subtest saturated-hostile-nopreempt: SUCCESS (0.484s)
[433.406883] [093/136] (619s left) gem_exec_nop (basic-series)
[433.823771] Starting subtest: basic-series
[436.763301] Subtest basic-series: SUCCESS (3.070s)
[436.986466] [094/136] (616s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[437.386622] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[437.429321] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[437.545857] [095/136] (615s left) gem_watchdog (default-virtual)
[437.966379] Starting subtest: default-virtual
[438.825513] Subtest default-virtual: SUCCESS (1.027s)
[438.942592] [096/136] (614s left) kms_pipe_crc_basic (nonblocking-crc)
[439.262037] Starting subtest: nonblocking-crc
[439.283245] Starting dynamic subtest: pipe-A-DP-1
[439.865249] Dynamic subtest pipe-A-DP-1: SUCCESS (0.590s)
[439.916169] Starting dynamic subtest: pipe-B-DP-1
[440.640771] Dynamic subtest pipe-B-DP-1: SUCCESS (0.775s)
[440.685382] Starting dynamic subtest: pipe-C-DP-1
[441.417011] Dynamic subtest pipe-C-DP-1: SUCCESS (0.768s)
[441.436771] Subtest nonblocking-crc: SUCCESS (2.142s)
[441.766417] [097/136] (611s left) kms_big_joiner (invalid-modeset)
[442.132515] Subtest invalid-modeset: SKIP (0.000s)
[442.250663] [098/136] (611s left) kms_vblank (pipe-a-wait-busy-hang)
[442.595152] Starting subtest: pipe-A-wait-busy-hang
[449.844285] Subtest pipe-A-wait-busy-hang: SUCCESS (7.133s)
[450.114467] [099/136] (603s left) kms_cursor_crc (cursor-onscreen-max-size)
[450.475966] Starting subtest: cursor-onscreen-max-size
[450.535166] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[450.649521] [100/136] (603s left) gem_tiled_blits (normal)
[451.111713] Starting subtest: normal
[500.971650] Subtest normal: SUCCESS (49.864s)
[501.105104] [101/136] (552s left) core_auth (getclient-simple)
[501.474369] Starting subtest: getclient-simple
[501.493325] Subtest getclient-simple: SUCCESS (0.003s)
[501.588612] [102/136] (552s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[501.956316] Starting subtest: basic-flip-after-cursor-legacy
[503.240810] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.283s)
[503.615384] [103/136] (550s left) gen9_exec_parse (bb-start-cmd)
[503.885584] Starting subtest: bb-start-cmd
[503.906098] Subtest bb-start-cmd: SUCCESS (0.004s)
[504.128546] [104/136] (550s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[504.549702] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[504.588661] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[504.704513] [105/136] (549s left) kms_ccs (pipe-d-crc-primary-basic-yf_tiled_ccs)
[505.278849] Subtest pipe-D-crc-primary-basic-yf_tiled_ccs: SKIP (0.000s)
[505.619991] [106/136] (548s left) i915_hangman (gt-error-state-capture)
[505.891094] Starting subtest: gt-error-state-capture
[505.912489] Starting dynamic subtest: rcs0
[516.080123] Dynamic subtest rcs0: SUCCESS (10.057s)
[516.121944] Starting dynamic subtest: bcs0
[526.121024] Dynamic subtest bcs0: SUCCESS (10.032s)
[526.160505] Starting dynamic subtest: vcs0
[536.101815] Dynamic subtest vcs0: SUCCESS (9.975s)
[536.141044] Starting dynamic subtest: vecs0
[546.086813] Dynamic subtest vecs0: SUCCESS (9.989s)
[546.105567] Subtest gt-error-state-capture: SUCCESS (40.058s)
[546.222004] [107/136] (508s left) v3d/v3d_submit_csd (bad-multisync-out-sync)
[546.575444] Subtest bad-multisync-out-sync: SKIP (0.000s)
[546.669032] [108/136] (508s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[547.005922] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[547.024513] Starting dynamic subtest: A-DP1
[548.216963] Dynamic subtest A-DP1: SUCCESS (1.175s)
[548.263639] Starting dynamic subtest: B-DP1
[549.251446] Dynamic subtest B-DP1: SUCCESS (1.028s)
[549.299093] Starting dynamic subtest: C-DP1
[550.253584] Dynamic subtest C-DP1: SUCCESS (1.033s)
[550.278164] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (3.245s)
[550.671604] [109/136] (504s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_dg2_rc_ccs_cc)
[551.119659] Starting subtest: pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs_cc
[551.174932] Subtest pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.001s)
[551.628105] [110/136] (503s left) syncobj_timeline (wait-all-complex)
[551.887548] Starting subtest: wait-all-complex
[552.092634] Subtest wait-all-complex: SUCCESS (0.216s)
[552.233201] [111/136] (502s left) kms_cursor_crc (cursor-onscreen-256x256)
[552.584994] Starting subtest: cursor-onscreen-256x256
[552.603821] Starting dynamic subtest: pipe-A-DP-1
[554.913194] Dynamic subtest pipe-A-DP-1: SUCCESS (2.321s)
[555.007807] Starting dynamic subtest: pipe-B-DP-1
[557.391335] Dynamic subtest pipe-B-DP-1: SUCCESS (2.411s)
[557.460861] Starting dynamic subtest: pipe-C-DP-1
[559.846802] Dynamic subtest pipe-C-DP-1: SUCCESS (2.396s)
[559.865921] Subtest cursor-onscreen-256x256: SUCCESS (7.255s)
[560.239291] [112/136] (495s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_ccs)
[560.696987] Starting subtest: pipe-B-crc-primary-basic-y_tiled_ccs
[561.343054] Subtest pipe-B-crc-primary-basic-y_tiled_ccs: SUCCESS (0.642s)
[561.887649] [113/136] (493s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[562.125561] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[562.144258] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[562.262803] [114/136] (493s left) kms_vrr (flip-suspend)
[562.601506] Starting subtest: flip-suspend
[562.639726] Subtest flip-suspend: SKIP (0.000s)
[562.754854] [115/136] (492s left) kms_ccs (pipe-a-missing-ccs-buffer-y_tiled_ccs)
[563.224719] Starting subtest: pipe-A-missing-ccs-buffer-y_tiled_ccs
[563.246231] Subtest pipe-A-missing-ccs-buffer-y_tiled_ccs: SUCCESS (0.001s)
[563.687360] [116/136] (492s left) v3d/v3d_get_param (base-params)
[564.007904] Subtest base-params: SKIP (0.000s)
[564.121425] [117/136] (491s left) kms_big_fb (linear-16bpp-rotate-90)
[564.501059] Starting subtest: linear-16bpp-rotate-90
[564.584853] Subtest linear-16bpp-rotate-90: SKIP (0.079s)
[564.716310] [118/136] (491s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[564.987840] Starting subtest: x-tiled-to-vebox-yf-tiled
[565.026201] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[565.217135] [119/136] (490s left) kms_cursor_legacy (forked-move)
[565.546860] Starting subtest: forked-move
[565.566943] Starting dynamic subtest: pipe-A
[587.111616] Dynamic subtest pipe-A: SUCCESS (21.549s)
[587.155035] Starting dynamic subtest: pipe-B
[608.678778] Dynamic subtest pipe-B: SUCCESS (21.568s)
[608.757435] Starting dynamic subtest: pipe-C
[630.223193] Dynamic subtest pipe-C: SUCCESS (21.541s)
[630.305236] Starting dynamic subtest: all-pipes
[651.773820] Dynamic subtest all-pipes: SUCCESS (21.553s)
[651.792592] Subtest forked-move: SUCCESS (86.215s)
[651.884533] [120/136] (404s left) gem_softpin (allocator-nopin-reserve)
[652.130235] Starting subtest: allocator-nopin-reserve
[652.361459] Subtest allocator-nopin-reserve: SUCCESS (0.232s)
[652.516344] [121/136] (403s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[652.830077] Starting subtest: flip-vs-cursor-atomic
[668.125130] Subtest flip-vs-cursor-atomic: SUCCESS (15.200s)
[668.396458] [122/136] (387s left) kms_concurrent (pipe-b)
[668.734181] Starting subtest: pipe-B
[668.753094] Starting dynamic subtest: DP-1
[669.512118] Dynamic subtest DP-1: SUCCESS (0.763s)
[669.533049] Subtest pipe-B: SUCCESS (0.766s)
[669.839731] [123/136] (386s left) kms_chamelium_hpd (hdmi-hpd)
[670.269593] Subtest hdmi-hpd: SKIP (0.000s)
[670.609468] [124/136] (385s left) gem_exec_reloc (basic-gtt-wc)
[670.848238] Starting subtest: basic-gtt-wc
[670.868357] Subtest basic-gtt-wc: SUCCESS (0.020s)
[671.099562] [125/136] (385s left) kms_rotation_crc (multiplane-rotation)
[671.430802] Starting subtest: multiplane-rotation
[685.398432] Subtest multiplane-rotation: SUCCESS (13.968s)
[685.544017] [126/136] (371s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[685.875228] Starting subtest: cursor-vs-flip-atomic
[723.059560] Subtest cursor-vs-flip-atomic: SUCCESS (37.081s)
[723.320979] [127/136] (333s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[723.712628] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[723.754349] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[723.870398] [128/136] (333s left) v3d/v3d_get_bo_offset (create-get-offsets)
[724.201146] Subtest create-get-offsets: SKIP (0.000s)
[724.317275] [129/136] (332s left) kms_color (ctm-green-to-red)
[724.660374] Starting subtest: ctm-green-to-red
[724.679190] Starting dynamic subtest: pipe-A-DP-1
[725.175019] Dynamic subtest pipe-A-DP-1: SUCCESS (0.504s)
[725.220169] Starting dynamic subtest: pipe-B-DP-1
[725.847834] Dynamic subtest pipe-B-DP-1: SUCCESS (0.667s)
[725.899837] Starting dynamic subtest: pipe-C-DP-1
[726.526329] Dynamic subtest pipe-C-DP-1: SUCCESS (0.685s)
[726.548158] Subtest ctm-green-to-red: SUCCESS (1.869s)
[726.901876] [130/136] (330s left) gem_softpin (invalid)
[727.163897] Starting subtest: invalid
[727.182862] Subtest invalid: SUCCESS (0.012s)
[727.323717] [131/136] (329s left) fbdev (info)
[727.577716] Starting subtest: info
[727.599345] Subtest info: SUCCESS (0.000s)
[727.708414] [132/136] (329s left) gem_exercise_blt (fast-copy-emit)
[728.010820] Starting subtest: fast-copy-emit
[728.029666] Starting dynamic subtest: linear-smem-smem-emit
[728.069871] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.057s)
[728.113051] Starting dynamic subtest: ymajor-smem-smem-emit
[728.134693] Dynamic subtest ymajor-smem-smem-emit: SUCCESS (0.049s)
[728.181035] Starting dynamic subtest: yfmajor-smem-smem-emit
[728.202501] Dynamic subtest yfmajor-smem-smem-emit: SUCCESS (0.047s)
[728.243962] Starting dynamic subtest: tile64-smem-smem-emit
[728.262879] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.047s)
[728.281572] Subtest fast-copy-emit: SUCCESS (0.205s)
[728.396902] [133/136] (329s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[728.793599] Starting subtest: fbc-rgb101010-draw-mmap-wc
[731.522787] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (2.683s)
[731.614448] [134/136] (325s left) vc4/vc4_tiling (get-bad-handle)
[731.922474] Subtest get-bad-handle: SKIP (0.000s)
[732.020249] [135/136] (325s left) kms_ccs (pipe-d-bad-pixel-format-y_tiled_gen12_rc_ccs)
[732.589482] Subtest pipe-D-bad-pixel-format-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[732.921064] [136/136] (324s left) perf_pmu (rc6)
[733.175214] Starting subtest: rc6
[739.503457] Subtest rc6: SUCCESS (6.336s)
[739.609648] Closing watchdogs
Done.