[57.387528] Initializing watchdogs
[57.387595]   /dev/watchdog0
[57.401234] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.405468] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.407577] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.410846] [001/133] (960s left) i915_drm_fdinfo (busy-idle)
[57.472150] Starting subtest: busy-idle
[57.474468] Starting dynamic subtest: rcs0
[57.502714] Dynamic subtest rcs0: SKIP (0.029s)
[57.512519] Starting dynamic subtest: bcs0
[57.516865] Dynamic subtest bcs0: SKIP (0.000s)
[57.523597] Starting dynamic subtest: vcs0
[57.527991] Dynamic subtest vcs0: SKIP (0.000s)
[57.534595] Starting dynamic subtest: vcs1
[57.538714] Dynamic subtest vcs1: SKIP (0.000s)
[57.544804] Starting dynamic subtest: vecs0
[57.548898] Dynamic subtest vecs0: SKIP (0.000s)
[57.554798] Starting dynamic subtest: ccs0
[57.559087] Dynamic subtest ccs0: SKIP (0.000s)
[57.563142] Subtest busy-idle: SKIP (0.032s)
[57.596302] [002/133] (960s left) kms_hdr (static-toggle-dpms)
[57.693593] Starting subtest: static-toggle-dpms
[57.699838] Subtest static-toggle-dpms: SKIP (0.000s)
[57.764015] [003/133] (960s left) gem_ctx_param (basic-default)
[57.823406] Starting subtest: basic-default
[57.825872] Subtest basic-default: SUCCESS (0.000s)
[57.895210] [004/133] (960s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[57.986262] Starting subtest: psr-rgb565-draw-mmap-wc
[64.795706] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.773s)
[64.905281] [005/133] (953s left) gem_render_copy (yf-tiled-ccs-to-linear)
[64.961837] Starting subtest: yf-tiled-ccs-to-linear
[64.966770] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[65.159205] [006/133] (952s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[65.265940] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[72.187789] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.909s)
[72.345060] [007/133] (945s left) i915_pm_rps (min-max-config-loaded)
[72.409840] Starting subtest: min-max-config-loaded
[72.414537] Subtest min-max-config-loaded: SKIP (0.001s)
[72.512043] [008/133] (945s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[72.611149] Starting subtest: fbcpsr-shrfb-scaledprimary
[78.451865] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.839s)
[78.579700] [009/133] (939s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[78.678619] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[85.657942] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.979s)
[85.777566] [010/133] (932s left) kms_rotation_crc (cursor-rotation-180)
[85.874247] Starting subtest: cursor-rotation-180
[87.361430] Subtest cursor-rotation-180: SUCCESS (1.488s)
[88.561772] [011/133] (929s left) syncobj_wait (reset-multiple-signaled)
[88.621106] Starting subtest: reset-multiple-signaled
[88.623458] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[88.735632] [012/133] (929s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[88.792080] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[88.794443] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s)
[88.876087] [013/133] (929s left) kms_psr (psr2-basic)
[88.971049] Starting subtest: psr2-basic
[88.973385] Starting dynamic subtest: eDP-1
[90.533986] Dynamic subtest eDP-1: SUCCESS (1.563s)
[90.536305] Subtest psr2-basic: SUCCESS (1.564s)
[91.331500] [014/133] (927s left) kms_vblank (ts-continuation-modeset)
[91.421738] Starting subtest: ts-continuation-modeset
[91.423873] Starting dynamic subtest: pipe-A-eDP-1
[92.879038] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.455s)
[92.893828] Starting dynamic subtest: pipe-D-eDP-1
[95.035137] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.156s)
[95.037514] Subtest ts-continuation-modeset: SUCCESS (3.614s)
[95.846033] [015/133] (922s left) syncobj_timeline (wait-for-submit-snapshot)
[95.915056] Starting subtest: wait-for-submit-snapshot
[95.997066] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[96.072674] [016/133] (922s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[96.142517] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[96.193633] [017/133] (922s left) gem_ctx_param (invalid-get-ringsize)
[96.259321] Starting subtest: invalid-get-ringsize
[96.261780] Subtest invalid-get-ringsize: SUCCESS (0.003s)
[96.363242] [018/133] (922s left) gem_tiled_fence_blits (normal)
[96.424960] Subtest normal: SKIP (0.000s)
[96.511954] [019/133] (922s left) gem_linear_blits (interruptible)
[96.806806] Starting subtest: interruptible
[101.101119] Subtest interruptible: SUCCESS (4.293s)
[101.274764] [020/133] (917s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[101.419799] Starting subtest: x-tiled-64bpp-rotate-270
[101.440416] Subtest x-tiled-64bpp-rotate-270: SKIP (0.020s)
[101.538652] [021/133] (917s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[101.624384] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[101.626566] Starting dynamic subtest: pipe-A
[101.974321] Dynamic subtest pipe-A: SUCCESS (0.351s)
[101.983060] Starting dynamic subtest: pipe-B
[103.417081] Dynamic subtest pipe-B: SUCCESS (1.442s)
[103.424355] Starting dynamic subtest: pipe-C
[104.853444] Dynamic subtest pipe-C: SUCCESS (1.436s)
[104.862626] Starting dynamic subtest: pipe-D
[106.297217] Dynamic subtest pipe-D: SUCCESS (1.443s)
[106.299627] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.674s)
[107.490024] [022/133] (911s left) kms_pm_rpm (system-suspend-modeset)
[109.060255] Starting subtest: system-suspend-modeset
[128.887265] Subtest system-suspend-modeset: SUCCESS (4.673s)
[129.296085] [023/133] (889s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[129.390094] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[129.392077] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[129.463514] [024/133] (889s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[129.553030] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[129.557183] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[129.623970] [025/133] (889s left) gem_ctx_param (non-root-set)
[129.685533] Starting subtest: non-root-set
[129.702260] Subtest non-root-set: SUCCESS (0.016s)
[129.824292] [026/133] (889s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[129.932310] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[129.936657] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[130.037787] [027/133] (888s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[130.135736] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[130.946649] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.793s)
[131.219009] [028/133] (887s left) gem_ctx_persistence (file)
[131.285071] Starting subtest: file
[131.399769] Subtest file: SUCCESS (0.112s)
[131.532983] [029/133] (887s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[131.627553] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[131.629811] Starting dynamic subtest: pipe-A-default-mode
[132.808644] Dynamic subtest pipe-A-default-mode: SKIP (1.157s)
[132.813381] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.159s)
[132.949218] [030/133] (886s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[133.055261] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[133.057375] Starting dynamic subtest: pipe-A
[134.118883] Dynamic subtest pipe-A: SUCCESS (1.050s)
[134.126590] Starting dynamic subtest: pipe-B
[136.234142] Dynamic subtest pipe-B: SUCCESS (2.088s)
[136.242819] Starting dynamic subtest: pipe-C
[137.433764] Dynamic subtest pipe-C: SUCCESS (1.186s)
[137.443973] Starting dynamic subtest: pipe-D
[138.673564] Dynamic subtest pipe-D: SUCCESS (1.228s)
[138.675921] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.555s)
[139.882048] [031/133] (879s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[139.998169] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[140.000536] Starting dynamic subtest: A-eDP1
[143.626389] Dynamic subtest A-eDP1: SUCCESS (3.607s)
[143.635769] Starting dynamic subtest: B-eDP1
[146.858490] Dynamic subtest B-eDP1: SUCCESS (3.217s)
[146.866944] Starting dynamic subtest: C-eDP1
[150.027914] Dynamic subtest C-eDP1: SUCCESS (3.160s)
[150.036659] Starting dynamic subtest: D-eDP1
[153.139168] Dynamic subtest D-eDP1: SUCCESS (3.105s)
[153.141337] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.098s)
[153.938600] [032/133] (865s left) gem_exec_parallel (contexts)
[154.003378] Starting subtest: contexts
[154.005735] Starting dynamic subtest: rcs0
[156.824557] Dynamic subtest rcs0: SUCCESS (2.816s)
[156.835247] Starting dynamic subtest: bcs0
[160.276171] Dynamic subtest bcs0: SUCCESS (3.449s)
[160.290450] Starting dynamic subtest: vcs0
[164.420759] Dynamic subtest vcs0: SUCCESS (4.142s)
[164.430849] Starting dynamic subtest: vcs1
[168.492148] Dynamic subtest vcs1: SUCCESS (4.068s)
[168.504449] Starting dynamic subtest: vecs0
[172.456741] Dynamic subtest vecs0: SUCCESS (3.960s)
[172.464996] Starting dynamic subtest: ccs0
[176.107255] Dynamic subtest ccs0: SUCCESS (3.647s)
[176.109611] Subtest contexts: SUCCESS (22.093s)
[176.293717] [033/133] (842s left) gem_exec_alignment (many)
[176.364468] Starting subtest: many
[198.904964] Subtest many: SUCCESS (22.528s)
[201.290234] [034/133] (817s left) kms_psr (fbc-pr-no-drrs)
[201.436756] Starting subtest: fbc-pr-no-drrs
[201.441163] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[201.506526] [035/133] (817s left) kms_vrr (flip-suspend)
[201.611505] Starting subtest: flip-suspend
[201.617890] Subtest flip-suspend: SKIP (0.000s)
[201.679798] [036/133] (817s left) i915_module_load (reload)
[201.715213] Starting subtest: reload
[206.509490] Subtest reload: SUCCESS (4.792s)
[206.553396] [037/133] (812s left) gem_vm_create (invalid-destroy)
[207.922288] Starting subtest: invalid-destroy
[207.924723] Subtest invalid-destroy: SUCCESS (0.002s)
[208.029147] [038/133] (811s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[208.128210] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[208.130330] Starting dynamic subtest: pipe-A-eDP-1
[208.138900] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[208.147817] Starting dynamic subtest: pipe-B-eDP-1
[208.156572] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[208.165608] Starting dynamic subtest: pipe-C-eDP-1
[208.173856] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[208.181261] Starting dynamic subtest: pipe-D-eDP-1
[208.189804] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[208.193873] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[210.398780] [039/133] (809s left) kms_dsc (dsc-with-bpc-formats)
[210.494029] Starting subtest: dsc-with-bpc-formats
[210.603032] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[210.643653] [040/133] (808s left) kms_flip (dpms-off-confusion)
[210.742307] Starting subtest: dpms-off-confusion
[210.747430] Starting dynamic subtest: A-eDP1
[219.513221] Dynamic subtest A-eDP1: SUCCESS (8.764s)
[219.522164] Starting dynamic subtest: B-eDP1
[228.152009] Dynamic subtest B-eDP1: SUCCESS (8.640s)
[228.163506] Starting dynamic subtest: C-eDP1
[236.779863] Dynamic subtest C-eDP1: SUCCESS (8.629s)
[236.789599] Starting dynamic subtest: D-eDP1
[245.415271] Dynamic subtest D-eDP1: SUCCESS (8.635s)
[245.420449] Subtest dpms-off-confusion: SUCCESS (34.680s)
[246.575938] [041/133] (772s left) gem_exec_schedule (submit-early-slice)
[246.644069] Starting subtest: submit-early-slice
[246.646496] Starting dynamic subtest: rcs0
[246.679325] Dynamic subtest rcs0: SUCCESS (0.042s)
[246.690846] Starting dynamic subtest: bcs0
[246.716748] Dynamic subtest bcs0: SUCCESS (0.037s)
[246.725474] Starting dynamic subtest: vcs0
[246.755656] Dynamic subtest vcs0: SUCCESS (0.038s)
[246.763746] Starting dynamic subtest: vcs1
[246.793331] Dynamic subtest vcs1: SUCCESS (0.037s)
[246.803510] Starting dynamic subtest: vecs0
[246.829233] Dynamic subtest vecs0: SUCCESS (0.035s)
[246.838160] Starting dynamic subtest: ccs0
[246.860448] Dynamic subtest ccs0: SUCCESS (0.030s)
[246.862768] Subtest submit-early-slice: SUCCESS (0.224s)
[248.089792] [042/133] (771s left) gem_exec_schedule (noreorder)
[248.274163] Starting subtest: noreorder
[248.276155] Starting dynamic subtest: rcs0
[248.337448] Dynamic subtest rcs0: SUCCESS (0.067s)
[248.350569] Starting dynamic subtest: vcs0
[249.979904] Dynamic subtest vcs0: SUCCESS (1.639s)
[249.991583] Starting dynamic subtest: vcs1
[251.972732] Dynamic subtest vcs1: SUCCESS (1.991s)
[251.985484] Starting dynamic subtest: vecs0
[253.954768] Dynamic subtest vecs0: SUCCESS (1.978s)
[253.966391] Starting dynamic subtest: ccs0
[254.028196] Dynamic subtest ccs0: SUCCESS (0.073s)
[254.030737] Subtest noreorder: SUCCESS (5.759s)
[254.228087] [043/133] (765s left) gem_close (many-handles-one-vma)
[254.290329] Starting subtest: many-handles-one-vma
[254.329172] Subtest many-handles-one-vma: SUCCESS (0.041s)
[254.438049] [044/133] (765s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[254.538747] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[254.542674] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[254.626792] [045/133] (765s left) kms_plane_alpha_blend (alpha-basic)
[254.718360] Starting subtest: alpha-basic
[254.999475] Starting dynamic subtest: pipe-A-eDP-1
[256.943129] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.942s)
[256.970216] Starting dynamic subtest: pipe-D-eDP-1
[259.651191] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.688s)
[259.653586] Subtest alpha-basic: SUCCESS (4.934s)
[260.449234] [046/133] (759s left) kms_psr (psr2-cursor-plane-move)
[260.566826] Starting subtest: psr2-cursor-plane-move
[260.569138] Starting dynamic subtest: eDP-1
[262.256206] Dynamic subtest eDP-1: SUCCESS (1.691s)
[262.258580] Subtest psr2-cursor-plane-move: SUCCESS (1.692s)
[263.056900] [047/133] (756s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[263.151959] Starting subtest: y-tiled-64bpp-rotate-270
[263.155789] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[263.256223] [048/133] (756s left) dmabuf_sync_file (export-multiwait)
[263.329622] Starting subtest: export-multiwait
[263.331830] Subtest export-multiwait: SUCCESS (0.001s)
[263.382559] [FACT dmabuf_sync_file (export-multiwait)] new: kernel.kmod_is_loaded.vgem: true
[263.385799] [049/133] (756s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[263.483747] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[263.487965] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[263.576612] [050/133] (756s left) gem_mmap_gtt (basic-small-copy)
[263.635946] Subtest basic-small-copy: SKIP (0.000s)
[263.690915] [051/133] (756s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[264.204417] Starting subtest: syncobj-backward-timeline-chain-engines
[264.300174] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.097s)
[266.073166] [052/133] (753s left) gem_userptr_blits (process-exit-busy)
[266.138066] Starting subtest: process-exit-busy
[266.156357] Subtest process-exit-busy: SUCCESS (0.019s)
[266.275470] [053/133] (753s left) kms_big_fb (linear-64bpp-rotate-90)
[266.388299] Starting subtest: linear-64bpp-rotate-90
[266.408821] Subtest linear-64bpp-rotate-90: SKIP (0.020s)
[266.521274] [054/133] (753s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[266.631806] Starting subtest: extended-modeset-hang-oldfb-with-reset
[266.634019] Starting dynamic subtest: pipe-A
[278.516632] Dynamic subtest pipe-A: SUCCESS (11.882s)
[278.527092] Starting dynamic subtest: pipe-D
[290.987352] Dynamic subtest pipe-D: SUCCESS (12.464s)
[290.989709] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.350s)
[291.769342] [055/133] (728s left) gem_readwrite (new-obj)
[291.830243] Subtest new-obj: SKIP (0.000s)
[291.893232] [056/133] (728s left) gem_exec_whisper (basic-forked-all)
[291.967272] Starting subtest: basic-forked-all
[305.994031] Subtest basic-forked-all: SUCCESS (14.018s)
[306.178001] [057/133] (713s left) gem_mmap_offset (mmap-boundaries)
[306.241163] Starting subtest: mmap-boundaries
[306.243426] Starting dynamic subtest: smem0
[306.530223] Dynamic subtest smem0: SUCCESS (0.289s)
[306.532636] Subtest mmap-boundaries: SUCCESS (0.290s)
[306.652601] [058/133] (713s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[306.751659] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[306.778031] Starting dynamic subtest: pipe-A-plane-0
[307.433389] Dynamic subtest pipe-A-plane-0: SUCCESS (0.655s)
[307.445168] Starting dynamic subtest: pipe-A-plane-3
[307.855349] Dynamic subtest pipe-A-plane-3: SUCCESS (0.420s)
[308.965454] Starting dynamic subtest: pipe-B-plane-0
[309.634821] Dynamic subtest pipe-B-plane-0: SUCCESS (0.677s)
[309.645853] Starting dynamic subtest: pipe-B-plane-3
[310.079517] Dynamic subtest pipe-B-plane-3: SUCCESS (0.444s)
[310.387809] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.637s)
[311.240323] [059/133] (708s left) api_intel_allocator (reopen)
[311.298766] Starting subtest: reopen
[311.303804] Subtest reopen: SUCCESS (0.004s)
[311.432600] [060/133] (708s left) gem_mmap (pf-nonblock)
[311.489310] Subtest pf-nonblock: SKIP (0.000s)
[311.553641] [061/133] (708s left) syncobj_timeline (wait-any-snapshot)
[311.606444] Starting subtest: wait-any-snapshot
[311.686111] Subtest wait-any-snapshot: SUCCESS (0.081s)
[311.776590] [062/133] (708s left) i915_query (query-garbage)
[311.837337] Starting subtest: query-garbage
[311.839321] Subtest query-garbage: SUCCESS (0.000s)
[311.950417] [063/133] (708s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[312.001298] Starting subtest: multi-wait-all-for-submit-signaled
[312.003355] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[312.093454] [064/133] (708s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[312.144937] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[312.149349] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[312.327252] [065/133] (708s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[312.421368] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[312.431990] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[312.506368] [066/133] (707s left) gem_create (create-valid-nonaligned)
[312.559496] Starting subtest: create-valid-nonaligned
[312.561618] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[312.786007] [067/133] (707s left) gem_barrier_race (remote-request)
[312.847312] Starting subtest: remote-request
[312.849355] Starting dynamic subtest: rcs0
[318.020493] Dynamic subtest rcs0: SUCCESS (5.173s)
[318.028216] Subtest remote-request: SUCCESS (5.174s)
[318.163302] [068/133] (702s left) kms_prop_blob (blob-prop-core)
[318.218125] Starting subtest: blob-prop-core
[318.220154] Subtest blob-prop-core: SUCCESS (0.000s)
[318.306997] [069/133] (702s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[318.398445] Starting subtest: fbcpsr-suspend
[359.070494] Subtest fbcpsr-suspend: SUCCESS (10.018s)
[359.197795] [070/133] (661s left) gem_mmap_gtt (basic-read)
[359.265879] Subtest basic-read: SKIP (0.000s)
[359.322802] [071/133] (661s left) kms_flip (2x-blocking-wf_vblank)
[359.427861] Starting subtest: 2x-blocking-wf_vblank
[359.436045] Subtest 2x-blocking-wf_vblank: SKIP (0.010s)
[359.562458] [072/133] (661s left) kms_psr (psr-sprite-plane-move)
[359.656343] Starting subtest: psr-sprite-plane-move
[359.658486] Starting dynamic subtest: eDP-1
[361.457417] Dynamic subtest eDP-1: SUCCESS (1.760s)
[361.459723] Subtest psr-sprite-plane-move: SUCCESS (1.761s)
[362.308948] [073/133] (658s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[362.412861] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[362.416876] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[362.521461] [074/133] (658s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[362.581293] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[362.684711] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.103s)
[362.760825] [075/133] (658s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[362.859498] Starting subtest: fbc-psr2-cursor-mmap-gtt
[362.861862] Starting dynamic subtest: eDP-1
[362.866171] Dynamic subtest eDP-1: SKIP (0.000s)
[362.870523] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[362.934791] [076/133] (657s left) kms_getfb (getfb-handle-protection)
[363.024709] Starting subtest: getfb-handle-protection
[363.039780] Subtest getfb-handle-protection: SUCCESS (0.015s)
[363.159952] [077/133] (657s left) kms_addfb_basic (bad-pitch-128)
[363.206512] Starting subtest: bad-pitch-128
[363.208812] Subtest bad-pitch-128: SUCCESS (0.000s)
[363.342900] [078/133] (657s left) gem_partial_pwrite_pread (writes-after-reads-display)
[363.411839] Subtest writes-after-reads-display: SKIP (0.000s)
[363.498270] [079/133] (657s left) kms_content_protection (atomic)
[363.651161] Starting subtest: atomic
[363.655652] Subtest atomic: SKIP (0.000s)
[363.798003] [080/133] (657s left) kms_cursor_edge_walk (256x256-left-edge)
[363.891114] Starting subtest: 256x256-left-edge
[363.893005] Starting dynamic subtest: pipe-A-eDP-1
[367.434695] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.503s)
[367.445342] Starting dynamic subtest: pipe-D-eDP-1
[370.576012] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.116s)
[370.577933] Subtest 256x256-left-edge: SUCCESS (6.622s)
[371.388882] [081/133] (649s left) kms_pm_rpm (cursor)
[373.716868] Starting subtest: cursor
[373.722188] Subtest cursor: SKIP (0.000s)
[374.104751] [082/133] (647s left) kms_atomic (plane-invalid-params-fence)
[374.195818] Starting subtest: plane-invalid-params-fence
[374.198041] Starting dynamic subtest: pipe-A-eDP-1
[374.554859] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.358s)
[374.557066] Subtest plane-invalid-params-fence: SUCCESS (0.359s)
[375.427489] [083/133] (645s left) kms_async_flips (crc)
[375.517779] Starting subtest: crc
[375.894934] Starting dynamic subtest: pipe-A-eDP-1
[378.854065] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.950s)
[379.229490] Starting dynamic subtest: pipe-B-eDP-1
[382.170089] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.944s)
[382.551862] Starting dynamic subtest: pipe-C-eDP-1
[385.399457] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.851s)
[385.764318] Starting dynamic subtest: pipe-D-eDP-1
[388.633417] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.877s)
[388.635562] Subtest crc: SUCCESS (13.094s)
[389.797437] [084/133] (631s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[389.897516] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[389.901761] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[390.005620] [085/133] (631s left) kms_plane_cursor (viewport)
[390.108544] Starting subtest: viewport
[390.113035] Starting dynamic subtest: pipe-A-eDP-1-size-64
[392.660717] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.552s)
[392.719880] Starting dynamic subtest: pipe-A-eDP-1-size-128
[395.206094] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.493s)
[395.265135] Starting dynamic subtest: pipe-A-eDP-1-size-256
[397.762891] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.505s)
[398.120003] Starting dynamic subtest: pipe-B-eDP-1-size-64
[401.338171] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.238s)
[401.399271] Starting dynamic subtest: pipe-B-eDP-1-size-128
[403.827614] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.437s)
[403.888464] Starting dynamic subtest: pipe-B-eDP-1-size-256
[406.406221] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.527s)
[406.757282] Starting dynamic subtest: pipe-C-eDP-1-size-64
[409.677705] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.932s)
[409.716453] Starting dynamic subtest: pipe-C-eDP-1-size-128
[411.833227] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.125s)
[411.872184] Starting dynamic subtest: pipe-C-eDP-1-size-256
[413.957364] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.092s)
[414.291105] Starting dynamic subtest: pipe-D-eDP-1-size-64
[417.069194] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.787s)
[417.106821] Starting dynamic subtest: pipe-D-eDP-1-size-128
[419.282402] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.182s)
[419.318626] Starting dynamic subtest: pipe-D-eDP-1-size-256
[421.436310] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.124s)
[421.755851] Subtest viewport: SUCCESS (31.648s)
[422.627015] [086/133] (598s left) i915_pm_rps (thresholds-idle)
[422.697777] Starting subtest: thresholds-idle
[422.702245] Subtest thresholds-idle: SKIP (0.001s)
[422.805843] [087/133] (598s left) kms_addfb_basic (bo-too-small)
[422.904574] Starting subtest: bo-too-small
[422.906891] Subtest bo-too-small: SUCCESS (0.000s)
[422.998832] [088/133] (598s left) gem_exec_whisper (basic-queues-forked)
[423.061444] Starting subtest: basic-queues-forked
[447.586622] Subtest basic-queues-forked: SUCCESS (24.495s)
[447.749781] [089/133] (573s left) perf (invalid-oa-format-id)
[447.850289] Starting subtest: invalid-oa-format-id
[447.862725] Subtest invalid-oa-format-id: SUCCESS (0.014s)
[447.902804] [090/133] (573s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[448.014208] Starting subtest: psr2-cursor-plane-update-sf
[448.016467] Starting dynamic subtest: pipe-A-eDP-1
[448.587144] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.573s)
[448.596922] Starting dynamic subtest: pipe-B-eDP-1
[449.919102] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.330s)
[449.921318] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.907s)
[450.806581] [091/133] (570s left) gem_exec_reloc (basic-cpu-gtt)
[450.871289] Subtest basic-cpu-gtt: SKIP (0.000s)
[450.935574] [092/133] (570s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[451.029029] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[451.031290] Starting dynamic subtest: pipe-A-eDP-1
[451.053601] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[451.065733] Starting dynamic subtest: pipe-B-eDP-1
[451.087298] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[451.096201] Starting dynamic subtest: pipe-C-eDP-1
[451.118920] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[451.129705] Starting dynamic subtest: pipe-D-eDP-1
[451.151174] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[451.155617] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[453.181364] [093/133] (568s left) gem_close_race (multigpu-basic-process)
[453.251899] Starting subtest: multigpu-basic-process
[453.256844] Subtest multigpu-basic-process: SKIP (0.000s)
[453.468576] [094/133] (568s left) gen9_exec_parse (batch-invalid-length)
[453.523074] Subtest batch-invalid-length: SKIP (0.000s)
[453.590402] [095/133] (568s left) gem_exec_fence (syncobj-unused-fence)
[454.034541] Starting subtest: syncobj-unused-fence
[454.040367] Subtest syncobj-unused-fence: SUCCESS (0.006s)
[455.573451] [096/133] (566s left) gem_exec_nop (basic-sequential)
[455.644191] Starting subtest: basic-sequential
[471.601448] Subtest basic-sequential: SUCCESS (15.970s)
[471.831115] [097/133] (549s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[471.940743] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[471.944813] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[472.046957] [098/133] (549s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[472.143076] Starting subtest: 4-tiled-64bpp-rotate-90
[472.162158] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.018s)
[472.282952] [099/133] (549s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[472.342989] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[472.399999] [100/133] (549s left) kms_fence_pin_leak
[472.572507] [101/133] (549s left) prime_busy (hang-wait)
[472.619634] Starting subtest: hang-wait
[472.621842] Starting dynamic subtest: rcs0
[498.984295] Dynamic subtest rcs0: SUCCESS (26.363s)
[498.995616] Starting dynamic subtest: bcs0
[506.137424] Dynamic subtest bcs0: SUCCESS (7.148s)
[506.148542] Starting dynamic subtest: vcs0
[513.111731] Dynamic subtest vcs0: SUCCESS (6.971s)
[513.121565] Starting dynamic subtest: vcs1
[520.148713] Dynamic subtest vcs1: SUCCESS (7.036s)
[520.161364] Starting dynamic subtest: vecs0
[527.122034] Dynamic subtest vecs0: SUCCESS (6.971s)
[527.134512] Starting dynamic subtest: ccs0
[540.961765] Dynamic subtest ccs0: SUCCESS (13.834s)
[540.964520] Subtest hang-wait: SUCCESS (68.338s)
[541.104534] [102/133] (480s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[541.501276] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[542.291125] [103/133] (479s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[542.382315] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[542.386872] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[542.488726] [104/133] (479s left) gem_unref_active_buffers
[542.672103] [105/133] (479s left) kms_rmfb (rmfb-ioctl)
[542.773610] Starting subtest: rmfb-ioctl
[542.775923] Starting dynamic subtest: pipe-A-eDP-1
[542.880224] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.108s)
[542.893378] Starting dynamic subtest: pipe-B-eDP-1
[544.085414] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.203s)
[544.098015] Starting dynamic subtest: pipe-C-eDP-1
[545.298373] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.211s)
[545.312591] Starting dynamic subtest: pipe-D-eDP-1
[546.440335] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.140s)
[546.442536] Subtest rmfb-ioctl: SUCCESS (3.668s)
[547.557655] [106/133] (474s left) gem_exec_reloc (basic-cpu-read-noreloc)
[547.619084] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[547.684079] [107/133] (474s left) kms_cursor_crc (cursor-dpms)
[547.813405] Starting subtest: cursor-dpms
[547.815266] Starting dynamic subtest: pipe-A-eDP-1
[550.824079] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.009s)
[550.846780] Starting dynamic subtest: pipe-D-eDP-1
[554.508711] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.682s)
[554.510805] Subtest cursor-dpms: SUCCESS (6.694s)
[555.352529] [108/133] (466s left) kms_debugfs (display-off-read-all)
[555.456082] Starting subtest: display-off-read-all
[555.763592] Subtest display-off-read-all: SUCCESS (0.308s)
[556.594422] [109/133] (465s left) perf_pmu (most-busy-idle-check-all)
[556.644245] Starting subtest: most-busy-idle-check-all
[556.646169] Starting dynamic subtest: rcs0
[558.538743] Dynamic subtest rcs0: SUCCESS (1.892s)
[558.552506] Starting dynamic subtest: bcs0
[560.457102] Dynamic subtest bcs0: SUCCESS (1.915s)
[560.480944] Starting dynamic subtest: vcs0
[562.506133] Dynamic subtest vcs0: SUCCESS (2.045s)
[562.528441] Starting dynamic subtest: vcs1
[564.553728] Dynamic subtest vcs1: SUCCESS (2.044s)
[564.566833] Starting dynamic subtest: vecs0
[566.473416] Dynamic subtest vecs0: SUCCESS (1.916s)
[566.486709] Starting dynamic subtest: ccs0
[568.521578] Dynamic subtest ccs0: SUCCESS (2.045s)
[568.524537] Subtest most-busy-idle-check-all: SUCCESS (11.875s)
[568.609624] [110/133] (453s left) gem_exec_balancer (waits)
[568.674759] Starting subtest: waits
[575.143454] Subtest waits: SUCCESS (6.465s)
[575.429876] [111/133] (446s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[575.534641] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[575.536974] Starting dynamic subtest: pipe-A-eDP-1
[577.651131] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.116s)
[577.660561] Starting dynamic subtest: pipe-B-eDP-1
[579.874222] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.221s)
[579.884339] Starting dynamic subtest: pipe-C-eDP-1
[581.973843] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.097s)
[581.984004] Starting dynamic subtest: pipe-D-eDP-1
[583.950320] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.975s)
[583.952452] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.415s)
[585.104030] [112/133] (437s left) perf (invalid-oa-metric-set-id)
[585.200639] Starting subtest: invalid-oa-metric-set-id
[585.210704] Subtest invalid-oa-metric-set-id: SUCCESS (0.009s)
[585.257549] [113/133] (437s left) kms_fbcon_fbt (fbc)
[585.330407] Starting subtest: fbc
[591.634265] Subtest fbc: SUCCESS (6.305s)
[592.727555] [114/133] (429s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[592.822522] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[592.827072] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[592.917637] [115/133] (429s left) kms_lease (lease-again)
[593.015107] Starting subtest: lease-again
[593.017381] Starting dynamic subtest: pipe-A-eDP-1
[593.019481] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.004s)
[593.029894] Starting dynamic subtest: pipe-B-eDP-1
[593.032100] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[593.041967] Starting dynamic subtest: pipe-C-eDP-1
[593.044023] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[593.053373] Starting dynamic subtest: pipe-D-eDP-1
[593.055470] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[593.057628] Subtest lease-again: SUCCESS (0.015s)
[593.157776] [116/133] (429s left) kms_chamelium_color (ctm-max)
[593.259808] Subtest ctm-max: SKIP (0.000s)
[593.304988] [117/133] (429s left) gem_softpin (zero)
[593.363886] Starting subtest: zero
[593.368465] Subtest zero: SUCCESS (0.004s)
[593.494444] [118/133] (429s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[593.593070] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[593.597626] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[593.684918] [119/133] (429s left) perf (missing-sample-flags)
[593.765786] Starting subtest: missing-sample-flags
[593.768263] Subtest missing-sample-flags: SUCCESS (0.000s)
[593.813882] [120/133] (428s left) core_auth (getclient-simple)
[593.848812] Starting subtest: getclient-simple
[593.873324] Subtest getclient-simple: SUCCESS (0.023s)
[593.973204] [121/133] (428s left) kms_color (degamma)
[594.070022] Starting subtest: degamma
[594.071951] Starting dynamic subtest: pipe-A-eDP-1
[594.788458] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.718s)
[594.809998] Starting dynamic subtest: pipe-B-eDP-1
[596.278908] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.491s)
[596.290945] Starting dynamic subtest: pipe-C-eDP-1
[597.640399] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.361s)
[597.651449] Starting dynamic subtest: pipe-D-eDP-1
[599.071206] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.430s)
[599.073412] Subtest degamma: SUCCESS (5.003s)
[599.878237] [122/133] (422s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[599.974288] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[599.978761] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[600.090572] [123/133] (422s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[600.180127] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[600.184836] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[601.305334] [124/133] (421s left) gem_ctx_create (basic-files)
[601.376243] Starting subtest: basic-files
[603.382111] Subtest basic-files: SUCCESS (2.009s)
[604.611350] [125/133] (418s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[604.859812] Starting subtest: cursor-rapid-movement-256x256
[604.864454] Starting dynamic subtest: pipe-A-eDP-1
[605.404602] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.541s)
[605.435164] Starting dynamic subtest: pipe-D-eDP-1
[606.623266] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.197s)
[606.625918] Subtest cursor-rapid-movement-256x256: SUCCESS (1.763s)
[607.488341] [126/133] (415s left) kms_chamelium_frames (dp-frame-dump)
[607.867385] Subtest dp-frame-dump: SKIP (0.000s)
[608.686318] [127/133] (414s left) gem_mmap_gtt (medium-copy)
[608.744697] Subtest medium-copy: SKIP (0.000s)
[608.801383] [128/133] (414s left) gem_ctx_param (invalid-param-set)
[608.858594] Starting subtest: invalid-param-set
[608.861068] Subtest invalid-param-set: SUCCESS (0.000s)
[608.932501] [129/133] (414s left) kms_psr (fbc-psr2-sprite-plane-move)
[609.025688] Starting subtest: fbc-psr2-sprite-plane-move
[609.027868] Starting dynamic subtest: eDP-1
[609.031838] Dynamic subtest eDP-1: SKIP (0.000s)
[609.035769] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[609.099015] [130/133] (414s left) gem_exec_balancer (full-pulse)
[609.168495] Starting subtest: full-pulse
[613.444755] Subtest full-pulse: SUCCESS (4.276s)
[613.765818] [131/133] (409s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[613.865203] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[613.869558] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[613.967583] [132/133] (409s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[614.082709] Starting subtest: flip-vs-cursor-crc-atomic
[614.726729] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.645s)
[615.543636] [133/133] (407s left) kms_vblank (invalid)
[615.639557] Starting subtest: invalid
[615.641810] Starting dynamic subtest: pipe-A-eDP-1
[616.065186] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.424s)
[616.067624] Subtest invalid: SUCCESS (0.426s)
[616.862396] 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.