[57.120717] Initializing watchdogs
[57.120787]   /dev/watchdog0
[57.135346] [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.140076] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.142332] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.145627] [001/133] (960s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[57.259673] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[57.263931] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[57.339586] [002/133] (960s left) gem_render_copy (linear-to-vebox-y-tiled)
[57.394261] Starting subtest: linear-to-vebox-y-tiled
[57.398905] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[57.572552] [003/133] (960s left) gem_exec_params (dr4-dirt)
[57.635024] Starting subtest: DR4-dirt
[57.637539] Subtest DR4-dirt: SUCCESS (0.000s)
[57.725989] [004/133] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[57.822923] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[57.827300] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[57.920804] [005/133] (959s left) api_intel_bb (intel-bb-blit-none)
[57.976398] Starting subtest: intel-bb-blit-none
[61.821925] Subtest intel-bb-blit-none: SUCCESS (3.846s)
[61.942505] [006/133] (955s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[62.046238] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[62.058571] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s)
[62.130675] [007/133] (955s left) gem_exec_params (no-blt)
[62.201150] Starting subtest: no-blt
[62.205772] Subtest no-blt: SUCCESS (0.002s)
[62.314040] [008/133] (955s left) kms_cursor_crc (cursor-onscreen-32x32)
[62.464660] Starting subtest: cursor-onscreen-32x32
[62.517735] Subtest cursor-onscreen-32x32: SKIP (0.047s)
[62.792687] [009/133] (955s left) kms_chamelium_frames (dp-crc-fast)
[63.176719] Subtest dp-crc-fast: SKIP (0.000s)
[64.015048] [010/133] (953s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[64.108048] Starting subtest: fbcpsr-rgb101010-draw-render
[70.915091] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.811s)
[71.026142] [011/133] (947s left) kms_async_flips (test-time-stamp-atomic)
[71.129576] Starting subtest: test-time-stamp-atomic
[71.502801] Starting dynamic subtest: pipe-A-eDP-1
[72.267145] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.763s)
[72.648832] Starting dynamic subtest: pipe-B-eDP-1
[73.396787] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.752s)
[73.770538] Starting dynamic subtest: pipe-C-eDP-1
[74.533775] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.767s)
[74.899059] Starting dynamic subtest: pipe-D-eDP-1
[75.662244] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.768s)
[75.664659] Subtest test-time-stamp-atomic: SUCCESS (4.533s)
[76.817128] [012/133] (941s left) kms_flip (blocking-wf_vblank)
[76.908606] Starting subtest: blocking-wf_vblank
[76.911177] Starting dynamic subtest: A-eDP1
[85.877510] Dynamic subtest A-eDP1: SUCCESS (8.968s)
[85.887819] Starting dynamic subtest: B-eDP1
[94.844229] Dynamic subtest B-eDP1: SUCCESS (8.935s)
[94.855480] Starting dynamic subtest: C-eDP1
[103.772170] Dynamic subtest C-eDP1: SUCCESS (8.914s)
[103.781632] Starting dynamic subtest: D-eDP1
[112.709946] Dynamic subtest D-eDP1: SUCCESS (8.933s)
[112.712320] Subtest blocking-wf_vblank: SUCCESS (35.760s)
[113.891141] [013/133] (904s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[114.005742] Starting subtest: cursorB-vs-flipB-legacy
[114.010173] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[114.149592] [014/133] (904s left) api_intel_allocator (fork-simple-stress)
[114.206102] Starting subtest: fork-simple-stress
[119.656026] Subtest fork-simple-stress: SUCCESS (5.398s)
[119.728185] [015/133] (898s left) syncobj_timeline (wait-for-submit-complex)
[119.790730] Starting subtest: wait-for-submit-complex
[119.852408] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[119.941247] [016/133] (898s left) perf_pmu (semaphore-wait)
[119.987699] Starting subtest: semaphore-wait
[119.990083] Starting dynamic subtest: rcs0
[120.503876] Dynamic subtest rcs0: SUCCESS (0.515s)
[120.514696] Starting dynamic subtest: bcs0
[121.018237] Dynamic subtest bcs0: SUCCESS (0.513s)
[121.027733] Starting dynamic subtest: vcs0
[121.530284] Dynamic subtest vcs0: SUCCESS (0.511s)
[121.541233] Starting dynamic subtest: vcs1
[122.044916] Dynamic subtest vcs1: SUCCESS (0.513s)
[122.057274] Starting dynamic subtest: vecs0
[122.557377] Dynamic subtest vecs0: SUCCESS (0.512s)
[122.568839] Starting dynamic subtest: ccs0
[123.071060] Dynamic subtest ccs0: SUCCESS (0.513s)
[123.074074] Subtest semaphore-wait: SUCCESS (3.083s)
[123.189707] [017/133] (895s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[123.256035] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[123.258522] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[123.386403] [018/133] (894s left) kms_pipe_crc_basic (bad-source)
[123.498720] Starting subtest: bad-source
[123.500782] Subtest bad-source: SUCCESS (0.000s)
[123.570451] [019/133] (894s left) i915_query (query-topology-garbage-items)
[123.632042] Starting subtest: query-topology-garbage-items
[123.634426] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[123.745682] [020/133] (894s left) perf (missing-sample-flags)
[123.876302] Starting subtest: missing-sample-flags
[123.878401] Subtest missing-sample-flags: SUCCESS (0.000s)
[123.922475] [021/133] (894s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[124.022772] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[124.027416] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[124.114866] [022/133] (894s left) kms_pm_rpm (cursor-dpms)
[126.057502] Starting subtest: cursor-dpms
[126.062469] Subtest cursor-dpms: SKIP (0.000s)
[126.447170] [023/133] (892s left) kms_plane_scaling (invalid-parameters)
[126.544694] Starting subtest: invalid-parameters
[126.546868] Starting dynamic subtest: less-than-1-height-src
[126.557636] Dynamic subtest less-than-1-height-src: SUCCESS (0.013s)
[126.566063] Starting dynamic subtest: less-than-1-width-src
[126.571262] Dynamic subtest less-than-1-width-src: SUCCESS (0.013s)
[126.573559] Subtest invalid-parameters: SUCCESS (0.027s)
[126.662951] [024/133] (891s left) i915_drm_fdinfo (virtual-busy-hang-all)
[126.709492] Starting subtest: virtual-busy-hang-all
[126.713693] Subtest virtual-busy-hang-all: SKIP (0.000s)
[126.769699] [025/133] (891s left) gem_mmap_offset (isolation)
[126.818886] Starting subtest: isolation
[126.835514] Subtest isolation: SUCCESS (0.006s)
[126.917442] [026/133] (891s left) gem_exec_schedule (submit-late-slice)
[126.991875] Starting subtest: submit-late-slice
[126.993906] Starting dynamic subtest: rcs0
[127.017380] Dynamic subtest rcs0: SUCCESS (0.035s)
[127.029165] Starting dynamic subtest: bcs0
[127.055516] Dynamic subtest bcs0: SUCCESS (0.037s)
[127.065291] Starting dynamic subtest: vcs0
[127.086578] Dynamic subtest vcs0: SUCCESS (0.031s)
[127.096649] Starting dynamic subtest: vcs1
[127.118245] Dynamic subtest vcs1: SUCCESS (0.031s)
[127.126512] Starting dynamic subtest: vecs0
[127.146632] Dynamic subtest vecs0: SUCCESS (0.028s)
[127.155533] Starting dynamic subtest: ccs0
[127.177019] Dynamic subtest ccs0: SUCCESS (0.030s)
[127.179274] Subtest submit-late-slice: SUCCESS (0.195s)
[129.002848] [027/133] (889s left) kms_draw_crc (draw-method-mmap-wc)
[129.090131] Starting subtest: draw-method-mmap-wc
[129.092376] Starting dynamic subtest: xrgb8888-untiled
[129.320736] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s)
[129.329696] Starting dynamic subtest: rgb565-untiled
[129.544376] Dynamic subtest rgb565-untiled: SUCCESS (0.222s)
[129.554039] Starting dynamic subtest: xrgb2101010-untiled
[129.765841] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[129.775319] Starting dynamic subtest: xbgr16161616f-untiled
[129.987536] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[129.995018] Starting dynamic subtest: xrgb8888-xtiled
[130.131715] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.144s)
[130.139809] Starting dynamic subtest: rgb565-xtiled
[130.266481] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[130.275506] Starting dynamic subtest: xrgb2101010-xtiled
[130.398062] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.132s)
[130.405614] Starting dynamic subtest: xbgr16161616f-xtiled
[130.520702] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s)
[130.528512] Starting dynamic subtest: xrgb8888-4tiled
[130.676071] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s)
[130.683568] Starting dynamic subtest: rgb565-4tiled
[130.820513] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[130.831221] Starting dynamic subtest: xrgb2101010-4tiled
[130.986711] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.166s)
[130.994527] Starting dynamic subtest: xbgr16161616f-4tiled
[131.165496] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.177s)
[131.167617] Subtest draw-method-mmap-wc: SUCCESS (2.078s)
[131.253735] [028/133] (887s left) kms_color (legacy-gamma)
[131.343096] Starting subtest: legacy-gamma
[131.344679] Starting dynamic subtest: pipe-A-eDP-1
[132.064515] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.720s)
[132.075514] Starting dynamic subtest: pipe-B-eDP-1
[133.445159] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.380s)
[133.454213] Starting dynamic subtest: pipe-C-eDP-1
[134.820702] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.376s)
[134.829633] Starting dynamic subtest: pipe-D-eDP-1
[136.173480] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.352s)
[136.175410] Subtest legacy-gamma: SUCCESS (4.830s)
[136.975495] [029/133] (881s left) gem_ctx_exec (basic-invalid-context)
[137.043395] Starting subtest: basic-invalid-context
[137.048237] Subtest basic-invalid-context: SUCCESS (0.005s)
[137.153073] [030/133] (881s left) gem_softpin (evict-single-offset)
[137.207066] Starting subtest: evict-single-offset
[164.888066] Subtest evict-single-offset: SUCCESS (27.677s)
[164.980962] [031/133] (853s left) gem_exec_reloc (basic-concurrent16)
[165.078056] Subtest basic-concurrent16: SKIP (0.000s)
[165.140641] [032/133] (853s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[165.247377] Starting subtest: psr-1p-primscrn-cur-indfb-move
[172.652857] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.410s)
[172.773365] [033/133] (846s left) sw_sync (sync_random_merge)
[172.824729] Starting subtest: sync_random_merge
[172.871645] Subtest sync_random_merge: SUCCESS (0.047s)
[172.953360] [034/133] (846s left) i915_drm_fdinfo (busy-idle-check-all)
[172.997576] Starting subtest: busy-idle-check-all
[172.999406] Starting dynamic subtest: rcs0
[173.003794] Dynamic subtest rcs0: SKIP (0.004s)
[173.012258] Starting dynamic subtest: bcs0
[173.016576] Dynamic subtest bcs0: SKIP (0.000s)
[173.024916] Starting dynamic subtest: vcs0
[173.029193] Dynamic subtest vcs0: SKIP (0.000s)
[173.039186] Starting dynamic subtest: vcs1
[173.043174] Dynamic subtest vcs1: SKIP (0.000s)
[173.051129] Starting dynamic subtest: vecs0
[173.055694] Dynamic subtest vecs0: SKIP (0.000s)
[173.063685] Starting dynamic subtest: ccs0
[173.067820] Dynamic subtest ccs0: SKIP (0.000s)
[173.072165] Subtest busy-idle-check-all: SKIP (0.008s)
[173.109521] [035/133] (845s left) gem_exec_schedule (preempt-queue)
[173.194847] Subtest preempt-queue: SKIP (0.000s)
[173.480517] [036/133] (845s left) gem_exec_suspend (basic-s0)
[173.542726] Starting subtest: basic-S0
[173.545085] Starting dynamic subtest: smem
[193.857021] Dynamic subtest smem: SUCCESS (6.381s)
[193.859779] Subtest basic-S0: SUCCESS (6.382s)
[204.060304] [037/133] (825s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[204.180604] Starting subtest: fbc-psr-sprite-mmap-cpu
[204.182729] Starting dynamic subtest: eDP-1
[204.186568] Dynamic subtest eDP-1: SKIP (0.000s)
[204.190507] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[204.251382] [038/133] (824s left) gem_eio (in-flight-internal-10ms)
[204.499476] Starting subtest: in-flight-internal-10ms
[205.904867] Subtest in-flight-internal-10ms: SUCCESS (1.402s)
[206.042825] [039/133] (823s left) gem_eio (wait-wedge-immediate)
[206.281859] Starting subtest: wait-wedge-immediate
[207.955292] Subtest wait-wedge-immediate: SUCCESS (1.669s)
[208.084937] [040/133] (821s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[208.178010] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[209.159341] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.978s)
[209.303425] [041/133] (820s left) kms_properties (invalid-properties-atomic)
[209.398099] Starting subtest: invalid-properties-atomic
[209.721543] Subtest invalid-properties-atomic: SUCCESS (0.315s)
[209.786761] [042/133] (819s left) kms_cursor_legacy (forked-bo)
[209.926242] Starting subtest: forked-bo
[209.928531] Starting dynamic subtest: pipe-A
[215.492008] Dynamic subtest pipe-A: SUCCESS (5.503s)
[215.505147] Starting dynamic subtest: pipe-B
[220.972367] Dynamic subtest pipe-B: SUCCESS (5.477s)
[220.982800] Starting dynamic subtest: pipe-C
[226.443444] Dynamic subtest pipe-C: SUCCESS (5.467s)
[226.454200] Starting dynamic subtest: pipe-D
[231.912226] Dynamic subtest pipe-D: SUCCESS (5.465s)
[231.926141] Starting dynamic subtest: all-pipes
[237.410513] Dynamic subtest all-pipes: SUCCESS (5.496s)
[237.412969] Subtest forked-bo: SUCCESS (27.417s)
[237.506292] [043/133] (791s left) gem_exec_params (batch-first)
[237.570089] Starting subtest: batch-first
[237.576175] Subtest batch-first: SUCCESS (0.006s)
[237.682749] [044/133] (791s left) perf (polling)
[237.800975] Starting subtest: polling
[237.803321] Starting dynamic subtest: 0-rcs0
[247.829673] Dynamic subtest 0-rcs0: SUCCESS (10.024s)
[247.839943] Starting dynamic subtest: 1-vcs0
[257.854801] Dynamic subtest 1-vcs0: SUCCESS (10.018s)
[257.857462] Subtest polling: SUCCESS (20.044s)
[257.902950] [045/133] (771s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[258.006685] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[265.469277] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.464s)
[265.583413] [046/133] (763s left) gem_userptr_blits (vma-merge)
[265.652755] Starting subtest: vma-merge
[265.692675] Subtest vma-merge: SUCCESS (0.040s)
[265.803992] [047/133] (763s left) i915_query (query-topology-coherent-slice-mask)
[265.861787] Starting subtest: query-topology-coherent-slice-mask
[265.866286] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[265.976055] [048/133] (763s left) kms_chamelium_hpd (hdmi-hpd)
[266.363647] Subtest hdmi-hpd: SKIP (0.000s)
[267.141386] [049/133] (762s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[267.238941] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[272.691360] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.455s)
[273.866964] [050/133] (755s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[273.955287] Starting subtest: y-tiled-32bpp-rotate-0
[273.959569] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[274.049147] [051/133] (755s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[274.146317] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[274.150348] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[274.240294] [052/133] (755s left) kms_plane_alpha_blend (constant-alpha-max)
[274.341055] Starting subtest: constant-alpha-max
[274.622300] Starting dynamic subtest: pipe-A-eDP-1
[275.731899] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.108s)
[275.742171] Starting dynamic subtest: pipe-D-eDP-1
[277.443799] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.710s)
[277.446147] Subtest constant-alpha-max: SUCCESS (3.103s)
[278.327479] [053/133] (751s left) gem_basic (multigpu-create-close)
[278.386535] Starting subtest: multigpu-create-close
[278.391030] Subtest multigpu-create-close: SKIP (0.000s)
[278.493324] [054/133] (751s left) gem_mmap_gtt (basic-read-write)
[278.545395] Subtest basic-read-write: SKIP (0.000s)
[278.608606] [055/133] (751s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[278.704292] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[278.708477] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[278.787627] [056/133] (751s left) kms_invalid_mode (overflow-vrefresh)
[278.874965] Starting subtest: overflow-vrefresh
[278.877191] Starting dynamic subtest: pipe-A-eDP-1
[279.171952] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.299s)
[279.182643] Starting dynamic subtest: pipe-B-eDP-1
[279.184726] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[279.194157] Starting dynamic subtest: pipe-C-eDP-1
[279.195990] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[279.204632] Starting dynamic subtest: pipe-D-eDP-1
[279.206881] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[279.209051] Subtest overflow-vrefresh: SUCCESS (0.304s)
[279.971752] [057/133] (749s left) intel_hwmon (hwmon-write)
[280.032825] Subtest hwmon-write: SKIP (0.000s)
[280.095693] [058/133] (749s left) gem_exec_suspend (basic-s3-devices)
[280.154881] Starting subtest: basic-S3-devices
[280.157255] Starting dynamic subtest: smem
[291.840967] Dynamic subtest smem: SUCCESS (11.681s)
[291.843635] Subtest basic-S3-devices: SUCCESS (11.683s)
[297.045855] [059/133] (738s left) gem_lmem_swapping (massive)
[297.105716] Subtest massive: SKIP (0.000s)
[297.155277] [060/133] (737s left) gem_exec_parallel (basic)
[297.215536] Starting subtest: basic
[297.217472] Starting dynamic subtest: rcs0
[298.721014] Dynamic subtest rcs0: SUCCESS (1.508s)
[298.733550] Starting dynamic subtest: bcs0
[300.187472] Dynamic subtest bcs0: SUCCESS (1.463s)
[300.200214] Starting dynamic subtest: vcs0
[301.853229] Dynamic subtest vcs0: SUCCESS (1.661s)
[301.863281] Starting dynamic subtest: vcs1
[303.808816] Dynamic subtest vcs1: SUCCESS (1.953s)
[303.820939] Starting dynamic subtest: vecs0
[305.793376] Dynamic subtest vecs0: SUCCESS (1.981s)
[305.806655] Starting dynamic subtest: ccs0
[307.245954] Dynamic subtest ccs0: SUCCESS (1.451s)
[307.248404] Subtest basic: SUCCESS (10.033s)
[307.430300] [061/133] (727s left) gem_exec_balancer (parallel-balancer)
[307.695641] Starting subtest: parallel-balancer
[308.601168] Subtest parallel-balancer: SUCCESS (0.908s)
[308.718910] [062/133] (726s left) gem_exec_fence (nb-await)
[308.893569] Starting subtest: nb-await
[308.895708] Starting dynamic subtest: rcs0
[308.973156] Dynamic subtest rcs0: SUCCESS (0.078s)
[308.984332] Starting dynamic subtest: bcs0
[309.036522] Dynamic subtest bcs0: SUCCESS (0.061s)
[309.047233] Starting dynamic subtest: vcs0
[309.099659] Dynamic subtest vcs0: SUCCESS (0.061s)
[309.110180] Starting dynamic subtest: vcs1
[309.163275] Dynamic subtest vcs1: SUCCESS (0.062s)
[309.175220] Starting dynamic subtest: vecs0
[309.222425] Dynamic subtest vecs0: SUCCESS (0.058s)
[309.234457] Starting dynamic subtest: ccs0
[309.282456] Dynamic subtest ccs0: SUCCESS (0.058s)
[309.285354] Subtest nb-await: SUCCESS (0.389s)
[310.929614] [FACT gem_exec_fence (nb-await)] new: kernel.kmod_is_loaded.vgem: true
[310.936463] [063/133] (724s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[311.041085] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[311.045617] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[312.161310] [064/133] (723s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[312.254806] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[313.301445] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.046s)
[313.424609] [065/133] (721s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[313.475238] Starting subtest: etime-single-wait-all-available-unsubmitted
[313.580842] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.105s)
[313.673120] [066/133] (721s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[313.768956] Starting subtest: x-tiled-32bpp-rotate-90
[313.790344] Subtest x-tiled-32bpp-rotate-90: SKIP (0.021s)
[313.910630] [067/133] (721s left) syncobj_wait (invalid-reset-zero-handles)
[313.976837] Starting subtest: invalid-reset-zero-handles
[313.978686] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[314.072231] [068/133] (721s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[314.183583] Starting subtest: cursor-vs-flip-varying-size
[345.120752] Subtest cursor-vs-flip-varying-size: SUCCESS (30.929s)
[345.996945] [069/133] (689s left) kms_pm_backlight (basic-brightness)
[346.098899] Starting subtest: basic-brightness
[346.148721] Starting dynamic subtest: eDP-1
[346.455554] Dynamic subtest eDP-1: SUCCESS (0.306s)
[346.458290] Subtest basic-brightness: SUCCESS (0.358s)
[347.323248] [070/133] (688s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[347.390114] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[347.451691] [071/133] (688s left) syncobj_timeline (single-wait-signaled)
[347.501294] Starting subtest: single-wait-signaled
[347.503612] Subtest single-wait-signaled: SUCCESS (0.000s)
[347.615627] [072/133] (688s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[347.682719] Subtest writes-after-reads: SKIP (0.000s)
[347.757776] [073/133] (687s left) gem_ctx_param (set-priority-range)
[347.818254] Starting subtest: set-priority-range
[347.832204] Subtest set-priority-range: SUCCESS (0.014s)
[347.943135] [074/133] (687s left) syncobj_wait (wait-all-for-submit-complex)
[348.003337] Starting subtest: wait-all-for-submit-complex
[348.217519] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[348.297055] [075/133] (687s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[348.398088] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[355.732769] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.336s)
[355.858524] [076/133] (679s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[355.953027] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[355.957084] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[356.032916] [077/133] (679s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[356.131085] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[356.133315] Starting dynamic subtest: pipe-A-eDP-1
[356.155551] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[356.165998] Starting dynamic subtest: pipe-B-eDP-1
[356.186459] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[356.196109] Starting dynamic subtest: pipe-C-eDP-1
[356.217521] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[356.228092] Starting dynamic subtest: pipe-D-eDP-1
[356.249353] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[356.253637] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.006s)
[358.415640] [078/133] (677s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[358.685635] Starting subtest: parallel-dmabuf-import-out-fence
[359.892968] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.210s)
[360.003230] [079/133] (675s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[360.099880] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[360.104148] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[360.169312] [080/133] (675s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[360.368166] Starting subtest: cursor-rapid-movement-64x21
[360.416671] Subtest cursor-rapid-movement-64x21: SKIP (0.045s)
[360.655885] [081/133] (675s left) gen9_exec_parse (basic-rejected)
[360.715564] Subtest basic-rejected: SKIP (0.000s)
[360.786529] [082/133] (675s left) kms_psr (fbc-pr-primary-mmap-cpu)
[360.881036] Starting subtest: fbc-pr-primary-mmap-cpu
[360.885500] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[360.954584] [083/133] (675s left) syncobj_wait (multi-wait-submitted)
[361.008656] Starting subtest: multi-wait-submitted
[361.116249] Subtest multi-wait-submitted: SUCCESS (0.107s)
[361.202700] [084/133] (674s left) kms_frontbuffer_tracking (fbc-tiling-4)
[361.311829] Starting subtest: fbc-tiling-4
[365.563326] Subtest fbc-tiling-4: SUCCESS (4.255s)
[366.747179] [085/133] (669s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[366.797042] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[366.900261] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.103s)
[366.979978] [086/133] (669s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[367.097228] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[367.101343] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[367.193447] [087/133] (669s left) kms_hdmi_inject (inject-4k)
[367.536252] Starting subtest: inject-4k
[367.850846] Subtest inject-4k: SUCCESS (0.315s)
[368.377766] [088/133] (667s left) kms_sequence (get-forked)
[368.473098] Starting subtest: get-forked
[368.475243] Starting dynamic subtest: pipe-A-eDP-1
[370.374576] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.900s)
[370.385401] Starting dynamic subtest: pipe-B-eDP-1
[372.975189] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.600s)
[372.987937] Starting dynamic subtest: pipe-C-eDP-1
[375.548688] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.571s)
[375.559485] Starting dynamic subtest: pipe-D-eDP-1
[378.050961] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.500s)
[378.053377] Subtest get-forked: SUCCESS (9.576s)
[378.869182] [089/133] (657s left) kms_hdr (invalid-metadata-sizes)
[378.956280] Starting subtest: invalid-metadata-sizes
[378.962766] Subtest invalid-metadata-sizes: SKIP (0.000s)
[379.033269] [090/133] (657s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[379.123609] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[379.128080] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[379.222751] [091/133] (657s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[379.315384] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[379.319851] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[379.422291] [092/133] (657s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[379.487565] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[379.556004] [093/133] (656s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[379.648915] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[379.651176] Starting dynamic subtest: pipe-A-eDP-1
[380.409035] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.752s)
[380.420162] Starting dynamic subtest: pipe-B-eDP-1
[382.231139] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.820s)
[382.240811] Starting dynamic subtest: pipe-C-eDP-1
[384.051444] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.818s)
[384.062632] Starting dynamic subtest: pipe-D-eDP-1
[385.852037] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.799s)
[385.854345] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.194s)
[387.055205] [094/133] (649s left) gem_exec_reloc (basic-write-read)
[387.120659] Subtest basic-write-read: SKIP (0.000s)
[387.198481] [095/133] (649s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[387.298357] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[393.804281] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.506s)
[393.953086] [096/133] (642s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[394.046337] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[394.050611] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[394.144958] [097/133] (642s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[394.248684] Starting subtest: crc-primary-basic-yf-tiled-ccs
[394.250963] Starting dynamic subtest: pipe-A-eDP-1
[394.272500] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[394.284308] Starting dynamic subtest: pipe-B-eDP-1
[394.304200] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[394.313673] Starting dynamic subtest: pipe-C-eDP-1
[394.334147] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[394.343491] Starting dynamic subtest: pipe-D-eDP-1
[394.365098] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[394.369375] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.006s)
[396.552613] [098/133] (640s left) perf_pmu (busy-no-semaphores)
[396.601812] Starting subtest: busy-no-semaphores
[396.604154] Starting dynamic subtest: rcs0
[397.152237] Dynamic subtest rcs0: SUCCESS (0.549s)
[397.170979] Starting dynamic subtest: bcs0
[397.702174] Dynamic subtest bcs0: SUCCESS (0.547s)
[397.714417] Starting dynamic subtest: vcs0
[398.255652] Dynamic subtest vcs0: SUCCESS (0.549s)
[398.267326] Starting dynamic subtest: vcs1
[399.360994] Dynamic subtest vcs1: SUCCESS (1.102s)
[399.372185] Starting dynamic subtest: vecs0
[401.348399] Dynamic subtest vecs0: SUCCESS (1.983s)
[401.369581] Starting dynamic subtest: ccs0
[403.332726] Dynamic subtest ccs0: SUCCESS (1.980s)
[403.335923] Subtest busy-no-semaphores: SUCCESS (6.730s)
[403.456580] [099/133] (633s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[403.533552] Starting subtest: yf-tiled-to-vebox-y-tiled
[403.538104] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[403.724946] [100/133] (633s left) kms_big_fb (linear-8bpp-rotate-180)
[403.830315] Starting subtest: linear-8bpp-rotate-180
[405.065901] Subtest linear-8bpp-rotate-180: SUCCESS (1.236s)
[405.179185] [101/133] (631s left) kms_lease (lease-again)
[405.274556] Starting subtest: lease-again
[405.276374] Starting dynamic subtest: pipe-A-eDP-1
[405.278225] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s)
[405.288322] Starting dynamic subtest: pipe-B-eDP-1
[405.290050] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[405.299620] Starting dynamic subtest: pipe-C-eDP-1
[405.301341] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[405.310717] Starting dynamic subtest: pipe-D-eDP-1
[405.312462] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[405.314239] Subtest lease-again: SUCCESS (0.013s)
[405.411675] [102/133] (631s left) kms_cursor_crc (cursor-sliding-32x32)
[405.570875] Starting subtest: cursor-sliding-32x32
[405.616652] Subtest cursor-sliding-32x32: SKIP (0.042s)
[405.906504] [103/133] (631s left) syncobj_timeline (invalid-transfer-non-existent-point)
[405.962148] Starting subtest: invalid-transfer-non-existent-point
[405.964003] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[406.054990] [104/133] (630s left) kms_vrr (seamless-rr-switch-virtual)
[406.156256] Starting subtest: seamless-rr-switch-virtual
[406.161703] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[406.233722] [105/133] (630s left) kms_content_protection (dp-mst-type-0-hdcp14)
[406.384200] Starting subtest: dp-mst-type-0-hdcp14
[406.388073] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[406.510369] [106/133] (630s left) gem_mmap_wc (write-prefaulted)
[406.559444] Subtest write-prefaulted: SKIP (0.000s)
[406.616599] [107/133] (630s left) gem_ppgtt (blt-vs-render-ctxn)
[406.674100] Starting subtest: blt-vs-render-ctxN
[439.485514] Subtest blt-vs-render-ctxN: SUCCESS (32.799s)
[439.619279] [108/133] (597s left) kms_psr (psr2-primary-page-flip)
[439.751893] Starting subtest: psr2-primary-page-flip
[439.754223] Starting dynamic subtest: eDP-1
[441.499681] Dynamic subtest eDP-1: SUCCESS (1.746s)
[441.501704] Subtest psr2-primary-page-flip: SUCCESS (1.747s)
[442.360341] [109/133] (594s left) kms_vblank (ts-continuation-idle-hang)
[442.455968] Starting subtest: ts-continuation-idle-hang
[442.457957] Starting dynamic subtest: pipe-A-eDP-1
[468.607472] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.143s)
[468.627004] Starting dynamic subtest: pipe-D-eDP-1
[483.648382] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.035s)
[483.650695] Subtest ts-continuation-idle-hang: SUCCESS (41.184s)
[484.465207] [110/133] (552s left) kms_properties (invalid-properties-legacy)
[484.552926] Starting subtest: invalid-properties-legacy
[484.657937] Subtest invalid-properties-legacy: SUCCESS (0.105s)
[484.729914] [111/133] (552s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[484.825651] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[484.830017] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[484.929535] [112/133] (552s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[485.047521] Starting subtest: short-flip-after-cursor-atomic-transitions
[486.043868] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.993s)
[486.866556] [113/133] (550s left) kms_flip (basic-flip-vs-wf_vblank)
[486.961121] Starting subtest: basic-flip-vs-wf_vblank
[486.962989] Starting dynamic subtest: A-eDP1
[488.875855] Dynamic subtest A-eDP1: SUCCESS (1.915s)
[488.893169] Starting dynamic subtest: B-eDP1
[490.782738] Dynamic subtest B-eDP1: SUCCESS (1.905s)
[490.797408] Starting dynamic subtest: C-eDP1
[492.673080] Dynamic subtest C-eDP1: SUCCESS (1.888s)
[492.684728] Starting dynamic subtest: D-eDP1
[494.562152] Dynamic subtest D-eDP1: SUCCESS (1.884s)
[494.566682] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.606s)
[495.768490] [114/133] (541s left) kms_prop_blob (invalid-set-prop-any)
[495.824459] Starting subtest: invalid-set-prop-any
[495.826738] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[495.938118] [115/133] (541s left) gem_unfence_active_buffers
[496.087317] [116/133] (541s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[496.183757] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[496.186044] Starting dynamic subtest: pipe-A-eDP-1
[496.336030] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.143s)
[496.348083] Starting dynamic subtest: pipe-B-eDP-1
[496.367974] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[496.378431] Starting dynamic subtest: pipe-C-eDP-1
[496.398894] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[496.408884] Starting dynamic subtest: pipe-D-eDP-1
[496.428494] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[496.430757] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.179s)
[498.564805] [117/133] (539s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[498.671205] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[498.675249] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[498.749488] [118/133] (538s left) kms_plane_multiple (tiling-x)
[498.835888] Starting subtest: tiling-x
[498.838194] Starting dynamic subtest: pipe-A-eDP-1
[502.739063] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.902s)
[502.749587] Starting dynamic subtest: pipe-B-eDP-1
[507.312162] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.571s)
[507.323454] Starting dynamic subtest: pipe-C-eDP-1
[511.892879] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.577s)
[511.903805] Starting dynamic subtest: pipe-D-eDP-1
[516.489188] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.595s)
[516.491629] Subtest tiling-x: SUCCESS (17.650s)
[517.370221] [119/133] (520s left) gem_ctx_persistence (processes)
[517.435930] Starting subtest: processes
[518.852424] Subtest processes: SUCCESS (1.419s)
[518.947507] [120/133] (518s left) kms_force_connector_basic (force-load-detect)
[519.032934] Starting subtest: force-load-detect
[519.037444] Subtest force-load-detect: SKIP (0.000s)
[519.149659] [121/133] (518s left) gem_ctx_shared (detached-shared-gtt)
[519.207917] Starting subtest: detached-shared-gtt
[521.361822] Subtest detached-shared-gtt: SUCCESS (2.152s)
[521.980966] [122/133] (515s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[522.064963] Starting subtest: fbc-psr2-cursor-mmap-cpu
[522.067263] Starting dynamic subtest: eDP-1
[522.071619] Dynamic subtest eDP-1: SKIP (0.000s)
[522.076514] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[522.143122] [123/133] (515s left) i915_pm_rpm (gem-pread)
[523.967965] Starting subtest: gem-pread
[526.031101] Subtest gem-pread: SUCCESS (2.065s)
[526.160149] [124/133] (511s left) gem_exec_reloc (basic-gtt-wc)
[526.224093] Subtest basic-gtt-wc: SKIP (0.000s)
[526.294674] [125/133] (511s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[526.390221] Starting subtest: fbc-rgb101010-draw-pwrite
[531.835875] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.438s)
[533.027702] [126/133] (505s left) device_reset (unbind-cold-reset-rebind)
[533.098760] Starting subtest: unbind-cold-reset-rebind
[533.103118] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[533.172331] [127/133] (504s left) gem_ctx_persistence (engines-mixed-process)
[533.227030] Starting subtest: engines-mixed-process
[533.229146] Starting dynamic subtest: rcs0
[534.850817] Dynamic subtest rcs0: SUCCESS (1.623s)
[534.863729] Starting dynamic subtest: bcs0
[536.835803] Dynamic subtest bcs0: SUCCESS (1.983s)
[536.847456] Starting dynamic subtest: vcs0
[538.801269] Dynamic subtest vcs0: SUCCESS (1.963s)
[538.813433] Starting dynamic subtest: vcs1
[540.819756] Dynamic subtest vcs1: SUCCESS (2.018s)
[540.832845] Starting dynamic subtest: vecs0
[542.783589] Dynamic subtest vecs0: SUCCESS (1.961s)
[542.796270] Starting dynamic subtest: ccs0
[544.835942] Dynamic subtest ccs0: SUCCESS (2.050s)
[544.838897] Subtest engines-mixed-process: SUCCESS (11.606s)
[544.923026] [128/133] (493s left) kms_flip (2x-wf_vblank-ts-check)
[545.029225] Starting subtest: 2x-wf_vblank-ts-check
[545.041458] Subtest 2x-wf_vblank-ts-check: SKIP (0.011s)
[545.124616] [129/133] (493s left) kms_pm_rpm (pm-caching)
[546.956593] Starting subtest: pm-caching
[546.961300] Subtest pm-caching: SKIP (0.000s)
[547.410229] [130/133] (490s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[547.503358] Starting subtest: flip-primary-invalidate-overlay
[559.159880] Subtest flip-primary-invalidate-overlay: SUCCESS (11.664s)
[559.315867] [131/133] (478s left) kms_psr (fbc-psr-suspend)
[559.409419] Starting subtest: fbc-psr-suspend
[559.411447] Starting dynamic subtest: eDP-1
[559.414892] Dynamic subtest eDP-1: SKIP (0.000s)
[559.418384] Subtest fbc-psr-suspend: SKIP (0.001s)
[559.484778] [132/133] (478s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[559.579892] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[559.583432] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[559.680434] [133/133] (478s left) gem_flink_race (flink_close)
[559.718572] Starting subtest: flink_close
[564.832744] Subtest flink_close: SUCCESS (5.111s)
[564.904290] Closing watchdogs
results: parsing output: 0/ for test: kms_flip_scaled_crc
results: parsing output: 1/ for test: gem_render_copy
results: parsing output: 2/ for test: gem_exec_params
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: api_intel_bb
results: parsing output: 5/ for test: kms_flip
results: parsing output: 6/ for test: gem_exec_params
results: parsing output: 7/ for test: kms_cursor_crc
results: parsing output: 8/ for test: kms_chamelium_frames
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_async_flips
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: kms_cursor_legacy
results: parsing output: 13/ for test: api_intel_allocator
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: perf_pmu
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: kms_pipe_crc_basic
results: parsing output: 18/ for test: i915_query
results: parsing output: 19/ for test: perf
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_pm_rpm
results: parsing output: 22/ for test: kms_plane_scaling
results: parsing output: 23/ for test: i915_drm_fdinfo
results: parsing output: 24/ for test: gem_mmap_offset
results: parsing output: 25/ for test: gem_exec_schedule
results: parsing output: 26/ for test: kms_draw_crc
results: parsing output: 27/ for test: kms_color
results: parsing output: 28/ for test: gem_ctx_exec
results: parsing output: 29/ for test: gem_softpin
results: parsing output: 30/ for test: gem_exec_reloc
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: sw_sync
results: parsing output: 33/ for test: i915_drm_fdinfo
results: parsing output: 34/ for test: gem_exec_schedule
results: parsing output: 35/ for test: gem_exec_suspend
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: gem_eio
results: parsing output: 38/ for test: gem_eio
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: kms_properties
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: gem_exec_params
results: parsing output: 43/ for test: perf
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_userptr_blits
results: parsing output: 46/ for test: i915_query
results: parsing output: 47/ for test: kms_chamelium_hpd
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_plane_alpha_blend
results: parsing output: 52/ for test: gem_basic
results: parsing output: 53/ for test: gem_mmap_gtt
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_invalid_mode
results: parsing output: 56/ for test: intel_hwmon
results: parsing output: 57/ for test: gem_exec_suspend
results: parsing output: 58/ for test: gem_lmem_swapping
results: parsing output: 59/ for test: gem_exec_parallel
results: parsing output: 60/ for test: gem_exec_balancer
results: parsing output: 61/ for test: gem_exec_fence
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: syncobj_wait
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: kms_pm_backlight
results: parsing output: 69/ for test: gem_mmap_gtt
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 72/ for test: gem_ctx_param
results: parsing output: 73/ for test: syncobj_wait
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: gem_exec_balancer
results: parsing output: 78/ for test: kms_psr2_sf
results: parsing output: 79/ for test: kms_cursor_crc
results: parsing output: 80/ for test: gen9_exec_parse
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: syncobj_wait
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: kms_flip_scaled_crc
results: parsing output: 86/ for test: kms_hdmi_inject
results: parsing output: 87/ for test: kms_sequence
results: parsing output: 88/ for test: kms_hdr
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_pipe_b_c_ivb
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: gem_exec_reloc
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_ccs
results: parsing output: 97/ for test: perf_pmu
results: parsing output: 98/ for test: gem_render_copy
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_lease
results: parsing output: 101/ for test: kms_cursor_crc
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: kms_vrr
results: parsing output: 104/ for test: kms_content_protection
results: parsing output: 105/ for test: gem_mmap_wc
results: parsing output: 106/ for test: gem_ppgtt
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: kms_vblank
results: parsing output: 109/ for test: kms_properties
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: kms_prop_blob
results: parsing output: 114/ for test: gem_unfence_active_buffers
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: kms_plane
results: parsing output: 117/ for test: kms_plane_multiple
results: parsing output: 118/ for test: gem_ctx_persistence
results: parsing output: 119/ for test: kms_force_connector_basic
results: parsing output: 120/ for test: gem_ctx_shared
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: i915_pm_rpm
results: parsing output: 123/ for test: gem_exec_reloc
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: device_reset
results: parsing output: 126/ for test: gem_ctx_persistence
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: kms_pm_rpm
results: parsing output: 129/ for test: kms_psr_stress_test
results: parsing output: 130/ for test: kms_psr
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_flink_race
Done.