[67.730632] Initializing watchdogs
[67.730707]   /dev/watchdog0
[67.756320] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[67.770902] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[67.778706] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[67.783063] [001/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[68.039412] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[68.041112] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[68.227895] [002/133] (960s left) gem_exec_suspend (basic-s3-devices)
[68.314369] Starting subtest: basic-S3-devices
[68.315243] Starting dynamic subtest: smem
[78.396405] Dynamic subtest smem: SUCCESS (10.082s)
[78.405198] Starting dynamic subtest: lmem0
[88.558906] Dynamic subtest lmem0: SUCCESS (10.160s)
[88.560209] Subtest basic-S3-devices: SUCCESS (20.243s)
[88.792449] [003/133] (939s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[88.865199] Starting subtest: y-tiled-ccs-to-yf-tiled
[88.867169] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[89.140313] [004/133] (939s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[89.318472] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[89.319396] Starting dynamic subtest: pipe-A-DP-3
[89.327933] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[89.336292] Starting dynamic subtest: pipe-B-DP-3
[89.344782] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[89.353866] Starting dynamic subtest: pipe-C-DP-3
[89.361993] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[89.370192] Starting dynamic subtest: pipe-D-DP-3
[89.379806] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[89.381464] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[89.804537] [005/133] (938s left) kms_flip (bo-too-big)
[89.988654] Starting subtest: bo-too-big
[89.992597] Starting dynamic subtest: A-DP3
[90.355106] Dynamic subtest A-DP3: SUCCESS (0.362s)
[90.387193] Starting dynamic subtest: B-DP3
[90.610234] Dynamic subtest B-DP3: SUCCESS (0.253s)
[90.639061] Starting dynamic subtest: C-DP3
[90.872733] Dynamic subtest C-DP3: SUCCESS (0.261s)
[90.884946] Starting dynamic subtest: D-DP3
[91.104674] Dynamic subtest D-DP3: SUCCESS (0.231s)
[91.108227] Subtest bo-too-big: SUCCESS (1.120s)
[91.513600] [006/133] (937s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[91.583824] Starting subtest: multi-wait-available-unsubmitted-signaled
[91.584680] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s)
[91.742937] [007/133] (936s left) kms_lease (lease-uevent)
[91.923191] Starting subtest: lease-uevent
[92.943369] Subtest lease-uevent: SUCCESS (1.020s)
[93.094441] [008/133] (935s left) gem_exec_fence (syncobj-timeline-wait)
[93.792230] Starting subtest: syncobj-timeline-wait
[93.950489] Subtest syncobj-timeline-wait: SUCCESS (0.157s)
[94.215902] [FACT gem_exec_fence (syncobj-timeline-wait)] new: kernel.kmod_is_loaded.vgem: true
[94.217672] [009/133] (934s left) kms_chamelium_color (gamma)
[94.412778] Subtest gamma: SKIP (0.000s)
[94.476220] [010/133] (934s left) prime_mmap (test_errors)
[94.556622] Starting subtest: test_errors
[94.557541] Starting dynamic subtest: test_errors-smem
[94.699400] Dynamic subtest test_errors-smem: SUCCESS (0.142s)
[94.708484] Starting dynamic subtest: test_errors-lmem0
[95.273318] Dynamic subtest test_errors-lmem0: SUCCESS (0.574s)
[95.274277] Subtest test_errors: SUCCESS (0.716s)
[95.429889] [011/133] (933s left) i915_drm_fdinfo (idle)
[95.497400] Starting subtest: idle
[95.498359] Starting dynamic subtest: rcs0
[96.104052] Dynamic subtest rcs0: SUCCESS (0.606s)
[96.116628] Starting dynamic subtest: bcs0
[96.609729] Dynamic subtest bcs0: SUCCESS (0.504s)
[96.619766] Starting dynamic subtest: vcs0
[97.115533] Dynamic subtest vcs0: SUCCESS (0.505s)
[97.124729] Starting dynamic subtest: vcs1
[97.620811] Dynamic subtest vcs1: SUCCESS (0.504s)
[97.631243] Starting dynamic subtest: vecs0
[98.126234] Dynamic subtest vecs0: SUCCESS (0.505s)
[98.135495] Starting dynamic subtest: vecs1
[98.630897] Dynamic subtest vecs1: SUCCESS (0.503s)
[98.668490] Starting dynamic subtest: ccs0
[99.137221] Dynamic subtest ccs0: SUCCESS (0.506s)
[99.138172] Subtest idle: SUCCESS (3.640s)
[99.281156] [012/133] (929s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[99.470502] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[99.472134] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[99.668615] [013/133] (929s left) kms_invalid_mode (zero-hdisplay)
[99.853871] Starting subtest: zero-hdisplay
[99.854708] Starting dynamic subtest: pipe-A-DP-3
[99.927121] Dynamic subtest pipe-A-DP-3: SUCCESS (0.073s)
[99.937210] Starting dynamic subtest: pipe-B-DP-3
[99.938133] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[99.947606] Starting dynamic subtest: pipe-C-DP-3
[99.948519] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[99.958113] Starting dynamic subtest: pipe-D-DP-3
[99.959068] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[99.960008] Subtest zero-hdisplay: SUCCESS (0.079s)
[100.214661] [014/133] (928s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[100.403430] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[100.404262] Starting dynamic subtest: pipe-A
[100.495623] Dynamic subtest pipe-A: SUCCESS (0.092s)
[100.510220] Starting dynamic subtest: pipe-B
[100.708867] Dynamic subtest pipe-B: SUCCESS (0.213s)
[100.726063] Starting dynamic subtest: pipe-C
[100.923070] Dynamic subtest pipe-C: SUCCESS (0.214s)
[100.938346] Starting dynamic subtest: pipe-D
[101.135894] Dynamic subtest pipe-D: SUCCESS (0.212s)
[101.136827] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (0.733s)
[101.497288] [015/133] (927s left) drm_read (fault-buffer)
[101.747881] Starting subtest: fault-buffer
[101.748797] Subtest fault-buffer: SUCCESS (0.001s)
[101.998488] [016/133] (927s left) gem_ccs (suspend-resume)
[102.087680] Starting subtest: suspend-resume
[102.088560] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0
[119.895675] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (3.906s)
[119.904837] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0
[138.019367] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.691s)
[138.028825] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0
[155.931786] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (3.629s)
[155.940836] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0
[174.003991] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.632s)
[174.013388] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0
[191.962435] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (3.656s)
[191.971725] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0
[210.023907] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.702s)
[210.033521] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0
[227.889438] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0: SUCCESS (3.617s)
[227.898939] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0
[245.960092] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.536s)
[245.960954] Subtest suspend-resume: SUCCESS (29.371s)
[246.184726] [017/133] (783s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[246.367768] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[246.368647] Starting dynamic subtest: pipe-A-DP-3
[246.376996] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[246.386516] Starting dynamic subtest: pipe-B-DP-3
[246.394925] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[246.404285] Starting dynamic subtest: pipe-C-DP-3
[246.412206] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[246.421415] Starting dynamic subtest: pipe-D-DP-3
[246.431403] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[246.433216] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[246.886753] [018/133] (782s left) gem_close (many-handles-one-vma)
[246.971118] Starting subtest: many-handles-one-vma
[247.000625] Subtest many-handles-one-vma: SUCCESS (0.029s)
[247.171089] [019/133] (782s left) gem_busy (extended)
[247.404659] Starting subtest: extended
[247.405581] Starting dynamic subtest: rcs0
[247.508702] Dynamic subtest rcs0: SUCCESS (0.103s)
[247.547959] Starting dynamic subtest: bcs0
[247.561607] Dynamic subtest bcs0: SUCCESS (0.052s)
[247.579490] Starting dynamic subtest: vcs0
[247.605454] Dynamic subtest vcs0: SUCCESS (0.043s)
[247.619163] Starting dynamic subtest: vcs1
[247.646667] Dynamic subtest vcs1: SUCCESS (0.040s)
[247.663728] Starting dynamic subtest: vecs0
[247.689840] Dynamic subtest vecs0: SUCCESS (0.042s)
[247.712958] Starting dynamic subtest: vecs1
[247.733978] Dynamic subtest vecs1: SUCCESS (0.043s)
[247.756942] Starting dynamic subtest: ccs0
[247.779618] Dynamic subtest ccs0: SUCCESS (0.045s)
[247.780702] Subtest extended: SUCCESS (0.374s)
[248.110174] [020/133] (781s left) kms_vblank (ts-continuation-suspend)
[248.292289] Starting subtest: ts-continuation-suspend
[248.294261] Starting dynamic subtest: pipe-A-DP-3
[267.935778] Dynamic subtest pipe-A-DP-3: SUCCESS (3.832s)
[267.947333] Starting dynamic subtest: pipe-D-DP-3
[287.135333] Dynamic subtest pipe-D-DP-3: SUCCESS (3.801s)
[287.136258] Subtest ts-continuation-suspend: SUCCESS (7.637s)
[287.404352] [021/133] (742s left) perf_pmu (semaphore-wait-idle)
[287.502565] Starting subtest: semaphore-wait-idle
[287.503508] Starting dynamic subtest: rcs0
[288.042206] Dynamic subtest rcs0: SUCCESS (0.538s)
[288.055596] Starting dynamic subtest: bcs0
[288.556424] Dynamic subtest bcs0: SUCCESS (0.512s)
[288.570296] Starting dynamic subtest: vcs0
[289.069410] Dynamic subtest vcs0: SUCCESS (0.510s)
[289.082755] Starting dynamic subtest: vcs1
[289.582546] Dynamic subtest vcs1: SUCCESS (0.511s)
[289.595281] Starting dynamic subtest: vecs0
[290.095067] Dynamic subtest vecs0: SUCCESS (0.510s)
[290.108610] Starting dynamic subtest: vecs1
[290.608274] Dynamic subtest vecs1: SUCCESS (0.511s)
[290.621668] Starting dynamic subtest: ccs0
[291.121539] Dynamic subtest ccs0: SUCCESS (0.511s)
[291.123360] Subtest semaphore-wait-idle: SUCCESS (3.617s)
[291.326394] [022/133] (738s left) kms_debugfs (display-off-read-all)
[291.512455] Starting subtest: display-off-read-all
[291.591719] Subtest display-off-read-all: SUCCESS (0.079s)
[291.845869] [023/133] (737s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[292.031494] Starting subtest: fbc-rgb101010-draw-blt
[294.896703] Subtest fbc-rgb101010-draw-blt: SUCCESS (2.864s)
[295.125207] [024/133] (734s left) gem_ctx_param (invalid-get-no-zeromap)
[295.201499] Starting subtest: invalid-get-no-zeromap
[295.203420] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[295.404310] [025/133] (734s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[295.606147] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[295.607922] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[295.816194] [026/133] (734s left) gem_exec_big (single)
[295.900816] Starting subtest: single
[301.460615] Subtest single: SUCCESS (5.557s)
[302.207843] [027/133] (727s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[302.521505] Starting subtest: psr-rgb101010-draw-mmap-gtt
[302.523236] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[302.678993] [028/133] (727s left) gem_exec_flush (basic-uc-prw-default)
[302.766800] Subtest basic-uc-prw-default: SKIP (0.000s)
[302.875975] [029/133] (727s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[303.063582] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[303.065287] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[303.215682] [030/133] (727s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[303.401399] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[303.403010] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[303.564043] [031/133] (726s left) gem_exec_create (forked)
[303.664176] Starting subtest: forked
[303.665171] Starting dynamic subtest: smem
[323.795681] Dynamic subtest smem: SUCCESS (20.122s)
[323.813915] Starting dynamic subtest: lmem0
[343.954107] Dynamic subtest lmem0: SUCCESS (20.148s)
[343.955131] Subtest forked: SUCCESS (40.271s)
[344.247289] [032/133] (686s left) kms_feature_discovery (display-1x)
[344.433163] Starting subtest: display-1x
[344.434042] Subtest display-1x: SUCCESS (0.000s)
[344.586841] [033/133] (685s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[344.777612] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[344.779279] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[344.967170] [034/133] (685s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[345.156586] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[345.158286] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[345.354319] [035/133] (685s left) gem_render_copy_redux (interruptible)
[345.438277] Starting subtest: interruptible
[346.189300] Subtest interruptible: SUCCESS (0.751s)
[346.387322] [036/133] (684s left) i915_pm_rpm (system-suspend-execbuf)
[348.716747] Starting subtest: system-suspend-execbuf
[409.124855] Subtest system-suspend-execbuf: SUCCESS (45.011s)
[409.588207] [037/133] (621s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[409.777481] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[409.779135] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[409.980699] [038/133] (620s left) gem_request_retire (retire-vma-not-inactive)
[410.063737] Starting subtest: retire-vma-not-inactive
[410.147782] Subtest retire-vma-not-inactive: SUCCESS (0.084s)
[410.372416] [039/133] (620s left) i915_pm_rps (thresholds-idle)
[410.465152] Starting subtest: thresholds-idle
[410.467109] Subtest thresholds-idle: SKIP (0.000s)
[410.645242] [040/133] (620s left) gem_ctx_persistence (legacy-engines-queued)
[410.730034] Starting subtest: legacy-engines-queued
[410.730942] Starting dynamic subtest: render
[410.854048] Dynamic subtest render: SUCCESS (0.123s)
[410.871883] Starting dynamic subtest: bsd1
[410.916056] Dynamic subtest bsd1: SUCCESS (0.060s)
[410.952499] Starting dynamic subtest: bsd2
[410.989265] Dynamic subtest bsd2: SUCCESS (0.071s)
[411.002244] Starting dynamic subtest: blt
[411.012689] Dynamic subtest blt: SUCCESS (0.023s)
[411.025461] Starting dynamic subtest: vebox
[411.100021] Dynamic subtest vebox: SUCCESS (0.086s)
[411.101240] Subtest legacy-engines-queued: SUCCESS (0.370s)
[411.307466] [041/133] (619s left) i915_hangman (gt-error-state-capture)
[411.405828] Starting subtest: gt-error-state-capture
[411.406717] Starting dynamic subtest: rcs0
[421.222294] Dynamic subtest rcs0: SUCCESS (9.814s)
[421.253861] Starting dynamic subtest: bcs0
[430.154370] Dynamic subtest bcs0: SUCCESS (8.927s)
[430.169942] Starting dynamic subtest: vcs0
[440.205352] Dynamic subtest vcs0: SUCCESS (10.045s)
[440.221014] Starting dynamic subtest: vcs1
[450.171058] Dynamic subtest vcs1: SUCCESS (9.960s)
[450.185915] Starting dynamic subtest: vecs0
[460.164107] Dynamic subtest vecs0: SUCCESS (9.987s)
[460.179249] Starting dynamic subtest: vecs1
[470.110306] Dynamic subtest vecs1: SUCCESS (9.948s)
[470.124337] Starting dynamic subtest: ccs0
[480.182698] Dynamic subtest ccs0: SUCCESS (10.075s)
[480.183616] Subtest gt-error-state-capture: SUCCESS (68.763s)
[480.370786] [042/133] (550s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[480.754855] Starting subtest: cursor-rapid-movement-128x42
[480.757998] Starting dynamic subtest: pipe-A-DP-3
[481.204452] Dynamic subtest pipe-A-DP-3: SUCCESS (0.446s)
[481.259727] Starting dynamic subtest: pipe-D-DP-3
[481.668890] Dynamic subtest pipe-D-DP-3: SUCCESS (0.422s)
[481.669774] Subtest cursor-rapid-movement-128x42: SUCCESS (0.915s)
[482.143908] [043/133] (549s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[482.228900] Subtest writes-after-reads-uncached: SKIP (0.000s)
[482.319067] [044/133] (549s left) gem_mmap_wc (coherency)
[482.395880] Subtest coherency: SKIP (0.000s)
[482.467548] [045/133] (548s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[482.560703] Starting subtest: single-wait-all-for-submit-signaled
[482.561698] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[482.712702] [046/133] (548s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[482.903461] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[485.639177] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (2.737s)
[485.874002] [047/133] (545s left) kms_psr (fbc-psr-primary-mmap-cpu)
[486.060161] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.000s)
[486.117499] [048/133] (545s left) kms_invalid_mode (bad-vsync-start)
[486.303957] Starting subtest: bad-vsync-start
[486.304837] Starting dynamic subtest: pipe-A-DP-3
[486.379437] Dynamic subtest pipe-A-DP-3: SUCCESS (0.074s)
[486.394892] Starting dynamic subtest: pipe-B-DP-3
[486.396014] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[486.411006] Starting dynamic subtest: pipe-C-DP-3
[486.411926] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[486.425855] Starting dynamic subtest: pipe-D-DP-3
[486.426764] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[486.427715] Subtest bad-vsync-start: SUCCESS (0.082s)
[486.666265] [049/133] (544s left) gem_exec_reloc (basic-wc-gtt)
[486.745639] Subtest basic-wc-gtt: SKIP (0.000s)
[486.855898] [050/133] (544s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[486.932567] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[487.007875] [051/133] (544s left) kms_prop_blob (blob-multiple)
[487.085861] Starting subtest: blob-multiple
[487.116856] Subtest blob-multiple: SUCCESS (0.032s)
[487.269343] [052/133] (544s left) api_intel_allocator (open-vm)
[487.347739] Starting subtest: open-vm
[487.378272] Subtest open-vm: SUCCESS (0.031s)
[487.552959] [053/133] (544s left) kms_getfb (getfb-repeated-different-handles)
[487.736511] Starting subtest: getfb-repeated-different-handles
[487.737464] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[487.964328] [054/133] (543s left) kms_content_protection (legacy-hdcp14)
[488.221524] Starting subtest: legacy-hdcp14
[488.497829] Starting dynamic subtest: pipe-A-DP-3
[610.056583] Dynamic subtest pipe-A-DP-3: FAIL (121.287s)
[610.057455] Subtest legacy-hdcp14: FAIL (121.672s)
[610.229814] [055/133] (421s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[610.501942] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[610.658963] [056/133] (421s left) kms_flip (blocking-absolute-wf_vblank)
[610.847723] Starting subtest: blocking-absolute-wf_vblank
[610.852115] Starting dynamic subtest: A-DP3
[618.862222] Dynamic subtest A-DP3: SUCCESS (8.011s)
[618.878806] Starting dynamic subtest: B-DP3
[626.799613] Dynamic subtest B-DP3: SUCCESS (7.937s)
[626.813342] Starting dynamic subtest: C-DP3
[634.739207] Dynamic subtest C-DP3: SUCCESS (7.939s)
[634.754117] Starting dynamic subtest: D-DP3
[642.503670] Dynamic subtest D-DP3: SUCCESS (7.764s)
[642.505849] Subtest blocking-absolute-wf_vblank: SUCCESS (31.662s)
[642.855252] [057/133] (389s left) gem_mmap_offset (bad-object)
[642.930050] Starting subtest: bad-object
[642.930982] Subtest bad-object: SUCCESS (0.000s)
[643.084556] [058/133] (389s left) kms_psr (psr2-no-drrs)
[643.270111] Subtest psr2-no-drrs: SKIP (0.000s)
[643.329351] [059/133] (388s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[643.415288] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[643.509443] [060/133] (388s left) kms_vblank (wait-idle)
[643.696015] Starting subtest: wait-idle
[643.698061] Starting dynamic subtest: pipe-A-DP-3
[646.011245] Dynamic subtest pipe-A-DP-3: SUCCESS (2.313s)
[646.031440] Starting dynamic subtest: pipe-D-DP-3
[648.255962] Dynamic subtest pipe-D-DP-3: SUCCESS (2.238s)
[648.256893] Subtest wait-idle: SUCCESS (4.559s)
[648.549419] [061/133] (383s left) gem_exec_whisper (basic-contexts-all)
[648.638253] Starting subtest: basic-contexts-all
[670.613689] Subtest basic-contexts-all: SUCCESS (21.973s)
[670.894016] [062/133] (361s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[671.090076] Starting subtest: x-tiled-16bpp-rotate-0
[672.867114] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.777s)
[673.096493] [063/133] (359s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[673.283741] Starting subtest: plane-primary-overlay-mutable-zpos
[675.300808] Subtest plane-primary-overlay-mutable-zpos: SKIP (2.016s)
[675.692483] [064/133] (357s left) gen9_exec_parse (bb-start-cmd)
[675.774514] Subtest bb-start-cmd: SKIP (0.000s)
[675.853063] [065/133] (356s left) kms_cursor_crc (cursor-alpha-opaque)
[676.045755] Starting subtest: cursor-alpha-opaque
[676.046690] Starting dynamic subtest: pipe-A-DP-3
[676.636173] Dynamic subtest pipe-A-DP-3: SUCCESS (0.590s)
[676.663878] Starting dynamic subtest: pipe-D-DP-3
[677.171907] Dynamic subtest pipe-D-DP-3: SUCCESS (0.531s)
[677.173332] Subtest cursor-alpha-opaque: SUCCESS (1.127s)
[677.847411] [066/133] (354s left) kms_cursor_crc (cursor-sliding-64x64)
[678.166784] Starting subtest: cursor-sliding-64x64
[678.170218] Starting dynamic subtest: pipe-A-DP-3
[682.512211] Dynamic subtest pipe-A-DP-3: SUCCESS (4.341s)
[682.566687] Starting dynamic subtest: pipe-D-DP-3
[686.976554] Dynamic subtest pipe-D-DP-3: SUCCESS (4.422s)
[686.977531] Subtest cursor-sliding-64x64: SUCCESS (8.810s)
[687.486142] [067/133] (345s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[687.678593] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[687.680213] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[687.852321] [068/133] (345s left) gem_ctx_shared (exec-single-timeline)
[687.960778] Starting subtest: exec-single-timeline
[687.961743] Starting dynamic subtest: rcs0
[689.015819] Dynamic subtest rcs0: SUCCESS (1.053s)
[689.032917] Starting dynamic subtest: bcs0
[690.039740] Dynamic subtest bcs0: SUCCESS (1.019s)
[690.057378] Starting dynamic subtest: vcs0
[691.063544] Dynamic subtest vcs0: SUCCESS (1.019s)
[691.081678] Starting dynamic subtest: vcs1
[692.088676] Dynamic subtest vcs1: SUCCESS (1.019s)
[692.106000] Starting dynamic subtest: vecs0
[693.111672] Dynamic subtest vecs0: SUCCESS (1.019s)
[693.128812] Starting dynamic subtest: vecs1
[694.135542] Dynamic subtest vecs1: SUCCESS (1.019s)
[694.153633] Starting dynamic subtest: ccs0
[695.159703] Dynamic subtest ccs0: SUCCESS (1.019s)
[695.163964] Subtest exec-single-timeline: SUCCESS (7.199s)
[695.515511] [069/133] (337s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[695.704829] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[695.705544] Starting dynamic subtest: pipe-A
[697.744739] Dynamic subtest pipe-A: SUCCESS (2.040s)
[697.771696] Starting dynamic subtest: pipe-B
[699.908067] Dynamic subtest pipe-B: SUCCESS (2.161s)
[699.930629] Starting dynamic subtest: pipe-C
[700.206679] Dynamic subtest pipe-C: SUCCESS (0.297s)
[700.236155] Starting dynamic subtest: pipe-D
[700.519630] Dynamic subtest pipe-D: SUCCESS (0.311s)
[700.520844] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (4.816s)
[700.902055] [070/133] (332s left) gem_wait (write-busy)
[700.993451] Starting subtest: write-busy
[700.994538] Starting dynamic subtest: all-engines
[701.624922] Dynamic subtest all-engines: SUCCESS (0.631s)
[701.643508] Starting dynamic subtest: rcs0
[702.175605] Dynamic subtest rcs0: SUCCESS (0.549s)
[702.189905] Starting dynamic subtest: bcs0
[702.719705] Dynamic subtest bcs0: SUCCESS (0.543s)
[702.734076] Starting dynamic subtest: vcs0
[703.262547] Dynamic subtest vcs0: SUCCESS (0.542s)
[703.276929] Starting dynamic subtest: vcs1
[703.804750] Dynamic subtest vcs1: SUCCESS (0.541s)
[703.820378] Starting dynamic subtest: vecs0
[704.346759] Dynamic subtest vecs0: SUCCESS (0.541s)
[704.362338] Starting dynamic subtest: vecs1
[704.889604] Dynamic subtest vecs1: SUCCESS (0.542s)
[704.905424] Starting dynamic subtest: ccs0
[705.432979] Dynamic subtest ccs0: SUCCESS (0.542s)
[705.433924] Subtest write-busy: SUCCESS (4.439s)
[705.731798] [071/133] (327s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[705.923847] Starting subtest: y-tiled-8bpp-rotate-0
[705.925649] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[706.115661] [072/133] (327s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[706.300848] Starting subtest: basic-busy-flip-before-cursor-legacy
[706.302633] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[706.473340] [073/133] (326s left) gem_basic (bad-close)
[706.549187] Starting subtest: bad-close
[706.551214] Subtest bad-close: SUCCESS (0.000s)
[706.716341] [074/133] (326s left) kms_big_fb (linear-16bpp-rotate-0)
[706.908624] Starting subtest: linear-16bpp-rotate-0
[708.701339] Subtest linear-16bpp-rotate-0: SUCCESS (1.791s)
[708.949245] [075/133] (324s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[709.141783] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[709.196440] [076/133] (324s left) drm_read (short-buffer-wakeup)
[709.452073] Starting subtest: short-buffer-wakeup
[741.670848] Subtest short-buffer-wakeup: SUCCESS (32.213s)
[741.903131] [077/133] (291s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[742.092719] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[742.094512] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[742.306971] [078/133] (291s left) kms_psr (fbc-pr-cursor-render)
[742.511865] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[742.571657] [079/133] (291s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[742.762130] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[742.764484] Starting dynamic subtest: pipe-A-DP-3
[742.767810] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[742.781312] Starting dynamic subtest: pipe-B-DP-3
[742.784633] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[742.798001] Starting dynamic subtest: pipe-C-DP-3
[742.801465] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[742.814584] Starting dynamic subtest: pipe-D-DP-3
[742.818337] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[742.820435] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[743.253669] [080/133] (290s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[743.439190] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[743.441491] Starting dynamic subtest: pipe-A-DP-3
[743.450669] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[743.463975] Starting dynamic subtest: pipe-B-DP-3
[743.473368] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[743.486895] Starting dynamic subtest: pipe-C-DP-3
[743.496514] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[743.510193] Starting dynamic subtest: pipe-D-DP-3
[743.521584] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[743.523723] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[743.929120] [081/133] (290s left) sw_sync (sync_multi_timeline_wait)
[743.976818] Starting subtest: sync_multi_timeline_wait
[743.977760] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[744.131963] [082/133] (289s left) sysfs_heartbeat_interval (idempotent)
[744.214537] Starting subtest: idempotent
[744.216898] Starting dynamic subtest: vecs0
[744.217817] Dynamic subtest vecs0: SUCCESS (0.001s)
[744.232119] Starting dynamic subtest: ccs0
[744.233009] Dynamic subtest ccs0: SUCCESS (0.001s)
[744.246939] Starting dynamic subtest: vcs0
[744.248028] Dynamic subtest vcs0: SUCCESS (0.001s)
[744.261466] Starting dynamic subtest: bcs0
[744.262782] Dynamic subtest bcs0: SUCCESS (0.001s)
[744.276165] Starting dynamic subtest: vecs1
[744.276995] Dynamic subtest vecs1: SUCCESS (0.001s)
[744.290773] Starting dynamic subtest: rcs0
[744.291844] Dynamic subtest rcs0: SUCCESS (0.001s)
[744.305178] Starting dynamic subtest: vcs1
[744.306339] Dynamic subtest vcs1: SUCCESS (0.001s)
[744.307453] Subtest idempotent: SUCCESS (0.015s)
[744.377446] [083/133] (289s left) syncobj_eventfd (invalid-bad-pad)
[744.461924] Starting subtest: invalid-bad-pad
[744.462844] Subtest invalid-bad-pad: SUCCESS (0.000s)
[744.612824] [084/133] (289s left) kms_busy (extended-pageflip-hang-newfb)
[744.806859] Starting subtest: extended-pageflip-hang-newfb
[744.807792] Starting dynamic subtest: pipe-A
[752.687716] Dynamic subtest pipe-A: SUCCESS (7.877s)
[752.703065] Starting dynamic subtest: pipe-D
[760.579973] Dynamic subtest pipe-D: SUCCESS (7.888s)
[760.582221] Subtest extended-pageflip-hang-newfb: SUCCESS (15.772s)
[760.875516] [085/133] (273s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[761.067936] Subtest psr2-cursor-plane-update-sf: SKIP (0.000s)
[761.133902] [086/133] (273s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[761.336306] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[762.037083] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.702s)
[762.290544] [087/133] (272s left) gem_exec_balancer (busy)
[762.377949] Starting subtest: busy
[763.240923] Subtest busy: SUCCESS (0.863s)
[763.690349] [088/133] (270s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[763.882974] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[763.884706] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[764.070552] [089/133] (270s left) vgem_slow (nohang)
[764.138717] Starting subtest: nohang
[774.520527] Subtest nohang: SUCCESS (10.378s)
[774.657178] [090/133] (259s left) gem_spin_batch (resubmit-new-all)
[774.744133] Starting subtest: resubmit-new-all
[774.745050] Starting dynamic subtest: rcs0
[774.788636] Dynamic subtest rcs0: SUCCESS (0.044s)
[774.803851] Starting dynamic subtest: bcs0
[774.804767] Dynamic subtest bcs0: SUCCESS (0.010s)
[774.818512] Starting dynamic subtest: vcs0
[774.819492] Dynamic subtest vcs0: SUCCESS (0.009s)
[774.833622] Starting dynamic subtest: vcs1
[774.834553] Dynamic subtest vcs1: SUCCESS (0.008s)
[774.848156] Starting dynamic subtest: vecs0
[774.849035] Dynamic subtest vecs0: SUCCESS (0.010s)
[774.862900] Starting dynamic subtest: vecs1
[774.864020] Dynamic subtest vecs1: SUCCESS (0.008s)
[774.877353] Starting dynamic subtest: ccs0
[774.878490] Dynamic subtest ccs0: SUCCESS (0.008s)
[774.879734] Subtest resubmit-new-all: SUCCESS (0.105s)
[775.244206] [091/133] (259s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[775.329354] Starting subtest: mixed-tiled-to-y-tiled-ccs
[775.331239] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[775.612576] [092/133] (259s left) syncobj_timeline (invalid-signal-illegal-point)
[775.705240] Starting subtest: invalid-signal-illegal-point
[775.706152] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[775.858514] [093/133] (258s left) gem_exec_schedule (preempt-contexts)
[775.950188] Starting subtest: preempt-contexts
[775.951091] Starting dynamic subtest: rcs0
[776.054035] Dynamic subtest rcs0: SUCCESS (0.103s)
[776.069041] Starting dynamic subtest: bcs0
[776.130110] Dynamic subtest bcs0: SUCCESS (0.075s)
[776.144969] Starting dynamic subtest: vcs0
[776.205002] Dynamic subtest vcs0: SUCCESS (0.074s)
[776.221144] Starting dynamic subtest: vcs1
[776.279310] Dynamic subtest vcs1: SUCCESS (0.073s)
[776.294207] Starting dynamic subtest: vecs0
[776.353493] Dynamic subtest vecs0: SUCCESS (0.073s)
[776.368692] Starting dynamic subtest: vecs1
[776.427865] Dynamic subtest vecs1: SUCCESS (0.073s)
[776.442698] Starting dynamic subtest: ccs0
[776.502185] Dynamic subtest ccs0: SUCCESS (0.073s)
[776.502977] Subtest preempt-contexts: SUCCESS (0.553s)
[777.044225] [094/133] (257s left) gem_pwrite_snooped
[777.226703] [095/133] (257s left) kms_tiled_display (basic-test-pattern)
[777.490945] Subtest basic-test-pattern: SKIP (0.000s)
[777.556033] [096/133] (257s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[777.742422] Starting subtest: psr-shrfb-scaledprimary
[777.744082] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[777.946029] [097/133] (257s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[778.133448] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[778.135049] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[778.350412] [098/133] (256s left) gem_pwrite (basic-self)
[778.426721] Subtest basic-self: SKIP (0.000s)
[778.506945] [099/133] (256s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[780.117524] Starting subtest: dpms-mode-unset-non-lpsp
[781.389253] Subtest dpms-mode-unset-non-lpsp: SUCCESS (1.271s)
[781.830996] [100/133] (253s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[782.022574] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[782.024243] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[782.213494] [101/133] (253s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[782.401694] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[782.403409] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[782.615029] [102/133] (252s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[782.809859] Starting subtest: plane-lut1d-ctm3x4-lut1d
[782.845187] Starting dynamic subtest: pipe-A-DP-3
[783.244855] Dynamic subtest pipe-A-DP-3: SUCCESS (0.399s)
[783.446087] Starting dynamic subtest: pipe-B-DP-3
[783.782660] Dynamic subtest pipe-B-DP-3: SUCCESS (0.349s)
[783.995778] Starting dynamic subtest: pipe-C-DP-3
[784.333110] Dynamic subtest pipe-C-DP-3: SUCCESS (0.348s)
[784.549849] Starting dynamic subtest: pipe-D-DP-3
[784.884298] Dynamic subtest pipe-D-DP-3: SUCCESS (0.348s)
[784.958430] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (2.149s)
[785.277332] [103/133] (250s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[785.469482] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[785.471156] Subtest psr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[785.678905] [104/133] (250s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[785.879490] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[785.881123] Subtest psr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[786.078461] [105/133] (249s left) gem_exec_schedule (preempt-queue-contexts-chain)
[786.173022] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[786.579665] [106/133] (249s left) api_intel_bb (object-noreloc-keep-cache-simple)
[786.656032] Starting subtest: object-noreloc-keep-cache-simple
[786.689077] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.033s)
[786.879711] [107/133] (249s left) gem_mmap (bad-object)
[786.956873] Subtest bad-object: SKIP (0.000s)
[787.036960] [108/133] (248s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[787.224863] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[787.225771] Starting dynamic subtest: pipe-A-valid-mode
[787.301536] Dynamic subtest pipe-A-valid-mode: SKIP (0.074s)
[787.303303] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.076s)
[787.559973] [109/133] (248s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[787.746855] Starting subtest: bo-too-small-due-to-tiling
[787.748692] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[787.946550] [110/133] (248s left) kms_psr (pr-sprite-blt)
[788.135076] Subtest pr-sprite-blt: SKIP (0.000s)
[788.203752] [111/133] (247s left) kms_draw_crc (fill-fb)
[788.389843] Starting subtest: fill-fb
[788.873408] Subtest fill-fb: SUCCESS (0.484s)
[789.078047] [112/133] (247s left) perf_pmu (busy-idle)
[789.147921] Starting subtest: busy-idle
[789.148807] Starting dynamic subtest: rcs0
[789.880129] Dynamic subtest rcs0: SUCCESS (0.732s)
[789.900606] Starting dynamic subtest: bcs0
[790.547204] Dynamic subtest bcs0: SUCCESS (0.662s)
[790.566864] Starting dynamic subtest: vcs0
[791.216279] Dynamic subtest vcs0: SUCCESS (0.664s)
[791.236462] Starting dynamic subtest: vcs1
[791.891251] Dynamic subtest vcs1: SUCCESS (0.669s)
[791.910919] Starting dynamic subtest: vecs0
[792.562163] Dynamic subtest vecs0: SUCCESS (0.666s)
[792.579793] Starting dynamic subtest: vecs1
[793.229435] Dynamic subtest vecs1: SUCCESS (0.662s)
[793.252090] Starting dynamic subtest: ccs0
[793.906188] Dynamic subtest ccs0: SUCCESS (0.672s)
[793.912462] Subtest busy-idle: SUCCESS (4.760s)
[794.125490] [113/133] (242s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[794.310938] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[794.311827] Starting dynamic subtest: pipe-A-DP-3
[794.332722] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[794.346511] Starting dynamic subtest: pipe-B-DP-3
[794.367735] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[794.381623] Starting dynamic subtest: pipe-C-DP-3
[794.407611] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[794.421778] Starting dynamic subtest: pipe-D-DP-3
[794.447112] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[794.449152] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.014s)
[794.805193] [114/133] (241s left) gem_exec_flush (basic-batch-kernel-default-uc)
[794.888489] Subtest basic-batch-kernel-default-uc: SKIP (0.000s)
[794.968000] [115/133] (241s left) gem_mmap_wc (write-read-distinct)
[795.042731] Subtest write-read-distinct: SKIP (0.000s)
[795.115891] [116/133] (241s left) kms_plane_lowres (tiling-x)
[795.301917] Starting subtest: tiling-x
[795.302812] Starting dynamic subtest: pipe-A-DP-3
[805.981676] Dynamic subtest pipe-A-DP-3: SUCCESS (10.676s)
[806.101373] Starting dynamic subtest: pipe-B-DP-3
[816.554696] Dynamic subtest pipe-B-DP-3: SUCCESS (10.463s)
[816.674146] Starting dynamic subtest: pipe-C-DP-3
[827.186597] Dynamic subtest pipe-C-DP-3: SUCCESS (10.522s)
[827.290661] Starting dynamic subtest: pipe-D-DP-3
[837.967015] Dynamic subtest pipe-D-DP-3: SUCCESS (10.686s)
[838.054339] Subtest tiling-x: SUCCESS (42.742s)
[838.347779] [117/133] (198s left) sw_sync (alloc_merge_fence)
[838.394852] Starting subtest: alloc_merge_fence
[838.395770] Subtest alloc_merge_fence: SUCCESS (0.000s)
[838.522215] [118/133] (198s left) kms_pm_backlight (fade)
[838.707829] Subtest fade: SKIP (0.000s)
[838.777857] [119/133] (197s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[838.961962] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[838.962837] Starting dynamic subtest: pipe-A-valid-mode
[841.865925] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.902s)
[841.866838] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SUCCESS (2.904s)
[842.173866] [120/133] (194s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[842.249012] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[842.350792] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.101s)
[842.540972] [121/133] (194s left) kms_psr (psr-cursor-mmap-cpu)
[842.726737] Subtest psr-cursor-mmap-cpu: SKIP (0.000s)
[842.785542] [122/133] (194s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[842.979528] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[843.705028] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.725s)
[844.009132] [123/133] (193s left) gem_exec_whisper (basic-queues-priority-all)
[844.096787] Starting subtest: basic-queues-priority-all
[866.089570] Subtest basic-queues-priority-all: SUCCESS (22.005s)
[866.369411] [124/133] (170s left) syncobj_timeline (etime-single-wait-all-submitted)
[866.446055] Starting subtest: etime-single-wait-all-submitted
[866.551430] Subtest etime-single-wait-all-submitted: SUCCESS (0.105s)
[866.704953] [125/133] (170s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[866.893785] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[866.895509] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[867.090243] [126/133] (170s left) kms_async_flips (async-flip-dpms)
[867.272556] Starting subtest: async-flip-dpms
[867.499348] Starting dynamic subtest: pipe-A-DP-3
[870.275465] Dynamic subtest pipe-A-DP-3: SUCCESS (2.778s)
[870.591349] Starting dynamic subtest: pipe-B-DP-3
[872.679210] Dynamic subtest pipe-B-DP-3: SUCCESS (2.104s)
[872.898597] Starting dynamic subtest: pipe-C-DP-3
[874.988369] Dynamic subtest pipe-C-DP-3: SUCCESS (2.105s)
[875.177305] Starting dynamic subtest: pipe-D-DP-3
[877.257658] Dynamic subtest pipe-D-DP-3: SUCCESS (2.096s)
[877.262652] Subtest async-flip-dpms: SUCCESS (9.993s)
[877.782148] [127/133] (159s left) gem_exec_reloc (basic-cpu-read-noreloc)
[877.872040] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[877.959385] [128/133] (159s left) syncobj_wait (invalid-reset-illegal-handle)
[878.035977] Starting subtest: invalid-reset-illegal-handle
[878.036855] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[878.211626] [129/133] (159s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[878.293148] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[878.400525] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[878.560945] [130/133] (158s left) gem_tiled_swapping (non-threaded)
[878.636755] Subtest non-threaded: SKIP (0.000s)
[878.708295] [131/133] (158s left) gem_exec_fence (syncobj-timeline-chain-engines)
[879.382345] Starting subtest: syncobj-timeline-chain-engines
[879.541509] Subtest syncobj-timeline-chain-engines: SUCCESS (0.159s)
[879.933321] [132/133] (157s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[880.119874] Starting subtest: flip-vs-cursor-legacy
[889.596701] Subtest flip-vs-cursor-legacy: SUCCESS (9.482s)
[889.908051] [133/133] (147s left) syncobj_basic (illegal-fd-to-handle)
[889.985029] Starting subtest: illegal-fd-to-handle
[889.985939] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[890.171304] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_exec_suspend
results: parsing output: 2/ for test: gem_render_copy
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: kms_lease
results: parsing output: 7/ for test: gem_exec_fence
results: parsing output: 8/ for test: kms_chamelium_color
results: parsing output: 9/ for test: prime_mmap
results: parsing output: 10/ for test: i915_drm_fdinfo
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_invalid_mode
results: parsing output: 13/ for test: kms_plane_scaling
results: parsing output: 14/ for test: drm_read
results: parsing output: 15/ for test: gem_ccs
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: gem_close
results: parsing output: 18/ for test: gem_busy
results: parsing output: 19/ for test: kms_vblank
results: parsing output: 20/ for test: perf_pmu
results: parsing output: 21/ for test: kms_debugfs
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_ctx_param
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_exec_big
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_exec_flush
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_exec_create
results: parsing output: 31/ for test: kms_feature_discovery
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_render_copy_redux
results: parsing output: 35/ for test: i915_pm_rpm
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_request_retire
results: parsing output: 38/ for test: i915_pm_rps
results: parsing output: 39/ for test: gem_ctx_persistence
results: parsing output: 40/ for test: i915_hangman
results: parsing output: 41/ for test: kms_cursor_crc
results: parsing output: 42/ for test: gem_partial_pwrite_pread
results: parsing output: 43/ for test: gem_mmap_wc
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_invalid_mode
results: parsing output: 48/ for test: gem_exec_reloc
results: parsing output: 49/ for test: gem_mmap_gtt
results: parsing output: 50/ for test: kms_prop_blob
results: parsing output: 51/ for test: api_intel_allocator
results: parsing output: 52/ for test: kms_getfb
results: parsing output: 53/ for test: kms_content_protection
results: parsing output: 54/ for test: kms_chamelium_hpd
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: gem_mmap_offset
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: gem_fenced_exec_thrash
results: parsing output: 59/ for test: kms_vblank
results: parsing output: 60/ for test: gem_exec_whisper
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_atomic
results: parsing output: 63/ for test: gen9_exec_parse
results: parsing output: 64/ for test: kms_cursor_crc
results: parsing output: 65/ for test: kms_cursor_crc
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_ctx_shared
results: parsing output: 68/ for test: kms_plane_scaling
results: parsing output: 69/ for test: gem_wait
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_cursor_legacy
results: parsing output: 72/ for test: gem_basic
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_psr2_sf
results: parsing output: 75/ for test: drm_read
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: sw_sync
results: parsing output: 81/ for test: sysfs_heartbeat_interval
results: parsing output: 82/ for test: syncobj_eventfd
results: parsing output: 83/ for test: kms_busy
results: parsing output: 84/ for test: kms_psr2_sf
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: gem_exec_balancer
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: vgem_slow
results: parsing output: 89/ for test: gem_spin_batch
results: parsing output: 90/ for test: gem_render_copy
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: gem_exec_schedule
results: parsing output: 93/ for test: gem_pwrite_snooped
results: parsing output: 94/ for test: kms_tiled_display
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_pwrite
results: parsing output: 98/ for test: kms_pm_rpm
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_color_pipeline
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: api_intel_bb
results: parsing output: 106/ for test: gem_mmap
results: parsing output: 107/ for test: kms_flip_scaled_crc
results: parsing output: 108/ for test: kms_addfb_basic
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: kms_draw_crc
results: parsing output: 111/ for test: perf_pmu
results: parsing output: 112/ for test: kms_ccs
results: parsing output: 113/ for test: gem_exec_flush
results: parsing output: 114/ for test: gem_mmap_wc
results: parsing output: 115/ for test: kms_plane_lowres
results: parsing output: 116/ for test: sw_sync
results: parsing output: 117/ for test: kms_pm_backlight
results: parsing output: 118/ for test: kms_flip_scaled_crc
results: parsing output: 119/ for test: syncobj_wait
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: gem_exec_whisper
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_async_flips
results: parsing output: 126/ for test: gem_exec_reloc
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: gem_tiled_swapping
results: parsing output: 130/ for test: gem_exec_fence
results: parsing output: 131/ for test: kms_cursor_legacy
results: parsing output: 132/ for test: syncobj_basic
Done.