[50.462519] Initializing watchdogs [50.463066] /dev/watchdog0 [50.494607] [001/142] (960s left) gem_ctx_param (set-priority-range) [50.905342] Starting subtest: set-priority-range [51.022760] Subtest set-priority-range: SUCCESS (0.119s) [51.184793] [002/142] (959s left) kms_plane_scaling (planes-downscale-factor-0-25) [51.663119] Starting subtest: planes-downscale-factor-0-25 [51.669740] Starting dynamic subtest: pipe-A-eDP-1 [51.748429] Dynamic subtest pipe-A-eDP-1: SKIP (0.075s) [51.775245] Starting dynamic subtest: pipe-B-eDP-1 [51.796925] Dynamic subtest pipe-B-eDP-1: SKIP (0.044s) [51.822784] Starting dynamic subtest: pipe-C-eDP-1 [51.846751] Dynamic subtest pipe-C-eDP-1: SKIP (0.043s) [51.872536] Starting dynamic subtest: pipe-D-eDP-1 [51.896456] Dynamic subtest pipe-D-eDP-1: SKIP (0.043s) [51.902126] Subtest planes-downscale-factor-0-25: SKIP (0.220s) [52.032478] [003/142] (959s left) kms_ccs (pipe-b-bad-rotation-90-y_tiled_gen12_mc_ccs) [53.127761] Starting subtest: pipe-B-bad-rotation-90-y_tiled_gen12_mc_ccs [53.134066] Subtest pipe-B-bad-rotation-90-y_tiled_gen12_mc_ccs: SKIP (0.000s) [54.219739] [004/142] (956s left) gem_lmem_swapping (random) [54.645128] Subtest random: SKIP (0.000s) [54.747987] [005/142] (956s left) kms_addfb_basic (no-handle) [55.133910] Starting subtest: no-handle [55.137505] Subtest no-handle: SUCCESS (0.000s) [55.394333] [006/142] (955s left) perf_pmu (busy-start) [55.797606] Starting subtest: busy-start [55.801485] Starting dynamic subtest: rcs0 [58.369255] Dynamic subtest rcs0: SUCCESS (2.572s) [58.398056] Starting dynamic subtest: bcs0 [60.921920] Dynamic subtest bcs0: SUCCESS (2.552s) [60.950375] Starting dynamic subtest: vcs0 [64.497906] Dynamic subtest vcs0: SUCCESS (3.574s) [64.530538] Starting dynamic subtest: vcs1 [68.530745] Dynamic subtest vcs1: SUCCESS (4.031s) [68.564234] Starting dynamic subtest: vecs0 [72.498892] Dynamic subtest vecs0: SUCCESS (3.967s) [72.530101] Starting dynamic subtest: ccs0 [75.049398] Dynamic subtest ccs0: SUCCESS (2.552s) [75.053634] Subtest busy-start: SUCCESS (19.253s) [75.192209] [007/142] (936s left) gem_render_copy (yf-tiled-ccs-to-y-tiled) [75.599780] Starting subtest: yf-tiled-ccs-to-y-tiled [75.605805] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s) [75.888417] [008/142] (935s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite) [76.404857] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite [76.411236] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [76.562407] [009/142] (934s left) gem_userptr_blits (map-fixed-invalidate-busy) [77.017321] Starting subtest: map-fixed-invalidate-busy [77.023993] Subtest map-fixed-invalidate-busy: SKIP (0.000s) [77.226655] [010/142] (934s left) kms_flip (blocking-absolute-wf_vblank) [77.620494] Starting subtest: blocking-absolute-wf_vblank [77.646847] Starting dynamic subtest: A-eDP1 [87.222559] Dynamic subtest A-eDP1: SUCCESS (9.576s) [87.246528] Starting dynamic subtest: B-eDP1 [96.392112] Dynamic subtest B-eDP1: SUCCESS (9.167s) [96.415174] Starting dynamic subtest: C-eDP1 [105.510718] Dynamic subtest C-eDP1: SUCCESS (9.116s) [105.539405] Starting dynamic subtest: D-eDP1 [114.486185] Dynamic subtest D-eDP1: SUCCESS (8.973s) [114.494344] Subtest blocking-absolute-wf_vblank: SUCCESS (36.881s) [116.147761] [011/142] (895s left) gem_tiled_fence_blits (normal) [116.552066] Subtest normal: SKIP (0.000s) [116.648264] [012/142] (895s left) gem_eio (wait-1us) [117.789376] Starting subtest: wait-1us [119.298474] Subtest wait-1us: SUCCESS (1.512s) [120.634526] [013/142] (891s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size) [121.192777] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size [121.202593] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.008s) [121.499209] [014/142] (890s left) gen9_exec_parse (batch-without-end) [121.837468] Subtest batch-without-end: SKIP (0.000s) [121.922811] [015/142] (890s left) syncobj_timeline (multi-wait-all-signaled) [122.303741] Starting subtest: multi-wait-all-signaled [122.307193] Subtest multi-wait-all-signaled: SUCCESS (0.004s) [122.433278] [016/142] (889s left) v3d/v3d_wait_bo (unused-bo-0ns) [122.898425] Subtest unused-bo-0ns: SKIP (0.000s) [123.001674] [017/142] (889s left) syncobj_timeline (invalid-single-wait-available-unsubmitted) [123.367059] Starting subtest: invalid-single-wait-available-unsubmitted [123.370532] Subtest invalid-single-wait-available-unsubmitted: SUCCESS (0.000s) [123.486460] [018/142] (888s left) i915_suspend (basic-s3-without-i915) [123.836942] Starting subtest: basic-s3-without-i915 [127.277757] Subtest basic-s3-without-i915: SKIP (3.434s) [130.214370] [019/142] (882s left) drm_fdinfo (virtual-busy-idle-all) [130.419601] Starting subtest: virtual-busy-idle-all [130.427400] Subtest virtual-busy-idle-all: SKIP (0.001s) [130.527989] [020/142] (881s left) i915_pm_rpm (cursor-dpms) [136.599210] Starting subtest: cursor-dpms [168.661239] Subtest cursor-dpms: SUCCESS (32.063s) [169.954848] [021/142] (842s left) gem_userptr_blits (create-destroy-sync) [170.404384] Starting subtest: create-destroy-sync [175.482916] Subtest create-destroy-sync: SUCCESS (5.077s) [175.723465] [022/142] (836s left) kms_prop_blob (blob-prop-validate) [176.099594] Starting subtest: blob-prop-validate [176.104312] Subtest blob-prop-validate: SUCCESS (0.000s) [176.259136] [023/142] (836s left) gem_exec_schedule (preempt-self) [176.698526] Starting subtest: preempt-self [176.702835] Starting dynamic subtest: rcs0 [176.799941] Dynamic subtest rcs0: SUCCESS (0.101s) [176.841849] Starting dynamic subtest: bcs0 [176.857936] Dynamic subtest bcs0: SUCCESS (0.057s) [176.899196] Starting dynamic subtest: vcs0 [176.916217] Dynamic subtest vcs0: SUCCESS (0.058s) [176.958417] Starting dynamic subtest: vcs1 [176.975170] Dynamic subtest vcs1: SUCCESS (0.058s) [177.012787] Starting dynamic subtest: vecs0 [177.034569] Dynamic subtest vecs0: SUCCESS (0.059s) [177.073311] Starting dynamic subtest: ccs0 [177.090800] Dynamic subtest ccs0: SUCCESS (0.056s) [177.094386] Subtest preempt-self: SUCCESS (0.392s) [178.648404] [024/142] (833s left) gem_exec_params (invalid-bsd1-flag-on-vebox) [179.043066] Starting subtest: invalid-bsd1-flag-on-vebox [179.047782] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.002s) [179.231730] [025/142] (833s left) kms_frontbuffer_tracking (fbcpsr-stridechange) [179.754411] Starting subtest: fbcpsr-stridechange [185.618205] Subtest fbcpsr-stridechange: SUCCESS (5.860s) [185.862608] [026/142] (826s left) kms_ccs (pipe-d-random-ccs-data-yf_tiled_ccs) [187.581350] Starting subtest: pipe-D-random-ccs-data-yf_tiled_ccs [187.591293] Subtest pipe-D-random-ccs-data-yf_tiled_ccs: SKIP (0.000s) [188.271099] [027/142] (824s left) gem_mmap_offset (open-flood) [188.643486] Starting subtest: open-flood [210.235293] Subtest open-flood: SUCCESS (21.596s) [210.407675] [028/142] (802s left) perf (low-oa-exponent-permissions) [211.276360] Starting subtest: low-oa-exponent-permissions [211.519260] Subtest low-oa-exponent-permissions: SUCCESS (0.243s) [211.622379] [029/142] (801s left) kms_invalid_mode (clock-too-high) [212.101362] Starting subtest: clock-too-high [212.104722] Starting dynamic subtest: eDP-1-pipe-A [212.110932] Dynamic subtest eDP-1-pipe-A: SKIP (0.001s) [212.143172] Starting dynamic subtest: eDP-1-pipe-B [212.148893] Dynamic subtest eDP-1-pipe-B: SKIP (0.000s) [212.186410] Starting dynamic subtest: eDP-1-pipe-C [212.193168] Dynamic subtest eDP-1-pipe-C: SKIP (0.000s) [212.226719] Starting dynamic subtest: eDP-1-pipe-D [212.233298] Dynamic subtest eDP-1-pipe-D: SKIP (0.000s) [212.239706] Subtest clock-too-high: SKIP (0.026s) [212.294975] [030/142] (800s left) kms_getfb (getfb2-handle-zero) [212.662599] Starting subtest: getfb2-handle-zero [212.666342] Subtest getfb2-handle-zero: SUCCESS (0.000s) [212.819035] [031/142] (800s left) kms_big_fb (4-tiled-addfb-size-overflow) [213.342871] Starting subtest: 4-tiled-addfb-size-overflow [213.346534] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.002s) [213.501071] [032/142] (799s left) gem_exec_whisper (basic-contexts-priority-all) [213.928533] Starting subtest: basic-contexts-priority-all [334.436685] Per-test timeout exceeded. Killing the current test with SIGQUIT. [337.263718] Closing watchdogs [337.277760] Initializing watchdogs [337.278100] /dev/watchdog0 [337.328191] [033/142] (676s left) sw_sync (sync_multi_consumer_producer) [337.710334] Starting subtest: sync_multi_consumer_producer [338.971065] Subtest sync_multi_consumer_producer: SUCCESS (1.260s) [339.113887] [034/142] (674s left) gem_exec_params (rs-invalid) [339.521110] Starting subtest: rs-invalid [339.534871] Subtest rs-invalid: SUCCESS (0.013s) [339.743375] [035/142] (673s left) kms_ccs (pipe-b-bad-pixel-format-y_tiled_gen12_rc_ccs_cc) [340.858821] Starting subtest: pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs_cc [340.865405] Subtest pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s) [342.147701] [036/142] (671s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move) [342.666725] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move [342.673229] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [342.840740] [037/142] (670s left) i915_pipe_stress (stress-xrgb8888-untiled) [343.355784] Starting subtest: stress-xrgb8888-untiled [358.005611] Subtest stress-xrgb8888-untiled: SUCCESS (14.655s) [358.113228] [038/142] (655s left) gem_exec_fence (submit67) [358.696407] Starting subtest: submit67 [358.703317] Subtest submit67: SKIP (0.000s) [360.642277] [039/142] (653s left) kms_cursor_crc (cursor-rapid-movement-32x10) [361.278399] Starting subtest: cursor-rapid-movement-32x10 [361.525552] Subtest cursor-rapid-movement-32x10: SKIP (0.244s) [362.232226] [040/142] (651s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_dg2_rc_ccs) [363.385450] Starting subtest: pipe-B-random-ccs-data-4_tiled_dg2_rc_ccs [363.394050] Subtest pipe-B-random-ccs-data-4_tiled_dg2_rc_ccs: SKIP (0.000s) [364.529313] [041/142] (649s left) kms_pipe_crc_basic (read-crc) [365.025418] Starting subtest: read-crc [365.030540] Starting dynamic subtest: pipe-A-eDP-1 [366.303813] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.269s) [366.351345] Starting dynamic subtest: pipe-B-eDP-1 [368.264354] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.951s) [368.312348] Starting dynamic subtest: pipe-C-eDP-1 [370.375181] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.096s) [370.413461] Starting dynamic subtest: pipe-D-eDP-1 [372.815343] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.433s) [372.819072] Subtest read-crc: SUCCESS (7.796s) [373.754072] [042/142] (640s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_dg2_rc_ccs) [375.094991] Starting subtest: pipe-C-crc-primary-rotation-180-4_tiled_dg2_rc_ccs [375.101267] Subtest pipe-C-crc-primary-rotation-180-4_tiled_dg2_rc_ccs: SKIP (0.003s) [376.006968] [043/142] (638s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled) [376.278757] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled [376.281784] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s) [376.373725] [044/142] (637s left) sw_sync (alloc_timeline) [376.519602] Starting subtest: alloc_timeline [376.521643] Subtest alloc_timeline: SUCCESS (0.000s) [376.577732] [045/142] (637s left) gem_spin_batch (resubmit-new) [376.726036] Starting subtest: resubmit-new [376.728711] Starting dynamic subtest: rcs0 [376.736355] Dynamic subtest rcs0: SUCCESS (0.010s) [376.753372] Starting dynamic subtest: bcs0 [376.756062] Dynamic subtest bcs0: SUCCESS (0.004s) [376.771227] Starting dynamic subtest: vcs0 [376.773778] Dynamic subtest vcs0: SUCCESS (0.009s) [376.788988] Starting dynamic subtest: vcs1 [376.791450] Dynamic subtest vcs1: SUCCESS (0.007s) [376.805115] Starting dynamic subtest: vecs0 [376.807518] Dynamic subtest vecs0: SUCCESS (0.006s) [376.821017] Starting dynamic subtest: ccs0 [376.823407] Dynamic subtest ccs0: SUCCESS (0.006s) [376.825766] Subtest resubmit-new: SUCCESS (0.054s) [378.691685] [046/142] (635s left) kms_big_fb (yf-tiled-64bpp-rotate-180) [379.229070] Starting subtest: yf-tiled-64bpp-rotate-180 [379.235629] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s) [379.396846] [047/142] (635s left) kms_writeback (writeback-invalid-parameters) [379.967759] Subtest writeback-invalid-parameters: SKIP (0.000s) [380.081602] [048/142] (634s left) syncobj_timeline (wait-all-for-submit-complex) [380.464877] Starting subtest: wait-all-for-submit-complex [380.686498] Subtest wait-all-for-submit-complex: SUCCESS (0.221s) [380.831167] [049/142] (633s left) kms_big_fb (linear-addfb) [381.377584] Starting subtest: linear-addfb [381.381714] Subtest linear-addfb: SUCCESS (0.001s) [381.551864] [050/142] (633s left) gem_tiled_blits (interruptible) [381.943409] Subtest interruptible: SKIP (0.000s) [382.065325] [051/142] (632s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc) [382.578060] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc [382.586557] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.001s) [382.713350] [052/142] (632s left) kms_chamelium_edid (hdmi-edid-read) [383.574214] Subtest hdmi-edid-read: SKIP (0.000s) [384.444211] [053/142] (630s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc) [384.974783] Starting subtest: psr-rgb565-draw-mmap-wc [396.623754] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (11.651s) [396.896074] [054/142] (618s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c) [397.274939] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s) [397.395751] [055/142] (617s left) kms_flip (2x-absolute-wf_vblank) [397.785609] Starting subtest: 2x-absolute-wf_vblank [397.946869] Subtest 2x-absolute-wf_vblank: SKIP (0.158s) [398.143878] [056/142] (617s left) gem_exec_fence (basic-busy) [398.726860] Starting subtest: basic-busy [398.730091] Starting dynamic subtest: rcs0 [398.802678] Dynamic subtest rcs0: SUCCESS (0.080s) [398.851578] Starting dynamic subtest: bcs0 [398.866968] Dynamic subtest bcs0: SUCCESS (0.060s) [398.930451] Starting dynamic subtest: vcs0 [398.936766] Dynamic subtest vcs0: SUCCESS (0.039s) [398.981535] Starting dynamic subtest: vcs1 [398.987351] Dynamic subtest vcs1: SUCCESS (0.033s) [399.034997] Starting dynamic subtest: vecs0 [399.040672] Dynamic subtest vecs0: SUCCESS (0.046s) [399.081062] Starting dynamic subtest: ccs0 [399.085891] Dynamic subtest ccs0: SUCCESS (0.058s) [399.088411] Subtest basic-busy: SUCCESS (0.347s) [400.783321] [057/142] (614s left) kms_ccs (pipe-c-bad-aux-stride-y_tiled_gen12_mc_ccs) [402.324562] Starting subtest: pipe-C-bad-aux-stride-y_tiled_gen12_mc_ccs [402.331428] Subtest pipe-C-bad-aux-stride-y_tiled_gen12_mc_ccs: SKIP (0.000s) [403.168994] [058/142] (612s left) kms_sequence (get-idle) [403.642206] Starting subtest: get-idle [403.651380] Starting dynamic subtest: eDP-1-pipe-A [405.817846] Dynamic subtest eDP-1-pipe-A: SUCCESS (2.169s) [405.866336] Starting dynamic subtest: eDP-1-pipe-B [408.651929] Dynamic subtest eDP-1-pipe-B: SUCCESS (2.819s) [408.700750] Starting dynamic subtest: eDP-1-pipe-C [411.739737] Dynamic subtest eDP-1-pipe-C: SUCCESS (3.080s) [411.788162] Starting dynamic subtest: eDP-1-pipe-D [415.148842] Dynamic subtest eDP-1-pipe-D: SUCCESS (3.400s) [415.152577] Subtest get-idle: SUCCESS (11.506s) [416.093285] [059/142] (599s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling) [416.602924] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling [416.610628] Starting dynamic subtest: pipe-A-default-mode [417.019894] Dynamic subtest pipe-A-default-mode: SKIP (0.402s) [417.026424] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.416s) [417.951787] [060/142] (597s left) perf_pmu (init-sema) [418.341502] Starting subtest: init-sema [418.347724] Starting dynamic subtest: rcs0 [418.351407] Dynamic subtest rcs0: SUCCESS (0.006s) [418.394960] Starting dynamic subtest: bcs0 [418.399228] Dynamic subtest bcs0: SUCCESS (0.002s) [418.441085] Starting dynamic subtest: vcs0 [418.444419] Dynamic subtest vcs0: SUCCESS (0.002s) [418.485075] Starting dynamic subtest: vcs1 [418.488254] Dynamic subtest vcs1: SUCCESS (0.002s) [418.528319] Starting dynamic subtest: vecs0 [418.531416] Dynamic subtest vecs0: SUCCESS (0.002s) [418.572064] Starting dynamic subtest: ccs0 [418.575208] Dynamic subtest ccs0: SUCCESS (0.002s) [418.578431] Subtest init-sema: SUCCESS (0.043s) [418.645114] [061/142] (596s left) kms_color (legacy-gamma-reset) [419.130160] Starting subtest: legacy-gamma-reset [419.133454] Starting dynamic subtest: pipe-A [421.467348] Dynamic subtest pipe-A: SUCCESS (2.337s) [421.509559] Starting dynamic subtest: pipe-B [423.383152] Dynamic subtest pipe-B: SUCCESS (1.910s) [423.426099] Starting dynamic subtest: pipe-C [424.491701] Dynamic subtest pipe-C: SUCCESS (1.107s) [424.508630] Starting dynamic subtest: pipe-D [424.936499] Dynamic subtest pipe-D: SUCCESS (0.445s) [424.938727] Subtest legacy-gamma-reset: SUCCESS (5.812s) [425.316222] [062/142] (590s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions) [425.887827] Starting subtest: flip-vs-cursor-atomic-transitions [432.074464] Subtest flip-vs-cursor-atomic-transitions: FAIL (5.429s) [432.149525] [063/142] (583s left) gem_eio (in-flight-contexts-1us) [434.249672] Starting subtest: in-flight-contexts-1us [473.619988] Subtest in-flight-contexts-1us: SUCCESS (39.373s) [475.655366] [064/142] (540s left) i915_query (query-regions-unallocated) [476.028560] Starting subtest: query-regions-unallocated [476.032106] Subtest query-regions-unallocated: SUCCESS (0.000s) [476.175156] [065/142] (539s left) gem_tiled_pread_basic [476.665567] [066/142] (539s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render) [477.215945] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render [477.222937] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [477.392191] [067/142] (538s left) gem_create (create-ext-placement-sanity-check) [477.926744] Starting subtest: create-ext-placement-sanity-check [477.946615] Subtest create-ext-placement-sanity-check: SUCCESS (0.017s) [478.097935] [068/142] (538s left) kms_cursor_crc (cursor-onscreen-128x42) [479.030763] Starting subtest: cursor-onscreen-128x42 [479.057239] Starting dynamic subtest: pipe-A-eDP-1 [483.019401] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.962s) [483.216519] Starting dynamic subtest: pipe-D-eDP-1 [488.578833] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.407s) [488.582492] Subtest cursor-onscreen-128x42: SUCCESS (9.553s) [489.662157] [069/142] (526s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs) [491.211198] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs [491.226863] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs: SKIP (0.013s) [492.042193] [070/142] (524s left) gem_eio (in-flight-contexts-immediate) [494.020412] Starting subtest: in-flight-contexts-immediate [537.131941] Subtest in-flight-contexts-immediate: SUCCESS (43.117s) [538.680355] [071/142] (477s left) kms_big_fb (y-tiled-16bpp-rotate-90) [539.225380] Starting subtest: y-tiled-16bpp-rotate-90 [539.232153] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s) [539.398970] [072/142] (477s left) prime_self_import (basic-with_two_bos) [539.762779] Starting subtest: basic-with_two_bos [539.781942] Subtest basic-with_two_bos: SUCCESS (0.015s) [539.943196] [073/142] (476s left) kms_busy (basic-hang) [540.433846] Starting subtest: basic-hang [540.441986] Starting dynamic subtest: flip-pipe-A [541.843630] Dynamic subtest flip-pipe-A: SUCCESS (1.396s) [541.896769] Starting dynamic subtest: modeset-pipe-A [547.131662] Dynamic subtest modeset-pipe-A: SUCCESS (5.289s) [547.195968] Starting dynamic subtest: flip-pipe-D [549.628803] Dynamic subtest flip-pipe-D: SUCCESS (2.476s) [549.689162] Starting dynamic subtest: modeset-pipe-D [554.576852] Dynamic subtest modeset-pipe-D: SUCCESS (4.942s) [554.580688] Subtest basic-hang: SUCCESS (14.145s) [555.527809] [074/142] (461s left) gen7_exec_parse (bitmasks) [555.933339] Subtest bitmasks: SKIP (0.000s) [556.063292] [075/142] (460s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible) [556.483551] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible [556.655891] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.168s) [556.833607] [076/142] (460s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt) [557.346677] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt [557.353651] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [557.521073] [077/142] (459s left) kms_psr2_sf (primary-plane-update-sf-dmg-area-big-fb) [564.765882] Starting subtest: primary-plane-update-sf-dmg-area-big-fb [564.774788] Starting dynamic subtest: pipe-A-eDP-1 [588.636313] Dynamic subtest pipe-A-eDP-1: SUCCESS (23.861s) [588.680666] Starting dynamic subtest: pipe-B-eDP-1 [613.985793] Dynamic subtest pipe-B-eDP-1: SUCCESS (25.337s) [613.989156] Subtest primary-plane-update-sf-dmg-area-big-fb: SUCCESS (49.219s) [615.162954] [078/142] (401s left) kms_flip (2x-flip-vs-expired-vblank-interruptible) [615.575845] Starting subtest: 2x-flip-vs-expired-vblank-interruptible [615.743813] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.164s) [615.915916] [079/142] (401s left) kms_ccs (pipe-a-bad-pixel-format-4_tiled_mtl_mc_ccs) [616.398798] Starting subtest: pipe-A-bad-pixel-format-4_tiled_mtl_mc_ccs [616.409321] Subtest pipe-A-bad-pixel-format-4_tiled_mtl_mc_ccs: SUCCESS (0.006s) [618.349692] [080/142] (398s left) syncobj_timeline (32bits-limit) [618.722452] Starting subtest: 32bits-limit [618.726131] Subtest 32bits-limit: SUCCESS (0.004s) [618.883261] [081/142] (398s left) dmabuf_sync_file (export-wait-after-attach) [619.260690] Starting subtest: export-wait-after-attach [619.264143] Subtest export-wait-after-attach: SUCCESS (0.003s) [619.402537] [082/142] (398s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [619.968531] Starting subtest: basic-flip-after-cursor-varying-size [621.374088] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.399s) [622.325597] [083/142] (395s left) gem_cs_tlb (engines) [622.722362] Starting subtest: engines [622.725994] Starting dynamic subtest: rcs0 [624.896689] Dynamic subtest rcs0: SUCCESS (2.169s) [624.944841] Starting dynamic subtest: bcs0 [627.069694] Dynamic subtest bcs0: SUCCESS (2.166s) [627.122373] Starting dynamic subtest: vcs0 [629.240324] Dynamic subtest vcs0: SUCCESS (2.166s) [629.283689] Starting dynamic subtest: vcs1 [631.415258] Dynamic subtest vcs1: SUCCESS (2.170s) [631.462436] Starting dynamic subtest: vecs0 [633.588451] Dynamic subtest vecs0: SUCCESS (2.168s) [633.638065] Starting dynamic subtest: ccs0 [635.759370] Dynamic subtest ccs0: SUCCESS (2.168s) [635.763922] Subtest engines: SUCCESS (13.036s) [635.976249] [084/142] (381s left) sysfs_preempt_timeout (timeout) [636.366487] Starting subtest: timeout [636.375780] Starting dynamic subtest: vecs0 [757.480343] Per-test timeout exceeded. Killing the current test with SIGQUIT. [759.622250] Closing watchdogs [759.629332] Initializing watchdogs [759.629666] /dev/watchdog0 [759.687962] [085/142] (258s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic) [760.283441] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic [760.301529] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.016s) [760.648752] [086/142] (257s left) api_intel_allocator (fork-simple-stress) [761.023691] Starting subtest: fork-simple-stress [766.634068] Subtest fork-simple-stress: SUCCESS (5.612s) [766.753164] [087/142] (251s left) gem_readwrite (read-write) [767.132337] Subtest read-write: SKIP (0.000s) [767.271165] [088/142] (250s left) kms_color (ctm-red-to-blue) [767.758178] Starting subtest: ctm-red-to-blue [767.761762] Starting dynamic subtest: pipe-A [769.049446] Dynamic subtest pipe-A: SUCCESS (1.290s) [769.096247] Starting dynamic subtest: pipe-B [771.842905] Dynamic subtest pipe-B: FAIL (1.994s) [771.893084] Starting dynamic subtest: pipe-C [774.122315] Dynamic subtest pipe-C: FAIL (2.255s) [774.172612] Starting dynamic subtest: pipe-D [776.844822] Dynamic subtest pipe-D: FAIL (2.740s) [776.848211] Subtest ctm-red-to-blue: FAIL (8.293s) [777.230415] [089/142] (240s left) gem_exec_schedule (submit-golden-slice) [777.671442] Starting subtest: submit-golden-slice [777.675277] Starting dynamic subtest: rcs0 [777.809479] Dynamic subtest rcs0: SUCCESS (0.135s) [777.858383] Starting dynamic subtest: bcs0 [777.939556] Dynamic subtest bcs0: SUCCESS (0.127s) [777.988052] Starting dynamic subtest: vcs0 [778.075537] Dynamic subtest vcs0: SUCCESS (0.133s) [778.125799] Starting dynamic subtest: vcs1 [778.199601] Dynamic subtest vcs1: SUCCESS (0.121s) [778.246567] Starting dynamic subtest: vecs0 [778.325624] Dynamic subtest vecs0: SUCCESS (0.122s) [778.376648] Starting dynamic subtest: ccs0 [778.456759] Dynamic subtest ccs0: SUCCESS (0.128s) [778.460384] Subtest submit-golden-slice: SUCCESS (0.787s) [779.687376] [090/142] (238s left) kms_chamelium_color (ctm-max) [780.181043] Subtest ctm-max: SKIP (0.000s) [780.298709] [091/142] (238s left) vc4/vc4_wait_bo (bad-pad) [780.773327] Subtest bad-pad: SKIP (0.000s) [780.910157] [092/142] (237s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs) [782.701863] Starting subtest: pipe-D-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs [803.584838] Subtest pipe-D-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs: SUCCESS (20.883s) [804.916957] [093/142] (213s left) kms_plane (plane-position-covered) [805.422943] Starting subtest: plane-position-covered [805.428935] Starting dynamic subtest: pipe-A-planes [813.407434] Dynamic subtest pipe-A-planes: SUCCESS (7.980s) [813.465713] Starting dynamic subtest: pipe-B-planes [822.165739] Dynamic subtest pipe-B-planes: SUCCESS (8.747s) [822.169173] Subtest plane-position-covered: SUCCESS (16.750s) [823.029218] [094/142] (195s left) kms_big_fb (x-tiled-addfb-size-overflow) [823.572828] Starting subtest: x-tiled-addfb-size-overflow [823.576767] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.003s) [823.759814] [095/142] (194s left) gem_workarounds (suspend-resume-context) [824.216267] Starting subtest: suspend-resume-context [840.975157] Subtest suspend-resume-context: SUCCESS (16.759s) [841.193549] [096/142] (177s left) gem_lmem_swapping (verify-random) [841.587855] Subtest verify-random: SKIP (0.000s) [841.717676] [097/142] (177s left) kms_psr_stress_test (flip-primary-invalidate-overlay) [842.195800] Starting subtest: flip-primary-invalidate-overlay [859.925841] Subtest flip-primary-invalidate-overlay: SUCCESS (17.732s) [860.448097] [098/142] (158s left) i915_pm_rpm (modeset-non-lpsp-stress) [866.540238] Starting subtest: modeset-non-lpsp-stress [870.505052] Subtest modeset-non-lpsp-stress: SKIP (3.961s) [871.378459] [099/142] (147s left) v3d/v3d_submit_cl (job-perfmon) [871.843319] Subtest job-perfmon: SKIP (0.000s) [871.984327] [100/142] (147s left) kms_big_fb (4-tiled-16bpp-rotate-270) [872.512414] Starting subtest: 4-tiled-16bpp-rotate-270 [872.578902] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.057s) [872.773255] [101/142] (146s left) kms_cursor_edge_walk (64x64-right-edge) [873.253079] Starting subtest: 64x64-right-edge [873.257736] Starting dynamic subtest: pipe-A-eDP-1 [877.134119] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.871s) [877.193868] Starting dynamic subtest: pipe-D-eDP-1 [880.598332] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.457s) [880.601876] Subtest 64x64-right-edge: SUCCESS (7.350s) [881.551080] [102/142] (137s left) gem_ctx_persistence (engines-persistence) [881.947444] Starting subtest: engines-persistence [881.951132] Starting dynamic subtest: rcs0 [882.760568] Dynamic subtest rcs0: SUCCESS (0.811s) [882.823533] Starting dynamic subtest: bcs0 [883.519911] Dynamic subtest bcs0: SUCCESS (0.755s) [883.576303] Starting dynamic subtest: vcs0 [884.290819] Dynamic subtest vcs0: SUCCESS (0.767s) [884.346495] Starting dynamic subtest: vcs1 [885.060492] Dynamic subtest vcs1: SUCCESS (0.766s) [885.122501] Starting dynamic subtest: vecs0 [885.820463] Dynamic subtest vecs0: SUCCESS (0.756s) [885.881602] Starting dynamic subtest: ccs0 [886.582277] Dynamic subtest ccs0: SUCCESS (0.757s) [886.585964] Subtest engines-persistence: SUCCESS (4.637s) [886.807565] [103/142] (132s left) gem_exec_params (invalid-ring2) [887.200535] Starting subtest: invalid-ring2 [887.205516] Subtest invalid-ring2: SUCCESS (0.001s) [887.404523] [104/142] (132s left) gem_mmap_gtt (basic-read-write-distinct) [887.787897] Subtest basic-read-write-distinct: SKIP (0.000s) [887.886256] [105/142] (131s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc) [888.953056] Starting subtest: pipe-A-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc [888.969362] Subtest pipe-A-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.013s) [890.267430] [106/142] (129s left) kms_big_fb (y-tiled-64bpp-rotate-270) [890.807371] Starting subtest: y-tiled-64bpp-rotate-270 [890.815239] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s) [890.970344] [107/142] (128s left) kms_ccs (pipe-d-bad-pixel-format-y_tiled_ccs) [892.531180] Starting subtest: pipe-D-bad-pixel-format-y_tiled_ccs [892.537585] Subtest pipe-D-bad-pixel-format-y_tiled_ccs: SKIP (0.000s) [893.343207] [108/142] (126s left) kms_dsc (dsc-with-bpc) [893.832312] Starting subtest: dsc-with-bpc [893.838971] Subtest dsc-with-bpc: SKIP (0.006s) [893.999622] [109/142] (126s left) kms_universal_plane (cursor-fb-leak-pipe-a) [894.469433] Starting subtest: cursor-fb-leak-pipe-A [895.591546] Subtest cursor-fb-leak-pipe-A: SUCCESS (1.120s) [896.544795] [110/142] (123s left) kms_lease (lease_invalid_crtc) [897.023848] Starting subtest: lease_invalid_crtc [897.032790] Starting dynamic subtest: pipe-A-eDP-1 [897.035743] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [897.092814] Starting dynamic subtest: pipe-B-eDP-1 [897.096667] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [897.151354] Starting dynamic subtest: pipe-C-eDP-1 [897.154493] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [897.208180] Starting dynamic subtest: pipe-D-eDP-1 [897.211361] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [897.214402] Subtest lease_invalid_crtc: SUCCESS (0.037s) [897.292778] [111/142] (122s left) kms_ccs (pipe-b-crc-primary-rotation-180-y_tiled_gen12_rc_ccs) [898.464304] Starting subtest: pipe-B-crc-primary-rotation-180-y_tiled_gen12_rc_ccs [898.471333] Subtest pipe-B-crc-primary-rotation-180-y_tiled_gen12_rc_ccs: SKIP (0.002s) [899.656708] [112/142] (120s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [900.152860] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [900.159840] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [900.335163] [113/142] (120s left) kms_flip (2x-flip-vs-absolute-wf_vblank) [900.725342] Starting subtest: 2x-flip-vs-absolute-wf_vblank [900.892376] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.164s) [901.104511] [114/142] (119s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [901.624900] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt [901.632268] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [901.799414] [115/142] (118s left) gem_exec_alignment (pi) [902.203395] Starting subtest: pi [914.854848] Killing the test because the kernel is tainted. [917.360449] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1852 [max: 8192] direct dependencies: 20312 [max: 32768] indirect dependencies: 165016 all direct dependencies: 410890 dependency chains: 30438 [max: 131072] dependency chain hlocks used: 132350 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 347 in-softirq chains: 611 in-process chains: 29480 stack-trace entries: 205216 [max: 1048576] number of stack traces: 10163 number of stack hash chains: 7559 combined max dependencies: 1983778160 hardirq-safe locks: 119 hardirq-unsafe locks: 1091 softirq-safe locks: 211 softirq-unsafe locks: 1003 irq-safe locks: 239 irq-unsafe locks: 1091 hardirq-read-safe locks: 3 hardirq-read-unsafe locks: 333 softirq-read-safe locks: 7 softirq-read-unsafe locks: 328 irq-read-safe locks: 7 irq-read-unsafe locks: 333 uncategorized locks: 302 unused locks: 1 max locking depth: 17 max bfs queue depth: 445 max lock class index: 1851 chain lookup misses: 35264 chain lookup hits: 436246546 cyclic checks: 35577 redundant checks: 0 redundant links: 0 find-mask forwards checks: 6437 find-mask backwards checks: 3023 hardirq on events: 253341768 hardirq off events: 253341746 redundant hardirq ons: 58 redundant hardirq offs: 27 softirq on events: 1133648 softirq off events: 1133648 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 191 zapped lock chains: 4343 large chain blocks: 1 [917.367272] Closing watchdogs Done.