[47.691463] Initializing watchdogs [47.691704] /dev/watchdog0 [47.725300] [001/168] (960s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled) [48.019897] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled [48.062497] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s) [48.225426] [002/168] (960s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling) [48.578117] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling [48.598980] Starting dynamic subtest: pipe-A-valid-mode [49.367298] Dynamic subtest pipe-A-valid-mode: SKIP (0.778s) [49.409281] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (0.778s) [49.737487] [003/168] (958s left) xe_debugfs (base) [50.220145] Subtest base: SKIP (0.000s) [50.342892] [004/168] (958s left) xe_vm (large-binds-536870912) [50.690460] Subtest large-binds-536870912: SKIP (0.000s) [50.821391] [005/168] (957s left) gem_gpgpu_fill (basic) [51.063111] Starting subtest: basic [51.084982] Starting dynamic subtest: smem [51.106539] Dynamic subtest smem: SUCCESS (0.037s) [51.127040] Subtest basic: SUCCESS (0.038s) [51.226492] [006/168] (957s left) kms_plane (invalid-pixel-format-settings) [51.585544] Starting subtest: invalid-pixel-format-settings [51.606903] Subtest invalid-pixel-format-settings: SUCCESS (0.018s) [51.709645] [007/168] (957s left) kms_flip (flip-vs-panning-interruptible) [52.063878] Starting subtest: flip-vs-panning-interruptible [52.084953] Starting dynamic subtest: A-DP1 [62.847283] Dynamic subtest A-DP1: SUCCESS (10.792s) [62.884040] Starting dynamic subtest: B-DP1 [73.378293] Dynamic subtest B-DP1: SUCCESS (10.489s) [73.412052] Starting dynamic subtest: C-DP1 [83.900527] Dynamic subtest C-DP1: SUCCESS (10.560s) [83.929985] Subtest flip-vs-panning-interruptible: SUCCESS (31.848s) [84.353945] [008/168] (924s left) kms_pwrite_crc [85.644108] [009/168] (923s left) xe_pm (s4-d3hot-basic-exec) [85.980402] Subtest s4-d3hot-basic-exec: SKIP (0.000s) [86.110473] [010/168] (923s left) kms_big_fb (y-tiled-64bpp-rotate-180) [86.507384] Starting subtest: y-tiled-64bpp-rotate-180 [94.229182] Subtest y-tiled-64bpp-rotate-180: SUCCESS (7.752s) [95.239136] [011/168] (914s left) gem_exec_schedule (manyslice) [95.631533] Starting subtest: manyslice [95.651562] Starting dynamic subtest: rcs0 [97.009558] Dynamic subtest rcs0: SUCCESS (1.507s) [97.073868] Starting dynamic subtest: bcs0 [97.816734] Dynamic subtest bcs0: SUCCESS (0.817s) [97.853279] Starting dynamic subtest: vcs0 [98.593596] Dynamic subtest vcs0: SUCCESS (0.773s) [98.629729] Starting dynamic subtest: vecs0 [99.366148] Dynamic subtest vecs0: SUCCESS (0.773s) [99.387171] Subtest manyslice: SUCCESS (3.872s) [99.716955] [012/168] (909s left) kms_cursor_crc (cursor-offscreen-32x10) [100.070824] Starting subtest: cursor-offscreen-32x10 [100.274609] Subtest cursor-offscreen-32x10: SKIP (0.168s) [100.376870] [013/168] (909s left) gem_workarounds (suspend-resume-context) [100.669464] Starting subtest: suspend-resume-context [118.335059] Subtest suspend-resume-context: SUCCESS (1.487s) [124.466833] [014/168] (907s left) kms_flip (modeset-vs-vblank-race-interruptible) [124.814004] Starting subtest: modeset-vs-vblank-race-interruptible [124.832789] Starting dynamic subtest: A-DP1 [128.994000] Dynamic subtest A-DP1: SUCCESS (4.200s) [129.028676] Starting dynamic subtest: B-DP1 [133.177784] Dynamic subtest B-DP1: SUCCESS (4.156s) [133.221938] Starting dynamic subtest: C-DP1 [137.285214] Dynamic subtest C-DP1: SUCCESS (4.121s) [137.306902] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (12.486s) [137.732251] [015/168] (894s left) gem_mmap_wc (bad-size) [138.023592] Starting subtest: bad-size [138.042373] Subtest bad-size: SUCCESS (0.002s) [138.157412] [016/168] (893s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt) [138.579160] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt [138.615633] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [138.734580] [017/168] (893s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [139.119485] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt [139.162877] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [139.272964] [018/168] (892s left) prime_mmap_coherency (read) [139.524765] Starting subtest: read [144.928003] Subtest read: SUCCESS (5.408s) [145.087689] [019/168] (887s left) feature_discovery (psr2) [145.420978] Starting subtest: psr2 [145.458201] Subtest psr2: SKIP (0.000s) [145.574547] [020/168] (886s left) kms_vblank (pipe-a-ts-continuation-idle) [145.913690] Starting subtest: pipe-A-ts-continuation-idle [146.171476] Subtest pipe-A-ts-continuation-idle: SUCCESS (0.250s) [146.526472] [021/168] (885s left) kms_vblank (pipe-d-ts-continuation-dpms-suspend) [146.877155] Subtest pipe-D-ts-continuation-dpms-suspend: SKIP (0.000s) [147.030467] [022/168] (885s left) xe_exec_fault_mode (twice-bindengine-imm) [147.343509] Subtest twice-bindengine-imm: SKIP (0.000s) [147.450676] [023/168] (885s left) syncobj_timeline (invalid-signal-one-illegal-handle) [147.700053] Starting subtest: invalid-signal-one-illegal-handle [147.718817] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.001s) [147.832231] [024/168] (884s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted) [148.069534] Starting subtest: etime-single-wait-all-for-submit-unsubmitted [148.162222] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.101s) [148.287140] [025/168] (884s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa [148.528551] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled [148.547440] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.002s) [148.658632] [026/168] (884s left) kms_addfb_basic (small-bo) [148.996763] Starting subtest: small-bo [149.017779] Subtest small-bo: SUCCESS (0.000s) [149.319196] [027/168] (883s left) xe_exec_threads (threads-mixed-fd-userptr-invalidate-race) [149.627166] Subtest threads-mixed-fd-userptr-invalidate-race: SKIP (0.000s) [149.740233] [028/168] (883s left) xe_exec_basic (once-userptr-invalidate) [150.032423] Subtest once-userptr-invalidate: SKIP (0.000s) [150.137073] [029/168] (883s left) device_reset (unbind-reset-rebind) [150.416084] Starting subtest: unbind-reset-rebind [151.243657] Subtest unbind-reset-rebind: SUCCESS (0.843s) [151.858164] [030/168] (881s left) kms_big_fb (4-tiled-8bpp-rotate-90) [152.258943] Starting subtest: 4-tiled-8bpp-rotate-90 [152.302224] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.000s) [152.411632] [031/168] (880s left) gem_userptr_blits (coherency-unsync) [152.741195] Subtest coherency-unsync: SKIP (0.000s) [152.863569] [032/168] (880s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt) [153.251737] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt [153.289886] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [153.407261] [033/168] (880s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite) [153.795319] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite [153.838265] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [153.949258] [034/168] (879s left) kms_big_fb (yf-tiled-32bpp-rotate-0) [154.319879] Starting subtest: yf-tiled-32bpp-rotate-0 [159.498663] Subtest yf-tiled-32bpp-rotate-0: SUCCESS (5.191s) [160.100923] [035/168] (873s left) kms_flip (2x-plain-flip) [160.475221] Starting subtest: 2x-plain-flip [160.528523] Subtest 2x-plain-flip: SKIP (0.003s) [160.666283] [036/168] (873s left) gem_exec_balancer (hog) [160.942271] Starting subtest: hog [164.778358] Subtest hog: SUCCESS (3.645s) [168.623829] [037/168] (865s left) gem_ctx_persistence (heartbeat-stop) [168.865612] Starting subtest: heartbeat-stop [169.037296] Subtest heartbeat-stop: SUCCESS (0.164s) [169.169994] [038/168] (864s left) gem_ctx_param (set-priority-invalid-size) [169.449509] Starting subtest: set-priority-invalid-size [169.470675] Subtest set-priority-invalid-size: SUCCESS (0.000s) [169.578583] [039/168] (864s left) kms_big_fb (4-tiled-32bpp-rotate-0) [169.975283] Starting subtest: 4-tiled-32bpp-rotate-0 [170.016349] Subtest 4-tiled-32bpp-rotate-0: SKIP (0.000s) [170.122504] [040/168] (864s left) xe_exec_fault_mode (once-bindengine) [170.425631] Subtest once-bindengine: SKIP (0.000s) [170.538170] [041/168] (863s left) i915_pm_rpm (gem-execbuf) [172.365794] Starting subtest: gem-execbuf [172.386921] Starting dynamic subtest: smem0 [174.261640] Dynamic subtest smem0: SUCCESS (1.896s) [174.281000] Subtest gem-execbuf: SUCCESS (1.898s) [174.778960] [042/168] (859s left) kms_cursor_crc (cursor-sliding-64x21) [175.134810] Starting subtest: cursor-sliding-64x21 [175.153503] Starting dynamic subtest: pipe-A-DP-1 [178.769696] Dynamic subtest pipe-A-DP-1: SUCCESS (3.634s) [178.855487] Starting dynamic subtest: pipe-B-DP-1 [182.600837] Dynamic subtest pipe-B-DP-1: SUCCESS (3.754s) [182.713008] Starting dynamic subtest: pipe-C-DP-1 [186.430080] Dynamic subtest pipe-C-DP-1: SUCCESS (3.763s) [186.450904] Subtest cursor-sliding-64x21: SUCCESS (11.308s) [186.818696] [043/168] (847s left) perf_pmu (semaphore-busy) [187.063142] Starting subtest: semaphore-busy [187.081771] Starting dynamic subtest: rcs0 [188.645878] Dynamic subtest rcs0: SUCCESS (1.567s) [188.683042] Starting dynamic subtest: bcs0 [190.207899] Dynamic subtest bcs0: SUCCESS (1.560s) [190.245105] Starting dynamic subtest: vcs0 [191.774219] Dynamic subtest vcs0: SUCCESS (1.564s) [191.811375] Starting dynamic subtest: vecs0 [193.336586] Dynamic subtest vecs0: SUCCESS (1.558s) [193.355671] Subtest semaphore-busy: SUCCESS (6.258s) [193.451287] [044/168] (841s left) gem_wait (write-wait) [193.714084] Starting subtest: write-wait [193.733111] Starting dynamic subtest: all-engines [194.892503] Dynamic subtest all-engines: SUCCESS (1.156s) [194.936128] Starting dynamic subtest: rcs0 [195.930658] Dynamic subtest rcs0: SUCCESS (1.032s) [195.975822] Starting dynamic subtest: bcs0 [196.959967] Dynamic subtest bcs0: SUCCESS (1.034s) [197.002471] Starting dynamic subtest: vcs0 [198.006254] Dynamic subtest vcs0: SUCCESS (1.027s) [198.053045] Starting dynamic subtest: vecs0 [199.017254] Dynamic subtest vecs0: SUCCESS (1.030s) [199.040635] Subtest write-wait: SUCCESS (5.285s) [199.274172] [045/168] (835s left) gem_exec_balancer (parallel) [203.503872] Subtest parallel: SKIP (0.000s) [203.609765] [046/168] (831s left) xe_exec_balancer (twice-cm-virtual-userptr-invalidate) [203.922952] Subtest twice-cm-virtual-userptr-invalidate: SKIP (0.000s) [204.033779] [047/168] (831s left) kms_hdr (bpc-switch-suspend) [204.361047] Starting subtest: bpc-switch-suspend [206.598419] Starting dynamic subtest: pipe-A-DP-1 [224.638416] Dynamic subtest pipe-A-DP-1: SUCCESS (2.427s) [224.657523] Subtest bpc-switch-suspend: SUCCESS (4.664s) [231.030314] [048/168] (825s left) xe_evict (evict-beng-small) [231.357875] Subtest evict-beng-small: SKIP (0.000s) [231.454071] [049/168] (825s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling) [231.784448] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling [231.805924] Starting dynamic subtest: pipe-A-valid-mode [232.519378] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.718s) [232.539320] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SUCCESS (0.720s) [232.882969] [050/168] (824s left) kms_flip (plain-flip-ts-check) [233.234803] Starting subtest: plain-flip-ts-check [233.253513] Starting dynamic subtest: A-DP1 [244.190369] Dynamic subtest A-DP1: SUCCESS (10.783s) [244.239549] Starting dynamic subtest: B-DP1 [254.745365] Dynamic subtest B-DP1: SUCCESS (10.734s) [254.783457] Starting dynamic subtest: C-DP1 [265.469270] Dynamic subtest C-DP1: SUCCESS (10.720s) [265.488418] Subtest plain-flip-ts-check: SUCCESS (32.246s) [265.886119] [051/168] (791s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt) [266.275998] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt [266.318052] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [266.430423] [052/168] (790s left) xe_exec_balancer (twice-parallel-userptr-rebind) [266.734908] Subtest twice-parallel-userptr-rebind: SKIP (0.000s) [266.849435] [053/168] (790s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180) [267.215221] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180 [268.597409] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.399s) [268.761320] [054/168] (788s left) i915_query (engine-info) [269.013350] Starting subtest: engine-info [269.033853] Subtest engine-info: SUCCESS (0.003s) [269.122190] [055/168] (788s left) xe_exec_fault_mode (twice-userptr-invalidate-imm) [269.433822] Subtest twice-userptr-invalidate-imm: SKIP (0.000s) [269.527149] [056/168] (787s left) kms_vblank (pipe-b-ts-continuation-modeset-hang) [269.835504] Starting subtest: pipe-B-ts-continuation-modeset-hang [277.315865] Subtest pipe-B-ts-continuation-modeset-hang: SUCCESS (7.468s) [277.669263] [057/168] (779s left) xe_exec_balancer (many-engines-parallel-basic) [277.973855] Subtest many-engines-parallel-basic: SKIP (0.000s) [278.090142] [058/168] (779s left) drm_fdinfo (busy-check-all) [278.338030] Starting subtest: busy-check-all [278.357303] Starting dynamic subtest: rcs0 [278.885462] Dynamic subtest rcs0: SUCCESS (0.529s) [278.928553] Starting dynamic subtest: bcs0 [279.415328] Dynamic subtest bcs0: SUCCESS (0.531s) [279.462894] Starting dynamic subtest: vcs0 [279.952450] Dynamic subtest vcs0: SUCCESS (0.528s) [279.994616] Starting dynamic subtest: vecs0 [280.488554] Dynamic subtest vecs0: SUCCESS (0.531s) [280.512400] Subtest busy-check-all: SUCCESS (2.123s) [280.624537] [059/168] (777s left) kms_addfb_basic (invalid-smem-bo-on-discrete) [280.884678] Starting subtest: invalid-smem-bo-on-discrete [280.929412] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s) [281.326732] [060/168] (776s left) xe_exec_threads (threads-cm-fd-rebind) [281.661562] Subtest threads-cm-fd-rebind: SKIP (0.000s) [281.786409] [061/168] (776s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu) [282.233885] Starting subtest: fbc-rgb101010-draw-mmap-cpu [284.909212] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.655s) [285.013069] [062/168] (773s left) kms_vblank (pipe-a-accuracy-idle) [285.363685] Starting subtest: pipe-A-accuracy-idle [287.628323] Subtest pipe-A-accuracy-idle: SUCCESS (2.274s) [288.013527] [063/168] (770s left) gem_exec_schedule (submit-late-slice) [288.454973] Starting subtest: submit-late-slice [288.477351] Starting dynamic subtest: rcs0 [288.499108] Dynamic subtest rcs0: SUCCESS (0.055s) [288.540680] Starting dynamic subtest: bcs0 [288.565282] Dynamic subtest bcs0: SUCCESS (0.049s) [288.612099] Starting dynamic subtest: vcs0 [288.637059] Dynamic subtest vcs0: SUCCESS (0.044s) [288.682720] Starting dynamic subtest: vecs0 [288.707761] Dynamic subtest vecs0: SUCCESS (0.047s) [288.732290] Subtest submit-late-slice: SUCCESS (0.202s) [288.868202] [064/168] (769s left) xe_exec_reset (close-fd) [289.179668] Subtest close-fd: SKIP (0.000s) [289.286786] [065/168] (769s left) xe_vm (munmap-style-unbind-either-side-partial-hammer) [289.587041] Subtest munmap-style-unbind-either-side-partial-hammer: SKIP (0.000s) [289.691422] [066/168] (768s left) kms_atomic_interruptible (universal-setplane-primary) [290.027861] Starting subtest: universal-setplane-primary [290.053711] Starting dynamic subtest: DP-1-pipe-A [296.567568] Dynamic subtest DP-1-pipe-A: SUCCESS (6.518s) [296.590597] Subtest universal-setplane-primary: SUCCESS (6.520s) [296.923651] [067/168] (761s left) xe_vm (large-misaligned-binds-33554432) [297.248768] Subtest large-misaligned-binds-33554432: SKIP (0.000s) [297.381853] [068/168] (761s left) xe_exec_compute_mode (many-preempt-fence-early) [297.690162] Subtest many-preempt-fence-early: SKIP (0.000s) [297.791927] [069/168] (761s left) kms_big_fb (x-tiled-32bpp-rotate-180) [298.194286] Starting subtest: x-tiled-32bpp-rotate-180 [302.851948] Subtest x-tiled-32bpp-rotate-180: SUCCESS (4.703s) [303.422588] [070/168] (755s left) gem_pxp (protected-encrypted-src-copy-not-readible) [306.411450] Subtest protected-encrypted-src-copy-not-readible: SKIP (0.000s) [306.558958] [071/168] (752s left) gem_exec_fence (syncobj-repeat) [307.267454] Starting subtest: syncobj-repeat [308.109107] Subtest syncobj-repeat: SUCCESS (0.862s) [308.484710] [072/168] (750s left) kms_lease (lease_invalid_plane) [308.825578] Starting subtest: lease_invalid_plane [308.846095] Starting dynamic subtest: pipe-A-DP-1 [308.982331] Dynamic subtest pipe-A-DP-1: SUCCESS (0.152s) [309.029719] Starting dynamic subtest: pipe-B-DP-1 [309.051199] Dynamic subtest pipe-B-DP-1: SUCCESS (0.015s) [309.090945] Starting dynamic subtest: pipe-C-DP-1 [309.109628] Dynamic subtest pipe-C-DP-1: SUCCESS (0.015s) [309.127954] Subtest lease_invalid_plane: SUCCESS (0.185s) [309.366788] [073/168] (749s left) vgem_basic (mmap) [309.632089] Starting subtest: mmap [309.650681] Subtest mmap: SUCCESS (0.028s) [309.769296] [074/168] (749s left) xe_vm (large-userptr-binds-33554432) [310.078659] Subtest large-userptr-binds-33554432: SKIP (0.000s) [310.187449] [075/168] (749s left) kms_cursor_legacy (single-move) [310.528410] Starting subtest: single-move [310.550594] Starting dynamic subtest: pipe-A [332.055664] Dynamic subtest pipe-A: SUCCESS (21.505s) [332.096878] Starting dynamic subtest: pipe-B [353.550187] Dynamic subtest pipe-B: SUCCESS (21.503s) [353.589248] Starting dynamic subtest: pipe-C [375.228849] Dynamic subtest pipe-C: SUCCESS (21.503s) [375.270610] Starting dynamic subtest: all-pipes [396.758770] Dynamic subtest all-pipes: SUCCESS (21.505s) [396.780028] Subtest single-move: SUCCESS (86.022s) [396.873189] [076/168] (662s left) kms_cursor_crc (cursor-rapid-movement-128x128) [397.204806] Starting subtest: cursor-rapid-movement-128x128 [397.223466] Starting dynamic subtest: pipe-A-DP-1 [397.717558] Dynamic subtest pipe-A-DP-1: SUCCESS (0.482s) [397.787265] Starting dynamic subtest: pipe-B-DP-1 [398.341552] Dynamic subtest pipe-B-DP-1: SUCCESS (0.570s) [398.412796] Starting dynamic subtest: pipe-C-DP-1 [398.978572] Dynamic subtest pipe-C-DP-1: SUCCESS (0.584s) [398.998061] Subtest cursor-rapid-movement-128x128: SUCCESS (1.765s) [399.359143] [077/168] (660s left) prime_mmap (test_errors) [399.611909] Starting subtest: test_errors [399.632649] Starting dynamic subtest: test_errors-smem [399.653195] Dynamic subtest test_errors-smem: SUCCESS (0.018s) [399.671932] Subtest test_errors: SUCCESS (0.020s) [399.783366] [078/168] (659s left) xe_exec_fault_mode (many-bindengine-userptr-invalidate) [400.085090] Subtest many-bindengine-userptr-invalidate: SKIP (0.000s) [400.199092] [079/168] (659s left) kms_vblank (pipe-d-ts-continuation-modeset-rpm) [400.536576] Subtest pipe-D-ts-continuation-modeset-rpm: SKIP (0.000s) [400.729122] [080/168] (659s left) gem_softpin (evict-prime) [400.989305] Starting subtest: evict-prime [401.015745] Starting dynamic subtest: rcs0 [402.104008] Dynamic subtest rcs0: SUCCESS (1.123s) [402.173062] Starting dynamic subtest: bcs0 [403.232203] Dynamic subtest bcs0: SUCCESS (1.118s) [403.309108] Starting dynamic subtest: vcs0 [404.336836] Dynamic subtest vcs0: SUCCESS (1.115s) [404.398161] Starting dynamic subtest: vecs0 [405.454147] Dynamic subtest vecs0: SUCCESS (1.115s) [405.522664] Starting dynamic subtest: all [406.568428] Dynamic subtest all: SUCCESS (1.111s) [406.589141] Subtest evict-prime: SUCCESS (5.590s) [406.684351] [081/168] (653s left) kms_ccs (pipe-c-crc-primary-basic-y_tiled_ccs) [407.161088] Starting subtest: pipe-C-crc-primary-basic-y_tiled_ccs [407.198751] Subtest pipe-C-crc-primary-basic-y_tiled_ccs: SKIP (0.001s) [407.533048] [082/168] (652s left) kms_chamelium_hpd (vga-hpd-without-ddc) [407.986631] Subtest vga-hpd-without-ddc: SKIP (0.000s) [408.316975] [083/168] (651s left) gem_reg_read (bad-register) [408.559372] Starting subtest: bad-register [408.580336] Subtest bad-register: SUCCESS (0.000s) [408.693090] [084/168] (651s left) gem_exec_suspend (basic-s0) [408.974588] Starting subtest: basic-S0 [408.993678] Starting dynamic subtest: smem [429.949904] Dynamic subtest smem: SUCCESS (20.980s) [429.971514] Subtest basic-S0: SUCCESS (20.982s) [436.199127] [085/168] (630s left) api_intel_bb (blit-reloc-purge-cache) [436.436930] Starting subtest: blit-reloc-purge-cache [436.455577] Subtest blit-reloc-purge-cache: SUCCESS (0.022s) [436.584698] [086/168] (629s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render) [436.967501] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render [437.009943] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [437.125899] [087/168] (629s left) kms_vblank (crtc-id) [437.439820] Starting subtest: crtc-id [437.741796] Subtest crtc-id: SUCCESS (0.294s) [438.105643] [088/168] (628s left) xe_exec_threads (threads-shared-vm-userptr-rebind-err) [438.420569] Subtest threads-shared-vm-userptr-rebind-err: SKIP (0.000s) [438.537612] [089/168] (628s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_dg2_mc_ccs) [439.004418] Subtest pipe-D-crc-primary-rotation-180-4_tiled_dg2_mc_ccs: SKIP (0.000s) [439.348307] [090/168] (627s left) kms_chamelium_color (ctm-0-25) [439.704811] Subtest ctm-0-25: SKIP (0.000s) [439.826120] [091/168] (627s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [440.154585] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [440.173334] Starting dynamic subtest: pipe-A-valid-mode [440.286684] Dynamic subtest pipe-A-valid-mode: SKIP (0.106s) [440.326989] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.108s) [440.642461] [092/168] (626s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite) [441.055312] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite [441.092033] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [441.207973] [093/168] (626s left) gem_exec_reloc (basic-concurrent0) [441.480363] Starting subtest: basic-concurrent0 [447.163092] Subtest basic-concurrent0: SUCCESS (5.441s) [447.280740] [094/168] (620s left) xe_vm (munmap-style-unbind-userptr-inval-front) [447.592222] Subtest munmap-style-unbind-userptr-inval-front: SKIP (0.000s) [447.684757] [095/168] (619s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt) [448.096852] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt [448.133742] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [448.251280] [096/168] (619s left) kms_psr (cursor_render) [448.521329] Subtest cursor_render: SKIP (0.000s) [448.615995] [097/168] (619s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [448.925415] Starting subtest: basic-busy-flip-before-cursor-atomic [448.962332] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [449.080856] [098/168] (618s left) kms_addfb_basic (bad-pitch-128) [449.317112] Starting subtest: bad-pitch-128 [449.338587] Subtest bad-pitch-128: SUCCESS (0.000s) [449.739103] [099/168] (618s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90) [450.052368] Starting subtest: primary-yf-tiled-reflect-x-90 [450.094295] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s) [450.207766] [100/168] (617s left) kms_chamelium_hpd (vga-hpd-for-each-pipe) [450.655002] Subtest vga-hpd-for-each-pipe: SKIP (0.000s) [450.944085] [101/168] (617s left) kms_vblank (pipe-c-query-idle) [451.271135] Starting subtest: pipe-C-query-idle [453.842630] Subtest pipe-C-query-idle: SUCCESS (2.572s) [454.213583] [102/168] (614s left) gem_madvise (dontneed-before-mmap) [454.480401] Starting subtest: dontneed-before-mmap [454.499318] Subtest dontneed-before-mmap: SUCCESS (0.013s) [454.636320] [103/168] (613s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [455.021693] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [455.059495] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [455.195864] [104/168] (613s left) gem_userptr_blits (readonly-pwrite-unsync) [455.549976] Subtest readonly-pwrite-unsync: SKIP (0.000s) [455.685075] [105/168] (612s left) kms_chamelium_frames (hdmi-cmp-planar-formats) [456.147036] Subtest hdmi-cmp-planar-formats: SKIP (0.000s) [456.467707] [106/168] (612s left) xe_exec_threads (threads-hang-fd-userptr) [456.776971] Subtest threads-hang-fd-userptr: SKIP (0.000s) [456.900732] [107/168] (611s left) xe_vm (large-userptr-split-misaligned-binds-268435456) [457.220766] Subtest large-userptr-split-misaligned-binds-268435456: SKIP (0.000s) [457.337814] [108/168] (611s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75) [457.680605] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75 [457.699749] Starting dynamic subtest: pipe-A-DP-1 [457.864959] Dynamic subtest pipe-A-DP-1: SUCCESS (0.193s) [457.906190] Starting dynamic subtest: pipe-B-DP-1 [458.279188] Dynamic subtest pipe-B-DP-1: SUCCESS (0.402s) [458.322990] Starting dynamic subtest: pipe-C-DP-1 [458.418455] Dynamic subtest pipe-C-DP-1: SKIP (0.122s) [458.441500] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SUCCESS (0.721s) [458.847211] [109/168] (610s left) kms_addfb_basic (clobberred-modifier) [459.083775] Starting subtest: clobberred-modifier [459.104846] Subtest clobberred-modifier: SUCCESS (0.000s) [459.505743] [110/168] (609s left) gem_set_tiling_vs_gtt [460.171079] [111/168] (609s left) sysfs_preempt_timeout (invalid) [460.424617] Starting subtest: invalid [460.443685] Starting dynamic subtest: vecs0 [460.463195] Dynamic subtest vecs0: SUCCESS (0.001s) [460.503036] Starting dynamic subtest: vcs0 [460.522953] Dynamic subtest vcs0: SUCCESS (0.001s) [460.565190] Starting dynamic subtest: bcs0 [460.586132] Dynamic subtest bcs0: SUCCESS (0.001s) [460.627806] Starting dynamic subtest: rcs0 [460.647495] Dynamic subtest rcs0: SUCCESS (0.001s) [460.666088] Subtest invalid: SUCCESS (0.012s) [460.778093] [112/168] (608s left) kms_psr2_sf (overlay-plane-update-sf-dmg-area) [461.047226] Subtest overlay-plane-update-sf-dmg-area: SKIP (0.000s) [461.164791] [113/168] (608s left) perf_pmu (busy-no-semaphores) [461.405300] Starting subtest: busy-no-semaphores [461.426703] Starting dynamic subtest: rcs0 [461.902894] Dynamic subtest rcs0: SUCCESS (0.519s) [461.943736] Starting dynamic subtest: bcs0 [462.420179] Dynamic subtest bcs0: SUCCESS (0.518s) [462.460859] Starting dynamic subtest: vcs0 [462.941164] Dynamic subtest vcs0: SUCCESS (0.516s) [462.983720] Starting dynamic subtest: vecs0 [463.458424] Dynamic subtest vecs0: SUCCESS (0.515s) [463.477478] Subtest busy-no-semaphores: SUCCESS (2.076s) [463.592542] [114/168] (605s left) syncobj_wait (invalid-wait-bad-flags) [463.837585] Starting subtest: invalid-wait-bad-flags [463.856346] Subtest invalid-wait-bad-flags: SUCCESS (0.000s) [463.953184] [115/168] (605s left) xe_exec_fault_mode (many-userptr-prefetch) [464.266416] Subtest many-userptr-prefetch: SKIP (0.000s) [464.359529] [116/168] (605s left) gem_mmap_gtt (basic-write-gtt) [464.611418] Starting subtest: basic-write-gtt [465.345260] Subtest basic-write-gtt: SUCCESS (0.749s) [465.487079] [117/168] (604s left) v3d/v3d_perfmon (get-values-invalid-pad) [465.789145] Subtest get-values-invalid-pad: SKIP (0.000s) [465.886452] [118/168] (604s left) i915_pm_rpm (system-suspend-devices) [467.793638] Starting subtest: system-suspend-devices [474.360400] Subtest system-suspend-devices: SUCCESS (6.567s) [479.842095] [119/168] (595s left) kms_ccs (pipe-b-bad-aux-stride-y_tiled_gen12_rc_ccs) [480.302898] Starting subtest: pipe-B-bad-aux-stride-y_tiled_gen12_rc_ccs [480.343590] Subtest pipe-B-bad-aux-stride-y_tiled_gen12_rc_ccs: SKIP (0.000s) [480.687409] [120/168] (594s left) xe_exec_compute_mode (twice-rebind) [481.009132] Subtest twice-rebind: SKIP (0.000s) [481.121976] [121/168] (594s left) gem_ctx_shared (exec-single-timeline) [481.399101] Starting subtest: exec-single-timeline [481.418319] Starting dynamic subtest: rcs0 [482.456578] Dynamic subtest rcs0: SUCCESS (1.075s) [482.501830] Starting dynamic subtest: bcs0 [483.544856] Dynamic subtest bcs0: SUCCESS (1.084s) [483.591333] Starting dynamic subtest: vcs0 [484.630434] Dynamic subtest vcs0: SUCCESS (1.086s) [484.676339] Starting dynamic subtest: vecs0 [485.717687] Dynamic subtest vecs0: SUCCESS (1.087s) [485.739072] Subtest exec-single-timeline: SUCCESS (4.338s) [485.965465] [122/168] (589s left) gen9_exec_parse (batch-zero-length) [486.238332] Starting subtest: batch-zero-length [486.259006] Subtest batch-zero-length: SUCCESS (0.002s) [486.466289] [123/168] (588s left) syncobj_wait (single-wait-submitted) [486.707033] Starting subtest: single-wait-submitted [486.805094] Subtest single-wait-submitted: SUCCESS (0.106s) [486.924063] [124/168] (588s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-pwrite) [487.307165] Starting subtest: psr-1p-offscren-pri-indfb-draw-pwrite [487.349598] Subtest psr-1p-offscren-pri-indfb-draw-pwrite: SKIP (0.000s) [487.465306] [125/168] (588s left) kms_ccs (pipe-d-bad-rotation-90-y_tiled_ccs) [487.956213] Subtest pipe-D-bad-rotation-90-y_tiled_ccs: SKIP (0.000s) [488.291198] [126/168] (587s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt) [488.679853] Starting subtest: psr-1p-primscrn-indfb-plflip-blt [488.716724] Subtest psr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s) [488.837767] [127/168] (586s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite) [489.225515] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite [489.268022] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [489.383493] [128/168] (586s left) xe_exec_fault_mode (many-engines-bindengine-userptr-invalidate-race-prefetch) [489.692334] Subtest many-engines-bindengine-userptr-invalidate-race-prefetch: SKIP (0.000s) [489.806051] [129/168] (586s left) kms_ccs (pipe-d-bad-aux-stride-y_tiled_ccs) [490.287538] Subtest pipe-D-bad-aux-stride-y_tiled_ccs: SKIP (0.000s) [490.652528] [130/168] (585s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite) [491.054860] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite [491.108594] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [491.243316] [131/168] (584s left) gem_create (create-size-update) [491.511198] Starting subtest: create-size-update [491.534872] Subtest create-size-update: SUCCESS (0.000s) [491.828719] [132/168] (584s left) syncobj_timeline (32bits-limit) [492.088316] Starting subtest: 32bits-limit [492.112683] Subtest 32bits-limit: SUCCESS (0.002s) [492.246140] [133/168] (584s left) syncobj_timeline (wait-all-complex) [492.508550] Starting subtest: wait-all-complex [492.710798] Subtest wait-all-complex: SUCCESS (0.217s) [492.852753] [134/168] (583s left) vc4/vc4_perfmon (create-perfmon-0) [493.221912] Subtest create-perfmon-0: SKIP (0.000s) [493.337701] [135/168] (583s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_dg2_rc_ccs_cc) [493.779436] Starting subtest: pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs_cc [493.822217] Subtest pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.001s) [494.179082] [136/168] (582s left) xe_exec_basic (many-engines-bindengine-userptr) [494.458777] Subtest many-engines-bindengine-userptr: SKIP (0.000s) [494.577030] [137/168] (582s left) kms_psr (psr2_suspend) [494.836422] Subtest psr2_suspend: SKIP (0.000s) [494.948761] [138/168] (582s left) gem_render_copy_redux (flink) [495.217865] Starting subtest: flink [499.715040] Subtest flink: SUCCESS (4.506s) [499.858894] [139/168] (577s left) v3d/v3d_submit_cl (multisync-out-syncs) [500.168498] Subtest multisync-out-syncs: SKIP (0.000s) [500.259160] [140/168] (576s left) gem_exec_capture (pi) [500.515578] Starting subtest: pi [500.534561] Starting dynamic subtest: rcs0 [530.624473] Dynamic subtest rcs0: SUCCESS (30.132s) [530.666194] Starting dynamic subtest: bcs0 [560.565445] Dynamic subtest bcs0: SUCCESS (29.943s) [560.606388] Starting dynamic subtest: vcs0 [589.798623] Dynamic subtest vcs0: SUCCESS (29.232s) [589.842866] Starting dynamic subtest: vecs0 [619.121361] Dynamic subtest vecs0: SUCCESS (29.320s) [619.139984] Subtest pi: SUCCESS (118.632s) [619.252573] [141/168] (457s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling) [619.742587] Starting subtest: planes-downscale-factor-0-5-unity-scaling [619.761364] Starting dynamic subtest: pipe-A-DP-1 [620.407059] Dynamic subtest pipe-A-DP-1: SUCCESS (0.654s) [620.449161] Starting dynamic subtest: pipe-B-DP-1 [620.826932] Dynamic subtest pipe-B-DP-1: SUCCESS (0.425s) [620.870331] Starting dynamic subtest: pipe-C-DP-1 [621.261447] Dynamic subtest pipe-C-DP-1: SUCCESS (0.423s) [621.280313] Subtest planes-downscale-factor-0-5-unity-scaling: SUCCESS (1.506s) [621.685489] [142/168] (455s left) kms_ccs (pipe-c-bad-pixel-format-y_tiled_gen12_rc_ccs) [622.161918] Starting subtest: pipe-C-bad-pixel-format-y_tiled_gen12_rc_ccs [622.200024] Subtest pipe-C-bad-pixel-format-y_tiled_gen12_rc_ccs: SKIP (0.000s) [622.548688] [143/168] (454s left) xe_exec_basic (once-bindengine-userptr) [622.912680] Subtest once-bindengine-userptr: SKIP (0.000s) [623.022455] [144/168] (454s left) kms_ccs (pipe-a-bad-pixel-format-4_tiled_dg2_rc_ccs) [623.351168] Starting subtest: pipe-A-bad-pixel-format-4_tiled_dg2_rc_ccs [623.393372] Subtest pipe-A-bad-pixel-format-4_tiled_dg2_rc_ccs: SKIP (0.000s) [623.854422] [145/168] (453s left) kms_ccs (pipe-b-bad-aux-stride-yf_tiled_ccs) [624.305775] Starting subtest: pipe-B-bad-aux-stride-yf_tiled_ccs [624.327476] Subtest pipe-B-bad-aux-stride-yf_tiled_ccs: SUCCESS (0.001s) [624.713755] [146/168] (453s left) gem_userptr_blits (unsync-overlap) [625.077644] Subtest unsync-overlap: SKIP (0.000s) [625.207115] [147/168] (452s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs) [625.651912] Starting subtest: pipe-B-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs [625.690980] Subtest pipe-B-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs: SKIP (0.005s) [626.029319] [148/168] (451s left) gem_exec_reloc (basic-range-active) [626.271588] Starting subtest: basic-range-active [626.362779] Subtest basic-range-active: SUCCESS (0.086s) [626.596079] [149/168] (451s left) kms_frontbuffer_tracking (psr-rgb565-draw-render) [627.015040] Starting subtest: psr-rgb565-draw-render [627.056304] Subtest psr-rgb565-draw-render: SKIP (0.000s) [627.172743] [150/168] (451s left) xe_exec_reset (virtual-close-fd-no-exec) [627.496674] Subtest virtual-close-fd-no-exec: SKIP (0.000s) [627.610659] [151/168] (450s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled) [627.852473] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [627.870910] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s) [627.989389] [152/168] (450s left) vc4/vc4_tiling (get-bad-modifier) [628.306621] Subtest get-bad-modifier: SKIP (0.000s) [628.418564] [153/168] (450s left) i915_module_load (reload-with-fault-injection) [628.665887] Starting subtest: reload-with-fault-injection [634.509365] Subtest reload-with-fault-injection: SUCCESS (5.860s) [634.617512] [154/168] (444s left) kms_flip (dpms-off-confusion-interruptible) [637.873735] Starting subtest: dpms-off-confusion-interruptible [637.899010] Starting dynamic subtest: A-DP1 [648.632070] Dynamic subtest A-DP1: SUCCESS (10.581s) [648.671804] Starting dynamic subtest: B-DP1 [659.045935] Dynamic subtest B-DP1: SUCCESS (10.426s) [659.097491] Starting dynamic subtest: C-DP1 [669.463742] Dynamic subtest C-DP1: SUCCESS (10.424s) [669.485002] Subtest dpms-off-confusion-interruptible: SUCCESS (31.441s) [669.762564] [155/168] (409s left) xe_mmio (mmio-invalid) [670.120124] Subtest mmio-invalid: SKIP (0.000s) [670.227571] [156/168] (408s left) gem_mmap_gtt (cpuset-big-copy-odd) [670.454319] Starting subtest: cpuset-big-copy-odd [694.115302] Subtest cpuset-big-copy-odd: SUCCESS (23.676s) [694.338487] [157/168] (384s left) xe_exec_balancer (many-cm-virtual-userptr-invalidate-race) [694.818523] Subtest many-cm-virtual-userptr-invalidate-race: SKIP (0.000s) [694.913567] [158/168] (384s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip) [695.326049] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip [695.439088] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.089s) [695.557111] [159/168] (383s left) kms_concurrent (pipe-c) [695.921400] Starting subtest: pipe-C [695.942956] Starting dynamic subtest: DP-1 [696.682438] Dynamic subtest DP-1: SUCCESS (0.774s) [696.703955] Subtest pipe-C: SUCCESS (0.775s) [697.046566] [160/168] (382s left) gem_userptr_blits (mmap-offset-banned) [697.401831] Starting subtest: mmap-offset-banned [697.423335] Starting dynamic subtest: gtt [697.444545] Dynamic subtest gtt: SUCCESS (0.001s) [697.485087] Starting dynamic subtest: wb [697.504256] Dynamic subtest wb: SUCCESS (0.001s) [697.542734] Starting dynamic subtest: wc [697.561275] Dynamic subtest wc: SUCCESS (0.001s) [697.599705] Starting dynamic subtest: uc [697.621127] Dynamic subtest uc: SUCCESS (0.001s) [697.642610] Subtest mmap-offset-banned: SUCCESS (0.008s) [697.755874] [161/168] (381s left) tools_test (tools_test) [698.138166] Starting subtest: tools_test [698.455474] Subtest tools_test: SUCCESS (0.438s) [698.566347] [162/168] (380s left) gem_sync (basic-many-each) [698.977898] Starting subtest: basic-many-each [701.488801] Subtest basic-many-each: SUCCESS (2.415s) [701.587301] [163/168] (377s left) gem_tiled_blits (interruptible) [702.034881] Starting subtest: interruptible [753.829300] Subtest interruptible: SUCCESS (51.621s) [753.926642] [164/168] (325s left) gem_ctx_engines (execute-one) [754.289146] Starting subtest: execute-one [757.396765] Subtest execute-one: SUCCESS (2.943s) [757.487675] [165/168] (322s left) xe_exec_balancer (no-exec-cm-virtual-rebind) [757.852836] Subtest no-exec-cm-virtual-rebind: SKIP (0.000s) [757.951070] [166/168] (321s left) vgem_slow (nohang) [758.194053] Starting subtest: nohang [768.793545] Subtest nohang: SUCCESS (10.344s) [768.887881] [167/168] (311s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-pwrite) [769.353097] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-pwrite [769.390393] Subtest fbcpsr-1p-offscren-pri-indfb-draw-pwrite: SKIP (0.000s) [769.507952] [168/168] (310s left) kms_plane (plane-position-hole-dpms) [769.822342] Starting subtest: plane-position-hole-dpms [769.842944] Starting dynamic subtest: pipe-A-planes [771.951365] Dynamic subtest pipe-A-planes: SUCCESS (2.112s) [772.002047] Starting dynamic subtest: pipe-B-planes [774.180779] Dynamic subtest pipe-B-planes: SUCCESS (2.226s) [774.202300] Subtest plane-position-hole-dpms: SUCCESS (4.341s) [774.512076] Closing watchdogs Done.