[47.924214] Initializing watchdogs
[47.924490]   /dev/watchdog0
[47.941351] [001/142] (960s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc)
[48.472752] Subtest pipe-D-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[48.792457] [002/142] (959s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[49.046195] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[49.048708] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[49.138708] [003/142] (959s left) kms_vblank (pipe-b-wait-idle-hang)
[49.372039] Starting subtest: pipe-B-wait-idle-hang
[57.008636] Subtest pipe-B-wait-idle-hang: SUCCESS (7.637s)
[57.351954] [004/142] (951s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[57.552850] Starting subtest: map-fixed-invalidate-overlap
[57.554379] Starting dynamic subtest: gtt
[57.820340] Dynamic subtest gtt: SUCCESS (0.266s)
[57.834481] Starting dynamic subtest: wb
[57.998134] Dynamic subtest wb: SUCCESS (0.177s)
[58.012806] Starting dynamic subtest: wc
[58.197253] Dynamic subtest wc: SUCCESS (0.198s)
[58.213599] Starting dynamic subtest: uc
[58.415106] Dynamic subtest uc: SUCCESS (0.217s)
[58.418423] Subtest map-fixed-invalidate-overlap: SUCCESS (0.859s)
[58.567267] [005/142] (950s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[58.748425] Starting subtest: invalid-multi-wait-unsubmitted
[58.750704] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.002s)
[58.834207] [006/142] (949s left) kms_color (ctm-0-75)
[59.129750] Starting subtest: ctm-0-75
[59.134069] Starting dynamic subtest: pipe-A
[61.631264] Dynamic subtest pipe-A: SUCCESS (2.503s)
[61.646836] Starting dynamic subtest: pipe-B
[64.523692] Dynamic subtest pipe-B: SUCCESS (2.893s)
[64.537894] Starting dynamic subtest: pipe-C
[67.189888] Dynamic subtest pipe-C: SUCCESS (2.666s)
[67.191385] Subtest ctm-0-75: SUCCESS (8.062s)
[67.544181] [007/142] (941s left) v3d/v3d_wait_bo (map-bo-1ns)
[67.745173] Subtest map-bo-1ns: SKIP (0.000s)
[67.808764] [008/142] (940s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-gtt)
[68.052730] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-gtt
[68.055322] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[68.140673] [009/142] (940s left) vc4/vc4_perfmon (get-values-invalid-perfmon)
[68.327636] Subtest get-values-invalid-perfmon: SKIP (0.000s)
[68.390111] [010/142] (940s left) sysfs_heartbeat_interval (idempotent)
[68.538450] Starting subtest: idempotent
[68.540372] Starting dynamic subtest: vecs0
[68.545405] Dynamic subtest vecs0: SUCCESS (0.006s)
[68.563676] Starting dynamic subtest: vcs0
[68.565027] Dynamic subtest vcs0: SUCCESS (0.004s)
[68.578963] Starting dynamic subtest: bcs0
[68.580252] Dynamic subtest bcs0: SUCCESS (0.004s)
[68.594407] Starting dynamic subtest: rcs0
[68.595709] Dynamic subtest rcs0: SUCCESS (0.004s)
[68.596929] Subtest idempotent: SUCCESS (0.021s)
[68.640559] [011/142] (940s left) syncobj_basic (bad-flags-fd-to-handle)
[68.779377] Starting subtest: bad-flags-fd-to-handle
[68.780997] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[68.856594] [012/142] (939s left) v3d/v3d_perfmon (create-single-perfmon)
[69.044080] Subtest create-single-perfmon: SKIP (0.000s)
[69.106655] [013/142] (939s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-render)
[69.356077] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-render
[71.295168] Subtest fbc-1p-offscren-pri-shrfb-draw-render: SUCCESS (1.944s)
[71.424798] [014/142] (937s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[71.589246] Starting subtest: yf-tiled-ccs-to-x-tiled
[71.590700] Starting dynamic subtest: smem
[71.900619] Dynamic subtest smem: SUCCESS (0.312s)
[71.901987] Subtest yf-tiled-ccs-to-x-tiled: SUCCESS (0.312s)
[72.094588] [015/142] (936s left) v3d/v3d_submit_csd (bad-flag)
[72.293689] Subtest bad-flag: SKIP (0.000s)
[72.357038] [016/142] (936s left) dumb_buffer (invalid-bpp)
[72.495264] Starting subtest: invalid-bpp
[72.496967] Subtest invalid-bpp: SUCCESS (0.000s)
[72.575458] [017/142] (936s left) gem_pxp (verify-pxp-stale-ctx-execution)
[75.245334] Subtest verify-pxp-stale-ctx-execution: SKIP (0.000s)
[75.328241] [018/142] (933s left) perf_pmu (semaphore-wait)
[75.474813] Starting subtest: semaphore-wait
[75.476460] Starting dynamic subtest: rcs0
[75.995170] Dynamic subtest rcs0: SUCCESS (0.520s)
[76.011697] Starting dynamic subtest: bcs0
[76.512953] Dynamic subtest bcs0: SUCCESS (0.517s)
[76.528377] Starting dynamic subtest: vcs0
[77.027921] Dynamic subtest vcs0: SUCCESS (0.513s)
[77.043717] Starting dynamic subtest: vecs0
[77.544733] Dynamic subtest vecs0: SUCCESS (0.514s)
[77.546188] Subtest semaphore-wait: SUCCESS (2.068s)
[77.641751] [019/142] (931s left) gem_exec_fence (syncobj-wait)
[78.320968] Starting subtest: syncobj-wait
[78.363325] Subtest syncobj-wait: SUCCESS (0.042s)
[78.727596] [020/142] (930s left) gem_flink_basic (flink-lifetime)
[78.866463] Starting subtest: flink-lifetime
[78.869645] Subtest flink-lifetime: SUCCESS (0.003s)
[78.958690] [021/142] (930s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[79.208633] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[79.211283] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[79.293991] [022/142] (929s left) kms_content_protection (type1)
[79.569626] Starting subtest: type1
[80.268518] Subtest type1: SKIP (0.695s)
[80.686579] [023/142] (928s left) kms_cursor_legacy (forked-bo)
[80.920029] Starting subtest: forked-bo
[80.921435] Starting dynamic subtest: pipe-A
[86.388438] Dynamic subtest pipe-A: SUCCESS (5.466s)
[86.405208] Starting dynamic subtest: pipe-B
[91.872569] Dynamic subtest pipe-B: SUCCESS (5.484s)
[91.888802] Starting dynamic subtest: pipe-C
[97.371084] Dynamic subtest pipe-C: SUCCESS (5.498s)
[97.391280] Starting dynamic subtest: all-pipes
[102.839974] Dynamic subtest all-pipes: SUCCESS (5.469s)
[102.843915] Subtest forked-bo: SUCCESS (21.920s)
[102.919647] [024/142] (906s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[103.169430] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[103.171836] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[103.268824] [025/142] (905s left) gem_mmap_wc (set-cache-level)
[103.407101] Starting subtest: set-cache-level
[103.410876] Subtest set-cache-level: SUCCESS (0.005s)
[103.487901] [026/142] (905s left) gem_exec_params (no-vebox)
[103.634435] Starting subtest: no-vebox
[103.636315] Subtest no-vebox: SUCCESS (0.002s)
[103.752895] [027/142] (905s left) gem_create (hog-create)
[103.909266] Starting subtest: hog-create
[103.910645] Starting dynamic subtest: smem0
[136.164794] Dynamic subtest smem0: SUCCESS (32.256s)
[136.166241] Subtest hog-create: SUCCESS (32.257s)
[136.353701] [028/142] (873s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc)
[136.819275] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc
[136.823587] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc: SKIP (0.004s)
[137.147384] [029/142] (872s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[137.384515] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[137.385864] Starting dynamic subtest: pipe-A-valid-mode
[137.819629] Dynamic subtest pipe-A-valid-mode: SKIP (0.434s)
[137.823216] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SKIP (0.437s)
[138.172069] [030/142] (871s left) i915_pm_rc6_residency (rc6-fence)
[138.314259] Starting subtest: rc6-fence
[153.571669] Subtest rc6-fence: SUCCESS (15.259s)
[153.822379] [031/142] (855s left) i915_pm_rps (min-max-config-idle)
[153.971456] Starting subtest: min-max-config-idle
[154.373576] Subtest min-max-config-idle: SUCCESS (0.402s)
[154.458387] [032/142] (855s left) dmabuf_sync_file (import-basic)
[154.603944] Starting subtest: import-basic
[154.609151] Subtest import-basic: SUCCESS (0.006s)
[154.672377] [033/142] (854s left) gem_exec_await (wide-contexts)
[155.013492] Starting subtest: wide-contexts
[177.855389] Subtest wide-contexts: SUCCESS (22.842s)
[178.084783] [034/142] (831s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[178.465616] Starting subtest: yf-tiled-16bpp-rotate-90
[178.546660] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.079s)
[178.657500] [035/142] (830s left) kms_chamelium_audio (hdmi-audio-edid)
[178.985074] Subtest hdmi-audio-edid: SKIP (0.000s)
[179.272614] [036/142] (830s left) kms_lease (lessee-list)
[179.507184] Starting subtest: lessee-list
[179.508511] Starting dynamic subtest: pipe-A-DP-1
[179.509941] Dynamic subtest pipe-A-DP-1: SUCCESS (0.003s)
[179.528933] Starting dynamic subtest: pipe-B-DP-1
[179.530231] Dynamic subtest pipe-B-DP-1: SUCCESS (0.002s)
[179.549281] Starting dynamic subtest: pipe-C-DP-1
[179.550512] Dynamic subtest pipe-C-DP-1: SUCCESS (0.001s)
[179.551712] Subtest lessee-list: SUCCESS (0.013s)
[179.617834] [037/142] (830s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[179.869166] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[179.872032] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[179.968119] [038/142] (829s left) gen9_exec_parse (bb-start-out)
[180.137501] Starting subtest: bb-start-out
[180.142574] Subtest bb-start-out: SUCCESS (0.005s)
[180.366970] [039/142] (829s left) kms_display_modes (mst-extended-mode-negative)
[180.616089] Starting subtest: mst-extended-mode-negative
[180.618796] Subtest mst-extended-mode-negative: SKIP (0.000s)
[180.669666] [040/142] (829s left) vgem_basic (dmabuf-fence)
[180.816561] Starting subtest: dmabuf-fence
[180.817946] Subtest dmabuf-fence: SUCCESS (0.002s)
[180.883873] [041/142] (828s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[181.127249] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[183.196392] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SUCCESS (2.072s)
[183.334089] [042/142] (826s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[183.475825] Starting subtest: cpuset-medium-copy-XY
[195.666671] Subtest cpuset-medium-copy-XY: SUCCESS (12.192s)
[195.802487] [043/142] (814s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[196.263040] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[196.549613] [044/142] (813s left) gem_exec_whisper (basic-forked-all)
[196.716705] Starting subtest: basic-forked-all
[218.766591] Subtest basic-forked-all: SUCCESS (22.047s)
[218.979584] [045/142] (791s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[219.225162] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[219.227591] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[219.327240] [046/142] (790s left) kms_big_fb (linear-8bpp-rotate-270)
[219.591181] Starting subtest: linear-8bpp-rotate-270
[219.687754] Subtest linear-8bpp-rotate-270: SKIP (0.095s)
[219.793467] [047/142] (790s left) kms_psr2_sf (primary-plane-update-sf-dmg-area-big-fb)
[219.934958] Subtest primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[219.993940] [048/142] (790s left) gen3_render_linear_blits
[220.176608] [049/142] (789s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[220.429235] Starting subtest: yf-tiled-addfb-size-overflow
[220.430664] Subtest yf-tiled-addfb-size-overflow: SUCCESS (0.001s)
[220.543206] [050/142] (789s left) kms_getfb (getfb-repeated-different-handles)
[220.683101] Starting subtest: getfb-repeated-different-handles
[220.684795] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[220.775665] [051/142] (789s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[220.930660] Starting subtest: etime-multi-wait-for-submit-submitted
[221.041387] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.109s)
[221.127173] [052/142] (789s left) kms_pm_lpsp (screens-disabled)
[222.365953] Starting subtest: screens-disabled
[222.368534] Subtest screens-disabled: SKIP (0.000s)
[222.526320] [053/142] (787s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_gen12_rc_ccs_cc)
[222.912237] Starting subtest: pipe-B-crc-primary-basic-y_tiled_gen12_rc_ccs_cc
[222.914957] Subtest pipe-B-crc-primary-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.001s)
[223.324736] [054/142] (787s left) gem_tiled_wb
[246.990724] [055/142] (763s left) kms_ccs (pipe-a-ccs-on-another-bo-y_tiled_ccs)
[247.345099] Starting subtest: pipe-A-ccs-on-another-bo-y_tiled_ccs
[247.346517] Subtest pipe-A-ccs-on-another-bo-y_tiled_ccs: SUCCESS (0.001s)
[247.780646] [056/142] (762s left) gem_userptr_blits (map-fixed-invalidate)
[247.963286] Starting subtest: map-fixed-invalidate
[247.964606] Starting dynamic subtest: gtt
[248.217191] Dynamic subtest gtt: SUCCESS (0.254s)
[248.236858] Starting dynamic subtest: wb
[248.395329] Dynamic subtest wb: SUCCESS (0.177s)
[248.414928] Starting dynamic subtest: wc
[248.588376] Dynamic subtest wc: SUCCESS (0.193s)
[248.607461] Starting dynamic subtest: uc
[248.772251] Dynamic subtest uc: SUCCESS (0.183s)
[248.773598] Subtest map-fixed-invalidate: SUCCESS (0.811s)
[248.911256] [057/142] (761s left) vgem_basic (bad-handle)
[249.055902] Starting subtest: bad-handle
[249.057619] Subtest bad-handle: SUCCESS (0.000s)
[249.125612] [058/142] (761s left) gem_render_linear_blits (basic)
[249.277050] Starting subtest: basic
[249.356494] Subtest basic: SUCCESS (0.079s)
[249.428487] [059/142] (761s left) syncobj_wait (reset-during-wait-for-submit)
[249.572483] Starting subtest: reset-during-wait-for-submit
[249.675187] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[249.760912] [060/142] (760s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[249.901053] Starting subtest: invalid-multi-wait-unsubmitted
[249.902717] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[249.995259] [061/142] (760s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[250.257479] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[250.262925] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.004s)
[250.347258] [062/142] (760s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[250.589870] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[250.592624] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[250.695774] [063/142] (760s left) kms_ccs (pipe-c-ccs-on-another-bo-y_tiled_gen12_rc_ccs)
[251.144460] Starting subtest: pipe-C-ccs-on-another-bo-y_tiled_gen12_rc_ccs
[251.147167] Subtest pipe-C-ccs-on-another-bo-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[251.461821] [064/142] (759s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[251.694448] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[251.695842] Starting dynamic subtest: pipe-A-valid-mode
[252.147577] Dynamic subtest pipe-A-valid-mode: SKIP (0.450s)
[252.150227] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.453s)
[252.528421] [065/142] (758s left) gem_softpin (zero)
[252.679287] Starting subtest: zero
[252.684356] Subtest zero: SUCCESS (0.006s)
[252.796144] [066/142] (758s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[253.054970] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[253.057707] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[253.162441] [067/142] (757s left) gem_render_copy_redux (flink-interruptible)
[253.317036] Starting subtest: flink-interruptible
[258.133840] Subtest flink-interruptible: SUCCESS (4.818s)
[258.246976] [068/142] (752s left) kms_ccs (pipe-a-bad-rotation-90-4_tiled_mtl_mc_ccs)
[258.571608] Starting subtest: pipe-A-bad-rotation-90-4_tiled_mtl_mc_ccs
[258.574186] Subtest pipe-A-bad-rotation-90-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[259.050037] [069/142] (751s left) gem_lmem_swapping (parallel-random-verify-ccs)
[259.199410] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[259.251368] [070/142] (751s left) kms_cursor_crc (cursor-offscreen-32x10)
[259.492512] Starting subtest: cursor-offscreen-32x10
[259.614305] Subtest cursor-offscreen-32x10: SKIP (0.118s)
[259.732257] [071/142] (751s left) gem_exec_fence (nb-await)
[260.027414] Starting subtest: nb-await
[260.029049] Starting dynamic subtest: rcs0
[260.101721] Dynamic subtest rcs0: SUCCESS (0.073s)
[260.123963] Starting dynamic subtest: bcs0
[260.174853] Dynamic subtest bcs0: SUCCESS (0.071s)
[260.197840] Starting dynamic subtest: vcs0
[260.248178] Dynamic subtest vcs0: SUCCESS (0.069s)
[260.271769] Starting dynamic subtest: vecs0
[260.320264] Dynamic subtest vecs0: SUCCESS (0.069s)
[260.321626] Subtest nb-await: SUCCESS (0.292s)
[260.998952] [072/142] (750s left) i915_suspend (fence-restore-tiled2untiled)
[261.140721] Starting subtest: fence-restore-tiled2untiled
[280.743110] Subtest fence-restore-tiled2untiled: SUCCESS (4.237s)
[283.874625] [073/142] (745s left) kms_addfb_basic (unused-modifier)
[284.016745] Starting subtest: unused-modifier
[284.020487] Subtest unused-modifier: SUCCESS (0.000s)
[284.217706] [074/142] (745s left) gem_userptr_blits (create-destroy-unsync)
[284.367635] Subtest create-destroy-unsync: SKIP (0.000s)
[284.535919] [075/142] (745s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[284.786619] Starting subtest: psr-rgb101010-draw-mmap-cpu
[284.789471] Subtest psr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[284.884759] [076/142] (744s left) kms_invalid_mode (bad-hsync-start)
[285.125376] Starting subtest: bad-hsync-start
[285.127699] Starting dynamic subtest: DP-1-pipe-A
[285.222937] Dynamic subtest DP-1-pipe-A: SUCCESS (0.098s)
[285.249130] Starting dynamic subtest: DP-1-pipe-B
[285.250507] Dynamic subtest DP-1-pipe-B: SUCCESS (0.002s)
[285.273604] Starting dynamic subtest: DP-1-pipe-C
[285.274965] Dynamic subtest DP-1-pipe-C: SUCCESS (0.002s)
[285.276422] Subtest bad-hsync-start: SUCCESS (0.110s)
[285.576113] [077/142] (744s left) gem_exec_params (secure-non-root)
[285.725769] Starting subtest: secure-non-root
[285.728875] Subtest secure-non-root: SKIP (0.000s)
[285.825890] [078/142] (743s left) kms_flip (flip-vs-wf_vblank-interruptible)
[286.055332] Starting subtest: flip-vs-wf_vblank-interruptible
[286.061301] Starting dynamic subtest: A-DP1
[287.677486] Dynamic subtest A-DP1: SUCCESS (1.615s)
[287.703847] Starting dynamic subtest: B-DP1
[289.063680] Dynamic subtest B-DP1: SUCCESS (1.384s)
[289.086824] Starting dynamic subtest: C-DP1
[290.453722] Dynamic subtest C-DP1: SUCCESS (1.388s)
[290.455659] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (4.400s)
[290.903691] [079/142] (738s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[291.147664] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[291.150323] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[291.235743] [080/142] (738s left) gem_ctx_shared (create-shared-gtt)
[291.400310] Starting subtest: create-shared-gtt
[293.552566] Subtest create-shared-gtt: SUCCESS (2.151s)
[293.753145] [081/142] (736s left) gen9_exec_parse (basic-rejected-ctx-param)
[293.931881] Starting subtest: basic-rejected-ctx-param
[294.009361] Subtest basic-rejected-ctx-param: SUCCESS (0.078s)
[294.253743] [082/142] (735s left) drm_fdinfo (virtual-busy-idle-all)
[294.400201] Starting subtest: virtual-busy-idle-all
[294.401815] Subtest virtual-busy-idle-all: SUCCESS (0.001s)
[294.487565] [083/142] (735s left) kms_ccs (pipe-d-bad-rotation-90-y_tiled_gen12_rc_ccs_cc)
[294.951073] Subtest pipe-D-bad-rotation-90-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[295.279088] [084/142] (734s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[295.420596] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[295.523683] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.102s)
[295.608770] [085/142] (734s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[295.752521] Starting subtest: etime-multi-wait-all-for-submit-submitted
[295.858584] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.106s)
[295.941166] [086/142] (734s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[296.186614] Starting subtest: cursorA-vs-flipB-varying-size
[296.189516] Subtest cursorA-vs-flipB-varying-size: SKIP (0.002s)
[296.275499] [087/142] (733s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[296.521605] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[296.524257] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[296.625935] [088/142] (733s left) gem_mmap_wc (fault-concurrent)
[296.767059] Starting subtest: fault-concurrent
[298.517611] Subtest fault-concurrent: SUCCESS (1.750s)
[298.609825] [089/142] (731s left) api_intel_bb (intel-bb-blit-none)
[298.756982] Starting subtest: intel-bb-blit-none
[302.439634] Subtest intel-bb-blit-none: SUCCESS (3.686s)
[302.558679] [090/142] (727s left) kms_big_fb (x-tiled-addfb-size-overflow)
[302.817812] Starting subtest: x-tiled-addfb-size-overflow
[302.819503] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.002s)
[302.930510] [091/142] (727s left) i915_pm_rpm (reg-read-ioctl)
[304.761294] Starting subtest: reg-read-ioctl
[305.475908] Subtest reg-read-ioctl: SUCCESS (0.718s)
[305.974993] [092/142] (724s left) gem_exec_balancer (bonded-chain)
[306.143705] Starting subtest: bonded-chain
[309.907201] Subtest bonded-chain: SUCCESS (3.763s)
[313.822505] [093/142] (716s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[314.071022] Starting subtest: cursor-rapid-movement-32x32
[314.202685] Subtest cursor-rapid-movement-32x32: SKIP (0.129s)
[314.322093] [094/142] (716s left) kms_vblank (pipe-d-wait-forked-hang)
[314.555792] Subtest pipe-D-wait-forked-hang: SKIP (0.000s)
[314.638765] [095/142] (715s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[314.889130] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[317.111856] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (2.225s)
[317.239475] [096/142] (713s left) kms_rmfb (close-fd)
[317.473347] Starting subtest: close-fd
[317.474654] Starting dynamic subtest: pipe-A-DP-1
[317.603978] Dynamic subtest pipe-A-DP-1: SUCCESS (0.123s)
[317.636251] Starting dynamic subtest: pipe-B-DP-1
[318.037203] Dynamic subtest pipe-B-DP-1: SUCCESS (0.436s)
[318.064217] Starting dynamic subtest: pipe-C-DP-1
[318.464096] Dynamic subtest pipe-C-DP-1: SUCCESS (0.423s)
[318.466199] Subtest close-fd: SUCCESS (0.992s)
[318.876577] [097/142] (711s left) kms_ccs (pipe-b-random-ccs-data-y_tiled_gen12_rc_ccs)
[319.281736] Starting subtest: pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs
[319.285726] Subtest pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[319.671126] [098/142] (710s left) kms_ccs (pipe-c-bad-pixel-format-4_tiled_dg2_rc_ccs_cc)
[320.087105] Starting subtest: pipe-C-bad-pixel-format-4_tiled_dg2_rc_ccs_cc
[320.089598] Subtest pipe-C-bad-pixel-format-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[320.472859] [099/142] (710s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[320.613408] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[320.723805] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.109s)
[320.823458] [100/142] (709s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[321.061692] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[321.063039] Starting dynamic subtest: pipe-A-DP-1
[321.390320] Dynamic subtest pipe-A-DP-1: SUCCESS (0.327s)
[321.435594] Starting dynamic subtest: pipe-B-DP-1
[321.778882] Dynamic subtest pipe-B-DP-1: SUCCESS (0.384s)
[321.818735] Starting dynamic subtest: pipe-C-DP-1
[321.878760] Dynamic subtest pipe-C-DP-1: SKIP (0.094s)
[321.880346] Subtest planes-downscale-factor-0-5-upscale-20x20: SUCCESS (0.818s)
[322.288930] [101/142] (708s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[322.526738] Starting subtest: plane-upscale-20x20-with-rotation
[322.528331] Starting dynamic subtest: pipe-A-DP-1
[322.584617] Dynamic subtest pipe-A-DP-1: SKIP (0.053s)
[322.620823] Starting dynamic subtest: pipe-B-DP-1
[322.933425] Dynamic subtest pipe-B-DP-1: SKIP (0.346s)
[322.972397] Starting dynamic subtest: pipe-C-DP-1
[323.290348] Dynamic subtest pipe-C-DP-1: SKIP (0.351s)
[323.292968] Subtest plane-upscale-20x20-with-rotation: SKIP (0.764s)
[323.677919] [102/142] (707s left) kms_flip (2x-flip-vs-panning-vs-hang)
[323.898298] Starting subtest: 2x-flip-vs-panning-vs-hang
[323.903126] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.003s)
[324.028312] [103/142] (706s left) kms_ccs (pipe-a-random-ccs-data-y_tiled_ccs)
[324.381519] Starting subtest: pipe-A-random-ccs-data-y_tiled_ccs
[324.835812] Subtest pipe-A-random-ccs-data-y_tiled_ccs: SUCCESS (0.454s)
[325.362710] [104/142] (705s left) gem_exec_schedule (u-submit-golden-slice)
[325.540417] Starting subtest: u-submit-golden-slice
[325.541931] Starting dynamic subtest: rcs0
[325.591047] Dynamic subtest rcs0: SUCCESS (0.051s)
[325.620947] Starting dynamic subtest: bcs0
[325.643627] Dynamic subtest bcs0: SUCCESS (0.050s)
[325.673444] Starting dynamic subtest: vcs0
[325.692478] Dynamic subtest vcs0: SUCCESS (0.047s)
[325.718345] Starting dynamic subtest: vecs0
[325.739840] Dynamic subtest vecs0: SUCCESS (0.045s)
[325.741554] Subtest u-submit-golden-slice: SUCCESS (0.203s)
[326.099088] [105/142] (704s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[326.346788] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[326.349372] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[326.445901] [106/142] (704s left) gem_set_tiling_vs_pwrite
[326.714088] [107/142] (704s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs)
[327.072754] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs
[327.079588] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs: SKIP (0.005s)
[327.508096] [108/142] (703s left) perf_pmu (busy-hang)
[327.659559] Starting subtest: busy-hang
[327.661363] Starting dynamic subtest: rcs0
[328.716648] Dynamic subtest rcs0: SUCCESS (1.058s)
[328.741643] Starting dynamic subtest: bcs0
[329.778482] Dynamic subtest bcs0: SUCCESS (1.060s)
[329.803472] Starting dynamic subtest: vcs0
[330.828442] Dynamic subtest vcs0: SUCCESS (1.048s)
[330.854751] Starting dynamic subtest: vecs0
[331.873735] Dynamic subtest vecs0: SUCCESS (1.043s)
[331.875939] Subtest busy-hang: SUCCESS (4.217s)
[331.973342] [109/142] (699s left) kms_vblank (pipe-c-wait-busy)
[332.215908] Starting subtest: pipe-C-wait-busy
[335.021134] Subtest pipe-C-wait-busy: SUCCESS (2.807s)
[335.351748] [110/142] (695s left) gem_pwrite (basic-exhaustion)
[335.496771] Starting subtest: basic-exhaustion
[351.626575] Subtest basic-exhaustion: SUCCESS (16.129s)
[351.739809] [111/142] (679s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[351.984499] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[351.985847] Starting dynamic subtest: pipe-A-valid-mode
[352.727247] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.739s)
[352.729002] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (0.743s)
[353.067010] [112/142] (678s left) kms_vblank (pipe-d-accuracy-idle)
[353.303387] Subtest pipe-D-accuracy-idle: SKIP (0.000s)
[353.400380] [113/142] (677s left) kms_flip (2x-flip-vs-panning)
[353.619915] Starting subtest: 2x-flip-vs-panning
[353.622501] Subtest 2x-flip-vs-panning: SKIP (0.003s)
[353.734733] [114/142] (677s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[353.976656] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[353.979353] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[354.083333] [115/142] (677s left) kms_plane_alpha_blend (constant-alpha-mid)
[354.324138] Starting subtest: constant-alpha-mid
[354.642470] Starting dynamic subtest: pipe-A-DP-1
[355.334836] Dynamic subtest pipe-A-DP-1: SUCCESS (0.691s)
[355.362345] Starting dynamic subtest: pipe-C-DP-1
[356.278504] Dynamic subtest pipe-C-DP-1: SUCCESS (0.937s)
[356.279990] Subtest constant-alpha-mid: SUCCESS (1.955s)
[356.653265] [116/142] (674s left) prime_mmap (test_invalid_sync_flags)
[356.800529] Starting subtest: test_invalid_sync_flags
[356.801950] Starting dynamic subtest: test_invalid_sync_flags-smem
[356.803246] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[356.804496] Subtest test_invalid_sync_flags: SUCCESS (0.002s)
[356.884507] [117/142] (674s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[357.147633] Starting subtest: 4-tiled-16bpp-rotate-0
[357.150626] Subtest 4-tiled-16bpp-rotate-0: SKIP (0.000s)
[357.235528] [118/142] (674s left) kms_psr (cursor_render)
[357.379029] Subtest cursor_render: SKIP (0.000s)
[357.437984] [119/142] (674s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[357.686354] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[357.689195] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[357.785470] [120/142] (673s left) kms_ccs (pipe-d-crc-sprite-planes-basic-yf_tiled_ccs)
[358.264727] Subtest pipe-D-crc-sprite-planes-basic-yf_tiled_ccs: SKIP (0.000s)
[358.595649] [121/142] (673s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[358.840354] Starting subtest: primary-y-tiled-reflect-x-90
[358.843582] Subtest primary-y-tiled-reflect-x-90: SKIP (0.003s)
[358.928698] [122/142] (672s left) syncobj_timeline (invalid-transfer-non-existent-point)
[359.070673] Starting subtest: invalid-transfer-non-existent-point
[359.072249] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[359.159873] [123/142] (672s left) kms_addfb_basic (clobberred-modifier)
[359.299418] Starting subtest: clobberred-modifier
[359.301069] Subtest clobberred-modifier: SUCCESS (0.000s)
[359.510042] [124/142] (672s left) gem_mmap_gtt (basic-write-gtt)
[359.653916] Starting subtest: basic-write-gtt
[360.404139] Subtest basic-write-gtt: SUCCESS (0.749s)
[360.512010] [125/142] (671s left) kms_ccs (pipe-b-ccs-on-another-bo-4_tiled_mtl_mc_ccs)
[360.928180] Starting subtest: pipe-B-ccs-on-another-bo-4_tiled_mtl_mc_ccs
[360.930869] Subtest pipe-B-ccs-on-another-bo-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[361.334391] [126/142] (670s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[361.592113] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[363.707576] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SUCCESS (2.118s)
[363.869690] [127/142] (668s left) gem_ctx_persistence (engines-hostile)
[364.022936] Starting subtest: engines-hostile
[364.024552] Starting dynamic subtest: rcs0
[364.061829] Dynamic subtest rcs0: SUCCESS (0.038s)
[364.089166] Starting dynamic subtest: bcs0
[364.159105] Dynamic subtest bcs0: SUCCESS (0.092s)
[364.186904] Starting dynamic subtest: vcs0
[364.254980] Dynamic subtest vcs0: SUCCESS (0.092s)
[364.282094] Starting dynamic subtest: vecs0
[364.347620] Dynamic subtest vecs0: SUCCESS (0.089s)
[364.349505] Subtest engines-hostile: SUCCESS (0.326s)
[364.454513] [128/142] (667s left) kms_plane_multiple (tiling-yf)
[364.694746] Starting subtest: tiling-yf
[364.696160] Starting dynamic subtest: pipe-A-DP-1
[366.584423] Dynamic subtest pipe-A-DP-1: SUCCESS (1.884s)
[366.611306] Starting dynamic subtest: pipe-B-DP-1
[368.738209] Dynamic subtest pipe-B-DP-1: SUCCESS (2.154s)
[368.767918] Starting dynamic subtest: pipe-C-DP-1
[370.862337] Dynamic subtest pipe-C-DP-1: SUCCESS (2.119s)
[370.866439] Subtest tiling-yf: SUCCESS (6.169s)
[371.234189] [129/142] (660s left) gem_exec_schedule (preempt-engines)
[371.414536] Starting subtest: preempt-engines
[371.416006] Starting dynamic subtest: rcs0
[371.748709] Dynamic subtest rcs0: SUCCESS (0.332s)
[371.780761] Starting dynamic subtest: bcs0
[372.148807] Dynamic subtest bcs0: SUCCESS (0.396s)
[372.176863] Starting dynamic subtest: vcs0
[372.411527] Dynamic subtest vcs0: SUCCESS (0.262s)
[372.448752] Starting dynamic subtest: vecs0
[372.691392] Dynamic subtest vecs0: SUCCESS (0.276s)
[372.694387] Subtest preempt-engines: SUCCESS (1.279s)
[373.066402] [130/142] (658s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[373.325357] Starting subtest: y-tiled-8bpp-rotate-90
[373.422530] Subtest y-tiled-8bpp-rotate-90: SKIP (0.094s)
[373.549197] [131/142] (658s left) gem_ctx_persistence (legacy-engines-persistence)
[373.697245] Starting subtest: legacy-engines-persistence
[373.698705] Starting dynamic subtest: render
[374.446566] Dynamic subtest render: SUCCESS (0.747s)
[374.474445] Starting dynamic subtest: bsd
[375.214370] Dynamic subtest bsd: SUCCESS (0.762s)
[375.242682] Starting dynamic subtest: blt
[375.981263] Dynamic subtest blt: SUCCESS (0.761s)
[376.008915] Starting dynamic subtest: vebox
[376.750016] Dynamic subtest vebox: SUCCESS (0.763s)
[376.751970] Subtest legacy-engines-persistence: SUCCESS (3.055s)
[376.851372] [132/142] (655s left) kms_ccs (pipe-c-random-ccs-data-yf_tiled_ccs)
[377.299303] Starting subtest: pipe-C-random-ccs-data-yf_tiled_ccs
[377.303416] Subtest pipe-C-random-ccs-data-yf_tiled_ccs: SKIP (0.000s)
[377.652503] [133/142] (654s left) kms_flip (2x-nonexisting-fb)
[377.882405] Starting subtest: 2x-nonexisting-fb
[377.885115] Subtest 2x-nonexisting-fb: SKIP (0.003s)
[378.002519] [134/142] (654s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[378.250190] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[378.253225] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[378.352764] [135/142] (653s left) syncobj_timeline (single-wait-for-submit-signaled)
[378.494151] Starting subtest: single-wait-for-submit-signaled
[378.495821] Subtest single-wait-for-submit-signaled: SUCCESS (0.001s)
[378.585253] [136/142] (653s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[378.833084] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[378.835828] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[378.934998] [137/142] (653s left) kms_psr (psr2_sprite_plane_onoff)
[379.074225] Subtest psr2_sprite_plane_onoff: SKIP (0.000s)
[379.137775] [138/142] (653s left) gem_exec_params (larger-than-life-batch)
[379.282496] Starting subtest: larger-than-life-batch
[379.856637] Subtest larger-than-life-batch: SKIP (0.556s)
[379.977474] [139/142] (652s left) gem_exec_balancer (parallel-bb-first)
[384.087073] Subtest parallel-bb-first: SKIP (0.000s)
[384.188017] [140/142] (648s left) gem_tiled_fence_blits (normal)
[384.549585] Starting subtest: normal
[386.592832] Subtest normal: SUCCESS (2.044s)
[386.687258] [141/142] (645s left) gem_wait (await)
[386.989736] Starting subtest: await
[386.991305] Starting dynamic subtest: all-engines
[388.022942] Dynamic subtest all-engines: SUCCESS (1.035s)
[388.051252] Starting dynamic subtest: rcs0
[389.057006] Dynamic subtest rcs0: SUCCESS (1.031s)
[389.085382] Starting dynamic subtest: bcs0
[390.089135] Dynamic subtest bcs0: SUCCESS (1.029s)
[390.117476] Starting dynamic subtest: vcs0
[391.115998] Dynamic subtest vcs0: SUCCESS (1.024s)
[391.145888] Starting dynamic subtest: vecs0
[392.152267] Dynamic subtest vecs0: SUCCESS (1.032s)
[392.156740] Subtest await: SUCCESS (5.167s)
[392.404715] [142/142] (640s left) gem_partial_pwrite_pread (reads)
[392.555752] Starting subtest: reads
[398.903840] Subtest reads: SUCCESS (6.348s)
[399.017019] Closing watchdogs
Done.