[56.790060] Initializing watchdogs
[56.790108]   /dev/watchdog0
[56.804607] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.808943] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.811144] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.814326] [001/133] (960s left) i915_drm_fdinfo (busy-idle)
[56.878664] Starting subtest: busy-idle
[56.881076] Starting dynamic subtest: rcs0
[56.899215] Dynamic subtest rcs0: SKIP (0.018s)
[56.907113] Starting dynamic subtest: bcs0
[56.911499] Dynamic subtest bcs0: SKIP (0.000s)
[56.919374] Starting dynamic subtest: vcs0
[56.923370] Dynamic subtest vcs0: SKIP (0.000s)
[56.930392] Starting dynamic subtest: vcs1
[56.934639] Dynamic subtest vcs1: SKIP (0.000s)
[56.941209] Starting dynamic subtest: vecs0
[56.945340] Dynamic subtest vecs0: SKIP (0.000s)
[56.951628] Starting dynamic subtest: ccs0
[56.955780] Dynamic subtest ccs0: SKIP (0.000s)
[56.960061] Subtest busy-idle: SKIP (0.021s)
[56.995681] [002/133] (960s left) kms_hdr (static-toggle-dpms)
[57.094374] Starting subtest: static-toggle-dpms
[57.101309] Subtest static-toggle-dpms: SKIP (0.000s)
[57.163597] [003/133] (960s left) gem_ctx_param (basic-default)
[57.223420] Starting subtest: basic-default
[57.225863] Subtest basic-default: SUCCESS (0.000s)
[57.292984] [004/133] (960s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[57.380330] Starting subtest: psr-rgb565-draw-mmap-wc
[64.149678] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.769s)
[64.256918] [005/133] (953s left) gem_render_copy (yf-tiled-ccs-to-linear)
[64.316587] Starting subtest: yf-tiled-ccs-to-linear
[64.320765] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[64.507714] [006/133] (952s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[64.609838] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[71.867520] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (7.256s)
[72.021640] [007/133] (945s left) i915_pm_rps (min-max-config-loaded)
[72.075967] Starting subtest: min-max-config-loaded
[72.080610] Subtest min-max-config-loaded: SKIP (0.001s)
[72.173346] [008/133] (945s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[72.280986] Starting subtest: fbcpsr-shrfb-scaledprimary
[78.116889] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.839s)
[78.260229] [009/133] (939s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[78.360955] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[85.464943] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.106s)
[85.590925] [010/133] (932s left) kms_rotation_crc (cursor-rotation-180)
[85.686107] Starting subtest: cursor-rotation-180
[87.183426] Subtest cursor-rotation-180: SUCCESS (1.496s)
[88.357254] [011/133] (929s left) syncobj_wait (reset-multiple-signaled)
[88.413077] Starting subtest: reset-multiple-signaled
[88.415501] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[88.494025] [012/133] (929s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[88.552648] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[88.554882] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s)
[88.663302] [013/133] (929s left) kms_psr (psr2-basic)
[88.763163] Starting subtest: psr2-basic
[88.765486] Starting dynamic subtest: eDP-1
[90.333054] Dynamic subtest eDP-1: SUCCESS (1.571s)
[90.335428] Subtest psr2-basic: SUCCESS (1.571s)
[91.136911] [014/133] (926s left) kms_vblank (ts-continuation-modeset)
[91.243263] Starting subtest: ts-continuation-modeset
[91.245500] Starting dynamic subtest: pipe-A-eDP-1
[92.713126] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.470s)
[92.726217] Starting dynamic subtest: pipe-D-eDP-1
[94.885053] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.170s)
[94.887416] Subtest ts-continuation-modeset: SUCCESS (3.643s)
[95.693829] [015/133] (922s left) syncobj_timeline (wait-for-submit-snapshot)
[95.749949] Starting subtest: wait-for-submit-snapshot
[95.831342] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[95.900866] [016/133] (921s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[95.958651] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[96.021456] [017/133] (921s left) gem_ctx_param (invalid-get-ringsize)
[96.073624] Starting subtest: invalid-get-ringsize
[96.075886] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[96.173602] [018/133] (921s left) gem_tiled_fence_blits (normal)
[96.240823] Subtest normal: SKIP (0.000s)
[96.310721] [019/133] (921s left) gem_linear_blits (interruptible)
[96.592535] Starting subtest: interruptible
[101.086891] Subtest interruptible: SUCCESS (4.496s)
[101.221902] [020/133] (916s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[101.370722] Starting subtest: x-tiled-64bpp-rotate-270
[101.391375] Subtest x-tiled-64bpp-rotate-270: SKIP (0.020s)
[101.504333] [021/133] (916s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[101.602846] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[101.605081] Starting dynamic subtest: pipe-A
[101.963585] Dynamic subtest pipe-A: SUCCESS (0.362s)
[101.972467] Starting dynamic subtest: pipe-B
[103.379024] Dynamic subtest pipe-B: SUCCESS (1.415s)
[103.386902] Starting dynamic subtest: pipe-C
[104.815836] Dynamic subtest pipe-C: SUCCESS (1.436s)
[104.823925] Starting dynamic subtest: pipe-D
[106.243361] Dynamic subtest pipe-D: SUCCESS (1.427s)
[106.245772] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.642s)
[107.406178] [022/133] (910s left) kms_pm_rpm (system-suspend-modeset)
[108.957710] Starting subtest: system-suspend-modeset
[128.722293] Subtest system-suspend-modeset: SUCCESS (4.843s)
[129.086200] [023/133] (889s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[129.158342] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[129.160491] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[129.253309] [024/133] (888s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[129.344148] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[129.348441] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[129.413709] [025/133] (888s left) gem_ctx_param (non-root-set)
[129.464630] Starting subtest: non-root-set
[129.484309] Subtest non-root-set: SUCCESS (0.020s)
[129.577496] [026/133] (888s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[129.676688] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[129.680597] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[129.772595] [027/133] (888s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[129.888164] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[130.689419] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.826s)
[130.847986] [028/133] (887s left) gem_ctx_persistence (file)
[130.921558] Starting subtest: file
[131.028679] Subtest file: SUCCESS (0.109s)
[131.144245] [029/133] (887s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[131.237315] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[131.239537] Starting dynamic subtest: pipe-A-default-mode
[132.345916] Dynamic subtest pipe-A-default-mode: SKIP (1.134s)
[132.350175] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.135s)
[132.498874] [030/133] (885s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[132.584112] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[132.586493] Starting dynamic subtest: pipe-A
[133.611524] Dynamic subtest pipe-A: SUCCESS (1.050s)
[133.619662] Starting dynamic subtest: pipe-B
[135.676536] Dynamic subtest pipe-B: SUCCESS (2.094s)
[135.700222] Starting dynamic subtest: pipe-C
[136.834477] Dynamic subtest pipe-C: SUCCESS (1.174s)
[136.845597] Starting dynamic subtest: pipe-D
[137.970136] Dynamic subtest pipe-D: SUCCESS (1.148s)
[137.972447] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.469s)
[139.144372] [031/133] (879s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[139.248743] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[139.251096] Starting dynamic subtest: A-eDP1
[142.843820] Dynamic subtest A-eDP1: SUCCESS (3.619s)
[142.852928] Starting dynamic subtest: B-eDP1
[146.041281] Dynamic subtest B-eDP1: SUCCESS (3.210s)
[146.049882] Starting dynamic subtest: C-eDP1
[149.149644] Dynamic subtest C-eDP1: SUCCESS (3.117s)
[149.158308] Starting dynamic subtest: D-eDP1
[152.263660] Dynamic subtest D-eDP1: SUCCESS (3.121s)
[152.265921] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.075s)
[153.061978] [032/133] (865s left) gem_exec_parallel (contexts)
[153.128169] Starting subtest: contexts
[153.130701] Starting dynamic subtest: rcs0
[155.848827] Dynamic subtest rcs0: SUCCESS (2.723s)
[155.857367] Starting dynamic subtest: bcs0
[159.472714] Dynamic subtest bcs0: SUCCESS (3.619s)
[159.482255] Starting dynamic subtest: vcs0
[163.332770] Dynamic subtest vcs0: SUCCESS (3.855s)
[163.342933] Starting dynamic subtest: vcs1
[167.372946] Dynamic subtest vcs1: SUCCESS (4.036s)
[167.382575] Starting dynamic subtest: vecs0
[171.401975] Dynamic subtest vecs0: SUCCESS (4.028s)
[171.411469] Starting dynamic subtest: ccs0
[175.196446] Dynamic subtest ccs0: SUCCESS (3.792s)
[175.198737] Subtest contexts: SUCCESS (22.067s)
[175.382745] [033/133] (843s left) gem_exec_alignment (many)
[175.463643] Starting subtest: many
[199.272821] Subtest many: SUCCESS (23.814s)
[200.738167] [034/133] (817s left) kms_psr (fbc-pr-no-drrs)
[200.892399] Starting subtest: fbc-pr-no-drrs
[200.896864] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[200.979529] [035/133] (817s left) kms_vrr (flip-suspend)
[201.087483] Starting subtest: flip-suspend
[201.093925] Subtest flip-suspend: SKIP (0.000s)
[201.156801] [036/133] (817s left) i915_module_load (reload)
[201.201165] Starting subtest: reload
[205.363782] Subtest reload: SUCCESS (4.165s)
[205.409814] [037/133] (813s left) gem_vm_create (invalid-destroy)
[206.883765] Starting subtest: invalid-destroy
[206.886071] Subtest invalid-destroy: SUCCESS (0.002s)
[206.979540] [038/133] (811s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[207.071376] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[207.073581] Starting dynamic subtest: pipe-A-eDP-1
[207.082598] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[207.091441] Starting dynamic subtest: pipe-B-eDP-1
[207.100361] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[207.108602] Starting dynamic subtest: pipe-C-eDP-1
[207.117511] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[207.125677] Starting dynamic subtest: pipe-D-eDP-1
[207.134097] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[207.138136] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.007s)
[209.401865] [039/133] (809s left) kms_dsc (dsc-with-bpc-formats)
[209.501610] Starting subtest: dsc-with-bpc-formats
[209.614043] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[209.650012] [040/133] (809s left) kms_flip (dpms-off-confusion)
[209.746404] Starting subtest: dpms-off-confusion
[209.748542] Starting dynamic subtest: A-eDP1
[218.509094] Dynamic subtest A-eDP1: SUCCESS (8.767s)
[218.519338] Starting dynamic subtest: B-eDP1
[227.228665] Dynamic subtest B-eDP1: SUCCESS (8.716s)
[227.241223] Starting dynamic subtest: C-eDP1
[235.863233] Dynamic subtest C-eDP1: SUCCESS (8.629s)
[235.877043] Starting dynamic subtest: D-eDP1
[244.504648] Dynamic subtest D-eDP1: SUCCESS (8.637s)
[244.509558] Subtest dpms-off-confusion: SUCCESS (34.762s)
[245.707874] [041/133] (773s left) gem_exec_schedule (submit-early-slice)
[245.770134] Starting subtest: submit-early-slice
[245.772432] Starting dynamic subtest: rcs0
[245.814230] Dynamic subtest rcs0: SUCCESS (0.049s)
[245.826102] Starting dynamic subtest: bcs0
[245.856727] Dynamic subtest bcs0: SUCCESS (0.042s)
[245.866991] Starting dynamic subtest: vcs0
[245.901280] Dynamic subtest vcs0: SUCCESS (0.044s)
[245.912086] Starting dynamic subtest: vcs1
[245.941087] Dynamic subtest vcs1: SUCCESS (0.039s)
[245.952906] Starting dynamic subtest: vecs0
[245.973187] Dynamic subtest vecs0: SUCCESS (0.032s)
[245.981382] Starting dynamic subtest: ccs0
[246.011716] Dynamic subtest ccs0: SUCCESS (0.037s)
[246.014211] Subtest submit-early-slice: SUCCESS (0.247s)
[246.982412] [042/133] (771s left) gem_exec_schedule (noreorder)
[247.165099] Starting subtest: noreorder
[247.167599] Starting dynamic subtest: rcs0
[247.236287] Dynamic subtest rcs0: SUCCESS (0.071s)
[247.251507] Starting dynamic subtest: vcs0
[248.886707] Dynamic subtest vcs0: SUCCESS (1.647s)
[248.898969] Starting dynamic subtest: vcs1
[250.924575] Dynamic subtest vcs1: SUCCESS (2.035s)
[250.936464] Starting dynamic subtest: vecs0
[252.915418] Dynamic subtest vecs0: SUCCESS (1.988s)
[252.925972] Starting dynamic subtest: ccs0
[252.981218] Dynamic subtest ccs0: SUCCESS (0.064s)
[252.983863] Subtest noreorder: SUCCESS (5.817s)
[253.167013] [043/133] (765s left) gem_close (many-handles-one-vma)
[253.233451] Starting subtest: many-handles-one-vma
[253.275872] Subtest many-handles-one-vma: SUCCESS (0.042s)
[253.387992] [044/133] (765s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[253.488936] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[253.493287] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[253.610264] [045/133] (765s left) kms_plane_alpha_blend (alpha-basic)
[253.703172] Starting subtest: alpha-basic
[254.015267] Starting dynamic subtest: pipe-A-eDP-1
[255.976571] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.960s)
[256.002747] Starting dynamic subtest: pipe-D-eDP-1
[258.656129] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.660s)
[258.658510] Subtest alpha-basic: SUCCESS (4.954s)
[259.537048] [046/133] (759s left) kms_psr (psr2-cursor-plane-move)
[259.629479] Starting subtest: psr2-cursor-plane-move
[259.631778] Starting dynamic subtest: eDP-1
[261.309159] Dynamic subtest eDP-1: SUCCESS (1.681s)
[261.311384] Subtest psr2-cursor-plane-move: SUCCESS (1.682s)
[262.125485] [047/133] (756s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[262.229223] Starting subtest: y-tiled-64bpp-rotate-270
[262.233753] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[262.313567] [048/133] (756s left) dmabuf_sync_file (export-multiwait)
[262.389402] Starting subtest: export-multiwait
[262.391705] Subtest export-multiwait: SUCCESS (0.001s)
[262.444241] [FACT dmabuf_sync_file (export-multiwait)] new: kernel.kmod_is_loaded.vgem: true
[262.447898] [049/133] (756s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[262.545043] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[262.549034] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[262.671169] [050/133] (756s left) gem_mmap_gtt (basic-small-copy)
[262.729295] Subtest basic-small-copy: SKIP (0.000s)
[262.789002] [051/133] (756s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[263.319592] Starting subtest: syncobj-backward-timeline-chain-engines
[263.430400] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.112s)
[265.039247] [052/133] (754s left) gem_userptr_blits (process-exit-busy)
[265.119072] Starting subtest: process-exit-busy
[265.135259] Subtest process-exit-busy: SUCCESS (0.016s)
[265.268295] [053/133] (754s left) kms_big_fb (linear-64bpp-rotate-90)
[265.367449] Starting subtest: linear-64bpp-rotate-90
[265.387691] Subtest linear-64bpp-rotate-90: SKIP (0.020s)
[265.516598] [054/133] (753s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[265.609446] Starting subtest: extended-modeset-hang-oldfb-with-reset
[265.611656] Starting dynamic subtest: pipe-A
[277.076422] Dynamic subtest pipe-A: SUCCESS (11.466s)
[277.086987] Starting dynamic subtest: pipe-D
[289.363741] Dynamic subtest pipe-D: SUCCESS (12.286s)
[289.366125] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.757s)
[290.166956] [055/133] (729s left) gem_readwrite (new-obj)
[290.226071] Subtest new-obj: SKIP (0.000s)
[290.288288] [056/133] (729s left) gem_exec_whisper (basic-forked-all)
[290.353755] Starting subtest: basic-forked-all
[303.927851] Subtest basic-forked-all: SUCCESS (13.578s)
[304.127101] [057/133] (715s left) gem_mmap_offset (mmap-boundaries)
[304.179682] Starting subtest: mmap-boundaries
[304.181969] Starting dynamic subtest: smem0
[304.467216] Dynamic subtest smem0: SUCCESS (0.288s)
[304.470071] Subtest mmap-boundaries: SUCCESS (0.289s)
[304.576356] [058/133] (714s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[304.678201] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[304.705909] Starting dynamic subtest: pipe-A-plane-0
[305.408269] Dynamic subtest pipe-A-plane-0: SUCCESS (0.700s)
[305.417923] Starting dynamic subtest: pipe-A-plane-3
[305.847831] Dynamic subtest pipe-A-plane-3: SUCCESS (0.444s)
[306.950964] Starting dynamic subtest: pipe-B-plane-0
[307.639885] Dynamic subtest pipe-B-plane-0: SUCCESS (0.700s)
[307.651856] Starting dynamic subtest: pipe-B-plane-3
[308.073024] Dynamic subtest pipe-B-plane-3: SUCCESS (0.433s)
[308.396783] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.719s)
[309.223106] [059/133] (710s left) api_intel_allocator (reopen)
[309.274372] Starting subtest: reopen
[309.279020] Subtest reopen: SUCCESS (0.005s)
[309.396575] [060/133] (710s left) gem_mmap (pf-nonblock)
[309.451471] Subtest pf-nonblock: SKIP (0.000s)
[309.508215] [061/133] (710s left) syncobj_timeline (wait-any-snapshot)
[309.554503] Starting subtest: wait-any-snapshot
[309.635131] Subtest wait-any-snapshot: SUCCESS (0.081s)
[309.710650] [062/133] (710s left) i915_query (query-garbage)
[309.766266] Starting subtest: query-garbage
[309.768640] Subtest query-garbage: SUCCESS (0.000s)
[309.864011] [063/133] (709s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[309.917942] Starting subtest: multi-wait-all-for-submit-signaled
[309.920169] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[310.028795] [064/133] (709s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[310.086402] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[310.090751] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[310.280059] [065/133] (709s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[310.375385] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[310.388304] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.012s)
[310.480799] [066/133] (709s left) gem_create (create-valid-nonaligned)
[310.542133] Starting subtest: create-valid-nonaligned
[310.544404] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[310.745554] [067/133] (709s left) gem_barrier_race (remote-request)
[310.823360] Starting subtest: remote-request
[310.825792] Starting dynamic subtest: rcs0
[316.013445] Dynamic subtest rcs0: SUCCESS (5.194s)
[316.015771] Subtest remote-request: SUCCESS (5.195s)
[316.169234] [068/133] (703s left) kms_prop_blob (blob-prop-core)
[316.224124] Starting subtest: blob-prop-core
[316.226184] Subtest blob-prop-core: SUCCESS (0.000s)
[316.318053] [069/133] (703s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[316.413532] Starting subtest: fbcpsr-suspend
[356.708656] Subtest fbcpsr-suspend: SUCCESS (10.063s)
[356.851543] [070/133] (663s left) gem_mmap_gtt (basic-read)
[356.919247] Subtest basic-read: SKIP (0.000s)
[356.974895] [071/133] (663s left) kms_flip (2x-blocking-wf_vblank)
[357.071226] Starting subtest: 2x-blocking-wf_vblank
[357.079102] Subtest 2x-blocking-wf_vblank: SKIP (0.010s)
[357.158593] [072/133] (663s left) kms_psr (psr-sprite-plane-move)
[357.248138] Starting subtest: psr-sprite-plane-move
[357.250474] Starting dynamic subtest: eDP-1
[358.982767] Dynamic subtest eDP-1: SUCCESS (1.781s)
[358.985456] Subtest psr-sprite-plane-move: SUCCESS (1.782s)
[359.769664] [073/133] (660s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[359.870188] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[359.875003] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[359.958503] [074/133] (660s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[360.007078] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[360.110540] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.106s)
[360.199293] [075/133] (660s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[360.299245] Starting subtest: fbc-psr2-cursor-mmap-gtt
[360.302055] Starting dynamic subtest: eDP-1
[360.307296] Dynamic subtest eDP-1: SKIP (0.000s)
[360.312150] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.002s)
[360.373418] [076/133] (659s left) kms_getfb (getfb-handle-protection)
[360.464131] Starting subtest: getfb-handle-protection
[360.479986] Subtest getfb-handle-protection: SUCCESS (0.017s)
[360.595833] [077/133] (659s left) kms_addfb_basic (bad-pitch-128)
[360.659131] Starting subtest: bad-pitch-128
[360.661624] Subtest bad-pitch-128: SUCCESS (0.000s)
[360.809034] [078/133] (659s left) gem_partial_pwrite_pread (writes-after-reads-display)
[360.872824] Subtest writes-after-reads-display: SKIP (0.000s)
[360.934265] [079/133] (659s left) kms_content_protection (atomic)
[361.093221] Starting subtest: atomic
[361.099023] Subtest atomic: SKIP (0.000s)
[361.221646] [080/133] (659s left) kms_cursor_edge_walk (256x256-left-edge)
[361.312677] Starting subtest: 256x256-left-edge
[361.314828] Starting dynamic subtest: pipe-A-eDP-1
[364.758263] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.491s)
[364.769544] Starting dynamic subtest: pipe-D-eDP-1
[367.862166] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.130s)
[367.864677] Subtest 256x256-left-edge: SUCCESS (6.624s)
[368.681676] [081/133] (651s left) kms_pm_rpm (cursor)
[370.420589] Starting subtest: cursor
[370.426242] Subtest cursor: SKIP (0.000s)
[370.989184] [082/133] (649s left) kms_atomic (plane-invalid-params-fence)
[371.083641] Starting subtest: plane-invalid-params-fence
[371.086338] Starting dynamic subtest: pipe-A-eDP-1
[371.451607] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.370s)
[371.453973] Subtest plane-invalid-params-fence: SUCCESS (0.371s)
[372.314184] [083/133] (648s left) kms_async_flips (crc)
[372.406117] Starting subtest: crc
[372.791072] Starting dynamic subtest: pipe-A-eDP-1
[375.717253] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.936s)
[376.097223] Starting dynamic subtest: pipe-B-eDP-1
[379.033903] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.954s)
[379.427880] Starting dynamic subtest: pipe-C-eDP-1
[382.344868] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.937s)
[382.718998] Starting dynamic subtest: pipe-D-eDP-1
[385.568086] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.864s)
[385.571120] Subtest crc: SUCCESS (13.194s)
[386.738847] [084/133] (633s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[386.845122] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[386.849715] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[386.938656] [085/133] (633s left) kms_plane_cursor (viewport)
[387.028631] Starting subtest: viewport
[387.033184] Starting dynamic subtest: pipe-A-eDP-1-size-64
[389.614020] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.580s)
[389.674195] Starting dynamic subtest: pipe-A-eDP-1-size-128
[392.263076] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.593s)
[392.323255] Starting dynamic subtest: pipe-A-eDP-1-size-256
[394.876941] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.559s)
[395.244114] Starting dynamic subtest: pipe-B-eDP-1-size-64
[398.512875] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.277s)
[398.574111] Starting dynamic subtest: pipe-B-eDP-1-size-128
[401.137104] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.571s)
[401.199276] Starting dynamic subtest: pipe-B-eDP-1-size-256
[403.651589] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.460s)
[403.999117] Starting dynamic subtest: pipe-C-eDP-1-size-64
[406.896847] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.907s)
[406.933999] Starting dynamic subtest: pipe-C-eDP-1-size-128
[409.075235] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.147s)
[409.113512] Starting dynamic subtest: pipe-C-eDP-1-size-256
[411.244008] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.136s)
[411.580538] Starting dynamic subtest: pipe-D-eDP-1-size-64
[414.352887] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.784s)
[414.393014] Starting dynamic subtest: pipe-D-eDP-1-size-128
[416.554101] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.171s)
[416.597053] Starting dynamic subtest: pipe-D-eDP-1-size-256
[418.686987] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.102s)
[419.004233] Subtest viewport: SUCCESS (31.955s)
[419.878506] [086/133] (600s left) i915_pm_rps (thresholds-idle)
[419.955015] Starting subtest: thresholds-idle
[419.960541] Subtest thresholds-idle: SKIP (0.001s)
[420.051145] [087/133] (600s left) kms_addfb_basic (bo-too-small)
[420.144067] Starting subtest: bo-too-small
[420.146830] Subtest bo-too-small: SUCCESS (0.000s)
[420.227562] [088/133] (600s left) gem_exec_whisper (basic-queues-forked)
[420.287238] Starting subtest: basic-queues-forked
[443.429996] Subtest basic-queues-forked: SUCCESS (23.145s)
[443.617076] [089/133] (577s left) perf (invalid-oa-format-id)
[443.717547] Starting subtest: invalid-oa-format-id
[443.730386] Subtest invalid-oa-format-id: SUCCESS (0.011s)
[443.771191] [090/133] (577s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[443.869477] Starting subtest: psr2-cursor-plane-update-sf
[443.872005] Starting dynamic subtest: pipe-A-eDP-1
[444.468544] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.602s)
[444.478886] Starting dynamic subtest: pipe-B-eDP-1
[445.789029] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.320s)
[445.791888] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.925s)
[446.648283] [091/133] (574s left) gem_exec_reloc (basic-cpu-gtt)
[446.705873] Subtest basic-cpu-gtt: SKIP (0.000s)
[446.789743] [092/133] (574s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[446.878237] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[446.880999] Starting dynamic subtest: pipe-A-eDP-1
[446.908035] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[446.918695] Starting dynamic subtest: pipe-B-eDP-1
[446.943727] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[446.954285] Starting dynamic subtest: pipe-C-eDP-1
[446.979758] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[446.989298] Starting dynamic subtest: pipe-D-eDP-1
[447.014851] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[447.020051] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[449.043787] [093/133] (572s left) gem_close_race (multigpu-basic-process)
[449.111141] Starting subtest: multigpu-basic-process
[449.117110] Subtest multigpu-basic-process: SKIP (0.000s)
[449.348112] [094/133] (571s left) gen9_exec_parse (batch-invalid-length)
[449.403575] Subtest batch-invalid-length: SKIP (0.000s)
[449.471815] [095/133] (571s left) gem_exec_fence (syncobj-unused-fence)
[449.931566] Starting subtest: syncobj-unused-fence
[449.934268] Subtest syncobj-unused-fence: SUCCESS (0.005s)
[451.366980] [096/133] (569s left) gem_exec_nop (basic-sequential)
[451.438964] Starting subtest: basic-sequential
[465.781060] Subtest basic-sequential: SUCCESS (14.352s)
[466.010086] [097/133] (555s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[466.111861] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[466.116712] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[466.201622] [098/133] (555s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[466.302694] Starting subtest: 4-tiled-64bpp-rotate-90
[466.323153] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.020s)
[466.428552] [099/133] (554s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[466.487395] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[466.550276] [100/133] (554s left) kms_fence_pin_leak
[466.726674] [101/133] (554s left) prime_busy (hang-wait)
[466.780796] Starting subtest: hang-wait
[466.783553] Starting dynamic subtest: rcs0
[492.734266] Dynamic subtest rcs0: SUCCESS (25.947s)
[492.743625] Starting dynamic subtest: bcs0
[499.881661] Dynamic subtest bcs0: SUCCESS (7.148s)
[499.891561] Starting dynamic subtest: vcs0
[506.923449] Dynamic subtest vcs0: SUCCESS (7.037s)
[506.935156] Starting dynamic subtest: vcs1
[513.900155] Dynamic subtest vcs1: SUCCESS (6.979s)
[513.913817] Starting dynamic subtest: vecs0
[520.872632] Dynamic subtest vecs0: SUCCESS (6.972s)
[520.885405] Starting dynamic subtest: ccs0
[534.774989] Dynamic subtest ccs0: SUCCESS (13.899s)
[534.777873] Subtest hang-wait: SUCCESS (67.995s)
[534.887947] [102/133] (486s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[535.295983] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[536.147097] [103/133] (485s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[536.240484] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[536.245106] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[536.348470] [104/133] (485s left) gem_unref_active_buffers
[536.545759] [105/133] (485s left) kms_rmfb (rmfb-ioctl)
[536.648182] Starting subtest: rmfb-ioctl
[536.650633] Starting dynamic subtest: pipe-A-eDP-1
[536.753737] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.107s)
[536.766261] Starting dynamic subtest: pipe-B-eDP-1
[537.918096] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.163s)
[537.930876] Starting dynamic subtest: pipe-C-eDP-1
[539.046410] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.127s)
[539.063718] Starting dynamic subtest: pipe-D-eDP-1
[540.174095] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s)
[540.176878] Subtest rmfb-ioctl: SUCCESS (3.530s)
[541.384779] [106/133] (480s left) gem_exec_reloc (basic-cpu-read-noreloc)
[541.440232] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[541.510037] [107/133] (480s left) kms_cursor_crc (cursor-dpms)
[541.633160] Starting subtest: cursor-dpms
[541.635996] Starting dynamic subtest: pipe-A-eDP-1
[544.699950] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.068s)
[544.713251] Starting dynamic subtest: pipe-D-eDP-1
[548.269491] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.565s)
[548.271766] Subtest cursor-dpms: SUCCESS (6.637s)
[549.110191] [108/133] (472s left) kms_debugfs (display-off-read-all)
[549.208983] Starting subtest: display-off-read-all
[549.500097] Subtest display-off-read-all: SUCCESS (0.294s)
[550.341076] [109/133] (471s left) perf_pmu (most-busy-idle-check-all)
[550.388247] Starting subtest: most-busy-idle-check-all
[550.390999] Starting dynamic subtest: rcs0
[552.283724] Dynamic subtest rcs0: SUCCESS (1.894s)
[552.296179] Starting dynamic subtest: bcs0
[554.268225] Dynamic subtest bcs0: SUCCESS (1.981s)
[554.281862] Starting dynamic subtest: vcs0
[556.251985] Dynamic subtest vcs0: SUCCESS (1.981s)
[556.264528] Starting dynamic subtest: vcs1
[558.299852] Dynamic subtest vcs1: SUCCESS (2.045s)
[558.312300] Starting dynamic subtest: vecs0
[560.283011] Dynamic subtest vecs0: SUCCESS (1.980s)
[560.296162] Starting dynamic subtest: ccs0
[562.268002] Dynamic subtest ccs0: SUCCESS (1.982s)
[562.270993] Subtest most-busy-idle-check-all: SUCCESS (11.882s)
[562.381964] [110/133] (459s left) gem_exec_balancer (waits)
[562.449126] Starting subtest: waits
[568.986286] Subtest waits: SUCCESS (6.537s)
[569.290174] [111/133] (452s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[569.397906] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[569.400384] Starting dynamic subtest: pipe-A-eDP-1
[571.648408] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.251s)
[571.659069] Starting dynamic subtest: pipe-B-eDP-1
[573.909900] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.263s)
[573.928502] Starting dynamic subtest: pipe-C-eDP-1
[576.094505] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.182s)
[576.106149] Starting dynamic subtest: pipe-D-eDP-1
[578.227786] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.130s)
[578.229955] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.833s)
[579.456232] [112/133] (442s left) perf (invalid-oa-metric-set-id)
[579.562939] Starting subtest: invalid-oa-metric-set-id
[579.574237] Subtest invalid-oa-metric-set-id: SUCCESS (0.010s)
[579.622114] [113/133] (442s left) kms_fbcon_fbt (fbc)
[579.678590] Starting subtest: fbc
[585.995496] Subtest fbc: SUCCESS (6.316s)
[587.084793] [114/133] (434s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[587.188953] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[587.193929] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[587.285576] [115/133] (434s left) kms_lease (lease-again)
[587.381390] Starting subtest: lease-again
[587.384214] Starting dynamic subtest: pipe-A-eDP-1
[587.387062] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s)
[587.398184] Starting dynamic subtest: pipe-B-eDP-1
[587.400822] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[587.411258] Starting dynamic subtest: pipe-C-eDP-1
[587.414066] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[587.424379] Starting dynamic subtest: pipe-D-eDP-1
[587.427065] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[587.429868] Subtest lease-again: SUCCESS (0.014s)
[587.508626] [116/133] (434s left) kms_chamelium_color (ctm-max)
[587.605250] Subtest ctm-max: SKIP (0.000s)
[587.657626] [117/133] (434s left) gem_softpin (zero)
[587.713813] Starting subtest: zero
[587.719034] Subtest zero: SUCCESS (0.005s)
[587.840121] [118/133] (434s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[587.939564] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[587.944615] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[588.061716] [119/133] (434s left) perf (missing-sample-flags)
[588.158747] Starting subtest: missing-sample-flags
[588.161231] Subtest missing-sample-flags: SUCCESS (0.000s)
[588.208891] [120/133] (434s left) core_auth (getclient-simple)
[588.248130] Starting subtest: getclient-simple
[588.265259] Subtest getclient-simple: SUCCESS (0.018s)
[588.364618] [121/133] (433s left) kms_color (degamma)
[588.464286] Starting subtest: degamma
[588.466866] Starting dynamic subtest: pipe-A-eDP-1
[589.184098] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.720s)
[589.195227] Starting dynamic subtest: pipe-B-eDP-1
[590.627823] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.441s)
[590.639721] Starting dynamic subtest: pipe-C-eDP-1
[592.012770] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.385s)
[592.023772] Starting dynamic subtest: pipe-D-eDP-1
[593.454947] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.439s)
[593.457598] Subtest degamma: SUCCESS (4.989s)
[594.315537] [122/133] (428s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[594.413997] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[594.418987] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[594.511290] [123/133] (427s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[594.604018] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[594.609224] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[595.747039] [124/133] (426s left) gem_ctx_create (basic-files)
[595.801929] Starting subtest: basic-files
[597.809732] Subtest basic-files: SUCCESS (2.008s)
[599.393110] [125/133] (423s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[599.640012] Starting subtest: cursor-rapid-movement-256x256
[599.642674] Starting dynamic subtest: pipe-A-eDP-1
[600.211972] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.569s)
[600.242985] Starting dynamic subtest: pipe-D-eDP-1
[601.494915] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.260s)
[601.497478] Subtest cursor-rapid-movement-256x256: SUCCESS (1.854s)
[602.321782] [126/133] (420s left) kms_chamelium_frames (dp-frame-dump)
[602.712470] Subtest dp-frame-dump: SKIP (0.000s)
[603.535352] [127/133] (419s left) gem_mmap_gtt (medium-copy)
[603.587982] Subtest medium-copy: SKIP (0.000s)
[603.684171] [128/133] (419s left) gem_ctx_param (invalid-param-set)
[603.729445] Starting subtest: invalid-param-set
[603.731954] Subtest invalid-param-set: SUCCESS (0.000s)
[603.804321] [129/133] (418s left) kms_psr (fbc-psr2-sprite-plane-move)
[603.897705] Starting subtest: fbc-psr2-sprite-plane-move
[603.900104] Starting dynamic subtest: eDP-1
[603.905151] Dynamic subtest eDP-1: SKIP (0.000s)
[603.909983] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[603.974609] [130/133] (418s left) gem_exec_balancer (full-pulse)
[604.030897] Starting subtest: full-pulse
[609.152458] Subtest full-pulse: SUCCESS (5.120s)
[609.473880] [131/133] (413s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[609.579998] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[609.584919] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[609.672261] [132/133] (413s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[609.794847] Starting subtest: flip-vs-cursor-crc-atomic
[610.496470] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.703s)
[611.386056] [133/133] (411s left) kms_vblank (invalid)
[611.482043] Starting subtest: invalid
[611.484253] Starting dynamic subtest: pipe-A-eDP-1
[611.888993] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.408s)
[611.891740] Subtest invalid: SUCCESS (0.410s)
[612.702605] 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.