[58.650993] Initializing watchdogs [58.651054] /dev/watchdog0 [58.669307] [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] [58.673905] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.676508] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.679867] [001/133] (960s left) gem_exec_reloc (basic-wc-gtt) [58.772929] Subtest basic-wc-gtt: SKIP (0.000s) [58.840595] [002/133] (960s left) kms_force_connector_basic (prune-stale-modes) [58.925273] Starting subtest: prune-stale-modes [59.319332] Subtest prune-stale-modes: SUCCESS (0.397s) [59.477894] [003/133] (959s left) gem_pread (bench) [59.534506] Subtest bench: SKIP (0.000s) [59.606387] [004/133] (959s left) gem_exec_schedule (semaphore-noskip) [59.671598] Starting subtest: semaphore-noskip [60.105408] Subtest semaphore-noskip: SUCCESS (0.441s) [60.468535] [005/133] (958s left) kms_ccs (random-ccs-data-y-tiled-ccs) [60.561387] Starting subtest: random-ccs-data-y-tiled-ccs [60.565988] Starting dynamic subtest: pipe-A-eDP-1 [60.597304] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [60.607087] Starting dynamic subtest: pipe-B-eDP-1 [60.629595] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [60.637061] Starting dynamic subtest: pipe-C-eDP-1 [60.659368] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [60.666727] Starting dynamic subtest: pipe-D-eDP-1 [60.690329] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [60.694323] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.003s) [62.814188] [006/133] (956s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing) [62.916583] Starting subtest: plane-all-transition-nonblocking-fencing [62.918975] Starting dynamic subtest: pipe-A-eDP-1 [65.398696] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.498s) [65.721649] Starting dynamic subtest: pipe-B-eDP-1 [68.904325] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.202s) [69.202375] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.313s) [70.008253] [007/133] (949s left) gem_ctx_param (root-set) [70.059705] Starting subtest: root-set [70.062068] Subtest root-set: SUCCESS (0.001s) [70.161019] [008/133] (949s left) gem_vm_create (isolation) [70.214079] Starting subtest: isolation [70.222480] Subtest isolation: SUCCESS (0.010s) [70.349822] [009/133] (949s left) kms_scaling_modes (scaling-mode-center) [70.450273] Starting subtest: scaling-mode-center [70.452607] Starting dynamic subtest: pipe-A-eDP-1 [70.546124] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.098s) [70.558720] Starting dynamic subtest: pipe-B-eDP-1 [71.696436] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.150s) [71.706360] Starting dynamic subtest: pipe-C-eDP-1 [72.861664] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.166s) [72.872398] Starting dynamic subtest: pipe-D-eDP-1 [74.050451] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.189s) [74.052788] Subtest scaling-mode-center: SUCCESS (3.609s) [75.274322] [010/133] (944s left) kms_cursor_crc (cursor-sliding-32x10) [75.424113] Starting subtest: cursor-sliding-32x10 [75.471338] Subtest cursor-sliding-32x10: SKIP (0.043s) [75.704761] [011/133] (943s left) gem_mmap_gtt (basic-write-read) [75.757376] Subtest basic-write-read: SKIP (0.000s) [75.826592] [012/133] (943s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff) [75.924182] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff [75.928517] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [76.017902] [013/133] (943s left) kms_cursor_crc (cursor-offscreen-64x64) [76.200952] Starting subtest: cursor-offscreen-64x64 [76.205450] Starting dynamic subtest: pipe-A-eDP-1 [78.142739] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.940s) [78.174087] Starting dynamic subtest: pipe-D-eDP-1 [80.747484] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.582s) [80.749708] Subtest cursor-offscreen-64x64: SUCCESS (4.548s) [81.582982] [014/133] (938s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render) [81.685870] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render [88.961229] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.278s) [89.094689] [015/133] (930s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs) [89.193020] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs [89.195334] Starting dynamic subtest: pipe-A-eDP-1 [89.252978] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [89.262323] Starting dynamic subtest: pipe-B-eDP-1 [89.319315] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [89.328596] Starting dynamic subtest: pipe-C-eDP-1 [89.385694] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [89.394721] Starting dynamic subtest: pipe-D-eDP-1 [89.453335] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [89.457580] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.008s) [91.472948] [016/133] (928s left) gem_mmap (bad-object) [91.526662] Subtest bad-object: SKIP (0.000s) [91.591299] [017/133] (928s left) syncobj_wait (single-wait-all-signaled) [91.637828] Starting subtest: single-wait-all-signaled [91.640158] Subtest single-wait-all-signaled: SUCCESS (0.000s) [91.728316] [018/133] (928s left) kms_psr (fbc-pr-sprite-mmap-cpu) [91.818248] Starting subtest: fbc-pr-sprite-mmap-cpu [91.822221] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s) [91.887492] [019/133] (928s left) gem_exec_params (invalid-ring) [91.946234] Starting subtest: invalid-ring [91.948592] Subtest invalid-ring: SUCCESS (0.000s) [92.035921] [020/133] (927s left) kms_atomic_transition (modeset-transition-nonblocking-fencing) [92.130787] Starting subtest: modeset-transition-nonblocking-fencing [92.133083] Starting dynamic subtest: 1x-outputs [103.238675] Dynamic subtest 1x-outputs: SUCCESS (11.104s) [103.241379] Subtest modeset-transition-nonblocking-fencing: SUCCESS (11.105s) [104.073648] [021/133] (915s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt) [104.172892] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt [104.177189] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [104.263167] [022/133] (915s left) gem_eio (banned) [104.483253] Starting subtest: banned [105.076724] Subtest banned: SUCCESS (0.595s) [105.229635] [023/133] (914s left) gem_render_copy (y-tiled-to-vebox-yf-tiled) [105.289398] Starting subtest: y-tiled-to-vebox-yf-tiled [105.293152] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s) [105.474497] [024/133] (914s left) kms_cursor_crc (cursor-rapid-movement-128x128) [105.692716] Starting subtest: cursor-rapid-movement-128x128 [105.695086] Starting dynamic subtest: pipe-A-eDP-1 [106.239380] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.545s) [106.270948] Starting dynamic subtest: pipe-D-eDP-1 [107.467986] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.204s) [107.470328] Subtest cursor-rapid-movement-128x128: SUCCESS (1.775s) [108.270278] [025/133] (911s left) kms_prop_blob (basic) [108.335685] Starting subtest: basic [108.337843] Subtest basic: SUCCESS (0.000s) [108.448746] [026/133] (911s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s [108.565309] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size [108.569784] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s) [108.715422] [027/133] (911s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [108.824244] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [108.828458] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [108.917947] [028/133] (911s left) gem_exec_async (concurrent-writes) [108.984936] Starting subtest: concurrent-writes [108.987140] Starting dynamic subtest: rcs0 [109.003776] Dynamic subtest rcs0: SUCCESS (0.019s) [109.013328] Starting dynamic subtest: bcs0 [109.015443] Dynamic subtest bcs0: SUCCESS (0.007s) [109.023893] Starting dynamic subtest: vcs0 [109.025761] Dynamic subtest vcs0: SUCCESS (0.004s) [109.033953] Starting dynamic subtest: vcs1 [109.036082] Dynamic subtest vcs1: SUCCESS (0.006s) [109.043861] Starting dynamic subtest: vecs0 [109.045664] Dynamic subtest vecs0: SUCCESS (0.005s) [109.053411] Starting dynamic subtest: ccs0 [109.055274] Dynamic subtest ccs0: SUCCESS (0.006s) [109.057128] Subtest concurrent-writes: SUCCESS (0.049s) [109.246462] [029/133] (911s left) perf (create-destroy-userspace-config) [109.362420] Starting subtest: create-destroy-userspace-config [109.386868] Subtest create-destroy-userspace-config: SUCCESS (0.024s) [109.422833] [030/133] (910s left) gem_exec_fence (syncobj-repeat) [109.882356] Starting subtest: syncobj-repeat [110.073382] Subtest syncobj-repeat: SUCCESS (0.189s) [111.346854] [FACT gem_exec_fence (syncobj-repeat)] new: kernel.kmod_is_loaded.vgem: true [111.350029] [031/133] (909s left) kms_flip (2x-wf_vblank-ts-check) [111.453115] Starting subtest: 2x-wf_vblank-ts-check [111.465983] Subtest 2x-wf_vblank-ts-check: SKIP (0.014s) [111.547955] [032/133] (908s left) kms_invalid_mode (int-max-clock) [111.650776] Starting subtest: int-max-clock [111.653078] Starting dynamic subtest: pipe-A-eDP-1 [111.946559] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.297s) [111.955690] Starting dynamic subtest: pipe-B-eDP-1 [111.957580] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [111.965668] Starting dynamic subtest: pipe-C-eDP-1 [111.967647] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [111.978510] Starting dynamic subtest: pipe-D-eDP-1 [111.980948] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [111.983192] Subtest int-max-clock: SUCCESS (0.303s) [112.780921] [033/133] (907s left) kms_plane (plane-position-hole-dpms) [112.895671] Starting subtest: plane-position-hole-dpms [113.418704] Starting dynamic subtest: pipe-A-plane-1 [115.808337] Dynamic subtest pipe-A-plane-1: SUCCESS (2.391s) [115.818113] Starting dynamic subtest: pipe-A-plane-2 [118.209907] Dynamic subtest pipe-A-plane-2: SUCCESS (2.399s) [118.219425] Starting dynamic subtest: pipe-A-plane-3 [120.600488] Dynamic subtest pipe-A-plane-3: SUCCESS (2.391s) [120.610145] Starting dynamic subtest: pipe-A-plane-4 [122.996310] Dynamic subtest pipe-A-plane-4: SUCCESS (2.392s) [123.007462] Starting dynamic subtest: pipe-A-plane-5 [123.020806] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s) [124.260840] Starting dynamic subtest: pipe-B-plane-1 [126.626664] Dynamic subtest pipe-B-plane-1: SUCCESS (2.374s) [126.636500] Starting dynamic subtest: pipe-B-plane-2 [128.985300] Dynamic subtest pipe-B-plane-2: SUCCESS (2.356s) [128.994958] Starting dynamic subtest: pipe-B-plane-3 [131.309287] Dynamic subtest pipe-B-plane-3: SUCCESS (2.323s) [131.318594] Starting dynamic subtest: pipe-B-plane-4 [133.739895] Dynamic subtest pipe-B-plane-4: SUCCESS (2.429s) [133.749559] Starting dynamic subtest: pipe-B-plane-5 [133.764476] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s) [133.766383] Subtest plane-position-hole-dpms: SUCCESS (20.868s) [134.587769] [034/133] (885s left) kms_color (ctm-red-to-blue) [134.691355] Starting subtest: ctm-red-to-blue [134.693278] Starting dynamic subtest: pipe-A-eDP-1 [135.402978] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.712s) [135.416017] Starting dynamic subtest: pipe-B-eDP-1 [136.858705] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.452s) [136.868066] Starting dynamic subtest: pipe-C-eDP-1 [138.209801] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.352s) [138.218769] Starting dynamic subtest: pipe-D-eDP-1 [139.607163] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.395s) [139.609502] Subtest ctm-red-to-blue: SUCCESS (4.915s) [140.481239] [035/133] (880s left) gem_softpin (full) [140.549052] Starting subtest: full [140.554659] Subtest full: SUCCESS (0.008s) [140.664463] [036/133] (879s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move) [140.755622] Starting subtest: fbc-1p-primscrn-spr-indfb-move [145.010828] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.258s) [146.188315] [037/133] (874s left) gem_ctx_isolation (dirty-switch) [146.252647] Starting subtest: dirty-switch [146.254997] Starting dynamic subtest: rcs0 [146.448122] Dynamic subtest rcs0: SUCCESS (0.195s) [146.458393] Starting dynamic subtest: bcs0 [146.673687] Dynamic subtest bcs0: SUCCESS (0.224s) [146.685290] Starting dynamic subtest: vcs0 [146.897578] Dynamic subtest vcs0: SUCCESS (0.223s) [146.908663] Starting dynamic subtest: vcs1 [148.461636] Dynamic subtest vcs1: SUCCESS (1.563s) [148.472906] Starting dynamic subtest: vecs0 [150.479097] Dynamic subtest vecs0: SUCCESS (2.016s) [150.489998] Starting dynamic subtest: ccs0 [152.541899] Dynamic subtest ccs0: SUCCESS (2.062s) [152.544308] Subtest dirty-switch: SUCCESS (6.289s) [152.792665] [038/133] (867s left) kms_cursor_legacy (flip-vs-cursor-toggle) [152.917713] Starting subtest: flip-vs-cursor-toggle [161.914548] Subtest flip-vs-cursor-toggle: SUCCESS (8.996s) [162.769864] [039/133] (857s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [162.864322] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu [162.868832] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [162.951126] [040/133] (857s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area) [163.045570] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area [163.049685] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s) [163.114024] [041/133] (857s left) syncobj_timeline (wait-zero-handles) [163.185680] Starting subtest: wait-zero-handles [163.188103] Subtest wait-zero-handles: SUCCESS (0.000s) [163.296215] [042/133] (857s left) kms_plane_multiple (tiling-none) [163.391954] Starting subtest: tiling-none [163.394220] Starting dynamic subtest: pipe-A-eDP-1 [167.204248] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.809s) [167.213638] Starting dynamic subtest: pipe-B-eDP-1 [171.820271] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.617s) [171.829499] Starting dynamic subtest: pipe-C-eDP-1 [176.408708] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.586s) [176.417701] Starting dynamic subtest: pipe-D-eDP-1 [181.005216] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.595s) [181.007542] Subtest tiling-none: SUCCESS (17.612s) [181.876341] [043/133] (839s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75) [181.979807] Starting subtest: planes-upscale-20x20-downscale-factor-0-75 [181.982173] Starting dynamic subtest: pipe-A [182.002406] Dynamic subtest pipe-A: SKIP (0.018s) [182.011796] Starting dynamic subtest: pipe-B [182.034730] Dynamic subtest pipe-B: SKIP (0.032s) [182.043348] Starting dynamic subtest: pipe-C [182.065778] Dynamic subtest pipe-C: SKIP (0.030s) [182.074917] Starting dynamic subtest: pipe-D [182.097610] Dynamic subtest pipe-D: SKIP (0.031s) [182.101358] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.115s) [182.197785] [044/133] (838s left) kms_big_fb (linear-16bpp-rotate-270) [182.300185] Starting subtest: linear-16bpp-rotate-270 [182.318488] Subtest linear-16bpp-rotate-270: SKIP (0.018s) [182.438075] [045/133] (838s left) kms_getfb (getfb2-accept-nv12) [182.533127] Starting subtest: getfb2-accept-nv12 [182.535451] Subtest getfb2-accept-nv12: SUCCESS (0.001s) [182.626694] [046/133] (838s left) gem_flink_basic (double-flink) [182.683590] Starting subtest: double-flink [182.685578] Subtest double-flink: SUCCESS (0.000s) [182.813225] [047/133] (838s left) i915_suspend (basic-s2idle-without-i915) [182.857457] Starting subtest: basic-s2idle-without-i915 [203.433814] Subtest basic-s2idle-without-i915: SUCCESS (5.672s) [203.583576] [048/133] (817s left) gem_pxp (regular-baseline-src-copy-readible) [203.744336] Starting subtest: regular-baseline-src-copy-readible [203.805343] Subtest regular-baseline-src-copy-readible: SUCCESS (0.064s) [203.946700] [049/133] (817s left) prime_vgem (fence-wait) [204.032155] Starting subtest: fence-wait [204.034366] Starting dynamic subtest: rcs0 [205.066147] Dynamic subtest rcs0: SUCCESS (1.049s) [205.077081] Starting dynamic subtest: bcs0 [206.126309] Dynamic subtest bcs0: SUCCESS (1.074s) [206.137321] Starting dynamic subtest: vcs0 [207.175365] Dynamic subtest vcs0: SUCCESS (1.059s) [207.186574] Starting dynamic subtest: vcs1 [209.198309] Dynamic subtest vcs1: SUCCESS (2.040s) [209.209500] Starting dynamic subtest: vecs0 [210.238066] Dynamic subtest vecs0: SUCCESS (1.046s) [210.247799] Starting dynamic subtest: ccs0 [211.280564] Dynamic subtest ccs0: SUCCESS (1.048s) [211.283232] Subtest fence-wait: SUCCESS (7.330s) [211.398188] [050/133] (809s left) gem_exec_balancer (parallel) [211.655155] Starting subtest: parallel [212.586646] Subtest parallel: SUCCESS (0.941s) [213.217834] [051/133] (808s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling) [213.319203] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling [213.323546] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s) [213.391311] [052/133] (807s left) kms_big_fb (yf-tiled-addfb) [213.478532] Starting subtest: yf-tiled-addfb [213.482563] Subtest yf-tiled-addfb: SKIP (0.000s) [213.576775] [053/133] (807s left) perf_pmu (most-busy-check-all) [213.618962] Starting subtest: most-busy-check-all [213.621162] Starting dynamic subtest: rcs0 [215.225471] Dynamic subtest rcs0: SUCCESS (1.613s) [215.238311] Starting dynamic subtest: bcs0 [217.209088] Dynamic subtest bcs0: SUCCESS (1.988s) [217.220384] Starting dynamic subtest: vcs0 [219.191670] Dynamic subtest vcs0: SUCCESS (1.986s) [219.201945] Starting dynamic subtest: vcs1 [221.178496] Dynamic subtest vcs1: SUCCESS (1.988s) [221.189748] Starting dynamic subtest: vecs0 [223.226144] Dynamic subtest vecs0: SUCCESS (2.048s) [223.237429] Starting dynamic subtest: ccs0 [225.208360] Dynamic subtest ccs0: SUCCESS (1.983s) [225.211150] Subtest most-busy-check-all: SUCCESS (11.624s) [225.310699] [054/133] (796s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted) [225.363367] Starting subtest: etime-single-wait-all-for-submit-submitted [225.469336] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.106s) [225.546173] [055/133] (795s left) kms_content_protection (dp-mst-type-1-suspend-resume) [225.691237] Starting subtest: dp-mst-type-1-suspend-resume [225.695904] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s) [225.805349] [056/133] (795s left) i915_drm_fdinfo (memory-info-idle) [225.849609] Starting subtest: memory-info-idle [225.851752] Starting dynamic subtest: smem0 [225.902279] Dynamic subtest smem0: SUCCESS (0.055s) [225.905207] Subtest memory-info-idle: SUCCESS (0.055s) [225.977632] [057/133] (795s left) kms_psr (pr-cursor-mmap-cpu) [226.066256] Starting subtest: pr-cursor-mmap-cpu [226.070699] Subtest pr-cursor-mmap-cpu: SKIP (0.000s) [226.141819] [058/133] (795s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt) [226.239977] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt [226.243956] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [226.350979] [059/133] (795s left) kms_chamelium_frames (hdmi-cmp-planar-formats) [226.746374] Subtest hdmi-cmp-planar-formats: SKIP (0.000s) [227.561614] [060/133] (794s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [227.664438] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu [234.793924] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.138s) [234.901394] [061/133] (786s left) gem_lmem_swapping (random-engines) [234.950642] Subtest random-engines: SKIP (0.000s) [234.997134] [062/133] (786s left) dumb_buffer (map-invalid-size) [235.052942] Starting subtest: map-invalid-size [235.055283] Subtest map-invalid-size: SUCCESS (0.000s) [235.167148] [063/133] (786s left) i915_drm_fdinfo (virtual-idle) [235.209119] Starting subtest: virtual-idle [238.274662] Subtest virtual-idle: SUCCESS (3.065s) [238.367522] [064/133] (783s left) api_intel_allocator (execbuf-with-allocator) [238.423237] Starting subtest: execbuf-with-allocator [238.430341] Subtest execbuf-with-allocator: SUCCESS (0.009s) [238.580679] [065/133] (783s left) kms_chamelium_hpd (vga-hpd-after-suspend) [238.973076] Subtest vga-hpd-after-suspend: SKIP (0.000s) [239.750505] [066/133] (782s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs) [239.843477] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs [239.845809] Starting dynamic subtest: pipe-A-eDP-1 [239.987325] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.135s) [239.999266] Starting dynamic subtest: pipe-B-eDP-1 [240.019489] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [240.028677] Starting dynamic subtest: pipe-C-eDP-1 [240.047423] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s) [240.056885] Starting dynamic subtest: pipe-D-eDP-1 [240.075638] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s) [240.077788] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.145s) [242.260167] [067/133] (779s left) syncobj_wait (single-wait-all-for-submit-signaled) [242.320974] Starting subtest: single-wait-all-for-submit-signaled [242.323356] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [242.429943] [068/133] (779s left) i915_pm_rpm (gem-pread) [244.357988] Starting subtest: gem-pread [246.407799] Subtest gem-pread: SUCCESS (2.050s) [246.495195] [069/133] (775s left) gem_create (hog-create) [246.551696] Starting subtest: hog-create [246.554099] Starting dynamic subtest: smem0 [280.195593] Dynamic subtest smem0: SUCCESS (33.651s) [280.198270] Subtest hog-create: SUCCESS (33.653s) [280.382015] [070/133] (741s left) gem_exec_await (wide-all) [280.622103] Starting subtest: wide-all [304.070090] Subtest wide-all: SUCCESS (23.450s) [304.277231] [071/133] (717s left) gem_exec_whisper (basic-queues-all) [304.387267] Starting subtest: basic-queues-all [317.146343] Subtest basic-queues-all: SUCCESS (12.750s) [317.331930] [072/133] (704s left) kms_flip (basic-flip-vs-dpms) [317.431467] Starting subtest: basic-flip-vs-dpms [317.433888] Starting dynamic subtest: A-eDP1 [320.069221] Dynamic subtest A-eDP1: SUCCESS (2.636s) [320.080056] Starting dynamic subtest: B-eDP1 [322.300380] Dynamic subtest B-eDP1: SUCCESS (2.231s) [322.313601] Starting dynamic subtest: C-eDP1 [324.378101] Dynamic subtest C-eDP1: SUCCESS (2.071s) [324.388243] Starting dynamic subtest: D-eDP1 [326.450059] Dynamic subtest D-eDP1: SUCCESS (2.071s) [326.452382] Subtest basic-flip-vs-dpms: SUCCESS (9.022s) [327.251351] [073/133] (694s left) kms_big_fb (y-tiled-16bpp-rotate-90) [327.393627] Starting subtest: y-tiled-16bpp-rotate-90 [327.398333] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s) [327.498569] [074/133] (694s left) gem_exec_params (invalid-ring2) [327.554068] Starting subtest: invalid-ring2 [327.556368] Subtest invalid-ring2: SUCCESS (0.000s) [327.651639] [075/133] (694s left) kms_pm_backlight (fade-with-suspend) [327.745087] Starting subtest: fade-with-suspend [344.059377] Starting dynamic subtest: eDP-1 [347.086294] Dynamic subtest eDP-1: SUCCESS (3.027s) [347.088765] Subtest fade-with-suspend: SUCCESS (4.275s) [347.883577] [076/133] (674s left) gem_exec_params (rsvd2-dirt) [347.961196] Starting subtest: rsvd2-dirt [347.965574] Subtest rsvd2-dirt: SKIP (0.000s) [348.071447] [077/133] (674s left) kms_cursor_legacy (cursora-vs-flipb-toggle) [348.207467] Starting subtest: cursorA-vs-flipB-toggle [348.211643] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s) [348.352958] [078/133] (674s left) kms_frontbuffer_tracking (psr-suspend) [348.472953] Starting subtest: psr-suspend [386.569847] Subtest psr-suspend: SUCCESS (7.934s) [386.699544] [079/133] (635s left) sw_sync (alloc_fence_invalid_timeline) [386.753863] Starting subtest: alloc_fence_invalid_timeline [386.756533] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s) [386.816047] [080/133] (635s left) syncobj_timeline (multi-wait-for-submit-signaled) [386.875880] Starting subtest: multi-wait-for-submit-signaled [386.878375] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s) [386.983354] [081/133] (635s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping) [387.079511] Starting subtest: pixel-format-x-tiled-modifier-source-clamping [387.105637] Starting dynamic subtest: pipe-A-plane-0 [387.762239] Dynamic subtest pipe-A-plane-0: SUCCESS (0.666s) [387.772719] Starting dynamic subtest: pipe-A-plane-3 [388.190562] Dynamic subtest pipe-A-plane-3: SUCCESS (0.432s) [389.323250] Starting dynamic subtest: pipe-B-plane-0 [389.992186] Dynamic subtest pipe-B-plane-0: SUCCESS (0.678s) [390.004253] Starting dynamic subtest: pipe-B-plane-3 [390.425439] Dynamic subtest pipe-B-plane-3: SUCCESS (0.443s) [390.742674] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.709s) [391.577420] [082/133] (630s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render) [391.682824] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render [391.688792] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [391.781693] [083/133] (630s left) perf (low-oa-exponent-permissions) [391.929377] Starting subtest: low-oa-exponent-permissions [391.966765] Subtest low-oa-exponent-permissions: SUCCESS (0.037s) [392.027466] [084/133] (630s left) kms_properties (connector-properties-legacy) [392.138557] Starting subtest: connector-properties-legacy [392.141244] Starting dynamic subtest: pipe-A-eDP-1 [400.052020] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.953s) [400.063299] Starting dynamic subtest: pipe-None-DP-1 [400.068706] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s) [400.079829] Starting dynamic subtest: pipe-None-HDMI-A-1 [400.085088] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s) [400.095473] Starting dynamic subtest: pipe-None-DP-2 [400.100343] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s) [400.110998] Starting dynamic subtest: pipe-None-HDMI-A-2 [400.115990] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s) [400.126305] Starting dynamic subtest: pipe-None-DP-3 [400.131505] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s) [400.142707] Starting dynamic subtest: pipe-None-DP-4 [400.148285] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s) [400.150699] Subtest connector-properties-legacy: SUCCESS (7.965s) [400.925283] [085/133] (621s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render) [401.041529] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render [401.046152] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [401.146192] [086/133] (621s left) gen9_exec_parse (basic-rejected) [401.202602] Subtest basic-rejected: SKIP (0.000s) [401.270686] [087/133] (621s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc) [401.365931] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc [401.371282] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [401.448967] [088/133] (621s left) kms_rotation_crc (primary-rotation-270) [401.539666] Starting subtest: primary-rotation-270 [401.544723] Subtest primary-rotation-270: SKIP (0.001s) [401.613458] [089/133] (621s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [401.713522] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip [402.357689] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.648s) [402.531596] [090/133] (620s left) kms_atomic_interruptible (atomic-setmode) [402.641492] Starting subtest: atomic-setmode [402.644014] Starting dynamic subtest: pipe-A-eDP-1 [410.278860] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.649s) [410.281679] Subtest atomic-setmode: SUCCESS (7.650s) [411.084364] [091/133] (611s left) kms_psr (fbc-psr-no-drrs) [411.180855] Starting subtest: fbc-psr-no-drrs [411.183906] Starting dynamic subtest: eDP-1 [411.189726] Dynamic subtest eDP-1: SKIP (0.000s) [411.195659] Subtest fbc-psr-no-drrs: SKIP (0.001s) [411.262602] [092/133] (611s left) kms_flip (blocking-absolute-wf_vblank-interruptible) [411.364424] Starting subtest: blocking-absolute-wf_vblank-interruptible [411.367136] Starting dynamic subtest: A-eDP1 [420.091764] Dynamic subtest A-eDP1: SUCCESS (8.694s) [420.103312] Starting dynamic subtest: B-eDP1 [428.823889] Dynamic subtest B-eDP1: SUCCESS (8.727s) [428.837448] Starting dynamic subtest: C-eDP1 [437.528191] Dynamic subtest C-eDP1: SUCCESS (8.738s) [437.539055] Starting dynamic subtest: D-eDP1 [446.292836] Dynamic subtest D-eDP1: SUCCESS (8.716s) [446.295852] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.887s) [447.467019] [093/133] (575s left) gem_mmap_offset (bad-extensions) [447.524245] Starting subtest: bad-extensions [447.526749] Subtest bad-extensions: SUCCESS (0.000s) [447.623708] [094/133] (575s left) kms_psr (psr2-sprite-mmap-cpu) [447.718636] Starting subtest: psr2-sprite-mmap-cpu [447.721222] Starting dynamic subtest: eDP-1 [449.472446] Dynamic subtest eDP-1: SUCCESS (1.755s) [449.475140] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.756s) [450.336243] [095/133] (572s left) api_intel_bb (destroy-bb) [450.400795] Starting subtest: destroy-bb [450.411700] Subtest destroy-bb: SUCCESS (0.010s) [450.521940] [096/133] (572s left) kms_async_flips (async-flip-dpms) [450.615060] Starting subtest: async-flip-dpms [450.988846] Starting dynamic subtest: pipe-A-eDP-1 [454.750979] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.764s) [455.125148] Starting dynamic subtest: pipe-B-eDP-1 [457.917640] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.800s) [458.297446] Starting dynamic subtest: pipe-C-eDP-1 [461.081663] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.792s) [461.461313] Starting dynamic subtest: pipe-D-eDP-1 [464.249823] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.796s) [464.252765] Subtest async-flip-dpms: SUCCESS (13.640s) [465.443935] [097/133] (557s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs) [465.550102] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs [465.552589] Starting dynamic subtest: pipe-A-eDP-1 [465.562677] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [465.573600] Starting dynamic subtest: pipe-B-eDP-1 [465.582894] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [465.593883] Starting dynamic subtest: pipe-C-eDP-1 [465.603617] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [465.614319] Starting dynamic subtest: pipe-D-eDP-1 [465.623777] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [465.628670] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.010s) [467.730718] [098/133] (555s left) kms_lease (multimaster-lease) [467.838307] Starting subtest: multimaster-lease [467.841043] Subtest multimaster-lease: SUCCESS (0.003s) [467.946100] [099/133] (555s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [468.046660] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [475.094975] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.054s) [475.261115] [100/133] (548s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [475.384017] Starting subtest: basic-busy-flip-before-cursor-atomic [475.390466] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [475.530466] [101/133] (547s left) syncobj_wait (wait-all-for-submit-delayed-submit) [475.577846] Starting subtest: wait-all-for-submit-delayed-submit [475.680633] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s) [475.778020] [102/133] (547s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc) [475.879297] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc [475.881699] Starting dynamic subtest: pipe-A-eDP-1 [475.904402] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [475.916016] Starting dynamic subtest: pipe-B-eDP-1 [475.940752] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [475.951317] Starting dynamic subtest: pipe-C-eDP-1 [475.973884] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [475.983901] Starting dynamic subtest: pipe-D-eDP-1 [476.009094] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [476.014312] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s) [478.208115] [103/133] (545s left) gem_ctx_persistence (heartbeat-hang) [478.272677] Starting subtest: heartbeat-hang [478.278447] Subtest heartbeat-hang: SKIP (0.000s) [478.388887] [104/133] (545s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [478.489598] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [479.335676] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.848s) [479.514208] [105/133] (544s left) perf_pmu (busy-accuracy-50) [479.562486] Starting subtest: busy-accuracy-50 [479.564989] Starting dynamic subtest: rcs0 [481.098257] Dynamic subtest rcs0: SUCCESS (1.536s) [481.112208] Starting dynamic subtest: bcs0 [482.641413] Dynamic subtest bcs0: SUCCESS (1.541s) [482.654882] Starting dynamic subtest: vcs0 [484.184853] Dynamic subtest vcs0: SUCCESS (1.539s) [484.198479] Starting dynamic subtest: vcs1 [485.726851] Dynamic subtest vcs1: SUCCESS (1.538s) [485.739899] Starting dynamic subtest: vecs0 [487.264551] Dynamic subtest vecs0: SUCCESS (1.534s) [487.277758] Starting dynamic subtest: ccs0 [488.813770] Dynamic subtest ccs0: SUCCESS (1.545s) [488.816853] Subtest busy-accuracy-50: SUCCESS (9.249s) [488.962151] [106/133] (534s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf) [489.087284] Starting subtest: pr-overlay-plane-move-continuous-sf [489.092537] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s) [489.172485] [107/133] (534s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0) [489.277272] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0 [489.282257] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [489.378629] [108/133] (534s left) gem_exec_fence (syncobj-timeline-signal) [489.950097] Starting subtest: syncobj-timeline-signal [489.958554] Subtest syncobj-timeline-signal: SUCCESS (0.010s) [491.598112] [109/133] (532s left) kms_flip (2x-dpms-vs-vblank-race-interruptible) [491.699019] Starting subtest: 2x-dpms-vs-vblank-race-interruptible [491.710744] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.010s) [491.820401] [110/133] (531s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling) [491.929409] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling [491.934728] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s) [492.017506] [111/133] (531s left) kms_feature_discovery (psr1) [492.114440] Starting subtest: psr1 [492.117027] Subtest psr1: SUCCESS (0.000s) [492.194520] [112/133] (531s left) gem_madvise (dontneed-before-pwrite) [492.237705] Starting subtest: dontneed-before-pwrite [492.267540] Subtest dontneed-before-pwrite: SKIP (0.028s) [492.329184] [113/133] (531s left) gem_exec_create (legacy) [492.391485] Starting subtest: legacy [492.393856] Starting dynamic subtest: smem [494.479124] Dynamic subtest smem: SUCCESS (2.086s) [494.482245] Subtest legacy: SUCCESS (2.087s) [494.668944] [114/133] (529s left) syncobj_timeline (wait-all-for-submit-delayed-submit) [494.724222] Starting subtest: wait-all-for-submit-delayed-submit [494.824768] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s) [494.908208] [115/133] (529s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [495.011653] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt [495.016650] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [495.113027] [116/133] (528s left) syncobj_wait (invalid-signal-one-illegal-handle) [495.167568] Starting subtest: invalid-signal-one-illegal-handle [495.170128] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s) [495.266448] [117/133] (528s left) gem_exec_whisper (basic-queues) [495.338357] Starting subtest: basic-queues [500.614874] Subtest basic-queues: SUCCESS (5.271s) [500.814182] [118/133] (523s left) gem_exec_schedule (implicit-read-write) [500.893697] Starting subtest: implicit-read-write [500.896268] Starting dynamic subtest: rcs0 [501.093544] Dynamic subtest rcs0: SUCCESS (0.210s) [501.107117] Starting dynamic subtest: vcs0 [501.203348] Dynamic subtest vcs0: SUCCESS (0.109s) [501.217165] Starting dynamic subtest: vcs1 [501.321711] Dynamic subtest vcs1: SUCCESS (0.116s) [501.335864] Starting dynamic subtest: vecs0 [501.444524] Dynamic subtest vecs0: SUCCESS (0.122s) [501.458617] Starting dynamic subtest: ccs0 [501.581738] Dynamic subtest ccs0: SUCCESS (0.136s) [501.584745] Subtest implicit-read-write: SUCCESS (0.701s) [502.638297] [119/133] (521s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen) [502.757414] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen [502.762437] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [502.864501] [120/133] (521s left) kms_big_fb (x-tiled-64bpp-rotate-180) [502.972661] Starting subtest: x-tiled-64bpp-rotate-180 [504.474467] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.502s) [504.616268] [121/133] (519s left) gem_mmap_gtt (medium-copy-odd) [504.680237] Subtest medium-copy-odd: SKIP (0.000s) [504.740894] [122/133] (519s left) gem_exec_reloc (basic-write-read-active) [504.811697] Subtest basic-write-read-active: SKIP (0.000s) [504.882058] [123/133] (519s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling) [504.980673] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling [504.982913] Starting dynamic subtest: pipe-A-default-mode [506.171650] Dynamic subtest pipe-A-default-mode: SKIP (1.185s) [506.176842] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.187s) [506.342262] [124/133] (518s left) gem_exec_reloc (basic-write-gtt-active) [506.411058] Subtest basic-write-gtt-active: SKIP (0.000s) [506.473280] [125/133] (518s left) syncobj_timeline (invalid-query-one-illegal-handle) [506.523495] Starting subtest: invalid-query-one-illegal-handle [506.525677] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s) [506.616835] [126/133] (517s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc) [506.727292] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc [506.731939] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [506.839426] [127/133] (517s left) kms_pipe_crc_basic (suspend-read-crc) [506.929900] Starting subtest: suspend-read-crc [506.932337] Starting dynamic subtest: pipe-A-eDP-1 [524.960899] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.540s) [524.972173] Starting dynamic subtest: pipe-B-eDP-1 [542.952144] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.130s) [542.963847] Starting dynamic subtest: pipe-C-eDP-1 [560.922592] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.052s) [560.934100] Starting dynamic subtest: pipe-D-eDP-1 [578.924030] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.084s) [578.926482] Subtest suspend-read-crc: SUCCESS (11.813s) [579.744031] [128/133] (444s left) gem_ccs (block-multicopy-compressed) [579.814975] Starting subtest: block-multicopy-compressed [579.819477] Subtest block-multicopy-compressed: SKIP (0.000s) [579.908694] [129/133] (444s left) kms_sequence (get-forked) [579.998447] Starting subtest: get-forked [580.000716] Starting dynamic subtest: pipe-A-eDP-1 [581.876342] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.901s) [581.890714] Starting dynamic subtest: pipe-B-eDP-1 [584.437731] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.579s) [584.449993] Starting dynamic subtest: pipe-C-eDP-1 [586.956745] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.536s) [586.968635] Starting dynamic subtest: pipe-D-eDP-1 [589.450454] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.504s) [589.452789] Subtest get-forked: SUCCESS (9.525s) [590.296651] [130/133] (434s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf) [590.395025] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf [590.397277] Starting dynamic subtest: pipe-A-eDP-1 [601.677889] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.311s) [601.689076] Starting dynamic subtest: pipe-B-eDP-1 [613.684029] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.011s) [613.686204] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.326s) [614.534219] [131/133] (410s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted) [614.602745] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted [614.707203] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.102s) [614.796648] [132/133] (410s left) gem_close_race (basic-threads) [614.860578] Starting subtest: basic-threads [616.217486] Subtest basic-threads: SUCCESS (1.356s) [616.420600] [133/133] (408s left) kms_vrr (flip-basic-fastset) [616.513113] Starting subtest: flip-basic-fastset [616.519334] Subtest flip-basic-fastset: SKIP (0.000s) [616.584260] Closing watchdogs results: parsing output: 0/ for test: gem_exec_reloc results: parsing output: 1/ for test: kms_force_connector_basic results: parsing output: 2/ for test: gem_pread results: parsing output: 3/ for test: gem_exec_schedule results: parsing output: 4/ for test: kms_ccs results: parsing output: 5/ for test: kms_atomic_transition results: parsing output: 6/ for test: gem_ctx_param results: parsing output: 7/ for test: gem_vm_create results: parsing output: 8/ for test: kms_scaling_modes results: parsing output: 9/ for test: kms_cursor_crc results: parsing output: 10/ for test: gem_mmap_gtt results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: kms_cursor_crc results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: kms_ccs results: parsing output: 15/ for test: gem_mmap results: parsing output: 16/ for test: syncobj_wait results: parsing output: 17/ for test: kms_psr results: parsing output: 18/ for test: gem_exec_params results: parsing output: 19/ for test: kms_atomic_transition results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: gem_eio results: parsing output: 22/ for test: gem_render_copy results: parsing output: 23/ for test: kms_cursor_crc results: parsing output: 24/ for test: kms_prop_blob results: parsing output: 25/ for test: kms_cursor_legacy results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: gem_exec_async results: parsing output: 28/ for test: perf results: parsing output: 29/ for test: gem_exec_fence results: parsing output: 30/ for test: kms_flip results: parsing output: 31/ for test: kms_invalid_mode results: parsing output: 32/ for test: kms_plane results: parsing output: 33/ for test: kms_color results: parsing output: 34/ for test: gem_softpin results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: gem_ctx_isolation results: parsing output: 37/ for test: kms_cursor_legacy results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: kms_psr2_sf results: parsing output: 40/ for test: syncobj_timeline results: parsing output: 41/ for test: kms_plane_multiple results: parsing output: 42/ for test: kms_plane_scaling results: parsing output: 43/ for test: kms_big_fb results: parsing output: 44/ for test: kms_getfb results: parsing output: 45/ for test: gem_flink_basic results: parsing output: 46/ for test: i915_suspend results: parsing output: 47/ for test: gem_pxp results: parsing output: 48/ for test: prime_vgem results: parsing output: 49/ for test: gem_exec_balancer results: parsing output: 50/ for test: kms_flip_scaled_crc results: parsing output: 51/ for test: kms_big_fb results: parsing output: 52/ for test: perf_pmu results: parsing output: 53/ for test: syncobj_timeline results: parsing output: 54/ for test: kms_content_protection results: parsing output: 55/ for test: i915_drm_fdinfo results: parsing output: 56/ for test: kms_psr results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: kms_chamelium_frames results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: gem_lmem_swapping results: parsing output: 61/ for test: dumb_buffer results: parsing output: 62/ for test: i915_drm_fdinfo results: parsing output: 63/ for test: api_intel_allocator results: parsing output: 64/ for test: kms_chamelium_hpd results: parsing output: 65/ for test: kms_ccs results: parsing output: 66/ for test: syncobj_wait results: parsing output: 67/ for test: i915_pm_rpm results: parsing output: 68/ for test: gem_create results: parsing output: 69/ for test: gem_exec_await results: parsing output: 70/ for test: gem_exec_whisper results: parsing output: 71/ for test: kms_flip results: parsing output: 72/ for test: kms_big_fb results: parsing output: 73/ for test: gem_exec_params results: parsing output: 74/ for test: kms_pm_backlight results: parsing output: 75/ for test: gem_exec_params results: parsing output: 76/ for test: kms_cursor_legacy results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: sw_sync results: parsing output: 79/ for test: syncobj_timeline results: parsing output: 80/ for test: kms_plane results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: perf results: parsing output: 83/ for test: kms_properties results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: gen9_exec_parse results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: kms_rotation_crc results: parsing output: 88/ for test: kms_big_fb results: parsing output: 89/ for test: kms_atomic_interruptible results: parsing output: 90/ for test: kms_psr results: parsing output: 91/ for test: kms_flip results: parsing output: 92/ for test: gem_mmap_offset results: parsing output: 93/ for test: kms_psr results: parsing output: 94/ for test: api_intel_bb results: parsing output: 95/ for test: kms_async_flips results: parsing output: 96/ for test: kms_ccs results: parsing output: 97/ for test: kms_lease results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: kms_cursor_legacy results: parsing output: 100/ for test: syncobj_wait results: parsing output: 101/ for test: kms_ccs results: parsing output: 102/ for test: gem_ctx_persistence results: parsing output: 103/ for test: kms_big_fb results: parsing output: 104/ for test: perf_pmu results: parsing output: 105/ for test: kms_psr2_sf results: parsing output: 106/ for test: kms_big_fb results: parsing output: 107/ for test: gem_exec_fence results: parsing output: 108/ for test: kms_flip results: parsing output: 109/ for test: kms_flip_scaled_crc results: parsing output: 110/ for test: kms_feature_discovery results: parsing output: 111/ for test: gem_madvise results: parsing output: 112/ for test: gem_exec_create results: parsing output: 113/ for test: syncobj_timeline results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: syncobj_wait results: parsing output: 116/ for test: gem_exec_whisper results: parsing output: 117/ for test: gem_exec_schedule results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: kms_big_fb results: parsing output: 120/ for test: gem_mmap_gtt results: parsing output: 121/ for test: gem_exec_reloc results: parsing output: 122/ for test: kms_flip_scaled_crc results: parsing output: 123/ for test: gem_exec_reloc results: parsing output: 124/ for test: syncobj_timeline results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: kms_pipe_crc_basic results: parsing output: 127/ for test: gem_ccs results: parsing output: 128/ for test: kms_sequence results: parsing output: 129/ for test: kms_psr2_sf results: parsing output: 130/ for test: syncobj_timeline results: parsing output: 131/ for test: gem_close_race results: parsing output: 132/ for test: kms_vrr Done.