[48.397217] Initializing watchdogs
[48.397448]   /dev/watchdog0
[48.415786] [001/137] (960s left) vc4/vc4_purgeable_bo (mark-purgeable-twice)
[48.662794] Subtest mark-purgeable-twice: SKIP (0.000s)
[48.727617] [002/137] (960s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[49.025462] Starting subtest: x-tiled-32bpp-rotate-180
[54.042722] Subtest x-tiled-32bpp-rotate-180: SUCCESS (5.018s)
[55.508702] [003/137] (953s left) syncobj_timeline (multi-wait-for-submit-signaled)
[55.698722] Starting subtest: multi-wait-for-submit-signaled
[55.703875] Subtest multi-wait-for-submit-signaled: SUCCESS (0.003s)
[55.772927] [004/137] (953s left) gem_readwrite (read-bad-handle)
[55.950792] Starting subtest: read-bad-handle
[55.954821] Subtest read-bad-handle: SUCCESS (0.000s)
[56.040898] [005/137] (952s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[56.334954] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[56.338880] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[56.424711] [006/137] (952s left) kms_busy (basic)
[56.740830] Starting subtest: basic
[56.742932] Starting dynamic subtest: flip
[57.358646] Dynamic subtest flip: SUCCESS (0.596s)
[57.372496] Starting dynamic subtest: modeset
[58.778968] Dynamic subtest modeset: SUCCESS (1.440s)
[58.781174] Subtest basic: SUCCESS (2.039s)
[59.127238] [007/137] (949s left) i915_module_load (load)
[59.304330] Starting subtest: load
[59.310789] Subtest load: SKIP (0.003s)
[59.375062] [008/137] (949s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[59.655752] Starting subtest: short-flip-before-cursor-atomic-transitions
[60.743790] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (1.093s)
[61.056982] [009/137] (948s left) kms_addfb_basic (bad-pitch-256)
[61.237293] Starting subtest: bad-pitch-256
[61.239377] Subtest bad-pitch-256: SUCCESS (0.000s)
[61.622509] [010/137] (947s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[61.930972] Starting subtest: 4-tiled-64bpp-rotate-0
[61.934874] Subtest 4-tiled-64bpp-rotate-0: SKIP (0.000s)
[62.038851] [011/137] (947s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[62.334918] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[63.672725] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.338s)
[63.873746] [012/137] (945s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[64.158489] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[64.162598] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[64.255310] [013/137] (945s left) sysfs_timeslice_duration (timeout)
[64.440964] Starting subtest: timeout
[64.443532] Starting dynamic subtest: vecs0
[65.332789] Dynamic subtest vecs0: SUCCESS (0.890s)
[65.350295] Starting dynamic subtest: vcs0
[66.221313] Dynamic subtest vcs0: SUCCESS (0.888s)
[66.236826] Starting dynamic subtest: bcs0
[67.126132] Dynamic subtest bcs0: SUCCESS (0.905s)
[67.144336] Starting dynamic subtest: rcs0
[68.013654] Dynamic subtest rcs0: SUCCESS (0.887s)
[68.015874] Subtest timeout: SUCCESS (3.572s)
[68.087338] [014/137] (941s left) dumb_buffer (map-uaf)
[68.269477] Starting subtest: map-uaf
[68.332571] Subtest map-uaf: SUCCESS (0.065s)
[68.470364] [015/137] (940s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[68.746426] Starting subtest: cursorB-vs-flipA-toggle
[68.750692] Subtest cursorB-vs-flipA-toggle: SKIP (0.004s)
[68.823284] [016/137] (940s left) kms_content_protection (mei_interface)
[69.140538] Starting subtest: mei_interface
[69.835136] Subtest mei_interface: SKIP (0.691s)
[70.253156] [017/137] (939s left) api_intel_allocator (default-alignment)
[70.430684] Starting subtest: default-alignment
[70.433495] Subtest default-alignment: SUCCESS (0.003s)
[70.535972] [018/137] (938s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[70.903763] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[71.171650] [019/137] (938s left) kms_lease (lease_unleased_connector)
[71.442985] Starting subtest: lease_unleased_connector
[71.444951] Starting dynamic subtest: pipe-A-DP-1
[71.612511] Dynamic subtest pipe-A-DP-1: SUCCESS (0.163s)
[71.631417] Starting dynamic subtest: pipe-B-DP-1
[71.785634] Dynamic subtest pipe-B-DP-1: SUCCESS (0.172s)
[71.800408] Starting dynamic subtest: pipe-C-DP-1
[71.955730] Dynamic subtest pipe-C-DP-1: SUCCESS (0.171s)
[71.957832] Subtest lease_unleased_connector: SUCCESS (0.512s)
[72.031041] [020/137] (937s left) gem_ctx_param (invalid-ctx-set)
[72.210856] Starting subtest: invalid-ctx-set
[72.213079] Subtest invalid-ctx-set: SUCCESS (0.000s)
[72.280514] [021/137] (937s left) kms_ccs (pipe-c-bad-pixel-format-y_tiled_gen12_rc_ccs)
[72.809086] Starting subtest: pipe-C-bad-pixel-format-y_tiled_gen12_rc_ccs
[72.812792] Subtest pipe-C-bad-pixel-format-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[73.206948] [022/137] (936s left) gem_userptr_blits (invalid-null-pointer)
[73.396317] Starting subtest: invalid-null-pointer
[73.398517] Subtest invalid-null-pointer: SUCCESS (0.005s)
[73.541283] [023/137] (936s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[73.813560] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[73.817368] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[73.890705] [024/137] (935s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[74.175861] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[74.179811] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[74.257460] [025/137] (935s left) gem_ctx_shared (single-timeline)
[74.453461] Starting subtest: single-timeline
[74.471538] Subtest single-timeline: SUCCESS (0.015s)
[74.691301] [026/137] (934s left) i915_query (test-query-geometry-subslices)
[74.867074] Starting subtest: test-query-geometry-subslices
[74.871078] Subtest test-query-geometry-subslices: SKIP (0.000s)
[74.940809] [027/137] (934s left) kms_ccs (pipe-c-missing-ccs-buffer-y_tiled_ccs)
[75.520115] Starting subtest: pipe-C-missing-ccs-buffer-y_tiled_ccs
[75.524046] Subtest pipe-C-missing-ccs-buffer-y_tiled_ccs: SKIP (0.000s)
[75.867137] [028/137] (933s left) gem_basic (create-close)
[76.039763] Starting subtest: create-close
[76.043838] Subtest create-close: SUCCESS (0.000s)
[76.133050] [029/137] (933s left) gem_softpin (full)
[76.315112] Starting subtest: full
[76.333836] Subtest full: SUCCESS (0.017s)
[76.434867] [030/137] (933s left) kms_setmode (invalid-clone-exclusive-crtc)
[76.609452] Starting subtest: invalid-clone-exclusive-crtc
[76.615332] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[76.687395] [031/137] (933s left) syncobj_timeline (single-wait-available-submitted)
[76.861236] Starting subtest: single-wait-available-submitted
[76.863695] Subtest single-wait-available-submitted: SUCCESS (0.001s)
[76.933119] [032/137] (932s left) v3d/v3d_perfmon (get-values-valid-perfmon)
[77.152080] Subtest get-values-valid-perfmon: SKIP (0.000s)
[77.216204] [033/137] (932s left) kms_vblank (pipe-d-ts-continuation-modeset)
[77.495635] Subtest pipe-D-ts-continuation-modeset: SKIP (0.000s)
[77.566792] [034/137] (932s left) kms_vblank (pipe-a-query-idle-hang)
[77.840901] Starting subtest: pipe-A-query-idle-hang
[84.547676] Subtest pipe-A-query-idle-hang: SUCCESS (6.711s)
[84.887966] [035/137] (925s left) api_intel_allocator (two-level-inception)
[85.063631] Starting subtest: two-level-inception
[90.554129] Subtest two-level-inception: SUCCESS (5.489s)
[90.636115] [036/137] (919s left) kms_ccs (pipe-c-bad-rotation-90-y_tiled_gen12_rc_ccs_cc)
[91.192577] Starting subtest: pipe-C-bad-rotation-90-y_tiled_gen12_rc_ccs_cc
[91.196821] Subtest pipe-C-bad-rotation-90-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[91.580940] [037/137] (918s left) kms_flip (nonexisting-fb)
[91.836119] Starting subtest: nonexisting-fb
[91.838077] Starting dynamic subtest: A-DP1
[92.360144] Dynamic subtest A-DP1: SUCCESS (0.521s)
[92.375491] Starting dynamic subtest: B-DP1
[92.791944] Dynamic subtest B-DP1: SUCCESS (0.434s)
[92.811442] Starting dynamic subtest: C-DP1
[93.257569] Dynamic subtest C-DP1: SUCCESS (0.466s)
[93.259832] Subtest nonexisting-fb: SUCCESS (1.428s)
[93.665868] [038/137] (916s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[93.941763] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[93.945533] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[94.047770] [039/137] (916s left) sw_sync (timeline_closed)
[94.216712] Starting subtest: timeline_closed
[94.218965] Subtest timeline_closed: SUCCESS (0.000s)
[94.281514] [040/137] (915s left) kms_ccs (pipe-a-crc-primary-rotation-180-y_tiled_gen12_rc_ccs)
[94.648718] Starting subtest: pipe-A-crc-primary-rotation-180-y_tiled_gen12_rc_ccs
[94.652735] Subtest pipe-A-crc-primary-rotation-180-y_tiled_gen12_rc_ccs: SKIP (0.001s)
[95.195909] [041/137] (914s left) gem_exec_reloc (basic-write-cpu-active)
[95.378785] Starting subtest: basic-write-cpu-active
[95.515240] Subtest basic-write-cpu-active: SUCCESS (0.135s)
[95.696533] [042/137] (914s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[95.964489] Starting subtest: plane-all-modeset-transition-fencing
[95.966590] Starting dynamic subtest: pipe-A-DP-1
[153.084800] Dynamic subtest pipe-A-DP-1: SUCCESS (57.120s)
[153.201483] Starting dynamic subtest: pipe-B-DP-1
[210.039417] Dynamic subtest pipe-B-DP-1: SUCCESS (56.851s)
[210.142155] Subtest plane-all-modeset-transition-fencing: SUCCESS (114.175s)
[210.463396] [043/137] (799s left) gem_userptr_blits (probe)
[210.725087] Starting subtest: probe
[211.838272] Subtest probe: SUCCESS (1.112s)
[211.945842] [044/137] (798s left) gem_eio (in-flight-internal-1us)
[212.148041] Starting subtest: in-flight-internal-1us
[212.250388] Subtest in-flight-internal-1us: SUCCESS (0.103s)
[212.433320] [045/137] (797s left) gem_eio (hibernate)
[212.628241] Starting subtest: hibernate
[228.164342] Subtest hibernate: SUCCESS (15.539s)
[233.369670] [046/137] (781s left) kms_psr (psr2_cursor_mmap_gtt)
[233.553856] Subtest psr2_cursor_mmap_gtt: SKIP (0.000s)
[233.596415] [047/137] (781s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[233.871042] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[233.874815] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[233.960146] [048/137] (781s left) kms_prop_blob (invalid-get-prop-any)
[234.133473] Starting subtest: invalid-get-prop-any
[234.135789] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[234.209892] [049/137] (781s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[234.503098] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[236.855050] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (2.360s)
[236.977058] [050/137] (778s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[237.258116] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[237.262121] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[237.360414] [051/137] (778s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[237.646474] Starting subtest: psr-rgb101010-draw-render
[237.650321] Subtest psr-rgb101010-draw-render: SKIP (0.000s)
[237.743772] [052/137] (777s left) sw_sync (sync_busy_fork_unixsocket)
[237.916462] Starting subtest: sync_busy_fork_unixsocket
[237.940165] Subtest sync_busy_fork_unixsocket: SUCCESS (0.027s)
[238.010485] [053/137] (777s left) gem_ctx_param (invalid-size-get)
[238.181527] Starting subtest: invalid-size-get
[238.183795] Subtest invalid-size-get: SUCCESS (0.000s)
[238.260624] [054/137] (777s left) gem_exec_schedule (preempt-contexts)
[238.461877] Starting subtest: preempt-contexts
[238.467584] Starting dynamic subtest: rcs0
[238.590539] Dynamic subtest rcs0: SUCCESS (0.123s)
[238.613349] Starting dynamic subtest: bcs0
[238.737508] Dynamic subtest bcs0: SUCCESS (0.146s)
[238.757053] Starting dynamic subtest: vcs0
[238.852114] Dynamic subtest vcs0: SUCCESS (0.113s)
[238.876450] Starting dynamic subtest: vecs0
[238.965347] Dynamic subtest vecs0: SUCCESS (0.112s)
[238.967454] Subtest preempt-contexts: SUCCESS (0.502s)
[239.311971] [055/137] (776s left) kms_psr (psr2_primary_mmap_cpu)
[239.484064] Subtest psr2_primary_mmap_cpu: SKIP (0.000s)
[239.529341] [056/137] (776s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[239.812304] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[242.088400] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (2.284s)
[242.210885] [057/137] (773s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[242.508994] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[243.721669] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (1.213s)
[243.944871] [058/137] (771s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[244.227864] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[244.231873] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[244.326750] [059/137] (771s left) gem_exec_whisper (basic-queues-forked-all)
[244.524262] Starting subtest: basic-queues-forked-all
[267.291384] Subtest basic-queues-forked-all: SUCCESS (22.765s)
[267.496277] [060/137] (748s left) kms_universal_plane (universal-plane-pipe-c-functional)
[267.768709] Starting subtest: universal-plane-pipe-C-functional
[270.722905] Subtest universal-plane-pipe-C-functional: SUCCESS (2.957s)
[271.035936] [061/137] (744s left) kms_plane_scaling (plane-downscale-with-modifiers-factor-0-5)
[271.308772] Starting subtest: plane-downscale-with-modifiers-factor-0-5
[271.310986] Starting dynamic subtest: pipe-A-DP-1
[272.473747] Dynamic subtest pipe-A-DP-1: SUCCESS (1.165s)
[272.495616] Starting dynamic subtest: pipe-B-DP-1
[273.712594] Dynamic subtest pipe-B-DP-1: SUCCESS (1.206s)
[273.750699] Starting dynamic subtest: pipe-C-DP-1
[274.590165] Dynamic subtest pipe-C-DP-1: SUCCESS (0.904s)
[274.592172] Subtest plane-downscale-with-modifiers-factor-0-5: SUCCESS (3.285s)
[275.005519] [062/137] (740s left) kms_flip (2x-flip-vs-rmfb)
[275.272091] Starting subtest: 2x-flip-vs-rmfb
[275.276053] Subtest 2x-flip-vs-rmfb: SKIP (0.003s)
[275.372699] [063/137] (740s left) prime_vgem (coherency-gtt)
[275.647342] Starting subtest: coherency-gtt
[275.651184] Subtest coherency-gtt: SKIP (0.000s)
[275.754914] [064/137] (740s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[276.033205] Starting subtest: basic-flip-before-cursor-legacy
[277.098706] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.064s)
[277.413459] [065/137] (738s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[277.709852] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[277.714065] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[277.812536] [066/137] (738s left) gem_exec_fence (basic-wait)
[278.132139] Starting subtest: basic-wait
[278.134831] Starting dynamic subtest: rcs0
[278.173444] Dynamic subtest rcs0: SUCCESS (0.040s)
[278.195697] Starting dynamic subtest: bcs0
[278.201352] Dynamic subtest bcs0: SUCCESS (0.025s)
[278.220654] Starting dynamic subtest: vcs0
[278.222698] Dynamic subtest vcs0: SUCCESS (0.020s)
[278.243620] Starting dynamic subtest: vecs0
[278.249133] Dynamic subtest vecs0: SUCCESS (0.025s)
[278.251100] Subtest basic-wait: SUCCESS (0.115s)
[278.880591] [067/137] (737s left) kms_universal_plane (universal-plane-pipe-d-functional)
[279.161767] Subtest universal-plane-pipe-D-functional: SKIP (0.000s)
[279.246409] [068/137] (736s left) gem_lmem_swapping (verify-ccs)
[279.431067] Subtest verify-ccs: SKIP (0.000s)
[279.481424] [069/137] (736s left) kms_ccs (pipe-d-missing-ccs-buffer-yf_tiled_ccs)
[280.095855] Subtest pipe-D-missing-ccs-buffer-yf_tiled_ccs: SKIP (0.000s)
[280.409290] [070/137] (735s left) vgem_basic (mmap)
[280.587141] Starting subtest: mmap
[280.615467] Subtest mmap: SUCCESS (0.028s)
[280.692714] [071/137] (735s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[280.969162] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[280.971704] Starting dynamic subtest: pipe-A-valid-mode
[281.070271] Dynamic subtest pipe-A-valid-mode: SKIP (0.099s)
[281.076227] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.102s)
[281.371567] [072/137] (734s left) kms_addfb_basic (legacy-format)
[281.547220] Starting subtest: legacy-format
[281.992355] Subtest legacy-format: SUCCESS (0.123s)
[282.047188] [073/137] (734s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-wc)
[282.339157] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-wc
[282.342981] Subtest psr-1p-offscren-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[282.437480] [074/137] (733s left) kms_fbcon_fbt (psr)
[282.627876] Starting subtest: psr
[282.632183] Subtest psr: SKIP (0.000s)
[282.716240] [075/137] (733s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[282.887266] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[282.996131] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[283.087745] [076/137] (733s left) drm_fdinfo (virtual-idle)
[283.266241] Starting subtest: virtual-idle
[285.287170] Subtest virtual-idle: SUCCESS (2.017s)
[285.370663] [077/137] (731s left) gem_exec_schedule (semaphore-user)
[285.572307] Starting subtest: semaphore-user
[285.586657] Subtest semaphore-user: SUCCESS (0.017s)
[285.921260] [078/137] (730s left) gem_ctx_persistence (heartbeat-hostile)
[286.106585] Starting subtest: heartbeat-hostile
[287.280319] Subtest heartbeat-hostile: SUCCESS (1.177s)
[287.370591] [079/137] (729s left) api_intel_bb (render)
[287.549343] Starting subtest: render
[287.551915] Starting dynamic subtest: render-none-512
[287.660438] Dynamic subtest render-none-512: SUCCESS (0.109s)
[287.681284] Starting dynamic subtest: render-none-reloc-512
[287.769764] Dynamic subtest render-none-reloc-512: SUCCESS (0.110s)
[287.792679] Starting dynamic subtest: render-none-1024
[288.130087] Dynamic subtest render-none-1024: SUCCESS (0.358s)
[288.152470] Starting dynamic subtest: render-none-reloc-1024
[288.493968] Dynamic subtest render-none-reloc-1024: SUCCESS (0.362s)
[288.514283] Starting dynamic subtest: render-x-512
[288.594949] Dynamic subtest render-x-512: SUCCESS (0.100s)
[288.614909] Starting dynamic subtest: render-x-reloc-512
[288.683338] Dynamic subtest render-x-reloc-512: SUCCESS (0.087s)
[288.703769] Starting dynamic subtest: render-x-1024
[288.992948] Dynamic subtest render-x-1024: SUCCESS (0.308s)
[289.013134] Starting dynamic subtest: render-x-reloc-1024
[289.315104] Dynamic subtest render-x-reloc-1024: SUCCESS (0.321s)
[289.334989] Starting dynamic subtest: render-y-512
[289.416733] Dynamic subtest render-y-512: SUCCESS (0.100s)
[289.436267] Starting dynamic subtest: render-y-reloc-512
[289.505258] Dynamic subtest render-y-reloc-512: SUCCESS (0.087s)
[289.525298] Starting dynamic subtest: render-y-1024
[289.813670] Dynamic subtest render-y-1024: SUCCESS (0.307s)
[289.833977] Starting dynamic subtest: render-y-reloc-1024
[290.133830] Dynamic subtest render-y-reloc-1024: SUCCESS (0.319s)
[290.135825] Subtest render: SUCCESS (2.585s)
[290.253797] [080/137] (726s left) gem_pxp (create-protected-buffer)
[292.943161] Subtest create-protected-buffer: SKIP (0.000s)
[293.020640] [081/137] (723s left) i915_pm_rpm (modeset-non-lpsp-stress)
[294.886328] Starting subtest: modeset-non-lpsp-stress
[301.892640] Subtest modeset-non-lpsp-stress: SUCCESS (7.006s)
[302.127751] [082/137] (714s left) kms_chamelium_frames (dp-crc-multiple)
[302.487482] Subtest dp-crc-multiple: SKIP (0.000s)
[302.803946] [083/137] (713s left) kms_cursor_crc (cursor-random-256x85)
[303.165096] Starting subtest: cursor-random-256x85
[303.188113] Starting dynamic subtest: pipe-A-DP-1
[306.951953] Dynamic subtest pipe-A-DP-1: SUCCESS (3.810s)
[307.036527] Starting dynamic subtest: pipe-B-DP-1
[311.021461] Dynamic subtest pipe-B-DP-1: SUCCESS (4.002s)
[311.089350] Starting dynamic subtest: pipe-C-DP-1
[315.201453] Dynamic subtest pipe-C-DP-1: SUCCESS (4.131s)
[315.203512] Subtest cursor-random-256x85: SUCCESS (12.073s)
[315.559304] [084/137] (701s left) kms_fbcon_fbt (fbc-suspend)
[315.753156] Starting subtest: fbc-suspend
[365.482786] Subtest fbc-suspend: SUCCESS (16.535s)
[366.272188] [085/137] (684s left) vc4/vc4_wait_bo (unused-bo-1ns)
[366.501687] Subtest unused-bo-1ns: SKIP (0.000s)
[366.575546] [086/137] (684s left) kms_invalid_mode (bad-htotal)
[366.859953] Starting subtest: bad-htotal
[366.863974] Starting dynamic subtest: DP-1-pipe-A
[366.954535] Dynamic subtest DP-1-pipe-A: SUCCESS (0.100s)
[366.986251] Starting dynamic subtest: DP-1-pipe-B
[366.988913] Dynamic subtest DP-1-pipe-B: SUCCESS (0.013s)
[367.016279] Starting dynamic subtest: DP-1-pipe-C
[367.019279] Dynamic subtest DP-1-pipe-C: SUCCESS (0.013s)
[367.022148] Subtest bad-htotal: SUCCESS (0.135s)
[367.293249] [087/137] (683s left) gem_wait (write-busy)
[367.497788] Starting subtest: write-busy
[367.500116] Starting dynamic subtest: all-engines
[368.028003] Dynamic subtest all-engines: SUCCESS (0.529s)
[368.053293] Starting dynamic subtest: rcs0
[368.544821] Dynamic subtest rcs0: SUCCESS (0.516s)
[368.570060] Starting dynamic subtest: bcs0
[369.066629] Dynamic subtest bcs0: SUCCESS (0.521s)
[369.091416] Starting dynamic subtest: vcs0
[369.581656] Dynamic subtest vcs0: SUCCESS (0.514s)
[369.606553] Starting dynamic subtest: vecs0
[370.098887] Dynamic subtest vecs0: SUCCESS (0.516s)
[370.100895] Subtest write-busy: SUCCESS (2.601s)
[370.326665] [088/137] (680s left) gem_exec_balancer (sliced)
[370.525166] Starting subtest: sliced
[374.274107] Subtest sliced: SUCCESS (3.747s)
[378.194250] [089/137] (672s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[378.476232] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[378.480175] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[378.593032] [090/137] (672s left) kms_ccs (pipe-d-random-ccs-data-y_tiled_ccs)
[379.204414] Subtest pipe-D-random-ccs-data-y_tiled_ccs: SKIP (0.000s)
[379.510456] [091/137] (671s left) kms_universal_plane (universal-plane-pipe-b-sanity)
[379.789013] Starting subtest: universal-plane-pipe-B-sanity
[380.586352] Subtest universal-plane-pipe-B-sanity: SUCCESS (0.798s)
[380.901688] [092/137] (670s left) i915_pm_dc (dc6-psr)
[382.184356] Starting subtest: dc6-psr
[382.190041] Subtest dc6-psr: SKIP (0.000s)
[382.352027] [093/137] (668s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[382.528678] Starting subtest: etime-single-wait-all-for-submit-submitted
[382.630481] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.101s)
[382.718087] [094/137] (668s left) kms_pipe_crc_basic (nonblocking-crc)
[382.992819] Starting subtest: nonblocking-crc
[382.994910] Starting dynamic subtest: pipe-A-DP-1
[383.589888] Dynamic subtest pipe-A-DP-1: SUCCESS (0.595s)
[383.616695] Starting dynamic subtest: pipe-B-DP-1
[384.460278] Dynamic subtest pipe-B-DP-1: SUCCESS (0.865s)
[384.486611] Starting dynamic subtest: pipe-C-DP-1
[385.438151] Dynamic subtest pipe-C-DP-1: SUCCESS (0.974s)
[385.440246] Subtest nonblocking-crc: SUCCESS (2.445s)
[385.748950] [095/137] (665s left) gem_mmap_gtt (fault-concurrent)
[385.921894] Starting subtest: fault-concurrent
[389.146751] Subtest fault-concurrent: SUCCESS (3.224s)
[389.496690] [096/137] (661s left) gem_create (busy-create)
[389.682581] Starting subtest: busy-create
[389.684668] Starting dynamic subtest: smem0
[421.948587] Dynamic subtest smem0: SUCCESS (32.264s)
[421.950712] Subtest busy-create: SUCCESS (32.265s)
[422.149399] [097/137] (629s left) prime_vgem (basic-write)
[422.336722] Starting subtest: basic-write
[422.394170] Subtest basic-write: SUCCESS (0.057s)
[422.480419] [098/137] (628s left) gem_ctx_engines (execute-oneforall)
[422.672781] Starting subtest: execute-oneforall
[423.331095] Subtest execute-oneforall: SUCCESS (0.658s)
[423.547930] [099/137] (627s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc)
[423.831207] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc
[423.835144] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[423.932234] [100/137] (627s left) vc4/vc4_label_bo (set-bad-handle)
[424.158502] Subtest set-bad-handle: SKIP (0.000s)
[424.233613] [101/137] (627s left) kms_vblank (pipe-c-query-busy)
[424.507623] Starting subtest: pipe-C-query-busy
[427.448682] Subtest pipe-C-query-busy: SUCCESS (2.945s)
[427.784476] [102/137] (623s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[428.111300] Starting subtest: yf-tiled-64bpp-rotate-0
[428.115430] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[428.288795] [103/137] (623s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-render)
[428.704402] Starting subtest: fbc-1p-offscren-pri-indfb-draw-render
[430.527724] Subtest fbc-1p-offscren-pri-indfb-draw-render: SUCCESS (1.915s)
[430.665996] [104/137] (620s left) gem_exercise_blt (fast-copy)
[430.852816] Starting subtest: fast-copy
[430.855571] Starting dynamic subtest: linear-smem-smem
[430.912286] Dynamic subtest linear-smem-smem: SUCCESS (0.059s)
[430.938702] Starting dynamic subtest: ymajor-smem-smem
[430.964817] Dynamic subtest ymajor-smem-smem: SUCCESS (0.051s)
[430.989347] Starting dynamic subtest: yfmajor-smem-smem
[431.015631] Dynamic subtest yfmajor-smem-smem: SUCCESS (0.049s)
[431.037420] Starting dynamic subtest: tile64-smem-smem
[431.065796] Dynamic subtest tile64-smem-smem: SUCCESS (0.049s)
[431.069790] Subtest fast-copy: SUCCESS (0.214s)
[431.182113] [105/137] (620s left) gem_render_copy (linear)
[431.376440] Starting subtest: linear
[431.378597] Starting dynamic subtest: smem
[431.624685] Dynamic subtest smem: SUCCESS (0.249s)
[431.626824] Subtest linear: SUCCESS (0.250s)
[431.817941] [106/137] (619s left) syncobj_basic (illegal-fd-to-handle)
[431.992705] Starting subtest: illegal-fd-to-handle
[431.994869] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[432.081298] [107/137] (619s left) gem_reg_read (timestamp-monotonic)
[432.255233] Starting subtest: timestamp-monotonic
[436.443056] Subtest timestamp-monotonic: SUCCESS (4.190s)
[436.532198] [108/137] (615s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[436.711338] Starting subtest: no-spare-fences-interruptible
[438.879213] Subtest no-spare-fences-interruptible: SUCCESS (2.168s)
[439.232935] [109/137] (612s left) gen9_exec_parse (secure-batches)
[439.427180] Starting subtest: secure-batches
[439.429366] Subtest secure-batches: SUCCESS (0.000s)
[439.649455] [110/137] (612s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[439.924540] Starting subtest: cursorA-vs-flipB-atomic
[439.928494] Subtest cursorA-vs-flipB-atomic: SKIP (0.002s)
[440.017145] [111/137] (611s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[440.309791] Starting subtest: y-tiled-32bpp-rotate-0
[445.174968] Subtest y-tiled-32bpp-rotate-0: SUCCESS (4.865s)
[446.650624] [112/137] (605s left) kms_ccs (pipe-d-ccs-on-another-bo-y_tiled_ccs)
[447.260363] Subtest pipe-D-ccs-on-another-bo-y_tiled_ccs: SKIP (0.000s)
[447.578453] [113/137] (604s left) kms_psr (primary_mmap_gtt)
[447.755291] Subtest primary_mmap_gtt: SKIP (0.000s)
[447.813390] [114/137] (604s left) gem_mmap_gtt (big-copy-odd)
[447.986602] Starting subtest: big-copy-odd
[461.087432] Subtest big-copy-odd: SUCCESS (13.101s)
[461.249468] [115/137] (590s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[461.655747] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[461.659706] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[461.746547] [116/137] (590s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc)
[462.271022] Starting subtest: pipe-B-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc
[462.278440] Subtest pipe-B-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.005s)
[462.694046] [117/137] (589s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[462.981125] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[462.985221] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[463.093868] [118/137] (589s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[463.282788] Starting subtest: yf-tiled-to-vebox-x-tiled
[463.286692] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[463.477612] [119/137] (588s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[463.749597] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[463.752706] Starting dynamic subtest: pipe-A-valid-mode
[463.872373] Dynamic subtest pipe-A-valid-mode: SKIP (0.118s)
[463.876446] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.121s)
[464.188040] [120/137] (588s left) v3d/v3d_submit_cl (multiple-job-submission)
[464.446509] Subtest multiple-job-submission: SKIP (0.000s)
[464.521142] [121/137] (587s left) gem_exec_schedule (deep)
[464.853417] Starting subtest: deep
[464.855771] Starting dynamic subtest: rcs0
[478.244684] Dynamic subtest rcs0: SUCCESS (13.389s)
[478.274759] Starting dynamic subtest: bcs0
[492.636945] Dynamic subtest bcs0: SUCCESS (14.388s)
[492.679382] Starting dynamic subtest: vcs0
[506.437883] Dynamic subtest vcs0: SUCCESS (13.792s)
[506.475326] Starting dynamic subtest: vecs0
[520.219177] Dynamic subtest vecs0: SUCCESS (13.786s)
[520.225712] Subtest deep: SUCCESS (55.365s)
[521.123765] [122/137] (531s left) gem_exec_flush (basic-uc-set-default)
[521.325761] Starting subtest: basic-uc-set-default
[526.785868] Subtest basic-uc-set-default: SUCCESS (5.460s)
[526.986752] [123/137] (525s left) gem_exec_fence (syncobj-repeat)
[527.599205] Starting subtest: syncobj-repeat
[528.432820] Subtest syncobj-repeat: SUCCESS (0.834s)
[528.787921] [124/137] (523s left) kms_plane_scaling (plane-downscale-with-rotation-factor-0-75)
[529.070801] Starting subtest: plane-downscale-with-rotation-factor-0-75
[529.073048] Starting dynamic subtest: pipe-A-DP-1
[529.165452] Dynamic subtest pipe-A-DP-1: SKIP (0.095s)
[529.198366] Starting dynamic subtest: pipe-B-DP-1
[529.550619] Dynamic subtest pipe-B-DP-1: SKIP (0.382s)
[529.583217] Starting dynamic subtest: pipe-C-DP-1
[529.932589] Dynamic subtest pipe-C-DP-1: SKIP (0.375s)
[529.936487] Subtest plane-downscale-with-rotation-factor-0-75: SKIP (0.863s)
[530.340247] [125/137] (522s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[530.618128] Starting subtest: cursor-vs-flip-toggle
[570.913716] Subtest cursor-vs-flip-toggle: SUCCESS (40.297s)
[571.255578] [126/137] (481s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs)
[571.692139] Starting subtest: pipe-A-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs
[571.700261] Subtest pipe-A-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs: SKIP (0.005s)
[572.223210] [127/137] (480s left) kms_ccs (pipe-b-bad-pixel-format-yf_tiled_ccs)
[572.666757] Starting subtest: pipe-B-bad-pixel-format-yf_tiled_ccs
[572.668849] Subtest pipe-B-bad-pixel-format-yf_tiled_ccs: SUCCESS (0.001s)
[573.174096] [128/137] (479s left) kms_cursor_edge_walk (128x128-right-edge)
[573.452362] Starting subtest: 128x128-right-edge
[573.454626] Starting dynamic subtest: pipe-A-DP-1
[577.084301] Dynamic subtest pipe-A-DP-1: SUCCESS (3.629s)
[577.110716] Starting dynamic subtest: pipe-C-DP-1
[580.549764] Dynamic subtest pipe-C-DP-1: SUCCESS (3.463s)
[580.552402] Subtest 128x128-right-edge: SUCCESS (7.099s)
[580.856765] [129/137] (471s left) gem_mmap_wc (read-write)
[581.032249] Starting subtest: read-write
[581.061381] Subtest read-write: SUCCESS (0.030s)
[581.170858] [130/137] (471s left) gem_exec_balancer (full-late)
[581.368512] Starting subtest: full-late
[585.304401] Subtest full-late: SUCCESS (3.934s)
[589.169521] [131/137] (463s left) perf_pmu (rc6-runtime-pm)
[589.353959] Starting subtest: rc6-runtime-pm
[596.920672] Subtest rc6-runtime-pm: SUCCESS (7.567s)
[597.244257] [132/137] (455s left) perf_pmu (event-wait)
[597.423261] Starting subtest: event-wait
[597.425837] Starting dynamic subtest: rcs0
[597.430597] Dynamic subtest rcs0: SKIP (0.000s)
[597.435732] Subtest event-wait: SKIP (0.001s)
[597.510762] [133/137] (455s left) syncobj_timeline (invalid-query-one-illegal-handle)
[597.687545] Starting subtest: invalid-query-one-illegal-handle
[597.690155] Subtest invalid-query-one-illegal-handle: SUCCESS (0.001s)
[597.775160] [134/137] (455s left) kms_flip (flip-vs-panning-interruptible)
[598.045876] Starting subtest: flip-vs-panning-interruptible
[598.048075] Starting dynamic subtest: A-DP1
[608.621838] Dynamic subtest A-DP1: SUCCESS (10.574s)
[608.648172] Starting dynamic subtest: B-DP1
[619.117192] Dynamic subtest B-DP1: SUCCESS (10.494s)
[619.197268] Starting dynamic subtest: C-DP1
[629.617904] Dynamic subtest C-DP1: SUCCESS (10.496s)
[629.620138] Subtest flip-vs-panning-interruptible: SUCCESS (31.576s)
[630.117788] [135/137] (422s left) kms_color (ctm-0-50)
[630.483709] Starting subtest: ctm-0-50
[630.506484] Starting dynamic subtest: pipe-A-DP-1
[631.618888] Dynamic subtest pipe-A-DP-1: SUCCESS (1.158s)
[631.665890] Starting dynamic subtest: pipe-B-DP-1
[633.048646] Dynamic subtest pipe-B-DP-1: SUCCESS (1.422s)
[633.081241] Starting dynamic subtest: pipe-C-DP-1
[634.626476] Dynamic subtest pipe-C-DP-1: SUCCESS (1.573s)
[634.628736] Subtest ctm-0-50: SUCCESS (4.165s)
[634.951875] [136/137] (418s left) prime_busy (after-wait)
[635.138689] Starting subtest: after-wait
[635.154958] Starting dynamic subtest: rcs0
[635.171470] Dynamic subtest rcs0: SUCCESS (0.018s)
[635.196524] Starting dynamic subtest: bcs0
[635.199138] Dynamic subtest bcs0: SUCCESS (0.026s)
[635.225148] Starting dynamic subtest: vcs0
[635.227200] Dynamic subtest vcs0: SUCCESS (0.019s)
[635.252688] Starting dynamic subtest: vecs0
[635.254755] Dynamic subtest vecs0: SUCCESS (0.021s)
[635.351636] Subtest after-wait: SUCCESS (0.212s)
[635.434404] [137/137] (417s left) gem_mmap_offset (oob-read)
[635.611211] Starting subtest: oob-read
[635.613466] Subtest oob-read: SUCCESS (0.002s)
[635.713071] Closing watchdogs
Done.