[51.603169] Initializing watchdogs [51.603391] /dev/watchdog0 [51.620837] [001/142] (960s left) syncobj_wait (wait-all-for-submit-delayed-submit) [51.794666] Starting subtest: wait-all-for-submit-delayed-submit [51.900074] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s) [51.997267] [002/142] (960s left) gen9_exec_parse (cmd-crossing-page) [52.223828] Starting subtest: cmd-crossing-page [52.254218] Subtest cmd-crossing-page: SUCCESS (0.026s) [52.463789] [003/142] (959s left) gem_render_copy (y-tiled-to-vebox-linear) [52.625870] Starting subtest: y-tiled-to-vebox-linear [52.630204] Subtest y-tiled-to-vebox-linear: SKIP (0.000s) [52.828550] [004/142] (959s left) kms_feature_discovery (display-4x) [53.069073] Starting subtest: display-4x [53.073454] Subtest display-4x: SKIP (0.000s) [53.142759] [005/142] (959s left) kms_dp_aux_dev [53.826195] [006/142] (958s left) kms_big_fb (linear-32bpp-rotate-0) [54.094092] Starting subtest: linear-32bpp-rotate-0 [60.228042] Subtest linear-32bpp-rotate-0: SUCCESS (6.133s) [60.744814] [007/142] (951s left) kms_big_fb (x-tiled-32bpp-rotate-90) [61.015039] Starting subtest: x-tiled-32bpp-rotate-90 [61.103660] Subtest x-tiled-32bpp-rotate-90: SKIP (0.086s) [61.211157] [008/142] (951s left) kms_flip (modeset-vs-vblank-race) [61.440230] Starting subtest: modeset-vs-vblank-race [61.442457] Starting dynamic subtest: A-DP1 [65.997322] Dynamic subtest A-DP1: SUCCESS (4.513s) [66.021825] Starting dynamic subtest: B-DP1 [70.364030] Dynamic subtest B-DP1: SUCCESS (4.410s) [70.377870] Starting dynamic subtest: C-DP1 [74.799835] Dynamic subtest C-DP1: SUCCESS (4.434s) [74.802080] Subtest modeset-vs-vblank-race: SUCCESS (13.364s) [75.215146] [009/142] (937s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels) [75.472944] Starting subtest: plane-all-modeset-transition-fencing-internal-panels [75.476848] Subtest plane-all-modeset-transition-fencing-internal-panels: SKIP (0.000s) [75.546747] [010/142] (936s left) gem_pxp (create-regular-buffer) [78.215430] Subtest create-regular-buffer: SKIP (0.000s) [78.295043] [011/142] (934s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled) [78.441322] Starting subtest: multi-wait-for-submit-submitted-signaled [78.443667] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.002s) [78.528077] [012/142] (933s left) kms_ccs (pipe-c-bad-pixel-format-y_tiled_gen12_rc_ccs_cc) [78.957698] Starting subtest: pipe-C-bad-pixel-format-y_tiled_gen12_rc_ccs_cc [78.961793] Subtest pipe-C-bad-pixel-format-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s) [79.336834] [013/142] (933s left) v3d/v3d_submit_csd (job-perfmon) [79.539535] Subtest job-perfmon: SKIP (0.000s) [79.604266] [014/142] (932s left) kms_color (invalid-ctm-matrix-sizes) [79.849087] Starting subtest: invalid-ctm-matrix-sizes [79.851084] Starting dynamic subtest: pipe-A [79.855532] Dynamic subtest pipe-A: SUCCESS (0.007s) [79.869851] Starting dynamic subtest: pipe-B [79.871834] Dynamic subtest pipe-B: SUCCESS (0.008s) [79.886250] Starting dynamic subtest: pipe-C [79.888152] Dynamic subtest pipe-C: SUCCESS (0.014s) [79.890090] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.031s) [79.954361] [015/142] (932s left) kms_universal_plane (cursor-fb-leak-pipe-d) [80.199970] Subtest cursor-fb-leak-pipe-D: SKIP (0.000s) [80.270671] [016/142] (932s left) kms_vblank (pipe-c-query-idle-hang) [80.507299] Starting subtest: pipe-C-query-idle-hang [87.984255] Subtest pipe-C-query-idle-hang: SUCCESS (7.478s) [88.330089] [017/142] (924s left) debugfs_test (read_all_entries_display_on) [88.579023] Starting subtest: read_all_entries_display_on [88.835917] Subtest read_all_entries_display_on: SUCCESS (0.256s) [88.962252] [018/142] (923s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [89.217494] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [89.221426] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [89.310931] [019/142] (923s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs) [89.681537] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs [89.688711] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs: SKIP (0.005s) [90.112601] [020/142] (922s left) kms_plane_scaling (intel-max-src-size) [90.356808] Starting subtest: intel-max-src-size [90.359101] Starting dynamic subtest: pipe-A-DP-1 [90.405417] Dynamic subtest pipe-A-DP-1: SUCCESS (0.051s) [90.407994] Subtest intel-max-src-size: SUCCESS (0.052s) [90.511135] [021/142] (922s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-pwrite) [90.762924] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-pwrite [90.766783] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-pwrite: SKIP (0.000s) [90.843209] [022/142] (922s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move) [91.092951] Starting subtest: psr-2p-scndscrn-cur-indfb-move [91.096902] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [91.176503] [023/142] (921s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_dg2_mc_ccs) [91.565170] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_dg2_mc_ccs [91.569240] Subtest pipe-B-crc-primary-rotation-180-4_tiled_dg2_mc_ccs: SKIP (0.001s) [91.962127] [024/142] (920s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt) [92.237977] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt [92.241898] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [92.296217] [025/142] (920s left) kms_vblank (pipe-b-ts-continuation-modeset) [92.546089] Starting subtest: pipe-B-ts-continuation-modeset [93.503561] Subtest pipe-B-ts-continuation-modeset: SUCCESS (0.957s) [93.830168] [026/142] (919s left) vc4/vc4_wait_bo (unused-bo-1ns) [94.013075] Subtest unused-bo-1ns: SKIP (0.000s) [94.077522] [027/142] (918s left) gem_tiled_partial_pwrite_pread (writes) [94.230713] Starting subtest: writes [96.388303] Subtest writes: SUCCESS (2.158s) [96.496425] [028/142] (916s left) kms_ccs (pipe-c-crc-primary-rotation-180-yf_tiled_ccs) [96.933533] Starting subtest: pipe-C-crc-primary-rotation-180-yf_tiled_ccs [96.937727] Subtest pipe-C-crc-primary-rotation-180-yf_tiled_ccs: SKIP (0.001s) [97.284108] [029/142] (915s left) kms_ccs (pipe-a-random-ccs-data-y_tiled_gen12_rc_ccs_cc) [97.659623] Starting subtest: pipe-A-random-ccs-data-y_tiled_gen12_rc_ccs_cc [97.665680] Subtest pipe-A-random-ccs-data-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s) [98.071828] [030/142] (915s left) gem_busy (parallel) [98.387412] Starting subtest: parallel [98.389636] Starting dynamic subtest: rcs0 [98.439556] Dynamic subtest rcs0: SUCCESS (0.053s) [98.456901] Starting dynamic subtest: bcs0 [98.482751] Dynamic subtest bcs0: SUCCESS (0.041s) [98.499967] Starting dynamic subtest: vcs0 [98.521356] Dynamic subtest vcs0: SUCCESS (0.037s) [98.538585] Starting dynamic subtest: vecs0 [98.557721] Dynamic subtest vecs0: SUCCESS (0.034s) [98.559886] Subtest parallel: SUCCESS (0.172s) [98.791224] [031/142] (914s left) gem_exec_fair (basic-pace-share) [98.966913] Starting subtest: basic-pace-share [98.969154] Starting dynamic subtest: rcs0 [103.793977] Dynamic subtest rcs0: SUCCESS (4.827s) [103.796132] Subtest basic-pace-share: SUCCESS (4.828s) [103.988371] [032/142] (909s left) kms_psr2_sf (primary-plane-update-sf-dmg-area) [104.132201] Subtest primary-plane-update-sf-dmg-area: SKIP (0.000s) [104.172129] [033/142] (909s left) gem_create (create-clear) [104.313254] Starting subtest: create-clear [104.316072] Starting dynamic subtest: smem0 [138.745960] Dynamic subtest smem0: SUCCESS (34.426s) [138.748067] Subtest create-clear: SUCCESS (34.427s) [139.022390] [034/142] (874s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc) [139.500141] Subtest pipe-D-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s) [139.825377] [035/142] (873s left) kms_rotation_crc (primary-rotation-270) [140.067045] Starting subtest: primary-rotation-270 [146.266824] Subtest primary-rotation-270: SUCCESS (6.201s) [146.685775] [036/142] (866s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible) [146.930504] Starting subtest: flip-vs-absolute-wf_vblank-interruptible [146.935724] Starting dynamic subtest: A-DP1 [157.878918] Dynamic subtest A-DP1: SUCCESS (10.945s) [157.896915] Starting dynamic subtest: B-DP1 [168.609547] Dynamic subtest B-DP1: SUCCESS (10.728s) [168.626771] Starting dynamic subtest: C-DP1 [179.354256] Dynamic subtest C-DP1: SUCCESS (10.742s) [179.357258] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (32.427s) [179.784745] [037/142] (833s left) syncobj_wait (multi-wait-all-for-submit-submitted) [179.928964] Starting subtest: multi-wait-all-for-submit-submitted [180.035283] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.105s) [180.116309] [038/142] (833s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu) [180.374071] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu [180.378094] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [180.464387] [039/142] (833s left) kms_invalid_mode (bad-vsync-end) [180.707746] Starting subtest: bad-vsync-end [180.709950] Starting dynamic subtest: DP-1-pipe-A [180.793483] Dynamic subtest DP-1-pipe-A: SUCCESS (0.083s) [180.811155] Starting dynamic subtest: DP-1-pipe-B [180.813223] Dynamic subtest DP-1-pipe-B: SUCCESS (0.002s) [180.831369] Starting dynamic subtest: DP-1-pipe-C [180.833955] Dynamic subtest DP-1-pipe-C: SUCCESS (0.002s) [180.836637] Subtest bad-vsync-end: SUCCESS (0.097s) [181.132135] [040/142] (832s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc) [181.388396] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc [181.392198] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [181.479868] [041/142] (832s left) kms_big_fb (yf-tiled-16bpp-rotate-180) [181.750933] Starting subtest: yf-tiled-16bpp-rotate-180 [185.312184] Subtest yf-tiled-16bpp-rotate-180: SUCCESS (3.560s) [185.648611] [042/142] (827s left) syncobj_timeline (reset-during-wait-for-submit) [185.793233] Starting subtest: reset-during-wait-for-submit [185.896126] Subtest reset-during-wait-for-submit: SUCCESS (0.103s) [185.981785] [043/142] (827s left) gem_render_tiled_blits (basic) [186.131106] Starting subtest: basic [186.240315] Subtest basic: SUCCESS (0.106s) [186.299450] [044/142] (827s left) gem_exec_schedule (implicit-write-read) [186.473107] Starting subtest: implicit-write-read [186.476414] Starting dynamic subtest: rcs0 [186.612115] Dynamic subtest rcs0: SUCCESS (0.135s) [186.629162] Starting dynamic subtest: bcs0 [186.749780] Dynamic subtest bcs0: SUCCESS (0.138s) [186.768226] Starting dynamic subtest: vcs0 [186.881056] Dynamic subtest vcs0: SUCCESS (0.129s) [186.900578] Starting dynamic subtest: vecs0 [187.012315] Dynamic subtest vecs0: SUCCESS (0.128s) [187.014429] Subtest implicit-write-read: SUCCESS (0.538s) [187.364964] [045/142] (826s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen) [187.614430] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen [187.618423] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [187.716212] [046/142] (826s left) gem_mmap (pf-nonblock) [187.863639] Starting subtest: pf-nonblock [187.867245] Subtest pf-nonblock: SUCCESS (0.006s) [187.980431] [047/142] (825s left) gem_exec_schedule (u-semaphore-noskip) [188.154892] Starting subtest: u-semaphore-noskip [188.392326] Subtest u-semaphore-noskip: SUCCESS (0.237s) [188.776903] [048/142] (825s left) kms_plane_scaling (plane-downscale-with-modifiers-factor-0-25) [189.015567] Starting subtest: plane-downscale-with-modifiers-factor-0-25 [189.017692] Starting dynamic subtest: pipe-A-DP-1 [189.071140] Dynamic subtest pipe-A-DP-1: SKIP (0.048s) [189.088875] Starting dynamic subtest: pipe-B-DP-1 [189.170316] Dynamic subtest pipe-B-DP-1: SKIP (0.099s) [189.188257] Starting dynamic subtest: pipe-C-DP-1 [189.276488] Dynamic subtest pipe-C-DP-1: SKIP (0.099s) [189.280462] Subtest plane-downscale-with-modifiers-factor-0-25: SKIP (0.258s) [189.365847] [049/142] (824s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled) [189.510832] Starting subtest: invalid-multi-wait-unsubmitted-signaled [189.513244] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s) [189.597438] [050/142] (824s left) gem_exec_balancer (waits) [189.765105] Starting subtest: waits [193.493073] Subtest waits: SUCCESS (3.727s) [197.432697] [051/142] (816s left) kms_lease (atomic_implicit_crtc) [197.677319] Starting subtest: atomic_implicit_crtc [197.684300] Starting dynamic subtest: pipe-A-DP-1 [197.686908] Dynamic subtest pipe-A-DP-1: SUCCESS (0.005s) [197.708766] Starting dynamic subtest: pipe-B-DP-1 [197.711167] Dynamic subtest pipe-B-DP-1: SUCCESS (0.019s) [197.730777] Starting dynamic subtest: pipe-C-DP-1 [197.732736] Dynamic subtest pipe-C-DP-1: SUCCESS (0.020s) [197.734704] Subtest atomic_implicit_crtc: SUCCESS (0.054s) [197.816335] [052/142] (816s left) kms_flip (2x-flip-vs-panning) [198.044386] Starting subtest: 2x-flip-vs-panning [198.053083] Subtest 2x-flip-vs-panning: SKIP (0.004s) [198.164922] [053/142] (815s left) i915_pm_rpm (gem-mmap-type) [199.901805] Starting subtest: gem-mmap-type [199.908682] Starting dynamic subtest: gtt-smem0 [202.442069] Dynamic subtest gtt-smem0: SUCCESS (2.542s) [202.461218] Starting dynamic subtest: wb-smem0 [203.760770] Dynamic subtest wb-smem0: SUCCESS (1.314s) [203.780850] Starting dynamic subtest: wc-smem0 [205.065822] Dynamic subtest wc-smem0: SUCCESS (1.304s) [205.084488] Starting dynamic subtest: uc-smem0 [206.374313] Dynamic subtest uc-smem0: SUCCESS (1.305s) [206.378133] Subtest gem-mmap-type: SUCCESS (6.473s) [206.569221] [054/142] (807s left) kms_pipe_crc_basic (bad-source) [206.820555] Starting subtest: bad-source [206.822937] Subtest bad-source: SUCCESS (0.001s) [206.900739] [055/142] (807s left) gem_mmap_wc (set-cache-level) [207.048844] Starting subtest: set-cache-level [207.054642] Subtest set-cache-level: SUCCESS (0.004s) [207.136996] [056/142] (807s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite) [207.393266] Starting subtest: fbc-rgb101010-draw-pwrite [210.048352] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (2.657s) [210.184513] [057/142] (804s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary) [210.434079] Starting subtest: fbcpsr-shrfb-scaledprimary [210.437921] Subtest fbcpsr-shrfb-scaledprimary: SKIP (0.000s) [210.535926] [058/142] (803s left) syncobj_wait (wait-any-complex) [210.683847] Starting subtest: wait-any-complex [210.746860] Subtest wait-any-complex: SUCCESS (0.064s) [210.837466] [059/142] (803s left) kms_chamelium_hpd (vga-hpd-after-suspend) [211.179686] Subtest vga-hpd-after-suspend: SKIP (0.000s) [211.474297] [060/142] (802s left) kms_cursor_crc (cursor-offscreen-512x512) [211.737297] Starting subtest: cursor-offscreen-512x512 [211.745129] Subtest cursor-offscreen-512x512: SKIP (0.003s) [211.892232] [061/142] (802s left) kms_ccs (pipe-d-crc-primary-rotation-180-yf_tiled_ccs) [212.460394] Subtest pipe-D-crc-primary-rotation-180-yf_tiled_ccs: SKIP (0.000s) [212.779235] [062/142] (801s left) kms_atomic (test-only) [213.140889] Starting subtest: test-only [214.039875] Subtest test-only: SUCCESS (0.899s) [214.384805] [063/142] (800s left) gem_exec_create (basic) [214.557268] Starting subtest: basic [214.559612] Starting dynamic subtest: smem [216.630048] Dynamic subtest smem: SUCCESS (2.072s) [216.632216] Subtest basic: SUCCESS (2.074s) [216.831366] [064/142] (797s left) kms_big_fb (y-tiled-8bpp-rotate-180) [217.097395] Starting subtest: y-tiled-8bpp-rotate-180 [220.010390] Subtest y-tiled-8bpp-rotate-180: SUCCESS (2.912s) [220.249209] [065/142] (794s left) kms_ccs (pipe-a-crc-primary-basic-y_tiled_gen12_rc_ccs_cc) [220.580821] Starting subtest: pipe-A-crc-primary-basic-y_tiled_gen12_rc_ccs_cc [220.584988] Subtest pipe-A-crc-primary-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.001s) [221.046901] [066/142] (793s left) gem_mmap_offset (bad-extensions) [221.193933] Starting subtest: bad-extensions [221.196239] Subtest bad-extensions: SUCCESS (0.000s) [221.295326] [067/142] (793s left) gem_fenced_exec_thrash (2-spare-fences) [221.447145] Starting subtest: 2-spare-fences [223.612571] Subtest 2-spare-fences: SUCCESS (2.164s) [223.979392] [068/142] (790s left) gem_ctx_persistence (heartbeat-hang) [224.133171] Starting subtest: heartbeat-hang [225.322930] Subtest heartbeat-hang: SUCCESS (1.189s) [225.412839] [069/142] (789s left) syncobj_basic (illegal-fd-to-handle) [225.560383] Starting subtest: illegal-fd-to-handle [225.562747] Subtest illegal-fd-to-handle: SUCCESS (0.000s) [225.645381] [070/142] (789s left) gem_watchdog (default-virtual) [225.806391] Starting subtest: default-virtual [226.832406] Subtest default-virtual: SUCCESS (1.031s) [226.913762] [071/142] (787s left) kms_pm_lpsp (kms-lpsp) [228.160729] Starting subtest: kms-lpsp [228.162998] Starting dynamic subtest: kms-lpsp-DP [228.166792] Dynamic subtest kms-lpsp-DP: SKIP (0.000s) [228.170618] Subtest kms-lpsp: SKIP (0.003s) [228.330312] [072/142] (786s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt) [228.586453] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt [228.590531] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [228.694692] [073/142] (786s left) kms_ccs (pipe-d-ccs-on-another-bo-4_tiled_mtl_mc_ccs) [229.171571] Subtest pipe-D-ccs-on-another-bo-4_tiled_mtl_mc_ccs: SKIP (0.000s) [229.496678] [074/142] (785s left) kms_frontbuffer_tracking (psr-rgb565-draw-render) [229.754197] Starting subtest: psr-rgb565-draw-render [229.758050] Subtest psr-rgb565-draw-render: SKIP (0.000s) [229.859636] [075/142] (785s left) kms_addfb_basic (invalid-get-prop-any) [230.005732] Starting subtest: invalid-get-prop-any [230.008146] Subtest invalid-get-prop-any: SUCCESS (0.000s) [230.195323] [076/142] (784s left) kms_ccs (pipe-b-missing-ccs-buffer-y_tiled_gen12_mc_ccs) [230.609442] Starting subtest: pipe-B-missing-ccs-buffer-y_tiled_gen12_mc_ccs [230.613609] Subtest pipe-B-missing-ccs-buffer-y_tiled_gen12_mc_ccs: SKIP (0.000s) [231.004465] [077/142] (784s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75) [231.246357] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75 [231.248521] Starting dynamic subtest: pipe-A-DP-1 [231.330170] Dynamic subtest pipe-A-DP-1: SUCCESS (0.084s) [231.352519] Starting dynamic subtest: pipe-B-DP-1 [231.721812] Dynamic subtest pipe-B-DP-1: SUCCESS (0.386s) [231.749059] Starting dynamic subtest: pipe-C-DP-1 [231.829795] Dynamic subtest pipe-C-DP-1: SKIP (0.099s) [231.832347] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SUCCESS (0.585s) [232.241751] [078/142] (782s left) gem_exec_gttfill (engines) [232.413461] Starting subtest: engines [232.415963] Starting dynamic subtest: rcs0 [269.561111] Dynamic subtest rcs0: SUCCESS (37.145s) [269.582941] Starting dynamic subtest: bcs0 [307.869475] Dynamic subtest bcs0: SUCCESS (38.302s) [307.892818] Starting dynamic subtest: vcs0 [344.361155] Dynamic subtest vcs0: SUCCESS (36.492s) [344.382270] Starting dynamic subtest: vecs0 [381.640265] Dynamic subtest vecs0: SUCCESS (37.276s) [381.642416] Subtest engines: SUCCESS (149.227s) [381.847652] [079/142] (633s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted) [382.123302] Starting subtest: etime-single-wait-all-for-submit-unsubmitted [382.226116] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.102s) [382.308335] [080/142] (632s left) vc4/vc4_dmabuf_poll (poll-write-waits-until-write-done) [382.488074] Subtest poll-write-waits-until-write-done: SKIP (0.000s) [382.558133] [081/142] (632s left) kms_vblank (pipe-c-ts-continuation-idle) [382.820612] Starting subtest: pipe-C-ts-continuation-idle [383.428572] Subtest pipe-C-ts-continuation-idle: SUCCESS (0.608s) [383.789776] [082/142] (631s left) api_intel_allocator (reserve-simple) [383.937771] Starting subtest: reserve-simple [383.940276] Subtest reserve-simple: SUCCESS (0.004s) [384.055326] [083/142] (631s left) gem_exec_async (forked-writes) [384.227517] Starting subtest: forked-writes [384.230766] Starting dynamic subtest: rcs0 [384.315724] Dynamic subtest rcs0: SUCCESS (0.085s) [384.335649] Starting dynamic subtest: bcs0 [384.395179] Dynamic subtest bcs0: SUCCESS (0.076s) [384.414595] Starting dynamic subtest: vcs0 [384.473967] Dynamic subtest vcs0: SUCCESS (0.077s) [384.494770] Starting dynamic subtest: vecs0 [384.549855] Dynamic subtest vecs0: SUCCESS (0.075s) [384.552056] Subtest forked-writes: SUCCESS (0.323s) [384.790621] [084/142] (630s left) kms_vblank (pipe-d-wait-busy) [385.037526] Subtest pipe-D-wait-busy: SKIP (0.000s) [385.122351] [085/142] (630s left) kms_sequence (get-busy) [385.360410] Starting subtest: get-busy [385.362571] Starting dynamic subtest: DP-1-pipe-A [387.827554] Dynamic subtest DP-1-pipe-A: SUCCESS (2.467s) [387.849895] Starting dynamic subtest: DP-1-pipe-B [390.452132] Dynamic subtest DP-1-pipe-B: SUCCESS (2.618s) [390.472768] Starting dynamic subtest: DP-1-pipe-C [393.101432] Dynamic subtest DP-1-pipe-C: SUCCESS (2.646s) [393.103408] Subtest get-busy: SUCCESS (7.744s) [393.457480] [086/142] (622s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc) [393.854245] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc [395.855432] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (2.068s) [395.978426] [087/142] (619s left) kms_scaling_modes (scaling-mode-center) [396.220063] Starting subtest: scaling-mode-center [396.224031] Subtest scaling-mode-center: SKIP (0.001s) [396.304190] [088/142] (619s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc) [396.550423] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc [398.780431] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (2.235s) [398.920856] [089/142] (616s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-render) [399.174907] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-render [401.083649] Subtest fbc-1p-offscren-pri-shrfb-draw-render: SUCCESS (1.914s) [401.221458] [090/142] (614s left) gem_ctx_persistence (engines-cleanup) [401.377857] Starting subtest: engines-cleanup [401.380389] Starting dynamic subtest: rcs0 [401.422613] Dynamic subtest rcs0: SUCCESS (0.043s) [401.447732] Starting dynamic subtest: bcs0 [401.471795] Dynamic subtest bcs0: SUCCESS (0.046s) [401.496388] Starting dynamic subtest: vcs0 [401.515427] Dynamic subtest vcs0: SUCCESS (0.040s) [401.540720] Starting dynamic subtest: vecs0 [401.561266] Dynamic subtest vecs0: SUCCESS (0.042s) [401.563704] Subtest engines-cleanup: SUCCESS (0.185s) [401.652986] [091/142] (614s left) gem_userptr_blits (stress-purge) [401.845770] Starting subtest: stress-purge [407.228296] Subtest stress-purge: SUCCESS (5.382s) [407.406170] [092/142] (608s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling) [407.775848] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling [407.777851] Starting dynamic subtest: pipe-A-valid-mode [408.488904] Dynamic subtest pipe-A-valid-mode: SKIP (0.707s) [408.496170] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.712s) [408.882792] [093/142] (606s left) kms_ccs (pipe-b-ccs-on-another-bo-yf_tiled_ccs) [409.303942] Starting subtest: pipe-B-ccs-on-another-bo-yf_tiled_ccs [409.306305] Subtest pipe-B-ccs-on-another-bo-yf_tiled_ccs: SUCCESS (0.001s) [409.698907] [094/142] (606s left) kms_chamelium_color (gamma) [409.962216] Subtest gamma: SKIP (0.000s) [410.000405] [095/142] (605s left) gem_ctx_param (invalid-ctx-set) [410.146834] Starting subtest: invalid-ctx-set [410.148916] Subtest invalid-ctx-set: SUCCESS (0.000s) [410.231755] [096/142] (605s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt) [410.482128] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt [410.486086] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [410.599184] [097/142] (605s left) gem_exec_whisper (basic-fds-priority-all) [410.772828] Starting subtest: basic-fds-priority-all [435.100749] Subtest basic-fds-priority-all: SUCCESS (24.324s) [435.301487] [098/142] (580s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled) [435.459245] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [435.461407] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s) [435.549759] [099/142] (580s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu) [435.798408] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu [435.802789] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [435.901439] [100/142] (580s left) kms_rotation_crc (primary-x-tiled-reflect-x-0) [436.154750] Starting subtest: primary-x-tiled-reflect-x-0 [436.159360] Subtest primary-x-tiled-reflect-x-0: SKIP (0.003s) [436.250366] [101/142] (579s left) kms_cursor_edge_walk (256x256-right-edge) [436.491940] Starting subtest: 256x256-right-edge [436.494546] Starting dynamic subtest: pipe-A-DP-1 [440.316625] Dynamic subtest pipe-A-DP-1: SUCCESS (3.822s) [440.337192] Starting dynamic subtest: pipe-C-DP-1 [443.814529] Dynamic subtest pipe-C-DP-1: SUCCESS (3.492s) [443.817689] Subtest 256x256-right-edge: SUCCESS (7.325s) [444.124837] [102/142] (572s left) perf_pmu (render-node-busy-idle) [444.284329] Starting subtest: render-node-busy-idle [444.286561] Starting dynamic subtest: rcs0 [444.918704] Dynamic subtest rcs0: SUCCESS (0.634s) [444.939890] Starting dynamic subtest: bcs0 [445.559431] Dynamic subtest bcs0: SUCCESS (0.639s) [445.584975] Starting dynamic subtest: vcs0 [446.193267] Dynamic subtest vcs0: SUCCESS (0.630s) [446.218398] Starting dynamic subtest: vecs0 [446.827822] Dynamic subtest vecs0: SUCCESS (0.631s) [446.830538] Subtest render-node-busy-idle: SUCCESS (2.546s) [446.927998] [103/142] (569s left) kms_ccs (pipe-c-ccs-on-another-bo-y_tiled_ccs) [447.388725] Starting subtest: pipe-C-ccs-on-another-bo-y_tiled_ccs [447.392955] Subtest pipe-C-ccs-on-another-bo-y_tiled_ccs: SKIP (0.000s) [447.726809] [104/142] (568s left) gem_exec_schedule (preempt-queue-contexts-chain) [447.909335] Starting subtest: preempt-queue-contexts-chain [447.911536] Starting dynamic subtest: rcs0 [448.971847] Dynamic subtest rcs0: SUCCESS (1.060s) [448.999186] Starting dynamic subtest: bcs0 [450.033625] Dynamic subtest bcs0: SUCCESS (1.058s) [450.061952] Starting dynamic subtest: vcs0 [451.069557] Dynamic subtest vcs0: SUCCESS (1.033s) [451.095094] Starting dynamic subtest: vecs0 [452.121521] Dynamic subtest vecs0: SUCCESS (1.053s) [452.125983] Subtest preempt-queue-contexts-chain: SUCCESS (4.215s) [452.495803] [105/142] (563s left) i915_pm_rc6_residency (media-rc6-accuracy) [452.812977] Starting subtest: media-rc6-accuracy [452.817556] Subtest media-rc6-accuracy: SKIP (0.000s) [452.909707] [106/142] (563s left) gem_mmap_gtt (basic) [453.060344] Starting subtest: basic [453.062949] Subtest basic: SUCCESS (0.002s) [453.161581] [107/142] (563s left) i915_query (test-query-geometry-subslices) [453.306801] Starting subtest: test-query-geometry-subslices [453.310862] Subtest test-query-geometry-subslices: SKIP (0.000s) [453.395911] [108/142] (563s left) drm_mm (drm_mm_test) [453.532063] Starting subtest: drm_mm_test [453.539705] Subtest drm_mm_test: SKIP (0.005s) [453.611956] [109/142] (562s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [453.857471] Starting subtest: compare-crc-sanitycheck-nv12 [453.864828] Starting dynamic subtest: pipe-A-DP-1 [453.869346] Dynamic subtest pipe-A-DP-1: SKIP (0.001s) [453.891434] Starting dynamic subtest: pipe-B-DP-1 [453.895194] Dynamic subtest pipe-B-DP-1: SKIP (0.001s) [453.915787] Starting dynamic subtest: pipe-C-DP-1 [453.919979] Dynamic subtest pipe-C-DP-1: SKIP (0.002s) [453.923872] Subtest compare-crc-sanitycheck-nv12: SKIP (0.020s) [453.976387] [110/142] (562s left) gem_lmem_swapping (massive-random) [454.130462] Subtest massive-random: SKIP (0.000s) [454.194596] [111/142] (562s left) gem_exec_suspend (basic-s3) [454.359756] Starting subtest: basic-S3 [454.362456] Starting dynamic subtest: smem [475.564726] Dynamic subtest smem: SUCCESS (6.009s) [475.567402] Subtest basic-S3: SUCCESS (6.012s) [480.779590] [112/142] (556s left) perf (gen12-group-exclusive-stream-ctx-handle) [481.057946] Starting subtest: gen12-group-exclusive-stream-ctx-handle [481.061900] Subtest gen12-group-exclusive-stream-ctx-handle: SKIP (0.000s) [481.120996] [113/142] (555s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy) [481.362347] Starting subtest: flip-vs-cursor-crc-legacy [481.987039] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.626s) [482.325702] [114/142] (554s left) v3d/v3d_mmap (mmap-bo) [482.513609] Subtest mmap-bo: SKIP (0.000s) [482.591171] [115/142] (554s left) prime_busy (before) [482.746038] Starting subtest: before [482.764163] Starting dynamic subtest: rcs0 [482.774891] Dynamic subtest rcs0: SUCCESS (0.011s) [482.804997] Starting dynamic subtest: bcs0 [482.807053] Dynamic subtest bcs0: SUCCESS (0.018s) [482.834532] Starting dynamic subtest: vcs0 [482.837045] Dynamic subtest vcs0: SUCCESS (0.020s) [482.861159] Starting dynamic subtest: vecs0 [482.863190] Dynamic subtest vecs0: SUCCESS (0.015s) [482.955458] Subtest before: SUCCESS (0.209s) [483.056109] [116/142] (554s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [483.302967] Starting subtest: basic-flip-after-cursor-varying-size [484.366486] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.061s) [484.704017] [117/142] (552s left) v3d/v3d_submit_cl (single-in-sync) [484.891969] Subtest single-in-sync: SKIP (0.000s) [484.967482] [118/142] (552s left) gem_userptr_blits (input-checking) [485.128214] Starting subtest: input-checking [485.130342] Subtest input-checking: SUCCESS (0.000s) [485.302961] [119/142] (551s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k) [485.642322] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s) [485.952166] [120/142] (551s left) gem_exec_params (invalid-fence-in) [486.103957] Starting subtest: invalid-fence-in [486.106436] Subtest invalid-fence-in: SUCCESS (0.001s) [486.210026] [121/142] (551s left) kms_big_fb (4-tiled-64bpp-rotate-270) [486.472620] Starting subtest: 4-tiled-64bpp-rotate-270 [486.477346] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.000s) [486.577518] [122/142] (550s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu) [486.835615] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu [486.839715] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [486.942893] [123/142] (550s left) i915_pm_rps (basic-api) [487.096915] Starting subtest: basic-api [487.104792] Subtest basic-api: SUCCESS (0.008s) [487.209638] [124/142] (550s left) kms_vblank (pipe-a-query-forked-busy) [487.446288] Starting subtest: pipe-A-query-forked-busy [489.913544] Subtest pipe-A-query-forked-busy: SUCCESS (2.465s) [490.263174] [125/142] (547s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled) [490.431844] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled [490.435976] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s) [490.647055] [126/142] (546s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt) [490.912001] Starting subtest: fbcpsr-farfromfence-mmap-gtt [490.918609] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s) [491.012836] [127/142] (546s left) syncobj_timeline (invalid-query-one-illegal-handle) [491.161516] Starting subtest: invalid-query-one-illegal-handle [491.163825] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s) [491.248233] [128/142] (546s left) syncobj_wait (wait-any-snapshot) [491.395302] Starting subtest: wait-any-snapshot [491.478192] Subtest wait-any-snapshot: SUCCESS (0.083s) [491.579068] [129/142] (546s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt) [491.830639] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt [491.834563] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [491.929588] [130/142] (545s left) kms_cursor_crc (cursor-rapid-movement-64x21) [492.177530] Starting subtest: cursor-rapid-movement-64x21 [492.187668] Starting dynamic subtest: pipe-A-DP-1 [492.698600] Dynamic subtest pipe-A-DP-1: SUCCESS (0.510s) [492.798940] Starting dynamic subtest: pipe-C-DP-1 [493.384308] Dynamic subtest pipe-C-DP-1: SUCCESS (0.615s) [493.386418] Subtest cursor-rapid-movement-64x21: SUCCESS (1.208s) [493.752697] [131/142] (544s left) kms_busy (extended-modeset-hang-oldfb-with-reset) [494.013401] Starting subtest: extended-modeset-hang-oldfb-with-reset [494.021012] Starting dynamic subtest: pipe-A [495.941864] Dynamic subtest pipe-A: SUCCESS (1.923s) [495.975546] Starting dynamic subtest: pipe-C [498.025421] Dynamic subtest pipe-C: SUCCESS (2.072s) [498.027692] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (4.013s) [498.375979] [132/142] (539s left) kms_flip (2x-plain-flip-fb-recreate) [498.618741] Starting subtest: 2x-plain-flip-fb-recreate [498.622824] Subtest 2x-plain-flip-fb-recreate: SKIP (0.003s) [498.741318] [133/142] (539s left) kms_ccs (pipe-a-bad-aux-stride-y_tiled_ccs) [499.108535] Starting subtest: pipe-A-bad-aux-stride-y_tiled_ccs [499.110975] Subtest pipe-A-bad-aux-stride-y_tiled_ccs: SUCCESS (0.002s) [499.551403] [134/142] (538s left) gem_ctx_sseu (mmap-args) [499.704127] Subtest mmap-args: SKIP (0.000s) [499.767921] [135/142] (538s left) syncobj_timeline (wait-all-for-submit-snapshot) [499.912375] Starting subtest: wait-all-for-submit-snapshot [499.996372] Subtest wait-all-for-submit-snapshot: SUCCESS (0.083s) [500.084111] [136/142] (537s left) gem_exec_flush (basic-wb-pro-default) [500.252793] Starting subtest: basic-wb-pro-default [505.723493] Subtest basic-wb-pro-default: SUCCESS (5.471s) [505.933521] [137/142] (532s left) gem_create (create-valid-nonaligned) [506.078919] Starting subtest: create-valid-nonaligned [506.081340] Subtest create-valid-nonaligned: SUCCESS (0.000s) [506.300990] [138/142] (531s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size) [506.536407] Starting subtest: cursorB-vs-flipA-varying-size [506.544651] Subtest cursorB-vs-flipA-varying-size: SKIP (0.004s) [506.632874] [139/142] (531s left) gem_exec_reloc (basic-gtt-read) [506.793967] Starting subtest: basic-gtt-read [506.813621] Subtest basic-gtt-read: SUCCESS (0.019s) [507.015438] [140/142] (531s left) kms_ccs (pipe-d-bad-aux-stride-y_tiled_ccs) [507.500524] Subtest pipe-D-bad-aux-stride-y_tiled_ccs: SKIP (0.000s) [507.826907] [141/142] (530s left) gem_partial_pwrite_pread (reads-uncached) [507.981122] Starting subtest: reads-uncached [514.301128] Subtest reads-uncached: SUCCESS (6.320s) [514.474179] [142/142] (523s left) kms_big_fb (yf-tiled-8bpp-rotate-0) [514.836840] Starting subtest: yf-tiled-8bpp-rotate-0 [514.882803] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s) [514.963463] Closing watchdogs Done.