[58.253102] Initializing watchdogs
[58.253149]   /dev/watchdog0
[58.266920] [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]
[58.271163] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.273325] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.276585] [001/134] (960s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[58.394605] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[58.396773] Starting dynamic subtest: pipe-A
[58.480640] Dynamic subtest pipe-A: SUCCESS (0.088s)
[58.495564] Starting dynamic subtest: pipe-B
[59.651428] Dynamic subtest pipe-B: SUCCESS (1.177s)
[59.669863] Starting dynamic subtest: pipe-C
[60.756670] Dynamic subtest pipe-C: SUCCESS (1.110s)
[60.770027] Starting dynamic subtest: pipe-D
[61.893498] Dynamic subtest pipe-D: SUCCESS (1.141s)
[61.895750] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.521s)
[63.077876] [002/134] (955s left) gem_userptr_blits (forbidden-operations)
[63.158555] Starting subtest: forbidden-operations
[63.162761] Subtest forbidden-operations: SKIP (0.000s)
[63.307181] [003/134] (955s left) gem_mmap_gtt (big-bo)
[63.373990] Subtest big-bo: SKIP (0.000s)
[63.442636] [004/134] (955s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[63.532296] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[70.795540] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.283s)
[70.964217] [005/134] (947s left) kms_fence_pin_leak
[71.148214] [006/134] (947s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[71.244020] Starting subtest: x-tiled-16bpp-rotate-180
[72.600627] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.358s)
[72.761912] [007/134] (946s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[72.824034] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[72.891949] [008/134] (946s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[72.993406] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[73.003587] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.010s)
[73.143758] [009/134] (945s left) perf_pmu (busy-check-all)
[73.185118] Starting subtest: busy-check-all
[73.186940] Starting dynamic subtest: rcs0
[73.754940] Dynamic subtest rcs0: SUCCESS (0.571s)
[73.765978] Starting dynamic subtest: bcs0
[74.303483] Dynamic subtest bcs0: SUCCESS (0.548s)
[74.313771] Starting dynamic subtest: vcs0
[75.926056] Dynamic subtest vcs0: SUCCESS (1.621s)
[75.936794] Starting dynamic subtest: vcs1
[77.912058] Dynamic subtest vcs1: SUCCESS (1.985s)
[77.922571] Starting dynamic subtest: vecs0
[79.893388] Dynamic subtest vecs0: SUCCESS (1.981s)
[79.903683] Starting dynamic subtest: ccs0
[80.447218] Dynamic subtest ccs0: SUCCESS (0.555s)
[80.449585] Subtest busy-check-all: SUCCESS (7.267s)
[80.590044] [010/134] (938s left) gem_mmap_wc (coherency)
[80.643255] Subtest coherency: SKIP (0.000s)
[80.696177] [011/134] (938s left) kms_big_fb (yf-tiled-addfb)
[80.813426] Starting subtest: yf-tiled-addfb
[80.817669] Subtest yf-tiled-addfb: SKIP (0.000s)
[80.945142] [012/134] (938s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[81.051667] Starting subtest: extended-modeset-hang-oldfb-with-reset
[81.053676] Starting dynamic subtest: pipe-A
[92.650646] Dynamic subtest pipe-A: SUCCESS (11.598s)
[92.659475] Starting dynamic subtest: pipe-D
[104.928597] Dynamic subtest pipe-D: SUCCESS (12.275s)
[104.930981] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.876s)
[105.753078] [013/134] (913s left) kms_plane_alpha_blend (constant-alpha-min)
[105.856924] Starting subtest: constant-alpha-min
[106.142808] Starting dynamic subtest: pipe-A-eDP-1
[106.876509] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.731s)
[106.891899] Starting dynamic subtest: pipe-D-eDP-1
[108.321193] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.444s)
[108.323572] Subtest constant-alpha-min: SUCCESS (2.464s)
[109.212285] [014/134] (910s left) sysfs_timeslice_duration (duration)
[109.287689] Starting subtest: duration
[109.290201] Starting dynamic subtest: vecs0
[122.803461] Dynamic subtest vecs0: SUCCESS (13.513s)
[122.813974] Starting dynamic subtest: ccs0
[135.981626] Dynamic subtest ccs0: SUCCESS (13.177s)
[135.992730] Starting dynamic subtest: vcs0
[149.812228] Dynamic subtest vcs0: SUCCESS (13.827s)
[149.823375] Starting dynamic subtest: bcs0
[162.982405] Dynamic subtest bcs0: SUCCESS (13.169s)
[162.992893] Starting dynamic subtest: rcs0
[176.160918] Dynamic subtest rcs0: SUCCESS (13.174s)
[176.171776] Starting dynamic subtest: vcs1
[189.811681] Dynamic subtest vcs1: SUCCESS (13.648s)
[189.814535] Subtest duration: SUCCESS (80.519s)
[189.908313] [015/134] (829s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[190.018491] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[193.623403] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.609s)
[194.783445] [016/134] (824s left) kms_cursor_crc (cursor-onscreen-64x64)
[194.955957] Starting subtest: cursor-onscreen-64x64
[194.960902] Starting dynamic subtest: pipe-A-eDP-1
[197.068202] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.107s)
[197.094922] Starting dynamic subtest: pipe-D-eDP-1
[199.812240] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.722s)
[199.814506] Subtest cursor-onscreen-64x64: SUCCESS (4.854s)
[200.624276] [017/134] (818s left) kms_color (ctm-red-to-blue)
[200.726127] Starting subtest: ctm-red-to-blue
[200.728063] Starting dynamic subtest: pipe-A-eDP-1
[201.436038] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.711s)
[201.445631] Starting dynamic subtest: pipe-B-eDP-1
[202.809774] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.372s)
[202.819150] Starting dynamic subtest: pipe-C-eDP-1
[204.200298] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.391s)
[204.208921] Starting dynamic subtest: pipe-D-eDP-1
[205.531233] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.330s)
[205.533572] Subtest ctm-red-to-blue: SUCCESS (4.805s)
[206.359309] [018/134] (813s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[206.418668] Subtest writes-after-reads-uncached: SKIP (0.000s)
[206.499286] [019/134] (812s left) dumb_buffer (invalid-bpp)
[206.558978] Starting subtest: invalid-bpp
[206.561205] Subtest invalid-bpp: SUCCESS (0.000s)
[206.695141] [020/134] (812s left) gem_mmap_gtt (ptrace)
[206.745741] Subtest ptrace: SKIP (0.000s)
[206.826821] [021/134] (812s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[206.945159] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[206.949687] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[207.110011] [022/134] (812s left) gem_lmem_swapping (verify)
[207.158886] Subtest verify: SKIP (0.000s)
[207.193543] [023/134] (812s left) gem_spin_batch (resubmit-new)
[207.257630] Starting subtest: resubmit-new
[207.260089] Starting dynamic subtest: rcs0
[207.264902] Dynamic subtest rcs0: SUCCESS (0.007s)
[207.275444] Starting dynamic subtest: bcs0
[207.277290] Dynamic subtest bcs0: SUCCESS (0.003s)
[207.285387] Starting dynamic subtest: vcs0
[207.287574] Dynamic subtest vcs0: SUCCESS (0.004s)
[207.295013] Starting dynamic subtest: vcs1
[207.296602] Dynamic subtest vcs1: SUCCESS (0.005s)
[207.303925] Starting dynamic subtest: vecs0
[207.305674] Dynamic subtest vecs0: SUCCESS (0.005s)
[207.312873] Starting dynamic subtest: ccs0
[207.314494] Dynamic subtest ccs0: SUCCESS (0.003s)
[207.316090] Subtest resubmit-new: SUCCESS (0.030s)
[208.979851] [024/134] (810s left) kms_cursor_crc (cursor-random-512x512)
[209.249333] Starting subtest: cursor-random-512x512
[209.253800] Subtest cursor-random-512x512: SKIP (0.001s)
[209.438966] [025/134] (810s left) kms_properties (plane-properties-legacy)
[209.531855] Starting subtest: plane-properties-legacy
[209.534176] Starting dynamic subtest: pipe-A-eDP-1
[210.083020] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.548s)
[210.093191] Starting dynamic subtest: pipe-B-eDP-1
[211.314166] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.231s)
[211.322280] Starting dynamic subtest: pipe-C-eDP-1
[212.544330] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.230s)
[212.552791] Starting dynamic subtest: pipe-D-eDP-1
[213.785462] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.238s)
[213.787417] Subtest plane-properties-legacy: SUCCESS (4.252s)
[214.607197] [026/134] (805s left) kms_vrr (flipline)
[214.701013] Starting subtest: flipline
[214.707268] Subtest flipline: SKIP (0.000s)
[214.798062] [027/134] (804s left) gem_exec_params (secure-non-master)
[214.868461] Starting subtest: secure-non-master
[214.873325] Subtest secure-non-master: SKIP (0.000s)
[214.986951] [028/134] (804s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[215.244792] Starting subtest: parallel-dmabuf-import-out-fence
[216.366791] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.122s)
[216.525933] [029/134] (803s left) kms_pm_dc (dc5-dpms-negative)
[217.638982] Starting subtest: dc5-dpms-negative
[217.643556] Subtest dc5-dpms-negative: SKIP (0.000s)
[217.732296] [030/134] (802s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[217.832352] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[217.836655] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[217.955034] [031/134] (801s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[218.054267] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[224.775047] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.725s)
[224.916793] [032/134] (795s left) kms_frontbuffer_tracking (psr-argb161616f-draw-mmap-cpu)
[225.021362] Starting subtest: psr-argb161616f-draw-mmap-cpu
[225.025701] Subtest psr-argb161616f-draw-mmap-cpu: SKIP (0.000s)
[225.157126] [033/134] (794s left) gem_exec_whisper (basic-fds-all)
[225.232859] Starting subtest: basic-fds-all
[236.853729] Subtest basic-fds-all: SUCCESS (11.617s)
[237.062338] [034/134] (782s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[237.174840] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[237.179079] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[237.299271] [035/134] (782s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[237.390040] Starting subtest: psr-rgb565-draw-render
[244.392490] Subtest psr-rgb565-draw-render: SUCCESS (7.003s)
[244.529975] [036/134] (775s left) gem_render_copy_redux (flink)
[244.601779] Starting subtest: flink
[245.357038] Subtest flink: SUCCESS (0.758s)
[245.516227] [037/134] (774s left) gem_mmap_wc (bad-offset)
[245.577247] Subtest bad-offset: SKIP (0.000s)
[245.640497] [038/134] (774s left) gem_pxp (reject-modify-context-protection-off-2)
[245.768252] Starting subtest: reject-modify-context-protection-off-2
[245.770347] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[245.908795] [039/134] (774s left) kms_3d (basic)
[245.964413] Starting subtest: basic
[247.937828] Subtest basic: SUCCESS (1.975s)
[248.464227] [040/134] (771s left) gem_ctx_persistence (smoketest)
[248.510464] Starting subtest: smoketest
[288.820458] Subtest smoketest: SUCCESS (40.306s)
[288.924008] [041/134] (731s left) kms_psr (fbc-pr-suspend)
[289.027362] Starting subtest: fbc-pr-suspend
[289.031813] Subtest fbc-pr-suspend: SKIP (0.000s)
[289.128391] [042/134] (731s left) syncobj_timeline (multi-wait-for-submit-signaled)
[289.190419] Starting subtest: multi-wait-for-submit-signaled
[289.192677] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[289.306711] [043/134] (731s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[289.416892] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[289.419187] Starting dynamic subtest: pipe-A-default-mode
[292.118413] Dynamic subtest pipe-A-default-mode: SUCCESS (2.699s)
[292.120380] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.701s)
[292.954561] [044/134] (727s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[293.053031] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[293.055346] Starting dynamic subtest: pipe-A-default-mode
[295.723372] Dynamic subtest pipe-A-default-mode: SUCCESS (2.668s)
[295.725265] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.669s)
[296.548085] [045/134] (723s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[296.662975] Starting subtest: psr-rgb565-draw-mmap-cpu
[303.350527] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.691s)
[303.499267] [046/134] (717s left) vgem_basic (mmap)
[303.629722] Starting subtest: mmap
[303.635315] Subtest mmap: SUCCESS (0.007s)
[303.706168] [FACT vgem_basic (mmap)] new: kernel.kmod_is_loaded.vgem: true
[303.709807] [047/134] (716s left) gem_userptr_blits (sync-unmap-after-close)
[303.781270] Starting subtest: sync-unmap-after-close
[303.792796] Subtest sync-unmap-after-close: SUCCESS (0.010s)
[303.955419] [048/134] (716s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[304.330049] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[305.107578] [049/134] (715s left) kms_frontbuffer_tracking (basic)
[305.201418] Starting subtest: basic
[308.341775] Subtest basic: SUCCESS (3.144s)
[308.503116] [050/134] (712s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[308.601078] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[315.554337] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (6.955s)
[315.713208] [051/134] (704s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[315.817065] Starting subtest: fbc-rgb101010-draw-blt
[320.391935] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.578s)
[321.552045] [052/134] (699s left) kms_lease (lease-unleased-connector)
[321.640335] Starting subtest: lease-unleased-connector
[321.642541] Starting dynamic subtest: pipe-A-eDP-1
[321.647078] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[321.656425] Starting dynamic subtest: pipe-B-eDP-1
[321.658634] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.008s)
[321.667943] Starting dynamic subtest: pipe-C-eDP-1
[321.670285] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[321.679656] Starting dynamic subtest: pipe-D-eDP-1
[321.681993] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[321.684196] Subtest lease-unleased-connector: SUCCESS (0.042s)
[321.823559] [053/134] (698s left) gem_tiled_partial_pwrite_pread (reads)
[321.880077] Subtest reads: SKIP (0.000s)
[321.965115] [054/134] (698s left) kms_dp_link_training (uhbr-sst)
[322.067205] Starting subtest: uhbr-sst
[322.075469] Subtest uhbr-sst: SKIP (0.000s)
[322.163774] [055/134] (698s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[322.231782] Starting subtest: etime-multi-wait-all-submitted-signaled
[322.337896] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.105s)
[322.436236] [056/134] (698s left) kms_invalid_mode (overflow-vrefresh)
[322.530147] Starting subtest: overflow-vrefresh
[322.532466] Starting dynamic subtest: pipe-A-eDP-1
[322.820415] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[322.829528] Starting dynamic subtest: pipe-B-eDP-1
[322.831421] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[322.839173] Starting dynamic subtest: pipe-C-eDP-1
[322.841329] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[322.849468] Starting dynamic subtest: pipe-D-eDP-1
[322.851695] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[322.853861] Subtest overflow-vrefresh: SUCCESS (0.295s)
[323.651439] [057/134] (697s left) kms_pm_rpm (i2c)
[325.189996] Starting subtest: i2c
[330.590655] Subtest i2c: SUCCESS (5.403s)
[330.689449] [058/134] (690s left) gem_exec_balancer (busy)
[330.752482] Starting subtest: busy
[332.925714] Subtest busy: SUCCESS (2.172s)
[333.290384] [059/134] (687s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[338.295906] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[338.301124] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s)
[339.148694] [060/134] (681s left) gen9_exec_parse (batch-without-end)
[339.219073] Subtest batch-without-end: SKIP (0.000s)
[339.305707] [061/134] (681s left) gem_ctx_shared (exec-shared-gtt)
[339.367876] Starting subtest: exec-shared-gtt
[339.370180] Starting dynamic subtest: rcs0
[339.375385] Dynamic subtest rcs0: SUCCESS (0.006s)
[339.385643] Starting dynamic subtest: bcs0
[339.387576] Dynamic subtest bcs0: SUCCESS (0.006s)
[339.396175] Starting dynamic subtest: vcs0
[339.398336] Dynamic subtest vcs0: SUCCESS (0.007s)
[339.406701] Starting dynamic subtest: vcs1
[339.408562] Dynamic subtest vcs1: SUCCESS (0.006s)
[339.416931] Starting dynamic subtest: vecs0
[339.419124] Dynamic subtest vecs0: SUCCESS (0.006s)
[339.427348] Starting dynamic subtest: ccs0
[339.429533] Dynamic subtest ccs0: SUCCESS (0.007s)
[339.431676] Subtest exec-shared-gtt: SUCCESS (0.041s)
[339.618988] [062/134] (681s left) perf (invalid-oa-metric-set-id)
[339.761643] Starting subtest: invalid-oa-metric-set-id
[339.773103] Subtest invalid-oa-metric-set-id: SUCCESS (0.011s)
[339.820996] [063/134] (681s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[339.880627] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[339.882848] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[340.021555] [064/134] (681s left) gem_tiled_pread_pwrite
[340.152417] [065/134] (681s left) i915_pm_rps (thresholds-park)
[340.211255] Starting subtest: thresholds-park
[340.215286] Subtest thresholds-park: SKIP (0.001s)
[340.364656] [066/134] (680s left) gem_ctx_engines (invalid-engines)
[340.433714] Starting subtest: invalid-engines
[340.441497] Subtest invalid-engines: SUCCESS (0.008s)
[340.706294] [067/134] (680s left) vgem_basic (create)
[340.755040] Starting subtest: create
[340.757391] Subtest create: SUCCESS (0.000s)
[340.838551] [068/134] (680s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[340.946953] Starting subtest: fbc-psr2-sprite-mmap-cpu
[340.949275] Starting dynamic subtest: eDP-1
[340.953598] Dynamic subtest eDP-1: SKIP (0.000s)
[340.957796] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[341.047461] [069/134] (680s left) gem_mmap_gtt (big-copy-odd)
[341.113430] Subtest big-copy-odd: SKIP (0.000s)
[341.177059] [070/134] (680s left) gem_exec_reloc (basic-gtt-cpu-active)
[341.250814] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[341.334620] [071/134] (680s left) prime_busy (before-wait)
[341.406285] Starting subtest: before-wait
[341.408638] Starting dynamic subtest: rcs0
[341.466469] Dynamic subtest rcs0: SUCCESS (0.059s)
[341.477733] Starting dynamic subtest: bcs0
[341.529049] Dynamic subtest bcs0: SUCCESS (0.061s)
[341.537716] Starting dynamic subtest: vcs0
[341.570038] Dynamic subtest vcs0: SUCCESS (0.041s)
[341.580571] Starting dynamic subtest: vcs1
[341.610240] Dynamic subtest vcs1: SUCCESS (0.040s)
[341.619048] Starting dynamic subtest: vecs0
[341.651515] Dynamic subtest vecs0: SUCCESS (0.041s)
[341.660436] Starting dynamic subtest: ccs0
[341.691728] Dynamic subtest ccs0: SUCCESS (0.040s)
[341.801087] Subtest before-wait: SUCCESS (0.396s)
[341.902539] [072/134] (679s left) gem_exec_fence (keep-in-fence)
[342.087407] Starting subtest: keep-in-fence
[342.089837] Starting dynamic subtest: rcs0
[342.167263] Dynamic subtest rcs0: SUCCESS (0.079s)
[342.186013] Starting dynamic subtest: bcs0
[342.221788] Dynamic subtest bcs0: SUCCESS (0.053s)
[342.233415] Starting dynamic subtest: vcs0
[343.894358] Dynamic subtest vcs0: SUCCESS (1.669s)
[343.906597] Starting dynamic subtest: vcs1
[345.880059] Dynamic subtest vcs1: SUCCESS (1.983s)
[345.892491] Starting dynamic subtest: vecs0
[347.925247] Dynamic subtest vecs0: SUCCESS (2.044s)
[347.937455] Starting dynamic subtest: ccs0
[348.160660] Dynamic subtest ccs0: SUCCESS (0.234s)
[348.163546] Subtest keep-in-fence: SUCCESS (6.074s)
[350.033505] [073/134] (671s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[350.136125] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[353.847050] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.714s)
[355.040038] [074/134] (666s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[355.137238] Starting subtest: 4-tiled-8bpp-rotate-270
[355.159107] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.021s)
[355.308352] [075/134] (666s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[360.368644] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[360.371053] Starting dynamic subtest: pipe-A-eDP-1
[361.176898] Dynamic subtest pipe-A-eDP-1: SKIP (0.803s)
[361.186959] Starting dynamic subtest: pipe-B-eDP-1
[362.316015] Dynamic subtest pipe-B-eDP-1: SKIP (1.139s)
[362.320595] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.946s)
[363.518217] [076/134] (658s left) gem_ccs (block-multicopy-inplace)
[363.592578] Starting subtest: block-multicopy-inplace
[363.597091] Subtest block-multicopy-inplace: SKIP (0.000s)
[363.734406] [077/134] (658s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[363.841880] Starting subtest: x-tiled-addfb-size-offset-overflow
[363.844206] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[363.976235] [078/134] (657s left) kms_atomic (crtc-invalid-params)
[364.077963] Starting subtest: crtc-invalid-params
[364.080345] Starting dynamic subtest: pipe-A-eDP-1
[364.438931] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.361s)
[364.441294] Subtest crtc-invalid-params: SUCCESS (0.363s)
[365.260503] [079/134] (656s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[365.365851] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[365.368072] Starting dynamic subtest: pipe-A-eDP-1
[365.387742] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s)
[365.398329] Starting dynamic subtest: pipe-B-eDP-1
[365.418263] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.019s)
[365.427322] Starting dynamic subtest: pipe-C-eDP-1
[365.446423] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.019s)
[365.455601] Starting dynamic subtest: pipe-D-eDP-1
[365.475668] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[365.477542] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.083s)
[367.633539] [080/134] (654s left) gem_lmem_swapping (heavy-verify-multi)
[367.677018] Subtest heavy-verify-multi: SKIP (0.000s)
[367.719207] [081/134] (654s left) kms_chamelium_frames (hdmi-crc-fast)
[368.098604] Subtest hdmi-crc-fast: SKIP (0.000s)
[368.913045] [082/134] (653s left) kms_vblank (query-forked-busy-hang)
[369.004234] Starting subtest: query-forked-busy-hang
[369.006521] Starting dynamic subtest: pipe-A-eDP-1
[395.664267] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.655s)
[395.678607] Starting dynamic subtest: pipe-D-eDP-1
[420.707626] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.040s)
[420.709927] Subtest query-forked-busy-hang: SUCCESS (51.699s)
[421.528180] [083/134] (600s left) kms_big_fb (linear-16bpp-rotate-90)
[421.640049] Starting subtest: linear-16bpp-rotate-90
[421.660100] Subtest linear-16bpp-rotate-90: SKIP (0.020s)
[421.798267] [084/134] (600s left) gem_flink_race (flink_close)
[421.842705] Starting subtest: flink_close
[426.941142] Subtest flink_close: SUCCESS (5.098s)
[427.044691] [085/134] (595s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[427.156217] Starting subtest: fbcpsr-modesetfrombusy
[433.395417] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.242s)
[433.596321] [086/134] (588s left) gem_exec_schedule (thriceslice)
[433.667675] Starting subtest: thriceslice
[433.669286] Starting dynamic subtest: rcs0
[433.692069] Dynamic subtest rcs0: SUCCESS (0.029s)
[433.702251] Starting dynamic subtest: bcs0
[433.721203] Dynamic subtest bcs0: SUCCESS (0.028s)
[433.729746] Starting dynamic subtest: vcs0
[433.753508] Dynamic subtest vcs0: SUCCESS (0.031s)
[433.762495] Starting dynamic subtest: vcs1
[433.783752] Dynamic subtest vcs1: SUCCESS (0.028s)
[433.792158] Starting dynamic subtest: vecs0
[433.812697] Dynamic subtest vecs0: SUCCESS (0.028s)
[433.825794] Starting dynamic subtest: ccs0
[433.843545] Dynamic subtest ccs0: SUCCESS (0.030s)
[433.845419] Subtest thriceslice: SUCCESS (0.182s)
[434.177173] [087/134] (588s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[434.275920] Starting subtest: flip-vs-dpms-off-vs-modeset
[434.278264] Starting dynamic subtest: A-eDP1
[437.899682] Dynamic subtest A-eDP1: SUCCESS (3.623s)
[437.909627] Starting dynamic subtest: B-eDP1
[441.088213] Dynamic subtest B-eDP1: SUCCESS (3.187s)
[441.097815] Starting dynamic subtest: C-eDP1
[444.210555] Dynamic subtest C-eDP1: SUCCESS (3.121s)
[444.220438] Starting dynamic subtest: D-eDP1
[447.319278] Dynamic subtest D-eDP1: SUCCESS (3.110s)
[447.321580] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.048s)
[448.140239] [088/134] (574s left) i915_pm_rps (min-max-config-idle)
[448.206403] Starting subtest: min-max-config-idle
[448.211035] Subtest min-max-config-idle: SKIP (0.000s)
[448.333364] [089/134] (573s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[448.430325] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[455.038305] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.609s)
[455.207472] [090/134] (567s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[460.210532] Starting subtest: psr2-overlay-plane-move-continuous-sf
[460.212962] Starting dynamic subtest: pipe-A-eDP-1
[466.913356] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.700s)
[466.932086] Starting dynamic subtest: pipe-B-eDP-1
[473.634057] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.719s)
[473.636476] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.424s)
[474.545590] [091/134] (547s left) kms_concurrent (multi-plane-atomic-lowres)
[474.650746] Starting subtest: multi-plane-atomic-lowres
[474.653065] Starting dynamic subtest: pipe-A-eDP-1
[475.162341] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.510s)
[475.164650] Subtest multi-plane-atomic-lowres: SUCCESS (0.512s)
[475.981654] [092/134] (546s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[476.085554] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[476.089702] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[476.210379] [093/134] (546s left) api_intel_allocator (reopen)
[476.262173] Starting subtest: reopen
[476.264576] Subtest reopen: SUCCESS (0.003s)
[476.418353] [094/134] (546s left) kms_flip (dpms-vs-vblank-race)
[476.537251] Starting subtest: dpms-vs-vblank-race
[476.539148] Starting dynamic subtest: A-eDP1
[480.437588] Dynamic subtest A-eDP1: SUCCESS (3.901s)
[480.447229] Starting dynamic subtest: B-eDP1
[483.946445] Dynamic subtest B-eDP1: SUCCESS (3.506s)
[483.956982] Starting dynamic subtest: C-eDP1
[488.554645] Dynamic subtest C-eDP1: SUCCESS (4.607s)
[488.563685] Starting dynamic subtest: D-eDP1
[493.188259] Dynamic subtest D-eDP1: SUCCESS (4.633s)
[493.190522] Subtest dpms-vs-vblank-race: SUCCESS (16.656s)
[494.092431] [095/134] (528s left) syncobj_timeline (single-wait-all-available-signaled)
[494.157623] Starting subtest: single-wait-all-available-signaled
[494.159583] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[494.293177] [096/134] (528s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[494.375728] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[494.377839] Starting dynamic subtest: pipe-A-eDP-1
[495.707903] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.331s)
[495.990752] Starting dynamic subtest: pipe-B-eDP-1
[497.032973] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.050s)
[497.300532] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.925s)
[498.167189] [097/134] (524s left) gem_exec_params (rs-invalid)
[498.235575] Starting subtest: rs-invalid
[498.237888] Subtest rs-invalid: SUCCESS (0.003s)
[498.393427] [098/134] (524s left) kms_scaling_modes (scaling-mode-full-aspect)
[498.492016] Starting subtest: scaling-mode-full-aspect
[498.494341] Starting dynamic subtest: pipe-A-eDP-1
[498.581070] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.091s)
[498.591194] Starting dynamic subtest: pipe-B-eDP-1
[499.766038] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.182s)
[499.777359] Starting dynamic subtest: pipe-C-eDP-1
[500.969359] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.203s)
[500.978461] Starting dynamic subtest: pipe-D-eDP-1
[502.100700] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s)
[502.103074] Subtest scaling-mode-full-aspect: SUCCESS (3.612s)
[503.274799] [099/134] (519s left) kms_plane (plane-panning-top-left)
[503.368974] Starting subtest: plane-panning-top-left
[503.371259] Starting dynamic subtest: pipe-A
[505.037626] Dynamic subtest pipe-A: SUCCESS (1.669s)
[505.047962] Starting dynamic subtest: pipe-B
[507.482970] Dynamic subtest pipe-B: SUCCESS (2.443s)
[507.485330] Subtest plane-panning-top-left: SUCCESS (4.115s)
[508.305127] [100/134] (514s left) kms_psr (psr2-sprite-mmap-cpu)
[508.409127] Starting subtest: psr2-sprite-mmap-cpu
[508.411390] Starting dynamic subtest: eDP-1
[510.160503] Dynamic subtest eDP-1: SUCCESS (1.753s)
[510.162714] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.754s)
[511.057226] [101/134] (511s left) gem_exec_params (rel-constants-invalid-ring)
[511.117429] Starting subtest: rel-constants-invalid-ring
[511.119801] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[511.261458] [102/134] (511s left) i915_query (query-garbage)
[511.337651] Starting subtest: query-garbage
[511.340019] Subtest query-garbage: SUCCESS (0.000s)
[511.468407] [103/134] (511s left) kms_psr (psr-cursor-mmap-cpu)
[511.567413] Starting subtest: psr-cursor-mmap-cpu
[511.569564] Starting dynamic subtest: eDP-1
[513.326528] Dynamic subtest eDP-1: SUCCESS (1.760s)
[513.328876] Subtest psr-cursor-mmap-cpu: SUCCESS (1.761s)
[514.213927] [104/134] (508s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[514.324348] Starting subtest: y-tiled-16bpp-rotate-90
[514.328674] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[514.460038] [105/134] (508s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[514.556584] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[514.560935] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[515.755427] [106/134] (507s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[515.884463] Starting subtest: flip-vs-cursor-legacy
[522.903804] Subtest flip-vs-cursor-legacy: SUCCESS (7.018s)
[523.771418] [107/134] (499s left) kms_frontbuffer_tracking (fbcpsr-argb161616f-draw-blt)
[523.882309] Starting subtest: fbcpsr-argb161616f-draw-blt
[523.886524] Subtest fbcpsr-argb161616f-draw-blt: SKIP (0.000s)
[524.021859] [108/134] (499s left) kms_flip (flip-vs-fences)
[524.113117] Starting subtest: flip-vs-fences
[524.117065] Subtest flip-vs-fences: SKIP (0.000s)
[524.256423] [109/134] (498s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[524.316680] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[524.381926] [110/134] (498s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[524.475579] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[524.477752] Starting dynamic subtest: pipe-A-eDP-1
[525.322938] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.839s)
[525.332791] Starting dynamic subtest: pipe-B-eDP-1
[526.858266] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.533s)
[526.868123] Starting dynamic subtest: pipe-C-eDP-1
[528.372114] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.511s)
[528.383394] Starting dynamic subtest: pipe-D-eDP-1
[529.896097] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.524s)
[529.898209] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.412s)
[531.111908] [111/134] (492s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[531.210386] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[531.214754] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[531.347226] [112/134] (491s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[531.441936] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[531.443787] Starting dynamic subtest: pipe-A-eDP-1
[532.146757] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.699s)
[532.156687] Starting dynamic subtest: pipe-B-eDP-1
[533.892370] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.743s)
[533.903007] Starting dynamic subtest: pipe-C-eDP-1
[535.621238] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.727s)
[535.631822] Starting dynamic subtest: pipe-D-eDP-1
[537.340087] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.718s)
[537.342403] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (5.892s)
[538.533050] [113/134] (484s left) i915_drm_fdinfo (memory-info-shared)
[538.575655] Starting subtest: memory-info-shared
[538.577926] Starting dynamic subtest: smem0
[538.640746] Dynamic subtest smem0: SUCCESS (0.064s)
[538.643577] Subtest memory-info-shared: SUCCESS (0.065s)
[538.743884] [114/134] (484s left) gem_exec_flush (basic-wb-set-default)
[538.808795] Starting subtest: basic-wb-set-default
[544.259257] Subtest basic-wb-set-default: SUCCESS (5.450s)
[544.467434] [115/134] (478s left) sysfs_timeslice_duration (timeout)
[544.530581] Starting subtest: timeout
[544.533055] Starting dynamic subtest: vecs0
[553.888681] Dynamic subtest vecs0: SUCCESS (9.354s)
[553.899717] Starting dynamic subtest: ccs0
[555.261684] Dynamic subtest ccs0: SUCCESS (1.371s)
[555.271927] Starting dynamic subtest: vcs0
[564.909942] Dynamic subtest vcs0: SUCCESS (9.644s)
[564.921618] Starting dynamic subtest: bcs0
[565.570221] Dynamic subtest bcs0: SUCCESS (0.659s)
[565.580679] Starting dynamic subtest: rcs0
[566.850065] Dynamic subtest rcs0: SUCCESS (1.277s)
[566.860182] Starting dynamic subtest: vcs1
[576.938320] Dynamic subtest vcs1: SUCCESS (10.085s)
[576.940976] Subtest timeout: SUCCESS (32.404s)
[577.035870] [116/134] (446s left) sriov_basic (enable-vfs-bind-unbind-each)
[577.093439] Starting subtest: enable-vfs-bind-unbind-each
[577.095862] Starting dynamic subtest: numvfs-1
[577.176272] Dynamic subtest numvfs-1: FAIL (0.031s)
[577.187112] Starting dynamic subtest: numvfs-2
[577.260892] Dynamic subtest numvfs-2: FAIL (0.003s)
[577.271218] Starting dynamic subtest: numvfs-3
[577.344784] Dynamic subtest numvfs-3: FAIL (0.003s)
[577.355570] Starting dynamic subtest: numvfs-4
[577.427491] Dynamic subtest numvfs-4: FAIL (0.003s)
[577.437936] Starting dynamic subtest: numvfs-5
[577.510395] Dynamic subtest numvfs-5: FAIL (0.003s)
[577.520999] Starting dynamic subtest: numvfs-6
[577.593050] Dynamic subtest numvfs-6: FAIL (0.003s)
[577.603592] Starting dynamic subtest: numvfs-7
[577.675709] Dynamic subtest numvfs-7: FAIL (0.004s)
[577.685505] Starting dynamic subtest: numvfs-random
[577.757203] Dynamic subtest numvfs-random: FAIL (0.003s)
[577.759255] Subtest enable-vfs-bind-unbind-each: FAIL (0.060s)
[577.797596] [117/134] (445s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[577.894205] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[577.898605] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[579.055638] [118/134] (444s left) kms_getfb (getfb-handle-not-fb)
[579.151877] Starting subtest: getfb-handle-not-fb
[579.154118] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[579.283503] [119/134] (444s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[579.373625] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[579.377844] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[579.582208] [120/134] (444s left) gem_workarounds (reset-context)
[579.644981] Starting subtest: reset-context
[579.812775] Subtest reset-context: SUCCESS (0.166s)
[579.995198] [121/134] (443s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[580.092609] Starting subtest: psr-farfromfence-mmap-gtt
[580.096581] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[580.224468] [122/134] (443s left) gem_wait (write-busy)
[580.292853] Starting subtest: write-busy
[580.295295] Starting dynamic subtest: all-engines
[580.918686] Dynamic subtest all-engines: SUCCESS (0.625s)
[580.934857] Starting dynamic subtest: rcs0
[581.473546] Dynamic subtest rcs0: SUCCESS (0.553s)
[581.489939] Starting dynamic subtest: bcs0
[582.023778] Dynamic subtest bcs0: SUCCESS (0.549s)
[582.039657] Starting dynamic subtest: vcs0
[583.892243] Dynamic subtest vcs0: SUCCESS (1.867s)
[583.908832] Starting dynamic subtest: vcs1
[585.877279] Dynamic subtest vcs1: SUCCESS (1.981s)
[585.893475] Starting dynamic subtest: vecs0
[587.925171] Dynamic subtest vecs0: SUCCESS (2.045s)
[587.943069] Starting dynamic subtest: ccs0
[588.477353] Dynamic subtest ccs0: SUCCESS (0.551s)
[588.479751] Subtest write-busy: SUCCESS (8.184s)
[588.698545] [123/134] (435s left) i915_hangman (detector)
[588.771744] Starting subtest: detector
[588.774133] Starting dynamic subtest: rcs0
[598.899568] Dynamic subtest rcs0: SUCCESS (10.126s)
[598.911977] Starting dynamic subtest: bcs0
[610.867482] Dynamic subtest bcs0: SUCCESS (11.964s)
[610.879299] Starting dynamic subtest: vcs0
[622.836384] Dynamic subtest vcs0: SUCCESS (11.965s)
[622.848920] Starting dynamic subtest: vcs1
[634.803587] Dynamic subtest vcs1: SUCCESS (11.964s)
[634.816160] Starting dynamic subtest: vecs0
[645.812306] Dynamic subtest vecs0: SUCCESS (11.005s)
[645.824660] Starting dynamic subtest: ccs0
[656.883439] Dynamic subtest ccs0: SUCCESS (11.067s)
[656.886188] Subtest detector: SUCCESS (68.109s)
[656.987630] [124/134] (366s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[657.079489] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[657.083857] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[657.214315] [125/134] (366s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[657.341338] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[657.345624] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[657.514580] [126/134] (366s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[657.574467] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[657.640152] [127/134] (366s left) gem_exec_schedule (noreorder-corked)
[657.816656] Starting subtest: noreorder-corked
[657.818920] Starting dynamic subtest: rcs0
[658.965430] Dynamic subtest rcs0: SUCCESS (1.148s)
[658.975711] Starting dynamic subtest: vcs0
[660.900585] Dynamic subtest vcs0: SUCCESS (1.931s)
[660.912886] Starting dynamic subtest: vcs1
[662.957998] Dynamic subtest vcs1: SUCCESS (2.056s)
[662.973618] Starting dynamic subtest: vecs0
[664.926680] Dynamic subtest vecs0: SUCCESS (1.966s)
[664.939972] Starting dynamic subtest: ccs0
[666.094669] Dynamic subtest ccs0: SUCCESS (1.166s)
[666.097268] Subtest noreorder-corked: SUCCESS (8.279s)
[666.306061] [128/134] (357s left) kms_psr (pr-cursor-mmap-cpu)
[666.407370] Starting subtest: pr-cursor-mmap-cpu
[666.411654] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[666.504434] [129/134] (357s left) perf (invalid-oa-format-id)
[666.614339] Starting subtest: invalid-oa-format-id
[666.623255] Subtest invalid-oa-format-id: SUCCESS (0.007s)
[666.666058] [130/134] (357s left) gem_eio (in-flight-internal-immediate)
[666.854794] Starting subtest: in-flight-internal-immediate
[667.978855] Subtest in-flight-internal-immediate: SUCCESS (1.123s)
[668.151982] [131/134] (355s left) kms_cursor_edge_walk (256x256-top-edge)
[668.254850] Starting subtest: 256x256-top-edge
[668.256980] Starting dynamic subtest: pipe-A-eDP-1
[671.694969] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.440s)
[671.708424] Starting dynamic subtest: pipe-D-eDP-1
[674.825382] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.128s)
[674.827235] Subtest 256x256-top-edge: SUCCESS (6.570s)
[675.650919] [132/134] (348s left) gem_ctx_persistence (engines-persistence)
[675.706755] Starting subtest: engines-persistence
[675.709169] Starting dynamic subtest: rcs0
[676.519933] Dynamic subtest rcs0: SUCCESS (0.812s)
[676.532190] Starting dynamic subtest: bcs0
[677.279907] Dynamic subtest bcs0: SUCCESS (0.758s)
[677.294642] Starting dynamic subtest: vcs0
[678.044954] Dynamic subtest vcs0: SUCCESS (0.762s)
[678.056910] Starting dynamic subtest: vcs1
[678.827982] Dynamic subtest vcs1: SUCCESS (0.781s)
[678.840222] Starting dynamic subtest: vecs0
[679.613073] Dynamic subtest vecs0: SUCCESS (0.783s)
[679.623829] Starting dynamic subtest: ccs0
[680.421202] Dynamic subtest ccs0: SUCCESS (0.806s)
[680.423872] Subtest engines-persistence: SUCCESS (4.715s)
[680.531078] [133/134] (343s left) api_intel_bb (render-ccs)
[680.593140] Starting subtest: render-ccs
[680.946668] Subtest render-ccs: SUCCESS (0.355s)
[681.064441] [134/134] (343s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[681.156073] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[681.160034] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[681.282905] Closing watchdogs
results: parsing output: 0/ for test: kms_plane_scaling
results: parsing output: 1/ for test: gem_userptr_blits
results: parsing output: 2/ for test: gem_mmap_gtt
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_fence_pin_leak
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: gem_mmap_wc
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: perf_pmu
results: parsing output: 9/ for test: gem_mmap_wc
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_busy
results: parsing output: 12/ for test: kms_plane_alpha_blend
results: parsing output: 13/ for test: sysfs_timeslice_duration
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_cursor_crc
results: parsing output: 16/ for test: kms_color
results: parsing output: 17/ for test: gem_partial_pwrite_pread
results: parsing output: 18/ for test: dumb_buffer
results: parsing output: 19/ for test: gem_mmap_gtt
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: gem_lmem_swapping
results: parsing output: 22/ for test: gem_spin_batch
results: parsing output: 23/ for test: kms_cursor_crc
results: parsing output: 24/ for test: kms_properties
results: parsing output: 25/ for test: kms_vrr
results: parsing output: 26/ for test: gem_exec_params
results: parsing output: 27/ for test: gem_exec_balancer
results: parsing output: 28/ for test: kms_pm_dc
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_exec_whisper
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_render_copy_redux
results: parsing output: 36/ for test: gem_mmap_wc
results: parsing output: 37/ for test: gem_pxp
results: parsing output: 38/ for test: kms_3d
results: parsing output: 39/ for test: gem_ctx_persistence
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: kms_flip_scaled_crc
results: parsing output: 43/ for test: kms_flip_scaled_crc
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: vgem_basic
results: parsing output: 46/ for test: gem_userptr_blits
results: parsing output: 47/ for test: kms_chamelium_hpd
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_lease
results: parsing output: 52/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 53/ for test: kms_dp_link_training
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: kms_invalid_mode
results: parsing output: 56/ for test: kms_pm_rpm
results: parsing output: 57/ for test: gem_exec_balancer
results: parsing output: 58/ for test: kms_psr2_sf
results: parsing output: 59/ for test: gen9_exec_parse
results: parsing output: 60/ for test: gem_ctx_shared
results: parsing output: 61/ for test: perf
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: gem_tiled_pread_pwrite
results: parsing output: 64/ for test: i915_pm_rps
results: parsing output: 65/ for test: gem_ctx_engines
results: parsing output: 66/ for test: vgem_basic
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: gem_mmap_gtt
results: parsing output: 69/ for test: gem_exec_reloc
results: parsing output: 70/ for test: prime_busy
results: parsing output: 71/ for test: gem_exec_fence
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_psr2_sf
results: parsing output: 75/ for test: gem_ccs
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_atomic
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: gem_lmem_swapping
results: parsing output: 80/ for test: kms_chamelium_frames
results: parsing output: 81/ for test: kms_vblank
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: gem_flink_race
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_exec_schedule
results: parsing output: 86/ for test: kms_flip
results: parsing output: 87/ for test: i915_pm_rps
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: kms_concurrent
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: api_intel_allocator
results: parsing output: 93/ for test: kms_flip
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: kms_atomic_transition
results: parsing output: 96/ for test: gem_exec_params
results: parsing output: 97/ for test: kms_scaling_modes
results: parsing output: 98/ for test: kms_plane
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: gem_exec_params
results: parsing output: 101/ for test: i915_query
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: kms_cursor_legacy
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: gem_exec_reloc
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_ccs
results: parsing output: 112/ for test: i915_drm_fdinfo
results: parsing output: 113/ for test: gem_exec_flush
results: parsing output: 114/ for test: sysfs_timeslice_duration
results: parsing output: 115/ for test: sriov_basic
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: kms_getfb
results: parsing output: 118/ for test: gem_render_copy
results: parsing output: 119/ for test: gem_workarounds
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_wait
results: parsing output: 122/ for test: i915_hangman
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: gem_mmap_gtt
results: parsing output: 126/ for test: gem_exec_schedule
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: perf
results: parsing output: 129/ for test: gem_eio
results: parsing output: 130/ for test: kms_cursor_edge_walk
results: parsing output: 131/ for test: gem_ctx_persistence
results: parsing output: 132/ for test: api_intel_bb
results: parsing output: 133/ for test: kms_frontbuffer_tracking
Done.