[50.071647] Initializing watchdogs [50.072453] /dev/watchdog0 [50.106871] [001/142] (960s left) kms_ccs (pipe-c-crc-primary-rotation-180-y_tiled_gen12_rc_ccs) [51.558416] Starting subtest: pipe-C-crc-primary-rotation-180-y_tiled_gen12_rc_ccs [51.564881] Subtest pipe-C-crc-primary-rotation-180-y_tiled_gen12_rc_ccs: SKIP (0.002s) [52.480646] [002/142] (958s left) gem_readwrite (read-bad-handle) [52.860826] Subtest read-bad-handle: SKIP (0.000s) [52.981694] [003/142] (957s left) kms_cursor_edge_walk (128x128-top-edge) [53.485880] Starting subtest: 128x128-top-edge [53.490465] Starting dynamic subtest: pipe-A-eDP-1 [57.662401] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.174s) [57.698082] Starting dynamic subtest: pipe-D-eDP-1 [60.990529] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.320s) [60.993884] Subtest 128x128-top-edge: SUCCESS (7.509s) [61.924224] [004/142] (948s left) kms_ccs (pipe-a-random-ccs-data-4_tiled_mtl_rc_ccs_cc) [62.880289] Starting subtest: pipe-A-random-ccs-data-4_tiled_mtl_rc_ccs_cc [64.097725] Subtest pipe-A-random-ccs-data-4_tiled_mtl_rc_ccs_cc: SUCCESS (1.217s) [65.920598] [005/142] (944s left) gem_create (create-ext-placement-sanity-check) [66.452633] Starting subtest: create-ext-placement-sanity-check [66.468624] Subtest create-ext-placement-sanity-check: SUCCESS (0.014s) [66.598712] [006/142] (944s left) kms_atomic (crtc-invalid-params) [67.400805] Starting subtest: crtc-invalid-params [67.533867] Subtest crtc-invalid-params: SUCCESS (0.132s) [68.878237] [007/142] (942s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes) [71.254462] Starting subtest: syncobj-timeline-multiple-ext-nodes [71.261492] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.008s) [71.684232] [008/142] (939s left) kms_prop_blob (invalid-get-prop) [72.066865] Starting subtest: invalid-get-prop [72.070598] Subtest invalid-get-prop: SUCCESS (0.000s) [72.209711] [009/142] (938s left) kms_ccs (pipe-d-crc-primary-basic-y_tiled_ccs) [73.871467] Starting subtest: pipe-D-crc-primary-basic-y_tiled_ccs [73.877802] Subtest pipe-D-crc-primary-basic-y_tiled_ccs: SKIP (0.002s) [74.616210] [010/142] (936s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [75.101725] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [75.109122] Starting dynamic subtest: pipe-A-default-mode [76.649931] Dynamic subtest pipe-A-default-mode: SKIP (1.536s) [76.656942] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.546s) [76.926846] [011/142] (934s left) gem_ctx_param (invalid-set-no-zeromap) [77.308720] Starting subtest: invalid-set-no-zeromap [77.312570] Subtest invalid-set-no-zeromap: SUCCESS (0.000s) [77.429559] [012/142] (933s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff) [77.938331] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff [77.945117] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [78.091887] [013/142] (933s left) kms_psr (sprite_mmap_gtt) [78.579186] Starting subtest: sprite_mmap_gtt [81.385251] Subtest sprite_mmap_gtt: SKIP (2.802s) [81.750274] [014/142] (929s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling) [82.221551] Starting subtest: planes-downscale-factor-0-5-unity-scaling [82.229142] Starting dynamic subtest: pipe-A-eDP-1 [82.268176] Dynamic subtest pipe-A-eDP-1: SKIP (0.037s) [82.302828] Starting dynamic subtest: pipe-B-eDP-1 [82.418492] Dynamic subtest pipe-B-eDP-1: SKIP (0.143s) [82.452480] Starting dynamic subtest: pipe-C-eDP-1 [82.570154] Dynamic subtest pipe-C-eDP-1: SKIP (0.145s) [82.607106] Starting dynamic subtest: pipe-D-eDP-1 [82.725393] Dynamic subtest pipe-D-eDP-1: SKIP (0.145s) [82.732283] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.500s) [82.879133] [015/142] (928s left) syncobj_wait (multi-wait-all-submitted-signaled) [83.261487] Starting subtest: multi-wait-all-submitted-signaled [83.370283] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.108s) [83.502734] [016/142] (928s left) syncobj_wait (single-wait-for-submit-unsubmitted) [83.868908] Starting subtest: single-wait-for-submit-unsubmitted [83.977929] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.108s) [84.108451] [017/142] (927s left) i915_query (engine-info-invalid) [84.481981] Starting subtest: engine-info-invalid [84.486197] Subtest engine-info-invalid: SUCCESS (0.001s) [84.610441] [018/142] (927s left) kms_chamelium_audio (dp-audio-edid) [85.500557] Subtest dp-audio-edid: SKIP (0.000s) [86.350710] [019/142] (925s left) sw_sync (sync_multi_consumer_producer) [86.713823] Starting subtest: sync_multi_consumer_producer [88.095804] Subtest sync_multi_consumer_producer: SUCCESS (1.381s) [88.211454] [020/142] (923s left) kms_big_fb (linear-16bpp-rotate-90) [88.748577] Starting subtest: linear-16bpp-rotate-90 [88.809307] Subtest linear-16bpp-rotate-90: SKIP (0.059s) [88.986173] [021/142] (923s left) kms_vblank (pipe-d-ts-continuation-modeset-hang) [89.460124] Starting subtest: pipe-D-ts-continuation-modeset-hang [105.824967] Subtest pipe-D-ts-continuation-modeset-hang: SUCCESS (16.366s) [106.757498] [022/142] (905s left) gem_mmap (basic-small-bo) [107.141854] Subtest basic-small-bo: SKIP (0.000s) [107.241509] [023/142] (904s left) kms_big_fb (yf-tiled-32bpp-rotate-180) [107.794623] Starting subtest: yf-tiled-32bpp-rotate-180 [107.801656] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s) [107.948495] [024/142] (904s left) kms_psr2_su (page_flip-nv12) [108.330736] Subtest page_flip-NV12: SKIP (0.000s) [108.434837] [025/142] (903s left) kms_addfb_basic (basic-y-tiled-legacy) [108.814957] Starting subtest: basic-y-tiled-legacy [108.821502] Subtest basic-y-tiled-legacy: SKIP (0.000s) [109.070467] [026/142] (903s left) gem_flink_basic (bad-open) [109.443437] Starting subtest: bad-open [109.446402] Subtest bad-open: SUCCESS (0.000s) [109.566917] [027/142] (902s left) kms_big_fb (x-tiled-8bpp-rotate-180) [110.101728] Starting subtest: x-tiled-8bpp-rotate-180 [113.683277] Subtest x-tiled-8bpp-rotate-180: SUCCESS (3.579s) [113.945592] [028/142] (898s left) syncobj_timeline (device-submit-unordered) [114.329147] Starting subtest: device-submit-unordered [114.332640] Subtest device-submit-unordered: SUCCESS (0.003s) [114.451974] [029/142] (898s left) gem_ctx_persistence (legacy-engines-persistence) [114.838484] Starting subtest: legacy-engines-persistence [114.841937] Starting dynamic subtest: render [115.645153] Dynamic subtest render: SUCCESS (0.804s) [115.681124] Starting dynamic subtest: bsd1 [116.407212] Dynamic subtest bsd1: SUCCESS (0.760s) [116.441676] Starting dynamic subtest: bsd2 [117.168908] Dynamic subtest bsd2: SUCCESS (0.760s) [117.201598] Starting dynamic subtest: blt [117.947175] Dynamic subtest blt: SUCCESS (0.775s) [117.981122] Starting dynamic subtest: vebox [118.709681] Dynamic subtest vebox: SUCCESS (0.761s) [118.713820] Subtest legacy-engines-persistence: SUCCESS (3.872s) [118.832235] [030/142] (893s left) gem_fenced_exec_thrash (2-spare-fences) [119.229873] Subtest 2-spare-fences: SKIP (0.000s) [119.347738] [031/142] (893s left) gem_ctx_persistence (legacy-engines-queued) [119.735895] Starting subtest: legacy-engines-queued [119.739634] Starting dynamic subtest: render [119.846765] Dynamic subtest render: SUCCESS (0.109s) [119.879590] Starting dynamic subtest: bsd1 [121.504990] Dynamic subtest bsd1: SUCCESS (1.655s) [121.541086] Starting dynamic subtest: bsd2 [123.485916] Dynamic subtest bsd2: SUCCESS (1.979s) [123.517451] Starting dynamic subtest: blt [123.588784] Dynamic subtest blt: SUCCESS (0.102s) [123.620439] Starting dynamic subtest: vebox [125.470249] Dynamic subtest vebox: SUCCESS (1.877s) [125.473337] Subtest legacy-engines-queued: SUCCESS (5.733s) [125.638840] [032/142] (887s left) gem_pxp (fail-invalid-protected-context) [128.539065] Subtest fail-invalid-protected-context: SKIP (0.000s) [128.696983] [033/142] (884s left) kms_ccs (pipe-a-bad-rotation-90-4_tiled_dg2_mc_ccs) [129.588140] Starting subtest: pipe-A-bad-rotation-90-4_tiled_dg2_mc_ccs [129.594735] Subtest pipe-A-bad-rotation-90-4_tiled_dg2_mc_ccs: SKIP (0.000s) [131.049580] [034/142] (881s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render) [131.556329] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render [131.563328] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [131.703274] [035/142] (881s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled) [132.126733] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled [132.133290] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s) [132.383056] [036/142] (880s left) sysfs_timeslice_duration (invalid) [132.777072] Starting subtest: invalid [132.781202] Starting dynamic subtest: vecs0 [132.785229] Dynamic subtest vecs0: SUCCESS (0.002s) [132.820345] Starting dynamic subtest: ccs0 [132.823344] Dynamic subtest ccs0: SUCCESS (0.002s) [132.855976] Starting dynamic subtest: vcs0 [132.859737] Dynamic subtest vcs0: SUCCESS (0.002s) [132.892903] Starting dynamic subtest: bcs0 [132.896415] Dynamic subtest bcs0: SUCCESS (0.002s) [132.927899] Starting dynamic subtest: rcs0 [132.931459] Dynamic subtest rcs0: SUCCESS (0.002s) [132.962711] Starting dynamic subtest: vcs1 [132.966168] Dynamic subtest vcs1: SUCCESS (0.002s) [132.969481] Subtest invalid: SUCCESS (0.023s) [133.017215] [037/142] (880s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite) [133.537821] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite [133.544147] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [133.694277] [038/142] (879s left) syncobj_wait (invalid-multi-wait-all-unsubmitted) [134.059842] Starting subtest: invalid-multi-wait-all-unsubmitted [134.063436] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s) [134.182290] [039/142] (879s left) kms_rmfb (close-fd) [134.651575] Starting subtest: close-fd [134.655062] Starting dynamic subtest: pipe-A-eDP-1 [135.025541] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.369s) [135.065083] Starting dynamic subtest: pipe-B-eDP-1 [136.684651] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.652s) [136.724599] Starting dynamic subtest: pipe-C-eDP-1 [138.349088] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.658s) [138.389411] Starting dynamic subtest: pipe-D-eDP-1 [140.025573] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.670s) [140.029558] Subtest close-fd: SUCCESS (5.376s) [141.516279] [040/142] (871s left) gem_mmap_offset (oob-read) [141.896391] Starting subtest: oob-read [141.899896] Subtest oob-read: SUCCESS (0.003s) [142.046860] [041/142] (871s left) kms_ccs (pipe-d-bad-aux-stride-4_tiled_mtl_rc_ccs_cc) [143.838612] Starting subtest: pipe-D-bad-aux-stride-4_tiled_mtl_rc_ccs_cc [143.846296] Subtest pipe-D-bad-aux-stride-4_tiled_mtl_rc_ccs_cc: SUCCESS (0.004s) [144.445645] [042/142] (869s left) vc4/vc4_wait_bo (used-bo) [144.937323] Subtest used-bo: SKIP (0.000s) [145.045950] [043/142] (868s left) kms_addfb_basic (addfb25-bad-modifier) [145.413120] Starting subtest: addfb25-bad-modifier [145.416482] Subtest addfb25-bad-modifier: SUCCESS (0.001s) [145.671083] [044/142] (867s left) v3d/v3d_wait_bo (unused-bo-1ns) [146.148923] Subtest unused-bo-1ns: SKIP (0.000s) [146.253373] [045/142] (867s left) kms_chamelium_frames (dp-crc-multiple) [147.136745] Subtest dp-crc-multiple: SKIP (0.000s) [147.996781] [046/142] (865s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff) [148.499564] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff [148.506127] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [148.646594] [047/142] (865s left) kms_vblank (pipe-c-query-forked-busy-hang) [149.121940] Starting subtest: pipe-C-query-forked-busy-hang [164.818140] Subtest pipe-C-query-forked-busy-hang: SUCCESS (15.696s) [165.761418] [048/142] (848s left) kms_flip (plain-flip-ts-check-interruptible) [166.178382] Starting subtest: plain-flip-ts-check-interruptible [166.210427] Starting dynamic subtest: A-eDP1 [175.647119] Dynamic subtest A-eDP1: SUCCESS (9.437s) [175.684102] Starting dynamic subtest: B-eDP1 [184.920045] Dynamic subtest B-eDP1: SUCCESS (9.269s) [184.946583] Starting dynamic subtest: C-eDP1 [194.145572] Dynamic subtest C-eDP1: SUCCESS (9.221s) [194.183693] Starting dynamic subtest: D-eDP1 [203.395370] Dynamic subtest D-eDP1: SUCCESS (9.246s) [203.422231] Subtest plain-flip-ts-check-interruptible: SUCCESS (37.244s) [204.954469] [049/142] (809s left) template (b) [205.322209] Starting subtest: B [205.326265] Subtest B: SUCCESS (0.000s) [205.451962] [050/142] (808s left) kms_vblank (pipe-a-ts-continuation-modeset-hang) [205.931888] Starting subtest: pipe-A-ts-continuation-modeset-hang [220.823957] Subtest pipe-A-ts-continuation-modeset-hang: SUCCESS (14.889s) [221.752396] [051/142] (792s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling) [222.238517] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling [222.247253] Starting dynamic subtest: pipe-A-default-mode [225.829586] Dynamic subtest pipe-A-default-mode: SUCCESS (3.582s) [225.833165] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (3.595s) [226.770844] [052/142] (787s left) debugfs_test (sysfs) [227.170478] Starting subtest: sysfs [227.992396] Subtest sysfs: SUCCESS (0.821s) [228.239921] [053/142] (786s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270) [228.725923] Starting subtest: primary-yf-tiled-reflect-x-270 [228.738248] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.007s) [228.868155] [054/142] (785s left) drm_fdinfo (virtual-idle) [229.250726] Starting subtest: virtual-idle [232.309881] Subtest virtual-idle: SUCCESS (3.053s) [232.469620] [055/142] (781s left) i915_pm_rpm (pc8-residency) [238.574141] Starting subtest: pc8-residency [238.583162] Subtest pc8-residency: SKIP (0.000s) [239.491599] [056/142] (775s left) perf (gen12-unprivileged-single-ctx-counters) [240.435349] Starting subtest: gen12-unprivileged-single-ctx-counters [240.438782] Starting dynamic subtest: rcs0 [240.716248] Dynamic subtest rcs0: SUCCESS (0.277s) [240.719753] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.282s) [240.821151] [057/142] (773s left) gem_partial_pwrite_pread (write-uncached) [241.216756] Subtest write-uncached: SKIP (0.000s) [241.353245] [058/142] (773s left) v3d/v3d_get_param (get-bad-param) [241.830368] Subtest get-bad-param: SKIP (0.000s) [241.950691] [059/142] (772s left) kms_setmode (clone-exclusive-crtc) [242.331283] Starting subtest: clone-exclusive-crtc [242.340858] Subtest clone-exclusive-crtc: SKIP (0.003s) [242.471297] [060/142] (772s left) kms_ccs (pipe-c-bad-pixel-format-4_tiled_dg2_rc_ccs) [243.821576] Starting subtest: pipe-C-bad-pixel-format-4_tiled_dg2_rc_ccs [243.828228] Subtest pipe-C-bad-pixel-format-4_tiled_dg2_rc_ccs: SKIP (0.000s) [244.854432] [061/142] (770s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180) [245.395925] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180 [248.229429] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (2.830s) [248.554284] [062/142] (766s left) gem_exec_reloc (basic-cpu) [248.950811] Subtest basic-cpu: SKIP (0.000s) [249.083905] [063/142] (766s left) gem_eio (in-flight-internal-1us) [250.540393] Starting subtest: in-flight-internal-1us [252.373700] Subtest in-flight-internal-1us: SUCCESS (1.841s) [253.607594] [064/142] (761s left) syncobj_timeline (single-wait-for-submit-available-submitted) [253.978815] Starting subtest: single-wait-for-submit-available-submitted [253.982511] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.001s) [254.115908] [065/142] (761s left) kms_cursor_crc (cursor-offscreen-512x170) [255.376237] Starting subtest: cursor-offscreen-512x170 [255.388121] Subtest cursor-offscreen-512x170: SKIP (0.007s) [255.708227] [066/142] (759s left) kms_ccs (pipe-c-ccs-on-another-bo-y_tiled_gen12_rc_ccs) [257.210223] Starting subtest: pipe-C-ccs-on-another-bo-y_tiled_gen12_rc_ccs [257.216612] Subtest pipe-C-ccs-on-another-bo-y_tiled_gen12_rc_ccs: SKIP (0.000s) [258.086722] [067/142] (757s left) gem_close (many-handles-one-vma) [258.467654] Starting subtest: many-handles-one-vma [258.622898] Subtest many-handles-one-vma: SUCCESS (0.155s) [258.799410] [068/142] (756s left) gem_exec_whisper (basic-contexts-priority) [259.221263] Starting subtest: basic-contexts-priority [296.814529] Subtest basic-contexts-priority: SUCCESS (37.587s) [297.084762] [069/142] (718s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-render) [297.594510] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-render [314.959517] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-render: SUCCESS (17.372s) [315.252749] [070/142] (700s left) kms_ccs (pipe-b-bad-rotation-90-y_tiled_gen12_rc_ccs) [316.382304] Starting subtest: pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs [316.388694] Subtest pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs: SKIP (0.000s) [317.618077] [071/142] (698s left) kms_invalid_mode (clock-too-high) [318.116250] Starting subtest: clock-too-high [318.119866] Starting dynamic subtest: eDP-1-pipe-A [318.126153] Dynamic subtest eDP-1-pipe-A: SKIP (0.001s) [318.174875] Starting dynamic subtest: eDP-1-pipe-B [318.181948] Dynamic subtest eDP-1-pipe-B: SKIP (0.001s) [318.231070] Starting dynamic subtest: eDP-1-pipe-C [318.237215] Dynamic subtest eDP-1-pipe-C: SKIP (0.001s) [318.282255] Starting dynamic subtest: eDP-1-pipe-D [318.288302] Dynamic subtest eDP-1-pipe-D: SKIP (0.001s) [318.294314] Subtest clock-too-high: SKIP (0.039s) [318.361670] [072/142] (697s left) kms_big_fb (y-tiled-32bpp-rotate-90) [318.904628] Starting subtest: y-tiled-32bpp-rotate-90 [318.911360] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s) [319.050768] [073/142] (696s left) gem_userptr_blits (userfault) [319.457455] Starting subtest: userfault [319.475921] Subtest userfault: SUCCESS (0.022s) [319.773598] [074/142] (696s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled) [320.198773] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled [320.205202] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s) [320.470122] [075/142] (695s left) gem_exec_schedule (u-submit-golden-slice) [320.919383] Starting subtest: u-submit-golden-slice [320.922824] Starting dynamic subtest: rcs0 [321.059424] Dynamic subtest rcs0: SUCCESS (0.136s) [321.108494] Starting dynamic subtest: bcs0 [321.189674] Dynamic subtest bcs0: SUCCESS (0.127s) [321.238647] Starting dynamic subtest: vcs0 [321.319925] Dynamic subtest vcs0: SUCCESS (0.126s) [321.380193] Starting dynamic subtest: vcs1 [321.390383] Dynamic subtest vcs1: SUCCESS (0.062s) [321.445970] Starting dynamic subtest: vecs0 [321.450449] Dynamic subtest vecs0: SUCCESS (0.058s) [321.498649] Starting dynamic subtest: ccs0 [321.508584] Dynamic subtest ccs0: SUCCESS (0.056s) [321.512222] Subtest u-submit-golden-slice: SUCCESS (0.591s) [322.629420] [076/142] (693s left) gem_wait (write-wait) [323.095177] Starting subtest: write-wait [323.098729] Starting dynamic subtest: all-engines [324.217938] Dynamic subtest all-engines: SUCCESS (1.125s) [324.283386] Starting dynamic subtest: rcs0 [325.301103] Dynamic subtest rcs0: SUCCESS (1.078s) [325.374453] Starting dynamic subtest: bcs0 [326.391299] Dynamic subtest bcs0: SUCCESS (1.085s) [326.460551] Starting dynamic subtest: vcs0 [327.454456] Dynamic subtest vcs0: SUCCESS (1.057s) [327.526503] Starting dynamic subtest: vcs1 [328.520466] Dynamic subtest vcs1: SUCCESS (1.062s) [328.592139] Starting dynamic subtest: vecs0 [329.586487] Dynamic subtest vecs0: SUCCESS (1.060s) [329.653931] Starting dynamic subtest: ccs0 [330.672563] Dynamic subtest ccs0: SUCCESS (1.081s) [330.676130] Subtest write-wait: SUCCESS (7.585s) [331.065576] [077/142] (685s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [331.495628] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [331.502178] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [331.666149] [078/142] (684s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_ccs) [332.843510] Starting subtest: pipe-B-crc-primary-basic-y_tiled_ccs [332.850429] Subtest pipe-B-crc-primary-basic-y_tiled_ccs: SKIP (0.002s) [334.085077] [079/142] (682s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt) [334.587917] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt [334.594136] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [334.763791] [080/142] (681s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt) [335.274915] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt [335.281979] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [335.446386] [081/142] (681s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt) [335.957298] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt [335.962761] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [336.133365] [082/142] (680s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted) [336.523136] Starting subtest: invalid-multi-wait-all-available-unsubmitted [336.526466] Subtest invalid-multi-wait-all-available-unsubmitted: SUCCESS (0.001s) [336.680811] [083/142] (680s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc) [337.192477] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc [337.198186] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.001s) [337.367224] [084/142] (679s left) gem_eio (wait-wedge-immediate) [339.025723] Starting subtest: wait-wedge-immediate [342.239317] Subtest wait-wedge-immediate: SUCCESS (3.213s) [343.657259] [085/142] (673s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_dg2_rc_ccs_cc) [344.908160] Starting subtest: pipe-B-random-ccs-data-4_tiled_dg2_rc_ccs_cc [344.916899] Subtest pipe-B-random-ccs-data-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s) [346.101955] [086/142] (670s left) vc4/vc4_purgeable_bo (mark-purgeable-twice) [346.577148] Subtest mark-purgeable-twice: SKIP (0.000s) [346.716270] [087/142] (670s left) prime_self_import (basic-with_fd_dup) [347.092980] Starting subtest: basic-with_fd_dup [347.114493] Subtest basic-with_fd_dup: SUCCESS (0.019s) [347.285537] [088/142] (669s left) api_intel_bb (intel-bb-blit-x) [347.675709] Starting subtest: intel-bb-blit-x [359.861446] Subtest intel-bb-blit-x: SUCCESS (12.185s) [360.083284] [089/142] (657s left) kms_busy (extended-pageflip-hang-newfb) [360.622785] Starting subtest: extended-pageflip-hang-newfb [360.631907] Starting dynamic subtest: pipe-A [374.889811] Dynamic subtest pipe-A: SUCCESS (14.256s) [374.951246] Starting dynamic subtest: pipe-D [389.844294] Dynamic subtest pipe-D: SUCCESS (14.931s) [389.847957] Subtest extended-pageflip-hang-newfb: SUCCESS (29.223s) [390.803197] [090/142] (626s left) gem_exec_reloc (basic-write-read-active) [391.211913] Subtest basic-write-read-active: SKIP (0.000s) [391.373888] [091/142] (626s left) i915_hangman (engine-engine-hang) [391.812868] Starting subtest: engine-engine-hang [391.816943] Starting dynamic subtest: rcs0 [393.499823] Dynamic subtest rcs0: SUCCESS (1.683s) [393.548167] Starting dynamic subtest: bcs0 [395.483281] Dynamic subtest bcs0: SUCCESS (1.980s) [395.530637] Starting dynamic subtest: vcs0 [406.181494] Dynamic subtest vcs0: FAIL (10.603s) [406.230499] Starting dynamic subtest: vcs1 [407.517202] Dynamic subtest vcs1: SUCCESS (1.421s) [407.564243] Starting dynamic subtest: vecs0 [409.499451] Dynamic subtest vecs0: SUCCESS (1.979s) [409.548320] Starting dynamic subtest: ccs0 [412.509261] Dynamic subtest ccs0: SUCCESS (3.005s) [412.513054] Subtest engine-engine-hang: FAIL (20.697s) [412.748765] [092/142] (604s left) kms_atomic_interruptible (atomic-setmode) [413.274369] Starting subtest: atomic-setmode [413.277833] Starting dynamic subtest: eDP-1-pipe-A [420.806846] Dynamic subtest eDP-1-pipe-A: SUCCESS (7.524s) [420.810343] Subtest atomic-setmode: SUCCESS (7.535s) [421.768105] [093/142] (595s left) gem_mmap_wc (write-read-distinct) [422.145591] Subtest write-read-distinct: SKIP (0.000s) [422.266570] [094/142] (595s left) gem_set_tiling_vs_blt (untiled-to-tiled) [422.672361] Subtest untiled-to-tiled: SKIP (0.000s) [422.806552] [095/142] (595s left) gem_exec_whisper (basic-sync-all) [423.236087] Starting subtest: basic-sync-all [444.694507] Subtest basic-sync-all: SUCCESS (21.452s) [445.006560] [096/142] (572s left) kms_pipe_crc_basic (read-crc) [445.462854] Starting subtest: read-crc [445.467447] Starting dynamic subtest: pipe-A-eDP-1 [446.652343] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.188s) [446.705969] Starting dynamic subtest: pipe-B-eDP-1 [448.570631] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.909s) [448.629220] Starting dynamic subtest: pipe-C-eDP-1 [450.741742] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.158s) [450.799255] Starting dynamic subtest: pipe-D-eDP-1 [453.363042] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.610s) [453.366504] Subtest read-crc: SUCCESS (7.906s) [454.318171] [097/142] (563s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move) [454.836951] Starting subtest: fbc-1p-primscrn-spr-indfb-move [461.543322] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (6.707s) [461.857243] [098/142] (556s left) gem_userptr_blits (coherency-unsync) [462.261291] Subtest coherency-unsync: SKIP (0.000s) [462.536107] [099/142] (555s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt) [463.034952] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt [478.495984] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (15.462s) [478.780956] [100/142] (539s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-cpu) [479.284260] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-cpu [489.775515] Subtest psr-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (10.499s) [490.057671] [101/142] (528s left) kms_cursor_crc (cursor-random-512x512) [491.250379] Starting subtest: cursor-random-512x512 [491.262528] Subtest cursor-random-512x512: SKIP (0.007s) [491.661071] [102/142] (526s left) i915_pm_backlight (basic-brightness) [492.160779] Starting subtest: basic-brightness [492.524058] Starting dynamic subtest: eDP-1 [493.234361] Dynamic subtest eDP-1: SUCCESS (0.711s) [493.237776] Subtest basic-brightness: SUCCESS (1.071s) [494.192461] [103/142] (524s left) gem_eio (in-flight-10ms) [496.366554] Starting subtest: in-flight-10ms [534.336685] Subtest in-flight-10ms: SUCCESS (37.967s) [535.667111] [104/142] (483s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible) [536.094576] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible [536.263552] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.165s) [536.410231] [105/142] (482s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_dg2_mc_ccs) [537.319464] Starting subtest: pipe-A-crc-primary-basic-4_tiled_dg2_mc_ccs [537.325802] Subtest pipe-A-crc-primary-basic-4_tiled_dg2_mc_ccs: SKIP (0.002s) [538.253255] [106/142] (480s left) syncobj_timeline (invalid-transfer-bad-pad) [538.640954] Starting subtest: invalid-transfer-bad-pad [538.644569] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s) [538.770262] [107/142] (480s left) kms_plane_lowres (tiling-4) [539.223280] Starting subtest: tiling-4 [539.226911] Starting dynamic subtest: pipe-A-eDP-1 [539.233414] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [539.665830] Starting dynamic subtest: pipe-B-eDP-1 [539.673169] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [539.711656] Starting dynamic subtest: pipe-C-eDP-1 [539.718858] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [539.768803] Starting dynamic subtest: pipe-D-eDP-1 [539.776246] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [539.783228] Subtest tiling-4: SKIP (0.481s) [540.576191] [108/142] (478s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt) [541.069186] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt [541.075924] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [541.246593] [109/142] (477s left) gem_eio (execbuf) [543.156595] Starting subtest: execbuf [545.962070] Subtest execbuf: SUCCESS (2.803s) [547.631369] [110/142] (471s left) dumb_buffer (create-valid-dumb) [548.010756] Starting subtest: create-valid-dumb [548.014462] Subtest create-valid-dumb: SUCCESS (0.000s) [548.182321] [111/142] (471s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt) [548.695205] Starting subtest: psr-2p-primscrn-indfb-plflip-blt [548.702094] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [548.864317] [112/142] (470s left) i915_pm_rpm (drm-resources-equal) [554.973394] Starting subtest: drm-resources-equal [564.780160] Subtest drm-resources-equal: SUCCESS (9.798s) [564.980100] [113/142] (454s left) gem_exec_endless (dispatch) [565.446777] Starting subtest: dispatch [565.450535] Starting dynamic subtest: rcs0 [565.469119] Dynamic subtest rcs0: SUCCESS (0.019s) [565.518831] Starting dynamic subtest: bcs0 [565.525456] Dynamic subtest bcs0: SUCCESS (0.017s) [565.575157] Starting dynamic subtest: vcs0 [565.582183] Dynamic subtest vcs0: SUCCESS (0.017s) [565.634280] Starting dynamic subtest: vcs1 [565.641197] Dynamic subtest vcs1: SUCCESS (0.017s) [565.689312] Starting dynamic subtest: vecs0 [565.695960] Dynamic subtest vecs0: SUCCESS (0.019s) [565.743042] Starting dynamic subtest: ccs0 [565.749596] Dynamic subtest ccs0: SUCCESS (0.019s) [565.753265] Subtest dispatch: SUCCESS (0.133s) [566.633712] [114/142] (452s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw) [567.134614] Starting subtest: fbc-1p-pri-indfb-multidraw [593.735231] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (26.602s) [594.037925] [115/142] (425s left) gem_madvise (dontneed-after-mmap) [594.403512] Starting subtest: dontneed-after-mmap [594.437922] Subtest dontneed-after-mmap: SUCCESS (0.029s) [594.627556] [116/142] (425s left) gem_exec_balancer (full) [595.059795] Starting subtest: full [604.349315] Subtest full: SUCCESS (9.290s) [605.374753] [117/142] (414s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0) [605.935884] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0 [605.943567] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s) [606.120351] [118/142] (413s left) gem_exec_params (rs-invalid) [606.529636] Starting subtest: rs-invalid [606.544574] Subtest rs-invalid: SUCCESS (0.013s) [606.729245] [119/142] (413s left) kms_vblank (pipe-c-wait-busy-hang) [607.198349] Starting subtest: pipe-C-wait-busy-hang [623.807108] Subtest pipe-C-wait-busy-hang: SUCCESS (16.608s) [624.761440] [120/142] (395s left) kms_ccs (pipe-a-missing-ccs-buffer-y_tiled_gen12_rc_ccs) [625.740871] Starting subtest: pipe-A-missing-ccs-buffer-y_tiled_gen12_rc_ccs [625.747182] Subtest pipe-A-missing-ccs-buffer-y_tiled_gen12_rc_ccs: SKIP (0.000s) [627.124629] [121/142] (393s left) kms_ccs (pipe-d-ccs-on-another-bo-y_tiled_gen12_mc_ccs) [628.869092] Starting subtest: pipe-D-ccs-on-another-bo-y_tiled_gen12_mc_ccs [628.875327] Subtest pipe-D-ccs-on-another-bo-y_tiled_gen12_mc_ccs: SKIP (0.000s) [629.529231] [122/142] (390s left) kms_plane_scaling (plane-downscale-with-modifiers-factor-0-75) [630.003332] Starting subtest: plane-downscale-with-modifiers-factor-0-75 [630.008487] Starting dynamic subtest: pipe-A-eDP-1 [632.239418] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.231s) [632.294959] Starting dynamic subtest: pipe-B-eDP-1 [635.790151] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.540s) [635.852529] Starting dynamic subtest: pipe-C-eDP-1 [639.299177] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.496s) [639.354284] Starting dynamic subtest: pipe-D-eDP-1 [642.750875] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.443s) [642.754143] Subtest plane-downscale-with-modifiers-factor-0-75: SUCCESS (12.755s) [644.320866] [123/142] (376s left) kms_chamelium_hpd (hdmi-hpd-storm) [645.224460] Subtest hdmi-hpd-storm: SKIP (0.000s) [646.105526] [124/142] (374s left) gem_workarounds (basic-read-fd) [646.557248] Starting subtest: basic-read-fd [646.601426] Subtest basic-read-fd: SUCCESS (0.044s) [646.794307] [125/142] (373s left) kms_fb_coherency (memset-crc) [647.276626] Starting subtest: memset-crc [647.280354] Starting dynamic subtest: mmap-offset-wc [648.325116] Dynamic subtest mmap-offset-wc: SUCCESS (1.044s) [648.772670] Starting dynamic subtest: mmap-offset-uc [661.205304] Dynamic subtest mmap-offset-uc: SUCCESS (12.477s) [661.533489] Subtest memset-crc: SUCCESS (14.249s) [662.506732] [126/142] (358s left) gem_lmem_swapping (verify-ccs) [662.920756] Subtest verify-ccs: SKIP (0.000s) [663.040832] [127/142] (357s left) kms_addfb_basic (addfb25-modifier-no-flag) [663.421315] Starting subtest: addfb25-modifier-no-flag [663.424282] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [663.702578] [128/142] (357s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc) [665.518062] Starting subtest: pipe-D-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc [668.648893] Subtest pipe-D-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc: SUCCESS (3.130s) [670.073413] [129/142] (350s left) syncobj_timeline (multi-wait-for-submit-available-submitted) [670.453980] Starting subtest: multi-wait-for-submit-available-submitted [670.457359] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.003s) [670.608325] [130/142] (350s left) kms_universal_plane (universal-plane-pipe-d-functional) [671.076413] Starting subtest: universal-plane-pipe-D-functional [678.647794] Subtest universal-plane-pipe-D-functional: SUCCESS (7.570s) [679.597402] [131/142] (341s left) v3d/v3d_submit_cl (simple-flush-cache) [680.072241] Subtest simple-flush-cache: SKIP (0.000s) [680.208449] [132/142] (341s left) gem_pipe_control_store_loop (reused-buffer) [680.599812] Starting subtest: reused-buffer [682.765434] Subtest reused-buffer: SUCCESS (2.164s) [682.988717] [133/142] (338s left) gem_exec_params (no-bsd) [683.393387] Starting subtest: no-bsd [683.401810] Subtest no-bsd: SUCCESS (0.005s) [684.693274] [134/142] (336s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt) [685.213835] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt [685.220622] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [685.402565] [135/142] (336s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc) [685.915576] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc [691.532231] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (5.626s) [691.812976] [136/142] (329s left) kms_sequence (get-busy) [692.292084] Starting subtest: get-busy [692.301189] Starting dynamic subtest: eDP-1-pipe-A [694.510943] Dynamic subtest eDP-1-pipe-A: SUCCESS (2.211s) [694.567598] Starting dynamic subtest: eDP-1-pipe-B [697.475849] Dynamic subtest eDP-1-pipe-B: SUCCESS (2.953s) [697.507439] Starting dynamic subtest: eDP-1-pipe-C [700.630420] Dynamic subtest eDP-1-pipe-C: SUCCESS (3.144s) [700.687428] Starting dynamic subtest: eDP-1-pipe-D [704.085977] Dynamic subtest eDP-1-pipe-D: SUCCESS (3.442s) [704.089606] Subtest get-busy: SUCCESS (11.790s) [705.073387] [137/142] (316s left) gem_exec_schedule (noreorder-corked) [705.667549] Starting subtest: noreorder-corked [705.671717] Starting dynamic subtest: rcs0 [706.827917] Dynamic subtest rcs0: SUCCESS (1.159s) [706.887768] Starting dynamic subtest: bcs0 [707.964729] Dynamic subtest bcs0: SUCCESS (1.132s) [708.022818] Starting dynamic subtest: vcs0 [709.492419] Dynamic subtest vcs0: SUCCESS (1.522s) [709.546130] Starting dynamic subtest: vcs1 [711.541069] Dynamic subtest vcs1: SUCCESS (2.044s) [711.591468] Starting dynamic subtest: vecs0 [713.523895] Dynamic subtest vecs0: SUCCESS (1.979s) [713.574815] Starting dynamic subtest: ccs0 [714.686380] Dynamic subtest ccs0: SUCCESS (1.160s) [714.689864] Subtest noreorder-corked: SUCCESS (9.022s) [715.002611] [138/142] (306s left) kms_color (gamma) [715.499848] Starting subtest: gamma [715.503440] Starting dynamic subtest: pipe-A [717.001475] Dynamic subtest pipe-A: SUCCESS (1.505s) [717.048712] Starting dynamic subtest: pipe-B [719.234943] Dynamic subtest pipe-B: SUCCESS (2.225s) [719.281226] Starting dynamic subtest: pipe-C [721.837673] Dynamic subtest pipe-C: SUCCESS (2.602s) [721.898367] Starting dynamic subtest: pipe-D [724.663339] Dynamic subtest pipe-D: SUCCESS (2.821s) [724.667600] Subtest gamma: SUCCESS (9.169s) [725.621116] [139/142] (296s left) gem_ctx_bad_destroy (invalid-default-ctx) [726.011339] Starting subtest: invalid-default-ctx [726.015107] Subtest invalid-default-ctx: SUCCESS (0.000s) [726.164312] [140/142] (295s left) gem_exec_balancer (persistence) [727.424753] Starting subtest: persistence [733.719612] Subtest persistence: SUCCESS (6.293s) [733.869588] [141/142] (288s left) kms_frontbuffer_tracking (psr-suspend) [734.391782] Starting subtest: psr-suspend [776.609329] Subtest psr-suspend: SUCCESS (42.220s) [776.860154] [142/142] (245s left) prime_busy (before-wait) [777.243153] Starting subtest: before-wait [777.273509] Starting dynamic subtest: rcs0 [777.301676] Dynamic subtest rcs0: SUCCESS (0.032s) [777.351275] Starting dynamic subtest: bcs0 [777.354612] Dynamic subtest bcs0: SUCCESS (0.047s) [777.405588] Starting dynamic subtest: vcs0 [777.408566] Dynamic subtest vcs0: SUCCESS (0.042s) [777.455846] Starting dynamic subtest: vcs1 [777.459381] Dynamic subtest vcs1: SUCCESS (0.022s) [777.510571] Starting dynamic subtest: vecs0 [777.513893] Dynamic subtest vecs0: SUCCESS (0.027s) [777.570832] Starting dynamic subtest: ccs0 [777.574509] Dynamic subtest ccs0: SUCCESS (0.031s) [777.614248] Subtest before-wait: SUCCESS (0.371s) [777.771490] Closing watchdogs Done.