[62.556013] Initializing watchdogs
[62.556058]   /dev/watchdog0
[62.570662] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[62.574760] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.577411] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.580736] [001/133] (960s left) kms_psr (fbc-psr-primary-mmap-gtt)
[62.676846] Starting subtest: fbc-psr-primary-mmap-gtt
[62.679372] Starting dynamic subtest: eDP-1
[62.683971] Dynamic subtest eDP-1: SKIP (0.000s)
[62.688639] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.000s)
[62.746148] [002/133] (960s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[62.821462] Starting subtest: pr-primary-plane-update-sf-dmg-area
[62.826024] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[62.888956] [003/133] (960s left) i915_pm_freq_api (freq-reset-multiple)
[62.966265] Starting subtest: freq-reset-multiple
[62.968720] Starting dynamic subtest: gt0
[70.263970] Dynamic subtest gt0: SUCCESS (7.309s)
[70.272667] Starting dynamic subtest: gt1
[76.766299] Dynamic subtest gt1: SUCCESS (6.508s)
[76.768914] Subtest freq-reset-multiple: SUCCESS (13.819s)
[76.840351] [004/133] (946s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[76.920936] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[76.923890] Starting dynamic subtest: pipe-A-eDP-1
[77.204632] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.252s)
[77.214771] Starting dynamic subtest: pipe-B-eDP-1
[78.489347] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.282s)
[78.499085] Starting dynamic subtest: pipe-C-eDP-1
[79.704248] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.213s)
[79.713736] Starting dynamic subtest: pipe-D-eDP-1
[80.921919] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.223s)
[80.924222] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.974s)
[82.073591] [005/133] (941s left) kms_selftest (drm_format)
[82.118038] Starting subtest: drm_format
[82.127858] Starting dynamic subtest: drm_test_format_block_width_invalid
[82.209755] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.081s)
[82.219061] Starting dynamic subtest: drm_test_format_block_width_one_plane
[82.304829] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.095s)
[82.313171] Starting dynamic subtest: drm_test_format_block_width_two_plane
[82.403723] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.098s)
[82.411795] Starting dynamic subtest: drm_test_format_block_width_three_plane
[82.485675] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.082s)
[82.494473] Starting dynamic subtest: drm_test_format_block_width_tiled
[82.578772] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.092s)
[82.587832] Starting dynamic subtest: drm_test_format_block_height_invalid
[82.666583] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.089s)
[82.675491] Starting dynamic subtest: drm_test_format_block_height_one_plane
[82.748535] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.081s)
[82.756919] Starting dynamic subtest: drm_test_format_block_height_two_plane
[82.842813] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.093s)
[82.852061] Starting dynamic subtest: drm_test_format_block_height_three_plane
[82.948447] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.106s)
[82.957741] Starting dynamic subtest: drm_test_format_block_height_tiled
[83.053634] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.105s)
[83.062442] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[83.148694] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.095s)
[83.157515] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[83.246738] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.099s)
[83.256040] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[83.354250] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.105s)
[83.362902] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[83.456762] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.103s)
[83.465158] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[83.572941] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.114s)
[83.580022] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[83.668728] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.096s)
[83.677087] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[83.789035] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.120s)
[83.796057] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[83.881302] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.092s)
[83.883625] Subtest drm_format: SUCCESS (1.763s)
[84.032748] [006/133] (939s left) gem_pxp (create-regular-buffer)
[84.146714] Starting subtest: create-regular-buffer
[84.149425] Subtest create-regular-buffer: SUCCESS (0.000s)
[84.249818] [007/133] (939s left) prime_self_import (export-vs-gem_close-race)
[84.278472] Starting subtest: export-vs-gem_close-race
[89.386359] Subtest export-vs-gem_close-race: SUCCESS (5.075s)
[89.470144] [008/133] (933s left) gen9_exec_parse (basic-rejected)
[89.551809] Subtest basic-rejected: SKIP (0.000s)
[89.626091] [009/133] (933s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[89.710034] Starting subtest: fbc-rgb101010-draw-render
[94.294498] Subtest fbc-rgb101010-draw-render: SUCCESS (4.589s)
[95.489430] [010/133] (927s left) perf_pmu (busy-no-semaphores)
[95.546406] Starting subtest: busy-no-semaphores
[95.548479] Starting dynamic subtest: rcs0
[96.101631] Dynamic subtest rcs0: SUCCESS (0.556s)
[96.111145] Starting dynamic subtest: bcs0
[96.652093] Dynamic subtest bcs0: SUCCESS (0.549s)
[96.661778] Starting dynamic subtest: vcs0
[97.204478] Dynamic subtest vcs0: SUCCESS (0.550s)
[97.215820] Starting dynamic subtest: vcs1
[98.331591] Dynamic subtest vcs1: SUCCESS (1.127s)
[98.343200] Starting dynamic subtest: vecs0
[100.380903] Dynamic subtest vecs0: SUCCESS (2.048s)
[100.392701] Starting dynamic subtest: ccs0
[102.365353] Dynamic subtest ccs0: SUCCESS (1.984s)
[102.368380] Subtest busy-no-semaphores: SUCCESS (6.822s)
[102.480930] [011/133] (920s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[102.563193] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[102.567160] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[102.670999] [012/133] (920s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[102.748085] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[102.752298] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[102.834701] [013/133] (920s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[102.907969] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[102.912153] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[103.019070] [014/133] (920s left) sysfs_preempt_timeout (idempotent)
[103.086114] Starting subtest: idempotent
[103.088547] Starting dynamic subtest: vecs0
[103.090846] Dynamic subtest vecs0: SUCCESS (0.000s)
[103.100849] Starting dynamic subtest: ccs0
[103.103301] Dynamic subtest ccs0: SUCCESS (0.000s)
[103.112242] Starting dynamic subtest: vcs0
[103.114412] Dynamic subtest vcs0: SUCCESS (0.000s)
[103.121628] Starting dynamic subtest: bcs0
[103.123851] Dynamic subtest bcs0: SUCCESS (0.000s)
[103.131267] Starting dynamic subtest: rcs0
[103.133077] Dynamic subtest rcs0: SUCCESS (0.000s)
[103.141559] Starting dynamic subtest: vcs1
[103.143656] Dynamic subtest vcs1: SUCCESS (0.000s)
[103.145741] Subtest idempotent: SUCCESS (0.004s)
[103.183018] [015/133] (920s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[103.267930] Starting subtest: yf-tiled-16bpp-rotate-180
[103.272076] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[103.371588] [016/133] (920s left) kms_cursor_crc (cursor-offscreen-512x512)
[103.616722] Starting subtest: cursor-offscreen-512x512
[103.620933] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[103.772479] [017/133] (919s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[103.849380] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[103.853418] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[105.012286] [018/133] (918s left) vgem_slow (nohang)
[105.084612] Starting subtest: nohang
[115.305921] Subtest nohang: SUCCESS (10.171s)
[115.340558] [FACT vgem_slow (nohang)] new: kernel.kmod_is_loaded.vgem: true
[115.343824] [019/133] (908s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[115.428539] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[115.432574] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[115.532932] [020/133] (908s left) perf (gen12-mi-rpc)
[115.645211] Starting subtest: gen12-mi-rpc
[115.647465] Starting dynamic subtest: rcs0
[115.664719] Dynamic subtest rcs0: SUCCESS (0.019s)
[115.666948] Subtest gen12-mi-rpc: SUCCESS (0.019s)
[115.717976] [021/133] (908s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[115.823748] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[122.610419] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.791s)
[122.712885] [022/133] (901s left) gem_ctx_persistence (heartbeat-close)
[122.766720] Starting subtest: heartbeat-close
[122.771200] Subtest heartbeat-close: SKIP (0.000s)
[122.867679] [023/133] (901s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[122.954048] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[127.255515] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.307s)
[128.391778] [024/133] (895s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[128.471671] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[128.476108] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[128.574566] [025/133] (895s left) gem_exec_schedule (semaphore-power)
[128.766845] Subtest semaphore-power: SKIP (0.000s)
[128.940853] [026/133] (895s left) kms_vblank (query-forked-busy-hang)
[129.018610] Starting subtest: query-forked-busy-hang
[129.020979] Starting dynamic subtest: pipe-A-eDP-1
[155.616805] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.597s)
[155.638156] Starting dynamic subtest: pipe-D-eDP-1
[170.648372] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.026s)
[170.650392] Subtest query-forked-busy-hang: SUCCESS (41.627s)
[171.451065] [027/133] (852s left) kms_cursor_legacy (forked-bo)
[171.543144] Starting subtest: forked-bo
[171.545041] Starting dynamic subtest: pipe-A
[177.055790] Dynamic subtest pipe-A: SUCCESS (5.457s)
[177.070192] Starting dynamic subtest: pipe-B
[182.533896] Dynamic subtest pipe-B: SUCCESS (5.478s)
[182.547593] Starting dynamic subtest: pipe-C
[188.019819] Dynamic subtest pipe-C: SUCCESS (5.485s)
[188.036213] Starting dynamic subtest: pipe-D
[193.483686] Dynamic subtest pipe-D: SUCCESS (5.462s)
[193.497640] Starting dynamic subtest: all-pipes
[198.993197] Dynamic subtest all-pipes: SUCCESS (5.511s)
[198.995574] Subtest forked-bo: SUCCESS (27.398s)
[199.085609] [028/133] (825s left) kms_lease (invalid-create-leases)
[199.172671] Starting subtest: invalid-create-leases
[199.177526] Subtest invalid-create-leases: SUCCESS (0.006s)
[199.284081] [029/133] (824s left) gem_mmap_gtt (basic-small-bo-tiledx)
[199.349633] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[199.408771] [030/133] (824s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[199.483467] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[199.487727] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[199.582966] [031/133] (824s left) gem_exec_whisper (basic-queues-priority)
[199.655110] Starting subtest: basic-queues-priority
[224.033665] Subtest basic-queues-priority: SUCCESS (24.325s)
[224.164968] [032/133] (800s left) sw_sync (timeline_closed_signaled)
[224.204305] Starting subtest: timeline_closed_signaled
[224.206635] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[224.267008] [033/133] (800s left) kms_prop_blob (blob-prop-core)
[224.324962] Starting subtest: blob-prop-core
[224.327451] Subtest blob-prop-core: SUCCESS (0.000s)
[224.438760] [034/133] (799s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[224.515220] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[231.353061] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.840s)
[231.492263] [035/133] (792s left) gem_ctx_bad_destroy (invalid-default-ctx)
[231.549585] Starting subtest: invalid-default-ctx
[231.551806] Subtest invalid-default-ctx: SUCCESS (0.000s)
[231.622845] [036/133] (792s left) gem_ctx_param (invalid-ctx-get)
[231.678528] Starting subtest: invalid-ctx-get
[231.680815] Subtest invalid-ctx-get: SUCCESS (0.000s)
[231.752393] [037/133] (792s left) kms_invalid_mode (clock-too-high)
[231.833898] Starting subtest: clock-too-high
[231.836218] Starting dynamic subtest: pipe-A-eDP-1
[231.840237] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[231.848396] Starting dynamic subtest: pipe-B-eDP-1
[231.852247] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[231.860465] Starting dynamic subtest: pipe-C-eDP-1
[231.864651] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[231.872545] Starting dynamic subtest: pipe-D-eDP-1
[231.877026] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[231.881091] Subtest clock-too-high: SKIP (0.003s)
[231.916466] [038/133] (792s left) perf_pmu (interrupts)
[231.962927] Starting subtest: interrupts
[233.070358] Subtest interrupts: SUCCESS (1.107s)
[233.184184] [039/133] (791s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[233.264930] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[233.268986] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[233.360063] [040/133] (791s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[233.720565] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[234.545793] [041/133] (790s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[234.603520] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[234.607904] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[234.784470] [042/133] (789s left) syncobj_wait (reset-unsignaled)
[234.851274] Starting subtest: reset-unsignaled
[234.853206] Subtest reset-unsignaled: SUCCESS (0.000s)
[234.963286] [043/133] (789s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[235.056572] Starting subtest: 4-tiled-64bpp-rotate-270
[235.077661] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.020s)
[235.191889] [044/133] (789s left) gem_exec_reloc (basic-gtt-read)
[235.259816] Subtest basic-gtt-read: SKIP (0.000s)
[235.333243] [045/133] (789s left) kms_pm_rpm (i2c)
[236.966850] Starting subtest: i2c
[242.525594] Subtest i2c: SUCCESS (5.558s)
[242.614877] [046/133] (782s left) kms_async_flips (async-flip-dpms)
[242.703871] Starting subtest: async-flip-dpms
[243.078819] Starting dynamic subtest: pipe-A-eDP-1
[246.892779] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.814s)
[247.273057] Starting dynamic subtest: pipe-B-eDP-1
[250.071198] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.804s)
[250.452585] Starting dynamic subtest: pipe-C-eDP-1
[253.237466] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.794s)
[253.603214] Starting dynamic subtest: pipe-D-eDP-1
[256.400048] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.802s)
[256.402472] Subtest async-flip-dpms: SUCCESS (13.697s)
[257.584803] [047/133] (767s left) gem_softpin (allocator-basic)
[257.647462] Starting subtest: allocator-basic
[257.716882] Subtest allocator-basic: SUCCESS (0.069s)
[257.855356] [048/133] (767s left) kms_color_pipeline (plane-ctm3x4)
[257.932750] Starting subtest: plane-ctm3x4
[258.078353] Starting dynamic subtest: pipe-A-plane-0
[258.212651] Dynamic subtest pipe-A-plane-0: SUCCESS (0.133s)
[258.224068] Starting dynamic subtest: pipe-A-plane-1
[258.355273] Dynamic subtest pipe-A-plane-1: SUCCESS (0.143s)
[258.364993] Starting dynamic subtest: pipe-A-plane-2
[258.488622] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[259.661773] Starting dynamic subtest: pipe-B-plane-0
[259.799303] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[259.808460] Starting dynamic subtest: pipe-B-plane-1
[259.912585] Dynamic subtest pipe-B-plane-1: SUCCESS (0.111s)
[259.921870] Starting dynamic subtest: pipe-B-plane-2
[260.043800] Dynamic subtest pipe-B-plane-2: SUCCESS (0.131s)
[261.195010] Starting dynamic subtest: pipe-C-plane-0
[261.300077] Dynamic subtest pipe-C-plane-0: SUCCESS (0.111s)
[261.311516] Starting dynamic subtest: pipe-C-plane-1
[261.409584] Dynamic subtest pipe-C-plane-1: SUCCESS (0.110s)
[261.418386] Starting dynamic subtest: pipe-C-plane-2
[261.521955] Dynamic subtest pipe-C-plane-2: SUCCESS (0.111s)
[262.723327] Starting dynamic subtest: pipe-D-plane-0
[262.872372] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[262.880852] Starting dynamic subtest: pipe-D-plane-1
[262.982300] Dynamic subtest pipe-D-plane-1: SUCCESS (0.108s)
[262.990971] Starting dynamic subtest: pipe-D-plane-2
[263.093933] Dynamic subtest pipe-D-plane-2: SUCCESS (0.110s)
[263.388797] Subtest plane-ctm3x4: SUCCESS (5.458s)
[264.208730] [049/133] (760s left) gem_workarounds (reset-fd)
[264.283192] Starting subtest: reset-fd
[264.453740] Subtest reset-fd: SUCCESS (0.170s)
[264.565180] [050/133] (760s left) gem_eio (create-ext)
[264.783473] Starting subtest: create-ext
[265.081452] Subtest create-ext: SUCCESS (0.297s)
[265.186317] [051/133] (759s left) gem_eio (throttle)
[265.391052] Starting subtest: throttle
[265.687550] Subtest throttle: SUCCESS (0.295s)
[265.808550] [052/133] (759s left) perf_pmu (semaphore-busy)
[265.852997] Starting subtest: semaphore-busy
[265.854652] Starting dynamic subtest: rcs0
[267.494152] Dynamic subtest rcs0: SUCCESS (1.638s)
[267.506638] Starting dynamic subtest: bcs0
[269.126284] Dynamic subtest bcs0: SUCCESS (1.629s)
[269.138368] Starting dynamic subtest: vcs0
[273.417109] Dynamic subtest vcs0: SUCCESS (4.236s)
[273.428821] Starting dynamic subtest: vcs1
[279.431173] Dynamic subtest vcs1: SUCCESS (6.012s)
[279.443032] Starting dynamic subtest: vecs0
[285.331914] Dynamic subtest vecs0: SUCCESS (5.949s)
[285.342893] Starting dynamic subtest: ccs0
[288.471814] Dynamic subtest ccs0: SUCCESS (3.137s)
[288.474779] Subtest semaphore-busy: SUCCESS (22.616s)
[288.586777] [053/133] (736s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[289.155391] Starting subtest: syncobj-backward-timeline-chain-engines
[289.342645] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.187s)
[290.926207] [054/133] (734s left) kms_atomic_transition (plane-all-transition-nonblocking)
[291.006192] Starting subtest: plane-all-transition-nonblocking
[291.008374] Starting dynamic subtest: pipe-A-eDP-1
[293.499902] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[293.806394] Starting dynamic subtest: pipe-B-eDP-1
[297.043190] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.245s)
[297.341212] Subtest plane-all-transition-nonblocking: SUCCESS (6.335s)
[298.170088] [055/133] (727s left) gem_eio (suspend)
[298.383739] Starting subtest: suspend
[310.617700] Subtest suspend: SUCCESS (12.235s)
[310.747555] [056/133] (714s left) gem_ctx_persistence (engines-mixed-process)
[310.816510] Starting subtest: engines-mixed-process
[310.818839] Starting dynamic subtest: rcs0
[312.851380] Dynamic subtest rcs0: SUCCESS (2.034s)
[312.861102] Starting dynamic subtest: bcs0
[314.764054] Dynamic subtest bcs0: SUCCESS (1.909s)
[314.775638] Starting dynamic subtest: vcs0
[316.807866] Dynamic subtest vcs0: SUCCESS (2.044s)
[316.819107] Starting dynamic subtest: vcs1
[318.875048] Dynamic subtest vcs1: SUCCESS (2.067s)
[318.886071] Starting dynamic subtest: vecs0
[320.869969] Dynamic subtest vecs0: SUCCESS (1.993s)
[320.881509] Starting dynamic subtest: ccs0
[322.838719] Dynamic subtest ccs0: SUCCESS (1.967s)
[322.841039] Subtest engines-mixed-process: SUCCESS (12.021s)
[322.917561] [057/133] (702s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[323.003885] Starting subtest: y-tiled-16bpp-rotate-180
[323.008229] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[323.107624] [058/133] (702s left) kms_flip (2x-flip-vs-panning-interruptible)
[323.189462] Starting subtest: 2x-flip-vs-panning-interruptible
[323.199353] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.008s)
[323.271318] [059/133] (702s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[323.331424] Starting subtest: x-tiled-to-vebox-y-tiled
[323.335950] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[323.523524] [060/133] (701s left) kms_busy (extended-modeset-hang-oldfb)
[323.591399] Starting subtest: extended-modeset-hang-oldfb
[323.593557] Starting dynamic subtest: pipe-A
[335.301038] Dynamic subtest pipe-A: SUCCESS (11.707s)
[335.311713] Starting dynamic subtest: pipe-D
[347.502966] Dynamic subtest pipe-D: SUCCESS (12.196s)
[347.505306] Subtest extended-modeset-hang-oldfb: SUCCESS (23.908s)
[348.378229] [061/133] (677s left) gem_userptr_blits (vma-merge)
[348.452054] Starting subtest: vma-merge
[348.493805] Subtest vma-merge: SUCCESS (0.042s)
[348.612917] [062/133] (676s left) kms_feature_discovery (chamelium)
[348.706295] Starting subtest: chamelium
[348.710762] Subtest chamelium: SKIP (0.000s)
[348.781400] [063/133] (676s left) kms_plane_multiple (tiling-none)
[348.863211] Starting subtest: tiling-none
[348.865556] Starting dynamic subtest: pipe-A-eDP-1
[352.518257] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.655s)
[352.529364] Starting dynamic subtest: pipe-B-eDP-1
[356.998774] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.477s)
[357.009025] Starting dynamic subtest: pipe-C-eDP-1
[361.386910] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.382s)
[361.397396] Starting dynamic subtest: pipe-D-eDP-1
[365.736235] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.352s)
[365.738624] Subtest tiling-none: SUCCESS (16.873s)
[366.539906] [064/133] (659s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[366.642619] Starting subtest: cursorA-vs-flipB-varying-size
[366.647347] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[366.810222] [065/133] (658s left) gem_exec_whisper (basic-contexts-priority-all)
[366.868582] Starting subtest: basic-contexts-priority-all
[389.986662] Subtest basic-contexts-priority-all: SUCCESS (23.114s)
[390.167648] [066/133] (635s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[390.270516] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[390.274605] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[390.354278] [067/133] (635s left) gem_exec_reloc (basic-range)
[390.421420] Subtest basic-range: SKIP (0.000s)
[390.487991] [068/133] (635s left) i915_query (hwconfig_table)
[390.540821] Starting subtest: hwconfig_table
[390.840793] Subtest hwconfig_table: SUCCESS (0.001s)
[390.884618] [069/133] (634s left) kms_cursor_crc (cursor-random-256x85)
[391.120086] Starting subtest: cursor-random-256x85
[391.167037] Subtest cursor-random-256x85: SKIP (0.043s)
[391.336996] [070/133] (634s left) gem_exec_balancer (invalid-bonds)
[391.399136] Starting subtest: invalid-bonds
[391.403101] Subtest invalid-bonds: SKIP (0.000s)
[391.701986] [071/133] (634s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[391.783028] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[391.787624] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[391.890247] [072/133] (634s left) gem_tiled_blits (basic)
[391.951138] Subtest basic: SKIP (0.000s)
[392.017558] [073/133] (633s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[392.062554] Starting subtest: single-wait-all-for-submit-unsubmitted
[392.172922] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.108s)
[392.249416] [074/133] (633s left) kms_pipe_crc_basic (read-crc)
[392.321137] Starting subtest: read-crc
[392.323319] Starting dynamic subtest: pipe-A-eDP-1
[393.023994] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.702s)
[393.036579] Starting dynamic subtest: pipe-B-eDP-1
[394.429562] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.405s)
[394.439642] Starting dynamic subtest: pipe-C-eDP-1
[395.718247] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.287s)
[395.728505] Starting dynamic subtest: pipe-D-eDP-1
[397.065738] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.343s)
[397.068066] Subtest read-crc: SUCCESS (4.743s)
[397.894746] [075/133] (628s left) core_auth (many-magics)
[397.950507] Starting subtest: many-magics
[398.813085] Subtest many-magics: SUCCESS (0.863s)
[398.997909] [076/133] (627s left) gem_flink_race (flink_close)
[399.037771] Starting subtest: flink_close
[404.132422] Subtest flink_close: SUCCESS (5.082s)
[404.234170] [077/133] (621s left) api_intel_allocator (reopen-fork)
[404.300072] Starting subtest: reopen-fork
[407.633116] Subtest reopen-fork: SUCCESS (3.283s)
[407.676320] [078/133] (618s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[407.732157] Starting subtest: multi-wait-all-for-submit-unsubmitted
[407.837041] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[407.920416] [079/133] (618s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[407.999124] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[408.003277] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[408.074025] [080/133] (618s left) kms_pm_backlight (brightness-with-dpms)
[408.147083] Starting subtest: brightness-with-dpms
[408.207291] Starting dynamic subtest: eDP-1
[410.646742] Dynamic subtest eDP-1: SUCCESS (2.441s)
[410.649065] Subtest brightness-with-dpms: SUCCESS (2.498s)
[411.523742] [081/133] (614s left) gem_exec_flush (basic-uc-set-default)
[411.580701] Starting subtest: basic-uc-set-default
[417.061627] Subtest basic-uc-set-default: SUCCESS (5.454s)
[417.221634] [082/133] (609s left) kms_getfb (getfb2-into-addfb2)
[417.305937] Starting subtest: getfb2-into-addfb2
[417.308240] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[417.407501] [083/133] (609s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[417.458196] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[417.460679] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[417.556210] [084/133] (608s left) syncobj_timeline (invalid-transfer-illegal-handle)
[417.602802] Starting subtest: invalid-transfer-illegal-handle
[417.605100] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[417.716675] [085/133] (608s left) prime_mmap_coherency (write)
[417.771981] Starting subtest: write
[423.201052] Subtest write: SUCCESS (5.377s)
[423.285913] [086/133] (603s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[423.350597] Starting subtest: single-wait-all-for-submit-available-signaled
[423.353064] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[423.479123] [087/133] (603s left) gem_madvise (dontneed-after-mmap)
[423.516601] Starting subtest: dontneed-after-mmap
[423.536773] Subtest dontneed-after-mmap: SUCCESS (0.020s)
[423.641178] [088/133] (603s left) kms_psr (psr-sprite-mmap-cpu)
[423.713015] Starting subtest: psr-sprite-mmap-cpu
[423.715348] Starting dynamic subtest: eDP-1
[425.443346] Dynamic subtest eDP-1: SUCCESS (1.730s)
[425.445642] Subtest psr-sprite-mmap-cpu: SUCCESS (1.731s)
[426.290765] [089/133] (600s left) gem_partial_pwrite_pread (writes-after-reads)
[426.349241] Subtest writes-after-reads: SKIP (0.000s)
[426.416798] [090/133] (600s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[426.477552] Starting subtest: etime-single-wait-all-available-unsubmitted
[426.579309] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.103s)
[426.657185] [091/133] (600s left) kms_atomic (atomic-invalid-params)
[426.735918] Starting subtest: atomic-invalid-params
[426.738170] Starting dynamic subtest: pipe-A-eDP-1
[427.135785] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.400s)
[427.138152] Subtest atomic-invalid-params: SUCCESS (0.401s)
[428.016860] [092/133] (598s left) gem_partial_pwrite_pread (reads-snoop)
[428.071720] Subtest reads-snoop: SKIP (0.000s)
[428.147894] [093/133] (598s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[428.227490] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[435.194526] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (6.970s)
[435.330420] [094/133] (591s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[435.426389] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[436.518015] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.091s)
[436.634711] [095/133] (590s left) kms_cursor_edge_walk (256x256-top-edge)
[436.707125] Starting subtest: 256x256-top-edge
[436.708993] Starting dynamic subtest: pipe-A-eDP-1
[440.214895] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.504s)
[440.226081] Starting dynamic subtest: pipe-D-eDP-1
[443.336678] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.119s)
[443.339078] Subtest 256x256-top-edge: SUCCESS (6.629s)
[444.140807] [096/133] (582s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[444.222805] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[444.226765] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[444.318829] [097/133] (582s left) api_intel_bb (render)
[444.382891] Starting subtest: render
[444.385116] Starting dynamic subtest: render-none-512
[444.478476] Dynamic subtest render-none-512: SUCCESS (0.097s)
[444.490822] Starting dynamic subtest: render-none-1024
[444.843829] Dynamic subtest render-none-1024: SUCCESS (0.363s)
[444.856769] Starting dynamic subtest: render-x-512
[444.932834] Dynamic subtest render-x-512: SUCCESS (0.088s)
[444.945130] Starting dynamic subtest: render-x-1024
[445.266578] Dynamic subtest render-x-1024: SUCCESS (0.333s)
[445.279478] Starting dynamic subtest: render-y-512
[445.352183] Dynamic subtest render-y-512: SUCCESS (0.084s)
[445.364632] Starting dynamic subtest: render-y-1024
[445.686669] Dynamic subtest render-y-1024: SUCCESS (0.331s)
[445.689220] Subtest render: SUCCESS (1.306s)
[445.808270] [098/133] (581s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[445.881368] Starting subtest: primary-yf-tiled-reflect-x-0
[445.941475] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.059s)
[446.042282] [099/133] (581s left) gem_mmap_gtt (hang-busy)
[446.104281] Subtest hang-busy: SKIP (0.000s)
[446.169750] [100/133] (580s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[446.247136] Starting subtest: crc-primary-basic-yf-tiled-ccs
[446.249395] Starting dynamic subtest: pipe-A-eDP-1
[446.272110] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[446.284190] Starting dynamic subtest: pipe-B-eDP-1
[446.305170] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[446.314031] Starting dynamic subtest: pipe-C-eDP-1
[446.335459] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[446.344375] Starting dynamic subtest: pipe-D-eDP-1
[446.365860] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[446.370128] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.006s)
[448.499421] [101/133] (578s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[448.585798] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[449.543561] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.958s)
[449.669147] [102/133] (577s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[449.753056] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[454.192395] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.443s)
[455.320599] [103/133] (571s left) kms_psr (psr2-primary-mmap-gtt)
[455.394260] Starting subtest: psr2-primary-mmap-gtt
[455.396559] Starting dynamic subtest: eDP-1
[456.810888] Dynamic subtest eDP-1: SKIP (1.413s)
[456.816066] Subtest psr2-primary-mmap-gtt: SKIP (1.416s)
[456.931154] [104/133] (570s left) gem_ctx_param (get-priority-new-ctx)
[456.992342] Starting subtest: get-priority-new-ctx
[456.994747] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[457.091463] [105/133] (570s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[457.153092] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[457.260476] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.108s)
[457.337707] [106/133] (570s left) fbdev (eof)
[457.376093] Starting subtest: eof
[457.378415] Subtest eof: SUCCESS (0.000s)
[457.459490] [107/133] (569s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[457.541059] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[457.543358] Starting dynamic subtest: pipe-A
[457.560247] Dynamic subtest pipe-A: SKIP (0.016s)
[457.570810] Starting dynamic subtest: pipe-B
[457.591269] Dynamic subtest pipe-B: SKIP (0.029s)
[457.601464] Starting dynamic subtest: pipe-C
[457.621332] Dynamic subtest pipe-C: SKIP (0.029s)
[457.631236] Starting dynamic subtest: pipe-D
[457.651426] Dynamic subtest pipe-D: SKIP (0.029s)
[457.655820] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.106s)
[457.756619] [108/133] (569s left) kms_psr (fbc-psr2-dpms)
[457.840228] Starting subtest: fbc-psr2-dpms
[457.842636] Starting dynamic subtest: eDP-1
[457.847060] Dynamic subtest eDP-1: SKIP (0.000s)
[457.851410] Subtest fbc-psr2-dpms: SKIP (0.001s)
[457.914498] [109/133] (569s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[457.998282] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[458.000611] Starting dynamic subtest: pipe-A-default-mode
[460.704657] Dynamic subtest pipe-A-default-mode: SUCCESS (2.704s)
[460.707118] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.706s)
[461.553995] [110/133] (566s left) kms_chamelium_edid (hdmi-mode-timings)
[461.925056] Subtest hdmi-mode-timings: SKIP (0.000s)
[462.765953] [111/133] (564s left) drm_buddy (drm_buddy)
[462.802343] Starting subtest: drm_buddy
[462.806815] Subtest drm_buddy: SKIP (0.000s)
[462.849174] [112/133] (564s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[462.914972] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[462.917274] Starting dynamic subtest: pipe-A-eDP-1
[462.926302] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[462.937148] Starting dynamic subtest: pipe-B-eDP-1
[462.946136] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[462.956188] Starting dynamic subtest: pipe-C-eDP-1
[462.964856] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[462.974698] Starting dynamic subtest: pipe-D-eDP-1
[462.983514] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[462.987724] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[465.160948] [113/133] (562s left) gem_exec_schedule (independent)
[465.230580] Starting subtest: independent
[465.232497] Starting dynamic subtest: rcs0
[466.841447] Dynamic subtest rcs0: SUCCESS (1.616s)
[466.854787] Starting dynamic subtest: vcs0
[468.834139] Dynamic subtest vcs0: SUCCESS (1.991s)
[468.851095] Starting dynamic subtest: vcs1
[470.886711] Dynamic subtest vcs1: SUCCESS (2.049s)
[470.899202] Starting dynamic subtest: vecs0
[472.857228] Dynamic subtest vecs0: SUCCESS (1.968s)
[472.867299] Starting dynamic subtest: ccs0
[474.841429] Dynamic subtest ccs0: SUCCESS (1.981s)
[474.844244] Subtest independent: SUCCESS (9.618s)
[475.165233] [114/133] (552s left) kms_psr (fbc-pr-no-drrs)
[475.243463] Starting subtest: fbc-pr-no-drrs
[475.247904] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[475.315856] [115/133] (552s left) kms_rotation_crc (sprite-rotation-270)
[475.386632] Starting subtest: sprite-rotation-270
[475.390653] Subtest sprite-rotation-270: SKIP (0.001s)
[475.461789] [116/133] (552s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[475.543880] Starting subtest: psr-2p-primscrn-spr-indfb-move
[475.548062] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[475.640161] [117/133] (552s left) gem_create (create-massive)
[475.691927] Starting subtest: create-massive
[475.693861] Subtest create-massive: SUCCESS (0.000s)
[475.876050] [118/133] (552s left) gem_exec_schedule (implicit-boths)
[475.948809] Starting subtest: implicit-boths
[475.951232] Starting dynamic subtest: rcs0
[476.057494] Dynamic subtest rcs0: SUCCESS (0.118s)
[476.069374] Starting dynamic subtest: vcs0
[476.137219] Dynamic subtest vcs0: SUCCESS (0.080s)
[476.146567] Starting dynamic subtest: vcs1
[476.219567] Dynamic subtest vcs1: SUCCESS (0.081s)
[476.232314] Starting dynamic subtest: vecs0
[476.301494] Dynamic subtest vecs0: SUCCESS (0.081s)
[476.313311] Starting dynamic subtest: ccs0
[476.390998] Dynamic subtest ccs0: SUCCESS (0.089s)
[476.393959] Subtest implicit-boths: SUCCESS (0.453s)
[477.949231] [119/133] (549s left) gem_exec_capture (capture)
[478.012067] Starting subtest: capture
[478.014254] Starting dynamic subtest: rcs0-smem
[478.853276] Dynamic subtest rcs0-smem: SUCCESS (0.842s)
[478.863310] Starting dynamic subtest: bcs0-smem
[479.682989] Dynamic subtest bcs0-smem: SUCCESS (0.830s)
[479.692699] Starting dynamic subtest: vcs0-smem
[480.515861] Dynamic subtest vcs0-smem: SUCCESS (0.830s)
[480.525198] Starting dynamic subtest: vcs1-smem
[481.838256] Dynamic subtest vcs1-smem: SUCCESS (1.320s)
[481.850324] Starting dynamic subtest: vecs0-smem
[482.731482] Dynamic subtest vecs0-smem: FAIL (0.833s)
[482.742546] Starting dynamic subtest: ccs0-smem
[484.009660] Dynamic subtest ccs0-smem: SUCCESS (1.339s)
[484.012018] Subtest capture: FAIL (5.998s)
[484.130401] [120/133] (543s left) kms_flip (flip-vs-fences-interruptible)
[484.219408] Starting subtest: flip-vs-fences-interruptible
[484.223840] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[484.321125] [121/133] (543s left) gem_softpin (evict-snoop-interruptible)
[484.373458] Starting subtest: evict-snoop-interruptible
[484.377785] Subtest evict-snoop-interruptible: SKIP (0.000s)
[484.502321] [122/133] (543s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[484.568973] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[484.571709] Starting dynamic subtest: pipe-A-default-mode
[487.314752] Dynamic subtest pipe-A-default-mode: SUCCESS (2.742s)
[487.316982] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.744s)
[488.146931] [123/133] (539s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[488.217422] Starting subtest: plane-upscale-20x20-with-rotation
[488.219818] Starting dynamic subtest: pipe-A
[488.442119] Dynamic subtest pipe-A: SUCCESS (0.226s)
[488.455699] Starting dynamic subtest: pipe-B
[489.734305] Dynamic subtest pipe-B: SUCCESS (1.292s)
[489.744119] Starting dynamic subtest: pipe-C
[491.072609] Dynamic subtest pipe-C: SUCCESS (1.337s)
[491.085374] Starting dynamic subtest: pipe-D
[492.402100] Dynamic subtest pipe-D: SUCCESS (1.328s)
[492.404396] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.187s)
[493.589388] [124/133] (534s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[493.656332] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[493.720056] [125/133] (534s left) kms_addfb_basic (bo-too-small)
[493.801215] Starting subtest: bo-too-small
[493.803514] Subtest bo-too-small: SUCCESS (0.000s)
[493.906990] [126/133] (534s left) syncobj_wait (wait-for-submit-complex)
[493.964155] Starting subtest: wait-for-submit-complex
[494.024647] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[494.103538] [127/133] (534s left) kms_psr (pr-basic)
[494.177708] Starting subtest: pr-basic
[494.182211] Subtest pr-basic: SKIP (0.000s)
[494.248791] [128/133] (534s left) i915_drm_fdinfo (idle)
[494.292451] Starting subtest: idle
[494.294479] Starting dynamic subtest: rcs0
[494.844262] Dynamic subtest rcs0: SUCCESS (0.552s)
[494.857069] Starting dynamic subtest: bcs0
[495.350966] Dynamic subtest bcs0: SUCCESS (0.503s)
[495.364063] Starting dynamic subtest: vcs0
[495.856748] Dynamic subtest vcs0: SUCCESS (0.503s)
[495.870534] Starting dynamic subtest: vcs1
[496.360742] Dynamic subtest vcs1: SUCCESS (0.502s)
[496.372245] Starting dynamic subtest: vecs0
[496.865714] Dynamic subtest vecs0: SUCCESS (0.503s)
[496.878829] Starting dynamic subtest: ccs0
[497.370781] Dynamic subtest ccs0: SUCCESS (0.503s)
[497.373977] Subtest idle: SUCCESS (3.079s)
[497.451659] [129/133] (530s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[497.575296] Starting subtest: dp-mst-type-0-suspend-resume
[497.579709] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[497.688252] [130/133] (530s left) i915_pm_rc6_residency (rc6-idle)
[497.742208] Starting subtest: rc6-idle
[497.765720] Starting dynamic subtest: gt0-rcs0
[522.071713] Dynamic subtest gt0-rcs0: SUCCESS (24.306s)
[522.084140] Starting dynamic subtest: gt0-bcs0
[546.418949] Dynamic subtest gt0-bcs0: SUCCESS (24.343s)
[546.428987] Starting dynamic subtest: gt0-ccs0
[570.778969] Dynamic subtest gt0-ccs0: SUCCESS (24.358s)
[570.788226] Starting dynamic subtest: gt1-vcs0
[577.008249] Dynamic subtest gt1-vcs0: SUCCESS (6.170s)
[577.021750] Starting dynamic subtest: gt1-vecs0
[583.175588] Dynamic subtest gt1-vecs0: SUCCESS (6.169s)
[583.178049] Subtest rc6-idle: SUCCESS (85.385s)
[583.218954] [131/133] (445s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[583.301675] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[583.305679] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[583.400968] [132/133] (445s left) tools_test (tools_test)
[583.452090] Starting subtest: tools_test
[583.500970] Subtest tools_test: SUCCESS (0.062s)
[583.560288] [133/133] (444s left) kms_chamelium_audio (dp-audio-edid)
[583.932897] Subtest dp-audio-edid: SKIP (0.000s)
[584.703147] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_psr2_sf
results: parsing output: 2/ for test: i915_pm_freq_api
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: kms_selftest
results: parsing output: 5/ for test: gem_pxp
results: parsing output: 6/ for test: prime_self_import
results: parsing output: 7/ for test: gen9_exec_parse
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: perf_pmu
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: sysfs_preempt_timeout
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: kms_cursor_crc
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: vgem_slow
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: perf
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_ctx_persistence
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_exec_schedule
results: parsing output: 25/ for test: kms_vblank
results: parsing output: 26/ for test: kms_cursor_legacy
results: parsing output: 27/ for test: kms_lease
results: parsing output: 28/ for test: gem_mmap_gtt
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_exec_whisper
results: parsing output: 31/ for test: sw_sync
results: parsing output: 32/ for test: kms_prop_blob
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_ctx_bad_destroy
results: parsing output: 35/ for test: gem_ctx_param
results: parsing output: 36/ for test: kms_invalid_mode
results: parsing output: 37/ for test: perf_pmu
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_chamelium_hpd
results: parsing output: 40/ for test: gem_render_copy
results: parsing output: 41/ for test: syncobj_wait
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: gem_exec_reloc
results: parsing output: 44/ for test: kms_pm_rpm
results: parsing output: 45/ for test: kms_async_flips
results: parsing output: 46/ for test: gem_softpin
results: parsing output: 47/ for test: kms_color_pipeline
results: parsing output: 48/ for test: gem_workarounds
results: parsing output: 49/ for test: gem_eio
results: parsing output: 50/ for test: gem_eio
results: parsing output: 51/ for test: perf_pmu
results: parsing output: 52/ for test: gem_exec_fence
results: parsing output: 53/ for test: kms_atomic_transition
results: parsing output: 54/ for test: gem_eio
results: parsing output: 55/ for test: gem_ctx_persistence
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: gem_render_copy
results: parsing output: 59/ for test: kms_busy
results: parsing output: 60/ for test: gem_userptr_blits
results: parsing output: 61/ for test: kms_feature_discovery
results: parsing output: 62/ for test: kms_plane_multiple
results: parsing output: 63/ for test: kms_cursor_legacy
results: parsing output: 64/ for test: gem_exec_whisper
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_exec_reloc
results: parsing output: 67/ for test: i915_query
results: parsing output: 68/ for test: kms_cursor_crc
results: parsing output: 69/ for test: gem_exec_balancer
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: gem_tiled_blits
results: parsing output: 72/ for test: syncobj_wait
results: parsing output: 73/ for test: kms_pipe_crc_basic
results: parsing output: 74/ for test: core_auth
results: parsing output: 75/ for test: gem_flink_race
results: parsing output: 76/ for test: api_intel_allocator
results: parsing output: 77/ for test: syncobj_wait
results: parsing output: 78/ for test: kms_plane
results: parsing output: 79/ for test: kms_pm_backlight
results: parsing output: 80/ for test: gem_exec_flush
results: parsing output: 81/ for test: kms_getfb
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: prime_mmap_coherency
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: gem_madvise
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: gem_partial_pwrite_pread
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: kms_atomic
results: parsing output: 91/ for test: gem_partial_pwrite_pread
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_cursor_edge_walk
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: api_intel_bb
results: parsing output: 97/ for test: kms_rotation_crc
results: parsing output: 98/ for test: gem_mmap_gtt
results: parsing output: 99/ for test: kms_ccs
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: gem_ctx_param
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: fbdev
results: parsing output: 106/ for test: kms_plane_scaling
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: kms_flip_scaled_crc
results: parsing output: 109/ for test: kms_chamelium_edid
results: parsing output: 110/ for test: drm_buddy
results: parsing output: 111/ for test: kms_ccs
results: parsing output: 112/ for test: gem_exec_schedule
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: kms_rotation_crc
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_create
results: parsing output: 117/ for test: gem_exec_schedule
results: parsing output: 118/ for test: gem_exec_capture
results: parsing output: 119/ for test: kms_flip
results: parsing output: 120/ for test: gem_softpin
results: parsing output: 121/ for test: kms_flip_scaled_crc
results: parsing output: 122/ for test: kms_plane_scaling
results: parsing output: 123/ for test: gem_mmap_gtt
results: parsing output: 124/ for test: kms_addfb_basic
results: parsing output: 125/ for test: syncobj_wait
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: i915_drm_fdinfo
results: parsing output: 128/ for test: kms_content_protection
results: parsing output: 129/ for test: i915_pm_rc6_residency
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: tools_test
results: parsing output: 132/ for test: kms_chamelium_audio
Done.