[148.951423] Initializing watchdogs
[148.951467]   /dev/watchdog0
[148.965128] [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]
[148.969537] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[148.971792] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[148.975204] [001/133] (960s left) i915_pm_rps (basic-api)
[149.053149] Starting subtest: basic-api
[149.057433] Subtest basic-api: SKIP (0.001s)
[149.161208] [002/133] (960s left) gem_softpin (safe-alignment)
[149.217584] Starting subtest: safe-alignment
[149.253960] Subtest safe-alignment: SUCCESS (0.037s)
[150.994600] [003/133] (958s left) gem_exec_whisper (basic-fds-forked)
[151.053841] Starting subtest: basic-fds-forked
[175.375993] Subtest basic-fds-forked: SUCCESS (24.318s)
[175.573077] [004/133] (934s left) syncobj_wait (single-wait-signaled)
[175.623894] Starting subtest: single-wait-signaled
[175.626476] Subtest single-wait-signaled: SUCCESS (0.000s)
[175.759173] [005/133] (933s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[175.855667] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[175.857835] Starting dynamic subtest: pipe-A
[176.997513] Dynamic subtest pipe-A: SUCCESS (1.143s)
[177.006866] Starting dynamic subtest: pipe-B
[179.289144] Dynamic subtest pipe-B: SUCCESS (2.291s)
[179.296952] Starting dynamic subtest: pipe-C
[180.469300] Dynamic subtest pipe-C: SUCCESS (1.179s)
[180.479534] Starting dynamic subtest: pipe-D
[181.690730] Dynamic subtest pipe-D: SUCCESS (1.221s)
[181.693167] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.836s)
[182.899409] [006/133] (926s left) gen9_exec_parse (cmd-crossing-page)
[182.958497] Subtest cmd-crossing-page: SKIP (0.000s)
[183.032933] [007/133] (926s left) gem_flink_race (flink_name)
[183.064778] Starting subtest: flink_name
[188.464468] Subtest flink_name: SUCCESS (5.397s)
[188.597814] [008/133] (921s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[188.706864] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[195.642551] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.939s)
[195.821234] [009/133] (913s left) api_intel_bb (render)
[195.885935] Starting subtest: render
[195.888463] Starting dynamic subtest: render-none-512
[195.991414] Dynamic subtest render-none-512: SUCCESS (0.105s)
[196.000379] Starting dynamic subtest: render-none-1024
[196.362743] Dynamic subtest render-none-1024: SUCCESS (0.370s)
[196.372776] Starting dynamic subtest: render-x-512
[196.446883] Dynamic subtest render-x-512: SUCCESS (0.084s)
[196.456946] Starting dynamic subtest: render-x-1024
[196.783555] Dynamic subtest render-x-1024: SUCCESS (0.336s)
[196.794353] Starting dynamic subtest: render-y-512
[196.867925] Dynamic subtest render-y-512: SUCCESS (0.085s)
[196.877925] Starting dynamic subtest: render-y-1024
[197.206132] Dynamic subtest render-y-1024: SUCCESS (0.335s)
[197.208445] Subtest render: SUCCESS (1.318s)
[197.342622] [010/133] (912s left) gem_mmap_gtt (basic-small-copy-xy)
[197.403847] Subtest basic-small-copy-XY: SKIP (0.000s)
[197.466120] [011/133] (912s left) gem_exec_fence (basic-busy-all)
[197.532693] Starting subtest: basic-busy-all
[197.632314] Subtest basic-busy-all: SUCCESS (0.102s)
[199.967307] [FACT gem_exec_fence (basic-busy-all)] new: kernel.kmod_is_loaded.vgem: true
[199.970265] [012/133] (909s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[200.074410] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[200.078577] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[200.195024] [013/133] (909s left) kms_atomic_transition (plane-toggle-modeset-transition)
[200.282737] Starting subtest: plane-toggle-modeset-transition
[200.284635] Starting dynamic subtest: pipe-A-eDP-1
[212.987361] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.705s)
[212.998053] Starting dynamic subtest: pipe-B-eDP-1
[225.437684] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.447s)
[225.440459] Subtest plane-toggle-modeset-transition: SUCCESS (25.157s)
[226.269200] [014/133] (883s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[226.358302] Starting subtest: fbcpsr-rgb565-draw-pwrite
[233.328184] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (6.973s)
[233.463840] [015/133] (876s left) kms_flip (2x-modeset-vs-vblank-race)
[233.555581] Starting subtest: 2x-modeset-vs-vblank-race
[233.564770] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[233.667577] [016/133] (876s left) gem_mmap_gtt (basic-small-bo-tiledy)
[233.738042] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[233.806907] [017/133] (876s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[233.903704] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[233.907889] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[234.021762] [018/133] (876s left) perf (polling-small-buf)
[234.159952] Starting subtest: polling-small-buf
[234.251116] Subtest polling-small-buf: SUCCESS (0.091s)
[234.293630] [019/133] (875s left) gem_ctx_param (non-root-set)
[234.346048] Starting subtest: non-root-set
[234.372964] Subtest non-root-set: SUCCESS (0.027s)
[234.480609] [020/133] (875s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[234.582589] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[235.251784] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.670s)
[235.442591] [021/133] (874s left) kms_vblank (wait-forked-hang)
[235.541964] Starting subtest: wait-forked-hang
[235.543913] Starting dynamic subtest: pipe-A-eDP-1
[261.653491] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.110s)
[261.666520] Starting dynamic subtest: pipe-D-eDP-1
[286.736846] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.080s)
[286.738942] Subtest wait-forked-hang: SUCCESS (51.194s)
[287.562788] [022/133] (822s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[287.628506] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[287.685827] [023/133] (822s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[287.781268] Starting subtest: invalid-modeset-force-ultra-joiner
[287.785525] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[287.856280] [024/133] (822s left) kms_pm_rpm (basic-rte)
[287.891035] Starting subtest: basic-rte
[291.549747] Subtest basic-rte: SUCCESS (3.660s)
[293.056504] [025/133] (817s left) gem_exec_fence (syncobj-wait)
[293.469161] Starting subtest: syncobj-wait
[294.940604] Subtest syncobj-wait: SUCCESS (1.470s)
[295.319078] [026/133] (815s left) kms_getfb (getfb-repeated-different-handles)
[295.414847] Starting subtest: getfb-repeated-different-handles
[295.417172] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[295.535725] [027/133] (814s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[295.628549] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[295.630819] Starting dynamic subtest: pipe-A-default-mode
[298.345744] Dynamic subtest pipe-A-default-mode: SUCCESS (2.716s)
[298.348052] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.717s)
[299.209977] [028/133] (811s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[299.306949] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[299.309150] Starting dynamic subtest: pipe-A-eDP-1
[299.333945] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[299.343490] Starting dynamic subtest: pipe-B-eDP-1
[299.366869] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[299.374914] Starting dynamic subtest: pipe-C-eDP-1
[299.398637] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[299.406617] Starting dynamic subtest: pipe-D-eDP-1
[299.431718] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[299.436243] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[301.554258] [029/133] (809s left) kms_cursor_crc (cursor-sliding-512x512)
[301.838240] Starting subtest: cursor-sliding-512x512
[301.842750] Subtest cursor-sliding-512x512: SKIP (0.001s)
[302.079788] [030/133] (808s left) api_intel_allocator (reserve-simple)
[302.129836] Starting subtest: reserve-simple
[302.132072] Subtest reserve-simple: SUCCESS (0.003s)
[302.273182] [031/133] (808s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[302.372431] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[302.376681] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[302.491799] [032/133] (808s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[302.594410] Starting subtest: 4-tiled-8bpp-rotate-270
[302.617868] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.021s)
[302.740798] [033/133] (808s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[302.835378] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[306.955236] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.123s)
[308.107585] [034/133] (802s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[308.512643] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[309.298607] [035/133] (801s left) gem_pwrite (basic-self)
[309.363213] Subtest basic-self: SKIP (0.000s)
[309.425676] [036/133] (801s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[309.542332] Starting subtest: basic-flip-before-cursor-atomic
[310.465074] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.921s)
[311.284101] [037/133] (799s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[311.385834] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[311.390129] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[312.506824] [038/133] (798s left) kms_pm_backlight (bad-brightness)
[312.597297] Starting subtest: bad-brightness
[312.645121] Starting dynamic subtest: eDP-1
[312.967704] Dynamic subtest eDP-1: SUCCESS (0.320s)
[312.969658] Subtest bad-brightness: SUCCESS (0.370s)
[313.850256] [039/133] (797s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[313.979283] Starting subtest: 2x-long-cursor-vs-flip-legacy
[313.983676] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s)
[314.120859] [040/133] (796s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[314.230076] Starting subtest: y-tiled-32bpp-rotate-0
[314.234300] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[314.347055] [041/133] (796s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[314.447300] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[322.093416] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.648s)
[322.229385] [042/133] (788s left) kms_psr (fbc-psr-primary-mmap-cpu)
[322.335873] Starting subtest: fbc-psr-primary-mmap-cpu
[322.338142] Starting dynamic subtest: eDP-1
[322.342281] Dynamic subtest eDP-1: SKIP (0.000s)
[322.346493] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[322.419037] [043/133] (788s left) kms_sequence (get-forked-busy)
[322.512214] Starting subtest: get-forked-busy
[322.514497] Starting dynamic subtest: pipe-A-eDP-1
[324.434886] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.925s)
[324.445755] Starting dynamic subtest: pipe-B-eDP-1
[327.047892] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.611s)
[327.057491] Starting dynamic subtest: pipe-C-eDP-1
[329.670891] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.623s)
[329.680964] Starting dynamic subtest: pipe-D-eDP-1
[332.276954] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.602s)
[332.279368] Subtest get-forked-busy: SUCCESS (9.764s)
[333.077037] [044/133] (778s left) kms_concurrent (multi-plane-atomic-lowres)
[333.178881] Starting subtest: multi-plane-atomic-lowres
[333.181257] Starting dynamic subtest: pipe-A-eDP-1
[333.682311] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.502s)
[333.684645] Subtest multi-plane-atomic-lowres: SUCCESS (0.503s)
[334.516173] [045/133] (776s left) gem_exec_schedule (reorder-wide)
[334.708103] Subtest reorder-wide: SKIP (0.000s)
[334.897427] [046/133] (776s left) prime_vgem (basic-write)
[334.976918] Starting subtest: basic-write
[334.985056] Subtest basic-write: SKIP (0.009s)
[335.127818] [047/133] (776s left) kms_hdmi_inject (inject-4k)
[335.484260] Starting subtest: inject-4k
[335.797994] Subtest inject-4k: SUCCESS (0.316s)
[336.387894] [048/133] (775s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[336.479328] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[336.481238] Starting dynamic subtest: pipe-A-eDP-1
[336.622385] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.135s)
[336.633086] Starting dynamic subtest: pipe-B-eDP-1
[336.654034] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.004s)
[336.662560] Starting dynamic subtest: pipe-C-eDP-1
[336.681915] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[336.689811] Starting dynamic subtest: pipe-D-eDP-1
[336.708970] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[336.711444] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.149s)
[338.866950] [049/133] (772s left) syncobj_timeline (invalid-query-zero-handles)
[338.930377] Starting subtest: invalid-query-zero-handles
[338.932643] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[339.073481] [050/133] (772s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[339.137361] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[339.241448] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[339.329970] [051/133] (772s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[339.432498] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[339.434758] Starting dynamic subtest: pipe-A-eDP-1
[339.495110] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[339.502676] Starting dynamic subtest: pipe-B-eDP-1
[339.558420] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[339.568101] Starting dynamic subtest: pipe-C-eDP-1
[339.624422] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[339.633711] Starting dynamic subtest: pipe-D-eDP-1
[339.690545] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[339.694597] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.009s)
[341.656841] [052/133] (769s left) kms_pipe_crc_basic (nonblocking-crc)
[341.756403] Starting subtest: nonblocking-crc
[341.758748] Starting dynamic subtest: pipe-A-eDP-1
[342.478223] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.723s)
[342.487772] Starting dynamic subtest: pipe-B-eDP-1
[343.913982] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.433s)
[343.922853] Starting dynamic subtest: pipe-C-eDP-1
[345.274088] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.358s)
[345.283562] Starting dynamic subtest: pipe-D-eDP-1
[346.660670] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.387s)
[346.663060] Subtest nonblocking-crc: SUCCESS (4.907s)
[347.566918] [053/133] (764s left) gem_ctx_shared (q-smoketest)
[347.635300] Starting subtest: Q-smoketest
[347.637708] Starting dynamic subtest: rcs0
[353.176773] Dynamic subtest rcs0: SUCCESS (5.493s)
[353.186518] Starting dynamic subtest: bcs0
[358.661045] Dynamic subtest bcs0: SUCCESS (5.485s)
[358.670793] Starting dynamic subtest: vcs0
[364.140967] Dynamic subtest vcs0: SUCCESS (5.477s)
[364.149926] Starting dynamic subtest: vcs1
[369.633995] Dynamic subtest vcs1: SUCCESS (5.492s)
[369.644809] Starting dynamic subtest: vecs0
[375.114366] Dynamic subtest vecs0: SUCCESS (5.477s)
[375.124596] Starting dynamic subtest: ccs0
[380.636248] Dynamic subtest ccs0: SUCCESS (5.521s)
[380.638619] Subtest Q-smoketest: SUCCESS (32.951s)
[380.789181] [054/133] (730s left) kms_async_flips (async-flip-dpms)
[380.898277] Starting subtest: async-flip-dpms
[381.278670] Starting dynamic subtest: pipe-A-eDP-1
[385.176342] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.898s)
[385.555576] Starting dynamic subtest: pipe-B-eDP-1
[388.380634] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.832s)
[388.753640] Starting dynamic subtest: pipe-C-eDP-1
[391.579986] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.832s)
[391.953722] Starting dynamic subtest: pipe-D-eDP-1
[394.775800] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.829s)
[394.778223] Subtest async-flip-dpms: SUCCESS (13.879s)
[395.942424] [055/133] (715s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[396.042039] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[396.044278] Starting dynamic subtest: pipe-A-eDP-1
[396.053054] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[396.061620] Starting dynamic subtest: pipe-B-eDP-1
[396.070618] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[396.078630] Starting dynamic subtest: pipe-C-eDP-1
[396.087142] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[396.094916] Starting dynamic subtest: pipe-D-eDP-1
[396.103263] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[396.107487] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s)
[398.334201] [056/133] (713s left) kms_psr (psr-cursor-plane-move)
[398.441298] Starting subtest: psr-cursor-plane-move
[398.443641] Starting dynamic subtest: eDP-1
[400.199622] Dynamic subtest eDP-1: SUCCESS (1.758s)
[400.201991] Subtest psr-cursor-plane-move: SUCCESS (1.759s)
[401.041051] [057/133] (710s left) syncobj_wait (invalid-signal-illegal-handle)
[401.108851] Starting subtest: invalid-signal-illegal-handle
[401.111228] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[401.228223] [058/133] (710s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[401.325725] Starting subtest: psr-rgb101010-draw-mmap-cpu
[408.289457] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (6.967s)
[408.412995] [059/133] (703s left) prime_mmap (test_aperture_limit)
[408.470621] Starting subtest: test_aperture_limit
[408.472845] Starting dynamic subtest: test_aperture_limit-smem
[408.486314] Dynamic subtest test_aperture_limit-smem: SKIP (0.011s)
[408.490380] Subtest test_aperture_limit: SKIP (0.011s)
[408.607863] [060/133] (703s left) gem_mmap_gtt (basic-write-read)
[408.676285] Subtest basic-write-read: SKIP (0.000s)
[408.744333] [061/133] (703s left) gem_huc_copy (huc-copy)
[408.809266] Starting subtest: huc-copy
[408.814578] Subtest huc-copy: SUCCESS (0.003s)
[408.956480] [062/133] (702s left) gem_exec_reloc (basic-gtt-wc-active)
[409.021065] Subtest basic-gtt-wc-active: SKIP (0.000s)
[409.102648] [063/133] (702s left) kms_color (ctm-negative)
[409.199171] Starting subtest: ctm-negative
[409.201247] Starting dynamic subtest: pipe-A-eDP-1
[409.907475] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.707s)
[409.916297] Starting dynamic subtest: pipe-B-eDP-1
[411.322675] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.416s)
[411.330818] Starting dynamic subtest: pipe-C-eDP-1
[412.650255] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.328s)
[412.659359] Starting dynamic subtest: pipe-D-eDP-1
[414.063795] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.411s)
[414.066044] Subtest ctm-negative: SUCCESS (4.865s)
[414.935793] [064/133] (697s left) syncobj_basic (bad-create-flags)
[414.999164] Starting subtest: bad-create-flags
[415.001356] Subtest bad-create-flags: SUCCESS (0.000s)
[415.137041] [065/133] (696s left) gem_exec_schedule (preemptive-hang)
[415.303094] Starting subtest: preemptive-hang
[415.306067] Starting dynamic subtest: rcs0
[425.023949] Dynamic subtest rcs0: SUCCESS (9.721s)
[425.034150] Starting dynamic subtest: bcs0
[434.045138] Dynamic subtest bcs0: SUCCESS (9.016s)
[434.057607] Starting dynamic subtest: vcs0
[443.004457] Dynamic subtest vcs0: SUCCESS (8.960s)
[443.015178] Starting dynamic subtest: vcs1
[452.027251] Dynamic subtest vcs1: SUCCESS (9.021s)
[452.038861] Starting dynamic subtest: vecs0
[461.048337] Dynamic subtest vecs0: SUCCESS (9.017s)
[461.058699] Starting dynamic subtest: ccs0
[470.012393] Dynamic subtest ccs0: SUCCESS (8.963s)
[470.014953] Subtest preemptive-hang: SUCCESS (54.708s)
[470.302434] [066/133] (641s left) gem_mmap_offset (open-flood)
[470.369103] Starting subtest: open-flood
[491.856633] Subtest open-flood: SUCCESS (21.489s)
[491.996469] [067/133] (620s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[492.105608] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[500.548304] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.446s)
[500.685727] [068/133] (611s left) syncobj_wait (wait-for-submit-snapshot)
[500.749512] Starting subtest: wait-for-submit-snapshot
[500.829777] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[500.915914] [069/133] (611s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[501.301039] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[502.105347] [070/133] (610s left) kms_flip (dpms-off-confusion-interruptible)
[502.208629] Starting subtest: dpms-off-confusion-interruptible
[502.211350] Starting dynamic subtest: A-eDP1
[510.897484] Dynamic subtest A-eDP1: SUCCESS (8.688s)
[510.906074] Starting dynamic subtest: B-eDP1
[519.589104] Dynamic subtest B-eDP1: SUCCESS (8.689s)
[519.600447] Starting dynamic subtest: C-eDP1
[528.192629] Dynamic subtest C-eDP1: SUCCESS (8.603s)
[528.203824] Starting dynamic subtest: D-eDP1
[536.882060] Dynamic subtest D-eDP1: SUCCESS (8.686s)
[536.886632] Subtest dpms-off-confusion-interruptible: SUCCESS (34.679s)
[538.137682] [071/133] (574s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[538.239247] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[538.266077] Starting dynamic subtest: pipe-A-plane-0
[538.564974] Dynamic subtest pipe-A-plane-0: SUCCESS (0.299s)
[538.575075] Starting dynamic subtest: pipe-A-plane-3
[538.798630] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[539.876729] Starting dynamic subtest: pipe-B-plane-0
[540.169779] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[540.179053] Starting dynamic subtest: pipe-B-plane-3
[540.414412] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s)
[540.711142] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.473s)
[541.530324] [072/133] (570s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[541.648122] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[541.652226] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[541.753140] [073/133] (570s left) perf (non-system-wide-paranoid)
[541.851474] Starting subtest: non-system-wide-paranoid
[541.875687] Subtest non-system-wide-paranoid: SUCCESS (0.027s)
[541.932263] [074/133] (570s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[542.040539] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[542.044658] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[542.117146] [075/133] (570s left) kms_pm_rpm (pm-caching)
[544.038872] Starting subtest: pm-caching
[544.044097] Subtest pm-caching: SKIP (0.000s)
[544.437950] [076/133] (568s left) perf (short-reads)
[544.544047] Starting subtest: short-reads
[544.554866] Subtest short-reads: SUCCESS (0.012s)
[544.603819] [077/133] (567s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[544.703967] Starting subtest: plane-all-transition-nonblocking-fencing
[544.706215] Starting dynamic subtest: pipe-A-eDP-1
[547.198938] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[547.514945] Starting dynamic subtest: pipe-B-eDP-1
[550.716574] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.209s)
[551.017271] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.309s)
[551.824401] [078/133] (560s left) gem_busy (busy)
[551.895167] Starting subtest: busy
[551.897502] Starting dynamic subtest: all-engines
[551.960299] Dynamic subtest all-engines: SUCCESS (0.065s)
[551.968734] Starting dynamic subtest: rcs0
[553.885213] Dynamic subtest rcs0: SUCCESS (1.923s)
[553.895528] Starting dynamic subtest: bcs0
[553.960237] Dynamic subtest bcs0: SUCCESS (0.072s)
[553.969541] Starting dynamic subtest: vcs0
[553.998444] Dynamic subtest vcs0: SUCCESS (0.038s)
[554.006798] Starting dynamic subtest: vcs1
[555.930033] Dynamic subtest vcs1: SUCCESS (1.928s)
[555.940641] Starting dynamic subtest: vecs0
[557.915290] Dynamic subtest vecs0: SUCCESS (1.984s)
[557.925823] Starting dynamic subtest: ccs0
[559.900930] Dynamic subtest ccs0: SUCCESS (1.983s)
[559.903364] Subtest busy: SUCCESS (8.002s)
[560.294111] [079/133] (552s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[560.406096] Starting subtest: extended-pageflip-modeset-hang-oldfb
[560.407973] Starting dynamic subtest: pipe-A
[568.326525] Dynamic subtest pipe-A: SUCCESS (7.919s)
[568.336185] Starting dynamic subtest: pipe-D
[576.912544] Dynamic subtest pipe-D: SUCCESS (8.582s)
[576.914930] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.506s)
[577.723317] [080/133] (534s left) kms_fb_coherency (memset-crc)
[577.828127] Starting subtest: memset-crc
[577.830430] Starting dynamic subtest: mmap-offset-wc
[578.193314] Dynamic subtest mmap-offset-wc: SUCCESS (0.365s)
[578.486033] Starting dynamic subtest: mmap-offset-uc
[584.182684] Dynamic subtest mmap-offset-uc: SUCCESS (5.703s)
[584.473294] Subtest memset-crc: SUCCESS (6.645s)
[585.338174] [081/133] (527s left) gem_vm_create (invalid-create)
[585.409252] Starting subtest: invalid-create
[585.411579] Subtest invalid-create: SUCCESS (0.002s)
[585.534172] [082/133] (527s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[585.631527] Starting subtest: yf-tiled-8bpp-rotate-270
[585.636018] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[585.734511] [083/133] (527s left) gem_ctx_persistence (saturated-hostile)
[585.795740] Starting subtest: saturated-hostile
[585.798101] Starting dynamic subtest: rcs0
[586.614933] Dynamic subtest rcs0: SUCCESS (0.818s)
[586.630726] Starting dynamic subtest: bcs0
[587.416610] Dynamic subtest bcs0: SUCCESS (0.799s)
[587.427982] Starting dynamic subtest: vcs0
[588.236104] Dynamic subtest vcs0: SUCCESS (0.817s)
[588.247785] Starting dynamic subtest: vcs1
[589.053885] Dynamic subtest vcs1: SUCCESS (0.816s)
[589.064845] Starting dynamic subtest: vecs0
[589.870177] Dynamic subtest vecs0: SUCCESS (0.811s)
[589.879626] Starting dynamic subtest: ccs0
[590.714471] Dynamic subtest ccs0: SUCCESS (0.846s)
[590.717049] Subtest saturated-hostile: SUCCESS (4.919s)
[590.808959] [084/133] (522s left) gem_exec_fence (syncobj-timeline-export)
[591.391334] Starting subtest: syncobj-timeline-export
[591.401073] Subtest syncobj-timeline-export: SUCCESS (0.011s)
[593.046167] [085/133] (519s left) syncobj_timeline (wait-zero-handles)
[593.109435] Starting subtest: wait-zero-handles
[593.111756] Subtest wait-zero-handles: SUCCESS (0.000s)
[593.229044] [086/133] (519s left) kms_big_fb (linear-32bpp-rotate-0)
[593.344724] Starting subtest: linear-32bpp-rotate-0
[594.891556] Subtest linear-32bpp-rotate-0: SUCCESS (1.546s)
[595.167904] [087/133] (517s left) kms_psr (psr-sprite-blt)
[595.275582] Starting subtest: psr-sprite-blt
[595.278267] Starting dynamic subtest: eDP-1
[596.998664] Dynamic subtest eDP-1: SUCCESS (1.727s)
[597.001031] Subtest psr-sprite-blt: SUCCESS (1.728s)
[597.821851] [088/133] (515s left) gem_eio (wait-10ms)
[598.058724] Starting subtest: wait-10ms
[598.385492] Subtest wait-10ms: SUCCESS (0.326s)
[598.565879] [089/133] (514s left) gem_pxp (verify-pxp-stale-buf-execution)
[598.684855] Starting subtest: verify-pxp-stale-buf-execution
[599.748223] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.063s)
[599.922111] [090/133] (513s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[600.025734] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[600.027994] Starting dynamic subtest: pipe-A-eDP-1
[600.109352] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[600.118661] Starting dynamic subtest: pipe-B-eDP-1
[601.264853] Dynamic subtest pipe-B-eDP-1: SKIP (1.151s)
[601.269207] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.243s)
[602.523775] [091/133] (510s left) gem_exec_balancer (nop)
[602.593477] Starting subtest: nop
[649.130672] Subtest nop: SUCCESS (46.536s)
[649.447862] [092/133] (463s left) kms_psr (fbc-pr-primary-mmap-cpu)
[649.554072] Starting subtest: fbc-pr-primary-mmap-cpu
[649.558517] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[649.640888] [093/133] (463s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[649.736270] Starting subtest: 4-tiled-16bpp-rotate-180
[651.106709] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.372s)
[651.271188] [094/133] (461s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[651.338124] Subtest no-spare-fences-busy: SKIP (0.000s)
[651.401051] [095/133] (461s left) gem_mmap_gtt (basic-read-write)
[651.458232] Subtest basic-read-write: SKIP (0.000s)
[651.524412] [096/133] (461s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[651.614433] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[651.617944] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[651.740969] [097/133] (461s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[651.856381] Starting subtest: short-flip-before-cursor-atomic-transitions
[652.818698] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.960s)
[653.617287] [098/133] (459s left) kms_cursor_legacy (forked-bo)
[653.737169] Starting subtest: forked-bo
[653.738989] Starting dynamic subtest: pipe-A
[659.190047] Dynamic subtest pipe-A: SUCCESS (5.450s)
[659.203551] Starting dynamic subtest: pipe-B
[664.671076] Dynamic subtest pipe-B: SUCCESS (5.478s)
[664.683295] Starting dynamic subtest: pipe-C
[670.133298] Dynamic subtest pipe-C: SUCCESS (5.460s)
[670.145925] Starting dynamic subtest: pipe-D
[675.607831] Dynamic subtest pipe-D: SUCCESS (5.471s)
[675.618776] Starting dynamic subtest: all-pipes
[681.102788] Dynamic subtest all-pipes: SUCCESS (5.492s)
[681.105326] Subtest forked-bo: SUCCESS (27.363s)
[681.252895] [099/133] (432s left) prime_mmap (test_map_unmap)
[681.322796] Starting subtest: test_map_unmap
[681.325157] Starting dynamic subtest: test_map_unmap-smem
[681.353335] Dynamic subtest test_map_unmap-smem: SUCCESS (0.030s)
[681.355799] Subtest test_map_unmap: SUCCESS (0.031s)
[681.472305] [100/133] (431s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[681.536687] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[681.541246] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[681.734426] [101/133] (431s left) dmabuf (all-tests)
[681.775370] Starting subtest: all-tests
[681.777552] Starting dynamic subtest: sanitycheck
[681.938640] Dynamic subtest sanitycheck: SUCCESS (0.161s)
[681.950659] Starting dynamic subtest: dma_fence
[682.254742] Dynamic subtest dma_fence: SUCCESS (0.313s)
[682.266513] Starting dynamic subtest: dma_fence_chain
[690.734518] Dynamic subtest dma_fence_chain: SUCCESS (8.477s)
[690.746799] Starting dynamic subtest: dma_fence_unwrap
[690.882390] Dynamic subtest dma_fence_unwrap: SUCCESS (0.146s)
[690.894484] Starting dynamic subtest: dma_resv
[691.010750] Dynamic subtest dma_resv: SUCCESS (0.126s)
[691.013692] Subtest all-tests: SUCCESS (9.235s)
[691.089665] [102/133] (422s left) kms_flip (plain-flip-fb-recreate-interruptible)
[691.189722] Starting subtest: plain-flip-fb-recreate-interruptible
[691.192081] Starting dynamic subtest: A-eDP1
[700.062923] Dynamic subtest A-eDP1: SUCCESS (8.872s)
[700.074369] Starting dynamic subtest: B-eDP1
[708.867995] Dynamic subtest B-eDP1: SUCCESS (8.802s)
[708.879053] Starting dynamic subtest: C-eDP1
[717.653787] Dynamic subtest C-eDP1: SUCCESS (8.783s)
[717.665276] Starting dynamic subtest: D-eDP1
[726.450622] Dynamic subtest D-eDP1: SUCCESS (8.794s)
[726.454635] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.265s)
[727.709052] [103/133] (385s left) kms_psr (fbc-psr2-no-drrs)
[727.802279] Starting subtest: fbc-psr2-no-drrs
[727.804191] Starting dynamic subtest: eDP-1
[727.808227] Dynamic subtest eDP-1: SKIP (0.000s)
[727.812365] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[727.884462] [104/133] (385s left) perf_pmu (busy-check-all)
[727.930706] Starting subtest: busy-check-all
[727.932930] Starting dynamic subtest: rcs0
[728.503246] Dynamic subtest rcs0: SUCCESS (0.571s)
[728.515276] Starting dynamic subtest: bcs0
[729.056129] Dynamic subtest bcs0: SUCCESS (0.550s)
[729.067681] Starting dynamic subtest: vcs0
[730.901758] Dynamic subtest vcs0: SUCCESS (1.843s)
[730.913893] Starting dynamic subtest: vcs1
[732.886052] Dynamic subtest vcs1: SUCCESS (1.980s)
[732.897932] Starting dynamic subtest: vecs0
[734.933986] Dynamic subtest vecs0: SUCCESS (2.045s)
[734.945601] Starting dynamic subtest: ccs0
[735.488309] Dynamic subtest ccs0: SUCCESS (0.553s)
[735.490703] Subtest busy-check-all: SUCCESS (7.558s)
[735.623421] [105/133] (378s left) kms_psr (fbc-psr-suspend)
[735.735919] Starting subtest: fbc-psr-suspend
[735.738222] Starting dynamic subtest: eDP-1
[735.742621] Dynamic subtest eDP-1: SKIP (0.000s)
[735.746826] Subtest fbc-psr-suspend: SKIP (0.001s)
[735.822945] [106/133] (377s left) gem_mmap_gtt (basic)
[735.887697] Subtest basic: SKIP (0.000s)
[735.962441] [107/133] (377s left) perf_pmu (init-busy)
[735.998195] Starting subtest: init-busy
[736.000461] Starting dynamic subtest: rcs0
[736.002698] Dynamic subtest rcs0: SUCCESS (0.001s)
[736.016912] Starting dynamic subtest: bcs0
[736.019268] Dynamic subtest bcs0: SUCCESS (0.001s)
[736.030112] Starting dynamic subtest: vcs0
[736.032235] Dynamic subtest vcs0: SUCCESS (0.000s)
[736.040465] Starting dynamic subtest: vcs1
[736.042654] Dynamic subtest vcs1: SUCCESS (0.001s)
[736.051212] Starting dynamic subtest: vecs0
[736.053368] Dynamic subtest vecs0: SUCCESS (0.002s)
[736.062171] Starting dynamic subtest: ccs0
[736.064491] Dynamic subtest ccs0: SUCCESS (0.001s)
[736.066680] Subtest init-busy: SUCCESS (0.013s)
[736.143750] [108/133] (377s left) i915_suspend (debugfs-reader)
[736.204808] Starting subtest: debugfs-reader
[753.927458] Subtest debugfs-reader: SUCCESS (3.305s)
[753.983585] [109/133] (359s left) gem_ctx_freq (sysfs)
[754.068128] Starting subtest: sysfs
[754.070529] Starting dynamic subtest: gt0
[759.606409] Dynamic subtest gt0: SUCCESS (5.533s)
[759.618446] Starting dynamic subtest: gt1
[801.317865] Dynamic subtest gt1: SUCCESS (41.702s)
[801.320560] Subtest sysfs: SUCCESS (47.239s)
[801.480627] [110/133] (312s left) kms_plane_multiple (tiling-y)
[801.581478] Starting subtest: tiling-y
[801.585592] Subtest tiling-y: SKIP (0.000s)
[801.670062] [111/133] (312s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[801.760245] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[801.764671] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[801.883623] [112/133] (312s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[801.940820] Starting subtest: etime-single-wait-all-available-unsubmitted
[802.050564] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.108s)
[802.141866] [113/133] (311s left) i915_drm_fdinfo (isolation)
[802.184674] Starting subtest: isolation
[802.186846] Starting dynamic subtest: rcs0
[802.218323] Dynamic subtest rcs0: SKIP (0.032s)
[802.230255] Starting dynamic subtest: bcs0
[802.234724] Dynamic subtest bcs0: SKIP (0.000s)
[802.243791] Starting dynamic subtest: vcs0
[802.248319] Dynamic subtest vcs0: SKIP (0.000s)
[802.257124] Starting dynamic subtest: vcs1
[802.261585] Dynamic subtest vcs1: SKIP (0.000s)
[802.271055] Starting dynamic subtest: vecs0
[802.275545] Dynamic subtest vecs0: SKIP (0.000s)
[802.284495] Starting dynamic subtest: ccs0
[802.288919] Dynamic subtest ccs0: SKIP (0.000s)
[802.293379] Subtest isolation: SKIP (0.037s)
[802.329952] [114/133] (311s left) gem_exec_reloc (basic-softpin)
[802.379256] Subtest basic-softpin: SKIP (0.000s)
[802.460416] [115/133] (311s left) kms_frontbuffer_tracking (fbc-2p-rte)
[802.563135] Starting subtest: fbc-2p-rte
[802.567244] Subtest fbc-2p-rte: SKIP (0.000s)
[802.691462] [116/133] (311s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[802.790766] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[802.795244] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[802.881016] [117/133] (311s left) gem_render_copy (y-tiled)
[802.954246] Starting subtest: y-tiled
[802.958437] Subtest y-tiled: SKIP (0.000s)
[803.145851] [118/133] (311s left) syncobj_timeline (wait-any-snapshot)
[803.199963] Starting subtest: wait-any-snapshot
[803.278526] Subtest wait-any-snapshot: SUCCESS (0.081s)
[803.366725] [119/133] (310s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[803.440000] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[803.442366] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[803.559857] [120/133] (310s left) gem_busy (close-race)
[803.615641] Starting subtest: close-race
[829.350136] Subtest close-race: SUCCESS (25.730s)
[829.744657] [121/133] (284s left) kms_flip (2x-dpms-vs-vblank-race)
[829.903336] Starting subtest: 2x-dpms-vs-vblank-race
[829.911619] Subtest 2x-dpms-vs-vblank-race: SKIP (0.010s)
[830.020745] [122/133] (284s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[830.129672] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[831.264101] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.133s)
[831.410865] [123/133] (282s left) perf_pmu (frequency)
[831.451940] Starting subtest: frequency
[831.454195] Starting dynamic subtest: gt0
[833.600061] Dynamic subtest gt0: SUCCESS (2.142s)
[833.612025] Starting dynamic subtest: idle-gt0
[834.106576] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[834.117007] Starting dynamic subtest: gt1
[838.323523] Dynamic subtest gt1: SUCCESS (4.212s)
[838.336153] Starting dynamic subtest: idle-gt1
[838.828108] Dynamic subtest idle-gt1: SUCCESS (0.505s)
[838.831208] Subtest frequency: SUCCESS (7.379s)
[838.946420] [124/133] (275s left) kms_lease (lease-unleased-connector)
[839.048680] Starting subtest: lease-unleased-connector
[839.050972] Starting dynamic subtest: pipe-A-eDP-1
[839.053373] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[839.065548] Starting dynamic subtest: pipe-B-eDP-1
[839.067825] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[839.079802] Starting dynamic subtest: pipe-C-eDP-1
[839.082078] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[839.091723] Starting dynamic subtest: pipe-D-eDP-1
[839.093854] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s)
[839.096076] Subtest lease-unleased-connector: SUCCESS (0.034s)
[839.207227] [125/133] (275s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[839.301611] Starting subtest: psr-rgb565-draw-render
[846.179543] Subtest psr-rgb565-draw-render: SUCCESS (6.879s)
[846.292577] [126/133] (268s left) i915_hangman (engine-engine-error)
[846.366871] Starting subtest: engine-engine-error
[846.368850] Starting dynamic subtest: rcs0
[848.326812] Dynamic subtest rcs0: SUCCESS (1.960s)
[848.344477] Starting dynamic subtest: bcs0
[850.245827] Dynamic subtest bcs0: SUCCESS (1.916s)
[850.259285] Starting dynamic subtest: vcs0
[852.293559] Dynamic subtest vcs0: SUCCESS (2.044s)
[852.306948] Starting dynamic subtest: vcs1
[854.276454] Dynamic subtest vcs1: SUCCESS (1.979s)
[854.289908] Starting dynamic subtest: vecs0
[856.261198] Dynamic subtest vecs0: SUCCESS (1.982s)
[856.274698] Starting dynamic subtest: ccs0
[858.308692] Dynamic subtest ccs0: SUCCESS (2.045s)
[858.313318] Subtest engine-engine-error: SUCCESS (11.944s)
[858.405562] [127/133] (256s left) gem_exec_fence (basic-wait)
[858.594513] Starting subtest: basic-wait
[858.597327] Starting dynamic subtest: rcs0
[858.690917] Dynamic subtest rcs0: SUCCESS (0.096s)
[858.703793] Starting dynamic subtest: bcs0
[858.757331] Dynamic subtest bcs0: SUCCESS (0.065s)
[858.769754] Starting dynamic subtest: vcs0
[858.826515] Dynamic subtest vcs0: SUCCESS (0.068s)
[858.839461] Starting dynamic subtest: vcs1
[858.897323] Dynamic subtest vcs1: SUCCESS (0.069s)
[858.909417] Starting dynamic subtest: vecs0
[858.967497] Dynamic subtest vecs0: SUCCESS (0.068s)
[858.987343] Starting dynamic subtest: ccs0
[859.041215] Dynamic subtest ccs0: SUCCESS (0.071s)
[859.044173] Subtest basic-wait: SUCCESS (0.448s)
[860.419899] [128/133] (254s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[860.695331] Starting subtest: cursor-rapid-movement-max-size
[860.702268] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[860.863683] [129/133] (253s left) kms_cursor_crc (cursor-offscreen-128x42)
[861.086282] Starting subtest: cursor-offscreen-128x42
[861.130908] Subtest cursor-offscreen-128x42: SKIP (0.043s)
[861.370207] [130/133] (253s left) gem_ctx_engines (invalid-engines)
[861.435930] Starting subtest: invalid-engines
[861.441980] Subtest invalid-engines: SUCCESS (0.008s)
[861.703898] [131/133] (253s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[861.818469] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[861.822744] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[861.951846] [132/133] (252s left) gem_flink_race (flink_close)
[861.986448] Starting subtest: flink_close
[867.079937] Subtest flink_close: SUCCESS (5.093s)
[867.171086] [133/133] (247s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[867.278914] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[867.282793] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[867.415769] Closing watchdogs
results: parsing output: 0/ for test: i915_pm_rps
results: parsing output: 1/ for test: gem_softpin
results: parsing output: 2/ for test: gem_exec_whisper
results: parsing output: 3/ for test: syncobj_wait
results: parsing output: 4/ for test: kms_plane_scaling
results: parsing output: 5/ for test: gen9_exec_parse
results: parsing output: 6/ for test: gem_flink_race
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: api_intel_bb
results: parsing output: 9/ for test: gem_mmap_gtt
results: parsing output: 10/ for test: gem_exec_fence
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_atomic_transition
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_flip
results: parsing output: 15/ for test: gem_mmap_gtt
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: perf
results: parsing output: 18/ for test: gem_ctx_param
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: kms_vblank
results: parsing output: 21/ for test: gem_mmap_gtt
results: parsing output: 22/ for test: kms_joiner
results: parsing output: 23/ for test: kms_pm_rpm
results: parsing output: 24/ for test: gem_exec_fence
results: parsing output: 25/ for test: kms_getfb
results: parsing output: 26/ for test: kms_flip_scaled_crc
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: kms_cursor_crc
results: parsing output: 29/ for test: api_intel_allocator
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_chamelium_hpd
results: parsing output: 34/ for test: gem_pwrite
results: parsing output: 35/ for test: kms_cursor_legacy
results: parsing output: 36/ for test: kms_ccs
results: parsing output: 37/ for test: kms_pm_backlight
results: parsing output: 38/ for test: kms_cursor_legacy
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: kms_sequence
results: parsing output: 43/ for test: kms_concurrent
results: parsing output: 44/ for test: gem_exec_schedule
results: parsing output: 45/ for test: prime_vgem
results: parsing output: 46/ for test: kms_hdmi_inject
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: kms_pipe_crc_basic
results: parsing output: 52/ for test: gem_ctx_shared
results: parsing output: 53/ for test: kms_async_flips
results: parsing output: 54/ for test: kms_ccs
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: syncobj_wait
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: prime_mmap
results: parsing output: 59/ for test: gem_mmap_gtt
results: parsing output: 60/ for test: gem_huc_copy
results: parsing output: 61/ for test: gem_exec_reloc
results: parsing output: 62/ for test: kms_color
results: parsing output: 63/ for test: syncobj_basic
results: parsing output: 64/ for test: gem_exec_schedule
results: parsing output: 65/ for test: gem_mmap_offset
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: syncobj_wait
results: parsing output: 68/ for test: kms_chamelium_edid
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: kms_plane
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: perf
results: parsing output: 73/ for test: kms_psr2_sf
results: parsing output: 74/ for test: kms_pm_rpm
results: parsing output: 75/ for test: perf
results: parsing output: 76/ for test: kms_atomic_transition
results: parsing output: 77/ for test: gem_busy
results: parsing output: 78/ for test: kms_busy
results: parsing output: 79/ for test: kms_fb_coherency
results: parsing output: 80/ for test: gem_vm_create
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: gem_ctx_persistence
results: parsing output: 83/ for test: gem_exec_fence
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: gem_eio
results: parsing output: 88/ for test: gem_pxp
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: gem_exec_balancer
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: gem_fenced_exec_thrash
results: parsing output: 94/ for test: gem_mmap_gtt
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: prime_mmap
results: parsing output: 99/ for test: gem_render_copy
results: parsing output: 100/ for test: dmabuf
results: parsing output: 101/ for test: kms_flip
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: perf_pmu
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: gem_mmap_gtt
results: parsing output: 106/ for test: perf_pmu
results: parsing output: 107/ for test: i915_suspend
results: parsing output: 108/ for test: gem_ctx_freq
results: parsing output: 109/ for test: kms_plane_multiple
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: syncobj_timeline
results: parsing output: 112/ for test: i915_drm_fdinfo
results: parsing output: 113/ for test: gem_exec_reloc
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_flip_scaled_crc
results: parsing output: 116/ for test: gem_render_copy
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: gem_busy
results: parsing output: 120/ for test: kms_flip
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: perf_pmu
results: parsing output: 123/ for test: kms_lease
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: i915_hangman
results: parsing output: 126/ for test: gem_exec_fence
results: parsing output: 127/ for test: kms_cursor_crc
results: parsing output: 128/ for test: kms_cursor_crc
results: parsing output: 129/ for test: gem_ctx_engines
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_flink_race
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.