[41.524121] Initializing watchdogs
[41.524151]   /dev/watchdog0
[41.530589] [001/130] (960s left) kms_cursor_crc (cursor-random-64x21)
[41.747471] Starting subtest: cursor-random-64x21
[41.786084] Subtest cursor-random-64x21: SKIP (0.033s)
[41.964724] [002/130] (960s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[42.057725] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[42.060071] Starting dynamic subtest: pipe-A-default-mode
[44.871793] Dynamic subtest pipe-A-default-mode: SUCCESS (2.813s)
[44.874704] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.814s)
[45.772086] [003/130] (956s left) i915_pm_freq_api (freq-reset-multiple)
[45.831751] Starting subtest: freq-reset-multiple
[45.834368] Starting dynamic subtest: gt0
[53.833134] Dynamic subtest gt0: SUCCESS (7.900s)
[53.839747] Starting dynamic subtest: gt1
[60.425110] Dynamic subtest gt1: SUCCESS (6.554s)
[60.427572] Subtest freq-reset-multiple: SUCCESS (14.455s)
[60.472661] [004/130] (941s left) kms_plane_cursor (overlay)
[60.565754] Starting subtest: overlay
[60.570358] Starting dynamic subtest: pipe-A-eDP-1-size-64
[63.286822] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.712s)
[63.346189] Starting dynamic subtest: pipe-A-eDP-1-size-128
[66.070162] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.726s)
[66.128114] Starting dynamic subtest: pipe-A-eDP-1-size-256
[68.807431] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.682s)
[69.155410] Starting dynamic subtest: pipe-B-eDP-1-size-64
[72.641876] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.493s)
[72.700280] Starting dynamic subtest: pipe-B-eDP-1-size-128
[75.387449] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.693s)
[75.443678] Starting dynamic subtest: pipe-B-eDP-1-size-256
[78.132845] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.693s)
[78.482311] Starting dynamic subtest: pipe-C-eDP-1-size-64
[81.580308] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.107s)
[81.619102] Starting dynamic subtest: pipe-C-eDP-1-size-128
[83.803238] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.190s)
[83.838855] Starting dynamic subtest: pipe-C-eDP-1-size-256
[86.105028] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.268s)
[86.428842] Starting dynamic subtest: pipe-D-eDP-1-size-64
[89.472506] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.050s)
[89.508097] Starting dynamic subtest: pipe-D-eDP-1-size-128
[91.739979] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.235s)
[91.773866] Starting dynamic subtest: pipe-D-eDP-1-size-256
[94.039531] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.269s)
[94.358551] Subtest overlay: SUCCESS (33.765s)
[95.242603] [005/130] (907s left) kms_scaling_modes (scaling-mode-none)
[95.333076] Starting subtest: scaling-mode-none
[95.335509] Starting dynamic subtest: pipe-A-eDP-1
[95.428106] Dynamic subtest pipe-A-eDP-1: SKIP (0.091s)
[95.435010] Starting dynamic subtest: pipe-B-eDP-1
[95.462046] Dynamic subtest pipe-B-eDP-1: SKIP (0.033s)
[95.468318] Starting dynamic subtest: pipe-C-eDP-1
[95.495411] Dynamic subtest pipe-C-eDP-1: SKIP (0.032s)
[95.503557] Starting dynamic subtest: pipe-D-eDP-1
[95.523264] Dynamic subtest pipe-D-eDP-1: SKIP (0.027s)
[95.527392] Subtest scaling-mode-none: SKIP (0.188s)
[95.638971] [006/130] (906s left) kms_rotation_crc (primary-rotation-270)
[95.715832] Starting subtest: primary-rotation-270
[95.720379] Subtest primary-rotation-270: SKIP (0.001s)
[95.766489] [007/130] (906s left) gem_tiled_blits (normal)
[95.811701] Subtest normal: SKIP (0.000s)
[95.856803] [008/130] (906s left) gem_softpin (safe-alignment)
[95.901744] Starting subtest: safe-alignment
[95.919591] Subtest safe-alignment: SUCCESS (0.018s)
[97.401655] [009/130] (904s left) gem_exec_await (wide-contexts)
[97.603702] Starting subtest: wide-contexts
[121.269715] Subtest wide-contexts: SUCCESS (23.661s)
[121.437159] [010/130] (880s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[121.574457] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[126.106093] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (4.533s)
[126.217039] [011/130] (876s left) gem_pwrite (basic-exhaustion)
[126.265635] Subtest basic-exhaustion: SKIP (0.000s)
[126.304228] [012/130] (876s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[126.399809] Starting subtest: psr-2p-primscrn-spr-indfb-move
[126.404682] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[126.476456] [013/130] (875s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[126.561055] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[126.563529] Starting dynamic subtest: pipe-A-eDP-1
[126.589575] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[126.597761] Starting dynamic subtest: pipe-B-eDP-1
[126.621755] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[126.628077] Starting dynamic subtest: pipe-C-eDP-1
[126.651569] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[126.660722] Starting dynamic subtest: pipe-D-eDP-1
[126.682519] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[126.686891] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[126.701625] [014/130] (875s left) kms_plane_scaling (plane-downscale-factor-0-25-with-modifiers)
[126.786148] Starting subtest: plane-downscale-factor-0-25-with-modifiers
[126.788719] Starting dynamic subtest: pipe-A
[126.801475] Dynamic subtest pipe-A: SKIP (0.009s)
[126.808742] Starting dynamic subtest: pipe-B
[126.820567] Dynamic subtest pipe-B: SKIP (0.018s)
[126.827173] Starting dynamic subtest: pipe-C
[126.838765] Dynamic subtest pipe-C: SKIP (0.018s)
[126.845259] Starting dynamic subtest: pipe-D
[126.861988] Dynamic subtest pipe-D: SKIP (0.023s)
[126.866241] Subtest plane-downscale-factor-0-25-with-modifiers: SKIP (0.070s)
[126.922991] [015/130] (875s left) gen9_exec_parse (bb-start-far)
[126.984249] Subtest bb-start-far: SKIP (0.000s)
[127.027405] [016/130] (875s left) gem_exec_schedule (u-lateslice)
[127.097167] Starting subtest: u-lateslice
[127.098838] Starting dynamic subtest: rcs0
[127.107223] Dynamic subtest rcs0: SUCCESS (0.018s)
[127.114869] Starting dynamic subtest: bcs0
[127.121966] Dynamic subtest bcs0: SUCCESS (0.015s)
[127.128466] Starting dynamic subtest: vcs0
[127.135421] Dynamic subtest vcs0: SUCCESS (0.013s)
[127.141480] Starting dynamic subtest: vcs1
[127.150474] Dynamic subtest vcs1: SUCCESS (0.015s)
[127.156259] Starting dynamic subtest: vecs0
[127.165047] Dynamic subtest vecs0: SUCCESS (0.014s)
[127.170897] Starting dynamic subtest: ccs0
[127.179870] Dynamic subtest ccs0: SUCCESS (0.014s)
[127.182012] Subtest u-lateslice: SUCCESS (0.091s)
[128.427354] [017/130] (874s left) gem_exec_balancer (full-late)
[128.484181] Starting subtest: full-late
[132.871834] Subtest full-late: SUCCESS (4.387s)
[133.118373] [018/130] (869s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[133.204707] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[133.206960] Starting dynamic subtest: pipe-A-eDP-1
[133.226127] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[133.233650] Starting dynamic subtest: pipe-B-eDP-1
[133.253065] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[133.259190] Starting dynamic subtest: pipe-C-eDP-1
[133.278547] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[133.284686] Starting dynamic subtest: pipe-D-eDP-1
[133.304424] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[133.306344] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.003s)
[133.319859] [019/130] (869s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[138.479025] Starting subtest: pr-overlay-plane-update-continuous-sf
[138.483855] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.002s)
[139.339302] [020/130] (863s left) kms_vblank (query-busy-hang)
[139.426834] Starting subtest: query-busy-hang
[139.429172] Starting dynamic subtest: pipe-A-eDP-1
[166.107661] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.676s)
[166.119191] Starting dynamic subtest: pipe-D-eDP-1
[181.143658] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.034s)
[181.145976] Subtest query-busy-hang: SUCCESS (41.714s)
[182.028579] [021/130] (820s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[182.124700] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[185.446379] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (3.326s)
[185.558389] [022/130] (816s left) kms_addfb_basic (bad-pitch-1024)
[185.601770] Starting subtest: bad-pitch-1024
[185.603608] Subtest bad-pitch-1024: SUCCESS (0.000s)
[185.706536] [023/130] (816s left) kms_psr (fbc-psr-primary-render)
[185.791514] Starting subtest: fbc-psr-primary-render
[185.793570] Starting dynamic subtest: eDP-1
[185.797438] Dynamic subtest eDP-1: SKIP (0.000s)
[185.801135] Subtest fbc-psr-primary-render: SKIP (0.001s)
[185.839601] [024/130] (816s left) gem_mmap_gtt (hang-user)
[185.887267] Subtest hang-user: SKIP (0.000s)
[185.918104] [025/130] (816s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[185.961343] Starting subtest: invalid-bsd1-flag-on-vebox
[185.963215] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[186.034992] [026/130] (816s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[186.122603] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[186.680237] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.558s)
[186.831039] [027/130] (815s left) kms_setmode (basic-clone-single-crtc)
[186.885438] Starting subtest: basic-clone-single-crtc
[186.892201] Subtest basic-clone-single-crtc: SKIP (0.000s)
[186.957701] [028/130] (815s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[187.058937] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[187.063525] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[187.124766] [029/130] (815s left) gem_exec_reloc (basic-wc-active)
[187.186297] Subtest basic-wc-active: SKIP (0.000s)
[187.219124] [030/130] (815s left) gem_exec_params (readonly)
[187.274033] Starting subtest: readonly
[187.276240] Subtest readonly: SUCCESS (0.003s)
[187.369327] [031/130] (815s left) gem_userptr_blits (vma-merge)
[187.431577] Starting subtest: vma-merge
[187.456334] Subtest vma-merge: SUCCESS (0.025s)
[187.555035] [032/130] (815s left) perf_pmu (most-busy-check-all)
[187.589160] Starting subtest: most-busy-check-all
[187.591234] Starting dynamic subtest: rcs0
[189.353511] Dynamic subtest rcs0: SUCCESS (1.762s)
[189.362855] Starting dynamic subtest: bcs0
[191.400080] Dynamic subtest bcs0: SUCCESS (2.045s)
[191.409955] Starting dynamic subtest: vcs0
[193.383973] Dynamic subtest vcs0: SUCCESS (1.983s)
[193.393560] Starting dynamic subtest: vcs1
[195.367945] Dynamic subtest vcs1: SUCCESS (1.983s)
[195.377707] Starting dynamic subtest: vecs0
[197.352161] Dynamic subtest vecs0: SUCCESS (1.983s)
[197.361453] Starting dynamic subtest: ccs0
[199.399974] Dynamic subtest ccs0: SUCCESS (2.047s)
[199.402916] Subtest most-busy-check-all: SUCCESS (11.809s)
[199.476516] [033/130] (803s left) kms_flip (2x-dpms-vs-vblank-race)
[199.579043] Starting subtest: 2x-dpms-vs-vblank-race
[199.593183] Subtest 2x-dpms-vs-vblank-race: SKIP (0.014s)
[199.648058] [034/130] (803s left) i915_power (sanity)
[199.701831] Starting subtest: sanity
[199.706297] Subtest sanity: SKIP (0.000s)
[199.765495] [035/130] (802s left) kms_rotation_crc (bad-pixel-format)
[199.855898] Starting subtest: bad-pixel-format
[199.860467] Subtest bad-pixel-format: SKIP (0.001s)
[199.907329] [036/130] (802s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[199.995852] Starting subtest: plane-upscale-20x20-with-rotation
[199.998575] Starting dynamic subtest: pipe-A
[200.222669] Dynamic subtest pipe-A: SUCCESS (0.226s)
[200.230560] Starting dynamic subtest: pipe-B
[201.589963] Dynamic subtest pipe-B: SUCCESS (1.367s)
[201.597052] Starting dynamic subtest: pipe-C
[202.934455] Dynamic subtest pipe-C: SUCCESS (1.344s)
[202.942590] Starting dynamic subtest: pipe-D
[204.281082] Dynamic subtest pipe-D: SUCCESS (1.346s)
[204.283484] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.285s)
[205.450644] [037/130] (797s left) gem_exec_balancer (bonded-semaphore)
[205.503419] Starting subtest: bonded-semaphore
[205.508135] Subtest bonded-semaphore: SKIP (0.000s)
[205.728174] [038/130] (797s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[205.772815] Starting subtest: multi-wait-all-for-submit-available-signaled
[205.775947] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[205.827500] [039/130] (796s left) kms_psr (fbc-psr-cursor-blt)
[205.922029] Starting subtest: fbc-psr-cursor-blt
[205.924324] Starting dynamic subtest: eDP-1
[205.928774] Dynamic subtest eDP-1: SKIP (0.000s)
[205.932872] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[205.971544] [040/130] (796s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[206.058345] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[210.882231] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (4.828s)
[210.975643] [041/130] (791s left) gem_exec_whisper (basic-forked)
[211.038994] Starting subtest: basic-forked
[218.344998] Subtest basic-forked: SUCCESS (7.306s)
[218.504583] [042/130] (784s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[218.608457] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[218.612569] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[218.679555] [043/130] (784s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[218.778238] Starting subtest: x-tiled-64bpp-rotate-90
[218.797224] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[218.911217] [044/130] (783s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[219.010212] Starting subtest: y-tiled-32bpp-rotate-270
[219.014676] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[219.073196] [045/130] (783s left) kms_psr2_su (page_flip-xrgb8888)
[219.118250] Subtest page_flip-XRGB8888: SKIP (0.000s)
[219.158384] [046/130] (783s left) gem_softpin (evict-snoop)
[219.213531] Starting subtest: evict-snoop
[219.217939] Subtest evict-snoop: SKIP (0.000s)
[219.311755] [047/130] (783s left) gem_create (hog-create)
[219.353089] Starting subtest: hog-create
[219.354975] Starting dynamic subtest: smem0
[253.368499] Dynamic subtest smem0: SUCCESS (34.013s)
[253.371455] Subtest hog-create: SUCCESS (34.013s)
[253.531908] [048/130] (749s left) gem_exec_reloc (basic-gtt)
[253.586580] Subtest basic-gtt: SKIP (0.000s)
[253.637855] [049/130] (749s left) kms_atomic_transition (modeset-transition-nonblocking)
[253.729049] Starting subtest: modeset-transition-nonblocking
[253.731449] Starting dynamic subtest: 1x-outputs
[265.120288] Dynamic subtest 1x-outputs: SUCCESS (11.388s)
[265.397672] Subtest modeset-transition-nonblocking: SUCCESS (11.665s)
[266.318185] [050/130] (736s left) gem_ctx_persistence (userptr)
[266.368902] Starting subtest: userptr
[266.493538] Subtest userptr: SUCCESS (0.123s)
[266.582412] [051/130] (736s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[266.670540] Starting subtest: x-tiled-16bpp-rotate-180
[267.823866] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.155s)
[267.937818] [052/130] (735s left) kms_psr (psr2-cursor-mmap-cpu)
[268.028552] Starting subtest: psr2-cursor-mmap-cpu
[268.030788] Starting dynamic subtest: eDP-1
[269.788351] Dynamic subtest eDP-1: SUCCESS (1.756s)
[269.790664] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.757s)
[270.668945] [053/130] (732s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-pwrite)
[270.760850] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-pwrite
[275.109034] Subtest fbcpsr-1p-offscren-pri-indfb-draw-pwrite: SUCCESS (4.351s)
[275.224800] [054/130] (727s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-pwrite)
[275.323374] Starting subtest: fbc-1p-offscren-pri-indfb-draw-pwrite
[278.551626] Subtest fbc-1p-offscren-pri-indfb-draw-pwrite: SUCCESS (3.232s)
[278.638647] [055/130] (724s left) syncobj_timeline (multi-wait-available-submitted)
[278.684094] Starting subtest: multi-wait-available-submitted
[278.686300] Subtest multi-wait-available-submitted: SUCCESS (0.000s)
[278.743161] [056/130] (724s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[278.835073] Starting subtest: fbcpsr-2p-rte
[278.839359] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[278.905978] [057/130] (724s left) drm_fdinfo (memory-info-active)
[278.933170] Starting subtest: memory-info-active
[278.935339] Starting dynamic subtest: smem0
[281.698687] Dynamic subtest smem0: SUCCESS (2.766s)
[281.701069] Subtest memory-info-active: SUCCESS (2.766s)
[281.747450] [058/130] (721s left) kms_addfb_basic (too-high)
[281.835537] Starting subtest: too-high
[281.837463] Subtest too-high: SUCCESS (0.000s)
[281.895338] [059/130] (721s left) syncobj_wait (multi-wait-all-signaled)
[281.941115] Starting subtest: multi-wait-all-signaled
[281.942930] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[281.993513] [060/130] (721s left) kms_cursor_crc (cursor-suspend)
[282.096823] Starting subtest: cursor-suspend
[282.099052] Starting dynamic subtest: pipe-A-eDP-1
[314.365742] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.675s)
[314.374408] Starting dynamic subtest: pipe-D-eDP-1
[347.377775] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.427s)
[347.380532] Subtest cursor-suspend: SUCCESS (7.103s)
[348.241185] [061/130] (713s left) kms_flip (flip-vs-panning-interruptible)
[348.344842] Starting subtest: flip-vs-panning-interruptible
[348.350039] Starting dynamic subtest: A-eDP1
[357.163406] Dynamic subtest A-eDP1: SUCCESS (8.721s)
[357.171907] Starting dynamic subtest: B-eDP1
[365.924482] Dynamic subtest B-eDP1: SUCCESS (8.729s)
[365.933504] Starting dynamic subtest: C-eDP1
[374.688238] Dynamic subtest C-eDP1: SUCCESS (8.750s)
[374.697166] Starting dynamic subtest: D-eDP1
[383.445433] Dynamic subtest D-eDP1: SUCCESS (8.756s)
[383.449635] Subtest flip-vs-panning-interruptible: SUCCESS (34.963s)
[384.720317] [062/130] (676s left) gem_userptr_blits (unsync-overlap)
[384.782524] Subtest unsync-overlap: SKIP (0.000s)
[384.886223] [063/130] (676s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[390.026313] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[390.031429] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.002s)
[390.925974] [064/130] (670s left) gem_ctx_isolation (preservation-s3)
[390.981141] Starting subtest: preservation-S3
[390.983585] Starting dynamic subtest: rcs0
[407.031468] Dynamic subtest rcs0: SUCCESS (1.234s)
[407.039157] Starting dynamic subtest: bcs0
[422.928053] Dynamic subtest bcs0: SUCCESS (1.091s)
[422.939439] Starting dynamic subtest: vcs0
[438.943178] Dynamic subtest vcs0: SUCCESS (2.062s)
[438.954681] Starting dynamic subtest: vcs1
[455.946835] Dynamic subtest vcs1: SUCCESS (3.990s)
[455.955771] Starting dynamic subtest: vecs0
[472.946044] Dynamic subtest vecs0: SUCCESS (3.916s)
[472.954260] Starting dynamic subtest: ccs0
[489.940980] Dynamic subtest ccs0: SUCCESS (2.080s)
[489.945500] Subtest preservation-S3: SUCCESS (14.375s)
[490.160524] [065/130] (655s left) kms_pm_dc (dc5-psr)
[491.257401] Starting subtest: dc5-psr
[494.644602] Subtest dc5-psr: SUCCESS (3.334s)
[495.507968] [066/130] (650s left) kms_hdr (bpc-switch-suspend)
[495.603190] Starting subtest: bpc-switch-suspend
[496.751174] Starting dynamic subtest: pipe-A-eDP-1
[516.185455] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.567s)
[516.187820] Subtest bpc-switch-suspend: SUCCESS (5.703s)
[516.287580] [067/130] (644s left) kms_content_protection (legacy)
[516.421769] Starting subtest: legacy
[520.430779] Subtest legacy: SKIP (3.946s)
[521.667732] [068/130] (639s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[521.755383] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[521.757726] Starting dynamic subtest: pipe-A-eDP-1
[521.781829] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[521.793280] Starting dynamic subtest: pipe-B-eDP-1
[521.816488] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[521.824148] Starting dynamic subtest: pipe-C-eDP-1
[521.846497] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[521.853952] Starting dynamic subtest: pipe-D-eDP-1
[521.876760] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[521.880927] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[521.895557] [069/130] (639s left) kms_cursor_legacy (forked-bo)
[522.012466] Starting subtest: forked-bo
[522.014769] Starting dynamic subtest: pipe-A
[527.481168] Dynamic subtest pipe-A: SUCCESS (5.428s)
[527.490320] Starting dynamic subtest: pipe-B
[532.924327] Dynamic subtest pipe-B: SUCCESS (5.423s)
[532.934254] Starting dynamic subtest: pipe-C
[538.354519] Dynamic subtest pipe-C: SUCCESS (5.418s)
[538.365034] Starting dynamic subtest: pipe-D
[543.781807] Dynamic subtest pipe-D: SUCCESS (5.421s)
[543.790188] Starting dynamic subtest: all-pipes
[549.217532] Dynamic subtest all-pipes: SUCCESS (5.431s)
[549.219758] Subtest forked-bo: SUCCESS (27.125s)
[549.325627] [070/130] (611s left) api_intel_bb (intel-bb-blit-none)
[549.362338] Starting subtest: intel-bb-blit-none
[553.107825] Subtest intel-bb-blit-none: SUCCESS (3.746s)
[553.192514] [071/130] (608s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[553.285612] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[553.289849] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[553.348179] [072/130] (607s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[553.396798] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[553.398894] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[553.445262] [073/130] (607s left) dmabuf_sync_file (export-wait-after-attach)
[553.479207] Starting subtest: export-wait-after-attach
[553.481435] Subtest export-wait-after-attach: SUCCESS (0.000s)
[553.512059] [074/130] (607s left) gem_exec_params (sol-reset-not-gen7)
[553.553110] Starting subtest: sol-reset-not-gen7
[553.558183] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[553.637706] [075/130] (607s left) perf (polling)
[553.739325] Starting subtest: polling
[553.741985] Starting dynamic subtest: 0-rcs0
[563.750879] Dynamic subtest 0-rcs0: SUCCESS (10.010s)
[563.760026] Starting dynamic subtest: 1-vcs1
[573.769868] Dynamic subtest 1-vcs1: SUCCESS (10.016s)
[573.772824] Subtest polling: SUCCESS (20.028s)
[573.795578] [076/130] (587s left) gem_exec_fair (basic-sync)
[573.859858] Subtest basic-sync: SKIP (0.000s)
[573.909732] [077/130] (587s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[574.021834] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[574.026263] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[574.092962] [078/130] (587s left) gem_unref_active_buffers
[574.254281] [079/130] (587s left) gem_mmap_wc (write)
[574.296691] Subtest write: SKIP (0.000s)
[574.341090] [080/130] (587s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[574.432429] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[577.798968] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (3.372s)
[577.890046] [081/130] (583s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[577.937824] Starting subtest: single-wait-for-submit-available-signaled
[577.939756] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[577.991827] [082/130] (583s left) gem_exec_fence (invalid-timeline-fence-array)
[578.476725] Starting subtest: invalid-timeline-fence-array
[578.482227] Subtest invalid-timeline-fence-array: SUCCESS (0.005s)
[579.806920] [083/130] (581s left) kms_color (ctm-blue-to-red)
[579.898351] Starting subtest: ctm-blue-to-red
[579.900714] Starting dynamic subtest: pipe-A-eDP-1
[580.553550] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.652s)
[580.563459] Starting dynamic subtest: pipe-B-eDP-1
[581.966884] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.413s)
[581.974680] Starting dynamic subtest: pipe-C-eDP-1
[583.321260] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.353s)
[583.331373] Starting dynamic subtest: pipe-D-eDP-1
[584.674722] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.350s)
[584.677260] Subtest ctm-blue-to-red: SUCCESS (4.772s)
[585.594216] [084/130] (575s left) gen9_exec_parse (valid-registers)
[585.647568] Subtest valid-registers: SKIP (0.000s)
[585.692744] [085/130] (575s left) kms_flip (flip-vs-blocking-wf-vblank)
[585.790333] Starting subtest: flip-vs-blocking-wf-vblank
[585.792863] Starting dynamic subtest: A-eDP1
[594.804766] Dynamic subtest A-eDP1: SUCCESS (9.011s)
[594.815915] Starting dynamic subtest: B-eDP1
[603.830279] Dynamic subtest B-eDP1: SUCCESS (9.020s)
[603.840593] Starting dynamic subtest: C-eDP1
[612.842593] Dynamic subtest C-eDP1: SUCCESS (9.007s)
[612.851743] Starting dynamic subtest: D-eDP1
[621.798213] Dynamic subtest D-eDP1: SUCCESS (8.958s)
[621.800921] Subtest flip-vs-blocking-wf-vblank: SUCCESS (36.006s)
[623.034677] [086/130] (538s left) kms_flip (2x-nonexisting-fb)
[623.123600] Starting subtest: 2x-nonexisting-fb
[623.137791] Subtest 2x-nonexisting-fb: SKIP (0.014s)
[623.192133] [087/130] (538s left) gem_eio (suspend)
[623.406775] Starting subtest: suspend
[635.165478] Subtest suspend: SUCCESS (11.762s)
[636.263873] [088/130] (526s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[636.663238] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[637.542494] [089/130] (525s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[637.638884] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[637.643195] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[637.702321] [090/130] (524s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[637.787753] Starting subtest: psr-rgb101010-draw-mmap-gtt
[637.791706] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[637.852612] [091/130] (524s left) gem_render_copy (yf-tiled-ccs-to-linear)
[637.899404] Starting subtest: yf-tiled-ccs-to-linear
[637.903783] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[638.060177] [092/130] (524s left) kms_lease (master-vs-lease)
[638.147424] Starting subtest: master-vs-lease
[638.149761] Subtest master-vs-lease: SUCCESS (0.001s)
[638.214818] [093/130] (524s left) syncobj_wait (multi-wait-for-submit-submitted)
[638.264665] Starting subtest: multi-wait-for-submit-submitted
[638.368075] Subtest multi-wait-for-submit-submitted: SUCCESS (0.104s)
[638.425329] [094/130] (524s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[638.517344] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[638.522261] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[638.587602] [095/130] (524s left) syncobj_timeline (32bits-limit)
[638.638656] Starting subtest: 32bits-limit
[638.640649] Subtest 32bits-limit: SUCCESS (0.001s)
[638.705837] [096/130] (524s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[638.789995] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[638.792353] Starting dynamic subtest: pipe-A
[640.009391] Dynamic subtest pipe-A: SUCCESS (1.218s)
[640.018373] Starting dynamic subtest: pipe-B
[642.338309] Dynamic subtest pipe-B: SUCCESS (2.329s)
[642.346778] Starting dynamic subtest: pipe-C
[643.572091] Dynamic subtest pipe-C: SUCCESS (1.233s)
[643.582439] Starting dynamic subtest: pipe-D
[644.852655] Dynamic subtest pipe-D: SUCCESS (1.280s)
[644.855395] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (6.062s)
[646.073692] [097/130] (516s left) gem_exec_schedule (deep)
[646.260124] Starting subtest: deep
[646.262471] Starting dynamic subtest: rcs0
[646.908842] Abort requested by /sbin/init [1] via Terminated, terminating children
[646.909107] Abort requested by /sbin/init [1] via Hangup, terminating children
[646.909120] Exiting gracefully, currently running test will have a 'notrun' result
[647.013214] Closing watchdogs
Done.