[37.345131] Initializing watchdogs [37.345170] /dev/watchdog0 [37.351412] [001/138] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt) [37.412753] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt [37.417144] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [37.498426] [002/138] (960s left) gem_exec_balancer (full-late-pulse) [37.553135] Starting subtest: full-late-pulse [42.078582] Subtest full-late-pulse: SUCCESS (4.525s) [42.316875] [003/138] (955s left) perf (gen8-unprivileged-single-ctx-counters) [42.459441] Starting subtest: gen8-unprivileged-single-ctx-counters [42.463621] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s) [42.480286] [004/138] (955s left) gem_exec_whisper (basic-queues-priority) [42.527256] Starting subtest: basic-queues-priority [65.788146] Subtest basic-queues-priority: SUCCESS (23.258s) [65.961577] [005/138] (931s left) gem_exec_schedule (thriceslice) [66.032259] Starting subtest: thriceslice [66.034387] Starting dynamic subtest: rcs0 [66.041561] Dynamic subtest rcs0: SUCCESS (0.023s) [66.048547] Starting dynamic subtest: bcs0 [66.089260] Dynamic subtest bcs0: SUCCESS (0.048s) [66.100759] Starting dynamic subtest: vcs0 [66.117185] Dynamic subtest vcs0: SUCCESS (0.028s) [66.128771] Starting dynamic subtest: vcs1 [66.168216] Dynamic subtest vcs1: SUCCESS (0.051s) [66.179386] Starting dynamic subtest: vecs0 [66.195491] Dynamic subtest vecs0: SUCCESS (0.027s) [66.206115] Starting dynamic subtest: ccs0 [66.226108] Dynamic subtest ccs0: SUCCESS (0.030s) [66.229072] Subtest thriceslice: SUCCESS (0.208s) [67.458688] [006/138] (930s left) kms_flip (nonblocking-read) [67.516992] Starting subtest: nonblocking-read [67.519271] Subtest nonblocking-read: SUCCESS (0.000s) [67.592200] [007/138] (930s left) v3d/v3d_submit_csd (single-out-sync) [67.680045] Subtest single-out-sync: SKIP (0.000s) [67.724851] [008/138] (930s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling) [67.803951] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling [67.806467] Starting dynamic subtest: pipe-A-default-mode [69.005164] Dynamic subtest pipe-A-default-mode: SKIP (1.197s) [69.009835] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.199s) [69.136916] [009/138] (928s left) api_intel_bb (blit-noreloc-keep-cache) [69.195128] Starting subtest: blit-noreloc-keep-cache [69.203971] Subtest blit-noreloc-keep-cache: SUCCESS (0.011s) [69.299376] [010/138] (928s left) kms_ccs (pipe-b-random-ccs-data-y-tiled-gen12-rc-ccs-cc) [69.688077] Starting subtest: pipe-B-random-ccs-data-y-tiled-gen12-rc-ccs-cc [69.695051] Subtest pipe-B-random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s) [70.553990] [011/138] (927s left) kms_lease (simple-lease) [70.619677] Starting subtest: simple-lease [70.622075] Starting dynamic subtest: pipe-A-eDP-1 [71.206880] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.588s) [71.218564] Starting dynamic subtest: pipe-B-eDP-1 [72.697647] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.487s) [72.708689] Starting dynamic subtest: pipe-C-eDP-1 [74.220286] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.522s) [74.231647] Starting dynamic subtest: pipe-D-eDP-1 [75.703519] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.481s) [75.706076] Subtest simple-lease: SUCCESS (5.084s) [76.635544] [012/138] (921s left) kms_ccs (pipe-a-crc-primary-rotation-180-y-tiled-gen12-mc-ccs) [77.026140] Starting subtest: pipe-A-crc-primary-rotation-180-y-tiled-gen12-mc-ccs [77.030930] Subtest pipe-A-crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.001s) [77.912841] [013/138] (920s left) core_getversion [78.026853] [014/138] (920s left) gem_mmap_wc (write-wc-read-gtt) [78.085209] Subtest write-wc-read-gtt: SKIP (0.000s) [78.117304] [015/138] (920s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [78.174239] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip [78.746971] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.575s) [78.873656] [016/138] (919s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode) [79.253227] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s) [80.130483] [017/138] (918s left) i915_hangman (gt-engine-error) [80.192873] Starting subtest: gt-engine-error [80.195933] Starting dynamic subtest: rcs0 [81.411488] Dynamic subtest rcs0: SUCCESS (1.218s) [81.424193] Starting dynamic subtest: bcs0 [83.395171] Dynamic subtest bcs0: SUCCESS (1.983s) [83.407297] Starting dynamic subtest: vcs0 [85.378544] Dynamic subtest vcs0: SUCCESS (1.983s) [85.393113] Starting dynamic subtest: vcs1 [87.427370] Dynamic subtest vcs1: SUCCESS (2.048s) [87.440027] Starting dynamic subtest: vecs0 [89.410322] Dynamic subtest vecs0: SUCCESS (1.983s) [89.422182] Starting dynamic subtest: ccs0 [91.394740] Dynamic subtest ccs0: SUCCESS (1.984s) [91.396855] Subtest gt-engine-error: SUCCESS (11.201s) [91.469519] [018/138] (906s left) kms_ccs (pipe-b-missing-ccs-buffer-yf-tiled-ccs) [91.852044] Starting subtest: pipe-B-missing-ccs-buffer-yf-tiled-ccs [91.858201] Subtest pipe-B-missing-ccs-buffer-yf-tiled-ccs: SKIP (0.000s) [92.709201] [019/138] (905s left) gem_exec_schedule (implicit-write-read) [92.780447] Starting subtest: implicit-write-read [92.782943] Starting dynamic subtest: rcs0 [92.821863] Dynamic subtest rcs0: SUCCESS (0.053s) [92.832973] Starting dynamic subtest: vcs0 [92.877189] Dynamic subtest vcs0: SUCCESS (0.055s) [92.888244] Starting dynamic subtest: vcs1 [92.935308] Dynamic subtest vcs1: SUCCESS (0.058s) [92.947297] Starting dynamic subtest: vecs0 [92.990087] Dynamic subtest vecs0: SUCCESS (0.055s) [93.001530] Starting dynamic subtest: ccs0 [93.047682] Dynamic subtest ccs0: SUCCESS (0.057s) [93.050263] Subtest implicit-write-read: SUCCESS (0.280s) [93.483025] [020/138] (904s left) i915_query (engine-info-invalid) [93.541405] Starting subtest: engine-info-invalid [93.543918] Subtest engine-info-invalid: SUCCESS (0.000s) [93.598245] [021/138] (904s left) kms_flip (plain-flip-ts-check-interruptible) [93.670231] Starting subtest: plain-flip-ts-check-interruptible [93.676180] Starting dynamic subtest: A-eDP1 [102.607958] Dynamic subtest A-eDP1: SUCCESS (8.932s) [102.622963] Starting dynamic subtest: B-eDP1 [111.504052] Dynamic subtest B-eDP1: SUCCESS (8.896s) [111.515350] Starting dynamic subtest: C-eDP1 [120.389062] Dynamic subtest C-eDP1: SUCCESS (8.884s) [120.401218] Starting dynamic subtest: D-eDP1 [129.285257] Dynamic subtest D-eDP1: SUCCESS (8.896s) [129.294755] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.622s) [130.535263] [022/138] (867s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [130.613999] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt [130.618301] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [130.680649] [023/138] (867s left) kms_big_fb (yf-tiled-8bpp-rotate-180) [130.749056] Starting subtest: yf-tiled-8bpp-rotate-180 [130.752976] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s) [130.817258] [024/138] (867s left) kms_ccs (pipe-a-bad-rotation-90-4-tiled-mtl-rc-ccs) [131.193220] Starting subtest: pipe-A-bad-rotation-90-4-tiled-mtl-rc-ccs [132.080513] Subtest pipe-A-bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.885s) [133.272066] [025/138] (865s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-wc) [133.356047] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-wc [137.926829] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (4.574s) [138.054807] [026/138] (860s left) kms_psr (primary_mmap_gtt) [138.123849] Starting subtest: primary_mmap_gtt [139.604555] Subtest primary_mmap_gtt: SKIP (1.477s) [139.761395] [027/138] (858s left) gem_exec_params (sol-reset-not-gen7) [139.830512] Starting subtest: sol-reset-not-gen7 [139.832881] Subtest sol-reset-not-gen7: SUCCESS (0.002s) [139.923058] [028/138] (858s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt) [140.000291] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt [140.004904] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [140.082211] [029/138] (858s left) kms_setmode (invalid-clone-exclusive-crtc) [140.133491] Starting subtest: invalid-clone-exclusive-crtc [140.140330] Subtest invalid-clone-exclusive-crtc: SKIP (0.001s) [140.193619] [030/138] (858s left) gem_mmap_gtt (fault-concurrent-y) [140.250796] Subtest fault-concurrent-Y: SKIP (0.000s) [140.270342] [031/138] (858s left) kms_ccs (pipe-b-bad-aux-stride-4-tiled-mtl-mc-ccs) [140.642994] Starting subtest: pipe-B-bad-aux-stride-4-tiled-mtl-mc-ccs [140.720477] Subtest pipe-B-bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.077s) [141.502530] [032/138] (857s left) prime_vgem (shrink) [141.614618] Starting subtest: shrink [141.632246] Subtest shrink: SUCCESS (0.019s) [141.720889] [033/138] (856s left) gem_create (busy-create) [141.769957] Starting subtest: busy-create [141.772601] Starting dynamic subtest: smem0 [175.435475] Dynamic subtest smem0: SUCCESS (33.665s) [175.437992] Subtest busy-create: SUCCESS (33.665s) [175.614022] [034/138] (823s left) kms_psr (psr2_sprite_plane_onoff) [175.679531] Starting subtest: psr2_sprite_plane_onoff [177.494477] Subtest psr2_sprite_plane_onoff: SUCCESS (1.814s) [178.406674] [035/138] (820s left) dumb_buffer (create-clear) [178.461539] Starting subtest: create-clear [213.138624] Subtest create-clear: SUCCESS (34.676s) [213.233917] [036/138] (785s left) kms_flip (nonexisting-fb) [213.295533] Starting subtest: nonexisting-fb [213.298078] Starting dynamic subtest: A-eDP1 [214.558753] Dynamic subtest A-eDP1: SUCCESS (1.263s) [214.571757] Starting dynamic subtest: B-eDP1 [215.838451] Dynamic subtest B-eDP1: SUCCESS (1.279s) [215.850827] Starting dynamic subtest: C-eDP1 [217.096159] Dynamic subtest C-eDP1: SUCCESS (1.257s) [217.110814] Starting dynamic subtest: D-eDP1 [218.375617] Dynamic subtest D-eDP1: SUCCESS (1.279s) [218.383185] Subtest nonexisting-fb: SUCCESS (5.091s) [219.686544] [037/138] (779s left) syncobj_wait (wait-all-for-submit-complex) [219.746707] Starting subtest: wait-all-for-submit-complex [219.957762] Subtest wait-all-for-submit-complex: SUCCESS (0.213s) [220.021995] [038/138] (778s left) perf_pmu (all-busy-check-all) [220.083594] Starting subtest: all-busy-check-all [221.378345] Subtest all-busy-check-all: SUCCESS (1.294s) [221.445574] [039/138] (777s left) kms_addfb_basic (addfb25-modifier-no-flag) [221.500301] Starting subtest: addfb25-modifier-no-flag [221.502382] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [221.608952] [040/138] (777s left) kms_ccs (pipe-a-crc-primary-basic-y-tiled-gen12-mc-ccs) [221.973890] Starting subtest: pipe-A-crc-primary-basic-y-tiled-gen12-mc-ccs [221.978768] Subtest pipe-A-crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.001s) [222.878065] [041/138] (775s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted) [222.925239] Starting subtest: etime-single-wait-for-submit-unsubmitted [223.025241] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.102s) [223.091300] [042/138] (775s left) kms_cursor_legacy (flip-vs-cursor-legacy) [223.175212] Starting subtest: flip-vs-cursor-legacy [228.885317] Subtest flip-vs-cursor-legacy: SUCCESS (5.707s) [229.800800] [043/138] (769s left) kms_rotation_crc (primary-y-tiled-reflect-x-90) [229.860619] Starting subtest: primary-y-tiled-reflect-x-90 [229.865245] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s) [229.911235] [044/138] (769s left) syncobj_timeline (single-wait-all-signaled) [229.965270] Starting subtest: single-wait-all-signaled [229.967697] Subtest single-wait-all-signaled: SUCCESS (0.001s) [230.021498] [045/138] (768s left) core_setmaster (master-drop-set-user) [230.575834] Starting subtest: master-drop-set-user [230.594884] Subtest master-drop-set-user: SUCCESS (0.019s) [230.615578] [046/138] (768s left) kms_big_fb (linear-64bpp-rotate-180) [230.682865] Starting subtest: linear-64bpp-rotate-180 [232.324279] Subtest linear-64bpp-rotate-180: SUCCESS (1.644s) [232.521781] [047/138] (766s left) gem_flink_basic (basic) [232.612362] Starting subtest: basic [232.614450] Subtest basic: SUCCESS (0.000s) [232.683223] [048/138] (766s left) gem_pxp (hw-rejects-pxp-buffer) [235.272204] Starting subtest: hw-rejects-pxp-buffer [235.275309] Subtest hw-rejects-pxp-buffer: SUCCESS (0.000s) [235.349511] [049/138] (763s left) kms_cursor_crc (cursor-rapid-movement-max-size) [235.502510] Starting subtest: cursor-rapid-movement-max-size [235.509637] Subtest cursor-rapid-movement-max-size: SKIP (0.000s) [235.608342] [050/138] (763s left) dmabuf_sync_file (export-multiwait) [235.695421] Starting subtest: export-multiwait [235.698483] Subtest export-multiwait: SUCCESS (0.001s) [235.742132] [051/138] (763s left) prime_vgem (basic-gtt) [235.798250] Starting subtest: basic-gtt [235.803705] Subtest basic-gtt: SKIP (0.000s) [235.872802] [052/138] (763s left) gem_exec_capture (pi) [235.912494] Starting subtest: pi [235.914944] Starting dynamic subtest: rcs0 [240.386258] Dynamic subtest rcs0: SUCCESS (4.474s) [240.399395] Starting dynamic subtest: bcs0 [244.464191] Dynamic subtest bcs0: SUCCESS (4.078s) [244.477629] Starting dynamic subtest: vcs0 [248.665782] Dynamic subtest vcs0: SUCCESS (4.201s) [248.681036] Starting dynamic subtest: vcs1 [252.880386] Dynamic subtest vcs1: SUCCESS (4.214s) [252.887106] Starting dynamic subtest: vecs0 [257.223593] Dynamic subtest vecs0: SUCCESS (4.343s) [257.237143] Starting dynamic subtest: ccs0 [261.624841] Dynamic subtest ccs0: SUCCESS (4.400s) [261.627299] Subtest pi: SUCCESS (25.713s) [261.695761] [053/138] (737s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [261.844854] Starting subtest: addfb25-y-tiled-small-legacy [261.849462] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [261.926975] [054/138] (737s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen) [261.991520] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen [262.000266] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [262.075464] [055/138] (737s left) kms_ccs (pipe-d-bad-pixel-format-y-tiled-gen12-rc-ccs-cc) [262.483065] Starting subtest: pipe-D-bad-pixel-format-y-tiled-gen12-rc-ccs-cc [262.488760] Subtest pipe-D-bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s) [263.321237] [056/138] (735s left) gem_exec_fence (syncobj-timeline-chain-engines) [263.873376] Starting subtest: syncobj-timeline-chain-engines [263.913525] Subtest syncobj-timeline-chain-engines: SUCCESS (0.042s) [265.496541] [057/138] (733s left) syncobj_wait (invalid-wait-bad-flags) [265.556685] Starting subtest: invalid-wait-bad-flags [265.559060] Subtest invalid-wait-bad-flags: SUCCESS (0.000s) [265.619609] [058/138] (733s left) gem_ctx_param (basic) [265.675557] Starting subtest: basic [265.677835] Subtest basic: SUCCESS (0.000s) [265.735798] [059/138] (733s left) gem_exec_balancer (smoke) [265.788139] Starting subtest: smoke [288.100223] Subtest smoke: SUCCESS (22.311s) [288.904276] [060/138] (710s left) kms_sequence (get-idle) [288.967646] Starting subtest: get-idle [288.970050] Starting dynamic subtest: pipe-A-eDP-1 [290.764934] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.798s) [290.782715] Starting dynamic subtest: pipe-B-eDP-1 [293.354774] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.588s) [293.368492] Starting dynamic subtest: pipe-C-eDP-1 [295.883742] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.524s) [295.898079] Starting dynamic subtest: pipe-D-eDP-1 [298.453422] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.570s) [298.455881] Subtest get-idle: SUCCESS (9.488s) [299.355330] [061/138] (699s left) kms_big_fb (x-tiled-8bpp-rotate-0) [299.414074] Starting subtest: x-tiled-8bpp-rotate-0 [300.723231] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.310s) [300.835039] [062/138] (698s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite) [300.914549] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite [305.606850] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.694s) [305.706956] [063/138] (693s left) kms_flip (flip-vs-expired-vblank) [305.766676] Starting subtest: flip-vs-expired-vblank [305.769144] Starting dynamic subtest: A-eDP1 [314.528201] Dynamic subtest A-eDP1: SUCCESS (8.764s) [314.547192] Starting dynamic subtest: B-eDP1 [323.295761] Dynamic subtest B-eDP1: SUCCESS (8.766s) [323.310358] Starting dynamic subtest: C-eDP1 [332.052901] Dynamic subtest C-eDP1: SUCCESS (8.756s) [332.068449] Starting dynamic subtest: D-eDP1 [340.822736] Dynamic subtest D-eDP1: SUCCESS (8.768s) [340.831530] Subtest flip-vs-expired-vblank: SUCCESS (35.071s) [342.122128] [064/138] (657s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75) [342.189673] Starting subtest: planes-upscale-20x20-downscale-factor-0-75 [342.192279] Starting dynamic subtest: pipe-A-eDP-1 [342.205115] Dynamic subtest pipe-A-eDP-1: SKIP (0.009s) [342.218075] Starting dynamic subtest: pipe-B-eDP-1 [342.222964] Dynamic subtest pipe-B-eDP-1: SKIP (0.017s) [342.235191] Starting dynamic subtest: pipe-C-eDP-1 [342.240047] Dynamic subtest pipe-C-eDP-1: SKIP (0.017s) [342.251682] Starting dynamic subtest: pipe-D-eDP-1 [342.256475] Dynamic subtest pipe-D-eDP-1: SKIP (0.017s) [342.260519] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.064s) [342.337538] [065/138] (657s left) kms_hdr (bpc-switch) [342.422243] Starting subtest: bpc-switch [343.536304] Starting dynamic subtest: pipe-A-eDP-1 [347.119800] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.585s) [347.122293] Subtest bpc-switch: SUCCESS (4.700s) [347.221579] [066/138] (652s left) gem_ctx_isolation (dirty-switch) [347.269741] Starting subtest: dirty-switch [347.272343] Starting dynamic subtest: rcs0 [347.370053] Dynamic subtest rcs0: SUCCESS (0.099s) [347.383046] Starting dynamic subtest: bcs0 [347.520773] Dynamic subtest bcs0: SUCCESS (0.152s) [347.535333] Starting dynamic subtest: vcs0 [347.684773] Dynamic subtest vcs0: SUCCESS (0.164s) [347.698385] Starting dynamic subtest: vcs1 [349.532065] Dynamic subtest vcs1: SUCCESS (1.847s) [349.542714] Starting dynamic subtest: vecs0 [351.597753] Dynamic subtest vecs0: SUCCESS (2.065s) [351.605178] Starting dynamic subtest: ccs0 [353.581992] Dynamic subtest ccs0: SUCCESS (1.984s) [353.584385] Subtest dirty-switch: SUCCESS (6.313s) [353.810987] [067/138] (645s left) kms_plane (plane-panning-bottom-right) [353.868732] Starting subtest: plane-panning-bottom-right [353.870848] Starting dynamic subtest: pipe-A [355.616358] Dynamic subtest pipe-A: SUCCESS (1.747s) [355.630041] Starting dynamic subtest: pipe-B [358.176989] Dynamic subtest pipe-B: SUCCESS (2.558s) [358.179630] Subtest plane-panning-bottom-right: SUCCESS (4.309s) [359.081400] [068/138] (640s left) kms_big_fb (y-tiled-8bpp-rotate-0) [359.174043] Starting subtest: y-tiled-8bpp-rotate-0 [359.178494] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s) [359.270393] [069/138] (640s left) kms_prop_blob (blob-prop-validate) [359.327584] Starting subtest: blob-prop-validate [359.330146] Subtest blob-prop-validate: SUCCESS (0.000s) [359.387407] [070/138] (640s left) gem_spin_batch (user-each) [359.454919] Starting subtest: user-each [362.720451] Subtest user-each: SUCCESS (3.263s) [363.463993] [071/138] (636s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt) [363.553867] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt [363.558031] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [363.640797] [072/138] (635s left) kms_vrr (flipline) [363.718053] Starting subtest: flipline [363.722623] Subtest flipline: SKIP (0.000s) [363.780846] [073/138] (635s left) kms_cursor_legacy (cursorb-vs-flipb-legacy) [363.879559] Starting subtest: cursorB-vs-flipB-legacy [363.884729] Subtest cursorB-vs-flipB-legacy: SKIP (0.002s) [364.013891] [074/138] (635s left) perf_pmu (invalid-open) [364.078285] Starting subtest: invalid-open [364.080475] Subtest invalid-open: SUCCESS (0.000s) [364.140368] [075/138] (635s left) prime_mmap_coherency (read) [364.200749] Starting subtest: read [369.575422] Subtest read: SUCCESS (5.373s) [369.673691] [076/138] (630s left) gem_ctx_shared (exec-single-timeline) [369.748706] Starting subtest: exec-single-timeline [369.751058] Starting dynamic subtest: rcs0 [370.818495] Dynamic subtest rcs0: SUCCESS (1.067s) [370.832108] Starting dynamic subtest: bcs0 [371.841478] Dynamic subtest bcs0: SUCCESS (1.022s) [371.856088] Starting dynamic subtest: vcs0 [372.866428] Dynamic subtest vcs0: SUCCESS (1.023s) [372.880312] Starting dynamic subtest: vcs1 [373.890946] Dynamic subtest vcs1: SUCCESS (1.023s) [373.905062] Starting dynamic subtest: vecs0 [374.914656] Dynamic subtest vecs0: SUCCESS (1.022s) [374.929712] Starting dynamic subtest: ccs0 [375.938886] Dynamic subtest ccs0: SUCCESS (1.022s) [375.941917] Subtest exec-single-timeline: SUCCESS (6.189s) [376.118196] [077/138] (623s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt) [376.205706] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt [376.210447] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [376.288986] [078/138] (623s left) prime_mmap (test_correct) [376.343028] Starting subtest: test_correct [376.345050] Starting dynamic subtest: test_correct-smem [376.367485] Dynamic subtest test_correct-smem: SUCCESS (0.027s) [376.370058] Subtest test_correct: SUCCESS (0.027s) [376.456050] [079/138] (623s left) syncobj_wait (invalid-wait-zero-handles) [376.499090] Starting subtest: invalid-wait-zero-handles [376.501031] Subtest invalid-wait-zero-handles: SUCCESS (0.000s) [376.555369] [080/138] (623s left) gem_mmap_wc (write-read-distinct) [376.628289] Subtest write-read-distinct: SKIP (0.000s) [376.646966] [081/138] (623s left) kms_pm_backlight (basic-brightness) [376.703877] Starting subtest: basic-brightness [376.760144] Starting dynamic subtest: eDP-1 [377.280344] Dynamic subtest eDP-1: SUCCESS (0.519s) [377.282966] Subtest basic-brightness: SUCCESS (0.576s) [378.197712] [082/138] (621s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [378.264636] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [378.798269] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.536s) [378.927744] [083/138] (620s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [379.017323] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip [379.021595] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [379.101412] [084/138] (620s left) kms_cursor_crc (cursor-rapid-movement-128x42) [379.225218] Starting subtest: cursor-rapid-movement-128x42 [379.227712] Starting dynamic subtest: pipe-A-eDP-1 [379.846239] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.617s) [379.882113] Starting dynamic subtest: pipe-D-eDP-1 [381.152934] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.282s) [381.155452] Subtest cursor-rapid-movement-128x42: SUCCESS (1.928s) [382.047509] [085/138] (617s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format) [382.129870] Starting subtest: plane-downscale-factor-0-75-with-pixel-format [382.132295] Starting dynamic subtest: pipe-A-eDP-1 [386.521726] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.394s) [386.536253] Starting dynamic subtest: pipe-B-eDP-1 [391.997173] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.474s) [392.005752] Starting dynamic subtest: pipe-C-eDP-1 [393.345619] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.347s) [393.357123] Starting dynamic subtest: pipe-D-eDP-1 [394.691195] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.343s) [394.693750] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (12.564s) [395.943838] [086/138] (604s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [395.999714] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [396.004339] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [396.080190] [087/138] (603s left) perf_pmu (frequency) [396.143489] Starting subtest: frequency [396.145881] Starting dynamic subtest: gt0 [398.226259] Dynamic subtest gt0: SUCCESS (2.076s) [398.239916] Starting dynamic subtest: idle-gt0 [398.748410] Dynamic subtest idle-gt0: SUCCESS (0.522s) [398.763574] Starting dynamic subtest: gt1 [403.405639] Dynamic subtest gt1: SUCCESS (4.654s) [403.419056] Starting dynamic subtest: idle-gt1 [403.926125] Dynamic subtest idle-gt1: SUCCESS (0.519s) [403.929245] Subtest frequency: SUCCESS (7.778s) [403.997443] [088/138] (596s left) kms_atomic_transition (plane-all-transition-fencing) [404.054400] Starting subtest: plane-all-transition-fencing [404.056801] Starting dynamic subtest: pipe-A-eDP-1 [406.548524] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s) [406.862358] Starting dynamic subtest: pipe-B-eDP-1 [410.196761] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.348s) [410.508740] Subtest plane-all-transition-fencing: SUCCESS (6.451s) [411.421352] [089/138] (588s left) gem_ctx_persistence (legacy-engines-queued) [411.482079] Starting subtest: legacy-engines-queued [411.484591] Starting dynamic subtest: render [411.529087] Dynamic subtest render: SUCCESS (0.045s) [411.543418] Starting dynamic subtest: bsd1 [413.380284] Dynamic subtest bsd1: SUCCESS (1.848s) [413.394086] Starting dynamic subtest: bsd2 [415.426917] Dynamic subtest bsd2: SUCCESS (2.044s) [415.442083] Starting dynamic subtest: blt [415.464696] Dynamic subtest blt: SUCCESS (0.037s) [415.478638] Starting dynamic subtest: vebox [417.411383] Dynamic subtest vebox: SUCCESS (1.943s) [417.414139] Subtest legacy-engines-queued: SUCCESS (5.929s) [417.510179] [090/138] (582s left) kms_vblank (query-idle) [417.571071] Starting subtest: query-idle [417.573450] Starting dynamic subtest: pipe-A-eDP-1 [419.324664] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.752s) [419.339386] Starting dynamic subtest: pipe-D-eDP-1 [421.876387] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.546s) [421.878954] Subtest query-idle: SUCCESS (4.307s) [422.812808] [091/138] (577s left) kms_cursor_crc (cursor-onscreen-256x256) [422.982150] Starting subtest: cursor-onscreen-256x256 [422.984598] Starting dynamic subtest: pipe-A-eDP-1 [425.149438] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.164s) [425.181288] Starting dynamic subtest: pipe-D-eDP-1 [428.022951] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.852s) [428.025198] Subtest cursor-onscreen-256x256: SUCCESS (5.042s) [428.912809] [092/138] (571s left) gem_lmem_swapping (heavy-verify-multi-ccs) [428.986185] Subtest heavy-verify-multi-ccs: SKIP (0.000s) [429.005335] [093/138] (571s left) kms_chamelium_edid (hdmi-edid-read) [429.372117] Subtest hdmi-edid-read: SKIP (0.000s) [430.278719] [094/138] (569s left) kms_ccs (pipe-c-crc-primary-rotation-180-4-tiled-mtl-mc-ccs) [430.662318] Starting subtest: pipe-C-crc-primary-rotation-180-4-tiled-mtl-mc-ccs [433.015486] Subtest pipe-C-crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (2.353s) [434.182053] [095/138] (566s left) kms_color (invalid-degamma-lut-sizes) [434.261928] Starting subtest: invalid-degamma-lut-sizes [434.264508] Starting dynamic subtest: pipe-A [434.549868] Dynamic subtest pipe-A: SUCCESS (0.286s) [434.559849] Starting dynamic subtest: pipe-B [434.562360] Dynamic subtest pipe-B: SUCCESS (0.002s) [434.570126] Starting dynamic subtest: pipe-C [434.572507] Dynamic subtest pipe-C: SUCCESS (0.001s) [434.579304] Starting dynamic subtest: pipe-D [434.581688] Dynamic subtest pipe-D: SUCCESS (0.002s) [434.583675] Subtest invalid-degamma-lut-sizes: SUCCESS (0.296s) [435.421597] [096/138] (564s left) kms_ccs (pipe-d-crc-primary-basic-4-tiled-mtl-mc-ccs) [435.831823] Starting subtest: pipe-D-crc-primary-basic-4-tiled-mtl-mc-ccs [438.235791] Subtest pipe-D-crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (2.402s) [439.458840] [097/138] (560s left) gem_render_copy (yf-tiled-to-vebox-x-tiled) [439.517693] Starting subtest: yf-tiled-to-vebox-x-tiled [439.522127] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s) [439.687684] [098/138] (560s left) kms_async_flips (alternate-sync-async-flip) [439.751869] Starting subtest: alternate-sync-async-flip [440.133596] Starting dynamic subtest: pipe-A-eDP-1 [442.954722] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.821s) [443.331260] Starting dynamic subtest: pipe-B-eDP-1 [446.156529] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.834s) [446.559498] Starting dynamic subtest: pipe-C-eDP-1 [449.421532] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.872s) [449.807969] Starting dynamic subtest: pipe-D-eDP-1 [452.685747] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.891s) [452.687907] Subtest alternate-sync-async-flip: SUCCESS (12.936s) [453.979254] [099/138] (546s left) kms_flip (2x-flip-vs-dpms) [454.044317] Starting subtest: 2x-flip-vs-dpms [454.054931] Subtest 2x-flip-vs-dpms: SKIP (0.013s) [454.121558] [100/138] (546s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled) [454.176365] Starting subtest: multi-wait-for-submit-available-submitted-signaled [454.178879] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s) [454.240076] [101/138] (546s left) vc4/vc4_purgeable_bo (mark-unpurgeable-purged) [454.344238] Subtest mark-unpurgeable-purged: SKIP (0.000s) [454.392276] [102/138] (545s left) syncobj_timeline (wait-any-interrupted) [454.445268] Starting subtest: wait-any-interrupted [454.544550] Subtest wait-any-interrupted: SUCCESS (0.101s) [454.614623] [103/138] (545s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt) [454.696082] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt [454.700326] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [454.776507] [104/138] (545s left) kms_ccs (pipe-d-bad-aux-stride-y-tiled-gen12-mc-ccs) [455.173891] Starting subtest: pipe-D-bad-aux-stride-y-tiled-gen12-mc-ccs [455.179286] Subtest pipe-D-bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.000s) [456.035472] [105/138] (544s left) gem_exec_reloc (basic-gtt-wc-noreloc) [456.076070] Subtest basic-gtt-wc-noreloc: SKIP (0.000s) [456.112407] [106/138] (544s left) gem_exec_reloc (basic-gtt-read) [456.176128] Subtest basic-gtt-read: SKIP (0.000s) [456.212560] [107/138] (544s left) gem_exec_schedule (preempt-queue-chain) [456.267725] Subtest preempt-queue-chain: SKIP (0.000s) [456.555701] [108/138] (543s left) v3d/v3d_submit_cl (bad-bo) [456.655873] Subtest bad-bo: SKIP (0.000s) [456.706367] [109/138] (543s left) gem_userptr_blits (coherency-unsync) [456.764413] Subtest coherency-unsync: SKIP (0.000s) [456.867082] [110/138] (543s left) gem_exec_reloc (basic-gtt-active) [456.928048] Subtest basic-gtt-active: SKIP (0.000s) [456.984267] [111/138] (543s left) gem_tiled_partial_pwrite_pread (writes) [457.036140] Subtest writes: SKIP (0.000s) [457.053345] [112/138] (543s left) gen7_exec_parse (bitmasks) [457.106268] Subtest bitmasks: SKIP (0.000s) [457.137307] [113/138] (543s left) v3d/v3d_mmap (mmap-bad-flags) [457.239222] Subtest mmap-bad-flags: SKIP (0.000s) [457.282127] [114/138] (543s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled) [457.341608] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled [457.346208] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s) [457.516444] [115/138] (543s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling) [457.585819] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling [457.588251] Starting dynamic subtest: pipe-A-default-mode [457.920086] Dynamic subtest pipe-A-default-mode: SKIP (0.333s) [457.925046] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.335s) [458.742531] [116/138] (541s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [458.798393] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu [458.802407] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [458.889064] [117/138] (541s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s [458.971920] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size [458.976265] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s) [459.078675] [118/138] (541s left) kms_ccs (pipe-b-ccs-on-another-bo-4-tiled-mtl-rc-ccs) [459.462128] Starting subtest: pipe-B-ccs-on-another-bo-4-tiled-mtl-rc-ccs [459.465168] Subtest pipe-B-ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.000s) [460.329279] [119/138] (540s left) kms_ccs (pipe-b-crc-primary-basic-y-tiled-gen12-rc-ccs-cc) [460.701388] Starting subtest: pipe-B-crc-primary-basic-y-tiled-gen12-rc-ccs-cc [460.706804] Subtest pipe-B-crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s) [461.593085] [120/138] (539s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite) [461.644648] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite [467.009658] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (5.367s) [467.143450] [121/138] (533s left) kms_frontbuffer_tracking (fbc-2p-rte) [467.201340] Starting subtest: fbc-2p-rte [467.206062] Subtest fbc-2p-rte: SKIP (0.000s) [467.284325] [122/138] (533s left) gem_softpin (evict-snoop-interruptible) [467.341098] Starting subtest: evict-snoop-interruptible [467.345653] Subtest evict-snoop-interruptible: SKIP (0.000s) [467.404655] [123/138] (533s left) kms_chamelium_audio (dp-audio) [467.775062] Subtest dp-audio: SKIP (0.000s) [468.674208] [124/138] (532s left) kms_psr2_sf (overlay-plane-move-continuous-sf) [473.905766] Starting subtest: overlay-plane-move-continuous-sf [473.908441] Starting dynamic subtest: pipe-A-eDP-1 [480.671047] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.761s) [480.684521] Starting dynamic subtest: pipe-B-eDP-1 [487.454581] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.781s) [487.457391] Subtest overlay-plane-move-continuous-sf: SUCCESS (13.549s) [488.348348] [125/138] (512s left) kms_invalid_mode (clock-too-high) [488.401309] Starting subtest: clock-too-high [488.403760] Starting dynamic subtest: pipe-A-eDP-1 [488.407847] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [488.421242] Starting dynamic subtest: pipe-B-eDP-1 [488.425402] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [488.433578] Starting dynamic subtest: pipe-C-eDP-1 [488.438449] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [488.452653] Starting dynamic subtest: pipe-D-eDP-1 [488.458067] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [488.463659] Subtest clock-too-high: SKIP (0.003s) [488.493281] [126/138] (512s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move) [488.578399] Starting subtest: psr-1p-primscrn-spr-indfb-move [494.127545] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (5.551s) [494.221361] [127/138] (506s left) gem_fence_thrash (bo-write-verify-x) [494.263703] Starting subtest: bo-write-verify-x [494.273493] Subtest bo-write-verify-x: SKIP (0.001s) [494.292140] [128/138] (506s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-blt) [494.350945] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-blt [499.126728] Subtest fbcpsr-1p-offscren-pri-indfb-draw-blt: SUCCESS (4.779s) [499.268031] [129/138] (501s left) gem_render_copy_redux (normal) [499.328381] Starting subtest: normal [499.636108] Subtest normal: SUCCESS (0.307s) [499.724350] [130/138] (501s left) syncobj_timeline (invalid-query-illegal-handle) [499.760874] Starting subtest: invalid-query-illegal-handle [499.763437] Subtest invalid-query-illegal-handle: SUCCESS (0.000s) [499.821850] [131/138] (501s left) kms_cursor_legacy (cursorb-vs-flipb-atomic) [499.904467] Starting subtest: cursorB-vs-flipB-atomic [499.909554] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s) [500.032275] [132/138] (501s left) kms_draw_crc (fill-fb) [500.102123] Starting subtest: fill-fb [500.588967] Subtest fill-fb: SUCCESS (0.487s) [500.674309] [133/138] (500s left) vc4/vc4_perfmon (get-values-invalid-perfmon) [500.756263] Subtest get-values-invalid-perfmon: SKIP (0.000s) [500.805681] [134/138] (500s left) i915_pm_rc6_residency (rc6-fence) [500.874064] Starting subtest: rc6-fence [524.455845] Subtest rc6-fence: SUCCESS (23.583s) [525.769396] [135/138] (475s left) kms_flip (flip-vs-rmfb) [525.850233] Starting subtest: flip-vs-rmfb [525.855663] Starting dynamic subtest: A-eDP1 [534.611943] Dynamic subtest A-eDP1: SUCCESS (8.757s) [534.625694] Starting dynamic subtest: B-eDP1 [543.380335] Dynamic subtest B-eDP1: SUCCESS (8.766s) [543.394606] Starting dynamic subtest: C-eDP1 [552.137785] Dynamic subtest C-eDP1: SUCCESS (8.756s) [552.151223] Starting dynamic subtest: D-eDP1 [560.906489] Dynamic subtest D-eDP1: SUCCESS (8.766s) [560.913714] Subtest flip-vs-rmfb: SUCCESS (35.068s) [562.149213] [136/138] (439s left) gem_exec_reloc (basic-wc) [562.219445] Subtest basic-wc: SKIP (0.000s) [562.280485] [137/138] (438s left) kms_ccs (pipe-c-ccs-on-another-bo-y-tiled-gen12-rc-ccs) [562.689397] Starting subtest: pipe-C-ccs-on-another-bo-y-tiled-gen12-rc-ccs [562.694969] Subtest pipe-C-ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.000s) [563.560827] [138/138] (437s left) kms_ccs (pipe-d-missing-ccs-buffer-y-tiled-gen12-mc-ccs) [563.964797] Starting subtest: pipe-D-missing-ccs-buffer-y-tiled-gen12-mc-ccs [563.970510] Subtest pipe-D-missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.000s) [564.826352] Closing watchdogs Done.