[63.724949] Initializing watchdogs
[63.725106]   /dev/watchdog0
[63.739896] [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]
[63.744128] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[63.746331] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.749624] [001/134] (960s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[63.877897] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[63.880355] Starting dynamic subtest: pipe-A
[63.963245] Dynamic subtest pipe-A: SUCCESS (0.087s)
[63.972840] Starting dynamic subtest: pipe-B
[65.131741] Dynamic subtest pipe-B: SUCCESS (1.169s)
[65.142756] Starting dynamic subtest: pipe-C
[66.229886] Dynamic subtest pipe-C: SUCCESS (1.099s)
[66.239066] Starting dynamic subtest: pipe-D
[67.351291] Dynamic subtest pipe-D: SUCCESS (1.122s)
[67.353605] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.479s)
[68.751466] [002/134] (955s left) gem_userptr_blits (forbidden-operations)
[68.823566] Starting subtest: forbidden-operations
[68.827817] Subtest forbidden-operations: SKIP (0.000s)
[68.973406] [003/134] (955s left) gem_mmap_gtt (big-bo)
[69.034787] Subtest big-bo: SKIP (0.000s)
[69.104482] [004/134] (955s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[69.200997] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[76.598765] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.405s)
[76.754574] [005/134] (947s left) kms_fence_pin_leak
[76.942366] [006/134] (947s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[77.032971] Starting subtest: x-tiled-16bpp-rotate-180
[78.265950] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.233s)
[78.430207] [007/134] (946s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[78.496072] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[78.556519] [008/134] (945s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[78.649081] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[78.659931] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.010s)
[78.790820] [009/134] (945s left) perf_pmu (busy-check-all)
[78.826695] Starting subtest: busy-check-all
[78.828577] Starting dynamic subtest: rcs0
[79.404764] Dynamic subtest rcs0: SUCCESS (0.578s)
[79.415363] Starting dynamic subtest: bcs0
[79.958447] Dynamic subtest bcs0: SUCCESS (0.553s)
[79.970179] Starting dynamic subtest: vcs0
[81.942742] Dynamic subtest vcs0: SUCCESS (1.982s)
[81.953544] Starting dynamic subtest: vcs1
[83.926019] Dynamic subtest vcs1: SUCCESS (1.981s)
[83.936388] Starting dynamic subtest: vecs0
[85.909973] Dynamic subtest vecs0: SUCCESS (1.983s)
[85.920781] Starting dynamic subtest: ccs0
[86.462881] Dynamic subtest ccs0: SUCCESS (0.554s)
[86.465307] Subtest busy-check-all: SUCCESS (7.639s)
[86.608660] [010/134] (937s left) gem_mmap_wc (coherency)
[86.669674] Subtest coherency: SKIP (0.000s)
[86.728292] [011/134] (937s left) kms_big_fb (yf-tiled-addfb)
[86.831292] Starting subtest: yf-tiled-addfb
[86.835509] Subtest yf-tiled-addfb: SKIP (0.000s)
[86.950672] [012/134] (937s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[87.041601] Starting subtest: extended-modeset-hang-oldfb-with-reset
[87.044035] Starting dynamic subtest: pipe-A
[98.720059] Dynamic subtest pipe-A: SUCCESS (11.676s)
[98.730433] Starting dynamic subtest: pipe-D
[110.999868] Dynamic subtest pipe-D: SUCCESS (12.281s)
[111.002725] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.961s)
[111.819754] [013/134] (912s left) kms_plane_alpha_blend (constant-alpha-min)
[111.929933] Starting subtest: constant-alpha-min
[112.210889] Starting dynamic subtest: pipe-A-eDP-1
[112.943955] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.732s)
[112.952185] Starting dynamic subtest: pipe-D-eDP-1
[114.431438] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.487s)
[114.433895] Subtest constant-alpha-min: SUCCESS (2.503s)
[115.297618] [014/134] (909s left) sysfs_timeslice_duration (duration)
[115.356212] Starting subtest: duration
[115.358544] Starting dynamic subtest: vecs0
[128.819578] Dynamic subtest vecs0: SUCCESS (13.461s)
[128.830568] Starting dynamic subtest: ccs0
[141.986279] Dynamic subtest ccs0: SUCCESS (13.166s)
[141.997337] Starting dynamic subtest: vcs0
[155.829617] Dynamic subtest vcs0: SUCCESS (13.840s)
[155.840930] Starting dynamic subtest: bcs0
[168.983364] Dynamic subtest bcs0: SUCCESS (13.153s)
[168.993869] Starting dynamic subtest: rcs0
[182.142459] Dynamic subtest rcs0: SUCCESS (13.157s)
[182.154430] Starting dynamic subtest: vcs1
[195.828273] Dynamic subtest vcs1: SUCCESS (13.683s)
[195.831103] Subtest duration: SUCCESS (80.469s)
[195.924700] [015/134] (828s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[196.040802] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[199.701200] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.665s)
[200.901614] [016/134] (823s left) kms_cursor_crc (cursor-onscreen-64x64)
[201.084454] Starting subtest: cursor-onscreen-64x64
[201.089312] Starting dynamic subtest: pipe-A-eDP-1
[203.186590] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.098s)
[203.214592] Starting dynamic subtest: pipe-D-eDP-1
[205.938751] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.731s)
[205.941564] Subtest cursor-onscreen-64x64: SUCCESS (4.852s)
[206.846912] [017/134] (818s left) kms_color (ctm-red-to-blue)
[206.951948] Starting subtest: ctm-red-to-blue
[206.954099] Starting dynamic subtest: pipe-A-eDP-1
[207.681973] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.730s)
[207.691228] Starting dynamic subtest: pipe-B-eDP-1
[209.125142] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.445s)
[209.133705] Starting dynamic subtest: pipe-C-eDP-1
[210.507935] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.379s)
[210.517023] Starting dynamic subtest: pipe-D-eDP-1
[211.831039] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.323s)
[211.833599] Subtest ctm-red-to-blue: SUCCESS (4.879s)
[212.668316] [018/134] (812s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[212.734688] Subtest writes-after-reads-uncached: SKIP (0.000s)
[212.818294] [019/134] (812s left) dumb_buffer (invalid-bpp)
[212.880139] Starting subtest: invalid-bpp
[212.882467] Subtest invalid-bpp: SUCCESS (0.000s)
[213.020039] [020/134] (811s left) gem_mmap_gtt (ptrace)
[213.075067] Subtest ptrace: SKIP (0.000s)
[213.141271] [021/134] (811s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[213.260163] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[213.264451] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[213.428056] [022/134] (811s left) gem_lmem_swapping (verify)
[213.467113] Subtest verify: SKIP (0.000s)
[213.508465] [023/134] (811s left) gem_spin_batch (resubmit-new)
[213.571065] Starting subtest: resubmit-new
[213.573073] Starting dynamic subtest: rcs0
[213.577482] Dynamic subtest rcs0: SUCCESS (0.007s)
[213.587982] Starting dynamic subtest: bcs0
[213.589824] Dynamic subtest bcs0: SUCCESS (0.003s)
[213.597944] Starting dynamic subtest: vcs0
[213.599953] Dynamic subtest vcs0: SUCCESS (0.004s)
[213.608071] Starting dynamic subtest: vcs1
[213.609821] Dynamic subtest vcs1: SUCCESS (0.008s)
[213.616898] Starting dynamic subtest: vecs0
[213.618756] Dynamic subtest vecs0: SUCCESS (0.004s)
[213.625936] Starting dynamic subtest: ccs0
[213.627768] Dynamic subtest ccs0: SUCCESS (0.004s)
[213.629556] Subtest resubmit-new: SUCCESS (0.033s)
[214.997527] [024/134] (810s left) kms_cursor_crc (cursor-random-512x512)
[215.277643] Starting subtest: cursor-random-512x512
[215.281953] Subtest cursor-random-512x512: SKIP (0.001s)
[215.441776] [025/134] (809s left) kms_properties (plane-properties-legacy)
[215.538299] Starting subtest: plane-properties-legacy
[215.540699] Starting dynamic subtest: pipe-A-eDP-1
[216.084221] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.546s)
[216.093331] Starting dynamic subtest: pipe-B-eDP-1
[217.316797] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.233s)
[217.327676] Starting dynamic subtest: pipe-C-eDP-1
[218.556765] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.238s)
[218.567371] Starting dynamic subtest: pipe-D-eDP-1
[219.796859] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.240s)
[219.799261] Subtest plane-properties-legacy: SUCCESS (4.261s)
[220.607150] [026/134] (804s left) kms_vrr (flipline)
[220.703230] Starting subtest: flipline
[220.709772] Subtest flipline: SKIP (0.000s)
[220.796246] [027/134] (804s left) gem_exec_params (secure-non-master)
[220.861218] Starting subtest: secure-non-master
[220.865316] Subtest secure-non-master: SKIP (0.000s)
[220.992133] [028/134] (804s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[221.246513] Starting subtest: parallel-dmabuf-import-out-fence
[222.361370] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.114s)
[222.508848] [029/134] (802s left) kms_pm_dc (dc5-dpms-negative)
[223.610916] Starting subtest: dc5-dpms-negative
[223.615429] Subtest dc5-dpms-negative: SKIP (0.000s)
[223.705030] [030/134] (801s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[223.809303] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[223.813315] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[223.939903] [031/134] (801s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[224.042658] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[230.864047] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.824s)
[231.001164] [032/134] (794s left) kms_frontbuffer_tracking (psr-argb161616f-draw-mmap-cpu)
[231.103607] Starting subtest: psr-argb161616f-draw-mmap-cpu
[231.107966] Subtest psr-argb161616f-draw-mmap-cpu: SKIP (0.000s)
[231.238838] [033/134] (794s left) gem_exec_whisper (basic-fds-all)
[231.305492] Starting subtest: basic-fds-all
[242.910369] Subtest basic-fds-all: SUCCESS (11.601s)
[243.120016] [034/134] (782s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[243.233817] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[243.238394] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[243.373010] [035/134] (782s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[243.469398] Starting subtest: psr-rgb565-draw-render
[250.799058] Subtest psr-rgb565-draw-render: SUCCESS (7.331s)
[250.964857] [036/134] (774s left) gem_render_copy_redux (flink)
[251.033318] Starting subtest: flink
[251.827107] Subtest flink: SUCCESS (0.794s)
[251.995819] [037/134] (773s left) gem_mmap_wc (bad-offset)
[252.062565] Subtest bad-offset: SKIP (0.000s)
[252.126961] [038/134] (773s left) gem_pxp (reject-modify-context-protection-off-2)
[252.257633] Starting subtest: reject-modify-context-protection-off-2
[252.259611] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[252.399936] [039/134] (773s left) kms_3d (basic)
[252.468441] Starting subtest: basic
[254.397799] Subtest basic: SUCCESS (1.929s)
[254.935726] [040/134] (770s left) gem_ctx_persistence (smoketest)
[254.994986] Starting subtest: smoketest
[294.835532] Subtest smoketest: SUCCESS (39.837s)
[294.937472] [041/134] (730s left) kms_psr (fbc-pr-suspend)
[295.052990] Starting subtest: fbc-pr-suspend
[295.057081] Subtest fbc-pr-suspend: SKIP (0.000s)
[295.143451] [042/134] (730s left) syncobj_timeline (multi-wait-for-submit-signaled)
[295.209605] Starting subtest: multi-wait-for-submit-signaled
[295.211959] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[295.337516] [043/134] (730s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[295.426079] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[295.428369] Starting dynamic subtest: pipe-A-default-mode
[298.158966] Dynamic subtest pipe-A-default-mode: SUCCESS (2.733s)
[298.161322] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.734s)
[299.015264] [044/134] (726s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[299.121118] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[299.123268] Starting dynamic subtest: pipe-A-default-mode
[301.884450] Dynamic subtest pipe-A-default-mode: SUCCESS (2.763s)
[301.886842] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.764s)
[302.712670] [045/134] (723s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[302.814277] Starting subtest: psr-rgb565-draw-mmap-cpu
[309.433503] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.620s)
[309.578627] [046/134] (716s left) vgem_basic (mmap)
[309.690570] Starting subtest: mmap
[309.692529] Subtest mmap: SUCCESS (0.007s)
[309.765208] [FACT vgem_basic (mmap)] new: kernel.kmod_is_loaded.vgem: true
[309.768465] [047/134] (716s left) gem_userptr_blits (sync-unmap-after-close)
[309.845064] Starting subtest: sync-unmap-after-close
[309.854688] Subtest sync-unmap-after-close: SUCCESS (0.010s)
[310.026603] [048/134] (716s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[310.422046] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[311.260875] [049/134] (714s left) kms_frontbuffer_tracking (basic)
[311.369480] Starting subtest: basic
[314.616808] Subtest basic: SUCCESS (3.251s)
[314.736481] [050/134] (711s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[314.838446] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[321.704455] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (6.869s)
[321.864104] [051/134] (704s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[321.966481] Starting subtest: fbc-rgb101010-draw-blt
[326.546091] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.583s)
[327.719194] [052/134] (698s left) kms_lease (lease-unleased-connector)
[327.825562] Starting subtest: lease-unleased-connector
[327.827921] Starting dynamic subtest: pipe-A-eDP-1
[327.833211] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[327.842679] Starting dynamic subtest: pipe-B-eDP-1
[327.844858] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[327.855321] Starting dynamic subtest: pipe-C-eDP-1
[327.857432] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[327.866437] Starting dynamic subtest: pipe-D-eDP-1
[327.868567] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s)
[327.870695] Subtest lease-unleased-connector: SUCCESS (0.039s)
[327.985922] [053/134] (698s left) gem_tiled_partial_pwrite_pread (reads)
[328.040366] Subtest reads: SKIP (0.000s)
[328.105525] [054/134] (698s left) kms_dp_link_training (uhbr-sst)
[328.192791] Starting subtest: uhbr-sst
[328.201297] Subtest uhbr-sst: SKIP (0.000s)
[328.287933] [055/134] (698s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[328.354297] Starting subtest: etime-multi-wait-all-submitted-signaled
[328.458321] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.103s)
[328.555396] [056/134] (697s left) kms_invalid_mode (overflow-vrefresh)
[328.667940] Starting subtest: overflow-vrefresh
[328.670347] Starting dynamic subtest: pipe-A-eDP-1
[328.962117] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s)
[328.971354] Starting dynamic subtest: pipe-B-eDP-1
[328.973564] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[328.982199] Starting dynamic subtest: pipe-C-eDP-1
[328.984463] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[328.992816] Starting dynamic subtest: pipe-D-eDP-1
[328.994721] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[328.996584] Subtest overflow-vrefresh: SUCCESS (0.301s)
[329.799588] [057/134] (696s left) kms_pm_rpm (i2c)
[332.131869] Starting subtest: i2c
[337.439063] Subtest i2c: SUCCESS (5.311s)
[337.542684] [058/134] (688s left) gem_exec_balancer (busy)
[337.606857] Starting subtest: busy
[338.901481] Subtest busy: SUCCESS (1.293s)
[339.237403] [059/134] (687s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[344.182629] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[344.187034] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s)
[345.063600] [060/134] (681s left) gen9_exec_parse (batch-without-end)
[345.132169] Subtest batch-without-end: SKIP (0.000s)
[345.203764] [061/134] (681s left) gem_ctx_shared (exec-shared-gtt)
[345.272526] Starting subtest: exec-shared-gtt
[345.274818] Starting dynamic subtest: rcs0
[345.280970] Dynamic subtest rcs0: SUCCESS (0.008s)
[345.291776] Starting dynamic subtest: bcs0
[345.293647] Dynamic subtest bcs0: SUCCESS (0.006s)
[345.302099] Starting dynamic subtest: vcs0
[345.304230] Dynamic subtest vcs0: SUCCESS (0.007s)
[345.312701] Starting dynamic subtest: vcs1
[345.314737] Dynamic subtest vcs1: SUCCESS (0.007s)
[345.322786] Starting dynamic subtest: vecs0
[345.324632] Dynamic subtest vecs0: SUCCESS (0.005s)
[345.332433] Starting dynamic subtest: ccs0
[345.334259] Dynamic subtest ccs0: SUCCESS (0.006s)
[345.336070] Subtest exec-shared-gtt: SUCCESS (0.043s)
[345.527518] [062/134] (681s left) perf (invalid-oa-metric-set-id)
[345.670273] Starting subtest: invalid-oa-metric-set-id
[345.685946] Subtest invalid-oa-metric-set-id: SUCCESS (0.017s)
[345.738703] [063/134] (680s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[345.796215] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[345.798581] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[345.935244] [064/134] (680s left) gem_tiled_pread_pwrite
[346.067485] [065/134] (680s left) i915_pm_rps (thresholds-park)
[346.125266] Starting subtest: thresholds-park
[346.128909] Subtest thresholds-park: SKIP (0.001s)
[346.264590] [066/134] (680s left) gem_ctx_engines (invalid-engines)
[346.322759] Starting subtest: invalid-engines
[346.330457] Subtest invalid-engines: SUCCESS (0.008s)
[346.602914] [067/134] (680s left) vgem_basic (create)
[346.652427] Starting subtest: create
[346.654449] Subtest create: SUCCESS (0.000s)
[346.733350] [068/134] (680s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[346.830217] Starting subtest: fbc-psr2-sprite-mmap-cpu
[346.832432] Starting dynamic subtest: eDP-1
[346.836442] Dynamic subtest eDP-1: SKIP (0.000s)
[346.840613] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[346.926820] [069/134] (680s left) gem_mmap_gtt (big-copy-odd)
[346.989818] Subtest big-copy-odd: SKIP (0.000s)
[347.058591] [070/134] (679s left) gem_exec_reloc (basic-gtt-cpu-active)
[347.119659] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[347.200636] [071/134] (679s left) prime_busy (before-wait)
[347.258831] Starting subtest: before-wait
[347.264342] Starting dynamic subtest: rcs0
[347.308089] Dynamic subtest rcs0: SUCCESS (0.046s)
[347.319418] Starting dynamic subtest: bcs0
[347.373085] Dynamic subtest bcs0: SUCCESS (0.064s)
[347.381902] Starting dynamic subtest: vcs0
[347.413128] Dynamic subtest vcs0: SUCCESS (0.038s)
[347.422892] Starting dynamic subtest: vcs1
[347.453582] Dynamic subtest vcs1: SUCCESS (0.040s)
[347.462034] Starting dynamic subtest: vecs0
[347.494680] Dynamic subtest vecs0: SUCCESS (0.040s)
[347.503038] Starting dynamic subtest: ccs0
[347.535542] Dynamic subtest ccs0: SUCCESS (0.040s)
[347.644343] Subtest before-wait: SUCCESS (0.384s)
[347.743641] [072/134] (679s left) gem_exec_fence (keep-in-fence)
[347.914339] Starting subtest: keep-in-fence
[347.916640] Starting dynamic subtest: rcs0
[348.005874] Dynamic subtest rcs0: SUCCESS (0.091s)
[348.017432] Starting dynamic subtest: bcs0
[348.059755] Dynamic subtest bcs0: SUCCESS (0.052s)
[348.074743] Starting dynamic subtest: vcs0
[349.911026] Dynamic subtest vcs0: SUCCESS (1.848s)
[349.922297] Starting dynamic subtest: vcs1
[351.894290] Dynamic subtest vcs1: SUCCESS (1.981s)
[351.906293] Starting dynamic subtest: vecs0
[353.941814] Dynamic subtest vecs0: SUCCESS (2.045s)
[353.953837] Starting dynamic subtest: ccs0
[354.180933] Dynamic subtest ccs0: SUCCESS (0.237s)
[354.183911] Subtest keep-in-fence: SUCCESS (6.267s)
[356.048264] [073/134] (671s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[356.152770] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[359.878958] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.729s)
[361.062789] [074/134] (666s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[361.162100] Starting subtest: 4-tiled-8bpp-rotate-270
[361.182833] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.020s)
[361.334407] [075/134] (665s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[366.383516] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[366.385906] Starting dynamic subtest: pipe-A-eDP-1
[367.191170] Dynamic subtest pipe-A-eDP-1: SKIP (0.802s)
[367.200780] Starting dynamic subtest: pipe-B-eDP-1
[368.327680] Dynamic subtest pipe-B-eDP-1: SKIP (1.134s)
[368.332345] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.940s)
[369.536851] [076/134] (657s left) gem_ccs (block-multicopy-inplace)
[369.603539] Starting subtest: block-multicopy-inplace
[369.608034] Subtest block-multicopy-inplace: SKIP (0.000s)
[369.722212] [077/134] (657s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[369.876672] Starting subtest: x-tiled-addfb-size-offset-overflow
[369.879055] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[370.017053] [078/134] (657s left) kms_atomic (crtc-invalid-params)
[370.108873] Starting subtest: crtc-invalid-params
[370.111091] Starting dynamic subtest: pipe-A-eDP-1
[370.467654] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.357s)
[370.469593] Subtest crtc-invalid-params: SUCCESS (0.358s)
[371.371321] [079/134] (655s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[371.465095] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[371.467236] Starting dynamic subtest: pipe-A-eDP-1
[371.486256] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[371.495153] Starting dynamic subtest: pipe-B-eDP-1
[371.514322] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.019s)
[371.523130] Starting dynamic subtest: pipe-C-eDP-1
[371.542171] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.019s)
[371.551015] Starting dynamic subtest: pipe-D-eDP-1
[371.570834] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[371.573099] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.084s)
[373.839561] [080/134] (653s left) gem_lmem_swapping (heavy-verify-multi)
[373.884675] Subtest heavy-verify-multi: SKIP (0.000s)
[373.923634] [081/134] (653s left) kms_chamelium_frames (hdmi-crc-fast)
[374.307091] Subtest hdmi-crc-fast: SKIP (0.000s)
[375.140340] [082/134] (652s left) kms_vblank (query-forked-busy-hang)
[375.232620] Starting subtest: query-forked-busy-hang
[375.235066] Starting dynamic subtest: pipe-A-eDP-1
[401.750698] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.515s)
[401.764414] Starting dynamic subtest: pipe-D-eDP-1
[426.702563] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.949s)
[426.704911] Subtest query-forked-busy-hang: SUCCESS (51.470s)
[427.535382] [083/134] (599s left) kms_big_fb (linear-16bpp-rotate-90)
[427.657748] Starting subtest: linear-16bpp-rotate-90
[427.679698] Subtest linear-16bpp-rotate-90: SKIP (0.021s)
[427.855931] [084/134] (599s left) gem_flink_race (flink_close)
[427.888872] Starting subtest: flink_close
[433.019512] Subtest flink_close: SUCCESS (5.129s)
[433.124691] [085/134] (594s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[433.238637] Starting subtest: fbcpsr-modesetfrombusy
[439.380097] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.145s)
[439.555385] [086/134] (588s left) gem_exec_schedule (thriceslice)
[439.623215] Starting subtest: thriceslice
[439.624889] Starting dynamic subtest: rcs0
[439.644845] Dynamic subtest rcs0: SUCCESS (0.029s)
[439.655994] Starting dynamic subtest: bcs0
[439.673060] Dynamic subtest bcs0: SUCCESS (0.028s)
[439.681973] Starting dynamic subtest: vcs0
[439.702905] Dynamic subtest vcs0: SUCCESS (0.029s)
[439.712083] Starting dynamic subtest: vcs1
[439.752633] Dynamic subtest vcs1: SUCCESS (0.049s)
[439.764200] Starting dynamic subtest: vecs0
[439.782394] Dynamic subtest vecs0: SUCCESS (0.028s)
[439.793223] Starting dynamic subtest: ccs0
[439.811557] Dynamic subtest ccs0: SUCCESS (0.028s)
[439.813521] Subtest thriceslice: SUCCESS (0.197s)
[440.983232] [087/134] (586s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[441.089257] Starting subtest: flip-vs-dpms-off-vs-modeset
[441.091571] Starting dynamic subtest: A-eDP1
[444.672158] Dynamic subtest A-eDP1: SUCCESS (3.584s)
[444.681204] Starting dynamic subtest: B-eDP1
[447.865929] Dynamic subtest B-eDP1: SUCCESS (3.193s)
[447.877562] Starting dynamic subtest: C-eDP1
[450.969041] Dynamic subtest C-eDP1: SUCCESS (3.102s)
[450.979244] Starting dynamic subtest: D-eDP1
[454.060881] Dynamic subtest D-eDP1: SUCCESS (3.090s)
[454.063280] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (12.977s)
[454.883369] [088/134] (572s left) i915_pm_rps (min-max-config-idle)
[454.947785] Starting subtest: min-max-config-idle
[454.952259] Subtest min-max-config-idle: SKIP (0.000s)
[455.087765] [089/134] (572s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[455.188272] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[461.671181] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.484s)
[461.843893] [090/134] (565s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[466.844966] Starting subtest: psr2-overlay-plane-move-continuous-sf
[466.847382] Starting dynamic subtest: pipe-A-eDP-1
[473.559767] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.714s)
[473.570217] Starting dynamic subtest: pipe-B-eDP-1
[480.271566] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.707s)
[480.273751] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.426s)
[481.166940] [091/134] (546s left) kms_concurrent (multi-plane-atomic-lowres)
[481.272279] Starting subtest: multi-plane-atomic-lowres
[481.274147] Starting dynamic subtest: pipe-A-eDP-1
[481.797126] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.522s)
[481.799422] Subtest multi-plane-atomic-lowres: SUCCESS (0.524s)
[482.705479] [092/134] (545s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[482.810430] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[482.814493] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[482.950714] [093/134] (544s left) api_intel_allocator (reopen)
[483.011627] Starting subtest: reopen
[483.016836] Subtest reopen: SUCCESS (0.006s)
[483.178654] [094/134] (544s left) kms_flip (dpms-vs-vblank-race)
[483.281135] Starting subtest: dpms-vs-vblank-race
[483.283395] Starting dynamic subtest: A-eDP1
[488.249312] Dynamic subtest A-eDP1: SUCCESS (4.967s)
[488.259366] Starting dynamic subtest: B-eDP1
[492.879805] Dynamic subtest B-eDP1: SUCCESS (4.627s)
[492.889077] Starting dynamic subtest: C-eDP1
[497.511261] Dynamic subtest C-eDP1: SUCCESS (4.628s)
[497.522509] Starting dynamic subtest: D-eDP1
[502.159400] Dynamic subtest D-eDP1: SUCCESS (4.650s)
[502.161739] Subtest dpms-vs-vblank-race: SUCCESS (18.880s)
[503.056195] [095/134] (524s left) syncobj_timeline (single-wait-all-available-signaled)
[503.113585] Starting subtest: single-wait-all-available-signaled
[503.115547] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[503.248777] [096/134] (524s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[503.334160] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[503.336305] Starting dynamic subtest: pipe-A-eDP-1
[504.698241] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.341s)
[504.957184] Starting dynamic subtest: pipe-B-eDP-1
[505.993060] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.043s)
[506.261609] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.927s)
[507.137257] [097/134] (520s left) gem_exec_params (rs-invalid)
[507.206769] Starting subtest: rs-invalid
[507.212641] Subtest rs-invalid: SUCCESS (0.003s)
[507.365520] [098/134] (520s left) kms_scaling_modes (scaling-mode-full-aspect)
[507.473239] Starting subtest: scaling-mode-full-aspect
[507.475443] Starting dynamic subtest: pipe-A-eDP-1
[507.563670] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.093s)
[507.573823] Starting dynamic subtest: pipe-B-eDP-1
[508.735968] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.171s)
[508.744961] Starting dynamic subtest: pipe-C-eDP-1
[509.844052] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.106s)
[509.857276] Starting dynamic subtest: pipe-D-eDP-1
[510.972492] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s)
[510.974668] Subtest scaling-mode-full-aspect: SUCCESS (3.502s)
[512.170726] [099/134] (516s left) kms_plane (plane-panning-top-left)
[512.265101] Starting subtest: plane-panning-top-left
[512.267306] Starting dynamic subtest: pipe-A
[513.934422] Dynamic subtest pipe-A: SUCCESS (1.669s)
[513.943841] Starting dynamic subtest: pipe-B
[516.308676] Dynamic subtest pipe-B: SUCCESS (2.374s)
[516.311085] Subtest plane-panning-top-left: SUCCESS (4.046s)
[517.212059] [100/134] (511s left) kms_psr (psr2-sprite-mmap-cpu)
[517.315627] Starting subtest: psr2-sprite-mmap-cpu
[517.317968] Starting dynamic subtest: eDP-1
[518.985952] Dynamic subtest eDP-1: SUCCESS (1.671s)
[518.988793] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.672s)
[519.890372] [101/134] (508s left) gem_exec_params (rel-constants-invalid-ring)
[519.958531] Starting subtest: rel-constants-invalid-ring
[519.960717] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[520.098463] [102/134] (508s left) i915_query (query-garbage)
[520.155988] Starting subtest: query-garbage
[520.158312] Subtest query-garbage: SUCCESS (0.000s)
[520.282529] [103/134] (508s left) kms_psr (psr-cursor-mmap-cpu)
[520.373919] Starting subtest: psr-cursor-mmap-cpu
[520.376189] Starting dynamic subtest: eDP-1
[522.066668] Dynamic subtest eDP-1: SUCCESS (1.691s)
[522.069067] Subtest psr-cursor-mmap-cpu: SUCCESS (1.692s)
[522.961622] [104/134] (505s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[523.070752] Starting subtest: y-tiled-16bpp-rotate-90
[523.074931] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[523.187347] [105/134] (505s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[523.282569] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[523.287254] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[524.390620] [106/134] (504s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[524.517351] Starting subtest: flip-vs-cursor-legacy
[531.542222] Subtest flip-vs-cursor-legacy: SUCCESS (7.022s)
[532.416979] [107/134] (496s left) kms_frontbuffer_tracking (fbcpsr-argb161616f-draw-blt)
[532.519634] Starting subtest: fbcpsr-argb161616f-draw-blt
[532.523659] Subtest fbcpsr-argb161616f-draw-blt: SKIP (0.000s)
[532.641615] [108/134] (495s left) kms_flip (flip-vs-fences)
[532.740260] Starting subtest: flip-vs-fences
[532.745222] Subtest flip-vs-fences: SKIP (0.000s)
[532.865781] [109/134] (495s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[532.940610] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[533.022846] [110/134] (495s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[533.111345] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[533.113489] Starting dynamic subtest: pipe-A-eDP-1
[533.934042] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.816s)
[533.943670] Starting dynamic subtest: pipe-B-eDP-1
[535.555443] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.617s)
[535.564959] Starting dynamic subtest: pipe-C-eDP-1
[537.090607] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.535s)
[537.100839] Starting dynamic subtest: pipe-D-eDP-1
[538.622985] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.531s)
[538.625254] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.505s)
[539.831398] [111/134] (488s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[539.931691] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[539.935831] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[540.062159] [112/134] (488s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[540.164284] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[540.166466] Starting dynamic subtest: pipe-A-eDP-1
[540.881703] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.710s)
[540.892688] Starting dynamic subtest: pipe-B-eDP-1
[542.627345] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.743s)
[542.636297] Starting dynamic subtest: pipe-C-eDP-1
[544.377749] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.751s)
[544.386728] Starting dynamic subtest: pipe-D-eDP-1
[546.199654] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.820s)
[546.201893] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.029s)
[547.363300] [113/134] (481s left) i915_drm_fdinfo (memory-info-shared)
[547.405115] Starting subtest: memory-info-shared
[547.407499] Starting dynamic subtest: smem0
[547.472941] Dynamic subtest smem0: SUCCESS (0.069s)
[547.475377] Subtest memory-info-shared: SUCCESS (0.069s)
[547.571356] [114/134] (481s left) gem_exec_flush (basic-wb-set-default)
[547.636635] Starting subtest: basic-wb-set-default
[553.089130] Subtest basic-wb-set-default: SUCCESS (5.453s)
[553.297908] [115/134] (475s left) sysfs_timeslice_duration (timeout)
[553.365860] Starting subtest: timeout
[553.368388] Starting dynamic subtest: vecs0
[562.924959] Dynamic subtest vecs0: SUCCESS (9.555s)
[562.939841] Starting dynamic subtest: ccs0
[564.255877] Dynamic subtest ccs0: SUCCESS (1.331s)
[564.266383] Starting dynamic subtest: vcs0
[573.925934] Dynamic subtest vcs0: SUCCESS (9.664s)
[573.937857] Starting dynamic subtest: bcs0
[574.603908] Dynamic subtest bcs0: SUCCESS (0.677s)
[574.624147] Starting dynamic subtest: rcs0
[575.940939] Dynamic subtest rcs0: SUCCESS (1.336s)
[575.953267] Starting dynamic subtest: vcs1
[585.879452] Dynamic subtest vcs1: SUCCESS (9.933s)
[585.882590] Subtest timeout: SUCCESS (32.510s)
[585.985775] [116/134] (442s left) sriov_basic (enable-vfs-bind-unbind-each)
[586.046720] Starting subtest: enable-vfs-bind-unbind-each
[586.048676] Starting dynamic subtest: numvfs-1
[586.127138] Dynamic subtest numvfs-1: FAIL (0.030s)
[586.138264] Starting dynamic subtest: numvfs-2
[586.210924] Dynamic subtest numvfs-2: FAIL (0.003s)
[586.221591] Starting dynamic subtest: numvfs-3
[586.296290] Dynamic subtest numvfs-3: FAIL (0.003s)
[586.307590] Starting dynamic subtest: numvfs-4
[586.381383] Dynamic subtest numvfs-4: FAIL (0.003s)
[586.392608] Starting dynamic subtest: numvfs-5
[586.465517] Dynamic subtest numvfs-5: FAIL (0.003s)
[586.475559] Starting dynamic subtest: numvfs-6
[586.547992] Dynamic subtest numvfs-6: FAIL (0.003s)
[586.557774] Starting dynamic subtest: numvfs-7
[586.630052] Dynamic subtest numvfs-7: FAIL (0.004s)
[586.639492] Starting dynamic subtest: numvfs-random
[586.708626] Dynamic subtest numvfs-random: FAIL (0.003s)
[586.710749] Subtest enable-vfs-bind-unbind-each: FAIL (0.059s)
[586.748619] [117/134] (442s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[586.845681] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[586.850082] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[587.989632] [118/134] (440s left) kms_getfb (getfb-handle-not-fb)
[588.086380] Starting subtest: getfb-handle-not-fb
[588.088681] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[588.209448] [119/134] (440s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[588.267296] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[588.271787] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[588.477088] [120/134] (440s left) gem_workarounds (reset-context)
[588.542480] Starting subtest: reset-context
[588.703930] Subtest reset-context: SUCCESS (0.160s)
[588.883900] [121/134] (440s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[588.983720] Starting subtest: psr-farfromfence-mmap-gtt
[588.988245] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[589.126116] [122/134] (440s left) gem_wait (write-busy)
[589.200068] Starting subtest: write-busy
[589.202484] Starting dynamic subtest: all-engines
[589.823919] Dynamic subtest all-engines: SUCCESS (0.623s)
[589.841582] Starting dynamic subtest: rcs0
[590.378693] Dynamic subtest rcs0: SUCCESS (0.552s)
[590.394555] Starting dynamic subtest: bcs0
[590.926895] Dynamic subtest bcs0: SUCCESS (0.547s)
[590.942902] Starting dynamic subtest: vcs0
[592.917050] Dynamic subtest vcs0: SUCCESS (1.987s)
[592.933302] Starting dynamic subtest: vcs1
[594.900796] Dynamic subtest vcs1: SUCCESS (1.981s)
[594.916960] Starting dynamic subtest: vecs0
[596.885086] Dynamic subtest vecs0: SUCCESS (1.982s)
[596.900215] Starting dynamic subtest: ccs0
[597.437222] Dynamic subtest ccs0: SUCCESS (0.550s)
[597.439681] Subtest write-busy: SUCCESS (8.237s)
[597.657364] [123/134] (431s left) i915_hangman (detector)
[597.728058] Starting subtest: detector
[597.730332] Starting dynamic subtest: rcs0
[608.884815] Dynamic subtest rcs0: SUCCESS (11.155s)
[608.897210] Starting dynamic subtest: bcs0
[620.852048] Dynamic subtest bcs0: SUCCESS (11.963s)
[620.864641] Starting dynamic subtest: vcs0
[632.819878] Dynamic subtest vcs0: SUCCESS (11.965s)
[632.831754] Starting dynamic subtest: vcs1
[643.828704] Dynamic subtest vcs1: SUCCESS (11.005s)
[643.841683] Starting dynamic subtest: vecs0
[654.835685] Dynamic subtest vecs0: SUCCESS (11.004s)
[654.847154] Starting dynamic subtest: ccs0
[666.868349] Dynamic subtest ccs0: SUCCESS (12.030s)
[666.871143] Subtest detector: SUCCESS (69.139s)
[666.974421] [124/134] (362s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[667.083068] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[667.087271] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[667.218638] [125/134] (362s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[667.345318] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[667.349719] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[667.532502] [126/134] (361s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[667.609789] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[667.672379] [127/134] (361s left) gem_exec_schedule (noreorder-corked)
[667.854055] Starting subtest: noreorder-corked
[667.856551] Starting dynamic subtest: rcs0
[669.002957] Dynamic subtest rcs0: SUCCESS (1.149s)
[669.013776] Starting dynamic subtest: vcs0
[670.892182] Dynamic subtest vcs0: SUCCESS (1.885s)
[670.902439] Starting dynamic subtest: vcs1
[672.900064] Dynamic subtest vcs1: SUCCESS (2.005s)
[672.914563] Starting dynamic subtest: vecs0
[674.876266] Dynamic subtest vecs0: SUCCESS (1.973s)
[674.892349] Starting dynamic subtest: ccs0
[676.057466] Dynamic subtest ccs0: SUCCESS (1.180s)
[676.060151] Subtest noreorder-corked: SUCCESS (8.205s)
[676.266534] [128/134] (353s left) kms_psr (pr-cursor-mmap-cpu)
[676.364095] Starting subtest: pr-cursor-mmap-cpu
[676.368268] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[676.462551] [129/134] (352s left) perf (invalid-oa-format-id)
[676.571806] Starting subtest: invalid-oa-format-id
[676.581974] Subtest invalid-oa-format-id: SUCCESS (0.008s)
[676.630451] [130/134] (352s left) gem_eio (in-flight-internal-immediate)
[676.818697] Starting subtest: in-flight-internal-immediate
[677.967037] Subtest in-flight-internal-immediate: SUCCESS (1.148s)
[678.158984] [131/134] (351s left) kms_cursor_edge_walk (256x256-top-edge)
[678.254960] Starting subtest: 256x256-top-edge
[678.257211] Starting dynamic subtest: pipe-A-eDP-1
[681.716588] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.460s)
[681.726498] Starting dynamic subtest: pipe-D-eDP-1
[684.819253] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.103s)
[684.821528] Subtest 256x256-top-edge: SUCCESS (6.565s)
[685.652051] [132/134] (343s left) gem_ctx_persistence (engines-persistence)
[685.711067] Starting subtest: engines-persistence
[685.713380] Starting dynamic subtest: rcs0
[686.493972] Dynamic subtest rcs0: SUCCESS (0.782s)
[686.509829] Starting dynamic subtest: bcs0
[687.258837] Dynamic subtest bcs0: SUCCESS (0.762s)
[687.271104] Starting dynamic subtest: vcs0
[688.033363] Dynamic subtest vcs0: SUCCESS (0.772s)
[688.046085] Starting dynamic subtest: vcs1
[688.799332] Dynamic subtest vcs1: SUCCESS (0.764s)
[688.811894] Starting dynamic subtest: vecs0
[689.573959] Dynamic subtest vecs0: SUCCESS (0.773s)
[689.586752] Starting dynamic subtest: ccs0
[690.310754] Dynamic subtest ccs0: SUCCESS (0.735s)
[690.313321] Subtest engines-persistence: SUCCESS (4.601s)
[690.478346] [133/134] (339s left) api_intel_bb (render-ccs)
[690.530782] Starting subtest: render-ccs
[690.878097] Subtest render-ccs: SUCCESS (0.349s)
[691.043434] [134/134] (338s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[691.158328] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[691.162366] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[691.270976] 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.