[38.398623] Initializing watchdogs
[38.398680]   /dev/watchdog0
[38.405628] [001/138] (960s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[38.530203] Starting subtest: cursor-rapid-movement-256x256
[38.538522] Starting dynamic subtest: pipe-A-eDP-1
[39.207688] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.667s)
[39.235398] Starting dynamic subtest: pipe-D-eDP-1
[40.525552] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.297s)
[40.527738] Subtest cursor-rapid-movement-256x256: SUCCESS (1.994s)
[41.414790] [002/138] (957s left) kms_vrr (flip-suspend)
[41.480072] Starting subtest: flip-suspend
[41.484472] Subtest flip-suspend: SKIP (0.000s)
[41.539665] [003/138] (957s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[41.609217] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[41.613332] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[41.686654] [004/138] (957s left) kms_scaling_modes (scaling-mode-center)
[41.741355] Starting subtest: scaling-mode-center
[41.744206] Starting dynamic subtest: pipe-A-eDP-1
[41.833425] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.095s)
[41.843083] Starting dynamic subtest: pipe-B-eDP-1
[43.071904] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.236s)
[43.081140] Starting dynamic subtest: pipe-C-eDP-1
[44.268040] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.194s)
[44.277860] Starting dynamic subtest: pipe-D-eDP-1
[45.491110] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.224s)
[45.493628] Subtest scaling-mode-center: SUCCESS (3.753s)
[46.720129] [005/138] (952s left) i915_query (query-topology-unsupported)
[46.766799] Starting subtest: query-topology-unsupported
[46.771651] Subtest query-topology-unsupported: SKIP (0.000s)
[46.820891] [006/138] (952s left) gem_exec_reloc (basic-cpu-active)
[46.883180] Subtest basic-cpu-active: SKIP (0.000s)
[46.932946] [007/138] (952s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[47.022251] Starting subtest: psr-rgb101010-draw-mmap-wc
[52.034568] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (5.021s)
[52.143613] [008/138] (946s left) kms_prop_blob (basic)
[52.187113] Starting subtest: basic
[52.189420] Subtest basic: SUCCESS (0.000s)
[52.244394] [009/138] (946s left) gem_tiled_wc
[52.334930] [010/138] (946s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[52.388792] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[52.489084] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.102s)
[52.550896] [011/138] (946s left) sw_sync (sync_merge)
[52.602274] Starting subtest: sync_merge
[52.604587] Subtest sync_merge: SUCCESS (0.000s)
[52.649336] [012/138] (946s left) kms_ccs (pipe-c-bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[53.044337] Starting subtest: pipe-C-bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[53.050566] Subtest pipe-C-bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[53.881993] [013/138] (945s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[53.966487] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[53.971052] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[54.045943] [014/138] (945s left) kms_addfb_basic (invalid-get-prop)
[54.097504] Starting subtest: invalid-get-prop
[54.099907] Subtest invalid-get-prop: SUCCESS (0.000s)
[54.179401] [015/138] (945s left) kms_psr2_sf (cursor-plane-move-continuous-sf)
[59.388568] Starting subtest: cursor-plane-move-continuous-sf
[59.391109] Starting dynamic subtest: pipe-A-eDP-1
[70.554694] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.165s)
[70.565407] Starting dynamic subtest: pipe-B-eDP-1
[81.759191] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.201s)
[81.761686] Subtest cursor-plane-move-continuous-sf: SUCCESS (22.371s)
[82.692315] [016/138] (916s left) kms_properties (get_properties-sanity-atomic)
[82.779860] Starting subtest: get_properties-sanity-atomic
[82.782207] Subtest get_properties-sanity-atomic: SUCCESS (0.003s)
[82.838990] [017/138] (916s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-gtt)
[82.906638] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-gtt
[82.911135] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[82.984261] [018/138] (916s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[83.071990] Starting subtest: basic-busy-flip-before-cursor-varying-size
[83.076866] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[83.156354] [019/138] (916s left) kms_chamelium_audio (dp-audio-edid)
[83.518118] Subtest dp-audio-edid: SKIP (0.000s)
[84.383619] [020/138] (914s left) gem_render_copy_redux (flink-interruptible)
[84.454946] Starting subtest: flink-interruptible
[85.280040] Subtest flink-interruptible: SUCCESS (0.826s)
[85.388177] [021/138] (913s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[85.462708] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[85.464832] Starting dynamic subtest: pipe-A-eDP-1
[85.527603] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.068s)
[85.540088] Starting dynamic subtest: pipe-B-eDP-1
[86.781225] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.250s)
[86.794058] Starting dynamic subtest: pipe-C-eDP-1
[87.987202] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.203s)
[88.000533] Starting dynamic subtest: pipe-D-eDP-1
[89.203819] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.214s)
[89.206480] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.744s)
[90.440634] [022/138] (908s left) kms_ccs (pipe-c-crc-sprite-planes-basic-yf-tiled-ccs)
[90.858992] Starting subtest: pipe-C-crc-sprite-planes-basic-yf-tiled-ccs
[90.865154] Subtest pipe-C-crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.001s)
[91.716867] [023/138] (907s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-factor-0-25)
[91.789023] Starting subtest: planes-downscale-factor-0-25-upscale-factor-0-25
[91.791552] Starting dynamic subtest: pipe-A-eDP-1
[91.800155] Dynamic subtest pipe-A-eDP-1: SKIP (0.008s)
[91.810774] Starting dynamic subtest: pipe-B-eDP-1
[91.815577] Dynamic subtest pipe-B-eDP-1: SKIP (0.015s)
[91.825714] Starting dynamic subtest: pipe-C-eDP-1
[91.835895] Dynamic subtest pipe-C-eDP-1: SKIP (0.015s)
[91.845851] Starting dynamic subtest: pipe-D-eDP-1
[91.850249] Dynamic subtest pipe-D-eDP-1: SKIP (0.016s)
[91.854900] Subtest planes-downscale-factor-0-25-upscale-factor-0-25: SKIP (0.058s)
[91.919104] [024/138] (907s left) gem_ctx_persistence (processes)
[91.979202] Starting subtest: processes
[93.510661] Subtest processes: SUCCESS (1.536s)
[93.579499] [025/138] (905s left) kms_vrr (flip-basic)
[93.643830] Starting subtest: flip-basic
[93.648635] Subtest flip-basic: SKIP (0.000s)
[93.702046] [026/138] (905s left) kms_flip (2x-modeset-vs-vblank-race)
[93.766213] Starting subtest: 2x-modeset-vs-vblank-race
[93.788619] Subtest 2x-modeset-vs-vblank-race: SKIP (0.021s)
[93.855230] [027/138] (905s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[93.929225] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[93.933375] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[94.001513] [028/138] (905s left) api_intel_bb (offset-control)
[94.058759] Starting subtest: offset-control
[94.061361] Subtest offset-control: SUCCESS (0.005s)
[94.150614] [029/138] (905s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[94.228404] Starting subtest: 2x-flip-vs-cursor-atomic
[94.233184] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[94.361773] [030/138] (905s left) gem_userptr_blits (vma-merge)
[94.448960] Starting subtest: vma-merge
[114.571138] Subtest vma-merge: FAIL (20.084s)
[114.600733] [031/138] (884s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[114.658817] Starting subtest: single-wait-all-for-submit-signaled
[114.661153] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.001s)
[114.719870] [032/138] (884s left) kms_ccs (pipe-d-ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[115.135861] Starting subtest: pipe-D-ccs-on-another-bo-y-tiled-gen12-rc-ccs
[115.142251] Subtest pipe-D-ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[115.959996] [033/138] (883s left) kms_ccs (pipe-d-bad-rotation-90-y-tiled-ccs)
[116.367634] Starting subtest: pipe-D-bad-rotation-90-y-tiled-ccs
[116.373221] Subtest pipe-D-bad-rotation-90-y-tiled-ccs: SKIP (0.000s)
[117.242579] [034/138] (882s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[117.291807] Starting subtest: multi-wait-all-for-submit-available-signaled
[117.293989] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.001s)
[117.337273] [035/138] (882s left) kms_flip (plain-flip-fb-recreate-interruptible)
[117.383922] Starting subtest: plain-flip-fb-recreate-interruptible
[117.386368] Starting dynamic subtest: A-eDP1
[126.319341] Dynamic subtest A-eDP1: SUCCESS (8.935s)
[126.331220] Starting dynamic subtest: B-eDP1
[135.215448] Dynamic subtest B-eDP1: SUCCESS (8.895s)
[135.231034] Starting dynamic subtest: C-eDP1
[144.164894] Dynamic subtest C-eDP1: SUCCESS (8.949s)
[144.176169] Starting dynamic subtest: D-eDP1
[153.124839] Dynamic subtest D-eDP1: SUCCESS (8.959s)
[153.132096] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.750s)
[154.375473] [036/138] (845s left) kms_ccs (pipe-a-bad-rotation-90-y-tiled-gen12-rc-ccs)
[154.753837] Starting subtest: pipe-A-bad-rotation-90-y-tiled-gen12-rc-ccs
[154.758646] Subtest pipe-A-bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[155.654202] [037/138] (844s left) api_intel_allocator (default-alignment)
[155.703599] Starting subtest: default-alignment
[155.706401] Subtest default-alignment: SUCCESS (0.002s)
[155.795162] [038/138] (843s left) kms_psr (cursor_blt)
[155.879019] Starting subtest: cursor_blt
[157.654918] Subtest cursor_blt: SUCCESS (1.776s)
[158.600925] [039/138] (841s left) gem_create (create-ext-placement-each)
[158.768300] Starting subtest: create-ext-placement-each
[158.771249] Subtest create-ext-placement-each: SUCCESS (0.000s)
[158.857157] [040/138] (840s left) kms_ccs (pipe-a-crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[159.196671] Starting subtest: pipe-A-crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[160.308231] Subtest pipe-A-crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (1.109s)
[161.482410] [041/138] (838s left) kms_atomic (atomic-invalid-params)
[161.547173] Starting subtest: atomic-invalid-params
[161.550257] Starting dynamic subtest: pipe-A-eDP-1
[161.952318] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.403s)
[161.954914] Subtest atomic-invalid-params: SUCCESS (0.404s)
[162.869719] [042/138] (836s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[162.960742] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[162.965504] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[163.037050] [043/138] (836s left) perf_pmu (init-busy)
[163.095464] Starting subtest: init-busy
[163.098169] Starting dynamic subtest: rcs0
[163.100803] Dynamic subtest rcs0: SUCCESS (0.002s)
[163.112427] Starting dynamic subtest: bcs0
[163.114680] Dynamic subtest bcs0: SUCCESS (0.001s)
[163.125599] Starting dynamic subtest: vcs0
[163.127960] Dynamic subtest vcs0: SUCCESS (0.001s)
[163.139819] Starting dynamic subtest: vcs1
[163.141848] Dynamic subtest vcs1: SUCCESS (0.001s)
[163.152336] Starting dynamic subtest: vecs0
[163.154675] Dynamic subtest vecs0: SUCCESS (0.001s)
[163.163030] Starting dynamic subtest: ccs0
[163.165293] Dynamic subtest ccs0: SUCCESS (0.001s)
[163.167541] Subtest init-busy: SUCCESS (0.009s)
[163.188765] [044/138] (836s left) vc4/vc4_purgeable_bo (mark-unpurgeable-check-retained)
[163.264953] Subtest mark-unpurgeable-check-retained: SKIP (0.000s)
[163.311718] [045/138] (836s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[163.386933] Starting subtest: fbcpsr-tiling-4
[168.444035] Subtest fbcpsr-tiling-4: SUCCESS (5.060s)
[168.554872] [046/138] (831s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[168.641071] Starting subtest: 4-tiled-32bpp-rotate-90
[168.657965] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.017s)
[168.750671] [047/138] (831s left) kms_ccs (pipe-b-crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[169.127331] Starting subtest: pipe-B-crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[171.616174] Subtest pipe-B-crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (2.490s)
[172.809735] [048/138] (827s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[172.864743] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[172.880375] [049/138] (827s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[172.943436] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[172.947895] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[173.030435] [050/138] (827s left) kms_atomic_interruptible (legacy-cursor)
[173.108187] Starting subtest: legacy-cursor
[173.110633] Starting dynamic subtest: pipe-A-eDP-1
[180.561971] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.453s)
[180.564683] Subtest legacy-cursor: SUCCESS (7.455s)
[181.512581] [051/138] (818s left) drm_fdinfo (virtual-busy-idle-all)
[181.559298] Starting subtest: virtual-busy-idle-all
[181.563787] Subtest virtual-busy-idle-all: SKIP (0.000s)
[181.623384] [052/138] (818s left) gem_exec_schedule (fairslice-all)
[181.704493] Starting subtest: fairslice-all
[183.761331] Subtest fairslice-all: SUCCESS (2.053s)
[185.533926] [053/138] (814s left) i915_hangman (engine-error-state-capture)
[185.617405] Starting subtest: engine-error-state-capture
[185.619666] Starting dynamic subtest: rcs0
[189.474772] Dynamic subtest rcs0: SUCCESS (3.858s)
[189.487587] Starting dynamic subtest: bcs0
[195.426671] Dynamic subtest bcs0: SUCCESS (5.950s)
[195.439283] Starting dynamic subtest: vcs0
[201.442645] Dynamic subtest vcs0: SUCCESS (6.014s)
[201.455506] Starting dynamic subtest: vcs1
[209.442181] Dynamic subtest vcs1: SUCCESS (7.999s)
[209.455186] Starting dynamic subtest: vecs0
[215.458986] Dynamic subtest vecs0: SUCCESS (6.015s)
[215.472778] Starting dynamic subtest: ccs0
[221.409996] Dynamic subtest ccs0: SUCCESS (5.950s)
[221.413226] Subtest engine-error-state-capture: SUCCESS (35.795s)
[221.520070] [054/138] (778s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted-submitted-sign
[221.570421] Starting subtest: invalid-multi-wait-all-available-unsubmitted-submitted-signaled
[221.572877] Subtest invalid-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[221.633298] [055/138] (778s left) kms_flip (flip-vs-panning-vs-hang)
[221.700890] Starting subtest: flip-vs-panning-vs-hang
[221.703380] Starting dynamic subtest: A-eDP1
[260.022568] Dynamic subtest A-eDP1: SUCCESS (38.321s)
[260.037338] Starting dynamic subtest: D-eDP1
[310.008387] Dynamic subtest D-eDP1: SUCCESS (49.985s)
[310.010799] Subtest flip-vs-panning-vs-hang: SUCCESS (88.314s)
[311.236417] [056/138] (688s left) gem_softpin (32b-excludes-last-page)
[311.289679] Starting subtest: 32b-excludes-last-page
[311.292267] Subtest 32b-excludes-last-page: SUCCESS (0.003s)
[311.383368] [057/138] (688s left) gem_pxp (create-regular-context-2)
[313.965403] Subtest create-regular-context-2: SKIP (0.000s)
[314.026716] [058/138] (686s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[314.083051] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[318.664142] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (4.585s)
[318.786750] [059/138] (681s left) gem_exec_reloc (basic-wc-cpu-active)
[318.849071] Subtest basic-wc-cpu-active: SKIP (0.000s)
[318.913736] [060/138] (681s left) kms_color (ctm-green-to-red)
[319.002466] Starting subtest: ctm-green-to-red
[319.004772] Starting dynamic subtest: pipe-A
[319.713843] Dynamic subtest pipe-A: SUCCESS (0.712s)
[319.726186] Starting dynamic subtest: pipe-B
[321.250880] Dynamic subtest pipe-B: SUCCESS (1.534s)
[321.261134] Starting dynamic subtest: pipe-C
[322.719992] Dynamic subtest pipe-C: SUCCESS (1.467s)
[322.730493] Starting dynamic subtest: pipe-D
[324.191286] Dynamic subtest pipe-D: SUCCESS (1.472s)
[324.193793] Subtest ctm-green-to-red: SUCCESS (5.191s)
[325.115035] [061/138] (675s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[325.187487] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[325.192063] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[325.263698] [062/138] (675s left) kms_ccs (pipe-b-bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[325.639984] Starting subtest: pipe-B-bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[325.642485] Subtest pipe-B-bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.000s)
[326.533648] [063/138] (673s left) gem_ctx_param (invalid-get-engines)
[326.584520] Starting subtest: invalid-get-engines
[326.587126] Subtest invalid-get-engines: SUCCESS (0.000s)
[326.633784] [064/138] (673s left) prime_mmap (test_invalid_sync_flags)
[326.683596] Starting subtest: test_invalid_sync_flags
[326.685902] Starting dynamic subtest: test_invalid_sync_flags-smem
[326.688408] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[326.690709] Subtest test_invalid_sync_flags: SUCCESS (0.000s)
[326.761145] [065/138] (673s left) gem_mmap_wc (write-cpu-read-wc)
[326.815068] Subtest write-cpu-read-wc: SKIP (0.000s)
[326.828956] [066/138] (673s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[327.196841] Starting subtest: pipe-B-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[329.075405] Subtest pipe-B-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (1.880s)
[330.299474] [067/138] (670s left) kms_addfb_basic (basic-y-tiled-legacy)
[330.358024] Starting subtest: basic-y-tiled-legacy
[330.363032] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[330.456033] [068/138] (670s left) drm_fdinfo (busy-idle-check-all)
[330.497137] Starting subtest: busy-idle-check-all
[330.499689] Starting dynamic subtest: rcs0
[330.504642] Dynamic subtest rcs0: SKIP (0.002s)
[330.510455] Starting dynamic subtest: bcs0
[330.514579] Dynamic subtest bcs0: SKIP (0.000s)
[330.521060] Starting dynamic subtest: vcs0
[330.525463] Dynamic subtest vcs0: SKIP (0.001s)
[330.532284] Starting dynamic subtest: vcs1
[330.536353] Dynamic subtest vcs1: SKIP (0.001s)
[330.543094] Starting dynamic subtest: vecs0
[330.547105] Dynamic subtest vecs0: SKIP (0.001s)
[330.553142] Starting dynamic subtest: ccs0
[330.557121] Dynamic subtest ccs0: SKIP (0.000s)
[330.561103] Subtest busy-idle-check-all: SKIP (0.009s)
[330.577148] [069/138] (669s left) kms_addfb_basic (small-bo)
[330.640055] Starting subtest: small-bo
[330.642411] Subtest small-bo: SUCCESS (0.000s)
[330.722681] [070/138] (669s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[330.795980] Starting subtest: disable-crc-after-crtc
[330.800637] Starting dynamic subtest: pipe-A-eDP-1
[332.577066] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.778s)
[332.589939] Starting dynamic subtest: pipe-B-eDP-1
[335.150094] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.571s)
[335.165447] Starting dynamic subtest: pipe-C-eDP-1
[337.654476] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.499s)
[337.665777] Starting dynamic subtest: pipe-D-eDP-1
[340.147432] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.491s)
[340.149906] Subtest disable-crc-after-crtc: SUCCESS (9.350s)
[341.051908] [071/138] (659s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[341.640920] Starting subtest: syncobj-backward-timeline-chain-engines
[341.678728] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.039s)
[343.561269] [072/138] (656s left) vc4/vc4_label_bo (set-bad-handle)
[343.652046] Subtest set-bad-handle: SKIP (0.000s)
[343.698779] [073/138] (656s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[343.785670] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[343.790033] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[343.869244] [074/138] (656s left) prime_vgem (busy)
[343.955052] Starting subtest: busy
[343.957447] Starting dynamic subtest: rcs0
[343.997056] Dynamic subtest rcs0: SUCCESS (0.041s)
[344.010081] Starting dynamic subtest: bcs0
[344.047766] Dynamic subtest bcs0: SUCCESS (0.050s)
[344.058119] Starting dynamic subtest: vcs0
[344.098809] Dynamic subtest vcs0: SUCCESS (0.050s)
[344.108700] Starting dynamic subtest: vcs1
[344.126021] Dynamic subtest vcs1: SUCCESS (0.024s)
[344.134180] Starting dynamic subtest: vecs0
[344.151066] Dynamic subtest vecs0: SUCCESS (0.026s)
[344.157407] Starting dynamic subtest: ccs0
[344.181757] Dynamic subtest ccs0: SUCCESS (0.030s)
[344.184144] Subtest busy: SUCCESS (0.227s)
[344.281817] [075/138] (656s left) gem_mmap_gtt (isolation)
[344.357560] Subtest isolation: SKIP (0.000s)
[344.381949] [076/138] (656s left) gem_mmap_offset (open-flood)
[344.451095] Starting subtest: open-flood
[365.949653] Subtest open-flood: SUCCESS (21.501s)
[366.046890] [077/138] (634s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[366.150642] Starting subtest: x-tiled-64bpp-rotate-270
[366.168179] Subtest x-tiled-64bpp-rotate-270: SKIP (0.016s)
[366.268128] [078/138] (634s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[366.670528] Starting subtest: pipe-D-crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[371.954586] Subtest pipe-D-crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (5.286s)
[373.192634] [079/138] (627s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[373.272326] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[373.279018] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[373.359727] [080/138] (627s left) gem_exec_schedule (u-independent)
[373.432487] Starting subtest: u-independent
[373.434842] Starting dynamic subtest: rcs0
[375.467557] Dynamic subtest rcs0: SUCCESS (2.038s)
[375.480493] Starting dynamic subtest: vcs0
[377.472519] Dynamic subtest vcs0: SUCCESS (2.003s)
[377.486604] Starting dynamic subtest: vcs1
[379.468371] Dynamic subtest vcs1: SUCCESS (1.995s)
[379.481777] Starting dynamic subtest: vecs0
[381.505578] Dynamic subtest vecs0: SUCCESS (2.036s)
[381.518993] Starting dynamic subtest: ccs0
[383.467480] Dynamic subtest ccs0: SUCCESS (1.960s)
[383.470504] Subtest u-independent: SUCCESS (10.040s)
[383.769440] [081/138] (617s left) syncobj_wait (single-wait-all-for-submit-signaled)
[383.838692] Starting subtest: single-wait-all-for-submit-signaled
[383.841392] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[383.896338] [082/138] (616s left) gem_exec_balancer (parallel-keep-in-fence)
[384.154878] Starting subtest: parallel-keep-in-fence
[385.017360] Subtest parallel-keep-in-fence: SUCCESS (0.863s)
[385.090398] [083/138] (615s left) kms_cursor_crc (cursor-onscreen-256x85)
[385.249310] Starting subtest: cursor-onscreen-256x85
[385.251789] Starting dynamic subtest: pipe-A-eDP-1
[387.396138] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.143s)
[387.433854] Starting dynamic subtest: pipe-D-eDP-1
[390.253874] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.823s)
[390.256969] Subtest cursor-onscreen-256x85: SUCCESS (5.003s)
[391.141606] [084/138] (609s left) v3d/v3d_wait_bo (map-bo-0ns)
[391.247074] Subtest map-bo-0ns: SKIP (0.000s)
[391.295341] [085/138] (609s left) gem_exec_fence (basic-await)
[391.478401] Starting subtest: basic-await
[391.481251] Starting dynamic subtest: rcs0
[391.555357] Dynamic subtest rcs0: SUCCESS (0.078s)
[391.568491] Starting dynamic subtest: bcs0
[391.647691] Dynamic subtest bcs0: SUCCESS (0.090s)
[391.661281] Starting dynamic subtest: vcs0
[391.732253] Dynamic subtest vcs0: SUCCESS (0.083s)
[391.745814] Starting dynamic subtest: vcs1
[391.815498] Dynamic subtest vcs1: SUCCESS (0.082s)
[391.828759] Starting dynamic subtest: vecs0
[391.897455] Dynamic subtest vecs0: SUCCESS (0.080s)
[391.910855] Starting dynamic subtest: ccs0
[391.978358] Dynamic subtest ccs0: SUCCESS (0.080s)
[391.981310] Subtest basic-await: SUCCESS (0.502s)
[393.540179] [086/138] (607s left) gem_bad_reloc (negative-reloc-bltcopy)
[393.611543] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[393.669361] [087/138] (607s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[393.740428] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[398.491523] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.751s)
[398.610207] [088/138] (602s left) perf_pmu (all-busy-idle-check-all)
[398.676216] Starting subtest: all-busy-idle-check-all
[400.418375] Subtest all-busy-idle-check-all: SUCCESS (1.740s)
[400.487748] [089/138] (600s left) gen9_exec_parse (allowed-single)
[400.536868] Subtest allowed-single: SKIP (0.000s)
[400.574168] [090/138] (600s left) syncobj_basic (bad-fd-to-handle)
[400.624062] Starting subtest: bad-fd-to-handle
[400.626316] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[400.675710] [091/138] (600s left) syncobj_timeline (wait-for-submit-complex)
[400.730047] Starting subtest: wait-for-submit-complex
[400.791808] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[400.859920] [092/138] (600s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[400.922386] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[401.956861] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.035s)
[402.101211] [093/138] (599s left) gem_lmem_swapping (parallel-multi)
[402.157191] Subtest parallel-multi: SKIP (0.000s)
[402.182921] [094/138] (598s left) kms_ccs (pipe-c-bad-rotation-90-yf-tiled-ccs)
[402.567596] Starting subtest: pipe-C-bad-rotation-90-yf-tiled-ccs
[402.572547] Subtest pipe-C-bad-rotation-90-yf-tiled-ccs: SKIP (0.000s)
[403.451679] [095/138] (597s left) kms_invalid_mode (zero-clock)
[403.506740] Starting subtest: zero-clock
[403.509346] Starting dynamic subtest: pipe-A-eDP-1
[403.795793] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s)
[403.810224] Starting dynamic subtest: pipe-B-eDP-1
[403.812346] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[403.823478] Starting dynamic subtest: pipe-C-eDP-1
[403.825469] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[403.833454] Starting dynamic subtest: pipe-D-eDP-1
[403.835972] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[403.838653] Subtest zero-clock: SUCCESS (0.305s)
[404.732224] [096/138] (596s left) gem_exec_balancer (bonded-sync)
[404.792403] Starting subtest: bonded-sync
[404.797778] Subtest bonded-sync: SKIP (0.000s)
[405.056535] [097/138] (596s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[405.113144] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[405.115769] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[405.173135] [098/138] (596s left) api_intel_bb (destroy-bb)
[405.227714] Starting subtest: destroy-bb
[405.230147] Subtest destroy-bb: SUCCESS (0.004s)
[405.327467] [099/138] (595s left) kms_ccs (pipe-a-bad-pixel-format-4-tiled-dg2-rc-ccs)
[405.396095] Starting subtest: pipe-A-bad-pixel-format-4-tiled-dg2-rc-ccs
[405.401361] Subtest pipe-A-bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[406.602434] [100/138] (594s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[406.701565] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[425.470447] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (18.769s)
[426.363891] [101/138] (574s left) kms_addfb_basic (no-handle)
[426.413723] Starting subtest: no-handle
[426.416301] Subtest no-handle: SUCCESS (0.000s)
[426.526869] [102/138] (574s left) kms_pm_rpm (fences-dpms)
[428.642228] Starting subtest: fences-dpms
[428.648197] Subtest fences-dpms: SKIP (0.000s)
[428.994560] [103/138] (572s left) kms_flip (2x-flip-vs-expired-vblank)
[429.038523] Starting subtest: 2x-flip-vs-expired-vblank
[429.049694] Subtest 2x-flip-vs-expired-vblank: SKIP (0.014s)
[429.113904] [104/138] (572s left) gem_exec_schedule (preempt-hang)
[429.293371] Starting subtest: preempt-hang
[429.296246] Starting dynamic subtest: rcs0
[429.526778] Dynamic subtest rcs0: SUCCESS (0.231s)
[429.533247] Starting dynamic subtest: bcs0
[429.762028] Dynamic subtest bcs0: SUCCESS (0.234s)
[429.775539] Starting dynamic subtest: vcs0
[429.992076] Dynamic subtest vcs0: SUCCESS (0.229s)
[430.005645] Starting dynamic subtest: vcs1
[430.222429] Dynamic subtest vcs1: SUCCESS (0.229s)
[430.228055] Starting dynamic subtest: vecs0
[430.448919] Dynamic subtest vecs0: SUCCESS (0.226s)
[430.458261] Starting dynamic subtest: ccs0
[430.686388] Dynamic subtest ccs0: SUCCESS (0.236s)
[430.689272] Subtest preempt-hang: SUCCESS (1.392s)
[431.567844] [105/138] (569s left) kms_chamelium_hpd (dp-hpd-storm)
[431.941407] Subtest dp-hpd-storm: SKIP (0.000s)
[432.804363] [106/138] (568s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[432.878772] Starting subtest: y-tiled-64bpp-rotate-180
[432.882934] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[432.967403] [107/138] (568s left) kms_chamelium_frames (dp-frame-dump)
[433.324162] Subtest dp-frame-dump: SKIP (0.000s)
[434.215371] [108/138] (567s left) i915_query (hwconfig_table)
[434.272538] Starting subtest: hwconfig_table
[434.577730] Subtest hwconfig_table: SUCCESS (0.002s)
[434.601130] [109/138] (566s left) gem_ctx_param (invalid-ctx-set)
[434.658719] Starting subtest: invalid-ctx-set
[434.660984] Subtest invalid-ctx-set: SUCCESS (0.000s)
[434.720433] [110/138] (566s left) gem_exec_suspend (basic-s0)
[434.777206] Starting subtest: basic-S0
[434.779838] Starting dynamic subtest: smem
[454.416899] Dynamic subtest smem: SUCCESS (6.664s)
[454.419686] Subtest basic-S0: SUCCESS (6.665s)
[454.598235] [111/138] (559s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[454.713194] Starting subtest: cursorA-vs-flipA-varying-size
[465.839660] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.127s)
[466.724419] [112/138] (547s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[466.807391] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[470.055466] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (3.252s)
[470.173856] [113/138] (544s left) vgem_basic (create)
[470.240156] Starting subtest: create
[470.242153] Subtest create: SUCCESS (0.000s)
[470.291340] [114/138] (544s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[470.383669] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[471.069241] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.686s)
[471.240331] [115/138] (543s left) gem_mmap_gtt (basic-small-copy-xy)
[471.284592] Subtest basic-small-copy-XY: SKIP (0.000s)
[471.318145] [116/138] (543s left) i915_module_load (load)
[471.379399] Starting subtest: load
[471.383950] Subtest load: SKIP (0.001s)
[471.435411] [117/138] (543s left) v3d/v3d_perfmon (get-values-invalid-pointer)
[471.496514] Subtest get-values-invalid-pointer: SKIP (0.000s)
[471.543065] [118/138] (543s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[471.605829] Starting subtest: x-tiled-to-vebox-yf-tiled
[471.610688] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[471.782642] [119/138] (542s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[471.835159] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[471.848417] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.014s)
[471.915726] [120/138] (542s left) core_getclient
[472.019782] [121/138] (542s left) gem_workarounds (suspend-resume)
[472.075119] Starting subtest: suspend-resume
[488.500780] Subtest suspend-resume: SUCCESS (1.160s)
[488.597874] [122/138] (541s left) kms_vblank (invalid)
[488.668631] Starting subtest: invalid
[488.671161] Starting dynamic subtest: pipe-A-eDP-1
[489.075203] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.409s)
[489.077658] Subtest invalid: SUCCESS (0.411s)
[490.010904] [123/138] (540s left) kms_cursor_crc (cursor-sliding-256x256)
[490.133035] Starting subtest: cursor-sliding-256x256
[490.135553] Starting dynamic subtest: pipe-A-eDP-1
[493.380809] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.244s)
[493.414881] Starting dynamic subtest: pipe-D-eDP-1
[497.374272] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.973s)
[497.376834] Subtest cursor-sliding-256x256: SUCCESS (7.241s)
[498.267307] [124/138] (531s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[498.327858] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[498.332219] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[498.402672] [125/138] (531s left) kms_plane_lowres (tiling-y)
[498.484073] Starting subtest: tiling-y
[498.488704] Subtest tiling-y: SKIP (0.000s)
[498.548304] [126/138] (531s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[498.612863] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[498.615390] Starting dynamic subtest: pipe-A-default-mode
[498.903191] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[498.908046] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.287s)
[499.801831] [127/138] (530s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[499.891976] Starting subtest: 2x-long-cursor-vs-flip-atomic
[499.899787] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[499.995814] [128/138] (530s left) gem_ctx_bad_destroy (double-destroy)
[500.061805] Starting subtest: double-destroy
[500.064133] Subtest double-destroy: SUCCESS (0.000s)
[500.122081] [129/138] (530s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[500.215173] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[500.219855] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[500.304909] [130/138] (530s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[500.374151] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[500.378752] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[500.465031] [131/138] (529s left) kms_ccs (pipe-b-bad-aux-stride-yf-tiled-ccs)
[500.869522] Starting subtest: pipe-B-bad-aux-stride-yf-tiled-ccs
[500.875380] Subtest pipe-B-bad-aux-stride-yf-tiled-ccs: SKIP (0.000s)
[501.773350] [132/138] (528s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[501.857800] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[507.205514] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (5.351s)
[507.316970] [133/138] (523s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[507.404189] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[512.330322] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.932s)
[512.434368] [134/138] (517s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[512.513197] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[512.515534] Starting dynamic subtest: pipe-A-default-mode
[512.813648] Dynamic subtest pipe-A-default-mode: SKIP (0.298s)
[512.818460] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.299s)
[513.689019] [135/138] (516s left) kms_ccs (pipe-c-random-ccs-data-4-tiled-mtl-mc-ccs)
[514.114304] Starting subtest: pipe-C-random-ccs-data-4-tiled-mtl-mc-ccs
[515.290460] Subtest pipe-C-random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (1.176s)
[516.490292] [136/138] (513s left) gem_ctx_persistence (legacy-engines-persistence)
[516.552125] Starting subtest: legacy-engines-persistence
[516.554433] Starting dynamic subtest: render
[517.322070] Dynamic subtest render: SUCCESS (0.775s)
[517.337838] Starting dynamic subtest: bsd1
[518.089849] Dynamic subtest bsd1: SUCCESS (0.765s)
[518.105938] Starting dynamic subtest: bsd2
[518.855559] Dynamic subtest bsd2: SUCCESS (0.764s)
[518.872398] Starting dynamic subtest: blt
[519.615301] Dynamic subtest blt: SUCCESS (0.758s)
[519.631153] Starting dynamic subtest: vebox
[520.381616] Dynamic subtest vebox: SUCCESS (0.764s)
[520.384561] Subtest legacy-engines-persistence: SUCCESS (3.835s)
[520.483265] [137/138] (510s left) v3d/v3d_job_submission (threaded-job-submission)
[520.555993] Subtest threaded-job-submission: SKIP (0.000s)
[520.600064] [138/138] (509s left) gem_userptr_blits (unsync-overlap)
[520.643960] Subtest unsync-overlap: SKIP (0.000s)
[520.747688] Closing watchdogs
Done.