[56.694377] Initializing watchdogs
[56.694426]   /dev/watchdog0
[56.709173] [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.713572] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.715895] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.719184] [001/134] (960s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[56.846165] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[56.848462] Starting dynamic subtest: pipe-A
[56.935675] Dynamic subtest pipe-A: SUCCESS (0.089s)
[56.955089] Starting dynamic subtest: pipe-B
[58.043795] Dynamic subtest pipe-B: SUCCESS (1.112s)
[58.062452] Starting dynamic subtest: pipe-C
[59.151813] Dynamic subtest pipe-C: SUCCESS (1.111s)
[59.171870] Starting dynamic subtest: pipe-D
[60.279581] Dynamic subtest pipe-D: SUCCESS (1.131s)
[60.281757] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.446s)
[61.457383] [002/134] (955s left) gem_userptr_blits (forbidden-operations)
[61.525880] Starting subtest: forbidden-operations
[61.529800] Subtest forbidden-operations: SKIP (0.000s)
[61.691372] [003/134] (955s left) gem_mmap_gtt (big-bo)
[61.747948] Subtest big-bo: SKIP (0.000s)
[61.812658] [004/134] (955s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[61.916900] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[69.607837] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.704s)
[69.768740] [005/134] (947s left) kms_fence_pin_leak
[69.934858] [006/134] (947s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[70.041455] Starting subtest: x-tiled-16bpp-rotate-180
[71.438041] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.399s)
[71.582984] [007/134] (945s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[71.644831] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[71.713313] [008/134] (945s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[71.816762] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[71.828761] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s)
[71.961058] [009/134] (945s left) perf_pmu (busy-check-all)
[72.003498] Starting subtest: busy-check-all
[72.005484] Starting dynamic subtest: rcs0
[72.574223] Dynamic subtest rcs0: SUCCESS (0.570s)
[72.585184] Starting dynamic subtest: bcs0
[73.121622] Dynamic subtest bcs0: SUCCESS (0.547s)
[73.132841] Starting dynamic subtest: vcs0
[74.906824] Dynamic subtest vcs0: SUCCESS (1.783s)
[74.918701] Starting dynamic subtest: vcs1
[76.889411] Dynamic subtest vcs1: SUCCESS (1.982s)
[76.900033] Starting dynamic subtest: vecs0
[78.937484] Dynamic subtest vecs0: SUCCESS (2.048s)
[78.948870] Starting dynamic subtest: ccs0
[79.493064] Dynamic subtest ccs0: SUCCESS (0.556s)
[79.495768] Subtest busy-check-all: SUCCESS (7.492s)
[79.642263] [010/134] (937s left) gem_mmap_wc (coherency)
[79.704376] Subtest coherency: SKIP (0.000s)
[79.772239] [011/134] (937s left) kms_big_fb (yf-tiled-addfb)
[79.875490] Starting subtest: yf-tiled-addfb
[79.879687] Subtest yf-tiled-addfb: SKIP (0.000s)
[79.994831] [012/134] (937s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[80.093020] Starting subtest: extended-modeset-hang-oldfb-with-reset
[80.095444] Starting dynamic subtest: pipe-A
[91.631855] Dynamic subtest pipe-A: SUCCESS (11.542s)
[91.643381] Starting dynamic subtest: pipe-D
[103.890347] Dynamic subtest pipe-D: SUCCESS (12.257s)
[103.892671] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.804s)
[104.708228] [013/134] (912s left) kms_plane_alpha_blend (constant-alpha-min)
[104.802146] Starting subtest: constant-alpha-min
[105.083441] Starting dynamic subtest: pipe-A-eDP-1
[105.784854] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.699s)
[105.794745] Starting dynamic subtest: pipe-D-eDP-1
[107.305076] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.520s)
[107.307265] Subtest constant-alpha-min: SUCCESS (2.504s)
[108.187373] [014/134] (909s left) sysfs_timeslice_duration (duration)
[108.256089] Starting subtest: duration
[108.258383] Starting dynamic subtest: vecs0
[121.851451] Dynamic subtest vecs0: SUCCESS (13.594s)
[121.862860] Starting dynamic subtest: ccs0
[135.015352] Dynamic subtest ccs0: SUCCESS (13.164s)
[135.027505] Starting dynamic subtest: vcs0
[148.856231] Dynamic subtest vcs0: SUCCESS (13.838s)
[148.868028] Starting dynamic subtest: bcs0
[162.024307] Dynamic subtest bcs0: SUCCESS (13.167s)
[162.036530] Starting dynamic subtest: rcs0
[175.194396] Dynamic subtest rcs0: SUCCESS (13.168s)
[175.205998] Starting dynamic subtest: vcs1
[188.855218] Dynamic subtest vcs1: SUCCESS (13.658s)
[188.857974] Subtest duration: SUCCESS (80.597s)
[188.965495] [015/134] (828s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[189.076500] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[192.660993] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.590s)
[193.869144] [016/134] (823s left) kms_cursor_crc (cursor-onscreen-64x64)
[194.064636] Starting subtest: cursor-onscreen-64x64
[194.069355] Starting dynamic subtest: pipe-A-eDP-1
[196.182735] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.113s)
[196.212388] Starting dynamic subtest: pipe-D-eDP-1
[198.920409] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.716s)
[198.922633] Subtest cursor-onscreen-64x64: SUCCESS (4.854s)
[199.745879] [017/134] (818s left) kms_color (ctm-red-to-blue)
[199.847304] Starting subtest: ctm-red-to-blue
[199.849453] Starting dynamic subtest: pipe-A-eDP-1
[200.557841] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[200.567707] Starting dynamic subtest: pipe-B-eDP-1
[201.937417] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.381s)
[201.946994] Starting dynamic subtest: pipe-C-eDP-1
[203.303641] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.365s)
[203.313104] Starting dynamic subtest: pipe-D-eDP-1
[204.656457] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.353s)
[204.658881] Subtest ctm-red-to-blue: SUCCESS (4.810s)
[205.555253] [018/134] (812s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[205.636784] Subtest writes-after-reads-uncached: SKIP (0.000s)
[205.721188] [019/134] (812s left) dumb_buffer (invalid-bpp)
[205.770311] Starting subtest: invalid-bpp
[205.772316] Subtest invalid-bpp: SUCCESS (0.000s)
[205.887931] [020/134] (812s left) gem_mmap_gtt (ptrace)
[205.944628] Subtest ptrace: SKIP (0.000s)
[206.009798] [021/134] (811s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[206.136259] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[206.140777] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[206.302654] [022/134] (811s left) gem_lmem_swapping (verify)
[206.343547] Subtest verify: SKIP (0.000s)
[206.390464] [023/134] (811s left) gem_spin_batch (resubmit-new)
[206.448335] Starting subtest: resubmit-new
[206.450581] Starting dynamic subtest: rcs0
[206.454885] Dynamic subtest rcs0: SUCCESS (0.006s)
[206.465762] Starting dynamic subtest: bcs0
[206.468516] Dynamic subtest bcs0: SUCCESS (0.004s)
[206.486726] Starting dynamic subtest: vcs0
[206.488349] Dynamic subtest vcs0: SUCCESS (0.005s)
[206.496763] Starting dynamic subtest: vcs1
[206.498503] Dynamic subtest vcs1: SUCCESS (0.004s)
[206.508836] Starting dynamic subtest: vecs0
[206.510438] Dynamic subtest vecs0: SUCCESS (0.005s)
[206.518262] Starting dynamic subtest: ccs0
[206.519835] Dynamic subtest ccs0: SUCCESS (0.003s)
[206.521526] Subtest resubmit-new: SUCCESS (0.030s)
[207.960477] [024/134] (810s left) kms_cursor_crc (cursor-random-512x512)
[208.233751] Starting subtest: cursor-random-512x512
[208.237448] Subtest cursor-random-512x512: SKIP (0.001s)
[208.432289] [025/134] (809s left) kms_properties (plane-properties-legacy)
[208.537972] Starting subtest: plane-properties-legacy
[208.540265] Starting dynamic subtest: pipe-A-eDP-1
[209.094990] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.557s)
[209.107156] Starting dynamic subtest: pipe-B-eDP-1
[210.401666] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.306s)
[210.411449] Starting dynamic subtest: pipe-C-eDP-1
[211.644318] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.241s)
[211.654783] Starting dynamic subtest: pipe-D-eDP-1
[212.883271] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.238s)
[212.885542] Subtest plane-properties-legacy: SUCCESS (4.345s)
[213.712286] [026/134] (804s left) kms_vrr (flipline)
[213.826233] Starting subtest: flipline
[213.832809] Subtest flipline: SKIP (0.000s)
[213.919909] [027/134] (804s left) gem_exec_params (secure-non-master)
[213.981647] Starting subtest: secure-non-master
[213.985911] Subtest secure-non-master: SKIP (0.000s)
[214.107780] [028/134] (804s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[214.368195] Starting subtest: parallel-dmabuf-import-out-fence
[215.464386] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.096s)
[215.606651] [029/134] (802s left) kms_pm_dc (dc5-dpms-negative)
[216.718053] Starting subtest: dc5-dpms-negative
[216.722456] Subtest dc5-dpms-negative: SKIP (0.000s)
[216.816034] [030/134] (801s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[216.916684] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[216.920707] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[217.054338] [031/134] (801s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[217.156412] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[224.057475] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.903s)
[224.207109] [032/134] (794s left) kms_frontbuffer_tracking (psr-argb161616f-draw-mmap-cpu)
[224.321598] Starting subtest: psr-argb161616f-draw-mmap-cpu
[224.326047] Subtest psr-argb161616f-draw-mmap-cpu: SKIP (0.000s)
[224.466665] [033/134] (794s left) gem_exec_whisper (basic-fds-all)
[224.529325] Starting subtest: basic-fds-all
[235.938402] Subtest basic-fds-all: SUCCESS (11.407s)
[236.151208] [034/134] (782s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[236.265328] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[236.269337] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[236.399938] [035/134] (782s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[236.507595] Starting subtest: psr-rgb565-draw-render
[243.588831] Subtest psr-rgb565-draw-render: SUCCESS (7.083s)
[243.735408] [036/134] (774s left) gem_render_copy_redux (flink)
[243.807231] Starting subtest: flink
[244.589871] Subtest flink: SUCCESS (0.786s)
[244.764916] [037/134] (773s left) gem_mmap_wc (bad-offset)
[244.833606] Subtest bad-offset: SKIP (0.000s)
[244.902384] [038/134] (773s left) gem_pxp (reject-modify-context-protection-off-2)
[245.037267] Starting subtest: reject-modify-context-protection-off-2
[245.039265] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[245.162814] [039/134] (773s left) kms_3d (basic)
[245.216669] Starting subtest: basic
[247.304763] Subtest basic: SUCCESS (2.090s)
[247.830556] [040/134] (770s left) gem_ctx_persistence (smoketest)
[247.909334] Starting subtest: smoketest
[287.082304] Subtest smoketest: SUCCESS (39.170s)
[287.188962] [041/134] (731s left) kms_psr (fbc-pr-suspend)
[287.298069] Starting subtest: fbc-pr-suspend
[287.302435] Subtest fbc-pr-suspend: SKIP (0.000s)
[287.395914] [042/134] (731s left) syncobj_timeline (multi-wait-for-submit-signaled)
[287.461581] Starting subtest: multi-wait-for-submit-signaled
[287.464095] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[287.599788] [043/134] (731s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[287.701929] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[287.704258] Starting dynamic subtest: pipe-A-default-mode
[290.412185] Dynamic subtest pipe-A-default-mode: SUCCESS (2.709s)
[290.414416] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.711s)
[291.262272] [044/134] (727s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[291.356960] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[291.359164] Starting dynamic subtest: pipe-A-default-mode
[294.041555] Dynamic subtest pipe-A-default-mode: SUCCESS (2.683s)
[294.043474] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.684s)
[294.864493] [045/134] (724s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[294.970387] Starting subtest: psr-rgb565-draw-mmap-cpu
[301.715129] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.746s)
[301.853360] [046/134] (717s left) vgem_basic (mmap)
[301.980599] Starting subtest: mmap
[301.986491] Subtest mmap: SUCCESS (0.007s)
[302.058934] [FACT vgem_basic (mmap)] new: kernel.kmod_is_loaded.vgem: true
[302.062221] [047/134] (716s left) gem_userptr_blits (sync-unmap-after-close)
[302.128599] Starting subtest: sync-unmap-after-close
[302.138591] Subtest sync-unmap-after-close: SUCCESS (0.010s)
[302.306981] [048/134] (716s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[302.693273] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[303.526197] [049/134] (715s left) kms_frontbuffer_tracking (basic)
[303.639234] Starting subtest: basic
[307.038516] Subtest basic: SUCCESS (3.402s)
[307.212291] [050/134] (711s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[307.316393] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[314.285391] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (6.970s)
[314.442514] [051/134] (704s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[314.564228] Starting subtest: fbc-rgb101010-draw-blt
[319.112228] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.550s)
[320.273736] [052/134] (698s left) kms_lease (lease-unleased-connector)
[320.377137] Starting subtest: lease-unleased-connector
[320.379352] Starting dynamic subtest: pipe-A-eDP-1
[320.384442] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[320.393986] Starting dynamic subtest: pipe-B-eDP-1
[320.396229] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[320.405829] Starting dynamic subtest: pipe-C-eDP-1
[320.408230] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s)
[320.417195] Starting dynamic subtest: pipe-D-eDP-1
[320.418981] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s)
[320.420797] Subtest lease-unleased-connector: SUCCESS (0.034s)
[320.556425] [053/134] (698s left) gem_tiled_partial_pwrite_pread (reads)
[320.624242] Subtest reads: SKIP (0.000s)
[320.717293] [054/134] (698s left) kms_dp_link_training (uhbr-sst)
[320.817057] Starting subtest: uhbr-sst
[320.825787] Subtest uhbr-sst: SKIP (0.000s)
[320.912716] [055/134] (698s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[320.973400] Starting subtest: etime-multi-wait-all-submitted-signaled
[321.078445] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.104s)
[321.178909] [056/134] (698s left) kms_invalid_mode (overflow-vrefresh)
[321.282170] Starting subtest: overflow-vrefresh
[321.284326] Starting dynamic subtest: pipe-A-eDP-1
[321.570928] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[321.581630] Starting dynamic subtest: pipe-B-eDP-1
[321.583584] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[321.592078] Starting dynamic subtest: pipe-C-eDP-1
[321.594034] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[321.603196] Starting dynamic subtest: pipe-D-eDP-1
[321.605628] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[321.607957] Subtest overflow-vrefresh: SUCCESS (0.297s)
[322.475082] [057/134] (696s left) kms_pm_rpm (i2c)
[324.008145] Starting subtest: i2c
[329.380734] Subtest i2c: SUCCESS (5.375s)
[329.527218] [058/134] (689s left) gem_exec_balancer (busy)
[329.601700] Starting subtest: busy
[330.913030] Subtest busy: SUCCESS (1.313s)
[331.270115] [059/134] (688s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[336.243538] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[336.248036] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s)
[337.129065] [060/134] (682s left) gen9_exec_parse (batch-without-end)
[337.191268] Subtest batch-without-end: SKIP (0.000s)
[337.279692] [061/134] (682s left) gem_ctx_shared (exec-shared-gtt)
[337.354115] Starting subtest: exec-shared-gtt
[337.355977] Starting dynamic subtest: rcs0
[337.358631] Dynamic subtest rcs0: SUCCESS (0.007s)
[337.368121] Starting dynamic subtest: bcs0
[337.370224] Dynamic subtest bcs0: SUCCESS (0.005s)
[337.379429] Starting dynamic subtest: vcs0
[337.381644] Dynamic subtest vcs0: SUCCESS (0.006s)
[337.390565] Starting dynamic subtest: vcs1
[337.392813] Dynamic subtest vcs1: SUCCESS (0.007s)
[337.401694] Starting dynamic subtest: vecs0
[337.403790] Dynamic subtest vecs0: SUCCESS (0.005s)
[337.412765] Starting dynamic subtest: ccs0
[337.414898] Dynamic subtest ccs0: SUCCESS (0.006s)
[337.417071] Subtest exec-shared-gtt: SUCCESS (0.041s)
[337.602654] [062/134] (682s left) perf (invalid-oa-metric-set-id)
[337.763758] Starting subtest: invalid-oa-metric-set-id
[337.774953] Subtest invalid-oa-metric-set-id: SUCCESS (0.011s)
[337.815373] [063/134] (681s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[337.874074] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[337.876585] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[337.989935] [064/134] (681s left) gem_tiled_pread_pwrite
[338.116311] [065/134] (681s left) i915_pm_rps (thresholds-park)
[338.185671] Starting subtest: thresholds-park
[338.189734] Subtest thresholds-park: SKIP (0.001s)
[338.320786] [066/134] (681s left) gem_ctx_engines (invalid-engines)
[338.383634] Starting subtest: invalid-engines
[338.392307] Subtest invalid-engines: SUCCESS (0.009s)
[338.642943] [067/134] (681s left) vgem_basic (create)
[338.683729] Starting subtest: create
[338.685863] Subtest create: SUCCESS (0.000s)
[338.768060] [068/134] (681s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[338.859135] Starting subtest: fbc-psr2-sprite-mmap-cpu
[338.861421] Starting dynamic subtest: eDP-1
[338.865798] Dynamic subtest eDP-1: SKIP (0.000s)
[338.870717] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[338.963959] [069/134] (681s left) gem_mmap_gtt (big-copy-odd)
[339.022886] Subtest big-copy-odd: SKIP (0.000s)
[339.091838] [070/134] (680s left) gem_exec_reloc (basic-gtt-cpu-active)
[339.146602] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[339.223620] [071/134] (680s left) prime_busy (before-wait)
[339.285767] Starting subtest: before-wait
[339.288051] Starting dynamic subtest: rcs0
[339.332708] Dynamic subtest rcs0: SUCCESS (0.046s)
[339.343779] Starting dynamic subtest: bcs0
[339.409730] Dynamic subtest bcs0: SUCCESS (0.076s)
[339.420600] Starting dynamic subtest: vcs0
[339.450177] Dynamic subtest vcs0: SUCCESS (0.040s)
[339.459715] Starting dynamic subtest: vcs1
[339.490472] Dynamic subtest vcs1: SUCCESS (0.040s)
[339.500048] Starting dynamic subtest: vecs0
[339.531061] Dynamic subtest vecs0: SUCCESS (0.040s)
[339.540359] Starting dynamic subtest: ccs0
[339.570822] Dynamic subtest ccs0: SUCCESS (0.039s)
[339.679612] Subtest before-wait: SUCCESS (0.395s)
[339.779979] [072/134] (680s left) gem_exec_fence (keep-in-fence)
[339.965065] Starting subtest: keep-in-fence
[339.967780] Starting dynamic subtest: rcs0
[340.039948] Dynamic subtest rcs0: SUCCESS (0.074s)
[340.053568] Starting dynamic subtest: bcs0
[340.094358] Dynamic subtest bcs0: SUCCESS (0.052s)
[340.106699] Starting dynamic subtest: vcs0
[341.914381] Dynamic subtest vcs0: SUCCESS (1.816s)
[341.926816] Starting dynamic subtest: vcs1
[343.898292] Dynamic subtest vcs1: SUCCESS (1.982s)
[343.910589] Starting dynamic subtest: vecs0
[345.882296] Dynamic subtest vecs0: SUCCESS (1.981s)
[345.894796] Starting dynamic subtest: ccs0
[346.119919] Dynamic subtest ccs0: SUCCESS (0.236s)
[346.122824] Subtest keep-in-fence: SUCCESS (6.155s)
[348.062063] [073/134] (672s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[348.177348] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[351.935071] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.761s)
[353.129151] [074/134] (667s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[353.249290] Starting subtest: 4-tiled-8bpp-rotate-270
[353.271224] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.022s)
[353.448639] [075/134] (666s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[358.491926] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[358.494344] Starting dynamic subtest: pipe-A-eDP-1
[359.279505] Dynamic subtest pipe-A-eDP-1: SKIP (0.784s)
[359.289918] Starting dynamic subtest: pipe-B-eDP-1
[360.403479] Dynamic subtest pipe-B-eDP-1: SKIP (1.123s)
[360.408082] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.911s)
[361.613738] [076/134] (658s left) gem_ccs (block-multicopy-inplace)
[361.677919] Starting subtest: block-multicopy-inplace
[361.682048] Subtest block-multicopy-inplace: SKIP (0.000s)
[361.809048] [077/134] (658s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[361.931231] Starting subtest: x-tiled-addfb-size-offset-overflow
[361.933619] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[362.077459] [078/134] (658s left) kms_atomic (crtc-invalid-params)
[362.165117] Starting subtest: crtc-invalid-params
[362.167393] Starting dynamic subtest: pipe-A-eDP-1
[362.523962] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.360s)
[362.526331] Subtest crtc-invalid-params: SUCCESS (0.361s)
[363.343731] [079/134] (657s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[363.450059] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[363.452178] Starting dynamic subtest: pipe-A-eDP-1
[363.473404] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.023s)
[363.482878] Starting dynamic subtest: pipe-B-eDP-1
[363.501938] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.023s)
[363.512976] Starting dynamic subtest: pipe-C-eDP-1
[363.532288] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.024s)
[363.541549] Starting dynamic subtest: pipe-D-eDP-1
[363.560538] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[363.562679] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.097s)
[365.722909] [080/134] (654s left) gem_lmem_swapping (heavy-verify-multi)
[365.770251] Subtest heavy-verify-multi: SKIP (0.000s)
[365.808112] [081/134] (654s left) kms_chamelium_frames (hdmi-crc-fast)
[366.184370] Subtest hdmi-crc-fast: SKIP (0.000s)
[367.003818] [082/134] (653s left) kms_vblank (query-forked-busy-hang)
[367.106376] Starting subtest: query-forked-busy-hang
[367.108359] Starting dynamic subtest: pipe-A-eDP-1
[393.681766] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.575s)
[393.697269] Starting dynamic subtest: pipe-D-eDP-1
[418.659201] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.974s)
[418.661623] Subtest query-forked-busy-hang: SUCCESS (51.554s)
[419.517790] [083/134] (601s left) kms_big_fb (linear-16bpp-rotate-90)
[419.622347] Starting subtest: linear-16bpp-rotate-90
[419.643258] Subtest linear-16bpp-rotate-90: SKIP (0.020s)
[419.806792] [084/134] (600s left) gem_flink_race (flink_close)
[419.842966] Starting subtest: flink_close
[424.929937] Subtest flink_close: SUCCESS (5.084s)
[425.036616] [085/134] (595s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[425.147389] Starting subtest: fbcpsr-modesetfrombusy
[431.368830] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.227s)
[431.566359] [086/134] (589s left) gem_exec_schedule (thriceslice)
[431.632948] Starting subtest: thriceslice
[431.634952] Starting dynamic subtest: rcs0
[431.657067] Dynamic subtest rcs0: SUCCESS (0.031s)
[431.668482] Starting dynamic subtest: bcs0
[431.710485] Dynamic subtest bcs0: SUCCESS (0.051s)
[431.722561] Starting dynamic subtest: vcs0
[431.762550] Dynamic subtest vcs0: SUCCESS (0.050s)
[431.774180] Starting dynamic subtest: vcs1
[431.794549] Dynamic subtest vcs1: SUCCESS (0.030s)
[431.807376] Starting dynamic subtest: vecs0
[431.824217] Dynamic subtest vecs0: SUCCESS (0.029s)
[431.834967] Starting dynamic subtest: ccs0
[431.854633] Dynamic subtest ccs0: SUCCESS (0.029s)
[431.856634] Subtest thriceslice: SUCCESS (0.229s)
[432.176513] [087/134] (588s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[432.283431] Starting subtest: flip-vs-dpms-off-vs-modeset
[432.285668] Starting dynamic subtest: A-eDP1
[435.871827] Dynamic subtest A-eDP1: SUCCESS (3.587s)
[435.882595] Starting dynamic subtest: B-eDP1
[439.077034] Dynamic subtest B-eDP1: SUCCESS (3.207s)
[439.088560] Starting dynamic subtest: C-eDP1
[442.185285] Dynamic subtest C-eDP1: SUCCESS (3.105s)
[442.195999] Starting dynamic subtest: D-eDP1
[445.262188] Dynamic subtest D-eDP1: SUCCESS (3.078s)
[445.264650] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (12.984s)
[446.082654] [088/134] (574s left) i915_pm_rps (min-max-config-idle)
[446.159172] Starting subtest: min-max-config-idle
[446.163738] Subtest min-max-config-idle: SKIP (0.001s)
[446.305748] [089/134] (574s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[446.404507] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[452.946357] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.544s)
[453.124308] [090/134] (567s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[458.147347] Starting subtest: psr2-overlay-plane-move-continuous-sf
[458.149602] Starting dynamic subtest: pipe-A-eDP-1
[464.865198] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.714s)
[464.875193] Starting dynamic subtest: pipe-B-eDP-1
[471.576402] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.709s)
[471.578646] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.427s)
[472.390552] [091/134] (548s left) kms_concurrent (multi-plane-atomic-lowres)
[472.477218] Starting subtest: multi-plane-atomic-lowres
[472.479624] Starting dynamic subtest: pipe-A-eDP-1
[472.998863] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.520s)
[473.001151] Subtest multi-plane-atomic-lowres: SUCCESS (0.522s)
[473.815899] [092/134] (547s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[473.939715] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[473.943879] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[474.077318] [093/134] (546s left) api_intel_allocator (reopen)
[474.146997] Starting subtest: reopen
[474.149665] Subtest reopen: SUCCESS (0.004s)
[474.324371] [094/134] (546s left) kms_flip (dpms-vs-vblank-race)
[474.425702] Starting subtest: dpms-vs-vblank-race
[474.427619] Starting dynamic subtest: A-eDP1
[478.281393] Dynamic subtest A-eDP1: SUCCESS (3.854s)
[478.291282] Starting dynamic subtest: B-eDP1
[482.893426] Dynamic subtest B-eDP1: SUCCESS (4.611s)
[482.904319] Starting dynamic subtest: C-eDP1
[487.502326] Dynamic subtest C-eDP1: SUCCESS (4.609s)
[487.512621] Starting dynamic subtest: D-eDP1
[492.150893] Dynamic subtest D-eDP1: SUCCESS (4.646s)
[492.153319] Subtest dpms-vs-vblank-race: SUCCESS (17.729s)
[493.042399] [095/134] (528s left) syncobj_timeline (single-wait-all-available-signaled)
[493.110595] Starting subtest: single-wait-all-available-signaled
[493.112874] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[493.239392] [096/134] (527s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[493.339195] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[493.341066] Starting dynamic subtest: pipe-A-eDP-1
[494.661264] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.321s)
[494.945965] Starting dynamic subtest: pipe-B-eDP-1
[495.978671] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.041s)
[496.257998] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.918s)
[497.121891] [097/134] (524s left) gem_exec_params (rs-invalid)
[497.177124] Starting subtest: rs-invalid
[497.181736] Subtest rs-invalid: SUCCESS (0.003s)
[497.329514] [098/134] (523s left) kms_scaling_modes (scaling-mode-full-aspect)
[497.417435] Starting subtest: scaling-mode-full-aspect
[497.419816] Starting dynamic subtest: pipe-A-eDP-1
[497.536912] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.119s)
[497.546766] Starting dynamic subtest: pipe-B-eDP-1
[498.723036] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.185s)
[498.738333] Starting dynamic subtest: pipe-C-eDP-1
[499.841648] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.115s)
[499.851511] Starting dynamic subtest: pipe-D-eDP-1
[500.964434] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.121s)
[500.966775] Subtest scaling-mode-full-aspect: SUCCESS (3.548s)
[502.162934] [099/134] (519s left) kms_plane (plane-panning-top-left)
[502.261159] Starting subtest: plane-panning-top-left
[502.263138] Starting dynamic subtest: pipe-A
[503.988278] Dynamic subtest pipe-A: SUCCESS (1.726s)
[503.998725] Starting dynamic subtest: pipe-B
[506.381905] Dynamic subtest pipe-B: SUCCESS (2.391s)
[506.383800] Subtest plane-panning-top-left: SUCCESS (4.120s)
[507.208313] [100/134] (514s left) kms_psr (psr2-sprite-mmap-cpu)
[507.304454] Starting subtest: psr2-sprite-mmap-cpu
[507.306676] Starting dynamic subtest: eDP-1
[509.062399] Dynamic subtest eDP-1: SUCCESS (1.759s)
[509.064589] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.760s)
[509.953685] [101/134] (511s left) gem_exec_params (rel-constants-invalid-ring)
[510.022551] Starting subtest: rel-constants-invalid-ring
[510.024662] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[510.153829] [102/134] (511s left) i915_query (query-garbage)
[510.212980] Starting subtest: query-garbage
[510.215035] Subtest query-garbage: SUCCESS (0.000s)
[510.347773] [103/134] (511s left) kms_psr (psr-cursor-mmap-cpu)
[510.455219] Starting subtest: psr-cursor-mmap-cpu
[510.457340] Starting dynamic subtest: eDP-1
[512.136460] Dynamic subtest eDP-1: SUCCESS (1.681s)
[512.138817] Subtest psr-cursor-mmap-cpu: SUCCESS (1.683s)
[513.035069] [104/134] (508s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[513.140072] Starting subtest: y-tiled-16bpp-rotate-90
[513.144647] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[513.282289] [105/134] (508s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[513.376051] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[513.380679] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[514.558035] [106/134] (506s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[514.684804] Starting subtest: flip-vs-cursor-legacy
[521.834384] Subtest flip-vs-cursor-legacy: SUCCESS (7.148s)
[522.688602] [107/134] (498s left) kms_frontbuffer_tracking (fbcpsr-argb161616f-draw-blt)
[522.790867] Starting subtest: fbcpsr-argb161616f-draw-blt
[522.795143] Subtest fbcpsr-argb161616f-draw-blt: SKIP (0.000s)
[522.908197] [108/134] (498s left) kms_flip (flip-vs-fences)
[523.018552] Starting subtest: flip-vs-fences
[523.023017] Subtest flip-vs-fences: SKIP (0.000s)
[523.158442] [109/134] (498s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[523.220155] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[523.311834] [110/134] (498s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[523.397478] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[523.399706] Starting dynamic subtest: pipe-A-eDP-1
[524.266763] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.864s)
[524.276869] Starting dynamic subtest: pipe-B-eDP-1
[525.910625] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.641s)
[525.923094] Starting dynamic subtest: pipe-C-eDP-1
[527.393810] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.482s)
[527.404621] Starting dynamic subtest: pipe-D-eDP-1
[528.961428] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.566s)
[528.963632] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.557s)
[530.212653] [111/134] (491s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[530.323262] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[530.327201] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[530.452283] [112/134] (491s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[530.547809] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[530.549989] Starting dynamic subtest: pipe-A-eDP-1
[531.291562] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.736s)
[531.300812] Starting dynamic subtest: pipe-B-eDP-1
[533.120749] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.827s)
[533.135472] Starting dynamic subtest: pipe-C-eDP-1
[534.960593] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.839s)
[534.971557] Starting dynamic subtest: pipe-D-eDP-1
[536.801435] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.839s)
[536.803421] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.246s)
[537.946892] [113/134] (483s left) i915_drm_fdinfo (memory-info-shared)
[537.993158] Starting subtest: memory-info-shared
[537.995303] Starting dynamic subtest: smem0
[538.040523] Dynamic subtest smem0: SUCCESS (0.049s)
[538.043035] Subtest memory-info-shared: SUCCESS (0.050s)
[538.141667] [114/134] (483s left) gem_exec_flush (basic-wb-set-default)
[538.192970] Starting subtest: basic-wb-set-default
[543.652661] Subtest basic-wb-set-default: SUCCESS (5.460s)
[543.864600] [115/134] (478s left) sysfs_timeslice_duration (timeout)
[543.936753] Starting subtest: timeout
[543.939243] Starting dynamic subtest: vecs0
[553.899275] Dynamic subtest vecs0: SUCCESS (9.958s)
[553.912060] Starting dynamic subtest: ccs0
[555.279672] Dynamic subtest ccs0: SUCCESS (1.380s)
[555.291342] Starting dynamic subtest: vcs0
[564.917554] Dynamic subtest vcs0: SUCCESS (9.633s)
[564.929862] Starting dynamic subtest: bcs0
[565.627944] Dynamic subtest bcs0: SUCCESS (0.710s)
[565.643608] Starting dynamic subtest: rcs0
[566.992771] Dynamic subtest rcs0: SUCCESS (1.363s)
[567.003958] Starting dynamic subtest: vcs1
[576.946532] Dynamic subtest vcs1: SUCCESS (9.948s)
[576.949382] Subtest timeout: SUCCESS (33.006s)
[577.063556] [116/134] (444s left) sriov_basic (enable-vfs-bind-unbind-each)
[577.122768] Starting subtest: enable-vfs-bind-unbind-each
[577.124941] Starting dynamic subtest: numvfs-1
[577.204754] Dynamic subtest numvfs-1: FAIL (0.032s)
[577.215131] Starting dynamic subtest: numvfs-2
[577.284819] Dynamic subtest numvfs-2: FAIL (0.004s)
[577.296076] Starting dynamic subtest: numvfs-3
[577.368352] Dynamic subtest numvfs-3: FAIL (0.004s)
[577.378845] Starting dynamic subtest: numvfs-4
[577.450800] Dynamic subtest numvfs-4: FAIL (0.003s)
[577.461403] Starting dynamic subtest: numvfs-5
[577.532937] Dynamic subtest numvfs-5: FAIL (0.003s)
[577.544438] Starting dynamic subtest: numvfs-6
[577.616610] Dynamic subtest numvfs-6: FAIL (0.003s)
[577.626652] Starting dynamic subtest: numvfs-7
[577.698893] Dynamic subtest numvfs-7: FAIL (0.003s)
[577.709008] Starting dynamic subtest: numvfs-random
[577.777594] Dynamic subtest numvfs-random: FAIL (0.003s)
[577.779860] Subtest enable-vfs-bind-unbind-each: FAIL (0.062s)
[577.818977] [117/134] (444s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[577.934442] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[577.938876] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[579.057555] [118/134] (443s left) kms_getfb (getfb-handle-not-fb)
[579.157214] Starting subtest: getfb-handle-not-fb
[579.159477] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[579.290018] [119/134] (442s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[579.356844] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[579.361515] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[579.567772] [120/134] (442s left) gem_workarounds (reset-context)
[579.632408] Starting subtest: reset-context
[579.799467] Subtest reset-context: SUCCESS (0.166s)
[579.974202] [121/134] (442s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[580.071861] Starting subtest: psr-farfromfence-mmap-gtt
[580.075971] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[580.206159] [122/134] (442s left) gem_wait (write-busy)
[580.264217] Starting subtest: write-busy
[580.266434] Starting dynamic subtest: all-engines
[580.891774] Dynamic subtest all-engines: SUCCESS (0.630s)
[580.909024] Starting dynamic subtest: rcs0
[581.446476] Dynamic subtest rcs0: SUCCESS (0.553s)
[581.463717] Starting dynamic subtest: bcs0
[581.995663] Dynamic subtest bcs0: SUCCESS (0.548s)
[582.011422] Starting dynamic subtest: vcs0
[583.896262] Dynamic subtest vcs0: SUCCESS (1.899s)
[583.913293] Starting dynamic subtest: vcs1
[585.880211] Dynamic subtest vcs1: SUCCESS (1.982s)
[585.896978] Starting dynamic subtest: vecs0
[587.928947] Dynamic subtest vecs0: SUCCESS (2.045s)
[587.945402] Starting dynamic subtest: ccs0
[588.480209] Dynamic subtest ccs0: SUCCESS (0.550s)
[588.482689] Subtest write-busy: SUCCESS (8.219s)
[588.699853] [123/134] (433s left) i915_hangman (detector)
[588.767409] Starting subtest: detector
[588.769696] Starting dynamic subtest: rcs0
[598.905452] Dynamic subtest rcs0: SUCCESS (10.136s)
[598.919079] Starting dynamic subtest: bcs0
[610.872383] Dynamic subtest bcs0: SUCCESS (11.964s)
[610.884435] Starting dynamic subtest: vcs0
[622.840061] Dynamic subtest vcs0: SUCCESS (11.965s)
[622.852736] Starting dynamic subtest: vcs1
[634.807261] Dynamic subtest vcs1: SUCCESS (11.964s)
[634.820537] Starting dynamic subtest: vecs0
[644.856035] Dynamic subtest vecs0: SUCCESS (10.045s)
[644.870274] Starting dynamic subtest: ccs0
[656.887415] Dynamic subtest ccs0: SUCCESS (12.029s)
[656.890097] Subtest detector: SUCCESS (68.119s)
[656.991467] [124/134] (365s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[657.093367] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[657.097718] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[657.229831] [125/134] (365s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[657.345409] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[657.349774] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[657.518741] [126/134] (364s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[657.582871] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[657.652528] [127/134] (364s left) gem_exec_schedule (noreorder-corked)
[657.833700] Starting subtest: noreorder-corked
[657.836215] Starting dynamic subtest: rcs0
[658.994725] Dynamic subtest rcs0: SUCCESS (1.161s)
[659.007943] Starting dynamic subtest: vcs0
[660.914867] Dynamic subtest vcs0: SUCCESS (1.916s)
[660.927890] Starting dynamic subtest: vcs1
[662.919594] Dynamic subtest vcs1: SUCCESS (2.003s)
[662.932060] Starting dynamic subtest: vecs0
[664.903882] Dynamic subtest vecs0: SUCCESS (1.982s)
[664.916532] Starting dynamic subtest: ccs0
[666.078620] Dynamic subtest ccs0: SUCCESS (1.173s)
[666.081603] Subtest noreorder-corked: SUCCESS (8.246s)
[666.295407] [128/134] (356s left) kms_psr (pr-cursor-mmap-cpu)
[666.407829] Starting subtest: pr-cursor-mmap-cpu
[666.412149] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[666.514215] [129/134] (356s left) perf (invalid-oa-format-id)
[666.613739] Starting subtest: invalid-oa-format-id
[666.623598] Subtest invalid-oa-format-id: SUCCESS (0.008s)
[666.666981] [130/134] (355s left) gem_eio (in-flight-internal-immediate)
[666.861741] Starting subtest: in-flight-internal-immediate
[667.986344] Subtest in-flight-internal-immediate: SUCCESS (1.123s)
[668.166322] [131/134] (354s left) kms_cursor_edge_walk (256x256-top-edge)
[668.268661] Starting subtest: 256x256-top-edge
[668.270845] Starting dynamic subtest: pipe-A-eDP-1
[671.682408] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.413s)
[671.692439] Starting dynamic subtest: pipe-D-eDP-1
[674.813197] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.131s)
[674.815451] Subtest 256x256-top-edge: SUCCESS (6.547s)
[675.632934] [132/134] (347s left) gem_ctx_persistence (engines-persistence)
[675.696466] Starting subtest: engines-persistence
[675.698689] Starting dynamic subtest: rcs0
[676.538041] Dynamic subtest rcs0: SUCCESS (0.841s)
[676.550906] Starting dynamic subtest: bcs0
[677.357912] Dynamic subtest bcs0: SUCCESS (0.817s)
[677.370479] Starting dynamic subtest: vcs0
[678.125923] Dynamic subtest vcs0: SUCCESS (0.766s)
[678.138062] Starting dynamic subtest: vcs1
[678.961928] Dynamic subtest vcs1: SUCCESS (0.834s)
[678.974072] Starting dynamic subtest: vecs0
[679.793092] Dynamic subtest vecs0: SUCCESS (0.829s)
[679.806061] Starting dynamic subtest: ccs0
[680.584198] Dynamic subtest ccs0: SUCCESS (0.788s)
[680.586748] Subtest engines-persistence: SUCCESS (4.887s)
[680.748766] [133/134] (341s left) api_intel_bb (render-ccs)
[680.811849] Starting subtest: render-ccs
[681.167811] Subtest render-ccs: SUCCESS (0.355s)
[681.288229] [134/134] (341s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[681.392153] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[681.396372] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[681.533759] 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.