[57.938038] Initializing watchdogs
[57.938091]   /dev/watchdog0
[57.955054] [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]
[57.959540] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.961827] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.965192] [001/134] (960s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[58.089990] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[58.092327] Starting dynamic subtest: pipe-A
[58.177684] Dynamic subtest pipe-A: SUCCESS (0.087s)
[58.193828] Starting dynamic subtest: pipe-B
[59.339762] Dynamic subtest pipe-B: SUCCESS (1.151s)
[59.349221] Starting dynamic subtest: pipe-C
[60.455615] Dynamic subtest pipe-C: SUCCESS (1.107s)
[60.464885] Starting dynamic subtest: pipe-D
[61.605773] Dynamic subtest pipe-D: SUCCESS (1.142s)
[61.608241] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.491s)
[62.787194] [002/134] (955s left) gem_userptr_blits (forbidden-operations)
[62.859828] Starting subtest: forbidden-operations
[62.864263] Subtest forbidden-operations: SKIP (0.000s)
[63.035974] [003/134] (955s left) gem_mmap_gtt (big-bo)
[63.094151] Subtest big-bo: SKIP (0.000s)
[63.150606] [004/134] (955s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[63.255753] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[70.618946] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.343s)
[70.776573] [005/134] (947s left) kms_fence_pin_leak
[70.961973] [006/134] (947s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[71.077714] Starting subtest: x-tiled-16bpp-rotate-180
[72.347269] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.267s)
[72.503340] [007/134] (946s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[72.566237] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[72.625173] [008/134] (946s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[72.712037] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[72.723402] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.010s)
[72.859130] [009/134] (945s left) perf_pmu (busy-check-all)
[72.895227] Starting subtest: busy-check-all
[72.897176] Starting dynamic subtest: rcs0
[73.467571] Dynamic subtest rcs0: SUCCESS (0.571s)
[73.479060] Starting dynamic subtest: bcs0
[74.017799] Dynamic subtest bcs0: SUCCESS (0.550s)
[74.028898] Starting dynamic subtest: vcs0
[75.929907] Dynamic subtest vcs0: SUCCESS (1.907s)
[75.940746] Starting dynamic subtest: vcs1
[77.909102] Dynamic subtest vcs1: SUCCESS (1.976s)
[77.920044] Starting dynamic subtest: vecs0
[79.893227] Dynamic subtest vecs0: SUCCESS (1.980s)
[79.904702] Starting dynamic subtest: ccs0
[80.447337] Dynamic subtest ccs0: SUCCESS (0.554s)
[80.449981] Subtest busy-check-all: SUCCESS (7.545s)
[80.575425] [010/134] (938s left) gem_mmap_wc (coherency)
[80.635503] Subtest coherency: SKIP (0.000s)
[80.691205] [011/134] (938s left) kms_big_fb (yf-tiled-addfb)
[80.803268] Starting subtest: yf-tiled-addfb
[80.807523] Subtest yf-tiled-addfb: SKIP (0.000s)
[80.920304] [012/134] (937s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[81.023606] Starting subtest: extended-modeset-hang-oldfb-with-reset
[81.026121] Starting dynamic subtest: pipe-A
[92.594839] Dynamic subtest pipe-A: SUCCESS (11.561s)
[92.605366] Starting dynamic subtest: pipe-D
[104.883987] Dynamic subtest pipe-D: SUCCESS (12.282s)
[104.886429] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.846s)
[105.688488] [013/134] (913s left) kms_plane_alpha_blend (constant-alpha-min)
[105.793979] Starting subtest: constant-alpha-min
[106.081059] Starting dynamic subtest: pipe-A-eDP-1
[106.779356] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.696s)
[106.788641] Starting dynamic subtest: pipe-D-eDP-1
[108.217224] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.436s)
[108.219510] Subtest constant-alpha-min: SUCCESS (2.424s)
[109.064028] [014/134] (909s left) sysfs_timeslice_duration (duration)
[109.132389] Starting subtest: duration
[109.134414] Starting dynamic subtest: vecs0
[122.804861] Dynamic subtest vecs0: SUCCESS (13.669s)
[122.816248] Starting dynamic subtest: ccs0
[135.986756] Dynamic subtest ccs0: SUCCESS (13.179s)
[135.998018] Starting dynamic subtest: vcs0
[149.810108] Dynamic subtest vcs0: SUCCESS (13.820s)
[149.820320] Starting dynamic subtest: bcs0
[162.937699] Dynamic subtest bcs0: SUCCESS (13.116s)
[162.946848] Starting dynamic subtest: rcs0
[176.098425] Dynamic subtest rcs0: SUCCESS (13.170s)
[176.110603] Starting dynamic subtest: vcs1
[189.811476] Dynamic subtest vcs1: SUCCESS (13.709s)
[189.814403] Subtest duration: SUCCESS (80.672s)
[189.911366] [015/134] (829s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[190.028314] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[193.619398] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.594s)
[194.768697] [016/134] (824s left) kms_cursor_crc (cursor-onscreen-64x64)
[194.956691] Starting subtest: cursor-onscreen-64x64
[194.958926] Starting dynamic subtest: pipe-A-eDP-1
[197.056044] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.096s)
[197.084089] Starting dynamic subtest: pipe-D-eDP-1
[199.804913] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.725s)
[199.807224] Subtest cursor-onscreen-64x64: SUCCESS (4.846s)
[200.624384] [017/134] (818s left) kms_color (ctm-red-to-blue)
[200.734120] Starting subtest: ctm-red-to-blue
[200.736392] Starting dynamic subtest: pipe-A-eDP-1
[201.445749] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.708s)
[201.456190] Starting dynamic subtest: pipe-B-eDP-1
[202.823058] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.379s)
[202.831866] Starting dynamic subtest: pipe-C-eDP-1
[204.219442] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.396s)
[204.227634] Starting dynamic subtest: pipe-D-eDP-1
[205.636449] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.416s)
[205.638891] Subtest ctm-red-to-blue: SUCCESS (4.901s)
[206.459095] [018/134] (812s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[206.520682] Subtest writes-after-reads-uncached: SKIP (0.000s)
[206.588333] [019/134] (812s left) dumb_buffer (invalid-bpp)
[206.646968] Starting subtest: invalid-bpp
[206.649166] Subtest invalid-bpp: SUCCESS (0.000s)
[206.788451] [020/134] (812s left) gem_mmap_gtt (ptrace)
[206.851205] Subtest ptrace: SKIP (0.000s)
[206.909062] [021/134] (812s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[207.029992] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[207.034432] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[207.202169] [022/134] (812s left) gem_lmem_swapping (verify)
[207.245960] Subtest verify: SKIP (0.000s)
[207.280699] [023/134] (812s left) gem_spin_batch (resubmit-new)
[207.339912] Starting subtest: resubmit-new
[207.341867] Starting dynamic subtest: rcs0
[207.346369] Dynamic subtest rcs0: SUCCESS (0.007s)
[207.354673] Starting dynamic subtest: bcs0
[207.356560] Dynamic subtest bcs0: SUCCESS (0.003s)
[207.364578] Starting dynamic subtest: vcs0
[207.366925] Dynamic subtest vcs0: SUCCESS (0.004s)
[207.374196] Starting dynamic subtest: vcs1
[207.375950] Dynamic subtest vcs1: SUCCESS (0.005s)
[207.383153] Starting dynamic subtest: vecs0
[207.384858] Dynamic subtest vecs0: SUCCESS (0.004s)
[207.391973] Starting dynamic subtest: ccs0
[207.393827] Dynamic subtest ccs0: SUCCESS (0.004s)
[207.395580] Subtest resubmit-new: SUCCESS (0.028s)
[208.975933] [024/134] (810s left) kms_cursor_crc (cursor-random-512x512)
[209.266372] Starting subtest: cursor-random-512x512
[209.270774] Subtest cursor-random-512x512: SKIP (0.001s)
[209.445143] [025/134] (809s left) kms_properties (plane-properties-legacy)
[209.550673] Starting subtest: plane-properties-legacy
[209.553081] Starting dynamic subtest: pipe-A-eDP-1
[210.106848] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.557s)
[210.115790] Starting dynamic subtest: pipe-B-eDP-1
[211.405797] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.295s)
[211.414808] Starting dynamic subtest: pipe-C-eDP-1
[212.647453] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.243s)
[212.656683] Starting dynamic subtest: pipe-D-eDP-1
[213.880128] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.230s)
[213.882411] Subtest plane-properties-legacy: SUCCESS (4.330s)
[214.715895] [026/134] (804s left) kms_vrr (flipline)
[214.818659] Starting subtest: flipline
[214.825326] Subtest flipline: SKIP (0.000s)
[214.913492] [027/134] (804s left) gem_exec_params (secure-non-master)
[214.963699] Starting subtest: secure-non-master
[214.968555] Subtest secure-non-master: SKIP (0.000s)
[215.108642] [028/134] (804s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[215.363227] Starting subtest: parallel-dmabuf-import-out-fence
[216.497020] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.136s)
[216.637769] [029/134] (802s left) kms_pm_dc (dc5-dpms-negative)
[217.741080] Starting subtest: dc5-dpms-negative
[217.745639] Subtest dc5-dpms-negative: SKIP (0.000s)
[217.837952] [030/134] (801s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[217.933853] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[217.938291] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[218.050507] [031/134] (801s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[218.151367] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[225.070556] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.922s)
[225.214739] [032/134] (794s left) kms_frontbuffer_tracking (psr-argb161616f-draw-mmap-cpu)
[225.311122] Starting subtest: psr-argb161616f-draw-mmap-cpu
[225.315322] Subtest psr-argb161616f-draw-mmap-cpu: SKIP (0.000s)
[225.437128] [033/134] (794s left) gem_exec_whisper (basic-fds-all)
[225.508125] Starting subtest: basic-fds-all
[236.901310] Subtest basic-fds-all: SUCCESS (11.391s)
[237.139797] [034/134] (782s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[237.252586] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[237.256905] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[237.366025] [035/134] (782s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[237.468545] Starting subtest: psr-rgb565-draw-render
[244.583091] Subtest psr-rgb565-draw-render: SUCCESS (7.118s)
[244.743024] [036/134] (775s left) gem_render_copy_redux (flink)
[244.814169] Starting subtest: flink
[245.638793] Subtest flink: SUCCESS (0.825s)
[245.792187] [037/134] (774s left) gem_mmap_wc (bad-offset)
[245.861210] Subtest bad-offset: SKIP (0.000s)
[245.931976] [038/134] (774s left) gem_pxp (reject-modify-context-protection-off-2)
[246.062366] Starting subtest: reject-modify-context-protection-off-2
[246.064792] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[246.202082] [039/134] (773s left) kms_3d (basic)
[246.256815] Starting subtest: basic
[248.237727] Subtest basic: SUCCESS (1.982s)
[248.742971] [040/134] (771s left) gem_ctx_persistence (smoketest)
[248.812864] Starting subtest: smoketest
[288.819263] Subtest smoketest: SUCCESS (40.003s)
[288.918514] [041/134] (731s left) kms_psr (fbc-pr-suspend)
[289.030970] Starting subtest: fbc-pr-suspend
[289.035463] Subtest fbc-pr-suspend: SKIP (0.000s)
[289.127896] [042/134] (731s left) syncobj_timeline (multi-wait-for-submit-signaled)
[289.187039] Starting subtest: multi-wait-for-submit-signaled
[289.188993] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[289.318163] [043/134] (730s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[289.404827] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[289.407084] Starting dynamic subtest: pipe-A-default-mode
[292.118440] Dynamic subtest pipe-A-default-mode: SUCCESS (2.714s)
[292.120753] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.715s)
[292.971160] [044/134] (727s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[293.077907] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[293.080124] Starting dynamic subtest: pipe-A-default-mode
[295.849598] Dynamic subtest pipe-A-default-mode: SUCCESS (2.769s)
[295.851599] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.771s)
[296.663548] [045/134] (723s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[296.766422] Starting subtest: psr-rgb565-draw-mmap-cpu
[303.539194] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.775s)
[303.688418] [046/134] (716s left) vgem_basic (mmap)
[303.793924] Starting subtest: mmap
[303.807177] Subtest mmap: SUCCESS (0.015s)
[303.885495] [FACT vgem_basic (mmap)] new: kernel.kmod_is_loaded.vgem: true
[303.888566] [047/134] (716s left) gem_userptr_blits (sync-unmap-after-close)
[303.964971] Starting subtest: sync-unmap-after-close
[303.973288] Subtest sync-unmap-after-close: SUCCESS (0.010s)
[304.144485] [048/134] (716s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[304.543199] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[305.331712] [049/134] (715s left) kms_frontbuffer_tracking (basic)
[305.431564] Starting subtest: basic
[308.652538] Subtest basic: SUCCESS (3.223s)
[308.817105] [050/134] (711s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[308.922056] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[315.869624] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (6.949s)
[316.028673] [051/134] (704s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[316.147381] Starting subtest: fbc-rgb101010-draw-blt
[320.713958] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.570s)
[321.915594] [052/134] (698s left) kms_lease (lease-unleased-connector)
[322.018088] Starting subtest: lease-unleased-connector
[322.020402] Starting dynamic subtest: pipe-A-eDP-1
[322.025655] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[322.039111] Starting dynamic subtest: pipe-B-eDP-1
[322.041440] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[322.050376] Starting dynamic subtest: pipe-C-eDP-1
[322.052640] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[322.061236] Starting dynamic subtest: pipe-D-eDP-1
[322.063099] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[322.065057] Subtest lease-unleased-connector: SUCCESS (0.037s)
[322.194311] [053/134] (698s left) gem_tiled_partial_pwrite_pread (reads)
[322.256102] Subtest reads: SKIP (0.000s)
[322.341618] [054/134] (698s left) kms_dp_link_training (uhbr-sst)
[322.437139] Starting subtest: uhbr-sst
[322.445666] Subtest uhbr-sst: SKIP (0.000s)
[322.539488] [055/134] (698s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[322.604609] Starting subtest: etime-multi-wait-all-submitted-signaled
[322.705084] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.101s)
[322.807555] [056/134] (697s left) kms_invalid_mode (overflow-vrefresh)
[322.898620] Starting subtest: overflow-vrefresh
[322.900897] Starting dynamic subtest: pipe-A-eDP-1
[323.183913] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[323.193369] Starting dynamic subtest: pipe-B-eDP-1
[323.195569] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[323.204095] Starting dynamic subtest: pipe-C-eDP-1
[323.206356] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[323.214680] Starting dynamic subtest: pipe-D-eDP-1
[323.216633] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[323.218535] Subtest overflow-vrefresh: SUCCESS (0.290s)
[324.069962] [057/134] (696s left) kms_pm_rpm (i2c)
[326.103819] Starting subtest: i2c
[331.101222] Subtest i2c: SUCCESS (4.999s)
[331.239888] [058/134] (689s left) gem_exec_balancer (busy)
[331.310067] Starting subtest: busy
[332.870513] Subtest busy: SUCCESS (1.559s)
[333.226575] [059/134] (687s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[338.265395] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[338.269906] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.003s)
[339.144590] [060/134] (681s left) gen9_exec_parse (batch-without-end)
[339.197459] Subtest batch-without-end: SKIP (0.000s)
[339.267254] [061/134] (681s left) gem_ctx_shared (exec-shared-gtt)
[339.329163] Starting subtest: exec-shared-gtt
[339.331474] Starting dynamic subtest: rcs0
[339.338175] Dynamic subtest rcs0: SUCCESS (0.009s)
[339.346994] Starting dynamic subtest: bcs0
[339.348926] Dynamic subtest bcs0: SUCCESS (0.006s)
[339.357585] Starting dynamic subtest: vcs0
[339.359789] Dynamic subtest vcs0: SUCCESS (0.007s)
[339.368654] Starting dynamic subtest: vcs1
[339.370854] Dynamic subtest vcs1: SUCCESS (0.006s)
[339.379263] Starting dynamic subtest: vecs0
[339.381144] Dynamic subtest vecs0: SUCCESS (0.006s)
[339.388992] Starting dynamic subtest: ccs0
[339.391029] Dynamic subtest ccs0: SUCCESS (0.006s)
[339.392975] Subtest exec-shared-gtt: SUCCESS (0.044s)
[339.580717] [062/134] (681s left) perf (invalid-oa-metric-set-id)
[339.712972] Starting subtest: invalid-oa-metric-set-id
[339.725079] Subtest invalid-oa-metric-set-id: SUCCESS (0.012s)
[339.765862] [063/134] (681s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[339.824078] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[339.826310] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[339.962021] [064/134] (681s left) gem_tiled_pread_pwrite
[340.092519] [065/134] (681s left) i915_pm_rps (thresholds-park)
[340.156472] Starting subtest: thresholds-park
[340.160355] Subtest thresholds-park: SKIP (0.001s)
[340.290089] [066/134] (680s left) gem_ctx_engines (invalid-engines)
[340.355503] Starting subtest: invalid-engines
[340.363519] Subtest invalid-engines: SUCCESS (0.008s)
[340.641975] [067/134] (680s left) vgem_basic (create)
[340.682667] Starting subtest: create
[340.684819] Subtest create: SUCCESS (0.000s)
[340.762369] [068/134] (680s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[340.865609] Starting subtest: fbc-psr2-sprite-mmap-cpu
[340.867846] Starting dynamic subtest: eDP-1
[340.871970] Dynamic subtest eDP-1: SKIP (0.000s)
[340.876113] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[340.961940] [069/134] (680s left) gem_mmap_gtt (big-copy-odd)
[341.018182] Subtest big-copy-odd: SKIP (0.000s)
[341.087766] [070/134] (680s left) gem_exec_reloc (basic-gtt-cpu-active)
[341.155044] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[341.235090] [071/134] (680s left) prime_busy (before-wait)
[341.289171] Starting subtest: before-wait
[341.291543] Starting dynamic subtest: rcs0
[341.337491] Dynamic subtest rcs0: SUCCESS (0.048s)
[341.348722] Starting dynamic subtest: bcs0
[341.395810] Dynamic subtest bcs0: SUCCESS (0.058s)
[341.404190] Starting dynamic subtest: vcs0
[341.435406] Dynamic subtest vcs0: SUCCESS (0.039s)
[341.443688] Starting dynamic subtest: vcs1
[341.479209] Dynamic subtest vcs1: SUCCESS (0.043s)
[341.488024] Starting dynamic subtest: vecs0
[341.519926] Dynamic subtest vecs0: SUCCESS (0.040s)
[341.528462] Starting dynamic subtest: ccs0
[341.559128] Dynamic subtest ccs0: SUCCESS (0.039s)
[341.668054] Subtest before-wait: SUCCESS (0.380s)
[341.764168] [072/134] (679s left) gem_exec_fence (keep-in-fence)
[341.946200] Starting subtest: keep-in-fence
[341.948688] Starting dynamic subtest: rcs0
[342.018759] Dynamic subtest rcs0: SUCCESS (0.072s)
[342.030261] Starting dynamic subtest: bcs0
[342.072367] Dynamic subtest bcs0: SUCCESS (0.052s)
[342.083914] Starting dynamic subtest: vcs0
[343.893031] Dynamic subtest vcs0: SUCCESS (1.817s)
[343.904954] Starting dynamic subtest: vcs1
[345.940993] Dynamic subtest vcs1: SUCCESS (2.045s)
[345.956995] Starting dynamic subtest: vecs0
[347.926339] Dynamic subtest vecs0: SUCCESS (1.982s)
[347.937953] Starting dynamic subtest: ccs0
[348.160041] Dynamic subtest ccs0: SUCCESS (0.233s)
[348.162871] Subtest keep-in-fence: SUCCESS (6.214s)
[350.025544] [073/134] (671s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[350.142682] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[353.857910] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.719s)
[355.047408] [074/134] (666s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[355.154572] Starting subtest: 4-tiled-8bpp-rotate-270
[355.174795] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.019s)
[355.342809] [075/134] (666s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[360.376740] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[360.378631] Starting dynamic subtest: pipe-A-eDP-1
[361.174064] Dynamic subtest pipe-A-eDP-1: SKIP (0.794s)
[361.183082] Starting dynamic subtest: pipe-B-eDP-1
[362.304011] Dynamic subtest pipe-B-eDP-1: SKIP (1.128s)
[362.308324] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.927s)
[363.514880] [076/134] (658s left) gem_ccs (block-multicopy-inplace)
[363.578754] Starting subtest: block-multicopy-inplace
[363.582925] Subtest block-multicopy-inplace: SKIP (0.000s)
[363.723020] [077/134] (657s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[363.824893] Starting subtest: x-tiled-addfb-size-offset-overflow
[363.827154] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[363.961512] [078/134] (657s left) kms_atomic (crtc-invalid-params)
[364.058908] Starting subtest: crtc-invalid-params
[364.061081] Starting dynamic subtest: pipe-A-eDP-1
[364.412418] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.354s)
[364.414776] Subtest crtc-invalid-params: SUCCESS (0.356s)
[365.245204] [079/134] (656s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[365.343611] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[365.345786] Starting dynamic subtest: pipe-A-eDP-1
[365.365359] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s)
[365.376083] Starting dynamic subtest: pipe-B-eDP-1
[365.395519] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.019s)
[365.404646] Starting dynamic subtest: pipe-C-eDP-1
[365.424113] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.019s)
[365.433043] Starting dynamic subtest: pipe-D-eDP-1
[365.453072] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.019s)
[365.455214] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.081s)
[367.703188] [080/134] (654s left) gem_lmem_swapping (heavy-verify-multi)
[367.748767] Subtest heavy-verify-multi: SKIP (0.000s)
[367.802360] [081/134] (653s left) kms_chamelium_frames (hdmi-crc-fast)
[368.191383] Subtest hdmi-crc-fast: SKIP (0.000s)
[368.992404] [082/134] (652s left) kms_vblank (query-forked-busy-hang)
[369.097832] Starting subtest: query-forked-busy-hang
[369.100069] Starting dynamic subtest: pipe-A-eDP-1
[395.665363] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.566s)
[395.679914] Starting dynamic subtest: pipe-D-eDP-1
[410.707603] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.039s)
[410.709962] Subtest query-forked-busy-hang: SUCCESS (41.609s)
[411.577682] [083/134] (610s left) kms_big_fb (linear-16bpp-rotate-90)
[411.679667] Starting subtest: linear-16bpp-rotate-90
[411.701706] Subtest linear-16bpp-rotate-90: SKIP (0.018s)
[411.858831] [084/134] (610s left) gem_flink_race (flink_close)
[411.897932] Starting subtest: flink_close
[417.002647] Subtest flink_close: SUCCESS (5.108s)
[417.103918] [085/134] (604s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[417.223168] Starting subtest: fbcpsr-modesetfrombusy
[423.425193] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.205s)
[423.622801] [086/134] (598s left) gem_exec_schedule (thriceslice)
[423.691501] Starting subtest: thriceslice
[423.693157] Starting dynamic subtest: rcs0
[423.714930] Dynamic subtest rcs0: SUCCESS (0.030s)
[423.725576] Starting dynamic subtest: bcs0
[423.743654] Dynamic subtest bcs0: SUCCESS (0.028s)
[423.751970] Starting dynamic subtest: vcs0
[423.794505] Dynamic subtest vcs0: SUCCESS (0.050s)
[423.805702] Starting dynamic subtest: vcs1
[423.844609] Dynamic subtest vcs1: SUCCESS (0.048s)
[423.855489] Starting dynamic subtest: vecs0
[423.875463] Dynamic subtest vecs0: SUCCESS (0.029s)
[423.884505] Starting dynamic subtest: ccs0
[423.905871] Dynamic subtest ccs0: SUCCESS (0.029s)
[423.907726] Subtest thriceslice: SUCCESS (0.223s)
[424.232225] [087/134] (597s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[424.324964] Starting subtest: flip-vs-dpms-off-vs-modeset
[424.327304] Starting dynamic subtest: A-eDP1
[427.910052] Dynamic subtest A-eDP1: SUCCESS (3.583s)
[427.920516] Starting dynamic subtest: B-eDP1
[431.140294] Dynamic subtest B-eDP1: SUCCESS (3.228s)
[431.150472] Starting dynamic subtest: C-eDP1
[434.248647] Dynamic subtest C-eDP1: SUCCESS (3.107s)
[434.261571] Starting dynamic subtest: D-eDP1
[437.358131] Dynamic subtest D-eDP1: SUCCESS (3.108s)
[437.360309] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.034s)
[438.181219] [088/134] (583s left) i915_pm_rps (min-max-config-idle)
[438.243299] Starting subtest: min-max-config-idle
[438.248031] Subtest min-max-config-idle: SKIP (0.000s)
[438.381608] [089/134] (583s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[438.475508] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[444.938464] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.465s)
[445.115210] [090/134] (577s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[450.129638] Starting subtest: psr2-overlay-plane-move-continuous-sf
[450.131942] Starting dynamic subtest: pipe-A-eDP-1
[456.838053] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.704s)
[456.848101] Starting dynamic subtest: pipe-B-eDP-1
[463.472413] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.633s)
[463.474808] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.341s)
[464.384539] [091/134] (557s left) kms_concurrent (multi-plane-atomic-lowres)
[464.489135] Starting subtest: multi-plane-atomic-lowres
[464.491154] Starting dynamic subtest: pipe-A-eDP-1
[464.957973] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.469s)
[464.960347] Subtest multi-plane-atomic-lowres: SUCCESS (0.470s)
[465.809602] [092/134] (556s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[465.902431] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[465.906776] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[466.055996] [093/134] (556s left) api_intel_allocator (reopen)
[466.117898] Starting subtest: reopen
[466.120244] Subtest reopen: SUCCESS (0.003s)
[466.260346] [094/134] (556s left) kms_flip (dpms-vs-vblank-race)
[466.368329] Starting subtest: dpms-vs-vblank-race
[466.370580] Starting dynamic subtest: A-eDP1
[471.273463] Dynamic subtest A-eDP1: SUCCESS (4.905s)
[471.282912] Starting dynamic subtest: B-eDP1
[475.894705] Dynamic subtest B-eDP1: SUCCESS (4.620s)
[475.906437] Starting dynamic subtest: C-eDP1
[480.439564] Dynamic subtest C-eDP1: SUCCESS (4.542s)
[480.449319] Starting dynamic subtest: D-eDP1
[485.090657] Dynamic subtest D-eDP1: SUCCESS (4.651s)
[485.092773] Subtest dpms-vs-vblank-race: SUCCESS (18.727s)
[485.971577] [095/134] (536s left) syncobj_timeline (single-wait-all-available-signaled)
[486.040724] Starting subtest: single-wait-all-available-signaled
[486.043065] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[486.177146] [096/134] (536s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[486.272907] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[486.275145] Starting dynamic subtest: pipe-A-eDP-1
[487.599775] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.326s)
[487.876586] Starting dynamic subtest: pipe-B-eDP-1
[488.916591] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.049s)
[489.185691] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.911s)
[490.053882] [097/134] (532s left) gem_exec_params (rs-invalid)
[490.126332] Starting subtest: rs-invalid
[490.128745] Subtest rs-invalid: SUCCESS (0.003s)
[490.290777] [098/134] (532s left) kms_scaling_modes (scaling-mode-full-aspect)
[490.385797] Starting subtest: scaling-mode-full-aspect
[490.388023] Starting dynamic subtest: pipe-A-eDP-1
[490.479616] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.095s)
[490.488725] Starting dynamic subtest: pipe-B-eDP-1
[491.649677] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.169s)
[491.660441] Starting dynamic subtest: pipe-C-eDP-1
[492.849257] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.198s)
[492.859252] Starting dynamic subtest: pipe-D-eDP-1
[493.979745] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[493.982113] Subtest scaling-mode-full-aspect: SUCCESS (3.596s)
[495.167334] [099/134] (527s left) kms_plane (plane-panning-top-left)
[495.268250] Starting subtest: plane-panning-top-left
[495.270171] Starting dynamic subtest: pipe-A
[496.886426] Dynamic subtest pipe-A: SUCCESS (1.616s)
[496.896556] Starting dynamic subtest: pipe-B
[499.198099] Dynamic subtest pipe-B: SUCCESS (2.311s)
[499.200288] Subtest plane-panning-top-left: SUCCESS (3.930s)
[500.023694] [100/134] (522s left) kms_psr (psr2-sprite-mmap-cpu)
[500.132075] Starting subtest: psr2-sprite-mmap-cpu
[500.134364] Starting dynamic subtest: eDP-1
[501.894225] Dynamic subtest eDP-1: SUCCESS (1.760s)
[501.896457] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.761s)
[502.792376] [101/134] (519s left) gem_exec_params (rel-constants-invalid-ring)
[502.858641] Starting subtest: rel-constants-invalid-ring
[502.861095] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[502.992688] [102/134] (519s left) i915_query (query-garbage)
[503.051915] Starting subtest: query-garbage
[503.054108] Subtest query-garbage: SUCCESS (0.000s)
[503.192602] [103/134] (519s left) kms_psr (psr-cursor-mmap-cpu)
[503.295745] Starting subtest: psr-cursor-mmap-cpu
[503.297934] Starting dynamic subtest: eDP-1
[505.079563] Dynamic subtest eDP-1: SUCCESS (1.783s)
[505.081878] Subtest psr-cursor-mmap-cpu: SUCCESS (1.784s)
[505.942186] [104/134] (516s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[506.050581] Starting subtest: y-tiled-16bpp-rotate-90
[506.055100] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[506.182802] [105/134] (516s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[506.280874] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[506.285347] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[507.397394] [106/134] (515s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[507.515673] Starting subtest: flip-vs-cursor-legacy
[514.530193] Subtest flip-vs-cursor-legacy: SUCCESS (7.012s)
[515.429067] [107/134] (507s left) kms_frontbuffer_tracking (fbcpsr-argb161616f-draw-blt)
[515.536168] Starting subtest: fbcpsr-argb161616f-draw-blt
[515.540611] Subtest fbcpsr-argb161616f-draw-blt: SKIP (0.000s)
[515.674308] [108/134] (507s left) kms_flip (flip-vs-fences)
[515.765169] Starting subtest: flip-vs-fences
[515.769564] Subtest flip-vs-fences: SKIP (0.000s)
[515.888926] [109/134] (507s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[515.952053] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[516.034351] [110/134] (506s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[516.129546] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[516.131514] Starting dynamic subtest: pipe-A-eDP-1
[516.941236] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.807s)
[516.950290] Starting dynamic subtest: pipe-B-eDP-1
[518.606202] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.661s)
[518.616752] Starting dynamic subtest: pipe-C-eDP-1
[520.114302] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.507s)
[520.124075] Starting dynamic subtest: pipe-D-eDP-1
[521.639778] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.523s)
[521.641871] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.503s)
[522.847040] [111/134] (500s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[522.945193] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[522.949175] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[523.056866] [112/134] (499s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[523.153567] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[523.155647] Starting dynamic subtest: pipe-A-eDP-1
[523.882786] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.722s)
[523.892882] Starting dynamic subtest: pipe-B-eDP-1
[525.642312] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.757s)
[525.651962] Starting dynamic subtest: pipe-C-eDP-1
[527.440264] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.796s)
[527.451022] Starting dynamic subtest: pipe-D-eDP-1
[529.174810] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.733s)
[529.176826] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.014s)
[530.338786] [113/134] (492s left) i915_drm_fdinfo (memory-info-shared)
[530.381944] Starting subtest: memory-info-shared
[530.384397] Starting dynamic subtest: smem0
[530.455242] Dynamic subtest smem0: SUCCESS (0.076s)
[530.457889] Subtest memory-info-shared: SUCCESS (0.077s)
[530.556638] [114/134] (492s left) gem_exec_flush (basic-wb-set-default)
[530.623863] Starting subtest: basic-wb-set-default
[536.076050] Subtest basic-wb-set-default: SUCCESS (5.452s)
[536.286616] [115/134] (486s left) sysfs_timeslice_duration (timeout)
[536.345586] Starting subtest: timeout
[536.347957] Starting dynamic subtest: vecs0
[545.957779] Dynamic subtest vecs0: SUCCESS (9.609s)
[545.969718] Starting dynamic subtest: ccs0
[547.345998] Dynamic subtest ccs0: SUCCESS (1.386s)
[547.357675] Starting dynamic subtest: vcs0
[556.893912] Dynamic subtest vcs0: SUCCESS (9.548s)
[556.905587] Starting dynamic subtest: bcs0
[557.504387] Dynamic subtest bcs0: SUCCESS (0.606s)
[557.516500] Starting dynamic subtest: rcs0
[558.835788] Dynamic subtest rcs0: SUCCESS (1.330s)
[558.847809] Starting dynamic subtest: vcs1
[568.914102] Dynamic subtest vcs1: SUCCESS (10.075s)
[568.916669] Subtest timeout: SUCCESS (32.567s)
[569.012678] [116/134] (454s left) sriov_basic (enable-vfs-bind-unbind-each)
[569.075428] Starting subtest: enable-vfs-bind-unbind-each
[569.077892] Starting dynamic subtest: numvfs-1
[569.158026] Dynamic subtest numvfs-1: FAIL (0.032s)
[569.166905] Starting dynamic subtest: numvfs-2
[569.240831] Dynamic subtest numvfs-2: FAIL (0.004s)
[569.251155] Starting dynamic subtest: numvfs-3
[569.324739] Dynamic subtest numvfs-3: FAIL (0.003s)
[569.335437] Starting dynamic subtest: numvfs-4
[569.408269] Dynamic subtest numvfs-4: FAIL (0.004s)
[569.418605] Starting dynamic subtest: numvfs-5
[569.492317] Dynamic subtest numvfs-5: FAIL (0.004s)
[569.503175] Starting dynamic subtest: numvfs-6
[569.575437] Dynamic subtest numvfs-6: FAIL (0.004s)
[569.585908] Starting dynamic subtest: numvfs-7
[569.658918] Dynamic subtest numvfs-7: FAIL (0.003s)
[569.669208] Starting dynamic subtest: numvfs-random
[569.743217] Dynamic subtest numvfs-random: FAIL (0.004s)
[569.745571] Subtest enable-vfs-bind-unbind-each: FAIL (0.062s)
[569.784766] [117/134] (453s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[569.893341] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[569.897931] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[571.059164] [118/134] (452s left) kms_getfb (getfb-handle-not-fb)
[571.161767] Starting subtest: getfb-handle-not-fb
[571.163990] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[571.305637] [119/134] (452s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[571.367502] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[571.371943] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[571.573963] [120/134] (451s left) gem_workarounds (reset-context)
[571.644705] Starting subtest: reset-context
[571.800879] Subtest reset-context: SUCCESS (0.159s)
[571.962136] [121/134] (451s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[572.072713] Starting subtest: psr-farfromfence-mmap-gtt
[572.076967] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[572.210880] [122/134] (451s left) gem_wait (write-busy)
[572.277345] Starting subtest: write-busy
[572.279665] Starting dynamic subtest: all-engines
[572.914208] Dynamic subtest all-engines: SUCCESS (0.636s)
[572.926613] Starting dynamic subtest: rcs0
[573.473642] Dynamic subtest rcs0: SUCCESS (0.557s)
[573.490970] Starting dynamic subtest: bcs0
[574.025745] Dynamic subtest bcs0: SUCCESS (0.551s)
[574.042533] Starting dynamic subtest: vcs0
[575.891873] Dynamic subtest vcs0: SUCCESS (1.864s)
[575.908970] Starting dynamic subtest: vcs1
[577.877143] Dynamic subtest vcs1: SUCCESS (1.982s)
[577.893475] Starting dynamic subtest: vecs0
[579.924890] Dynamic subtest vecs0: SUCCESS (2.044s)
[579.940871] Starting dynamic subtest: ccs0
[580.474080] Dynamic subtest ccs0: SUCCESS (0.549s)
[580.476641] Subtest write-busy: SUCCESS (8.197s)
[580.694175] [123/134] (442s left) i915_hangman (detector)
[580.761181] Starting subtest: detector
[580.763518] Starting dynamic subtest: rcs0
[589.875952] Dynamic subtest rcs0: SUCCESS (9.113s)
[589.887976] Starting dynamic subtest: bcs0
[601.907076] Dynamic subtest bcs0: SUCCESS (12.028s)
[601.919196] Starting dynamic subtest: vcs0
[613.812291] Dynamic subtest vcs0: SUCCESS (11.901s)
[613.825601] Starting dynamic subtest: vcs1
[623.795307] Dynamic subtest vcs1: SUCCESS (9.980s)
[623.806589] Starting dynamic subtest: vecs0
[633.843828] Dynamic subtest vecs0: SUCCESS (10.045s)
[633.855863] Starting dynamic subtest: ccs0
[645.875393] Dynamic subtest ccs0: SUCCESS (12.028s)
[645.878062] Subtest detector: SUCCESS (65.113s)
[645.984965] [124/134] (377s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[646.082358] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[646.086484] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[646.196137] [125/134] (377s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[646.315375] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[646.319815] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[646.482014] [126/134] (377s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[646.543293] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[646.610240] [127/134] (377s left) gem_exec_schedule (noreorder-corked)
[646.792249] Starting subtest: noreorder-corked
[646.794752] Starting dynamic subtest: rcs0
[647.955368] Dynamic subtest rcs0: SUCCESS (1.163s)
[647.967945] Starting dynamic subtest: vcs0
[649.964770] Dynamic subtest vcs0: SUCCESS (2.006s)
[649.977142] Starting dynamic subtest: vcs1
[651.947348] Dynamic subtest vcs1: SUCCESS (1.980s)
[651.959985] Starting dynamic subtest: vecs0
[653.924725] Dynamic subtest vecs0: SUCCESS (1.974s)
[653.937268] Starting dynamic subtest: ccs0
[655.090032] Dynamic subtest ccs0: SUCCESS (1.164s)
[655.092794] Subtest noreorder-corked: SUCCESS (8.299s)
[655.305895] [128/134] (368s left) kms_psr (pr-cursor-mmap-cpu)
[655.397091] Starting subtest: pr-cursor-mmap-cpu
[655.401416] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[655.494374] [129/134] (368s left) perf (invalid-oa-format-id)
[655.601788] Starting subtest: invalid-oa-format-id
[655.612351] Subtest invalid-oa-format-id: SUCCESS (0.009s)
[655.654199] [130/134] (368s left) gem_eio (in-flight-internal-immediate)
[655.846483] Starting subtest: in-flight-internal-immediate
[656.970145] Subtest in-flight-internal-immediate: SUCCESS (1.125s)
[657.150440] [131/134] (366s left) kms_cursor_edge_walk (256x256-top-edge)
[657.239427] Starting subtest: 256x256-top-edge
[657.241787] Starting dynamic subtest: pipe-A-eDP-1
[660.683185] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.445s)
[660.692709] Starting dynamic subtest: pipe-D-eDP-1
[663.802711] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.115s)
[663.805040] Subtest 256x256-top-edge: SUCCESS (6.564s)
[664.625800] [132/134] (359s left) gem_ctx_persistence (engines-persistence)
[664.686561] Starting subtest: engines-persistence
[664.689061] Starting dynamic subtest: rcs0
[665.466259] Dynamic subtest rcs0: SUCCESS (0.778s)
[665.477855] Starting dynamic subtest: bcs0
[666.352275] Dynamic subtest bcs0: SUCCESS (0.884s)
[666.364809] Starting dynamic subtest: vcs0
[667.139040] Dynamic subtest vcs0: SUCCESS (0.785s)
[667.151421] Starting dynamic subtest: vcs1
[668.009196] Dynamic subtest vcs1: SUCCESS (0.868s)
[668.021726] Starting dynamic subtest: vecs0
[668.846179] Dynamic subtest vecs0: SUCCESS (0.835s)
[668.865370] Starting dynamic subtest: ccs0
[669.661241] Dynamic subtest ccs0: SUCCESS (0.812s)
[669.663788] Subtest engines-persistence: SUCCESS (4.975s)
[669.770285] [133/134] (354s left) api_intel_bb (render-ccs)
[669.834944] Starting subtest: render-ccs
[670.193940] Subtest render-ccs: SUCCESS (0.360s)
[670.325323] [134/134] (353s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[670.442495] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[670.446792] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[670.563963] 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.