[81.776797] Initializing watchdogs [81.776858] /dev/watchdog0 [81.782237] [001/138] (960s left) gem_eio (in-flight-internal-10ms) [82.052522] Starting subtest: in-flight-internal-10ms [83.379196] Subtest in-flight-internal-10ms: SUCCESS (1.327s) [83.522335] [002/138] (958s left) gem_create (hog-create) [83.597051] Starting subtest: hog-create [83.597973] Starting dynamic subtest: lmem0 [115.898158] Dynamic subtest lmem0: SUCCESS (32.301s) [115.903118] Starting dynamic subtest: smem0 [148.173900] Dynamic subtest smem0: SUCCESS (32.259s) [148.175592] Subtest hog-create: SUCCESS (64.560s) [148.381242] [003/138] (893s left) gem_exec_balancer (individual) [148.475326] Starting subtest: individual [150.443280] Subtest individual: SUCCESS (1.959s) [150.729088] [004/138] (891s left) gem_exec_reloc (basic-write-gtt) [150.776426] Subtest basic-write-gtt: SKIP (0.000s) [150.832556] [005/138] (891s left) kms_plane_scaling (planes-upscale-20x20) [150.949246] Starting subtest: planes-upscale-20x20 [150.960794] Starting dynamic subtest: pipe-A-DP-4 [151.056919] Dynamic subtest pipe-A-DP-4: SUCCESS (0.096s) [151.074769] Starting dynamic subtest: pipe-B-DP-4 [151.264563] Dynamic subtest pipe-B-DP-4: SUCCESS (0.195s) [151.282936] Starting dynamic subtest: pipe-C-DP-4 [151.471888] Dynamic subtest pipe-C-DP-4: SUCCESS (0.195s) [151.494439] Starting dynamic subtest: pipe-D-DP-4 [151.694697] Dynamic subtest pipe-D-DP-4: SUCCESS (0.210s) [151.695674] Subtest planes-upscale-20x20: SUCCESS (0.745s) [151.972646] [006/138] (890s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling) [152.115473] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling [152.116307] Starting dynamic subtest: pipe-A-valid-mode [154.678827] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.561s) [154.680643] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SUCCESS (2.562s) [154.910625] [007/138] (887s left) kms_ccs (pipe-a-missing-ccs-buffer-y-tiled-gen12-mc-ccs) [155.161567] Starting subtest: pipe-A-missing-ccs-buffer-y-tiled-gen12-mc-ccs [155.163487] Subtest pipe-A-missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.000s) [155.394227] [008/138] (887s left) kms_draw_crc (draw-method-render) [155.534276] Starting subtest: draw-method-render [155.535181] Starting dynamic subtest: xrgb8888-untiled [155.901892] Dynamic subtest xrgb8888-untiled: SUCCESS (0.366s) [155.910481] Starting dynamic subtest: rgb565-untiled [156.201810] Dynamic subtest rgb565-untiled: SUCCESS (0.299s) [156.211976] Starting dynamic subtest: xrgb2101010-untiled [156.467836] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.266s) [156.492123] Starting dynamic subtest: xrgb8888-xtiled [156.652872] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.184s) [156.679409] Starting dynamic subtest: rgb565-xtiled [156.835210] Dynamic subtest rgb565-xtiled: SUCCESS (0.182s) [156.843976] Starting dynamic subtest: xrgb2101010-xtiled [156.967958] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.133s) [156.991408] Starting dynamic subtest: xrgb8888-4tiled [157.152126] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.183s) [157.178933] Starting dynamic subtest: rgb565-4tiled [157.333994] Dynamic subtest rgb565-4tiled: SUCCESS (0.182s) [157.341504] Starting dynamic subtest: xrgb2101010-4tiled [157.468539] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.134s) [157.470553] Subtest draw-method-render: SUCCESS (1.933s) [157.604901] [009/138] (884s left) gen9_exec_parse (batch-without-end) [157.667493] Subtest batch-without-end: SKIP (0.000s) [157.691742] [010/138] (884s left) gem_exec_flush (basic-wb-set-default) [157.737820] Subtest basic-wb-set-default: SKIP (0.000s) [157.794623] [011/138] (884s left) kms_ccs (pipe-b-crc-primary-rotation-180-4-tiled-mtl-rc-ccs) [158.019922] Starting subtest: pipe-B-crc-primary-rotation-180-4-tiled-mtl-rc-ccs [158.021621] Subtest pipe-B-crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.000s) [158.228752] [012/138] (884s left) kms_psr (primary_render) [158.326103] Subtest primary_render: SKIP (0.000s) [158.348900] [013/138] (884s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [158.467515] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt [158.469151] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [158.543556] [014/138] (884s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy) [158.671140] Starting subtest: 2x-long-cursor-vs-flip-legacy [158.673621] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.002s) [158.723489] [015/138] (883s left) kms_addfb_basic (master-rmfb) [158.764926] Starting subtest: master-rmfb [158.765770] Subtest master-rmfb: SUCCESS (0.001s) [158.908652] [016/138] (883s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt) [159.040382] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt [159.042076] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [159.110253] [017/138] (883s left) api_intel_bb (intel-bb-blit-none) [159.172346] Starting subtest: intel-bb-blit-none [159.895739] Subtest intel-bb-blit-none: SUCCESS (0.724s) [159.990910] [018/138] (882s left) kms_chamelium_frames (dp-crc-fast) [160.183874] Subtest dp-crc-fast: SKIP (0.000s) [160.294824] [019/138] (882s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render) [160.432261] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render [160.433795] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [160.519055] [020/138] (882s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling) [160.658814] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling [160.659736] Starting dynamic subtest: pipe-A-valid-mode [162.899430] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.237s) [162.900994] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.238s) [163.112533] [021/138] (879s left) v3d/v3d_perfmon (create-perfmon-0) [163.207348] Subtest create-perfmon-0: SKIP (0.000s) [163.261343] [022/138] (879s left) gem_softpin (full) [163.312912] Starting subtest: full [163.324348] Subtest full: SUCCESS (0.011s) [163.417036] [023/138] (879s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt) [163.542339] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt [163.543841] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [163.626960] [024/138] (879s left) kms_pm_rpm (cursor) [165.538733] Starting subtest: cursor [172.149691] Subtest cursor: SUCCESS (6.612s) [172.522802] [025/138] (870s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s [172.679916] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size [172.681468] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s) [172.732258] [026/138] (870s left) kms_prime (basic-modeset-hybrid) [173.484188] Subtest basic-modeset-hybrid: SKIP (0.000s) [173.584681] [027/138] (869s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip) [173.709039] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip [174.901213] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.191s) [175.025331] [028/138] (867s left) kms_ccs (pipe-a-bad-aux-stride-yf-tiled-ccs) [175.241485] Starting subtest: pipe-A-bad-aux-stride-yf-tiled-ccs [175.243454] Subtest pipe-A-bad-aux-stride-yf-tiled-ccs: SKIP (0.000s) [175.463184] [029/138] (867s left) syncobj_timeline (invalid-wait-illegal-handle) [175.551782] Starting subtest: invalid-wait-illegal-handle [175.552628] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [175.607097] [030/138] (867s left) kms_ccs (pipe-a-crc-primary-rotation-180-4-tiled-dg2-rc-ccs) [175.804262] Starting subtest: pipe-A-crc-primary-rotation-180-4-tiled-dg2-rc-ccs [176.241517] Subtest pipe-A-crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SUCCESS (0.436s) [176.649636] [031/138] (866s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu) [176.815215] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu [176.816839] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [176.894238] [032/138] (866s left) gem_ctx_engines (invalid-engines) [176.966539] Starting subtest: invalid-engines [176.990192] Subtest invalid-engines: SUCCESS (0.023s) [177.229366] [033/138] (865s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip) [177.352412] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip [178.577352] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.206s) [178.659663] [034/138] (864s left) gem_ctx_param (non-root-set) [178.705479] Starting subtest: non-root-set [178.714286] Subtest non-root-set: SUCCESS (0.009s) [178.773734] [035/138] (864s left) kms_ccs (pipe-c-crc-primary-rotation-180-yf-tiled-ccs) [179.024139] Starting subtest: pipe-C-crc-primary-rotation-180-yf-tiled-ccs [179.025990] Subtest pipe-C-crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.000s) [179.228795] [036/138] (863s left) syncobj_wait (wait-for-submit-delayed-submit) [179.296231] Starting subtest: wait-for-submit-delayed-submit [179.396582] Subtest wait-for-submit-delayed-submit: SUCCESS (0.101s) [179.509677] [037/138] (863s left) kms_prop_blob (invalid-set-prop) [179.563341] Starting subtest: invalid-set-prop [179.564189] Subtest invalid-set-prop: SUCCESS (0.000s) [179.649616] [038/138] (863s left) kms_flip (2x-flip-vs-expired-vblank) [179.790720] Starting subtest: 2x-flip-vs-expired-vblank [179.806288] Subtest 2x-flip-vs-expired-vblank: SKIP (0.015s) [179.864767] [039/138] (863s left) gem_exec_balancer (sliced) [179.920074] Starting subtest: sliced [179.921718] Subtest sliced: SKIP (0.000s) [180.221184] [040/138] (862s left) kms_cursor_crc (cursor-offscreen-512x170) [180.518166] Starting subtest: cursor-offscreen-512x170 [180.520028] Subtest cursor-offscreen-512x170: SKIP (0.001s) [180.688084] [041/138] (862s left) kms_ccs (pipe-d-bad-rotation-90-4-tiled-dg2-rc-ccs-cc) [180.962411] Starting subtest: pipe-D-bad-rotation-90-4-tiled-dg2-rc-ccs-cc [181.079595] Subtest pipe-D-bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SUCCESS (0.117s) [181.387376] [042/138] (861s left) kms_plane_alpha_blend (alpha-opaque-fb) [181.550274] Starting subtest: alpha-opaque-fb [181.757133] Starting dynamic subtest: pipe-A-DP-4 [182.279248] Dynamic subtest pipe-A-DP-4: SUCCESS (0.521s) [182.285266] Starting dynamic subtest: pipe-D-DP-4 [182.860351] Dynamic subtest pipe-D-DP-4: SUCCESS (0.580s) [182.861144] Subtest alpha-opaque-fb: SUCCESS (1.310s) [183.098486] [043/138] (860s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu) [183.230382] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu [183.232097] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [183.303417] [044/138] (860s left) kms_ccs (pipe-a-crc-primary-basic-4-tiled-dg2-mc-ccs) [183.511878] Starting subtest: pipe-A-crc-primary-basic-4-tiled-dg2-mc-ccs [188.163873] Subtest pipe-A-crc-primary-basic-4-tiled-dg2-mc-ccs: SUCCESS (4.652s) [188.533691] [045/138] (854s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [188.697155] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [188.698756] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [188.787072] [046/138] (854s left) kms_psr_stress_test (flip-primary-invalidate-overlay) [188.853196] Subtest flip-primary-invalidate-overlay: SKIP (0.000s) [188.890254] [047/138] (854s left) kms_ccs (pipe-c-bad-pixel-format-yf-tiled-ccs) [189.132883] Starting subtest: pipe-C-bad-pixel-format-yf-tiled-ccs [189.134571] Subtest pipe-C-bad-pixel-format-yf-tiled-ccs: SKIP (0.000s) [189.340230] [048/138] (854s left) kms_ccs (pipe-c-bad-rotation-90-4-tiled-mtl-rc-ccs-cc) [189.623392] Starting subtest: pipe-C-bad-rotation-90-4-tiled-mtl-rc-ccs-cc [189.625229] Subtest pipe-C-bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s) [189.827733] [049/138] (853s left) kms_big_fb (x-tiled-8bpp-rotate-0) [189.983738] Starting subtest: x-tiled-8bpp-rotate-0 [191.404581] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.413s) [191.559284] [050/138] (851s left) syncobj_timeline (reset-during-wait-for-submit) [191.636275] Starting subtest: reset-during-wait-for-submit [191.737724] Subtest reset-during-wait-for-submit: SUCCESS (0.101s) [191.836989] [051/138] (851s left) gem_mmap_gtt (cpuset-basic-small-copy-xy) [191.915190] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s) [191.937254] [052/138] (851s left) kms_plane (plane-panning-top-left) [192.052400] Starting subtest: plane-panning-top-left [192.053211] Starting dynamic subtest: pipe-A [192.784403] Dynamic subtest pipe-A: SUCCESS (0.731s) [192.791814] Starting dynamic subtest: pipe-B [193.437828] Dynamic subtest pipe-B: SUCCESS (0.653s) [193.438733] Subtest plane-panning-top-left: SUCCESS (1.386s) [193.647866] [053/138] (849s left) kms_color (legacy-gamma-reset) [193.770514] Starting subtest: legacy-gamma-reset [193.771444] Starting dynamic subtest: pipe-A [193.971550] Dynamic subtest pipe-A: SUCCESS (0.201s) [193.980044] Starting dynamic subtest: pipe-B [193.989220] Dynamic subtest pipe-B: SUCCESS (0.017s) [193.995292] Starting dynamic subtest: pipe-C [194.002939] Dynamic subtest pipe-C: SUCCESS (0.013s) [194.009014] Starting dynamic subtest: pipe-D [194.016611] Dynamic subtest pipe-D: SUCCESS (0.013s) [194.017424] Subtest legacy-gamma-reset: SUCCESS (0.246s) [194.178169] [054/138] (849s left) kms_cursor_crc (cursor-sliding-128x42) [194.450835] Starting subtest: cursor-sliding-128x42 [194.454906] Starting dynamic subtest: pipe-A-DP-4 [198.757988] Dynamic subtest pipe-A-DP-4: SUCCESS (4.300s) [198.801989] Starting dynamic subtest: pipe-D-DP-4 [202.936483] Dynamic subtest pipe-D-DP-4: SUCCESS (4.140s) [202.937426] Subtest cursor-sliding-128x42: SUCCESS (8.485s) [203.266229] [055/138] (840s left) kms_cursor_crc (cursor-onscreen-64x21) [203.513871] Starting subtest: cursor-onscreen-64x21 [203.517950] Starting dynamic subtest: pipe-A-DP-4 [206.095786] Dynamic subtest pipe-A-DP-4: SUCCESS (2.576s) [206.122694] Starting dynamic subtest: pipe-D-DP-4 [208.724583] Dynamic subtest pipe-D-DP-4: SUCCESS (2.607s) [208.725560] Subtest cursor-onscreen-64x21: SUCCESS (5.210s) [209.127972] [056/138] (834s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted) [209.205207] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted [209.305699] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.100s) [209.394443] [057/138] (834s left) gem_sync (basic-store-each) [209.458874] Starting subtest: basic-store-each [213.741203] Subtest basic-store-each: SUCCESS (4.282s) [213.969611] [058/138] (829s left) api_intel_allocator (alloc-simple) [214.024821] Starting subtest: alloc-simple [214.044995] Subtest alloc-simple: SUCCESS (0.021s) [214.185720] [059/138] (829s left) drm_read (invalid-buffer) [214.377421] Starting subtest: invalid-buffer [214.378276] Subtest invalid-buffer: SUCCESS (0.000s) [214.553993] [060/138] (829s left) gem_ctx_param (invalid-ctx-get) [214.626148] Starting subtest: invalid-ctx-get [214.626975] Subtest invalid-ctx-get: SUCCESS (0.000s) [214.700442] [061/138] (829s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip) [214.826974] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip [214.828621] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [214.894955] [062/138] (829s left) kms_fbcon_fbt (psr) [214.956905] Starting subtest: psr [214.959042] Subtest psr: SKIP (0.000s) [215.045560] [063/138] (828s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt) [215.202966] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt [215.204796] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [215.281497] [064/138] (828s left) gem_eio (reset-stress) [215.564226] Starting subtest: reset-stress [257.374035] Subtest reset-stress: SUCCESS (41.810s) [257.536404] [065/138] (786s left) gem_mmap_gtt (basic-small-copy) [257.621629] Subtest basic-small-copy: SKIP (0.000s) [257.653496] [066/138] (786s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt) [257.773905] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt [257.775568] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [257.871145] [067/138] (786s left) gem_softpin (invalid) [257.948975] Starting subtest: invalid [257.957460] Subtest invalid: SUCCESS (0.008s) [258.105510] [068/138] (785s left) kms_setmode (clone-exclusive-crtc) [258.184219] Starting subtest: clone-exclusive-crtc [258.187061] Subtest clone-exclusive-crtc: SKIP (0.000s) [258.267964] [069/138] (785s left) kms_chamelium_audio (dp-audio) [258.471846] Subtest dp-audio: SKIP (0.000s) [258.587368] [070/138] (785s left) kms_lease (empty-lease) [258.734572] Starting subtest: empty-lease [258.735448] Starting dynamic subtest: pipe-A-DP-4 [258.736243] Dynamic subtest pipe-A-DP-4: SUCCESS (0.001s) [258.743358] Starting dynamic subtest: pipe-B-DP-4 [258.744151] Dynamic subtest pipe-B-DP-4: SUCCESS (0.001s) [258.750707] Starting dynamic subtest: pipe-C-DP-4 [258.751484] Dynamic subtest pipe-C-DP-4: SUCCESS (0.001s) [258.757739] Starting dynamic subtest: pipe-D-DP-4 [258.758519] Dynamic subtest pipe-D-DP-4: SUCCESS (0.001s) [258.759316] Subtest empty-lease: SUCCESS (0.008s) [258.845530] [071/138] (785s left) kms_ccs (pipe-b-bad-rotation-90-4-tiled-mtl-mc-ccs) [259.101765] Starting subtest: pipe-B-bad-rotation-90-4-tiled-mtl-mc-ccs [259.103518] Subtest pipe-B-bad-rotation-90-4-tiled-mtl-mc-ccs: SKIP (0.000s) [259.319269] [072/138] (784s left) gem_exec_fence (syncobj-channel) [260.103114] Starting subtest: syncobj-channel [261.130177] Subtest syncobj-channel: SUCCESS (1.018s) [261.498702] [073/138] (782s left) gem_ctx_sseu (mmap-args) [261.566721] Subtest mmap-args: SKIP (0.000s) [261.592522] [074/138] (782s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen) [261.742938] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen [261.744593] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [261.816608] [075/138] (782s left) kms_frontbuffer_tracking (fbc-tiling-linear) [261.959617] Starting subtest: fbc-tiling-linear [264.264375] Subtest fbc-tiling-linear: SUCCESS (2.306s) [264.407417] [076/138] (779s left) gem_mmap_offset (open-flood) [264.452389] Starting subtest: open-flood [285.935459] Subtest open-flood: SUCCESS (21.484s) [286.024628] [077/138] (758s left) kms_force_connector_basic (force-connector-state) [286.116163] Starting subtest: force-connector-state [286.411877] Subtest force-connector-state: SUCCESS (0.295s) [286.713515] [078/138] (757s left) gem_exec_reloc (basic-gtt) [286.766705] Subtest basic-gtt: SKIP (0.000s) [286.823100] [079/138] (757s left) gem_ctx_persistence (legacy-engines-mixed-process) [286.882547] Starting subtest: legacy-engines-mixed-process [286.883408] Starting dynamic subtest: render [288.357702] Dynamic subtest render: SUCCESS (1.475s) [288.365268] Starting dynamic subtest: bsd1 [290.344539] Dynamic subtest bsd1: SUCCESS (1.986s) [290.352009] Starting dynamic subtest: bsd2 [292.390937] Dynamic subtest bsd2: SUCCESS (2.045s) [292.398833] Starting dynamic subtest: blt [294.373575] Dynamic subtest blt: SUCCESS (1.982s) [294.380798] Starting dynamic subtest: vebox [296.362868] Dynamic subtest vebox: SUCCESS (1.988s) [296.364057] Subtest legacy-engines-mixed-process: SUCCESS (9.480s) [296.450253] [080/138] (747s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite) [296.569674] Starting subtest: fbcpsr-rgb101010-draw-pwrite [296.571429] Subtest fbcpsr-rgb101010-draw-pwrite: SKIP (0.000s) [296.651608] [081/138] (747s left) kms_flip (flip-vs-fences-interruptible) [296.782915] Starting subtest: flip-vs-fences-interruptible [296.784707] Subtest flip-vs-fences-interruptible: SKIP (0.000s) [296.870827] [082/138] (747s left) kms_addfb_basic (bad-pitch-999) [296.943035] Starting subtest: bad-pitch-999 [296.943884] Subtest bad-pitch-999: SUCCESS (0.000s) [297.101591] [083/138] (747s left) gem_exec_parallel (engines) [297.178937] Starting subtest: engines [297.179817] Starting dynamic subtest: basic [298.654609] Dynamic subtest basic: SUCCESS (1.475s) [298.661241] Starting dynamic subtest: contexts [302.347073] Dynamic subtest contexts: SUCCESS (3.683s) [302.354169] Starting dynamic subtest: fds [306.934581] Dynamic subtest fds: SUCCESS (4.586s) [306.941284] Starting dynamic subtest: userptr [308.310457] Dynamic subtest userptr: SUCCESS (1.384s) [308.311720] Subtest engines: SUCCESS (11.132s) [308.587967] [084/138] (735s left) kms_ccs (pipe-d-crc-primary-basic-4-tiled-dg2-rc-ccs-cc) [308.898664] Starting subtest: pipe-D-crc-primary-basic-4-tiled-dg2-rc-ccs-cc [309.267737] Subtest pipe-D-crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SUCCESS (0.368s) [309.610209] [085/138] (734s left) gem_exec_whisper (basic-fds-priority) [309.701325] Starting subtest: basic-fds-priority [332.621097] Subtest basic-fds-priority: SUCCESS (22.909s) [332.803436] [086/138] (711s left) kms_plane (plane-position-covered) [332.918747] Starting subtest: plane-position-covered [332.919620] Starting dynamic subtest: pipe-A [335.198473] Dynamic subtest pipe-A: SUCCESS (2.279s) [335.205610] Starting dynamic subtest: pipe-B [337.277257] Dynamic subtest pipe-B: SUCCESS (2.078s) [337.278163] Subtest plane-position-covered: SUCCESS (4.360s) [337.501387] [087/138] (707s left) gem_render_copy (yf-tiled-ccs-to-x-tiled) [337.576141] Starting subtest: yf-tiled-ccs-to-x-tiled [337.577611] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s) [337.785156] [088/138] (706s left) gem_exec_schedule (semaphore-codependency) [337.849261] Starting subtest: semaphore-codependency [337.873782] Subtest semaphore-codependency: SUCCESS (0.024s) [338.213971] [089/138] (706s left) gem_vm_create (invalid-destroy) [338.262747] Starting subtest: invalid-destroy [338.266193] Subtest invalid-destroy: SUCCESS (0.001s) [338.357400] [090/138] (706s left) i915_pm_rpm (debugfs-read) [340.600641] Starting subtest: debugfs-read [363.600038] Subtest debugfs-read: SUCCESS (22.997s) [363.958653] [091/138] (680s left) gem_exec_schedule (in-order) [364.054671] Starting subtest: in-order [364.055493] Starting dynamic subtest: rcs0 [364.324857] Dynamic subtest rcs0: SUCCESS (0.261s) [364.332050] Starting dynamic subtest: bcs0 [364.511528] Dynamic subtest bcs0: SUCCESS (0.188s) [364.518580] Starting dynamic subtest: vcs0 [364.708284] Dynamic subtest vcs0: SUCCESS (0.196s) [364.715441] Starting dynamic subtest: vcs1 [364.899689] Dynamic subtest vcs1: SUCCESS (0.197s) [364.907243] Starting dynamic subtest: vecs0 [365.104153] Dynamic subtest vecs0: SUCCESS (0.196s) [365.111409] Starting dynamic subtest: vecs1 [365.299409] Dynamic subtest vecs1: SUCCESS (0.194s) [365.306467] Starting dynamic subtest: ccs0 [365.539163] Dynamic subtest ccs0: SUCCESS (0.239s) [365.546472] Starting dynamic subtest: ccs1 [365.733547] Dynamic subtest ccs1: SUCCESS (0.194s) [365.740778] Starting dynamic subtest: ccs2 [365.927647] Dynamic subtest ccs2: SUCCESS (0.194s) [365.934904] Starting dynamic subtest: ccs3 [366.124214] Dynamic subtest ccs3: SUCCESS (0.196s) [366.125438] Subtest in-order: SUCCESS (2.061s) [366.568650] [092/138] (678s left) gem_exec_fair (basic-flow) [366.629366] Subtest basic-flow: SKIP (0.000s) [366.663694] [093/138] (678s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [366.957970] Starting subtest: pipe-D-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc [368.273707] Subtest pipe-D-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SUCCESS (1.316s) [368.600903] [094/138] (676s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff) [368.743115] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff [368.744618] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [368.830677] [095/138] (676s left) gem_mmap_wc (write-cpu-read-wc) [368.900176] Subtest write-cpu-read-wc: SKIP (0.000s) [368.932460] [096/138] (675s left) dumb_buffer (create-valid-dumb) [368.980157] Starting subtest: create-valid-dumb [368.981009] Subtest create-valid-dumb: SUCCESS (0.000s) [369.103928] [097/138] (675s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt) [369.251463] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt [369.253023] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [369.327473] [098/138] (675s left) vc4/vc4_dmabuf_poll (poll-write-waits-until-write-done) [369.406580] Subtest poll-write-waits-until-write-done: SKIP (0.000s) [369.464139] [099/138] (675s left) kms_properties (invalid-properties-legacy) [369.601997] Starting subtest: invalid-properties-legacy [369.781497] Subtest invalid-properties-legacy: SUCCESS (0.171s) [369.844590] [100/138] (675s left) gem_lmem_swapping (heavy-verify-multi) [372.430995] Starting subtest: heavy-verify-multi [372.431843] Starting dynamic subtest: lmem0 [388.489160] Dynamic subtest lmem0: SUCCESS (16.024s) [388.490154] Subtest heavy-verify-multi: SUCCESS (16.024s) [389.942153] [101/138] (655s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic) [390.778866] Starting subtest: 2x-long-cursor-vs-flip-atomic [390.781525] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.002s) [390.896796] [102/138] (654s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180) [391.052754] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180 [391.054605] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [391.160509] [103/138] (653s left) vc4/vc4_perfmon (create-two-perfmon) [391.264101] Subtest create-two-perfmon: SKIP (0.000s) [391.322110] [104/138] (653s left) gem_readwrite (new-obj) [391.372823] Subtest new-obj: SKIP (0.000s) [391.403933] [105/138] (653s left) kms_busy (basic) [391.529687] Starting subtest: basic [391.531799] Starting dynamic subtest: flip [392.146280] Dynamic subtest flip: SUCCESS (0.614s) [392.163700] Starting dynamic subtest: modeset [393.068990] Dynamic subtest modeset: SUCCESS (0.920s) [393.070155] Subtest basic: SUCCESS (1.538s) [393.300091] [106/138] (651s left) syncobj_timeline (signal-point-0) [393.355293] Starting subtest: signal-point-0 [393.356182] Subtest signal-point-0: SUCCESS (0.000s) [393.429328] [107/138] (651s left) gem_pxp (protected-encrypted-src-copy-not-readible) [396.064473] Subtest protected-encrypted-src-copy-not-readible: SKIP (0.000s) [396.099864] [108/138] (649s left) gem_eio (in-flight-immediate) [396.406044] Starting subtest: in-flight-immediate [401.158158] Subtest in-flight-immediate: SUCCESS (4.752s) [401.289442] [109/138] (643s left) syncobj_wait (wait-delayed-signal) [401.338213] Starting subtest: wait-delayed-signal [401.439701] Subtest wait-delayed-signal: SUCCESS (0.101s) [401.549622] [110/138] (643s left) debugfs_test (read_all_entries) [401.619180] Starting subtest: read_all_entries [402.209434] Subtest read_all_entries: SUCCESS (0.589s) [402.339588] [111/138] (642s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt) [402.458325] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt [402.459925] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [402.547761] [112/138] (642s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode) [402.781624] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s) [402.895455] [113/138] (642s left) gem_mmap_gtt (basic-write-gtt) [402.959084] Subtest basic-write-gtt: SKIP (0.000s) [402.988009] [114/138] (642s left) i915_pm_sseu (full-enable) [403.038497] Subtest full-enable: SKIP (0.000s) [403.101550] [115/138] (642s left) kms_ccs (pipe-d-bad-aux-stride-yf-tiled-ccs) [403.389068] Starting subtest: pipe-D-bad-aux-stride-yf-tiled-ccs [403.390966] Subtest pipe-D-bad-aux-stride-yf-tiled-ccs: SKIP (0.000s) [403.558464] [116/138] (641s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc) [403.830579] Starting subtest: pipe-B-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc [403.833292] Subtest pipe-B-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.002s) [404.046894] [117/138] (641s left) prime_busy (after-wait) [404.136417] Starting subtest: after-wait [404.141156] Starting dynamic subtest: rcs0 [404.182540] Dynamic subtest rcs0: SUCCESS (0.041s) [404.189570] Starting dynamic subtest: bcs0 [404.225848] Dynamic subtest bcs0: SUCCESS (0.043s) [404.233962] Starting dynamic subtest: vcs0 [404.269081] Dynamic subtest vcs0: SUCCESS (0.042s) [404.300297] Starting dynamic subtest: vcs1 [404.315240] Dynamic subtest vcs1: SUCCESS (0.044s) [404.341541] Starting dynamic subtest: vecs0 [404.355253] Dynamic subtest vecs0: SUCCESS (0.038s) [404.366368] Starting dynamic subtest: vecs1 [404.397149] Dynamic subtest vecs1: SUCCESS (0.041s) [404.407628] Starting dynamic subtest: ccs0 [404.438946] Dynamic subtest ccs0: SUCCESS (0.041s) [404.460557] Starting dynamic subtest: ccs1 [404.481997] Dynamic subtest ccs1: SUCCESS (0.041s) [404.503574] Starting dynamic subtest: ccs2 [404.523044] Dynamic subtest ccs2: SUCCESS (0.039s) [404.540260] Starting dynamic subtest: ccs3 [404.564174] Dynamic subtest ccs3: SUCCESS (0.040s) [404.693125] Subtest after-wait: SUCCESS (0.547s) [404.832536] [118/138] (640s left) gem_request_retire (retire-vma-not-inactive) [404.892368] Starting subtest: retire-vma-not-inactive [405.001438] Subtest retire-vma-not-inactive: SUCCESS (0.107s) [405.135719] [119/138] (640s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip) [405.256402] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip [406.454802] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.189s) [406.586403] [120/138] (638s left) testdisplay [424.399209] [121/138] (621s left) core_getclient [424.531019] [122/138] (621s left) prime_mmap (test_dup) [424.578242] Starting subtest: test_dup [424.579112] Starting dynamic subtest: test_dup-smem [424.616535] Dynamic subtest test_dup-smem: SUCCESS (0.039s) [424.623274] Starting dynamic subtest: test_dup-lmem0 [424.772730] Dynamic subtest test_dup-lmem0: SUCCESS (0.146s) [424.774775] Subtest test_dup: SUCCESS (0.186s) [424.864729] [123/138] (620s left) kms_setmode (invalid-clone-single-crtc-stealing) [424.964277] Starting subtest: invalid-clone-single-crtc-stealing [424.967677] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s) [425.042322] [124/138] (620s left) kms_flip (modeset-vs-vblank-race-interruptible) [425.152545] Starting subtest: modeset-vs-vblank-race-interruptible [425.159720] Starting dynamic subtest: A-DP4 [428.440750] Dynamic subtest A-DP4: SUCCESS (3.281s) [428.472231] Starting dynamic subtest: B-DP4 [431.573792] Dynamic subtest B-DP4: SUCCESS (3.129s) [431.605979] Starting dynamic subtest: C-DP4 [434.799285] Dynamic subtest C-DP4: SUCCESS (3.221s) [434.832191] Starting dynamic subtest: D-DP4 [437.902060] Dynamic subtest D-DP4: SUCCESS (3.099s) [437.907344] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (12.752s) [438.208599] [125/138] (607s left) i915_suspend (fence-restore-untiled) [438.302069] Starting subtest: fence-restore-untiled [438.303977] Subtest fence-restore-untiled: SKIP (0.000s) [438.354673] [126/138] (607s left) perf (global-sseu-config) [438.672394] Subtest global-sseu-config: SKIP (0.000s) [438.701783] [127/138] (607s left) dmabuf_sync_file (import-multiple-read-only) [438.755232] Starting subtest: import-multiple-read-only [438.757417] Subtest import-multiple-read-only: SUCCESS (0.003s) [438.812348] [128/138] (606s left) gem_spin_batch (legacy) [438.876450] Starting subtest: legacy [438.877418] Starting dynamic subtest: default [442.153941] Dynamic subtest default: SUCCESS (3.241s) [442.162776] Starting dynamic subtest: render [445.385707] Dynamic subtest render: SUCCESS (3.228s) [445.394233] Starting dynamic subtest: bsd [448.617456] Dynamic subtest bsd: SUCCESS (3.228s) [448.626229] Starting dynamic subtest: bsd1 [451.850529] Dynamic subtest bsd1: SUCCESS (3.229s) [451.859604] Starting dynamic subtest: bsd2 [455.083656] Dynamic subtest bsd2: SUCCESS (3.229s) [455.095307] Starting dynamic subtest: blt [458.313826] Dynamic subtest blt: SUCCESS (3.230s) [458.322960] Starting dynamic subtest: vebox [461.524700] Dynamic subtest vebox: SUCCESS (3.230s) [461.526790] Subtest legacy: SUCCESS (22.636s) [461.707641] [129/138] (584s left) kms_sequence (get-forked-busy) [461.826182] Starting subtest: get-forked-busy [461.827115] Starting dynamic subtest: pipe-A-DP-4 [464.432824] Dynamic subtest pipe-A-DP-4: SUCCESS (2.605s) [464.442403] Starting dynamic subtest: pipe-B-DP-4 [466.940898] Dynamic subtest pipe-B-DP-4: SUCCESS (2.505s) [466.970064] Starting dynamic subtest: pipe-C-DP-4 [469.533569] Dynamic subtest pipe-C-DP-4: SUCCESS (2.587s) [469.556149] Starting dynamic subtest: pipe-D-DP-4 [472.126651] Dynamic subtest pipe-D-DP-4: SUCCESS (2.590s) [472.127681] Subtest get-forked-busy: SUCCESS (10.302s) [472.320541] [130/138] (573s left) tools_test (sysfs_l3_parity) [472.419625] Starting subtest: sysfs_l3_parity [472.468563] Subtest sysfs_l3_parity: SKIP (0.054s) [472.532685] [131/138] (573s left) sysfs_preempt_timeout (idempotent) [472.613363] Starting subtest: idempotent [472.614163] Starting dynamic subtest: ccs2 [472.614956] Dynamic subtest ccs2: SUCCESS (0.000s) [472.621703] Starting dynamic subtest: vecs0 [472.622492] Dynamic subtest vecs0: SUCCESS (0.000s) [472.629166] Starting dynamic subtest: ccs0 [472.629947] Dynamic subtest ccs0: SUCCESS (0.000s) [472.636287] Starting dynamic subtest: vcs0 [472.637057] Dynamic subtest vcs0: SUCCESS (0.000s) [472.643404] Starting dynamic subtest: bcs0 [472.644185] Dynamic subtest bcs0: SUCCESS (0.000s) [472.650512] Starting dynamic subtest: ccs3 [472.651319] Dynamic subtest ccs3: SUCCESS (0.000s) [472.658223] Starting dynamic subtest: vecs1 [472.659132] Dynamic subtest vecs1: SUCCESS (0.000s) [472.665773] Starting dynamic subtest: ccs1 [472.666911] Dynamic subtest ccs1: SUCCESS (0.000s) [472.675771] Starting dynamic subtest: rcs0 [472.676569] Dynamic subtest rcs0: SUCCESS (0.000s) [472.682888] Starting dynamic subtest: vcs1 [472.683642] Dynamic subtest vcs1: SUCCESS (0.000s) [472.684536] Subtest idempotent: SUCCESS (0.010s) [472.695035] [132/138] (573s left) perf_pmu (init-busy) [472.742240] Starting subtest: init-busy [472.743046] Starting dynamic subtest: rcs0 [472.743821] Dynamic subtest rcs0: SUCCESS (0.001s) [472.750687] Starting dynamic subtest: bcs0 [472.751547] Dynamic subtest bcs0: SUCCESS (0.000s) [472.758182] Starting dynamic subtest: vcs0 [472.758967] Dynamic subtest vcs0: SUCCESS (0.000s) [472.765305] Starting dynamic subtest: vcs1 [472.766131] Dynamic subtest vcs1: SUCCESS (0.000s) [472.772476] Starting dynamic subtest: vecs0 [472.773259] Dynamic subtest vecs0: SUCCESS (0.000s) [472.779587] Starting dynamic subtest: vecs1 [472.780376] Dynamic subtest vecs1: SUCCESS (0.000s) [472.786707] Starting dynamic subtest: ccs0 [472.787499] Dynamic subtest ccs0: SUCCESS (0.000s) [472.793818] Starting dynamic subtest: ccs1 [472.794585] Dynamic subtest ccs1: SUCCESS (0.000s) [472.801216] Starting dynamic subtest: ccs2 [472.802060] Dynamic subtest ccs2: SUCCESS (0.000s) [472.808384] Starting dynamic subtest: ccs3 [472.809177] Dynamic subtest ccs3: SUCCESS (0.000s) [472.809964] Subtest init-busy: SUCCESS (0.010s) [472.833731] [133/138] (573s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt) [472.956142] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt [472.957819] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [473.041600] [134/138] (572s left) kms_vblank (wait-forked-hang) [473.177007] Starting subtest: wait-forked-hang [473.179047] Starting dynamic subtest: pipe-A-DP-4 [487.092722] Dynamic subtest pipe-A-DP-4: SUCCESS (13.913s) [487.106136] Starting dynamic subtest: pipe-D-DP-4 [512.029084] Dynamic subtest pipe-D-DP-4: SUCCESS (24.932s) [512.030044] Subtest wait-forked-hang: SUCCESS (38.852s) [512.256127] [135/138] (533s left) v3d/v3d_submit_cl (bad-multisync-out-sync) [512.350096] Subtest bad-multisync-out-sync: SKIP (0.000s) [512.415653] [136/138] (533s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen) [512.543862] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen [512.550759] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [512.647562] [137/138] (533s left) debugfs_test (sysfs) [512.738544] Starting subtest: sysfs [513.245657] Subtest sysfs: SUCCESS (0.507s) [513.383327] [138/138] (532s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted) [513.434497] Starting subtest: etime-single-wait-for-submit-available-unsubmitted [513.537599] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.104s) [513.643183] Closing watchdogs Done.