[44.070540] Initializing watchdogs [44.071126] /dev/watchdog0 [44.102932] [001/141] (960s left) syncobj_timeline (multi-wait-all-available-submitted-signaled) [44.512452] Starting subtest: multi-wait-all-available-submitted-signaled [44.516483] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.004s) [44.665905] [002/141] (960s left) gem_exec_schedule (thriceslice) [45.112475] Starting subtest: thriceslice [45.115351] Starting dynamic subtest: rcs0 [45.187886] Dynamic subtest rcs0: SUCCESS (0.074s) [45.219471] Starting dynamic subtest: bcs0 [45.261758] Dynamic subtest bcs0: SUCCESS (0.074s) [45.289406] Starting dynamic subtest: vcs0 [45.306538] Dynamic subtest vcs0: SUCCESS (0.044s) [45.333888] Starting dynamic subtest: vcs1 [45.371070] Dynamic subtest vcs1: SUCCESS (0.064s) [45.397236] Starting dynamic subtest: vecs0 [45.412564] Dynamic subtest vecs0: SUCCESS (0.041s) [45.437246] Starting dynamic subtest: ccs0 [45.459962] Dynamic subtest ccs0: SUCCESS (0.047s) [45.466216] Subtest thriceslice: SUCCESS (0.347s) [46.672468] [003/141] (958s left) gem_media_fill (media-fill) [47.068196] Subtest media-fill: SKIP (0.000s) [47.243181] [004/141] (957s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5) [47.732394] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5 [47.735380] Starting dynamic subtest: pipe-A-eDP-1 [47.781969] Dynamic subtest pipe-A-eDP-1: SKIP (0.042s) [47.804746] Starting dynamic subtest: pipe-B-eDP-1 [47.916934] Dynamic subtest pipe-B-eDP-1: SKIP (0.128s) [47.939855] Starting dynamic subtest: pipe-C-eDP-1 [48.080482] Dynamic subtest pipe-C-eDP-1: SKIP (0.156s) [48.109839] Starting dynamic subtest: pipe-D-eDP-1 [48.234724] Dynamic subtest pipe-D-eDP-1: SKIP (0.146s) [48.242211] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.501s) [48.387144] [005/141] (956s left) kms_ccs (pipe-b-bad-pixel-format-y_tiled_gen12_rc_ccs_cc) [49.510714] Starting subtest: pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs_cc [49.517157] Subtest pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s) [50.798941] [006/141] (954s left) kms_addfb_basic (bad-pitch-65536) [51.172921] Starting subtest: bad-pitch-65536 [51.177101] Subtest bad-pitch-65536: SUCCESS (0.001s) [51.432419] [007/141] (953s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling) [51.915727] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling [51.923882] Starting dynamic subtest: pipe-A-default-mode [52.331427] Dynamic subtest pipe-A-default-mode: SKIP (0.401s) [52.338280] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.411s) [53.252411] [008/141] (951s left) kms_invalid_mode (uint-max-clock) [53.721212] Starting subtest: uint-max-clock [53.724804] Starting dynamic subtest: eDP-1-pipe-A [54.133898] Dynamic subtest eDP-1-pipe-A: SUCCESS (0.408s) [54.164488] Starting dynamic subtest: eDP-1-pipe-B [54.179444] Dynamic subtest eDP-1-pipe-B: SUCCESS (0.040s) [54.209731] Starting dynamic subtest: eDP-1-pipe-C [54.225447] Dynamic subtest eDP-1-pipe-C: SUCCESS (0.040s) [54.255745] Starting dynamic subtest: eDP-1-pipe-D [54.271413] Dynamic subtest eDP-1-pipe-D: SUCCESS (0.040s) [54.274917] Subtest uint-max-clock: SUCCESS (0.552s) [55.041526] [009/141] (950s left) kms_fb_coherency (memset-crc) [55.526413] Starting subtest: memset-crc [55.529962] Starting dynamic subtest: mmap-offset-wc [56.866851] Dynamic subtest mmap-offset-wc: SUCCESS (1.337s) [57.294084] Starting dynamic subtest: mmap-offset-uc [70.345766] Dynamic subtest mmap-offset-uc: SUCCESS (13.077s) [70.659562] Subtest memset-crc: SUCCESS (15.127s) [71.584927] [010/141] (933s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [72.052308] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [72.060163] Starting dynamic subtest: pipe-A-default-mode [72.466805] Dynamic subtest pipe-A-default-mode: SKIP (0.402s) [72.473086] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.413s) [73.383443] [011/141] (931s left) kms_vblank (pipe-c-wait-idle-hang) [73.867208] Starting subtest: pipe-C-wait-idle-hang [89.831934] Subtest pipe-C-wait-idle-hang: SUCCESS (15.963s) [90.762165] [012/141] (914s left) gem_exec_schedule (preempt-queue) [91.195626] Subtest preempt-queue: SKIP (0.000s) [91.598086] [013/141] (913s left) gem_set_tiling_vs_gtt [92.100753] [014/141] (913s left) gem_pxp (fail-invalid-protected-context) [94.999194] Subtest fail-invalid-protected-context: SKIP (0.000s) [95.152497] [015/141] (910s left) drm_fdinfo (all-busy-idle-check-all) [95.542956] Starting subtest: all-busy-idle-check-all [95.555797] Subtest all-busy-idle-check-all: SKIP (0.014s) [95.705104] [016/141] (909s left) gem_exec_params (secure-non-master) [96.134074] Starting subtest: secure-non-master [96.141187] Subtest secure-non-master: SKIP (0.000s) [96.320208] [017/141] (909s left) kms_addfb_basic (bad-pitch-63) [96.686173] Starting subtest: bad-pitch-63 [96.689460] Subtest bad-pitch-63: SUCCESS (0.000s) [96.958701] [018/141] (908s left) kms_flip (blocking-wf_vblank) [97.350092] Starting subtest: blocking-wf_vblank [97.375515] Starting dynamic subtest: A-eDP1 [106.881380] Dynamic subtest A-eDP1: SUCCESS (9.505s) [106.911317] Starting dynamic subtest: B-eDP1 [116.042966] Dynamic subtest B-eDP1: SUCCESS (9.161s) [116.068141] Starting dynamic subtest: C-eDP1 [125.370275] Dynamic subtest C-eDP1: SUCCESS (9.326s) [125.397233] Starting dynamic subtest: D-eDP1 [134.709160] Dynamic subtest D-eDP1: SUCCESS (9.337s) [134.734150] Subtest blocking-wf_vblank: SUCCESS (37.389s) [136.300760] [019/141] (869s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff) [136.809622] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff [136.816335] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [136.959421] [020/141] (868s left) drm_read (short-buffer-nonblock) [137.760737] Starting subtest: short-buffer-nonblock [137.764501] Subtest short-buffer-nonblock: SUCCESS (0.000s) [137.979465] [021/141] (867s left) kms_vblank (pipe-c-query-forked-hang) [138.451373] Starting subtest: pipe-C-query-forked-hang [154.873066] Subtest pipe-C-query-forked-hang: SUCCESS (16.423s) [155.805869] [022/141] (850s left) kms_cursor_crc (cursor-offscreen-64x64) [156.537211] Starting subtest: cursor-offscreen-64x64 [156.569810] Starting dynamic subtest: pipe-A-eDP-1 [159.314149] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.743s) [159.496790] Starting dynamic subtest: pipe-D-eDP-1 [163.352951] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.882s) [163.356514] Subtest cursor-offscreen-64x64: SUCCESS (6.814s) [164.586678] [023/141] (841s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt) [165.090764] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt [165.097180] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [165.240337] [024/141] (840s left) kms_frontbuffer_tracking (fbcpsr-slowdraw) [165.742054] Starting subtest: fbcpsr-slowdraw [199.397359] Subtest fbcpsr-slowdraw: SUCCESS (33.657s) [199.642669] [025/141] (806s left) kms_content_protection (type1) [200.343845] Starting subtest: type1 [204.600788] Subtest type1: SKIP (4.257s) [206.111627] [026/141] (800s left) kms_hdr (bpc-switch-suspend) [206.576797] Starting subtest: bpc-switch-suspend [207.792633] Starting dynamic subtest: pipe-A-eDP-1 [229.351634] Dynamic subtest pipe-A-eDP-1: SUCCESS (21.563s) [229.355299] Subtest bpc-switch-suspend: SUCCESS (22.777s) [229.556783] [027/141] (776s left) gem_cs_tlb (engines) [229.933379] Starting subtest: engines [229.936995] Starting dynamic subtest: rcs0 [232.107159] Dynamic subtest rcs0: SUCCESS (2.168s) [232.146420] Starting dynamic subtest: bcs0 [234.280310] Dynamic subtest bcs0: SUCCESS (2.171s) [234.318551] Starting dynamic subtest: vcs0 [236.452445] Dynamic subtest vcs0: SUCCESS (2.169s) [236.488509] Starting dynamic subtest: vcs1 [238.623081] Dynamic subtest vcs1: SUCCESS (2.168s) [238.660796] Starting dynamic subtest: vecs0 [240.790416] Dynamic subtest vecs0: SUCCESS (2.165s) [240.829381] Starting dynamic subtest: ccs0 [242.963776] Dynamic subtest ccs0: SUCCESS (2.171s) [242.968058] Subtest engines: SUCCESS (13.025s) [243.161404] [028/141] (763s left) gem_exec_balancer (nop) [243.592237] Starting subtest: nop [301.862444] Subtest nop: SUCCESS (58.269s) [302.858223] [029/141] (703s left) feature_discovery (chamelium) [303.351720] Starting subtest: chamelium [303.358614] Subtest chamelium: SKIP (0.001s) [303.489281] [030/141] (703s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt) [303.991421] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt [303.997382] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [304.143085] [031/141] (702s left) gen7_exec_parse (batch-without-end) [304.530794] Subtest batch-without-end: SKIP (0.000s) [304.644679] [032/141] (702s left) gem_exec_whisper (basic-contexts-priority) [305.064304] Starting subtest: basic-contexts-priority [342.020985] Subtest basic-contexts-priority: SUCCESS (36.953s) [342.298169] [033/141] (664s left) i915_pm_lpsp (screens-disabled) [343.807192] Starting subtest: screens-disabled [343.812815] Subtest screens-disabled: SKIP (0.000s) [343.944145] [034/141] (663s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu) [344.445264] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu [352.581694] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (8.141s) [352.834806] [035/141] (654s left) prime_vgem (basic-read) [353.328950] Starting subtest: basic-read [353.387683] Subtest basic-read: SKIP (0.056s) [353.565792] [036/141] (653s left) gem_render_linear_blits (basic) [353.975933] Starting subtest: basic [354.122776] Subtest basic: SUCCESS (0.155s) [354.296492] [037/141] (652s left) gem_exec_schedule (fairslice-all) [354.696896] Starting subtest: fairslice-all [356.907896] Subtest fairslice-all: SUCCESS (2.214s) [358.644051] [038/141] (648s left) sw_sync (sync_busy_fork_unixsocket) [359.020952] Starting subtest: sync_busy_fork_unixsocket [359.087699] Subtest sync_busy_fork_unixsocket: SUCCESS (0.067s) [359.253056] [039/141] (648s left) kms_chamelium_edid (hdmi-mode-timings) [360.129454] Subtest hdmi-mode-timings: SKIP (0.000s) [360.992548] [040/141] (646s left) v3d/v3d_submit_csd (bad-multisync-pad) [361.469674] Subtest bad-multisync-pad: SKIP (0.000s) [361.605906] [041/141] (645s left) kms_vrr (flip-basic) [362.089781] Starting subtest: flip-basic [362.096922] Subtest flip-basic: SKIP (0.000s) [362.236573] [042/141] (645s left) kms_flip (flip-vs-dpms-off-vs-modeset) [362.638914] Starting subtest: flip-vs-dpms-off-vs-modeset [362.666111] Starting dynamic subtest: A-eDP1 [367.159818] Dynamic subtest A-eDP1: SUCCESS (4.489s) [367.201971] Starting dynamic subtest: B-eDP1 [370.724149] Dynamic subtest B-eDP1: SUCCESS (3.565s) [370.747372] Starting dynamic subtest: C-eDP1 [374.264861] Dynamic subtest C-eDP1: SUCCESS (3.533s) [374.301310] Starting dynamic subtest: D-eDP1 [377.732731] Dynamic subtest D-eDP1: SUCCESS (3.466s) [377.742916] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (15.104s) [378.684753] [043/141] (629s left) kms_chamelium_audio (dp-audio-edid) [379.578524] Subtest dp-audio-edid: SKIP (0.000s) [380.443307] [044/141] (627s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs) [380.853281] Starting subtest: mixed-tiled-to-y-tiled-ccs [380.859651] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s) [381.129392] [045/141] (626s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy) [381.694191] Starting subtest: 2x-flip-vs-cursor-legacy [381.710741] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.016s) [382.051423] [046/141] (625s left) gem_exec_reloc (basic-gtt-read-active) [382.448263] Subtest basic-gtt-read-active: SKIP (0.000s) [382.584753] [047/141] (625s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc) [383.081560] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc [400.236281] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (17.161s) [400.539786] [048/141] (607s left) gem_wait (invalid-flags) [400.934156] Starting subtest: invalid-flags [400.937501] Subtest invalid-flags: SUCCESS (0.000s) [401.341510] [049/141] (606s left) kms_vblank (pipe-c-wait-idle) [401.744599] Starting subtest: pipe-C-wait-idle [404.913105] Subtest pipe-C-wait-idle: SUCCESS (3.170s) [405.854794] [050/141] (602s left) kms_color (ctm-signed) [406.322798] Starting subtest: ctm-signed [406.326065] Starting dynamic subtest: pipe-A [409.404450] Dynamic subtest pipe-A: SUCCESS (3.078s) [409.448498] Starting dynamic subtest: pipe-B [413.200871] Dynamic subtest pipe-B: SUCCESS (3.796s) [413.239583] Starting dynamic subtest: pipe-C [417.063399] Dynamic subtest pipe-C: SUCCESS (3.854s) [417.106383] Starting dynamic subtest: pipe-D [420.716520] Dynamic subtest pipe-D: SUCCESS (3.652s) [420.719906] Subtest ctm-signed: SUCCESS (14.395s) [421.672655] [051/141] (586s left) gem_caching (reads) [422.073250] Subtest reads: SKIP (0.000s) [422.202774] [052/141] (586s left) vc4/vc4_label_bo (set-bad-handle) [422.660271] Subtest set-bad-handle: SKIP (0.000s) [422.779935] [053/141] (585s left) kms_big_fb (linear-16bpp-rotate-0) [423.321566] Starting subtest: linear-16bpp-rotate-0 [427.768409] Subtest linear-16bpp-rotate-0: SUCCESS (4.446s) [428.281926] [054/141] (580s left) gem_create (create-ext-set-pat) [428.807987] Starting subtest: create-ext-set-pat [428.811752] Subtest create-ext-set-pat: SUCCESS (0.002s) [428.975092] [055/141] (579s left) kms_big_fb (linear-8bpp-rotate-90) [429.504765] Starting subtest: linear-8bpp-rotate-90 [429.569244] Subtest linear-8bpp-rotate-90: SKIP (0.056s) [429.750265] [056/141] (579s left) kms_universal_plane (disable-primary-vs-flip-pipe-c) [430.227699] Starting subtest: disable-primary-vs-flip-pipe-C [433.584777] Subtest disable-primary-vs-flip-pipe-C: SUCCESS (3.360s) [434.524186] [057/141] (574s left) kms_atomic (atomic_plane_damage) [435.332926] Starting subtest: atomic_plane_damage [436.224987] Subtest atomic_plane_damage: SUCCESS (0.899s) [437.556283] [058/141] (571s left) gem_flink_race (flink_close) [437.924443] Starting subtest: flink_close [442.998721] Subtest flink_close: SUCCESS (5.071s) [443.158061] [059/141] (565s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [443.654039] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu [458.212541] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (14.562s) [458.467263] [060/141] (550s left) kms_atomic_transition (plane-all-transition-nonblocking) [458.946775] Starting subtest: plane-all-transition-nonblocking [458.950540] Starting dynamic subtest: pipe-A-eDP-1 [463.599596] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.649s) [464.111292] Starting dynamic subtest: pipe-B-eDP-1 [469.433201] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.361s) [469.848912] Subtest plane-all-transition-nonblocking: SUCCESS (10.904s) [470.800054] [061/141] (538s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc) [471.319992] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc [481.430996] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (10.117s) [481.724916] [062/141] (527s left) gem_exec_fence (syncobj-backward-timeline-chain-engines) [483.916339] Starting subtest: syncobj-backward-timeline-chain-engines [484.267700] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.350s) [484.683512] [063/141] (524s left) syncobj_wait (multi-wait-all-for-submit-signaled) [485.070855] Starting subtest: multi-wait-all-for-submit-signaled [485.074524] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.002s) [485.256824] [064/141] (524s left) gem_lmem_swapping (parallel-random) [485.660921] Subtest parallel-random: SKIP (0.000s) [485.792487] [065/141] (523s left) kms_ccs (pipe-c-crc-primary-basic-y_tiled_gen12_rc_ccs_cc) [487.220179] Starting subtest: pipe-C-crc-primary-basic-y_tiled_gen12_rc_ccs_cc [487.226719] Subtest pipe-C-crc-primary-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.003s) [488.214254] [066/141] (521s left) kms_big_fb (y-tiled-16bpp-rotate-0) [488.762418] Starting subtest: y-tiled-16bpp-rotate-0 [488.769164] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s) [488.919725] [067/141] (520s left) kms_big_fb (4-tiled-64bpp-rotate-180) [489.465413] Starting subtest: 4-tiled-64bpp-rotate-180 [496.019396] Subtest 4-tiled-64bpp-rotate-180: FAIL (5.769s) [496.245628] [068/141] (513s left) kms_psr2_su (page_flip-nv12) [496.619274] Subtest page_flip-NV12: SKIP (0.000s) [496.742308] [069/141] (513s left) sysfs_heartbeat_interval (nopreempt) [497.142454] Starting subtest: nopreempt [497.154776] Starting dynamic subtest: vecs0 [498.612256] Dynamic subtest vecs0: FAIL (1.385s) [498.649777] Starting dynamic subtest: ccs0 [500.649516] Dynamic subtest ccs0: FAIL (2.018s) [500.687655] Starting dynamic subtest: vcs0 [502.645975] Dynamic subtest vcs0: FAIL (1.974s) [502.709554] Starting dynamic subtest: bcs0 [504.010773] Dynamic subtest bcs0: FAIL (1.354s) [504.057449] Starting dynamic subtest: rcs0 [504.787259] Dynamic subtest rcs0: FAIL (0.796s) [504.825494] Starting dynamic subtest: vcs1 [506.617873] Dynamic subtest vcs1: FAIL (1.818s) [506.621356] Subtest nopreempt: FAIL (9.375s) [506.693985] [070/141] (503s left) gem_mmap_wc (set-cache-level) [507.076294] Subtest set-cache-level: SKIP (0.000s) [507.211457] [071/141] (502s left) kms_rotation_crc (primary-rotation-270) [507.700219] Starting subtest: primary-rotation-270 [507.706329] Subtest primary-rotation-270: SKIP (0.006s) [507.862747] [072/141] (502s left) kms_getfb (getfb-reject-ccs) [508.241542] Starting subtest: getfb-reject-ccs [508.245738] Subtest getfb-reject-ccs: SUCCESS (0.002s) [508.413812] [073/141] (501s left) kms_ccs (pipe-b-bad-rotation-90-yf_tiled_ccs) [509.534587] Starting subtest: pipe-B-bad-rotation-90-yf_tiled_ccs [509.541512] Subtest pipe-B-bad-rotation-90-yf_tiled_ccs: SKIP (0.000s) [510.458773] [074/141] (499s left) kms_psr2_sf (overlay-primary-update-sf-dmg-area) [517.304584] Starting subtest: overlay-primary-update-sf-dmg-area [517.316544] Starting dynamic subtest: pipe-A-eDP-1 [525.615195] Dynamic subtest pipe-A-eDP-1: SUCCESS (8.305s) [525.662980] Starting dynamic subtest: pipe-B-eDP-1 [533.866396] Dynamic subtest pipe-B-eDP-1: SUCCESS (8.241s) [533.869840] Subtest overlay-primary-update-sf-dmg-area: SUCCESS (16.568s) [534.823141] [075/141] (475s left) syncobj_timeline (single-wait-all-available-submitted) [535.200451] Starting subtest: single-wait-all-available-submitted [535.203993] Subtest single-wait-all-available-submitted: SUCCESS (0.001s) [535.356257] [076/141] (475s left) kms_ccs (pipe-d-random-ccs-data-4_tiled_dg2_mc_ccs) [537.060093] Starting subtest: pipe-D-random-ccs-data-4_tiled_dg2_mc_ccs [537.069733] Subtest pipe-D-random-ccs-data-4_tiled_dg2_mc_ccs: SKIP (0.000s) [537.768349] [077/141] (472s left) perf_pmu (most-busy-idle-check-all) [538.170163] Starting subtest: most-busy-idle-check-all [538.173536] Starting dynamic subtest: rcs0 [539.498403] Dynamic subtest rcs0: SUCCESS (1.325s) [539.548953] Starting dynamic subtest: bcs0 [541.482352] Dynamic subtest bcs0: SUCCESS (1.980s) [541.545943] Starting dynamic subtest: vcs0 [543.529939] Dynamic subtest vcs0: SUCCESS (2.042s) [543.581857] Starting dynamic subtest: vcs1 [545.514951] Dynamic subtest vcs1: SUCCESS (1.980s) [545.572599] Starting dynamic subtest: vecs0 [547.498541] Dynamic subtest vecs0: SUCCESS (1.978s) [547.557769] Starting dynamic subtest: ccs0 [549.483194] Dynamic subtest ccs0: SUCCESS (1.978s) [549.487204] Subtest most-busy-idle-check-all: SUCCESS (11.313s) [549.675830] [078/141] (461s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [550.238437] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip [555.438964] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: FAIL (4.394s) [555.514650] [079/141] (455s left) kms_ccs (pipe-a-ccs-on-another-bo-y_tiled_ccs) [556.535147] Starting subtest: pipe-A-ccs-on-another-bo-y_tiled_ccs [556.541724] Subtest pipe-A-ccs-on-another-bo-y_tiled_ccs: SKIP (0.000s) [557.921736] [080/141] (453s left) kms_concurrent (pipe-b) [558.394467] Starting subtest: pipe-B [558.399257] Starting dynamic subtest: eDP-1 [560.542275] Dynamic subtest eDP-1: SUCCESS (2.142s) [560.545796] Subtest pipe-B: SUCCESS (2.154s) [561.504848] [081/141] (449s left) prime_vgem (basic-gtt) [561.920450] Starting subtest: basic-gtt [561.928399] Subtest basic-gtt: SKIP (0.000s) [562.105246] [082/141] (449s left) kms_lease (page_flip_implicit_plane) [562.582177] Starting subtest: page_flip_implicit_plane [562.591681] Starting dynamic subtest: pipe-A-eDP-1 [563.298439] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.706s) [563.356206] Starting dynamic subtest: pipe-B-eDP-1 [564.694935] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.387s) [564.749443] Starting dynamic subtest: pipe-C-eDP-1 [566.350322] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.648s) [566.412646] Starting dynamic subtest: pipe-D-eDP-1 [568.542381] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.178s) [568.545850] Subtest page_flip_implicit_plane: SUCCESS (5.960s) [569.500076] [083/141] (441s left) v3d/v3d_perfmon (create-perfmon-0) [569.977849] Subtest create-perfmon-0: SKIP (0.000s) [570.109397] [084/141] (441s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size) [570.692605] Starting subtest: basic-busy-flip-before-cursor-varying-size [570.699717] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s) [571.029320] [085/141] (440s left) core_auth (many-magics) [571.409165] Starting subtest: many-magics [574.289196] Subtest many-magics: SUCCESS (2.882s) [574.808523] [086/141] (436s left) gem_ctx_persistence (engines-queued) [575.222286] Starting subtest: engines-queued [575.227595] Starting dynamic subtest: rcs0 [575.313394] Dynamic subtest rcs0: SUCCESS (0.095s) [575.369089] Starting dynamic subtest: bcs0 [575.437747] Dynamic subtest bcs0: SUCCESS (0.120s) [575.490142] Starting dynamic subtest: vcs0 [576.495885] Dynamic subtest vcs0: SUCCESS (1.053s) [576.542862] Starting dynamic subtest: vcs1 [578.477631] Dynamic subtest vcs1: SUCCESS (1.977s) [578.528576] Starting dynamic subtest: vecs0 [580.526929] Dynamic subtest vecs0: SUCCESS (2.044s) [580.573736] Starting dynamic subtest: ccs0 [582.541624] Dynamic subtest ccs0: SUCCESS (2.012s) [582.545357] Subtest engines-queued: SUCCESS (7.326s) [582.728736] [087/141] (428s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_mtl_rc_ccs) [583.904196] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_mtl_rc_ccs [585.214182] Subtest pipe-B-crc-primary-rotation-180-4_tiled_mtl_rc_ccs: SUCCESS (1.310s) [586.889414] [088/141] (424s left) kms_frontbuffer_tracking (psr-modesetfrombusy) [587.401894] Starting subtest: psr-modesetfrombusy [595.216763] Subtest psr-modesetfrombusy: SUCCESS (7.820s) [595.495732] [089/141] (416s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw) [596.000421] Starting subtest: fbcpsr-2p-pri-indfb-multidraw [596.006730] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s) [596.177074] [090/141] (415s left) gem_mmap_offset (basic-uaf) [596.543263] Starting subtest: basic-uaf [596.552787] Subtest basic-uaf: SUCCESS (0.009s) [596.724413] [091/141] (415s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt) [597.224150] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt [597.230899] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [597.401154] [092/141] (414s left) kms_ccs (pipe-c-random-ccs-data-y_tiled_gen12_rc_ccs) [598.843357] Starting subtest: pipe-C-random-ccs-data-y_tiled_gen12_rc_ccs [598.853240] Subtest pipe-C-random-ccs-data-y_tiled_gen12_rc_ccs: SKIP (0.000s) [599.771623] [093/141] (412s left) kms_sequence (get-forked) [600.253477] Starting subtest: get-forked [600.257815] Starting dynamic subtest: eDP-1-pipe-A [602.786343] Dynamic subtest eDP-1-pipe-A: SUCCESS (2.525s) [602.841225] Starting dynamic subtest: eDP-1-pipe-B [606.052549] Dynamic subtest eDP-1-pipe-B: SUCCESS (3.255s) [606.107916] Starting dynamic subtest: eDP-1-pipe-C [609.660894] Dynamic subtest eDP-1-pipe-C: SUCCESS (3.601s) [609.713561] Starting dynamic subtest: eDP-1-pipe-D [613.434168] Dynamic subtest eDP-1-pipe-D: SUCCESS (3.765s) [613.437656] Subtest get-forked: SUCCESS (13.184s) [614.387089] [094/141] (397s left) i915_pm_rpm (modeset-non-lpsp-stress) [616.708044] Starting subtest: modeset-non-lpsp-stress [620.464328] Subtest modeset-non-lpsp-stress: SKIP (3.757s) [621.409095] [095/141] (390s left) gem_close (many-handles-one-vma) [621.803710] Starting subtest: many-handles-one-vma [621.960230] Subtest many-handles-one-vma: SUCCESS (0.155s) [622.143902] [096/141] (390s left) gem_exec_reloc (basic-write-wc-noreloc) [622.544133] Subtest basic-write-wc-noreloc: SKIP (0.000s) [622.689161] [097/141] (389s left) kms_vblank (pipe-d-query-busy) [623.169380] Starting subtest: pipe-D-query-busy [627.222396] Subtest pipe-D-query-busy: SUCCESS (4.055s) [628.180449] [098/141] (384s left) vc4/vc4_perfmon (destroy-valid-perfmon) [628.607270] Subtest destroy-valid-perfmon: SKIP (0.000s) [628.750307] [099/141] (383s left) vgem_slow (nohang) [629.118312] Starting subtest: nohang [639.212846] Subtest nohang: SUCCESS (10.094s) [639.336961] [100/141] (373s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc) [641.158139] Starting subtest: pipe-D-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc [644.219579] Subtest pipe-D-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc: SUCCESS (3.061s) [645.651998] [101/141] (367s left) kms_psr (cursor_render) [646.134355] Starting subtest: cursor_render [649.324938] Subtest cursor_render: SUCCESS (3.185s) [650.240944] [102/141] (362s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt) [650.750253] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt [650.757549] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [650.927284] [103/141] (362s left) kms_plane_scaling (planes-downscale-factor-0-25-unity-scaling) [651.400779] Starting subtest: planes-downscale-factor-0-25-unity-scaling [651.410045] Starting dynamic subtest: pipe-A-eDP-1 [651.479883] Dynamic subtest pipe-A-eDP-1: SKIP (0.067s) [651.526167] Starting dynamic subtest: pipe-B-eDP-1 [651.652087] Dynamic subtest pipe-B-eDP-1: SKIP (0.161s) [651.712805] Starting dynamic subtest: pipe-C-eDP-1 [651.848984] Dynamic subtest pipe-C-eDP-1: SKIP (0.183s) [651.899870] Starting dynamic subtest: pipe-D-eDP-1 [652.041584] Dynamic subtest pipe-D-eDP-1: SKIP (0.181s) [652.048402] Subtest planes-downscale-factor-0-25-unity-scaling: SKIP (0.634s) [652.221955] [104/141] (360s left) i915_query (query-topology-known-pci-ids) [652.590072] Starting subtest: query-topology-known-pci-ids [652.596981] Subtest query-topology-known-pci-ids: SKIP (0.000s) [652.742134] [105/141] (360s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip) [653.273382] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip [653.280318] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [653.457127] [106/141] (359s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt) [653.982911] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt [653.989896] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [654.158098] [107/141] (359s left) syncobj_timeline (etime-single-wait-all-submitted) [654.529848] Starting subtest: etime-single-wait-all-submitted [654.632987] Subtest etime-single-wait-all-submitted: SUCCESS (0.104s) [654.788452] [108/141] (358s left) gem_exec_fence (concurrent) [655.379234] Starting subtest: concurrent [655.385268] Subtest concurrent: SKIP (0.000s) [657.726151] [109/141] (355s left) kms_ccs (pipe-d-bad-pixel-format-y_tiled_gen12_rc_ccs_cc) [659.317346] Starting subtest: pipe-D-bad-pixel-format-y_tiled_gen12_rc_ccs_cc [659.324150] Subtest pipe-D-bad-pixel-format-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s) [660.117525] [110/141] (353s left) gem_exec_balancer (bonded-chain) [660.543797] Starting subtest: bonded-chain [671.733631] Subtest bonded-chain: SUCCESS (11.189s) [672.753806] [111/141] (341s left) kms_ccs (pipe-c-bad-aux-stride-y_tiled_gen12_rc_ccs_cc) [674.295364] Starting subtest: pipe-C-bad-aux-stride-y_tiled_gen12_rc_ccs_cc [674.302050] Subtest pipe-C-bad-aux-stride-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s) [675.148998] [112/141] (338s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt) [675.662825] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt [675.669709] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [675.845879] [113/141] (338s left) kms_flip (2x-plain-flip-ts-check) [676.239507] Starting subtest: 2x-plain-flip-ts-check [676.404925] Subtest 2x-plain-flip-ts-check: SKIP (0.162s) [676.609142] [114/141] (337s left) gem_userptr_blits (stress-purge) [677.055735] Starting subtest: stress-purge [682.547571] Subtest stress-purge: SUCCESS (5.490s) [682.836624] [115/141] (331s left) perf_pmu (busy-hang) [683.399634] Starting subtest: busy-hang [683.403944] Starting dynamic subtest: rcs0 [685.693199] Dynamic subtest rcs0: SUCCESS (2.291s) [685.752831] Starting dynamic subtest: bcs0 [687.878333] Dynamic subtest bcs0: SUCCESS (2.181s) [687.935934] Starting dynamic subtest: vcs0 [690.028174] Dynamic subtest vcs0: SUCCESS (2.146s) [690.088400] Starting dynamic subtest: vcs1 [693.996815] Dynamic subtest vcs1: SUCCESS (3.964s) [694.050584] Starting dynamic subtest: vecs0 [698.025920] Dynamic subtest vecs0: SUCCESS (4.025s) [698.077665] Starting dynamic subtest: ccs0 [700.130143] Dynamic subtest ccs0: SUCCESS (2.101s) [700.133740] Subtest busy-hang: SUCCESS (16.733s) [700.329313] [116/141] (313s left) kms_vblank (pipe-b-ts-continuation-modeset-hang) [700.821158] Starting subtest: pipe-B-ts-continuation-modeset-hang [716.722518] Subtest pipe-B-ts-continuation-modeset-hang: SUCCESS (15.907s) [717.670521] [117/141] (296s left) i915_pm_dc (dc5-dpms-negative) [719.200685] Starting subtest: dc5-dpms-negative [719.207755] Subtest dc5-dpms-negative: SKIP (0.000s) [719.366365] [118/141] (295s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled) [719.756104] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [719.759805] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.004s) [719.920816] [119/141] (294s left) kms_ccs (pipe-a-crc-primary-rotation-180-y_tiled_gen12_mc_ccs) [720.753938] Starting subtest: pipe-A-crc-primary-rotation-180-y_tiled_gen12_mc_ccs [720.761634] Subtest pipe-A-crc-primary-rotation-180-y_tiled_gen12_mc_ccs: SKIP (0.001s) [721.722703] [120/141] (292s left) gem_exec_flush (basic-uc-set-default) [722.159159] Starting subtest: basic-uc-set-default [728.024152] Subtest basic-uc-set-default: SUCCESS (5.868s) [728.310531] [121/141] (286s left) api_intel_bb (destroy-bb) [728.696714] Starting subtest: destroy-bb [728.736936] Subtest destroy-bb: SUCCESS (0.045s) [728.976862] [122/141] (285s left) gem_ctx_persistence (legacy-engines-queued) [729.375801] Starting subtest: legacy-engines-queued [729.385391] Starting dynamic subtest: render [729.489819] Dynamic subtest render: SUCCESS (0.110s) [729.550567] Starting dynamic subtest: bsd1 [731.502757] Dynamic subtest bsd1: SUCCESS (2.006s) [731.557646] Starting dynamic subtest: bsd2 [733.485866] Dynamic subtest bsd2: SUCCESS (1.978s) [733.549704] Starting dynamic subtest: blt [733.583460] Dynamic subtest blt: SUCCESS (0.092s) [733.643275] Starting dynamic subtest: vebox [735.534106] Dynamic subtest vebox: SUCCESS (1.943s) [735.537816] Subtest legacy-engines-queued: SUCCESS (6.159s) [735.754133] [123/141] (279s left) syncobj_wait (invalid-multi-wait-all-unsubmitted) [736.142459] Starting subtest: invalid-multi-wait-all-unsubmitted [736.146592] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.001s) [736.333641] [124/141] (278s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc) [736.853793] Starting subtest: fbc-rgb565-draw-mmap-wc [749.523501] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (12.674s) [749.823058] [125/141] (265s left) kms_flip (2x-dpms-vs-vblank-race-interruptible) [750.237315] Starting subtest: 2x-dpms-vs-vblank-race-interruptible [750.401187] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.160s) [750.582799] [126/141] (264s left) kms_ccs (pipe-c-bad-rotation-90-4_tiled_dg2_rc_ccs_cc) [751.919273] Starting subtest: pipe-C-bad-rotation-90-4_tiled_dg2_rc_ccs_cc [751.925530] Subtest pipe-C-bad-rotation-90-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s) [752.899856] [127/141] (262s left) gem_mmap_gtt (big-copy-xy) [753.281303] Subtest big-copy-XY: SKIP (0.000s) [753.406980] [128/141] (262s left) i915_hangman (engine-error-state-capture) [753.788216] Starting subtest: engine-error-state-capture [753.791906] Starting dynamic subtest: rcs0 [757.483676] Dynamic subtest rcs0: SUCCESS (3.693s) [757.537404] Starting dynamic subtest: bcs0 [763.499809] Dynamic subtest bcs0: SUCCESS (6.012s) [763.520880] Starting dynamic subtest: vcs0 [769.515583] Dynamic subtest vcs0: SUCCESS (6.011s) [769.572054] Starting dynamic subtest: vcs1 [775.532940] Dynamic subtest vcs1: SUCCESS (6.012s) [775.585591] Starting dynamic subtest: vecs0 [781.483277] Dynamic subtest vecs0: SUCCESS (5.947s) [781.532921] Starting dynamic subtest: ccs0 [788.523945] Dynamic subtest ccs0: SUCCESS (7.036s) [788.527768] Subtest engine-error-state-capture: SUCCESS (34.737s) [788.751245] [129/141] (226s left) device_reset (unbind-reset-rebind) [789.565501] Starting subtest: unbind-reset-rebind [794.073445] Subtest unbind-reset-rebind: SUCCESS (4.509s) [794.214734] [130/141] (221s left) kms_plane_alpha_blend (constant-alpha-min) [794.721279] Starting subtest: constant-alpha-min [796.497890] Starting dynamic subtest: pipe-A-eDP-1 [798.065911] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.567s) [798.121290] Starting dynamic subtest: pipe-D-eDP-1 [800.480300] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.401s) [800.483826] Subtest constant-alpha-min: SUCCESS (5.762s) [801.448790] [131/141] (214s left) i915_pm_rps (min-max-config-loaded) [801.861370] Starting subtest: min-max-config-loaded [801.874301] Subtest min-max-config-loaded: SKIP (0.004s) [802.044706] [132/141] (213s left) api_intel_allocator (alloc-simple) [802.410341] Starting subtest: alloc-simple [802.418870] Subtest alloc-simple: SUCCESS (0.009s) [802.609310] [133/141] (213s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt) [803.114645] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt [803.121359] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [803.286485] [134/141] (212s left) kms_cursor_crc (cursor-random-64x21) [804.110365] Starting subtest: cursor-random-64x21 [804.142206] Starting dynamic subtest: pipe-A-eDP-1 [810.538931] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.396s) [810.748152] Starting dynamic subtest: pipe-D-eDP-1 [818.060528] Dynamic subtest pipe-D-eDP-1: SUCCESS (7.361s) [818.063946] Subtest cursor-random-64x21: SUCCESS (13.947s) [819.258934] [135/141] (196s left) gem_softpin (allocator-fork) [819.647064] Starting subtest: allocator-fork [822.212505] Subtest allocator-fork: SUCCESS (2.566s) [822.448184] [136/141] (193s left) kms_busy (extended-modeset-hang-oldfb-with-reset) [823.021193] Starting subtest: extended-modeset-hang-oldfb-with-reset [823.032995] Starting dynamic subtest: pipe-A [827.679398] Dynamic subtest pipe-A: SUCCESS (4.645s) [827.752560] Starting dynamic subtest: pipe-D [832.021316] Dynamic subtest pipe-D: SUCCESS (4.314s) [832.024937] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (8.999s) [832.995796] [137/141] (183s left) kms_ccs (pipe-c-missing-ccs-buffer-y_tiled_gen12_mc_ccs) [834.462089] Starting subtest: pipe-C-missing-ccs-buffer-y_tiled_gen12_mc_ccs [834.468325] Subtest pipe-C-missing-ccs-buffer-y_tiled_gen12_mc_ccs: SKIP (0.000s) [835.372598] [138/141] (181s left) syncobj_timeline (etime-multi-wait-for-submit-submitted) [835.765288] Starting subtest: etime-multi-wait-for-submit-submitted [835.874315] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.110s) [836.040197] [139/141] (180s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs) [837.105289] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs [837.120705] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs: SKIP (0.013s) [838.426218] [140/141] (178s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [838.977059] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip [844.149904] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: FAIL (4.384s) [844.353513] [141/141] (172s left) kms_pipe_crc_basic (bad-source) [844.841391] Starting subtest: bad-source [844.844626] Subtest bad-source: SUCCESS (0.001s) [844.995231] Closing watchdogs Done.