[29.226342] Initializing watchdogs
[29.226404]   /dev/watchdog0
[29.232290] [001/142] (960s left) kms_ccs (pipe-d-random-ccs-data-4_tiled_dg2_mc_ccs)
[31.359903] Starting subtest: pipe-D-random-ccs-data-4_tiled_dg2_mc_ccs
[31.843988] Subtest pipe-D-random-ccs-data-4_tiled_dg2_mc_ccs: SUCCESS (0.484s)
[31.967454] [002/142] (957s left) gem_ctx_persistence (legacy-engines-mixed)
[32.033577] Starting subtest: legacy-engines-mixed
[32.034389] Starting dynamic subtest: render
[32.109286] Dynamic subtest render: SUCCESS (0.075s)
[32.115247] Starting dynamic subtest: bsd1
[32.148645] Dynamic subtest bsd1: SUCCESS (0.039s)
[32.160384] Starting dynamic subtest: bsd2
[32.192638] Dynamic subtest bsd2: SUCCESS (0.043s)
[32.205258] Starting dynamic subtest: blt
[32.245632] Dynamic subtest blt: SUCCESS (0.052s)
[32.253303] Starting dynamic subtest: vebox
[32.293145] Dynamic subtest vebox: SUCCESS (0.046s)
[32.294492] Subtest legacy-engines-mixed: SUCCESS (0.259s)
[32.394031] [003/142] (957s left) gem_ctx_param (invalid-ctx-get)
[32.473182] Starting subtest: invalid-ctx-get
[32.474146] Subtest invalid-ctx-get: SUCCESS (0.000s)
[32.533394] [004/142] (957s left) gem_userptr_blits (set-cache-level)
[32.600100] Starting subtest: set-cache-level
[32.600949] Subtest set-cache-level: SUCCESS (0.000s)
[32.727457] [005/142] (957s left) kms_flip (2x-modeset-vs-vblank-race)
[33.786378] Starting subtest: 2x-modeset-vs-vblank-race
[33.803543] Subtest 2x-modeset-vs-vblank-race: SKIP (0.018s)
[33.865552] [006/142] (955s left) gem_exec_reloc (basic-write-cpu-active)
[33.957130] Subtest basic-write-cpu-active: SKIP (0.000s)
[34.015441] [007/142] (955s left) kms_ccs (pipe-c-bad-pixel-format-4_tiled_dg2_mc_ccs)
[36.113528] Starting subtest: pipe-C-bad-pixel-format-4_tiled_dg2_mc_ccs
[36.115476] Subtest pipe-C-bad-pixel-format-4_tiled_dg2_mc_ccs: SUCCESS (0.002s)
[36.271472] [008/142] (953s left) kms_content_protection (dp-mst-lic-type-1)
[38.275278] Starting subtest: dp-mst-lic-type-1
[38.276928] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[38.380440] [009/142] (951s left) kms_invalid_mode (bad-vsync-end)
[40.396932] Starting subtest: bad-vsync-end
[40.397733] Starting dynamic subtest: HDMI-A-1-pipe-A
[40.437508] Dynamic subtest HDMI-A-1-pipe-A: SUCCESS (0.041s)
[40.442142] Starting dynamic subtest: HDMI-A-1-pipe-B
[40.445379] Dynamic subtest HDMI-A-1-pipe-B: SUCCESS (0.007s)
[40.450055] Starting dynamic subtest: HDMI-A-1-pipe-C
[40.453268] Dynamic subtest HDMI-A-1-pipe-C: SUCCESS (0.007s)
[40.457622] Starting dynamic subtest: HDMI-A-1-pipe-D
[40.460640] Dynamic subtest HDMI-A-1-pipe-D: SUCCESS (0.007s)
[40.461486] Subtest bad-vsync-end: SUCCESS (0.065s)
[40.553278] [010/142] (949s left) kms_flip (2x-plain-flip-interruptible)
[41.568798] Starting subtest: 2x-plain-flip-interruptible
[41.587065] Subtest 2x-plain-flip-interruptible: SKIP (0.017s)
[41.653265] [011/142] (948s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[43.624980] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[43.626744] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[43.703449] [012/142] (946s left) kms_cursor_crc (cursor-onscreen-512x512)
[45.840396] Starting subtest: cursor-onscreen-512x512
[45.842949] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[46.029974] [013/142] (943s left) gem_exec_schedule (submit-early-slice)
[46.147102] Starting subtest: submit-early-slice
[46.148032] Starting dynamic subtest: rcs0
[46.245717] Dynamic subtest rcs0: SUCCESS (0.099s)
[46.250234] Starting dynamic subtest: bcs0
[46.307495] Dynamic subtest bcs0: SUCCESS (0.062s)
[46.312148] Starting dynamic subtest: vcs0
[46.380929] Dynamic subtest vcs0: SUCCESS (0.073s)
[46.386167] Starting dynamic subtest: vcs1
[46.454201] Dynamic subtest vcs1: SUCCESS (0.073s)
[46.458674] Starting dynamic subtest: vecs0
[46.538205] Dynamic subtest vecs0: SUCCESS (0.084s)
[46.542935] Starting dynamic subtest: vecs1
[46.624732] Dynamic subtest vecs1: SUCCESS (0.086s)
[46.630635] Starting dynamic subtest: ccs0
[46.713338] Dynamic subtest ccs0: SUCCESS (0.088s)
[46.718478] Starting dynamic subtest: ccs1
[46.787315] Dynamic subtest ccs1: SUCCESS (0.074s)
[46.793563] Starting dynamic subtest: ccs2
[46.866142] Dynamic subtest ccs2: SUCCESS (0.078s)
[46.876960] Starting dynamic subtest: ccs3
[46.940277] Dynamic subtest ccs3: SUCCESS (0.075s)
[46.941062] Subtest submit-early-slice: SUCCESS (0.793s)
[47.388827] [014/142] (942s left) kms_vrr (flip-suspend)
[49.372232] Starting subtest: flip-suspend
[49.374049] Subtest flip-suspend: SKIP (0.000s)
[49.420929] [015/142] (940s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[51.383006] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[51.384790] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[51.453808] [016/142] (938s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[51.522549] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[51.523531] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[51.597887] [017/142] (938s left) kms_universal_plane (universal-plane-pipe-b-sanity)
[53.570197] Starting subtest: universal-plane-pipe-B-sanity
[54.153507] Subtest universal-plane-pipe-B-sanity: SUCCESS (0.583s)
[54.284883] [018/142] (935s left) kms_vblank (pipe-c-ts-continuation-dpms-rpm)
[56.241517] Starting subtest: pipe-C-ts-continuation-dpms-rpm
[58.866988] Subtest pipe-C-ts-continuation-dpms-rpm: SUCCESS (2.626s)
[60.017784] [019/142] (929s left) kms_ccs (pipe-b-bad-rotation-90-4_tiled_dg2_rc_ccs_cc)
[62.105543] Starting subtest: pipe-B-bad-rotation-90-4_tiled_dg2_rc_ccs_cc
[62.172866] Subtest pipe-B-bad-rotation-90-4_tiled_dg2_rc_ccs_cc: SUCCESS (0.067s)
[62.405077] [020/142] (927s left) gem_exec_params (dr4-dirt)
[62.465648] Starting subtest: DR4-dirt
[62.466456] Subtest DR4-dirt: SUCCESS (0.000s)
[62.538133] [021/142] (927s left) syncobj_wait (invalid-wait-illegal-handle)
[62.594189] Starting subtest: invalid-wait-illegal-handle
[62.595107] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[62.656247] [022/142] (927s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[64.622814] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[64.624247] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[64.688436] [023/142] (925s left) kms_addfb_basic (legacy-format)
[64.751619] Starting subtest: legacy-format
[64.804480] Subtest legacy-format: SUCCESS (0.039s)
[66.788463] [024/142] (923s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[68.751203] Starting subtest: yf-tiled-16bpp-rotate-180
[68.752845] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[68.821819] [025/142] (921s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[70.783387] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[70.785139] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[70.872393] [026/142] (919s left) vc4/vc4_tiling (get-bad-flags)
[70.995609] Subtest get-bad-flags: SKIP (0.000s)
[71.059926] [027/142] (919s left) kms_busy (basic)
[73.059764] Starting subtest: basic
[73.060561] Starting dynamic subtest: flip
[73.814530] Dynamic subtest flip: SUCCESS (0.754s)
[73.819549] Starting dynamic subtest: modeset
[74.519921] Dynamic subtest modeset: SUCCESS (0.705s)
[74.520724] Subtest basic: SUCCESS (1.460s)
[74.643873] [028/142] (915s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[76.596306] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[76.598130] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[76.676727] [029/142] (913s left) i915_pm_rpm (drm-resources-equal)
[81.614087] Starting subtest: drm-resources-equal
[96.645799] Subtest drm-resources-equal: SUCCESS (15.032s)
[96.797142] [030/142] (893s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[98.788096] Starting subtest: basic-flip-before-cursor-varying-size
[99.804071] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.016s)
[99.924265] [031/142] (890s left) gem_readwrite (read-write)
[99.983292] Subtest read-write: SKIP (0.000s)
[100.018596] [032/142] (890s left) kms_cursor_legacy (forked-bo)
[101.975265] Starting subtest: forked-bo
[101.976142] Starting dynamic subtest: pipe-A
[107.419957] Dynamic subtest pipe-A: SUCCESS (5.410s)
[107.428292] Starting dynamic subtest: pipe-B
[112.801849] Dynamic subtest pipe-B: SUCCESS (5.415s)
[112.807054] Starting dynamic subtest: pipe-C
[118.205056] Dynamic subtest pipe-C: SUCCESS (5.403s)
[118.210172] Starting dynamic subtest: pipe-D
[123.610529] Dynamic subtest pipe-D: SUCCESS (5.405s)
[123.615658] Starting dynamic subtest: all-pipes
[129.017930] Dynamic subtest all-pipes: SUCCESS (5.407s)
[129.018779] Subtest forked-bo: SUCCESS (27.044s)
[129.074838] [033/142] (861s left) kms_ccs (pipe-c-random-ccs-data-y_tiled_gen12_mc_ccs)
[131.181307] Starting subtest: pipe-C-random-ccs-data-y_tiled_gen12_mc_ccs
[131.184035] Subtest pipe-C-random-ccs-data-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[131.318878] [034/142] (858s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-25)
[133.273033] Starting subtest: planes-upscale-20x20-downscale-factor-0-25
[133.274989] Starting dynamic subtest: pipe-A-HDMI-A-1
[133.287360] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.012s)
[133.292589] Starting dynamic subtest: pipe-B-HDMI-A-1
[133.313949] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.025s)
[133.319106] Starting dynamic subtest: pipe-C-HDMI-A-1
[133.339528] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.024s)
[133.344987] Starting dynamic subtest: pipe-D-HDMI-A-1
[133.364274] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.023s)
[133.365901] Subtest planes-upscale-20x20-downscale-factor-0-25: SKIP (0.091s)
[133.435592] [035/142] (856s left) kms_concurrent (pipe-b)
[135.391335] Starting subtest: pipe-B
[135.393327] Starting dynamic subtest: HDMI-A-1
[135.675883] Dynamic subtest HDMI-A-1: SUCCESS (0.282s)
[135.676817] Subtest pipe-B: SUCCESS (0.284s)
[135.812305] [036/142] (854s left) gem_exec_basic (basic)
[135.874256] Starting subtest: basic
[135.875200] Starting dynamic subtest: rcs0-smem
[135.877343] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[135.882504] Starting dynamic subtest: bcs0-smem
[135.883309] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[135.888489] Starting dynamic subtest: vcs0-smem
[135.889323] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[135.894400] Starting dynamic subtest: vcs1-smem
[135.895208] Dynamic subtest vcs1-smem: SUCCESS (0.000s)
[135.900234] Starting dynamic subtest: vecs0-smem
[135.901063] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[135.906119] Starting dynamic subtest: vecs1-smem
[135.907020] Dynamic subtest vecs1-smem: SUCCESS (0.000s)
[135.911921] Starting dynamic subtest: ccs0-smem
[135.912815] Dynamic subtest ccs0-smem: SUCCESS (0.000s)
[135.917747] Starting dynamic subtest: ccs1-smem
[135.918646] Dynamic subtest ccs1-smem: SUCCESS (0.000s)
[135.923569] Starting dynamic subtest: ccs2-smem
[135.924464] Dynamic subtest ccs2-smem: SUCCESS (0.000s)
[135.929374] Starting dynamic subtest: ccs3-smem
[135.930274] Dynamic subtest ccs3-smem: SUCCESS (0.001s)
[135.935212] Starting dynamic subtest: rcs0-lmem0
[135.936074] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[135.940984] Starting dynamic subtest: bcs0-lmem0
[135.941894] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[135.946810] Starting dynamic subtest: vcs0-lmem0
[135.947663] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[135.952591] Starting dynamic subtest: vcs1-lmem0
[135.953488] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[135.958379] Starting dynamic subtest: vecs0-lmem0
[135.959271] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[135.964181] Starting dynamic subtest: vecs1-lmem0
[135.965059] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s)
[135.969976] Starting dynamic subtest: ccs0-lmem0
[135.970876] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s)
[135.975807] Starting dynamic subtest: ccs1-lmem0
[135.976707] Dynamic subtest ccs1-lmem0: SUCCESS (0.000s)
[135.981620] Starting dynamic subtest: ccs2-lmem0
[135.982514] Dynamic subtest ccs2-lmem0: SUCCESS (0.000s)
[135.987445] Starting dynamic subtest: ccs3-lmem0
[135.988338] Dynamic subtest ccs3-lmem0: SUCCESS (0.000s)
[135.989226] Subtest basic: SUCCESS (0.021s)
[136.078843] [037/142] (854s left) gem_workarounds (basic-read-fd)
[136.146872] Starting subtest: basic-read-fd
[136.176969] Subtest basic-read-fd: SUCCESS (0.030s)
[136.266211] [038/142] (853s left) kms_draw_crc (draw-method-mmap-wc)
[138.221650] Starting subtest: draw-method-mmap-wc
[138.223438] Subtest draw-method-mmap-wc: SKIP (0.000s)
[138.295261] [039/142] (851s left) kms_atomic_transition (plane-all-transition-fencing)
[140.276718] Starting subtest: plane-all-transition-fencing
[140.279728] Starting dynamic subtest: pipe-A-HDMI-A-1
[144.048682] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.770s)
[144.092857] Starting dynamic subtest: pipe-B-HDMI-A-1
[147.887233] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.799s)
[147.927391] Subtest plane-all-transition-fencing: SUCCESS (7.653s)
[148.039846] [040/142] (842s left) device_reset (unbind-cold-reset-rebind)
[148.112033] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[148.172812] [041/142] (842s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[150.134241] Starting subtest: fbcpsr-1p-rte
[150.135967] Subtest fbcpsr-1p-rte: SKIP (0.000s)
[150.223242] [042/142] (840s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[152.213561] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[152.842226] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.629s)
[152.940220] [043/142] (837s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[154.902127] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[154.903802] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[154.972858] [044/142] (835s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc)
[157.110905] Starting subtest: pipe-D-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc
[158.264418] Subtest pipe-D-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc: SUCCESS (1.154s)
[158.462401] [045/142] (831s left) syncobj_wait (single-wait-all-for-submit-signaled)
[158.522409] Starting subtest: single-wait-all-for-submit-signaled
[158.523337] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[158.578078] [046/142] (831s left) kms_plane_scaling (plane-downscale-with-rotation-factor-0-25)
[160.535752] Starting subtest: plane-downscale-with-rotation-factor-0-25
[160.536639] Starting dynamic subtest: pipe-A-HDMI-A-1
[160.583050] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.045s)
[160.588439] Starting dynamic subtest: pipe-B-HDMI-A-1
[160.618422] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.035s)
[160.623656] Starting dynamic subtest: pipe-C-HDMI-A-1
[160.655143] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.035s)
[160.660250] Starting dynamic subtest: pipe-D-HDMI-A-1
[160.691256] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.034s)
[160.692880] Subtest plane-downscale-with-rotation-factor-0-25: SKIP (0.155s)
[160.778993] [047/142] (829s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[162.732362] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[162.733285] Starting dynamic subtest: pipe-A-valid-mode
[162.772450] Dynamic subtest pipe-A-valid-mode: SKIP (0.038s)
[162.774014] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.040s)
[162.858638] [048/142] (827s left) kms_ccs (pipe-a-random-ccs-data-yf_tiled_ccs)
[164.864512] Starting subtest: pipe-A-random-ccs-data-yf_tiled_ccs
[164.867183] Subtest pipe-A-random-ccs-data-yf_tiled_ccs: SKIP (0.000s)
[165.071356] [049/142] (825s left) gem_exec_schedule (deep)
[165.281073] Starting subtest: deep
[165.284717] Starting dynamic subtest: rcs0
[177.353752] Dynamic subtest rcs0: SUCCESS (12.093s)
[177.359375] Starting dynamic subtest: bcs0
[189.737338] Dynamic subtest bcs0: SUCCESS (12.383s)
[189.743330] Starting dynamic subtest: vcs0
[202.051743] Dynamic subtest vcs0: SUCCESS (12.314s)
[202.057348] Starting dynamic subtest: vcs1
[214.369377] Dynamic subtest vcs1: SUCCESS (12.317s)
[214.375330] Starting dynamic subtest: vecs0
[226.580051] Dynamic subtest vecs0: SUCCESS (12.210s)
[226.593974] Starting dynamic subtest: vecs1
[238.725743] Dynamic subtest vecs1: SUCCESS (12.145s)
[238.731359] Starting dynamic subtest: ccs0
[251.058410] Dynamic subtest ccs0: SUCCESS (12.332s)
[251.064733] Starting dynamic subtest: ccs1
[263.420183] Dynamic subtest ccs1: SUCCESS (12.361s)
[263.429848] Starting dynamic subtest: ccs2
[275.808970] Dynamic subtest ccs2: SUCCESS (12.388s)
[275.814692] Starting dynamic subtest: ccs3
[288.200862] Dynamic subtest ccs3: SUCCESS (12.391s)
[288.201641] Subtest deep: SUCCESS (122.941s)
[288.653361] [050/142] (701s left) gem_fenced_exec_thrash (no-spare-fences)
[288.750471] Subtest no-spare-fences: SKIP (0.000s)
[288.787982] [051/142] (701s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc)
[290.878277] Starting subtest: pipe-C-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc
[291.162158] Subtest pipe-C-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc: SUCCESS (0.285s)
[291.359903] [052/142] (699s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[293.315727] Starting subtest: psr-shrfb-scaledprimary
[293.317323] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[293.393758] [053/142] (697s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[295.406308] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[295.461211] [054/142] (695s left) gem_exec_fair (basic-none-vip)
[295.529024] Subtest basic-none-vip: SKIP (0.000s)
[295.576068] [055/142] (694s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[297.532186] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[297.532966] Starting dynamic subtest: pipe-A-valid-mode
[298.253406] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.721s)
[298.254353] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (0.723s)
[298.388785] [056/142] (692s left) dmabuf_sync_file (import-basic)
[298.443189] Starting subtest: import-basic
[298.444142] Subtest import-basic: SUCCESS (0.001s)
[298.487884] [057/142] (692s left) gem_ctx_shared (q-independent)
[298.556328] Starting subtest: Q-independent
[298.557260] Starting dynamic subtest: rcs0
[298.792783] Dynamic subtest rcs0: SUCCESS (0.228s)
[298.798409] Starting dynamic subtest: bcs0
[298.945868] Dynamic subtest bcs0: SUCCESS (0.152s)
[298.951725] Starting dynamic subtest: vcs0
[299.110378] Dynamic subtest vcs0: SUCCESS (0.164s)
[299.115964] Starting dynamic subtest: vcs1
[299.273897] Dynamic subtest vcs1: SUCCESS (0.163s)
[299.279702] Starting dynamic subtest: vecs0
[299.437993] Dynamic subtest vecs0: SUCCESS (0.163s)
[299.443663] Starting dynamic subtest: vecs1
[299.607677] Dynamic subtest vecs1: SUCCESS (0.169s)
[299.613438] Starting dynamic subtest: ccs0
[299.768337] Dynamic subtest ccs0: SUCCESS (0.160s)
[299.774080] Starting dynamic subtest: ccs1
[299.928957] Dynamic subtest ccs1: SUCCESS (0.161s)
[299.934592] Starting dynamic subtest: ccs2
[300.091560] Dynamic subtest ccs2: SUCCESS (0.159s)
[300.097230] Starting dynamic subtest: ccs3
[300.251126] Dynamic subtest ccs3: SUCCESS (0.161s)
[300.252644] Subtest Q-independent: SUCCESS (1.687s)
[300.602312] [058/142] (689s left) kms_vblank (pipe-b-wait-forked-hang)
[302.559428] Starting subtest: pipe-B-wait-forked-hang
[317.019601] Subtest pipe-B-wait-forked-hang: SUCCESS (14.462s)
[317.127327] [059/142] (673s left) gem_wait (write-wait)
[317.200020] Starting subtest: write-wait
[317.200838] Starting dynamic subtest: all-engines
[318.286210] Dynamic subtest all-engines: SUCCESS (1.086s)
[318.295616] Starting dynamic subtest: rcs0
[319.344821] Dynamic subtest rcs0: SUCCESS (1.056s)
[319.356506] Starting dynamic subtest: bcs0
[320.405945] Dynamic subtest bcs0: SUCCESS (1.057s)
[320.417775] Starting dynamic subtest: vcs0
[321.467057] Dynamic subtest vcs0: SUCCESS (1.057s)
[321.478913] Starting dynamic subtest: vcs1
[322.529902] Dynamic subtest vcs1: SUCCESS (1.059s)
[322.544667] Starting dynamic subtest: vecs0
[323.594903] Dynamic subtest vecs0: SUCCESS (1.061s)
[323.606465] Starting dynamic subtest: vecs1
[324.657051] Dynamic subtest vecs1: SUCCESS (1.058s)
[324.668561] Starting dynamic subtest: ccs0
[325.717839] Dynamic subtest ccs0: SUCCESS (1.057s)
[325.729472] Starting dynamic subtest: ccs1
[326.778965] Dynamic subtest ccs1: SUCCESS (1.057s)
[326.789211] Starting dynamic subtest: ccs2
[327.837163] Dynamic subtest ccs2: SUCCESS (1.054s)
[327.849374] Starting dynamic subtest: ccs3
[328.899834] Dynamic subtest ccs3: SUCCESS (1.059s)
[328.901901] Subtest write-wait: SUCCESS (11.701s)
[329.129033] [060/142] (661s left) v3d/v3d_get_bo_offset (create-get-offsets)
[329.215119] Subtest create-get-offsets: SKIP (0.000s)
[329.261494] [061/142] (661s left) kms_getfb (getfb2-handle-not-fb)
[329.331069] Starting subtest: getfb2-handle-not-fb
[331.227346] Subtest getfb2-handle-not-fb: SUCCESS (1.896s)
[331.310579] [062/142] (659s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[333.298900] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[333.300466] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[333.376880] [063/142] (657s left) kms_addfb_basic (bad-pitch-256)
[333.449470] Starting subtest: bad-pitch-256
[333.450457] Subtest bad-pitch-256: SUCCESS (0.000s)
[335.427909] [064/142] (655s left) gem_flink_race (flink_name)
[335.482456] Starting subtest: flink_name
[340.902615] Subtest flink_name: SUCCESS (5.383s)
[340.979319] [065/142] (649s left) kms_legacy_colorkey (invalid-plane)
[343.042336] Starting subtest: invalid-plane
[343.043252] Starting dynamic subtest: zero-id
[343.044137] Dynamic subtest zero-id: SUCCESS (0.000s)
[343.049696] Starting dynamic subtest: outrange-id
[343.050552] Dynamic subtest outrange-id: SUCCESS (0.000s)
[343.051446] Subtest invalid-plane: SUCCESS (0.001s)
[343.094345] [066/142] (647s left) gem_exec_params (secure-non-master)
[343.160509] Starting subtest: secure-non-master
[343.162476] Subtest secure-non-master: SKIP (0.000s)
[343.261746] [067/142] (647s left) vc4/vc4_mmap (mmap-bo)
[343.382174] Subtest mmap-bo: SKIP (0.000s)
[343.427728] [068/142] (647s left) kms_sysfs_edid_timing
[357.894634] [069/142] (632s left) i915_pm_rpm (modeset-lpsp-stress)
[362.631323] Starting subtest: modeset-lpsp-stress
[394.707372] Subtest modeset-lpsp-stress: SUCCESS (32.076s)
[395.757410] [070/142] (594s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[398.168876] Starting subtest: plane-primary-overlay-mutable-zpos
[398.171456] Subtest plane-primary-overlay-mutable-zpos: SKIP (0.000s)
[398.348279] [071/142] (592s left) gem_pwrite (basic-self)
[398.408807] Subtest basic-self: SKIP (0.000s)
[398.459358] [072/142] (592s left) v3d/v3d_submit_csd (bad-in-sync)
[398.551363] Subtest bad-in-sync: SKIP (0.000s)
[398.599906] [073/142] (592s left) kms_ccs (pipe-c-missing-ccs-buffer-4_tiled_mtl_rc_ccs)
[400.691634] Starting subtest: pipe-C-missing-ccs-buffer-4_tiled_mtl_rc_ccs
[400.693350] Subtest pipe-C-missing-ccs-buffer-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[400.828973] [074/142] (589s left) perf_pmu (init-busy)
[400.893014] Starting subtest: init-busy
[400.893855] Starting dynamic subtest: rcs0
[400.894678] Dynamic subtest rcs0: SUCCESS (0.001s)
[400.900309] Starting dynamic subtest: bcs0
[400.901227] Dynamic subtest bcs0: SUCCESS (0.000s)
[400.906920] Starting dynamic subtest: vcs0
[400.907804] Dynamic subtest vcs0: SUCCESS (0.000s)
[400.913238] Starting dynamic subtest: vcs1
[400.914140] Dynamic subtest vcs1: SUCCESS (0.000s)
[400.919516] Starting dynamic subtest: vecs0
[400.920418] Dynamic subtest vecs0: SUCCESS (0.000s)
[400.925900] Starting dynamic subtest: vecs1
[400.926798] Dynamic subtest vecs1: SUCCESS (0.000s)
[400.932295] Starting dynamic subtest: ccs0
[400.933219] Dynamic subtest ccs0: SUCCESS (0.000s)
[400.938581] Starting dynamic subtest: ccs1
[400.939447] Dynamic subtest ccs1: SUCCESS (0.000s)
[400.945120] Starting dynamic subtest: ccs2
[400.946047] Dynamic subtest ccs2: SUCCESS (0.000s)
[400.951513] Starting dynamic subtest: ccs3
[400.952379] Dynamic subtest ccs3: SUCCESS (0.000s)
[400.953285] Subtest init-busy: SUCCESS (0.011s)
[400.991986] [075/142] (589s left) kms_cursor_crc (cursor-random-max-size)
[403.169606] Starting subtest: cursor-random-max-size
[403.173394] Subtest cursor-random-max-size: SKIP (0.000s)
[403.322414] [076/142] (587s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[405.326465] Starting subtest: y-tiled-64bpp-rotate-270
[405.328283] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[405.395593] [077/142] (585s left) gem_exec_gttfill (basic)
[405.478948] Starting subtest: basic
[410.894891] Subtest basic: SUCCESS (5.407s)
[411.113804] [078/142] (579s left) i915_hangman (engine-error-state-capture)
[411.225584] Starting subtest: engine-error-state-capture
[411.226472] Starting dynamic subtest: rcs0
[413.103687] Dynamic subtest rcs0: SUCCESS (1.878s)
[413.109921] Starting dynamic subtest: bcs0
[417.059266] Dynamic subtest bcs0: SUCCESS (3.955s)
[417.065569] Starting dynamic subtest: vcs0
[421.083301] Dynamic subtest vcs0: SUCCESS (4.023s)
[421.090228] Starting dynamic subtest: vcs1
[425.041512] Dynamic subtest vcs1: SUCCESS (3.957s)
[425.047861] Starting dynamic subtest: vecs0
[429.090248] Dynamic subtest vecs0: SUCCESS (4.048s)
[429.096444] Starting dynamic subtest: vecs1
[433.044337] Dynamic subtest vecs1: SUCCESS (3.953s)
[433.051114] Starting dynamic subtest: ccs0
[437.107524] Dynamic subtest ccs0: SUCCESS (4.062s)
[437.113828] Starting dynamic subtest: ccs1
[441.077388] Dynamic subtest ccs1: SUCCESS (3.969s)
[441.084308] Starting dynamic subtest: ccs2
[445.098270] Dynamic subtest ccs2: SUCCESS (4.020s)
[445.104573] Starting dynamic subtest: ccs3
[449.043371] Dynamic subtest ccs3: SUCCESS (3.944s)
[449.044225] Subtest engine-error-state-capture: SUCCESS (37.818s)
[449.151994] [079/142] (541s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-pwrite)
[451.117268] Starting subtest: psr-1p-offscren-pri-shrfb-draw-pwrite
[451.119053] Subtest psr-1p-offscren-pri-shrfb-draw-pwrite: SKIP (0.000s)
[451.197449] [080/142] (539s left) gem_render_copy (linear)
[451.277064] Starting subtest: linear
[451.278149] Starting dynamic subtest: smem
[451.359871] Dynamic subtest smem: SUCCESS (0.082s)
[451.366034] Starting dynamic subtest: lmem0
[451.593239] Dynamic subtest lmem0: SUCCESS (0.224s)
[451.594429] Subtest linear: SUCCESS (0.308s)
[451.806613] [081/142] (539s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[453.777029] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[453.778520] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[453.846953] [082/142] (537s left) perf (per-context-mode-unprivileged)
[454.207764] Starting subtest: per-context-mode-unprivileged
[454.209475] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[454.229852] [083/142] (536s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[456.186423] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[456.188055] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[456.264288] [084/142] (534s left) kms_ccs (pipe-b-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc)
[458.334507] Starting subtest: pipe-B-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc
[458.336187] Subtest pipe-B-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[458.513950] [085/142] (532s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc)
[460.533749] Starting subtest: pipe-A-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc
[461.817701] Subtest pipe-A-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc: SUCCESS (1.283s)
[462.050709] [086/142] (528s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[464.017313] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[464.019030] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[464.100551] [087/142] (526s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[464.182585] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[464.183723] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[464.260425] [088/142] (526s left) gem_exec_whisper (basic-queues-all)
[464.352248] Starting subtest: basic-queues-all
[486.340793] Subtest basic-queues-all: SUCCESS (21.978s)
[486.520317] [089/142] (504s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[488.518261] Starting subtest: x-tiled-16bpp-rotate-180
[490.208929] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.688s)
[490.338828] [090/142] (500s left) kms_ccs (pipe-a-bad-pixel-format-4_tiled_mtl_mc_ccs)
[492.297228] Starting subtest: pipe-A-bad-pixel-format-4_tiled_mtl_mc_ccs
[492.299116] Subtest pipe-A-bad-pixel-format-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[492.562429] [091/142] (498s left) syncobj_timeline (signal-array)
[492.623634] Starting subtest: signal-array
[492.624446] Subtest signal-array: SUCCESS (0.000s)
[492.678906] [092/142] (498s left) api_intel_allocator (open-vm)
[492.743111] Starting subtest: open-vm
[492.759550] Subtest open-vm: SUCCESS (0.017s)
[492.850345] [093/142] (498s left) kms_psr2_su (page_flip-xrgb8888)
[492.950291] Subtest page_flip-XRGB8888: SKIP (0.000s)
[492.974277] [094/142] (498s left) kms_vblank (invalid)
[494.934325] Starting subtest: invalid
[495.303174] Subtest invalid: SUCCESS (0.370s)
[495.400601] [095/142] (495s left) kms_plane (invalid-pixel-format-settings)
[497.362308] Starting subtest: invalid-pixel-format-settings
[497.397925] Subtest invalid-pixel-format-settings: SUCCESS (0.037s)
[497.483918] [096/142] (493s left) kms_pipe_crc_basic (bad-source)
[499.442168] Starting subtest: bad-source
[499.443180] Subtest bad-source: SUCCESS (0.000s)
[499.500605] [097/142] (491s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[499.565868] Subtest writes-after-reads: SKIP (0.000s)
[499.595794] [098/142] (491s left) kms_color (ctm-blue-to-red)
[501.555391] Starting subtest: ctm-blue-to-red
[501.556355] Starting dynamic subtest: pipe-A
[502.207346] Dynamic subtest pipe-A: SUCCESS (0.653s)
[502.213850] Starting dynamic subtest: pipe-B
[502.657405] Dynamic subtest pipe-B: SUCCESS (0.449s)
[502.665694] Starting dynamic subtest: pipe-C
[503.169684] Dynamic subtest pipe-C: SUCCESS (0.510s)
[503.176382] Starting dynamic subtest: pipe-D
[503.744159] Dynamic subtest pipe-D: SUCCESS (0.575s)
[503.745009] Subtest ctm-blue-to-red: SUCCESS (2.190s)
[503.864585] [099/142] (487s left) syncobj_timeline (wait-for-submit-complex)
[503.925095] Starting subtest: wait-for-submit-complex
[503.987194] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[504.062876] [100/142] (487s left) kms_ccs (pipe-a-crc-primary-rotation-180-4_tiled_mtl_mc_ccs)
[506.065556] Starting subtest: pipe-A-crc-primary-rotation-180-4_tiled_mtl_mc_ccs
[506.067186] Subtest pipe-A-crc-primary-rotation-180-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[506.277371] [101/142] (484s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[508.240650] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[508.242326] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[508.309909] [102/142] (482s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[508.380502] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[508.381484] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[508.462367] [103/142] (482s left) gem_bad_reloc (negative-reloc)
[508.542183] Subtest negative-reloc: SKIP (0.000s)
[508.589962] [104/142] (482s left) i915_hangman (gt-error-state-capture)
[508.676245] Starting subtest: gt-error-state-capture
[508.677131] Starting dynamic subtest: rcs0
[518.561996] Dynamic subtest rcs0: SUCCESS (9.887s)
[518.569203] Starting dynamic subtest: bcs0
[528.547912] Dynamic subtest bcs0: SUCCESS (9.985s)
[528.555114] Starting dynamic subtest: vcs0
[538.616276] Dynamic subtest vcs0: SUCCESS (10.068s)
[538.623143] Starting dynamic subtest: vcs1
[548.590540] Dynamic subtest vcs1: SUCCESS (9.974s)
[548.597728] Starting dynamic subtest: vecs0
[558.572498] Dynamic subtest vecs0: SUCCESS (9.981s)
[558.579400] Starting dynamic subtest: vecs1
[568.568475] Dynamic subtest vecs1: SUCCESS (9.995s)
[568.578055] Starting dynamic subtest: ccs0
[578.614285] Dynamic subtest ccs0: SUCCESS (10.045s)
[578.621559] Starting dynamic subtest: ccs1
[588.592405] Dynamic subtest ccs1: SUCCESS (9.977s)
[588.599497] Starting dynamic subtest: ccs2
[598.574260] Dynamic subtest ccs2: SUCCESS (9.980s)
[598.587894] Starting dynamic subtest: ccs3
[608.565149] Dynamic subtest ccs3: SUCCESS (9.989s)
[608.565986] Subtest gt-error-state-capture: SUCCESS (99.890s)
[608.678777] [105/142] (382s left) api_intel_bb (blit-reloc-purge-cache)
[608.738128] Starting subtest: blit-reloc-purge-cache
[608.739843] Subtest blit-reloc-purge-cache: SKIP (0.000s)
[608.849910] [106/142] (382s left) kms_frontbuffer_tracking (fbc-badstride)
[610.845672] Starting subtest: fbc-badstride
[620.787808] Subtest fbc-badstride: SUCCESS (9.942s)
[620.883904] [107/142] (370s left) kms_addfb_basic (tile-pitch-mismatch)
[620.959868] Starting subtest: tile-pitch-mismatch
[620.961636] Subtest tile-pitch-mismatch: SKIP (0.000s)
[622.947323] [108/142] (368s left) gem_mmap (bad-offset)
[623.031853] Subtest bad-offset: SKIP (0.000s)
[623.064074] [109/142] (368s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[625.040885] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[625.042408] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[625.113939] [110/142] (366s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[627.094290] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[627.096057] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[627.163913] [111/142] (364s left) kms_flip (bo-too-big-interruptible)
[628.197738] Starting subtest: bo-too-big-interruptible
[628.202481] Starting dynamic subtest: A-HDMI-A1
[628.396812] Dynamic subtest A-HDMI-A1: SUCCESS (0.194s)
[628.403697] Starting dynamic subtest: B-HDMI-A1
[628.526257] Dynamic subtest B-HDMI-A1: SUCCESS (0.129s)
[628.533184] Starting dynamic subtest: C-HDMI-A1
[628.638756] Dynamic subtest C-HDMI-A1: SUCCESS (0.112s)
[628.645736] Starting dynamic subtest: D-HDMI-A1
[628.750511] Dynamic subtest D-HDMI-A1: SUCCESS (0.111s)
[628.752918] Subtest bo-too-big-interruptible: SUCCESS (0.555s)
[628.907371] [112/142] (362s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[629.925871] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[629.944256] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.018s)
[630.006859] [113/142] (361s left) gem_softpin (allocator-basic)
[630.092266] Starting subtest: allocator-basic
[630.266701] Subtest allocator-basic: SUCCESS (0.166s)
[630.384601] [114/142] (361s left) kms_psr (psr2_sprite_mmap_cpu)
[630.477965] Subtest psr2_sprite_mmap_cpu: SKIP (0.000s)
[630.501731] [115/142] (360s left) kms_plane_scaling (plane-upscale-with-pixel-format-factor-0-25)
[632.462399] Starting subtest: plane-upscale-with-pixel-format-factor-0-25
[632.463382] Starting dynamic subtest: pipe-A-HDMI-A-1
[636.126441] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.663s)
[636.133339] Starting dynamic subtest: pipe-B-HDMI-A-1
[639.565843] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.439s)
[639.574053] Starting dynamic subtest: pipe-C-HDMI-A-1
[639.772013] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.205s)
[639.780276] Starting dynamic subtest: pipe-D-HDMI-A-1
[639.978401] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.205s)
[639.979300] Subtest plane-upscale-with-pixel-format-factor-0-25: SUCCESS (7.517s)
[640.151164] [116/142] (351s left) gem_mmap_offset (close-race)
[640.211894] Starting subtest: close-race
[660.301174] Subtest close-race: SUCCESS (20.055s)
[660.362697] [117/142] (331s left) kms_chamelium_color (ctm-0-75)
[662.356495] Subtest ctm-0-75: SKIP (0.000s)
[662.380539] [118/142] (329s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[664.341142] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[673.643576] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.303s)
[673.774137] [119/142] (317s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[673.838970] Starting subtest: yf-tiled-ccs-to-x-tiled
[673.841097] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[674.025565] [120/142] (317s left) gem_lmem_swapping (basic)
[677.709622] Starting subtest: basic
[677.710367] Starting dynamic subtest: lmem0
[694.793063] Dynamic subtest lmem0: SUCCESS (17.074s)
[694.793890] Subtest basic: SUCCESS (17.075s)
[697.231346] [121/142] (294s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[700.323235] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[700.428748] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.106s)
[701.315873] [122/142] (290s left) gem_mmap_gtt (medium-copy-odd)
[701.380591] Subtest medium-copy-odd: SKIP (0.000s)
[701.407559] [123/142] (290s left) v3d/v3d_submit_csd (multisync-out-syncs)
[701.483717] Subtest multisync-out-syncs: SKIP (0.000s)
[701.530546] [124/142] (290s left) kms_ccs (pipe-b-random-ccs-data-y_tiled_gen12_mc_ccs)
[703.564570] Starting subtest: pipe-B-random-ccs-data-y_tiled_gen12_mc_ccs
[703.567284] Subtest pipe-B-random-ccs-data-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[703.697313] [125/142] (287s left) kms_ccs (pipe-d-bad-pixel-format-y_tiled_gen12_mc_ccs)
[705.791221] Starting subtest: pipe-D-bad-pixel-format-y_tiled_gen12_mc_ccs
[705.793108] Subtest pipe-D-bad-pixel-format-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[705.912883] [126/142] (285s left) gem_create (create-clear)
[705.972902] Starting subtest: create-clear
[705.973775] Starting dynamic subtest: lmem0
[741.319230] Dynamic subtest lmem0: SUCCESS (35.338s)
[741.325142] Starting dynamic subtest: smem0
[776.265935] Dynamic subtest smem0: SUCCESS (34.944s)
[776.267300] Subtest create-clear: SUCCESS (70.284s)
[776.681442] [127/142] (214s left) gem_ctx_isolation (nonpriv)
[776.753654] Starting subtest: nonpriv
[776.754490] Starting dynamic subtest: rcs0
[777.404486] Dynamic subtest rcs0: SUCCESS (0.650s)
[777.411959] Starting dynamic subtest: bcs0
[778.113059] Dynamic subtest bcs0: SUCCESS (0.708s)
[778.119473] Starting dynamic subtest: vcs0
[778.799512] Dynamic subtest vcs0: SUCCESS (0.686s)
[778.805928] Starting dynamic subtest: vcs1
[779.473806] Dynamic subtest vcs1: SUCCESS (0.673s)
[779.479917] Starting dynamic subtest: vecs0
[780.156247] Dynamic subtest vecs0: SUCCESS (0.682s)
[780.162459] Starting dynamic subtest: vecs1
[780.787688] Dynamic subtest vecs1: SUCCESS (0.631s)
[780.793759] Starting dynamic subtest: ccs0
[781.467759] Dynamic subtest ccs0: SUCCESS (0.679s)
[781.473922] Starting dynamic subtest: ccs1
[782.151070] Dynamic subtest ccs1: SUCCESS (0.682s)
[782.157451] Starting dynamic subtest: ccs2
[782.826201] Dynamic subtest ccs2: SUCCESS (0.674s)
[782.832217] Starting dynamic subtest: ccs3
[783.480624] Dynamic subtest ccs3: SUCCESS (0.654s)
[783.481502] Subtest nonpriv: SUCCESS (6.727s)
[783.715420] [128/142] (207s left) syncobj_timeline (invalid-signal-bad-pad)
[783.774142] Starting subtest: invalid-signal-bad-pad
[783.775145] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[783.836642] [129/142] (207s left) gem_exec_fence (syncobj-signal)
[784.610335] Starting subtest: syncobj-signal
[784.635232] Subtest syncobj-signal: SUCCESS (0.025s)
[785.019928] [130/142] (206s left) kms_getfb (getfb-handle-zero)
[785.122461] Starting subtest: getfb-handle-zero
[785.123288] Subtest getfb-handle-zero: SUCCESS (0.000s)
[785.201934] [131/142] (206s left) gem_exec_reloc (basic-gtt-read-noreloc)
[785.271699] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[785.310247] [132/142] (206s left) gem_exec_schedule (noreorder-corked)
[785.504408] Starting subtest: noreorder-corked
[785.505403] Starting dynamic subtest: rcs0
[786.616995] Dynamic subtest rcs0: SUCCESS (1.121s)
[786.623302] Starting dynamic subtest: bcs0
[787.737692] Dynamic subtest bcs0: SUCCESS (1.119s)
[787.749881] Starting dynamic subtest: vcs0
[788.850410] Dynamic subtest vcs0: SUCCESS (1.111s)
[788.856550] Starting dynamic subtest: vcs1
[789.974144] Dynamic subtest vcs1: SUCCESS (1.123s)
[789.980383] Starting dynamic subtest: vecs0
[791.079403] Dynamic subtest vecs0: SUCCESS (1.104s)
[791.085439] Starting dynamic subtest: vecs1
[792.182358] Dynamic subtest vecs1: SUCCESS (1.102s)
[792.188498] Starting dynamic subtest: ccs0
[793.284411] Dynamic subtest ccs0: SUCCESS (1.101s)
[793.290526] Starting dynamic subtest: ccs1
[794.379979] Dynamic subtest ccs1: SUCCESS (1.094s)
[794.386532] Starting dynamic subtest: ccs2
[795.484733] Dynamic subtest ccs2: SUCCESS (1.105s)
[795.495990] Starting dynamic subtest: ccs3
[796.592379] Dynamic subtest ccs3: SUCCESS (1.106s)
[796.593328] Subtest noreorder-corked: SUCCESS (11.097s)
[796.801612] [133/142] (194s left) gem_workarounds (suspend-resume)
[796.872187] Starting subtest: suspend-resume
[814.635271] Subtest suspend-resume: SUCCESS (2.350s)
[820.772037] [134/142] (192s left) gem_userptr_blits (sync-unmap)
[820.848009] Starting subtest: sync-unmap
[820.870329] Subtest sync-unmap: SUCCESS (0.022s)
[820.968665] [135/142] (192s left) perf_pmu (busy-double-start)
[821.037269] Starting subtest: busy-double-start
[821.038075] Starting dynamic subtest: rcs0
[824.640381] Dynamic subtest rcs0: SUCCESS (3.602s)
[824.652083] Starting dynamic subtest: bcs0
[828.223336] Dynamic subtest bcs0: SUCCESS (3.579s)
[828.235577] Starting dynamic subtest: vcs0
[831.817295] Dynamic subtest vcs0: FAIL (3.578s)
[831.826312] Starting dynamic subtest: vcs1
[835.389013] Dynamic subtest vcs1: FAIL (3.561s)
[835.398475] Starting dynamic subtest: vecs0
[838.951229] Dynamic subtest vecs0: FAIL (3.560s)
[838.961073] Starting dynamic subtest: vecs1
[842.510499] Dynamic subtest vecs1: FAIL (3.560s)
[842.520107] Starting dynamic subtest: ccs0
[846.072729] Dynamic subtest ccs0: FAIL (3.560s)
[846.082285] Starting dynamic subtest: ccs1
[849.641322] Dynamic subtest ccs1: FAIL (3.562s)
[849.653653] Starting dynamic subtest: ccs2
[853.197509] Dynamic subtest ccs2: SUCCESS (3.585s)
[853.209780] Starting dynamic subtest: ccs3
[856.785294] Dynamic subtest ccs3: SUCCESS (3.584s)
[856.787378] Subtest busy-double-start: FAIL (35.749s)
[856.855666] [136/142] (156s left) kms_big_fb (linear-8bpp-rotate-270)
[858.823468] Starting subtest: linear-8bpp-rotate-270
[858.870662] Subtest linear-8bpp-rotate-270: SKIP (0.047s)
[859.019536] [137/142] (154s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[861.049372] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[861.050956] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[861.119375] [138/142] (152s left) i915_pm_rpm (universal-planes)
[865.968194] Starting subtest: universal-planes
[865.969470] Starting dynamic subtest: plane-31
[876.075532] Dynamic subtest plane-31: SUCCESS (10.107s)
[876.083653] Starting dynamic subtest: plane-40
[889.688315] Dynamic subtest plane-40: SUCCESS (13.612s)
[889.747800] Starting dynamic subtest: plane-49
[901.282922] Dynamic subtest plane-49: SUCCESS (11.559s)
[901.344626] Starting dynamic subtest: plane-58
[912.518124] Dynamic subtest plane-58: SUCCESS (11.195s)
[912.569648] Starting dynamic subtest: plane-67
[922.319988] Dynamic subtest plane-67: SUCCESS (9.774s)
[922.329619] Starting dynamic subtest: plane-76
[934.751497] Dynamic subtest plane-76: SUCCESS (12.430s)
[934.752713] Subtest universal-planes: SUCCESS (68.784s)
[935.811438] [139/142] ( 77s left) gem_exec_async (concurrent-writes)
[935.880171] Starting subtest: concurrent-writes
[935.881111] Starting dynamic subtest: rcs0
[935.917181] Dynamic subtest rcs0: SUCCESS (0.037s)
[935.927091] Starting dynamic subtest: bcs0
[935.931821] Dynamic subtest bcs0: SUCCESS (0.014s)
[935.940128] Starting dynamic subtest: vcs0
[935.943916] Dynamic subtest vcs0: SUCCESS (0.011s)
[935.952253] Starting dynamic subtest: vcs1
[935.955963] Dynamic subtest vcs1: SUCCESS (0.011s)
[935.964118] Starting dynamic subtest: vecs0
[935.967929] Dynamic subtest vecs0: SUCCESS (0.011s)
[935.976466] Starting dynamic subtest: vecs1
[935.980980] Dynamic subtest vecs1: SUCCESS (0.012s)
[935.989147] Starting dynamic subtest: ccs0
[935.992881] Dynamic subtest ccs0: SUCCESS (0.011s)
[936.001020] Starting dynamic subtest: ccs1
[936.004833] Dynamic subtest ccs1: SUCCESS (0.011s)
[936.013010] Starting dynamic subtest: ccs2
[936.016836] Dynamic subtest ccs2: SUCCESS (0.011s)
[936.024988] Starting dynamic subtest: ccs3
[936.028781] Dynamic subtest ccs3: SUCCESS (0.011s)
[936.029718] Subtest concurrent-writes: SUCCESS (0.149s)
[936.259854] [140/142] ( 77s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[938.227802] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[938.229524] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[938.294557] [141/142] ( 75s left) kms_psr (sprite_mmap_cpu)
[938.367373] Subtest sprite_mmap_cpu: SKIP (0.000s)
[938.390348] [142/142] ( 75s left) prime_busy (hang-wait)
[938.456021] Starting subtest: hang-wait
[938.457015] Starting dynamic subtest: rcs0
[952.429481] Dynamic subtest rcs0: SUCCESS (13.972s)
[952.437955] Starting dynamic subtest: bcs0
[959.581545] Dynamic subtest bcs0: SUCCESS (7.151s)
[959.589738] Starting dynamic subtest: vcs0
[966.562807] Dynamic subtest vcs0: SUCCESS (6.982s)
[966.571470] Starting dynamic subtest: vcs1
[973.535964] Dynamic subtest vcs1: SUCCESS (6.972s)
[973.544158] Starting dynamic subtest: vecs0
[980.572344] Dynamic subtest vecs0: SUCCESS (7.035s)
[980.580412] Starting dynamic subtest: vecs1
[987.563573] Dynamic subtest vecs1: SUCCESS (6.981s)
[987.575250] Starting dynamic subtest: ccs0
[1001.465273] Dynamic subtest ccs0: SUCCESS (13.901s)
[1001.473648] Starting dynamic subtest: ccs1
[1015.407833] Dynamic subtest ccs1: SUCCESS (13.951s)
[1015.416442] Starting dynamic subtest: ccs2
[1029.429397] Dynamic subtest ccs2: SUCCESS (14.021s)
[1029.437508] Starting dynamic subtest: ccs3
[1043.441120] Dynamic subtest ccs3: SUCCESS (14.011s)
[1043.442067] Subtest hang-wait: SUCCESS (104.985s)
[1043.530801] Overall timeout time exceeded, stopping.
[1043.530952] Closing watchdogs
Done.