[63.540926] Initializing watchdogs
[63.540975]   /dev/watchdog0
[63.555773] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[63.560343] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[63.562771] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.566171] [001/133] (960s left) kms_psr (psr-cursor-render)
[63.685331] Starting subtest: psr-cursor-render
[63.687697] Starting dynamic subtest: eDP-1
[65.408406] Dynamic subtest eDP-1: SUCCESS (1.718s)
[65.410316] Subtest psr-cursor-render: SUCCESS (1.720s)
[66.273217] [002/133] (957s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[66.366076] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[66.452453] [003/133] (957s left) kms_chamelium_audio (hdmi-audio)
[66.827025] Subtest hdmi-audio: SKIP (0.000s)
[67.698338] [004/133] (956s left) gem_lmem_swapping (basic)
[67.761105] Subtest basic: SKIP (0.000s)
[67.814732] [005/133] (956s left) kms_sequence (get-busy)
[67.980522] Starting subtest: get-busy
[67.982901] Starting dynamic subtest: pipe-A-eDP-1
[69.919306] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.938s)
[69.927632] Starting dynamic subtest: pipe-B-eDP-1
[72.516311] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.593s)
[72.524290] Starting dynamic subtest: pipe-C-eDP-1
[75.114144] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.600s)
[75.122774] Starting dynamic subtest: pipe-D-eDP-1
[77.635283] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.520s)
[77.637819] Subtest get-busy: SUCCESS (9.655s)
[78.434644] [006/133] (945s left) gem_mmap_offset (mmap-unmap)
[78.490020] Starting subtest: mmap-unmap
[78.492337] Starting dynamic subtest: smem0
[101.793942] Dynamic subtest smem0: SUCCESS (23.303s)
[101.796858] Subtest mmap-unmap: SUCCESS (23.303s)
[101.903323] [007/133] (922s left) gem_mmap (basic)
[101.958634] Subtest basic: SKIP (0.000s)
[102.022144] [008/133] (922s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[102.128947] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[102.131312] Starting dynamic subtest: pipe-A-eDP-1
[102.154564] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[102.163607] Starting dynamic subtest: pipe-B-eDP-1
[102.185659] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[102.195368] Starting dynamic subtest: pipe-C-eDP-1
[102.216534] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[102.223778] Starting dynamic subtest: pipe-D-eDP-1
[102.245734] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[102.249821] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[104.314106] [009/133] (920s left) gem_ctx_bad_destroy (invalid-ctx)
[104.379782] Starting subtest: invalid-ctx
[104.382229] Subtest invalid-ctx: SUCCESS (0.000s)
[104.454363] [010/133] (919s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[104.561808] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[111.374659] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.811s)
[111.535744] [011/133] (912s left) kms_flip (basic-flip-vs-modeset)
[111.641192] Starting subtest: basic-flip-vs-modeset
[111.643263] Starting dynamic subtest: A-eDP1
[114.235823] Dynamic subtest A-eDP1: SUCCESS (2.594s)
[114.245666] Starting dynamic subtest: B-eDP1
[116.395631] Dynamic subtest B-eDP1: SUCCESS (2.159s)
[116.404190] Starting dynamic subtest: C-eDP1
[118.566220] Dynamic subtest C-eDP1: SUCCESS (2.170s)
[118.575661] Starting dynamic subtest: D-eDP1
[120.740481] Dynamic subtest D-eDP1: SUCCESS (2.173s)
[120.742857] Subtest basic-flip-vs-modeset: SUCCESS (9.102s)
[121.551778] [012/133] (902s left) kms_vblank (wait-forked)
[121.646920] Starting subtest: wait-forked
[121.648866] Starting dynamic subtest: pipe-A-eDP-1
[123.467290] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.820s)
[123.480220] Starting dynamic subtest: pipe-D-eDP-1
[125.957487] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.489s)
[125.959823] Subtest wait-forked: SUCCESS (4.312s)
[126.821432] [013/133] (897s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[126.929504] Starting subtest: yf-tiled-addfb-size-offset-overflow
[126.933945] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[127.023061] [014/133] (897s left) syncobj_wait (wait-all-complex)
[127.084749] Starting subtest: wait-all-complex
[127.300616] Subtest wait-all-complex: SUCCESS (0.214s)
[127.372475] [015/133] (897s left) gem_wait (busy)
[127.439152] Starting subtest: busy
[127.441605] Starting dynamic subtest: all-engines
[128.916366] Dynamic subtest all-engines: SUCCESS (1.475s)
[128.926520] Starting dynamic subtest: rcs0
[129.458718] Dynamic subtest rcs0: SUCCESS (0.542s)
[129.467593] Starting dynamic subtest: bcs0
[129.998502] Dynamic subtest bcs0: SUCCESS (0.540s)
[130.007623] Starting dynamic subtest: vcs0
[131.924281] Dynamic subtest vcs0: SUCCESS (1.924s)
[131.934092] Starting dynamic subtest: vcs1
[133.907795] Dynamic subtest vcs1: SUCCESS (1.983s)
[133.917935] Starting dynamic subtest: vecs0
[135.892977] Dynamic subtest vecs0: SUCCESS (1.983s)
[135.903030] Starting dynamic subtest: ccs0
[136.433398] Dynamic subtest ccs0: SUCCESS (0.541s)
[136.435887] Subtest busy: SUCCESS (8.994s)
[136.626751] [016/133] (888s left) syncobj_timeline (transfer-timeline-point)
[136.689252] Starting subtest: transfer-timeline-point
[136.691731] Subtest transfer-timeline-point: SUCCESS (0.000s)
[136.792769] [017/133] (887s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[136.906951] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[143.887187] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.981s)
[144.018033] [018/133] (880s left) kms_content_protection (uevent)
[144.164867] Starting subtest: uevent
[144.169458] Subtest uevent: SKIP (0.000s)
[144.282468] [019/133] (880s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[144.382694] Starting subtest: 4-tiled-32bpp-rotate-180
[145.771400] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.390s)
[145.949804] [020/133] (878s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[146.068239] Starting subtest: cursor-vs-flip-atomic
[175.497731] Subtest cursor-vs-flip-atomic: SUCCESS (29.427s)
[176.333301] [021/133] (848s left) gem_userptr_blits (create-destroy-sync)
[176.396501] Starting subtest: create-destroy-sync
[181.412067] Subtest create-destroy-sync: SUCCESS (5.016s)
[181.533731] [022/133] (843s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[181.637840] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[181.640179] Starting dynamic subtest: pipe-A-eDP-1
[181.650275] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[181.658260] Starting dynamic subtest: pipe-B-eDP-1
[181.666844] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[181.673705] Starting dynamic subtest: pipe-C-eDP-1
[181.682130] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[181.688842] Starting dynamic subtest: pipe-D-eDP-1
[181.697091] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[181.701256] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[183.899906] [023/133] (841s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[183.953767] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[183.956395] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[184.045114] [024/133] (840s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[184.139698] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[190.677099] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.540s)
[190.798868] [025/133] (834s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[190.922469] Starting subtest: flip-vs-cursor-atomic-transitions
[198.543072] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.619s)
[199.365758] [026/133] (825s left) prime_mmap (test_aperture_limit)
[199.429419] Starting subtest: test_aperture_limit
[199.431746] Starting dynamic subtest: test_aperture_limit-smem
[199.439344] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[199.443989] Subtest test_aperture_limit: SKIP (0.008s)
[199.525726] [027/133] (825s left) gem_ctx_param (set-priority-range)
[199.583704] Starting subtest: set-priority-range
[199.598728] Subtest set-priority-range: SUCCESS (0.015s)
[199.694660] [028/133] (825s left) perf_pmu (multi-client)
[199.731191] Starting subtest: multi-client
[199.733489] Starting dynamic subtest: rcs0
[200.789397] Dynamic subtest rcs0: SUCCESS (1.057s)
[200.800608] Starting dynamic subtest: bcs0
[201.840047] Dynamic subtest bcs0: SUCCESS (1.048s)
[201.850578] Starting dynamic subtest: vcs0
[202.892661] Dynamic subtest vcs0: SUCCESS (1.052s)
[202.903164] Starting dynamic subtest: vcs1
[204.939033] Dynamic subtest vcs1: SUCCESS (2.044s)
[204.950306] Starting dynamic subtest: vecs0
[206.924077] Dynamic subtest vecs0: SUCCESS (1.983s)
[206.934807] Starting dynamic subtest: ccs0
[208.908866] Dynamic subtest ccs0: SUCCESS (1.983s)
[208.911812] Subtest multi-client: SUCCESS (9.178s)
[209.040478] [029/133] (816s left) kms_hdr (static-toggle-suspend)
[209.146965] Starting subtest: static-toggle-suspend
[209.153749] Subtest static-toggle-suspend: SKIP (0.000s)
[209.219829] [030/133] (816s left) kms_cursor_edge_walk (256x256-right-edge)
[209.323916] Starting subtest: 256x256-right-edge
[209.326273] Starting dynamic subtest: pipe-A-eDP-1
[212.827611] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.501s)
[212.835596] Starting dynamic subtest: pipe-D-eDP-1
[215.944176] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.117s)
[215.946334] Subtest 256x256-right-edge: SUCCESS (6.621s)
[216.740796] [031/133] (808s left) i915_pm_rpm (sysfs-read)
[218.263074] Starting subtest: sysfs-read
[219.412043] Subtest sysfs-read: SUCCESS (1.147s)
[219.789194] [032/133] (805s left) gem_linear_blits (normal)
[220.131984] Starting subtest: normal
[223.982642] Subtest normal: SUCCESS (3.851s)
[224.142097] [033/133] (801s left) kms_setmode (invalid-clone-single-crtc-stealing)
[224.240308] Starting subtest: invalid-clone-single-crtc-stealing
[224.246642] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[224.391672] [034/133] (801s left) gem_exec_schedule (independent)
[224.477785] Starting subtest: independent
[224.479776] Starting dynamic subtest: rcs0
[225.942645] Dynamic subtest rcs0: SUCCESS (1.470s)
[225.954776] Starting dynamic subtest: vcs0
[227.935357] Dynamic subtest vcs0: SUCCESS (1.991s)
[227.946622] Starting dynamic subtest: vcs1
[229.924309] Dynamic subtest vcs1: SUCCESS (1.986s)
[229.935930] Starting dynamic subtest: vecs0
[231.903472] Dynamic subtest vecs0: SUCCESS (1.978s)
[231.914744] Starting dynamic subtest: ccs0
[233.877378] Dynamic subtest ccs0: SUCCESS (1.971s)
[233.880051] Subtest independent: SUCCESS (9.406s)
[234.190653] [035/133] (791s left) dumb_buffer (create-valid-dumb)
[234.258513] Starting subtest: create-valid-dumb
[234.260496] Subtest create-valid-dumb: SUCCESS (0.000s)
[234.368603] [036/133] (791s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[234.772454] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[235.592513] [037/133] (789s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[235.699026] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[236.547428] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.850s)
[236.708274] [038/133] (788s left) kms_getfb (getfb-addfb-different-handles)
[236.811701] Starting subtest: getfb-addfb-different-handles
[236.813897] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[236.907360] [039/133] (788s left) kms_plane_scaling (planes-upscale-factor-0-25)
[237.005902] Starting subtest: planes-upscale-factor-0-25
[237.008145] Starting dynamic subtest: pipe-A
[237.066126] Dynamic subtest pipe-A: SUCCESS (0.062s)
[237.074164] Starting dynamic subtest: pipe-B
[238.245635] Dynamic subtest pipe-B: SUCCESS (1.178s)
[238.254259] Starting dynamic subtest: pipe-C
[239.359913] Dynamic subtest pipe-C: SUCCESS (1.114s)
[239.368944] Starting dynamic subtest: pipe-D
[240.481621] Dynamic subtest pipe-D: SUCCESS (1.120s)
[240.483897] Subtest planes-upscale-factor-0-25: SUCCESS (3.478s)
[241.648755] [040/133] (783s left) kms_lease (lease-get)
[241.751674] Starting subtest: lease-get
[241.753880] Starting dynamic subtest: pipe-A-eDP-1
[241.756145] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[241.764250] Starting dynamic subtest: pipe-B-eDP-1
[241.766082] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[241.773593] Starting dynamic subtest: pipe-C-eDP-1
[241.775448] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[241.782925] Starting dynamic subtest: pipe-D-eDP-1
[241.784770] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[241.786619] Subtest lease-get: SUCCESS (0.009s)
[241.877870] [041/133] (783s left) kms_addfb_basic (size-max)
[241.975870] Starting subtest: size-max
[241.978046] Subtest size-max: SUCCESS (0.000s)
[242.085623] [042/133] (783s left) gem_exec_schedule (u-semaphore-user)
[242.148619] Starting subtest: u-semaphore-user
[242.199714] Subtest u-semaphore-user: SUCCESS (0.058s)
[243.960488] [043/133] (781s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[244.056613] Starting subtest: fbc-rgb101010-draw-mmap-wc
[248.639740] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.586s)
[249.752873] [044/133] (776s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[249.841902] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[249.845734] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[249.911425] [045/133] (775s left) perf (blocking-parameterized)
[250.037311] Starting subtest: blocking-parameterized
[270.060380] Subtest blocking-parameterized: SUCCESS (20.022s)
[270.109372] [046/133] (755s left) gem_lmem_swapping (parallel-random-verify)
[270.152506] Subtest parallel-random-verify: SKIP (0.000s)
[270.200166] [047/133] (755s left) gem_create (hog-create)
[270.250623] Starting subtest: hog-create
[270.252995] Starting dynamic subtest: smem0
[303.891281] Dynamic subtest smem0: SUCCESS (33.637s)
[303.893801] Subtest hog-create: SUCCESS (33.639s)
[304.074923] [048/133] (721s left) api_intel_bb (intel-bb-blit-x)
[304.144722] Starting subtest: intel-bb-blit-x
[308.027445] Subtest intel-bb-blit-x: SUCCESS (3.883s)
[308.152382] [049/133] (717s left) kms_pipe_crc_basic (suspend-read-crc)
[308.245098] Starting subtest: suspend-read-crc
[308.247312] Starting dynamic subtest: pipe-A-eDP-1
[325.955253] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.666s)
[325.964709] Starting dynamic subtest: pipe-B-eDP-1
[343.944153] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.200s)
[343.953233] Starting dynamic subtest: pipe-C-eDP-1
[361.904548] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.997s)
[361.914806] Starting dynamic subtest: pipe-D-eDP-1
[379.918332] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.072s)
[379.920349] Subtest suspend-read-crc: SUCCESS (11.941s)
[380.746348] [050/133] (645s left) gem_exec_whisper (basic-fds-priority-all)
[380.817810] Starting subtest: basic-fds-priority-all
[402.713542] Subtest basic-fds-priority-all: SUCCESS (21.818s)
[402.891680] [051/133] (623s left) gem_exec_balancer (full)
[402.947213] Starting subtest: full
[407.399674] Subtest full: SUCCESS (4.448s)
[407.704418] [052/133] (618s left) kms_dp_link_training (uhbr-sst)
[407.802543] Starting subtest: uhbr-sst
[407.811398] Subtest uhbr-sst: SKIP (0.000s)
[407.884778] [053/133] (618s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[407.985280] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[407.989735] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[408.070429] [054/133] (618s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[408.165622] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[408.170326] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[409.249082] [055/133] (616s left) gem_exec_flush (basic-wb-pro-default)
[409.319947] Starting subtest: basic-wb-pro-default
[414.772295] Subtest basic-wb-pro-default: SUCCESS (5.457s)
[414.955822] [056/133] (611s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[415.083094] Starting subtest: flip-vs-cursor-toggle
[423.762572] Subtest flip-vs-cursor-toggle: SUCCESS (8.680s)
[424.564025] [057/133] (601s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[424.658365] Starting subtest: fbc-pr-cursor-mmap-cpu
[424.662926] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[424.730864] [058/133] (601s left) drm_read (empty-block)
[424.880189] Starting subtest: empty-block
[425.876868] Subtest empty-block: SUCCESS (1.000s)
[425.999937] [059/133] (600s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[426.100442] Starting subtest: fbc-pr-sprite-mmap-gtt
[426.104728] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[426.173113] [060/133] (600s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[426.273075] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[430.288080] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.018s)
[431.459329] [061/133] (595s left) vgem_basic (bad-handle)
[431.629263] Starting subtest: bad-handle
[431.631584] Subtest bad-handle: SUCCESS (0.000s)
[431.684026] [FACT vgem_basic (bad-handle)] new: kernel.kmod_is_loaded.vgem: true
[431.688090] [062/133] (594s left) gem_exec_params (mmapped)
[431.750305] Starting subtest: mmapped
[431.755640] Subtest mmapped: SUCCESS (0.003s)
[431.863087] [063/133] (594s left) kms_pm_dc (dc6-psr)
[432.971835] Starting subtest: dc6-psr
[435.917531] Subtest dc6-psr: SUCCESS (2.944s)
[436.785822] [064/133] (589s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[436.833457] Starting subtest: framebuffer-vs-set-tiling
[436.837521] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[436.979293] [065/133] (589s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[437.078656] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[437.082900] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[437.177247] [066/133] (589s left) gem_softpin (evict-prime-sanity-check)
[437.236684] Starting subtest: evict-prime-sanity-check
[437.238963] Starting dynamic subtest: rcs0
[438.379250] Dynamic subtest rcs0: SUCCESS (1.142s)
[438.389113] Starting dynamic subtest: bcs0
[439.492339] Dynamic subtest bcs0: SUCCESS (1.112s)
[439.502990] Starting dynamic subtest: vcs0
[441.488244] Dynamic subtest vcs0: SUCCESS (1.992s)
[441.500620] Starting dynamic subtest: vcs1
[443.534013] Dynamic subtest vcs1: SUCCESS (2.043s)
[443.546458] Starting dynamic subtest: vecs0
[445.501290] Dynamic subtest vecs0: SUCCESS (1.964s)
[445.512857] Starting dynamic subtest: ccs0
[446.647898] Dynamic subtest ccs0: SUCCESS (1.145s)
[446.667463] Starting dynamic subtest: all
[447.781826] Dynamic subtest all: SUCCESS (1.132s)
[447.784606] Subtest evict-prime-sanity-check: SUCCESS (10.544s)
[447.877020] [067/133] (578s left) kms_cursor_legacy (torture-move)
[447.990631] Starting subtest: torture-move
[447.992414] Starting dynamic subtest: pipe-A
[453.893431] Dynamic subtest pipe-A: SUCCESS (5.900s)
[453.906132] Starting dynamic subtest: pipe-B
[460.973242] Dynamic subtest pipe-B: SUCCESS (7.077s)
[460.982652] Starting dynamic subtest: pipe-C
[467.294674] Dynamic subtest pipe-C: SUCCESS (6.315s)
[467.306478] Starting dynamic subtest: pipe-D
[474.919644] Dynamic subtest pipe-D: SUCCESS (7.620s)
[474.930732] Starting dynamic subtest: all-pipes
[481.952176] Dynamic subtest all-pipes: SUCCESS (7.034s)
[481.954490] Subtest torture-move: SUCCESS (33.956s)
[482.107142] [068/133] (544s left) kms_flip (plain-flip-fb-recreate-interruptible)
[482.201829] Starting subtest: plain-flip-fb-recreate-interruptible
[482.204309] Starting dynamic subtest: A-eDP1
[491.081270] Dynamic subtest A-eDP1: SUCCESS (8.880s)
[491.093118] Starting dynamic subtest: B-eDP1
[499.917126] Dynamic subtest B-eDP1: SUCCESS (8.834s)
[499.927650] Starting dynamic subtest: C-eDP1
[508.725559] Dynamic subtest C-eDP1: SUCCESS (8.807s)
[508.738029] Starting dynamic subtest: D-eDP1
[517.556284] Dynamic subtest D-eDP1: SUCCESS (8.828s)
[517.560853] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.362s)
[518.738053] [069/133] (508s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[518.846745] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[518.850658] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[518.950730] [070/133] (507s left) perf_pmu (all-busy-check-all)
[518.990413] Starting subtest: all-busy-check-all
[520.532276] Subtest all-busy-check-all: SUCCESS (1.541s)
[520.633332] [071/133] (506s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[520.730814] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[520.757459] Starting dynamic subtest: pipe-A-plane-0
[521.179542] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[521.190124] Starting dynamic subtest: pipe-A-plane-3
[521.446637] Dynamic subtest pipe-A-plane-3: SUCCESS (0.266s)
[521.455705] Starting dynamic subtest: pipe-A-plane-5
[521.459657] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[522.525763] Starting dynamic subtest: pipe-B-plane-0
[522.967634] Dynamic subtest pipe-B-plane-0: SUCCESS (0.455s)
[522.979351] Starting dynamic subtest: pipe-B-plane-3
[523.222820] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[523.232725] Starting dynamic subtest: pipe-B-plane-5
[523.236908] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[523.531688] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.803s)
[524.400447] [072/133] (502s left) gem_ctx_param (invalid-get-ringsize)
[524.458052] Starting subtest: invalid-get-ringsize
[524.460458] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[524.551090] [073/133] (502s left) gem_eio (in-flight-contexts-1us)
[524.767929] Starting subtest: in-flight-contexts-1us
[536.557529] Subtest in-flight-contexts-1us: SUCCESS (11.787s)
[536.713298] [074/133] (490s left) kms_frontbuffer_tracking (fbc-1p-rte)
[536.820090] Starting subtest: fbc-1p-rte
[542.271940] Subtest fbc-1p-rte: SUCCESS (5.454s)
[543.429806] [075/133] (483s left) gem_pxp (reject-modify-context-protection-off-2)
[543.555865] Starting subtest: reject-modify-context-protection-off-2
[543.558470] Subtest reject-modify-context-protection-off-2: SUCCESS (0.001s)
[543.662871] [076/133] (483s left) drm_read (short-buffer-block)
[543.819401] Starting subtest: short-buffer-block
[543.821743] Subtest short-buffer-block: SUCCESS (0.000s)
[543.971237] [077/133] (483s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[544.054221] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[544.056338] Starting dynamic subtest: pipe-A-eDP-1
[544.080237] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[544.090829] Starting dynamic subtest: pipe-B-eDP-1
[544.113195] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[544.122361] Starting dynamic subtest: pipe-C-eDP-1
[544.144729] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[544.153401] Starting dynamic subtest: pipe-D-eDP-1
[544.176250] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[544.180338] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[546.360969] [078/133] (480s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[546.474169] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[546.476503] Starting dynamic subtest: pipe-A
[546.870315] Dynamic subtest pipe-A: SUCCESS (0.397s)
[546.881795] Starting dynamic subtest: pipe-B
[548.297734] Dynamic subtest pipe-B: SUCCESS (1.425s)
[548.309332] Starting dynamic subtest: pipe-C
[549.699074] Dynamic subtest pipe-C: SUCCESS (1.400s)
[549.709369] Starting dynamic subtest: pipe-D
[551.143016] Dynamic subtest pipe-D: SUCCESS (1.442s)
[551.145361] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.670s)
[552.282845] [079/133] (474s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[552.382185] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[552.386876] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[552.482053] [080/133] (474s left) gem_exec_alignment (pi)
[552.553350] Starting subtest: pi
[605.712808] Subtest pi: SUCCESS (53.148s)
[606.878751] [081/133] (420s left) kms_cursor_crc (cursor-onscreen-256x256)
[607.164197] Starting subtest: cursor-onscreen-256x256
[607.166383] Starting dynamic subtest: pipe-A-eDP-1
[609.307639] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.140s)
[609.337286] Starting dynamic subtest: pipe-D-eDP-1
[612.098721] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.767s)
[612.100977] Subtest cursor-onscreen-256x256: SUCCESS (4.935s)
[612.954466] [082/133] (414s left) syncobj_wait (single-wait-for-submit-signaled)
[613.019306] Starting subtest: single-wait-for-submit-signaled
[613.021730] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[613.097809] [083/133] (414s left) kms_psr (psr2-sprite-blt)
[613.190290] Starting subtest: psr2-sprite-blt
[613.192519] Starting dynamic subtest: eDP-1
[614.966786] Dynamic subtest eDP-1: SUCCESS (1.775s)
[614.969059] Subtest psr2-sprite-blt: SUCCESS (1.776s)
[615.824195] [084/133] (411s left) syncobj_timeline (multi-wait-all-available-submitted)
[615.888858] Starting subtest: multi-wait-all-available-submitted
[615.891210] Subtest multi-wait-all-available-submitted: SUCCESS (0.001s)
[615.992985] [085/133] (411s left) gen3_render_tiledx_blits
[616.120764] [086/133] (411s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[616.377032] Starting subtest: cursor-rapid-movement-256x256
[616.381831] Starting dynamic subtest: pipe-A-eDP-1
[616.947905] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s)
[616.978516] Starting dynamic subtest: pipe-D-eDP-1
[618.156737] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.184s)
[618.158711] Subtest cursor-rapid-movement-256x256: SUCCESS (1.777s)
[618.991987] [087/133] (408s left) kms_psr (pr-primary-blt)
[619.078247] Starting subtest: pr-primary-blt
[619.082490] Subtest pr-primary-blt: SKIP (0.000s)
[619.151089] [088/133] (408s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[619.247297] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[619.251512] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[619.353299] [089/133] (408s left) gem_userptr_blits (coherency-sync)
[619.414213] Starting subtest: coherency-sync
[619.577674] Subtest coherency-sync: SKIP (0.128s)
[619.686125] [090/133] (408s left) kms_chamelium_frames (dp-frame-dump)
[620.109119] Subtest dp-frame-dump: SKIP (0.000s)
[620.891308] [091/133] (406s left) i915_selftest (live)
[624.194465] Starting subtest: live
[624.197187] Starting dynamic subtest: sanitycheck
[628.532135] Dynamic subtest sanitycheck: SUCCESS (4.336s)
[628.542327] Starting dynamic subtest: uncore
[632.833372] Dynamic subtest uncore: SUCCESS (4.300s)
[632.843388] Starting dynamic subtest: workarounds
[635.936948] Dynamic subtest workarounds: SUCCESS (3.102s)
[635.947311] Starting dynamic subtest: gt_engines
[640.431126] Dynamic subtest gt_engines: SUCCESS (4.493s)
[640.441118] Starting dynamic subtest: gt_timelines
[656.042205] Dynamic subtest gt_timelines: SUCCESS (15.611s)
[656.057256] Starting dynamic subtest: gt_contexts
[660.397609] Dynamic subtest gt_contexts: SUCCESS (4.354s)
[660.407545] Starting dynamic subtest: gt_lrc
[664.757087] Dynamic subtest gt_lrc: SUCCESS (4.358s)
[664.767544] Starting dynamic subtest: gt_mocs
[667.754003] Dynamic subtest gt_mocs: SUCCESS (2.995s)
[667.765216] Starting dynamic subtest: gt_pm
[674.607160] Dynamic subtest gt_pm: SUCCESS (6.851s)
[674.620985] Starting dynamic subtest: gt_heartbeat
[678.934623] Dynamic subtest gt_heartbeat: SUCCESS (4.325s)
[678.945181] Starting dynamic subtest: gt_tlb
[688.233957] Dynamic subtest gt_tlb: SUCCESS (9.297s)
[688.244170] Starting dynamic subtest: requests
[699.850126] Dynamic subtest requests: SUCCESS (11.613s)
[699.860151] Starting dynamic subtest: migrate
[705.701134] Dynamic subtest migrate: SUCCESS (5.849s)
[705.711381] Starting dynamic subtest: active
[710.041833] Dynamic subtest active: SUCCESS (4.338s)
[710.051686] Starting dynamic subtest: objects
[714.850150] Dynamic subtest objects: SUCCESS (4.806s)
[714.858926] Starting dynamic subtest: mman
[719.629636] Dynamic subtest mman: SUCCESS (4.777s)
[719.639932] Starting dynamic subtest: dmabuf
[722.380700] Dynamic subtest dmabuf: SUCCESS (2.750s)
[722.390451] Starting dynamic subtest: vma
[726.724042] Dynamic subtest vma: SUCCESS (4.341s)
[726.734162] Starting dynamic subtest: coherency
[731.652172] Dynamic subtest coherency: SUCCESS (4.926s)
[731.668733] Starting dynamic subtest: gtt
[741.752122] Dynamic subtest gtt: SUCCESS (10.097s)
[741.762295] Starting dynamic subtest: gem
[749.253473] Dynamic subtest gem: SUCCESS (7.499s)
[749.263267] Starting dynamic subtest: evict
[754.113094] Dynamic subtest evict: SUCCESS (4.856s)
[754.124616] Starting dynamic subtest: hugepages
[762.857487] Dynamic subtest hugepages: SUCCESS (8.736s)
[762.864799] Starting dynamic subtest: gem_contexts
[791.418636] Dynamic subtest gem_contexts: SUCCESS (28.559s)
[791.428777] Starting dynamic subtest: client
[795.720289] Dynamic subtest client: SUCCESS (4.300s)
[795.730317] Starting dynamic subtest: gem_migrate
[798.386094] Dynamic subtest gem_migrate: SUCCESS (2.663s)
[798.396397] Starting dynamic subtest: reset
[801.136335] Dynamic subtest reset: SUCCESS (2.749s)
[801.148293] Starting dynamic subtest: memory_region
[803.868040] Dynamic subtest memory_region: SUCCESS (2.730s)
[803.877845] Starting dynamic subtest: hangcheck
[817.265858] Dynamic subtest hangcheck: SUCCESS (13.392s)
[817.276627] Starting dynamic subtest: execlists
[821.556116] Dynamic subtest execlists: SUCCESS (4.288s)
[821.571413] Starting dynamic subtest: ring_submission
[825.945315] Dynamic subtest ring_submission: SUCCESS (4.386s)
[825.955236] Starting dynamic subtest: perf
[830.345136] Dynamic subtest perf: SUCCESS (4.398s)
[830.355315] Starting dynamic subtest: slpc
[844.351560] Dynamic subtest slpc: SUCCESS (14.002s)
[844.368411] Starting dynamic subtest: guc
[848.296953] Dynamic subtest guc: SUCCESS (3.941s)
[848.307105] Starting dynamic subtest: guc_multi_lrc
[852.606940] Dynamic subtest guc_multi_lrc: SUCCESS (4.307s)
[852.617145] Starting dynamic subtest: guc_hang
[857.417626] Dynamic subtest guc_hang: SUCCESS (4.808s)
[857.432482] Starting dynamic subtest: late_gt_pm
[860.098139] Dynamic subtest late_gt_pm: SUCCESS (2.679s)
[860.100770] Subtest live: SUCCESS (235.873s)
[860.127282] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[860.128005] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[860.131031] [092/133] (167s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[861.691161] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[861.695524] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[861.805436] [FACT kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[861.806681] [FACT kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)] new: kernel.kmod_is_loaded.i915: true
[861.810469] [093/133] (166s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[861.901765] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[861.903632] Starting dynamic subtest: pipe-A-eDP-1
[861.968369] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.068s)
[861.977990] Starting dynamic subtest: pipe-B-eDP-1
[862.033539] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.064s)
[862.042508] Starting dynamic subtest: pipe-C-eDP-1
[862.096242] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.061s)
[862.105075] Starting dynamic subtest: pipe-D-eDP-1
[862.158239] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.061s)
[862.160568] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.259s)
[864.398543] [094/133] (163s left) perf (polling)
[864.555536] Starting subtest: polling
[864.557888] Starting dynamic subtest: 0-rcs0
[874.587984] Dynamic subtest 0-rcs0: SUCCESS (10.032s)
[874.597561] Starting dynamic subtest: 1-vecs0
[884.608565] Dynamic subtest 1-vecs0: SUCCESS (10.021s)
[884.611626] Subtest polling: SUCCESS (20.056s)
[884.658925] [095/133] (143s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[884.767636] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[888.393208] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.632s)
[889.588050] [096/133] (138s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[889.656434] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[889.658460] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[889.749081] [097/133] (138s left) kms_prime (basic-crc-hybrid)
[889.833456] Subtest basic-crc-hybrid: SKIP (0.000s)
[889.928492] [098/133] (138s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[890.053038] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[890.057562] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[890.232926] [099/133] (137s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[890.339020] Starting subtest: x-tiled-8bpp-rotate-90
[890.365291] Subtest x-tiled-8bpp-rotate-90: SKIP (0.025s)
[890.502574] [100/133] (137s left) gen9_exec_parse (unaligned-jump)
[890.563934] Subtest unaligned-jump: SKIP (0.000s)
[890.642834] [101/133] (137s left) perf_pmu (semaphore-wait)
[890.681597] Starting subtest: semaphore-wait
[890.683341] Starting dynamic subtest: rcs0
[891.197506] Dynamic subtest rcs0: SUCCESS (0.515s)
[891.209306] Starting dynamic subtest: bcs0
[891.710567] Dynamic subtest bcs0: SUCCESS (0.510s)
[891.723058] Starting dynamic subtest: vcs0
[892.224799] Dynamic subtest vcs0: SUCCESS (0.511s)
[892.237081] Starting dynamic subtest: vcs1
[892.738187] Dynamic subtest vcs1: SUCCESS (0.510s)
[892.750287] Starting dynamic subtest: vecs0
[893.251560] Dynamic subtest vecs0: SUCCESS (0.511s)
[893.263764] Starting dynamic subtest: ccs0
[893.768110] Dynamic subtest ccs0: SUCCESS (0.513s)
[893.770927] Subtest semaphore-wait: SUCCESS (3.089s)
[893.886050] [102/133] (134s left) syncobj_wait (invalid-reset-one-illegal-handle)
[893.946839] Starting subtest: invalid-reset-one-illegal-handle
[893.949018] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[894.050897] [103/133] (134s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[894.109980] Starting subtest: yf-tiled-to-vebox-yf-tiled
[894.114283] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[894.296040] [104/133] (134s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[894.394741] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[894.396968] Starting dynamic subtest: A-eDP1
[898.024750] Dynamic subtest A-eDP1: SUCCESS (3.628s)
[898.034261] Starting dynamic subtest: B-eDP1
[901.216658] Dynamic subtest B-eDP1: SUCCESS (3.190s)
[901.226223] Starting dynamic subtest: C-eDP1
[904.410128] Dynamic subtest C-eDP1: SUCCESS (3.192s)
[904.424343] Starting dynamic subtest: D-eDP1
[907.601591] Dynamic subtest D-eDP1: SUCCESS (3.192s)
[907.604167] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.210s)
[908.411854] [105/133] (119s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[908.499088] Starting subtest: fbcpsr-rgb101010-draw-render
[915.304798] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.809s)
[915.430028] [106/133] (113s left) i915_drm_fdinfo (virtual-busy-idle-all)
[915.471845] Starting subtest: virtual-busy-idle-all
[915.476345] Subtest virtual-busy-idle-all: SKIP (0.000s)
[915.537862] [107/133] (112s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[915.600717] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[915.660706] [108/133] (112s left) kms_psr (fbc-psr-dpms)
[915.755114] Starting subtest: fbc-psr-dpms
[915.757255] Starting dynamic subtest: eDP-1
[915.761185] Dynamic subtest eDP-1: SKIP (0.000s)
[915.765151] Subtest fbc-psr-dpms: SKIP (0.001s)
[915.828330] [109/133] (112s left) gem_render_linear_blits (basic)
[915.891550] Starting subtest: basic
[915.917201] Subtest basic: SUCCESS (0.026s)
[916.002832] [110/133] (112s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[916.104873] Starting subtest: psr-rgb101010-draw-pwrite
[923.901881] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.801s)
[924.030062] [111/133] (104s left) intel_hwmon (hwmon-read)
[924.083468] Subtest hwmon-read: SKIP (0.000s)
[924.146043] [112/133] (104s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[924.238860] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[924.241059] Starting dynamic subtest: pipe-A-eDP-1
[935.226091] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.990s)
[935.236094] Starting dynamic subtest: pipe-B-eDP-1
[946.956654] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.731s)
[946.958817] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.724s)
[947.822196] [113/133] ( 80s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[947.920218] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[955.433645] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.516s)
[955.570411] [114/133] ( 73s left) gem_ctx_persistence (processes)
[955.629265] Starting subtest: processes
[957.545164] Subtest processes: SUCCESS (1.915s)
[957.638465] [115/133] ( 71s left) gem_exec_reloc (basic-gtt)
[957.702011] Subtest basic-gtt: SKIP (0.000s)
[957.782775] [116/133] ( 71s left) syncobj_eventfd (invalid-bad-flags)
[957.868663] Starting subtest: invalid-bad-flags
[957.870939] Subtest invalid-bad-flags: SUCCESS (0.000s)
[957.978443] [117/133] ( 70s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[958.071284] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[958.075812] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[958.177831] [118/133] ( 70s left) kms_atomic (crtc-invalid-params-fence)
[958.267566] Starting subtest: crtc-invalid-params-fence
[958.269848] Starting dynamic subtest: pipe-A-eDP-1
[958.692483] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.424s)
[958.694894] Subtest crtc-invalid-params-fence: SUCCESS (0.425s)
[959.502326] [119/133] ( 69s left) dumb_buffer (map-valid)
[959.577295] Starting subtest: map-valid
[959.579367] Subtest map-valid: SUCCESS (0.000s)
[959.668542] [120/133] ( 69s left) gem_exec_reloc (basic-wc-read-active)
[959.726113] Subtest basic-wc-read-active: SKIP (0.000s)
[959.797679] [121/133] ( 69s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[959.900287] Starting subtest: psr-1p-pri-indfb-multidraw
[983.171550] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (23.274s)
[983.295263] [122/133] ( 45s left) kms_color_pipeline (plane-ctm3x4)
[983.392549] Starting subtest: plane-ctm3x4
[983.538803] Starting dynamic subtest: pipe-A-plane-0
[983.833272] Dynamic subtest pipe-A-plane-0: FAIL (0.155s)
[983.843958] Starting dynamic subtest: pipe-A-plane-1
[984.022651] Dynamic subtest pipe-A-plane-1: FAIL (0.146s)
[984.033529] Starting dynamic subtest: pipe-A-plane-2
[984.236490] Dynamic subtest pipe-A-plane-2: FAIL (0.159s)
[985.251754] Starting dynamic subtest: pipe-B-plane-0
[985.646844] Dynamic subtest pipe-B-plane-0: FAIL (0.142s)
[985.657170] Starting dynamic subtest: pipe-B-plane-1
[985.951827] Dynamic subtest pipe-B-plane-1: FAIL (0.143s)
[985.962870] Starting dynamic subtest: pipe-B-plane-2
[986.266013] Dynamic subtest pipe-B-plane-2: FAIL (0.155s)
[986.878844] Starting dynamic subtest: pipe-C-plane-0
[987.363852] Dynamic subtest pipe-C-plane-0: FAIL (0.140s)
[987.374860] Starting dynamic subtest: pipe-C-plane-1
[987.760311] Dynamic subtest pipe-C-plane-1: FAIL (0.133s)
[987.771158] Starting dynamic subtest: pipe-C-plane-2
[988.120685] Dynamic subtest pipe-C-plane-2: FAIL (0.606s)
[989.019833] Starting dynamic subtest: pipe-D-plane-0
[989.569480] Dynamic subtest pipe-D-plane-0: FAIL (0.118s)
[989.581347] Starting dynamic subtest: pipe-D-plane-1
[990.018570] Dynamic subtest pipe-D-plane-1: FAIL (0.609s)
[990.030127] Starting dynamic subtest: pipe-D-plane-2
[990.455769] Dynamic subtest pipe-D-plane-2: FAIL (0.536s)
[990.583622] Subtest plane-ctm3x4: FAIL (7.190s)
[991.462717] [123/133] ( 37s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[991.564642] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[991.568748] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[991.637166] [124/133] ( 37s left) gem_exec_big (single)
[991.695680] Starting subtest: single
[995.139848] Subtest single: FAIL (3.384s)
[995.181294] [125/133] ( 34s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[995.335643] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[995.337924] Starting dynamic subtest: pipe-A-default-mode
[998.122573] Dynamic subtest pipe-A-default-mode: SUCCESS (2.788s)
[998.125111] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.789s)
[998.962136] [126/133] ( 30s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[999.056648] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[999.061296] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[999.150170] [127/133] ( 30s left) gem_exec_fence (syncobj-channel)
[999.579169] Starting subtest: syncobj-channel
[1000.598492] Subtest syncobj-channel: SUCCESS (1.015s)
[1000.891235] [128/133] ( 28s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[1000.990371] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[1000.994996] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[1001.083822] [129/133] ( 28s left) gem_pwrite (basic-random)
[1001.143162] Subtest basic-random: SKIP (0.000s)
[1001.211879] [130/133] ( 28s left) syncobj_wait (reset-unsignaled)
[1001.288718] Starting subtest: reset-unsignaled
[1001.290760] Subtest reset-unsignaled: SUCCESS (0.000s)
[1001.379657] [131/133] ( 28s left) api_intel_allocator (reloc-allocator)
[1001.430180] Starting subtest: reloc-allocator
[1001.432482] Starting dynamic subtest: basic
[1001.434867] Dynamic subtest basic: SUCCESS (0.005s)
[1001.447125] Starting dynamic subtest: parallel-one
[1001.449502] Dynamic subtest parallel-one: SUCCESS (0.007s)
[1001.461466] Starting dynamic subtest: print
[1001.463791] Dynamic subtest print: SUCCESS (0.000s)
[1001.474359] Starting dynamic subtest: reuse
[1001.476728] Dynamic subtest reuse: SUCCESS (0.000s)
[1001.486170] Starting dynamic subtest: fork-reopen-allocator
[1001.488450] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[1001.490769] Subtest reloc-allocator: SUCCESS (0.027s)
[1001.588731] [132/133] ( 27s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[1001.693195] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[1002.717071] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.024s)
[1002.855832] [133/133] ( 26s left) gen9_exec_parse (allowed-single)
[1002.925828] Subtest allowed-single: SKIP (0.000s)
[1003.010623] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_addfb_basic
results: parsing output: 2/ for test: kms_chamelium_audio
results: parsing output: 3/ for test: gem_lmem_swapping
results: parsing output: 4/ for test: kms_sequence
results: parsing output: 5/ for test: gem_mmap_offset
results: parsing output: 6/ for test: gem_mmap
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: gem_ctx_bad_destroy
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: kms_vblank
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: syncobj_wait
results: parsing output: 14/ for test: gem_wait
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_content_protection
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_cursor_legacy
results: parsing output: 20/ for test: gem_userptr_blits
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_cursor_legacy
results: parsing output: 25/ for test: prime_mmap
results: parsing output: 26/ for test: gem_ctx_param
results: parsing output: 27/ for test: perf_pmu
results: parsing output: 28/ for test: kms_hdr
results: parsing output: 29/ for test: kms_cursor_edge_walk
results: parsing output: 30/ for test: i915_pm_rpm
results: parsing output: 31/ for test: gem_linear_blits
results: parsing output: 32/ for test: kms_setmode
results: parsing output: 33/ for test: gem_exec_schedule
results: parsing output: 34/ for test: dumb_buffer
results: parsing output: 35/ for test: kms_chamelium_hpd
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: kms_getfb
results: parsing output: 38/ for test: kms_plane_scaling
results: parsing output: 39/ for test: kms_lease
results: parsing output: 40/ for test: kms_addfb_basic
results: parsing output: 41/ for test: gem_exec_schedule
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_flip_scaled_crc
results: parsing output: 44/ for test: perf
results: parsing output: 45/ for test: gem_lmem_swapping
results: parsing output: 46/ for test: gem_create
results: parsing output: 47/ for test: api_intel_bb
results: parsing output: 48/ for test: kms_pipe_crc_basic
results: parsing output: 49/ for test: gem_exec_whisper
results: parsing output: 50/ for test: gem_exec_balancer
results: parsing output: 51/ for test: kms_dp_link_training
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: gem_exec_flush
results: parsing output: 55/ for test: kms_cursor_legacy
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: drm_read
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: vgem_basic
results: parsing output: 61/ for test: gem_exec_params
results: parsing output: 62/ for test: kms_pm_dc
results: parsing output: 63/ for test: kms_addfb_basic
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_softpin
results: parsing output: 66/ for test: kms_cursor_legacy
results: parsing output: 67/ for test: kms_flip
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: perf_pmu
results: parsing output: 70/ for test: kms_plane
results: parsing output: 71/ for test: gem_ctx_param
results: parsing output: 72/ for test: gem_eio
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_pxp
results: parsing output: 75/ for test: drm_read
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: kms_plane_scaling
results: parsing output: 78/ for test: kms_plane
results: parsing output: 79/ for test: gem_exec_alignment
results: parsing output: 80/ for test: kms_cursor_crc
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: gen3_render_tiledx_blits
results: parsing output: 85/ for test: kms_cursor_crc
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_userptr_blits
results: parsing output: 89/ for test: kms_chamelium_frames
results: parsing output: 90/ for test: i915_selftest
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: perf
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: kms_prime
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: gen9_exec_parse
results: parsing output: 100/ for test: perf_pmu
results: parsing output: 101/ for test: syncobj_wait
results: parsing output: 102/ for test: gem_render_copy
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: i915_drm_fdinfo
results: parsing output: 106/ for test: kms_pipe_b_c_ivb
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: gem_render_linear_blits
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: intel_hwmon
results: parsing output: 111/ for test: kms_psr2_sf
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_ctx_persistence
results: parsing output: 114/ for test: gem_exec_reloc
results: parsing output: 115/ for test: syncobj_eventfd
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_atomic
results: parsing output: 118/ for test: dumb_buffer
results: parsing output: 119/ for test: gem_exec_reloc
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_color_pipeline
results: parsing output: 122/ for test: kms_psr2_sf
results: parsing output: 123/ for test: gem_exec_big
results: parsing output: 124/ for test: kms_flip_scaled_crc
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_exec_fence
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: gem_pwrite
results: parsing output: 129/ for test: syncobj_wait
results: parsing output: 130/ for test: api_intel_allocator
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: gen9_exec_parse
Done.