[55.702889] Initializing watchdogs [55.702937] /dev/watchdog0 [55.710784] [001/130] (960s left) gem_mmap_gtt (fault-concurrent-x) [55.770997] Subtest fault-concurrent-X: SKIP (0.000s) [55.804394] [002/130] (960s left) gem_softpin (evict-snoop) [55.856606] Starting subtest: evict-snoop [55.861045] Subtest evict-snoop: SKIP (0.000s) [55.939782] [003/130] (960s left) syncobj_wait (wait-all-for-submit-snapshot) [56.008023] Starting subtest: wait-all-for-submit-snapshot [56.090389] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s) [56.143245] [004/130] (960s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180) [56.257490] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180 [57.133762] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (0.886s) [57.245619] [005/130] (959s left) gem_pipe_control_store_loop (reused-buffer) [57.298039] Starting subtest: reused-buffer [59.432886] Subtest reused-buffer: SUCCESS (2.151s) [59.552095] [006/130] (956s left) syncobj_timeline (wait-any-complex) [59.608813] Starting subtest: wait-any-complex [59.668062] Subtest wait-any-complex: SUCCESS (0.062s) [59.722182] [007/130] (956s left) gen9_exec_parse (basic-rejected) [59.792092] Subtest basic-rejected: SKIP (0.000s) [59.848881] [008/130] (956s left) syncobj_timeline (etime-multi-wait-submitted) [59.899817] Starting subtest: etime-multi-wait-submitted [60.007775] Subtest etime-multi-wait-submitted: SUCCESS (0.108s) [60.062751] [009/130] (956s left) kms_mmap_write_crc (main) [60.171722] Starting subtest: main [60.174074] Starting dynamic subtest: pipe-A-eDP-1 [63.281785] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.124s) [63.284137] Subtest main: SUCCESS (3.125s) [64.090854] [010/130] (952s left) kms_fbcon_fbt (fbc-suspend) [64.149545] Starting subtest: fbc-suspend [111.290073] Subtest fbc-suspend: SUCCESS (17.905s) [111.361468] [011/130] (934s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [111.460947] Starting subtest: crc-primary-basic-y-tiled-ccs [111.463271] Starting dynamic subtest: pipe-A-eDP-1 [111.487420] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [111.496619] Starting dynamic subtest: pipe-B-eDP-1 [111.521499] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [111.528581] Starting dynamic subtest: pipe-C-eDP-1 [111.553708] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [111.560712] Starting dynamic subtest: pipe-D-eDP-1 [111.587888] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [111.593165] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.004s) [113.564870] [012/130] (932s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling) [113.665876] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling [113.668143] Starting dynamic subtest: pipe-A-default-mode [116.365174] Dynamic subtest pipe-A-default-mode: SUCCESS (2.714s) [116.367865] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.715s) [117.202456] [013/130] (928s left) gem_exec_whisper (basic-fds-all) [117.278111] Starting subtest: basic-fds-all [128.315973] Subtest basic-fds-all: SUCCESS (11.067s) [128.476454] [014/130] (917s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs) [128.566888] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs [128.569385] Starting dynamic subtest: pipe-A-eDP-1 [128.595225] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [128.604248] Starting dynamic subtest: pipe-B-eDP-1 [128.630678] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [128.638240] Starting dynamic subtest: pipe-C-eDP-1 [128.665219] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [128.672607] Starting dynamic subtest: pipe-D-eDP-1 [128.698379] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [128.703389] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.002s) [130.719504] [015/130] (914s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [130.839297] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [131.572449] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.737s) [131.736284] [016/130] (913s left) kms_pm_rpm (drm-resources-equal) [133.460941] Starting subtest: drm-resources-equal [138.625504] Subtest drm-resources-equal: SUCCESS (5.169s) [138.692098] [017/130] (906s left) kms_cursor_legacy (flip-vs-cursor-toggle) [138.816192] Starting subtest: flip-vs-cursor-toggle [146.354625] Subtest flip-vs-cursor-toggle: SUCCESS (7.538s) [147.146769] [018/130] (898s left) kms_big_fb (4-tiled-16bpp-rotate-180) [147.257692] Starting subtest: 4-tiled-16bpp-rotate-180 [148.347141] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.090s) [148.458928] [019/130] (897s left) gem_exec_reloc (basic-write-gtt-active) [148.520725] Subtest basic-write-gtt-active: SKIP (0.000s) [148.559857] [020/130] (897s left) kms_atomic_interruptible (universal-setplane-cursor) [148.658705] Starting subtest: universal-setplane-cursor [148.660816] Starting dynamic subtest: pipe-A-eDP-1 [156.080287] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.420s) [156.082712] Subtest universal-setplane-cursor: SUCCESS (7.421s) [156.897924] [021/130] (888s left) kms_feature_discovery (psr2) [157.008428] Starting subtest: psr2 [157.011102] Subtest psr2: SUCCESS (0.000s) [157.061896] [022/130] (888s left) drm_fdinfo (virtual-busy-all) [157.105242] Starting subtest: virtual-busy-all [157.110612] Subtest virtual-busy-all: SKIP (0.000s) [157.144897] [023/130] (888s left) kms_cursor_legacy (torture-bo) [157.271134] Starting subtest: torture-bo [157.273536] Starting dynamic subtest: pipe-A [163.079856] Dynamic subtest pipe-A: SUCCESS (5.808s) [163.090496] Starting dynamic subtest: pipe-B [169.465704] Dynamic subtest pipe-B: SUCCESS (6.388s) [169.478675] Starting dynamic subtest: pipe-C [176.147592] Dynamic subtest pipe-C: SUCCESS (6.683s) [176.156618] Starting dynamic subtest: pipe-D [182.557603] Dynamic subtest pipe-D: SUCCESS (6.410s) [182.569052] Starting dynamic subtest: all-pipes [189.000974] Dynamic subtest all-pipes: SUCCESS (6.446s) [189.003606] Subtest torture-bo: SUCCESS (31.737s) [189.138425] [024/130] (856s left) kms_cursor_crc (cursor-random-128x42) [189.333753] Starting subtest: cursor-random-128x42 [189.371334] Subtest cursor-random-128x42: SKIP (0.032s) [189.574957] [025/130] (856s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff) [189.681688] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff [194.410600] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (4.734s) [194.525792] [026/130] (851s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs) [194.630120] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs [194.632638] Starting dynamic subtest: pipe-A-eDP-1 [194.714428] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.083s) [194.722549] Starting dynamic subtest: pipe-B-eDP-1 [194.788704] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.074s) [194.797003] Starting dynamic subtest: pipe-C-eDP-1 [194.862605] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.072s) [194.870721] Starting dynamic subtest: pipe-D-eDP-1 [194.936949] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.074s) [194.939436] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.307s) [197.079355] [027/130] (848s left) gem_exec_fence (basic-wait) [197.283111] Starting subtest: basic-wait [197.288105] Starting dynamic subtest: rcs0 [197.334640] Dynamic subtest rcs0: SUCCESS (0.080s) [197.342701] Starting dynamic subtest: bcs0 [197.395464] Dynamic subtest bcs0: SUCCESS (0.060s) [197.409569] Starting dynamic subtest: vcs0 [197.452158] Dynamic subtest vcs0: SUCCESS (0.055s) [197.462755] Starting dynamic subtest: vcs1 [197.504959] Dynamic subtest vcs1: SUCCESS (0.051s) [197.514704] Starting dynamic subtest: vecs0 [197.568341] Dynamic subtest vecs0: SUCCESS (0.063s) [197.583032] Starting dynamic subtest: ccs0 [197.626970] Dynamic subtest ccs0: SUCCESS (0.057s) [197.629977] Subtest basic-wait: SUCCESS (0.372s) [199.355113] [028/130] (846s left) kms_busy (basic-hang) [199.457246] Starting subtest: basic-hang [199.459941] Starting dynamic subtest: flip-pipe-A [200.049496] Dynamic subtest flip-pipe-A: SUCCESS (0.590s) [200.058100] Starting dynamic subtest: modeset-pipe-A [203.503329] Dynamic subtest modeset-pipe-A: SUCCESS (3.454s) [203.513365] Starting dynamic subtest: flip-pipe-D [204.694196] Dynamic subtest flip-pipe-D: SUCCESS (1.188s) [204.704238] Starting dynamic subtest: modeset-pipe-D [208.099094] Dynamic subtest modeset-pipe-D: SUCCESS (3.404s) [208.101688] Subtest basic-hang: SUCCESS (8.640s) [208.877993] [029/130] (836s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite) [208.986617] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite [208.991585] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [209.063441] [030/130] (836s left) gem_exec_flush (basic-wb-set-default) [209.123283] Starting subtest: basic-wb-set-default [214.603611] Subtest basic-wb-set-default: SUCCESS (5.478s) [214.768041] [031/130] (831s left) gem_ctx_engines (invalid-engines) [214.823735] Starting subtest: invalid-engines [214.831324] Subtest invalid-engines: SUCCESS (0.008s) [215.054645] [032/130] (830s left) kms_cursor_crc (cursor-random-64x21) [215.241641] Starting subtest: cursor-random-64x21 [215.278599] Subtest cursor-random-64x21: SKIP (0.032s) [215.487422] [033/130] (830s left) gem_exec_alignment (pi) [215.553178] Starting subtest: pi [265.538209] Subtest pi: SUCCESS (49.980s) [266.353500] [034/130] (779s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [266.500402] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [266.505830] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [266.583565] [035/130] (779s left) core_getclient [266.739020] [036/130] (779s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt) [266.841575] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt [266.846871] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [266.938347] [037/130] (779s left) kms_concurrent (multi-plane-atomic-lowres) [267.037884] Starting subtest: multi-plane-atomic-lowres [267.040179] Starting dynamic subtest: pipe-A-eDP-1 [267.535338] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.496s) [267.538184] Subtest multi-plane-atomic-lowres: SUCCESS (0.497s) [268.305849] [038/130] (777s left) syncobj_timeline (invalid-query-one-illegal-handle) [268.376447] Starting subtest: invalid-query-one-illegal-handle [268.379461] Subtest invalid-query-one-illegal-handle: SUCCESS (0.001s) [268.430022] [039/130] (777s left) gem_mmap_gtt (basic-read) [268.491717] Subtest basic-read: SKIP (0.000s) [268.539217] [040/130] (777s left) perf_pmu (busy-idle-no-semaphores) [268.583717] Starting subtest: busy-idle-no-semaphores [268.586479] Starting dynamic subtest: rcs0 [269.236846] Dynamic subtest rcs0: SUCCESS (0.654s) [269.248402] Starting dynamic subtest: bcs0 [269.888002] Dynamic subtest bcs0: SUCCESS (0.650s) [269.899747] Starting dynamic subtest: vcs0 [270.539161] Dynamic subtest vcs0: SUCCESS (0.650s) [270.548572] Starting dynamic subtest: vcs1 [271.936193] Dynamic subtest vcs1: SUCCESS (1.396s) [271.947330] Starting dynamic subtest: vecs0 [273.986114] Dynamic subtest vecs0: SUCCESS (2.049s) [273.997575] Starting dynamic subtest: ccs0 [275.970158] Dynamic subtest ccs0: SUCCESS (1.983s) [275.973327] Subtest busy-idle-no-semaphores: SUCCESS (7.389s) [276.073128] [041/130] (770s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt) [276.186306] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt [281.344162] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (5.163s) [281.462148] [042/130] (764s left) gem_render_copy (y-tiled) [281.530734] Starting subtest: y-tiled [281.536392] Subtest y-tiled: SKIP (0.000s) [281.695134] [043/130] (764s left) gem_exec_fence (syncobj-timeline-chain-engines) [282.273052] Starting subtest: syncobj-timeline-chain-engines [282.369644] Subtest syncobj-timeline-chain-engines: SUCCESS (0.098s) [283.445721] [044/130] (762s left) syncobj_timeline (multi-wait-for-submit-available-submitted) [283.498683] Starting subtest: multi-wait-for-submit-available-submitted [283.501303] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s) [283.582103] [045/130] (762s left) gem_ctx_persistence (smoketest) [283.640775] Starting subtest: smoketest [324.344206] Subtest smoketest: SUCCESS (40.712s) [324.402978] [046/130] (721s left) gem_exec_params (invalid-ring2) [324.474527] Starting subtest: invalid-ring2 [324.477424] Subtest invalid-ring2: SUCCESS (0.000s) [324.579926] [047/130] (721s left) tools_test (sysfs_l3_parity) [324.633520] Starting subtest: sysfs_l3_parity [324.723528] Subtest sysfs_l3_parity: SKIP (0.103s) [324.757034] [048/130] (721s left) gem_pxp (display-protected-crc) [325.931526] Starting subtest: display-protected-crc [327.501570] Subtest display-protected-crc: SUCCESS (1.571s) [327.608777] [049/130] (718s left) perf (enable-disable) [327.756271] Starting subtest: enable-disable [327.759093] Starting dynamic subtest: 0-rcs0 [330.030011] Dynamic subtest 0-rcs0: SUCCESS (2.274s) [330.038718] Starting dynamic subtest: 1-vecs0 [334.531534] Dynamic subtest 1-vecs0: SUCCESS (4.500s) [334.534571] Subtest enable-disable: SUCCESS (6.775s) [334.563207] [050/130] (711s left) gem_mmap_gtt (basic-write-read) [334.631697] Subtest basic-write-read: SKIP (0.000s) [334.663238] [051/130] (711s left) prime_vgem (sync) [334.730076] Starting subtest: sync [334.732626] Starting dynamic subtest: rcs0 [334.788260] Dynamic subtest rcs0: SUCCESS (0.058s) [334.797705] Starting dynamic subtest: bcs0 [334.867024] Dynamic subtest bcs0: SUCCESS (0.077s) [334.875949] Starting dynamic subtest: vcs0 [334.923066] Dynamic subtest vcs0: SUCCESS (0.056s) [334.931735] Starting dynamic subtest: vcs1 [334.970325] Dynamic subtest vcs1: SUCCESS (0.047s) [334.978946] Starting dynamic subtest: vecs0 [335.020026] Dynamic subtest vecs0: SUCCESS (0.049s) [335.028757] Starting dynamic subtest: ccs0 [335.068497] Dynamic subtest ccs0: SUCCESS (0.047s) [335.071139] Subtest sync: SUCCESS (0.339s) [335.199424] [052/130] (711s left) kms_psr (fbc-psr-sprite-render) [335.299372] Starting subtest: fbc-psr-sprite-render [335.301925] Starting dynamic subtest: eDP-1 [335.307122] Dynamic subtest eDP-1: SKIP (0.000s) [335.312283] Subtest fbc-psr-sprite-render: SKIP (0.001s) [335.355196] [053/130] (710s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf) [340.286448] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf [340.292578] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.002s) [341.122133] [054/130] (705s left) gem_exec_reloc (basic-wc-read-active) [341.184167] Subtest basic-wc-read-active: SKIP (0.000s) [341.248962] [055/130] (705s left) kms_big_fb (linear-8bpp-rotate-0) [341.361369] Starting subtest: linear-8bpp-rotate-0 [342.540116] Subtest linear-8bpp-rotate-0: SUCCESS (1.180s) [342.654875] [056/130] (703s left) kms_flip (busy-flip) [342.756709] Starting subtest: busy-flip [342.759513] Starting dynamic subtest: A-eDP1 [344.455852] Dynamic subtest A-eDP1: SUCCESS (1.698s) [344.466409] Starting dynamic subtest: B-eDP1 [346.089696] Dynamic subtest B-eDP1: SUCCESS (1.632s) [346.100628] Starting dynamic subtest: C-eDP1 [347.806754] Dynamic subtest C-eDP1: SUCCESS (1.715s) [347.815750] Starting dynamic subtest: D-eDP1 [349.429583] Dynamic subtest D-eDP1: SUCCESS (1.622s) [349.432263] Subtest busy-flip: SUCCESS (6.675s) [350.569121] [057/130] (695s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [350.678608] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt [350.683710] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [350.768986] [058/130] (695s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [350.874444] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [355.674187] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (4.803s) [355.805170] [059/130] (690s left) gem_lmem_swapping (smem-oom) [355.855763] Subtest smem-oom: SKIP (0.000s) [355.876925] [060/130] (690s left) kms_pm_rpm (basic-rte) [355.916525] Starting subtest: basic-rte [358.849429] Subtest basic-rte: SUCCESS (2.938s) [360.629901] [061/130] (685s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc) [360.742494] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc [360.747578] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [360.823989] [062/130] (685s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render) [360.929473] Starting subtest: fbcpsr-rgb101010-draw-render [365.595682] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (4.667s) [365.699190] [063/130] (680s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite) [365.803555] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite [365.808447] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [365.887356] [064/130] (680s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25) [365.987390] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25 [365.990343] Starting dynamic subtest: pipe-A [366.002311] Dynamic subtest pipe-A: SKIP (0.005s) [366.017625] Starting dynamic subtest: pipe-B [366.028340] Dynamic subtest pipe-B: SKIP (0.015s) [366.037643] Starting dynamic subtest: pipe-C [366.047983] Dynamic subtest pipe-C: SKIP (0.016s) [366.056391] Starting dynamic subtest: pipe-D [366.066707] Dynamic subtest pipe-D: SKIP (0.015s) [366.071938] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.053s) [366.114117] [065/130] (680s left) dmabuf (all-tests) [366.158926] Starting subtest: all-tests [366.161424] Starting dynamic subtest: sanitycheck [366.320126] Dynamic subtest sanitycheck: SUCCESS (0.159s) [366.332691] Starting dynamic subtest: dma_fence [366.596597] Dynamic subtest dma_fence: SUCCESS (0.275s) [366.608306] Starting dynamic subtest: dma_fence_chain [375.241132] Dynamic subtest dma_fence_chain: SUCCESS (8.642s) [375.253152] Starting dynamic subtest: dma_fence_unwrap [375.367561] Dynamic subtest dma_fence_unwrap: SUCCESS (0.124s) [375.380084] Starting dynamic subtest: dma_resv [375.505085] Dynamic subtest dma_resv: SUCCESS (0.135s) [375.508019] Subtest all-tests: SUCCESS (9.345s) [375.557069] [066/130] (671s left) syncobj_timeline (single-wait-all-available-submitted) [375.612683] Starting subtest: single-wait-all-available-submitted [375.615053] Subtest single-wait-all-available-submitted: SUCCESS (0.000s) [375.684129] [067/130] (670s left) api_intel_bb (add-remove-objects) [375.735864] Starting subtest: add-remove-objects [375.741895] Subtest add-remove-objects: SUCCESS (0.009s) [375.859951] [068/130] (670s left) gem_exec_schedule (lateslice) [375.940178] Starting subtest: lateslice [375.942470] Starting dynamic subtest: rcs0 [375.957930] Dynamic subtest rcs0: SUCCESS (0.030s) [375.967459] Starting dynamic subtest: bcs0 [375.983640] Dynamic subtest bcs0: SUCCESS (0.025s) [375.992485] Starting dynamic subtest: vcs0 [376.010198] Dynamic subtest vcs0: SUCCESS (0.026s) [376.018552] Starting dynamic subtest: vcs1 [376.033613] Dynamic subtest vcs1: SUCCESS (0.023s) [376.042069] Starting dynamic subtest: vecs0 [376.058586] Dynamic subtest vecs0: SUCCESS (0.024s) [376.066983] Starting dynamic subtest: ccs0 [376.081547] Dynamic subtest ccs0: SUCCESS (0.023s) [376.084530] Subtest lateslice: SUCCESS (0.153s) [377.455598] [069/130] (669s left) gem_basic (create-close) [377.528538] Starting subtest: create-close [377.534501] Subtest create-close: SUCCESS (0.000s) [377.625498] [070/130] (669s left) i915_power (sanity) [377.700078] Starting subtest: sanity [381.762575] Subtest sanity: SUCCESS (4.056s) [383.396239] [071/130] (663s left) kms_vblank (wait-busy-hang) [383.498408] Starting subtest: wait-busy-hang [383.501242] Starting dynamic subtest: pipe-A-eDP-1 [411.091578] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.589s) [411.107000] Starting dynamic subtest: pipe-D-eDP-1 [436.107518] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.015s) [436.110509] Subtest wait-busy-hang: SUCCESS (52.608s) [436.902341] [072/130] (609s left) drm_read (empty-nonblock) [437.057453] Starting subtest: empty-nonblock [437.060607] Subtest empty-nonblock: SUCCESS (0.000s) [437.164049] [073/130] (609s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant) [437.260413] Starting subtest: coverage-vs-premult-vs-constant [437.533682] Starting dynamic subtest: pipe-A-eDP-1 [438.064558] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.530s) [438.073498] Starting dynamic subtest: pipe-D-eDP-1 [439.312335] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.245s) [439.314955] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.050s) [440.164611] [074/130] (606s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt) [440.269523] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt [440.274575] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [440.349966] [075/130] (606s left) kms_addfb_basic (too-wide) [440.438398] Starting subtest: too-wide [440.441060] Subtest too-wide: SUCCESS (0.000s) [440.523562] [076/130] (606s left) kms_psr2_sf (pr-cursor-plane-update-sf) [445.420215] Starting subtest: pr-cursor-plane-update-sf [445.425572] Subtest pr-cursor-plane-update-sf: SKIP (0.002s) [446.254177] [077/130] (600s left) kms_hdr (bpc-switch-dpms) [446.351737] Starting subtest: bpc-switch-dpms [447.430643] Starting dynamic subtest: pipe-A-eDP-1 [451.816454] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.386s) [451.819201] Subtest bpc-switch-dpms: SUCCESS (5.464s) [451.920832] [078/130] (594s left) gem_fenced_exec_thrash (no-spare-fences) [451.989602] Subtest no-spare-fences: SKIP (0.000s) [452.055128] [079/130] (594s left) gem_readwrite (write-bad-handle) [452.113199] Subtest write-bad-handle: SKIP (0.000s) [452.155143] [080/130] (594s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt) [452.263483] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt [452.268293] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [452.346212] [081/130] (594s left) gem_wait (busy) [452.412906] Starting subtest: busy [452.415751] Starting dynamic subtest: all-engines [454.361127] Dynamic subtest all-engines: SUCCESS (1.947s) [454.370692] Starting dynamic subtest: rcs0 [454.903712] Dynamic subtest rcs0: SUCCESS (0.541s) [454.915565] Starting dynamic subtest: bcs0 [455.444356] Dynamic subtest bcs0: SUCCESS (0.540s) [455.453620] Starting dynamic subtest: vcs0 [457.369123] Dynamic subtest vcs0: SUCCESS (1.923s) [457.380367] Starting dynamic subtest: vcs1 [459.353301] Dynamic subtest vcs1: SUCCESS (1.982s) [459.364688] Starting dynamic subtest: vecs0 [461.337207] Dynamic subtest vecs0: SUCCESS (1.982s) [461.346548] Starting dynamic subtest: ccs0 [461.879843] Dynamic subtest ccs0: SUCCESS (0.541s) [461.882557] Subtest busy: SUCCESS (9.468s) [462.061773] [082/130] (584s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff) [462.170482] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff [462.175466] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [462.264104] [083/130] (584s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs) [462.366197] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs [462.371225] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s) [463.472194] [084/130] (583s left) kms_vrr (negative-basic) [463.576454] Starting subtest: negative-basic [463.584113] Starting dynamic subtest: pipe-A-eDP-1 [468.994483] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.409s) [469.271690] Subtest negative-basic: SUCCESS (5.693s) [470.093527] [085/130] (576s left) kms_joiner (basic-big-joiner) [470.204534] Starting subtest: basic-big-joiner [470.209975] Subtest basic-big-joiner: SKIP (0.000s) [470.249108] [086/130] (576s left) syncobj_wait (multi-wait-all-for-submit-signaled) [470.314017] Starting subtest: multi-wait-all-for-submit-signaled [470.316515] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [470.391056] [087/130] (576s left) gem_exec_balancer (parallel-dmabuf-import-out-fence) [470.650728] Starting subtest: parallel-dmabuf-import-out-fence [471.833167] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.182s) [471.937424] [088/130] (575s left) gem_spin_batch (resubmit-all) [472.005016] Starting subtest: resubmit-all [472.007734] Starting dynamic subtest: rcs0 [472.016504] Dynamic subtest rcs0: SUCCESS (0.012s) [472.025440] Starting dynamic subtest: bcs0 [472.027739] Dynamic subtest bcs0: SUCCESS (0.002s) [472.036521] Starting dynamic subtest: vcs0 [472.038506] Dynamic subtest vcs0: SUCCESS (0.002s) [472.046386] Starting dynamic subtest: vcs1 [472.048416] Dynamic subtest vcs1: SUCCESS (0.002s) [472.056072] Starting dynamic subtest: vecs0 [472.058183] Dynamic subtest vecs0: SUCCESS (0.002s) [472.066334] Starting dynamic subtest: ccs0 [472.068419] Dynamic subtest ccs0: SUCCESS (0.002s) [472.070455] Subtest resubmit-all: SUCCESS (0.025s) [473.327838] [089/130] (573s left) kms_flip (2x-flip-vs-expired-vblank-interruptible) [473.431420] Starting subtest: 2x-flip-vs-expired-vblank-interruptible [473.443588] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s) [473.502572] [090/130] (573s left) kms_chamelium_hpd (dp-hpd-for-each-pipe) [473.893607] Subtest dp-hpd-for-each-pipe: SKIP (0.000s) [474.695717] [091/130] (572s left) perf_pmu (rc6-all-gts) [474.735727] Starting subtest: rc6-all-gts [481.117038] Subtest rc6-all-gts: SUCCESS (6.380s) [482.127805] [092/130] (565s left) gem_mmap_offset (clear-via-pagefault) [482.193451] Starting subtest: clear-via-pagefault [482.195100] Starting dynamic subtest: smem0 [518.212566] Dynamic subtest smem0: SUCCESS (36.018s) [518.215286] Subtest clear-via-pagefault: SUCCESS (36.020s) [518.315131] [093/130] (528s left) kms_sequence (get-idle) [518.421495] Starting subtest: get-idle [518.424253] Starting dynamic subtest: pipe-A-eDP-1 [520.219976] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.796s) [520.228963] Starting dynamic subtest: pipe-B-eDP-1 [522.672583] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.454s) [522.682764] Starting dynamic subtest: pipe-C-eDP-1 [525.086233] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.410s) [525.096342] Starting dynamic subtest: pipe-D-eDP-1 [527.513289] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.427s) [527.515691] Subtest get-idle: SUCCESS (9.092s) [528.293685] [094/130] (518s left) i915_pm_freq_mult (media-freq) [528.345251] Starting subtest: media-freq [528.347582] Starting dynamic subtest: gt0 [528.352522] Dynamic subtest gt0: SKIP (0.000s) [528.362774] Starting dynamic subtest: gt1 [528.367682] Dynamic subtest gt1: SKIP (0.000s) [528.372558] Subtest media-freq: SKIP (0.001s) [528.438143] [095/130] (518s left) kms_psr2_su (page_flip-nv12) [528.505495] Subtest page_flip-NV12: SKIP (0.000s) [528.551926] [096/130] (518s left) gem_exec_schedule (submit-early-slice) [528.632304] Starting subtest: submit-early-slice [528.634878] Starting dynamic subtest: rcs0 [528.666861] Dynamic subtest rcs0: SUCCESS (0.045s) [528.678034] Starting dynamic subtest: bcs0 [528.702829] Dynamic subtest bcs0: SUCCESS (0.036s) [528.712040] Starting dynamic subtest: vcs0 [528.744513] Dynamic subtest vcs0: SUCCESS (0.041s) [528.753517] Starting dynamic subtest: vcs1 [528.779643] Dynamic subtest vcs1: SUCCESS (0.035s) [528.788674] Starting dynamic subtest: vecs0 [528.808604] Dynamic subtest vecs0: SUCCESS (0.028s) [528.817706] Starting dynamic subtest: ccs0 [528.843773] Dynamic subtest ccs0: SUCCESS (0.035s) [528.846534] Subtest submit-early-slice: SUCCESS (0.222s) [530.425520] [097/130] (516s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt) [530.535116] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt [530.540139] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [530.636785] [098/130] (516s left) kms_rotation_crc (multiplane-rotation) [530.740477] Starting subtest: multiplane-rotation [538.076087] Subtest multiplane-rotation: SUCCESS (7.337s) [538.170200] [099/130] (509s left) gem_eio (in-flight-immediate) [538.414478] Starting subtest: in-flight-immediate [547.326620] Subtest in-flight-immediate: SUCCESS (8.912s) [547.483707] [100/130] (499s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt) [547.590275] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt [547.594865] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [547.677578] [101/130] (499s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180) [547.766211] Starting subtest: primary-yf-tiled-reflect-x-180 [547.829114] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.060s) [547.910400] [102/130] (499s left) gem_softpin (allocator-nopin-reserve) [547.962067] Starting subtest: allocator-nopin-reserve [548.050452] Subtest allocator-nopin-reserve: SUCCESS (0.088s) [548.157835] [103/130] (499s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt) [548.252532] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt [553.289864] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (5.041s) [553.416533] [104/130] (493s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic) [553.545449] Starting subtest: 2x-long-flip-vs-cursor-atomic [553.550405] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s) [553.636298] [105/130] (493s left) i915_pm_rpm (sysfs-read) [555.461424] Starting subtest: sysfs-read [556.617629] Subtest sysfs-read: SUCCESS (1.153s) [556.941967] [106/130] (490s left) kms_addfb_basic (master-rmfb) [556.998235] Starting subtest: master-rmfb [557.000809] Subtest master-rmfb: SUCCESS (0.002s) [557.133768] [107/130] (490s left) gem_pxp (verify-pxp-stale-buf-execution) [558.238260] Starting subtest: verify-pxp-stale-buf-execution [558.301426] Subtest verify-pxp-stale-buf-execution: SUCCESS (0.063s) [558.465784] [108/130] (489s left) gem_ctx_param (invalid-param-get) [558.521316] Starting subtest: invalid-param-get [558.523995] Subtest invalid-param-get: SUCCESS (0.001s) [558.593918] [109/130] (488s left) kms_dsc (dsc-with-formats) [558.694293] Starting subtest: dsc-with-formats [558.740436] Subtest dsc-with-formats: SKIP (0.001s) [558.760053] [110/130] (488s left) kms_flip (2x-flip-vs-blocking-wf-vblank) [558.865597] Starting subtest: 2x-flip-vs-blocking-wf-vblank [558.876424] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.010s) [558.937099] [111/130] (488s left) kms_psr (fbc-pr-sprite-blt) [559.039556] Starting subtest: fbc-pr-sprite-blt [559.044728] Subtest fbc-pr-sprite-blt: SKIP (0.000s) [559.093917] [112/130] (488s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size) [559.210130] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size [560.195632] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.985s) [560.963038] [113/130] (486s left) gem_basic (multigpu-create-close) [561.028531] Starting subtest: multigpu-create-close [561.033307] Subtest multigpu-create-close: SKIP (0.000s) [561.119937] [114/130] (486s left) kms_chamelium_color (degamma) [561.230424] Subtest degamma: SKIP (0.000s) [561.256342] [115/130] (486s left) kms_psr (fbc-psr-sprite-mmap-cpu) [561.356464] Starting subtest: fbc-psr-sprite-mmap-cpu [561.359340] Starting dynamic subtest: eDP-1 [561.364359] Dynamic subtest eDP-1: SKIP (0.000s) [561.369345] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s) [561.410612] [116/130] (486s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [561.512315] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip [561.517229] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [561.588871] [117/130] (486s left) gem_ctx_persistence (heartbeat-close) [561.650619] Starting subtest: heartbeat-close [561.656635] Subtest heartbeat-close: SKIP (0.000s) [561.724105] [118/130] (485s left) gem_ctx_create (basic-files) [561.800660] Starting subtest: basic-files [563.810308] Subtest basic-files: SUCCESS (2.011s) [565.368340] [119/130] (482s left) gem_unref_active_buffers [565.549622] [120/130] (482s left) gem_busy (close-race) [565.618625] Starting subtest: close-race [589.337877] Subtest close-race: SUCCESS (23.722s) [589.702168] [121/130] (458s left) perf (i915-ref-count) [589.834707] Starting subtest: i915-ref-count [589.860705] Subtest i915-ref-count: SUCCESS (0.024s) [589.900082] [122/130] (457s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling) [590.008516] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling [590.010927] Starting dynamic subtest: pipe-A-default-mode [590.297696] Dynamic subtest pipe-A-default-mode: SKIP (0.284s) [590.303312] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.286s) [591.074131] [123/130] (456s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation) [591.181467] Starting subtest: plane-scaler-with-clipping-clamping-rotation [591.184237] Starting dynamic subtest: pipe-A [591.411733] Dynamic subtest pipe-A: SUCCESS (0.231s) [591.421164] Starting dynamic subtest: pipe-B [592.675978] Dynamic subtest pipe-B: SUCCESS (1.263s) [592.685357] Starting dynamic subtest: pipe-C [594.006398] Dynamic subtest pipe-C: SUCCESS (1.330s) [594.026865] Starting dynamic subtest: pipe-D [595.331215] Dynamic subtest pipe-D: SUCCESS (1.325s) [595.333880] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.151s) [596.496183] [124/130] (451s left) kms_psr (psr2-sprite-render) [596.605563] Starting subtest: psr2-sprite-render [596.608308] Starting dynamic subtest: eDP-1 [598.301695] Dynamic subtest eDP-1: SUCCESS (1.695s) [598.304208] Subtest psr2-sprite-render: SUCCESS (1.696s) [599.143426] [125/130] (448s left) kms_big_fb (linear-16bpp-rotate-180) [599.260068] Starting subtest: linear-16bpp-rotate-180 [600.537712] Subtest linear-16bpp-rotate-180: SUCCESS (1.279s) [600.640189] [126/130] (447s left) gem_exec_schedule (preempt-hang) [600.820061] Starting subtest: preempt-hang [600.822730] Starting dynamic subtest: rcs0 [601.062716] Dynamic subtest rcs0: SUCCESS (0.240s) [601.073746] Starting dynamic subtest: bcs0 [601.294043] Dynamic subtest bcs0: SUCCESS (0.231s) [601.304909] Starting dynamic subtest: vcs0 [601.515013] Dynamic subtest vcs0: SUCCESS (0.220s) [601.524531] Starting dynamic subtest: vcs1 [601.744100] Dynamic subtest vcs1: SUCCESS (0.226s) [601.755813] Starting dynamic subtest: vecs0 [601.967547] Dynamic subtest vecs0: SUCCESS (0.223s) [601.978477] Starting dynamic subtest: ccs0 [602.195241] Dynamic subtest ccs0: SUCCESS (0.227s) [602.197732] Subtest preempt-hang: SUCCESS (1.372s) [603.446488] [127/130] (444s left) syncobj_wait (invalid-reset-bad-pad) [603.514712] Starting subtest: invalid-reset-bad-pad [603.517540] Subtest invalid-reset-bad-pad: SUCCESS (0.000s) [603.590845] [128/130] (444s left) debugfs_test (read_all_entries_display_on) [603.696154] Starting subtest: read_all_entries_display_on [604.438934] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 2387 [max: 8192] direct dependencies: 28648 [max: 524288] indirect dependencies: 250083 all direct dependencies: 619864 dependency chains: 44865 [max: 524288] dependency chain hlocks used: 196247 [max: 2621440] dependency chain hlocks lost: 0 in-hardirq chains: 444 in-softirq chains: 950 in-process chains: 43471 stack-trace entries: 290237 [max: 524288] number of stack traces: 13429 number of stack hash chains: 9147 combined max dependencies: 1217263856 hardirq-safe locks: 139 hardirq-unsafe locks: 1356 softirq-safe locks: 266 softirq-unsafe locks: 1261 irq-safe locks: 297 irq-unsafe locks: 1356 hardirq-read-safe locks: 5 hardirq-read-unsafe locks: 493 softirq-read-safe locks: 10 softirq-read-unsafe locks: 489 irq-read-safe locks: 10 irq-read-unsafe locks: 493 uncategorized locks: 378 unused locks: 1 max locking depth: 17 max bfs queue depth: 432 max lock class index: 2386 debug_locks: 0 zapped classes: 7 zapped lock chains: 185 large chain blocks: 1 [604.441898] Closing watchdogs Done.