[59.468363] Initializing watchdogs
[59.468525]   /dev/watchdog0
[59.485045] [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]
[59.489471] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.491682] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.493943] [001/133] (960s left) i915_drm_fdinfo (busy-idle)
[59.537812] Starting subtest: busy-idle
[59.538872] Starting dynamic subtest: rcs0
[59.575726] Dynamic subtest rcs0: SKIP (0.037s)
[59.583958] Starting dynamic subtest: bcs0
[59.585690] Dynamic subtest bcs0: SKIP (0.001s)
[59.590841] Starting dynamic subtest: vcs0
[59.592556] Dynamic subtest vcs0: SKIP (0.000s)
[59.598365] Starting dynamic subtest: vcs1
[59.600164] Dynamic subtest vcs1: SKIP (0.000s)
[59.605883] Starting dynamic subtest: vecs0
[59.607534] Dynamic subtest vecs0: SKIP (0.000s)
[59.612651] Starting dynamic subtest: ccs0
[59.614472] Dynamic subtest ccs0: SKIP (0.000s)
[59.616367] Subtest busy-idle: SKIP (0.041s)
[59.641261] [002/133] (960s left) kms_hdr (static-toggle-dpms)
[59.738992] Starting subtest: static-toggle-dpms
[59.741801] Subtest static-toggle-dpms: SKIP (0.000s)
[59.808472] [003/133] (960s left) gem_ctx_param (basic-default)
[59.849381] Starting subtest: basic-default
[59.850431] Subtest basic-default: SUCCESS (0.000s)
[59.928554] [004/133] (960s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[60.032352] Starting subtest: psr-rgb565-draw-mmap-wc
[66.924837] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.908s)
[67.500085] [005/133] (952s left) gem_render_copy (yf-tiled-ccs-to-linear)
[67.662730] Starting subtest: yf-tiled-ccs-to-linear
[67.664822] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[67.960260] [006/133] (952s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[68.146289] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[75.109926] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.967s)
[75.235878] [007/133] (944s left) i915_pm_rps (min-max-config-loaded)
[75.294123] Starting subtest: min-max-config-loaded
[75.295980] Subtest min-max-config-loaded: SKIP (0.001s)
[75.386157] [008/133] (944s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[75.467197] Starting subtest: fbcpsr-shrfb-scaledprimary
[81.308832] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.843s)
[81.438146] [009/133] (938s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[81.531461] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[88.647700] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.118s)
[88.775226] [010/133] (931s left) kms_rotation_crc (cursor-rotation-180)
[88.868648] Starting subtest: cursor-rotation-180
[90.382512] Subtest cursor-rotation-180: SUCCESS (1.515s)
[91.564260] [011/133] (928s left) syncobj_wait (reset-multiple-signaled)
[91.610098] Starting subtest: reset-multiple-signaled
[91.610970] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[91.695433] [012/133] (928s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[91.741183] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[91.742073] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s)
[91.824740] [013/133] (928s left) kms_psr (psr2-basic)
[91.902591] Starting subtest: psr2-basic
[91.903690] Starting dynamic subtest: eDP-1
[93.532685] Dynamic subtest eDP-1: SUCCESS (1.628s)
[93.533784] Subtest psr2-basic: SUCCESS (1.629s)
[94.320491] [014/133] (926s left) kms_vblank (ts-continuation-modeset)
[94.410845] Starting subtest: ts-continuation-modeset
[94.411940] Starting dynamic subtest: pipe-A-eDP-1
[95.898616] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.488s)
[95.905925] Starting dynamic subtest: pipe-D-eDP-1
[98.068681] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.166s)
[98.069907] Subtest ts-continuation-modeset: SUCCESS (3.658s)
[98.859923] [015/133] (921s left) syncobj_timeline (wait-for-submit-snapshot)
[98.918241] Starting subtest: wait-for-submit-snapshot
[99.000057] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[99.067026] [016/133] (921s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[99.118924] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[99.171062] [017/133] (921s left) gem_ctx_param (invalid-get-ringsize)
[99.214218] Starting subtest: invalid-get-ringsize
[99.216939] Subtest invalid-get-ringsize: SUCCESS (0.002s)
[99.303645] [018/133] (921s left) gem_tiled_fence_blits (normal)
[99.350953] Subtest normal: SKIP (0.000s)
[99.411069] [019/133] (921s left) gem_linear_blits (interruptible)
[99.755540] Starting subtest: interruptible
[104.313627] Subtest interruptible: SUCCESS (4.513s)
[104.399569] [020/133] (916s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[104.822951] Starting subtest: x-tiled-64bpp-rotate-270
[104.843026] Subtest x-tiled-64bpp-rotate-270: SKIP (0.020s)
[104.936709] [021/133] (915s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[105.020504] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[105.021458] Starting dynamic subtest: pipe-A
[105.393545] Dynamic subtest pipe-A: SUCCESS (0.373s)
[105.400038] Starting dynamic subtest: pipe-B
[106.779335] Dynamic subtest pipe-B: SUCCESS (1.385s)
[106.785830] Starting dynamic subtest: pipe-C
[108.203742] Dynamic subtest pipe-C: SUCCESS (1.424s)
[108.210940] Starting dynamic subtest: pipe-D
[109.686484] Dynamic subtest pipe-D: SUCCESS (1.482s)
[109.687737] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.667s)
[110.827256] [022/133] (909s left) kms_pm_rpm (system-suspend-modeset)
[113.086626] Starting subtest: system-suspend-modeset
[133.267491] Subtest system-suspend-modeset: SUCCESS (5.087s)
[138.651737] [023/133] (887s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[138.702828] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[138.704224] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.002s)
[138.778882] [024/133] (886s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[138.876379] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[138.878102] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[138.953131] [025/133] (886s left) gem_ctx_param (non-root-set)
[139.000963] Starting subtest: non-root-set
[139.022225] Subtest non-root-set: SUCCESS (0.022s)
[139.109436] [026/133] (886s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[139.205309] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[139.206783] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[139.293534] [027/133] (886s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[139.388915] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[140.190843] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.815s)
[140.339276] [028/133] (885s left) gem_ctx_persistence (file)
[140.389926] Starting subtest: file
[140.495010] Subtest file: SUCCESS (0.107s)
[140.602017] [029/133] (885s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[140.694582] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[140.695449] Starting dynamic subtest: pipe-A-default-mode
[141.841342] Dynamic subtest pipe-A-default-mode: SKIP (1.159s)
[141.842972] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.160s)
[141.988435] [030/133] (883s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[142.070927] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[142.071855] Starting dynamic subtest: pipe-A
[143.121652] Dynamic subtest pipe-A: SUCCESS (1.062s)
[143.136836] Starting dynamic subtest: pipe-B
[145.190884] Dynamic subtest pipe-B: SUCCESS (2.086s)
[145.199083] Starting dynamic subtest: pipe-C
[146.378042] Dynamic subtest pipe-C: SUCCESS (1.195s)
[146.385312] Starting dynamic subtest: pipe-D
[147.602128] Dynamic subtest pipe-D: SUCCESS (1.231s)
[147.603069] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.578s)
[148.799884] [031/133] (877s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[148.892820] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[148.893980] Starting dynamic subtest: A-eDP1
[152.516991] Dynamic subtest A-eDP1: SUCCESS (3.637s)
[152.524168] Starting dynamic subtest: B-eDP1
[155.710632] Dynamic subtest B-eDP1: SUCCESS (3.201s)
[155.718009] Starting dynamic subtest: C-eDP1
[158.887665] Dynamic subtest C-eDP1: SUCCESS (3.181s)
[158.895328] Starting dynamic subtest: D-eDP1
[161.971122] Dynamic subtest D-eDP1: SUCCESS (3.087s)
[161.973942] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.116s)
[162.768078] [032/133] (863s left) gem_exec_parallel (contexts)
[162.828743] Starting subtest: contexts
[162.829539] Starting dynamic subtest: rcs0
[165.626161] Dynamic subtest rcs0: SUCCESS (2.791s)
[165.636922] Starting dynamic subtest: bcs0
[169.310482] Dynamic subtest bcs0: SUCCESS (3.685s)
[169.318516] Starting dynamic subtest: vcs0
[173.526569] Dynamic subtest vcs0: SUCCESS (4.212s)
[173.536001] Starting dynamic subtest: vcs1
[177.556143] Dynamic subtest vcs1: SUCCESS (4.027s)
[177.565973] Starting dynamic subtest: vecs0
[181.450827] Dynamic subtest vecs0: SUCCESS (3.893s)
[181.461155] Starting dynamic subtest: ccs0
[184.832496] Dynamic subtest ccs0: SUCCESS (3.379s)
[184.833917] Subtest contexts: SUCCESS (22.001s)
[185.004144] [033/133] (841s left) gem_exec_alignment (many)
[185.056185] Starting subtest: many
[210.020148] Subtest many: SUCCESS (24.924s)
[212.242930] [034/133] (813s left) kms_psr (fbc-pr-no-drrs)
[212.374219] Starting subtest: fbc-pr-no-drrs
[212.376227] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[212.445342] [035/133] (813s left) kms_vrr (flip-suspend)
[212.532004] Starting subtest: flip-suspend
[212.534603] Subtest flip-suspend: SKIP (0.000s)
[212.596546] [036/133] (813s left) i915_module_load (reload)
[212.631115] Starting subtest: reload
[216.056582] Subtest reload: SUCCESS (3.427s)
[216.088264] [037/133] (810s left) gem_vm_create (invalid-destroy)
[217.977444] Starting subtest: invalid-destroy
[217.978648] Subtest invalid-destroy: SUCCESS (0.002s)
[218.078672] [038/133] (808s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[218.172002] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[218.172909] Starting dynamic subtest: pipe-A-eDP-1
[218.176448] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[218.187655] Starting dynamic subtest: pipe-B-eDP-1
[218.191131] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[218.201992] Starting dynamic subtest: pipe-C-eDP-1
[218.205515] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[218.218489] Starting dynamic subtest: pipe-D-eDP-1
[218.222796] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[218.224637] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[220.423754] [039/133] (805s left) kms_dsc (dsc-with-bpc-formats)
[220.516677] Starting subtest: dsc-with-bpc-formats
[220.559065] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[220.607155] [040/133] (805s left) kms_flip (dpms-off-confusion)
[220.688105] Starting subtest: dpms-off-confusion
[220.691611] Starting dynamic subtest: A-eDP1
[229.468965] Dynamic subtest A-eDP1: SUCCESS (8.755s)
[229.478789] Starting dynamic subtest: B-eDP1
[238.194942] Dynamic subtest B-eDP1: SUCCESS (8.722s)
[238.202425] Starting dynamic subtest: C-eDP1
[246.934138] Dynamic subtest C-eDP1: SUCCESS (8.722s)
[246.942361] Starting dynamic subtest: D-eDP1
[255.572776] Dynamic subtest D-eDP1: SUCCESS (8.633s)
[255.573665] Subtest dpms-off-confusion: SUCCESS (34.847s)
[256.705440] [041/133] (769s left) gem_exec_schedule (submit-early-slice)
[256.780831] Starting subtest: submit-early-slice
[256.781944] Starting dynamic subtest: rcs0
[256.827908] Dynamic subtest rcs0: SUCCESS (0.046s)
[256.838348] Starting dynamic subtest: bcs0
[256.867677] Dynamic subtest bcs0: SUCCESS (0.039s)
[256.879435] Starting dynamic subtest: vcs0
[256.903597] Dynamic subtest vcs0: SUCCESS (0.035s)
[256.910507] Starting dynamic subtest: vcs1
[256.941066] Dynamic subtest vcs1: SUCCESS (0.037s)
[256.948974] Starting dynamic subtest: vecs0
[256.974713] Dynamic subtest vecs0: SUCCESS (0.033s)
[256.982369] Starting dynamic subtest: ccs0
[257.011065] Dynamic subtest ccs0: SUCCESS (0.036s)
[257.011870] Subtest submit-early-slice: SUCCESS (0.231s)
[258.071199] [042/133] (768s left) gem_exec_schedule (noreorder)
[258.259298] Starting subtest: noreorder
[258.260409] Starting dynamic subtest: rcs0
[258.312995] Dynamic subtest rcs0: SUCCESS (0.059s)
[258.323268] Starting dynamic subtest: vcs0
[259.983320] Dynamic subtest vcs0: SUCCESS (1.659s)
[259.993389] Starting dynamic subtest: vcs1
[262.035647] Dynamic subtest vcs1: SUCCESS (2.050s)
[262.045033] Starting dynamic subtest: vecs0
[264.020380] Dynamic subtest vecs0: SUCCESS (1.981s)
[264.029451] Starting dynamic subtest: ccs0
[264.075618] Dynamic subtest ccs0: SUCCESS (0.062s)
[264.077760] Subtest noreorder: SUCCESS (5.823s)
[264.259307] [043/133] (762s left) gem_close (many-handles-one-vma)
[264.322637] Starting subtest: many-handles-one-vma
[264.367944] Subtest many-handles-one-vma: SUCCESS (0.045s)
[264.474335] [044/133] (761s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[264.576786] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[264.578374] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[264.676363] [045/133] (761s left) kms_plane_alpha_blend (alpha-basic)
[264.761790] Starting subtest: alpha-basic
[265.047952] Starting dynamic subtest: pipe-A-eDP-1
[266.960423] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.912s)
[266.989622] Starting dynamic subtest: pipe-D-eDP-1
[269.601447] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.619s)
[269.602330] Subtest alpha-basic: SUCCESS (4.839s)
[270.480812] [046/133] (755s left) kms_psr (psr2-cursor-plane-move)
[270.562023] Starting subtest: psr2-cursor-plane-move
[270.562916] Starting dynamic subtest: eDP-1
[272.261411] Dynamic subtest eDP-1: SUCCESS (1.699s)
[272.262149] Subtest psr2-cursor-plane-move: SUCCESS (1.700s)
[273.064300] [047/133] (753s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[273.166009] Starting subtest: y-tiled-64bpp-rotate-270
[273.167819] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[273.252122] [048/133] (753s left) dmabuf_sync_file (export-multiwait)
[273.319472] Starting subtest: export-multiwait
[273.320409] Subtest export-multiwait: SUCCESS (0.001s)
[273.376736] [FACT dmabuf_sync_file (export-multiwait)] new: kernel.kmod_is_loaded.vgem: true
[273.378597] [049/133] (753s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[273.465389] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[273.467242] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[273.560532] [050/133] (753s left) gem_mmap_gtt (basic-small-copy)
[273.614104] Subtest basic-small-copy: SKIP (0.000s)
[273.670446] [051/133] (752s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[274.202928] Starting subtest: syncobj-backward-timeline-chain-engines
[274.291059] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.100s)
[276.057853] [052/133] (750s left) gem_userptr_blits (process-exit-busy)
[276.109312] Starting subtest: process-exit-busy
[276.123997] Subtest process-exit-busy: SUCCESS (0.015s)
[276.232425] [053/133] (750s left) kms_big_fb (linear-64bpp-rotate-90)
[276.328064] Starting subtest: linear-64bpp-rotate-90
[276.347714] Subtest linear-64bpp-rotate-90: SKIP (0.019s)
[276.481660] [054/133] (750s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[276.573140] Starting subtest: extended-modeset-hang-oldfb-with-reset
[276.573978] Starting dynamic subtest: pipe-A
[288.700889] Dynamic subtest pipe-A: SUCCESS (12.127s)
[288.710887] Starting dynamic subtest: pipe-D
[301.272134] Dynamic subtest pipe-D: SUCCESS (12.571s)
[301.273111] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.702s)
[302.071927] [055/133] (724s left) gem_readwrite (new-obj)
[302.134206] Subtest new-obj: SKIP (0.000s)
[302.192011] [056/133] (724s left) gem_exec_whisper (basic-forked-all)
[302.248073] Starting subtest: basic-forked-all
[315.824795] Subtest basic-forked-all: SUCCESS (13.578s)
[316.006161] [057/133] (710s left) gem_mmap_offset (mmap-boundaries)
[316.059904] Starting subtest: mmap-boundaries
[316.060956] Starting dynamic subtest: smem0
[316.388399] Dynamic subtest smem0: SUCCESS (0.320s)
[316.389446] Subtest mmap-boundaries: SUCCESS (0.321s)
[316.494230] [058/133] (710s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[316.584362] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[316.612106] Starting dynamic subtest: pipe-A-plane-0
[317.266433] Dynamic subtest pipe-A-plane-0: SUCCESS (0.655s)
[317.274740] Starting dynamic subtest: pipe-A-plane-3
[317.755566] Dynamic subtest pipe-A-plane-3: SUCCESS (0.488s)
[318.861084] Starting dynamic subtest: pipe-B-plane-0
[319.507506] Dynamic subtest pipe-B-plane-0: SUCCESS (0.655s)
[319.516193] Starting dynamic subtest: pipe-B-plane-3
[319.963119] Dynamic subtest pipe-B-plane-3: SUCCESS (0.455s)
[320.288933] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.706s)
[321.146054] [059/133] (705s left) api_intel_allocator (reopen)
[321.197390] Starting subtest: reopen
[321.200079] Subtest reopen: SUCCESS (0.004s)
[321.344846] [060/133] (705s left) gem_mmap (pf-nonblock)
[321.386868] Subtest pf-nonblock: SKIP (0.000s)
[321.442481] [061/133] (705s left) syncobj_timeline (wait-any-snapshot)
[321.497154] Starting subtest: wait-any-snapshot
[321.578809] Subtest wait-any-snapshot: SUCCESS (0.081s)
[321.653400] [062/133] (705s left) i915_query (query-garbage)
[321.696714] Starting subtest: query-garbage
[321.697507] Subtest query-garbage: SUCCESS (0.000s)
[321.779491] [063/133] (705s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[321.826806] Starting subtest: multi-wait-all-for-submit-signaled
[321.827901] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[321.939864] [064/133] (705s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[321.992061] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[321.993805] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[322.169346] [065/133] (704s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[322.275496] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[322.286938] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[322.396467] [066/133] (704s left) gem_create (create-valid-nonaligned)
[322.446534] Starting subtest: create-valid-nonaligned
[322.447520] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[322.629195] [067/133] (704s left) gem_barrier_race (remote-request)
[322.689023] Starting subtest: remote-request
[322.689929] Starting dynamic subtest: rcs0
[327.889245] Dynamic subtest rcs0: SUCCESS (5.201s)
[327.894061] Subtest remote-request: SUCCESS (5.202s)
[328.038351] [068/133] (699s left) kms_prop_blob (blob-prop-core)
[328.102030] Starting subtest: blob-prop-core
[328.103173] Subtest blob-prop-core: SUCCESS (0.000s)
[328.229906] [069/133] (699s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[328.335061] Starting subtest: fbcpsr-suspend
[369.402974] Subtest fbcpsr-suspend: SUCCESS (11.605s)
[372.533231] [070/133] (657s left) gem_mmap_gtt (basic-read)
[372.594621] Subtest basic-read: SKIP (0.000s)
[372.654878] [071/133] (657s left) kms_flip (2x-blocking-wf_vblank)
[372.750652] Starting subtest: 2x-blocking-wf_vblank
[372.761317] Subtest 2x-blocking-wf_vblank: SKIP (0.011s)
[372.836904] [072/133] (657s left) kms_psr (psr-sprite-plane-move)
[372.936242] Starting subtest: psr-sprite-plane-move
[372.937099] Starting dynamic subtest: eDP-1
[374.702262] Dynamic subtest eDP-1: SUCCESS (1.792s)
[374.703121] Subtest psr-sprite-plane-move: SUCCESS (1.793s)
[375.514332] [073/133] (654s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[375.613405] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[375.615266] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[375.726095] [074/133] (654s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[375.773985] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[375.891781] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.108s)
[375.966201] [075/133] (654s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[376.056301] Starting subtest: fbc-psr2-cursor-mmap-gtt
[376.057131] Starting dynamic subtest: eDP-1
[376.058950] Dynamic subtest eDP-1: SKIP (0.000s)
[376.060506] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[376.125530] [076/133] (654s left) kms_getfb (getfb-handle-protection)
[376.230754] Starting subtest: getfb-handle-protection
[376.240592] Subtest getfb-handle-protection: SUCCESS (0.017s)
[376.365343] [077/133] (654s left) kms_addfb_basic (bad-pitch-128)
[376.416532] Starting subtest: bad-pitch-128
[376.417303] Subtest bad-pitch-128: SUCCESS (0.000s)
[376.545336] [078/133] (654s left) gem_partial_pwrite_pread (writes-after-reads-display)
[376.601989] Subtest writes-after-reads-display: SKIP (0.000s)
[376.659800] [079/133] (653s left) kms_content_protection (atomic)
[376.789641] Starting subtest: atomic
[376.791801] Subtest atomic: SKIP (0.000s)
[376.922948] [080/133] (653s left) kms_cursor_edge_walk (256x256-left-edge)
[377.006394] Starting subtest: 256x256-left-edge
[377.007281] Starting dynamic subtest: pipe-A-eDP-1
[380.451893] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.472s)
[380.461332] Starting dynamic subtest: pipe-D-eDP-1
[383.558779] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.122s)
[383.559699] Subtest 256x256-left-edge: SUCCESS (6.597s)
[384.350634] [081/133] (646s left) kms_pm_rpm (cursor)
[386.569873] Starting subtest: cursor
[386.571636] Subtest cursor: SKIP (0.000s)
[386.942774] [082/133] (643s left) kms_atomic (plane-invalid-params-fence)
[387.036248] Starting subtest: plane-invalid-params-fence
[387.037137] Starting dynamic subtest: pipe-A-eDP-1
[387.389254] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.354s)
[387.390146] Subtest plane-invalid-params-fence: SUCCESS (0.355s)
[388.266742] [083/133] (642s left) kms_async_flips (crc)
[388.352637] Starting subtest: crc
[388.728270] Starting dynamic subtest: pipe-A-eDP-1
[391.689306] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.967s)
[392.078641] Starting dynamic subtest: pipe-B-eDP-1
[395.014710] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.948s)
[395.387805] Starting dynamic subtest: pipe-C-eDP-1
[398.311074] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.935s)
[398.675748] Starting dynamic subtest: pipe-D-eDP-1
[401.544157] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.881s)
[401.545196] Subtest crc: SUCCESS (13.212s)
[402.714068] [084/133] (628s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[402.801592] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[402.803515] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[402.898507] [085/133] (627s left) kms_plane_cursor (viewport)
[402.971968] Starting subtest: viewport
[402.973721] Starting dynamic subtest: pipe-A-eDP-1-size-64
[405.527532] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.556s)
[405.592673] Starting dynamic subtest: pipe-A-eDP-1-size-128
[408.141384] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.560s)
[408.203179] Starting dynamic subtest: pipe-A-eDP-1-size-256
[410.810191] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.615s)
[411.163497] Starting dynamic subtest: pipe-B-eDP-1-size-64
[414.465389] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.312s)
[414.528093] Starting dynamic subtest: pipe-B-eDP-1-size-128
[417.089691] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.571s)
[417.150734] Starting dynamic subtest: pipe-B-eDP-1-size-256
[419.724040] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.582s)
[420.074050] Starting dynamic subtest: pipe-C-eDP-1-size-64
[422.903284] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.839s)
[422.943184] Starting dynamic subtest: pipe-C-eDP-1-size-128
[425.169519] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.236s)
[425.209630] Starting dynamic subtest: pipe-C-eDP-1-size-256
[427.402876] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.203s)
[427.733908] Starting dynamic subtest: pipe-D-eDP-1-size-64
[430.657936] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.933s)
[430.697475] Starting dynamic subtest: pipe-D-eDP-1-size-128
[432.892135] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.204s)
[432.929800] Starting dynamic subtest: pipe-D-eDP-1-size-256
[435.101590] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.180s)
[435.420794] Subtest viewport: SUCCESS (32.446s)
[436.218208] [086/133] (594s left) i915_pm_rps (thresholds-idle)
[436.276023] Starting subtest: thresholds-idle
[436.277678] Subtest thresholds-idle: SKIP (0.001s)
[436.371407] [087/133] (594s left) kms_addfb_basic (bo-too-small)
[436.459975] Starting subtest: bo-too-small
[436.461102] Subtest bo-too-small: SUCCESS (0.000s)
[436.567937] [088/133] (594s left) gem_exec_whisper (basic-queues-forked)
[436.633712] Starting subtest: basic-queues-forked
[459.699479] Subtest basic-queues-forked: SUCCESS (23.062s)
[459.882583] [089/133] (571s left) perf (invalid-oa-format-id)
[459.980174] Starting subtest: invalid-oa-format-id
[459.991974] Subtest invalid-oa-format-id: SUCCESS (0.012s)
[460.041793] [090/133] (570s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[460.140398] Starting subtest: psr2-cursor-plane-update-sf
[460.141262] Starting dynamic subtest: pipe-A-eDP-1
[460.718794] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.577s)
[460.727948] Starting dynamic subtest: pipe-B-eDP-1
[461.994087] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.274s)
[461.994852] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.854s)
[462.862281] [091/133] (568s left) gem_exec_reloc (basic-cpu-gtt)
[462.915512] Subtest basic-cpu-gtt: SKIP (0.000s)
[462.978774] [092/133] (568s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[463.075227] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[463.076239] Starting dynamic subtest: pipe-A-eDP-1
[463.085218] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[463.097944] Starting dynamic subtest: pipe-B-eDP-1
[463.105568] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[463.114594] Starting dynamic subtest: pipe-C-eDP-1
[463.122285] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[463.130655] Starting dynamic subtest: pipe-D-eDP-1
[463.138585] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[463.140218] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[465.329955] [093/133] (565s left) gem_close_race (multigpu-basic-process)
[465.395084] Starting subtest: multigpu-basic-process
[465.396963] Subtest multigpu-basic-process: SKIP (0.000s)
[465.617971] [094/133] (565s left) gen9_exec_parse (batch-invalid-length)
[465.666410] Subtest batch-invalid-length: SKIP (0.000s)
[465.737969] [095/133] (565s left) gem_exec_fence (syncobj-unused-fence)
[466.182596] Starting subtest: syncobj-unused-fence
[466.187666] Subtest syncobj-unused-fence: SUCCESS (0.005s)
[467.513343] [096/133] (563s left) gem_exec_nop (basic-sequential)
[467.571761] Starting subtest: basic-sequential
[481.920573] Subtest basic-sequential: SUCCESS (14.346s)
[482.161221] [097/133] (549s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[482.250837] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[482.252539] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[482.350750] [098/133] (548s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[482.466362] Starting subtest: 4-tiled-64bpp-rotate-90
[482.492249] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.025s)
[482.627492] [099/133] (548s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[482.682241] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[482.742691] [100/133] (548s left) kms_fence_pin_leak
[482.913103] [101/133] (548s left) prime_busy (hang-wait)
[482.965941] Starting subtest: hang-wait
[482.966856] Starting dynamic subtest: rcs0
[508.929998] Dynamic subtest rcs0: SUCCESS (25.960s)
[508.938440] Starting dynamic subtest: bcs0
[516.085656] Dynamic subtest bcs0: SUCCESS (7.153s)
[516.096020] Starting dynamic subtest: vcs0
[523.130356] Dynamic subtest vcs0: SUCCESS (7.043s)
[523.140058] Starting dynamic subtest: vcs1
[530.098177] Dynamic subtest vcs1: SUCCESS (6.968s)
[530.108170] Starting dynamic subtest: vecs0
[537.072888] Dynamic subtest vecs0: SUCCESS (6.974s)
[537.082846] Starting dynamic subtest: ccs0
[550.977705] Dynamic subtest ccs0: SUCCESS (13.905s)
[550.980990] Subtest hang-wait: SUCCESS (68.017s)
[551.090007] [102/133] (480s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[551.470290] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[552.318752] [103/133] (479s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[552.411987] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[552.413917] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[552.501893] [104/133] (479s left) gem_unref_active_buffers
[552.710804] [105/133] (478s left) kms_rmfb (rmfb-ioctl)
[552.809221] Starting subtest: rmfb-ioctl
[552.810397] Starting dynamic subtest: pipe-A-eDP-1
[552.915931] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.107s)
[552.927771] Starting dynamic subtest: pipe-B-eDP-1
[554.108228] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.191s)
[554.120373] Starting dynamic subtest: pipe-C-eDP-1
[555.335775] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.224s)
[555.346036] Starting dynamic subtest: pipe-D-eDP-1
[556.465044] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.128s)
[556.466526] Subtest rmfb-ioctl: SUCCESS (3.658s)
[557.596206] [106/133] (474s left) gem_exec_reloc (basic-cpu-read-noreloc)
[557.658154] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[557.721530] [107/133] (473s left) kms_cursor_crc (cursor-dpms)
[557.850983] Starting subtest: cursor-dpms
[557.851876] Starting dynamic subtest: pipe-A-eDP-1
[560.960279] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.109s)
[560.969012] Starting dynamic subtest: pipe-D-eDP-1
[564.571875] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.612s)
[564.572732] Subtest cursor-dpms: SUCCESS (6.724s)
[565.412031] [108/133] (466s left) kms_debugfs (display-off-read-all)
[565.502014] Starting subtest: display-off-read-all
[565.789977] Subtest display-off-read-all: SUCCESS (0.289s)
[566.641296] [109/133] (465s left) perf_pmu (most-busy-idle-check-all)
[566.678164] Starting subtest: most-busy-idle-check-all
[566.679078] Starting dynamic subtest: rcs0
[568.494417] Dynamic subtest rcs0: SUCCESS (1.806s)
[568.504510] Starting dynamic subtest: bcs0
[570.481599] Dynamic subtest bcs0: SUCCESS (1.982s)
[570.490696] Starting dynamic subtest: vcs0
[572.461705] Dynamic subtest vcs0: SUCCESS (1.980s)
[572.470552] Starting dynamic subtest: vcs1
[574.510295] Dynamic subtest vcs1: SUCCESS (2.046s)
[574.521152] Starting dynamic subtest: vecs0
[576.493836] Dynamic subtest vecs0: SUCCESS (1.980s)
[576.505196] Starting dynamic subtest: ccs0
[578.478589] Dynamic subtest ccs0: SUCCESS (1.982s)
[578.479739] Subtest most-busy-idle-check-all: SUCCESS (11.796s)
[578.568051] [110/133] (453s left) gem_exec_balancer (waits)
[578.636994] Starting subtest: waits
[585.225265] Subtest waits: SUCCESS (6.582s)
[585.521152] [111/133] (446s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[585.615461] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[585.616388] Starting dynamic subtest: pipe-A-eDP-1
[587.844678] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.230s)
[587.855365] Starting dynamic subtest: pipe-B-eDP-1
[590.304972] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.460s)
[590.315483] Starting dynamic subtest: pipe-C-eDP-1
[592.501494] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.196s)
[592.512058] Starting dynamic subtest: pipe-D-eDP-1
[594.668357] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.166s)
[594.669390] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (9.057s)
[595.844866] [112/133] (435s left) perf (invalid-oa-metric-set-id)
[595.946412] Starting subtest: invalid-oa-metric-set-id
[595.956636] Subtest invalid-oa-metric-set-id: SUCCESS (0.010s)
[595.999580] [113/133] (435s left) kms_fbcon_fbt (fbc)
[596.057987] Starting subtest: fbc
[602.387660] Subtest fbc: SUCCESS (6.317s)
[603.471770] [114/133] (428s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[603.559831] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[603.561631] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[603.658912] [115/133] (428s left) kms_lease (lease-again)
[603.747862] Starting subtest: lease-again
[603.748790] Starting dynamic subtest: pipe-A-eDP-1
[603.751149] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s)
[603.761707] Starting dynamic subtest: pipe-B-eDP-1
[603.762544] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[603.771634] Starting dynamic subtest: pipe-C-eDP-1
[603.772519] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[603.781345] Starting dynamic subtest: pipe-D-eDP-1
[603.782355] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[603.783237] Subtest lease-again: SUCCESS (0.013s)
[603.865184] [116/133] (428s left) kms_chamelium_color (ctm-max)
[603.947640] Subtest ctm-max: SKIP (0.000s)
[603.988485] [117/133] (428s left) gem_softpin (zero)
[604.044486] Starting subtest: zero
[604.048300] Subtest zero: SUCCESS (0.004s)
[604.172580] [118/133] (427s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[604.262148] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[604.264064] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[604.365121] [119/133] (427s left) perf (missing-sample-flags)
[604.465692] Starting subtest: missing-sample-flags
[604.466585] Subtest missing-sample-flags: SUCCESS (0.000s)
[604.509662] [120/133] (427s left) core_auth (getclient-simple)
[604.540092] Starting subtest: getclient-simple
[604.564344] Subtest getclient-simple: SUCCESS (0.024s)
[604.701080] [121/133] (427s left) kms_color (degamma)
[604.793078] Starting subtest: degamma
[604.793921] Starting dynamic subtest: pipe-A-eDP-1
[605.525718] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.733s)
[605.535138] Starting dynamic subtest: pipe-B-eDP-1
[606.923018] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.395s)
[606.932329] Starting dynamic subtest: pipe-C-eDP-1
[608.278542] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.355s)
[608.287562] Starting dynamic subtest: pipe-D-eDP-1
[609.612544] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.333s)
[609.613410] Subtest degamma: SUCCESS (4.818s)
[610.405622] [122/133] (421s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[610.495098] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[610.496693] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[610.586086] [123/133] (421s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[610.672860] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[610.674373] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[611.842763] [124/133] (420s left) gem_ctx_create (basic-files)
[611.904539] Starting subtest: basic-files
[613.915315] Subtest basic-files: SUCCESS (2.010s)
[615.500934] [125/133] (416s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[615.742215] Starting subtest: cursor-rapid-movement-256x256
[615.747746] Starting dynamic subtest: pipe-A-eDP-1
[616.299203] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.553s)
[616.329898] Starting dynamic subtest: pipe-D-eDP-1
[617.600568] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.278s)
[617.601516] Subtest cursor-rapid-movement-256x256: SUCCESS (1.858s)
[618.414082] [126/133] (413s left) kms_chamelium_frames (dp-frame-dump)
[618.785309] Subtest dp-frame-dump: SKIP (0.000s)
[619.619197] [127/133] (412s left) gem_mmap_gtt (medium-copy)
[619.677686] Subtest medium-copy: SKIP (0.000s)
[619.730919] [128/133] (412s left) gem_ctx_param (invalid-param-set)
[619.807678] Starting subtest: invalid-param-set
[619.808843] Subtest invalid-param-set: SUCCESS (0.000s)
[619.875578] [129/133] (412s left) kms_psr (fbc-psr2-sprite-plane-move)
[619.962832] Starting subtest: fbc-psr2-sprite-plane-move
[619.963622] Starting dynamic subtest: eDP-1
[619.965468] Dynamic subtest eDP-1: SKIP (0.000s)
[619.967038] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[620.032751] [130/133] (412s left) gem_exec_balancer (full-pulse)
[620.101157] Starting subtest: full-pulse
[624.390500] Subtest full-pulse: SUCCESS (4.287s)
[624.725817] [131/133] (407s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[624.830175] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[624.831912] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[624.921098] [132/133] (407s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[625.064690] Starting subtest: flip-vs-cursor-crc-atomic
[625.776359] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.711s)
[626.572373] [133/133] (406s left) kms_vblank (invalid)
[626.650189] Starting subtest: invalid
[626.651203] Starting dynamic subtest: pipe-A-eDP-1
[627.054441] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.404s)
[627.055301] Subtest invalid: SUCCESS (0.405s)
[627.894765] Closing watchdogs
results: parsing output: 0/ for test: i915_drm_fdinfo
results: parsing output: 1/ for test: kms_hdr
results: parsing output: 2/ for test: gem_ctx_param
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_render_copy
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: i915_pm_rps
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_rotation_crc
results: parsing output: 10/ for test: syncobj_wait
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: kms_vblank
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: gem_mmap_gtt
results: parsing output: 16/ for test: gem_ctx_param
results: parsing output: 17/ for test: gem_tiled_fence_blits
results: parsing output: 18/ for test: gem_linear_blits
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: kms_plane_scaling
results: parsing output: 21/ for test: kms_pm_rpm
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: kms_flip_scaled_crc
results: parsing output: 24/ for test: gem_ctx_param
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: gem_ctx_persistence
results: parsing output: 28/ for test: kms_flip_scaled_crc
results: parsing output: 29/ for test: kms_plane_scaling
results: parsing output: 30/ for test: kms_flip
results: parsing output: 31/ for test: gem_exec_parallel
results: parsing output: 32/ for test: gem_exec_alignment
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: kms_vrr
results: parsing output: 35/ for test: i915_module_load
results: parsing output: 36/ for test: gem_vm_create
results: parsing output: 37/ for test: kms_ccs
results: parsing output: 38/ for test: kms_dsc
results: parsing output: 39/ for test: kms_flip
results: parsing output: 40/ for test: gem_exec_schedule
results: parsing output: 41/ for test: gem_exec_schedule
results: parsing output: 42/ for test: gem_close
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_plane_alpha_blend
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: dmabuf_sync_file
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_mmap_gtt
results: parsing output: 50/ for test: gem_exec_fence
results: parsing output: 51/ for test: gem_userptr_blits
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_busy
results: parsing output: 54/ for test: gem_readwrite
results: parsing output: 55/ for test: gem_exec_whisper
results: parsing output: 56/ for test: gem_mmap_offset
results: parsing output: 57/ for test: kms_plane
results: parsing output: 58/ for test: api_intel_allocator
results: parsing output: 59/ for test: gem_mmap
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: i915_query
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: gem_render_copy
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: gem_create
results: parsing output: 66/ for test: gem_barrier_race
results: parsing output: 67/ for test: kms_prop_blob
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_mmap_gtt
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: syncobj_timeline
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: kms_getfb
results: parsing output: 76/ for test: kms_addfb_basic
results: parsing output: 77/ for test: gem_partial_pwrite_pread
results: parsing output: 78/ for test: kms_content_protection
results: parsing output: 79/ for test: kms_cursor_edge_walk
results: parsing output: 80/ for test: kms_pm_rpm
results: parsing output: 81/ for test: kms_atomic
results: parsing output: 82/ for test: kms_async_flips
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_plane_cursor
results: parsing output: 85/ for test: i915_pm_rps
results: parsing output: 86/ for test: kms_addfb_basic
results: parsing output: 87/ for test: gem_exec_whisper
results: parsing output: 88/ for test: perf
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: gem_exec_reloc
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: gem_close_race
results: parsing output: 93/ for test: gen9_exec_parse
results: parsing output: 94/ for test: gem_exec_fence
results: parsing output: 95/ for test: gem_exec_nop
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_pipe_b_c_ivb
results: parsing output: 99/ for test: kms_fence_pin_leak
results: parsing output: 100/ for test: prime_busy
results: parsing output: 101/ for test: kms_chamelium_hpd
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_unref_active_buffers
results: parsing output: 104/ for test: kms_rmfb
results: parsing output: 105/ for test: gem_exec_reloc
results: parsing output: 106/ for test: kms_cursor_crc
results: parsing output: 107/ for test: kms_debugfs
results: parsing output: 108/ for test: perf_pmu
results: parsing output: 109/ for test: gem_exec_balancer
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: perf
results: parsing output: 112/ for test: kms_fbcon_fbt
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_lease
results: parsing output: 115/ for test: kms_chamelium_color
results: parsing output: 116/ for test: gem_softpin
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: perf
results: parsing output: 119/ for test: core_auth
results: parsing output: 120/ for test: kms_color
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_ccs
results: parsing output: 123/ for test: gem_ctx_create
results: parsing output: 124/ for test: kms_cursor_crc
results: parsing output: 125/ for test: kms_chamelium_frames
results: parsing output: 126/ for test: gem_mmap_gtt
results: parsing output: 127/ for test: gem_ctx_param
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: gem_exec_balancer
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_cursor_legacy
results: parsing output: 132/ for test: kms_vblank
Done.