[60.163994] Initializing watchdogs
[60.164056]   /dev/watchdog0
[60.179292] [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]
[60.183725] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.186086] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.189260] [001/133] (960s left) gem_userptr_blits (relocations)
[60.279079] Starting subtest: relocations
[60.283590] Subtest relocations: SKIP (0.001s)
[60.410260] [002/133] (960s left) syncobj_timeline (single-wait-available-submitted)
[60.469988] Starting subtest: single-wait-available-submitted
[60.472235] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[60.586858] [003/133] (960s left) gem_softpin (allocator-fork)
[60.652068] Starting subtest: allocator-fork
[62.919670] Subtest allocator-fork: SUCCESS (2.220s)
[62.980148] [004/133] (957s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[63.086845] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[70.339941] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.265s)
[70.489276] [005/133] (950s left) kms_psr (pr-primary-mmap-cpu)
[70.579072] Starting subtest: pr-primary-mmap-cpu
[70.583907] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[70.647026] [006/133] (950s left) gem_readwrite (write-bad-handle)
[70.705919] Subtest write-bad-handle: SKIP (0.000s)
[70.760564] [007/133] (950s left) gem_create (create-ext-placement-all)
[70.923359] Starting subtest: create-ext-placement-all
[70.925232] Subtest create-ext-placement-all: SUCCESS (0.000s)
[71.033939] [008/133] (949s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[71.170302] Starting subtest: dp-mst-type-1-suspend-resume
[71.175350] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[71.295023] [009/133] (949s left) gem_exec_flush (basic-uc-rw-default)
[71.360478] Starting subtest: basic-uc-rw-default
[76.840361] Subtest basic-uc-rw-default: SUCCESS (5.463s)
[77.005235] [010/133] (944s left) gem_ringfill (engines-basic)
[82.907172] Starting subtest: engines-basic
[82.909663] Starting dynamic subtest: rcs0
[82.954128] Dynamic subtest rcs0: SUCCESS (0.049s)
[82.964856] Starting dynamic subtest: bcs0
[82.998525] Dynamic subtest bcs0: SUCCESS (0.043s)
[83.006202] Starting dynamic subtest: vcs0
[83.041190] Dynamic subtest vcs0: SUCCESS (0.043s)
[83.050848] Starting dynamic subtest: vcs1
[83.087835] Dynamic subtest vcs1: SUCCESS (0.045s)
[83.099102] Starting dynamic subtest: vecs0
[83.132739] Dynamic subtest vecs0: SUCCESS (0.044s)
[83.143031] Starting dynamic subtest: ccs0
[83.178835] Dynamic subtest ccs0: SUCCESS (0.045s)
[83.181228] Subtest engines-basic: SUCCESS (0.274s)
[83.254765] [FACT gem_ringfill (engines-basic)] new: kernel.kmod_is_loaded.vgem: true
[83.258341] [011/133] (937s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[83.356653] Starting subtest: 2x-absolute-wf_vblank-interruptible
[83.368399] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.011s)
[83.448871] [012/133] (937s left) syncobj_wait (invalid-reset-bad-pad)
[83.508735] Starting subtest: invalid-reset-bad-pad
[83.511069] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[83.599369] [013/133] (937s left) kms_chamelium_hpd (dp-hpd-storm)
[83.981684] Subtest dp-hpd-storm: SKIP (0.000s)
[84.766433] [014/133] (936s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[84.849891] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[84.852100] Starting dynamic subtest: pipe-A-default-mode
[87.649641] Dynamic subtest pipe-A-default-mode: SUCCESS (2.800s)
[87.652055] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.801s)
[88.484010] [015/133] (932s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[88.538714] Starting subtest: invalid-multi-wait-unsubmitted
[88.541083] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[88.634189] [016/133] (932s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[88.723086] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[88.725447] Starting dynamic subtest: pipe-A-eDP-1
[88.748861] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[88.758654] Starting dynamic subtest: pipe-B-eDP-1
[88.780303] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[88.787960] Starting dynamic subtest: pipe-C-eDP-1
[88.809504] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[88.817029] Starting dynamic subtest: pipe-D-eDP-1
[88.838595] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[88.842652] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[91.040441] [017/133] (930s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[91.133254] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[91.137850] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s)
[91.217449] [018/133] (930s left) i915_pm_freq_api (freq-suspend)
[91.266286] Starting subtest: freq-suspend
[91.268705] Starting dynamic subtest: gt0
[107.069368] Dynamic subtest gt0: SUCCESS (1.317s)
[107.080629] Starting dynamic subtest: gt1
[123.085059] Dynamic subtest gt1: SUCCESS (1.208s)
[123.096925] Subtest freq-suspend: SUCCESS (2.526s)
[124.171241] [019/133] (898s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[124.720624] Starting subtest: syncobj-timeline-invalid-flags
[124.722737] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[126.303838] [020/133] (896s left) kms_color_pipeline (plane-ctm3x4)
[126.406647] Starting subtest: plane-ctm3x4
[126.551181] Starting dynamic subtest: pipe-A-plane-0
[126.694042] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[126.704915] Starting dynamic subtest: pipe-A-plane-1
[126.815151] Dynamic subtest pipe-A-plane-1: SUCCESS (0.122s)
[126.823706] Starting dynamic subtest: pipe-A-plane-2
[126.947320] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[128.137931] Starting dynamic subtest: pipe-B-plane-0
[128.272184] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[128.282852] Starting dynamic subtest: pipe-B-plane-1
[128.404427] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[128.414259] Starting dynamic subtest: pipe-B-plane-2
[128.570087] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[129.716661] Starting dynamic subtest: pipe-C-plane-0
[129.831317] Dynamic subtest pipe-C-plane-0: SUCCESS (0.122s)
[129.842226] Starting dynamic subtest: pipe-C-plane-1
[129.956102] Dynamic subtest pipe-C-plane-1: SUCCESS (0.122s)
[129.967569] Starting dynamic subtest: pipe-C-plane-2
[130.084565] Dynamic subtest pipe-C-plane-2: SUCCESS (0.133s)
[131.255895] Starting dynamic subtest: pipe-D-plane-0
[131.367013] Dynamic subtest pipe-D-plane-0: SUCCESS (0.122s)
[131.376068] Starting dynamic subtest: pipe-D-plane-1
[131.489555] Dynamic subtest pipe-D-plane-1: SUCCESS (0.122s)
[131.499400] Starting dynamic subtest: pipe-D-plane-2
[131.621538] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[131.912830] Subtest plane-ctm3x4: SUCCESS (5.542s)
[132.706278] [021/133] (889s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[132.808668] Starting subtest: plane-upscale-20x20-with-modifiers
[132.810989] Starting dynamic subtest: pipe-A
[133.143084] Dynamic subtest pipe-A: SUCCESS (0.338s)
[133.154746] Starting dynamic subtest: pipe-B
[134.592417] Dynamic subtest pipe-B: SUCCESS (1.454s)
[134.601083] Starting dynamic subtest: pipe-C
[136.015828] Dynamic subtest pipe-C: SUCCESS (1.427s)
[136.024812] Starting dynamic subtest: pipe-D
[137.441743] Dynamic subtest pipe-D: SUCCESS (1.429s)
[137.443986] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.651s)
[138.598439] [022/133] (883s left) gem_exec_whisper (basic-fds-priority-all)
[138.669793] Starting subtest: basic-fds-priority-all
[160.471318] Subtest basic-fds-priority-all: SUCCESS (21.812s)
[160.671238] [023/133] (861s left) kms_flip (2x-dpms-vs-vblank-race)
[160.769710] Starting subtest: 2x-dpms-vs-vblank-race
[160.779987] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s)
[160.855756] [024/133] (861s left) kms_pm_lpsp (kms-lpsp)
[161.953261] Starting subtest: kms-lpsp
[161.955931] Starting dynamic subtest: pipe-A-eDP-1
[162.151530] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.204s)
[162.458321] Subtest kms-lpsp: SUCCESS (0.509s)
[163.317589] [025/133] (859s left) perf_pmu (init-sema)
[163.355335] Starting subtest: init-sema
[163.357871] Starting dynamic subtest: rcs0
[163.360278] Dynamic subtest rcs0: SUCCESS (0.002s)
[163.371501] Starting dynamic subtest: bcs0
[163.373700] Dynamic subtest bcs0: SUCCESS (0.001s)
[163.382606] Starting dynamic subtest: vcs0
[163.384868] Dynamic subtest vcs0: SUCCESS (0.000s)
[163.394618] Starting dynamic subtest: vcs1
[163.396853] Dynamic subtest vcs1: SUCCESS (0.001s)
[163.405543] Starting dynamic subtest: vecs0
[163.407717] Dynamic subtest vecs0: SUCCESS (0.001s)
[163.416809] Starting dynamic subtest: ccs0
[163.418724] Dynamic subtest ccs0: SUCCESS (0.000s)
[163.420602] Subtest init-sema: SUCCESS (0.007s)
[163.469317] [026/133] (859s left) kms_psr (psr2-primary-page-flip)
[163.558402] Starting subtest: psr2-primary-page-flip
[163.560767] Starting dynamic subtest: eDP-1
[165.308531] Dynamic subtest eDP-1: SUCCESS (1.748s)
[165.310684] Subtest psr2-primary-page-flip: SUCCESS (1.748s)
[166.198784] [027/133] (856s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[166.302885] Starting subtest: y-tiled-64bpp-rotate-180
[166.307246] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[166.398589] [028/133] (856s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[166.493889] Starting subtest: fbc-1p-pri-indfb-multidraw
[179.429849] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (12.944s)
[180.812638] [029/133] (842s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[180.917012] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[180.921597] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[181.045998] [030/133] (841s left) kms_invalid_mode (bad-hsync-start)
[181.146783] Starting subtest: bad-hsync-start
[181.149161] Starting dynamic subtest: pipe-A-eDP-1
[181.439903] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s)
[181.453911] Starting dynamic subtest: pipe-B-eDP-1
[181.455816] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[181.464990] Starting dynamic subtest: pipe-C-eDP-1
[181.467096] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[181.476008] Starting dynamic subtest: pipe-D-eDP-1
[181.478176] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[181.480524] Subtest bad-hsync-start: SUCCESS (0.298s)
[182.254766] [031/133] (840s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[182.366604] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[182.370554] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[182.486697] [032/133] (840s left) core_setmaster (master-drop-set-shared-fd)
[182.572063] Starting subtest: master-drop-set-shared-fd
[182.579635] Subtest master-drop-set-shared-fd: SUCCESS (0.011s)
[182.619899] [033/133] (840s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[182.722319] Starting subtest: yf-tiled-8bpp-rotate-90
[182.726739] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[182.825085] [034/133] (840s left) gem_pxp (regular-baseline-src-copy-readible)
[182.944297] Starting subtest: regular-baseline-src-copy-readible
[183.007153] Subtest regular-baseline-src-copy-readible: SUCCESS (0.064s)
[183.136772] [035/133] (839s left) kms_plane_scaling (intel-max-src-size)
[183.220546] Starting subtest: intel-max-src-size
[183.225941] Subtest intel-max-src-size: SKIP (0.000s)
[183.320988] [036/133] (839s left) syncobj_eventfd (invalid-illegal-eventfd)
[183.361507] Starting subtest: invalid-illegal-eventfd
[183.363257] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[183.446592] [037/133] (839s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[183.499342] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[183.569976] [038/133] (839s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[183.668665] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[183.672298] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[183.817973] [039/133] (839s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[183.870865] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[183.915596] [040/133] (839s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[184.014407] Starting subtest: async-flip-with-page-flip-events-tiled
[184.386567] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[187.160221] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.719s)
[187.173173] Starting dynamic subtest: pipe-A-eDP-1-4
[189.331670] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[189.343292] Starting dynamic subtest: pipe-A-eDP-1-4
[191.289075] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[191.301155] Starting dynamic subtest: pipe-A-eDP-1-x
[193.530353] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[193.865804] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[196.691118] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.781s)
[196.703830] Starting dynamic subtest: pipe-B-eDP-1-4
[198.876834] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[198.893141] Starting dynamic subtest: pipe-B-eDP-1-4
[200.834244] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.008s)
[200.845553] Starting dynamic subtest: pipe-B-eDP-1-x
[203.075727] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.190s)
[203.390604] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[206.216050] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.781s)
[206.226111] Starting dynamic subtest: pipe-C-eDP-1-4
[208.389749] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[208.399957] Starting dynamic subtest: pipe-C-eDP-1-4
[210.347535] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[210.356942] Starting dynamic subtest: pipe-C-eDP-1-x
[212.566270] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.167s)
[212.883171] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[215.680049] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.805s)
[215.693040] Starting dynamic subtest: pipe-D-eDP-1-4
[217.907570] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[217.917338] Starting dynamic subtest: pipe-D-eDP-1-4
[219.862963] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.006s)
[219.872575] Starting dynamic subtest: pipe-D-eDP-1-x
[222.094941] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[222.097058] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.039s)
[223.268558] [041/133] (800s left) kms_cursor_crc (cursor-offscreen-max-size)
[223.562096] Starting subtest: cursor-offscreen-max-size
[223.568434] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[223.704040] [042/133] (799s left) kms_vblank (wait-busy-hang)
[223.790607] Starting subtest: wait-busy-hang
[223.792499] Starting dynamic subtest: pipe-A-eDP-1
[249.984210] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.188s)
[249.999446] Starting dynamic subtest: pipe-D-eDP-1
[264.966229] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.977s)
[264.968740] Subtest wait-busy-hang: SUCCESS (41.170s)
[265.819739] [043/133] (757s left) kms_vblank (query-busy)
[265.925562] Starting subtest: query-busy
[265.927491] Starting dynamic subtest: pipe-A-eDP-1
[267.804059] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.879s)
[267.819165] Starting dynamic subtest: pipe-D-eDP-1
[270.379686] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.573s)
[270.382112] Subtest query-busy: SUCCESS (4.456s)
[271.193685] [044/133] (752s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[271.296873] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[272.366259] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.069s)
[272.500729] [045/133] (751s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[272.554736] Starting subtest: invalid-single-wait-all-unsubmitted
[272.557026] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[272.673053] [046/133] (750s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[272.781336] Starting subtest: 2x-flip-vs-cursor-atomic
[272.784736] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[272.942364] [047/133] (750s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[272.991761] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[272.993737] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[273.083661] [048/133] (750s left) syncobj_wait (wait-zero-handles)
[273.130405] Starting subtest: wait-zero-handles
[273.132366] Subtest wait-zero-handles: SUCCESS (0.000s)
[273.223246] [049/133] (750s left) gem_exec_params (batch-first)
[273.279503] Starting subtest: batch-first
[273.285961] Subtest batch-first: SUCCESS (0.006s)
[273.370813] [050/133] (750s left) api_intel_bb (full-batch)
[273.415558] Starting subtest: full-batch
[273.420150] Subtest full-batch: SUCCESS (0.005s)
[273.538733] [051/133] (750s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[273.628917] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[273.632324] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[273.725372] [052/133] (750s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[273.817382] Starting subtest: psr-rgb565-draw-mmap-wc
[280.658446] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.843s)
[280.773260] [053/133] (743s left) kms_psr (psr-no-drrs)
[280.865413] Starting subtest: psr-no-drrs
[280.867672] Starting dynamic subtest: eDP-1
[282.504513] Dynamic subtest eDP-1: SUCCESS (1.638s)
[282.506845] Subtest psr-no-drrs: SUCCESS (1.639s)
[283.385665] [054/133] (740s left) gem_exec_gttfill (basic)
[283.443219] Starting subtest: basic
[286.130798] Subtest basic: SUCCESS (2.687s)
[286.320046] [055/133] (737s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[286.478877] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[286.481255] Starting dynamic subtest: pipe-A-default-mode
[287.645277] Dynamic subtest pipe-A-default-mode: SKIP (1.162s)
[287.649476] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.164s)
[287.828939] [056/133] (736s left) kms_prop_blob (basic)
[287.895396] Starting subtest: basic
[287.897728] Subtest basic: SUCCESS (0.000s)
[288.012647] [057/133] (736s left) perf_pmu (semaphore-wait-idle)
[288.060483] Starting subtest: semaphore-wait-idle
[288.062838] Starting dynamic subtest: rcs0
[288.574116] Dynamic subtest rcs0: SUCCESS (0.512s)
[288.587184] Starting dynamic subtest: bcs0
[289.087715] Dynamic subtest bcs0: SUCCESS (0.511s)
[289.099190] Starting dynamic subtest: vcs0
[289.603237] Dynamic subtest vcs0: SUCCESS (0.512s)
[289.616123] Starting dynamic subtest: vcs1
[290.116143] Dynamic subtest vcs1: SUCCESS (0.510s)
[290.128652] Starting dynamic subtest: vecs0
[290.628999] Dynamic subtest vecs0: SUCCESS (0.510s)
[290.642478] Starting dynamic subtest: ccs0
[291.145846] Dynamic subtest ccs0: SUCCESS (0.514s)
[291.148901] Subtest semaphore-wait-idle: SUCCESS (3.086s)
[292.236849] [058/133] (731s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[292.330340] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[292.332601] Starting dynamic subtest: pipe-A-eDP-1
[292.355227] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[292.367540] Starting dynamic subtest: pipe-B-eDP-1
[292.388819] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[292.398071] Starting dynamic subtest: pipe-C-eDP-1
[292.419524] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[292.428986] Starting dynamic subtest: pipe-D-eDP-1
[292.451454] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[292.455919] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[294.577207] [059/133] (729s left) gem_exec_balancer (semaphore)
[294.639060] Starting subtest: semaphore
[296.204841] Subtest semaphore: SUCCESS (1.564s)
[296.496335] [060/133] (727s left) gem_exec_reloc (basic-cpu-wc-active)
[296.565328] Subtest basic-cpu-wc-active: SKIP (0.000s)
[296.647975] [061/133] (727s left) kms_cursor_crc (cursor-random-512x512)
[296.950755] Starting subtest: cursor-random-512x512
[296.955103] Subtest cursor-random-512x512: SKIP (0.002s)
[297.110612] [062/133] (727s left) gen9_exec_parse (valid-registers)
[297.169591] Subtest valid-registers: SKIP (0.000s)
[297.245642] [063/133] (727s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[297.345779] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[297.350113] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[297.456979] [064/133] (726s left) gem_exec_reloc (basic-cpu-gtt-active)
[297.515470] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[297.610107] [065/133] (726s left) kms_psr (fbc-pr-primary-render)
[297.695311] Starting subtest: fbc-pr-primary-render
[297.699156] Subtest fbc-pr-primary-render: SKIP (0.000s)
[297.770324] [066/133] (726s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[297.841177] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[297.908688] [067/133] (726s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[298.015970] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[298.019479] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[298.128605] [068/133] (726s left) kms_chamelium_audio (dp-audio-edid)
[298.521426] Subtest dp-audio-edid: SKIP (0.000s)
[299.301141] [069/133] (725s left) gem_ctx_persistence (heartbeat-stop)
[299.365787] Starting subtest: heartbeat-stop
[299.370414] Subtest heartbeat-stop: SKIP (0.000s)
[299.478926] [070/133] (725s left) gem_userptr_blits (nohangcheck)
[299.565356] Starting subtest: nohangcheck
[299.829720] Subtest nohangcheck: SUCCESS (0.264s)
[299.953900] [071/133] (724s left) kms_flip (plain-flip-ts-check)
[300.047686] Starting subtest: plain-flip-ts-check
[300.049549] Starting dynamic subtest: A-eDP1
[308.918346] Dynamic subtest A-eDP1: SUCCESS (8.874s)
[308.940633] Starting dynamic subtest: B-eDP1
[317.777866] Dynamic subtest B-eDP1: SUCCESS (8.827s)
[317.789771] Starting dynamic subtest: C-eDP1
[326.612802] Dynamic subtest C-eDP1: SUCCESS (8.822s)
[326.625519] Starting dynamic subtest: D-eDP1
[335.444234] Dynamic subtest D-eDP1: SUCCESS (8.832s)
[335.446567] Subtest plain-flip-ts-check: SUCCESS (35.369s)
[336.583311] [072/133] (688s left) kms_pipe_crc_basic (suspend-read-crc)
[336.679903] Starting subtest: suspend-read-crc
[336.682177] Starting dynamic subtest: pipe-A-eDP-1
[354.962305] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.556s)
[354.972811] Starting dynamic subtest: pipe-B-eDP-1
[373.000360] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.188s)
[373.011422] Starting dynamic subtest: pipe-C-eDP-1
[390.969600] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.140s)
[390.980527] Starting dynamic subtest: pipe-D-eDP-1
[408.950481] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.043s)
[408.953469] Subtest suspend-read-crc: SUCCESS (11.934s)
[409.770626] [073/133] (614s left) gem_softpin (evict-active-interruptible)
[409.836380] Starting subtest: evict-active-interruptible
[409.839077] Subtest evict-active-interruptible: SUCCESS (0.006s)
[409.932614] [074/133] (614s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[410.033580] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[410.039283] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[410.128568] [075/133] (614s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[410.223521] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[410.228921] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[410.328322] [076/133] (614s left) gem_exec_balancer (full)
[410.398574] Starting subtest: full
[415.450564] Subtest full: SUCCESS (5.085s)
[415.734762] [077/133] (609s left) sw_sync (sync_busy_fork_unixsocket)
[415.786517] Starting subtest: sync_busy_fork_unixsocket
[415.796181] Subtest sync_busy_fork_unixsocket: SUCCESS (0.010s)
[415.864202] [078/133] (609s left) kms_cursor_crc (cursor-tearing-position-change)
[415.977636] Starting subtest: cursor-tearing-position-change
[415.980193] Starting dynamic subtest: pipe-A-eDP-1
[416.538529] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.564s)
[416.549526] Starting dynamic subtest: pipe-D-eDP-1
[417.753478] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.218s)
[417.756420] Subtest cursor-tearing-position-change: SUCCESS (1.785s)
[418.586011] [079/133] (606s left) gem_mmap_wc (bad-size)
[418.636210] Subtest bad-size: SKIP (0.000s)
[418.703259] [080/133] (606s left) i915_pm_rpm (gem-idle)
[420.738401] Starting subtest: gem-idle
[426.966285] Subtest gem-idle: SUCCESS (6.227s)
[427.295624] [081/133] (597s left) kms_dp_link_training (non-uhbr-sst)
[428.576382] Starting subtest: non-uhbr-sst
[428.587418] Subtest non-uhbr-sst: SKIP (0.000s)
[428.650069] [082/133] (596s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[428.750535] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[428.762298] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.010s)
[428.841533] [083/133] (596s left) kms_pwrite_crc
[430.418069] [084/133] (594s left) kms_frontbuffer_tracking (psr-suspend)
[430.512181] Starting subtest: psr-suspend
[468.623913] Subtest psr-suspend: SUCCESS (7.960s)
[468.737867] [085/133] (556s left) gem_eio (context-create)
[468.956247] Starting subtest: context-create
[469.263954] Subtest context-create: SUCCESS (0.311s)
[469.378863] [086/133] (555s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[469.475713] Starting subtest: x-tiled-64bpp-rotate-0
[471.100234] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.638s)
[471.281467] [087/133] (554s left) kms_psr2_su (page_flip-p010)
[471.346082] Subtest page_flip-P010: SKIP (0.000s)
[471.406236] [088/133] (553s left) syncobj_wait (single-wait-all-signaled)
[471.458648] Starting subtest: single-wait-all-signaled
[471.460655] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[471.552488] [089/133] (553s left) kms_big_fb (linear-16bpp-rotate-180)
[471.641727] Starting subtest: linear-16bpp-rotate-180
[473.012783] Subtest linear-16bpp-rotate-180: SUCCESS (1.379s)
[473.136070] [090/133] (552s left) gem_exec_create (forked)
[473.204092] Starting subtest: forked
[473.206065] Starting dynamic subtest: smem
[493.397998] Dynamic subtest smem: SUCCESS (20.242s)
[493.400272] Subtest forked: SUCCESS (20.243s)
[493.583333] [091/133] (531s left) kms_chamelium_edid (dp-edid-resolution-list)
[493.985850] Subtest dp-edid-resolution-list: SKIP (0.000s)
[494.839327] [092/133] (530s left) gem_exec_schedule (pi-userfault)
[495.022620] Starting subtest: pi-userfault
[495.024977] Starting dynamic subtest: rcs0
[495.033152] Dynamic subtest rcs0: SUCCESS (0.013s)
[495.043773] Starting dynamic subtest: bcs0
[495.045747] Dynamic subtest bcs0: SUCCESS (0.009s)
[495.055808] Starting dynamic subtest: vcs0
[495.058032] Dynamic subtest vcs0: SUCCESS (0.008s)
[495.067842] Starting dynamic subtest: vcs1
[495.070256] Dynamic subtest vcs1: SUCCESS (0.007s)
[495.080532] Starting dynamic subtest: vecs0
[495.082471] Dynamic subtest vecs0: SUCCESS (0.009s)
[495.092100] Starting dynamic subtest: ccs0
[495.094053] Dynamic subtest ccs0: SUCCESS (0.009s)
[495.095954] Subtest pi-userfault: SUCCESS (0.058s)
[495.275521] [093/133] (530s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[495.378463] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[495.383032] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[495.483623] [094/133] (530s left) api_intel_allocator (gem-pool)
[495.546149] Starting subtest: gem-pool
[495.552072] Subtest gem-pool: SUCCESS (0.008s)
[495.682544] [095/133] (529s left) gem_busy (semaphore)
[495.874769] Subtest semaphore: SKIP (0.000s)
[496.106652] [096/133] (529s left) syncobj_timeline (reset-unsignaled)
[496.161762] Starting subtest: reset-unsignaled
[496.164036] Subtest reset-unsignaled: SUCCESS (0.000s)
[496.257776] [097/133] (529s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[496.359573] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[503.160257] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.803s)
[503.294740] [098/133] (522s left) kms_async_flips (test-cursor)
[503.386774] Starting subtest: test-cursor
[503.762072] Starting dynamic subtest: pipe-A-eDP-1
[504.585522] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.824s)
[504.973262] Starting dynamic subtest: pipe-B-eDP-1
[505.717470] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.753s)
[506.110075] Starting dynamic subtest: pipe-C-eDP-1
[506.849945] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.750s)
[507.216923] Starting dynamic subtest: pipe-D-eDP-1
[507.975036] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.766s)
[507.977197] Subtest test-cursor: SUCCESS (4.589s)
[509.150776] [099/133] (516s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[509.263317] Starting subtest: 4-tiled-32bpp-rotate-180
[510.730963] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.467s)
[510.875335] [100/133] (514s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[510.976829] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[510.980194] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[511.073109] [101/133] (514s left) gem_softpin (evict-active)
[511.142211] Starting subtest: evict-active
[511.147326] Subtest evict-active: SUCCESS (0.005s)
[511.277883] [102/133] (514s left) i915_query (query-regions-garbage-items)
[511.332188] Starting subtest: query-regions-garbage-items
[511.334177] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[511.420991] [103/133] (514s left) kms_psr (fbc-psr-no-drrs)
[511.512320] Starting subtest: fbc-psr-no-drrs
[511.514171] Starting dynamic subtest: eDP-1
[511.517543] Dynamic subtest eDP-1: SKIP (0.000s)
[511.520941] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[511.585238] [104/133] (514s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[511.680103] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[511.683443] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[511.803662] [105/133] (514s left) gem_render_copy_redux (interruptible)
[511.862612] Starting subtest: interruptible
[512.164302] Subtest interruptible: SUCCESS (0.304s)
[512.303535] [106/133] (513s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[512.398690] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[512.401939] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[512.514138] [107/133] (513s left) gem_mmap_gtt (basic-small-copy-odd)
[512.581739] Subtest basic-small-copy-odd: SKIP (0.000s)
[512.636507] [108/133] (513s left) gem_exec_gttfill (multigpu-basic)
[512.810122] Starting subtest: multigpu-basic
[524.965795] Subtest multigpu-basic: SUCCESS (12.157s)
[525.015998] [109/133] (501s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[525.167501] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[525.171490] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[525.272437] [110/133] (501s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[525.364661] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[525.369064] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[525.447836] [111/133] (500s left) gem_mmap_offset (blt-coherency)
[525.507661] Starting subtest: blt-coherency
[525.518070] Subtest blt-coherency: SUCCESS (0.012s)
[525.649990] [112/133] (500s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[525.743029] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[532.796764] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.057s)
[532.941369] [113/133] (493s left) kms_feature_discovery (psr1)
[533.044059] Starting subtest: psr1
[533.046424] Subtest psr1: SUCCESS (0.000s)
[533.121337] [114/133] (493s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[533.256392] Starting subtest: flip-vs-cursor-legacy
[540.505502] Subtest flip-vs-cursor-legacy: SUCCESS (7.250s)
[541.316420] [115/133] (485s left) gem_sync (basic-store-all)
[541.386005] Starting subtest: basic-store-all
[545.440433] Subtest basic-store-all: SUCCESS (4.065s)
[545.627458] [116/133] (480s left) gem_exec_schedule (preempt-self)
[545.710685] Starting subtest: preempt-self
[545.713126] Starting dynamic subtest: rcs0
[545.740349] Dynamic subtest rcs0: SUCCESS (0.037s)
[545.753962] Starting dynamic subtest: bcs0
[545.779304] Dynamic subtest bcs0: SUCCESS (0.038s)
[545.791776] Starting dynamic subtest: vcs0
[545.819986] Dynamic subtest vcs0: SUCCESS (0.040s)
[545.830252] Starting dynamic subtest: vcs1
[545.857914] Dynamic subtest vcs1: SUCCESS (0.037s)
[545.868237] Starting dynamic subtest: vecs0
[545.892033] Dynamic subtest vecs0: SUCCESS (0.032s)
[545.902384] Starting dynamic subtest: ccs0
[545.925626] Dynamic subtest ccs0: SUCCESS (0.033s)
[545.928069] Subtest preempt-self: SUCCESS (0.224s)
[547.862225] [117/133] (478s left) kms_vrr (seamless-rr-switch-virtual)
[547.974800] Starting subtest: seamless-rr-switch-virtual
[547.981070] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[548.047303] [118/133] (478s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[548.143971] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[548.148448] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[549.256916] [119/133] (477s left) kms_lease (lease-uevent)
[549.351029] Starting subtest: lease-uevent
[550.369713] Subtest lease-uevent: SUCCESS (1.021s)
[550.447235] [120/133] (476s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[550.546497] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[550.551134] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[550.653806] [121/133] (476s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[550.761575] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[554.748900] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (3.992s)
[555.950661] [122/133] (470s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[556.050770] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[556.053069] Starting dynamic subtest: pipe-A-eDP-1
[556.168211] Dynamic subtest pipe-A-eDP-1: SKIP (0.122s)
[556.179563] Starting dynamic subtest: pipe-B-eDP-1
[557.318177] Dynamic subtest pipe-B-eDP-1: SKIP (1.146s)
[557.323051] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.271s)
[558.503179] [123/133] (468s left) syncobj_wait (invalid-reset-one-illegal-handle)
[558.558854] Starting subtest: invalid-reset-one-illegal-handle
[558.561188] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[558.657903] [124/133] (468s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[558.761963] Starting subtest: pixel-format-linear-modifier-source-clamping
[558.787315] Starting dynamic subtest: pipe-A-plane-0
[562.418670] Dynamic subtest pipe-A-plane-0: SUCCESS (3.633s)
[562.428769] Starting dynamic subtest: pipe-A-plane-3
[564.174547] Dynamic subtest pipe-A-plane-3: SUCCESS (1.755s)
[565.288615] Starting dynamic subtest: pipe-B-plane-0
[568.814421] Dynamic subtest pipe-B-plane-0: SUCCESS (3.533s)
[568.827002] Starting dynamic subtest: pipe-B-plane-3
[570.493010] Dynamic subtest pipe-B-plane-3: SUCCESS (1.676s)
[570.799354] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (12.037s)
[571.671685] [125/133] (455s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[571.778891] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[579.366819] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.590s)
[579.517299] [126/133] (447s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[579.638162] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[579.642570] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[579.753612] [127/133] (447s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[579.810744] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[579.913578] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.104s)
[579.992335] [128/133] (447s left) gem_workarounds (basic-read-context)
[580.069236] Starting subtest: basic-read-context
[580.077608] Subtest basic-read-context: SUCCESS (0.010s)
[580.181630] [129/133] (446s left) gem_madvise (dontneed-before-pwrite)
[580.223425] Starting subtest: dontneed-before-pwrite
[580.254028] Subtest dontneed-before-pwrite: SKIP (0.030s)
[580.322729] [130/133] (446s left) gem_exec_reloc (basic-write-gtt-noreloc)
[580.401852] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[580.487676] [131/133] (446s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[580.599198] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[580.601010] Starting dynamic subtest: pipe-A-eDP-1
[580.619391] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[580.630864] Starting dynamic subtest: pipe-B-eDP-1
[580.648235] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[580.658303] Starting dynamic subtest: pipe-C-eDP-1
[580.675700] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[580.685538] Starting dynamic subtest: pipe-D-eDP-1
[580.704891] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[580.708415] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.005s)
[582.851429] [132/133] (444s left) gem_ctx_isolation (preservation-s3)
[582.921529] Starting subtest: preservation-S3
[582.923863] Starting dynamic subtest: rcs0
[599.121745] Dynamic subtest rcs0: SUCCESS (1.339s)
[599.133143] Starting dynamic subtest: bcs0
[615.119293] Dynamic subtest bcs0: SUCCESS (1.317s)
[615.130483] Starting dynamic subtest: vcs0
[631.171103] Dynamic subtest vcs0: SUCCESS (2.351s)
[631.182334] Starting dynamic subtest: vcs1
[649.107297] Dynamic subtest vcs1: SUCCESS (4.977s)
[649.119531] Starting dynamic subtest: vecs0
[667.126059] Dynamic subtest vecs0: SUCCESS (5.046s)
[667.137995] Starting dynamic subtest: ccs0
[685.122213] Dynamic subtest ccs0: SUCCESS (3.210s)
[685.125021] Subtest preservation-S3: SUCCESS (18.247s)
[685.366915] [133/133] (341s left) gen7_exec_parse (cmd-crossing-page)
[685.447882] Subtest cmd-crossing-page: SKIP (0.000s)
[685.519034] 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.