[58.079837] Initializing watchdogs
[58.079882]   /dev/watchdog0
[58.094547] [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.098892] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.101279] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.103210] [001/134] (960s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[58.213776] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[58.214729] Starting dynamic subtest: pipe-A
[58.299812] Dynamic subtest pipe-A: SUCCESS (0.087s)
[58.307676] Starting dynamic subtest: pipe-B
[59.470466] Dynamic subtest pipe-B: SUCCESS (1.178s)
[59.482703] Starting dynamic subtest: pipe-C
[60.575198] Dynamic subtest pipe-C: SUCCESS (1.110s)
[60.580566] Starting dynamic subtest: pipe-D
[61.694199] Dynamic subtest pipe-D: SUCCESS (1.123s)
[61.695400] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.501s)
[62.872922] [002/134] (955s left) gem_userptr_blits (forbidden-operations)
[62.928974] Starting subtest: forbidden-operations
[62.930984] Subtest forbidden-operations: SKIP (0.000s)
[63.065815] [003/134] (955s left) gem_mmap_gtt (big-bo)
[63.116442] Subtest big-bo: SKIP (0.000s)
[63.180626] [004/134] (955s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[63.293690] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[70.598449] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.323s)
[70.745398] [005/134] (947s left) kms_fence_pin_leak
[70.908942] [006/134] (947s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[71.005284] Starting subtest: x-tiled-16bpp-rotate-180
[72.382390] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.379s)
[72.554733] [007/134] (946s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[72.604099] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[72.664618] [008/134] (946s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[72.758500] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[72.770418] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s)
[72.861430] [009/134] (945s left) perf_pmu (busy-check-all)
[72.892538] Starting subtest: busy-check-all
[72.893610] Starting dynamic subtest: rcs0
[73.456316] Dynamic subtest rcs0: SUCCESS (0.564s)
[73.465323] Starting dynamic subtest: bcs0
[74.005456] Dynamic subtest bcs0: SUCCESS (0.549s)
[74.014838] Starting dynamic subtest: vcs0
[75.926751] Dynamic subtest vcs0: SUCCESS (1.919s)
[75.936201] Starting dynamic subtest: vcs1
[77.911866] Dynamic subtest vcs1: SUCCESS (1.985s)
[77.921282] Starting dynamic subtest: vecs0
[79.895703] Dynamic subtest vecs0: SUCCESS (1.983s)
[79.904778] Starting dynamic subtest: ccs0
[80.449368] Dynamic subtest ccs0: SUCCESS (0.555s)
[80.450829] Subtest busy-check-all: SUCCESS (7.561s)
[80.579173] [010/134] (938s left) gem_mmap_wc (coherency)
[80.632130] Subtest coherency: SKIP (0.000s)
[80.680514] [011/134] (938s left) kms_big_fb (yf-tiled-addfb)
[80.781460] Starting subtest: yf-tiled-addfb
[80.783382] Subtest yf-tiled-addfb: SKIP (0.000s)
[80.924078] [012/134] (938s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[81.017293] Starting subtest: extended-modeset-hang-oldfb-with-reset
[81.018140] Starting dynamic subtest: pipe-A
[92.650506] Dynamic subtest pipe-A: SUCCESS (11.632s)
[92.659926] Starting dynamic subtest: pipe-D
[104.919468] Dynamic subtest pipe-D: SUCCESS (12.267s)
[104.920305] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.903s)
[105.736977] [013/134] (913s left) kms_plane_alpha_blend (constant-alpha-min)
[105.823499] Starting subtest: constant-alpha-min
[106.115133] Starting dynamic subtest: pipe-A-eDP-1
[106.804034] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.687s)
[106.811225] Starting dynamic subtest: pipe-D-eDP-1
[108.294220] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.490s)
[108.295169] Subtest constant-alpha-min: SUCCESS (2.472s)
[109.200408] [014/134] (909s left) sysfs_timeslice_duration (duration)
[109.257942] Starting subtest: duration
[109.259330] Starting dynamic subtest: vecs0
[122.806080] Dynamic subtest vecs0: SUCCESS (13.544s)
[122.818080] Starting dynamic subtest: ccs0
[135.926787] Dynamic subtest ccs0: SUCCESS (13.121s)
[135.934780] Starting dynamic subtest: vcs0
[149.877743] Dynamic subtest vcs0: SUCCESS (13.946s)
[149.886464] Starting dynamic subtest: bcs0
[163.036288] Dynamic subtest bcs0: SUCCESS (13.158s)
[163.046429] Starting dynamic subtest: rcs0
[176.203912] Dynamic subtest rcs0: SUCCESS (13.165s)
[176.214141] Starting dynamic subtest: vcs1
[190.838722] Dynamic subtest vcs1: SUCCESS (14.631s)
[190.840360] Subtest duration: SUCCESS (81.576s)
[190.933824] [015/134] (828s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[191.036692] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[194.630331] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.595s)
[195.819407] [016/134] (823s left) kms_cursor_crc (cursor-onscreen-64x64)
[195.996186] Starting subtest: cursor-onscreen-64x64
[195.999752] Starting dynamic subtest: pipe-A-eDP-1
[198.107378] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.107s)
[198.134979] Starting dynamic subtest: pipe-D-eDP-1
[200.878404] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.749s)
[200.879374] Subtest cursor-onscreen-64x64: SUCCESS (4.881s)
[201.695808] [017/134] (817s left) kms_color (ctm-red-to-blue)
[201.793118] Starting subtest: ctm-red-to-blue
[201.793957] Starting dynamic subtest: pipe-A-eDP-1
[202.477552] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.685s)
[202.484547] Starting dynamic subtest: pipe-B-eDP-1
[203.848917] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.370s)
[203.856046] Starting dynamic subtest: pipe-C-eDP-1
[205.148767] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.298s)
[205.156973] Starting dynamic subtest: pipe-D-eDP-1
[206.502077] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.353s)
[206.503027] Subtest ctm-red-to-blue: SUCCESS (4.709s)
[207.336775] [018/134] (811s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[207.401119] Subtest writes-after-reads-uncached: SKIP (0.000s)
[207.462905] [019/134] (811s left) dumb_buffer (invalid-bpp)
[207.520562] Starting subtest: invalid-bpp
[207.521668] Subtest invalid-bpp: SUCCESS (0.000s)
[207.648647] [020/134] (811s left) gem_mmap_gtt (ptrace)
[207.715120] Subtest ptrace: SKIP (0.000s)
[207.780127] [021/134] (811s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[207.893801] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[207.895705] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[208.057253] [022/134] (811s left) gem_lmem_swapping (verify)
[208.101617] Subtest verify: SKIP (0.000s)
[208.137733] [023/134] (811s left) gem_spin_batch (resubmit-new)
[208.189937] Starting subtest: resubmit-new
[208.190890] Starting dynamic subtest: rcs0
[208.198589] Dynamic subtest rcs0: SUCCESS (0.008s)
[208.206769] Starting dynamic subtest: bcs0
[208.207633] Dynamic subtest bcs0: SUCCESS (0.004s)
[208.214363] Starting dynamic subtest: vcs0
[208.215145] Dynamic subtest vcs0: SUCCESS (0.004s)
[208.221543] Starting dynamic subtest: vcs1
[208.222569] Dynamic subtest vcs1: SUCCESS (0.005s)
[208.229104] Starting dynamic subtest: vecs0
[208.229881] Dynamic subtest vecs0: SUCCESS (0.004s)
[208.236249] Starting dynamic subtest: ccs0
[208.237037] Dynamic subtest ccs0: SUCCESS (0.004s)
[208.237862] Subtest resubmit-new: SUCCESS (0.032s)
[209.932994] [024/134] (809s left) kms_cursor_crc (cursor-random-512x512)
[210.220423] Starting subtest: cursor-random-512x512
[210.222347] Subtest cursor-random-512x512: SKIP (0.001s)
[210.409409] [025/134] (808s left) kms_properties (plane-properties-legacy)
[210.493066] Starting subtest: plane-properties-legacy
[210.494183] Starting dynamic subtest: pipe-A-eDP-1
[211.035413] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.543s)
[211.043062] Starting dynamic subtest: pipe-B-eDP-1
[212.282988] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.246s)
[212.290352] Starting dynamic subtest: pipe-C-eDP-1
[213.512822] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.229s)
[213.520872] Starting dynamic subtest: pipe-D-eDP-1
[214.747552] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.233s)
[214.748436] Subtest plane-properties-legacy: SUCCESS (4.255s)
[215.570272] [026/134] (803s left) kms_vrr (flipline)
[215.668408] Starting subtest: flipline
[215.671057] Subtest flipline: SKIP (0.000s)
[215.759630] [027/134] (803s left) gem_exec_params (secure-non-master)
[215.815998] Starting subtest: secure-non-master
[215.817859] Subtest secure-non-master: SKIP (0.000s)
[215.925678] [028/134] (803s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[216.170276] Starting subtest: parallel-dmabuf-import-out-fence
[217.231436] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.063s)
[217.358724] [029/134] (802s left) kms_pm_dc (dc5-dpms-negative)
[218.470241] Starting subtest: dc5-dpms-negative
[218.471888] Subtest dc5-dpms-negative: SKIP (0.000s)
[218.562329] [030/134] (800s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[218.659184] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[218.660888] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[218.775597] [031/134] (800s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[218.870460] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[225.592115] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.722s)
[225.732044] [032/134] (793s left) kms_frontbuffer_tracking (psr-argb161616f-draw-mmap-cpu)
[225.833533] Starting subtest: psr-argb161616f-draw-mmap-cpu
[225.835290] Subtest psr-argb161616f-draw-mmap-cpu: SKIP (0.000s)
[225.957731] [033/134] (793s left) gem_exec_whisper (basic-fds-all)
[226.029489] Starting subtest: basic-fds-all
[237.879663] Subtest basic-fds-all: SUCCESS (11.847s)
[238.077094] [034/134] (781s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[238.177707] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[238.179407] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[238.290290] [035/134] (781s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[238.405945] Starting subtest: psr-rgb565-draw-render
[245.431204] Subtest psr-rgb565-draw-render: SUCCESS (7.026s)
[245.585178] [036/134] (774s left) gem_render_copy_redux (flink)
[245.640405] Starting subtest: flink
[246.412890] Subtest flink: SUCCESS (0.772s)
[246.559507] [037/134] (773s left) gem_mmap_wc (bad-offset)
[246.614770] Subtest bad-offset: SKIP (0.000s)
[246.670634] [038/134] (773s left) gem_pxp (reject-modify-context-protection-off-2)
[246.804055] Starting subtest: reject-modify-context-protection-off-2
[246.805654] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[246.946541] [039/134] (772s left) kms_3d (basic)
[246.997509] Starting subtest: basic
[248.945643] Subtest basic: SUCCESS (1.949s)
[249.443463] [040/134] (770s left) gem_ctx_persistence (smoketest)
[249.501067] Starting subtest: smoketest
[289.846399] Subtest smoketest: SUCCESS (40.341s)
[289.942803] [041/134] (729s left) kms_psr (fbc-pr-suspend)
[290.040075] Starting subtest: fbc-pr-suspend
[290.041886] Subtest fbc-pr-suspend: SKIP (0.000s)
[290.129192] [042/134] (729s left) syncobj_timeline (multi-wait-for-submit-signaled)
[290.188683] Starting subtest: multi-wait-for-submit-signaled
[290.189606] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[290.322643] [043/134] (729s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[290.419426] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[290.420372] Starting dynamic subtest: pipe-A-default-mode
[293.123906] Dynamic subtest pipe-A-default-mode: SUCCESS (2.703s)
[293.124831] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.704s)
[294.006342] [044/134] (725s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[294.090142] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[294.091202] Starting dynamic subtest: pipe-A-default-mode
[296.857133] Dynamic subtest pipe-A-default-mode: SUCCESS (2.768s)
[296.857951] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.769s)
[297.705016] [045/134] (722s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[297.794604] Starting subtest: psr-rgb565-draw-mmap-cpu
[304.531068] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.736s)
[304.657323] [046/134] (715s left) vgem_basic (mmap)
[304.763835] Starting subtest: mmap
[304.769426] Subtest mmap: SUCCESS (0.006s)
[304.836462] [FACT vgem_basic (mmap)] new: kernel.kmod_is_loaded.vgem: true
[304.838359] [047/134] (715s left) gem_userptr_blits (sync-unmap-after-close)
[304.902586] Starting subtest: sync-unmap-after-close
[304.913318] Subtest sync-unmap-after-close: SUCCESS (0.011s)
[305.070965] [048/134] (715s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[305.456804] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[306.226919] [049/134] (713s left) kms_frontbuffer_tracking (basic)
[306.323217] Starting subtest: basic
[309.424476] Subtest basic: SUCCESS (3.101s)
[309.571692] [050/134] (710s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[309.673319] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[316.658194] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (6.985s)
[316.814863] [051/134] (703s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[316.916609] Starting subtest: fbc-rgb101010-draw-blt
[321.513956] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.597s)
[322.734873] [052/134] (697s left) kms_lease (lease-unleased-connector)
[322.821436] Starting subtest: lease-unleased-connector
[322.822412] Starting dynamic subtest: pipe-A-eDP-1
[322.828436] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[322.836610] Starting dynamic subtest: pipe-B-eDP-1
[322.838370] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[322.853088] Starting dynamic subtest: pipe-C-eDP-1
[322.853995] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[322.861339] Starting dynamic subtest: pipe-D-eDP-1
[322.862233] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[322.863083] Subtest lease-unleased-connector: SUCCESS (0.032s)
[322.982182] [053/134] (697s left) gem_tiled_partial_pwrite_pread (reads)
[323.047236] Subtest reads: SKIP (0.000s)
[323.107962] [054/134] (697s left) kms_dp_link_training (uhbr-sst)
[323.200515] Starting subtest: uhbr-sst
[323.204123] Subtest uhbr-sst: SKIP (0.000s)
[323.293356] [055/134] (697s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[323.342517] Starting subtest: etime-multi-wait-all-submitted-signaled
[323.451390] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.108s)
[323.545338] [056/134] (696s left) kms_invalid_mode (overflow-vrefresh)
[323.628804] Starting subtest: overflow-vrefresh
[323.629791] Starting dynamic subtest: pipe-A-eDP-1
[323.923047] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s)
[323.930442] Starting dynamic subtest: pipe-B-eDP-1
[323.931382] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[323.938143] Starting dynamic subtest: pipe-C-eDP-1
[323.939077] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[323.945862] Starting dynamic subtest: pipe-D-eDP-1
[323.946810] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[323.947798] Subtest overflow-vrefresh: SUCCESS (0.299s)
[324.739212] [057/134] (695s left) kms_pm_rpm (i2c)
[326.272066] Starting subtest: i2c
[331.613579] Subtest i2c: SUCCESS (5.345s)
[331.723451] [058/134] (688s left) gem_exec_balancer (busy)
[331.787159] Starting subtest: busy
[333.947981] Subtest busy: SUCCESS (2.158s)
[334.270932] [059/134] (686s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[339.252299] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[339.255461] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.003s)
[340.113621] [060/134] (680s left) gen9_exec_parse (batch-without-end)
[340.180852] Subtest batch-without-end: SKIP (0.000s)
[340.243416] [061/134] (680s left) gem_ctx_shared (exec-shared-gtt)
[340.296827] Starting subtest: exec-shared-gtt
[340.297900] Starting dynamic subtest: rcs0
[340.303941] Dynamic subtest rcs0: SUCCESS (0.007s)
[340.313837] Starting dynamic subtest: bcs0
[340.314763] Dynamic subtest bcs0: SUCCESS (0.006s)
[340.322490] Starting dynamic subtest: vcs0
[340.323386] Dynamic subtest vcs0: SUCCESS (0.007s)
[340.330675] Starting dynamic subtest: vcs1
[340.331591] Dynamic subtest vcs1: SUCCESS (0.006s)
[340.339182] Starting dynamic subtest: vecs0
[340.340064] Dynamic subtest vecs0: SUCCESS (0.006s)
[340.347223] Starting dynamic subtest: ccs0
[340.348076] Dynamic subtest ccs0: SUCCESS (0.006s)
[340.348927] Subtest exec-shared-gtt: SUCCESS (0.041s)
[340.541064] [062/134] (680s left) perf (invalid-oa-metric-set-id)
[340.678500] Starting subtest: invalid-oa-metric-set-id
[340.689784] Subtest invalid-oa-metric-set-id: SUCCESS (0.012s)
[340.727113] [063/134] (679s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[340.779055] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[340.780561] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[340.887717] [064/134] (679s left) gem_tiled_pread_pwrite
[340.986839] [065/134] (679s left) i915_pm_rps (thresholds-park)
[341.039338] Starting subtest: thresholds-park
[341.041439] Subtest thresholds-park: SKIP (0.001s)
[341.157846] [066/134] (679s left) gem_ctx_engines (invalid-engines)
[341.205378] Starting subtest: invalid-engines
[341.212883] Subtest invalid-engines: SUCCESS (0.009s)
[341.483814] [067/134] (679s left) vgem_basic (create)
[341.529318] Starting subtest: create
[341.530278] Subtest create: SUCCESS (0.000s)
[341.602568] [068/134] (679s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[341.696325] Starting subtest: fbc-psr2-sprite-mmap-cpu
[341.697195] Starting dynamic subtest: eDP-1
[341.699061] Dynamic subtest eDP-1: SKIP (0.000s)
[341.700740] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[341.787562] [069/134] (678s left) gem_mmap_gtt (big-copy-odd)
[341.848433] Subtest big-copy-odd: SKIP (0.000s)
[341.915982] [070/134] (678s left) gem_exec_reloc (basic-gtt-cpu-active)
[341.974786] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[342.055589] [071/134] (678s left) prime_busy (before-wait)
[342.117611] Starting subtest: before-wait
[342.119353] Starting dynamic subtest: rcs0
[342.147390] Dynamic subtest rcs0: SUCCESS (0.028s)
[342.154991] Starting dynamic subtest: bcs0
[342.189495] Dynamic subtest bcs0: SUCCESS (0.041s)
[342.199809] Starting dynamic subtest: vcs0
[342.231258] Dynamic subtest vcs0: SUCCESS (0.039s)
[342.239855] Starting dynamic subtest: vcs1
[342.272313] Dynamic subtest vcs1: SUCCESS (0.039s)
[342.281404] Starting dynamic subtest: vecs0
[342.313920] Dynamic subtest vecs0: SUCCESS (0.039s)
[342.321787] Starting dynamic subtest: ccs0
[342.354108] Dynamic subtest ccs0: SUCCESS (0.040s)
[342.463903] Subtest before-wait: SUCCESS (0.345s)
[342.554765] [072/134] (678s left) gem_exec_fence (keep-in-fence)
[342.730606] Starting subtest: keep-in-fence
[342.731716] Starting dynamic subtest: rcs0
[342.805745] Dynamic subtest rcs0: SUCCESS (0.074s)
[342.823868] Starting dynamic subtest: bcs0
[342.862437] Dynamic subtest bcs0: SUCCESS (0.055s)
[342.872641] Starting dynamic subtest: vcs0
[344.919503] Dynamic subtest vcs0: SUCCESS (2.052s)
[344.928145] Starting dynamic subtest: vcs1
[346.904323] Dynamic subtest vcs1: SUCCESS (1.982s)
[346.914523] Starting dynamic subtest: vecs0
[348.887393] Dynamic subtest vecs0: SUCCESS (1.981s)
[348.897501] Starting dynamic subtest: ccs0
[349.114469] Dynamic subtest ccs0: SUCCESS (0.226s)
[349.115792] Subtest keep-in-fence: SUCCESS (6.384s)
[351.058095] [073/134] (669s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[351.162679] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[354.969523] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.807s)
[356.134298] [074/134] (664s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[356.240881] Starting subtest: 4-tiled-8bpp-rotate-270
[356.262892] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.021s)
[356.429503] [075/134] (664s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[361.519244] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[361.520341] Starting dynamic subtest: pipe-A-eDP-1
[362.298843] Dynamic subtest pipe-A-eDP-1: SKIP (0.778s)
[362.313896] Starting dynamic subtest: pipe-B-eDP-1
[363.427715] Dynamic subtest pipe-B-eDP-1: SKIP (1.126s)
[363.429424] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.910s)
[364.643538] [076/134] (656s left) gem_ccs (block-multicopy-inplace)
[364.701653] Starting subtest: block-multicopy-inplace
[364.703870] Subtest block-multicopy-inplace: SKIP (0.000s)
[364.826646] [077/134] (656s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[364.922678] Starting subtest: x-tiled-addfb-size-offset-overflow
[364.923804] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[365.053308] [078/134] (656s left) kms_atomic (crtc-invalid-params)
[365.134341] Starting subtest: crtc-invalid-params
[365.135242] Starting dynamic subtest: pipe-A-eDP-1
[365.494078] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.354s)
[365.495289] Subtest crtc-invalid-params: SUCCESS (0.356s)
[366.382471] [079/134] (654s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[366.470205] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[366.471026] Starting dynamic subtest: pipe-A-eDP-1
[366.491146] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[366.499786] Starting dynamic subtest: pipe-B-eDP-1
[366.512208] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[366.520670] Starting dynamic subtest: pipe-C-eDP-1
[366.533565] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[366.542296] Starting dynamic subtest: pipe-D-eDP-1
[366.554718] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[366.555619] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.085s)
[368.751656] [080/134] (652s left) gem_lmem_swapping (heavy-verify-multi)
[368.794020] Subtest heavy-verify-multi: SKIP (0.000s)
[368.832799] [081/134] (652s left) kms_chamelium_frames (hdmi-crc-fast)
[369.199140] Subtest hdmi-crc-fast: SKIP (0.000s)
[370.032072] [082/134] (651s left) kms_vblank (query-forked-busy-hang)
[370.125307] Starting subtest: query-forked-busy-hang
[370.126219] Starting dynamic subtest: pipe-A-eDP-1
[396.693477] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.566s)
[396.703935] Starting dynamic subtest: pipe-D-eDP-1
[421.724102] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.027s)
[421.724960] Subtest query-forked-busy-hang: SUCCESS (51.598s)
[422.540446] [083/134] (598s left) kms_big_fb (linear-16bpp-rotate-90)
[422.642682] Starting subtest: linear-16bpp-rotate-90
[422.665936] Subtest linear-16bpp-rotate-90: SKIP (0.021s)
[422.785229] [084/134] (598s left) gem_flink_race (flink_close)
[422.823563] Starting subtest: flink_close
[427.923978] Subtest flink_close: SUCCESS (5.100s)
[428.025584] [085/134] (593s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[428.126210] Starting subtest: fbcpsr-modesetfrombusy
[434.267650] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.140s)
[434.463541] [086/134] (586s left) gem_exec_schedule (thriceslice)
[434.529259] Starting subtest: thriceslice
[434.530314] Starting dynamic subtest: rcs0
[434.559336] Dynamic subtest rcs0: SUCCESS (0.030s)
[434.569284] Starting dynamic subtest: bcs0
[434.589180] Dynamic subtest bcs0: SUCCESS (0.029s)
[434.597887] Starting dynamic subtest: vcs0
[434.641179] Dynamic subtest vcs0: SUCCESS (0.050s)
[434.653183] Starting dynamic subtest: vcs1
[434.671707] Dynamic subtest vcs1: SUCCESS (0.029s)
[434.681894] Starting dynamic subtest: vecs0
[434.700490] Dynamic subtest vecs0: SUCCESS (0.028s)
[434.708660] Starting dynamic subtest: ccs0
[434.752890] Dynamic subtest ccs0: SUCCESS (0.051s)
[434.754141] Subtest thriceslice: SUCCESS (0.225s)
[435.073320] [087/134] (586s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[435.175357] Starting subtest: flip-vs-dpms-off-vs-modeset
[435.177429] Starting dynamic subtest: A-eDP1
[438.785254] Dynamic subtest A-eDP1: SUCCESS (3.608s)
[438.792812] Starting dynamic subtest: B-eDP1
[442.008114] Dynamic subtest B-eDP1: SUCCESS (3.222s)
[442.019309] Starting dynamic subtest: C-eDP1
[445.115809] Dynamic subtest C-eDP1: SUCCESS (3.105s)
[445.123409] Starting dynamic subtest: D-eDP1
[448.211415] Dynamic subtest D-eDP1: SUCCESS (3.094s)
[448.213460] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.038s)
[449.033400] [088/134] (572s left) i915_pm_rps (min-max-config-idle)
[449.092498] Starting subtest: min-max-config-idle
[449.094386] Subtest min-max-config-idle: SKIP (0.000s)
[449.230670] [089/134] (572s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[449.325829] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[455.914640] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.588s)
[456.083843] [090/134] (565s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[461.164185] Starting subtest: psr2-overlay-plane-move-continuous-sf
[461.166252] Starting dynamic subtest: pipe-A-eDP-1
[467.862631] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.697s)
[467.872043] Starting dynamic subtest: pipe-B-eDP-1
[474.578841] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.714s)
[474.579778] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.415s)
[475.482639] [091/134] (546s left) kms_concurrent (multi-plane-atomic-lowres)
[475.580406] Starting subtest: multi-plane-atomic-lowres
[475.581290] Starting dynamic subtest: pipe-A-eDP-1
[476.058202] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.478s)
[476.059094] Subtest multi-plane-atomic-lowres: SUCCESS (0.479s)
[476.903672] [092/134] (544s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[477.008689] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[477.010583] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[477.142149] [093/134] (544s left) api_intel_allocator (reopen)
[477.196041] Starting subtest: reopen
[477.197962] Subtest reopen: SUCCESS (0.004s)
[477.372194] [094/134] (544s left) kms_flip (dpms-vs-vblank-race)
[477.466198] Starting subtest: dpms-vs-vblank-race
[477.467077] Starting dynamic subtest: A-eDP1
[482.482665] Dynamic subtest A-eDP1: SUCCESS (5.015s)
[482.491806] Starting dynamic subtest: B-eDP1
[486.003041] Dynamic subtest B-eDP1: SUCCESS (3.518s)
[486.010946] Starting dynamic subtest: C-eDP1
[490.626432] Dynamic subtest C-eDP1: SUCCESS (4.622s)
[490.635746] Starting dynamic subtest: D-eDP1
[495.262321] Dynamic subtest D-eDP1: SUCCESS (4.635s)
[495.264503] Subtest dpms-vs-vblank-race: SUCCESS (17.799s)
[496.155995] [095/134] (525s left) syncobj_timeline (single-wait-all-available-signaled)
[496.207189] Starting subtest: single-wait-all-available-signaled
[496.208369] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[496.335801] [096/134] (525s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[496.431542] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[496.432506] Starting dynamic subtest: pipe-A-eDP-1
[497.788880] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.354s)
[498.066535] Starting dynamic subtest: pipe-B-eDP-1
[499.112901] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.053s)
[499.391989] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.960s)
[500.245080] [097/134] (521s left) gem_exec_params (rs-invalid)
[500.302280] Starting subtest: rs-invalid
[500.304386] Subtest rs-invalid: SUCCESS (0.003s)
[500.459948] [098/134] (521s left) kms_scaling_modes (scaling-mode-full-aspect)
[500.557665] Starting subtest: scaling-mode-full-aspect
[500.558653] Starting dynamic subtest: pipe-A-eDP-1
[500.650555] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.093s)
[500.664036] Starting dynamic subtest: pipe-B-eDP-1
[501.852747] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.201s)
[501.861933] Starting dynamic subtest: pipe-C-eDP-1
[502.961425] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.107s)
[502.971171] Starting dynamic subtest: pipe-D-eDP-1
[504.093532] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s)
[504.094439] Subtest scaling-mode-full-aspect: SUCCESS (3.537s)
[505.287558] [099/134] (516s left) kms_plane (plane-panning-top-left)
[505.378403] Starting subtest: plane-panning-top-left
[505.379503] Starting dynamic subtest: pipe-A
[507.050657] Dynamic subtest pipe-A: SUCCESS (1.672s)
[507.058598] Starting dynamic subtest: pipe-B
[509.398074] Dynamic subtest pipe-B: SUCCESS (2.346s)
[509.398933] Subtest plane-panning-top-left: SUCCESS (4.021s)
[510.220278] [100/134] (511s left) kms_psr (psr2-sprite-mmap-cpu)
[510.320627] Starting subtest: psr2-sprite-mmap-cpu
[510.321561] Starting dynamic subtest: eDP-1
[512.005480] Dynamic subtest eDP-1: SUCCESS (1.684s)
[512.006378] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.686s)
[512.895938] [101/134] (508s left) gem_exec_params (rel-constants-invalid-ring)
[512.957651] Starting subtest: rel-constants-invalid-ring
[512.958753] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[513.082914] [102/134] (508s left) i915_query (query-garbage)
[513.131241] Starting subtest: query-garbage
[513.132209] Subtest query-garbage: SUCCESS (0.000s)
[513.254596] [103/134] (508s left) kms_psr (psr-cursor-mmap-cpu)
[513.355285] Starting subtest: psr-cursor-mmap-cpu
[513.356160] Starting dynamic subtest: eDP-1
[515.085888] Dynamic subtest eDP-1: SUCCESS (1.730s)
[515.086794] Subtest psr-cursor-mmap-cpu: SUCCESS (1.731s)
[515.961348] [104/134] (505s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[516.068012] Starting subtest: y-tiled-16bpp-rotate-90
[516.070037] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[516.206277] [105/134] (505s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[516.296826] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[516.298920] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[517.401473] [106/134] (504s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[517.519988] Starting subtest: flip-vs-cursor-legacy
[524.661689] Subtest flip-vs-cursor-legacy: SUCCESS (7.143s)
[525.525547] [107/134] (496s left) kms_frontbuffer_tracking (fbcpsr-argb161616f-draw-blt)
[525.617401] Starting subtest: fbcpsr-argb161616f-draw-blt
[525.619067] Subtest fbcpsr-argb161616f-draw-blt: SKIP (0.000s)
[525.735018] [108/134] (496s left) kms_flip (flip-vs-fences)
[525.823768] Starting subtest: flip-vs-fences
[525.825512] Subtest flip-vs-fences: SKIP (0.000s)
[525.951041] [109/134] (496s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[526.020421] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[526.104854] [110/134] (496s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[526.184378] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[526.185251] Starting dynamic subtest: pipe-A-eDP-1
[527.012678] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.826s)
[527.020217] Starting dynamic subtest: pipe-B-eDP-1
[528.552757] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.539s)
[528.560792] Starting dynamic subtest: pipe-C-eDP-1
[530.034706] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.480s)
[530.042476] Starting dynamic subtest: pipe-D-eDP-1
[531.557713] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.522s)
[531.558571] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.371s)
[532.777439] [111/134] (489s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[532.883767] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[532.885535] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[533.018466] [112/134] (489s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[533.104926] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[533.105729] Starting dynamic subtest: pipe-A-eDP-1
[533.845989] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.737s)
[533.853577] Starting dynamic subtest: pipe-B-eDP-1
[535.686257] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.838s)
[535.695062] Starting dynamic subtest: pipe-C-eDP-1
[537.504589] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.818s)
[537.512102] Starting dynamic subtest: pipe-D-eDP-1
[539.330381] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.825s)
[539.331193] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.222s)
[540.496675] [113/134] (481s left) i915_drm_fdinfo (memory-info-shared)
[540.540266] Starting subtest: memory-info-shared
[540.541184] Starting dynamic subtest: smem0
[540.606561] Dynamic subtest smem0: SUCCESS (0.066s)
[540.607609] Subtest memory-info-shared: SUCCESS (0.067s)
[540.696579] [114/134] (481s left) gem_exec_flush (basic-wb-set-default)
[540.754392] Starting subtest: basic-wb-set-default
[546.209518] Subtest basic-wb-set-default: SUCCESS (5.455s)
[546.416292] [115/134] (475s left) sysfs_timeslice_duration (timeout)
[546.482693] Starting subtest: timeout
[546.483765] Starting dynamic subtest: vecs0
[555.947544] Dynamic subtest vecs0: SUCCESS (9.461s)
[555.958631] Starting dynamic subtest: ccs0
[557.381543] Dynamic subtest ccs0: SUCCESS (1.434s)
[557.394783] Starting dynamic subtest: vcs0
[566.957899] Dynamic subtest vcs0: SUCCESS (9.570s)
[566.973079] Starting dynamic subtest: bcs0
[567.665061] Dynamic subtest bcs0: SUCCESS (0.708s)
[567.675497] Starting dynamic subtest: rcs0
[569.026678] Dynamic subtest rcs0: SUCCESS (1.360s)
[569.038920] Starting dynamic subtest: vcs1
[578.913710] Dynamic subtest vcs1: SUCCESS (9.884s)
[578.914783] Subtest timeout: SUCCESS (32.429s)
[579.006839] [116/134] (443s left) sriov_basic (enable-vfs-bind-unbind-each)
[579.066160] Starting subtest: enable-vfs-bind-unbind-each
[579.067237] Starting dynamic subtest: numvfs-1
[579.100372] Dynamic subtest numvfs-1: FAIL (0.017s)
[579.108428] Starting dynamic subtest: numvfs-2
[579.134949] Dynamic subtest numvfs-2: FAIL (0.004s)
[579.142231] Starting dynamic subtest: numvfs-3
[579.167736] Dynamic subtest numvfs-3: FAIL (0.003s)
[579.174934] Starting dynamic subtest: numvfs-4
[579.200183] Dynamic subtest numvfs-4: FAIL (0.003s)
[579.207340] Starting dynamic subtest: numvfs-5
[579.232821] Dynamic subtest numvfs-5: FAIL (0.004s)
[579.240142] Starting dynamic subtest: numvfs-6
[579.266019] Dynamic subtest numvfs-6: FAIL (0.003s)
[579.273117] Starting dynamic subtest: numvfs-7
[579.298678] Dynamic subtest numvfs-7: FAIL (0.003s)
[579.305732] Starting dynamic subtest: numvfs-random
[579.332873] Dynamic subtest numvfs-random: FAIL (0.003s)
[579.333761] Subtest enable-vfs-bind-unbind-each: FAIL (0.047s)
[579.361232] [117/134] (443s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[579.455776] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[579.457433] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[580.615688] [118/134] (441s left) kms_getfb (getfb-handle-not-fb)
[580.709701] Starting subtest: getfb-handle-not-fb
[580.710804] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[580.860214] [119/134] (441s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[580.927936] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[580.929799] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[581.126409] [120/134] (441s left) gem_workarounds (reset-context)
[581.193546] Starting subtest: reset-context
[581.359403] Subtest reset-context: SUCCESS (0.166s)
[581.526295] [121/134] (440s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[581.628370] Starting subtest: psr-farfromfence-mmap-gtt
[581.630146] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[581.742377] [122/134] (440s left) gem_wait (write-busy)
[581.818175] Starting subtest: write-busy
[581.819028] Starting dynamic subtest: all-engines
[582.431982] Dynamic subtest all-engines: SUCCESS (0.614s)
[582.439749] Starting dynamic subtest: rcs0
[582.986463] Dynamic subtest rcs0: SUCCESS (0.553s)
[583.001936] Starting dynamic subtest: bcs0
[583.536547] Dynamic subtest bcs0: SUCCESS (0.549s)
[583.551193] Starting dynamic subtest: vcs0
[584.918908] Dynamic subtest vcs0: SUCCESS (1.379s)
[584.934529] Starting dynamic subtest: vcs1
[586.903326] Dynamic subtest vcs1: SUCCESS (1.982s)
[586.918495] Starting dynamic subtest: vecs0
[588.886842] Dynamic subtest vecs0: SUCCESS (1.981s)
[588.901825] Starting dynamic subtest: ccs0
[589.436356] Dynamic subtest ccs0: SUCCESS (0.549s)
[589.437654] Subtest write-busy: SUCCESS (7.619s)
[589.652502] [123/134] (432s left) i915_hangman (detector)
[589.723105] Starting subtest: detector
[589.724084] Starting dynamic subtest: rcs0
[599.860685] Dynamic subtest rcs0: SUCCESS (10.134s)
[599.871073] Starting dynamic subtest: bcs0
[611.893867] Dynamic subtest bcs0: SUCCESS (12.029s)
[611.904587] Starting dynamic subtest: vcs0
[623.797947] Dynamic subtest vcs0: SUCCESS (11.900s)
[623.811744] Starting dynamic subtest: vcs1
[634.805873] Dynamic subtest vcs1: SUCCESS (11.004s)
[634.816590] Starting dynamic subtest: vecs0
[645.878105] Dynamic subtest vecs0: SUCCESS (11.069s)
[645.888310] Starting dynamic subtest: ccs0
[656.886091] Dynamic subtest ccs0: SUCCESS (11.005s)
[656.887447] Subtest detector: SUCCESS (67.159s)
[656.981062] [124/134] (365s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[657.082797] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[657.084472] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[657.227778] [125/134] (365s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[657.345951] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[657.347590] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[657.532044] [126/134] (365s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[657.594950] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[657.661220] [127/134] (365s left) gem_exec_schedule (noreorder-corked)
[657.833633] Starting subtest: noreorder-corked
[657.834731] Starting dynamic subtest: rcs0
[658.948503] Dynamic subtest rcs0: SUCCESS (1.115s)
[658.958521] Starting dynamic subtest: vcs0
[660.873244] Dynamic subtest vcs0: SUCCESS (1.921s)
[660.885447] Starting dynamic subtest: vcs1
[662.854264] Dynamic subtest vcs1: SUCCESS (1.978s)
[662.864349] Starting dynamic subtest: vecs0
[664.902125] Dynamic subtest vecs0: SUCCESS (2.045s)
[664.912708] Starting dynamic subtest: ccs0
[666.080106] Dynamic subtest ccs0: SUCCESS (1.177s)
[666.081271] Subtest noreorder-corked: SUCCESS (8.247s)
[666.284515] [128/134] (356s left) kms_psr (pr-cursor-mmap-cpu)
[666.382920] Starting subtest: pr-cursor-mmap-cpu
[666.384635] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[666.473615] [129/134] (356s left) perf (invalid-oa-format-id)
[666.582786] Starting subtest: invalid-oa-format-id
[666.590968] Subtest invalid-oa-format-id: SUCCESS (0.009s)
[666.625270] [130/134] (356s left) gem_eio (in-flight-internal-immediate)
[666.819657] Starting subtest: in-flight-internal-immediate
[667.981097] Subtest in-flight-internal-immediate: SUCCESS (1.162s)
[668.147141] [131/134] (354s left) kms_cursor_edge_walk (256x256-top-edge)
[668.232481] Starting subtest: 256x256-top-edge
[668.233423] Starting dynamic subtest: pipe-A-eDP-1
[671.645318] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.412s)
[671.653296] Starting dynamic subtest: pipe-D-eDP-1
[674.777268] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.130s)
[674.778110] Subtest 256x256-top-edge: SUCCESS (6.545s)
[675.604758] [132/134] (347s left) gem_ctx_persistence (engines-persistence)
[675.655056] Starting subtest: engines-persistence
[675.655971] Starting dynamic subtest: rcs0
[676.523884] Dynamic subtest rcs0: SUCCESS (0.868s)
[676.535830] Starting dynamic subtest: bcs0
[677.352868] Dynamic subtest bcs0: SUCCESS (0.827s)
[677.365551] Starting dynamic subtest: vcs0
[678.126763] Dynamic subtest vcs0: SUCCESS (0.772s)
[678.139638] Starting dynamic subtest: vcs1
[678.950694] Dynamic subtest vcs1: SUCCESS (0.822s)
[678.962771] Starting dynamic subtest: vecs0
[679.710696] Dynamic subtest vecs0: SUCCESS (0.758s)
[679.722551] Starting dynamic subtest: ccs0
[680.452908] Dynamic subtest ccs0: SUCCESS (0.740s)
[680.454186] Subtest engines-persistence: SUCCESS (4.799s)
[680.619823] [133/134] (342s left) api_intel_bb (render-ccs)
[680.677538] Starting subtest: render-ccs
[681.046746] Subtest render-ccs: SUCCESS (0.367s)
[681.191948] [134/134] (341s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[681.296012] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[681.297930] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[681.417101] 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.