[56.780310] Initializing watchdogs
[56.780379]   /dev/watchdog0
[56.796167] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.800685] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.803515] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.807547] [001/133] (960s left) gem_userptr_blits (relocations)
[56.905311] Starting subtest: relocations
[56.909169] Subtest relocations: SKIP (0.001s)
[57.016763] [002/133] (960s left) syncobj_timeline (single-wait-available-submitted)
[57.066036] Starting subtest: single-wait-available-submitted
[57.068673] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[57.185660] [003/133] (960s left) gem_softpin (allocator-fork)
[57.237271] Starting subtest: allocator-fork
[59.488086] Subtest allocator-fork: SUCCESS (2.205s)
[59.546564] [004/133] (957s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[59.655227] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[66.854941] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.220s)
[67.386109] [005/133] (950s left) kms_psr (pr-primary-mmap-cpu)
[67.657486] Starting subtest: pr-primary-mmap-cpu
[67.662129] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[68.039982] [006/133] (949s left) gem_readwrite (write-bad-handle)
[68.102893] Subtest write-bad-handle: SKIP (0.000s)
[68.170898] [007/133] (949s left) gem_create (create-ext-placement-all)
[68.333615] Starting subtest: create-ext-placement-all
[68.335834] Subtest create-ext-placement-all: SUCCESS (0.000s)
[68.455748] [008/133] (949s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[68.595825] Starting subtest: dp-mst-type-1-suspend-resume
[68.600163] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[68.698136] [009/133] (948s left) gem_exec_flush (basic-uc-rw-default)
[68.755482] Starting subtest: basic-uc-rw-default
[74.240345] Subtest basic-uc-rw-default: SUCCESS (5.451s)
[74.388912] [010/133] (943s left) gem_ringfill (engines-basic)
[79.897673] Starting subtest: engines-basic
[79.900094] Starting dynamic subtest: rcs0
[79.961504] Dynamic subtest rcs0: SUCCESS (0.065s)
[79.972529] Starting dynamic subtest: bcs0
[80.005226] Dynamic subtest bcs0: SUCCESS (0.043s)
[80.016399] Starting dynamic subtest: vcs0
[80.048679] Dynamic subtest vcs0: SUCCESS (0.042s)
[80.057935] Starting dynamic subtest: vcs1
[80.091507] Dynamic subtest vcs1: SUCCESS (0.042s)
[80.100850] Starting dynamic subtest: vecs0
[80.135714] Dynamic subtest vecs0: SUCCESS (0.043s)
[80.145062] Starting dynamic subtest: ccs0
[80.181516] Dynamic subtest ccs0: SUCCESS (0.045s)
[80.183996] Subtest engines-basic: SUCCESS (0.286s)
[80.253675] [FACT gem_ringfill (engines-basic)] new: kernel.kmod_is_loaded.vgem: true
[80.257601] [011/133] (937s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[80.360884] Starting subtest: 2x-absolute-wf_vblank-interruptible
[80.372282] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.010s)
[80.451734] [012/133] (937s left) syncobj_wait (invalid-reset-bad-pad)
[80.510969] Starting subtest: invalid-reset-bad-pad
[80.513322] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[80.617868] [013/133] (937s left) kms_chamelium_hpd (dp-hpd-storm)
[80.992273] Subtest dp-hpd-storm: SKIP (0.000s)
[81.812202] [014/133] (936s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[81.905127] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[81.907318] Starting dynamic subtest: pipe-A-default-mode
[84.687732] Dynamic subtest pipe-A-default-mode: SUCCESS (2.781s)
[84.690059] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.782s)
[85.518246] [015/133] (932s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[85.572636] Starting subtest: invalid-multi-wait-unsubmitted
[85.574551] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[85.662361] [016/133] (932s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[85.756227] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[85.758537] Starting dynamic subtest: pipe-A-eDP-1
[85.782066] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[85.791716] Starting dynamic subtest: pipe-B-eDP-1
[85.813363] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[85.820858] Starting dynamic subtest: pipe-C-eDP-1
[85.842785] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[85.850283] Starting dynamic subtest: pipe-D-eDP-1
[85.872359] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[85.876414] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[88.104216] [017/133] (929s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[88.199348] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[88.203852] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s)
[88.269374] [018/133] (929s left) i915_pm_freq_api (freq-suspend)
[88.347054] Starting subtest: freq-suspend
[88.349051] Starting dynamic subtest: gt0
[105.111349] Dynamic subtest gt0: SUCCESS (1.370s)
[105.121709] Starting dynamic subtest: gt1
[121.131297] Dynamic subtest gt1: SUCCESS (1.230s)
[121.133528] Subtest freq-suspend: SUCCESS (2.601s)
[121.210369] [019/133] (896s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[121.724633] Starting subtest: syncobj-timeline-invalid-flags
[121.726795] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[123.155957] [020/133] (894s left) kms_color_pipeline (plane-ctm3x4)
[123.254069] Starting subtest: plane-ctm3x4
[123.377559] Starting dynamic subtest: pipe-A-plane-0
[123.497378] Dynamic subtest pipe-A-plane-0: SUCCESS (0.122s)
[123.505350] Starting dynamic subtest: pipe-A-plane-1
[123.605731] Dynamic subtest pipe-A-plane-1: SUCCESS (0.111s)
[123.614972] Starting dynamic subtest: pipe-A-plane-2
[123.716182] Dynamic subtest pipe-A-plane-2: SUCCESS (0.111s)
[124.933465] Starting dynamic subtest: pipe-B-plane-0
[125.059378] Dynamic subtest pipe-B-plane-0: SUCCESS (0.133s)
[125.068570] Starting dynamic subtest: pipe-B-plane-1
[125.169300] Dynamic subtest pipe-B-plane-1: SUCCESS (0.111s)
[125.178373] Starting dynamic subtest: pipe-B-plane-2
[125.300900] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[126.439754] Starting dynamic subtest: pipe-C-plane-0
[126.554262] Dynamic subtest pipe-C-plane-0: SUCCESS (0.122s)
[126.565788] Starting dynamic subtest: pipe-C-plane-1
[126.675492] Dynamic subtest pipe-C-plane-1: SUCCESS (0.122s)
[126.684800] Starting dynamic subtest: pipe-C-plane-2
[126.786721] Dynamic subtest pipe-C-plane-2: SUCCESS (0.111s)
[127.957177] Starting dynamic subtest: pipe-D-plane-0
[128.061721] Dynamic subtest pipe-D-plane-0: SUCCESS (0.111s)
[128.069867] Starting dynamic subtest: pipe-D-plane-1
[128.171878] Dynamic subtest pipe-D-plane-1: SUCCESS (0.111s)
[128.179877] Starting dynamic subtest: pipe-D-plane-2
[128.304394] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[128.594756] Subtest plane-ctm3x4: SUCCESS (5.391s)
[129.414435] [021/133] (888s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[129.496680] Starting subtest: plane-upscale-20x20-with-modifiers
[129.498986] Starting dynamic subtest: pipe-A
[129.833894] Dynamic subtest pipe-A: SUCCESS (0.339s)
[129.843063] Starting dynamic subtest: pipe-B
[131.204602] Dynamic subtest pipe-B: SUCCESS (1.377s)
[131.213892] Starting dynamic subtest: pipe-C
[132.631346] Dynamic subtest pipe-C: SUCCESS (1.432s)
[132.640409] Starting dynamic subtest: pipe-D
[134.053647] Dynamic subtest pipe-D: SUCCESS (1.427s)
[134.055994] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.578s)
[135.221205] [022/133] (882s left) gem_exec_whisper (basic-fds-priority-all)
[135.292732] Starting subtest: basic-fds-priority-all
[157.704742] Subtest basic-fds-priority-all: SUCCESS (22.433s)
[157.883283] [023/133] (860s left) kms_flip (2x-dpms-vs-vblank-race)
[157.984534] Starting subtest: 2x-dpms-vs-vblank-race
[157.993413] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s)
[158.083557] [024/133] (860s left) kms_pm_lpsp (kms-lpsp)
[159.186372] Starting subtest: kms-lpsp
[159.188314] Starting dynamic subtest: pipe-A-eDP-1
[159.365538] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.180s)
[159.655672] Subtest kms-lpsp: SUCCESS (0.470s)
[160.516662] [025/133] (857s left) perf_pmu (init-sema)
[160.551767] Starting subtest: init-sema
[160.553983] Starting dynamic subtest: rcs0
[160.556294] Dynamic subtest rcs0: SUCCESS (0.001s)
[160.565859] Starting dynamic subtest: bcs0
[160.567735] Dynamic subtest bcs0: SUCCESS (0.000s)
[160.575844] Starting dynamic subtest: vcs0
[160.577905] Dynamic subtest vcs0: SUCCESS (0.001s)
[160.585562] Starting dynamic subtest: vcs1
[160.587424] Dynamic subtest vcs1: SUCCESS (0.000s)
[160.595167] Starting dynamic subtest: vecs0
[160.596973] Dynamic subtest vecs0: SUCCESS (0.000s)
[160.606912] Starting dynamic subtest: ccs0
[160.609194] Dynamic subtest ccs0: SUCCESS (0.000s)
[160.611406] Subtest init-sema: SUCCESS (0.006s)
[160.662183] [026/133] (857s left) kms_psr (psr2-primary-page-flip)
[160.757219] Starting subtest: psr2-primary-page-flip
[160.759451] Starting dynamic subtest: eDP-1
[162.501523] Dynamic subtest eDP-1: SUCCESS (1.744s)
[162.503803] Subtest psr2-primary-page-flip: SUCCESS (1.744s)
[163.381648] [027/133] (854s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[163.487553] Starting subtest: y-tiled-64bpp-rotate-180
[163.491709] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[163.590111] [028/133] (854s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[163.684889] Starting subtest: fbc-1p-pri-indfb-multidraw
[176.501066] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (12.825s)
[177.912190] [029/133] (840s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[178.018348] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[178.022408] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[178.122027] [030/133] (840s left) kms_invalid_mode (bad-hsync-start)
[178.213553] Starting subtest: bad-hsync-start
[178.215814] Starting dynamic subtest: pipe-A-eDP-1
[178.501293] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[178.510350] Starting dynamic subtest: pipe-B-eDP-1
[178.512662] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[178.520855] Starting dynamic subtest: pipe-C-eDP-1
[178.523184] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[178.531422] Starting dynamic subtest: pipe-D-eDP-1
[178.533791] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[178.536187] Subtest bad-hsync-start: SUCCESS (0.295s)
[179.333629] [031/133] (839s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[179.424447] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[179.428489] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[179.545893] [032/133] (839s left) core_setmaster (master-drop-set-shared-fd)
[179.624672] Starting subtest: master-drop-set-shared-fd
[179.646802] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[179.686705] [033/133] (838s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[179.784407] Starting subtest: yf-tiled-8bpp-rotate-90
[179.788815] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[179.874792] [034/133] (838s left) gem_pxp (regular-baseline-src-copy-readible)
[180.002201] Starting subtest: regular-baseline-src-copy-readible
[180.077235] Subtest regular-baseline-src-copy-readible: SUCCESS (0.076s)
[180.197557] [035/133] (838s left) kms_plane_scaling (intel-max-src-size)
[180.282709] Starting subtest: intel-max-src-size
[180.288212] Subtest intel-max-src-size: SKIP (0.000s)
[180.385434] [036/133] (838s left) syncobj_eventfd (invalid-illegal-eventfd)
[180.436096] Starting subtest: invalid-illegal-eventfd
[180.437647] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[180.525071] [037/133] (838s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[180.578077] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[180.644939] [038/133] (838s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[180.732525] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[180.735992] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[180.842896] [039/133] (837s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[180.885797] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[180.924196] [040/133] (837s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[181.016965] Starting subtest: async-flip-with-page-flip-events-tiled
[181.399546] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[184.259378] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.806s)
[184.271700] Starting dynamic subtest: pipe-A-eDP-1-4
[186.443441] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.185s)
[186.459243] Starting dynamic subtest: pipe-A-eDP-1-4
[188.401533] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[188.410693] Starting dynamic subtest: pipe-A-eDP-1-x
[190.641707] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[190.974103] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[193.786867] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.769s)
[193.799184] Starting dynamic subtest: pipe-B-eDP-1-4
[195.972501] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[195.984468] Starting dynamic subtest: pipe-B-eDP-1-4
[197.929801] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[197.942732] Starting dynamic subtest: pipe-B-eDP-1-x
[200.170699] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[200.498701] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[203.316501] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.773s)
[203.333372] Starting dynamic subtest: pipe-C-eDP-1-4
[205.501453] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.185s)
[205.510686] Starting dynamic subtest: pipe-C-eDP-1-4
[207.458964] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[207.469847] Starting dynamic subtest: pipe-C-eDP-1-x
[209.688514] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[210.014777] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[212.797925] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.794s)
[212.808846] Starting dynamic subtest: pipe-D-eDP-1-4
[214.960325] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.163s)
[214.969030] Starting dynamic subtest: pipe-D-eDP-1-4
[216.970202] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[216.981892] Starting dynamic subtest: pipe-D-eDP-1-x
[219.190222] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.165s)
[219.192315] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.135s)
[220.288968] [041/133] (798s left) kms_cursor_crc (cursor-offscreen-max-size)
[220.579158] Starting subtest: cursor-offscreen-max-size
[220.585813] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[220.718260] [042/133] (798s left) kms_vblank (wait-busy-hang)
[220.811341] Starting subtest: wait-busy-hang
[220.813597] Starting dynamic subtest: pipe-A-eDP-1
[246.902235] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.084s)
[246.916729] Starting dynamic subtest: pipe-D-eDP-1
[261.818441] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.915s)
[261.820915] Subtest wait-busy-hang: SUCCESS (41.003s)
[262.659413] [043/133] (756s left) kms_vblank (query-busy)
[262.749056] Starting subtest: query-busy
[262.751125] Starting dynamic subtest: pipe-A-eDP-1
[264.625234] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.876s)
[264.638430] Starting dynamic subtest: pipe-D-eDP-1
[267.217957] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.592s)
[267.220374] Subtest query-busy: SUCCESS (4.471s)
[268.014357] [044/133] (751s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[268.125765] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[269.069579] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.945s)
[269.194651] [045/133] (749s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[269.250995] Starting subtest: invalid-single-wait-all-unsubmitted
[269.253276] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[269.339369] [046/133] (749s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[269.459598] Starting subtest: 2x-flip-vs-cursor-atomic
[269.463457] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[269.601575] [047/133] (749s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[269.662249] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[269.664177] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[269.759121] [048/133] (749s left) syncobj_wait (wait-zero-handles)
[269.809518] Starting subtest: wait-zero-handles
[269.811376] Subtest wait-zero-handles: SUCCESS (0.000s)
[269.905408] [049/133] (749s left) gem_exec_params (batch-first)
[269.963395] Starting subtest: batch-first
[269.969578] Subtest batch-first: SUCCESS (0.006s)
[270.102918] [050/133] (749s left) api_intel_bb (full-batch)
[270.152690] Starting subtest: full-batch
[270.156868] Subtest full-batch: SUCCESS (0.005s)
[270.274351] [051/133] (749s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[270.375374] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[270.378717] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[270.487100] [052/133] (748s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[270.597812] Starting subtest: psr-rgb565-draw-mmap-wc
[277.410302] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.821s)
[277.509588] [053/133] (741s left) kms_psr (psr-no-drrs)
[277.611636] Starting subtest: psr-no-drrs
[277.613741] Starting dynamic subtest: eDP-1
[279.213920] Dynamic subtest eDP-1: SUCCESS (1.601s)
[279.215852] Subtest psr-no-drrs: SUCCESS (1.602s)
[280.014061] [054/133] (739s left) gem_exec_gttfill (basic)
[280.091824] Starting subtest: basic
[282.776496] Subtest basic: SUCCESS (2.688s)
[282.961316] [055/133] (736s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[283.107772] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[283.110115] Starting dynamic subtest: pipe-A-default-mode
[284.273249] Dynamic subtest pipe-A-default-mode: SKIP (1.164s)
[284.277404] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.166s)
[284.408980] [056/133] (735s left) kms_prop_blob (basic)
[284.469077] Starting subtest: basic
[284.471296] Subtest basic: SUCCESS (0.000s)
[284.565791] [057/133] (734s left) perf_pmu (semaphore-wait-idle)
[284.615267] Starting subtest: semaphore-wait-idle
[284.617183] Starting dynamic subtest: rcs0
[285.127694] Dynamic subtest rcs0: SUCCESS (0.512s)
[285.140116] Starting dynamic subtest: bcs0
[285.640758] Dynamic subtest bcs0: SUCCESS (0.510s)
[285.653159] Starting dynamic subtest: vcs0
[286.154044] Dynamic subtest vcs0: SUCCESS (0.511s)
[286.166686] Starting dynamic subtest: vcs1
[286.666836] Dynamic subtest vcs1: SUCCESS (0.510s)
[286.678828] Starting dynamic subtest: vecs0
[287.178401] Dynamic subtest vecs0: SUCCESS (0.510s)
[287.189057] Starting dynamic subtest: ccs0
[287.698611] Dynamic subtest ccs0: SUCCESS (0.516s)
[287.701416] Subtest semaphore-wait-idle: SUCCESS (3.086s)
[289.090712] [058/133] (730s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[289.194052] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[289.196384] Starting dynamic subtest: pipe-A-eDP-1
[289.219320] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[289.230043] Starting dynamic subtest: pipe-B-eDP-1
[289.251448] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[289.259886] Starting dynamic subtest: pipe-C-eDP-1
[289.280995] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[289.289277] Starting dynamic subtest: pipe-D-eDP-1
[289.310448] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[289.314792] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[291.484732] [059/133] (728s left) gem_exec_balancer (semaphore)
[291.543491] Starting subtest: semaphore
[293.105609] Subtest semaphore: SUCCESS (1.561s)
[293.428443] [060/133] (726s left) gem_exec_reloc (basic-cpu-wc-active)
[293.500007] Subtest basic-cpu-wc-active: SKIP (0.000s)
[293.569772] [061/133] (726s left) kms_cursor_crc (cursor-random-512x512)
[293.828332] Starting subtest: cursor-random-512x512
[293.832586] Subtest cursor-random-512x512: SKIP (0.001s)
[293.996006] [062/133] (725s left) gen9_exec_parse (valid-registers)
[294.053395] Subtest valid-registers: SKIP (0.000s)
[294.139318] [063/133] (725s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[294.241550] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[294.245922] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[294.342161] [064/133] (725s left) gem_exec_reloc (basic-cpu-gtt-active)
[294.396170] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[294.467774] [065/133] (725s left) kms_psr (fbc-pr-primary-render)
[294.551469] Starting subtest: fbc-pr-primary-render
[294.555109] Subtest fbc-pr-primary-render: SKIP (0.000s)
[294.627652] [066/133] (725s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[294.675194] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[294.747261] [067/133] (725s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[294.844720] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[294.847980] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[294.944939] [068/133] (725s left) kms_chamelium_audio (dp-audio-edid)
[295.310103] Subtest dp-audio-edid: SKIP (0.000s)
[296.093521] [069/133] (723s left) gem_ctx_persistence (heartbeat-stop)
[296.154220] Starting subtest: heartbeat-stop
[296.158750] Subtest heartbeat-stop: SKIP (0.000s)
[296.254088] [070/133] (723s left) gem_userptr_blits (nohangcheck)
[296.320760] Starting subtest: nohangcheck
[296.565840] Subtest nohangcheck: SUCCESS (0.244s)
[296.680730] [071/133] (723s left) kms_flip (plain-flip-ts-check)
[296.780789] Starting subtest: plain-flip-ts-check
[296.783274] Starting dynamic subtest: A-eDP1
[305.735562] Dynamic subtest A-eDP1: SUCCESS (8.924s)
[305.744452] Starting dynamic subtest: B-eDP1
[314.585375] Dynamic subtest B-eDP1: SUCCESS (8.850s)
[314.595935] Starting dynamic subtest: C-eDP1
[323.413912] Dynamic subtest C-eDP1: SUCCESS (8.817s)
[323.426362] Starting dynamic subtest: D-eDP1
[332.229636] Dynamic subtest D-eDP1: SUCCESS (8.825s)
[332.231787] Subtest plain-flip-ts-check: SUCCESS (35.430s)
[333.374926] [072/133] (686s left) kms_pipe_crc_basic (suspend-read-crc)
[333.473483] Starting subtest: suspend-read-crc
[333.475786] Starting dynamic subtest: pipe-A-eDP-1
[351.068431] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.611s)
[351.079775] Starting dynamic subtest: pipe-B-eDP-1
[369.026585] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.136s)
[369.037127] Starting dynamic subtest: pipe-C-eDP-1
[386.998055] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.074s)
[387.010665] Starting dynamic subtest: pipe-D-eDP-1
[405.015417] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.058s)
[405.018406] Subtest suspend-read-crc: SUCCESS (11.885s)
[405.828678] [073/133] (614s left) gem_softpin (evict-active-interruptible)
[405.897263] Starting subtest: evict-active-interruptible
[405.901613] Subtest evict-active-interruptible: SUCCESS (0.007s)
[406.022191] [074/133] (614s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[406.112530] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[406.117472] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[406.208562] [075/133] (614s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[406.316290] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[406.321229] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[406.411153] [076/133] (613s left) gem_exec_balancer (full)
[406.469396] Starting subtest: full
[411.566753] Subtest full: SUCCESS (5.099s)
[411.875036] [077/133] (608s left) sw_sync (sync_busy_fork_unixsocket)
[411.926322] Starting subtest: sync_busy_fork_unixsocket
[411.935247] Subtest sync_busy_fork_unixsocket: SUCCESS (0.009s)
[412.020510] [078/133] (608s left) kms_cursor_crc (cursor-tearing-position-change)
[412.140675] Starting subtest: cursor-tearing-position-change
[412.143674] Starting dynamic subtest: pipe-A-eDP-1
[412.699687] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.559s)
[412.709601] Starting dynamic subtest: pipe-D-eDP-1
[413.956213] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.258s)
[413.959087] Subtest cursor-tearing-position-change: SUCCESS (1.820s)
[414.793729] [079/133] (605s left) gem_mmap_wc (bad-size)
[414.850125] Subtest bad-size: SKIP (0.000s)
[414.907195] [080/133] (605s left) i915_pm_rpm (gem-idle)
[416.939590] Starting subtest: gem-idle
[423.143401] Subtest gem-idle: SUCCESS (6.201s)
[423.477663] [081/133] (597s left) kms_dp_link_training (non-uhbr-sst)
[424.781691] Starting subtest: non-uhbr-sst
[424.791668] Subtest non-uhbr-sst: SKIP (0.000s)
[424.854091] [082/133] (595s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[424.953248] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[424.964669] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s)
[425.040084] [083/133] (595s left) kms_pwrite_crc
[426.700432] [084/133] (593s left) kms_frontbuffer_tracking (psr-suspend)
[426.799330] Starting subtest: psr-suspend
[465.675120] Subtest psr-suspend: SUCCESS (7.923s)
[465.793790] [085/133] (554s left) gem_eio (context-create)
[466.014142] Starting subtest: context-create
[466.316388] Subtest context-create: SUCCESS (0.307s)
[466.445648] [086/133] (554s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[466.545818] Starting subtest: x-tiled-64bpp-rotate-0
[468.182639] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.657s)
[468.345943] [087/133] (552s left) kms_psr2_su (page_flip-p010)
[468.399760] Subtest page_flip-P010: SKIP (0.000s)
[468.452373] [088/133] (552s left) syncobj_wait (single-wait-all-signaled)
[468.501315] Starting subtest: single-wait-all-signaled
[468.503172] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[468.603218] [089/133] (552s left) kms_big_fb (linear-16bpp-rotate-180)
[468.703275] Starting subtest: linear-16bpp-rotate-180
[470.071384] Subtest linear-16bpp-rotate-180: SUCCESS (1.379s)
[470.176253] [090/133] (550s left) gem_exec_create (forked)
[470.229288] Starting subtest: forked
[470.231387] Starting dynamic subtest: smem
[491.701720] Dynamic subtest smem: SUCCESS (21.537s)
[491.704393] Subtest forked: SUCCESS (21.539s)
[491.886283] [091/133] (529s left) kms_chamelium_edid (dp-edid-resolution-list)
[492.272388] Subtest dp-edid-resolution-list: SKIP (0.000s)
[493.051930] [092/133] (527s left) gem_exec_schedule (pi-userfault)
[493.246529] Starting subtest: pi-userfault
[493.248812] Starting dynamic subtest: rcs0
[493.255844] Dynamic subtest rcs0: SUCCESS (0.011s)
[493.267662] Starting dynamic subtest: bcs0
[493.269552] Dynamic subtest bcs0: SUCCESS (0.008s)
[493.278660] Starting dynamic subtest: vcs0
[493.280832] Dynamic subtest vcs0: SUCCESS (0.009s)
[493.289957] Starting dynamic subtest: vcs1
[493.291860] Dynamic subtest vcs1: SUCCESS (0.010s)
[493.301106] Starting dynamic subtest: vecs0
[493.303325] Dynamic subtest vecs0: SUCCESS (0.008s)
[493.312004] Starting dynamic subtest: ccs0
[493.313959] Dynamic subtest ccs0: SUCCESS (0.009s)
[493.315880] Subtest pi-userfault: SUCCESS (0.058s)
[493.496386] [093/133] (527s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[493.580825] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[493.584914] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[493.668277] [094/133] (527s left) api_intel_allocator (gem-pool)
[493.727223] Starting subtest: gem-pool
[493.731899] Subtest gem-pool: SUCCESS (0.007s)
[493.848150] [095/133] (527s left) gem_busy (semaphore)
[494.028587] Subtest semaphore: SKIP (0.000s)
[494.262268] [096/133] (526s left) syncobj_timeline (reset-unsignaled)
[494.323501] Starting subtest: reset-unsignaled
[494.325820] Subtest reset-unsignaled: SUCCESS (0.000s)
[494.437005] [097/133] (526s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[494.524161] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[501.224969] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.704s)
[501.352891] [098/133] (519s left) kms_async_flips (test-cursor)
[501.451148] Starting subtest: test-cursor
[501.839771] Starting dynamic subtest: pipe-A-eDP-1
[502.615831] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.776s)
[503.001196] Starting dynamic subtest: pipe-B-eDP-1
[503.742339] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.749s)
[504.124549] Starting dynamic subtest: pipe-C-eDP-1
[504.870709] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.753s)
[505.249849] Starting dynamic subtest: pipe-D-eDP-1
[506.006201] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.765s)
[506.008596] Subtest test-cursor: SUCCESS (4.556s)
[507.174625] [099/133] (514s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[507.263840] Starting subtest: 4-tiled-32bpp-rotate-180
[508.644810] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.381s)
[508.811488] [100/133] (512s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[508.912025] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[508.915292] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[509.008377] [101/133] (512s left) gem_softpin (evict-active)
[509.075004] Starting subtest: evict-active
[509.077792] Subtest evict-active: SUCCESS (0.006s)
[509.181863] [102/133] (512s left) i915_query (query-regions-garbage-items)
[509.242668] Starting subtest: query-regions-garbage-items
[509.244298] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[509.345577] [103/133] (512s left) kms_psr (fbc-psr-no-drrs)
[509.437590] Starting subtest: fbc-psr-no-drrs
[509.439662] Starting dynamic subtest: eDP-1
[509.443342] Dynamic subtest eDP-1: SKIP (0.000s)
[509.447083] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[509.512721] [104/133] (511s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[509.612583] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[509.616469] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[509.696000] [105/133] (511s left) gem_render_copy_redux (interruptible)
[509.761358] Starting subtest: interruptible
[510.052257] Subtest interruptible: SUCCESS (0.291s)
[510.163346] [106/133] (511s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[510.269537] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[510.273069] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[510.360892] [107/133] (511s left) gem_mmap_gtt (basic-small-copy-odd)
[510.418123] Subtest basic-small-copy-odd: SKIP (0.000s)
[510.487666] [108/133] (511s left) gem_exec_gttfill (multigpu-basic)
[510.664621] Starting subtest: multigpu-basic
[522.839479] Subtest multigpu-basic: SUCCESS (12.178s)
[522.899684] [109/133] (498s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[523.047077] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[523.051350] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[523.132182] [110/133] (498s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[523.238741] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[523.242862] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[523.309052] [111/133] (498s left) gem_mmap_offset (blt-coherency)
[523.362245] Starting subtest: blt-coherency
[523.369067] Subtest blt-coherency: SUCCESS (0.008s)
[523.495942] [112/133] (498s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[523.591141] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[530.583291] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (6.996s)
[530.725245] [113/133] (491s left) kms_feature_discovery (psr1)
[530.820585] Starting subtest: psr1
[530.822955] Subtest psr1: SUCCESS (0.000s)
[530.896256] [114/133] (491s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[531.019774] Starting subtest: flip-vs-cursor-legacy
[538.101853] Subtest flip-vs-cursor-legacy: SUCCESS (7.083s)
[538.904678] [115/133] (483s left) gem_sync (basic-store-all)
[538.979678] Starting subtest: basic-store-all
[543.150639] Subtest basic-store-all: SUCCESS (4.181s)
[543.336165] [116/133] (478s left) gem_exec_schedule (preempt-self)
[543.420259] Starting subtest: preempt-self
[543.422859] Starting dynamic subtest: rcs0
[543.448293] Dynamic subtest rcs0: SUCCESS (0.033s)
[543.458466] Starting dynamic subtest: bcs0
[543.476602] Dynamic subtest bcs0: SUCCESS (0.028s)
[543.485993] Starting dynamic subtest: vcs0
[543.508765] Dynamic subtest vcs0: SUCCESS (0.031s)
[543.521245] Starting dynamic subtest: vcs1
[543.542291] Dynamic subtest vcs1: SUCCESS (0.033s)
[543.551417] Starting dynamic subtest: vecs0
[543.568990] Dynamic subtest vecs0: SUCCESS (0.026s)
[543.581059] Starting dynamic subtest: ccs0
[543.603734] Dynamic subtest ccs0: SUCCESS (0.034s)
[543.606067] Subtest preempt-self: SUCCESS (0.190s)
[544.788470] [117/133] (477s left) kms_vrr (seamless-rr-switch-virtual)
[544.874105] Starting subtest: seamless-rr-switch-virtual
[544.880449] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[544.947681] [118/133] (477s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[545.045466] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[545.049781] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[546.146860] [119/133] (475s left) kms_lease (lease-uevent)
[546.233035] Starting subtest: lease-uevent
[547.243187] Subtest lease-uevent: SUCCESS (1.011s)
[547.343977] [120/133] (474s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[547.428730] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[547.433023] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[547.506792] [121/133] (474s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[547.595512] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[551.589735] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (3.999s)
[552.725058] [122/133] (469s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[552.824633] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[552.826885] Starting dynamic subtest: pipe-A-eDP-1
[552.945285] Dynamic subtest pipe-A-eDP-1: SKIP (0.122s)
[552.956486] Starting dynamic subtest: pipe-B-eDP-1
[554.097911] Dynamic subtest pipe-B-eDP-1: SKIP (1.151s)
[554.102290] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.276s)
[555.393219] [123/133] (466s left) syncobj_wait (invalid-reset-one-illegal-handle)
[555.450262] Starting subtest: invalid-reset-one-illegal-handle
[555.452577] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[555.555065] [124/133] (466s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[555.655131] Starting subtest: pixel-format-linear-modifier-source-clamping
[555.682267] Starting dynamic subtest: pipe-A-plane-0
[559.424453] Dynamic subtest pipe-A-plane-0: SUCCESS (3.744s)
[559.436431] Starting dynamic subtest: pipe-A-plane-3
[561.135166] Dynamic subtest pipe-A-plane-3: SUCCESS (1.709s)
[562.275391] Starting dynamic subtest: pipe-B-plane-0
[566.001303] Dynamic subtest pipe-B-plane-0: SUCCESS (3.733s)
[566.015540] Starting dynamic subtest: pipe-B-plane-3
[567.646069] Dynamic subtest pipe-B-plane-3: SUCCESS (1.642s)
[567.962042] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (12.307s)
[568.753498] [125/133] (453s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[568.852388] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[576.399684] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.547s)
[576.548656] [126/133] (445s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[576.648314] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[576.652378] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[576.746415] [127/133] (445s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[576.804459] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[576.912194] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.108s)
[576.989064] [128/133] (445s left) gem_workarounds (basic-read-context)
[577.057522] Starting subtest: basic-read-context
[577.066843] Subtest basic-read-context: SUCCESS (0.009s)
[577.196688] [129/133] (445s left) gem_madvise (dontneed-before-pwrite)
[577.234363] Starting subtest: dontneed-before-pwrite
[577.251206] Subtest dontneed-before-pwrite: SKIP (0.014s)
[577.312595] [130/133] (445s left) gem_exec_reloc (basic-write-gtt-noreloc)
[577.372071] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[577.449202] [131/133] (445s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[577.530314] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[577.532623] Starting dynamic subtest: pipe-A-eDP-1
[577.555212] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[577.567712] Starting dynamic subtest: pipe-B-eDP-1
[577.589018] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[577.598188] Starting dynamic subtest: pipe-C-eDP-1
[577.619181] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[577.628134] Starting dynamic subtest: pipe-D-eDP-1
[577.649321] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[577.653574] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.004s)
[579.753845] [132/133] (442s left) gem_ctx_isolation (preservation-s3)
[579.819547] Starting subtest: preservation-S3
[579.821816] Starting dynamic subtest: rcs0
[596.143135] Dynamic subtest rcs0: SUCCESS (1.321s)
[596.153708] Starting dynamic subtest: bcs0
[612.152757] Dynamic subtest bcs0: SUCCESS (1.308s)
[612.165392] Starting dynamic subtest: vcs0
[628.158710] Dynamic subtest vcs0: SUCCESS (2.294s)
[628.169361] Starting dynamic subtest: vcs1
[646.137114] Dynamic subtest vcs1: SUCCESS (5.092s)
[646.147818] Starting dynamic subtest: vecs0
[664.170988] Dynamic subtest vecs0: SUCCESS (5.089s)
[664.188444] Starting dynamic subtest: ccs0
[682.131702] Dynamic subtest ccs0: SUCCESS (3.181s)
[682.135159] Subtest preservation-S3: SUCCESS (18.291s)
[682.355810] [133/133] (340s left) gen7_exec_parse (cmd-crossing-page)
[682.417492] Subtest cmd-crossing-page: SKIP (0.000s)
[682.489234] Closing watchdogs
results: parsing output: 0/ for test: gem_userptr_blits
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: gem_softpin
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: gem_readwrite
results: parsing output: 6/ for test: gem_create
results: parsing output: 7/ for test: kms_content_protection
results: parsing output: 8/ for test: gem_exec_flush
results: parsing output: 9/ for test: gem_ringfill
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: syncobj_wait
results: parsing output: 12/ for test: kms_chamelium_hpd
results: parsing output: 13/ for test: kms_flip_scaled_crc
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: kms_plane
results: parsing output: 17/ for test: i915_pm_freq_api
results: parsing output: 18/ for test: gem_exec_fence
results: parsing output: 19/ for test: kms_color_pipeline
results: parsing output: 20/ for test: kms_plane_scaling
results: parsing output: 21/ for test: gem_exec_whisper
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: kms_pm_lpsp
results: parsing output: 24/ for test: perf_pmu
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: kms_big_fb
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_invalid_mode
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: core_setmaster
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: gem_pxp
results: parsing output: 34/ for test: kms_plane_scaling
results: parsing output: 35/ for test: syncobj_eventfd
results: parsing output: 36/ for test: gem_exec_reloc
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_lmem_swapping
results: parsing output: 39/ for test: kms_async_flips
results: parsing output: 40/ for test: kms_cursor_crc
results: parsing output: 41/ for test: kms_vblank
results: parsing output: 42/ for test: kms_vblank
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: syncobj_wait
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: syncobj_wait
results: parsing output: 48/ for test: gem_exec_params
results: parsing output: 49/ for test: api_intel_bb
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: gem_exec_gttfill
results: parsing output: 54/ for test: kms_flip_scaled_crc
results: parsing output: 55/ for test: kms_prop_blob
results: parsing output: 56/ for test: perf_pmu
results: parsing output: 57/ for test: kms_ccs
results: parsing output: 58/ for test: gem_exec_balancer
results: parsing output: 59/ for test: gem_exec_reloc
results: parsing output: 60/ for test: kms_cursor_crc
results: parsing output: 61/ for test: gen9_exec_parse
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: gem_exec_reloc
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: gem_mmap_gtt
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_chamelium_audio
results: parsing output: 68/ for test: gem_ctx_persistence
results: parsing output: 69/ for test: gem_userptr_blits
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: kms_pipe_crc_basic
results: parsing output: 72/ for test: gem_softpin
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_exec_balancer
results: parsing output: 76/ for test: sw_sync
results: parsing output: 77/ for test: kms_cursor_crc
results: parsing output: 78/ for test: gem_mmap_wc
results: parsing output: 79/ for test: i915_pm_rpm
results: parsing output: 80/ for test: kms_dp_link_training
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: kms_pwrite_crc
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_eio
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: kms_psr2_su
results: parsing output: 87/ for test: syncobj_wait
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: gem_exec_create
results: parsing output: 90/ for test: kms_chamelium_edid
results: parsing output: 91/ for test: gem_exec_schedule
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: api_intel_allocator
results: parsing output: 94/ for test: gem_busy
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_async_flips
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_softpin
results: parsing output: 101/ for test: i915_query
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_render_copy_redux
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_mmap_gtt
results: parsing output: 107/ for test: gem_exec_gttfill
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_psr2_sf
results: parsing output: 110/ for test: gem_mmap_offset
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_feature_discovery
results: parsing output: 113/ for test: kms_cursor_legacy
results: parsing output: 114/ for test: gem_sync
results: parsing output: 115/ for test: gem_exec_schedule
results: parsing output: 116/ for test: kms_vrr
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: kms_lease
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_psr2_sf
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: kms_plane
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: gem_workarounds
results: parsing output: 128/ for test: gem_madvise
results: parsing output: 129/ for test: gem_exec_reloc
results: parsing output: 130/ for test: kms_ccs
results: parsing output: 131/ for test: gem_ctx_isolation
results: parsing output: 132/ for test: gen7_exec_parse
Done.