[59.762137] Initializing watchdogs
[59.762179]   /dev/watchdog0
[59.776181] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[59.780045] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.782057] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.785459] [001/133] (960s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[59.886182] Starting subtest: nonblocking-crc-frame-sequence
[59.888913] Starting dynamic subtest: pipe-A-eDP-1
[60.659229] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.771s)
[60.668842] Starting dynamic subtest: pipe-B-eDP-1
[62.071762] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.412s)
[62.080197] Starting dynamic subtest: pipe-C-eDP-1
[63.469497] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.396s)
[63.478303] Starting dynamic subtest: pipe-D-eDP-1
[64.797062] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.325s)
[64.799473] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.908s)
[65.587453] [002/133] (954s left) i915_module_load (reload)
[65.624604] Starting subtest: reload
[70.482046] Subtest reload: SUCCESS (4.857s)
[70.517166] [003/133] (949s left) gem_eio (in-flight-1us)
[71.888895] Starting subtest: in-flight-1us
[79.695920] Subtest in-flight-1us: SUCCESS (7.805s)
[79.890103] [FACT gem_eio (in-flight-1us)] new: kernel.kmod_is_loaded.vgem: true
[79.893270] [004/133] (940s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[79.986284] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[81.064710] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.078s)
[81.173936] [005/133] (939s left) kms_addfb_basic (bad-pitch-1024)
[81.227111] Starting subtest: bad-pitch-1024
[81.228836] Subtest bad-pitch-1024: SUCCESS (0.000s)
[81.355372] [006/133] (939s left) kms_getfb (getfb2-handle-zero)
[81.430186] Starting subtest: getfb2-handle-zero
[81.432052] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[81.543538] [007/133] (938s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[81.590738] Starting subtest: single-wait-all-for-submit-signaled
[81.592764] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.001s)
[81.713648] [008/133] (938s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[81.764253] Starting subtest: invalid-multi-wait-all-unsubmitted
[81.766138] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[81.877113] [009/133] (938s left) kms_atomic_interruptible (universal-setplane-cursor)
[81.970213] Starting subtest: universal-setplane-cursor
[81.972259] Starting dynamic subtest: pipe-A-eDP-1
[89.384625] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.411s)
[89.386929] Subtest universal-setplane-cursor: SUCCESS (7.412s)
[90.232576] [010/133] (930s left) gem_exec_reloc (basic-wc-cpu)
[90.310998] Subtest basic-wc-cpu: SKIP (0.000s)
[90.390977] [011/133] (930s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[90.475567] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[90.480174] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[90.592943] [012/133] (930s left) gem_pxp (hw-rejects-pxp-buffer)
[90.724826] Starting subtest: hw-rejects-pxp-buffer
[90.729939] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[90.845130] [013/133] (929s left) gem_exec_balancer (invalid-bonds)
[90.917689] Starting subtest: invalid-bonds
[90.922239] Subtest invalid-bonds: SKIP (0.001s)
[91.223920] [014/133] (929s left) gem_exec_whisper (basic-forked-all)
[91.288339] Starting subtest: basic-forked-all
[105.132580] Subtest basic-forked-all: SUCCESS (13.841s)
[105.324398] [015/133] (915s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[105.402520] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[111.965772] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.567s)
[112.132153] [016/133] (908s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[112.216286] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[119.069896] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.856s)
[119.232750] [017/133] (901s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[119.317440] Starting subtest: psr-rgb565-draw-render
[126.262748] Subtest psr-rgb565-draw-render: SUCCESS (6.949s)
[126.418667] [018/133] (894s left) kms_psr (pr-cursor-mmap-cpu)
[126.506900] Starting subtest: pr-cursor-mmap-cpu
[126.511347] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[126.595266] [019/133] (894s left) gem_close_race (basic-process)
[126.659704] Starting subtest: basic-process
[126.728975] Subtest basic-process: SUCCESS (0.069s)
[126.923424] [020/133] (894s left) syncobj_timeline (etime-single-wait-all-submitted)
[126.983317] Starting subtest: etime-single-wait-all-submitted
[127.085344] Subtest etime-single-wait-all-submitted: SUCCESS (0.102s)
[127.171716] [021/133] (893s left) kms_cursor_crc (cursor-random-128x42)
[127.398044] Starting subtest: cursor-random-128x42
[127.445309] Subtest cursor-random-128x42: SKIP (0.042s)
[127.683049] [022/133] (893s left) syncobj_timeline (invalid-wait-bad-flags)
[127.740062] Starting subtest: invalid-wait-bad-flags
[127.742360] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[127.858752] [023/133] (893s left) gem_sync (basic-all)
[127.942801] Starting subtest: basic-all
[130.398450] Subtest basic-all: SUCCESS (2.467s)
[130.596434] [024/133] (890s left) kms_big_fb (linear-16bpp-rotate-90)
[130.691581] Starting subtest: linear-16bpp-rotate-90
[130.714693] Subtest linear-16bpp-rotate-90: SKIP (0.020s)
[130.859891] [025/133] (890s left) gem_flink_basic (bad-flink)
[130.922350] Starting subtest: bad-flink
[130.924642] Subtest bad-flink: SUCCESS (0.000s)
[131.041865] [026/133] (890s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[131.124406] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[131.128585] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[131.242896] [027/133] (890s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[131.624370] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[132.404370] [028/133] (888s left) gem_exec_fence (syncobj-invalid-wait)
[132.820318] Starting subtest: syncobj-invalid-wait
[132.822983] Subtest syncobj-invalid-wait: SUCCESS (0.000s)
[133.965601] [029/133] (887s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[134.042499] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[134.892653] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.851s)
[135.102463] [030/133] (886s left) gem_exec_schedule (implicit-boths)
[135.190770] Starting subtest: implicit-boths
[135.193027] Starting dynamic subtest: rcs0
[135.295428] Dynamic subtest rcs0: SUCCESS (0.111s)
[135.306670] Starting dynamic subtest: vcs0
[135.373724] Dynamic subtest vcs0: SUCCESS (0.078s)
[135.384171] Starting dynamic subtest: vcs1
[135.451808] Dynamic subtest vcs1: SUCCESS (0.078s)
[135.463026] Starting dynamic subtest: vecs0
[135.527396] Dynamic subtest vecs0: SUCCESS (0.075s)
[135.538700] Starting dynamic subtest: ccs0
[135.615032] Dynamic subtest ccs0: SUCCESS (0.087s)
[135.617650] Subtest implicit-boths: SUCCESS (0.432s)
[136.990262] [031/133] (884s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[137.078641] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[138.057599] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (0.979s)
[138.238655] [032/133] (883s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[138.326193] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[138.330236] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[138.446719] [033/133] (883s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[138.526973] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[138.530859] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[138.635901] [034/133] (882s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[138.709905] Starting subtest: fbc-rgb101010-draw-blt
[143.349254] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.641s)
[144.530823] [035/133] (877s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[144.619220] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[144.621672] Starting dynamic subtest: pipe-A
[144.681951] Dynamic subtest pipe-A: SUCCESS (0.065s)
[144.692624] Starting dynamic subtest: pipe-B
[145.833947] Dynamic subtest pipe-B: SUCCESS (1.151s)
[145.849072] Starting dynamic subtest: pipe-C
[146.946358] Dynamic subtest pipe-C: SUCCESS (1.111s)
[146.955781] Starting dynamic subtest: pipe-D
[148.074955] Dynamic subtest pipe-D: SUCCESS (1.128s)
[148.077336] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.458s)
[149.254452] [036/133] (872s left) gem_userptr_blits (probe)
[149.325743] Starting subtest: probe
[149.393085] Subtest probe: SUCCESS (0.069s)
[149.523523] [037/133] (872s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[149.604771] Starting subtest: yf-tiled-8bpp-rotate-270
[149.608972] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[149.711380] [038/133] (872s left) gem_eio (wait-wedge-1us)
[149.940018] Starting subtest: wait-wedge-1us
[150.944284] Subtest wait-wedge-1us: SUCCESS (1.004s)
[151.090424] [039/133] (870s left) syncobj_wait (invalid-signal-one-illegal-handle)
[151.158894] Starting subtest: invalid-signal-one-illegal-handle
[151.161304] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[151.287516] [040/133] (870s left) gem_exec_parallel (basic)
[151.349495] Starting subtest: basic
[151.351919] Starting dynamic subtest: rcs0
[152.801071] Dynamic subtest rcs0: SUCCESS (1.451s)
[152.810612] Starting dynamic subtest: bcs0
[154.268733] Dynamic subtest bcs0: SUCCESS (1.465s)
[154.277547] Starting dynamic subtest: vcs0
[155.824936] Dynamic subtest vcs0: SUCCESS (1.553s)
[155.833571] Starting dynamic subtest: vcs1
[157.785424] Dynamic subtest vcs1: SUCCESS (1.960s)
[157.796053] Starting dynamic subtest: vecs0
[159.833411] Dynamic subtest vecs0: SUCCESS (2.046s)
[159.845044] Starting dynamic subtest: ccs0
[161.330898] Dynamic subtest ccs0: SUCCESS (1.496s)
[161.333588] Subtest basic: SUCCESS (9.981s)
[161.526831] [041/133] (860s left) gem_ccs (ctrl-surf-copy)
[161.594171] Starting subtest: ctrl-surf-copy
[161.598644] Subtest ctrl-surf-copy: SKIP (0.000s)
[161.723842] [042/133] (860s left) gem_exec_fence (basic-busy-all)
[161.799272] Starting subtest: basic-busy-all
[161.919054] Subtest basic-busy-all: SUCCESS (0.120s)
[163.972612] [043/133] (857s left) kms_psr (psr2-primary-blt)
[164.066834] Starting subtest: psr2-primary-blt
[164.070576] Starting dynamic subtest: eDP-1
[165.837232] Dynamic subtest eDP-1: SUCCESS (1.770s)
[165.839628] Subtest psr2-primary-blt: SUCCESS (1.771s)
[166.716771] [044/133] (855s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[166.768166] Starting subtest: single-wait-for-submit-unsubmitted
[166.876883] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[166.962543] [045/133] (855s left) kms_flip (flip-vs-rmfb-interruptible)
[167.038620] Starting subtest: flip-vs-rmfb-interruptible
[167.040793] Starting dynamic subtest: A-eDP1
[175.688311] Dynamic subtest A-eDP1: SUCCESS (8.648s)
[175.697018] Starting dynamic subtest: B-eDP1
[184.330177] Dynamic subtest B-eDP1: SUCCESS (8.640s)
[184.340051] Starting dynamic subtest: C-eDP1
[192.952307] Dynamic subtest C-eDP1: SUCCESS (8.620s)
[192.961205] Starting dynamic subtest: D-eDP1
[201.580958] Dynamic subtest D-eDP1: SUCCESS (8.627s)
[201.585794] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.547s)
[202.792392] [046/133] (819s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[202.907395] Starting subtest: cursor-vs-flip-varying-size
[233.603508] Subtest cursor-vs-flip-varying-size: SUCCESS (30.694s)
[234.414835] [047/133] (787s left) i915_query (hwconfig_table)
[234.482723] Starting subtest: hwconfig_table
[234.780283] Subtest hwconfig_table: SUCCESS (0.001s)
[234.818968] [048/133] (787s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[234.904998] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[234.909308] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[235.039988] [049/133] (787s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[235.153318] Starting subtest: cursorB-vs-flipB-atomic
[235.157626] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[235.310169] [050/133] (786s left) gen9_exec_parse (valid-registers)
[235.376282] Subtest valid-registers: SKIP (0.000s)
[235.453695] [051/133] (786s left) kms_addfb_basic (bo-too-small)
[235.527352] Starting subtest: bo-too-small
[235.529251] Subtest bo-too-small: SUCCESS (0.000s)
[235.652153] [052/133] (786s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[235.732036] Starting subtest: y-tiled-8bpp-rotate-0
[235.735506] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[235.833743] [053/133] (786s left) gem_linear_blits (interruptible)
[236.287467] Starting subtest: interruptible
[240.708120] Subtest interruptible: SUCCESS (4.423s)
[240.821918] [054/133] (781s left) gem_create (hog-create)
[240.909962] Starting subtest: hog-create
[240.912224] Starting dynamic subtest: smem0
[273.919585] Dynamic subtest smem0: SUCCESS (33.006s)
[273.922533] Subtest hog-create: SUCCESS (33.008s)
[274.113292] [055/133] (748s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[274.181395] Starting subtest: multi-wait-all-for-submit-submitted
[274.283515] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.101s)
[274.373721] [056/133] (748s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[274.474028] Starting subtest: fbcpsr-rgb565-draw-pwrite
[281.475750] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (7.007s)
[281.614712] [057/133] (740s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[281.698060] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[281.700427] Starting dynamic subtest: pipe-A-eDP-1
[281.762452] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.065s)
[281.772307] Starting dynamic subtest: pipe-B-eDP-1
[281.823671] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.060s)
[281.833084] Starting dynamic subtest: pipe-C-eDP-1
[281.885306] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.059s)
[281.894770] Starting dynamic subtest: pipe-D-eDP-1
[281.944638] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.060s)
[281.946820] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.249s)
[284.101953] [058/133] (738s left) gem_exec_balancer (parallel-ordering)
[284.376859] Starting subtest: parallel-ordering
[285.288532] Subtest parallel-ordering: SUCCESS (0.914s)
[285.443536] [059/133] (737s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[285.533550] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[290.085582] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.552s)
[291.258836] [060/133] (731s left) kms_addfb_basic (basic-x-tiled-legacy)
[291.334646] Starting subtest: basic-x-tiled-legacy
[291.339302] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[291.472491] [061/133] (731s left) perf (polling)
[291.624591] Starting subtest: polling
[291.626850] Starting dynamic subtest: 0-rcs0
[301.636653] Dynamic subtest 0-rcs0: SUCCESS (10.010s)
[301.647396] Starting dynamic subtest: 1-vcs1
[311.657583] Dynamic subtest 1-vcs1: SUCCESS (10.020s)
[311.660315] Subtest polling: SUCCESS (20.033s)
[311.708035] [062/133] (711s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[311.792875] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[311.794978] Starting dynamic subtest: pipe-A-eDP-1
[313.977204] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.185s)
[313.985733] Starting dynamic subtest: pipe-B-eDP-1
[316.197594] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.218s)
[316.208839] Starting dynamic subtest: pipe-C-eDP-1
[318.253135] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.054s)
[318.263078] Starting dynamic subtest: pipe-D-eDP-1
[320.307998] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.054s)
[320.310365] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.517s)
[321.531441] [063/133] (701s left) api_intel_bb (simple-bb-ctx)
[321.611623] Starting subtest: simple-bb-ctx
[321.619598] Subtest simple-bb-ctx: SUCCESS (0.009s)
[321.766308] [064/133] (701s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[321.847868] Starting subtest: plane-primary-overlay-mutable-zpos
[325.251237] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.403s)
[326.447363] [065/133] (696s left) kms_pm_rpm (pm-caching)
[327.961574] Starting subtest: pm-caching
[327.966931] Subtest pm-caching: SKIP (0.000s)
[328.677516] [066/133] (694s left) gem_ctx_persistence (engines-hang)
[328.742781] Starting subtest: engines-hang
[328.745207] Starting dynamic subtest: rcs0
[328.852271] Dynamic subtest rcs0: SUCCESS (0.109s)
[328.865134] Starting dynamic subtest: bcs0
[328.916235] Dynamic subtest bcs0: SUCCESS (0.062s)
[328.927708] Starting dynamic subtest: vcs0
[329.023956] Dynamic subtest vcs0: SUCCESS (0.105s)
[329.035815] Starting dynamic subtest: vcs1
[329.136212] Dynamic subtest vcs1: SUCCESS (0.110s)
[329.147811] Starting dynamic subtest: vecs0
[329.252211] Dynamic subtest vecs0: SUCCESS (0.114s)
[329.264129] Starting dynamic subtest: ccs0
[329.364986] Dynamic subtest ccs0: SUCCESS (0.111s)
[329.367795] Subtest engines-hang: SUCCESS (0.623s)
[329.474410] [067/133] (693s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[329.560877] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[329.563217] Starting dynamic subtest: pipe-A
[329.578715] Dynamic subtest pipe-A: SKIP (0.015s)
[329.589396] Starting dynamic subtest: pipe-B
[329.605780] Dynamic subtest pipe-B: SKIP (0.027s)
[329.615027] Starting dynamic subtest: pipe-C
[329.634473] Dynamic subtest pipe-C: SKIP (0.028s)
[329.643439] Starting dynamic subtest: pipe-D
[329.661091] Dynamic subtest pipe-D: SKIP (0.027s)
[329.664877] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.100s)
[329.793622] [068/133] (693s left) api_intel_allocator (fork-simple-once)
[329.852447] Starting subtest: fork-simple-once
[329.865795] Subtest fork-simple-once: SUCCESS (0.015s)
[330.034988] [069/133] (693s left) gem_pread (self)
[330.101327] Subtest self: SKIP (0.000s)
[330.171455] [070/133] (692s left) gem_exec_schedule (preempt-other-chain)
[330.244789] Starting subtest: preempt-other-chain
[330.246374] Starting dynamic subtest: rcs0
[330.324200] Dynamic subtest rcs0: SUCCESS (0.080s)
[330.335519] Starting dynamic subtest: bcs0
[330.407597] Dynamic subtest bcs0: SUCCESS (0.083s)
[330.416557] Starting dynamic subtest: vcs0
[330.489135] Dynamic subtest vcs0: SUCCESS (0.081s)
[330.498442] Starting dynamic subtest: vcs1
[330.569187] Dynamic subtest vcs1: SUCCESS (0.079s)
[330.581161] Starting dynamic subtest: vecs0
[330.648123] Dynamic subtest vecs0: SUCCESS (0.078s)
[330.658310] Starting dynamic subtest: ccs0
[330.728854] Dynamic subtest ccs0: SUCCESS (0.080s)
[330.730820] Subtest preempt-other-chain: SUCCESS (0.486s)
[332.011938] [071/133] (691s left) gem_ctx_persistence (legacy-engines-mixed)
[332.073881] Starting subtest: legacy-engines-mixed
[332.076217] Starting dynamic subtest: render
[332.172372] Dynamic subtest render: SUCCESS (0.097s)
[332.184859] Starting dynamic subtest: bsd1
[332.254876] Dynamic subtest bsd1: SUCCESS (0.080s)
[332.270212] Starting dynamic subtest: bsd2
[332.320949] Dynamic subtest bsd2: SUCCESS (0.063s)
[332.333602] Starting dynamic subtest: blt
[332.408357] Dynamic subtest blt: SUCCESS (0.085s)
[332.420889] Starting dynamic subtest: vebox
[332.493304] Dynamic subtest vebox: SUCCESS (0.082s)
[332.496070] Subtest legacy-engines-mixed: SUCCESS (0.420s)
[332.587562] [072/133] (690s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[332.675128] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[339.464201] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.791s)
[339.610269] [073/133] (683s left) gem_mmap_gtt (bad-object)
[339.674190] Subtest bad-object: SKIP (0.000s)
[339.738563] [074/133] (683s left) kms_psr (fbc-psr-basic)
[339.826619] Starting subtest: fbc-psr-basic
[339.829412] Starting dynamic subtest: eDP-1
[339.834235] Dynamic subtest eDP-1: SKIP (0.000s)
[339.838781] Subtest fbc-psr-basic: SKIP (0.001s)
[339.908163] [075/133] (683s left) gem_userptr_blits (access-control)
[339.984339] Starting subtest: access-control
[339.988564] Subtest access-control: SKIP (0.000s)
[340.121415] [076/133] (683s left) gem_ctx_param (non-root-set)
[340.178505] Starting subtest: non-root-set
[340.199686] Subtest non-root-set: SUCCESS (0.021s)
[340.298000] [077/133] (683s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[340.370724] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[347.652345] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.284s)
[347.823535] [078/133] (675s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[347.908937] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[347.911262] Starting dynamic subtest: pipe-A-eDP-1
[347.933391] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[347.943524] Starting dynamic subtest: pipe-B-eDP-1
[347.965066] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[347.973627] Starting dynamic subtest: pipe-C-eDP-1
[347.994504] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[348.003182] Starting dynamic subtest: pipe-D-eDP-1
[348.025097] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[348.029388] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[350.092051] [079/133] (673s left) core_setmaster (master-drop-set-user)
[350.184483] Starting subtest: master-drop-set-user
[350.208159] Subtest master-drop-set-user: SUCCESS (0.026s)
[350.257129] [080/133] (673s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[350.343765] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[350.369644] Starting dynamic subtest: pipe-A-plane-0
[350.374093] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[350.383883] Starting dynamic subtest: pipe-A-plane-3
[350.388208] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[350.397833] Starting dynamic subtest: pipe-A-plane-5
[350.402213] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[351.459635] Starting dynamic subtest: pipe-B-plane-0
[351.463769] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[351.473707] Starting dynamic subtest: pipe-B-plane-3
[351.478056] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[351.487218] Starting dynamic subtest: pipe-B-plane-5
[351.491558] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[351.786811] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (1.440s)
[352.645760] [081/133] (670s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[352.738115] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[352.740473] Starting dynamic subtest: pipe-A-default-mode
[355.461259] Dynamic subtest pipe-A-default-mode: SUCCESS (2.724s)
[355.463638] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.725s)
[356.335109] [082/133] (667s left) syncobj_timeline (reset-unsignaled)
[356.395225] Starting subtest: reset-unsignaled
[356.397424] Subtest reset-unsignaled: SUCCESS (0.000s)
[356.503851] [083/133] (667s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[356.565308] Starting subtest: yf-tiled-to-vebox-x-tiled
[356.569779] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[356.760232] [084/133] (666s left) perf_pmu (busy-idle-check-all)
[356.800027] Starting subtest: busy-idle-check-all
[356.802105] Starting dynamic subtest: rcs0
[357.472366] Dynamic subtest rcs0: SUCCESS (0.673s)
[357.484821] Starting dynamic subtest: bcs0
[358.125060] Dynamic subtest bcs0: SUCCESS (0.650s)
[358.137837] Starting dynamic subtest: vcs0
[359.832053] Dynamic subtest vcs0: SUCCESS (1.703s)
[359.844311] Starting dynamic subtest: vcs1
[361.816650] Dynamic subtest vcs1: SUCCESS (1.981s)
[361.829433] Starting dynamic subtest: vecs0
[363.864157] Dynamic subtest vecs0: SUCCESS (2.044s)
[363.877380] Starting dynamic subtest: ccs0
[364.522281] Dynamic subtest ccs0: SUCCESS (0.657s)
[364.524985] Subtest busy-idle-check-all: SUCCESS (7.725s)
[364.633876] [085/133] (659s left) kms_draw_crc (draw-method-mmap-cpu)
[364.732867] Starting subtest: draw-method-mmap-cpu
[364.735089] Starting dynamic subtest: xrgb8888-untiled
[364.953434] Dynamic subtest xrgb8888-untiled: SUCCESS (0.221s)
[364.963245] Starting dynamic subtest: rgb565-untiled
[365.164716] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[365.174351] Starting dynamic subtest: xrgb2101010-untiled
[365.364587] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.199s)
[365.374458] Starting dynamic subtest: xbgr16161616f-untiled
[365.564218] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.199s)
[365.573469] Starting dynamic subtest: xrgb8888-xtiled
[365.697698] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[365.709215] Starting dynamic subtest: rgb565-xtiled
[365.830661] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s)
[365.840289] Starting dynamic subtest: xrgb2101010-xtiled
[365.953514] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[365.963928] Starting dynamic subtest: xbgr16161616f-xtiled
[366.086741] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[366.096176] Starting dynamic subtest: xrgb8888-4tiled
[366.220148] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[366.231939] Starting dynamic subtest: rgb565-4tiled
[366.364573] Dynamic subtest rgb565-4tiled: SUCCESS (0.142s)
[366.375664] Starting dynamic subtest: xrgb2101010-4tiled
[366.498037] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[366.510074] Starting dynamic subtest: xbgr16161616f-4tiled
[366.653223] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.153s)
[366.655126] Subtest draw-method-mmap-cpu: SUCCESS (1.922s)
[366.782403] [086/133] (656s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[366.870151] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[366.898141] Starting dynamic subtest: pipe-A-plane-0
[367.186843] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[367.195738] Starting dynamic subtest: pipe-A-plane-3
[367.476091] Dynamic subtest pipe-A-plane-3: SUCCESS (0.288s)
[367.487991] Starting dynamic subtest: pipe-A-plane-5
[367.491732] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[368.612673] Starting dynamic subtest: pipe-B-plane-0
[368.859924] Dynamic subtest pipe-B-plane-0: SUCCESS (0.255s)
[368.869897] Starting dynamic subtest: pipe-B-plane-3
[369.094422] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[369.103428] Starting dynamic subtest: pipe-B-plane-5
[369.107911] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[369.406887] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.534s)
[370.300522] [087/133] (653s left) kms_joiner (invalid-modeset-force-big-joiner)
[370.395639] Starting subtest: invalid-modeset-force-big-joiner
[370.399717] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[370.474388] [088/133] (653s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[370.555280] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[370.557429] Starting dynamic subtest: pipe-A-default-mode
[371.748613] Dynamic subtest pipe-A-default-mode: SKIP (1.189s)
[371.753725] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.190s)
[371.941403] [089/133] (651s left) gem_ctx_shared (single-timeline)
[372.003801] Starting subtest: single-timeline
[372.024073] Subtest single-timeline: SUCCESS (0.013s)
[372.293341] [090/133] (651s left) vgem_basic (unload)
[372.326472] Starting subtest: unload
[401.637619] Subtest unload: SUCCESS (29.314s)
[401.752760] [091/133] (622s left) gem_spin_batch (legacy-resubmit-new)
[401.824509] Starting subtest: legacy-resubmit-new
[401.826495] Starting dynamic subtest: default
[401.834626] Dynamic subtest default: SUCCESS (0.013s)
[401.849531] Starting dynamic subtest: render
[401.851773] Dynamic subtest render: SUCCESS (0.006s)
[401.863887] Starting dynamic subtest: bsd
[401.865815] Dynamic subtest bsd: SUCCESS (0.008s)
[401.874840] Starting dynamic subtest: bsd1
[401.877163] Dynamic subtest bsd1: SUCCESS (0.004s)
[401.886219] Starting dynamic subtest: bsd2
[401.888476] Dynamic subtest bsd2: SUCCESS (0.010s)
[401.897391] Starting dynamic subtest: blt
[401.899659] Dynamic subtest blt: SUCCESS (0.007s)
[401.908717] Starting dynamic subtest: vebox
[401.911040] Dynamic subtest vebox: SUCCESS (0.007s)
[401.913231] Subtest legacy-resubmit-new: SUCCESS (0.062s)
[403.927767] [092/133] (620s left) kms_psr (fbc-pr-dpms)
[404.006866] Starting subtest: fbc-pr-dpms
[404.011151] Subtest fbc-pr-dpms: SKIP (0.000s)
[404.090587] [093/133] (619s left) kms_cursor_crc (cursor-offscreen-128x128)
[404.300864] Starting subtest: cursor-offscreen-128x128
[404.305130] Starting dynamic subtest: pipe-A-eDP-1
[406.248591] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.942s)
[406.274854] Starting dynamic subtest: pipe-D-eDP-1
[408.833220] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.563s)
[408.835493] Subtest cursor-offscreen-128x128: SUCCESS (4.532s)
[409.698017] [094/133] (614s left) gem_exec_reloc (basic-cpu)
[409.764066] Subtest basic-cpu: SKIP (0.000s)
[409.858545] [095/133] (614s left) syncobj_wait (invalid-wait-illegal-handle)
[409.927939] Starting subtest: invalid-wait-illegal-handle
[409.930206] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[410.051580] [096/133] (614s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[410.138052] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[414.473952] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.338s)
[415.689927] [097/133] (608s left) gem_ctx_param (set-priority-not-supported)
[415.752918] Starting subtest: set-priority-not-supported
[415.757626] Subtest set-priority-not-supported: SKIP (0.000s)
[415.840522] [098/133] (608s left) kms_chamelium_color (ctm-max)
[415.926165] Subtest ctm-max: SKIP (0.000s)
[415.970587] [099/133] (608s left) sriov_basic (enable-vfs-autoprobe-on)
[416.035311] Starting subtest: enable-vfs-autoprobe-on
[416.037789] Starting dynamic subtest: numvfs-1
[416.121245] Dynamic subtest numvfs-1: FAIL (0.039s)
[416.135794] Starting dynamic subtest: numvfs-2
[416.209219] Dynamic subtest numvfs-2: FAIL (0.004s)
[416.219499] Starting dynamic subtest: numvfs-3
[416.292448] Dynamic subtest numvfs-3: FAIL (0.004s)
[416.302961] Starting dynamic subtest: numvfs-4
[416.374641] Dynamic subtest numvfs-4: FAIL (0.003s)
[416.385249] Starting dynamic subtest: numvfs-5
[416.457947] Dynamic subtest numvfs-5: FAIL (0.004s)
[416.468090] Starting dynamic subtest: numvfs-6
[416.539575] Dynamic subtest numvfs-6: FAIL (0.004s)
[416.550878] Starting dynamic subtest: numvfs-7
[416.619954] Dynamic subtest numvfs-7: FAIL (0.004s)
[416.629449] Starting dynamic subtest: numvfs-random
[416.688693] Dynamic subtest numvfs-random: FAIL (0.004s)
[416.698530] Starting dynamic subtest: numvfs-all
[416.758623] Dynamic subtest numvfs-all: FAIL (0.004s)
[416.760540] Subtest enable-vfs-autoprobe-on: FAIL (0.076s)
[416.796590] [100/133] (607s left) kms_frontbuffer_tracking (fbc-tiling-y)
[416.877518] Starting subtest: fbc-tiling-y
[416.880894] Subtest fbc-tiling-y: SKIP (0.000s)
[416.997127] [101/133] (607s left) kms_cursor_edge_walk (128x128-left-edge)
[417.076426] Starting subtest: 128x128-left-edge
[417.078398] Starting dynamic subtest: pipe-A-eDP-1
[420.535790] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.456s)
[420.545991] Starting dynamic subtest: pipe-D-eDP-1
[423.658359] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.120s)
[423.660668] Subtest 128x128-left-edge: SUCCESS (6.581s)
[424.478515] [102/133] (599s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[424.571348] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[429.039465] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.472s)
[430.189818] [103/133] (594s left) kms_debugfs (display-on-read-all)
[430.270670] Starting subtest: display-on-read-all
[430.438347] Subtest display-on-read-all: SUCCESS (0.167s)
[430.582403] [104/133] (593s left) kms_flip (2x-plain-flip-fb-recreate)
[430.664339] Starting subtest: 2x-plain-flip-fb-recreate
[430.673078] Subtest 2x-plain-flip-fb-recreate: SKIP (0.010s)
[430.766523] [105/133] (593s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[430.849138] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[430.853613] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[430.943943] [106/133] (593s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[431.005429] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[431.007666] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[431.112013] [107/133] (593s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[431.191927] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[431.201103] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.008s)
[431.345132] [108/133] (593s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[431.420107] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[431.421972] Starting dynamic subtest: pipe-A-eDP-1
[431.441361] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[431.451149] Starting dynamic subtest: pipe-B-eDP-1
[431.467475] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.019s)
[431.476518] Starting dynamic subtest: pipe-C-eDP-1
[431.492443] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.019s)
[431.501611] Starting dynamic subtest: pipe-D-eDP-1
[431.518320] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[431.520158] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.083s)
[433.760524] [109/133] (590s left) kms_lease (invalid-create-leases)
[433.842233] Starting subtest: invalid-create-leases
[433.852466] Subtest invalid-create-leases: SUCCESS (0.009s)
[433.980580] [110/133] (590s left) kms_selftest (drm_dp_mst_helper)
[434.026722] Starting subtest: drm_dp_mst_helper
[434.038760] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[434.196593] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.157s)
[434.205648] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[434.355459] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.159s)
[434.364493] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[434.522853] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.166s)
[434.525055] Subtest drm_dp_mst_helper: SUCCESS (0.495s)
[434.720614] [111/133] (590s left) gen7_exec_parse (oacontrol-tracking)
[434.777836] Subtest oacontrol-tracking: SKIP (0.000s)
[434.864470] [112/133] (589s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[434.944303] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[434.948366] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[435.069308] [113/133] (589s left) gem_exec_schedule (thriceslice)
[435.136951] Starting subtest: thriceslice
[435.138925] Starting dynamic subtest: rcs0
[435.180976] Dynamic subtest rcs0: SUCCESS (0.052s)
[435.193843] Starting dynamic subtest: bcs0
[435.234534] Dynamic subtest bcs0: SUCCESS (0.052s)
[435.245995] Starting dynamic subtest: vcs0
[435.265602] Dynamic subtest vcs0: SUCCESS (0.029s)
[435.275582] Starting dynamic subtest: vcs1
[435.294590] Dynamic subtest vcs1: SUCCESS (0.028s)
[435.303764] Starting dynamic subtest: vecs0
[435.324609] Dynamic subtest vecs0: SUCCESS (0.029s)
[435.333779] Starting dynamic subtest: ccs0
[435.354265] Dynamic subtest ccs0: SUCCESS (0.029s)
[435.356498] Subtest thriceslice: SUCCESS (0.227s)
[436.877361] [114/133] (587s left) syncobj_eventfd (invalid-illegal-eventfd)
[436.938654] Starting subtest: invalid-illegal-eventfd
[436.941031] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[437.062436] [115/133] (587s left) kms_psr (psr-sprite-plane-move)
[437.145073] Starting subtest: psr-sprite-plane-move
[437.147383] Starting dynamic subtest: eDP-1
[438.867283] Dynamic subtest eDP-1: SUCCESS (1.723s)
[438.869448] Subtest psr-sprite-plane-move: SUCCESS (1.724s)
[439.706194] [116/133] (585s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[439.780350] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[439.782630] Starting dynamic subtest: pipe-A-eDP-1
[439.805085] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[439.820345] Starting dynamic subtest: pipe-B-eDP-1
[439.841959] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[439.853342] Starting dynamic subtest: pipe-C-eDP-1
[439.874690] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[439.883473] Starting dynamic subtest: pipe-D-eDP-1
[439.905053] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[439.909065] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[442.046232] [117/133] (582s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[444.041327] Starting subtest: gem-execbuf-stress-pc8
[444.082571] Subtest gem-execbuf-stress-pc8: SKIP (0.038s)
[444.416097] [118/133] (580s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[444.510222] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[444.514167] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[444.647845] [119/133] (580s left) sysfs_timeslice_duration (duration)
[444.705719] Starting subtest: duration
[444.708604] Starting dynamic subtest: vecs0
[457.907976] Dynamic subtest vecs0: SUCCESS (13.201s)
[457.920330] Starting dynamic subtest: ccs0
[471.079921] Dynamic subtest ccs0: SUCCESS (13.169s)
[471.092387] Starting dynamic subtest: vcs0
[484.789885] Dynamic subtest vcs0: SUCCESS (13.706s)
[484.801483] Starting dynamic subtest: bcs0
[497.939943] Dynamic subtest bcs0: SUCCESS (13.148s)
[497.952716] Starting dynamic subtest: rcs0
[511.096073] Dynamic subtest rcs0: SUCCESS (13.153s)
[511.108863] Starting dynamic subtest: vcs1
[524.790259] Dynamic subtest vcs1: SUCCESS (13.689s)
[524.793261] Subtest duration: SUCCESS (80.081s)
[524.878769] [120/133] (500s left) gem_gpgpu_fill (basic)
[524.950551] Starting subtest: basic
[524.952908] Starting dynamic subtest: smem
[524.959898] Dynamic subtest smem: SUCCESS (0.010s)
[524.962276] Subtest basic: SUCCESS (0.011s)
[525.124215] [121/133] (500s left) perf (gen12-group-concurrent-oa-buffer-read)
[525.237841] Starting subtest: gen12-group-concurrent-oa-buffer-read
[535.287267] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.047s)
[535.336740] [122/133] (489s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[535.424797] Starting subtest: fbc-pr-sprite-mmap-cpu
[535.429739] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[535.503862] [123/133] (489s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[535.587599] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[535.590076] Starting dynamic subtest: pipe-A-eDP-1
[535.671726] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[535.682809] Starting dynamic subtest: pipe-B-eDP-1
[536.883334] Dynamic subtest pipe-B-eDP-1: SKIP (1.209s)
[536.887610] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.299s)
[538.080058] [124/133] (487s left) kms_content_protection (dp-mst-type-1)
[538.208833] Starting subtest: dp-mst-type-1
[538.213462] Subtest dp-mst-type-1: SKIP (0.000s)
[538.349380] [125/133] (486s left) kms_pm_lpsp (screens-disabled)
[539.436894] Starting subtest: screens-disabled
[539.441098] Subtest screens-disabled: SKIP (0.000s)
[539.517782] [126/133] (485s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[539.598062] Starting subtest: plane-lut1d-pre-ctm3x4
[539.611628] Starting dynamic subtest: pipe-A-eDP-1
[540.314961] Dynamic subtest pipe-A-eDP-1: FAIL (0.305s)
[540.954980] Starting dynamic subtest: pipe-B-eDP-1
[541.755208] Dynamic subtest pipe-B-eDP-1: FAIL (0.290s)
[542.285630] Starting dynamic subtest: pipe-C-eDP-1
[543.090887] Dynamic subtest pipe-C-eDP-1: FAIL (0.235s)
[543.624754] Starting dynamic subtest: pipe-D-eDP-1
[544.430445] Dynamic subtest pipe-D-eDP-1: FAIL (0.235s)
[544.432630] Subtest plane-lut1d-pre-ctm3x4: FAIL (4.538s)
[545.033682] [127/133] (480s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[545.126385] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[545.130293] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[545.204932] [128/133] (480s left) kms_vblank (wait-idle-hang)
[545.271746] Starting subtest: wait-idle-hang
[545.274015] Starting dynamic subtest: pipe-A-eDP-1
[571.709459] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.434s)
[571.723847] Starting dynamic subtest: pipe-D-eDP-1
[586.697555] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.981s)
[586.699757] Subtest wait-idle-hang: SUCCESS (41.424s)
[587.616664] [129/133] (437s left) gem_mmap_gtt (flink-race)
[587.676651] Subtest flink-race: SKIP (0.000s)
[587.749905] [130/133] (437s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[587.821995] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[587.825978] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[587.961608] [131/133] (437s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[588.324186] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[589.177057] [132/133] (436s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[589.251075] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[589.255543] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[589.334512] [133/133] (436s left) kms_addfb_basic (basic)
[589.398594] Starting subtest: basic
[589.400794] Subtest basic: SUCCESS (0.000s)
[589.531418] Closing watchdogs
results: parsing output: 0/ for test: kms_pipe_crc_basic
results: parsing output: 1/ for test: i915_module_load
results: parsing output: 2/ for test: gem_eio
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: kms_addfb_basic
results: parsing output: 5/ for test: kms_getfb
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: syncobj_wait
results: parsing output: 8/ for test: kms_atomic_interruptible
results: parsing output: 9/ for test: gem_exec_reloc
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_pxp
results: parsing output: 12/ for test: gem_exec_balancer
results: parsing output: 13/ for test: gem_exec_whisper
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: gem_close_race
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: kms_cursor_crc
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: gem_sync
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: gem_flink_basic
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_chamelium_hpd
results: parsing output: 27/ for test: gem_exec_fence
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: gem_exec_schedule
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_plane_scaling
results: parsing output: 35/ for test: gem_userptr_blits
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: gem_eio
results: parsing output: 38/ for test: syncobj_wait
results: parsing output: 39/ for test: gem_exec_parallel
results: parsing output: 40/ for test: gem_ccs
results: parsing output: 41/ for test: gem_exec_fence
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: syncobj_wait
results: parsing output: 44/ for test: kms_flip
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: i915_query
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_cursor_legacy
results: parsing output: 49/ for test: gen9_exec_parse
results: parsing output: 50/ for test: kms_addfb_basic
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: gem_linear_blits
results: parsing output: 53/ for test: gem_create
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: gem_exec_balancer
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_addfb_basic
results: parsing output: 60/ for test: perf
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: api_intel_bb
results: parsing output: 63/ for test: kms_atomic
results: parsing output: 64/ for test: kms_pm_rpm
results: parsing output: 65/ for test: gem_ctx_persistence
results: parsing output: 66/ for test: kms_plane_scaling
results: parsing output: 67/ for test: api_intel_allocator
results: parsing output: 68/ for test: gem_pread
results: parsing output: 69/ for test: gem_exec_schedule
results: parsing output: 70/ for test: gem_ctx_persistence
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_mmap_gtt
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: gem_userptr_blits
results: parsing output: 75/ for test: gem_ctx_param
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: core_setmaster
results: parsing output: 79/ for test: kms_plane
results: parsing output: 80/ for test: kms_flip_scaled_crc
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: gem_render_copy
results: parsing output: 83/ for test: perf_pmu
results: parsing output: 84/ for test: kms_draw_crc
results: parsing output: 85/ for test: kms_plane
results: parsing output: 86/ for test: kms_joiner
results: parsing output: 87/ for test: kms_flip_scaled_crc
results: parsing output: 88/ for test: gem_ctx_shared
results: parsing output: 89/ for test: vgem_basic
results: parsing output: 90/ for test: gem_spin_batch
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: gem_exec_reloc
results: parsing output: 94/ for test: syncobj_wait
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_ctx_param
results: parsing output: 97/ for test: kms_chamelium_color
results: parsing output: 98/ for test: sriov_basic
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_cursor_edge_walk
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_debugfs
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: syncobj_wait
results: parsing output: 106/ for test: kms_flip
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: kms_lease
results: parsing output: 109/ for test: kms_selftest
results: parsing output: 110/ for test: gen7_exec_parse
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gem_exec_schedule
results: parsing output: 113/ for test: syncobj_eventfd
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: i915_pm_rpm
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: sysfs_timeslice_duration
results: parsing output: 119/ for test: gem_gpgpu_fill
results: parsing output: 120/ for test: perf
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: kms_psr2_sf
results: parsing output: 123/ for test: kms_content_protection
results: parsing output: 124/ for test: kms_pm_lpsp
results: parsing output: 125/ for test: kms_color_pipeline
results: parsing output: 126/ for test: kms_psr2_sf
results: parsing output: 127/ for test: kms_vblank
results: parsing output: 128/ for test: gem_mmap_gtt
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_chamelium_edid
results: parsing output: 131/ for test: kms_flip_scaled_crc
results: parsing output: 132/ for test: kms_addfb_basic
Done.