[58.956705] Initializing watchdogs
[58.956757]   /dev/watchdog0
[58.971065] [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.975470] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.977905] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.981025] [001/134] (960s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[59.107320] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[59.109661] Starting dynamic subtest: pipe-A
[59.194805] Dynamic subtest pipe-A: SUCCESS (0.089s)
[59.217091] Starting dynamic subtest: pipe-B
[60.307580] Dynamic subtest pipe-B: SUCCESS (1.108s)
[60.317351] Starting dynamic subtest: pipe-C
[61.431085] Dynamic subtest pipe-C: SUCCESS (1.119s)
[61.440746] Starting dynamic subtest: pipe-D
[62.583649] Dynamic subtest pipe-D: SUCCESS (1.149s)
[62.585993] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.468s)
[63.756787] [002/134] (955s left) gem_userptr_blits (forbidden-operations)
[63.831276] Starting subtest: forbidden-operations
[63.835560] Subtest forbidden-operations: SKIP (0.000s)
[63.973909] [003/134] (955s left) gem_mmap_gtt (big-bo)
[64.048175] Subtest big-bo: SKIP (0.000s)
[64.111580] [004/134] (955s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[64.212095] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[72.024982] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.805s)
[72.192201] [005/134] (947s left) kms_fence_pin_leak
[72.369182] [006/134] (947s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[72.471430] Starting subtest: x-tiled-16bpp-rotate-180
[73.762341] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.290s)
[73.930044] [007/134] (945s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[73.990881] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[74.057780] [008/134] (945s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[74.150351] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[74.162424] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s)
[74.302587] [009/134] (945s left) perf_pmu (busy-check-all)
[74.349045] Starting subtest: busy-check-all
[74.350852] Starting dynamic subtest: rcs0
[74.904987] Dynamic subtest rcs0: SUCCESS (0.554s)
[74.918972] Starting dynamic subtest: bcs0
[75.453782] Dynamic subtest bcs0: SUCCESS (0.548s)
[75.464314] Starting dynamic subtest: vcs0
[76.887418] Dynamic subtest vcs0: SUCCESS (1.431s)
[76.898178] Starting dynamic subtest: vcs1
[78.936239] Dynamic subtest vcs1: SUCCESS (2.047s)
[78.946025] Starting dynamic subtest: vecs0
[80.920069] Dynamic subtest vecs0: SUCCESS (1.982s)
[80.930014] Starting dynamic subtest: ccs0
[81.478566] Dynamic subtest ccs0: SUCCESS (0.558s)
[81.481617] Subtest busy-check-all: SUCCESS (7.126s)
[81.618504] [010/134] (938s left) gem_mmap_wc (coherency)
[81.691239] Subtest coherency: SKIP (0.000s)
[81.765974] [011/134] (938s left) kms_big_fb (yf-tiled-addfb)
[81.877994] Starting subtest: yf-tiled-addfb
[81.882070] Subtest yf-tiled-addfb: SKIP (0.000s)
[82.018527] [012/134] (937s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[82.123615] Starting subtest: extended-modeset-hang-oldfb-with-reset
[82.126072] Starting dynamic subtest: pipe-A
[93.649552] Dynamic subtest pipe-A: SUCCESS (11.520s)
[93.660723] Starting dynamic subtest: pipe-D
[105.922655] Dynamic subtest pipe-D: SUCCESS (12.270s)
[105.925083] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.795s)
[106.822927] [013/134] (913s left) kms_plane_alpha_blend (constant-alpha-min)
[106.927158] Starting subtest: constant-alpha-min
[107.214548] Starting dynamic subtest: pipe-A-eDP-1
[107.924193] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.708s)
[107.933469] Starting dynamic subtest: pipe-D-eDP-1
[109.372078] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.445s)
[109.374567] Subtest constant-alpha-min: SUCCESS (2.444s)
[110.197569] [014/134] (909s left) sysfs_timeslice_duration (duration)
[110.256661] Starting subtest: duration
[110.259056] Starting dynamic subtest: vecs0
[123.829044] Dynamic subtest vecs0: SUCCESS (13.570s)
[123.840181] Starting dynamic subtest: ccs0
[136.995387] Dynamic subtest ccs0: SUCCESS (13.165s)
[137.008084] Starting dynamic subtest: vcs0
[150.837962] Dynamic subtest vcs0: SUCCESS (13.839s)
[150.850088] Starting dynamic subtest: bcs0
[163.988041] Dynamic subtest bcs0: SUCCESS (13.150s)
[163.999543] Starting dynamic subtest: rcs0
[177.159160] Dynamic subtest rcs0: SUCCESS (13.169s)
[177.170573] Starting dynamic subtest: vcs1
[190.839406] Dynamic subtest vcs1: SUCCESS (13.676s)
[190.842300] Subtest duration: SUCCESS (80.578s)
[190.942058] [015/134] (829s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[191.051415] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[194.681849] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.633s)
[195.897922] [016/134] (824s left) kms_cursor_crc (cursor-onscreen-64x64)
[196.091908] Starting subtest: cursor-onscreen-64x64
[196.094232] Starting dynamic subtest: pipe-A-eDP-1
[198.185055] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.090s)
[198.217355] Starting dynamic subtest: pipe-D-eDP-1
[200.939096] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.725s)
[200.941124] Subtest cursor-onscreen-64x64: SUCCESS (4.845s)
[201.772514] [017/134] (818s left) kms_color (ctm-red-to-blue)
[201.876739] Starting subtest: ctm-red-to-blue
[201.878841] Starting dynamic subtest: pipe-A-eDP-1
[202.586583] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[202.596034] Starting dynamic subtest: pipe-B-eDP-1
[204.084202] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.497s)
[204.093078] Starting dynamic subtest: pipe-C-eDP-1
[205.437068] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.351s)
[205.445965] Starting dynamic subtest: pipe-D-eDP-1
[206.771767] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.334s)
[206.773701] Subtest ctm-red-to-blue: SUCCESS (4.894s)
[207.589312] [018/134] (812s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[207.670221] Subtest writes-after-reads-uncached: SKIP (0.000s)
[207.757988] [019/134] (812s left) dumb_buffer (invalid-bpp)
[207.819148] Starting subtest: invalid-bpp
[207.821090] Subtest invalid-bpp: SUCCESS (0.000s)
[207.950657] [020/134] (812s left) gem_mmap_gtt (ptrace)
[208.012363] Subtest ptrace: SKIP (0.000s)
[208.068083] [021/134] (812s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[208.196472] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[208.201073] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[208.366165] [022/134] (811s left) gem_lmem_swapping (verify)
[208.414329] Subtest verify: SKIP (0.000s)
[208.460732] [023/134] (811s left) gem_spin_batch (resubmit-new)
[208.529458] Starting subtest: resubmit-new
[208.531590] Starting dynamic subtest: rcs0
[208.535863] Dynamic subtest rcs0: SUCCESS (0.006s)
[208.546181] Starting dynamic subtest: bcs0
[208.547758] Dynamic subtest bcs0: SUCCESS (0.004s)
[208.556801] Starting dynamic subtest: vcs0
[208.558702] Dynamic subtest vcs0: SUCCESS (0.004s)
[208.566769] Starting dynamic subtest: vcs1
[208.568644] Dynamic subtest vcs1: SUCCESS (0.006s)
[208.576316] Starting dynamic subtest: vecs0
[208.577879] Dynamic subtest vecs0: SUCCESS (0.007s)
[208.585500] Starting dynamic subtest: ccs0
[208.587107] Dynamic subtest ccs0: SUCCESS (0.005s)
[208.588628] Subtest resubmit-new: SUCCESS (0.037s)
[210.006268] [024/134] (810s left) kms_cursor_crc (cursor-random-512x512)
[210.293784] Starting subtest: cursor-random-512x512
[210.298210] Subtest cursor-random-512x512: SKIP (0.001s)
[210.501565] [025/134] (809s left) kms_properties (plane-properties-legacy)
[210.584113] Starting subtest: plane-properties-legacy
[210.586418] Starting dynamic subtest: pipe-A-eDP-1
[211.152477] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.567s)
[211.162399] Starting dynamic subtest: pipe-B-eDP-1
[212.449802] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.294s)
[212.459786] Starting dynamic subtest: pipe-C-eDP-1
[213.689040] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.240s)
[213.698678] Starting dynamic subtest: pipe-D-eDP-1
[214.927634] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.235s)
[214.929649] Subtest plane-properties-legacy: SUCCESS (4.340s)
[215.751878] [026/134] (804s left) kms_vrr (flipline)
[215.856207] Starting subtest: flipline
[215.862777] Subtest flipline: SKIP (0.000s)
[215.946780] [027/134] (804s left) gem_exec_params (secure-non-master)
[216.010549] Starting subtest: secure-non-master
[216.015278] Subtest secure-non-master: SKIP (0.000s)
[216.133820] [028/134] (804s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[216.387789] Starting subtest: parallel-dmabuf-import-out-fence
[217.497242] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.109s)
[217.625915] [029/134] (802s left) kms_pm_dc (dc5-dpms-negative)
[218.738661] Starting subtest: dc5-dpms-negative
[218.742857] Subtest dc5-dpms-negative: SKIP (0.000s)
[218.851524] [030/134] (801s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[218.951961] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[218.956380] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[219.057273] [031/134] (801s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[219.157732] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[225.995970] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.842s)
[226.152758] [032/134] (794s left) kms_frontbuffer_tracking (psr-argb161616f-draw-mmap-cpu)
[226.250697] Starting subtest: psr-argb161616f-draw-mmap-cpu
[226.254823] Subtest psr-argb161616f-draw-mmap-cpu: SKIP (0.000s)
[226.393155] [033/134] (794s left) gem_exec_whisper (basic-fds-all)
[226.466631] Starting subtest: basic-fds-all
[237.873286] Subtest basic-fds-all: SUCCESS (11.404s)
[238.081105] [034/134] (782s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[238.186314] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[238.190311] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[238.329098] [035/134] (782s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[238.433080] Starting subtest: psr-rgb565-draw-render
[245.462764] Subtest psr-rgb565-draw-render: SUCCESS (7.032s)
[245.622485] [036/134] (775s left) gem_render_copy_redux (flink)
[245.696318] Starting subtest: flink
[246.490779] Subtest flink: SUCCESS (0.795s)
[246.649169] [037/134] (774s left) gem_mmap_wc (bad-offset)
[246.717551] Subtest bad-offset: SKIP (0.000s)
[246.782174] [038/134] (774s left) gem_pxp (reject-modify-context-protection-off-2)
[246.908860] Starting subtest: reject-modify-context-protection-off-2
[246.911132] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[247.069977] [039/134] (773s left) kms_3d (basic)
[247.125248] Starting subtest: basic
[249.105720] Subtest basic: SUCCESS (1.980s)
[249.625172] [040/134] (771s left) gem_ctx_persistence (smoketest)
[249.688193] Starting subtest: smoketest
[289.845256] Subtest smoketest: SUCCESS (40.156s)
[289.945565] [041/134] (731s left) kms_psr (fbc-pr-suspend)
[290.048492] Starting subtest: fbc-pr-suspend
[290.053228] Subtest fbc-pr-suspend: SKIP (0.000s)
[290.143448] [042/134] (731s left) syncobj_timeline (multi-wait-for-submit-signaled)
[290.203251] Starting subtest: multi-wait-for-submit-signaled
[290.205505] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[290.334832] [043/134] (730s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[290.440948] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[290.443241] Starting dynamic subtest: pipe-A-default-mode
[293.138514] Dynamic subtest pipe-A-default-mode: SUCCESS (2.695s)
[293.140815] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.697s)
[293.992232] [044/134] (727s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[294.093275] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[294.095377] Starting dynamic subtest: pipe-A-default-mode
[296.864673] Dynamic subtest pipe-A-default-mode: SUCCESS (2.770s)
[296.866956] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.772s)
[297.690242] [045/134] (723s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[297.790293] Starting subtest: psr-rgb565-draw-mmap-cpu
[304.573248] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.784s)
[304.720518] [046/134] (716s left) vgem_basic (mmap)
[304.827359] Starting subtest: mmap
[304.831898] Subtest mmap: SUCCESS (0.006s)
[304.902133] [FACT vgem_basic (mmap)] new: kernel.kmod_is_loaded.vgem: true
[304.905308] [047/134] (716s left) gem_userptr_blits (sync-unmap-after-close)
[304.988720] Starting subtest: sync-unmap-after-close
[304.997847] Subtest sync-unmap-after-close: SUCCESS (0.012s)
[305.167676] [048/134] (716s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[305.550749] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[306.344369] [049/134] (715s left) kms_frontbuffer_tracking (basic)
[306.454652] Starting subtest: basic
[309.797296] Subtest basic: SUCCESS (3.346s)
[309.948630] [050/134] (711s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[310.057387] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[317.032386] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (6.976s)
[317.182993] [051/134] (704s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[317.306419] Starting subtest: fbc-rgb101010-draw-blt
[321.918168] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.615s)
[323.109290] [052/134] (698s left) kms_lease (lease-unleased-connector)
[323.211845] Starting subtest: lease-unleased-connector
[323.214093] Starting dynamic subtest: pipe-A-eDP-1
[323.222836] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.009s)
[323.233928] Starting dynamic subtest: pipe-B-eDP-1
[323.236039] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[323.245975] Starting dynamic subtest: pipe-C-eDP-1
[323.248277] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[323.257603] Starting dynamic subtest: pipe-D-eDP-1
[323.259682] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[323.261758] Subtest lease-unleased-connector: SUCCESS (0.037s)
[323.379770] [053/134] (698s left) gem_tiled_partial_pwrite_pread (reads)
[323.447031] Subtest reads: SKIP (0.000s)
[323.518904] [054/134] (698s left) kms_dp_link_training (uhbr-sst)
[323.622342] Starting subtest: uhbr-sst
[323.631138] Subtest uhbr-sst: SKIP (0.000s)
[323.726345] [055/134] (697s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[323.793856] Starting subtest: etime-multi-wait-all-submitted-signaled
[323.900044] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.106s)
[324.000726] [056/134] (697s left) kms_invalid_mode (overflow-vrefresh)
[324.097224] Starting subtest: overflow-vrefresh
[324.099467] Starting dynamic subtest: pipe-A-eDP-1
[324.382713] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[324.392691] Starting dynamic subtest: pipe-B-eDP-1
[324.394849] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[324.403838] Starting dynamic subtest: pipe-C-eDP-1
[324.406149] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[324.415408] Starting dynamic subtest: pipe-D-eDP-1
[324.417711] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[324.419910] Subtest overflow-vrefresh: SUCCESS (0.290s)
[325.191643] [057/134] (696s left) kms_pm_rpm (i2c)
[327.120963] Starting subtest: i2c
[332.130146] Subtest i2c: SUCCESS (5.011s)
[332.246159] [058/134] (689s left) gem_exec_balancer (busy)
[332.317344] Starting subtest: busy
[333.933961] Subtest busy: SUCCESS (1.615s)
[334.305429] [059/134] (687s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[339.364644] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[339.372047] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.003s)
[340.244909] [060/134] (681s left) gen9_exec_parse (batch-without-end)
[340.305247] Subtest batch-without-end: SKIP (0.000s)
[340.392654] [061/134] (681s left) gem_ctx_shared (exec-shared-gtt)
[340.470111] Starting subtest: exec-shared-gtt
[340.472131] Starting dynamic subtest: rcs0
[340.475940] Dynamic subtest rcs0: SUCCESS (0.008s)
[340.488275] Starting dynamic subtest: bcs0
[340.490487] Dynamic subtest bcs0: SUCCESS (0.005s)
[340.500175] Starting dynamic subtest: vcs0
[340.502380] Dynamic subtest vcs0: SUCCESS (0.006s)
[340.511607] Starting dynamic subtest: vcs1
[340.513788] Dynamic subtest vcs1: SUCCESS (0.005s)
[340.523219] Starting dynamic subtest: vecs0
[340.525079] Dynamic subtest vecs0: SUCCESS (0.005s)
[340.533899] Starting dynamic subtest: ccs0
[340.535760] Dynamic subtest ccs0: SUCCESS (0.005s)
[340.537609] Subtest exec-shared-gtt: SUCCESS (0.040s)
[340.721343] [062/134] (681s left) perf (invalid-oa-metric-set-id)
[340.861172] Starting subtest: invalid-oa-metric-set-id
[340.872165] Subtest invalid-oa-metric-set-id: SUCCESS (0.011s)
[340.913352] [063/134] (681s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[340.978737] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[340.981068] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[341.115158] [064/134] (680s left) gem_tiled_pread_pwrite
[341.250453] [065/134] (680s left) i915_pm_rps (thresholds-park)
[341.315284] Starting subtest: thresholds-park
[341.318891] Subtest thresholds-park: SKIP (0.001s)
[341.441024] [066/134] (680s left) gem_ctx_engines (invalid-engines)
[341.504420] Starting subtest: invalid-engines
[341.512050] Subtest invalid-engines: SUCCESS (0.008s)
[341.775148] [067/134] (680s left) vgem_basic (create)
[341.813901] Starting subtest: create
[341.815797] Subtest create: SUCCESS (0.000s)
[341.894929] [068/134] (680s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[341.988052] Starting subtest: fbc-psr2-sprite-mmap-cpu
[341.990210] Starting dynamic subtest: eDP-1
[341.994148] Dynamic subtest eDP-1: SKIP (0.000s)
[341.998124] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[342.087836] [069/134] (680s left) gem_mmap_gtt (big-copy-odd)
[342.144338] Subtest big-copy-odd: SKIP (0.000s)
[342.208948] [070/134] (680s left) gem_exec_reloc (basic-gtt-cpu-active)
[342.264140] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[342.347076] [071/134] (680s left) prime_busy (before-wait)
[342.398620] Starting subtest: before-wait
[342.404189] Starting dynamic subtest: rcs0
[342.450857] Dynamic subtest rcs0: SUCCESS (0.048s)
[342.461511] Starting dynamic subtest: bcs0
[342.523531] Dynamic subtest bcs0: SUCCESS (0.072s)
[342.534036] Starting dynamic subtest: vcs0
[342.565767] Dynamic subtest vcs0: SUCCESS (0.042s)
[342.575442] Starting dynamic subtest: vcs1
[342.607128] Dynamic subtest vcs1: SUCCESS (0.040s)
[342.616560] Starting dynamic subtest: vecs0
[342.646841] Dynamic subtest vecs0: SUCCESS (0.039s)
[342.655754] Starting dynamic subtest: ccs0
[342.686435] Dynamic subtest ccs0: SUCCESS (0.039s)
[342.795073] Subtest before-wait: SUCCESS (0.395s)
[342.894246] [072/134] (679s left) gem_exec_fence (keep-in-fence)
[343.070678] Starting subtest: keep-in-fence
[343.073146] Starting dynamic subtest: rcs0
[343.147654] Dynamic subtest rcs0: SUCCESS (0.077s)
[343.159217] Starting dynamic subtest: bcs0
[343.201702] Dynamic subtest bcs0: SUCCESS (0.051s)
[343.216724] Starting dynamic subtest: vcs0
[344.920978] Dynamic subtest vcs0: SUCCESS (1.715s)
[344.933074] Starting dynamic subtest: vcs1
[346.903910] Dynamic subtest vcs1: SUCCESS (1.980s)
[346.916039] Starting dynamic subtest: vecs0
[348.887908] Dynamic subtest vecs0: SUCCESS (1.981s)
[348.899607] Starting dynamic subtest: ccs0
[349.136184] Dynamic subtest ccs0: SUCCESS (0.248s)
[349.138667] Subtest keep-in-fence: SUCCESS (6.067s)
[351.065321] [073/134] (671s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[351.169151] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[354.872890] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.707s)
[356.078298] [074/134] (666s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[356.170444] Starting subtest: 4-tiled-8bpp-rotate-270
[356.194726] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.024s)
[356.357144] [075/134] (666s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[361.424887] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[361.427179] Starting dynamic subtest: pipe-A-eDP-1
[362.214104] Dynamic subtest pipe-A-eDP-1: SKIP (0.786s)
[362.224662] Starting dynamic subtest: pipe-B-eDP-1
[363.343298] Dynamic subtest pipe-B-eDP-1: SKIP (1.125s)
[363.347535] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.917s)
[364.550706] [076/134] (658s left) gem_ccs (block-multicopy-inplace)
[364.627195] Starting subtest: block-multicopy-inplace
[364.631608] Subtest block-multicopy-inplace: SKIP (0.000s)
[364.761284] [077/134] (657s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[364.874623] Starting subtest: x-tiled-addfb-size-offset-overflow
[364.876943] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[365.003445] [078/134] (657s left) kms_atomic (crtc-invalid-params)
[365.099135] Starting subtest: crtc-invalid-params
[365.101246] Starting dynamic subtest: pipe-A-eDP-1
[365.459471] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.359s)
[365.461368] Subtest crtc-invalid-params: SUCCESS (0.361s)
[366.275263] [079/134] (656s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[366.370935] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[366.372804] Starting dynamic subtest: pipe-A-eDP-1
[366.393607] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[366.404602] Starting dynamic subtest: pipe-B-eDP-1
[366.424410] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[366.434228] Starting dynamic subtest: pipe-C-eDP-1
[366.453662] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[366.464134] Starting dynamic subtest: pipe-D-eDP-1
[366.484060] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[366.485939] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.085s)
[368.656331] [080/134] (654s left) gem_lmem_swapping (heavy-verify-multi)
[368.703786] Subtest heavy-verify-multi: SKIP (0.000s)
[368.746388] [081/134] (654s left) kms_chamelium_frames (hdmi-crc-fast)
[369.136964] Subtest hdmi-crc-fast: SKIP (0.000s)
[369.944494] [082/134] (652s left) kms_vblank (query-forked-busy-hang)
[370.049050] Starting subtest: query-forked-busy-hang
[370.050894] Starting dynamic subtest: pipe-A-eDP-1
[396.756702] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.707s)
[396.771995] Starting dynamic subtest: pipe-D-eDP-1
[411.683684] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.921s)
[411.685858] Subtest query-forked-busy-hang: SUCCESS (41.633s)
[412.546135] [083/134] (610s left) kms_big_fb (linear-16bpp-rotate-90)
[412.643438] Starting subtest: linear-16bpp-rotate-90
[412.666242] Subtest linear-16bpp-rotate-90: SKIP (0.020s)
[412.813080] [084/134] (610s left) gem_flink_race (flink_close)
[412.855053] Starting subtest: flink_close
[417.946547] Subtest flink_close: SUCCESS (5.093s)
[418.052208] [085/134] (604s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[418.177545] Starting subtest: fbcpsr-modesetfrombusy
[424.309436] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.134s)
[424.494925] [086/134] (598s left) gem_exec_schedule (thriceslice)
[424.569729] Starting subtest: thriceslice
[424.571551] Starting dynamic subtest: rcs0
[424.596070] Dynamic subtest rcs0: SUCCESS (0.030s)
[424.607174] Starting dynamic subtest: bcs0
[424.625406] Dynamic subtest bcs0: SUCCESS (0.029s)
[424.634450] Starting dynamic subtest: vcs0
[424.655167] Dynamic subtest vcs0: SUCCESS (0.029s)
[424.664045] Starting dynamic subtest: vcs1
[424.706045] Dynamic subtest vcs1: SUCCESS (0.050s)
[424.717466] Starting dynamic subtest: vecs0
[424.736172] Dynamic subtest vecs0: SUCCESS (0.028s)
[424.745251] Starting dynamic subtest: ccs0
[424.787787] Dynamic subtest ccs0: SUCCESS (0.050s)
[424.790204] Subtest thriceslice: SUCCESS (0.223s)
[426.006348] [087/134] (597s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[426.101339] Starting subtest: flip-vs-dpms-off-vs-modeset
[426.103528] Starting dynamic subtest: A-eDP1
[429.701353] Dynamic subtest A-eDP1: SUCCESS (3.600s)
[429.711653] Starting dynamic subtest: B-eDP1
[432.894322] Dynamic subtest B-eDP1: SUCCESS (3.190s)
[432.904373] Starting dynamic subtest: C-eDP1
[435.984110] Dynamic subtest C-eDP1: SUCCESS (3.089s)
[435.993889] Starting dynamic subtest: D-eDP1
[439.089646] Dynamic subtest D-eDP1: SUCCESS (3.105s)
[439.091837] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (12.992s)
[439.910495] [088/134] (583s left) i915_pm_rps (min-max-config-idle)
[439.972883] Starting subtest: min-max-config-idle
[439.977487] Subtest min-max-config-idle: SKIP (0.000s)
[440.099469] [089/134] (583s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[440.199657] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[446.823558] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.626s)
[446.973129] [090/134] (576s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[452.031568] Starting subtest: psr2-overlay-plane-move-continuous-sf
[452.033845] Starting dynamic subtest: pipe-A-eDP-1
[458.730137] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.697s)
[458.740975] Starting dynamic subtest: pipe-B-eDP-1
[465.467516] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.733s)
[465.469930] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.434s)
[466.368974] [091/134] (556s left) kms_concurrent (multi-plane-atomic-lowres)
[466.469270] Starting subtest: multi-plane-atomic-lowres
[466.471421] Starting dynamic subtest: pipe-A-eDP-1
[466.992899] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.520s)
[466.995261] Subtest multi-plane-atomic-lowres: SUCCESS (0.522s)
[467.820891] [092/134] (555s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[467.927278] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[467.931377] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[468.046671] [093/134] (555s left) api_intel_allocator (reopen)
[468.105071] Starting subtest: reopen
[468.107360] Subtest reopen: SUCCESS (0.004s)
[468.268625] [094/134] (555s left) kms_flip (dpms-vs-vblank-race)
[468.361072] Starting subtest: dpms-vs-vblank-race
[468.363320] Starting dynamic subtest: A-eDP1
[473.387445] Dynamic subtest A-eDP1: SUCCESS (5.022s)
[473.398122] Starting dynamic subtest: B-eDP1
[477.997612] Dynamic subtest B-eDP1: SUCCESS (4.608s)
[478.007990] Starting dynamic subtest: C-eDP1
[482.614788] Dynamic subtest C-eDP1: SUCCESS (4.618s)
[482.624374] Starting dynamic subtest: D-eDP1
[487.238065] Dynamic subtest D-eDP1: SUCCESS (4.621s)
[487.240708] Subtest dpms-vs-vblank-race: SUCCESS (18.877s)
[488.125756] [095/134] (535s left) syncobj_timeline (single-wait-all-available-signaled)
[488.203136] Starting subtest: single-wait-all-available-signaled
[488.205232] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[488.327209] [096/134] (535s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[488.428030] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[488.429869] Starting dynamic subtest: pipe-A-eDP-1
[489.742056] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.313s)
[490.026051] Starting dynamic subtest: pipe-B-eDP-1
[491.068514] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.051s)
[491.336524] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.908s)
[492.211924] [097/134] (531s left) gem_exec_params (rs-invalid)
[492.280505] Starting subtest: rs-invalid
[492.285980] Subtest rs-invalid: SUCCESS (0.003s)
[492.435432] [098/134] (531s left) kms_scaling_modes (scaling-mode-full-aspect)
[492.536918] Starting subtest: scaling-mode-full-aspect
[492.538765] Starting dynamic subtest: pipe-A-eDP-1
[492.629459] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[492.639591] Starting dynamic subtest: pipe-B-eDP-1
[493.813069] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.181s)
[493.824332] Starting dynamic subtest: pipe-C-eDP-1
[494.924302] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.110s)
[494.936904] Starting dynamic subtest: pipe-D-eDP-1
[496.055267] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.128s)
[496.057447] Subtest scaling-mode-full-aspect: SUCCESS (3.521s)
[497.252247] [099/134] (526s left) kms_plane (plane-panning-top-left)
[497.357057] Starting subtest: plane-panning-top-left
[497.359216] Starting dynamic subtest: pipe-A
[499.065738] Dynamic subtest pipe-A: SUCCESS (1.708s)
[499.079650] Starting dynamic subtest: pipe-B
[501.484616] Dynamic subtest pipe-B: SUCCESS (2.415s)
[501.486961] Subtest plane-panning-top-left: SUCCESS (4.128s)
[502.388887] [100/134] (521s left) kms_psr (psr2-sprite-mmap-cpu)
[502.494827] Starting subtest: psr2-sprite-mmap-cpu
[502.496926] Starting dynamic subtest: eDP-1
[504.260098] Dynamic subtest eDP-1: SUCCESS (1.764s)
[504.262533] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.766s)
[505.152766] [101/134] (518s left) gem_exec_params (rel-constants-invalid-ring)
[505.234952] Starting subtest: rel-constants-invalid-ring
[505.237364] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[505.369289] [102/134] (518s left) i915_query (query-garbage)
[505.429634] Starting subtest: query-garbage
[505.432056] Subtest query-garbage: SUCCESS (0.000s)
[505.570951] [103/134] (518s left) kms_psr (psr-cursor-mmap-cpu)
[505.670759] Starting subtest: psr-cursor-mmap-cpu
[505.672973] Starting dynamic subtest: eDP-1
[507.426964] Dynamic subtest eDP-1: SUCCESS (1.756s)
[507.429249] Subtest psr-cursor-mmap-cpu: SUCCESS (1.758s)
[508.326206] [104/134] (515s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[508.443442] Starting subtest: y-tiled-16bpp-rotate-90
[508.447560] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[508.561393] [105/134] (515s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[508.647161] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[508.651811] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[509.765594] [106/134] (514s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[509.884051] Starting subtest: flip-vs-cursor-legacy
[517.044438] Subtest flip-vs-cursor-legacy: SUCCESS (7.158s)
[517.921505] [107/134] (505s left) kms_frontbuffer_tracking (fbcpsr-argb161616f-draw-blt)
[518.024319] Starting subtest: fbcpsr-argb161616f-draw-blt
[518.028333] Subtest fbcpsr-argb161616f-draw-blt: SKIP (0.000s)
[518.145702] [108/134] (505s left) kms_flip (flip-vs-fences)
[518.243560] Starting subtest: flip-vs-fences
[518.247732] Subtest flip-vs-fences: SKIP (0.000s)
[518.403958] [109/134] (505s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[518.474736] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[518.546841] [110/134] (505s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[518.647059] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[518.649293] Starting dynamic subtest: pipe-A-eDP-1
[519.571455] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.919s)
[519.584794] Starting dynamic subtest: pipe-B-eDP-1
[521.170143] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.594s)
[521.181212] Starting dynamic subtest: pipe-C-eDP-1
[522.713667] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.541s)
[522.724880] Starting dynamic subtest: pipe-D-eDP-1
[524.273192] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.558s)
[524.275727] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.618s)
[525.522784] [111/134] (498s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[525.628836] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[525.633257] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[525.757357] [112/134] (498s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[525.853387] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[525.855315] Starting dynamic subtest: pipe-A-eDP-1
[526.602264] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.740s)
[526.616650] Starting dynamic subtest: pipe-B-eDP-1
[528.465223] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.862s)
[528.479499] Starting dynamic subtest: pipe-C-eDP-1
[530.277446] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.811s)
[530.287669] Starting dynamic subtest: pipe-D-eDP-1
[532.125920] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.846s)
[532.128297] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.266s)
[533.362098] [113/134] (490s left) i915_drm_fdinfo (memory-info-shared)
[533.401944] Starting subtest: memory-info-shared
[533.404645] Starting dynamic subtest: smem0
[533.477798] Dynamic subtest smem0: SUCCESS (0.076s)
[533.480636] Subtest memory-info-shared: SUCCESS (0.077s)
[533.576905] [114/134] (490s left) gem_exec_flush (basic-wb-set-default)
[533.646868] Starting subtest: basic-wb-set-default
[539.099774] Subtest basic-wb-set-default: SUCCESS (5.453s)
[539.311745] [115/134] (484s left) sysfs_timeslice_duration (timeout)
[539.377055] Starting subtest: timeout
[539.379458] Starting dynamic subtest: vecs0
[548.906384] Dynamic subtest vecs0: SUCCESS (9.525s)
[548.921027] Starting dynamic subtest: ccs0
[550.248685] Dynamic subtest ccs0: SUCCESS (1.343s)
[550.260845] Starting dynamic subtest: vcs0
[559.911231] Dynamic subtest vcs0: SUCCESS (9.658s)
[559.923510] Starting dynamic subtest: bcs0
[560.612580] Dynamic subtest bcs0: SUCCESS (0.700s)
[560.624541] Starting dynamic subtest: rcs0
[561.997040] Dynamic subtest rcs0: SUCCESS (1.383s)
[562.009337] Starting dynamic subtest: vcs1
[571.947965] Dynamic subtest vcs1: SUCCESS (9.947s)
[571.950579] Subtest timeout: SUCCESS (32.568s)
[572.047876] [116/134] (452s left) sriov_basic (enable-vfs-bind-unbind-each)
[572.106087] Starting subtest: enable-vfs-bind-unbind-each
[572.108576] Starting dynamic subtest: numvfs-1
[572.190781] Dynamic subtest numvfs-1: FAIL (0.031s)
[572.202670] Starting dynamic subtest: numvfs-2
[572.276319] Dynamic subtest numvfs-2: FAIL (0.004s)
[572.287985] Starting dynamic subtest: numvfs-3
[572.362547] Dynamic subtest numvfs-3: FAIL (0.004s)
[572.373931] Starting dynamic subtest: numvfs-4
[572.446608] Dynamic subtest numvfs-4: FAIL (0.007s)
[572.458312] Starting dynamic subtest: numvfs-5
[572.531269] Dynamic subtest numvfs-5: FAIL (0.003s)
[572.542188] Starting dynamic subtest: numvfs-6
[572.616306] Dynamic subtest numvfs-6: FAIL (0.004s)
[572.627188] Starting dynamic subtest: numvfs-7
[572.700294] Dynamic subtest numvfs-7: FAIL (0.004s)
[572.711702] Starting dynamic subtest: numvfs-random
[572.784279] Dynamic subtest numvfs-random: FAIL (0.005s)
[572.786870] Subtest enable-vfs-bind-unbind-each: FAIL (0.067s)
[572.827894] [117/134] (451s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[572.924720] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[572.929064] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[574.087429] [118/134] (450s left) kms_getfb (getfb-handle-not-fb)
[574.185041] Starting subtest: getfb-handle-not-fb
[574.187287] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[574.331255] [119/134] (450s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[574.401848] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[574.406465] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[574.610346] [120/134] (449s left) gem_workarounds (reset-context)
[574.667844] Starting subtest: reset-context
[574.837643] Subtest reset-context: SUCCESS (0.169s)
[575.008334] [121/134] (449s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[575.118622] Starting subtest: psr-farfromfence-mmap-gtt
[575.123174] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[575.250299] [122/134] (449s left) gem_wait (write-busy)
[575.316452] Starting subtest: write-busy
[575.318802] Starting dynamic subtest: all-engines
[575.906811] Dynamic subtest all-engines: SUCCESS (0.593s)
[575.923379] Starting dynamic subtest: rcs0
[576.463560] Dynamic subtest rcs0: SUCCESS (0.554s)
[576.479882] Starting dynamic subtest: bcs0
[577.014926] Dynamic subtest bcs0: SUCCESS (0.550s)
[577.032525] Starting dynamic subtest: vcs0
[578.903092] Dynamic subtest vcs0: SUCCESS (1.885s)
[578.919997] Starting dynamic subtest: vcs1
[580.887600] Dynamic subtest vcs1: SUCCESS (1.982s)
[580.903934] Starting dynamic subtest: vecs0
[582.935621] Dynamic subtest vecs0: SUCCESS (2.045s)
[582.952807] Starting dynamic subtest: ccs0
[583.487241] Dynamic subtest ccs0: SUCCESS (0.551s)
[583.489629] Subtest write-busy: SUCCESS (8.174s)
[583.710228] [123/134] (440s left) i915_hangman (detector)
[583.783810] Starting subtest: detector
[583.786117] Starting dynamic subtest: rcs0
[592.886626] Dynamic subtest rcs0: SUCCESS (9.101s)
[592.898496] Starting dynamic subtest: bcs0
[604.854343] Dynamic subtest bcs0: SUCCESS (11.964s)
[604.867541] Starting dynamic subtest: vcs0
[616.822780] Dynamic subtest vcs0: SUCCESS (11.965s)
[616.833625] Starting dynamic subtest: vcs1
[628.854602] Dynamic subtest vcs1: SUCCESS (12.028s)
[628.867170] Starting dynamic subtest: vecs0
[640.822485] Dynamic subtest vecs0: SUCCESS (11.965s)
[640.836930] Starting dynamic subtest: ccs0
[652.854195] Dynamic subtest ccs0: SUCCESS (12.028s)
[652.857048] Subtest detector: SUCCESS (69.068s)
[652.967933] [124/134] (371s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[653.068061] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[653.072190] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[653.202219] [125/134] (371s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[653.321058] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[653.325238] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[653.488772] [126/134] (371s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[653.556560] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[653.627831] [127/134] (371s left) gem_exec_schedule (noreorder-corked)
[653.811629] Starting subtest: noreorder-corked
[653.814064] Starting dynamic subtest: rcs0
[654.967824] Dynamic subtest rcs0: SUCCESS (1.156s)
[654.980623] Starting dynamic subtest: vcs0
[656.936289] Dynamic subtest vcs0: SUCCESS (1.965s)
[656.948628] Starting dynamic subtest: vcs1
[658.922321] Dynamic subtest vcs1: SUCCESS (1.983s)
[658.934531] Starting dynamic subtest: vecs0
[660.909243] Dynamic subtest vecs0: SUCCESS (1.985s)
[660.921833] Starting dynamic subtest: ccs0
[662.077895] Dynamic subtest ccs0: SUCCESS (1.168s)
[662.080557] Subtest noreorder-corked: SUCCESS (8.268s)
[662.290832] [128/134] (362s left) kms_psr (pr-cursor-mmap-cpu)
[662.393790] Starting subtest: pr-cursor-mmap-cpu
[662.398106] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[662.492639] [129/134] (362s left) perf (invalid-oa-format-id)
[662.590061] Starting subtest: invalid-oa-format-id
[662.599154] Subtest invalid-oa-format-id: SUCCESS (0.007s)
[662.643257] [130/134] (362s left) gem_eio (in-flight-internal-immediate)
[662.825789] Starting subtest: in-flight-internal-immediate
[663.954132] Subtest in-flight-internal-immediate: SUCCESS (1.128s)
[664.108580] [131/134] (360s left) kms_cursor_edge_walk (256x256-top-edge)
[664.212825] Starting subtest: 256x256-top-edge
[664.215098] Starting dynamic subtest: pipe-A-eDP-1
[667.623544] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.409s)
[667.634123] Starting dynamic subtest: pipe-D-eDP-1
[670.745779] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.122s)
[670.748126] Subtest 256x256-top-edge: SUCCESS (6.534s)
[671.577503] [132/134] (353s left) gem_ctx_persistence (engines-persistence)
[671.649326] Starting subtest: engines-persistence
[671.651471] Starting dynamic subtest: rcs0
[672.454859] Dynamic subtest rcs0: SUCCESS (0.807s)
[672.467818] Starting dynamic subtest: bcs0
[673.259913] Dynamic subtest bcs0: SUCCESS (0.803s)
[673.272337] Starting dynamic subtest: vcs0
[674.020899] Dynamic subtest vcs0: SUCCESS (0.759s)
[674.033655] Starting dynamic subtest: vcs1
[674.798342] Dynamic subtest vcs1: SUCCESS (0.774s)
[674.810082] Starting dynamic subtest: vecs0
[675.620069] Dynamic subtest vecs0: SUCCESS (0.819s)
[675.632381] Starting dynamic subtest: ccs0
[676.357864] Dynamic subtest ccs0: SUCCESS (0.735s)
[676.360428] Subtest engines-persistence: SUCCESS (4.712s)
[676.527826] [133/134] (348s left) api_intel_bb (render-ccs)
[676.590389] Starting subtest: render-ccs
[676.958275] Subtest render-ccs: SUCCESS (0.369s)
[677.085540] [134/134] (347s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[677.198650] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[677.202853] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[677.326299] 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.