[50.842126] Initializing watchdogs
[50.842599]   /dev/watchdog0
[50.875732] [001/142] (960s left) api_intel_allocator (reserve-simple)
[51.288384] Starting subtest: reserve-simple
[51.310566] Subtest reserve-simple: SUCCESS (0.026s)
[51.514393] [002/142] (959s left) prime_self_import (basic-with_one_bo_two_files)
[51.880834] Starting subtest: basic-with_one_bo_two_files
[51.892072] Subtest basic-with_one_bo_two_files: SUCCESS (0.012s)
[52.062662] [003/142] (959s left) gem_mmap_gtt (basic-write-gtt)
[52.434619] Subtest basic-write-gtt: SKIP (0.000s)
[52.536984] [004/142] (959s left) kms_vblank (pipe-d-query-busy)
[53.022374] Starting subtest: pipe-D-query-busy
[57.065919] Subtest pipe-D-query-busy: SUCCESS (4.043s)
[58.001647] [005/142] (953s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[58.548296] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[61.609762] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (3.064s)
[61.912866] [006/142] (949s left) gem_mmap_gtt (basic-read-write)
[62.297883] Subtest basic-read-write: SKIP (0.000s)
[62.399888] [007/142] (949s left) gen9_exec_parse (valid-registers)
[62.820526] Subtest valid-registers: SKIP (0.000s)
[62.920786] [008/142] (948s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[63.427850] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[73.700814] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (10.277s)
[73.971744] [009/142] (937s left) gem_ctx_persistence (legacy-engines-mixed)
[74.373875] Starting subtest: legacy-engines-mixed
[74.377779] Starting dynamic subtest: render
[74.459255] Dynamic subtest render: SUCCESS (0.084s)
[74.497455] Starting dynamic subtest: bsd1
[74.533489] Dynamic subtest bsd1: SUCCESS (0.073s)
[74.569556] Starting dynamic subtest: bsd2
[74.606221] Dynamic subtest bsd2: SUCCESS (0.072s)
[74.640213] Starting dynamic subtest: blt
[74.682401] Dynamic subtest blt: SUCCESS (0.074s)
[74.718639] Starting dynamic subtest: vebox
[74.755429] Dynamic subtest vebox: SUCCESS (0.072s)
[74.759304] Subtest legacy-engines-mixed: SUCCESS (0.382s)
[74.903130] [010/142] (937s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_mtl_rc_ccs_cc)
[76.025818] Starting subtest: pipe-B-crc-primary-basic-4_tiled_mtl_rc_ccs_cc
[77.171256] Subtest pipe-B-crc-primary-basic-4_tiled_mtl_rc_ccs_cc: SUCCESS (1.145s)
[78.843116] [011/142] (933s left) gem_exec_create (madvise)
[79.264412] Starting subtest: madvise
[79.267773] Starting dynamic subtest: smem
[100.735521] Dynamic subtest smem: SUCCESS (21.469s)
[100.739344] Subtest madvise: SUCCESS (21.470s)
[103.468655] [012/142] (908s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[103.986793] Starting subtest: psr-shrfb-scaledprimary
[110.212269] Subtest psr-shrfb-scaledprimary: SUCCESS (6.228s)
[110.381571] [013/142] (901s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[110.874299] Starting subtest: fbcpsr-modesetfrombusy
[116.936483] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.066s)
[117.211367] [014/142] (895s left) i915_pm_lpsp (screens-disabled)
[118.691679] Starting subtest: screens-disabled
[118.698121] Subtest screens-disabled: SKIP (0.000s)
[118.829310] [015/142] (893s left) sysfs_heartbeat_interval (idempotent)
[119.215397] Starting subtest: idempotent
[119.219198] Starting dynamic subtest: vecs0
[119.222816] Dynamic subtest vecs0: SUCCESS (0.006s)
[119.256996] Starting dynamic subtest: ccs0
[119.260699] Dynamic subtest ccs0: SUCCESS (0.005s)
[119.294899] Starting dynamic subtest: vcs0
[119.298717] Dynamic subtest vcs0: SUCCESS (0.006s)
[119.330716] Starting dynamic subtest: bcs0
[119.334415] Dynamic subtest bcs0: SUCCESS (0.004s)
[119.366635] Starting dynamic subtest: rcs0
[119.370491] Dynamic subtest rcs0: SUCCESS (0.004s)
[119.402562] Starting dynamic subtest: vcs1
[119.406311] Dynamic subtest vcs1: SUCCESS (0.004s)
[119.409888] Subtest idempotent: SUCCESS (0.047s)
[119.461231] [016/142] (892s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc)
[119.947173] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc
[134.969154] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (15.027s)
[135.231681] [017/142] (877s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[135.673272] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[135.839529] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.167s)
[135.999952] [018/142] (876s left) kms_ccs (pipe-c-missing-ccs-buffer-4_tiled_mtl_mc_ccs)
[137.475513] Starting subtest: pipe-C-missing-ccs-buffer-4_tiled_mtl_mc_ccs
[137.644309] Subtest pipe-C-missing-ccs-buffer-4_tiled_mtl_mc_ccs: SUCCESS (0.169s)
[138.544916] [019/142] (874s left) kms_cursor_crc (cursor-random-256x256)
[139.578282] Starting subtest: cursor-random-256x256
[139.607834] Starting dynamic subtest: pipe-A-eDP-1
[145.706789] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.099s)
[145.893541] Starting dynamic subtest: pipe-D-eDP-1
[153.402458] Dynamic subtest pipe-D-eDP-1: SUCCESS (7.535s)
[153.406122] Subtest cursor-random-256x256: SUCCESS (13.827s)
[154.342612] [020/142] (858s left) perf (gen12-group-exclusive-stream-sample-oa)
[155.196246] Starting subtest: gen12-group-exclusive-stream-sample-oa
[155.273283] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.076s)
[155.371226] [021/142] (857s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_ccs)
[156.534248] Starting subtest: pipe-B-crc-primary-basic-y_tiled_ccs
[156.541098] Subtest pipe-B-crc-primary-basic-y_tiled_ccs: SKIP (0.002s)
[157.755755] [022/142] (855s left) gem_ctx_shared (q-out-order)
[158.192618] Starting subtest: Q-out-order
[158.197068] Starting dynamic subtest: rcs0
[158.645171] Dynamic subtest rcs0: SUCCESS (0.449s)
[158.688236] Starting dynamic subtest: bcs0
[158.878837] Dynamic subtest bcs0: SUCCESS (0.231s)
[158.930677] Starting dynamic subtest: vcs0
[159.134985] Dynamic subtest vcs0: SUCCESS (0.253s)
[159.178232] Starting dynamic subtest: vcs1
[159.381180] Dynamic subtest vcs1: SUCCESS (0.243s)
[159.426770] Starting dynamic subtest: vecs0
[159.618337] Dynamic subtest vecs0: SUCCESS (0.233s)
[159.669428] Starting dynamic subtest: ccs0
[159.888201] Dynamic subtest ccs0: SUCCESS (0.267s)
[159.891482] Subtest Q-out-order: SUCCESS (1.696s)
[160.700389] [023/142] (852s left) v3d/v3d_wait_bo (used-bo-0ns)
[161.207167] Subtest used-bo-0ns: SKIP (0.000s)
[161.341772] [024/142] (851s left) kms_ccs (pipe-d-random-ccs-data-y_tiled_gen12_mc_ccs)
[163.023240] Starting subtest: pipe-D-random-ccs-data-y_tiled_gen12_mc_ccs
[163.032220] Subtest pipe-D-random-ccs-data-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[163.696656] [025/142] (849s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[164.214868] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[164.221765] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[164.365757] [026/142] (848s left) kms_lease (lease_invalid_crtc)
[164.855137] Starting subtest: lease_invalid_crtc
[164.858391] Starting dynamic subtest: pipe-A-eDP-1
[164.861811] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[164.903913] Starting dynamic subtest: pipe-B-eDP-1
[164.907842] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[164.943289] Starting dynamic subtest: pipe-C-eDP-1
[164.946566] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[164.980925] Starting dynamic subtest: pipe-D-eDP-1
[164.984159] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[164.987189] Subtest lease_invalid_crtc: SUCCESS (0.033s)
[165.044995] [027/142] (848s left) kms_flip (flip-vs-suspend-interruptible)
[165.473436] Starting subtest: flip-vs-suspend-interruptible
[165.507236] Starting dynamic subtest: A-eDP1
[201.388434] Dynamic subtest A-eDP1: SUCCESS (35.882s)
[201.416160] Starting dynamic subtest: B-eDP1
[236.414344] Dynamic subtest B-eDP1: SUCCESS (35.023s)
[236.452499] Starting dynamic subtest: C-eDP1
[271.399358] Dynamic subtest C-eDP1: SUCCESS (34.981s)
[271.421140] Starting dynamic subtest: D-eDP1
[306.408946] Dynamic subtest D-eDP1: SUCCESS (35.005s)
[306.427630] Subtest flip-vs-suspend-interruptible: SUCCESS (140.955s)
[307.950439] [028/142] (705s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_dg2_rc_ccs)
[309.259253] Starting subtest: pipe-C-crc-primary-rotation-180-4_tiled_dg2_rc_ccs
[309.268490] Subtest pipe-C-crc-primary-rotation-180-4_tiled_dg2_rc_ccs: SKIP (0.003s)
[310.099830] [029/142] (703s left) kms_flip (2x-flip-vs-wf_vblank)
[310.249062] Starting subtest: 2x-flip-vs-wf_vblank
[310.298454] Subtest 2x-flip-vs-wf_vblank: SKIP (0.052s)
[310.440031] [030/142] (702s left) kms_vblank (pipe-d-wait-idle)
[310.613943] Starting subtest: pipe-D-wait-idle
[313.542632] Subtest pipe-D-wait-idle: SUCCESS (2.928s)
[314.488486] [031/142] (698s left) gem_exec_reloc (basic-wc-read)
[314.883952] Subtest basic-wc-read: SKIP (0.000s)
[315.026823] [032/142] (698s left) kms_flip (dpms-off-confusion-interruptible)
[315.446631] Starting subtest: dpms-off-confusion-interruptible
[315.474094] Starting dynamic subtest: A-eDP1
[324.735432] Dynamic subtest A-eDP1: SUCCESS (9.261s)
[324.776975] Starting dynamic subtest: B-eDP1
[333.805780] Dynamic subtest B-eDP1: SUCCESS (9.065s)
[333.848703] Starting dynamic subtest: C-eDP1
[342.866903] Dynamic subtest C-eDP1: SUCCESS (9.056s)
[342.908034] Starting dynamic subtest: D-eDP1
[351.915480] Dynamic subtest D-eDP1: SUCCESS (9.043s)
[351.943897] Subtest dpms-off-confusion-interruptible: SUCCESS (36.501s)
[353.454116] [033/142] (660s left) gem_create (create-valid-nonaligned)
[353.826062] Starting subtest: create-valid-nonaligned
[353.830208] Subtest create-valid-nonaligned: SUCCESS (0.001s)
[354.125638] [034/142] (659s left) gem_exec_fence (syncobj-timeline-unused-fence)
[356.155395] Starting subtest: syncobj-timeline-unused-fence
[356.173310] Subtest syncobj-timeline-unused-fence: SUCCESS (0.020s)
[356.712466] [035/142] (657s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[357.234248] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[362.740189] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (5.516s)
[363.016998] [036/142] (650s left) gem_exec_whisper (basic-fds)
[363.460470] Starting subtest: basic-fds
[385.463312] Subtest basic-fds: SUCCESS (22.005s)
[385.977206] [037/142] (627s left) v3d/v3d_submit_cl (single-in-sync)
[386.469687] Subtest single-in-sync: SKIP (0.000s)
[386.582416] [038/142] (627s left) kms_plane (plane-panning-bottom-right-suspend)
[387.061948] Starting subtest: plane-panning-bottom-right-suspend
[387.071852] Starting dynamic subtest: pipe-A-planes
[405.759508] Dynamic subtest pipe-A-planes: SUCCESS (18.689s)
[405.799562] Starting dynamic subtest: pipe-B-planes
[425.017394] Dynamic subtest pipe-B-planes: SUCCESS (19.248s)
[425.020974] Subtest plane-panning-bottom-right-suspend: SUCCESS (37.958s)
[425.975492] [039/142] (588s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[426.479473] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[426.486811] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.001s)
[426.666137] [040/142] (587s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[427.161182] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[427.171722] Starting dynamic subtest: pipe-A-default-mode
[427.579967] Dynamic subtest pipe-A-default-mode: SKIP (0.403s)
[427.587167] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.416s)
[428.528520] [041/142] (585s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[429.067245] Starting subtest: 4-tiled-16bpp-rotate-180
[433.402371] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (4.337s)
[433.938173] [042/142] (580s left) kms_ccs (pipe-d-bad-aux-stride-y_tiled_ccs)
[435.689654] Starting subtest: pipe-D-bad-aux-stride-y_tiled_ccs
[435.696462] Subtest pipe-D-bad-aux-stride-y_tiled_ccs: SKIP (0.000s)
[436.304625] [043/142] (578s left) gem_ctx_engines (invalid-engines)
[436.735250] Starting subtest: invalid-engines
[436.767500] Subtest invalid-engines: SUCCESS (0.033s)
[437.077096] [044/142] (577s left) gem_exec_fair (basic-none)
[437.482656] Subtest basic-none: SKIP (0.000s)
[437.619582] [045/142] (576s left) gem_mmap_gtt (basic-read)
[437.990129] Subtest basic-read: SKIP (0.000s)
[438.107050] [046/142] (576s left) kms_psr (sprite_blt)
[438.593914] Starting subtest: sprite_blt
[441.645386] Subtest sprite_blt: SUCCESS (3.052s)
[442.591550] [047/142] (572s left) gen3_render_tiledx_blits
[443.080414] [048/142] (571s left) gem_sync (basic-many-each)
[443.507461] Starting subtest: basic-many-each
[445.993252] Subtest basic-many-each: SUCCESS (2.485s)
[446.287633] [049/142] (568s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_dg2_rc_ccs)
[447.536583] Starting subtest: pipe-D-crc-primary-rotation-180-4_tiled_dg2_rc_ccs
[447.543458] Subtest pipe-D-crc-primary-rotation-180-4_tiled_dg2_rc_ccs: SKIP (0.002s)
[448.090538] [050/142] (566s left) gem_userptr_blits (mmap-offset-banned)
[448.548307] Starting subtest: mmap-offset-banned
[448.551851] Starting dynamic subtest: gtt
[448.558597] Dynamic subtest gtt: SKIP (0.000s)
[448.595094] Starting dynamic subtest: wb
[448.598127] Dynamic subtest wb: SUCCESS (0.001s)
[448.637086] Starting dynamic subtest: wc
[448.640506] Dynamic subtest wc: SUCCESS (0.001s)
[448.684305] Starting dynamic subtest: uc
[448.687672] Dynamic subtest uc: SUCCESS (0.001s)
[448.690550] Subtest mmap-offset-banned: SUCCESS (0.019s)
[448.793501] [051/142] (566s left) kms_flip (2x-plain-flip-fb-recreate)
[449.185947] Starting subtest: 2x-plain-flip-fb-recreate
[449.344820] Subtest 2x-plain-flip-fb-recreate: SKIP (0.161s)
[449.550946] [052/142] (565s left) gem_exec_params (invalid-flag)
[449.878244] Starting subtest: invalid-flag
[449.882466] Subtest invalid-flag: SUCCESS (0.001s)
[450.021608] [053/142] (565s left) kms_psr (psr2_cursor_render)
[450.381124] Starting subtest: psr2_cursor_render
[452.569875] Subtest psr2_cursor_render: SUCCESS (2.188s)
[453.532461] [054/142] (561s left) kms_dsc (dsc-with-output-formats-with-bpc)
[454.024132] Starting subtest: dsc-with-output-formats-with-bpc
[454.037630] Subtest dsc-with-output-formats-with-bpc: SKIP (0.011s)
[454.188244] [055/142] (561s left) kms_chamelium_color (ctm-0-50)
[454.675683] Subtest ctm-0-50: SKIP (0.000s)
[454.794545] [056/142] (560s left) kms_cursor_edge_walk (256x256-top-edge)
[455.286614] Starting subtest: 256x256-top-edge
[455.292262] Starting dynamic subtest: pipe-A-eDP-1
[459.183067] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.890s)
[459.236740] Starting dynamic subtest: pipe-D-eDP-1
[462.670220] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.471s)
[462.673268] Subtest 256x256-top-edge: SUCCESS (7.383s)
[463.609677] [057/142] (551s left) gem_lmem_swapping (smem-oom)
[464.002996] Subtest smem-oom: SKIP (0.000s)
[464.117844] [058/142] (551s left) gem_fenced_exec_thrash (no-spare-fences)
[464.511115] Subtest no-spare-fences: SKIP (0.000s)
[464.629204] [059/142] (551s left) i915_module_load (load)
[464.985099] Starting subtest: load
[464.996938] Subtest load: SKIP (0.005s)
[465.117346] [060/142] (550s left) prime_vgem (basic-blt)
[465.528561] Starting subtest: basic-blt
[465.700923] Subtest basic-blt: FAIL (0.136s)
[465.897184] [061/142] (550s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[466.270410] Starting subtest: framebuffer-vs-set-tiling
[466.277197] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[466.553824] [062/142] (549s left) perf_pmu (module-unload)
[466.992873] Starting subtest: module-unload
[515.614766] Subtest module-unload: SUCCESS (48.621s)
[515.693404] [063/142] (500s left) syncobj_timeline (multi-wait-available-submitted)
[521.977752] Starting subtest: multi-wait-available-submitted
[521.980945] Subtest multi-wait-available-submitted: SUCCESS (0.002s)
[522.042722] [064/142] (494s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[522.453350] Starting subtest: basic-flip-after-cursor-varying-size
[523.888914] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.434s)
[524.853161] [065/142] (491s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[525.102743] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[535.149652] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (10.045s)
[535.392872] [066/142] (480s left) kms_ccs (pipe-a-crc-primary-rotation-180-4_tiled_dg2_rc_ccs)
[536.286117] Starting subtest: pipe-A-crc-primary-rotation-180-4_tiled_dg2_rc_ccs
[536.293097] Subtest pipe-A-crc-primary-rotation-180-4_tiled_dg2_rc_ccs: SKIP (0.002s)
[537.635939] [067/142] (478s left) syncobj_basic (bad-pad-fd-to-handle)
[538.023748] Starting subtest: bad-pad-fd-to-handle
[538.027985] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[538.168558] [068/142] (478s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[538.711057] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[542.622405] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (3.911s)
[543.208972] [069/142] (473s left) kms_chamelium_frames (dp-crc-multiple)
[544.090976] Subtest dp-crc-multiple: SKIP (0.000s)
[544.966099] [070/142] (471s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[545.489099] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[548.317293] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (2.824s)
[548.610612] [071/142] (468s left) vc4/vc4_wait_bo (used-bo)
[549.084332] Subtest used-bo: SKIP (0.000s)
[549.220594] [072/142] (467s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[549.637151] Starting subtest: y-tiled-ccs-to-yf-tiled
[549.643602] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[549.913717] [073/142] (467s left) perf (invalid-create-userspace-config)
[550.799682] Starting subtest: invalid-create-userspace-config
[550.811141] Subtest invalid-create-userspace-config: SUCCESS (0.010s)
[550.916211] [074/142] (466s left) kms_properties (crtc-properties-atomic)
[551.392530] Starting subtest: crtc-properties-atomic
[555.862930] Subtest crtc-properties-atomic: SUCCESS (4.466s)
[556.814477] [075/142] (460s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_dg2_rc_ccs)
[558.037589] Starting subtest: pipe-B-random-ccs-data-4_tiled_dg2_rc_ccs
[558.047176] Subtest pipe-B-random-ccs-data-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[559.209212] [076/142] (457s left) core_setmaster (master-drop-set-user)
[559.703883] Starting subtest: master-drop-set-user
[559.788367] Subtest master-drop-set-user: SUCCESS (0.085s)
[559.881157] [077/142] (457s left) kms_ccs (pipe-a-missing-ccs-buffer-yf_tiled_ccs)
[560.876288] Starting subtest: pipe-A-missing-ccs-buffer-yf_tiled_ccs
[560.882681] Subtest pipe-A-missing-ccs-buffer-yf_tiled_ccs: SKIP (0.000s)
[562.229861] [078/142] (455s left) kms_ccs (pipe-c-bad-aux-stride-y_tiled_gen12_mc_ccs)
[563.746371] Starting subtest: pipe-C-bad-aux-stride-y_tiled_gen12_mc_ccs
[563.753244] Subtest pipe-C-bad-aux-stride-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[564.579173] [079/142] (452s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[565.064849] Starting subtest: primary-4-tiled-reflect-x-180
[580.563774] Subtest primary-4-tiled-reflect-x-180: SUCCESS (15.501s)
[582.071251] [080/142] (435s left) kms_plane_scaling (planes-downscale-factor-0-75)
[582.543292] Starting subtest: planes-downscale-factor-0-75
[582.548265] Starting dynamic subtest: pipe-A-eDP-1
[582.650600] Dynamic subtest pipe-A-eDP-1: SKIP (0.097s)
[582.697935] Starting dynamic subtest: pipe-B-eDP-1
[582.879445] Dynamic subtest pipe-B-eDP-1: SKIP (0.217s)
[582.930071] Starting dynamic subtest: pipe-C-eDP-1
[583.116550] Dynamic subtest pipe-C-eDP-1: SKIP (0.226s)
[583.167131] Starting dynamic subtest: pipe-D-eDP-1
[583.352584] Dynamic subtest pipe-D-eDP-1: SKIP (0.226s)
[583.359494] Subtest planes-downscale-factor-0-75: SKIP (0.809s)
[583.539314] [081/142] (434s left) gem_ctx_param (set-priority-not-supported)
[583.913685] Starting subtest: set-priority-not-supported
[583.920239] Subtest set-priority-not-supported: SKIP (0.000s)
[584.053130] [082/142] (433s left) kms_properties (connector-properties-atomic)
[584.537149] Starting subtest: connector-properties-atomic
[585.835583] Subtest connector-properties-atomic: SUCCESS (1.299s)
[586.732776] [083/142] (431s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[587.258189] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[587.265538] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[587.437813] [084/142] (430s left) gem_softpin (allocator-evict)
[587.836243] Starting subtest: allocator-evict
[587.839989] Starting dynamic subtest: rcs0
[624.603513] Dynamic subtest rcs0: SUCCESS (36.765s)
[624.665100] Starting dynamic subtest: bcs0
[657.437525] Dynamic subtest bcs0: SUCCESS (32.827s)
[657.490803] Starting dynamic subtest: vcs0
[692.588270] Dynamic subtest vcs0: SUCCESS (35.145s)
[692.644168] Starting dynamic subtest: vcs1
[725.574794] Dynamic subtest vcs1: SUCCESS (32.982s)
[725.630694] Starting dynamic subtest: vecs0
[758.529363] Dynamic subtest vecs0: SUCCESS (32.948s)
[758.550130] Starting dynamic subtest: ccs0
[788.372206] Dynamic subtest ccs0: SUCCESS (29.839s)
[788.376142] Subtest allocator-evict: SUCCESS (200.537s)
[788.514371] [085/142] (229s left) gem_lmem_swapping (verify)
[789.074322] Subtest verify: SKIP (0.000s)
[789.203848] [086/142] (228s left) gem_softpin (noreloc-s3)
[789.601188] Starting subtest: noreloc-S3
[807.395517] Subtest noreloc-S3: SUCCESS (17.796s)
[807.583158] [087/142] (210s left) i915_query (test-query-geometry-subslices)
[807.959212] Starting subtest: test-query-geometry-subslices
[807.962683] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[808.114331] [088/142] (210s left) kms_getfb (getfb2-handle-not-fb)
[808.325418] Starting subtest: getfb2-handle-not-fb
[808.434115] Subtest getfb2-handle-not-fb: SUCCESS (0.110s)
[808.619981] [089/142] (209s left) vc4/vc4_label_bo (set-label)
[809.023183] Subtest set-label: SKIP (0.000s)
[809.153168] [090/142] (209s left) gem_mmap_wc (pf-nonblock)
[809.523911] Subtest pf-nonblock: SKIP (0.000s)
[809.649755] [091/142] (208s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[810.186435] Starting subtest: y-tiled-32bpp-rotate-90
[810.193055] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[810.369076] [092/142] (208s left) kms_invalid_mode (zero-clock)
[810.835382] Starting subtest: zero-clock
[810.838676] Starting dynamic subtest: eDP-1-pipe-A
[811.219130] Dynamic subtest eDP-1-pipe-A: SUCCESS (0.379s)
[811.258732] Starting dynamic subtest: eDP-1-pipe-B
[811.262176] Dynamic subtest eDP-1-pipe-B: SUCCESS (0.030s)
[811.300791] Starting dynamic subtest: eDP-1-pipe-C
[811.304437] Dynamic subtest eDP-1-pipe-C: SUCCESS (0.031s)
[811.344484] Starting dynamic subtest: eDP-1-pipe-D
[811.347385] Dynamic subtest eDP-1-pipe-D: SUCCESS (0.031s)
[811.350227] Subtest zero-clock: SUCCESS (0.498s)
[812.158250] [093/142] (206s left) kms_big_fb (linear-64bpp-rotate-90)
[812.700487] Starting subtest: linear-64bpp-rotate-90
[812.761709] Subtest linear-64bpp-rotate-90: SKIP (0.059s)
[812.955924] [094/142] (205s left) kms_cursor_crc (cursor-random-32x32)
[813.578362] Starting subtest: cursor-random-32x32
[813.873142] Subtest cursor-random-32x32: SKIP (0.284s)
[814.764223] [095/142] (204s left) syncobj_wait (multi-wait-all-submitted)
[815.146997] Starting subtest: multi-wait-all-submitted
[815.256114] Subtest multi-wait-all-submitted: SUCCESS (0.108s)
[815.416212] [096/142] (203s left) kms_vblank (pipe-a-accuracy-idle)
[815.901802] Starting subtest: pipe-A-accuracy-idle
[817.826360] Subtest pipe-A-accuracy-idle: SUCCESS (1.929s)
[818.787401] [097/142] (200s left) gem_render_copy_redux (flink)
[819.215214] Starting subtest: flink
[826.275623] Subtest flink: SUCCESS (7.061s)
[826.531198] [098/142] (192s left) gem_eio (create)
[828.550373] Starting subtest: create
[831.665888] Subtest create: SUCCESS (3.117s)
[833.669727] [099/142] (185s left) kms_3d
[842.832471] [100/142] (176s left) kms_properties (invalid-properties-atomic)
[843.327212] Starting subtest: invalid-properties-atomic
[845.622554] Subtest invalid-properties-atomic: SUCCESS (2.299s)
[845.772775] [101/142] (173s left) gem_ccs (block-multicopy-compressed)
[846.164813] Starting subtest: block-multicopy-compressed
[846.171844] Subtest block-multicopy-compressed: SKIP (0.000s)
[846.323898] [102/142] (173s left) kms_ccs (pipe-d-bad-rotation-90-y_tiled_gen12_rc_ccs_cc)
[847.903239] Starting subtest: pipe-D-bad-rotation-90-y_tiled_gen12_rc_ccs_cc
[847.909484] Subtest pipe-D-bad-rotation-90-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[848.685278] [103/142] (170s left) drm_fdinfo (idle)
[849.081072] Starting subtest: idle
[849.084734] Starting dynamic subtest: rcs0
[849.605276] Dynamic subtest rcs0: SUCCESS (0.522s)
[849.665959] Starting dynamic subtest: bcs0
[850.116735] Dynamic subtest bcs0: SUCCESS (0.505s)
[850.170635] Starting dynamic subtest: vcs0
[850.633177] Dynamic subtest vcs0: SUCCESS (0.506s)
[850.685186] Starting dynamic subtest: vcs1
[851.136204] Dynamic subtest vcs1: SUCCESS (0.505s)
[851.188912] Starting dynamic subtest: vecs0
[851.650231] Dynamic subtest vecs0: SUCCESS (0.505s)
[851.702752] Starting dynamic subtest: ccs0
[852.156116] Dynamic subtest ccs0: SUCCESS (0.505s)
[852.160213] Subtest idle: SUCCESS (3.075s)
[852.341951] [104/142] (167s left) gem_exec_balancer (semaphore)
[852.779568] Starting subtest: semaphore
[860.542325] Subtest semaphore: SUCCESS (7.761s)
[861.587115] [105/142] (158s left) kms_rotation_crc (bad-pixel-format)
[862.084838] Starting subtest: bad-pixel-format
[862.091393] Subtest bad-pixel-format: SKIP (0.007s)
[862.253854] [106/142] (157s left) gem_pipe_control_store_loop (fresh-buffer)
[862.650387] Starting subtest: fresh-buffer
[864.815239] Subtest fresh-buffer: SUCCESS (2.164s)
[865.004472] [107/142] (155s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[865.522751] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[865.529796] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[865.709114] [108/142] (154s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[866.218893] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[877.207963] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (10.996s)
[877.476569] [109/142] (142s left) i915_pm_rpm (gem-pread)
[883.829586] Starting subtest: gem-pread
[886.281372] Subtest gem-pread: SUCCESS (2.455s)
[886.488604] [110/142] (133s left) gem_fence_thrash (bo-write-verify-threaded-none)
[886.854342] Starting subtest: bo-write-verify-threaded-none
[886.872930] Subtest bo-write-verify-threaded-none: SKIP (0.011s)
[887.003492] [111/142] (133s left) syncobj_timeline (invalid-transfer-bad-pad)
[887.374661] Starting subtest: invalid-transfer-bad-pad
[887.378227] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[887.529371] [112/142] (133s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[887.905998] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[887.910382] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.002s)
[888.066436] [113/142] (132s left) syncobj_timeline (wait-all-delayed-signal)
[888.461629] Starting subtest: wait-all-delayed-signal
[888.564475] Subtest wait-all-delayed-signal: SUCCESS (0.106s)
[888.739814] [114/142] (131s left) gem_userptr_blits (sync-unmap-cycles)
[889.198471] Starting subtest: sync-unmap-cycles
[894.584483] Subtest sync-unmap-cycles: SUCCESS (5.382s)
[894.816462] [115/142] (126s left) gem_pxp (display-protected-crc)
[897.739824] Subtest display-protected-crc: SKIP (0.000s)
[897.899883] [116/142] (123s left) gem_watchdog (default-physical)
[898.298224] Starting subtest: default-physical
[899.615445] Subtest default-physical: SUCCESS (1.317s)
[899.785263] [117/142] (121s left) kms_psr2_sf (overlay-plane-move-continuous-exceed-fully-sf)
[906.381205] Starting subtest: overlay-plane-move-continuous-exceed-fully-sf
[906.385116] Starting dynamic subtest: pipe-A-eDP-1
[924.591388] Dynamic subtest pipe-A-eDP-1: SUCCESS (18.211s)
[924.652725] Starting dynamic subtest: pipe-B-eDP-1
[942.359197] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.756s)
[942.363259] Subtest overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (35.984s)
[943.371084] [118/142] ( 77s left) syncobj_timeline (host-signal-points)
[943.755701] Starting subtest: host-signal-points
[943.791272] Subtest host-signal-points: SUCCESS (0.036s)
[943.952642] [119/142] ( 77s left) api_intel_allocator (reloc-allocator)
[944.321693] Starting subtest: reloc-allocator
[944.325860] Starting dynamic subtest: basic
[944.334969] Dynamic subtest basic: SUCCESS (0.011s)
[944.380981] Starting dynamic subtest: parallel-one
[944.384867] Dynamic subtest parallel-one: SUCCESS (0.034s)
[944.439466] Starting dynamic subtest: print
[944.442807] Dynamic subtest print: SUCCESS (0.000s)
[944.498974] Starting dynamic subtest: reuse
[944.502595] Dynamic subtest reuse: SUCCESS (0.001s)
[944.557255] Starting dynamic subtest: fork-reopen-allocator
[944.560465] Dynamic subtest fork-reopen-allocator: SUCCESS (0.077s)
[944.563642] Subtest reloc-allocator: SUCCESS (0.144s)
[944.663975] [120/142] ( 76s left) kms_ccs (pipe-a-ccs-on-another-bo-4_tiled_mtl_mc_ccs)
[945.694707] Starting subtest: pipe-A-ccs-on-another-bo-4_tiled_mtl_mc_ccs
[945.872663] Subtest pipe-A-ccs-on-another-bo-4_tiled_mtl_mc_ccs: SUCCESS (0.182s)
[947.255459] [121/142] ( 74s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[947.772547] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[947.779796] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[947.948755] [122/142] ( 73s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[948.513481] Starting subtest: flip-vs-cursor-atomic-transitions
[954.265371] Subtest flip-vs-cursor-atomic-transitions: FAIL (5.116s)
[954.472138] [123/142] ( 67s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[954.968376] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[964.957533] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (9.988s)
[965.245279] [124/142] ( 56s left) kms_busy (extended-modeset-hang-oldfb)
[965.750656] Starting subtest: extended-modeset-hang-oldfb
[965.759412] Starting dynamic subtest: pipe-A
[981.555230] Dynamic subtest pipe-A: SUCCESS (15.791s)
[981.630241] Starting dynamic subtest: pipe-D
[998.005456] Dynamic subtest pipe-D: SUCCESS (16.426s)
[998.009295] Subtest extended-modeset-hang-oldfb: SUCCESS (32.257s)
[998.970351] [125/142] ( 22s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[999.527587] Starting subtest: flip-vs-cursor-busy-crc-atomic
[1001.355951] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (1.829s)
[1002.316112] [126/142] ( 19s left) gem_exec_schedule (fifo)
[1002.760289] Starting subtest: fifo
[1002.763436] Starting dynamic subtest: rcs0
[1003.133574] Dynamic subtest rcs0: SUCCESS (0.375s)
[1003.196551] Starting dynamic subtest: bcs0
[1003.406389] Dynamic subtest bcs0: SUCCESS (0.268s)
[1003.467096] Starting dynamic subtest: vcs0
[1003.683380] Dynamic subtest vcs0: SUCCESS (0.274s)
[1003.744662] Starting dynamic subtest: vcs1
[1003.954427] Dynamic subtest vcs1: SUCCESS (0.266s)
[1004.017208] Starting dynamic subtest: vecs0
[1004.228095] Dynamic subtest vecs0: SUCCESS (0.270s)
[1004.288586] Starting dynamic subtest: ccs0
[1004.529665] Dynamic subtest ccs0: SUCCESS (0.297s)
[1004.533319] Subtest fifo: SUCCESS (1.775s)
[1004.985362] [127/142] ( 17s left) kms_properties (get_properties-sanity-non-atomic)
[1005.491906] Starting subtest: get_properties-sanity-non-atomic
[1005.509432] Subtest get_properties-sanity-non-atomic: SUCCESS (0.022s)
[1005.683718] [128/142] ( 16s left) fbdev (pan)
[1005.935345] Starting subtest: pan
[1005.982940] Subtest pan: SUCCESS (0.048s)
[1006.146304] [129/142] ( 16s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[1006.521958] Starting subtest: invalid-single-wait-all-unsubmitted
[1006.525625] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[1006.688801] [130/142] ( 15s left) kms_addfb_basic (basic-y-tiled-legacy)
[1007.083185] Starting subtest: basic-y-tiled-legacy
[1007.089476] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[1007.375706] [131/142] ( 15s left) gem_exec_schedule (thriceslice)
[1007.820311] Starting subtest: thriceslice
[1007.823447] Starting dynamic subtest: rcs0
[1007.861453] Dynamic subtest rcs0: SUCCESS (0.044s)
[1007.926182] Starting dynamic subtest: bcs0
[1007.933468] Dynamic subtest bcs0: SUCCESS (0.066s)
[1007.993890] Starting dynamic subtest: vcs0
[1008.003443] Dynamic subtest vcs0: SUCCESS (0.066s)
[1008.065393] Starting dynamic subtest: vcs1
[1008.071408] Dynamic subtest vcs1: SUCCESS (0.063s)
[1008.135733] Starting dynamic subtest: vecs0
[1008.140226] Dynamic subtest vecs0: SUCCESS (0.064s)
[1008.203766] Starting dynamic subtest: ccs0
[1008.211700] Dynamic subtest ccs0: SUCCESS (0.066s)
[1008.215619] Subtest thriceslice: SUCCESS (0.398s)
[1009.679275] [132/142] ( 12s left) syncobj_basic (bad-flags-handle-to-fd)
[1010.057271] Starting subtest: bad-flags-handle-to-fd
[1010.060903] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[1010.233665] [133/142] ( 12s left) kms_ccs (pipe-a-random-ccs-data-yf_tiled_ccs)
[1011.214402] Starting subtest: pipe-A-random-ccs-data-yf_tiled_ccs
[1011.224551] Subtest pipe-A-random-ccs-data-yf_tiled_ccs: SKIP (0.000s)
[1012.624067] [134/142] ( 10s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[1013.170623] Starting subtest: yf-tiled-addfb-size-offset-overflow
[1013.179071] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[1013.350163] [135/142] (  9s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[1013.865289] Starting subtest: fbcpsr-suspend
[1058.082897] Subtest fbcpsr-suspend: SUCCESS (44.216s)
[1058.353059] Overall timeout time exceeded, stopping.
[1058.354245] Closing watchdogs
Done.