[42.416228] Initializing watchdogs
[42.416275]   /dev/watchdog0
[42.423202] [001/142] (960s left) kms_ccs (pipe-b-bad-rotation-90-4_tiled_dg2_rc_ccs_cc)
[42.830175] Starting subtest: pipe-B-bad-rotation-90-4_tiled_dg2_rc_ccs_cc
[42.835902] Subtest pipe-B-bad-rotation-90-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[43.712734] [002/142] (959s left) syncobj_wait (invalid-reset-one-illegal-handle)
[43.769219] Starting subtest: invalid-reset-one-illegal-handle
[43.771667] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[43.825585] [003/142] (959s left) gem_exec_reloc (basic-concurrent0)
[43.906238] Subtest basic-concurrent0: SKIP (0.000s)
[43.959609] [004/142] (959s left) gem_exec_reloc (basic-write-read-active)
[44.021209] Subtest basic-write-read-active: SKIP (0.000s)
[44.074037] [005/142] (958s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[44.181374] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[47.438674] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (3.260s)
[47.562675] [006/142] (955s left) kms_flip (2x-flip-vs-panning-interruptible)
[47.626104] Starting subtest: 2x-flip-vs-panning-interruptible
[47.640082] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.014s)
[47.695613] [007/142] (955s left) core_getclient
[47.793454] [008/142] (955s left) kms_flip (flip-vs-blocking-wf-vblank)
[47.858139] Starting subtest: flip-vs-blocking-wf-vblank
[47.864507] Starting dynamic subtest: A-eDP1
[56.932101] Dynamic subtest A-eDP1: SUCCESS (9.067s)
[56.943381] Starting dynamic subtest: B-eDP1
[65.955342] Dynamic subtest B-eDP1: SUCCESS (9.023s)
[65.966037] Starting dynamic subtest: C-eDP1
[74.970385] Dynamic subtest C-eDP1: SUCCESS (9.012s)
[74.983932] Starting dynamic subtest: D-eDP1
[83.993776] Dynamic subtest D-eDP1: SUCCESS (9.025s)
[84.001208] Subtest flip-vs-blocking-wf-vblank: SUCCESS (36.145s)
[85.249719] [009/142] (917s left) gem_flink_basic (bad-flink)
[85.309923] Starting subtest: bad-flink
[85.312741] Subtest bad-flink: SUCCESS (0.000s)
[85.369150] [010/142] (917s left) prime_mmap_coherency (write)
[85.415648] Starting subtest: write
[90.791083] Subtest write: SUCCESS (5.374s)
[91.022034] [011/142] (912s left) kms_ccs (pipe-c-random-ccs-data-yf_tiled_ccs)
[91.441366] Starting subtest: pipe-C-random-ccs-data-yf_tiled_ccs
[91.449086] Subtest pipe-C-random-ccs-data-yf_tiled_ccs: SKIP (0.000s)
[92.255073] [012/142] (910s left) gem_userptr_blits (stress-mm)
[92.319913] Starting subtest: stress-mm
[97.687351] Subtest stress-mm: SUCCESS (5.370s)
[97.788730] [013/142] (905s left) kms_ccs (pipe-b-crc-primary-rotation-180-y_tiled_ccs)
[98.182894] Starting subtest: pipe-B-crc-primary-rotation-180-y_tiled_ccs
[98.188534] Subtest pipe-B-crc-primary-rotation-180-y_tiled_ccs: SKIP (0.000s)
[99.073629] [014/142] (904s left) kms_getfb (getfb-handle-zero)
[99.145243] Starting subtest: getfb-handle-zero
[99.147323] Subtest getfb-handle-zero: SUCCESS (0.000s)
[99.229480] [015/142] (903s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[99.320033] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[99.324592] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[99.399573] [016/142] (903s left) syncobj_timeline (single-wait-available-signaled)
[99.457272] Starting subtest: single-wait-available-signaled
[99.459357] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[99.514583] [017/142] (903s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-wc)
[99.632797] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-wc
[104.292315] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (4.664s)
[104.418776] [018/142] (898s left) vgem_basic (dmabuf-export)
[104.524117] Starting subtest: dmabuf-export
[104.528943] Subtest dmabuf-export: SUCCESS (0.002s)
[104.605254] [019/142] (898s left) kms_vblank (pipe-a-ts-continuation-dpms-suspend)
[104.672186] Starting subtest: pipe-A-ts-continuation-dpms-suspend
[122.615481] Subtest pipe-A-ts-continuation-dpms-suspend: SUCCESS (1.946s)
[123.509109] [020/142] (895s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[123.601151] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[123.605831] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[123.683825] [021/142] (895s left) kms_plane_multiple (tiling-none)
[123.767996] Starting subtest: tiling-none
[123.770031] Starting dynamic subtest: pipe-A-eDP-1
[127.858175] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.089s)
[127.870901] Starting dynamic subtest: pipe-B-eDP-1
[132.710760] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.852s)
[132.721271] Starting dynamic subtest: pipe-C-eDP-1
[137.554159] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.839s)
[137.566986] Starting dynamic subtest: pipe-D-eDP-1
[142.406578] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.850s)
[142.408731] Subtest tiling-none: SUCCESS (18.637s)
[143.284690] [022/142] (876s left) i915_pm_rpm (legacy-planes-dpms)
[145.637871] Starting subtest: legacy-planes-dpms
[145.640696] Starting dynamic subtest: plane-40
[173.239771] Dynamic subtest plane-40: SUCCESS (27.602s)
[173.252431] Starting dynamic subtest: plane-49
[197.629934] Dynamic subtest plane-49: SUCCESS (24.389s)
[197.643559] Starting dynamic subtest: plane-58
[221.900096] Dynamic subtest plane-58: SUCCESS (24.268s)
[221.914328] Starting dynamic subtest: plane-67
[249.971090] Dynamic subtest plane-67: SUCCESS (28.069s)
[249.973677] Subtest legacy-planes-dpms: SUCCESS (104.333s)
[251.110414] [023/142] (768s left) kms_cursor_crc (cursor-alpha-opaque)
[251.181416] Starting subtest: cursor-alpha-opaque
[251.183925] Starting dynamic subtest: pipe-A-eDP-1
[251.879425] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.699s)
[251.891952] Starting dynamic subtest: pipe-D-eDP-1
[253.302019] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.420s)
[253.304627] Subtest cursor-alpha-opaque: SUCCESS (2.123s)
[254.193405] [024/142] (765s left) i915_pm_rc6_residency (rc6-fence)
[254.239787] Starting subtest: rc6-fence
[280.449928] Subtest rc6-fence: SUCCESS (26.212s)
[281.762278] [025/142] (737s left) kms_ccs (pipe-c-ccs-on-another-bo-y_tiled_gen12_mc_ccs)
[282.169658] Starting subtest: pipe-C-ccs-on-another-bo-y_tiled_gen12_mc_ccs
[282.175127] Subtest pipe-C-ccs-on-another-bo-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[283.009609] [026/142] (736s left) api_intel_bb (object-noreloc-purge-cache-simple)
[283.075063] Starting subtest: object-noreloc-purge-cache-simple
[283.077366] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.005s)
[283.156664] [027/142] (736s left) kms_cursor_edge_walk (256x256-right-edge)
[283.223358] Starting subtest: 256x256-right-edge
[283.225898] Starting dynamic subtest: pipe-A-eDP-1
[286.773069] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.549s)
[286.786732] Starting dynamic subtest: pipe-D-eDP-1
[290.019327] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.242s)
[290.022189] Subtest 256x256-right-edge: SUCCESS (6.795s)
[290.949574] [028/142] (728s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc)
[291.016392] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc
[295.556742] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (4.544s)
[295.687101] [029/142] (723s left) syncobj_basic (bad-fd-to-handle)
[295.750379] Starting subtest: bad-fd-to-handle
[295.752416] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[295.812259] [030/142] (723s left) kms_addfb_basic (bad-pitch-256)
[295.877410] Starting subtest: bad-pitch-256
[295.879920] Subtest bad-pitch-256: SUCCESS (0.000s)
[295.986915] [031/142] (723s left) drm_fdinfo (virtual-busy)
[296.052312] Starting subtest: virtual-busy
[296.056532] Subtest virtual-busy: SKIP (0.000s)
[296.113780] [032/142] (723s left) kms_ccs (pipe-a-random-ccs-data-4_tiled_dg2_rc_ccs)
[296.479945] Starting subtest: pipe-A-random-ccs-data-4_tiled_dg2_rc_ccs
[296.487854] Subtest pipe-A-random-ccs-data-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[298.551380] [033/142] (721s left) kms_pm_dc (dc5-dpms-negative)
[299.658929] Starting subtest: dc5-dpms-negative
[299.663425] Subtest dc5-dpms-negative: SKIP (0.000s)
[299.723304] [034/142] (719s left) gem_exec_balancer (invalid-bonds)
[299.782428] Starting subtest: invalid-bonds
[299.786828] Subtest invalid-bonds: SKIP (0.000s)
[300.030609] [035/142] (719s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[300.091690] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[300.096906] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[300.271157] [036/142] (719s left) kms_properties (get_properties-sanity-atomic)
[300.356281] Starting subtest: get_properties-sanity-atomic
[300.358806] Subtest get_properties-sanity-atomic: SUCCESS (0.003s)
[300.421088] [037/142] (719s left) perf (unprivileged-single-ctx-counters)
[300.576018] Starting subtest: unprivileged-single-ctx-counters
[300.580574] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[300.604794] [038/142] (719s left) kms_ccs (pipe-a-crc-primary-basic-yf_tiled_ccs)
[300.967546] Starting subtest: pipe-A-crc-primary-basic-yf_tiled_ccs
[300.972367] Subtest pipe-A-crc-primary-basic-yf_tiled_ccs: SKIP (0.001s)
[301.890559] [039/142] (717s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[301.979996] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[301.984478] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[302.062102] [040/142] (717s left) prime_vgem (fence-write-hang)
[302.140859] Subtest fence-write-hang: SKIP (0.000s)
[302.225535] [041/142] (717s left) gem_ctx_sseu (engines)
[302.285112] Subtest engines: SKIP (0.000s)
[302.309662] [042/142] (717s left) kms_pm_backlight (fade)
[302.409888] Starting subtest: fade
[302.463174] Starting dynamic subtest: eDP-1
[305.135775] Dynamic subtest eDP-1: SUCCESS (2.671s)
[305.138335] Subtest fade: SUCCESS (2.725s)
[306.051499] [043/142] (713s left) kms_plane_scaling (plane-downscale-with-rotation-factor-0-5)
[306.108318] Starting subtest: plane-downscale-with-rotation-factor-0-5
[306.110861] Starting dynamic subtest: pipe-A-eDP-1
[306.131576] Dynamic subtest pipe-A-eDP-1: SKIP (0.021s)
[306.138444] Starting dynamic subtest: pipe-B-eDP-1
[306.172387] Dynamic subtest pipe-B-eDP-1: SKIP (0.041s)
[306.179249] Starting dynamic subtest: pipe-C-eDP-1
[306.202891] Dynamic subtest pipe-C-eDP-1: SKIP (0.029s)
[306.208938] Starting dynamic subtest: pipe-D-eDP-1
[306.245890] Dynamic subtest pipe-D-eDP-1: SKIP (0.044s)
[306.250503] Subtest plane-downscale-with-rotation-factor-0-5: SKIP (0.138s)
[306.343116] [044/142] (713s left) kms_cursor_crc (cursor-onscreen-32x10)
[306.437804] Starting subtest: cursor-onscreen-32x10
[306.480395] Subtest cursor-onscreen-32x10: SKIP (0.038s)
[306.668018] [045/142] (713s left) kms_writeback (writeback-fb-id)
[306.766898] Subtest writeback-fb-id: SKIP (0.000s)
[306.783006] [046/142] (713s left) syncobj_wait (single-wait-all-for-submit-signaled)
[306.832054] Starting subtest: single-wait-all-for-submit-signaled
[306.833977] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[306.891708] [047/142] (713s left) kms_addfb_basic (bad-pitch-128)
[306.952615] Starting subtest: bad-pitch-128
[306.955166] Subtest bad-pitch-128: SUCCESS (0.000s)
[307.056011] [048/142] (713s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[307.102917] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[307.104725] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[307.150500] [049/142] (712s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[307.241318] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[307.244529] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[307.325716] [050/142] (712s left) syncobj_basic (create-signaled)
[307.369751] Starting subtest: create-signaled
[307.371408] Subtest create-signaled: SUCCESS (0.000s)
[307.417150] [051/142] (712s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[307.495852] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[307.499586] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[307.579303] [052/142] (712s left) kms_ccs (pipe-a-bad-pixel-format-4_tiled_dg2_rc_ccs)
[307.646238] Starting subtest: pipe-A-bad-pixel-format-4_tiled_dg2_rc_ccs
[307.650387] Subtest pipe-A-bad-pixel-format-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[308.867443] [053/142] (711s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[308.944709] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[308.961012] [054/142] (711s left) gem_exec_fair (basic-none-vip)
[309.020955] Subtest basic-none-vip: SKIP (0.000s)
[309.057213] [055/142] (711s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[309.153004] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[309.937939] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.786s)
[310.145571] [056/142] (710s left) kms_psr2_sf (overlay-plane-move-continuous-sf)
[315.376886] Starting subtest: overlay-plane-move-continuous-sf
[315.379170] Starting dynamic subtest: pipe-A-eDP-1
[322.158323] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.777s)
[322.176088] Starting dynamic subtest: pipe-B-eDP-1
[328.950075] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.790s)
[328.952698] Subtest overlay-plane-move-continuous-sf: SUCCESS (13.574s)
[329.860011] [057/142] (690s left) kms_ccs (pipe-c-bad-pixel-format-4_tiled_mtl_rc_ccs)
[330.313687] Starting subtest: pipe-C-bad-pixel-format-4_tiled_mtl_rc_ccs
[330.316919] Subtest pipe-C-bad-pixel-format-4_tiled_mtl_rc_ccs: SUCCESS (0.000s)
[331.147129] [058/142] (689s left) kms_ccs (pipe-c-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc)
[331.570156] Starting subtest: pipe-C-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc
[331.576735] Subtest pipe-C-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[332.417221] [059/142] (687s left) v3d/v3d_submit_cl (bad-multisync-in-sync)
[332.512100] Subtest bad-multisync-in-sync: SKIP (0.000s)
[332.560875] [060/142] (687s left) kms_properties (connector-properties-legacy)
[332.643376] Starting subtest: connector-properties-legacy
[341.135263] Subtest connector-properties-legacy: SUCCESS (8.487s)
[342.014153] [061/142] (678s left) gem_exec_schedule (manyslice)
[342.093607] Starting subtest: manyslice
[342.095992] Starting dynamic subtest: rcs0
[344.440554] Dynamic subtest rcs0: SUCCESS (2.351s)
[344.454843] Starting dynamic subtest: bcs0
[347.127253] Dynamic subtest bcs0: SUCCESS (2.685s)
[347.141651] Starting dynamic subtest: vcs0
[350.633580] Dynamic subtest vcs0: SUCCESS (3.504s)
[350.651335] Starting dynamic subtest: vcs1
[354.645476] Dynamic subtest vcs1: SUCCESS (4.010s)
[354.661015] Starting dynamic subtest: vecs0
[358.143331] Dynamic subtest vecs0: SUCCESS (3.495s)
[358.157396] Starting dynamic subtest: ccs0
[360.890113] Dynamic subtest ccs0: SUCCESS (2.746s)
[360.892641] Subtest manyslice: SUCCESS (18.802s)
[361.199495] [062/142] (659s left) gen7_exec_parse (basic-rejected)
[361.255408] Subtest basic-rejected: SKIP (0.000s)
[361.294741] [063/142] (659s left) vc4/vc4_label_bo (set-kernel-name)
[361.369454] Subtest set-kernel-name: SKIP (0.000s)
[361.413993] [064/142] (659s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[361.468143] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[361.569866] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[361.641361] [065/142] (658s left) gem_eio (unwedge-stress)
[361.884842] Starting subtest: unwedge-stress
[421.414518] Subtest unwedge-stress: SUCCESS (59.527s)
[423.519960] [066/142] (597s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_dg2_rc_ccs_cc)
[423.922665] Starting subtest: pipe-B-random-ccs-data-4_tiled_dg2_rc_ccs_cc
[423.931740] Subtest pipe-B-random-ccs-data-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[424.836099] [067/142] (595s left) kms_addfb_basic (basic)
[424.890901] Starting subtest: basic
[424.893420] Subtest basic: SUCCESS (0.000s)
[425.007406] [068/142] (595s left) kms_ccs (pipe-d-crc-primary-basic-y_tiled_gen12_rc_ccs)
[425.412637] Starting subtest: pipe-D-crc-primary-basic-y_tiled_gen12_rc_ccs
[425.418202] Subtest pipe-D-crc-primary-basic-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[426.296458] [069/142] (594s left) v3d/v3d_create_bo (create-bo-0)
[426.388275] Subtest create-bo-0: SKIP (0.000s)
[426.436254] [070/142] (594s left) kms_plane_alpha_blend (constant-alpha-min)
[426.488925] Starting subtest: constant-alpha-min
[426.723822] Starting dynamic subtest: pipe-A-eDP-1
[427.517183] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.790s)
[427.532233] Starting dynamic subtest: pipe-D-eDP-1
[429.175862] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.655s)
[429.178397] Subtest constant-alpha-min: SUCCESS (2.686s)
[430.071659] [071/142] (590s left) kms_psr (psr2_primary_page_flip)
[430.161809] Starting subtest: psr2_primary_page_flip
[431.972008] Subtest psr2_primary_page_flip: SUCCESS (1.811s)
[432.899946] [072/142] (587s left) gem_wait (invalid-buf)
[432.964408] Starting subtest: invalid-buf
[432.967025] Subtest invalid-buf: SUCCESS (0.000s)
[433.188669] [073/142] (587s left) kms_chamelium_frames (dp-frame-dump)
[433.562533] Subtest dp-frame-dump: SKIP (0.000s)
[434.462395] [074/142] (586s left) gem_exec_whisper (basic-sync-all)
[434.522876] Starting subtest: basic-sync-all
[444.593107] Subtest basic-sync-all: SUCCESS (10.071s)
[444.774658] [075/142] (576s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[444.848265] Starting subtest: y-tiled-8bpp-rotate-90
[444.852137] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[444.939252] [076/142] (575s left) kms_invalid_mode (bad-vsync-end)
[445.000773] Starting subtest: bad-vsync-end
[445.003242] Starting dynamic subtest: eDP-1-pipe-A
[445.283241] Dynamic subtest eDP-1-pipe-A: SUCCESS (0.283s)
[445.298858] Starting dynamic subtest: eDP-1-pipe-B
[445.301575] Dynamic subtest eDP-1-pipe-B: SUCCESS (0.001s)
[445.316987] Starting dynamic subtest: eDP-1-pipe-C
[445.319966] Dynamic subtest eDP-1-pipe-C: SUCCESS (0.001s)
[445.335871] Starting dynamic subtest: eDP-1-pipe-D
[445.338725] Dynamic subtest eDP-1-pipe-D: SUCCESS (0.001s)
[445.341477] Subtest bad-vsync-end: SUCCESS (0.295s)
[446.201834] [077/142] (574s left) gem_ctx_persistence (engines-hang)
[446.252110] Starting subtest: engines-hang
[446.255070] Starting dynamic subtest: rcs0
[446.293461] Dynamic subtest rcs0: SUCCESS (0.042s)
[446.308792] Starting dynamic subtest: bcs0
[446.337897] Dynamic subtest bcs0: SUCCESS (0.044s)
[446.352665] Starting dynamic subtest: vcs0
[447.212010] Dynamic subtest vcs0: FAIL (0.818s)
[447.226738] Starting dynamic subtest: vcs1
[449.624237] Dynamic subtest vcs1: SUCCESS (2.465s)
[449.639838] Starting dynamic subtest: vecs0
[449.704197] Dynamic subtest vecs0: SUCCESS (0.079s)
[449.719636] Starting dynamic subtest: ccs0
[449.777707] Dynamic subtest ccs0: SUCCESS (0.073s)
[449.780308] Subtest engines-hang: FAIL (3.528s)
[449.853571] [078/142] (571s left) gem_mmap_offset (bad-extensions)
[449.910743] Starting subtest: bad-extensions
[449.912783] Subtest bad-extensions: SUCCESS (0.000s)
[450.000063] [079/142] (570s left) gem_tiled_pread_basic
[450.093141] [080/142] (570s left) kms_psr (primary_blt)
[450.181165] Starting subtest: primary_blt
[452.001030] Subtest primary_blt: SUCCESS (1.818s)
[452.933966] [081/142] (568s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_dg2_rc_ccs)
[453.323291] Starting subtest: pipe-D-bad-rotation-90-4_tiled_dg2_rc_ccs
[453.329720] Subtest pipe-D-bad-rotation-90-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[454.213133] [082/142] (566s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[454.304108] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[459.140593] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (4.838s)
[459.255263] [083/142] (561s left) syncobj_timeline (invalid-signal-zero-handles)
[459.312940] Starting subtest: invalid-signal-zero-handles
[459.315803] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[459.366473] [084/142] (561s left) kms_ccs (pipe-d-random-ccs-data-y_tiled_gen12_rc_ccs)
[459.782461] Starting subtest: pipe-D-random-ccs-data-y_tiled_gen12_rc_ccs
[459.791224] Subtest pipe-D-random-ccs-data-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[460.619711] [085/142] (560s left) i915_pm_rpm (modeset-stress-extra-wait)
[462.650391] Starting subtest: modeset-stress-extra-wait
[519.190934] Subtest modeset-stress-extra-wait: SUCCESS (56.541s)
[519.276604] [086/142] (501s left) kms_force_connector_basic (prune-stale-modes)
[519.351263] Starting subtest: prune-stale-modes
[519.589959] Subtest prune-stale-modes: SKIP (0.239s)
[519.693939] [087/142] (501s left) prime_vgem (busy)
[519.768475] Starting subtest: busy
[519.771562] Starting dynamic subtest: rcs0
[519.811076] Dynamic subtest rcs0: SUCCESS (0.042s)
[519.824676] Starting dynamic subtest: bcs0
[519.861168] Dynamic subtest bcs0: SUCCESS (0.049s)
[519.870426] Starting dynamic subtest: vcs0
[519.911848] Dynamic subtest vcs0: SUCCESS (0.048s)
[519.921641] Starting dynamic subtest: vcs1
[519.939782] Dynamic subtest vcs1: SUCCESS (0.028s)
[519.949080] Starting dynamic subtest: vecs0
[519.965976] Dynamic subtest vecs0: SUCCESS (0.023s)
[519.978279] Starting dynamic subtest: ccs0
[519.995456] Dynamic subtest ccs0: SUCCESS (0.031s)
[519.998072] Subtest busy: SUCCESS (0.227s)
[520.107766] [088/142] (501s left) gem_spin_batch (resubmit-new-all)
[520.157825] Starting subtest: resubmit-new-all
[520.160363] Starting dynamic subtest: rcs0
[520.162920] Dynamic subtest rcs0: SUCCESS (0.005s)
[520.180397] Starting dynamic subtest: bcs0
[520.182907] Dynamic subtest bcs0: SUCCESS (0.002s)
[520.195046] Starting dynamic subtest: vcs0
[520.197396] Dynamic subtest vcs0: SUCCESS (0.002s)
[520.206686] Starting dynamic subtest: vcs1
[520.209093] Dynamic subtest vcs1: SUCCESS (0.002s)
[520.216919] Starting dynamic subtest: vecs0
[520.218832] Dynamic subtest vecs0: SUCCESS (0.002s)
[520.225687] Starting dynamic subtest: ccs0
[520.227577] Dynamic subtest ccs0: SUCCESS (0.002s)
[520.229416] Subtest resubmit-new-all: SUCCESS (0.018s)
[521.504643] [089/142] (499s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[521.584481] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[521.589137] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[521.674632] [090/142] (499s left) gem_mmap_wc (read-write)
[521.746542] Subtest read-write: SKIP (0.000s)
[521.771525] [091/142] (499s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[521.883986] Starting subtest: short-flip-after-cursor-atomic-transitions
[522.845438] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.960s)
[523.780514] [092/142] (497s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[523.855314] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[523.859333] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[523.937296] [093/142] (497s left) kms_async_flips (test-cursor)
[524.022395] Starting subtest: test-cursor
[524.026298] Subtest test-cursor: SKIP (0.000s)
[525.316707] [094/142] (496s left) gem_exec_balancer (bonded-sync)
[525.382067] Starting subtest: bonded-sync
[525.386864] Subtest bonded-sync: SKIP (0.000s)
[525.633847] [095/142] (495s left) gem_mmap_gtt (close-race)
[525.680992] Subtest close-race: SKIP (0.000s)
[525.712633] [096/142] (495s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[525.786566] Starting subtest: yf-tiled-32bpp-rotate-180
[525.791000] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[525.860432] [097/142] (495s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[525.935505] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[526.569228] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.636s)
[526.725054] [098/142] (494s left) kms_addfb_basic (addfb25-4-tiled)
[526.791947] Starting subtest: addfb25-4-tiled
[526.793985] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[526.879583] [099/142] (494s left) perf (gen12-oa-tlb-invalidate)
[527.005894] Starting subtest: gen12-oa-tlb-invalidate
[527.008842] Starting dynamic subtest: 0-rcs0
[537.038647] Dynamic subtest 0-rcs0: SUCCESS (10.032s)
[537.050210] Starting dynamic subtest: 1-vcs1
[547.058594] Dynamic subtest 1-vcs1: SUCCESS (10.019s)
[547.062307] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.052s)
[547.097295] [100/142] (474s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[547.183309] Starting subtest: x-tiled-64bpp-rotate-0
[548.728922] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.548s)
[548.963230] [101/142] (472s left) kms_lease (lease_invalid_connector)
[549.053465] Starting subtest: lease_invalid_connector
[549.055950] Starting dynamic subtest: pipe-A-eDP-1
[549.057986] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[549.072633] Starting dynamic subtest: pipe-B-eDP-1
[549.074723] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[549.085892] Starting dynamic subtest: pipe-C-eDP-1
[549.088230] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[549.097125] Starting dynamic subtest: pipe-D-eDP-1
[549.099442] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[549.101749] Subtest lease_invalid_connector: SUCCESS (0.003s)
[549.119728] [102/142] (472s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[549.174175] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[553.879899] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (4.709s)
[554.019009] [103/142] (467s left) kms_flip (2x-flip-vs-wf_vblank)
[554.074538] Starting subtest: 2x-flip-vs-wf_vblank
[554.096772] Subtest 2x-flip-vs-wf_vblank: SKIP (0.022s)
[554.169492] [104/142] (467s left) gem_exec_schedule (semaphore-user)
[554.231609] Starting subtest: semaphore-user
[554.241420] Subtest semaphore-user: SUCCESS (0.012s)
[555.488520] [105/142] (466s left) gem_softpin (full)
[555.550759] Starting subtest: full
[555.556271] Subtest full: SUCCESS (0.006s)
[555.658809] [106/142] (466s left) gem_ctx_isolation (dirty-create)
[555.710534] Starting subtest: dirty-create
[555.713048] Starting dynamic subtest: rcs0
[555.829528] Dynamic subtest rcs0: SUCCESS (0.119s)
[555.848190] Starting dynamic subtest: bcs0
[556.004571] Dynamic subtest bcs0: SUCCESS (0.174s)
[556.019053] Starting dynamic subtest: vcs0
[556.148888] Dynamic subtest vcs0: SUCCESS (0.144s)
[556.164765] Starting dynamic subtest: vcs1
[557.574896] Dynamic subtest vcs1: SUCCESS (1.426s)
[557.592380] Starting dynamic subtest: vecs0
[559.641706] Dynamic subtest vecs0: SUCCESS (2.066s)
[559.648704] Starting dynamic subtest: ccs0
[561.615415] Dynamic subtest ccs0: SUCCESS (1.973s)
[561.618246] Subtest dirty-create: SUCCESS (5.905s)
[561.858808] [107/142] (459s left) kms_addfb_basic (addfb25-bad-modifier)
[561.914285] Starting subtest: addfb25-bad-modifier
[561.917326] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[562.013520] [108/142] (459s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[562.103547] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[567.329984] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (5.229s)
[567.442785] [109/142] (454s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[567.527862] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[567.532165] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[567.613884] [110/142] (454s left) gem_bad_reloc (negative-reloc)
[567.682529] Subtest negative-reloc: SKIP (0.000s)
[567.748449] [111/142] (454s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[567.817958] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[567.820417] Starting dynamic subtest: pipe-A-default-mode
[570.719107] Dynamic subtest pipe-A-default-mode: SUCCESS (2.899s)
[570.721642] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.901s)
[571.651942] [112/142] (450s left) gem_close (many-handles-one-vma)
[571.712920] Starting subtest: many-handles-one-vma
[571.735412] Subtest many-handles-one-vma: SUCCESS (0.022s)
[571.820398] [113/142] (450s left) kms_flip (2x-plain-flip-ts-check)
[571.868693] Starting subtest: 2x-plain-flip-ts-check
[571.880721] Subtest 2x-plain-flip-ts-check: SKIP (0.014s)
[571.946987] [114/142] (449s left) kms_dirtyfb (dirtyfb-ioctl)
[572.003028] Starting subtest: dirtyfb-ioctl
[572.005592] Starting dynamic subtest: default-eDP-1
[573.618383] Dynamic subtest default-eDP-1: SUCCESS (1.615s)
[573.634774] Starting dynamic subtest: drrs-eDP-1
[573.639246] Dynamic subtest drrs-eDP-1: SKIP (0.001s)
[573.653665] Starting dynamic subtest: fbc-eDP-1
[575.976209] Dynamic subtest fbc-eDP-1: SUCCESS (2.354s)
[575.991066] Starting dynamic subtest: psr-eDP-1
[578.470450] Dynamic subtest psr-eDP-1: SUCCESS (2.496s)
[578.473159] Subtest dirtyfb-ioctl: SUCCESS (6.470s)
[579.394747] [115/142] (442s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[579.480161] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[579.482613] Starting dynamic subtest: pipe-A-default-mode
[579.772280] Dynamic subtest pipe-A-default-mode: SKIP (0.288s)
[579.777240] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.290s)
[580.670677] [116/142] (441s left) gem_mmap_gtt (big-copy-xy)
[580.725757] Subtest big-copy-XY: SKIP (0.000s)
[580.758958] [117/142] (441s left) syncobj_timeline (invalid-wait-illegal-handle)
[580.808933] Starting subtest: invalid-wait-illegal-handle
[580.811421] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[580.860198] [118/142] (441s left) gem_exec_whisper (basic-fds-all)
[580.942589] Starting subtest: basic-fds-all
[599.390539] Subtest basic-fds-all: SUCCESS (18.445s)
[599.571951] [119/142] (422s left) perf_pmu (render-node-busy)
[599.626105] Starting subtest: render-node-busy
[599.628601] Starting dynamic subtest: rcs0
[600.226417] Dynamic subtest rcs0: FAIL (0.551s)
[600.241927] Starting dynamic subtest: bcs0
[600.779657] Dynamic subtest bcs0: FAIL (0.556s)
[600.794896] Starting dynamic subtest: vcs0
[601.373924] Dynamic subtest vcs0: SUCCESS (0.639s)
[601.390625] Starting dynamic subtest: vcs1
[603.419887] Dynamic subtest vcs1: SUCCESS (2.043s)
[603.436977] Starting dynamic subtest: vecs0
[605.403972] Dynamic subtest vecs0: SUCCESS (1.982s)
[605.421936] Starting dynamic subtest: ccs0
[605.994120] Dynamic subtest ccs0: FAIL (0.532s)
[605.996251] Subtest render-node-busy: FAIL (6.312s)
[606.022030] [120/142] (416s left) kms_color (ctm-0-25)
[606.113897] Starting subtest: ctm-0-25
[606.116326] Starting dynamic subtest: pipe-A
[609.753333] Dynamic subtest pipe-A: SUCCESS (3.641s)
[609.769994] Starting dynamic subtest: pipe-B
[614.213545] Dynamic subtest pipe-B: SUCCESS (4.460s)
[614.236593] Starting dynamic subtest: pipe-C
[618.421661] Dynamic subtest pipe-C: SUCCESS (4.206s)
[618.439027] Starting dynamic subtest: pipe-D
[622.623656] Dynamic subtest pipe-D: SUCCESS (4.200s)
[622.626314] Subtest ctm-0-25: SUCCESS (16.513s)
[623.554414] [121/142] (398s left) gem_exec_suspend (basic-s3)
[623.615736] Starting subtest: basic-S3
[623.618284] Starting dynamic subtest: smem
[643.989076] Dynamic subtest smem: SUCCESS (6.813s)
[643.991896] Subtest basic-S3: SUCCESS (6.814s)
[644.169364] [122/142] (391s left) gem_exec_fence (syncobj-timeline-chain-engines)
[644.732448] Starting subtest: syncobj-timeline-chain-engines
[644.782125] Subtest syncobj-timeline-chain-engines: SUCCESS (0.051s)
[646.097579] [123/142] (389s left) perf (low-oa-exponent-permissions)
[646.204557] Starting subtest: low-oa-exponent-permissions
[646.243492] Subtest low-oa-exponent-permissions: SUCCESS (0.037s)
[646.273547] [124/142] (389s left) kms_vblank (pipe-a-wait-forked-busy-hang)
[646.323899] Starting subtest: pipe-A-wait-forked-busy-hang
[657.038234] Subtest pipe-A-wait-forked-busy-hang: SUCCESS (10.715s)
[657.982635] [125/142] (377s left) kms_flip (dpms-off-confusion-interruptible)
[658.029040] Starting subtest: dpms-off-confusion-interruptible
[658.034391] Starting dynamic subtest: A-eDP1
[666.813702] Dynamic subtest A-eDP1: SUCCESS (8.782s)
[666.831264] Starting dynamic subtest: B-eDP1
[675.569329] Dynamic subtest B-eDP1: SUCCESS (8.753s)
[675.587549] Starting dynamic subtest: C-eDP1
[684.325302] Dynamic subtest C-eDP1: SUCCESS (8.755s)
[684.341896] Starting dynamic subtest: D-eDP1
[693.097250] Dynamic subtest D-eDP1: SUCCESS (8.770s)
[693.105991] Subtest dpms-off-confusion-interruptible: SUCCESS (35.077s)
[694.399151] [126/142] (341s left) kms_ccs (pipe-a-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc)
[694.773239] Starting subtest: pipe-A-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc
[694.779120] Subtest pipe-A-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[695.681593] [127/142] (340s left) v3d/v3d_perfmon (get-values-invalid-pointer)
[695.773960] Subtest get-values-invalid-pointer: SKIP (0.000s)
[695.826182] [128/142] (340s left) vc4/vc4_tiling (get-bad-modifier)
[695.917529] Subtest get-bad-modifier: SKIP (0.000s)
[695.969109] [129/142] (339s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[696.056428] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[697.146743] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.090s)
[697.314705] [130/142] (338s left) kms_busy (extended-modeset-hang-oldfb)
[697.400794] Starting subtest: extended-modeset-hang-oldfb
[697.403173] Starting dynamic subtest: pipe-A
[709.166958] Dynamic subtest pipe-A: SUCCESS (11.766s)
[709.188956] Starting dynamic subtest: pipe-D
[721.210418] Dynamic subtest pipe-D: SUCCESS (12.035s)
[721.213074] Subtest extended-modeset-hang-oldfb: SUCCESS (23.811s)
[722.102861] [131/142] (313s left) gem_create (create-ext-cpu-access-sanity-check)
[722.273974] Starting subtest: create-ext-cpu-access-sanity-check
[722.278978] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[722.346463] [132/142] (313s left) kms_ccs (pipe-d-crc-primary-rotation-180-y_tiled_gen12_rc_ccs)
[722.750219] Starting subtest: pipe-D-crc-primary-rotation-180-y_tiled_gen12_rc_ccs
[722.756158] Subtest pipe-D-crc-primary-rotation-180-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[723.636078] [133/142] (312s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[723.717793] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[723.722083] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[723.808305] [134/142] (312s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[723.874467] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[723.876734] Starting dynamic subtest: pipe-A-default-mode
[724.174570] Dynamic subtest pipe-A-default-mode: SKIP (0.298s)
[724.179654] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.300s)
[725.119565] [135/142] (310s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[725.207353] Starting subtest: fbc-1p-pri-indfb-multidraw
[735.258858] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (10.057s)
[735.391964] [136/142] (300s left) kms_chamelium_hpd (vga-hpd)
[735.743906] Subtest vga-hpd: SKIP (0.000s)
[736.601214] [137/142] (299s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[736.687690] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[736.691971] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[736.784635] [138/142] (299s left) kms_vblank (pipe-c-accuracy-idle)
[736.858543] Starting subtest: pipe-C-accuracy-idle
[739.794670] Subtest pipe-C-accuracy-idle: SUCCESS (2.937s)
[740.721357] [139/142] (295s left) v3d/v3d_submit_csd (valid-submission)
[740.815064] Subtest valid-submission: SKIP (0.000s)
[740.861627] [140/142] (295s left) gem_pwrite (basic-random)
[740.922710] Subtest basic-random: SKIP (0.000s)
[740.974092] [141/142] (295s left) gen9_exec_parse (unaligned-jump)
[741.020346] Subtest unaligned-jump: SKIP (0.000s)
[741.044449] [142/142] (295s left) api_intel_bb (simple-bb)
[741.097274] Starting subtest: simple-bb
[741.099362] Subtest simple-bb: SUCCESS (0.005s)
[741.177786] Closing watchdogs
Done.