[45.921558] Initializing watchdogs
[45.921602]   /dev/watchdog0
[45.927176] [001/142] (960s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[46.078545] Starting subtest: 2x-flip-vs-cursor-legacy
[46.083343] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[46.164444] [002/142] (960s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[46.537902] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[47.395967] [003/142] (959s left) kms_display_modes (mst-extended-mode-negative)
[47.471676] Starting subtest: mst-extended-mode-negative
[47.476602] Subtest mst-extended-mode-negative: SKIP (0.000s)
[47.493149] [004/142] (958s left) gem_ctx_param (invalid-param-set)
[47.526111] Starting subtest: invalid-param-set
[47.528486] Subtest invalid-param-set: SUCCESS (0.000s)
[47.574788] [005/142] (958s left) v3d/v3d_submit_cl (bad-extension)
[47.642710] Subtest bad-extension: SKIP (0.000s)
[47.682491] [006/142] (958s left) kms_flip (2x-flip-vs-suspend)
[47.749310] Starting subtest: 2x-flip-vs-suspend
[47.768330] Subtest 2x-flip-vs-suspend: SKIP (0.020s)
[47.835752] [007/142] (958s left) kms_prop_blob (invalid-set-prop-any)
[47.895167] Starting subtest: invalid-set-prop-any
[47.897546] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[47.952490] [008/142] (958s left) kms_ccs (pipe-a-crc-primary-rotation-180-4_tiled_dg2_mc_ccs)
[48.307088] Starting subtest: pipe-A-crc-primary-rotation-180-4_tiled_dg2_mc_ccs
[48.311900] Subtest pipe-A-crc-primary-rotation-180-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[49.222822] [009/142] (957s left) kms_setmode (invalid-clone-single-crtc)
[49.288612] Starting subtest: invalid-clone-single-crtc
[49.295569] Subtest invalid-clone-single-crtc: SKIP (0.001s)
[49.348219] [010/142] (957s left) kms_psr2_su (frontbuffer-xrgb8888)
[49.398838] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[49.409588] [011/142] (957s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[49.484433] Starting subtest: fbcpsr-slowdraw
[72.532695] Subtest fbcpsr-slowdraw: SUCCESS (23.052s)
[72.665045] [012/142] (933s left) kms_lease (lease_revoke)
[72.746327] Starting subtest: lease_revoke
[72.748895] Starting dynamic subtest: pipe-A-eDP-1
[72.773837] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.028s)
[72.785204] Starting dynamic subtest: pipe-B-eDP-1
[72.793958] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[72.804522] Starting dynamic subtest: pipe-C-eDP-1
[72.827173] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.032s)
[72.840597] Starting dynamic subtest: pipe-D-eDP-1
[72.857871] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.029s)
[72.860328] Subtest lease_revoke: SUCCESS (0.112s)
[72.955874] [013/142] (933s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[73.063283] Starting subtest: cursor-vs-flip-legacy
[101.611180] Subtest cursor-vs-flip-legacy: SUCCESS (28.549s)
[102.487659] [014/142] (904s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_dg2_mc_ccs)
[102.878777] Starting subtest: pipe-B-crc-primary-basic-4_tiled_dg2_mc_ccs
[102.883550] Subtest pipe-B-crc-primary-basic-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[103.752691] [015/142] (902s left) kms_ccs (pipe-d-random-ccs-data-y_tiled_gen12_rc_ccs_cc)
[104.183891] Starting subtest: pipe-D-random-ccs-data-y_tiled_gen12_rc_ccs_cc
[104.191563] Subtest pipe-D-random-ccs-data-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[105.033493] [016/142] (901s left) kms_universal_plane (universal-plane-pipe-d-sanity)
[105.114175] Starting subtest: universal-plane-pipe-D-sanity
[106.835932] Subtest universal-plane-pipe-D-sanity: SUCCESS (1.723s)
[107.703265] [017/142] (899s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[107.774906] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[107.779523] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[107.856729] [018/142] (898s left) kms_hdr (invalid-hdr)
[107.923683] Starting subtest: invalid-hdr
[109.075020] Starting dynamic subtest: pipe-A-eDP-1
[112.203870] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.130s)
[112.206310] Subtest invalid-hdr: SUCCESS (4.282s)
[112.284564] [019/142] (894s left) kms_vblank (pipe-a-query-forked-hang)
[112.335904] Starting subtest: pipe-A-query-forked-hang
[127.326097] Subtest pipe-A-query-forked-hang: SUCCESS (14.991s)
[128.267197] [020/142] (878s left) kms_ccs (pipe-c-crc-primary-basic-y_tiled_gen12_rc_ccs)
[128.685087] Starting subtest: pipe-C-crc-primary-basic-y_tiled_gen12_rc_ccs
[128.689641] Subtest pipe-C-crc-primary-basic-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[129.546238] [021/142] (877s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-blt)
[129.606104] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-blt
[134.430846] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-blt: SUCCESS (4.829s)
[134.555297] [022/142] (872s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[134.606874] Starting subtest: invalid-multi-wait-unsubmitted
[134.608919] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[134.656387] [023/142] (872s left) vgem_basic (sysfs)
[134.773705] Starting subtest: sysfs
[134.776048] Subtest sysfs: SUCCESS (0.001s)
[134.820492] [024/142] (872s left) gem_ctx_param (non-root-set)
[134.869836] Starting subtest: non-root-set
[134.881144] Subtest non-root-set: SUCCESS (0.014s)
[134.936387] [025/142] (871s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[134.981066] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[134.983613] Starting dynamic subtest: pipe-A-eDP-1
[134.995060] Dynamic subtest pipe-A-eDP-1: SKIP (0.010s)
[135.004877] Starting dynamic subtest: pipe-B-eDP-1
[135.015564] Dynamic subtest pipe-B-eDP-1: SKIP (0.020s)
[135.025624] Starting dynamic subtest: pipe-C-eDP-1
[135.034224] Dynamic subtest pipe-C-eDP-1: SKIP (0.021s)
[135.043788] Starting dynamic subtest: pipe-D-eDP-1
[135.055950] Dynamic subtest pipe-D-eDP-1: SKIP (0.019s)
[135.060217] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.073s)
[135.138436] [026/142] (871s left) kms_vblank (pipe-a-ts-continuation-modeset)
[135.193941] Starting subtest: pipe-A-ts-continuation-modeset
[136.761512] Subtest pipe-A-ts-continuation-modeset: SUCCESS (1.566s)
[137.671873] [027/142] (869s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[137.715676] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[137.822149] [028/142] (869s left) gem_mmap_wc (read-write-distinct)
[137.881161] Subtest read-write-distinct: SKIP (0.000s)
[137.895909] [029/142] (869s left) gem_exec_whisper (basic-queues-priority-all)
[137.950914] Starting subtest: basic-queues-priority-all
[162.740238] Subtest basic-queues-priority-all: SUCCESS (24.784s)
[162.915765] [030/142] (844s left) gem_fence_thrash (bo-write-verify-y)
[162.979937] Starting subtest: bo-write-verify-y
[162.987272] Subtest bo-write-verify-y: SKIP (0.003s)
[163.020243] [031/142] (844s left) kms_universal_plane (disable-primary-vs-flip-pipe-b)
[163.072836] Starting subtest: disable-primary-vs-flip-pipe-B
[165.852926] Subtest disable-primary-vs-flip-pipe-B: SUCCESS (2.779s)
[166.796688] [032/142] (840s left) kms_vblank (pipe-c-wait-forked-busy)
[166.885158] Starting subtest: pipe-C-wait-forked-busy
[169.898274] Subtest pipe-C-wait-forked-busy: SUCCESS (3.011s)
[170.825135] [033/142] (836s left) gem_ctx_persistence (file)
[170.885728] Starting subtest: file
[170.959469] Subtest file: SUCCESS (0.074s)
[171.054629] [034/142] (836s left) kms_color (ctm-0-50)
[171.137033] Starting subtest: ctm-0-50
[171.139047] Starting dynamic subtest: pipe-A
[174.765221] Dynamic subtest pipe-A: SUCCESS (3.629s)
[174.775308] Starting dynamic subtest: pipe-B
[179.181914] Dynamic subtest pipe-B: SUCCESS (4.416s)
[179.194243] Starting dynamic subtest: pipe-C
[183.480519] Dynamic subtest pipe-C: SUCCESS (4.296s)
[183.489962] Starting dynamic subtest: pipe-D
[187.717027] Dynamic subtest pipe-D: SUCCESS (4.234s)
[187.719147] Subtest ctm-0-50: SUCCESS (16.578s)
[188.604596] [035/142] (818s left) kms_vblank (pipe-a-ts-continuation-idle-hang)
[188.683653] Starting subtest: pipe-A-ts-continuation-idle-hang
[202.327382] Subtest pipe-A-ts-continuation-idle-hang: SUCCESS (13.643s)
[203.198484] [036/142] (803s left) perf (gen12-group-exclusive-stream-ctx-handle)
[203.297994] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[203.314112] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.013s)
[203.335330] [037/142] (803s left) gem_basic (bad-close)
[204.460260] Starting subtest: bad-close
[204.465077] Subtest bad-close: SUCCESS (0.000s)
[204.520527] [038/142] (802s left) kms_ccs (pipe-d-bad-rotation-90-y_tiled_ccs)
[204.932314] Starting subtest: pipe-D-bad-rotation-90-y_tiled_ccs
[204.938030] Subtest pipe-D-bad-rotation-90-y_tiled_ccs: SKIP (0.000s)
[205.771209] [039/142] (801s left) gem_eio (kms)
[206.002170] Starting subtest: kms
[242.157118] Subtest kms: SUCCESS (36.157s)
[243.470957] [040/142] (763s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[243.558738] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[243.563024] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[243.643425] [041/142] (763s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[243.738043] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[243.740459] Starting dynamic subtest: pipe-A-default-mode
[244.951557] Dynamic subtest pipe-A-default-mode: SKIP (1.210s)
[244.956459] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.214s)
[245.069091] [042/142] (762s left) api_intel_bb (blit-reloc-keep-cache)
[245.111477] Starting subtest: blit-reloc-keep-cache
[245.115997] Subtest blit-reloc-keep-cache: SKIP (0.000s)
[245.204720] [043/142] (762s left) kms_vblank (pipe-d-wait-busy)
[245.274236] Starting subtest: pipe-D-wait-busy
[248.287982] Subtest pipe-D-wait-busy: SUCCESS (3.012s)
[249.228768] [044/142] (758s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[249.306581] Starting subtest: primary-y-tiled-reflect-x-90
[249.311187] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[249.366729] [045/142] (758s left) gem_pxp (fail-invalid-protected-context)
[251.931723] Subtest fail-invalid-protected-context: SKIP (0.000s)
[251.995743] [046/142] (755s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[252.046125] Starting subtest: x-tiled-to-vebox-yf-tiled
[252.050871] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[252.224199] [047/142] (755s left) gem_exec_balancer (smoke)
[252.293409] Starting subtest: smoke
[274.603672] Subtest smoke: SUCCESS (22.309s)
[275.231253] [048/142] (732s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[275.331517] Starting subtest: cursorB-vs-flipB-atomic
[275.336241] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[275.414392] [049/142] (732s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[275.483835] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[278.796354] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (3.317s)
[278.914247] [050/142] (728s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[279.496874] Starting subtest: syncobj-timeline-invalid-wait
[279.499572] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s)
[280.513295] [051/142] (727s left) gen9_exec_parse (valid-registers)
[280.571607] Subtest valid-registers: SKIP (0.000s)
[280.595906] [052/142] (726s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[280.670716] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[280.675316] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[280.754226] [053/142] (726s left) kms_ccs (pipe-c-bad-pixel-format-yf_tiled_ccs)
[281.142372] Starting subtest: pipe-C-bad-pixel-format-yf_tiled_ccs
[281.148425] Subtest pipe-C-bad-pixel-format-yf_tiled_ccs: SKIP (0.000s)
[281.995791] [054/142] (725s left) kms_ccs (pipe-a-missing-ccs-buffer-4_tiled_mtl_mc_ccs)
[282.378075] Starting subtest: pipe-A-missing-ccs-buffer-4_tiled_mtl_mc_ccs
[282.402866] Subtest pipe-A-missing-ccs-buffer-4_tiled_mtl_mc_ccs: SUCCESS (0.023s)
[283.250171] [055/142] (724s left) i915_pm_rc6_residency (media-rc6-accuracy)
[284.536933] Subtest media-rc6-accuracy: SKIP (0.000s)
[284.601095] [056/142] (723s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[284.666351] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[284.694358] [057/142] (723s left) vc4/vc4_purgeable_bo (access-purged-bo-mem)
[284.765679] Subtest access-purged-bo-mem: SKIP (0.000s)
[284.812350] [058/142] (722s left) gem_ctx_isolation (dirty-switch)
[284.877791] Starting subtest: dirty-switch
[284.881549] Starting dynamic subtest: rcs0
[284.987648] Dynamic subtest rcs0: SUCCESS (0.109s)
[285.001079] Starting dynamic subtest: bcs0
[285.151426] Dynamic subtest bcs0: SUCCESS (0.163s)
[285.157341] Starting dynamic subtest: vcs0
[285.302564] Dynamic subtest vcs0: SUCCESS (0.151s)
[285.316042] Starting dynamic subtest: vcs1
[286.608555] Dynamic subtest vcs1: SUCCESS (1.305s)
[286.621597] Starting dynamic subtest: vecs0
[288.599553] Dynamic subtest vecs0: SUCCESS (1.990s)
[288.613026] Starting dynamic subtest: ccs0
[290.640736] Dynamic subtest ccs0: SUCCESS (2.041s)
[290.643214] Subtest dirty-switch: SUCCESS (5.763s)
[290.857416] [059/142] (716s left) gem_userptr_blits (userfault)
[290.921854] Starting subtest: userfault
[290.924358] Subtest userfault: SUCCESS (0.005s)
[291.045248] [060/142] (716s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[291.138541] Starting subtest: yf-tiled-16bpp-rotate-0
[291.142801] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[291.209711] [061/142] (716s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[291.263371] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[291.265367] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[291.319124] [062/142] (716s left) gem_exec_reloc (basic-write-read-noreloc)
[291.358939] Subtest basic-write-read-noreloc: SKIP (0.000s)
[291.417342] [063/142] (716s left) kms_vblank (pipe-a-wait-busy)
[291.474663] Starting subtest: pipe-A-wait-busy
[293.343708] Subtest pipe-A-wait-busy: SUCCESS (1.869s)
[294.286858] [064/142] (713s left) gem_softpin (32b-excludes-last-page)
[294.349639] Starting subtest: 32b-excludes-last-page
[294.355067] Subtest 32b-excludes-last-page: SUCCESS (0.003s)
[294.453366] [065/142] (713s left) kms_big_fb (y-tiled-addfb)
[294.532504] Starting subtest: y-tiled-addfb
[294.537166] Subtest y-tiled-addfb: SKIP (0.000s)
[294.617707] [066/142] (713s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc)
[295.024201] Starting subtest: pipe-C-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc
[295.029529] Subtest pipe-C-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[295.887190] [067/142] (712s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[295.953402] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[301.284056] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (5.337s)
[301.394933] [068/142] (706s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[301.470741] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[301.474705] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[301.555274] [069/142] (706s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc)
[301.965241] Starting subtest: pipe-D-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc
[302.995950] Subtest pipe-D-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc: SUCCESS (1.031s)
[304.191863] [070/142] (703s left) gem_exec_params (cliprects-invalid)
[304.240472] Starting subtest: cliprects-invalid
[304.242873] Subtest cliprects-invalid: SUCCESS (0.000s)
[304.326110] [071/142] (703s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[304.419679] Starting subtest: flip-vs-cursor-atomic
[310.257734] Subtest flip-vs-cursor-atomic: SUCCESS (5.837s)
[311.171583] [072/142] (696s left) gem_exec_balancer (individual)
[311.243451] Starting subtest: individual
[312.451097] Subtest individual: SUCCESS (1.206s)
[312.694109] [073/142] (695s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc)
[313.094050] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc
[313.100233] Subtest pipe-B-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[314.000378] [074/142] (694s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[314.064101] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[319.429100] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (5.367s)
[319.552105] [075/142] (688s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[319.621935] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[319.625920] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[319.708778] [076/142] (688s left) syncobj_wait (invalid-single-wait-unsubmitted)
[319.750335] Starting subtest: invalid-single-wait-unsubmitted
[319.752592] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[319.796529] [077/142] (688s left) syncobj_wait (multi-wait-for-submit-signaled)
[319.859913] Starting subtest: multi-wait-for-submit-signaled
[319.862571] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[319.926784] [078/142] (688s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[319.998258] Starting subtest: 4-tiled-32bpp-rotate-270
[320.011548] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.016s)
[320.101456] [079/142] (688s left) kms_cursor_crc (cursor-random-512x170)
[320.250081] Starting subtest: cursor-random-512x170
[320.254996] Subtest cursor-random-512x170: SKIP (0.001s)
[320.359046] [080/142] (687s left) syncobj_timeline (signal-array)
[320.413486] Starting subtest: signal-array
[320.415495] Subtest signal-array: SUCCESS (0.000s)
[320.474617] [081/142] (687s left) kms_force_connector_basic (force-connector-state)
[320.525240] Starting subtest: force-connector-state
[321.110411] Subtest force-connector-state: SUCCESS (0.583s)
[322.071900] [082/142] (686s left) kms_cursor_crc (cursor-sliding-32x10)
[322.151155] Starting subtest: cursor-sliding-32x10
[322.184127] Subtest cursor-sliding-32x10: SKIP (0.025s)
[322.348033] [083/142] (686s left) gen9_exec_parse (batch-invalid-length)
[322.403647] Subtest batch-invalid-length: SKIP (0.000s)
[322.427456] [084/142] (685s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[322.515719] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[322.520238] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[322.590284] [085/142] (685s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[322.660077] Starting subtest: modeset-transition-nonblocking-fencing
[322.662534] Starting dynamic subtest: 1x-outputs
[335.086968] Dynamic subtest 1x-outputs: SUCCESS (12.425s)
[335.381067] Subtest modeset-transition-nonblocking-fencing: SUCCESS (12.720s)
[336.268033] [086/142] (672s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[336.352454] Starting subtest: x-tiled-32bpp-rotate-0
[337.720361] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.368s)
[337.854972] [087/142] (670s left) kms_lease (setcrtc_implicit_plane)
[337.916834] Starting subtest: setcrtc_implicit_plane
[337.919580] Starting dynamic subtest: pipe-A-eDP-1
[338.370217] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.452s)
[338.381666] Starting dynamic subtest: pipe-B-eDP-1
[339.579932] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.204s)
[339.592443] Starting dynamic subtest: pipe-C-eDP-1
[340.794221] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.213s)
[340.807936] Starting dynamic subtest: pipe-D-eDP-1
[342.011192] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.214s)
[342.013828] Subtest setcrtc_implicit_plane: SUCCESS (4.094s)
[342.912612] [088/142] (665s left) fbdev (pan)
[342.964392] Starting subtest: pan
[342.997295] Subtest pan: SUCCESS (0.035s)
[343.060041] [089/142] (665s left) prime_busy (after)
[343.114394] Starting subtest: after
[343.116923] Starting dynamic subtest: rcs0
[343.135062] Dynamic subtest rcs0: SUCCESS (0.019s)
[343.148728] Starting dynamic subtest: bcs0
[343.174963] Dynamic subtest bcs0: SUCCESS (0.038s)
[343.189073] Starting dynamic subtest: vcs0
[343.214291] Dynamic subtest vcs0: SUCCESS (0.038s)
[343.228156] Starting dynamic subtest: vcs1
[343.234248] Dynamic subtest vcs1: SUCCESS (0.018s)
[343.246731] Starting dynamic subtest: vecs0
[343.249515] Dynamic subtest vecs0: SUCCESS (0.016s)
[343.259524] Starting dynamic subtest: ccs0
[343.265321] Dynamic subtest ccs0: SUCCESS (0.015s)
[343.376934] Subtest after: SUCCESS (0.262s)
[343.444840] [090/142] (665s left) i915_pm_rps (thresholds-idle-park)
[343.498860] Starting subtest: thresholds-idle-park
[343.501429] Starting dynamic subtest: gt0
[343.506075] Dynamic subtest gt0: SKIP (0.001s)
[343.516461] Starting dynamic subtest: gt1
[343.520966] Dynamic subtest gt1: SKIP (0.000s)
[343.525530] Subtest thresholds-idle-park: SKIP (0.002s)
[343.566383] [091/142] (665s left) kms_ccs (pipe-a-random-ccs-data-4_tiled_mtl_rc_ccs_cc)
[343.992848] Starting subtest: pipe-A-random-ccs-data-4_tiled_mtl_rc_ccs_cc
[344.825172] Subtest pipe-A-random-ccs-data-4_tiled_mtl_rc_ccs_cc: SUCCESS (0.832s)
[346.062244] [092/142] (662s left) gem_userptr_blits (map-fixed-invalidate-busy)
[346.145305] Starting subtest: map-fixed-invalidate-busy
[346.153634] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[346.262316] [093/142] (662s left) drm_fdinfo (busy)
[346.322870] Starting subtest: busy
[346.325527] Starting dynamic subtest: rcs0
[346.330613] Dynamic subtest rcs0: SKIP (0.000s)
[346.344583] Starting dynamic subtest: bcs0
[346.349400] Dynamic subtest bcs0: SKIP (0.000s)
[346.362957] Starting dynamic subtest: vcs0
[346.367982] Dynamic subtest vcs0: SKIP (0.000s)
[346.379953] Starting dynamic subtest: vcs1
[346.384601] Dynamic subtest vcs1: SKIP (0.000s)
[346.393474] Starting dynamic subtest: vecs0
[346.397945] Dynamic subtest vecs0: SKIP (0.000s)
[346.406522] Starting dynamic subtest: ccs0
[346.411017] Dynamic subtest ccs0: SKIP (0.000s)
[346.415514] Subtest busy: SKIP (0.008s)
[346.435150] [094/142] (662s left) kms_ccs (pipe-b-crc-sprite-planes-basic-yf_tiled_ccs)
[346.848256] Starting subtest: pipe-B-crc-sprite-planes-basic-yf_tiled_ccs
[346.854152] Subtest pipe-B-crc-sprite-planes-basic-yf_tiled_ccs: SKIP (0.001s)
[347.726878] [095/142] (660s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[347.789546] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[347.805262] [096/142] (660s left) kms_color (ctm-negative)
[347.871040] Starting subtest: ctm-negative
[347.873061] Starting dynamic subtest: pipe-A
[348.598543] Dynamic subtest pipe-A: SUCCESS (0.730s)
[348.611475] Starting dynamic subtest: pipe-B
[350.109392] Dynamic subtest pipe-B: SUCCESS (1.509s)
[350.123084] Starting dynamic subtest: pipe-C
[351.567045] Dynamic subtest pipe-C: SUCCESS (1.457s)
[351.582229] Starting dynamic subtest: pipe-D
[352.970265] Dynamic subtest pipe-D: SUCCESS (1.402s)
[352.972715] Subtest ctm-negative: SUCCESS (5.103s)
[353.871805] [097/142] (654s left) kms_plane_scaling (planes-downscale-factor-0-5)
[353.949594] Starting subtest: planes-downscale-factor-0-5
[353.952036] Starting dynamic subtest: pipe-A-eDP-1
[353.956758] Dynamic subtest pipe-A-eDP-1: SKIP (0.004s)
[353.971274] Starting dynamic subtest: pipe-B-eDP-1
[353.975984] Dynamic subtest pipe-B-eDP-1: SKIP (0.019s)
[353.988490] Starting dynamic subtest: pipe-C-eDP-1
[353.997741] Dynamic subtest pipe-C-eDP-1: SKIP (0.019s)
[354.008659] Starting dynamic subtest: pipe-D-eDP-1
[354.025847] Dynamic subtest pipe-D-eDP-1: SKIP (0.025s)
[354.030410] Subtest planes-downscale-factor-0-5: SKIP (0.073s)
[354.112365] [098/142] (654s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[354.166994] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[354.269820] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[354.339589] [099/142] (654s left) gem_exec_store (basic)
[354.395562] Starting subtest: basic
[354.481838] Subtest basic: SUCCESS (0.088s)
[354.660531] [100/142] (654s left) gem_exec_fence (concurrent)
[354.838559] Starting subtest: concurrent
[354.843793] Subtest concurrent: SKIP (0.000s)
[356.549605] [101/142] (652s left) gem_exec_flush (basic-wb-rw-before-default)
[356.609231] Starting subtest: basic-wb-rw-before-default
[362.071991] Subtest basic-wb-rw-before-default: SUCCESS (5.467s)
[362.254254] [102/142] (646s left) perf_pmu (module-unload)
[362.316317] Starting subtest: module-unload
[399.304509] Subtest module-unload: SUCCESS (36.987s)
[399.328295] [103/142] (609s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[400.781758] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[401.773353] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.992s)
[402.694663] [104/142] (606s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[402.794889] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[402.799492] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[402.887257] [105/142] (606s left) gem_ppgtt (shrink-vs-evict-any)
[402.942724] Starting subtest: shrink-vs-evict-any
[408.485381] Subtest shrink-vs-evict-any: SUCCESS (5.541s)
[408.555818] [106/142] (600s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[408.638379] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[408.642929] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[408.720204] [107/142] (600s left) gem_eio (in-flight-internal-immediate)
[408.876124] Starting subtest: in-flight-internal-immediate
[410.547289] Subtest in-flight-internal-immediate: SUCCESS (1.670s)
[412.519377] [108/142] (596s left) gem_exec_parallel (basic)
[412.574677] Starting subtest: basic
[412.577160] Starting dynamic subtest: rcs0
[414.111483] Dynamic subtest rcs0: SUCCESS (1.537s)
[414.125138] Starting dynamic subtest: bcs0
[416.152209] Dynamic subtest bcs0: SUCCESS (2.039s)
[416.165813] Starting dynamic subtest: vcs0
[419.441361] Dynamic subtest vcs0: SUCCESS (3.287s)
[419.454763] Starting dynamic subtest: vcs1
[421.423241] Dynamic subtest vcs1: SUCCESS (1.981s)
[421.437084] Starting dynamic subtest: vecs0
[423.472591] Dynamic subtest vecs0: SUCCESS (2.047s)
[423.486221] Starting dynamic subtest: ccs0
[425.453437] Dynamic subtest ccs0: SUCCESS (1.980s)
[425.456847] Subtest basic: SUCCESS (12.879s)
[425.640366] [109/142] (583s left) v3d/v3d_submit_csd (single-in-sync)
[425.709679] Subtest single-in-sync: SKIP (0.000s)
[425.745034] [110/142] (583s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[425.819664] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[425.824093] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[425.898898] [111/142] (583s left) kms_cursor_crc (cursor-offscreen-64x64)
[426.000112] Starting subtest: cursor-offscreen-64x64
[426.005710] Starting dynamic subtest: pipe-A-eDP-1
[427.992187] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.988s)
[428.035139] Starting dynamic subtest: pipe-D-eDP-1
[430.732051] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.708s)
[430.734509] Subtest cursor-offscreen-64x64: SUCCESS (4.731s)
[431.623323] [112/142] (577s left) i915_pm_rpm (dpms-mode-unset-non-lpsp)
[433.639998] Starting subtest: dpms-mode-unset-non-lpsp
[436.989729] Subtest dpms-mode-unset-non-lpsp: SKIP (3.346s)
[437.807222] [113/142] (571s left) kms_flip (flip-vs-rmfb-interruptible)
[437.881192] Starting subtest: flip-vs-rmfb-interruptible
[437.886614] Starting dynamic subtest: A-eDP1
[446.571686] Dynamic subtest A-eDP1: SUCCESS (8.686s)
[446.587808] Starting dynamic subtest: B-eDP1
[455.352575] Dynamic subtest B-eDP1: SUCCESS (8.779s)
[455.366192] Starting dynamic subtest: C-eDP1
[464.110217] Dynamic subtest C-eDP1: SUCCESS (8.756s)
[464.126182] Starting dynamic subtest: D-eDP1
[472.811804] Dynamic subtest D-eDP1: SUCCESS (8.700s)
[472.819694] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.939s)
[474.125365] [114/142] (535s left) kms_psr (suspend)
[474.182131] Starting subtest: suspend
[492.853067] Subtest suspend: SUCCESS (2.931s)
[493.760462] [115/142] (531s left) kms_ccs (pipe-a-bad-pixel-format-4_tiled_dg2_rc_ccs_cc)
[493.843388] Starting subtest: pipe-A-bad-pixel-format-4_tiled_dg2_rc_ccs_cc
[493.848626] Subtest pipe-A-bad-pixel-format-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[495.050839] [116/142] (529s left) gem_exec_schedule (semaphore-noskip)
[495.130546] Starting subtest: semaphore-noskip
[495.584059] Subtest semaphore-noskip: SUCCESS (0.458s)
[495.908160] [117/142] (529s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[495.988882] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[495.992822] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[496.074852] [118/142] (528s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[496.132539] Starting subtest: blocking-absolute-wf_vblank-interruptible
[496.138420] Starting dynamic subtest: A-eDP1
[504.952814] Dynamic subtest A-eDP1: SUCCESS (8.816s)
[504.968960] Starting dynamic subtest: B-eDP1
[513.783909] Dynamic subtest B-eDP1: SUCCESS (8.830s)
[513.799250] Starting dynamic subtest: C-eDP1
[522.541586] Dynamic subtest C-eDP1: SUCCESS (8.755s)
[522.559329] Starting dynamic subtest: D-eDP1
[531.308812] Dynamic subtest D-eDP1: SUCCESS (8.766s)
[531.316450] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (35.183s)
[532.555983] [119/142] (492s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_dg2_rc_ccs_cc)
[532.963680] Starting subtest: pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs_cc
[532.971665] Subtest pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[533.823924] [120/142] (491s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[533.889292] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[533.891718] Starting dynamic subtest: pipe-A-default-mode
[534.180811] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[534.186474] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.289s)
[535.102667] [121/142] (490s left) kms_frontbuffer_tracking (basic)
[535.185651] Starting subtest: basic
[538.550762] Subtest basic: SUCCESS (3.372s)
[538.649295] [122/142] (486s left) gem_create (create-size-update)
[538.699387] Starting subtest: create-size-update
[538.701408] Subtest create-size-update: SUCCESS (0.000s)
[538.895616] [123/142] (486s left) vc4/vc4_purgeable_bo (mark-willneed)
[538.993592] Subtest mark-willneed: SKIP (0.000s)
[539.040725] [124/142] (486s left) api_intel_bb (purge-bb)
[539.092988] Starting subtest: purge-bb
[539.095794] Subtest purge-bb: SUCCESS (0.001s)
[539.192433] [125/142] (486s left) syncobj_timeline (invalid-transfer-non-existent-point)
[539.240055] Starting subtest: invalid-transfer-non-existent-point
[539.242107] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[539.302484] [126/142] (485s left) gem_exec_reloc (basic-cpu-noreloc)
[539.353063] Subtest basic-cpu-noreloc: SKIP (0.000s)
[539.398575] [127/142] (485s left) gem_lmem_swapping (heavy-random)
[539.448330] Subtest heavy-random: SKIP (0.000s)
[539.473526] [128/142] (485s left) kms_plane (plane-panning-bottom-right-suspend)
[539.520229] Starting subtest: plane-panning-bottom-right-suspend
[539.522622] Starting dynamic subtest: pipe-A-planes
[557.793976] Dynamic subtest pipe-A-planes: SUCCESS (2.926s)
[557.807921] Starting dynamic subtest: pipe-B-planes
[576.869704] Dynamic subtest pipe-B-planes: SUCCESS (3.718s)
[576.872721] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.648s)
[577.772888] [129/142] (478s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[577.834753] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[577.839379] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[577.928140] [130/142] (478s left) kms_addfb_basic (bad-pitch-0)
[577.982937] Starting subtest: bad-pitch-0
[577.984867] Subtest bad-pitch-0: SUCCESS (0.000s)
[578.095467] [131/142] (478s left) kms_scaling_modes (scaling-mode-center)
[578.169410] Starting subtest: scaling-mode-center
[578.172007] Starting dynamic subtest: eDP-1-pipe-A
[578.284926] Dynamic subtest eDP-1-pipe-A: SUCCESS (0.115s)
[578.303404] Starting dynamic subtest: eDP-1-pipe-B
[579.512787] Dynamic subtest eDP-1-pipe-B: SUCCESS (1.225s)
[579.529190] Starting dynamic subtest: eDP-1-pipe-C
[580.757242] Dynamic subtest eDP-1-pipe-C: SUCCESS (1.242s)
[580.767534] Starting dynamic subtest: eDP-1-pipe-D
[581.977203] Dynamic subtest eDP-1-pipe-D: SUCCESS (1.215s)
[581.979445] Subtest scaling-mode-center: SUCCESS (3.807s)
[583.230371] [132/142] (472s left) kms_big_fb (linear-addfb)
[583.319652] Starting subtest: linear-addfb
[583.321893] Subtest linear-addfb: SUCCESS (0.000s)
[583.408190] [133/142] (472s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[583.456748] Starting subtest: invalid-multi-wait-all-unsubmitted
[583.459614] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[583.525134] [134/142] (472s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[583.600647] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[586.400300] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (2.803s)
[586.535672] [135/142] (469s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[586.615847] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[589.719789] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (3.108s)
[589.844446] [136/142] (466s left) syncobj_timeline (invalid-signal-zero-handles)
[589.877136] Starting subtest: invalid-signal-zero-handles
[589.878875] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[589.938075] [137/142] (466s left) v3d/v3d_job_submission (array-job-submission)
[590.026097] Subtest array-job-submission: SKIP (0.000s)
[590.078175] [138/142] (466s left) gem_exec_reloc (basic-scanout)
[590.143585] Subtest basic-scanout: SKIP (0.000s)
[590.202692] [139/142] (466s left) kms_flip (2x-flip-vs-panning-vs-hang)
[590.267842] Starting subtest: 2x-flip-vs-panning-vs-hang
[590.285553] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.019s)
[590.359894] [140/142] (465s left) kms_ccs (pipe-d-missing-ccs-buffer-y_tiled_ccs)
[590.777632] Starting subtest: pipe-D-missing-ccs-buffer-y_tiled_ccs
[590.783399] Subtest pipe-D-missing-ccs-buffer-y_tiled_ccs: SKIP (0.000s)
[591.675008] [141/142] (464s left) sysfs_timeslice_duration (idempotent)
[591.754547] Starting subtest: idempotent
[591.757023] Starting dynamic subtest: vecs0
[591.759439] Dynamic subtest vecs0: SUCCESS (0.001s)
[591.768651] Starting dynamic subtest: ccs0
[591.770585] Dynamic subtest ccs0: SUCCESS (0.000s)
[591.777238] Starting dynamic subtest: vcs0
[591.779132] Dynamic subtest vcs0: SUCCESS (0.000s)
[591.785066] Starting dynamic subtest: bcs0
[591.786951] Dynamic subtest bcs0: SUCCESS (0.001s)
[591.792791] Starting dynamic subtest: rcs0
[591.794728] Dynamic subtest rcs0: SUCCESS (0.000s)
[591.800451] Starting dynamic subtest: vcs1
[591.802351] Dynamic subtest vcs1: SUCCESS (0.000s)
[591.804239] Subtest idempotent: SUCCESS (0.008s)
[591.848328] [142/142] (464s left) gem_exec_nop (basic-sequential)
[591.919084] Starting subtest: basic-sequential
[608.030301] Subtest basic-sequential: SUCCESS (16.116s)
[608.226558] Closing watchdogs
Done.