[57.738699] Initializing watchdogs
[57.738772]   /dev/watchdog0
[57.753156] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.757370] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.759539] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.762992] [001/134] (960s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[57.888178] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[57.890337] Starting dynamic subtest: pipe-A
[57.973425] Dynamic subtest pipe-A: SUCCESS (0.087s)
[57.982737] Starting dynamic subtest: pipe-B
[59.081687] Dynamic subtest pipe-B: SUCCESS (1.104s)
[59.093737] Starting dynamic subtest: pipe-C
[60.194748] Dynamic subtest pipe-C: SUCCESS (1.110s)
[60.201791] Starting dynamic subtest: pipe-D
[61.323958] Dynamic subtest pipe-D: SUCCESS (1.126s)
[61.326472] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.431s)
[62.500821] [002/134] (955s left) gem_userptr_blits (forbidden-operations)
[62.573328] Starting subtest: forbidden-operations
[62.577401] Subtest forbidden-operations: SKIP (0.000s)
[62.735915] [003/134] (955s left) gem_mmap_gtt (big-bo)
[62.802270] Subtest big-bo: SKIP (0.000s)
[62.867172] [004/134] (955s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[62.972892] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[70.561184] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.583s)
[70.725884] [005/134] (947s left) kms_fence_pin_leak
[70.905167] [006/134] (947s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[71.004934] Starting subtest: x-tiled-16bpp-rotate-180
[72.373187] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.368s)
[72.582206] [007/134] (945s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[72.651084] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[72.712831] [008/134] (945s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[72.799224] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[72.810356] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.010s)
[72.906591] [009/134] (945s left) perf_pmu (busy-check-all)
[72.945810] Starting subtest: busy-check-all
[72.947684] Starting dynamic subtest: rcs0
[73.510706] Dynamic subtest rcs0: SUCCESS (0.566s)
[73.521251] Starting dynamic subtest: bcs0
[74.058552] Dynamic subtest bcs0: SUCCESS (0.547s)
[74.069055] Starting dynamic subtest: vcs0
[75.927720] Dynamic subtest vcs0: SUCCESS (1.866s)
[75.938091] Starting dynamic subtest: vcs1
[77.911197] Dynamic subtest vcs1: SUCCESS (1.982s)
[77.921406] Starting dynamic subtest: vecs0
[79.894040] Dynamic subtest vecs0: SUCCESS (1.982s)
[79.905098] Starting dynamic subtest: ccs0
[80.446893] Dynamic subtest ccs0: SUCCESS (0.553s)
[80.449351] Subtest busy-check-all: SUCCESS (7.501s)
[80.588139] [010/134] (938s left) gem_mmap_wc (coherency)
[80.646333] Subtest coherency: SKIP (0.000s)
[80.702705] [011/134] (937s left) kms_big_fb (yf-tiled-addfb)
[80.801643] Starting subtest: yf-tiled-addfb
[80.806060] Subtest yf-tiled-addfb: SKIP (0.000s)
[80.914441] [012/134] (937s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[81.019344] Starting subtest: extended-modeset-hang-oldfb-with-reset
[81.021644] Starting dynamic subtest: pipe-A
[92.593121] Dynamic subtest pipe-A: SUCCESS (11.571s)
[92.601395] Starting dynamic subtest: pipe-D
[104.864799] Dynamic subtest pipe-D: SUCCESS (12.271s)
[104.867174] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.846s)
[105.693181] [013/134] (913s left) kms_plane_alpha_blend (constant-alpha-min)
[105.804065] Starting subtest: constant-alpha-min
[106.085651] Starting dynamic subtest: pipe-A-eDP-1
[106.831431] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.745s)
[106.841203] Starting dynamic subtest: pipe-D-eDP-1
[108.374701] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.541s)
[108.377055] Subtest constant-alpha-min: SUCCESS (2.571s)
[109.250626] [014/134] (909s left) sysfs_timeslice_duration (duration)
[109.322271] Starting subtest: duration
[109.324586] Starting dynamic subtest: vecs0
[122.804357] Dynamic subtest vecs0: SUCCESS (13.480s)
[122.813938] Starting dynamic subtest: ccs0
[135.971375] Dynamic subtest ccs0: SUCCESS (13.167s)
[135.982570] Starting dynamic subtest: vcs0
[149.811915] Dynamic subtest vcs0: SUCCESS (13.836s)
[149.823546] Starting dynamic subtest: bcs0
[162.933755] Dynamic subtest bcs0: SUCCESS (13.120s)
[162.942284] Starting dynamic subtest: rcs0
[176.117951] Dynamic subtest rcs0: SUCCESS (13.181s)
[176.129673] Starting dynamic subtest: vcs1
[189.812943] Dynamic subtest vcs1: SUCCESS (13.691s)
[189.815750] Subtest duration: SUCCESS (80.484s)
[189.909815] [015/134] (828s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[190.022231] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[193.667034] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.649s)
[194.872040] [016/134] (823s left) kms_cursor_crc (cursor-onscreen-64x64)
[195.056171] Starting subtest: cursor-onscreen-64x64
[195.058539] Starting dynamic subtest: pipe-A-eDP-1
[197.159747] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.101s)
[197.187688] Starting dynamic subtest: pipe-D-eDP-1
[199.904343] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.723s)
[199.906385] Subtest cursor-onscreen-64x64: SUCCESS (4.848s)
[200.740173] [017/134] (818s left) kms_color (ctm-red-to-blue)
[200.839397] Starting subtest: ctm-red-to-blue
[200.841422] Starting dynamic subtest: pipe-A-eDP-1
[201.544234] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.707s)
[201.554424] Starting dynamic subtest: pipe-B-eDP-1
[202.954378] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.408s)
[202.963629] Starting dynamic subtest: pipe-C-eDP-1
[204.272416] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.318s)
[204.280383] Starting dynamic subtest: pipe-D-eDP-1
[205.641367] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.366s)
[205.643285] Subtest ctm-red-to-blue: SUCCESS (4.802s)
[206.461760] [018/134] (812s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[206.535240] Subtest writes-after-reads-uncached: SKIP (0.000s)
[206.607898] [019/134] (812s left) dumb_buffer (invalid-bpp)
[206.660133] Starting subtest: invalid-bpp
[206.662431] Subtest invalid-bpp: SUCCESS (0.000s)
[206.768810] [020/134] (812s left) gem_mmap_gtt (ptrace)
[206.814676] Subtest ptrace: SKIP (0.000s)
[206.868985] [021/134] (812s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[206.997154] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[207.001707] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[207.162703] [022/134] (811s left) gem_lmem_swapping (verify)
[207.205189] Subtest verify: SKIP (0.000s)
[207.250016] [023/134] (811s left) gem_spin_batch (resubmit-new)
[207.310156] Starting subtest: resubmit-new
[207.312174] Starting dynamic subtest: rcs0
[207.314167] Dynamic subtest rcs0: SUCCESS (0.007s)
[207.327126] Starting dynamic subtest: bcs0
[207.329393] Dynamic subtest bcs0: SUCCESS (0.003s)
[207.342481] Starting dynamic subtest: vcs0
[207.344506] Dynamic subtest vcs0: SUCCESS (0.004s)
[207.354042] Starting dynamic subtest: vcs1
[207.355967] Dynamic subtest vcs1: SUCCESS (0.005s)
[207.363660] Starting dynamic subtest: vecs0
[207.365548] Dynamic subtest vecs0: SUCCESS (0.003s)
[207.373119] Starting dynamic subtest: ccs0
[207.374681] Dynamic subtest ccs0: SUCCESS (0.004s)
[207.376258] Subtest resubmit-new: SUCCESS (0.029s)
[208.979415] [024/134] (810s left) kms_cursor_crc (cursor-random-512x512)
[209.265603] Starting subtest: cursor-random-512x512
[209.270156] Subtest cursor-random-512x512: SKIP (0.001s)
[209.450684] [025/134] (809s left) kms_properties (plane-properties-legacy)
[209.544673] Starting subtest: plane-properties-legacy
[209.547274] Starting dynamic subtest: pipe-A-eDP-1
[210.093467] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.545s)
[210.103272] Starting dynamic subtest: pipe-B-eDP-1
[211.408575] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.315s)
[211.417727] Starting dynamic subtest: pipe-C-eDP-1
[212.654182] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.234s)
[212.674947] Starting dynamic subtest: pipe-D-eDP-1
[213.876595] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.230s)
[213.879058] Subtest plane-properties-legacy: SUCCESS (4.329s)
[214.684358] [026/134] (804s left) kms_vrr (flipline)
[214.787197] Starting subtest: flipline
[214.793817] Subtest flipline: SKIP (0.000s)
[214.883874] [027/134] (804s left) gem_exec_params (secure-non-master)
[214.952510] Starting subtest: secure-non-master
[214.956869] Subtest secure-non-master: SKIP (0.000s)
[215.079295] [028/134] (804s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[215.329737] Starting subtest: parallel-dmabuf-import-out-fence
[216.391581] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.065s)
[216.523791] [029/134] (802s left) kms_pm_dc (dc5-dpms-negative)
[217.626854] Starting subtest: dc5-dpms-negative
[217.631351] Subtest dc5-dpms-negative: SKIP (0.000s)
[217.723144] [030/134] (801s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[217.838052] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[217.842399] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[217.973889] [031/134] (801s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[218.081859] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[224.907397] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.827s)
[225.045454] [032/134] (794s left) kms_frontbuffer_tracking (psr-argb161616f-draw-mmap-cpu)
[225.147995] Starting subtest: psr-argb161616f-draw-mmap-cpu
[225.152141] Subtest psr-argb161616f-draw-mmap-cpu: SKIP (0.000s)
[225.273327] [033/134] (794s left) gem_exec_whisper (basic-fds-all)
[225.332454] Starting subtest: basic-fds-all
[236.720760] Subtest basic-fds-all: SUCCESS (11.387s)
[236.927529] [034/134] (782s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[237.033552] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[237.037858] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[237.165111] [035/134] (782s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[237.264631] Starting subtest: psr-rgb565-draw-render
[244.295174] Subtest psr-rgb565-draw-render: SUCCESS (7.033s)
[244.448870] [036/134] (775s left) gem_render_copy_redux (flink)
[244.514301] Starting subtest: flink
[245.321983] Subtest flink: SUCCESS (0.807s)
[245.460381] [037/134] (774s left) gem_mmap_wc (bad-offset)
[245.529683] Subtest bad-offset: SKIP (0.000s)
[245.599960] [038/134] (774s left) gem_pxp (reject-modify-context-protection-off-2)
[245.730163] Starting subtest: reject-modify-context-protection-off-2
[245.732116] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[245.880599] [039/134] (773s left) kms_3d (basic)
[245.928840] Starting subtest: basic
[247.892694] Subtest basic: SUCCESS (1.965s)
[248.391832] [040/134] (771s left) gem_ctx_persistence (smoketest)
[248.457241] Starting subtest: smoketest
[288.820750] Subtest smoketest: SUCCESS (40.361s)
[288.965121] [041/134] (730s left) kms_psr (fbc-pr-suspend)
[289.075839] Starting subtest: fbc-pr-suspend
[289.079920] Subtest fbc-pr-suspend: SKIP (0.000s)
[289.168545] [042/134] (730s left) syncobj_timeline (multi-wait-for-submit-signaled)
[289.233067] Starting subtest: multi-wait-for-submit-signaled
[289.235427] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[289.376364] [043/134] (730s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[289.468733] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[289.470990] Starting dynamic subtest: pipe-A-default-mode
[292.164448] Dynamic subtest pipe-A-default-mode: SUCCESS (2.694s)
[292.166755] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.696s)
[293.013668] [044/134] (726s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[293.096824] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[293.099136] Starting dynamic subtest: pipe-A-default-mode
[295.777441] Dynamic subtest pipe-A-default-mode: SUCCESS (2.679s)
[295.779352] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.681s)
[296.605229] [045/134] (723s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[296.701928] Starting subtest: psr-rgb565-draw-mmap-cpu
[303.304521] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.606s)
[303.439278] [046/134] (716s left) vgem_basic (mmap)
[303.547700] Starting subtest: mmap
[303.553496] Subtest mmap: SUCCESS (0.006s)
[303.626353] [FACT vgem_basic (mmap)] new: kernel.kmod_is_loaded.vgem: true
[303.630539] [047/134] (716s left) gem_userptr_blits (sync-unmap-after-close)
[303.697926] Starting subtest: sync-unmap-after-close
[303.705784] Subtest sync-unmap-after-close: SUCCESS (0.010s)
[303.874082] [048/134] (716s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[304.254786] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[305.058139] [049/134] (715s left) kms_frontbuffer_tracking (basic)
[305.175031] Starting subtest: basic
[308.328110] Subtest basic: SUCCESS (3.157s)
[308.492179] [050/134] (711s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[308.590298] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[315.527990] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (6.939s)
[315.665637] [051/134] (704s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[315.776073] Starting subtest: fbc-rgb101010-draw-blt
[320.332961] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.558s)
[321.521081] [052/134] (698s left) kms_lease (lease-unleased-connector)
[321.620737] Starting subtest: lease-unleased-connector
[321.622941] Starting dynamic subtest: pipe-A-eDP-1
[321.627989] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[321.637252] Starting dynamic subtest: pipe-B-eDP-1
[321.639401] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.008s)
[321.648746] Starting dynamic subtest: pipe-C-eDP-1
[321.650902] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[321.659589] Starting dynamic subtest: pipe-D-eDP-1
[321.661755] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[321.663938] Subtest lease-unleased-connector: SUCCESS (0.034s)
[321.802077] [053/134] (698s left) gem_tiled_partial_pwrite_pread (reads)
[321.857751] Subtest reads: SKIP (0.000s)
[321.936940] [054/134] (698s left) kms_dp_link_training (uhbr-sst)
[322.034920] Starting subtest: uhbr-sst
[322.043655] Subtest uhbr-sst: SKIP (0.000s)
[322.129591] [055/134] (698s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[322.186411] Starting subtest: etime-multi-wait-all-submitted-signaled
[322.288850] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.103s)
[322.390053] [056/134] (698s left) kms_invalid_mode (overflow-vrefresh)
[322.479577] Starting subtest: overflow-vrefresh
[322.481739] Starting dynamic subtest: pipe-A-eDP-1
[322.759813] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.280s)
[322.769564] Starting dynamic subtest: pipe-B-eDP-1
[322.771953] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[322.780390] Starting dynamic subtest: pipe-C-eDP-1
[322.782314] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[322.790230] Starting dynamic subtest: pipe-D-eDP-1
[322.792217] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[322.794124] Subtest overflow-vrefresh: SUCCESS (0.286s)
[323.606935] [057/134] (696s left) kms_pm_rpm (i2c)
[325.133855] Starting subtest: i2c
[330.853259] Subtest i2c: SUCCESS (5.723s)
[330.975467] [058/134] (689s left) gem_exec_balancer (busy)
[331.038132] Starting subtest: busy
[332.884821] Subtest busy: SUCCESS (1.845s)
[333.241583] [059/134] (687s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[338.225259] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[338.229873] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s)
[339.103148] [060/134] (681s left) gen9_exec_parse (batch-without-end)
[339.171525] Subtest batch-without-end: SKIP (0.000s)
[339.267727] [061/134] (681s left) gem_ctx_shared (exec-shared-gtt)
[339.332448] Starting subtest: exec-shared-gtt
[339.334868] Starting dynamic subtest: rcs0
[339.340830] Dynamic subtest rcs0: SUCCESS (0.008s)
[339.351056] Starting dynamic subtest: bcs0
[339.352926] Dynamic subtest bcs0: SUCCESS (0.006s)
[339.362363] Starting dynamic subtest: vcs0
[339.364498] Dynamic subtest vcs0: SUCCESS (0.007s)
[339.373074] Starting dynamic subtest: vcs1
[339.375300] Dynamic subtest vcs1: SUCCESS (0.007s)
[339.383622] Starting dynamic subtest: vecs0
[339.385760] Dynamic subtest vecs0: SUCCESS (0.006s)
[339.393948] Starting dynamic subtest: ccs0
[339.396214] Dynamic subtest ccs0: SUCCESS (0.005s)
[339.398358] Subtest exec-shared-gtt: SUCCESS (0.043s)
[339.585553] [062/134] (681s left) perf (invalid-oa-metric-set-id)
[339.716333] Starting subtest: invalid-oa-metric-set-id
[339.728092] Subtest invalid-oa-metric-set-id: SUCCESS (0.011s)
[339.771078] [063/134] (680s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[339.842377] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[339.844683] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[339.978153] [064/134] (680s left) gem_tiled_pread_pwrite
[340.103196] [065/134] (680s left) i915_pm_rps (thresholds-park)
[340.164952] Starting subtest: thresholds-park
[340.168573] Subtest thresholds-park: SKIP (0.001s)
[340.262349] [066/134] (680s left) gem_ctx_engines (invalid-engines)
[340.323743] Starting subtest: invalid-engines
[340.330910] Subtest invalid-engines: SUCCESS (0.007s)
[340.599600] [067/134] (680s left) vgem_basic (create)
[340.648884] Starting subtest: create
[340.651122] Subtest create: SUCCESS (0.000s)
[340.728258] [068/134] (680s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[340.821963] Starting subtest: fbc-psr2-sprite-mmap-cpu
[340.824237] Starting dynamic subtest: eDP-1
[340.828412] Dynamic subtest eDP-1: SKIP (0.000s)
[340.832600] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[340.920979] [069/134] (680s left) gem_mmap_gtt (big-copy-odd)
[340.989603] Subtest big-copy-odd: SKIP (0.000s)
[341.060894] [070/134] (679s left) gem_exec_reloc (basic-gtt-cpu-active)
[341.133937] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[341.247669] [071/134] (679s left) prime_busy (before-wait)
[341.308594] Starting subtest: before-wait
[341.314115] Starting dynamic subtest: rcs0
[341.359276] Dynamic subtest rcs0: SUCCESS (0.048s)
[341.370227] Starting dynamic subtest: bcs0
[341.437360] Dynamic subtest bcs0: SUCCESS (0.077s)
[341.448023] Starting dynamic subtest: vcs0
[341.477051] Dynamic subtest vcs0: SUCCESS (0.040s)
[341.485965] Starting dynamic subtest: vcs1
[341.518994] Dynamic subtest vcs1: SUCCESS (0.041s)
[341.528309] Starting dynamic subtest: vecs0
[341.560745] Dynamic subtest vecs0: SUCCESS (0.041s)
[341.569911] Starting dynamic subtest: ccs0
[341.600660] Dynamic subtest ccs0: SUCCESS (0.039s)
[341.709687] Subtest before-wait: SUCCESS (0.399s)
[341.809296] [072/134] (679s left) gem_exec_fence (keep-in-fence)
[341.986381] Starting subtest: keep-in-fence
[341.988946] Starting dynamic subtest: rcs0
[342.056836] Dynamic subtest rcs0: SUCCESS (0.071s)
[342.067941] Starting dynamic subtest: bcs0
[342.110628] Dynamic subtest bcs0: SUCCESS (0.052s)
[342.121817] Starting dynamic subtest: vcs0
[343.894349] Dynamic subtest vcs0: SUCCESS (1.780s)
[343.906491] Starting dynamic subtest: vcs1
[345.942945] Dynamic subtest vcs1: SUCCESS (2.047s)
[345.954873] Starting dynamic subtest: vecs0
[347.925945] Dynamic subtest vecs0: SUCCESS (1.981s)
[347.937499] Starting dynamic subtest: ccs0
[348.181844] Dynamic subtest ccs0: SUCCESS (0.254s)
[348.184757] Subtest keep-in-fence: SUCCESS (6.197s)
[350.037956] [073/134] (671s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[350.150076] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[353.871576] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.724s)
[355.100915] [074/134] (666s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[355.210043] Starting subtest: 4-tiled-8bpp-rotate-270
[355.230918] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.020s)
[355.381578] [075/134] (665s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[360.433318] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[360.435524] Starting dynamic subtest: pipe-A-eDP-1
[361.234771] Dynamic subtest pipe-A-eDP-1: SKIP (0.798s)
[361.244771] Starting dynamic subtest: pipe-B-eDP-1
[362.364772] Dynamic subtest pipe-B-eDP-1: SKIP (1.127s)
[362.369476] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.931s)
[363.576560] [076/134] (657s left) gem_ccs (block-multicopy-inplace)
[363.637870] Starting subtest: block-multicopy-inplace
[363.641827] Subtest block-multicopy-inplace: SKIP (0.000s)
[363.751931] [077/134] (657s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[363.851979] Starting subtest: x-tiled-addfb-size-offset-overflow
[363.854330] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[363.993576] [078/134] (657s left) kms_atomic (crtc-invalid-params)
[364.096075] Starting subtest: crtc-invalid-params
[364.098271] Starting dynamic subtest: pipe-A-eDP-1
[364.462323] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.366s)
[364.464493] Subtest crtc-invalid-params: SUCCESS (0.367s)
[365.309698] [079/134] (656s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[365.409981] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[365.412292] Starting dynamic subtest: pipe-A-eDP-1
[365.431759] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s)
[365.442134] Starting dynamic subtest: pipe-B-eDP-1
[365.461642] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[365.473079] Starting dynamic subtest: pipe-C-eDP-1
[365.492710] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.019s)
[365.501925] Starting dynamic subtest: pipe-D-eDP-1
[365.521662] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.019s)
[365.523779] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.083s)
[367.677513] [080/134] (653s left) gem_lmem_swapping (heavy-verify-multi)
[367.716658] Subtest heavy-verify-multi: SKIP (0.000s)
[367.767544] [081/134] (653s left) kms_chamelium_frames (hdmi-crc-fast)
[368.147192] Subtest hdmi-crc-fast: SKIP (0.000s)
[368.952910] [082/134] (652s left) kms_vblank (query-forked-busy-hang)
[369.041989] Starting subtest: query-forked-busy-hang
[369.043866] Starting dynamic subtest: pipe-A-eDP-1
[395.667767] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.626s)
[395.682661] Starting dynamic subtest: pipe-D-eDP-1
[420.686611] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.015s)
[420.688945] Subtest query-forked-busy-hang: SUCCESS (51.645s)
[421.553209] [083/134] (599s left) kms_big_fb (linear-16bpp-rotate-90)
[421.686316] Starting subtest: linear-16bpp-rotate-90
[421.717502] Subtest linear-16bpp-rotate-90: SKIP (0.030s)
[421.923134] [084/134] (599s left) gem_flink_race (flink_close)
[421.961976] Starting subtest: flink_close
[427.063482] Subtest flink_close: SUCCESS (5.100s)
[427.168063] [085/134] (594s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[427.295207] Starting subtest: fbcpsr-modesetfrombusy
[433.515312] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.225s)
[433.701982] [086/134] (587s left) gem_exec_schedule (thriceslice)
[433.790233] Starting subtest: thriceslice
[433.792129] Starting dynamic subtest: rcs0
[433.833157] Dynamic subtest rcs0: SUCCESS (0.051s)
[433.845477] Starting dynamic subtest: bcs0
[433.863586] Dynamic subtest bcs0: SUCCESS (0.029s)
[433.872473] Starting dynamic subtest: vcs0
[433.914413] Dynamic subtest vcs0: SUCCESS (0.050s)
[433.926582] Starting dynamic subtest: vcs1
[433.944398] Dynamic subtest vcs1: SUCCESS (0.028s)
[433.952887] Starting dynamic subtest: vecs0
[433.973477] Dynamic subtest vecs0: SUCCESS (0.028s)
[433.981921] Starting dynamic subtest: ccs0
[434.003387] Dynamic subtest ccs0: SUCCESS (0.029s)
[434.005370] Subtest thriceslice: SUCCESS (0.222s)
[434.323357] [087/134] (587s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[434.424179] Starting subtest: flip-vs-dpms-off-vs-modeset
[434.426465] Starting dynamic subtest: A-eDP1
[438.021673] Dynamic subtest A-eDP1: SUCCESS (3.593s)
[438.033402] Starting dynamic subtest: B-eDP1
[441.231623] Dynamic subtest B-eDP1: SUCCESS (3.210s)
[441.242126] Starting dynamic subtest: C-eDP1
[444.335513] Dynamic subtest C-eDP1: SUCCESS (3.101s)
[444.349652] Starting dynamic subtest: D-eDP1
[447.437291] Dynamic subtest D-eDP1: SUCCESS (3.101s)
[447.439609] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.014s)
[448.264474] [088/134] (573s left) i915_pm_rps (min-max-config-idle)
[448.326390] Starting subtest: min-max-config-idle
[448.330821] Subtest min-max-config-idle: SKIP (0.001s)
[448.457360] [089/134] (573s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[448.553374] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[455.019219] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.467s)
[455.190955] [090/134] (566s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[460.110195] Starting subtest: psr2-overlay-plane-move-continuous-sf
[460.112477] Starting dynamic subtest: pipe-A-eDP-1
[466.831200] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.719s)
[466.841330] Starting dynamic subtest: pipe-B-eDP-1
[473.586720] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.754s)
[473.589082] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.477s)
[474.471451] [091/134] (547s left) kms_concurrent (multi-plane-atomic-lowres)
[474.575174] Starting subtest: multi-plane-atomic-lowres
[474.577028] Starting dynamic subtest: pipe-A-eDP-1
[475.075068] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.497s)
[475.077401] Subtest multi-plane-atomic-lowres: SUCCESS (0.499s)
[475.909293] [092/134] (546s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[476.020533] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[476.024717] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[476.163857] [093/134] (545s left) api_intel_allocator (reopen)
[476.232502] Starting subtest: reopen
[476.234731] Subtest reopen: SUCCESS (0.004s)
[476.390371] [094/134] (545s left) kms_flip (dpms-vs-vblank-race)
[476.483575] Starting subtest: dpms-vs-vblank-race
[476.485740] Starting dynamic subtest: A-eDP1
[480.359294] Dynamic subtest A-eDP1: SUCCESS (3.872s)
[480.369600] Starting dynamic subtest: B-eDP1
[484.986139] Dynamic subtest B-eDP1: SUCCESS (4.628s)
[484.996281] Starting dynamic subtest: C-eDP1
[489.584309] Dynamic subtest C-eDP1: SUCCESS (4.596s)
[489.594073] Starting dynamic subtest: D-eDP1
[494.233925] Dynamic subtest D-eDP1: SUCCESS (4.649s)
[494.236342] Subtest dpms-vs-vblank-race: SUCCESS (17.753s)
[495.128136] [095/134] (526s left) syncobj_timeline (single-wait-all-available-signaled)
[495.212575] Starting subtest: single-wait-all-available-signaled
[495.214932] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[495.347615] [096/134] (526s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[495.441427] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[495.443313] Starting dynamic subtest: pipe-A-eDP-1
[496.742369] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.300s)
[497.032492] Starting dynamic subtest: pipe-B-eDP-1
[498.079051] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.054s)
[498.343416] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.903s)
[499.221454] [097/134] (522s left) gem_exec_params (rs-invalid)
[499.295031] Starting subtest: rs-invalid
[499.297342] Subtest rs-invalid: SUCCESS (0.003s)
[499.451672] [098/134] (522s left) kms_scaling_modes (scaling-mode-full-aspect)
[499.550182] Starting subtest: scaling-mode-full-aspect
[499.551986] Starting dynamic subtest: pipe-A-eDP-1
[499.652737] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.103s)
[499.665368] Starting dynamic subtest: pipe-B-eDP-1
[500.810427] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.154s)
[500.820368] Starting dynamic subtest: pipe-C-eDP-1
[501.935042] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.123s)
[501.947282] Starting dynamic subtest: pipe-D-eDP-1
[503.057780] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.120s)
[503.060070] Subtest scaling-mode-full-aspect: SUCCESS (3.510s)
[504.251345] [099/134] (517s left) kms_plane (plane-panning-top-left)
[504.357018] Starting subtest: plane-panning-top-left
[504.359368] Starting dynamic subtest: pipe-A
[505.978778] Dynamic subtest pipe-A: SUCCESS (1.621s)
[505.988206] Starting dynamic subtest: pipe-B
[508.345061] Dynamic subtest pipe-B: SUCCESS (2.364s)
[508.347300] Subtest plane-panning-top-left: SUCCESS (3.988s)
[509.187625] [100/134] (513s left) kms_psr (psr2-sprite-mmap-cpu)
[509.285671] Starting subtest: psr2-sprite-mmap-cpu
[509.287771] Starting dynamic subtest: eDP-1
[511.055452] Dynamic subtest eDP-1: SUCCESS (1.769s)
[511.057816] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.769s)
[511.964927] [101/134] (510s left) gem_exec_params (rel-constants-invalid-ring)
[512.026309] Starting subtest: rel-constants-invalid-ring
[512.028526] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[512.158270] [102/134] (510s left) i915_query (query-garbage)
[512.207088] Starting subtest: query-garbage
[512.208978] Subtest query-garbage: SUCCESS (0.000s)
[512.332781] [103/134] (510s left) kms_psr (psr-cursor-mmap-cpu)
[512.429770] Starting subtest: psr-cursor-mmap-cpu
[512.432045] Starting dynamic subtest: eDP-1
[514.114139] Dynamic subtest eDP-1: SUCCESS (1.684s)
[514.116530] Subtest psr-cursor-mmap-cpu: SUCCESS (1.685s)
[515.011413] [104/134] (507s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[515.105460] Starting subtest: y-tiled-16bpp-rotate-90
[515.110392] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[515.233871] [105/134] (507s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[515.323156] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[515.327319] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[516.450576] [106/134] (506s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[516.574978] Starting subtest: flip-vs-cursor-legacy
[523.629825] Subtest flip-vs-cursor-legacy: SUCCESS (7.057s)
[524.480189] [107/134] (498s left) kms_frontbuffer_tracking (fbcpsr-argb161616f-draw-blt)
[524.587465] Starting subtest: fbcpsr-argb161616f-draw-blt
[524.591870] Subtest fbcpsr-argb161616f-draw-blt: SKIP (0.000s)
[524.752203] [108/134] (497s left) kms_flip (flip-vs-fences)
[524.845421] Starting subtest: flip-vs-fences
[524.849668] Subtest flip-vs-fences: SKIP (0.000s)
[524.982692] [109/134] (497s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[525.043667] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[525.127145] [110/134] (497s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[525.223121] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[525.225394] Starting dynamic subtest: pipe-A-eDP-1
[526.036856] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.806s)
[526.047246] Starting dynamic subtest: pipe-B-eDP-1
[527.614032] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.574s)
[527.624442] Starting dynamic subtest: pipe-C-eDP-1
[529.068522] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.454s)
[529.082597] Starting dynamic subtest: pipe-D-eDP-1
[530.595053] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.527s)
[530.597324] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.366s)
[531.838968] [111/134] (490s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[531.949459] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[531.953866] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[532.077667] [112/134] (490s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[532.176811] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[532.179061] Starting dynamic subtest: pipe-A-eDP-1
[532.891088] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.707s)
[532.900309] Starting dynamic subtest: pipe-B-eDP-1
[534.701366] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.809s)
[534.712089] Starting dynamic subtest: pipe-C-eDP-1
[536.518133] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.816s)
[536.526656] Starting dynamic subtest: pipe-D-eDP-1
[538.255309] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.735s)
[538.257343] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.072s)
[539.425553] [113/134] (483s left) i915_drm_fdinfo (memory-info-shared)
[539.466364] Starting subtest: memory-info-shared
[539.468591] Starting dynamic subtest: smem0
[539.543661] Dynamic subtest smem0: SUCCESS (0.076s)
[539.546140] Subtest memory-info-shared: SUCCESS (0.077s)
[539.641265] [114/134] (483s left) gem_exec_flush (basic-wb-set-default)
[539.715646] Starting subtest: basic-wb-set-default
[545.162832] Subtest basic-wb-set-default: SUCCESS (5.450s)
[545.377132] [115/134] (477s left) sysfs_timeslice_duration (timeout)
[545.445225] Starting subtest: timeout
[545.447082] Starting dynamic subtest: vecs0
[554.918057] Dynamic subtest vecs0: SUCCESS (9.471s)
[554.929891] Starting dynamic subtest: ccs0
[556.284505] Dynamic subtest ccs0: SUCCESS (1.366s)
[556.295651] Starting dynamic subtest: vcs0
[565.929584] Dynamic subtest vcs0: SUCCESS (9.640s)
[565.941919] Starting dynamic subtest: bcs0
[566.701531] Dynamic subtest bcs0: SUCCESS (0.772s)
[566.715310] Starting dynamic subtest: rcs0
[568.018873] Dynamic subtest rcs0: SUCCESS (1.316s)
[568.030098] Starting dynamic subtest: vcs1
[577.894812] Dynamic subtest vcs1: SUCCESS (9.871s)
[577.897320] Subtest timeout: SUCCESS (32.449s)
[577.990062] [116/134] (445s left) sriov_basic (enable-vfs-bind-unbind-each)
[578.046860] Starting subtest: enable-vfs-bind-unbind-each
[578.049343] Starting dynamic subtest: numvfs-1
[578.127757] Dynamic subtest numvfs-1: FAIL (0.029s)
[578.138303] Starting dynamic subtest: numvfs-2
[578.212045] Dynamic subtest numvfs-2: FAIL (0.003s)
[578.222238] Starting dynamic subtest: numvfs-3
[578.295371] Dynamic subtest numvfs-3: FAIL (0.003s)
[578.305476] Starting dynamic subtest: numvfs-4
[578.378244] Dynamic subtest numvfs-4: FAIL (0.003s)
[578.388417] Starting dynamic subtest: numvfs-5
[578.460482] Dynamic subtest numvfs-5: FAIL (0.003s)
[578.470744] Starting dynamic subtest: numvfs-6
[578.543161] Dynamic subtest numvfs-6: FAIL (0.003s)
[578.553891] Starting dynamic subtest: numvfs-7
[578.626193] Dynamic subtest numvfs-7: FAIL (0.004s)
[578.636219] Starting dynamic subtest: numvfs-random
[578.708079] Dynamic subtest numvfs-random: FAIL (0.003s)
[578.710429] Subtest enable-vfs-bind-unbind-each: FAIL (0.058s)
[578.755642] [117/134] (444s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[578.854738] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[578.859165] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[579.978977] [118/134] (443s left) kms_getfb (getfb-handle-not-fb)
[580.080090] Starting subtest: getfb-handle-not-fb
[580.082350] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[580.239921] [119/134] (442s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[580.309794] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[580.314327] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[580.520031] [120/134] (442s left) gem_workarounds (reset-context)
[580.592625] Starting subtest: reset-context
[580.750137] Subtest reset-context: SUCCESS (0.159s)
[580.899441] [121/134] (442s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[581.006523] Starting subtest: psr-farfromfence-mmap-gtt
[581.010594] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[581.148277] [122/134] (442s left) gem_wait (write-busy)
[581.219286] Starting subtest: write-busy
[581.221193] Starting dynamic subtest: all-engines
[581.848110] Dynamic subtest all-engines: SUCCESS (0.631s)
[581.864875] Starting dynamic subtest: rcs0
[582.402344] Dynamic subtest rcs0: SUCCESS (0.552s)
[582.418931] Starting dynamic subtest: bcs0
[582.951844] Dynamic subtest bcs0: SUCCESS (0.548s)
[582.967603] Starting dynamic subtest: vcs0
[584.917688] Dynamic subtest vcs0: SUCCESS (1.963s)
[584.933856] Starting dynamic subtest: vcs1
[586.901279] Dynamic subtest vcs1: SUCCESS (1.981s)
[586.917416] Starting dynamic subtest: vecs0
[588.884717] Dynamic subtest vecs0: SUCCESS (1.981s)
[588.900932] Starting dynamic subtest: ccs0
[589.435084] Dynamic subtest ccs0: SUCCESS (0.549s)
[589.437480] Subtest write-busy: SUCCESS (8.219s)
[589.656151] [123/134] (433s left) i915_hangman (detector)
[589.728207] Starting subtest: detector
[589.730092] Starting dynamic subtest: rcs0
[600.884293] Dynamic subtest rcs0: SUCCESS (11.155s)
[600.895904] Starting dynamic subtest: bcs0
[612.853066] Dynamic subtest bcs0: SUCCESS (11.965s)
[612.865304] Starting dynamic subtest: vcs0
[623.801410] Dynamic subtest vcs0: SUCCESS (10.939s)
[623.816601] Starting dynamic subtest: vcs1
[634.803513] Dynamic subtest vcs1: SUCCESS (11.005s)
[634.815285] Starting dynamic subtest: vecs0
[645.812472] Dynamic subtest vecs0: SUCCESS (11.005s)
[645.824968] Starting dynamic subtest: ccs0
[655.859507] Dynamic subtest ccs0: SUCCESS (10.044s)
[655.862130] Subtest detector: SUCCESS (66.130s)
[655.963632] [124/134] (367s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[656.068024] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[656.072048] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[656.196719] [125/134] (367s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[656.330461] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[656.334764] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[656.503362] [126/134] (366s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[656.571843] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[656.647511] [127/134] (366s left) gem_exec_schedule (noreorder-corked)
[656.821613] Starting subtest: noreorder-corked
[656.824221] Starting dynamic subtest: rcs0
[657.971354] Dynamic subtest rcs0: SUCCESS (1.150s)
[657.984168] Starting dynamic subtest: vcs0
[659.931302] Dynamic subtest vcs0: SUCCESS (1.957s)
[659.943902] Starting dynamic subtest: vcs1
[661.935448] Dynamic subtest vcs1: SUCCESS (2.002s)
[661.947889] Starting dynamic subtest: vecs0
[663.931730] Dynamic subtest vecs0: SUCCESS (1.993s)
[663.944500] Starting dynamic subtest: ccs0
[665.105984] Dynamic subtest ccs0: SUCCESS (1.174s)
[665.108753] Subtest noreorder-corked: SUCCESS (8.287s)
[665.319731] [128/134] (358s left) kms_psr (pr-cursor-mmap-cpu)
[665.415694] Starting subtest: pr-cursor-mmap-cpu
[665.419711] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[665.548073] [129/134] (358s left) perf (invalid-oa-format-id)
[665.664059] Starting subtest: invalid-oa-format-id
[665.674323] Subtest invalid-oa-format-id: SUCCESS (0.008s)
[665.716407] [130/134] (357s left) gem_eio (in-flight-internal-immediate)
[665.910299] Starting subtest: in-flight-internal-immediate
[666.961900] Subtest in-flight-internal-immediate: SUCCESS (1.048s)
[667.128355] [131/134] (356s left) kms_cursor_edge_walk (256x256-top-edge)
[667.231200] Starting subtest: 256x256-top-edge
[667.233516] Starting dynamic subtest: pipe-A-eDP-1
[670.701316] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.470s)
[670.711738] Starting dynamic subtest: pipe-D-eDP-1
[673.821109] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.118s)
[673.823425] Subtest 256x256-top-edge: SUCCESS (6.592s)
[674.658371] [132/134] (349s left) gem_ctx_persistence (engines-persistence)
[674.722965] Starting subtest: engines-persistence
[674.725379] Starting dynamic subtest: rcs0
[675.567966] Dynamic subtest rcs0: SUCCESS (0.844s)
[675.580030] Starting dynamic subtest: bcs0
[676.404886] Dynamic subtest bcs0: SUCCESS (0.834s)
[676.418118] Starting dynamic subtest: vcs0
[677.178829] Dynamic subtest vcs0: SUCCESS (0.772s)
[677.190709] Starting dynamic subtest: vcs1
[677.989725] Dynamic subtest vcs1: SUCCESS (0.809s)
[678.001845] Starting dynamic subtest: vecs0
[678.763890] Dynamic subtest vecs0: SUCCESS (0.772s)
[678.776750] Starting dynamic subtest: ccs0
[679.605807] Dynamic subtest ccs0: SUCCESS (0.839s)
[679.608605] Subtest engines-persistence: SUCCESS (4.884s)
[679.710649] [133/134] (344s left) api_intel_bb (render-ccs)
[679.768156] Starting subtest: render-ccs
[680.169882] Subtest render-ccs: SUCCESS (0.403s)
[680.295374] [134/134] (343s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[680.395078] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[680.398940] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[680.511116] 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.