[42.939465] Initializing watchdogs [42.939494] /dev/watchdog0 [42.945905] [001/130] (960s left) kms_lease (lease-invalid-connector) [43.076972] Starting subtest: lease-invalid-connector [43.079402] Starting dynamic subtest: pipe-A-eDP-1 [43.081744] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [43.088110] Starting dynamic subtest: pipe-B-eDP-1 [43.090315] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [43.095274] Starting dynamic subtest: pipe-C-eDP-1 [43.097112] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [43.101317] Starting dynamic subtest: pipe-D-eDP-1 [43.103637] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [43.105868] Subtest lease-invalid-connector: SUCCESS (0.002s) [43.126316] [002/130] (960s left) kms_cursor_crc (cursor-offscreen-512x170) [43.361956] Starting subtest: cursor-offscreen-512x170 [43.366239] Subtest cursor-offscreen-512x170: SKIP (0.001s) [43.494273] [003/130] (959s left) gem_mmap_gtt (basic-write-cpu-read-gtt) [43.538815] Subtest basic-write-cpu-read-gtt: SKIP (0.000s) [43.579429] [004/130] (959s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [43.692578] Starting subtest: basic-flip-after-cursor-varying-size [44.630090] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.936s) [45.511590] [005/130] (957s left) gem_exec_params (cliprects-invalid) [45.566081] Starting subtest: cliprects-invalid [45.568559] Subtest cliprects-invalid: SUCCESS (0.000s) [45.633544] [006/130] (957s left) kms_big_fb (linear-16bpp-rotate-270) [45.726080] Starting subtest: linear-16bpp-rotate-270 [45.744521] Subtest linear-16bpp-rotate-270: SKIP (0.018s) [45.826261] [007/130] (957s left) vgem_basic (setversion) [45.888883] Starting subtest: setversion [45.893037] Subtest setversion: SUCCESS (0.000s) [45.922851] [008/130] (957s left) kms_big_fb (4-tiled-32bpp-rotate-90) [46.019708] Starting subtest: 4-tiled-32bpp-rotate-90 [46.037165] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.018s) [46.135304] [009/130] (957s left) gem_mmap_gtt (cpuset-medium-copy-xy) [46.180226] Subtest cpuset-medium-copy-XY: SKIP (0.000s) [46.210770] [010/130] (957s left) kms_atomic_interruptible (legacy-cursor) [46.302744] Starting subtest: legacy-cursor [46.305108] Starting dynamic subtest: pipe-A-eDP-1 [53.798736] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.499s) [53.801614] Subtest legacy-cursor: SUCCESS (7.500s) [54.666571] [011/130] (948s left) kms_color (invalid-degamma-lut-sizes) [54.765032] Starting subtest: invalid-degamma-lut-sizes [54.767453] Starting dynamic subtest: pipe-A [55.049368] Dynamic subtest pipe-A: SUCCESS (0.284s) [55.056218] Starting dynamic subtest: pipe-B [55.058734] Dynamic subtest pipe-B: SUCCESS (0.001s) [55.063753] Starting dynamic subtest: pipe-C [55.066131] Dynamic subtest pipe-C: SUCCESS (0.000s) [55.071141] Starting dynamic subtest: pipe-D [55.073078] Dynamic subtest pipe-D: SUCCESS (0.001s) [55.074999] Subtest invalid-degamma-lut-sizes: SUCCESS (0.286s) [55.946221] [012/130] (947s left) kms_psr (psr-sprite-blt) [56.034966] Starting subtest: psr-sprite-blt [56.037219] Starting dynamic subtest: eDP-1 [57.807297] Dynamic subtest eDP-1: SUCCESS (1.772s) [57.809975] Subtest psr-sprite-blt: SUCCESS (1.773s) [58.696822] [013/130] (944s left) syncobj_timeline (multi-wait-for-submit-available-signaled) [58.744046] Starting subtest: multi-wait-for-submit-available-signaled [58.746860] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s) [58.813054] [014/130] (944s left) gem_ctx_create (basic-files) [58.865088] Starting subtest: basic-files [60.873703] Subtest basic-files: SUCCESS (2.006s) [62.399826] [015/130] (941s left) kms_ccs (bad-pixel-format-y-tiled-ccs) [62.478793] Starting subtest: bad-pixel-format-y-tiled-ccs [62.481117] Starting dynamic subtest: pipe-A-eDP-1 [62.503321] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [62.509744] Starting dynamic subtest: pipe-B-eDP-1 [62.531969] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [62.538044] Starting dynamic subtest: pipe-C-eDP-1 [62.560249] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [62.566231] Starting dynamic subtest: pipe-D-eDP-1 [62.589202] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [62.593347] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.002s) [62.606082] [016/130] (941s left) api_intel_bb (blit-noreloc-keep-cache) [62.661040] Starting subtest: blit-noreloc-keep-cache [62.667745] Subtest blit-noreloc-keep-cache: SUCCESS (0.010s) [62.775486] [017/130] (940s left) gem_exec_reloc (basic-scanout) [62.827364] Subtest basic-scanout: SKIP (0.000s) [62.868422] [018/130] (940s left) gem_exec_whisper (basic-fds-priority) [62.924704] Starting subtest: basic-fds-priority [85.679981] Subtest basic-fds-priority: SUCCESS (22.757s) [85.838264] [019/130] (917s left) kms_busy (extended-modeset-hang-oldfb) [85.930460] Starting subtest: extended-modeset-hang-oldfb [85.932753] Starting dynamic subtest: pipe-A [97.744599] Dynamic subtest pipe-A: SUCCESS (11.810s) [97.752143] Starting dynamic subtest: pipe-D [110.540330] Dynamic subtest pipe-D: SUCCESS (12.797s) [110.543810] Subtest extended-modeset-hang-oldfb: SUCCESS (24.610s) [111.435129] [020/130] (892s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite) [111.538944] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite [116.957334] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (5.422s) [117.067535] [021/130] (886s left) kms_big_fb (y-tiled-64bpp-rotate-90) [117.153798] Starting subtest: y-tiled-64bpp-rotate-90 [117.158298] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s) [117.219483] [022/130] (886s left) gem_partial_pwrite_pread (writes-after-reads) [117.264164] Subtest writes-after-reads: SKIP (0.000s) [117.292899] [023/130] (886s left) kms_cursor_crc (cursor-onscreen-64x21) [117.449244] Starting subtest: cursor-onscreen-64x21 [117.482683] Subtest cursor-onscreen-64x21: SKIP (0.031s) [117.661435] [024/130] (886s left) gem_fenced_exec_thrash (no-spare-fences-interruptible) [117.706426] Subtest no-spare-fences-interruptible: SKIP (0.000s) [117.747830] [025/130] (886s left) prime_vgem (basic-blt) [117.803832] Starting subtest: basic-blt [117.841054] Subtest basic-blt: SUCCESS (0.036s) [117.951840] [026/130] (885s left) gem_exec_reloc (basic-gtt-wc) [117.993815] Subtest basic-gtt-wc: SKIP (0.000s) [118.042217] [027/130] (885s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt) [118.141434] Starting subtest: psr-farfromfence-mmap-gtt [118.144811] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s) [118.210967] [028/130] (885s left) syncobj_timeline (invalid-query-illegal-handle) [118.257425] Starting subtest: invalid-query-illegal-handle [118.259319] Subtest invalid-query-illegal-handle: SUCCESS (0.000s) [118.320050] [029/130] (885s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt) [118.408035] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt [118.411561] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [118.480425] [030/130] (885s left) gem_create (create-ext-set-pat) [118.632245] Starting subtest: create-ext-set-pat [118.635096] Subtest create-ext-set-pat: SUCCESS (0.001s) [118.709782] [031/130] (885s left) drm_fdinfo (virtual-busy-hang) [118.742921] Starting subtest: virtual-busy-hang [118.747357] Subtest virtual-busy-hang: SKIP (0.000s) [118.783941] [032/130] (885s left) syncobj_timeline (host-signal-points) [118.831131] Starting subtest: host-signal-points [118.833542] Subtest host-signal-points: SUCCESS (0.003s) [118.883659] [033/130] (884s left) gem_eio (throttle) [119.069415] Starting subtest: throttle [119.355045] Subtest throttle: SUCCESS (0.284s) [119.488790] [034/130] (884s left) kms_cursor_crc (cursor-rapid-movement-64x21) [119.640605] Starting subtest: cursor-rapid-movement-64x21 [119.676147] Subtest cursor-rapid-movement-64x21: SKIP (0.031s) [119.878790] [035/130] (883s left) gem_exec_params (no-blt) [119.929937] Starting subtest: no-blt [119.931849] Subtest no-blt: SUCCESS (0.002s) [120.030824] [036/130] (883s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs) [120.118449] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs [120.120524] Starting dynamic subtest: pipe-A-eDP-1 [120.139290] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [120.147892] Starting dynamic subtest: pipe-B-eDP-1 [120.166090] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [120.172145] Starting dynamic subtest: pipe-C-eDP-1 [120.189917] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [120.195354] Starting dynamic subtest: pipe-D-eDP-1 [120.213610] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [120.217251] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.003s) [120.229644] [037/130] (883s left) dmabuf_sync_file (export-before-signal) [120.267770] Starting subtest: export-before-signal [120.269342] Subtest export-before-signal: SUCCESS (0.000s) [120.301970] [038/130] (883s left) kms_flip (flip-vs-rmfb-interruptible) [120.396211] Starting subtest: flip-vs-rmfb-interruptible [120.397949] Starting dynamic subtest: A-eDP1 [129.099538] Dynamic subtest A-eDP1: SUCCESS (8.702s) [129.107213] Starting dynamic subtest: B-eDP1 [137.802042] Dynamic subtest B-eDP1: SUCCESS (8.701s) [137.810286] Starting dynamic subtest: C-eDP1 [146.494508] Dynamic subtest C-eDP1: SUCCESS (8.692s) [146.501739] Starting dynamic subtest: D-eDP1 [155.198081] Dynamic subtest D-eDP1: SUCCESS (8.702s) [155.202635] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.805s) [156.427232] [039/130] (847s left) kms_cursor_legacy (cursor-vs-flip-atomic) [156.533769] Starting subtest: cursor-vs-flip-atomic [185.224254] Subtest cursor-vs-flip-atomic: SUCCESS (28.691s) [186.122897] [040/130] (817s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [186.222334] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [186.226849] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [186.290505] [041/130] (817s left) perf_pmu (busy-no-semaphores) [186.323385] Starting subtest: busy-no-semaphores [186.326259] Starting dynamic subtest: rcs0 [186.886962] Dynamic subtest rcs0: SUCCESS (0.563s) [186.894268] Starting dynamic subtest: bcs0 [187.436469] Dynamic subtest bcs0: SUCCESS (0.548s) [187.446709] Starting dynamic subtest: vcs0 [187.986446] Dynamic subtest vcs0: SUCCESS (0.548s) [187.996429] Starting dynamic subtest: vcs1 [189.865964] Dynamic subtest vcs1: SUCCESS (1.878s) [189.874660] Starting dynamic subtest: vecs0 [191.915034] Dynamic subtest vecs0: SUCCESS (2.047s) [191.923505] Starting dynamic subtest: ccs0 [193.900061] Dynamic subtest ccs0: SUCCESS (1.984s) [193.903175] Subtest busy-no-semaphores: SUCCESS (7.577s) [193.997630] [042/130] (809s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [194.084942] Starting subtest: addfb25-yf-tiled-legacy [194.087257] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [194.158064] [043/130] (809s left) syncobj_timeline (wait-delayed-signal) [194.204562] Starting subtest: wait-delayed-signal [194.304547] Subtest wait-delayed-signal: SUCCESS (0.102s) [194.359636] [044/130] (809s left) gem_render_copy (yf-tiled) [194.409319] Starting subtest: yf-tiled [194.414675] Subtest yf-tiled: SKIP (0.000s) [194.570078] [045/130] (809s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc) [194.661935] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc [194.664317] Starting dynamic subtest: pipe-A-eDP-1 [194.686393] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [194.694554] Starting dynamic subtest: pipe-B-eDP-1 [194.715914] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [194.722326] Starting dynamic subtest: pipe-C-eDP-1 [194.743994] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [194.750325] Starting dynamic subtest: pipe-D-eDP-1 [194.772673] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [194.776841] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [194.793705] [046/130] (809s left) gem_spin_batch (legacy) [194.844916] Starting subtest: legacy [194.847632] Starting dynamic subtest: default [198.090377] Dynamic subtest default: SUCCESS (3.240s) [198.100217] Starting dynamic subtest: render [201.329046] Dynamic subtest render: SUCCESS (3.237s) [201.338745] Starting dynamic subtest: bsd [204.565389] Dynamic subtest bsd: SUCCESS (3.234s) [204.574543] Starting dynamic subtest: bsd1 [207.808053] Dynamic subtest bsd1: SUCCESS (3.242s) [207.816699] Starting dynamic subtest: bsd2 [211.049471] Dynamic subtest bsd2: SUCCESS (3.237s) [211.056982] Starting dynamic subtest: blt [214.293275] Dynamic subtest blt: SUCCESS (3.244s) [214.299915] Starting dynamic subtest: vebox [217.535886] Dynamic subtest vebox: SUCCESS (3.241s) [217.538179] Subtest legacy: SUCCESS (22.687s) [219.405115] [047/130] (784s left) gem_lmem_swapping (parallel-random-verify) [219.454242] Subtest parallel-random-verify: SKIP (0.000s) [219.477710] [048/130] (784s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines) [220.005117] Starting subtest: syncobj-stationary-timeline-chain-engines [220.171754] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.167s) [221.446932] [049/130] (782s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf) [226.613357] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf [226.618445] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s) [227.531907] [050/130] (776s left) gem_gpgpu_fill (basic) [227.581546] Starting subtest: basic [227.584203] Starting dynamic subtest: smem [227.589041] Dynamic subtest smem: SUCCESS (0.009s) [227.591325] Subtest basic: SUCCESS (0.009s) [227.681546] [051/130] (776s left) gem_exec_flush (basic-batch-kernel-default-wb) [227.743117] Starting subtest: basic-batch-kernel-default-wb [234.125330] Subtest basic-batch-kernel-default-wb: SUCCESS (6.384s) [234.288878] [052/130] (769s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt) [234.385121] Starting subtest: psr-rgb565-draw-blt [239.220901] Subtest psr-rgb565-draw-blt: SUCCESS (4.841s) [239.330604] [053/130] (764s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible) [239.378978] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s) [239.421065] [054/130] (764s left) gem_pwrite (basic-random) [239.479613] Subtest basic-random: SKIP (0.000s) [239.510425] [055/130] (764s left) kms_getfb (getfb-handle-closed) [239.550888] Starting subtest: getfb-handle-closed [239.553263] Subtest getfb-handle-closed: SUCCESS (0.000s) [239.635964] [056/130] (764s left) kms_chamelium_color (ctm-max) [239.721115] Subtest ctm-max: SKIP (0.000s) [239.743592] [057/130] (764s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt) [239.836748] Starting subtest: fbc-rgb101010-draw-blt [243.473281] Subtest fbc-rgb101010-draw-blt: SUCCESS (3.639s) [243.575503] [058/130] (760s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5) [243.670186] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5 [243.672407] Starting dynamic subtest: pipe-A [243.681110] Dynamic subtest pipe-A: SKIP (0.004s) [243.688038] Starting dynamic subtest: pipe-B [243.696478] Dynamic subtest pipe-B: SKIP (0.014s) [243.702773] Starting dynamic subtest: pipe-C [243.711460] Dynamic subtest pipe-C: SKIP (0.015s) [243.717937] Starting dynamic subtest: pipe-D [243.730184] Dynamic subtest pipe-D: SKIP (0.020s) [243.734493] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.055s) [243.789525] [059/130] (760s left) kms_psr (fbc-psr2-primary-mmap-gtt) [243.882875] Starting subtest: fbc-psr2-primary-mmap-gtt [243.885163] Starting dynamic subtest: eDP-1 [243.889530] Dynamic subtest eDP-1: SKIP (0.000s) [243.893521] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s) [243.932996] [060/130] (760s left) kms_writeback (writeback-pixel-formats) [244.033064] Subtest writeback-pixel-formats: SKIP (0.000s) [244.054697] [061/130] (760s left) kms_chamelium_hpd (common-hpd-after-suspend) [244.434246] Subtest common-hpd-after-suspend: SKIP (0.000s) [245.303408] [062/130] (758s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling) [245.384872] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling [245.387089] Starting dynamic subtest: pipe-A-default-mode [246.582855] Dynamic subtest pipe-A-default-mode: SKIP (1.193s) [246.587695] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.194s) [246.702131] [063/130] (757s left) gem_exec_reloc (basic-wc-cpu) [246.755037] Subtest basic-wc-cpu: SKIP (0.000s) [246.798608] [064/130] (757s left) i915_pm_freq_api (freq-reset-multiple) [246.849715] Starting subtest: freq-reset-multiple [246.852058] Starting dynamic subtest: gt0 [256.290390] Dynamic subtest gt0: SUCCESS (9.437s) [256.298802] Starting dynamic subtest: gt1 [263.996215] Dynamic subtest gt1: SUCCESS (7.706s) [263.999048] Subtest freq-reset-multiple: SUCCESS (17.143s) [264.051768] [065/130] (740s left) kms_vblank (wait-idle) [264.147759] Starting subtest: wait-idle [264.150106] Starting dynamic subtest: pipe-A-eDP-1 [265.900370] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.749s) [265.911953] Starting dynamic subtest: pipe-D-eDP-1 [268.392950] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.490s) [268.395775] Subtest wait-idle: SUCCESS (4.243s) [269.257263] [066/130] (735s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu) [269.357807] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu [269.362886] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [269.428274] [067/130] (734s left) syncobj_wait (wait-any-complex) [269.474149] Starting subtest: wait-any-complex [269.534417] Subtest wait-any-complex: SUCCESS (0.062s) [269.588013] [068/130] (734s left) gem_render_copy (yf-tiled-ccs-to-linear) [269.642576] Starting subtest: yf-tiled-ccs-to-linear [269.648215] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s) [269.800885] [069/130] (734s left) kms_invalid_mode (zero-hdisplay) [269.887083] Starting subtest: zero-hdisplay [269.889456] Starting dynamic subtest: pipe-A-eDP-1 [270.169964] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s) [270.179377] Starting dynamic subtest: pipe-B-eDP-1 [270.181930] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [270.188229] Starting dynamic subtest: pipe-C-eDP-1 [270.191100] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [270.197572] Starting dynamic subtest: pipe-D-eDP-1 [270.200109] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [270.202755] Subtest zero-hdisplay: SUCCESS (0.287s) [271.052664] [070/130] (733s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [271.145297] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [271.149383] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [271.210151] [071/130] (733s left) kms_pm_rpm (dpms-mode-unset-lpsp) [273.530293] Starting subtest: dpms-mode-unset-lpsp [277.584613] Subtest dpms-mode-unset-lpsp: SUCCESS (4.054s) [277.909179] [072/130] (726s left) core_getversion (basic) [277.938308] Starting subtest: basic [277.942417] Subtest basic: SUCCESS (0.000s) [277.977858] [073/130] (726s left) gem_exec_schedule (semaphore-resolve) [278.051068] Starting subtest: semaphore-resolve [278.073790] Subtest semaphore-resolve: SUCCESS (0.034s) [278.396978] [074/130] (726s left) kms_plane_alpha_blend (alpha-basic) [278.487929] Starting subtest: alpha-basic [278.766620] Starting dynamic subtest: pipe-A-eDP-1 [280.674035] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.904s) [280.691478] Starting dynamic subtest: pipe-D-eDP-1 [283.390703] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.704s) [283.393205] Subtest alpha-basic: SUCCESS (4.901s) [284.298051] [075/130] (720s left) gem_userptr_blits (process-exit-busy) [284.349462] Starting subtest: process-exit-busy [284.355645] Subtest process-exit-busy: SUCCESS (0.013s) [284.456372] [076/130] (720s left) gem_userptr_blits (map-fixed-invalidate-overlap) [284.512164] Starting subtest: map-fixed-invalidate-overlap [284.516623] Subtest map-fixed-invalidate-overlap: SKIP (0.000s) [284.624167] [077/130] (719s left) kms_vblank (query-idle-hang) [284.710901] Starting subtest: query-idle-hang [284.713234] Starting dynamic subtest: pipe-A-eDP-1 [311.132223] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.418s) [311.144058] Starting dynamic subtest: pipe-D-eDP-1 [326.181665] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.045s) [326.184021] Subtest query-idle-hang: SUCCESS (41.467s) [327.052084] [078/130] (677s left) gem_exec_endless (dispatch) [327.101780] Starting subtest: dispatch [327.104549] Starting dynamic subtest: rcs0 [327.109477] Dynamic subtest rcs0: SUCCESS (0.004s) [327.118411] Starting dynamic subtest: bcs0 [327.123039] Dynamic subtest bcs0: SUCCESS (0.003s) [327.129254] Starting dynamic subtest: vcs0 [327.133510] Dynamic subtest vcs0: SUCCESS (0.003s) [327.139271] Starting dynamic subtest: vcs1 [327.143494] Dynamic subtest vcs1: SUCCESS (0.004s) [327.149285] Starting dynamic subtest: vecs0 [327.153470] Dynamic subtest vecs0: SUCCESS (0.003s) [327.159166] Starting dynamic subtest: ccs0 [327.163705] Dynamic subtest ccs0: SUCCESS (0.003s) [327.165690] Subtest dispatch: SUCCESS (0.021s) [328.378460] [079/130] (676s left) prime_vgem (basic-fence-read) [328.451963] Starting subtest: basic-fence-read [328.463594] Subtest basic-fence-read: SKIP (0.009s) [328.552356] [080/130] (675s left) kms_flip (2x-modeset-vs-vblank-race-interruptible) [328.633940] Starting subtest: 2x-modeset-vs-vblank-race-interruptible [328.649853] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.014s) [328.701404] [081/130] (675s left) kms_properties (plane-properties-legacy) [328.788892] Starting subtest: plane-properties-legacy [328.791201] Starting dynamic subtest: pipe-A-eDP-1 [329.333481] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.542s) [329.342415] Starting dynamic subtest: pipe-B-eDP-1 [330.712725] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.377s) [330.723552] Starting dynamic subtest: pipe-C-eDP-1 [332.057891] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.344s) [332.066744] Starting dynamic subtest: pipe-D-eDP-1 [333.387863] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s) [333.390264] Subtest plane-properties-legacy: SUCCESS (4.596s) [334.282712] [082/130] (670s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs) [334.369815] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs [334.372118] Starting dynamic subtest: pipe-A-eDP-1 [335.608039] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.237s) [335.615214] Starting dynamic subtest: pipe-B-eDP-1 [338.013209] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.403s) [338.022809] Starting dynamic subtest: pipe-C-eDP-1 [340.367915] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.355s) [340.375930] Starting dynamic subtest: pipe-D-eDP-1 [342.738293] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.369s) [342.740677] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.368s) [343.947946] [083/130] (660s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-wc) [344.048647] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-wc [348.365558] Subtest psr-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (4.319s) [348.466366] [084/130] (656s left) syncobj_wait (reset-during-wait-for-submit) [348.518688] Starting subtest: reset-during-wait-for-submit [348.617873] Subtest reset-during-wait-for-submit: SUCCESS (0.102s) [348.673660] [085/130] (655s left) kms_plane_lowres (tiling-none) [348.754863] Starting subtest: tiling-none [348.757185] Starting dynamic subtest: pipe-A-eDP-1 [348.761785] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [349.047987] Starting dynamic subtest: pipe-B-eDP-1 [349.053580] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [349.061120] Starting dynamic subtest: pipe-C-eDP-1 [349.066064] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [349.072366] Starting dynamic subtest: pipe-D-eDP-1 [349.077177] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [349.081879] Subtest tiling-none: SKIP (0.290s) [349.901546] [086/130] (654s left) kms_psr (psr2-primary-mmap-gtt) [349.987853] Starting subtest: psr2-primary-mmap-gtt [349.990086] Starting dynamic subtest: eDP-1 [351.505539] Dynamic subtest eDP-1: SKIP (1.512s) [351.510929] Subtest psr2-primary-mmap-gtt: SKIP (1.513s) [351.608740] [087/130] (653s left) kms_atomic_transition (plane-all-transition) [351.699097] Starting subtest: plane-all-transition [351.701447] Starting dynamic subtest: pipe-A-eDP-1 [354.191107] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.489s) [354.488128] Starting dynamic subtest: pipe-B-eDP-1 [357.832476] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.351s) [358.106463] Subtest plane-all-transition: SUCCESS (6.406s) [358.986254] [088/130] (645s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render) [359.097482] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render [363.962212] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.868s) [364.062244] [089/130] (640s left) kms_addfb_basic (bad-pitch-1024) [364.108916] Starting subtest: bad-pitch-1024 [364.111125] Subtest bad-pitch-1024: SUCCESS (0.000s) [364.219398] [090/130] (640s left) kms_flip (flip-vs-wf_vblank-interruptible) [364.308964] Starting subtest: flip-vs-wf_vblank-interruptible [364.313500] Starting dynamic subtest: A-eDP1 [366.257379] Dynamic subtest A-eDP1: SUCCESS (1.945s) [366.266202] Starting dynamic subtest: B-eDP1 [368.240363] Dynamic subtest B-eDP1: SUCCESS (1.982s) [368.247072] Starting dynamic subtest: C-eDP1 [370.213405] Dynamic subtest C-eDP1: SUCCESS (1.971s) [370.221753] Starting dynamic subtest: D-eDP1 [372.196802] Dynamic subtest D-eDP1: SUCCESS (1.983s) [372.202074] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.891s) [373.450276] [091/130] (631s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling) [373.534134] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling [373.536526] Starting dynamic subtest: pipe-A-default-mode [376.385027] Dynamic subtest pipe-A-default-mode: SUCCESS (2.846s) [376.387589] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.848s) [377.290994] [092/130] (627s left) kms_flip (flip-vs-blocking-wf-vblank) [377.374066] Starting subtest: flip-vs-blocking-wf-vblank [377.376424] Starting dynamic subtest: A-eDP1 [386.376354] Dynamic subtest A-eDP1: SUCCESS (9.001s) [386.385282] Starting dynamic subtest: B-eDP1 [395.402567] Dynamic subtest B-eDP1: SUCCESS (9.023s) [395.411038] Starting dynamic subtest: C-eDP1 [404.413778] Dynamic subtest C-eDP1: SUCCESS (9.011s) [404.421797] Starting dynamic subtest: D-eDP1 [413.373697] Dynamic subtest D-eDP1: SUCCESS (8.959s) [413.379826] Subtest flip-vs-blocking-wf-vblank: SUCCESS (36.006s) [414.604743] [093/130] (590s left) gen9_exec_parse (bb-large) [414.659901] Subtest bb-large: SKIP (0.000s) [414.691148] [094/130] (590s left) i915_hangman (gt-engine-error) [414.731598] Starting subtest: gt-engine-error [414.733720] Starting dynamic subtest: rcs0 [416.326608] Dynamic subtest rcs0: SUCCESS (1.594s) [416.337408] Starting dynamic subtest: bcs0 [418.374547] Dynamic subtest bcs0: SUCCESS (2.046s) [418.384162] Starting dynamic subtest: vcs0 [420.359313] Dynamic subtest vcs0: SUCCESS (1.983s) [420.369889] Starting dynamic subtest: vcs1 [422.342924] Dynamic subtest vcs1: SUCCESS (1.983s) [422.354752] Starting dynamic subtest: vecs0 [424.326265] Dynamic subtest vecs0: SUCCESS (1.982s) [424.335836] Starting dynamic subtest: ccs0 [426.311124] Dynamic subtest ccs0: SUCCESS (1.984s) [426.314186] Subtest gt-engine-error: SUCCESS (11.579s) [426.368033] [095/130] (578s left) gem_exec_fence (syncobj-timeline-invalid-wait) [426.873765] Starting subtest: syncobj-timeline-invalid-wait [426.879508] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.006s) [428.466694] [096/130] (576s left) kms_cursor_legacy (single-move) [428.579712] Starting subtest: single-move [428.581602] Starting dynamic subtest: pipe-A [433.959910] Dynamic subtest pipe-A: SUCCESS (5.377s) [433.968977] Starting dynamic subtest: pipe-B [439.338840] Dynamic subtest pipe-B: SUCCESS (5.378s) [439.347601] Starting dynamic subtest: pipe-C [444.718336] Dynamic subtest pipe-C: SUCCESS (5.378s) [444.727610] Starting dynamic subtest: pipe-D [450.097200] Dynamic subtest pipe-D: SUCCESS (5.378s) [450.108171] Starting dynamic subtest: all-pipes [455.485272] Dynamic subtest all-pipes: SUCCESS (5.387s) [455.488094] Subtest single-move: SUCCESS (26.904s) [455.571473] [097/130] (549s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0) [455.672536] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0 [455.676989] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [455.730709] [098/130] (549s left) kms_psr (fbc-psr-cursor-render) [455.826022] Starting subtest: fbc-psr-cursor-render [455.828371] Starting dynamic subtest: eDP-1 [455.832887] Dynamic subtest eDP-1: SKIP (0.000s) [455.837434] Subtest fbc-psr-cursor-render: SKIP (0.001s) [455.875812] [099/130] (548s left) kms_psr (pr-sprite-mmap-cpu) [455.964975] Starting subtest: pr-sprite-mmap-cpu [455.969398] Subtest pr-sprite-mmap-cpu: SKIP (0.000s) [456.013361] [100/130] (548s left) gem_ctx_persistence (legacy-engines-hang) [456.048131] Starting subtest: legacy-engines-hang [456.050485] Starting dynamic subtest: render [456.178553] Dynamic subtest render: SUCCESS (0.129s) [456.188904] Starting dynamic subtest: bsd1 [456.257093] Dynamic subtest bsd1: SUCCESS (0.077s) [456.264844] Starting dynamic subtest: bsd2 [456.367236] Dynamic subtest bsd2: SUCCESS (0.108s) [456.375279] Starting dynamic subtest: blt [456.402063] Dynamic subtest blt: SUCCESS (0.033s) [456.409196] Starting dynamic subtest: vebox [456.478156] Dynamic subtest vebox: SUCCESS (0.075s) [456.480937] Subtest legacy-engines-hang: SUCCESS (0.429s) [456.594148] [101/130] (548s left) gem_ctx_param (invalid-ctx-get) [456.645806] Starting subtest: invalid-ctx-get [456.648315] Subtest invalid-ctx-get: SUCCESS (0.000s) [456.690510] [102/130] (548s left) gem_ctx_persistence (engines-mixed-process) [456.737984] Starting subtest: engines-mixed-process [456.739998] Starting dynamic subtest: rcs0 [458.421420] Dynamic subtest rcs0: SUCCESS (1.682s) [458.431289] Starting dynamic subtest: bcs0 [460.410319] Dynamic subtest bcs0: SUCCESS (1.988s) [460.419090] Starting dynamic subtest: vcs0 [462.382636] Dynamic subtest vcs0: SUCCESS (1.971s) [462.391874] Starting dynamic subtest: vcs1 [464.364609] Dynamic subtest vcs1: SUCCESS (1.981s) [464.373869] Starting dynamic subtest: vecs0 [466.364639] Dynamic subtest vecs0: SUCCESS (1.999s) [466.376251] Starting dynamic subtest: ccs0 [468.405184] Dynamic subtest ccs0: SUCCESS (2.040s) [468.407947] Subtest engines-mixed-process: SUCCESS (11.667s) [468.465745] [103/130] (536s left) kms_frontbuffer_tracking (fbc-2p-rte) [468.565845] Starting subtest: fbc-2p-rte [468.570497] Subtest fbc-2p-rte: SKIP (0.000s) [468.636993] [104/130] (536s left) gem_eio (in-flight-contexts-1us) [468.819242] Starting subtest: in-flight-contexts-1us [477.367041] Subtest in-flight-contexts-1us: SUCCESS (8.549s) [477.508810] [105/130] (527s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt) [477.602054] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt [482.548335] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.951s) [482.647443] [106/130] (522s left) kms_plane_scaling (plane-downscale-factor-0-25-with-modifiers) [482.735795] Starting subtest: plane-downscale-factor-0-25-with-modifiers [482.738033] Starting dynamic subtest: pipe-A [482.752618] Dynamic subtest pipe-A: SKIP (0.010s) [482.759948] Starting dynamic subtest: pipe-B [482.772195] Dynamic subtest pipe-B: SKIP (0.020s) [482.778875] Starting dynamic subtest: pipe-C [482.793746] Dynamic subtest pipe-C: SKIP (0.020s) [482.800086] Starting dynamic subtest: pipe-D [482.811760] Dynamic subtest pipe-D: SKIP (0.020s) [482.815982] Subtest plane-downscale-factor-0-25-with-modifiers: SKIP (0.071s) [482.877599] [107/130] (522s left) prime_self_import (basic-with_fd_dup) [482.901178] Starting subtest: basic-with_fd_dup [482.928646] Subtest basic-with_fd_dup: SUCCESS (0.026s) [483.016061] [108/130] (521s left) sysfs_timeslice_duration (idempotent) [483.064467] Starting subtest: idempotent [483.067053] Starting dynamic subtest: vecs0 [483.069304] Dynamic subtest vecs0: SUCCESS (0.000s) [483.075459] Starting dynamic subtest: ccs0 [483.077680] Dynamic subtest ccs0: SUCCESS (0.000s) [483.083642] Starting dynamic subtest: vcs0 [483.085872] Dynamic subtest vcs0: SUCCESS (0.000s) [483.091830] Starting dynamic subtest: bcs0 [483.094072] Dynamic subtest bcs0: SUCCESS (0.000s) [483.100188] Starting dynamic subtest: rcs0 [483.102063] Dynamic subtest rcs0: SUCCESS (0.000s) [483.107678] Starting dynamic subtest: vcs1 [483.109832] Dynamic subtest vcs1: SUCCESS (0.000s) [483.112455] Subtest idempotent: SUCCESS (0.003s) [483.132183] [109/130] (521s left) gem_eio (context-create) [483.316042] Starting subtest: context-create [483.590214] Subtest context-create: SUCCESS (0.272s) [483.719666] [110/130] (521s left) kms_big_fb (yf-tiled-addfb) [483.813978] Starting subtest: yf-tiled-addfb [483.817733] Subtest yf-tiled-addfb: SKIP (0.000s) [483.877361] [111/130] (521s left) gem_spin_batch (spin-all) [483.918049] Starting subtest: spin-all [483.928350] Subtest spin-all: SUCCESS (0.009s) [485.367868] [112/130] (519s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled) [485.416504] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled [485.515743] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.101s) [485.571145] [113/130] (519s left) gem_mmap_gtt (basic-small-copy-odd) [485.619592] Subtest basic-small-copy-odd: SKIP (0.000s) [485.656326] [114/130] (519s left) kms_big_fb (4-tiled-8bpp-rotate-90) [485.751632] Starting subtest: 4-tiled-8bpp-rotate-90 [485.773975] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.020s) [485.861068] [115/130] (519s left) kms_dp_linktrain_fallback (dp-fallback) [485.950783] Starting subtest: dp-fallback [485.957309] Subtest dp-fallback: SKIP (0.000s) [485.998381] [116/130] (519s left) gem_madvise (dontneed-before-exec) [486.026048] Starting subtest: dontneed-before-exec [486.054557] Subtest dontneed-before-exec: SKIP (0.023s) [486.092242] [117/130] (518s left) kms_prop_blob (blob-prop-lifetime) [486.136051] Starting subtest: blob-prop-lifetime [486.138168] Subtest blob-prop-lifetime: SUCCESS (0.001s) [486.192771] [118/130] (518s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip) [486.280773] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip [487.155838] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.877s) [487.265372] [119/130] (517s left) kms_psr2_su (page_flip-xrgb8888) [487.307421] Subtest page_flip-XRGB8888: SKIP (0.000s) [487.341588] [120/130] (517s left) kms_frontbuffer_tracking (psr-suspend) [487.437544] Starting subtest: psr-suspend [523.095207] Subtest psr-suspend: SUCCESS (5.312s) [523.195752] [121/130] (512s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf) [528.323907] Starting subtest: pr-overlay-plane-update-continuous-sf [528.328858] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.002s) [529.244983] [122/130] (506s left) kms_flip (basic-plain-flip) [529.336400] Starting subtest: basic-plain-flip [529.338717] Starting dynamic subtest: A-eDP1 [531.083415] Dynamic subtest A-eDP1: SUCCESS (1.745s) [531.095910] Starting dynamic subtest: B-eDP1 [532.811175] Dynamic subtest B-eDP1: SUCCESS (1.726s) [532.820151] Starting dynamic subtest: C-eDP1 [534.526995] Dynamic subtest C-eDP1: SUCCESS (1.715s) [534.537052] Starting dynamic subtest: D-eDP1 [536.254405] Dynamic subtest D-eDP1: SUCCESS (1.726s) [536.259711] Subtest basic-plain-flip: SUCCESS (6.923s) [537.498240] [123/130] (498s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render) [537.594767] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render [537.598939] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [537.662235] [124/130] (497s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-blt) [537.753301] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-blt [540.644568] Subtest fbc-1p-offscren-pri-shrfb-draw-blt: SUCCESS (2.898s) [540.757686] [125/130] (494s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc) [540.854857] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc [545.206300] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (4.352s) [545.317740] [126/130] (490s left) i915_pm_rps (reset) [545.369279] Starting subtest: reset [545.448741] Subtest reset: FAIL (0.010s) [545.501840] [127/130] (490s left) gem_ccs (block-copy-uncompressed) [545.547593] Starting subtest: block-copy-uncompressed [545.549907] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem [545.569758] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.022s) [545.578239] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem [545.591157] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.021s) [545.600142] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem [545.609866] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.018s) [545.616458] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem [545.627530] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s) [545.629801] Subtest block-copy-uncompressed: SUCCESS (0.080s) [545.727968] [128/130] (489s left) gem_sync (basic-each) [545.787952] Starting subtest: basic-each [548.273332] Subtest basic-each: SUCCESS (2.498s) [548.432218] [129/130] (487s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc) [548.537308] Starting subtest: fbc-rgb101010-draw-mmap-wc [552.116317] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (3.583s) [552.208122] [130/130] (483s left) gem_exec_balancer (nop) [552.258933] Starting subtest: nop [598.551561] Subtest nop: SUCCESS (46.286s) [598.775609] Closing watchdogs Done.