[59.284658] Initializing watchdogs
[59.284710]   /dev/watchdog0
[59.298359] [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]
[59.302546] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.304676] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.308198] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[59.440849] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[59.445151] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[59.569880] [002/133] (960s left) gem_bad_reloc (negative-reloc-bltcopy)
[59.636060] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[59.721190] [003/133] (960s left) gem_exec_params (invalid-fence-in-submit)
[59.780664] Starting subtest: invalid-fence-in-submit
[59.785332] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[59.902175] [004/133] (960s left) kms_plane (pixel-format-linear-modifier)
[59.993684] Starting subtest: pixel-format-linear-modifier
[60.029967] Starting dynamic subtest: pipe-A-plane-0
[63.482954] Dynamic subtest pipe-A-plane-0: SUCCESS (3.434s)
[63.489666] Starting dynamic subtest: pipe-A-plane-3
[65.191226] Dynamic subtest pipe-A-plane-3: SUCCESS (1.699s)
[65.198788] Starting dynamic subtest: pipe-A-plane-5
[65.401887] Dynamic subtest pipe-A-plane-5: SUCCESS (0.210s)
[66.561104] Starting dynamic subtest: pipe-B-plane-0
[70.329900] Dynamic subtest pipe-B-plane-0: SUCCESS (3.767s)
[70.337154] Starting dynamic subtest: pipe-B-plane-3
[72.044151] Dynamic subtest pipe-B-plane-3: SUCCESS (1.711s)
[72.050935] Starting dynamic subtest: pipe-B-plane-5
[72.255556] Dynamic subtest pipe-B-plane-5: SUCCESS (0.210s)
[72.568156] Subtest pixel-format-linear-modifier: SUCCESS (12.530s)
[73.452215] [005/133] (946s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[73.553625] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[77.815326] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.261s)
[78.946906] [006/133] (941s left) gem_exec_schedule (pi-shared-iova)
[79.129731] Starting subtest: pi-shared-iova
[79.132258] Starting dynamic subtest: rcs0
[79.201960] Dynamic subtest rcs0: SUCCESS (0.074s)
[79.209793] Starting dynamic subtest: vcs0
[79.258858] Dynamic subtest vcs0: SUCCESS (0.057s)
[79.268530] Starting dynamic subtest: vcs1
[79.317834] Dynamic subtest vcs1: SUCCESS (0.058s)
[79.330918] Starting dynamic subtest: vecs0
[79.365728] Dynamic subtest vecs0: SUCCESS (0.048s)
[79.376526] Starting dynamic subtest: ccs0
[79.428058] Dynamic subtest ccs0: SUCCESS (0.062s)
[79.430534] Subtest pi-shared-iova: SUCCESS (0.301s)
[81.030865] [007/133] (939s left) gem_mmap_gtt (basic-write-read)
[81.085744] Subtest basic-write-read: SKIP (0.000s)
[81.148180] [008/133] (938s left) kms_flip (flip-vs-rmfb)
[81.238227] Starting subtest: flip-vs-rmfb
[81.240597] Starting dynamic subtest: A-eDP1
[89.914891] Dynamic subtest A-eDP1: SUCCESS (8.670s)
[89.923612] Starting dynamic subtest: B-eDP1
[98.547922] Dynamic subtest B-eDP1: SUCCESS (8.627s)
[98.556408] Starting dynamic subtest: C-eDP1
[107.167609] Dynamic subtest C-eDP1: SUCCESS (8.616s)
[107.176813] Starting dynamic subtest: D-eDP1
[115.799126] Dynamic subtest D-eDP1: SUCCESS (8.628s)
[115.803786] Subtest flip-vs-rmfb: SUCCESS (34.550s)
[116.994958] [009/133] (903s left) gem_exec_whisper (basic-contexts-priority)
[117.059215] Starting subtest: basic-contexts-priority
[140.522223] Subtest basic-contexts-priority: SUCCESS (23.454s)
[140.726014] [010/133] (879s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[140.827514] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[140.831639] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[140.930894] [011/133] (879s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[141.028789] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[141.033097] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[141.155561] [012/133] (879s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[141.222574] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[141.329921] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.106s)
[141.413900] [013/133] (878s left) kms_content_protection (atomic-hdcp14)
[141.552070] Starting subtest: atomic-hdcp14
[141.557436] Subtest atomic-hdcp14: SKIP (0.000s)
[141.706320] [014/133] (878s left) gem_flink_race (flink_close)
[141.743674] Starting subtest: flink_close
[146.843617] Subtest flink_close: SUCCESS (5.100s)
[146.937884] [015/133] (873s left) tools_test (sysfs_l3_parity)
[146.999811] Starting subtest: sysfs_l3_parity
[147.141361] Subtest sysfs_l3_parity: SKIP (0.149s)
[147.230622] [016/133] (873s left) kms_cdclk (plane-scaling)
[147.364087] Starting subtest: plane-scaling
[147.366324] Starting dynamic subtest: pipe-A-eDP-1
[147.670110] Dynamic subtest pipe-A-eDP-1: SKIP (0.302s)
[147.682476] Starting dynamic subtest: pipe-B-eDP-1
[147.686967] Dynamic subtest pipe-B-eDP-1: SKIP (0.002s)
[147.699942] Starting dynamic subtest: pipe-C-eDP-1
[147.704465] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[147.715855] Starting dynamic subtest: pipe-D-eDP-1
[147.720192] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[147.724584] Subtest plane-scaling: SKIP (0.311s)
[148.532170] [017/133] (871s left) kms_psr (pr-sprite-mmap-cpu)
[148.637471] Starting subtest: pr-sprite-mmap-cpu
[148.641833] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[148.714893] [018/133] (871s left) i915_pm_rpm (system-suspend-devices)
[150.238433] Starting subtest: system-suspend-devices
[158.080222] Subtest system-suspend-devices: SUCCESS (7.841s)
[158.461952] [019/133] (862s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[158.565776] Starting subtest: fbc-rgb565-draw-blt
[162.792189] Subtest fbc-rgb565-draw-blt: SUCCESS (4.230s)
[163.967861] [020/133] (856s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[164.061300] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[168.032399] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (3.975s)
[169.153791] [021/133] (851s left) kms_cursor_edge_walk (256x256-top-edge)
[169.242399] Starting subtest: 256x256-top-edge
[169.244713] Starting dynamic subtest: pipe-A-eDP-1
[172.721027] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.477s)
[172.731475] Starting dynamic subtest: pipe-D-eDP-1
[175.919756] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.199s)
[175.922071] Subtest 256x256-top-edge: SUCCESS (6.680s)
[176.737505] [022/133] (843s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[176.856469] Starting subtest: cursorA-vs-flipB-atomic-transitions
[176.860944] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[177.004651] [023/133] (843s left) gem_ctx_engines (execute-one)
[177.074145] Starting subtest: execute-one
[179.208444] Subtest execute-one: SUCCESS (2.137s)
[179.400862] [024/133] (841s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[179.512853] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[179.517521] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[179.641677] [025/133] (841s left) gem_exec_reloc (basic-wc-read-noreloc)
[179.712635] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[179.797464] [026/133] (840s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[179.900817] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[179.905225] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[180.012241] [027/133] (840s left) kms_plane (plane-panning-bottom-right-suspend)
[180.101101] Starting subtest: plane-panning-bottom-right-suspend
[180.103357] Starting dynamic subtest: pipe-A
[197.630191] Dynamic subtest pipe-A: SUCCESS (2.953s)
[197.639632] Starting dynamic subtest: pipe-B
[215.614840] Dynamic subtest pipe-B: SUCCESS (3.420s)
[215.617253] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.376s)
[216.488191] [028/133] (804s left) kms_big_fb (y-tiled-addfb-size-overflow)
[216.600450] Starting subtest: y-tiled-addfb-size-overflow
[216.604711] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[216.728446] [029/133] (804s left) gem_exec_async (concurrent-writes)
[216.796623] Starting subtest: concurrent-writes
[216.798907] Starting dynamic subtest: rcs0
[216.810593] Dynamic subtest rcs0: SUCCESS (0.016s)
[216.820392] Starting dynamic subtest: bcs0
[216.822917] Dynamic subtest bcs0: SUCCESS (0.006s)
[216.831858] Starting dynamic subtest: vcs0
[216.833790] Dynamic subtest vcs0: SUCCESS (0.005s)
[216.844015] Starting dynamic subtest: vcs1
[216.846276] Dynamic subtest vcs1: SUCCESS (0.005s)
[216.855028] Starting dynamic subtest: vecs0
[216.857257] Dynamic subtest vecs0: SUCCESS (0.005s)
[216.865822] Starting dynamic subtest: ccs0
[216.868131] Dynamic subtest ccs0: SUCCESS (0.006s)
[216.870375] Subtest concurrent-writes: SUCCESS (0.046s)
[217.108925] [030/133] (803s left) kms_addfb_basic (unused-pitches)
[217.174454] Starting subtest: unused-pitches
[217.176922] Subtest unused-pitches: SUCCESS (0.000s)
[217.323135] [031/133] (803s left) api_intel_bb (delta-check)
[217.374226] Starting subtest: delta-check
[217.377450] Subtest delta-check: SUCCESS (0.005s)
[217.539194] [032/133] (803s left) gem_watchdog (default-virtual)
[217.609542] Starting subtest: default-virtual
[223.642699] Subtest default-virtual: SUCCESS (5.899s)
[223.758362] [033/133] (797s left) prime_mmap (test_errors)
[223.821693] Starting subtest: test_errors
[223.824066] Starting dynamic subtest: test_errors-smem
[223.917898] Dynamic subtest test_errors-smem: SUCCESS (0.096s)
[223.920585] Subtest test_errors: SUCCESS (0.097s)
[224.046519] [034/133] (797s left) vgem_basic (bad-handle)
[224.164672] Starting subtest: bad-handle
[224.166628] Subtest bad-handle: SUCCESS (0.000s)
[224.241385] [FACT vgem_basic (bad-handle)] new: kernel.kmod_is_loaded.vgem: true
[224.244583] [035/133] (796s left) kms_plane_lowres (tiling-x)
[224.342638] Starting subtest: tiling-x
[224.345038] Starting dynamic subtest: pipe-A-eDP-1
[224.350114] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[224.637455] Starting dynamic subtest: pipe-B-eDP-1
[224.641978] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[224.650729] Starting dynamic subtest: pipe-C-eDP-1
[224.655357] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[224.664681] Starting dynamic subtest: pipe-D-eDP-1
[224.669348] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[224.673991] Subtest tiling-x: SKIP (0.291s)
[225.531624] [036/133] (795s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[225.659710] Starting subtest: flip-vs-cursor-varying-size
[234.215876] Subtest flip-vs-cursor-varying-size: SUCCESS (8.491s)
[235.042836] [037/133] (786s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[235.148352] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[235.150554] Starting dynamic subtest: pipe-A-eDP-1
[241.007795] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.849s)
[241.017740] Starting dynamic subtest: pipe-B-eDP-1
[247.667168] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.650s)
[247.669336] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.501s)
[248.549072] [038/133] (772s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[248.611842] Starting subtest: framebuffer-vs-set-tiling
[248.616158] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[248.770206] [039/133] (772s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[248.902578] Starting subtest: verify-pxp-execution-after-suspend-resume
[255.950241] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.049s)
[256.094886] [040/133] (765s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[256.215382] Starting subtest: x-tiled-64bpp-rotate-180
[257.683057] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.467s)
[257.884208] [041/133] (763s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[257.938872] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[258.048106] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.109s)
[258.133244] [042/133] (763s left) gem_softpin (allocator-basic)
[258.187476] Starting subtest: allocator-basic
[258.252597] Subtest allocator-basic: SUCCESS (0.065s)
[258.393364] [043/133] (763s left) perf_pmu (render-node-busy-idle)
[258.466066] Starting subtest: render-node-busy-idle
[258.468501] Starting dynamic subtest: rcs0
[259.174570] Dynamic subtest rcs0: SUCCESS (0.708s)
[259.185837] Starting dynamic subtest: bcs0
[259.843478] Dynamic subtest bcs0: SUCCESS (0.666s)
[259.855160] Starting dynamic subtest: vcs0
[261.923234] Dynamic subtest vcs0: SUCCESS (2.075s)
[261.934605] Starting dynamic subtest: vcs1
[263.907460] Dynamic subtest vcs1: SUCCESS (1.980s)
[263.918694] Starting dynamic subtest: vecs0
[265.892291] Dynamic subtest vecs0: SUCCESS (1.981s)
[265.904161] Starting dynamic subtest: ccs0
[266.569137] Dynamic subtest ccs0: SUCCESS (0.676s)
[266.571738] Subtest render-node-busy-idle: SUCCESS (8.102s)
[266.669219] [044/133] (754s left) gem_basic (create-fd-close)
[266.741441] Starting subtest: create-fd-close
[266.745733] Subtest create-fd-close: SUCCESS (0.000s)
[266.858076] [045/133] (754s left) kms_dp_link_training (non-uhbr-sst)
[266.959879] Starting subtest: non-uhbr-sst
[266.968146] Subtest non-uhbr-sst: SKIP (0.000s)
[267.043311] [046/133] (754s left) kms_cursor_crc (cursor-offscreen-64x21)
[267.228177] Starting subtest: cursor-offscreen-64x21
[267.277825] Subtest cursor-offscreen-64x21: SKIP (0.047s)
[267.544897] [047/133] (754s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[267.644418] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[274.987184] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.343s)
[275.135054] [048/133] (746s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[275.232996] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[275.235307] Starting dynamic subtest: pipe-A
[275.254391] Dynamic subtest pipe-A: SKIP (0.016s)
[275.265605] Starting dynamic subtest: pipe-B
[275.283332] Dynamic subtest pipe-B: SKIP (0.029s)
[275.293017] Starting dynamic subtest: pipe-C
[275.311256] Dynamic subtest pipe-C: SKIP (0.028s)
[275.320336] Starting dynamic subtest: pipe-D
[275.341140] Dynamic subtest pipe-D: SKIP (0.029s)
[275.345049] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.105s)
[275.466681] [049/133] (746s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[275.559190] Starting subtest: extended-pageflip-modeset-hang-oldfb
[275.561343] Starting dynamic subtest: pipe-A
[283.452383] Dynamic subtest pipe-A: SUCCESS (7.888s)
[283.463486] Starting dynamic subtest: pipe-D
[292.017306] Dynamic subtest pipe-D: SUCCESS (8.561s)
[292.019517] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.454s)
[292.887102] [050/133] (728s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[292.992654] Starting subtest: fbcpsr-tiling-linear
[299.628100] Subtest fbcpsr-tiling-linear: SUCCESS (6.637s)
[299.789172] [051/133] (721s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[299.885303] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[303.627201] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.745s)
[304.800323] [052/133] (717s left) kms_flip (flip-vs-wf_vblank-interruptible)
[304.911251] Starting subtest: flip-vs-wf_vblank-interruptible
[304.913666] Starting dynamic subtest: A-eDP1
[306.825055] Dynamic subtest A-eDP1: SUCCESS (1.913s)
[306.839133] Starting dynamic subtest: B-eDP1
[308.757891] Dynamic subtest B-eDP1: SUCCESS (1.931s)
[308.771533] Starting dynamic subtest: C-eDP1
[310.670289] Dynamic subtest C-eDP1: SUCCESS (1.911s)
[310.683661] Starting dynamic subtest: D-eDP1
[312.607103] Dynamic subtest D-eDP1: SUCCESS (1.935s)
[312.612437] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.698s)
[313.847531] [053/133] (708s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[313.949119] Starting subtest: yf-tiled-64bpp-rotate-180
[313.953683] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[314.067573] [054/133] (707s left) gem_exec_balancer (nohangcheck)
[314.333743] Starting subtest: nohangcheck
[315.202176] Subtest nohangcheck: SUCCESS (0.866s)
[315.366563] [055/133] (706s left) i915_drm_fdinfo (most-busy-check-all)
[315.410147] Starting subtest: most-busy-check-all
[315.412564] Starting dynamic subtest: rcs0
[315.417247] Dynamic subtest rcs0: SKIP (0.004s)
[315.431925] Starting dynamic subtest: bcs0
[315.436153] Dynamic subtest bcs0: SKIP (0.000s)
[315.444494] Starting dynamic subtest: vcs0
[315.448499] Dynamic subtest vcs0: SKIP (0.000s)
[315.456517] Starting dynamic subtest: vcs1
[315.460445] Dynamic subtest vcs1: SKIP (0.000s)
[315.468511] Starting dynamic subtest: vecs0
[315.472425] Dynamic subtest vecs0: SKIP (0.000s)
[315.480692] Starting dynamic subtest: ccs0
[315.484536] Dynamic subtest ccs0: SKIP (0.000s)
[315.488468] Subtest most-busy-check-all: SKIP (0.011s)
[315.524624] [056/133] (706s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[315.673740] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[338.491059] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.814s)
[338.641302] [057/133] (683s left) kms_plane_cursor (overlay)
[338.739480] Starting subtest: overlay
[338.743417] Starting dynamic subtest: pipe-A-eDP-1-size-64
[341.155585] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.416s)
[341.217702] Starting dynamic subtest: pipe-A-eDP-1-size-128
[343.649218] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.437s)
[343.712529] Starting dynamic subtest: pipe-A-eDP-1-size-256
[346.215812] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.516s)
[346.565485] Starting dynamic subtest: pipe-B-eDP-1-size-64
[349.661669] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.107s)
[349.722376] Starting dynamic subtest: pipe-B-eDP-1-size-128
[352.106924] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.393s)
[352.168695] Starting dynamic subtest: pipe-B-eDP-1-size-256
[354.532540] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.371s)
[354.881850] Starting dynamic subtest: pipe-C-eDP-1-size-64
[357.651882] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.780s)
[357.689357] Starting dynamic subtest: pipe-C-eDP-1-size-128
[359.751270] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.069s)
[359.789289] Starting dynamic subtest: pipe-C-eDP-1-size-256
[361.841239] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.058s)
[362.194215] Starting dynamic subtest: pipe-D-eDP-1-size-64
[365.093634] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.907s)
[365.131217] Starting dynamic subtest: pipe-D-eDP-1-size-128
[367.171250] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.047s)
[367.212656] Starting dynamic subtest: pipe-D-eDP-1-size-256
[369.260464] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.058s)
[369.586032] Subtest overlay: SUCCESS (30.836s)
[370.394945] [058/133] (651s left) gem_render_copy_redux (normal)
[370.453293] Starting subtest: normal
[370.693306] Subtest normal: SUCCESS (0.239s)
[370.842867] [059/133] (651s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[370.931264] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[370.933515] Starting dynamic subtest: pipe-A-default-mode
[373.650968] Dynamic subtest pipe-A-default-mode: SUCCESS (2.719s)
[373.653458] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.721s)
[374.493260] [060/133] (647s left) gem_render_copy (yf-tiled-to-vebox-linear)
[374.584454] Starting subtest: yf-tiled-to-vebox-linear
[374.588666] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[374.788732] [061/133] (647s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[374.858750] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[374.861076] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[374.997425] [062/133] (647s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[375.103615] Starting subtest: psr2-cursor-plane-move-continuous-sf
[375.105978] Starting dynamic subtest: pipe-A-eDP-1
[385.449731] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.349s)
[385.463508] Starting dynamic subtest: pipe-B-eDP-1
[396.553337] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.096s)
[396.555321] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.448s)
[397.360195] [063/133] (624s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[397.449814] Starting subtest: fbc-psr2-sprite-mmap-gtt
[397.452095] Starting dynamic subtest: eDP-1
[397.456342] Dynamic subtest eDP-1: SKIP (0.000s)
[397.460614] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[397.534833] [064/133] (624s left) gem_mmap_wc (bad-size)
[397.595290] Subtest bad-size: SKIP (0.000s)
[397.657437] [065/133] (624s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[397.743076] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[397.747347] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[397.825173] [066/133] (624s left) kms_vblank (ts-continuation-suspend)
[397.928870] Starting subtest: ts-continuation-suspend
[397.930714] Starting dynamic subtest: pipe-A-eDP-1
[414.486870] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.562s)
[414.501589] Starting dynamic subtest: pipe-D-eDP-1
[431.529702] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.238s)
[431.532098] Subtest ts-continuation-suspend: SUCCESS (3.804s)
[432.392287] [067/133] (590s left) kms_addfb_basic (invalid-set-prop)
[432.471501] Starting subtest: invalid-set-prop
[432.473968] Subtest invalid-set-prop: SUCCESS (0.000s)
[432.665027] [068/133] (589s left) kms_psr (psr-sprite-plane-onoff)
[432.769092] Starting subtest: psr-sprite-plane-onoff
[432.771479] Starting dynamic subtest: eDP-1
[434.605648] Dynamic subtest eDP-1: SUCCESS (1.774s)
[434.608055] Subtest psr-sprite-plane-onoff: SUCCESS (1.776s)
[435.458400] [069/133] (587s left) gem_fence_thrash (bo-write-verify-threaded-y)
[435.493762] Starting subtest: bo-write-verify-threaded-y
[435.526079] Subtest bo-write-verify-threaded-y: SKIP (0.029s)
[435.597300] [070/133] (586s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[435.711428] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[435.715517] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[435.838265] [071/133] (586s left) gem_exec_schedule (submit-early-slice)
[435.905903] Starting subtest: submit-early-slice
[435.908255] Starting dynamic subtest: rcs0
[435.939377] Dynamic subtest rcs0: SUCCESS (0.041s)
[435.951662] Starting dynamic subtest: bcs0
[435.974310] Dynamic subtest bcs0: SUCCESS (0.033s)
[435.984519] Starting dynamic subtest: vcs0
[436.016593] Dynamic subtest vcs0: SUCCESS (0.041s)
[436.025585] Starting dynamic subtest: vcs1
[436.051053] Dynamic subtest vcs1: SUCCESS (0.033s)
[436.062567] Starting dynamic subtest: vecs0
[436.090085] Dynamic subtest vecs0: SUCCESS (0.038s)
[436.101184] Starting dynamic subtest: ccs0
[436.127274] Dynamic subtest ccs0: SUCCESS (0.036s)
[436.129547] Subtest submit-early-slice: SUCCESS (0.225s)
[437.756068] [072/133] (584s left) i915_hangman (gt-engine-error)
[437.814851] Starting subtest: gt-engine-error
[437.817968] Starting dynamic subtest: rcs0
[439.568834] Dynamic subtest rcs0: SUCCESS (1.722s)
[439.582173] Starting dynamic subtest: bcs0
[441.616600] Dynamic subtest bcs0: SUCCESS (2.016s)
[441.630732] Starting dynamic subtest: vcs0
[443.601752] Dynamic subtest vcs0: SUCCESS (1.961s)
[443.616725] Starting dynamic subtest: vcs1
[445.584845] Dynamic subtest vcs1: SUCCESS (1.964s)
[445.600857] Starting dynamic subtest: vecs0
[447.570419] Dynamic subtest vecs0: SUCCESS (1.970s)
[447.586929] Starting dynamic subtest: ccs0
[449.618857] Dynamic subtest ccs0: SUCCESS (2.035s)
[449.621468] Subtest gt-engine-error: SUCCESS (11.684s)
[449.709861] [073/133] (572s left) api_intel_allocator (gem-pool)
[449.777529] Starting subtest: gem-pool
[449.791654] Subtest gem-pool: SUCCESS (0.016s)
[449.958740] [074/133] (572s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[450.018598] Starting subtest: multi-wait-for-submit-unsubmitted
[450.128347] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[450.224471] [075/133] (572s left) gem_lmem_swapping (massive)
[450.268020] Subtest massive: SKIP (0.000s)
[450.351426] [076/133] (572s left) kms_big_fb (linear-64bpp-rotate-270)
[450.465077] Starting subtest: linear-64bpp-rotate-270
[450.484254] Subtest linear-64bpp-rotate-270: SKIP (0.019s)
[450.630841] [077/133] (572s left) gem_exec_params (rsvd2-dirt)
[450.691867] Starting subtest: rsvd2-dirt
[450.696050] Subtest rsvd2-dirt: SKIP (0.000s)
[450.842607] [078/133] (572s left) kms_pm_dc (dc9-dpms)
[451.936839] Starting subtest: dc9-dpms
[453.354466] Subtest dc9-dpms: SUCCESS (1.415s)
[453.438432] [079/133] (569s left) kms_properties (invalid-properties-atomic)
[453.533561] Starting subtest: invalid-properties-atomic
[453.827489] Subtest invalid-properties-atomic: SUCCESS (0.293s)
[453.924140] [080/133] (569s left) gem_pipe_control_store_loop (fresh-buffer)
[453.977608] Starting subtest: fresh-buffer
[456.136237] Subtest fresh-buffer: SUCCESS (2.153s)
[456.290836] [081/133] (566s left) kms_flip (wf_vblank-ts-check-interruptible)
[456.399881] Starting subtest: wf_vblank-ts-check-interruptible
[456.402129] Starting dynamic subtest: A-eDP1
[465.270930] Dynamic subtest A-eDP1: SUCCESS (8.861s)
[465.282976] Starting dynamic subtest: B-eDP1
[474.203482] Dynamic subtest B-eDP1: SUCCESS (8.929s)
[474.215406] Starting dynamic subtest: C-eDP1
[483.127211] Dynamic subtest C-eDP1: SUCCESS (8.920s)
[483.141133] Starting dynamic subtest: D-eDP1
[492.062849] Dynamic subtest D-eDP1: SUCCESS (8.932s)
[492.067990] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.654s)
[493.302356] [082/133] (529s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[493.408599] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[493.413145] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[493.532096] [083/133] (529s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[493.633638] Starting subtest: crc-primary-suspend-y-tiled-ccs
[493.635804] Starting dynamic subtest: pipe-A-eDP-1
[493.644356] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[493.654812] Starting dynamic subtest: pipe-B-eDP-1
[493.663150] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[493.672607] Starting dynamic subtest: pipe-C-eDP-1
[493.680521] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[493.689116] Starting dynamic subtest: pipe-D-eDP-1
[493.697254] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[493.701125] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s)
[495.961453] [084/133] (527s left) gem_lmem_swapping (parallel-random-verify-ccs)
[496.006905] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[496.059524] [085/133] (527s left) kms_atomic (plane-primary-legacy)
[496.152848] Starting subtest: plane-primary-legacy
[496.155100] Starting dynamic subtest: pipe-A-eDP-1
[496.610564] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.457s)
[496.612799] Subtest plane-primary-legacy: SUCCESS (0.459s)
[497.500660] [086/133] (525s left) sw_sync (sync_multi_consumer)
[497.539470] Starting subtest: sync_multi_consumer
[497.964443] Subtest sync_multi_consumer: SUCCESS (0.425s)
[498.036560] [087/133] (525s left) intel_hwmon (hwmon-read)
[498.094172] Subtest hwmon-read: SKIP (0.000s)
[498.151159] [088/133] (525s left) kms_cursor_crc (cursor-sliding-128x42)
[498.373352] Starting subtest: cursor-sliding-128x42
[498.418144] Subtest cursor-sliding-128x42: SKIP (0.039s)
[498.637052] [089/133] (524s left) kms_color (gamma)
[498.743890] Starting subtest: gamma
[498.745790] Starting dynamic subtest: pipe-A-eDP-1
[499.438791] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.696s)
[499.458809] Starting dynamic subtest: pipe-B-eDP-1
[500.884592] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.443s)
[500.894861] Starting dynamic subtest: pipe-C-eDP-1
[502.277795] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.392s)
[502.287686] Starting dynamic subtest: pipe-D-eDP-1
[503.587638] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.309s)
[503.589899] Subtest gamma: SUCCESS (4.842s)
[504.431513] [090/133] (519s left) gen9_exec_parse (cmd-crossing-page)
[504.507087] Subtest cmd-crossing-page: SKIP (0.000s)
[504.578719] [091/133] (518s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[504.679943] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[504.682199] Starting dynamic subtest: pipe-A-eDP-1
[504.737046] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[504.747355] Starting dynamic subtest: pipe-B-eDP-1
[504.803012] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[504.812900] Starting dynamic subtest: pipe-C-eDP-1
[504.866942] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[504.876104] Starting dynamic subtest: pipe-D-eDP-1
[504.931127] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[504.935370] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.008s)
[506.984640] [092/133] (516s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[507.088058] Starting subtest: bad-pixel-format-yf-tiled-ccs
[507.090295] Starting dynamic subtest: pipe-A-eDP-1
[507.112721] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[507.124247] Starting dynamic subtest: pipe-B-eDP-1
[507.144237] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[507.152974] Starting dynamic subtest: pipe-C-eDP-1
[507.173933] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[507.182340] Starting dynamic subtest: pipe-D-eDP-1
[507.203236] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[507.207399] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s)
[509.324587] [093/133] (514s left) gem_userptr_blits (dmabuf-unsync)
[509.393355] Subtest dmabuf-unsync: SKIP (0.000s)
[509.548785] [094/133] (514s left) gem_exec_params (batch-first)
[509.620475] Starting subtest: batch-first
[509.626787] Subtest batch-first: SUCCESS (0.006s)
[509.790896] [095/133] (513s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[510.184548] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[511.031832] [096/133] (512s left) gem_workarounds (basic-read)
[511.115705] Starting subtest: basic-read
[511.125584] Subtest basic-read: SUCCESS (0.009s)
[511.273803] [097/133] (512s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[511.379103] Starting subtest: 4-tiled-16bpp-rotate-270
[511.399176] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.019s)
[511.545256] [098/133] (512s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[511.596308] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[511.658689] [099/133] (512s left) prime_self_import (basic-with_two_bos)
[511.699285] Starting subtest: basic-with_two_bos
[511.721040] Subtest basic-with_two_bos: SUCCESS (0.025s)
[511.865047] [100/133] (511s left) i915_query (query-topology-coherent-slice-mask)
[511.923778] Starting subtest: query-topology-coherent-slice-mask
[511.928474] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[512.050741] [101/133] (511s left) drm_buddy (drm_buddy)
[512.088305] Starting subtest: drm_buddy
[512.092189] Subtest drm_buddy: SKIP (0.001s)
[512.164348] [102/133] (511s left) kms_draw_crc (draw-method-mmap-wc)
[512.268057] Starting subtest: draw-method-mmap-wc
[512.269882] Starting dynamic subtest: xrgb8888-untiled
[512.477476] Dynamic subtest xrgb8888-untiled: SUCCESS (0.210s)
[512.487514] Starting dynamic subtest: rgb565-untiled
[512.688697] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[512.697537] Starting dynamic subtest: xrgb2101010-untiled
[512.888626] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.199s)
[512.897952] Starting dynamic subtest: xbgr16161616f-untiled
[513.088862] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.199s)
[513.097876] Starting dynamic subtest: xrgb8888-xtiled
[513.210960] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[513.220278] Starting dynamic subtest: rgb565-xtiled
[513.333338] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[513.342655] Starting dynamic subtest: xrgb2101010-xtiled
[513.444247] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[513.453324] Starting dynamic subtest: xbgr16161616f-xtiled
[513.566792] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.121s)
[513.575776] Starting dynamic subtest: xrgb8888-4tiled
[513.711228] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[513.719780] Starting dynamic subtest: rgb565-4tiled
[513.856744] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[513.865584] Starting dynamic subtest: xrgb2101010-4tiled
[513.989237] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[513.998111] Starting dynamic subtest: xbgr16161616f-4tiled
[514.167740] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.177s)
[514.169739] Subtest draw-method-mmap-wc: SUCCESS (1.900s)
[514.293546] [103/133] (509s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[514.364208] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[514.433942] [104/133] (509s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[514.532949] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[514.536469] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[514.682827] [105/133] (509s left) kms_joiner (invalid-modeset-ultra-joiner)
[514.778283] Starting subtest: invalid-modeset-ultra-joiner
[514.781743] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[514.870899] [106/133] (509s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[514.984072] Starting subtest: cursorB-vs-flipA-atomic
[514.987752] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[515.142665] [107/133] (509s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[515.245624] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[516.026464] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.781s)
[516.211114] [108/133] (507s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[516.325895] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[516.328108] Starting dynamic subtest: pipe-A-eDP-1
[516.348336] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[516.358974] Starting dynamic subtest: pipe-B-eDP-1
[516.378396] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[516.387841] Starting dynamic subtest: pipe-C-eDP-1
[516.407482] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[516.417436] Starting dynamic subtest: pipe-D-eDP-1
[516.436858] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[516.439143] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.007s)
[518.526231] [109/133] (505s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[518.575260] Starting subtest: single-wait-all-for-submit-available-signaled
[518.577532] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[518.709714] [110/133] (505s left) kms_hdr (bpc-switch-dpms)
[518.804611] Starting subtest: bpc-switch-dpms
[519.892285] Starting dynamic subtest: pipe-A-eDP-1
[524.401851] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.510s)
[524.404038] Subtest bpc-switch-dpms: SUCCESS (5.597s)
[524.553247] [111/133] (499s left) perf (global-sseu-config-invalid)
[524.674157] Starting subtest: global-sseu-config-invalid
[524.678552] Subtest global-sseu-config-invalid: SKIP (0.000s)
[524.717479] [112/133] (499s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[524.821272] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[524.825603] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[524.963424] [113/133] (499s left) i915_pm_rps (thresholds-idle-park)
[525.027454] Starting subtest: thresholds-idle-park
[525.031610] Subtest thresholds-idle-park: SKIP (0.001s)
[525.139425] [114/133] (499s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[525.513732] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[526.359363] [115/133] (498s left) kms_pm_rpm (i2c)
[527.879032] Starting subtest: i2c
[533.311420] Subtest i2c: SUCCESS (5.435s)
[533.414659] [116/133] (491s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[533.473402] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[533.475767] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[533.590316] [117/133] (490s left) gem_eio (wait-wedge-immediate)
[533.817750] Starting subtest: wait-wedge-immediate
[535.669459] Subtest wait-wedge-immediate: SUCCESS (1.851s)
[535.834350] [118/133] (488s left) prime_busy (before)
[535.895238] Starting subtest: before
[535.897632] Starting dynamic subtest: rcs0
[535.927932] Dynamic subtest rcs0: SUCCESS (0.033s)
[535.939735] Starting dynamic subtest: bcs0
[535.968692] Dynamic subtest bcs0: SUCCESS (0.039s)
[535.979939] Starting dynamic subtest: vcs0
[536.008742] Dynamic subtest vcs0: SUCCESS (0.040s)
[536.018526] Starting dynamic subtest: vcs1
[536.049006] Dynamic subtest vcs1: SUCCESS (0.040s)
[536.058630] Starting dynamic subtest: vecs0
[536.091212] Dynamic subtest vecs0: SUCCESS (0.041s)
[536.100807] Starting dynamic subtest: ccs0
[536.131836] Dynamic subtest ccs0: SUCCESS (0.040s)
[536.240097] Subtest before: SUCCESS (0.346s)
[536.323940] [119/133] (488s left) gem_ccs (block-copy-compressed)
[536.390664] Starting subtest: block-copy-compressed
[536.395402] Subtest block-copy-compressed: SKIP (0.000s)
[536.512295] [120/133] (488s left) kms_lease (atomic-implicit-crtc)
[536.603070] Starting subtest: atomic-implicit-crtc
[536.605393] Starting dynamic subtest: pipe-A-eDP-1
[536.616523] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[536.627656] Starting dynamic subtest: pipe-B-eDP-1
[536.638885] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[536.648887] Starting dynamic subtest: pipe-C-eDP-1
[536.659278] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[536.668609] Starting dynamic subtest: pipe-D-eDP-1
[536.679397] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[536.681348] Subtest atomic-implicit-crtc: SUCCESS (0.037s)
[536.788653] [121/133] (487s left) kms_psr (psr-basic)
[536.890600] Starting subtest: psr-basic
[536.892751] Starting dynamic subtest: eDP-1
[538.564147] Dynamic subtest eDP-1: SUCCESS (1.671s)
[538.566047] Subtest psr-basic: SUCCESS (1.672s)
[539.455597] [122/133] (485s left) kms_psr (fbc-psr2-primary-blt)
[539.560106] Starting subtest: fbc-psr2-primary-blt
[539.562395] Starting dynamic subtest: eDP-1
[539.566931] Dynamic subtest eDP-1: SKIP (0.000s)
[539.571338] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[539.680003] [123/133] (485s left) gem_eio (reset-stress)
[539.915276] Starting subtest: reset-stress
[539.917513] Starting dynamic subtest: render
[545.064777] Dynamic subtest render: SUCCESS (5.148s)
[545.077243] Starting dynamic subtest: bsd1
[563.130050] Dynamic subtest bsd1: SUCCESS (18.067s)
[563.139557] Starting dynamic subtest: bsd2
[581.144128] Dynamic subtest bsd2: SUCCESS (18.009s)
[581.160261] Starting dynamic subtest: blt
[581.164212] Dynamic subtest blt: SKIP (0.000s)
[581.173917] Starting dynamic subtest: vebox
[599.183473] Dynamic subtest vebox: SUCCESS (18.034s)
[599.185773] Subtest reset-stress: SUCCESS (59.264s)
[600.674412] [124/133] (424s left) gem_ctx_persistence (idempotent)
[600.731249] Starting subtest: idempotent
[600.733460] Subtest idempotent: SUCCESS (0.000s)
[600.872551] [125/133] (424s left) gem_exec_params (dr1-dirt)
[600.936040] Starting subtest: DR1-dirt
[600.938385] Subtest DR1-dirt: SUCCESS (0.000s)
[601.067183] [126/133] (423s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[601.190184] Starting subtest: short-flip-before-cursor-toggle
[602.108094] Subtest short-flip-before-cursor-toggle: SUCCESS (0.918s)
[602.998543] [127/133] (422s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[603.102233] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[603.104485] Starting dynamic subtest: pipe-A-eDP-1
[603.174184] Dynamic subtest pipe-A-eDP-1: SKIP (0.076s)
[603.184841] Starting dynamic subtest: pipe-B-eDP-1
[604.352295] Dynamic subtest pipe-B-eDP-1: SKIP (1.175s)
[604.356871] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.254s)
[605.577734] [128/133] (419s left) kms_vblank (query-busy-hang)
[605.674791] Starting subtest: query-busy-hang
[605.676999] Starting dynamic subtest: pipe-A-eDP-1
[632.433481] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.750s)
[632.450284] Starting dynamic subtest: pipe-D-eDP-1
[657.467388] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.026s)
[657.469508] Subtest query-busy-hang: SUCCESS (51.779s)
[658.336050] [129/133] (366s left) gem_exec_capture (pi)
[658.403259] Starting subtest: pi
[658.405732] Starting dynamic subtest: rcs0
[663.046219] Dynamic subtest rcs0: SUCCESS (4.643s)
[663.059110] Starting dynamic subtest: bcs0
[667.102278] Dynamic subtest bcs0: SUCCESS (4.055s)
[667.115892] Starting dynamic subtest: vcs0
[671.159896] Dynamic subtest vcs0: SUCCESS (4.057s)
[671.170260] Starting dynamic subtest: vcs1
[675.243769] Dynamic subtest vcs1: SUCCESS (4.083s)
[675.256751] Starting dynamic subtest: vecs0
[679.310793] Dynamic subtest vecs0: SUCCESS (4.066s)
[679.324578] Starting dynamic subtest: ccs0
[683.389067] Dynamic subtest ccs0: SUCCESS (4.077s)
[683.391988] Subtest pi: SUCCESS (24.991s)
[683.487511] [130/133] (341s left) gem_exec_fence (syncobj-signal)
[683.994968] Starting subtest: syncobj-signal
[684.001306] Subtest syncobj-signal: SUCCESS (0.007s)
[685.737166] [131/133] (339s left) gem_ctx_persistence (engines-cleanup)
[685.811171] Starting subtest: engines-cleanup
[685.813485] Starting dynamic subtest: rcs0
[685.904300] Dynamic subtest rcs0: SUCCESS (0.093s)
[685.917690] Starting dynamic subtest: bcs0
[685.959522] Dynamic subtest bcs0: SUCCESS (0.053s)
[685.971406] Starting dynamic subtest: vcs0
[686.007531] Dynamic subtest vcs0: SUCCESS (0.046s)
[686.019358] Starting dynamic subtest: vcs1
[686.074519] Dynamic subtest vcs1: SUCCESS (0.065s)
[686.086929] Starting dynamic subtest: vecs0
[686.132331] Dynamic subtest vecs0: SUCCESS (0.056s)
[686.144558] Starting dynamic subtest: ccs0
[686.160141] Dynamic subtest ccs0: SUCCESS (0.026s)
[686.162394] Subtest engines-cleanup: SUCCESS (0.350s)
[686.303117] [132/133] (338s left) core_auth (basic-auth)
[686.366445] Starting subtest: basic-auth
[686.368804] Subtest basic-auth: SUCCESS (0.001s)
[686.489566] [133/133] (338s left) gem_mmap_gtt (ptrace)
[686.550374] Subtest ptrace: SKIP (0.000s)
[686.618278] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_bad_reloc
results: parsing output: 2/ for test: gem_exec_params
results: parsing output: 3/ for test: kms_plane
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_exec_schedule
results: parsing output: 6/ for test: gem_mmap_gtt
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: gem_exec_whisper
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: kms_content_protection
results: parsing output: 13/ for test: gem_flink_race
results: parsing output: 14/ for test: tools_test
results: parsing output: 15/ for test: kms_cdclk
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: i915_pm_rpm
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_cursor_edge_walk
results: parsing output: 21/ for test: kms_cursor_legacy
results: parsing output: 22/ for test: gem_ctx_engines
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_exec_reloc
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_plane
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: gem_exec_async
results: parsing output: 29/ for test: kms_addfb_basic
results: parsing output: 30/ for test: api_intel_bb
results: parsing output: 31/ for test: gem_watchdog
results: parsing output: 32/ for test: prime_mmap
results: parsing output: 33/ for test: vgem_basic
results: parsing output: 34/ for test: kms_plane_lowres
results: parsing output: 35/ for test: kms_cursor_legacy
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: kms_addfb_basic
results: parsing output: 38/ for test: gem_pxp
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: gem_softpin
results: parsing output: 42/ for test: perf_pmu
results: parsing output: 43/ for test: gem_basic
results: parsing output: 44/ for test: kms_dp_link_training
results: parsing output: 45/ for test: kms_cursor_crc
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_plane_scaling
results: parsing output: 48/ for test: kms_busy
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: gem_exec_balancer
results: parsing output: 54/ for test: i915_drm_fdinfo
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_plane_cursor
results: parsing output: 57/ for test: gem_render_copy_redux
results: parsing output: 58/ for test: kms_flip_scaled_crc
results: parsing output: 59/ for test: gem_render_copy
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: kms_psr2_sf
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: gem_mmap_wc
results: parsing output: 64/ for test: kms_flip_scaled_crc
results: parsing output: 65/ for test: kms_vblank
results: parsing output: 66/ for test: kms_addfb_basic
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: gem_fence_thrash
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_exec_schedule
results: parsing output: 71/ for test: i915_hangman
results: parsing output: 72/ for test: api_intel_allocator
results: parsing output: 73/ for test: syncobj_wait
results: parsing output: 74/ for test: gem_lmem_swapping
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: gem_exec_params
results: parsing output: 77/ for test: kms_pm_dc
results: parsing output: 78/ for test: kms_properties
results: parsing output: 79/ for test: gem_pipe_control_store_loop
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: gem_lmem_swapping
results: parsing output: 84/ for test: kms_atomic
results: parsing output: 85/ for test: sw_sync
results: parsing output: 86/ for test: intel_hwmon
results: parsing output: 87/ for test: kms_cursor_crc
results: parsing output: 88/ for test: kms_color
results: parsing output: 89/ for test: gen9_exec_parse
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: gem_userptr_blits
results: parsing output: 93/ for test: gem_exec_params
results: parsing output: 94/ for test: kms_chamelium_hpd
results: parsing output: 95/ for test: gem_workarounds
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: kms_pipe_b_c_ivb
results: parsing output: 98/ for test: prime_self_import
results: parsing output: 99/ for test: i915_query
results: parsing output: 100/ for test: drm_buddy
results: parsing output: 101/ for test: kms_draw_crc
results: parsing output: 102/ for test: gem_mmap_wc
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_joiner
results: parsing output: 105/ for test: kms_cursor_legacy
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: kms_hdr
results: parsing output: 110/ for test: perf
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: i915_pm_rps
results: parsing output: 113/ for test: kms_chamelium_edid
results: parsing output: 114/ for test: kms_pm_rpm
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: gem_eio
results: parsing output: 117/ for test: prime_busy
results: parsing output: 118/ for test: gem_ccs
results: parsing output: 119/ for test: kms_lease
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: gem_eio
results: parsing output: 123/ for test: gem_ctx_persistence
results: parsing output: 124/ for test: gem_exec_params
results: parsing output: 125/ for test: kms_cursor_legacy
results: parsing output: 126/ for test: kms_psr2_sf
results: parsing output: 127/ for test: kms_vblank
results: parsing output: 128/ for test: gem_exec_capture
results: parsing output: 129/ for test: gem_exec_fence
results: parsing output: 130/ for test: gem_ctx_persistence
results: parsing output: 131/ for test: core_auth
results: parsing output: 132/ for test: gem_mmap_gtt
Done.