[57.701522] Initializing watchdogs
[57.701613]   /dev/watchdog0
[57.715872] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.720076] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.722038] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.724067] [001/134] (960s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[57.826946] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[57.827859] Starting dynamic subtest: pipe-A
[57.912861] Dynamic subtest pipe-A: SUCCESS (0.087s)
[57.920765] Starting dynamic subtest: pipe-B
[59.072727] Dynamic subtest pipe-B: SUCCESS (1.166s)
[59.079014] Starting dynamic subtest: pipe-C
[60.184406] Dynamic subtest pipe-C: SUCCESS (1.116s)
[60.191224] Starting dynamic subtest: pipe-D
[61.310966] Dynamic subtest pipe-D: SUCCESS (1.130s)
[61.312131] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.502s)
[62.474078] [002/134] (955s left) gem_userptr_blits (forbidden-operations)
[62.544076] Starting subtest: forbidden-operations
[62.546129] Subtest forbidden-operations: SKIP (0.000s)
[62.710671] [003/134] (955s left) gem_mmap_gtt (big-bo)
[62.772187] Subtest big-bo: SKIP (0.000s)
[62.836124] [004/134] (955s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[62.933407] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[70.179540] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.261s)
[70.352976] [005/134] (947s left) kms_fence_pin_leak
[70.546647] [006/134] (947s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[70.651049] Starting subtest: x-tiled-16bpp-rotate-180
[71.915557] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.266s)
[72.067338] [007/134] (946s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[72.118244] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[72.173600] [008/134] (946s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[72.266266] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[72.277959] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s)
[72.410745] [009/134] (946s left) perf_pmu (busy-check-all)
[72.446908] Starting subtest: busy-check-all
[72.447772] Starting dynamic subtest: rcs0
[73.017452] Dynamic subtest rcs0: SUCCESS (0.571s)
[73.026675] Starting dynamic subtest: bcs0
[73.567487] Dynamic subtest bcs0: SUCCESS (0.549s)
[73.575688] Starting dynamic subtest: vcs0
[74.902956] Dynamic subtest vcs0: SUCCESS (1.334s)
[74.912631] Starting dynamic subtest: vcs1
[76.888117] Dynamic subtest vcs1: SUCCESS (1.984s)
[76.897319] Starting dynamic subtest: vecs0
[78.936254] Dynamic subtest vecs0: SUCCESS (2.047s)
[78.946274] Starting dynamic subtest: ccs0
[79.492842] Dynamic subtest ccs0: SUCCESS (0.558s)
[79.493962] Subtest busy-check-all: SUCCESS (7.049s)
[79.614610] [010/134] (938s left) gem_mmap_wc (coherency)
[79.671962] Subtest coherency: SKIP (0.000s)
[79.732672] [011/134] (938s left) kms_big_fb (yf-tiled-addfb)
[79.820641] Starting subtest: yf-tiled-addfb
[79.822697] Subtest yf-tiled-addfb: SKIP (0.000s)
[79.942154] [012/134] (938s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[80.041988] Starting subtest: extended-modeset-hang-oldfb-with-reset
[80.042957] Starting dynamic subtest: pipe-A
[91.634992] Dynamic subtest pipe-A: SUCCESS (11.592s)
[91.644054] Starting dynamic subtest: pipe-D
[103.911845] Dynamic subtest pipe-D: SUCCESS (12.274s)
[103.912685] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.870s)
[104.730078] [013/134] (913s left) kms_plane_alpha_blend (constant-alpha-min)
[104.822221] Starting subtest: constant-alpha-min
[105.110595] Starting dynamic subtest: pipe-A-eDP-1
[105.816924] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.705s)
[105.823965] Starting dynamic subtest: pipe-D-eDP-1
[107.283468] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.466s)
[107.284423] Subtest constant-alpha-min: SUCCESS (2.462s)
[108.094335] [014/134] (910s left) sysfs_timeslice_duration (duration)
[108.150748] Starting subtest: duration
[108.151708] Starting dynamic subtest: vecs0
[121.846933] Dynamic subtest vecs0: SUCCESS (13.692s)
[121.855648] Starting dynamic subtest: ccs0
[135.021452] Dynamic subtest ccs0: SUCCESS (13.175s)
[135.030685] Starting dynamic subtest: vcs0
[149.878634] Dynamic subtest vcs0: SUCCESS (14.853s)
[149.888982] Starting dynamic subtest: bcs0
[163.049223] Dynamic subtest bcs0: SUCCESS (13.170s)
[163.058687] Starting dynamic subtest: rcs0
[176.215048] Dynamic subtest rcs0: SUCCESS (13.164s)
[176.224352] Starting dynamic subtest: vcs1
[189.815065] Dynamic subtest vcs1: SUCCESS (13.595s)
[189.816759] Subtest duration: SUCCESS (81.658s)
[189.906186] [015/134] (828s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[190.003576] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[193.566918] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.564s)
[194.711966] [016/134] (823s left) kms_cursor_crc (cursor-onscreen-64x64)
[194.885525] Starting subtest: cursor-onscreen-64x64
[194.888563] Starting dynamic subtest: pipe-A-eDP-1
[196.986631] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.098s)
[197.014848] Starting dynamic subtest: pipe-D-eDP-1
[199.773556] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.764s)
[199.774590] Subtest cursor-onscreen-64x64: SUCCESS (4.887s)
[200.675289] [017/134] (818s left) kms_color (ctm-red-to-blue)
[200.772778] Starting subtest: ctm-red-to-blue
[200.773718] Starting dynamic subtest: pipe-A-eDP-1
[201.481935] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.707s)
[201.490734] Starting dynamic subtest: pipe-B-eDP-1
[202.862615] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.381s)
[202.870160] Starting dynamic subtest: pipe-C-eDP-1
[204.237206] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.374s)
[204.244166] Starting dynamic subtest: pipe-D-eDP-1
[205.588853] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.351s)
[205.589801] Subtest ctm-red-to-blue: SUCCESS (4.816s)
[206.405433] [018/134] (812s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[206.458929] Subtest writes-after-reads-uncached: SKIP (0.000s)
[206.536301] [019/134] (812s left) dumb_buffer (invalid-bpp)
[206.589245] Starting subtest: invalid-bpp
[206.590182] Subtest invalid-bpp: SUCCESS (0.000s)
[206.721725] [020/134] (812s left) gem_mmap_gtt (ptrace)
[206.781391] Subtest ptrace: SKIP (0.000s)
[206.842898] [021/134] (811s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[206.972994] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[206.974929] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[207.140947] [022/134] (811s left) gem_lmem_swapping (verify)
[207.176607] Subtest verify: SKIP (0.000s)
[207.215407] [023/134] (811s left) gem_spin_batch (resubmit-new)
[207.278585] Starting subtest: resubmit-new
[207.279699] Starting dynamic subtest: rcs0
[207.285964] Dynamic subtest rcs0: SUCCESS (0.007s)
[207.295019] Starting dynamic subtest: bcs0
[207.295942] Dynamic subtest bcs0: SUCCESS (0.004s)
[207.303091] Starting dynamic subtest: vcs0
[207.304159] Dynamic subtest vcs0: SUCCESS (0.004s)
[207.313469] Starting dynamic subtest: vcs1
[207.314380] Dynamic subtest vcs1: SUCCESS (0.004s)
[207.320878] Starting dynamic subtest: vecs0
[207.321818] Dynamic subtest vecs0: SUCCESS (0.004s)
[207.328378] Starting dynamic subtest: ccs0
[207.329356] Dynamic subtest ccs0: SUCCESS (0.004s)
[207.330266] Subtest resubmit-new: SUCCESS (0.030s)
[208.984266] [024/134] (809s left) kms_cursor_crc (cursor-random-512x512)
[209.258285] Starting subtest: cursor-random-512x512
[209.260136] Subtest cursor-random-512x512: SKIP (0.001s)
[209.447286] [025/134] (809s left) kms_properties (plane-properties-legacy)
[209.541344] Starting subtest: plane-properties-legacy
[209.542298] Starting dynamic subtest: pipe-A-eDP-1
[210.086985] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.546s)
[210.094801] Starting dynamic subtest: pipe-B-eDP-1
[211.380400] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.292s)
[211.387739] Starting dynamic subtest: pipe-C-eDP-1
[212.613183] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.231s)
[212.620513] Starting dynamic subtest: pipe-D-eDP-1
[213.849611] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.236s)
[213.850507] Subtest plane-properties-legacy: SUCCESS (4.310s)
[214.665183] [026/134] (804s left) kms_vrr (flipline)
[214.757278] Starting subtest: flipline
[214.759787] Subtest flipline: SKIP (0.000s)
[214.845472] [027/134] (804s left) gem_exec_params (secure-non-master)
[214.898890] Starting subtest: secure-non-master
[214.900699] Subtest secure-non-master: SKIP (0.000s)
[215.051778] [028/134] (804s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[215.311715] Starting subtest: parallel-dmabuf-import-out-fence
[216.427697] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.116s)
[216.572818] [029/134] (802s left) kms_pm_dc (dc5-dpms-negative)
[217.676198] Starting subtest: dc5-dpms-negative
[217.677936] Subtest dc5-dpms-negative: SKIP (0.000s)
[217.768878] [030/134] (801s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[217.861250] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[217.862996] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[217.990638] [031/134] (801s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[218.081768] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[224.790071] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.709s)
[224.935344] [032/134] (794s left) kms_frontbuffer_tracking (psr-argb161616f-draw-mmap-cpu)
[225.031305] Starting subtest: psr-argb161616f-draw-mmap-cpu
[225.032925] Subtest psr-argb161616f-draw-mmap-cpu: SKIP (0.000s)
[225.159026] [033/134] (794s left) gem_exec_whisper (basic-fds-all)
[225.220148] Starting subtest: basic-fds-all
[236.858465] Subtest basic-fds-all: SUCCESS (11.634s)
[237.055702] [034/134] (782s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[237.146619] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[237.148315] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[237.286722] [035/134] (781s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[237.377855] Starting subtest: psr-rgb565-draw-render
[244.342299] Subtest psr-rgb565-draw-render: SUCCESS (6.964s)
[244.486487] [036/134] (774s left) gem_render_copy_redux (flink)
[244.548594] Starting subtest: flink
[245.321487] Subtest flink: SUCCESS (0.773s)
[245.475473] [037/134] (773s left) gem_mmap_wc (bad-offset)
[245.526935] Subtest bad-offset: SKIP (0.000s)
[245.581707] [038/134] (773s left) gem_pxp (reject-modify-context-protection-off-2)
[245.707647] Starting subtest: reject-modify-context-protection-off-2
[245.708811] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[245.848313] [039/134] (773s left) kms_3d (basic)
[245.903019] Starting subtest: basic
[247.928083] Subtest basic: SUCCESS (2.026s)
[248.428629] [040/134] (771s left) gem_ctx_persistence (smoketest)
[248.479338] Starting subtest: smoketest
[287.864085] Subtest smoketest: SUCCESS (39.381s)
[287.956014] [041/134] (731s left) kms_psr (fbc-pr-suspend)
[288.069443] Starting subtest: fbc-pr-suspend
[288.071378] Subtest fbc-pr-suspend: SKIP (0.000s)
[288.158293] [042/134] (731s left) syncobj_timeline (multi-wait-for-submit-signaled)
[288.206912] Starting subtest: multi-wait-for-submit-signaled
[288.207885] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[288.330590] [043/134] (731s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[288.429086] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[288.429908] Starting dynamic subtest: pipe-A-default-mode
[291.078132] Dynamic subtest pipe-A-default-mode: SUCCESS (2.648s)
[291.078953] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.650s)
[291.923424] [044/134] (727s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[292.010304] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[292.011147] Starting dynamic subtest: pipe-A-default-mode
[294.715188] Dynamic subtest pipe-A-default-mode: SUCCESS (2.704s)
[294.716037] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.705s)
[295.525326] [045/134] (724s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[295.629997] Starting subtest: psr-rgb565-draw-mmap-cpu
[302.197138] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.568s)
[302.325558] [046/134] (717s left) vgem_basic (mmap)
[302.429363] Starting subtest: mmap
[302.437055] Subtest mmap: SUCCESS (0.009s)
[302.512757] [FACT vgem_basic (mmap)] new: kernel.kmod_is_loaded.vgem: true
[302.514515] [047/134] (717s left) gem_userptr_blits (sync-unmap-after-close)
[302.578597] Starting subtest: sync-unmap-after-close
[302.591400] Subtest sync-unmap-after-close: SUCCESS (0.013s)
[302.742570] [048/134] (716s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[303.130279] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[303.898872] [049/134] (715s left) kms_frontbuffer_tracking (basic)
[303.993783] Starting subtest: basic
[307.105089] Subtest basic: SUCCESS (3.113s)
[307.260614] [050/134] (712s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[307.359696] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[314.331864] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (6.972s)
[314.473255] [051/134] (705s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[314.581934] Starting subtest: fbc-rgb101010-draw-blt
[319.194342] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.612s)
[320.331761] [052/134] (699s left) kms_lease (lease-unleased-connector)
[320.421114] Starting subtest: lease-unleased-connector
[320.421963] Starting dynamic subtest: pipe-A-eDP-1
[320.429955] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[320.439439] Starting dynamic subtest: pipe-B-eDP-1
[320.440269] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[320.447889] Starting dynamic subtest: pipe-C-eDP-1
[320.448759] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[320.456529] Starting dynamic subtest: pipe-D-eDP-1
[320.457314] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[320.458136] Subtest lease-unleased-connector: SUCCESS (0.033s)
[320.583607] [053/134] (699s left) gem_tiled_partial_pwrite_pread (reads)
[320.643242] Subtest reads: SKIP (0.000s)
[320.702862] [054/134] (699s left) kms_dp_link_training (uhbr-sst)
[320.782493] Starting subtest: uhbr-sst
[320.785933] Subtest uhbr-sst: SKIP (0.000s)
[320.872485] [055/134] (699s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[320.931743] Starting subtest: etime-multi-wait-all-submitted-signaled
[321.036327] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.104s)
[321.129939] [056/134] (698s left) kms_invalid_mode (overflow-vrefresh)
[321.221172] Starting subtest: overflow-vrefresh
[321.222090] Starting dynamic subtest: pipe-A-eDP-1
[321.516903] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.296s)
[321.525484] Starting dynamic subtest: pipe-B-eDP-1
[321.526380] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[321.533247] Starting dynamic subtest: pipe-C-eDP-1
[321.534111] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[321.541050] Starting dynamic subtest: pipe-D-eDP-1
[321.541925] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[321.542817] Subtest overflow-vrefresh: SUCCESS (0.302s)
[322.336431] [057/134] (697s left) kms_pm_rpm (i2c)
[324.063552] Starting subtest: i2c
[329.254517] Subtest i2c: SUCCESS (5.191s)
[329.362933] [058/134] (690s left) gem_exec_balancer (busy)
[329.433594] Starting subtest: busy
[330.937197] Subtest busy: SUCCESS (1.501s)
[331.279795] [059/134] (688s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[336.326998] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[336.328856] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s)
[337.187309] [060/134] (682s left) gen9_exec_parse (batch-without-end)
[337.248712] Subtest batch-without-end: SKIP (0.000s)
[337.316810] [061/134] (682s left) gem_ctx_shared (exec-shared-gtt)
[337.373847] Starting subtest: exec-shared-gtt
[337.374852] Starting dynamic subtest: rcs0
[337.381821] Dynamic subtest rcs0: SUCCESS (0.008s)
[337.391217] Starting dynamic subtest: bcs0
[337.392038] Dynamic subtest bcs0: SUCCESS (0.006s)
[337.399598] Starting dynamic subtest: vcs0
[337.400429] Dynamic subtest vcs0: SUCCESS (0.007s)
[337.407620] Starting dynamic subtest: vcs1
[337.408432] Dynamic subtest vcs1: SUCCESS (0.006s)
[337.415826] Starting dynamic subtest: vecs0
[337.416640] Dynamic subtest vecs0: SUCCESS (0.006s)
[337.423745] Starting dynamic subtest: ccs0
[337.424542] Dynamic subtest ccs0: SUCCESS (0.005s)
[337.425338] Subtest exec-shared-gtt: SUCCESS (0.042s)
[337.624317] [062/134] (682s left) perf (invalid-oa-metric-set-id)
[337.755114] Starting subtest: invalid-oa-metric-set-id
[337.766437] Subtest invalid-oa-metric-set-id: SUCCESS (0.012s)
[337.805686] [063/134] (682s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[337.860593] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[337.861503] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[337.988647] [064/134] (682s left) gem_tiled_pread_pwrite
[338.120483] [065/134] (682s left) i915_pm_rps (thresholds-park)
[338.184858] Starting subtest: thresholds-park
[338.186741] Subtest thresholds-park: SKIP (0.001s)
[338.320872] [066/134] (681s left) gem_ctx_engines (invalid-engines)
[338.383794] Starting subtest: invalid-engines
[338.392151] Subtest invalid-engines: SUCCESS (0.008s)
[338.662204] [067/134] (681s left) vgem_basic (create)
[338.693057] Starting subtest: create
[338.693945] Subtest create: SUCCESS (0.000s)
[338.768417] [068/134] (681s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[338.856244] Starting subtest: fbc-psr2-sprite-mmap-cpu
[338.857222] Starting dynamic subtest: eDP-1
[338.858966] Dynamic subtest eDP-1: SKIP (0.000s)
[338.860735] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[338.963297] [069/134] (681s left) gem_mmap_gtt (big-copy-odd)
[339.020534] Subtest big-copy-odd: SKIP (0.000s)
[339.076805] [070/134] (681s left) gem_exec_reloc (basic-gtt-cpu-active)
[339.131724] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[339.212044] [071/134] (681s left) prime_busy (before-wait)
[339.269395] Starting subtest: before-wait
[339.272488] Starting dynamic subtest: rcs0
[339.316209] Dynamic subtest rcs0: SUCCESS (0.043s)
[339.326072] Starting dynamic subtest: bcs0
[339.377061] Dynamic subtest bcs0: SUCCESS (0.060s)
[339.385526] Starting dynamic subtest: vcs0
[339.418046] Dynamic subtest vcs0: SUCCESS (0.040s)
[339.425703] Starting dynamic subtest: vcs1
[339.458243] Dynamic subtest vcs1: SUCCESS (0.040s)
[339.465761] Starting dynamic subtest: vecs0
[339.499472] Dynamic subtest vecs0: SUCCESS (0.040s)
[339.507196] Starting dynamic subtest: ccs0
[339.539944] Dynamic subtest ccs0: SUCCESS (0.040s)
[339.650533] Subtest before-wait: SUCCESS (0.378s)
[339.742172] [072/134] (680s left) gem_exec_fence (keep-in-fence)
[339.910227] Starting subtest: keep-in-fence
[339.911807] Starting dynamic subtest: rcs0
[339.996351] Dynamic subtest rcs0: SUCCESS (0.085s)
[340.006551] Starting dynamic subtest: bcs0
[340.048977] Dynamic subtest bcs0: SUCCESS (0.052s)
[340.059420] Starting dynamic subtest: vcs0
[341.912872] Dynamic subtest vcs0: SUCCESS (1.859s)
[341.923500] Starting dynamic subtest: vcs1
[343.896493] Dynamic subtest vcs1: SUCCESS (1.981s)
[343.907184] Starting dynamic subtest: vecs0
[345.880744] Dynamic subtest vecs0: SUCCESS (1.981s)
[345.891353] Starting dynamic subtest: ccs0
[346.105363] Dynamic subtest ccs0: SUCCESS (0.224s)
[346.106617] Subtest keep-in-fence: SUCCESS (6.195s)
[348.050077] [073/134] (672s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[348.147568] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[351.899068] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.751s)
[353.087425] [074/134] (667s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[353.196780] Starting subtest: 4-tiled-8bpp-rotate-270
[353.218840] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.020s)
[353.371090] [075/134] (667s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[358.349213] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[358.351312] Starting dynamic subtest: pipe-A-eDP-1
[359.136917] Dynamic subtest pipe-A-eDP-1: SKIP (0.786s)
[359.145579] Starting dynamic subtest: pipe-B-eDP-1
[360.272388] Dynamic subtest pipe-B-eDP-1: SKIP (1.133s)
[360.274155] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.923s)
[361.491239] [076/134] (659s left) gem_ccs (block-multicopy-inplace)
[361.551603] Starting subtest: block-multicopy-inplace
[361.553385] Subtest block-multicopy-inplace: SKIP (0.000s)
[361.714413] [077/134] (658s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[361.836420] Starting subtest: x-tiled-addfb-size-offset-overflow
[361.837323] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[361.968224] [078/134] (658s left) kms_atomic (crtc-invalid-params)
[362.057410] Starting subtest: crtc-invalid-params
[362.058435] Starting dynamic subtest: pipe-A-eDP-1
[362.412999] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.355s)
[362.414195] Subtest crtc-invalid-params: SUCCESS (0.356s)
[363.232605] [079/134] (657s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[363.327537] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[363.328497] Starting dynamic subtest: pipe-A-eDP-1
[363.347731] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[363.356801] Starting dynamic subtest: pipe-B-eDP-1
[363.369460] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[363.378353] Starting dynamic subtest: pipe-C-eDP-1
[363.390321] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[363.399082] Starting dynamic subtest: pipe-D-eDP-1
[363.411548] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[363.412457] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.086s)
[365.623754] [080/134] (655s left) gem_lmem_swapping (heavy-verify-multi)
[365.660184] Subtest heavy-verify-multi: SKIP (0.000s)
[365.700950] [081/134] (655s left) kms_chamelium_frames (hdmi-crc-fast)
[366.080680] Subtest hdmi-crc-fast: SKIP (0.000s)
[366.900971] [082/134] (653s left) kms_vblank (query-forked-busy-hang)
[366.993612] Starting subtest: query-forked-busy-hang
[366.994563] Starting dynamic subtest: pipe-A-eDP-1
[393.701034] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.685s)
[393.711977] Starting dynamic subtest: pipe-D-eDP-1
[418.655321] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.971s)
[418.656221] Subtest query-forked-busy-hang: SUCCESS (51.661s)
[419.497927] [083/134] (601s left) kms_big_fb (linear-16bpp-rotate-90)
[419.604695] Starting subtest: linear-16bpp-rotate-90
[419.628413] Subtest linear-16bpp-rotate-90: SKIP (0.023s)
[419.783286] [084/134] (601s left) gem_flink_race (flink_close)
[419.813984] Starting subtest: flink_close
[424.921644] Subtest flink_close: SUCCESS (5.106s)
[425.036890] [085/134] (595s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[425.153162] Starting subtest: fbcpsr-modesetfrombusy
[431.434948] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.282s)
[431.612362] [086/134] (589s left) gem_exec_schedule (thriceslice)
[431.678064] Starting subtest: thriceslice
[431.679062] Starting dynamic subtest: rcs0
[431.733570] Dynamic subtest rcs0: SUCCESS (0.056s)
[431.745186] Starting dynamic subtest: bcs0
[431.791421] Dynamic subtest bcs0: SUCCESS (0.054s)
[431.803056] Starting dynamic subtest: vcs0
[431.824844] Dynamic subtest vcs0: SUCCESS (0.032s)
[431.832603] Starting dynamic subtest: vcs1
[431.854666] Dynamic subtest vcs1: SUCCESS (0.029s)
[431.863875] Starting dynamic subtest: vecs0
[431.884216] Dynamic subtest vecs0: SUCCESS (0.029s)
[431.891879] Starting dynamic subtest: ccs0
[431.942317] Dynamic subtest ccs0: SUCCESS (0.055s)
[431.943442] Subtest thriceslice: SUCCESS (0.264s)
[432.998894] [087/134] (588s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[433.081349] Starting subtest: flip-vs-dpms-off-vs-modeset
[433.083614] Starting dynamic subtest: A-eDP1
[436.651768] Dynamic subtest A-eDP1: SUCCESS (3.567s)
[436.659595] Starting dynamic subtest: B-eDP1
[439.842650] Dynamic subtest B-eDP1: SUCCESS (3.190s)
[439.850375] Starting dynamic subtest: C-eDP1
[442.973739] Dynamic subtest C-eDP1: SUCCESS (3.130s)
[442.981753] Starting dynamic subtest: D-eDP1
[446.082927] Dynamic subtest D-eDP1: SUCCESS (3.108s)
[446.085062] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.003s)
[446.910428] [088/134] (574s left) i915_pm_rps (min-max-config-idle)
[446.984773] Starting subtest: min-max-config-idle
[446.986605] Subtest min-max-config-idle: SKIP (0.001s)
[447.114088] [089/134] (574s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[447.213409] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[453.783965] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.570s)
[453.928028] [090/134] (567s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[458.924733] Starting subtest: psr2-overlay-plane-move-continuous-sf
[458.925619] Starting dynamic subtest: pipe-A-eDP-1
[465.614608] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.688s)
[465.623680] Starting dynamic subtest: pipe-B-eDP-1
[472.252833] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.635s)
[472.253772] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.328s)
[473.073058] [091/134] (548s left) kms_concurrent (multi-plane-atomic-lowres)
[473.181458] Starting subtest: multi-plane-atomic-lowres
[473.182338] Starting dynamic subtest: pipe-A-eDP-1
[473.691076] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.509s)
[473.691999] Subtest multi-plane-atomic-lowres: SUCCESS (0.510s)
[474.504293] [092/134] (546s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[474.603817] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[474.605611] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[474.737836] [093/134] (546s left) api_intel_allocator (reopen)
[474.808126] Starting subtest: reopen
[474.811854] Subtest reopen: SUCCESS (0.004s)
[474.940243] [094/134] (546s left) kms_flip (dpms-vs-vblank-race)
[475.037320] Starting subtest: dpms-vs-vblank-race
[475.038214] Starting dynamic subtest: A-eDP1
[479.977814] Dynamic subtest A-eDP1: SUCCESS (4.939s)
[479.992585] Starting dynamic subtest: B-eDP1
[484.628676] Dynamic subtest B-eDP1: SUCCESS (4.649s)
[484.636423] Starting dynamic subtest: C-eDP1
[489.246305] Dynamic subtest C-eDP1: SUCCESS (4.616s)
[489.254332] Starting dynamic subtest: D-eDP1
[493.861377] Dynamic subtest D-eDP1: SUCCESS (4.613s)
[493.863620] Subtest dpms-vs-vblank-race: SUCCESS (18.826s)
[494.761505] [095/134] (526s left) syncobj_timeline (single-wait-all-available-signaled)
[494.819335] Starting subtest: single-wait-all-available-signaled
[494.820234] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[494.919884] [096/134] (526s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[495.012869] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[495.013804] Starting dynamic subtest: pipe-A-eDP-1
[496.379518] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.364s)
[496.657585] Starting dynamic subtest: pipe-B-eDP-1
[497.702808] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.055s)
[497.986547] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.974s)
[498.842409] [097/134] (522s left) gem_exec_params (rs-invalid)
[498.914671] Starting subtest: rs-invalid
[498.917584] Subtest rs-invalid: SUCCESS (0.003s)
[499.084958] [098/134] (522s left) kms_scaling_modes (scaling-mode-full-aspect)
[499.182292] Starting subtest: scaling-mode-full-aspect
[499.183208] Starting dynamic subtest: pipe-A-eDP-1
[499.284832] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.102s)
[499.293808] Starting dynamic subtest: pipe-B-eDP-1
[500.456048] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.170s)
[500.467067] Starting dynamic subtest: pipe-C-eDP-1
[501.572367] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.113s)
[501.581292] Starting dynamic subtest: pipe-D-eDP-1
[502.705565] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s)
[502.708899] Subtest scaling-mode-full-aspect: SUCCESS (3.525s)
[503.989276] [099/134] (517s left) kms_plane (plane-panning-top-left)
[504.081445] Starting subtest: plane-panning-top-left
[504.082424] Starting dynamic subtest: pipe-A
[505.740285] Dynamic subtest pipe-A: SUCCESS (1.657s)
[505.750501] Starting dynamic subtest: pipe-B
[508.089811] Dynamic subtest pipe-B: SUCCESS (2.349s)
[508.090833] Subtest plane-panning-top-left: SUCCESS (4.009s)
[508.912090] [100/134] (512s left) kms_psr (psr2-sprite-mmap-cpu)
[509.008248] Starting subtest: psr2-sprite-mmap-cpu
[509.009025] Starting dynamic subtest: eDP-1
[510.690793] Dynamic subtest eDP-1: SUCCESS (1.683s)
[510.691685] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.684s)
[511.573966] [101/134] (509s left) gem_exec_params (rel-constants-invalid-ring)
[511.630348] Starting subtest: rel-constants-invalid-ring
[511.631283] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[511.755547] [102/134] (509s left) i915_query (query-garbage)
[511.811365] Starting subtest: query-garbage
[511.812301] Subtest query-garbage: SUCCESS (0.000s)
[511.952506] [103/134] (509s left) kms_psr (psr-cursor-mmap-cpu)
[512.044054] Starting subtest: psr-cursor-mmap-cpu
[512.044852] Starting dynamic subtest: eDP-1
[513.744592] Dynamic subtest eDP-1: SUCCESS (1.700s)
[513.745479] Subtest psr-cursor-mmap-cpu: SUCCESS (1.701s)
[514.629393] [104/134] (506s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[514.723376] Starting subtest: y-tiled-16bpp-rotate-90
[514.725252] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[514.850118] [105/134] (506s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[514.951071] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[514.952669] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[516.059536] [106/134] (505s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[516.176186] Starting subtest: flip-vs-cursor-legacy
[523.312826] Subtest flip-vs-cursor-legacy: SUCCESS (7.136s)
[524.181056] [107/134] (497s left) kms_frontbuffer_tracking (fbcpsr-argb161616f-draw-blt)
[524.273705] Starting subtest: fbcpsr-argb161616f-draw-blt
[524.275339] Subtest fbcpsr-argb161616f-draw-blt: SKIP (0.000s)
[524.388950] [108/134] (497s left) kms_flip (flip-vs-fences)
[524.481603] Starting subtest: flip-vs-fences
[524.483298] Subtest flip-vs-fences: SKIP (0.000s)
[524.607470] [109/134] (497s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[524.669322] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[524.728992] [110/134] (497s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[524.814436] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[524.815402] Starting dynamic subtest: pipe-A-eDP-1
[525.646176] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.829s)
[525.654055] Starting dynamic subtest: pipe-B-eDP-1
[527.167813] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.521s)
[527.175714] Starting dynamic subtest: pipe-C-eDP-1
[528.705574] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.522s)
[528.716484] Starting dynamic subtest: pipe-D-eDP-1
[530.248498] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.555s)
[530.249310] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.432s)
[531.523421] [111/134] (490s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[531.624869] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[531.626619] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[531.744390] [112/134] (490s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[531.834462] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[531.835482] Starting dynamic subtest: pipe-A-eDP-1
[532.573865] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.736s)
[532.581903] Starting dynamic subtest: pipe-B-eDP-1
[534.337714] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.762s)
[534.346666] Starting dynamic subtest: pipe-C-eDP-1
[536.187045] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.848s)
[536.195480] Starting dynamic subtest: pipe-D-eDP-1
[538.006750] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.818s)
[538.007749] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.170s)
[539.158897] [113/134] (482s left) i915_drm_fdinfo (memory-info-shared)
[539.200450] Starting subtest: memory-info-shared
[539.201405] Starting dynamic subtest: smem0
[539.274940] Dynamic subtest smem0: SUCCESS (0.073s)
[539.276380] Subtest memory-info-shared: SUCCESS (0.074s)
[539.363398] [114/134] (482s left) gem_exec_flush (basic-wb-set-default)
[539.438387] Starting subtest: basic-wb-set-default
[544.895930] Subtest basic-wb-set-default: SUCCESS (5.457s)
[545.101552] [115/134] (476s left) sysfs_timeslice_duration (timeout)
[545.164117] Starting subtest: timeout
[545.165021] Starting dynamic subtest: vecs0
[554.912554] Dynamic subtest vecs0: SUCCESS (9.746s)
[554.922477] Starting dynamic subtest: ccs0
[556.440643] Dynamic subtest ccs0: SUCCESS (1.528s)
[556.451039] Starting dynamic subtest: vcs0
[565.904914] Dynamic subtest vcs0: SUCCESS (9.459s)
[565.914607] Starting dynamic subtest: bcs0
[566.560962] Dynamic subtest bcs0: SUCCESS (0.655s)
[566.571434] Starting dynamic subtest: rcs0
[568.022465] Dynamic subtest rcs0: SUCCESS (1.460s)
[568.033510] Starting dynamic subtest: vcs1
[577.895752] Dynamic subtest vcs1: SUCCESS (9.868s)
[577.897222] Subtest timeout: SUCCESS (32.729s)
[577.990360] [116/134] (444s left) sriov_basic (enable-vfs-bind-unbind-each)
[578.047626] Starting subtest: enable-vfs-bind-unbind-each
[578.048460] Starting dynamic subtest: numvfs-1
[578.084460] Dynamic subtest numvfs-1: FAIL (0.017s)
[578.100399] Starting dynamic subtest: numvfs-2
[578.128089] Dynamic subtest numvfs-2: FAIL (0.004s)
[578.136089] Starting dynamic subtest: numvfs-3
[578.164601] Dynamic subtest numvfs-3: FAIL (0.004s)
[578.172080] Starting dynamic subtest: numvfs-4
[578.204601] Dynamic subtest numvfs-4: FAIL (0.004s)
[578.212526] Starting dynamic subtest: numvfs-5
[578.239562] Dynamic subtest numvfs-5: FAIL (0.003s)
[578.246790] Starting dynamic subtest: numvfs-6
[578.273859] Dynamic subtest numvfs-6: FAIL (0.004s)
[578.281056] Starting dynamic subtest: numvfs-7
[578.308047] Dynamic subtest numvfs-7: FAIL (0.004s)
[578.315172] Starting dynamic subtest: numvfs-random
[578.343546] Dynamic subtest numvfs-random: FAIL (0.004s)
[578.344508] Subtest enable-vfs-bind-unbind-each: FAIL (0.049s)
[578.372507] [117/134] (443s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[578.456028] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[578.457655] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[579.584170] [118/134] (442s left) kms_getfb (getfb-handle-not-fb)
[579.683676] Starting subtest: getfb-handle-not-fb
[579.684631] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[579.822965] [119/134] (442s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[579.881973] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[579.883780] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[580.082340] [120/134] (442s left) gem_workarounds (reset-context)
[580.148651] Starting subtest: reset-context
[580.318699] Subtest reset-context: SUCCESS (0.170s)
[580.480248] [121/134] (441s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[580.577494] Starting subtest: psr-farfromfence-mmap-gtt
[580.579274] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[580.713509] [122/134] (441s left) gem_wait (write-busy)
[580.785485] Starting subtest: write-busy
[580.786494] Starting dynamic subtest: all-engines
[581.403757] Dynamic subtest all-engines: SUCCESS (0.617s)
[581.418966] Starting dynamic subtest: rcs0
[581.958283] Dynamic subtest rcs0: SUCCESS (0.554s)
[581.973629] Starting dynamic subtest: bcs0
[582.508341] Dynamic subtest bcs0: SUCCESS (0.549s)
[582.523620] Starting dynamic subtest: vcs0
[583.896195] Dynamic subtest vcs0: SUCCESS (1.384s)
[583.911442] Starting dynamic subtest: vcs1
[585.880974] Dynamic subtest vcs1: SUCCESS (1.982s)
[585.895895] Starting dynamic subtest: vecs0
[587.927983] Dynamic subtest vecs0: SUCCESS (2.044s)
[587.942751] Starting dynamic subtest: ccs0
[588.478089] Dynamic subtest ccs0: SUCCESS (0.550s)
[588.479077] Subtest write-busy: SUCCESS (7.693s)
[588.698219] [123/134] (433s left) i915_hangman (detector)
[588.769650] Starting subtest: detector
[588.770465] Starting dynamic subtest: rcs0
[599.862837] Dynamic subtest rcs0: SUCCESS (11.090s)
[599.875721] Starting dynamic subtest: bcs0
[611.831788] Dynamic subtest bcs0: SUCCESS (11.965s)
[611.842520] Starting dynamic subtest: vcs0
[622.904674] Dynamic subtest vcs0: SUCCESS (11.069s)
[622.914617] Starting dynamic subtest: vcs1
[633.847400] Dynamic subtest vcs1: SUCCESS (10.940s)
[633.865188] Starting dynamic subtest: vecs0
[644.855934] Dynamic subtest vecs0: SUCCESS (11.005s)
[644.866596] Starting dynamic subtest: ccs0
[656.887877] Dynamic subtest ccs0: SUCCESS (12.028s)
[656.889462] Subtest detector: SUCCESS (68.114s)
[656.987647] [124/134] (365s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[657.095035] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[657.096776] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[657.223932] [125/134] (365s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[657.346876] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[657.348715] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[657.509597] [126/134] (364s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[657.560174] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[657.613832] [127/134] (364s left) gem_exec_schedule (noreorder-corked)
[657.793252] Starting subtest: noreorder-corked
[657.794176] Starting dynamic subtest: rcs0
[658.958031] Dynamic subtest rcs0: SUCCESS (1.165s)
[658.970840] Starting dynamic subtest: vcs0
[660.919237] Dynamic subtest vcs0: SUCCESS (1.956s)
[660.929502] Starting dynamic subtest: vcs1
[662.961565] Dynamic subtest vcs1: SUCCESS (2.040s)
[662.971856] Starting dynamic subtest: vecs0
[664.960871] Dynamic subtest vecs0: SUCCESS (1.996s)
[664.970410] Starting dynamic subtest: ccs0
[666.107904] Dynamic subtest ccs0: SUCCESS (1.146s)
[666.109235] Subtest noreorder-corked: SUCCESS (8.316s)
[666.313263] [128/134] (356s left) kms_psr (pr-cursor-mmap-cpu)
[666.422151] Starting subtest: pr-cursor-mmap-cpu
[666.423926] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[666.513431] [129/134] (355s left) perf (invalid-oa-format-id)
[666.617742] Starting subtest: invalid-oa-format-id
[666.626685] Subtest invalid-oa-format-id: SUCCESS (0.008s)
[666.663882] [130/134] (355s left) gem_eio (in-flight-internal-immediate)
[666.859419] Starting subtest: in-flight-internal-immediate
[667.984780] Subtest in-flight-internal-immediate: SUCCESS (1.125s)
[668.118318] [131/134] (354s left) kms_cursor_edge_walk (256x256-top-edge)
[668.211537] Starting subtest: 256x256-top-edge
[668.212476] Starting dynamic subtest: pipe-A-eDP-1
[671.686444] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.474s)
[671.695408] Starting dynamic subtest: pipe-D-eDP-1
[674.849722] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.162s)
[674.850575] Subtest 256x256-top-edge: SUCCESS (6.639s)
[675.680745] [132/134] (346s left) gem_ctx_persistence (engines-persistence)
[675.740899] Starting subtest: engines-persistence
[675.742245] Starting dynamic subtest: rcs0
[676.575945] Dynamic subtest rcs0: SUCCESS (0.834s)
[676.588055] Starting dynamic subtest: bcs0
[677.347040] Dynamic subtest bcs0: SUCCESS (0.768s)
[677.359256] Starting dynamic subtest: vcs0
[678.118898] Dynamic subtest vcs0: SUCCESS (0.770s)
[678.131223] Starting dynamic subtest: vcs1
[678.891934] Dynamic subtest vcs1: SUCCESS (0.771s)
[678.904298] Starting dynamic subtest: vecs0
[679.711824] Dynamic subtest vecs0: SUCCESS (0.818s)
[679.723967] Starting dynamic subtest: ccs0
[680.453737] Dynamic subtest ccs0: SUCCESS (0.740s)
[680.454840] Subtest engines-persistence: SUCCESS (4.714s)
[680.609804] [133/134] (341s left) api_intel_bb (render-ccs)
[680.667584] Starting subtest: render-ccs
[681.047557] Subtest render-ccs: SUCCESS (0.379s)
[681.163424] [134/134] (341s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[681.257600] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[681.259185] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[681.381252] 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.