[59.026250] Initializing watchdogs
[59.026298]   /dev/watchdog0
[59.040842] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.045441] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.047754] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.051167] [001/133] (960s left) i915_drm_fdinfo (busy-idle)
[59.120057] Starting subtest: busy-idle
[59.122069] Starting dynamic subtest: rcs0
[59.149240] Dynamic subtest rcs0: SKIP (0.029s)
[59.158592] Starting dynamic subtest: bcs0
[59.162999] Dynamic subtest bcs0: SKIP (0.000s)
[59.170644] Starting dynamic subtest: vcs0
[59.174775] Dynamic subtest vcs0: SKIP (0.000s)
[59.181898] Starting dynamic subtest: vcs1
[59.186208] Dynamic subtest vcs1: SKIP (0.000s)
[59.192733] Starting dynamic subtest: vecs0
[59.197155] Dynamic subtest vecs0: SKIP (0.000s)
[59.203471] Starting dynamic subtest: ccs0
[59.207857] Dynamic subtest ccs0: SKIP (0.000s)
[59.212223] Subtest busy-idle: SKIP (0.033s)
[59.244662] [002/133] (960s left) kms_hdr (static-toggle-dpms)
[59.345070] Starting subtest: static-toggle-dpms
[59.351558] Subtest static-toggle-dpms: SKIP (0.000s)
[59.410014] [003/133] (960s left) gem_ctx_param (basic-default)
[59.462673] Starting subtest: basic-default
[59.465224] Subtest basic-default: SUCCESS (0.000s)
[59.523949] [004/133] (960s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[59.625374] Starting subtest: psr-rgb565-draw-mmap-wc
[66.433306] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.809s)
[66.530185] [005/133] (953s left) gem_render_copy (yf-tiled-ccs-to-linear)
[66.581671] Starting subtest: yf-tiled-ccs-to-linear
[66.586344] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[66.764703] [006/133] (952s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[66.878167] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[73.724602] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.848s)
[73.873975] [007/133] (945s left) i915_pm_rps (min-max-config-loaded)
[73.934648] Starting subtest: min-max-config-loaded
[73.938907] Subtest min-max-config-loaded: SKIP (0.001s)
[74.048215] [008/133] (945s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[74.137323] Starting subtest: fbcpsr-shrfb-scaledprimary
[79.913573] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.777s)
[80.042704] [009/133] (939s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[80.142488] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[87.164189] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.024s)
[87.309099] [010/133] (932s left) kms_rotation_crc (cursor-rotation-180)
[87.404502] Starting subtest: cursor-rotation-180
[88.925563] Subtest cursor-rotation-180: SUCCESS (1.522s)
[90.112949] [011/133] (929s left) syncobj_wait (reset-multiple-signaled)
[90.179086] Starting subtest: reset-multiple-signaled
[90.181449] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[90.286251] [012/133] (929s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[90.344328] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[90.346688] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s)
[90.452710] [013/133] (929s left) kms_psr (psr2-basic)
[90.548884] Starting subtest: psr2-basic
[90.551224] Starting dynamic subtest: eDP-1
[92.166219] Dynamic subtest eDP-1: SUCCESS (1.617s)
[92.168126] Subtest psr2-basic: SUCCESS (1.617s)
[92.962639] [014/133] (927s left) kms_vblank (ts-continuation-modeset)
[93.054176] Starting subtest: ts-continuation-modeset
[93.056084] Starting dynamic subtest: pipe-A-eDP-1
[94.525535] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.472s)
[94.538304] Starting dynamic subtest: pipe-D-eDP-1
[96.682634] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.153s)
[96.684802] Subtest ts-continuation-modeset: SUCCESS (3.628s)
[97.483909] [015/133] (922s left) syncobj_timeline (wait-for-submit-snapshot)
[97.542065] Starting subtest: wait-for-submit-snapshot
[97.623551] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[97.711686] [016/133] (922s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[97.778559] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[97.841235] [017/133] (922s left) gem_ctx_param (invalid-get-ringsize)
[97.897742] Starting subtest: invalid-get-ringsize
[97.900233] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[98.005801] [018/133] (922s left) gem_tiled_fence_blits (normal)
[98.062272] Subtest normal: SKIP (0.000s)
[98.130629] [019/133] (922s left) gem_linear_blits (interruptible)
[98.386366] Starting subtest: interruptible
[102.719347] Subtest interruptible: SUCCESS (4.334s)
[102.841603] [020/133] (917s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[102.978295] Starting subtest: x-tiled-64bpp-rotate-270
[102.998607] Subtest x-tiled-64bpp-rotate-270: SKIP (0.020s)
[103.119326] [021/133] (917s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[103.207339] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[103.209642] Starting dynamic subtest: pipe-A
[103.557247] Dynamic subtest pipe-A: SUCCESS (0.351s)
[103.566188] Starting dynamic subtest: pipe-B
[105.035639] Dynamic subtest pipe-B: SUCCESS (1.477s)
[105.049448] Starting dynamic subtest: pipe-C
[106.443501] Dynamic subtest pipe-C: SUCCESS (1.406s)
[106.451215] Starting dynamic subtest: pipe-D
[107.879092] Dynamic subtest pipe-D: SUCCESS (1.434s)
[107.881397] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.674s)
[109.021488] [022/133] (911s left) kms_pm_rpm (system-suspend-modeset)
[111.074466] Starting subtest: system-suspend-modeset
[131.230411] Subtest system-suspend-modeset: SUCCESS (4.757s)
[131.610155] [023/133] (888s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[131.684272] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[131.686861] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[131.778051] [024/133] (888s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[131.862381] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[131.866636] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[131.927926] [025/133] (888s left) gem_ctx_param (non-root-set)
[131.981925] Starting subtest: non-root-set
[132.006489] Subtest non-root-set: SUCCESS (0.024s)
[132.109290] [026/133] (888s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[132.228112] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[132.232625] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[132.316172] [027/133] (888s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[132.410878] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[133.201818] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.792s)
[133.373112] [028/133] (887s left) gem_ctx_persistence (file)
[133.440074] Starting subtest: file
[133.573171] Subtest file: SUCCESS (0.133s)
[133.707580] [029/133] (886s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[133.792193] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[133.794567] Starting dynamic subtest: pipe-A-default-mode
[134.972084] Dynamic subtest pipe-A-default-mode: SKIP (1.178s)
[134.976602] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.180s)
[135.117568] [030/133] (885s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[135.210640] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[135.212831] Starting dynamic subtest: pipe-A
[136.259135] Dynamic subtest pipe-A: SUCCESS (1.050s)
[136.269177] Starting dynamic subtest: pipe-B
[138.353698] Dynamic subtest pipe-B: SUCCESS (2.094s)
[138.362506] Starting dynamic subtest: pipe-C
[139.556645] Dynamic subtest pipe-C: SUCCESS (1.201s)
[139.571360] Starting dynamic subtest: pipe-D
[140.783188] Dynamic subtest pipe-D: SUCCESS (1.226s)
[140.785526] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.573s)
[141.993041] [031/133] (878s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[142.117662] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[142.119964] Starting dynamic subtest: A-eDP1
[145.709701] Dynamic subtest A-eDP1: SUCCESS (3.587s)
[145.718839] Starting dynamic subtest: B-eDP1
[148.933303] Dynamic subtest B-eDP1: SUCCESS (3.221s)
[148.942174] Starting dynamic subtest: C-eDP1
[152.133128] Dynamic subtest C-eDP1: SUCCESS (3.200s)
[152.142281] Starting dynamic subtest: D-eDP1
[155.234327] Dynamic subtest D-eDP1: SUCCESS (3.099s)
[155.236199] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.116s)
[156.045371] [032/133] (864s left) gem_exec_parallel (contexts)
[156.113194] Starting subtest: contexts
[156.115660] Starting dynamic subtest: rcs0
[159.127392] Dynamic subtest rcs0: SUCCESS (3.012s)
[159.135671] Starting dynamic subtest: bcs0
[162.574952] Dynamic subtest bcs0: SUCCESS (3.446s)
[162.586292] Starting dynamic subtest: vcs0
[166.664933] Dynamic subtest vcs0: SUCCESS (4.088s)
[166.673948] Starting dynamic subtest: vcs1
[170.762973] Dynamic subtest vcs1: SUCCESS (4.097s)
[170.772003] Starting dynamic subtest: vecs0
[174.736707] Dynamic subtest vecs0: SUCCESS (3.971s)
[174.748454] Starting dynamic subtest: ccs0
[178.307733] Dynamic subtest ccs0: SUCCESS (3.569s)
[178.310568] Subtest contexts: SUCCESS (22.193s)
[178.495822] [033/133] (842s left) gem_exec_alignment (many)
[178.574894] Starting subtest: many
[201.716829] Subtest many: SUCCESS (23.142s)
[205.338214] [034/133] (815s left) kms_psr (fbc-pr-no-drrs)
[205.487271] Starting subtest: fbc-pr-no-drrs
[205.491642] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[205.559692] [035/133] (815s left) kms_vrr (flip-suspend)
[205.653538] Starting subtest: flip-suspend
[205.660124] Subtest flip-suspend: SKIP (0.000s)
[205.723659] [036/133] (815s left) i915_module_load (reload)
[205.765364] Starting subtest: reload
[209.030803] Subtest reload: SUCCESS (3.266s)
[209.074384] [037/133] (811s left) gem_vm_create (invalid-destroy)
[210.279542] Starting subtest: invalid-destroy
[210.281888] Subtest invalid-destroy: SUCCESS (0.002s)
[210.401385] [038/133] (810s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[210.503104] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[210.505343] Starting dynamic subtest: pipe-A-eDP-1
[210.514268] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[210.523360] Starting dynamic subtest: pipe-B-eDP-1
[210.532426] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[210.542210] Starting dynamic subtest: pipe-C-eDP-1
[210.550642] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[210.558135] Starting dynamic subtest: pipe-D-eDP-1
[210.566650] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[210.570687] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[212.745884] [039/133] (808s left) kms_dsc (dsc-with-bpc-formats)
[212.833999] Starting subtest: dsc-with-bpc-formats
[212.944663] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[212.984634] [040/133] (808s left) kms_flip (dpms-off-confusion)
[213.085084] Starting subtest: dpms-off-confusion
[213.087344] Starting dynamic subtest: A-eDP1
[221.849553] Dynamic subtest A-eDP1: SUCCESS (8.766s)
[221.858876] Starting dynamic subtest: B-eDP1
[230.492612] Dynamic subtest B-eDP1: SUCCESS (8.641s)
[230.501392] Starting dynamic subtest: C-eDP1
[239.121166] Dynamic subtest C-eDP1: SUCCESS (8.627s)
[239.129218] Starting dynamic subtest: D-eDP1
[247.750678] Dynamic subtest D-eDP1: SUCCESS (8.627s)
[247.755179] Subtest dpms-off-confusion: SUCCESS (34.672s)
[248.912554] [041/133] (772s left) gem_exec_schedule (submit-early-slice)
[248.988507] Starting subtest: submit-early-slice
[248.990440] Starting dynamic subtest: rcs0
[249.026089] Dynamic subtest rcs0: SUCCESS (0.044s)
[249.034949] Starting dynamic subtest: bcs0
[249.066444] Dynamic subtest bcs0: SUCCESS (0.039s)
[249.075669] Starting dynamic subtest: vcs0
[249.101104] Dynamic subtest vcs0: SUCCESS (0.034s)
[249.109963] Starting dynamic subtest: vcs1
[249.137504] Dynamic subtest vcs1: SUCCESS (0.036s)
[249.146630] Starting dynamic subtest: vecs0
[249.171274] Dynamic subtest vecs0: SUCCESS (0.033s)
[249.180045] Starting dynamic subtest: ccs0
[249.208375] Dynamic subtest ccs0: SUCCESS (0.036s)
[249.210583] Subtest submit-early-slice: SUCCESS (0.227s)
[250.382738] [042/133] (770s left) gem_exec_schedule (noreorder)
[250.563755] Starting subtest: noreorder
[250.566352] Starting dynamic subtest: rcs0
[250.632692] Dynamic subtest rcs0: SUCCESS (0.069s)
[250.644421] Starting dynamic subtest: vcs0
[252.257200] Dynamic subtest vcs0: SUCCESS (1.621s)
[252.271223] Starting dynamic subtest: vcs1
[254.241185] Dynamic subtest vcs1: SUCCESS (1.981s)
[254.252201] Starting dynamic subtest: vecs0
[256.304090] Dynamic subtest vecs0: SUCCESS (2.060s)
[256.315843] Starting dynamic subtest: ccs0
[256.375159] Dynamic subtest ccs0: SUCCESS (0.070s)
[256.377690] Subtest noreorder: SUCCESS (5.814s)
[256.563295] [043/133] (764s left) gem_close (many-handles-one-vma)
[256.640873] Starting subtest: many-handles-one-vma
[256.686550] Subtest many-handles-one-vma: SUCCESS (0.046s)
[256.810522] [044/133] (764s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[256.920682] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[256.924611] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[257.028429] [045/133] (764s left) kms_plane_alpha_blend (alpha-basic)
[257.127163] Starting subtest: alpha-basic
[257.410385] Starting dynamic subtest: pipe-A-eDP-1
[259.321318] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.910s)
[259.350329] Starting dynamic subtest: pipe-D-eDP-1
[261.982037] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.640s)
[261.984271] Subtest alpha-basic: SUCCESS (4.857s)
[262.773143] [046/133] (758s left) kms_psr (psr2-cursor-plane-move)
[262.867183] Starting subtest: psr2-cursor-plane-move
[262.869574] Starting dynamic subtest: eDP-1
[264.563568] Dynamic subtest eDP-1: SUCCESS (1.697s)
[264.565923] Subtest psr2-cursor-plane-move: SUCCESS (1.698s)
[265.362806] [047/133] (755s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[265.464390] Starting subtest: y-tiled-64bpp-rotate-270
[265.468719] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[265.563419] [048/133] (755s left) dmabuf_sync_file (export-multiwait)
[265.652714] Starting subtest: export-multiwait
[265.654997] Subtest export-multiwait: SUCCESS (0.002s)
[265.709570] [FACT dmabuf_sync_file (export-multiwait)] new: kernel.kmod_is_loaded.vgem: true
[265.713208] [049/133] (755s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[265.820802] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[265.825191] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[265.942361] [050/133] (755s left) gem_mmap_gtt (basic-small-copy)
[266.009637] Subtest basic-small-copy: SKIP (0.000s)
[266.074014] [051/133] (755s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[266.593622] Starting subtest: syncobj-backward-timeline-chain-engines
[266.691924] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.099s)
[268.457027] [052/133] (753s left) gem_userptr_blits (process-exit-busy)
[268.516509] Starting subtest: process-exit-busy
[268.529758] Subtest process-exit-busy: SUCCESS (0.014s)
[268.659646] [053/133] (752s left) kms_big_fb (linear-64bpp-rotate-90)
[268.770735] Starting subtest: linear-64bpp-rotate-90
[268.789573] Subtest linear-64bpp-rotate-90: SKIP (0.018s)
[268.893338] [054/133] (752s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[268.994272] Starting subtest: extended-modeset-hang-oldfb-with-reset
[268.996527] Starting dynamic subtest: pipe-A
[280.553265] Dynamic subtest pipe-A: SUCCESS (11.555s)
[280.566371] Starting dynamic subtest: pipe-D
[292.817124] Dynamic subtest pipe-D: SUCCESS (12.261s)
[292.819318] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.821s)
[293.616959] [055/133] (728s left) gem_readwrite (new-obj)
[293.697465] Subtest new-obj: SKIP (0.000s)
[293.758080] [056/133] (727s left) gem_exec_whisper (basic-forked-all)
[293.812796] Starting subtest: basic-forked-all
[307.363967] Subtest basic-forked-all: SUCCESS (13.548s)
[307.548631] [057/133] (714s left) gem_mmap_offset (mmap-boundaries)
[307.606427] Starting subtest: mmap-boundaries
[307.608407] Starting dynamic subtest: smem0
[307.891702] Dynamic subtest smem0: SUCCESS (0.284s)
[307.894344] Subtest mmap-boundaries: SUCCESS (0.286s)
[308.027713] [058/133] (713s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[308.111643] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[308.136998] Starting dynamic subtest: pipe-A-plane-0
[308.814408] Dynamic subtest pipe-A-plane-0: SUCCESS (0.678s)
[308.826703] Starting dynamic subtest: pipe-A-plane-3
[309.248816] Dynamic subtest pipe-A-plane-3: SUCCESS (0.433s)
[310.402190] Starting dynamic subtest: pipe-B-plane-0
[311.095527] Dynamic subtest pipe-B-plane-0: SUCCESS (0.700s)
[311.105918] Starting dynamic subtest: pipe-B-plane-3
[311.538561] Dynamic subtest pipe-B-plane-3: SUCCESS (0.444s)
[311.848132] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.736s)
[312.678206] [059/133] (709s left) api_intel_allocator (reopen)
[312.733067] Starting subtest: reopen
[312.735037] Subtest reopen: SUCCESS (0.005s)
[312.862902] [060/133] (708s left) gem_mmap (pf-nonblock)
[312.915342] Subtest pf-nonblock: SKIP (0.000s)
[312.979663] [061/133] (708s left) syncobj_timeline (wait-any-snapshot)
[313.035727] Starting subtest: wait-any-snapshot
[313.116194] Subtest wait-any-snapshot: SUCCESS (0.081s)
[313.190507] [062/133] (708s left) i915_query (query-garbage)
[313.241373] Starting subtest: query-garbage
[313.243568] Subtest query-garbage: SUCCESS (0.000s)
[313.337501] [063/133] (708s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[313.397207] Starting subtest: multi-wait-all-for-submit-signaled
[313.399562] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[313.498162] [064/133] (708s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[313.549664] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[313.554102] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[313.730166] [065/133] (708s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[313.821555] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[313.833217] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[313.908078] [066/133] (708s left) gem_create (create-valid-nonaligned)
[313.959119] Starting subtest: create-valid-nonaligned
[313.960963] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[314.144455] [067/133] (707s left) gem_barrier_race (remote-request)
[314.210072] Starting subtest: remote-request
[314.212486] Starting dynamic subtest: rcs0
[319.392354] Dynamic subtest rcs0: SUCCESS (5.182s)
[319.397901] Subtest remote-request: SUCCESS (5.185s)
[319.548066] [068/133] (702s left) kms_prop_blob (blob-prop-core)
[319.605742] Starting subtest: blob-prop-core
[319.607612] Subtest blob-prop-core: SUCCESS (0.000s)
[319.701357] [069/133] (702s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[319.811198] Starting subtest: fbcpsr-suspend
[360.306969] Subtest fbcpsr-suspend: SUCCESS (9.991s)
[360.453384] [070/133] (661s left) gem_mmap_gtt (basic-read)
[360.528373] Subtest basic-read: SKIP (0.000s)
[360.590043] [071/133] (661s left) kms_flip (2x-blocking-wf_vblank)
[360.678670] Starting subtest: 2x-blocking-wf_vblank
[360.689561] Subtest 2x-blocking-wf_vblank: SKIP (0.010s)
[360.768394] [072/133] (661s left) kms_psr (psr-sprite-plane-move)
[360.855731] Starting subtest: psr-sprite-plane-move
[360.857992] Starting dynamic subtest: eDP-1
[362.642720] Dynamic subtest eDP-1: SUCCESS (1.786s)
[362.645291] Subtest psr-sprite-plane-move: SUCCESS (1.788s)
[363.467470] [073/133] (658s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[363.567067] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[363.571617] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[363.670668] [074/133] (658s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[363.730256] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[363.837777] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.107s)
[363.920013] [075/133] (658s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[364.020547] Starting subtest: fbc-psr2-cursor-mmap-gtt
[364.022902] Starting dynamic subtest: eDP-1
[364.027053] Dynamic subtest eDP-1: SKIP (0.000s)
[364.031265] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[364.094893] [076/133] (658s left) kms_getfb (getfb-handle-protection)
[364.188926] Starting subtest: getfb-handle-protection
[364.206651] Subtest getfb-handle-protection: SUCCESS (0.018s)
[364.307635] [077/133] (658s left) kms_addfb_basic (bad-pitch-128)
[364.359628] Starting subtest: bad-pitch-128
[364.361811] Subtest bad-pitch-128: SUCCESS (0.000s)
[364.492997] [078/133] (658s left) gem_partial_pwrite_pread (writes-after-reads-display)
[364.552612] Subtest writes-after-reads-display: SKIP (0.000s)
[364.623114] [079/133] (658s left) kms_content_protection (atomic)
[364.758664] Starting subtest: atomic
[364.763309] Subtest atomic: SKIP (0.000s)
[364.887787] [080/133] (657s left) kms_cursor_edge_walk (256x256-left-edge)
[364.979754] Starting subtest: 256x256-left-edge
[364.981622] Starting dynamic subtest: pipe-A-eDP-1
[368.424636] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.440s)
[368.435359] Starting dynamic subtest: pipe-D-eDP-1
[371.559329] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.132s)
[371.561785] Subtest 256x256-left-edge: SUCCESS (6.575s)
[372.371995] [081/133] (650s left) kms_pm_rpm (cursor)
[373.897567] Starting subtest: cursor
[373.902203] Subtest cursor: SKIP (0.000s)
[374.612392] [082/133] (648s left) kms_atomic (plane-invalid-params-fence)
[374.704315] Starting subtest: plane-invalid-params-fence
[374.706539] Starting dynamic subtest: pipe-A-eDP-1
[375.082128] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.375s)
[375.084130] Subtest plane-invalid-params-fence: SUCCESS (0.376s)
[375.925661] [083/133] (646s left) kms_async_flips (crc)
[376.023652] Starting subtest: crc
[376.409253] Starting dynamic subtest: pipe-A-eDP-1
[379.342050] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.931s)
[379.741198] Starting dynamic subtest: pipe-B-eDP-1
[382.605701] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.875s)
[382.980650] Starting dynamic subtest: pipe-C-eDP-1
[385.913452] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.941s)
[386.281370] Starting dynamic subtest: pipe-D-eDP-1
[389.141413] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.869s)
[389.143696] Subtest crc: SUCCESS (13.115s)
[390.312399] [084/133] (632s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[390.412629] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[390.416744] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[390.518571] [085/133] (632s left) kms_plane_cursor (viewport)
[390.605817] Starting subtest: viewport
[390.610168] Starting dynamic subtest: pipe-A-eDP-1-size-64
[393.092614] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.488s)
[393.152682] Starting dynamic subtest: pipe-A-eDP-1-size-128
[395.739288] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.593s)
[395.799528] Starting dynamic subtest: pipe-A-eDP-1-size-256
[398.306343] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.515s)
[398.655947] Starting dynamic subtest: pipe-B-eDP-1-size-64
[401.799307] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.153s)
[401.858786] Starting dynamic subtest: pipe-B-eDP-1-size-128
[404.367575] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.516s)
[404.428490] Starting dynamic subtest: pipe-B-eDP-1-size-256
[406.924977] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.504s)
[407.284428] Starting dynamic subtest: pipe-C-eDP-1-size-64
[410.033837] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.762s)
[410.071941] Starting dynamic subtest: pipe-C-eDP-1-size-128
[412.168029] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.103s)
[412.207100] Starting dynamic subtest: pipe-C-eDP-1-size-256
[414.278864] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.080s)
[414.612369] Starting dynamic subtest: pipe-D-eDP-1-size-64
[417.390838] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.791s)
[417.428874] Starting dynamic subtest: pipe-D-eDP-1-size-128
[419.478671] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.058s)
[419.518028] Starting dynamic subtest: pipe-D-eDP-1-size-256
[421.701661] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.191s)
[422.023539] Subtest viewport: SUCCESS (31.409s)
[422.829717] [086/133] (600s left) i915_pm_rps (thresholds-idle)
[422.891181] Starting subtest: thresholds-idle
[422.895945] Subtest thresholds-idle: SKIP (0.001s)
[423.004879] [087/133] (599s left) kms_addfb_basic (bo-too-small)
[423.094793] Starting subtest: bo-too-small
[423.097027] Subtest bo-too-small: SUCCESS (0.000s)
[423.206769] [088/133] (599s left) gem_exec_whisper (basic-queues-forked)
[423.267030] Starting subtest: basic-queues-forked
[447.852272] Subtest basic-queues-forked: SUCCESS (24.575s)
[448.039099] [089/133] (575s left) perf (invalid-oa-format-id)
[448.137143] Starting subtest: invalid-oa-format-id
[448.150205] Subtest invalid-oa-format-id: SUCCESS (0.013s)
[448.191849] [090/133] (574s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[448.288495] Starting subtest: psr2-cursor-plane-update-sf
[448.290708] Starting dynamic subtest: pipe-A-eDP-1
[448.880184] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.593s)
[448.891341] Starting dynamic subtest: pipe-B-eDP-1
[450.117246] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.239s)
[450.119658] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.834s)
[450.996078] [091/133] (572s left) gem_exec_reloc (basic-cpu-gtt)
[451.058710] Subtest basic-cpu-gtt: SKIP (0.000s)
[451.133189] [092/133] (572s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[451.215319] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[451.217458] Starting dynamic subtest: pipe-A-eDP-1
[451.238889] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[451.249675] Starting dynamic subtest: pipe-B-eDP-1
[451.269880] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[451.279520] Starting dynamic subtest: pipe-C-eDP-1
[451.300015] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[451.309834] Starting dynamic subtest: pipe-D-eDP-1
[451.331741] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[451.335823] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[453.481025] [093/133] (569s left) gem_close_race (multigpu-basic-process)
[453.537365] Starting subtest: multigpu-basic-process
[453.541981] Subtest multigpu-basic-process: SKIP (0.000s)
[453.762100] [094/133] (569s left) gen9_exec_parse (batch-invalid-length)
[453.824641] Subtest batch-invalid-length: SKIP (0.000s)
[453.890854] [095/133] (569s left) gem_exec_fence (syncobj-unused-fence)
[454.330647] Starting subtest: syncobj-unused-fence
[454.332650] Subtest syncobj-unused-fence: SUCCESS (0.005s)
[455.947277] [096/133] (567s left) gem_exec_nop (basic-sequential)
[456.022436] Starting subtest: basic-sequential
[471.903296] Subtest basic-sequential: SUCCESS (15.894s)
[472.141387] [097/133] (551s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[472.246578] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[472.250976] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[472.360236] [098/133] (551s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[472.451347] Starting subtest: 4-tiled-64bpp-rotate-90
[472.470110] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.018s)
[472.576746] [099/133] (550s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[472.634729] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[472.694795] [100/133] (550s left) kms_fence_pin_leak
[472.880451] [101/133] (550s left) prime_busy (hang-wait)
[472.949002] Starting subtest: hang-wait
[472.951233] Starting dynamic subtest: rcs0
[499.323119] Dynamic subtest rcs0: SUCCESS (26.372s)
[499.332442] Starting dynamic subtest: bcs0
[506.416399] Dynamic subtest bcs0: SUCCESS (7.089s)
[506.426151] Starting dynamic subtest: vcs0
[513.387533] Dynamic subtest vcs0: SUCCESS (6.970s)
[513.398465] Starting dynamic subtest: vcs1
[520.427901] Dynamic subtest vcs1: SUCCESS (7.038s)
[520.440354] Starting dynamic subtest: vecs0
[527.405105] Dynamic subtest vecs0: SUCCESS (6.971s)
[527.416753] Starting dynamic subtest: ccs0
[541.308614] Dynamic subtest ccs0: SUCCESS (13.899s)
[541.311263] Subtest hang-wait: SUCCESS (68.352s)
[541.448334] [102/133] (482s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[541.854525] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[542.686451] [103/133] (480s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[542.786741] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[542.790770] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[542.891865] [104/133] (480s left) gem_unref_active_buffers
[543.099495] [105/133] (480s left) kms_rmfb (rmfb-ioctl)
[543.195382] Starting subtest: rmfb-ioctl
[543.197577] Starting dynamic subtest: pipe-A-eDP-1
[543.301215] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.107s)
[543.314159] Starting dynamic subtest: pipe-B-eDP-1
[544.469497] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.166s)
[544.481675] Starting dynamic subtest: pipe-C-eDP-1
[545.673952] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.203s)
[545.686602] Starting dynamic subtest: pipe-D-eDP-1
[546.807350] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.132s)
[546.809688] Subtest rmfb-ioctl: SUCCESS (3.614s)
[547.960615] [106/133] (475s left) gem_exec_reloc (basic-cpu-read-noreloc)
[548.024251] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[548.107896] [107/133] (475s left) kms_cursor_crc (cursor-dpms)
[548.249247] Starting subtest: cursor-dpms
[548.251501] Starting dynamic subtest: pipe-A-eDP-1
[551.293161] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.042s)
[551.304126] Starting dynamic subtest: pipe-D-eDP-1
[554.978193] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.682s)
[554.980789] Subtest cursor-dpms: SUCCESS (6.727s)
[555.829296] [108/133] (468s left) kms_debugfs (display-off-read-all)
[555.910840] Starting subtest: display-off-read-all
[556.202931] Subtest display-off-read-all: SUCCESS (0.292s)
[557.065431] [109/133] (466s left) perf_pmu (most-busy-idle-check-all)
[557.106252] Starting subtest: most-busy-idle-check-all
[557.108103] Starting dynamic subtest: rcs0
[558.818329] Dynamic subtest rcs0: SUCCESS (1.710s)
[558.830087] Starting dynamic subtest: bcs0
[560.737251] Dynamic subtest bcs0: SUCCESS (1.916s)
[560.750224] Starting dynamic subtest: vcs0
[561.825402] Dynamic subtest vcs0: SUCCESS (1.085s)
[561.838529] Starting dynamic subtest: vcs1
[563.809624] Dynamic subtest vcs1: SUCCESS (1.981s)
[563.820925] Starting dynamic subtest: vecs0
[565.793825] Dynamic subtest vecs0: SUCCESS (1.981s)
[565.807450] Starting dynamic subtest: ccs0
[567.842538] Dynamic subtest ccs0: SUCCESS (2.045s)
[567.845662] Subtest most-busy-idle-check-all: SUCCESS (10.735s)
[567.953533] [110/133] (456s left) gem_exec_balancer (waits)
[568.037092] Starting subtest: waits
[574.554892] Subtest waits: SUCCESS (6.512s)
[574.858470] [111/133] (449s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[574.960548] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[574.962464] Starting dynamic subtest: pipe-A-eDP-1
[577.037454] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.077s)
[577.047731] Starting dynamic subtest: pipe-B-eDP-1
[579.216020] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.177s)
[579.226024] Starting dynamic subtest: pipe-C-eDP-1
[581.298979] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.082s)
[581.309693] Starting dynamic subtest: pipe-D-eDP-1
[583.366361] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.067s)
[583.368681] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.408s)
[584.600495] [112/133] (439s left) perf (invalid-oa-metric-set-id)
[584.684636] Starting subtest: invalid-oa-metric-set-id
[584.695148] Subtest invalid-oa-metric-set-id: SUCCESS (0.009s)
[584.745579] [113/133] (439s left) kms_fbcon_fbt (fbc)
[584.802061] Starting subtest: fbc
[591.148830] Subtest fbc: SUCCESS (6.347s)
[592.241014] [114/133] (431s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[592.349417] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[592.353888] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[592.461921] [115/133] (431s left) kms_lease (lease-again)
[592.556947] Starting subtest: lease-again
[592.560193] Starting dynamic subtest: pipe-A-eDP-1
[592.562575] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s)
[592.574430] Starting dynamic subtest: pipe-B-eDP-1
[592.577094] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[592.588470] Starting dynamic subtest: pipe-C-eDP-1
[592.590340] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[592.601797] Starting dynamic subtest: pipe-D-eDP-1
[592.603666] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[592.605636] Subtest lease-again: SUCCESS (0.014s)
[592.695408] [116/133] (431s left) kms_chamelium_color (ctm-max)
[592.792936] Subtest ctm-max: SKIP (0.000s)
[592.840928] [117/133] (431s left) gem_softpin (zero)
[592.888824] Starting subtest: zero
[592.893534] Subtest zero: SUCCESS (0.004s)
[593.022020] [118/133] (431s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[593.127759] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[593.131757] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[593.219892] [119/133] (431s left) perf (missing-sample-flags)
[593.306347] Starting subtest: missing-sample-flags
[593.308323] Subtest missing-sample-flags: SUCCESS (0.000s)
[593.354452] [120/133] (431s left) core_auth (getclient-simple)
[593.387391] Starting subtest: getclient-simple
[593.411337] Subtest getclient-simple: SUCCESS (0.023s)
[593.504516] [121/133] (430s left) kms_color (degamma)
[593.609730] Starting subtest: degamma
[593.611491] Starting dynamic subtest: pipe-A-eDP-1
[594.329661] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.719s)
[594.340642] Starting dynamic subtest: pipe-B-eDP-1
[595.765272] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.435s)
[595.777475] Starting dynamic subtest: pipe-C-eDP-1
[597.160322] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.393s)
[597.170946] Starting dynamic subtest: pipe-D-eDP-1
[598.490657] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.330s)
[598.492839] Subtest degamma: SUCCESS (4.881s)
[599.295168] [122/133] (425s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[599.402609] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[599.406917] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[599.503999] [123/133] (425s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[599.595913] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[599.600599] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[600.725814] [124/133] (423s left) gem_ctx_create (basic-files)
[600.791240] Starting subtest: basic-files
[603.001330] Subtest basic-files: SUCCESS (2.212s)
[604.813555] [125/133] (419s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[605.065426] Starting subtest: cursor-rapid-movement-256x256
[605.067620] Starting dynamic subtest: pipe-A-eDP-1
[605.612250] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.542s)
[605.641534] Starting dynamic subtest: pipe-D-eDP-1
[606.838279] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.206s)
[606.840157] Subtest cursor-rapid-movement-256x256: SUCCESS (1.773s)
[607.682132] [126/133] (416s left) kms_chamelium_frames (dp-frame-dump)
[608.079201] Subtest dp-frame-dump: SKIP (0.000s)
[608.894439] [127/133] (415s left) gem_mmap_gtt (medium-copy)
[608.951906] Subtest medium-copy: SKIP (0.000s)
[609.010983] [128/133] (415s left) gem_ctx_param (invalid-param-set)
[609.071456] Starting subtest: invalid-param-set
[609.073738] Subtest invalid-param-set: SUCCESS (0.000s)
[609.142981] [129/133] (415s left) kms_psr (fbc-psr2-sprite-plane-move)
[609.230061] Starting subtest: fbc-psr2-sprite-plane-move
[609.232215] Starting dynamic subtest: eDP-1
[609.236165] Dynamic subtest eDP-1: SKIP (0.000s)
[609.240119] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[609.307285] [130/133] (415s left) gem_exec_balancer (full-pulse)
[609.361753] Starting subtest: full-pulse
[613.663800] Subtest full-pulse: SUCCESS (4.302s)
[613.976457] [131/133] (410s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[614.073658] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[614.077862] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[614.185692] [132/133] (410s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[614.293628] Starting subtest: flip-vs-cursor-crc-atomic
[614.987189] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.692s)
[615.847338] [133/133] (409s left) kms_vblank (invalid)
[615.939073] Starting subtest: invalid
[615.941210] Starting dynamic subtest: pipe-A-eDP-1
[616.337073] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.396s)
[616.338964] Subtest invalid: SUCCESS (0.398s)
[617.166837] 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.