[56.918537] Initializing watchdogs [56.918586] /dev/watchdog0 [56.934445] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [56.939210] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.941793] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.946212] [001/132] (960s left) kms_psr (fbc-pr-basic) [57.071161] Starting subtest: fbc-pr-basic [57.075649] Subtest fbc-pr-basic: SKIP (0.000s) [57.184061] [002/132] (960s left) kms_setmode (invalid-clone-exclusive-crtc) [57.249977] Starting subtest: invalid-clone-exclusive-crtc [57.256709] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s) [57.367345] [003/132] (960s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted) [57.418857] Starting subtest: etime-single-wait-all-available-unsubmitted [57.521206] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.102s) [57.607054] [004/132] (959s left) gem_lmem_swapping (parallel-random-verify) [57.652762] Subtest parallel-random-verify: SKIP (0.000s) [57.688638] [005/132] (959s left) gem_gpgpu_fill (basic) [57.744536] Starting subtest: basic [57.746500] Starting dynamic subtest: smem [57.751539] Dynamic subtest smem: SUCCESS (0.007s) [57.753686] Subtest basic: SUCCESS (0.008s) [57.891097] [006/132] (959s left) api_intel_bb (reset-bb) [57.944056] Starting subtest: reset-bb [57.947600] Subtest reset-bb: SUCCESS (0.005s) [58.057335] [007/132] (959s left) gem_flink_basic (double-flink) [58.109066] Starting subtest: double-flink [58.110936] Subtest double-flink: SUCCESS (0.000s) [58.209639] [008/132] (959s left) kms_universal_plane (universal-plane-sanity) [58.292996] Starting subtest: universal-plane-sanity [58.295082] Starting dynamic subtest: pipe-A-eDP-1 [58.915749] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.623s) [58.924936] Starting dynamic subtest: pipe-B-eDP-1 [60.102992] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.185s) [60.112582] Starting dynamic subtest: pipe-C-eDP-1 [61.310150] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.205s) [61.319581] Starting dynamic subtest: pipe-D-eDP-1 [62.533850] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.223s) [62.536356] Subtest universal-plane-sanity: SUCCESS (4.241s) [63.384942] [009/132] (954s left) kms_big_fb (linear-16bpp-rotate-270) [63.499682] Starting subtest: linear-16bpp-rotate-270 [63.519815] Subtest linear-16bpp-rotate-270: SKIP (0.020s) [63.636634] [010/132] (954s left) gem_madvise (dontneed-before-pwrite) [63.673388] Starting subtest: dontneed-before-pwrite [63.689066] Subtest dontneed-before-pwrite: SKIP (0.013s) [63.743053] [011/132] (954s left) perf_pmu (idle-no-semaphores) [63.778964] Starting subtest: idle-no-semaphores [63.781445] Starting dynamic subtest: rcs0 [64.327395] Dynamic subtest rcs0: SUCCESS (0.547s) [64.337478] Starting dynamic subtest: bcs0 [64.843862] Dynamic subtest bcs0: SUCCESS (0.515s) [64.853852] Starting dynamic subtest: vcs0 [65.355763] Dynamic subtest vcs0: SUCCESS (0.511s) [65.365832] Starting dynamic subtest: vcs1 [65.871247] Dynamic subtest vcs1: SUCCESS (0.514s) [65.880202] Starting dynamic subtest: vecs0 [66.387776] Dynamic subtest vecs0: SUCCESS (0.515s) [66.397934] Starting dynamic subtest: ccs0 [66.902555] Dynamic subtest ccs0: SUCCESS (0.513s) [66.905496] Subtest idle-no-semaphores: SUCCESS (3.124s) [66.998330] [012/132] (950s left) syncobj_wait (invalid-signal-illegal-handle) [67.048827] Starting subtest: invalid-signal-illegal-handle [67.051194] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [67.147623] [013/132] (950s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode) [67.529663] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s) [68.307720] [014/132] (949s left) kms_multipipe_modeset (basic-max-pipe-crc-check) [68.408784] Starting subtest: basic-max-pipe-crc-check [68.413287] Subtest basic-max-pipe-crc-check: SKIP (0.000s) [68.452603] [015/132] (949s left) kms_pm_lpsp (screens-disabled) [69.554250] Starting subtest: screens-disabled [69.558668] Subtest screens-disabled: SKIP (0.000s) [69.623334] [016/132] (948s left) gem_exec_create (madvise) [69.700436] Starting subtest: madvise [69.702933] Starting dynamic subtest: smem [91.395020] Dynamic subtest smem: SUCCESS (21.687s) [91.397093] Subtest madvise: SUCCESS (21.688s) [92.488667] [017/132] (925s left) gem_partial_pwrite_pread (reads) [92.549076] Subtest reads: SKIP (0.000s) [92.617171] [018/132] (925s left) prime_vgem (basic-fence-read) [92.781312] Starting subtest: basic-fence-read [92.789702] Subtest basic-fence-read: SKIP (0.005s) [92.892548] [FACT prime_vgem (basic-fence-read)] new: kernel.kmod_is_loaded.vgem: true [92.895175] [019/132] (925s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu) [93.003324] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu [93.007720] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [93.106014] [020/132] (925s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [93.217354] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [93.221408] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [93.313955] [021/132] (924s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite) [93.407101] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite [93.411625] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [93.501294] [022/132] (924s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc) [93.590965] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc [93.593078] Starting dynamic subtest: pipe-A-eDP-1 [93.610079] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [93.619643] Starting dynamic subtest: pipe-B-eDP-1 [93.635539] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [93.643111] Starting dynamic subtest: pipe-C-eDP-1 [93.658459] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [93.665807] Starting dynamic subtest: pipe-D-eDP-1 [93.681790] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [93.683541] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.007s) [95.898540] [023/132] (922s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render) [95.995548] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render [95.999670] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [96.089834] [024/132] (922s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw) [96.181484] Starting subtest: fbc-1p-pri-indfb-multidraw [109.316820] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.141s) [110.714697] [025/132] (907s left) syncobj_timeline (single-wait-all-for-submit-available-signaled) [110.766464] Starting subtest: single-wait-all-for-submit-available-signaled [110.768593] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s) [110.859371] [026/132] (907s left) gem_mmap_gtt (basic-short) [110.913360] Subtest basic-short: SKIP (0.000s) [111.009845] [027/132] (907s left) kms_big_fb (yf-tiled-64bpp-rotate-0) [111.117158] Starting subtest: yf-tiled-64bpp-rotate-0 [111.121100] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s) [111.239398] [028/132] (907s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs) [111.323427] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs [111.328056] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s) [112.434175] [029/132] (906s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling) [112.515786] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling [112.520184] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s) [112.585832] [030/132] (906s left) gem_ctx_shared (q-promotion) [112.641686] Starting subtest: Q-promotion [112.644225] Starting dynamic subtest: rcs0 [112.745942] Dynamic subtest rcs0: SUCCESS (0.104s) [112.761860] Starting dynamic subtest: vcs0 [112.832942] Dynamic subtest vcs0: SUCCESS (0.087s) [112.847724] Starting dynamic subtest: vcs1 [112.918470] Dynamic subtest vcs1: SUCCESS (0.085s) [112.934412] Starting dynamic subtest: vecs0 [113.002287] Dynamic subtest vecs0: SUCCESS (0.083s) [113.018849] Starting dynamic subtest: ccs0 [113.080821] Dynamic subtest ccs0: SUCCESS (0.078s) [113.083362] Subtest Q-promotion: SUCCESS (0.439s) [114.394666] [031/132] (904s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20) [114.503357] Starting subtest: planes-downscale-factor-0-5-upscale-20x20 [114.505577] Starting dynamic subtest: pipe-A [114.523332] Dynamic subtest pipe-A: SKIP (0.018s) [114.540379] Starting dynamic subtest: pipe-B [114.560665] Dynamic subtest pipe-B: SKIP (0.037s) [114.572180] Starting dynamic subtest: pipe-C [114.609954] Dynamic subtest pipe-C: SKIP (0.047s) [114.620686] Starting dynamic subtest: pipe-D [114.640428] Dynamic subtest pipe-D: SKIP (0.031s) [114.644706] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.136s) [114.748562] [032/132] (904s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [114.851793] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip [115.508703] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.659s) [115.673088] [033/132] (903s left) gem_ctx_param (invalid-get-engines) [115.716323] Starting subtest: invalid-get-engines [115.718722] Subtest invalid-get-engines: SUCCESS (0.001s) [115.823059] [034/132] (903s left) i915_query (test-query-geometry-subslices) [115.873045] Starting subtest: test-query-geometry-subslices [115.875452] Subtest test-query-geometry-subslices: SUCCESS (0.000s) [115.979702] [035/132] (902s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc) [116.099592] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc [116.103703] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [116.187015] [036/132] (902s left) kms_atomic_interruptible (legacy-dpms) [116.277083] Starting subtest: legacy-dpms [116.279494] Starting dynamic subtest: pipe-A-eDP-1 [123.654957] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.378s) [123.657424] Subtest legacy-dpms: SUCCESS (7.379s) [124.492957] [037/132] (894s left) gem_exec_params (larger-than-life-batch) [124.555723] Starting subtest: larger-than-life-batch [126.869622] Subtest larger-than-life-batch: SUCCESS (2.315s) [127.361155] [038/132] (891s left) gem_ctx_persistence (legacy-engines-mixed-process) [127.477059] Starting subtest: legacy-engines-mixed-process [127.479558] Starting dynamic subtest: render [129.287804] Dynamic subtest render: SUCCESS (1.811s) [129.298253] Starting dynamic subtest: bsd1 [131.267735] Dynamic subtest bsd1: SUCCESS (1.979s) [131.277854] Starting dynamic subtest: bsd2 [133.320222] Dynamic subtest bsd2: SUCCESS (2.051s) [133.332309] Starting dynamic subtest: blt [135.291912] Dynamic subtest blt: SUCCESS (1.970s) [135.303710] Starting dynamic subtest: vebox [137.277886] Dynamic subtest vebox: SUCCESS (1.985s) [137.280366] Subtest legacy-engines-mixed-process: SUCCESS (9.801s) [137.356626] [039/132] (881s left) kms_frontbuffer_tracking (fbcpsr-stridechange) [137.470158] Starting subtest: fbcpsr-stridechange [143.766974] Subtest fbcpsr-stridechange: SUCCESS (6.300s) [143.893040] [040/132] (875s left) gem_ctx_bad_destroy (invalid-ctx) [143.948098] Starting subtest: invalid-ctx [143.950544] Subtest invalid-ctx: SUCCESS (0.000s) [144.042021] [041/132] (875s left) kms_prop_blob (invalid-set-prop) [144.095604] Starting subtest: invalid-set-prop [144.097476] Subtest invalid-set-prop: SUCCESS (0.000s) [144.179902] [042/132] (874s left) syncobj_wait (invalid-reset-illegal-handle) [144.237157] Starting subtest: invalid-reset-illegal-handle [144.239445] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [144.333445] [043/132] (874s left) gem_exec_reloc (basic-gtt-wc) [144.390683] Subtest basic-gtt-wc: SKIP (0.000s) [144.459924] [044/132] (874s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip) [144.557836] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip [144.561668] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [144.650059] [045/132] (874s left) gem_softpin (safe-alignment) [144.718254] Starting subtest: safe-alignment [144.743059] Subtest safe-alignment: SUCCESS (0.025s) [146.338788] [046/132] (872s left) gem_readwrite (read-write) [146.389103] Subtest read-write: SKIP (0.000s) [146.453222] [047/132] (872s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render) [146.552106] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render [146.556095] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [146.656904] [048/132] (872s left) syncobj_wait (single-wait-all-submitted) [146.709318] Starting subtest: single-wait-all-submitted [146.818601] Subtest single-wait-all-submitted: SUCCESS (0.108s) [146.897628] [049/132] (872s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc) [146.991288] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc [146.993492] Starting dynamic subtest: pipe-A-eDP-1 [147.015312] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [147.025867] Starting dynamic subtest: pipe-B-eDP-1 [147.046660] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [147.055680] Starting dynamic subtest: pipe-C-eDP-1 [147.076406] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [147.085223] Starting dynamic subtest: pipe-D-eDP-1 [147.105813] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [147.110094] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s) [149.298594] [050/132] (870s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [149.398780] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [150.267268] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.870s) [150.432332] [051/132] (869s left) kms_draw_crc (draw-method-mmap-cpu) [150.530059] Starting subtest: draw-method-mmap-cpu [150.532194] Starting dynamic subtest: xrgb8888-untiled [150.762322] Dynamic subtest xrgb8888-untiled: SUCCESS (0.234s) [150.772768] Starting dynamic subtest: rgb565-untiled [150.962639] Dynamic subtest rgb565-untiled: SUCCESS (0.200s) [150.973689] Starting dynamic subtest: xrgb2101010-untiled [151.173370] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s) [151.183054] Starting dynamic subtest: xbgr16161616f-untiled [151.395607] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s) [151.405549] Starting dynamic subtest: xrgb8888-xtiled [151.517973] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s) [151.529853] Starting dynamic subtest: rgb565-xtiled [151.662347] Dynamic subtest rgb565-xtiled: SUCCESS (0.144s) [151.672716] Starting dynamic subtest: xrgb2101010-xtiled [151.784333] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s) [151.794174] Starting dynamic subtest: xbgr16161616f-xtiled [151.917662] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s) [151.927081] Starting dynamic subtest: xrgb8888-4tiled [152.050926] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s) [152.060726] Starting dynamic subtest: rgb565-4tiled [152.195508] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s) [152.205569] Starting dynamic subtest: xrgb2101010-4tiled [152.328766] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s) [152.338465] Starting dynamic subtest: xbgr16161616f-4tiled [152.473430] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s) [152.475535] Subtest draw-method-mmap-cpu: SUCCESS (1.945s) [152.556723] [052/132] (867s left) i915_pciid [152.706152] [053/132] (866s left) kms_ccs (bad-pixel-format-y-tiled-ccs) [152.800720] Starting subtest: bad-pixel-format-y-tiled-ccs [152.802499] Starting dynamic subtest: pipe-A-eDP-1 [152.820830] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [152.830077] Starting dynamic subtest: pipe-B-eDP-1 [152.846320] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [152.854521] Starting dynamic subtest: pipe-C-eDP-1 [152.871505] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [152.880065] Starting dynamic subtest: pipe-D-eDP-1 [152.897431] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [152.900802] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.003s) [155.057811] [054/132] (864s left) gem_exec_schedule (thriceslice) [155.132760] Starting subtest: thriceslice [155.134668] Starting dynamic subtest: rcs0 [155.152654] Dynamic subtest rcs0: SUCCESS (0.030s) [155.164698] Starting dynamic subtest: bcs0 [155.180456] Dynamic subtest bcs0: SUCCESS (0.028s) [155.192660] Starting dynamic subtest: vcs0 [155.210313] Dynamic subtest vcs0: SUCCESS (0.029s) [155.219579] Starting dynamic subtest: vcs1 [155.261631] Dynamic subtest vcs1: SUCCESS (0.050s) [155.274514] Starting dynamic subtest: vecs0 [155.291518] Dynamic subtest vecs0: SUCCESS (0.029s) [155.301739] Starting dynamic subtest: ccs0 [155.345687] Dynamic subtest ccs0: SUCCESS (0.053s) [155.348288] Subtest thriceslice: SUCCESS (0.224s) [155.655777] [055/132] (864s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted) [155.712074] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted [155.817556] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.105s) [155.892873] [056/132] (863s left) kms_lease (lease-invalid-connector) [156.002765] Starting subtest: lease-invalid-connector [156.005080] Starting dynamic subtest: pipe-A-eDP-1 [156.007289] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [156.016278] Starting dynamic subtest: pipe-B-eDP-1 [156.018560] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [156.027659] Starting dynamic subtest: pipe-C-eDP-1 [156.029840] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [156.038683] Starting dynamic subtest: pipe-D-eDP-1 [156.040588] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [156.042486] Subtest lease-invalid-connector: SUCCESS (0.003s) [156.079201] [057/132] (863s left) perf (buffer-fill) [156.207821] Starting subtest: buffer-fill [156.210026] Starting dynamic subtest: 0-rcs0 [158.484086] Dynamic subtest 0-rcs0: SUCCESS (2.274s) [158.496874] Starting dynamic subtest: 1-vecs0 [162.913324] Dynamic subtest 1-vecs0: SUCCESS (4.428s) [162.916082] Subtest buffer-fill: SUCCESS (6.704s) [162.963074] [058/132] (856s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic) [163.088275] Starting subtest: flip-vs-cursor-busy-crc-atomic [163.910450] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.821s) [164.785251] [059/132] (855s left) kms_rotation_crc (bad-pixel-format) [164.886039] Starting subtest: bad-pixel-format [164.890272] Subtest bad-pixel-format: SKIP (0.001s) [164.961760] [060/132] (854s left) kms_cursor_crc (cursor-onscreen-max-size) [165.274282] Starting subtest: cursor-onscreen-max-size [165.281116] Subtest cursor-onscreen-max-size: SKIP (0.000s) [165.415407] [061/132] (854s left) gem_exec_reloc (basic-cpu-read) [165.471021] Subtest basic-cpu-read: SKIP (0.000s) [165.545108] [062/132] (854s left) i915_pm_rc6_residency (rc6-idle) [165.603115] Starting subtest: rc6-idle [165.637370] Starting dynamic subtest: gt0-rcs0 [190.013776] Dynamic subtest gt0-rcs0: SUCCESS (24.375s) [190.023224] Starting dynamic subtest: gt0-bcs0 [214.296070] Dynamic subtest gt0-bcs0: SUCCESS (24.280s) [214.305643] Starting dynamic subtest: gt0-ccs0 [238.651445] Dynamic subtest gt0-ccs0: SUCCESS (24.353s) [238.660992] Starting dynamic subtest: gt1-vcs0 [244.825568] Dynamic subtest gt1-vcs0: SUCCESS (6.170s) [244.836102] Starting dynamic subtest: gt1-vecs0 [250.996324] Dynamic subtest gt1-vecs0: SUCCESS (6.168s) [250.999512] Subtest rc6-idle: SUCCESS (85.393s) [251.079242] [063/132] (768s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [251.186963] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt [251.191510] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [251.286401] [064/132] (768s left) core_setmaster (master-drop-set-root) [251.357995] Starting subtest: master-drop-set-root [251.368266] Subtest master-drop-set-root: SUCCESS (0.013s) [251.418879] [065/132] (768s left) gem_exec_fence (invalid-timeline-fence-array) [251.993789] Starting subtest: invalid-timeline-fence-array [251.999464] Subtest invalid-timeline-fence-array: SUCCESS (0.005s) [253.382776] [066/132] (766s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping) [253.471346] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping [253.475794] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s) [253.543146] [067/132] (766s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite) [253.651687] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite [253.655893] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [253.753235] [068/132] (766s left) gem_pxp (verify-pxp-key-change-after-suspend-resume) [253.882829] Starting subtest: verify-pxp-key-change-after-suspend-resume [261.167699] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.287s) [261.275781] [069/132] (759s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs) [261.394938] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs [261.397085] Starting dynamic subtest: pipe-A-eDP-1 [261.416460] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [261.426895] Starting dynamic subtest: pipe-B-eDP-1 [261.445191] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [261.454704] Starting dynamic subtest: pipe-C-eDP-1 [261.473179] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [261.482510] Starting dynamic subtest: pipe-D-eDP-1 [261.501086] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [261.502914] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.008s) [263.700928] [070/132] (756s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc) [263.810606] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc [270.599710] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.790s) [270.727458] [071/132] (749s left) perf_pmu (busy) [270.774048] Starting subtest: busy [270.776733] Starting dynamic subtest: rcs0 [271.379071] Dynamic subtest rcs0: SUCCESS (0.604s) [271.392212] Starting dynamic subtest: bcs0 [271.951430] Dynamic subtest bcs0: SUCCESS (0.570s) [271.964086] Starting dynamic subtest: vcs0 [273.277553] Dynamic subtest vcs0: SUCCESS (1.324s) [273.290214] Starting dynamic subtest: vcs1 [275.262381] Dynamic subtest vcs1: SUCCESS (1.981s) [275.273878] Starting dynamic subtest: vecs0 [277.310311] Dynamic subtest vecs0: SUCCESS (2.046s) [277.323296] Starting dynamic subtest: ccs0 [277.875431] Dynamic subtest ccs0: SUCCESS (0.564s) [277.877966] Subtest busy: SUCCESS (7.102s) [277.985941] [072/132] (742s left) kms_cursor_legacy (cursora-vs-flipb-legacy) [278.101143] Starting subtest: cursorA-vs-flipB-legacy [278.105884] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s) [278.257317] [073/132] (742s left) gem_close_race (multigpu-basic-threads) [278.339888] Starting subtest: multigpu-basic-threads [278.344442] Subtest multigpu-basic-threads: SKIP (0.000s) [278.566311] [074/132] (741s left) core_setmaster_vs_auth [278.724435] [075/132] (741s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled) [278.787444] Starting subtest: invalid-multi-wait-unsubmitted-signaled [278.789869] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s) [278.882797] [076/132] (741s left) gem_pxp (create-valid-protected-context) [278.933660] Starting subtest: create-valid-protected-context [278.935786] Subtest create-valid-protected-context: SUCCESS (0.001s) [279.044514] [077/132] (741s left) syncobj_wait (single-wait-for-submit-submitted) [279.103052] Starting subtest: single-wait-for-submit-submitted [279.208624] Subtest single-wait-for-submit-submitted: SUCCESS (0.107s) [279.286681] [078/132] (741s left) sw_sync (sync_merge_invalid) [279.323959] Starting subtest: sync_merge_invalid [279.351327] Subtest sync_merge_invalid: SUCCESS (0.029s) [279.433532] [079/132] (741s left) gem_mmap_gtt (medium-copy-xy) [279.490509] Subtest medium-copy-XY: SKIP (0.000s) [279.555973] [080/132] (741s left) syncobj_timeline (multi-wait-available-submitted) [279.601110] Starting subtest: multi-wait-available-submitted [279.603099] Subtest multi-wait-available-submitted: SUCCESS (0.000s) [279.741569] [081/132] (741s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt) [279.840206] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt [279.843640] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [279.926116] [082/132] (740s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw) [280.041854] Starting subtest: fbcpsr-2p-pri-indfb-multidraw [280.045225] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s) [280.121981] [083/132] (740s left) gem_exec_whisper (basic-contexts-forked) [280.191237] Starting subtest: basic-contexts-forked [303.969515] Subtest basic-contexts-forked: SUCCESS (23.772s) [304.169845] [084/132] (716s left) prime_vgem (fence-flip-hang) [304.253115] Subtest fence-flip-hang: SKIP (0.000s) [304.365931] [085/132] (716s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite) [304.473952] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite [312.397748] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.929s) [312.526448] [086/132] (708s left) kms_rotation_crc (multiplane-rotation-cropping-top) [312.631274] Starting subtest: multiplane-rotation-cropping-top [330.087911] Subtest multiplane-rotation-cropping-top: SUCCESS (17.460s) [330.204965] [087/132] (690s left) api_intel_allocator (gem-pool) [330.270043] Starting subtest: gem-pool [330.274648] Subtest gem-pool: SUCCESS (0.007s) [330.407973] [088/132] (690s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling) [330.506420] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling [330.508292] Starting dynamic subtest: pipe-A-default-mode [333.267657] Dynamic subtest pipe-A-default-mode: SUCCESS (2.758s) [333.269585] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.760s) [334.141961] [089/132] (687s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs) [334.196014] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs [334.200352] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s) [334.380805] [090/132] (686s left) kms_flip (2x-absolute-wf_vblank-interruptible) [334.475420] Starting subtest: 2x-absolute-wf_vblank-interruptible [334.487552] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.011s) [334.569082] [091/132] (686s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render) [334.674535] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render [334.678617] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [334.775599] [092/132] (686s left) kms_cursor_crc (cursor-rapid-movement-512x170) [335.074699] Starting subtest: cursor-rapid-movement-512x170 [335.079272] Subtest cursor-rapid-movement-512x170: SKIP (0.001s) [335.231635] [093/132] (686s left) kms_chamelium_frames (hdmi-crc-multiple) [335.614833] Subtest hdmi-crc-multiple: SKIP (0.000s) [336.441472] [094/132] (684s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [336.541948] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [336.546651] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [336.648617] [095/132] (684s left) gem_exec_balancer (bonded-sync) [336.720033] Starting subtest: bonded-sync [336.724692] Subtest bonded-sync: SKIP (0.000s) [337.049272] [096/132] (684s left) kms_flip (flip-vs-rmfb-interruptible) [337.146290] Starting subtest: flip-vs-rmfb-interruptible [337.148725] Starting dynamic subtest: A-eDP1 [345.754568] Dynamic subtest A-eDP1: SUCCESS (8.607s) [345.769098] Starting dynamic subtest: B-eDP1 [354.384792] Dynamic subtest B-eDP1: SUCCESS (8.627s) [354.398047] Starting dynamic subtest: C-eDP1 [363.035401] Dynamic subtest C-eDP1: SUCCESS (8.647s) [363.048936] Starting dynamic subtest: D-eDP1 [371.634312] Dynamic subtest D-eDP1: SUCCESS (8.596s) [371.638626] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.493s) [372.828019] [097/132] (648s left) kms_dither (fb-8bpc-vs-panel-8bpc) [372.918165] Starting subtest: fb-8bpc-vs-panel-8bpc [372.920442] Starting dynamic subtest: pipe-A-eDP-1 [374.326620] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.408s) [374.328839] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.410s) [375.203617] [098/132] (646s left) gen7_exec_parse (basic-allocation) [375.268081] Subtest basic-allocation: SKIP (0.000s) [375.343182] [099/132] (646s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [375.432532] Starting subtest: addfb25-y-tiled-small-legacy [375.436626] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [375.518718] [100/132] (646s left) kms_frontbuffer_tracking (fbc-tiling-linear) [375.623587] Starting subtest: fbc-tiling-linear [379.343810] Subtest fbc-tiling-linear: SUCCESS (3.726s) [380.482939] [101/132] (641s left) gem_close_race (basic-threads) [380.541485] Starting subtest: basic-threads [382.015387] Subtest basic-threads: SUCCESS (1.473s) [382.200687] [102/132] (639s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping) [382.305934] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping [382.310269] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s) [382.380349] [103/132] (639s left) kms_psr (fbc-psr2-primary-mmap-gtt) [382.476544] Starting subtest: fbc-psr2-primary-mmap-gtt [382.478817] Starting dynamic subtest: eDP-1 [382.482976] Dynamic subtest eDP-1: SKIP (0.000s) [382.487132] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s) [382.570515] [104/132] (639s left) sysfs_timeslice_duration (duration) [382.626893] Starting subtest: duration [382.629317] Starting dynamic subtest: vecs0 [396.188085] Dynamic subtest vecs0: SUCCESS (13.558s) [396.202030] Starting dynamic subtest: ccs0 [409.338620] Dynamic subtest ccs0: SUCCESS (13.148s) [409.352814] Starting dynamic subtest: vcs0 [423.195958] Dynamic subtest vcs0: SUCCESS (13.854s) [423.209566] Starting dynamic subtest: bcs0 [436.343644] Dynamic subtest bcs0: SUCCESS (13.145s) [436.355387] Starting dynamic subtest: rcs0 [449.486938] Dynamic subtest rcs0: SUCCESS (13.141s) [449.500712] Starting dynamic subtest: vcs1 [463.198060] Dynamic subtest vcs1: SUCCESS (13.707s) [463.201276] Subtest duration: SUCCESS (80.570s) [463.275329] [105/132] (558s left) kms_joiner (basic-big-joiner) [463.376398] Starting subtest: basic-big-joiner [463.380462] Subtest basic-big-joiner: SKIP (0.000s) [463.445223] [106/132] (558s left) kms_plane (pixel-format-y-tiled-modifier) [463.531608] Starting subtest: pixel-format-y-tiled-modifier [463.535762] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s) [463.605421] [107/132] (558s left) kms_flip_tiling (flip-change-tiling) [463.687209] Starting subtest: flip-change-tiling [463.689497] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs [463.861881] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.175s) [463.877401] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs [464.007746] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.142s) [464.020219] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [464.140754] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s) [464.154046] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4 [464.284621] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s) [464.298428] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x [464.428300] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s) [464.443279] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear [464.599803] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.169s) [464.617360] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs [464.744679] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.142s) [464.759854] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs [464.867030] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.121s) [464.878728] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [465.001542] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s) [465.014725] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4 [465.144915] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s) [465.159088] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x [465.289053] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s) [465.303612] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear [465.433476] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s) [465.445095] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [465.566499] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s) [465.578647] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [465.701690] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s) [465.714907] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [465.811486] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.108s) [465.824274] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4 [465.944962] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.131s) [465.958146] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x [466.088634] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s) [466.104601] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear [466.233196] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s) [466.246241] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs [466.378263] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s) [466.391086] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs [466.523400] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s) [466.537465] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc [466.667023] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.141s) [466.680856] Starting dynamic subtest: pipe-A-eDP-1-4-to-4 [466.788976] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.120s) [466.802019] Starting dynamic subtest: pipe-A-eDP-1-4-to-x [466.932923] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.142s) [466.948599] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear [467.077474] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.142s) [467.092617] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs [467.222061] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s) [467.237467] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs [467.366485] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s) [467.380940] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc [467.510975] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s) [467.523879] Starting dynamic subtest: pipe-A-eDP-1-x-to-4 [467.655666] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.142s) [467.670997] Starting dynamic subtest: pipe-A-eDP-1-x-to-x [467.789078] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.131s) [467.802047] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear [467.933828] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.143s) [467.945890] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs [468.077391] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s) [468.093094] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs [468.233278] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.152s) [468.246348] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc [468.378653] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s) [468.395571] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4 [468.533045] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.153s) [468.547799] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x [468.689254] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.153s) [468.705329] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear [468.822635] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.131s) [468.876311] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs [470.135372] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.266s) [470.148926] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs [470.270045] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s) [470.283400] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [470.403478] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s) [470.416983] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4 [470.546471] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s) [470.560027] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x [470.690729] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s) [470.704410] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear [470.834576] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s) [470.847305] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs [470.968051] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s) [470.981189] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs [471.079713] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s) [471.093048] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [471.214356] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s) [471.228105] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4 [471.357421] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s) [471.373773] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x [471.501490] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s) [471.515042] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear [471.645697] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s) [471.658851] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [471.779793] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s) [471.793041] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [471.925069] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.142s) [471.938256] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [472.035505] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s) [472.048036] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4 [472.179862] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.143s) [472.191886] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x [472.323445] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s) [472.336201] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear [472.467761] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s) [472.483954] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs [472.612698] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.141s) [472.625437] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs [472.757483] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s) [472.771033] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc [472.902218] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s) [472.916064] Starting dynamic subtest: pipe-B-eDP-1-4-to-4 [473.023466] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.120s) [473.041040] Starting dynamic subtest: pipe-B-eDP-1-4-to-x [473.168455] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.142s) [473.182495] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear [473.312596] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.142s) [473.328389] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs [473.456563] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s) [473.471995] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs [473.601270] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s) [473.613424] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc [473.745597] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s) [473.762469] Starting dynamic subtest: pipe-B-eDP-1-x-to-4 [473.890051] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.142s) [473.902192] Starting dynamic subtest: pipe-B-eDP-1-x-to-x [474.012479] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.120s) [474.025349] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear [474.157024] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.142s) [474.169444] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs [474.301072] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s) [474.315571] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs [474.445844] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s) [474.458744] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc [474.590070] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s) [474.603234] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4 [474.745540] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.153s) [474.768035] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x [474.890665] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.142s) [474.903222] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear [475.023693] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.131s) [475.077986] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs [476.264465] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.194s) [476.276934] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs [476.376384] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.109s) [476.389222] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [476.487068] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.109s) [476.500772] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4 [476.597886] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s) [476.611042] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x [476.708669] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s) [476.723074] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear [476.819471] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.109s) [476.830901] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs [476.920161] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s) [476.931918] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs [477.020263] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s) [477.031735] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [477.120336] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s) [477.133707] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4 [477.231063] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s) [477.243054] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x [477.341349] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s) [477.355789] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear [477.452364] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s) [477.465371] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [477.552824] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s) [477.567655] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [477.664353] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.108s) [477.676348] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [477.775461] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s) [477.787830] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4 [477.886783] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s) [477.898800] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x [477.997075] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s) [478.011617] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear [478.108042] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s) [478.119047] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs [478.219749] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.109s) [478.238075] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs [478.330999] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.108s) [478.342777] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc [478.441868] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s) [478.452828] Starting dynamic subtest: pipe-C-eDP-1-4-to-4 [478.564541] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.120s) [478.578048] Starting dynamic subtest: pipe-C-eDP-1-4-to-x [478.674896] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.109s) [478.688848] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear [478.785918] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.109s) [478.802829] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs [478.896953] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.108s) [478.908622] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs [479.008145] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.110s) [479.020755] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc [479.119375] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.109s) [479.131434] Starting dynamic subtest: pipe-C-eDP-1-x-to-4 [479.230415] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.110s) [479.243531] Starting dynamic subtest: pipe-C-eDP-1-x-to-x [479.341778] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.109s) [479.355037] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear [479.452869] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.109s) [479.465592] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs [479.563667] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s) [479.576622] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs [479.663909] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.098s) [479.676111] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc [479.775084] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.110s) [479.787328] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4 [479.886249] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.109s) [479.899528] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x [480.008645] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.120s) [480.021096] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear [480.130861] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.120s) [480.173958] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs [481.402585] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.236s) [481.415960] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs [481.502302] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s) [481.514104] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [481.602465] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s) [481.616713] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4 [481.702283] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.098s) [481.715263] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x [481.812588] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s) [481.830413] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear [481.935156] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.121s) [481.948300] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs [482.035582] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s) [482.048994] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs [482.136082] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s) [482.149736] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [482.236055] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s) [482.249335] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4 [482.346417] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s) [482.361726] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x [482.457090] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s) [482.469087] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear [482.568453] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s) [482.580286] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [482.668333] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s) [482.679756] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [482.768485] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s) [482.781076] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [482.868630] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s) [482.881215] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4 [482.979616] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s) [482.992769] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x [483.090406] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s) [483.103077] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear [483.201531] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s) [483.214152] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs [483.312393] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.109s) [483.328136] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs [483.424467] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.109s) [483.437256] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc [483.535247] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s) [483.548505] Starting dynamic subtest: pipe-D-eDP-1-4-to-4 [483.646329] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.109s) [483.658482] Starting dynamic subtest: pipe-D-eDP-1-4-to-x [483.756941] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.109s) [483.769080] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear [483.867916] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.109s) [483.880189] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs [483.978912] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.110s) [483.995297] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs [484.079609] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.099s) [484.092634] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc [484.190176] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.110s) [484.203119] Starting dynamic subtest: pipe-D-eDP-1-x-to-4 [484.340132] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.148s) [484.355182] Starting dynamic subtest: pipe-D-eDP-1-x-to-x [484.451820] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.108s) [484.464732] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear [484.562585] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.109s) [484.575229] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs [484.673426] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s) [484.685706] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs [484.784646] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s) [484.797438] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc [484.895550] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s) [484.910331] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4 [485.006787] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.109s) [485.018831] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x [485.118539] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.109s) [485.131801] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear [485.240573] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.120s) [485.273108] Subtest flip-change-tiling: SUCCESS (21.588s) [486.408084] [108/132] (535s left) kms_vrr (flip-basic-fastset) [486.505397] Starting subtest: flip-basic-fastset [486.512118] Subtest flip-basic-fastset: SKIP (0.000s) [486.592712] [109/132] (535s left) gem_eio (in-flight-suspend) [486.833224] Starting subtest: in-flight-suspend [529.864039] Subtest in-flight-suspend: SUCCESS (13.792s) [529.993339] [110/132] (492s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf) [530.107631] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf [530.109865] Starting dynamic subtest: pipe-A-eDP-1 [541.115158] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.001s) [541.127021] Starting dynamic subtest: pipe-B-eDP-1 [552.857767] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.736s) [552.860140] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.740s) [553.706784] [111/132] (468s left) kms_concurrent (multi-plane-atomic-lowres) [553.802066] Starting subtest: multi-plane-atomic-lowres [553.804578] Starting dynamic subtest: pipe-A-eDP-1 [554.308356] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.508s) [554.319657] Starting dynamic subtest: pipe-B-eDP-1 [555.542447] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.230s) [555.553146] Starting dynamic subtest: pipe-C-eDP-1 [556.818062] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.272s) [556.829036] Starting dynamic subtest: pipe-D-eDP-1 [558.112838] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.295s) [558.115437] Subtest multi-plane-atomic-lowres: SUCCESS (4.311s) [558.942418] [112/132] (463s left) kms_atomic_transition (plane-all-modeset-transition) [559.037998] Starting subtest: plane-all-modeset-transition [559.043193] Subtest plane-all-modeset-transition: SKIP (0.000s) [559.115199] [113/132] (463s left) gem_exec_capture (pi) [559.170940] Starting subtest: pi [559.173948] Starting dynamic subtest: rcs0 [563.313392] Dynamic subtest rcs0: SUCCESS (4.144s) [563.329777] Starting dynamic subtest: bcs0 [567.310209] Dynamic subtest bcs0: SUCCESS (3.995s) [567.333434] Starting dynamic subtest: vcs0 [571.252424] Dynamic subtest vcs0: SUCCESS (3.942s) [571.264988] Starting dynamic subtest: vcs1 [575.249387] Dynamic subtest vcs1: SUCCESS (3.996s) [575.260194] Starting dynamic subtest: vecs0 [579.182470] Dynamic subtest vecs0: SUCCESS (3.931s) [579.198430] Starting dynamic subtest: ccs0 [583.229315] Dynamic subtest ccs0: SUCCESS (4.045s) [583.232143] Subtest pi: SUCCESS (24.062s) [583.362593] [114/132] (438s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt) [583.525624] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt [587.315382] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.794s) [588.443771] [115/132] (433s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic) [588.564600] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic [606.007027] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.440s) [606.807520] [116/132] (415s left) kms_psr (fbc-psr-sprite-mmap-cpu) [606.920411] Starting subtest: fbc-psr-sprite-mmap-cpu [606.922976] Starting dynamic subtest: eDP-1 [606.927914] Dynamic subtest eDP-1: SKIP (0.000s) [606.932860] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s) [606.993699] [117/132] (415s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt) [607.094971] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt [611.704149] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.612s) [612.914871] [118/132] (409s left) gem_workarounds (reset) [612.984330] Starting subtest: reset [613.144296] Subtest reset: SUCCESS (0.158s) [613.275619] [119/132] (409s left) kms_psr (psr2-basic) [613.366341] Starting subtest: psr2-basic [613.368595] Starting dynamic subtest: eDP-1 [614.970802] Dynamic subtest eDP-1: SUCCESS (1.605s) [614.973646] Subtest psr2-basic: SUCCESS (1.607s) [615.763817] [120/132] (406s left) perf_pmu (semaphore-wait) [615.817650] Starting subtest: semaphore-wait [615.820166] Starting dynamic subtest: rcs0 [616.331037] Dynamic subtest rcs0: SUCCESS (0.513s) [616.345432] Starting dynamic subtest: bcs0 [616.846325] Dynamic subtest bcs0: SUCCESS (0.512s) [616.858946] Starting dynamic subtest: vcs0 [617.362136] Dynamic subtest vcs0: SUCCESS (0.513s) [617.380344] Starting dynamic subtest: vcs1 [617.875924] Dynamic subtest vcs1: SUCCESS (0.511s) [617.889423] Starting dynamic subtest: vecs0 [618.389182] Dynamic subtest vecs0: SUCCESS (0.511s) [618.403306] Starting dynamic subtest: ccs0 [618.907716] Dynamic subtest ccs0: SUCCESS (0.515s) [618.910553] Subtest semaphore-wait: SUCCESS (3.092s) [619.028913] [121/132] (403s left) gem_exec_schedule (pi-shared-iova) [619.231894] Starting subtest: pi-shared-iova [619.235049] Starting dynamic subtest: rcs0 [619.372036] Dynamic subtest rcs0: SUCCESS (0.140s) [619.390177] Starting dynamic subtest: vcs0 [619.458387] Dynamic subtest vcs0: SUCCESS (0.086s) [619.470764] Starting dynamic subtest: vcs1 [619.547385] Dynamic subtest vcs1: SUCCESS (0.088s) [619.561783] Starting dynamic subtest: vecs0 [619.639426] Dynamic subtest vecs0: SUCCESS (0.091s) [619.651182] Starting dynamic subtest: ccs0 [619.765687] Dynamic subtest ccs0: SUCCESS (0.125s) [619.768180] Subtest pi-shared-iova: SUCCESS (0.535s) [620.625257] [122/132] (402s left) gen7_exec_parse (load-register-reg) [620.698726] Subtest load-register-reg: SKIP (0.000s) [620.759393] [123/132] (401s left) gem_exec_reloc (basic-gtt-read-noreloc) [620.826168] Subtest basic-gtt-read-noreloc: SKIP (0.000s) [620.902097] [124/132] (401s left) gem_mmap_gtt (zero-extend) [620.966001] Subtest zero-extend: SKIP (0.000s) [621.028808] [125/132] (401s left) fbdev (eof) [621.080139] Starting subtest: eof [621.082638] Subtest eof: SUCCESS (0.000s) [621.158560] [126/132] (401s left) kms_cursor_crc (cursor-sliding-256x85) [621.441181] Starting subtest: cursor-sliding-256x85 [621.486154] Subtest cursor-sliding-256x85: SKIP (0.040s) [621.643975] [127/132] (401s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d) [621.742989] Starting subtest: plane-lut1d-ctm3x4-lut1d [621.866340] Starting dynamic subtest: pipe-A-plane-0 [622.033797] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s) [622.045091] Starting dynamic subtest: pipe-A-plane-1 [622.165705] Dynamic subtest pipe-A-plane-1: SUCCESS (0.132s) [622.176812] Starting dynamic subtest: pipe-A-plane-2 [622.321342] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s) [623.604196] Starting dynamic subtest: pipe-B-plane-0 [623.773985] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s) [623.785659] Starting dynamic subtest: pipe-B-plane-1 [623.961588] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s) [623.973108] Starting dynamic subtest: pipe-B-plane-2 [624.117973] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s) [625.309635] Starting dynamic subtest: pipe-C-plane-0 [625.445155] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s) [625.459229] Starting dynamic subtest: pipe-C-plane-1 [625.589505] Dynamic subtest pipe-C-plane-1: SUCCESS (0.143s) [625.600911] Starting dynamic subtest: pipe-C-plane-2 [625.733842] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s) [626.934041] Starting dynamic subtest: pipe-D-plane-0 [627.078924] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s) [627.091027] Starting dynamic subtest: pipe-D-plane-1 [627.223079] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s) [627.235987] Starting dynamic subtest: pipe-D-plane-2 [627.367596] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s) [627.652961] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (5.911s) [628.485790] [128/132] (394s left) kms_psr (psr2-primary-mmap-cpu) [628.582683] Starting subtest: psr2-primary-mmap-cpu [628.584983] Starting dynamic subtest: eDP-1 [630.266751] Dynamic subtest eDP-1: SUCCESS (1.685s) [630.269446] Subtest psr2-primary-mmap-cpu: SUCCESS (1.686s) [631.153716] [129/132] (391s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs) [631.252313] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs [631.254948] Starting dynamic subtest: pipe-A-eDP-1 [631.282976] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [631.295608] Starting dynamic subtest: pipe-B-eDP-1 [631.323915] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [631.334940] Starting dynamic subtest: pipe-C-eDP-1 [631.363996] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [631.375982] Starting dynamic subtest: pipe-D-eDP-1 [631.404714] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [631.409472] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.009s) [633.519264] [130/132] (389s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt) [633.617043] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt [633.622429] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [633.726829] [131/132] (389s left) i915_drm_fdinfo (busy) [633.772085] Starting subtest: busy [633.775051] Starting dynamic subtest: rcs0 [633.791224] Dynamic subtest rcs0: SKIP (0.019s) [633.803363] Starting dynamic subtest: bcs0 [633.808350] Dynamic subtest bcs0: SKIP (0.000s) [633.819581] Starting dynamic subtest: vcs0 [633.824675] Dynamic subtest vcs0: SKIP (0.000s) [633.835465] Starting dynamic subtest: vcs1 [633.840175] Dynamic subtest vcs1: SKIP (0.000s) [633.850855] Starting dynamic subtest: vecs0 [633.855764] Dynamic subtest vecs0: SKIP (0.000s) [633.866633] Starting dynamic subtest: ccs0 [633.871619] Dynamic subtest ccs0: SKIP (0.000s) [633.876634] Subtest busy: SKIP (0.024s) [633.919548] [132/132] (389s left) kms_async_flips (test-cursor-atomic) [634.010150] Starting subtest: test-cursor-atomic [634.404609] Starting dynamic subtest: pipe-A-eDP-1 [635.208069] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.803s) [635.598696] Starting dynamic subtest: pipe-B-eDP-1 [636.331046] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.744s) [636.701442] Starting dynamic subtest: pipe-C-eDP-1 [637.463626] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.773s) [637.836132] Starting dynamic subtest: pipe-D-eDP-1 [638.592739] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.767s) [638.595409] Subtest test-cursor-atomic: SUCCESS (4.584s) [639.765995] Closing watchdogs results: parsing output: 0/ for test: kms_psr results: parsing output: 1/ for test: kms_setmode results: parsing output: 2/ for test: syncobj_timeline results: parsing output: 3/ for test: gem_lmem_swapping results: parsing output: 4/ for test: gem_gpgpu_fill results: parsing output: 5/ for test: api_intel_bb results: parsing output: 6/ for test: gem_flink_basic results: parsing output: 7/ for test: kms_universal_plane results: parsing output: 8/ for test: kms_big_fb results: parsing output: 9/ for test: gem_madvise results: parsing output: 10/ for test: perf_pmu results: parsing output: 11/ for test: syncobj_wait results: parsing output: 12/ for test: kms_chamelium_hpd results: parsing output: 13/ for test: kms_multipipe_modeset results: parsing output: 14/ for test: kms_pm_lpsp results: parsing output: 15/ for test: gem_exec_create results: parsing output: 16/ for test: gem_partial_pwrite_pread results: parsing output: 17/ for test: prime_vgem results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: kms_frontbuffer_tracking results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: kms_ccs results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: syncobj_timeline results: parsing output: 25/ for test: gem_mmap_gtt results: parsing output: 26/ for test: kms_big_fb results: parsing output: 27/ for test: kms_ccs results: parsing output: 28/ for test: kms_flip_scaled_crc results: parsing output: 29/ for test: gem_ctx_shared results: parsing output: 30/ for test: kms_plane_scaling results: parsing output: 31/ for test: kms_big_fb results: parsing output: 32/ for test: gem_ctx_param results: parsing output: 33/ for test: i915_query results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: kms_atomic_interruptible results: parsing output: 36/ for test: gem_exec_params results: parsing output: 37/ for test: gem_ctx_persistence results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: gem_ctx_bad_destroy results: parsing output: 40/ for test: kms_prop_blob results: parsing output: 41/ for test: syncobj_wait results: parsing output: 42/ for test: gem_exec_reloc results: parsing output: 43/ for test: kms_big_fb results: parsing output: 44/ for test: gem_softpin results: parsing output: 45/ for test: gem_readwrite results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: syncobj_wait results: parsing output: 48/ for test: kms_ccs results: parsing output: 49/ for test: kms_big_fb results: parsing output: 50/ for test: kms_draw_crc results: parsing output: 51/ for test: i915_pciid results: parsing output: 52/ for test: kms_ccs results: parsing output: 53/ for test: gem_exec_schedule results: parsing output: 54/ for test: syncobj_timeline results: parsing output: 55/ for test: kms_lease results: parsing output: 56/ for test: perf results: parsing output: 57/ for test: kms_cursor_legacy results: parsing output: 58/ for test: kms_rotation_crc results: parsing output: 59/ for test: kms_cursor_crc results: parsing output: 60/ for test: gem_exec_reloc results: parsing output: 61/ for test: i915_pm_rc6_residency results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: core_setmaster results: parsing output: 64/ for test: gem_exec_fence results: parsing output: 65/ for test: kms_plane results: parsing output: 66/ for test: kms_frontbuffer_tracking results: parsing output: 67/ for test: gem_pxp results: parsing output: 68/ for test: kms_ccs results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: perf_pmu results: parsing output: 71/ for test: kms_cursor_legacy results: parsing output: 72/ for test: gem_close_race results: parsing output: 73/ for test: core_setmaster_vs_auth results: parsing output: 74/ for test: syncobj_timeline results: parsing output: 75/ for test: gem_pxp results: parsing output: 76/ for test: syncobj_wait results: parsing output: 77/ for test: sw_sync results: parsing output: 78/ for test: gem_mmap_gtt results: parsing output: 79/ for test: syncobj_timeline results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: gem_exec_whisper results: parsing output: 83/ for test: prime_vgem results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_rotation_crc results: parsing output: 86/ for test: api_intel_allocator results: parsing output: 87/ for test: kms_flip_scaled_crc results: parsing output: 88/ for test: gem_render_copy results: parsing output: 89/ for test: kms_flip results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: kms_cursor_crc results: parsing output: 92/ for test: kms_chamelium_frames results: parsing output: 93/ for test: kms_big_fb results: parsing output: 94/ for test: gem_exec_balancer results: parsing output: 95/ for test: kms_flip results: parsing output: 96/ for test: kms_dither results: parsing output: 97/ for test: gen7_exec_parse results: parsing output: 98/ for test: kms_addfb_basic results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: gem_close_race results: parsing output: 101/ for test: kms_plane results: parsing output: 102/ for test: kms_psr results: parsing output: 103/ for test: sysfs_timeslice_duration results: parsing output: 104/ for test: kms_joiner results: parsing output: 105/ for test: kms_plane results: parsing output: 106/ for test: kms_flip_tiling results: parsing output: 107/ for test: kms_vrr results: parsing output: 108/ for test: gem_eio results: parsing output: 109/ for test: kms_psr2_sf results: parsing output: 110/ for test: kms_concurrent results: parsing output: 111/ for test: kms_atomic_transition results: parsing output: 112/ for test: gem_exec_capture results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: kms_cursor_legacy results: parsing output: 115/ for test: kms_psr results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: gem_workarounds results: parsing output: 118/ for test: kms_psr results: parsing output: 119/ for test: perf_pmu results: parsing output: 120/ for test: gem_exec_schedule results: parsing output: 121/ for test: gen7_exec_parse results: parsing output: 122/ for test: gem_exec_reloc results: parsing output: 123/ for test: gem_mmap_gtt results: parsing output: 124/ for test: fbdev results: parsing output: 125/ for test: kms_cursor_crc results: parsing output: 126/ for test: kms_color_pipeline results: parsing output: 127/ for test: kms_psr results: parsing output: 128/ for test: kms_ccs results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: i915_drm_fdinfo results: parsing output: 131/ for test: kms_async_flips Done.