[60.310453] Initializing watchdogs
[60.310566]   /dev/watchdog0
[60.326705] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[60.331222] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.333510] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.336939] [001/134] (960s left) gem_exec_schedule (pi-ringfull)
[60.545503] Starting subtest: pi-ringfull
[60.547792] Starting dynamic subtest: rcs0
[60.594627] Dynamic subtest rcs0: SUCCESS (0.053s)
[60.601880] Starting dynamic subtest: bcs0
[60.627604] Dynamic subtest bcs0: SUCCESS (0.033s)
[60.635052] Starting dynamic subtest: vcs0
[60.659628] Dynamic subtest vcs0: SUCCESS (0.032s)
[60.666964] Starting dynamic subtest: vcs1
[60.691229] Dynamic subtest vcs1: SUCCESS (0.032s)
[60.706730] Starting dynamic subtest: vecs0
[60.721198] Dynamic subtest vecs0: SUCCESS (0.030s)
[60.727890] Starting dynamic subtest: ccs0
[60.752587] Dynamic subtest ccs0: SUCCESS (0.031s)
[60.754705] Subtest pi-ringfull: SUCCESS (0.214s)
[60.997112] [FACT gem_exec_schedule (pi-ringfull)] new: kernel.kmod_is_loaded.vgem: true
[60.999924] [002/134] (959s left) syncobj_timeline (multi-wait-available-submitted)
[61.048071] Starting subtest: multi-wait-available-submitted
[61.050548] Subtest multi-wait-available-submitted: SUCCESS (0.001s)
[61.183376] [003/134] (959s left) kms_selftest (drm_plane_helper)
[61.218851] Starting subtest: drm_plane_helper
[61.223888] Starting dynamic subtest: drm_test_check_plane_state
[61.331063] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.109s)
[61.338395] Starting dynamic subtest: drm_test_check_invalid_plane_state
[61.442052] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.111s)
[61.444118] Subtest drm_plane_helper: SUCCESS (0.227s)
[61.615353] [004/134] (959s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[61.726618] Starting subtest: random-ccs-data-y-tiled-ccs
[61.728787] Starting dynamic subtest: pipe-A-eDP-1
[61.753840] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[61.764164] Starting dynamic subtest: pipe-B-eDP-1
[61.787067] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[61.794308] Starting dynamic subtest: pipe-C-eDP-1
[61.818828] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[61.826559] Starting dynamic subtest: pipe-D-eDP-1
[61.849110] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[61.853221] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.002s)
[64.038353] [005/134] (956s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[64.129253] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[64.133649] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[64.197889] [006/134] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[64.297767] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[64.302384] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[64.397023] [007/134] (956s left) i915_query (query-regions-garbage-items)
[64.458983] Starting subtest: query-regions-garbage-items
[64.460869] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[64.573910] [008/134] (956s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[64.671442] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[68.728912] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (4.087s)
[69.856923] [009/134] (951s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[69.944623] Starting subtest: primary-y-tiled-reflect-x-90
[69.949330] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[70.015609] [010/134] (951s left) kms_flip (dpms-off-confusion)
[70.112383] Starting subtest: dpms-off-confusion
[70.114894] Starting dynamic subtest: A-eDP1
[78.882215] Dynamic subtest A-eDP1: SUCCESS (8.757s)
[78.893066] Starting dynamic subtest: B-eDP1
[87.587291] Dynamic subtest B-eDP1: SUCCESS (8.710s)
[87.596508] Starting dynamic subtest: C-eDP1
[96.259519] Dynamic subtest C-eDP1: SUCCESS (8.704s)
[96.271362] Starting dynamic subtest: D-eDP1
[104.942239] Dynamic subtest D-eDP1: SUCCESS (8.634s)
[104.944527] Subtest dpms-off-confusion: SUCCESS (34.812s)
[106.068429] [011/134] (915s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[106.174372] Starting subtest: y-tiled-16bpp-rotate-0
[106.179024] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[106.281297] [012/134] (914s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[106.388961] Starting subtest: bad-aux-stride-y-tiled-ccs
[106.391237] Starting dynamic subtest: pipe-A-eDP-1
[106.414604] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[106.422770] Starting dynamic subtest: pipe-B-eDP-1
[106.444319] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[106.452400] Starting dynamic subtest: pipe-C-eDP-1
[106.474102] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[106.481600] Starting dynamic subtest: pipe-D-eDP-1
[106.503650] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[106.507990] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[108.630573] [013/134] (912s left) gem_vm_create (invalid-destroy)
[108.689063] Starting subtest: invalid-destroy
[108.693528] Subtest invalid-destroy: SUCCESS (0.002s)
[108.792053] [014/134] (912s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[108.899293] Starting subtest: x-tiled-64bpp-rotate-90
[108.918322] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[109.033058] [015/134] (912s left) kms_addfb_basic (too-high)
[109.122184] Starting subtest: too-high
[109.124398] Subtest too-high: SUCCESS (0.000s)
[109.218331] [016/134] (912s left) kms_setmode (invalid-clone-single-crtc)
[109.270962] Starting subtest: invalid-clone-single-crtc
[109.277849] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[109.404268] [017/134] (912s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[109.502823] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[118.211050] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.712s)
[118.335230] [018/134] (903s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[118.424710] Starting subtest: fbcpsr-suspend
[159.389189] Subtest fbcpsr-suspend: SUCCESS (10.233s)
[159.523813] [019/134] (862s left) gem_ctx_param (invalid-get-no-zeromap)
[159.590031] Starting subtest: invalid-get-no-zeromap
[159.592398] Subtest invalid-get-no-zeromap: SUCCESS (0.002s)
[159.688877] [020/134] (861s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[159.766273] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[159.770665] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[160.878185] [021/134] (860s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[160.980763] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[168.312634] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.445s)
[168.458424] [022/134] (853s left) kms_chamelium_frames (hdmi-frame-dump)
[168.846924] Subtest hdmi-frame-dump: SKIP (0.000s)
[169.683435] [023/134] (852s left) i915_pciid
[169.865320] [024/134] (851s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[169.986280] Starting subtest: verify-pxp-stale-buf-optout-execution
[171.047134] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.069s)
[171.181923] [025/134] (850s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[171.283411] Starting subtest: fbc-pr-cursor-mmap-gtt
[171.287847] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.001s)
[171.354353] [026/134] (850s left) kms_psr (psr-sprite-blt)
[171.458771] Starting subtest: psr-sprite-blt
[171.461149] Starting dynamic subtest: eDP-1
[173.191053] Dynamic subtest eDP-1: SUCCESS (1.741s)
[173.193085] Subtest psr-sprite-blt: SUCCESS (1.742s)
[174.056132] [027/134] (847s left) gem_ctx_exec (basic-invalid-context)
[174.109930] Starting subtest: basic-invalid-context
[174.115178] Subtest basic-invalid-context: SUCCESS (0.006s)
[174.227872] [028/134] (847s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[174.316862] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[178.318985] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.019s)
[179.460426] [029/134] (842s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[179.556656] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[179.561334] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[179.650700] [030/134] (842s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[179.746960] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[180.755592] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.012s)
[180.881085] [031/134] (841s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[180.979760] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[185.473157] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.503s)
[186.657322] [032/134] (835s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[186.754055] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[186.758398] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[186.871688] [033/134] (835s left) kms_psr (pr-suspend)
[186.963417] Starting subtest: pr-suspend
[186.967865] Subtest pr-suspend: SKIP (0.000s)
[187.036724] [034/134] (835s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[187.167884] Starting subtest: basic-flip-before-cursor-atomic
[188.090945] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.921s)
[188.899483] [035/134] (833s left) gem_flink_basic (flink-lifetime)
[188.954959] Starting subtest: flink-lifetime
[188.957344] Subtest flink-lifetime: SUCCESS (0.002s)
[189.070415] [036/134] (833s left) gem_exec_reloc (basic-gtt-wc-active)
[189.124660] Subtest basic-gtt-wc-active: SKIP (0.000s)
[189.203762] [037/134] (833s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[189.298019] Starting subtest: 4-tiled-8bpp-rotate-0
[190.523162] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.224s)
[190.646644] [038/134] (831s left) kms_rotation_crc (exhaust-fences)
[190.740032] Starting subtest: exhaust-fences
[190.743653] Subtest exhaust-fences: SKIP (0.000s)
[190.840396] [039/134] (831s left) kms_flip (dpms-vs-vblank-race-interruptible)
[190.941864] Starting subtest: dpms-vs-vblank-race-interruptible
[190.943681] Starting dynamic subtest: A-eDP1
[195.898078] Dynamic subtest A-eDP1: SUCCESS (4.946s)
[195.907615] Starting dynamic subtest: B-eDP1
[200.508434] Dynamic subtest B-eDP1: SUCCESS (4.608s)
[200.519164] Starting dynamic subtest: C-eDP1
[204.023667] Dynamic subtest C-eDP1: SUCCESS (3.512s)
[204.033417] Starting dynamic subtest: D-eDP1
[208.626962] Dynamic subtest D-eDP1: SUCCESS (4.600s)
[208.629397] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (17.676s)
[209.504636] [040/134] (812s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[209.892900] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[210.711911] [041/134] (811s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[210.805263] Starting subtest: fbc-psr-cursor-mmap-gtt
[210.807692] Starting dynamic subtest: eDP-1
[210.811977] Dynamic subtest eDP-1: SKIP (0.000s)
[210.816268] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[210.891014] [042/134] (811s left) gem_tiled_swapping (non-threaded)
[210.947651] Subtest non-threaded: SKIP (0.000s)
[211.009924] [043/134] (811s left) kms_color (legacy-gamma-reset)
[211.093828] Starting subtest: legacy-gamma-reset
[211.095757] Starting dynamic subtest: pipe-A-eDP-1
[211.468756] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.377s)
[211.478191] Starting dynamic subtest: pipe-B-eDP-1
[211.480159] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s)
[211.489266] Starting dynamic subtest: pipe-C-eDP-1
[211.491810] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[211.500495] Starting dynamic subtest: pipe-D-eDP-1
[211.502440] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[211.504831] Subtest legacy-gamma-reset: SUCCESS (0.412s)
[212.261147] [044/134] (810s left) gem_mmap_offset (isolation)
[212.310045] Starting subtest: isolation
[212.327307] Subtest isolation: SUCCESS (0.010s)
[212.432552] [045/134] (810s left) gem_exec_balancer (individual)
[212.490223] Starting subtest: individual
[214.154979] Subtest individual: SUCCESS (1.662s)
[214.492245] [046/134] (808s left) kms_universal_plane (universal-plane-sanity)
[214.592763] Starting subtest: universal-plane-sanity
[214.594948] Starting dynamic subtest: pipe-A-eDP-1
[215.181129] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.587s)
[215.192243] Starting dynamic subtest: pipe-B-eDP-1
[216.363022] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.180s)
[216.373013] Starting dynamic subtest: pipe-C-eDP-1
[217.579885] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.216s)
[217.591850] Starting dynamic subtest: pipe-D-eDP-1
[218.811789] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.232s)
[218.814263] Subtest universal-plane-sanity: SUCCESS (4.221s)
[219.685191] [047/134] (803s left) gem_ctx_param (invalid-ctx-set)
[219.737456] Starting subtest: invalid-ctx-set
[219.739979] Subtest invalid-ctx-set: SUCCESS (0.001s)
[219.847125] [048/134] (802s left) gem_render_linear_blits (basic)
[219.907052] Starting subtest: basic
[219.939176] Subtest basic: SUCCESS (0.033s)
[220.030034] [049/134] (802s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[220.153847] Starting subtest: cursorB-vs-flipB-toggle
[220.158281] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[220.301218] [050/134] (802s left) perf_pmu (busy-start)
[220.337443] Starting subtest: busy-start
[220.339489] Starting dynamic subtest: rcs0
[222.887146] Dynamic subtest rcs0: SUCCESS (2.551s)
[222.899097] Starting dynamic subtest: bcs0
[225.456157] Dynamic subtest bcs0: SUCCESS (2.546s)
[225.467865] Starting dynamic subtest: vcs0
[229.131954] Dynamic subtest vcs0: SUCCESS (3.694s)
[229.144513] Starting dynamic subtest: vcs1
[233.164664] Dynamic subtest vcs1: SUCCESS (4.030s)
[233.177237] Starting dynamic subtest: vecs0
[237.132720] Dynamic subtest vecs0: SUCCESS (3.967s)
[237.144662] Starting dynamic subtest: ccs0
[239.704083] Dynamic subtest ccs0: SUCCESS (2.550s)
[239.706083] Subtest busy-start: SUCCESS (19.351s)
[239.788397] [051/134] (783s left) gem_ctx_shared (exec-shared-gtt)
[239.843097] Starting subtest: exec-shared-gtt
[239.845292] Starting dynamic subtest: rcs0
[239.859449] Dynamic subtest rcs0: SUCCESS (0.016s)
[239.870718] Starting dynamic subtest: bcs0
[239.873049] Dynamic subtest bcs0: SUCCESS (0.011s)
[239.883180] Starting dynamic subtest: vcs0
[239.885488] Dynamic subtest vcs0: SUCCESS (0.009s)
[239.895003] Starting dynamic subtest: vcs1
[239.897409] Dynamic subtest vcs1: SUCCESS (0.007s)
[239.907479] Starting dynamic subtest: vecs0
[239.909891] Dynamic subtest vecs0: SUCCESS (0.007s)
[239.918899] Starting dynamic subtest: ccs0
[239.920829] Dynamic subtest ccs0: SUCCESS (0.011s)
[239.922709] Subtest exec-shared-gtt: SUCCESS (0.065s)
[240.096589] [052/134] (782s left) gem_userptr_blits (create-destroy-unsync)
[240.160597] Subtest create-destroy-unsync: SKIP (0.000s)
[240.287118] [053/134] (782s left) syncobj_timeline (wait-all-for-submit-snapshot)
[240.341735] Starting subtest: wait-all-for-submit-snapshot
[240.424019] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[240.503341] [054/134] (782s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[240.609712] Starting subtest: bad-aux-stride-yf-tiled-ccs
[240.612015] Starting dynamic subtest: pipe-A-eDP-1
[240.636062] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[240.647422] Starting dynamic subtest: pipe-B-eDP-1
[240.667251] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[240.676133] Starting dynamic subtest: pipe-C-eDP-1
[240.693773] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[240.702749] Starting dynamic subtest: pipe-D-eDP-1
[240.720876] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[240.724327] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.004s)
[242.846227] [055/134] (780s left) kms_cursor_crc (cursor-onscreen-128x128)
[243.047482] Starting subtest: cursor-onscreen-128x128
[243.052277] Starting dynamic subtest: pipe-A-eDP-1
[245.141841] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.087s)
[245.171256] Starting dynamic subtest: pipe-D-eDP-1
[247.942977] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.778s)
[247.945283] Subtest cursor-onscreen-128x128: SUCCESS (4.893s)
[248.790351] [056/134] (774s left) syncobj_timeline (single-wait-all-signaled)
[248.844006] Starting subtest: single-wait-all-signaled
[248.846151] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[248.941107] [057/134] (774s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[249.040973] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[249.045495] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[249.114219] [058/134] (774s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[249.211446] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[249.213753] Starting dynamic subtest: pipe-A
[249.232768] Dynamic subtest pipe-A: SKIP (0.018s)
[249.242876] Starting dynamic subtest: pipe-B
[249.265154] Dynamic subtest pipe-B: SKIP (0.031s)
[249.275142] Starting dynamic subtest: pipe-C
[249.295864] Dynamic subtest pipe-C: SKIP (0.031s)
[249.305514] Starting dynamic subtest: pipe-D
[249.327634] Dynamic subtest pipe-D: SKIP (0.031s)
[249.331702] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.113s)
[249.433018] [059/134] (773s left) gem_exec_parallel (fds)
[249.485367] Starting subtest: fds
[249.487802] Starting dynamic subtest: rcs0
[251.791271] Dynamic subtest rcs0: SUCCESS (2.306s)
[251.804757] Starting dynamic subtest: bcs0
[254.992122] Dynamic subtest bcs0: SUCCESS (3.196s)
[255.003932] Starting dynamic subtest: vcs0
[259.331188] Dynamic subtest vcs0: SUCCESS (4.337s)
[259.341516] Starting dynamic subtest: vcs1
[263.416124] Dynamic subtest vcs1: SUCCESS (4.083s)
[263.427639] Starting dynamic subtest: vecs0
[267.357057] Dynamic subtest vecs0: SUCCESS (3.937s)
[267.367199] Starting dynamic subtest: ccs0
[270.853431] Dynamic subtest ccs0: SUCCESS (3.493s)
[270.857612] Subtest fds: SUCCESS (21.365s)
[271.052996] [060/134] (752s left) kms_lease (atomic-implicit-crtc)
[271.153670] Starting subtest: atomic-implicit-crtc
[271.155794] Starting dynamic subtest: pipe-A-eDP-1
[271.166900] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[271.177692] Starting dynamic subtest: pipe-B-eDP-1
[271.188958] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[271.199144] Starting dynamic subtest: pipe-C-eDP-1
[271.209833] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[271.219615] Starting dynamic subtest: pipe-D-eDP-1
[271.230111] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[271.232018] Subtest atomic-implicit-crtc: SUCCESS (0.036s)
[271.309961] [061/134] (752s left) gem_busy (parallel)
[271.482178] Starting subtest: parallel
[271.484207] Starting dynamic subtest: rcs0
[273.164772] Dynamic subtest rcs0: SUCCESS (1.681s)
[273.178946] Starting dynamic subtest: bcs0
[275.149648] Dynamic subtest bcs0: SUCCESS (1.982s)
[275.163547] Starting dynamic subtest: vcs0
[277.134194] Dynamic subtest vcs0: SUCCESS (1.982s)
[277.147010] Starting dynamic subtest: vcs1
[279.234322] Dynamic subtest vcs1: SUCCESS (2.045s)
[279.246826] Starting dynamic subtest: vecs0
[281.164145] Dynamic subtest vecs0: SUCCESS (1.981s)
[281.183157] Starting dynamic subtest: ccs0
[283.149069] Dynamic subtest ccs0: SUCCESS (1.982s)
[283.152183] Subtest parallel: SUCCESS (11.666s)
[283.393986] [062/134] (739s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[283.492575] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[283.494879] Starting dynamic subtest: pipe-A
[283.829941] Dynamic subtest pipe-A: SUCCESS (0.339s)
[283.840769] Starting dynamic subtest: pipe-B
[285.276654] Dynamic subtest pipe-B: SUCCESS (1.445s)
[285.287940] Starting dynamic subtest: pipe-C
[286.706892] Dynamic subtest pipe-C: SUCCESS (1.430s)
[286.718165] Starting dynamic subtest: pipe-D
[288.138791] Dynamic subtest pipe-D: SUCCESS (1.431s)
[288.141153] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.649s)
[289.327543] [063/134] (734s left) kms_psr (fbc-psr-cursor-plane-move)
[289.420341] Starting subtest: fbc-psr-cursor-plane-move
[289.422713] Starting dynamic subtest: eDP-1
[289.427306] Dynamic subtest eDP-1: SKIP (0.000s)
[289.432032] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[289.506449] [064/134] (733s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[289.597619] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[289.601697] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[289.701339] [065/134] (733s left) gem_mmap_wc (write-prefaulted)
[289.754655] Subtest write-prefaulted: SKIP (0.000s)
[289.811500] [066/134] (733s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[289.911378] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[289.915535] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[290.001102] [067/134] (733s left) gem_exec_reloc (basic-gtt-cpu)
[290.053206] Subtest basic-gtt-cpu: SKIP (0.000s)
[290.122330] [068/134] (733s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[290.224229] Starting subtest: stress-xrgb8888-ytiled
[290.228699] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[290.297980] [069/134] (733s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[290.863831] Starting subtest: syncobj-timeline-invalid-wait
[290.868598] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s)
[292.270061] [070/134] (731s left) kms_prime (basic-crc-vgem)
[292.358243] Starting subtest: basic-crc-vgem
[292.360622] Starting dynamic subtest: second-to-first
[293.321006] Dynamic subtest second-to-first: SUCCESS (0.967s)
[293.322958] Subtest basic-crc-vgem: SUCCESS (0.968s)
[293.439295] [071/134] (730s left) api_intel_allocator (reserve-simple)
[293.514301] Starting subtest: reserve-simple
[293.516422] Subtest reserve-simple: SUCCESS (0.004s)
[293.647410] [072/134] (730s left) kms_flip (plain-flip-fb-recreate)
[293.743110] Starting subtest: plain-flip-fb-recreate
[293.745203] Starting dynamic subtest: A-eDP1
[302.619692] Dynamic subtest A-eDP1: SUCCESS (8.878s)
[302.629908] Starting dynamic subtest: B-eDP1
[311.476621] Dynamic subtest B-eDP1: SUCCESS (8.856s)
[311.489337] Starting dynamic subtest: C-eDP1
[320.297310] Dynamic subtest C-eDP1: SUCCESS (8.821s)
[320.309996] Starting dynamic subtest: D-eDP1
[329.133926] Dynamic subtest D-eDP1: SUCCESS (8.836s)
[329.136017] Subtest plain-flip-fb-recreate: SUCCESS (35.399s)
[330.305882] [073/134] (693s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[330.356280] Starting subtest: single-wait-all-for-submit-unsubmitted
[330.465143] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.108s)
[330.543233] [074/134] (693s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[330.641134] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[337.323537] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.686s)
[337.437119] [075/134] (686s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[337.544974] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[337.548908] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[337.652962] [076/134] (686s left) gem_exec_schedule (thriceslice)
[337.731894] Starting subtest: thriceslice
[337.733784] Starting dynamic subtest: rcs0
[337.753334] Dynamic subtest rcs0: SUCCESS (0.030s)
[337.765381] Starting dynamic subtest: bcs0
[337.782239] Dynamic subtest bcs0: SUCCESS (0.029s)
[337.792305] Starting dynamic subtest: vcs0
[337.812506] Dynamic subtest vcs0: SUCCESS (0.029s)
[337.822319] Starting dynamic subtest: vcs1
[337.841562] Dynamic subtest vcs1: SUCCESS (0.028s)
[337.851332] Starting dynamic subtest: vecs0
[337.870265] Dynamic subtest vecs0: SUCCESS (0.028s)
[337.880031] Starting dynamic subtest: ccs0
[337.900832] Dynamic subtest ccs0: SUCCESS (0.030s)
[337.903080] Subtest thriceslice: SUCCESS (0.178s)
[338.206691] [077/134] (685s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[338.301741] Starting subtest: addfb25-y-tiled-legacy
[338.303843] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[338.416189] [078/134] (685s left) gem_media_fill (media-fill)
[338.475506] Subtest media-fill: SKIP (0.000s)
[338.620379] [079/134] (685s left) gen7_exec_parse (chained-batch)
[338.691975] Subtest chained-batch: SKIP (0.000s)
[338.760438] [080/134] (685s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[338.861983] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[338.866368] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[338.972295] [081/134] (685s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[339.069762] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[339.074125] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[339.198319] [082/134] (684s left) prime_self_import (basic-with_two_bos)
[339.232482] Starting subtest: basic-with_two_bos
[339.245021] Subtest basic-with_two_bos: SUCCESS (0.015s)
[339.362805] [083/134] (684s left) dmabuf_sync_file (import-basic)
[339.405172] Starting subtest: import-basic
[339.407221] Subtest import-basic: SUCCESS (0.003s)
[339.458909] [084/134] (684s left) kms_cursor_crc (cursor-random-32x10)
[339.614298] Starting subtest: cursor-random-32x10
[339.660509] Subtest cursor-random-32x10: SKIP (0.042s)
[339.948538] [085/134] (684s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[340.075848] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[340.079667] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[340.220311] [086/134] (684s left) sysfs_timeslice_duration (duration)
[340.271852] Starting subtest: duration
[340.273776] Starting dynamic subtest: vecs0
[354.089476] Dynamic subtest vecs0: SUCCESS (13.817s)
[354.102632] Starting dynamic subtest: ccs0
[367.247271] Dynamic subtest ccs0: SUCCESS (13.142s)
[367.257338] Starting dynamic subtest: vcs0
[381.098629] Dynamic subtest vcs0: SUCCESS (13.866s)
[381.111080] Starting dynamic subtest: bcs0
[394.254499] Dynamic subtest bcs0: SUCCESS (13.148s)
[394.266009] Starting dynamic subtest: rcs0
[407.415879] Dynamic subtest rcs0: SUCCESS (13.152s)
[407.427824] Starting dynamic subtest: vcs1
[421.098953] Dynamic subtest vcs1: SUCCESS (13.679s)
[421.101462] Subtest duration: SUCCESS (80.823s)
[421.178660] [087/134] (603s left) gem_tiled_pread_pwrite
[421.291883] [088/134] (603s left) syncobj_basic (bad-destroy-pad)
[421.341824] Starting subtest: bad-destroy-pad
[421.344064] Subtest bad-destroy-pad: SUCCESS (0.000s)
[421.424224] [089/134] (603s left) kms_dsc (dsc-with-formats)
[421.512650] Starting subtest: dsc-with-formats
[421.552451] Subtest dsc-with-formats: SKIP (0.001s)
[421.592466] [090/134] (602s left) perf_pmu (init-wait)
[421.628055] Starting subtest: init-wait
[421.630314] Starting dynamic subtest: rcs0
[421.632672] Dynamic subtest rcs0: SUCCESS (0.002s)
[421.644390] Starting dynamic subtest: bcs0
[421.646313] Dynamic subtest bcs0: SUCCESS (0.000s)
[421.658208] Starting dynamic subtest: vcs0
[421.660075] Dynamic subtest vcs0: SUCCESS (0.001s)
[421.669772] Starting dynamic subtest: vcs1
[421.671645] Dynamic subtest vcs1: SUCCESS (0.001s)
[421.681469] Starting dynamic subtest: vecs0
[421.683280] Dynamic subtest vecs0: SUCCESS (0.001s)
[421.692660] Starting dynamic subtest: ccs0
[421.695417] Dynamic subtest ccs0: SUCCESS (0.000s)
[421.697708] Subtest init-wait: SUCCESS (0.008s)
[421.750559] [091/134] (602s left) kms_cursor_edge_walk (64x64-top-bottom)
[421.850693] Starting subtest: 64x64-top-bottom
[421.852835] Starting dynamic subtest: pipe-A-eDP-1
[425.289845] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.438s)
[425.302672] Starting dynamic subtest: pipe-D-eDP-1
[428.417209] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[428.419448] Subtest 64x64-top-bottom: SUCCESS (6.566s)
[429.225517] [092/134] (595s left) sw_sync (alloc_fence)
[429.263564] Starting subtest: alloc_fence
[429.265782] Subtest alloc_fence: SUCCESS (0.000s)
[429.312100] [093/134] (595s left) gem_exec_parallel (basic)
[429.375676] Starting subtest: basic
[429.378095] Starting dynamic subtest: rcs0
[430.791451] Dynamic subtest rcs0: SUCCESS (1.418s)
[430.802239] Starting dynamic subtest: bcs0
[432.300041] Dynamic subtest bcs0: SUCCESS (1.507s)
[432.311094] Starting dynamic subtest: vcs0
[434.124981] Dynamic subtest vcs0: SUCCESS (1.821s)
[434.138416] Starting dynamic subtest: vcs1
[436.107189] Dynamic subtest vcs1: SUCCESS (1.981s)
[436.118190] Starting dynamic subtest: vecs0
[438.091871] Dynamic subtest vecs0: SUCCESS (1.983s)
[438.105017] Starting dynamic subtest: ccs0
[439.598293] Dynamic subtest ccs0: SUCCESS (1.505s)
[439.600983] Subtest basic: SUCCESS (10.225s)
[439.789554] [094/134] (584s left) gem_exec_whisper (basic-fds)
[439.857279] Starting subtest: basic-fds
[449.071770] Subtest basic-fds: SUCCESS (9.211s)
[449.255515] [095/134] (575s left) gem_exec_fence (syncobj-wait)
[449.735288] Starting subtest: syncobj-wait
[451.181141] Subtest syncobj-wait: SUCCESS (1.444s)
[451.535830] [096/134] (573s left) sw_sync (alloc_timeline)
[451.578026] Starting subtest: alloc_timeline
[451.580376] Subtest alloc_timeline: SUCCESS (0.000s)
[451.645886] [097/134] (573s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[451.745781] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[451.750185] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[451.843726] [098/134] (573s left) gem_exec_params (rsvd2-dirt)
[451.910043] Starting subtest: rsvd2-dirt
[451.914751] Subtest rsvd2-dirt: SKIP (0.000s)
[452.026534] [099/134] (572s left) sw_sync (sync_multi_consumer_producer)
[452.067076] Starting subtest: sync_multi_consumer_producer
[452.360429] Subtest sync_multi_consumer_producer: SUCCESS (0.295s)
[452.421844] [100/134] (572s left) kms_legacy_colorkey (invalid-plane)
[452.514046] Starting subtest: invalid-plane
[452.516381] Starting dynamic subtest: zero-id
[452.518394] Dynamic subtest zero-id: SUCCESS (0.000s)
[452.529267] Starting dynamic subtest: outrange-id
[452.531620] Dynamic subtest outrange-id: SUCCESS (0.000s)
[452.533911] Subtest invalid-plane: SUCCESS (0.002s)
[452.584794] [101/134] (572s left) gem_exec_fence (basic-await)
[452.765454] Starting subtest: basic-await
[452.768058] Starting dynamic subtest: rcs0
[452.839719] Dynamic subtest rcs0: SUCCESS (0.074s)
[452.856628] Starting dynamic subtest: bcs0
[452.912051] Dynamic subtest bcs0: SUCCESS (0.071s)
[452.923981] Starting dynamic subtest: vcs0
[452.985692] Dynamic subtest vcs0: SUCCESS (0.071s)
[452.998930] Starting dynamic subtest: vcs1
[453.058138] Dynamic subtest vcs1: SUCCESS (0.071s)
[453.070100] Starting dynamic subtest: vecs0
[453.132138] Dynamic subtest vecs0: SUCCESS (0.072s)
[453.146196] Starting dynamic subtest: ccs0
[453.208102] Dynamic subtest ccs0: SUCCESS (0.074s)
[453.210653] Subtest basic-await: SUCCESS (0.444s)
[455.269189] [102/134] (569s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[455.371152] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[456.383731] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.012s)
[456.523140] [103/134] (568s left) gem_lmem_swapping (parallel-random-verify)
[456.569190] Subtest parallel-random-verify: SKIP (0.000s)
[456.613943] [104/134] (568s left) kms_content_protection (legacy-hdcp14)
[456.758241] Starting subtest: legacy-hdcp14
[456.761627] Subtest legacy-hdcp14: SKIP (0.000s)
[456.887169] [105/134] (568s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[456.977906] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[456.979858] Starting dynamic subtest: pipe-A-eDP-1
[457.057204] Dynamic subtest pipe-A-eDP-1: SKIP (0.079s)
[457.069616] Starting dynamic subtest: pipe-B-eDP-1
[458.184163] Dynamic subtest pipe-B-eDP-1: SKIP (1.126s)
[458.188723] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.208s)
[459.372446] [106/134] (565s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[459.468331] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[459.473153] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[459.666993] [107/134] (565s left) i915_drm_fdinfo (isolation)
[459.706766] Starting subtest: isolation
[459.709037] Starting dynamic subtest: rcs0
[459.741077] Dynamic subtest rcs0: SKIP (0.030s)
[459.754868] Starting dynamic subtest: bcs0
[459.759831] Dynamic subtest bcs0: SKIP (0.000s)
[459.769756] Starting dynamic subtest: vcs0
[459.773966] Dynamic subtest vcs0: SKIP (0.000s)
[459.784686] Starting dynamic subtest: vcs1
[459.788866] Dynamic subtest vcs1: SKIP (0.000s)
[459.798633] Starting dynamic subtest: vecs0
[459.802816] Dynamic subtest vecs0: SKIP (0.000s)
[459.812549] Starting dynamic subtest: ccs0
[459.816861] Dynamic subtest ccs0: SKIP (0.000s)
[459.821185] Subtest isolation: SKIP (0.036s)
[459.860754] [108/134] (565s left) syncobj_wait (wait-for-submit-delayed-submit)
[459.915220] Starting subtest: wait-for-submit-delayed-submit
[460.016491] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[460.091170] [109/134] (565s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[460.205938] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[460.208109] Starting dynamic subtest: pipe-A-default-mode
[461.338070] Dynamic subtest pipe-A-default-mode: SKIP (1.129s)
[461.342547] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.130s)
[461.486900] [110/134] (563s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[461.588218] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[466.922678] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.338s)
[468.104524] [111/134] (557s left) kms_invalid_mode (bad-hsync-start)
[468.208004] Starting subtest: bad-hsync-start
[468.210284] Starting dynamic subtest: pipe-A-eDP-1
[468.492288] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[468.502693] Starting dynamic subtest: pipe-B-eDP-1
[468.504544] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[468.514335] Starting dynamic subtest: pipe-C-eDP-1
[468.516514] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[468.526280] Starting dynamic subtest: pipe-D-eDP-1
[468.528517] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[468.530682] Subtest bad-hsync-start: SUCCESS (0.290s)
[469.330069] [112/134] (556s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[469.423188] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[473.134921] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.717s)
[474.331542] [113/134] (551s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[474.440888] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[474.444870] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[474.541972] [114/134] (550s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[474.643348] Starting subtest: pr-primary-plane-update-sf-dmg-area
[474.647338] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[474.727646] [115/134] (550s left) gem_madvise (dontneed-before-exec)
[474.758302] Starting subtest: dontneed-before-exec
[474.790649] Subtest dontneed-before-exec: SKIP (0.028s)
[474.854488] [116/134] (550s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[474.946681] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[474.949041] Starting dynamic subtest: pipe-A-eDP-1
[475.008315] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[475.021173] Starting dynamic subtest: pipe-B-eDP-1
[475.079448] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[475.091321] Starting dynamic subtest: pipe-C-eDP-1
[475.150275] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[475.164037] Starting dynamic subtest: pipe-D-eDP-1
[475.222209] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[475.226646] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[477.193301] [117/134] (548s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[477.256265] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[477.360282] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.104s)
[477.436875] [118/134] (548s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[477.521790] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[477.526362] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[478.653536] [119/134] (547s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[478.779041] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[478.783637] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[478.935608] [120/134] (546s left) prime_vgem (wait)
[478.996617] Starting subtest: wait
[478.998871] Starting dynamic subtest: rcs0
[479.043314] Dynamic subtest rcs0: SUCCESS (0.049s)
[479.054028] Starting dynamic subtest: bcs0
[479.095609] Dynamic subtest bcs0: SUCCESS (0.051s)
[479.106372] Starting dynamic subtest: vcs0
[479.143734] Dynamic subtest vcs0: SUCCESS (0.047s)
[479.154504] Starting dynamic subtest: vcs1
[479.187839] Dynamic subtest vcs1: SUCCESS (0.043s)
[479.198466] Starting dynamic subtest: vecs0
[479.234839] Dynamic subtest vecs0: SUCCESS (0.046s)
[479.245567] Starting dynamic subtest: ccs0
[479.281966] Dynamic subtest ccs0: SUCCESS (0.046s)
[479.284217] Subtest wait: SUCCESS (0.289s)
[479.414752] [121/134] (546s left) gem_ctx_persistence (legacy-engines-hang)
[479.469343] Starting subtest: legacy-engines-hang
[479.471696] Starting dynamic subtest: render
[479.565694] Dynamic subtest render: SUCCESS (0.096s)
[479.579985] Starting dynamic subtest: bsd1
[479.660048] Dynamic subtest bsd1: SUCCESS (0.091s)
[479.674807] Starting dynamic subtest: bsd2
[479.748916] Dynamic subtest bsd2: SUCCESS (0.086s)
[479.764017] Starting dynamic subtest: blt
[479.861755] Dynamic subtest blt: SUCCESS (0.110s)
[479.876691] Starting dynamic subtest: vebox
[479.966235] Dynamic subtest vebox: SUCCESS (0.102s)
[479.968447] Subtest legacy-engines-hang: SUCCESS (0.499s)
[480.044801] [122/134] (545s left) template (a)
[480.105312] Starting subtest: A
[480.107356] Subtest A: SUCCESS (0.000s)
[480.206349] [123/134] (545s left) kms_atomic (plane-invalid-params-fence)
[480.316102] Starting subtest: plane-invalid-params-fence
[480.317689] Starting dynamic subtest: pipe-A-eDP-1
[480.687416] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.372s)
[480.689822] Subtest plane-invalid-params-fence: SUCCESS (0.373s)
[481.478031] [124/134] (544s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[481.569749] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[481.574160] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[481.646211] [125/134] (544s left) kms_pm_rpm (cursor)
[483.274187] Starting subtest: cursor
[483.278876] Subtest cursor: SKIP (0.000s)
[483.935755] [126/134] (542s left) gem_caching (writes)
[483.993284] Subtest writes: SKIP (0.000s)
[484.076525] [127/134] (541s left) api_intel_bb (intel-bb-blit-none)
[484.126870] Starting subtest: intel-bb-blit-none
[488.132255] Subtest intel-bb-blit-none: SUCCESS (4.006s)
[488.251825] [128/134] (537s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[488.369390] Starting subtest: cursor-vs-flip-legacy
[518.062542] Subtest cursor-vs-flip-legacy: SUCCESS (29.694s)
[518.937257] [129/134] (507s left) i915_pm_rpm (gem-execbuf-stress)
[520.465907] Starting subtest: gem-execbuf-stress
[520.468232] Starting dynamic subtest: smem0
[533.421358] Dynamic subtest smem0: SUCCESS (12.959s)
[533.433613] Starting dynamic subtest: extra-wait-smem0
[595.078407] Dynamic subtest extra-wait-smem0: SUCCESS (61.659s)
[595.081485] Subtest gem-execbuf-stress: SUCCESS (74.625s)
[595.476343] [130/134] (430s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[595.526391] Starting subtest: etime-single-wait-for-submit-unsubmitted
[595.631792] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[595.737095] [131/134] (430s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[595.789207] Starting subtest: multi-wait-all-for-submit-signaled
[595.791401] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[595.904609] [132/134] (430s left) gem_spin_batch (engines)
[595.966951] Starting subtest: engines
[595.969303] Starting dynamic subtest: rcs0
[599.209624] Dynamic subtest rcs0: SUCCESS (3.237s)
[599.221996] Starting dynamic subtest: bcs0
[602.509850] Dynamic subtest bcs0: SUCCESS (3.235s)
[602.523194] Starting dynamic subtest: vcs0
[605.736208] Dynamic subtest vcs0: SUCCESS (3.234s)
[605.752037] Starting dynamic subtest: vcs1
[608.968524] Dynamic subtest vcs1: SUCCESS (3.232s)
[608.981002] Starting dynamic subtest: vecs0
[612.209636] Dynamic subtest vecs0: SUCCESS (3.237s)
[612.222986] Starting dynamic subtest: ccs0
[615.447512] Dynamic subtest ccs0: SUCCESS (3.235s)
[615.449925] Subtest engines: SUCCESS (19.429s)
[615.624581] [133/134] (410s left) kms_vblank (wait-forked-busy)
[615.729311] Starting subtest: wait-forked-busy
[615.731178] Starting dynamic subtest: pipe-A-eDP-1
[617.605220] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.876s)
[617.622092] Starting dynamic subtest: pipe-D-eDP-1
[620.216595] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.609s)
[620.219086] Subtest wait-forked-busy: SUCCESS (4.489s)
[621.015070] [134/134] (405s left) kms_flip (flip-vs-suspend)
[621.103877] Starting subtest: flip-vs-suspend
[621.106097] Starting dynamic subtest: A-eDP1
[782.875285] Dynamic subtest A-eDP1: SUCCESS (12.246s)
[782.877529] Subtest flip-vs-suspend: SUCCESS (12.249s)
[783.019141] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_schedule
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: kms_selftest
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: kms_plane
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: i915_query
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_rotation_crc
results: parsing output: 9/ for test: kms_flip
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: gem_vm_create
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: kms_addfb_basic
results: parsing output: 15/ for test: kms_setmode
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gem_ctx_param
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_chamelium_frames
results: parsing output: 22/ for test: i915_pciid
results: parsing output: 23/ for test: gem_pxp
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: gem_ctx_exec
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: kms_cursor_legacy
results: parsing output: 34/ for test: gem_flink_basic
results: parsing output: 35/ for test: gem_exec_reloc
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: kms_rotation_crc
results: parsing output: 38/ for test: kms_flip
results: parsing output: 39/ for test: kms_chamelium_hpd
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: gem_tiled_swapping
results: parsing output: 42/ for test: kms_color
results: parsing output: 43/ for test: gem_mmap_offset
results: parsing output: 44/ for test: gem_exec_balancer
results: parsing output: 45/ for test: kms_universal_plane
results: parsing output: 46/ for test: gem_ctx_param
results: parsing output: 47/ for test: gem_render_linear_blits
results: parsing output: 48/ for test: kms_cursor_legacy
results: parsing output: 49/ for test: perf_pmu
results: parsing output: 50/ for test: gem_ctx_shared
results: parsing output: 51/ for test: gem_userptr_blits
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: kms_cursor_crc
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: kms_plane
results: parsing output: 57/ for test: kms_plane_scaling
results: parsing output: 58/ for test: gem_exec_parallel
results: parsing output: 59/ for test: kms_lease
results: parsing output: 60/ for test: gem_busy
results: parsing output: 61/ for test: kms_plane_scaling
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_mmap_wc
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_exec_reloc
results: parsing output: 67/ for test: kms_pipe_stress
results: parsing output: 68/ for test: gem_exec_fence
results: parsing output: 69/ for test: kms_prime
results: parsing output: 70/ for test: api_intel_allocator
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: syncobj_wait
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_exec_schedule
results: parsing output: 76/ for test: kms_addfb_basic
results: parsing output: 77/ for test: gem_media_fill
results: parsing output: 78/ for test: gen7_exec_parse
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: prime_self_import
results: parsing output: 82/ for test: dmabuf_sync_file
results: parsing output: 83/ for test: kms_cursor_crc
results: parsing output: 84/ for test: kms_cursor_legacy
results: parsing output: 85/ for test: sysfs_timeslice_duration
results: parsing output: 86/ for test: gem_tiled_pread_pwrite
results: parsing output: 87/ for test: syncobj_basic
results: parsing output: 88/ for test: kms_dsc
results: parsing output: 89/ for test: perf_pmu
results: parsing output: 90/ for test: kms_cursor_edge_walk
results: parsing output: 91/ for test: sw_sync
results: parsing output: 92/ for test: gem_exec_parallel
results: parsing output: 93/ for test: gem_exec_whisper
results: parsing output: 94/ for test: gem_exec_fence
results: parsing output: 95/ for test: sw_sync
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: gem_exec_params
results: parsing output: 98/ for test: sw_sync
results: parsing output: 99/ for test: kms_legacy_colorkey
results: parsing output: 100/ for test: gem_exec_fence
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: gem_lmem_swapping
results: parsing output: 103/ for test: kms_content_protection
results: parsing output: 104/ for test: kms_psr2_sf
results: parsing output: 105/ for test: gem_render_copy
results: parsing output: 106/ for test: i915_drm_fdinfo
results: parsing output: 107/ for test: syncobj_wait
results: parsing output: 108/ for test: kms_flip_scaled_crc
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_invalid_mode
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_psr2_sf
results: parsing output: 114/ for test: gem_madvise
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: kms_cursor_legacy
results: parsing output: 119/ for test: prime_vgem
results: parsing output: 120/ for test: gem_ctx_persistence
results: parsing output: 121/ for test: template
results: parsing output: 122/ for test: kms_atomic
results: parsing output: 123/ for test: kms_flip_scaled_crc
results: parsing output: 124/ for test: kms_pm_rpm
results: parsing output: 125/ for test: gem_caching
results: parsing output: 126/ for test: api_intel_bb
results: parsing output: 127/ for test: kms_cursor_legacy
results: parsing output: 128/ for test: i915_pm_rpm
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: syncobj_wait
results: parsing output: 131/ for test: gem_spin_batch
results: parsing output: 132/ for test: kms_vblank
results: parsing output: 133/ for test: kms_flip
Done.