[51.333818] Initializing watchdogs [51.334101] /dev/watchdog0 [51.370412] [001/141] (960s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted) [51.708610] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted [51.786615] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.109s) [51.899587] [002/141] (960s left) sw_sync (timeline_closed_signaled) [52.180473] Starting subtest: timeline_closed_signaled [52.199651] Subtest timeline_closed_signaled: SUCCESS (0.000s) [52.277368] [003/141] (959s left) v3d/v3d_wait_bo (map-bo-0ns) [52.629216] Subtest map-bo-0ns: SKIP (0.000s) [52.713117] [004/141] (959s left) gem_mmap_wc (write) [53.008142] Starting subtest: write [53.165938] Subtest write: SUCCESS (0.190s) [53.271710] [005/141] (958s left) gem_ctx_param (invalid-size-get) [53.572451] Starting subtest: invalid-size-get [53.591381] Subtest invalid-size-get: SUCCESS (0.001s) [53.672423] [006/141] (958s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt) [54.117951] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt [54.157574] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [54.261760] [007/141] (958s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [54.686094] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip [54.729439] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s) [54.827909] [008/141] (957s left) kms_vblank (pipe-c-ts-continuation-modeset-rpm) [55.189706] Starting subtest: pipe-C-ts-continuation-modeset-rpm [57.743383] Subtest pipe-C-ts-continuation-modeset-rpm: SUCCESS (2.546s) [58.257966] [009/141] (954s left) kms_psr (psr2_sprite_render) [58.581246] Subtest psr2_sprite_render: SKIP (0.000s) [58.683618] [010/141] (953s left) i915_pm_rpm (basic-rte) [58.963924] Starting subtest: basic-rte [61.449254] Subtest basic-rte: SUCCESS (2.491s) [62.472897] [011/141] (950s left) kms_cursor_edge_walk (256x256-top-bottom) [62.838905] Starting subtest: 256x256-top-bottom [62.860365] Starting dynamic subtest: pipe-A-DP-1 [66.515611] Dynamic subtest pipe-A-DP-1: SUCCESS (3.667s) [66.545448] Starting dynamic subtest: pipe-C-DP-1 [69.999163] Dynamic subtest pipe-C-DP-1: SUCCESS (3.473s) [70.018717] Subtest 256x256-top-bottom: SUCCESS (7.145s) [70.343913] [012/141] (942s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy) [70.727807] Starting subtest: flip-vs-cursor-crc-legacy [71.382803] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.636s) [71.719900] [013/141] (941s left) gem_eio (in-flight-contexts-10ms) [72.083653] Starting subtest: in-flight-contexts-10ms [83.314720] Subtest in-flight-contexts-10ms: SUCCESS (11.259s) [83.567153] [014/141] (929s left) gem_lmem_swapping (verify) [83.878402] Subtest verify: SKIP (0.000s) [83.981326] [015/141] (929s left) kms_plane_scaling (planes-downscale-factor-0-25-unity-scaling) [84.393594] Starting subtest: planes-downscale-factor-0-25-unity-scaling [84.425108] Starting dynamic subtest: pipe-A-DP-1 [84.482572] Dynamic subtest pipe-A-DP-1: SKIP (0.035s) [84.529540] Starting dynamic subtest: pipe-B-DP-1 [84.581331] Dynamic subtest pipe-B-DP-1: SKIP (0.084s) [84.619428] Starting dynamic subtest: pipe-C-DP-1 [84.675924] Dynamic subtest pipe-C-DP-1: SKIP (0.080s) [84.733623] Subtest planes-downscale-factor-0-25-unity-scaling: SKIP (0.209s) [84.875392] [016/141] (928s left) sysfs_heartbeat_interval (precise) [85.211974] Starting subtest: precise [85.231710] Starting dynamic subtest: vecs0 [86.734445] Dynamic subtest vecs0: SUCCESS (1.515s) [86.769359] Starting dynamic subtest: vcs0 [88.223533] Dynamic subtest vcs0: SUCCESS (1.499s) [88.259662] Starting dynamic subtest: bcs0 [89.724162] Dynamic subtest bcs0: SUCCESS (1.493s) [89.757113] Starting dynamic subtest: rcs0 [91.236908] Dynamic subtest rcs0: SUCCESS (1.508s) [91.257602] Subtest precise: SUCCESS (6.019s) [91.340085] [017/141] (921s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [91.762304] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip [92.837601] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.120s) [93.223281] [018/141] (920s left) gem_softpin (evict-prime-sanity-check) [93.517454] Starting subtest: evict-prime-sanity-check [93.539048] Starting dynamic subtest: rcs0 [94.610201] Dynamic subtest rcs0: SUCCESS (1.119s) [94.643800] Starting dynamic subtest: bcs0 [95.721473] Dynamic subtest bcs0: SUCCESS (1.109s) [95.756197] Starting dynamic subtest: vcs0 [96.828643] Dynamic subtest vcs0: SUCCESS (1.108s) [96.865494] Starting dynamic subtest: vecs0 [97.938160] Dynamic subtest vecs0: SUCCESS (1.110s) [97.971550] Starting dynamic subtest: all [99.046555] Dynamic subtest all: SUCCESS (1.104s) [99.067373] Subtest evict-prime-sanity-check: SUCCESS (5.552s) [99.149249] [019/141] (914s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc) [99.910426] Subtest pipe-D-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s) [100.234536] [020/141] (913s left) kms_ccs (pipe-c-bad-pixel-format-4_tiled_dg2_rc_ccs) [100.850307] Starting subtest: pipe-C-bad-pixel-format-4_tiled_dg2_rc_ccs [100.887917] Subtest pipe-C-bad-pixel-format-4_tiled_dg2_rc_ccs: SKIP (0.000s) [101.308925] [021/141] (912s left) perf_pmu (busy-idle-no-semaphores) [101.609063] Starting subtest: busy-idle-no-semaphores [101.628053] Starting dynamic subtest: rcs0 [102.222335] Dynamic subtest rcs0: SUCCESS (0.638s) [102.259151] Starting dynamic subtest: bcs0 [102.856945] Dynamic subtest bcs0: SUCCESS (0.634s) [102.892158] Starting dynamic subtest: vcs0 [103.482081] Dynamic subtest vcs0: SUCCESS (0.626s) [103.516260] Starting dynamic subtest: vecs0 [104.121983] Dynamic subtest vecs0: SUCCESS (0.635s) [104.143150] Subtest busy-idle-no-semaphores: SUCCESS (2.535s) [104.247344] [022/141] (909s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic) [104.600676] Starting subtest: 2x-cursor-vs-flip-atomic [104.642466] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.004s) [104.752178] [023/141] (909s left) kms_vblank (pipe-d-wait-forked-busy) [105.123133] Subtest pipe-D-wait-forked-busy: SKIP (0.000s) [105.317428] [024/141] (908s left) gem_exec_schedule (pi-distinct-iova) [105.773980] Starting subtest: pi-distinct-iova [105.793182] Starting dynamic subtest: rcs0 [105.832538] Dynamic subtest rcs0: SUCCESS (0.080s) [105.869338] Starting dynamic subtest: bcs0 [105.912543] Dynamic subtest bcs0: SUCCESS (0.075s) [105.949899] Starting dynamic subtest: vcs0 [105.968858] Dynamic subtest vcs0: SUCCESS (0.054s) [106.006495] Starting dynamic subtest: vecs0 [106.025256] Dynamic subtest vecs0: SUCCESS (0.057s) [106.045277] Subtest pi-distinct-iova: SUCCESS (0.270s) [106.258673] [025/141] (907s left) i915_pm_rpm (modeset-non-lpsp-stress-no-wait) [108.110022] Starting subtest: modeset-non-lpsp-stress-no-wait [114.557212] Subtest modeset-non-lpsp-stress-no-wait: SUCCESS (6.432s) [114.785071] [026/141] (899s left) dumb_buffer (create-clear) [115.077755] Starting subtest: create-clear [159.680520] Subtest create-clear: SUCCESS (44.424s) [159.763727] [027/141] (854s left) kms_ccs (pipe-b-random-ccs-data-y_tiled_gen12_rc_ccs_cc) [160.350721] Starting subtest: pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs_cc [160.409943] Subtest pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s) [160.851517] [028/141] (853s left) kms_cursor_legacy (cursora-vs-flipb-atomic) [161.228456] Starting subtest: cursorA-vs-flipB-atomic [161.268275] Subtest cursorA-vs-flipB-atomic: SKIP (0.003s) [161.376639] [029/141] (853s left) kms_vblank (pipe-b-ts-continuation-suspend) [161.728546] Starting subtest: pipe-B-ts-continuation-suspend [179.250012] Subtest pipe-B-ts-continuation-suspend: SUCCESS (2.215s) [185.796817] [030/141] (850s left) gem_ctx_param (invalid-ctx-set) [186.088465] Starting subtest: invalid-ctx-set [186.109603] Subtest invalid-ctx-set: SUCCESS (0.001s) [186.197139] [031/141] (849s left) kms_content_protection (dp-mst-type-0) [186.605760] Starting subtest: dp-mst-type-0 [186.648388] Subtest dp-mst-type-0: SKIP (0.001s) [186.755250] [032/141] (849s left) vgem_basic (setversion) [187.151890] Starting subtest: setversion [187.196073] Subtest setversion: SUCCESS (0.000s) [187.285931] [033/141] (848s left) kms_ccs (pipe-b-bad-rotation-90-y_tiled_gen12_rc_ccs_cc) [187.822244] Starting subtest: pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs_cc [187.862897] Subtest pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s) [188.373813] [034/141] (847s left) syncobj_wait (multi-wait-for-submit-submitted-signaled) [188.672050] Starting subtest: multi-wait-for-submit-submitted-signaled [188.691972] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s) [188.798117] [035/141] (847s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic) [189.180527] Starting subtest: 2x-flip-vs-cursor-atomic [189.221342] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.004s) [189.327921] [036/141] (847s left) vgem_basic (unload) [189.600922] Starting subtest: unload [218.748863] Subtest unload: SUCCESS (28.989s) [218.837539] [037/141] (817s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs) [219.117658] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs [219.138314] Starting dynamic subtest: smem [219.537030] Dynamic subtest smem: SUCCESS (0.437s) [219.555980] Subtest y-tiled-ccs-to-yf-tiled-ccs: SUCCESS (0.439s) [219.773020] [038/141] (817s left) kms_flip (2x-flip-vs-absolute-wf_vblank) [220.131162] Starting subtest: 2x-flip-vs-absolute-wf_vblank [220.168470] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.003s) [220.286870] [039/141] (816s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw) [220.699561] Starting subtest: fbc-2p-pri-indfb-multidraw [220.743268] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s) [220.855523] [040/141] (816s left) kms_cursor_crc (cursor-rapid-movement-32x32) [221.220247] Starting subtest: cursor-rapid-movement-32x32 [221.383032] Subtest cursor-rapid-movement-32x32: SKIP (0.120s) [221.510540] [041/141] (815s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling) [221.879969] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling [221.899515] Starting dynamic subtest: pipe-A-valid-mode [222.017841] Dynamic subtest pipe-A-valid-mode: SKIP (0.099s) [222.058811] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (0.102s) [222.324281] [042/141] (814s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move) [222.764645] Starting subtest: psr-2p-scndscrn-spr-indfb-move [222.802042] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [222.914248] [043/141] (814s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled) [223.200497] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [223.219555] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s) [223.336711] [044/141] (814s left) gen9_exec_parse (allowed-all) [223.658948] Starting subtest: allowed-all [223.677613] Subtest allowed-all: SUCCESS (0.003s) [223.926757] [045/141] (813s left) kms_addfb_basic (invalid-get-prop-any) [224.229649] Starting subtest: invalid-get-prop-any [224.251312] Subtest invalid-get-prop-any: SUCCESS (0.000s) [224.425829] [046/141] (813s left) gem_exec_fence (submit67) [224.849925] Starting subtest: submit67 [224.871016] Starting dynamic subtest: rcs0 [227.404720] Dynamic subtest rcs0: SUCCESS (2.373s) [227.445107] Starting dynamic subtest: bcs0 [228.370975] Dynamic subtest bcs0: SUCCESS (1.142s) [228.415327] Starting dynamic subtest: vcs0 [229.537264] Dynamic subtest vcs0: SUCCESS (1.170s) [229.579160] Starting dynamic subtest: vecs0 [230.760608] Dynamic subtest vecs0: SUCCESS (1.222s) [230.782662] Subtest submit67: SUCCESS (5.914s) [231.459117] [047/141] (806s left) vgem_slow (nohang) [231.754085] Starting subtest: nohang [242.233635] Subtest nohang: SUCCESS (10.335s) [242.328511] [048/141] (795s left) gem_ctx_param (invalid-set-no-zeromap) [242.617125] Starting subtest: invalid-set-no-zeromap [242.637893] Subtest invalid-set-no-zeromap: SUCCESS (0.000s) [242.728478] [049/141] (795s left) kms_getfb (getfb-handle-protection) [243.030426] Starting subtest: getfb-handle-protection [243.049484] Subtest getfb-handle-protection: SUCCESS (0.033s) [243.174793] [050/141] (794s left) kms_sequence (get-idle) [243.564966] Starting subtest: get-idle [243.585986] Starting dynamic subtest: DP-1-pipe-A [245.875669] Dynamic subtest DP-1-pipe-A: SUCCESS (2.312s) [245.917873] Starting dynamic subtest: DP-1-pipe-B [248.447569] Dynamic subtest DP-1-pipe-B: SUCCESS (2.572s) [248.496875] Starting dynamic subtest: DP-1-pipe-C [251.171523] Dynamic subtest DP-1-pipe-C: SUCCESS (2.720s) [251.190616] Subtest get-idle: SUCCESS (7.614s) [251.516519] [051/141] (786s left) gem_ppgtt (blt-vs-render-ctx0) [251.814208] Starting subtest: blt-vs-render-ctx0 [285.445539] Subtest blt-vs-render-ctx0: SUCCESS (33.655s) [285.595244] [052/141] (752s left) kms_psr2_sf (cursor-plane-move-continuous-sf) [286.035892] Subtest cursor-plane-move-continuous-sf: SKIP (0.000s) [286.125183] [053/141] (752s left) gem_eio (create-ext) [286.467443] Starting subtest: create-ext [286.489611] Subtest create-ext: SUCCESS (0.036s) [286.798932] [054/141] (751s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180) [287.205840] Starting subtest: linear-max-hw-stride-32bpp-rotate-180 [288.955635] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.789s) [289.146386] [055/141] (749s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt) [289.571696] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt [289.614928] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [289.727253] [056/141] (748s left) gem_ctx_create (basic) [290.025942] Starting subtest: basic [290.045040] Subtest basic: SUCCESS (0.000s) [290.246826] [057/141] (748s left) v3d/v3d_submit_cl (multi-and-single-sync) [290.626478] Subtest multi-and-single-sync: SKIP (0.000s) [290.721244] [058/141] (748s left) kms_big_fb (yf-tiled-8bpp-rotate-0) [291.115696] Starting subtest: yf-tiled-8bpp-rotate-0 [291.159047] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s) [291.276443] [059/141] (747s left) kms_flip (basic-flip-vs-modeset) [291.664682] Starting subtest: basic-flip-vs-modeset [291.686029] Starting dynamic subtest: A-DP1 [292.935167] Dynamic subtest A-DP1: SUCCESS (1.287s) [292.976287] Starting dynamic subtest: B-DP1 [294.072085] Dynamic subtest B-DP1: SUCCESS (1.131s) [294.115266] Starting dynamic subtest: C-DP1 [295.230472] Dynamic subtest C-DP1: SUCCESS (1.154s) [295.253443] Subtest basic-flip-vs-modeset: SUCCESS (3.584s) [295.645762] [060/141] (743s left) perf (rc6-disable) [296.124271] Starting subtest: rc6-disable [296.333126] Subtest rc6-disable: SUCCESS (0.239s) [296.471160] [061/141] (742s left) gen9_exec_parse (unaligned-access) [296.766300] Starting subtest: unaligned-access [296.832997] Subtest unaligned-access: SUCCESS (0.076s) [297.115979] [062/141] (742s left) vc4/vc4_purgeable_bo (mark-purgeable-twice) [297.467918] Subtest mark-purgeable-twice: SKIP (0.000s) [297.577337] [063/141] (741s left) i915_pipe_stress (stress-xrgb8888-untiled) [297.971083] Starting subtest: stress-xrgb8888-untiled [306.400552] Subtest stress-xrgb8888-untiled: FAIL (7.143s) [306.517553] [064/141] (732s left) kms_frontbuffer_tracking (fbcpsr-suspend) [306.963732] Starting subtest: fbcpsr-suspend [307.000911] Subtest fbcpsr-suspend: SKIP (0.000s) [307.125154] [065/141] (732s left) kms_hdr (static-toggle-dpms) [307.490939] Starting subtest: static-toggle-dpms [307.529271] Subtest static-toggle-dpms: SKIP (0.000s) [307.647736] [066/141] (732s left) drm_fdinfo (isolation) [307.940359] Starting subtest: isolation [307.962688] Starting dynamic subtest: rcs0 [308.462212] Dynamic subtest rcs0: SUCCESS (0.529s) [308.502778] Starting dynamic subtest: bcs0 [308.990693] Dynamic subtest bcs0: SUCCESS (0.534s) [309.033446] Starting dynamic subtest: vcs0 [309.529932] Dynamic subtest vcs0: SUCCESS (0.529s) [309.569720] Starting dynamic subtest: vecs0 [310.057551] Dynamic subtest vecs0: SUCCESS (0.538s) [310.079494] Subtest isolation: SUCCESS (2.138s) [310.178779] [067/141] (729s left) kms_setmode (clone-exclusive-crtc) [310.473658] Starting subtest: clone-exclusive-crtc [310.534607] Subtest clone-exclusive-crtc: SKIP (0.000s) [310.625235] [068/141] (729s left) perf (invalid-oa-metric-set-id) [310.982495] Starting subtest: invalid-oa-metric-set-id [311.026451] Subtest invalid-oa-metric-set-id: SUCCESS (0.045s) [311.142756] [069/141] (728s left) kms_vblank (pipe-c-query-forked-hang) [311.507192] Starting subtest: pipe-C-query-forked-hang [319.460942] Subtest pipe-C-query-forked-hang: SUCCESS (7.841s) [319.749060] [070/141] (720s left) kms_atomic (plane-immutable-zpos) [320.267051] Starting subtest: plane-immutable-zpos [320.522142] Subtest plane-immutable-zpos: SUCCESS (0.261s) [320.989160] [071/141] (719s left) kms_ccs (pipe-a-bad-rotation-90-4_tiled_dg2_rc_ccs) [321.470457] Starting subtest: pipe-A-bad-rotation-90-4_tiled_dg2_rc_ccs [321.510762] Subtest pipe-A-bad-rotation-90-4_tiled_dg2_rc_ccs: SKIP (0.000s) [322.090537] [072/141] (718s left) kms_chamelium_hpd (hdmi-hpd-storm) [322.576721] Subtest hdmi-hpd-storm: SKIP (0.000s) [322.891188] [073/141] (717s left) kms_vblank (pipe-c-ts-continuation-modeset) [323.248727] Starting subtest: pipe-C-ts-continuation-modeset [324.367071] Subtest pipe-C-ts-continuation-modeset: SUCCESS (1.123s) [324.761326] [074/141] (715s left) kms_chamelium_edid (hdmi-edid-read) [325.244097] Subtest hdmi-edid-read: SKIP (0.000s) [325.563178] [075/141] (715s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite) [325.976672] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite [326.019312] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [326.136919] [076/141] (714s left) api_intel_bb (render-ccs) [326.437539] Starting subtest: render-ccs [326.729309] Subtest render-ccs: SUCCESS (0.329s) [326.900755] [077/141] (714s left) kms_plane_cursor (overlay) [327.263052] Starting subtest: overlay [327.300796] Starting dynamic subtest: pipe-A-DP-1-size-64 [329.689145] Dynamic subtest pipe-A-DP-1-size-64: SUCCESS (2.430s) [329.779415] Starting dynamic subtest: pipe-A-DP-1-size-128 [332.163391] Dynamic subtest pipe-A-DP-1-size-128: SUCCESS (2.415s) [332.229086] Starting dynamic subtest: pipe-A-DP-1-size-256 [334.622522] Dynamic subtest pipe-A-DP-1-size-256: SUCCESS (2.415s) [334.869937] Starting dynamic subtest: pipe-B-DP-1-size-64 [337.445842] Dynamic subtest pipe-B-DP-1-size-64: SUCCESS (2.655s) [337.522613] Starting dynamic subtest: pipe-B-DP-1-size-128 [339.936405] Dynamic subtest pipe-B-DP-1-size-128: SUCCESS (2.432s) [340.021575] Starting dynamic subtest: pipe-B-DP-1-size-256 [342.384149] Dynamic subtest pipe-B-DP-1-size-256: SUCCESS (2.415s) [342.609062] Starting dynamic subtest: pipe-C-DP-1-size-64 [345.178994] Dynamic subtest pipe-C-DP-1-size-64: SUCCESS (2.643s) [345.265413] Starting dynamic subtest: pipe-C-DP-1-size-128 [347.643907] Dynamic subtest pipe-C-DP-1-size-128: SUCCESS (2.415s) [347.733951] Starting dynamic subtest: pipe-C-DP-1-size-256 [350.129320] Dynamic subtest pipe-C-DP-1-size-256: SUCCESS (2.429s) [350.267913] Subtest overlay: SUCCESS (23.005s) [350.637100] [078/141] (690s left) kms_ccs (pipe-d-bad-pixel-format-4_tiled_mtl_rc_ccs_cc) [351.389353] Subtest pipe-D-bad-pixel-format-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s) [351.731115] [079/141] (689s left) kms_lease (setcrtc_implicit_plane) [352.123136] Starting subtest: setcrtc_implicit_plane [352.145434] Starting dynamic subtest: pipe-A-DP-1 [352.415185] Dynamic subtest pipe-A-DP-1: SUCCESS (0.309s) [352.455753] Starting dynamic subtest: pipe-B-DP-1 [353.023664] Dynamic subtest pipe-B-DP-1: SUCCESS (0.602s) [353.065463] Starting dynamic subtest: pipe-C-DP-1 [353.725366] Dynamic subtest pipe-C-DP-1: SUCCESS (0.704s) [353.744444] Subtest setcrtc_implicit_plane: SUCCESS (1.628s) [354.137984] [080/141] (687s left) gem_pread (exhaustion) [354.465281] Starting subtest: exhaustion [375.813074] Subtest exhaustion: SUCCESS (21.387s) [375.957802] [081/141] (665s left) syncobj_timeline (signal) [376.258950] Starting subtest: signal [376.279830] Subtest signal: SUCCESS (0.001s) [376.374936] [082/141] (665s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt) [376.777800] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt [376.820188] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [376.936573] [083/141] (664s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs) [377.486958] Starting subtest: pipe-A-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs [377.531345] Subtest pipe-A-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs: SKIP (0.005s) [378.061991] [084/141] (663s left) kms_display_modes (extended-mode-basic) [378.430763] Starting subtest: extended-mode-basic [378.473148] Subtest extended-mode-basic: SKIP (0.000s) [378.589292] [085/141] (663s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [379.021956] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip [380.250750] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (1.277s) [380.628529] [086/141] (661s left) kms_flip (wf_vblank-ts-check-interruptible) [380.985283] Starting subtest: wf_vblank-ts-check-interruptible [381.004820] Starting dynamic subtest: A-DP1 [391.986230] Dynamic subtest A-DP1: SUCCESS (10.816s) [392.028858] Starting dynamic subtest: B-DP1 [402.538823] Dynamic subtest B-DP1: SUCCESS (10.726s) [402.579485] Starting dynamic subtest: C-DP1 [413.431889] Dynamic subtest C-DP1: SUCCESS (10.716s) [413.451126] Subtest wf_vblank-ts-check-interruptible: SUCCESS (32.273s) [413.727206] [087/141] (628s left) kms_plane_scaling (plane-downscale-with-modifiers-factor-0-25) [414.093794] Starting subtest: plane-downscale-with-modifiers-factor-0-25 [414.116545] Starting dynamic subtest: pipe-A-DP-1 [414.191634] Dynamic subtest pipe-A-DP-1: SKIP (0.049s) [414.245054] Starting dynamic subtest: pipe-B-DP-1 [414.285096] Dynamic subtest pipe-B-DP-1: SKIP (0.096s) [414.326915] Starting dynamic subtest: pipe-C-DP-1 [414.370475] Dynamic subtest pipe-C-DP-1: SKIP (0.094s) [414.412449] Subtest plane-downscale-with-modifiers-factor-0-25: SKIP (0.255s) [414.537649] [088/141] (627s left) kms_ccs (pipe-c-missing-ccs-buffer-y_tiled_gen12_mc_ccs) [415.253522] Starting subtest: pipe-C-missing-ccs-buffer-y_tiled_gen12_mc_ccs [415.299475] Subtest pipe-C-missing-ccs-buffer-y_tiled_gen12_mc_ccs: SKIP (0.000s) [415.659755] [089/141] (626s left) gem_create (create-ext-cpu-access-sanity-check) [416.056553] Starting subtest: create-ext-cpu-access-sanity-check [416.100328] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s) [416.215075] [090/141] (626s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic) [416.581972] Starting subtest: 2x-long-flip-vs-cursor-atomic [416.622233] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.004s) [416.742907] [091/141] (625s left) prime_vgem (basic-blt) [417.064112] Starting subtest: basic-blt [417.104118] Subtest basic-blt: SUCCESS (0.060s) [417.264019] [092/141] (625s left) i915_pm_sseu (full-enable) [418.071180] Starting subtest: full-enable [418.092358] Subtest full-enable: SUCCESS (0.019s) [418.242151] [093/141] (624s left) gem_userptr_blits (usage-restrictions) [418.603174] Starting subtest: usage-restrictions [418.624250] Subtest usage-restrictions: SUCCESS (0.000s) [418.756115] [094/141] (623s left) gem_mmap_offset (open-flood) [419.057408] Starting subtest: open-flood [440.620516] Subtest open-flood: SUCCESS (21.575s) [440.738348] [095/141] (602s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0) [441.148159] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0 [442.572670] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.441s) [442.739725] [096/141] (600s left) gem_exec_balancer (sliced) [443.040940] Starting subtest: sliced [446.967403] Subtest sliced: SUCCESS (3.755s) [450.872164] [097/141] (592s left) kms_ccs (pipe-a-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc) [451.387009] Starting subtest: pipe-A-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc [451.430055] Subtest pipe-A-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s) [451.955757] [098/141] (591s left) gem_readwrite (new-obj) [452.250017] Starting subtest: new-obj [452.287798] Subtest new-obj: SUCCESS (0.001s) [452.407646] [099/141] (590s left) gem_render_copy (y-tiled-ccs-to-linear) [452.702442] Starting subtest: y-tiled-ccs-to-linear [452.723205] Starting dynamic subtest: smem [452.956436] Dynamic subtest smem: SUCCESS (0.268s) [452.975435] Subtest y-tiled-ccs-to-linear: SUCCESS (0.270s) [453.212274] [100/141] (590s left) perf (enable-disable) [453.576503] Starting subtest: enable-disable [453.597566] Starting dynamic subtest: 0-rcs0 [456.717867] Dynamic subtest 0-rcs0: SUCCESS (2.972s) [456.739332] Subtest enable-disable: SUCCESS (2.975s) [456.869476] [101/141] (586s left) perf (oa-exponents) [457.243241] Starting subtest: oa-exponents [457.261945] Starting dynamic subtest: 0-rcs0 [461.276943] Dynamic subtest 0-rcs0: SUCCESS (4.054s) [461.298674] Subtest oa-exponents: SUCCESS (4.056s) [461.413687] [102/141] (582s left) gem_exec_capture (capture-recoverable) [461.713103] Starting subtest: capture-recoverable [461.751118] Subtest capture-recoverable: SKIP (0.000s) [461.847151] [103/141] (581s left) syncobj_timeline (invalid-signal-illegal-point) [462.132949] Starting subtest: invalid-signal-illegal-point [462.151692] Subtest invalid-signal-illegal-point: SUCCESS (0.000s) [462.251779] [104/141] (581s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt) [462.670316] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt [464.973215] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (2.374s) [465.149225] [105/141] (578s left) gem_spin_batch (engines) [465.449413] Starting subtest: engines [465.471424] Starting dynamic subtest: rcs0 [468.963216] Dynamic subtest rcs0: SUCCESS (3.325s) [469.004195] Starting dynamic subtest: bcs0 [472.294623] Dynamic subtest bcs0: SUCCESS (3.324s) [472.337215] Starting dynamic subtest: vcs0 [475.614672] Dynamic subtest vcs0: SUCCESS (3.322s) [475.658308] Starting dynamic subtest: vecs0 [478.939796] Dynamic subtest vecs0: SUCCESS (3.320s) [478.959025] Subtest engines: SUCCESS (13.299s) [479.050946] [106/141] (564s left) gem_exec_schedule (u-independent) [479.513424] Starting subtest: u-independent [479.532380] Starting dynamic subtest: rcs0 [479.551358] Dynamic subtest rcs0: SUCCESS (0.188s) [479.602938] Starting dynamic subtest: bcs0 [479.744841] Dynamic subtest bcs0: SUCCESS (0.202s) [479.793905] Starting dynamic subtest: vcs0 [479.927899] Dynamic subtest vcs0: SUCCESS (0.182s) [479.980666] Starting dynamic subtest: vecs0 [480.106288] Dynamic subtest vecs0: SUCCESS (0.174s) [480.125378] Subtest u-independent: SUCCESS (0.757s) [480.476287] [107/141] (563s left) kms_ccs (pipe-b-bad-pixel-format-y_tiled_ccs) [481.017191] Starting subtest: pipe-B-bad-pixel-format-y_tiled_ccs [481.038108] Subtest pipe-B-bad-pixel-format-y_tiled_ccs: SUCCESS (0.001s) [481.587263] [108/141] (562s left) kms_flip (modeset-vs-vblank-race) [481.966240] Starting subtest: modeset-vs-vblank-race [481.985326] Starting dynamic subtest: A-DP1 [486.328928] Dynamic subtest A-DP1: SUCCESS (4.393s) [486.370218] Starting dynamic subtest: B-DP1 [490.646178] Dynamic subtest B-DP1: SUCCESS (4.311s) [490.690443] Starting dynamic subtest: C-DP1 [494.976075] Dynamic subtest C-DP1: SUCCESS (4.329s) [494.998679] Subtest modeset-vs-vblank-race: SUCCESS (13.046s) [495.456096] [109/141] (548s left) api_intel_allocator (execbuf-with-allocator) [495.789668] Starting subtest: execbuf-with-allocator [495.808695] Subtest execbuf-with-allocator: SUCCESS (0.010s) [495.932512] [110/141] (548s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen) [496.377428] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen [496.416628] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [496.535946] [111/141] (548s left) kms_vblank (pipe-b-ts-continuation-modeset-rpm) [496.897098] Starting subtest: pipe-B-ts-continuation-modeset-rpm [499.137373] Subtest pipe-B-ts-continuation-modeset-rpm: SUCCESS (2.237s) [499.640658] [112/141] (545s left) kms_psr (psr2_primary_mmap_gtt) [499.959768] Subtest psr2_primary_mmap_gtt: SKIP (0.000s) [500.078383] [113/141] (544s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen) [500.479674] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen [500.521753] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [500.641342] [114/141] (544s left) i915_suspend (fence-restore-tiled2untiled) [500.941243] Starting subtest: fence-restore-tiled2untiled [520.775395] Subtest fence-restore-tiled2untiled: SUCCESS (4.271s) [526.097740] [115/141] (539s left) gem_softpin (evict-snoop-interruptible) [526.400985] Starting subtest: evict-snoop-interruptible [526.443013] Subtest evict-snoop-interruptible: SKIP (0.000s) [526.560035] [116/141] (539s left) kms_cdclk (mode-transition-all-outputs) [526.876478] Subtest mode-transition-all-outputs: SKIP (0.000s) [526.990145] [117/141] (538s left) kms_ccs (pipe-b-crc-primary-rotation-180-y_tiled_gen12_mc_ccs) [527.557898] Starting subtest: pipe-B-crc-primary-rotation-180-y_tiled_gen12_mc_ccs [527.599157] Subtest pipe-B-crc-primary-rotation-180-y_tiled_gen12_mc_ccs: SKIP (0.001s) [528.075618] [118/141] (538s left) gem_ctx_persistence (hang) [528.374818] Starting subtest: hang [528.412582] Subtest hang: SKIP (0.008s) [528.532866] [119/141] (537s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render) [528.946790] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render [528.988192] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [529.107955] [120/141] (537s left) gem_exec_whisper (basic-normal-all) [529.451127] Starting subtest: basic-normal-all [539.891879] Subtest basic-normal-all: SUCCESS (10.458s) [540.116423] [121/141] (526s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [540.529118] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu [540.570835] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [540.691340] [122/141] (525s left) gem_huc_copy (huc-copy) [540.989364] Starting subtest: huc-copy [541.027119] Subtest huc-copy: SKIP (0.000s) [541.144980] [123/141] (525s left) kms_ccs (pipe-d-crc-primary-basic-y_tiled_gen12_rc_ccs_cc) [541.865213] Subtest pipe-D-crc-primary-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s) [542.213603] [124/141] (524s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt) [542.653723] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt [542.691708] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [542.811403] [125/141] (524s left) gem_ctx_persistence (saturated-hostile) [543.098857] Starting subtest: saturated-hostile [543.119667] Starting dynamic subtest: rcs0 [543.204373] Dynamic subtest rcs0: SUCCESS (0.111s) [543.250349] Starting dynamic subtest: bcs0 [543.311395] Dynamic subtest bcs0: SUCCESS (0.117s) [543.360543] Starting dynamic subtest: vcs0 [543.446580] Dynamic subtest vcs0: SUCCESS (0.124s) [543.497230] Starting dynamic subtest: vecs0 [543.550724] Dynamic subtest vecs0: SUCCESS (0.109s) [543.576064] Subtest saturated-hostile: SUCCESS (0.472s) [543.740556] [126/141] (523s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff) [544.227766] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff [544.275580] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [544.418139] [127/141] (522s left) gem_exec_flush (basic-wb-set-default) [544.760315] Starting subtest: basic-wb-set-default [550.222361] Subtest basic-wb-set-default: SUCCESS (5.476s) [550.464451] [128/141] (516s left) kms_psr (suspend) [550.754724] Subtest suspend: SKIP (0.000s) [550.873519] [129/141] (516s left) api_intel_allocator (reopen-fork) [551.157632] Starting subtest: reopen-fork [554.583232] Subtest reopen-fork: SUCCESS (3.275s) [554.697773] [130/141] (512s left) kms_ccs (pipe-d-ccs-on-another-bo-4_tiled_mtl_mc_ccs) [555.456538] Subtest pipe-D-ccs-on-another-bo-4_tiled_mtl_mc_ccs: SKIP (0.000s) [555.805176] [131/141] (511s left) prime_mmap (test_forked_cpu_write) [556.100454] Starting subtest: test_forked_cpu_write [556.122067] Starting dynamic subtest: test_forked_cpu_write-smem [556.143659] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.035s) [556.164619] Subtest test_forked_cpu_write: SUCCESS (0.037s) [556.278424] [132/141] (511s left) v3d/v3d_mmap (mmap-bad-handle) [556.617995] Subtest mmap-bad-handle: SKIP (0.000s) [556.738860] [133/141] (511s left) kms_big_fb (y-tiled-64bpp-rotate-0) [557.135449] Starting subtest: y-tiled-64bpp-rotate-0 [564.829582] Subtest y-tiled-64bpp-rotate-0: SUCCESS (7.714s) [565.805319] [134/141] (502s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling) [566.194918] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling [566.214619] Starting dynamic subtest: pipe-A-valid-mode [566.922717] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.732s) [566.944277] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SUCCESS (0.736s) [567.308273] [135/141] (500s left) syncobj_timeline (multi-wait-signaled) [567.609943] Starting subtest: multi-wait-signaled [567.629071] Subtest multi-wait-signaled: SUCCESS (0.002s) [567.746679] [136/141] (500s left) kms_cursor_crc (cursor-offscreen-max-size) [568.144846] Starting subtest: cursor-offscreen-max-size [568.201603] Subtest cursor-offscreen-max-size: SKIP (0.000s) [568.320903] [137/141] (499s left) syncobj_wait (single-wait-all-submitted) [568.613359] Starting subtest: single-wait-all-submitted [568.689233] Subtest single-wait-all-submitted: SUCCESS (0.102s) [568.822817] [138/141] (499s left) gem_exec_schedule (independent) [569.256866] Starting subtest: independent [569.276188] Starting dynamic subtest: rcs0 [569.295475] Dynamic subtest rcs0: SUCCESS (0.183s) [569.344915] Starting dynamic subtest: bcs0 [569.467595] Dynamic subtest bcs0: SUCCESS (0.185s) [569.519641] Starting dynamic subtest: vcs0 [569.632950] Dynamic subtest vcs0: SUCCESS (0.165s) [569.682287] Starting dynamic subtest: vecs0 [569.801191] Dynamic subtest vecs0: SUCCESS (0.160s) [569.822061] Subtest independent: SUCCESS (0.704s) [570.170679] [139/141] (498s left) kms_ccs (pipe-c-ccs-on-another-bo-yf_tiled_ccs) [570.872295] Starting subtest: pipe-C-ccs-on-another-bo-yf_tiled_ccs [570.915731] Subtest pipe-C-ccs-on-another-bo-yf_tiled_ccs: SKIP (0.000s) [571.270982] [140/141] (497s left) perf_pmu (semaphore-wait-idle) [571.565925] Starting subtest: semaphore-wait-idle [571.587408] Starting dynamic subtest: rcs0 [572.065505] Dynamic subtest rcs0: SUCCESS (0.518s) [572.115481] Starting dynamic subtest: bcs0 [572.583876] Dynamic subtest bcs0: SUCCESS (0.515s) [572.625359] Starting dynamic subtest: vcs0 [573.102256] Dynamic subtest vcs0: SUCCESS (0.514s) [573.146207] Starting dynamic subtest: vecs0 [573.618763] Dynamic subtest vecs0: SUCCESS (0.513s) [573.637890] Subtest semaphore-wait-idle: SUCCESS (2.075s) [573.766313] [141/141] (494s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite) [574.193972] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite [574.231827] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [574.306779] Closing watchdogs Done.