[38.416684] Initializing watchdogs
[38.416721]   /dev/watchdog0
[38.424420] [001/133] (960s left) kms_universal_plane (universal-plane-sanity)
[38.553878] Starting subtest: universal-plane-sanity
[38.556376] Starting dynamic subtest: pipe-A-eDP-1
[39.179785] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.624s)
[39.190944] Starting dynamic subtest: pipe-B-eDP-1
[40.458821] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.278s)
[40.470523] Starting dynamic subtest: pipe-C-eDP-1
[41.731661] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.268s)
[41.740834] Starting dynamic subtest: pipe-D-eDP-1
[43.059387] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.325s)
[43.062081] Subtest universal-plane-sanity: SUCCESS (4.501s)
[43.937125] [002/133] (955s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[44.055580] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[44.059892] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[44.133764] [003/133] (954s left) kms_psr (psr2-cursor-blt)
[44.235570] Starting subtest: psr2-cursor-blt
[44.238189] Starting dynamic subtest: eDP-1
[46.037705] Dynamic subtest eDP-1: SUCCESS (1.801s)
[46.041048] Subtest psr2-cursor-blt: SUCCESS (1.801s)
[46.913615] [004/133] (952s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[47.027514] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[47.032138] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[47.105833] [005/133] (951s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[47.250465] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[47.255141] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[47.330474] [006/133] (951s left) kms_plane_alpha_blend (constant-alpha-max)
[47.435796] Starting subtest: constant-alpha-max
[47.668300] Starting dynamic subtest: pipe-A-eDP-1
[48.757521] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.088s)
[48.770227] Starting dynamic subtest: pipe-D-eDP-1
[50.515747] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.754s)
[50.518923] Subtest constant-alpha-max: SUCCESS (3.076s)
[51.386928] [007/133] (947s left) gem_exec_params (invalid-bsd2-flag-on-render)
[51.466349] Starting subtest: invalid-bsd2-flag-on-render
[51.469569] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[51.563714] [008/133] (947s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[51.694593] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[51.698903] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[51.761587] [009/133] (947s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[51.862847] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[51.865376] Starting dynamic subtest: pipe-A-default-mode
[54.772788] Dynamic subtest pipe-A-default-mode: SUCCESS (2.906s)
[54.775537] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.907s)
[55.651627] [010/133] (943s left) kms_properties (crtc-properties-legacy)
[55.783832] Starting subtest: crtc-properties-legacy
[60.031856] Subtest crtc-properties-legacy: SUCCESS (4.242s)
[60.900533] [011/133] (938s left) sw_sync (sync_merge_invalid)
[60.952413] Starting subtest: sync_merge_invalid
[60.977787] Subtest sync_merge_invalid: SUCCESS (0.026s)
[61.053932] [012/133] (938s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[61.115934] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[61.117992] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[61.191870] [013/133] (937s left) gem_exec_schedule (preempt-queue)
[61.277600] Subtest preempt-queue: SKIP (0.000s)
[61.563867] [014/133] (937s left) gem_ctx_param (invalid-size-set)
[61.623700] Starting subtest: invalid-size-set
[61.626838] Subtest invalid-size-set: SUCCESS (0.002s)
[61.715458] [015/133] (937s left) i915_query (query-regions-garbage-items)
[61.778806] Starting subtest: query-regions-garbage-items
[61.781558] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[61.861709] [016/133] (937s left) gem_ctx_bad_destroy (invalid-ctx)
[61.930348] Starting subtest: invalid-ctx
[61.933501] Subtest invalid-ctx: SUCCESS (0.000s)
[61.994840] [017/133] (937s left) kms_cursor_crc (cursor-onscreen-512x170)
[62.259608] Starting subtest: cursor-onscreen-512x170
[62.264429] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[62.390898] [018/133] (936s left) prime_vgem (coherency-gtt)
[62.508384] Starting subtest: coherency-gtt
[62.513204] Subtest coherency-gtt: SKIP (0.000s)
[62.603983] [019/133] (936s left) gem_exec_capture (capture-recoverable)
[62.675450] Starting subtest: capture-recoverable
[62.677756] Subtest capture-recoverable: SUCCESS (0.002s)
[62.788151] [020/133] (936s left) kms_atomic_transition (plane-all-transition-fencing)
[62.908194] Starting subtest: plane-all-transition-fencing
[62.910359] Starting dynamic subtest: pipe-A-eDP-1
[65.405301] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[65.716343] Starting dynamic subtest: pipe-B-eDP-1
[69.028819] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.322s)
[69.329562] Subtest plane-all-transition-fencing: SUCCESS (6.417s)
[70.246207] [021/133] (929s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[70.374968] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[70.379405] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[70.449344] [022/133] (928s left) gem_exec_reloc (basic-cpu)
[70.516856] Subtest basic-cpu: SKIP (0.000s)
[70.562679] [023/133] (928s left) gem_sync (basic-each)
[70.645819] Starting subtest: basic-each
[74.418507] Subtest basic-each: SUCCESS (3.783s)
[74.595620] [024/133] (924s left) kms_psr (pr-primary-blt)
[74.711919] Starting subtest: pr-primary-blt
[74.717216] Subtest pr-primary-blt: SKIP (0.000s)
[74.770122] [025/133] (924s left) kms_cursor_crc (cursor-sliding-512x170)
[75.051681] Starting subtest: cursor-sliding-512x170
[75.056422] Subtest cursor-sliding-512x170: SKIP (0.001s)
[75.201200] [026/133] (924s left) v3d/v3d_submit_cl (single-in-sync)
[75.291644] Subtest single-in-sync: SKIP (0.000s)
[75.329821] [027/133] (924s left) gem_exec_schedule (noreorder)
[75.514956] Starting subtest: noreorder
[75.517673] Starting dynamic subtest: rcs0
[75.583978] Dynamic subtest rcs0: SUCCESS (0.069s)
[75.596108] Starting dynamic subtest: vcs0
[77.440768] Dynamic subtest vcs0: SUCCESS (1.854s)
[77.454404] Starting dynamic subtest: vcs1
[79.454746] Dynamic subtest vcs1: SUCCESS (2.013s)
[79.467109] Starting dynamic subtest: vecs0
[81.463844] Dynamic subtest vecs0: SUCCESS (2.008s)
[81.477041] Starting dynamic subtest: ccs0
[81.560858] Dynamic subtest ccs0: SUCCESS (0.097s)
[81.563576] Subtest noreorder: SUCCESS (6.046s)
[81.743333] [028/133] (917s left) kms_getfb (getfb-handle-protection)
[81.799952] Starting subtest: getfb-handle-protection
[81.834684] Subtest getfb-handle-protection: SUCCESS (0.036s)
[81.944414] [029/133] (917s left) gem_exec_params (no-vebox)
[82.015363] Starting subtest: no-vebox
[82.020858] Subtest no-vebox: SUCCESS (0.004s)
[83.513047] [030/133] (916s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[83.650721] Starting subtest: crc-primary-basic-y-tiled-ccs
[83.653263] Starting dynamic subtest: pipe-A-eDP-1
[83.658061] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[83.670714] Starting dynamic subtest: pipe-B-eDP-1
[83.676048] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[83.693879] Starting dynamic subtest: pipe-C-eDP-1
[83.698387] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[83.704065] Starting dynamic subtest: pipe-D-eDP-1
[83.708303] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[83.712526] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.005s)
[83.727318] [031/133] (915s left) kms_cursor_crc (cursor-onscreen-64x64)
[83.908379] Starting subtest: cursor-onscreen-64x64
[83.913546] Starting dynamic subtest: pipe-A-eDP-1
[86.079648] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.165s)
[86.110153] Starting dynamic subtest: pipe-D-eDP-1
[89.041985] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.937s)
[89.044662] Subtest cursor-onscreen-64x64: SUCCESS (5.132s)
[89.919408] [032/133] (909s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[90.055050] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[90.059690] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[90.131919] [033/133] (909s left) kms_chamelium_color (gamma)
[90.247203] Subtest gamma: SKIP (0.000s)
[90.267780] [034/133] (909s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[90.367811] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[90.372097] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[90.467897] [035/133] (909s left) sriov_basic (enable-vfs-autoprobe-on)
[90.529939] Subtest enable-vfs-autoprobe-on: SKIP (0.000s)
[90.569928] [036/133] (909s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[90.694286] Starting subtest: 4-tiled-64bpp-rotate-270
[90.712116] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.018s)
[90.829186] [037/133] (908s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[93.434702] Subtest protected-encrypted-src-copy-not-readible: SKIP (0.000s)
[93.492852] [038/133] (906s left) gem_mmap_gtt (fault-concurrent-x)
[93.567297] Subtest fault-concurrent-X: SKIP (0.000s)
[93.602745] [039/133] (906s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[93.730383] Starting subtest: psr-1p-primscrn-cur-indfb-move
[99.163546] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (5.437s)
[99.298154] [040/133] (900s left) kms_psr (fbc-pr-sprite-blt)
[99.415770] Starting subtest: fbc-pr-sprite-blt
[99.420493] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[99.480245] [041/133] (900s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[99.603845] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[99.620637] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.014s)
[99.687296] [042/133] (900s left) gem_exec_params (secure-non-master)
[99.769803] Starting subtest: secure-non-master
[99.775056] Subtest secure-non-master: SKIP (0.000s)
[99.869318] [043/133] (900s left) dmabuf_sync_file (export-multiwait)
[99.923606] Starting subtest: export-multiwait
[99.925991] Subtest export-multiwait: SUCCESS (0.001s)
[99.971274] [044/133] (899s left) gem_ctx_isolation (preservation-s3)
[100.034460] Starting subtest: preservation-S3
[100.036859] Starting dynamic subtest: rcs0
[115.806479] Dynamic subtest rcs0: SUCCESS (2.221s)
[115.814585] Starting dynamic subtest: bcs0
[131.796816] Dynamic subtest bcs0: SUCCESS (1.328s)
[131.810134] Starting dynamic subtest: vcs0
[147.810926] Dynamic subtest vcs0: SUCCESS (2.998s)
[147.824339] Starting dynamic subtest: vcs1
[165.776415] Dynamic subtest vcs1: SUCCESS (4.955s)
[165.790152] Starting dynamic subtest: vecs0
[183.785290] Dynamic subtest vecs0: SUCCESS (4.987s)
[183.792211] Starting dynamic subtest: ccs0
[201.790630] Dynamic subtest ccs0: SUCCESS (3.233s)
[201.793124] Subtest preservation-S3: SUCCESS (19.725s)
[202.012561] [045/133] (879s left) gem_busy (semaphore)
[202.224393] Subtest semaphore: SKIP (0.000s)
[202.444630] [046/133] (879s left) gem_exec_fence (submit67)
[202.640227] Starting subtest: submit67
[202.645299] Subtest submit67: SKIP (0.000s)
[204.587156] [047/133] (877s left) core_auth (getclient-simple)
[204.633832] Starting subtest: getclient-simple
[204.653147] Subtest getclient-simple: SUCCESS (0.020s)
[204.743613] [048/133] (877s left) vc4/vc4_purgeable_bo (access-purgeable-bo-mem)
[204.816738] Subtest access-purgeable-bo-mem: SKIP (0.000s)
[204.865353] [049/133] (877s left) kms_atomic (crtc-invalid-params-fence)
[204.981813] Starting subtest: crtc-invalid-params-fence
[204.984610] Starting dynamic subtest: pipe-A-eDP-1
[205.385036] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.401s)
[205.388089] Subtest crtc-invalid-params-fence: SUCCESS (0.403s)
[206.295544] [050/133] (875s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[206.418599] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[206.423361] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[206.502437] [051/133] (875s left) prime_mmap (test_aperture_limit)
[206.563091] Starting subtest: test_aperture_limit
[206.565607] Starting dynamic subtest: test_aperture_limit-smem
[206.568082] Dynamic subtest test_aperture_limit-smem: SUCCESS (0.006s)
[206.570507] Subtest test_aperture_limit: SUCCESS (0.006s)
[206.648874] [052/133] (875s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[206.759120] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[206.778282] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.016s)
[206.852032] [053/133] (875s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[206.975767] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[206.980300] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[207.055887] [054/133] (875s left) kms_draw_crc (draw-method-mmap-wc)
[207.160642] Starting subtest: draw-method-mmap-wc
[207.163013] Starting dynamic subtest: xrgb8888-untiled
[207.385424] Dynamic subtest xrgb8888-untiled: SUCCESS (0.223s)
[207.395832] Starting dynamic subtest: rgb565-untiled
[207.617176] Dynamic subtest rgb565-untiled: SUCCESS (0.232s)
[207.631729] Starting dynamic subtest: xrgb2101010-untiled
[207.839442] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[207.853544] Starting dynamic subtest: xrgb8888-xtiled
[207.975771] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[207.990263] Starting dynamic subtest: rgb565-xtiled
[208.083207] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s)
[208.089660] Starting dynamic subtest: xrgb2101010-xtiled
[208.217124] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.133s)
[208.230609] Starting dynamic subtest: xrgb8888-4tiled
[208.360669] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.142s)
[208.374559] Starting dynamic subtest: rgb565-4tiled
[208.483143] Dynamic subtest rgb565-4tiled: SUCCESS (0.121s)
[208.492850] Starting dynamic subtest: xrgb2101010-4tiled
[208.582665] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.099s)
[208.584793] Subtest draw-method-mmap-wc: SUCCESS (1.423s)
[208.677721] [055/133] (873s left) kms_psr2_sf (fbc-plane-move-sf-dmg-area)
[213.941877] Starting subtest: fbc-plane-move-sf-dmg-area
[213.944428] Starting dynamic subtest: psr2-pipe-A-eDP-1
[214.831135] Dynamic subtest psr2-pipe-A-eDP-1: SKIP (0.886s)
[214.847198] Starting dynamic subtest: psr2-pipe-B-eDP-1
[216.048944] Dynamic subtest psr2-pipe-B-eDP-1: SKIP (1.217s)
[216.053694] Subtest fbc-plane-move-sf-dmg-area: SKIP (2.108s)
[217.365353] [056/133] (864s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[217.431433] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[217.532145] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[217.602047] [057/133] (864s left) gem_mmap_wc (read)
[217.680519] Subtest read: SKIP (0.000s)
[217.737922] [058/133] (864s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[217.807726] Starting subtest: multi-wait-for-submit-unsubmitted
[217.907769] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[217.970050] [059/133] (864s left) sw_sync (sync_busy_fork_unixsocket)
[218.015695] Starting subtest: sync_busy_fork_unixsocket
[218.032606] Subtest sync_busy_fork_unixsocket: SUCCESS (0.018s)
[218.090076] [060/133] (864s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[218.217645] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[218.221926] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[218.298736] [061/133] (864s left) gem_ctx_persistence (legacy-engines-persistence)
[218.361986] Starting subtest: legacy-engines-persistence
[218.364536] Starting dynamic subtest: render
[219.187892] Dynamic subtest render: SUCCESS (0.825s)
[219.202806] Starting dynamic subtest: bsd1
[219.918368] Dynamic subtest bsd1: SUCCESS (0.729s)
[219.933014] Starting dynamic subtest: bsd2
[220.684911] Dynamic subtest bsd2: SUCCESS (0.764s)
[220.699984] Starting dynamic subtest: blt
[221.449089] Dynamic subtest blt: SUCCESS (0.762s)
[221.464412] Starting dynamic subtest: vebox
[222.212805] Dynamic subtest vebox: SUCCESS (0.762s)
[222.215614] Subtest legacy-engines-persistence: SUCCESS (3.851s)
[222.318111] [062/133] (860s left) kms_busy (extended-pageflip-hang-oldfb)
[222.450503] Starting subtest: extended-pageflip-hang-oldfb
[222.453092] Starting dynamic subtest: pipe-A
[222.856940] Dynamic subtest pipe-A: SUCCESS (0.404s)
[222.871903] Starting dynamic subtest: pipe-D
[224.102007] Dynamic subtest pipe-D: SUCCESS (1.240s)
[224.104808] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.652s)
[224.988083] [063/133] (857s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[225.104347] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[225.106787] Starting dynamic subtest: pipe-A-eDP-1
[225.111563] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[225.124062] Starting dynamic subtest: pipe-B-eDP-1
[225.128551] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[225.137646] Starting dynamic subtest: pipe-C-eDP-1
[225.141831] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[225.149407] Starting dynamic subtest: pipe-D-eDP-1
[225.153656] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[225.157861] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[225.174383] [064/133] (857s left) i915_hangman (engine-engine-hang)
[225.250859] Starting subtest: engine-engine-hang
[225.253420] Starting dynamic subtest: rcs0
[226.431193] Dynamic subtest rcs0: SUCCESS (1.182s)
[226.447143] Starting dynamic subtest: bcs0
[228.413976] Dynamic subtest bcs0: SUCCESS (1.981s)
[228.429465] Starting dynamic subtest: vcs0
[230.462366] Dynamic subtest vcs0: SUCCESS (2.046s)
[230.477453] Starting dynamic subtest: vcs1
[232.447803] Dynamic subtest vcs1: SUCCESS (1.983s)
[232.463427] Starting dynamic subtest: vecs0
[234.430051] Dynamic subtest vecs0: SUCCESS (1.981s)
[234.445331] Starting dynamic subtest: ccs0
[236.415101] Dynamic subtest ccs0: SUCCESS (1.983s)
[236.418442] Subtest engine-engine-hang: SUCCESS (11.166s)
[236.491071] [065/133] (845s left) gem_exec_schedule (u-semaphore-noskip)
[236.579547] Starting subtest: u-semaphore-noskip
[237.090128] Subtest u-semaphore-noskip: SUCCESS (0.514s)
[237.434217] [066/133] (845s left) kms_lease (simple-lease)
[237.544432] Starting subtest: simple-lease
[237.546864] Starting dynamic subtest: pipe-A-eDP-1
[238.054873] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.509s)
[238.069008] Starting dynamic subtest: pipe-B-eDP-1
[239.530447] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.471s)
[239.539626] Starting dynamic subtest: pipe-C-eDP-1
[241.010331] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.478s)
[241.024238] Starting dynamic subtest: pipe-D-eDP-1
[242.561641] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.549s)
[242.564219] Subtest simple-lease: SUCCESS (5.019s)
[243.471849] [067/133] (839s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[243.528633] Starting subtest: single-wait-all-for-submit-signaled
[243.531480] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.001s)
[243.616794] [068/133] (838s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[243.691272] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[243.693805] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[243.777708] [069/133] (838s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[243.862974] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[243.868345] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[244.036864] [070/133] (838s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[244.143618] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[244.146140] Starting dynamic subtest: pipe-A-default-mode
[244.468335] Dynamic subtest pipe-A-default-mode: SKIP (0.321s)
[244.473191] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.322s)
[245.312649] [071/133] (837s left) kms_flip (2x-wf_vblank-ts-check)
[245.432324] Starting subtest: 2x-wf_vblank-ts-check
[245.447616] Subtest 2x-wf_vblank-ts-check: SKIP (0.015s)
[245.516692] [072/133] (837s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[245.654883] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[245.659896] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[245.753706] [073/133] (836s left) syncobj_wait (single-wait-for-submit-signaled)
[245.838661] Starting subtest: single-wait-for-submit-signaled
[245.841192] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[245.929009] [074/133] (836s left) perf_pmu (event-wait)
[245.980188] Starting subtest: event-wait
[245.982752] Starting dynamic subtest: rcs0
[245.987390] Dynamic subtest rcs0: SKIP (0.000s)
[245.991934] Subtest event-wait: SKIP (0.000s)
[246.086228] [075/133] (836s left) gem_exec_params (readonly)
[246.161423] Starting subtest: readonly
[246.167471] Subtest readonly: SUCCESS (0.005s)
[246.289519] [076/133] (836s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-25)
[246.414900] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-25
[246.417019] Starting dynamic subtest: pipe-A-eDP-1
[246.429918] Dynamic subtest pipe-A-eDP-1: SKIP (0.008s)
[246.444211] Starting dynamic subtest: pipe-B-eDP-1
[246.448949] Dynamic subtest pipe-B-eDP-1: SKIP (0.016s)
[246.458469] Starting dynamic subtest: pipe-C-eDP-1
[246.462652] Dynamic subtest pipe-C-eDP-1: SKIP (0.015s)
[246.470176] Starting dynamic subtest: pipe-D-eDP-1
[246.477681] Dynamic subtest pipe-D-eDP-1: SKIP (0.015s)
[246.481253] Subtest planes-upscale-factor-0-25-downscale-factor-0-25: SKIP (0.059s)
[246.549159] [077/133] (836s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[246.676427] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[247.433827] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.759s)
[247.599915] [078/133] (835s left) gem_userptr_blits (userfault)
[247.672189] Starting subtest: userfault
[247.674956] Subtest userfault: SUCCESS (0.008s)
[247.812304] [079/133] (834s left) gem_exec_suspend (basic)
[247.871286] Starting subtest: basic
[247.874191] Starting dynamic subtest: smem
[249.440920] Dynamic subtest smem: SUCCESS (1.568s)
[249.444163] Subtest basic: SUCCESS (1.569s)
[249.618284] [080/133] (833s left) gem_tiled_swapping (non-threaded)
[249.691424] Subtest non-threaded: SKIP (0.000s)
[249.737662] [081/133] (833s left) syncobj_wait (wait-any-interrupted)
[249.799093] Starting subtest: wait-any-interrupted
[249.897975] Subtest wait-any-interrupted: SUCCESS (0.101s)
[249.969840] [082/133] (832s left) gem_spin_batch (user-each)
[250.051090] Starting subtest: user-each
[253.410722] Subtest user-each: SUCCESS (3.359s)
[253.591980] [083/133] (829s left) api_intel_allocator (two-level-inception-interruptible)
[253.660803] Starting subtest: two-level-inception-interruptible
[259.069155] Subtest two-level-inception-interruptible: SUCCESS (5.410s)
[259.167528] [084/133] (823s left) kms_pm_rpm (pc8-residency)
[260.710447] Starting subtest: pc8-residency
[260.716418] Subtest pc8-residency: SKIP (0.000s)
[261.497442] [085/133] (821s left) gem_ctx_engines (execute-allforone)
[261.571107] Starting subtest: execute-allforone
[261.593510] Subtest execute-allforone: SUCCESS (0.023s)
[263.503402] [086/133] (819s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[263.624116] Starting subtest: invalidate-primary-flip-overlay
[274.279414] Subtest invalidate-primary-flip-overlay: SUCCESS (10.659s)
[274.434143] [087/133] (808s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[274.556958] Starting subtest: fbc-psr-cursor-mmap-cpu
[274.559098] Starting dynamic subtest: eDP-1
[274.563035] Dynamic subtest eDP-1: SKIP (0.000s)
[274.566610] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s)
[274.612551] [088/133] (808s left) kms_flip (2x-plain-flip)
[274.716917] Starting subtest: 2x-plain-flip
[274.732074] Subtest 2x-plain-flip: SKIP (0.015s)
[274.805522] [089/133] (808s left) kms_tv_load_detect (load-detect)
[274.861283] Subtest load-detect: SKIP (0.000s)
[274.903684] [090/133] (808s left) kms_vrr (seamless-rr-switch-vrr)
[275.000573] Starting subtest: seamless-rr-switch-vrr
[275.005417] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[275.063522] [091/133] (808s left) gem_exec_fence (basic-busy-all)
[275.137637] Starting subtest: basic-busy-all
[275.220539] Subtest basic-busy-all: SUCCESS (0.084s)
[277.526102] [092/133] (805s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc)
[277.634489] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc
[282.205864] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (4.576s)
[282.322866] [093/133] (800s left) gen7_exec_parse (batch-without-end)
[282.392864] Subtest batch-without-end: SKIP (0.000s)
[282.450911] [094/133] (800s left) gem_flink_basic (bad-flink)
[282.526215] Starting subtest: bad-flink
[282.528943] Subtest bad-flink: SUCCESS (0.000s)
[282.628730] [095/133] (800s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-cpu)
[282.741468] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-cpu
[287.256325] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (4.519s)
[287.366031] [096/133] (795s left) kms_flip (flip-vs-suspend-interruptible)
[287.467643] Starting subtest: flip-vs-suspend-interruptible
[287.470727] Starting dynamic subtest: A-eDP1
[336.761255] Dynamic subtest A-eDP1: SUCCESS (4.679s)
[336.774898] Starting dynamic subtest: B-eDP1
[385.767701] Dynamic subtest B-eDP1: SUCCESS (4.711s)
[385.781795] Starting dynamic subtest: C-eDP1
[434.781453] Dynamic subtest C-eDP1: SUCCESS (4.660s)
[434.795895] Starting dynamic subtest: D-eDP1
[483.784102] Dynamic subtest D-eDP1: SUCCESS (4.749s)
[483.790266] Subtest flip-vs-suspend-interruptible: SUCCESS (18.811s)
[485.057495] [097/133] (775s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[485.203836] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[485.208646] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[485.287623] [098/133] (775s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[485.420953] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[485.426320] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[485.498464] [099/133] (775s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[485.618794] Starting subtest: basic-flip-before-cursor-varying-size
[486.563135] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.941s)
[487.442211] [100/133] (773s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[487.496343] Starting subtest: invalid-bsd2-flag-on-vebox
[487.499237] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[487.590244] [101/133] (773s left) gem_partial_pwrite_pread (reads-display)
[487.659139] Subtest reads-display: SKIP (0.000s)
[487.723560] [102/133] (773s left) gem_ppgtt (shrink-vs-evict-any)
[487.789348] Starting subtest: shrink-vs-evict-any
[496.063311] Subtest shrink-vs-evict-any: SUCCESS (8.221s)
[496.111723] [103/133] (764s left) kms_big_fb (linear-32bpp-rotate-90)
[496.234511] Starting subtest: linear-32bpp-rotate-90
[496.248204] Subtest linear-32bpp-rotate-90: SKIP (0.017s)
[496.353988] [104/133] (764s left) kms_color (degamma)
[496.465723] Starting subtest: degamma
[496.468191] Starting dynamic subtest: pipe-A
[497.203737] Dynamic subtest pipe-A: SUCCESS (0.735s)
[497.219431] Starting dynamic subtest: pipe-B
[498.693765] Dynamic subtest pipe-B: SUCCESS (1.490s)
[498.703711] Starting dynamic subtest: pipe-C
[500.110057] Dynamic subtest pipe-C: SUCCESS (1.414s)
[500.127577] Starting dynamic subtest: pipe-D
[501.504279] Dynamic subtest pipe-D: SUCCESS (1.394s)
[501.507296] Subtest degamma: SUCCESS (5.038s)
[502.402017] [105/133] (758s left) prime_vgem (basic-fence-blt)
[502.473191] Starting subtest: basic-fence-blt
[502.559588] Subtest basic-fence-blt: SUCCESS (0.086s)
[502.672451] [106/133] (758s left) kms_vblank (ts-continuation-modeset-hang)
[502.798031] Starting subtest: ts-continuation-modeset-hang
[502.800598] Starting dynamic subtest: pipe-A-eDP-1
[528.788579] Dynamic subtest pipe-A-eDP-1: SUCCESS (25.984s)
[528.802699] Starting dynamic subtest: pipe-D-eDP-1
[552.799380] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.007s)
[552.802035] Subtest ts-continuation-modeset-hang: SUCCESS (49.998s)
[553.727415] [107/133] (707s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[553.858682] Starting subtest: cursor-vs-flip-legacy
[583.212331] Subtest cursor-vs-flip-legacy: SUCCESS (29.351s)
[584.087805] [108/133] (676s left) i915_pm_freq_api (freq-reset-multiple)
[584.166958] Starting subtest: freq-reset-multiple
[584.169723] Starting dynamic subtest: gt0
[592.719872] Dynamic subtest gt0: SUCCESS (8.551s)
[592.728529] Starting dynamic subtest: gt1
[600.937488] Dynamic subtest gt1: SUCCESS (8.216s)
[600.940314] Subtest freq-reset-multiple: SUCCESS (16.769s)
[600.998132] [109/133] (660s left) syncobj_wait (single-wait-all-for-submit-signaled)
[601.045981] Starting subtest: single-wait-all-for-submit-signaled
[601.048600] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[601.128146] [110/133] (659s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[601.244873] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[601.249204] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[601.323809] [111/133] (659s left) gem_eio (create-ext)
[601.514614] Starting subtest: create-ext
[601.781796] Subtest create-ext: SUCCESS (0.266s)
[601.899189] [112/133] (659s left) gem_exec_whisper (basic-sync)
[601.970871] Starting subtest: basic-sync
[610.249603] Subtest basic-sync: SUCCESS (8.261s)
[610.407008] [113/133] (650s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[610.525530] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[610.528325] Starting dynamic subtest: pipe-A-eDP-1
[611.620975] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.097s)
[611.630976] Starting dynamic subtest: pipe-B-eDP-1
[613.814187] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.191s)
[613.825529] Starting dynamic subtest: pipe-C-eDP-1
[615.843295] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.029s)
[615.853281] Starting dynamic subtest: pipe-D-eDP-1
[617.846320] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.001s)
[617.849227] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (7.324s)
[619.073520] [114/133] (642s left) gem_exec_balancer (full-late-pulse)
[619.155380] Starting subtest: full-late-pulse
[623.555726] Subtest full-late-pulse: SUCCESS (4.401s)
[623.825855] [115/133] (637s left) kms_invalid_mode (zero-vdisplay)
[623.925982] Starting subtest: zero-vdisplay
[623.928717] Starting dynamic subtest: pipe-A-eDP-1
[624.212984] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[624.222261] Starting dynamic subtest: pipe-B-eDP-1
[624.224337] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[624.230982] Starting dynamic subtest: pipe-C-eDP-1
[624.232985] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[624.240536] Starting dynamic subtest: pipe-D-eDP-1
[624.242903] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[624.245279] Subtest zero-vdisplay: SUCCESS (0.293s)
[625.084507] [116/133] (636s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[625.168352] Starting subtest: basic-batch-kernel-default-cmd
[625.172602] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[625.353930] [117/133] (635s left) kms_chamelium_edid (hdmi-edid-read)
[625.764484] Subtest hdmi-edid-read: SKIP (0.000s)
[626.661917] [118/133] (634s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[626.787889] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[626.790372] Starting dynamic subtest: pipe-A-eDP-1
[627.168951] Dynamic subtest pipe-A-eDP-1: SKIP (0.376s)
[627.184945] Starting dynamic subtest: pipe-B-eDP-1
[628.628503] Dynamic subtest pipe-B-eDP-1: SKIP (1.457s)
[628.639172] Starting dynamic subtest: pipe-C-eDP-1
[630.010947] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.386s)
[630.032097] Starting dynamic subtest: pipe-D-eDP-1
[631.357396] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.342s)
[631.361557] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (4.570s)
[632.642223] [119/133] (628s left) kms_pm_rpm (cursor-dpms)
[634.210505] Starting subtest: cursor-dpms
[666.681804] Subtest cursor-dpms: SUCCESS (32.471s)
[667.746006] [120/133] (593s left) v3d/v3d_submit_csd (multisync-out-syncs)
[667.816783] Subtest multisync-out-syncs: SKIP (0.000s)
[667.865410] [121/133] (593s left) kms_flip (2x-flip-vs-modeset)
[667.969181] Starting subtest: 2x-flip-vs-modeset
[667.983849] Subtest 2x-flip-vs-modeset: SKIP (0.014s)
[668.050109] [122/133] (593s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[668.449213] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[669.349691] [123/133] (592s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[669.489250] Starting subtest: cursorB-vs-flipB-atomic-transitions
[669.494073] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[669.609268] [124/133] (591s left) v3d/v3d_perfmon (get-values-invalid-pad)
[669.688577] Subtest get-values-invalid-pad: SKIP (0.000s)
[669.735466] [125/133] (591s left) vc4/vc4_wait_bo (used-bo-0ns)
[669.799866] Subtest used-bo-0ns: SKIP (0.000s)
[669.845580] [126/133] (591s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[669.956329] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[670.690268] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.736s)
[670.858469] [127/133] (590s left) gem_exec_reloc (basic-gtt-read-active)
[670.925103] Subtest basic-gtt-read-active: SKIP (0.000s)
[670.995778] [128/133] (590s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[671.135055] Starting subtest: x-tiled-64bpp-rotate-270
[671.151866] Subtest x-tiled-64bpp-rotate-270: SKIP (0.018s)
[671.269939] [129/133] (590s left) kms_prop_blob (blob-prop-validate)
[671.350775] Starting subtest: blob-prop-validate
[671.353557] Subtest blob-prop-validate: SUCCESS (0.000s)
[671.442144] [130/133] (590s left) drm_fdinfo (memory-info-purgeable)
[671.473905] Starting subtest: memory-info-purgeable
[671.476587] Starting dynamic subtest: smem0
[674.364933] Dynamic subtest smem0: SUCCESS (2.891s)
[674.367393] Subtest memory-info-purgeable: SUCCESS (2.892s)
[674.428370] [131/133] (587s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[674.557495] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[679.417525] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (4.862s)
[679.546861] [132/133] (582s left) gem_media_fill (media-fill)
[679.627943] Subtest media-fill: SKIP (0.000s)
[679.719772] [133/133] (581s left) syncobj_timeline (wait-for-submit-complex)
[679.793452] Starting subtest: wait-for-submit-complex
[679.855166] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[679.917952] Closing watchdogs
Done.