[57.191884] Initializing watchdogs
[57.191931]   /dev/watchdog0
[57.206128] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.210304] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.212450] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.215657] [001/132] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[57.338211] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[57.342701] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[57.447723] [002/132] (960s left) kms_psr (fbc-pr-sprite-plane-move)
[57.531132] Starting subtest: fbc-pr-sprite-plane-move
[57.535296] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[57.624775] [003/132] (960s left) kms_cursor_crc (cursor-onscreen-512x170)
[57.891690] Starting subtest: cursor-onscreen-512x170
[57.895887] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[58.062167] [004/132] (959s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[58.166187] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[66.701668] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.549s)
[66.955817] [005/132] (950s left) prime_mmap (test_invalid_sync_flags)
[67.228067] Starting subtest: test_invalid_sync_flags
[67.230524] Starting dynamic subtest: test_invalid_sync_flags-smem
[67.232832] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[67.235221] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[67.500789] [006/132] (950s left) gem_softpin (allocator-evict)
[67.647029] Starting subtest: allocator-evict
[67.649426] Starting dynamic subtest: rcs0
[91.292335] Dynamic subtest rcs0: SUCCESS (23.646s)
[91.302911] Starting dynamic subtest: bcs0
[115.179831] Dynamic subtest bcs0: SUCCESS (23.885s)
[115.188237] Starting dynamic subtest: vcs0
[139.042986] Dynamic subtest vcs0: SUCCESS (23.861s)
[139.058654] Starting dynamic subtest: vcs1
[162.510674] Dynamic subtest vcs1: SUCCESS (23.468s)
[162.519443] Starting dynamic subtest: vecs0
[186.039208] Dynamic subtest vecs0: SUCCESS (23.528s)
[186.049899] Starting dynamic subtest: ccs0
[210.083130] Dynamic subtest ccs0: SUCCESS (24.043s)
[210.085511] Subtest allocator-evict: SUCCESS (142.436s)
[210.174966] [007/132] (807s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[210.308894] Starting subtest: plane-all-transition-nonblocking-fencing
[210.311215] Starting dynamic subtest: pipe-A-eDP-1
[212.818427] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.511s)
[213.128869] Starting dynamic subtest: pipe-B-eDP-1
[216.321059] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.203s)
[216.621486] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.312s)
[217.465030] [008/132] (800s left) api_intel_bb (render)
[217.532751] Starting subtest: render
[217.535347] Starting dynamic subtest: render-none-512
[217.637268] Dynamic subtest render-none-512: SUCCESS (0.106s)
[217.647538] Starting dynamic subtest: render-none-1024
[218.067557] Dynamic subtest render-none-1024: SUCCESS (0.429s)
[218.075897] Starting dynamic subtest: render-x-512
[218.151044] Dynamic subtest render-x-512: SUCCESS (0.084s)
[218.161213] Starting dynamic subtest: render-x-1024
[218.486789] Dynamic subtest render-x-1024: SUCCESS (0.334s)
[218.497035] Starting dynamic subtest: render-y-512
[218.571027] Dynamic subtest render-y-512: SUCCESS (0.085s)
[218.581036] Starting dynamic subtest: render-y-1024
[218.905585] Dynamic subtest render-y-1024: SUCCESS (0.333s)
[218.908492] Subtest render: SUCCESS (1.374s)
[219.055160] [009/132] (798s left) gem_userptr_blits (relocations)
[219.130743] Starting subtest: relocations
[219.135086] Subtest relocations: SKIP (0.000s)
[219.279435] [010/132] (798s left) kms_cursor_legacy (single-move)
[219.395992] Starting subtest: single-move
[219.398225] Starting dynamic subtest: pipe-A
[224.777060] Dynamic subtest pipe-A: SUCCESS (5.378s)
[224.787781] Starting dynamic subtest: pipe-B
[230.159087] Dynamic subtest pipe-B: SUCCESS (5.380s)
[230.168823] Starting dynamic subtest: pipe-C
[235.540646] Dynamic subtest pipe-C: SUCCESS (5.379s)
[235.549815] Starting dynamic subtest: pipe-D
[240.921494] Dynamic subtest pipe-D: SUCCESS (5.380s)
[240.931556] Starting dynamic subtest: all-pipes
[246.309095] Dynamic subtest all-pipes: SUCCESS (5.387s)
[246.311462] Subtest single-move: SUCCESS (26.911s)
[246.462258] [011/132] (771s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[246.563325] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[246.565463] Starting dynamic subtest: pipe-A-eDP-1
[246.631077] Dynamic subtest pipe-A-eDP-1: SKIP (0.002s)
[246.642072] Starting dynamic subtest: pipe-B-eDP-1
[246.699036] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[246.708357] Starting dynamic subtest: pipe-C-eDP-1
[246.765960] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[246.774859] Starting dynamic subtest: pipe-D-eDP-1
[246.831821] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[246.836105] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.010s)
[248.820867] [012/132] (769s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[248.919147] Starting subtest: psr-1p-primscrn-cur-indfb-move
[256.274473] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.358s)
[256.439618] [013/132] (761s left) kms_atomic_interruptible (atomic-setmode)
[256.545366] Starting subtest: atomic-setmode
[256.547604] Starting dynamic subtest: pipe-A-eDP-1
[263.451485] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.904s)
[263.453828] Subtest atomic-setmode: SUCCESS (6.905s)
[264.323050] [014/132] (753s left) kms_prop_blob (invalid-get-prop-any)
[264.377220] Starting subtest: invalid-get-prop-any
[264.379513] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[264.483563] [015/132] (753s left) gem_exec_schedule (preempt-other-chain)
[264.548221] Starting subtest: preempt-other-chain
[264.550077] Starting dynamic subtest: rcs0
[264.634579] Dynamic subtest rcs0: SUCCESS (0.092s)
[264.647873] Starting dynamic subtest: bcs0
[264.707873] Dynamic subtest bcs0: SUCCESS (0.074s)
[264.717014] Starting dynamic subtest: vcs0
[264.781769] Dynamic subtest vcs0: SUCCESS (0.073s)
[264.792988] Starting dynamic subtest: vcs1
[264.860815] Dynamic subtest vcs1: SUCCESS (0.079s)
[264.876707] Starting dynamic subtest: vecs0
[264.935107] Dynamic subtest vecs0: SUCCESS (0.074s)
[264.943876] Starting dynamic subtest: ccs0
[265.020356] Dynamic subtest ccs0: SUCCESS (0.084s)
[265.023045] Subtest preempt-other-chain: SUCCESS (0.479s)
[266.006237] [016/132] (752s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[266.103473] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[266.107889] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[266.209412] [017/132] (752s left) kms_content_protection (uevent)
[266.345823] Starting subtest: uevent
[266.350267] Subtest uevent: SKIP (0.000s)
[266.488822] [018/132] (751s left) gem_exec_fence (syncobj-signal)
[266.963763] Starting subtest: syncobj-signal
[266.968888] Subtest syncobj-signal: SUCCESS (0.004s)
[268.997225] [FACT gem_exec_fence (syncobj-signal)] new: kernel.kmod_is_loaded.vgem: true
[269.000357] [019/132] (749s left) gem_exec_schedule (semaphore-resolve)
[269.073167] Starting subtest: semaphore-resolve
[269.126800] Subtest semaphore-resolve: SUCCESS (0.061s)
[269.512982] [020/132] (748s left) syncobj_basic (bad-handle-to-fd)
[269.572030] Starting subtest: bad-handle-to-fd
[269.574275] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[269.675670] [021/132] (748s left) gem_ctx_exec (basic-norecovery)
[269.735288] Starting subtest: basic-norecovery
[270.188564] Subtest basic-norecovery: SUCCESS (0.452s)
[270.359642] [022/132] (748s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[270.470306] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[271.448598] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.978s)
[271.605723] [023/132] (746s left) gem_mmap_wc (fault-concurrent)
[271.679159] Subtest fault-concurrent: SKIP (0.000s)
[271.747138] [024/132] (746s left) kms_flip (2x-flip-vs-wf_vblank)
[271.846568] Starting subtest: 2x-flip-vs-wf_vblank
[271.854674] Subtest 2x-flip-vs-wf_vblank: SKIP (0.010s)
[271.955604] [025/132] (746s left) syncobj_wait (reset-signaled)
[272.011189] Starting subtest: reset-signaled
[272.012990] Subtest reset-signaled: SUCCESS (0.000s)
[272.133921] [026/132] (746s left) gen3_render_tiledy_blits
[272.270930] [027/132] (746s left) kms_psr2_su (page_flip-nv12)
[272.334020] Subtest page_flip-NV12: SKIP (0.000s)
[272.406589] [028/132] (746s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[272.503099] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[272.506899] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[272.632481] [029/132] (746s left) gem_pxp (hw-rejects-pxp-buffer)
[272.762769] Starting subtest: hw-rejects-pxp-buffer
[272.766549] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[272.878665] [030/132] (745s left) gem_render_copy (linear)
[272.939566] Starting subtest: linear
[272.941615] Starting dynamic subtest: smem
[272.983602] Dynamic subtest smem: SUCCESS (0.044s)
[272.985582] Subtest linear: SUCCESS (0.044s)
[273.244235] [031/132] (745s left) kms_psr (fbc-psr-sprite-render)
[273.338387] Starting subtest: fbc-psr-sprite-render
[273.340299] Starting dynamic subtest: eDP-1
[273.344450] Dynamic subtest eDP-1: SKIP (0.000s)
[273.348628] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[273.423055] [032/132] (745s left) api_intel_allocator (reserve-simple)
[273.477792] Starting subtest: reserve-simple
[273.482288] Subtest reserve-simple: SUCCESS (0.003s)
[273.641947] [033/132] (745s left) kms_plane (plane-panning-bottom-right-suspend)
[273.735976] Starting subtest: plane-panning-bottom-right-suspend
[273.738270] Starting dynamic subtest: pipe-A
[291.205926] Dynamic subtest pipe-A: SUCCESS (2.937s)
[291.217239] Starting dynamic subtest: pipe-B
[309.168356] Dynamic subtest pipe-B: SUCCESS (3.406s)
[309.170577] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.346s)
[309.992354] [034/132] (709s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[310.113377] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[310.117451] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[310.237361] [035/132] (708s left) gem_ctx_persistence (legacy-engines-hang)
[310.307968] Starting subtest: legacy-engines-hang
[310.309922] Starting dynamic subtest: render
[310.417838] Dynamic subtest render: SUCCESS (0.112s)
[310.429077] Starting dynamic subtest: bsd1
[310.539105] Dynamic subtest bsd1: SUCCESS (0.120s)
[310.550201] Starting dynamic subtest: bsd2
[310.657272] Dynamic subtest bsd2: SUCCESS (0.117s)
[310.669195] Starting dynamic subtest: blt
[310.769260] Dynamic subtest blt: SUCCESS (0.111s)
[310.781738] Starting dynamic subtest: vebox
[310.888073] Dynamic subtest vebox: SUCCESS (0.117s)
[310.890892] Subtest legacy-engines-hang: SUCCESS (0.588s)
[310.979160] [036/132] (708s left) gem_userptr_blits (process-exit)
[311.048514] Starting subtest: process-exit
[311.055700] Subtest process-exit: SUCCESS (0.009s)
[311.190838] [037/132] (707s left) gem_pipe_control_store_loop (fresh-buffer)
[311.254870] Starting subtest: fresh-buffer
[313.395098] Subtest fresh-buffer: SUCCESS (2.152s)
[313.539518] [038/132] (705s left) gem_exec_schedule (fifo)
[313.611687] Starting subtest: fifo
[313.613611] Starting dynamic subtest: rcs0
[313.751015] Dynamic subtest rcs0: SUCCESS (0.149s)
[313.762877] Starting dynamic subtest: vcs0
[313.856467] Dynamic subtest vcs0: SUCCESS (0.104s)
[313.869757] Starting dynamic subtest: vcs1
[313.970163] Dynamic subtest vcs1: SUCCESS (0.114s)
[313.983015] Starting dynamic subtest: vecs0
[314.074774] Dynamic subtest vecs0: SUCCESS (0.105s)
[314.087241] Starting dynamic subtest: ccs0
[314.191652] Dynamic subtest ccs0: SUCCESS (0.116s)
[314.194052] Subtest fifo: SUCCESS (0.593s)
[315.158983] [039/132] (704s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[315.268754] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[315.272729] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[315.402259] [040/132] (703s left) syncobj_timeline (single-wait-all-available-submitted)
[315.460190] Starting subtest: single-wait-all-available-submitted
[315.462471] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[315.588760] [041/132] (703s left) syncobj_timeline (etime-multi-wait-all-submitted)
[315.643791] Starting subtest: etime-multi-wait-all-submitted
[315.749067] Subtest etime-multi-wait-all-submitted: SUCCESS (0.105s)
[315.837566] [042/132] (703s left) kms_frontbuffer_tracking (psr-suspend)
[315.948435] Starting subtest: psr-suspend
[354.304244] Subtest psr-suspend: SUCCESS (7.966s)
[354.454093] [043/132] (664s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[354.568114] Starting subtest: yf-tiled-64bpp-rotate-270
[354.572428] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[354.702799] [044/132] (664s left) kms_vblank (query-idle-hang)
[354.796862] Starting subtest: query-idle-hang
[354.798740] Starting dynamic subtest: pipe-A-eDP-1
[381.295238] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.561s)
[381.309365] Starting dynamic subtest: pipe-D-eDP-1
[396.212820] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.915s)
[396.215195] Subtest query-idle-hang: SUCCESS (41.482s)
[397.018885] [045/132] (622s left) gem_eio (wait-1us)
[397.231291] Starting subtest: wait-1us
[397.528760] Subtest wait-1us: SUCCESS (0.296s)
[397.697251] [046/132] (621s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[397.797995] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[397.800250] Starting dynamic subtest: pipe-A-default-mode
[398.086629] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[398.091006] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.287s)
[398.950929] [047/132] (620s left) kms_psr (fbc-psr2-sprite-render)
[399.057244] Starting subtest: fbc-psr2-sprite-render
[399.059386] Starting dynamic subtest: eDP-1
[399.063251] Dynamic subtest eDP-1: SKIP (0.000s)
[399.067268] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[399.144917] [048/132] (620s left) gem_exec_balancer (nop)
[399.212833] Starting subtest: nop
[445.865558] Subtest nop: SUCCESS (46.660s)
[446.194300] [049/132] (573s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[446.298376] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[450.223641] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.930s)
[451.433463] [050/132] (568s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[451.499366] Starting subtest: invalid-multi-wait-unsubmitted
[451.501250] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[451.620660] [051/132] (568s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[451.719363] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[451.723706] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[451.860348] [052/132] (567s left) gem_exec_create (basic)
[451.939042] Starting subtest: basic
[451.941133] Starting dynamic subtest: smem
[454.441092] Dynamic subtest smem: SUCCESS (2.502s)
[454.444013] Subtest basic: SUCCESS (2.503s)
[454.641823] [053/132] (565s left) kms_sequence (get-busy)
[454.756287] Starting subtest: get-busy
[454.758460] Starting dynamic subtest: pipe-A-eDP-1
[456.690409] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.932s)
[456.700432] Starting dynamic subtest: pipe-B-eDP-1
[459.298481] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.605s)
[459.309129] Starting dynamic subtest: pipe-C-eDP-1
[461.922334] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.622s)
[461.936231] Starting dynamic subtest: pipe-D-eDP-1
[464.463434] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.540s)
[464.465862] Subtest get-busy: SUCCESS (9.704s)
[465.274938] [054/132] (554s left) gem_exec_reloc (basic-gtt-read)
[465.350297] Subtest basic-gtt-read: SKIP (0.000s)
[465.427382] [055/132] (554s left) kms_pm_rpm (cursor)
[467.566785] Starting subtest: cursor
[467.571714] Subtest cursor: SKIP (0.000s)
[467.966976] [056/132] (551s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[468.367686] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[469.148399] [057/132] (550s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[469.253675] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[469.258049] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[469.383108] [058/132] (550s left) kms_flip (flip-vs-dpms-on-nop)
[469.475582] Starting subtest: flip-vs-dpms-on-nop
[469.477861] Starting dynamic subtest: A-eDP1
[471.352958] Dynamic subtest A-eDP1: SUCCESS (1.876s)
[471.367454] Starting dynamic subtest: B-eDP1
[473.187933] Dynamic subtest B-eDP1: SUCCESS (1.832s)
[473.199986] Starting dynamic subtest: C-eDP1
[475.007322] Dynamic subtest C-eDP1: SUCCESS (1.816s)
[475.017773] Starting dynamic subtest: D-eDP1
[476.835275] Dynamic subtest D-eDP1: SUCCESS (1.827s)
[476.837673] Subtest flip-vs-dpms-on-nop: SUCCESS (7.362s)
[478.030760] [059/132] (542s left) kms_psr (psr2-primary-page-flip)
[478.129549] Starting subtest: psr2-primary-page-flip
[478.131960] Starting dynamic subtest: eDP-1
[479.826597] Dynamic subtest eDP-1: SUCCESS (1.696s)
[479.828876] Subtest psr2-primary-page-flip: SUCCESS (1.697s)
[480.710548] [060/132] (539s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-mmap-gtt)
[480.815003] Starting subtest: fbcpsr-abgr161616f-draw-mmap-gtt
[480.819402] Subtest fbcpsr-abgr161616f-draw-mmap-gtt: SKIP (0.000s)
[480.935464] [061/132] (539s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[481.030445] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[488.232225] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.204s)
[488.398710] [062/132] (531s left) gem_exec_reloc (basic-cpu-read-noreloc)
[488.469208] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[488.548725] [063/132] (531s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[488.646317] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[488.648525] Starting dynamic subtest: pipe-A
[488.709949] Dynamic subtest pipe-A: SUCCESS (0.066s)
[488.720937] Starting dynamic subtest: pipe-B
[489.862633] Dynamic subtest pipe-B: SUCCESS (1.152s)
[489.873833] Starting dynamic subtest: pipe-C
[490.984471] Dynamic subtest pipe-C: SUCCESS (1.121s)
[490.994589] Starting dynamic subtest: pipe-D
[492.113448] Dynamic subtest pipe-D: SUCCESS (1.128s)
[492.115963] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.471s)
[493.284490] [064/132] (527s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[493.410808] Starting subtest: cursorB-vs-flipB-legacy
[493.415411] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[493.578417] [065/132] (526s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[493.683373] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[493.685617] Starting dynamic subtest: pipe-A-eDP-1
[493.694853] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[493.705508] Starting dynamic subtest: pipe-B-eDP-1
[493.714685] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[493.724255] Starting dynamic subtest: pipe-C-eDP-1
[493.732743] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[493.741963] Starting dynamic subtest: pipe-D-eDP-1
[493.750554] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[493.754712] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s)
[495.945546] [066/132] (524s left) fbdev (nullptr)
[495.996684] Starting subtest: nullptr
[495.998984] Subtest nullptr: SUCCESS (0.000s)
[496.063635] [067/132] (524s left) kms_chamelium_color (ctm-0-75)
[496.166262] Subtest ctm-0-75: SKIP (0.000s)
[496.210002] [068/132] (524s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[496.306623] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[496.310702] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[496.437803] [069/132] (524s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[496.532625] Starting subtest: plane-primary-overlay-mutable-zpos
[499.968441] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.435s)
[501.164403] [070/132] (519s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[501.281389] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[502.241186] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.958s)
[503.095545] [071/132] (517s left) kms_pm_backlight (basic-brightness)
[503.183520] Starting subtest: basic-brightness
[503.233694] Starting dynamic subtest: eDP-1
[503.745556] Dynamic subtest eDP-1: SUCCESS (0.512s)
[503.747770] Subtest basic-brightness: SUCCESS (0.562s)
[504.624706] [072/132] (515s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[504.734707] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[504.737039] Starting dynamic subtest: pipe-A-eDP-1
[504.760903] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[504.772170] Starting dynamic subtest: pipe-B-eDP-1
[504.794543] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[504.805578] Starting dynamic subtest: pipe-C-eDP-1
[504.827111] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[504.836128] Starting dynamic subtest: pipe-D-eDP-1
[504.858004] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[504.862016] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.008s)
[506.910108] [073/132] (513s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[507.118574] Starting subtest: cursor-rapid-movement-128x128
[507.124201] Starting dynamic subtest: pipe-A-eDP-1
[507.667388] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.545s)
[507.696961] Starting dynamic subtest: pipe-D-eDP-1
[508.911467] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.220s)
[508.913390] Subtest cursor-rapid-movement-128x128: SUCCESS (1.792s)
[509.774036] [074/132] (510s left) gem_vm_create (create-ext)
[509.831399] Starting subtest: create-ext
[509.836059] Subtest create-ext: SUCCESS (0.004s)
[509.987678] [075/132] (510s left) kms_feature_discovery (chamelium)
[510.075206] Starting subtest: chamelium
[510.079347] Subtest chamelium: SKIP (0.000s)
[510.163036] [076/132] (510s left) gem_exec_whisper (basic-queues-priority)
[510.235131] Starting subtest: basic-queues-priority
[533.591127] Subtest basic-queues-priority: SUCCESS (23.360s)
[533.793846] [077/132] (487s left) kms_big_fb (linear-8bpp-rotate-270)
[533.904650] Starting subtest: linear-8bpp-rotate-270
[533.925965] Subtest linear-8bpp-rotate-270: SKIP (0.021s)
[534.078470] [078/132] (486s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[539.103719] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[539.106035] Starting dynamic subtest: pipe-A-eDP-1
[539.915714] Dynamic subtest pipe-A-eDP-1: SKIP (0.809s)
[539.934896] Starting dynamic subtest: pipe-B-eDP-1
[541.039877] Dynamic subtest pipe-B-eDP-1: SKIP (1.124s)
[541.045207] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.937s)
[542.242621] [079/132] (478s left) kms_cursor_edge_walk (128x128-top-bottom)
[542.360039] Starting subtest: 128x128-top-bottom
[542.362179] Starting dynamic subtest: pipe-A-eDP-1
[545.800694] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.441s)
[545.810689] Starting dynamic subtest: pipe-D-eDP-1
[548.940554] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.138s)
[548.942829] Subtest 128x128-top-bottom: SUCCESS (6.583s)
[549.750307] [080/132] (471s left) syncobj_eventfd (timeline-wait-before-signal)
[549.817558] Starting subtest: timeline-wait-before-signal
[549.846376] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[549.934904] [081/132] (471s left) core_setmaster (master-drop-set-user)
[550.017170] Starting subtest: master-drop-set-user
[550.031356] Subtest master-drop-set-user: SUCCESS (0.014s)
[550.071544] [082/132] (470s left) gen9_exec_parse (batch-invalid-length)
[550.136031] Subtest batch-invalid-length: SKIP (0.000s)
[550.213035] [083/132] (470s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[550.315774] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[550.319802] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[550.438331] [084/132] (470s left) gem_exec_fence (basic-await)
[550.619024] Starting subtest: basic-await
[550.621631] Starting dynamic subtest: rcs0
[550.692752] Dynamic subtest rcs0: SUCCESS (0.073s)
[550.707207] Starting dynamic subtest: bcs0
[550.768848] Dynamic subtest bcs0: SUCCESS (0.073s)
[550.781107] Starting dynamic subtest: vcs0
[550.839081] Dynamic subtest vcs0: SUCCESS (0.070s)
[550.851950] Starting dynamic subtest: vcs1
[550.912525] Dynamic subtest vcs1: SUCCESS (0.071s)
[550.924879] Starting dynamic subtest: vecs0
[550.983945] Dynamic subtest vecs0: SUCCESS (0.070s)
[550.998555] Starting dynamic subtest: ccs0
[551.056752] Dynamic subtest ccs0: SUCCESS (0.071s)
[551.059200] Subtest basic-await: SUCCESS (0.439s)
[552.581867] [085/132] (468s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[552.676302] Starting subtest: compare-crc-sanitycheck-xr24
[552.678603] Starting dynamic subtest: pipe-A-eDP-1
[553.323544] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.647s)
[553.333867] Starting dynamic subtest: pipe-B-eDP-1
[554.593614] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.268s)
[554.603689] Starting dynamic subtest: pipe-C-eDP-1
[555.773329] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.179s)
[555.785951] Starting dynamic subtest: pipe-D-eDP-1
[557.018864] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.245s)
[557.021201] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.344s)
[557.852517] [086/132] (463s left) kms_flip (flip-vs-rmfb-interruptible)
[557.963892] Starting subtest: flip-vs-rmfb-interruptible
[557.966293] Starting dynamic subtest: A-eDP1
[566.624248] Dynamic subtest A-eDP1: SUCCESS (8.662s)
[566.634906] Starting dynamic subtest: B-eDP1
[575.260232] Dynamic subtest B-eDP1: SUCCESS (8.637s)
[575.271338] Starting dynamic subtest: C-eDP1
[583.876413] Dynamic subtest C-eDP1: SUCCESS (8.614s)
[583.889199] Starting dynamic subtest: D-eDP1
[592.515563] Dynamic subtest D-eDP1: SUCCESS (8.633s)
[592.520226] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.556s)
[593.815457] [087/132] (427s left) gem_create (create-valid-nonaligned)
[593.883741] Starting subtest: create-valid-nonaligned
[593.886113] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[594.092369] [088/132] (427s left) intel_hwmon (hwmon-read)
[594.148651] Subtest hwmon-read: SKIP (0.000s)
[594.209191] [089/132] (427s left) gem_ctx_shared (detached-shared-gtt)
[594.272297] Starting subtest: detached-shared-gtt
[596.425124] Subtest detached-shared-gtt: SUCCESS (2.151s)
[596.780854] [090/132] (424s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[596.889299] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[596.891474] Starting dynamic subtest: pipe-A-default-mode
[597.182212] Dynamic subtest pipe-A-default-mode: SKIP (0.289s)
[597.186594] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.290s)
[598.050537] [091/132] (423s left) prime_self_import (export-vs-gem_close-race)
[598.090613] Starting subtest: export-vs-gem_close-race
[603.189844] Subtest export-vs-gem_close-race: SUCCESS (5.098s)
[603.283469] [092/132] (418s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[603.417927] Starting subtest: flip-vs-cursor-legacy
[610.616002] Subtest flip-vs-cursor-legacy: SUCCESS (7.195s)
[611.471432] [093/132] (410s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[611.565825] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[612.568117] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.000s)
[612.723101] [094/132] (408s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[612.842878] Starting subtest: cursorA-vs-flipA-varying-size
[623.971086] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.126s)
[624.804110] [095/132] (396s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[624.918347] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[624.920562] Starting dynamic subtest: pipe-A-eDP-1
[624.941938] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[624.954700] Starting dynamic subtest: pipe-B-eDP-1
[624.976769] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[624.990186] Starting dynamic subtest: pipe-C-eDP-1
[625.011889] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[625.022932] Starting dynamic subtest: pipe-D-eDP-1
[625.044351] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[625.048661] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[627.168895] [096/132] (394s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[627.294410] Starting subtest: 2x-long-cursor-vs-flip-atomic
[627.298829] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[627.448777] [097/132] (394s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[627.552636] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[627.556880] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[627.665505] [098/132] (394s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[627.766052] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[628.434553] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.670s)
[628.640719] [099/132] (393s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[628.751342] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[628.755455] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[628.870060] [100/132] (392s left) gen9_exec_parse (shadow-peek)
[628.937362] Subtest shadow-peek: SKIP (0.000s)
[629.023568] [101/132] (392s left) perf_pmu (multi-client)
[629.067107] Starting subtest: multi-client
[629.069275] Starting dynamic subtest: rcs0
[630.137905] Dynamic subtest rcs0: SUCCESS (1.077s)
[630.148190] Starting dynamic subtest: bcs0
[631.186513] Dynamic subtest bcs0: SUCCESS (1.045s)
[631.199780] Starting dynamic subtest: vcs0
[632.238473] Dynamic subtest vcs0: SUCCESS (1.048s)
[632.250916] Starting dynamic subtest: vcs1
[633.441108] Dynamic subtest vcs1: SUCCESS (1.200s)
[633.454016] Starting dynamic subtest: vecs0
[635.428237] Dynamic subtest vecs0: SUCCESS (1.984s)
[635.440700] Starting dynamic subtest: ccs0
[637.471975] Dynamic subtest ccs0: SUCCESS (2.041s)
[637.474530] Subtest multi-client: SUCCESS (8.414s)
[637.602400] [102/132] (384s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[637.714442] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[637.718814] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[637.814544] [103/132] (384s left) syncobj_timeline (transfer-timeline-point)
[637.868119] Starting subtest: transfer-timeline-point
[637.870565] Subtest transfer-timeline-point: SUCCESS (0.000s)
[637.988815] [104/132] (383s left) i915_pm_freq_api (freq-reset)
[638.057787] Starting subtest: freq-reset
[638.060100] Starting dynamic subtest: gt0
[638.220880] Dynamic subtest gt0: SUCCESS (0.165s)
[638.232328] Starting dynamic subtest: gt1
[638.371170] Dynamic subtest gt1: SUCCESS (0.149s)
[638.373721] Subtest freq-reset: SUCCESS (0.316s)
[638.468271] [105/132] (383s left) kms_psr (psr-cursor-render)
[638.554330] Starting subtest: psr-cursor-render
[638.556648] Starting dynamic subtest: eDP-1
[640.248612] Dynamic subtest eDP-1: SUCCESS (1.695s)
[640.251018] Subtest psr-cursor-render: SUCCESS (1.696s)
[641.125353] [106/132] (380s left) kms_properties (plane-properties-legacy)
[641.216570] Starting subtest: plane-properties-legacy
[641.218982] Starting dynamic subtest: pipe-A-eDP-1
[641.765097] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.545s)
[641.775526] Starting dynamic subtest: pipe-B-eDP-1
[643.077883] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.312s)
[643.089405] Starting dynamic subtest: pipe-C-eDP-1
[644.299402] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.220s)
[644.309688] Starting dynamic subtest: pipe-D-eDP-1
[645.535443] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.236s)
[645.537868] Subtest plane-properties-legacy: SUCCESS (4.319s)
[646.340358] [107/132] (375s left) kms_flip (wf_vblank-ts-check)
[646.437452] Starting subtest: wf_vblank-ts-check
[646.439631] Starting dynamic subtest: A-eDP1
[655.378781] Dynamic subtest A-eDP1: SUCCESS (8.944s)
[655.388858] Starting dynamic subtest: B-eDP1
[664.308079] Dynamic subtest B-eDP1: SUCCESS (8.928s)
[664.321390] Starting dynamic subtest: C-eDP1
[673.234280] Dynamic subtest C-eDP1: SUCCESS (8.924s)
[673.245724] Starting dynamic subtest: D-eDP1
[682.161507] Dynamic subtest D-eDP1: SUCCESS (8.927s)
[682.163974] Subtest wf_vblank-ts-check: SUCCESS (35.732s)
[683.410970] [108/132] (338s left) gem_ringfill (engines-basic)
[689.453191] Starting subtest: engines-basic
[689.455823] Starting dynamic subtest: rcs0
[689.547178] Dynamic subtest rcs0: SUCCESS (0.094s)
[689.560366] Starting dynamic subtest: bcs0
[689.590742] Dynamic subtest bcs0: SUCCESS (0.042s)
[689.601703] Starting dynamic subtest: vcs0
[689.632896] Dynamic subtest vcs0: SUCCESS (0.041s)
[689.643997] Starting dynamic subtest: vcs1
[689.676209] Dynamic subtest vcs1: SUCCESS (0.041s)
[689.687959] Starting dynamic subtest: vecs0
[689.720052] Dynamic subtest vecs0: SUCCESS (0.042s)
[689.731728] Starting dynamic subtest: ccs0
[689.765860] Dynamic subtest ccs0: SUCCESS (0.043s)
[689.768201] Subtest engines-basic: SUCCESS (0.315s)
[689.888639] [109/132] (332s left) i915_power (sanity)
[689.941658] Starting subtest: sanity
[689.946205] Subtest sanity: SKIP (0.000s)
[690.057518] [110/132] (332s left) kms_color_pipeline (plane-ctm3x4)
[690.150966] Starting subtest: plane-ctm3x4
[690.164428] Starting dynamic subtest: pipe-A-eDP-1
[690.776965] Dynamic subtest pipe-A-eDP-1: FAIL (0.288s)
[691.568881] Starting dynamic subtest: pipe-B-eDP-1
[692.349822] Dynamic subtest pipe-B-eDP-1: FAIL (0.269s)
[692.891201] Starting dynamic subtest: pipe-C-eDP-1
[693.693849] Dynamic subtest pipe-C-eDP-1: FAIL (0.213s)
[694.141156] Starting dynamic subtest: pipe-D-eDP-1
[694.948893] Dynamic subtest pipe-D-eDP-1: FAIL (0.224s)
[694.951266] Subtest plane-ctm3x4: FAIL (4.498s)
[695.522649] [111/132] (326s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[695.581397] Starting subtest: multi-wait-all-for-submit-available-submitted
[695.583283] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[695.705528] [112/132] (326s left) kms_invalid_mode (zero-vdisplay)
[695.800491] Starting subtest: zero-vdisplay
[695.802773] Starting dynamic subtest: pipe-A-eDP-1
[696.096585] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.297s)
[696.106994] Starting dynamic subtest: pipe-B-eDP-1
[696.109203] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[696.118394] Starting dynamic subtest: pipe-C-eDP-1
[696.120597] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[696.130099] Starting dynamic subtest: pipe-D-eDP-1
[696.132007] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[696.133925] Subtest zero-vdisplay: SUCCESS (0.303s)
[696.963009] [113/132] (325s left) sw_sync (alloc_fence_invalid_timeline)
[697.003363] Starting subtest: alloc_fence_invalid_timeline
[697.005261] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[697.072896] [114/132] (325s left) i915_pm_rpm (reg-read-ioctl)
[698.599863] Starting subtest: reg-read-ioctl
[700.892188] Subtest reg-read-ioctl: SUCCESS (2.295s)
[701.282202] [115/132] (321s left) perf_pmu (init-busy)
[701.319505] Starting subtest: init-busy
[701.321894] Starting dynamic subtest: rcs0
[701.324383] Dynamic subtest rcs0: SUCCESS (0.001s)
[701.337133] Starting dynamic subtest: bcs0
[701.339120] Dynamic subtest bcs0: SUCCESS (0.001s)
[701.349469] Starting dynamic subtest: vcs0
[701.351698] Dynamic subtest vcs0: SUCCESS (0.001s)
[701.361473] Starting dynamic subtest: vcs1
[701.363784] Dynamic subtest vcs1: SUCCESS (0.001s)
[701.373254] Starting dynamic subtest: vecs0
[701.375462] Dynamic subtest vecs0: SUCCESS (0.000s)
[701.384845] Starting dynamic subtest: ccs0
[701.386812] Dynamic subtest ccs0: SUCCESS (0.000s)
[701.388776] Subtest init-busy: SUCCESS (0.010s)
[701.438536] [116/132] (321s left) syncobj_wait (wait-any-interrupted)
[701.512798] Starting subtest: wait-any-interrupted
[701.615600] Subtest wait-any-interrupted: SUCCESS (0.102s)
[701.703561] [117/132] (320s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[701.815166] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[708.763243] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (6.951s)
[708.912504] [118/132] (313s left) gem_exec_parallel (contexts)
[708.972439] Starting subtest: contexts
[708.974829] Starting dynamic subtest: rcs0
[711.971224] Dynamic subtest rcs0: SUCCESS (2.997s)
[711.981229] Starting dynamic subtest: bcs0
[716.151862] Dynamic subtest bcs0: SUCCESS (4.177s)
[716.164990] Starting dynamic subtest: vcs0
[721.906691] Dynamic subtest vcs0: SUCCESS (5.753s)
[721.916778] Starting dynamic subtest: vcs1
[725.998730] Dynamic subtest vcs1: SUCCESS (4.090s)
[726.008712] Starting dynamic subtest: vecs0
[731.816372] Dynamic subtest vecs0: SUCCESS (5.816s)
[731.826639] Starting dynamic subtest: ccs0
[735.751890] Dynamic subtest ccs0: SUCCESS (3.934s)
[735.754316] Subtest contexts: SUCCESS (26.783s)
[735.957416] [119/132] (286s left) gem_exec_whisper (basic-fds)
[736.026454] Starting subtest: basic-fds
[744.943126] Subtest basic-fds: SUCCESS (8.919s)
[745.142745] [120/132] (277s left) gem_mmap_gtt (ptrace)
[745.212872] Subtest ptrace: SKIP (0.000s)
[745.289510] [121/132] (277s left) kms_vrr (max-min)
[745.385291] Starting subtest: max-min
[745.391903] Subtest max-min: SKIP (0.000s)
[745.467772] [122/132] (277s left) perf (invalid-open-flags)
[745.621782] Starting subtest: invalid-open-flags
[745.623943] Subtest invalid-open-flags: SUCCESS (0.000s)
[745.661210] [123/132] (277s left) gem_exec_reloc (basic-write-cpu-active)
[745.728512] Subtest basic-write-cpu-active: SKIP (0.000s)
[745.819621] [124/132] (276s left) kms_plane_alpha_blend (alpha-opaque-fb)
[745.916489] Starting subtest: alpha-opaque-fb
[746.213892] Starting dynamic subtest: pipe-A-eDP-1
[746.935416] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.719s)
[746.945724] Starting dynamic subtest: pipe-D-eDP-1
[748.231273] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.294s)
[748.233531] Subtest alpha-opaque-fb: SUCCESS (2.315s)
[749.080555] [125/132] (273s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[749.154839] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[749.262001] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s)
[749.363172] [126/132] (273s left) gem_lmem_swapping (verify-ccs)
[749.403307] Subtest verify-ccs: SKIP (0.000s)
[749.453022] [127/132] (273s left) gem_pxp (display-protected-crc)
[749.560630] Starting subtest: display-protected-crc
[751.167216] Subtest display-protected-crc: SUCCESS (1.609s)
[751.345695] [128/132] (271s left) kms_big_fb (y-tiled-addfb)
[751.451881] Starting subtest: y-tiled-addfb
[751.456029] Subtest y-tiled-addfb: SKIP (0.000s)
[751.573957] [129/132] (271s left) kms_hdr (static-toggle-dpms)
[751.661367] Starting subtest: static-toggle-dpms
[751.667971] Subtest static-toggle-dpms: SKIP (0.000s)
[751.746897] [130/132] (271s left) kms_chamelium_color (degamma)
[751.842713] Subtest degamma: SKIP (0.000s)
[751.890103] [131/132] (271s left) gem_ctx_engines (execute-oneforall)
[751.943251] Starting subtest: execute-oneforall
[752.604334] Subtest execute-oneforall: SUCCESS (0.660s)
[753.713572] [132/132] (269s left) syncobj_wait (single-wait-all-for-submit-submitted)
[753.793205] Starting subtest: single-wait-all-for-submit-submitted
[753.901436] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.108s)
[754.004361] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: kms_cursor_crc
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: prime_mmap
results: parsing output: 5/ for test: gem_softpin
results: parsing output: 6/ for test: kms_atomic_transition
results: parsing output: 7/ for test: api_intel_bb
results: parsing output: 8/ for test: gem_userptr_blits
results: parsing output: 9/ for test: kms_cursor_legacy
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_atomic_interruptible
results: parsing output: 13/ for test: kms_prop_blob
results: parsing output: 14/ for test: gem_exec_schedule
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_content_protection
results: parsing output: 17/ for test: gem_exec_fence
results: parsing output: 18/ for test: gem_exec_schedule
results: parsing output: 19/ for test: syncobj_basic
results: parsing output: 20/ for test: gem_ctx_exec
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: gem_mmap_wc
results: parsing output: 23/ for test: kms_flip
results: parsing output: 24/ for test: syncobj_wait
results: parsing output: 25/ for test: gen3_render_tiledy_blits
results: parsing output: 26/ for test: kms_psr2_su
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_pxp
results: parsing output: 29/ for test: gem_render_copy
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: api_intel_allocator
results: parsing output: 32/ for test: kms_plane
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_ctx_persistence
results: parsing output: 35/ for test: gem_userptr_blits
results: parsing output: 36/ for test: gem_pipe_control_store_loop
results: parsing output: 37/ for test: gem_exec_schedule
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: kms_vblank
results: parsing output: 44/ for test: gem_eio
results: parsing output: 45/ for test: kms_flip_scaled_crc
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: gem_exec_balancer
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_exec_create
results: parsing output: 52/ for test: kms_sequence
results: parsing output: 53/ for test: gem_exec_reloc
results: parsing output: 54/ for test: kms_pm_rpm
results: parsing output: 55/ for test: kms_chamelium_hpd
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_exec_reloc
results: parsing output: 62/ for test: kms_plane_scaling
results: parsing output: 63/ for test: kms_cursor_legacy
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: fbdev
results: parsing output: 66/ for test: kms_chamelium_color
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_atomic
results: parsing output: 69/ for test: kms_cursor_legacy
results: parsing output: 70/ for test: kms_pm_backlight
results: parsing output: 71/ for test: kms_ccs
results: parsing output: 72/ for test: kms_cursor_crc
results: parsing output: 73/ for test: gem_vm_create
results: parsing output: 74/ for test: kms_feature_discovery
results: parsing output: 75/ for test: gem_exec_whisper
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_psr2_sf
results: parsing output: 78/ for test: kms_cursor_edge_walk
results: parsing output: 79/ for test: syncobj_eventfd
results: parsing output: 80/ for test: core_setmaster
results: parsing output: 81/ for test: gen9_exec_parse
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_exec_fence
results: parsing output: 84/ for test: kms_pipe_crc_basic
results: parsing output: 85/ for test: kms_flip
results: parsing output: 86/ for test: gem_create
results: parsing output: 87/ for test: intel_hwmon
results: parsing output: 88/ for test: gem_ctx_shared
results: parsing output: 89/ for test: kms_flip_scaled_crc
results: parsing output: 90/ for test: prime_self_import
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: kms_cursor_legacy
results: parsing output: 94/ for test: kms_ccs
results: parsing output: 95/ for test: kms_cursor_legacy
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gen9_exec_parse
results: parsing output: 100/ for test: perf_pmu
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: i915_pm_freq_api
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: kms_properties
results: parsing output: 106/ for test: kms_flip
results: parsing output: 107/ for test: gem_ringfill
results: parsing output: 108/ for test: i915_power
results: parsing output: 109/ for test: kms_color_pipeline
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: kms_invalid_mode
results: parsing output: 112/ for test: sw_sync
results: parsing output: 113/ for test: i915_pm_rpm
results: parsing output: 114/ for test: perf_pmu
results: parsing output: 115/ for test: syncobj_wait
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: gem_exec_parallel
results: parsing output: 118/ for test: gem_exec_whisper
results: parsing output: 119/ for test: gem_mmap_gtt
results: parsing output: 120/ for test: kms_vrr
results: parsing output: 121/ for test: perf
results: parsing output: 122/ for test: gem_exec_reloc
results: parsing output: 123/ for test: kms_plane_alpha_blend
results: parsing output: 124/ for test: syncobj_wait
results: parsing output: 125/ for test: gem_lmem_swapping
results: parsing output: 126/ for test: gem_pxp
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: kms_hdr
results: parsing output: 129/ for test: kms_chamelium_color
results: parsing output: 130/ for test: gem_ctx_engines
results: parsing output: 131/ for test: syncobj_wait
Done.