[47.905509] Initializing watchdogs
[47.905736]   /dev/watchdog0
[47.921548] [001/139] (960s left) gem_blits (basic)
[48.103334] Starting subtest: basic
[61.008343] Subtest basic: SUCCESS (12.903s)
[61.117873] [002/139] (947s left) gem_mmap (big-bo)
[61.260992] Starting subtest: big-bo
[63.760152] Subtest big-bo: SUCCESS (2.498s)
[63.881648] [003/139] (944s left) syncobj_timeline (host-signal-points)
[64.161811] Starting subtest: host-signal-points
[64.180943] Subtest host-signal-points: SUCCESS (0.019s)
[64.264279] [004/139] (944s left) kms_prop_blob (invalid-set-prop)
[64.406119] Starting subtest: invalid-set-prop
[64.407506] Subtest invalid-set-prop: SUCCESS (0.000s)
[64.482719] [005/139] (944s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-25)
[64.729154] Starting subtest: planes-unity-scaling-downscale-factor-0-25
[64.736295] Starting dynamic subtest: pipe-A-DP-1
[64.780060] Dynamic subtest pipe-A-DP-1: SKIP (0.042s)
[64.803079] Starting dynamic subtest: pipe-B-DP-1
[64.884935] Dynamic subtest pipe-B-DP-1: SKIP (0.095s)
[64.893068] Subtest planes-unity-scaling-downscale-factor-0-25: SKIP (0.165s)
[64.999269] [006/139] (943s left) vc4/vc4_wait_bo (unused-bo-0ns)
[65.200732] Subtest unused-bo-0ns: SKIP (0.000s)
[65.264148] [007/139] (943s left) kms_feature_discovery (display-2x)
[65.500945] Starting subtest: display-2x
[65.503651] Subtest display-2x: SKIP (0.000s)
[65.581836] [008/139] (943s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[65.818607] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[65.820053] Starting dynamic subtest: pipe-A-valid-mode
[66.529537] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.709s)
[66.530944] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SUCCESS (0.711s)
[66.874124] [009/139] (941s left) kms_getfb (getfb-handle-zero)
[67.016844] Starting subtest: getfb-handle-zero
[67.018326] Subtest getfb-handle-zero: SUCCESS (0.000s)
[67.121338] [010/139] (941s left) gem_madvise (dontneed-after-mmap)
[67.258982] Starting subtest: dontneed-after-mmap
[67.274505] Subtest dontneed-after-mmap: SUCCESS (0.015s)
[67.372472] [011/139] (941s left) kms_lease (lease-revoke)
[67.612033] Starting subtest: lease-revoke
[67.613670] Starting dynamic subtest: pipe-A-DP-1
[67.718492] Dynamic subtest pipe-A-DP-1: SUCCESS (0.104s)
[67.736561] Starting dynamic subtest: pipe-B-DP-1
[67.821123] Dynamic subtest pipe-B-DP-1: SUCCESS (0.102s)
[67.840314] Starting dynamic subtest: pipe-C-DP-1
[67.923218] Dynamic subtest pipe-C-DP-1: SUCCESS (0.099s)
[67.924415] Subtest lease-revoke: SUCCESS (0.312s)
[68.032301] [012/139] (940s left) kms_ccs (pipe-c-bad-rotation-90-4-tiled-mtl-mc-ccs)
[68.468766] Starting subtest: pipe-C-bad-rotation-90-4-tiled-mtl-mc-ccs
[68.471415] Subtest pipe-C-bad-rotation-90-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[68.829150] [013/139] (940s left) gem_spin_batch (resubmit-new-all)
[69.007861] Starting subtest: resubmit-new-all
[69.009690] Starting dynamic subtest: rcs0
[69.024182] Dynamic subtest rcs0: SUCCESS (0.017s)
[69.046084] Starting dynamic subtest: bcs0
[69.047575] Dynamic subtest bcs0: SUCCESS (0.015s)
[69.066504] Starting dynamic subtest: vcs0
[69.068025] Dynamic subtest vcs0: SUCCESS (0.018s)
[69.086734] Starting dynamic subtest: vecs0
[69.088084] Dynamic subtest vecs0: SUCCESS (0.013s)
[69.089709] Subtest resubmit-new-all: SUCCESS (0.065s)
[69.295505] [014/139] (939s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[69.608098] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[69.893258] [015/139] (939s left) gem_tiled_swapping (non-threaded)
[75.091825] Starting subtest: non-threaded
[97.195345] Subtest non-threaded: SUCCESS (22.089s)
[99.632546] [016/139] (909s left) perf_pmu (most-busy-idle-check-all)
[99.916398] Starting subtest: most-busy-idle-check-all
[99.918270] Starting dynamic subtest: rcs0
[100.547360] Dynamic subtest rcs0: SUCCESS (0.629s)
[100.571816] Starting dynamic subtest: bcs0
[101.173239] Dynamic subtest bcs0: SUCCESS (0.625s)
[101.195667] Starting dynamic subtest: vcs0
[101.801156] Dynamic subtest vcs0: SUCCESS (0.628s)
[101.826165] Starting dynamic subtest: vecs0
[102.427185] Dynamic subtest vecs0: SUCCESS (0.627s)
[102.429063] Subtest most-busy-idle-check-all: SUCCESS (2.511s)
[102.514711] [017/139] (906s left) kms_cursor_crc (cursor-sliding-256x256)
[102.784374] Starting subtest: cursor-sliding-256x256
[102.796236] Starting dynamic subtest: pipe-A-DP-1
[106.688639] Dynamic subtest pipe-A-DP-1: SUCCESS (3.891s)
[106.780848] Starting dynamic subtest: pipe-C-DP-1
[110.542655] Dynamic subtest pipe-C-DP-1: SUCCESS (3.781s)
[110.544049] Subtest cursor-sliding-256x256: SUCCESS (7.756s)
[110.906808] [018/139] (898s left) v3d/v3d_get_param (base-params)
[111.113876] Subtest base-params: SKIP (0.000s)
[111.183337] [019/139] (897s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[111.401331] Starting subtest: flip-vs-dpms-off-vs-modeset
[111.405632] Starting dynamic subtest: A-DP1
[112.692642] Dynamic subtest A-DP1: SUCCESS (1.289s)
[112.713580] Starting dynamic subtest: B-DP1
[113.833626] Dynamic subtest B-DP1: SUCCESS (1.139s)
[113.854720] Starting dynamic subtest: C-DP1
[114.956288] Dynamic subtest C-DP1: SUCCESS (1.122s)
[114.957734] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (3.557s)
[115.322944] [020/139] (893s left) gem_exec_flush (basic-wb-rw-default)
[115.490887] Starting subtest: basic-wb-rw-default
[120.973540] Subtest basic-wb-rw-default: SUCCESS (5.482s)
[121.187484] [021/139] (887s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[121.667740] Subtest pipe-D-crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[121.980602] [022/139] (887s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[122.218449] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[122.219768] Starting dynamic subtest: pipe-A-valid-mode
[122.305896] Dynamic subtest pipe-A-valid-mode: SKIP (0.085s)
[122.308474] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.087s)
[122.624515] [023/139] (886s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[122.872693] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[122.875424] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[122.975188] [024/139] (886s left) kms_busy (extended-modeset-hang-oldfb)
[123.224688] Starting subtest: extended-modeset-hang-oldfb
[123.226190] Starting dynamic subtest: pipe-A
[130.351594] Dynamic subtest pipe-A: SUCCESS (7.125s)
[130.376258] Starting dynamic subtest: pipe-C
[138.339493] Dynamic subtest pipe-C: SUCCESS (7.979s)
[138.340914] Subtest extended-modeset-hang-oldfb: SUCCESS (15.115s)
[138.692296] [025/139] (870s left) kms_vblank (wait-forked)
[138.930107] Starting subtest: wait-forked
[138.934471] Starting dynamic subtest: pipe-A-DP-1
[141.278505] Dynamic subtest pipe-A-DP-1: SUCCESS (2.346s)
[141.306758] Starting dynamic subtest: pipe-C-DP-1
[143.810257] Dynamic subtest pipe-C-DP-1: SUCCESS (2.525s)
[143.811697] Subtest wait-forked: SUCCESS (4.881s)
[144.162633] [026/139] (865s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[145.894039] Starting subtest: gem-execbuf-stress-pc8
[145.944517] Subtest gem-execbuf-stress-pc8: SKIP (0.047s)
[146.322799] [027/139] (863s left) gem_ctx_isolation (nonpriv-switch)
[146.491239] Starting subtest: nonpriv-switch
[146.492693] Starting dynamic subtest: rcs0
[148.931214] Dynamic subtest rcs0: SUCCESS (2.439s)
[148.952627] Starting dynamic subtest: bcs0
[152.103189] Dynamic subtest bcs0: SUCCESS (3.168s)
[152.126772] Starting dynamic subtest: vcs0
[154.472547] Dynamic subtest vcs0: SUCCESS (2.370s)
[154.497566] Starting dynamic subtest: vecs0
[156.867661] Dynamic subtest vecs0: SUCCESS (2.395s)
[156.869092] Subtest nonpriv-switch: SUCCESS (10.376s)
[157.075813] [028/139] (852s left) kms_addfb_basic (bad-pitch-128)
[157.216092] Starting subtest: bad-pitch-128
[157.218271] Subtest bad-pitch-128: SUCCESS (0.000s)
[157.403204] [029/139] (852s left) kms_ccs (pipe-a-random-ccs-data-yf-tiled-ccs)
[157.742829] Starting subtest: pipe-A-random-ccs-data-yf-tiled-ccs
[158.189826] Subtest pipe-A-random-ccs-data-yf-tiled-ccs: SUCCESS (0.445s)
[158.759401] [030/139] (850s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[159.005904] Starting subtest: fbcpsr-rgb101010-draw-render
[159.008561] Subtest fbcpsr-rgb101010-draw-render: SKIP (0.000s)
[159.108691] [031/139] (850s left) gem_mmap_gtt (cpuset-big-copy-odd)
[159.249549] Starting subtest: cpuset-big-copy-odd
[182.364195] Subtest cpuset-big-copy-odd: SUCCESS (23.114s)
[182.814574] [032/139] (826s left) kms_flip (flip-vs-rmfb)
[183.147136] Starting subtest: flip-vs-rmfb
[183.151113] Starting dynamic subtest: A-DP1
[193.880273] Dynamic subtest A-DP1: SUCCESS (10.730s)
[193.902878] Starting dynamic subtest: B-DP1
[204.306242] Dynamic subtest B-DP1: SUCCESS (10.423s)
[204.328373] Starting dynamic subtest: C-DP1
[214.742945] Dynamic subtest C-DP1: SUCCESS (10.436s)
[214.747380] Subtest flip-vs-rmfb: SUCCESS (31.600s)
[215.174596] [033/139] (794s left) kms_cursor_crc (cursor-offscreen-128x128)
[215.439645] Starting subtest: cursor-offscreen-128x128
[215.450718] Starting dynamic subtest: pipe-A-DP-1
[217.925722] Dynamic subtest pipe-A-DP-1: SUCCESS (2.473s)
[218.025609] Starting dynamic subtest: pipe-C-DP-1
[220.602918] Dynamic subtest pipe-C-DP-1: SUCCESS (2.600s)
[220.604236] Subtest cursor-offscreen-128x128: SUCCESS (5.162s)
[220.982679] [034/139] (788s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[221.230889] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[221.233606] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[221.345106] [035/139] (788s left) kms_chamelium_frames (hdmi-crc-single)
[221.668089] Subtest hdmi-crc-single: SKIP (0.000s)
[221.965966] [036/139] (787s left) syncobj_timeline (invalid-single-wait-all-available-unsubmitted)
[222.125914] Starting subtest: invalid-single-wait-all-available-unsubmitted
[222.172059] Subtest invalid-single-wait-all-available-unsubmitted: FAIL (0.034s)
[222.242994] [037/139] (787s left) gem_exec_schedule (reorder-wide)
[222.561044] Starting subtest: reorder-wide
[222.562818] Starting dynamic subtest: rcs0
[222.797681] Dynamic subtest rcs0: SUCCESS (0.236s)
[222.823246] Starting dynamic subtest: bcs0
[223.135633] Dynamic subtest bcs0: SUCCESS (0.332s)
[223.164202] Starting dynamic subtest: vcs0
[223.297784] Dynamic subtest vcs0: SUCCESS (0.163s)
[223.332258] Starting dynamic subtest: vecs0
[223.464316] Dynamic subtest vecs0: SUCCESS (0.162s)
[223.465603] Subtest reorder-wide: SUCCESS (0.903s)
[223.694220] [038/139] (786s left) syncobj_wait (wait-any-snapshot)
[223.839210] Starting subtest: wait-any-snapshot
[223.922370] Subtest wait-any-snapshot: SUCCESS (0.082s)
[224.009635] [039/139] (785s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[224.255695] Starting subtest: fbc-modesetfrombusy
[225.458259] Subtest fbc-modesetfrombusy: SUCCESS (1.202s)
[225.583113] [040/139] (784s left) kms_psr (psr2_cursor_mmap_gtt)
[225.728307] Subtest psr2_cursor_mmap_gtt: SKIP (0.000s)
[225.785711] [041/139] (784s left) gem_exec_params (secure-non-master)
[225.934471] Starting subtest: secure-non-master
[225.937689] Subtest secure-non-master: SKIP (0.000s)
[226.051609] [042/139] (784s left) vc4/vc4_purgeable_bo (mark-purgeable-twice)
[226.258153] Subtest mark-purgeable-twice: SKIP (0.000s)
[226.334667] [043/139] (783s left) kms_sequence (queue-idle)
[226.575438] Starting subtest: queue-idle
[226.577077] Starting dynamic subtest: pipe-A-DP-1
[228.904727] Dynamic subtest pipe-A-DP-1: SUCCESS (2.327s)
[228.928436] Starting dynamic subtest: pipe-B-DP-1
[231.389429] Dynamic subtest pipe-B-DP-1: SUCCESS (2.482s)
[231.416456] Starting dynamic subtest: pipe-C-DP-1
[233.910043] Dynamic subtest pipe-C-DP-1: SUCCESS (2.516s)
[233.911416] Subtest queue-idle: SUCCESS (7.338s)
[234.234522] [044/139] (775s left) dmabuf_sync_file (export-before-signal)
[234.389637] Starting subtest: export-before-signal
[234.393597] Subtest export-before-signal: SUCCESS (0.002s)
[234.465995] [045/139] (775s left) gem_render_copy (yf-tiled)
[234.656385] Starting subtest: yf-tiled
[234.657965] Starting dynamic subtest: smem
[235.041363] Dynamic subtest smem: SUCCESS (0.383s)
[235.042877] Subtest yf-tiled: SUCCESS (0.385s)
[235.251291] [046/139] (775s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-pwrite)
[235.495678] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-pwrite
[235.498720] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-pwrite: SKIP (0.000s)
[235.599477] [047/139] (774s left) kms_ccs (pipe-c-crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[236.032040] Starting subtest: pipe-C-crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[236.034815] Subtest pipe-C-crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.001s)
[236.380771] [048/139] (773s left) sw_sync (alloc_merge_fence)
[236.522192] Starting subtest: alloc_merge_fence
[236.523569] Subtest alloc_merge_fence: SUCCESS (0.001s)
[236.599096] [049/139] (773s left) kms_flip (2x-flip-vs-panning-vs-hang)
[236.823437] Starting subtest: 2x-flip-vs-panning-vs-hang
[236.826250] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.003s)
[236.949543] [050/139] (773s left) syncobj_eventfd (invalid-bad-pad)
[237.095357] Starting subtest: invalid-bad-pad
[237.096952] Subtest invalid-bad-pad: SUCCESS (0.000s)
[237.182278] [051/139] (773s left) kms_ccs (pipe-b-bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[237.565351] Starting subtest: pipe-B-bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[237.567991] Subtest pipe-B-bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[237.976120] [052/139] (772s left) gem_softpin (32b-excludes-last-page)
[238.127468] Starting subtest: 32b-excludes-last-page
[238.133172] Subtest 32b-excludes-last-page: SUCCESS (0.005s)
[238.259122] [053/139] (772s left) i915_suspend (debugfs-reader)
[238.399798] Starting subtest: debugfs-reader
[257.838397] Subtest debugfs-reader: SUCCESS (3.439s)
[260.945361] [054/139] (768s left) gem_workarounds (suspend-resume-context)
[261.120381] Starting subtest: suspend-resume-context
[278.840019] Subtest suspend-resume-context: SUCCESS (1.225s)
[283.052763] [055/139] (767s left) i915_pm_freq_api (freq-reset-multiple)
[283.201253] Subtest freq-reset-multiple: SKIP (0.000s)
[283.262811] [056/139] (767s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[283.507996] Starting subtest: psr-2p-primscrn-cur-indfb-move
[283.510807] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[283.613461] [057/139] (766s left) debugfs_test (read_all_entries)
[283.764899] Starting subtest: read_all_entries
[283.991408] Subtest read_all_entries: SUCCESS (0.224s)
[284.176888] [058/139] (766s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-gtt)
[284.423766] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-gtt
[286.284012] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-gtt: SUCCESS (1.861s)
[286.428876] [059/139] (763s left) kms_universal_plane (universal-plane-functional)
[286.669845] Starting subtest: universal-plane-functional
[286.671225] Starting dynamic subtest: pipe-A-DP-1
[289.082886] Dynamic subtest pipe-A-DP-1: SUCCESS (2.411s)
[289.112080] Starting dynamic subtest: pipe-B-DP-1
[291.889128] Dynamic subtest pipe-B-DP-1: SUCCESS (2.799s)
[291.933249] Starting dynamic subtest: pipe-C-DP-1
[294.543968] Dynamic subtest pipe-C-DP-1: SUCCESS (2.650s)
[294.545375] Subtest universal-plane-functional: SUCCESS (7.876s)
[294.875476] [060/139] (755s left) perf (polling)
[295.158452] Starting subtest: polling
[295.159847] Starting dynamic subtest: 0-rcs0
[305.240463] Dynamic subtest 0-rcs0: SUCCESS (10.078s)
[305.241913] Subtest polling: SUCCESS (10.081s)
[305.310174] [061/139] (745s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[305.568395] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[306.943327] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.374s)
[307.092953] [062/139] (743s left) kms_flip (2x-flip-vs-wf_vblank)
[307.315597] Starting subtest: 2x-flip-vs-wf_vblank
[307.318215] Subtest 2x-flip-vs-wf_vblank: SKIP (0.003s)
[307.449551] [063/139] (743s left) kms_ccs (pipe-a-crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[307.783383] Starting subtest: pipe-A-crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[307.786192] Subtest pipe-A-crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.001s)
[308.248483] [064/139] (742s left) gem_exec_balancer (parallel-keep-in-fence)
[312.041815] Subtest parallel-keep-in-fence: SKIP (0.000s)
[312.149896] [065/139] (738s left) gem_mmap_wc (read-write-distinct)
[312.294586] Starting subtest: read-write-distinct
[312.324058] Subtest read-write-distinct: SUCCESS (0.032s)
[312.448149] [066/139] (738s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[312.590742] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[312.592187] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[312.681270] [067/139] (738s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[312.928391] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[312.931267] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[313.047909] [068/139] (737s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[313.294426] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[313.297171] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[313.397907] [069/139] (737s left) kms_panel_fitting (legacy)
[313.634719] Starting subtest: legacy
[313.637390] Subtest legacy: SKIP (0.000s)
[313.732167] [070/139] (737s left) gem_exec_fair (basic-pace)
[313.905315] Starting subtest: basic-pace
[313.907113] Starting dynamic subtest: rcs0
[318.793349] Dynamic subtest rcs0: SUCCESS (4.885s)
[318.822443] Starting dynamic subtest: bcs0
[318.825101] Dynamic subtest bcs0: SKIP (0.007s)
[318.852438] Starting dynamic subtest: vcs0
[323.676393] Dynamic subtest vcs0: SUCCESS (4.871s)
[323.706005] Starting dynamic subtest: vecs0
[328.514955] Dynamic subtest vecs0: SUCCESS (4.836s)
[328.516555] Subtest basic-pace: SUCCESS (14.612s)
[328.732906] [071/139] (722s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[328.984182] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[331.117953] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (2.136s)
[331.265388] [072/139] (719s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[331.693974] Starting subtest: pipe-B-crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[331.699953] Subtest pipe-B-crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[332.085809] [073/139] (719s left) syncobj_timeline (wait-all-complex)
[332.229889] Starting subtest: wait-all-complex
[332.448634] Subtest wait-all-complex: SUCCESS (0.217s)
[332.554753] [074/139] (718s left) gem_mmap_offset (blt-coherency)
[332.697387] Starting subtest: blt-coherency
[332.717743] Subtest blt-coherency: SUCCESS (0.020s)
[332.837302] [075/139] (718s left) gen9_exec_parse (bb-chained)
[333.001228] Starting subtest: bb-chained
[333.012823] Subtest bb-chained: SUCCESS (0.010s)
[333.251863] [076/139] (718s left) gem_ctx_param (invalid-get-ringsize)
[333.393228] Starting subtest: invalid-get-ringsize
[333.394932] Subtest invalid-get-ringsize: SUCCESS (0.000s)
[333.485797] [077/139] (717s left) kms_ccs (pipe-a-crc-primary-basic-y-tiled-gen12-mc-ccs)
[333.823882] Starting subtest: pipe-A-crc-primary-basic-y-tiled-gen12-mc-ccs
[333.826947] Subtest pipe-A-crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.001s)
[334.298519] [078/139] (717s left) gem_ctx_shared (exec-single-timeline)
[334.467337] Starting subtest: exec-single-timeline
[334.468715] Starting dynamic subtest: rcs0
[335.548334] Dynamic subtest rcs0: SUCCESS (1.078s)
[335.585702] Starting dynamic subtest: bcs0
[336.637499] Dynamic subtest bcs0: SUCCESS (1.083s)
[336.671506] Starting dynamic subtest: vcs0
[337.723513] Dynamic subtest vcs0: SUCCESS (1.085s)
[337.759300] Starting dynamic subtest: vecs0
[338.812105] Dynamic subtest vecs0: SUCCESS (1.085s)
[338.813607] Subtest exec-single-timeline: SUCCESS (4.344s)
[339.048877] [079/139] (712s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[339.301101] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[339.303672] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[339.414109] [080/139] (712s left) syncobj_timeline (wait-for-submit-complex)
[339.558064] Starting subtest: wait-for-submit-complex
[339.623616] Subtest wait-for-submit-complex: SUCCESS (0.063s)
[339.714619] [081/139] (711s left) v3d/v3d_submit_cl (bad-extension)
[339.920261] Subtest bad-extension: SKIP (0.000s)
[339.997332] [082/139] (711s left) sw_sync (alloc_fence_invalid_timeline)
[340.136835] Starting subtest: alloc_fence_invalid_timeline
[340.138281] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[340.215114] [083/139] (711s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[340.436648] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[340.439171] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.003s)
[340.564405] [084/139] (711s left) kms_cursor_crc (cursor-onscreen-512x170)
[340.819826] Starting subtest: cursor-onscreen-512x170
[340.825196] Subtest cursor-onscreen-512x170: SKIP (0.003s)
[340.930543] [085/139] (710s left) kms_setmode (basic)
[341.071879] Starting subtest: basic
[341.265889] Starting dynamic subtest: pipe-A-DP-1
[343.564029] Dynamic subtest pipe-A-DP-1: SUCCESS (2.295s)
[343.722313] Starting dynamic subtest: pipe-B-DP-1
[346.002699] Dynamic subtest pipe-B-DP-1: SUCCESS (2.309s)
[346.096700] Subtest basic: SUCCESS (5.023s)
[346.445528] [086/139] (705s left) gem_workarounds (basic-read-context)
[346.618494] Starting subtest: basic-read-context
[346.640920] Subtest basic-read-context: SUCCESS (0.022s)
[346.742620] [087/139] (705s left) api_intel_allocator (fork-simple-stress-signal)
[346.882894] Starting subtest: fork-simple-stress-signal
[352.427211] Subtest fork-simple-stress-signal: SUCCESS (5.542s)
[352.528604] [088/139] (699s left) kms_ccs (pipe-b-crc-primary-basic-y-tiled-gen12-rc-ccs)
[352.912451] Starting subtest: pipe-B-crc-primary-basic-y-tiled-gen12-rc-ccs
[352.915467] Subtest pipe-B-crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.001s)
[353.332149] [089/139] (698s left) vgem_basic (create)
[353.486334] Starting subtest: create
[353.487970] Subtest create: SUCCESS (0.001s)
[353.564431] [090/139] (698s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[353.808428] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[353.812318] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[353.914236] [091/139] (698s left) gem_exec_whisper (basic-sync)
[354.080422] Starting subtest: basic-sync
[361.775607] Subtest basic-sync: SUCCESS (7.694s)
[361.982684] [092/139] (690s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[362.248782] Starting subtest: 4-tiled-64bpp-rotate-180
[362.251801] Subtest 4-tiled-64bpp-rotate-180: SKIP (0.000s)
[362.349333] [093/139] (689s left) gem_userptr_blits (unsync-unmap-after-close)
[362.504944] Subtest unsync-unmap-after-close: SKIP (0.000s)
[362.683876] [094/139] (689s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[362.935538] Starting subtest: yf-tiled-64bpp-rotate-90
[362.938267] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[363.049120] [095/139] (689s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[364.756001] Starting subtest: dpms-mode-unset-non-lpsp
[366.069135] Subtest dpms-mode-unset-non-lpsp: SUCCESS (1.313s)
[366.571229] [096/139] (685s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[366.738487] Starting subtest: basic-batch-kernel-default-cmd
[372.664263] Subtest basic-batch-kernel-default-cmd: SUCCESS (5.921s)
[372.870885] [097/139] (679s left) drm_fdinfo (virtual-busy)
[373.017441] Starting subtest: virtual-busy
[375.195942] Subtest virtual-busy: SUCCESS (2.179s)
[375.288210] [098/139] (677s left) syncobj_basic (bad-pad-fd-to-handle)
[375.429876] Starting subtest: bad-pad-fd-to-handle
[375.431499] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[375.534951] [099/139] (676s left) syncobj_basic (bad-destroy)
[375.677456] Starting subtest: bad-destroy
[375.679128] Subtest bad-destroy: SUCCESS (0.000s)
[375.768502] [100/139] (676s left) v3d/v3d_submit_csd (bad-multisync-in-sync)
[375.973981] Subtest bad-multisync-in-sync: SKIP (0.000s)
[376.051520] [101/139] (676s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[376.291848] Starting subtest: plane-all-modeset-transition-internal-panels
[376.294990] Subtest plane-all-modeset-transition-internal-panels: SKIP (0.000s)
[376.385279] [102/139] (676s left) kms_hdr (invalid-hdr)
[376.621905] Starting subtest: invalid-hdr
[378.968863] Starting dynamic subtest: pipe-A-DP-1
[384.959620] Dynamic subtest pipe-A-DP-1: SUCCESS (5.992s)
[384.960959] Subtest invalid-hdr: SUCCESS (8.341s)
[385.352096] [103/139] (667s left) core_auth (getclient-master-drop)
[385.489818] Starting subtest: getclient-master-drop
[385.496868] Subtest getclient-master-drop: SUCCESS (0.005s)
[385.596929] [104/139] (667s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[385.848396] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[389.111890] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SUCCESS (3.265s)
[389.276292] [105/139] (663s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[389.520528] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[389.523120] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[389.625800] [106/139] (663s left) kms_atomic (atomic-plane-damage)
[389.861187] Starting subtest: atomic-plane-damage
[390.762119] Subtest atomic-plane-damage: SKIP (0.901s)
[391.184831] [107/139] (661s left) kms_plane (plane-panning-bottom-right)
[391.420734] Starting subtest: plane-panning-bottom-right
[391.422113] Starting dynamic subtest: pipe-A
[392.240754] Dynamic subtest pipe-A: SUCCESS (0.816s)
[392.274789] Starting dynamic subtest: pipe-B
[393.241185] Dynamic subtest pipe-B: SUCCESS (0.998s)
[393.242858] Subtest plane-panning-bottom-right: SUCCESS (1.825s)
[393.601734] [108/139] (659s left) kms_ccs (pipe-d-random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[394.078521] Subtest pipe-D-random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[394.411755] [109/139] (658s left) kms_ccs (pipe-c-bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[394.842274] Starting subtest: pipe-C-bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[394.844943] Subtest pipe-C-bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[395.226923] [110/139] (657s left) gem_exec_whisper (basic-fds-forked-all)
[395.392953] Starting subtest: basic-fds-forked-all
[419.479252] Subtest basic-fds-forked-all: SUCCESS (24.084s)
[419.696193] [111/139] (633s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[419.960933] Starting subtest: y-tiled-16bpp-rotate-0
[423.513587] Subtest y-tiled-16bpp-rotate-0: SUCCESS (3.553s)
[423.828697] [112/139] (629s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[424.079525] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[424.082748] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.001s)
[424.195877] [113/139] (628s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[424.452621] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[424.455343] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[424.560575] [114/139] (628s left) syncobj_wait (wait-all-interrupted)
[424.707229] Starting subtest: wait-all-interrupted
[424.809489] Subtest wait-all-interrupted: SUCCESS (0.103s)
[424.910393] [115/139] (628s left) gem_exec_fence (syncobj-timeline-export)
[425.665965] Starting subtest: syncobj-timeline-export
[425.671789] Subtest syncobj-timeline-export: SUCCESS (0.007s)
[425.913150] [116/139] (627s left) gem_exec_fence (syncobj-timeline-unused-fence)
[426.658238] Starting subtest: syncobj-timeline-unused-fence
[426.662751] Subtest syncobj-timeline-unused-fence: SUCCESS (0.006s)
[426.912739] [117/139] (626s left) kms_ccs (pipe-d-crc-primary-basic-4-tiled-mtl-rc-ccs)
[427.385961] Subtest pipe-D-crc-primary-basic-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[427.707836] [118/139] (625s left) perf_pmu (busy-double-start)
[427.860306] Starting subtest: busy-double-start
[427.861930] Starting dynamic subtest: rcs0
[431.406887] Dynamic subtest rcs0: SUCCESS (3.548s)
[431.439763] Starting dynamic subtest: bcs0
[434.958857] Dynamic subtest bcs0: SUCCESS (3.550s)
[434.989765] Starting dynamic subtest: vcs0
[438.503865] Dynamic subtest vcs0: SUCCESS (3.543s)
[438.535101] Starting dynamic subtest: vecs0
[442.049895] Dynamic subtest vecs0: SUCCESS (3.544s)
[442.051708] Subtest busy-double-start: SUCCESS (14.193s)
[442.156928] [119/139] (611s left) kms_hdmi_inject (inject-audio)
[442.299387] Subtest inject-audio: SKIP (0.000s)
[442.356978] [120/139] (611s left) kms_cursor_legacy (single-move)
[442.592459] Starting subtest: single-move
[442.593846] Starting dynamic subtest: pipe-A
[448.001925] Dynamic subtest pipe-A: SUCCESS (5.407s)
[448.030959] Starting dynamic subtest: pipe-B
[453.410581] Dynamic subtest pipe-B: SUCCESS (5.406s)
[453.439419] Starting dynamic subtest: pipe-C
[458.822227] Dynamic subtest pipe-C: SUCCESS (5.406s)
[458.850777] Starting dynamic subtest: all-pipes
[464.230777] Dynamic subtest all-pipes: SUCCESS (5.408s)
[464.232329] Subtest single-move: SUCCESS (21.638s)
[464.325277] [121/139] (589s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[464.568731] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[464.571263] Subtest psr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[464.673987] [122/139] (588s left) kms_ccs (pipe-d-bad-pixel-format-4-tiled-dg2-mc-ccs)
[465.153390] Subtest pipe-D-bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[465.484817] [123/139] (588s left) kms_pm_dc (dc6-psr)
[466.731722] Starting subtest: dc6-psr
[466.736203] Subtest dc6-psr: SKIP (0.000s)
[466.899826] [124/139] (586s left) gem_mmap_wc (pf-nonblock)
[467.044139] Starting subtest: pf-nonblock
[467.047195] Subtest pf-nonblock: SUCCESS (0.006s)
[467.166199] [125/139] (586s left) gen7_exec_parse (basic-rejected)
[467.315970] Subtest basic-rejected: SKIP (0.000s)
[467.383820] [126/139] (586s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[467.640640] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[467.645646] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.003s)
[467.750934] [127/139] (586s left) gem_exec_schedule (noreorder-corked)
[468.065551] Starting subtest: noreorder-corked
[468.067099] Starting dynamic subtest: rcs0
[469.193354] Dynamic subtest rcs0: SUCCESS (1.127s)
[469.224766] Starting dynamic subtest: bcs0
[470.321258] Dynamic subtest bcs0: SUCCESS (1.124s)
[470.353103] Starting dynamic subtest: vcs0
[471.451028] Dynamic subtest vcs0: SUCCESS (1.125s)
[471.483988] Starting dynamic subtest: vecs0
[472.589193] Dynamic subtest vecs0: SUCCESS (1.134s)
[472.590889] Subtest noreorder-corked: SUCCESS (4.526s)
[472.800742] [128/139] (581s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[473.053697] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[473.057067] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[473.166213] [129/139] (580s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[473.400125] Starting subtest: cursorB-vs-flipB-legacy
[473.403286] Subtest cursorB-vs-flipB-legacy: SKIP (0.002s)
[473.498837] [130/139] (580s left) gem_ctx_sseu (mmap-args)
[473.648466] Subtest mmap-args: SKIP (0.000s)
[473.715565] [131/139] (580s left) kms_ccs (pipe-c-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[474.179778] Starting subtest: pipe-C-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[474.186123] Subtest pipe-C-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[474.530842] [132/139] (579s left) kms_color (ctm-green-to-red)
[474.775735] Starting subtest: ctm-green-to-red
[474.777090] Starting dynamic subtest: pipe-A
[475.314063] Dynamic subtest pipe-A: SUCCESS (0.534s)
[475.350624] Starting dynamic subtest: pipe-B
[476.041837] Dynamic subtest pipe-B: SUCCESS (0.726s)
[476.076893] Starting dynamic subtest: pipe-C
[476.740162] Dynamic subtest pipe-C: SUCCESS (0.696s)
[476.742178] Subtest ctm-green-to-red: SUCCESS (1.964s)
[477.079018] [133/139] (577s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[477.322768] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[479.580006] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (2.258s)
[479.731097] [134/139] (574s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[479.973908] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[479.976460] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[480.078930] [135/139] (574s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[480.226765] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[480.228511] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.002s)
[480.332567] [136/139] (573s left) api_intel_allocator (fork-simple-stress)
[480.471946] Starting subtest: fork-simple-stress
[485.988322] Subtest fork-simple-stress: SUCCESS (5.514s)
[486.080684] [137/139] (568s left) kms_plane_alpha_blend (alpha-basic)
[486.320706] Starting subtest: alpha-basic
[486.638805] Starting dynamic subtest: pipe-A-DP-1
[487.162909] Dynamic subtest pipe-A-DP-1: FAIL (0.180s)
[487.191731] Starting dynamic subtest: pipe-C-DP-1
[487.988831] Dynamic subtest pipe-C-DP-1: FAIL (0.719s)
[487.990251] Subtest alpha-basic: FAIL (1.310s)
[488.073566] [138/139] (566s left) gem_userptr_blits (map-fixed-invalidate)
[488.256490] Starting subtest: map-fixed-invalidate
[488.258064] Starting dynamic subtest: gtt
[488.506741] Dynamic subtest gtt: SUCCESS (0.247s)
[488.538164] Starting dynamic subtest: wb
[488.684707] Dynamic subtest wb: SUCCESS (0.175s)
[488.713895] Starting dynamic subtest: wc
[488.856415] Dynamic subtest wc: SUCCESS (0.169s)
[488.885592] Starting dynamic subtest: uc
[489.039473] Dynamic subtest uc: SUCCESS (0.178s)
[489.040915] Subtest map-fixed-invalidate: SUCCESS (0.782s)
[489.191582] [139/139] (565s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[489.451545] Starting subtest: x-tiled-32bpp-rotate-0
[494.257423] Subtest x-tiled-32bpp-rotate-0: SUCCESS (4.805s)
[494.787527] Closing watchdogs
Done.