[58.634178] Initializing watchdogs
[58.634226]   /dev/watchdog0
[58.649847] [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.654946] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.657446] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.661588] [001/131] (960s left) gem_exec_balancer (full-pulse)
[58.746052] Starting subtest: full-pulse
[63.155990] Subtest full-pulse: SUCCESS (4.418s)
[63.524507] [002/131] (955s left) kms_flip (2x-flip-vs-expired-vblank)
[63.624184] Starting subtest: 2x-flip-vs-expired-vblank
[63.636520] Subtest 2x-flip-vs-expired-vblank: SKIP (0.012s)
[63.722399] [003/131] (955s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[63.815813] Starting subtest: basic-modeset-with-all-modifiers-formats
[64.196197] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[65.011738] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.818s)
[65.020117] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[65.032916] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[65.041275] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[65.056024] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[65.067707] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[65.211345] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.155s)
[65.221116] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[65.233193] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.022s)
[65.241278] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[65.255353] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[65.264802] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[65.277551] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[65.285186] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[65.299421] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.022s)
[65.307135] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[65.322429] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.022s)
[65.331374] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[65.344722] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.022s)
[65.352858] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[65.366437] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[65.375610] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[65.388853] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[65.396811] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[65.544080] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s)
[65.552696] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[65.566153] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.022s)
[65.574133] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[65.588338] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s)
[65.596253] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[65.611363] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[65.621609] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[65.632797] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[65.640625] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[65.654684] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s)
[65.663989] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[65.677240] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s)
[65.684931] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[65.698981] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[65.706446] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[65.721629] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[65.730744] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[65.877084] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.156s)
[65.889708] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[65.899122] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[65.910483] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[65.921593] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[65.931064] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[65.943716] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[65.953262] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[65.965807] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[65.975943] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[65.987863] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[65.995902] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[66.010168] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[66.020636] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[66.032404] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[66.040312] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[66.054566] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[66.445531] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.634s)
[67.284775] [004/131] (952s left) syncobj_timeline (etime-multi-wait-submitted)
[67.338195] Starting subtest: etime-multi-wait-submitted
[67.442125] Subtest etime-multi-wait-submitted: SUCCESS (0.104s)
[67.519360] [005/131] (951s left) gem_exec_schedule (preempt-self)
[67.602121] Starting subtest: preempt-self
[67.604635] Starting dynamic subtest: rcs0
[67.618512] Dynamic subtest rcs0: SUCCESS (0.025s)
[67.628797] Starting dynamic subtest: bcs0
[67.640401] Dynamic subtest bcs0: SUCCESS (0.021s)
[67.648464] Starting dynamic subtest: vcs0
[67.657274] Dynamic subtest vcs0: SUCCESS (0.017s)
[67.665383] Starting dynamic subtest: vcs1
[67.674470] Dynamic subtest vcs1: SUCCESS (0.017s)
[67.686512] Starting dynamic subtest: vecs0
[67.691691] Dynamic subtest vecs0: SUCCESS (0.016s)
[67.699838] Starting dynamic subtest: ccs0
[67.709742] Dynamic subtest ccs0: SUCCESS (0.018s)
[67.712198] Subtest preempt-self: SUCCESS (0.116s)
[69.408062] [006/131] (949s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[69.462627] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[69.467140] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[69.641972] [007/131] (949s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[69.735464] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[76.740443] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (7.012s)
[76.876996] [008/131] (942s left) kms_addfb_basic (invalid-set-prop-any)
[76.939349] Starting subtest: invalid-set-prop-any
[76.941334] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[77.074494] [009/131] (942s left) kms_flip_event_leak (basic)
[77.160198] Starting subtest: basic
[77.162465] Starting dynamic subtest: pipe-A-eDP-1
[77.590439] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.429s)
[77.599736] Starting dynamic subtest: pipe-B-eDP-1
[78.724402] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.134s)
[78.734025] Starting dynamic subtest: pipe-C-eDP-1
[79.834067] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.108s)
[79.842921] Starting dynamic subtest: pipe-D-eDP-1
[80.963118] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[80.965552] Subtest basic: SUCCESS (3.803s)
[81.836254] [010/131] (937s left) kms_cursor_edge_walk (256x256-right-edge)
[81.934069] Starting subtest: 256x256-right-edge
[81.936344] Starting dynamic subtest: pipe-A-eDP-1
[85.403837] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.470s)
[85.416721] Starting dynamic subtest: pipe-D-eDP-1
[88.608316] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.205s)
[88.610284] Subtest 256x256-right-edge: SUCCESS (6.677s)
[89.421330] [011/131] (930s left) kms_invalid_mode (zero-hdisplay)
[89.516354] Starting subtest: zero-hdisplay
[89.518757] Starting dynamic subtest: pipe-A-eDP-1
[89.826333] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.310s)
[89.836866] Starting dynamic subtest: pipe-B-eDP-1
[89.838855] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[89.848939] Starting dynamic subtest: pipe-C-eDP-1
[89.851252] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[89.860354] Starting dynamic subtest: pipe-D-eDP-1
[89.862763] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[89.865133] Subtest zero-hdisplay: SUCCESS (0.314s)
[90.666812] [012/131] (928s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[90.763239] Starting subtest: fbc-psr-cursor-mmap-cpu
[90.765614] Starting dynamic subtest: eDP-1
[90.769594] Dynamic subtest eDP-1: SKIP (0.000s)
[90.773638] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.000s)
[90.835648] [013/131] (928s left) gem_mmap (bad-object)
[90.891966] Subtest bad-object: SKIP (0.000s)
[90.950417] [014/131] (928s left) kms_content_protection (dp-mst-lic-type-1)
[91.090797] Starting subtest: dp-mst-lic-type-1
[91.095581] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[91.203264] [015/131] (928s left) gem_ccs (suspend-resume)
[91.258830] Starting subtest: suspend-resume
[91.262875] Subtest suspend-resume: SKIP (0.000s)
[91.360152] [016/131] (928s left) gem_exec_gttfill (multigpu-basic)
[91.526675] Starting subtest: multigpu-basic
[105.400351] Subtest multigpu-basic: SUCCESS (13.876s)
[105.454616] [017/131] (914s left) kms_lease (empty-lease)
[105.598435] Starting subtest: empty-lease
[105.600814] Starting dynamic subtest: pipe-A-eDP-1
[105.603531] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[105.613482] Starting dynamic subtest: pipe-B-eDP-1
[105.615337] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[105.623736] Starting dynamic subtest: pipe-C-eDP-1
[105.625806] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[105.634442] Starting dynamic subtest: pipe-D-eDP-1
[105.636406] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[105.638385] Subtest empty-lease: SUCCESS (0.007s)
[105.713828] [018/131] (914s left) perf_pmu (busy)
[105.759486] Starting subtest: busy
[105.761728] Starting dynamic subtest: rcs0
[106.347423] Dynamic subtest rcs0: SUCCESS (0.588s)
[106.360938] Starting dynamic subtest: bcs0
[106.917884] Dynamic subtest bcs0: SUCCESS (0.569s)
[106.929825] Starting dynamic subtest: vcs0
[108.293553] Dynamic subtest vcs0: SUCCESS (1.373s)
[108.305617] Starting dynamic subtest: vcs1
[110.279045] Dynamic subtest vcs1: SUCCESS (1.984s)
[110.289501] Starting dynamic subtest: vecs0
[112.327064] Dynamic subtest vecs0: SUCCESS (2.047s)
[112.338943] Starting dynamic subtest: ccs0
[112.889216] Dynamic subtest ccs0: SUCCESS (0.563s)
[112.891893] Subtest busy: SUCCESS (7.131s)
[112.989222] [019/131] (906s left) syncobj_timeline (wait-any-snapshot)
[113.046477] Starting subtest: wait-any-snapshot
[113.128830] Subtest wait-any-snapshot: SUCCESS (0.081s)
[113.221009] [020/131] (906s left) kms_async_flips (test-time-stamp-atomic)
[113.331705] Starting subtest: test-time-stamp-atomic
[113.720630] Starting dynamic subtest: pipe-A-eDP-1
[114.565576] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.843s)
[114.961277] Starting dynamic subtest: pipe-B-eDP-1
[115.798704] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.845s)
[116.171295] Starting dynamic subtest: pipe-C-eDP-1
[116.937654] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.776s)
[117.314981] Starting dynamic subtest: pipe-D-eDP-1
[118.074282] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.767s)
[118.076854] Subtest test-time-stamp-atomic: SUCCESS (4.741s)
[119.253304] [021/131] (900s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[119.351040] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[119.355626] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[119.459844] [022/131] (900s left) syncobj_basic (bad-create-flags)
[119.513770] Starting subtest: bad-create-flags
[119.516045] Subtest bad-create-flags: SUCCESS (0.000s)
[119.613603] [023/131] (900s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[119.717933] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[127.555127] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.840s)
[127.687611] [024/131] (892s left) gem_exec_whisper (basic-queues-forked-all)
[127.754859] Starting subtest: basic-queues-forked-all
[147.509903] Subtest basic-queues-forked-all: SUCCESS (19.752s)
[147.691700] [025/131] (872s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[147.793744] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[147.797819] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[147.897647] [026/131] (872s left) gem_wait (wait)
[147.962255] Starting subtest: wait
[147.964668] Starting dynamic subtest: all-engines
[149.317853] Dynamic subtest all-engines: SUCCESS (1.353s)
[149.329455] Starting dynamic subtest: rcs0
[150.363514] Dynamic subtest rcs0: SUCCESS (1.046s)
[150.374650] Starting dynamic subtest: bcs0
[151.409977] Dynamic subtest bcs0: SUCCESS (1.045s)
[151.421641] Starting dynamic subtest: vcs0
[152.452869] Dynamic subtest vcs0: SUCCESS (1.042s)
[152.463968] Starting dynamic subtest: vcs1
[153.497993] Dynamic subtest vcs1: SUCCESS (1.044s)
[153.509244] Starting dynamic subtest: vecs0
[154.543632] Dynamic subtest vecs0: SUCCESS (1.045s)
[154.555636] Starting dynamic subtest: ccs0
[155.591743] Dynamic subtest ccs0: SUCCESS (1.047s)
[155.594263] Subtest wait: SUCCESS (7.629s)
[155.786284] [027/131] (864s left) kms_feature_discovery (display)
[155.888264] Starting subtest: display
[155.890395] Subtest display: SUCCESS (0.000s)
[155.993653] [028/131] (864s left) gem_exec_schedule (preemptive-hang)
[156.175508] Starting subtest: preemptive-hang
[156.178191] Starting dynamic subtest: rcs0
[165.428037] Dynamic subtest rcs0: SUCCESS (9.252s)
[165.438791] Starting dynamic subtest: bcs0
[174.451374] Dynamic subtest bcs0: SUCCESS (9.023s)
[174.461684] Starting dynamic subtest: vcs0
[183.408614] Dynamic subtest vcs0: SUCCESS (8.956s)
[183.419582] Starting dynamic subtest: vcs1
[192.430853] Dynamic subtest vcs1: SUCCESS (9.022s)
[192.440035] Starting dynamic subtest: vecs0
[201.387980] Dynamic subtest vecs0: SUCCESS (8.955s)
[201.404024] Starting dynamic subtest: ccs0
[210.418752] Dynamic subtest ccs0: SUCCESS (9.029s)
[210.420843] Subtest preemptive-hang: SUCCESS (54.242s)
[210.659762] [029/131] (809s left) gem_bad_reloc (negative-reloc-lut)
[210.730920] Subtest negative-reloc-lut: SKIP (0.000s)
[210.795221] [030/131] (809s left) gem_mmap_wc (write-prefaulted)
[210.846198] Subtest write-prefaulted: SKIP (0.000s)
[210.901035] [031/131] (809s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[210.958762] Starting subtest: multi-wait-all-for-submit-unsubmitted
[211.066078] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.106s)
[211.155647] [032/131] (809s left) gem_tiled_fence_blits (basic)
[211.221313] Subtest basic: SKIP (0.000s)
[211.281218] [033/131] (809s left) prime_vgem (basic-fence-blt)
[211.419522] Starting subtest: basic-fence-blt
[211.499570] Subtest basic-fence-blt: SUCCESS (0.079s)
[211.625815] [FACT prime_vgem (basic-fence-blt)] new: kernel.kmod_is_loaded.vgem: true
[211.629296] [034/131] (808s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[211.744144] Starting subtest: x-tiled-8bpp-rotate-270
[211.765173] Subtest x-tiled-8bpp-rotate-270: SKIP (0.021s)
[211.883465] [035/131] (808s left) api_intel_allocator (gem-pool)
[211.938975] Starting subtest: gem-pool
[211.943772] Subtest gem-pool: SUCCESS (0.006s)
[212.069008] [036/131] (808s left) gem_exec_fence (syncobj-timeline-signal)
[212.593669] Starting subtest: syncobj-timeline-signal
[212.600887] Subtest syncobj-timeline-signal: SUCCESS (0.008s)
[214.372819] [037/131] (806s left) kms_psr (psr2-cursor-plane-move)
[214.480037] Starting subtest: psr2-cursor-plane-move
[214.482421] Starting dynamic subtest: eDP-1
[216.191809] Dynamic subtest eDP-1: SUCCESS (1.712s)
[216.194225] Subtest psr2-cursor-plane-move: SUCCESS (1.713s)
[217.073801] [038/131] (803s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[217.299290] Starting subtest: cursor-rapid-movement-128x42
[217.350516] Subtest cursor-rapid-movement-128x42: SKIP (0.047s)
[217.561152] [039/131] (803s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[217.647215] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[217.649423] Starting dynamic subtest: pipe-A
[217.710390] Dynamic subtest pipe-A: SUCCESS (0.065s)
[217.721852] Starting dynamic subtest: pipe-B
[218.890322] Dynamic subtest pipe-B: SUCCESS (1.179s)
[218.902067] Starting dynamic subtest: pipe-C
[220.011596] Dynamic subtest pipe-C: SUCCESS (1.120s)
[220.022433] Starting dynamic subtest: pipe-D
[221.155757] Dynamic subtest pipe-D: SUCCESS (1.143s)
[221.158359] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.511s)
[222.307212] [040/131] (798s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[222.409585] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[222.413934] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[222.509921] [041/131] (798s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[222.613826] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[223.282568] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.670s)
[223.446630] [042/131] (797s left) gem_ctx_shared (exec-shared-gtt)
[223.511303] Starting subtest: exec-shared-gtt
[223.513935] Starting dynamic subtest: rcs0
[223.519572] Dynamic subtest rcs0: SUCCESS (0.008s)
[223.529537] Starting dynamic subtest: bcs0
[223.531491] Dynamic subtest bcs0: SUCCESS (0.005s)
[223.543710] Starting dynamic subtest: vcs0
[223.545825] Dynamic subtest vcs0: SUCCESS (0.006s)
[223.556297] Starting dynamic subtest: vcs1
[223.558427] Dynamic subtest vcs1: SUCCESS (0.006s)
[223.567330] Starting dynamic subtest: vecs0
[223.569455] Dynamic subtest vecs0: SUCCESS (0.006s)
[223.578572] Starting dynamic subtest: ccs0
[223.580731] Dynamic subtest ccs0: SUCCESS (0.006s)
[223.582886] Subtest exec-shared-gtt: SUCCESS (0.041s)
[223.736282] [043/131] (797s left) kms_fbcon_fbt (fbc-suspend)
[223.794954] Starting subtest: fbc-suspend
[272.477513] Subtest fbc-suspend: SUCCESS (19.964s)
[273.826993] [044/131] (747s left) i915_drm_fdinfo (virtual-busy-all)
[273.877541] Starting subtest: virtual-busy-all
[273.881962] Subtest virtual-busy-all: SKIP (0.000s)
[273.957283] [045/131] (747s left) kms_color (ctm-negative)
[274.054313] Starting subtest: ctm-negative
[274.056580] Starting dynamic subtest: pipe-A-eDP-1
[274.762362] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.710s)
[274.773495] Starting dynamic subtest: pipe-B-eDP-1
[276.151702] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.393s)
[276.162407] Starting dynamic subtest: pipe-C-eDP-1
[277.513458] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.360s)
[277.524862] Starting dynamic subtest: pipe-D-eDP-1
[278.849430] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.338s)
[278.851775] Subtest ctm-negative: SUCCESS (4.804s)
[279.656799] [046/131] (741s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[279.755014] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[279.759581] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s)
[279.828817] [047/131] (741s left) kms_psr2_su (page_flip-nv12)
[279.879870] Subtest page_flip-NV12: SKIP (0.000s)
[279.949134] [048/131] (741s left) gem_exec_reloc (basic-gtt)
[280.002485] Subtest basic-gtt: SKIP (0.000s)
[280.076865] [049/131] (741s left) dmabuf_sync_file (export-before-signal)
[280.126382] Starting subtest: export-before-signal
[280.128549] Subtest export-before-signal: SUCCESS (0.002s)
[280.199280] [050/131] (740s left) kms_flip (plain-flip-ts-check-interruptible)
[280.302450] Starting subtest: plain-flip-ts-check-interruptible
[280.304733] Starting dynamic subtest: A-eDP1
[289.152768] Dynamic subtest A-eDP1: SUCCESS (8.858s)
[289.166110] Starting dynamic subtest: B-eDP1
[297.986600] Dynamic subtest B-eDP1: SUCCESS (8.838s)
[297.997575] Starting dynamic subtest: C-eDP1
[306.795310] Dynamic subtest C-eDP1: SUCCESS (8.806s)
[306.807619] Starting dynamic subtest: D-eDP1
[315.630481] Dynamic subtest D-eDP1: SUCCESS (8.834s)
[315.633428] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.344s)
[316.826258] [051/131] (704s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[316.934801] Starting subtest: yf-tiled-addfb-size-offset-overflow
[316.939538] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[317.029796] [052/131] (704s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[317.124519] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[317.128539] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s)
[317.200367] [053/131] (704s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[317.295183] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[317.299136] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[317.393416] [054/131] (703s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[317.484713] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[317.489183] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[317.582796] [055/131] (703s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[317.675191] Starting subtest: coverage-vs-premult-vs-constant
[317.965903] Starting dynamic subtest: pipe-A-eDP-1
[318.611564] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.642s)
[318.624544] Starting dynamic subtest: pipe-D-eDP-1
[319.925595] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.315s)
[319.928428] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.253s)
[320.784239] [056/131] (700s left) gen3_render_tiledx_blits
[320.911416] [057/131] (700s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[321.015360] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[321.019783] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[321.129667] [058/131] (700s left) kms_pm_dc (dc5-dpms)
[322.227940] Starting subtest: dc5-dpms
[324.342279] Subtest dc5-dpms: SUCCESS (2.115s)
[324.422669] [059/131] (697s left) gem_mmap_gtt (cpuset-basic-small-copy)
[324.483437] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[324.543331] [060/131] (697s left) gem_readwrite (read-bad-handle)
[324.610591] Subtest read-bad-handle: SKIP (0.000s)
[324.683544] [061/131] (696s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[324.783271] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[324.785742] Starting dynamic subtest: pipe-A-eDP-1
[324.844899] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[324.857497] Starting dynamic subtest: pipe-B-eDP-1
[324.916961] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[324.930073] Starting dynamic subtest: pipe-C-eDP-1
[324.987117] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[324.998822] Starting dynamic subtest: pipe-D-eDP-1
[325.056533] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[325.061095] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.009s)
[327.058796] [062/131] (694s left) kms_psr (fbc-psr2-primary-page-flip)
[327.155063] Starting subtest: fbc-psr2-primary-page-flip
[327.157261] Starting dynamic subtest: eDP-1
[327.161317] Dynamic subtest eDP-1: SKIP (0.000s)
[327.165426] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[327.232288] [063/131] (694s left) gem_mmap_offset (partial-remap)
[327.296620] Starting subtest: partial-remap
[327.299040] Starting dynamic subtest: smem0
[327.307909] Dynamic subtest smem0: SUCCESS (0.004s)
[327.309887] Subtest partial-remap: SUCCESS (0.005s)
[327.430015] [064/131] (694s left) i915_pm_freq_api (freq-basic-api)
[327.494720] Starting subtest: freq-basic-api
[327.497071] Starting dynamic subtest: gt0
[327.499287] Dynamic subtest gt0: SUCCESS (0.003s)
[327.509606] Starting dynamic subtest: gt1
[327.511789] Dynamic subtest gt1: SUCCESS (0.003s)
[327.513992] Subtest freq-basic-api: SUCCESS (0.007s)
[327.608628] [065/131] (694s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[327.702923] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[327.705185] Starting dynamic subtest: pipe-A-eDP-1
[327.727723] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[327.740509] Starting dynamic subtest: pipe-B-eDP-1
[327.761882] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[327.775512] Starting dynamic subtest: pipe-C-eDP-1
[327.797259] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[327.807156] Starting dynamic subtest: pipe-D-eDP-1
[327.829202] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[327.833612] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[330.022221] [066/131] (691s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[330.126530] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[330.131054] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[330.214616] [067/131] (691s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[330.324454] Starting subtest: psr2-cursor-plane-update-sf
[330.326778] Starting dynamic subtest: pipe-A-eDP-1
[330.888411] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.567s)
[330.902924] Starting dynamic subtest: pipe-B-eDP-1
[332.204382] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.314s)
[332.206642] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.883s)
[333.079978] [068/131] (688s left) kms_flip (dpms-vs-vblank-race)
[333.176739] Starting subtest: dpms-vs-vblank-race
[333.179535] Starting dynamic subtest: A-eDP1
[337.137710] Dynamic subtest A-eDP1: SUCCESS (3.960s)
[337.149471] Starting dynamic subtest: B-eDP1
[340.759917] Dynamic subtest B-eDP1: SUCCESS (3.620s)
[340.770520] Starting dynamic subtest: C-eDP1
[344.278108] Dynamic subtest C-eDP1: SUCCESS (3.517s)
[344.289709] Starting dynamic subtest: D-eDP1
[348.909895] Dynamic subtest D-eDP1: SUCCESS (4.634s)
[348.915390] Subtest dpms-vs-vblank-race: SUCCESS (15.743s)
[349.787667] [069/131] (672s left) gem_exec_balancer (parallel-out-fence)
[350.045636] Starting subtest: parallel-out-fence
[351.210243] Subtest parallel-out-fence: SUCCESS (1.164s)
[351.319784] [070/131] (670s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[351.379905] Starting subtest: multi-wait-available-unsubmitted-signaled
[351.381826] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[351.479858] [071/131] (670s left) kms_prop_blob (blob-prop-core)
[351.540559] Starting subtest: blob-prop-core
[351.542823] Subtest blob-prop-core: SUCCESS (0.000s)
[351.643127] [072/131] (670s left) kms_chamelium_edid (dp-mode-timings)
[352.040044] Subtest dp-mode-timings: SKIP (0.000s)
[352.905740] [073/131] (669s left) gem_softpin (evict-single-offset)
[352.967107] Starting subtest: evict-single-offset
[382.054860] Subtest evict-single-offset: SUCCESS (29.082s)
[382.152152] [074/131] (640s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[382.302488] Starting subtest: y-tiled-8bpp-rotate-270
[382.306675] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[382.401546] [075/131] (639s left) gem_mmap_gtt (basic-small-copy)
[382.473319] Subtest basic-small-copy: SKIP (0.000s)
[382.530680] [076/131] (639s left) kms_vblank (invalid)
[382.627680] Starting subtest: invalid
[382.629969] Starting dynamic subtest: pipe-A-eDP-1
[383.045774] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.418s)
[383.048199] Subtest invalid: SUCCESS (0.420s)
[383.863214] [077/131] (638s left) gem_flink_basic (basic)
[383.927897] Starting subtest: basic
[383.929966] Subtest basic: SUCCESS (0.001s)
[384.039968] [078/131] (638s left) kms_setmode (invalid-clone-single-crtc-stealing)
[384.096428] Starting subtest: invalid-clone-single-crtc-stealing
[384.103109] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[384.203908] [079/131] (638s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[384.304279] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[384.306608] Starting dynamic subtest: pipe-A
[384.531214] Dynamic subtest pipe-A: SUCCESS (0.229s)
[384.542481] Starting dynamic subtest: pipe-B
[385.866249] Dynamic subtest pipe-B: SUCCESS (1.334s)
[385.876519] Starting dynamic subtest: pipe-C
[387.191228] Dynamic subtest pipe-C: SUCCESS (1.324s)
[387.206909] Starting dynamic subtest: pipe-D
[388.539587] Dynamic subtest pipe-D: SUCCESS (1.347s)
[388.542396] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.237s)
[389.705999] [080/131] (632s left) kms_pm_rpm (modeset-pc8-residency-stress)
[391.274465] Starting subtest: modeset-pc8-residency-stress
[391.279299] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[392.051541] [081/131] (630s left) sw_sync (sync_merge_invalid)
[392.103326] Starting subtest: sync_merge_invalid
[392.125721] Subtest sync_merge_invalid: SUCCESS (0.024s)
[392.218520] [082/131] (630s left) kms_big_fb (linear-16bpp-rotate-270)
[392.324473] Starting subtest: linear-16bpp-rotate-270
[392.344122] Subtest linear-16bpp-rotate-270: SKIP (0.019s)
[392.481227] [083/131] (630s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[392.581375] Starting subtest: multiplane-rotation-cropping-bottom
[410.061771] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.482s)
[410.155049] [084/131] (612s left) kms_psr (pr-cursor-mmap-cpu)
[410.263244] Starting subtest: pr-cursor-mmap-cpu
[410.266746] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[410.338701] [085/131] (612s left) gem_eio (wait-wedge-10ms)
[410.585127] Starting subtest: wait-wedge-10ms
[412.150043] Subtest wait-wedge-10ms: SUCCESS (1.562s)
[412.272374] [086/131] (610s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[412.375979] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[412.378304] Starting dynamic subtest: pipe-A-default-mode
[415.091060] Dynamic subtest pipe-A-default-mode: SUCCESS (2.717s)
[415.093338] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.718s)
[415.947776] [087/131] (606s left) i915_pm_rps (min-max-config-idle)
[416.017630] Starting subtest: min-max-config-idle
[416.022139] Subtest min-max-config-idle: SKIP (0.001s)
[416.125849] [088/131] (606s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[416.228430] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[416.232438] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[416.353204] [089/131] (606s left) kms_cursor_crc (cursor-offscreen-32x32)
[416.497629] Starting subtest: cursor-offscreen-32x32
[416.547877] Subtest cursor-offscreen-32x32: SKIP (0.044s)
[416.845104] [090/131] (606s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[416.941058] Starting subtest: fbc-rgb565-draw-mmap-cpu
[421.032490] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.094s)
[422.259841] [091/131] (600s left) syncobj_timeline (invalid-signal-bad-pad)
[422.338659] Starting subtest: invalid-signal-bad-pad
[422.341207] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[422.455967] [092/131] (600s left) i915_suspend (basic-s3-without-i915)
[422.494165] Starting subtest: basic-s3-without-i915
[425.935247] Subtest basic-s3-without-i915: SKIP (3.438s)
[427.624727] [093/131] (595s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[427.736533] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[434.745900] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (7.014s)
[434.870466] [094/131] (588s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[434.969655] Starting subtest: psr-rgb101010-draw-mmap-gtt
[434.974231] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[435.071193] [095/131] (588s left) gem_ctx_param (set-priority-invalid-size)
[435.139239] Starting subtest: set-priority-invalid-size
[435.141679] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[435.232904] [096/131] (587s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[435.326332] Starting subtest: pipe-fbc-rte
[435.333144] Starting dynamic subtest: pipe-B-eDP-1
[440.857548] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.535s)
[440.865860] Subtest pipe-fbc-rte: SUCCESS (5.538s)
[443.148580] [097/131] (580s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[443.243168] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[443.247057] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[443.364463] [098/131] (579s left) gem_request_retire (retire-vma-not-inactive)
[443.427764] Starting subtest: retire-vma-not-inactive
[443.488956] Subtest retire-vma-not-inactive: SUCCESS (0.058s)
[443.619506] [099/131] (579s left) gem_set_tiling_vs_pwrite
[443.728395] [100/131] (579s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[443.823877] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[443.825810] Starting dynamic subtest: pipe-A-eDP-1
[444.572927] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.740s)
[444.582941] Starting dynamic subtest: pipe-B-eDP-1
[446.364886] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.792s)
[446.375929] Starting dynamic subtest: pipe-C-eDP-1
[448.181699] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.816s)
[448.192380] Starting dynamic subtest: pipe-D-eDP-1
[450.035668] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.853s)
[450.038108] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.206s)
[451.253775] [101/131] (572s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[451.356702] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[455.548141] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.196s)
[456.749765] [102/131] (566s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[456.846250] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[456.848595] Starting dynamic subtest: pipe-A-eDP-1
[456.872079] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[456.884161] Starting dynamic subtest: pipe-B-eDP-1
[456.906021] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[456.916126] Starting dynamic subtest: pipe-C-eDP-1
[456.938231] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[456.950554] Starting dynamic subtest: pipe-D-eDP-1
[456.971677] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[456.975719] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[459.087983] [103/131] (564s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[459.470953] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[460.299217] [104/131] (563s left) gem_exec_whisper (basic-contexts-forked)
[460.371113] Starting subtest: basic-contexts-forked
[483.746271] Subtest basic-contexts-forked: SUCCESS (23.382s)
[483.934931] [105/131] (539s left) perf_pmu (init-busy)
[483.981378] Starting subtest: init-busy
[483.983926] Starting dynamic subtest: rcs0
[483.986632] Dynamic subtest rcs0: SUCCESS (0.001s)
[483.998813] Starting dynamic subtest: bcs0
[484.001420] Dynamic subtest bcs0: SUCCESS (0.000s)
[484.011150] Starting dynamic subtest: vcs0
[484.013265] Dynamic subtest vcs0: SUCCESS (0.001s)
[484.023866] Starting dynamic subtest: vcs1
[484.026002] Dynamic subtest vcs1: SUCCESS (0.001s)
[484.035906] Starting dynamic subtest: vecs0
[484.037735] Dynamic subtest vecs0: SUCCESS (0.001s)
[484.047432] Starting dynamic subtest: ccs0
[484.049551] Dynamic subtest ccs0: SUCCESS (0.000s)
[484.051644] Subtest init-busy: SUCCESS (0.008s)
[484.105531] [106/131] (539s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[484.211268] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[484.215414] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[484.313083] [107/131] (539s left) gem_ctx_persistence (heartbeat-hang)
[484.373374] Starting subtest: heartbeat-hang
[484.378104] Subtest heartbeat-hang: SKIP (0.000s)
[484.493569] [108/131] (539s left) syncobj_timeline (wait-all-complex)
[484.535978] Starting subtest: wait-all-complex
[484.750429] Subtest wait-all-complex: SUCCESS (0.213s)
[484.845073] [109/131] (538s left) kms_vrr (flip-basic)
[484.935907] Starting subtest: flip-basic
[484.942490] Subtest flip-basic: SKIP (0.000s)
[485.022084] [110/131] (538s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[485.088494] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[485.092996] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[485.285971] [111/131] (538s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[485.388001] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[485.390312] Starting dynamic subtest: pipe-A-eDP-1
[486.336389] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.941s)
[486.348013] Starting dynamic subtest: pipe-B-eDP-1
[488.073011] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.735s)
[488.084079] Starting dynamic subtest: pipe-C-eDP-1
[489.668255] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.593s)
[489.680894] Starting dynamic subtest: pipe-D-eDP-1
[491.247611] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.581s)
[491.249890] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.855s)
[492.451565] [112/131] (531s left) kms_properties (connector-properties-legacy)
[492.555479] Starting subtest: connector-properties-legacy
[492.557511] Starting dynamic subtest: pipe-A-eDP-1
[500.765665] Dynamic subtest pipe-A-eDP-1: SUCCESS (8.207s)
[500.778070] Starting dynamic subtest: pipe-None-DP-1
[500.782639] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[500.792360] Starting dynamic subtest: pipe-None-HDMI-A-1
[500.797152] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[500.807183] Starting dynamic subtest: pipe-None-DP-2
[500.811640] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[500.821675] Starting dynamic subtest: pipe-None-HDMI-A-2
[500.826721] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[500.839193] Starting dynamic subtest: pipe-None-DP-3
[500.843885] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[500.854125] Starting dynamic subtest: pipe-None-DP-4
[500.858149] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[500.860055] Subtest connector-properties-legacy: SUCCESS (8.219s)
[501.634454] [113/131] (522s left) syncobj_wait (multi-wait-all-signaled)
[501.709339] Starting subtest: multi-wait-all-signaled
[501.711241] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[501.829904] [114/131] (522s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[501.925603] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[501.930001] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[502.027431] [115/131] (521s left) gem_ctx_freq (sysfs)
[502.077180] Starting subtest: sysfs
[502.079513] Starting dynamic subtest: gt0
[507.611734] Dynamic subtest gt0: SUCCESS (5.532s)
[507.625475] Starting dynamic subtest: gt1
[549.093526] Dynamic subtest gt1: SUCCESS (41.471s)
[549.096595] Subtest sysfs: SUCCESS (47.006s)
[549.231441] [116/131] (474s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[549.328257] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[553.055433] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.730s)
[554.232641] [117/131] (469s left) gem_caching (read-writes)
[554.296872] Subtest read-writes: SKIP (0.000s)
[554.376196] [118/131] (469s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[554.465053] Starting subtest: psr-dirtyfb-ioctl
[554.467295] Starting dynamic subtest: A-eDP-1
[558.427362] Dynamic subtest A-eDP-1: SUCCESS (3.963s)
[558.429826] Subtest psr-dirtyfb-ioctl: SUCCESS (3.964s)
[559.310363] [119/131] (464s left) core_getversion (all-cards)
[559.348638] Starting subtest: all-cards
[559.356664] Subtest all-cards: SUCCESS (0.011s)
[559.404436] [120/131] (464s left) gem_close_race (basic-process)
[559.474480] Starting subtest: basic-process
[559.535883] Subtest basic-process: SUCCESS (0.061s)
[559.721983] [121/131] (464s left) vgem_basic (unload)
[559.752639] Starting subtest: unload
[588.853570] Subtest unload: SUCCESS (29.100s)
[588.952092] [122/131] (435s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[589.047858] Starting subtest: primary-y-tiled-reflect-x-180
[589.122033] Subtest primary-y-tiled-reflect-x-180: SKIP (0.072s)
[589.228578] [123/131] (435s left) gem_softpin (overlap)
[589.289312] Starting subtest: overlap
[590.226385] Subtest overlap: SUCCESS (0.935s)
[590.348505] [124/131] (434s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[590.449163] Starting subtest: 4-tiled-64bpp-rotate-90
[590.469013] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s)
[590.593225] [125/131] (433s left) gen9_exec_parse (basic-rejected-ctx-param)
[590.651133] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[590.721883] [126/131] (433s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[590.819547] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[590.823967] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[590.922025] [127/131] (433s left) gem_workarounds (suspend-resume-fd)
[590.984957] Starting subtest: suspend-resume-fd
[607.212983] Subtest suspend-resume-fd: SUCCESS (1.174s)
[607.351854] [128/131] (417s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[607.454896] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[607.460264] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[607.572530] [129/131] (417s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[607.679568] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[615.145654] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.491s)
[615.282480] [130/131] (409s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[615.392670] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[615.397782] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[615.492351] [131/131] (409s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[615.545578] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[615.651331] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.106s)
[615.731017] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_balancer
results: parsing output: 1/ for test: kms_flip
results: parsing output: 2/ for test: kms_async_flips
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: gem_exec_schedule
results: parsing output: 5/ for test: gem_render_copy
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_addfb_basic
results: parsing output: 8/ for test: kms_flip_event_leak
results: parsing output: 9/ for test: kms_cursor_edge_walk
results: parsing output: 10/ for test: kms_invalid_mode
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: gem_mmap
results: parsing output: 13/ for test: kms_content_protection
results: parsing output: 14/ for test: gem_ccs
results: parsing output: 15/ for test: gem_exec_gttfill
results: parsing output: 16/ for test: kms_lease
results: parsing output: 17/ for test: perf_pmu
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: kms_async_flips
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: syncobj_basic
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_exec_whisper
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_wait
results: parsing output: 26/ for test: kms_feature_discovery
results: parsing output: 27/ for test: gem_exec_schedule
results: parsing output: 28/ for test: gem_bad_reloc
results: parsing output: 29/ for test: gem_mmap_wc
results: parsing output: 30/ for test: syncobj_wait
results: parsing output: 31/ for test: gem_tiled_fence_blits
results: parsing output: 32/ for test: prime_vgem
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: api_intel_allocator
results: parsing output: 35/ for test: gem_exec_fence
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: kms_cursor_crc
results: parsing output: 38/ for test: kms_plane_scaling
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: gem_ctx_shared
results: parsing output: 42/ for test: kms_fbcon_fbt
results: parsing output: 43/ for test: i915_drm_fdinfo
results: parsing output: 44/ for test: kms_color
results: parsing output: 45/ for test: kms_plane
results: parsing output: 46/ for test: kms_psr2_su
results: parsing output: 47/ for test: gem_exec_reloc
results: parsing output: 48/ for test: dmabuf_sync_file
results: parsing output: 49/ for test: kms_flip
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: kms_plane
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_plane_alpha_blend
results: parsing output: 55/ for test: gen3_render_tiledx_blits
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_pm_dc
results: parsing output: 58/ for test: gem_mmap_gtt
results: parsing output: 59/ for test: gem_readwrite
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: kms_psr
results: parsing output: 62/ for test: gem_mmap_offset
results: parsing output: 63/ for test: i915_pm_freq_api
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_psr2_sf
results: parsing output: 67/ for test: kms_flip
results: parsing output: 68/ for test: gem_exec_balancer
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: kms_prop_blob
results: parsing output: 71/ for test: kms_chamelium_edid
results: parsing output: 72/ for test: gem_softpin
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: gem_mmap_gtt
results: parsing output: 75/ for test: kms_vblank
results: parsing output: 76/ for test: gem_flink_basic
results: parsing output: 77/ for test: kms_setmode
results: parsing output: 78/ for test: kms_plane_scaling
results: parsing output: 79/ for test: kms_pm_rpm
results: parsing output: 80/ for test: sw_sync
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: kms_rotation_crc
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: gem_eio
results: parsing output: 85/ for test: kms_flip_scaled_crc
results: parsing output: 86/ for test: i915_pm_rps
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_cursor_crc
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: i915_suspend
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_ctx_param
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_request_retire
results: parsing output: 98/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 99/ for test: kms_ccs
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: kms_chamelium_hpd
results: parsing output: 103/ for test: gem_exec_whisper
results: parsing output: 104/ for test: perf_pmu
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_ctx_persistence
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_vrr
results: parsing output: 109/ for test: gem_render_copy
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: kms_properties
results: parsing output: 112/ for test: syncobj_wait
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_ctx_freq
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_caching
results: parsing output: 117/ for test: kms_dirtyfb
results: parsing output: 118/ for test: core_getversion
results: parsing output: 119/ for test: gem_close_race
results: parsing output: 120/ for test: vgem_basic
results: parsing output: 121/ for test: kms_rotation_crc
results: parsing output: 122/ for test: gem_softpin
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: gen9_exec_parse
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_workarounds
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: syncobj_timeline
Done.