[37.625353] Initializing watchdogs
[37.625405]   /dev/watchdog0
[37.631534] [001/140] (960s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[37.760420] Starting subtest: 4-tiled-16bpp-rotate-90
[37.821599] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.060s)
[37.937653] [002/140] (960s left) kms_ccs (pipe-d-ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[38.256156] Starting subtest: pipe-D-ccs-on-another-bo-y-tiled-gen12-rc-ccs
[38.258035] Subtest pipe-D-ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[38.415878] [003/140] (959s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[38.487373] Starting subtest: multi-wait-for-submit-available-submitted
[38.488300] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[38.540817] [004/140] (959s left) gen9_exec_parse (batch-zero-length)
[38.618342] Subtest batch-zero-length: SKIP (0.000s)
[38.647735] [005/140] (959s left) kms_flip (flip-vs-expired-vblank)
[38.749734] Starting subtest: flip-vs-expired-vblank
[38.754933] Starting dynamic subtest: A-DP4
[46.677456] Dynamic subtest A-DP4: SUCCESS (7.920s)
[46.682577] Starting dynamic subtest: B-DP4
[54.455368] Dynamic subtest B-DP4: SUCCESS (7.761s)
[54.460507] Starting dynamic subtest: C-DP4
[62.193137] Dynamic subtest C-DP4: SUCCESS (7.757s)
[62.199229] Starting dynamic subtest: D-DP4
[69.951756] Dynamic subtest D-DP4: SUCCESS (7.758s)
[69.952683] Subtest flip-vs-expired-vblank: SUCCESS (31.203s)
[70.220886] [006/140] (928s left) gem_ctx_persistence (legacy-engines-queued)
[70.314145] Starting subtest: legacy-engines-queued
[70.315148] Starting dynamic subtest: render
[70.373169] Dynamic subtest render: SUCCESS (0.059s)
[70.378096] Starting dynamic subtest: bsd1
[70.393133] Dynamic subtest bsd1: SUCCESS (0.020s)
[70.397684] Starting dynamic subtest: bsd2
[70.437419] Dynamic subtest bsd2: SUCCESS (0.044s)
[70.444058] Starting dynamic subtest: blt
[70.487844] Dynamic subtest blt: SUCCESS (0.050s)
[70.504875] Starting dynamic subtest: vebox
[70.570771] Dynamic subtest vebox: SUCCESS (0.082s)
[70.572094] Subtest legacy-engines-queued: SUCCESS (0.256s)
[70.691565] [007/140] (927s left) kms_ccs (pipe-c-bad-pixel-format-4-tiled-mtl-mc-ccs)
[70.943284] Starting subtest: pipe-C-bad-pixel-format-4-tiled-mtl-mc-ccs
[70.944873] Subtest pipe-C-bad-pixel-format-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[71.146927] [008/140] (927s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[71.311980] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[71.313755] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[71.390313] [009/140] (926s left) gem_workarounds (suspend-resume-context)
[71.469860] Starting subtest: suspend-resume-context
[90.818853] Subtest suspend-resume-context: SUCCESS (3.717s)
[90.913912] [010/140] (923s left) kms_plane_scaling (invalid-parameters)
[91.041476] Starting subtest: invalid-parameters
[91.042283] Starting dynamic subtest: less-than-1-height-src
[91.053946] Dynamic subtest less-than-1-height-src: SUCCESS (0.012s)
[91.059621] Starting dynamic subtest: less-than-1-width-src
[91.064910] Dynamic subtest less-than-1-width-src: SUCCESS (0.011s)
[91.065802] Subtest invalid-parameters: SUCCESS (0.023s)
[91.130409] [011/140] (922s left) kms_properties (connector-properties-atomic)
[91.248420] Starting subtest: connector-properties-atomic
[91.477696] Subtest connector-properties-atomic: SUCCESS (0.228s)
[91.712486] [012/140] (922s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[91.878319] Starting subtest: psr-rgb101010-draw-blt
[91.880046] Subtest psr-rgb101010-draw-blt: SKIP (0.000s)
[91.951878] [013/140] (922s left) gem_exec_gttfill (basic)
[92.047529] Starting subtest: basic
[97.046424] Subtest basic: SUCCESS (4.990s)
[97.302551] [014/140] (916s left) kms_dsc (dsc-with-output-formats-with-bpc)
[97.455488] Subtest dsc-with-output-formats-with-bpc: SKIP (0.000s)
[97.475626] [015/140] (916s left) gem_fenced_exec_thrash (too-many-fences)
[97.530217] Subtest too-many-fences: SKIP (0.000s)
[97.559152] [016/140] (916s left) i915_pm_rpm (gem-execbuf-stress)
[99.157833] Starting subtest: gem-execbuf-stress
[99.159259] Starting dynamic subtest: lmem0
[103.850649] Dynamic subtest lmem0: SUCCESS (4.692s)
[103.859598] Starting dynamic subtest: extra-wait-lmem0
[158.360210] Dynamic subtest extra-wait-lmem0: SUCCESS (54.475s)
[158.368734] Starting dynamic subtest: smem0
[162.979205] Dynamic subtest smem0: SUCCESS (4.653s)
[162.988826] Starting dynamic subtest: extra-wait-smem0
[217.688832] Dynamic subtest extra-wait-smem0: SUCCESS (54.674s)
[217.690896] Subtest gem-execbuf-stress: SUCCESS (118.497s)
[217.980094] [017/140] (796s left) gem_exec_params (rel-constants-invalid-ring)
[218.065291] Starting subtest: rel-constants-invalid-ring
[218.066321] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[218.173111] [018/140] (795s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[218.337319] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[218.338968] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[218.414105] [019/140] (795s left) gem_ccs (block-copy-uncompressed)
[218.475087] Starting subtest: block-copy-uncompressed
[218.475955] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[218.509296] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.033s)
[218.524053] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-lmem0
[218.533013] Dynamic subtest linear-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.024s)
[218.541213] Starting dynamic subtest: linear-uncompressed-compfmt0-lmem0-smem
[218.639861] Dynamic subtest linear-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.107s)
[218.646498] Starting dynamic subtest: linear-uncompressed-compfmt0-lmem0-lmem0
[218.746419] Dynamic subtest linear-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.106s)
[218.753168] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[218.759532] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.013s)
[218.766250] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-lmem0
[218.772152] Dynamic subtest xmajor-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.013s)
[218.778927] Starting dynamic subtest: xmajor-uncompressed-compfmt0-lmem0-smem
[218.877437] Dynamic subtest xmajor-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.105s)
[218.884032] Starting dynamic subtest: xmajor-uncompressed-compfmt0-lmem0-lmem0
[218.978351] Dynamic subtest xmajor-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.101s)
[218.984916] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[218.992117] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.013s)
[218.998634] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-lmem0
[219.004830] Dynamic subtest tile4-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.013s)
[219.011725] Starting dynamic subtest: tile4-uncompressed-compfmt0-lmem0-smem
[219.118972] Dynamic subtest tile4-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.112s)
[219.125669] Starting dynamic subtest: tile4-uncompressed-compfmt0-lmem0-lmem0
[219.217784] Dynamic subtest tile4-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.100s)
[219.224410] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[219.231044] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.013s)
[219.237655] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-lmem0
[219.247749] Dynamic subtest tile64-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.016s)
[219.260994] Starting dynamic subtest: tile64-uncompressed-compfmt0-lmem0-smem
[219.367728] Dynamic subtest tile64-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.119s)
[219.374168] Starting dynamic subtest: tile64-uncompressed-compfmt0-lmem0-lmem0
[219.467512] Dynamic subtest tile64-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.101s)
[219.468453] Subtest block-copy-uncompressed: SUCCESS (0.992s)
[219.567836] [020/140] (794s left) gem_wait (write-wait)
[219.620702] Starting subtest: write-wait
[219.621587] Starting dynamic subtest: all-engines
[220.740969] Dynamic subtest all-engines: SUCCESS (1.120s)
[220.752434] Starting dynamic subtest: rcs0
[221.797350] Dynamic subtest rcs0: SUCCESS (1.055s)
[221.808632] Starting dynamic subtest: bcs0
[222.855341] Dynamic subtest bcs0: SUCCESS (1.057s)
[222.866873] Starting dynamic subtest: vcs0
[223.913710] Dynamic subtest vcs0: SUCCESS (1.057s)
[223.925469] Starting dynamic subtest: vcs1
[224.972265] Dynamic subtest vcs1: SUCCESS (1.058s)
[224.984057] Starting dynamic subtest: vecs0
[226.031302] Dynamic subtest vecs0: SUCCESS (1.058s)
[226.042593] Starting dynamic subtest: vecs1
[227.090457] Dynamic subtest vecs1: SUCCESS (1.058s)
[227.100173] Starting dynamic subtest: ccs0
[228.148335] Dynamic subtest ccs0: SUCCESS (1.057s)
[228.159952] Starting dynamic subtest: ccs1
[229.208624] Dynamic subtest ccs1: SUCCESS (1.059s)
[229.220959] Starting dynamic subtest: ccs2
[230.268585] Dynamic subtest ccs2: SUCCESS (1.059s)
[230.280850] Starting dynamic subtest: ccs3
[231.329467] Dynamic subtest ccs3: SUCCESS (1.060s)
[231.331353] Subtest write-wait: SUCCESS (11.708s)
[231.585377] [021/140] (782s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[231.772719] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[231.886359] [022/140] (782s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[232.036041] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[232.038031] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[232.106602] [023/140] (782s left) kms_psr2_sf (overlay-plane-move-continuous-exceed-sf)
[232.166786] Subtest overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[232.199297] [024/140] (782s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[232.322566] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[232.333358] Starting dynamic subtest: pipe-A-DP-4
[232.421904] Dynamic subtest pipe-A-DP-4: SUCCESS (0.088s)
[232.445708] Starting dynamic subtest: pipe-B-DP-4
[232.645895] Dynamic subtest pipe-B-DP-4: SUCCESS (0.211s)
[232.671632] Starting dynamic subtest: pipe-C-DP-4
[232.869802] Dynamic subtest pipe-C-DP-4: SUCCESS (0.210s)
[232.890312] Starting dynamic subtest: pipe-D-DP-4
[233.096078] Dynamic subtest pipe-D-DP-4: SUCCESS (0.214s)
[233.096968] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (0.774s)
[233.357139] [025/140] (780s left) kms_ccs (pipe-b-random-ccs-data-yf-tiled-ccs)
[233.626606] Starting subtest: pipe-B-random-ccs-data-yf-tiled-ccs
[233.629087] Subtest pipe-B-random-ccs-data-yf-tiled-ccs: SKIP (0.000s)
[233.834079] [026/140] (780s left) v3d/v3d_mmap (mmap-bad-flags)
[233.934235] Subtest mmap-bad-flags: SKIP (0.000s)
[233.983734] [027/140] (780s left) gem_eio (create)
[234.266128] Starting subtest: create
[234.818750] Subtest create: SUCCESS (0.553s)
[234.950210] [028/140] (779s left) gem_mmap_gtt (basic-write)
[235.003673] Subtest basic-write: SKIP (0.000s)
[235.025094] [029/140] (779s left) kms_ccs (pipe-a-crc-primary-basic-y-tiled-ccs)
[235.228743] Starting subtest: pipe-A-crc-primary-basic-y-tiled-ccs
[235.230481] Subtest pipe-A-crc-primary-basic-y-tiled-ccs: SKIP (0.000s)
[235.456869] [030/140] (778s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[235.604444] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[235.606107] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[235.681956] [031/140] (778s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[235.749781] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[235.771128] [032/140] (778s left) gem_exec_fence (syncobj-timeline-wait)
[236.575867] Starting subtest: syncobj-timeline-wait
[236.684096] Subtest syncobj-timeline-wait: SUCCESS (0.117s)
[236.884084] [033/140] (777s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[237.005834] Starting subtest: flip-vs-cursor-atomic
[244.699739] Subtest flip-vs-cursor-atomic: SUCCESS (7.695s)
[244.903602] [034/140] (769s left) kms_ccs (pipe-d-bad-aux-stride-y-tiled-ccs)
[245.191517] Starting subtest: pipe-D-bad-aux-stride-y-tiled-ccs
[245.193392] Subtest pipe-D-bad-aux-stride-y-tiled-ccs: SKIP (0.000s)
[245.357919] [035/140] (769s left) kms_cursor_legacy (single-bo)
[245.509320] Starting subtest: single-bo
[245.510241] Starting dynamic subtest: pipe-A
[250.922542] Dynamic subtest pipe-A: SUCCESS (5.379s)
[250.929644] Starting dynamic subtest: pipe-B
[256.301538] Dynamic subtest pipe-B: SUCCESS (5.379s)
[256.308732] Starting dynamic subtest: pipe-C
[261.656771] Dynamic subtest pipe-C: SUCCESS (5.379s)
[261.664489] Starting dynamic subtest: pipe-D
[267.034302] Dynamic subtest pipe-D: SUCCESS (5.379s)
[267.041873] Starting dynamic subtest: all-pipes
[272.413556] Dynamic subtest all-pipes: SUCCESS (5.379s)
[272.414376] Subtest single-bo: SUCCESS (26.896s)
[272.474408] [036/140] (742s left) syncobj_wait (single-wait-signaled)
[272.519274] Starting subtest: single-wait-signaled
[272.520521] Subtest single-wait-signaled: SUCCESS (0.000s)
[272.582944] [037/140] (741s left) kms_addfb_basic (unused-modifier)
[272.655074] Starting subtest: unused-modifier
[272.656014] Subtest unused-modifier: SUCCESS (0.000s)
[272.812140] [038/140] (741s left) gem_mmap_gtt (hang-user)
[272.879473] Subtest hang-user: SKIP (0.000s)
[272.898563] [039/140] (741s left) vc4/vc4_lookup_fail (bad-color-write)
[272.973525] Subtest bad-color-write: SKIP (0.000s)
[273.038927] [040/140] (741s left) drm_read (empty-nonblock)
[273.255900] Starting subtest: empty-nonblock
[273.256765] Subtest empty-nonblock: SUCCESS (0.000s)
[273.408472] [041/140] (741s left) gem_readwrite (new-obj)
[273.505436] Subtest new-obj: SKIP (0.000s)
[273.549468] [042/140] (741s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-wc)
[273.675021] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-wc
[273.676596] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[273.761580] [043/140] (740s left) gem_ctx_param (basic-default)
[273.819956] Starting subtest: basic-default
[273.820840] Subtest basic-default: SUCCESS (0.000s)
[273.873337] [044/140] (740s left) gem_mmap (bad-offset)
[273.925978] Subtest bad-offset: SKIP (0.000s)
[273.948076] [045/140] (740s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[274.068058] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[275.839417] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (1.773s)
[275.982865] [046/140] (738s left) gem_eio (throttle)
[276.329919] Starting subtest: throttle
[276.927982] Subtest throttle: SUCCESS (0.599s)
[277.114085] [047/140] (737s left) gem_exec_schedule (wide)
[277.330622] Starting subtest: wide
[277.332295] Starting dynamic subtest: rcs0
[285.622255] Dynamic subtest rcs0: SUCCESS (8.267s)
[285.630023] Starting dynamic subtest: bcs0
[293.908837] Dynamic subtest bcs0: SUCCESS (8.308s)
[293.917127] Starting dynamic subtest: vcs0
[302.720220] Dynamic subtest vcs0: SUCCESS (8.788s)
[302.728166] Starting dynamic subtest: vcs1
[311.783612] Dynamic subtest vcs1: SUCCESS (9.064s)
[311.791571] Starting dynamic subtest: vecs0
[320.282961] Dynamic subtest vecs0: SUCCESS (8.524s)
[320.291108] Starting dynamic subtest: vecs1
[329.078115] Dynamic subtest vecs1: SUCCESS (8.792s)
[329.086084] Starting dynamic subtest: ccs0
[338.137974] Dynamic subtest ccs0: SUCCESS (9.037s)
[338.145932] Starting dynamic subtest: ccs1
[347.096409] Dynamic subtest ccs1: SUCCESS (8.958s)
[347.104664] Starting dynamic subtest: ccs2
[356.289163] Dynamic subtest ccs2: SUCCESS (9.192s)
[356.297873] Starting dynamic subtest: ccs3
[365.326324] Dynamic subtest ccs3: SUCCESS (9.062s)
[365.327311] Subtest wide: SUCCESS (87.997s)
[366.312334] [048/140] (648s left) gem_mmap_gtt (basic-small-copy-odd)
[366.361204] Subtest basic-small-copy-odd: SKIP (0.000s)
[366.385318] [049/140] (648s left) kms_getfb (getfb2-handle-closed)
[366.431202] Starting subtest: getfb2-handle-closed
[366.432122] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[366.522718] [050/140] (648s left) kms_cursor_crc (cursor-offscreen-256x85)
[366.816986] Starting subtest: cursor-offscreen-256x85
[366.821200] Starting dynamic subtest: pipe-A-DP-4
[369.259368] Dynamic subtest pipe-A-DP-4: SUCCESS (2.436s)
[369.307648] Starting dynamic subtest: pipe-D-DP-4
[371.761272] Dynamic subtest pipe-D-DP-4: SUCCESS (2.461s)
[371.762406] Subtest cursor-offscreen-256x85: SUCCESS (4.943s)
[372.052630] [051/140] (642s left) kms_big_fb (linear-16bpp-rotate-0)
[372.205478] Starting subtest: linear-16bpp-rotate-0
[373.811446] Subtest linear-16bpp-rotate-0: SUCCESS (1.605s)
[373.930959] [052/140] (640s left) kms_pm_backlight (bad-brightness)
[374.052122] Subtest bad-brightness: SKIP (0.000s)
[374.087158] [053/140] (640s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-gtt)
[374.206570] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-gtt
[374.208255] Subtest psr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[374.281391] [054/140] (640s left) gem_readwrite (beyond-eob)
[374.340498] Subtest beyond-EOB: SKIP (0.000s)
[374.395874] [055/140] (640s left) kms_atomic_interruptible (legacy-dpms)
[374.539828] Starting subtest: legacy-dpms
[374.540799] Starting dynamic subtest: pipe-A-DP-4
[380.866476] Dynamic subtest pipe-A-DP-4: SUCCESS (6.325s)
[380.867317] Subtest legacy-dpms: SUCCESS (6.326s)
[381.067270] [056/140] (633s left) gem_ctx_bad_destroy (invalid-pad)
[381.138211] Starting subtest: invalid-pad
[381.139204] Subtest invalid-pad: SUCCESS (0.000s)
[381.212911] [057/140] (633s left) sysfs_timeslice_duration (duration)
[381.268639] Starting subtest: duration
[381.269563] Starting dynamic subtest: ccs2
[394.389543] Dynamic subtest ccs2: SUCCESS (13.119s)
[394.399387] Starting dynamic subtest: vecs0
[407.516023] Dynamic subtest vecs0: SUCCESS (13.125s)
[407.526573] Starting dynamic subtest: ccs0
[420.645431] Dynamic subtest ccs0: SUCCESS (13.124s)
[420.653524] Starting dynamic subtest: vcs0
[433.765203] Dynamic subtest vcs0: SUCCESS (13.121s)
[433.775541] Starting dynamic subtest: bcs0
[446.898633] Dynamic subtest bcs0: SUCCESS (13.131s)
[446.908615] Starting dynamic subtest: ccs3
[460.002965] Dynamic subtest ccs3: SUCCESS (13.103s)
[460.011898] Starting dynamic subtest: vecs1
[473.147505] Dynamic subtest vecs1: SUCCESS (13.141s)
[473.157646] Starting dynamic subtest: ccs1
[486.280192] Dynamic subtest ccs1: SUCCESS (13.133s)
[486.290709] Starting dynamic subtest: rcs0
[499.387183] Dynamic subtest rcs0: SUCCESS (13.105s)
[499.399523] Starting dynamic subtest: vcs1
[512.533268] Dynamic subtest vcs1: SUCCESS (13.143s)
[512.535223] Subtest duration: SUCCESS (131.264s)
[512.610159] [058/140] (502s left) kms_ccs (pipe-c-random-ccs-data-4-tiled-dg2-rc-ccs)
[512.856418] Starting subtest: pipe-C-random-ccs-data-4-tiled-dg2-rc-ccs
[513.025967] Subtest pipe-C-random-ccs-data-4-tiled-dg2-rc-ccs: SUCCESS (0.169s)
[513.331333] [059/140] (501s left) kms_vblank (query-forked-hang)
[513.478054] Starting subtest: query-forked-hang
[513.479977] Starting dynamic subtest: pipe-A-DP-4
[527.674934] Dynamic subtest pipe-A-DP-4: SUCCESS (14.195s)
[527.684105] Starting dynamic subtest: pipe-D-DP-4
[552.685329] Dynamic subtest pipe-D-DP-4: SUCCESS (25.008s)
[552.686162] Subtest query-forked-hang: SUCCESS (39.207s)
[552.879493] [060/140] (462s left) debugfs_test (read_all_entries_display_on)
[553.047783] Starting subtest: read_all_entries_display_on
[553.574859] Subtest read_all_entries_display_on: SUCCESS (0.528s)
[553.716571] [061/140] (461s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[553.840305] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[553.842161] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[553.912812] [062/140] (461s left) kms_pipe_crc_basic (nonblocking-crc)
[554.055098] Starting subtest: nonblocking-crc
[554.056944] Starting dynamic subtest: pipe-A-DP-4
[554.735113] Dynamic subtest pipe-A-DP-4: SUCCESS (0.678s)
[554.755068] Starting dynamic subtest: pipe-B-DP-4
[555.356831] Dynamic subtest pipe-B-DP-4: SUCCESS (0.616s)
[555.367879] Starting dynamic subtest: pipe-C-DP-4
[555.980802] Dynamic subtest pipe-C-DP-4: SUCCESS (0.625s)
[555.996794] Starting dynamic subtest: pipe-D-DP-4
[556.606461] Dynamic subtest pipe-D-DP-4: SUCCESS (0.624s)
[556.607411] Subtest nonblocking-crc: SUCCESS (2.551s)
[556.844121] [063/140] (458s left) kms_color (invalid-ctm-matrix-sizes)
[556.996760] Starting subtest: invalid-ctm-matrix-sizes
[556.997737] Starting dynamic subtest: pipe-A
[557.000531] Dynamic subtest pipe-A: SUCCESS (0.004s)
[557.008692] Starting dynamic subtest: pipe-B
[557.009624] Dynamic subtest pipe-B: SUCCESS (0.004s)
[557.018163] Starting dynamic subtest: pipe-C
[557.019128] Dynamic subtest pipe-C: SUCCESS (0.006s)
[557.027458] Starting dynamic subtest: pipe-D
[557.028780] Dynamic subtest pipe-D: SUCCESS (0.006s)
[557.029932] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.022s)
[557.074459] [064/140] (458s left) kms_ccs (pipe-d-crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[557.324834] Starting subtest: pipe-D-crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[557.326636] Subtest pipe-D-crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[557.496246] [065/140] (457s left) gem_pxp (reject-modify-context-protection-off-3)
[560.129153] Subtest reject-modify-context-protection-off-3: SKIP (0.000s)
[560.174475] [066/140] (455s left) gem_spin_batch (legacy-resubmit-new)
[560.226487] Starting subtest: legacy-resubmit-new
[560.227496] Starting dynamic subtest: default
[560.247065] Dynamic subtest default: SUCCESS (0.020s)
[560.255474] Starting dynamic subtest: render
[560.256335] Dynamic subtest render: SUCCESS (0.004s)
[560.264613] Starting dynamic subtest: bsd
[560.265475] Dynamic subtest bsd: SUCCESS (0.003s)
[560.273674] Starting dynamic subtest: bsd1
[560.274562] Dynamic subtest bsd1: SUCCESS (0.002s)
[560.282526] Starting dynamic subtest: bsd2
[560.283573] Dynamic subtest bsd2: SUCCESS (0.003s)
[560.291508] Starting dynamic subtest: blt
[560.292604] Dynamic subtest blt: SUCCESS (0.003s)
[560.300754] Starting dynamic subtest: vebox
[560.301891] Dynamic subtest vebox: SUCCESS (0.003s)
[560.303087] Subtest legacy-resubmit-new: SUCCESS (0.041s)
[560.530203] [067/140] (454s left) kms_flip (2x-flip-vs-fences)
[560.653889] Starting subtest: 2x-flip-vs-fences
[560.655822] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[560.737806] [068/140] (454s left) gem_ctx_param (invalid-set-no-zeromap)
[560.796830] Starting subtest: invalid-set-no-zeromap
[560.797761] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[560.872255] [069/140] (454s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[561.009461] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[561.011660] Starting dynamic subtest: pipe-A-DP-4
[561.097711] Dynamic subtest pipe-A-DP-4: SUCCESS (0.087s)
[561.187083] Starting dynamic subtest: pipe-B-DP-4
[561.392542] Dynamic subtest pipe-B-DP-4: SUCCESS (0.218s)
[561.465915] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (0.455s)
[561.660863] [070/140] (453s left) gem_softpin (softpin)
[561.754130] Starting subtest: softpin
[593.996300] Subtest softpin: SUCCESS (32.233s)
[594.083215] [071/140] (421s left) kms_ccs (pipe-a-random-ccs-data-y-tiled-gen12-rc-ccs)
[594.287934] Starting subtest: pipe-A-random-ccs-data-y-tiled-gen12-rc-ccs
[594.290756] Subtest pipe-A-random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[594.512232] [072/140] (420s left) gem_exec_schedule (deep)
[594.723172] Starting subtest: deep
[594.724177] Starting dynamic subtest: rcs0
[606.778549] Dynamic subtest rcs0: SUCCESS (12.055s)
[606.786993] Starting dynamic subtest: bcs0
[618.764569] Dynamic subtest bcs0: SUCCESS (11.985s)
[618.773123] Starting dynamic subtest: vcs0
[630.657012] Dynamic subtest vcs0: SUCCESS (11.899s)
[630.665579] Starting dynamic subtest: vcs1
[643.025857] Dynamic subtest vcs1: SUCCESS (12.361s)
[643.034406] Starting dynamic subtest: vecs0
[655.422567] Dynamic subtest vecs0: SUCCESS (12.396s)
[655.431106] Starting dynamic subtest: vecs1
[667.662876] Dynamic subtest vecs1: SUCCESS (12.239s)
[667.672291] Starting dynamic subtest: ccs0
[680.136523] Dynamic subtest ccs0: SUCCESS (12.474s)
[680.145316] Starting dynamic subtest: ccs1
[692.326055] Dynamic subtest ccs1: SUCCESS (12.189s)
[692.334499] Starting dynamic subtest: ccs2
[704.511176] Dynamic subtest ccs2: SUCCESS (12.184s)
[704.519798] Starting dynamic subtest: ccs3
[716.902065] Dynamic subtest ccs3: SUCCESS (12.390s)
[716.902909] Subtest deep: SUCCESS (122.179s)
[717.409173] [073/140] (298s left) vc4/vc4_create_bo (create-bo-0)
[717.503606] Subtest create-bo-0: SKIP (0.000s)
[717.554870] [074/140] (297s left) sw_sync (sync_busy_fork_unixsocket)
[717.606874] Starting subtest: sync_busy_fork_unixsocket
[717.615502] Subtest sync_busy_fork_unixsocket: SUCCESS (0.009s)
[717.658016] [075/140] (297s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[717.722816] Starting subtest: single-wait-all-for-submit-available-signaled
[717.723808] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[717.824950] [076/140] (297s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[717.968754] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[721.104381] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (3.136s)
[721.259038] [077/140] (294s left) kms_psr (pr_primary_mmap_cpu)
[721.387581] Subtest pr_primary_mmap_cpu: SKIP (0.000s)
[721.413714] [078/140] (294s left) kms_psr (psr2_cursor_blt)
[721.527454] Subtest psr2_cursor_blt: SKIP (0.000s)
[721.546678] [079/140] (294s left) kms_big_joiner (basic)
[721.670912] Subtest basic: SKIP (0.000s)
[721.696369] [080/140] (293s left) kms_setmode (invalid-clone-single-crtc-stealing)
[721.739413] Starting subtest: invalid-clone-single-crtc-stealing
[721.741719] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[721.819168] [081/140] (293s left) prime_mmap (test_userptr)
[721.878073] Starting subtest: test_userptr
[721.879112] Starting dynamic subtest: test_userptr-smem
[721.879945] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[721.880810] Subtest test_userptr: SUCCESS (0.002s)
[721.957614] [082/140] (293s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[722.087661] Starting subtest: fbc-indfb-scaledprimary
[725.504418] Subtest fbc-indfb-scaledprimary: SUCCESS (3.418s)
[725.647266] [083/140] (290s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[725.869899] Starting subtest: cursor-rapid-movement-128x128
[725.874449] Starting dynamic subtest: pipe-A-DP-4
[726.296854] Dynamic subtest pipe-A-DP-4: SUCCESS (0.423s)
[726.340655] Starting dynamic subtest: pipe-D-DP-4
[726.726481] Dynamic subtest pipe-D-DP-4: SUCCESS (0.394s)
[726.727432] Subtest cursor-rapid-movement-128x128: SUCCESS (0.856s)
[727.071851] [084/140] (288s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[727.232824] Starting subtest: fbcpsr-2p-rte
[727.234497] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[727.330935] [085/140] (288s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[727.413274] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[727.415227] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[727.636130] [086/140] (288s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[727.883529] Starting subtest: pipe-B-crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[727.886406] Subtest pipe-B-crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SKIP (0.002s)
[728.098423] [087/140] (287s left) gem_eio (reset-stress)
[728.479107] Starting subtest: reset-stress
[768.078464] Subtest reset-stress: SUCCESS (39.599s)
[768.276315] [088/140] (247s left) kms_vrr (flip-suspend)
[768.420864] Starting subtest: flip-suspend
[768.422781] Subtest flip-suspend: SKIP (0.000s)
[768.489062] [089/140] (247s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[768.613651] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[768.615324] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[768.692254] [090/140] (247s left) dmabuf_sync_file (export-before-signal)
[768.769048] Starting subtest: export-before-signal
[768.770178] Subtest export-before-signal: SUCCESS (0.001s)
[768.823631] [091/140] (247s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[768.889516] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[768.992174] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.103s)
[769.074935] [092/140] (246s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[769.202691] Starting subtest: psr-2p-pri-indfb-multidraw
[769.204465] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[769.272909] [093/140] (246s left) gem_exec_capture (capture-recoverable)
[769.333358] Starting subtest: capture-recoverable
[769.336742] Subtest capture-recoverable: SUCCESS (0.003s)
[769.457607] [094/140] (246s left) kms_mmap_write_crc (main)
[769.584143] Starting subtest: main
[769.586391] Starting dynamic subtest: pipe-A-DP-4
[773.691531] Dynamic subtest pipe-A-DP-4: SUCCESS (4.103s)
[773.693189] Subtest main: SUCCESS (4.105s)
[773.952228] [095/140] (242s left) i915_selftest (live)
[776.609168] Starting subtest: live
[776.610719] Starting dynamic subtest: sanitycheck
[779.121644] Dynamic subtest sanitycheck: SUCCESS (2.504s)
[779.128900] Starting dynamic subtest: uncore
[781.400340] Dynamic subtest uncore: SUCCESS (2.278s)
[781.407923] Starting dynamic subtest: workarounds
[786.572348] Dynamic subtest workarounds: SUCCESS (5.171s)
[786.580617] Starting dynamic subtest: gt_engines
[789.928261] Dynamic subtest gt_engines: SUCCESS (3.355s)
[789.934689] Starting dynamic subtest: gt_timelines
[818.366251] Dynamic subtest gt_timelines: SUCCESS (28.437s)
[818.373582] Starting dynamic subtest: gt_contexts
[820.790489] Dynamic subtest gt_contexts: SUCCESS (2.423s)
[820.797787] Starting dynamic subtest: gt_lrc
[829.689228] Dynamic subtest gt_lrc: SUCCESS (8.898s)
[829.696840] Starting dynamic subtest: gt_mocs
[834.349379] Dynamic subtest gt_mocs: SUCCESS (4.659s)
[834.357348] Starting dynamic subtest: gt_pm
[837.693262] Dynamic subtest gt_pm: SUCCESS (3.343s)
[837.699615] Starting dynamic subtest: gt_heartbeat
[840.317487] Dynamic subtest gt_heartbeat: SUCCESS (2.623s)
[840.325232] Starting dynamic subtest: gt_tlb
[853.459352] Dynamic subtest gt_tlb: SUCCESS (13.141s)
[853.466376] Starting dynamic subtest: requests
[871.905379] Dynamic subtest requests: SUCCESS (18.445s)
[871.913512] Starting dynamic subtest: migrate
[878.139298] Dynamic subtest migrate: SUCCESS (6.233s)
[878.146309] Starting dynamic subtest: active
[880.559205] Dynamic subtest active: SUCCESS (2.419s)
[880.566721] Starting dynamic subtest: objects
[883.767187] Dynamic subtest objects: SUCCESS (3.207s)
[883.773969] Starting dynamic subtest: mman
[893.602339] Dynamic subtest mman: SUCCESS (9.834s)
[893.609585] Starting dynamic subtest: dmabuf
[896.008365] Dynamic subtest dmabuf: SUCCESS (2.405s)
[896.015816] Starting dynamic subtest: vma
[898.361371] Dynamic subtest vma: SUCCESS (2.352s)
[898.368899] Starting dynamic subtest: coherency
[903.568890] Dynamic subtest coherency: SUCCESS (5.207s)
[903.576216] Starting dynamic subtest: gtt
[913.381361] Dynamic subtest gtt: SUCCESS (9.812s)
[913.387420] Starting dynamic subtest: gem
[915.879427] Dynamic subtest gem: SUCCESS (2.505s)
[915.887369] Starting dynamic subtest: evict
[920.337475] Dynamic subtest evict: SUCCESS (4.449s)
[920.345092] Starting dynamic subtest: hugepages
[938.952267] Dynamic subtest hugepages: SUCCESS (18.614s)
[938.960280] Starting dynamic subtest: gem_contexts
[980.102253] Dynamic subtest gem_contexts: SUCCESS (41.149s)
[980.108359] Starting dynamic subtest: client
[982.607400] Dynamic subtest client: SUCCESS (2.504s)
[982.615314] Starting dynamic subtest: gem_migrate
[988.594215] Dynamic subtest gem_migrate: SUCCESS (5.986s)
[988.601595] Starting dynamic subtest: reset
[991.089355] Dynamic subtest reset: SUCCESS (2.494s)
[991.096727] Starting dynamic subtest: memory_region
[995.089088] Dynamic subtest memory_region: SUCCESS (3.999s)
[995.096200] Starting dynamic subtest: hangcheck
[1041.944354] Dynamic subtest hangcheck: SUCCESS (46.854s)
[1041.952400] Starting dynamic subtest: execlists
[1044.431296] Dynamic subtest execlists: SUCCESS (2.486s)
[1044.438721] Starting dynamic subtest: ring_submission
[1046.855391] Dynamic subtest ring_submission: SUCCESS (2.423s)
[1046.862267] Starting dynamic subtest: perf
[1049.368400] Dynamic subtest perf: SUCCESS (2.512s)
[1049.376289] Starting dynamic subtest: slpc
[1059.679051] Dynamic subtest slpc: SUCCESS (10.310s)
[1059.686170] Starting dynamic subtest: guc
[1063.390355] Dynamic subtest guc: SUCCESS (3.710s)
[1063.397551] Starting dynamic subtest: guc_multi_lrc
[1065.861215] Dynamic subtest guc_multi_lrc: SUCCESS (2.470s)
[1065.867995] Starting dynamic subtest: guc_hang
[1069.032488] Dynamic subtest guc_hang: SUCCESS (3.171s)
[1069.040593] Starting dynamic subtest: late_gt_pm
[1071.530339] Dynamic subtest late_gt_pm: SUCCESS (2.497s)
[1071.531757] Subtest live: SUCCESS (294.913s)
[1071.741028] Overall timeout time exceeded, stopping.
[1071.741761] Closing watchdogs
Done.