[64.067561] Initializing watchdogs
[64.067642]   /dev/watchdog0
[64.083036] [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]
[64.087482] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[64.089820] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[64.093256] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[64.214937] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[64.219157] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[64.321066] [002/133] (960s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[64.420081] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[64.432113] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.011s)
[64.525923] [003/133] (960s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[64.642307] Starting subtest: short-flip-after-cursor-toggle
[65.624992] Subtest short-flip-after-cursor-toggle: SUCCESS (0.979s)
[66.417838] [004/133] (958s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[66.516835] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[67.498039] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.981s)
[67.765780] [005/133] (956s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[67.926058] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[67.935366] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.011s)
[68.117864] [006/133] (956s left) gem_ctx_persistence (hostile)
[68.296762] Starting subtest: hostile
[78.455153] Subtest hostile: SUCCESS (10.146s)
[78.561838] [007/133] (946s left) core_auth (getclient-simple)
[78.607230] Starting subtest: getclient-simple
[78.626776] Subtest getclient-simple: SUCCESS (0.020s)
[78.766810] [008/133] (946s left) vgem_basic (bad-handle)
[78.873570] Starting subtest: bad-handle
[78.875603] Subtest bad-handle: SUCCESS (0.000s)
[78.947633] [FACT vgem_basic (bad-handle)] new: kernel.kmod_is_loaded.vgem: true
[78.950730] [009/133] (946s left) gem_ctx_bad_destroy (invalid-ctx)
[79.003567] Starting subtest: invalid-ctx
[79.005853] Subtest invalid-ctx: SUCCESS (0.000s)
[79.080515] [010/133] (945s left) syncobj_wait (wait-all-interrupted)
[79.131826] Starting subtest: wait-all-interrupted
[79.234213] Subtest wait-all-interrupted: SUCCESS (0.101s)
[79.329488] [011/133] (945s left) kms_flip (basic-flip-vs-wf_vblank)
[79.425395] Starting subtest: basic-flip-vs-wf_vblank
[79.427833] Starting dynamic subtest: A-eDP1
[81.370048] Dynamic subtest A-eDP1: SUCCESS (1.944s)
[81.379498] Starting dynamic subtest: B-eDP1
[83.303383] Dynamic subtest B-eDP1: SUCCESS (1.931s)
[83.313395] Starting dynamic subtest: C-eDP1
[85.238215] Dynamic subtest C-eDP1: SUCCESS (1.918s)
[85.248755] Starting dynamic subtest: D-eDP1
[87.155311] Dynamic subtest D-eDP1: SUCCESS (1.931s)
[87.160045] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.733s)
[88.381580] [012/133] (936s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[88.460148] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[88.464535] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[88.662425] [013/133] (936s left) gem_mmap_gtt (basic-read-write-distinct)
[88.727592] Subtest basic-read-write-distinct: SKIP (0.000s)
[88.787708] [014/133] (936s left) gem_fenced_exec_thrash (too-many-fences)
[88.850343] Subtest too-many-fences: SKIP (0.000s)
[88.933546] [015/133] (936s left) gem_spin_batch (spin-each)
[89.007547] Starting subtest: spin-each
[92.365053] Subtest spin-each: SUCCESS (3.356s)
[92.956803] [016/133] (932s left) kms_plane (plane-position-covered)
[93.045191] Starting subtest: plane-position-covered
[93.591234] Starting dynamic subtest: pipe-A-plane-1
[94.904707] Dynamic subtest pipe-A-plane-1: SUCCESS (1.314s)
[94.913782] Starting dynamic subtest: pipe-A-plane-2
[96.185758] Dynamic subtest pipe-A-plane-2: SUCCESS (1.281s)
[96.195223] Starting dynamic subtest: pipe-A-plane-3
[97.410926] Dynamic subtest pipe-A-plane-3: SUCCESS (1.225s)
[97.419083] Starting dynamic subtest: pipe-A-plane-4
[98.652149] Dynamic subtest pipe-A-plane-4: SUCCESS (1.240s)
[98.661243] Starting dynamic subtest: pipe-A-plane-5
[98.683446] Dynamic subtest pipe-A-plane-5: SUCCESS (0.029s)
[99.829298] Starting dynamic subtest: pipe-B-plane-1
[101.138204] Dynamic subtest pipe-B-plane-1: SUCCESS (1.314s)
[101.147227] Starting dynamic subtest: pipe-B-plane-2
[102.449668] Dynamic subtest pipe-B-plane-2: SUCCESS (1.310s)
[102.457589] Starting dynamic subtest: pipe-B-plane-3
[103.684532] Dynamic subtest pipe-B-plane-3: SUCCESS (1.236s)
[103.693656] Starting dynamic subtest: pipe-B-plane-4
[104.922273] Dynamic subtest pipe-B-plane-4: SUCCESS (1.236s)
[104.931563] Starting dynamic subtest: pipe-B-plane-5
[104.946092] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[104.948208] Subtest plane-position-covered: SUCCESS (11.897s)
[105.718779] [017/133] (919s left) kms_vblank (query-busy-hang)
[105.807384] Starting subtest: query-busy-hang
[105.809684] Starting dynamic subtest: pipe-A-eDP-1
[132.699475] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.890s)
[132.715221] Starting dynamic subtest: pipe-D-eDP-1
[157.661811] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.960s)
[157.663948] Subtest query-busy-hang: SUCCESS (51.853s)
[158.483327] [018/133] (866s left) syncobj_timeline (multi-wait-all-signaled)
[158.543293] Starting subtest: multi-wait-all-signaled
[158.545741] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[158.631677] [019/133] (866s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[158.685099] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[158.792614] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.107s)
[158.870204] [020/133] (866s left) kms_vblank (wait-forked-busy)
[158.973315] Starting subtest: wait-forked-busy
[158.975583] Starting dynamic subtest: pipe-A-eDP-1
[160.866898] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.895s)
[160.880280] Starting dynamic subtest: pipe-D-eDP-1
[163.437798] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.568s)
[163.440186] Subtest wait-forked-busy: SUCCESS (4.467s)
[164.247990] [021/133] (861s left) perf_pmu (semaphore-wait-idle)
[164.288766] Starting subtest: semaphore-wait-idle
[164.290599] Starting dynamic subtest: rcs0
[164.804154] Dynamic subtest rcs0: SUCCESS (0.515s)
[164.814210] Starting dynamic subtest: bcs0
[165.316302] Dynamic subtest bcs0: SUCCESS (0.511s)
[165.325571] Starting dynamic subtest: vcs0
[165.829598] Dynamic subtest vcs0: SUCCESS (0.511s)
[165.840085] Starting dynamic subtest: vcs1
[166.342435] Dynamic subtest vcs1: SUCCESS (0.511s)
[166.352922] Starting dynamic subtest: vecs0
[166.855733] Dynamic subtest vecs0: SUCCESS (0.511s)
[166.866898] Starting dynamic subtest: ccs0
[167.372074] Dynamic subtest ccs0: SUCCESS (0.513s)
[167.375369] Subtest semaphore-wait-idle: SUCCESS (3.083s)
[167.486791] [022/133] (858s left) kms_addfb_basic (unused-handle)
[167.536799] Starting subtest: unused-handle
[167.539165] Subtest unused-handle: SUCCESS (0.000s)
[167.739457] [023/133] (857s left) gen9_exec_parse (batch-zero-length)
[167.807352] Subtest batch-zero-length: SKIP (0.000s)
[167.857332] [024/133] (857s left) gem_eio (throttle)
[168.062958] Starting subtest: throttle
[168.314881] Subtest throttle: SUCCESS (0.251s)
[168.427055] [025/133] (857s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[168.529160] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[168.532597] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[168.629078] [026/133] (857s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[168.725412] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[172.933878] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.209s)
[174.141280] [027/133] (851s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[174.239181] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[174.241167] Starting dynamic subtest: pipe-A-eDP-1
[174.982440] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.737s)
[174.992051] Starting dynamic subtest: pipe-B-eDP-1
[176.776191] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.791s)
[176.785649] Starting dynamic subtest: pipe-C-eDP-1
[178.597073] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.820s)
[178.605306] Starting dynamic subtest: pipe-D-eDP-1
[180.433522] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.835s)
[180.435828] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.189s)
[181.575879] [028/133] (844s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[181.682642] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[181.694801] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[181.771315] [029/133] (844s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[181.878503] Starting subtest: compare-crc-sanitycheck-xr24
[181.880788] Starting dynamic subtest: pipe-A-eDP-1
[182.534705] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.657s)
[182.545238] Starting dynamic subtest: pipe-B-eDP-1
[183.898428] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.362s)
[183.908752] Starting dynamic subtest: pipe-C-eDP-1
[185.145032] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.246s)
[185.154271] Starting dynamic subtest: pipe-D-eDP-1
[186.395133] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.248s)
[186.397415] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.518s)
[187.218373] [030/133] (838s left) dumb_buffer (create-clear)
[187.271231] Starting subtest: create-clear
[221.400836] Subtest create-clear: SUCCESS (34.128s)
[221.500382] [031/133] (804s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[221.603165] Starting subtest: fbc-psr2-sprite-mmap-gtt
[221.605430] Starting dynamic subtest: eDP-1
[221.609696] Dynamic subtest eDP-1: SKIP (0.000s)
[221.613711] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.002s)
[221.684483] [032/133] (804s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[221.784936] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[221.802854] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.016s)
[221.878099] [033/133] (804s left) gem_exec_schedule (pi-ringfull)
[222.057935] Starting subtest: pi-ringfull
[222.060220] Starting dynamic subtest: rcs0
[222.088319] Dynamic subtest rcs0: SUCCESS (0.032s)
[222.100809] Starting dynamic subtest: bcs0
[222.117180] Dynamic subtest bcs0: SUCCESS (0.028s)
[222.129506] Starting dynamic subtest: vcs0
[222.146456] Dynamic subtest vcs0: SUCCESS (0.029s)
[222.158249] Starting dynamic subtest: vcs1
[222.174825] Dynamic subtest vcs1: SUCCESS (0.028s)
[222.186915] Starting dynamic subtest: vecs0
[222.202629] Dynamic subtest vecs0: SUCCESS (0.027s)
[222.215781] Starting dynamic subtest: ccs0
[222.230066] Dynamic subtest ccs0: SUCCESS (0.027s)
[222.232193] Subtest pi-ringfull: SUCCESS (0.175s)
[222.467898] [034/133] (803s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[222.561220] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[222.565242] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[222.666861] [035/133] (803s left) kms_cursor_edge_walk (64x64-right-edge)
[222.753151] Starting subtest: 64x64-right-edge
[222.755312] Starting dynamic subtest: pipe-A-eDP-1
[226.174913] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.422s)
[226.184706] Starting dynamic subtest: pipe-D-eDP-1
[229.307047] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.131s)
[229.309276] Subtest 64x64-right-edge: SUCCESS (6.556s)
[230.103148] [036/133] (796s left) gem_mmap_wc (bad-size)
[230.163103] Subtest bad-size: SKIP (0.000s)
[230.227204] [037/133] (795s left) api_intel_allocator (gem-pool)
[230.274807] Starting subtest: gem-pool
[230.281088] Subtest gem-pool: SUCCESS (0.008s)
[230.389979] [038/133] (795s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[230.492070] Starting subtest: pr-plane-move-sf-dmg-area
[230.496294] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[230.563135] [039/133] (795s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[230.672659] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[235.146964] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.478s)
[236.318604] [040/133] (790s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[236.428033] Starting subtest: psr-rgb101010-draw-blt
[243.714149] Subtest psr-rgb101010-draw-blt: SUCCESS (7.290s)
[243.831219] [041/133] (782s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[243.961988] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[251.022942] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.063s)
[251.158677] [042/133] (775s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[251.260333] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[251.262590] Starting dynamic subtest: pipe-A
[251.323575] Dynamic subtest pipe-A: SUCCESS (0.065s)
[251.332468] Starting dynamic subtest: pipe-B
[252.478345] Dynamic subtest pipe-B: SUCCESS (1.153s)
[252.488145] Starting dynamic subtest: pipe-C
[253.603156] Dynamic subtest pipe-C: SUCCESS (1.123s)
[253.611823] Starting dynamic subtest: pipe-D
[254.728485] Dynamic subtest pipe-D: SUCCESS (1.124s)
[254.730827] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.471s)
[255.881126] [043/133] (770s left) gem_gpgpu_fill (basic)
[255.933787] Starting subtest: basic
[255.936080] Starting dynamic subtest: smem
[255.940720] Dynamic subtest smem: SUCCESS (0.007s)
[255.943019] Subtest basic: SUCCESS (0.008s)
[256.068138] [044/133] (770s left) kms_atomic_interruptible (universal-setplane-primary)
[256.162772] Starting subtest: universal-setplane-primary
[256.165024] Starting dynamic subtest: pipe-A-eDP-1
[263.642321] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.478s)
[263.644565] Subtest universal-setplane-primary: SUCCESS (7.479s)
[264.468738] [045/133] (762s left) gem_exec_fence (long-history)
[264.881920] Starting subtest: long-history
[271.625243] Subtest long-history: SUCCESS (6.744s)
[272.089790] [046/133] (754s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[272.188695] Starting subtest: primary-y-tiled-reflect-x-90
[272.193070] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[272.260320] [047/133] (754s left) gem_close_race (multigpu-basic-process)
[272.326140] Starting subtest: multigpu-basic-process
[272.330840] Subtest multigpu-basic-process: SKIP (0.000s)
[272.572337] [048/133] (754s left) kms_draw_crc (draw-method-pwrite)
[272.665387] Starting subtest: draw-method-pwrite
[272.667749] Starting dynamic subtest: xrgb8888-untiled
[273.242446] Dynamic subtest xrgb8888-untiled: SUCCESS (0.578s)
[273.251988] Starting dynamic subtest: rgb565-untiled
[273.686755] Dynamic subtest rgb565-untiled: SUCCESS (0.444s)
[273.696214] Starting dynamic subtest: xrgb2101010-untiled
[274.233161] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.544s)
[274.242102] Starting dynamic subtest: xbgr16161616f-untiled
[274.986843] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.755s)
[274.998197] Starting dynamic subtest: xrgb8888-xtiled
[276.765454] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.775s)
[276.774589] Starting dynamic subtest: rgb565-xtiled
[277.843826] Dynamic subtest rgb565-xtiled: SUCCESS (1.077s)
[277.852941] Starting dynamic subtest: xrgb2101010-xtiled
[279.609152] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.766s)
[279.622896] Starting dynamic subtest: xbgr16161616f-xtiled
[282.898582] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.288s)
[282.907926] Starting dynamic subtest: xrgb8888-4tiled
[283.987798] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.087s)
[283.997279] Starting dynamic subtest: rgb565-4tiled
[284.554092] Dynamic subtest rgb565-4tiled: SUCCESS (0.566s)
[284.563139] Starting dynamic subtest: xrgb2101010-4tiled
[285.656650] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.099s)
[285.665766] Starting dynamic subtest: xbgr16161616f-4tiled
[288.634088] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.977s)
[288.636222] Subtest draw-method-pwrite: SUCCESS (15.968s)
[288.726381] [049/133] (737s left) gem_exec_schedule (fairslice-all)
[288.797058] Starting subtest: fairslice-all
[290.860923] Subtest fairslice-all: SUCCESS (2.068s)
[291.165246] [050/133] (735s left) gem_ctx_param (invalid-param-get)
[291.231060] Starting subtest: invalid-param-get
[291.233411] Subtest invalid-param-get: SUCCESS (0.002s)
[291.340943] [051/133] (735s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[293.075363] Starting subtest: modeset-lpsp-stress-no-wait
[303.047483] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.977s)
[303.125316] [052/133] (723s left) i915_drm_fdinfo (virtual-idle)
[303.170444] Starting subtest: virtual-idle
[306.214208] Subtest virtual-idle: SUCCESS (3.043s)
[306.302213] [053/133] (720s left) gem_userptr_blits (set-cache-level)
[306.367670] Starting subtest: set-cache-level
[306.372029] Subtest set-cache-level: SKIP (0.000s)
[306.490320] [054/133] (720s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[306.584862] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[306.587213] Starting dynamic subtest: pipe-A-eDP-1
[306.610163] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[306.621236] Starting dynamic subtest: pipe-B-eDP-1
[306.643077] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[306.652857] Starting dynamic subtest: pipe-C-eDP-1
[306.674617] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[306.683753] Starting dynamic subtest: pipe-D-eDP-1
[306.705112] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[306.709281] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.004s)
[308.783770] [055/133] (718s left) gem_eio (wait-10ms)
[309.026071] Starting subtest: wait-10ms
[309.389209] Subtest wait-10ms: SUCCESS (0.362s)
[309.531142] [056/133] (717s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[309.630507] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[319.083994] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.455s)
[319.221013] [057/133] (707s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[319.325845] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[320.305684] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.980s)
[320.427369] [058/133] (706s left) perf (i915-ref-count)
[320.509484] Starting subtest: i915-ref-count
[320.580089] Subtest i915-ref-count: SUCCESS (0.069s)
[320.641196] [059/133] (706s left) gem_tiled_blits (interruptible)
[320.694687] Subtest interruptible: SKIP (0.000s)
[320.786127] [060/133] (706s left) syncobj_timeline (wait-all-snapshot)
[320.843920] Starting subtest: wait-all-snapshot
[320.924627] Subtest wait-all-snapshot: SUCCESS (0.082s)
[321.003371] [061/133] (706s left) perf_pmu (busy-double-start)
[321.042191] Starting subtest: busy-double-start
[321.043799] Starting dynamic subtest: rcs0
[324.679303] Dynamic subtest rcs0: FAIL (3.580s)
[324.689356] Starting dynamic subtest: bcs0
[328.187788] Dynamic subtest bcs0: SUCCESS (3.565s)
[328.197497] Starting dynamic subtest: vcs0
[332.473599] Dynamic subtest vcs0: SUCCESS (4.284s)
[332.484745] Starting dynamic subtest: vcs1
[336.402671] Dynamic subtest vcs1: SUCCESS (3.927s)
[336.413921] Starting dynamic subtest: vecs0
[340.458932] Dynamic subtest vecs0: SUCCESS (4.054s)
[340.470507] Starting dynamic subtest: ccs0
[344.093956] Dynamic subtest ccs0: FAIL (3.566s)
[344.096190] Subtest busy-double-start: FAIL (22.986s)
[344.161542] [062/133] (683s left) kms_lease (lease-unleased-crtc)
[344.273750] Starting subtest: lease-unleased-crtc
[344.275546] Starting dynamic subtest: pipe-A-eDP-1
[344.566995] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s)
[344.578337] Starting dynamic subtest: pipe-B-eDP-1
[345.357833] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.790s)
[345.369113] Starting dynamic subtest: pipe-C-eDP-1
[345.371261] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[345.379708] Starting dynamic subtest: pipe-D-eDP-1
[345.381647] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[345.383584] Subtest lease-unleased-crtc: SUCCESS (1.096s)
[345.725503] [063/133] (681s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[345.822223] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[345.824490] Starting dynamic subtest: pipe-A-eDP-1
[345.846292] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[345.857051] Starting dynamic subtest: pipe-B-eDP-1
[345.877208] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[345.885283] Starting dynamic subtest: pipe-C-eDP-1
[345.905922] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[345.914118] Starting dynamic subtest: pipe-D-eDP-1
[345.935304] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[345.939686] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[348.009416] [064/133] (679s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[348.125857] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[355.032557] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.908s)
[355.186767] [065/133] (672s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[355.294683] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[355.320565] Starting dynamic subtest: pipe-A-plane-0
[355.931175] Dynamic subtest pipe-A-plane-0: SUCCESS (0.611s)
[355.940568] Starting dynamic subtest: pipe-A-plane-3
[356.386195] Dynamic subtest pipe-A-plane-3: SUCCESS (0.455s)
[357.459096] Starting dynamic subtest: pipe-B-plane-0
[358.140764] Dynamic subtest pipe-B-plane-0: SUCCESS (0.689s)
[358.151712] Starting dynamic subtest: pipe-B-plane-3
[358.573520] Dynamic subtest pipe-B-plane-3: SUCCESS (0.432s)
[358.884130] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.590s)
[359.728464] [066/133] (667s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[359.825209] Starting subtest: plane-use-after-nonblocking-unbind
[359.827469] Starting dynamic subtest: pipe-A-eDP-1
[359.885302] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[360.186710] Starting dynamic subtest: pipe-B-eDP-1
[361.026776] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.850s)
[361.313436] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.489s)
[362.189233] [067/133] (665s left) gem_tiled_fence_blits (basic)
[362.256435] Subtest basic: SKIP (0.000s)
[362.325679] [068/133] (665s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[362.376100] Starting subtest: invalid-multi-wait-unsubmitted
[362.378415] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[362.466934] [069/133] (665s left) i915_query (test-query-geometry-subslices)
[362.532613] Starting subtest: test-query-geometry-subslices
[362.534585] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[362.645732] [070/133] (664s left) kms_cursor_legacy (forked-move)
[362.752694] Starting subtest: forked-move
[362.755039] Starting dynamic subtest: pipe-A
[368.228160] Dynamic subtest pipe-A: SUCCESS (5.471s)
[368.239992] Starting dynamic subtest: pipe-B
[373.722529] Dynamic subtest pipe-B: SUCCESS (5.491s)
[373.735828] Starting dynamic subtest: pipe-C
[379.195102] Dynamic subtest pipe-C: SUCCESS (5.470s)
[379.207847] Starting dynamic subtest: pipe-D
[384.686990] Dynamic subtest pipe-D: SUCCESS (5.489s)
[384.702027] Starting dynamic subtest: all-pipes
[390.223816] Dynamic subtest all-pipes: SUCCESS (5.534s)
[390.226266] Subtest forked-move: SUCCESS (27.468s)
[390.398393] [071/133] (637s left) kms_busy (extended-pageflip-hang-newfb)
[390.525402] Starting subtest: extended-pageflip-hang-newfb
[390.527693] Starting dynamic subtest: pipe-A
[416.677624] Dynamic subtest pipe-A: SUCCESS (26.150s)
[416.687246] Starting dynamic subtest: pipe-D
[441.720407] Dynamic subtest pipe-D: SUCCESS (25.038s)
[441.722743] Subtest extended-pageflip-hang-newfb: SUCCESS (51.193s)
[442.565824] [072/133] (585s left) gem_tiling_max_stride
[442.693537] [073/133] (585s left) kms_flip (2x-flip-vs-wf_vblank)
[442.780124] Starting subtest: 2x-flip-vs-wf_vblank
[442.791660] Subtest 2x-flip-vs-wf_vblank: SKIP (0.011s)
[442.886375] [074/133] (584s left) vgem_basic (dmabuf-export)
[442.926248] Starting subtest: dmabuf-export
[442.964683] Subtest dmabuf-export: SUCCESS (0.042s)
[443.095580] [075/133] (584s left) kms_psr (psr-cursor-mmap-cpu)
[443.180285] Starting subtest: psr-cursor-mmap-cpu
[443.182500] Starting dynamic subtest: eDP-1
[444.869894] Dynamic subtest eDP-1: SUCCESS (1.689s)
[444.872226] Subtest psr-cursor-mmap-cpu: SUCCESS (1.690s)
[445.737902] [076/133] (582s left) gem_mmap_gtt (basic-small-bo-tiledx)
[445.802506] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[445.862595] [077/133] (582s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[445.957780] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[445.961800] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[446.065358] [078/133] (581s left) kms_rotation_crc (primary-rotation-90)
[446.164612] Starting subtest: primary-rotation-90
[446.169101] Subtest primary-rotation-90: SKIP (0.001s)
[446.248446] [079/133] (581s left) gem_pxp (reject-modify-context-protection-on)
[446.378828] Starting subtest: reject-modify-context-protection-on
[446.381185] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[446.499404] [080/133] (581s left) kms_psr (fbc-pr-primary-page-flip)
[446.597744] Starting subtest: fbc-pr-primary-page-flip
[446.602109] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[446.666456] [081/133] (581s left) perf_pmu (busy-idle)
[446.708053] Starting subtest: busy-idle
[446.709898] Starting dynamic subtest: rcs0
[447.417048] Dynamic subtest rcs0: SUCCESS (0.708s)
[447.429297] Starting dynamic subtest: bcs0
[448.090028] Dynamic subtest bcs0: SUCCESS (0.671s)
[448.102330] Starting dynamic subtest: vcs0
[449.941061] Dynamic subtest vcs0: SUCCESS (1.847s)
[449.952602] Starting dynamic subtest: vcs1
[451.924507] Dynamic subtest vcs1: SUCCESS (1.981s)
[451.936932] Starting dynamic subtest: vecs0
[453.909377] Dynamic subtest vecs0: SUCCESS (1.981s)
[453.921057] Starting dynamic subtest: ccs0
[454.578351] Dynamic subtest ccs0: SUCCESS (0.668s)
[454.581041] Subtest busy-idle: SUCCESS (7.871s)
[454.670564] [082/133] (573s left) gem_exec_params (no-blt)
[454.726688] Starting subtest: no-blt
[454.731340] Subtest no-blt: SUCCESS (0.004s)
[454.871801] [083/133] (573s left) gem_ctx_shared (exec-single-timeline)
[454.936525] Starting subtest: exec-single-timeline
[454.938853] Starting dynamic subtest: rcs0
[455.986164] Dynamic subtest rcs0: SUCCESS (1.048s)
[456.003851] Starting dynamic subtest: bcs0
[457.074814] Dynamic subtest bcs0: SUCCESS (1.084s)
[457.086904] Starting dynamic subtest: vcs0
[458.162595] Dynamic subtest vcs0: SUCCESS (1.086s)
[458.174731] Starting dynamic subtest: vcs1
[459.251748] Dynamic subtest vcs1: SUCCESS (1.085s)
[459.267516] Starting dynamic subtest: vecs0
[460.337637] Dynamic subtest vecs0: SUCCESS (1.084s)
[460.348373] Starting dynamic subtest: ccs0
[461.426849] Dynamic subtest ccs0: SUCCESS (1.088s)
[461.429960] Subtest exec-single-timeline: SUCCESS (6.490s)
[461.617998] [084/133] (566s left) intel_hwmon (hwmon-write)
[461.676061] Subtest hwmon-write: SKIP (0.000s)
[461.734818] [085/133] (566s left) gem_exec_balancer (parallel-out-fence)
[462.001042] Starting subtest: parallel-out-fence
[463.247774] Subtest parallel-out-fence: SUCCESS (1.247s)
[463.363783] [086/133] (564s left) i915_drm_fdinfo (memory-info-purgeable)
[463.406956] Starting subtest: memory-info-purgeable
[463.409248] Starting dynamic subtest: smem0
[465.973453] Dynamic subtest smem0: SUCCESS (2.568s)
[465.975307] Subtest memory-info-purgeable: SUCCESS (2.569s)
[466.047432] [087/133] (562s left) gem_basic (multigpu-create-close)
[466.101189] Starting subtest: multigpu-create-close
[466.104762] Subtest multigpu-create-close: SKIP (0.000s)
[466.210821] [088/133] (562s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[466.315928] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[466.319643] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[466.407423] [089/133] (562s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[466.733105] Starting subtest: cursor-rapid-movement-max-size
[466.738513] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[466.855969] [090/133] (561s left) perf_pmu (all-busy-check-all)
[466.897524] Starting subtest: all-busy-check-all
[468.885377] Subtest all-busy-check-all: SUCCESS (1.985s)
[468.986509] [091/133] (559s left) gem_mmap_gtt (basic-small-bo-tiledy)
[469.048713] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[469.110083] [092/133] (559s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[469.221247] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[472.950705] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.733s)
[474.158671] [093/133] (554s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[474.255270] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[474.259186] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[474.354954] [094/133] (554s left) kms_properties (connector-properties-atomic)
[474.445683] Starting subtest: connector-properties-atomic
[474.447549] Starting dynamic subtest: pipe-A-eDP-1
[482.351080] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.905s)
[482.361560] Starting dynamic subtest: pipe-None-DP-1
[482.366464] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[482.375226] Starting dynamic subtest: pipe-None-HDMI-A-1
[482.379813] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[482.388169] Starting dynamic subtest: pipe-None-DP-2
[482.392271] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[482.401288] Starting dynamic subtest: pipe-None-HDMI-A-2
[482.405966] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[482.414788] Starting dynamic subtest: pipe-None-DP-3
[482.419146] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[482.427865] Starting dynamic subtest: pipe-None-DP-4
[482.432169] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[482.434362] Subtest connector-properties-atomic: SUCCESS (7.917s)
[483.228126] [095/133] (545s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[483.324952] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[483.327242] Starting dynamic subtest: pipe-A-eDP-1
[483.349261] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[483.360067] Starting dynamic subtest: pipe-B-eDP-1
[483.381895] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[483.390629] Starting dynamic subtest: pipe-C-eDP-1
[483.412381] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[483.420719] Starting dynamic subtest: pipe-D-eDP-1
[483.442827] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[483.447234] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[485.506479] [096/133] (543s left) kms_color (ctm-negative)
[485.614165] Starting subtest: ctm-negative
[485.616305] Starting dynamic subtest: pipe-A-eDP-1
[486.313772] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.699s)
[486.323586] Starting dynamic subtest: pipe-B-eDP-1
[487.728466] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.415s)
[487.738850] Starting dynamic subtest: pipe-C-eDP-1
[489.103873] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.373s)
[489.115784] Starting dynamic subtest: pipe-D-eDP-1
[490.429645] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.324s)
[490.431946] Subtest ctm-negative: SUCCESS (4.816s)
[491.232347] [097/133] (537s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[491.322220] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[491.324428] Starting dynamic subtest: pipe-A-default-mode
[494.090479] Dynamic subtest pipe-A-default-mode: SUCCESS (2.769s)
[494.092873] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.770s)
[494.932377] [098/133] (533s left) syncobj_eventfd (binary-wait)
[494.993640] Starting subtest: binary-wait
[495.001960] Subtest binary-wait: SUCCESS (0.010s)
[495.114724] [099/133] (533s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[495.234201] Starting subtest: y-tiled-16bpp-rotate-0
[495.238375] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[495.335284] [100/133] (533s left) i915_pm_rpm (system-suspend-devices)
[497.062632] Starting subtest: system-suspend-devices
[504.833693] Subtest system-suspend-devices: SUCCESS (7.773s)
[505.235221] [101/133] (523s left) gem_userptr_blits (process-exit)
[505.307662] Starting subtest: process-exit
[505.314139] Subtest process-exit: SUCCESS (0.008s)
[505.425857] [102/133] (523s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[505.812841] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[506.619656] [103/133] (522s left) kms_rotation_crc (multiplane-rotation)
[506.717247] Starting subtest: multiplane-rotation
[524.144442] Subtest multiplane-rotation: SUCCESS (17.428s)
[524.274079] [104/133] (504s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[524.380054] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[524.381857] Starting dynamic subtest: pipe-A-eDP-1
[530.228753] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.847s)
[530.241932] Starting dynamic subtest: pipe-B-eDP-1
[536.871947] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.644s)
[536.874340] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.494s)
[537.757869] [105/133] (491s left) gem_exec_schedule (smoketest)
[537.940411] Starting subtest: smoketest
[537.942756] Starting dynamic subtest: rcs0
[543.483519] Dynamic subtest rcs0: SUCCESS (5.496s)
[543.496347] Starting dynamic subtest: bcs0
[549.005188] Dynamic subtest bcs0: SUCCESS (5.525s)
[549.021628] Starting dynamic subtest: vcs0
[554.503014] Dynamic subtest vcs0: SUCCESS (5.493s)
[554.514143] Starting dynamic subtest: vcs1
[560.005433] Dynamic subtest vcs1: SUCCESS (5.498s)
[560.017162] Starting dynamic subtest: vecs0
[565.489426] Dynamic subtest vecs0: SUCCESS (5.488s)
[565.504723] Starting dynamic subtest: ccs0
[570.985470] Dynamic subtest ccs0: SUCCESS (5.487s)
[570.987547] Subtest smoketest: SUCCESS (32.995s)
[571.127039] [106/133] (458s left) gem_ctx_param (invalid-get-ringsize)
[571.188810] Starting subtest: invalid-get-ringsize
[571.191179] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[571.312656] [107/133] (457s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[571.395824] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[571.397999] Starting dynamic subtest: pipe-A-eDP-1
[571.420070] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[571.432388] Starting dynamic subtest: pipe-B-eDP-1
[571.453178] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[571.462841] Starting dynamic subtest: pipe-C-eDP-1
[571.483877] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[571.493299] Starting dynamic subtest: pipe-D-eDP-1
[571.514680] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[571.518769] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[573.632090] [108/133] (455s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[573.739296] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[574.363678] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.626s)
[574.537290] [109/133] (454s left) kms_psr (pr-primary-render)
[574.639235] Starting subtest: pr-primary-render
[574.643545] Subtest pr-primary-render: SKIP (0.000s)
[574.723460] [110/133] (454s left) kms_prop_blob (invalid-set-prop-any)
[574.782453] Starting subtest: invalid-set-prop-any
[574.784377] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[574.874867] [111/133] (454s left) kms_async_flips (test-time-stamp-atomic)
[574.959918] Starting subtest: test-time-stamp-atomic
[575.347764] Starting dynamic subtest: pipe-A-eDP-1
[576.133517] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.783s)
[576.504103] Starting dynamic subtest: pipe-B-eDP-1
[577.255695] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.756s)
[577.626429] Starting dynamic subtest: pipe-C-eDP-1
[578.391268] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.770s)
[578.755667] Starting dynamic subtest: pipe-D-eDP-1
[579.516702] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.768s)
[579.519199] Subtest test-time-stamp-atomic: SUCCESS (4.557s)
[580.680856] [112/133] (448s left) kms_flip (basic-flip-vs-dpms)
[580.783733] Starting subtest: basic-flip-vs-dpms
[580.786138] Starting dynamic subtest: A-eDP1
[583.375743] Dynamic subtest A-eDP1: SUCCESS (2.589s)
[583.386469] Starting dynamic subtest: B-eDP1
[585.581921] Dynamic subtest B-eDP1: SUCCESS (2.205s)
[585.594074] Starting dynamic subtest: C-eDP1
[587.718045] Dynamic subtest C-eDP1: SUCCESS (2.136s)
[587.734918] Starting dynamic subtest: D-eDP1
[589.779313] Dynamic subtest D-eDP1: SUCCESS (2.060s)
[589.781732] Subtest basic-flip-vs-dpms: SUCCESS (8.999s)
[590.598751] [113/133] (438s left) kms_pm_backlight (brightness-with-dpms)
[590.690064] Starting subtest: brightness-with-dpms
[590.775988] Starting dynamic subtest: eDP-1
[593.219794] Dynamic subtest eDP-1: SUCCESS (2.446s)
[593.222244] Subtest brightness-with-dpms: SUCCESS (2.532s)
[594.060587] [114/133] (435s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[594.163757] Starting subtest: x-tiled-8bpp-rotate-0
[595.356694] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.194s)
[595.513655] [115/133] (434s left) gem_ctx_param (invalid-ctx-set)
[595.564452] Starting subtest: invalid-ctx-set
[595.566471] Subtest invalid-ctx-set: SUCCESS (0.001s)
[595.682424] [116/133] (433s left) kms_content_protection (dp-mst-type-1)
[595.838489] Starting subtest: dp-mst-type-1
[595.842286] Subtest dp-mst-type-1: SKIP (0.000s)
[595.964563] [117/133] (433s left) gem_mmap_gtt (cpuset-big-copy)
[596.032970] Subtest cpuset-big-copy: SKIP (0.000s)
[596.098283] [118/133] (433s left) gem_mmap_offset (close-race)
[596.148447] Starting subtest: close-race
[616.264754] Subtest close-race: SUCCESS (20.114s)
[616.414783] [119/133] (413s left) kms_chamelium_hpd (dp-hpd-fast)
[616.807720] Subtest dp-hpd-fast: SKIP (0.000s)
[617.590118] [120/133] (412s left) kms_invalid_mode (bad-vtotal)
[617.692658] Starting subtest: bad-vtotal
[617.695084] Starting dynamic subtest: pipe-A-eDP-1
[617.978031] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[617.988646] Starting dynamic subtest: pipe-B-eDP-1
[617.990617] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[618.000514] Starting dynamic subtest: pipe-C-eDP-1
[618.002869] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[618.012662] Starting dynamic subtest: pipe-D-eDP-1
[618.015089] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[618.017444] Subtest bad-vtotal: SUCCESS (0.292s)
[618.842637] [121/133] (410s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[618.936683] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[618.941200] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[619.028799] [122/133] (410s left) kms_plane_lowres (tiling-yf)
[619.117287] Starting subtest: tiling-yf
[619.121580] Subtest tiling-yf: SKIP (0.000s)
[619.190664] [123/133] (410s left) gem_exec_flush (basic-wb-ro-default)
[619.247240] Starting subtest: basic-wb-ro-default
[624.705481] Subtest basic-wb-ro-default: SUCCESS (5.458s)
[624.910471] [124/133] (404s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[625.021429] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[625.025878] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[625.116132] [125/133] (404s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[625.217065] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[625.219364] Starting dynamic subtest: pipe-A-default-mode
[626.404725] Dynamic subtest pipe-A-default-mode: SKIP (1.186s)
[626.409344] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.188s)
[626.553411] [126/133] (403s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[626.651521] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[633.376234] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.728s)
[633.524353] [127/133] (396s left) gem_exec_store (pages)
[633.577709] Starting subtest: pages
[633.579929] Starting dynamic subtest: rcs0
[633.649415] Dynamic subtest rcs0: SUCCESS (0.073s)
[633.661999] Starting dynamic subtest: bcs0
[633.717205] Dynamic subtest bcs0: SUCCESS (0.067s)
[633.728131] Starting dynamic subtest: vcs0
[633.789677] Dynamic subtest vcs0: SUCCESS (0.070s)
[633.802135] Starting dynamic subtest: vcs1
[633.855061] Dynamic subtest vcs1: SUCCESS (0.065s)
[633.864806] Starting dynamic subtest: vecs0
[633.919980] Dynamic subtest vecs0: SUCCESS (0.064s)
[633.931124] Starting dynamic subtest: ccs0
[633.988298] Dynamic subtest ccs0: SUCCESS (0.067s)
[633.990700] Subtest pages: SUCCESS (0.413s)
[634.174834] [128/133] (395s left) gem_exec_create (basic)
[634.230623] Starting subtest: basic
[634.232805] Starting dynamic subtest: smem
[637.908697] Dynamic subtest smem: SUCCESS (3.675s)
[637.911881] Subtest basic: SUCCESS (3.677s)
[638.103167] [129/133] (392s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[638.226034] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[638.230438] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[638.366052] [130/133] (391s left) gem_exec_balancer (bonded-dual)
[638.439433] Starting subtest: bonded-dual
[638.443618] Subtest bonded-dual: SKIP (0.000s)
[638.735168] [131/133] (391s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[638.830891] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[645.625294] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.798s)
[645.738524] [132/133] (384s left) kms_cursor_crc (cursor-offscreen-32x10)
[645.889827] Starting subtest: cursor-offscreen-32x10
[645.934445] Subtest cursor-offscreen-32x10: SKIP (0.043s)
[646.203462] [133/133] (384s left) gem_exec_reloc (basic-wc)
[646.274398] Subtest basic-wc: SKIP (0.000s)
[646.345645] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_flip
results: parsing output: 2/ for test: kms_cursor_legacy
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: gem_ctx_persistence
results: parsing output: 6/ for test: core_auth
results: parsing output: 7/ for test: vgem_basic
results: parsing output: 8/ for test: gem_ctx_bad_destroy
results: parsing output: 9/ for test: syncobj_wait
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: gem_render_copy
results: parsing output: 12/ for test: gem_mmap_gtt
results: parsing output: 13/ for test: gem_fenced_exec_thrash
results: parsing output: 14/ for test: gem_spin_batch
results: parsing output: 15/ for test: kms_plane
results: parsing output: 16/ for test: kms_vblank
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: kms_vblank
results: parsing output: 20/ for test: perf_pmu
results: parsing output: 21/ for test: kms_addfb_basic
results: parsing output: 22/ for test: gen9_exec_parse
results: parsing output: 23/ for test: gem_eio
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: kms_pipe_crc_basic
results: parsing output: 29/ for test: dumb_buffer
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: gem_exec_schedule
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_cursor_edge_walk
results: parsing output: 35/ for test: gem_mmap_wc
results: parsing output: 36/ for test: api_intel_allocator
results: parsing output: 37/ for test: kms_psr2_sf
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_plane_scaling
results: parsing output: 42/ for test: gem_gpgpu_fill
results: parsing output: 43/ for test: kms_atomic_interruptible
results: parsing output: 44/ for test: gem_exec_fence
results: parsing output: 45/ for test: kms_rotation_crc
results: parsing output: 46/ for test: gem_close_race
results: parsing output: 47/ for test: kms_draw_crc
results: parsing output: 48/ for test: gem_exec_schedule
results: parsing output: 49/ for test: gem_ctx_param
results: parsing output: 50/ for test: kms_pm_rpm
results: parsing output: 51/ for test: i915_drm_fdinfo
results: parsing output: 52/ for test: gem_userptr_blits
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: gem_eio
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: perf
results: parsing output: 58/ for test: gem_tiled_blits
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: perf_pmu
results: parsing output: 61/ for test: kms_lease
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_plane
results: parsing output: 65/ for test: kms_atomic_transition
results: parsing output: 66/ for test: gem_tiled_fence_blits
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: i915_query
results: parsing output: 69/ for test: kms_cursor_legacy
results: parsing output: 70/ for test: kms_busy
results: parsing output: 71/ for test: gem_tiling_max_stride
results: parsing output: 72/ for test: kms_flip
results: parsing output: 73/ for test: vgem_basic
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: gem_mmap_gtt
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_rotation_crc
results: parsing output: 78/ for test: gem_pxp
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: perf_pmu
results: parsing output: 81/ for test: gem_exec_params
results: parsing output: 82/ for test: gem_ctx_shared
results: parsing output: 83/ for test: intel_hwmon
results: parsing output: 84/ for test: gem_exec_balancer
results: parsing output: 85/ for test: i915_drm_fdinfo
results: parsing output: 86/ for test: gem_basic
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_cursor_crc
results: parsing output: 89/ for test: perf_pmu
results: parsing output: 90/ for test: gem_mmap_gtt
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_properties
results: parsing output: 94/ for test: kms_ccs
results: parsing output: 95/ for test: kms_color
results: parsing output: 96/ for test: kms_flip_scaled_crc
results: parsing output: 97/ for test: syncobj_eventfd
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: i915_pm_rpm
results: parsing output: 100/ for test: gem_userptr_blits
results: parsing output: 101/ for test: kms_chamelium_edid
results: parsing output: 102/ for test: kms_rotation_crc
results: parsing output: 103/ for test: kms_psr2_sf
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: gem_ctx_param
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: kms_prop_blob
results: parsing output: 110/ for test: kms_async_flips
results: parsing output: 111/ for test: kms_flip
results: parsing output: 112/ for test: kms_pm_backlight
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: gem_ctx_param
results: parsing output: 115/ for test: kms_content_protection
results: parsing output: 116/ for test: gem_mmap_gtt
results: parsing output: 117/ for test: gem_mmap_offset
results: parsing output: 118/ for test: kms_chamelium_hpd
results: parsing output: 119/ for test: kms_invalid_mode
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_plane_lowres
results: parsing output: 122/ for test: gem_exec_flush
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_flip_scaled_crc
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_exec_store
results: parsing output: 127/ for test: gem_exec_create
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: gem_exec_balancer
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_cursor_crc
results: parsing output: 132/ for test: gem_exec_reloc
Done.