[61.883026] Initializing watchdogs
[61.883139]   /dev/watchdog0
[61.898514] [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]
[61.902706] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.904864] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.907942] [001/133] (960s left) i915_drm_fdinfo (busy-idle)
[61.966949] Starting subtest: busy-idle
[61.968991] Starting dynamic subtest: rcs0
[61.981084] Dynamic subtest rcs0: SKIP (0.012s)
[61.989800] Starting dynamic subtest: bcs0
[61.998495] Dynamic subtest bcs0: SKIP (0.014s)
[62.005328] Starting dynamic subtest: vcs0
[62.009662] Dynamic subtest vcs0: SKIP (0.001s)
[62.015526] Starting dynamic subtest: vcs1
[62.019889] Dynamic subtest vcs1: SKIP (0.000s)
[62.026090] Starting dynamic subtest: vecs0
[62.030603] Dynamic subtest vecs0: SKIP (0.000s)
[62.036295] Starting dynamic subtest: ccs0
[62.040122] Dynamic subtest ccs0: SKIP (0.000s)
[62.044076] Subtest busy-idle: SKIP (0.029s)
[62.077174] [002/133] (960s left) kms_hdr (static-toggle-dpms)
[62.175687] Starting subtest: static-toggle-dpms
[62.182630] Subtest static-toggle-dpms: SKIP (0.000s)
[62.248078] [003/133] (960s left) gem_ctx_param (basic-default)
[62.311979] Starting subtest: basic-default
[62.314325] Subtest basic-default: SUCCESS (0.000s)
[62.378731] [004/133] (960s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[62.488283] Starting subtest: psr-rgb565-draw-mmap-wc
[69.361794] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.871s)
[69.482416] [005/133] (953s left) gem_render_copy (yf-tiled-ccs-to-linear)
[69.552229] Starting subtest: yf-tiled-ccs-to-linear
[69.556639] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[69.731107] [006/133] (952s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[69.837122] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[76.702247] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.866s)
[76.835042] [007/133] (945s left) i915_pm_rps (min-max-config-loaded)
[76.895463] Starting subtest: min-max-config-loaded
[76.899940] Subtest min-max-config-loaded: SKIP (0.001s)
[76.990448] [008/133] (945s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[77.091463] Starting subtest: fbcpsr-shrfb-scaledprimary
[82.940154] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.850s)
[83.088189] [009/133] (939s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[83.185832] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[90.198975] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.015s)
[90.321220] [010/133] (932s left) kms_rotation_crc (cursor-rotation-180)
[90.426988] Starting subtest: cursor-rotation-180
[91.974417] Subtest cursor-rotation-180: SUCCESS (1.548s)
[93.153885] [011/133] (929s left) syncobj_wait (reset-multiple-signaled)
[93.213863] Starting subtest: reset-multiple-signaled
[93.216259] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[93.317861] [012/133] (929s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[93.374818] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[93.377135] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s)
[93.473930] [013/133] (929s left) kms_psr (psr2-basic)
[93.565549] Starting subtest: psr2-basic
[93.567786] Starting dynamic subtest: eDP-1
[95.131483] Dynamic subtest eDP-1: SUCCESS (1.566s)
[95.133797] Subtest psr2-basic: SUCCESS (1.567s)
[95.924365] [014/133] (926s left) kms_vblank (ts-continuation-modeset)
[96.018388] Starting subtest: ts-continuation-modeset
[96.020400] Starting dynamic subtest: pipe-A-eDP-1
[97.492773] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.474s)
[97.506324] Starting dynamic subtest: pipe-D-eDP-1
[99.683174] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.188s)
[99.685142] Subtest ts-continuation-modeset: SUCCESS (3.665s)
[100.483182] [015/133] (922s left) syncobj_timeline (wait-for-submit-snapshot)
[100.541126] Starting subtest: wait-for-submit-snapshot
[100.622246] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[100.697384] [016/133] (922s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[100.761323] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[100.821256] [017/133] (922s left) gem_ctx_param (invalid-get-ringsize)
[100.880338] Starting subtest: invalid-get-ringsize
[100.882847] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[100.978303] [018/133] (922s left) gem_tiled_fence_blits (normal)
[101.034530] Subtest normal: SKIP (0.000s)
[101.102927] [019/133] (921s left) gem_linear_blits (interruptible)
[101.437870] Starting subtest: interruptible
[106.031642] Subtest interruptible: SUCCESS (4.594s)
[106.165382] [020/133] (916s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[106.311241] Starting subtest: x-tiled-64bpp-rotate-270
[106.332456] Subtest x-tiled-64bpp-rotate-270: SKIP (0.021s)
[106.442204] [021/133] (916s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[106.540292] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[106.542645] Starting dynamic subtest: pipe-A
[106.891442] Dynamic subtest pipe-A: SUCCESS (0.351s)
[106.899899] Starting dynamic subtest: pipe-B
[108.293304] Dynamic subtest pipe-B: SUCCESS (1.401s)
[108.302872] Starting dynamic subtest: pipe-C
[109.720838] Dynamic subtest pipe-C: SUCCESS (1.427s)
[109.729669] Starting dynamic subtest: pipe-D
[111.153440] Dynamic subtest pipe-D: SUCCESS (1.432s)
[111.155764] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.613s)
[112.302390] [022/133] (910s left) kms_pm_rpm (system-suspend-modeset)
[114.075589] Starting subtest: system-suspend-modeset
[133.647355] Subtest system-suspend-modeset: SUCCESS (4.720s)
[134.028066] [023/133] (889s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[134.097754] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[134.100128] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[134.211120] [024/133] (889s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[134.292425] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[134.296799] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[134.363864] [025/133] (888s left) gem_ctx_param (non-root-set)
[134.407032] Starting subtest: non-root-set
[134.422060] Subtest non-root-set: SUCCESS (0.015s)
[134.510641] [026/133] (888s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[134.615354] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[134.619488] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[134.717664] [027/133] (888s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[134.821361] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[135.618328] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.792s)
[135.777243] [028/133] (887s left) gem_ctx_persistence (file)
[135.836814] Starting subtest: file
[135.958344] Subtest file: SUCCESS (0.121s)
[136.070216] [029/133] (887s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[136.163348] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[136.165467] Starting dynamic subtest: pipe-A-default-mode
[137.302607] Dynamic subtest pipe-A-default-mode: SKIP (1.128s)
[137.306970] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.130s)
[137.457285] [030/133] (886s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[137.554201] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[137.556734] Starting dynamic subtest: pipe-A
[138.640347] Dynamic subtest pipe-A: SUCCESS (1.083s)
[138.648493] Starting dynamic subtest: pipe-B
[140.802324] Dynamic subtest pipe-B: SUCCESS (2.151s)
[140.812462] Starting dynamic subtest: pipe-C
[141.993843] Dynamic subtest pipe-C: SUCCESS (1.184s)
[142.001898] Starting dynamic subtest: pipe-D
[143.147504] Dynamic subtest pipe-D: SUCCESS (1.149s)
[143.149806] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.572s)
[144.345872] [031/133] (879s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[144.457732] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[144.460190] Starting dynamic subtest: A-eDP1
[148.092283] Dynamic subtest A-eDP1: SUCCESS (3.624s)
[148.101089] Starting dynamic subtest: B-eDP1
[151.284152] Dynamic subtest B-eDP1: SUCCESS (3.185s)
[151.293218] Starting dynamic subtest: C-eDP1
[154.401576] Dynamic subtest C-eDP1: SUCCESS (3.115s)
[154.412431] Starting dynamic subtest: D-eDP1
[157.486910] Dynamic subtest D-eDP1: SUCCESS (3.079s)
[157.488814] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.010s)
[158.298801] [032/133] (865s left) gem_exec_parallel (contexts)
[158.366862] Starting subtest: contexts
[158.369375] Starting dynamic subtest: rcs0
[161.192216] Dynamic subtest rcs0: SUCCESS (2.821s)
[161.201066] Starting dynamic subtest: bcs0
[165.049662] Dynamic subtest bcs0: SUCCESS (3.857s)
[165.060787] Starting dynamic subtest: vcs0
[169.129325] Dynamic subtest vcs0: SUCCESS (4.079s)
[169.139919] Starting dynamic subtest: vcs1
[173.237797] Dynamic subtest vcs1: SUCCESS (4.107s)
[173.249088] Starting dynamic subtest: vecs0
[177.219868] Dynamic subtest vecs0: SUCCESS (3.980s)
[177.230007] Starting dynamic subtest: ccs0
[180.847140] Dynamic subtest ccs0: SUCCESS (3.623s)
[180.849917] Subtest contexts: SUCCESS (22.479s)
[181.028351] [033/133] (842s left) gem_exec_alignment (many)
[181.082989] Starting subtest: many
[205.549181] Subtest many: SUCCESS (24.406s)
[206.848952] [034/133] (816s left) kms_psr (fbc-pr-no-drrs)
[206.998328] Starting subtest: fbc-pr-no-drrs
[207.002858] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[207.070782] [035/133] (816s left) kms_vrr (flip-suspend)
[207.163104] Starting subtest: flip-suspend
[207.169441] Subtest flip-suspend: SKIP (0.000s)
[207.237251] [036/133] (816s left) i915_module_load (reload)
[207.275990] Starting subtest: reload
[210.504044] Subtest reload: SUCCESS (3.227s)
[210.546427] [037/133] (813s left) gem_vm_create (invalid-destroy)
[211.694410] Starting subtest: invalid-destroy
[211.696956] Subtest invalid-destroy: SUCCESS (0.002s)
[211.795982] [038/133] (812s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[211.907609] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[211.910006] Starting dynamic subtest: pipe-A-eDP-1
[211.919481] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[211.928343] Starting dynamic subtest: pipe-B-eDP-1
[211.937777] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[211.946911] Starting dynamic subtest: pipe-C-eDP-1
[211.955927] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[211.963288] Starting dynamic subtest: pipe-D-eDP-1
[211.972028] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[211.976453] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[214.431844] [039/133] (809s left) kms_dsc (dsc-with-bpc-formats)
[214.535445] Starting subtest: dsc-with-bpc-formats
[214.643960] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[214.679556] [040/133] (809s left) kms_flip (dpms-off-confusion)
[214.766620] Starting subtest: dpms-off-confusion
[214.769114] Starting dynamic subtest: A-eDP1
[223.494777] Dynamic subtest A-eDP1: SUCCESS (8.687s)
[223.512341] Starting dynamic subtest: B-eDP1
[232.145255] Dynamic subtest B-eDP1: SUCCESS (8.650s)
[232.155584] Starting dynamic subtest: C-eDP1
[240.866092] Dynamic subtest C-eDP1: SUCCESS (8.712s)
[240.873669] Starting dynamic subtest: D-eDP1
[249.500035] Dynamic subtest D-eDP1: SUCCESS (8.629s)
[249.502255] Subtest dpms-off-confusion: SUCCESS (34.690s)
[250.605891] [041/133] (773s left) gem_exec_schedule (submit-early-slice)
[250.671056] Starting subtest: submit-early-slice
[250.673358] Starting dynamic subtest: rcs0
[250.704317] Dynamic subtest rcs0: SUCCESS (0.041s)
[250.715184] Starting dynamic subtest: bcs0
[250.743956] Dynamic subtest bcs0: SUCCESS (0.039s)
[250.753113] Starting dynamic subtest: vcs0
[250.782156] Dynamic subtest vcs0: SUCCESS (0.038s)
[250.791421] Starting dynamic subtest: vcs1
[250.819445] Dynamic subtest vcs1: SUCCESS (0.036s)
[250.831161] Starting dynamic subtest: vecs0
[250.853689] Dynamic subtest vecs0: SUCCESS (0.034s)
[250.862229] Starting dynamic subtest: ccs0
[250.887110] Dynamic subtest ccs0: SUCCESS (0.032s)
[250.889405] Subtest submit-early-slice: SUCCESS (0.225s)
[252.823119] [042/133] (771s left) gem_exec_schedule (noreorder)
[253.006126] Starting subtest: noreorder
[253.008462] Starting dynamic subtest: rcs0
[253.052172] Dynamic subtest rcs0: SUCCESS (0.046s)
[253.063071] Starting dynamic subtest: vcs0
[254.699243] Dynamic subtest vcs0: SUCCESS (1.644s)
[254.710976] Starting dynamic subtest: vcs1
[256.824398] Dynamic subtest vcs1: SUCCESS (2.070s)
[256.835340] Starting dynamic subtest: vecs0
[258.749899] Dynamic subtest vecs0: SUCCESS (1.974s)
[258.760931] Starting dynamic subtest: ccs0
[258.818609] Dynamic subtest ccs0: SUCCESS (0.068s)
[258.821418] Subtest noreorder: SUCCESS (5.813s)
[259.026176] [043/133] (764s left) gem_close (many-handles-one-vma)
[259.081981] Starting subtest: many-handles-one-vma
[259.122474] Subtest many-handles-one-vma: SUCCESS (0.041s)
[259.210785] [044/133] (764s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[259.319796] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[259.324154] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[259.415673] [045/133] (764s left) kms_plane_alpha_blend (alpha-basic)
[259.514825] Starting subtest: alpha-basic
[259.804463] Starting dynamic subtest: pipe-A-eDP-1
[261.758513] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.951s)
[261.782791] Starting dynamic subtest: pipe-D-eDP-1
[264.391806] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.615s)
[264.394321] Subtest alpha-basic: SUCCESS (4.876s)
[265.186273] [046/133] (758s left) kms_psr (psr2-cursor-plane-move)
[265.278729] Starting subtest: psr2-cursor-plane-move
[265.281120] Starting dynamic subtest: eDP-1
[266.973142] Dynamic subtest eDP-1: SUCCESS (1.694s)
[266.975561] Subtest psr2-cursor-plane-move: SUCCESS (1.695s)
[267.772167] [047/133] (756s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[267.885076] Starting subtest: y-tiled-64bpp-rotate-270
[267.889216] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[268.002046] [048/133] (756s left) dmabuf_sync_file (export-multiwait)
[268.090719] Starting subtest: export-multiwait
[268.092938] Subtest export-multiwait: SUCCESS (0.001s)
[268.139452] [FACT dmabuf_sync_file (export-multiwait)] new: kernel.kmod_is_loaded.vgem: true
[268.143056] [049/133] (756s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[268.238222] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[268.242619] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[268.335347] [050/133] (755s left) gem_mmap_gtt (basic-small-copy)
[268.393564] Subtest basic-small-copy: SKIP (0.000s)
[268.452204] [051/133] (755s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[268.973429] Starting subtest: syncobj-backward-timeline-chain-engines
[269.073007] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.101s)
[270.812887] [052/133] (753s left) gem_userptr_blits (process-exit-busy)
[270.879888] Starting subtest: process-exit-busy
[270.894082] Subtest process-exit-busy: SUCCESS (0.016s)
[271.027330] [053/133] (753s left) kms_big_fb (linear-64bpp-rotate-90)
[271.124293] Starting subtest: linear-64bpp-rotate-90
[271.145920] Subtest linear-64bpp-rotate-90: SKIP (0.020s)
[271.266815] [054/133] (753s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[271.366584] Starting subtest: extended-modeset-hang-oldfb-with-reset
[271.368593] Starting dynamic subtest: pipe-A
[283.066768] Dynamic subtest pipe-A: SUCCESS (11.697s)
[283.076760] Starting dynamic subtest: pipe-D
[295.355166] Dynamic subtest pipe-D: SUCCESS (12.283s)
[295.357353] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.984s)
[296.148651] [055/133] (728s left) gem_readwrite (new-obj)
[296.205619] Subtest new-obj: SKIP (0.000s)
[296.263326] [056/133] (728s left) gem_exec_whisper (basic-forked-all)
[296.332367] Starting subtest: basic-forked-all
[309.943202] Subtest basic-forked-all: SUCCESS (13.605s)
[310.123699] [057/133] (714s left) gem_mmap_offset (mmap-boundaries)
[310.187965] Starting subtest: mmap-boundaries
[310.190226] Starting dynamic subtest: smem0
[310.476224] Dynamic subtest smem0: SUCCESS (0.287s)
[310.479496] Subtest mmap-boundaries: SUCCESS (0.288s)
[310.604117] [058/133] (713s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[310.697493] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[310.723818] Starting dynamic subtest: pipe-A-plane-0
[311.389864] Dynamic subtest pipe-A-plane-0: SUCCESS (0.666s)
[311.399199] Starting dynamic subtest: pipe-A-plane-3
[311.845149] Dynamic subtest pipe-A-plane-3: SUCCESS (0.455s)
[312.948884] Starting dynamic subtest: pipe-B-plane-0
[313.650016] Dynamic subtest pipe-B-plane-0: SUCCESS (0.711s)
[313.662855] Starting dynamic subtest: pipe-B-plane-3
[314.093553] Dynamic subtest pipe-B-plane-3: SUCCESS (0.444s)
[314.409986] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.711s)
[315.214704] [059/133] (709s left) api_intel_allocator (reopen)
[315.276693] Starting subtest: reopen
[315.281521] Subtest reopen: SUCCESS (0.006s)
[315.400324] [060/133] (709s left) gem_mmap (pf-nonblock)
[315.460680] Subtest pf-nonblock: SKIP (0.000s)
[315.523829] [061/133] (709s left) syncobj_timeline (wait-any-snapshot)
[315.583586] Starting subtest: wait-any-snapshot
[315.665305] Subtest wait-any-snapshot: SUCCESS (0.081s)
[315.743823] [062/133] (708s left) i915_query (query-garbage)
[315.798964] Starting subtest: query-garbage
[315.801180] Subtest query-garbage: SUCCESS (0.000s)
[315.908131] [063/133] (708s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[315.963037] Starting subtest: multi-wait-all-for-submit-signaled
[315.965424] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[316.076842] [064/133] (708s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[316.139220] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[316.142764] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[316.318171] [065/133] (708s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[316.415461] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[316.426765] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[316.517876] [066/133] (708s left) gem_create (create-valid-nonaligned)
[316.572755] Starting subtest: create-valid-nonaligned
[316.574714] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[316.783462] [067/133] (708s left) gem_barrier_race (remote-request)
[316.862091] Starting subtest: remote-request
[316.864198] Starting dynamic subtest: rcs0
[322.030045] Dynamic subtest rcs0: SUCCESS (5.167s)
[322.040389] Subtest remote-request: SUCCESS (5.173s)
[322.164614] [068/133] (702s left) kms_prop_blob (blob-prop-core)
[322.219519] Starting subtest: blob-prop-core
[322.221621] Subtest blob-prop-core: SUCCESS (0.000s)
[322.330272] [069/133] (702s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[322.436512] Starting subtest: fbcpsr-suspend
[362.729660] Subtest fbcpsr-suspend: SUCCESS (10.950s)
[362.866249] [070/133] (662s left) gem_mmap_gtt (basic-read)
[362.936958] Subtest basic-read: SKIP (0.000s)
[363.000218] [071/133] (662s left) kms_flip (2x-blocking-wf_vblank)
[363.088055] Starting subtest: 2x-blocking-wf_vblank
[363.097379] Subtest 2x-blocking-wf_vblank: SKIP (0.011s)
[363.187583] [072/133] (661s left) kms_psr (psr-sprite-plane-move)
[363.294338] Starting subtest: psr-sprite-plane-move
[363.296740] Starting dynamic subtest: eDP-1
[365.093666] Dynamic subtest eDP-1: SUCCESS (1.784s)
[365.096089] Subtest psr-sprite-plane-move: SUCCESS (1.785s)
[365.916870] [073/133] (659s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[366.010802] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[366.015118] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[366.106597] [074/133] (659s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[366.152169] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[366.258437] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.104s)
[366.349274] [075/133] (658s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[366.433375] Starting subtest: fbc-psr2-cursor-mmap-gtt
[366.435755] Starting dynamic subtest: eDP-1
[366.440527] Dynamic subtest eDP-1: SKIP (0.000s)
[366.445172] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[366.503802] [076/133] (658s left) kms_getfb (getfb-handle-protection)
[366.592232] Starting subtest: getfb-handle-protection
[366.611713] Subtest getfb-handle-protection: SUCCESS (0.020s)
[366.740963] [077/133] (658s left) kms_addfb_basic (bad-pitch-128)
[366.790188] Starting subtest: bad-pitch-128
[366.792531] Subtest bad-pitch-128: SUCCESS (0.000s)
[366.925318] [078/133] (658s left) gem_partial_pwrite_pread (writes-after-reads-display)
[366.998822] Subtest writes-after-reads-display: SKIP (0.000s)
[367.069988] [079/133] (658s left) kms_content_protection (atomic)
[367.214268] Starting subtest: atomic
[367.218813] Subtest atomic: SKIP (0.000s)
[367.370429] [080/133] (658s left) kms_cursor_edge_walk (256x256-left-edge)
[367.481856] Starting subtest: 256x256-left-edge
[367.483748] Starting dynamic subtest: pipe-A-eDP-1
[370.926969] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.430s)
[370.942267] Starting dynamic subtest: pipe-D-eDP-1
[374.056587] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.118s)
[374.058828] Subtest 256x256-left-edge: SUCCESS (6.552s)
[374.865616] [081/133] (650s left) kms_pm_rpm (cursor)
[376.387190] Starting subtest: cursor
[376.392426] Subtest cursor: SKIP (0.000s)
[377.115669] [082/133] (648s left) kms_atomic (plane-invalid-params-fence)
[377.213294] Starting subtest: plane-invalid-params-fence
[377.215628] Starting dynamic subtest: pipe-A-eDP-1
[377.567631] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.354s)
[377.570155] Subtest plane-invalid-params-fence: SUCCESS (0.356s)
[378.435114] [083/133] (647s left) kms_async_flips (crc)
[378.523216] Starting subtest: crc
[378.899580] Starting dynamic subtest: pipe-A-eDP-1
[381.882917] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.959s)
[382.242599] Starting dynamic subtest: pipe-B-eDP-1
[385.221400] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.971s)
[385.587537] Starting dynamic subtest: pipe-C-eDP-1
[388.540764] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.930s)
[388.875296] Starting dynamic subtest: pipe-D-eDP-1
[391.767085] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.858s)
[391.769288] Subtest crc: SUCCESS (13.192s)
[392.900421] [084/133] (632s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[393.009752] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[393.014214] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[393.123620] [085/133] (632s left) kms_plane_cursor (viewport)
[393.218375] Starting subtest: viewport
[393.222757] Starting dynamic subtest: pipe-A-eDP-1-size-64
[395.630012] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.413s)
[395.691108] Starting dynamic subtest: pipe-A-eDP-1-size-128
[398.139743] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.459s)
[398.201669] Starting dynamic subtest: pipe-A-eDP-1-size-256
[400.629691] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.438s)
[400.984658] Starting dynamic subtest: pipe-B-eDP-1-size-64
[404.273588] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.301s)
[404.335452] Starting dynamic subtest: pipe-B-eDP-1-size-128
[406.841341] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.517s)
[406.901909] Starting dynamic subtest: pipe-B-eDP-1-size-256
[409.387006] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.493s)
[409.742632] Starting dynamic subtest: pipe-C-eDP-1-size-64
[412.548435] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.817s)
[412.586749] Starting dynamic subtest: pipe-C-eDP-1-size-128
[414.726674] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.147s)
[414.765404] Starting dynamic subtest: pipe-C-eDP-1-size-256
[416.915326] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.158s)
[417.249778] Starting dynamic subtest: pipe-D-eDP-1-size-64
[420.119845] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.885s)
[420.158414] Starting dynamic subtest: pipe-D-eDP-1-size-128
[422.264092] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.114s)
[422.302368] Starting dynamic subtest: pipe-D-eDP-1-size-256
[424.342390] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.047s)
[424.667347] Subtest viewport: SUCCESS (31.453s)
[425.522703] [086/133] (600s left) i915_pm_rps (thresholds-idle)
[425.594951] Starting subtest: thresholds-idle
[425.599642] Subtest thresholds-idle: SKIP (0.001s)
[425.702410] [087/133] (600s left) kms_addfb_basic (bo-too-small)
[425.801349] Starting subtest: bo-too-small
[425.803588] Subtest bo-too-small: SUCCESS (0.000s)
[425.894735] [088/133] (599s left) gem_exec_whisper (basic-queues-forked)
[425.965016] Starting subtest: basic-queues-forked
[450.158873] Subtest basic-queues-forked: SUCCESS (24.130s)
[450.292474] [089/133] (575s left) perf (invalid-oa-format-id)
[450.391542] Starting subtest: invalid-oa-format-id
[450.403710] Subtest invalid-oa-format-id: SUCCESS (0.011s)
[450.447977] [090/133] (575s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[450.544070] Starting subtest: psr2-cursor-plane-update-sf
[450.546405] Starting dynamic subtest: pipe-A-eDP-1
[451.109662] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.569s)
[451.120769] Starting dynamic subtest: pipe-B-eDP-1
[452.400203] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.288s)
[452.402491] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.860s)
[453.271610] [091/133] (572s left) gem_exec_reloc (basic-cpu-gtt)
[453.336815] Subtest basic-cpu-gtt: SKIP (0.000s)
[453.410619] [092/133] (572s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[453.496402] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[453.498689] Starting dynamic subtest: pipe-A-eDP-1
[453.521183] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[453.533886] Starting dynamic subtest: pipe-B-eDP-1
[453.555279] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[453.564209] Starting dynamic subtest: pipe-C-eDP-1
[453.585391] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[453.594664] Starting dynamic subtest: pipe-D-eDP-1
[453.616187] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[453.620424] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[455.764187] [093/133] (570s left) gem_close_race (multigpu-basic-process)
[455.834796] Starting subtest: multigpu-basic-process
[455.839330] Subtest multigpu-basic-process: SKIP (0.000s)
[456.046297] [094/133] (570s left) gen9_exec_parse (batch-invalid-length)
[456.102371] Subtest batch-invalid-length: SKIP (0.000s)
[456.178245] [095/133] (569s left) gem_exec_fence (syncobj-unused-fence)
[456.625564] Starting subtest: syncobj-unused-fence
[456.631474] Subtest syncobj-unused-fence: SUCCESS (0.005s)
[458.133094] [096/133] (568s left) gem_exec_nop (basic-sequential)
[458.203852] Starting subtest: basic-sequential
[474.184783] Subtest basic-sequential: SUCCESS (15.972s)
[474.389838] [097/133] (551s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[474.498221] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[474.502160] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[474.593707] [098/133] (551s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[474.688513] Starting subtest: 4-tiled-64bpp-rotate-90
[474.708233] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s)
[474.823605] [099/133] (551s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[474.877705] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[474.940375] [100/133] (551s left) kms_fence_pin_leak
[475.098079] [101/133] (551s left) prime_busy (hang-wait)
[475.153603] Starting subtest: hang-wait
[475.155381] Starting dynamic subtest: rcs0
[501.532877] Dynamic subtest rcs0: SUCCESS (26.367s)
[501.543770] Starting dynamic subtest: bcs0
[508.622200] Dynamic subtest bcs0: SUCCESS (7.088s)
[508.633260] Starting dynamic subtest: vcs0
[515.655885] Dynamic subtest vcs0: SUCCESS (7.037s)
[515.665597] Starting dynamic subtest: vcs1
[522.630721] Dynamic subtest vcs1: SUCCESS (6.975s)
[522.643352] Starting dynamic subtest: vecs0
[529.664197] Dynamic subtest vecs0: SUCCESS (7.026s)
[529.675904] Starting dynamic subtest: ccs0
[543.569979] Dynamic subtest ccs0: SUCCESS (13.900s)
[543.572816] Subtest hang-wait: SUCCESS (68.410s)
[543.684380] [102/133] (482s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[544.071819] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[544.851008] [103/133] (481s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[544.945836] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[544.949961] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[545.081735] [104/133] (481s left) gem_unref_active_buffers
[545.285741] [105/133] (481s left) kms_rmfb (rmfb-ioctl)
[545.367263] Starting subtest: rmfb-ioctl
[545.369378] Starting dynamic subtest: pipe-A-eDP-1
[545.472465] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.107s)
[545.485253] Starting dynamic subtest: pipe-B-eDP-1
[546.628946] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.155s)
[546.640557] Starting dynamic subtest: pipe-C-eDP-1
[547.765677] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.134s)
[547.776729] Starting dynamic subtest: pipe-D-eDP-1
[548.904725] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.137s)
[548.907044] Subtest rmfb-ioctl: SUCCESS (3.539s)
[550.040987] [106/133] (476s left) gem_exec_reloc (basic-cpu-read-noreloc)
[550.116560] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[550.184827] [107/133] (476s left) kms_cursor_crc (cursor-dpms)
[550.319615] Starting subtest: cursor-dpms
[550.321553] Starting dynamic subtest: pipe-A-eDP-1
[553.326837] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.004s)
[553.337585] Starting dynamic subtest: pipe-D-eDP-1
[556.931255] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.603s)
[556.933560] Subtest cursor-dpms: SUCCESS (6.611s)
[557.770575] [108/133] (468s left) kms_debugfs (display-off-read-all)
[557.866009] Starting subtest: display-off-read-all
[558.158284] Subtest display-off-read-all: SUCCESS (0.292s)
[558.991696] [109/133] (467s left) perf_pmu (most-busy-idle-check-all)
[559.039087] Starting subtest: most-busy-idle-check-all
[559.041320] Starting dynamic subtest: rcs0
[561.014662] Dynamic subtest rcs0: SUCCESS (1.975s)
[561.028634] Starting dynamic subtest: bcs0
[563.062490] Dynamic subtest bcs0: SUCCESS (2.044s)
[563.075874] Starting dynamic subtest: vcs0
[565.046762] Dynamic subtest vcs0: SUCCESS (1.981s)
[565.060427] Starting dynamic subtest: vcs1
[567.030324] Dynamic subtest vcs1: SUCCESS (1.980s)
[567.043321] Starting dynamic subtest: vecs0
[569.015347] Dynamic subtest vecs0: SUCCESS (1.980s)
[569.028208] Starting dynamic subtest: ccs0
[571.066989] Dynamic subtest ccs0: SUCCESS (2.042s)
[571.071476] Subtest most-busy-idle-check-all: SUCCESS (12.021s)
[571.174523] [110/133] (455s left) gem_exec_balancer (waits)
[571.245029] Starting subtest: waits
[577.720972] Subtest waits: SUCCESS (6.472s)
[578.004048] [111/133] (448s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[578.119127] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[578.121227] Starting dynamic subtest: pipe-A-eDP-1
[580.266267] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.148s)
[580.275872] Starting dynamic subtest: pipe-B-eDP-1
[582.411592] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.143s)
[582.423503] Starting dynamic subtest: pipe-C-eDP-1
[584.432423] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.019s)
[584.443047] Starting dynamic subtest: pipe-D-eDP-1
[586.527510] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.092s)
[586.529666] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.408s)
[587.707713] [112/133] (439s left) perf (invalid-oa-metric-set-id)
[587.814608] Starting subtest: invalid-oa-metric-set-id
[587.827017] Subtest invalid-oa-metric-set-id: SUCCESS (0.012s)
[587.880793] [113/133] (439s left) kms_fbcon_fbt (fbc)
[587.948716] Starting subtest: fbc
[594.247181] Subtest fbc: SUCCESS (6.298s)
[595.333583] [114/133] (431s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[595.435355] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[595.439798] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[595.553760] [115/133] (431s left) kms_lease (lease-again)
[595.649481] Starting subtest: lease-again
[595.651858] Starting dynamic subtest: pipe-A-eDP-1
[595.654180] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s)
[595.670166] Starting dynamic subtest: pipe-B-eDP-1
[595.672648] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[595.682544] Starting dynamic subtest: pipe-C-eDP-1
[595.684741] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[595.694593] Starting dynamic subtest: pipe-D-eDP-1
[595.696836] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[595.699095] Subtest lease-again: SUCCESS (0.013s)
[595.788911] [116/133] (431s left) kms_chamelium_color (ctm-max)
[595.875818] Subtest ctm-max: SKIP (0.000s)
[595.926082] [117/133] (431s left) gem_softpin (zero)
[595.981551] Starting subtest: zero
[595.989467] Subtest zero: SUCCESS (0.005s)
[596.114479] [118/133] (431s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[596.212340] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[596.216340] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[596.295910] [119/133] (430s left) perf (missing-sample-flags)
[596.391724] Starting subtest: missing-sample-flags
[596.393853] Subtest missing-sample-flags: SUCCESS (0.000s)
[596.440524] [120/133] (430s left) core_auth (getclient-simple)
[596.481129] Starting subtest: getclient-simple
[596.498107] Subtest getclient-simple: SUCCESS (0.019s)
[596.609822] [121/133] (430s left) kms_color (degamma)
[596.691885] Starting subtest: degamma
[596.693691] Starting dynamic subtest: pipe-A-eDP-1
[597.412993] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.721s)
[597.422861] Starting dynamic subtest: pipe-B-eDP-1
[598.853668] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.440s)
[598.864214] Starting dynamic subtest: pipe-C-eDP-1
[600.235425] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.382s)
[600.246746] Starting dynamic subtest: pipe-D-eDP-1
[601.577977] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.342s)
[601.579843] Subtest degamma: SUCCESS (4.887s)
[602.374088] [122/133] (424s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[602.483578] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[602.487908] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[602.573285] [123/133] (424s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[602.654407] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[602.658951] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[603.817771] [124/133] (423s left) gem_ctx_create (basic-files)
[603.876971] Starting subtest: basic-files
[605.885783] Subtest basic-files: SUCCESS (2.009s)
[607.148889] [125/133] (420s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[607.398881] Starting subtest: cursor-rapid-movement-256x256
[607.401734] Starting dynamic subtest: pipe-A-eDP-1
[607.955322] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.553s)
[607.984022] Starting dynamic subtest: pipe-D-eDP-1
[609.139881] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.164s)
[609.141776] Subtest cursor-rapid-movement-256x256: SUCCESS (1.742s)
[609.980233] [126/133] (417s left) kms_chamelium_frames (dp-frame-dump)
[610.378945] Subtest dp-frame-dump: SKIP (0.000s)
[611.193225] [127/133] (416s left) gem_mmap_gtt (medium-copy)
[611.247265] Subtest medium-copy: SKIP (0.000s)
[611.302817] [128/133] (416s left) gem_ctx_param (invalid-param-set)
[611.343357] Starting subtest: invalid-param-set
[611.345937] Subtest invalid-param-set: SUCCESS (0.000s)
[611.414612] [129/133] (416s left) kms_psr (fbc-psr2-sprite-plane-move)
[611.506191] Starting subtest: fbc-psr2-sprite-plane-move
[611.508500] Starting dynamic subtest: eDP-1
[611.512868] Dynamic subtest eDP-1: SKIP (0.000s)
[611.517275] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[611.579898] [130/133] (416s left) gem_exec_balancer (full-pulse)
[611.641534] Starting subtest: full-pulse
[615.895298] Subtest full-pulse: SUCCESS (4.254s)
[616.220212] [131/133] (411s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[616.308414] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[616.312383] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[616.423564] [132/133] (411s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[616.537700] Starting subtest: flip-vs-cursor-crc-atomic
[617.206321] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.669s)
[618.054638] [133/133] (409s left) kms_vblank (invalid)
[618.150674] Starting subtest: invalid
[618.153032] Starting dynamic subtest: pipe-A-eDP-1
[618.550219] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.397s)
[618.552644] Subtest invalid: SUCCESS (0.399s)
[619.382714] 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.