[39.624442] Initializing watchdogs [39.624567] /dev/watchdog0 [39.636156] [001/145] (960s left) kms_ccs (pipe-a-bad-rotation-90-4-tiled-dg2-rc-ccs-cc) [40.056310] Starting subtest: pipe-A-bad-rotation-90-4-tiled-dg2-rc-ccs-cc [40.061093] Subtest pipe-A-bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s) [40.931462] [002/145] (959s left) gem_mmap_gtt (big-copy) [40.992806] Subtest big-copy: SKIP (0.000s) [41.036405] [003/145] (959s left) gem_eio (in-flight-internal-immediate) [41.197506] Starting subtest: in-flight-internal-immediate [42.482819] Subtest in-flight-internal-immediate: SUCCESS (1.287s) [42.587228] [004/145] (957s left) kms_getfb (getfb-handle-not-fb) [42.647787] Starting subtest: getfb-handle-not-fb [42.665626] Subtest getfb-handle-not-fb: SUCCESS (0.019s) [42.739457] [005/145] (957s left) gem_ctx_shared (create-shared-gtt) [42.825420] Starting subtest: create-shared-gtt [44.983371] Subtest create-shared-gtt: SUCCESS (2.155s) [45.295626] [006/145] (954s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [45.388616] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip [46.442816] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (1.058s) [46.610243] [007/145] (953s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move) [46.737332] Starting subtest: psr-2p-scndscrn-cur-indfb-move [46.742084] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [46.816650] [008/145] (953s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu) [46.935553] Starting subtest: psr-rgb565-draw-mmap-cpu [51.706055] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (4.774s) [51.807118] [009/145] (948s left) kms_psr2_sf (fbc-overlay-plane-move-continuous-exceed-sf) [57.139383] Starting subtest: fbc-overlay-plane-move-continuous-exceed-sf [57.142206] Starting dynamic subtest: pipe-A-eDP-1 [57.973049] Dynamic subtest pipe-A-eDP-1: SKIP (0.832s) [57.986392] Starting dynamic subtest: pipe-B-eDP-1 [59.197560] Dynamic subtest pipe-B-eDP-1: SKIP (1.222s) [59.202427] Subtest fbc-overlay-plane-move-continuous-exceed-sf: SKIP (2.059s) [60.460378] [010/145] (939s left) kms_ccs (pipe-d-bad-aux-stride-4-tiled-mtl-rc-ccs) [60.884494] Starting subtest: pipe-D-bad-aux-stride-4-tiled-mtl-rc-ccs [60.887709] Subtest pipe-D-bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.000s) [61.716104] [011/145] (938s left) kms_ccs (pipe-d-crc-primary-rotation-180-yf-tiled-ccs) [62.159559] Starting subtest: pipe-D-crc-primary-rotation-180-yf-tiled-ccs [62.164813] Subtest pipe-D-crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.000s) [63.017995] [012/145] (937s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc) [63.388568] Starting subtest: pipe-A-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc [63.393495] Subtest pipe-A-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.001s) [64.296832] [013/145] (936s left) gem_exec_balancer (waits) [64.370763] Starting subtest: waits [70.564528] Subtest waits: SUCCESS (6.192s) [70.824268] [014/145] (929s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt) [70.896679] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt [70.900481] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [70.975947] [015/145] (929s left) kms_addfb_basic (bo-too-small) [71.074383] Starting subtest: bo-too-small [71.076723] Subtest bo-too-small: SUCCESS (0.000s) [71.155344] [016/145] (929s left) i915_pm_rpm (gem-mmap-type) [72.700279] Starting subtest: gem-mmap-type [72.703081] Starting dynamic subtest: gtt-smem0 [73.438475] Dynamic subtest gtt-smem0: SKIP (0.736s) [73.456611] Starting dynamic subtest: wb-smem0 [75.739047] Dynamic subtest wb-smem0: SUCCESS (2.302s) [75.754467] Starting dynamic subtest: wc-smem0 [78.063133] Dynamic subtest wc-smem0: SUCCESS (2.323s) [78.080282] Starting dynamic subtest: uc-smem0 [80.374229] Dynamic subtest uc-smem0: SUCCESS (2.312s) [80.376835] Subtest gem-mmap-type: SUCCESS (7.674s) [80.457516] [017/145] (920s left) kms_psr (psr2-sprite-mmap-cpu) [80.553409] Starting subtest: psr2-sprite-mmap-cpu [80.555807] Starting dynamic subtest: eDP-1 [82.419456] Dynamic subtest eDP-1: SUCCESS (1.862s) [82.422080] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.864s) [83.311635] [018/145] (917s left) kms_atomic_transition (modeset-transition) [83.399362] Starting subtest: modeset-transition [83.401874] Starting dynamic subtest: 1x-outputs [95.570718] Dynamic subtest 1x-outputs: SUCCESS (12.172s) [95.860548] Subtest modeset-transition: SUCCESS (12.461s) [96.748685] [019/145] (903s left) gem_exec_schedule (smoketest) [96.946220] Starting subtest: smoketest [96.948807] Starting dynamic subtest: rcs0 [102.561384] Dynamic subtest rcs0: SUCCESS (5.554s) [102.578625] Starting dynamic subtest: bcs0 [108.142435] Dynamic subtest bcs0: SUCCESS (5.586s) [108.151133] Starting dynamic subtest: vcs0 [113.685489] Dynamic subtest vcs0: SUCCESS (5.544s) [113.695787] Starting dynamic subtest: vcs1 [119.241490] Dynamic subtest vcs1: SUCCESS (5.550s) [119.256946] Starting dynamic subtest: vecs0 [124.834232] Dynamic subtest vecs0: SUCCESS (5.545s) [124.844493] Starting dynamic subtest: ccs0 [130.432452] Dynamic subtest ccs0: SUCCESS (5.592s) [130.434839] Subtest smoketest: SUCCESS (33.375s) [130.529835] [020/145] (870s left) syncobj_eventfd (invalid-illegal-eventfd) [130.607342] Starting subtest: invalid-illegal-eventfd [130.609794] Subtest invalid-illegal-eventfd: SUCCESS (0.000s) [130.684601] [021/145] (869s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation) [130.793420] Starting subtest: plane-scaler-with-clipping-clamping-rotation [130.795890] Starting dynamic subtest: pipe-A-eDP-1 [131.323046] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.529s) [131.337117] Starting dynamic subtest: pipe-B-eDP-1 [132.997651] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.672s) [133.014755] Starting dynamic subtest: pipe-C-eDP-1 [134.750757] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.750s) [134.767474] Starting dynamic subtest: pipe-D-eDP-1 [136.469852] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.715s) [136.472758] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (5.677s) [137.705694] [022/145] (862s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic) [137.821421] Starting subtest: 2x-long-cursor-vs-flip-atomic [137.826362] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s) [137.926154] [023/145] (862s left) kms_big_fb (yf-tiled-16bpp-rotate-0) [138.042160] Starting subtest: yf-tiled-16bpp-rotate-0 [138.046340] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s) [138.125286] [024/145] (862s left) gem_exec_reloc (basic-concurrent16) [138.206681] Subtest basic-concurrent16: SKIP (0.000s) [138.244061] [025/145] (862s left) vgem_basic (bad-pad) [138.328476] Starting subtest: bad-pad [138.330519] Subtest bad-pad: SUCCESS (0.000s) [138.365398] [026/145] (862s left) kms_ccs (pipe-c-crc-primary-rotation-180-y-tiled-ccs) [138.785033] Starting subtest: pipe-C-crc-primary-rotation-180-y-tiled-ccs [138.790400] Subtest pipe-C-crc-primary-rotation-180-y-tiled-ccs: SKIP (0.000s) [139.628630] [027/145] (861s left) kms_chamelium_frames (hdmi-cmp-planar-formats) [140.004445] Subtest hdmi-cmp-planar-formats: SKIP (0.000s) [140.878157] [028/145] (859s left) gem_create (create-ext-placement-all) [141.081761] Starting subtest: create-ext-placement-all [141.085069] Subtest create-ext-placement-all: SUCCESS (0.000s) [141.156139] [029/145] (859s left) kms_busy (basic) [141.249067] Starting subtest: basic [141.251504] Starting dynamic subtest: flip [141.909941] Dynamic subtest flip: SUCCESS (0.662s) [141.924422] Starting dynamic subtest: modeset [145.631687] Dynamic subtest modeset: SUCCESS (3.720s) [145.634533] Subtest basic: SUCCESS (4.385s) [146.540183] [030/145] (854s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt) [146.613136] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt [151.987140] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (5.378s) [152.103683] [031/145] (848s left) gem_pxp (reject-modify-context-protection-off-1) [154.766087] Subtest reject-modify-context-protection-off-1: SKIP (0.000s) [154.798043] [032/145] (846s left) kms_plane_multiple (tiling-y) [154.897387] Starting subtest: tiling-y [154.901339] Subtest tiling-y: SKIP (0.000s) [154.963527] [033/145] (845s left) kms_async_flips (test-time-stamp) [155.050547] Starting subtest: test-time-stamp [155.419954] Starting dynamic subtest: pipe-A-eDP-1 [156.265915] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.844s) [156.648327] Starting dynamic subtest: pipe-B-eDP-1 [157.528167] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.890s) [157.907201] Starting dynamic subtest: pipe-C-eDP-1 [158.743375] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.845s) [159.132795] Starting dynamic subtest: pipe-D-eDP-1 [160.021939] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.902s) [160.024571] Subtest test-time-stamp: SUCCESS (4.974s) [161.260636] [034/145] (839s left) kms_big_fb (y-tiled-addfb-size-overflow) [161.379354] Starting subtest: y-tiled-addfb-size-overflow [161.384718] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s) [161.466167] [035/145] (839s left) perf_pmu (busy-idle-no-semaphores) [161.529514] Starting subtest: busy-idle-no-semaphores [161.532537] Starting dynamic subtest: rcs0 [162.167060] Dynamic subtest rcs0: SUCCESS (0.635s) [162.181969] Starting dynamic subtest: bcs0 [162.822191] Dynamic subtest bcs0: SUCCESS (0.654s) [162.837520] Starting dynamic subtest: vcs0 [163.476187] Dynamic subtest vcs0: SUCCESS (0.653s) [163.491972] Starting dynamic subtest: vcs1 [165.084619] Dynamic subtest vcs1: SUCCESS (1.607s) [165.099677] Starting dynamic subtest: vecs0 [167.070808] Dynamic subtest vecs0: SUCCESS (1.983s) [167.086266] Starting dynamic subtest: ccs0 [169.053504] Dynamic subtest ccs0: SUCCESS (1.984s) [169.056452] Subtest busy-idle-no-semaphores: SUCCESS (7.523s) [169.167794] [036/145] (831s left) syncobj_timeline (invalid-signal-illegal-handle) [169.242406] Starting subtest: invalid-signal-illegal-handle [169.245378] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [169.330618] [037/145] (831s left) gem_exec_reloc (basic-cpu) [169.386054] Subtest basic-cpu: SKIP (0.000s) [169.443587] [038/145] (831s left) gem_lmem_swapping (smem-oom) [169.509399] Subtest smem-oom: SKIP (0.000s) [169.549691] [039/145] (831s left) vc4/vc4_dmabuf_poll (poll-write-waits-until-write-done) [169.610838] Subtest poll-write-waits-until-write-done: SKIP (0.000s) [169.658534] [040/145] (831s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted) [169.722990] Starting subtest: etime-single-wait-all-for-submit-submitted [169.828169] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.106s) [169.904472] [041/145] (831s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled) [169.986671] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled [169.992174] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s) [170.171723] [042/145] (831s left) v3d/v3d_submit_cl (multisync-out-syncs) [170.251884] Subtest multisync-out-syncs: SKIP (0.000s) [170.299566] [043/145] (830s left) gem_workarounds (basic-read) [170.375324] Starting subtest: basic-read [170.394547] Subtest basic-read: SUCCESS (0.019s) [170.490813] [044/145] (830s left) gem_exec_fence (basic-busy) [170.693876] Starting subtest: basic-busy [170.696673] Starting dynamic subtest: rcs0 [170.777645] Dynamic subtest rcs0: SUCCESS (0.084s) [170.792746] Starting dynamic subtest: bcs0 [170.837457] Dynamic subtest bcs0: SUCCESS (0.059s) [170.851990] Starting dynamic subtest: vcs0 [170.898637] Dynamic subtest vcs0: SUCCESS (0.060s) [170.913420] Starting dynamic subtest: vcs1 [170.952714] Dynamic subtest vcs1: SUCCESS (0.053s) [170.967928] Starting dynamic subtest: vecs0 [171.007984] Dynamic subtest vecs0: SUCCESS (0.054s) [171.022486] Starting dynamic subtest: ccs0 [171.067442] Dynamic subtest ccs0: SUCCESS (0.059s) [171.070607] Subtest basic-busy: SUCCESS (0.375s) [172.527464] [045/145] (828s left) gem_busy (close-race) [172.609970] Starting subtest: close-race [198.448481] Subtest close-race: SUCCESS (25.836s) [198.804617] [046/145] (802s left) dumb_buffer (map-uaf) [198.952916] Starting subtest: map-uaf [198.955546] Subtest map-uaf: SUCCESS (0.004s) [199.032978] [047/145] (802s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [199.151821] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [199.156903] Starting dynamic subtest: pipe-A-default-mode [199.453556] Dynamic subtest pipe-A-default-mode: SKIP (0.294s) [199.459217] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.298s) [200.362845] [048/145] (801s left) kms_ccs (pipe-d-bad-pixel-format-4-tiled-dg2-mc-ccs) [200.799927] Starting subtest: pipe-D-bad-pixel-format-4-tiled-dg2-mc-ccs [200.806103] Subtest pipe-D-bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.000s) [201.643742] [049/145] (799s left) v3d/v3d_submit_csd (multi-and-single-sync) [201.763522] Subtest multi-and-single-sync: SKIP (0.000s) [201.814508] [050/145] (799s left) kms_lease (cursor-implicit-plane) [201.911970] Starting subtest: cursor-implicit-plane [201.914435] Starting dynamic subtest: pipe-A-eDP-1 [202.402965] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.494s) [202.421543] Starting dynamic subtest: pipe-B-eDP-1 [203.631319] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.221s) [203.647682] Starting dynamic subtest: pipe-C-eDP-1 [204.823797] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.192s) [204.839563] Starting dynamic subtest: pipe-D-eDP-1 [206.042305] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.213s) [206.044998] Subtest cursor-implicit-plane: SUCCESS (4.131s) [206.957636] [051/145] (794s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw) [207.063515] Starting subtest: fbc-1p-pri-indfb-multidraw [218.255564] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (11.196s) [218.387519] [052/145] (783s left) vc4/vc4_purgeable_bo (mark-purgeable) [218.498458] Subtest mark-purgeable: SKIP (0.000s) [218.543247] [053/145] (782s left) gen9_exec_parse (batch-invalid-length) [218.591416] Subtest batch-invalid-length: SKIP (0.000s) [218.654854] [054/145] (782s left) kms_vblank (ts-continuation-modeset) [218.753559] Starting subtest: ts-continuation-modeset [218.755243] Starting dynamic subtest: pipe-A-eDP-1 [220.408022] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.653s) [220.425093] Starting dynamic subtest: pipe-D-eDP-1 [222.756686] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.339s) [222.759254] Subtest ts-continuation-modeset: SUCCESS (4.001s) [223.663124] [055/145] (777s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes) [224.260089] Starting subtest: syncobj-timeline-multiple-ext-nodes [224.265837] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.006s) [225.514072] [056/145] (776s left) syncobj_wait (multi-wait-submitted-signaled) [225.593141] Starting subtest: multi-wait-submitted-signaled [225.595634] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s) [225.676210] [057/145] (775s left) kms_ccs (pipe-c-bad-aux-stride-y-tiled-ccs) [226.125164] Starting subtest: pipe-C-bad-aux-stride-y-tiled-ccs [226.131211] Subtest pipe-C-bad-aux-stride-y-tiled-ccs: SKIP (0.000s) [226.991621] [058/145] (774s left) kms_cursor_legacy (torture-bo) [227.103505] Starting subtest: torture-bo [227.105520] Starting dynamic subtest: pipe-A [232.928785] Dynamic subtest pipe-A: SUCCESS (5.821s) [232.948529] Starting dynamic subtest: pipe-B [239.533334] Dynamic subtest pipe-B: SUCCESS (6.602s) [239.549168] Starting dynamic subtest: pipe-C [246.575189] Dynamic subtest pipe-C: SUCCESS (7.042s) [246.592900] Starting dynamic subtest: pipe-D [253.628757] Dynamic subtest pipe-D: SUCCESS (7.052s) [253.644863] Starting dynamic subtest: all-pipes [260.630745] Dynamic subtest all-pipes: SUCCESS (7.001s) [260.633412] Subtest torture-bo: SUCCESS (33.527s) [260.780640] [059/145] (740s left) kms_cursor_crc (cursor-random-512x170) [261.155585] Starting subtest: cursor-random-512x170 [261.160362] Subtest cursor-random-512x170: SKIP (0.001s) [261.276679] [060/145] (740s left) gem_render_copy (y-tiled-ccs-to-linear) [261.356451] Starting subtest: y-tiled-ccs-to-linear [261.361210] Subtest y-tiled-ccs-to-linear: SKIP (0.000s) [261.538281] [061/145] (740s left) kms_ccs (pipe-b-crc-primary-basic-4-tiled-xe2-ccs) [261.930453] Starting subtest: pipe-B-crc-primary-basic-4-tiled-xe2-ccs [261.935472] Subtest pipe-B-crc-primary-basic-4-tiled-xe2-ccs: SKIP (0.000s) [262.831987] [062/145] (738s left) v3d/v3d_create_bo (create-bo-0) [262.912895] Subtest create-bo-0: SKIP (0.000s) [262.958153] [063/145] (738s left) kms_dither (fb-8bpc-vs-panel-8bpc) [263.049105] Starting subtest: fb-8bpc-vs-panel-8bpc [263.051725] Starting dynamic subtest: pipe-A-eDP-1 [264.504290] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.457s) [264.506764] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.458s) [265.392463] [064/145] (736s left) kms_ccs (pipe-b-random-ccs-data-yf-tiled-ccs) [265.791841] Starting subtest: pipe-B-random-ccs-data-yf-tiled-ccs [265.799467] Subtest pipe-B-random-ccs-data-yf-tiled-ccs: SKIP (0.000s) [266.670101] [065/145] (735s left) kms_big_fb (x-tiled-32bpp-rotate-180) [266.745456] Starting subtest: x-tiled-32bpp-rotate-180 [268.614774] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.869s) [268.755962] [066/145] (733s left) kms_sequence (get-busy) [268.829035] Starting subtest: get-busy [268.831365] Starting dynamic subtest: pipe-A-eDP-1 [270.764660] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.934s) [270.780076] Starting dynamic subtest: pipe-B-eDP-1 [273.456725] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.686s) [273.469407] Starting dynamic subtest: pipe-C-eDP-1 [276.112257] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.656s) [276.127565] Starting dynamic subtest: pipe-D-eDP-1 [278.817190] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.701s) [278.819903] Subtest get-busy: SUCCESS (9.987s) [279.723287] [067/145] (722s left) gem_exec_flush (basic-wb-set-default) [279.815794] Starting subtest: basic-wb-set-default [285.292507] Subtest basic-wb-set-default: SUCCESS (5.477s) [285.478818] [068/145] (716s left) kms_flip_event_leak (basic) [285.571928] Starting subtest: basic [285.574337] Starting dynamic subtest: pipe-A-eDP-1 [286.031183] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.454s) [286.049818] Starting dynamic subtest: pipe-B-eDP-1 [287.281855] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.249s) [287.294171] Starting dynamic subtest: pipe-C-eDP-1 [288.482285] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.198s) [288.494798] Starting dynamic subtest: pipe-D-eDP-1 [289.700920] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.216s) [289.703456] Subtest basic: SUCCESS (4.128s) [290.608824] [069/145] (711s left) kms_psr (fbc-psr2-sprite-plane-onoff) [290.682646] Starting subtest: fbc-psr2-sprite-plane-onoff [290.685115] Starting dynamic subtest: eDP-1 [290.690042] Dynamic subtest eDP-1: SKIP (0.000s) [290.697527] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s) [290.786138] [070/145] (711s left) gem_mmap (basic-small-bo) [290.858881] Subtest basic-small-bo: SKIP (0.000s) [290.909209] [071/145] (711s left) kms_color (ctm-max) [291.000651] Starting subtest: ctm-max [291.003123] Starting dynamic subtest: pipe-A [291.793757] Dynamic subtest pipe-A: SUCCESS (0.791s) [291.805021] Starting dynamic subtest: pipe-B [293.306581] Dynamic subtest pipe-B: SUCCESS (1.512s) [293.319381] Starting dynamic subtest: pipe-C [294.724057] Dynamic subtest pipe-C: SUCCESS (1.414s) [294.739897] Starting dynamic subtest: pipe-D [296.226384] Dynamic subtest pipe-D: SUCCESS (1.502s) [296.228739] Subtest ctm-max: SUCCESS (5.224s) [297.133517] [072/145] (704s left) kms_vrr (negative-basic) [297.223136] Starting subtest: negative-basic [297.231182] Starting dynamic subtest: pipe-A-eDP-1 [302.654333] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.426s) [302.961184] Subtest negative-basic: SUCCESS (5.735s) [303.853211] [073/145] (698s left) kms_content_protection (uevent) [303.966729] Starting subtest: uevent [307.522649] Subtest uevent: SKIP (3.553s) [308.780682] [074/145] (693s left) kms_plane_lowres (tiling-none) [308.868411] Starting subtest: tiling-none [308.871024] Starting dynamic subtest: pipe-A-eDP-1 [308.875849] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [309.168063] Starting dynamic subtest: pipe-B-eDP-1 [309.174274] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [309.184187] Starting dynamic subtest: pipe-C-eDP-1 [309.190220] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [309.199477] Starting dynamic subtest: pipe-D-eDP-1 [309.203896] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [309.208390] Subtest tiling-none: SKIP (0.302s) [310.061419] [075/145] (692s left) kms_panel_fitting (legacy) [310.139158] Starting subtest: legacy [310.141572] Starting dynamic subtest: pipe-A-eDP-1 [310.764778] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.625s) [310.795466] Starting dynamic subtest: pipe-B-eDP-1 [312.523474] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.742s) [312.553960] Starting dynamic subtest: pipe-C-eDP-1 [314.292134] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.747s) [314.322959] Starting dynamic subtest: pipe-D-eDP-1 [315.986584] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.674s) [315.989084] Subtest legacy: SUCCESS (5.847s) [317.228428] [076/145] (684s left) kms_chamelium_edid (hdmi-edid-stress-resolution-4k) [317.612437] Subtest hdmi-edid-stress-resolution-4k: SKIP (0.000s) [318.477472] [077/145] (683s left) kms_cursor_legacy (cursora-vs-flipa-atomic) [318.585189] Starting subtest: cursorA-vs-flipA-atomic [329.727965] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.141s) [330.673105] [078/145] (671s left) core_setmaster (master-drop-set-root) [331.317720] Starting subtest: master-drop-set-root [331.322842] Subtest master-drop-set-root: SUCCESS (0.002s) [331.353677] [079/145] (670s left) gem_exec_balancer (nop) [331.443776] Starting subtest: nop [377.759358] Subtest nop: SUCCESS (46.315s) [378.052071] [080/145] (624s left) kms_properties (get_properties-sanity-non-atomic) [378.152155] Starting subtest: get_properties-sanity-non-atomic [378.154655] Subtest get_properties-sanity-non-atomic: SUCCESS (0.003s) [378.221469] [081/145] (624s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [378.328599] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [378.332512] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [378.411716] [082/145] (623s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render) [378.532386] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render [383.383542] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (4.853s) [383.482216] [083/145] (618s left) syncobj_timeline (multi-wait-all-available-signaled) [383.549773] Starting subtest: multi-wait-all-available-signaled [383.552204] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s) [383.640422] [084/145] (618s left) gem_close_race (multigpu-basic-process) [383.736789] Starting subtest: multigpu-basic-process [383.741235] Subtest multigpu-basic-process: SKIP (0.000s) [383.943509] [085/145] (618s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling) [384.027564] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling [384.029970] Starting dynamic subtest: pipe-A-default-mode [384.402163] Dynamic subtest pipe-A-default-mode: SKIP (0.372s) [384.407237] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.374s) [385.198953] [086/145] (617s left) kms_setmode (invalid-clone-exclusive-crtc) [385.274754] Starting subtest: invalid-clone-exclusive-crtc [385.284513] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s) [385.366160] [087/145] (617s left) gem_softpin (evict-prime-sanity-check) [385.446132] Starting subtest: evict-prime-sanity-check [385.448702] Starting dynamic subtest: rcs0 [386.569566] Dynamic subtest rcs0: SUCCESS (1.121s) [386.580775] Starting dynamic subtest: bcs0 [387.672882] Dynamic subtest bcs0: SUCCESS (1.103s) [387.690774] Starting dynamic subtest: vcs0 [389.401959] Dynamic subtest vcs0: SUCCESS (1.726s) [389.419450] Starting dynamic subtest: vcs1 [391.445923] Dynamic subtest vcs1: SUCCESS (2.043s) [391.462052] Starting dynamic subtest: vecs0 [393.379666] Dynamic subtest vecs0: SUCCESS (1.932s) [393.396434] Starting dynamic subtest: ccs0 [394.486255] Dynamic subtest ccs0: SUCCESS (1.106s) [394.502809] Starting dynamic subtest: all [395.592382] Dynamic subtest all: SUCCESS (1.105s) [395.595444] Subtest evict-prime-sanity-check: SUCCESS (10.146s) [395.668131] [088/145] (606s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible) [395.762498] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible [395.765052] Starting dynamic subtest: A-eDP1 [399.650200] Dynamic subtest A-eDP1: SUCCESS (3.884s) [399.669031] Starting dynamic subtest: B-eDP1 [403.106827] Dynamic subtest B-eDP1: SUCCESS (3.455s) [403.123725] Starting dynamic subtest: C-eDP1 [406.560894] Dynamic subtest C-eDP1: SUCCESS (3.455s) [406.575346] Starting dynamic subtest: D-eDP1 [410.014656] Dynamic subtest D-eDP1: SUCCESS (3.452s) [410.021334] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (14.261s) [410.932114] [089/145] (591s left) i915_pm_freq_api (freq-basic-api) [410.998926] Starting subtest: freq-basic-api [411.001933] Starting dynamic subtest: gt0 [411.004554] Dynamic subtest gt0: SUCCESS (0.004s) [411.021468] Starting dynamic subtest: gt1 [411.024455] Dynamic subtest gt1: SUCCESS (0.003s) [411.027648] Subtest freq-basic-api: SUCCESS (0.008s) [411.080206] [090/145] (591s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [411.173740] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip [412.007973] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.836s) [412.147468] [091/145] (590s left) syncobj_timeline (wait-any-complex) [412.213562] Starting subtest: wait-any-complex [412.275364] Subtest wait-any-complex: SUCCESS (0.063s) [412.342108] [092/145] (590s left) sw_sync (sync_busy) [412.409862] Starting subtest: sync_busy [412.412463] Subtest sync_busy: SUCCESS (0.003s) [412.469402] [093/145] (590s left) kms_rotation_crc (sprite-rotation-90) [412.541629] Starting subtest: sprite-rotation-90 [412.545997] Subtest sprite-rotation-90: SKIP (0.001s) [412.612712] [094/145] (590s left) kms_psr (psr2-sprite-plane-onoff) [412.695233] Starting subtest: psr2-sprite-plane-onoff [412.697975] Starting dynamic subtest: eDP-1 [414.570526] Dynamic subtest eDP-1: SUCCESS (1.875s) [414.573217] Subtest psr2-sprite-plane-onoff: SUCCESS (1.876s) [415.468186] [095/145] (587s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu) [415.555551] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu [415.560943] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [415.630549] [096/145] (587s left) gem_exec_schedule (wide) [415.846064] Starting subtest: wide [415.848717] Starting dynamic subtest: rcs0 [425.798982] Dynamic subtest rcs0: SUCCESS (9.901s) [425.811469] Starting dynamic subtest: vcs0 [435.890054] Dynamic subtest vcs0: SUCCESS (10.142s) [435.897936] Starting dynamic subtest: vcs1 [446.724809] Dynamic subtest vcs1: SUCCESS (10.834s) [446.732463] Starting dynamic subtest: vecs0 [456.989238] Dynamic subtest vecs0: SUCCESS (10.263s) [456.997556] Starting dynamic subtest: ccs0 [468.625572] Dynamic subtest ccs0: SUCCESS (11.636s) [468.627934] Subtest wide: SUCCESS (52.780s) [470.682998] [097/145] (532s left) kms_psr (fbc-pr-cursor-render) [470.775828] Starting subtest: fbc-pr-cursor-render [470.780691] Subtest fbc-pr-cursor-render: SKIP (0.000s) [470.878326] [098/145] (531s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc) [470.951436] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc [470.956275] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [471.038127] [099/145] (531s left) dmabuf_sync_file (import-multiple-read-only) [471.109804] Starting subtest: import-multiple-read-only [471.115403] Subtest import-multiple-read-only: SUCCESS (0.007s) [471.177240] [100/145] (531s left) prime_vgem (coherency-gtt) [471.261708] Starting subtest: coherency-gtt [471.266539] Subtest coherency-gtt: SKIP (0.000s) [471.339974] [101/145] (531s left) kms_ccs (pipe-b-bad-rotation-90-y-tiled-gen12-mc-ccs) [471.734941] Starting subtest: pipe-B-bad-rotation-90-y-tiled-gen12-mc-ccs [471.740216] Subtest pipe-B-bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.000s) [472.600726] [102/145] (530s left) gem_softpin (noreloc-s3) [472.670543] Starting subtest: noreloc-S3 [492.071854] Subtest noreloc-S3: SUCCESS (5.403s) [492.178711] [103/145] (524s left) gem_userptr_blits (vma-merge) [492.302367] Starting subtest: vma-merge [512.450295] Subtest vma-merge: FAIL (20.108s) [512.483238] [104/145] (504s left) gem_exec_balancer (bonded-chain) [512.570879] Starting subtest: bonded-chain [519.352991] Subtest bonded-chain: SUCCESS (6.780s) [519.633366] [105/145] (497s left) syncobj_wait (single-wait-signaled) [519.711914] Starting subtest: single-wait-signaled [519.714547] Subtest single-wait-signaled: SUCCESS (0.000s) [519.804788] [106/145] (497s left) kms_3d [522.240723] [107/145] (494s left) kms_prop_blob (invalid-get-prop) [522.316716] Starting subtest: invalid-get-prop [522.319468] Subtest invalid-get-prop: SUCCESS (0.000s) [522.393965] [108/145] (494s left) kms_flip (flip-vs-expired-vblank) [522.489111] Starting subtest: flip-vs-expired-vblank [522.491649] Starting dynamic subtest: A-eDP1 [531.327846] Dynamic subtest A-eDP1: SUCCESS (8.800s) [531.336413] Starting dynamic subtest: B-eDP1 [540.158418] Dynamic subtest B-eDP1: SUCCESS (8.831s) [540.177635] Starting dynamic subtest: C-eDP1 [548.946968] Dynamic subtest C-eDP1: SUCCESS (8.823s) [548.970725] Starting dynamic subtest: D-eDP1 [557.823230] Dynamic subtest D-eDP1: SUCCESS (8.828s) [557.825980] Subtest flip-vs-expired-vblank: SUCCESS (35.298s) [559.084784] [109/145] (458s left) kms_cdclk (mode-transition-all-outputs) [559.182734] Starting subtest: mode-transition-all-outputs [559.486547] Subtest mode-transition-all-outputs: SKIP (0.298s) [560.413602] [110/145] (456s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu) [560.492062] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu [560.496696] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [560.577400] [111/145] (456s left) kms_flip (2x-wf_vblank-ts-check-interruptible) [560.659220] Starting subtest: 2x-wf_vblank-ts-check-interruptible [560.671401] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.013s) [560.748407] [112/145] (456s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw) [560.843370] Starting subtest: psr-1p-pri-indfb-multidraw [581.547409] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (20.711s) [581.644877] [113/145] (435s left) i915_selftest (mock) [583.258791] Starting subtest: mock [583.261600] Starting dynamic subtest: sanitycheck [583.574233] Dynamic subtest sanitycheck: SUCCESS (0.316s) [583.585914] Starting dynamic subtest: shmem [583.798550] Dynamic subtest shmem: SUCCESS (0.223s) [583.810053] Starting dynamic subtest: fence [591.517518] Dynamic subtest fence: SUCCESS (7.717s) [591.529737] Starting dynamic subtest: scatterlist [592.746106] Dynamic subtest scatterlist: SUCCESS (1.227s) [592.758316] Starting dynamic subtest: syncmap [595.520137] Dynamic subtest syncmap: SUCCESS (2.771s) [595.532464] Starting dynamic subtest: uncore [595.736245] Dynamic subtest uncore: SUCCESS (0.217s) [595.748596] Starting dynamic subtest: ring [595.965853] Dynamic subtest ring: SUCCESS (0.229s) [595.977324] Starting dynamic subtest: engine [596.184899] Dynamic subtest engine: SUCCESS (0.218s) [596.197021] Starting dynamic subtest: timelines [599.503372] Dynamic subtest timelines: SUCCESS (3.315s) [599.516009] Starting dynamic subtest: requests [602.288146] Dynamic subtest requests: SUCCESS (2.783s) [602.300145] Starting dynamic subtest: objects [602.575707] Dynamic subtest objects: SUCCESS (0.287s) [602.587834] Starting dynamic subtest: phys [602.891709] Dynamic subtest phys: SUCCESS (0.315s) [602.903122] Starting dynamic subtest: dmabuf [603.197074] Dynamic subtest dmabuf: SUCCESS (0.304s) [603.208844] Starting dynamic subtest: vma [608.681583] Dynamic subtest vma: SUCCESS (5.483s) [608.694381] Starting dynamic subtest: evict [610.130779] Dynamic subtest evict: FAIL (1.401s) [610.135008] Subtest mock: FAIL (26.831s) [610.151290] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1684 [max: 8192] direct dependencies: 17446 [max: 32768] indirect dependencies: 110142 all direct dependencies: 319495 dependency chains: 24813 [max: 131072] dependency chain hlocks used: 102757 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 173 in-softirq chains: 579 in-process chains: 24061 stack-trace entries: 210178 [max: 1048576] number of stack traces: 10442 number of stack hash chains: 7709 combined max dependencies: 2428337040 hardirq-safe locks: 89 hardirq-unsafe locks: 1017 softirq-safe locks: 190 softirq-unsafe locks: 925 irq-safe locks: 208 irq-unsafe locks: 1017 hardirq-read-safe locks: 3 hardirq-read-unsafe locks: 297 softirq-read-safe locks: 7 softirq-read-unsafe locks: 292 irq-read-safe locks: 7 irq-read-unsafe locks: 297 uncategorized locks: 278 unused locks: 1 max locking depth: 16 max bfs queue depth: 465 max lock class index: 1869 chain lookup misses: 33746 chain lookup hits: 1214502298 cyclic checks: 34075 redundant checks: 0 redundant links: 0 find-mask forwards checks: 5542 find-mask backwards checks: 3137 hardirq on events: 624789816 hardirq off events: 624789794 redundant hardirq ons: 58 redundant hardirq offs: 39 softirq on events: 2286980 softirq off events: 2286980 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 480 zapped lock chains: 8450 large chain blocks: 1 [610.154111] Closing watchdogs Done.