[56.649302] Initializing watchdogs
[56.649344]   /dev/watchdog0
[56.665670] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.670555] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.672669] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.676461] [001/133] (960s left) sw_sync (alloc_fence)
[56.733794] Starting subtest: alloc_fence
[56.736088] Subtest alloc_fence: SUCCESS (0.000s)
[56.817201] [002/133] (960s left) vgem_basic (dmabuf-mmap)
[56.888195] Starting subtest: dmabuf-mmap
[56.892633] Subtest dmabuf-mmap: SUCCESS (0.009s)
[56.951488] [FACT vgem_basic (dmabuf-mmap)] new: kernel.kmod_is_loaded.vgem: true
[56.954747] [003/133] (960s left) sw_sync (sync_expired_merge)
[56.990479] Starting subtest: sync_expired_merge
[58.072965] Subtest sync_expired_merge: SUCCESS (1.074s)
[58.148372] [004/133] (959s left) intel_hwmon (hwmon-read)
[58.208390] Subtest hwmon-read: SKIP (0.000s)
[58.264053] [005/133] (959s left) fbdev (info)
[58.299920] Starting subtest: info
[58.302185] Subtest info: SUCCESS (0.000s)
[58.368616] [006/133] (959s left) kms_psr (pr-sprite-mmap-gtt)
[58.458105] Starting subtest: pr-sprite-mmap-gtt
[58.462362] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[58.557368] [007/133] (958s left) kms_cursor_legacy (single-bo)
[58.683999] Starting subtest: single-bo
[58.686282] Starting dynamic subtest: pipe-A
[64.152777] Dynamic subtest pipe-A: SUCCESS (5.380s)
[64.162857] Starting dynamic subtest: pipe-B
[69.548799] Dynamic subtest pipe-B: SUCCESS (5.383s)
[69.557882] Starting dynamic subtest: pipe-C
[74.938201] Dynamic subtest pipe-C: SUCCESS (5.381s)
[74.947908] Starting dynamic subtest: pipe-D
[80.322461] Dynamic subtest pipe-D: SUCCESS (5.381s)
[80.332133] Starting dynamic subtest: all-pipes
[85.712160] Dynamic subtest all-pipes: SUCCESS (5.386s)
[85.714285] Subtest single-bo: SUCCESS (26.917s)
[85.803976] [008/133] (931s left) syncobj_eventfd (invalid-illegal-eventfd)
[85.858916] Starting subtest: invalid-illegal-eventfd
[85.861357] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[85.941444] [009/133] (931s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[86.323777] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[87.118659] [010/133] (930s left) gem_userptr_blits (vma-merge)
[87.186243] Starting subtest: vma-merge
[87.226327] Subtest vma-merge: SUCCESS (0.043s)
[87.347974] [011/133] (930s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[87.452177] Starting subtest: x-tiled-16bpp-rotate-180
[88.741311] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.290s)
[88.877999] [012/133] (928s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[88.977041] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[88.978931] Starting dynamic subtest: pipe-A-eDP-1
[99.666754] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.691s)
[99.675471] Starting dynamic subtest: pipe-B-eDP-1
[111.052570] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.381s)
[111.054691] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.074s)
[111.902969] [013/133] (905s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[112.009240] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[112.013207] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[112.110832] [014/133] (905s left) gem_mmap_wc (write-cpu-read-wc)
[112.166963] Subtest write-cpu-read-wc: SKIP (0.000s)
[112.230334] [015/133] (905s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[112.339490] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[112.343859] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[112.436961] [016/133] (905s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[112.533909] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[112.538462] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[112.641170] [017/133] (905s left) device_reset (unbind-cold-reset-rebind)
[112.689949] Starting subtest: unbind-cold-reset-rebind
[112.694711] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[112.749909] [018/133] (905s left) gem_exec_reloc (basic-cpu-gtt)
[112.812411] Subtest basic-cpu-gtt: SKIP (0.000s)
[112.886655] [019/133] (905s left) kms_psr (psr2-sprite-plane-onoff)
[112.971499] Starting subtest: psr2-sprite-plane-onoff
[112.973627] Starting dynamic subtest: eDP-1
[114.718418] Dynamic subtest eDP-1: SUCCESS (1.745s)
[114.720706] Subtest psr2-sprite-plane-onoff: SUCCESS (1.745s)
[115.573019] [020/133] (902s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[115.624768] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[115.627091] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.001s)
[115.742334] [021/133] (902s left) gem_exec_reloc (basic-wc-read-noreloc)
[115.802779] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[115.878213] [022/133] (902s left) kms_dsc (dsc-fractional-bpp)
[115.967145] Starting subtest: dsc-fractional-bpp
[115.979902] Subtest dsc-fractional-bpp: SKIP (0.000s)
[116.034913] [023/133] (902s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[116.119349] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[116.123976] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[117.213686] [024/133] (900s left) drm_read (invalid-buffer)
[117.353871] Starting subtest: invalid-buffer
[117.356481] Subtest invalid-buffer: SUCCESS (0.000s)
[117.480182] [025/133] (900s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[117.581031] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[125.055107] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.476s)
[125.203846] [026/133] (892s left) gem_eio (wait-wedge-1us)
[125.400809] Starting subtest: wait-wedge-1us
[127.337871] Subtest wait-wedge-1us: SUCCESS (1.937s)
[127.493915] [027/133] (890s left) i915_pm_rps (reset)
[127.566795] Starting subtest: reset
[135.999467] Subtest reset: SUCCESS (8.431s)
[136.119219] [028/133] (882s left) kms_color_pipeline (plane-lut1d)
[136.221846] Starting subtest: plane-lut1d
[136.368317] Starting dynamic subtest: pipe-A-plane-0
[136.535218] Dynamic subtest pipe-A-plane-0: SUCCESS (0.167s)
[136.547408] Starting dynamic subtest: pipe-A-plane-1
[136.690938] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[136.701201] Starting dynamic subtest: pipe-A-plane-2
[136.879824] Dynamic subtest pipe-A-plane-2: SUCCESS (0.189s)
[138.074228] Starting dynamic subtest: pipe-B-plane-0
[138.234479] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[138.245700] Starting dynamic subtest: pipe-B-plane-1
[138.389285] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s)
[138.397708] Starting dynamic subtest: pipe-B-plane-2
[138.544811] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[139.942374] Starting dynamic subtest: pipe-C-plane-0
[140.090647] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[140.102327] Starting dynamic subtest: pipe-C-plane-1
[140.235390] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[140.244469] Starting dynamic subtest: pipe-C-plane-2
[140.390534] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[141.569935] Starting dynamic subtest: pipe-D-plane-0
[141.718448] Dynamic subtest pipe-D-plane-0: SUCCESS (0.156s)
[141.727624] Starting dynamic subtest: pipe-D-plane-1
[141.874214] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[141.884756] Starting dynamic subtest: pipe-D-plane-2
[142.018298] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[142.305519] Subtest plane-lut1d: SUCCESS (6.082s)
[143.147855] [029/133] (875s left) kms_pm_rpm (modeset-lpsp-stress)
[145.391476] Starting subtest: modeset-lpsp-stress
[161.320960] Subtest modeset-lpsp-stress: SUCCESS (15.931s)
[161.424089] [030/133] (856s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[161.526398] Starting subtest: 2x-absolute-wf_vblank-interruptible
[161.536849] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.010s)
[161.639986] [031/133] (856s left) gem_exec_reloc (basic-cpu-read-active)
[161.693880] Subtest basic-cpu-read-active: SKIP (0.000s)
[161.769025] [032/133] (856s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[161.862210] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[161.864468] Starting dynamic subtest: pipe-A-default-mode
[163.046391] Dynamic subtest pipe-A-default-mode: SKIP (1.179s)
[163.050684] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.180s)
[163.185630] [033/133] (855s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[163.274934] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[163.285791] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.010s)
[163.410038] [034/133] (855s left) perf_pmu (semaphore-wait)
[163.449955] Starting subtest: semaphore-wait
[163.452189] Starting dynamic subtest: rcs0
[163.964316] Dynamic subtest rcs0: SUCCESS (0.514s)
[163.976982] Starting dynamic subtest: bcs0
[164.477380] Dynamic subtest bcs0: SUCCESS (0.511s)
[164.489506] Starting dynamic subtest: vcs0
[164.990677] Dynamic subtest vcs0: SUCCESS (0.511s)
[165.003041] Starting dynamic subtest: vcs1
[165.503671] Dynamic subtest vcs1: SUCCESS (0.511s)
[165.516082] Starting dynamic subtest: vecs0
[166.016735] Dynamic subtest vecs0: SUCCESS (0.511s)
[166.028876] Starting dynamic subtest: ccs0
[166.532597] Dynamic subtest ccs0: SUCCESS (0.513s)
[166.535878] Subtest semaphore-wait: SUCCESS (3.084s)
[166.653949] [035/133] (851s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[166.779847] Starting subtest: flip-vs-cursor-toggle
[175.738157] Subtest flip-vs-cursor-toggle: SUCCESS (8.957s)
[176.531321] [036/133] (842s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[176.630048] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[176.634512] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[177.761474] [037/133] (840s left) gem_eio (hibernate)
[177.963437] Starting subtest: hibernate
[193.469163] Subtest hibernate: SUCCESS (15.505s)
[201.602771] [038/133] (825s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[201.718688] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[206.327775] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.610s)
[207.459040] [039/133] (819s left) syncobj_wait (reset-during-wait-for-submit)
[207.516821] Starting subtest: reset-during-wait-for-submit
[207.618614] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[207.698785] [040/133] (819s left) kms_selftest (drm_plane_helper)
[207.738250] Starting subtest: drm_plane_helper
[207.762502] Starting dynamic subtest: drm_test_check_plane_state
[207.865077] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.100s)
[207.875965] Starting dynamic subtest: drm_test_check_invalid_plane_state
[207.979436] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.114s)
[207.981278] Subtest drm_plane_helper: SUCCESS (0.241s)
[208.132903] [041/133] (818s left) syncobj_wait (wait-all-snapshot)
[208.179633] Starting subtest: wait-all-snapshot
[208.261584] Subtest wait-all-snapshot: SUCCESS (0.082s)
[208.337804] [042/133] (818s left) kms_plane (plane-panning-bottom-right-suspend)
[208.432271] Starting subtest: plane-panning-bottom-right-suspend
[208.434648] Starting dynamic subtest: pipe-A
[226.451303] Dynamic subtest pipe-A: SUCCESS (2.883s)
[226.463834] Starting dynamic subtest: pipe-B
[245.418084] Dynamic subtest pipe-B: SUCCESS (3.458s)
[245.420519] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.343s)
[246.244122] [043/133] (780s left) gem_exec_suspend (basic-s3)
[246.313777] Starting subtest: basic-S3
[246.316132] Starting dynamic subtest: smem
[266.915023] Dynamic subtest smem: SUCCESS (6.483s)
[266.918240] Subtest basic-S3: SUCCESS (6.486s)
[267.103695] [044/133] (759s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[267.212177] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[267.216437] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[267.322338] [045/133] (759s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[267.422645] Starting subtest: stress-xrgb8888-ytiled
[267.427045] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[267.527754] [046/133] (759s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[267.629982] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[267.634138] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[267.699250] [047/133] (759s left) kms_psr (fbc-pr-cursor-render)
[267.804675] Starting subtest: fbc-pr-cursor-render
[267.809037] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[267.892680] [048/133] (759s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[267.946027] Subtest tiled-to-untiled: SKIP (0.000s)
[268.027378] [049/133] (759s left) core_getclient (basic)
[268.084481] Starting subtest: basic
[268.086186] Subtest basic: SUCCESS (0.000s)
[268.173701] [050/133] (759s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[268.264790] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[268.268375] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[268.365107] [051/133] (758s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[268.470659] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[268.474360] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[268.577204] [052/133] (758s left) gem_exec_schedule (u-semaphore-noskip)
[268.634664] Starting subtest: u-semaphore-noskip
[269.043265] Subtest u-semaphore-noskip: SUCCESS (0.410s)
[269.379319] [053/133] (758s left) kms_hdr (static-toggle-suspend)
[269.482063] Starting subtest: static-toggle-suspend
[269.488071] Subtest static-toggle-suspend: SKIP (0.000s)
[269.556161] [054/133] (757s left) gem_exec_reloc (basic-write-wc-noreloc)
[269.609280] Subtest basic-write-wc-noreloc: SKIP (0.000s)
[269.677487] [055/133] (757s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[269.764770] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[276.788254] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (7.005s)
[276.918269] [056/133] (750s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[276.979201] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[277.050691] [057/133] (750s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[277.101677] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[277.159102] [058/133] (750s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[277.264375] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[277.268404] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[277.386525] [059/133] (750s left) gen9_exec_parse (valid-registers)
[277.439374] Subtest valid-registers: SKIP (0.000s)
[277.513556] [060/133] (750s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[277.605248] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[277.609333] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[277.705091] [061/133] (750s left) kms_plane_multiple (tiling-y)
[277.798087] Starting subtest: tiling-y
[277.802146] Subtest tiling-y: SKIP (0.000s)
[277.869514] [062/133] (749s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[277.958853] Starting subtest: multiplane-rotation-cropping-top
[295.333441] Subtest multiplane-rotation-cropping-top: SUCCESS (17.360s)
[295.454324] [063/133] (732s left) gem_ctx_shared (single-timeline)
[295.516280] Starting subtest: single-timeline
[295.533600] Subtest single-timeline: SUCCESS (0.012s)
[295.758042] [064/133] (732s left) syncobj_timeline (host-signal-ordered)
[295.810813] Starting subtest: host-signal-ordered
[295.812997] Subtest host-signal-ordered: SUCCESS (0.001s)
[295.895105] [065/133] (731s left) kms_vblank (ts-continuation-suspend)
[295.975476] Starting subtest: ts-continuation-suspend
[295.977654] Starting dynamic subtest: pipe-A-eDP-1
[312.288380] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.502s)
[312.308294] Starting dynamic subtest: pipe-D-eDP-1
[329.311627] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.197s)
[329.314040] Subtest ts-continuation-suspend: SUCCESS (3.702s)
[330.142370] [066/133] (697s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[330.251432] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[331.055042] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.792s)
[331.221960] [067/133] (696s left) kms_atomic (atomic-plane-damage)
[331.325543] Starting subtest: atomic-plane-damage
[331.371793] Starting dynamic subtest: pipe-A-eDP-1
[331.932784] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.551s)
[331.935141] Subtest atomic-plane-damage: SUCCESS (0.599s)
[332.801104] [068/133] (695s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[332.861686] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[332.866481] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[333.054296] [069/133] (695s left) gem_lmem_swapping (heavy-verify-random)
[333.112667] Subtest heavy-verify-random: SKIP (0.000s)
[333.161700] [070/133] (694s left) kms_big_fb (linear-8bpp-rotate-90)
[333.254001] Starting subtest: linear-8bpp-rotate-90
[333.275482] Subtest linear-8bpp-rotate-90: SKIP (0.021s)
[333.417368] [071/133] (694s left) kms_cursor_crc (cursor-random-64x64)
[333.616929] Starting subtest: cursor-random-64x64
[333.619270] Starting dynamic subtest: pipe-A-eDP-1
[336.982202] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.336s)
[337.015896] Starting dynamic subtest: pipe-D-eDP-1
[340.963992] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.933s)
[340.966221] Subtest cursor-random-64x64: SUCCESS (7.296s)
[341.846023] [072/133] (686s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[341.952514] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[341.954389] Starting dynamic subtest: pipe-A-eDP-1
[342.009082] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.058s)
[342.020447] Starting dynamic subtest: pipe-B-eDP-1
[342.071428] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.059s)
[342.082578] Starting dynamic subtest: pipe-C-eDP-1
[342.129991] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.058s)
[342.142522] Starting dynamic subtest: pipe-D-eDP-1
[342.189098] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.058s)
[342.191327] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.238s)
[344.500166] [073/133] (683s left) i915_hangman (detector)
[344.568091] Starting subtest: detector
[344.570371] Starting dynamic subtest: rcs0
[356.500850] Dynamic subtest rcs0: SUCCESS (11.913s)
[356.515343] Starting dynamic subtest: bcs0
[368.468330] Dynamic subtest bcs0: SUCCESS (11.965s)
[368.482149] Starting dynamic subtest: vcs0
[380.434900] Dynamic subtest vcs0: SUCCESS (11.964s)
[380.449523] Starting dynamic subtest: vcs1
[391.443446] Dynamic subtest vcs1: SUCCESS (11.003s)
[391.457041] Starting dynamic subtest: vecs0
[402.452167] Dynamic subtest vecs0: SUCCESS (11.002s)
[402.465271] Starting dynamic subtest: ccs0
[414.484201] Dynamic subtest ccs0: SUCCESS (12.025s)
[414.487694] Subtest detector: SUCCESS (69.890s)
[414.618626] [074/133] (613s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[414.734858] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[414.739155] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[414.820901] [075/133] (613s left) gem_exec_reloc (basic-active)
[414.868915] Subtest basic-active: SKIP (0.000s)
[414.939419] [076/133] (613s left) kms_atomic_interruptible (legacy-cursor)
[415.025269] Starting subtest: legacy-cursor
[415.027516] Starting dynamic subtest: pipe-A-eDP-1
[422.427455] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.397s)
[422.429710] Subtest legacy-cursor: SUCCESS (7.399s)
[423.281652] [077/133] (605s left) sysfs_timeslice_duration (idempotent)
[423.350605] Starting subtest: idempotent
[423.353088] Starting dynamic subtest: vecs0
[423.355463] Dynamic subtest vecs0: SUCCESS (0.000s)
[423.367200] Starting dynamic subtest: ccs0
[423.369108] Dynamic subtest ccs0: SUCCESS (0.001s)
[423.379138] Starting dynamic subtest: vcs0
[423.381111] Dynamic subtest vcs0: SUCCESS (0.000s)
[423.391262] Starting dynamic subtest: bcs0
[423.393241] Dynamic subtest bcs0: SUCCESS (0.001s)
[423.403782] Starting dynamic subtest: rcs0
[423.405935] Dynamic subtest rcs0: SUCCESS (0.000s)
[423.416196] Starting dynamic subtest: vcs1
[423.418084] Dynamic subtest vcs1: SUCCESS (0.000s)
[423.420036] Subtest idempotent: SUCCESS (0.010s)
[423.459958] [078/133] (604s left) kms_force_connector_basic (prune-stale-modes)
[423.536535] Starting subtest: prune-stale-modes
[423.977886] Subtest prune-stale-modes: SUCCESS (0.444s)
[424.117889] [079/133] (604s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[424.210083] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[424.213420] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[424.326005] [080/133] (604s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[424.425787] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[424.429169] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[424.546574] [081/133] (604s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[424.648888] Starting subtest: crc-primary-basic-yf-tiled-ccs
[424.650871] Starting dynamic subtest: pipe-A-eDP-1
[424.669957] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[424.683568] Starting dynamic subtest: pipe-B-eDP-1
[424.701794] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[424.711760] Starting dynamic subtest: pipe-C-eDP-1
[424.729722] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[424.740243] Starting dynamic subtest: pipe-D-eDP-1
[424.758532] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[424.761944] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.007s)
[426.914872] [082/133] (601s left) gem_cs_tlb (engines)
[426.971141] Starting subtest: engines
[426.973483] Starting dynamic subtest: rcs0
[429.177835] Dynamic subtest rcs0: SUCCESS (2.152s)
[429.191331] Starting dynamic subtest: bcs0
[431.278328] Dynamic subtest bcs0: SUCCESS (2.152s)
[431.291448] Starting dynamic subtest: vcs0
[433.482932] Dynamic subtest vcs0: SUCCESS (2.153s)
[433.497113] Starting dynamic subtest: vcs1
[435.635560] Dynamic subtest vcs1: SUCCESS (2.151s)
[435.649151] Starting dynamic subtest: vecs0
[437.789133] Dynamic subtest vecs0: SUCCESS (2.153s)
[437.803371] Starting dynamic subtest: ccs0
[439.943731] Dynamic subtest ccs0: SUCCESS (2.154s)
[439.946348] Subtest engines: SUCCESS (12.921s)
[440.007943] [083/133] (588s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[440.109129] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[440.113331] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[440.217596] [084/133] (588s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[440.323000] Starting subtest: 4-tiled-32bpp-rotate-0
[441.703877] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.380s)
[441.838227] [085/133] (586s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[441.942316] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[441.954799] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s)
[442.050907] [086/133] (586s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[442.096552] Starting subtest: invalid-single-wait-all-unsubmitted
[442.098540] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[442.210461] [087/133] (586s left) kms_psr (fbc-psr-cursor-plane-onoff)
[442.295952] Starting subtest: fbc-psr-cursor-plane-onoff
[442.297725] Starting dynamic subtest: eDP-1
[442.301074] Dynamic subtest eDP-1: SKIP (0.000s)
[442.304324] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[442.372483] [088/133] (586s left) kms_content_protection (atomic-dpms-hdcp14)
[442.512801] Starting subtest: atomic-dpms-hdcp14
[442.516480] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[442.632890] [089/133] (586s left) gem_exec_balancer (bonded-semaphore)
[442.699004] Starting subtest: bonded-semaphore
[442.702775] Subtest bonded-semaphore: SKIP (0.000s)
[443.014522] [090/133] (585s left) gen9_exec_parse (bb-large)
[443.081442] Subtest bb-large: SKIP (0.000s)
[443.163007] [091/133] (585s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[443.257640] Starting subtest: plane-upscale-20x20-with-modifiers
[443.259955] Starting dynamic subtest: pipe-A
[443.594413] Dynamic subtest pipe-A: SUCCESS (0.338s)
[443.613482] Starting dynamic subtest: pipe-B
[444.963283] Dynamic subtest pipe-B: SUCCESS (1.368s)
[444.974196] Starting dynamic subtest: pipe-C
[446.365581] Dynamic subtest pipe-C: SUCCESS (1.401s)
[446.379479] Starting dynamic subtest: pipe-D
[447.765972] Dynamic subtest pipe-D: SUCCESS (1.400s)
[447.768268] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.511s)
[448.904205] [092/133] (580s left) kms_pm_rpm (fences-dpms)
[450.736346] Starting subtest: fences-dpms
[450.741689] Subtest fences-dpms: SKIP (0.000s)
[451.213311] [093/133] (577s left) kms_cursor_crc (cursor-sliding-64x21)
[451.421189] Starting subtest: cursor-sliding-64x21
[451.470881] Subtest cursor-sliding-64x21: SKIP (0.043s)
[451.729206] [094/133] (577s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[451.829205] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[458.853936] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.027s)
[458.980067] [095/133] (570s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[459.083919] Starting subtest: y-tiled-16bpp-rotate-270
[459.088218] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[459.198660] [096/133] (570s left) perf_pmu (interrupts)
[459.247927] Starting subtest: interrupts
[460.354338] Subtest interrupts: SUCCESS (1.106s)
[460.476351] [097/133] (568s left) kms_lease (lessee-list)
[460.566615] Starting subtest: lessee-list
[460.569029] Starting dynamic subtest: pipe-A-eDP-1
[460.571594] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[460.585742] Starting dynamic subtest: pipe-B-eDP-1
[460.587616] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[460.597761] Starting dynamic subtest: pipe-C-eDP-1
[460.599619] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[460.609954] Starting dynamic subtest: pipe-D-eDP-1
[460.611780] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[460.613611] Subtest lessee-list: SUCCESS (0.008s)
[460.707393] [098/133] (568s left) gem_lmem_swapping (verify-ccs)
[460.751988] Subtest verify-ccs: SKIP (0.000s)
[460.792559] [099/133] (568s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[460.836351] Starting subtest: single-wait-for-submit-available-submitted
[460.838587] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[460.942935] [100/133] (568s left) gem_exec_fence (syncobj-timeline-export)
[461.487028] Starting subtest: syncobj-timeline-export
[461.492218] Subtest syncobj-timeline-export: SUCCESS (0.007s)
[462.613809] [101/133] (566s left) sw_sync (sync_multi_producer_single_consumer)
[462.647409] Starting subtest: sync_multi_producer_single_consumer
[463.721932] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[463.796689] [102/133] (565s left) gem_mmap_offset (mmap-unmap)
[463.841001] Starting subtest: mmap-unmap
[463.843019] Starting dynamic subtest: smem0
[487.542540] Dynamic subtest smem0: SUCCESS (23.698s)
[487.546016] Subtest mmap-unmap: SUCCESS (23.699s)
[487.640082] [103/133] (541s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[487.757299] Starting subtest: cursorB-vs-flipB-toggle
[487.761790] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[487.902759] [104/133] (541s left) perf_pmu (module-unload)