[59.848790] Initializing watchdogs
[59.848855]   /dev/watchdog0
[59.868065] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[59.877336] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[59.881300] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.885795] [001/133] (960s left) gem_spin_batch (legacy-resubmit-new)
[60.048387] Starting subtest: legacy-resubmit-new
[60.049235] Starting dynamic subtest: default
[60.076236] Dynamic subtest default: SUCCESS (0.027s)
[60.083520] Starting dynamic subtest: render
[60.084433] Dynamic subtest render: SUCCESS (0.004s)
[60.092306] Starting dynamic subtest: bsd
[60.093259] Dynamic subtest bsd: SUCCESS (0.006s)
[60.100630] Starting dynamic subtest: bsd1
[60.101506] Dynamic subtest bsd1: SUCCESS (0.004s)
[60.109229] Starting dynamic subtest: bsd2
[60.110236] Dynamic subtest bsd2: SUCCESS (0.003s)
[60.117365] Starting dynamic subtest: blt
[60.118381] Dynamic subtest blt: SUCCESS (0.004s)
[60.125554] Starting dynamic subtest: vebox
[60.126637] Dynamic subtest vebox: SUCCESS (0.004s)
[60.127795] Subtest legacy-resubmit-new: SUCCESS (0.053s)
[60.362927] [002/133] (960s left) kms_flip (2x-flip-vs-suspend-interruptible)
[60.567765] Starting subtest: 2x-flip-vs-suspend-interruptible
[60.582787] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.014s)
[60.685372] [003/133] (959s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[60.889570] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[60.891436] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[61.008172] [004/133] (959s left) gem_exec_schedule (u-semaphore-user)
[61.092266] Starting subtest: u-semaphore-user
[61.172797] Subtest u-semaphore-user: SUCCESS (0.080s)
[61.574486] [005/133] (959s left) gem_exec_schedule (fairslice)
[61.657477] Starting subtest: fairslice
[61.658411] Starting dynamic subtest: rcs0
[63.702523] Dynamic subtest rcs0: SUCCESS (2.046s)
[63.710564] Starting dynamic subtest: bcs0
[65.720038] Dynamic subtest bcs0: SUCCESS (2.019s)
[65.727690] Starting dynamic subtest: vcs0
[67.735441] Dynamic subtest vcs0: SUCCESS (2.017s)
[67.743208] Starting dynamic subtest: vcs1
[69.754815] Dynamic subtest vcs1: SUCCESS (2.020s)
[69.762472] Starting dynamic subtest: vecs0
[71.771139] Dynamic subtest vecs0: SUCCESS (2.017s)
[71.778795] Starting dynamic subtest: vecs1
[73.786255] Dynamic subtest vecs1: SUCCESS (2.016s)
[73.793864] Starting dynamic subtest: ccs0
[75.803486] Dynamic subtest ccs0: SUCCESS (2.017s)
[75.804483] Subtest fairslice: SUCCESS (14.152s)
[76.201772] [006/133] (944s left) vkms/vkms_configfs (plane-wrong-values)
[76.281651] Subtest plane-wrong-values: SKIP (0.000s)
[76.350560] [007/133] (944s left) gem_exec_balancer (parallel-balancer)
[76.724453] Starting subtest: parallel-balancer
[77.982437] Subtest parallel-balancer: SUCCESS (1.258s)
[78.089017] [008/133] (942s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[78.293936] Starting subtest: 2x-flip-vs-modeset-vs-hang
[78.308439] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.014s)
[78.444678] [009/133] (942s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[78.530492] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[78.532441] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[78.753803] [010/133] (942s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[78.961225] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[78.962160] Starting dynamic subtest: pipe-A-DP-3
[78.984159] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[78.991527] Starting dynamic subtest: pipe-B-DP-3
[79.013755] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[79.021348] Starting dynamic subtest: pipe-C-DP-3
[79.047022] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[79.054553] Starting dynamic subtest: pipe-D-DP-3
[79.075270] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[79.076939] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.010s)
[79.414820] [011/133] (941s left) sysfs_preempt_timeout (invalid)
[79.495408] Starting subtest: invalid
[79.496412] Starting dynamic subtest: vecs0
[79.497276] Dynamic subtest vecs0: SUCCESS (0.000s)
[79.504994] Starting dynamic subtest: ccs0
[79.506160] Dynamic subtest ccs0: SUCCESS (0.000s)
[79.513889] Starting dynamic subtest: vcs0
[79.515070] Dynamic subtest vcs0: SUCCESS (0.000s)
[79.522463] Starting dynamic subtest: bcs0
[79.523572] Dynamic subtest bcs0: SUCCESS (0.000s)
[79.530954] Starting dynamic subtest: vecs1
[79.532051] Dynamic subtest vecs1: SUCCESS (0.000s)
[79.539653] Starting dynamic subtest: rcs0
[79.540800] Dynamic subtest rcs0: SUCCESS (0.000s)
[79.548132] Starting dynamic subtest: vcs1
[79.549184] Dynamic subtest vcs1: SUCCESS (0.000s)
[79.550135] Subtest invalid: SUCCESS (0.004s)
[79.613187] [012/133] (941s left) i915_pm_rps (thresholds-park)
[79.696990] Starting subtest: thresholds-park
[79.698924] Subtest thresholds-park: SKIP (0.001s)
[79.815253] [013/133] (941s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[80.023572] Starting subtest: fbc-indfb-scaledprimary
[83.617389] Subtest fbc-indfb-scaledprimary: SUCCESS (3.595s)
[83.820952] [014/133] (937s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[84.027191] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[84.036011] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[84.328257] [015/133] (936s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[84.549842] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[85.522177] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.973s)
[85.753389] [016/133] (935s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[85.964685] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[88.439769] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (2.476s)
[88.614280] [017/133] (932s left) prime_busy (before)
[88.698633] Starting subtest: before
[88.704587] Starting dynamic subtest: rcs0
[88.761299] Dynamic subtest rcs0: SUCCESS (0.057s)
[88.769546] Starting dynamic subtest: bcs0
[88.809879] Dynamic subtest bcs0: SUCCESS (0.048s)
[88.823009] Starting dynamic subtest: vcs0
[88.853572] Dynamic subtest vcs0: SUCCESS (0.043s)
[88.885520] Starting dynamic subtest: vcs1
[88.893770] Dynamic subtest vcs1: SUCCESS (0.040s)
[88.908484] Starting dynamic subtest: vecs0
[88.933325] Dynamic subtest vecs0: SUCCESS (0.039s)
[88.944576] Starting dynamic subtest: vecs1
[88.975339] Dynamic subtest vecs1: SUCCESS (0.042s)
[88.993778] Starting dynamic subtest: ccs0
[89.020318] Dynamic subtest ccs0: SUCCESS (0.044s)
[89.140324] Subtest before: SUCCESS (0.440s)
[89.321959] [018/133] (932s left) sw_sync (sync_random_merge)
[89.372797] Starting subtest: sync_random_merge
[89.431754] Subtest sync_random_merge: SUCCESS (0.059s)
[89.498624] [019/133] (931s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[89.702565] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[89.704432] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[89.809770] [020/133] (931s left) gem_ccs (suspend-resume)
[89.893685] Starting subtest: suspend-resume
[89.894603] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0
[108.560341] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (4.015s)
[108.569415] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0
[126.665563] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.798s)
[126.674768] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0
[144.554536] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (3.634s)
[144.563685] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0
[162.669959] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.746s)
[162.679619] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0
[180.562191] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (3.631s)
[180.571484] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0
[198.640138] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.685s)
[198.649379] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0
[216.531474] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0: SUCCESS (3.697s)
[216.541251] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0
[234.672470] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.773s)
[234.673431] Subtest suspend-resume: SUCCESS (29.983s)
[234.787980] [021/133] (901s left) syncobj_timeline (signal-array)
[234.869220] Starting subtest: signal-array
[234.870092] Subtest signal-array: SUCCESS (0.000s)
[234.971049] [022/133] (901s left) kms_big_fb (linear-64bpp-rotate-90)
[235.190096] Starting subtest: linear-64bpp-rotate-90
[235.242323] Subtest linear-64bpp-rotate-90: SKIP (0.052s)
[235.424774] [023/133] (901s left) gem_exec_big (single)
[235.504285] Starting subtest: single
[240.973081] Subtest single: SUCCESS (5.483s)
[241.614164] [024/133] (894s left) kms_pm_rpm (system-suspend-modeset)
[243.901123] Starting subtest: system-suspend-modeset
[264.706939] Subtest system-suspend-modeset: SUCCESS (5.458s)
[265.104713] [025/133] (886s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[265.318107] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[265.319863] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[265.443872] [026/133] (886s left) gem_softpin (noreloc)
[265.532924] Starting subtest: noreloc
[270.996027] Subtest noreloc: SUCCESS (5.466s)
[271.153903] [027/133] (880s left) gem_exec_params (cliprects-invalid)
[271.233982] Starting subtest: cliprects-invalid
[271.235018] Subtest cliprects-invalid: SUCCESS (0.000s)
[271.397700] [028/133] (880s left) kms_psr (psr-cursor-plane-onoff)
[271.601928] Subtest psr-cursor-plane-onoff: SKIP (0.000s)
[271.664522] [029/133] (880s left) syncobj_wait (wait-any-snapshot)
[271.749859] Starting subtest: wait-any-snapshot
[271.832585] Subtest wait-any-snapshot: SUCCESS (0.082s)
[271.969307] [030/133] (880s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[272.186908] Starting subtest: y-tiled-addfb-size-offset-overflow
[272.188658] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[272.339736] [031/133] (880s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[272.554089] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[272.555788] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[272.700625] [032/133] (879s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[272.911070] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[272.912809] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[273.039825] [033/133] (879s left) perf (gen12-group-exclusive-stream-sample-oa)
[273.402760] Starting subtest: gen12-group-exclusive-stream-sample-oa
[273.424360] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.021s)
[273.484304] [034/133] (879s left) syncobj_timeline (single-wait-available-submitted)
[273.563067] Starting subtest: single-wait-available-submitted
[273.564000] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[273.722368] [035/133] (878s left) gen9_exec_parse (cmd-crossing-page)
[273.803656] Subtest cmd-crossing-page: SKIP (0.000s)
[273.882915] [036/133] (878s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[273.964887] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[274.047040] [037/133] (878s left) drm_read (short-buffer-nonblock)
[274.321817] Starting subtest: short-buffer-nonblock
[274.322753] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[274.551862] [038/133] (878s left) perf (invalid-remove-userspace-config)
[274.754672] Starting subtest: invalid-remove-userspace-config
[274.766854] Subtest invalid-remove-userspace-config: SUCCESS (0.012s)
[274.816628] [039/133] (878s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[275.020815] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[275.021735] Starting dynamic subtest: pipe-A-valid-mode
[275.098653] Dynamic subtest pipe-A-valid-mode: SKIP (0.076s)
[275.100586] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.077s)
[275.313762] [040/133] (877s left) gem_ctx_sseu (engines)
[275.397481] Subtest engines: SKIP (0.000s)
[275.464836] [041/133] (877s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[275.671032] Starting subtest: basic-busy-flip-before-cursor-legacy
[275.672824] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[275.782192] [042/133] (877s left) i915_pm_rpm (gem-evict-pwrite)
[278.361004] Starting subtest: gem-evict-pwrite
[278.364762] Subtest gem-evict-pwrite: SKIP (0.000s)
[278.741702] [043/133] (874s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[278.953726] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[278.954521] Starting dynamic subtest: pipe-A
[279.053651] Dynamic subtest pipe-A: SUCCESS (0.100s)
[279.068035] Starting dynamic subtest: pipe-B
[279.291548] Dynamic subtest pipe-B: SUCCESS (0.238s)
[279.309153] Starting dynamic subtest: pipe-C
[279.513180] Dynamic subtest pipe-C: SUCCESS (0.221s)
[279.531749] Starting dynamic subtest: pipe-D
[279.733094] Dynamic subtest pipe-D: SUCCESS (0.219s)
[279.734103] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SUCCESS (0.780s)
[280.053377] [044/133] (873s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[280.269391] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (0.000s)
[280.326743] [045/133] (872s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[280.728115] Starting subtest: cursor-rapid-movement-512x512
[280.729916] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[280.968765] [046/133] (872s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[281.179242] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[281.180937] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[281.334732] [047/133] (872s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[281.557815] Starting subtest: y-tiled-16bpp-rotate-90
[281.559642] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[281.679019] [048/133] (871s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[281.896155] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[283.149777] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.255s)
[283.321201] [049/133] (870s left) gem_exec_params (invalid-bsd1-flag-on-render)
[283.403133] Starting subtest: invalid-bsd1-flag-on-render
[283.404150] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[283.535906] [050/133] (870s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[283.744726] Starting subtest: coverage-vs-premult-vs-constant
[283.973659] Starting dynamic subtest: pipe-A-DP-3
[284.441147] Dynamic subtest pipe-A-DP-3: SUCCESS (0.467s)
[284.454779] Starting dynamic subtest: pipe-D-DP-3
[284.976473] Dynamic subtest pipe-D-DP-3: SUCCESS (0.535s)
[284.977438] Subtest coverage-vs-premult-vs-constant: SUCCESS (1.232s)
[285.264822] [051/133] (868s left) kms_addfb_basic (unused-pitches)
[285.344824] Starting subtest: unused-pitches
[285.345775] Subtest unused-pitches: SUCCESS (0.000s)
[285.627320] [052/133] (868s left) kms_vblank (wait-busy-hang)
[285.836833] Starting subtest: wait-busy-hang
[285.838960] Starting dynamic subtest: pipe-A-DP-3
[312.839911] Dynamic subtest pipe-A-DP-3: SUCCESS (27.003s)
[312.853020] Starting dynamic subtest: pipe-D-DP-3
[337.766164] Dynamic subtest pipe-D-DP-3: SUCCESS (24.930s)
[337.767092] Subtest wait-busy-hang: SUCCESS (51.937s)
[338.010854] [053/133] (815s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[338.223789] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[338.224731] Starting dynamic subtest: pipe-A-DP-3
[338.233353] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[338.244034] Starting dynamic subtest: pipe-B-DP-3
[338.252494] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[338.263435] Starting dynamic subtest: pipe-C-DP-3
[338.271737] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[338.282515] Starting dynamic subtest: pipe-D-DP-3
[338.293026] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[338.295021] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s)
[338.701204] [054/133] (815s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[338.912233] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[338.913883] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[339.059371] [055/133] (814s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[339.135126] Starting subtest: multi-wait-available-unsubmitted-submitted
[339.136049] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[339.252042] [056/133] (814s left) gem_mmap_wc (bad-object)
[339.331871] Subtest bad-object: SKIP (0.000s)
[339.414652] [057/133] (814s left) perf_pmu (all-busy-check-all)
[339.484720] Starting subtest: all-busy-check-all
[340.078194] Subtest all-busy-check-all: SUCCESS (0.593s)
[340.236463] [058/133] (813s left) gem_ctx_param (root-set)
[340.311955] Starting subtest: root-set
[340.313985] Subtest root-set: SUCCESS (0.001s)
[340.449630] [059/133] (813s left) kms_cursor_crc (cursor-offscreen-512x170)
[340.885097] Starting subtest: cursor-offscreen-512x170
[340.888042] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[341.151978] [060/133] (813s left) gem_partial_pwrite_pread (reads-snoop)
[341.235888] Subtest reads-snoop: SKIP (0.000s)
[341.305040] [061/133] (813s left) kms_psr (psr2-primary-mmap-gtt)
[341.508833] Subtest psr2-primary-mmap-gtt: SKIP (0.000s)
[341.573320] [062/133] (812s left) kms_vblank (query-busy-hang)
[341.781868] Starting subtest: query-busy-hang
[341.783958] Starting dynamic subtest: pipe-A-DP-3
[367.815585] Dynamic subtest pipe-A-DP-3: SUCCESS (26.041s)
[367.830574] Starting dynamic subtest: pipe-D-DP-3
[392.815666] Dynamic subtest pipe-D-DP-3: SUCCESS (24.991s)
[392.816653] Subtest query-busy-hang: SUCCESS (51.036s)
[393.065200] [063/133] (761s left) i915_query (query-regions-sanity-check)
[393.159955] Starting subtest: query-regions-sanity-check
[393.192248] Subtest query-regions-sanity-check: SUCCESS (0.033s)
[393.363905] [064/133] (761s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[393.566864] Starting subtest: primary-y-tiled-reflect-x-0
[393.658955] Subtest primary-y-tiled-reflect-x-0: SKIP (0.091s)
[393.826056] [065/133] (760s left) core_setmaster (master-drop-set-root)
[396.674226] Starting subtest: master-drop-set-root
[396.690944] Subtest master-drop-set-root: SUCCESS (0.017s)
[396.752143] [FACT core_setmaster (master-drop-set-root)] new: kernel.kmod_is_loaded.amdgpu: true
[396.753125] [FACT core_setmaster (master-drop-set-root)] new: kernel.kmod_is_loaded.xe: true
[396.755053] [066/133] (757s left) gem_exec_reloc (basic-cpu-gtt)
[396.839764] Subtest basic-cpu-gtt: SKIP (0.000s)
[396.919359] [067/133] (757s left) kms_chamelium_audio (hdmi-audio-edid)
[397.204065] Subtest hdmi-audio-edid: SKIP (0.000s)
[397.362222] [068/133] (757s left) api_intel_bb (crc32)
[397.442655] Starting subtest: crc32
[397.443649] Starting dynamic subtest: rcs0-lmem0
[397.672301] Dynamic subtest rcs0-lmem0: SUCCESS (0.228s)
[397.688440] Starting dynamic subtest: rcs0-smem0
[397.969466] Dynamic subtest rcs0-smem0: SUCCESS (0.295s)
[397.984411] Starting dynamic subtest: bcs0-lmem0
[398.189019] Dynamic subtest bcs0-lmem0: SUCCESS (0.217s)
[398.205467] Starting dynamic subtest: bcs0-smem0
[398.505094] Dynamic subtest bcs0-smem0: SUCCESS (0.314s)
[398.552394] Starting dynamic subtest: vcs0-lmem0
[398.880012] Dynamic subtest vcs0-lmem0: SUCCESS (0.372s)
[398.894859] Starting dynamic subtest: vcs0-smem0
[399.345559] Dynamic subtest vcs0-smem0: SUCCESS (0.463s)
[399.361734] Starting dynamic subtest: vcs1-lmem0
[399.696604] Dynamic subtest vcs1-lmem0: SUCCESS (0.348s)
[399.711217] Starting dynamic subtest: vcs1-smem0
[400.172617] Dynamic subtest vcs1-smem0: SUCCESS (0.473s)
[400.187196] Starting dynamic subtest: vecs0-lmem0
[400.515971] Dynamic subtest vecs0-lmem0: SUCCESS (0.342s)
[400.532337] Starting dynamic subtest: vecs0-smem0
[400.994359] Dynamic subtest vecs0-smem0: SUCCESS (0.477s)
[401.009085] Starting dynamic subtest: vecs1-lmem0
[401.340381] Dynamic subtest vecs1-lmem0: SUCCESS (0.343s)
[401.386545] Starting dynamic subtest: vecs1-smem0
[401.847029] Dynamic subtest vecs1-smem0: SUCCESS (0.504s)
[401.861947] Starting dynamic subtest: ccs0-lmem0
[402.077746] Dynamic subtest ccs0-lmem0: SUCCESS (0.228s)
[402.121754] Starting dynamic subtest: ccs0-smem0
[402.442772] Dynamic subtest ccs0-smem0: SUCCESS (0.362s)
[402.445459] Subtest crc32: SUCCESS (5.001s)
[402.605854] [069/133] (752s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[402.897220] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[403.049494] [070/133] (751s left) kms_cursor_crc (cursor-random-64x64)
[403.349909] Starting subtest: cursor-random-64x64
[403.354364] Starting dynamic subtest: pipe-A-DP-3
[407.925348] Dynamic subtest pipe-A-DP-3: SUCCESS (4.571s)
[407.980541] Starting dynamic subtest: pipe-D-DP-3
[412.266700] Dynamic subtest pipe-D-DP-3: SUCCESS (4.298s)
[412.267812] Subtest cursor-random-64x64: SUCCESS (8.917s)
[412.762986] [071/133] (742s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[412.973560] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[412.975354] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[413.103144] [072/133] (741s left) kms_chamelium_color (ctm-blue-to-red)
[413.311633] Subtest ctm-blue-to-red: SKIP (0.000s)
[413.376762] [073/133] (741s left) kms_sequence (get-idle)
[413.585781] Starting subtest: get-idle
[413.586684] Starting dynamic subtest: pipe-A-DP-3
[415.961909] Dynamic subtest pipe-A-DP-3: SUCCESS (2.374s)
[415.981054] Starting dynamic subtest: pipe-B-DP-3
[418.324050] Dynamic subtest pipe-B-DP-3: SUCCESS (2.360s)
[418.352614] Starting dynamic subtest: pipe-C-DP-3
[420.648923] Dynamic subtest pipe-C-DP-3: SUCCESS (2.322s)
[420.661655] Starting dynamic subtest: pipe-D-DP-3
[422.957794] Dynamic subtest pipe-D-DP-3: SUCCESS (2.308s)
[422.958692] Subtest get-idle: SUCCESS (9.374s)
[423.243172] [074/133] (731s left) dmabuf_sync_file (export-multiwait)
[423.364745] Starting subtest: export-multiwait
[423.365671] Subtest export-multiwait: SUCCESS (0.001s)
[423.478621] [FACT dmabuf_sync_file (export-multiwait)] new: kernel.kmod_is_loaded.vgem: true
[423.481194] [075/133] (731s left) gem_exec_nop (basic-sequential)
[423.575499] Starting subtest: basic-sequential
[428.040800] Subtest basic-sequential: SUCCESS (4.464s)
[428.283928] [076/133] (726s left) kms_psr (fbc-psr-primary-blt)
[428.502738] Subtest fbc-psr-primary-blt: SKIP (0.000s)
[428.574115] [077/133] (726s left) gem_exec_schedule (pi-distinct-iova)
[428.795429] Starting subtest: pi-distinct-iova
[428.796472] Starting dynamic subtest: rcs0
[429.057419] Dynamic subtest rcs0: SUCCESS (0.255s)
[429.070181] Starting dynamic subtest: bcs0
[429.220872] Dynamic subtest bcs0: SUCCESS (0.170s)
[429.233704] Starting dynamic subtest: vcs0
[429.394933] Dynamic subtest vcs0: SUCCESS (0.173s)
[429.407497] Starting dynamic subtest: vcs1
[429.572148] Dynamic subtest vcs1: SUCCESS (0.176s)
[429.584599] Starting dynamic subtest: vecs0
[429.746050] Dynamic subtest vecs0: SUCCESS (0.173s)
[429.758677] Starting dynamic subtest: vecs1
[429.922276] Dynamic subtest vecs1: SUCCESS (0.175s)
[429.934873] Starting dynamic subtest: ccs0
[430.103699] Dynamic subtest ccs0: SUCCESS (0.180s)
[430.104686] Subtest pi-distinct-iova: SUCCESS (1.309s)
[430.445082] [078/133] (724s left) kms_plane_scaling (intel-max-src-size)
[430.684816] Starting subtest: intel-max-src-size
[430.697403] Starting dynamic subtest: pipe-A-DP-3
[430.892745] Dynamic subtest pipe-A-DP-3: SUCCESS (0.195s)
[430.894679] Subtest intel-max-src-size: SUCCESS (0.209s)
[431.342509] [079/133] (724s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[431.426295] Starting subtest: etime-multi-wait-all-available-unsubmitted
[431.528832] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.101s)
[431.684458] [080/133] (723s left) gem_mmap_wc (write)
[431.770053] Subtest write: SKIP (0.000s)
[431.850307] [081/133] (723s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[432.073854] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[432.075754] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[432.253045] [082/133] (723s left) kms_pm_dc (dc9-dpms)
[433.475706] Starting subtest: dc9-dpms
[433.976617] Subtest dc9-dpms: SUCCESS (0.502s)
[434.089591] [083/133] (721s left) sw_sync (alloc_fence)
[434.144544] Starting subtest: alloc_fence
[434.145808] Subtest alloc_fence: SUCCESS (0.000s)
[434.227140] [084/133] (721s left) prime_busy (before-wait)
[434.326068] Starting subtest: before-wait
[434.331899] Starting dynamic subtest: rcs0
[434.387181] Dynamic subtest rcs0: SUCCESS (0.055s)
[434.400139] Starting dynamic subtest: bcs0
[434.445086] Dynamic subtest bcs0: SUCCESS (0.057s)
[434.472642] Starting dynamic subtest: vcs0
[434.486136] Dynamic subtest vcs0: SUCCESS (0.040s)
[434.509792] Starting dynamic subtest: vcs1
[434.526181] Dynamic subtest vcs1: SUCCESS (0.039s)
[434.542560] Starting dynamic subtest: vecs0
[434.566712] Dynamic subtest vecs0: SUCCESS (0.040s)
[434.583356] Starting dynamic subtest: vecs1
[434.609398] Dynamic subtest vecs1: SUCCESS (0.042s)
[434.634067] Starting dynamic subtest: ccs0
[434.650637] Dynamic subtest ccs0: SUCCESS (0.040s)
[434.760110] Subtest before-wait: SUCCESS (0.433s)
[434.893407] [085/133] (721s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[435.113304] Subtest psr2-plane-move-sf-dmg-area: SKIP (0.000s)
[435.169564] [086/133] (720s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[435.466354] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[435.624416] [087/133] (720s left) gem_ctx_persistence (heartbeat-hostile)
[435.715825] Starting subtest: heartbeat-hostile
[435.717662] Subtest heartbeat-hostile: SKIP (0.000s)
[435.886867] [088/133] (720s left) kms_hdr (invalid-hdr)
[436.098872] Starting subtest: invalid-hdr
[436.101617] Subtest invalid-hdr: SKIP (0.000s)
[436.209564] [089/133] (719s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[436.419994] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[436.422067] Starting dynamic subtest: pipe-A-valid-mode
[436.512696] Dynamic subtest pipe-A-valid-mode: SKIP (0.090s)
[436.514738] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.092s)
[436.742327] [090/133] (719s left) gem_exec_gttfill (basic)
[436.840065] Starting subtest: basic
[442.051963] Subtest basic: SUCCESS (5.213s)
[442.286386] [091/133] (714s left) gem_userptr_blits (sync-overlap)
[442.426617] Starting subtest: sync-overlap
[442.427645] Subtest sync-overlap: SUCCESS (0.000s)
[442.581779] [092/133] (713s left) kms_flip (2x-plain-flip)
[442.798330] Starting subtest: 2x-plain-flip
[442.812984] Subtest 2x-plain-flip: SKIP (0.014s)
[442.921377] [093/133] (713s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[443.139459] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[443.141310] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[443.264520] [094/133] (713s left) i915_query (query-topology-unsupported)
[443.354839] Starting subtest: query-topology-unsupported
[443.357033] Subtest query-topology-unsupported: SKIP (0.000s)
[443.515291] [095/133] (713s left) gem_exec_flush (basic-wb-set-default)
[443.609115] Subtest basic-wb-set-default: SKIP (0.000s)
[443.720578] [096/133] (712s left) kms_plane_scaling (2x-scaler-multi-pipe)
[443.956408] Starting subtest: 2x-scaler-multi-pipe
[443.959490] Subtest 2x-scaler-multi-pipe: SKIP (0.002s)
[444.146378] [097/133] (712s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[444.370449] Starting subtest: flip-vs-cursor-varying-size
[455.246529] Subtest flip-vs-cursor-varying-size: SUCCESS (10.879s)
[455.510313] [098/133] (701s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[455.732400] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[455.734117] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[455.904941] [099/133] (701s left) kms_flip (flip-vs-blocking-wf-vblank)
[456.116549] Starting subtest: flip-vs-blocking-wf-vblank
[456.120723] Starting dynamic subtest: A-DP3
[464.417668] Dynamic subtest A-DP3: SUCCESS (8.300s)
[464.433057] Starting dynamic subtest: B-DP3
[472.615899] Dynamic subtest B-DP3: SUCCESS (8.200s)
[472.630605] Starting dynamic subtest: C-DP3
[480.819415] Dynamic subtest C-DP3: SUCCESS (8.205s)
[480.834322] Starting dynamic subtest: D-DP3
[489.019737] Dynamic subtest D-DP3: SUCCESS (8.202s)
[489.021919] Subtest flip-vs-blocking-wf-vblank: SUCCESS (32.917s)
[489.349173] [100/133] (667s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[489.560003] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[489.562099] Starting dynamic subtest: pipe-A-DP-3
[489.570990] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[489.583508] Starting dynamic subtest: pipe-B-DP-3
[489.592043] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[489.604492] Starting dynamic subtest: pipe-C-DP-3
[489.613802] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[489.626423] Starting dynamic subtest: pipe-D-DP-3
[489.637326] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[489.639391] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[490.018442] [101/133] (667s left) gem_ppgtt (shrink-vs-evict-pinned)
[490.110208] Starting subtest: shrink-vs-evict-pinned
[497.189242] Subtest shrink-vs-evict-pinned: SUCCESS (7.073s)
[497.298678] [102/133] (659s left) kms_async_flips (test-time-stamp)
[497.515085] Starting subtest: test-time-stamp
[497.745973] Starting dynamic subtest: pipe-A-DP-3
[498.042270] Dynamic subtest pipe-A-DP-3: SUCCESS (0.294s)
[498.292209] Starting dynamic subtest: pipe-B-DP-3
[498.437090] Dynamic subtest pipe-B-DP-3: SUCCESS (0.157s)
[498.644661] Starting dynamic subtest: pipe-C-DP-3
[498.782932] Dynamic subtest pipe-C-DP-3: SUCCESS (0.150s)
[499.026865] Starting dynamic subtest: pipe-D-DP-3
[499.170727] Dynamic subtest pipe-D-DP-3: SUCCESS (0.156s)
[499.171661] Subtest test-time-stamp: SUCCESS (1.653s)
[499.635635] [103/133] (657s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-gtt)
[499.852399] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-gtt
[499.854126] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[499.983143] [104/133] (657s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[500.204064] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[500.205765] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[500.334530] [105/133] (657s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[500.558705] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[500.625398] [106/133] (656s left) gem_ctx_persistence (legacy-engines-cleanup)
[500.720729] Starting subtest: legacy-engines-cleanup
[500.721714] Starting dynamic subtest: render
[500.835878] Dynamic subtest render: SUCCESS (0.114s)
[500.852027] Starting dynamic subtest: bsd1
[500.877843] Dynamic subtest bsd1: SUCCESS (0.040s)
[500.896318] Starting dynamic subtest: bsd2
[500.901724] Dynamic subtest bsd2: SUCCESS (0.022s)
[500.919987] Starting dynamic subtest: blt
[500.959821] Dynamic subtest blt: SUCCESS (0.057s)
[500.983784] Starting dynamic subtest: vebox
[501.009078] Dynamic subtest vebox: SUCCESS (0.047s)
[501.010290] Subtest legacy-engines-cleanup: SUCCESS (0.289s)
[501.196824] [107/133] (656s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[501.289797] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[501.290802] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[501.384353] [108/133] (656s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[501.606335] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[501.608104] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[501.761575] [109/133] (655s left) gem_render_copy (yf-tiled)
[501.853871] Starting subtest: yf-tiled
[501.855931] Subtest yf-tiled: SKIP (0.000s)
[502.118689] [110/133] (655s left) kms_atomic_interruptible (universal-setplane-cursor)
[502.334918] Starting subtest: universal-setplane-cursor
[502.335843] Starting dynamic subtest: pipe-A-DP-3
[508.675414] Dynamic subtest pipe-A-DP-3: SUCCESS (6.333s)
[508.676448] Subtest universal-setplane-cursor: SUCCESS (6.335s)
[508.977905] [111/133] (648s left) kms_legacy_colorkey (basic)
[509.189966] Starting subtest: basic
[509.190817] Starting dynamic subtest: pipe-A
[509.256544] Dynamic subtest pipe-A: SUCCESS (0.066s)
[509.279896] Starting dynamic subtest: pipe-B
[509.281057] Dynamic subtest pipe-B: SUCCESS (0.000s)
[509.301401] Starting dynamic subtest: pipe-C
[509.302541] Dynamic subtest pipe-C: SUCCESS (0.000s)
[509.316704] Starting dynamic subtest: pipe-D
[509.317940] Dynamic subtest pipe-D: SUCCESS (0.001s)
[509.319044] Subtest basic: SUCCESS (0.072s)
[509.376141] [112/133] (648s left) vkms/vkms_configfs (enabled-connector-hot-plug)
[509.449962] Subtest enabled-connector-hot-plug: SKIP (0.000s)
[509.525694] [113/133] (648s left) kms_properties (connector-properties-legacy)
[509.747172] Starting subtest: connector-properties-legacy
[509.749764] Starting dynamic subtest: pipe-A-DP-3
[511.350900] Dynamic subtest pipe-A-DP-3: SUCCESS (1.599s)
[511.367973] Starting dynamic subtest: pipe-None-DP-1
[511.369875] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[511.385075] Starting dynamic subtest: pipe-None-DP-2
[511.386887] Dynamic subtest pipe-None-DP-2: SUCCESS (0.002s)
[511.400041] Starting dynamic subtest: pipe-None-HDMI-A-1
[511.402397] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.002s)
[511.414951] Starting dynamic subtest: pipe-None-HDMI-A-2
[511.416806] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.002s)
[511.429639] Starting dynamic subtest: pipe-None-DP-4
[511.431392] Dynamic subtest pipe-None-DP-4: SUCCESS (0.002s)
[511.444148] Starting dynamic subtest: pipe-None-HDMI-A-3
[511.445605] Dynamic subtest pipe-None-HDMI-A-3: SUCCESS (0.002s)
[511.446331] Subtest connector-properties-legacy: SUCCESS (1.620s)
[511.630070] [114/133] (646s left) gem_wait (await)
[511.731767] Starting subtest: await
[511.732715] Starting dynamic subtest: all-engines
[512.872864] Dynamic subtest all-engines: SUCCESS (1.140s)
[512.890349] Starting dynamic subtest: rcs0
[513.939173] Dynamic subtest rcs0: SUCCESS (1.064s)
[513.956738] Starting dynamic subtest: bcs0
[515.004224] Dynamic subtest bcs0: SUCCESS (1.062s)
[515.052172] Starting dynamic subtest: vcs0
[516.093138] Dynamic subtest vcs0: SUCCESS (1.084s)
[516.114933] Starting dynamic subtest: vcs1
[517.167347] Dynamic subtest vcs1: SUCCESS (1.069s)
[517.189621] Starting dynamic subtest: vecs0
[518.235274] Dynamic subtest vecs0: SUCCESS (1.063s)
[518.257105] Starting dynamic subtest: vecs1
[519.301250] Dynamic subtest vecs1: SUCCESS (1.061s)
[519.323361] Starting dynamic subtest: ccs0
[520.368292] Dynamic subtest ccs0: SUCCESS (1.062s)
[520.370458] Subtest await: SUCCESS (8.633s)
[520.671290] [115/133] (637s left) kms_flip (nonexisting-fb-interruptible)
[520.891716] Starting subtest: nonexisting-fb-interruptible
[520.896395] Starting dynamic subtest: A-DP3
[521.208270] Dynamic subtest A-DP3: SUCCESS (0.311s)
[521.255327] Starting dynamic subtest: B-DP3
[521.478784] Dynamic subtest B-DP3: SUCCESS (0.266s)
[521.516419] Starting dynamic subtest: C-DP3
[521.748727] Dynamic subtest C-DP3: SUCCESS (0.266s)
[521.792096] Starting dynamic subtest: D-DP3
[522.010829] Dynamic subtest D-DP3: SUCCESS (0.257s)
[522.015556] Subtest nonexisting-fb-interruptible: SUCCESS (1.123s)
[522.428923] [116/133] (635s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[522.641282] Starting subtest: 2x-long-cursor-vs-flip-atomic
[522.644496] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.002s)
[522.753893] [117/133] (635s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[522.975764] Starting subtest: 4-tiled-32bpp-rotate-90
[523.025935] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.049s)
[523.217680] [118/133] (635s left) gem_eio (wait-10ms)
[523.524120] Starting subtest: wait-10ms
[524.135176] Subtest wait-10ms: SUCCESS (0.611s)
[524.362940] [119/133] (634s left) kms_invalid_mode (zero-clock)
[524.583836] Starting subtest: zero-clock
[524.584786] Starting dynamic subtest: pipe-A-DP-3
[524.668076] Dynamic subtest pipe-A-DP-3: SUCCESS (0.083s)
[524.685635] Starting dynamic subtest: pipe-B-DP-3
[524.686913] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[524.702507] Starting dynamic subtest: pipe-C-DP-3
[524.703509] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[524.717925] Starting dynamic subtest: pipe-D-DP-3
[524.718888] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[524.719760] Subtest zero-clock: SUCCESS (0.093s)
[524.922226] [120/133] (633s left) gem_create (hog-create)
[525.019050] Starting subtest: hog-create
[525.019963] Starting dynamic subtest: lmem0
[557.293776] Dynamic subtest lmem0: SUCCESS (32.268s)
[557.307853] Starting dynamic subtest: smem0
[589.564042] Dynamic subtest smem0: SUCCESS (32.271s)
[589.565155] Subtest hog-create: SUCCESS (64.541s)
[589.868669] [121/133] (568s left) gem_exec_whisper (basic-fds-forked)
[589.966888] Starting subtest: basic-fds-forked
[612.730639] Subtest basic-fds-forked: SUCCESS (22.765s)
[612.970815] [122/133] (545s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[613.184994] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[613.185832] Starting dynamic subtest: pipe-A
[613.278885] Dynamic subtest pipe-A: SUCCESS (0.093s)
[613.297542] Starting dynamic subtest: pipe-B
[613.496999] Dynamic subtest pipe-B: SUCCESS (0.217s)
[613.519187] Starting dynamic subtest: pipe-C
[613.716936] Dynamic subtest pipe-C: SUCCESS (0.219s)
[613.740782] Starting dynamic subtest: pipe-D
[613.934948] Dynamic subtest pipe-D: SUCCESS (0.217s)
[613.935909] Subtest planes-unity-scaling-downscale-factor-0-5: SUCCESS (0.751s)
[614.257162] [123/133] (544s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[614.478303] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[614.479977] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[614.611337] [124/133] (544s left) kms_dp_link_training (non-uhbr-mst)
[614.826162] Starting subtest: non-uhbr-mst
[614.829804] Subtest non-uhbr-mst: SKIP (0.000s)
[614.923524] [125/133] (543s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[615.142525] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[615.144332] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[615.278371] [126/133] (543s left) drm_fdinfo (memory-info-resident)
[615.353703] Starting subtest: memory-info-resident
[615.354664] Starting dynamic subtest: lmem0
[618.427924] Dynamic subtest lmem0: SUCCESS (3.073s)
[618.449166] Starting dynamic subtest: smem0
[622.325654] Dynamic subtest smem0: SUCCESS (3.894s)
[622.326644] Subtest memory-info-resident: SUCCESS (6.972s)
[622.423600] [127/133] (536s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[622.639376] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[622.641210] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[622.813915] [128/133] (536s left) kms_psr (fbc-psr2-no-drrs)
[623.026717] Subtest fbc-psr2-no-drrs: SKIP (0.000s)
[623.085608] [129/133] (536s left) kms_addfb_basic (addfb25-modifier-no-flag)
[623.299065] Starting subtest: addfb25-modifier-no-flag
[623.300085] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[623.450238] [130/133] (535s left) gem_exec_fence (syncobj-timeline-export)
[624.190610] Starting subtest: syncobj-timeline-export
[624.231373] Subtest syncobj-timeline-export: SUCCESS (0.042s)
[624.563623] [131/133] (534s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[624.781339] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[624.782986] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[624.905330] [132/133] (534s left) gem_gpgpu_fill (offset-16x16)
[624.989106] Starting subtest: offset-16x16
[625.016457] Subtest offset-16x16: SUCCESS (0.027s)
[625.243382] [133/133] (534s left) gem_mmap_gtt (cpuset-basic-small-copy)
[625.327745] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[625.400152] Closing watchdogs
results: parsing output: 0/ for test: gem_spin_batch
results: parsing output: 1/ for test: kms_flip
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_exec_schedule
results: parsing output: 4/ for test: gem_exec_schedule
results: parsing output: 5/ for test: vkms/vkms_configfs
results: parsing output: 6/ for test: gem_exec_balancer
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: gem_render_copy
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: sysfs_preempt_timeout
results: parsing output: 11/ for test: i915_pm_rps
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: prime_busy
results: parsing output: 17/ for test: sw_sync
results: parsing output: 18/ for test: kms_cursor_legacy
results: parsing output: 19/ for test: gem_ccs
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: gem_exec_big
results: parsing output: 23/ for test: kms_pm_rpm
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_softpin
results: parsing output: 26/ for test: gem_exec_params
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: syncobj_wait
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: perf
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: gen9_exec_parse
results: parsing output: 35/ for test: gem_exec_reloc
results: parsing output: 36/ for test: drm_read
results: parsing output: 37/ for test: perf
results: parsing output: 38/ for test: kms_flip_scaled_crc
results: parsing output: 39/ for test: gem_ctx_sseu
results: parsing output: 40/ for test: kms_cursor_legacy
results: parsing output: 41/ for test: i915_pm_rpm
results: parsing output: 42/ for test: kms_plane_scaling
results: parsing output: 43/ for test: kms_psr2_sf
results: parsing output: 44/ for test: kms_cursor_crc
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: gem_exec_params
results: parsing output: 49/ for test: kms_plane_alpha_blend
results: parsing output: 50/ for test: kms_addfb_basic
results: parsing output: 51/ for test: kms_vblank
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: gem_mmap_wc
results: parsing output: 56/ for test: perf_pmu
results: parsing output: 57/ for test: gem_ctx_param
results: parsing output: 58/ for test: kms_cursor_crc
results: parsing output: 59/ for test: gem_partial_pwrite_pread
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: kms_vblank
results: parsing output: 62/ for test: i915_query
results: parsing output: 63/ for test: kms_rotation_crc
results: parsing output: 64/ for test: core_setmaster
results: parsing output: 65/ for test: gem_exec_reloc
results: parsing output: 66/ for test: kms_chamelium_audio
results: parsing output: 67/ for test: api_intel_bb
results: parsing output: 68/ for test: kms_chamelium_hpd
results: parsing output: 69/ for test: kms_cursor_crc
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_chamelium_color
results: parsing output: 72/ for test: kms_sequence
results: parsing output: 73/ for test: dmabuf_sync_file
results: parsing output: 74/ for test: gem_exec_nop
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: gem_exec_schedule
results: parsing output: 77/ for test: kms_plane_scaling
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: gem_mmap_wc
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: kms_pm_dc
results: parsing output: 82/ for test: sw_sync
results: parsing output: 83/ for test: prime_busy
results: parsing output: 84/ for test: kms_psr2_sf
results: parsing output: 85/ for test: kms_chamelium_hpd
results: parsing output: 86/ for test: gem_ctx_persistence
results: parsing output: 87/ for test: kms_hdr
results: parsing output: 88/ for test: kms_flip_scaled_crc
results: parsing output: 89/ for test: gem_exec_gttfill
results: parsing output: 90/ for test: gem_userptr_blits
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: i915_query
results: parsing output: 94/ for test: gem_exec_flush
results: parsing output: 95/ for test: kms_plane_scaling
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: kms_ccs
results: parsing output: 100/ for test: gem_ppgtt
results: parsing output: 101/ for test: kms_async_flips
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: gem_ctx_persistence
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_render_copy
results: parsing output: 109/ for test: kms_atomic_interruptible
results: parsing output: 110/ for test: kms_legacy_colorkey
results: parsing output: 111/ for test: vkms/vkms_configfs
results: parsing output: 112/ for test: kms_properties
results: parsing output: 113/ for test: gem_wait
results: parsing output: 114/ for test: kms_flip
results: parsing output: 115/ for test: kms_cursor_legacy
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: gem_eio
results: parsing output: 118/ for test: kms_invalid_mode
results: parsing output: 119/ for test: gem_create
results: parsing output: 120/ for test: gem_exec_whisper
results: parsing output: 121/ for test: kms_plane_scaling
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_dp_link_training
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: drm_fdinfo
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_addfb_basic
results: parsing output: 129/ for test: gem_exec_fence
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_gpgpu_fill
results: parsing output: 132/ for test: gem_mmap_gtt
Done.