[56.284216] Initializing watchdogs
[56.284264]   /dev/watchdog0
[56.298546] [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.303433] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.305764] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.309488] [001/133] (960s left) gem_mmap_gtt (cpuset-big-copy-xy)
[56.391044] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[56.451704] [002/133] (960s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[56.562287] Starting subtest: fbcpsr-slowdraw
[81.707919] Subtest fbcpsr-slowdraw: SUCCESS (25.288s)
[81.843136] [003/133] (935s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[81.956811] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[81.961226] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[82.056131] [004/133] (934s left) gem_userptr_blits (stress-purge)
[82.126051] Starting subtest: stress-purge
[87.522538] Subtest stress-purge: SUCCESS (5.398s)
[87.636996] [005/133] (929s left) gem_exec_balancer (waits)
[87.735757] Starting subtest: waits
[94.293717] Subtest waits: SUCCESS (6.557s)
[94.590795] [006/133] (922s left) kms_chamelium_frames (hdmi-crc-fast)
[94.993352] Subtest hdmi-crc-fast: SKIP (0.000s)
[95.766961] [007/133] (921s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[95.826770] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[95.829352] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.001s)
[95.912064] [008/133] (921s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[96.008430] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[102.665901] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.661s)
[102.811135] [009/133] (914s left) kms_cdclk (mode-transition-all-outputs)
[102.905379] Starting subtest: mode-transition-all-outputs
[103.197184] Subtest mode-transition-all-outputs: SKIP (0.288s)
[104.059208] [010/133] (913s left) sw_sync (sync_multi_consumer_producer)
[104.098071] Starting subtest: sync_multi_consumer_producer
[104.385769] Subtest sync_multi_consumer_producer: SUCCESS (0.288s)
[104.445609] [011/133] (912s left) kms_psr (psr2-primary-mmap-cpu)
[104.535403] Starting subtest: psr2-primary-mmap-cpu
[104.537817] Starting dynamic subtest: eDP-1
[106.239654] Dynamic subtest eDP-1: SUCCESS (1.706s)
[106.242075] Subtest psr2-primary-mmap-cpu: SUCCESS (1.707s)
[107.119664] [012/133] (910s left) gem_eio (in-flight-internal-1us)
[107.329865] Starting subtest: in-flight-internal-1us
[108.375933] Subtest in-flight-internal-1us: SUCCESS (1.046s)
[108.525788] [013/133] (908s left) kms_pm_rpm (system-suspend-modeset)
[110.387977] Starting subtest: system-suspend-modeset
[130.558930] Subtest system-suspend-modeset: SUCCESS (4.796s)
[130.938804] [014/133] (886s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[131.044508] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[131.048783] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[131.140840] [015/133] (886s left) kms_cursor_crc (cursor-random-512x170)
[131.416871] Starting subtest: cursor-random-512x170
[131.421708] Subtest cursor-random-512x170: SKIP (0.001s)
[131.560079] [016/133] (885s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[131.663837] Starting subtest: x-tiled-16bpp-rotate-270
[131.682622] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[131.806278] [017/133] (885s left) i915_selftest (live)
[135.114409] Starting subtest: live
[135.116818] Starting dynamic subtest: sanitycheck
[139.444175] Dynamic subtest sanitycheck: SUCCESS (4.376s)
[139.453772] Starting dynamic subtest: uncore
[143.761593] Dynamic subtest uncore: SUCCESS (4.317s)
[143.772803] Starting dynamic subtest: workarounds
[146.864962] Dynamic subtest workarounds: SUCCESS (3.142s)
[146.875251] Starting dynamic subtest: gt_engines
[151.370226] Dynamic subtest gt_engines: SUCCESS (4.516s)
[151.379123] Starting dynamic subtest: gt_timelines
[167.107621] Dynamic subtest gt_timelines: SUCCESS (15.744s)
[167.117631] Starting dynamic subtest: gt_contexts
[171.479993] Dynamic subtest gt_contexts: SUCCESS (4.372s)
[171.490482] Starting dynamic subtest: gt_lrc
[175.841996] Dynamic subtest gt_lrc: SUCCESS (4.362s)
[175.852050] Starting dynamic subtest: gt_mocs
[178.851260] Dynamic subtest gt_mocs: SUCCESS (3.009s)
[178.865960] Starting dynamic subtest: gt_pm
[185.549894] Dynamic subtest gt_pm: SUCCESS (6.699s)
[185.560035] Starting dynamic subtest: gt_heartbeat
[188.254170] Dynamic subtest gt_heartbeat: SUCCESS (2.704s)
[188.264651] Starting dynamic subtest: gt_tlb
[197.605189] Dynamic subtest gt_tlb: SUCCESS (9.353s)
[197.615221] Starting dynamic subtest: requests
[211.090040] Dynamic subtest requests: SUCCESS (13.488s)
[211.100563] Starting dynamic subtest: migrate
[218.870205] Dynamic subtest migrate: SUCCESS (7.782s)
[218.879039] Starting dynamic subtest: active
[223.241193] Dynamic subtest active: SUCCESS (4.371s)
[223.251462] Starting dynamic subtest: objects
[227.998505] Dynamic subtest objects: SUCCESS (4.754s)
[228.008934] Starting dynamic subtest: mman
[232.837213] Dynamic subtest mman: SUCCESS (4.834s)
[232.846948] Starting dynamic subtest: dmabuf
[237.206781] Dynamic subtest dmabuf: SUCCESS (4.368s)
[237.218920] Starting dynamic subtest: vma
[241.529824] Dynamic subtest vma: SUCCESS (4.321s)
[241.545116] Starting dynamic subtest: coherency
[246.524216] Dynamic subtest coherency: SUCCESS (4.992s)
[246.534642] Starting dynamic subtest: gtt
[258.432621] Dynamic subtest gtt: SUCCESS (11.906s)
[258.442206] Starting dynamic subtest: gem
[266.486068] Dynamic subtest gem: SUCCESS (8.053s)
[266.496552] Starting dynamic subtest: evict
[272.067461] Dynamic subtest evict: SUCCESS (5.580s)
[272.077817] Starting dynamic subtest: hugepages
[282.855098] Dynamic subtest hugepages: SUCCESS (10.788s)
[282.865496] Starting dynamic subtest: gem_contexts
[311.790830] Dynamic subtest gem_contexts: SUCCESS (28.940s)
[311.801210] Starting dynamic subtest: client
[316.123229] Dynamic subtest client: SUCCESS (4.333s)
[316.133767] Starting dynamic subtest: gem_migrate
[318.825424] Dynamic subtest gem_migrate: SUCCESS (2.701s)
[318.833910] Starting dynamic subtest: reset
[323.241157] Dynamic subtest reset: SUCCESS (4.413s)
[323.251886] Starting dynamic subtest: memory_region
[327.518593] Dynamic subtest memory_region: SUCCESS (4.278s)
[327.528194] Starting dynamic subtest: hangcheck
[342.427153] Dynamic subtest hangcheck: SUCCESS (14.912s)
[342.438915] Starting dynamic subtest: execlists
[345.145186] Dynamic subtest execlists: SUCCESS (2.716s)
[345.154202] Starting dynamic subtest: ring_submission
[349.538497] Dynamic subtest ring_submission: SUCCESS (4.392s)
[349.548808] Starting dynamic subtest: perf
[353.906576] Dynamic subtest perf: SUCCESS (4.366s)
[353.917097] Starting dynamic subtest: slpc
[368.022654] Dynamic subtest slpc: SUCCESS (14.108s)
[368.032516] Starting dynamic subtest: guc
[371.935172] Dynamic subtest guc: SUCCESS (3.910s)
[371.946418] Starting dynamic subtest: guc_multi_lrc
[376.289237] Dynamic subtest guc_multi_lrc: SUCCESS (4.352s)
[376.299731] Starting dynamic subtest: guc_hang
[381.233585] Dynamic subtest guc_hang: SUCCESS (4.941s)
[381.243773] Starting dynamic subtest: late_gt_pm
[383.994362] Dynamic subtest late_gt_pm: SUCCESS (2.758s)
[383.997180] Subtest live: SUCCESS (249.004s)
[384.025922] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[384.029144] [018/133] (633s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[385.547710] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[385.606036] [FACT kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)] new: kernel.kmod_is_loaded.i915: true
[385.610335] [019/133] (631s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[385.720375] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[385.722518] Starting dynamic subtest: pipe-A-eDP-1
[385.744801] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[385.756646] Starting dynamic subtest: pipe-B-eDP-1
[385.777821] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[385.786188] Starting dynamic subtest: pipe-C-eDP-1
[385.807455] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[385.815600] Starting dynamic subtest: pipe-D-eDP-1
[385.838645] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[385.843112] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[387.900501] [020/133] (629s left) gem_eio (hibernate)
[388.047887] Starting subtest: hibernate
[403.257719] Subtest hibernate: SUCCESS (15.210s)
[411.400115] [021/133] (614s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[411.535575] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[411.539951] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[411.644056] [022/133] (613s left) gem_close_race (multigpu-basic-threads)
[411.707211] Starting subtest: multigpu-basic-threads
[411.711755] Subtest multigpu-basic-threads: SKIP (0.000s)
[411.934022] [023/133] (613s left) gem_tiled_partial_pwrite_pread (writes)
[411.988476] Subtest writes: SKIP (0.000s)
[412.061344] [024/133] (613s left) gem_ctx_param (invalid-param-set)
[412.106868] Starting subtest: invalid-param-set
[412.109177] Subtest invalid-param-set: SUCCESS (0.000s)
[412.166587] [025/133] (613s left) kms_psr (fbc-psr-sprite-render)
[412.257165] Starting subtest: fbc-psr-sprite-render
[412.259482] Starting dynamic subtest: eDP-1
[412.263496] Dynamic subtest eDP-1: SKIP (0.000s)
[412.267497] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[412.329816] [026/133] (613s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[412.427266] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[412.429598] Starting dynamic subtest: pipe-A-default-mode
[415.110343] Dynamic subtest pipe-A-default-mode: SUCCESS (2.682s)
[415.112538] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.683s)
[415.975703] [027/133] (609s left) kms_flip (flip-vs-modeset-vs-hang)
[416.086771] Starting subtest: flip-vs-modeset-vs-hang
[416.089156] Starting dynamic subtest: A-eDP1
[468.209105] Dynamic subtest A-eDP1: SUCCESS (52.127s)
[468.220993] Starting dynamic subtest: D-eDP1
[518.192504] Dynamic subtest D-eDP1: SUCCESS (49.985s)
[518.194867] Subtest flip-vs-modeset-vs-hang: SUCCESS (102.118s)
[518.565210] [028/133] (507s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[518.664467] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[525.685828] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (7.025s)
[525.825696] [029/133] (500s left) gem_ppgtt (flink-and-close-vma-leak)
[525.901170] Starting subtest: flink-and-close-vma-leak
[525.944506] Subtest flink-and-close-vma-leak: SUCCESS (0.043s)
[526.068749] [030/133] (499s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[526.174232] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[526.178416] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[526.255352] [031/133] (499s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[526.360192] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[526.362456] Starting dynamic subtest: pipe-A-eDP-1
[526.456284] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[526.468786] Starting dynamic subtest: pipe-B-eDP-1
[527.609883] Dynamic subtest pipe-B-eDP-1: SKIP (1.152s)
[527.614239] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.255s)
[528.802774] [032/133] (497s left) kms_psr (psr-sprite-plane-move)
[528.903506] Starting subtest: psr-sprite-plane-move
[528.905771] Starting dynamic subtest: eDP-1
[530.650654] Dynamic subtest eDP-1: SUCCESS (1.748s)
[530.652923] Subtest psr-sprite-plane-move: SUCCESS (1.749s)
[531.471816] [033/133] (494s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[531.843803] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[532.676313] [034/133] (493s left) perf_pmu (semaphore-busy)
[532.724447] Starting subtest: semaphore-busy
[532.726633] Starting dynamic subtest: rcs0
[534.367425] Dynamic subtest rcs0: SUCCESS (1.643s)
[534.381851] Starting dynamic subtest: bcs0
[536.001572] Dynamic subtest bcs0: SUCCESS (1.630s)
[536.014772] Starting dynamic subtest: vcs0
[540.242177] Dynamic subtest vcs0: SUCCESS (4.238s)
[540.255533] Starting dynamic subtest: vcs1
[546.258881] Dynamic subtest vcs1: SUCCESS (6.014s)
[546.272624] Starting dynamic subtest: vecs0
[552.274730] Dynamic subtest vecs0: SUCCESS (6.014s)
[552.288118] Starting dynamic subtest: ccs0
[555.347730] Dynamic subtest ccs0: SUCCESS (3.071s)
[555.350244] Subtest semaphore-busy: SUCCESS (22.627s)
[555.475913] [035/133] (470s left) gem_tiled_fence_blits (basic)
[555.534431] Subtest basic: SKIP (0.000s)
[555.607160] [036/133] (470s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[555.710677] Starting subtest: async-flip-with-page-flip-events-tiled
[556.085443] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[558.872067] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.786s)
[558.884034] Starting dynamic subtest: pipe-A-eDP-1-4
[561.047501] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[561.058873] Starting dynamic subtest: pipe-A-eDP-1-4
[563.056300] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[563.067203] Starting dynamic subtest: pipe-A-eDP-1-x
[565.257210] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.200s)
[565.650232] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[568.408926] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.767s)
[568.419823] Starting dynamic subtest: pipe-B-eDP-1-4
[570.594343] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[570.604958] Starting dynamic subtest: pipe-B-eDP-1-4
[572.603834] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.008s)
[572.614551] Starting dynamic subtest: pipe-B-eDP-1-x
[574.804999] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.200s)
[575.170075] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[577.933638] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.770s)
[577.945777] Starting dynamic subtest: pipe-C-eDP-1-4
[580.106409] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[580.119949] Starting dynamic subtest: pipe-C-eDP-1-4
[582.117826] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[582.129162] Starting dynamic subtest: pipe-C-eDP-1-x
[584.295801] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[584.662419] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[587.456990] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.802s)
[587.470916] Starting dynamic subtest: pipe-D-eDP-1-4
[589.630202] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s)
[589.641253] Starting dynamic subtest: pipe-D-eDP-1-4
[591.640566] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[591.651846] Starting dynamic subtest: pipe-D-eDP-1-x
[593.818920] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s)
[593.821631] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.115s)
[595.039630] [037/133] (431s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[595.140613] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[595.820375] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.681s)
[596.006894] [038/133] (430s left) gem_mmap_offset (open-flood)
[596.059401] Starting subtest: open-flood
[617.542459] Subtest open-flood: SUCCESS (21.489s)
[617.654191] [039/133] (408s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[617.744252] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[617.746074] Starting dynamic subtest: pipe-A-eDP-1
[617.765193] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[617.777531] Starting dynamic subtest: pipe-B-eDP-1
[617.795568] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[617.806040] Starting dynamic subtest: pipe-C-eDP-1
[617.824959] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[617.836418] Starting dynamic subtest: pipe-D-eDP-1
[617.854722] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[617.858049] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[620.003923] [040/133] (406s left) prime_self_import (basic-with_one_bo)
[620.039199] Starting subtest: basic-with_one_bo
[620.057207] Subtest basic-with_one_bo: SUCCESS (0.017s)
[620.186170] [041/133] (406s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[620.285757] Starting subtest: fbc-rgb565-draw-blt
[624.476915] Subtest fbc-rgb565-draw-blt: SUCCESS (4.196s)
[625.612160] [042/133] (400s left) gem_render_copy (linear-to-vebox-y-tiled)
[625.676378] Starting subtest: linear-to-vebox-y-tiled
[625.680548] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[625.862430] [043/133] (400s left) syncobj_wait (reset-during-wait-for-submit)
[625.930268] Starting subtest: reset-during-wait-for-submit
[626.035189] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[626.116609] [044/133] (400s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[626.224961] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[626.229081] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[626.340973] [045/133] (400s left) kms_vblank (query-busy)
[626.434181] Starting subtest: query-busy
[626.436038] Starting dynamic subtest: pipe-A-eDP-1
[628.314404] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.879s)
[628.330244] Starting dynamic subtest: pipe-D-eDP-1
[630.856664] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.540s)
[630.858831] Subtest query-busy: SUCCESS (4.423s)
[631.665205] [046/133] (394s left) drm_mm (drm_mm)
[631.706592] Starting subtest: drm_mm
[631.750001] Starting dynamic subtest: drm_test_mm_init
[631.852097] Dynamic subtest drm_test_mm_init: SUCCESS (0.101s)
[631.864299] Starting dynamic subtest: drm_test_mm_debug
[631.951021] Dynamic subtest drm_test_mm_debug: SUCCESS (0.098s)
[631.963017] Starting dynamic subtest: drm_test_mm_align32
[632.048112] Dynamic subtest drm_test_mm_align32: SUCCESS (0.097s)
[632.060363] Starting dynamic subtest: drm_test_mm_align64
[632.164198] Dynamic subtest drm_test_mm_align64: SUCCESS (0.115s)
[632.176511] Starting dynamic subtest: drm_test_mm_lowest
[632.259187] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.093s)
[632.271070] Starting dynamic subtest: drm_test_mm_highest
[632.371926] Dynamic subtest drm_test_mm_highest: SUCCESS (0.113s)
[632.374069] Subtest drm_mm: SUCCESS (0.664s)
[632.534491] [047/133] (394s left) core_auth (getclient-simple)
[632.573597] Starting subtest: getclient-simple
[632.594217] Subtest getclient-simple: SUCCESS (0.021s)
[632.699953] [048/133] (394s left) gem_exec_schedule (semaphore-resolve)
[632.774006] Starting subtest: semaphore-resolve
[632.805873] Subtest semaphore-resolve: SUCCESS (0.041s)
[633.157292] [049/133] (393s left) i915_pm_rpm (system-suspend-devices)
[634.882395] Starting subtest: system-suspend-devices
[642.560211] Subtest system-suspend-devices: SUCCESS (7.680s)
[642.951690] [050/133] (383s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[643.052800] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[643.057332] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[643.162855] [051/133] (383s left) syncobj_timeline (single-wait-all-available-signaled)
[643.217213] Starting subtest: single-wait-all-available-signaled
[643.219520] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[643.304552] [052/133] (383s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[643.396589] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[643.398888] Starting dynamic subtest: pipe-A-eDP-1
[644.690383] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.294s)
[644.968446] Starting dynamic subtest: pipe-B-eDP-1
[646.009116] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.052s)
[646.280770] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.887s)
[647.105724] [053/133] (379s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[647.203800] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[647.208290] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[647.317131] [054/133] (379s left) gem_ctx_persistence (legacy-engines-queued)
[647.381841] Starting subtest: legacy-engines-queued
[647.384091] Starting dynamic subtest: render
[647.474700] Dynamic subtest render: SUCCESS (0.092s)
[647.490650] Starting dynamic subtest: bsd1
[648.695691] Dynamic subtest bsd1: SUCCESS (1.216s)
[648.709711] Starting dynamic subtest: bsd2
[650.677484] Dynamic subtest bsd2: SUCCESS (1.978s)
[650.691887] Starting dynamic subtest: blt
[650.752988] Dynamic subtest blt: SUCCESS (0.074s)
[650.765535] Starting dynamic subtest: vebox
[652.724809] Dynamic subtest vebox: SUCCESS (1.968s)
[652.728037] Subtest legacy-engines-queued: SUCCESS (5.343s)
[652.806175] [055/133] (374s left) kms_cursor_crc (cursor-onscreen-64x21)
[653.014201] Starting subtest: cursor-onscreen-64x21
[653.062705] Subtest cursor-onscreen-64x21: SKIP (0.042s)
[653.296774] [056/133] (373s left) gem_ctx_shared (q-smoketest-all)
[653.357125] Starting subtest: Q-smoketest-all
[685.732936] Subtest Q-smoketest-all: SUCCESS (32.329s)
[686.790010] [057/133] (340s left) kms_dp_link_training (uhbr-mst)
[686.889639] Starting subtest: uhbr-mst
[686.898344] Subtest uhbr-mst: SKIP (0.000s)
[686.959915] [058/133] (340s left) kms_lease (lessee-list)
[687.043208] Starting subtest: lessee-list
[687.045665] Starting dynamic subtest: pipe-A-eDP-1
[687.047870] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[687.059637] Starting dynamic subtest: pipe-B-eDP-1
[687.061760] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[687.072714] Starting dynamic subtest: pipe-C-eDP-1
[687.074815] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[687.086195] Starting dynamic subtest: pipe-D-eDP-1
[687.088063] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[687.089887] Subtest lessee-list: SUCCESS (0.009s)
[687.168009] [059/133] (340s left) kms_force_connector_basic (force-edid)
[687.244078] Starting subtest: force-edid
[687.609315] Subtest force-edid: SUCCESS (0.368s)
[687.747377] [060/133] (339s left) kms_flip (2x-flip-vs-fences-interruptible)
[687.837458] Starting subtest: 2x-flip-vs-fences-interruptible
[687.841158] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[687.943616] [061/133] (339s left) gem_exec_reloc (basic-concurrent0)
[687.994126] Subtest basic-concurrent0: SKIP (0.000s)
[688.057942] [062/133] (339s left) kms_dsc (dsc-basic)
[688.150110] Starting subtest: dsc-basic
[688.161374] Subtest dsc-basic: SKIP (0.000s)
[688.256822] [063/133] (339s left) kms_psr (fbc-pr-suspend)
[688.360797] Starting subtest: fbc-pr-suspend
[688.364525] Subtest fbc-pr-suspend: SKIP (0.000s)
[688.430832] [064/133] (338s left) gem_ctx_param (set-priority-not-supported)
[688.480104] Starting subtest: set-priority-not-supported
[688.484079] Subtest set-priority-not-supported: SKIP (0.000s)
[688.542287] [065/133] (338s left) gem_exec_suspend (basic-s3-devices)
[688.599144] Starting subtest: basic-S3-devices
[688.601181] Starting dynamic subtest: smem
[699.670653] Dynamic subtest smem: SUCCESS (11.070s)
[699.673223] Subtest basic-S3-devices: SUCCESS (11.071s)
[699.870222] [066/133] (327s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[699.993621] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[699.997888] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[700.098792] [067/133] (327s left) kms_properties (invalid-properties-atomic)
[700.190512] Starting subtest: invalid-properties-atomic
[700.502790] Subtest invalid-properties-atomic: SUCCESS (0.313s)
[700.573288] [068/133] (326s left) kms_atomic_interruptible (legacy-dpms)
[700.659486] Starting subtest: legacy-dpms
[700.661875] Starting dynamic subtest: pipe-A-eDP-1
[708.123359] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.464s)
[708.125764] Subtest legacy-dpms: SUCCESS (7.465s)
[708.925214] [069/133] (318s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[709.028812] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[713.380362] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.355s)
[714.528221] [070/133] (313s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[714.623638] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[714.649417] Starting dynamic subtest: pipe-A-plane-0
[714.937520] Dynamic subtest pipe-A-plane-0: SUCCESS (0.288s)
[714.948652] Starting dynamic subtest: pipe-A-plane-3
[715.193185] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[716.278396] Starting dynamic subtest: pipe-B-plane-0
[716.580005] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[716.601560] Starting dynamic subtest: pipe-B-plane-3
[716.824194] Dynamic subtest pipe-B-plane-3: SUCCESS (0.242s)
[717.145855] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.525s)
[718.020418] [071/133] (309s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[718.114281] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[718.116611] Starting dynamic subtest: pipe-A-default-mode
[719.252790] Dynamic subtest pipe-A-default-mode: SKIP (1.136s)
[719.257148] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.138s)
[719.398787] [072/133] (308s left) kms_atomic (crtc-invalid-params)
[719.494434] Starting subtest: crtc-invalid-params
[719.496595] Starting dynamic subtest: pipe-A-eDP-1
[719.854980] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.359s)
[719.856802] Subtest crtc-invalid-params: SUCCESS (0.361s)
[720.720749] [073/133] (307s left) gem_ctx_exec (basic-nohangcheck)
[720.787393] Starting subtest: basic-nohangcheck
[721.032427] Subtest basic-nohangcheck: SUCCESS (0.245s)
[721.152657] [074/133] (306s left) gem_exec_whisper (basic-fds-all)
[721.206372] Starting subtest: basic-fds-all
[732.518306] Subtest basic-fds-all: SUCCESS (11.310s)
[732.703979] [075/133] (295s left) perf_pmu (busy-no-semaphores)
[732.761659] Starting subtest: busy-no-semaphores
[732.763915] Starting dynamic subtest: rcs0
[733.314419] Dynamic subtest rcs0: SUCCESS (0.552s)
[733.328330] Starting dynamic subtest: bcs0
[733.867986] Dynamic subtest bcs0: SUCCESS (0.550s)
[733.882844] Starting dynamic subtest: vcs0
[734.419458] Dynamic subtest vcs0: SUCCESS (0.548s)
[734.433737] Starting dynamic subtest: vcs1
[736.282436] Dynamic subtest vcs1: SUCCESS (1.860s)
[736.296794] Starting dynamic subtest: vecs0
[738.268750] Dynamic subtest vecs0: SUCCESS (1.982s)
[738.283341] Starting dynamic subtest: ccs0
[740.250915] Dynamic subtest ccs0: SUCCESS (1.978s)
[740.253647] Subtest busy-no-semaphores: SUCCESS (7.491s)
[740.369295] [076/133] (287s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[740.490340] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[741.325810] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.837s)
[741.498703] [077/133] (286s left) kms_cursor_edge_walk (128x128-right-edge)
[741.592334] Starting subtest: 128x128-right-edge
[741.594690] Starting dynamic subtest: pipe-A-eDP-1
[745.046290] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.455s)
[745.058454] Starting dynamic subtest: pipe-D-eDP-1
[748.251672] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.204s)
[748.253861] Subtest 128x128-right-edge: SUCCESS (6.661s)
[749.102528] [078/133] (278s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[749.224398] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[758.698009] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.470s)
[759.506272] [079/133] (268s left) gem_exec_balancer (parallel-bb-first)
[759.762207] Starting subtest: parallel-bb-first
[760.714620] Subtest parallel-bb-first: SUCCESS (0.952s)
[761.793159] [080/133] (266s left) kms_rotation_crc (primary-rotation-270)
[761.888814] Starting subtest: primary-rotation-270
[761.893385] Subtest primary-rotation-270: SKIP (0.001s)
[761.966205] [081/133] (266s left) kms_psr (fbc-pr-no-drrs)
[762.049502] Starting subtest: fbc-pr-no-drrs
[762.053862] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[762.122546] [082/133] (266s left) kms_vblank (ts-continuation-idle)
[762.209632] Starting subtest: ts-continuation-idle
[762.211461] Starting dynamic subtest: pipe-A-eDP-1
[762.657774] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.447s)
[762.674297] Starting dynamic subtest: pipe-D-eDP-1
[763.770909] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.110s)
[763.772906] Subtest ts-continuation-idle: SUCCESS (1.561s)
[764.618532] [083/133] (263s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[764.708430] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[764.710756] Starting dynamic subtest: pipe-A-eDP-1
[765.572589] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.858s)
[765.584761] Starting dynamic subtest: pipe-B-eDP-1
[767.250210] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.674s)
[767.263160] Starting dynamic subtest: pipe-C-eDP-1
[768.843496] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.593s)
[768.858244] Starting dynamic subtest: pipe-D-eDP-1
[770.406086] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.563s)
[770.408235] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.692s)
[771.605031] [084/133] (256s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[771.709665] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[781.178515] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.471s)
[781.305239] [085/133] (246s left) gem_spin_batch (resubmit-new-all)
[781.371916] Starting subtest: resubmit-new-all
[781.374325] Starting dynamic subtest: rcs0
[781.389871] Dynamic subtest rcs0: SUCCESS (0.018s)
[781.401570] Starting dynamic subtest: bcs0
[781.403931] Dynamic subtest bcs0: SUCCESS (0.010s)
[781.415643] Starting dynamic subtest: vcs0
[781.417811] Dynamic subtest vcs0: SUCCESS (0.009s)
[781.431948] Starting dynamic subtest: vcs1
[781.434298] Dynamic subtest vcs1: SUCCESS (0.009s)
[781.449384] Starting dynamic subtest: vecs0
[781.451453] Dynamic subtest vecs0: SUCCESS (0.010s)
[781.461967] Starting dynamic subtest: ccs0
[781.463928] Dynamic subtest ccs0: SUCCESS (0.014s)
[781.465823] Subtest resubmit-new-all: SUCCESS (0.076s)
[782.719865] [086/133] (245s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[782.781186] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[782.785864] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[782.968693] [087/133] (245s left) syncobj_wait (single-wait-submitted)
[783.024512] Starting subtest: single-wait-submitted
[783.131465] Subtest single-wait-submitted: SUCCESS (0.107s)
[783.208783] [088/133] (245s left) gem_mmap_offset (ptrace)
[783.261326] Starting subtest: ptrace
[783.263888] Starting dynamic subtest: smem0-wb
[783.284765] Dynamic subtest smem0-wb: SUCCESS (0.022s)
[783.296700] Starting dynamic subtest: smem0-wc
[783.305891] Dynamic subtest smem0-wc: SUCCESS (0.020s)
[783.317241] Starting dynamic subtest: smem0-uc
[783.328757] Dynamic subtest smem0-uc: SUCCESS (0.021s)
[783.331021] Subtest ptrace: SUCCESS (0.069s)
[783.446683] [089/133] (245s left) kms_color (invalid-ctm-matrix-sizes)
[783.535314] Starting subtest: invalid-ctm-matrix-sizes
[783.537910] Starting dynamic subtest: pipe-A
[783.540514] Dynamic subtest pipe-A: SUCCESS (0.002s)
[783.555286] Starting dynamic subtest: pipe-B
[783.557484] Dynamic subtest pipe-B: SUCCESS (0.003s)
[783.569041] Starting dynamic subtest: pipe-C
[783.570966] Dynamic subtest pipe-C: SUCCESS (0.004s)
[783.582505] Starting dynamic subtest: pipe-D
[783.584749] Dynamic subtest pipe-D: SUCCESS (0.004s)
[783.586984] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.015s)
[783.627769] [090/133] (244s left) syncobj_wait (single-wait-all-submitted)
[783.680566] Starting subtest: single-wait-all-submitted
[783.787057] Subtest single-wait-all-submitted: SUCCESS (0.107s)
[783.864992] [091/133] (244s left) gem_mmap_gtt (big-copy)
[783.915326] Subtest big-copy: SKIP (0.000s)
[783.990273] [092/133] (244s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[784.045539] Starting subtest: etime-multi-wait-all-for-submit-submitted
[784.146741] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.102s)
[784.237822] [093/133] (244s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[784.844384] Starting subtest: syncobj-timeline-invalid-flags
[784.846933] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[785.823710] [FACT gem_exec_fence (syncobj-timeline-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true
[785.827516] [094/133] (242s left) perf (i915-ref-count)
[785.926970] Starting subtest: i915-ref-count
[786.061191] Subtest i915-ref-count: SUCCESS (0.133s)
[786.119991] [095/133] (242s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[786.234758] Starting subtest: yf-tiled-64bpp-rotate-90
[786.239110] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[786.318704] [096/133] (242s left) syncobj_timeline (multi-wait-all-available-submitted)
[786.386793] Starting subtest: multi-wait-all-available-submitted
[786.389007] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[786.484715] [097/133] (242s left) kms_addfb_basic (bad-pitch-63)
[786.547480] Starting subtest: bad-pitch-63
[786.549705] Subtest bad-pitch-63: SUCCESS (0.000s)
[786.686499] [098/133] (242s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[786.798170] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[787.798592] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.998s)
[788.606388] [099/133] (240s left) i915_drm_fdinfo (virtual-busy-idle-all)
[788.645855] Starting subtest: virtual-busy-idle-all
[788.650309] Subtest virtual-busy-idle-all: SKIP (0.000s)
[788.719810] [100/133] (240s left) gem_exec_schedule (pi-shared-iova)
[788.900879] Starting subtest: pi-shared-iova
[788.902996] Starting dynamic subtest: rcs0
[788.981952] Dynamic subtest rcs0: SUCCESS (0.082s)
[788.997536] Starting dynamic subtest: vcs0
[789.043902] Dynamic subtest vcs0: SUCCESS (0.061s)
[789.058459] Starting dynamic subtest: vcs1
[789.105478] Dynamic subtest vcs1: SUCCESS (0.061s)
[789.120774] Starting dynamic subtest: vecs0
[789.171385] Dynamic subtest vecs0: SUCCESS (0.065s)
[789.185531] Starting dynamic subtest: ccs0
[789.230187] Dynamic subtest ccs0: SUCCESS (0.058s)
[789.232600] Subtest pi-shared-iova: SUCCESS (0.331s)
[790.827079] [101/133] (238s left) sysfs_heartbeat_interval (precise)
[790.888219] Starting subtest: precise
[790.890603] Starting dynamic subtest: vecs0
[798.751915] Dynamic subtest vecs0: SUCCESS (7.863s)
[798.766425] Starting dynamic subtest: ccs0
[799.901088] Dynamic subtest ccs0: SUCCESS (1.146s)
[799.915666] Starting dynamic subtest: vcs0
[806.745389] Dynamic subtest vcs0: SUCCESS (6.844s)
[806.759952] Starting dynamic subtest: bcs0
[807.882101] Dynamic subtest bcs0: SUCCESS (1.133s)
[807.896941] Starting dynamic subtest: rcs0
[809.000469] Dynamic subtest rcs0: SUCCESS (1.118s)
[809.014543] Starting dynamic subtest: vcs1
[816.724781] Dynamic subtest vcs1: SUCCESS (7.720s)
[816.727210] Subtest precise: SUCCESS (25.837s)
[816.816385] [102/133] (212s left) perf_pmu (interrupts)
[816.860754] Starting subtest: interrupts
[817.941214] Subtest interrupts: SUCCESS (1.080s)
[818.050467] [103/133] (211s left) prime_self_import (basic-with_fd_dup)
[818.086376] Starting subtest: basic-with_fd_dup
[818.100407] Subtest basic-with_fd_dup: SUCCESS (0.014s)
[818.217065] [104/133] (210s left) fbdev (nullptr)
[818.262143] Starting subtest: nullptr
[818.264542] Subtest nullptr: SUCCESS (0.000s)
[818.330835] [105/133] (210s left) template (a)
[818.384253] Starting subtest: A
[818.386187] Subtest A: SUCCESS (0.000s)
[818.479681] [106/133] (210s left) gem_exercise_blt (fast-copy-emit)
[818.541799] Starting subtest: fast-copy-emit
[818.546013] Starting dynamic subtest: linear-smem-smem-emit
[818.569000] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.031s)
[818.581197] Starting dynamic subtest: xmajor-smem-smem-emit
[818.589321] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.019s)
[818.600777] Starting dynamic subtest: tile4-smem-smem-emit
[818.608331] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.018s)
[818.620076] Starting dynamic subtest: tile64-smem-smem-emit
[818.627196] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.018s)
[818.629474] Subtest fast-copy-emit: SUCCESS (0.090s)
[818.747294] [107/133] (210s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[818.823716] Subtest untiled-to-tiled: SKIP (0.000s)
[818.878553] [108/133] (210s left) kms_invalid_mode (bad-hsync-start)
[818.971992] Starting subtest: bad-hsync-start
[818.973934] Starting dynamic subtest: pipe-A-eDP-1
[819.260126] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[819.273161] Starting dynamic subtest: pipe-B-eDP-1
[819.275066] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[819.286851] Starting dynamic subtest: pipe-C-eDP-1
[819.289016] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[819.302069] Starting dynamic subtest: pipe-D-eDP-1
[819.304276] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[819.306396] Subtest bad-hsync-start: SUCCESS (0.295s)
[820.102310] [109/133] (209s left) kms_plane_multiple (tiling-y)
[820.204494] Starting subtest: tiling-y
[820.208541] Subtest tiling-y: SKIP (0.000s)
[820.282086] [110/133] (209s left) gen9_exec_parse (bb-start-out)
[820.331510] Subtest bb-start-out: SKIP (0.000s)
[820.419151] [111/133] (209s left) kms_big_fb (y-tiled-addfb)
[820.522575] Starting subtest: y-tiled-addfb
[820.526814] Subtest y-tiled-addfb: SKIP (0.000s)
[820.617426] [112/133] (208s left) gem_render_copy_redux (normal)
[820.678709] Starting subtest: normal
[820.955775] Subtest normal: SUCCESS (0.277s)
[821.041322] [113/133] (208s left) kms_concurrent (multi-plane-atomic-lowres)
[821.125280] Starting subtest: multi-plane-atomic-lowres
[821.127105] Starting dynamic subtest: pipe-A-eDP-1
[821.629365] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.503s)
[821.641168] Starting dynamic subtest: pipe-B-eDP-1
[822.941825] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.310s)
[822.954861] Starting dynamic subtest: pipe-C-eDP-1
[824.209401] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.268s)
[824.221495] Starting dynamic subtest: pipe-D-eDP-1
[825.407493] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.196s)
[825.409844] Subtest multi-plane-atomic-lowres: SUCCESS (4.282s)
[826.195522] [114/133] (203s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[826.288020] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[826.292238] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[826.377255] [115/133] (203s left) kms_psr (fbc-psr-sprite-plane-onoff)
[826.484946] Starting subtest: fbc-psr-sprite-plane-onoff
[826.487316] Starting dynamic subtest: eDP-1
[826.491713] Dynamic subtest eDP-1: SKIP (0.000s)
[826.496245] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[826.576699] [116/133] (203s left) i915_drm_fdinfo (all-busy-check-all)
[826.617821] Starting subtest: all-busy-check-all
[826.622118] Subtest all-busy-check-all: SKIP (0.004s)
[826.697011] [117/133] (202s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[826.819447] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[826.821624] Starting dynamic subtest: pipe-A-eDP-1
[826.879260] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[826.890349] Starting dynamic subtest: pipe-B-eDP-1
[826.948191] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[826.961023] Starting dynamic subtest: pipe-C-eDP-1
[827.018114] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[827.030310] Starting dynamic subtest: pipe-D-eDP-1
[827.087748] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[827.091904] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.009s)
[829.099724] [118/133] (200s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[829.209332] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[829.213867] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[829.317032] [119/133] (200s left) gem_mmap (basic)
[829.373037] Subtest basic: SKIP (0.000s)
[829.436023] [120/133] (200s left) syncobj_timeline (reset-multiple-signaled)
[829.491185] Starting subtest: reset-multiple-signaled
[829.493343] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[829.609108] [121/133] (200s left) prime_vgem (fence-read-hang)
[829.694628] Subtest fence-read-hang: SKIP (0.000s)
[829.813858] [122/133] (200s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[829.922944] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[829.927123] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[830.031065] [123/133] (199s left) kms_pm_backlight (brightness-with-dpms)
[830.128975] Starting subtest: brightness-with-dpms
[830.181588] Starting dynamic subtest: eDP-1
[832.565821] Dynamic subtest eDP-1: SUCCESS (2.386s)
[832.568283] Subtest brightness-with-dpms: SUCCESS (2.439s)
[833.411348] [124/133] (196s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[833.515941] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[833.531386] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.018s)
[833.617021] [125/133] (196s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[833.729315] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[834.855981] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: FAIL (0.525s)
[834.902247] [126/133] (195s left) prime_mmap_coherency (read)
[834.979244] Starting subtest: read
[840.352966] Subtest read: SUCCESS (5.373s)
[840.466507] [127/133] (189s left) kms_plane_scaling (planes-upscale-20x20)
[840.560105] Starting subtest: planes-upscale-20x20
[840.562441] Starting dynamic subtest: pipe-A
[840.620210] Dynamic subtest pipe-A: SUCCESS (0.062s)
[840.631893] Starting dynamic subtest: pipe-B
[841.784356] Dynamic subtest pipe-B: SUCCESS (1.163s)
[841.797308] Starting dynamic subtest: pipe-C
[842.892503] Dynamic subtest pipe-C: SUCCESS (1.107s)
[842.904885] Starting dynamic subtest: pipe-D
[844.060207] Dynamic subtest pipe-D: SUCCESS (1.166s)
[844.062469] Subtest planes-upscale-20x20: SUCCESS (3.503s)
[845.197118] [128/133] (184s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[845.306765] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[845.310768] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[845.412419] [129/133] (184s left) kms_vrr (flip-suspend)
[845.513448] Starting subtest: flip-suspend
[845.519753] Subtest flip-suspend: SKIP (0.000s)
[845.588034] [130/133] (184s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[845.678891] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[845.680751] Starting dynamic subtest: pipe-A
[846.835822] Dynamic subtest pipe-A: SUCCESS (1.158s)
[846.848020] Starting dynamic subtest: pipe-B
[849.063685] Dynamic subtest pipe-B: SUCCESS (2.227s)
[849.075075] Starting dynamic subtest: pipe-C
[850.221553] Dynamic subtest pipe-C: SUCCESS (1.156s)
[850.234207] Starting dynamic subtest: pipe-D
[851.437993] Dynamic subtest pipe-D: SUCCESS (1.215s)
[851.440817] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.761s)
[852.591692] [131/133] (177s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[852.683446] Starting subtest: basic-max-pipe-crc-check
[852.687631] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[852.733794] [132/133] (177s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[852.825901] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[852.830391] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[852.918032] [133/133] (177s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[853.010307] Starting subtest: pr-overlay-plane-update-continuous-sf
[853.014844] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[853.079075] Closing watchdogs
results: parsing output: 0/ for test: gem_mmap_gtt
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: gem_userptr_blits
results: parsing output: 4/ for test: gem_exec_balancer
results: parsing output: 5/ for test: kms_chamelium_frames
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_cdclk
results: parsing output: 9/ for test: sw_sync
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: gem_eio
results: parsing output: 12/ for test: kms_pm_rpm
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_cursor_crc
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: i915_selftest
results: parsing output: 17/ for test: kms_pipe_b_c_ivb
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: gem_eio
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_close_race
results: parsing output: 22/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 23/ for test: gem_ctx_param
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: kms_flip_scaled_crc
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_ppgtt
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_psr2_sf
results: parsing output: 31/ for test: kms_psr
results: parsing output: 32/ for test: kms_chamelium_hpd
results: parsing output: 33/ for test: perf_pmu
results: parsing output: 34/ for test: gem_tiled_fence_blits
results: parsing output: 35/ for test: kms_async_flips
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: gem_mmap_offset
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: prime_self_import
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_render_copy
results: parsing output: 42/ for test: syncobj_wait
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_vblank
results: parsing output: 45/ for test: drm_mm
results: parsing output: 46/ for test: core_auth
results: parsing output: 47/ for test: gem_exec_schedule
results: parsing output: 48/ for test: i915_pm_rpm
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: kms_atomic_transition
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_ctx_persistence
results: parsing output: 54/ for test: kms_cursor_crc
results: parsing output: 55/ for test: gem_ctx_shared
results: parsing output: 56/ for test: kms_dp_link_training
results: parsing output: 57/ for test: kms_lease
results: parsing output: 58/ for test: kms_force_connector_basic
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: gem_exec_reloc
results: parsing output: 61/ for test: kms_dsc
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: gem_ctx_param
results: parsing output: 64/ for test: gem_exec_suspend
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_properties
results: parsing output: 67/ for test: kms_atomic_interruptible
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_plane
results: parsing output: 70/ for test: kms_flip_scaled_crc
results: parsing output: 71/ for test: kms_atomic
results: parsing output: 72/ for test: gem_ctx_exec
results: parsing output: 73/ for test: gem_exec_whisper
results: parsing output: 74/ for test: perf_pmu
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: kms_cursor_edge_walk
results: parsing output: 77/ for test: kms_cursor_legacy
results: parsing output: 78/ for test: gem_exec_balancer
results: parsing output: 79/ for test: kms_rotation_crc
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: kms_vblank
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_spin_batch
results: parsing output: 85/ for test: gem_render_copy
results: parsing output: 86/ for test: syncobj_wait
results: parsing output: 87/ for test: gem_mmap_offset
results: parsing output: 88/ for test: kms_color
results: parsing output: 89/ for test: syncobj_wait
results: parsing output: 90/ for test: gem_mmap_gtt
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: gem_exec_fence
results: parsing output: 93/ for test: perf
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: kms_addfb_basic
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: i915_drm_fdinfo
results: parsing output: 99/ for test: gem_exec_schedule
results: parsing output: 100/ for test: sysfs_heartbeat_interval
results: parsing output: 101/ for test: perf_pmu
results: parsing output: 102/ for test: prime_self_import
results: parsing output: 103/ for test: fbdev
results: parsing output: 104/ for test: template
results: parsing output: 105/ for test: gem_exercise_blt
results: parsing output: 106/ for test: gem_set_tiling_vs_blt
results: parsing output: 107/ for test: kms_invalid_mode
results: parsing output: 108/ for test: kms_plane_multiple
results: parsing output: 109/ for test: gen9_exec_parse
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: gem_render_copy_redux
results: parsing output: 112/ for test: kms_concurrent
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: i915_drm_fdinfo
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_mmap
results: parsing output: 119/ for test: syncobj_timeline
results: parsing output: 120/ for test: prime_vgem
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_pm_backlight
results: parsing output: 123/ for test: kms_flip
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: prime_mmap_coherency
results: parsing output: 126/ for test: kms_plane_scaling
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_vrr
results: parsing output: 129/ for test: kms_plane_scaling
results: parsing output: 130/ for test: kms_multipipe_modeset
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_psr2_sf
Done.