[57.843467] Initializing watchdogs
[57.843510]   /dev/watchdog0
[57.856572] [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.860779] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.862980] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.866264] [001/133] (960s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[57.957591] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[57.962354] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[58.146215] [002/133] (960s left) kms_lease (lease-again)
[58.241963] Starting subtest: lease-again
[58.244372] Starting dynamic subtest: pipe-A-eDP-1
[58.246751] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[58.254823] Starting dynamic subtest: pipe-B-eDP-1
[58.256969] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[58.263577] Starting dynamic subtest: pipe-C-eDP-1
[58.265681] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[58.272636] Starting dynamic subtest: pipe-D-eDP-1
[58.274823] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[58.277058] Subtest lease-again: SUCCESS (0.011s)
[58.368382] [003/133] (960s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[58.425942] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[58.529196] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.104s)
[58.613126] [004/133] (959s left) kms_async_flips (test-time-stamp)
[58.707448] Starting subtest: test-time-stamp
[59.078830] Starting dynamic subtest: pipe-A-eDP-1
[59.857747] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.778s)
[60.239364] Starting dynamic subtest: pipe-B-eDP-1
[60.996778] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.762s)
[61.363812] Starting dynamic subtest: pipe-C-eDP-1
[62.120462] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.761s)
[62.478910] Starting dynamic subtest: pipe-D-eDP-1
[63.250731] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.776s)
[63.253244] Subtest test-time-stamp: SUCCESS (4.552s)
[64.421015] [005/133] (954s left) kms_feature_discovery (display-1x)
[64.525692] Starting subtest: display-1x
[64.528174] Subtest display-1x: SUCCESS (0.000s)
[64.619717] [006/133] (953s left) syncobj_wait (single-wait-signaled)
[64.688969] Starting subtest: single-wait-signaled
[64.691381] Subtest single-wait-signaled: SUCCESS (0.000s)
[64.811812] [007/133] (953s left) vgem_basic (mmap)
[64.878527] Starting subtest: mmap
[64.885411] Subtest mmap: SUCCESS (0.009s)
[64.942329] [FACT vgem_basic (mmap)] new: kernel.kmod_is_loaded.vgem: true
[64.945228] [008/133] (953s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[65.046489] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[65.051073] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[65.176493] [009/133] (953s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[65.229312] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[65.231716] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[65.349553] [010/133] (953s left) gem_ctx_persistence (legacy-engines-hostile)
[65.422246] Starting subtest: legacy-engines-hostile
[65.424283] Starting dynamic subtest: render
[65.597309] Dynamic subtest render: SUCCESS (0.175s)
[65.606445] Starting dynamic subtest: bsd1
[65.712412] Dynamic subtest bsd1: SUCCESS (0.113s)
[65.721503] Starting dynamic subtest: bsd2
[65.827065] Dynamic subtest bsd2: SUCCESS (0.113s)
[65.836983] Starting dynamic subtest: blt
[65.952481] Dynamic subtest blt: SUCCESS (0.124s)
[65.961820] Starting dynamic subtest: vebox
[66.078577] Dynamic subtest vebox: SUCCESS (0.124s)
[66.080997] Subtest legacy-engines-hostile: SUCCESS (0.657s)
[66.173195] [011/133] (952s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[66.257940] Starting subtest: disable-crc-after-crtc
[66.259521] Starting dynamic subtest: pipe-A-eDP-1
[67.867719] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.611s)
[67.877243] Starting dynamic subtest: pipe-B-eDP-1
[70.117786] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.250s)
[70.125626] Starting dynamic subtest: pipe-C-eDP-1
[72.369321] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.251s)
[72.378327] Starting dynamic subtest: pipe-D-eDP-1
[74.628748] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.259s)
[74.631114] Subtest disable-crc-after-crtc: SUCCESS (8.375s)
[75.464379] [012/133] (943s left) kms_vrr (seamless-rr-switch-drrs)
[75.563065] Starting subtest: seamless-rr-switch-drrs
[75.569397] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[75.678493] [013/133] (943s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[75.786166] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[80.236545] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.453s)
[81.380505] [014/133] (937s left) kms_color (ctm-green-to-red)
[81.470263] Starting subtest: ctm-green-to-red
[81.472544] Starting dynamic subtest: pipe-A-eDP-1
[82.182221] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.712s)
[82.190575] Starting dynamic subtest: pipe-B-eDP-1
[83.539955] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.356s)
[83.548220] Starting dynamic subtest: pipe-C-eDP-1
[84.806099] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.268s)
[84.814255] Starting dynamic subtest: pipe-D-eDP-1
[86.133600] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.327s)
[86.136095] Subtest ctm-green-to-red: SUCCESS (4.664s)
[86.986231] [015/133] (931s left) gem_exec_create (madvise)
[87.056846] Starting subtest: madvise
[87.059149] Starting dynamic subtest: smem
[107.996824] Dynamic subtest smem: SUCCESS (20.937s)
[107.999475] Subtest madvise: SUCCESS (20.938s)
[108.890581] [016/133] (910s left) kms_flip (flip-vs-suspend-interruptible)
[108.991961] Starting subtest: flip-vs-suspend-interruptible
[108.994352] Starting dynamic subtest: A-eDP1
[158.063473] Dynamic subtest A-eDP1: SUCCESS (4.682s)
[158.072139] Starting dynamic subtest: B-eDP1
[207.049566] Dynamic subtest B-eDP1: SUCCESS (4.527s)
[207.058253] Starting dynamic subtest: C-eDP1
[256.048363] Dynamic subtest C-eDP1: SUCCESS (4.521s)
[256.068209] Starting dynamic subtest: D-eDP1
[305.086090] Dynamic subtest D-eDP1: SUCCESS (4.589s)
[305.088416] Subtest flip-vs-suspend-interruptible: SUCCESS (18.329s)
[306.295373] [017/133] (712s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[306.401688] Starting subtest: fbcpsr-modesetfrombusy
[312.534557] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.157s)
[312.707159] [018/133] (706s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[312.803741] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[312.815452] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.010s)
[312.906692] [019/133] (706s left) gem_eio (kms)
[313.178692] Starting subtest: kms
[334.788411] Subtest kms: SUCCESS (21.631s)
[336.002564] [020/133] (683s left) kms_joiner (basic-big-joiner)
[336.116806] Starting subtest: basic-big-joiner
[336.120987] Subtest basic-big-joiner: SKIP (0.000s)
[336.192073] [021/133] (682s left) gem_exec_schedule (preempt-other-chain)
[336.269927] Starting subtest: preempt-other-chain
[336.271834] Starting dynamic subtest: rcs0
[336.345622] Dynamic subtest rcs0: SUCCESS (0.082s)
[336.358980] Starting dynamic subtest: bcs0
[336.422418] Dynamic subtest bcs0: SUCCESS (0.077s)
[336.431843] Starting dynamic subtest: vcs0
[336.498193] Dynamic subtest vcs0: SUCCESS (0.075s)
[336.509109] Starting dynamic subtest: vcs1
[336.575178] Dynamic subtest vcs1: SUCCESS (0.076s)
[336.583786] Starting dynamic subtest: vecs0
[336.654338] Dynamic subtest vecs0: SUCCESS (0.078s)
[336.666322] Starting dynamic subtest: ccs0
[336.733612] Dynamic subtest ccs0: SUCCESS (0.078s)
[336.736242] Subtest preempt-other-chain: SUCCESS (0.472s)
[337.906297] [022/133] (681s left) syncobj_timeline (reset-during-wait-for-submit)
[337.956258] Starting subtest: reset-during-wait-for-submit
[338.058155] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[338.148651] [023/133] (681s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[338.250198] Starting subtest: cursor-tearing-framebuffer-change
[338.252431] Starting dynamic subtest: pipe-A-eDP-1
[338.823275] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.570s)
[338.832322] Starting dynamic subtest: pipe-D-eDP-1
[340.016691] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.192s)
[340.018847] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.765s)
[340.850328] [024/133] (678s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[340.954201] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[340.958474] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[341.057713] [025/133] (678s left) kms_addfb_basic (too-wide)
[341.159459] Starting subtest: too-wide
[341.161758] Subtest too-wide: SUCCESS (0.000s)
[341.299553] [026/133] (678s left) gem_pread (exhaustion)
[341.359446] Subtest exhaustion: SKIP (0.000s)
[341.429295] [027/133] (677s left) kms_plane (plane-panning-bottom-right)
[341.518031] Starting subtest: plane-panning-bottom-right
[341.520176] Starting dynamic subtest: pipe-A
[343.203854] Dynamic subtest pipe-A: SUCCESS (1.685s)
[343.213087] Starting dynamic subtest: pipe-B
[345.493099] Dynamic subtest pipe-B: SUCCESS (2.289s)
[345.495441] Subtest plane-panning-bottom-right: SUCCESS (3.977s)
[346.289866] [028/133] (673s left) gem_exec_schedule (fifo)
[346.366554] Starting subtest: fifo
[346.368850] Starting dynamic subtest: rcs0
[346.444749] Dynamic subtest rcs0: SUCCESS (0.089s)
[346.456313] Starting dynamic subtest: vcs0
[346.517879] Dynamic subtest vcs0: SUCCESS (0.073s)
[346.530879] Starting dynamic subtest: vcs1
[346.597011] Dynamic subtest vcs1: SUCCESS (0.079s)
[346.609325] Starting dynamic subtest: vecs0
[346.680035] Dynamic subtest vecs0: SUCCESS (0.082s)
[346.689688] Starting dynamic subtest: ccs0
[346.774905] Dynamic subtest ccs0: SUCCESS (0.094s)
[346.777286] Subtest fifo: SUCCESS (0.421s)
[347.974197] [029/133] (671s left) dmabuf_sync_file (export-basic)
[348.026158] Starting subtest: export-basic
[348.028100] Subtest export-basic: SUCCESS (0.001s)
[348.099721] [030/133] (671s left) gem_exec_fence (submit)
[348.289052] Starting subtest: submit
[348.294072] Subtest submit: SKIP (0.000s)
[349.938504] [031/133] (669s left) gem_flink_race (flink_name)
[349.974544] Starting subtest: flink_name
[355.386537] Subtest flink_name: SUCCESS (5.403s)
[355.540502] [032/133] (664s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[355.656491] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[362.421478] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.771s)
[362.578672] [033/133] (657s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[362.687573] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[362.689797] Starting dynamic subtest: pipe-A-eDP-1
[362.712717] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[362.727794] Starting dynamic subtest: pipe-B-eDP-1
[362.749232] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[362.757410] Starting dynamic subtest: pipe-C-eDP-1
[362.778641] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[362.786468] Starting dynamic subtest: pipe-D-eDP-1
[362.808193] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[362.812204] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[364.912713] [034/133] (654s left) gem_mmap_gtt (basic-read-write-distinct)
[364.975912] Subtest basic-read-write-distinct: SKIP (0.000s)
[365.039735] [035/133] (654s left) kms_addfb_basic (unused-pitches)
[365.091408] Starting subtest: unused-pitches
[365.093583] Subtest unused-pitches: SUCCESS (0.000s)
[365.235510] [036/133] (654s left) gem_spin_batch (user-each)
[365.303060] Starting subtest: user-each
[368.569716] Subtest user-each: SUCCESS (3.259s)
[368.882315] [037/133] (650s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[368.992197] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[368.996443] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[369.098456] [038/133] (650s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[369.162554] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[369.271414] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.108s)
[369.361834] [039/133] (650s left) kms_atomic_transition (plane-all-transition-fencing)
[369.467348] Starting subtest: plane-all-transition-fencing
[369.469577] Starting dynamic subtest: pipe-A-eDP-1
[371.959129] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.494s)
[372.289202] Starting dynamic subtest: pipe-B-eDP-1
[375.534833] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.257s)
[375.833437] Subtest plane-all-transition-fencing: SUCCESS (6.368s)
[376.669602] [040/133] (643s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[376.778044] Starting subtest: plane-use-after-nonblocking-unbind
[376.780410] Starting dynamic subtest: pipe-A-eDP-1
[376.837287] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.061s)
[377.134983] Starting dynamic subtest: pipe-B-eDP-1
[377.952955] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.827s)
[378.254425] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.478s)
[379.136932] [041/133] (640s left) syncobj_wait (multi-wait-for-submit-submitted)
[379.201015] Starting subtest: multi-wait-for-submit-submitted
[379.302680] Subtest multi-wait-for-submit-submitted: SUCCESS (0.102s)
[379.405687] [042/133] (640s left) gem_partial_pwrite_pread (writes-after-reads-display)
[379.471402] Subtest writes-after-reads-display: SKIP (0.000s)
[379.554054] [043/133] (640s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[379.658718] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[386.380605] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.727s)
[386.565138] [044/133] (633s left) kms_psr (fbc-pr-dpms)
[386.660857] Starting subtest: fbc-pr-dpms
[386.665115] Subtest fbc-pr-dpms: SKIP (0.000s)
[386.742890] [045/133] (633s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[386.852412] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[386.856983] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[386.993020] [046/133] (633s left) gem_exec_balancer (parallel-keep-in-fence)
[387.254697] Starting subtest: parallel-keep-in-fence
[388.432764] Subtest parallel-keep-in-fence: SUCCESS (1.179s)
[388.568641] [047/133] (631s left) i915_hangman (hangcheck-unterminated)
[388.626991] Starting subtest: hangcheck-unterminated
[399.769236] Subtest hangcheck-unterminated: SUCCESS (11.147s)
[399.937768] [048/133] (620s left) kms_psr (pr-no-drrs)
[400.049260] Starting subtest: pr-no-drrs
[400.053641] Subtest pr-no-drrs: SKIP (0.000s)
[400.134294] [049/133] (620s left) gem_flink_basic (basic)
[400.182744] Starting subtest: basic
[400.184929] Subtest basic: SUCCESS (0.000s)
[400.303850] [050/133] (620s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[400.399892] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[400.404328] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[400.539827] [051/133] (619s left) gem_basic (create-fd-close)
[400.607807] Starting subtest: create-fd-close
[400.612466] Subtest create-fd-close: SUCCESS (0.000s)
[400.732719] [052/133] (619s left) gem_render_copy_redux (interruptible)
[400.791475] Starting subtest: interruptible
[401.073827] Subtest interruptible: SUCCESS (0.285s)
[401.208690] [053/133] (619s left) kms_cursor_crc (cursor-offscreen-128x42)
[401.430816] Starting subtest: cursor-offscreen-128x42
[401.474790] Subtest cursor-offscreen-128x42: SKIP (0.039s)
[401.703169] [054/133] (618s left) perf (per-context-mode-unprivileged)
[401.833791] Starting subtest: per-context-mode-unprivileged
[401.837284] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[401.874311] [055/133] (618s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[401.969471] Starting subtest: psr-2p-pri-indfb-multidraw
[401.972865] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[402.071570] [056/133] (618s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[402.145524] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[402.211731] [057/133] (618s left) gem_exec_params (rel-constants-invalid-ring)
[402.274503] Starting subtest: rel-constants-invalid-ring
[402.276468] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[402.396545] [058/133] (618s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[402.502519] Starting subtest: y-tiled-16bpp-rotate-180
[402.506251] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[402.612515] [059/133] (618s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[402.706814] Starting subtest: basic-modeset-with-all-modifiers-formats
[403.087049] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[403.906218] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.819s)
[403.915746] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[403.928043] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[403.936705] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[403.950147] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.021s)
[403.959125] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[404.094632] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.144s)
[404.103907] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[404.116697] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[404.125339] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[404.138958] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.021s)
[404.147620] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[404.161198] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[404.169401] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[404.183450] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[404.191406] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[404.205617] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.022s)
[404.213730] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[404.227823] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[404.235877] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[404.250048] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.022s)
[404.258096] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[404.272386] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[404.280487] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[404.428025] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s)
[404.437399] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[404.449964] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[404.458059] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[404.472351] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s)
[404.480581] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[404.494446] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.021s)
[404.505885] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[404.516304] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[404.525094] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[404.538839] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s)
[404.547034] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[404.561051] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.021s)
[404.569254] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[404.583311] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.021s)
[404.591540] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[404.605828] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[404.621090] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[404.761552] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.154s)
[404.770716] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[404.783190] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[404.792019] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[404.805619] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[404.814225] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[404.828002] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[404.838585] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[404.850178] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[404.858431] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[404.872394] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.021s)
[404.880514] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[404.894582] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[404.902320] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[404.916383] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.021s)
[404.924249] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[404.938648] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[405.320201] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.616s)
[406.094277] [060/133] (614s left) i915_pm_rps (waitboost)
[406.173667] Starting subtest: waitboost
[412.259289] Subtest waitboost: SUCCESS (6.088s)
[412.412984] [061/133] (608s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[412.523566] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[412.527802] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[412.652540] [062/133] (608s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[412.758660] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[419.826120] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.073s)
[420.007872] [063/133] (600s left) gem_lmem_swapping (random-engines)
[420.052222] Subtest random-engines: SKIP (0.000s)
[420.094588] [064/133] (600s left) kms_plane_cursor (viewport)
[420.190657] Starting subtest: viewport
[420.195034] Starting dynamic subtest: pipe-A-eDP-1-size-64
[422.740479] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.550s)
[422.801028] Starting dynamic subtest: pipe-A-eDP-1-size-128
[425.273018] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.482s)
[425.333893] Starting dynamic subtest: pipe-A-eDP-1-size-256
[427.806442] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.482s)
[428.154917] Starting dynamic subtest: pipe-B-eDP-1-size-64
[431.354805] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.213s)
[431.416738] Starting dynamic subtest: pipe-B-eDP-1-size-128
[433.911037] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.505s)
[433.969574] Starting dynamic subtest: pipe-B-eDP-1-size-256
[436.444534] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.482s)
[436.791896] Starting dynamic subtest: pipe-C-eDP-1-size-64
[439.541429] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.761s)
[439.578030] Starting dynamic subtest: pipe-C-eDP-1-size-128
[441.772501] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.203s)
[441.809244] Starting dynamic subtest: pipe-C-eDP-1-size-256
[443.893712] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.091s)
[444.221224] Starting dynamic subtest: pipe-D-eDP-1-size-64
[447.033670] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.825s)
[447.071398] Starting dynamic subtest: pipe-D-eDP-1-size-128
[449.255413] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.191s)
[449.292346] Starting dynamic subtest: pipe-D-eDP-1-size-256
[451.366478] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.081s)
[451.683873] Subtest viewport: SUCCESS (31.507s)
[452.543590] [065/133] (568s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[452.816993] Starting subtest: cursor-rapid-movement-512x512
[452.821257] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[453.019679] [066/133] (567s left) kms_flip (2x-wf_vblank-ts-check)
[453.107510] Starting subtest: 2x-wf_vblank-ts-check
[453.115867] Subtest 2x-wf_vblank-ts-check: SKIP (0.010s)
[453.238428] [067/133] (567s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[453.616029] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[454.440674] [068/133] (566s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[454.539817] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[454.542181] Starting dynamic subtest: pipe-A-eDP-1
[454.950780] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.381s)
[454.961526] Starting dynamic subtest: pipe-B-eDP-1
[456.358556] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.408s)
[456.368822] Starting dynamic subtest: pipe-C-eDP-1
[457.682382] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.322s)
[457.692866] Starting dynamic subtest: pipe-D-eDP-1
[459.031197] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.350s)
[459.033437] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.466s)
[460.222635] [069/133] (560s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[460.330167] Starting subtest: 4-tiled-8bpp-rotate-180
[461.479929] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.150s)
[461.626175] [070/133] (559s left) gem_ctx_isolation (nonpriv-switch)
[461.703171] Starting subtest: nonpriv-switch
[461.705559] Starting dynamic subtest: rcs0
[461.990764] Dynamic subtest rcs0: SUCCESS (0.288s)
[462.001646] Starting dynamic subtest: bcs0
[462.305296] Dynamic subtest bcs0: SUCCESS (0.314s)
[462.316165] Starting dynamic subtest: vcs0
[462.614463] Dynamic subtest vcs0: SUCCESS (0.308s)
[462.625294] Starting dynamic subtest: vcs1
[464.045665] Dynamic subtest vcs1: SUCCESS (1.430s)
[464.056774] Starting dynamic subtest: vecs0
[466.098446] Dynamic subtest vecs0: SUCCESS (2.047s)
[466.109000] Starting dynamic subtest: ccs0
[468.116469] Dynamic subtest ccs0: SUCCESS (2.012s)
[468.118794] Subtest nonpriv-switch: SUCCESS (6.405s)
[468.398488] [071/133] (552s left) gem_exercise_blt (fast-copy-emit)
[468.465272] Starting subtest: fast-copy-emit
[468.468016] Starting dynamic subtest: linear-smem-smem-emit
[468.491623] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.027s)
[468.502922] Starting dynamic subtest: xmajor-smem-smem-emit
[468.510233] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.018s)
[468.518643] Starting dynamic subtest: tile4-smem-smem-emit
[468.528636] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.018s)
[468.536966] Starting dynamic subtest: tile64-smem-smem-emit
[468.546723] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.017s)
[468.548892] Subtest fast-copy-emit: SUCCESS (0.083s)
[468.699975] [072/133] (552s left) kms_rotation_crc (multiplane-rotation)
[468.808159] Starting subtest: multiplane-rotation
[486.233709] Subtest multiplane-rotation: SUCCESS (17.415s)
[486.396914] [073/133] (534s left) gem_ctx_exec (basic-invalid-context)
[486.481351] Starting subtest: basic-invalid-context
[486.486000] Subtest basic-invalid-context: SUCCESS (0.004s)
[486.641693] [074/133] (534s left) gem_eio (in-flight-internal-10ms)
[486.870566] Starting subtest: in-flight-internal-10ms
[487.873415] Subtest in-flight-internal-10ms: SUCCESS (1.001s)
[488.031727] [075/133] (533s left) gem_userptr_blits (unsync-unmap)
[488.104561] Subtest unsync-unmap: SKIP (0.000s)
[488.250335] [076/133] (533s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[488.376934] Starting subtest: verify-pxp-execution-after-suspend-resume
[495.460972] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.085s)
[495.622406] [077/133] (525s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[495.739179] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[495.751078] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s)
[495.840382] [078/133] (525s left) api_intel_allocator (reopen-fork)
[495.912908] Starting subtest: reopen-fork
[499.242405] Subtest reopen-fork: SUCCESS (3.330s)
[499.339861] [079/133] (522s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[499.438850] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[499.442994] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[499.546145] [080/133] (522s left) i915_drm_fdinfo (memory-info-active)
[499.586192] Starting subtest: memory-info-active
[499.588534] Starting dynamic subtest: smem0
[502.229909] Dynamic subtest smem0: SUCCESS (2.645s)
[502.232033] Subtest memory-info-active: SUCCESS (2.647s)
[502.316792] [081/133] (519s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[502.435063] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[502.456202] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.019s)
[502.555604] [082/133] (519s left) kms_big_fb (linear-64bpp-rotate-90)
[502.663692] Starting subtest: linear-64bpp-rotate-90
[502.682984] Subtest linear-64bpp-rotate-90: SKIP (0.019s)
[502.835224] [083/133] (518s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[502.922643] Starting subtest: psr-rgb101010-draw-render
[510.148631] Subtest psr-rgb101010-draw-render: SUCCESS (7.228s)
[510.298332] [084/133] (511s left) gem_mmap_offset (mmap-boundaries)
[510.359150] Starting subtest: mmap-boundaries
[510.361183] Starting dynamic subtest: smem0
[510.631882] Dynamic subtest smem0: SUCCESS (0.275s)
[510.634425] Subtest mmap-boundaries: SUCCESS (0.276s)
[510.791960] [085/133] (510s left) gem_exec_store (cachelines)
[510.866746] Starting subtest: cachelines
[510.868711] Starting dynamic subtest: rcs0
[510.994329] Dynamic subtest rcs0: SUCCESS (0.128s)
[511.006209] Starting dynamic subtest: bcs0
[511.064930] Dynamic subtest bcs0: SUCCESS (0.069s)
[511.075895] Starting dynamic subtest: vcs0
[511.128129] Dynamic subtest vcs0: SUCCESS (0.062s)
[511.138641] Starting dynamic subtest: vcs1
[511.192911] Dynamic subtest vcs1: SUCCESS (0.060s)
[511.203313] Starting dynamic subtest: vecs0
[511.250896] Dynamic subtest vecs0: SUCCESS (0.059s)
[511.261419] Starting dynamic subtest: ccs0
[511.313733] Dynamic subtest ccs0: SUCCESS (0.061s)
[511.316108] Subtest cachelines: SUCCESS (0.449s)
[511.507797] [086/133] (510s left) api_intel_bb (intel-bb-blit-none)
[511.574579] Starting subtest: intel-bb-blit-none
[515.348181] Subtest intel-bb-blit-none: SUCCESS (3.773s)
[515.495947] [087/133] (506s left) kms_universal_plane (universal-plane-pageflip-windowed)
[515.602304] Starting subtest: universal-plane-pageflip-windowed
[515.604561] Starting dynamic subtest: pipe-A-eDP-1
[516.200891] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.599s)
[516.210473] Starting dynamic subtest: pipe-B-eDP-1
[517.468235] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.265s)
[517.478031] Starting dynamic subtest: pipe-C-eDP-1
[518.669783] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.201s)
[518.685260] Starting dynamic subtest: pipe-D-eDP-1
[519.903205] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.233s)
[519.905489] Subtest universal-plane-pageflip-windowed: SUCCESS (4.303s)
[520.776932] [088/133] (501s left) gem_eio (suspend)
[520.999471] Starting subtest: suspend
[533.251280] Subtest suspend: SUCCESS (12.251s)
[533.405677] [089/133] (488s left) gem_exec_balancer (invalid-bonds)
[533.465199] Starting subtest: invalid-bonds
[533.469475] Subtest invalid-bonds: SKIP (0.000s)
[533.781370] [090/133] (488s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[533.871657] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[533.873853] Starting dynamic subtest: pipe-A-eDP-1
[533.896146] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[533.907075] Starting dynamic subtest: pipe-B-eDP-1
[533.928633] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[533.939695] Starting dynamic subtest: pipe-C-eDP-1
[533.961214] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[533.969914] Starting dynamic subtest: pipe-D-eDP-1
[533.992063] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[533.996129] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[536.138121] [091/133] (485s left) gem_pread (snoop)
[536.202934] Subtest snoop: SKIP (0.000s)
[536.267528] [092/133] (485s left) perf_pmu (semaphore-wait-idle)
[536.310065] Starting subtest: semaphore-wait-idle
[536.312391] Starting dynamic subtest: rcs0
[536.825779] Dynamic subtest rcs0: SUCCESS (0.513s)
[536.838454] Starting dynamic subtest: bcs0
[537.340128] Dynamic subtest bcs0: SUCCESS (0.511s)
[537.352563] Starting dynamic subtest: vcs0
[537.852794] Dynamic subtest vcs0: SUCCESS (0.510s)
[537.865506] Starting dynamic subtest: vcs1
[538.366938] Dynamic subtest vcs1: SUCCESS (0.511s)
[538.379210] Starting dynamic subtest: vecs0
[538.880313] Dynamic subtest vecs0: SUCCESS (0.510s)
[538.892080] Starting dynamic subtest: ccs0
[539.395800] Dynamic subtest ccs0: SUCCESS (0.513s)
[539.398586] Subtest semaphore-wait-idle: SUCCESS (3.086s)
[540.836163] [093/133] (481s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[540.970581] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[540.974960] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[541.141067] [094/133] (481s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[541.236225] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[541.238527] Starting dynamic subtest: pipe-A-eDP-1
[541.261145] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[541.271954] Starting dynamic subtest: pipe-B-eDP-1
[541.293113] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[541.302427] Starting dynamic subtest: pipe-C-eDP-1
[541.323851] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[541.333720] Starting dynamic subtest: pipe-D-eDP-1
[541.355638] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[541.359585] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.006s)
[543.504431] [095/133] (478s left) syncobj_timeline (signal-array)
[543.576567] Starting subtest: signal-array
[543.579071] Subtest signal-array: SUCCESS (0.000s)
[543.688929] [096/133] (478s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[545.913117] Starting subtest: gem-execbuf-stress-pc8
[545.956114] Subtest gem-execbuf-stress-pc8: SKIP (0.039s)
[546.306151] [097/133] (475s left) gem_mmap_gtt (big-copy)
[546.369190] Subtest big-copy: SKIP (0.000s)
[546.441501] [098/133] (475s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[546.542240] Starting subtest: primary-y-tiled-reflect-x-180
[546.602230] Subtest primary-y-tiled-reflect-x-180: SKIP (0.059s)
[546.715496] [099/133] (475s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[546.811090] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[546.815493] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[546.943942] [100/133] (475s left) kms_chamelium_color (ctm-0-50)
[547.049833] Subtest ctm-0-50: SKIP (0.000s)
[547.098910] [101/133] (475s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[547.197236] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[547.201334] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[547.331061] [102/133] (475s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[547.447584] Starting subtest: short-flip-before-cursor-toggle
[548.374246] Subtest short-flip-before-cursor-toggle: SUCCESS (0.926s)
[549.238646] [103/133] (473s left) kms_vblank (wait-forked-busy)
[549.334269] Starting subtest: wait-forked-busy
[549.336523] Starting dynamic subtest: pipe-A-eDP-1
[551.207077] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.873s)
[551.222533] Starting dynamic subtest: pipe-D-eDP-1
[553.768544] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.559s)
[553.770855] Subtest wait-forked-busy: SUCCESS (4.436s)
[554.588776] [104/133] (467s left) gen9_exec_parse (allowed-single)
[554.658180] Subtest allowed-single: SKIP (0.000s)
[554.748618] [105/133] (467s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[554.849522] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[554.851945] Starting dynamic subtest: pipe-A-default-mode
[556.038169] Dynamic subtest pipe-A-default-mode: SKIP (1.186s)
[556.046059] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.189s)
[556.234811] [106/133] (466s left) perf_pmu (event-wait)
[556.279370] Starting subtest: event-wait
[556.281671] Starting dynamic subtest: rcs0
[556.285693] Dynamic subtest rcs0: SKIP (0.000s)
[556.289733] Subtest event-wait: SKIP (0.001s)
[556.405517] [107/133] (466s left) gem_exec_schedule (semaphore-power)
[556.576600] Subtest semaphore-power: SKIP (0.000s)
[556.766464] [108/133] (465s left) kms_dp_linktrain_fallback (dp-fallback)
[556.862505] Starting subtest: dp-fallback
[556.869164] Subtest dp-fallback: SKIP (0.000s)
[556.945840] [109/133] (465s left) gem_userptr_blits (sd-probe)
[557.004868] Starting subtest: sd-probe
[557.006707] Subtest sd-probe: SUCCESS (0.000s)
[557.164815] [110/133] (465s left) kms_atomic_interruptible (atomic-setmode)
[557.256415] Starting subtest: atomic-setmode
[557.258649] Starting dynamic subtest: pipe-A-eDP-1
[564.163655] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.906s)
[564.165958] Subtest atomic-setmode: SUCCESS (6.908s)
[565.033468] [111/133] (457s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[565.144696] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[565.148700] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[565.277169] [112/133] (457s left) gem_mmap_gtt (basic-small-bo)
[565.339325] Subtest basic-small-bo: SKIP (0.000s)
[565.410195] [113/133] (457s left) syncobj_basic (bad-create-flags)
[565.473910] Starting subtest: bad-create-flags
[565.476159] Subtest bad-create-flags: SUCCESS (0.000s)
[565.601057] [114/133] (457s left) kms_psr (psr2-primary-mmap-gtt)
[565.694068] Starting subtest: psr2-primary-mmap-gtt
[565.696328] Starting dynamic subtest: eDP-1
[567.110102] Dynamic subtest eDP-1: SKIP (1.413s)
[567.115090] Subtest psr2-primary-mmap-gtt: SKIP (1.415s)
[567.243437] [115/133] (455s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[567.349946] Starting subtest: pr-primary-plane-update-sf-dmg-area
[567.354318] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[567.432552] [116/133] (455s left) kms_pm_lpsp (kms-lpsp)
[568.543531] Starting subtest: kms-lpsp
[568.545648] Starting dynamic subtest: pipe-A-eDP-1
[568.690114] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.148s)
[568.976483] Subtest kms-lpsp: SUCCESS (0.431s)
[569.784497] [117/133] (453s left) kms_content_protection (type1)
[569.936630] Starting subtest: type1
[569.941232] Subtest type1: SKIP (0.000s)
[570.078743] [118/133] (453s left) kms_prime (d3hot)
[570.161581] Subtest D3hot: SKIP (0.000s)
[570.276481] [119/133] (452s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[570.660916] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[571.480485] [120/133] (451s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[571.581566] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[571.585526] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[571.709725] [121/133] (451s left) kms_psr (fbc-psr-primary-blt)
[571.803633] Starting subtest: fbc-psr-primary-blt
[571.805519] Starting dynamic subtest: eDP-1
[571.809563] Dynamic subtest eDP-1: SKIP (0.000s)
[571.813612] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[571.887337] [122/133] (451s left) kms_psr (fbc-psr2-primary-page-flip)
[571.989875] Starting subtest: fbc-psr2-primary-page-flip
[571.992244] Starting dynamic subtest: eDP-1
[571.996504] Dynamic subtest eDP-1: SKIP (0.000s)
[572.000680] Subtest fbc-psr2-primary-page-flip: SKIP (0.002s)
[572.073273] [123/133] (451s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[572.178834] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[572.182956] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[572.269486] [124/133] (451s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[572.379283] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[572.383572] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[572.508107] [125/133] (450s left) kms_properties (crtc-properties-atomic)
[572.618714] Starting subtest: crtc-properties-atomic
[572.620378] Starting dynamic subtest: pipe-A-eDP-1
[573.053058] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.434s)
[573.062906] Starting dynamic subtest: pipe-B-eDP-1
[574.258305] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.205s)
[574.268588] Starting dynamic subtest: pipe-C-eDP-1
[575.390786] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.129s)
[575.400889] Starting dynamic subtest: pipe-D-eDP-1
[576.513719] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.120s)
[576.515883] Subtest crtc-properties-atomic: SUCCESS (3.894s)
[577.354710] [126/133] (446s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[577.425430] Starting subtest: multi-wait-all-for-submit-available-submitted
[577.427753] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[577.574109] [127/133] (445s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[577.688788] Starting subtest: yf-tiled-16bpp-rotate-0
[577.693080] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[577.826823] [128/133] (445s left) fbdev (pan)
[577.863104] Starting subtest: pan
[577.896724] Subtest pan: SUCCESS (0.035s)
[577.980148] [129/133] (445s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[578.084993] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[579.097116] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.011s)
[579.254570] [130/133] (444s left) kms_fbcon_fbt (psr-suspend)
[579.308883] Starting subtest: psr-suspend
[629.041652] Subtest psr-suspend: SUCCESS (19.822s)
[629.133713] [131/133] (394s left) sysfs_preempt_timeout (timeout)
[629.200557] Starting subtest: timeout
[629.203549] Starting dynamic subtest: vecs0
[638.876286] Dynamic subtest vecs0: SUCCESS (9.712s)
[638.889971] Starting dynamic subtest: ccs0
[640.241667] Dynamic subtest ccs0: SUCCESS (1.364s)
[640.252240] Starting dynamic subtest: vcs0
[649.873841] Dynamic subtest vcs0: SUCCESS (9.640s)
[649.884232] Starting dynamic subtest: bcs0
[651.250853] Dynamic subtest bcs0: SUCCESS (1.378s)
[651.267869] Starting dynamic subtest: rcs0
[652.497648] Dynamic subtest rcs0: SUCCESS (1.245s)
[652.509486] Starting dynamic subtest: vcs1
[661.845988] Dynamic subtest vcs1: SUCCESS (9.348s)
[661.849235] Subtest timeout: SUCCESS (32.701s)
[661.942379] [132/133] (361s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[662.046787] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[662.051915] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[662.149857] [133/133] (361s left) kms_plane_scaling (planes-downscale-factor-0-5)
[662.246378] Starting subtest: planes-downscale-factor-0-5
[662.248593] Starting dynamic subtest: pipe-A
[662.266602] Dynamic subtest pipe-A: SKIP (0.016s)
[662.276582] Starting dynamic subtest: pipe-B
[662.294627] Dynamic subtest pipe-B: SKIP (0.029s)
[662.303926] Starting dynamic subtest: pipe-C
[662.325010] Dynamic subtest pipe-C: SKIP (0.028s)
[662.334144] Starting dynamic subtest: pipe-D
[662.351508] Dynamic subtest pipe-D: SKIP (0.027s)
[662.355243] Subtest planes-downscale-factor-0-5: SKIP (0.104s)
[662.469627] Closing watchdogs
results: parsing output: 0/ for test: gem_render_copy
results: parsing output: 1/ for test: kms_lease
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: kms_async_flips
results: parsing output: 4/ for test: kms_feature_discovery
results: parsing output: 5/ for test: syncobj_wait
results: parsing output: 6/ for test: vgem_basic
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: syncobj_wait
results: parsing output: 9/ for test: gem_ctx_persistence
results: parsing output: 10/ for test: kms_pipe_crc_basic
results: parsing output: 11/ for test: kms_vrr
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_color
results: parsing output: 14/ for test: gem_exec_create
results: parsing output: 15/ for test: kms_flip
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: gem_eio
results: parsing output: 19/ for test: kms_joiner
results: parsing output: 20/ for test: gem_exec_schedule
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_cursor_crc
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_addfb_basic
results: parsing output: 25/ for test: gem_pread
results: parsing output: 26/ for test: kms_plane
results: parsing output: 27/ for test: gem_exec_schedule
results: parsing output: 28/ for test: dmabuf_sync_file
results: parsing output: 29/ for test: gem_exec_fence
results: parsing output: 30/ for test: gem_flink_race
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: gem_mmap_gtt
results: parsing output: 34/ for test: kms_addfb_basic
results: parsing output: 35/ for test: gem_spin_batch
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: kms_atomic_transition
results: parsing output: 39/ for test: kms_atomic_transition
results: parsing output: 40/ for test: syncobj_wait
results: parsing output: 41/ for test: gem_partial_pwrite_pread
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_exec_balancer
results: parsing output: 46/ for test: i915_hangman
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: gem_flink_basic
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_basic
results: parsing output: 51/ for test: gem_render_copy_redux
results: parsing output: 52/ for test: kms_cursor_crc
results: parsing output: 53/ for test: perf
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: gem_exec_reloc
results: parsing output: 56/ for test: gem_exec_params
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: kms_async_flips
results: parsing output: 59/ for test: i915_pm_rps
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_lmem_swapping
results: parsing output: 63/ for test: kms_plane_cursor
results: parsing output: 64/ for test: kms_cursor_crc
results: parsing output: 65/ for test: kms_flip
results: parsing output: 66/ for test: kms_chamelium_hpd
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: gem_ctx_isolation
results: parsing output: 70/ for test: gem_exercise_blt
results: parsing output: 71/ for test: kms_rotation_crc
results: parsing output: 72/ for test: gem_ctx_exec
results: parsing output: 73/ for test: gem_eio
results: parsing output: 74/ for test: gem_userptr_blits
results: parsing output: 75/ for test: gem_pxp
results: parsing output: 76/ for test: kms_plane
results: parsing output: 77/ for test: api_intel_allocator
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: i915_drm_fdinfo
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_mmap_offset
results: parsing output: 84/ for test: gem_exec_store
results: parsing output: 85/ for test: api_intel_bb
results: parsing output: 86/ for test: kms_universal_plane
results: parsing output: 87/ for test: gem_eio
results: parsing output: 88/ for test: gem_exec_balancer
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: gem_pread
results: parsing output: 91/ for test: perf_pmu
results: parsing output: 92/ for test: kms_cursor_legacy
results: parsing output: 93/ for test: kms_ccs
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: i915_pm_rpm
results: parsing output: 96/ for test: gem_mmap_gtt
results: parsing output: 97/ for test: kms_rotation_crc
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_chamelium_color
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_cursor_legacy
results: parsing output: 102/ for test: kms_vblank
results: parsing output: 103/ for test: gen9_exec_parse
results: parsing output: 104/ for test: kms_flip_scaled_crc
results: parsing output: 105/ for test: perf_pmu
results: parsing output: 106/ for test: gem_exec_schedule
results: parsing output: 107/ for test: kms_dp_linktrain_fallback
results: parsing output: 108/ for test: gem_userptr_blits
results: parsing output: 109/ for test: kms_atomic_interruptible
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_mmap_gtt
results: parsing output: 112/ for test: syncobj_basic
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: kms_psr2_sf
results: parsing output: 115/ for test: kms_pm_lpsp
results: parsing output: 116/ for test: kms_content_protection
results: parsing output: 117/ for test: kms_prime
results: parsing output: 118/ for test: kms_chamelium_edid
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: kms_psr2_sf
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_properties
results: parsing output: 125/ for test: syncobj_timeline
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: fbdev
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_fbcon_fbt
results: parsing output: 130/ for test: sysfs_preempt_timeout
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: kms_plane_scaling
Done.