[41.418930] Initializing watchdogs
[41.419289]   /dev/watchdog0
[41.434904] [001/137] (960s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[41.833780] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[42.126254] [002/137] (959s left) kms_plane (plane-position-covered)
[42.404748] Starting subtest: plane-position-covered
[42.406084] Starting dynamic subtest: pipe-A-planes
[43.922823] Dynamic subtest pipe-A-planes: SUCCESS (1.518s)
[43.937429] Starting dynamic subtest: pipe-B-planes
[45.711316] Dynamic subtest pipe-B-planes: SUCCESS (1.785s)
[45.715067] Subtest plane-position-covered: SUCCESS (3.308s)
[46.050950] [003/137] (955s left) gem_exec_balancer (hog)
[46.263335] Starting subtest: hog
[49.905810] Subtest hog: SUCCESS (3.642s)
[53.733998] [004/137] (948s left) gem_close_race (basic-process)
[53.957168] Starting subtest: basic-process
[54.054964] Subtest basic-process: SUCCESS (0.098s)
[54.250856] [005/137] (947s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[54.539971] Starting subtest: psr-1p-primscrn-spr-indfb-move
[54.542415] Subtest psr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[54.634635] [006/137] (947s left) kms_chamelium_frames (hdmi-frame-dump)
[55.002685] Subtest hdmi-frame-dump: SKIP (0.000s)
[55.273992] [007/137] (946s left) dmabuf_sync_file (import-multiple-read-only)
[55.536365] Starting subtest: import-multiple-read-only
[55.548797] Subtest import-multiple-read-only: SUCCESS (0.011s)
[55.601113] [008/137] (946s left) perf (i915-ref-count)
[55.854648] Starting subtest: i915-ref-count
[55.941781] Subtest i915-ref-count: SUCCESS (0.086s)
[55.997928] [009/137] (946s left) i915_pm_rps (waitboost)
[56.182485] Starting subtest: waitboost
[58.747920] Subtest waitboost: SUCCESS (2.566s)
[58.815176] [010/137] (943s left) gem_exec_whisper (basic-fds-priority)
[59.013873] Starting subtest: basic-fds-priority
[77.784516] Subtest basic-fds-priority: SUCCESS (18.769s)
[77.970512] [011/137] (924s left) kms_psr (psr2_sprite_plane_onoff)
[78.153806] Subtest psr2_sprite_plane_onoff: SKIP (0.000s)
[78.207467] [012/137] (924s left) gem_eio (wait-wedge-1us)
[78.414688] Starting subtest: wait-wedge-1us
[78.497393] Subtest wait-wedge-1us: SUCCESS (0.084s)
[78.672120] [013/137] (923s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-render)
[78.953252] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-render
[78.955778] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-render: SKIP (0.000s)
[79.053601] [014/137] (923s left) kms_ccs (pipe-d-missing-ccs-buffer-y_tiled_ccs)
[79.671354] Subtest pipe-D-missing-ccs-buffer-y_tiled_ccs: SKIP (0.000s)
[79.980521] [015/137] (922s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[80.286491] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[80.315450] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.027s)
[80.430376] [016/137] (921s left) kms_addfb_basic (bo-too-small)
[80.707022] Starting subtest: bo-too-small
[80.708306] Subtest bo-too-small: SUCCESS (0.001s)
[80.980268] [017/137] (921s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[81.262776] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[83.362624] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (2.103s)
[83.497881] [018/137] (918s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[83.777326] Starting subtest: 2x-long-cursor-vs-flip-legacy
[83.780180] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.004s)
[83.863624] [019/137] (918s left) api_intel_bb (offset-control)
[84.043240] Starting subtest: offset-control
[84.061387] Subtest offset-control: SUCCESS (0.018s)
[84.181117] [020/137] (918s left) gem_exec_reloc (basic-write-cpu)
[84.367574] Starting subtest: basic-write-cpu
[84.385445] Subtest basic-write-cpu: SUCCESS (0.017s)
[84.564045] [021/137] (917s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[84.836132] Starting subtest: basic-flip-before-cursor-varying-size
[86.164395] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.331s)
[86.481681] [022/137] (916s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-gtt)
[86.769731] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-gtt
[86.772368] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[86.862224] [023/137] (915s left) vc4/vc4_label_bo (set-label)
[87.096582] Subtest set-label: SKIP (0.000s)
[87.162297] [024/137] (915s left) v3d/v3d_submit_cl (bad-multisync-pad)
[87.396335] Subtest bad-multisync-pad: SKIP (0.000s)
[87.462178] [025/137] (915s left) gem_caching (writes)
[87.646609] Starting subtest: writes
[101.523863] Subtest writes: SUCCESS (13.877s)
[101.630632] [026/137] (901s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[101.934695] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[101.963631] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.027s)
[102.080240] [027/137] (900s left) perf_pmu (busy-hang)
[102.263674] Starting subtest: busy-hang
[102.265201] Starting dynamic subtest: rcs0
[103.299074] Dynamic subtest rcs0: SUCCESS (1.035s)
[103.316705] Starting dynamic subtest: bcs0
[104.343883] Dynamic subtest bcs0: SUCCESS (1.045s)
[104.361537] Starting dynamic subtest: vcs0
[105.379472] Dynamic subtest vcs0: SUCCESS (1.033s)
[105.397030] Starting dynamic subtest: vecs0
[106.410308] Dynamic subtest vecs0: SUCCESS (1.033s)
[106.411865] Subtest busy-hang: SUCCESS (4.146s)
[106.495663] [028/137] (896s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted-signaled)
[106.675896] Starting subtest: invalid-multi-wait-all-available-unsubmitted-signaled
[106.678937] Subtest invalid-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.002s)
[106.761731] [029/137] (896s left) kms_ccs (pipe-c-bad-pixel-format-y_tiled_gen12_mc_ccs)
[107.286661] Starting subtest: pipe-C-bad-pixel-format-y_tiled_gen12_mc_ccs
[107.289267] Subtest pipe-C-bad-pixel-format-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[107.678894] [030/137] (895s left) gem_ccs (block-copy-compressed)
[107.862758] Subtest block-copy-compressed: SKIP (0.000s)
[107.915048] [031/137] (894s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[108.187799] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[108.190416] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[108.277985] [032/137] (894s left) gem_softpin (zero)
[108.460977] Starting subtest: zero
[108.468029] Subtest zero: SUCCESS (0.006s)
[108.578850] [033/137] (894s left) sysfs_heartbeat_interval (precise)
[108.760265] Starting subtest: precise
[108.761748] Starting dynamic subtest: vecs0
[110.266711] Dynamic subtest vecs0: SUCCESS (1.505s)
[110.284653] Starting dynamic subtest: vcs0
[111.760965] Dynamic subtest vcs0: SUCCESS (1.493s)
[111.779391] Starting dynamic subtest: bcs0
[113.250993] Dynamic subtest bcs0: SUCCESS (1.489s)
[113.268295] Starting dynamic subtest: rcs0
[114.738976] Dynamic subtest rcs0: SUCCESS (1.489s)
[114.740350] Subtest precise: SUCCESS (5.979s)
[114.810791] [034/137] (888s left) vgem_basic (bad-fence)
[115.010649] Starting subtest: bad-fence
[115.011963] Subtest bad-fence: SUCCESS (0.000s)
[115.077676] [035/137] (887s left) kms_cursor_crc (cursor-onscreen-128x42)
[115.375143] Starting subtest: cursor-onscreen-128x42
[115.387317] Starting dynamic subtest: pipe-A-DP-1
[117.734733] Dynamic subtest pipe-A-DP-1: SUCCESS (2.342s)
[117.805270] Starting dynamic subtest: pipe-B-DP-1
[120.326729] Dynamic subtest pipe-B-DP-1: SUCCESS (2.536s)
[120.420816] Starting dynamic subtest: pipe-C-DP-1
[123.125545] Dynamic subtest pipe-C-DP-1: SUCCESS (2.731s)
[123.126972] Subtest cursor-onscreen-128x42: SUCCESS (7.752s)
[123.463724] [036/137] (879s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[123.748333] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[123.750940] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[123.858772] [037/137] (879s left) syncobj_wait (wait-delayed-signal)
[124.036865] Starting subtest: wait-delayed-signal
[124.140353] Subtest wait-delayed-signal: SUCCESS (0.103s)
[124.226097] [038/137] (878s left) i915_pm_rpm (gem-evict-pwrite)
[126.094625] Starting subtest: gem-evict-pwrite
[127.169345] Subtest gem-evict-pwrite: SUCCESS (1.074s)
[127.635751] [039/137] (875s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[127.929900] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[127.932546] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[128.018434] [040/137] (875s left) i915_pm_dc (dc5-dpms-negative)
[129.300465] Starting subtest: dc5-dpms-negative
[133.603244] Subtest dc5-dpms-negative: SUCCESS (4.305s)
[133.800165] [041/137] (869s left) gem_pxp (protected-raw-src-copy-not-readible)
[136.500420] Subtest protected-raw-src-copy-not-readible: SKIP (0.000s)
[136.583115] [042/137] (866s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[136.877518] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[136.880499] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[136.968177] [043/137] (866s left) api_intel_bb (intel-bb-blit-y)
[137.144057] Starting subtest: intel-bb-blit-y
[140.345611] Subtest intel-bb-blit-y: SUCCESS (3.202s)
[140.452599] [044/137] (862s left) kms_lease (lease_invalid_connector)
[140.730614] Starting subtest: lease_invalid_connector
[140.731927] Starting dynamic subtest: pipe-A-DP-1
[140.733403] Dynamic subtest pipe-A-DP-1: SUCCESS (0.000s)
[140.750418] Starting dynamic subtest: pipe-B-DP-1
[140.751702] Dynamic subtest pipe-B-DP-1: SUCCESS (0.000s)
[140.768764] Starting dynamic subtest: pipe-C-DP-1
[140.770098] Dynamic subtest pipe-C-DP-1: SUCCESS (0.000s)
[140.771311] Subtest lease_invalid_connector: SUCCESS (0.005s)
[140.818047] [045/137] (862s left) kms_ccs (pipe-a-crc-primary-basic-yf_tiled_ccs)
[141.192430] Starting subtest: pipe-A-crc-primary-basic-yf_tiled_ccs
[141.838646] Subtest pipe-A-crc-primary-basic-yf_tiled_ccs: SUCCESS (0.647s)
[142.483271] [046/137] (860s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[142.769515] Starting subtest: cursor-rapid-movement-128x128
[142.780438] Starting dynamic subtest: pipe-A-DP-1
[143.280629] Dynamic subtest pipe-A-DP-1: SUCCESS (0.498s)
[143.362342] Starting dynamic subtest: pipe-B-DP-1
[144.031886] Dynamic subtest pipe-B-DP-1: SUCCESS (0.696s)
[144.110290] Starting dynamic subtest: pipe-C-DP-1
[144.932223] Dynamic subtest pipe-C-DP-1: SUCCESS (0.838s)
[144.933454] Subtest cursor-rapid-movement-128x128: SUCCESS (2.162s)
[145.275142] [047/137] (858s left) gem_lmem_swapping (parallel-random-verify-ccs)
[145.464589] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[145.506192] [048/137] (857s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc)
[145.933122] Starting subtest: pipe-A-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc
[145.938069] Subtest pipe-A-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.005s)
[146.422714] [049/137] (857s left) gem_exec_balancer (persistence)
[150.372979] Starting subtest: persistence
[154.021104] Subtest persistence: SUCCESS (3.647s)
[154.106339] [050/137] (849s left) gem_exec_params (rs-invalid)
[154.291676] Starting subtest: rs-invalid
[154.298664] Subtest rs-invalid: SUCCESS (0.006s)
[154.404650] [051/137] (849s left) gem_busy (close-race)
[154.601764] Starting subtest: close-race
[177.982900] Subtest close-race: SUCCESS (23.381s)
[178.345773] [052/137] (825s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[178.770498] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[178.773200] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[178.877983] [053/137] (824s left) kms_vblank (pipe-c-wait-forked)
[179.154513] Starting subtest: pipe-C-wait-forked
[181.955558] Subtest pipe-C-wait-forked: SUCCESS (2.804s)
[182.289530] [054/137] (821s left) kms_vrr (flip-dpms)
[182.561881] Starting subtest: flip-dpms
[182.564472] Subtest flip-dpms: SKIP (0.000s)
[182.606937] [055/137] (821s left) gem_ctx_param (vm)
[182.781264] Starting subtest: vm
[182.839476] Subtest vm: SUCCESS (0.059s)
[182.955218] [056/137] (820s left) template (b)
[183.131778] Starting subtest: B
[183.133424] Subtest B: SUCCESS (0.000s)
[183.222412] [057/137] (820s left) gem_ctx_engines (invalid-engines)
[183.420394] Starting subtest: invalid-engines
[183.438107] Subtest invalid-engines: SUCCESS (0.018s)
[183.639163] [058/137] (820s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[183.916825] Starting subtest: 2x-long-flip-vs-cursor-legacy
[183.919577] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.003s)
[184.005693] [059/137] (819s left) kms_flip (2x-blocking-wf_vblank)
[184.272760] Starting subtest: 2x-blocking-wf_vblank
[184.275289] Subtest 2x-blocking-wf_vblank: SKIP (0.003s)
[184.372783] [060/137] (819s left) gem_exec_flush (basic-batch-kernel-default-wb)
[184.573238] Starting subtest: basic-batch-kernel-default-wb
[190.308075] Subtest basic-batch-kernel-default-wb: SUCCESS (5.735s)
[190.505479] [061/137] (813s left) api_intel_allocator (fork-simple-stress-signal)
[190.680565] Starting subtest: fork-simple-stress-signal
[196.182652] Subtest fork-simple-stress-signal: SUCCESS (5.503s)
[196.273143] [062/137] (807s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[196.553227] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[196.555831] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.004s)
[196.638923] [063/137] (807s left) perf_pmu (idle)
[196.822733] Starting subtest: idle
[196.824245] Starting dynamic subtest: rcs0
[197.331491] Dynamic subtest rcs0: SUCCESS (0.506s)
[197.350130] Starting dynamic subtest: bcs0
[197.839091] Dynamic subtest bcs0: SUCCESS (0.506s)
[197.857492] Starting dynamic subtest: vcs0
[198.346601] Dynamic subtest vcs0: SUCCESS (0.505s)
[198.365182] Starting dynamic subtest: vecs0
[198.853379] Dynamic subtest vecs0: SUCCESS (0.506s)
[198.854784] Subtest idle: SUCCESS (2.030s)
[198.938195] [064/137] (805s left) gem_exec_fence (long-history)
[199.534522] Starting subtest: long-history
[205.280901] Subtest long-history: SUCCESS (5.746s)
[205.921208] [065/137] (798s left) gem_ctx_shared (exec-shared-gtt)
[206.119753] Starting subtest: exec-shared-gtt
[206.121199] Starting dynamic subtest: rcs0
[206.132229] Dynamic subtest rcs0: SUCCESS (0.011s)
[206.157656] Starting dynamic subtest: bcs0
[206.159385] Dynamic subtest bcs0: SUCCESS (0.018s)
[206.179451] Starting dynamic subtest: vcs0
[206.180739] Dynamic subtest vcs0: SUCCESS (0.008s)
[206.200861] Starting dynamic subtest: vecs0
[206.202170] Dynamic subtest vecs0: SUCCESS (0.008s)
[206.203425] Subtest exec-shared-gtt: SUCCESS (0.049s)
[206.398304] [066/137] (797s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[206.585962] Starting subtest: tiled-to-untiled
[206.702188] Subtest tiled-to-untiled: SUCCESS (0.114s)
[206.805298] [067/137] (797s left) perf (invalid-oa-exponent)
[207.095366] Starting subtest: invalid-oa-exponent
[207.158066] Subtest invalid-oa-exponent: SUCCESS (0.060s)
[207.203256] [068/137] (796s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[207.488444] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[207.491071] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[207.589449] [069/137] (796s left) drm_read (short-buffer-wakeup)
[208.220550] Starting subtest: short-buffer-wakeup
[240.437084] Subtest short-buffer-wakeup: SUCCESS (32.216s)
[240.556366] [070/137] (763s left) kms_big_fb (linear-64bpp-rotate-180)
[240.861300] Starting subtest: linear-64bpp-rotate-180
[248.985579] Subtest linear-64bpp-rotate-180: SUCCESS (8.123s)
[249.958148] [071/137] (754s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[250.262984] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[250.266130] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[250.390452] [072/137] (753s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[250.572423] Starting subtest: invalid-single-wait-all-unsubmitted
[250.574031] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.001s)
[250.657164] [073/137] (753s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-render)
[250.941123] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-render
[250.943651] Subtest fbcpsr-1p-offscren-pri-indfb-draw-render: SKIP (0.000s)
[251.089610] [074/137] (753s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[251.386493] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[251.389128] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[251.539696] [075/137] (752s left) perf (invalid-create-userspace-config)
[251.804727] Starting subtest: invalid-create-userspace-config
[251.809148] Subtest invalid-create-userspace-config: SUCCESS (0.006s)
[251.853232] [076/137] (752s left) gem_tiled_pread_pwrite
[253.101791] [077/137] (751s left) kms_vblank (pipe-c-query-forked)
[253.509813] Starting subtest: pipe-C-query-forked
[256.365285] Subtest pipe-C-query-forked: SUCCESS (2.858s)
[256.698097] [078/137] (747s left) gem_mmap_gtt (hang-user)
[256.880658] Starting subtest: hang-user
[271.737709] Subtest hang-user: SUCCESS (14.854s)
[271.830892] [079/137] (732s left) kms_ccs (pipe-d-missing-ccs-buffer-y_tiled_gen12_rc_ccs)
[272.461758] Subtest pipe-D-missing-ccs-buffer-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[272.777662] [080/137] (731s left) gem_exec_fence (basic-wait-all)
[272.987439] Starting subtest: basic-wait-all
[273.019700] Subtest basic-wait-all: SUCCESS (0.035s)
[273.777198] [081/137] (730s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[273.967574] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[274.074247] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.107s)
[274.160157] [082/137] (730s left) kms_draw_crc (draw-method-blt)
[274.434830] Starting subtest: draw-method-blt
[274.436175] Starting dynamic subtest: xrgb8888-untiled
[274.739053] Dynamic subtest xrgb8888-untiled: SUCCESS (0.303s)
[274.762486] Starting dynamic subtest: xrgb8888-xtiled
[274.903638] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.166s)
[274.926195] Starting dynamic subtest: xrgb8888-ytiled
[275.071908] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.166s)
[275.094684] Starting dynamic subtest: rgb565-untiled
[275.354884] Dynamic subtest rgb565-untiled: SUCCESS (0.283s)
[275.376517] Starting dynamic subtest: rgb565-xtiled
[275.520574] Dynamic subtest rgb565-xtiled: SUCCESS (0.166s)
[275.542656] Starting dynamic subtest: rgb565-ytiled
[275.688224] Dynamic subtest rgb565-ytiled: SUCCESS (0.166s)
[275.709382] Starting dynamic subtest: xrgb2101010-untiled
[275.987713] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.299s)
[276.009815] Starting dynamic subtest: xrgb2101010-xtiled
[276.155047] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.166s)
[276.177068] Starting dynamic subtest: xrgb2101010-ytiled
[276.337696] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.182s)
[276.339756] Subtest draw-method-blt: SUCCESS (1.904s)
[276.442725] [083/137] (728s left) gem_exec_schedule (smoketest)
[276.776471] Starting subtest: smoketest
[276.777812] Starting dynamic subtest: rcs0
[282.225596] Dynamic subtest rcs0: SUCCESS (5.443s)
[282.248661] Starting dynamic subtest: bcs0
[287.669222] Dynamic subtest bcs0: SUCCESS (5.443s)
[287.690281] Starting dynamic subtest: vcs0
[293.114483] Dynamic subtest vcs0: SUCCESS (5.445s)
[293.146759] Starting dynamic subtest: vecs0
[298.562445] Dynamic subtest vecs0: SUCCESS (5.448s)
[298.564079] Subtest smoketest: SUCCESS (21.781s)
[298.761066] [084/137] (705s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[299.041528] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[299.043687] Starting dynamic subtest: pipe-A-DP-1
[299.667415] Dynamic subtest pipe-A-DP-1: SUCCESS (0.626s)
[299.690650] Starting dynamic subtest: pipe-B-DP-1
[300.056363] Dynamic subtest pipe-B-DP-1: SUCCESS (0.386s)
[300.079419] Starting dynamic subtest: pipe-C-DP-1
[300.184321] Dynamic subtest pipe-C-DP-1: SKIP (0.123s)
[300.185608] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SUCCESS (1.144s)
[300.593636] [085/137] (704s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[300.871632] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[300.873196] Starting dynamic subtest: pipe-A-DP-1
[301.069117] Dynamic subtest pipe-A-DP-1: SUCCESS (0.198s)
[301.093614] Starting dynamic subtest: pipe-B-DP-1
[301.492749] Dynamic subtest pipe-B-DP-1: SUCCESS (0.421s)
[301.516189] Starting dynamic subtest: pipe-C-DP-1
[301.913903] Dynamic subtest pipe-C-DP-1: SUCCESS (0.418s)
[301.915426] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (1.045s)
[302.322263] [086/137] (702s left) kms_ccs (pipe-c-crc-primary-basic-yf_tiled_ccs)
[302.875435] Starting subtest: pipe-C-crc-primary-basic-yf_tiled_ccs
[302.878513] Subtest pipe-C-crc-primary-basic-yf_tiled_ccs: SKIP (0.001s)
[303.256202] [087/137] (701s left) syncobj_timeline (multi-wait-available-signaled)
[303.429704] Starting subtest: multi-wait-available-signaled
[303.431091] Subtest multi-wait-available-signaled: SUCCESS (0.002s)
[303.522592] [088/137] (701s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[303.804374] Starting subtest: psr-rgb565-draw-render
[303.806957] Subtest psr-rgb565-draw-render: SKIP (0.000s)
[303.905489] [089/137] (700s left) gem_pxp (verify-pxp-stale-ctx-execution)
[306.597151] Subtest verify-pxp-stale-ctx-execution: SKIP (0.000s)
[306.672545] [090/137] (698s left) syncobj_timeline (invalid-query-bad-pad)
[306.846625] Starting subtest: invalid-query-bad-pad
[306.848473] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[306.938777] [091/137] (698s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[307.214022] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[307.215501] Starting dynamic subtest: pipe-A-valid-mode
[307.300934] Dynamic subtest pipe-A-valid-mode: SKIP (0.087s)
[307.303913] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.089s)
[307.613297] [092/137] (697s left) kms_flip (flip-vs-blocking-wf-vblank)
[307.871977] Starting subtest: flip-vs-blocking-wf-vblank
[307.873444] Starting dynamic subtest: A-DP1
[318.683668] Dynamic subtest A-DP1: SUCCESS (10.811s)
[318.707821] Starting dynamic subtest: B-DP1
[329.434553] Dynamic subtest B-DP1: SUCCESS (10.747s)
[329.455428] Starting dynamic subtest: C-DP1
[340.177420] Dynamic subtest C-DP1: SUCCESS (10.739s)
[340.178712] Subtest flip-vs-blocking-wf-vblank: SUCCESS (32.307s)
[340.587725] [093/137] (664s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[340.844877] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[340.847614] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.003s)
[340.952924] [094/137] (664s left) kms_plane_cursor (viewport)
[341.231795] Starting subtest: viewport
[341.234659] Starting dynamic subtest: pipe-A-DP-1-size-64
[343.662841] Dynamic subtest pipe-A-DP-1-size-64: SUCCESS (2.432s)
[343.733112] Starting dynamic subtest: pipe-A-DP-1-size-128
[346.128878] Dynamic subtest pipe-A-DP-1-size-128: SUCCESS (2.415s)
[346.199632] Starting dynamic subtest: pipe-A-DP-1-size-256
[348.595673] Dynamic subtest pipe-A-DP-1-size-256: SUCCESS (2.415s)
[348.760810] Starting dynamic subtest: pipe-B-DP-1-size-64
[351.369102] Dynamic subtest pipe-B-DP-1-size-64: SUCCESS (2.637s)
[351.445856] Starting dynamic subtest: pipe-B-DP-1-size-128
[353.851938] Dynamic subtest pipe-B-DP-1-size-128: SUCCESS (2.432s)
[353.926378] Starting dynamic subtest: pipe-B-DP-1-size-256
[356.336369] Dynamic subtest pipe-B-DP-1-size-256: SUCCESS (2.430s)
[356.506895] Starting dynamic subtest: pipe-C-DP-1-size-64
[359.152539] Dynamic subtest pipe-C-DP-1-size-64: SUCCESS (2.665s)
[359.222647] Starting dynamic subtest: pipe-C-DP-1-size-128
[361.634862] Dynamic subtest pipe-C-DP-1-size-128: SUCCESS (2.432s)
[361.707508] Starting dynamic subtest: pipe-C-DP-1-size-256
[364.119180] Dynamic subtest pipe-C-DP-1-size-256: SUCCESS (2.432s)
[364.251587] Subtest viewport: SUCCESS (23.024s)
[364.569606] [095/137] (640s left) kms_color (ctm-0-25)
[364.855248] Starting subtest: ctm-0-25
[364.856575] Starting dynamic subtest: pipe-A-DP-1
[366.005543] Dynamic subtest pipe-A-DP-1: SUCCESS (1.150s)
[366.033332] Starting dynamic subtest: pipe-B-DP-1
[367.455416] Dynamic subtest pipe-B-DP-1: SUCCESS (1.444s)
[367.483367] Starting dynamic subtest: pipe-C-DP-1
[369.067379] Dynamic subtest pipe-C-DP-1: SUCCESS (1.610s)
[369.068794] Subtest ctm-0-25: SUCCESS (4.217s)
[369.399629] [096/137] (635s left) vc4/vc4_mmap (mmap-bad-handle)
[369.627874] Subtest mmap-bad-handle: SKIP (0.000s)
[369.699248] [097/137] (635s left) sw_sync (sync_merge)
[369.871931] Starting subtest: sync_merge
[369.873698] Subtest sync_merge: SUCCESS (0.001s)
[369.949268] [098/137] (635s left) kms_cursor_edge_walk (256x256-right-edge)
[370.220935] Starting subtest: 256x256-right-edge
[370.222801] Starting dynamic subtest: pipe-A-DP-1
[373.841250] Dynamic subtest pipe-A-DP-1: SUCCESS (3.622s)
[373.867741] Starting dynamic subtest: pipe-C-DP-1
[377.324843] Dynamic subtest pipe-C-DP-1: SUCCESS (3.480s)
[377.326352] Subtest 256x256-right-edge: SUCCESS (7.108s)
[377.647542] [099/137] (627s left) gem_mmap_offset (pf-nonblock)
[377.823029] Starting subtest: pf-nonblock
[377.834525] Subtest pf-nonblock: SUCCESS (0.013s)
[377.945874] [100/137] (627s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[378.251563] Starting subtest: 4-tiled-16bpp-rotate-0
[378.254633] Subtest 4-tiled-16bpp-rotate-0: SKIP (0.000s)
[378.362802] [101/137] (626s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[378.639815] Starting subtest: basic-busy-flip-before-cursor-atomic
[378.642606] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[378.730216] [102/137] (626s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[379.018116] Starting subtest: fbcpsr-1p-rte
[379.020920] Subtest fbcpsr-1p-rte: SKIP (0.000s)
[379.112939] [103/137] (626s left) kms_invalid_mode (bad-hsync-end)
[379.388702] Starting subtest: bad-hsync-end
[379.390819] Starting dynamic subtest: DP-1-pipe-A
[379.479230] Dynamic subtest DP-1-pipe-A: SUCCESS (0.088s)
[379.499231] Starting dynamic subtest: DP-1-pipe-B
[379.500629] Dynamic subtest DP-1-pipe-B: SUCCESS (0.013s)
[379.520414] Starting dynamic subtest: DP-1-pipe-C
[379.521768] Dynamic subtest DP-1-pipe-C: SUCCESS (0.013s)
[379.523153] Subtest bad-hsync-end: SUCCESS (0.122s)
[379.825560] [104/137] (625s left) kms_flip (modeset-vs-vblank-race-interruptible)
[380.094763] Starting subtest: modeset-vs-vblank-race-interruptible
[380.100591] Starting dynamic subtest: A-DP1
[384.286772] Dynamic subtest A-DP1: SUCCESS (4.186s)
[384.312051] Starting dynamic subtest: B-DP1
[388.563422] Dynamic subtest B-DP1: SUCCESS (4.274s)
[388.585547] Starting dynamic subtest: C-DP1
[392.701638] Dynamic subtest C-DP1: SUCCESS (4.135s)
[392.703073] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (12.606s)
[393.115458] [105/137] (612s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[393.411964] Starting subtest: fbcpsr-tiling-4
[393.414646] Subtest fbcpsr-tiling-4: SKIP (0.000s)
[393.515987] [106/137] (612s left) kms_ccs (pipe-c-missing-ccs-buffer-y_tiled_gen12_mc_ccs)
[394.122453] Starting subtest: pipe-C-missing-ccs-buffer-y_tiled_gen12_mc_ccs
[394.125104] Subtest pipe-C-missing-ccs-buffer-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[394.472846] [107/137] (611s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[394.751890] Starting subtest: psr-1p-primscrn-cur-indfb-move
[394.754583] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[394.856141] [108/137] (610s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[395.126390] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[395.127790] Starting dynamic subtest: pipe-A-valid-mode
[395.804314] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.678s)
[395.805917] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (0.680s)
[396.139147] [109/137] (609s left) syncobj_wait (single-wait-all-signaled)
[396.319969] Starting subtest: single-wait-all-signaled
[396.321704] Subtest single-wait-all-signaled: SUCCESS (0.001s)
[396.405484] [110/137] (609s left) kms_ccs (pipe-b-bad-rotation-90-yf_tiled_ccs)
[396.848247] Starting subtest: pipe-B-bad-rotation-90-yf_tiled_ccs
[397.292342] Subtest pipe-B-bad-rotation-90-yf_tiled_ccs: SUCCESS (0.443s)
[397.867222] [111/137] (607s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[398.053280] Starting subtest: writes-after-reads-uncached
[418.248791] Subtest writes-after-reads-uncached: SUCCESS (20.196s)
[418.365821] [112/137] (587s left) gem_softpin (allocator-basic)
[418.552605] Starting subtest: allocator-basic
[418.775268] Subtest allocator-basic: SUCCESS (0.220s)
[418.901247] [113/137] (586s left) gem_userptr_blits (unsync-unmap)
[419.090829] Subtest unsync-unmap: SKIP (0.000s)
[419.249743] [114/137] (586s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[419.423552] Starting subtest: single-wait-all-for-submit-signaled
[419.425589] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.001s)
[419.515202] [115/137] (586s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[419.784290] Starting subtest: short-flip-after-cursor-atomic-transitions
[420.917788] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (1.128s)
[421.274259] [116/137] (584s left) kms_psr (psr2_dpms)
[421.452642] Subtest psr2_dpms: SKIP (0.000s)
[421.508391] [117/137] (584s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[421.679588] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[421.724888] [118/137] (584s left) sw_sync (sync_multi_consumer)
[421.892761] Starting subtest: sync_multi_consumer
[423.062488] Subtest sync_multi_consumer: SUCCESS (1.169s)
[423.140157] [119/137] (582s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[423.413480] Starting subtest: addfb25-x-tiled-legacy
[423.414808] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[423.707519] [120/137] (582s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[423.994712] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[423.997563] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[424.089407] [121/137] (582s left) kms_sequence (queue-idle)
[424.361722] Starting subtest: queue-idle
[424.363050] Starting dynamic subtest: DP-1-pipe-A
[426.629573] Dynamic subtest DP-1-pipe-A: SUCCESS (2.269s)
[426.651510] Starting dynamic subtest: DP-1-pipe-B
[429.213968] Dynamic subtest DP-1-pipe-B: SUCCESS (2.581s)
[429.235245] Starting dynamic subtest: DP-1-pipe-C
[431.886513] Dynamic subtest DP-1-pipe-C: SUCCESS (2.672s)
[431.887929] Subtest queue-idle: SUCCESS (7.529s)
[432.198230] [122/137] (573s left) kms_vblank (pipe-c-query-idle-hang)
[432.467704] Starting subtest: pipe-C-query-idle-hang
[439.537041] Subtest pipe-C-query-idle-hang: SUCCESS (7.072s)
[439.858826] [123/137] (566s left) kms_ccs (pipe-d-bad-pixel-format-y_tiled_gen12_rc_ccs)
[440.492466] Subtest pipe-D-bad-pixel-format-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[440.803698] [124/137] (565s left) gem_exec_fence (invalid-fence-array)
[441.412963] Starting subtest: invalid-fence-array
[441.420897] Subtest invalid-fence-array: SUCCESS (0.006s)
[441.771433] [125/137] (564s left) i915_pm_rpm (system-suspend-modeset)
[443.544476] Starting subtest: system-suspend-modeset
[461.635541] Subtest system-suspend-modeset: SUCCESS (2.080s)
[467.318517] [126/137] (559s left) v3d/v3d_perfmon (create-perfmon-0)
[467.552018] Subtest create-perfmon-0: SKIP (0.000s)
[467.626904] [127/137] (559s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[467.918277] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[467.952586] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.032s)
[468.077109] [128/137] (559s left) perf_pmu (interrupts)
[468.257145] Starting subtest: interrupts
[469.384759] Subtest interrupts: SUCCESS (1.127s)
[469.493630] [129/137] (557s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[469.768856] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[471.999622] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SUCCESS (2.234s)
[472.143877] [130/137] (555s left) gen9_exec_parse (batch-zero-length)
[472.339591] Starting subtest: batch-zero-length
[472.343859] Subtest batch-zero-length: SUCCESS (0.003s)
[472.560463] [131/137] (554s left) kms_flip (plain-flip-interruptible)
[472.834241] Starting subtest: plain-flip-interruptible
[472.839326] Starting dynamic subtest: A-DP1
[474.025142] Dynamic subtest A-DP1: SUCCESS (1.186s)
[474.051264] Starting dynamic subtest: B-DP1
[475.129220] Dynamic subtest B-DP1: SUCCESS (1.102s)
[475.155842] Starting dynamic subtest: C-DP1
[476.241413] Dynamic subtest C-DP1: SUCCESS (1.111s)
[476.243050] Subtest plain-flip-interruptible: SUCCESS (3.409s)
[476.657223] [132/137] (550s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs)
[477.204902] Starting subtest: pipe-B-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs
[477.212034] Subtest pipe-B-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs: SKIP (0.006s)
[477.642591] [133/137] (549s left) gen7_exec_parse (batch-without-end)
[477.825414] Subtest batch-without-end: SKIP (0.000s)
[477.877701] [134/137] (549s left) gem_exec_params (invalid-bsd2-flag-on-render)
[478.056230] Starting subtest: invalid-bsd2-flag-on-render
[478.057555] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.001s)
[478.174805] [135/137] (549s left) kms_ccs (pipe-a-bad-rotation-90-4_tiled_dg2_rc_ccs_cc)
[478.549240] Starting subtest: pipe-A-bad-rotation-90-4_tiled_dg2_rc_ccs_cc
[478.552180] Subtest pipe-A-bad-rotation-90-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[479.117948] [136/137] (548s left) gem_exec_schedule (preempt-other)
[479.320135] Starting subtest: preempt-other
[479.322039] Starting dynamic subtest: rcs0
[479.393065] Dynamic subtest rcs0: SUCCESS (0.071s)
[479.432301] Starting dynamic subtest: bcs0
[479.472089] Dynamic subtest bcs0: SUCCESS (0.077s)
[479.504394] Starting dynamic subtest: vcs0
[479.546590] Dynamic subtest vcs0: SUCCESS (0.072s)
[479.582174] Starting dynamic subtest: vecs0
[479.624493] Dynamic subtest vecs0: SUCCESS (0.076s)
[479.626672] Subtest preempt-other: SUCCESS (0.304s)
[479.968424] [137/137] (547s left) gem_exec_reloc (basic-softpin)
[480.155777] Starting subtest: basic-softpin
[480.161047] Subtest basic-softpin: SUCCESS (0.006s)
[480.364086] Closing watchdogs
Done.