[86.576398] Initializing watchdogs
[86.576463]   /dev/watchdog0
[86.598501] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[86.609435] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[86.613368] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[86.615804] [001/156] (960s left) kms_psr (fbc-pr-primary-blt)
[86.802342] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[86.850684] [002/156] (960s left) kms_fb_coherency (memset-crc)
[87.034983] Starting subtest: memset-crc
[87.035896] Starting dynamic subtest: mmap-offset-fixed
[87.612843] Dynamic subtest mmap-offset-fixed: SUCCESS (0.577s)
[87.706067] Subtest memset-crc: SUCCESS (0.671s)
[87.955865] [003/156] (959s left) gem_userptr_blits (create-destroy-unsync)
[88.044028] Subtest create-destroy-unsync: SKIP (0.000s)
[88.233625] [004/156] (959s left) gen3_render_tiledx_blits
[88.375480] [005/156] (958s left) kms_cursor_crc (cursor-size-change)
[88.557986] Starting subtest: cursor-size-change
[88.559132] Starting dynamic subtest: pipe-A-DP-3
[89.396058] Dynamic subtest pipe-A-DP-3: SUCCESS (0.837s)
[89.407394] Starting dynamic subtest: pipe-D-DP-3
[90.188839] Dynamic subtest pipe-D-DP-3: SUCCESS (0.790s)
[90.189861] Subtest cursor-size-change: SUCCESS (1.630s)
[90.799962] [006/156] (956s left) gem_pxp (verify-pxp-stale-buf-execution)
[93.394505] Starting subtest: verify-pxp-stale-buf-execution
[93.397766] Subtest verify-pxp-stale-buf-execution: SKIP (0.000s)
[93.491332] [007/156] (953s left) syncobj_timeline (device-submit-unordered)
[93.564163] Starting subtest: device-submit-unordered
[93.565220] Subtest device-submit-unordered: SUCCESS (0.001s)
[93.712600] [008/156] (953s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[93.900445] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[93.902148] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[94.112699] [009/156] (953s left) kms_plane_cursor (overlay)
[94.295335] Starting subtest: overlay
[94.297131] Starting dynamic subtest: pipe-A-DP-3-size-64
[97.592127] Dynamic subtest pipe-A-DP-3-size-64: SUCCESS (3.293s)
[97.726628] Starting dynamic subtest: pipe-A-DP-3-size-128
[100.942488] Dynamic subtest pipe-A-DP-3-size-128: SUCCESS (3.250s)
[101.021741] Starting dynamic subtest: pipe-A-DP-3-size-256
[104.226793] Dynamic subtest pipe-A-DP-3-size-256: SUCCESS (3.216s)
[104.397378] Starting dynamic subtest: pipe-B-DP-3-size-64
[107.634176] Dynamic subtest pipe-B-DP-3-size-64: SUCCESS (3.245s)
[107.690754] Starting dynamic subtest: pipe-B-DP-3-size-128
[110.835234] Dynamic subtest pipe-B-DP-3-size-128: SUCCESS (3.151s)
[110.901625] Starting dynamic subtest: pipe-B-DP-3-size-256
[114.069338] Dynamic subtest pipe-B-DP-3-size-256: SUCCESS (3.184s)
[114.208578] Starting dynamic subtest: pipe-C-DP-3-size-64
[117.453757] Dynamic subtest pipe-C-DP-3-size-64: SUCCESS (3.256s)
[117.520439] Starting dynamic subtest: pipe-C-DP-3-size-128
[120.736596] Dynamic subtest pipe-C-DP-3-size-128: SUCCESS (3.233s)
[120.804532] Starting dynamic subtest: pipe-C-DP-3-size-256
[124.021605] Dynamic subtest pipe-C-DP-3-size-256: SUCCESS (3.234s)
[124.161165] Starting dynamic subtest: pipe-D-DP-3-size-64
[127.400754] Dynamic subtest pipe-D-DP-3-size-64: SUCCESS (3.250s)
[127.466927] Starting dynamic subtest: pipe-D-DP-3-size-128
[130.601129] Dynamic subtest pipe-D-DP-3-size-128: SUCCESS (3.150s)
[130.658010] Starting dynamic subtest: pipe-D-DP-3-size-256
[133.851360] Dynamic subtest pipe-D-DP-3-size-256: SUCCESS (3.200s)
[133.977317] Subtest overlay: SUCCESS (39.671s)
[134.285818] [010/156] (913s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[134.542390] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[134.592052] [011/156] (913s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[134.772225] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[134.773927] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[134.871751] [012/156] (912s left) gem_vm_create (create-ext)
[134.953398] Starting subtest: create-ext
[134.957681] Subtest create-ext: SUCCESS (0.004s)
[135.153275] [013/156] (912s left) syncobj_timeline (wait-any-interrupted)
[135.231400] Starting subtest: wait-any-interrupted
[135.334568] Subtest wait-any-interrupted: SUCCESS (0.103s)
[135.487426] [014/156] (912s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[135.559314] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[135.662943] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[135.818073] [015/156] (912s left) kms_psr (pr-no-drrs)
[135.998566] Subtest pr-no-drrs: SKIP (0.000s)
[136.060520] [016/156] (912s left) perf_pmu (init-busy)
[136.126966] Starting subtest: init-busy
[136.127896] Starting dynamic subtest: rcs0
[136.130243] Dynamic subtest rcs0: SUCCESS (0.003s)
[136.139646] Starting dynamic subtest: bcs0
[136.140539] Dynamic subtest bcs0: SUCCESS (0.001s)
[136.149673] Starting dynamic subtest: vcs0
[136.150519] Dynamic subtest vcs0: SUCCESS (0.001s)
[136.159560] Starting dynamic subtest: vcs1
[136.160647] Dynamic subtest vcs1: SUCCESS (0.000s)
[136.169764] Starting dynamic subtest: vecs0
[136.170923] Dynamic subtest vecs0: SUCCESS (0.001s)
[136.179835] Starting dynamic subtest: vecs1
[136.181039] Dynamic subtest vecs1: SUCCESS (0.000s)
[136.190412] Starting dynamic subtest: ccs0
[136.191467] Dynamic subtest ccs0: SUCCESS (0.001s)
[136.192568] Subtest init-busy: SUCCESS (0.009s)
[136.265918] [017/156] (911s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[136.453922] Starting subtest: fbcpsr-shrfb-scaledprimary
[136.455743] Subtest fbcpsr-shrfb-scaledprimary: SKIP (0.000s)
[136.653102] [018/156] (911s left) gem_userptr_blits (unsync-unmap-cycles)
[136.732999] Subtest unsync-unmap-cycles: SKIP (0.000s)
[136.906327] [019/156] (911s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[137.092582] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[137.094259] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[137.217118] [020/156] (911s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[137.406630] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc
[137.408342] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[137.602910] [021/156] (910s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[137.792591] Starting subtest: fbc-farfromfence-mmap-gtt
[137.794281] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[137.945959] [022/156] (910s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[138.022225] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[138.023155] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[138.137670] [023/156] (910s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc)
[138.324606] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc
[138.326279] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[138.450636] [024/156] (910s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[138.518181] Starting subtest: multi-wait-all-for-submit-available-submitted
[138.519127] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[138.624984] [025/156] (910s left) gem_close_race (basic-threads)
[138.736692] Starting subtest: basic-threads
[139.985569] Subtest basic-threads: SUCCESS (1.249s)
[140.333320] [026/156] (908s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[140.548631] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[140.550247] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[140.696035] [027/156] (908s left) gem_busy (semaphore)
[140.965462] Subtest semaphore: SKIP (0.000s)
[141.252645] [028/156] (907s left) kms_lease (lease-unleased-connector)
[141.433881] Starting subtest: lease-unleased-connector
[141.434809] Starting dynamic subtest: pipe-A-DP-3
[141.536584] Dynamic subtest pipe-A-DP-3: SUCCESS (0.102s)
[141.547970] Starting dynamic subtest: pipe-B-DP-3
[141.640302] Dynamic subtest pipe-B-DP-3: SUCCESS (0.102s)
[141.650965] Starting dynamic subtest: pipe-C-DP-3
[141.742581] Dynamic subtest pipe-C-DP-3: SUCCESS (0.101s)
[141.753771] Starting dynamic subtest: pipe-D-DP-3
[141.849426] Dynamic subtest pipe-D-DP-3: SUCCESS (0.104s)
[141.850271] Subtest lease-unleased-connector: SUCCESS (0.415s)
[142.013361] [029/156] (906s left) gem_tiled_fence_blits (basic)
[142.091554] Subtest basic: SKIP (0.000s)
[142.160703] [030/156] (906s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[142.860358] Starting subtest: syncobj-backward-timeline-chain-engines
[143.020100] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.170s)
[143.351092] [FACT gem_exec_fence (syncobj-backward-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[143.353245] [031/156] (905s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-pgflip-blt)
[143.549720] Starting subtest: fbchdr-2p-scndscrn-shrfb-pgflip-blt
[143.551460] Subtest fbchdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[143.726872] [032/156] (905s left) gem_exec_reloc (basic-write-wc)
[143.816890] Subtest basic-write-wc: SKIP (0.000s)
[143.896810] [033/156] (905s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[144.084651] Starting subtest: modeset-atomic-cursor-hotspot
[144.086397] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[144.196353] [034/156] (905s left) kms_frontbuffer_tracking (hdr-modesetfrombusy)
[144.392589] Starting subtest: hdr-modesetfrombusy
[145.295319] Subtest hdr-modesetfrombusy: SUCCESS (0.904s)
[145.518119] [035/156] (903s left) dumb_buffer (create-clear)
[145.596219] Starting subtest: create-clear
[145.721811] Subtest create-clear: FAIL (0.016s)
[145.807839] [036/156] (903s left) i915_drm_fdinfo (busy)
[145.880563] Starting subtest: busy
[145.881491] Starting dynamic subtest: rcs0
[145.883232] Dynamic subtest rcs0: SKIP (0.001s)
[145.892943] Starting dynamic subtest: bcs0
[145.894808] Dynamic subtest bcs0: SKIP (0.000s)
[145.904591] Starting dynamic subtest: vcs0
[145.906417] Dynamic subtest vcs0: SKIP (0.000s)
[145.916171] Starting dynamic subtest: vcs1
[145.918178] Dynamic subtest vcs1: SKIP (0.000s)
[145.927614] Starting dynamic subtest: vecs0
[145.929921] Dynamic subtest vecs0: SKIP (0.000s)
[145.939490] Starting dynamic subtest: vecs1
[145.941422] Dynamic subtest vecs1: SKIP (0.000s)
[145.950720] Starting dynamic subtest: ccs0
[145.953048] Dynamic subtest ccs0: SKIP (0.000s)
[145.954949] Subtest busy: SKIP (0.007s)
[145.999196] [037/156] (903s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[146.206564] Starting subtest: yf-tiled-addfb-size-offset-overflow
[146.208273] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[146.325076] [038/156] (903s left) core_getversion (all-cards)
[146.390990] Starting subtest: all-cards
[146.428523] Subtest all-cards: SUCCESS (0.038s)
[146.493693] [039/156] (903s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[146.772510] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[146.968819] [040/156] (902s left) i915_query (query-regions-sanity-check)
[147.049379] Starting subtest: query-regions-sanity-check
[147.071998] Subtest query-regions-sanity-check: SUCCESS (0.023s)
[147.206682] [041/156] (902s left) gem_exec_schedule (thriceslice)
[147.302180] Starting subtest: thriceslice
[147.303156] Starting dynamic subtest: rcs0
[147.331703] Dynamic subtest rcs0: SUCCESS (0.030s)
[147.341404] Starting dynamic subtest: bcs0
[147.364219] Dynamic subtest bcs0: SUCCESS (0.032s)
[147.374536] Starting dynamic subtest: vcs0
[147.418420] Dynamic subtest vcs0: SUCCESS (0.053s)
[147.438173] Starting dynamic subtest: vcs1
[147.483122] Dynamic subtest vcs1: SUCCESS (0.063s)
[147.497833] Starting dynamic subtest: vecs0
[147.543590] Dynamic subtest vecs0: SUCCESS (0.058s)
[147.557498] Starting dynamic subtest: vecs1
[147.579019] Dynamic subtest vecs1: SUCCESS (0.034s)
[147.602399] Starting dynamic subtest: ccs0
[147.644909] Dynamic subtest ccs0: SUCCESS (0.064s)
[147.646996] Subtest thriceslice: SUCCESS (0.344s)
[148.005289] [042/156] (901s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-onoff)
[148.199890] Starting subtest: hdr-2p-primscrn-cur-indfb-onoff
[148.201563] Subtest hdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[148.345327] [043/156] (901s left) syncobj_timeline (multi-wait-signaled)
[148.427298] Starting subtest: multi-wait-signaled
[148.428220] Subtest multi-wait-signaled: SUCCESS (0.001s)
[148.603682] [044/156] (901s left) gem_mmap_gtt (medium-copy-xy)
[148.685061] Subtest medium-copy-XY: SKIP (0.000s)
[148.764154] [045/156] (901s left) gem_mmap_offset (basic-uaf)
[148.845423] Starting subtest: basic-uaf
[148.846280] Subtest basic-uaf: SUCCESS (0.000s)
[148.995321] [046/156] (901s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[149.187190] Starting subtest: primary-x-tiled-reflect-x-180
[159.767035] Subtest primary-x-tiled-reflect-x-180: SUCCESS (10.580s)
[160.184600] [047/156] (890s left) gem_linear_blits (basic)
[160.675214] Starting subtest: basic
[160.712119] Subtest basic: SUCCESS (0.037s)
[160.919244] [048/156] (889s left) gem_mmap_wc (write-prefaulted)
[161.047076] Subtest write-prefaulted: SKIP (0.000s)
[161.138447] [049/156] (889s left) kms_rotation_crc (sprite-rotation-90)
[161.327923] Starting subtest: sprite-rotation-90
[161.329698] Subtest sprite-rotation-90: SKIP (0.001s)
[161.437757] [050/156] (889s left) i915_hangman (engine-engine-error)
[161.536454] Starting subtest: engine-engine-error
[161.537316] Starting dynamic subtest: rcs0
[162.331474] Dynamic subtest rcs0: SUCCESS (0.795s)
[162.343394] Starting dynamic subtest: bcs0
[163.036368] Dynamic subtest bcs0: SUCCESS (0.704s)
[163.049732] Starting dynamic subtest: vcs0
[163.755426] Dynamic subtest vcs0: SUCCESS (0.718s)
[163.766488] Starting dynamic subtest: vcs1
[164.491586] Dynamic subtest vcs1: SUCCESS (0.735s)
[164.504447] Starting dynamic subtest: vecs0
[165.238290] Dynamic subtest vecs0: SUCCESS (0.746s)
[165.249177] Starting dynamic subtest: vecs1
[165.943333] Dynamic subtest vecs1: SUCCESS (0.704s)
[165.954040] Starting dynamic subtest: ccs0
[166.693281] Dynamic subtest ccs0: SUCCESS (0.749s)
[166.694239] Subtest engine-engine-error: SUCCESS (5.158s)
[166.848746] [051/156] (883s left) kms_pm_lpsp (screens-disabled)
[168.045406] Starting subtest: screens-disabled
[168.047155] Subtest screens-disabled: SKIP (0.000s)
[168.212181] [052/156] (882s left) gem_ringfill (basic-all)
[168.657063] Starting subtest: basic-all
[170.422441] Subtest basic-all: SUCCESS (1.765s)
[170.565400] [053/156] (880s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[170.761873] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[170.763541] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[170.918915] [054/156] (879s left) gem_exec_params (invalid-ring2)
[171.008297] Starting subtest: invalid-ring2
[171.009417] Subtest invalid-ring2: SUCCESS (0.000s)
[171.161671] [055/156] (879s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[171.354603] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[171.356299] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[171.516752] [056/156] (879s left) kms_psr (pr-basic)
[171.708660] Subtest pr-basic: SKIP (0.000s)
[171.773521] [057/156] (879s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[171.971612] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[171.973293] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[172.100195] [058/156] (878s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[172.291951] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[172.307934] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.015s)
[172.430132] [059/156] (878s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite)
[172.622776] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite
[172.624434] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[172.779272] [060/156] (878s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[172.973559] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[172.975246] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[173.127323] [061/156] (878s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[173.318403] Starting subtest: flip-vs-cursor-busy-crc-legacy
[173.959699] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.642s)
[174.295587] [062/156] (877s left) gem_exec_reloc (basic-wc-read)
[174.382518] Subtest basic-wc-read: SKIP (0.000s)
[174.466049] [063/156] (876s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[174.653592] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[174.655671] Starting dynamic subtest: pipe-A-DP-3
[178.521215] Dynamic subtest pipe-A-DP-3: SUCCESS (3.863s)
[178.535442] Starting dynamic subtest: pipe-B-DP-3
[179.271179] Dynamic subtest pipe-B-DP-3: SUCCESS (0.745s)
[179.286879] Starting dynamic subtest: pipe-C-DP-3
[180.017444] Dynamic subtest pipe-C-DP-3: SUCCESS (0.741s)
[180.032947] Starting dynamic subtest: pipe-D-DP-3
[180.764760] Dynamic subtest pipe-D-DP-3: SUCCESS (0.740s)
[180.766758] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SUCCESS (6.107s)
[181.099889] [064/156] (870s left) gem_ctx_isolation (preservation-reset)
[181.303958] Starting subtest: preservation-reset
[181.305064] Starting dynamic subtest: rcs0
[181.931757] Dynamic subtest rcs0: SUCCESS (0.627s)
[181.944632] Starting dynamic subtest: bcs0
[182.569300] Dynamic subtest bcs0: SUCCESS (0.637s)
[182.580692] Starting dynamic subtest: vcs0
[183.210642] Dynamic subtest vcs0: SUCCESS (0.641s)
[183.222150] Starting dynamic subtest: vcs1
[183.850609] Dynamic subtest vcs1: SUCCESS (0.639s)
[183.861982] Starting dynamic subtest: vecs0
[184.482742] Dynamic subtest vecs0: SUCCESS (0.631s)
[184.494168] Starting dynamic subtest: vecs1
[185.106540] Dynamic subtest vecs1: SUCCESS (0.623s)
[185.118591] Starting dynamic subtest: ccs0
[185.751017] Dynamic subtest ccs0: SUCCESS (0.644s)
[185.751888] Subtest preservation-reset: SUCCESS (4.448s)
[186.017184] [065/156] (865s left) kms_psr (fbc-pr-suspend)
[186.210519] Subtest fbc-pr-suspend: SKIP (0.000s)
[186.265436] [066/156] (865s left) kms_atomic (atomic-plane-damage)
[186.456483] Starting subtest: atomic-plane-damage
[186.836390] Starting dynamic subtest: pipe-A-DP-3
[187.910047] Dynamic subtest pipe-A-DP-3: SUCCESS (1.074s)
[187.910896] Subtest atomic-plane-damage: SUCCESS (1.453s)
[188.188179] [067/156] (863s left) gem_exec_fence (basic-await)
[188.394187] Starting subtest: basic-await
[188.395310] Starting dynamic subtest: rcs0
[188.519022] Dynamic subtest rcs0: SUCCESS (0.124s)
[188.530613] Starting dynamic subtest: bcs0
[188.605258] Dynamic subtest bcs0: SUCCESS (0.085s)
[188.617823] Starting dynamic subtest: vcs0
[188.692750] Dynamic subtest vcs0: SUCCESS (0.087s)
[188.705576] Starting dynamic subtest: vcs1
[188.780493] Dynamic subtest vcs1: SUCCESS (0.087s)
[188.794982] Starting dynamic subtest: vecs0
[188.870699] Dynamic subtest vecs0: SUCCESS (0.089s)
[188.883322] Starting dynamic subtest: vecs1
[188.957975] Dynamic subtest vecs1: SUCCESS (0.086s)
[188.970946] Starting dynamic subtest: ccs0
[189.046043] Dynamic subtest ccs0: SUCCESS (0.087s)
[189.046925] Subtest basic-await: SUCCESS (0.653s)
[189.790802] [068/156] (861s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[189.993994] Starting subtest: fbc-rgb101010-draw-mmap-wc
[189.996044] Subtest fbc-rgb101010-draw-mmap-wc: SKIP (0.000s)
[190.182128] [069/156] (861s left) gem_exec_schedule (pi-common)
[190.399025] Starting subtest: pi-common
[190.399919] Starting dynamic subtest: rcs0
[190.431653] Dynamic subtest rcs0: SUCCESS (0.033s)
[190.444185] Starting dynamic subtest: bcs0
[190.461437] Dynamic subtest bcs0: SUCCESS (0.029s)
[190.473433] Starting dynamic subtest: vcs0
[190.491445] Dynamic subtest vcs0: SUCCESS (0.029s)
[190.503428] Starting dynamic subtest: vcs1
[190.521089] Dynamic subtest vcs1: SUCCESS (0.029s)
[190.532853] Starting dynamic subtest: vecs0
[190.549857] Dynamic subtest vecs0: SUCCESS (0.028s)
[190.561850] Starting dynamic subtest: vecs1
[190.578890] Dynamic subtest vecs1: SUCCESS (0.028s)
[190.590965] Starting dynamic subtest: ccs0
[190.608886] Dynamic subtest ccs0: SUCCESS (0.029s)
[190.609879] Subtest pi-common: SUCCESS (0.211s)
[190.919040] [070/156] (861s left) perf (invalid-create-userspace-config)
[191.292291] Starting subtest: invalid-create-userspace-config
[191.294450] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[191.349063] [071/156] (860s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[191.544064] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc
[191.545826] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[191.692984] [072/156] (860s left) gem_ctx_engines (none)
[191.786713] Starting subtest: none
[191.789349] Subtest none: SUCCESS (0.002s)
[192.076783] [073/156] (860s left) gem_exec_nop (basic-series)
[192.168666] Starting subtest: basic-series
[196.514062] Subtest basic-series: SUCCESS (4.345s)
[196.767321] [074/156] (855s left) i915_pm_rps (reset)
[196.862235] Starting subtest: reset
[201.931149] Subtest reset: SUCCESS (5.068s)
[202.067480] [075/156] (850s left) kms_vblank (wait-forked-busy-hang)
[202.258250] Starting subtest: wait-forked-busy-hang
[202.259160] Starting dynamic subtest: pipe-A-DP-3
[228.544807] Dynamic subtest pipe-A-DP-3: SUCCESS (26.283s)
[228.566962] Starting dynamic subtest: pipe-D-DP-3
[253.562378] Dynamic subtest pipe-D-DP-3: SUCCESS (25.012s)
[253.563262] Subtest wait-forked-busy-hang: SUCCESS (51.303s)
[253.851781] [076/156] (798s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[254.042424] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[254.043295] Starting dynamic subtest: pipe-A-valid-mode
[255.898587] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.856s)
[255.899468] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (1.857s)
[256.185952] [077/156] (796s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[256.378204] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[256.379954] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[256.525855] [078/156] (796s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[256.717260] Starting subtest: plane-lut1d-pre-ctm3x4
[256.929323] Starting dynamic subtest: pipe-A-plane-0
[257.144525] Dynamic subtest pipe-A-plane-0: SUCCESS (0.215s)
[257.189558] Starting dynamic subtest: pipe-A-plane-1
[257.342667] Dynamic subtest pipe-A-plane-1: SUCCESS (0.195s)
[257.354939] Starting dynamic subtest: pipe-A-plane-2
[257.527672] Dynamic subtest pipe-A-plane-2: SUCCESS (0.183s)
[257.909061] Starting dynamic subtest: pipe-B-plane-0
[258.062174] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[258.073800] Starting dynamic subtest: pipe-B-plane-1
[258.230359] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[258.267962] Starting dynamic subtest: pipe-B-plane-2
[258.430865] Dynamic subtest pipe-B-plane-2: SUCCESS (0.195s)
[258.816692] Starting dynamic subtest: pipe-C-plane-0
[258.981120] Dynamic subtest pipe-C-plane-0: SUCCESS (0.198s)
[259.018254] Starting dynamic subtest: pipe-C-plane-1
[259.179433] Dynamic subtest pipe-C-plane-1: SUCCESS (0.195s)
[259.190995] Starting dynamic subtest: pipe-C-plane-2
[259.364572] Dynamic subtest pipe-C-plane-2: SUCCESS (0.183s)
[259.762397] Starting dynamic subtest: pipe-D-plane-0
[259.943752] Dynamic subtest pipe-D-plane-0: SUCCESS (0.215s)
[259.972391] Starting dynamic subtest: pipe-D-plane-1
[260.126576] Dynamic subtest pipe-D-plane-1: SUCCESS (0.178s)
[260.170637] Starting dynamic subtest: pipe-D-plane-2
[260.325257] Dynamic subtest pipe-D-plane-2: SUCCESS (0.196s)
[260.383522] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (3.667s)
[260.681858] [079/156] (791s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[260.876667] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[260.934644] [080/156] (791s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[261.129572] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[261.144980] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.014s)
[261.243914] [081/156] (791s left) kms_flip (2x-blocking-absolute-wf_vblank)
[261.435294] Starting subtest: 2x-blocking-absolute-wf_vblank
[261.450478] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.014s)
[261.566087] [082/156] (791s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[261.762345] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu
[261.764071] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[261.899398] [083/156] (790s left) gem_softpin (reverse)
[261.989454] Starting subtest: reverse
[262.001306] Subtest reverse: SUCCESS (0.012s)
[262.156929] [084/156] (790s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[262.352301] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[262.354043] Subtest hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[262.503907] [085/156] (790s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-render)
[262.698815] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-render
[263.432119] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (0.733s)
[263.650933] [086/156] (789s left) gem_exec_reloc (basic-cpu-wc)
[263.737727] Subtest basic-cpu-wc: SKIP (0.000s)
[263.844422] [087/156] (789s left) prime_busy (after)
[263.934499] Starting subtest: after
[263.939593] Starting dynamic subtest: rcs0
[263.995582] Dynamic subtest rcs0: SUCCESS (0.056s)
[264.009340] Starting dynamic subtest: bcs0
[264.046625] Dynamic subtest bcs0: SUCCESS (0.050s)
[264.061143] Starting dynamic subtest: vcs0
[264.086448] Dynamic subtest vcs0: SUCCESS (0.039s)
[264.104889] Starting dynamic subtest: vcs1
[264.127014] Dynamic subtest vcs1: SUCCESS (0.039s)
[264.145397] Starting dynamic subtest: vecs0
[264.166971] Dynamic subtest vecs0: SUCCESS (0.039s)
[264.185569] Starting dynamic subtest: vecs1
[264.207186] Dynamic subtest vecs1: SUCCESS (0.039s)
[264.225561] Starting dynamic subtest: ccs0
[264.249047] Dynamic subtest ccs0: SUCCESS (0.040s)
[264.359205] Subtest after: SUCCESS (0.420s)
[264.488646] [088/156] (788s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-blt)
[264.689975] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-blt
[265.337920] Subtest hdr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (0.648s)
[265.607440] [089/156] (787s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[265.799307] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[265.800136] Starting dynamic subtest: pipe-A
[266.043288] Dynamic subtest pipe-A: SUCCESS (0.245s)
[266.064705] Starting dynamic subtest: pipe-B
[266.273225] Dynamic subtest pipe-B: SUCCESS (0.228s)
[266.287641] Starting dynamic subtest: pipe-C
[266.485700] Dynamic subtest pipe-C: SUCCESS (0.211s)
[266.510690] Starting dynamic subtest: pipe-D
[266.715708] Dynamic subtest pipe-D: SUCCESS (0.228s)
[266.716855] Subtest planes-downscale-factor-0-5-upscale-20x20: SUCCESS (0.918s)
[267.054991] [090/156] (786s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[267.255283] Starting subtest: cursorA-vs-flipB-toggle
[267.257039] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[267.350147] [091/156] (786s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[267.543985] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[267.545518] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[267.694111] [092/156] (785s left) gem_ctx_persistence (legacy-engines-hostile)
[267.780481] Starting subtest: legacy-engines-hostile
[267.781421] Starting dynamic subtest: render
[267.879503] Dynamic subtest render: SUCCESS (0.098s)
[267.893477] Starting dynamic subtest: bsd1
[267.966819] Dynamic subtest bsd1: SUCCESS (0.085s)
[268.010199] Starting dynamic subtest: bsd2
[268.031362] Dynamic subtest bsd2: SUCCESS (0.062s)
[268.045544] Starting dynamic subtest: blt
[268.129751] Dynamic subtest blt: SUCCESS (0.096s)
[268.172085] Starting dynamic subtest: vebox
[268.193404] Dynamic subtest vebox: SUCCESS (0.061s)
[268.194415] Subtest legacy-engines-hostile: SUCCESS (0.414s)
[268.350237] [093/156] (785s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[268.555275] Starting subtest: y-tiled-8bpp-rotate-180
[268.557063] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[268.712587] [094/156] (784s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-move)
[268.909181] Starting subtest: hdr-2p-primscrn-spr-indfb-move
[268.910878] Subtest hdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[269.067792] [095/156] (784s left) syncobj_wait (single-wait-for-submit-submitted)
[269.154467] Starting subtest: single-wait-for-submit-submitted
[269.270360] Subtest single-wait-for-submit-submitted: SUCCESS (0.108s)
[269.387706] [096/156] (784s left) sysfs_defaults (readonly)
[269.474918] Starting subtest: readonly
[269.476190] Starting dynamic subtest: vecs0
[269.477088] Dynamic subtest vecs0: SUCCESS (0.000s)
[269.489176] Starting dynamic subtest: ccs0
[269.490047] Dynamic subtest ccs0: SUCCESS (0.000s)
[269.501212] Starting dynamic subtest: vcs0
[269.502282] Dynamic subtest vcs0: SUCCESS (0.001s)
[269.513650] Starting dynamic subtest: bcs0
[269.514777] Dynamic subtest bcs0: SUCCESS (0.000s)
[269.526348] Starting dynamic subtest: vecs1
[269.527389] Dynamic subtest vecs1: SUCCESS (0.000s)
[269.539143] Starting dynamic subtest: rcs0
[269.540340] Dynamic subtest rcs0: SUCCESS (0.000s)
[269.552641] Starting dynamic subtest: vcs1
[269.553763] Dynamic subtest vcs1: SUCCESS (0.000s)
[269.554918] Subtest readonly: SUCCESS (0.011s)
[269.603412] [097/156] (784s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[269.795809] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[269.797488] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[269.943405] [098/156] (784s left) syncobj_basic (create-signaled)
[270.024432] Starting subtest: create-signaled
[270.025485] Subtest create-signaled: SUCCESS (0.000s)
[270.205914] [099/156] (783s left) gem_userptr_blits (sync-unmap)
[270.301208] Starting subtest: sync-unmap
[270.322631] Subtest sync-unmap: SUCCESS (0.021s)
[270.521515] [100/156] (783s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[270.714352] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[270.715246] Starting dynamic subtest: pipe-A-DP-3
[310.205072] Dynamic subtest pipe-A-DP-3: SUCCESS (8.461s)
[310.225521] Starting dynamic subtest: pipe-B-DP-3
[348.836761] Dynamic subtest pipe-B-DP-3: SUCCESS (7.447s)
[348.853922] Starting dynamic subtest: pipe-C-DP-3
[387.811865] Dynamic subtest pipe-C-DP-3: SUCCESS (7.490s)
[387.827428] Starting dynamic subtest: pipe-D-DP-3
[426.856081] Dynamic subtest pipe-D-DP-3: SUCCESS (7.224s)
[426.857225] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SUCCESS (30.633s)
[445.249947] [101/156] (627s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[445.448861] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[445.450485] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[445.607364] [102/156] (626s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[445.806942] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[445.808643] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[445.947957] [103/156] (626s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[446.146998] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[446.148649] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[446.278572] [104/156] (626s left) gem_lmem_swapping (basic)
[449.005772] Starting subtest: basic
[449.008586] Starting dynamic subtest: lmem0
[469.920589] Dynamic subtest lmem0: SUCCESS (20.914s)
[469.921547] Subtest basic: SUCCESS (20.915s)
[471.280428] [FACT gem_lmem_swapping (basic)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[471.281460] [FACT gem_lmem_swapping (basic)] deleted: kernel.kmod_is_loaded.i915: true
[471.283424] [105/156] (601s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[472.936841] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[474.208897] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.271s)
[474.451605] [FACT kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[474.454495] [FACT kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)] new: kernel.kmod_is_loaded.i915: true
[474.457914] [106/156] (598s left) gem_exec_balancer (bonded-dual)
[474.556498] Starting subtest: bonded-dual
[474.558462] Subtest bonded-dual: SKIP (0.000s)
[475.034683] [107/156] (597s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[475.231070] Starting subtest: psr-rgb101010-draw-render
[475.232756] Subtest psr-rgb101010-draw-render: SKIP (0.000s)
[475.365327] [108/156] (597s left) kms_big_fb (linear-16bpp-rotate-270)
[475.576344] Starting subtest: linear-16bpp-rotate-270
[475.640638] Subtest linear-16bpp-rotate-270: SKIP (0.064s)
[475.848439] [109/156] (597s left) kms_psr (psr2-sprite-mmap-cpu)
[476.040282] Subtest psr2-sprite-mmap-cpu: SKIP (0.000s)
[476.105678] [110/156] (596s left) kms_chamelium_frames (hdmi-crc-single)
[476.403338] Subtest hdmi-crc-single: SKIP (0.000s)
[476.589370] [111/156] (596s left) kms_pwrite_crc (basic)
[476.781386] Starting subtest: basic
[477.429647] Subtest basic: SUCCESS (0.648s)
[477.776706] [112/156] (595s left) gem_exec_alignment (forked)
[477.864579] Starting subtest: forked
[521.659988] Subtest forked: SUCCESS (43.793s)
[521.869518] [113/156] (551s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[522.016644] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[522.017535] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[522.130564] [114/156] (551s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[522.327661] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[522.329342] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[522.481008] [115/156] (550s left) gem_media_vme
[522.659396] [116/156] (550s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-pwrite)
[522.852474] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-pwrite
[523.448414] Subtest fbchdr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (0.597s)
[523.677642] [117/156] (549s left) kms_lease (atomic-implicit-crtc)
[523.872668] Starting subtest: atomic-implicit-crtc
[523.874969] Starting dynamic subtest: pipe-A-DP-3
[523.879591] Dynamic subtest pipe-A-DP-3: SUCCESS (0.002s)
[523.893397] Starting dynamic subtest: pipe-B-DP-3
[523.897840] Dynamic subtest pipe-B-DP-3: SUCCESS (0.010s)
[523.911772] Starting dynamic subtest: pipe-C-DP-3
[523.916032] Dynamic subtest pipe-C-DP-3: SUCCESS (0.011s)
[523.929114] Starting dynamic subtest: pipe-D-DP-3
[523.933605] Dynamic subtest pipe-D-DP-3: SUCCESS (0.010s)
[523.934575] Subtest atomic-implicit-crtc: SUCCESS (0.041s)
[524.054342] [118/156] (549s left) perf_pmu (busy-check-all)
[524.129538] Starting subtest: busy-check-all
[524.130485] Starting dynamic subtest: rcs0
[524.717082] Dynamic subtest rcs0: SUCCESS (0.587s)
[524.734199] Starting dynamic subtest: bcs0
[525.271808] Dynamic subtest bcs0: SUCCESS (0.552s)
[525.290965] Starting dynamic subtest: vcs0
[525.829093] Dynamic subtest vcs0: SUCCESS (0.552s)
[525.848035] Starting dynamic subtest: vcs1
[526.385819] Dynamic subtest vcs1: SUCCESS (0.552s)
[526.405418] Starting dynamic subtest: vecs0
[526.943954] Dynamic subtest vecs0: SUCCESS (0.552s)
[526.962554] Starting dynamic subtest: vecs1
[527.501433] Dynamic subtest vecs1: SUCCESS (0.553s)
[527.518426] Starting dynamic subtest: ccs0
[528.057733] Dynamic subtest ccs0: SUCCESS (0.554s)
[528.064228] Subtest busy-check-all: SUCCESS (3.930s)
[528.225165] [119/156] (545s left) gem_exec_parallel (engines)
[528.319428] Starting subtest: engines
[528.320330] Starting dynamic subtest: basic
[529.851386] Dynamic subtest basic: SUCCESS (1.531s)
[529.868999] Starting dynamic subtest: contexts
[534.542877] Dynamic subtest contexts: SUCCESS (4.690s)
[534.557500] Starting dynamic subtest: fds
[538.729179] Dynamic subtest fds: SUCCESS (4.185s)
[538.743837] Starting dynamic subtest: userptr
[540.197431] Dynamic subtest userptr: SUCCESS (1.467s)
[540.198529] Subtest engines: SUCCESS (11.878s)
[540.542524] [120/156] (533s left) kms_cursor_crc (cursor-random-32x10)
[540.857215] Starting subtest: cursor-random-32x10
[540.906891] Subtest cursor-random-32x10: SKIP (0.046s)
[541.310574] [121/156] (532s left) kms_cursor_edge_walk (256x256-right-edge)
[541.501495] Starting subtest: 256x256-right-edge
[541.502470] Starting dynamic subtest: pipe-A-DP-3
[544.984103] Dynamic subtest pipe-A-DP-3: SUCCESS (3.481s)
[545.006342] Starting dynamic subtest: pipe-D-DP-3
[548.329072] Dynamic subtest pipe-D-DP-3: SUCCESS (3.342s)
[548.330051] Subtest 256x256-right-edge: SUCCESS (6.828s)
[548.636688] [122/156] (525s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-render)
[548.834254] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-render
[549.531922] Subtest hdr-1p-primscrn-pri-indfb-draw-render: SUCCESS (0.698s)
[549.721646] [123/156] (524s left) gem_fence_thrash (bo-write-verify-threaded-y)
[549.771697] Starting subtest: bo-write-verify-threaded-y
[549.802271] Subtest bo-write-verify-threaded-y: SKIP (0.030s)
[549.878268] [124/156] (524s left) gem_userptr_blits (access-control)
[549.978036] Starting subtest: access-control
[549.979978] Subtest access-control: SKIP (0.000s)
[550.171713] [125/156] (523s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[550.365464] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[553.108401] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (2.743s)
[553.267973] [126/156] (520s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[553.461307] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[553.462200] Starting dynamic subtest: pipe-A-DP-3
[553.470452] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[553.485098] Starting dynamic subtest: pipe-B-DP-3
[553.493619] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[553.507791] Starting dynamic subtest: pipe-C-DP-3
[553.516204] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[553.530458] Starting dynamic subtest: pipe-D-DP-3
[553.539213] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[553.540978] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[553.939946] [127/156] (520s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[554.029491] Subtest writes-after-reads: SKIP (0.000s)
[554.118409] [128/156] (520s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[554.308637] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[554.333366] Starting dynamic subtest: pipe-A-plane-0
[554.833486] Dynamic subtest pipe-A-plane-0: SUCCESS (0.500s)
[554.883340] Starting dynamic subtest: pipe-A-plane-3
[555.184479] Dynamic subtest pipe-A-plane-3: SUCCESS (0.348s)
[555.489716] Starting dynamic subtest: pipe-B-plane-0
[555.820720] Dynamic subtest pipe-B-plane-0: SUCCESS (0.366s)
[555.865171] Starting dynamic subtest: pipe-B-plane-3
[556.136930] Dynamic subtest pipe-B-plane-3: SUCCESS (0.314s)
[556.260967] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SUCCESS (1.952s)
[556.559851] [129/156] (517s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[556.755346] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[556.757103] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[556.921928] [130/156] (517s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[557.128125] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[558.246152] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (1.117s)
[558.439331] [131/156] (516s left) kms_async_flips (alternate-sync-async-flip)
[558.630454] Starting subtest: alternate-sync-async-flip
[558.862327] Starting dynamic subtest: pipe-A-DP-3
[561.182572] Dynamic subtest pipe-A-DP-3: SUCCESS (2.320s)
[561.429708] Starting dynamic subtest: pipe-B-DP-3
[563.557806] Dynamic subtest pipe-B-DP-3: SUCCESS (2.143s)
[563.791415] Starting dynamic subtest: pipe-C-DP-3
[565.924524] Dynamic subtest pipe-C-DP-3: SUCCESS (2.147s)
[566.138785] Starting dynamic subtest: pipe-D-DP-3
[568.265730] Dynamic subtest pipe-D-DP-3: SUCCESS (2.141s)
[568.266751] Subtest alternate-sync-async-flip: SUCCESS (9.637s)
[568.792796] [132/156] (505s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[568.984835] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[568.987183] Starting dynamic subtest: pipe-A-DP-3
[568.995678] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[569.010408] Starting dynamic subtest: pipe-B-DP-3
[569.018842] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[569.033195] Starting dynamic subtest: pipe-C-DP-3
[569.041636] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[569.056248] Starting dynamic subtest: pipe-D-DP-3
[569.066504] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[569.068564] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.007s)
[569.457993] [133/156] (505s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[569.651974] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[569.653751] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[569.807988] [134/156] (505s left) gem_sync (basic-store-each)
[569.907823] Starting subtest: basic-store-each
[572.867264] Subtest basic-store-each: SUCCESS (2.959s)
[573.148008] [135/156] (501s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[573.342966] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[573.344623] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[573.482631] [136/156] (501s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-blt)
[573.681090] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-blt
[573.682851] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[573.820444] [137/156] (501s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[574.010646] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[574.011556] Starting dynamic subtest: pipe-A
[574.105393] Dynamic subtest pipe-A: SUCCESS (0.094s)
[574.140447] Starting dynamic subtest: pipe-B
[574.334786] Dynamic subtest pipe-B: SUCCESS (0.227s)
[574.364995] Starting dynamic subtest: pipe-C
[574.581433] Dynamic subtest pipe-C: SUCCESS (0.245s)
[574.608361] Starting dynamic subtest: pipe-D
[574.827229] Dynamic subtest pipe-D: SUCCESS (0.244s)
[574.828114] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (0.817s)
[575.144740] [138/156] (500s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-mmap-wc)
[575.342036] Starting subtest: fbchdr-rgb101010-draw-mmap-wc
[575.343785] Subtest fbchdr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[575.485423] [139/156] (499s left) kms_frontbuffer_tracking (psrhdr-suspend)
[575.680340] Starting subtest: psrhdr-suspend
[575.682000] Subtest psrhdr-suspend: SKIP (0.000s)
[575.871484] [140/156] (499s left) kms_prime (basic-crc-vgem)
[576.070240] Subtest basic-crc-vgem: SKIP (0.000s)
[576.253727] [141/156] (499s left) kms_frontbuffer_tracking (hdr-shrfb-scaledprimary)
[576.449789] Starting subtest: hdr-shrfb-scaledprimary
[577.229907] Subtest hdr-shrfb-scaledprimary: SUCCESS (0.780s)
[577.496007] [142/156] (498s left) kms_chamelium_color (ctm-green-to-red)
[577.687682] Subtest ctm-green-to-red: SKIP (0.000s)
[577.751260] [143/156] (497s left) api_intel_allocator (open-vm)
[577.833424] Starting subtest: open-vm
[577.859667] Subtest open-vm: SUCCESS (0.026s)
[578.097160] [144/156] (497s left) gem_reg_read (timestamp-moving)
[578.181891] Starting subtest: timestamp-moving
[579.182605] Subtest timestamp-moving: SUCCESS (1.001s)
[579.302090] [145/156] (496s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[579.497650] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[579.566480] [146/156] (496s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-pgflip-blt)
[579.766209] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-pgflip-blt
[579.767939] Subtest fbcpsrhdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[579.917096] [147/156] (496s left) gem_render_copy (linear)
[580.003086] Starting subtest: linear
[580.003990] Starting dynamic subtest: smem
[580.114031] Dynamic subtest smem: SUCCESS (0.110s)
[580.129515] Starting dynamic subtest: lmem0
[580.364300] Dynamic subtest lmem0: SUCCESS (0.249s)
[580.365261] Subtest linear: SUCCESS (0.362s)
[580.620826] [148/156] (495s left) kms_content_protection (uevent)
[580.871511] Starting subtest: uevent
[581.059295] Starting dynamic subtest: pipe-A-DP-3
[615.375937] Dynamic subtest pipe-A-DP-3: FAIL (34.262s)
[615.417009] Subtest uevent: FAIL (34.543s)
[615.699957] [149/156] (460s left) gem_exec_whisper (basic-fds-forked-all)
[615.794291] Starting subtest: basic-fds-forked-all
[638.523610] Subtest basic-fds-forked-all: SUCCESS (22.726s)
[638.806938] [150/156] (437s left) gen9_exec_parse (bb-secure)
[638.895477] Subtest bb-secure: SKIP (0.000s)
[639.005107] [151/156] (437s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[639.207514] Starting subtest: x-tiled-64bpp-rotate-270
[639.272660] Subtest x-tiled-64bpp-rotate-270: SKIP (0.064s)
[639.461477] [152/156] (436s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[639.662515] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[639.664312] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[639.799411] [153/156] (436s left) gem_ctx_create (basic)
[639.896366] Starting subtest: basic
[639.897446] Subtest basic: SUCCESS (0.000s)
[640.161211] [154/156] (436s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[640.363262] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[640.364935] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[640.498986] [155/156] (436s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[640.692219] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[640.693986] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[640.868947] [156/156] (435s left) kms_cursor_crc (cursor-onscreen-64x21)
[641.219409] Starting subtest: cursor-onscreen-64x21
[641.223566] Starting dynamic subtest: pipe-A-DP-3
[644.048192] Dynamic subtest pipe-A-DP-3: SUCCESS (2.824s)
[644.091303] Starting dynamic subtest: pipe-D-DP-3
[646.846992] Dynamic subtest pipe-D-DP-3: SUCCESS (2.769s)
[646.848023] Subtest cursor-onscreen-64x21: SUCCESS (5.626s)
[647.324925] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_fb_coherency
results: parsing output: 2/ for test: gem_userptr_blits
results: parsing output: 3/ for test: gen3_render_tiledx_blits
results: parsing output: 4/ for test: kms_cursor_crc
results: parsing output: 5/ for test: gem_pxp
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_plane_cursor
results: parsing output: 9/ for test: kms_tiled_display
results: parsing output: 10/ for test: kms_plane
results: parsing output: 11/ for test: gem_vm_create
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: perf_pmu
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_userptr_blits
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: syncobj_wait
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: gem_close_race
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_busy
results: parsing output: 27/ for test: kms_lease
results: parsing output: 28/ for test: gem_tiled_fence_blits
results: parsing output: 29/ for test: gem_exec_fence
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: kms_cursor_legacy
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: dumb_buffer
results: parsing output: 35/ for test: i915_drm_fdinfo
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: core_getversion
results: parsing output: 38/ for test: kms_chamelium_hpd
results: parsing output: 39/ for test: i915_query
results: parsing output: 40/ for test: gem_exec_schedule
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: gem_mmap_gtt
results: parsing output: 44/ for test: gem_mmap_offset
results: parsing output: 45/ for test: kms_rotation_crc
results: parsing output: 46/ for test: gem_linear_blits
results: parsing output: 47/ for test: gem_mmap_wc
results: parsing output: 48/ for test: kms_rotation_crc
results: parsing output: 49/ for test: i915_hangman
results: parsing output: 50/ for test: kms_pm_lpsp
results: parsing output: 51/ for test: gem_ringfill
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_exec_params
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_cursor_legacy
results: parsing output: 61/ for test: gem_exec_reloc
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: gem_ctx_isolation
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: kms_atomic
results: parsing output: 66/ for test: gem_exec_fence
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_exec_schedule
results: parsing output: 69/ for test: perf
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_ctx_engines
results: parsing output: 72/ for test: gem_exec_nop
results: parsing output: 73/ for test: i915_pm_rps
results: parsing output: 74/ for test: kms_vblank
results: parsing output: 75/ for test: kms_flip_scaled_crc
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_color_pipeline
results: parsing output: 78/ for test: kms_psr2_sf
results: parsing output: 79/ for test: kms_flip
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_softpin
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_exec_reloc
results: parsing output: 86/ for test: prime_busy
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_plane_scaling
results: parsing output: 89/ for test: kms_cursor_legacy
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_ctx_persistence
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: syncobj_wait
results: parsing output: 95/ for test: sysfs_defaults
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: syncobj_basic
results: parsing output: 98/ for test: gem_userptr_blits
results: parsing output: 99/ for test: kms_ccs
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_lmem_swapping
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: gem_exec_balancer
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: kms_chamelium_frames
results: parsing output: 110/ for test: kms_pwrite_crc
results: parsing output: 111/ for test: gem_exec_alignment
results: parsing output: 112/ for test: syncobj_wait
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_media_vme
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_lease
results: parsing output: 117/ for test: perf_pmu
results: parsing output: 118/ for test: gem_exec_parallel
results: parsing output: 119/ for test: kms_cursor_crc
results: parsing output: 120/ for test: kms_cursor_edge_walk
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_fence_thrash
results: parsing output: 123/ for test: gem_userptr_blits
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 127/ for test: kms_plane
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: kms_async_flips
results: parsing output: 131/ for test: kms_ccs
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: gem_sync
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: kms_plane_scaling
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: kms_prime
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: kms_chamelium_color
results: parsing output: 142/ for test: api_intel_allocator
results: parsing output: 143/ for test: gem_reg_read
results: parsing output: 144/ for test: kms_psr2_sf
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: gem_render_copy
results: parsing output: 147/ for test: kms_content_protection
results: parsing output: 148/ for test: gem_exec_whisper
results: parsing output: 149/ for test: gen9_exec_parse
results: parsing output: 150/ for test: kms_big_fb
results: parsing output: 151/ for test: kms_big_fb
results: parsing output: 152/ for test: gem_ctx_create
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: kms_frontbuffer_tracking
results: parsing output: 155/ for test: kms_cursor_crc
Done.