[61.055443] Initializing watchdogs
[61.055510]   /dev/watchdog0
[61.073259] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[61.082601] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[61.086620] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.088987] [001/132] (960s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[61.295361] Starting subtest: fbcpsr-rgb101010-draw-blt
[61.297063] Subtest fbcpsr-rgb101010-draw-blt: SKIP (0.000s)
[61.396354] [002/132] (960s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[61.598937] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[61.599899] Starting dynamic subtest: pipe-A-DP-4
[61.608439] Dynamic subtest pipe-A-DP-4: SKIP (0.000s)
[61.615354] Starting dynamic subtest: pipe-B-DP-4
[61.623968] Dynamic subtest pipe-B-DP-4: SKIP (0.000s)
[61.630726] Starting dynamic subtest: pipe-C-DP-4
[61.639134] Dynamic subtest pipe-C-DP-4: SKIP (0.000s)
[61.645636] Starting dynamic subtest: pipe-D-DP-4
[61.654057] Dynamic subtest pipe-D-DP-4: SKIP (0.000s)
[61.655765] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[62.041627] [003/132] (959s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[62.240961] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[62.241935] Starting dynamic subtest: pipe-A-valid-mode
[62.315924] Dynamic subtest pipe-A-valid-mode: SKIP (0.075s)
[62.317745] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.075s)
[62.529704] [004/132] (959s left) kms_tv_load_detect (load-detect)
[62.601992] Subtest load-detect: SKIP (0.000s)
[62.655208] [005/132] (959s left) kms_vblank (wait-forked-busy-hang)
[62.852338] Starting subtest: wait-forked-busy-hang
[62.854215] Starting dynamic subtest: pipe-A-DP-4
[89.641173] Dynamic subtest pipe-A-DP-4: SUCCESS (26.810s)
[89.650043] Starting dynamic subtest: pipe-D-DP-4
[114.572209] Dynamic subtest pipe-D-DP-4: SUCCESS (24.926s)
[114.573223] Subtest wait-forked-busy-hang: SUCCESS (51.741s)
[114.827535] [006/132] (907s left) kms_psr (fbc-pr-primary-page-flip)
[115.024622] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[115.067219] [007/132] (906s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[115.270463] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[115.272231] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[115.388364] [008/132] (906s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[115.998334] Starting subtest: syncobj-timeline-multiple-ext-nodes
[116.001309] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s)
[116.254762] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true
[116.256636] [009/132] (905s left) intel_hwmon (hwmon-read)
[116.344250] Starting subtest: hwmon-read
[116.346212] Subtest hwmon-read: SUCCESS (0.001s)
[116.508663] [010/132] (905s left) kms_atomic (test-only)
[116.713468] Starting subtest: test-only
[117.115946] Starting dynamic subtest: pipe-A-DP-4
[117.934016] Dynamic subtest pipe-A-DP-4: SUCCESS (0.817s)
[117.935209] Subtest test-only: SUCCESS (1.221s)
[118.228595] [011/132] (903s left) kms_big_fb (linear-32bpp-rotate-180)
[118.452297] Starting subtest: linear-32bpp-rotate-180
[120.251446] Subtest linear-32bpp-rotate-180: SUCCESS (1.798s)
[120.486181] [012/132] (901s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[120.566702] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[120.567636] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.001s)
[120.700349] [013/132] (901s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[120.908952] Starting subtest: short-flip-before-cursor-atomic-transitions
[121.938979] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (1.029s)
[122.216125] [014/132] (900s left) gem_barrier_race (remote-request)
[122.303167] Starting subtest: remote-request
[122.304077] Starting dynamic subtest: rcs0
[127.596496] Dynamic subtest rcs0: SUCCESS (5.293s)
[127.598349] Subtest remote-request: SUCCESS (5.293s)
[127.826835] [015/132] (894s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[128.039429] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[128.040296] Starting dynamic subtest: pipe-A-DP-4
[128.049057] Dynamic subtest pipe-A-DP-4: SKIP (0.000s)
[128.056524] Starting dynamic subtest: pipe-B-DP-4
[128.065170] Dynamic subtest pipe-B-DP-4: SKIP (0.000s)
[128.072590] Starting dynamic subtest: pipe-C-DP-4
[128.081056] Dynamic subtest pipe-C-DP-4: SKIP (0.000s)
[128.088461] Starting dynamic subtest: pipe-D-DP-4
[128.097148] Dynamic subtest pipe-D-DP-4: SKIP (0.000s)
[128.099101] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[128.485723] [016/132] (894s left) kms_plane_scaling (plane-downscale-factor-0-25-with-pixel-format)
[128.688418] Starting subtest: plane-downscale-factor-0-25-with-pixel-format
[128.689282] Starting dynamic subtest: pipe-A
[129.469778] Dynamic subtest pipe-A: SKIP (0.779s)
[129.477208] Starting dynamic subtest: pipe-B
[130.651214] Dynamic subtest pipe-B: SKIP (1.181s)
[130.659013] Starting dynamic subtest: pipe-C
[131.833471] Dynamic subtest pipe-C: SKIP (1.182s)
[131.840780] Starting dynamic subtest: pipe-D
[133.017652] Dynamic subtest pipe-D: SKIP (1.184s)
[133.019204] Subtest plane-downscale-factor-0-25-with-pixel-format: SKIP (4.328s)
[133.153537] [017/132] (889s left) prime_self_import (basic-with_fd_dup)
[133.212192] Starting subtest: basic-with_fd_dup
[133.255593] Subtest basic-with_fd_dup: SUCCESS (0.043s)
[133.369692] [018/132] (889s left) core_auth (getclient-master-drop)
[133.420597] Starting subtest: getclient-master-drop
[133.460263] Subtest getclient-master-drop: SUCCESS (0.041s)
[133.586839] [019/132] (889s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[133.799412] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[133.800173] Starting dynamic subtest: pipe-A
[133.893930] Dynamic subtest pipe-A: SUCCESS (0.095s)
[133.901417] Starting dynamic subtest: pipe-B
[134.097112] Dynamic subtest pipe-B: SUCCESS (0.202s)
[134.104496] Starting dynamic subtest: pipe-C
[134.300171] Dynamic subtest pipe-C: SUCCESS (0.202s)
[134.307568] Starting dynamic subtest: pipe-D
[134.502246] Dynamic subtest pipe-D: SUCCESS (0.201s)
[134.503107] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SUCCESS (0.704s)
[134.748185] [020/132] (888s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[134.954688] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[134.955579] Starting dynamic subtest: pipe-A-DP-4
[134.964245] Dynamic subtest pipe-A-DP-4: SKIP (0.000s)
[134.971842] Starting dynamic subtest: pipe-B-DP-4
[134.980507] Dynamic subtest pipe-B-DP-4: SKIP (0.000s)
[134.987980] Starting dynamic subtest: pipe-C-DP-4
[134.996460] Dynamic subtest pipe-C-DP-4: SKIP (0.000s)
[135.003579] Starting dynamic subtest: pipe-D-DP-4
[135.012164] Dynamic subtest pipe-D-DP-4: SKIP (0.000s)
[135.013921] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[135.427024] [021/132] (887s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[135.633682] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[135.634454] Starting dynamic subtest: pipe-A
[136.163488] Dynamic subtest pipe-A: SUCCESS (0.530s)
[136.184071] Starting dynamic subtest: pipe-B
[136.817284] Dynamic subtest pipe-B: SUCCESS (0.652s)
[136.839789] Starting dynamic subtest: pipe-C
[137.470290] Dynamic subtest pipe-C: SUCCESS (0.650s)
[137.493497] Starting dynamic subtest: pipe-D
[138.122265] Dynamic subtest pipe-D: SUCCESS (0.649s)
[138.123570] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (2.490s)
[138.475768] [022/132] (884s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[138.688088] Starting subtest: x-tiled-32bpp-rotate-270
[138.743509] Subtest x-tiled-32bpp-rotate-270: SKIP (0.055s)
[138.938960] [023/132] (884s left) gem_mmap_gtt (hang-busy)
[139.017317] Subtest hang-busy: SKIP (0.000s)
[139.085112] [024/132] (883s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[139.297997] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[139.299847] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[139.422312] [025/132] (883s left) perf_pmu (most-busy-idle-check-all)
[139.493307] Starting subtest: most-busy-idle-check-all
[139.494255] Starting dynamic subtest: rcs0
[140.197075] Dynamic subtest rcs0: SUCCESS (0.694s)
[140.218259] Starting dynamic subtest: bcs0
[140.843960] Dynamic subtest bcs0: SUCCESS (0.655s)
[140.853699] Starting dynamic subtest: vcs0
[141.496038] Dynamic subtest vcs0: SUCCESS (0.651s)
[141.505744] Starting dynamic subtest: vcs1
[142.151048] Dynamic subtest vcs1: SUCCESS (0.654s)
[142.160766] Starting dynamic subtest: vecs0
[142.804962] Dynamic subtest vecs0: SUCCESS (0.652s)
[142.823572] Starting dynamic subtest: vecs1
[143.465981] Dynamic subtest vecs1: SUCCESS (0.656s)
[143.484588] Starting dynamic subtest: ccs0
[144.129155] Dynamic subtest ccs0: SUCCESS (0.659s)
[144.130055] Subtest most-busy-idle-check-all: SUCCESS (4.636s)
[144.264132] [026/132] (878s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[144.474900] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[144.531767] [027/132] (878s left) gen7_exec_parse (bitmasks)
[144.615919] Subtest bitmasks: SKIP (0.000s)
[144.682739] [028/132] (878s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[144.892986] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[144.894827] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[145.026530] [029/132] (878s left) kms_setmode (invalid-clone-exclusive-crtc)
[145.101431] Starting subtest: invalid-clone-exclusive-crtc
[145.104172] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[145.230305] [030/132] (878s left) gem_ctx_persistence (heartbeat-stop)
[145.315130] Starting subtest: heartbeat-stop
[145.317027] Subtest heartbeat-stop: SKIP (0.000s)
[145.491954] [031/132] (877s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[145.703905] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[145.705633] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[145.813649] [032/132] (877s left) gem_userptr_blits (access-control)
[145.916041] Starting subtest: access-control
[145.917889] Subtest access-control: SKIP (0.000s)
[146.098692] [033/132] (877s left) kms_cursor_crc (cursor-suspend)
[146.347873] Starting subtest: cursor-suspend
[146.350219] Starting dynamic subtest: pipe-A-DP-4
[185.675888] Dynamic subtest pipe-A-DP-4: SUCCESS (8.042s)
[185.701831] Starting dynamic subtest: pipe-D-DP-4
[224.575679] Dynamic subtest pipe-D-DP-4: SUCCESS (7.625s)
[224.576670] Subtest cursor-suspend: SUCCESS (15.677s)
[229.099351] [034/132] (861s left) kms_flip (2x-wf_vblank-ts-check)
[229.322486] Starting subtest: 2x-wf_vblank-ts-check
[229.334910] Subtest 2x-wf_vblank-ts-check: SKIP (0.013s)
[229.437844] [035/132] (860s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[229.728881] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[229.916399] [036/132] (860s left) kms_async_flips (alternate-sync-async-flip-atomic)
[230.128237] Starting subtest: alternate-sync-async-flip-atomic
[230.360291] Starting dynamic subtest: pipe-A-DP-4
[232.632994] Dynamic subtest pipe-A-DP-4: SUCCESS (2.273s)
[232.876513] Starting dynamic subtest: pipe-B-DP-4
[235.004994] Dynamic subtest pipe-B-DP-4: SUCCESS (2.140s)
[235.215091] Starting dynamic subtest: pipe-C-DP-4
[237.339153] Dynamic subtest pipe-C-DP-4: SUCCESS (2.141s)
[237.577039] Starting dynamic subtest: pipe-D-DP-4
[239.675809] Dynamic subtest pipe-D-DP-4: SUCCESS (2.114s)
[239.676937] Subtest alternate-sync-async-flip-atomic: SUCCESS (9.565s)
[240.154141] [037/132] (850s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[242.765173] Starting subtest: verify-pxp-stale-buf-optout-execution
[242.767159] Subtest verify-pxp-stale-buf-optout-execution: SKIP (0.000s)
[242.863734] [038/132] (847s left) kms_chamelium_color (ctm-0-75)
[243.088684] Subtest ctm-0-75: SKIP (0.000s)
[243.147349] [039/132] (847s left) gem_ctx_isolation (dirty-create)
[243.238130] Starting subtest: dirty-create
[243.239051] Starting dynamic subtest: rcs0
[243.791321] Dynamic subtest rcs0: SUCCESS (0.554s)
[243.802124] Starting dynamic subtest: bcs0
[244.417204] Dynamic subtest bcs0: SUCCESS (0.626s)
[244.429172] Starting dynamic subtest: vcs0
[245.044980] Dynamic subtest vcs0: SUCCESS (0.628s)
[245.056828] Starting dynamic subtest: vcs1
[245.637136] Dynamic subtest vcs1: SUCCESS (0.592s)
[245.649009] Starting dynamic subtest: vecs0
[246.260022] Dynamic subtest vecs0: SUCCESS (0.623s)
[246.272354] Starting dynamic subtest: vecs1
[246.849796] Dynamic subtest vecs1: SUCCESS (0.589s)
[246.860828] Starting dynamic subtest: ccs0
[247.464139] Dynamic subtest ccs0: SUCCESS (0.614s)
[247.465081] Subtest dirty-create: SUCCESS (4.233s)
[247.770290] [040/132] (842s left) kms_rotation_crc (bad-pixel-format)
[247.986552] Starting subtest: bad-pixel-format
[247.988362] Subtest bad-pixel-format: SKIP (0.001s)
[248.079447] [041/132] (842s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[248.295644] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[248.342216] [042/132] (842s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[248.632911] Starting subtest: cursor-rapid-movement-32x10
[248.682895] Subtest cursor-rapid-movement-32x10: SKIP (0.048s)
[249.064718] [043/132] (841s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[249.288175] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[249.289952] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[249.411532] [044/132] (841s left) gem_eio (wait-wedge-immediate)
[249.684714] Starting subtest: wait-wedge-immediate
[251.450024] Subtest wait-wedge-immediate: SUCCESS (1.767s)
[251.677085] [045/132] (839s left) dmabuf_sync_file (export-before-signal)
[251.731586] Starting subtest: export-before-signal
[251.732414] Subtest export-before-signal: SUCCESS (0.001s)
[251.818363] [046/132] (839s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[252.033954] Starting subtest: psr-indfb-scaledprimary
[252.035733] Subtest psr-indfb-scaledprimary: SKIP (0.000s)
[252.158787] [047/132] (838s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[252.238260] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[252.239210] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[252.417555] [048/132] (838s left) gem_lmem_swapping (parallel-random-engines)
[255.474026] Starting subtest: parallel-random-engines
[255.475052] Starting dynamic subtest: lmem0
[290.580779] Dynamic subtest lmem0: SUCCESS (35.109s)
[290.582732] Subtest parallel-random-engines: SUCCESS (35.112s)
[292.015280] [FACT gem_lmem_swapping (parallel-random-engines)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[292.016297] [FACT gem_lmem_swapping (parallel-random-engines)] deleted: kernel.kmod_is_loaded.i915: true
[292.018265] [049/132] (799s left) kms_lease (invalid-create-leases)
[293.702803] Starting subtest: invalid-create-leases
[293.714948] Subtest invalid-create-leases: SUCCESS (0.012s)
[293.888714] [FACT kms_lease (invalid-create-leases)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[293.891860] [FACT kms_lease (invalid-create-leases)] new: kernel.kmod_is_loaded.i915: true
[293.895065] [050/132] (797s left) kms_pipe_stress (stress-xrgb8888-untiled)
[294.116830] Starting subtest: stress-xrgb8888-untiled
[302.092272] Subtest stress-xrgb8888-untiled: SUCCESS (7.977s)
[302.358749] [051/132] (788s left) gem_userptr_blits (usage-restrictions)
[302.443224] Starting subtest: usage-restrictions
[302.444096] Subtest usage-restrictions: SUCCESS (0.000s)
[302.625871] [052/132] (788s left) gem_exec_parallel (userptr)
[302.719647] Starting subtest: userptr
[302.720621] Starting dynamic subtest: rcs0
[304.268240] Dynamic subtest rcs0: SUCCESS (1.548s)
[304.281291] Starting dynamic subtest: bcs0
[305.769084] Dynamic subtest bcs0: SUCCESS (1.500s)
[305.780908] Starting dynamic subtest: vcs0
[307.240664] Dynamic subtest vcs0: SUCCESS (1.471s)
[307.251073] Starting dynamic subtest: vcs1
[308.759132] Dynamic subtest vcs1: SUCCESS (1.518s)
[308.772993] Starting dynamic subtest: vecs0
[310.250342] Dynamic subtest vecs0: SUCCESS (1.490s)
[310.263500] Starting dynamic subtest: vecs1
[311.754518] Dynamic subtest vecs1: SUCCESS (1.503s)
[311.768989] Starting dynamic subtest: ccs0
[313.249138] Dynamic subtest ccs0: SUCCESS (1.494s)
[313.250265] Subtest userptr: SUCCESS (10.533s)
[313.552556] [053/132] (777s left) syncobj_timeline (device-submit-unordered)
[313.630983] Starting subtest: device-submit-unordered
[313.631902] Subtest device-submit-unordered: SUCCESS (0.000s)
[313.784805] [054/132] (777s left) gem_exec_params (dr4-dirt)
[313.866219] Starting subtest: DR4-dirt
[313.867167] Subtest DR4-dirt: SUCCESS (0.000s)
[314.008793] [055/132] (777s left) kms_invalid_mode (zero-clock)
[314.215546] Starting subtest: zero-clock
[314.216390] Starting dynamic subtest: pipe-A-DP-4
[314.305783] Dynamic subtest pipe-A-DP-4: SUCCESS (0.088s)
[314.318594] Starting dynamic subtest: pipe-B-DP-4
[314.319781] Dynamic subtest pipe-B-DP-4: SUCCESS (0.001s)
[314.332278] Starting dynamic subtest: pipe-C-DP-4
[314.333406] Dynamic subtest pipe-C-DP-4: SUCCESS (0.001s)
[314.345298] Starting dynamic subtest: pipe-D-DP-4
[314.346243] Dynamic subtest pipe-D-DP-4: SUCCESS (0.001s)
[314.347145] Subtest zero-clock: SUCCESS (0.098s)
[314.556584] [056/132] (777s left) kms_content_protection (dp-mst-lic-type-1)
[314.816668] Starting subtest: dp-mst-lic-type-1
[314.818616] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[314.995645] [057/132] (776s left) gen9_exec_parse (bb-chained)
[315.080972] Subtest bb-chained: SKIP (0.000s)
[315.161784] [058/132] (776s left) kms_feature_discovery (psr1)
[315.380971] Starting subtest: psr1
[315.382774] Subtest psr1: SKIP (0.000s)
[315.462960] [059/132] (776s left) gem_pread (bench)
[315.543179] Subtest bench: SKIP (0.000s)
[315.657032] [060/132] (776s left) prime_mmap (test_forked)
[315.739177] Starting subtest: test_forked
[315.740078] Starting dynamic subtest: test_forked-smem
[315.798353] Dynamic subtest test_forked-smem: SUCCESS (0.059s)
[315.810163] Starting dynamic subtest: test_forked-lmem0
[316.022311] Dynamic subtest test_forked-lmem0: SUCCESS (0.215s)
[316.023306] Subtest test_forked: SUCCESS (0.275s)
[316.154022] [061/132] (775s left) prime_vgem (basic-write)
[316.251284] Starting subtest: basic-write
[316.270525] Subtest basic-write: SKIP (0.018s)
[316.415458] [062/132] (775s left) syncobj_timeline (signal)
[316.494642] Starting subtest: signal
[316.495553] Subtest signal: SUCCESS (0.000s)
[316.652875] [063/132] (775s left) gem_ctx_param (set-priority-range)
[316.740829] Starting subtest: set-priority-range
[316.764921] Subtest set-priority-range: SUCCESS (0.024s)
[316.944939] [064/132] (775s left) perf_pmu (busy-idle)
[317.020924] Starting subtest: busy-idle
[317.021905] Starting dynamic subtest: rcs0
[317.754795] Dynamic subtest rcs0: SUCCESS (0.732s)
[317.770889] Starting dynamic subtest: bcs0
[318.418960] Dynamic subtest bcs0: SUCCESS (0.659s)
[318.437296] Starting dynamic subtest: vcs0
[319.083785] Dynamic subtest vcs0: SUCCESS (0.660s)
[319.102838] Starting dynamic subtest: vcs1
[319.747896] Dynamic subtest vcs1: SUCCESS (0.659s)
[319.764332] Starting dynamic subtest: vecs0
[320.414721] Dynamic subtest vecs0: SUCCESS (0.662s)
[320.431250] Starting dynamic subtest: vecs1
[321.080892] Dynamic subtest vecs1: SUCCESS (0.661s)
[321.100134] Starting dynamic subtest: ccs0
[321.747632] Dynamic subtest ccs0: SUCCESS (0.662s)
[321.754674] Subtest busy-idle: SUCCESS (4.730s)
[321.919349] [065/132] (770s left) kms_flip (flip-vs-rmfb-interruptible)
[322.134910] Starting subtest: flip-vs-rmfb-interruptible
[322.140429] Starting dynamic subtest: A-DP4
[329.939234] Dynamic subtest A-DP4: SUCCESS (7.800s)
[329.977890] Starting dynamic subtest: B-DP4
[337.689399] Dynamic subtest B-DP4: SUCCESS (7.743s)
[337.732121] Starting dynamic subtest: C-DP4
[345.439321] Dynamic subtest C-DP4: SUCCESS (7.742s)
[345.475941] Starting dynamic subtest: D-DP4
[353.190876] Dynamic subtest D-DP4: SUCCESS (7.746s)
[353.194751] Subtest flip-vs-rmfb-interruptible: SUCCESS (31.056s)
[353.571923] [066/132] (738s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[353.780496] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[353.833689] [067/132] (738s left) i915_pm_rpm (debugfs-forcewake-user)
[355.594803] Starting subtest: debugfs-forcewake-user
[366.274297] Subtest debugfs-forcewake-user: SUCCESS (10.679s)
[366.598269] [068/132] (725s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[366.813959] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[366.815725] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[366.956722] [069/132] (725s left) gem_ctx_persistence (legacy-engines-cleanup)
[367.040993] Starting subtest: legacy-engines-cleanup
[367.041991] Starting dynamic subtest: render
[367.141140] Dynamic subtest render: SUCCESS (0.099s)
[367.156282] Starting dynamic subtest: bsd1
[367.191560] Dynamic subtest bsd1: SUCCESS (0.048s)
[367.232264] Starting dynamic subtest: bsd2
[367.249241] Dynamic subtest bsd2: SUCCESS (0.054s)
[367.268157] Starting dynamic subtest: blt
[367.291126] Dynamic subtest blt: SUCCESS (0.040s)
[367.307634] Starting dynamic subtest: vebox
[367.325953] Dynamic subtest vebox: SUCCESS (0.033s)
[367.326989] Subtest legacy-engines-cleanup: SUCCESS (0.286s)
[367.523801] [070/132] (725s left) kms_3d
[369.823754] [071/132] (722s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[370.046557] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[370.048447] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[370.170534] [072/132] (722s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[370.386281] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[372.946306] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (2.561s)
[373.175041] [073/132] (719s left) kms_psr (fbc-psr-sprite-blt)
[373.381593] Subtest fbc-psr-sprite-blt: SKIP (0.000s)
[373.437072] [074/132] (719s left) kms_scaling_modes (scaling-mode-none)
[373.652697] Starting subtest: scaling-mode-none
[373.657932] Subtest scaling-mode-none: SKIP (0.001s)
[373.741039] [075/132] (719s left) kms_dp_link_training (uhbr-mst)
[373.949391] Starting subtest: uhbr-mst
[373.951193] Subtest uhbr-mst: SKIP (0.000s)
[374.040319] [076/132] (718s left) gem_mmap_offset (partial-unmap)
[374.118159] Starting subtest: partial-unmap
[374.119025] Starting dynamic subtest: lmem0
[374.128897] Dynamic subtest lmem0: SUCCESS (0.011s)
[374.140604] Starting dynamic subtest: smem0
[374.141714] Dynamic subtest smem0: SUCCESS (0.004s)
[374.142827] Subtest partial-unmap: SUCCESS (0.016s)
[374.310124] [077/132] (718s left) drm_read (short-buffer-nonblock)
[374.595550] Starting subtest: short-buffer-nonblock
[374.596533] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[374.837773] [078/132] (718s left) i915_pm_rps (min-max-config-idle)
[374.923195] Starting subtest: min-max-config-idle
[374.925128] Subtest min-max-config-idle: SKIP (0.001s)
[375.054991] [079/132] (718s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[375.272679] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[375.273665] Starting dynamic subtest: pipe-A-valid-mode
[375.354804] Dynamic subtest pipe-A-valid-mode: SKIP (0.081s)
[375.356679] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.083s)
[375.576279] [080/132] (717s left) sysfs_timeslice_duration (timeout)
[375.665260] Starting subtest: timeout
[375.667823] Starting dynamic subtest: vecs0
[377.590072] Dynamic subtest vecs0: SUCCESS (1.923s)
[377.602593] Starting dynamic subtest: ccs0
[379.429245] Dynamic subtest ccs0: SUCCESS (1.838s)
[379.440965] Starting dynamic subtest: vcs0
[381.075901] Dynamic subtest vcs0: SUCCESS (1.646s)
[381.087233] Starting dynamic subtest: bcs0
[382.142096] Dynamic subtest bcs0: SUCCESS (1.065s)
[382.153961] Starting dynamic subtest: vecs1
[383.859065] Dynamic subtest vecs1: SUCCESS (1.716s)
[383.872062] Starting dynamic subtest: rcs0
[385.484927] Dynamic subtest rcs0: SUCCESS (1.624s)
[385.496338] Starting dynamic subtest: vcs1
[387.181064] Dynamic subtest vcs1: SUCCESS (1.695s)
[387.181989] Subtest timeout: SUCCESS (11.517s)
[387.316482] [081/132] (705s left) kms_psr (psr2-primary-mmap-gtt)
[387.523561] Subtest psr2-primary-mmap-gtt: SKIP (0.000s)
[387.573473] [082/132] (705s left) kms_addfb_basic (tile-pitch-mismatch)
[387.653159] Starting subtest: tile-pitch-mismatch
[387.654920] Subtest tile-pitch-mismatch: SKIP (0.000s)
[387.913329] [083/132] (705s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[388.124842] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[388.126579] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[388.265543] [084/132] (705s left) gem_exec_await (wide-all)
[388.523784] Starting subtest: wide-all
[410.725203] Subtest wide-all: SUCCESS (22.205s)
[410.990731] [085/132] (682s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[411.247844] Starting subtest: fbcpsr-rgb565-draw-pwrite
[411.249659] Subtest fbcpsr-rgb565-draw-pwrite: SKIP (0.000s)
[411.408786] [086/132] (682s left) kms_flip (2x-modeset-vs-vblank-race)
[411.615244] Starting subtest: 2x-modeset-vs-vblank-race
[411.628811] Subtest 2x-modeset-vs-vblank-race: SKIP (0.013s)
[411.732473] [087/132] (681s left) gem_exec_balancer (nohangcheck)
[412.105810] Starting subtest: nohangcheck
[413.398029] Subtest nohangcheck: SUCCESS (1.292s)
[413.557700] [088/132] (680s left) kms_psr (psr-cursor-render)
[413.767739] Subtest psr-cursor-render: SKIP (0.000s)
[413.819543] [089/132] (679s left) gem_exec_suspend (basic-s3)
[413.910963] Starting subtest: basic-S3
[413.911923] Starting dynamic subtest: smem
[436.352602] Dynamic subtest smem: SUCCESS (6.652s)
[436.364350] Starting dynamic subtest: lmem0
[458.325172] Dynamic subtest lmem0: SUCCESS (6.379s)
[458.326255] Subtest basic-S3: SUCCESS (13.033s)
[461.608024] [090/132] (666s left) kms_flip (plain-flip-fb-recreate-interruptible)
[461.818237] Starting subtest: plain-flip-fb-recreate-interruptible
[461.823660] Starting dynamic subtest: A-DP4
[469.953250] Dynamic subtest A-DP4: SUCCESS (8.130s)
[469.997737] Starting dynamic subtest: B-DP4
[478.021322] Dynamic subtest B-DP4: SUCCESS (8.064s)
[478.065134] Starting dynamic subtest: C-DP4
[486.074651] Dynamic subtest C-DP4: SUCCESS (8.065s)
[486.118672] Starting dynamic subtest: D-DP4
[494.136650] Dynamic subtest D-DP4: SUCCESS (8.065s)
[494.143123] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (32.352s)
[494.490220] [091/132] (633s left) gem_exec_balancer (bonded-true-hang)
[494.856508] Starting subtest: bonded-true-hang
[494.858326] Subtest bonded-true-hang: SKIP (0.000s)
[494.988959] [092/132] (633s left) gem_mmap (bad-object)
[495.074591] Subtest bad-object: SKIP (0.000s)
[495.169192] [093/132] (633s left) gem_mmap_gtt (basic-small-bo)
[495.248603] Subtest basic-small-bo: SKIP (0.000s)
[495.316356] [094/132] (633s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[495.535412] Starting subtest: y-tiled-64bpp-rotate-90
[495.537238] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[495.672910] [095/132] (632s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[495.887111] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[495.888884] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[496.021009] [096/132] (632s left) gem_softpin (zero)
[496.111107] Starting subtest: zero
[496.115493] Subtest zero: SUCCESS (0.004s)
[496.307729] [097/132] (632s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[496.518042] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[496.519860] Subtest psr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[496.685841] [098/132] (632s left) api_intel_allocator (reserve-simple)
[496.765377] Starting subtest: reserve-simple
[496.788843] Subtest reserve-simple: SUCCESS (0.024s)
[497.006361] [099/132] (631s left) drm_mm (drm_mm)
[497.072337] Starting subtest: drm_mm
[497.092833] Starting dynamic subtest: drm_test_mm_init
[497.252006] Dynamic subtest drm_test_mm_init: SUCCESS (0.144s)
[497.300187] Starting dynamic subtest: drm_test_mm_debug
[497.371877] Dynamic subtest drm_test_mm_debug: SUCCESS (0.117s)
[497.389139] Starting dynamic subtest: drm_test_mm_align32
[497.478398] Dynamic subtest drm_test_mm_align32: SUCCESS (0.109s)
[497.524938] Starting dynamic subtest: drm_test_mm_align64
[497.566210] Dynamic subtest drm_test_mm_align64: SUCCESS (0.086s)
[497.589444] Starting dynamic subtest: drm_test_mm_lowest
[497.675695] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.106s)
[497.722123] Starting dynamic subtest: drm_test_mm_highest
[497.793939] Dynamic subtest drm_test_mm_highest: SUCCESS (0.114s)
[497.795909] Subtest drm_mm: SUCCESS (0.723s)
[498.043412] [100/132] (630s left) syncobj_wait (single-wait-signaled)
[498.124429] Starting subtest: single-wait-signaled
[498.125352] Subtest single-wait-signaled: SUCCESS (0.000s)
[498.280012] [101/132] (630s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[498.489033] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[498.490812] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[498.617464] [102/132] (630s left) perf (invalid-remove-userspace-config)
[498.980168] Starting subtest: invalid-remove-userspace-config
[498.991680] Subtest invalid-remove-userspace-config: SUCCESS (0.012s)
[499.048193] [103/132] (630s left) perf (blocking-parameterized)
[499.250979] Starting subtest: blocking-parameterized
[519.285422] Subtest blocking-parameterized: SUCCESS (20.037s)
[519.346525] [104/132] (609s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[519.559246] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[519.561023] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[519.674543] [105/132] (609s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[519.889202] Starting subtest: yf-tiled-8bpp-rotate-270
[519.891011] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[520.011445] [106/132] (609s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[520.236130] Starting subtest: extended-modeset-hang-newfb-with-reset
[520.238376] Starting dynamic subtest: pipe-A
[541.376341] Dynamic subtest pipe-A: SUCCESS (21.138s)
[541.400535] Starting dynamic subtest: pipe-D
[562.406868] Dynamic subtest pipe-D: SUCCESS (21.031s)
[562.407800] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (42.178s)
[562.670359] [107/132] (566s left) kms_pm_rpm (dpms-non-lpsp)
[565.059131] Starting subtest: dpms-non-lpsp
[565.212547] Subtest dpms-non-lpsp: SUCCESS (0.154s)
[565.460004] [108/132] (563s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[565.670204] Starting subtest: cursorB-vs-flipA-legacy
[565.673275] Subtest cursorB-vs-flipA-legacy: SKIP (0.002s)
[565.756022] [109/132] (563s left) kms_plane_cursor (viewport)
[565.974898] Starting subtest: viewport
[565.976662] Starting dynamic subtest: pipe-A-DP-4-size-64
[569.507485] Dynamic subtest pipe-A-DP-4-size-64: SUCCESS (3.533s)
[569.616801] Starting dynamic subtest: pipe-A-DP-4-size-128
[573.073212] Dynamic subtest pipe-A-DP-4-size-128: SUCCESS (3.499s)
[573.155573] Starting dynamic subtest: pipe-A-DP-4-size-256
[576.673480] Dynamic subtest pipe-A-DP-4-size-256: SUCCESS (3.533s)
[576.851223] Starting dynamic subtest: pipe-B-DP-4-size-64
[580.500643] Dynamic subtest pipe-B-DP-4-size-64: SUCCESS (3.663s)
[580.563982] Starting dynamic subtest: pipe-B-DP-4-size-128
[584.018843] Dynamic subtest pipe-B-DP-4-size-128: SUCCESS (3.466s)
[584.106104] Starting dynamic subtest: pipe-B-DP-4-size-256
[587.619924] Dynamic subtest pipe-B-DP-4-size-256: SUCCESS (3.549s)
[587.781732] Starting dynamic subtest: pipe-C-DP-4-size-64
[591.396636] Dynamic subtest pipe-C-DP-4-size-64: SUCCESS (3.631s)
[591.495833] Starting dynamic subtest: pipe-C-DP-4-size-128
[594.947598] Dynamic subtest pipe-C-DP-4-size-128: SUCCESS (3.498s)
[595.022467] Starting dynamic subtest: pipe-C-DP-4-size-256
[598.547892] Dynamic subtest pipe-C-DP-4-size-256: SUCCESS (3.549s)
[598.707320] Starting dynamic subtest: pipe-D-DP-4-size-64
[602.335140] Dynamic subtest pipe-D-DP-4-size-64: SUCCESS (3.642s)
[602.397064] Starting dynamic subtest: pipe-D-DP-4-size-128
[605.885141] Dynamic subtest pipe-D-DP-4-size-128: SUCCESS (3.500s)
[605.958675] Starting dynamic subtest: pipe-D-DP-4-size-256
[609.485367] Dynamic subtest pipe-D-DP-4-size-256: SUCCESS (3.549s)
[609.597139] Subtest viewport: SUCCESS (43.617s)
[609.877187] [110/132] (519s left) kms_psr (pr-sprite-blt)
[610.082251] Subtest pr-sprite-blt: SKIP (0.000s)
[610.144303] [111/132] (519s left) perf (invalid-open-flags)
[610.320220] Starting subtest: invalid-open-flags
[610.321101] Subtest invalid-open-flags: SUCCESS (0.000s)
[610.380133] [112/132] (519s left) tools_test (tools_test)
[610.438996] Starting subtest: tools_test
[610.512470] Subtest tools_test: SUCCESS (0.081s)
[610.590592] [113/132] (519s left) gem_render_tiled_blits (basic)
[610.672823] Subtest basic: SKIP (0.000s)
[610.797337] [114/132] (519s left) kms_color (ctm-0-25)
[611.005770] Starting subtest: ctm-0-25
[611.006673] Starting dynamic subtest: pipe-A-DP-4
[612.778540] Dynamic subtest pipe-A-DP-4: SUCCESS (1.771s)
[612.799461] Starting dynamic subtest: pipe-B-DP-4
[614.472605] Dynamic subtest pipe-B-DP-4: SUCCESS (1.691s)
[614.496132] Starting dynamic subtest: pipe-C-DP-4
[616.167134] Dynamic subtest pipe-C-DP-4: SUCCESS (1.694s)
[616.182422] Starting dynamic subtest: pipe-D-DP-4
[617.849107] Dynamic subtest pipe-D-DP-4: SUCCESS (1.681s)
[617.850136] Subtest ctm-0-25: SUCCESS (6.844s)
[618.145163] [115/132] (511s left) kms_cursor_crc (cursor-offscreen-128x42)
[618.509031] Starting subtest: cursor-offscreen-128x42
[618.514225] Starting dynamic subtest: pipe-A-DP-4
[620.993798] Dynamic subtest pipe-A-DP-4: SUCCESS (2.478s)
[621.048450] Starting dynamic subtest: pipe-D-DP-4
[623.499924] Dynamic subtest pipe-D-DP-4: SUCCESS (2.462s)
[623.501249] Subtest cursor-offscreen-128x42: SUCCESS (4.991s)
[623.900444] [116/132] (506s left) gem_exec_whisper (basic-contexts-priority-all)
[623.995833] Starting subtest: basic-contexts-priority-all
[646.277138] Subtest basic-contexts-priority-all: SUCCESS (22.283s)
[646.502257] [117/132] (483s left) kms_addfb_basic (unused-pitches)
[646.582534] Starting subtest: unused-pitches
[646.583486] Subtest unused-pitches: SUCCESS (0.000s)
[646.894676] [118/132] (483s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[647.102516] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[647.103473] Starting dynamic subtest: pipe-A-DP-4
[647.378647] Dynamic subtest pipe-A-DP-4: SUCCESS (0.256s)
[647.407412] Starting dynamic subtest: pipe-B-DP-4
[647.766211] Dynamic subtest pipe-B-DP-4: SUCCESS (0.379s)
[647.795476] Starting dynamic subtest: pipe-C-DP-4
[648.133912] Dynamic subtest pipe-C-DP-4: SUCCESS (0.361s)
[648.161921] Starting dynamic subtest: pipe-D-DP-4
[648.520838] Dynamic subtest pipe-D-DP-4: SUCCESS (0.379s)
[648.522787] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SUCCESS (1.402s)
[648.903214] [119/132] (481s left) gem_exec_nop (basic-parallel)
[648.993038] Starting subtest: basic-parallel
[653.398383] Subtest basic-parallel: SUCCESS (4.406s)
[653.696997] [120/132] (476s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[653.914980] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[654.548345] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.633s)
[654.774099] [121/132] (475s left) gem_exec_schedule (smoketest)
[654.984064] Starting subtest: smoketest
[654.985028] Starting dynamic subtest: rcs0
[660.448513] Dynamic subtest rcs0: SUCCESS (5.459s)
[660.462530] Starting dynamic subtest: bcs0
[665.903345] Dynamic subtest bcs0: SUCCESS (5.455s)
[665.917187] Starting dynamic subtest: vcs0
[671.356366] Dynamic subtest vcs0: SUCCESS (5.454s)
[671.370907] Starting dynamic subtest: vcs1
[676.810159] Dynamic subtest vcs1: SUCCESS (5.453s)
[676.823539] Starting dynamic subtest: vecs0
[682.269577] Dynamic subtest vecs0: SUCCESS (5.461s)
[682.284176] Starting dynamic subtest: vecs1
[687.717473] Dynamic subtest vecs1: SUCCESS (5.448s)
[687.730699] Starting dynamic subtest: ccs0
[693.177793] Dynamic subtest ccs0: SUCCESS (5.459s)
[693.178701] Subtest smoketest: SUCCESS (38.196s)
[693.503637] [122/132] (436s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[693.724897] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[693.726835] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[693.858813] [123/132] (436s left) syncobj_timeline (wait-for-submit-complex)
[693.943231] Starting subtest: wait-for-submit-complex
[694.007585] Subtest wait-for-submit-complex: SUCCESS (0.064s)
[694.157781] [124/132] (436s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[694.366201] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[694.367953] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[694.485165] [125/132] (436s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[694.694378] Starting subtest: flip-vs-cursor-crc-legacy
[695.244161] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.549s)
[695.520159] [126/132] (435s left) gem_softpin (allocator-basic-reserve)
[695.602514] Starting subtest: allocator-basic-reserve
[695.765321] Subtest allocator-basic-reserve: SUCCESS (0.162s)
[695.979860] [127/132] (434s left) gem_exec_capture (capture)
[696.069463] Starting subtest: capture
[696.070365] Starting dynamic subtest: rcs0-smem
[697.036610] Dynamic subtest rcs0-smem: SUCCESS (0.967s)
[697.050512] Starting dynamic subtest: rcs0-lmem0
[697.988442] Dynamic subtest rcs0-lmem0: SUCCESS (0.951s)
[698.001770] Starting dynamic subtest: bcs0-smem
[698.907449] Dynamic subtest bcs0-smem: SUCCESS (0.918s)
[698.920708] Starting dynamic subtest: bcs0-lmem0
[699.829184] Dynamic subtest bcs0-lmem0: SUCCESS (0.919s)
[699.842298] Starting dynamic subtest: vcs0-smem
[700.742455] Dynamic subtest vcs0-smem: SUCCESS (0.915s)
[700.755789] Starting dynamic subtest: vcs0-lmem0
[701.654506] Dynamic subtest vcs0-lmem0: SUCCESS (0.911s)
[701.668009] Starting dynamic subtest: vcs1-smem
[703.068502] Dynamic subtest vcs1-smem: SUCCESS (1.413s)
[703.082029] Starting dynamic subtest: vcs1-lmem0
[704.190750] Dynamic subtest vcs1-lmem0: SUCCESS (1.121s)
[704.204019] Starting dynamic subtest: vecs0-smem
[705.134787] Dynamic subtest vecs0-smem: FAIL (0.923s)
[705.147650] Starting dynamic subtest: vecs0-lmem0
[706.139269] Dynamic subtest vecs0-lmem0: FAIL (1.001s)
[706.152096] Starting dynamic subtest: vecs1-smem
[707.565840] Dynamic subtest vecs1-smem: FAIL (1.424s)
[707.578717] Starting dynamic subtest: vecs1-lmem0
[708.565943] Dynamic subtest vecs1-lmem0: FAIL (0.998s)
[708.578842] Starting dynamic subtest: ccs0-smem
[709.961388] Dynamic subtest ccs0-smem: SUCCESS (1.417s)
[709.974766] Starting dynamic subtest: ccs0-lmem0
[710.885552] Dynamic subtest ccs0-lmem0: SUCCESS (0.922s)
[710.886513] Subtest capture: FAIL (14.816s)
[711.005725] [128/132] (419s left) gem_exec_schedule (noreorder-priority)
[711.212251] Starting subtest: noreorder-priority
[711.213275] Starting dynamic subtest: rcs0
[712.379904] Dynamic subtest rcs0: SUCCESS (1.167s)
[712.397636] Starting dynamic subtest: bcs0
[713.518478] Dynamic subtest bcs0: SUCCESS (1.137s)
[713.534566] Starting dynamic subtest: vcs0
[714.644551] Dynamic subtest vcs0: SUCCESS (1.124s)
[714.658584] Starting dynamic subtest: vcs1
[715.777424] Dynamic subtest vcs1: SUCCESS (1.131s)
[715.791564] Starting dynamic subtest: vecs0
[716.917475] Dynamic subtest vecs0: SUCCESS (1.139s)
[716.934552] Starting dynamic subtest: vecs1
[718.060420] Dynamic subtest vecs1: SUCCESS (1.141s)
[718.075773] Starting dynamic subtest: ccs0
[719.161444] Dynamic subtest ccs0: SUCCESS (1.099s)
[719.162361] Subtest noreorder-priority: SUCCESS (7.947s)
[719.405052] [129/132] (411s left) gem_tiled_wb
[719.571855] [130/132] (411s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[719.778440] Starting subtest: psr-farfromfence-mmap-gtt
[719.780134] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[719.931782] [131/132] (411s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[720.140995] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[720.142881] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[720.275158] [132/132] (410s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[720.357360] Starting subtest: etime-single-wait-all-available-unsubmitted
[720.467262] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.107s)
[720.621733] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_flip_scaled_crc
results: parsing output: 3/ for test: kms_tv_load_detect
results: parsing output: 4/ for test: kms_vblank
results: parsing output: 5/ for test: kms_psr
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_exec_fence
results: parsing output: 8/ for test: intel_hwmon
results: parsing output: 9/ for test: kms_atomic
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: kms_cursor_legacy
results: parsing output: 13/ for test: gem_barrier_race
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: kms_plane_scaling
results: parsing output: 16/ for test: prime_self_import
results: parsing output: 17/ for test: core_auth
results: parsing output: 18/ for test: kms_plane_scaling
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: kms_plane_scaling
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: gem_mmap_gtt
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: perf_pmu
results: parsing output: 25/ for test: kms_psr2_sf
results: parsing output: 26/ for test: gen7_exec_parse
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_setmode
results: parsing output: 29/ for test: gem_ctx_persistence
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_userptr_blits
results: parsing output: 32/ for test: kms_cursor_crc
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: kms_chamelium_hpd
results: parsing output: 35/ for test: kms_async_flips
results: parsing output: 36/ for test: gem_pxp
results: parsing output: 37/ for test: kms_chamelium_color
results: parsing output: 38/ for test: gem_ctx_isolation
results: parsing output: 39/ for test: kms_rotation_crc
results: parsing output: 40/ for test: kms_psr2_sf
results: parsing output: 41/ for test: kms_cursor_crc
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: gem_eio
results: parsing output: 44/ for test: dmabuf_sync_file
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: gem_lmem_swapping
results: parsing output: 48/ for test: kms_lease
results: parsing output: 49/ for test: kms_pipe_stress
results: parsing output: 50/ for test: gem_userptr_blits
results: parsing output: 51/ for test: gem_exec_parallel
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: gem_exec_params
results: parsing output: 54/ for test: kms_invalid_mode
results: parsing output: 55/ for test: kms_content_protection
results: parsing output: 56/ for test: gen9_exec_parse
results: parsing output: 57/ for test: kms_feature_discovery
results: parsing output: 58/ for test: gem_pread
results: parsing output: 59/ for test: prime_mmap
results: parsing output: 60/ for test: prime_vgem
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: gem_ctx_param
results: parsing output: 63/ for test: perf_pmu
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: i915_pm_rpm
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_ctx_persistence
results: parsing output: 69/ for test: kms_3d
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: kms_scaling_modes
results: parsing output: 74/ for test: kms_dp_link_training
results: parsing output: 75/ for test: gem_mmap_offset
results: parsing output: 76/ for test: drm_read
results: parsing output: 77/ for test: i915_pm_rps
results: parsing output: 78/ for test: kms_flip_scaled_crc
results: parsing output: 79/ for test: sysfs_timeslice_duration
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: kms_addfb_basic
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_exec_await
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_flip
results: parsing output: 86/ for test: gem_exec_balancer
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: gem_exec_suspend
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: gem_exec_balancer
results: parsing output: 91/ for test: gem_mmap
results: parsing output: 92/ for test: gem_mmap_gtt
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_softpin
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: api_intel_allocator
results: parsing output: 98/ for test: drm_mm
results: parsing output: 99/ for test: syncobj_wait
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: perf
results: parsing output: 102/ for test: perf
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: kms_busy
results: parsing output: 106/ for test: kms_pm_rpm
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: kms_plane_cursor
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: perf
results: parsing output: 111/ for test: tools_test
results: parsing output: 112/ for test: gem_render_tiled_blits
results: parsing output: 113/ for test: kms_color
results: parsing output: 114/ for test: kms_cursor_crc
results: parsing output: 115/ for test: gem_exec_whisper
results: parsing output: 116/ for test: kms_addfb_basic
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: gem_exec_nop
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: gem_exec_schedule
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: gem_softpin
results: parsing output: 126/ for test: gem_exec_capture
results: parsing output: 127/ for test: gem_exec_schedule
results: parsing output: 128/ for test: gem_tiled_wb
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: syncobj_timeline
Done.