[50.604795] Initializing watchdogs
[50.605382]   /dev/watchdog0
[50.637073] [001/142] (960s left) kms_addfb_basic (unused-offsets)
[51.055929] Starting subtest: unused-offsets
[51.059379] Subtest unused-offsets: SUCCESS (0.000s)
[51.336340] [002/142] (959s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[51.815842] Starting subtest: addfb25-y-tiled-legacy
[51.819976] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[51.965536] [003/142] (959s left) vgem_basic (dmabuf-mmap)
[52.473915] Starting subtest: dmabuf-mmap
[52.525164] Subtest dmabuf-mmap: SUCCESS (0.054s)
[52.633800] [004/142] (958s left) kms_vblank (pipe-d-ts-continuation-idle)
[53.096295] Starting subtest: pipe-D-ts-continuation-idle
[55.044702] Subtest pipe-D-ts-continuation-idle: SUCCESS (1.948s)
[55.970561] [005/142] (955s left) device_reset (unbind-cold-reset-rebind)
[56.803991] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[56.923878] [006/142] (954s left) kms_flip (flip-vs-fences-interruptible)
[57.320162] Starting subtest: flip-vs-fences-interruptible
[57.326744] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[57.472461] [007/142] (954s left) gem_softpin (allocator-nopin-reserve)
[57.861057] Starting subtest: allocator-nopin-reserve
[58.407516] Subtest allocator-nopin-reserve: SUCCESS (0.545s)
[58.641599] [008/142] (952s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[59.144348] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[59.149903] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[59.301786] [009/142] (952s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[59.795738] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[59.802224] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[59.945483] [010/142] (951s left) kms_chamelium_audio (dp-audio-edid)
[60.817735] Subtest dp-audio-edid: SKIP (0.000s)
[61.673777] [011/142] (950s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[62.104081] Starting subtest: basic-batch-kernel-default-cmd
[62.110558] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[62.365592] [012/142] (949s left) kms_selftest (framebuffer)
[62.713932] Starting subtest: framebuffer
[62.725178] Subtest framebuffer: SKIP (0.005s)
[62.832826] [013/142] (949s left) perf_pmu (interrupts-sync)
[63.217611] Starting subtest: interrupts-sync
[64.444404] Subtest interrupts-sync: SUCCESS (1.225s)
[64.611195] [014/142] (947s left) vc4/vc4_create_bo (create-bo-4096)
[65.099086] Subtest create-bo-4096: SKIP (0.000s)
[65.230343] [015/142] (946s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[65.743872] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[65.750287] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[65.888502] [016/142] (946s left) gem_ccs (ctrl-surf-copy-new-ctx)
[66.282634] Starting subtest: ctrl-surf-copy-new-ctx
[66.290229] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[66.415113] [017/142] (945s left) kms_atomic_transition (modeset-transition-fencing)
[66.888396] Starting subtest: modeset-transition-fencing
[66.891798] Starting dynamic subtest: 1x-outputs
[94.044810] Dynamic subtest 1x-outputs: SUCCESS (27.152s)
[94.391909] Subtest modeset-transition-fencing: SUCCESS (27.501s)
[95.351996] [018/142] (916s left) kms_cursor_crc (cursor-suspend)
[95.933687] Starting subtest: cursor-suspend
[95.948052] Starting dynamic subtest: pipe-A-eDP-1
[130.960431] Dynamic subtest pipe-A-eDP-1: SUCCESS (35.015s)
[131.004740] Starting dynamic subtest: pipe-D-eDP-1
[167.910748] Dynamic subtest pipe-D-eDP-1: SUCCESS (36.938s)
[167.914490] Subtest cursor-suspend: SUCCESS (71.974s)
[169.283957] [019/142] (843s left) gem_pxp (create-valid-protected-context)
[172.188497] Subtest create-valid-protected-context: SKIP (0.000s)
[172.362984] [020/142] (840s left) kms_ccs (pipe-c-crc-primary-rotation-180-yf_tiled_ccs)
[173.635587] Starting subtest: pipe-C-crc-primary-rotation-180-yf_tiled_ccs
[173.643124] Subtest pipe-C-crc-primary-rotation-180-yf_tiled_ccs: SKIP (0.001s)
[174.131304] [021/142] (838s left) sw_sync (sync_multi_producer_single_consumer)
[174.496785] Starting subtest: sync_multi_producer_single_consumer
[175.581425] Subtest sync_multi_producer_single_consumer: SUCCESS (1.083s)
[175.719207] [022/142] (836s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[176.205372] Starting subtest: FB-8BPC-Vs-Panel-6BPC
[176.208304] Starting dynamic subtest: pipe-A-eDP-1
[177.925319] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.720s)
[177.928777] Subtest FB-8BPC-Vs-Panel-6BPC: SUCCESS (1.724s)
[178.872993] [023/142] (833s left) gem_exec_fence (syncobj-timeline-export)
[179.919405] Starting subtest: syncobj-timeline-export
[179.921986] Subtest syncobj-timeline-export: SUCCESS (0.003s)
[181.591582] [024/142] (831s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_mtl_rc_ccs)
[182.068296] Starting subtest: pipe-D-bad-rotation-90-4_tiled_mtl_rc_ccs
[182.812733] Subtest pipe-D-bad-rotation-90-4_tiled_mtl_rc_ccs: SUCCESS (0.744s)
[184.084332] [025/142] (828s left) syncobj_wait (invalid-wait-zero-handles)
[184.463258] Starting subtest: invalid-wait-zero-handles
[184.466925] Subtest invalid-wait-zero-handles: SUCCESS (0.000s)
[184.614492] [026/142] (828s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[185.134339] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[185.141091] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[185.298747] [027/142] (827s left) gem_ctx_exec (basic-nohangcheck)
[185.678874] Starting subtest: basic-nohangcheck
[187.007987] Subtest basic-nohangcheck: SUCCESS (1.328s)
[187.178918] [028/142] (825s left) gem_mmap (bad-offset)
[187.555278] Subtest bad-offset: SKIP (0.000s)
[187.665385] [029/142] (825s left) gem_exec_reloc (basic-write-read)
[188.067505] Subtest basic-write-read: SKIP (0.000s)
[188.214286] [030/142] (825s left) gem_exec_parallel (userptr)
[188.649156] Starting subtest: userptr
[188.652539] Starting dynamic subtest: rcs0
[193.484772] Dynamic subtest rcs0: SUCCESS (4.834s)
[193.528787] Starting dynamic subtest: bcs0
[197.748613] Dynamic subtest bcs0: SUCCESS (4.260s)
[197.800373] Starting dynamic subtest: vcs0
[201.551983] Dynamic subtest vcs0: SUCCESS (3.799s)
[201.596909] Starting dynamic subtest: vcs1
[204.498357] Dynamic subtest vcs1: SUCCESS (2.944s)
[204.552595] Starting dynamic subtest: vecs0
[207.660499] Dynamic subtest vecs0: SUCCESS (3.159s)
[207.701939] Starting dynamic subtest: ccs0
[212.061737] Dynamic subtest ccs0: SUCCESS (4.397s)
[212.065601] Subtest userptr: SUCCESS (23.415s)
[212.400659] [031/142] (800s left) gem_exec_reloc (basic-gtt-cpu)
[212.809175] Subtest basic-gtt-cpu: SKIP (0.000s)
[212.957784] [032/142] (800s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[213.510657] Starting subtest: yf-tiled-32bpp-rotate-270
[213.517779] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[213.682403] [033/142] (799s left) kms_ccs (pipe-b-bad-aux-stride-y_tiled_gen12_mc_ccs)
[214.943169] Starting subtest: pipe-B-bad-aux-stride-y_tiled_gen12_mc_ccs
[214.949652] Subtest pipe-B-bad-aux-stride-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[216.022346] [034/142] (797s left) kms_vblank (pipe-c-ts-continuation-dpms-rpm)
[216.504539] Starting subtest: pipe-C-ts-continuation-dpms-rpm
[220.841705] Subtest pipe-C-ts-continuation-dpms-rpm: SUCCESS (4.339s)
[221.808206] [035/142] (791s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[222.189376] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[222.291551] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[222.438947] [036/142] (791s left) kms_prop_blob (basic)
[222.811754] Starting subtest: basic
[222.815375] Subtest basic: SUCCESS (0.000s)
[222.943470] [037/142] (790s left) kms_getfb (getfb-handle-closed)
[223.308339] Starting subtest: getfb-handle-closed
[223.312842] Subtest getfb-handle-closed: SUCCESS (0.000s)
[223.487378] [038/142] (790s left) kms_ccs (pipe-d-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs)
[224.356997] Starting subtest: pipe-D-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs
[224.367181] Subtest pipe-D-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs: SKIP (0.005s)
[225.061181] [039/142] (788s left) gem_mmap_offset (ptrace)
[225.369246] Starting subtest: ptrace
[225.378326] Starting dynamic subtest: smem0-wb
[225.503444] Dynamic subtest smem0-wb: SUCCESS (0.124s)
[225.538188] Starting dynamic subtest: smem0-wc
[225.642903] Dynamic subtest smem0-wc: SUCCESS (0.136s)
[225.677580] Starting dynamic subtest: smem0-uc
[225.789610] Dynamic subtest smem0-uc: SUCCESS (0.143s)
[225.793166] Subtest ptrace: SUCCESS (0.423s)
[225.962903] [040/142] (788s left) syncobj_timeline (invalid-query-zero-handles)
[226.335990] Starting subtest: invalid-query-zero-handles
[226.340476] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[226.474513] [041/142] (787s left) gem_lmem_swapping (heavy-verify-random-ccs)
[226.876630] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[227.003137] [042/142] (787s left) core_setmaster_vs_auth
[227.531793] [043/142] (786s left) kms_selftest (drm_format_helper)
[227.893036] Starting subtest: drm_format_helper
[227.904234] Subtest drm_format_helper: SKIP (0.007s)
[228.047908] [044/142] (786s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[228.564956] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[228.571564] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[228.725282] [045/142] (785s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[229.239551] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[229.246315] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[229.403838] [046/142] (785s left) gem_mmap_gtt (big-copy)
[229.770711] Subtest big-copy: SKIP (0.000s)
[229.888224] [047/142] (784s left) kms_psr (psr2_primary_mmap_cpu)
[230.370913] Starting subtest: psr2_primary_mmap_cpu
[233.642474] Subtest psr2_primary_mmap_cpu: SUCCESS (3.267s)
[234.594607] [048/142] (780s left) gem_exec_reloc (basic-gtt-active)
[234.990591] Subtest basic-gtt-active: SKIP (0.000s)
[235.129479] [049/142] (779s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_dg2_rc_ccs)
[236.760068] Starting subtest: pipe-D-crc-primary-basic-4_tiled_dg2_rc_ccs
[236.766633] Subtest pipe-D-crc-primary-basic-4_tiled_dg2_rc_ccs: SKIP (0.002s)
[237.506350] [050/142] (777s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[237.993791] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[238.000183] Starting dynamic subtest: pipe-A-default-mode
[240.243367] Dynamic subtest pipe-A-default-mode: SKIP (2.235s)
[240.250522] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (2.249s)
[240.499125] [051/142] (774s left) kms_rmfb (close-fd)
[240.990206] Starting subtest: close-fd
[240.993726] Starting dynamic subtest: pipe-A-eDP-1
[241.311055] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.314s)
[241.364864] Starting dynamic subtest: pipe-B-eDP-1
[242.962261] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.642s)
[243.011216] Starting dynamic subtest: pipe-C-eDP-1
[244.632080] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.663s)
[244.681929] Starting dynamic subtest: pipe-D-eDP-1
[246.349740] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.711s)
[246.352939] Subtest close-fd: SUCCESS (5.365s)
[247.818720] [052/142] (767s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[248.300110] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[248.307262] Starting dynamic subtest: pipe-A-default-mode
[248.703844] Dynamic subtest pipe-A-default-mode: SKIP (0.391s)
[248.709805] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.405s)
[249.648435] [053/142] (765s left) kms_psr (cursor_plane_onoff)
[250.125355] Starting subtest: cursor_plane_onoff
[253.183562] Subtest cursor_plane_onoff: SUCCESS (3.057s)
[254.125769] [054/142] (761s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[254.648725] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[254.655611] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[254.817652] [055/142] (760s left) gem_ctx_bad_destroy (invalid-default-ctx)
[255.197462] Starting subtest: invalid-default-ctx
[255.201135] Subtest invalid-default-ctx: SUCCESS (0.000s)
[255.346417] [056/142] (760s left) kms_plane_scaling (plane-downscale-with-modifiers-factor-0-25)
[255.839482] Starting subtest: plane-downscale-with-modifiers-factor-0-25
[255.845150] Starting dynamic subtest: pipe-A-eDP-1
[256.038736] Dynamic subtest pipe-A-eDP-1: SKIP (0.189s)
[256.088660] Starting dynamic subtest: pipe-B-eDP-1
[256.320251] Dynamic subtest pipe-B-eDP-1: SKIP (0.272s)
[256.368876] Starting dynamic subtest: pipe-C-eDP-1
[256.604842] Dynamic subtest pipe-C-eDP-1: SKIP (0.273s)
[256.653878] Starting dynamic subtest: pipe-D-eDP-1
[256.892379] Dynamic subtest pipe-D-eDP-1: SKIP (0.274s)
[256.899158] Subtest plane-downscale-with-modifiers-factor-0-25: SKIP (1.051s)
[257.078412] [057/142] (758s left) i915_pm_rps (engine-order)
[257.481410] Starting subtest: engine-order
[264.489085] Subtest engine-order: SUCCESS (7.007s)
[264.673640] [058/142] (750s left) api_intel_allocator (execbuf-with-allocator)
[265.051789] Starting subtest: execbuf-with-allocator
[265.074780] Subtest execbuf-with-allocator: SUCCESS (0.024s)
[265.269231] [059/142] (750s left) i915_pm_rpm (drm-resources-equal)
[267.710448] Starting subtest: drm-resources-equal
[277.258785] Subtest drm-resources-equal: SUCCESS (9.554s)
[277.454992] [060/142] (738s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[277.881262] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[278.047425] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.167s)
[278.216904] [061/142] (737s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[278.600085] Starting subtest: single-wait-all-for-submit-available-signaled
[278.603767] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.001s)
[278.750325] [062/142] (737s left) gem_exec_await (wide-all)
[280.335953] Starting subtest: wide-all
[305.691504] Subtest wide-all: SUCCESS (25.355s)
[306.032566] [063/142] (710s left) gem_exec_balancer (nohangcheck)
[307.396905] Starting subtest: nohangcheck
[313.930905] Subtest nohangcheck: SUCCESS (6.535s)
[314.110208] [064/142] (702s left) gem_ctx_persistence (processes)
[314.512470] Starting subtest: processes
[316.606793] Subtest processes: SUCCESS (2.094s)
[316.797915] [065/142] (699s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[317.321937] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[327.440591] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (10.115s)
[327.752967] [066/142] (688s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[328.320267] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[328.330498] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.008s)
[328.646591] [067/142] (687s left) kms_content_protection (dp-mst-lic-type-1)
[329.343883] Starting subtest: dp-mst-lic-type-1
[329.350491] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[329.541274] [068/142] (687s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[330.019760] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[330.023412] Starting dynamic subtest: pipe-A-eDP-1
[330.262374] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.239s)
[330.321918] Starting dynamic subtest: pipe-B-eDP-1
[331.763880] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.491s)
[331.823155] Starting dynamic subtest: pipe-C-eDP-1
[333.302582] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.527s)
[333.366232] Starting dynamic subtest: pipe-D-eDP-1
[334.839528] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.526s)
[334.842797] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (4.827s)
[336.348408] [069/142] (680s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_gen12_mc_ccs)
[337.506935] Starting subtest: pipe-B-crc-primary-basic-y_tiled_gen12_mc_ccs
[337.512999] Subtest pipe-B-crc-primary-basic-y_tiled_gen12_mc_ccs: SKIP (0.002s)
[338.748213] [070/142] (677s left) kms_setmode (clone-exclusive-crtc)
[339.120161] Starting subtest: clone-exclusive-crtc
[339.129179] Subtest clone-exclusive-crtc: SKIP (0.003s)
[339.279545] [071/142] (677s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[339.792641] Starting subtest: psr-rgb565-draw-blt
[353.978467] Subtest psr-rgb565-draw-blt: SUCCESS (14.185s)
[354.261578] [072/142] (662s left) gem_exec_balancer (bonded-pair)
[354.693086] Starting subtest: bonded-pair
[354.699763] Subtest bonded-pair: SKIP (0.001s)
[355.701201] [073/142] (661s left) kms_ccs (pipe-b-ccs-on-another-bo-y_tiled_gen12_mc_ccs)
[356.974779] Starting subtest: pipe-B-ccs-on-another-bo-y_tiled_gen12_mc_ccs
[356.981187] Subtest pipe-B-ccs-on-another-bo-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[358.109473] [074/142] (659s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[358.525553] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[358.532171] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[358.810220] [075/142] (658s left) kms_lease (lease_invalid_plane)
[359.296400] Starting subtest: lease_invalid_plane
[359.299932] Starting dynamic subtest: pipe-A-eDP-1
[359.303496] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[359.361105] Starting dynamic subtest: pipe-B-eDP-1
[359.364358] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[359.414946] Starting dynamic subtest: pipe-C-eDP-1
[359.418526] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[359.468444] Starting dynamic subtest: pipe-D-eDP-1
[359.471966] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[359.475555] Subtest lease_invalid_plane: SUCCESS (0.037s)
[359.546450] [076/142] (657s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[360.056211] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[374.599268] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (14.549s)
[374.835059] [077/142] (642s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[375.369876] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[375.377409] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[375.554888] [078/142] (641s left) kms_big_joiner (2x-modeset)
[376.044131] Subtest 2x-modeset: SKIP (0.000s)
[376.164845] [079/142] (641s left) gem_exec_whisper (basic-fds-all)
[376.590848] Starting subtest: basic-fds-all
[395.588398] Subtest basic-fds-all: SUCCESS (18.992s)
[396.003816] [080/142] (621s left) kms_ccs (pipe-a-crc-primary-rotation-180-y_tiled_gen12_rc_ccs)
[396.935937] Starting subtest: pipe-A-crc-primary-rotation-180-y_tiled_gen12_rc_ccs
[396.942568] Subtest pipe-A-crc-primary-rotation-180-y_tiled_gen12_rc_ccs: SKIP (0.002s)
[398.353398] [081/142] (619s left) kms_ccs (pipe-c-bad-pixel-format-4_tiled_dg2_mc_ccs)
[399.684109] Starting subtest: pipe-C-bad-pixel-format-4_tiled_dg2_mc_ccs
[399.690684] Subtest pipe-C-bad-pixel-format-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[400.717909] [082/142] (617s left) gem_exec_reloc (basic-gtt-read)
[401.139194] Subtest basic-gtt-read: SKIP (0.000s)
[401.285508] [083/142] (616s left) v3d/v3d_get_param (get-bad-param)
[401.789808] Subtest get-bad-param: SKIP (0.000s)
[401.932508] [084/142] (616s left) gen7_exec_parse (basic-rejected)
[402.335565] Subtest basic-rejected: SKIP (0.000s)
[402.470595] [085/142] (615s left) gem_ctx_param (root-set)
[402.846512] Starting subtest: root-set
[402.849996] Subtest root-set: SUCCESS (0.002s)
[403.003795] [086/142] (615s left) gem_spin_batch (legacy-resubmit)
[403.424895] Starting subtest: legacy-resubmit
[403.428766] Starting dynamic subtest: default
[403.442180] Dynamic subtest default: SUCCESS (0.014s)
[403.511376] Starting dynamic subtest: render
[403.515236] Dynamic subtest render: SUCCESS (0.008s)
[403.569795] Starting dynamic subtest: bsd
[403.573052] Dynamic subtest bsd: SUCCESS (0.009s)
[403.625939] Starting dynamic subtest: bsd1
[403.629505] Dynamic subtest bsd1: SUCCESS (0.007s)
[403.680994] Starting dynamic subtest: bsd2
[403.684115] Dynamic subtest bsd2: SUCCESS (0.006s)
[403.736109] Starting dynamic subtest: blt
[403.739103] Dynamic subtest blt: SUCCESS (0.007s)
[403.790872] Starting dynamic subtest: vebox
[403.793918] Dynamic subtest vebox: SUCCESS (0.006s)
[403.796894] Subtest legacy-resubmit: SUCCESS (0.093s)
[404.682301] [087/142] (613s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[405.233242] Starting subtest: x-tiled-32bpp-rotate-0
[410.542137] Subtest x-tiled-32bpp-rotate-0: SUCCESS (5.309s)
[411.110948] [088/142] (607s left) perf_pmu (idle)
[411.411154] Starting subtest: idle
[411.415440] Starting dynamic subtest: rcs0
[411.937304] Dynamic subtest rcs0: SUCCESS (0.529s)
[411.992909] Starting dynamic subtest: bcs0
[412.462700] Dynamic subtest bcs0: SUCCESS (0.522s)
[412.483452] Starting dynamic subtest: vcs0
[412.989652] Dynamic subtest vcs0: SUCCESS (0.515s)
[413.016935] Starting dynamic subtest: vcs1
[413.507522] Dynamic subtest vcs1: SUCCESS (0.522s)
[413.535196] Starting dynamic subtest: vecs0
[414.036248] Dynamic subtest vecs0: SUCCESS (0.523s)
[414.077416] Starting dynamic subtest: ccs0
[414.559739] Dynamic subtest ccs0: SUCCESS (0.521s)
[414.563942] Subtest idle: SUCCESS (3.155s)
[414.700601] [089/142] (603s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[415.218379] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[415.225405] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[415.398613] [090/142] (603s left) syncobj_wait (wait-all-for-submit-complex)
[415.778551] Starting subtest: wait-all-for-submit-complex
[415.997330] Subtest wait-all-for-submit-complex: SUCCESS (0.218s)
[416.156732] [091/142] (602s left) v3d/v3d_submit_csd (bad-multisync-in-sync)
[416.627433] Subtest bad-multisync-in-sync: SKIP (0.000s)
[416.766694] [092/142] (601s left) kms_concurrent (pipe-d)
[417.265364] Starting subtest: pipe-D
[417.274746] Starting dynamic subtest: eDP-1
[419.204165] Dynamic subtest eDP-1: SUCCESS (1.928s)
[419.207805] Subtest pipe-D: SUCCESS (1.939s)
[420.107909] [093/142] (598s left) kms_frontbuffer_tracking (fbc-tiling-4)
[420.292112] Starting subtest: fbc-tiling-4
[431.354310] Subtest fbc-tiling-4: SUCCESS (11.063s)
[431.631437] [094/142] (587s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[432.142801] Starting subtest: fbc-rgb565-draw-pwrite
[444.252993] Subtest fbc-rgb565-draw-pwrite: SUCCESS (12.113s)
[444.561958] [095/142] (574s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[444.939862] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[445.043823] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.104s)
[445.204638] [096/142] (573s left) i915_pm_rpm (pc8-residency)
[447.737178] Starting subtest: pc8-residency
[447.743821] Subtest pc8-residency: SKIP (0.000s)
[448.380422] [097/142] (570s left) kms_ccs (pipe-a-missing-ccs-buffer-4_tiled_mtl_mc_ccs)
[449.389213] Starting subtest: pipe-A-missing-ccs-buffer-4_tiled_mtl_mc_ccs
[449.557921] Subtest pipe-A-missing-ccs-buffer-4_tiled_mtl_mc_ccs: SUCCESS (0.168s)
[450.957762] [098/142] (568s left) kms_addfb_basic (bad-pitch-128)
[451.341754] Starting subtest: bad-pitch-128
[451.344841] Subtest bad-pitch-128: SUCCESS (0.000s)
[451.646942] [099/142] (567s left) kms_cursor_crc (cursor-random-max-size)
[452.954531] Starting subtest: cursor-random-max-size
[452.965175] Subtest cursor-random-max-size: SKIP (0.000s)
[453.243151] [100/142] (566s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[453.631085] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[453.635565] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.004s)
[453.795822] [101/142] (565s left) gem_exec_fair (basic-deadline)
[454.214428] Subtest basic-deadline: SKIP (0.000s)
[454.373379] [102/142] (565s left) gem_exec_create (forked)
[454.793379] Starting subtest: forked
[454.797758] Starting dynamic subtest: smem
[476.551128] Dynamic subtest smem: SUCCESS (21.755s)
[476.555060] Subtest forked: SUCCESS (21.759s)
[476.870351] [103/142] (542s left) dumb_buffer (create-clear)
[477.249334] Starting subtest: create-clear
[517.208680] Subtest create-clear: SUCCESS (39.953s)
[517.453488] [104/142] (502s left) kms_big_fb (linear-16bpp-rotate-270)
[517.994422] Starting subtest: linear-16bpp-rotate-270
[518.054241] Subtest linear-16bpp-rotate-270: SKIP (0.057s)
[518.258315] [105/142] (501s left) gem_workarounds (reset-fd)
[518.712820] Starting subtest: reset-fd
[520.357524] Subtest reset-fd: SUCCESS (1.644s)
[520.553588] [106/142] (499s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[521.068875] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[521.076082] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[521.254909] [107/142] (498s left) kms_plane_lowres (tiling-x)
[521.742889] Starting subtest: tiling-x
[521.746598] Starting dynamic subtest: pipe-A-eDP-1
[521.752809] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[522.207322] Starting dynamic subtest: pipe-B-eDP-1
[522.213236] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[522.267434] Starting dynamic subtest: pipe-C-eDP-1
[522.274845] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[522.327633] Starting dynamic subtest: pipe-D-eDP-1
[522.334871] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[522.341818] Subtest tiling-x: SKIP (0.501s)
[523.101393] [108/142] (497s left) gem_partial_pwrite_pread (reads-snoop)
[523.492205] Subtest reads-snoop: SKIP (0.000s)
[523.656222] [109/142] (496s left) v3d/v3d_create_bo (create-bo-zeroed)
[524.152772] Subtest create-bo-zeroed: SKIP (0.000s)
[524.286089] [110/142] (496s left) kms_lease (cursor_implicit_plane)
[524.778846] Starting subtest: cursor_implicit_plane
[524.789207] Starting dynamic subtest: pipe-A-eDP-1
[525.476561] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.690s)
[525.537961] Starting dynamic subtest: pipe-B-eDP-1
[526.815050] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.330s)
[526.877301] Starting dynamic subtest: pipe-C-eDP-1
[528.403806] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.579s)
[528.465641] Starting dynamic subtest: pipe-D-eDP-1
[529.612867] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.197s)
[529.616562] Subtest cursor_implicit_plane: SUCCESS (4.833s)
[530.559877] [111/142] (489s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[531.097205] Starting subtest: basic-flip-before-cursor-varying-size
[532.256891] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.160s)
[533.248835] [112/142] (487s left) i915_hangman (engine-engine-error)
[533.693698] Starting subtest: engine-engine-error
[533.697250] Starting dynamic subtest: rcs0
[535.560775] Dynamic subtest rcs0: SUCCESS (1.866s)
[535.614362] Starting dynamic subtest: bcs0
[538.566337] Dynamic subtest bcs0: SUCCESS (3.002s)
[538.616157] Starting dynamic subtest: vcs0
[540.550593] Dynamic subtest vcs0: SUCCESS (1.980s)
[540.599753] Starting dynamic subtest: vcs1
[542.533911] Dynamic subtest vcs1: SUCCESS (1.979s)
[542.573775] Starting dynamic subtest: vecs0
[544.518882] Dynamic subtest vecs0: SUCCESS (1.979s)
[544.565087] Starting dynamic subtest: ccs0
[547.526991] Dynamic subtest ccs0: SUCCESS (3.005s)
[547.530536] Subtest engine-engine-error: SUCCESS (13.837s)
[547.745519] [113/142] (472s left) gem_exec_flush (basic-wb-prw-default)
[548.184686] Starting subtest: basic-wb-prw-default
[554.077479] Subtest basic-wb-prw-default: SUCCESS (5.892s)
[554.393589] [114/142] (466s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[554.903760] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[569.064419] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (14.164s)
[569.342799] [115/142] (451s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[569.767063] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[569.938679] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.167s)
[570.123656] [116/142] (450s left) i915_pm_backlight (fade)
[570.608487] Starting subtest: fade
[570.964475] Starting dynamic subtest: eDP-1
[573.863793] Dynamic subtest eDP-1: SUCCESS (2.903s)
[573.867908] Subtest fade: SUCCESS (3.256s)
[574.848079] [117/142] (446s left) gem_ctx_param (invalid-ctx-set)
[575.231383] Starting subtest: invalid-ctx-set
[575.235320] Subtest invalid-ctx-set: SUCCESS (0.002s)
[575.389770] [118/142] (445s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[576.276874] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[577.155626] [119/142] (444s left) gem_exec_schedule (reorder-wide)
[577.750183] Subtest reorder-wide: SKIP (0.000s)
[578.029570] [120/142] (443s left) kms_ccs (pipe-c-random-ccs-data-y_tiled_gen12_rc_ccs_cc)
[579.493922] Starting subtest: pipe-C-random-ccs-data-y_tiled_gen12_rc_ccs_cc
[579.503758] Subtest pipe-C-random-ccs-data-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[580.420372] [121/142] (441s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[580.927141] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[594.483727] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (13.558s)
[594.775502] [122/142] (426s left) perf_pmu (busy-check-all)
[595.167214] Starting subtest: busy-check-all
[595.170957] Starting dynamic subtest: rcs0
[595.760967] Dynamic subtest rcs0: SUCCESS (0.592s)
[595.825594] Starting dynamic subtest: bcs0
[596.343553] Dynamic subtest bcs0: SUCCESS (0.579s)
[596.405872] Starting dynamic subtest: vcs0
[597.509551] Dynamic subtest vcs0: SUCCESS (1.160s)
[597.567194] Starting dynamic subtest: vcs1
[599.557461] Dynamic subtest vcs1: SUCCESS (2.044s)
[599.611854] Starting dynamic subtest: vecs0
[601.542684] Dynamic subtest vecs0: SUCCESS (1.979s)
[601.597480] Starting dynamic subtest: ccs0
[602.125307] Dynamic subtest ccs0: SUCCESS (0.581s)
[602.128987] Subtest busy-check-all: SUCCESS (6.960s)
[602.329557] [123/142] (419s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[602.911083] Starting subtest: 2x-long-flip-vs-cursor-atomic
[602.927345] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.016s)
[603.267111] [124/142] (418s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_dg2_mc_ccs)
[604.463466] Starting subtest: pipe-B-random-ccs-data-4_tiled_dg2_mc_ccs
[604.473244] Subtest pipe-B-random-ccs-data-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[605.631436] [125/142] (416s left) kms_cursor_crc (cursor-offscreen-max-size)
[606.965422] Starting subtest: cursor-offscreen-max-size
[606.976410] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[607.248409] [126/142] (414s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[607.770355] Starting subtest: fbc-rgb565-draw-blt
[617.899154] Subtest fbc-rgb565-draw-blt: SUCCESS (10.130s)
[618.225243] [127/142] (403s left) kms_rotation_crc (primary-rotation-270)
[618.711756] Starting subtest: primary-rotation-270
[618.724816] Subtest primary-rotation-270: SKIP (0.007s)
[618.882940] [128/142] (403s left) drm_fdinfo (virtual-idle)
[619.275840] Starting subtest: virtual-idle
[622.339156] Subtest virtual-idle: SUCCESS (3.060s)
[622.520333] [129/142] (399s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[623.077478] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[623.084737] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[623.243894] [130/142] (399s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[623.801976] Starting subtest: 4-tiled-8bpp-rotate-0
[627.892234] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (4.088s)
[628.270457] [131/142] (394s left) kms_chamelium_edid (hdmi-mode-timings)
[629.171513] Subtest hdmi-mode-timings: SKIP (0.000s)
[630.051432] [132/142] (392s left) gem_ctx_persistence (idempotent)
[630.444316] Starting subtest: idempotent
[630.447810] Subtest idempotent: SUCCESS (0.000s)
[630.611345] [133/142] (392s left) api_intel_allocator (simple-allocator)
[630.978701] Starting subtest: simple-allocator
[630.982208] Starting dynamic subtest: basic
[630.991602] Dynamic subtest basic: SUCCESS (0.012s)
[631.041959] Starting dynamic subtest: parallel-one
[631.519231] Dynamic subtest parallel-one: SUCCESS (0.521s)
[631.579348] Starting dynamic subtest: print
[631.583125] Dynamic subtest print: SUCCESS (0.000s)
[631.638181] Starting dynamic subtest: reuse
[631.641272] Dynamic subtest reuse: SUCCESS (0.001s)
[631.697658] Starting dynamic subtest: reserve
[631.701743] Dynamic subtest reserve: SUCCESS (0.001s)
[631.756681] Starting dynamic subtest: fork-reopen-allocator
[631.760303] Dynamic subtest fork-reopen-allocator: SUCCESS (0.080s)
[631.763785] Subtest simple-allocator: SUCCESS (0.642s)
[631.838791] [134/142] (390s left) vc4/vc4_purgeable_bo (mark-unpurgeable-check-retained)
[632.320822] Subtest mark-unpurgeable-check-retained: SKIP (0.000s)
[632.463177] [135/142] (390s left) gem_exec_schedule (pi-ringfull)
[633.062402] Starting subtest: pi-ringfull
[633.066049] Starting dynamic subtest: rcs0
[633.221139] Dynamic subtest rcs0: SUCCESS (0.156s)
[633.296156] Starting dynamic subtest: bcs0
[633.379770] Dynamic subtest bcs0: SUCCESS (0.155s)
[633.455951] Starting dynamic subtest: vcs0
[633.539666] Dynamic subtest vcs0: SUCCESS (0.156s)
[633.622963] Starting dynamic subtest: vcs1
[633.700271] Dynamic subtest vcs1: SUCCESS (0.156s)
[633.779607] Starting dynamic subtest: vecs0
[633.863771] Dynamic subtest vecs0: SUCCESS (0.159s)
[633.944511] Starting dynamic subtest: ccs0
[634.022342] Dynamic subtest ccs0: SUCCESS (0.154s)
[634.025995] Subtest pi-ringfull: SUCCESS (0.962s)
[634.389457] [136/142] (388s left) kms_vblank (pipe-b-query-forked-busy-hang)
[634.891524] Starting subtest: pipe-B-query-forked-busy-hang
[650.880776] Subtest pipe-B-query-forked-busy-hang: SUCCESS (15.983s)
[651.836448] [137/142] (371s left) vc4/vc4_tiling (get-bad-modifier)
[652.309372] Subtest get-bad-modifier: SKIP (0.000s)
[652.449329] [138/142] (370s left) kms_ccs (pipe-a-bad-rotation-90-yf_tiled_ccs)
[653.300197] Starting subtest: pipe-A-bad-rotation-90-yf_tiled_ccs
[653.306825] Subtest pipe-A-bad-rotation-90-yf_tiled_ccs: SKIP (0.000s)
[654.707839] [139/142] (368s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[655.222773] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[666.907194] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (11.690s)
[667.223971] [140/142] (356s left) gem_readwrite (write-bad-handle)
[667.604549] Subtest write-bad-handle: SKIP (0.000s)
[667.753359] [141/142] (355s left) kms_ccs (pipe-c-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc)
[669.252935] Starting subtest: pipe-C-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc
[669.256592] Subtest pipe-C-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc: SUCCESS (0.003s)
[670.104201] [142/142] (353s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[670.494411] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[670.604750] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.109s)
[670.755708] Closing watchdogs
Done.