[57.154922] Initializing watchdogs
[57.155121]   /dev/watchdog0
[57.168794] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.172823] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.175090] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.178338] [001/132] (960s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[57.292347] Starting subtest: fbcpsr-rgb101010-draw-blt
[64.013840] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.753s)
[64.128952] [002/132] (953s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[64.219952] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[64.222336] Starting dynamic subtest: pipe-A-eDP-1
[64.245626] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[64.253212] Starting dynamic subtest: pipe-B-eDP-1
[64.274770] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[64.280528] Starting dynamic subtest: pipe-C-eDP-1
[64.302940] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[64.311066] Starting dynamic subtest: pipe-D-eDP-1
[64.334091] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[64.338560] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.002s)
[66.405165] [003/132] (951s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[66.504038] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[66.506452] Starting dynamic subtest: pipe-A-default-mode
[66.806923] Dynamic subtest pipe-A-default-mode: SKIP (0.291s)
[66.811688] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.293s)
[67.622829] [004/132] (950s left) kms_tv_load_detect (load-detect)
[67.680060] Subtest load-detect: SKIP (0.000s)
[67.742013] [005/132] (950s left) kms_vblank (wait-forked-busy-hang)
[67.840832] Starting subtest: wait-forked-busy-hang
[67.843120] Starting dynamic subtest: pipe-A-eDP-1
[94.687058] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.857s)
[94.698291] Starting dynamic subtest: pipe-D-eDP-1
[119.642236] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.953s)
[119.644907] Subtest wait-forked-busy-hang: SUCCESS (51.813s)
[120.445810] [006/132] (897s left) kms_psr (fbc-pr-primary-page-flip)
[120.543952] Starting subtest: fbc-pr-primary-page-flip
[120.548719] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[120.607567] [007/132] (897s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[120.706849] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[120.711053] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[120.778187] [008/132] (897s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[121.319065] Starting subtest: syncobj-timeline-multiple-ext-nodes
[121.322247] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.004s)
[122.995677] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true
[122.998758] [009/132] (894s left) intel_hwmon (hwmon-read)
[123.054055] Subtest hwmon-read: SKIP (0.000s)
[123.115418] [010/132] (894s left) kms_atomic (test-only)
[123.213868] Starting subtest: test-only
[123.295073] Starting dynamic subtest: pipe-A-eDP-1
[125.634677] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.337s)
[125.636684] Subtest test-only: SUCCESS (2.418s)
[126.426367] [011/132] (891s left) kms_big_fb (linear-32bpp-rotate-180)
[126.539065] Starting subtest: linear-32bpp-rotate-180
[128.283105] Subtest linear-32bpp-rotate-180: SUCCESS (1.744s)
[128.428461] [012/132] (889s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[128.489096] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[128.491114] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.001s)
[128.615350] [013/132] (889s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[128.728152] Starting subtest: short-flip-before-cursor-atomic-transitions
[129.689696] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.959s)
[130.548194] [014/132] (887s left) gem_barrier_race (remote-request)
[130.615196] Starting subtest: remote-request
[130.617582] Starting dynamic subtest: rcs0
[135.837585] Dynamic subtest rcs0: SUCCESS (5.225s)
[135.841331] Subtest remote-request: SUCCESS (5.225s)
[135.971533] [015/132] (882s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[136.074576] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[136.076682] Starting dynamic subtest: pipe-A-eDP-1
[136.098128] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[136.106531] Starting dynamic subtest: pipe-B-eDP-1
[136.125362] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[136.132077] Starting dynamic subtest: pipe-C-eDP-1
[136.149197] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[136.154914] Starting dynamic subtest: pipe-D-eDP-1
[136.172247] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[136.175669] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.002s)
[138.193039] [016/132] (879s left) kms_plane_scaling (plane-downscale-factor-0-25-with-pixel-format)
[138.286865] Starting subtest: plane-downscale-factor-0-25-with-pixel-format
[138.289188] Starting dynamic subtest: pipe-A
[138.303752] Dynamic subtest pipe-A: SKIP (0.011s)
[138.311228] Starting dynamic subtest: pipe-B
[138.326683] Dynamic subtest pipe-B: SKIP (0.023s)
[138.333618] Starting dynamic subtest: pipe-C
[138.348257] Dynamic subtest pipe-C: SKIP (0.022s)
[138.354841] Starting dynamic subtest: pipe-D
[138.368717] Dynamic subtest pipe-D: SKIP (0.019s)
[138.373057] Subtest plane-downscale-factor-0-25-with-pixel-format: SKIP (0.076s)
[138.454579] [017/132] (879s left) prime_self_import (basic-with_fd_dup)
[138.490667] Starting subtest: basic-with_fd_dup
[138.511082] Subtest basic-with_fd_dup: SUCCESS (0.019s)
[138.601831] [018/132] (879s left) core_auth (getclient-master-drop)
[138.634646] Starting subtest: getclient-master-drop
[138.663874] Subtest getclient-master-drop: SUCCESS (0.028s)
[138.794167] [019/132] (879s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[138.897889] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[138.900314] Starting dynamic subtest: pipe-A
[138.918613] Dynamic subtest pipe-A: SKIP (0.014s)
[138.926481] Starting dynamic subtest: pipe-B
[138.947033] Dynamic subtest pipe-B: SKIP (0.029s)
[138.953917] Starting dynamic subtest: pipe-C
[138.975776] Dynamic subtest pipe-C: SKIP (0.028s)
[138.982289] Starting dynamic subtest: pipe-D
[139.003055] Dynamic subtest pipe-D: SKIP (0.026s)
[139.006655] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.099s)
[139.100475] [020/132] (879s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[139.202427] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[139.204342] Starting dynamic subtest: pipe-A-eDP-1
[139.222764] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[139.230255] Starting dynamic subtest: pipe-B-eDP-1
[139.247246] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[139.254295] Starting dynamic subtest: pipe-C-eDP-1
[139.271567] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[139.277151] Starting dynamic subtest: pipe-D-eDP-1
[139.295783] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[139.299490] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.002s)
[141.349158] [021/132] (876s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[141.451859] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[141.454252] Starting dynamic subtest: pipe-A
[141.790770] Dynamic subtest pipe-A: SUCCESS (0.339s)
[141.800614] Starting dynamic subtest: pipe-B
[143.145123] Dynamic subtest pipe-B: SUCCESS (1.354s)
[143.153092] Starting dynamic subtest: pipe-C
[144.572660] Dynamic subtest pipe-C: SUCCESS (1.427s)
[144.581208] Starting dynamic subtest: pipe-D
[145.989998] Dynamic subtest pipe-D: SUCCESS (1.417s)
[145.992398] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.538s)
[147.148740] [022/132] (871s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[147.263234] Starting subtest: x-tiled-32bpp-rotate-270
[147.285111] Subtest x-tiled-32bpp-rotate-270: SKIP (0.022s)
[147.432697] [023/132] (870s left) gem_mmap_gtt (hang-busy)
[147.495818] Subtest hang-busy: SKIP (0.000s)
[147.547427] [024/132] (870s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[147.651495] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[147.656071] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[147.760576] [025/132] (870s left) perf_pmu (most-busy-idle-check-all)
[147.802242] Starting subtest: most-busy-idle-check-all
[147.804075] Starting dynamic subtest: rcs0
[148.906668] Dynamic subtest rcs0: SUCCESS (1.104s)
[148.918221] Starting dynamic subtest: bcs0
[150.955078] Dynamic subtest bcs0: SUCCESS (2.046s)
[150.965625] Starting dynamic subtest: vcs0
[152.939386] Dynamic subtest vcs0: SUCCESS (1.984s)
[152.948770] Starting dynamic subtest: vcs1
[154.922088] Dynamic subtest vcs1: SUCCESS (1.981s)
[154.931817] Starting dynamic subtest: vecs0
[156.906113] Dynamic subtest vecs0: SUCCESS (1.983s)
[156.916035] Starting dynamic subtest: ccs0
[158.953670] Dynamic subtest ccs0: SUCCESS (2.046s)
[158.956457] Subtest most-busy-idle-check-all: SUCCESS (11.150s)
[159.073857] [026/132] (859s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[164.093260] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[164.098634] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[164.945433] [027/132] (853s left) gen7_exec_parse (bitmasks)
[165.007877] Subtest bitmasks: SKIP (0.000s)
[165.083633] [028/132] (853s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[165.197203] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[165.201472] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[165.314255] [029/132] (853s left) kms_setmode (invalid-clone-exclusive-crtc)
[165.358320] Starting subtest: invalid-clone-exclusive-crtc
[165.365273] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[165.450876] [030/132] (853s left) gem_ctx_persistence (heartbeat-stop)
[165.503669] Starting subtest: heartbeat-stop
[165.507954] Subtest heartbeat-stop: SKIP (0.000s)
[165.602910] [031/132] (853s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[165.700081] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[165.704034] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[165.800140] [032/132] (852s left) gem_userptr_blits (access-control)
[165.870999] Starting subtest: access-control
[165.875082] Subtest access-control: SKIP (0.000s)
[165.995778] [033/132] (852s left) kms_cursor_crc (cursor-suspend)
[166.103751] Starting subtest: cursor-suspend
[166.105672] Starting dynamic subtest: pipe-A-eDP-1
[199.084744] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.154s)
[199.097254] Starting dynamic subtest: pipe-D-eDP-1
[232.054610] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.591s)
[232.056888] Subtest cursor-suspend: SUCCESS (6.747s)
[232.832581] [034/132] (845s left) kms_flip (2x-wf_vblank-ts-check)
[232.938198] Starting subtest: 2x-wf_vblank-ts-check
[232.948307] Subtest 2x-wf_vblank-ts-check: SKIP (0.010s)
[233.053402] [035/132] (844s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[233.418472] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[234.218298] [036/132] (843s left) kms_async_flips (alternate-sync-async-flip-atomic)
[234.315265] Starting subtest: alternate-sync-async-flip-atomic
[234.682783] Starting dynamic subtest: pipe-A-eDP-1
[237.411422] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.753s)
[237.787104] Starting dynamic subtest: pipe-B-eDP-1
[240.525513] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.763s)
[240.886869] Starting dynamic subtest: pipe-C-eDP-1
[243.635381] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.767s)
[243.999333] Starting dynamic subtest: pipe-D-eDP-1
[246.760601] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.776s)
[246.762789] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.512s)
[247.909451] [037/132] (830s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[248.036597] Starting subtest: verify-pxp-stale-buf-optout-execution
[249.094090] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.061s)
[249.217527] [038/132] (828s left) kms_chamelium_color (ctm-0-75)
[249.308315] Subtest ctm-0-75: SKIP (0.000s)
[249.346997] [039/132] (828s left) gem_ctx_isolation (dirty-create)
[249.404603] Starting subtest: dirty-create
[249.406910] Starting dynamic subtest: rcs0
[249.791970] Dynamic subtest rcs0: SUCCESS (0.388s)
[249.802618] Starting dynamic subtest: bcs0
[250.195466] Dynamic subtest bcs0: SUCCESS (0.404s)
[250.205520] Starting dynamic subtest: vcs0
[250.644320] Dynamic subtest vcs0: SUCCESS (0.449s)
[250.654434] Starting dynamic subtest: vcs1
[252.631854] Dynamic subtest vcs1: SUCCESS (1.989s)
[252.642100] Starting dynamic subtest: vecs0
[254.636801] Dynamic subtest vecs0: SUCCESS (2.007s)
[254.646436] Starting dynamic subtest: ccs0
[256.593454] Dynamic subtest ccs0: SUCCESS (1.958s)
[256.595774] Subtest dirty-create: SUCCESS (7.199s)
[256.865822] [040/132] (821s left) kms_rotation_crc (bad-pixel-format)
[256.960137] Starting subtest: bad-pixel-format
[256.964589] Subtest bad-pixel-format: SKIP (0.001s)
[257.030881] [041/132] (821s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[262.034831] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[262.040010] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.002s)
[262.884623] [042/132] (815s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[263.024208] Starting subtest: cursor-rapid-movement-32x10
[263.060926] Subtest cursor-rapid-movement-32x10: SKIP (0.034s)
[263.310069] [043/132] (814s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[263.407074] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[263.411336] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[263.514872] [044/132] (814s left) gem_eio (wait-wedge-immediate)
[263.731128] Starting subtest: wait-wedge-immediate
[265.242947] Subtest wait-wedge-immediate: SUCCESS (1.508s)
[265.390231] [045/132] (812s left) dmabuf_sync_file (export-before-signal)
[265.428410] Starting subtest: export-before-signal
[265.430754] Subtest export-before-signal: SUCCESS (0.001s)
[265.476706] [046/132] (812s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[265.569745] Starting subtest: psr-indfb-scaledprimary
[271.287204] Subtest psr-indfb-scaledprimary: SUCCESS (5.719s)
[271.419229] [047/132] (806s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[271.479427] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[271.481732] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[271.559465] [048/132] (806s left) gem_lmem_swapping (parallel-random-engines)
[271.602974] Subtest parallel-random-engines: SKIP (0.000s)
[271.637693] [049/132] (806s left) kms_lease (invalid-create-leases)
[271.737698] Starting subtest: invalid-create-leases
[271.743403] Subtest invalid-create-leases: SUCCESS (0.005s)
[271.861487] [050/132] (806s left) kms_pipe_stress (stress-xrgb8888-untiled)
[271.962586] Starting subtest: stress-xrgb8888-untiled
[277.962871] Subtest stress-xrgb8888-untiled: SUCCESS (6.000s)
[278.013545] [051/132] (800s left) gem_userptr_blits (usage-restrictions)
[278.087775] Starting subtest: usage-restrictions
[278.089320] Subtest usage-restrictions: SUCCESS (0.000s)
[278.235659] [052/132] (800s left) gem_exec_parallel (userptr)
[278.291279] Starting subtest: userptr
[278.293234] Starting dynamic subtest: rcs0
[279.743182] Dynamic subtest rcs0: SUCCESS (1.451s)
[279.753170] Starting dynamic subtest: bcs0
[281.239758] Dynamic subtest bcs0: SUCCESS (1.495s)
[281.249223] Starting dynamic subtest: vcs0
[283.158632] Dynamic subtest vcs0: SUCCESS (1.916s)
[283.167233] Starting dynamic subtest: vcs1
[285.143410] Dynamic subtest vcs1: SUCCESS (1.983s)
[285.154492] Starting dynamic subtest: vecs0
[287.140847] Dynamic subtest vecs0: SUCCESS (1.995s)
[287.149811] Starting dynamic subtest: ccs0
[288.613567] Dynamic subtest ccs0: SUCCESS (1.472s)
[288.615924] Subtest userptr: SUCCESS (10.324s)
[288.797048] [053/132] (789s left) syncobj_timeline (device-submit-unordered)
[288.852568] Starting subtest: device-submit-unordered
[288.854962] Subtest device-submit-unordered: SUCCESS (0.000s)
[288.950884] [054/132] (789s left) gem_exec_params (dr4-dirt)
[289.004222] Starting subtest: DR4-dirt
[289.006743] Subtest DR4-dirt: SUCCESS (0.000s)
[289.108942] [055/132] (789s left) kms_invalid_mode (zero-clock)
[289.208442] Starting subtest: zero-clock
[289.210701] Starting dynamic subtest: pipe-A-eDP-1
[289.504529] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.295s)
[289.514408] Starting dynamic subtest: pipe-B-eDP-1
[289.516345] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[289.523847] Starting dynamic subtest: pipe-C-eDP-1
[289.526215] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[289.536131] Starting dynamic subtest: pipe-D-eDP-1
[289.538671] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[289.541088] Subtest zero-clock: SUCCESS (0.300s)
[290.304329] [056/132] (788s left) kms_content_protection (dp-mst-lic-type-1)
[290.469796] Starting subtest: dp-mst-lic-type-1
[290.474462] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[290.587729] [057/132] (788s left) gen9_exec_parse (bb-chained)
[290.647287] Subtest bb-chained: SKIP (0.000s)
[290.720435] [058/132] (787s left) kms_feature_discovery (psr1)
[290.821121] Starting subtest: psr1
[290.823253] Subtest psr1: SUCCESS (0.000s)
[290.885572] [059/132] (787s left) gem_pread (bench)
[290.942879] Subtest bench: SKIP (0.000s)
[290.989469] [060/132] (787s left) prime_mmap (test_forked)
[291.037161] Starting subtest: test_forked
[291.039734] Starting dynamic subtest: test_forked-smem
[291.079084] Dynamic subtest test_forked-smem: SUCCESS (0.043s)
[291.082174] Subtest test_forked: SUCCESS (0.044s)
[291.179960] [061/132] (787s left) prime_vgem (basic-write)
[291.255018] Starting subtest: basic-write
[291.279793] Subtest basic-write: SKIP (0.015s)
[291.390432] [062/132] (787s left) syncobj_timeline (signal)
[291.449226] Starting subtest: signal
[291.451244] Subtest signal: SUCCESS (0.000s)
[291.537082] [063/132] (787s left) gem_ctx_param (set-priority-range)
[291.591185] Starting subtest: set-priority-range
[291.611259] Subtest set-priority-range: SUCCESS (0.020s)
[291.722461] [064/132] (787s left) perf_pmu (busy-idle)
[291.760748] Starting subtest: busy-idle
[291.762797] Starting dynamic subtest: rcs0
[292.476577] Dynamic subtest rcs0: SUCCESS (0.718s)
[292.486778] Starting dynamic subtest: bcs0
[293.148453] Dynamic subtest bcs0: SUCCESS (0.670s)
[293.167479] Starting dynamic subtest: vcs0
[295.190812] Dynamic subtest vcs0: SUCCESS (2.040s)
[295.200809] Starting dynamic subtest: vcs1
[297.174509] Dynamic subtest vcs1: SUCCESS (1.982s)
[297.184834] Starting dynamic subtest: vecs0
[299.159513] Dynamic subtest vecs0: SUCCESS (1.983s)
[299.171717] Starting dynamic subtest: ccs0
[299.836774] Dynamic subtest ccs0: SUCCESS (0.676s)
[299.839312] Subtest busy-idle: SUCCESS (8.080s)
[299.951231] [065/132] (778s left) kms_flip (flip-vs-rmfb-interruptible)
[300.052639] Starting subtest: flip-vs-rmfb-interruptible
[300.054554] Starting dynamic subtest: A-eDP1
[308.687574] Dynamic subtest A-eDP1: SUCCESS (8.636s)
[308.697289] Starting dynamic subtest: B-eDP1
[317.306398] Dynamic subtest B-eDP1: SUCCESS (8.620s)
[317.315420] Starting dynamic subtest: C-eDP1
[325.948298] Dynamic subtest C-eDP1: SUCCESS (8.644s)
[325.956208] Starting dynamic subtest: D-eDP1
[334.647871] Dynamic subtest D-eDP1: SUCCESS (8.694s)
[334.653375] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.603s)
[335.820349] [066/132] (743s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[335.928248] Starting subtest: fbc-pr-cursor-mmap-gtt
[335.932389] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[335.996653] [067/132] (742s left) i915_pm_rpm (debugfs-forcewake-user)
[338.327754] Starting subtest: debugfs-forcewake-user
[349.725514] Subtest debugfs-forcewake-user: SUCCESS (11.394s)
[350.071157] [068/132] (728s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[350.169044] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[350.173264] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[350.276208] [069/132] (728s left) gem_ctx_persistence (legacy-engines-cleanup)
[350.332557] Starting subtest: legacy-engines-cleanup
[350.335007] Starting dynamic subtest: render
[350.427224] Dynamic subtest render: SUCCESS (0.094s)
[350.438599] Starting dynamic subtest: bsd1
[350.494121] Dynamic subtest bsd1: SUCCESS (0.065s)
[350.505333] Starting dynamic subtest: bsd2
[350.535638] Dynamic subtest bsd2: SUCCESS (0.040s)
[350.545422] Starting dynamic subtest: blt
[350.564494] Dynamic subtest blt: SUCCESS (0.027s)
[350.572621] Starting dynamic subtest: vebox
[350.666117] Dynamic subtest vebox: SUCCESS (0.100s)
[350.668658] Subtest legacy-engines-cleanup: SUCCESS (0.334s)
[350.744289] [070/132] (728s left) kms_3d
[353.105155] [071/132] (725s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[353.204935] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[353.209261] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[353.292594] [072/132] (725s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[353.389775] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[357.106402] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.721s)
[358.294863] [073/132] (720s left) kms_psr (fbc-psr-sprite-blt)
[358.404318] Starting subtest: fbc-psr-sprite-blt
[358.406650] Starting dynamic subtest: eDP-1
[358.410880] Dynamic subtest eDP-1: SKIP (0.000s)
[358.415240] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[358.476499] [074/132] (720s left) kms_scaling_modes (scaling-mode-none)
[358.567206] Starting subtest: scaling-mode-none
[358.569476] Starting dynamic subtest: pipe-A-eDP-1
[358.681521] Dynamic subtest pipe-A-eDP-1: SKIP (0.111s)
[358.692498] Starting dynamic subtest: pipe-B-eDP-1
[358.733420] Dynamic subtest pipe-B-eDP-1: SKIP (0.049s)
[358.742566] Starting dynamic subtest: pipe-C-eDP-1
[358.783551] Dynamic subtest pipe-C-eDP-1: SKIP (0.049s)
[358.792567] Starting dynamic subtest: pipe-D-eDP-1
[358.833076] Dynamic subtest pipe-D-eDP-1: SKIP (0.048s)
[358.837517] Subtest scaling-mode-none: SKIP (0.264s)
[358.969007] [075/132] (720s left) kms_dp_link_training (uhbr-mst)
[359.066218] Starting subtest: uhbr-mst
[359.074854] Subtest uhbr-mst: SKIP (0.000s)
[359.134014] [076/132] (720s left) gem_mmap_offset (partial-unmap)
[359.186437] Starting subtest: partial-unmap
[359.188461] Starting dynamic subtest: smem0
[359.691223] Dynamic subtest smem0: SUCCESS (0.505s)
[359.694121] Subtest partial-unmap: SUCCESS (0.506s)
[359.812949] [077/132] (719s left) drm_read (short-buffer-nonblock)
[359.979351] Starting subtest: short-buffer-nonblock
[359.981729] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[360.120314] [078/132] (719s left) i915_pm_rps (min-max-config-idle)
[360.176207] Starting subtest: min-max-config-idle
[360.181035] Subtest min-max-config-idle: SKIP (0.001s)
[360.254851] [079/132] (719s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[360.348476] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[360.350743] Starting dynamic subtest: pipe-A-default-mode
[360.634323] Dynamic subtest pipe-A-default-mode: SKIP (0.282s)
[360.638853] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.284s)
[361.488575] [080/132] (717s left) sysfs_timeslice_duration (timeout)
[361.546489] Starting subtest: timeout
[361.548868] Starting dynamic subtest: vecs0
[371.175328] Dynamic subtest vecs0: SUCCESS (9.625s)
[371.186771] Starting dynamic subtest: ccs0
[372.531801] Dynamic subtest ccs0: SUCCESS (1.355s)
[372.544755] Starting dynamic subtest: vcs0
[382.165520] Dynamic subtest vcs0: SUCCESS (9.632s)
[382.177571] Starting dynamic subtest: bcs0
[382.854198] Dynamic subtest bcs0: SUCCESS (0.687s)
[382.867913] Starting dynamic subtest: rcs0
[384.231465] Dynamic subtest rcs0: SUCCESS (1.376s)
[384.242840] Starting dynamic subtest: vcs1
[394.218060] Dynamic subtest vcs1: SUCCESS (9.985s)
[394.220661] Subtest timeout: SUCCESS (32.673s)
[394.286447] [081/132] (685s left) kms_psr (psr2-primary-mmap-gtt)
[394.386516] Starting subtest: psr2-primary-mmap-gtt
[394.388771] Starting dynamic subtest: eDP-1
[395.945275] Dynamic subtest eDP-1: SKIP (1.554s)
[395.950087] Subtest psr2-primary-mmap-gtt: SKIP (1.555s)
[396.089069] [082/132] (683s left) kms_addfb_basic (tile-pitch-mismatch)
[396.138649] Starting subtest: tile-pitch-mismatch
[396.143485] Subtest tile-pitch-mismatch: SKIP (0.000s)
[396.267478] [083/132] (683s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[396.368020] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[396.372394] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[396.467006] [084/132] (683s left) gem_exec_await (wide-all)
[396.670919] Starting subtest: wide-all
[420.085172] Subtest wide-all: SUCCESS (23.417s)
[420.277812] [085/132] (659s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[420.428546] Starting subtest: fbcpsr-rgb565-draw-pwrite
[427.342799] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (6.919s)
[427.459424] [086/132] (652s left) kms_flip (2x-modeset-vs-vblank-race)
[427.559900] Starting subtest: 2x-modeset-vs-vblank-race
[427.570811] Subtest 2x-modeset-vs-vblank-race: SKIP (0.010s)
[427.670550] [087/132] (651s left) gem_exec_balancer (nohangcheck)
[427.924723] Starting subtest: nohangcheck
[428.643403] Subtest nohangcheck: SUCCESS (0.721s)
[428.759699] [088/132] (650s left) kms_psr (psr-cursor-render)
[428.872608] Starting subtest: psr-cursor-render
[428.874935] Starting dynamic subtest: eDP-1
[430.535682] Dynamic subtest eDP-1: SUCCESS (1.663s)
[430.538107] Subtest psr-cursor-render: SUCCESS (1.664s)
[431.367329] [089/132] (648s left) gem_exec_suspend (basic-s3)
[431.427446] Starting subtest: basic-S3
[431.429881] Starting dynamic subtest: smem
[451.653599] Dynamic subtest smem: SUCCESS (6.758s)
[451.656134] Subtest basic-S3: SUCCESS (6.759s)
[451.832971] [090/132] (641s left) kms_flip (plain-flip-fb-recreate-interruptible)
[451.934525] Starting subtest: plain-flip-fb-recreate-interruptible
[451.939874] Starting dynamic subtest: A-eDP1
[462.795496] Dynamic subtest A-eDP1: FAIL (10.436s)
[462.807005] Starting dynamic subtest: B-eDP1
[471.180453] Dynamic subtest B-eDP1: SUCCESS (8.886s)
[471.193116] Starting dynamic subtest: C-eDP1
[480.048087] Dynamic subtest C-eDP1: SUCCESS (8.875s)
[480.060776] Starting dynamic subtest: D-eDP1
[488.937633] Dynamic subtest D-eDP1: SUCCESS (8.888s)
[488.939927] Subtest plain-flip-fb-recreate-interruptible: FAIL (37.098s)
[490.082355] [091/132] (603s left) gem_exec_balancer (bonded-true-hang)
[490.326137] Starting subtest: bonded-true-hang
[490.331159] Subtest bonded-true-hang: SKIP (0.000s)
[490.433165] [092/132] (602s left) gem_mmap (bad-object)
[490.504997] Subtest bad-object: SKIP (0.000s)
[490.561634] [093/132] (602s left) gem_mmap_gtt (basic-small-bo)
[490.622354] Subtest basic-small-bo: SKIP (0.000s)
[490.678039] [094/132] (602s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[490.782343] Starting subtest: y-tiled-64bpp-rotate-90
[490.786709] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[490.873051] [095/132] (602s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[490.975042] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[490.978985] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[491.092767] [096/132] (602s left) gem_softpin (zero)
[491.163661] Starting subtest: zero
[491.168008] Subtest zero: SUCCESS (0.004s)
[491.289168] [097/132] (602s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[491.386188] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[498.580766] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.196s)
[498.690586] [098/132] (594s left) api_intel_allocator (reserve-simple)
[498.751043] Starting subtest: reserve-simple
[498.753426] Subtest reserve-simple: SUCCESS (0.003s)
[498.864250] [099/132] (594s left) drm_mm (drm_mm)
[498.912842] Starting subtest: drm_mm
[498.936353] Starting dynamic subtest: drm_test_mm_init
[499.082318] Dynamic subtest drm_test_mm_init: SUCCESS (0.146s)
[499.097457] Starting dynamic subtest: drm_test_mm_debug
[499.171612] Dynamic subtest drm_test_mm_debug: SUCCESS (0.089s)
[499.181446] Starting dynamic subtest: drm_test_mm_align32
[499.291933] Dynamic subtest drm_test_mm_align32: SUCCESS (0.116s)
[499.301990] Starting dynamic subtest: drm_test_mm_align64
[499.430063] Dynamic subtest drm_test_mm_align64: SUCCESS (0.138s)
[499.440185] Starting dynamic subtest: drm_test_mm_lowest
[499.560056] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.128s)
[499.570809] Starting dynamic subtest: drm_test_mm_highest
[499.688609] Dynamic subtest drm_test_mm_highest: SUCCESS (0.125s)
[499.690948] Subtest drm_mm: SUCCESS (0.772s)
[499.888605] [100/132] (593s left) syncobj_wait (single-wait-signaled)
[499.947608] Starting subtest: single-wait-signaled
[499.950005] Subtest single-wait-signaled: SUCCESS (0.000s)
[500.056023] [101/132] (593s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[500.166151] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[500.170034] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[500.275922] [102/132] (593s left) perf (invalid-remove-userspace-config)
[500.374207] Starting subtest: invalid-remove-userspace-config
[500.386355] Subtest invalid-remove-userspace-config: SUCCESS (0.012s)
[500.421019] [103/132] (593s left) perf (blocking-parameterized)
[500.505106] Starting subtest: blocking-parameterized
[520.537272] Subtest blocking-parameterized: SUCCESS (20.034s)
[520.583993] [104/132] (573s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[520.689394] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[520.693515] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[520.787911] [105/132] (572s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[520.886783] Starting subtest: yf-tiled-8bpp-rotate-270
[520.890997] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[520.981723] [106/132] (572s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[521.090380] Starting subtest: extended-modeset-hang-newfb-with-reset
[521.092709] Starting dynamic subtest: pipe-A
[537.059242] Dynamic subtest pipe-A: SUCCESS (15.973s)
[537.069230] Starting dynamic subtest: pipe-D
[552.698385] Dynamic subtest pipe-D: SUCCESS (15.636s)
[552.700454] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (31.613s)
[553.566379] [107/132] (540s left) kms_pm_rpm (dpms-non-lpsp)
[555.808654] Starting subtest: dpms-non-lpsp
[555.814632] Subtest dpms-non-lpsp: SKIP (0.001s)
[556.153780] [108/132] (537s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[556.285519] Starting subtest: cursorB-vs-flipA-legacy
[556.289946] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[556.378003] [109/132] (537s left) kms_plane_cursor (viewport)
[556.475995] Starting subtest: viewport
[556.480431] Starting dynamic subtest: pipe-A-eDP-1-size-64
[559.305876] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.826s)
[559.366535] Starting dynamic subtest: pipe-A-eDP-1-size-128
[562.205982] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.848s)
[562.268816] Starting dynamic subtest: pipe-A-eDP-1-size-256
[565.143021] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.882s)
[565.491776] Starting dynamic subtest: pipe-B-eDP-1-size-64
[568.921021] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.439s)
[568.979780] Starting dynamic subtest: pipe-B-eDP-1-size-128
[571.830385] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.859s)
[571.890778] Starting dynamic subtest: pipe-B-eDP-1-size-256
[574.722655] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.839s)
[575.070699] Starting dynamic subtest: pipe-C-eDP-1-size-64
[578.194564] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.135s)
[578.232741] Starting dynamic subtest: pipe-C-eDP-1-size-128
[580.661341] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.435s)
[580.698219] Starting dynamic subtest: pipe-C-eDP-1-size-256
[583.160971] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.468s)
[583.476177] Starting dynamic subtest: pipe-D-eDP-1-size-64
[586.583135] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.117s)
[586.627935] Starting dynamic subtest: pipe-D-eDP-1-size-128
[589.083135] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.468s)
[589.120568] Starting dynamic subtest: pipe-D-eDP-1-size-256
[591.550110] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.435s)
[591.867585] Subtest viewport: SUCCESS (35.386s)
[592.665025] [110/132] (501s left) kms_psr (pr-sprite-blt)
[592.782179] Starting subtest: pr-sprite-blt
[592.786662] Subtest pr-sprite-blt: SKIP (0.000s)
[592.850996] [111/132] (501s left) perf (invalid-open-flags)
[592.928560] Starting subtest: invalid-open-flags
[592.930762] Subtest invalid-open-flags: SUCCESS (0.000s)
[592.970305] [112/132] (500s left) tools_test (tools_test)
[593.019117] Starting subtest: tools_test
[593.075766] Subtest tools_test: SUCCESS (0.072s)
[593.136024] [113/132] (500s left) gem_render_tiled_blits (basic)
[593.202863] Subtest basic: SKIP (0.000s)
[593.274462] [114/132] (500s left) kms_color (ctm-0-25)
[593.368979] Starting subtest: ctm-0-25
[593.371159] Starting dynamic subtest: pipe-A-eDP-1
[596.695000] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.324s)
[596.705136] Starting dynamic subtest: pipe-B-eDP-1
[600.895605] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.202s)
[600.906110] Starting dynamic subtest: pipe-C-eDP-1
[604.838977] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.943s)
[604.849514] Starting dynamic subtest: pipe-D-eDP-1
[608.736197] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.896s)
[608.738655] Subtest ctm-0-25: SUCCESS (15.368s)
[609.564102] [115/132] (484s left) kms_cursor_crc (cursor-offscreen-128x42)
[609.793134] Starting subtest: cursor-offscreen-128x42
[609.826206] Subtest cursor-offscreen-128x42: SKIP (0.031s)
[610.018283] [116/132] (484s left) gem_exec_whisper (basic-contexts-priority-all)
[610.078793] Starting subtest: basic-contexts-priority-all
[632.666147] Subtest basic-contexts-priority-all: SUCCESS (22.588s)
[632.841112] [117/132] (461s left) kms_addfb_basic (unused-pitches)
[632.899453] Starting subtest: unused-pitches
[632.901911] Subtest unused-pitches: SUCCESS (0.000s)
[633.066313] [118/132] (461s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[633.167007] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[633.169215] Starting dynamic subtest: pipe-A-eDP-1
[633.228919] Dynamic subtest pipe-A-eDP-1: SKIP (0.003s)
[633.239973] Starting dynamic subtest: pipe-B-eDP-1
[633.298131] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[633.309625] Starting dynamic subtest: pipe-C-eDP-1
[633.367957] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[633.378926] Starting dynamic subtest: pipe-D-eDP-1
[633.436722] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[633.441356] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.010s)
[635.359233] [119/132] (458s left) gem_exec_nop (basic-parallel)
[635.435119] Starting subtest: basic-parallel
[651.593042] Subtest basic-parallel: SUCCESS (16.170s)
[651.810175] [120/132] (442s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[651.915673] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[652.783328] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.870s)
[652.984559] [121/132] (441s left) gem_exec_schedule (smoketest)
[653.174354] Starting subtest: smoketest
[653.176806] Starting dynamic subtest: rcs0
[658.722990] Dynamic subtest rcs0: SUCCESS (5.492s)
[658.733874] Starting dynamic subtest: bcs0
[664.229342] Dynamic subtest bcs0: SUCCESS (5.511s)
[664.246884] Starting dynamic subtest: vcs0
[669.740170] Dynamic subtest vcs0: SUCCESS (5.515s)
[669.763010] Starting dynamic subtest: vcs1
[675.243068] Dynamic subtest vcs1: SUCCESS (5.504s)
[675.253806] Starting dynamic subtest: vecs0
[680.761223] Dynamic subtest vecs0: SUCCESS (5.513s)
[680.777243] Starting dynamic subtest: ccs0
[686.270775] Dynamic subtest ccs0: SUCCESS (5.509s)
[686.272741] Subtest smoketest: SUCCESS (33.049s)
[686.406025] [122/132] (407s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[686.522452] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[686.526939] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[686.606060] [123/132] (407s left) syncobj_timeline (wait-for-submit-complex)
[686.661373] Starting subtest: wait-for-submit-complex
[686.724234] Subtest wait-for-submit-complex: SUCCESS (0.063s)
[686.795246] [124/132] (407s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[686.889785] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[691.131140] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.246s)
[692.256270] [125/132] (402s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[692.383889] Starting subtest: flip-vs-cursor-crc-legacy
[692.987169] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.604s)
[693.848137] [126/132] (400s left) gem_softpin (allocator-basic-reserve)
[693.906465] Starting subtest: allocator-basic-reserve
[693.964605] Subtest allocator-basic-reserve: SUCCESS (0.058s)
[694.105585] [127/132] (400s left) gem_exec_capture (capture)
[694.181749] Starting subtest: capture
[694.184054] Starting dynamic subtest: rcs0-smem
[695.020901] Dynamic subtest rcs0-smem: SUCCESS (0.837s)
[695.033561] Starting dynamic subtest: bcs0-smem
[695.970363] Dynamic subtest bcs0-smem: SUCCESS (0.947s)
[695.985667] Starting dynamic subtest: vcs0-smem
[696.791146] Dynamic subtest vcs0-smem: SUCCESS (0.822s)
[696.808747] Starting dynamic subtest: vcs1-smem
[697.613131] Dynamic subtest vcs1-smem: SUCCESS (0.818s)
[697.624470] Starting dynamic subtest: vecs0-smem
[699.019557] Dynamic subtest vecs0-smem: FAIL (1.331s)
[699.030458] Starting dynamic subtest: ccs0-smem
[700.268348] Dynamic subtest ccs0-smem: SUCCESS (1.325s)
[700.270908] Subtest capture: FAIL (6.083s)
[700.396284] [128/132] (394s left) gem_exec_schedule (noreorder-priority)
[700.577107] Starting subtest: noreorder-priority
[700.579717] Starting dynamic subtest: rcs0
[701.721602] Dynamic subtest rcs0: SUCCESS (1.145s)
[701.731830] Starting dynamic subtest: vcs0
[703.706936] Dynamic subtest vcs0: SUCCESS (1.982s)
[703.716865] Starting dynamic subtest: vcs1
[705.667257] Dynamic subtest vcs1: SUCCESS (1.958s)
[705.678797] Starting dynamic subtest: vecs0
[707.681137] Dynamic subtest vecs0: SUCCESS (2.012s)
[707.693958] Starting dynamic subtest: ccs0
[708.837033] Dynamic subtest ccs0: SUCCESS (1.155s)
[708.839866] Subtest noreorder-priority: SUCCESS (8.259s)
[709.022530] [129/132] (385s left) gem_tiled_wb
[709.139097] [130/132] (385s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[709.245567] Starting subtest: psr-farfromfence-mmap-gtt
[709.250086] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[709.357267] [131/132] (385s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[709.477126] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[709.481402] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[709.581448] [132/132] (385s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[709.634662] Starting subtest: etime-single-wait-all-available-unsubmitted
[709.739742] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.105s)
[709.809697] 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.