[47.355302] Initializing watchdogs
[47.355702]   /dev/watchdog0
[47.371122] [001/137] (960s left) kms_cursor_crc (cursor-random-64x64)
[47.684100] Starting subtest: cursor-random-64x64
[47.713252] Starting dynamic subtest: pipe-A-DP-1
[51.762546] Dynamic subtest pipe-A-DP-1: SUCCESS (4.051s)
[51.837334] Starting dynamic subtest: pipe-B-DP-1
[55.710635] Dynamic subtest pipe-B-DP-1: SUCCESS (3.886s)
[55.781469] Starting dynamic subtest: pipe-C-DP-1
[59.665474] Dynamic subtest pipe-C-DP-1: SUCCESS (3.892s)
[59.666931] Subtest cursor-random-64x64: SUCCESS (11.978s)
[60.080873] [002/137] (947s left) kms_addfb_basic (invalid-set-prop-any)
[60.548018] Starting subtest: invalid-set-prop-any
[60.549306] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[60.640264] [003/137] (947s left) perf_pmu (frequency)
[60.833462] Starting subtest: frequency
[62.925904] Subtest frequency: SUCCESS (2.090s)
[63.006466] [004/137] (944s left) prime_busy (before-wait)
[63.189488] Starting subtest: before-wait
[63.201775] Starting dynamic subtest: rcs0
[63.227413] Dynamic subtest rcs0: SUCCESS (0.025s)
[63.242712] Starting dynamic subtest: bcs0
[63.246360] Dynamic subtest bcs0: SUCCESS (0.019s)
[63.260566] Starting dynamic subtest: vcs0
[63.267694] Dynamic subtest vcs0: SUCCESS (0.021s)
[63.282818] Starting dynamic subtest: vecs0
[63.284558] Dynamic subtest vecs0: SUCCESS (0.017s)
[63.397929] Subtest before-wait: SUCCESS (0.206s)
[63.473948] [005/137] (944s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[63.653674] Starting subtest: multi-wait-all-for-submit-submitted
[63.764175] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.109s)
[63.839837] [006/137] (944s left) gem_exec_schedule (u-lateslice)
[64.042698] Starting subtest: u-lateslice
[64.044207] Starting dynamic subtest: rcs0
[64.083649] Dynamic subtest rcs0: SUCCESS (0.041s)
[64.101234] Starting dynamic subtest: bcs0
[64.119252] Dynamic subtest bcs0: SUCCESS (0.034s)
[64.139547] Starting dynamic subtest: vcs0
[64.151559] Dynamic subtest vcs0: SUCCESS (0.033s)
[64.168331] Starting dynamic subtest: vecs0
[64.183837] Dynamic subtest vecs0: SUCCESS (0.032s)
[64.186070] Subtest u-lateslice: SUCCESS (0.141s)
[64.524162] [007/137] (943s left) i915_pm_rpm (modeset-non-lpsp)
[66.396065] Starting subtest: modeset-non-lpsp
[67.026155] Subtest modeset-non-lpsp: SUCCESS (0.630s)
[67.253191] [008/137] (940s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[67.558429] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[67.563931] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.003s)
[67.651967] [009/137] (940s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_dg2_rc_ccs_cc)
[68.154516] Subtest pipe-D-crc-primary-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[68.458979] [010/137] (939s left) gem_mmap_offset (bad-extensions)
[68.636375] Starting subtest: bad-extensions
[68.637737] Subtest bad-extensions: SUCCESS (0.000s)
[68.742048] [011/137] (939s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[69.013460] Starting subtest: primary-yf-tiled-reflect-x-180
[69.016054] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.002s)
[69.091851] [012/137] (939s left) gem_softpin (allocator-evict)
[69.283236] Starting subtest: allocator-evict
[69.284653] Starting dynamic subtest: rcs0
[104.374924] Dynamic subtest rcs0: SUCCESS (35.088s)
[104.391380] Starting dynamic subtest: bcs0
[140.639471] Dynamic subtest bcs0: SUCCESS (36.264s)
[140.655934] Starting dynamic subtest: vcs0
[176.794095] Dynamic subtest vcs0: SUCCESS (36.156s)
[176.811339] Starting dynamic subtest: vecs0
[212.814761] Dynamic subtest vecs0: SUCCESS (36.020s)
[212.816216] Subtest allocator-evict: SUCCESS (143.529s)
[212.897314] [013/137] (795s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[213.295861] Starting subtest: short-flip-after-cursor-toggle
[214.596636] Subtest short-flip-after-cursor-toggle: SUCCESS (1.298s)
[214.979399] [014/137] (793s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[215.269129] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[217.395033] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.129s)
[217.528919] [015/137] (790s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[217.795730] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[217.800867] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.003s)
[217.895262] [016/137] (790s left) kms_vblank (pipe-d-query-forked-busy-hang)
[218.165212] Subtest pipe-D-query-forked-busy-hang: SKIP (0.000s)
[218.244462] [017/137] (790s left) kms_addfb_basic (invalid-get-prop)
[218.702785] Starting subtest: invalid-get-prop
[218.704198] Subtest invalid-get-prop: SUCCESS (0.000s)
[218.794965] [018/137] (789s left) kms_flip (plain-flip-fb-recreate-interruptible)
[219.060848] Starting subtest: plain-flip-fb-recreate-interruptible
[219.066216] Starting dynamic subtest: A-DP1
[229.825596] Dynamic subtest A-DP1: SUCCESS (10.759s)
[229.843335] Starting dynamic subtest: B-DP1
[240.541573] Dynamic subtest B-DP1: SUCCESS (10.713s)
[240.560470] Starting dynamic subtest: C-DP1
[251.252150] Dynamic subtest C-DP1: SUCCESS (10.711s)
[251.253651] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (32.191s)
[251.661338] [019/137] (756s left) syncobj_timeline (invalid-multi-wait-available-unsubmitted)
[251.847361] Starting subtest: invalid-multi-wait-available-unsubmitted
[251.849669] Subtest invalid-multi-wait-available-unsubmitted: SUCCESS (0.000s)
[251.925488] [020/137] (756s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[252.215177] Starting subtest: 4-tiled-16bpp-rotate-90
[252.218187] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.000s)
[252.308612] [021/137] (756s left) v3d/v3d_submit_cl (bad-bo)
[252.542189] Subtest bad-bo: SKIP (0.000s)
[252.609399] [022/137] (755s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[252.873671] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[252.876223] Starting dynamic subtest: pipe-A-valid-mode
[252.959147] Dynamic subtest pipe-A-valid-mode: SKIP (0.085s)
[252.963430] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.087s)
[253.261431] [023/137] (755s left) kms_flip (2x-plain-flip)
[253.523197] Starting subtest: 2x-plain-flip
[253.525724] Subtest 2x-plain-flip: SKIP (0.003s)
[253.626409] [024/137] (754s left) kms_addfb_basic (small-bo)
[253.894779] Starting subtest: small-bo
[253.896198] Subtest small-bo: SUCCESS (0.000s)
[254.179102] [025/137] (754s left) kms_setmode (basic-clone-single-crtc)
[254.348693] Starting subtest: basic-clone-single-crtc
[254.352764] Subtest basic-clone-single-crtc: SKIP (0.000s)
[254.426414] [026/137] (754s left) gem_ppgtt (shrink-vs-evict-pinned)
[254.608156] Starting subtest: shrink-vs-evict-pinned
[259.691994] Subtest shrink-vs-evict-pinned: SUCCESS (5.082s)
[259.764371] [027/137] (748s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[260.045743] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[260.048313] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[260.143827] [028/137] (748s left) gem_exec_params (readonly)
[260.326031] Starting subtest: readonly
[260.330866] Subtest readonly: SUCCESS (0.003s)
[260.448684] [029/137] (748s left) syncobj_wait (invalid-reset-illegal-handle)
[260.619756] Starting subtest: invalid-reset-illegal-handle
[260.621331] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[260.692126] [030/137] (748s left) kms_atomic (plane-cursor-legacy)
[261.079882] Starting subtest: plane-cursor-legacy
[261.136322] Subtest plane-cursor-legacy: SUCCESS (0.057s)
[261.540438] [031/137] (747s left) kms_big_fb (linear-16bpp-rotate-270)
[261.826308] Starting subtest: linear-16bpp-rotate-270
[261.900369] Subtest linear-16bpp-rotate-270: SKIP (0.071s)
[262.005528] [032/137] (746s left) gem_exec_fair (basic-pace-share)
[262.202663] Starting subtest: basic-pace-share
[262.204137] Starting dynamic subtest: rcs0
[267.156363] Dynamic subtest rcs0: FAIL (4.926s)
[267.157672] Subtest basic-pace-share: FAIL (4.927s)
[267.339675] [033/137] (741s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[267.627504] Starting subtest: yf-tiled-16bpp-rotate-90
[267.699741] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.070s)
[267.806172] [034/137] (741s left) kms_psr (psr2_cursor_blt)
[267.978339] Subtest psr2_cursor_blt: SKIP (0.000s)
[268.024931] [035/137] (740s left) i915_query (query-garbage)
[268.188731] Starting subtest: query-garbage
[268.190278] Subtest query-garbage: SUCCESS (0.000s)
[268.272765] [036/137] (740s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[268.560918] Starting subtest: extended-modeset-hang-oldfb-with-reset
[268.564411] Starting dynamic subtest: pipe-A
[270.481868] Dynamic subtest pipe-A: SUCCESS (1.914s)
[270.500506] Starting dynamic subtest: pipe-C
[272.503959] Dynamic subtest pipe-C: SUCCESS (2.018s)
[272.505763] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (3.941s)
[272.861530] [037/137] (736s left) kms_ccs (pipe-d-ccs-on-another-bo-y_tiled_gen12_mc_ccs)
[273.355087] Subtest pipe-D-ccs-on-another-bo-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[273.658797] [038/137] (735s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[273.934137] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[273.936809] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[274.025258] [039/137] (735s left) gem_ctx_exec (basic)
[274.195965] Starting subtest: basic
[274.201860] Subtest basic: SUCCESS (0.006s)
[274.296721] [040/137] (734s left) vc4/vc4_perfmon (create-single-perfmon)
[274.507671] Subtest create-single-perfmon: SKIP (0.000s)
[274.575278] [041/137] (734s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[274.745042] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[274.852458] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.106s)
[274.925361] [042/137] (734s left) gen9_exec_parse (bb-start-far)
[275.113772] Starting subtest: bb-start-far
[275.120203] Subtest bb-start-far: SUCCESS (0.006s)
[275.343391] [043/137] (733s left) kms_color (ctm-max)
[275.615100] Starting subtest: ctm-max
[275.616688] Starting dynamic subtest: pipe-A-DP-1
[276.121105] Dynamic subtest pipe-A-DP-1: SUCCESS (0.504s)
[276.145156] Starting dynamic subtest: pipe-B-DP-1
[276.797137] Dynamic subtest pipe-B-DP-1: SUCCESS (0.670s)
[276.823701] Starting dynamic subtest: pipe-C-DP-1
[277.485043] Dynamic subtest pipe-C-DP-1: SUCCESS (0.685s)
[277.486387] Subtest ctm-max: SUCCESS (1.873s)
[277.811822] [044/137] (731s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs)
[278.245946] Starting subtest: pipe-B-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs
[278.252317] Subtest pipe-B-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs: SKIP (0.005s)
[278.617731] [045/137] (730s left) gem_ctx_exec (basic-norecovery)
[278.789927] Starting subtest: basic-norecovery
[278.824450] Subtest basic-norecovery: SUCCESS (0.036s)
[278.919416] [046/137] (730s left) kms_cursor_legacy (torture-bo)
[279.190725] Starting subtest: torture-bo
[279.192256] Starting dynamic subtest: pipe-A
[302.596717] Dynamic subtest pipe-A: SUCCESS (23.405s)
[302.616800] Starting dynamic subtest: pipe-B
[324.433719] Dynamic subtest pipe-B: SUCCESS (21.834s)
[324.456299] Starting dynamic subtest: pipe-C
[346.062468] Dynamic subtest pipe-C: SUCCESS (21.631s)
[346.085932] Starting dynamic subtest: all-pipes
[367.704099] Dynamic subtest all-pipes: SUCCESS (21.637s)
[367.705976] Subtest torture-bo: SUCCESS (88.508s)
[367.787128] [047/137] (641s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[368.062716] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[368.064179] Starting dynamic subtest: pipe-A-valid-mode
[368.768322] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.702s)
[368.769905] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (0.704s)
[369.122762] [048/137] (640s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs)
[369.631185] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs
[369.640514] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs: SKIP (0.005s)
[369.955362] [049/137] (639s left) perf_pmu (rc6-runtime-pm-long)
[370.149474] Starting subtest: rc6-runtime-pm-long
[382.733194] Subtest rc6-runtime-pm-long: SUCCESS (12.584s)
[383.052730] [050/137] (626s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[383.336152] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[383.338711] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[383.435593] [051/137] (626s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[383.726090] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[386.383808] Subtest fbc-rgb101010-draw-mmap-gtt: SUCCESS (2.658s)
[386.517961] [052/137] (623s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[386.792767] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[386.795662] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[386.885502] [053/137] (622s left) kms_psr (sprite_plane_onoff)
[387.057510] Subtest sprite_plane_onoff: SKIP (0.000s)
[387.104493] [054/137] (622s left) gem_create (create-ext-placement-each)
[387.398794] Starting subtest: create-ext-placement-each
[387.400345] Subtest create-ext-placement-each: SUCCESS (0.000s)
[387.501356] [055/137] (622s left) dmabuf (all-tests)
[387.673075] Starting subtest: all-tests
[387.674557] Starting dynamic subtest: sanitycheck
[387.710671] Dynamic subtest sanitycheck: SUCCESS (0.036s)
[387.731758] Starting dynamic subtest: dma_fence
[387.856179] Dynamic subtest dma_fence: SUCCESS (0.144s)
[387.875872] Starting dynamic subtest: dma_fence_chain
[411.562420] Dynamic subtest dma_fence_chain: SUCCESS (23.703s)
[411.584884] Starting dynamic subtest: dma_fence_unwrap
[411.589045] Dynamic subtest dma_fence_unwrap: SUCCESS (0.026s)
[411.613182] Starting dynamic subtest: dma_resv
[411.618890] Dynamic subtest dma_resv: SUCCESS (0.030s)
[411.620410] Subtest all-tests: SUCCESS (23.946s)
[411.684771] [056/137] (598s left) sw_sync (sync_multi_consumer_producer)
[411.858986] Starting subtest: sync_multi_consumer_producer
[412.516612] Subtest sync_multi_consumer_producer: SUCCESS (0.656s)
[412.584372] [057/137] (597s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-25)
[412.854425] Starting subtest: planes-upscale-20x20-downscale-factor-0-25
[412.859783] Starting dynamic subtest: pipe-A-DP-1
[412.995507] Dynamic subtest pipe-A-DP-1: SKIP (0.136s)
[413.016023] Starting dynamic subtest: pipe-B-DP-1
[413.117119] Dynamic subtest pipe-B-DP-1: SKIP (0.118s)
[413.136884] Starting dynamic subtest: pipe-C-DP-1
[413.224135] Dynamic subtest pipe-C-DP-1: SKIP (0.102s)
[413.227419] Subtest planes-upscale-20x20-downscale-factor-0-25: SKIP (0.365s)
[413.336883] [058/137] (596s left) vgem_basic (sysfs)
[413.582233] Starting subtest: sysfs
[413.583636] Subtest sysfs: SUCCESS (0.001s)
[413.652368] [059/137] (596s left) gem_mmap_wc (close)
[413.827192] Starting subtest: close
[413.908997] Subtest close: SUCCESS (0.082s)
[413.985793] [060/137] (595s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[414.274082] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[416.499945] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (2.228s)
[416.617817] [061/137] (593s left) kms_ccs (pipe-d-missing-ccs-buffer-y_tiled_gen12_mc_ccs)
[417.117789] Subtest pipe-D-missing-ccs-buffer-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[417.424193] [062/137] (592s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[417.617213] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[417.618712] Starting dynamic subtest: smem
[418.041687] Dynamic subtest smem: SUCCESS (0.422s)
[418.042958] Subtest mixed-tiled-to-yf-tiled-ccs: SUCCESS (0.423s)
[418.242332] [063/137] (591s left) perf_pmu (busy-no-semaphores)
[418.417803] Starting subtest: busy-no-semaphores
[418.419559] Starting dynamic subtest: rcs0
[418.942192] Dynamic subtest rcs0: SUCCESS (0.522s)
[418.963224] Starting dynamic subtest: bcs0
[419.464705] Dynamic subtest bcs0: SUCCESS (0.521s)
[419.483644] Starting dynamic subtest: vcs0
[419.982642] Dynamic subtest vcs0: SUCCESS (0.516s)
[420.001988] Starting dynamic subtest: vecs0
[420.501501] Dynamic subtest vecs0: SUCCESS (0.517s)
[420.503127] Subtest busy-no-semaphores: SUCCESS (2.082s)
[420.606154] [064/137] (589s left) kms_vblank (pipe-d-ts-continuation-modeset-hang)
[420.874515] Subtest pipe-D-ts-continuation-modeset-hang: SKIP (0.000s)
[420.958545] [065/137] (589s left) gem_basic (create-close)
[421.127603] Starting subtest: create-close
[421.130325] Subtest create-close: SUCCESS (0.000s)
[421.223722] [066/137] (588s left) gem_exec_suspend (basic-s3)
[421.414918] Starting subtest: basic-S3
[421.416503] Starting dynamic subtest: smem
[442.170433] Dynamic subtest smem: SUCCESS (5.777s)
[442.171786] Subtest basic-S3: SUCCESS (5.778s)
[444.365578] [067/137] (582s left) gen9_exec_parse (basic-rejected)
[444.570890] Starting subtest: basic-rejected
[444.574733] Subtest basic-rejected: SUCCESS (0.003s)
[444.792701] [068/137] (582s left) syncobj_wait (invalid-reset-bad-pad)
[444.966565] Starting subtest: invalid-reset-bad-pad
[444.968133] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[445.058404] [069/137] (582s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[445.333372] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[445.336029] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[445.426770] [070/137] (581s left) gem_exec_reloc (basic-range-active)
[445.610150] Starting subtest: basic-range-active
[445.699905] Subtest basic-range-active: SUCCESS (0.088s)
[445.877724] [071/137] (581s left) i915_pm_dc (dc6-psr)
[447.163311] Starting subtest: dc6-psr
[447.167847] Subtest dc6-psr: SKIP (0.000s)
[447.327044] [072/137] (579s left) gem_ctx_persistence (legacy-engines-mixed)
[447.507939] Starting subtest: legacy-engines-mixed
[447.512109] Starting dynamic subtest: render
[447.561770] Dynamic subtest render: SUCCESS (0.052s)
[447.587415] Starting dynamic subtest: bsd
[447.613567] Dynamic subtest bsd: SUCCESS (0.051s)
[447.641922] Starting dynamic subtest: blt
[447.669780] Dynamic subtest blt: SUCCESS (0.054s)
[447.696577] Starting dynamic subtest: vebox
[447.714523] Dynamic subtest vebox: SUCCESS (0.042s)
[447.716089] Subtest legacy-engines-mixed: SUCCESS (0.206s)
[447.811047] [073/137] (579s left) kms_prop_blob (basic)
[447.981652] Starting subtest: basic
[447.983570] Subtest basic: SUCCESS (0.000s)
[448.075043] [074/137] (579s left) gem_exec_balancer (parallel-balancer)
[452.077946] Subtest parallel-balancer: SKIP (0.000s)
[452.176272] [075/137] (575s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[452.450526] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[452.453178] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[452.543238] [076/137] (574s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[452.821326] Starting subtest: cursorB-vs-flipA-atomic-transitions
[452.824580] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.004s)
[452.910408] [077/137] (574s left) gem_exec_whisper (basic-contexts-forked-all)
[453.107352] Starting subtest: basic-contexts-forked-all
[476.841052] Subtest basic-contexts-forked-all: SUCCESS (23.731s)
[477.043601] [078/137] (550s left) syncobj_timeline (single-wait-all-signaled)
[477.219899] Starting subtest: single-wait-all-signaled
[477.221869] Subtest single-wait-all-signaled: SUCCESS (0.001s)
[477.310471] [079/137] (550s left) kms_ccs (pipe-c-crc-primary-basic-4_tiled_dg2_mc_ccs)
[477.784772] Starting subtest: pipe-C-crc-primary-basic-4_tiled_dg2_mc_ccs
[477.787542] Subtest pipe-C-crc-primary-basic-4_tiled_dg2_mc_ccs: SKIP (0.001s)
[478.131438] [080/137] (549s left) syncobj_basic (bad-flags-fd-to-handle)
[478.304339] Starting subtest: bad-flags-fd-to-handle
[478.306174] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[478.398370] [081/137] (549s left) vc4/vc4_wait_bo (used-bo)
[478.624998] Subtest used-bo: SKIP (0.000s)
[478.698721] [082/137] (548s left) gem_exec_whisper (basic-queues-priority-all)
[478.890968] Starting subtest: basic-queues-priority-all
[501.451195] Subtest basic-queues-priority-all: SUCCESS (22.557s)
[501.647604] [083/137] (526s left) kms_content_protection (legacy)
[501.949318] Starting subtest: legacy
[502.144338] Starting dynamic subtest: pipe-A-DP-1
[622.884418] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[623.617030] Closing watchdogs
[623.622818] Initializing watchdogs
[623.623027]   /dev/watchdog0
[623.650217] [084/137] (404s left) kms_ccs (pipe-c-bad-aux-stride-y_tiled_gen12_rc_ccs_cc)
[624.149157] Starting subtest: pipe-C-bad-aux-stride-y_tiled_gen12_rc_ccs_cc
[624.151871] Subtest pipe-C-bad-aux-stride-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[624.476000] [085/137] (403s left) kms_selftest (all-tests)
[624.647890] Starting subtest: all-tests
[624.651285] Subtest all-tests: SKIP (0.000s)
[624.726780] [086/137] (403s left) kms_chamelium_frames (dp-crc-multiple)
[625.083371] Subtest dp-crc-multiple: SKIP (0.000s)
[625.353472] [087/137] (402s left) gem_exec_fence (syncobj-timeline-signal)
[626.099453] Starting subtest: syncobj-timeline-signal
[626.110187] Subtest syncobj-timeline-signal: SUCCESS (0.012s)
[626.329163] [088/137] (401s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[626.614240] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[629.205104] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (2.592s)
[629.362758] [089/137] (398s left) syncobj_wait (single-wait-for-submit-submitted)
[629.539668] Starting subtest: single-wait-for-submit-submitted
[629.646207] Subtest single-wait-for-submit-submitted: SUCCESS (0.107s)
[629.728203] [090/137] (398s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[630.023668] Starting subtest: y-tiled-16bpp-rotate-270
[630.099511] Subtest y-tiled-16bpp-rotate-270: SKIP (0.072s)
[630.212482] [091/137] (397s left) prime_self_import (reimport-vs-gem_close-race)
[630.383031] Starting subtest: reimport-vs-gem_close-race
[635.408350] Subtest reimport-vs-gem_close-race: SUCCESS (5.024s)
[635.495031] [092/137] (392s left) i915_pm_rps (min-max-config-idle)
[635.680676] Starting subtest: min-max-config-idle
[636.030580] Subtest min-max-config-idle: SUCCESS (0.353s)
[636.130794] [093/137] (391s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[636.409247] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[636.411926] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[636.512660] [094/137] (391s left) drm_fdinfo (idle)
[636.692268] Starting subtest: idle
[636.693932] Starting dynamic subtest: rcs0
[637.199896] Dynamic subtest rcs0: SUCCESS (0.505s)
[637.224265] Starting dynamic subtest: bcs0
[637.704927] Dynamic subtest bcs0: SUCCESS (0.504s)
[637.728031] Starting dynamic subtest: vcs0
[638.210509] Dynamic subtest vcs0: SUCCESS (0.504s)
[638.234135] Starting dynamic subtest: vecs0
[638.715177] Dynamic subtest vecs0: SUCCESS (0.504s)
[638.716555] Subtest idle: SUCCESS (2.021s)
[638.794690] [095/137] (389s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[639.071213] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[639.073974] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[639.178689] [096/137] (389s left) kms_flip (2x-nonexisting-fb)
[639.434508] Starting subtest: 2x-nonexisting-fb
[639.437135] Subtest 2x-nonexisting-fb: SKIP (0.003s)
[639.545778] [097/137] (388s left) vc4/vc4_create_bo (create-bo-4096)
[639.770904] Subtest create-bo-4096: SKIP (0.000s)
[639.845919] [098/137] (388s left) kms_lease (lease_invalid_crtc)
[640.115264] Starting subtest: lease_invalid_crtc
[640.116597] Starting dynamic subtest: pipe-A-DP-1
[640.118029] Dynamic subtest pipe-A-DP-1: SUCCESS (0.000s)
[640.141315] Starting dynamic subtest: pipe-B-DP-1
[640.142662] Dynamic subtest pipe-B-DP-1: SUCCESS (0.000s)
[640.165554] Starting dynamic subtest: pipe-C-DP-1
[640.166923] Dynamic subtest pipe-C-DP-1: SUCCESS (0.000s)
[640.168204] Subtest lease_invalid_crtc: SUCCESS (0.007s)
[640.212114] [099/137] (388s left) kms_getfb (getfb2-into-addfb2)
[640.389060] Starting subtest: getfb2-into-addfb2
[640.390584] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[640.480417] [100/137] (387s left) kms_flip (2x-flip-vs-fences)
[640.729373] Starting subtest: 2x-flip-vs-fences
[640.736813] Subtest 2x-flip-vs-fences: SKIP (0.003s)
[640.845498] [101/137] (387s left) kms_ccs (pipe-a-ccs-on-another-bo-y_tiled_gen12_rc_ccs)
[641.228756] Starting subtest: pipe-A-ccs-on-another-bo-y_tiled_gen12_rc_ccs
[641.231803] Subtest pipe-A-ccs-on-another-bo-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[641.650495] [102/137] (386s left) drm_read (invalid-buffer)
[642.045439] Starting subtest: invalid-buffer
[642.046871] Subtest invalid-buffer: SUCCESS (0.000s)
[642.168204] [103/137] (386s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[642.456314] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[642.459083] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[642.567352] [104/137] (385s left) gem_render_copy (x-tiled)
[642.755450] Starting subtest: x-tiled
[642.757299] Starting dynamic subtest: smem
[643.037422] Dynamic subtest smem: SUCCESS (0.279s)
[643.038818] Subtest x-tiled: SUCCESS (0.281s)
[643.235350] [105/137] (385s left) v3d/v3d_submit_cl (valid-multisync-submission)
[643.459257] Subtest valid-multisync-submission: SKIP (0.000s)
[643.533429] [106/137] (385s left) syncobj_timeline (multi-wait-available-submitted)
[643.710029] Starting subtest: multi-wait-available-submitted
[643.712145] Subtest multi-wait-available-submitted: SUCCESS (0.002s)
[643.799758] [107/137] (384s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[644.092566] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[645.324258] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (1.233s)
[645.650494] [108/137] (383s left) kms_getfb (getfb2-accept-ccs)
[645.825620] Starting subtest: getfb2-accept-ccs
[645.827352] Subtest getfb2-accept-ccs: SUCCESS (0.000s)
[645.934595] [109/137] (382s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[646.215731] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[646.218990] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[646.334119] [110/137] (382s left) kms_cursor_edge_walk (256x256-top-edge)
[646.604188] Starting subtest: 256x256-top-edge
[646.605563] Starting dynamic subtest: pipe-A-DP-1
[650.241976] Dynamic subtest pipe-A-DP-1: SUCCESS (3.639s)
[650.269079] Starting dynamic subtest: pipe-C-DP-1
[653.732763] Dynamic subtest pipe-C-DP-1: SUCCESS (3.487s)
[653.734325] Subtest 256x256-top-edge: SUCCESS (7.133s)
[654.045036] [111/137] (374s left) gem_ctx_sseu (invalid-args)
[654.225689] Subtest invalid-args: SKIP (0.000s)
[654.279438] [112/137] (374s left) kms_big_fb (linear-8bpp-rotate-0)
[654.576492] Starting subtest: linear-8bpp-rotate-0
[658.435219] Subtest linear-8bpp-rotate-0: SUCCESS (3.857s)
[658.693979] [113/137] (370s left) gem_userptr_blits (sync-unmap-cycles)
[658.900582] Starting subtest: sync-unmap-cycles
[664.276985] Subtest sync-unmap-cycles: SUCCESS (5.375s)
[664.409993] [114/137] (364s left) fbdev (unaligned-write)
[664.603488] Starting subtest: unaligned-write
[664.789074] Subtest unaligned-write: SUCCESS (0.185s)
[664.860480] [115/137] (364s left) gem_userptr_blits (create-destroy-sync)
[665.065605] Starting subtest: create-destroy-sync
[670.137379] Subtest create-destroy-sync: SUCCESS (5.070s)
[670.260159] [116/137] (358s left) gem_tiled_partial_pwrite_pread (writes)
[670.443450] Starting subtest: writes
[672.527997] Subtest writes: SUCCESS (2.084s)
[672.643028] [117/137] (356s left) kms_plane (pixel-format-source-clamping)
[672.916101] Starting subtest: pixel-format-source-clamping
[672.917385] Starting dynamic subtest: pipe-A-planes
[679.247184] Dynamic subtest pipe-A-planes: SUCCESS (6.332s)
[679.297883] Starting dynamic subtest: pipe-B-planes
[685.799214] Dynamic subtest pipe-B-planes: SUCCESS (6.547s)
[685.800705] Subtest pixel-format-source-clamping: SUCCESS (12.887s)
[686.125917] [118/137] (343s left) kms_ccs (pipe-a-random-ccs-data-4_tiled_dg2_mc_ccs)
[686.495867] Starting subtest: pipe-A-random-ccs-data-4_tiled_dg2_mc_ccs
[686.499789] Subtest pipe-A-random-ccs-data-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[686.926615] [119/137] (342s left) perf (i915-ref-count)
[687.168436] Starting subtest: i915-ref-count
[687.270291] Subtest i915-ref-count: SUCCESS (0.102s)
[687.341230] [120/137] (341s left) gem_exec_params (no-blt)
[687.526985] Starting subtest: no-blt
[687.531061] Subtest no-blt: SUCCESS (0.003s)
[687.642220] [121/137] (341s left) syncobj_wait (invalid-reset-zero-handles)
[687.816566] Starting subtest: invalid-reset-zero-handles
[687.818354] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[687.908741] [122/137] (341s left) sysfs_heartbeat_interval (mixed)
[688.088129] Starting subtest: mixed
[688.092677] Starting dynamic subtest: vecs0
[693.315514] Dynamic subtest vecs0: SUCCESS (5.225s)
[693.340882] Starting dynamic subtest: vcs0
[698.537351] Dynamic subtest vcs0: SUCCESS (5.220s)
[698.564774] Starting dynamic subtest: bcs0
[703.778496] Dynamic subtest bcs0: SUCCESS (5.240s)
[703.803095] Starting dynamic subtest: rcs0
[709.030749] Dynamic subtest rcs0: SUCCESS (5.250s)
[709.032393] Subtest mixed: SUCCESS (20.943s)
[709.124700] [123/137] (320s left) api_intel_allocator (reopen-fork)
[709.297874] Starting subtest: reopen-fork
[712.572355] Subtest reopen-fork: SUCCESS (3.273s)
[712.658777] [124/137] (316s left) syncobj_timeline (invalid-wait-zero-handles)
[712.833518] Starting subtest: invalid-wait-zero-handles
[712.835433] Subtest invalid-wait-zero-handles: SUCCESS (0.000s)
[712.924632] [125/137] (316s left) kms_ccs (pipe-b-bad-pixel-format-y_tiled_gen12_rc_ccs)
[713.323892] Starting subtest: pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs
[713.326676] Subtest pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[713.736098] [126/137] (315s left) kms_vblank (pipe-c-accuracy-idle)
[714.009864] Starting subtest: pipe-C-accuracy-idle
[716.563785] Subtest pipe-C-accuracy-idle: SUCCESS (2.553s)
[716.895909] [127/137] (312s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[717.182356] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[717.185041] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[717.279125] [128/137] (312s left) gem_exec_schedule (preempt-queue)
[717.483318] Starting subtest: preempt-queue
[717.485051] Starting dynamic subtest: rcs0
[717.855625] Dynamic subtest rcs0: SUCCESS (0.371s)
[717.887624] Starting dynamic subtest: bcs0
[718.250924] Dynamic subtest bcs0: SUCCESS (0.393s)
[718.280283] Starting dynamic subtest: vcs0
[718.621637] Dynamic subtest vcs0: SUCCESS (0.370s)
[718.650731] Starting dynamic subtest: vecs0
[718.994214] Dynamic subtest vecs0: SUCCESS (0.371s)
[718.995743] Subtest preempt-queue: SUCCESS (1.512s)
[719.347682] [129/137] (310s left) kms_rotation_crc (sprite-rotation-90)
[719.618553] Starting subtest: sprite-rotation-90
[725.709927] Subtest sprite-rotation-90: SUCCESS (6.093s)
[726.138249] [130/137] (303s left) gem_exec_flush (basic-uc-prw-default)
[726.334123] Starting subtest: basic-uc-prw-default
[731.792272] Subtest basic-uc-prw-default: SUCCESS (5.458s)
[732.003642] [131/137] (297s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[732.359530] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[732.646414] [132/137] (297s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[732.917277] Starting subtest: 2x-cursor-vs-flip-atomic
[732.920374] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.004s)
[733.004312] [133/137] (296s left) gem_exec_balancer (hog)
[733.200660] Starting subtest: hog
[736.971236] Subtest hog: SUCCESS (3.768s)
[740.887772] [134/137] (288s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[741.171579] Starting subtest: read-crc-frame-sequence
[741.173179] Starting dynamic subtest: pipe-A-DP-1
[741.688930] Dynamic subtest pipe-A-DP-1: SUCCESS (0.517s)
[741.717255] Starting dynamic subtest: pipe-B-DP-1
[742.382156] Dynamic subtest pipe-B-DP-1: SUCCESS (0.687s)
[742.408739] Starting dynamic subtest: pipe-C-DP-1
[743.085549] Dynamic subtest pipe-C-DP-1: SUCCESS (0.703s)
[743.087088] Subtest read-crc-frame-sequence: SUCCESS (1.918s)
[743.398696] [135/137] (286s left) gem_spin_batch (engines)
[743.594554] Starting subtest: engines
[743.596155] Starting dynamic subtest: rcs0
[746.923137] Dynamic subtest rcs0: SUCCESS (3.324s)
[746.946633] Starting dynamic subtest: bcs0
[750.248524] Dynamic subtest bcs0: SUCCESS (3.323s)
[750.271690] Starting dynamic subtest: vcs0
[753.571529] Dynamic subtest vcs0: SUCCESS (3.322s)
[753.594845] Starting dynamic subtest: vecs0
[756.892327] Dynamic subtest vecs0: SUCCESS (3.320s)
[756.893944] Subtest engines: SUCCESS (13.295s)
[757.097067] [136/137] (272s left) gem_mmap_gtt (cpuset-big-copy)
[757.273198] Starting subtest: cpuset-big-copy
[780.081536] Subtest cpuset-big-copy: SUCCESS (22.809s)
[780.514468] [137/137] (249s left) i915_pm_dc (dc5-dpms-negative)
[781.942487] Starting subtest: dc5-dpms-negative
[786.256010] Subtest dc5-dpms-negative: SUCCESS (4.312s)
[786.460191] Closing watchdogs
Done.