[57.035769] Initializing watchdogs
[57.035819]   /dev/watchdog0
[57.053219] [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.057833] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.060302] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.063997] [001/155] (960s left) gem_reg_read (timestamp-moving)
[57.137376] Starting subtest: timestamp-moving
[58.140349] Subtest timestamp-moving: SUCCESS (0.995s)
[58.213018] [002/155] (959s left) sysfs_timeslice_duration (idempotent)
[58.277795] Starting subtest: idempotent
[58.280153] Starting dynamic subtest: vecs0
[58.282410] Dynamic subtest vecs0: SUCCESS (0.000s)
[58.289635] Starting dynamic subtest: ccs0
[58.291577] Dynamic subtest ccs0: SUCCESS (0.000s)
[58.298290] Starting dynamic subtest: vcs0
[58.300182] Dynamic subtest vcs0: SUCCESS (0.000s)
[58.307143] Starting dynamic subtest: bcs0
[58.309321] Dynamic subtest bcs0: SUCCESS (0.000s)
[58.316381] Starting dynamic subtest: rcs0
[58.318286] Dynamic subtest rcs0: SUCCESS (0.000s)
[58.325398] Starting dynamic subtest: vcs1
[58.327634] Dynamic subtest vcs1: SUCCESS (0.000s)
[58.329856] Subtest idempotent: SUCCESS (0.004s)
[58.369560] [003/155] (959s left) kms_atomic_interruptible (atomic-setmode)
[58.470846] Starting subtest: atomic-setmode
[58.473161] Starting dynamic subtest: pipe-A-eDP-1
[65.409674] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.914s)
[65.412075] Subtest atomic-setmode: SUCCESS (6.915s)
[66.279410] [004/155] (951s left) kms_chamelium_hpd (hdmi-hpd-fast)
[67.413633] Subtest hdmi-hpd-fast: SKIP (0.000s)
[67.736209] [005/155] (949s left) gem_exec_params (no-bsd)
[67.797700] Starting subtest: no-bsd
[67.799957] Subtest no-bsd: SUCCESS (0.002s)
[69.387838] [006/155] (948s left) kms_getfb (getfb-addfb-different-handles)
[69.487737] Starting subtest: getfb-addfb-different-handles
[69.490321] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[69.601228] [007/155] (948s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[69.698436] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[69.702611] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[69.791217] [008/155] (948s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-4)
[69.895755] Starting subtest: fbcpsrhdr-tiling-4
[69.900376] Subtest fbcpsrhdr-tiling-4: SKIP (0.000s)
[69.981906] [009/155] (947s left) kms_pm_rpm (pm-tiling)
[71.549185] Starting subtest: pm-tiling
[71.554411] Subtest pm-tiling: SKIP (0.000s)
[72.302258] [010/155] (945s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[72.442931] Starting subtest: short-flip-after-cursor-atomic-transitions
[73.456187] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (1.014s)
[74.344876] [011/155] (943s left) kms_feature_discovery (display)
[74.438979] Starting subtest: display
[74.441399] Subtest display: SUCCESS (0.000s)
[74.515097] [012/155] (943s left) kms_addfb_basic (size-max)
[74.617028] Starting subtest: size-max
[74.619284] Subtest size-max: SUCCESS (0.000s)
[74.710021] [013/155] (943s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[74.819187] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[82.177658] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.360s)
[82.288782] [014/155] (935s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[82.376388] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[82.380686] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[82.446249] [015/155] (935s left) gem_spin_batch (spin-each)
[82.510450] Starting subtest: spin-each
[85.783334] Subtest spin-each: SUCCESS (3.264s)
[86.362012] [016/155] (931s left) kms_pm_rpm (dpms-lpsp)
[88.496087] Starting subtest: dpms-lpsp
[88.812467] Subtest dpms-lpsp: SUCCESS (0.320s)
[88.941326] [017/155] (929s left) prime_mmap_coherency (ioctl-errors)
[88.989880] Starting subtest: ioctl-errors
[102.212132] Subtest ioctl-errors: SUCCESS (13.220s)
[102.383638] [018/155] (915s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[102.528114] Starting subtest: primary-yf-tiled-reflect-x-90
[102.531673] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[102.596691] [019/155] (915s left) gem_ctx_param (invalid-set-no-zeromap)
[102.646312] Starting subtest: invalid-set-no-zeromap
[102.648350] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[102.708226] [020/155] (915s left) gem_exec_fence (syncobj-wait)
[103.190968] Starting subtest: syncobj-wait
[104.352555] Subtest syncobj-wait: SUCCESS (1.159s)
[104.714744] [FACT gem_exec_fence (syncobj-wait)] new: kernel.kmod_is_loaded.vgem: true
[104.718203] [021/155] (913s left) gem_eio (hibernate)
[104.956974] Starting subtest: hibernate
[119.846156] Subtest hibernate: SUCCESS (14.888s)
[128.021818] [022/155] (898s left) gem_exec_whisper (basic-fds-forked-all)
[128.154979] Starting subtest: basic-fds-forked-all
[151.456891] Subtest basic-fds-forked-all: SUCCESS (23.299s)
[151.663951] [023/155] (874s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-render)
[151.776394] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-render
[151.780760] Subtest fbchdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.001s)
[151.874168] [024/155] (874s left) gem_softpin (invalid)
[151.937081] Starting subtest: invalid
[151.945824] Subtest invalid: SUCCESS (0.008s)
[152.070602] [025/155] (874s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[152.163706] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[152.167853] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[152.263275] [026/155] (874s left) gem_exec_fence (syncobj-timeline-repeat)
[152.867884] Starting subtest: syncobj-timeline-repeat
[153.124249] Subtest syncobj-timeline-repeat: SUCCESS (0.256s)
[154.393013] [027/155] (872s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[154.669640] Starting subtest: cursor-rapid-movement-256x256
[154.674598] Starting dynamic subtest: pipe-A-eDP-1
[155.265392] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.592s)
[155.300390] Starting dynamic subtest: pipe-D-eDP-1
[156.526497] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.235s)
[156.528392] Subtest cursor-rapid-movement-256x256: SUCCESS (1.856s)
[157.370883] [028/155] (869s left) dmabuf_sync_file (export-wait-after-attach)
[157.419680] Starting subtest: export-wait-after-attach
[157.421772] Subtest export-wait-after-attach: SUCCESS (0.001s)
[157.481126] [029/155] (869s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[157.582336] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[157.593855] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[157.711516] [030/155] (869s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[157.781731] Starting subtest: legacy-engines-hostile-preempt
[157.784071] Starting dynamic subtest: render
[157.877881] Dynamic subtest render: SUCCESS (0.098s)
[157.893693] Starting dynamic subtest: bsd1
[159.278900] Dynamic subtest bsd1: SUCCESS (1.397s)
[159.291724] Starting dynamic subtest: bsd2
[161.262837] Dynamic subtest bsd2: SUCCESS (1.982s)
[161.275808] Starting dynamic subtest: blt
[161.334601] Dynamic subtest blt: SUCCESS (0.071s)
[161.346744] Starting dynamic subtest: vebox
[163.342298] Dynamic subtest vebox: SUCCESS (2.004s)
[163.344886] Subtest legacy-engines-hostile-preempt: SUCCESS (5.562s)
[163.438020] [031/155] (863s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-blt)
[163.536068] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-blt
[163.540753] Subtest psrhdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[163.635422] [032/155] (863s left) kms_sequence (get-busy)
[163.725153] Starting subtest: get-busy
[163.727394] Starting dynamic subtest: pipe-A-eDP-1
[165.658054] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.929s)
[165.668449] Starting dynamic subtest: pipe-B-eDP-1
[168.280031] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.623s)
[168.291078] Starting dynamic subtest: pipe-C-eDP-1
[170.873510] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.590s)
[170.884283] Starting dynamic subtest: pipe-D-eDP-1
[173.496620] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.622s)
[173.498599] Subtest get-busy: SUCCESS (9.769s)
[174.386190] [033/155] (852s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[174.503557] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[174.508129] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[174.607697] [034/155] (852s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[174.709102] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[182.139546] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.436s)
[182.267214] [035/155] (844s left) gem_lmem_evict (dontneed-evict-race)
[182.321263] Subtest dontneed-evict-race: SKIP (0.000s)
[182.370872] [036/155] (844s left) gem_softpin (softpin)
[182.433267] Starting subtest: softpin
[214.795509] Subtest softpin: SUCCESS (32.357s)
[214.928411] [037/155] (812s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[215.028926] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[215.033068] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s)
[215.115747] [038/155] (812s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[215.213751] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[215.218051] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[215.315292] [039/155] (811s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[215.411672] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[220.364278] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.959s)
[221.581704] [040/155] (805s left) gem_fenced_exec_thrash (too-many-fences)
[221.641238] Subtest too-many-fences: SKIP (0.000s)
[221.703042] [041/155] (805s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[221.802533] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[221.807041] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[221.905520] [042/155] (805s left) gem_partial_pwrite_pread (reads)
[221.958494] Subtest reads: SKIP (0.000s)
[222.030375] [043/155] (805s left) gem_ctx_shared (exec-single-timeline)
[222.081419] Starting subtest: exec-single-timeline
[222.083895] Starting dynamic subtest: rcs0
[223.141476] Dynamic subtest rcs0: SUCCESS (1.058s)
[223.155818] Starting dynamic subtest: bcs0
[224.229520] Dynamic subtest bcs0: SUCCESS (1.086s)
[224.242444] Starting dynamic subtest: vcs0
[225.317674] Dynamic subtest vcs0: SUCCESS (1.085s)
[225.332471] Starting dynamic subtest: vcs1
[226.405696] Dynamic subtest vcs1: SUCCESS (1.087s)
[226.417771] Starting dynamic subtest: vecs0
[227.494565] Dynamic subtest vecs0: SUCCESS (1.086s)
[227.508645] Starting dynamic subtest: ccs0
[228.582363] Dynamic subtest ccs0: SUCCESS (1.085s)
[228.585044] Subtest exec-single-timeline: SUCCESS (6.501s)
[229.392223] [044/155] (797s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[229.498025] Starting subtest: x-tiled-32bpp-rotate-90
[229.517829] Subtest x-tiled-32bpp-rotate-90: SKIP (0.020s)
[229.630326] [045/155] (797s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[229.723871] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[237.152545] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.433s)
[237.288185] [046/155] (790s left) syncobj_wait (invalid-wait-illegal-handle)
[237.337809] Starting subtest: invalid-wait-illegal-handle
[237.340104] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[237.443292] [047/155] (790s left) kms_flip (2x-flip-vs-fences-interruptible)
[237.543020] Starting subtest: 2x-flip-vs-fences-interruptible
[237.546754] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[237.669294] [048/155] (789s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-shrfb-plflip-blt)
[237.761331] Starting subtest: psrhdr-1p-primscrn-shrfb-plflip-blt
[237.765571] Subtest psrhdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[237.874451] [049/155] (789s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[237.968070] Starting subtest: fbc-psr2-cursor-mmap-cpu
[237.970325] Starting dynamic subtest: eDP-1
[237.974587] Dynamic subtest eDP-1: SKIP (0.000s)
[237.979048] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[238.045286] [050/155] (789s left) gem_pwrite (basic-self)
[238.096279] Subtest basic-self: SKIP (0.000s)
[238.153245] [051/155] (789s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[238.214305] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[238.317954] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.103s)
[238.407972] [052/155] (789s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[238.502969] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[238.505294] Starting dynamic subtest: pipe-A-eDP-1
[238.527534] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[238.540571] Starting dynamic subtest: pipe-B-eDP-1
[238.562284] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[238.572269] Starting dynamic subtest: pipe-C-eDP-1
[238.593878] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[238.604194] Starting dynamic subtest: pipe-D-eDP-1
[238.627359] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[238.631719] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[240.772418] [053/155] (787s left) kms_plane_multiple (2x-tiling-none)
[240.863078] Starting subtest: 2x-tiling-none
[240.867139] Subtest 2x-tiling-none: SKIP (0.000s)
[240.941043] [054/155] (786s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[241.032490] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[241.036814] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[241.128550] [055/155] (786s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[241.226350] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[241.230540] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[241.334874] [056/155] (786s left) gem_exec_balancer (bonded-false-hang)
[241.608297] Starting subtest: bonded-false-hang
[241.613624] Subtest bonded-false-hang: SKIP (0.000s)
[241.724805] [057/155] (786s left) gen9_exec_parse (shadow-peek)
[241.789104] Subtest shadow-peek: SKIP (0.000s)
[241.874524] [058/155] (786s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-pwrite)
[241.973440] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-pwrite
[241.977827] Subtest psrhdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[242.070722] [059/155] (785s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[242.163691] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[242.167831] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[242.235844] [060/155] (785s left) kms_invalid_mode (bad-hsync-start)
[242.322365] Starting subtest: bad-hsync-start
[242.324761] Starting dynamic subtest: pipe-A-eDP-1
[242.608201] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[242.619227] Starting dynamic subtest: pipe-B-eDP-1
[242.621234] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[242.631877] Starting dynamic subtest: pipe-C-eDP-1
[242.634075] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[242.645159] Starting dynamic subtest: pipe-D-eDP-1
[242.647375] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[242.649678] Subtest bad-hsync-start: SUCCESS (0.291s)
[243.498406] [061/155] (784s left) gem_exec_create (legacy)
[243.572698] Starting subtest: legacy
[243.575285] Starting dynamic subtest: smem
[245.670493] Dynamic subtest smem: SUCCESS (2.098s)
[245.673042] Subtest legacy: SUCCESS (2.099s)
[245.853680] [062/155] (782s left) kms_frontbuffer_tracking (fbchdr-farfromfence-mmap-gtt)
[245.961747] Starting subtest: fbchdr-farfromfence-mmap-gtt
[245.966157] Subtest fbchdr-farfromfence-mmap-gtt: SKIP (0.000s)
[246.080308] [063/155] (782s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[246.175072] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[246.177208] Starting dynamic subtest: pipe-A-eDP-1
[246.201756] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[246.213057] Starting dynamic subtest: pipe-B-eDP-1
[246.235253] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[246.245626] Starting dynamic subtest: pipe-C-eDP-1
[246.269261] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[246.281996] Starting dynamic subtest: pipe-D-eDP-1
[246.306453] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[246.310834] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[248.476692] [064/155] (779s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-render)
[248.576088] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-render
[248.580504] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[248.678534] [065/155] (779s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[248.738364] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[248.740615] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[248.848692] [066/155] (779s left) kms_flip (flip-vs-blocking-wf-vblank)
[248.947207] Starting subtest: flip-vs-blocking-wf-vblank
[248.949474] Starting dynamic subtest: A-eDP1
[257.907302] Dynamic subtest A-eDP1: SUCCESS (8.961s)
[257.918542] Starting dynamic subtest: B-eDP1
[266.836448] Dynamic subtest B-eDP1: SUCCESS (8.928s)
[266.849360] Starting dynamic subtest: C-eDP1
[275.755975] Dynamic subtest C-eDP1: SUCCESS (8.916s)
[275.768687] Starting dynamic subtest: D-eDP1
[284.682906] Dynamic subtest D-eDP1: SUCCESS (8.926s)
[284.685429] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.740s)
[285.908577] [067/155] (742s left) kms_psr (psr-cursor-blt)
[285.998177] Starting subtest: psr-cursor-blt
[286.000487] Starting dynamic subtest: eDP-1
[287.694240] Dynamic subtest eDP-1: SUCCESS (1.696s)
[287.696293] Subtest psr-cursor-blt: SUCCESS (1.697s)
[288.568315] [068/155] (739s left) kms_atomic_transition (modeset-transition)
[288.651266] Starting subtest: modeset-transition
[288.653192] Starting dynamic subtest: 1x-outputs
[299.778410] Dynamic subtest 1x-outputs: SUCCESS (11.128s)
[299.780799] Subtest modeset-transition: SUCCESS (11.130s)
[300.643269] [069/155] (727s left) gem_render_copy (linear-to-vebox-yf-tiled)
[300.715515] Starting subtest: linear-to-vebox-yf-tiled
[300.719877] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[300.900319] [070/155] (727s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[300.999668] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[301.003652] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[301.105270] [071/155] (727s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[301.189862] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[301.192142] Starting dynamic subtest: pipe-A-eDP-1
[317.502444] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.413s)
[317.513401] Starting dynamic subtest: pipe-B-eDP-1
[334.501087] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.449s)
[334.513136] Starting dynamic subtest: pipe-C-eDP-1
[351.457859] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.428s)
[351.469623] Starting dynamic subtest: pipe-D-eDP-1
[368.454027] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.357s)
[368.456387] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.652s)
[369.726926] [072/155] (658s left) kms_big_fb (yf-tiled-addfb)
[369.843391] Starting subtest: yf-tiled-addfb
[369.847951] Subtest yf-tiled-addfb: SKIP (0.000s)
[369.928320] [073/155] (658s left) kms_psr (psr-primary-page-flip)
[370.019823] Starting subtest: psr-primary-page-flip
[370.022146] Starting dynamic subtest: eDP-1
[371.831524] Dynamic subtest eDP-1: SUCCESS (1.792s)
[371.833491] Subtest psr-primary-page-flip: SUCCESS (1.793s)
[372.713439] [074/155] (656s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[372.819374] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt
[372.823530] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[372.920605] [075/155] (655s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-shrfb-msflip-blt)
[373.014112] Starting subtest: fbchdr-1p-primscrn-shrfb-msflip-blt
[373.018071] Subtest fbchdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[373.119313] [076/155] (655s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[373.220473] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[373.224501] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[373.325783] [077/155] (655s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-onoff)
[373.423462] Starting subtest: fbchdr-1p-primscrn-cur-indfb-onoff
[373.427941] Subtest fbchdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[373.516129] [078/155] (655s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[373.894680] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[374.724876] [079/155] (654s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[374.828363] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc
[374.832844] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[374.946864] [080/155] (654s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-render)
[375.041237] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-render
[375.045511] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[375.141177] [081/155] (653s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[375.187322] Starting subtest: multi-wait-all-for-submit-unsubmitted
[375.292771] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[375.374031] [082/155] (653s left) i915_hangman (hangcheck-unterminated)
[375.439701] Starting subtest: hangcheck-unterminated
[386.823368] Subtest hangcheck-unterminated: SUCCESS (11.346s)
[386.958119] [083/155] (642s left) kms_psr (fbc-pr-primary-render)
[387.058077] Starting subtest: fbc-pr-primary-render
[387.062334] Subtest fbc-pr-primary-render: SKIP (0.000s)
[387.142212] [084/155] (642s left) gem_exec_schedule (u-submit-early-slice)
[387.208350] Starting subtest: u-submit-early-slice
[387.210363] Starting dynamic subtest: rcs0
[387.248695] Dynamic subtest rcs0: SUCCESS (0.045s)
[387.263075] Starting dynamic subtest: bcs0
[387.288308] Dynamic subtest bcs0: SUCCESS (0.039s)
[387.300067] Starting dynamic subtest: vcs0
[387.334311] Dynamic subtest vcs0: SUCCESS (0.045s)
[387.347063] Starting dynamic subtest: vcs1
[387.378197] Dynamic subtest vcs1: SUCCESS (0.043s)
[387.393492] Starting dynamic subtest: vecs0
[387.416291] Dynamic subtest vecs0: SUCCESS (0.037s)
[387.429811] Starting dynamic subtest: ccs0
[387.455152] Dynamic subtest ccs0: SUCCESS (0.038s)
[387.457366] Subtest u-submit-early-slice: SUCCESS (0.253s)
[388.913106] [085/155] (640s left) kms_vblank (wait-idle)
[389.010560] Starting subtest: wait-idle
[389.012842] Starting dynamic subtest: pipe-A-eDP-1
[390.771359] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.758s)
[390.791345] Starting dynamic subtest: pipe-D-eDP-1
[393.234314] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.458s)
[393.236677] Subtest wait-idle: SUCCESS (4.221s)
[394.059198] [086/155] (635s left) kms_setmode (invalid-clone-single-crtc)
[394.113792] Starting subtest: invalid-clone-single-crtc
[394.120079] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[394.226253] [087/155] (635s left) perf_pmu (busy-hang)
[394.268934] Starting subtest: busy-hang
[394.271156] Starting dynamic subtest: rcs0
[395.538861] Dynamic subtest rcs0: SUCCESS (1.271s)
[395.551175] Starting dynamic subtest: bcs0
[396.764842] Dynamic subtest bcs0: SUCCESS (1.223s)
[396.781919] Starting dynamic subtest: vcs0
[399.336602] Dynamic subtest vcs0: SUCCESS (2.568s)
[399.350347] Starting dynamic subtest: vcs1
[401.331637] Dynamic subtest vcs1: SUCCESS (1.991s)
[401.344438] Starting dynamic subtest: vecs0
[403.373348] Dynamic subtest vecs0: SUCCESS (2.039s)
[403.387015] Starting dynamic subtest: ccs0
[404.629947] Dynamic subtest ccs0: SUCCESS (1.242s)
[404.632338] Subtest busy-hang: SUCCESS (10.347s)
[404.743586] [088/155] (624s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[404.844507] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[404.846856] Starting dynamic subtest: pipe-A-eDP-1
[405.335747] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.461s)
[405.349934] Starting dynamic subtest: pipe-B-eDP-1
[406.806493] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.469s)
[406.820683] Starting dynamic subtest: pipe-C-eDP-1
[408.194327] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.387s)
[408.206592] Starting dynamic subtest: pipe-D-eDP-1
[409.628879] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.434s)
[409.631188] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.757s)
[410.807832] [089/155] (618s left) gem_exec_reloc (basic-range)
[410.875132] Subtest basic-range: SKIP (0.000s)
[410.956719] [090/155] (618s left) kms_content_protection (type1)
[411.096361] Starting subtest: type1
[411.101013] Subtest type1: SKIP (0.000s)
[411.243784] [091/155] (618s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[411.338268] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[411.340458] Starting dynamic subtest: pipe-A
[411.361176] Dynamic subtest pipe-A: SKIP (0.019s)
[411.373491] Starting dynamic subtest: pipe-B
[411.393649] Dynamic subtest pipe-B: SKIP (0.032s)
[411.405714] Starting dynamic subtest: pipe-C
[411.425254] Dynamic subtest pipe-C: SKIP (0.031s)
[411.437861] Starting dynamic subtest: pipe-D
[411.455866] Dynamic subtest pipe-D: SKIP (0.031s)
[411.460072] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.115s)
[411.554960] [092/155] (617s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[411.680183] Starting subtest: basic-busy-flip-before-cursor-varying-size
[411.684553] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[411.827908] [093/155] (617s left) gem_mmap_gtt (zero-extend)
[411.873248] Subtest zero-extend: SKIP (0.000s)
[411.940745] [094/155] (617s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[412.032991] Starting subtest: fbcpsr-rgb565-draw-render
[419.135404] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.104s)
[419.251703] [095/155] (610s left) gem_exec_schedule (preempt-other)
[419.325078] Starting subtest: preempt-other
[419.327059] Starting dynamic subtest: rcs0
[419.390355] Dynamic subtest rcs0: SUCCESS (0.072s)
[419.402516] Starting dynamic subtest: bcs0
[419.477705] Dynamic subtest bcs0: SUCCESS (0.088s)
[419.489977] Starting dynamic subtest: vcs0
[419.548808] Dynamic subtest vcs0: SUCCESS (0.070s)
[419.568238] Starting dynamic subtest: vcs1
[419.618491] Dynamic subtest vcs1: SUCCESS (0.070s)
[419.631911] Starting dynamic subtest: vecs0
[419.691849] Dynamic subtest vecs0: SUCCESS (0.071s)
[419.706127] Starting dynamic subtest: ccs0
[419.757129] Dynamic subtest ccs0: SUCCESS (0.065s)
[419.759573] Subtest preempt-other: SUCCESS (0.442s)
[420.936439] [096/155] (608s left) gem_create (create-ext-placement-all)
[421.103108] Starting subtest: create-ext-placement-all
[421.105992] Subtest create-ext-placement-all: SUCCESS (0.000s)
[421.212454] [097/155] (608s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[421.312521] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[421.317040] Subtest hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[421.417483] [098/155] (608s left) kms_frontbuffer_tracking (hdr-2p-rte)
[421.514911] Starting subtest: hdr-2p-rte
[421.518860] Subtest hdr-2p-rte: SKIP (0.000s)
[421.611133] [099/155] (608s left) api_intel_bb (reset-bb)
[421.660250] Starting subtest: reset-bb
[421.664891] Subtest reset-bb: SUCCESS (0.005s)
[421.779260] [100/155] (608s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[421.875675] Starting subtest: fbc-1p-pri-indfb-multidraw
[434.965360] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.091s)
[436.371004] [101/155] (593s left) i915_drm_fdinfo (busy-idle)
[436.413060] Starting subtest: busy-idle
[436.415120] Starting dynamic subtest: rcs0
[436.438635] Dynamic subtest rcs0: SKIP (0.025s)
[436.452308] Starting dynamic subtest: bcs0
[436.456684] Dynamic subtest bcs0: SKIP (0.000s)
[436.468539] Starting dynamic subtest: vcs0
[436.472701] Dynamic subtest vcs0: SKIP (0.000s)
[436.483812] Starting dynamic subtest: vcs1
[436.487900] Dynamic subtest vcs1: SKIP (0.000s)
[436.499420] Starting dynamic subtest: vecs0
[436.503538] Dynamic subtest vecs0: SKIP (0.000s)
[436.515137] Starting dynamic subtest: ccs0
[436.519243] Dynamic subtest ccs0: SKIP (0.000s)
[436.523338] Subtest busy-idle: SKIP (0.030s)
[436.562494] [102/155] (593s left) kms_psr (psr2-cursor-render)
[436.659871] Starting subtest: psr2-cursor-render
[436.662191] Starting dynamic subtest: eDP-1
[438.345903] Dynamic subtest eDP-1: SUCCESS (1.683s)
[438.348233] Subtest psr2-cursor-render: SUCCESS (1.684s)
[439.240857] [103/155] (590s left) perf_pmu (semaphore-wait-idle)
[439.282211] Starting subtest: semaphore-wait-idle
[439.284344] Starting dynamic subtest: rcs0
[439.797481] Dynamic subtest rcs0: SUCCESS (0.514s)
[439.811803] Starting dynamic subtest: bcs0
[440.312343] Dynamic subtest bcs0: SUCCESS (0.511s)
[440.334947] Starting dynamic subtest: vcs0
[440.825399] Dynamic subtest vcs0: SUCCESS (0.510s)
[440.838934] Starting dynamic subtest: vcs1
[441.337959] Dynamic subtest vcs1: SUCCESS (0.510s)
[441.351605] Starting dynamic subtest: vecs0
[441.850920] Dynamic subtest vecs0: SUCCESS (0.510s)
[441.864017] Starting dynamic subtest: ccs0
[442.369062] Dynamic subtest ccs0: SUCCESS (0.515s)
[442.371955] Subtest semaphore-wait-idle: SUCCESS (3.088s)
[443.829902] [104/155] (586s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[443.934444] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[446.428217] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.498s)
[447.629997] [105/155] (582s left) gem_reg_read (timestamp-monotonic)
[447.689320] Starting subtest: timestamp-monotonic
[451.719053] Subtest timestamp-monotonic: SUCCESS (4.029s)
[451.797672] [106/155] (578s left) kms_cursor_legacy (single-move)
[451.916228] Starting subtest: single-move
[451.918479] Starting dynamic subtest: pipe-A
[457.303220] Dynamic subtest pipe-A: SUCCESS (5.380s)
[457.317731] Starting dynamic subtest: pipe-B
[462.689675] Dynamic subtest pipe-B: SUCCESS (5.380s)
[462.705789] Starting dynamic subtest: pipe-C
[468.071524] Dynamic subtest pipe-C: SUCCESS (5.381s)
[468.085007] Starting dynamic subtest: pipe-D
[473.450521] Dynamic subtest pipe-D: SUCCESS (5.379s)
[473.464830] Starting dynamic subtest: all-pipes
[478.839598] Dynamic subtest all-pipes: SUCCESS (5.387s)
[478.842092] Subtest single-move: SUCCESS (26.921s)
[478.987665] [107/155] (551s left) kms_pipe_crc_basic (bad-source)
[479.079389] Starting subtest: bad-source
[479.081663] Subtest bad-source: SUCCESS (0.000s)
[479.160964] [108/155] (551s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[479.260696] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[480.096139] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.837s)
[480.272406] [109/155] (550s left) kms_frontbuffer_tracking (fbchdr-tiling-4)
[480.370772] Starting subtest: fbchdr-tiling-4
[480.374872] Subtest fbchdr-tiling-4: SKIP (0.000s)
[480.478415] [110/155] (549s left) kms_plane_lowres (tiling-x)
[480.579653] Starting subtest: tiling-x
[480.581995] Starting dynamic subtest: pipe-A-eDP-1
[480.586556] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[480.880220] Starting dynamic subtest: pipe-B-eDP-1
[480.885079] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[480.897043] Starting dynamic subtest: pipe-C-eDP-1
[480.901654] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[480.913362] Starting dynamic subtest: pipe-D-eDP-1
[480.917587] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[480.921978] Subtest tiling-x: SKIP (0.295s)
[481.772568] [111/155] (548s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[481.893007] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[483.015362] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.123s)
[483.131090] [112/155] (547s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[483.232794] Starting subtest: async-flip-with-page-flip-events-linear
[483.613360] Starting dynamic subtest: pipe-A-eDP-1
[486.408860] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.795s)
[486.776735] Starting dynamic subtest: pipe-B-eDP-1
[489.542554] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.778s)
[489.906911] Starting dynamic subtest: pipe-C-eDP-1
[492.678445] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.780s)
[493.052054] Starting dynamic subtest: pipe-D-eDP-1
[495.805352] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.763s)
[495.808434] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.573s)
[496.998962] [113/155] (533s left) gem_exec_reloc (basic-cpu-gtt)
[497.060556] Subtest basic-cpu-gtt: SKIP (0.000s)
[497.127059] [114/155] (533s left) perf (missing-sample-flags)
[497.251525] Starting subtest: missing-sample-flags
[497.253748] Subtest missing-sample-flags: SUCCESS (0.000s)
[497.297023] [115/155] (533s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[497.394113] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[497.396395] Starting dynamic subtest: A-eDP1
[501.016789] Dynamic subtest A-eDP1: SUCCESS (3.621s)
[501.031028] Starting dynamic subtest: B-eDP1
[504.336596] Dynamic subtest B-eDP1: SUCCESS (3.318s)
[504.348454] Starting dynamic subtest: C-eDP1
[507.553241] Dynamic subtest C-eDP1: SUCCESS (3.214s)
[507.566535] Starting dynamic subtest: D-eDP1
[510.766452] Dynamic subtest D-eDP1: SUCCESS (3.213s)
[510.768679] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.374s)
[511.578798] [116/155] (519s left) gem_lmem_swapping (verify-ccs)
[511.622234] Subtest verify-ccs: SKIP (0.000s)
[511.663686] [117/155] (518s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-blt)
[511.763298] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-blt
[511.767720] Subtest hdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[511.879125] [118/155] (518s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[511.995103] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[511.999126] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[512.108088] [119/155] (518s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[512.162650] Starting subtest: invalid-multi-wait-unsubmitted
[512.164988] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[512.278263] [120/155] (518s left) kms_addfb_basic (clobberred-modifier)
[512.330600] Starting subtest: clobberred-modifier
[512.335037] Subtest clobberred-modifier: SKIP (0.000s)
[512.467659] [121/155] (518s left) api_intel_allocator (reloc-allocator)
[512.521191] Starting subtest: reloc-allocator
[512.522986] Starting dynamic subtest: basic
[512.525080] Dynamic subtest basic: SUCCESS (0.003s)
[512.540068] Starting dynamic subtest: parallel-one
[512.541995] Dynamic subtest parallel-one: SUCCESS (0.008s)
[512.553820] Starting dynamic subtest: print
[512.555694] Dynamic subtest print: SUCCESS (0.000s)
[512.567212] Starting dynamic subtest: reuse
[512.568987] Dynamic subtest reuse: SUCCESS (0.000s)
[512.579953] Starting dynamic subtest: fork-reopen-allocator
[512.581976] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[512.583834] Subtest reloc-allocator: SUCCESS (0.027s)
[512.672719] [122/155] (518s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[512.731032] Starting subtest: multi-wait-all-for-submit-signaled
[512.732859] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[512.833563] [123/155] (518s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[512.933456] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-mmap-gtt
[512.937094] Subtest hdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[513.047446] [124/155] (517s left) kms_color (ctm-signed)
[513.139838] Starting subtest: ctm-signed
[513.141617] Starting dynamic subtest: pipe-A-eDP-1
[515.274223] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.133s)
[515.286329] Starting dynamic subtest: pipe-B-eDP-1
[518.137447] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.860s)
[518.150257] Starting dynamic subtest: pipe-C-eDP-1
[520.857833] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.719s)
[520.869697] Starting dynamic subtest: pipe-D-eDP-1
[523.512219] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.653s)
[523.514573] Subtest ctm-signed: SUCCESS (10.370s)
[524.346261] [125/155] (506s left) i915_pm_rpm (system-suspend-execbuf)
[525.981520] Starting subtest: system-suspend-execbuf
[584.194307] Subtest system-suspend-execbuf: SUCCESS (42.874s)
[584.588101] [126/155] (446s left) kms_plane (pixel-format-yf-tiled-modifier)
[584.690888] Starting subtest: pixel-format-yf-tiled-modifier
[584.694852] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[584.764810] [127/155] (446s left) gem_eio (banned)
[584.989535] Starting subtest: banned
[585.614717] Subtest banned: SUCCESS (0.625s)
[585.778825] [128/155] (445s left) kms_psr (pr-cursor-mmap-gtt)
[585.874151] Starting subtest: pr-cursor-mmap-gtt
[585.877609] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[585.950249] [129/155] (445s left) syncobj_timeline (wait-for-submit-complex)
[586.007706] Starting subtest: wait-for-submit-complex
[586.068681] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[586.159675] [130/155] (445s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[586.251670] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[586.255386] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[586.353170] [131/155] (444s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[586.452280] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[593.037054] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.588s)
[593.180287] [132/155] (438s left) sriov_basic (enable-vfs-bind-unbind-each)
[593.246576] Starting subtest: enable-vfs-bind-unbind-each
[593.249053] Starting dynamic subtest: numvfs-1
[593.328945] Dynamic subtest numvfs-1: FAIL (0.029s)
[593.341724] Starting dynamic subtest: numvfs-2
[593.415732] Dynamic subtest numvfs-2: FAIL (0.004s)
[593.429322] Starting dynamic subtest: numvfs-3
[593.502845] Dynamic subtest numvfs-3: FAIL (0.004s)
[593.515716] Starting dynamic subtest: numvfs-4
[593.588252] Dynamic subtest numvfs-4: FAIL (0.004s)
[593.601358] Starting dynamic subtest: numvfs-5
[593.674421] Dynamic subtest numvfs-5: FAIL (0.004s)
[593.686526] Starting dynamic subtest: numvfs-6
[593.759864] Dynamic subtest numvfs-6: FAIL (0.004s)
[593.773012] Starting dynamic subtest: numvfs-7
[593.846337] Dynamic subtest numvfs-7: FAIL (0.004s)
[593.858865] Starting dynamic subtest: numvfs-random
[593.931952] Dynamic subtest numvfs-random: FAIL (0.004s)
[593.933951] Subtest enable-vfs-bind-unbind-each: FAIL (0.062s)
[593.979897] [133/155] (437s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[594.075260] Starting subtest: fbc-pr-cursor-plane-update-sf
[594.078691] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[594.148404] [134/155] (437s left) syncobj_timeline (invalid-signal-bad-pad)
[594.198705] Starting subtest: invalid-signal-bad-pad
[594.201387] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[594.295559] [135/155] (437s left) kms_frontbuffer_tracking (psrhdr-modesetfrombusy)
[594.391545] Starting subtest: psrhdr-modesetfrombusy
[594.394861] Subtest psrhdr-modesetfrombusy: SKIP (0.000s)
[594.505571] [136/155] (436s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[594.597254] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[594.598912] Starting dynamic subtest: pipe-A-eDP-1
[595.033298] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.437s)
[595.047218] Starting dynamic subtest: pipe-B-eDP-1
[595.065209] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.003s)
[595.079003] Starting dynamic subtest: pipe-C-eDP-1
[595.094989] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.003s)
[595.106293] Starting dynamic subtest: pipe-D-eDP-1
[595.122388] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[595.124171] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.451s)
[597.351007] [137/155] (434s left) perf (unprivileged-single-ctx-counters)
[597.462810] Starting subtest: unprivileged-single-ctx-counters
[597.467378] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[597.516234] [138/155] (434s left) fbdev (read)
[597.567239] Starting subtest: read
[598.413567] Subtest read: SUCCESS (0.847s)
[598.477359] [139/155] (433s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[598.590673] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[598.595113] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[598.697412] [140/155] (432s left) vgem_basic (mmap)
[598.743826] Starting subtest: mmap
[598.764237] Subtest mmap: SUCCESS (0.022s)
[598.843855] [141/155] (432s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[598.960940] Starting subtest: 2x-cursor-vs-flip-atomic
[598.965339] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[599.118358] [142/155] (432s left) perf (low-oa-exponent-permissions)
[599.203016] Starting subtest: low-oa-exponent-permissions
[599.241963] Subtest low-oa-exponent-permissions: SUCCESS (0.039s)
[599.285255] [143/155] (432s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[599.335921] Starting subtest: y-tiled-ccs-to-yf-tiled
[599.340319] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[599.546186] [144/155] (432s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[599.659915] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[600.485229] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.826s)
[600.636501] [145/155] (431s left) kms_invalid_mode (bad-htotal)
[600.725683] Starting subtest: bad-htotal
[600.727989] Starting dynamic subtest: pipe-A-eDP-1
[601.026439] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.299s)
[601.039004] Starting dynamic subtest: pipe-B-eDP-1
[601.040932] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[601.052731] Starting dynamic subtest: pipe-C-eDP-1
[601.054942] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[601.066819] Starting dynamic subtest: pipe-D-eDP-1
[601.069029] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[601.071280] Subtest bad-htotal: SUCCESS (0.305s)
[601.883822] [146/155] (430s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[601.976141] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[608.613337] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.639s)
[608.756964] [147/155] (423s left) i915_pm_sseu (full-enable)
[608.813528] Subtest full-enable: SKIP (0.000s)
[608.912117] [148/155] (423s left) kms_cursor_crc (cursor-offscreen-64x21)
[609.103912] Starting subtest: cursor-offscreen-64x21
[609.147273] Subtest cursor-offscreen-64x21: SKIP (0.042s)
[609.407918] [149/155] (422s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[609.466292] Starting subtest: invalid-bsd1-flag-on-blt
[609.468645] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[609.569059] [150/155] (422s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[609.666600] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[609.670125] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[609.762605] [151/155] (422s left) kms_lease (possible-crtcs-filtering)
[609.856019] Starting subtest: possible-crtcs-filtering
[609.859695] Subtest possible-crtcs-filtering: SUCCESS (0.006s)
[609.985190] [152/155] (422s left) gem_userptr_blits (userfault)
[610.055820] Starting subtest: userfault
[610.057925] Subtest userfault: SUCCESS (0.005s)
[610.208826] [153/155] (422s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[610.304862] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[610.306802] Starting dynamic subtest: pipe-A
[610.642963] Dynamic subtest pipe-A: SUCCESS (0.339s)
[610.655842] Starting dynamic subtest: pipe-B
[612.044006] Dynamic subtest pipe-B: SUCCESS (1.398s)
[612.063808] Starting dynamic subtest: pipe-C
[613.475361] Dynamic subtest pipe-C: SUCCESS (1.428s)
[613.497599] Starting dynamic subtest: pipe-D
[614.914783] Dynamic subtest pipe-D: SUCCESS (1.437s)
[614.917052] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.610s)
[616.085587] [154/155] (416s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[616.195601] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[616.200044] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[616.315524] [155/155] (416s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[616.424903] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[616.429463] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[616.524948] Closing watchdogs
results: parsing output: 0/ for test: gem_reg_read
results: parsing output: 1/ for test: sysfs_timeslice_duration
results: parsing output: 2/ for test: kms_atomic_interruptible
results: parsing output: 3/ for test: kms_chamelium_hpd
results: parsing output: 4/ for test: gem_exec_params
results: parsing output: 5/ for test: kms_getfb
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_pm_rpm
results: parsing output: 9/ for test: kms_cursor_legacy
results: parsing output: 10/ for test: kms_feature_discovery
results: parsing output: 11/ for test: kms_addfb_basic
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_flip_scaled_crc
results: parsing output: 14/ for test: gem_spin_batch
results: parsing output: 15/ for test: kms_pm_rpm
results: parsing output: 16/ for test: prime_mmap_coherency
results: parsing output: 17/ for test: kms_rotation_crc
results: parsing output: 18/ for test: gem_ctx_param
results: parsing output: 19/ for test: gem_exec_fence
results: parsing output: 20/ for test: gem_eio
results: parsing output: 21/ for test: gem_exec_whisper
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_softpin
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_exec_fence
results: parsing output: 26/ for test: kms_cursor_crc
results: parsing output: 27/ for test: dmabuf_sync_file
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: gem_ctx_persistence
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_sequence
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_lmem_evict
results: parsing output: 35/ for test: gem_softpin
results: parsing output: 36/ for test: kms_flip_scaled_crc
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_fenced_exec_thrash
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_partial_pwrite_pread
results: parsing output: 42/ for test: gem_ctx_shared
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: syncobj_wait
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: gem_pwrite
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: kms_plane_multiple
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: gem_exec_balancer
results: parsing output: 56/ for test: gen9_exec_parse
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_psr2_sf
results: parsing output: 59/ for test: kms_invalid_mode
results: parsing output: 60/ for test: gem_exec_create
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: kms_flip
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: kms_atomic_transition
results: parsing output: 68/ for test: gem_render_copy
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_chamelium_edid
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: syncobj_wait
results: parsing output: 81/ for test: i915_hangman
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: gem_exec_schedule
results: parsing output: 84/ for test: kms_vblank
results: parsing output: 85/ for test: kms_setmode
results: parsing output: 86/ for test: perf_pmu
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: gem_exec_reloc
results: parsing output: 89/ for test: kms_content_protection
results: parsing output: 90/ for test: kms_plane_scaling
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: gem_mmap_gtt
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_exec_schedule
results: parsing output: 95/ for test: gem_create
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: api_intel_bb
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: i915_drm_fdinfo
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: perf_pmu
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_reg_read
results: parsing output: 105/ for test: kms_cursor_legacy
results: parsing output: 106/ for test: kms_pipe_crc_basic
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_plane_lowres
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: kms_async_flips
results: parsing output: 112/ for test: gem_exec_reloc
results: parsing output: 113/ for test: perf
results: parsing output: 114/ for test: kms_flip
results: parsing output: 115/ for test: gem_lmem_swapping
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: kms_addfb_basic
results: parsing output: 120/ for test: api_intel_allocator
results: parsing output: 121/ for test: syncobj_wait
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_color
results: parsing output: 124/ for test: i915_pm_rpm
results: parsing output: 125/ for test: kms_plane
results: parsing output: 126/ for test: gem_eio
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: sriov_basic
results: parsing output: 132/ for test: kms_psr2_sf
results: parsing output: 133/ for test: syncobj_timeline
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: kms_ccs
results: parsing output: 136/ for test: perf
results: parsing output: 137/ for test: fbdev
results: parsing output: 138/ for test: kms_big_fb
results: parsing output: 139/ for test: vgem_basic
results: parsing output: 140/ for test: kms_cursor_legacy
results: parsing output: 141/ for test: perf
results: parsing output: 142/ for test: gem_render_copy
results: parsing output: 143/ for test: kms_big_fb
results: parsing output: 144/ for test: kms_invalid_mode
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: i915_pm_sseu
results: parsing output: 147/ for test: kms_cursor_crc
results: parsing output: 148/ for test: gem_exec_params
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: kms_lease
results: parsing output: 151/ for test: gem_userptr_blits
results: parsing output: 152/ for test: kms_plane_scaling
results: parsing output: 153/ for test: kms_big_fb
results: parsing output: 154/ for test: kms_frontbuffer_tracking
Done.