[59.708269] Initializing watchdogs
[59.708314]   /dev/watchdog0
[59.721615] [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]
[59.725722] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.727981] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.731381] [001/133] (960s left) gem_mmap_offset (partial-unmap)
[59.812901] Starting subtest: partial-unmap
[59.815228] Starting dynamic subtest: smem0
[60.280133] Dynamic subtest smem0: SUCCESS (0.467s)
[60.283261] Subtest partial-unmap: SUCCESS (0.468s)
[60.408332] [002/133] (959s left) kms_cursor_crc (cursor-dpms)
[60.546300] Starting subtest: cursor-dpms
[60.548454] Starting dynamic subtest: pipe-A-eDP-1
[63.606820] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.057s)
[63.615034] Starting dynamic subtest: pipe-D-eDP-1
[67.217181] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.611s)
[67.219544] Subtest cursor-dpms: SUCCESS (6.671s)
[68.062518] [003/133] (952s left) dmabuf_sync_file (export-wait-after-attach)
[68.129296] Starting subtest: export-wait-after-attach
[68.131481] Subtest export-wait-after-attach: SUCCESS (0.001s)
[68.184918] [FACT dmabuf_sync_file (export-wait-after-attach)] new: kernel.kmod_is_loaded.vgem: true
[68.187801] [004/133] (952s left) kms_color_pipeline (plane-lut1d-lut1d)
[68.288237] Starting subtest: plane-lut1d-lut1d
[68.412786] Starting dynamic subtest: pipe-A-plane-0
[68.780253] Dynamic subtest pipe-A-plane-0: FAIL (0.197s)
[68.787442] Starting dynamic subtest: pipe-A-plane-1
[69.004414] Dynamic subtest pipe-A-plane-1: FAIL (0.167s)
[69.010728] Starting dynamic subtest: pipe-A-plane-2
[69.218656] Dynamic subtest pipe-A-plane-2: FAIL (0.187s)
[70.134991] Starting dynamic subtest: pipe-B-plane-0
[70.551746] Dynamic subtest pipe-B-plane-0: FAIL (0.152s)
[70.559999] Starting dynamic subtest: pipe-B-plane-1
[70.876770] Dynamic subtest pipe-B-plane-1: FAIL (0.167s)
[70.885380] Starting dynamic subtest: pipe-B-plane-2
[71.197134] Dynamic subtest pipe-B-plane-2: FAIL (0.166s)
[71.881723] Starting dynamic subtest: pipe-C-plane-0
[72.361335] Dynamic subtest pipe-C-plane-0: FAIL (0.129s)
[72.370056] Starting dynamic subtest: pipe-C-plane-1
[72.770345] Dynamic subtest pipe-C-plane-1: FAIL (0.166s)
[72.778699] Starting dynamic subtest: pipe-C-plane-2
[73.136243] Dynamic subtest pipe-C-plane-2: FAIL (0.618s)
[73.991302] Starting dynamic subtest: pipe-D-plane-0
[74.596364] Dynamic subtest pipe-D-plane-0: FAIL (0.140s)
[74.604682] Starting dynamic subtest: pipe-D-plane-1
[75.069658] Dynamic subtest pipe-D-plane-1: FAIL (0.611s)
[75.078183] Starting dynamic subtest: pipe-D-plane-2
[75.499213] Dynamic subtest pipe-D-plane-2: FAIL (0.540s)
[75.577455] Subtest plane-lut1d-lut1d: FAIL (7.291s)
[76.380177] [005/133] (944s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[76.477189] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[76.479526] Starting dynamic subtest: pipe-A
[76.541792] Dynamic subtest pipe-A: SUCCESS (0.064s)
[76.550786] Starting dynamic subtest: pipe-B
[77.701279] Dynamic subtest pipe-B: SUCCESS (1.159s)
[77.709252] Starting dynamic subtest: pipe-C
[78.813576] Dynamic subtest pipe-C: SUCCESS (1.111s)
[78.822269] Starting dynamic subtest: pipe-D
[79.959077] Dynamic subtest pipe-D: SUCCESS (1.145s)
[79.961357] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.482s)
[81.111148] [006/133] (939s left) syncobj_wait (wait-delayed-signal)
[81.170127] Starting subtest: wait-delayed-signal
[81.272477] Subtest wait-delayed-signal: SUCCESS (0.103s)
[81.348247] [007/133] (939s left) kms_chamelium_hpd (dp-hpd-storm)
[81.743674] Subtest dp-hpd-storm: SKIP (0.000s)
[82.520383] [008/133] (937s left) gem_exec_flush (basic-uc-set-default)
[82.589165] Starting subtest: basic-uc-set-default
[88.039906] Subtest basic-uc-set-default: SUCCESS (5.453s)
[88.237259] [009/133] (932s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[88.347664] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[92.358744] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.016s)
[93.563692] [010/133] (927s left) i915_pm_rc6_residency (rc6-fence)
[93.620054] Starting subtest: rc6-fence
[93.638783] Starting dynamic subtest: gt0
[106.839427] Dynamic subtest gt0: SUCCESS (13.201s)
[106.850407] Starting dynamic subtest: gt1
[121.877382] Dynamic subtest gt1: SUCCESS (15.035s)
[121.880077] Subtest rc6-fence: SUCCESS (28.259s)
[121.964255] [011/133] (898s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[122.064816] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[122.068979] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[122.163826] [012/133] (898s left) kms_rotation_crc (bad-tiling)
[122.256144] Starting subtest: bad-tiling
[122.260320] Subtest bad-tiling: SKIP (0.001s)
[122.332878] [013/133] (898s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[122.432949] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[130.191162] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.760s)
[130.290452] [014/133] (890s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[130.395727] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[130.400301] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[130.500525] [015/133] (890s left) gem_ctx_persistence (process)
[130.574802] Starting subtest: process
[130.758875] Subtest process: SUCCESS (0.184s)
[130.838839] [016/133] (889s left) perf (low-oa-exponent-permissions)
[130.956154] Starting subtest: low-oa-exponent-permissions
[130.986240] Subtest low-oa-exponent-permissions: SUCCESS (0.032s)
[131.027202] [017/133] (889s left) gem_ctx_param (invalid-get-ringsize)
[131.082702] Starting subtest: invalid-get-ringsize
[131.085091] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[131.185702] [018/133] (889s left) kms_lease (page-flip-implicit-plane)
[131.301505] Starting subtest: page-flip-implicit-plane
[131.303506] Starting dynamic subtest: pipe-A-eDP-1
[131.820606] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.518s)
[131.829060] Starting dynamic subtest: pipe-B-eDP-1
[132.989267] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.167s)
[132.997705] Starting dynamic subtest: pipe-C-eDP-1
[134.120072] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.128s)
[134.128747] Starting dynamic subtest: pipe-D-eDP-1
[135.237068] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.115s)
[135.239353] Subtest page-flip-implicit-plane: SUCCESS (3.934s)
[136.078205] [019/133] (884s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[136.195657] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[136.199891] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[136.301170] [020/133] (884s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[136.394116] Starting subtest: x-tiled-8bpp-rotate-90
[136.417872] Subtest x-tiled-8bpp-rotate-90: SKIP (0.020s)
[136.556343] [021/133] (884s left) gem_exec_schedule (u-submit-late-slice)
[136.630873] Starting subtest: u-submit-late-slice
[136.633256] Starting dynamic subtest: rcs0
[136.662950] Dynamic subtest rcs0: SUCCESS (0.041s)
[136.675167] Starting dynamic subtest: bcs0
[136.695901] Dynamic subtest bcs0: SUCCESS (0.032s)
[136.707458] Starting dynamic subtest: vcs0
[136.724296] Dynamic subtest vcs0: SUCCESS (0.029s)
[136.734969] Starting dynamic subtest: vcs1
[136.757027] Dynamic subtest vcs1: SUCCESS (0.032s)
[136.764587] Starting dynamic subtest: vecs0
[136.784406] Dynamic subtest vecs0: SUCCESS (0.027s)
[136.792305] Starting dynamic subtest: ccs0
[136.813527] Dynamic subtest ccs0: SUCCESS (0.029s)
[136.815797] Subtest u-submit-late-slice: SUCCESS (0.192s)
[138.021477] [022/133] (883s left) gem_pxp (create-protected-buffer)
[138.155528] Starting subtest: create-protected-buffer
[138.157836] Subtest create-protected-buffer: SUCCESS (0.000s)
[138.272012] [023/133] (882s left) gem_exec_balancer (noheartbeat)
[138.532255] Starting subtest: noheartbeat
[138.536942] Subtest noheartbeat: SKIP (0.000s)
[138.659245] [024/133] (882s left) kms_plane_multiple (2x-tiling-yf)
[138.755622] Starting subtest: 2x-tiling-yf
[138.760134] Subtest 2x-tiling-yf: SKIP (0.000s)
[138.872781] [025/133] (882s left) kms_psr (fbc-psr-cursor-plane-onoff)
[138.980453] Starting subtest: fbc-psr-cursor-plane-onoff
[138.982565] Starting dynamic subtest: eDP-1
[138.986719] Dynamic subtest eDP-1: SKIP (0.000s)
[138.990846] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[139.050843] [026/133] (882s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[139.106252] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[139.110539] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[139.288327] [027/133] (882s left) kms_plane (pixel-format-x-tiled-modifier)
[139.377309] Starting subtest: pixel-format-x-tiled-modifier
[139.403020] Starting dynamic subtest: pipe-A-plane-0
[140.047918] Dynamic subtest pipe-A-plane-0: SUCCESS (0.644s)
[140.062471] Starting dynamic subtest: pipe-A-plane-3
[140.447262] Dynamic subtest pipe-A-plane-3: SUCCESS (0.398s)
[140.457450] Starting dynamic subtest: pipe-A-plane-5
[140.461366] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[141.561725] Starting dynamic subtest: pipe-B-plane-0
[142.165406] Dynamic subtest pipe-B-plane-0: SUCCESS (0.611s)
[142.173607] Starting dynamic subtest: pipe-B-plane-3
[142.553932] Dynamic subtest pipe-B-plane-3: SUCCESS (0.388s)
[142.561319] Starting dynamic subtest: pipe-B-plane-5
[142.564738] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[142.870496] Subtest pixel-format-x-tiled-modifier: SUCCESS (3.495s)
[143.746738] [028/133] (877s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[143.858499] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[151.320192] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.464s)
[151.445587] [029/133] (870s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[151.546528] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[151.548776] Starting dynamic subtest: pipe-A-eDP-1
[151.570999] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[151.579993] Starting dynamic subtest: pipe-B-eDP-1
[151.601388] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[151.608979] Starting dynamic subtest: pipe-C-eDP-1
[151.630203] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[151.637423] Starting dynamic subtest: pipe-D-eDP-1
[151.659380] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[151.663387] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.005s)
[153.818226] [030/133] (867s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[153.915423] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[153.917751] Starting dynamic subtest: pipe-A-eDP-1
[153.999192] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[154.008944] Starting dynamic subtest: pipe-B-eDP-1
[155.204967] Dynamic subtest pipe-B-eDP-1: SKIP (1.204s)
[155.209559] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.294s)
[156.410163] [031/133] (865s left) perf (polling)
[156.495775] Starting subtest: polling
[156.498038] Starting dynamic subtest: 0-rcs0
[166.508153] Dynamic subtest 0-rcs0: SUCCESS (10.009s)
[166.517097] Starting dynamic subtest: 1-vcs1
[176.526882] Dynamic subtest 1-vcs1: SUCCESS (10.018s)
[176.529778] Subtest polling: SUCCESS (20.029s)
[176.573704] [032/133] (844s left) gem_softpin (allocator-fork)
[176.642633] Starting subtest: allocator-fork
[178.863766] Subtest allocator-fork: SUCCESS (2.222s)
[179.023959] [033/133] (842s left) kms_rotation_crc (primary-rotation-90)
[179.113939] Starting subtest: primary-rotation-90
[179.118386] Subtest primary-rotation-90: SKIP (0.001s)
[179.187387] [034/133] (842s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[179.301201] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[179.305187] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[179.408316] [035/133] (842s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[179.510690] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[179.515137] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[179.607588] [036/133] (842s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[179.704081] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[180.671673] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.967s)
[180.805937] [037/133] (840s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[180.894652] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[180.899070] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[180.984174] [038/133] (840s left) prime_mmap_kms (buffer-sharing)
[181.074258] Starting subtest: buffer-sharing
[181.535908] Subtest buffer-sharing: SUCCESS (0.460s)
[182.367579] [039/133] (839s left) gem_exec_schedule (out-order)
[182.436300] Starting subtest: out-order
[182.438644] Starting dynamic subtest: rcs0
[182.533082] Dynamic subtest rcs0: SUCCESS (0.104s)
[182.542283] Starting dynamic subtest: vcs0
[182.618469] Dynamic subtest vcs0: SUCCESS (0.083s)
[182.627906] Starting dynamic subtest: vcs1
[182.699961] Dynamic subtest vcs1: SUCCESS (0.082s)
[182.711796] Starting dynamic subtest: vecs0
[182.778649] Dynamic subtest vecs0: SUCCESS (0.077s)
[182.793798] Starting dynamic subtest: ccs0
[182.860251] Dynamic subtest ccs0: SUCCESS (0.081s)
[182.862768] Subtest out-order: SUCCESS (0.431s)
[184.000094] [040/133] (837s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[184.100725] Starting subtest: fbc-psr2-cursor-plane-onoff
[184.102903] Starting dynamic subtest: eDP-1
[184.107171] Dynamic subtest eDP-1: SKIP (0.000s)
[184.111367] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[184.199632] [041/133] (837s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[184.282917] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[184.285169] Starting dynamic subtest: pipe-A-eDP-1
[184.309049] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[184.324056] Starting dynamic subtest: pipe-B-eDP-1
[184.347098] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[184.359635] Starting dynamic subtest: pipe-C-eDP-1
[184.383357] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[184.393242] Starting dynamic subtest: pipe-D-eDP-1
[184.416716] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[184.420784] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[186.590093] [042/133] (835s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[186.718869] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[186.723304] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[186.861650] [043/133] (835s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[186.982363] Starting subtest: cursorB-vs-flipA-toggle
[186.986837] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[187.128754] [044/133] (834s left) kms_chamelium_frames (dp-crc-fast)
[187.509690] Subtest dp-crc-fast: SKIP (0.000s)
[188.303323] [045/133] (833s left) gem_exec_params (invalid-ring2)
[188.360477] Starting subtest: invalid-ring2
[188.362824] Subtest invalid-ring2: SUCCESS (0.000s)
[188.472445] [046/133] (833s left) i915_suspend (basic-s3-without-i915)
[188.507130] Starting subtest: basic-s3-without-i915
[191.757449] Subtest basic-s3-without-i915: SKIP (3.245s)
[193.278865] [047/133] (828s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[193.379522] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[193.383567] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[193.484075] [048/133] (828s left) i915_fb_tiling (basic-x-tiling)
[193.544795] Subtest basic-x-tiling: SKIP (0.000s)
[193.603185] [049/133] (828s left) gem_exec_schedule (deep)
[193.788987] Starting subtest: deep
[193.791417] Starting dynamic subtest: rcs0
[198.735263] Dynamic subtest rcs0: SKIP (4.942s)
[198.746184] Starting dynamic subtest: vcs0
[208.880614] Dynamic subtest vcs0: SUCCESS (10.147s)
[208.892222] Starting dynamic subtest: vcs1
[220.140870] Dynamic subtest vcs1: SUCCESS (11.260s)
[220.150791] Starting dynamic subtest: vecs0
[232.097056] Dynamic subtest vecs0: SUCCESS (11.954s)
[232.107088] Starting dynamic subtest: ccs0
[245.098728] Dynamic subtest ccs0: SUCCESS (13.000s)
[245.101610] Subtest deep: SUCCESS (51.308s)
[246.830257] [050/133] (775s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[246.938182] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[246.942360] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[247.022956] [051/133] (775s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[247.111567] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[247.115957] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[247.205753] [052/133] (775s left) gem_exec_parallel (contexts)
[247.259417] Starting subtest: contexts
[247.261650] Starting dynamic subtest: rcs0
[250.078883] Dynamic subtest rcs0: SUCCESS (2.820s)
[250.090086] Starting dynamic subtest: bcs0
[253.441246] Dynamic subtest bcs0: SUCCESS (3.360s)
[253.449855] Starting dynamic subtest: vcs0
[257.445386] Dynamic subtest vcs0: SUCCESS (4.003s)
[257.457352] Starting dynamic subtest: vcs1
[261.438951] Dynamic subtest vcs1: SUCCESS (3.992s)
[261.448070] Starting dynamic subtest: vecs0
[265.391081] Dynamic subtest vecs0: SUCCESS (3.951s)
[265.401163] Starting dynamic subtest: ccs0
[269.230127] Dynamic subtest ccs0: SUCCESS (3.837s)
[269.232668] Subtest contexts: SUCCESS (21.973s)
[269.419429] [053/133] (753s left) syncobj_wait (reset-during-wait-for-submit)
[269.478810] Starting subtest: reset-during-wait-for-submit
[269.579466] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[269.658958] [054/133] (752s left) syncobj_wait (single-wait-signaled)
[269.707230] Starting subtest: single-wait-signaled
[269.709067] Subtest single-wait-signaled: SUCCESS (0.000s)
[269.799188] [055/133] (752s left) gem_busy (parallel)
[269.990235] Starting subtest: parallel
[269.992709] Starting dynamic subtest: rcs0
[271.897746] Dynamic subtest rcs0: SUCCESS (1.903s)
[271.909481] Starting dynamic subtest: bcs0
[273.878051] Dynamic subtest bcs0: SUCCESS (1.980s)
[273.889072] Starting dynamic subtest: vcs0
[275.928643] Dynamic subtest vcs0: SUCCESS (2.045s)
[275.937781] Starting dynamic subtest: vcs1
[277.911358] Dynamic subtest vcs1: SUCCESS (1.981s)
[277.922562] Starting dynamic subtest: vecs0
[279.895198] Dynamic subtest vecs0: SUCCESS (1.981s)
[279.907287] Starting dynamic subtest: ccs0
[281.878541] Dynamic subtest ccs0: SUCCESS (1.981s)
[281.881361] Subtest parallel: SUCCESS (11.889s)
[282.119511] [056/133] (740s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[282.222062] Starting subtest: modeset-transition-nonblocking-fencing
[282.224046] Starting dynamic subtest: 1x-outputs
[293.282442] Dynamic subtest 1x-outputs: SUCCESS (11.059s)
[293.284886] Subtest modeset-transition-nonblocking-fencing: SUCCESS (11.060s)
[294.157823] [057/133] (728s left) gem_exec_fence (long-history)
[294.623321] Starting subtest: long-history
[301.640292] Subtest long-history: SUCCESS (7.018s)
[302.152393] [058/133] (720s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[302.264100] Starting subtest: yf-tiled-8bpp-rotate-90
[302.268579] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[302.349867] [059/133] (720s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[302.447915] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[303.470496] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.023s)
[303.593042] [060/133] (719s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[303.689801] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[303.693727] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[303.796919] [061/133] (718s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[303.895400] Starting subtest: plane-downscale-factor-0-5-with-rotation
[303.897329] Starting dynamic subtest: pipe-A
[303.914588] Dynamic subtest pipe-A: SKIP (0.016s)
[303.927217] Starting dynamic subtest: pipe-B
[303.944033] Dynamic subtest pipe-B: SKIP (0.029s)
[303.954743] Starting dynamic subtest: pipe-C
[303.972565] Dynamic subtest pipe-C: SKIP (0.029s)
[303.980788] Starting dynamic subtest: pipe-D
[304.007828] Dynamic subtest pipe-D: SKIP (0.033s)
[304.011486] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.110s)
[304.114576] [062/133] (718s left) kms_invalid_mode (bad-hsync-start)
[304.209575] Starting subtest: bad-hsync-start
[304.211457] Starting dynamic subtest: pipe-A-eDP-1
[304.494793] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[304.504840] Starting dynamic subtest: pipe-B-eDP-1
[304.507230] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[304.516456] Starting dynamic subtest: pipe-C-eDP-1
[304.518753] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[304.526553] Starting dynamic subtest: pipe-D-eDP-1
[304.528900] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[304.531334] Subtest bad-hsync-start: SUCCESS (0.291s)
[305.384875] [063/133] (717s left) kms_content_protection (suspend-resume)
[305.531085] Starting subtest: suspend-resume
[305.536504] Subtest suspend-resume: SKIP (0.000s)
[305.644351] [064/133] (717s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[305.771049] Starting subtest: flip-vs-cursor-atomic
[312.888324] Subtest flip-vs-cursor-atomic: SUCCESS (7.114s)
[313.717308] [065/133] (709s left) kms_feature_discovery (psr2)
[313.815714] Starting subtest: psr2
[313.817631] Subtest psr2: SUCCESS (0.000s)
[313.886710] [066/133] (709s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[313.982542] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[313.984663] Starting dynamic subtest: pipe-A-default-mode
[316.780977] Dynamic subtest pipe-A-default-mode: SUCCESS (2.798s)
[316.783314] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.799s)
[317.607489] [067/133] (705s left) syncobj_wait (single-wait-all-signaled)
[317.671532] Starting subtest: single-wait-all-signaled
[317.673468] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[317.781337] [068/133] (705s left) gem_exec_schedule (promotion)
[317.858698] Starting subtest: promotion
[317.860852] Starting dynamic subtest: rcs0
[317.955950] Dynamic subtest rcs0: SUCCESS (0.104s)
[317.967807] Starting dynamic subtest: vcs0
[318.048869] Dynamic subtest vcs0: SUCCESS (0.093s)
[318.060394] Starting dynamic subtest: vcs1
[318.135742] Dynamic subtest vcs1: SUCCESS (0.086s)
[318.145783] Starting dynamic subtest: vecs0
[318.216595] Dynamic subtest vecs0: SUCCESS (0.079s)
[318.228528] Starting dynamic subtest: ccs0
[318.314757] Dynamic subtest ccs0: SUCCESS (0.097s)
[318.317831] Subtest promotion: SUCCESS (0.464s)
[319.994474] [069/133] (703s left) kms_flip (basic-flip-vs-modeset)
[320.094171] Starting subtest: basic-flip-vs-modeset
[320.096081] Starting dynamic subtest: A-eDP1
[322.701771] Dynamic subtest A-eDP1: SUCCESS (2.609s)
[322.711658] Starting dynamic subtest: B-eDP1
[324.853186] Dynamic subtest B-eDP1: SUCCESS (2.151s)
[324.862598] Starting dynamic subtest: C-eDP1
[326.933678] Dynamic subtest C-eDP1: SUCCESS (2.078s)
[326.942746] Starting dynamic subtest: D-eDP1
[329.090776] Dynamic subtest D-eDP1: SUCCESS (2.155s)
[329.093075] Subtest basic-flip-vs-modeset: SUCCESS (8.999s)
[329.900230] [070/133] (693s left) kms_addfb_basic (unused-offsets)
[329.959770] Starting subtest: unused-offsets
[329.962550] Subtest unused-offsets: SUCCESS (0.000s)
[330.097111] [071/133] (693s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[330.182304] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[330.186422] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[330.295683] [072/133] (692s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[330.355767] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[330.433506] [073/133] (692s left) gem_wait (busy)
[330.496488] Starting subtest: busy
[330.498739] Starting dynamic subtest: all-engines
[331.925945] Dynamic subtest all-engines: SUCCESS (1.427s)
[331.937945] Starting dynamic subtest: rcs0
[332.465696] Dynamic subtest rcs0: SUCCESS (0.538s)
[332.476500] Starting dynamic subtest: bcs0
[333.003840] Dynamic subtest bcs0: SUCCESS (0.538s)
[333.014946] Starting dynamic subtest: vcs0
[334.933066] Dynamic subtest vcs0: SUCCESS (1.926s)
[334.943831] Starting dynamic subtest: vcs1
[336.917217] Dynamic subtest vcs1: SUCCESS (1.981s)
[336.928747] Starting dynamic subtest: vecs0
[338.901153] Dynamic subtest vecs0: SUCCESS (1.982s)
[338.912618] Starting dynamic subtest: ccs0
[339.442025] Dynamic subtest ccs0: SUCCESS (0.540s)
[339.444708] Subtest busy: SUCCESS (8.945s)
[339.635351] [074/133] (683s left) gen9_exec_parse (bb-large)
[339.689457] Subtest bb-large: SKIP (0.000s)
[339.772574] [075/133] (683s left) syncobj_timeline (single-wait-for-submit-signaled)
[339.825090] Starting subtest: single-wait-for-submit-signaled
[339.827389] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[339.934176] [076/133] (683s left) gem_pxp (protected-raw-src-copy-not-readible)
[340.062035] Starting subtest: protected-raw-src-copy-not-readible
[340.125050] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.065s)
[340.236153] [077/133] (683s left) perf (whitelisted-registers-userspace-config)
[340.364729] Starting subtest: whitelisted-registers-userspace-config
[340.366910] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[340.411535] [078/133] (683s left) kms_flip (dpms-vs-vblank-race-interruptible)
[340.507444] Starting subtest: dpms-vs-vblank-race-interruptible
[340.509697] Starting dynamic subtest: A-eDP1
[345.495968] Dynamic subtest A-eDP1: SUCCESS (4.984s)
[345.507521] Starting dynamic subtest: B-eDP1
[350.089491] Dynamic subtest B-eDP1: SUCCESS (4.591s)
[350.100885] Starting dynamic subtest: C-eDP1
[354.704103] Dynamic subtest C-eDP1: SUCCESS (4.613s)
[354.718493] Starting dynamic subtest: D-eDP1
[359.322749] Dynamic subtest D-eDP1: SUCCESS (4.617s)
[359.324960] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (18.815s)
[360.198578] [079/133] (663s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[360.291890] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[360.294242] Starting dynamic subtest: pipe-A-eDP-1
[360.351636] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[360.362064] Starting dynamic subtest: pipe-B-eDP-1
[360.417803] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[360.427834] Starting dynamic subtest: pipe-C-eDP-1
[360.482123] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[360.491118] Starting dynamic subtest: pipe-D-eDP-1
[360.546537] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[360.550728] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[362.553234] [080/133] (661s left) kms_flip (flip-vs-fences)
[362.650798] Starting subtest: flip-vs-fences
[362.655250] Subtest flip-vs-fences: SKIP (0.000s)
[362.758449] [081/133] (660s left) kms_flip (2x-nonexisting-fb-interruptible)
[362.859629] Starting subtest: 2x-nonexisting-fb-interruptible
[362.870696] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.010s)
[362.947307] [082/133] (660s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[363.051053] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[363.055166] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[363.119860] [083/133] (660s left) gem_exec_balancer (parallel-keep-submit-fence)
[363.373703] Starting subtest: parallel-keep-submit-fence
[364.489596] Subtest parallel-keep-submit-fence: SUCCESS (1.116s)
[364.600467] [084/133] (659s left) kms_pm_rpm (modeset-stress-extra-wait)
[366.132405] Starting subtest: modeset-stress-extra-wait
[420.416575] Subtest modeset-stress-extra-wait: SUCCESS (54.281s)
[420.513534] [085/133] (603s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[420.610750] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[420.613054] Starting dynamic subtest: pipe-A-eDP-1
[421.387349] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.767s)
[421.397075] Starting dynamic subtest: pipe-B-eDP-1
[422.871888] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.485s)
[422.882314] Starting dynamic subtest: pipe-C-eDP-1
[424.366192] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.493s)
[424.376092] Starting dynamic subtest: pipe-D-eDP-1
[425.901643] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.534s)
[425.903898] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.283s)
[427.086132] [086/133] (596s left) syncobj_wait (wait-all-interrupted)
[427.151343] Starting subtest: wait-all-interrupted
[427.252926] Subtest wait-all-interrupted: SUCCESS (0.102s)
[427.328418] [087/133] (596s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[427.422857] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[427.425078] Starting dynamic subtest: pipe-A-eDP-1
[427.571228] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.140s)
[427.582253] Starting dynamic subtest: pipe-B-eDP-1
[427.600712] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[427.609407] Starting dynamic subtest: pipe-C-eDP-1
[427.629093] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.015s)
[427.637691] Starting dynamic subtest: pipe-D-eDP-1
[427.657083] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[427.659249] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.182s)
[429.848317] [088/133] (594s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[429.917701] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[429.990427] [089/133] (593s left) vgem_basic (bad-flag)
[430.034375] Starting subtest: bad-flag
[430.036602] Subtest bad-flag: SUCCESS (0.000s)
[430.093388] [090/133] (593s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[430.156468] Starting subtest: etime-single-wait-for-submit-unsubmitted
[430.257363] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[430.335748] [091/133] (593s left) syncobj_timeline (multi-wait-all-available-submitted)
[430.399309] Starting subtest: multi-wait-all-available-submitted
[430.401234] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[430.519527] [092/133] (593s left) kms_universal_plane (disable-primary-vs-flip)
[430.611202] Starting subtest: disable-primary-vs-flip
[430.613114] Starting dynamic subtest: pipe-A-eDP-1
[432.144065] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.532s)
[432.153138] Starting dynamic subtest: pipe-B-eDP-1
[434.389957] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.242s)
[434.399978] Starting dynamic subtest: pipe-C-eDP-1
[436.545466] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.158s)
[436.554305] Starting dynamic subtest: pipe-D-eDP-1
[438.741447] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.193s)
[438.743738] Subtest disable-primary-vs-flip: SUCCESS (8.130s)
[439.619488] [093/133] (584s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[439.720867] Starting subtest: invalidate-primary-flip-overlay
[450.479430] Subtest invalidate-primary-flip-overlay: SUCCESS (10.760s)
[450.583588] [094/133] (573s left) kms_cursor_crc (cursor-random-512x512)
[450.862567] Starting subtest: cursor-random-512x512
[450.866729] Subtest cursor-random-512x512: SKIP (0.001s)
[451.024361] [095/133] (573s left) i915_drm_fdinfo (virtual-busy-all)
[451.059672] Starting subtest: virtual-busy-all
[451.063443] Subtest virtual-busy-all: SKIP (0.000s)
[451.121670] [096/133] (573s left) gem_create (create-massive)
[451.178221] Starting subtest: create-massive
[451.180332] Subtest create-massive: SUCCESS (0.000s)
[451.369064] [097/133] (572s left) kms_pm_dc (dc6-psr)
[452.465803] Starting subtest: dc6-psr
[455.342295] Subtest dc6-psr: SUCCESS (2.878s)
[456.142295] [098/133] (568s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[456.265389] Starting subtest: basic-busy-flip-before-cursor-varying-size
[456.269772] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[456.411204] [099/133] (567s left) kms_vblank (query-forked-busy-hang)
[456.497434] Starting subtest: query-forked-busy-hang
[456.499655] Starting dynamic subtest: pipe-A-eDP-1
[482.646765] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.145s)
[482.661800] Starting dynamic subtest: pipe-D-eDP-1
[497.739485] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.093s)
[497.741994] Subtest query-forked-busy-hang: SUCCESS (41.243s)
[498.593235] [100/133] (525s left) kms_addfb_basic (master-rmfb)
[498.656427] Starting subtest: master-rmfb
[498.658335] Subtest master-rmfb: SUCCESS (0.001s)
[498.798964] [101/133] (525s left) perf_pmu (render-node-busy-idle)
[498.876463] Starting subtest: render-node-busy-idle
[498.878912] Starting dynamic subtest: rcs0
[499.537695] Dynamic subtest rcs0: SUCCESS (0.659s)
[499.549051] Starting dynamic subtest: bcs0
[500.207793] Dynamic subtest bcs0: SUCCESS (0.670s)
[500.219573] Starting dynamic subtest: vcs0
[501.910444] Dynamic subtest vcs0: SUCCESS (1.698s)
[501.922639] Starting dynamic subtest: vcs1
[503.894478] Dynamic subtest vcs1: SUCCESS (1.981s)
[503.906207] Starting dynamic subtest: vecs0
[505.878057] Dynamic subtest vecs0: SUCCESS (1.980s)
[505.889806] Starting dynamic subtest: ccs0
[506.544465] Dynamic subtest ccs0: SUCCESS (0.665s)
[506.546982] Subtest render-node-busy-idle: SUCCESS (7.669s)
[506.620414] [102/133] (517s left) kms_atomic_transition (plane-all-transition-fencing)
[506.725075] Starting subtest: plane-all-transition-fencing
[506.727451] Starting dynamic subtest: pipe-A-eDP-1
[509.219171] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[509.530933] Starting dynamic subtest: pipe-B-eDP-1
[512.716916] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.195s)
[513.013022] Subtest plane-all-transition-fencing: SUCCESS (6.289s)
[513.843020] [103/133] (510s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[513.940807] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[513.944885] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[514.039528] [104/133] (510s left) gem_mmap_gtt (basic-write-gtt)
[514.090564] Subtest basic-write-gtt: SKIP (0.000s)
[514.148800] [105/133] (510s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[514.259136] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[514.263282] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[514.363622] [106/133] (510s left) gem_gtt_cpu_tlb
[514.480094] [107/133] (510s left) kms_properties (plane-properties-legacy)
[514.570165] Starting subtest: plane-properties-legacy
[514.572194] Starting dynamic subtest: pipe-A-eDP-1
[515.125089] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.555s)
[515.134785] Starting dynamic subtest: pipe-B-eDP-1
[516.419547] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.290s)
[516.429043] Starting dynamic subtest: pipe-C-eDP-1
[517.649815] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.229s)
[517.659128] Starting dynamic subtest: pipe-D-eDP-1
[518.873168] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.221s)
[518.875379] Subtest plane-properties-legacy: SUCCESS (4.302s)
[519.679502] [108/133] (505s left) gem_exec_whisper (basic-queues-forked-all)
[519.738418] Starting subtest: basic-queues-forked-all
[539.028036] Subtest basic-queues-forked-all: SUCCESS (19.286s)
[539.210137] [109/133] (485s left) gem_exec_alignment (many)
[539.274524] Starting subtest: many
[562.908625] Subtest many: SUCCESS (23.632s)
[564.818312] [110/133] (459s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[564.978783] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[564.983575] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[565.125695] [111/133] (459s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[565.222735] Starting subtest: read-crc-frame-sequence
[565.225021] Starting dynamic subtest: pipe-A-eDP-1
[565.955631] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.731s)
[565.965244] Starting dynamic subtest: pipe-B-eDP-1
[567.339846] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.384s)
[567.349127] Starting dynamic subtest: pipe-C-eDP-1
[568.653362] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.311s)
[568.666739] Starting dynamic subtest: pipe-D-eDP-1
[569.990657] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.335s)
[569.992618] Subtest read-crc-frame-sequence: SUCCESS (4.767s)
[570.812712] [112/133] (454s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[570.913607] Starting subtest: psr-rgb565-draw-pwrite
[577.998471] Subtest psr-rgb565-draw-pwrite: SUCCESS (7.088s)
[578.100369] [113/133] (446s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[578.172471] Starting subtest: single-wait-for-submit-unsubmitted
[578.281903] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[578.359903] [114/133] (446s left) api_intel_bb (object-noreloc-keep-cache-simple)
[578.420218] Starting subtest: object-noreloc-keep-cache-simple
[578.423295] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.006s)
[578.533809] [115/133] (446s left) kms_psr (pr-sprite-blt)
[578.624057] Starting subtest: pr-sprite-blt
[578.628234] Subtest pr-sprite-blt: SKIP (0.000s)
[578.722534] [116/133] (446s left) gem_lmem_swapping (verify-random)
[578.764222] Subtest verify-random: SKIP (0.000s)
[578.809990] [117/133] (446s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[578.905121] Starting subtest: y-tiled-addfb-size-offset-overflow
[578.909588] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[579.017240] [118/133] (446s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[579.112796] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[585.771642] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.660s)
[585.888090] [119/133] (439s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[585.982063] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[586.639132] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.659s)
[586.816449] [120/133] (438s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[586.876682] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[586.879075] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[586.995232] [121/133] (438s left) api_intel_allocator (execbuf-with-allocator)
[587.054057] Starting subtest: execbuf-with-allocator
[587.058504] Subtest execbuf-with-allocator: SUCCESS (0.007s)
[587.190310] [122/133] (438s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[587.248822] Starting subtest: multi-wait-for-submit-submitted-signaled
[587.251084] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[587.346302] [123/133] (438s left) syncobj_timeline (reset-unsignaled)
[587.399905] Starting subtest: reset-unsignaled
[587.401928] Subtest reset-unsignaled: SUCCESS (0.000s)
[587.494625] [124/133] (437s left) prime_self_import (export-vs-gem_close-race)
[587.533827] Starting subtest: export-vs-gem_close-race
[592.625628] Subtest export-vs-gem_close-race: SUCCESS (5.092s)
[592.705039] [125/133] (432s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[592.829109] Starting subtest: cursorA-vs-flipA-legacy
[603.994937] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.163s)
[604.816651] [126/133] (420s left) prime_vgem (basic-fence-mmap)
[604.914848] Starting subtest: basic-fence-mmap
[604.919574] Subtest basic-fence-mmap: SKIP (0.000s)
[605.034765] [127/133] (420s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[605.139830] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[611.677902] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.541s)
[611.806480] [128/133] (413s left) kms_psr (psr-cursor-plane-onoff)
[611.908782] Starting subtest: psr-cursor-plane-onoff
[611.911064] Starting dynamic subtest: eDP-1
[613.633273] Dynamic subtest eDP-1: SUCCESS (1.724s)
[613.635541] Subtest psr-cursor-plane-onoff: SUCCESS (1.725s)
[614.499691] [129/133] (411s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[614.596939] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[614.601405] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[614.732926] [130/133] (410s left) perf (stress-open-close)
[614.856580] Starting subtest: stress-open-close
[614.859036] Starting dynamic subtest: 0-rcs0
[617.019944] Dynamic subtest 0-rcs0: SUCCESS (2.164s)
[617.030815] Starting dynamic subtest: 1-vecs0
[619.183272] Dynamic subtest 1-vecs0: SUCCESS (2.162s)
[619.185207] Subtest stress-open-close: SUCCESS (4.328s)
[619.231317] [131/133] (406s left) perf_pmu (busy-accuracy-98)
[619.274958] Starting subtest: busy-accuracy-98
[619.276607] Starting dynamic subtest: rcs0
[622.312514] Dynamic subtest rcs0: SUCCESS (3.036s)
[622.321729] Starting dynamic subtest: bcs0
[625.362977] Dynamic subtest bcs0: SUCCESS (3.047s)
[625.372246] Starting dynamic subtest: vcs0
[628.411512] Dynamic subtest vcs0: SUCCESS (3.045s)
[628.422841] Starting dynamic subtest: vcs1
[631.456293] Dynamic subtest vcs1: SUCCESS (3.043s)
[631.467370] Starting dynamic subtest: vecs0
[634.498712] Dynamic subtest vecs0: SUCCESS (3.040s)
[634.510079] Starting dynamic subtest: ccs0
[637.550258] Dynamic subtest ccs0: SUCCESS (3.049s)
[637.552689] Subtest busy-accuracy-98: SUCCESS (18.273s)
[637.690389] [132/133] (388s left) syncobj_eventfd (binary-wait-before-signal)
[637.753495] Starting subtest: binary-wait-before-signal
[637.784085] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[637.873265] [133/133] (387s left) kms_psr (fbc-pr-cursor-blt)
[637.974152] Starting subtest: fbc-pr-cursor-blt
[637.978516] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[638.046462] Closing watchdogs
results: parsing output: 0/ for test: gem_mmap_offset
results: parsing output: 1/ for test: kms_cursor_crc
results: parsing output: 2/ for test: dmabuf_sync_file
results: parsing output: 3/ for test: kms_color_pipeline
results: parsing output: 4/ for test: kms_plane_scaling
results: parsing output: 5/ for test: syncobj_wait
results: parsing output: 6/ for test: kms_chamelium_hpd
results: parsing output: 7/ for test: gem_exec_flush
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: i915_pm_rc6_residency
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_rotation_crc
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_ctx_persistence
results: parsing output: 15/ for test: perf
results: parsing output: 16/ for test: gem_ctx_param
results: parsing output: 17/ for test: kms_lease
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: gem_exec_schedule
results: parsing output: 21/ for test: gem_pxp
results: parsing output: 22/ for test: gem_exec_balancer
results: parsing output: 23/ for test: kms_plane_multiple
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: gem_render_copy
results: parsing output: 26/ for test: kms_plane
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: kms_psr2_sf
results: parsing output: 30/ for test: perf
results: parsing output: 31/ for test: gem_softpin
results: parsing output: 32/ for test: kms_rotation_crc
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: prime_mmap_kms
results: parsing output: 38/ for test: gem_exec_schedule
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: kms_chamelium_frames
results: parsing output: 44/ for test: gem_exec_params
results: parsing output: 45/ for test: i915_suspend
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: i915_fb_tiling
results: parsing output: 48/ for test: gem_exec_schedule
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_exec_parallel
results: parsing output: 52/ for test: syncobj_wait
results: parsing output: 53/ for test: syncobj_wait
results: parsing output: 54/ for test: gem_busy
results: parsing output: 55/ for test: kms_atomic_transition
results: parsing output: 56/ for test: gem_exec_fence
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_plane_scaling
results: parsing output: 61/ for test: kms_invalid_mode
results: parsing output: 62/ for test: kms_content_protection
results: parsing output: 63/ for test: kms_cursor_legacy
results: parsing output: 64/ for test: kms_feature_discovery
results: parsing output: 65/ for test: kms_flip_scaled_crc
results: parsing output: 66/ for test: syncobj_wait
results: parsing output: 67/ for test: gem_exec_schedule
results: parsing output: 68/ for test: kms_flip
results: parsing output: 69/ for test: kms_addfb_basic
results: parsing output: 70/ for test: kms_flip_scaled_crc
results: parsing output: 71/ for test: gem_fenced_exec_thrash
results: parsing output: 72/ for test: gem_wait
results: parsing output: 73/ for test: gen9_exec_parse
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: gem_pxp
results: parsing output: 76/ for test: perf
results: parsing output: 77/ for test: kms_flip
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: kms_flip
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_psr2_sf
results: parsing output: 82/ for test: gem_exec_balancer
results: parsing output: 83/ for test: kms_pm_rpm
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: syncobj_wait
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: gem_exec_reloc
results: parsing output: 88/ for test: vgem_basic
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_universal_plane
results: parsing output: 92/ for test: kms_psr_stress_test
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: i915_drm_fdinfo
results: parsing output: 95/ for test: gem_create
results: parsing output: 96/ for test: kms_pm_dc
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: kms_vblank
results: parsing output: 99/ for test: kms_addfb_basic
results: parsing output: 100/ for test: perf_pmu
results: parsing output: 101/ for test: kms_atomic_transition
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_mmap_gtt
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_gtt_cpu_tlb
results: parsing output: 106/ for test: kms_properties
results: parsing output: 107/ for test: gem_exec_whisper
results: parsing output: 108/ for test: gem_exec_alignment
results: parsing output: 109/ for test: kms_cursor_legacy
results: parsing output: 110/ for test: kms_pipe_crc_basic
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: syncobj_wait
results: parsing output: 113/ for test: api_intel_bb
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: gem_lmem_swapping
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: syncobj_wait
results: parsing output: 120/ for test: api_intel_allocator
results: parsing output: 121/ for test: syncobj_wait
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: prime_self_import
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: prime_vgem
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: perf
results: parsing output: 130/ for test: perf_pmu
results: parsing output: 131/ for test: syncobj_eventfd
results: parsing output: 132/ for test: kms_psr
Done.