[57.707768] Initializing watchdogs
[57.707813]   /dev/watchdog0
[57.723654] [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]
[57.728204] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.730492] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.733933] [001/133] (960s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[57.818854] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[57.821191] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[57.932605] [002/133] (960s left) kms_color (ctm-max)
[58.035098] Starting subtest: ctm-max
[58.036942] Starting dynamic subtest: pipe-A-eDP-1
[58.821411] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.784s)
[58.831068] Starting dynamic subtest: pipe-B-eDP-1
[60.210858] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.387s)
[60.219645] Starting dynamic subtest: pipe-C-eDP-1
[61.593228] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.382s)
[61.601774] Starting dynamic subtest: pipe-D-eDP-1
[62.928100] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.332s)
[62.930470] Subtest ctm-max: SUCCESS (4.886s)
[63.727945] [003/133] (954s left) gem_eio (in-flight-1us)
[63.894056] Starting subtest: in-flight-1us
[71.848099] Subtest in-flight-1us: SUCCESS (7.949s)
[71.974617] [FACT gem_eio (in-flight-1us)] new: kernel.kmod_is_loaded.vgem: true
[71.977912] [004/133] (946s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[72.100963] Starting subtest: basic-busy-flip-before-cursor-legacy
[72.105575] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[72.257134] [005/133] (946s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[72.363978] Starting subtest: fbc-psr2-sprite-plane-onoff
[72.366376] Starting dynamic subtest: eDP-1
[72.370577] Dynamic subtest eDP-1: SKIP (0.000s)
[72.374792] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.000s)
[72.435139] [006/133] (945s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[72.528149] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[72.530510] Starting dynamic subtest: pipe-A-eDP-1
[72.686488] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.150s)
[72.696418] Starting dynamic subtest: pipe-B-eDP-1
[72.712206] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.014s)
[72.719922] Starting dynamic subtest: pipe-C-eDP-1
[72.736589] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[72.744084] Starting dynamic subtest: pipe-D-eDP-1
[72.760589] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[72.762114] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.190s)
[75.002997] [007/133] (943s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[75.104775] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[75.109068] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[75.186558] [008/133] (943s left) kms_flip (flip-vs-panning)
[75.295406] Starting subtest: flip-vs-panning
[75.297494] Starting dynamic subtest: A-eDP1
[84.023589] Dynamic subtest A-eDP1: SUCCESS (8.729s)
[84.036937] Starting dynamic subtest: B-eDP1
[92.759461] Dynamic subtest B-eDP1: SUCCESS (8.733s)
[92.769721] Starting dynamic subtest: C-eDP1
[101.483616] Dynamic subtest C-eDP1: SUCCESS (8.722s)
[101.491626] Starting dynamic subtest: D-eDP1
[110.221343] Dynamic subtest D-eDP1: SUCCESS (8.736s)
[110.225313] Subtest flip-vs-panning: SUCCESS (34.930s)
[111.388966] [009/133] (907s left) gem_exec_fence (submit3)
[111.574695] Starting subtest: submit3
[111.579682] Subtest submit3: SKIP (0.000s)
[112.976473] [010/133] (905s left) api_intel_allocator (gem-pool)
[113.030919] Starting subtest: gem-pool
[113.036745] Subtest gem-pool: SUCCESS (0.008s)
[113.146983] [011/133] (905s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[113.194943] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[113.249372] [012/133] (905s left) i915_pm_rpm (sysfs-read)
[115.077413] Starting subtest: sysfs-read
[116.229680] Subtest sysfs-read: SUCCESS (1.150s)
[116.608201] [013/133] (902s left) kms_cursor_crc (cursor-onscreen-64x64)
[116.789919] Starting subtest: cursor-onscreen-64x64
[116.792292] Starting dynamic subtest: pipe-A-eDP-1
[118.896631] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.101s)
[118.922452] Starting dynamic subtest: pipe-D-eDP-1
[121.684438] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.767s)
[121.686617] Subtest cursor-onscreen-64x64: SUCCESS (4.893s)
[122.560625] [014/133] (896s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[122.651405] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[122.655586] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[122.743230] [015/133] (896s left) gem_userptr_blits (forbidden-operations)
[122.808874] Starting subtest: forbidden-operations
[122.813372] Subtest forbidden-operations: SKIP (0.000s)
[122.927223] [016/133] (895s left) kms_big_fb (linear-64bpp-rotate-270)
[123.022682] Starting subtest: linear-64bpp-rotate-270
[123.041668] Subtest linear-64bpp-rotate-270: SKIP (0.019s)
[123.143819] [017/133] (895s left) kms_atomic_transition (plane-all-transition)
[123.240918] Starting subtest: plane-all-transition
[123.243237] Starting dynamic subtest: pipe-A-eDP-1
[125.734440] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[126.057426] Starting dynamic subtest: pipe-B-eDP-1
[129.298326] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.248s)
[129.598170] Subtest plane-all-transition: SUCCESS (6.357s)
[130.436036] [018/133] (888s left) api_intel_bb (reset-flags)
[130.503495] Starting subtest: reset-flags
[130.508315] Subtest reset-flags: SUCCESS (0.007s)
[130.631110] [019/133] (888s left) gem_sync (basic-many-each)
[130.699911] Starting subtest: basic-many-each
[132.974022] Subtest basic-many-each: SUCCESS (2.284s)
[133.160318] [020/133] (885s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[133.260405] Starting subtest: yf-tiled-8bpp-rotate-0
[133.264414] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[133.357907] [021/133] (885s left) gem_exec_balancer (nohangcheck)
[133.625790] Starting subtest: nohangcheck
[134.535191] Subtest nohangcheck: SUCCESS (0.908s)
[134.643447] [022/133] (884s left) kms_plane_alpha_blend (alpha-7efc)
[134.731380] Starting subtest: alpha-7efc
[135.021450] Starting dynamic subtest: pipe-A-eDP-1
[135.624780] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.603s)
[135.656095] Starting dynamic subtest: pipe-D-eDP-1
[136.954942] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.305s)
[136.957412] Subtest alpha-7efc: SUCCESS (2.223s)
[137.808952] [023/133] (881s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[137.907215] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[137.911536] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[138.007195] [024/133] (881s left) gem_softpin (evict-snoop-interruptible)
[138.060607] Starting subtest: evict-snoop-interruptible
[138.065312] Subtest evict-snoop-interruptible: SKIP (0.000s)
[138.131592] [025/133] (881s left) kms_hdmi_inject (inject-audio)
[138.466030] Starting subtest: inject-audio
[138.746311] Subtest inject-audio: SUCCESS (0.281s)
[139.380411] [026/133] (879s left) gem_bad_reloc (negative-reloc-bltcopy)
[139.437169] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[139.518228] [027/133] (879s left) gem_userptr_blits (unsync-overlap)
[139.582227] Subtest unsync-overlap: SKIP (0.000s)
[139.719971] [028/133] (879s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[139.835823] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[139.840451] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[139.981230] [029/133] (879s left) gem_eio (in-flight-internal-immediate)
[140.208336] Starting subtest: in-flight-internal-immediate
[141.989714] Subtest in-flight-internal-immediate: SUCCESS (1.781s)
[142.122226] [030/133] (877s left) kms_pm_backlight (brightness-with-dpms)
[142.210861] Starting subtest: brightness-with-dpms
[142.262348] Starting dynamic subtest: eDP-1
[144.677869] Dynamic subtest eDP-1: SUCCESS (2.413s)
[144.680130] Subtest brightness-with-dpms: SUCCESS (2.466s)
[145.553491] [031/133] (873s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[145.609555] Starting subtest: y-tiled-ccs-to-yf-tiled
[145.613736] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[145.793990] [032/133] (873s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[145.892311] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[145.896620] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[145.997979] [033/133] (873s left) dmabuf_sync_file (import-multiple-read-only)
[146.037048] Starting subtest: import-multiple-read-only
[146.038945] Subtest import-multiple-read-only: SUCCESS (0.003s)
[146.092675] [034/133] (873s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[146.145804] Starting subtest: framebuffer-vs-set-tiling
[146.150146] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[146.306937] [035/133] (873s left) gem_exec_capture (userptr)
[146.359745] Starting subtest: userptr
[147.196036] Subtest userptr: SUCCESS (0.837s)
[147.319495] [036/133] (872s left) fbdev (nullptr)
[147.357337] Starting subtest: nullptr
[147.359926] Subtest nullptr: SUCCESS (0.000s)
[147.422734] [037/133] (872s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[147.528281] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[152.912027] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.387s)
[154.089164] [038/133] (865s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[154.181071] Starting subtest: x-tiled-64bpp-rotate-270
[154.201084] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s)
[154.314540] [039/133] (865s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[154.407603] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[154.411716] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[154.492238] [040/133] (865s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[154.575169] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[154.579544] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[154.649984] [041/133] (865s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[154.743192] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[154.747251] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[154.814469] [042/133] (865s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[154.879332] Subtest writes-after-reads-uncached: SKIP (0.000s)
[154.942993] [043/133] (865s left) kms_hdr (static-toggle-dpms)
[155.028406] Starting subtest: static-toggle-dpms
[155.033474] Subtest static-toggle-dpms: SKIP (0.000s)
[155.101556] [044/133] (864s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[155.157533] Starting subtest: etime-multi-wait-for-submit-submitted
[155.265235] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.106s)
[155.339321] [045/133] (864s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[155.431767] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[155.436069] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[155.546250] [046/133] (864s left) perf_pmu (idle)
[155.587840] Starting subtest: idle
[155.590005] Starting dynamic subtest: rcs0
[156.134130] Dynamic subtest rcs0: SUCCESS (0.543s)
[156.142685] Starting dynamic subtest: bcs0
[156.645788] Dynamic subtest bcs0: SUCCESS (0.515s)
[156.655798] Starting dynamic subtest: vcs0
[157.171730] Dynamic subtest vcs0: SUCCESS (0.518s)
[157.182401] Starting dynamic subtest: vcs1
[157.689821] Dynamic subtest vcs1: SUCCESS (0.520s)
[157.702968] Starting dynamic subtest: vecs0
[158.208864] Dynamic subtest vecs0: SUCCESS (0.516s)
[158.220448] Starting dynamic subtest: ccs0
[158.729234] Dynamic subtest ccs0: SUCCESS (0.517s)
[158.732122] Subtest idle: SUCCESS (3.143s)
[158.828184] [047/133] (861s left) kms_chamelium_color (degamma)
[158.922224] Subtest degamma: SKIP (0.000s)
[158.968282] [048/133] (861s left) gem_pxp (create-regular-context-2)
[159.090037] Starting subtest: create-regular-context-2
[159.092725] Subtest create-regular-context-2: SUCCESS (0.002s)
[159.196358] [049/133] (861s left) gem_softpin (allocator-basic-reserve)
[159.253602] Starting subtest: allocator-basic-reserve
[159.325264] Subtest allocator-basic-reserve: SUCCESS (0.071s)
[159.460083] [050/133] (860s left) kms_plane_multiple (2x-tiling-none)
[159.548988] Starting subtest: 2x-tiling-none
[159.553142] Subtest 2x-tiling-none: SKIP (0.000s)
[159.622240] [051/133] (860s left) kms_feature_discovery (psr1)
[159.717167] Starting subtest: psr1
[159.719459] Subtest psr1: SUCCESS (0.000s)
[159.789811] [052/133] (860s left) kms_getfb (getfb-handle-protection)
[159.888458] Starting subtest: getfb-handle-protection
[159.906274] Subtest getfb-handle-protection: SUCCESS (0.018s)
[160.009804] [053/133] (860s left) kms_prop_blob (blob-prop-core)
[160.071716] Starting subtest: blob-prop-core
[160.073898] Subtest blob-prop-core: SUCCESS (0.000s)
[160.176947] [054/133] (860s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[160.257755] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[160.259673] Starting dynamic subtest: pipe-A
[161.316792] Dynamic subtest pipe-A: SUCCESS (1.061s)
[161.324999] Starting dynamic subtest: pipe-B
[163.465432] Dynamic subtest pipe-B: SUCCESS (2.148s)
[163.473782] Starting dynamic subtest: pipe-C
[164.664903] Dynamic subtest pipe-C: SUCCESS (1.198s)
[164.673658] Starting dynamic subtest: pipe-D
[165.903369] Dynamic subtest pipe-D: SUCCESS (1.238s)
[165.905651] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.648s)
[167.104857] [055/133] (853s left) gem_create (create-size-update)
[167.158989] Starting subtest: create-size-update
[167.161175] Subtest create-size-update: SUCCESS (0.000s)
[167.369219] [056/133] (853s left) syncobj_timeline (transfer-timeline-point)
[167.426384] Starting subtest: transfer-timeline-point
[167.428557] Subtest transfer-timeline-point: SUCCESS (0.000s)
[167.519908] [057/133] (853s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[167.612369] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[167.614540] Starting dynamic subtest: pipe-A-eDP-1
[168.127645] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.488s)
[168.138983] Starting dynamic subtest: pipe-B-eDP-1
[169.577171] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.447s)
[169.587485] Starting dynamic subtest: pipe-C-eDP-1
[170.919897] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.342s)
[170.931064] Starting dynamic subtest: pipe-D-eDP-1
[172.250296] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.329s)
[172.252610] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.612s)
[173.427180] [058/133] (847s left) vgem_basic (dmabuf-fence)
[173.468911] Starting subtest: dmabuf-fence
[173.471243] Subtest dmabuf-fence: SUCCESS (0.001s)
[173.544082] [059/133] (847s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[173.640638] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[173.644967] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[173.749721] [060/133] (846s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[173.840020] Starting subtest: random-ccs-data-y-tiled-ccs
[173.842149] Starting dynamic subtest: pipe-A-eDP-1
[173.865986] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[173.875400] Starting dynamic subtest: pipe-B-eDP-1
[173.897134] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[173.905573] Starting dynamic subtest: pipe-C-eDP-1
[173.928533] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[173.937038] Starting dynamic subtest: pipe-D-eDP-1
[173.960555] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[173.964886] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.005s)
[175.998085] [061/133] (844s left) kms_addfb_basic (bad-pitch-63)
[176.058148] Starting subtest: bad-pitch-63
[176.060307] Subtest bad-pitch-63: SUCCESS (0.000s)
[176.192747] [062/133] (844s left) gem_exec_schedule (u-semaphore-user)
[176.257750] Starting subtest: u-semaphore-user
[176.309390] Subtest u-semaphore-user: SUCCESS (0.059s)
[177.993694] [063/133] (842s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[178.106669] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[178.108899] Starting dynamic subtest: pipe-A-eDP-1
[178.191433] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[178.200671] Starting dynamic subtest: pipe-B-eDP-1
[179.372763] Dynamic subtest pipe-B-eDP-1: SKIP (1.179s)
[179.377051] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.270s)
[180.559834] [064/133] (840s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[180.661637] Starting subtest: extended-modeset-hang-oldfb-with-reset
[180.663916] Starting dynamic subtest: pipe-A
[192.441271] Dynamic subtest pipe-A: SUCCESS (11.778s)
[192.451565] Starting dynamic subtest: pipe-D
[204.712865] Dynamic subtest pipe-D: SUCCESS (12.269s)
[204.715604] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.051s)
[205.510433] [065/133] (815s left) gem_mmap_gtt (cpuset-big-copy-xy)
[205.580230] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[205.648417] [066/133] (815s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[205.756626] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[216.934193] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.177s)
[217.746432] [067/133] (803s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[217.849862] Starting subtest: basic-modeset-with-all-modifiers-formats
[218.227919] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[219.028063] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.803s)
[219.037655] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[219.049814] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[219.058657] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[219.071745] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.021s)
[219.083878] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[219.216551] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.144s)
[219.226164] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[219.238610] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[219.247655] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[219.260788] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.021s)
[219.269787] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[219.283311] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.021s)
[219.292111] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[219.305593] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[219.315415] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[219.327643] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[219.336537] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[219.349893] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[219.358762] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[219.371822] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[219.380519] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[219.394252] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.021s)
[219.403224] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[219.560971] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.166s)
[219.573224] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[219.583169] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[219.592058] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[219.605362] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s)
[219.613981] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[219.627629] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.021s)
[219.635995] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[219.649905] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[219.658352] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[219.672122] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.021s)
[219.680485] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[219.694279] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.021s)
[219.702597] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[219.716715] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[219.725078] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[219.738841] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.021s)
[219.747305] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[219.894740] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s)
[219.908251] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[219.916905] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[219.925849] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[219.939177] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.021s)
[219.947916] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[219.961041] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.021s)
[219.969991] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[219.983615] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[219.992314] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[220.005859] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.021s)
[220.015295] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[220.027782] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.021s)
[220.036604] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[220.049884] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.021s)
[220.057941] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[220.072202] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.021s)
[220.453136] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.606s)
[221.305110] [068/133] (799s left) i915_query (query-regions-sanity-check)
[221.378895] Starting subtest: query-regions-sanity-check
[221.389372] Subtest query-regions-sanity-check: SUCCESS (0.012s)
[221.480589] [069/133] (799s left) gem_exec_whisper (basic-normal-all)
[221.545267] Starting subtest: basic-normal-all
[223.916773] Subtest basic-normal-all: SUCCESS (2.371s)
[224.127272] [070/133] (796s left) gem_mmap_offset (blt-coherency)
[224.187929] Starting subtest: blt-coherency
[224.196093] Subtest blt-coherency: SUCCESS (0.011s)
[224.307744] [071/133] (796s left) kms_flip (flip-vs-suspend)
[224.400222] Starting subtest: flip-vs-suspend
[224.402581] Starting dynamic subtest: A-eDP1
[258.768161] Dynamic subtest A-eDP1: SUCCESS (5.136s)
[258.779650] Starting dynamic subtest: B-eDP1
[293.794748] Dynamic subtest B-eDP1: SUCCESS (4.221s)
[293.811098] Starting dynamic subtest: C-eDP1
[327.785888] Dynamic subtest C-eDP1: SUCCESS (4.193s)
[327.799588] Starting dynamic subtest: D-eDP1
[361.801925] Dynamic subtest D-eDP1: SUCCESS (4.218s)
[361.803999] Subtest flip-vs-suspend: SUCCESS (17.778s)
[373.002215] [072/133] (658s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[373.136395] Starting subtest: basic-busy-flip-before-cursor-atomic
[373.140828] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[373.299868] [073/133] (657s left) kms_psr (psr-cursor-blt)
[373.391213] Starting subtest: psr-cursor-blt
[373.393515] Starting dynamic subtest: eDP-1
[375.095925] Dynamic subtest eDP-1: SUCCESS (1.686s)
[375.098117] Subtest psr-cursor-blt: SUCCESS (1.687s)
[375.979693] [074/133] (655s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[376.074988] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[376.077292] Starting dynamic subtest: pipe-A-eDP-1
[387.432238] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.316s)
[387.446275] Starting dynamic subtest: pipe-B-eDP-1
[399.448928] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.995s)
[399.451495] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.317s)
[400.293955] [075/133] (631s left) gem_exec_reloc (basic-write-read-active)
[400.358825] Subtest basic-write-read-active: SKIP (0.000s)
[400.442651] [076/133] (630s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[400.541487] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[405.101881] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.562s)
[406.248224] [077/133] (625s left) kms_flip (2x-nonexisting-fb)
[406.349050] Starting subtest: 2x-nonexisting-fb
[406.357629] Subtest 2x-nonexisting-fb: SKIP (0.011s)
[406.461942] [078/133] (625s left) gem_ctx_isolation (preservation-reset)
[406.633582] Starting subtest: preservation-reset
[406.636112] Starting dynamic subtest: rcs0
[406.913670] Dynamic subtest rcs0: SUCCESS (0.284s)
[406.924797] Starting dynamic subtest: bcs0
[407.239274] Dynamic subtest bcs0: SUCCESS (0.324s)
[407.254071] Starting dynamic subtest: vcs0
[407.571811] Dynamic subtest vcs0: SUCCESS (0.332s)
[407.584110] Starting dynamic subtest: vcs1
[408.830532] Dynamic subtest vcs1: SUCCESS (1.258s)
[408.840679] Starting dynamic subtest: vecs0
[410.837500] Dynamic subtest vecs0: SUCCESS (2.006s)
[410.847734] Starting dynamic subtest: ccs0
[412.820879] Dynamic subtest ccs0: SUCCESS (1.982s)
[412.823062] Subtest preservation-reset: SUCCESS (6.195s)
[412.968615] [079/133] (618s left) syncobj_eventfd (invalid-bad-pad)
[413.032628] Starting subtest: invalid-bad-pad
[413.034887] Subtest invalid-bad-pad: SUCCESS (0.000s)
[413.123445] [080/133] (618s left) kms_universal_plane (cursor-fb-leak)
[413.225347] Starting subtest: cursor-fb-leak
[413.227744] Starting dynamic subtest: pipe-A-eDP-1
[413.587654] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.363s)
[413.603456] Starting dynamic subtest: pipe-B-eDP-1
[414.971645] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.381s)
[414.987901] Starting dynamic subtest: pipe-C-eDP-1
[416.362836] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.387s)
[416.375977] Starting dynamic subtest: pipe-D-eDP-1
[417.803668] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.439s)
[417.806111] Subtest cursor-fb-leak: SUCCESS (4.581s)
[418.957140] [081/133] (612s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[419.082694] Starting subtest: cursor-vs-flip-varying-size
[450.352611] Subtest cursor-vs-flip-varying-size: SUCCESS (31.261s)
[451.197180] [082/133] (580s left) prime_busy (hang)
[451.280443] Starting subtest: hang
[451.282818] Starting dynamic subtest: rcs0
[477.043699] Dynamic subtest rcs0: SUCCESS (25.756s)
[477.054066] Starting dynamic subtest: bcs0
[484.202167] Dynamic subtest bcs0: SUCCESS (7.161s)
[484.213277] Starting dynamic subtest: vcs0
[491.175992] Dynamic subtest vcs0: SUCCESS (6.973s)
[491.188771] Starting dynamic subtest: vcs1
[498.214982] Dynamic subtest vcs1: SUCCESS (7.038s)
[498.227742] Starting dynamic subtest: vecs0
[505.189820] Dynamic subtest vecs0: SUCCESS (6.973s)
[505.202639] Starting dynamic subtest: ccs0
[519.033597] Dynamic subtest ccs0: SUCCESS (13.837s)
[519.036198] Subtest hang: SUCCESS (67.745s)
[519.148027] [083/133] (512s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[519.209637] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[519.211897] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[519.305335] [084/133] (512s left) gem_exec_balancer (parallel-keep-in-fence)
[519.560033] Starting subtest: parallel-keep-in-fence
[520.767107] Subtest parallel-keep-in-fence: SUCCESS (1.210s)
[520.875597] [085/133] (510s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[520.971791] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[520.976190] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[521.048781] [086/133] (510s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[521.165838] Starting subtest: flip-vs-cursor-legacy
[528.618114] Subtest flip-vs-cursor-legacy: SUCCESS (7.450s)
[529.427256] [087/133] (502s left) i915_hangman (gt-engine-error)
[529.494061] Starting subtest: gt-engine-error
[529.495939] Starting dynamic subtest: rcs0
[531.518107] Dynamic subtest rcs0: SUCCESS (2.023s)
[531.531117] Starting dynamic subtest: bcs0
[533.501299] Dynamic subtest bcs0: SUCCESS (1.980s)
[533.514171] Starting dynamic subtest: vcs0
[535.485127] Dynamic subtest vcs0: SUCCESS (1.981s)
[535.498726] Starting dynamic subtest: vcs1
[537.469132] Dynamic subtest vcs1: SUCCESS (1.981s)
[537.482424] Starting dynamic subtest: vecs0
[539.517277] Dynamic subtest vecs0: SUCCESS (2.045s)
[539.530835] Starting dynamic subtest: ccs0
[541.501590] Dynamic subtest ccs0: SUCCESS (1.980s)
[541.504778] Subtest gt-engine-error: SUCCESS (12.007s)
[541.633001] [088/133] (490s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[541.737836] Starting subtest: 4-tiled-64bpp-rotate-0
[543.338747] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.600s)
[543.521423] [089/133] (488s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[543.632685] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[543.636816] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[543.733401] [090/133] (488s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[543.855187] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[544.718037] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.863s)
[544.895847] [091/133] (487s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[544.976319] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[545.100944] [092/133] (487s left) prime_self_import (basic-with_one_bo_two_files)
[545.139502] Starting subtest: basic-with_one_bo_two_files
[545.161787] Subtest basic-with_one_bo_two_files: SUCCESS (0.022s)
[545.255311] [093/133] (486s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[545.302094] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[545.352250] [094/133] (486s left) gem_exec_params (invalid-batch-start-offset)
[545.408689] Starting subtest: invalid-batch-start-offset
[545.411157] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[545.536476] [095/133] (486s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[545.636323] Starting subtest: y-tiled-8bpp-rotate-270
[545.639839] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[545.726411] [096/133] (486s left) gem_eio (create)
[545.939171] Starting subtest: create
[546.267394] Subtest create: SUCCESS (0.328s)
[546.385216] [097/133] (485s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[546.476500] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[546.478422] Starting dynamic subtest: pipe-A-eDP-1
[546.497656] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[546.509010] Starting dynamic subtest: pipe-B-eDP-1
[546.526963] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[546.536844] Starting dynamic subtest: pipe-C-eDP-1
[546.554608] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[546.564115] Starting dynamic subtest: pipe-D-eDP-1
[546.583488] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[546.587106] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[548.713989] [098/133] (483s left) kms_psr (pr-primary-blt)
[548.799114] Starting subtest: pr-primary-blt
[548.803497] Subtest pr-primary-blt: SKIP (0.000s)
[548.901207] [099/133] (483s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[549.161369] Starting subtest: cursor-rapid-movement-256x256
[549.166219] Starting dynamic subtest: pipe-A-eDP-1
[549.718552] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.552s)
[549.751004] Starting dynamic subtest: pipe-D-eDP-1
[550.929167] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.188s)
[550.931490] Subtest cursor-rapid-movement-256x256: SUCCESS (1.767s)
[551.773974] [100/133] (480s left) gem_exec_params (sol-reset-invalid)
[551.843293] Starting subtest: sol-reset-invalid
[551.845627] Subtest sol-reset-invalid: SUCCESS (0.002s)
[553.566693] [101/133] (478s left) gem_exec_params (invalid-fence-in)
[553.622420] Starting subtest: invalid-fence-in
[553.624894] Subtest invalid-fence-in: SUCCESS (0.000s)
[553.740536] [102/133] (478s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[553.842722] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[553.846771] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[553.941900] [103/133] (478s left) syncobj_wait (wait-all-complex)
[554.002923] Starting subtest: wait-all-complex
[554.216745] Subtest wait-all-complex: SUCCESS (0.213s)
[554.307028] [104/133] (478s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[554.397953] Starting subtest: fbcpsr-rgb101010-draw-render
[561.172053] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.776s)
[561.298109] [105/133] (471s left) kms_lease (lease-unleased-connector)
[561.397116] Starting subtest: lease-unleased-connector
[561.399287] Starting dynamic subtest: pipe-A-eDP-1
[561.401508] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[561.416307] Starting dynamic subtest: pipe-B-eDP-1
[561.418628] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s)
[561.429620] Starting dynamic subtest: pipe-C-eDP-1
[561.431509] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[561.441090] Starting dynamic subtest: pipe-D-eDP-1
[561.442956] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.006s)
[561.444917] Subtest lease-unleased-connector: SUCCESS (0.029s)
[561.556562] [106/133] (471s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[561.947708] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[562.737291] [107/133] (470s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[562.836427] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[566.775311] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (3.940s)
[567.957460] [108/133] (464s left) kms_fbcon_fbt (fbc)
[568.020934] Starting subtest: fbc
[574.405071] Subtest fbc: SUCCESS (6.382s)
[575.483608] [109/133] (457s left) kms_vblank (wait-idle-hang)
[575.569096] Starting subtest: wait-idle-hang
[575.571378] Starting dynamic subtest: pipe-A-eDP-1
[602.265155] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.691s)
[602.280332] Starting dynamic subtest: pipe-D-eDP-1
[617.318824] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.057s)
[617.321225] Subtest wait-idle-hang: SUCCESS (41.752s)
[618.167746] [110/133] (414s left) kms_cursor_edge_walk (256x256-top-edge)
[618.282006] Starting subtest: 256x256-top-edge
[618.284298] Starting dynamic subtest: pipe-A-eDP-1
[621.719071] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.435s)
[621.730276] Starting dynamic subtest: pipe-D-eDP-1
[624.853603] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.134s)
[624.855990] Subtest 256x256-top-edge: SUCCESS (6.572s)
[625.653921] [111/133] (407s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[625.720293] Starting subtest: multi-wait-all-for-submit-available-signaled
[625.722179] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[625.817248] [112/133] (407s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[625.905139] Starting subtest: fbc-psr2-cursor-plane-onoff
[625.907307] Starting dynamic subtest: eDP-1
[625.911257] Dynamic subtest eDP-1: SKIP (0.000s)
[625.915269] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[625.980994] [113/133] (407s left) kms_pm_rpm (modeset-lpsp)
[627.711848] Starting subtest: modeset-lpsp
[629.167266] Subtest modeset-lpsp: SUCCESS (1.460s)
[629.271717] [114/133] (403s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[629.390716] Starting subtest: cursorB-vs-flipB-atomic
[629.395338] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[629.549640] [115/133] (403s left) kms_vrr (seamless-rr-switch-drrs)
[629.644167] Starting subtest: seamless-rr-switch-drrs
[629.650982] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[629.729327] [116/133] (403s left) gem_exec_params (dr4-dirt)
[629.786637] Starting subtest: DR4-dirt
[629.788646] Subtest DR4-dirt: SUCCESS (0.000s)
[629.921373] [117/133] (403s left) gem_exec_schedule (preempt-other-chain)
[629.992100] Starting subtest: preempt-other-chain
[629.994351] Starting dynamic subtest: rcs0
[630.066370] Dynamic subtest rcs0: SUCCESS (0.081s)
[630.080738] Starting dynamic subtest: bcs0
[630.143926] Dynamic subtest bcs0: SUCCESS (0.078s)
[630.158973] Starting dynamic subtest: vcs0
[630.223560] Dynamic subtest vcs0: SUCCESS (0.078s)
[630.240592] Starting dynamic subtest: vcs1
[630.304107] Dynamic subtest vcs1: SUCCESS (0.081s)
[630.315606] Starting dynamic subtest: vecs0
[630.382555] Dynamic subtest vecs0: SUCCESS (0.077s)
[630.395847] Starting dynamic subtest: ccs0
[630.462297] Dynamic subtest ccs0: SUCCESS (0.079s)
[630.464548] Subtest preempt-other-chain: SUCCESS (0.479s)
[631.600435] [118/133] (401s left) i915_drm_fdinfo (memory-info-shared)
[631.645895] Starting subtest: memory-info-shared
[631.648116] Starting dynamic subtest: smem0
[631.700857] Dynamic subtest smem0: SUCCESS (0.057s)
[631.703763] Subtest memory-info-shared: SUCCESS (0.057s)
[631.792354] [119/133] (401s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[631.885065] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[638.556449] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.676s)
[638.704189] [120/133] (394s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[638.818619] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[645.851891] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.037s)
[645.967639] [121/133] (387s left) gem_ctx_persistence (legacy-engines-hostile)
[646.028659] Starting subtest: legacy-engines-hostile
[646.030954] Starting dynamic subtest: render
[646.138866] Dynamic subtest render: SUCCESS (0.109s)
[646.153512] Starting dynamic subtest: bsd1
[646.243599] Dynamic subtest bsd1: SUCCESS (0.102s)
[646.258890] Starting dynamic subtest: bsd2
[646.338557] Dynamic subtest bsd2: SUCCESS (0.092s)
[646.354201] Starting dynamic subtest: blt
[646.439994] Dynamic subtest blt: SUCCESS (0.099s)
[646.454073] Starting dynamic subtest: vebox
[646.534885] Dynamic subtest vebox: SUCCESS (0.092s)
[646.537462] Subtest legacy-engines-hostile: SUCCESS (0.507s)
[646.627646] [122/133] (386s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[646.734155] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[646.736420] Starting dynamic subtest: pipe-A-eDP-1
[646.758181] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[646.768591] Starting dynamic subtest: pipe-B-eDP-1
[646.786620] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[646.796141] Starting dynamic subtest: pipe-C-eDP-1
[646.813106] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[646.821806] Starting dynamic subtest: pipe-D-eDP-1
[646.839138] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[646.842506] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.005s)
[649.080800] [123/133] (384s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[649.133129] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[649.234884] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.101s)
[649.319693] [124/133] (384s left) gem_sync (basic-each)
[649.389642] Starting subtest: basic-each
[651.920347] Subtest basic-each: SUCCESS (2.541s)
[652.105087] [125/133] (381s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[652.226649] Starting subtest: cursor-vs-flip-atomic-transitions
[682.552394] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.324s)
[683.399551] [126/133] (350s left) gem_mmap_gtt (basic-small-copy-xy)
[683.476086] Subtest basic-small-copy-XY: SKIP (0.000s)
[683.541791] [127/133] (350s left) gem_pxp (reject-modify-context-protection-off-3)
[683.653541] Starting subtest: reject-modify-context-protection-off-3
[683.655850] Subtest reject-modify-context-protection-off-3: SUCCESS (0.001s)
[683.762070] [128/133] (349s left) sysfs_heartbeat_interval (nopreempt)
[683.820491] Starting subtest: nopreempt
[683.822656] Starting dynamic subtest: vecs0
[693.532565] Dynamic subtest vecs0: SUCCESS (9.710s)
[693.549914] Starting dynamic subtest: ccs0
[697.532902] Dynamic subtest ccs0: SUCCESS (3.997s)
[697.545552] Starting dynamic subtest: vcs0
[707.552251] Dynamic subtest vcs0: SUCCESS (10.017s)
[707.565675] Starting dynamic subtest: bcs0
[711.559693] Dynamic subtest bcs0: SUCCESS (4.003s)
[711.572192] Starting dynamic subtest: rcs0
[715.564410] Dynamic subtest rcs0: SUCCESS (4.002s)
[715.575576] Starting dynamic subtest: vcs1
[725.537937] Dynamic subtest vcs1: SUCCESS (9.969s)
[725.540566] Subtest nopreempt: SUCCESS (41.710s)
[725.619622] [129/133] (308s left) kms_content_protection (content-type-change)
[725.772676] Starting subtest: content-type-change
[725.777147] Subtest content-type-change: SKIP (0.000s)
[725.898097] [130/133] (307s left) kms_psr (psr-suspend)
[725.993133] Starting subtest: psr-suspend
[725.995236] Starting dynamic subtest: eDP-1
[744.210194] Dynamic subtest eDP-1: SUCCESS (3.318s)
[744.212340] Subtest psr-suspend: SUCCESS (3.319s)
[750.095559] [131/133] (288s left) gen9_exec_parse (batch-invalid-length)
[750.194554] Subtest batch-invalid-length: SKIP (0.000s)
[750.271233] [132/133] (288s left) kms_atomic_transition (modeset-transition)
[750.376749] Starting subtest: modeset-transition
[750.378912] Starting dynamic subtest: 1x-outputs
[761.249601] Dynamic subtest 1x-outputs: SUCCESS (10.891s)
[761.252113] Subtest modeset-transition: SUCCESS (10.893s)
[762.115962] [133/133] (276s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[762.217604] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[762.219883] Starting dynamic subtest: pipe-A-default-mode
[764.963539] Dynamic subtest pipe-A-default-mode: SUCCESS (2.749s)
[764.965879] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.750s)
[765.779831] Closing watchdogs
results: parsing output: 0/ for test: syncobj_wait
results: parsing output: 1/ for test: kms_color
results: parsing output: 2/ for test: gem_eio
results: parsing output: 3/ for test: kms_cursor_legacy
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: gem_exec_fence
results: parsing output: 9/ for test: api_intel_allocator
results: parsing output: 10/ for test: kms_pipe_b_c_ivb
results: parsing output: 11/ for test: i915_pm_rpm
results: parsing output: 12/ for test: kms_cursor_crc
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_userptr_blits
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_atomic_transition
results: parsing output: 17/ for test: api_intel_bb
results: parsing output: 18/ for test: gem_sync
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: gem_exec_balancer
results: parsing output: 21/ for test: kms_plane_alpha_blend
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_softpin
results: parsing output: 24/ for test: kms_hdmi_inject
results: parsing output: 25/ for test: gem_bad_reloc
results: parsing output: 26/ for test: gem_userptr_blits
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: gem_eio
results: parsing output: 29/ for test: kms_pm_backlight
results: parsing output: 30/ for test: gem_render_copy
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: dmabuf_sync_file
results: parsing output: 33/ for test: kms_addfb_basic
results: parsing output: 34/ for test: gem_exec_capture
results: parsing output: 35/ for test: fbdev
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_plane
results: parsing output: 40/ for test: kms_flip_scaled_crc
results: parsing output: 41/ for test: gem_partial_pwrite_pread
results: parsing output: 42/ for test: kms_hdr
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: perf_pmu
results: parsing output: 46/ for test: kms_chamelium_color
results: parsing output: 47/ for test: gem_pxp
results: parsing output: 48/ for test: gem_softpin
results: parsing output: 49/ for test: kms_plane_multiple
results: parsing output: 50/ for test: kms_feature_discovery
results: parsing output: 51/ for test: kms_getfb
results: parsing output: 52/ for test: kms_prop_blob
results: parsing output: 53/ for test: kms_plane_scaling
results: parsing output: 54/ for test: gem_create
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: vgem_basic
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: kms_addfb_basic
results: parsing output: 61/ for test: gem_exec_schedule
results: parsing output: 62/ for test: kms_psr2_sf
results: parsing output: 63/ for test: kms_busy
results: parsing output: 64/ for test: gem_mmap_gtt
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: kms_async_flips
results: parsing output: 67/ for test: i915_query
results: parsing output: 68/ for test: gem_exec_whisper
results: parsing output: 69/ for test: gem_mmap_offset
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: kms_cursor_legacy
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: kms_psr2_sf
results: parsing output: 74/ for test: gem_exec_reloc
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_flip
results: parsing output: 77/ for test: gem_ctx_isolation
results: parsing output: 78/ for test: syncobj_eventfd
results: parsing output: 79/ for test: kms_universal_plane
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: prime_busy
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: gem_exec_balancer
results: parsing output: 84/ for test: kms_plane
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: i915_hangman
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: gem_userptr_blits
results: parsing output: 91/ for test: prime_self_import
results: parsing output: 92/ for test: gem_lmem_swapping
results: parsing output: 93/ for test: gem_exec_params
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: gem_eio
results: parsing output: 96/ for test: kms_ccs
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: kms_cursor_crc
results: parsing output: 99/ for test: gem_exec_params
results: parsing output: 100/ for test: gem_exec_params
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: syncobj_wait
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_lease
results: parsing output: 105/ for test: kms_chamelium_hpd
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_fbcon_fbt
results: parsing output: 108/ for test: kms_vblank
results: parsing output: 109/ for test: kms_cursor_edge_walk
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: kms_pm_rpm
results: parsing output: 113/ for test: kms_cursor_legacy
results: parsing output: 114/ for test: kms_vrr
results: parsing output: 115/ for test: gem_exec_params
results: parsing output: 116/ for test: gem_exec_schedule
results: parsing output: 117/ for test: i915_drm_fdinfo
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gem_ctx_persistence
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: gem_sync
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: gem_mmap_gtt
results: parsing output: 126/ for test: gem_pxp
results: parsing output: 127/ for test: sysfs_heartbeat_interval
results: parsing output: 128/ for test: kms_content_protection
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: gen9_exec_parse
results: parsing output: 131/ for test: kms_atomic_transition
results: parsing output: 132/ for test: kms_flip_scaled_crc
Done.