[58.135433] Initializing watchdogs
[58.135480]   /dev/watchdog0
[58.149935] [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.154532] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.156789] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.160584] [001/134] (960s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[58.300940] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[58.303223] Starting dynamic subtest: pipe-A
[58.389932] Dynamic subtest pipe-A: SUCCESS (0.089s)
[58.404154] Starting dynamic subtest: pipe-B
[59.550512] Dynamic subtest pipe-B: SUCCESS (1.162s)
[59.562448] Starting dynamic subtest: pipe-C
[60.755192] Dynamic subtest pipe-C: SUCCESS (1.205s)
[60.762337] Starting dynamic subtest: pipe-D
[61.896798] Dynamic subtest pipe-D: SUCCESS (1.142s)
[61.899177] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.601s)
[63.067769] [002/134] (955s left) gem_userptr_blits (forbidden-operations)
[63.139565] Starting subtest: forbidden-operations
[63.144128] Subtest forbidden-operations: SKIP (0.000s)
[63.313216] [003/134] (955s left) gem_mmap_gtt (big-bo)
[63.385146] Subtest big-bo: SKIP (0.000s)
[63.449177] [004/134] (955s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[63.550434] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[71.112857] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.571s)
[71.291371] [005/134] (947s left) kms_fence_pin_leak
[71.472709] [006/134] (947s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[71.579212] Starting subtest: x-tiled-16bpp-rotate-180
[72.946061] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.367s)
[73.101303] [007/134] (945s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[73.161482] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[73.230418] [008/134] (945s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[73.335805] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[73.347506] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.010s)
[73.483132] [009/134] (945s left) perf_pmu (busy-check-all)
[73.520451] Starting subtest: busy-check-all
[73.522252] Starting dynamic subtest: rcs0
[74.071388] Dynamic subtest rcs0: SUCCESS (0.550s)
[74.081183] Starting dynamic subtest: bcs0
[74.620448] Dynamic subtest bcs0: SUCCESS (0.548s)
[74.630891] Starting dynamic subtest: vcs0
[75.926027] Dynamic subtest vcs0: SUCCESS (1.304s)
[75.936968] Starting dynamic subtest: vcs1
[77.909875] Dynamic subtest vcs1: SUCCESS (1.982s)
[77.920570] Starting dynamic subtest: vecs0
[79.893861] Dynamic subtest vecs0: SUCCESS (1.983s)
[79.904663] Starting dynamic subtest: ccs0
[80.446982] Dynamic subtest ccs0: SUCCESS (0.554s)
[80.449424] Subtest busy-check-all: SUCCESS (6.928s)
[80.586934] [010/134] (938s left) gem_mmap_wc (coherency)
[80.660801] Subtest coherency: SKIP (0.000s)
[80.735411] [011/134] (938s left) kms_big_fb (yf-tiled-addfb)
[80.840482] Starting subtest: yf-tiled-addfb
[80.844478] Subtest yf-tiled-addfb: SKIP (0.000s)
[80.953535] [012/134] (938s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[81.053418] Starting subtest: extended-modeset-hang-oldfb-with-reset
[81.055818] Starting dynamic subtest: pipe-A
[92.931317] Dynamic subtest pipe-A: SUCCESS (11.878s)
[92.942792] Starting dynamic subtest: pipe-D
[105.406690] Dynamic subtest pipe-D: SUCCESS (12.474s)
[105.409105] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.356s)
[106.231965] [013/134] (912s left) kms_plane_alpha_blend (constant-alpha-min)
[106.344090] Starting subtest: constant-alpha-min
[106.702043] Starting dynamic subtest: pipe-A-eDP-1
[107.414085] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.705s)
[107.424058] Starting dynamic subtest: pipe-D-eDP-1
[108.886835] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.478s)
[108.889201] Subtest constant-alpha-min: SUCCESS (2.544s)
[109.726458] [014/134] (909s left) sysfs_timeslice_duration (duration)
[109.800726] Starting subtest: duration
[109.803175] Starting dynamic subtest: vecs0
[123.826934] Dynamic subtest vecs0: SUCCESS (14.023s)
[123.836778] Starting dynamic subtest: ccs0
[136.992589] Dynamic subtest ccs0: SUCCESS (13.165s)
[137.003075] Starting dynamic subtest: vcs0
[150.837219] Dynamic subtest vcs0: SUCCESS (13.841s)
[150.847630] Starting dynamic subtest: bcs0
[164.007326] Dynamic subtest bcs0: SUCCESS (13.169s)
[164.017085] Starting dynamic subtest: rcs0
[177.142975] Dynamic subtest rcs0: SUCCESS (13.134s)
[177.153483] Starting dynamic subtest: vcs1
[190.835740] Dynamic subtest vcs1: SUCCESS (13.689s)
[190.838669] Subtest duration: SUCCESS (81.031s)
[190.934201] [015/134] (828s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[191.039631] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[194.579044] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.543s)
[195.730236] [016/134] (823s left) kms_cursor_crc (cursor-onscreen-64x64)
[195.920815] Starting subtest: cursor-onscreen-64x64
[195.923150] Starting dynamic subtest: pipe-A-eDP-1
[198.021464] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.097s)
[198.048846] Starting dynamic subtest: pipe-D-eDP-1
[200.791941] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.746s)
[200.793993] Subtest cursor-onscreen-64x64: SUCCESS (4.870s)
[201.686224] [017/134] (817s left) kms_color (ctm-red-to-blue)
[201.774811] Starting subtest: ctm-red-to-blue
[201.776681] Starting dynamic subtest: pipe-A-eDP-1
[202.480648] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.707s)
[202.490816] Starting dynamic subtest: pipe-B-eDP-1
[203.866686] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.384s)
[203.875171] Starting dynamic subtest: pipe-C-eDP-1
[205.249773] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.383s)
[205.259204] Starting dynamic subtest: pipe-D-eDP-1
[206.562618] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.311s)
[206.564590] Subtest ctm-red-to-blue: SUCCESS (4.788s)
[207.393535] [018/134] (811s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[207.460525] Subtest writes-after-reads-uncached: SKIP (0.000s)
[207.535285] [019/134] (811s left) dumb_buffer (invalid-bpp)
[207.596745] Starting subtest: invalid-bpp
[207.599058] Subtest invalid-bpp: SUCCESS (0.000s)
[207.728114] [020/134] (811s left) gem_mmap_gtt (ptrace)
[207.791403] Subtest ptrace: SKIP (0.000s)
[207.865423] [021/134] (811s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[207.990229] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[207.994729] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[208.157685] [022/134] (811s left) gem_lmem_swapping (verify)
[208.202530] Subtest verify: SKIP (0.000s)
[208.241466] [023/134] (811s left) gem_spin_batch (resubmit-new)
[208.306456] Starting subtest: resubmit-new
[208.308505] Starting dynamic subtest: rcs0
[208.313736] Dynamic subtest rcs0: SUCCESS (0.007s)
[208.323741] Starting dynamic subtest: bcs0
[208.326131] Dynamic subtest bcs0: SUCCESS (0.003s)
[208.336323] Starting dynamic subtest: vcs0
[208.338025] Dynamic subtest vcs0: SUCCESS (0.005s)
[208.346241] Starting dynamic subtest: vcs1
[208.347802] Dynamic subtest vcs1: SUCCESS (0.006s)
[208.355319] Starting dynamic subtest: vecs0
[208.356883] Dynamic subtest vecs0: SUCCESS (0.005s)
[208.364082] Starting dynamic subtest: ccs0
[208.365643] Dynamic subtest ccs0: SUCCESS (0.004s)
[208.367262] Subtest resubmit-new: SUCCESS (0.032s)
[209.943495] [024/134] (809s left) kms_cursor_crc (cursor-random-512x512)
[210.227968] Starting subtest: cursor-random-512x512
[210.232528] Subtest cursor-random-512x512: SKIP (0.001s)
[210.435555] [025/134] (809s left) kms_properties (plane-properties-legacy)
[210.530895] Starting subtest: plane-properties-legacy
[210.532916] Starting dynamic subtest: pipe-A-eDP-1
[211.076062] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.546s)
[211.086216] Starting dynamic subtest: pipe-B-eDP-1
[212.339035] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.260s)
[212.347397] Starting dynamic subtest: pipe-C-eDP-1
[213.578272] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.238s)
[213.587771] Starting dynamic subtest: pipe-D-eDP-1
[214.805993] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.226s)
[214.808644] Subtest plane-properties-legacy: SUCCESS (4.275s)
[215.622744] [026/134] (804s left) kms_vrr (flipline)
[215.730050] Starting subtest: flipline
[215.736431] Subtest flipline: SKIP (0.000s)
[215.828288] [027/134] (803s left) gem_exec_params (secure-non-master)
[215.905477] Starting subtest: secure-non-master
[215.909374] Subtest secure-non-master: SKIP (0.000s)
[216.034942] [028/134] (803s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[216.304208] Starting subtest: parallel-dmabuf-import-out-fence
[217.446046] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.142s)
[217.584073] [029/134] (802s left) kms_pm_dc (dc5-dpms-negative)
[218.682720] Starting subtest: dc5-dpms-negative
[218.687192] Subtest dc5-dpms-negative: SKIP (0.000s)
[218.774112] [030/134] (801s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[218.877341] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[218.881726] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[219.020835] [031/134] (800s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[219.129517] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[225.949100] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.823s)
[226.110467] [032/134] (793s left) kms_frontbuffer_tracking (psr-argb161616f-draw-mmap-cpu)
[226.217596] Starting subtest: psr-argb161616f-draw-mmap-cpu
[226.221974] Subtest psr-argb161616f-draw-mmap-cpu: SKIP (0.000s)
[226.347679] [033/134] (793s left) gem_exec_whisper (basic-fds-all)
[226.425116] Starting subtest: basic-fds-all
[237.810799] Subtest basic-fds-all: SUCCESS (11.383s)
[238.022442] [034/134] (781s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[238.132456] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[238.136647] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[238.265446] [035/134] (781s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[238.374299] Starting subtest: psr-rgb565-draw-render
[245.462660] Subtest psr-rgb565-draw-render: SUCCESS (7.089s)
[245.620095] [036/134] (774s left) gem_render_copy_redux (flink)
[245.691573] Starting subtest: flink
[246.494994] Subtest flink: SUCCESS (0.804s)
[246.659807] [037/134] (773s left) gem_mmap_wc (bad-offset)
[246.725306] Subtest bad-offset: SKIP (0.000s)
[246.802932] [038/134] (773s left) gem_pxp (reject-modify-context-protection-off-2)
[246.942863] Starting subtest: reject-modify-context-protection-off-2
[246.945267] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[247.090233] [039/134] (773s left) kms_3d (basic)
[247.148232] Starting subtest: basic
[249.142403] Subtest basic: SUCCESS (1.993s)
[249.626737] [040/134] (770s left) gem_ctx_persistence (smoketest)
[249.702809] Starting subtest: smoketest
[289.844496] Subtest smoketest: SUCCESS (40.137s)
[289.953320] [041/134] (730s left) kms_psr (fbc-pr-suspend)
[290.050992] Starting subtest: fbc-pr-suspend
[290.055384] Subtest fbc-pr-suspend: SKIP (0.000s)
[290.146800] [042/134] (730s left) syncobj_timeline (multi-wait-for-submit-signaled)
[290.210638] Starting subtest: multi-wait-for-submit-signaled
[290.212614] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[290.328420] [043/134] (730s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[290.419052] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[290.421169] Starting dynamic subtest: pipe-A-default-mode
[293.132303] Dynamic subtest pipe-A-default-mode: SUCCESS (2.714s)
[293.134687] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.716s)
[293.964639] [044/134] (726s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[294.067429] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[294.069783] Starting dynamic subtest: pipe-A-default-mode
[296.750182] Dynamic subtest pipe-A-default-mode: SUCCESS (2.684s)
[296.752621] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.686s)
[297.578074] [045/134] (722s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[297.695534] Starting subtest: psr-rgb565-draw-mmap-cpu
[304.490405] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.797s)
[304.626136] [046/134] (715s left) vgem_basic (mmap)
[304.745706] Starting subtest: mmap
[304.757247] Subtest mmap: SUCCESS (0.012s)
[304.834632] [FACT vgem_basic (mmap)] new: kernel.kmod_is_loaded.vgem: true
[304.837727] [047/134] (715s left) gem_userptr_blits (sync-unmap-after-close)
[304.904317] Starting subtest: sync-unmap-after-close
[304.913946] Subtest sync-unmap-after-close: SUCCESS (0.010s)
[305.072372] [048/134] (715s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[305.466069] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[306.334401] [049/134] (714s left) kms_frontbuffer_tracking (basic)
[306.432200] Starting subtest: basic
[309.719864] Subtest basic: SUCCESS (3.291s)
[309.905875] [050/134] (710s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[310.012207] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[317.002951] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (6.992s)
[317.170412] [051/134] (703s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[317.283666] Starting subtest: fbc-rgb101010-draw-blt
[321.908972] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.627s)
[323.077127] [052/134] (697s left) kms_lease (lease-unleased-connector)
[323.178142] Starting subtest: lease-unleased-connector
[323.180354] Starting dynamic subtest: pipe-A-eDP-1
[323.182649] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[323.193411] Starting dynamic subtest: pipe-B-eDP-1
[323.195891] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.008s)
[323.210330] Starting dynamic subtest: pipe-C-eDP-1
[323.212662] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[323.221362] Starting dynamic subtest: pipe-D-eDP-1
[323.223478] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s)
[323.225589] Subtest lease-unleased-connector: SUCCESS (0.036s)
[323.357785] [053/134] (697s left) gem_tiled_partial_pwrite_pread (reads)
[323.423117] Subtest reads: SKIP (0.000s)
[323.488276] [054/134] (697s left) kms_dp_link_training (uhbr-sst)
[323.592093] Starting subtest: uhbr-sst
[323.600267] Subtest uhbr-sst: SKIP (0.000s)
[323.692325] [055/134] (697s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[323.750045] Starting subtest: etime-multi-wait-all-submitted-signaled
[323.858069] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.107s)
[323.961530] [056/134] (696s left) kms_invalid_mode (overflow-vrefresh)
[324.062136] Starting subtest: overflow-vrefresh
[324.064426] Starting dynamic subtest: pipe-A-eDP-1
[324.346334] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[324.356223] Starting dynamic subtest: pipe-B-eDP-1
[324.358703] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[324.367207] Starting dynamic subtest: pipe-C-eDP-1
[324.369478] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[324.378161] Starting dynamic subtest: pipe-D-eDP-1
[324.380087] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[324.382019] Subtest overflow-vrefresh: SUCCESS (0.292s)
[325.168642] [057/134] (695s left) kms_pm_rpm (i2c)
[327.096377] Starting subtest: i2c
[332.125622] Subtest i2c: SUCCESS (5.032s)
[332.237836] [058/134] (688s left) gem_exec_balancer (busy)
[332.309205] Starting subtest: busy
[333.911504] Subtest busy: SUCCESS (1.600s)
[334.278764] [059/134] (686s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[339.263887] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[339.268218] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s)
[340.148545] [060/134] (680s left) gen9_exec_parse (batch-without-end)
[340.209253] Subtest batch-without-end: SKIP (0.000s)
[340.286667] [061/134] (680s left) gem_ctx_shared (exec-shared-gtt)
[340.357660] Starting subtest: exec-shared-gtt
[340.359995] Starting dynamic subtest: rcs0
[340.364974] Dynamic subtest rcs0: SUCCESS (0.007s)
[340.375104] Starting dynamic subtest: bcs0
[340.377230] Dynamic subtest bcs0: SUCCESS (0.005s)
[340.385785] Starting dynamic subtest: vcs0
[340.387621] Dynamic subtest vcs0: SUCCESS (0.006s)
[340.396224] Starting dynamic subtest: vcs1
[340.398391] Dynamic subtest vcs1: SUCCESS (0.006s)
[340.406502] Starting dynamic subtest: vecs0
[340.408393] Dynamic subtest vecs0: SUCCESS (0.005s)
[340.416583] Starting dynamic subtest: ccs0
[340.418490] Dynamic subtest ccs0: SUCCESS (0.005s)
[340.420363] Subtest exec-shared-gtt: SUCCESS (0.039s)
[340.611128] [062/134] (680s left) perf (invalid-oa-metric-set-id)
[340.754944] Starting subtest: invalid-oa-metric-set-id
[340.766975] Subtest invalid-oa-metric-set-id: SUCCESS (0.011s)
[340.812135] [063/134] (680s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[340.869178] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[340.871451] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[341.011940] [064/134] (680s left) gem_tiled_pread_pwrite
[341.143498] [065/134] (680s left) i915_pm_rps (thresholds-park)
[341.199848] Starting subtest: thresholds-park
[341.203750] Subtest thresholds-park: SKIP (0.001s)
[341.342704] [066/134] (679s left) gem_ctx_engines (invalid-engines)
[341.408195] Starting subtest: invalid-engines
[341.416294] Subtest invalid-engines: SUCCESS (0.008s)
[341.693381] [067/134] (679s left) vgem_basic (create)
[341.744094] Starting subtest: create
[341.746069] Subtest create: SUCCESS (0.000s)
[341.825567] [068/134] (679s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[341.908070] Starting subtest: fbc-psr2-sprite-mmap-cpu
[341.910361] Starting dynamic subtest: eDP-1
[341.914731] Dynamic subtest eDP-1: SKIP (0.000s)
[341.919200] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[342.002339] [069/134] (679s left) gem_mmap_gtt (big-copy-odd)
[342.064046] Subtest big-copy-odd: SKIP (0.000s)
[342.137895] [070/134] (679s left) gem_exec_reloc (basic-gtt-cpu-active)
[342.208705] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[342.305095] [071/134] (679s left) prime_busy (before-wait)
[342.355821] Starting subtest: before-wait
[342.360693] Starting dynamic subtest: rcs0
[342.410992] Dynamic subtest rcs0: SUCCESS (0.052s)
[342.421049] Starting dynamic subtest: bcs0
[342.475350] Dynamic subtest bcs0: SUCCESS (0.063s)
[342.485730] Starting dynamic subtest: vcs0
[342.515183] Dynamic subtest vcs0: SUCCESS (0.040s)
[342.524665] Starting dynamic subtest: vcs1
[342.556641] Dynamic subtest vcs1: SUCCESS (0.041s)
[342.566789] Starting dynamic subtest: vecs0
[342.597131] Dynamic subtest vecs0: SUCCESS (0.040s)
[342.605819] Starting dynamic subtest: ccs0
[342.637363] Dynamic subtest ccs0: SUCCESS (0.039s)
[342.745471] Subtest before-wait: SUCCESS (0.388s)
[342.845052] [072/134] (678s left) gem_exec_fence (keep-in-fence)
[343.024758] Starting subtest: keep-in-fence
[343.027551] Starting dynamic subtest: rcs0
[343.079186] Dynamic subtest rcs0: SUCCESS (0.054s)
[343.090706] Starting dynamic subtest: bcs0
[343.133196] Dynamic subtest bcs0: SUCCESS (0.052s)
[343.144406] Starting dynamic subtest: vcs0
[344.918122] Dynamic subtest vcs0: SUCCESS (1.780s)
[344.930114] Starting dynamic subtest: vcs1
[346.903384] Dynamic subtest vcs1: SUCCESS (1.983s)
[346.915757] Starting dynamic subtest: vecs0
[348.886353] Dynamic subtest vecs0: SUCCESS (1.980s)
[348.899071] Starting dynamic subtest: ccs0
[349.125109] Dynamic subtest ccs0: SUCCESS (0.237s)
[349.128052] Subtest keep-in-fence: SUCCESS (6.101s)
[351.003258] [073/134] (670s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[351.130304] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[354.862041] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.734s)
[356.070664] [074/134] (665s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[356.184211] Starting subtest: 4-tiled-8bpp-rotate-270
[356.208198] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.023s)
[356.358129] [075/134] (665s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[361.414719] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[361.416640] Starting dynamic subtest: pipe-A-eDP-1
[362.209325] Dynamic subtest pipe-A-eDP-1: SKIP (0.788s)
[362.219265] Starting dynamic subtest: pipe-B-eDP-1
[363.340370] Dynamic subtest pipe-B-eDP-1: SKIP (1.132s)
[363.344817] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.925s)
[364.547253] [076/134] (657s left) gem_ccs (block-multicopy-inplace)
[364.618676] Starting subtest: block-multicopy-inplace
[364.622826] Subtest block-multicopy-inplace: SKIP (0.000s)
[364.769723] [077/134] (656s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[364.876925] Starting subtest: x-tiled-addfb-size-offset-overflow
[364.879100] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[365.013051] [078/134] (656s left) kms_atomic (crtc-invalid-params)
[365.110182] Starting subtest: crtc-invalid-params
[365.112505] Starting dynamic subtest: pipe-A-eDP-1
[365.465087] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.354s)
[365.467248] Subtest crtc-invalid-params: SUCCESS (0.356s)
[366.288804] [079/134] (655s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[366.391250] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[366.393348] Starting dynamic subtest: pipe-A-eDP-1
[366.411790] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[366.421017] Starting dynamic subtest: pipe-B-eDP-1
[366.440188] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[366.449264] Starting dynamic subtest: pipe-C-eDP-1
[366.468147] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[366.477322] Starting dynamic subtest: pipe-D-eDP-1
[366.496701] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[366.498947] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.085s)
[368.671032] [080/134] (653s left) gem_lmem_swapping (heavy-verify-multi)
[368.720404] Subtest heavy-verify-multi: SKIP (0.000s)
[368.765987] [081/134] (653s left) kms_chamelium_frames (hdmi-crc-fast)
[369.157716] Subtest hdmi-crc-fast: SKIP (0.000s)
[369.958935] [082/134] (652s left) kms_vblank (query-forked-busy-hang)
[370.051469] Starting subtest: query-forked-busy-hang
[370.053663] Starting dynamic subtest: pipe-A-eDP-1
[396.693761] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.642s)
[396.713167] Starting dynamic subtest: pipe-D-eDP-1
[420.706116] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.009s)
[420.708469] Subtest query-forked-busy-hang: SUCCESS (50.656s)
[421.565301] [083/134] (600s left) kms_big_fb (linear-16bpp-rotate-90)
[421.674280] Starting subtest: linear-16bpp-rotate-90
[421.695068] Subtest linear-16bpp-rotate-90: SKIP (0.020s)
[421.844566] [084/134] (600s left) gem_flink_race (flink_close)
[421.877943] Starting subtest: flink_close
[426.947432] Subtest flink_close: SUCCESS (5.067s)
[427.089312] [085/134] (595s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[427.209335] Starting subtest: fbcpsr-modesetfrombusy
[433.532559] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.326s)
[433.717435] [086/134] (588s left) gem_exec_schedule (thriceslice)
[433.791382] Starting subtest: thriceslice
[433.793045] Starting dynamic subtest: rcs0
[433.816055] Dynamic subtest rcs0: SUCCESS (0.030s)
[433.827049] Starting dynamic subtest: bcs0
[433.844846] Dynamic subtest bcs0: SUCCESS (0.028s)
[433.853844] Starting dynamic subtest: vcs0
[433.895353] Dynamic subtest vcs0: SUCCESS (0.049s)
[433.907885] Starting dynamic subtest: vcs1
[433.925750] Dynamic subtest vcs1: SUCCESS (0.029s)
[433.934707] Starting dynamic subtest: vecs0
[433.954856] Dynamic subtest vecs0: SUCCESS (0.028s)
[433.964035] Starting dynamic subtest: ccs0
[433.984943] Dynamic subtest ccs0: SUCCESS (0.029s)
[433.987267] Subtest thriceslice: SUCCESS (0.199s)
[434.310978] [087/134] (587s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[434.400294] Starting subtest: flip-vs-dpms-off-vs-modeset
[434.402623] Starting dynamic subtest: A-eDP1
[438.026244] Dynamic subtest A-eDP1: SUCCESS (3.624s)
[438.038073] Starting dynamic subtest: B-eDP1
[441.243918] Dynamic subtest B-eDP1: SUCCESS (3.215s)
[441.254042] Starting dynamic subtest: C-eDP1
[444.345921] Dynamic subtest C-eDP1: SUCCESS (3.104s)
[444.357953] Starting dynamic subtest: D-eDP1
[447.437571] Dynamic subtest D-eDP1: SUCCESS (3.090s)
[447.439894] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.040s)
[448.266263] [088/134] (573s left) i915_pm_rps (min-max-config-idle)
[448.326275] Starting subtest: min-max-config-idle
[448.330625] Subtest min-max-config-idle: SKIP (0.001s)
[448.456226] [089/134] (573s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[448.553617] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[455.209237] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.657s)
[455.383865] [090/134] (566s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[460.460814] Starting subtest: psr2-overlay-plane-move-continuous-sf
[460.463138] Starting dynamic subtest: pipe-A-eDP-1
[467.155766] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.694s)
[467.166910] Starting dynamic subtest: pipe-B-eDP-1
[473.889547] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.730s)
[473.891890] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.428s)
[474.710370] [091/134] (547s left) kms_concurrent (multi-plane-atomic-lowres)
[474.810595] Starting subtest: multi-plane-atomic-lowres
[474.812499] Starting dynamic subtest: pipe-A-eDP-1
[475.325691] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.513s)
[475.328073] Subtest multi-plane-atomic-lowres: SUCCESS (0.514s)
[476.155304] [092/134] (546s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[476.254911] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[476.259428] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[476.388483] [093/134] (546s left) api_intel_allocator (reopen)
[476.441893] Starting subtest: reopen
[476.446431] Subtest reopen: SUCCESS (0.004s)
[476.589303] [094/134] (545s left) kms_flip (dpms-vs-vblank-race)
[476.676083] Starting subtest: dpms-vs-vblank-race
[476.678376] Starting dynamic subtest: A-eDP1
[480.595256] Dynamic subtest A-eDP1: SUCCESS (3.917s)
[480.605124] Starting dynamic subtest: B-eDP1
[484.098684] Dynamic subtest B-eDP1: SUCCESS (3.505s)
[484.109327] Starting dynamic subtest: C-eDP1
[487.612810] Dynamic subtest C-eDP1: SUCCESS (3.513s)
[487.622344] Starting dynamic subtest: D-eDP1
[492.243752] Dynamic subtest D-eDP1: SUCCESS (4.626s)
[492.245767] Subtest dpms-vs-vblank-race: SUCCESS (15.570s)
[493.146299] [095/134] (529s left) syncobj_timeline (single-wait-all-available-signaled)
[493.204539] Starting subtest: single-wait-all-available-signaled
[493.206760] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[493.334304] [096/134] (529s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[493.442122] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[493.444381] Starting dynamic subtest: pipe-A-eDP-1
[494.768285] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.325s)
[495.047209] Starting dynamic subtest: pipe-B-eDP-1
[496.089428] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.050s)
[496.362307] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.921s)
[497.219632] [097/134] (525s left) gem_exec_params (rs-invalid)
[497.281057] Starting subtest: rs-invalid
[497.283310] Subtest rs-invalid: SUCCESS (0.003s)
[497.437128] [098/134] (525s left) kms_scaling_modes (scaling-mode-full-aspect)
[497.528046] Starting subtest: scaling-mode-full-aspect
[497.530395] Starting dynamic subtest: pipe-A-eDP-1
[497.619912] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.093s)
[497.629432] Starting dynamic subtest: pipe-B-eDP-1
[498.821345] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.200s)
[498.831799] Starting dynamic subtest: pipe-C-eDP-1
[499.934075] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.111s)
[499.943659] Starting dynamic subtest: pipe-D-eDP-1
[501.063503] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.128s)
[501.065845] Subtest scaling-mode-full-aspect: SUCCESS (3.538s)
[502.271120] [099/134] (520s left) kms_plane (plane-panning-top-left)
[502.371118] Starting subtest: plane-panning-top-left
[502.373409] Starting dynamic subtest: pipe-A
[504.124755] Dynamic subtest pipe-A: SUCCESS (1.754s)
[504.135320] Starting dynamic subtest: pipe-B
[506.507092] Dynamic subtest pipe-B: SUCCESS (2.380s)
[506.509486] Subtest plane-panning-top-left: SUCCESS (4.137s)
[507.329784] [100/134] (515s left) kms_psr (psr2-sprite-mmap-cpu)
[507.435044] Starting subtest: psr2-sprite-mmap-cpu
[507.437424] Starting dynamic subtest: eDP-1
[509.188277] Dynamic subtest eDP-1: SUCCESS (1.751s)
[509.190681] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.753s)
[510.093237] [101/134] (512s left) gem_exec_params (rel-constants-invalid-ring)
[510.153823] Starting subtest: rel-constants-invalid-ring
[510.156274] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[510.280521] [102/134] (512s left) i915_query (query-garbage)
[510.333751] Starting subtest: query-garbage
[510.336126] Subtest query-garbage: SUCCESS (0.000s)
[510.473140] [103/134] (512s left) kms_psr (psr-cursor-mmap-cpu)
[510.579810] Starting subtest: psr-cursor-mmap-cpu
[510.582171] Starting dynamic subtest: eDP-1
[512.264107] Dynamic subtest eDP-1: SUCCESS (1.685s)
[512.266481] Subtest psr-cursor-mmap-cpu: SUCCESS (1.687s)
[513.172995] [104/134] (509s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[513.288519] Starting subtest: y-tiled-16bpp-rotate-90
[513.293061] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[513.436206] [105/134] (509s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[513.541053] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[513.545663] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[514.718638] [106/134] (508s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[514.847031] Starting subtest: flip-vs-cursor-legacy
[521.961743] Subtest flip-vs-cursor-legacy: SUCCESS (7.113s)
[522.850017] [107/134] (500s left) kms_frontbuffer_tracking (fbcpsr-argb161616f-draw-blt)
[522.959073] Starting subtest: fbcpsr-argb161616f-draw-blt
[522.963229] Subtest fbcpsr-argb161616f-draw-blt: SKIP (0.000s)
[523.110744] [108/134] (499s left) kms_flip (flip-vs-fences)
[523.203298] Starting subtest: flip-vs-fences
[523.207777] Subtest flip-vs-fences: SKIP (0.000s)
[523.316942] [109/134] (499s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[523.382696] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[523.473782] [110/134] (499s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[523.583193] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[523.585373] Starting dynamic subtest: pipe-A-eDP-1
[524.487970] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.897s)
[524.497546] Starting dynamic subtest: pipe-B-eDP-1
[526.163234] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.672s)
[526.177404] Starting dynamic subtest: pipe-C-eDP-1
[527.646607] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.481s)
[527.657246] Starting dynamic subtest: pipe-D-eDP-1
[529.194067] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.547s)
[529.196434] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.603s)
[530.455590] [111/134] (492s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[530.575177] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[530.579183] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[530.717422] [112/134] (492s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[530.815176] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[530.817373] Starting dynamic subtest: pipe-A-eDP-1
[531.562468] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.740s)
[531.572989] Starting dynamic subtest: pipe-B-eDP-1
[533.357654] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.794s)
[533.368764] Starting dynamic subtest: pipe-C-eDP-1
[535.190786] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.831s)
[535.200677] Starting dynamic subtest: pipe-D-eDP-1
[537.015547] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.823s)
[537.017699] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.194s)
[538.183313] [113/134] (485s left) i915_drm_fdinfo (memory-info-shared)
[538.231024] Starting subtest: memory-info-shared
[538.233231] Starting dynamic subtest: smem0
[538.299760] Dynamic subtest smem0: SUCCESS (0.070s)
[538.302311] Subtest memory-info-shared: SUCCESS (0.071s)
[538.397606] [114/134] (484s left) gem_exec_flush (basic-wb-set-default)
[538.456396] Starting subtest: basic-wb-set-default
[543.910872] Subtest basic-wb-set-default: SUCCESS (5.455s)
[544.121547] [115/134] (479s left) sysfs_timeslice_duration (timeout)
[544.186259] Starting subtest: timeout
[544.188667] Starting dynamic subtest: vecs0
[553.875047] Dynamic subtest vecs0: SUCCESS (9.684s)
[553.886946] Starting dynamic subtest: ccs0
[555.272383] Dynamic subtest ccs0: SUCCESS (1.397s)
[555.284080] Starting dynamic subtest: vcs0
[564.912915] Dynamic subtest vcs0: SUCCESS (9.636s)
[564.925320] Starting dynamic subtest: bcs0
[565.596694] Dynamic subtest bcs0: SUCCESS (0.682s)
[565.609267] Starting dynamic subtest: rcs0
[566.902639] Dynamic subtest rcs0: SUCCESS (1.304s)
[566.913690] Starting dynamic subtest: vcs1
[576.913935] Dynamic subtest vcs1: SUCCESS (10.007s)
[576.916416] Subtest timeout: SUCCESS (32.724s)
[577.011635] [116/134] (446s left) sriov_basic (enable-vfs-bind-unbind-each)
[577.062040] Starting subtest: enable-vfs-bind-unbind-each
[577.064217] Starting dynamic subtest: numvfs-1
[577.146323] Dynamic subtest numvfs-1: FAIL (0.031s)
[577.157712] Starting dynamic subtest: numvfs-2
[577.228060] Dynamic subtest numvfs-2: FAIL (0.004s)
[577.239867] Starting dynamic subtest: numvfs-3
[577.313801] Dynamic subtest numvfs-3: FAIL (0.004s)
[577.324418] Starting dynamic subtest: numvfs-4
[577.396225] Dynamic subtest numvfs-4: FAIL (0.004s)
[577.406375] Starting dynamic subtest: numvfs-5
[577.478069] Dynamic subtest numvfs-5: FAIL (0.004s)
[577.489094] Starting dynamic subtest: numvfs-6
[577.560849] Dynamic subtest numvfs-6: FAIL (0.004s)
[577.570739] Starting dynamic subtest: numvfs-7
[577.642280] Dynamic subtest numvfs-7: FAIL (0.004s)
[577.652823] Starting dynamic subtest: numvfs-random
[577.724241] Dynamic subtest numvfs-random: FAIL (0.003s)
[577.726594] Subtest enable-vfs-bind-unbind-each: FAIL (0.066s)
[577.766295] [117/134] (445s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[577.861743] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[577.866325] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[578.994436] [118/134] (444s left) kms_getfb (getfb-handle-not-fb)
[579.095126] Starting subtest: getfb-handle-not-fb
[579.097428] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[579.244746] [119/134] (444s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[579.310583] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[579.314969] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[579.517673] [120/134] (444s left) gem_workarounds (reset-context)
[579.584630] Starting subtest: reset-context
[579.759863] Subtest reset-context: SUCCESS (0.175s)
[579.932425] [121/134] (443s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[580.028657] Starting subtest: psr-farfromfence-mmap-gtt
[580.032745] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[580.172745] [122/134] (443s left) gem_wait (write-busy)
[580.239274] Starting subtest: write-busy
[580.241619] Starting dynamic subtest: all-engines
[580.863060] Dynamic subtest all-engines: SUCCESS (0.623s)
[580.874788] Starting dynamic subtest: rcs0
[581.420420] Dynamic subtest rcs0: SUCCESS (0.555s)
[581.436935] Starting dynamic subtest: bcs0
[581.970835] Dynamic subtest bcs0: SUCCESS (0.549s)
[581.986188] Starting dynamic subtest: vcs0
[583.893253] Dynamic subtest vcs0: SUCCESS (1.919s)
[583.909946] Starting dynamic subtest: vcs1
[585.941374] Dynamic subtest vcs1: SUCCESS (2.046s)
[585.957771] Starting dynamic subtest: vecs0
[587.925556] Dynamic subtest vecs0: SUCCESS (1.981s)
[587.941210] Starting dynamic subtest: ccs0
[588.475979] Dynamic subtest ccs0: SUCCESS (0.549s)
[588.478939] Subtest write-busy: SUCCESS (8.236s)
[588.699030] [123/134] (435s left) i915_hangman (detector)
[588.780941] Starting subtest: detector
[588.782990] Starting dynamic subtest: rcs0
[599.859576] Dynamic subtest rcs0: SUCCESS (11.077s)
[599.871662] Starting dynamic subtest: bcs0
[610.804576] Dynamic subtest bcs0: SUCCESS (10.941s)
[610.816464] Starting dynamic subtest: vcs0
[620.853509] Dynamic subtest vcs0: SUCCESS (10.045s)
[620.865822] Starting dynamic subtest: vcs1
[631.795988] Dynamic subtest vcs1: SUCCESS (10.939s)
[631.807927] Starting dynamic subtest: vecs0
[641.908052] Dynamic subtest vecs0: SUCCESS (10.109s)
[641.920215] Starting dynamic subtest: ccs0
[651.890855] Dynamic subtest ccs0: SUCCESS (9.981s)
[651.893692] Subtest detector: SUCCESS (63.109s)
[652.063943] [124/134] (371s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[652.175026] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[652.178957] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[652.312349] [125/134] (371s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[652.434568] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[652.439114] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[652.606435] [126/134] (371s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[652.679052] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[652.755067] [127/134] (371s left) gem_exec_schedule (noreorder-corked)
[652.931137] Starting subtest: noreorder-corked
[652.933471] Starting dynamic subtest: rcs0
[654.069725] Dynamic subtest rcs0: SUCCESS (1.139s)
[654.081841] Starting dynamic subtest: vcs0
[655.924318] Dynamic subtest vcs0: SUCCESS (1.851s)
[655.936534] Starting dynamic subtest: vcs1
[657.908049] Dynamic subtest vcs1: SUCCESS (1.981s)
[657.920131] Starting dynamic subtest: vecs0
[659.952198] Dynamic subtest vecs0: SUCCESS (2.041s)
[659.968272] Starting dynamic subtest: ccs0
[661.112533] Dynamic subtest ccs0: SUCCESS (1.158s)
[661.115489] Subtest noreorder-corked: SUCCESS (8.182s)
[661.324994] [128/134] (362s left) kms_psr (pr-cursor-mmap-cpu)
[661.414152] Starting subtest: pr-cursor-mmap-cpu
[661.418665] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[661.512369] [129/134] (362s left) perf (invalid-oa-format-id)
[661.609068] Starting subtest: invalid-oa-format-id
[661.620740] Subtest invalid-oa-format-id: SUCCESS (0.008s)
[661.666277] [130/134] (362s left) gem_eio (in-flight-internal-immediate)
[661.869103] Starting subtest: in-flight-internal-immediate
[662.989370] Subtest in-flight-internal-immediate: SUCCESS (1.120s)
[663.170421] [131/134] (360s left) kms_cursor_edge_walk (256x256-top-edge)
[663.273031] Starting subtest: 256x256-top-edge
[663.275299] Starting dynamic subtest: pipe-A-eDP-1
[666.769779] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.496s)
[666.779672] Starting dynamic subtest: pipe-D-eDP-1
[669.943929] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.172s)
[669.946278] Subtest 256x256-top-edge: SUCCESS (6.672s)
[670.777397] [132/134] (353s left) gem_ctx_persistence (engines-persistence)
[670.846192] Starting subtest: engines-persistence
[670.848536] Starting dynamic subtest: rcs0
[671.666356] Dynamic subtest rcs0: SUCCESS (0.819s)
[671.678751] Starting dynamic subtest: bcs0
[672.499507] Dynamic subtest bcs0: SUCCESS (0.830s)
[672.512238] Starting dynamic subtest: vcs0
[673.281853] Dynamic subtest vcs0: SUCCESS (0.780s)
[673.293679] Starting dynamic subtest: vcs1
[674.092900] Dynamic subtest vcs1: SUCCESS (0.809s)
[674.105050] Starting dynamic subtest: vecs0
[674.922852] Dynamic subtest vecs0: SUCCESS (0.828s)
[674.935178] Starting dynamic subtest: ccs0
[675.767031] Dynamic subtest ccs0: SUCCESS (0.842s)
[675.769787] Subtest engines-persistence: SUCCESS (4.922s)
[675.871963] [133/134] (348s left) api_intel_bb (render-ccs)
[675.935953] Starting subtest: render-ccs
[676.303957] Subtest render-ccs: SUCCESS (0.369s)
[676.482072] [134/134] (347s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[676.588355] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[676.592392] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[676.704439] 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.