[51.867198] Initializing watchdogs
[51.867448]   /dev/watchdog0
[51.883741] [001/137] (960s left) syncobj_basic (illegal-fd-to-handle)
[52.110146] Starting subtest: illegal-fd-to-handle
[52.112428] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[52.189622] [002/137] (960s left) gem_eio (wait-10ms)
[52.428823] Starting subtest: wait-10ms
[52.539589] Subtest wait-10ms: SUCCESS (0.111s)
[52.720700] [003/137] (959s left) kms_addfb_basic (basic)
[52.921879] Starting subtest: basic
[52.924133] Subtest basic: SUCCESS (0.000s)
[53.121554] [004/137] (959s left) kms_ccs (pipe-c-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc)
[53.810456] Starting subtest: pipe-C-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc
[53.815109] Subtest pipe-C-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[54.181692] [005/137] (958s left) gem_exec_reloc (basic-cpu-wc-active)
[54.396834] Starting subtest: basic-cpu-wc-active
[54.547485] Subtest basic-cpu-wc-active: SUCCESS (0.150s)
[54.732285] [006/137] (957s left) api_intel_allocator (reopen-fork)
[54.935121] Starting subtest: reopen-fork
[58.223707] Subtest reopen-fork: SUCCESS (3.289s)
[58.303585] [007/137] (954s left) i915_query (engine-info-invalid)
[58.521755] Starting subtest: engine-info-invalid
[58.524079] Subtest engine-info-invalid: SUCCESS (0.001s)
[58.608448] [008/137] (954s left) kms_flip (flip-vs-panning-vs-hang)
[59.000821] Starting subtest: flip-vs-panning-vs-hang
[59.003260] Starting dynamic subtest: A-DP1
[72.934171] Dynamic subtest A-DP1: SUCCESS (13.931s)
[72.949129] Starting dynamic subtest: C-DP1
[85.916916] Dynamic subtest C-DP1: SUCCESS (12.983s)
[85.918966] Subtest flip-vs-panning-vs-hang: SUCCESS (26.918s)
[86.365551] [009/137] (926s left) kms_addfb_basic (unused-modifier)
[86.569169] Starting subtest: unused-modifier
[86.571182] Subtest unused-modifier: SUCCESS (0.000s)
[86.763662] [010/137] (925s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[87.058871] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[87.067961] Starting dynamic subtest: pipe-A-DP-1
[87.384344] Dynamic subtest pipe-A-DP-1: SUCCESS (0.322s)
[87.402954] Starting dynamic subtest: pipe-B-DP-1
[87.764830] Dynamic subtest pipe-B-DP-1: SUCCESS (0.377s)
[87.782236] Starting dynamic subtest: pipe-C-DP-1
[87.854706] Dynamic subtest pipe-C-DP-1: SKIP (0.083s)
[87.856852] Subtest planes-downscale-factor-0-5-upscale-20x20: SUCCESS (0.793s)
[88.238491] [011/137] (924s left) api_intel_bb (simple-bb-ctx)
[88.444792] Starting subtest: simple-bb-ctx
[88.463285] Subtest simple-bb-ctx: SUCCESS (0.018s)
[88.555320] [012/137] (924s left) kms_atomic (plane-overlay-legacy)
[88.973975] Starting subtest: plane-overlay-legacy
[89.105370] Subtest plane-overlay-legacy: SUCCESS (0.131s)
[89.528493] [013/137] (923s left) kms_ccs (pipe-a-bad-rotation-90-4_tiled_dg2_mc_ccs)
[89.943851] Starting subtest: pipe-A-bad-rotation-90-4_tiled_dg2_mc_ccs
[89.948141] Subtest pipe-A-bad-rotation-90-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[90.555834] [014/137] (922s left) kms_ccs (pipe-a-ccs-on-another-bo-y_tiled_ccs)
[90.996351] Starting subtest: pipe-A-ccs-on-another-bo-y_tiled_ccs
[90.998483] Subtest pipe-A-ccs-on-another-bo-y_tiled_ccs: SUCCESS (0.002s)
[91.561729] [015/137] (921s left) gem_exec_parallel (engines)
[91.784494] Starting subtest: engines
[91.787169] Starting dynamic subtest: basic
[95.446187] Dynamic subtest basic: SUCCESS (3.661s)
[95.471035] Starting dynamic subtest: contexts
[99.521802] Dynamic subtest contexts: SUCCESS (4.074s)
[99.538440] Starting dynamic subtest: fds
[103.820739] Dynamic subtest fds: SUCCESS (4.300s)
[103.838846] Starting dynamic subtest: userptr
[107.449560] Dynamic subtest userptr: SUCCESS (3.628s)
[107.451844] Subtest engines: SUCCESS (15.664s)
[107.652749] [016/137] (905s left) gem_fenced_exec_thrash (2-spare-fences)
[107.863358] Starting subtest: 2-spare-fences
[110.031466] Subtest 2-spare-fences: SUCCESS (2.163s)
[110.379257] [017/137] (902s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-wc)
[110.697977] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-wc
[110.701988] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[110.796897] [018/137] (902s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[111.107519] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[113.611168] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (2.508s)
[113.747150] [019/137] (899s left) drm_buddy (all-tests)
[113.947855] Starting subtest: all-tests
[113.952138] Subtest all-tests: SKIP (0.000s)
[114.013394] [020/137] (899s left) kms_vblank (pipe-d-ts-continuation-idle-hang)
[114.310866] Subtest pipe-D-ts-continuation-idle-hang: SKIP (0.000s)
[114.470705] [021/137] (898s left) gem_exec_fence (basic-wait-all)
[114.806198] Starting subtest: basic-wait-all
[114.829252] Subtest basic-wait-all: SUCCESS (0.033s)
[115.680792] [022/137] (897s left) gem_mmap_offset (close-race)
[115.880938] Starting subtest: close-race
[135.993792] Subtest close-race: SUCCESS (20.112s)
[136.098658] [023/137] (877s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[136.416722] Starting subtest: 4-tiled-addfb-size-offset-overflow
[136.420742] Subtest 4-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[136.514234] [024/137] (876s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[136.797080] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[136.799127] Starting dynamic subtest: A-DP1
[138.031781] Dynamic subtest A-DP1: SUCCESS (1.229s)
[138.049148] Starting dynamic subtest: B-DP1
[139.106705] Dynamic subtest B-DP1: SUCCESS (1.076s)
[139.124203] Starting dynamic subtest: C-DP1
[140.206814] Dynamic subtest C-DP1: SUCCESS (1.100s)
[140.208907] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (3.412s)
[140.548388] [025/137] (872s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[140.873660] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[142.175767] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (1.303s)
[142.514574] [026/137] (870s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[142.825970] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[142.829762] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[142.913289] [027/137] (870s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_ccs)
[143.428260] Starting subtest: pipe-B-crc-primary-basic-y_tiled_ccs
[144.082923] Subtest pipe-B-crc-primary-basic-y_tiled_ccs: SUCCESS (0.651s)
[144.658239] [028/137] (868s left) gem_exec_reloc (basic-cpu-read)
[144.871225] Starting subtest: basic-cpu-read
[144.889433] Subtest basic-cpu-read: SUCCESS (0.019s)
[145.072291] [029/137] (868s left) kms_flip (2x-flip-vs-modeset)
[145.349127] Starting subtest: 2x-flip-vs-modeset
[145.353055] Subtest 2x-flip-vs-modeset: SKIP (0.003s)
[145.456531] [030/137] (868s left) gem_flink_basic (flink-lifetime)
[145.654760] Starting subtest: flink-lifetime
[145.657236] Subtest flink-lifetime: SUCCESS (0.002s)
[145.755272] [031/137] (867s left) kms_invalid_mode (bad-vsync-start)
[146.087851] Starting subtest: bad-vsync-start
[146.089940] Starting dynamic subtest: DP-1-pipe-A
[146.157272] Dynamic subtest DP-1-pipe-A: SUCCESS (0.101s)
[146.178502] Starting dynamic subtest: DP-1-pipe-B
[146.180994] Dynamic subtest DP-1-pipe-B: SUCCESS (0.014s)
[146.200847] Starting dynamic subtest: DP-1-pipe-C
[146.202885] Dynamic subtest DP-1-pipe-C: SUCCESS (0.014s)
[146.204847] Subtest bad-vsync-start: SUCCESS (0.139s)
[146.518747] [032/137] (867s left) gem_exec_fair (basic-sync)
[146.750950] Starting subtest: basic-sync
[146.753116] Starting dynamic subtest: rcs0
[151.533690] Dynamic subtest rcs0: SUCCESS (4.781s)
[151.535794] Subtest basic-sync: SUCCESS (4.782s)
[151.733930] [033/137] (861s left) syncobj_wait (multi-wait-for-submit-submitted)
[151.935653] Starting subtest: multi-wait-for-submit-submitted
[152.045220] Subtest multi-wait-for-submit-submitted: SUCCESS (0.109s)
[152.132840] [034/137] (861s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[152.439734] Starting subtest: fbcpsr-modesetfrombusy
[152.443633] Subtest fbcpsr-modesetfrombusy: SKIP (0.000s)
[152.533562] [035/137] (861s left) kms_dp_tiled_display (basic-test-pattern)
[152.830443] Starting subtest: basic-test-pattern
[152.834305] Subtest basic-test-pattern: SKIP (0.001s)
[152.916486] [036/137] (860s left) gem_exec_whisper (basic-contexts)
[153.139734] Starting subtest: basic-contexts
[162.084764] Subtest basic-contexts: SUCCESS (8.942s)
[162.284828] [037/137] (851s left) gem_ctx_sseu (engines)
[162.495945] Subtest engines: SKIP (0.000s)
[162.553416] [038/137] (851s left) kms_concurrent (pipe-b)
[162.854665] Starting subtest: pipe-B
[162.856751] Starting dynamic subtest: DP-1
[163.739170] Dynamic subtest DP-1: SUCCESS (0.882s)
[163.741206] Subtest pipe-B: SUCCESS (0.886s)
[164.053136] [039/137] (849s left) gem_eio (unwedge-stress)
[164.278830] Starting subtest: unwedge-stress
[197.628434] Subtest unwedge-stress: SUCCESS (33.350s)
[197.785423] [040/137] (816s left) gem_unref_active_buffers
[198.217954] [041/137] (815s left) gem_wait (wait)
[198.454169] Starting subtest: wait
[198.456440] Starting dynamic subtest: all-engines
[199.484829] Dynamic subtest all-engines: SUCCESS (1.030s)
[199.505250] Starting dynamic subtest: rcs0
[200.504491] Dynamic subtest rcs0: SUCCESS (1.019s)
[200.523144] Starting dynamic subtest: bcs0
[201.533569] Dynamic subtest bcs0: SUCCESS (1.028s)
[201.553331] Starting dynamic subtest: vcs0
[202.556997] Dynamic subtest vcs0: SUCCESS (1.022s)
[202.576733] Starting dynamic subtest: vecs0
[203.589179] Dynamic subtest vecs0: SUCCESS (1.031s)
[203.591264] Subtest wait: SUCCESS (5.135s)
[203.835970] [042/137] (810s left) i915_pm_rpm (gem-evict-pwrite)
[205.630978] Starting subtest: gem-evict-pwrite
[206.729188] Subtest gem-evict-pwrite: SUCCESS (1.099s)
[207.207665] [043/137] (806s left) gem_ctx_param (invalid-set-ringsize)
[207.408922] Starting subtest: invalid-set-ringsize
[207.411253] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[207.488755] [044/137] (806s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[207.782709] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[207.787559] Starting dynamic subtest: A-DP1
[218.558349] Dynamic subtest A-DP1: SUCCESS (10.770s)
[218.578491] Starting dynamic subtest: B-DP1
[229.288790] Dynamic subtest B-DP1: SUCCESS (10.729s)
[229.309124] Starting dynamic subtest: C-DP1
[240.016723] Dynamic subtest C-DP1: SUCCESS (10.725s)
[240.018710] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (32.234s)
[240.439674] [045/137] (773s left) gem_userptr_blits (access-control)
[240.704828] Starting subtest: access-control
[240.708842] Subtest access-control: SKIP (0.000s)
[240.821813] [046/137] (773s left) kms_universal_plane (universal-plane-pipe-a-functional)
[241.118261] Starting subtest: universal-plane-pipe-A-functional
[243.596322] Subtest universal-plane-pipe-A-functional: SUCCESS (2.448s)
[243.929226] [047/137] (770s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[244.243316] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[244.247367] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[244.322352] [048/137] (769s left) prime_busy (after)
[244.529336] Starting subtest: after
[244.546110] Starting dynamic subtest: rcs0
[244.558236] Dynamic subtest rcs0: SUCCESS (0.011s)
[244.578374] Starting dynamic subtest: bcs0
[244.580531] Dynamic subtest bcs0: SUCCESS (0.019s)
[244.600744] Starting dynamic subtest: vcs0
[244.602719] Dynamic subtest vcs0: SUCCESS (0.014s)
[244.623209] Starting dynamic subtest: vecs0
[244.625166] Dynamic subtest vecs0: SUCCESS (0.017s)
[244.725228] Subtest after: SUCCESS (0.196s)
[244.806263] [049/137] (769s left) kms_atomic_interruptible (legacy-setmode)
[245.106905] Starting subtest: legacy-setmode
[245.112243] Starting dynamic subtest: DP-1-pipe-A
[251.617640] Dynamic subtest DP-1-pipe-A: SUCCESS (6.506s)
[251.619791] Subtest legacy-setmode: SUCCESS (6.510s)
[251.917372] [050/137] (762s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_dg2_rc_ccs)
[252.643263] Subtest pipe-D-crc-primary-rotation-180-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[252.957032] [051/137] (761s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[253.175193] Starting subtest: y-tiled-to-vebox-x-tiled
[253.179046] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[253.374315] [052/137] (760s left) kms_dsc (dsc-with-formats)
[253.669599] Subtest dsc-with-formats: SKIP (0.000s)
[253.722799] [053/137] (760s left) gem_create (create-ext-cpu-access-sanity-check)
[254.048220] Starting subtest: create-ext-cpu-access-sanity-check
[254.052879] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[254.140912] [054/137] (760s left) gem_pxp (create-regular-buffer)
[256.858214] Subtest create-regular-buffer: SKIP (0.000s)
[256.940637] [055/137] (757s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[257.240467] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[257.243672] Starting dynamic subtest: pipe-A-valid-mode
[257.334371] Dynamic subtest pipe-A-valid-mode: SKIP (0.091s)
[257.341255] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SKIP (0.094s)
[257.652463] [056/137] (756s left) prime_mmap_coherency (write)
[257.863457] Starting subtest: write
[263.281933] Subtest write: SUCCESS (5.418s)
[263.835152] [057/137] (750s left) gem_exec_schedule (u-fairslice-all)
[264.070162] Starting subtest: u-fairslice-all
[266.185098] Subtest u-fairslice-all: SUCCESS (2.118s)
[266.553341] [058/137] (748s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[266.759135] Starting subtest: invalid-bsd1-flag-on-vebox
[266.761345] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.001s)
[266.869116] [059/137] (747s left) core_getstats
[267.152196] [060/137] (747s left) i915_pm_dc (dc5-dpms-negative)
[268.458560] Starting subtest: dc5-dpms-negative
[272.769103] Subtest dc5-dpms-negative: SUCCESS (4.313s)
[272.985961] [061/137] (741s left) kms_psr2_sf (overlay-primary-update-sf-dmg-area)
[273.191107] Subtest overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[273.252719] [062/137] (741s left) kms_cursor_crc (cursor-random-512x512)
[273.565373] Starting subtest: cursor-random-512x512
[273.569890] Subtest cursor-random-512x512: SKIP (0.003s)
[273.686711] [063/137] (741s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[273.997776] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[274.001698] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[274.086409] [064/137] (740s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[274.480883] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[274.766458] [065/137] (740s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[274.974238] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[275.077130] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.105s)
[275.159226] [066/137] (739s left) syncobj_timeline (invalid-query-one-illegal-handle)
[275.357154] Starting subtest: invalid-query-one-illegal-handle
[275.359404] Subtest invalid-query-one-illegal-handle: SUCCESS (0.001s)
[275.442874] [067/137] (739s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[275.754979] Starting subtest: y-tiled-32bpp-rotate-180
[280.935133] Subtest y-tiled-32bpp-rotate-180: SUCCESS (5.180s)
[281.460781] [068/137] (733s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[281.783904] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[281.787749] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[281.944384] [069/137] (733s left) perf_pmu (enable-race)
[282.154133] Starting subtest: enable-race
[282.156422] Starting dynamic subtest: rcs0
[294.816362] Dynamic subtest rcs0: SUCCESS (12.662s)
[294.835899] Starting dynamic subtest: bcs0
[307.533485] Dynamic subtest bcs0: SUCCESS (12.716s)
[307.552732] Starting dynamic subtest: vcs0
[320.200285] Dynamic subtest vcs0: SUCCESS (12.665s)
[320.219650] Starting dynamic subtest: vecs0
[332.866708] Dynamic subtest vecs0: SUCCESS (12.664s)
[332.869117] Subtest enable-race: SUCCESS (50.712s)
[332.960375] [070/137] (682s left) kms_vblank (pipe-b-ts-continuation-idle-hang)
[333.259670] Starting subtest: pipe-B-ts-continuation-idle-hang
[340.972143] Subtest pipe-B-ts-continuation-idle-hang: SUCCESS (7.714s)
[341.310814] [071/137] (673s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[341.613475] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[341.617584] Starting dynamic subtest: pipe-A-valid-mode
[341.734988] Dynamic subtest pipe-A-valid-mode: SKIP (0.122s)
[341.739097] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.125s)
[342.054605] [072/137] (673s left) kms_ccs (pipe-c-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc)
[342.724178] Starting subtest: pipe-C-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc
[342.728755] Subtest pipe-C-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[343.070130] [073/137] (672s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs)
[343.574954] Starting subtest: pipe-A-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs
[343.583330] Subtest pipe-A-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs: SKIP (0.006s)
[344.148565] [074/137] (671s left) i915_pm_rpm (pm-caching)
[345.941548] Starting subtest: pm-caching
[347.655395] Subtest pm-caching: SUCCESS (1.715s)
[348.156252] [075/137] (667s left) kms_lease (lease_unleased_connector)
[348.534883] Starting subtest: lease_unleased_connector
[348.557477] Starting dynamic subtest: pipe-A-DP-1
[348.696428] Dynamic subtest pipe-A-DP-1: SUCCESS (0.163s)
[348.728338] Starting dynamic subtest: pipe-B-DP-1
[348.866299] Dynamic subtest pipe-B-DP-1: SUCCESS (0.168s)
[348.898523] Starting dynamic subtest: pipe-C-DP-1
[349.016402] Dynamic subtest pipe-C-DP-1: SUCCESS (0.162s)
[349.018365] Subtest lease_unleased_connector: SUCCESS (0.503s)
[349.104394] [076/137] (666s left) kms_getfb (getfb-repeated-different-handles)
[349.309337] Starting subtest: getfb-repeated-different-handles
[349.311488] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[349.418360] [077/137] (666s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[349.621583] Starting subtest: single-wait-all-for-submit-available-submitted
[349.623657] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[349.701570] [078/137] (665s left) kms_vblank (pipe-d-query-busy-hang)
[349.996259] Subtest pipe-D-query-busy-hang: SKIP (0.000s)
[350.085386] [079/137] (665s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[350.386801] Starting subtest: cursor-vs-flip-legacy
[388.491305] Subtest cursor-vs-flip-legacy: SUCCESS (38.106s)
[388.830591] [080/137] (626s left) kms_vblank (pipe-c-ts-continuation-idle)
[389.125481] Starting subtest: pipe-C-ts-continuation-idle
[389.854134] Subtest pipe-C-ts-continuation-idle: SUCCESS (0.727s)
[390.188181] [081/137] (625s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[390.395103] Starting subtest: addfb25-x-tiled-mismatch-legacy
[390.397328] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[390.588233] [082/137] (625s left) kms_universal_plane (disable-primary-vs-flip-pipe-d)
[390.887099] Subtest disable-primary-vs-flip-pipe-D: SKIP (0.000s)
[390.970998] [083/137] (624s left) kms_big_fb (linear-8bpp-rotate-0)
[391.289214] Starting subtest: linear-8bpp-rotate-0
[395.181080] Subtest linear-8bpp-rotate-0: SUCCESS (3.891s)
[395.440404] [084/137] (620s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[395.738703] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[395.742591] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[395.838209] [085/137] (619s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[396.150536] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[396.154440] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[396.254342] [086/137] (619s left) gem_fence_thrash (bo-write-verify-threaded-none)
[396.458493] Starting subtest: bo-write-verify-threaded-none
[398.871269] Subtest bo-write-verify-threaded-none: SUCCESS (2.412s)
[398.973924] [087/137] (616s left) gem_exec_balancer (parallel-out-fence)
[402.973597] Subtest parallel-out-fence: SKIP (0.000s)
[403.072629] [088/137] (612s left) kms_pipe_crc_basic (suspend-read-crc)
[403.378033] Starting subtest: suspend-read-crc
[403.380210] Starting dynamic subtest: pipe-A-DP-1
[421.551718] Dynamic subtest pipe-A-DP-1: SUCCESS (2.502s)
[427.438863] [089/137] (609s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[427.728261] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[427.732107] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.003s)
[427.848467] [090/137] (608s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[428.072236] Starting subtest: yf-tiled-ccs-to-y-tiled
[428.074488] Starting dynamic subtest: smem
[428.385095] Dynamic subtest smem: SUCCESS (0.314s)
[428.387929] Subtest yf-tiled-ccs-to-y-tiled: SUCCESS (0.316s)
[428.599699] [091/137] (608s left) kms_ccs (pipe-d-bad-pixel-format-y_tiled_ccs)
[429.299972] Subtest pipe-D-bad-pixel-format-y_tiled_ccs: SKIP (0.000s)
[429.617248] [092/137] (607s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[429.924189] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[429.928069] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[430.033334] [093/137] (606s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[430.356065] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[430.359986] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[430.450732] [094/137] (606s left) v3d/v3d_job_submission (multiple-singlesync-to-multisync)
[430.707429] Subtest multiple-singlesync-to-multisync: SKIP (0.000s)
[430.783029] [095/137] (606s left) kms_color (ctm-red-to-blue)
[431.085934] Starting subtest: ctm-red-to-blue
[431.088276] Starting dynamic subtest: pipe-A-DP-1
[431.605491] Dynamic subtest pipe-A-DP-1: SUCCESS (0.515s)
[431.636480] Starting dynamic subtest: pipe-B-DP-1
[432.399244] Dynamic subtest pipe-B-DP-1: SUCCESS (0.788s)
[432.424948] Starting dynamic subtest: pipe-C-DP-1
[433.339094] Dynamic subtest pipe-C-DP-1: SUCCESS (0.935s)
[433.341083] Subtest ctm-red-to-blue: SUCCESS (2.257s)
[433.681389] [096/137] (603s left) kms_ccs (pipe-b-bad-rotation-90-yf_tiled_ccs)
[434.182298] Starting subtest: pipe-B-bad-rotation-90-yf_tiled_ccs
[434.674579] Subtest pipe-B-bad-rotation-90-yf_tiled_ccs: SUCCESS (0.451s)
[435.310619] [097/137] (601s left) kms_hdmi_inject (inject-4k)
[435.512439] Subtest inject-4k: SKIP (0.000s)
[435.572330] [098/137] (601s left) gem_exec_schedule (lateslice)
[435.798949] Starting subtest: lateslice
[435.801417] Starting dynamic subtest: rcs0
[435.829283] Dynamic subtest rcs0: SUCCESS (0.029s)
[435.862401] Starting dynamic subtest: bcs0
[435.865191] Dynamic subtest bcs0: SUCCESS (0.030s)
[435.895816] Starting dynamic subtest: vcs0
[435.897851] Dynamic subtest vcs0: SUCCESS (0.030s)
[435.922325] Starting dynamic subtest: vecs0
[435.924543] Dynamic subtest vecs0: SUCCESS (0.030s)
[435.926916] Subtest lateslice: SUCCESS (0.126s)
[436.274278] [099/137] (600s left) gem_ctx_engines (invalid-engines)
[436.496441] Starting subtest: invalid-engines
[436.512166] Subtest invalid-engines: SUCCESS (0.015s)
[436.723534] [100/137] (600s left) gem_ctx_exec (basic)
[436.924743] Starting subtest: basic
[436.931110] Subtest basic: SUCCESS (0.007s)
[437.056244] [101/137] (600s left) kms_cursor_crc (cursor-sliding-512x512)
[437.368466] Starting subtest: cursor-sliding-512x512
[437.376753] Subtest cursor-sliding-512x512: SKIP (0.003s)
[437.489767] [102/137] (599s left) kms_vblank (pipe-b-query-forked)
[437.790766] Starting subtest: pipe-B-query-forked
[440.553415] Subtest pipe-B-query-forked: SUCCESS (2.766s)
[440.888277] [103/137] (596s left) gem_exec_fence (syncobj-timeline-chain-engines)
[441.673092] Starting subtest: syncobj-timeline-chain-engines
[441.801226] Subtest syncobj-timeline-chain-engines: SUCCESS (0.128s)
[442.039642] [104/137] (595s left) kms_prime (basic-crc-vgem)
[444.022423] Starting subtest: basic-crc-vgem
[444.024603] Starting dynamic subtest: second-to-first
[445.224810] Dynamic subtest second-to-first: SUCCESS (1.202s)
[445.226906] Subtest basic-crc-vgem: SUCCESS (1.203s)
[445.373064] [105/137] (591s left) kms_chamelium_edid (dp-edid-resolution-list)
[445.766260] Subtest dp-edid-resolution-list: SKIP (0.000s)
[446.058536] [106/137] (591s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[446.375554] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[446.379399] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[446.484982] [107/137] (590s left) v3d/v3d_create_bo (create-bo-4096)
[446.741879] Subtest create-bo-4096: SKIP (0.000s)
[446.818309] [108/137] (590s left) vc4/vc4_wait_bo (used-bo-1ns)
[447.075329] Subtest used-bo-1ns: SKIP (0.000s)
[447.151980] [109/137] (590s left) kms_rotation_crc (sprite-rotation-270)
[447.615769] Starting subtest: sprite-rotation-270
[453.568983] Subtest sprite-rotation-270: SUCCESS (6.124s)
[453.993351] [110/137] (583s left) gem_exec_balancer (hog)
[454.218106] Starting subtest: hog
[457.952809] Subtest hog: SUCCESS (3.733s)
[461.827606] [111/137] (575s left) syncobj_timeline (multi-wait-submitted-signaled)
[462.030350] Starting subtest: multi-wait-submitted-signaled
[462.032639] Subtest multi-wait-submitted-signaled: SUCCESS (0.002s)
[462.126872] [112/137] (575s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[462.425404] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[462.432856] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.003s)
[462.543356] [113/137] (575s left) gem_exec_params (invalid-bsd-ring)
[462.750486] Starting subtest: invalid-bsd-ring
[462.753365] Subtest invalid-bsd-ring: SUCCESS (0.002s)
[462.858869] [114/137] (574s left) gem_exec_reloc (basic-write-read-noreloc)
[463.065885] Starting subtest: basic-write-read-noreloc
[463.073188] Subtest basic-write-read-noreloc: SUCCESS (0.007s)
[463.260559] [115/137] (574s left) gem_mmap_gtt (bad-object)
[463.466899] Starting subtest: bad-object
[463.468892] Subtest bad-object: SUCCESS (0.000s)
[463.575783] [116/137] (574s left) feature_discovery (chamelium)
[463.873236] Starting subtest: chamelium
[463.877079] Subtest chamelium: SKIP (0.001s)
[463.959957] [117/137] (573s left) kms_chamelium_audio (dp-audio-edid)
[464.350346] Subtest dp-audio-edid: SKIP (0.000s)
[464.654892] [118/137] (573s left) kms_ccs (pipe-c-bad-aux-stride-y_tiled_gen12_rc_ccs)
[465.328841] Starting subtest: pipe-C-bad-aux-stride-y_tiled_gen12_rc_ccs
[465.333463] Subtest pipe-C-bad-aux-stride-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[465.673590] [119/137] (572s left) gem_spin_batch (resubmit-new)
[465.919205] Starting subtest: resubmit-new
[465.921460] Starting dynamic subtest: rcs0
[465.931697] Dynamic subtest rcs0: SUCCESS (0.010s)
[465.967569] Starting dynamic subtest: bcs0
[465.969643] Dynamic subtest bcs0: SUCCESS (0.011s)
[465.992994] Starting dynamic subtest: vcs0
[465.995006] Dynamic subtest vcs0: SUCCESS (0.008s)
[466.017939] Starting dynamic subtest: vecs0
[466.019982] Dynamic subtest vecs0: SUCCESS (0.007s)
[466.021899] Subtest resubmit-new: SUCCESS (0.043s)
[466.205051] [120/137] (571s left) v3d/v3d_wait_bo (map-bo-0ns)
[466.461502] Subtest map-bo-0ns: SKIP (0.000s)
[466.537865] [121/137] (571s left) i915_hangman (engine-engine-error)
[466.758427] Starting subtest: engine-engine-error
[466.760688] Starting dynamic subtest: rcs0
[466.842175] Dynamic subtest rcs0: SUCCESS (0.082s)
[466.867505] Starting dynamic subtest: bcs0
[466.871935] Dynamic subtest bcs0: SKIP (0.003s)
[466.902276] Starting dynamic subtest: vcs0
[466.934712] Dynamic subtest vcs0: SUCCESS (0.087s)
[466.968461] Starting dynamic subtest: vecs0
[467.019986] Dynamic subtest vecs0: SUCCESS (0.083s)
[467.022359] Subtest engine-engine-error: SUCCESS (0.262s)
[467.137574] [122/137] (570s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[467.456712] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[467.481562] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.019s)
[467.604591] [123/137] (570s left) kms_psr (sprite_plane_move)
[467.808950] Subtest sprite_plane_move: SKIP (0.000s)
[467.871374] [124/137] (570s left) gem_eio (in-flight-10ms)
[468.086966] Starting subtest: in-flight-10ms
[469.043347] Subtest in-flight-10ms: SUCCESS (0.959s)
[469.221901] [125/137] (568s left) vc4/vc4_purgeable_bo (mark-unpurgeable-twice)
[469.478025] Subtest mark-unpurgeable-twice: SKIP (0.000s)
[469.554821] [126/137] (568s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[469.757843] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[469.866651] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.108s)
[469.954384] [127/137] (568s left) kms_plane (pixel-format-source-clamping)
[470.256275] Starting subtest: pixel-format-source-clamping
[470.258370] Starting dynamic subtest: pipe-A-planes
[476.642515] Dynamic subtest pipe-A-planes: SUCCESS (6.384s)
[476.679114] Starting dynamic subtest: pipe-B-planes
[483.215988] Dynamic subtest pipe-B-planes: SUCCESS (6.565s)
[483.218066] Subtest pixel-format-source-clamping: SUCCESS (12.962s)
[483.554062] [128/137] (554s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[483.854807] Starting subtest: cursorA-vs-flipA-toggle
[494.890910] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.039s)
[495.229243] [129/137] (543s left) kms_cursor_crc (cursor-dpms)
[495.539096] Starting subtest: cursor-dpms
[495.541362] Starting dynamic subtest: pipe-A-DP-1
[496.934323] Dynamic subtest pipe-A-DP-1: SUCCESS (1.391s)
[496.963648] Starting dynamic subtest: pipe-C-DP-1
[498.661906] Dynamic subtest pipe-C-DP-1: SUCCESS (1.721s)
[498.663926] Subtest cursor-dpms: SUCCESS (3.123s)
[499.009240] [130/137] (539s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[499.305977] Starting subtest: multiplane-rotation-cropping-bottom
[513.311953] Subtest multiplane-rotation-cropping-bottom: SUCCESS (14.011s)
[513.422682] [131/137] (525s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[513.735666] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[513.739761] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[513.839094] [132/137] (524s left) gem_exec_params (dr1-dirt)
[514.045719] Starting subtest: DR1-dirt
[514.047971] Subtest DR1-dirt: SUCCESS (0.001s)
[514.156592] [133/137] (524s left) gem_eio (wait-wedge-1us)
[514.379714] Starting subtest: wait-wedge-1us
[514.448479] Subtest wait-wedge-1us: SUCCESS (0.072s)
[514.638428] [134/137] (523s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[514.943714] Starting subtest: cursorA-vs-flipA-atomic-transitions
[526.032296] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.086s)
[526.367721] [135/137] (512s left) v3d/v3d_submit_cl (single-in-sync)
[526.638567] Subtest single-in-sync: SKIP (0.000s)
[526.715342] [136/137] (511s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[527.034856] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[528.385978] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (1.351s)
[528.733941] [137/137] (510s left) gem_lmem_swapping (heavy-verify-random-ccs)
[528.945460] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[528.993927] Closing watchdogs
Done.