[34.386509] Initializing watchdogs [34.386590] /dev/watchdog0 [34.393736] [001/142] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu) [36.395101] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu [36.397763] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [36.461445] [002/142] (958s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff) [38.532576] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff [38.536438] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [38.608654] [003/142] (956s left) kms_ccs (pipe-a-bad-pixel-format-4_tiled_dg2_mc_ccs) [40.608846] Starting subtest: pipe-A-bad-pixel-format-4_tiled_dg2_mc_ccs [40.612288] Subtest pipe-A-bad-pixel-format-4_tiled_dg2_mc_ccs: SKIP (0.000s) [41.091987] [004/142] (953s left) kms_ccs (pipe-c-bad-pixel-format-y_tiled_ccs) [43.279230] Starting subtest: pipe-C-bad-pixel-format-y_tiled_ccs [43.282373] Subtest pipe-C-bad-pixel-format-y_tiled_ccs: SKIP (0.000s) [43.541144] [005/142] (951s left) gem_exec_balancer (smoke) [43.626937] Starting subtest: smoke [66.824237] Subtest smoke: SUCCESS (23.194s) [67.522129] [006/142] (927s left) kms_plane (plane-position-covered) [69.509604] Starting subtest: plane-position-covered [69.511186] Starting dynamic subtest: pipe-A-planes [72.018562] Dynamic subtest pipe-A-planes: SUCCESS (2.507s) [72.024779] Starting dynamic subtest: pipe-B-planes [74.677229] Dynamic subtest pipe-B-planes: SUCCESS (2.648s) [74.680100] Subtest plane-position-covered: SUCCESS (5.159s) [74.815395] [007/142] (920s left) kms_frontbuffer_tracking (fbcpsr-slowdraw) [76.806123] Starting subtest: fbcpsr-slowdraw [76.809498] Subtest fbcpsr-slowdraw: SKIP (0.000s) [76.882915] [008/142] (918s left) prime_vgem (fence-flip-hang) [77.006477] Subtest fence-flip-hang: SKIP (0.000s) [77.099123] [009/142] (917s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling) [79.077699] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling [79.079350] Starting dynamic subtest: pipe-A-valid-mode [79.123658] Dynamic subtest pipe-A-valid-mode: SKIP (0.043s) [79.126858] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.044s) [79.211357] [010/142] (915s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move) [81.190926] Starting subtest: psr-2p-primscrn-spr-indfb-move [81.194156] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [81.260223] [011/142] (913s left) gem_exec_fence (syncobj-import) [81.689831] Starting subtest: syncobj-import [81.705718] Subtest syncobj-import: SUCCESS (0.016s) [82.074122] [012/142] (913s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc) [84.049760] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc [84.053122] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [84.126416] [013/142] (910s left) gem_softpin (evict-snoop-interruptible) [84.230677] Starting subtest: evict-snoop-interruptible [84.234061] Subtest evict-snoop-interruptible: SKIP (0.000s) [84.313124] [014/142] (910s left) kms_flip (plain-flip-fb-recreate-interruptible) [85.371285] Starting subtest: plain-flip-fb-recreate-interruptible [85.382698] Starting dynamic subtest: A-HDMI-A4 [93.555750] Dynamic subtest A-HDMI-A4: SUCCESS (8.173s) [93.568416] Starting dynamic subtest: B-HDMI-A4 [101.516914] Dynamic subtest B-HDMI-A4: SUCCESS (7.958s) [101.536182] Starting dynamic subtest: C-HDMI-A4 [109.488871] Dynamic subtest C-HDMI-A4: SUCCESS (7.969s) [109.506919] Starting dynamic subtest: D-HDMI-A4 [117.454442] Dynamic subtest D-HDMI-A4: SUCCESS (7.963s) [117.456582] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (32.083s) [117.607640] [015/142] (877s left) kms_frontbuffer_tracking (fbc-tiling-linear) [119.589445] Starting subtest: fbc-tiling-linear [121.926230] Subtest fbc-tiling-linear: SUCCESS (2.337s) [122.057064] [016/142] (873s left) feature_discovery (display-2x) [124.036599] Starting subtest: display-2x [124.038669] Subtest display-2x: SKIP (0.000s) [124.089938] [017/142] (871s left) vc4/vc4_dmabuf_poll (poll-write-waits-until-write-done) [124.242603] Subtest poll-write-waits-until-write-done: SKIP (0.000s) [124.291453] [018/142] (870s left) kms_plane_lowres (tiling-4) [126.270875] Starting subtest: tiling-4 [126.273190] Subtest tiling-4: SKIP (0.000s) [126.323421] [019/142] (868s left) kms_ccs (pipe-c-crc-primary-basic-y_tiled_gen12_rc_ccs) [128.533850] Starting subtest: pipe-C-crc-primary-basic-y_tiled_gen12_rc_ccs [128.886342] Subtest pipe-C-crc-primary-basic-y_tiled_gen12_rc_ccs: SUCCESS (0.352s) [129.182778] [020/142] (866s left) gem_exec_flush (basic-wb-ro-default) [129.257436] Subtest basic-wb-ro-default: SKIP (0.000s) [129.305351] [021/142] (865s left) gem_ctx_persistence (heartbeat-hang) [129.378932] Starting subtest: heartbeat-hang [129.380671] Subtest heartbeat-hang: SKIP (0.000s) [129.447119] [022/142] (865s left) kms_flip (nonexisting-fb) [130.470910] Starting subtest: nonexisting-fb [130.481372] Starting dynamic subtest: A-HDMI-A4 [130.726654] Dynamic subtest A-HDMI-A4: SUCCESS (0.245s) [130.732045] Starting dynamic subtest: B-HDMI-A4 [130.881074] Dynamic subtest B-HDMI-A4: SUCCESS (0.154s) [130.886477] Starting dynamic subtest: C-HDMI-A4 [131.053244] Dynamic subtest C-HDMI-A4: SUCCESS (0.172s) [131.058461] Starting dynamic subtest: D-HDMI-A4 [131.213726] Dynamic subtest D-HDMI-A4: SUCCESS (0.160s) [131.214579] Subtest nonexisting-fb: SUCCESS (0.744s) [131.368843] [023/142] (863s left) kms_cursor_crc (cursor-random-128x42) [133.487994] Starting subtest: cursor-random-128x42 [133.495960] Starting dynamic subtest: pipe-A-HDMI-A-4 [138.108727] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (4.613s) [138.133870] Starting dynamic subtest: pipe-D-HDMI-A-4 [143.481930] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (5.354s) [143.483020] Subtest cursor-random-128x42: SUCCESS (9.994s) [143.792823] [024/142] (851s left) vc4/vc4_purgeable_bo (mark-unpurgeable-twice) [143.912351] Subtest mark-unpurgeable-twice: SKIP (0.000s) [143.991161] [025/142] (851s left) v3d/v3d_submit_csd (bad-extension) [144.110431] Subtest bad-extension: SKIP (0.000s) [144.160351] [026/142] (851s left) kms_invalid_mode (bad-vtotal) [146.147375] Starting subtest: bad-vtotal [146.148414] Starting dynamic subtest: HDMI-A-4-pipe-A [146.202092] Dynamic subtest HDMI-A-4-pipe-A: SUCCESS (0.055s) [146.210957] Starting dynamic subtest: HDMI-A-4-pipe-B [146.227146] Dynamic subtest HDMI-A-4-pipe-B: SUCCESS (0.024s) [146.234177] Starting dynamic subtest: HDMI-A-4-pipe-C [146.253352] Dynamic subtest HDMI-A-4-pipe-C: SUCCESS (0.024s) [146.259890] Starting dynamic subtest: HDMI-A-4-pipe-D [146.278962] Dynamic subtest HDMI-A-4-pipe-D: SUCCESS (0.024s) [146.280368] Subtest bad-vtotal: SUCCESS (0.134s) [146.378708] [027/142] (848s left) i915_pm_rpm (debugfs-read) [151.440885] Starting subtest: debugfs-read [193.333753] Subtest debugfs-read: FAIL (41.847s) [194.875228] [028/142] (800s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite) [196.887457] Starting subtest: psr-rgb101010-draw-pwrite [196.889490] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s) [196.957454] [029/142] (798s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y_tiled_ccs) [199.139917] Starting subtest: pipe-B-crc-sprite-planes-basic-y_tiled_ccs [199.144132] Subtest pipe-B-crc-sprite-planes-basic-y_tiled_ccs: SKIP (0.003s) [199.421165] [030/142] (795s left) prime_mmap (test_errors) [199.492398] Starting subtest: test_errors [199.493283] Starting dynamic subtest: test_errors-smem [199.770170] Dynamic subtest test_errors-smem: SUCCESS (0.275s) [199.775758] Starting dynamic subtest: test_errors-lmem0 [200.050411] Dynamic subtest test_errors-lmem0: SUCCESS (0.279s) [200.051407] Subtest test_errors: SUCCESS (0.556s) [200.122625] [031/142] (795s left) gem_exec_capture (capture-recoverable) [200.201209] Starting subtest: capture-recoverable [200.203919] Subtest capture-recoverable: SUCCESS (0.003s) [200.341682] [032/142] (795s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic) [202.345164] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic [203.927041] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.582s) [204.045128] [033/142] (791s left) drm_fdinfo (all-busy-check-all) [204.119657] Starting subtest: all-busy-check-all [204.133578] Subtest all-busy-check-all: SKIP (0.013s) [204.193720] [034/142] (791s left) kms_vblank (pipe-a-ts-continuation-suspend) [206.214119] Starting subtest: pipe-A-ts-continuation-suspend [226.839031] Subtest pipe-A-ts-continuation-suspend: SUCCESS (9.180s) [232.968491] [035/142] (779s left) gem_exec_schedule (smoketest) [233.176219] Starting subtest: smoketest [233.177314] Starting dynamic subtest: rcs0 [238.615707] Dynamic subtest rcs0: SUCCESS (5.434s) [238.622602] Starting dynamic subtest: bcs0 [244.049190] Dynamic subtest bcs0: SUCCESS (5.432s) [244.056132] Starting dynamic subtest: vcs0 [249.480875] Dynamic subtest vcs0: SUCCESS (5.432s) [249.487811] Starting dynamic subtest: vcs1 [254.927143] Dynamic subtest vcs1: SUCCESS (5.445s) [254.934188] Starting dynamic subtest: vecs0 [260.372431] Dynamic subtest vecs0: SUCCESS (5.443s) [260.373526] Subtest smoketest: SUCCESS (27.191s) [260.654800] [036/142] (752s left) kms_prime (basic-modeset-hybrid) [263.399925] Subtest basic-modeset-hybrid: SKIP (0.000s) [263.492362] [037/142] (749s left) api_intel_bb (object-noreloc-purge-cache-simple) [263.563044] Starting subtest: object-noreloc-purge-cache-simple [263.578929] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.016s) [263.703474] [038/142] (749s left) gem_exec_suspend (basic-s3) [263.780621] Starting subtest: basic-S3 [263.781710] Starting dynamic subtest: smem [287.947265] Dynamic subtest smem: SUCCESS (12.456s) [287.956765] Starting dynamic subtest: lmem0 [311.924867] Dynamic subtest lmem0: SUCCESS (12.074s) [311.926416] Subtest basic-S3: SUCCESS (24.534s) [318.162734] [039/142] (724s left) gem_create (hog-create) [318.242854] Starting subtest: hog-create [318.243662] Starting dynamic subtest: lmem0 [350.520687] Dynamic subtest lmem0: SUCCESS (32.276s) [350.556562] Starting dynamic subtest: smem0 [382.793160] Dynamic subtest smem0: SUCCESS (32.268s) [382.793958] Subtest hog-create: SUCCESS (64.551s) [383.003828] [040/142] (659s left) kms_cursor_crc (cursor-rapid-movement-64x21) [385.078025] Starting subtest: cursor-rapid-movement-64x21 [385.085844] Starting dynamic subtest: pipe-A-HDMI-A-4 [385.537958] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.453s) [385.569682] Starting dynamic subtest: pipe-D-HDMI-A-4 [386.958379] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (1.401s) [386.959314] Subtest cursor-rapid-movement-64x21: SUCCESS (1.881s) [387.315172] [041/142] (655s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible) [387.391774] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s) [387.422608] [042/142] (655s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_mtl_rc_ccs_cc) [389.700402] Starting subtest: pipe-D-bad-rotation-90-4_tiled_mtl_rc_ccs_cc [389.702656] Subtest pipe-D-bad-rotation-90-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s) [389.870873] [043/142] (652s left) gem_exec_schedule (preempt-queue-chain) [389.954758] Subtest preempt-queue-chain: SKIP (0.000s) [390.236762] [044/142] (652s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff) [392.220371] Starting subtest: psr-1p-primscrn-spr-indfb-onoff [392.222385] Subtest psr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s) [392.286231] [045/142] (650s left) gem_ctx_create (basic) [392.377393] Starting subtest: basic [392.378429] Subtest basic: SUCCESS (0.000s) [392.611030] [046/142] (650s left) gem_eio (wait-1us) [392.842460] Starting subtest: wait-1us [393.285574] Subtest wait-1us: SUCCESS (0.443s) [395.235734] [047/142] (647s left) kms_plane_scaling (planes-downscale-factor-0-25) [397.222660] Starting subtest: planes-downscale-factor-0-25 [397.223599] Starting dynamic subtest: pipe-A-HDMI-A-4 [397.235882] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.012s) [397.244886] Starting dynamic subtest: pipe-B-HDMI-A-4 [397.260258] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.022s) [397.269333] Starting dynamic subtest: pipe-C-HDMI-A-4 [397.285695] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.022s) [397.294746] Starting dynamic subtest: pipe-D-HDMI-A-4 [397.310506] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.022s) [397.312383] Subtest planes-downscale-factor-0-25: SKIP (0.089s) [397.402963] [048/142] (645s left) i915_query (query-regions-garbage-items) [397.474244] Starting subtest: query-regions-garbage-items [397.475247] Subtest query-regions-garbage-items: SUCCESS (0.000s) [397.536181] [049/142] (645s left) gem_exec_reloc (basic-scanout) [397.611219] Subtest basic-scanout: SKIP (0.000s) [397.661436] [050/142] (645s left) kms_psr2_sf (plane-move-sf-dmg-area) [397.732477] Subtest plane-move-sf-dmg-area: SKIP (0.000s) [397.761192] [051/142] (645s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite) [399.746454] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite [399.748454] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [399.836217] [052/142] (643s left) i915_pm_rpm (gem-execbuf-stress-pc8) [404.527425] Starting subtest: gem-execbuf-stress-pc8 [404.595878] Subtest gem-execbuf-stress-pc8: SKIP (0.067s) [405.671154] [053/142] (637s left) gem_ctx_param (invalid-param-get) [405.740877] Starting subtest: invalid-param-get [405.741742] Subtest invalid-param-get: SUCCESS (0.001s) [405.803855] [054/142] (637s left) syncobj_timeline (wait-for-submit-complex) [405.876601] Starting subtest: wait-for-submit-complex [405.937221] Subtest wait-for-submit-complex: SUCCESS (0.062s) [406.044148] [055/142] (636s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-pwrite) [408.054418] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-pwrite [408.056635] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-pwrite: SKIP (0.000s) [408.137195] [056/142] (634s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot) [410.133737] Starting subtest: modeset-atomic-cursor-hotspot [410.135734] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s) [410.203298] [057/142] (632s left) gem_mmap_gtt (hang-busy) [410.284957] Subtest hang-busy: SKIP (0.000s) [410.311837] [058/142] (632s left) gem_mmap_gtt (coherency) [410.382218] Subtest coherency: SKIP (0.000s) [410.411226] [059/142] (632s left) kms_chamelium_edid (hdmi-edid-stress-resolution-4k) [412.426309] Subtest hdmi-edid-stress-resolution-4k: SKIP (0.000s) [412.488742] [060/142] (630s left) syncobj_wait (multi-wait-signaled) [412.559744] Starting subtest: multi-wait-signaled [412.560912] Subtest multi-wait-signaled: SUCCESS (0.001s) [412.626384] [061/142] (630s left) gen9_exec_parse (bb-start-param) [412.700599] Subtest bb-start-param: SKIP (0.000s) [412.734537] [062/142] (630s left) kms_draw_crc (fill-fb) [414.704965] Starting subtest: fill-fb [415.223519] Subtest fill-fb: SUCCESS (0.520s) [415.296144] [063/142] (627s left) kms_addfb_basic (bad-pitch-999) [415.369112] Starting subtest: bad-pitch-999 [415.370191] Subtest bad-pitch-999: SUCCESS (0.000s) [417.358717] [064/142] (625s left) syncobj_timeline (invalid-query-one-illegal-handle) [417.454312] Starting subtest: invalid-query-one-illegal-handle [417.455558] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s) [417.548727] [065/142] (625s left) syncobj_timeline (invalid-wait-zero-handles) [417.652877] Starting subtest: invalid-wait-zero-handles [417.654284] Subtest invalid-wait-zero-handles: SUCCESS (0.000s) [417.734540] [066/142] (625s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render) [419.719232] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render [419.721315] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [419.808838] [067/142] (623s left) gem_exec_async (forked-writes) [419.905954] Starting subtest: forked-writes [419.906966] Starting dynamic subtest: rcs0 [419.951641] Dynamic subtest rcs0: SUCCESS (0.045s) [419.960640] Starting dynamic subtest: bcs0 [419.986474] Dynamic subtest bcs0: SUCCESS (0.034s) [419.995871] Starting dynamic subtest: vcs0 [420.019395] Dynamic subtest vcs0: SUCCESS (0.032s) [420.028353] Starting dynamic subtest: vcs1 [420.052262] Dynamic subtest vcs1: SUCCESS (0.032s) [420.061569] Starting dynamic subtest: vecs0 [420.085168] Dynamic subtest vecs0: SUCCESS (0.032s) [420.086100] Subtest forked-writes: SUCCESS (0.180s) [420.354092] [068/142] (622s left) prime_self_import (export-vs-gem_close-race) [420.581559] Starting subtest: export-vs-gem_close-race [425.609204] Subtest export-vs-gem_close-race: SUCCESS (5.051s) [425.741957] [069/142] (617s left) kms_flip (dpms-vs-vblank-race-interruptible) [426.807795] Starting subtest: dpms-vs-vblank-race-interruptible [426.819562] Starting dynamic subtest: A-HDMI-A4 [429.826357] Dynamic subtest A-HDMI-A4: SUCCESS (3.007s) [429.836567] Starting dynamic subtest: B-HDMI-A4 [432.780815] Dynamic subtest B-HDMI-A4: SUCCESS (2.953s) [432.792322] Starting dynamic subtest: C-HDMI-A4 [435.726214] Dynamic subtest C-HDMI-A4: SUCCESS (2.944s) [435.735661] Starting dynamic subtest: D-HDMI-A4 [438.633959] Dynamic subtest D-HDMI-A4: SUCCESS (2.905s) [438.634889] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (11.825s) [438.771958] [070/142] (604s left) kms_cdclk (mode-transition-all-outputs) [438.856396] Subtest mode-transition-all-outputs: SKIP (0.000s) [438.879154] [071/142] (604s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [440.869184] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip [441.418191] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.549s) [441.521379] [072/142] (601s left) kms_big_fb (linear-16bpp-rotate-180) [443.508230] Starting subtest: linear-16bpp-rotate-180 [445.370613] Subtest linear-16bpp-rotate-180: SUCCESS (1.860s) [445.487681] [073/142] (597s left) kms_flip (2x-flip-vs-rmfb-interruptible) [446.518967] Starting subtest: 2x-flip-vs-rmfb-interruptible [446.545726] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.026s) [446.620220] [074/142] (596s left) kms_ccs (pipe-a-random-ccs-data-4_tiled_dg2_mc_ccs) [448.672544] Starting subtest: pipe-A-random-ccs-data-4_tiled_dg2_mc_ccs [448.675632] Subtest pipe-A-random-ccs-data-4_tiled_dg2_mc_ccs: SKIP (0.000s) [449.076371] [075/142] (594s left) kms_atomic (atomic_plane_damage) [451.273647] Starting subtest: atomic_plane_damage [451.958324] Subtest atomic_plane_damage: SUCCESS (0.684s) [452.157618] [076/142] (591s left) vc4/vc4_wait_seqno (bad-seqno-1ns) [452.272490] Subtest bad-seqno-1ns: SKIP (0.000s) [452.323528] [077/142] (591s left) kms_chamelium_hpd (hdmi-hpd-storm) [454.347466] Subtest hdmi-hpd-storm: SKIP (0.000s) [454.407674] [078/142] (589s left) kms_vblank (pipe-a-wait-forked-busy-hang) [456.385008] Starting subtest: pipe-A-wait-forked-busy-hang [469.933093] Subtest pipe-A-wait-forked-busy-hang: SUCCESS (13.550s) [470.038094] [079/142] (573s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt) [472.005479] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt [472.007509] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [472.105353] [080/142] (571s left) kms_psr (psr2_sprite_plane_move) [472.208520] Subtest psr2_sprite_plane_move: SKIP (0.000s) [472.229104] [081/142] (571s left) kms_draw_crc (draw-method-mmap-cpu) [474.205044] Starting subtest: draw-method-mmap-cpu [474.206139] Starting dynamic subtest: xrgb8888-untiled [474.518870] Dynamic subtest xrgb8888-untiled: SUCCESS (0.314s) [474.533498] Starting dynamic subtest: rgb565-untiled [474.818995] Dynamic subtest rgb565-untiled: SUCCESS (0.298s) [474.831035] Starting dynamic subtest: xrgb2101010-untiled [475.086754] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.264s) [475.118158] Starting dynamic subtest: xrgb8888-xtiled [475.269430] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.177s) [475.289414] Starting dynamic subtest: rgb565-xtiled [475.435607] Dynamic subtest rgb565-xtiled: SUCCESS (0.163s) [475.454866] Starting dynamic subtest: xrgb2101010-xtiled [475.586616] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.146s) [475.618472] Starting dynamic subtest: xrgb8888-ytiled [475.769266] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.177s) [475.781286] Starting dynamic subtest: rgb565-ytiled [475.919395] Dynamic subtest rgb565-ytiled: SUCCESS (0.146s) [475.931304] Starting dynamic subtest: xrgb2101010-ytiled [476.069984] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.146s) [476.078170] Subtest draw-method-mmap-cpu: SUCCESS (1.867s) [476.153086] [082/142] (567s left) gem_exec_params (dr1-dirt) [476.228476] Starting subtest: DR1-dirt [476.229409] Subtest DR1-dirt: SUCCESS (0.000s) [476.308440] [083/142] (567s left) kms_atomic_interruptible (legacy-dpms) [478.292218] Starting subtest: legacy-dpms [478.293254] Starting dynamic subtest: HDMI-A-4-pipe-A [484.496326] Dynamic subtest HDMI-A-4-pipe-A: SUCCESS (6.204s) [484.497122] Subtest legacy-dpms: SUCCESS (6.206s) [484.602745] [084/142] (558s left) gem_wait (busy) [484.687385] Starting subtest: busy [484.688186] Starting dynamic subtest: all-engines [485.257260] Dynamic subtest all-engines: SUCCESS (0.569s) [485.268300] Starting dynamic subtest: rcs0 [485.796846] Dynamic subtest rcs0: SUCCESS (0.538s) [485.806031] Starting dynamic subtest: bcs0 [486.336756] Dynamic subtest bcs0: SUCCESS (0.539s) [486.345978] Starting dynamic subtest: vcs0 [486.876255] Dynamic subtest vcs0: SUCCESS (0.538s) [486.888485] Starting dynamic subtest: vcs1 [487.417882] Dynamic subtest vcs1: SUCCESS (0.540s) [487.427166] Starting dynamic subtest: vecs0 [487.956875] Dynamic subtest vecs0: SUCCESS (0.538s) [487.957844] Subtest busy: SUCCESS (3.270s) [488.192671] [085/142] (555s left) kms_big_fb (x-tiled-8bpp-rotate-90) [490.182833] Starting subtest: x-tiled-8bpp-rotate-90 [490.269674] Subtest x-tiled-8bpp-rotate-90: SKIP (0.085s) [490.369319] [086/142] (553s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render) [492.349965] Starting subtest: fbcpsr-rgb101010-draw-render [492.351618] Subtest fbcpsr-rgb101010-draw-render: SKIP (0.000s) [492.435075] [087/142] (551s left) kms_cursor_legacy (cursora-vs-flipa-varying-size) [494.428650] Starting subtest: cursorA-vs-flipA-varying-size [505.356364] Subtest cursorA-vs-flipA-varying-size: SUCCESS (10.926s) [505.479652] [088/142] (538s left) gem_exec_reloc (basic-wc-read-active) [505.555188] Subtest basic-wc-read-active: SKIP (0.000s) [505.603938] [089/142] (538s left) gem_ppgtt (shrink-vs-evict-any) [505.677810] Starting subtest: shrink-vs-evict-any [513.322975] Subtest shrink-vs-evict-any: SUCCESS (7.642s) [513.387296] [090/142] (530s left) kms_flip (absolute-wf_vblank) [514.412471] Starting subtest: absolute-wf_vblank [514.423636] Starting dynamic subtest: A-HDMI-A4 [522.336329] Dynamic subtest A-HDMI-A4: SUCCESS (7.913s) [522.346679] Starting dynamic subtest: B-HDMI-A4 [530.181645] Dynamic subtest B-HDMI-A4: SUCCESS (7.844s) [530.194211] Starting dynamic subtest: C-HDMI-A4 [538.021057] Dynamic subtest C-HDMI-A4: SUCCESS (7.838s) [538.030999] Starting dynamic subtest: D-HDMI-A4 [545.853732] Dynamic subtest D-HDMI-A4: SUCCESS (7.831s) [545.854663] Subtest absolute-wf_vblank: SUCCESS (31.442s) [545.995885] [091/142] (497s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt) [547.975284] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt [547.977541] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [548.061356] [092/142] (495s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled) [548.152715] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled [548.153774] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s) [548.211066] [093/142] (495s left) kms_color (deep-color) [550.186001] Starting subtest: deep-color [550.191942] Subtest deep-color: SKIP (0.004s) [550.261284] [094/142] (493s left) kms_big_fb (y-tiled-addfb) [552.259882] Starting subtest: y-tiled-addfb [552.261013] Subtest y-tiled-addfb: SUCCESS (0.000s) [552.345433] [095/142] (491s left) kms_pipe_crc_basic (nonblocking-crc) [554.348039] Starting subtest: nonblocking-crc [554.351127] Starting dynamic subtest: pipe-A-HDMI-A-4 [555.014975] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.665s) [555.028892] Starting dynamic subtest: pipe-B-HDMI-A-4 [555.934488] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.916s) [555.949188] Starting dynamic subtest: pipe-C-HDMI-A-4 [557.235817] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (1.299s) [557.249193] Starting dynamic subtest: pipe-D-HDMI-A-4 [558.916187] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (1.677s) [558.916976] Subtest nonblocking-crc: SUCCESS (4.568s) [559.041747] [096/142] (484s left) kms_ccs (pipe-c-bad-aux-stride-4_tiled_mtl_mc_ccs) [561.298640] Starting subtest: pipe-C-bad-aux-stride-4_tiled_mtl_mc_ccs [561.300497] Subtest pipe-C-bad-aux-stride-4_tiled_mtl_mc_ccs: SKIP (0.000s) [561.501217] [097/142] (482s left) gem_userptr_blits (sd-probe) [561.578336] Starting subtest: sd-probe [561.580641] Subtest sd-probe: SKIP (0.000s) [561.682743] [098/142] (482s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0) [563.670237] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0 [563.672242] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s) [563.749187] [099/142] (480s left) gem_render_copy (y-tiled-ccs-to-linear) [563.847960] Starting subtest: y-tiled-ccs-to-linear [563.848947] Starting dynamic subtest: smem [563.927298] Dynamic subtest smem: SUCCESS (0.079s) [563.935654] Starting dynamic subtest: lmem0 [564.234469] Dynamic subtest lmem0: SUCCESS (0.303s) [564.235430] Subtest y-tiled-ccs-to-linear: SUCCESS (0.384s) [564.460958] [100/142] (479s left) gem_softpin (evict-active) [564.535325] Starting subtest: evict-active [564.547194] Subtest evict-active: SUCCESS (0.012s) [564.655451] [101/142] (479s left) perf (polling-small-buf) [564.830438] Starting subtest: polling-small-buf [564.929837] Subtest polling-small-buf: SUCCESS (0.100s) [564.963502] [102/142] (478s left) device_reset (cold-reset-bound) [565.053707] Subtest cold-reset-bound: SKIP (0.000s) [565.118344] [103/142] (478s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size) [567.106240] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size [568.127815] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (1.022s) [568.270570] [104/142] (475s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_mtl_rc_ccs) [570.496554] Starting subtest: pipe-C-random-ccs-data-4_tiled_mtl_rc_ccs [570.499527] Subtest pipe-C-random-ccs-data-4_tiled_mtl_rc_ccs: SKIP (0.000s) [570.727042] [105/142] (473s left) perf_pmu (busy-idle-no-semaphores) [570.800653] Starting subtest: busy-idle-no-semaphores [570.801468] Starting dynamic subtest: rcs0 [571.445985] Dynamic subtest rcs0: SUCCESS (0.641s) [571.455012] Starting dynamic subtest: bcs0 [572.099281] Dynamic subtest bcs0: SUCCESS (0.648s) [572.111933] Starting dynamic subtest: vcs0 [572.753759] Dynamic subtest vcs0: SUCCESS (0.649s) [572.767264] Starting dynamic subtest: vcs1 [573.408448] Dynamic subtest vcs1: SUCCESS (0.649s) [573.421021] Starting dynamic subtest: vecs0 [574.063116] Dynamic subtest vecs0: SUCCESS (0.649s) [574.065295] Subtest busy-idle-no-semaphores: SUCCESS (3.261s) [574.197438] [106/142] (469s left) kms_big_fb (4-tiled-64bpp-rotate-90) [576.193027] Starting subtest: 4-tiled-64bpp-rotate-90 [576.195249] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.000s) [576.278341] [107/142] (467s left) kms_vblank (pipe-b-wait-busy) [578.281820] Starting subtest: pipe-B-wait-busy [581.099713] Subtest pipe-B-wait-busy: SUCCESS (2.820s) [581.206766] [108/142] (462s left) v3d/v3d_perfmon (get-values-invalid-perfmon) [581.304901] Subtest get-values-invalid-perfmon: SKIP (0.000s) [581.356586] [109/142] (462s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_mtl_mc_ccs) [583.389144] Starting subtest: pipe-A-crc-primary-basic-4_tiled_mtl_mc_ccs [583.391231] Subtest pipe-A-crc-primary-basic-4_tiled_mtl_mc_ccs: SKIP (0.000s) [583.811905] [110/142] (460s left) gem_lmem_swapping (massive-random) [587.786245] Starting subtest: massive-random [587.787030] Starting dynamic subtest: lmem0 [588.433123] Dynamic subtest lmem0: SUCCESS (0.647s) [588.433901] Subtest massive-random: SUCCESS (0.648s) [590.186256] [111/142] (453s left) gem_close_race (basic-threads) [592.705216] Starting subtest: basic-threads [593.864357] Subtest basic-threads: SUCCESS (1.159s) [594.101735] [112/142] (450s left) kms_ccs (pipe-b-bad-rotation-90-4_tiled_dg2_rc_ccs_cc) [596.170870] Starting subtest: pipe-B-bad-rotation-90-4_tiled_dg2_rc_ccs_cc [596.173190] Subtest pipe-B-bad-rotation-90-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s) [596.363528] [113/142] (447s left) kms_ccs (pipe-d-crc-primary-basic-y_tiled_ccs) [598.656746] Starting subtest: pipe-D-crc-primary-basic-y_tiled_ccs [598.658577] Subtest pipe-D-crc-primary-basic-y_tiled_ccs: SKIP (0.000s) [598.819346] [114/142] (445s left) prime_mmap (test_reprime) [598.888000] Starting subtest: test_reprime [598.889021] Starting dynamic subtest: test_reprime-smem [598.979191] Dynamic subtest test_reprime-smem: SUCCESS (0.091s) [598.988998] Starting dynamic subtest: test_reprime-lmem0 [599.071338] Dynamic subtest test_reprime-lmem0: SUCCESS (0.091s) [599.072341] Subtest test_reprime: SUCCESS (0.184s) [599.152672] [115/142] (445s left) kms_universal_plane (universal-plane-pipe-c-sanity) [601.126814] Starting subtest: universal-plane-pipe-C-sanity [602.388910] Subtest universal-plane-pipe-C-sanity: SUCCESS (1.262s) [602.512991] [116/142] (441s left) kms_addfb_basic (basic-x-tiled-legacy) [602.585133] Starting subtest: basic-x-tiled-legacy [602.586968] Subtest basic-x-tiled-legacy: SKIP (0.000s) [604.557196] [117/142] (439s left) kms_ccs (pipe-b-bad-aux-stride-yf_tiled_ccs) [606.746773] Starting subtest: pipe-B-bad-aux-stride-yf_tiled_ccs [606.748794] Subtest pipe-B-bad-aux-stride-yf_tiled_ccs: SKIP (0.000s) [607.034488] [118/142] (437s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted) [607.104345] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted [607.212061] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.105s) [607.267509] [119/142] (437s left) i915_pm_backlight (fade-with-dpms) [609.242792] Subtest fade-with-dpms: SKIP (0.000s) [609.276330] [120/142] (435s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled) [609.347407] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled [609.348339] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s) [609.423835] [121/142] (434s left) kms_vblank (pipe-d-query-forked-busy) [611.423333] Starting subtest: pipe-D-query-forked-busy [615.002458] Subtest pipe-D-query-forked-busy: SUCCESS (3.581s) [615.109838] [122/142] (429s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs) [615.188290] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs [615.189208] Starting dynamic subtest: smem [615.285378] Dynamic subtest smem: SUCCESS (0.096s) [615.294450] Starting dynamic subtest: lmem0 [616.394847] Dynamic subtest lmem0: SUCCESS (1.105s) [616.395685] Subtest y-tiled-ccs-to-yf-tiled-ccs: SUCCESS (1.204s) [616.619337] [123/142] (427s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [618.592884] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [618.593940] Starting dynamic subtest: pipe-A-valid-mode [618.632652] Dynamic subtest pipe-A-valid-mode: SKIP (0.039s) [618.634647] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.041s) [618.724870] [124/142] (425s left) gem_ctx_persistence (userptr) [618.799606] Starting subtest: userptr [618.933157] Subtest userptr: SUCCESS (0.134s) [618.990759] [125/142] (425s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs) [621.256522] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs [621.260659] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs: SKIP (0.003s) [621.450624] [126/142] (422s left) kms_addfb_basic (bad-pitch-0) [621.520272] Starting subtest: bad-pitch-0 [621.521169] Subtest bad-pitch-0: SUCCESS (0.000s) [623.500600] [127/142] (420s left) kms_ccs (pipe-a-bad-rotation-90-4_tiled_dg2_rc_ccs) [625.524774] Starting subtest: pipe-A-bad-rotation-90-4_tiled_dg2_rc_ccs [625.526843] Subtest pipe-A-bad-rotation-90-4_tiled_dg2_rc_ccs: SKIP (0.000s) [625.964836] [128/142] (418s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu) [627.947891] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu [627.950165] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [628.023274] [129/142] (416s left) kms_flip (flip-vs-panning) [629.063293] Starting subtest: flip-vs-panning [629.073718] Starting dynamic subtest: A-HDMI-A4 [636.868766] Dynamic subtest A-HDMI-A4: SUCCESS (7.794s) [636.880460] Starting dynamic subtest: B-HDMI-A4 [644.613561] Dynamic subtest B-HDMI-A4: SUCCESS (7.740s) [644.624758] Starting dynamic subtest: C-HDMI-A4 [652.336738] Dynamic subtest C-HDMI-A4: SUCCESS (7.720s) [652.348710] Starting dynamic subtest: D-HDMI-A4 [660.050441] Dynamic subtest D-HDMI-A4: SUCCESS (7.710s) [660.051453] Subtest flip-vs-panning: SUCCESS (30.988s) [660.208793] [130/142] (384s left) kms_ccs (pipe-d-random-ccs-data-yf_tiled_ccs) [662.519322] Starting subtest: pipe-D-random-ccs-data-yf_tiled_ccs [662.521707] Subtest pipe-D-random-ccs-data-yf_tiled_ccs: SKIP (0.000s) [662.660521] [131/142] (381s left) gem_softpin (allocator-basic-reserve) [662.733418] Starting subtest: allocator-basic-reserve [662.944685] Subtest allocator-basic-reserve: SUCCESS (0.208s) [663.060348] [132/142] (381s left) gem_readwrite (beyond-eob) [663.130618] Subtest beyond-EOB: SKIP (0.000s) [663.168405] [133/142] (381s left) kms_vrr (negative-basic) [665.145576] Starting subtest: negative-basic [665.147406] Subtest negative-basic: SKIP (0.000s) [665.209816] [134/142] (379s left) gem_eio (in-flight-1us) [665.388989] Starting subtest: in-flight-1us [669.040285] Subtest in-flight-1us: SUCCESS (3.652s) [671.010081] [135/142] (373s left) gem_pread (bench) [671.085040] Subtest bench: SKIP (0.000s) [671.154830] [136/142] (373s left) kms_psr (dpms) [671.249511] Subtest dpms: SKIP (0.000s) [671.317037] [137/142] (373s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary) [673.315305] Starting subtest: fbc-indfb-scaledprimary [676.758663] Subtest fbc-indfb-scaledprimary: SUCCESS (3.444s) [676.894658] [138/142] (367s left) gem_exec_whisper (basic-queues-forked-all) [676.974349] Starting subtest: basic-queues-forked-all [699.712187] Subtest basic-queues-forked-all: SUCCESS (22.734s) [699.913864] [139/142] (344s left) gem_ctx_freq (sysfs) [700.007661] Starting subtest: sysfs [700.008541] Starting dynamic subtest: gt0 [705.594072] Dynamic subtest gt0: SUCCESS (5.588s) [705.595174] Subtest sysfs: SUCCESS (5.590s) [705.716595] [140/142] (339s left) syncobj_timeline (single-wait-for-submit-available-submitted) [705.785707] Starting subtest: single-wait-for-submit-available-submitted [705.786608] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s) [705.859270] [141/142] (338s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [707.837241] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [707.839241] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [707.922912] [142/142] (336s left) gem_partial_pwrite_pread (write-uncached) [708.020936] Subtest write-uncached: SKIP (0.000s) [708.064172] Closing watchdogs Done.