[60.997929] Initializing watchdogs
[60.997993]   /dev/watchdog0
[61.017529] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[61.028275] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[61.032112] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.034532] [001/134] (960s left) kms_cursor_edge_walk (64x64-left-edge)
[61.221860] Starting subtest: 64x64-left-edge
[61.222703] Starting dynamic subtest: pipe-A-DP-3
[64.720467] Dynamic subtest pipe-A-DP-3: SUCCESS (3.486s)
[64.732322] Starting dynamic subtest: pipe-D-DP-3
[68.039518] Dynamic subtest pipe-D-DP-3: SUCCESS (3.311s)
[68.040395] Subtest 64x64-left-edge: SUCCESS (6.800s)
[68.292520] [002/134] (953s left) sysfs_heartbeat_interval (precise)
[68.373962] Starting subtest: precise
[68.374853] Starting dynamic subtest: vecs0
[69.972312] Dynamic subtest vecs0: SUCCESS (1.595s)
[69.980507] Starting dynamic subtest: ccs0
[71.463859] Dynamic subtest ccs0: SUCCESS (1.489s)
[71.472418] Starting dynamic subtest: vcs0
[74.144292] Dynamic subtest vcs0: SUCCESS (2.679s)
[74.153091] Starting dynamic subtest: bcs0
[75.567313] Dynamic subtest bcs0: SUCCESS (1.422s)
[75.575833] Starting dynamic subtest: vecs1
[78.094206] Dynamic subtest vecs1: SUCCESS (2.525s)
[78.103152] Starting dynamic subtest: rcs0
[79.568297] Dynamic subtest rcs0: SUCCESS (1.473s)
[79.576528] Starting dynamic subtest: vcs1
[81.031168] Dynamic subtest vcs1: SUCCESS (1.462s)
[81.032197] Subtest precise: SUCCESS (12.647s)
[81.167309] [003/134] (940s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[81.349387] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[81.364697] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.014s)
[81.512973] [004/134] (940s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[81.699584] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[81.701223] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[81.851617] [005/134] (939s left) i915_pm_rpm (reg-read-ioctl)
[84.063690] Starting subtest: reg-read-ioctl
[84.874304] Subtest reg-read-ioctl: SUCCESS (0.810s)
[85.299674] [006/134] (936s left) kms_plane_alpha_blend (alpha-opaque-fb)
[85.478467] Starting subtest: alpha-opaque-fb
[85.737891] Starting dynamic subtest: pipe-A-DP-3
[86.249125] Dynamic subtest pipe-A-DP-3: SUCCESS (0.511s)
[86.257951] Starting dynamic subtest: pipe-D-DP-3
[86.827158] Dynamic subtest pipe-D-DP-3: SUCCESS (0.576s)
[86.827959] Subtest alpha-opaque-fb: SUCCESS (1.347s)
[87.158705] [007/134] (934s left) kms_plane_lowres (tiling-y)
[87.334930] Starting subtest: tiling-y
[87.336603] Subtest tiling-y: SKIP (0.000s)
[87.505145] [008/134] (934s left) kms_properties (crtc-properties-legacy)
[87.679339] Starting subtest: crtc-properties-legacy
[87.680243] Starting dynamic subtest: pipe-A-DP-3
[88.009395] Dynamic subtest pipe-A-DP-3: SUCCESS (0.328s)
[88.017583] Starting dynamic subtest: pipe-B-DP-3
[88.363128] Dynamic subtest pipe-B-DP-3: SUCCESS (0.353s)
[88.371279] Starting dynamic subtest: pipe-C-DP-3
[88.717184] Dynamic subtest pipe-C-DP-3: SUCCESS (0.353s)
[88.725383] Starting dynamic subtest: pipe-D-DP-3
[89.068172] Dynamic subtest pipe-D-DP-3: SUCCESS (0.350s)
[89.069161] Subtest crtc-properties-legacy: SUCCESS (1.388s)
[89.387728] [009/134] (932s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[89.577129] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[90.675263] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (1.097s)
[90.934961] [010/134] (931s left) gem_mmap_offset (mmap-boundaries)
[91.015952] Starting subtest: mmap-boundaries
[91.016865] Starting dynamic subtest: lmem0
[91.136483] Dynamic subtest lmem0: SUCCESS (0.120s)
[91.144553] Starting dynamic subtest: smem0
[92.575332] Dynamic subtest smem0: SUCCESS (1.438s)
[92.576339] Subtest mmap-boundaries: SUCCESS (1.559s)
[92.966450] [011/134] (929s left) gem_exec_async (concurrent-writes)
[93.060511] Starting subtest: concurrent-writes
[93.061436] Starting dynamic subtest: rcs0
[93.106795] Dynamic subtest rcs0: SUCCESS (0.046s)
[93.115511] Starting dynamic subtest: bcs0
[93.119207] Dynamic subtest bcs0: SUCCESS (0.012s)
[93.127447] Starting dynamic subtest: vcs0
[93.129310] Dynamic subtest vcs0: SUCCESS (0.009s)
[93.137474] Starting dynamic subtest: vcs1
[93.139424] Dynamic subtest vcs1: SUCCESS (0.010s)
[93.147505] Starting dynamic subtest: vecs0
[93.149474] Dynamic subtest vecs0: SUCCESS (0.010s)
[93.158036] Starting dynamic subtest: vecs1
[93.159973] Dynamic subtest vecs1: SUCCESS (0.010s)
[93.169075] Starting dynamic subtest: ccs0
[93.173091] Dynamic subtest ccs0: SUCCESS (0.013s)
[93.173979] Subtest concurrent-writes: SUCCESS (0.113s)
[93.501741] [012/134] (928s left) gem_exec_reloc (basic-write-gtt-noreloc)
[93.576497] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[93.672217] [013/134] (928s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[93.748099] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[93.748993] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.001s)
[93.878168] [014/134] (928s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[94.054515] Starting subtest: flip-vs-cursor-toggle
[106.002036] Subtest flip-vs-cursor-toggle: SUCCESS (11.944s)
[106.298676] [015/134] (916s left) api_intel_bb (destroy-bb)
[106.371992] Starting subtest: destroy-bb
[106.410099] Subtest destroy-bb: SUCCESS (0.039s)
[106.612420] [016/134] (915s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[106.794578] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[106.796268] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[106.981395] [017/134] (915s left) gem_close (many-handles-one-vma)
[107.051395] Starting subtest: many-handles-one-vma
[107.080766] Subtest many-handles-one-vma: SUCCESS (0.029s)
[107.282974] [018/134] (915s left) prime_busy (before-wait)
[107.357298] Starting subtest: before-wait
[107.361794] Starting dynamic subtest: rcs0
[107.419539] Dynamic subtest rcs0: SUCCESS (0.058s)
[107.427999] Starting dynamic subtest: bcs0
[107.459075] Dynamic subtest bcs0: SUCCESS (0.039s)
[107.470134] Starting dynamic subtest: vcs0
[107.502257] Dynamic subtest vcs0: SUCCESS (0.043s)
[107.514601] Starting dynamic subtest: vcs1
[107.541714] Dynamic subtest vcs1: SUCCESS (0.039s)
[107.555799] Starting dynamic subtest: vecs0
[107.584503] Dynamic subtest vecs0: SUCCESS (0.042s)
[107.608973] Starting dynamic subtest: vecs1
[107.629208] Dynamic subtest vecs1: SUCCESS (0.044s)
[107.652568] Starting dynamic subtest: ccs0
[107.673097] Dynamic subtest ccs0: SUCCESS (0.043s)
[107.780914] Subtest before-wait: SUCCESS (0.423s)
[108.002942] [019/134] (914s left) kms_draw_crc (draw-method-pwrite)
[108.182985] Starting subtest: draw-method-pwrite
[108.183975] Starting dynamic subtest: xrgb8888-untiled
[108.609235] Dynamic subtest xrgb8888-untiled: SUCCESS (0.426s)
[108.622239] Starting dynamic subtest: rgb565-untiled
[109.041378] Dynamic subtest rgb565-untiled: SUCCESS (0.432s)
[109.054445] Starting dynamic subtest: xrgb2101010-untiled
[109.442565] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.400s)
[109.453971] Starting dynamic subtest: xbgr16161616f-untiled
[109.874919] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.432s)
[109.885019] Starting dynamic subtest: xrgb8888-xtiled
[110.408752] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.533s)
[110.419485] Starting dynamic subtest: rgb565-xtiled
[110.975391] Dynamic subtest rgb565-xtiled: SUCCESS (0.566s)
[110.985876] Starting dynamic subtest: xrgb2101010-xtiled
[111.491881] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.516s)
[111.501322] Starting dynamic subtest: xbgr16161616f-xtiled
[112.091996] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.600s)
[112.101158] Starting dynamic subtest: xrgb8888-4tiled
[112.510134] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.417s)
[112.521462] Starting dynamic subtest: rgb565-4tiled
[112.825449] Dynamic subtest rgb565-4tiled: SUCCESS (0.315s)
[112.835574] Starting dynamic subtest: xrgb2101010-4tiled
[113.225381] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.399s)
[113.234378] Starting dynamic subtest: xbgr16161616f-4tiled
[113.842250] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.616s)
[113.843209] Subtest draw-method-pwrite: SUCCESS (5.659s)
[113.980907] [020/134] (908s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[114.169551] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[114.171230] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[114.373044] [021/134] (908s left) gem_userptr_blits (process-exit-busy)
[114.459997] Starting subtest: process-exit-busy
[114.475280] Subtest process-exit-busy: SUCCESS (0.016s)
[114.691428] [022/134] (908s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[114.873558] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[114.875250] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[115.052494] [023/134] (908s left) i915_drm_fdinfo (all-busy-check-all)
[115.112691] Starting subtest: all-busy-check-all
[115.144464] Subtest all-busy-check-all: SKIP (0.031s)
[115.278132] [024/134] (907s left) gem_exec_balancer (smoke)
[115.401125] Starting subtest: smoke
[138.840899] Subtest smoke: SUCCESS (23.437s)
[139.505067] [025/134] (883s left) gem_lmem_swapping (basic)
[142.239344] Starting subtest: basic
[142.240535] Starting dynamic subtest: lmem0
[163.075762] Dynamic subtest lmem0: SUCCESS (20.836s)
[163.076645] Subtest basic: SUCCESS (20.837s)
[164.483238] [FACT gem_lmem_swapping (basic)] deleted: kernel.kmod_is_loaded.i915: true
[164.484736] [026/134] (858s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[168.589269] Starting subtest: verify-pxp-key-change-after-suspend-resume
[168.592166] Subtest verify-pxp-key-change-after-suspend-resume: SKIP (0.000s)
[168.638377] [FACT gem_pxp (verify-pxp-key-change-after-suspend-resume)] new: kernel.kmod_is_loaded.i915: true
[168.640558] [027/134] (854s left) kms_psr (fbc-pr-primary-page-flip)
[168.826303] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[168.888136] [028/134] (854s left) gem_exec_fence (invalid-timeline-fence-array)
[169.558281] Starting subtest: invalid-timeline-fence-array
[169.568520] Subtest invalid-timeline-fence-array: SUCCESS (0.010s)
[169.861569] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[169.863322] [029/134] (853s left) gem_exec_schedule (preempt-contexts)
[169.955184] Starting subtest: preempt-contexts
[169.956197] Starting dynamic subtest: rcs0
[170.064377] Dynamic subtest rcs0: SUCCESS (0.109s)
[170.073615] Starting dynamic subtest: bcs0
[170.146548] Dynamic subtest bcs0: SUCCESS (0.082s)
[170.155273] Starting dynamic subtest: vcs0
[170.220460] Dynamic subtest vcs0: SUCCESS (0.074s)
[170.229330] Starting dynamic subtest: vcs1
[170.299842] Dynamic subtest vcs1: SUCCESS (0.079s)
[170.308754] Starting dynamic subtest: vecs0
[170.374932] Dynamic subtest vecs0: SUCCESS (0.075s)
[170.383721] Starting dynamic subtest: vecs1
[170.452108] Dynamic subtest vecs1: SUCCESS (0.077s)
[170.461019] Starting dynamic subtest: ccs0
[170.524754] Dynamic subtest ccs0: SUCCESS (0.072s)
[170.525597] Subtest preempt-contexts: SUCCESS (0.570s)
[171.081894] [030/134] (852s left) gen7_exec_parse (bitmasks)
[171.165091] Subtest bitmasks: SKIP (0.000s)
[171.242593] [031/134] (852s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[171.439360] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[171.441008] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[171.635762] [032/134] (851s left) syncobj_wait (wait-delayed-signal)
[171.712145] Starting subtest: wait-delayed-signal
[171.815493] Subtest wait-delayed-signal: SUCCESS (0.103s)
[171.972870] [033/134] (851s left) kms_getfb (getfb-reject-nv12)
[172.156617] Starting subtest: getfb-reject-nv12
[172.158493] Subtest getfb-reject-nv12: SUCCESS (0.002s)
[172.343087] [034/134] (851s left) kms_frontbuffer_tracking (fbc-abgr161616f-draw-mmap-gtt)
[172.530507] Starting subtest: fbc-abgr161616f-draw-mmap-gtt
[172.532177] Subtest fbc-abgr161616f-draw-mmap-gtt: SKIP (0.000s)
[172.715798] [035/134] (851s left) kms_vblank (ts-continuation-dpms-rpm)
[172.903959] Starting subtest: ts-continuation-dpms-rpm
[172.905988] Starting dynamic subtest: pipe-A-DP-3
[175.411632] Dynamic subtest pipe-A-DP-3: SUCCESS (2.506s)
[175.430035] Starting dynamic subtest: pipe-D-DP-3
[176.264704] Dynamic subtest pipe-D-DP-3: SUCCESS (0.849s)
[176.265576] Subtest ts-continuation-dpms-rpm: SUCCESS (3.361s)
[176.543470] [036/134] (847s left) perf (enable-disable)
[176.979554] Starting subtest: enable-disable
[176.980395] Starting dynamic subtest: 0-rcs0
[179.245509] Dynamic subtest 0-rcs0: SUCCESS (2.266s)
[179.246428] Subtest enable-disable: SUCCESS (2.266s)
[179.310131] [037/134] (844s left) gem_exec_params (no-vebox)
[179.410017] Starting subtest: no-vebox
[179.412183] Subtest no-vebox: SUCCESS (0.002s)
[179.604431] [038/134] (844s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[179.790339] Starting subtest: addfb25-y-tiled-legacy
[179.791229] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[179.990904] [039/134] (844s left) gem_ctx_persistence (idempotent)
[180.086956] Starting subtest: idempotent
[180.087815] Subtest idempotent: SUCCESS (0.000s)
[180.275821] [040/134] (843s left) kms_chamelium_frames (hdmi-crc-multiple)
[180.556191] Subtest hdmi-crc-multiple: SKIP (0.000s)
[180.704926] [041/134] (843s left) gem_exec_create (basic)
[180.797015] Starting subtest: basic
[180.797870] Starting dynamic subtest: smem
[182.891731] Dynamic subtest smem: SUCCESS (2.094s)
[182.901996] Starting dynamic subtest: lmem0
[184.998437] Dynamic subtest lmem0: SUCCESS (2.106s)
[184.999552] Subtest basic: SUCCESS (4.202s)
[185.275750] [042/134] (839s left) syncobj_timeline (single-wait-for-submit-signaled)
[185.353225] Starting subtest: single-wait-for-submit-signaled
[185.354150] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[185.495525] [043/134] (838s left) kms_flip (dpms-vs-vblank-race-interruptible)
[185.681461] Starting subtest: dpms-vs-vblank-race-interruptible
[185.686152] Starting dynamic subtest: A-DP3
[188.942226] Dynamic subtest A-DP3: SUCCESS (3.256s)
[188.961548] Starting dynamic subtest: B-DP3
[191.970402] Dynamic subtest B-DP3: SUCCESS (3.026s)
[191.980160] Starting dynamic subtest: C-DP3
[194.942435] Dynamic subtest C-DP3: SUCCESS (2.971s)
[194.953578] Starting dynamic subtest: D-DP3
[197.978131] Dynamic subtest D-DP3: SUCCESS (3.034s)
[197.980532] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (12.297s)
[198.319823] [044/134] (826s left) gem_reg_read (timestamp-moving)
[198.400517] Starting subtest: timestamp-moving
[199.401403] Subtest timestamp-moving: SUCCESS (1.001s)
[199.518263] [045/134] (824s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[199.710165] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[202.170182] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (2.460s)
[202.384963] [046/134] (822s left) kms_psr (psr-cursor-mmap-cpu)
[202.568396] Subtest psr-cursor-mmap-cpu: SKIP (0.000s)
[202.628560] [047/134] (822s left) kms_cursor_crc (cursor-random-512x170)
[203.119173] Starting subtest: cursor-random-512x170
[203.122873] Subtest cursor-random-512x170: SKIP (0.001s)
[203.388737] [048/134] (821s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[203.586370] Starting subtest: 4-tiled-64bpp-rotate-0
[205.602715] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (2.016s)
[205.835502] [049/134] (818s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[206.047952] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[206.049756] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[206.235647] [050/134] (818s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[206.421385] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[206.422261] Starting dynamic subtest: pipe-A-valid-mode
[212.780104] Dynamic subtest pipe-A-valid-mode: SUCCESS (6.356s)
[212.781846] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SUCCESS (6.359s)
[213.116349] [051/134] (811s left) prime_vgem (basic-fence-read)
[213.224014] Starting subtest: basic-fence-read
[213.243129] Subtest basic-fence-read: SKIP (0.018s)
[213.403461] [052/134] (811s left) gem_ctx_param (invalid-get-ringsize)
[213.480859] Starting subtest: invalid-get-ringsize
[213.483185] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[213.666200] [053/134] (811s left) gem_spin_batch (resubmit-new)
[213.753391] Starting subtest: resubmit-new
[213.754351] Starting dynamic subtest: rcs0
[213.789171] Dynamic subtest rcs0: SUCCESS (0.035s)
[213.798994] Starting dynamic subtest: bcs0
[213.800076] Dynamic subtest bcs0: SUCCESS (0.007s)
[213.809762] Starting dynamic subtest: vcs0
[213.810615] Dynamic subtest vcs0: SUCCESS (0.005s)
[213.820292] Starting dynamic subtest: vcs1
[213.821214] Dynamic subtest vcs1: SUCCESS (0.005s)
[213.831131] Starting dynamic subtest: vecs0
[213.832137] Dynamic subtest vecs0: SUCCESS (0.005s)
[213.841499] Starting dynamic subtest: vecs1
[213.842509] Dynamic subtest vecs1: SUCCESS (0.005s)
[213.852214] Starting dynamic subtest: ccs0
[213.853383] Dynamic subtest ccs0: SUCCESS (0.007s)
[213.854624] Subtest resubmit-new: SUCCESS (0.076s)
[214.182760] [054/134] (811s left) gem_lmem_swapping (verify-random)
[216.917136] Starting subtest: verify-random
[216.918380] Starting dynamic subtest: lmem0
[225.516334] Dynamic subtest lmem0: SUCCESS (8.598s)
[225.517283] Subtest verify-random: SUCCESS (8.599s)
[226.527646] [FACT gem_lmem_swapping (verify-random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[226.528670] [FACT gem_lmem_swapping (verify-random)] deleted: kernel.kmod_is_loaded.i915: true
[226.530847] [055/134] (798s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[228.199575] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[228.200489] Starting dynamic subtest: pipe-A
[228.317735] Dynamic subtest pipe-A: SUCCESS (0.118s)
[228.335071] Starting dynamic subtest: pipe-B
[228.532850] Dynamic subtest pipe-B: SUCCESS (0.213s)
[228.548635] Starting dynamic subtest: pipe-C
[228.745911] Dynamic subtest pipe-C: SUCCESS (0.211s)
[228.761961] Starting dynamic subtest: pipe-D
[228.997010] Dynamic subtest pipe-D: SUCCESS (0.249s)
[228.997903] Subtest planes-upscale-20x20-downscale-factor-0-5: SUCCESS (0.798s)
[229.228841] [FACT kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[229.231164] [FACT kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)] new: kernel.kmod_is_loaded.i915: true
[229.233900] [056/134] (796s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-mmap-gtt)
[229.426138] Starting subtest: fbcpsr-abgr161616f-draw-mmap-gtt
[229.427838] Subtest fbcpsr-abgr161616f-draw-mmap-gtt: SKIP (0.000s)
[229.616641] [057/134] (795s left) kms_plane (pixel-format-yf-tiled-modifier)
[229.808638] Starting subtest: pixel-format-yf-tiled-modifier
[229.842775] Starting dynamic subtest: pipe-A-plane-0
[229.844475] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[229.853266] Starting dynamic subtest: pipe-A-plane-3
[229.855562] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[229.864962] Starting dynamic subtest: pipe-A-plane-5
[229.866891] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[230.067164] Starting dynamic subtest: pipe-B-plane-0
[230.068992] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[230.077360] Starting dynamic subtest: pipe-B-plane-3
[230.079121] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[230.087419] Starting dynamic subtest: pipe-B-plane-5
[230.089124] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[230.148902] Subtest pixel-format-yf-tiled-modifier: SKIP (0.338s)
[230.435456] [058/134] (795s left) gem_eio (wait-immediate)
[230.750174] Starting subtest: wait-immediate
[231.280187] Subtest wait-immediate: SUCCESS (0.530s)
[231.517546] [059/134] (794s left) gem_userptr_blits (nohangcheck)
[231.615400] Starting subtest: nohangcheck
[231.931529] Subtest nohangcheck: SUCCESS (0.316s)
[232.132443] [060/134] (793s left) gem_mmap_gtt (fault-concurrent)
[232.215177] Subtest fault-concurrent: SKIP (0.000s)
[232.301945] [061/134] (793s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[232.381484] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[232.486317] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.104s)
[232.630319] [062/134] (793s left) kms_pm_dc (dc3co-vpb-simulation)
[233.825273] Starting subtest: dc3co-vpb-simulation
[233.827082] Subtest dc3co-vpb-simulation: SKIP (0.000s)
[233.986222] [063/134] (791s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[234.185984] Starting subtest: bad-aux-stride-y-tiled-ccs
[234.188420] Starting dynamic subtest: pipe-A-DP-3
[234.196892] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[234.206282] Starting dynamic subtest: pipe-B-DP-3
[234.214589] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[234.223636] Starting dynamic subtest: pipe-C-DP-3
[234.231817] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[234.240854] Starting dynamic subtest: pipe-D-DP-3
[234.249627] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[234.251548] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.007s)
[234.678889] [064/134] (791s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[234.874367] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[236.128531] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.253s)
[236.360979] [065/134] (789s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[236.549430] Starting subtest: primary-y-tiled-reflect-x-0
[236.644846] Subtest primary-y-tiled-reflect-x-0: SKIP (0.095s)
[236.837071] [066/134] (789s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[237.025284] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[237.026184] Starting dynamic subtest: pipe-A-DP-3
[237.034437] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[237.043754] Starting dynamic subtest: pipe-B-DP-3
[237.052024] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[237.061201] Starting dynamic subtest: pipe-C-DP-3
[237.069371] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[237.078369] Starting dynamic subtest: pipe-D-DP-3
[237.088863] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[237.091125] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s)
[237.504935] [067/134] (788s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[237.697114] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[237.698884] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[237.905069] [068/134] (788s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[238.091515] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[238.093696] Starting dynamic subtest: pipe-A-DP-3
[238.101978] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[238.111438] Starting dynamic subtest: pipe-B-DP-3
[238.119839] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[238.129109] Starting dynamic subtest: pipe-C-DP-3
[238.137278] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[238.146745] Starting dynamic subtest: pipe-D-DP-3
[238.157458] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[238.159528] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[238.608979] [069/134] (787s left) perf_pmu (busy-double-start)
[238.679140] Starting subtest: busy-double-start
[238.680045] Starting dynamic subtest: rcs0
[242.317231] Dynamic subtest rcs0: SUCCESS (3.636s)
[242.331609] Starting dynamic subtest: bcs0
[245.927308] Dynamic subtest bcs0: SUCCESS (3.605s)
[245.941603] Starting dynamic subtest: vcs0
[249.515221] Dynamic subtest vcs0: SUCCESS (3.583s)
[249.529789] Starting dynamic subtest: vcs1
[253.125410] Dynamic subtest vcs1: SUCCESS (3.605s)
[253.139923] Starting dynamic subtest: vecs0
[256.707528] Dynamic subtest vecs0: SUCCESS (3.577s)
[256.748255] Starting dynamic subtest: vecs1
[260.311187] Dynamic subtest vecs1: SUCCESS (3.600s)
[260.325821] Starting dynamic subtest: ccs0
[263.908526] Dynamic subtest ccs0: SUCCESS (3.592s)
[263.913549] Subtest busy-double-start: SUCCESS (25.230s)
[264.064683] [070/134] (762s left) perf_pmu (gt-awake)
[264.134812] Starting subtest: gt-awake
[268.554045] Subtest gt-awake: SUCCESS (4.419s)
[268.723864] [071/134] (757s left) kms_atomic (plane-cursor-legacy)
[268.908445] Starting subtest: plane-cursor-legacy
[268.909398] Starting dynamic subtest: pipe-A-DP-3
[269.464959] Dynamic subtest pipe-A-DP-3: SUCCESS (0.555s)
[269.465875] Subtest plane-cursor-legacy: SUCCESS (0.557s)
[269.771418] [072/134] (756s left) kms_rotation_crc (sprite-rotation-180)
[269.958264] Starting subtest: sprite-rotation-180
[280.202354] Subtest sprite-rotation-180: SUCCESS (10.244s)
[280.623968] [073/134] (745s left) syncobj_timeline (device-submit-unordered)
[280.705268] Starting subtest: device-submit-unordered
[280.706244] Subtest device-submit-unordered: SUCCESS (0.000s)
[280.913477] [074/134] (745s left) api_intel_bb (blit-reloc-purge-cache)
[280.996586] Starting subtest: blit-reloc-purge-cache
[280.998481] Subtest blit-reloc-purge-cache: SKIP (0.000s)
[281.148787] [075/134] (745s left) gem_create (create-ext-placement-all)
[281.353805] Starting subtest: create-ext-placement-all
[281.355030] Subtest create-ext-placement-all: SUCCESS (0.000s)
[281.508222] [076/134] (745s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[281.706420] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[281.707293] Starting dynamic subtest: pipe-A-valid-mode
[282.044424] Dynamic subtest pipe-A-valid-mode: SKIP (0.333s)
[282.046179] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.334s)
[282.359497] [077/134] (744s left) gem_ppgtt (shrink-vs-evict-any)
[282.442238] Starting subtest: shrink-vs-evict-any
[287.913351] Subtest shrink-vs-evict-any: SUCCESS (5.470s)
[288.041390] [078/134] (738s left) kms_psr (pr-cursor-plane-onoff)
[288.229844] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[288.287100] [079/134] (738s left) kms_color (legacy-gamma-reset)
[288.473783] Starting subtest: legacy-gamma-reset
[288.474651] Starting dynamic subtest: pipe-A-DP-3
[288.706904] Dynamic subtest pipe-A-DP-3: SUCCESS (0.233s)
[288.719474] Starting dynamic subtest: pipe-B-DP-3
[288.730342] Dynamic subtest pipe-B-DP-3: SUCCESS (0.021s)
[288.740840] Starting dynamic subtest: pipe-C-DP-3
[288.750550] Dynamic subtest pipe-C-DP-3: SUCCESS (0.020s)
[288.762579] Starting dynamic subtest: pipe-D-DP-3
[288.772279] Dynamic subtest pipe-D-DP-3: SUCCESS (0.021s)
[288.773208] Subtest legacy-gamma-reset: SUCCESS (0.299s)
[289.003497] [080/134] (738s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[289.092397] Starting subtest: map-fixed-invalidate-overlap
[289.094283] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[289.293884] [081/134] (737s left) gem_eio (in-flight-contexts-immediate)
[289.555983] Starting subtest: in-flight-contexts-immediate
[302.950965] Subtest in-flight-contexts-immediate: SUCCESS (13.396s)
[303.247451] [082/134] (723s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[303.439244] Starting subtest: fbcpsr-suspend
[303.440972] Subtest fbcpsr-suspend: SKIP (0.000s)
[303.653011] [083/134] (723s left) gem_sync (basic-many-each)
[303.740392] Starting subtest: basic-many-each
[306.114702] Subtest basic-many-each: SUCCESS (2.374s)
[306.392023] [084/134] (721s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[306.583201] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[306.585036] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[306.776212] [085/134] (720s left) kms_chamelium_hpd (vga-hpd)
[307.056773] Subtest vga-hpd: SKIP (0.000s)
[307.210900] [086/134] (720s left) kms_sequence (get-forked-busy)
[307.397418] Starting subtest: get-forked-busy
[307.398356] Starting dynamic subtest: pipe-A-DP-3
[310.063546] Dynamic subtest pipe-A-DP-3: SUCCESS (2.665s)
[310.080477] Starting dynamic subtest: pipe-B-DP-3
[312.621772] Dynamic subtest pipe-B-DP-3: SUCCESS (2.555s)
[312.643287] Starting dynamic subtest: pipe-C-DP-3
[315.182569] Dynamic subtest pipe-C-DP-3: SUCCESS (2.557s)
[315.204921] Starting dynamic subtest: pipe-D-DP-3
[317.752478] Dynamic subtest pipe-D-DP-3: SUCCESS (2.566s)
[317.753599] Subtest get-forked-busy: SUCCESS (10.356s)
[318.053321] [087/134] (709s left) gem_exec_schedule (smoketest-all)
[318.146999] Starting subtest: smoketest-all
[350.457359] Subtest smoketest-all: SUCCESS (32.303s)
[350.924385] [088/134] (676s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[351.124207] Starting subtest: y-tiled-64bpp-rotate-180
[351.126056] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[351.329627] [089/134] (676s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[351.519378] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[351.521118] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[351.726629] [090/134] (676s left) kms_content_protection (lic-type-0)
[351.985469] Starting subtest: lic-type-0
[352.009524] Starting dynamic subtest: pipe-A-DP-3
[473.437240] Dynamic subtest pipe-A-DP-3: FAIL (121.238s)
[473.438146] Subtest lic-type-0: FAIL (121.353s)
[473.668270] [091/134] (554s left) i915_getparams_basic (basic-subslice-total)
[473.752352] Starting subtest: basic-subslice-total
[473.754632] Subtest basic-subslice-total: SUCCESS (0.000s)
[473.939814] [092/134] (554s left) gem_ccs (block-copy-uncompressed)
[474.030010] Starting subtest: block-copy-uncompressed
[474.032387] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[474.079512] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.048s)
[474.091057] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-lmem0
[474.095928] Dynamic subtest linear-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.015s)
[474.108626] Starting dynamic subtest: linear-uncompressed-compfmt0-lmem0-smem
[474.216496] Dynamic subtest linear-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.116s)
[474.228295] Starting dynamic subtest: linear-uncompressed-compfmt0-lmem0-lmem0
[474.329519] Dynamic subtest linear-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.116s)
[474.342442] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[474.346458] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[474.359327] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-lmem0
[474.362478] Dynamic subtest xmajor-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.015s)
[474.375375] Starting dynamic subtest: xmajor-uncompressed-compfmt0-lmem0-smem
[474.486217] Dynamic subtest xmajor-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.117s)
[474.497971] Starting dynamic subtest: xmajor-uncompressed-compfmt0-lmem0-lmem0
[474.598209] Dynamic subtest xmajor-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.117s)
[474.611282] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[474.616931] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[474.629822] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-lmem0
[474.633052] Dynamic subtest tile4-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.015s)
[474.645814] Starting dynamic subtest: tile4-uncompressed-compfmt0-lmem0-smem
[474.756328] Dynamic subtest tile4-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.117s)
[474.768032] Starting dynamic subtest: tile4-uncompressed-compfmt0-lmem0-lmem0
[474.866862] Dynamic subtest tile4-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.115s)
[474.879641] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[474.883585] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.015s)
[474.896972] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-lmem0
[474.899514] Dynamic subtest tile64-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.015s)
[474.912429] Starting dynamic subtest: tile64-uncompressed-compfmt0-lmem0-smem
[475.017444] Dynamic subtest tile64-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.116s)
[475.029165] Starting dynamic subtest: tile64-uncompressed-compfmt0-lmem0-lmem0
[475.141427] Dynamic subtest tile64-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.117s)
[475.148599] Subtest block-copy-uncompressed: SUCCESS (1.106s)
[475.314633] [093/134] (552s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[475.498886] Starting subtest: plane-scaler-unity-scaling-with-rotation
[475.499795] Starting dynamic subtest: pipe-A
[475.864912] Dynamic subtest pipe-A: SUCCESS (0.365s)
[475.889705] Starting dynamic subtest: pipe-B
[476.343636] Dynamic subtest pipe-B: SUCCESS (0.477s)
[476.371837] Starting dynamic subtest: pipe-C
[476.824766] Dynamic subtest pipe-C: SUCCESS (0.479s)
[476.854227] Starting dynamic subtest: pipe-D
[477.304957] Dynamic subtest pipe-D: SUCCESS (0.477s)
[477.308523] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (1.807s)
[477.648757] [094/134] (550s left) gem_pwrite_snooped
[477.812073] [095/134] (550s left) kms_psr (psr-sprite-mmap-cpu)
[478.000235] Subtest psr-sprite-mmap-cpu: SKIP (0.000s)
[478.062438] [096/134] (550s left) gem_exec_reloc (basic-write-read)
[478.154402] Subtest basic-write-read: SKIP (0.000s)
[478.254651] [097/134] (550s left) core_setmaster (master-drop-set-root)
[478.406460] Starting subtest: master-drop-set-root
[478.432781] Subtest master-drop-set-root: SUCCESS (0.026s)
[478.520851] [098/134] (549s left) kms_dp_linktrain_fallback (dsc-fallback)
[478.704926] Starting subtest: dsc-fallback
[478.707548] Subtest dsc-fallback: SKIP (0.001s)
[478.834637] [099/134] (549s left) gem_exec_balancer (full-pulse)
[478.921525] Starting subtest: full-pulse
[481.028306] Subtest full-pulse: SUCCESS (2.107s)
[481.474427] [100/134] (547s left) gem_exec_reloc (basic-concurrent16)
[481.558655] Subtest basic-concurrent16: SKIP (0.000s)
[481.627316] [101/134] (546s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[481.705551] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[481.706430] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[481.900642] [102/134] (546s left) kms_rotation_crc (primary-rotation-270)
[482.092406] Starting subtest: primary-rotation-270
[482.094219] Subtest primary-rotation-270: SKIP (0.001s)
[482.253618] [103/134] (546s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[482.447956] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[482.449692] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[482.618497] [104/134] (546s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[482.812216] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[482.813877] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[483.002860] [105/134] (545s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[483.186886] Starting subtest: compare-crc-sanitycheck-nv12
[483.189375] Starting dynamic subtest: pipe-A-DP-3
[483.977350] Dynamic subtest pipe-A-DP-3: SUCCESS (0.788s)
[483.998063] Starting dynamic subtest: pipe-B-DP-3
[484.669181] Dynamic subtest pipe-B-DP-3: SUCCESS (0.689s)
[484.682586] Starting dynamic subtest: pipe-C-DP-3
[485.333053] Dynamic subtest pipe-C-DP-3: SUCCESS (0.662s)
[485.346553] Starting dynamic subtest: pipe-D-DP-3
[486.018363] Dynamic subtest pipe-D-DP-3: SUCCESS (0.683s)
[486.019257] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.831s)
[486.325585] [106/134] (542s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[486.513773] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[486.516278] Starting dynamic subtest: pipe-A-DP-3
[486.519780] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[486.531123] Starting dynamic subtest: pipe-B-DP-3
[486.534590] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[486.545709] Starting dynamic subtest: pipe-C-DP-3
[486.549164] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[486.560258] Starting dynamic subtest: pipe-D-DP-3
[486.563762] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[486.565363] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SKIP (0.008s)
[486.977507] [107/134] (542s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[487.063412] Starting subtest: multi-wait-all-for-submit-signaled
[487.064325] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[487.211124] [108/134] (541s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[487.406249] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[487.407987] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[487.558801] [109/134] (541s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[487.748210] Starting subtest: fbc-shrfb-scaledprimary
[489.363033] Subtest fbc-shrfb-scaledprimary: SUCCESS (1.615s)
[489.611604] [110/134] (539s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[489.694477] Starting subtest: y-tiled-to-vebox-x-tiled
[489.696530] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[489.982515] [111/134] (539s left) kms_prop_blob (invalid-get-prop)
[490.066684] Starting subtest: invalid-get-prop
[490.067652] Subtest invalid-get-prop: SUCCESS (0.000s)
[490.282125] [112/134] (539s left) kms_psr (fbc-psr-basic)
[490.470617] Subtest fbc-psr-basic: SKIP (0.000s)
[490.522951] [113/134] (539s left) gem_render_copy (linear)
[490.606613] Starting subtest: linear
[490.607495] Starting dynamic subtest: smem
[490.711339] Dynamic subtest smem: SUCCESS (0.104s)
[490.724223] Starting dynamic subtest: lmem0
[491.036792] Dynamic subtest lmem0: SUCCESS (0.324s)
[491.037648] Subtest linear: SUCCESS (0.430s)
[491.354755] [114/134] (538s left) gem_mmap_gtt (basic-copy)
[491.431234] Subtest basic-copy: SKIP (0.000s)
[491.537695] [115/134] (538s left) kms_pm_rpm (pc8-residency)
[493.050061] Starting subtest: pc8-residency
[493.052192] Subtest pc8-residency: SKIP (0.000s)
[493.504038] [116/134] (536s left) gem_exec_reloc (basic-wc)
[493.591985] Subtest basic-wc: SKIP (0.000s)
[493.695584] [117/134] (536s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[493.892496] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[493.894450] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[494.119758] [118/134] (535s left) gem_exec_schedule (semaphore-codependency)
[494.210991] Starting subtest: semaphore-codependency
[494.252243] Subtest semaphore-codependency: SUCCESS (0.041s)
[494.708442] [119/134] (535s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[494.908356] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[494.910192] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[495.046402] [120/134] (535s left) prime_mmap (test_forked_cpu_write)
[495.121892] Starting subtest: test_forked_cpu_write
[495.122821] Starting dynamic subtest: test_forked_cpu_write-smem
[495.130803] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.008s)
[495.144084] Starting dynamic subtest: test_forked_cpu_write-lmem0
[495.145169] Dynamic subtest test_forked_cpu_write-lmem0: SUCCESS (0.009s)
[495.146384] Subtest test_forked_cpu_write: SUCCESS (0.019s)
[495.334737] [121/134] (534s left) gem_fence_thrash (bo-write-verify-threaded-y)
[495.381827] Starting subtest: bo-write-verify-threaded-y
[495.416406] Subtest bo-write-verify-threaded-y: SKIP (0.034s)
[495.487923] [122/134] (534s left) gem_exec_reloc (basic-softpin)
[495.581507] Subtest basic-softpin: SKIP (0.000s)
[495.697686] [123/134] (534s left) kms_invalid_mode (bad-hsync-end)
[495.887280] Starting subtest: bad-hsync-end
[495.889463] Starting dynamic subtest: pipe-A-DP-3
[495.962736] Dynamic subtest pipe-A-DP-3: SUCCESS (0.074s)
[495.979027] Starting dynamic subtest: pipe-B-DP-3
[495.980199] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[495.994566] Starting dynamic subtest: pipe-C-DP-3
[495.995508] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[496.008734] Starting dynamic subtest: pipe-D-DP-3
[496.009586] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[496.010465] Subtest bad-hsync-end: SUCCESS (0.085s)
[496.251536] [124/134] (534s left) perf (buffer-fill)
[496.636271] Starting subtest: buffer-fill
[496.637149] Starting dynamic subtest: 0-rcs0
[498.801773] Dynamic subtest 0-rcs0: SUCCESS (2.165s)
[498.802667] Subtest buffer-fill: SUCCESS (2.166s)
[498.860702] [125/134] (531s left) i915_suspend (basic-s3-without-i915)
[498.915990] Starting subtest: basic-s3-without-i915
[520.051187] Subtest basic-s3-without-i915: SUCCESS (5.826s)
[520.210449] [126/134] (510s left) gem_exec_whisper (basic-fds-priority-all)
[520.306925] Starting subtest: basic-fds-priority-all
[542.966079] Subtest basic-fds-priority-all: SUCCESS (22.657s)
[543.260128] [127/134] (487s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[543.445260] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[543.447777] Starting dynamic subtest: pipe-A-DP-3
[543.456886] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[543.468745] Starting dynamic subtest: pipe-B-DP-3
[543.477985] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[543.490359] Starting dynamic subtest: pipe-C-DP-3
[543.499387] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[543.510908] Starting dynamic subtest: pipe-D-DP-3
[543.522548] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[543.524755] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.007s)
[543.922720] [128/134] (486s left) gem_exec_reloc (basic-wc-read-noreloc)
[544.005037] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[544.110093] [129/134] (486s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[544.301847] Subtest psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[544.353018] [130/134] (486s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[544.539762] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[544.541518] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[544.743415] [131/134] (486s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[544.819965] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[544.820879] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[544.965718] [132/134] (486s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[545.149880] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[545.150767] Starting dynamic subtest: pipe-A-valid-mode
[545.235762] Dynamic subtest pipe-A-valid-mode: SKIP (0.084s)
[545.237617] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.086s)
[545.495528] [133/134] (485s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[545.677353] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.000s)
[545.739857] [134/134] (485s left) kms_cursor_crc (cursor-onscreen-64x21)
[546.095840] Starting subtest: cursor-onscreen-64x21
[546.096792] Starting dynamic subtest: pipe-A-DP-3
[548.921595] Dynamic subtest pipe-A-DP-3: SUCCESS (2.827s)
[548.967982] Starting dynamic subtest: pipe-D-DP-3
[551.593004] Dynamic subtest pipe-D-DP-3: SUCCESS (2.637s)
[551.593940] Subtest cursor-onscreen-64x21: SUCCESS (5.505s)
[552.093335] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_edge_walk
results: parsing output: 1/ for test: sysfs_heartbeat_interval
results: parsing output: 2/ for test: kms_flip
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: i915_pm_rpm
results: parsing output: 5/ for test: kms_plane_alpha_blend
results: parsing output: 6/ for test: kms_plane_lowres
results: parsing output: 7/ for test: kms_properties
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: gem_mmap_offset
results: parsing output: 10/ for test: gem_exec_async
results: parsing output: 11/ for test: gem_exec_reloc
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: kms_cursor_legacy
results: parsing output: 14/ for test: api_intel_bb
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_close
results: parsing output: 17/ for test: prime_busy
results: parsing output: 18/ for test: kms_draw_crc
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_userptr_blits
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: i915_drm_fdinfo
results: parsing output: 23/ for test: gem_exec_balancer
results: parsing output: 24/ for test: gem_lmem_swapping
results: parsing output: 25/ for test: gem_pxp
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: gem_exec_fence
results: parsing output: 28/ for test: gem_exec_schedule
results: parsing output: 29/ for test: gen7_exec_parse
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: syncobj_wait
results: parsing output: 32/ for test: kms_getfb
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_vblank
results: parsing output: 35/ for test: perf
results: parsing output: 36/ for test: gem_exec_params
results: parsing output: 37/ for test: kms_addfb_basic
results: parsing output: 38/ for test: gem_ctx_persistence
results: parsing output: 39/ for test: kms_chamelium_frames
results: parsing output: 40/ for test: gem_exec_create
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: gem_reg_read
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: kms_cursor_crc
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: kms_flip_scaled_crc
results: parsing output: 50/ for test: prime_vgem
results: parsing output: 51/ for test: gem_ctx_param
results: parsing output: 52/ for test: gem_spin_batch
results: parsing output: 53/ for test: gem_lmem_swapping
results: parsing output: 54/ for test: kms_plane_scaling
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_plane
results: parsing output: 57/ for test: gem_eio
results: parsing output: 58/ for test: gem_userptr_blits
results: parsing output: 59/ for test: gem_mmap_gtt
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: kms_pm_dc
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_rotation_crc
results: parsing output: 65/ for test: kms_ccs
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: perf_pmu
results: parsing output: 69/ for test: perf_pmu
results: parsing output: 70/ for test: kms_atomic
results: parsing output: 71/ for test: kms_rotation_crc
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: api_intel_bb
results: parsing output: 74/ for test: gem_create
results: parsing output: 75/ for test: kms_flip_scaled_crc
results: parsing output: 76/ for test: gem_ppgtt
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: kms_color
results: parsing output: 79/ for test: gem_userptr_blits
results: parsing output: 80/ for test: gem_eio
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_sync
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_chamelium_hpd
results: parsing output: 85/ for test: kms_sequence
results: parsing output: 86/ for test: gem_exec_schedule
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_content_protection
results: parsing output: 90/ for test: i915_getparams_basic
results: parsing output: 91/ for test: gem_ccs
results: parsing output: 92/ for test: kms_plane_scaling
results: parsing output: 93/ for test: gem_pwrite_snooped
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: gem_exec_reloc
results: parsing output: 96/ for test: core_setmaster
results: parsing output: 97/ for test: kms_dp_linktrain_fallback
results: parsing output: 98/ for test: gem_exec_balancer
results: parsing output: 99/ for test: gem_exec_reloc
results: parsing output: 100/ for test: syncobj_wait
results: parsing output: 101/ for test: kms_rotation_crc
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_pipe_crc_basic
results: parsing output: 105/ for test: kms_ccs
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_render_copy
results: parsing output: 110/ for test: kms_prop_blob
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: gem_render_copy
results: parsing output: 113/ for test: gem_mmap_gtt
results: parsing output: 114/ for test: kms_pm_rpm
results: parsing output: 115/ for test: gem_exec_reloc
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: gem_exec_schedule
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: prime_mmap
results: parsing output: 120/ for test: gem_fence_thrash
results: parsing output: 121/ for test: gem_exec_reloc
results: parsing output: 122/ for test: kms_invalid_mode
results: parsing output: 123/ for test: perf
results: parsing output: 124/ for test: i915_suspend
results: parsing output: 125/ for test: gem_exec_whisper
results: parsing output: 126/ for test: kms_ccs
results: parsing output: 127/ for test: gem_exec_reloc
results: parsing output: 128/ for test: kms_psr2_sf
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: syncobj_wait
results: parsing output: 131/ for test: kms_flip_scaled_crc
results: parsing output: 132/ for test: kms_psr
results: parsing output: 133/ for test: kms_cursor_crc
Done.