[56.644264] Initializing watchdogs
[56.644309]   /dev/watchdog0
[56.658419] [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]
[56.662583] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.664771] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.668102] [001/134] (960s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[56.795717] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[56.797965] Starting dynamic subtest: pipe-A
[56.882767] Dynamic subtest pipe-A: SUCCESS (0.090s)
[56.892062] Starting dynamic subtest: pipe-B
[57.995775] Dynamic subtest pipe-B: SUCCESS (1.125s)
[58.007550] Starting dynamic subtest: pipe-C
[59.112463] Dynamic subtest pipe-C: SUCCESS (1.127s)
[59.124367] Starting dynamic subtest: pipe-D
[60.223852] Dynamic subtest pipe-D: SUCCESS (1.121s)
[60.226304] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.466s)
[61.395689] [002/134] (955s left) gem_userptr_blits (forbidden-operations)
[61.477681] Starting subtest: forbidden-operations
[61.482428] Subtest forbidden-operations: SKIP (0.000s)
[61.620948] [003/134] (955s left) gem_mmap_gtt (big-bo)
[61.684095] Subtest big-bo: SKIP (0.000s)
[61.739862] [004/134] (955s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[61.844068] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[69.337099] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.525s)
[69.491141] [005/134] (947s left) kms_fence_pin_leak
[69.705472] [006/134] (947s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[69.807908] Starting subtest: x-tiled-16bpp-rotate-180
[71.160263] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.356s)
[71.292937] [007/134] (946s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[71.342890] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[71.403961] [008/134] (946s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[71.504921] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[71.516447] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.010s)
[71.651294] [009/134] (945s left) perf_pmu (busy-check-all)
[71.692548] Starting subtest: busy-check-all
[71.694511] Starting dynamic subtest: rcs0
[72.258921] Dynamic subtest rcs0: SUCCESS (0.567s)
[72.271028] Starting dynamic subtest: bcs0
[72.811728] Dynamic subtest bcs0: SUCCESS (0.553s)
[72.822160] Starting dynamic subtest: vcs0
[73.943839] Dynamic subtest vcs0: SUCCESS (1.131s)
[73.954213] Starting dynamic subtest: vcs1
[75.927209] Dynamic subtest vcs1: SUCCESS (1.984s)
[75.938339] Starting dynamic subtest: vecs0
[77.911443] Dynamic subtest vecs0: SUCCESS (1.985s)
[77.922908] Starting dynamic subtest: ccs0
[78.465416] Dynamic subtest ccs0: SUCCESS (0.555s)
[78.467836] Subtest busy-check-all: SUCCESS (6.781s)
[78.582447] [010/134] (938s left) gem_mmap_wc (coherency)
[78.637986] Subtest coherency: SKIP (0.000s)
[78.702295] [011/134] (938s left) kms_big_fb (yf-tiled-addfb)
[78.803057] Starting subtest: yf-tiled-addfb
[78.806994] Subtest yf-tiled-addfb: SKIP (0.000s)
[78.919979] [012/134] (938s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[79.027611] Starting subtest: extended-modeset-hang-oldfb-with-reset
[79.030040] Starting dynamic subtest: pipe-A
[90.526576] Dynamic subtest pipe-A: SUCCESS (11.493s)
[90.538477] Starting dynamic subtest: pipe-D
[102.811491] Dynamic subtest pipe-D: SUCCESS (12.278s)
[102.813746] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.774s)
[103.618629] [013/134] (913s left) kms_plane_alpha_blend (constant-alpha-min)
[103.725058] Starting subtest: constant-alpha-min
[104.014562] Starting dynamic subtest: pipe-A-eDP-1
[104.716140] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.699s)
[104.725626] Starting dynamic subtest: pipe-D-eDP-1
[106.150681] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.433s)
[106.153139] Subtest constant-alpha-min: SUCCESS (2.423s)
[106.974255] [014/134] (910s left) sysfs_timeslice_duration (duration)
[107.031477] Starting subtest: duration
[107.033719] Starting dynamic subtest: vecs0
[121.846991] Dynamic subtest vecs0: SUCCESS (14.810s)
[121.856242] Starting dynamic subtest: ccs0
[135.032122] Dynamic subtest ccs0: SUCCESS (13.184s)
[135.042803] Starting dynamic subtest: vcs0
[149.811855] Dynamic subtest vcs0: SUCCESS (14.777s)
[149.822935] Starting dynamic subtest: bcs0
[162.972384] Dynamic subtest bcs0: SUCCESS (13.160s)
[162.983858] Starting dynamic subtest: rcs0
[176.127407] Dynamic subtest rcs0: SUCCESS (13.154s)
[176.138078] Starting dynamic subtest: vcs1
[189.811953] Dynamic subtest vcs1: SUCCESS (13.682s)
[189.814962] Subtest duration: SUCCESS (82.778s)
[189.909046] [015/134] (827s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[190.011477] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[193.638594] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.631s)
[194.860226] [016/134] (822s left) kms_cursor_crc (cursor-onscreen-64x64)
[195.039140] Starting subtest: cursor-onscreen-64x64
[195.041526] Starting dynamic subtest: pipe-A-eDP-1
[197.128819] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.088s)
[197.156467] Starting dynamic subtest: pipe-D-eDP-1
[199.893927] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.742s)
[199.895964] Subtest cursor-onscreen-64x64: SUCCESS (4.854s)
[200.719776] [017/134] (817s left) kms_color (ctm-red-to-blue)
[200.822047] Starting subtest: ctm-red-to-blue
[200.824239] Starting dynamic subtest: pipe-A-eDP-1
[201.532152] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[201.540592] Starting dynamic subtest: pipe-B-eDP-1
[202.907603] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.375s)
[202.915895] Starting dynamic subtest: pipe-C-eDP-1
[204.296853] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.389s)
[204.306786] Starting dynamic subtest: pipe-D-eDP-1
[205.604842] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.307s)
[205.607112] Subtest ctm-red-to-blue: SUCCESS (4.782s)
[206.443351] [018/134] (811s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[206.512191] Subtest writes-after-reads-uncached: SKIP (0.000s)
[206.615876] [019/134] (811s left) dumb_buffer (invalid-bpp)
[206.670092] Starting subtest: invalid-bpp
[206.672327] Subtest invalid-bpp: SUCCESS (0.000s)
[206.779102] [020/134] (811s left) gem_mmap_gtt (ptrace)
[206.840125] Subtest ptrace: SKIP (0.000s)
[206.903904] [021/134] (811s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[207.022695] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[207.027284] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[207.183700] [022/134] (810s left) gem_lmem_swapping (verify)
[207.230219] Subtest verify: SKIP (0.000s)
[207.273302] [023/134] (810s left) gem_spin_batch (resubmit-new)
[207.332372] Starting subtest: resubmit-new
[207.334701] Starting dynamic subtest: rcs0
[207.339477] Dynamic subtest rcs0: SUCCESS (0.006s)
[207.350270] Starting dynamic subtest: bcs0
[207.352574] Dynamic subtest bcs0: SUCCESS (0.003s)
[207.363263] Starting dynamic subtest: vcs0
[207.364801] Dynamic subtest vcs0: SUCCESS (0.004s)
[207.372348] Starting dynamic subtest: vcs1
[207.373881] Dynamic subtest vcs1: SUCCESS (0.004s)
[207.381050] Starting dynamic subtest: vecs0
[207.382578] Dynamic subtest vecs0: SUCCESS (0.005s)
[207.389520] Starting dynamic subtest: ccs0
[207.391076] Dynamic subtest ccs0: SUCCESS (0.004s)
[207.392645] Subtest resubmit-new: SUCCESS (0.029s)
[208.980295] [024/134] (809s left) kms_cursor_crc (cursor-random-512x512)
[209.274406] Starting subtest: cursor-random-512x512
[209.278725] Subtest cursor-random-512x512: SKIP (0.001s)
[209.471799] [025/134] (808s left) kms_properties (plane-properties-legacy)
[209.569227] Starting subtest: plane-properties-legacy
[209.571515] Starting dynamic subtest: pipe-A-eDP-1
[210.127374] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.555s)
[210.136455] Starting dynamic subtest: pipe-B-eDP-1
[211.415105] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.288s)
[211.427134] Starting dynamic subtest: pipe-C-eDP-1
[212.727513] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.310s)
[212.737435] Starting dynamic subtest: pipe-D-eDP-1
[213.968309] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.240s)
[213.970639] Subtest plane-properties-legacy: SUCCESS (4.397s)
[214.787216] [026/134] (803s left) kms_vrr (flipline)
[214.894157] Starting subtest: flipline
[214.901566] Subtest flipline: SKIP (0.000s)
[214.988898] [027/134] (803s left) gem_exec_params (secure-non-master)
[215.059644] Starting subtest: secure-non-master
[215.064214] Subtest secure-non-master: SKIP (0.000s)
[215.226849] [028/134] (802s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[215.482331] Starting subtest: parallel-dmabuf-import-out-fence
[216.596856] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.115s)
[216.731166] [029/134] (801s left) kms_pm_dc (dc5-dpms-negative)
[217.845041] Starting subtest: dc5-dpms-negative
[217.849696] Subtest dc5-dpms-negative: SKIP (0.000s)
[217.940981] [030/134] (800s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[218.034716] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[218.038864] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[218.151218] [031/134] (800s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[218.253614] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[225.044318] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.793s)
[225.205264] [032/134] (793s left) kms_frontbuffer_tracking (psr-argb161616f-draw-mmap-cpu)
[225.315451] Starting subtest: psr-argb161616f-draw-mmap-cpu
[225.319590] Subtest psr-argb161616f-draw-mmap-cpu: SKIP (0.000s)
[225.424718] [033/134] (792s left) gem_exec_whisper (basic-fds-all)
[225.485672] Starting subtest: basic-fds-all
[236.931779] Subtest basic-fds-all: SUCCESS (11.444s)
[237.136854] [034/134] (781s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[237.247304] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[237.251273] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[237.356574] [035/134] (781s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[237.442357] Starting subtest: psr-rgb565-draw-render
[244.503902] Subtest psr-rgb565-draw-render: SUCCESS (7.064s)
[244.664324] [036/134] (773s left) gem_render_copy_redux (flink)
[244.738804] Starting subtest: flink
[245.489819] Subtest flink: SUCCESS (0.753s)
[245.635681] [037/134] (772s left) gem_mmap_wc (bad-offset)
[245.703164] Subtest bad-offset: SKIP (0.000s)
[245.768864] [038/134] (772s left) gem_pxp (reject-modify-context-protection-off-2)
[245.893443] Starting subtest: reject-modify-context-protection-off-2
[245.895668] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[246.032742] [039/134] (772s left) kms_3d (basic)
[246.085402] Starting subtest: basic
[248.111696] Subtest basic: SUCCESS (2.026s)
[248.637122] [040/134] (770s left) gem_ctx_persistence (smoketest)
[248.699558] Starting subtest: smoketest
[288.823177] Subtest smoketest: SUCCESS (40.118s)
[288.934087] [041/134] (729s left) kms_psr (fbc-pr-suspend)
[289.045906] Starting subtest: fbc-pr-suspend
[289.050212] Subtest fbc-pr-suspend: SKIP (0.000s)
[289.139031] [042/134] (729s left) syncobj_timeline (multi-wait-for-submit-signaled)
[289.205294] Starting subtest: multi-wait-for-submit-signaled
[289.207596] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[289.321972] [043/134] (729s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[289.418117] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[289.420395] Starting dynamic subtest: pipe-A-default-mode
[292.131937] Dynamic subtest pipe-A-default-mode: SUCCESS (2.713s)
[292.134291] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.715s)
[292.972150] [044/134] (725s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[293.069234] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[293.071338] Starting dynamic subtest: pipe-A-default-mode
[295.767772] Dynamic subtest pipe-A-default-mode: SUCCESS (2.699s)
[295.770113] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.700s)
[296.588862] [045/134] (722s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[296.697289] Starting subtest: psr-rgb565-draw-mmap-cpu
[303.381473] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.686s)
[303.553163] [046/134] (715s left) vgem_basic (mmap)
[303.679370] Starting subtest: mmap
[303.684958] Subtest mmap: SUCCESS (0.007s)
[303.757888] [FACT vgem_basic (mmap)] new: kernel.kmod_is_loaded.vgem: true
[303.761284] [047/134] (715s left) gem_userptr_blits (sync-unmap-after-close)
[303.832188] Starting subtest: sync-unmap-after-close
[303.840715] Subtest sync-unmap-after-close: SUCCESS (0.009s)
[304.011854] [048/134] (714s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[304.392709] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[305.240759] [049/134] (713s left) kms_frontbuffer_tracking (basic)
[305.353906] Starting subtest: basic
[308.484107] Subtest basic: SUCCESS (3.134s)
[308.650590] [050/134] (710s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[308.760668] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[315.687155] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (6.929s)
[315.822219] [051/134] (703s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[315.929530] Starting subtest: fbc-rgb101010-draw-blt
[320.533217] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.606s)
[321.685228] [052/134] (697s left) kms_lease (lease-unleased-connector)
[321.770306] Starting subtest: lease-unleased-connector
[321.772557] Starting dynamic subtest: pipe-A-eDP-1
[321.777953] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[321.787853] Starting dynamic subtest: pipe-B-eDP-1
[321.789662] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[321.798424] Starting dynamic subtest: pipe-C-eDP-1
[321.800570] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[321.808969] Starting dynamic subtest: pipe-D-eDP-1
[321.811137] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[321.813306] Subtest lease-unleased-connector: SUCCESS (0.036s)
[321.935915] [053/134] (697s left) gem_tiled_partial_pwrite_pread (reads)
[322.009060] Subtest reads: SKIP (0.000s)
[322.095455] [054/134] (697s left) kms_dp_link_training (uhbr-sst)
[322.196393] Starting subtest: uhbr-sst
[322.204673] Subtest uhbr-sst: SKIP (0.000s)
[322.290790] [055/134] (697s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[322.344520] Starting subtest: etime-multi-wait-all-submitted-signaled
[322.451081] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.107s)
[322.553167] [056/134] (696s left) kms_invalid_mode (overflow-vrefresh)
[322.648150] Starting subtest: overflow-vrefresh
[322.650402] Starting dynamic subtest: pipe-A-eDP-1
[322.944662] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.298s)
[322.957852] Starting dynamic subtest: pipe-B-eDP-1
[322.960047] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[322.968194] Starting dynamic subtest: pipe-C-eDP-1
[322.970047] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[322.977950] Starting dynamic subtest: pipe-D-eDP-1
[322.979871] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[322.981792] Subtest overflow-vrefresh: SUCCESS (0.304s)
[323.776164] [057/134] (695s left) kms_pm_rpm (i2c)
[326.028526] Starting subtest: i2c
[331.360713] Subtest i2c: SUCCESS (5.334s)
[331.475871] [058/134] (687s left) gem_exec_balancer (busy)
[331.537461] Starting subtest: busy
[332.913202] Subtest busy: SUCCESS (1.373s)
[333.266772] [059/134] (686s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[338.252431] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[338.257014] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s)
[339.134874] [060/134] (680s left) gen9_exec_parse (batch-without-end)
[339.195241] Subtest batch-without-end: SKIP (0.000s)
[339.259831] [061/134] (680s left) gem_ctx_shared (exec-shared-gtt)
[339.329268] Starting subtest: exec-shared-gtt
[339.331623] Starting dynamic subtest: rcs0
[339.336566] Dynamic subtest rcs0: SUCCESS (0.007s)
[339.345501] Starting dynamic subtest: bcs0
[339.347656] Dynamic subtest bcs0: SUCCESS (0.005s)
[339.356864] Starting dynamic subtest: vcs0
[339.359203] Dynamic subtest vcs0: SUCCESS (0.006s)
[339.367830] Starting dynamic subtest: vcs1
[339.369746] Dynamic subtest vcs1: SUCCESS (0.008s)
[339.377983] Starting dynamic subtest: vecs0
[339.380231] Dynamic subtest vecs0: SUCCESS (0.006s)
[339.388446] Starting dynamic subtest: ccs0
[339.390708] Dynamic subtest ccs0: SUCCESS (0.005s)
[339.392880] Subtest exec-shared-gtt: SUCCESS (0.040s)
[339.577740] [062/134] (680s left) perf (invalid-oa-metric-set-id)
[339.714771] Starting subtest: invalid-oa-metric-set-id
[339.726075] Subtest invalid-oa-metric-set-id: SUCCESS (0.012s)
[339.762932] [063/134] (679s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[339.821484] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[339.823434] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[339.964721] [064/134] (679s left) gem_tiled_pread_pwrite
[340.087304] [065/134] (679s left) i915_pm_rps (thresholds-park)
[340.149495] Starting subtest: thresholds-park
[340.153173] Subtest thresholds-park: SKIP (0.001s)
[340.293669] [066/134] (679s left) gem_ctx_engines (invalid-engines)
[340.366413] Starting subtest: invalid-engines
[340.374246] Subtest invalid-engines: SUCCESS (0.010s)
[340.631526] [067/134] (679s left) vgem_basic (create)
[340.686277] Starting subtest: create
[340.688431] Subtest create: SUCCESS (0.000s)
[340.767457] [068/134] (679s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[340.863181] Starting subtest: fbc-psr2-sprite-mmap-cpu
[340.865402] Starting dynamic subtest: eDP-1
[340.869572] Dynamic subtest eDP-1: SKIP (0.000s)
[340.873706] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[340.957089] [069/134] (678s left) gem_mmap_gtt (big-copy-odd)
[341.021212] Subtest big-copy-odd: SKIP (0.000s)
[341.087386] [070/134] (678s left) gem_exec_reloc (basic-gtt-cpu-active)
[341.152485] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[341.239731] [071/134] (678s left) prime_busy (before-wait)
[341.299415] Starting subtest: before-wait
[341.304163] Starting dynamic subtest: rcs0
[341.351847] Dynamic subtest rcs0: SUCCESS (0.050s)
[341.362592] Starting dynamic subtest: bcs0
[341.422516] Dynamic subtest bcs0: SUCCESS (0.070s)
[341.432593] Starting dynamic subtest: vcs0
[341.464368] Dynamic subtest vcs0: SUCCESS (0.041s)
[341.473603] Starting dynamic subtest: vcs1
[341.505875] Dynamic subtest vcs1: SUCCESS (0.041s)
[341.514480] Starting dynamic subtest: vecs0
[341.546478] Dynamic subtest vecs0: SUCCESS (0.040s)
[341.555072] Starting dynamic subtest: ccs0
[341.587125] Dynamic subtest ccs0: SUCCESS (0.040s)
[341.696055] Subtest before-wait: SUCCESS (0.395s)
[341.801245] [072/134] (678s left) gem_exec_fence (keep-in-fence)
[341.982246] Starting subtest: keep-in-fence
[341.984492] Starting dynamic subtest: rcs0
[342.062822] Dynamic subtest rcs0: SUCCESS (0.084s)
[342.074317] Starting dynamic subtest: bcs0
[342.116996] Dynamic subtest bcs0: SUCCESS (0.053s)
[342.126204] Starting dynamic subtest: vcs0
[343.895287] Dynamic subtest vcs0: SUCCESS (1.774s)
[343.906879] Starting dynamic subtest: vcs1
[345.879163] Dynamic subtest vcs1: SUCCESS (1.981s)
[345.890762] Starting dynamic subtest: vecs0
[347.927233] Dynamic subtest vecs0: SUCCESS (2.045s)
[347.939026] Starting dynamic subtest: ccs0
[348.161421] Dynamic subtest ccs0: SUCCESS (0.232s)
[348.164349] Subtest keep-in-fence: SUCCESS (6.183s)
[350.029370] [073/134] (669s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[350.133685] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[353.837325] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.707s)
[355.080714] [074/134] (665s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[355.194860] Starting subtest: 4-tiled-8bpp-rotate-270
[355.215520] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.020s)
[355.365396] [075/134] (664s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[360.390721] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[360.393120] Starting dynamic subtest: pipe-A-eDP-1
[361.187166] Dynamic subtest pipe-A-eDP-1: SKIP (0.792s)
[361.197393] Starting dynamic subtest: pipe-B-eDP-1
[362.314433] Dynamic subtest pipe-B-eDP-1: SKIP (1.126s)
[362.319070] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.922s)
[363.518975] [076/134] (656s left) gem_ccs (block-multicopy-inplace)
[363.575818] Starting subtest: block-multicopy-inplace
[363.580527] Subtest block-multicopy-inplace: SKIP (0.000s)
[363.720384] [077/134] (656s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[363.820616] Starting subtest: x-tiled-addfb-size-offset-overflow
[363.822896] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[363.949943] [078/134] (656s left) kms_atomic (crtc-invalid-params)
[364.046268] Starting subtest: crtc-invalid-params
[364.048605] Starting dynamic subtest: pipe-A-eDP-1
[364.398918] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.352s)
[364.401100] Subtest crtc-invalid-params: SUCCESS (0.353s)
[365.244202] [079/134] (655s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[365.346416] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[365.348318] Starting dynamic subtest: pipe-A-eDP-1
[365.368867] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[365.379403] Starting dynamic subtest: pipe-B-eDP-1
[365.399143] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.019s)
[365.408695] Starting dynamic subtest: pipe-C-eDP-1
[365.428525] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.019s)
[365.437599] Starting dynamic subtest: pipe-D-eDP-1
[365.457636] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.019s)
[365.459525] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.083s)
[367.617216] [080/134] (652s left) gem_lmem_swapping (heavy-verify-multi)
[367.659504] Subtest heavy-verify-multi: SKIP (0.000s)
[367.708052] [081/134] (652s left) kms_chamelium_frames (hdmi-crc-fast)
[368.091525] Subtest hdmi-crc-fast: SKIP (0.000s)
[368.901089] [082/134] (651s left) kms_vblank (query-forked-busy-hang)
[368.994283] Starting subtest: query-forked-busy-hang
[368.996701] Starting dynamic subtest: pipe-A-eDP-1
[395.732628] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.737s)
[395.747886] Starting dynamic subtest: pipe-D-eDP-1
[420.703478] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.964s)
[420.705772] Subtest query-forked-busy-hang: SUCCESS (51.706s)
[421.610604] [083/134] (598s left) kms_big_fb (linear-16bpp-rotate-90)
[421.719204] Starting subtest: linear-16bpp-rotate-90
[421.740052] Subtest linear-16bpp-rotate-90: SKIP (0.020s)
[421.912256] [084/134] (598s left) gem_flink_race (flink_close)
[421.945161] Starting subtest: flink_close
[427.056233] Subtest flink_close: SUCCESS (5.112s)
[427.159906] [085/134] (593s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[427.284172] Starting subtest: fbcpsr-modesetfrombusy
[433.489220] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.210s)
[433.664024] [086/134] (586s left) gem_exec_schedule (thriceslice)
[433.730108] Starting subtest: thriceslice
[433.731838] Starting dynamic subtest: rcs0
[433.750995] Dynamic subtest rcs0: SUCCESS (0.029s)
[433.762084] Starting dynamic subtest: bcs0
[433.779942] Dynamic subtest bcs0: SUCCESS (0.028s)
[433.788534] Starting dynamic subtest: vcs0
[433.830732] Dynamic subtest vcs0: SUCCESS (0.049s)
[433.841949] Starting dynamic subtest: vcs1
[433.860854] Dynamic subtest vcs1: SUCCESS (0.029s)
[433.869308] Starting dynamic subtest: vecs0
[433.910064] Dynamic subtest vecs0: SUCCESS (0.048s)
[433.920051] Starting dynamic subtest: ccs0
[433.940554] Dynamic subtest ccs0: SUCCESS (0.028s)
[433.942452] Subtest thriceslice: SUCCESS (0.220s)
[434.262013] [087/134] (586s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[434.352168] Starting subtest: flip-vs-dpms-off-vs-modeset
[434.354414] Starting dynamic subtest: A-eDP1
[437.990347] Dynamic subtest A-eDP1: SUCCESS (3.634s)
[438.000443] Starting dynamic subtest: B-eDP1
[441.178331] Dynamic subtest B-eDP1: SUCCESS (3.189s)
[441.189131] Starting dynamic subtest: C-eDP1
[444.278763] Dynamic subtest C-eDP1: SUCCESS (3.099s)
[444.293387] Starting dynamic subtest: D-eDP1
[447.405832] Dynamic subtest D-eDP1: SUCCESS (3.125s)
[447.408257] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.055s)
[448.226065] [088/134] (572s left) i915_pm_rps (min-max-config-idle)
[448.282402] Starting subtest: min-max-config-idle
[448.286656] Subtest min-max-config-idle: SKIP (0.001s)
[448.428422] [089/134] (572s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[448.519669] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[455.095602] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.577s)
[455.268477] [090/134] (565s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[460.277748] Starting subtest: psr2-overlay-plane-move-continuous-sf
[460.280128] Starting dynamic subtest: pipe-A-eDP-1
[466.982378] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.702s)
[466.994304] Starting dynamic subtest: pipe-B-eDP-1
[473.662230] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.677s)
[473.664473] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.384s)
[474.536602] [091/134] (546s left) kms_concurrent (multi-plane-atomic-lowres)
[474.637943] Starting subtest: multi-plane-atomic-lowres
[474.640252] Starting dynamic subtest: pipe-A-eDP-1
[475.154029] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.512s)
[475.156325] Subtest multi-plane-atomic-lowres: SUCCESS (0.514s)
[475.976351] [092/134] (544s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[476.100154] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[476.104497] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[476.230728] [093/134] (544s left) api_intel_allocator (reopen)
[476.282816] Starting subtest: reopen
[476.291104] Subtest reopen: SUCCESS (0.008s)
[476.447175] [094/134] (544s left) kms_flip (dpms-vs-vblank-race)
[476.552664] Starting subtest: dpms-vs-vblank-race
[476.554992] Starting dynamic subtest: A-eDP1
[481.531979] Dynamic subtest A-eDP1: SUCCESS (4.981s)
[481.545080] Starting dynamic subtest: B-eDP1
[486.134064] Dynamic subtest B-eDP1: SUCCESS (4.598s)
[486.143727] Starting dynamic subtest: C-eDP1
[490.742221] Dynamic subtest C-eDP1: SUCCESS (4.610s)
[490.752117] Starting dynamic subtest: D-eDP1
[495.376937] Dynamic subtest D-eDP1: SUCCESS (4.630s)
[495.379240] Subtest dpms-vs-vblank-race: SUCCESS (18.826s)
[496.289954] [095/134] (524s left) syncobj_timeline (single-wait-all-available-signaled)
[496.362406] Starting subtest: single-wait-all-available-signaled
[496.364728] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[496.501406] [096/134] (524s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[496.582965] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[496.585158] Starting dynamic subtest: pipe-A-eDP-1
[497.895060] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.312s)
[498.185774] Starting dynamic subtest: pipe-B-eDP-1
[499.230046] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.052s)
[499.498946] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.916s)
[500.370062] [097/134] (520s left) gem_exec_params (rs-invalid)
[500.441369] Starting subtest: rs-invalid
[500.446397] Subtest rs-invalid: SUCCESS (0.003s)
[500.604650] [098/134] (520s left) kms_scaling_modes (scaling-mode-full-aspect)
[500.700348] Starting subtest: scaling-mode-full-aspect
[500.702551] Starting dynamic subtest: pipe-A-eDP-1
[500.794338] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.096s)
[500.804152] Starting dynamic subtest: pipe-B-eDP-1
[501.962040] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.166s)
[501.979821] Starting dynamic subtest: pipe-C-eDP-1
[503.081163] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.115s)
[503.091161] Starting dynamic subtest: pipe-D-eDP-1
[504.209745] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s)
[504.212254] Subtest scaling-mode-full-aspect: SUCCESS (3.512s)
[505.395613] [099/134] (515s left) kms_plane (plane-panning-top-left)
[505.491101] Starting subtest: plane-panning-top-left
[505.493372] Starting dynamic subtest: pipe-A
[507.145070] Dynamic subtest pipe-A: SUCCESS (1.654s)
[507.157712] Starting dynamic subtest: pipe-B
[509.492153] Dynamic subtest pipe-B: SUCCESS (2.344s)
[509.494421] Subtest plane-panning-top-left: SUCCESS (4.001s)
[510.321245] [100/134] (510s left) kms_psr (psr2-sprite-mmap-cpu)
[510.423156] Starting subtest: psr2-sprite-mmap-cpu
[510.425474] Starting dynamic subtest: eDP-1
[512.189875] Dynamic subtest eDP-1: SUCCESS (1.765s)
[512.192134] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.767s)
[513.080149] [101/134] (508s left) gem_exec_params (rel-constants-invalid-ring)
[513.145046] Starting subtest: rel-constants-invalid-ring
[513.147083] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[513.284899] [102/134] (507s left) i915_query (query-garbage)
[513.341574] Starting subtest: query-garbage
[513.343509] Subtest query-garbage: SUCCESS (0.000s)
[513.472306] [103/134] (507s left) kms_psr (psr-cursor-mmap-cpu)
[513.560950] Starting subtest: psr-cursor-mmap-cpu
[513.563135] Starting dynamic subtest: eDP-1
[515.251424] Dynamic subtest eDP-1: SUCCESS (1.691s)
[515.253784] Subtest psr-cursor-mmap-cpu: SUCCESS (1.692s)
[516.143171] [104/134] (505s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[516.254782] Starting subtest: y-tiled-16bpp-rotate-90
[516.259420] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[516.358434] [105/134] (505s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[516.462228] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[516.466749] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[517.571914] [106/134] (503s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[517.704187] Starting subtest: flip-vs-cursor-legacy
[524.777162] Subtest flip-vs-cursor-legacy: SUCCESS (7.073s)
[525.602436] [107/134] (495s left) kms_frontbuffer_tracking (fbcpsr-argb161616f-draw-blt)
[525.700642] Starting subtest: fbcpsr-argb161616f-draw-blt
[525.704781] Subtest fbcpsr-argb161616f-draw-blt: SKIP (0.000s)
[525.829954] [108/134] (495s left) kms_flip (flip-vs-fences)
[525.934255] Starting subtest: flip-vs-fences
[525.938791] Subtest flip-vs-fences: SKIP (0.000s)
[526.066644] [109/134] (495s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[526.134165] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[526.208143] [110/134] (495s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[526.303110] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[526.305402] Starting dynamic subtest: pipe-A-eDP-1
[527.118037] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.808s)
[527.128213] Starting dynamic subtest: pipe-B-eDP-1
[528.772814] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.651s)
[528.784902] Starting dynamic subtest: pipe-C-eDP-1
[530.283702] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.511s)
[530.293909] Starting dynamic subtest: pipe-D-eDP-1
[531.806092] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.521s)
[531.808347] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.497s)
[533.021514] [111/134] (488s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[533.118677] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[533.122777] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[533.246603] [112/134] (488s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[533.347726] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[533.349831] Starting dynamic subtest: pipe-A-eDP-1
[534.094055] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.739s)
[534.103965] Starting dynamic subtest: pipe-B-eDP-1
[535.925084] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.829s)
[535.934959] Starting dynamic subtest: pipe-C-eDP-1
[537.754289] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.828s)
[537.764174] Starting dynamic subtest: pipe-D-eDP-1
[539.584127] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.829s)
[539.586422] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.230s)
[540.739646] [113/134] (480s left) i915_drm_fdinfo (memory-info-shared)
[540.785490] Starting subtest: memory-info-shared
[540.787854] Starting dynamic subtest: smem0
[540.856654] Dynamic subtest smem0: SUCCESS (0.072s)
[540.859424] Subtest memory-info-shared: SUCCESS (0.073s)
[540.955376] [114/134] (480s left) gem_exec_flush (basic-wb-set-default)
[541.024859] Starting subtest: basic-wb-set-default
[546.469546] Subtest basic-wb-set-default: SUCCESS (5.447s)
[546.680558] [115/134] (475s left) sysfs_timeslice_duration (timeout)
[546.741297] Starting subtest: timeout
[546.743513] Starting dynamic subtest: vecs0
[555.945809] Dynamic subtest vecs0: SUCCESS (9.201s)
[555.957191] Starting dynamic subtest: ccs0
[557.259197] Dynamic subtest ccs0: SUCCESS (1.312s)
[557.270388] Starting dynamic subtest: vcs0
[566.934318] Dynamic subtest vcs0: SUCCESS (9.674s)
[566.945918] Starting dynamic subtest: bcs0
[567.634160] Dynamic subtest bcs0: SUCCESS (0.698s)
[567.645299] Starting dynamic subtest: rcs0
[568.955416] Dynamic subtest rcs0: SUCCESS (1.321s)
[568.965690] Starting dynamic subtest: vcs1
[578.945094] Dynamic subtest vcs1: SUCCESS (9.962s)
[578.949508] Subtest timeout: SUCCESS (32.177s)
[579.018447] [116/134] (442s left) sriov_basic (enable-vfs-bind-unbind-each)
[579.073100] Starting subtest: enable-vfs-bind-unbind-each
[579.075407] Starting dynamic subtest: numvfs-1
[579.155074] Dynamic subtest numvfs-1: FAIL (0.032s)
[579.166394] Starting dynamic subtest: numvfs-2
[579.237560] Dynamic subtest numvfs-2: FAIL (0.004s)
[579.247876] Starting dynamic subtest: numvfs-3
[579.319986] Dynamic subtest numvfs-3: FAIL (0.003s)
[579.330167] Starting dynamic subtest: numvfs-4
[579.401541] Dynamic subtest numvfs-4: FAIL (0.004s)
[579.411667] Starting dynamic subtest: numvfs-5
[579.483064] Dynamic subtest numvfs-5: FAIL (0.006s)
[579.493175] Starting dynamic subtest: numvfs-6
[579.565187] Dynamic subtest numvfs-6: FAIL (0.003s)
[579.575531] Starting dynamic subtest: numvfs-7
[579.647715] Dynamic subtest numvfs-7: FAIL (0.003s)
[579.657986] Starting dynamic subtest: numvfs-random
[579.729731] Dynamic subtest numvfs-random: FAIL (0.003s)
[579.732065] Subtest enable-vfs-bind-unbind-each: FAIL (0.064s)
[579.770386] [117/134] (442s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[579.853790] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[579.858095] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[580.970422] [118/134] (440s left) kms_getfb (getfb-handle-not-fb)
[581.071867] Starting subtest: getfb-handle-not-fb
[581.074116] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[581.207426] [119/134] (440s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[581.274147] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[581.278576] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[581.479027] [120/134] (440s left) gem_workarounds (reset-context)
[581.550905] Starting subtest: reset-context
[581.711553] Subtest reset-context: SUCCESS (0.161s)
[581.870119] [121/134] (440s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[581.984511] Starting subtest: psr-farfromfence-mmap-gtt
[581.988582] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[582.128248] [122/134] (439s left) gem_wait (write-busy)
[582.196374] Starting subtest: write-busy
[582.198750] Starting dynamic subtest: all-engines
[582.824433] Dynamic subtest all-engines: SUCCESS (0.628s)
[582.839664] Starting dynamic subtest: rcs0
[583.378612] Dynamic subtest rcs0: SUCCESS (0.552s)
[583.395043] Starting dynamic subtest: bcs0
[583.928910] Dynamic subtest bcs0: SUCCESS (0.549s)
[583.944031] Starting dynamic subtest: vcs0
[585.942381] Dynamic subtest vcs0: SUCCESS (2.011s)
[585.958575] Starting dynamic subtest: vcs1
[587.925959] Dynamic subtest vcs1: SUCCESS (1.982s)
[587.940275] Starting dynamic subtest: vecs0
[589.846313] Dynamic subtest vecs0: SUCCESS (1.917s)
[589.862375] Starting dynamic subtest: ccs0
[590.396533] Dynamic subtest ccs0: SUCCESS (0.549s)
[590.399059] Subtest write-busy: SUCCESS (8.200s)
[590.617990] [123/134] (431s left) i915_hangman (detector)
[590.694518] Starting subtest: detector
[590.696413] Starting dynamic subtest: rcs0
[600.884600] Dynamic subtest rcs0: SUCCESS (10.189s)
[600.897960] Starting dynamic subtest: bcs0
[612.852938] Dynamic subtest bcs0: SUCCESS (11.966s)
[612.865737] Starting dynamic subtest: vcs0
[624.884654] Dynamic subtest vcs0: SUCCESS (12.029s)
[624.896744] Starting dynamic subtest: vcs1
[636.852781] Dynamic subtest vcs1: SUCCESS (11.965s)
[636.864135] Starting dynamic subtest: vecs0
[648.885050] Dynamic subtest vecs0: SUCCESS (12.029s)
[648.897262] Starting dynamic subtest: ccs0
[660.852569] Dynamic subtest ccs0: SUCCESS (11.964s)
[660.855743] Subtest detector: SUCCESS (70.158s)
[660.957056] [124/134] (361s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[661.065344] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[661.069389] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[661.215443] [125/134] (360s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[661.331625] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[661.336128] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[661.499980] [126/134] (360s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[661.558174] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[661.614915] [127/134] (360s left) gem_exec_schedule (noreorder-corked)
[661.789028] Starting subtest: noreorder-corked
[661.791339] Starting dynamic subtest: rcs0
[662.948289] Dynamic subtest rcs0: SUCCESS (1.158s)
[662.961151] Starting dynamic subtest: vcs0
[664.903475] Dynamic subtest vcs0: SUCCESS (1.952s)
[664.919303] Starting dynamic subtest: vcs1
[666.919173] Dynamic subtest vcs1: SUCCESS (2.013s)
[666.931028] Starting dynamic subtest: vecs0
[668.938969] Dynamic subtest vecs0: SUCCESS (1.989s)
[668.948579] Starting dynamic subtest: ccs0
[670.092891] Dynamic subtest ccs0: SUCCESS (1.181s)
[670.095642] Subtest noreorder-corked: SUCCESS (8.305s)
[670.310407] [128/134] (352s left) kms_psr (pr-cursor-mmap-cpu)
[670.419069] Starting subtest: pr-cursor-mmap-cpu
[670.423547] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[670.517147] [129/134] (351s left) perf (invalid-oa-format-id)
[670.626059] Starting subtest: invalid-oa-format-id
[670.637626] Subtest invalid-oa-format-id: SUCCESS (0.009s)
[670.681469] [130/134] (351s left) gem_eio (in-flight-internal-immediate)
[670.879789] Starting subtest: in-flight-internal-immediate
[671.949496] Subtest in-flight-internal-immediate: SUCCESS (1.070s)
[672.111721] [131/134] (350s left) kms_cursor_edge_walk (256x256-top-edge)
[672.211287] Starting subtest: 256x256-top-edge
[672.213549] Starting dynamic subtest: pipe-A-eDP-1
[675.756370] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.544s)
[675.765975] Starting dynamic subtest: pipe-D-eDP-1
[678.927788] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.170s)
[678.930082] Subtest 256x256-top-edge: SUCCESS (6.717s)
[679.748783] [132/134] (342s left) gem_ctx_persistence (engines-persistence)
[679.815828] Starting subtest: engines-persistence
[679.817721] Starting dynamic subtest: rcs0
[680.632975] Dynamic subtest rcs0: SUCCESS (0.818s)
[680.646903] Starting dynamic subtest: bcs0
[681.442931] Dynamic subtest bcs0: SUCCESS (0.807s)
[681.454726] Starting dynamic subtest: vcs0
[682.223031] Dynamic subtest vcs0: SUCCESS (0.778s)
[682.234842] Starting dynamic subtest: vcs1
[683.060238] Dynamic subtest vcs1: SUCCESS (0.835s)
[683.072939] Starting dynamic subtest: vecs0
[683.873728] Dynamic subtest vecs0: SUCCESS (0.811s)
[683.884331] Starting dynamic subtest: ccs0
[684.615087] Dynamic subtest ccs0: SUCCESS (0.740s)
[684.617636] Subtest engines-persistence: SUCCESS (4.801s)
[684.767641] [133/134] (337s left) api_intel_bb (render-ccs)
[684.819717] Starting subtest: render-ccs
[685.318644] Subtest render-ccs: SUCCESS (0.500s)
[685.431556] [134/134] (337s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[685.545284] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[685.549313] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[685.664066] 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.