[58.622242] Initializing watchdogs
[58.622288]   /dev/watchdog0
[58.636199] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.640467] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.642789] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.646122] [001/134] (960s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[58.769327] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[58.771638] Starting dynamic subtest: pipe-A
[58.857694] Dynamic subtest pipe-A: SUCCESS (0.088s)
[58.867467] Starting dynamic subtest: pipe-B
[59.997525] Dynamic subtest pipe-B: SUCCESS (1.139s)
[60.009631] Starting dynamic subtest: pipe-C
[61.098761] Dynamic subtest pipe-C: SUCCESS (1.100s)
[61.108079] Starting dynamic subtest: pipe-D
[62.242046] Dynamic subtest pipe-D: SUCCESS (1.143s)
[62.244533] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.473s)
[63.427333] [002/134] (955s left) gem_userptr_blits (forbidden-operations)
[63.492359] Starting subtest: forbidden-operations
[63.496702] Subtest forbidden-operations: SKIP (0.000s)
[63.661963] [003/134] (955s left) gem_mmap_gtt (big-bo)
[63.724340] Subtest big-bo: SKIP (0.000s)
[63.782663] [004/134] (955s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[63.886317] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[71.379755] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.498s)
[71.570198] [005/134] (947s left) kms_fence_pin_leak
[71.744849] [006/134] (947s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[71.851000] Starting subtest: x-tiled-16bpp-rotate-180
[73.073082] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.223s)
[73.229323] [007/134] (946s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[73.299231] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[73.363746] [008/134] (946s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[73.463448] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[73.475135] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.010s)
[73.606349] [009/134] (945s left) perf_pmu (busy-check-all)
[73.650059] Starting subtest: busy-check-all
[73.652054] Starting dynamic subtest: rcs0
[74.210690] Dynamic subtest rcs0: SUCCESS (0.560s)
[74.220890] Starting dynamic subtest: bcs0
[74.758465] Dynamic subtest bcs0: SUCCESS (0.547s)
[74.768760] Starting dynamic subtest: vcs0
[75.926294] Dynamic subtest vcs0: SUCCESS (1.165s)
[75.936605] Starting dynamic subtest: vcs1
[77.910790] Dynamic subtest vcs1: SUCCESS (1.983s)
[77.921517] Starting dynamic subtest: vecs0
[79.898979] Dynamic subtest vecs0: SUCCESS (1.987s)
[79.909077] Starting dynamic subtest: ccs0
[80.454094] Dynamic subtest ccs0: SUCCESS (0.556s)
[80.456622] Subtest busy-check-all: SUCCESS (6.804s)
[80.620857] [010/134] (938s left) gem_mmap_wc (coherency)
[80.678337] Subtest coherency: SKIP (0.000s)
[80.743723] [011/134] (938s left) kms_big_fb (yf-tiled-addfb)
[80.859069] Starting subtest: yf-tiled-addfb
[80.863138] Subtest yf-tiled-addfb: SKIP (0.000s)
[80.987812] [012/134] (938s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[81.098169] Starting subtest: extended-modeset-hang-oldfb-with-reset
[81.100340] Starting dynamic subtest: pipe-A
[92.599707] Dynamic subtest pipe-A: SUCCESS (11.498s)
[92.613952] Starting dynamic subtest: pipe-D
[104.876532] Dynamic subtest pipe-D: SUCCESS (12.276s)
[104.878915] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.778s)
[105.681658] [013/134] (913s left) kms_plane_alpha_blend (constant-alpha-min)
[105.789762] Starting subtest: constant-alpha-min
[106.064557] Starting dynamic subtest: pipe-A-eDP-1
[106.766574] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.699s)
[106.776103] Starting dynamic subtest: pipe-D-eDP-1
[108.254777] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.488s)
[108.257310] Subtest constant-alpha-min: SUCCESS (2.465s)
[109.137560] [014/134] (910s left) sysfs_timeslice_duration (duration)
[109.195014] Starting subtest: duration
[109.197396] Starting dynamic subtest: vecs0
[122.805634] Dynamic subtest vecs0: SUCCESS (13.608s)
[122.816846] Starting dynamic subtest: ccs0
[135.970114] Dynamic subtest ccs0: SUCCESS (13.164s)
[135.981105] Starting dynamic subtest: vcs0
[149.812101] Dynamic subtest vcs0: SUCCESS (13.838s)
[149.823769] Starting dynamic subtest: bcs0
[162.958240] Dynamic subtest bcs0: SUCCESS (13.145s)
[162.968146] Starting dynamic subtest: rcs0
[176.127390] Dynamic subtest rcs0: SUCCESS (13.167s)
[176.139046] Starting dynamic subtest: vcs1
[189.812392] Dynamic subtest vcs1: SUCCESS (13.682s)
[189.814927] Subtest duration: SUCCESS (80.613s)
[189.908704] [015/134] (829s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[190.021590] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[193.610947] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.592s)
[194.841132] [016/134] (824s left) kms_cursor_crc (cursor-onscreen-64x64)
[195.015318] Starting subtest: cursor-onscreen-64x64
[195.020246] Starting dynamic subtest: pipe-A-eDP-1
[197.140183] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.120s)
[197.169191] Starting dynamic subtest: pipe-D-eDP-1
[199.864852] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.705s)
[199.867188] Subtest cursor-onscreen-64x64: SUCCESS (4.850s)
[200.696298] [017/134] (819s left) kms_color (ctm-red-to-blue)
[200.800498] Starting subtest: ctm-red-to-blue
[200.802572] Starting dynamic subtest: pipe-A-eDP-1
[201.533253] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.731s)
[201.546031] Starting dynamic subtest: pipe-B-eDP-1
[202.983134] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.451s)
[202.992604] Starting dynamic subtest: pipe-C-eDP-1
[204.354855] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.371s)
[204.364377] Starting dynamic subtest: pipe-D-eDP-1
[205.674941] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.321s)
[205.677310] Subtest ctm-red-to-blue: SUCCESS (4.876s)
[206.510323] [018/134] (813s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[206.574600] Subtest writes-after-reads-uncached: SKIP (0.000s)
[206.664127] [019/134] (813s left) dumb_buffer (invalid-bpp)
[206.717069] Starting subtest: invalid-bpp
[206.719310] Subtest invalid-bpp: SUCCESS (0.000s)
[206.840540] [020/134] (813s left) gem_mmap_gtt (ptrace)
[206.904248] Subtest ptrace: SKIP (0.000s)
[206.971753] [021/134] (812s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[207.095996] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[207.100490] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[207.264325] [022/134] (812s left) gem_lmem_swapping (verify)
[207.312691] Subtest verify: SKIP (0.000s)
[207.357506] [023/134] (812s left) gem_spin_batch (resubmit-new)
[207.416668] Starting subtest: resubmit-new
[207.419048] Starting dynamic subtest: rcs0
[207.423827] Dynamic subtest rcs0: SUCCESS (0.007s)
[207.433796] Starting dynamic subtest: bcs0
[207.435462] Dynamic subtest bcs0: SUCCESS (0.007s)
[207.443043] Starting dynamic subtest: vcs0
[207.444858] Dynamic subtest vcs0: SUCCESS (0.004s)
[207.452847] Starting dynamic subtest: vcs1
[207.454646] Dynamic subtest vcs1: SUCCESS (0.005s)
[207.461917] Starting dynamic subtest: vecs0
[207.463730] Dynamic subtest vecs0: SUCCESS (0.005s)
[207.470917] Starting dynamic subtest: ccs0
[207.472749] Dynamic subtest ccs0: SUCCESS (0.003s)
[207.474553] Subtest resubmit-new: SUCCESS (0.035s)
[208.977538] [024/134] (811s left) kms_cursor_crc (cursor-random-512x512)
[209.250970] Starting subtest: cursor-random-512x512
[209.255388] Subtest cursor-random-512x512: SKIP (0.001s)
[209.462175] [025/134] (810s left) kms_properties (plane-properties-legacy)
[209.569072] Starting subtest: plane-properties-legacy
[209.571319] Starting dynamic subtest: pipe-A-eDP-1
[210.116038] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.545s)
[210.125830] Starting dynamic subtest: pipe-B-eDP-1
[211.354080] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.238s)
[211.363173] Starting dynamic subtest: pipe-C-eDP-1
[212.587546] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.232s)
[212.598598] Starting dynamic subtest: pipe-D-eDP-1
[213.827834] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.240s)
[213.830080] Subtest plane-properties-legacy: SUCCESS (4.261s)
[214.659780] [026/134] (805s left) kms_vrr (flipline)
[214.758083] Starting subtest: flipline
[214.764235] Subtest flipline: SKIP (0.000s)
[214.856575] [027/134] (805s left) gem_exec_params (secure-non-master)
[214.917827] Starting subtest: secure-non-master
[214.922356] Subtest secure-non-master: SKIP (0.000s)
[215.053826] [028/134] (805s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[215.296292] Starting subtest: parallel-dmabuf-import-out-fence
[216.364730] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.068s)
[216.503013] [029/134] (803s left) kms_pm_dc (dc5-dpms-negative)
[217.611371] Starting subtest: dc5-dpms-negative
[217.615660] Subtest dc5-dpms-negative: SKIP (0.000s)
[217.724546] [030/134] (802s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[217.828433] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[217.832276] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[217.956776] [031/134] (802s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[218.060083] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[224.878858] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.821s)
[225.026588] [032/134] (795s left) kms_frontbuffer_tracking (psr-argb161616f-draw-mmap-cpu)
[225.134144] Starting subtest: psr-argb161616f-draw-mmap-cpu
[225.138127] Subtest psr-argb161616f-draw-mmap-cpu: SKIP (0.000s)
[225.266480] [033/134] (795s left) gem_exec_whisper (basic-fds-all)
[225.338205] Starting subtest: basic-fds-all
[236.688378] Subtest basic-fds-all: SUCCESS (11.347s)
[236.897898] [034/134] (783s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[237.009219] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[237.013157] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[237.150152] [035/134] (783s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[237.244070] Starting subtest: psr-rgb565-draw-render
[244.295086] Subtest psr-rgb565-draw-render: SUCCESS (7.052s)
[244.465328] [036/134] (776s left) gem_render_copy_redux (flink)
[244.521893] Starting subtest: flink
[245.298232] Subtest flink: SUCCESS (0.778s)
[245.460479] [037/134] (775s left) gem_mmap_wc (bad-offset)
[245.519999] Subtest bad-offset: SKIP (0.000s)
[245.582383] [038/134] (775s left) gem_pxp (reject-modify-context-protection-off-2)
[245.699450] Starting subtest: reject-modify-context-protection-off-2
[245.701473] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[245.834545] [039/134] (774s left) kms_3d (basic)
[245.900031] Starting subtest: basic
[247.851133] Subtest basic: SUCCESS (1.956s)
[248.374474] [040/134] (772s left) gem_ctx_persistence (smoketest)
[248.443683] Starting subtest: smoketest
[288.820708] Subtest smoketest: SUCCESS (40.373s)
[288.920351] [041/134] (731s left) kms_psr (fbc-pr-suspend)
[289.031080] Starting subtest: fbc-pr-suspend
[289.035298] Subtest fbc-pr-suspend: SKIP (0.000s)
[289.121371] [042/134] (731s left) syncobj_timeline (multi-wait-for-submit-signaled)
[289.180215] Starting subtest: multi-wait-for-submit-signaled
[289.182582] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[289.308484] [043/134] (731s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[289.392963] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[289.395208] Starting dynamic subtest: pipe-A-default-mode
[292.061195] Dynamic subtest pipe-A-default-mode: SUCCESS (2.666s)
[292.063403] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.667s)
[292.902814] [044/134] (727s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[292.996056] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[292.998319] Starting dynamic subtest: pipe-A-default-mode
[295.684424] Dynamic subtest pipe-A-default-mode: SUCCESS (2.686s)
[295.686456] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.688s)
[296.509564] [045/134] (724s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[296.609658] Starting subtest: psr-rgb565-draw-mmap-cpu
[303.209396] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.602s)
[303.345441] [046/134] (717s left) vgem_basic (mmap)
[303.463819] Starting subtest: mmap
[303.471159] Subtest mmap: SUCCESS (0.008s)
[303.573899] [FACT vgem_basic (mmap)] new: kernel.kmod_is_loaded.vgem: true
[303.577437] [047/134] (717s left) gem_userptr_blits (sync-unmap-after-close)
[303.653191] Starting subtest: sync-unmap-after-close
[303.662823] Subtest sync-unmap-after-close: SUCCESS (0.010s)
[303.830436] [048/134] (717s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[304.214768] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[305.069809] [049/134] (716s left) kms_frontbuffer_tracking (basic)
[305.180907] Starting subtest: basic
[308.328887] Subtest basic: SUCCESS (3.154s)
[308.480425] [050/134] (712s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[308.590715] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[315.516142] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (6.928s)
[315.654754] [051/134] (705s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[315.763143] Starting subtest: fbc-rgb101010-draw-blt
[320.340588] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.580s)
[321.518344] [052/134] (699s left) kms_lease (lease-unleased-connector)
[321.617406] Starting subtest: lease-unleased-connector
[321.619450] Starting dynamic subtest: pipe-A-eDP-1
[321.624551] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[321.636546] Starting dynamic subtest: pipe-B-eDP-1
[321.638671] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s)
[321.648346] Starting dynamic subtest: pipe-C-eDP-1
[321.650518] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[321.658734] Starting dynamic subtest: pipe-D-eDP-1
[321.660606] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[321.662489] Subtest lease-unleased-connector: SUCCESS (0.032s)
[321.787198] [053/134] (699s left) gem_tiled_partial_pwrite_pread (reads)
[321.852687] Subtest reads: SKIP (0.000s)
[321.931852] [054/134] (699s left) kms_dp_link_training (uhbr-sst)
[322.022958] Starting subtest: uhbr-sst
[322.031948] Subtest uhbr-sst: SKIP (0.000s)
[322.119210] [055/134] (699s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[322.176627] Starting subtest: etime-multi-wait-all-submitted-signaled
[322.281576] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.103s)
[322.382923] [056/134] (698s left) kms_invalid_mode (overflow-vrefresh)
[322.473329] Starting subtest: overflow-vrefresh
[322.475435] Starting dynamic subtest: pipe-A-eDP-1
[322.759407] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[322.769228] Starting dynamic subtest: pipe-B-eDP-1
[322.771666] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[322.782113] Starting dynamic subtest: pipe-C-eDP-1
[322.783925] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[322.791913] Starting dynamic subtest: pipe-D-eDP-1
[322.793742] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[322.795660] Subtest overflow-vrefresh: SUCCESS (0.290s)
[323.615992] [057/134] (697s left) kms_pm_rpm (i2c)
[325.134634] Starting subtest: i2c
[330.846533] Subtest i2c: SUCCESS (5.714s)
[330.976543] [058/134] (690s left) gem_exec_balancer (busy)
[331.031178] Starting subtest: busy
[332.920697] Subtest busy: SUCCESS (1.888s)
[333.261688] [059/134] (688s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[338.321698] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[338.326271] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s)
[339.200454] [060/134] (682s left) gen9_exec_parse (batch-without-end)
[339.258809] Subtest batch-without-end: SKIP (0.000s)
[339.325827] [061/134] (682s left) gem_ctx_shared (exec-shared-gtt)
[339.387732] Starting subtest: exec-shared-gtt
[339.390070] Starting dynamic subtest: rcs0
[339.396665] Dynamic subtest rcs0: SUCCESS (0.008s)
[339.406166] Starting dynamic subtest: bcs0
[339.408022] Dynamic subtest bcs0: SUCCESS (0.005s)
[339.416847] Starting dynamic subtest: vcs0
[339.419330] Dynamic subtest vcs0: SUCCESS (0.009s)
[339.427758] Starting dynamic subtest: vcs1
[339.429651] Dynamic subtest vcs1: SUCCESS (0.008s)
[339.438141] Starting dynamic subtest: vecs0
[339.440301] Dynamic subtest vecs0: SUCCESS (0.007s)
[339.448589] Starting dynamic subtest: ccs0
[339.450795] Dynamic subtest ccs0: SUCCESS (0.005s)
[339.453047] Subtest exec-shared-gtt: SUCCESS (0.047s)
[339.650380] [062/134] (681s left) perf (invalid-oa-metric-set-id)
[339.788992] Starting subtest: invalid-oa-metric-set-id
[339.801078] Subtest invalid-oa-metric-set-id: SUCCESS (0.012s)
[339.840977] [063/134] (681s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[339.894418] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[339.896494] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[340.011274] [064/134] (681s left) gem_tiled_pread_pwrite
[340.148744] [065/134] (681s left) i915_pm_rps (thresholds-park)
[340.204304] Starting subtest: thresholds-park
[340.208282] Subtest thresholds-park: SKIP (0.001s)
[340.327114] [066/134] (681s left) gem_ctx_engines (invalid-engines)
[340.395276] Starting subtest: invalid-engines
[340.402832] Subtest invalid-engines: SUCCESS (0.008s)
[340.670759] [067/134] (681s left) vgem_basic (create)
[340.711182] Starting subtest: create
[340.713290] Subtest create: SUCCESS (0.000s)
[340.788140] [068/134] (681s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[340.870119] Starting subtest: fbc-psr2-sprite-mmap-cpu
[340.872233] Starting dynamic subtest: eDP-1
[340.876196] Dynamic subtest eDP-1: SKIP (0.000s)
[340.880169] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[340.969863] [069/134] (680s left) gem_mmap_gtt (big-copy-odd)
[341.026948] Subtest big-copy-odd: SKIP (0.000s)
[341.082487] [070/134] (680s left) gem_exec_reloc (basic-gtt-cpu-active)
[341.145619] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[341.215078] [071/134] (680s left) prime_busy (before-wait)
[341.265124] Starting subtest: before-wait
[341.269985] Starting dynamic subtest: rcs0
[341.298250] Dynamic subtest rcs0: SUCCESS (0.029s)
[341.308585] Starting dynamic subtest: bcs0
[341.355828] Dynamic subtest bcs0: SUCCESS (0.057s)
[341.365606] Starting dynamic subtest: vcs0
[341.396341] Dynamic subtest vcs0: SUCCESS (0.040s)
[341.405249] Starting dynamic subtest: vcs1
[341.438241] Dynamic subtest vcs1: SUCCESS (0.041s)
[341.447135] Starting dynamic subtest: vecs0
[341.479971] Dynamic subtest vecs0: SUCCESS (0.041s)
[341.489133] Starting dynamic subtest: ccs0
[341.520586] Dynamic subtest ccs0: SUCCESS (0.040s)
[341.629654] Subtest before-wait: SUCCESS (0.362s)
[341.728713] [072/134] (680s left) gem_exec_fence (keep-in-fence)
[341.903704] Starting subtest: keep-in-fence
[341.906097] Starting dynamic subtest: rcs0
[341.990909] Dynamic subtest rcs0: SUCCESS (0.086s)
[342.002705] Starting dynamic subtest: bcs0
[342.046350] Dynamic subtest bcs0: SUCCESS (0.053s)
[342.057264] Starting dynamic subtest: vcs0
[343.893637] Dynamic subtest vcs0: SUCCESS (1.844s)
[343.905748] Starting dynamic subtest: vcs1
[345.879022] Dynamic subtest vcs1: SUCCESS (1.983s)
[345.891080] Starting dynamic subtest: vecs0
[347.926086] Dynamic subtest vecs0: SUCCESS (2.044s)
[347.937791] Starting dynamic subtest: ccs0
[348.179844] Dynamic subtest ccs0: SUCCESS (0.253s)
[348.182700] Subtest keep-in-fence: SUCCESS (6.276s)
[350.032429] [073/134] (672s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[350.150803] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[353.911789] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.765s)
[355.124654] [074/134] (667s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[355.228685] Starting subtest: 4-tiled-8bpp-rotate-270
[355.252809] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.024s)
[355.434948] [075/134] (666s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[360.439465] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[360.441859] Starting dynamic subtest: pipe-A-eDP-1
[361.264527] Dynamic subtest pipe-A-eDP-1: SKIP (0.810s)
[361.275033] Starting dynamic subtest: pipe-B-eDP-1
[362.391455] Dynamic subtest pipe-B-eDP-1: SKIP (1.134s)
[362.395898] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.949s)
[363.598385] [076/134] (658s left) gem_ccs (block-multicopy-inplace)
[363.668500] Starting subtest: block-multicopy-inplace
[363.672647] Subtest block-multicopy-inplace: SKIP (0.000s)
[363.797057] [077/134] (658s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[363.906674] Starting subtest: x-tiled-addfb-size-offset-overflow
[363.908777] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[364.038850] [078/134] (658s left) kms_atomic (crtc-invalid-params)
[364.141875] Starting subtest: crtc-invalid-params
[364.144082] Starting dynamic subtest: pipe-A-eDP-1
[364.526690] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.385s)
[364.528862] Subtest crtc-invalid-params: SUCCESS (0.386s)
[365.424235] [079/134] (656s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[365.525709] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[365.527981] Starting dynamic subtest: pipe-A-eDP-1
[365.547395] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s)
[365.557574] Starting dynamic subtest: pipe-B-eDP-1
[365.576754] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.019s)
[365.585887] Starting dynamic subtest: pipe-C-eDP-1
[365.604754] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.019s)
[365.615043] Starting dynamic subtest: pipe-D-eDP-1
[365.634778] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[365.637052] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.084s)
[367.809441] [080/134] (654s left) gem_lmem_swapping (heavy-verify-multi)
[367.854950] Subtest heavy-verify-multi: SKIP (0.000s)
[367.899839] [081/134] (654s left) kms_chamelium_frames (hdmi-crc-fast)
[368.276621] Subtest hdmi-crc-fast: SKIP (0.000s)
[369.090954] [082/134] (653s left) kms_vblank (query-forked-busy-hang)
[369.200252] Starting subtest: query-forked-busy-hang
[369.202173] Starting dynamic subtest: pipe-A-eDP-1
[395.678944] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.477s)
[395.693314] Starting dynamic subtest: pipe-D-eDP-1
[420.694388] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.015s)
[420.696674] Subtest query-forked-busy-hang: SUCCESS (51.496s)
[421.598406] [083/134] (600s left) kms_big_fb (linear-16bpp-rotate-90)
[421.699404] Starting subtest: linear-16bpp-rotate-90
[421.720322] Subtest linear-16bpp-rotate-90: SKIP (0.020s)
[421.876570] [084/134] (600s left) gem_flink_race (flink_close)
[421.915198] Starting subtest: flink_close
[427.024394] Subtest flink_close: SUCCESS (5.109s)
[427.127053] [085/134] (595s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[427.237421] Starting subtest: fbcpsr-modesetfrombusy
[433.542616] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.309s)
[433.704615] [086/134] (588s left) gem_exec_schedule (thriceslice)
[433.772547] Starting subtest: thriceslice
[433.774122] Starting dynamic subtest: rcs0
[433.799681] Dynamic subtest rcs0: SUCCESS (0.030s)
[433.810742] Starting dynamic subtest: bcs0
[433.830866] Dynamic subtest bcs0: SUCCESS (0.031s)
[433.839497] Starting dynamic subtest: vcs0
[433.882388] Dynamic subtest vcs0: SUCCESS (0.050s)
[433.893368] Starting dynamic subtest: vcs1
[433.912190] Dynamic subtest vcs1: SUCCESS (0.028s)
[433.920385] Starting dynamic subtest: vecs0
[433.940978] Dynamic subtest vecs0: SUCCESS (0.028s)
[433.949554] Starting dynamic subtest: ccs0
[433.969583] Dynamic subtest ccs0: SUCCESS (0.028s)
[433.971550] Subtest thriceslice: SUCCESS (0.201s)
[434.289863] [087/134] (588s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[434.384992] Starting subtest: flip-vs-dpms-off-vs-modeset
[434.387327] Starting dynamic subtest: A-eDP1
[437.947816] Dynamic subtest A-eDP1: SUCCESS (3.559s)
[437.957165] Starting dynamic subtest: B-eDP1
[441.151695] Dynamic subtest B-eDP1: SUCCESS (3.204s)
[441.161142] Starting dynamic subtest: C-eDP1
[444.277476] Dynamic subtest C-eDP1: SUCCESS (3.123s)
[444.287085] Starting dynamic subtest: D-eDP1
[447.395569] Dynamic subtest D-eDP1: SUCCESS (3.118s)
[447.397984] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.012s)
[448.216863] [088/134] (574s left) i915_pm_rps (min-max-config-idle)
[448.279253] Starting subtest: min-max-config-idle
[448.283714] Subtest min-max-config-idle: SKIP (0.000s)
[448.412684] [089/134] (574s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[448.519667] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[454.995087] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.487s)
[455.171460] [090/134] (567s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[460.180535] Starting subtest: psr2-overlay-plane-move-continuous-sf
[460.182956] Starting dynamic subtest: pipe-A-eDP-1
[466.874795] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.695s)
[466.886702] Starting dynamic subtest: pipe-B-eDP-1
[473.616469] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.736s)
[473.618778] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.436s)
[474.523457] [091/134] (548s left) kms_concurrent (multi-plane-atomic-lowres)
[474.624016] Starting subtest: multi-plane-atomic-lowres
[474.626301] Starting dynamic subtest: pipe-A-eDP-1
[475.137238] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.511s)
[475.139527] Subtest multi-plane-atomic-lowres: SUCCESS (0.513s)
[475.961635] [092/134] (546s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[476.057167] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[476.061522] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[476.179238] [093/134] (546s left) api_intel_allocator (reopen)
[476.239522] Starting subtest: reopen
[476.244604] Subtest reopen: SUCCESS (0.004s)
[476.393299] [094/134] (546s left) kms_flip (dpms-vs-vblank-race)
[476.486284] Starting subtest: dpms-vs-vblank-race
[476.488595] Starting dynamic subtest: A-eDP1
[481.413069] Dynamic subtest A-eDP1: SUCCESS (4.926s)
[481.422683] Starting dynamic subtest: B-eDP1
[486.030542] Dynamic subtest B-eDP1: SUCCESS (4.615s)
[486.039395] Starting dynamic subtest: C-eDP1
[490.659274] Dynamic subtest C-eDP1: SUCCESS (4.626s)
[490.668556] Starting dynamic subtest: D-eDP1
[494.173726] Dynamic subtest D-eDP1: SUCCESS (3.514s)
[494.176027] Subtest dpms-vs-vblank-race: SUCCESS (17.689s)
[495.064399] [095/134] (527s left) syncobj_timeline (single-wait-all-available-signaled)
[495.124148] Starting subtest: single-wait-all-available-signaled
[495.126450] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[495.276063] [096/134] (527s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[495.378834] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[495.381048] Starting dynamic subtest: pipe-A-eDP-1
[496.689060] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.309s)
[496.964073] Starting dynamic subtest: pipe-B-eDP-1
[498.009247] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.053s)
[498.277460] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.899s)
[499.137863] [097/134] (523s left) gem_exec_params (rs-invalid)
[499.198713] Starting subtest: rs-invalid
[499.201163] Subtest rs-invalid: SUCCESS (0.003s)
[499.344563] [098/134] (523s left) kms_scaling_modes (scaling-mode-full-aspect)
[499.437663] Starting subtest: scaling-mode-full-aspect
[499.440123] Starting dynamic subtest: pipe-A-eDP-1
[499.535927] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.097s)
[499.545220] Starting dynamic subtest: pipe-B-eDP-1
[500.751958] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.214s)
[500.764284] Starting dynamic subtest: pipe-C-eDP-1
[501.868701] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.113s)
[501.886771] Starting dynamic subtest: pipe-D-eDP-1
[502.992506] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s)
[502.994840] Subtest scaling-mode-full-aspect: SUCCESS (3.556s)
[504.185103] [099/134] (518s left) kms_plane (plane-panning-top-left)
[504.270970] Starting subtest: plane-panning-top-left
[504.273347] Starting dynamic subtest: pipe-A
[505.916411] Dynamic subtest pipe-A: SUCCESS (1.647s)
[505.925823] Starting dynamic subtest: pipe-B
[508.297062] Dynamic subtest pipe-B: SUCCESS (2.378s)
[508.299400] Subtest plane-panning-top-left: SUCCESS (4.029s)
[509.198180] [100/134] (514s left) kms_psr (psr2-sprite-mmap-cpu)
[509.303279] Starting subtest: psr2-sprite-mmap-cpu
[509.305626] Starting dynamic subtest: eDP-1
[510.981360] Dynamic subtest eDP-1: SUCCESS (1.678s)
[510.983601] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.680s)
[511.860435] [101/134] (511s left) gem_exec_params (rel-constants-invalid-ring)
[511.932603] Starting subtest: rel-constants-invalid-ring
[511.935055] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[512.079147] [102/134] (511s left) i915_query (query-garbage)
[512.139228] Starting subtest: query-garbage
[512.141421] Subtest query-garbage: SUCCESS (0.000s)
[512.275664] [103/134] (511s left) kms_psr (psr-cursor-mmap-cpu)
[512.378152] Starting subtest: psr-cursor-mmap-cpu
[512.380492] Starting dynamic subtest: eDP-1
[514.123522] Dynamic subtest eDP-1: SUCCESS (1.745s)
[514.125881] Subtest psr-cursor-mmap-cpu: SUCCESS (1.747s)
[515.009764] [104/134] (508s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[515.112106] Starting subtest: y-tiled-16bpp-rotate-90
[515.116090] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[515.242234] [105/134] (508s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[515.340992] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[515.345524] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[516.437740] [106/134] (507s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[516.558316] Starting subtest: flip-vs-cursor-legacy
[523.577352] Subtest flip-vs-cursor-legacy: SUCCESS (7.018s)
[524.474222] [107/134] (499s left) kms_frontbuffer_tracking (fbcpsr-argb161616f-draw-blt)
[524.584028] Starting subtest: fbcpsr-argb161616f-draw-blt
[524.588684] Subtest fbcpsr-argb161616f-draw-blt: SKIP (0.000s)
[524.702359] [108/134] (498s left) kms_flip (flip-vs-fences)
[524.800593] Starting subtest: flip-vs-fences
[524.804735] Subtest flip-vs-fences: SKIP (0.000s)
[524.944724] [109/134] (498s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[525.015709] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[525.103944] [110/134] (498s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[525.214356] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[525.216217] Starting dynamic subtest: pipe-A-eDP-1
[526.061569] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.841s)
[526.071564] Starting dynamic subtest: pipe-B-eDP-1
[527.682312] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.617s)
[527.692149] Starting dynamic subtest: pipe-C-eDP-1
[529.180761] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.498s)
[529.191053] Starting dynamic subtest: pipe-D-eDP-1
[530.716040] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.533s)
[530.718322] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.494s)
[531.934209] [111/134] (491s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[532.039900] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[532.044335] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[532.171548] [112/134] (491s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[532.274137] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[532.275991] Starting dynamic subtest: pipe-A-eDP-1
[532.986729] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.706s)
[532.997128] Starting dynamic subtest: pipe-B-eDP-1
[534.733307] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.745s)
[534.742169] Starting dynamic subtest: pipe-C-eDP-1
[536.543993] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.810s)
[536.554751] Starting dynamic subtest: pipe-D-eDP-1
[538.283789] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.738s)
[538.286091] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.003s)
[539.456868] [113/134] (484s left) i915_drm_fdinfo (memory-info-shared)
[539.499993] Starting subtest: memory-info-shared
[539.502373] Starting dynamic subtest: smem0
[539.571938] Dynamic subtest smem0: SUCCESS (0.072s)
[539.574568] Subtest memory-info-shared: SUCCESS (0.073s)
[539.670139] [114/134] (484s left) gem_exec_flush (basic-wb-set-default)
[539.734797] Starting subtest: basic-wb-set-default
[545.189423] Subtest basic-wb-set-default: SUCCESS (5.455s)
[545.402893] [115/134] (478s left) sysfs_timeslice_duration (timeout)
[545.469121] Starting subtest: timeout
[545.471557] Starting dynamic subtest: vecs0
[554.923074] Dynamic subtest vecs0: SUCCESS (9.450s)
[554.938916] Starting dynamic subtest: ccs0
[556.257625] Dynamic subtest ccs0: SUCCESS (1.333s)
[556.270540] Starting dynamic subtest: vcs0
[565.933520] Dynamic subtest vcs0: SUCCESS (9.672s)
[565.944860] Starting dynamic subtest: bcs0
[566.665673] Dynamic subtest bcs0: SUCCESS (0.730s)
[566.677343] Starting dynamic subtest: rcs0
[568.021890] Dynamic subtest rcs0: SUCCESS (1.356s)
[568.034192] Starting dynamic subtest: vcs1
[577.934387] Dynamic subtest vcs1: SUCCESS (9.907s)
[577.936900] Subtest timeout: SUCCESS (32.461s)
[578.033656] [116/134] (445s left) sriov_basic (enable-vfs-bind-unbind-each)
[578.088144] Starting subtest: enable-vfs-bind-unbind-each
[578.090729] Starting dynamic subtest: numvfs-1
[578.169401] Dynamic subtest numvfs-1: FAIL (0.031s)
[578.179481] Starting dynamic subtest: numvfs-2
[578.250587] Dynamic subtest numvfs-2: FAIL (0.003s)
[578.261259] Starting dynamic subtest: numvfs-3
[578.332722] Dynamic subtest numvfs-3: FAIL (0.003s)
[578.342477] Starting dynamic subtest: numvfs-4
[578.410793] Dynamic subtest numvfs-4: FAIL (0.003s)
[578.419658] Starting dynamic subtest: numvfs-5
[578.487569] Dynamic subtest numvfs-5: FAIL (0.003s)
[578.496526] Starting dynamic subtest: numvfs-6
[578.564789] Dynamic subtest numvfs-6: FAIL (0.003s)
[578.573974] Starting dynamic subtest: numvfs-7
[578.643810] Dynamic subtest numvfs-7: FAIL (0.003s)
[578.654577] Starting dynamic subtest: numvfs-random
[578.727071] Dynamic subtest numvfs-random: FAIL (0.003s)
[578.729406] Subtest enable-vfs-bind-unbind-each: FAIL (0.060s)
[578.772086] [117/134] (445s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[578.868725] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[578.873032] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[579.982036] [118/134] (443s left) kms_getfb (getfb-handle-not-fb)
[580.070906] Starting subtest: getfb-handle-not-fb
[580.073220] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[580.209030] [119/134] (443s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[580.277486] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[580.281747] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[580.482812] [120/134] (443s left) gem_workarounds (reset-context)
[580.552277] Starting subtest: reset-context
[580.714721] Subtest reset-context: SUCCESS (0.160s)
[580.882503] [121/134] (443s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[580.980334] Starting subtest: psr-farfromfence-mmap-gtt
[580.984746] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[581.120353] [122/134] (442s left) gem_wait (write-busy)
[581.184328] Starting subtest: write-busy
[581.186530] Starting dynamic subtest: all-engines
[581.811321] Dynamic subtest all-engines: SUCCESS (0.629s)
[581.828098] Starting dynamic subtest: rcs0
[582.366486] Dynamic subtest rcs0: SUCCESS (0.554s)
[582.382442] Starting dynamic subtest: bcs0
[582.916604] Dynamic subtest bcs0: SUCCESS (0.549s)
[582.932240] Starting dynamic subtest: vcs0
[584.917363] Dynamic subtest vcs0: SUCCESS (1.998s)
[584.933923] Starting dynamic subtest: vcs1
[586.901182] Dynamic subtest vcs1: SUCCESS (1.981s)
[586.918433] Starting dynamic subtest: vecs0
[588.885104] Dynamic subtest vecs0: SUCCESS (1.981s)
[588.901946] Starting dynamic subtest: ccs0
[589.436195] Dynamic subtest ccs0: SUCCESS (0.550s)
[589.438838] Subtest write-busy: SUCCESS (8.255s)
[589.660500] [123/134] (434s left) i915_hangman (detector)
[589.724610] Starting subtest: detector
[589.726965] Starting dynamic subtest: rcs0
[600.884618] Dynamic subtest rcs0: SUCCESS (11.158s)
[600.896820] Starting dynamic subtest: bcs0
[612.852249] Dynamic subtest bcs0: SUCCESS (11.964s)
[612.864591] Starting dynamic subtest: vcs0
[624.819444] Dynamic subtest vcs0: SUCCESS (11.964s)
[624.830729] Starting dynamic subtest: vcs1
[633.843711] Dynamic subtest vcs1: SUCCESS (9.022s)
[633.858996] Starting dynamic subtest: vecs0
[644.851642] Dynamic subtest vecs0: SUCCESS (11.005s)
[644.863650] Starting dynamic subtest: ccs0
[656.884484] Dynamic subtest ccs0: SUCCESS (12.029s)
[656.887470] Subtest detector: SUCCESS (67.157s)
[657.051926] [124/134] (367s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[657.162071] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[657.166028] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[657.299425] [125/134] (366s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[657.415570] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[657.420140] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[657.585307] [126/134] (366s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[657.644435] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[657.710223] [127/134] (366s left) gem_exec_schedule (noreorder-corked)
[657.890577] Starting subtest: noreorder-corked
[657.892968] Starting dynamic subtest: rcs0
[659.054543] Dynamic subtest rcs0: SUCCESS (1.166s)
[659.066659] Starting dynamic subtest: vcs0
[660.892067] Dynamic subtest vcs0: SUCCESS (1.834s)
[660.903915] Starting dynamic subtest: vcs1
[662.953475] Dynamic subtest vcs1: SUCCESS (2.058s)
[662.969543] Starting dynamic subtest: vecs0
[664.902351] Dynamic subtest vecs0: SUCCESS (1.946s)
[664.915055] Starting dynamic subtest: ccs0
[666.072390] Dynamic subtest ccs0: SUCCESS (1.168s)
[666.075184] Subtest noreorder-corked: SUCCESS (8.185s)
[666.282307] [128/134] (358s left) kms_psr (pr-cursor-mmap-cpu)
[666.375193] Starting subtest: pr-cursor-mmap-cpu
[666.379633] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[666.474289] [129/134] (357s left) perf (invalid-oa-format-id)
[666.580656] Starting subtest: invalid-oa-format-id
[666.591739] Subtest invalid-oa-format-id: SUCCESS (0.008s)
[666.633044] [130/134] (357s left) gem_eio (in-flight-internal-immediate)
[666.832712] Starting subtest: in-flight-internal-immediate
[667.980474] Subtest in-flight-internal-immediate: SUCCESS (1.146s)
[668.148481] [131/134] (356s left) kms_cursor_edge_walk (256x256-top-edge)
[668.240263] Starting subtest: 256x256-top-edge
[668.242565] Starting dynamic subtest: pipe-A-eDP-1
[671.717611] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.474s)
[671.727795] Starting dynamic subtest: pipe-D-eDP-1
[674.853951] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.135s)
[674.856295] Subtest 256x256-top-edge: SUCCESS (6.612s)
[675.694632] [132/134] (348s left) gem_ctx_persistence (engines-persistence)
[675.753401] Starting subtest: engines-persistence
[675.755797] Starting dynamic subtest: rcs0
[676.550270] Dynamic subtest rcs0: SUCCESS (0.796s)
[676.561827] Starting dynamic subtest: bcs0
[677.398950] Dynamic subtest bcs0: SUCCESS (0.847s)
[677.411696] Starting dynamic subtest: vcs0
[678.178546] Dynamic subtest vcs0: SUCCESS (0.778s)
[678.190886] Starting dynamic subtest: vcs1
[678.912818] Dynamic subtest vcs1: SUCCESS (0.732s)
[678.923943] Starting dynamic subtest: vecs0
[679.723037] Dynamic subtest vecs0: SUCCESS (0.808s)
[679.734819] Starting dynamic subtest: ccs0
[680.516986] Dynamic subtest ccs0: SUCCESS (0.792s)
[680.519647] Subtest engines-persistence: SUCCESS (4.764s)
[680.675143] [133/134] (343s left) api_intel_bb (render-ccs)
[680.735228] Starting subtest: render-ccs
[681.089280] Subtest render-ccs: SUCCESS (0.354s)
[681.250328] [134/134] (343s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[681.354328] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[681.358653] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[681.490373] 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.