[53.792476] Initializing watchdogs
[53.792769]   /dev/watchdog0
[53.809810] [001/142] (960s left) kms_color (ctm-max)
[54.136215] Starting subtest: ctm-max
[54.138173] Starting dynamic subtest: pipe-A
[54.721511] Dynamic subtest pipe-A: SUCCESS (0.570s)
[54.741925] Starting dynamic subtest: pipe-B
[55.566533] Dynamic subtest pipe-B: SUCCESS (0.843s)
[55.583260] Starting dynamic subtest: pipe-C
[56.508727] Dynamic subtest pipe-C: SUCCESS (0.957s)
[56.510843] Subtest ctm-max: SUCCESS (2.372s)
[56.852790] [002/142] (957s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-factor-0-25)
[57.167344] Starting subtest: planes-downscale-factor-0-25-upscale-factor-0-25
[57.171245] Starting dynamic subtest: pipe-A-DP-1
[57.198659] Dynamic subtest pipe-A-DP-1: SKIP (0.029s)
[57.218638] Starting dynamic subtest: pipe-B-DP-1
[57.287355] Dynamic subtest pipe-B-DP-1: SKIP (0.086s)
[57.302483] Starting dynamic subtest: pipe-C-DP-1
[57.369470] Dynamic subtest pipe-C-DP-1: SKIP (0.081s)
[57.373895] Subtest planes-downscale-factor-0-25-upscale-factor-0-25: SKIP (0.206s)
[57.468063] [003/142] (956s left) kms_flip (2x-flip-vs-rmfb)
[57.766668] Starting subtest: 2x-flip-vs-rmfb
[57.770769] Subtest 2x-flip-vs-rmfb: SKIP (0.003s)
[57.883920] [004/142] (956s left) gem_exec_fair (basic-deadline)
[58.135454] Starting subtest: basic-deadline
[60.475069] Subtest basic-deadline: FAIL (2.177s)
[60.535205] [005/142] (953s left) gem_exec_reloc (basic-write-wc)
[60.754148] Starting subtest: basic-write-wc
[60.774688] Subtest basic-write-wc: SUCCESS (0.020s)
[60.951070] [006/142] (953s left) gem_exec_whisper (basic-contexts-forked-all)
[61.183467] Starting subtest: basic-contexts-forked-all
[85.165742] Subtest basic-contexts-forked-all: SUCCESS (23.978s)
[85.366687] [007/142] (929s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[85.713236] Starting subtest: y-tiled-addfb-size-offset-overflow
[85.717288] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[85.820328] [008/142] (928s left) gem_create (create-size-update)
[86.024755] Starting subtest: create-size-update
[86.026792] Subtest create-size-update: SUCCESS (0.000s)
[86.252274] [009/142] (928s left) gem_ctx_shared (disjoint-timelines)
[86.480577] Starting subtest: disjoint-timelines
[86.576751] Subtest disjoint-timelines: SUCCESS (0.097s)
[86.802525] [010/142] (927s left) kms_prop_blob (blob-prop-validate)
[87.005735] Starting subtest: blob-prop-validate
[87.007869] Subtest blob-prop-validate: SUCCESS (0.000s)
[87.084813] [011/142] (927s left) gem_linear_blits (basic)
[88.641454] Starting subtest: basic
[88.656710] Subtest basic: SUCCESS (0.017s)
[88.786194] [012/142] (925s left) gem_ringfill (legacy-basic)
[89.386325] Starting subtest: legacy-basic
[89.388468] Starting dynamic subtest: default
[89.411684] Dynamic subtest default: SUCCESS (0.027s)
[89.433685] Starting dynamic subtest: render
[89.439080] Dynamic subtest render: SUCCESS (0.026s)
[89.458753] Starting dynamic subtest: bsd
[89.464240] Dynamic subtest bsd: SUCCESS (0.023s)
[89.483560] Starting dynamic subtest: bsd1
[89.488434] Dynamic subtest bsd1: SUCCESS (0.023s)
[89.509025] Starting dynamic subtest: blt
[89.516640] Dynamic subtest blt: SUCCESS (0.028s)
[89.536278] Starting dynamic subtest: vebox
[89.541683] Dynamic subtest vebox: SUCCESS (0.024s)
[89.544260] Subtest legacy-basic: SUCCESS (0.158s)
[89.636320] [013/142] (925s left) gem_vm_create (create-ext)
[89.862823] Starting subtest: create-ext
[89.864924] Subtest create-ext: SUCCESS (0.005s)
[89.971096] [014/142] (924s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[90.302460] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[90.306293] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[90.388955] [015/142] (924s left) kms_ccs (pipe-a-random-ccs-data-yf_tiled_ccs)
[90.826436] Starting subtest: pipe-A-random-ccs-data-yf_tiled_ccs
[91.275694] Subtest pipe-A-random-ccs-data-yf_tiled_ccs: SUCCESS (0.445s)
[91.950617] [016/142] (922s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[92.256097] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[93.053782] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (0.795s)
[93.391872] [017/142] (921s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[93.702560] Starting subtest: primary-4-tiled-reflect-x-180
[93.706502] Subtest primary-4-tiled-reflect-x-180: SKIP (0.003s)
[93.790307] [018/142] (921s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[94.128186] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[94.132084] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[94.240497] [019/142] (920s left) gem_ppgtt (blt-vs-render-ctx0)
[94.475232] Starting subtest: blt-vs-render-ctx0
[127.131810] Subtest blt-vs-render-ctx0: SUCCESS (32.678s)
[127.255590] [020/142] (887s left) vc4/vc4_perfmon (create-perfmon-0)
[127.652709] Subtest create-perfmon-0: SKIP (0.000s)
[127.721860] [021/142] (887s left) kms_plane_alpha_blend (alpha-7efc)
[128.037518] Starting subtest: alpha-7efc
[128.350845] Starting dynamic subtest: pipe-A-DP-1
[128.817535] Dynamic subtest pipe-A-DP-1: SUCCESS (0.464s)
[128.897425] Starting dynamic subtest: pipe-C-DP-1
[129.705662] Dynamic subtest pipe-C-DP-1: SUCCESS (0.826s)
[129.707946] Subtest alpha-7efc: SUCCESS (1.670s)
[130.083746] [022/142] (885s left) v3d/v3d_submit_cl (bad-in-sync)
[130.345266] Subtest bad-in-sync: SKIP (0.000s)
[130.416462] [023/142] (884s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[130.739052] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[130.743197] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[130.833950] [024/142] (884s left) gem_exec_balancer (bonded-sync)
[131.064910] Starting subtest: bonded-sync
[134.822274] Subtest bonded-sync: SUCCESS (3.756s)
[138.767961] [025/142] (876s left) gem_ctx_persistence (file)
[138.984057] Starting subtest: file
[139.064424] Subtest file: SUCCESS (0.081s)
[139.166334] [026/142] (876s left) kms_vblank (pipe-a-ts-continuation-suspend)
[139.471399] Starting subtest: pipe-A-ts-continuation-suspend
[156.134750] Subtest pipe-A-ts-continuation-suspend: SUCCESS (1.686s)
[162.489448] [027/142] (873s left) gem_exec_basic (basic)
[162.712635] Starting subtest: basic
[162.715014] Starting dynamic subtest: rcs0-smem
[162.717053] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[162.739327] Starting dynamic subtest: bcs0-smem
[162.741370] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[162.762948] Starting dynamic subtest: vcs0-smem
[162.764947] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[162.787636] Starting dynamic subtest: vecs0-smem
[162.789716] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[162.791784] Subtest basic: SUCCESS (0.008s)
[162.947885] [028/142] (873s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-pwrite)
[163.256121] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-pwrite
[163.259976] Subtest fbcpsr-1p-offscren-pri-indfb-draw-pwrite: SKIP (0.000s)
[163.363822] [029/142] (873s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[163.571366] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[163.573598] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.001s)
[163.663999] [030/142] (872s left) kms_cursor_crc (cursor-sliding-32x10)
[163.973120] Starting subtest: cursor-sliding-32x10
[164.094622] Subtest cursor-sliding-32x10: SKIP (0.117s)
[164.214064] [031/142] (872s left) kms_hdr (bpc-switch)
[164.511638] Starting subtest: bpc-switch
[166.771102] Starting dynamic subtest: pipe-A-DP-1
[168.030440] Dynamic subtest pipe-A-DP-1: SUCCESS (1.261s)
[168.033143] Subtest bpc-switch: SUCCESS (3.519s)
[168.423016] [032/142] (868s left) vgem_basic (unload)
[168.624248] Starting subtest: unload
[197.643619] Subtest unload: SUCCESS (29.018s)
[197.787053] [033/142] (838s left) dumb_buffer (map-invalid-size)
[197.993995] Starting subtest: map-invalid-size
[197.996018] Subtest map-invalid-size: SUCCESS (0.000s)
[198.103301] [034/142] (838s left) gem_cs_tlb (engines)
[198.315089] Starting subtest: engines
[198.317201] Starting dynamic subtest: rcs0
[200.482633] Dynamic subtest rcs0: SUCCESS (2.163s)
[200.509596] Starting dynamic subtest: bcs0
[202.646672] Dynamic subtest bcs0: SUCCESS (2.166s)
[202.670367] Starting dynamic subtest: vcs0
[204.811228] Dynamic subtest vcs0: SUCCESS (2.164s)
[204.833896] Starting dynamic subtest: vecs0
[206.973362] Dynamic subtest vecs0: SUCCESS (2.161s)
[206.975720] Subtest engines: SUCCESS (8.656s)
[207.089302] [035/142] (829s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[207.402661] Starting subtest: 2x-flip-vs-cursor-atomic
[207.408170] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.005s)
[207.488616] [036/142] (829s left) kms_ccs (pipe-c-random-ccs-data-yf_tiled_ccs)
[208.109199] Starting subtest: pipe-C-random-ccs-data-yf_tiled_ccs
[208.115200] Subtest pipe-C-random-ccs-data-yf_tiled_ccs: SKIP (0.000s)
[208.481369] [037/142] (828s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[208.792221] Starting subtest: read-crc-frame-sequence
[208.794584] Starting dynamic subtest: pipe-A-DP-1
[209.334284] Dynamic subtest pipe-A-DP-1: SUCCESS (0.542s)
[209.361664] Starting dynamic subtest: pipe-B-DP-1
[210.153081] Dynamic subtest pipe-B-DP-1: SUCCESS (0.815s)
[210.176466] Starting dynamic subtest: pipe-C-DP-1
[211.109827] Dynamic subtest pipe-C-DP-1: SUCCESS (0.953s)
[211.112422] Subtest read-crc-frame-sequence: SUCCESS (2.321s)
[211.439432] [038/142] (825s left) kms_cursor_crc (cursor-offscreen-512x512)
[211.767026] Starting subtest: cursor-offscreen-512x512
[211.774294] Subtest cursor-offscreen-512x512: SKIP (0.003s)
[211.889002] [039/142] (824s left) syncobj_wait (reset-during-wait-for-submit)
[212.097563] Starting subtest: reset-during-wait-for-submit
[212.202124] Subtest reset-during-wait-for-submit: SUCCESS (0.104s)
[212.291084] [040/142] (824s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[212.600599] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[212.604534] Subtest fbcpsr-1p-pri-indfb-multidraw: SKIP (0.000s)
[212.705739] [041/142] (824s left) gem_exec_params (rel-constants-invalid)
[212.919206] Starting subtest: rel-constants-invalid
[212.921490] Subtest rel-constants-invalid: SUCCESS (0.000s)
[213.038411] [042/142] (823s left) drm_read (fault-buffer)
[213.461542] Starting subtest: fault-buffer
[213.463703] Subtest fault-buffer: SUCCESS (0.002s)
[213.591386] [043/142] (823s left) kms_ccs (pipe-c-bad-pixel-format-4_tiled_dg2_rc_ccs_cc)
[214.172053] Starting subtest: pipe-C-bad-pixel-format-4_tiled_dg2_rc_ccs_cc
[214.177544] Subtest pipe-C-bad-pixel-format-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[214.607212] [044/142] (822s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[214.812629] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[214.919928] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.108s)
[215.006556] [045/142] (822s left) kms_cursor_legacy (single-bo)
[215.308469] Starting subtest: single-bo
[215.310582] Starting dynamic subtest: pipe-A
[220.713180] Dynamic subtest pipe-A: SUCCESS (5.406s)
[220.736913] Starting dynamic subtest: pipe-B
[226.119705] Dynamic subtest pipe-B: SUCCESS (5.405s)
[226.143045] Starting dynamic subtest: pipe-C
[231.525999] Dynamic subtest pipe-C: SUCCESS (5.404s)
[231.548628] Starting dynamic subtest: all-pipes
[236.934536] Dynamic subtest all-pipes: SUCCESS (5.408s)
[236.937120] Subtest single-bo: SUCCESS (21.629s)
[237.024418] [046/142] (800s left) gem_mmap_wc (fault-concurrent)
[237.229875] Starting subtest: fault-concurrent
[238.930748] Subtest fault-concurrent: SUCCESS (1.702s)
[239.022729] [047/142] (798s left) vgem_basic (busy-fence)
[239.230985] Starting subtest: busy-fence
[239.233168] Subtest busy-fence: SUCCESS (0.001s)
[239.306287] [048/142] (797s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[239.616505] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[239.620460] Subtest psr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[239.724505] [049/142] (797s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[240.050014] Starting subtest: x-tiled-16bpp-rotate-270
[240.140807] Subtest x-tiled-16bpp-rotate-270: SKIP (0.087s)
[240.257348] [050/142] (797s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[240.567531] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[242.879689] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (2.318s)
[243.008090] [051/142] (794s left) perf_pmu (busy-idle-no-semaphores)
[243.226032] Starting subtest: busy-idle-no-semaphores
[243.228345] Starting dynamic subtest: rcs0
[243.866967] Dynamic subtest rcs0: SUCCESS (0.642s)
[243.895241] Starting dynamic subtest: bcs0
[244.502317] Dynamic subtest bcs0: SUCCESS (0.633s)
[244.525651] Starting dynamic subtest: vcs0
[245.132630] Dynamic subtest vcs0: SUCCESS (0.628s)
[245.155745] Starting dynamic subtest: vecs0
[245.762675] Dynamic subtest vecs0: SUCCESS (0.628s)
[245.764917] Subtest busy-idle-no-semaphores: SUCCESS (2.539s)
[245.872482] [052/142] (791s left) i915_pm_freq_api (freq-reset)
[246.085604] Subtest freq-reset: SKIP (0.000s)
[246.138073] [053/142] (791s left) gem_mmap_wc (bad-size)
[246.338270] Starting subtest: bad-size
[246.340622] Subtest bad-size: SUCCESS (0.001s)
[246.455602] [054/142] (791s left) api_intel_bb (blit-reloc-purge-cache)
[246.662274] Starting subtest: blit-reloc-purge-cache
[246.681352] Subtest blit-reloc-purge-cache: SUCCESS (0.020s)
[246.788804] [055/142] (790s left) perf_pmu (pmu-read)
[246.998574] Starting subtest: pmu-read
[247.005910] Subtest pmu-read: SUCCESS (0.007s)
[247.122325] [056/142] (790s left) kms_vblank (pipe-c-ts-continuation-dpms-rpm)
[247.422166] Starting subtest: pipe-C-ts-continuation-dpms-rpm
[249.706950] Subtest pipe-C-ts-continuation-dpms-rpm: SUCCESS (2.282s)
[250.190450] [057/142] (787s left) gem_mmap_gtt (big-copy-xy)
[250.397914] Starting subtest: big-copy-XY
[262.660327] Subtest big-copy-XY: SUCCESS (12.264s)
[262.808487] [058/142] (774s left) kms_vblank (pipe-d-wait-idle)
[263.230290] Subtest pipe-D-wait-idle: SKIP (0.000s)
[263.324048] [059/142] (774s left) kms_psr (cursor_mmap_cpu)
[263.535544] Subtest cursor_mmap_cpu: SKIP (0.000s)
[263.588532] [060/142] (774s left) gem_render_copy (y-tiled-ccs-to-linear)
[263.811565] Starting subtest: y-tiled-ccs-to-linear
[263.814198] Starting dynamic subtest: smem
[264.084017] Dynamic subtest smem: SUCCESS (0.270s)
[264.086215] Subtest y-tiled-ccs-to-linear: SUCCESS (0.272s)
[264.340625] [061/142] (773s left) drm_fdinfo (busy-check-all)
[264.556620] Starting subtest: busy-check-all
[264.559139] Starting dynamic subtest: rcs0
[265.090416] Dynamic subtest rcs0: SUCCESS (0.533s)
[265.117665] Starting dynamic subtest: bcs0
[265.626146] Dynamic subtest bcs0: SUCCESS (0.534s)
[265.653155] Starting dynamic subtest: vcs0
[266.155692] Dynamic subtest vcs0: SUCCESS (0.528s)
[266.180720] Starting dynamic subtest: vecs0
[266.685584] Dynamic subtest vecs0: SUCCESS (0.529s)
[266.687970] Subtest busy-check-all: SUCCESS (2.130s)
[266.773088] [062/142] (771s left) sysfs_heartbeat_interval (precise)
[266.986017] Starting subtest: precise
[266.988077] Starting dynamic subtest: vecs0
[268.499022] Dynamic subtest vecs0: SUCCESS (1.511s)
[268.523043] Starting dynamic subtest: vcs0
[269.983202] Dynamic subtest vcs0: SUCCESS (1.481s)
[270.008682] Starting dynamic subtest: bcs0
[271.471500] Dynamic subtest bcs0: SUCCESS (1.488s)
[271.496251] Starting dynamic subtest: rcs0
[272.980095] Dynamic subtest rcs0: SUCCESS (1.506s)
[272.982571] Subtest precise: SUCCESS (5.994s)
[273.071707] [063/142] (764s left) kms_draw_crc (draw-method-mmap-wc)
[273.382167] Starting subtest: draw-method-mmap-wc
[273.384465] Starting dynamic subtest: xrgb8888-untiled
[273.677277] Dynamic subtest xrgb8888-untiled: SUCCESS (0.298s)
[273.703082] Starting dynamic subtest: rgb565-untiled
[273.960724] Dynamic subtest rgb565-untiled: SUCCESS (0.282s)
[273.986230] Starting dynamic subtest: xrgb2101010-untiled
[274.259791] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.298s)
[274.285383] Starting dynamic subtest: xrgb8888-xtiled
[274.476549] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.215s)
[274.501029] Starting dynamic subtest: rgb565-xtiled
[274.677745] Dynamic subtest rgb565-xtiled: SUCCESS (0.198s)
[274.701762] Starting dynamic subtest: xrgb2101010-xtiled
[274.893297] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.215s)
[274.918677] Starting dynamic subtest: xrgb8888-ytiled
[275.111332] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.217s)
[275.135507] Starting dynamic subtest: rgb565-ytiled
[275.310328] Dynamic subtest rgb565-ytiled: SUCCESS (0.198s)
[275.335578] Starting dynamic subtest: xrgb2101010-ytiled
[275.527529] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.215s)
[275.529921] Subtest draw-method-mmap-wc: SUCCESS (2.148s)
[275.638149] [064/142] (762s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[275.959243] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[275.963158] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[276.056721] [065/142] (761s left) kms_plane_scaling (plane-scaler-with-pixel-format-unity-scaling)
[276.358803] Starting subtest: plane-scaler-with-pixel-format-unity-scaling
[276.360920] Starting dynamic subtest: pipe-A-DP-1
[278.743185] Dynamic subtest pipe-A-DP-1: SUCCESS (2.385s)
[278.782945] Starting dynamic subtest: pipe-B-DP-1
[281.369781] Dynamic subtest pipe-B-DP-1: SUCCESS (2.623s)
[281.403005] Starting dynamic subtest: pipe-C-DP-1
[281.757513] Dynamic subtest pipe-C-DP-1: SUCCESS (0.382s)
[281.759815] Subtest plane-scaler-with-pixel-format-unity-scaling: SUCCESS (5.403s)
[282.178399] [066/142] (755s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[282.580942] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[282.875079] [067/142] (755s left) v3d/v3d_submit_cl (multi-and-single-sync)
[283.158668] Subtest multi-and-single-sync: SKIP (0.000s)
[283.235589] [068/142] (754s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[283.549333] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[284.827693] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (1.279s)
[285.172141] [069/142] (753s left) gem_userptr_blits (unsync-overlap)
[285.395746] Subtest unsync-overlap: SKIP (0.000s)
[285.570810] [070/142] (752s left) kms_atomic (plane-immutable-zpos)
[285.997076] Starting subtest: plane-immutable-zpos
[286.222621] Subtest plane-immutable-zpos: SUCCESS (0.227s)
[286.677162] [071/142] (751s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[286.891362] Starting subtest: invalid-bsd1-flag-on-vebox
[286.893903] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.001s)
[286.994699] [072/142] (751s left) gem_huc_copy (huc-copy)
[287.209066] Starting subtest: huc-copy
[287.213629] Subtest huc-copy: SKIP (0.000s)
[287.327481] [073/142] (751s left) gem_pxp (create-regular-buffer)
[290.051041] Subtest create-regular-buffer: SKIP (0.000s)
[290.143307] [074/142] (748s left) kms_ccs (pipe-a-crc-primary-basic-y_tiled_ccs)
[290.566463] Starting subtest: pipe-A-crc-primary-basic-y_tiled_ccs
[291.220384] Subtest pipe-A-crc-primary-basic-y_tiled_ccs: SUCCESS (0.655s)
[291.968715] [075/142] (746s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[292.279266] Starting subtest: cursorB-vs-flipB-legacy
[292.283460] Subtest cursorB-vs-flipB-legacy: SKIP (0.002s)
[292.380736] [076/142] (746s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[292.602038] Starting subtest: y-tiled-ccs-to-x-tiled
[292.605068] Starting dynamic subtest: smem
[292.894398] Dynamic subtest smem: SUCCESS (0.289s)
[292.896609] Subtest y-tiled-ccs-to-x-tiled: SUCCESS (0.291s)
[293.100066] [077/142] (745s left) gem_exec_schedule (preemptive-hang)
[293.451034] Starting subtest: preemptive-hang
[293.453547] Starting dynamic subtest: rcs0
[299.309326] Dynamic subtest rcs0: SUCCESS (5.856s)
[299.337106] Starting dynamic subtest: bcs0
[305.324760] Dynamic subtest bcs0: SUCCESS (6.014s)
[305.355283] Starting dynamic subtest: vcs0
[311.342731] Dynamic subtest vcs0: SUCCESS (6.014s)
[311.371252] Starting dynamic subtest: vecs0
[317.293652] Dynamic subtest vecs0: SUCCESS (5.950s)
[317.295805] Subtest preemptive-hang: SUCCESS (23.841s)
[317.513155] [078/142] (721s left) gem_shrink (reclaim)
[317.730781] Starting subtest: reclaim
[319.994805] Subtest reclaim: SUCCESS (2.264s)
[320.083386] [079/142] (718s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[320.391041] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[320.394778] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[320.497686] [080/142] (718s left) kms_addfb_basic (invalid-set-prop-any)
[320.704081] Starting subtest: invalid-set-prop-any
[320.706216] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[320.914541] [081/142] (717s left) gem_userptr_blits (sync-unmap-after-close)
[321.158364] Starting subtest: sync-unmap-after-close
[321.194996] Subtest sync-unmap-after-close: SUCCESS (0.036s)
[321.331678] [082/142] (717s left) gem_exec_params (invalid-fence-in-submit)
[321.542059] Starting subtest: invalid-fence-in-submit
[321.548369] Subtest invalid-fence-in-submit: SUCCESS (0.004s)
[321.662892] [083/142] (717s left) gem_render_copy (yf-tiled-to-vebox-linear)
[321.887280] Starting subtest: yf-tiled-to-vebox-linear
[321.891410] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[322.097187] [084/142] (716s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[322.402870] Starting subtest: cursorA-vs-flipB-toggle
[322.406731] Subtest cursorA-vs-flipB-toggle: SKIP (0.002s)
[322.498478] [085/142] (716s left) kms_ccs (pipe-c-crc-primary-basic-4_tiled_mtl_rc_ccs_cc)
[323.099970] Starting subtest: pipe-C-crc-primary-basic-4_tiled_mtl_rc_ccs_cc
[323.104329] Subtest pipe-C-crc-primary-basic-4_tiled_mtl_rc_ccs_cc: SKIP (0.001s)
[323.504002] [086/142] (715s left) perf_pmu (cpu-hotplug)
[323.716983] Starting subtest: cpu-hotplug
[323.723967] Subtest cpu-hotplug: SKIP (0.005s)
[323.836311] [087/142] (715s left) gem_vm_create (isolation)
[324.047275] Starting subtest: isolation
[324.059636] Subtest isolation: SUCCESS (0.012s)
[324.169624] [088/142] (714s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[324.484953] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[324.488810] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[324.587338] [089/142] (714s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[324.916300] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[324.920657] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[325.041501] [090/142] (714s left) kms_vblank (pipe-c-wait-forked-busy-hang)
[325.372055] Starting subtest: pipe-C-wait-forked-busy-hang
[332.965167] Subtest pipe-C-wait-forked-busy-hang: SUCCESS (7.593s)
[333.319547] [091/142] (705s left) gem_exec_fence (syncobj-channel)
[334.005316] Starting subtest: syncobj-channel
[335.073202] Subtest syncobj-channel: SUCCESS (1.066s)
[335.417808] [092/142] (703s left) kms_invalid_mode (zero-vdisplay)
[335.723527] Starting subtest: zero-vdisplay
[335.725738] Starting dynamic subtest: DP-1-pipe-A
[335.829499] Dynamic subtest DP-1-pipe-A: SUCCESS (0.106s)
[335.872347] Starting dynamic subtest: DP-1-pipe-B
[335.874882] Dynamic subtest DP-1-pipe-B: SUCCESS (0.015s)
[335.915351] Starting dynamic subtest: DP-1-pipe-C
[335.917953] Dynamic subtest DP-1-pipe-C: SUCCESS (0.014s)
[335.920400] Subtest zero-vdisplay: SUCCESS (0.146s)
[336.192871] [093/142] (703s left) gem_mmap_gtt (basic-small-bo-tiledx)
[336.396773] Starting subtest: basic-small-bo-tiledX
[337.082181] Subtest basic-small-bo-tiledX: SUCCESS (0.686s)
[337.271172] [094/142] (702s left) gem_mmap_gtt (close-race)
[337.593025] Starting subtest: close-race
[357.696594] Subtest close-race: SUCCESS (20.105s)
[357.809574] [095/142] (681s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[358.118886] Starting subtest: flip-vs-cursor-crc-atomic
[358.947061] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.826s)
[359.294817] [096/142] (680s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[359.610820] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[359.614725] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[359.710745] [097/142] (679s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-blt)
[360.035005] Starting subtest: psr-1p-offscren-pri-indfb-draw-blt
[360.038952] Subtest psr-1p-offscren-pri-indfb-draw-blt: SKIP (0.000s)
[360.143749] [098/142] (679s left) kms_vblank (pipe-a-wait-forked-busy)
[360.446878] Starting subtest: pipe-A-wait-forked-busy
[362.915327] Subtest pipe-A-wait-forked-busy: SUCCESS (2.469s)
[363.258335] [099/142] (676s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[363.577492] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[363.581485] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[363.690773] [100/142] (675s left) syncobj_basic (bad-flags-fd-to-handle)
[363.894171] Starting subtest: bad-flags-fd-to-handle
[363.896659] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[363.991415] [101/142] (675s left) kms_ccs (pipe-b-ccs-on-another-bo-y_tiled_gen12_rc_ccs)
[364.539192] Starting subtest: pipe-B-ccs-on-another-bo-y_tiled_gen12_rc_ccs
[364.544037] Subtest pipe-B-ccs-on-another-bo-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[365.000603] [102/142] (674s left) kms_ccs (pipe-d-random-ccs-data-y_tiled_ccs)
[365.682109] Subtest pipe-D-random-ccs-data-y_tiled_ccs: SKIP (0.000s)
[365.995161] [103/142] (673s left) vc4/vc4_label_bo (set-bad-handle)
[366.266597] Subtest set-bad-handle: SKIP (0.000s)
[366.344435] [104/142] (673s left) kms_ccs (pipe-a-bad-rotation-90-4_tiled_dg2_rc_ccs)
[366.748196] Starting subtest: pipe-A-bad-rotation-90-4_tiled_dg2_rc_ccs
[366.752776] Subtest pipe-A-bad-rotation-90-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[367.318559] [105/142] (672s left) kms_cdclk (plane-scaling)
[367.525991] Subtest plane-scaling: SKIP (0.000s)
[367.583928] [106/142] (672s left) syncobj_timeline (single-wait-available-submitted)
[367.790681] Starting subtest: single-wait-available-submitted
[367.793154] Subtest single-wait-available-submitted: SUCCESS (0.001s)
[367.893479] [107/142] (672s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[368.226920] Starting subtest: psr-2p-primscrn-spr-indfb-move
[368.230888] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[368.337801] [108/142] (671s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[368.549351] Starting subtest: multi-wait-for-submit-available-signaled
[368.552286] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.003s)
[368.658127] [109/142] (671s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[368.983277] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[368.987151] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[369.113769] [110/142] (671s left) gem_exec_flush (basic-wb-set-default)
[369.343403] Starting subtest: basic-wb-set-default
[374.818730] Subtest basic-wb-set-default: SUCCESS (5.475s)
[375.035143] [111/142] (665s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs)
[375.701050] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs
[375.708713] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs: SKIP (0.004s)
[376.042009] [112/142] (664s left) gen9_exec_parse (batch-zero-length)
[376.270087] Starting subtest: batch-zero-length
[376.275533] Subtest batch-zero-length: SUCCESS (0.004s)
[376.508400] [113/142] (663s left) kms_async_flips (invalid-async-flip)
[376.812172] Starting subtest: invalid-async-flip
[377.277909] Starting dynamic subtest: pipe-A-DP-1
[378.158749] Dynamic subtest pipe-A-DP-1: SUCCESS (0.881s)
[378.631257] Starting dynamic subtest: pipe-B-DP-1
[378.894959] Dynamic subtest pipe-B-DP-1: SUCCESS (0.302s)
[379.282742] Starting dynamic subtest: pipe-C-DP-1
[379.517193] Dynamic subtest pipe-C-DP-1: SUCCESS (0.260s)
[379.519529] Subtest invalid-async-flip: SUCCESS (2.708s)
[380.086444] [114/142] (660s left) kms_ccs (pipe-a-bad-aux-stride-y_tiled_gen12_rc_ccs)
[380.553984] Starting subtest: pipe-A-bad-aux-stride-y_tiled_gen12_rc_ccs
[380.558424] Subtest pipe-A-bad-aux-stride-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[381.113119] [115/142] (659s left) kms_ccs (pipe-d-bad-pixel-format-y_tiled_gen12_rc_ccs)
[381.796304] Subtest pipe-D-bad-pixel-format-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[382.114722] [116/142] (658s left) gem_exec_params (cliprects-invalid)
[382.328771] Starting subtest: cliprects-invalid
[382.331433] Subtest cliprects-invalid: SUCCESS (0.001s)
[382.447913] [117/142] (658s left) kms_ccs (pipe-d-crc-primary-basic-y_tiled_gen12_rc_ccs)
[383.159300] Subtest pipe-D-crc-primary-basic-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[383.504185] [118/142] (657s left) kms_vblank (pipe-d-accuracy-idle)
[383.809399] Subtest pipe-D-accuracy-idle: SKIP (0.000s)
[383.903337] [119/142] (656s left) gem_exec_flush (basic-batch-kernel-default-uc)
[384.133249] Starting subtest: basic-batch-kernel-default-uc
[389.890941] Subtest basic-batch-kernel-default-uc: SUCCESS (5.760s)
[390.104081] [120/142] (650s left) kms_ccs (pipe-b-random-ccs-data-y_tiled_gen12_rc_ccs)
[390.620810] Starting subtest: pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs
[390.626823] Subtest pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[391.098460] [121/142] (649s left) kms_psr2_su (frontbuffer-xrgb8888)
[391.306290] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[391.364751] [122/142] (649s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[391.694324] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[393.098813] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.408s)
[393.267656] [123/142] (647s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y_tiled_ccs)
[393.834040] Starting subtest: pipe-B-crc-sprite-planes-basic-y_tiled_ccs
[394.361642] Subtest pipe-B-crc-sprite-planes-basic-y_tiled_ccs: SUCCESS (0.526s)
[394.884318] [124/142] (645s left) api_intel_bb (render)
[395.092146] Starting subtest: render
[395.095253] Starting dynamic subtest: render-none-512
[395.202384] Dynamic subtest render-none-512: SUCCESS (0.110s)
[395.227040] Starting dynamic subtest: render-none-reloc-512
[395.309641] Dynamic subtest render-none-reloc-512: SUCCESS (0.105s)
[395.334818] Starting dynamic subtest: render-none-1024
[395.674053] Dynamic subtest render-none-1024: SUCCESS (0.362s)
[395.699281] Starting dynamic subtest: render-none-reloc-1024
[396.039085] Dynamic subtest render-none-reloc-1024: SUCCESS (0.362s)
[396.067988] Starting dynamic subtest: render-x-512
[396.132747] Dynamic subtest render-x-512: SUCCESS (0.091s)
[396.162768] Starting dynamic subtest: render-x-reloc-512
[396.223738] Dynamic subtest render-x-reloc-512: SUCCESS (0.089s)
[396.252671] Starting dynamic subtest: render-x-1024
[396.538280] Dynamic subtest render-x-1024: SUCCESS (0.312s)
[396.570254] Starting dynamic subtest: render-x-reloc-1024
[396.856924] Dynamic subtest render-x-reloc-1024: SUCCESS (0.313s)
[396.882246] Starting dynamic subtest: render-y-512
[396.947188] Dynamic subtest render-y-512: SUCCESS (0.088s)
[396.971676] Starting dynamic subtest: render-y-reloc-512
[397.036064] Dynamic subtest render-y-reloc-512: SUCCESS (0.087s)
[397.062107] Starting dynamic subtest: render-y-1024
[397.352232] Dynamic subtest render-y-1024: SUCCESS (0.312s)
[397.380385] Starting dynamic subtest: render-y-reloc-1024
[397.669818] Dynamic subtest render-y-reloc-1024: SUCCESS (0.316s)
[397.672580] Subtest render: SUCCESS (2.580s)
[397.800695] [125/142] (643s left) i915_pm_rps (fence-order)
[398.019349] Starting subtest: fence-order
[401.118759] Subtest fence-order: SUCCESS (3.100s)
[401.353589] [126/142] (639s left) kms_ccs (pipe-a-crc-sprite-planes-basic-yf_tiled_ccs)
[401.838519] Starting subtest: pipe-A-crc-sprite-planes-basic-yf_tiled_ccs
[402.381609] Subtest pipe-A-crc-sprite-planes-basic-yf_tiled_ccs: SUCCESS (0.543s)
[403.037177] [127/142] (637s left) i915_pm_rpm (gem-execbuf)
[404.885575] Starting subtest: gem-execbuf
[404.889338] Starting dynamic subtest: smem0
[406.828585] Dynamic subtest smem0: SUCCESS (1.942s)
[406.832027] Subtest gem-execbuf: SUCCESS (1.945s)
[407.305039] [128/142] (633s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[407.619863] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[407.622170] Starting dynamic subtest: pipe-A-valid-mode
[407.734271] Dynamic subtest pipe-A-valid-mode: SKIP (0.114s)
[407.738631] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.119s)
[408.061028] [129/142] (633s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[408.378811] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[408.383100] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[408.494647] [130/142] (632s left) i915_pm_backlight (fade)
[408.798617] Subtest fade: SKIP (0.000s)
[408.863107] [131/142] (632s left) kms_flip (2x-plain-flip-ts-check)
[409.174634] Starting subtest: 2x-plain-flip-ts-check
[409.180815] Subtest 2x-plain-flip-ts-check: SKIP (0.003s)
[409.296512] [132/142] (631s left) api_intel_allocator (fork-simple-once)
[409.502231] Starting subtest: fork-simple-once
[409.543595] Subtest fork-simple-once: SUCCESS (0.044s)
[409.661553] [133/142] (631s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[409.971790] Starting subtest: psr-rgb101010-draw-mmap-wc
[409.975919] Subtest psr-rgb101010-draw-mmap-wc: SKIP (0.001s)
[410.094401] [134/142] (631s left) gem_exec_gttfill (basic)
[410.323498] Starting subtest: basic
[436.864178] Subtest basic: SUCCESS (26.540s)
[437.093629] [135/142] (604s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[437.516075] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[437.518130] Starting dynamic subtest: pipe-A-valid-mode
[438.239994] Dynamic subtest pipe-A-valid-mode: SKIP (0.718s)
[438.243985] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.723s)
[438.660903] [136/142] (602s left) gem_exec_schedule (wide)
[439.047134] Starting subtest: wide
[439.049622] Starting dynamic subtest: rcs0
[459.469089] Dynamic subtest rcs0: SUCCESS (20.417s)
[459.505719] Starting dynamic subtest: bcs0
[480.859396] Dynamic subtest bcs0: SUCCESS (21.389s)
[480.893427] Starting dynamic subtest: vcs0
[501.391776] Dynamic subtest vcs0: SUCCESS (20.525s)
[501.423011] Starting dynamic subtest: vecs0
[522.050074] Dynamic subtest vecs0: SUCCESS (20.660s)
[522.053684] Subtest wide: SUCCESS (83.004s)
[522.909705] [137/142] (518s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[523.251207] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[523.288252] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.032s)
[523.411521] [138/142] (518s left) kms_cursor_crc (cursor-dpms)
[523.730134] Starting subtest: cursor-dpms
[523.732388] Starting dynamic subtest: pipe-A-DP-1
[525.356315] Dynamic subtest pipe-A-DP-1: SUCCESS (1.621s)
[525.389907] Starting dynamic subtest: pipe-C-DP-1
[527.112510] Dynamic subtest pipe-C-DP-1: SUCCESS (1.753s)
[527.114728] Subtest cursor-dpms: SUCCESS (3.384s)
[527.502368] [139/142] (514s left) gem_partial_pwrite_pread (writes-after-reads)
[527.730123] Starting subtest: writes-after-reads
[549.240168] Subtest writes-after-reads: SUCCESS (21.510s)
[549.347585] [140/142] (492s left) gem_flink_basic (double-flink)
[549.567472] Starting subtest: double-flink
[549.569768] Subtest double-flink: SUCCESS (0.000s)
[549.680128] [141/142] (491s left) perf (sysctl-defaults)
[550.005349] Starting subtest: sysctl-defaults
[550.007910] Subtest sysctl-defaults: SUCCESS (0.000s)
[550.113377] [142/142] (491s left) syncobj_timeline (invalid-transfer-non-existent-point)
[550.330886] Starting subtest: invalid-transfer-non-existent-point
[550.332978] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[550.426669] Closing watchdogs
Done.