[57.231527] Initializing watchdogs
[57.231665]   /dev/watchdog0
[57.248511] [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.253147] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.255312] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.258769] [001/154] (960s left) gem_ctx_exec (basic-close-race)
[57.332224] Starting subtest: basic-close-race
[63.020803] Subtest basic-close-race: SUCCESS (5.739s)
[63.156238] [002/154] (954s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[63.214182] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[63.216642] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.001s)
[63.319062] [003/154] (954s left) gem_wait (invalid-buf)
[63.374387] Starting subtest: invalid-buf
[63.376958] Subtest invalid-buf: SUCCESS (0.000s)
[63.579428] [004/154] (954s left) kms_psr (pr-cursor-plane-move)
[63.675071] Starting subtest: pr-cursor-plane-move
[63.679247] Subtest pr-cursor-plane-move: SKIP (0.000s)
[63.748099] [005/154] (954s left) i915_drm_fdinfo (busy-hang)
[63.789514] Starting subtest: busy-hang
[63.791857] Starting dynamic subtest: rcs0
[63.825838] Dynamic subtest rcs0: SKIP (0.034s)
[63.836153] Starting dynamic subtest: bcs0
[63.840204] Dynamic subtest bcs0: SKIP (0.001s)
[63.849122] Starting dynamic subtest: vcs0
[63.853651] Dynamic subtest vcs0: SKIP (0.000s)
[63.862785] Starting dynamic subtest: vcs1
[63.866672] Dynamic subtest vcs1: SKIP (0.001s)
[63.873842] Starting dynamic subtest: vecs0
[63.877667] Dynamic subtest vecs0: SKIP (0.000s)
[63.884955] Starting dynamic subtest: ccs0
[63.888827] Dynamic subtest ccs0: SKIP (0.000s)
[63.892677] Subtest busy-hang: SKIP (0.039s)
[63.929157] [006/154] (954s left) kms_debugfs (display-on-read-all)
[64.017958] Starting subtest: display-on-read-all
[64.211349] Subtest display-on-read-all: SUCCESS (0.196s)
[64.344660] [007/154] (953s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[64.406124] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[64.461659] [008/154] (953s left) gem_exec_whisper (basic-fds-all)
[64.526199] Starting subtest: basic-fds-all
[75.915699] Subtest basic-fds-all: SUCCESS (11.417s)
[76.096851] [009/154] (941s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[76.226915] Starting subtest: cursor-vs-flip-atomic
[105.997248] Subtest cursor-vs-flip-atomic: SUCCESS (29.775s)
[106.897576] [010/154] (911s left) gem_ctx_create (basic)
[106.965746] Starting subtest: basic
[106.968196] Subtest basic: SUCCESS (0.000s)
[107.158390] [011/154] (911s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[107.258241] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-cpu
[107.262275] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[107.371048] [012/154] (910s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[107.465744] Starting subtest: bad-rotation-90-yf-tiled-ccs
[107.467956] Starting dynamic subtest: pipe-A-eDP-1
[107.489693] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[107.500603] Starting dynamic subtest: pipe-B-eDP-1
[107.521717] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[107.530525] Starting dynamic subtest: pipe-C-eDP-1
[107.551345] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[107.559422] Starting dynamic subtest: pipe-D-eDP-1
[107.581264] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[107.585592] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.003s)
[109.756027] [013/154] (908s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-render)
[109.852989] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-render
[109.857224] Subtest fbchdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[109.952176] [014/154] (908s left) gem_ctx_isolation (nonpriv)
[110.012508] Starting subtest: nonpriv
[110.014981] Starting dynamic subtest: rcs0
[110.248026] Dynamic subtest rcs0: SUCCESS (0.235s)
[110.257600] Starting dynamic subtest: bcs0
[110.491918] Dynamic subtest bcs0: SUCCESS (0.244s)
[110.503505] Starting dynamic subtest: vcs0
[110.750595] Dynamic subtest vcs0: SUCCESS (0.259s)
[110.762379] Starting dynamic subtest: vcs1
[112.586923] Dynamic subtest vcs1: SUCCESS (1.836s)
[112.598058] Starting dynamic subtest: vecs0
[114.597162] Dynamic subtest vecs0: SUCCESS (2.010s)
[114.608180] Starting dynamic subtest: ccs0
[116.574790] Dynamic subtest ccs0: SUCCESS (1.977s)
[116.577151] Subtest nonpriv: SUCCESS (6.562s)
[116.792970] [015/154] (901s left) kms_flip (2x-busy-flip)
[116.886644] Starting subtest: 2x-busy-flip
[116.895974] Subtest 2x-busy-flip: SKIP (0.011s)
[116.982364] [016/154] (901s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[117.086399] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[117.090461] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[117.179827] [017/154] (901s left) gem_mmap_gtt (basic-read-write)
[117.234624] Subtest basic-read-write: SKIP (0.000s)
[117.295628] [018/154] (901s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[117.389921] Starting subtest: async-flip-with-page-flip-events-linear
[117.783590] Starting dynamic subtest: pipe-A-eDP-1
[120.543587] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.758s)
[120.920682] Starting dynamic subtest: pipe-B-eDP-1
[123.679311] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.766s)
[124.049247] Starting dynamic subtest: pipe-C-eDP-1
[126.821190] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.777s)
[127.190939] Starting dynamic subtest: pipe-D-eDP-1
[129.953963] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.770s)
[129.956704] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.564s)
[131.127081] [019/154] (887s left) perf (invalid-oa-exponent)
[131.236848] Starting subtest: invalid-oa-exponent
[131.251492] Subtest invalid-oa-exponent: SUCCESS (0.014s)
[131.294290] [020/154] (887s left) kms_chamelium_frames (vga-frame-dump)
[131.667349] Subtest vga-frame-dump: SKIP (0.000s)
[132.454129] [021/154] (886s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[132.550324] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu
[132.554322] Subtest psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[132.655749] [022/154] (885s left) kms_pm_dc (dc6-psr)
[133.754839] Starting subtest: dc6-psr
[136.624567] Subtest dc6-psr: SUCCESS (2.870s)
[137.514342] [023/154] (881s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[137.617205] Starting subtest: y-tiled-16bpp-rotate-0
[137.621851] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[137.724110] [024/154] (880s left) gem_ccs (ctrl-surf-copy-new-ctx)
[137.778390] Starting subtest: ctrl-surf-copy-new-ctx
[137.782899] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[137.866303] [025/154] (880s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[137.976087] Starting subtest: extended-modeset-hang-oldfb-with-reset
[137.978463] Starting dynamic subtest: pipe-A
[149.902664] Dynamic subtest pipe-A: SUCCESS (11.925s)
[149.914451] Starting dynamic subtest: pipe-D
[162.668958] Dynamic subtest pipe-D: SUCCESS (12.764s)
[162.671271] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.692s)
[163.549804] [026/154] (855s left) dmabuf_sync_file (export-wait-after-attach)
[163.669340] Starting subtest: export-wait-after-attach
[163.671889] Subtest export-wait-after-attach: SUCCESS (0.001s)
[163.724018] [FACT dmabuf_sync_file (export-wait-after-attach)] new: kernel.kmod_is_loaded.vgem: true
[163.727277] [027/154] (855s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-render)
[163.825228] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-render
[163.829605] Subtest fbchdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[163.930870] [028/154] (854s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[164.028134] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc
[164.032520] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[164.131231] [029/154] (854s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[164.230015] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[164.234484] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[164.328920] [030/154] (854s left) kms_pm_rpm (modeset-pc8-residency-stress)
[166.461326] Starting subtest: modeset-pc8-residency-stress
[166.466055] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[166.853105] [031/154] (852s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[166.953650] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-wc
[166.957885] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[167.053148] [032/154] (851s left) gem_exec_flush (basic-batch-kernel-default-wb)
[167.112531] Starting subtest: basic-batch-kernel-default-wb
[174.366827] Subtest basic-batch-kernel-default-wb: SUCCESS (7.254s)
[174.551743] [033/154] (844s left) gen9_exec_parse (batch-invalid-length)
[174.605737] Subtest batch-invalid-length: SKIP (0.000s)
[174.684397] [034/154] (844s left) gem_render_copy_redux (flink-interruptible)
[174.749897] Starting subtest: flink-interruptible
[176.039525] Subtest flink-interruptible: SUCCESS (1.289s)
[176.202618] [035/154] (842s left) kms_flip (flip-vs-rmfb)
[176.309922] Starting subtest: flip-vs-rmfb
[176.312045] Starting dynamic subtest: A-eDP1
[185.033686] Dynamic subtest A-eDP1: SUCCESS (8.723s)
[185.045126] Starting dynamic subtest: B-eDP1
[193.673341] Dynamic subtest B-eDP1: SUCCESS (8.638s)
[193.683506] Starting dynamic subtest: C-eDP1
[202.292953] Dynamic subtest C-eDP1: SUCCESS (8.618s)
[202.303492] Starting dynamic subtest: D-eDP1
[210.927750] Dynamic subtest D-eDP1: SUCCESS (8.633s)
[210.932441] Subtest flip-vs-rmfb: SUCCESS (34.621s)
[212.113710] [036/154] (807s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[212.210095] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[212.212389] Starting dynamic subtest: pipe-A
[212.233503] Dynamic subtest pipe-A: SKIP (0.019s)
[212.243716] Starting dynamic subtest: pipe-B
[212.267872] Dynamic subtest pipe-B: SKIP (0.034s)
[212.278115] Starting dynamic subtest: pipe-C
[212.298677] Dynamic subtest pipe-C: SKIP (0.032s)
[212.308796] Starting dynamic subtest: pipe-D
[212.331886] Dynamic subtest pipe-D: SKIP (0.032s)
[212.335912] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.120s)
[212.424591] [037/154] (806s left) gem_render_copy_redux (interruptible)
[212.482870] Starting subtest: interruptible
[212.788835] Subtest interruptible: SUCCESS (0.309s)
[212.915231] [038/154] (806s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[213.008164] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[213.010521] Starting dynamic subtest: pipe-A-eDP-1
[213.033346] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[213.045419] Starting dynamic subtest: pipe-B-eDP-1
[213.063021] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[213.072058] Starting dynamic subtest: pipe-C-eDP-1
[213.089680] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[213.098469] Starting dynamic subtest: pipe-D-eDP-1
[213.116676] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[213.120068] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[215.277883] [039/154] (804s left) gem_unref_active_buffers
[215.478074] [040/154] (803s left) kms_pipe_crc_basic (suspend-read-crc)
[215.563154] Starting subtest: suspend-read-crc
[215.565480] Starting dynamic subtest: pipe-A-eDP-1
[234.055949] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.062s)
[234.067231] Starting dynamic subtest: pipe-B-eDP-1
[253.052780] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.630s)
[253.065037] Starting dynamic subtest: pipe-C-eDP-1
[272.009055] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.541s)
[272.019498] Starting dynamic subtest: pipe-D-eDP-1
[291.004010] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.490s)
[291.006403] Subtest suspend-read-crc: SUCCESS (13.728s)
[300.861259] [041/154] (727s left) gem_mmap_wc (read-write)
[300.932562] Subtest read-write: SKIP (0.000s)
[300.996945] [042/154] (727s left) gem_exec_balancer (noheartbeat)
[301.271642] Starting subtest: noheartbeat
[301.276316] Subtest noheartbeat: SKIP (0.000s)
[301.373119] [043/154] (727s left) syncobj_wait (wait-all-for-submit-complex)
[301.422354] Starting subtest: wait-all-for-submit-complex
[301.635336] Subtest wait-all-for-submit-complex: SUCCESS (0.218s)
[301.727651] [044/154] (726s left) syncobj_timeline (invalid-query-bad-pad)
[301.777623] Starting subtest: invalid-query-bad-pad
[301.779994] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[301.891721] [045/154] (726s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[302.003331] Starting subtest: fbcpsr-rgb101010-draw-blt
[306.729017] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (4.803s)
[306.878314] [046/154] (721s left) api_intel_allocator (reopen-fork)
[306.932727] Starting subtest: reopen-fork
[310.287990] Subtest reopen-fork: SUCCESS (3.386s)
[310.365908] [047/154] (718s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[310.473683] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[310.478060] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[310.578566] [048/154] (718s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[310.963968] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[311.774338] [049/154] (716s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[311.879267] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[313.019037] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.146s)
[313.119702] [050/154] (715s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[313.222908] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[313.226303] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[313.309519] [051/154] (715s left) gem_tiled_pread_pwrite
[313.420576] [052/154] (715s left) gem_eio (suspend)
[313.649705] Starting subtest: suspend
[326.659961] Subtest suspend: SUCCESS (13.042s)
[333.786274] [053/154] (702s left) perf (disabled-read-error)
[333.903413] Starting subtest: disabled-read-error
[333.918033] Subtest disabled-read-error: SUCCESS (0.015s)
[333.965423] [054/154] (702s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[334.066075] Starting subtest: x-tiled-32bpp-rotate-0
[335.545504] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.479s)
[335.683408] [055/154] (700s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[335.775302] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[335.778557] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[335.871446] [056/154] (700s left) kms_draw_crc (draw-method-pwrite)
[335.962471] Starting subtest: draw-method-pwrite
[335.964242] Starting dynamic subtest: xrgb8888-untiled
[336.573925] Dynamic subtest xrgb8888-untiled: SUCCESS (0.611s)
[336.585133] Starting dynamic subtest: rgb565-untiled
[337.040165] Dynamic subtest rgb565-untiled: SUCCESS (0.464s)
[337.051040] Starting dynamic subtest: xrgb2101010-untiled
[337.619187] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.577s)
[337.630169] Starting dynamic subtest: xbgr16161616f-untiled
[338.407362] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.788s)
[338.418193] Starting dynamic subtest: xrgb8888-xtiled
[340.297697] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.888s)
[340.309400] Starting dynamic subtest: rgb565-xtiled
[341.431773] Dynamic subtest rgb565-xtiled: SUCCESS (1.132s)
[341.444825] Starting dynamic subtest: xrgb2101010-xtiled
[343.275929] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.843s)
[343.286954] Starting dynamic subtest: xbgr16161616f-xtiled
[346.742815] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.466s)
[346.756216] Starting dynamic subtest: xrgb8888-4tiled
[347.910057] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.165s)
[347.921141] Starting dynamic subtest: rgb565-4tiled
[348.487717] Dynamic subtest rgb565-4tiled: SUCCESS (0.577s)
[348.499045] Starting dynamic subtest: xrgb2101010-4tiled
[349.643524] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.155s)
[349.656438] Starting dynamic subtest: xbgr16161616f-4tiled
[352.787974] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.144s)
[352.790359] Subtest draw-method-pwrite: SUCCESS (16.823s)
[352.883682] [057/154] (683s left) gem_spin_batch (resubmit-new)
[352.948862] Starting subtest: resubmit-new
[352.951230] Starting dynamic subtest: rcs0
[352.957351] Dynamic subtest rcs0: SUCCESS (0.008s)
[352.968824] Starting dynamic subtest: bcs0
[352.970726] Dynamic subtest bcs0: SUCCESS (0.005s)
[352.981282] Starting dynamic subtest: vcs0
[352.983449] Dynamic subtest vcs0: SUCCESS (0.006s)
[352.993743] Starting dynamic subtest: vcs1
[352.996018] Dynamic subtest vcs1: SUCCESS (0.004s)
[353.006068] Starting dynamic subtest: vecs0
[353.008297] Dynamic subtest vecs0: SUCCESS (0.004s)
[353.018370] Starting dynamic subtest: ccs0
[353.020571] Dynamic subtest ccs0: SUCCESS (0.006s)
[353.022815] Subtest resubmit-new: SUCCESS (0.040s)
[355.048972] [058/154] (681s left) kms_plane (pixel-format-4-tiled-modifier)
[355.130154] Starting subtest: pixel-format-4-tiled-modifier
[355.155445] Starting dynamic subtest: pipe-A-plane-0
[355.566947] Dynamic subtest pipe-A-plane-0: SUCCESS (0.411s)
[355.577851] Starting dynamic subtest: pipe-A-plane-3
[355.889156] Dynamic subtest pipe-A-plane-3: SUCCESS (0.321s)
[355.899534] Starting dynamic subtest: pipe-A-plane-5
[355.903882] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[357.026330] Starting dynamic subtest: pipe-B-plane-0
[357.439744] Dynamic subtest pipe-B-plane-0: SUCCESS (0.422s)
[357.452240] Starting dynamic subtest: pipe-B-plane-3
[357.785261] Dynamic subtest pipe-B-plane-3: SUCCESS (0.344s)
[357.796618] Starting dynamic subtest: pipe-B-plane-5
[357.800977] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[358.091946] Subtest pixel-format-4-tiled-modifier: SUCCESS (2.964s)
[358.909978] [059/154] (677s left) syncobj_wait (single-wait-signaled)
[358.974654] Starting subtest: single-wait-signaled
[358.976527] Subtest single-wait-signaled: SUCCESS (0.000s)
[359.075218] [060/154] (677s left) perf_pmu (busy-idle-check-all)
[359.117458] Starting subtest: busy-idle-check-all
[359.119914] Starting dynamic subtest: rcs0
[359.772715] Dynamic subtest rcs0: SUCCESS (0.655s)
[359.789249] Starting dynamic subtest: bcs0
[360.427888] Dynamic subtest bcs0: SUCCESS (0.652s)
[360.441358] Starting dynamic subtest: vcs0
[362.033968] Dynamic subtest vcs0: SUCCESS (1.603s)
[362.048030] Starting dynamic subtest: vcs1
[364.017534] Dynamic subtest vcs1: SUCCESS (1.981s)
[364.031559] Starting dynamic subtest: vecs0
[366.065791] Dynamic subtest vecs0: SUCCESS (2.045s)
[366.079904] Starting dynamic subtest: ccs0
[366.722415] Dynamic subtest ccs0: SUCCESS (0.656s)
[366.724894] Subtest busy-idle-check-all: SUCCESS (7.607s)
[366.824288] [061/154] (669s left) gem_ctx_param (invalid-ctx-set)
[366.873874] Starting subtest: invalid-ctx-set
[366.876227] Subtest invalid-ctx-set: SUCCESS (0.001s)
[366.981540] [062/154] (669s left) gem_pxp (regular-baseline-src-copy-readible)
[367.097870] Starting subtest: regular-baseline-src-copy-readible
[367.160382] Subtest regular-baseline-src-copy-readible: SUCCESS (0.064s)
[367.290216] [063/154] (669s left) kms_cursor_edge_walk (64x64-right-edge)
[367.387279] Starting subtest: 64x64-right-edge
[367.389646] Starting dynamic subtest: pipe-A-eDP-1
[370.873427] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.484s)
[370.884408] Starting dynamic subtest: pipe-D-eDP-1
[374.007287] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.134s)
[374.009649] Subtest 64x64-right-edge: SUCCESS (6.620s)
[374.821227] [064/154] (661s left) gen7_exec_parse (basic-allowed)
[374.885786] Subtest basic-allowed: SKIP (0.000s)
[374.952998] [065/154] (661s left) kms_big_fb (linear-32bpp-rotate-180)
[375.060995] Starting subtest: linear-32bpp-rotate-180
[376.607201] Subtest linear-32bpp-rotate-180: SUCCESS (1.546s)
[376.732824] [066/154] (659s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[376.829932] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[376.833392] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[376.944721] [067/154] (659s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[377.044339] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[377.046220] Starting dynamic subtest: pipe-A-eDP-1
[377.064574] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[377.075314] Starting dynamic subtest: pipe-B-eDP-1
[377.092557] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[377.102724] Starting dynamic subtest: pipe-C-eDP-1
[377.120590] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[377.131986] Starting dynamic subtest: pipe-D-eDP-1
[377.150079] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[377.153744] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[379.300111] [068/154] (657s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[379.401021] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[379.405567] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[379.517063] [069/154] (657s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-pwrite)
[379.618993] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-pwrite
[379.623955] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[379.726521] [070/154] (656s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[379.843113] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[379.847395] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[379.952662] [071/154] (656s left) i915_getparams_basic (basic-subslice-total)
[380.005927] Starting subtest: basic-subslice-total
[380.010660] Subtest basic-subslice-total: SUCCESS (0.000s)
[380.096640] [072/154] (656s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[380.196412] Starting subtest: primary-y-tiled-reflect-x-270
[380.200776] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[380.267997] [073/154] (656s left) gem_mmap_wc (write-read-distinct)
[380.322227] Subtest write-read-distinct: SKIP (0.000s)
[380.389288] [074/154] (656s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[380.491603] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[380.502042] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.011s)
[380.579292] [075/154] (656s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[380.679254] Starting subtest: psr2-overlay-plane-move-continuous-sf
[380.681248] Starting dynamic subtest: pipe-A-eDP-1
[386.657585] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.982s)
[386.669743] Starting dynamic subtest: pipe-B-eDP-1
[393.374699] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.715s)
[393.376968] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (12.700s)
[394.254772] [076/154] (642s left) kms_addfb_basic (too-wide)
[394.353880] Starting subtest: too-wide
[394.356157] Subtest too-wide: SUCCESS (0.000s)
[394.460419] [077/154] (642s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-mmap-wc)
[394.570472] Starting subtest: fbchdr-rgb101010-draw-mmap-wc
[394.574328] Subtest fbchdr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[394.685744] [078/154] (642s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[394.775624] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[394.778087] Starting dynamic subtest: pipe-A-eDP-1
[395.306948] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.510s)
[395.320569] Starting dynamic subtest: pipe-B-eDP-1
[396.857758] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.545s)
[396.870612] Starting dynamic subtest: pipe-C-eDP-1
[398.266028] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.408s)
[398.278576] Starting dynamic subtest: pipe-D-eDP-1
[399.638425] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.372s)
[399.640392] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.839s)
[400.813468] [079/154] (636s left) perf (i915-ref-count)
[400.877921] Starting subtest: i915-ref-count
[400.905520] Subtest i915-ref-count: SUCCESS (0.024s)
[400.965111] [080/154] (636s left) kms_vblank (query-forked)
[401.061176] Starting subtest: query-forked
[401.063032] Starting dynamic subtest: pipe-A-eDP-1
[402.873107] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.813s)
[402.889788] Starting dynamic subtest: pipe-D-eDP-1
[405.414604] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.540s)
[405.416983] Subtest query-forked: SUCCESS (4.358s)
[406.292494] [081/154] (630s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[406.386076] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[406.390268] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[406.460455] [082/154] (630s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[406.559670] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[406.563697] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[406.671887] [083/154] (630s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-msflip-blt)
[406.768884] Starting subtest: psrhdr-2p-scndscrn-indfb-msflip-blt
[406.772999] Subtest psrhdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[406.893652] [084/154] (630s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-msflip-blt)
[407.003790] Starting subtest: hdr-2p-scndscrn-indfb-msflip-blt
[407.007976] Subtest hdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[407.110034] [085/154] (630s left) i915_pm_rps (min-max-config-idle)
[407.168821] Starting subtest: min-max-config-idle
[407.173269] Subtest min-max-config-idle: SKIP (0.001s)
[407.289380] [086/154] (630s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[407.384456] Starting subtest: fbc-psr-cursor-mmap-gtt
[407.386259] Starting dynamic subtest: eDP-1
[407.389487] Dynamic subtest eDP-1: SKIP (0.000s)
[407.392726] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[407.460438] [087/154] (629s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[407.553390] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt
[407.556969] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[407.657855] [088/154] (629s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[407.709926] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[407.774061] [089/154] (629s left) kms_flip (wf_vblank-ts-check-interruptible)
[407.862669] Starting subtest: wf_vblank-ts-check-interruptible
[407.864365] Starting dynamic subtest: A-eDP1
[416.822192] Dynamic subtest A-eDP1: SUCCESS (8.959s)
[416.834051] Starting dynamic subtest: B-eDP1
[425.760109] Dynamic subtest B-eDP1: SUCCESS (8.939s)
[425.775742] Starting dynamic subtest: C-eDP1
[434.681863] Dynamic subtest C-eDP1: SUCCESS (8.919s)
[434.695822] Starting dynamic subtest: D-eDP1
[443.611223] Dynamic subtest D-eDP1: SUCCESS (8.931s)
[443.616422] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.762s)
[444.834768] [090/154] (592s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[444.948754] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-mmap-gtt
[444.952837] Subtest hdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[445.062398] [091/154] (592s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[445.164126] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[445.168297] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[445.242167] [092/154] (592s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[445.308072] Starting subtest: y-tiled-to-vebox-y-tiled
[445.312600] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[445.505964] [093/154] (592s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[445.597824] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[445.601818] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[445.707718] [094/154] (592s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[445.809350] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[445.813701] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[445.910731] [095/154] (591s left) api_intel_bb (intel-bb-blit-none)
[445.969930] Starting subtest: intel-bb-blit-none
[449.897882] Subtest intel-bb-blit-none: SUCCESS (3.929s)
[450.009865] [096/154] (587s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[450.120956] Starting subtest: psr-rgb101010-draw-blt
[457.532156] Subtest psr-rgb101010-draw-blt: SUCCESS (7.417s)
[457.645647] [097/154] (580s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-render)
[457.744791] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-render
[457.748810] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[457.828179] [098/154] (580s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-indfb-msflip-blt)
[457.934944] Starting subtest: psrhdr-2p-primscrn-indfb-msflip-blt
[457.939363] Subtest psrhdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[458.047495] [099/154] (579s left) kms_content_protection (mei-interface)
[458.179058] Starting subtest: mei-interface
[458.183724] Subtest mei-interface: SKIP (0.001s)
[458.293978] [100/154] (579s left) syncobj_wait (single-wait-for-submit-submitted)
[458.350662] Starting subtest: single-wait-for-submit-submitted
[458.453842] Subtest single-wait-for-submit-submitted: SUCCESS (0.103s)
[458.533548] [101/154] (579s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[458.625683] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[458.629883] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[458.719995] [102/154] (579s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[458.815808] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[466.290169] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.482s)
[466.410974] [103/154] (571s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite)
[466.519572] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite
[466.523554] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[466.638732] [104/154] (571s left) perf (invalid-oa-metric-set-id)
[466.723176] Starting subtest: invalid-oa-metric-set-id
[466.733227] Subtest invalid-oa-metric-set-id: SUCCESS (0.010s)
[466.792338] [105/154] (571s left) gem_exec_fence (basic-await)
[466.969199] Starting subtest: basic-await
[466.972081] Starting dynamic subtest: rcs0
[467.044059] Dynamic subtest rcs0: SUCCESS (0.075s)
[467.059160] Starting dynamic subtest: bcs0
[467.118680] Dynamic subtest bcs0: SUCCESS (0.073s)
[467.133350] Starting dynamic subtest: vcs0
[467.196187] Dynamic subtest vcs0: SUCCESS (0.076s)
[467.210035] Starting dynamic subtest: vcs1
[467.270596] Dynamic subtest vcs1: SUCCESS (0.073s)
[467.283808] Starting dynamic subtest: vecs0
[467.344973] Dynamic subtest vecs0: SUCCESS (0.072s)
[467.359662] Starting dynamic subtest: ccs0
[467.419730] Dynamic subtest ccs0: SUCCESS (0.073s)
[467.422758] Subtest basic-await: SUCCESS (0.452s)
[469.132283] [106/154] (569s left) gem_exec_schedule (implicit-write-read)
[469.205842] Starting subtest: implicit-write-read
[469.207817] Starting dynamic subtest: rcs0
[469.386182] Dynamic subtest rcs0: SUCCESS (0.186s)
[469.399459] Starting dynamic subtest: vcs0
[469.496443] Dynamic subtest vcs0: SUCCESS (0.110s)
[469.511143] Starting dynamic subtest: vcs1
[469.636574] Dynamic subtest vcs1: SUCCESS (0.140s)
[469.651120] Starting dynamic subtest: vecs0
[469.747772] Dynamic subtest vecs0: SUCCESS (0.108s)
[469.762081] Starting dynamic subtest: ccs0
[469.884181] Dynamic subtest ccs0: SUCCESS (0.136s)
[469.887168] Subtest implicit-write-read: SUCCESS (0.687s)
[471.132069] [107/154] (567s left) kms_psr (psr-dpms)
[471.217130] Starting subtest: psr-dpms
[471.219386] Starting dynamic subtest: eDP-1
[474.198485] Dynamic subtest eDP-1: SUCCESS (2.981s)
[474.200705] Subtest psr-dpms: SUCCESS (2.982s)
[475.065366] [108/154] (563s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[475.152152] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[475.154472] Starting dynamic subtest: pipe-A
[475.175060] Dynamic subtest pipe-A: SKIP (0.018s)
[475.186538] Starting dynamic subtest: pipe-B
[475.206917] Dynamic subtest pipe-B: SKIP (0.031s)
[475.217444] Starting dynamic subtest: pipe-C
[475.239431] Dynamic subtest pipe-C: SKIP (0.032s)
[475.250212] Starting dynamic subtest: pipe-D
[475.270063] Dynamic subtest pipe-D: SKIP (0.031s)
[475.274599] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.114s)
[475.376339] [109/154] (563s left) gem_exec_schedule (submit-early-slice)
[475.445683] Starting subtest: submit-early-slice
[475.448035] Starting dynamic subtest: rcs0
[475.484506] Dynamic subtest rcs0: SUCCESS (0.046s)
[475.501022] Starting dynamic subtest: bcs0
[475.532594] Dynamic subtest bcs0: SUCCESS (0.046s)
[475.545452] Starting dynamic subtest: vcs0
[475.575871] Dynamic subtest vcs0: SUCCESS (0.042s)
[475.587717] Starting dynamic subtest: vcs1
[475.616457] Dynamic subtest vcs1: SUCCESS (0.040s)
[475.628812] Starting dynamic subtest: vecs0
[475.657245] Dynamic subtest vecs0: SUCCESS (0.040s)
[475.668746] Starting dynamic subtest: ccs0
[475.698406] Dynamic subtest ccs0: SUCCESS (0.040s)
[475.700797] Subtest submit-early-slice: SUCCESS (0.261s)
[477.128548] [110/154] (561s left) gem_ctx_persistence (legacy-engines-persistence)
[477.189725] Starting subtest: legacy-engines-persistence
[477.191689] Starting dynamic subtest: render
[478.014545] Dynamic subtest render: SUCCESS (0.827s)
[478.028436] Starting dynamic subtest: bsd1
[478.763855] Dynamic subtest bsd1: SUCCESS (0.747s)
[478.780134] Starting dynamic subtest: bsd2
[479.522960] Dynamic subtest bsd2: SUCCESS (0.756s)
[479.535286] Starting dynamic subtest: blt
[480.279498] Dynamic subtest blt: SUCCESS (0.754s)
[480.292916] Starting dynamic subtest: vebox
[481.082220] Dynamic subtest vebox: SUCCESS (0.800s)
[481.084892] Subtest legacy-engines-persistence: SUCCESS (3.898s)
[481.167971] [111/154] (557s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[481.285687] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[481.289637] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[481.385177] [112/154] (557s left) kms_getfb (getfb-reject-nv12)
[481.471509] Starting subtest: getfb-reject-nv12
[481.473738] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[481.619237] [113/154] (556s left) syncobj_wait (single-wait-all-for-submit-submitted)
[481.674173] Starting subtest: single-wait-all-for-submit-submitted
[481.781886] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.106s)
[481.861917] [114/154] (556s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-render)
[481.960208] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-render
[481.964445] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[482.070582] [115/154] (556s left) kms_async_flips (test-cursor-atomic)
[482.160780] Starting subtest: test-cursor-atomic
[482.539921] Starting dynamic subtest: pipe-A-eDP-1
[483.354356] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.815s)
[483.739458] Starting dynamic subtest: pipe-B-eDP-1
[484.495704] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.765s)
[484.865840] Starting dynamic subtest: pipe-C-eDP-1
[485.629144] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.773s)
[486.013318] Starting dynamic subtest: pipe-D-eDP-1
[486.776677] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.773s)
[486.779004] Subtest test-cursor-atomic: SUCCESS (4.621s)
[488.045613] [116/154] (550s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[488.139879] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[488.144240] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[488.235034] [117/154] (550s left) perf_pmu (semaphore-wait-idle)
[488.276578] Starting subtest: semaphore-wait-idle
[488.278840] Starting dynamic subtest: rcs0
[488.793125] Dynamic subtest rcs0: SUCCESS (0.516s)
[488.806587] Starting dynamic subtest: bcs0
[489.306329] Dynamic subtest bcs0: SUCCESS (0.511s)
[489.319020] Starting dynamic subtest: vcs0
[489.820074] Dynamic subtest vcs0: SUCCESS (0.510s)
[489.834293] Starting dynamic subtest: vcs1
[490.334642] Dynamic subtest vcs1: SUCCESS (0.511s)
[490.348705] Starting dynamic subtest: vecs0
[490.848694] Dynamic subtest vecs0: SUCCESS (0.511s)
[490.862497] Starting dynamic subtest: ccs0
[491.366052] Dynamic subtest ccs0: SUCCESS (0.514s)
[491.369498] Subtest semaphore-wait-idle: SUCCESS (3.092s)
[491.490563] [118/154] (547s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[491.596877] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[498.964228] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.371s)
[499.090076] [119/154] (539s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[499.185169] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[499.187468] Starting dynamic subtest: pipe-A-default-mode
[500.323559] Dynamic subtest pipe-A-default-mode: SKIP (1.137s)
[500.327531] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.138s)
[500.462464] [120/154] (538s left) kms_chamelium_audio (hdmi-audio)
[500.851071] Subtest hdmi-audio: SKIP (0.000s)
[501.711483] [121/154] (537s left) prime_vgem (fence-wait)
[501.791846] Starting subtest: fence-wait
[501.794204] Starting dynamic subtest: rcs0
[502.844006] Dynamic subtest rcs0: SUCCESS (1.050s)
[502.856996] Starting dynamic subtest: bcs0
[503.896939] Dynamic subtest bcs0: SUCCESS (1.051s)
[503.910625] Starting dynamic subtest: vcs0
[504.942039] Dynamic subtest vcs0: SUCCESS (1.044s)
[504.954957] Starting dynamic subtest: vcs1
[506.043889] Dynamic subtest vcs1: SUCCESS (1.078s)
[506.055159] Starting dynamic subtest: vecs0
[507.063574] Dynamic subtest vecs0: SUCCESS (1.039s)
[507.074839] Starting dynamic subtest: ccs0
[508.107731] Dynamic subtest ccs0: SUCCESS (1.041s)
[508.110259] Subtest fence-wait: SUCCESS (6.313s)
[508.242038] [122/154] (530s left) gem_exec_reloc (basic-concurrent16)
[508.305554] Subtest basic-concurrent16: SKIP (0.000s)
[508.377529] [123/154] (530s left) gem_mmap_gtt (zero-extend)
[508.433183] Subtest zero-extend: SKIP (0.000s)
[508.496913] [124/154] (530s left) gem_exec_reloc (basic-write-wc)
[508.556084] Subtest basic-write-wc: SKIP (0.000s)
[508.641556] [125/154] (530s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[508.746505] Starting subtest: 4-tiled-32bpp-rotate-270
[508.767727] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.020s)
[508.885692] [126/154] (530s left) kms_vblank (ts-continuation-modeset)
[508.972820] Starting subtest: ts-continuation-modeset
[508.975036] Starting dynamic subtest: pipe-A-eDP-1
[510.498526] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.524s)
[510.514145] Starting dynamic subtest: pipe-D-eDP-1
[512.677734] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.175s)
[512.680227] Subtest ts-continuation-modeset: SUCCESS (3.705s)
[513.491339] [127/154] (525s left) gem_fence_thrash (bo-write-verify-y)
[513.531351] Starting subtest: bo-write-verify-y
[513.546186] Subtest bo-write-verify-y: SKIP (0.016s)
[513.613886] [128/154] (525s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[513.714289] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[513.718738] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[513.815988] [129/154] (525s left) kms_plane (pixel-format-yf-tiled-modifier)
[513.907448] Starting subtest: pixel-format-yf-tiled-modifier
[513.911829] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[513.979242] [130/154] (525s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[514.133721] Starting subtest: cursor-rapid-movement-32x10
[514.181219] Subtest cursor-rapid-movement-32x10: SKIP (0.042s)
[514.450560] [131/154] (524s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[514.542653] Starting subtest: disable-crc-after-crtc
[514.544533] Starting dynamic subtest: pipe-A-eDP-1
[516.256837] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.713s)
[516.268900] Starting dynamic subtest: pipe-B-eDP-1
[518.603759] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.346s)
[518.615131] Starting dynamic subtest: pipe-C-eDP-1
[520.865784] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.257s)
[520.877969] Starting dynamic subtest: pipe-D-eDP-1
[523.152028] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.287s)
[523.154469] Subtest disable-crc-after-crtc: SUCCESS (8.609s)
[523.998031] [132/154] (515s left) gem_pxp (display-protected-crc)
[524.063645] Starting subtest: display-protected-crc
[525.722122] Subtest display-protected-crc: SUCCESS (1.658s)
[525.831837] [133/154] (513s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[525.932837] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[525.936827] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[526.036947] [134/154] (513s left) perf_pmu (all-busy-idle-check-all)
[526.084426] Starting subtest: all-busy-idle-check-all
[528.050582] Subtest all-busy-idle-check-all: SUCCESS (1.967s)
[528.158741] [135/154] (511s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-onoff)
[528.264180] Starting subtest: hdr-2p-primscrn-cur-indfb-onoff
[528.268466] Subtest hdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[528.349720] [136/154] (511s left) gem_exec_fence (syncobj-signal)
[528.779825] Starting subtest: syncobj-signal
[528.785478] Subtest syncobj-signal: SUCCESS (0.005s)
[530.106499] [137/154] (509s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-render)
[530.204210] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-render
[530.208727] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[530.322278] [138/154] (509s left) syncobj_timeline (wait-delayed-signal)
[530.383548] Starting subtest: wait-delayed-signal
[530.486627] Subtest wait-delayed-signal: SUCCESS (0.103s)
[530.601197] [139/154] (509s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[530.700396] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[534.442017] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.747s)
[535.610506] [140/154] (504s left) intel_hwmon (hwmon-read)
[535.667968] Subtest hwmon-read: SKIP (0.000s)
[535.731298] [141/154] (504s left) kms_frontbuffer_tracking (hdr-indfb-scaledprimary)
[535.824305] Starting subtest: hdr-indfb-scaledprimary
[535.828266] Subtest hdr-indfb-scaledprimary: SKIP (0.000s)
[535.921531] [142/154] (503s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[536.017284] Starting subtest: fbc-pr-sprite-mmap-gtt
[536.021491] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[536.088511] [143/154] (503s left) kms_cursor_crc (cursor-offscreen-128x128)
[536.288007] Starting subtest: cursor-offscreen-128x128
[536.293187] Starting dynamic subtest: pipe-A-eDP-1
[538.246795] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.952s)
[538.277837] Starting dynamic subtest: pipe-D-eDP-1
[540.904801] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.636s)
[540.907350] Subtest cursor-offscreen-128x128: SUCCESS (4.615s)
[541.773128] [144/154] (498s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[541.859281] Starting subtest: primary-4-tiled-reflect-x-0
[548.962715] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.104s)
[550.141408] [145/154] (489s left) gem_exec_parallel (basic)
[550.202186] Starting subtest: basic
[550.204434] Starting dynamic subtest: rcs0
[551.637695] Dynamic subtest rcs0: SUCCESS (1.435s)
[551.649026] Starting dynamic subtest: bcs0
[553.136702] Dynamic subtest bcs0: SUCCESS (1.498s)
[553.148683] Starting dynamic subtest: vcs0
[555.017782] Dynamic subtest vcs0: SUCCESS (1.878s)
[555.032001] Starting dynamic subtest: vcs1
[557.042603] Dynamic subtest vcs1: SUCCESS (2.021s)
[557.059765] Starting dynamic subtest: vecs0
[559.026064] Dynamic subtest vecs0: SUCCESS (1.981s)
[559.037074] Starting dynamic subtest: ccs0
[560.535845] Dynamic subtest ccs0: SUCCESS (1.508s)
[560.538177] Subtest basic: SUCCESS (10.334s)
[560.728247] [146/154] (479s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-pwrite)
[560.835211] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-pwrite
[560.839158] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[560.938155] [147/154] (479s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-onoff)
[561.039073] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-onoff
[561.043512] Subtest psrhdr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[561.154072] [148/154] (479s left) gem_lmem_swapping (parallel-random-verify)
[561.195219] Subtest parallel-random-verify: SKIP (0.000s)
[561.237105] [149/154] (478s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-mmap-cpu)
[561.341427] Starting subtest: fbcpsrhdr-rgb565-draw-mmap-cpu
[561.345855] Subtest fbcpsrhdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[561.451377] [150/154] (478s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[561.550390] Starting subtest: plane-lut1d-post-ctm3x4
[561.696087] Starting dynamic subtest: pipe-A-plane-0
[561.840360] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[561.851856] Starting dynamic subtest: pipe-A-plane-1
[561.984947] Dynamic subtest pipe-A-plane-1: SUCCESS (0.144s)
[561.995864] Starting dynamic subtest: pipe-A-plane-2
[562.117798] Dynamic subtest pipe-A-plane-2: SUCCESS (0.132s)
[563.363799] Starting dynamic subtest: pipe-B-plane-0
[563.543521] Dynamic subtest pipe-B-plane-0: SUCCESS (0.189s)
[563.554820] Starting dynamic subtest: pipe-B-plane-1
[563.733212] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s)
[563.744082] Starting dynamic subtest: pipe-B-plane-2
[563.899631] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[565.096634] Starting dynamic subtest: pipe-C-plane-0
[565.231407] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[565.242522] Starting dynamic subtest: pipe-C-plane-1
[565.388674] Dynamic subtest pipe-C-plane-1: SUCCESS (0.154s)
[565.399892] Starting dynamic subtest: pipe-C-plane-2
[565.554258] Dynamic subtest pipe-C-plane-2: SUCCESS (0.165s)
[566.816147] Starting dynamic subtest: pipe-D-plane-0
[566.975459] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[566.988820] Starting dynamic subtest: pipe-D-plane-1
[567.139920] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[567.152930] Starting dynamic subtest: pipe-D-plane-2
[567.284459] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[567.569428] Subtest plane-lut1d-post-ctm3x4: SUCCESS (6.019s)
[568.376535] [151/154] (471s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[568.428852] Starting subtest: etime-multi-wait-all-for-submit-submitted
[568.534089] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.104s)
[568.626422] [152/154] (471s left) kms_psr (fbc-pr-dpms)
[568.721153] Starting subtest: fbc-pr-dpms
[568.725330] Subtest fbc-pr-dpms: SKIP (0.000s)
[568.795141] [153/154] (471s left) kms_joiner (basic-force-ultra-joiner)
[568.892406] Starting subtest: basic-force-ultra-joiner
[568.896531] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[568.960610] [154/154] (471s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[569.015653] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[569.017634] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[569.134387] Closing watchdogs
results: parsing output: 0/ for test: gem_ctx_exec
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: gem_wait
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: i915_drm_fdinfo
results: parsing output: 5/ for test: kms_debugfs
results: parsing output: 6/ for test: gem_mmap_gtt
results: parsing output: 7/ for test: gem_exec_whisper
results: parsing output: 8/ for test: kms_cursor_legacy
results: parsing output: 9/ for test: gem_ctx_create
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: gem_ctx_isolation
results: parsing output: 14/ for test: kms_flip
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_mmap_gtt
results: parsing output: 17/ for test: kms_async_flips
results: parsing output: 18/ for test: perf
results: parsing output: 19/ for test: kms_chamelium_frames
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_pm_dc
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: gem_ccs
results: parsing output: 24/ for test: kms_busy
results: parsing output: 25/ for test: dmabuf_sync_file
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_pm_rpm
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_exec_flush
results: parsing output: 32/ for test: gen9_exec_parse
results: parsing output: 33/ for test: gem_render_copy_redux
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: kms_plane_scaling
results: parsing output: 36/ for test: gem_render_copy_redux
results: parsing output: 37/ for test: kms_ccs
results: parsing output: 38/ for test: gem_unref_active_buffers
results: parsing output: 39/ for test: kms_pipe_crc_basic
results: parsing output: 40/ for test: gem_mmap_wc
results: parsing output: 41/ for test: gem_exec_balancer
results: parsing output: 42/ for test: syncobj_wait
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: api_intel_allocator
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_chamelium_hpd
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: kms_flip_scaled_crc
results: parsing output: 50/ for test: gem_tiled_pread_pwrite
results: parsing output: 51/ for test: gem_eio
results: parsing output: 52/ for test: perf
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_draw_crc
results: parsing output: 56/ for test: gem_spin_batch
results: parsing output: 57/ for test: kms_plane
results: parsing output: 58/ for test: syncobj_wait
results: parsing output: 59/ for test: perf_pmu
results: parsing output: 60/ for test: gem_ctx_param
results: parsing output: 61/ for test: gem_pxp
results: parsing output: 62/ for test: kms_cursor_edge_walk
results: parsing output: 63/ for test: gen7_exec_parse
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: i915_getparams_basic
results: parsing output: 71/ for test: kms_rotation_crc
results: parsing output: 72/ for test: gem_mmap_wc
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: kms_psr2_sf
results: parsing output: 75/ for test: kms_addfb_basic
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: perf
results: parsing output: 79/ for test: kms_vblank
results: parsing output: 80/ for test: kms_psr2_sf
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: i915_pm_rps
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_mmap_gtt
results: parsing output: 88/ for test: kms_flip
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_flip_scaled_crc
results: parsing output: 91/ for test: gem_render_copy
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: api_intel_bb
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_content_protection
results: parsing output: 99/ for test: syncobj_wait
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: perf
results: parsing output: 104/ for test: gem_exec_fence
results: parsing output: 105/ for test: gem_exec_schedule
results: parsing output: 106/ for test: kms_psr
results: parsing output: 107/ for test: kms_plane_scaling
results: parsing output: 108/ for test: gem_exec_schedule
results: parsing output: 109/ for test: gem_ctx_persistence
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_getfb
results: parsing output: 112/ for test: syncobj_wait
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_async_flips
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: perf_pmu
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_flip_scaled_crc
results: parsing output: 119/ for test: kms_chamelium_audio
results: parsing output: 120/ for test: prime_vgem
results: parsing output: 121/ for test: gem_exec_reloc
results: parsing output: 122/ for test: gem_mmap_gtt
results: parsing output: 123/ for test: gem_exec_reloc
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_vblank
results: parsing output: 126/ for test: gem_fence_thrash
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_plane
results: parsing output: 129/ for test: kms_cursor_crc
results: parsing output: 130/ for test: kms_pipe_crc_basic
results: parsing output: 131/ for test: gem_pxp
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: perf_pmu
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: gem_exec_fence
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: syncobj_timeline
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: intel_hwmon
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: kms_psr
results: parsing output: 142/ for test: kms_cursor_crc
results: parsing output: 143/ for test: kms_rotation_crc
results: parsing output: 144/ for test: gem_exec_parallel
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: gem_lmem_swapping
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_color_pipeline
results: parsing output: 150/ for test: syncobj_timeline
results: parsing output: 151/ for test: kms_psr
results: parsing output: 152/ for test: kms_joiner
results: parsing output: 153/ for test: syncobj_timeline
Done.