[44.784087] Initializing watchdogs [44.784539] /dev/watchdog0 [44.817385] [001/142] (960s left) i915_pm_rpm (reg-read-ioctl) [51.210188] Starting subtest: reg-read-ioctl [58.948453] Subtest reg-read-ioctl: SUCCESS (7.738s) [59.897572] [002/142] (945s left) kms_flip (flip-vs-dpms-off-vs-modeset) [60.276402] Starting subtest: flip-vs-dpms-off-vs-modeset [60.301551] Starting dynamic subtest: A-eDP1 [65.236505] Dynamic subtest A-eDP1: SUCCESS (4.930s) [65.264251] Starting dynamic subtest: B-eDP1 [68.890773] Dynamic subtest B-eDP1: SUCCESS (3.654s) [68.918136] Starting dynamic subtest: C-eDP1 [72.507599] Dynamic subtest C-eDP1: SUCCESS (3.615s) [72.541410] Starting dynamic subtest: D-eDP1 [76.124908] Dynamic subtest D-eDP1: SUCCESS (3.617s) [76.145080] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (15.872s) [77.077734] [003/142] (928s left) syncobj_timeline (device-signal-unordered) [77.455353] Starting subtest: device-signal-unordered [77.462368] Subtest device-signal-unordered: SUCCESS (0.005s) [77.593875] [004/142] (927s left) kms_ccs (pipe-d-random-ccs-data-4_tiled_mtl_rc_ccs_cc) [79.256335] Starting subtest: pipe-D-random-ccs-data-4_tiled_mtl_rc_ccs_cc [80.471308] Subtest pipe-D-random-ccs-data-4_tiled_mtl_rc_ccs_cc: SUCCESS (1.215s) [81.885392] [005/142] (923s left) vc4/vc4_create_bo (create-bo-0) [82.348868] Subtest create-bo-0: SKIP (0.000s) [82.452400] [006/142] (923s left) prime_mmap (test_forked) [82.822117] Starting subtest: test_forked [82.825203] Starting dynamic subtest: test_forked-smem [83.414107] Dynamic subtest test_forked-smem: SUCCESS (0.592s) [83.418417] Subtest test_forked: SUCCESS (0.593s) [83.566822] [007/142] (922s left) v3d/v3d_mmap (mmap-bo) [83.997895] Subtest mmap-bo: SKIP (0.000s) [84.099334] [008/142] (921s left) kms_big_fb (x-tiled-8bpp-rotate-270) [84.628326] Starting subtest: x-tiled-8bpp-rotate-270 [84.698217] Subtest x-tiled-8bpp-rotate-270: SKIP (0.064s) [84.880528] [009/142] (920s left) kms_chamelium_frames (dp-crc-fast) [85.761876] Subtest dp-crc-fast: SKIP (0.000s) [86.611568] [010/142] (919s left) kms_ccs (pipe-c-random-ccs-data-y_tiled_gen12_mc_ccs) [88.088413] Starting subtest: pipe-C-random-ccs-data-y_tiled_gen12_mc_ccs [88.098132] Subtest pipe-C-random-ccs-data-y_tiled_gen12_mc_ccs: SKIP (0.000s) [89.009693] [011/142] (916s left) kms_ccs (pipe-c-bad-aux-stride-4_tiled_mtl_rc_ccs) [90.520953] Starting subtest: pipe-C-bad-aux-stride-4_tiled_mtl_rc_ccs [90.524620] Subtest pipe-C-bad-aux-stride-4_tiled_mtl_rc_ccs: SUCCESS (0.003s) [91.336682] [012/142] (914s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt) [91.831809] Starting subtest: psr-rgb101010-draw-mmap-gtt [91.838628] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [91.988953] [013/142] (914s left) api_intel_bb (intel-bb-blit-y) [92.354349] Starting subtest: intel-bb-blit-y [103.794853] Subtest intel-bb-blit-y: SUCCESS (11.442s) [103.985922] [014/142] (902s left) perf (invalid-oa-metric-set-id) [104.874295] Starting subtest: invalid-oa-metric-set-id [104.926357] Subtest invalid-oa-metric-set-id: SUCCESS (0.049s) [105.019633] [015/142] (901s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite) [105.527354] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite [105.533131] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [105.678161] [016/142] (900s left) kms_ccs (pipe-a-ccs-on-another-bo-4_tiled_mtl_mc_ccs) [106.666438] Starting subtest: pipe-A-ccs-on-another-bo-4_tiled_mtl_mc_ccs [106.833244] Subtest pipe-A-ccs-on-another-bo-4_tiled_mtl_mc_ccs: SUCCESS (0.167s) [107.791118] [017/142] (898s left) kms_lease (lease_revoke) [108.075118] Starting subtest: lease_revoke [108.078587] Starting dynamic subtest: pipe-A-eDP-1 [108.197105] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.121s) [108.217442] Starting dynamic subtest: pipe-B-eDP-1 [108.304410] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.103s) [108.325957] Starting dynamic subtest: pipe-C-eDP-1 [108.414863] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.105s) [108.437540] Starting dynamic subtest: pipe-D-eDP-1 [108.527591] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.107s) [108.531824] Subtest lease_revoke: SUCCESS (0.456s) [108.708114] [018/142] (897s left) gem_exec_balancer (bonded-true-hang) [109.944506] Starting subtest: bonded-true-hang [109.950919] Subtest bonded-true-hang: SKIP (0.000s) [110.099383] [019/142] (896s left) gem_exec_params (invalid-ring2) [110.495855] Starting subtest: invalid-ring2 [110.499771] Subtest invalid-ring2: SUCCESS (0.001s) [110.643338] [020/142] (895s left) kms_psr2_sf (overlay-plane-update-sf-dmg-area) [117.239044] Starting subtest: overlay-plane-update-sf-dmg-area [117.242572] Starting dynamic subtest: pipe-A-eDP-1 [124.188606] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.946s) [124.205479] Starting dynamic subtest: pipe-B-eDP-1 [131.046943] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.853s) [131.049679] Subtest overlay-plane-update-sf-dmg-area: SUCCESS (13.808s) [132.005162] [021/142] (874s left) kms_atomic_transition (modeset-transition-nonblocking-fencing) [132.489763] Starting subtest: modeset-transition-nonblocking-fencing [132.493900] Starting dynamic subtest: 1x-outputs [159.215506] Dynamic subtest 1x-outputs: SUCCESS (26.727s) [159.548202] Subtest modeset-transition-nonblocking-fencing: SUCCESS (27.060s) [160.503648] [022/142] (846s left) kms_ccs (pipe-a-crc-primary-basic-y_tiled_gen12_rc_ccs) [161.412543] Starting subtest: pipe-A-crc-primary-basic-y_tiled_gen12_rc_ccs [161.419229] Subtest pipe-A-crc-primary-basic-y_tiled_gen12_rc_ccs: SKIP (0.002s) [162.882474] [023/142] (843s left) kms_atomic_interruptible (legacy-setmode) [163.365813] Starting subtest: legacy-setmode [163.374570] Starting dynamic subtest: eDP-1-pipe-A [170.749640] Dynamic subtest eDP-1-pipe-A: SUCCESS (7.374s) [170.753310] Subtest legacy-setmode: SUCCESS (7.385s) [171.695743] [024/142] (835s left) kms_big_fb (y-tiled-16bpp-rotate-0) [172.221588] Starting subtest: y-tiled-16bpp-rotate-0 [172.228606] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s) [172.364052] [025/142] (834s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled) [172.735576] Starting subtest: multi-wait-for-submit-submitted-signaled [172.739289] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.003s) [172.871248] [026/142] (834s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt) [173.362623] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt [173.369440] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [173.517466] [027/142] (833s left) i915_hangman (hangcheck-unterminated) [173.953383] Starting subtest: hangcheck-unterminated [185.498535] Subtest hangcheck-unterminated: SUCCESS (11.546s) [185.719459] [028/142] (821s left) kms_lease (simple_lease) [186.229380] Starting subtest: simple_lease [186.233657] Starting dynamic subtest: pipe-A-eDP-1 [187.434337] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.201s) [187.477995] Starting dynamic subtest: pipe-B-eDP-1 [189.655491] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.209s) [189.694816] Starting dynamic subtest: pipe-C-eDP-1 [191.827859] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.166s) [191.870217] Starting dynamic subtest: pipe-D-eDP-1 [193.995384] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.158s) [193.998851] Subtest simple_lease: SUCCESS (7.769s) [194.947865] [029/142] (812s left) gem_exec_capture (capture-invisible) [195.340232] Starting subtest: capture-invisible [195.343824] Starting dynamic subtest: smem0 [195.350787] Dynamic subtest smem0: SKIP (0.000s) [195.356793] Subtest capture-invisible: SKIP (0.004s) [195.510524] [030/142] (811s left) v3d/v3d_get_param (get-bad-param) [195.956939] Subtest get-bad-param: SKIP (0.000s) [196.082580] [031/142] (811s left) syncobj_timeline (single-wait-all-for-submit-available-signaled) [196.464993] Starting subtest: single-wait-all-for-submit-available-signaled [196.469253] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.001s) [196.606799] [032/142] (810s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt) [197.107825] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt [197.114642] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [197.272882] [033/142] (810s left) perf (missing-sample-flags) [197.898092] Starting subtest: missing-sample-flags [197.902065] Subtest missing-sample-flags: SUCCESS (0.001s) [198.000709] [034/142] (809s left) gem_readwrite (write-bad-handle) [198.367756] Subtest write-bad-handle: SKIP (0.000s) [198.493866] [035/142] (809s left) perf_pmu (rc6) [198.882311] Starting subtest: rc6 [198.885978] Starting dynamic subtest: gt0 [205.226356] Dynamic subtest gt0: SUCCESS (6.338s) [205.267884] Starting dynamic subtest: runtime-pm-gt0 [213.100253] Dynamic subtest runtime-pm-gt0: SUCCESS (7.873s) [213.141375] Starting dynamic subtest: runtime-pm-long-gt0 [225.806244] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.701s) [225.845928] Starting dynamic subtest: other-idle-gt0 [232.150584] Dynamic subtest other-idle-gt0: SUCCESS (6.340s) [232.190090] Starting dynamic subtest: gt1 [238.493543] Dynamic subtest gt1: SUCCESS (6.338s) [238.533383] Starting dynamic subtest: runtime-pm-gt1 [241.881593] Dynamic subtest runtime-pm-gt1: SKIP (3.380s) [241.921120] Starting dynamic subtest: runtime-pm-long-gt1 [252.754560] Dynamic subtest runtime-pm-long-gt1: SKIP (10.869s) [252.794151] Starting dynamic subtest: other-idle-gt1 [255.077151] Dynamic subtest other-idle-gt1: SKIP (2.319s) [255.080750] Subtest rc6: SUCCESS (56.193s) [255.644253] [036/142] (752s left) kms_cursor_crc (cursor-random-512x170) [256.713796] Starting subtest: cursor-random-512x170 [256.721857] Subtest cursor-random-512x170: SKIP (0.003s) [256.964277] [037/142] (750s left) gem_exec_params (no-bsd) [257.360101] Starting subtest: no-bsd [257.369434] Subtest no-bsd: SUCCESS (0.007s) [258.619889] [038/142] (749s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_mtl_rc_ccs) [259.819459] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_mtl_rc_ccs [261.123233] Subtest pipe-B-crc-primary-rotation-180-4_tiled_mtl_rc_ccs: SUCCESS (1.303s) [262.601467] [039/142] (745s left) gem_mmap_gtt (fault-concurrent) [262.972476] Subtest fault-concurrent: SKIP (0.000s) [263.070933] [040/142] (745s left) perf_pmu (busy-accuracy-50) [263.459284] Starting subtest: busy-accuracy-50 [263.462920] Starting dynamic subtest: rcs0 [265.057324] Dynamic subtest rcs0: SUCCESS (1.592s) [265.100901] Starting dynamic subtest: bcs0 [266.662975] Dynamic subtest bcs0: SUCCESS (1.600s) [266.704612] Starting dynamic subtest: vcs0 [268.256185] Dynamic subtest vcs0: SUCCESS (1.588s) [268.297366] Starting dynamic subtest: vcs1 [269.854901] Dynamic subtest vcs1: SUCCESS (1.595s) [269.896731] Starting dynamic subtest: vecs0 [271.451999] Dynamic subtest vecs0: SUCCESS (1.592s) [271.493514] Starting dynamic subtest: ccs0 [273.053461] Dynamic subtest ccs0: SUCCESS (1.597s) [273.057350] Subtest busy-accuracy-50: SUCCESS (9.593s) [273.213612] [041/142] (735s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling) [273.698230] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling [273.708252] Starting dynamic subtest: pipe-A-default-mode [274.186279] Dynamic subtest pipe-A-default-mode: SKIP (0.474s) [274.192818] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.488s) [275.002301] [042/142] (733s left) kms_ccs (pipe-d-ccs-on-another-bo-yf_tiled_ccs) [276.744412] Starting subtest: pipe-D-ccs-on-another-bo-yf_tiled_ccs [276.751256] Subtest pipe-D-ccs-on-another-bo-yf_tiled_ccs: SKIP (0.000s) [277.337905] [043/142] (731s left) kms_addfb_basic (too-high) [277.820986] Starting subtest: too-high [277.824886] Subtest too-high: SUCCESS (0.004s) [277.948372] [044/142] (730s left) kms_cursor_crc (cursor-random-64x21) [278.752271] Starting subtest: cursor-random-64x21 [278.788435] Starting dynamic subtest: pipe-A-eDP-1 [285.007798] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.218s) [285.197595] Starting dynamic subtest: pipe-D-eDP-1 [292.579778] Dynamic subtest pipe-D-eDP-1: SUCCESS (7.417s) [292.583382] Subtest cursor-random-64x21: SUCCESS (13.824s) [293.701101] [045/142] (714s left) gem_exec_fair (basic-pace) [294.103461] Subtest basic-pace: SKIP (0.000s) [294.222977] [046/142] (714s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu) [294.725581] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu [294.732160] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [294.853308] [047/142] (713s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs) [295.251956] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs [295.258312] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s) [295.482377] [048/142] (713s left) gem_mmap_wc (read) [295.860740] Subtest read: SKIP (0.000s) [295.953502] [049/142] (713s left) gem_exec_suspend (basic-s0) [296.386234] Starting subtest: basic-S0 [296.391061] Starting dynamic subtest: smem [325.464942] Dynamic subtest smem: SUCCESS (29.075s) [325.469160] Subtest basic-S0: SUCCESS (29.079s) [325.713699] [050/142] (683s left) gem_exec_reloc (basic-write-read) [326.106889] Subtest basic-write-read: SKIP (0.000s) [326.240625] [051/142] (682s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [326.724787] Starting subtest: plane-use-after-nonblocking-unbind [326.735215] Starting dynamic subtest: pipe-A-eDP-1 [327.002946] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.271s) [327.466472] Starting dynamic subtest: pipe-B-eDP-1 [328.431767] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.018s) [328.880783] Subtest plane-use-after-nonblocking-unbind: SUCCESS (2.154s) [329.785561] [052/142] (679s left) gem_ctx_exec (basic-close-race) [330.160881] Starting subtest: basic-close-race [336.236778] Subtest basic-close-race: SUCCESS (6.073s) [340.936305] [053/142] (668s left) kms_vblank (pipe-b-ts-continuation-dpms-suspend) [342.653257] Starting subtest: pipe-B-ts-continuation-dpms-suspend [361.515271] Subtest pipe-B-ts-continuation-dpms-suspend: SUCCESS (18.869s) [362.441206] [054/142] (646s left) vc4/vc4_purgeable_bo (free-purged-bo) [362.888639] Subtest free-purged-bo: SKIP (0.000s) [362.980427] [055/142] (646s left) kms_psr (psr2_sprite_mmap_cpu) [363.460483] Starting subtest: psr2_sprite_mmap_cpu [366.515857] Subtest psr2_sprite_mmap_cpu: SUCCESS (3.055s) [367.421378] [056/142] (642s left) gem_exec_fence (syncobj-export) [369.575783] Starting subtest: syncobj-export [369.593447] Subtest syncobj-export: SUCCESS (0.018s) [369.987882] [057/142] (639s left) gem_exec_params (cliprects_ptr-dirt) [370.384499] Starting subtest: cliprects_ptr-dirt [370.389215] Subtest cliprects_ptr-dirt: SUCCESS (0.002s) [370.504645] [058/142] (639s left) gem_mmap_gtt (big-bo-tiledx) [370.887602] Subtest big-bo-tiledX: SKIP (0.000s) [371.006773] [059/142] (638s left) kms_vblank (pipe-a-query-forked-hang) [371.492303] Starting subtest: pipe-A-query-forked-hang [385.819662] Subtest pipe-A-query-forked-hang: SUCCESS (14.329s) [386.737400] [060/142] (623s left) perf (blocking-parameterized) [387.312537] Starting subtest: blocking-parameterized [407.407377] Subtest blocking-parameterized: SUCCESS (20.093s) [407.531522] [061/142] (602s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt) [408.045547] Starting subtest: fbc-rgb565-draw-mmap-gtt [408.052411] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s) [408.184323] [062/142] (601s left) kms_plane_scaling (plane-downscale-with-rotation-factor-0-75) [408.658815] Starting subtest: plane-downscale-with-rotation-factor-0-75 [408.664163] Starting dynamic subtest: pipe-A-eDP-1 [410.204633] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.541s) [410.260626] Starting dynamic subtest: pipe-B-eDP-1 [413.059284] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.844s) [413.124181] Starting dynamic subtest: pipe-C-eDP-1 [415.722199] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.645s) [415.772219] Starting dynamic subtest: pipe-D-eDP-1 [418.090110] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.365s) [418.092372] Subtest plane-downscale-with-rotation-factor-0-75: SUCCESS (9.436s) [419.454251] [063/142] (590s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0) [419.983904] Starting subtest: linear-max-hw-stride-64bpp-rotate-0 [423.053622] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (3.067s) [423.284169] [064/142] (587s left) gen9_exec_parse (bb-start-param) [423.675070] Subtest bb-start-param: SKIP (0.000s) [423.786741] [065/142] (586s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [424.133936] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s) [424.349903] [066/142] (586s left) kms_hdmi_inject (inject-4k) [424.922120] Starting subtest: inject-4k [425.376995] Subtest inject-4k: SUCCESS (0.456s) [425.968974] [067/142] (584s left) gem_create (create-ext-set-pat) [426.482744] Starting subtest: create-ext-set-pat [426.486363] Subtest create-ext-set-pat: SUCCESS (0.002s) [426.619456] [068/142] (584s left) gem_mmap_gtt (fault-concurrent-x) [426.872725] Subtest fault-concurrent-X: SKIP (0.000s) [426.937727] [069/142] (583s left) gem_partial_pwrite_pread (reads-display) [427.115645] Subtest reads-display: SKIP (0.000s) [427.195830] [070/142] (583s left) kms_ccs (pipe-a-random-ccs-data-y_tiled_gen12_rc_ccs_cc) [427.809101] Starting subtest: pipe-A-random-ccs-data-y_tiled_gen12_rc_ccs_cc [427.819339] Subtest pipe-A-random-ccs-data-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s) [429.162651] [071/142] (581s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [429.642200] Starting subtest: addfb25-y-tiled-small-legacy [429.649406] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [429.779312] [072/142] (581s left) testdisplay [430.923604] [073/142] (580s left) kms_vblank (invalid) [431.421218] Starting subtest: invalid [432.011935] Subtest invalid: SUCCESS (0.592s) [432.926354] [074/142] (578s left) kms_frontbuffer_tracking (fbcpsr-suspend) [433.425802] Starting subtest: fbcpsr-suspend [477.729966] Subtest fbcpsr-suspend: SUCCESS (44.306s) [477.965807] [075/142] (533s left) gem_render_copy (x-tiled) [478.335250] Starting subtest: x-tiled [478.338502] Starting dynamic subtest: smem [478.744591] Dynamic subtest smem: SUCCESS (0.406s) [478.748334] Subtest x-tiled: SUCCESS (0.410s) [479.024242] [076/142] (532s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt) [479.518483] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt [479.525301] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [479.669713] [077/142] (531s left) prime_busy (hang-wait) [480.052833] Starting subtest: hang-wait [480.062394] Starting dynamic subtest: rcs0 [494.173867] Dynamic subtest rcs0: SUCCESS (14.110s) [494.230515] Starting dynamic subtest: bcs0 [501.320535] Dynamic subtest bcs0: SUCCESS (7.143s) [501.371206] Starting dynamic subtest: vcs0 [508.310234] Dynamic subtest vcs0: SUCCESS (6.984s) [508.361184] Starting dynamic subtest: vcs1 [515.357547] Dynamic subtest vcs1: SUCCESS (7.039s) [515.413149] Starting dynamic subtest: vecs0 [522.321792] Dynamic subtest vecs0: SUCCESS (6.962s) [522.376105] Starting dynamic subtest: ccs0 [536.147911] Dynamic subtest ccs0: SUCCESS (13.822s) [536.152863] Subtest hang-wait: SUCCESS (56.095s) [536.303720] [078/142] (475s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite) [536.791756] Starting subtest: fbc-rgb101010-draw-pwrite [542.058187] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.268s) [542.292072] [079/142] (469s left) gem_ctx_persistence (saturated-hostile-nopreempt) [542.692472] Starting subtest: saturated-hostile-nopreempt [542.696641] Starting dynamic subtest: rcs0 [542.741512] Dynamic subtest rcs0: SKIP (0.050s) [542.797262] Starting dynamic subtest: bcs0 [542.804138] Dynamic subtest bcs0: SKIP (0.015s) [542.859837] Starting dynamic subtest: vcs0 [542.866698] Dynamic subtest vcs0: SKIP (0.026s) [542.916308] Starting dynamic subtest: vcs1 [542.922405] Dynamic subtest vcs1: SKIP (0.019s) [542.972787] Starting dynamic subtest: vecs0 [542.979506] Dynamic subtest vecs0: SKIP (0.023s) [543.029253] Starting dynamic subtest: ccs0 [543.035640] Dynamic subtest ccs0: SKIP (0.027s) [543.042100] Subtest saturated-hostile-nopreempt: SKIP (0.185s) [543.113971] [080/142] (468s left) syncobj_wait (wait-all-delayed-signal) [543.490051] Starting subtest: wait-all-delayed-signal [543.595947] Subtest wait-all-delayed-signal: SUCCESS (0.105s) [543.715664] [081/142] (468s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt) [544.230252] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt [544.236524] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [544.363641] [082/142] (467s left) gem_exec_reloc (basic-write-gtt-noreloc) [544.762645] Subtest basic-write-gtt-noreloc: SKIP (0.000s) [544.888856] [083/142] (467s left) gem_request_retire (retire-vma-not-inactive) [545.281915] Starting subtest: retire-vma-not-inactive [545.355060] Subtest retire-vma-not-inactive: SUCCESS (0.072s) [546.561883] [084/142] (465s left) gem_render_copy (linear-to-vebox-yf-tiled) [546.962542] Starting subtest: linear-to-vebox-yf-tiled [546.969066] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s) [547.202131] [085/142] (464s left) kms_flip (2x-flip-vs-fences) [547.598755] Starting subtest: 2x-flip-vs-fences [547.605611] Subtest 2x-flip-vs-fences: SKIP (0.000s) [547.769985] [086/142] (464s left) prime_vgem (fence-read-hang) [548.190932] Subtest fence-read-hang: SKIP (0.000s) [548.302306] [087/142] (464s left) kms_ccs (pipe-c-crc-primary-basic-yf_tiled_ccs) [549.685440] Starting subtest: pipe-C-crc-primary-basic-yf_tiled_ccs [549.691845] Subtest pipe-C-crc-primary-basic-yf_tiled_ccs: SKIP (0.002s) [550.619228] [088/142] (461s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc) [552.407167] Starting subtest: pipe-D-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc [554.948254] Subtest pipe-D-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc: SUCCESS (2.542s) [556.246110] [089/142] (456s left) kms_ccs (pipe-a-missing-ccs-buffer-y_tiled_gen12_mc_ccs) [557.240606] Starting subtest: pipe-A-missing-ccs-buffer-y_tiled_gen12_mc_ccs [557.247276] Subtest pipe-A-missing-ccs-buffer-y_tiled_gen12_mc_ccs: SKIP (0.000s) [558.588063] [090/142] (454s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt) [559.084363] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt [559.090870] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [559.218173] [091/142] (453s left) kms_cursor_legacy (cursorb-vs-flipa-legacy) [559.786346] Starting subtest: cursorB-vs-flipA-legacy [559.802485] Subtest cursorB-vs-flipA-legacy: SKIP (0.016s) [560.099451] [092/142] (452s left) gem_exec_schedule (pi-userfault) [560.684429] Starting subtest: pi-userfault [560.687781] Starting dynamic subtest: rcs0 [560.713258] Dynamic subtest rcs0: SUCCESS (0.029s) [560.770761] Starting dynamic subtest: bcs0 [560.774303] Dynamic subtest bcs0: SUCCESS (0.019s) [560.826098] Starting dynamic subtest: vcs0 [560.829549] Dynamic subtest vcs0: SUCCESS (0.019s) [560.881234] Starting dynamic subtest: vcs1 [560.884719] Dynamic subtest vcs1: SUCCESS (0.022s) [560.935669] Starting dynamic subtest: vecs0 [560.939325] Dynamic subtest vecs0: SUCCESS (0.018s) [560.997413] Starting dynamic subtest: ccs0 [561.000419] Dynamic subtest ccs0: SUCCESS (0.020s) [561.003346] Subtest pi-userfault: SUCCESS (0.151s) [562.564856] [093/142] (450s left) gem_userptr_blits (mmap-offset-banned) [563.016394] Starting subtest: mmap-offset-banned [563.019841] Starting dynamic subtest: gtt [563.026557] Dynamic subtest gtt: SKIP (0.000s) [563.078731] Starting dynamic subtest: wb [563.081822] Dynamic subtest wb: SUCCESS (0.001s) [563.137092] Starting dynamic subtest: wc [563.141123] Dynamic subtest wc: SUCCESS (0.001s) [563.194929] Starting dynamic subtest: uc [563.198409] Dynamic subtest uc: SUCCESS (0.001s) [563.201658] Subtest mmap-offset-banned: SUCCESS (0.020s) [563.273814] [094/142] (449s left) kms_color (ctm-signed) [563.761455] Starting subtest: ctm-signed [563.764539] Starting dynamic subtest: pipe-A [566.905578] Dynamic subtest pipe-A: SUCCESS (3.143s) [566.937923] Starting dynamic subtest: pipe-B [570.679202] Dynamic subtest pipe-B: SUCCESS (3.767s) [570.730407] Starting dynamic subtest: pipe-C [574.633915] Dynamic subtest pipe-C: SUCCESS (3.952s) [574.690500] Starting dynamic subtest: pipe-D [578.974964] Dynamic subtest pipe-D: SUCCESS (4.333s) [578.977974] Subtest ctm-signed: SUCCESS (15.213s) [579.886603] [095/142] (433s left) gem_workarounds (reset-context) [580.341411] Starting subtest: reset-context [581.461883] Subtest reset-context: SUCCESS (1.120s) [581.618379] [096/142] (431s left) kms_flip (2x-blocking-wf_vblank) [582.018207] Starting subtest: 2x-blocking-wf_vblank [582.181365] Subtest 2x-blocking-wf_vblank: SKIP (0.162s) [582.351660] [097/142] (430s left) kms_ccs (pipe-c-missing-ccs-buffer-y_tiled_ccs) [583.377913] Starting subtest: pipe-C-missing-ccs-buffer-y_tiled_ccs [583.385091] Subtest pipe-C-missing-ccs-buffer-y_tiled_ccs: SKIP (0.000s) [584.007503] [098/142] (429s left) kms_big_fb (y-tiled-addfb-size-overflow) [584.539563] Starting subtest: y-tiled-addfb-size-overflow [584.546241] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s) [584.682792] [099/142] (428s left) gem_exercise_blt (fast-copy-emit) [585.071550] Starting subtest: fast-copy-emit [585.075203] Starting dynamic subtest: linear-smem-smem-emit [585.191505] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.118s) [585.244097] Starting dynamic subtest: xmajor-smem-smem-emit [585.304714] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.109s) [585.361726] Starting dynamic subtest: tile4-smem-smem-emit [585.416381] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.108s) [585.478544] Starting dynamic subtest: tile64-smem-smem-emit [585.575299] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.153s) [585.579679] Subtest fast-copy-emit: SUCCESS (0.506s) [585.732565] [100/142] (427s left) kms_ccs (pipe-c-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc) [587.220709] Starting subtest: pipe-C-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc [587.224471] Subtest pipe-C-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc: SUCCESS (0.003s) [588.079105] [101/142] (425s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20) [588.553602] Starting subtest: planes-downscale-factor-0-75-upscale-20x20 [588.558387] Starting dynamic subtest: pipe-A-eDP-1 [588.772452] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.214s) [588.836216] Starting dynamic subtest: pipe-B-eDP-1 [590.266093] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.482s) [590.329614] Starting dynamic subtest: pipe-C-eDP-1 [591.717880] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.438s) [591.779398] Starting dynamic subtest: pipe-D-eDP-1 [593.200658] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.474s) [593.205403] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (4.651s) [594.684953] [102/142] (419s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling) [595.159656] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling [595.172488] Starting dynamic subtest: pipe-A-default-mode [596.748217] Dynamic subtest pipe-A-default-mode: SKIP (1.575s) [596.754109] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.590s) [597.003791] [103/142] (416s left) feature_discovery (display-4x) [597.487880] Starting subtest: display-4x [597.493933] Subtest display-4x: SKIP (0.000s) [597.609948] [104/142] (416s left) kms_psr (no_drrs) [598.098793] Starting subtest: no_drrs [601.171623] Subtest no_drrs: SUCCESS (3.069s) [602.087298] [105/142] (412s left) kms_plane (plane-panning-top-left) [602.570807] Starting subtest: plane-panning-top-left [602.579801] Starting dynamic subtest: pipe-A-planes [604.946309] Dynamic subtest pipe-A-planes: SUCCESS (2.363s) [604.999907] Starting dynamic subtest: pipe-B-planes [607.971716] Dynamic subtest pipe-B-planes: SUCCESS (3.017s) [607.975261] Subtest plane-panning-top-left: SUCCESS (5.402s) [608.890451] [106/142] (405s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-render) [609.394688] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-render [625.200888] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-render: SUCCESS (15.815s) [625.465400] [107/142] (388s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling) [625.949219] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling [625.959505] Starting dynamic subtest: pipe-A-default-mode [626.364102] Dynamic subtest pipe-A-default-mode: SKIP (0.401s) [626.370953] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.415s) [627.268500] [108/142] (387s left) syncobj_wait (single-wait-all-signaled) [627.644618] Starting subtest: single-wait-all-signaled [627.648309] Subtest single-wait-all-signaled: SUCCESS (0.001s) [627.761378] [109/142] (386s left) kms_chamelium_audio (dp-audio) [628.632251] Subtest dp-audio: SKIP (0.000s) [629.512078] [110/142] (385s left) kms_vblank (pipe-a-query-busy) [629.987949] Starting subtest: pipe-A-query-busy [632.047927] Subtest pipe-A-query-busy: SUCCESS (2.061s) [632.958950] [111/142] (381s left) gem_mmap_wc (bad-offset) [633.331940] Subtest bad-offset: SKIP (0.000s) [633.441679] [112/142] (381s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu) [633.956745] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu [648.709775] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (14.758s) [648.986877] [113/142] (365s left) gem_eio (in-flight-1us) [650.525801] Starting subtest: in-flight-1us [682.738400] Subtest in-flight-1us: SUCCESS (32.216s) [684.620178] [114/142] (330s left) core_setmaster (master-drop-set-root) [688.279202] Starting subtest: master-drop-set-root [688.299899] Subtest master-drop-set-root: SUCCESS (0.022s) [688.404600] [115/142] (326s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size) [688.980275] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size [690.592144] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (1.609s) [691.472169] [116/142] (323s left) drm_fdinfo (basics) [691.841646] Starting subtest: basics [691.845499] Subtest basics: SUCCESS (0.000s) [691.958720] [117/142] (323s left) i915_pm_rpm (dpms-non-lpsp) [698.005090] Starting subtest: dpms-non-lpsp [698.013275] Subtest dpms-non-lpsp: SKIP (0.002s) [698.898943] [118/142] (316s left) kms_big_fb (yf-tiled-addfb) [699.415553] Starting subtest: yf-tiled-addfb [699.423125] Subtest yf-tiled-addfb: SKIP (0.000s) [699.557071] [119/142] (315s left) gem_exec_schedule (implicit-boths) [699.992479] Starting subtest: implicit-boths [699.996402] Starting dynamic subtest: rcs0 [700.382418] Dynamic subtest rcs0: SUCCESS (0.387s) [700.433214] Starting dynamic subtest: bcs0 [700.655419] Dynamic subtest bcs0: SUCCESS (0.269s) [700.717572] Starting dynamic subtest: vcs0 [700.931194] Dynamic subtest vcs0: SUCCESS (0.271s) [700.982167] Starting dynamic subtest: vcs1 [701.203439] Dynamic subtest vcs1: SUCCESS (0.268s) [701.257883] Starting dynamic subtest: vecs0 [701.475423] Dynamic subtest vecs0: SUCCESS (0.268s) [701.526638] Starting dynamic subtest: ccs0 [701.856315] Dynamic subtest ccs0: SUCCESS (0.378s) [701.860140] Subtest implicit-boths: SUCCESS (1.865s) [703.691507] [120/142] (311s left) kms_big_fb (linear-16bpp-rotate-0) [704.231366] Starting subtest: linear-16bpp-rotate-0 [708.742310] Subtest linear-16bpp-rotate-0: SUCCESS (4.504s) [709.144580] [121/142] (306s left) i915_pm_sseu (full-enable) [709.547230] Subtest full-enable: SKIP (0.000s) [709.650236] [122/142] (306s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s [710.091038] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size [710.096926] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s) [710.283559] [123/142] (305s left) gem_ctx_persistence (engines-hang) [710.475362] Starting subtest: engines-hang [710.478107] Starting dynamic subtest: rcs0 [710.525845] Dynamic subtest rcs0: SUCCESS (0.049s) [710.551613] Starting dynamic subtest: bcs0 [710.616213] Dynamic subtest bcs0: SUCCESS (0.089s) [710.637360] Starting dynamic subtest: vcs0 [711.511174] Dynamic subtest vcs0: FAIL (0.837s) [711.566934] Starting dynamic subtest: vcs1 [714.136701] Dynamic subtest vcs1: SUCCESS (2.676s) [714.196135] Starting dynamic subtest: vecs0 [714.199496] Dynamic subtest vecs0: SUCCESS (0.041s) [714.254776] Starting dynamic subtest: ccs0 [714.280094] Dynamic subtest ccs0: SUCCESS (0.094s) [714.284175] Subtest engines-hang: FAIL (3.806s) [714.421222] [124/142] (301s left) syncobj_timeline (invalid-multi-wait-unsubmitted) [714.793456] Starting subtest: invalid-multi-wait-unsubmitted [714.797119] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.001s) [714.904809] [125/142] (301s left) kms_content_protection (type1) [715.588923] Starting subtest: type1 [719.582950] Subtest type1: SKIP (3.984s) [721.296220] [126/142] (294s left) gen7_exec_parse (batch-without-end) [721.692302] Subtest batch-without-end: SKIP (0.000s) [721.806509] [127/142] (294s left) gem_exec_schedule (u-semaphore-noskip) [722.245052] Starting subtest: u-semaphore-noskip [723.071422] Subtest u-semaphore-noskip: SUCCESS (0.824s) [723.504310] [128/142] (292s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt) [723.999622] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt [724.006451] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [724.134511] [129/142] (292s left) syncobj_wait (wait-all-for-submit-snapshot) [724.504052] Starting subtest: wait-all-for-submit-snapshot [724.589068] Subtest wait-all-for-submit-snapshot: SUCCESS (0.085s) [724.711357] [130/142] (291s left) kms_frontbuffer_tracking (fbc-tiling-y) [725.228638] Starting subtest: fbc-tiling-y [725.235869] Subtest fbc-tiling-y: SKIP (0.000s) [725.368399] [131/142] (291s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted) [728.271665] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SKIP (0.000s) [728.390437] [132/142] (288s left) kms_sequence (get-idle) [728.892412] Starting subtest: get-idle [728.895931] Starting dynamic subtest: eDP-1-pipe-A [731.029908] Dynamic subtest eDP-1-pipe-A: SUCCESS (2.136s) [731.094387] Starting dynamic subtest: eDP-1-pipe-B [733.885250] Dynamic subtest eDP-1-pipe-B: SUCCESS (2.843s) [733.948981] Starting dynamic subtest: eDP-1-pipe-C [737.009742] Dynamic subtest eDP-1-pipe-C: SUCCESS (3.118s) [737.072675] Starting dynamic subtest: eDP-1-pipe-D [740.350483] Dynamic subtest eDP-1-pipe-D: SUCCESS (3.331s) [740.354057] Subtest get-idle: SUCCESS (11.466s) [741.276219] [133/142] (275s left) prime_self_import (basic-with_two_bos) [741.647938] Starting subtest: basic-with_two_bos [741.666961] Subtest basic-with_two_bos: SUCCESS (0.016s) [741.803645] [134/142] (275s left) kms_busy (extended-pageflip-modeset-hang-oldfb) [742.306955] Starting subtest: extended-pageflip-modeset-hang-oldfb [742.321526] Starting dynamic subtest: pipe-A [750.933226] Dynamic subtest pipe-A: SUCCESS (8.615s) [751.008681] Starting dynamic subtest: pipe-D [759.983752] Dynamic subtest pipe-D: SUCCESS (9.025s) [759.988052] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (17.676s) [760.899583] [135/142] (256s left) kms_flip (2x-flip-vs-rmfb-interruptible) [761.307339] Starting subtest: 2x-flip-vs-rmfb-interruptible [761.474500] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.163s) [761.618590] [136/142] (255s left) gem_eio (in-flight-suspend) [763.081283] Starting subtest: in-flight-suspend [807.938420] Subtest in-flight-suspend: SUCCESS (44.854s) [809.613268] [137/142] (207s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff) [810.130659] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff [810.137759] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [810.268161] [138/142] (207s left) kms_ccs (pipe-b-bad-rotation-90-yf_tiled_ccs) [811.382941] Starting subtest: pipe-B-bad-rotation-90-yf_tiled_ccs [811.390345] Subtest pipe-B-bad-rotation-90-yf_tiled_ccs: SKIP (0.000s) [812.623058] [139/142] (204s left) vc4/vc4_wait_bo (bad-bo) [813.091197] Subtest bad-bo: SKIP (0.000s) [813.189612] [140/142] (204s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt) [813.644875] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt [822.882528] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (9.243s) [823.143670] [141/142] (194s left) v3d/v3d_submit_csd (bad-multisync-in-sync) [823.621056] Subtest bad-multisync-in-sync: SKIP (0.000s) [823.719570] [142/142] (193s left) syncobj_timeline (invalid-signal-bad-pad) [824.095460] Starting subtest: invalid-signal-bad-pad [824.099596] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [824.210249] Closing watchdogs Done.