[57.070458] Initializing watchdogs
[57.070575]   /dev/watchdog0
[57.084934] [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.089154] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.091779] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.095092] [001/134] (960s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[57.225005] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[57.227571] Starting dynamic subtest: pipe-A
[57.311560] Dynamic subtest pipe-A: SUCCESS (0.088s)
[57.319521] Starting dynamic subtest: pipe-B
[58.494874] Dynamic subtest pipe-B: SUCCESS (1.175s)
[58.504144] Starting dynamic subtest: pipe-C
[59.604663] Dynamic subtest pipe-C: SUCCESS (1.103s)
[59.614202] Starting dynamic subtest: pipe-D
[60.739673] Dynamic subtest pipe-D: SUCCESS (1.129s)
[60.742092] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.498s)
[61.916171] [002/134] (955s left) gem_userptr_blits (forbidden-operations)
[61.991640] Starting subtest: forbidden-operations
[61.995956] Subtest forbidden-operations: SKIP (0.000s)
[62.186175] [003/134] (955s left) gem_mmap_gtt (big-bo)
[62.238541] Subtest big-bo: SKIP (0.000s)
[62.300116] [004/134] (955s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[62.413979] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[69.862443] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.437s)
[70.018193] [005/134] (947s left) kms_fence_pin_leak
[70.205959] [006/134] (947s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[70.316693] Starting subtest: x-tiled-16bpp-rotate-180
[71.540888] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.222s)
[71.707649] [007/134] (946s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[71.777128] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[71.851203] [008/134] (946s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[71.954058] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[71.964966] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.010s)
[72.106705] [009/134] (945s left) perf_pmu (busy-check-all)
[72.152114] Starting subtest: busy-check-all
[72.153955] Starting dynamic subtest: rcs0
[72.726816] Dynamic subtest rcs0: SUCCESS (0.573s)
[72.736571] Starting dynamic subtest: bcs0
[73.275547] Dynamic subtest bcs0: SUCCESS (0.547s)
[73.283879] Starting dynamic subtest: vcs0
[74.902984] Dynamic subtest vcs0: SUCCESS (1.624s)
[74.912112] Starting dynamic subtest: vcs1
[76.886502] Dynamic subtest vcs1: SUCCESS (1.981s)
[76.896870] Starting dynamic subtest: vecs0
[78.932856] Dynamic subtest vecs0: SUCCESS (2.044s)
[78.943036] Starting dynamic subtest: ccs0
[79.487927] Dynamic subtest ccs0: SUCCESS (0.555s)
[79.490380] Subtest busy-check-all: SUCCESS (7.331s)
[79.620422] [010/134] (938s left) gem_mmap_wc (coherency)
[79.689051] Subtest coherency: SKIP (0.000s)
[79.747859] [011/134] (938s left) kms_big_fb (yf-tiled-addfb)
[79.851066] Starting subtest: yf-tiled-addfb
[79.855450] Subtest yf-tiled-addfb: SKIP (0.000s)
[79.974769] [012/134] (938s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[80.080572] Starting subtest: extended-modeset-hang-oldfb-with-reset
[80.082966] Starting dynamic subtest: pipe-A
[91.637447] Dynamic subtest pipe-A: SUCCESS (11.551s)
[91.647826] Starting dynamic subtest: pipe-D
[103.903673] Dynamic subtest pipe-D: SUCCESS (12.261s)
[103.906117] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.816s)
[104.712361] [013/134] (913s left) kms_plane_alpha_blend (constant-alpha-min)
[104.813044] Starting subtest: constant-alpha-min
[105.096582] Starting dynamic subtest: pipe-A-eDP-1
[105.841478] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.743s)
[105.850206] Starting dynamic subtest: pipe-D-eDP-1
[107.263617] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.421s)
[107.265824] Subtest constant-alpha-min: SUCCESS (2.451s)
[108.089792] [014/134] (910s left) sysfs_timeslice_duration (duration)
[108.167138] Starting subtest: duration
[108.169486] Starting dynamic subtest: vecs0
[121.847318] Dynamic subtest vecs0: SUCCESS (13.676s)
[121.858399] Starting dynamic subtest: ccs0
[135.016636] Dynamic subtest ccs0: SUCCESS (13.166s)
[135.027647] Starting dynamic subtest: vcs0
[148.851065] Dynamic subtest vcs0: SUCCESS (13.831s)
[148.862032] Starting dynamic subtest: bcs0
[162.031245] Dynamic subtest bcs0: SUCCESS (13.179s)
[162.041722] Starting dynamic subtest: rcs0
[175.198752] Dynamic subtest rcs0: SUCCESS (13.165s)
[175.212983] Starting dynamic subtest: vcs1
[188.850735] Dynamic subtest vcs1: SUCCESS (13.649s)
[188.853446] Subtest duration: SUCCESS (80.677s)
[188.947163] [015/134] (829s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[189.057279] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[192.662798] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.609s)
[193.793772] [016/134] (824s left) kms_cursor_crc (cursor-onscreen-64x64)
[193.979963] Starting subtest: cursor-onscreen-64x64
[193.984977] Starting dynamic subtest: pipe-A-eDP-1
[196.117243] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.134s)
[196.147208] Starting dynamic subtest: pipe-D-eDP-1
[198.979502] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.840s)
[198.981769] Subtest cursor-onscreen-64x64: SUCCESS (4.999s)
[199.845479] [017/134] (818s left) kms_color (ctm-red-to-blue)
[199.950495] Starting subtest: ctm-red-to-blue
[199.952738] Starting dynamic subtest: pipe-A-eDP-1
[200.668221] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.716s)
[200.677865] Starting dynamic subtest: pipe-B-eDP-1
[202.029764] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.360s)
[202.038952] Starting dynamic subtest: pipe-C-eDP-1
[203.414688] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.384s)
[203.425504] Starting dynamic subtest: pipe-D-eDP-1
[204.739081] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.324s)
[204.741358] Subtest ctm-red-to-blue: SUCCESS (4.787s)
[205.563139] [018/134] (812s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[205.633812] Subtest writes-after-reads-uncached: SKIP (0.000s)
[205.717197] [019/134] (812s left) dumb_buffer (invalid-bpp)
[205.766969] Starting subtest: invalid-bpp
[205.769257] Subtest invalid-bpp: SUCCESS (0.000s)
[205.900800] [020/134] (812s left) gem_mmap_gtt (ptrace)
[205.958179] Subtest ptrace: SKIP (0.000s)
[206.021766] [021/134] (812s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[206.147966] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[206.152387] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[206.319177] [022/134] (812s left) gem_lmem_swapping (verify)
[206.366797] Subtest verify: SKIP (0.000s)
[206.413882] [023/134] (812s left) gem_spin_batch (resubmit-new)
[206.469335] Starting subtest: resubmit-new
[206.471630] Starting dynamic subtest: rcs0
[206.476431] Dynamic subtest rcs0: SUCCESS (0.007s)
[206.486152] Starting dynamic subtest: bcs0
[206.487895] Dynamic subtest bcs0: SUCCESS (0.004s)
[206.495476] Starting dynamic subtest: vcs0
[206.497357] Dynamic subtest vcs0: SUCCESS (0.004s)
[206.505317] Starting dynamic subtest: vcs1
[206.507076] Dynamic subtest vcs1: SUCCESS (0.005s)
[206.514349] Starting dynamic subtest: vecs0
[206.516179] Dynamic subtest vecs0: SUCCESS (0.005s)
[206.523372] Starting dynamic subtest: ccs0
[206.525229] Dynamic subtest ccs0: SUCCESS (0.005s)
[206.527073] Subtest resubmit-new: SUCCESS (0.032s)
[207.954736] [024/134] (810s left) kms_cursor_crc (cursor-random-512x512)
[208.283318] Starting subtest: cursor-random-512x512
[208.287914] Subtest cursor-random-512x512: SKIP (0.001s)
[208.478269] [025/134] (810s left) kms_properties (plane-properties-legacy)
[208.588440] Starting subtest: plane-properties-legacy
[208.590834] Starting dynamic subtest: pipe-A-eDP-1
[209.134499] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.545s)
[209.144104] Starting dynamic subtest: pipe-B-eDP-1
[210.410721] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.275s)
[210.419208] Starting dynamic subtest: pipe-C-eDP-1
[211.655284] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.244s)
[211.664661] Starting dynamic subtest: pipe-D-eDP-1
[212.891306] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.235s)
[212.893705] Subtest plane-properties-legacy: SUCCESS (4.304s)
[213.707031] [026/134] (804s left) kms_vrr (flipline)
[213.810293] Starting subtest: flipline
[213.816570] Subtest flipline: SKIP (0.000s)
[213.924359] [027/134] (804s left) gem_exec_params (secure-non-master)
[213.977325] Starting subtest: secure-non-master
[213.981963] Subtest secure-non-master: SKIP (0.000s)
[214.114357] [028/134] (804s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[214.361949] Starting subtest: parallel-dmabuf-import-out-fence
[215.478480] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.117s)
[215.603718] [029/134] (803s left) kms_pm_dc (dc5-dpms-negative)
[216.712819] Starting subtest: dc5-dpms-negative
[216.717267] Subtest dc5-dpms-negative: SKIP (0.000s)
[216.804461] [030/134] (801s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[216.914940] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[216.919108] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[217.056247] [031/134] (801s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[217.161329] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[223.977783] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.820s)
[224.127300] [032/134] (794s left) kms_frontbuffer_tracking (psr-argb161616f-draw-mmap-cpu)
[224.230241] Starting subtest: psr-argb161616f-draw-mmap-cpu
[224.234245] Subtest psr-argb161616f-draw-mmap-cpu: SKIP (0.000s)
[224.359666] [033/134] (794s left) gem_exec_whisper (basic-fds-all)
[224.421567] Starting subtest: basic-fds-all
[235.826893] Subtest basic-fds-all: SUCCESS (11.404s)
[236.035305] [034/134] (782s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[236.151389] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[236.155540] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[236.280238] [035/134] (782s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[236.374162] Starting subtest: psr-rgb565-draw-render
[243.358057] Subtest psr-rgb565-draw-render: SUCCESS (6.986s)
[243.527896] [036/134] (775s left) gem_render_copy_redux (flink)
[243.599602] Starting subtest: flink
[244.355897] Subtest flink: SUCCESS (0.757s)
[244.521270] [037/134] (774s left) gem_mmap_wc (bad-offset)
[244.571895] Subtest bad-offset: SKIP (0.000s)
[244.639772] [038/134] (774s left) gem_pxp (reject-modify-context-protection-off-2)
[244.774553] Starting subtest: reject-modify-context-protection-off-2
[244.776737] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[244.932027] [039/134] (774s left) kms_3d (basic)
[244.993699] Starting subtest: basic
[246.938053] Subtest basic: SUCCESS (1.946s)
[247.440333] [040/134] (771s left) gem_ctx_persistence (smoketest)
[247.527803] Starting subtest: smoketest
[287.795419] Subtest smoketest: SUCCESS (40.264s)
[287.898250] [041/134] (731s left) kms_psr (fbc-pr-suspend)
[287.988946] Starting subtest: fbc-pr-suspend
[287.993301] Subtest fbc-pr-suspend: SKIP (0.000s)
[288.084693] [042/134] (731s left) syncobj_timeline (multi-wait-for-submit-signaled)
[288.138856] Starting subtest: multi-wait-for-submit-signaled
[288.141129] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[288.251538] [043/134] (731s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[288.356888] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[288.359167] Starting dynamic subtest: pipe-A-default-mode
[291.060180] Dynamic subtest pipe-A-default-mode: SUCCESS (2.704s)
[291.062500] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.705s)
[291.903188] [044/134] (727s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[292.005702] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[292.008024] Starting dynamic subtest: pipe-A-default-mode
[294.663619] Dynamic subtest pipe-A-default-mode: SUCCESS (2.656s)
[294.665588] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.657s)
[295.506369] [045/134] (723s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[295.620674] Starting subtest: psr-rgb565-draw-mmap-cpu
[302.310391] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.694s)
[302.447565] [046/134] (716s left) vgem_basic (mmap)
[302.553939] Starting subtest: mmap
[302.558965] Subtest mmap: SUCCESS (0.007s)
[302.629807] [FACT vgem_basic (mmap)] new: kernel.kmod_is_loaded.vgem: true
[302.633171] [047/134] (716s left) gem_userptr_blits (sync-unmap-after-close)
[302.702690] Starting subtest: sync-unmap-after-close
[302.713344] Subtest sync-unmap-after-close: SUCCESS (0.010s)
[302.894093] [048/134] (716s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[303.283730] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[304.059660] [049/134] (715s left) kms_frontbuffer_tracking (basic)
[304.170034] Starting subtest: basic
[307.265945] Subtest basic: SUCCESS (3.101s)
[307.426459] [050/134] (712s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[307.535393] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[314.416376] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (6.880s)
[314.563116] [051/134] (705s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[314.673271] Starting subtest: fbc-rgb101010-draw-blt
[319.235309] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.566s)
[320.417961] [052/134] (699s left) kms_lease (lease-unleased-connector)
[320.529965] Starting subtest: lease-unleased-connector
[320.532323] Starting dynamic subtest: pipe-A-eDP-1
[320.537381] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.008s)
[320.548108] Starting dynamic subtest: pipe-B-eDP-1
[320.550602] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[320.567749] Starting dynamic subtest: pipe-C-eDP-1
[320.570111] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s)
[320.578593] Starting dynamic subtest: pipe-D-eDP-1
[320.580742] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s)
[320.582945] Subtest lease-unleased-connector: SUCCESS (0.038s)
[320.694417] [053/134] (698s left) gem_tiled_partial_pwrite_pread (reads)
[320.753353] Subtest reads: SKIP (0.000s)
[320.822261] [054/134] (698s left) kms_dp_link_training (uhbr-sst)
[320.919532] Starting subtest: uhbr-sst
[320.928230] Subtest uhbr-sst: SKIP (0.000s)
[321.019995] [055/134] (698s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[321.079324] Starting subtest: etime-multi-wait-all-submitted-signaled
[321.184837] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.106s)
[321.281441] [056/134] (698s left) kms_invalid_mode (overflow-vrefresh)
[321.380599] Starting subtest: overflow-vrefresh
[321.382927] Starting dynamic subtest: pipe-A-eDP-1
[321.669462] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[321.678870] Starting dynamic subtest: pipe-B-eDP-1
[321.681234] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[321.691419] Starting dynamic subtest: pipe-C-eDP-1
[321.693455] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[321.701323] Starting dynamic subtest: pipe-D-eDP-1
[321.703233] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[321.705122] Subtest overflow-vrefresh: SUCCESS (0.296s)
[322.507537] [057/134] (697s left) kms_pm_rpm (i2c)
[324.032677] Starting subtest: i2c
[329.437647] Subtest i2c: SUCCESS (5.404s)
[329.581917] [058/134] (690s left) gem_exec_balancer (busy)
[329.653347] Starting subtest: busy
[330.936679] Subtest busy: SUCCESS (1.281s)
[331.292414] [059/134] (688s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[336.301256] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[336.305695] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s)
[337.177142] [060/134] (682s left) gen9_exec_parse (batch-without-end)
[337.237173] Subtest batch-without-end: SKIP (0.000s)
[337.311207] [061/134] (682s left) gem_ctx_shared (exec-shared-gtt)
[337.370097] Starting subtest: exec-shared-gtt
[337.372486] Starting dynamic subtest: rcs0
[337.377618] Dynamic subtest rcs0: SUCCESS (0.007s)
[337.388075] Starting dynamic subtest: bcs0
[337.390015] Dynamic subtest bcs0: SUCCESS (0.006s)
[337.398817] Starting dynamic subtest: vcs0
[337.401047] Dynamic subtest vcs0: SUCCESS (0.006s)
[337.409674] Starting dynamic subtest: vcs1
[337.411956] Dynamic subtest vcs1: SUCCESS (0.007s)
[337.420607] Starting dynamic subtest: vecs0
[337.422827] Dynamic subtest vecs0: SUCCESS (0.006s)
[337.431416] Starting dynamic subtest: ccs0
[337.433596] Dynamic subtest ccs0: SUCCESS (0.005s)
[337.435758] Subtest exec-shared-gtt: SUCCESS (0.040s)
[337.622372] [062/134] (682s left) perf (invalid-oa-metric-set-id)
[337.771605] Starting subtest: invalid-oa-metric-set-id
[337.783868] Subtest invalid-oa-metric-set-id: SUCCESS (0.011s)
[337.828775] [063/134] (682s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[337.893078] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[337.895332] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s)
[338.026106] [064/134] (682s left) gem_tiled_pread_pwrite
[338.139647] [065/134] (682s left) i915_pm_rps (thresholds-park)
[338.200388] Starting subtest: thresholds-park
[338.204253] Subtest thresholds-park: SKIP (0.001s)
[338.327446] [066/134] (681s left) gem_ctx_engines (invalid-engines)
[338.389729] Starting subtest: invalid-engines
[338.397934] Subtest invalid-engines: SUCCESS (0.008s)
[338.663772] [067/134] (681s left) vgem_basic (create)
[338.712140] Starting subtest: create
[338.714018] Subtest create: SUCCESS (0.000s)
[338.794256] [068/134] (681s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[338.906747] Starting subtest: fbc-psr2-sprite-mmap-cpu
[338.909121] Starting dynamic subtest: eDP-1
[338.913511] Dynamic subtest eDP-1: SKIP (0.000s)
[338.917664] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.002s)
[339.004883] [069/134] (681s left) gem_mmap_gtt (big-copy-odd)
[339.065718] Subtest big-copy-odd: SKIP (0.000s)
[339.134441] [070/134] (681s left) gem_exec_reloc (basic-gtt-cpu-active)
[339.196392] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[339.281359] [071/134] (681s left) prime_busy (before-wait)
[339.346977] Starting subtest: before-wait
[339.351718] Starting dynamic subtest: rcs0
[339.411867] Dynamic subtest rcs0: SUCCESS (0.062s)
[339.421746] Starting dynamic subtest: bcs0
[339.493983] Dynamic subtest bcs0: SUCCESS (0.081s)
[339.503819] Starting dynamic subtest: vcs0
[339.535264] Dynamic subtest vcs0: SUCCESS (0.041s)
[339.544081] Starting dynamic subtest: vcs1
[339.576025] Dynamic subtest vcs1: SUCCESS (0.040s)
[339.584058] Starting dynamic subtest: vecs0
[339.618818] Dynamic subtest vecs0: SUCCESS (0.042s)
[339.627505] Starting dynamic subtest: ccs0
[339.659718] Dynamic subtest ccs0: SUCCESS (0.040s)
[339.768408] Subtest before-wait: SUCCESS (0.421s)
[339.866868] [072/134] (680s left) gem_exec_fence (keep-in-fence)
[340.042873] Starting subtest: keep-in-fence
[340.045336] Starting dynamic subtest: rcs0
[340.125777] Dynamic subtest rcs0: SUCCESS (0.082s)
[340.137074] Starting dynamic subtest: bcs0
[340.179279] Dynamic subtest bcs0: SUCCESS (0.051s)
[340.191056] Starting dynamic subtest: vcs0
[341.911044] Dynamic subtest vcs0: SUCCESS (1.728s)
[341.922977] Starting dynamic subtest: vcs1
[343.894471] Dynamic subtest vcs1: SUCCESS (1.980s)
[343.906189] Starting dynamic subtest: vecs0
[345.941909] Dynamic subtest vecs0: SUCCESS (2.045s)
[345.952809] Starting dynamic subtest: ccs0
[346.186542] Dynamic subtest ccs0: SUCCESS (0.243s)
[346.189044] Subtest keep-in-fence: SUCCESS (6.144s)
[348.067029] [073/134] (672s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[348.181729] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[351.883647] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.706s)
[353.087399] [074/134] (667s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[353.187752] Starting subtest: 4-tiled-8bpp-rotate-270
[353.208840] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.020s)
[353.368333] [075/134] (667s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[358.348867] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[358.351318] Starting dynamic subtest: pipe-A-eDP-1
[359.140585] Dynamic subtest pipe-A-eDP-1: SKIP (0.789s)
[359.150700] Starting dynamic subtest: pipe-B-eDP-1
[360.261516] Dynamic subtest pipe-B-eDP-1: SKIP (1.119s)
[360.265827] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.912s)
[361.463660] [076/134] (659s left) gem_ccs (block-multicopy-inplace)
[361.533589] Starting subtest: block-multicopy-inplace
[361.537950] Subtest block-multicopy-inplace: SKIP (0.000s)
[361.698514] [077/134] (658s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[361.809855] Starting subtest: x-tiled-addfb-size-offset-overflow
[361.812140] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[361.952179] [078/134] (658s left) kms_atomic (crtc-invalid-params)
[362.055924] Starting subtest: crtc-invalid-params
[362.058138] Starting dynamic subtest: pipe-A-eDP-1
[362.412687] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.359s)
[362.415024] Subtest crtc-invalid-params: SUCCESS (0.360s)
[363.284275] [079/134] (657s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[363.377015] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[363.379255] Starting dynamic subtest: pipe-A-eDP-1
[363.398466] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s)
[363.409142] Starting dynamic subtest: pipe-B-eDP-1
[363.428303] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.019s)
[363.437443] Starting dynamic subtest: pipe-C-eDP-1
[363.457208] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.019s)
[363.468543] Starting dynamic subtest: pipe-D-eDP-1
[363.488754] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.019s)
[363.491095] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.082s)
[365.750839] [080/134] (655s left) gem_lmem_swapping (heavy-verify-multi)
[365.794736] Subtest heavy-verify-multi: SKIP (0.000s)
[365.839197] [081/134] (654s left) kms_chamelium_frames (hdmi-crc-fast)
[366.249541] Subtest hdmi-crc-fast: SKIP (0.000s)
[367.033563] [082/134] (653s left) kms_vblank (query-forked-busy-hang)
[367.135584] Starting subtest: query-forked-busy-hang
[367.137768] Starting dynamic subtest: pipe-A-eDP-1
[393.683710] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.547s)
[393.698834] Starting dynamic subtest: pipe-D-eDP-1
[408.662789] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.976s)
[408.665073] Subtest query-forked-busy-hang: SUCCESS (41.527s)
[409.537643] [083/134] (611s left) kms_big_fb (linear-16bpp-rotate-90)
[409.635811] Starting subtest: linear-16bpp-rotate-90
[409.656096] Subtest linear-16bpp-rotate-90: SKIP (0.020s)
[409.815288] [084/134] (611s left) gem_flink_race (flink_close)
[409.850321] Starting subtest: flink_close
[414.951099] Subtest flink_close: SUCCESS (5.103s)
[415.053077] [085/134] (605s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[415.161464] Starting subtest: fbcpsr-modesetfrombusy
[421.291094] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.133s)
[421.461846] [086/134] (599s left) gem_exec_schedule (thriceslice)
[421.529307] Starting subtest: thriceslice
[421.530968] Starting dynamic subtest: rcs0
[421.550898] Dynamic subtest rcs0: SUCCESS (0.030s)
[421.562307] Starting dynamic subtest: bcs0
[421.579219] Dynamic subtest bcs0: SUCCESS (0.028s)
[421.589245] Starting dynamic subtest: vcs0
[421.608869] Dynamic subtest vcs0: SUCCESS (0.029s)
[421.617199] Starting dynamic subtest: vcs1
[421.638848] Dynamic subtest vcs1: SUCCESS (0.029s)
[421.647761] Starting dynamic subtest: vecs0
[421.689153] Dynamic subtest vecs0: SUCCESS (0.049s)
[421.703565] Starting dynamic subtest: ccs0
[421.739672] Dynamic subtest ccs0: SUCCESS (0.049s)
[421.741724] Subtest thriceslice: SUCCESS (0.220s)
[422.080386] [087/134] (599s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[422.181453] Starting subtest: flip-vs-dpms-off-vs-modeset
[422.183614] Starting dynamic subtest: A-eDP1
[425.835370] Dynamic subtest A-eDP1: SUCCESS (3.652s)
[425.845935] Starting dynamic subtest: B-eDP1
[429.027959] Dynamic subtest B-eDP1: SUCCESS (3.191s)
[429.037643] Starting dynamic subtest: C-eDP1
[432.136547] Dynamic subtest C-eDP1: SUCCESS (3.110s)
[432.147411] Starting dynamic subtest: D-eDP1
[435.249871] Dynamic subtest D-eDP1: SUCCESS (3.109s)
[435.252299] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.070s)
[436.068378] [088/134] (585s left) i915_pm_rps (min-max-config-idle)
[436.145440] Starting subtest: min-max-config-idle
[436.149502] Subtest min-max-config-idle: SKIP (0.000s)
[436.314517] [089/134] (584s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[436.419961] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[442.961655] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.545s)
[443.131262] [090/134] (578s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[448.141358] Starting subtest: psr2-overlay-plane-move-continuous-sf
[448.143641] Starting dynamic subtest: pipe-A-eDP-1
[454.845714] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.703s)
[454.856558] Starting dynamic subtest: pipe-B-eDP-1
[461.504568] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.656s)
[461.506924] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.364s)
[462.404283] [091/134] (558s left) kms_concurrent (multi-plane-atomic-lowres)
[462.504092] Starting subtest: multi-plane-atomic-lowres
[462.506326] Starting dynamic subtest: pipe-A-eDP-1
[462.994802] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.487s)
[462.997194] Subtest multi-plane-atomic-lowres: SUCCESS (0.488s)
[463.831355] [092/134] (557s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[463.928723] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[463.932696] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[464.072440] [093/134] (557s left) api_intel_allocator (reopen)
[464.128646] Starting subtest: reopen
[464.131049] Subtest reopen: SUCCESS (0.004s)
[464.274426] [094/134] (557s left) kms_flip (dpms-vs-vblank-race)
[464.358275] Starting subtest: dpms-vs-vblank-race
[464.360600] Starting dynamic subtest: A-eDP1
[468.183008] Dynamic subtest A-eDP1: SUCCESS (3.823s)
[468.196441] Starting dynamic subtest: B-eDP1
[472.795946] Dynamic subtest B-eDP1: SUCCESS (4.609s)
[472.805818] Starting dynamic subtest: C-eDP1
[477.420694] Dynamic subtest C-eDP1: SUCCESS (4.624s)
[477.430425] Starting dynamic subtest: D-eDP1
[482.062408] Dynamic subtest D-eDP1: SUCCESS (4.642s)
[482.064596] Subtest dpms-vs-vblank-race: SUCCESS (17.706s)
[482.962838] [095/134] (538s left) syncobj_timeline (single-wait-all-available-signaled)
[483.030843] Starting subtest: single-wait-all-available-signaled
[483.032768] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[483.170331] [096/134] (538s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[483.260019] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[483.261914] Starting dynamic subtest: pipe-A-eDP-1
[484.590906] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.331s)
[484.881721] Starting dynamic subtest: pipe-B-eDP-1
[485.917429] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.042s)
[486.185405] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.925s)
[487.049444] [097/134] (534s left) gem_exec_params (rs-invalid)
[487.109621] Starting subtest: rs-invalid
[487.115095] Subtest rs-invalid: SUCCESS (0.003s)
[487.283207] [098/134] (534s left) kms_scaling_modes (scaling-mode-full-aspect)
[487.384562] Starting subtest: scaling-mode-full-aspect
[487.386733] Starting dynamic subtest: pipe-A-eDP-1
[487.478703] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.095s)
[487.488055] Starting dynamic subtest: pipe-B-eDP-1
[488.647966] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.168s)
[488.660752] Starting dynamic subtest: pipe-C-eDP-1
[489.750290] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.101s)
[489.759795] Starting dynamic subtest: pipe-D-eDP-1
[490.890442] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.138s)
[490.892909] Subtest scaling-mode-full-aspect: SUCCESS (3.508s)
[492.101848] [099/134] (529s left) kms_plane (plane-panning-top-left)
[492.203214] Starting subtest: plane-panning-top-left
[492.205152] Starting dynamic subtest: pipe-A
[493.845824] Dynamic subtest pipe-A: SUCCESS (1.642s)
[493.856810] Starting dynamic subtest: pipe-B
[496.188372] Dynamic subtest pipe-B: SUCCESS (2.340s)
[496.190562] Subtest plane-panning-top-left: SUCCESS (3.985s)
[497.015444] [100/134] (524s left) kms_psr (psr2-sprite-mmap-cpu)
[497.114787] Starting subtest: psr2-sprite-mmap-cpu
[497.117058] Starting dynamic subtest: eDP-1
[498.907689] Dynamic subtest eDP-1: SUCCESS (1.791s)
[498.910100] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.792s)
[499.786330] [101/134] (521s left) gem_exec_params (rel-constants-invalid-ring)
[499.854349] Starting subtest: rel-constants-invalid-ring
[499.856668] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[499.970370] [102/134] (521s left) i915_query (query-garbage)
[500.026046] Starting subtest: query-garbage
[500.028279] Subtest query-garbage: SUCCESS (0.000s)
[500.158332] [103/134] (521s left) kms_psr (psr-cursor-mmap-cpu)
[500.246610] Starting subtest: psr-cursor-mmap-cpu
[500.248825] Starting dynamic subtest: eDP-1
[501.958226] Dynamic subtest eDP-1: SUCCESS (1.711s)
[501.960497] Subtest psr-cursor-mmap-cpu: SUCCESS (1.712s)
[502.849745] [104/134] (518s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[502.951411] Starting subtest: y-tiled-16bpp-rotate-90
[502.955733] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[503.076657] [105/134] (518s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[503.176711] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[503.181218] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[504.287212] [106/134] (517s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[504.412088] Starting subtest: flip-vs-cursor-legacy
[511.397387] Subtest flip-vs-cursor-legacy: SUCCESS (6.984s)
[512.222513] [107/134] (509s left) kms_frontbuffer_tracking (fbcpsr-argb161616f-draw-blt)
[512.340503] Starting subtest: fbcpsr-argb161616f-draw-blt
[512.344513] Subtest fbcpsr-argb161616f-draw-blt: SKIP (0.000s)
[512.470353] [108/134] (509s left) kms_flip (flip-vs-fences)
[512.571972] Starting subtest: flip-vs-fences
[512.575999] Subtest flip-vs-fences: SKIP (0.000s)
[512.707010] [109/134] (509s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[512.792775] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[512.907702] [110/134] (509s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[513.004073] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[513.006045] Starting dynamic subtest: pipe-A-eDP-1
[513.826102] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.815s)
[513.835049] Starting dynamic subtest: pipe-B-eDP-1
[515.450604] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.621s)
[515.462251] Starting dynamic subtest: pipe-C-eDP-1
[516.920962] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.471s)
[516.930917] Starting dynamic subtest: pipe-D-eDP-1
[518.469601] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.544s)
[518.471850] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.456s)
[519.672756] [111/134] (502s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[519.777214] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[519.781077] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[519.893810] [112/134] (502s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[519.986932] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[519.988853] Starting dynamic subtest: pipe-A-eDP-1
[520.689629] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.695s)
[520.698085] Starting dynamic subtest: pipe-B-eDP-1
[522.479610] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.788s)
[522.490171] Starting dynamic subtest: pipe-C-eDP-1
[524.294306] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.813s)
[524.306159] Starting dynamic subtest: pipe-D-eDP-1
[526.050135] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.755s)
[526.052357] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.057s)
[527.217202] [113/134] (494s left) i915_drm_fdinfo (memory-info-shared)
[527.261168] Starting subtest: memory-info-shared
[527.263279] Starting dynamic subtest: smem0
[527.339077] Dynamic subtest smem0: SUCCESS (0.078s)
[527.341614] Subtest memory-info-shared: SUCCESS (0.079s)
[527.438571] [114/134] (494s left) gem_exec_flush (basic-wb-set-default)
[527.504897] Starting subtest: basic-wb-set-default
[532.958841] Subtest basic-wb-set-default: SUCCESS (5.456s)
[533.174493] [115/134] (489s left) sysfs_timeslice_duration (timeout)
[533.240667] Starting subtest: timeout
[533.242643] Starting dynamic subtest: vecs0
[542.954493] Dynamic subtest vecs0: SUCCESS (9.713s)
[542.966063] Starting dynamic subtest: ccs0
[544.378053] Dynamic subtest ccs0: SUCCESS (1.423s)
[544.389682] Starting dynamic subtest: vcs0
[553.901203] Dynamic subtest vcs0: SUCCESS (9.520s)
[553.911540] Starting dynamic subtest: bcs0
[554.624795] Dynamic subtest bcs0: SUCCESS (0.724s)
[554.633729] Starting dynamic subtest: rcs0
[556.023593] Dynamic subtest rcs0: SUCCESS (1.396s)
[556.035248] Starting dynamic subtest: vcs1
[565.908923] Dynamic subtest vcs1: SUCCESS (9.880s)
[565.911608] Subtest timeout: SUCCESS (32.668s)
[566.008256] [116/134] (456s left) sriov_basic (enable-vfs-bind-unbind-each)
[566.075205] Starting subtest: enable-vfs-bind-unbind-each
[566.077367] Starting dynamic subtest: numvfs-1
[566.154841] Dynamic subtest numvfs-1: FAIL (0.031s)
[566.165747] Starting dynamic subtest: numvfs-2
[566.237971] Dynamic subtest numvfs-2: FAIL (0.004s)
[566.248303] Starting dynamic subtest: numvfs-3
[566.321494] Dynamic subtest numvfs-3: FAIL (0.003s)
[566.332093] Starting dynamic subtest: numvfs-4
[566.404278] Dynamic subtest numvfs-4: FAIL (0.003s)
[566.414875] Starting dynamic subtest: numvfs-5
[566.488160] Dynamic subtest numvfs-5: FAIL (0.004s)
[566.498596] Starting dynamic subtest: numvfs-6
[566.571211] Dynamic subtest numvfs-6: FAIL (0.006s)
[566.581644] Starting dynamic subtest: numvfs-7
[566.654098] Dynamic subtest numvfs-7: FAIL (0.003s)
[566.664125] Starting dynamic subtest: numvfs-random
[566.735637] Dynamic subtest numvfs-random: FAIL (0.003s)
[566.737652] Subtest enable-vfs-bind-unbind-each: FAIL (0.063s)
[566.776585] [117/134] (455s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[566.885941] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[566.890537] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[568.037184] [118/134] (454s left) kms_getfb (getfb-handle-not-fb)
[568.139044] Starting subtest: getfb-handle-not-fb
[568.141431] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[568.299795] [119/134] (454s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[568.370186] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[568.374443] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[568.576512] [120/134] (453s left) gem_workarounds (reset-context)
[568.646273] Starting subtest: reset-context
[568.805330] Subtest reset-context: SUCCESS (0.159s)
[568.977371] [121/134] (453s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[569.076612] Starting subtest: psr-farfromfence-mmap-gtt
[569.080911] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[569.195305] [122/134] (453s left) gem_wait (write-busy)
[569.265757] Starting subtest: write-busy
[569.268236] Starting dynamic subtest: all-engines
[569.892367] Dynamic subtest all-engines: SUCCESS (0.626s)
[569.904701] Starting dynamic subtest: rcs0
[570.465907] Dynamic subtest rcs0: SUCCESS (0.572s)
[570.482208] Starting dynamic subtest: bcs0
[571.018718] Dynamic subtest bcs0: SUCCESS (0.551s)
[571.034800] Starting dynamic subtest: vcs0
[572.884715] Dynamic subtest vcs0: SUCCESS (1.864s)
[572.900831] Starting dynamic subtest: vcs1
[574.932746] Dynamic subtest vcs1: SUCCESS (2.045s)
[574.948479] Starting dynamic subtest: vecs0
[576.916828] Dynamic subtest vecs0: SUCCESS (1.982s)
[576.932886] Starting dynamic subtest: ccs0
[577.467938] Dynamic subtest ccs0: SUCCESS (0.550s)
[577.470342] Subtest write-busy: SUCCESS (8.203s)
[577.691807] [123/134] (444s left) i915_hangman (detector)
[577.774667] Starting subtest: detector
[577.776998] Starting dynamic subtest: rcs0
[588.852187] Dynamic subtest rcs0: SUCCESS (11.075s)
[588.863828] Starting dynamic subtest: bcs0
[600.820619] Dynamic subtest bcs0: SUCCESS (11.965s)
[600.836231] Starting dynamic subtest: vcs0
[611.827532] Dynamic subtest vcs0: SUCCESS (11.004s)
[611.839400] Starting dynamic subtest: vcs1
[623.795987] Dynamic subtest vcs1: SUCCESS (11.965s)
[623.807690] Starting dynamic subtest: vecs0
[633.843579] Dynamic subtest vecs0: SUCCESS (10.044s)
[633.855493] Starting dynamic subtest: ccs0
[645.876807] Dynamic subtest ccs0: SUCCESS (12.030s)
[645.879928] Subtest detector: SUCCESS (68.100s)
[646.045507] [124/134] (376s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[646.156310] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[646.160161] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[646.293088] [125/134] (376s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[646.408773] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[646.413235] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[646.580374] [126/134] (376s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[646.637257] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[646.696634] [127/134] (376s left) gem_exec_schedule (noreorder-corked)
[646.884827] Starting subtest: noreorder-corked
[646.887545] Starting dynamic subtest: rcs0
[648.053023] Dynamic subtest rcs0: SUCCESS (1.169s)
[648.066073] Starting dynamic subtest: vcs0
[649.891658] Dynamic subtest vcs0: SUCCESS (1.835s)
[649.904094] Starting dynamic subtest: vcs1
[651.952880] Dynamic subtest vcs1: SUCCESS (2.058s)
[651.965276] Starting dynamic subtest: vecs0
[653.899644] Dynamic subtest vecs0: SUCCESS (1.944s)
[653.912496] Starting dynamic subtest: ccs0
[655.083261] Dynamic subtest ccs0: SUCCESS (1.182s)
[655.085939] Subtest noreorder-corked: SUCCESS (8.200s)
[655.298145] [128/134] (367s left) kms_psr (pr-cursor-mmap-cpu)
[655.397189] Starting subtest: pr-cursor-mmap-cpu
[655.401736] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[655.496876] [129/134] (367s left) perf (invalid-oa-format-id)
[655.607855] Starting subtest: invalid-oa-format-id
[655.610461] Subtest invalid-oa-format-id: SUCCESS (0.007s)
[655.657403] [130/134] (367s left) gem_eio (in-flight-internal-immediate)
[655.841812] Starting subtest: in-flight-internal-immediate
[656.974395] Subtest in-flight-internal-immediate: SUCCESS (1.131s)
[657.149448] [131/134] (365s left) kms_cursor_edge_walk (256x256-top-edge)
[657.252565] Starting subtest: 256x256-top-edge
[657.255179] Starting dynamic subtest: pipe-A-eDP-1
[660.677189] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.425s)
[660.687198] Starting dynamic subtest: pipe-D-eDP-1
[663.813403] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.135s)
[663.815721] Subtest 256x256-top-edge: SUCCESS (6.563s)
[664.628168] [132/134] (358s left) gem_ctx_persistence (engines-persistence)
[664.702599] Starting subtest: engines-persistence
[664.704887] Starting dynamic subtest: rcs0
[665.519081] Dynamic subtest rcs0: SUCCESS (0.817s)
[665.530450] Starting dynamic subtest: bcs0
[666.344862] Dynamic subtest bcs0: SUCCESS (0.823s)
[666.356347] Starting dynamic subtest: vcs0
[667.112049] Dynamic subtest vcs0: SUCCESS (0.765s)
[667.124905] Starting dynamic subtest: vcs1
[667.877949] Dynamic subtest vcs1: SUCCESS (0.763s)
[667.889053] Starting dynamic subtest: vecs0
[668.650807] Dynamic subtest vecs0: SUCCESS (0.771s)
[668.662264] Starting dynamic subtest: ccs0
[669.479957] Dynamic subtest ccs0: SUCCESS (0.827s)
[669.482588] Subtest engines-persistence: SUCCESS (4.779s)
[669.586810] [133/134] (353s left) api_intel_bb (render-ccs)
[669.650516] Starting subtest: render-ccs
[670.004558] Subtest render-ccs: SUCCESS (0.354s)
[670.122351] [134/134] (352s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[670.223705] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[670.228190] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[670.334276] 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.