[67.652962] Initializing watchdogs [67.653117] /dev/watchdog0 [67.678519] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics] [67.691716] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [67.696144] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [67.698785] [001/131] (960s left) gem_tiled_blits (basic) [67.874439] Subtest basic: SKIP (0.000s) [67.941061] [002/131] (960s left) sysfs_heartbeat_interval (nopreempt) [67.992625] Starting subtest: nopreempt [67.993529] Starting dynamic subtest: vecs0 [71.940101] Dynamic subtest vecs0: SUCCESS (3.944s) [71.947458] Starting dynamic subtest: vcs0 [75.783049] Dynamic subtest vcs0: SUCCESS (3.846s) [75.790468] Starting dynamic subtest: bcs0 [79.647266] Dynamic subtest bcs0: SUCCESS (3.864s) [79.656115] Starting dynamic subtest: rcs0 [83.575092] Dynamic subtest rcs0: SUCCESS (3.928s) [83.582494] Starting dynamic subtest: vcs1 [87.447889] Dynamic subtest vcs1: SUCCESS (3.873s) [87.448989] Subtest nopreempt: SUCCESS (19.456s) [87.584337] [003/131] (940s left) gem_mmap_offset (partial-remap) [87.634852] Starting subtest: partial-remap [87.635761] Starting dynamic subtest: lmem0 [87.640960] Dynamic subtest lmem0: SUCCESS (0.005s) [87.648590] Starting dynamic subtest: smem0 [87.650497] Dynamic subtest smem0: SUCCESS (0.005s) [87.651503] Subtest partial-remap: SUCCESS (0.011s) [87.792844] [004/131] (940s left) kms_addfb_basic (legacy-format) [87.841628] Starting subtest: legacy-format [87.881865] Subtest legacy-format: SUCCESS (0.038s) [89.946765] [005/131] (938s left) prime_self_import (basic-llseek-size) [89.998632] Starting subtest: basic-llseek-size [90.002477] Subtest basic-llseek-size: SUCCESS (0.004s) [90.128616] [006/131] (938s left) kms_chamelium_hpd (dp-hpd-after-suspend) [92.167758] Subtest dp-hpd-after-suspend: SKIP (0.000s) [92.262980] [007/131] (936s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc) [94.265805] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc [94.267531] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [94.438883] [008/131] (934s left) gem_eio (in-flight-internal-immediate) [94.593592] Starting subtest: in-flight-internal-immediate [95.869489] Subtest in-flight-internal-immediate: SUCCESS (1.276s) [97.938416] [009/131] (930s left) perf_pmu (busy-idle) [98.016804] Starting subtest: busy-idle [98.018062] Starting dynamic subtest: rcs0 [98.720172] Dynamic subtest rcs0: SUCCESS (0.702s) [98.730595] Starting dynamic subtest: bcs0 [99.384789] Dynamic subtest bcs0: SUCCESS (0.662s) [99.398128] Starting dynamic subtest: vcs0 [100.048803] Dynamic subtest vcs0: SUCCESS (0.662s) [100.061201] Starting dynamic subtest: vcs1 [100.709790] Dynamic subtest vcs1: SUCCESS (0.659s) [100.721907] Starting dynamic subtest: vecs0 [101.370792] Dynamic subtest vecs0: SUCCESS (0.659s) [101.373170] Subtest busy-idle: SUCCESS (3.354s) [101.486074] [010/131] (927s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc) [103.485980] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc [103.487906] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [103.704468] [011/131] (925s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size) [105.698111] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size [105.700096] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.002s) [105.821784] [012/131] (923s left) kms_vblank (wait-idle) [107.850780] Starting subtest: wait-idle [107.851652] Starting dynamic subtest: pipe-A-HDMI-A-4 [110.184993] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.333s) [110.197164] Starting dynamic subtest: pipe-D-HDMI-A-4 [112.355893] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.167s) [112.356868] Subtest wait-idle: SUCCESS (4.507s) [112.515276] [013/131] (916s left) kms_vblank (query-busy) [114.511423] Starting subtest: query-busy [114.513481] Starting dynamic subtest: pipe-A-HDMI-A-4 [117.047679] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.535s) [117.059488] Starting dynamic subtest: pipe-D-HDMI-A-4 [119.416947] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.365s) [119.417858] Subtest query-busy: SUCCESS (4.906s) [119.568338] [014/131] (909s left) kms_joiner (invalid-modeset-big-joiner) [121.567341] Starting subtest: invalid-modeset-big-joiner [121.569251] Subtest invalid-modeset-big-joiner: SKIP (0.000s) [121.692637] [015/131] (907s left) gem_gtt_cpu_tlb [121.854228] [016/131] (907s left) gem_exec_whisper (basic-forked) [121.917403] Starting subtest: basic-forked [124.737142] Subtest basic-forked: SUCCESS (2.816s) [125.016537] [017/131] (904s left) gem_vm_create (invalid-create) [125.071804] Starting subtest: invalid-create [125.073875] Subtest invalid-create: SUCCESS (0.002s) [125.219839] [018/131] (904s left) syncobj_timeline (invalid-signal-zero-handles) [125.270358] Starting subtest: invalid-signal-zero-handles [125.271209] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [125.371695] [019/131] (904s left) i915_pm_rps (waitboost) [125.429321] Starting subtest: waitboost [128.007412] Subtest waitboost: SUCCESS (2.578s) [128.157079] [020/131] (901s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf) [130.158980] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s) [130.230607] [021/131] (899s left) gem_userptr_blits (huge-split) [130.316340] Starting subtest: huge-split [130.333699] Subtest huge-split: SUCCESS (0.017s) [130.549986] [022/131] (899s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow) [132.567297] Starting subtest: yf-tiled-addfb-size-offset-overflow [132.568994] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s) [132.794832] [023/131] (897s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted) [135.365307] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted [135.367143] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SKIP (0.000s) [135.479972] [024/131] (894s left) perf_pmu (gt-awake) [135.534574] Starting subtest: gt-awake [138.795317] Subtest gt-awake: SUCCESS (3.260s) [138.943764] [025/131] (891s left) kms_pipe_crc_basic (read-crc) [140.940262] Starting subtest: read-crc [140.941200] Starting dynamic subtest: pipe-A-HDMI-A-4 [141.601690] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.660s) [141.613057] Starting dynamic subtest: pipe-B-HDMI-A-4 [142.125120] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.522s) [142.135471] Starting dynamic subtest: pipe-C-HDMI-A-4 [142.645972] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.519s) [142.656160] Starting dynamic subtest: pipe-D-HDMI-A-4 [143.140457] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.492s) [143.141336] Subtest read-crc: SUCCESS (2.201s) [143.319936] [026/131] (886s left) kms_psr (fbc-psr2-sprite-mmap-cpu) [145.315836] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.000s) [145.377408] [027/131] (884s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled) [145.429892] Starting subtest: multi-wait-all-for-submit-submitted-signaled [145.535357] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.101s) [145.715870] [028/131] (884s left) drm_read (invalid-buffer) [147.810876] Starting subtest: invalid-buffer [147.811878] Subtest invalid-buffer: SUCCESS (0.000s) [148.071104] [029/131] (882s left) kms_cursor_crc (cursor-random-32x32) [150.116899] Starting subtest: cursor-random-32x32 [150.163983] Subtest cursor-random-32x32: SKIP (0.045s) [150.582880] [030/131] (879s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render) [152.589971] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render [155.344137] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (2.753s) [155.547661] [031/131] (874s left) gem_lmem_swapping (parallel-random-verify-ccs) [160.747722] Starting subtest: parallel-random-verify-ccs [160.748661] Starting dynamic subtest: lmem0 [160.750371] Dynamic subtest lmem0: SKIP (0.000s) [160.752299] Subtest parallel-random-verify-ccs: SKIP (0.001s) [161.925527] [FACT gem_lmem_swapping (parallel-random-verify-ccs)] deleted: kernel.kmod_is_loaded.i915: true [161.927910] [032/131] (868s left) kms_draw_crc (draw-method-mmap-cpu) [168.211710] Starting subtest: draw-method-mmap-cpu [168.212615] Starting dynamic subtest: xrgb8888-untiled [168.590160] Dynamic subtest xrgb8888-untiled: SUCCESS (0.377s) [168.628099] Starting dynamic subtest: rgb565-untiled [168.923606] Dynamic subtest rgb565-untiled: SUCCESS (0.329s) [168.960452] Starting dynamic subtest: xrgb2101010-untiled [169.256793] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.329s) [169.291750] Starting dynamic subtest: xbgr16161616f-untiled [169.623224] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.362s) [169.635377] Starting dynamic subtest: xrgb8888-xtiled [169.790190] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.162s) [169.826071] Starting dynamic subtest: rgb565-xtiled [169.973437] Dynamic subtest rgb565-xtiled: SUCCESS (0.178s) [170.009971] Starting dynamic subtest: xrgb2101010-xtiled [170.158037] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.181s) [170.166237] Starting dynamic subtest: xbgr16161616f-xtiled [170.323238] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.163s) [170.356749] Starting dynamic subtest: xrgb8888-ytiled [170.523339] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.195s) [170.560067] Starting dynamic subtest: rgb565-ytiled [170.723263] Dynamic subtest rgb565-ytiled: SUCCESS (0.195s) [170.759808] Starting dynamic subtest: xrgb2101010-ytiled [170.906678] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.179s) [170.918483] Starting dynamic subtest: xbgr16161616f-ytiled [171.073035] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.162s) [171.075723] Subtest draw-method-mmap-cpu: SUCCESS (2.863s) [171.276352] [FACT kms_draw_crc (draw-method-mmap-cpu)] new: kernel.kmod_is_loaded.i915: true [171.277388] [FACT kms_draw_crc (draw-method-mmap-cpu)] new: kernel.kmod_is_loaded.xe: true [171.279723] [033/131] (859s left) gem_softpin (evict-active) [171.342407] Starting subtest: evict-active [171.357307] Subtest evict-active: SUCCESS (0.015s) [171.543169] [034/131] (859s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-blt) [173.535991] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-blt [173.537965] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-blt: SKIP (0.000s) [173.765119] [035/131] (857s left) kms_lease (lessee-list) [175.761120] Starting subtest: lessee-list [175.762030] Starting dynamic subtest: pipe-A-HDMI-A-4 [175.762903] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.001s) [175.772772] Starting dynamic subtest: pipe-B-HDMI-A-4 [175.773695] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.001s) [175.781972] Starting dynamic subtest: pipe-C-HDMI-A-4 [175.782897] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.001s) [175.791085] Starting dynamic subtest: pipe-D-HDMI-A-4 [175.791988] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.001s) [175.792912] Subtest lessee-list: SUCCESS (0.012s) [175.932571] [036/131] (854s left) prime_vgem (basic-read) [176.070172] Starting subtest: basic-read [176.077044] Subtest basic-read: SKIP (0.006s) [176.264545] [FACT prime_vgem (basic-read)] new: kernel.kmod_is_loaded.vgem: true [176.267057] [037/131] (854s left) i915_query (query-regions-garbage-items) [176.320140] Starting subtest: query-regions-garbage-items [176.321139] Subtest query-regions-garbage-items: SUCCESS (0.000s) [176.439893] [038/131] (854s left) kms_flip (2x-flip-vs-suspend-interruptible) [178.446377] Starting subtest: 2x-flip-vs-suspend-interruptible [178.463393] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.017s) [178.622881] [039/131] (852s left) kms_getfb (getfb-handle-valid) [178.680464] Starting subtest: getfb-handle-valid [178.681425] Subtest getfb-handle-valid: SUCCESS (0.000s) [178.827090] [040/131] (852s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt) [180.825444] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt [180.827126] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [181.001827] [041/131] (850s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-cpu) [183.010402] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-cpu [185.227232] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (2.217s) [185.401630] [042/131] (846s left) gem_exec_reloc (basic-concurrent0) [185.460095] Subtest basic-concurrent0: SKIP (0.000s) [185.566684] [043/131] (845s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc) [187.569955] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc [187.571631] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [187.789320] [044/131] (843s left) gem_exec_reloc (basic-cpu-noreloc) [187.846169] Subtest basic-cpu-noreloc: SKIP (0.000s) [187.945398] [045/131] (843s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [189.957168] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [189.959108] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [190.142841] [046/131] (841s left) gem_basic (bad-close) [190.196543] Starting subtest: bad-close [190.198221] Subtest bad-close: SUCCESS (0.000s) [190.316294] [047/131] (841s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt) [192.319220] Starting subtest: fbcpsr-rgb101010-draw-blt [192.321237] Subtest fbcpsr-rgb101010-draw-blt: SKIP (0.000s) [192.510698] [048/131] (839s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc) [194.508639] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc [194.509563] Starting dynamic subtest: pipe-A-HDMI-A-4 [194.520234] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.001s) [194.528717] Starting dynamic subtest: pipe-B-HDMI-A-4 [194.535907] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.001s) [194.544410] Starting dynamic subtest: pipe-C-HDMI-A-4 [194.551583] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.001s) [194.559923] Starting dynamic subtest: pipe-D-HDMI-A-4 [194.567372] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.001s) [194.568190] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.011s) [194.737071] [049/131] (837s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling) [196.730506] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling [196.731406] Starting dynamic subtest: pipe-A-valid-mode [197.945638] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.214s) [197.946471] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SUCCESS (1.216s) [198.108456] [050/131] (834s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot) [200.106462] Starting subtest: modeset-atomic-cursor-hotspot [200.108210] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s) [200.229365] [051/131] (832s left) gem_busy (busy) [200.323429] Starting subtest: busy [200.324561] Starting dynamic subtest: all-engines [200.407205] Dynamic subtest all-engines: SUCCESS (0.083s) [200.419394] Starting dynamic subtest: rcs0 [200.507123] Dynamic subtest rcs0: SUCCESS (0.099s) [200.521914] Starting dynamic subtest: bcs0 [200.563875] Dynamic subtest bcs0: SUCCESS (0.055s) [200.580117] Starting dynamic subtest: vcs0 [200.604572] Dynamic subtest vcs0: SUCCESS (0.039s) [200.625782] Starting dynamic subtest: vcs1 [200.645565] Dynamic subtest vcs1: SUCCESS (0.039s) [200.666720] Starting dynamic subtest: vecs0 [200.687088] Dynamic subtest vecs0: SUCCESS (0.039s) [200.688248] Subtest busy: SUCCESS (0.364s) [201.092767] [052/131] (831s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render) [203.096642] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render [203.098314] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [203.286233] [053/131] (829s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt) [205.294820] Starting subtest: psr-rgb565-draw-mmap-gtt [205.296617] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s) [205.485942] [054/131] (827s left) kms_chamelium_edid (dp-mode-timings) [207.536918] Subtest dp-mode-timings: SKIP (0.000s) [207.646743] [055/131] (825s left) gem_ctx_isolation (nonpriv) [207.709515] Starting subtest: nonpriv [207.710481] Starting dynamic subtest: rcs0 [208.677095] Dynamic subtest rcs0: SUCCESS (0.967s) [208.686197] Starting dynamic subtest: bcs0 [209.695476] Dynamic subtest bcs0: SUCCESS (1.017s) [209.704953] Starting dynamic subtest: vcs0 [210.772131] Dynamic subtest vcs0: SUCCESS (1.076s) [210.783161] Starting dynamic subtest: vcs1 [211.787160] Dynamic subtest vcs1: SUCCESS (1.014s) [211.796051] Starting dynamic subtest: vecs0 [212.810980] Dynamic subtest vecs0: SUCCESS (1.020s) [212.811906] Subtest nonpriv: SUCCESS (5.100s) [213.132552] [056/131] (819s left) kms_psr_stress_test (flip-primary-invalidate-overlay) [213.183535] Subtest flip-primary-invalidate-overlay: SKIP (0.000s) [213.262464] [057/131] (819s left) kms_pm_rpm (modeset-lpsp-stress-no-wait) [218.038207] Starting subtest: modeset-lpsp-stress-no-wait [218.113326] Subtest modeset-lpsp-stress-no-wait: SKIP (0.076s) [219.225467] [058/131] (813s left) dumb_buffer (create-valid-dumb) [219.291758] Starting subtest: create-valid-dumb [219.292736] Subtest create-valid-dumb: SUCCESS (0.000s) [219.467155] [059/131] (813s left) kms_atomic_transition (modeset-transition-nonblocking-fencing) [221.465488] Starting subtest: modeset-transition-nonblocking-fencing [221.466387] Starting dynamic subtest: 1x-outputs [223.412221] Dynamic subtest 1x-outputs: SUCCESS (1.943s) [223.448197] Subtest modeset-transition-nonblocking-fencing: SUCCESS (1.983s) [223.625869] [060/131] (809s left) gem_mmap_gtt (cpuset-medium-copy-odd) [223.676117] Subtest cpuset-medium-copy-odd: SKIP (0.000s) [223.752405] [061/131] (809s left) kms_cursor_crc (cursor-rapid-movement-256x85) [225.932794] Starting subtest: cursor-rapid-movement-256x85 [225.939453] Starting dynamic subtest: pipe-A-HDMI-A-4 [226.371083] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.431s) [226.400257] Starting dynamic subtest: pipe-D-HDMI-A-4 [226.674215] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.281s) [226.675212] Subtest cursor-rapid-movement-256x85: SUCCESS (0.741s) [227.024307] [062/131] (806s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format) [229.017283] Starting subtest: plane-upscale-20x20-with-pixel-format [229.018174] Starting dynamic subtest: pipe-A [231.264060] Dynamic subtest pipe-A: SUCCESS (2.246s) [231.283595] Starting dynamic subtest: pipe-B [233.503550] Dynamic subtest pipe-B: SUCCESS (2.237s) [233.517962] Starting dynamic subtest: pipe-C [233.794322] Dynamic subtest pipe-C: SUCCESS (0.289s) [233.808033] Starting dynamic subtest: pipe-D [234.083587] Dynamic subtest pipe-D: SUCCESS (0.287s) [234.084700] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.068s) [234.316245] [063/131] (798s left) gem_ctx_persistence (smoketest) [234.374710] Starting subtest: smoketest [272.978405] Subtest smoketest: SUCCESS (38.604s) [273.115050] [064/131] (760s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf) [275.121923] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [275.189404] [065/131] (758s left) gem_exec_suspend (basic-s3) [275.253255] Starting subtest: basic-S3 [275.254131] Starting dynamic subtest: smem [299.424953] Dynamic subtest smem: SUCCESS (12.813s) [299.437628] Starting dynamic subtest: lmem0 [323.410204] Dynamic subtest lmem0: SUCCESS (12.574s) [323.411395] Subtest basic-S3: SUCCESS (25.390s) [325.678124] [066/131] (732s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt) [327.678236] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt [327.680034] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [327.859335] [067/131] (730s left) gem_reg_read (bad-register) [327.913429] Starting subtest: bad-register [327.914372] Subtest bad-register: SUCCESS (0.000s) [328.027971] [068/131] (730s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-pwrite) [330.030406] Starting subtest: psr-1p-offscren-pri-shrfb-draw-pwrite [330.032395] Subtest psr-1p-offscren-pri-shrfb-draw-pwrite: SKIP (0.000s) [330.241429] [069/131] (728s left) gem_exec_fence (syncobj-unused-fence) [330.693776] Starting subtest: syncobj-unused-fence [330.711975] Subtest syncobj-unused-fence: SUCCESS (0.018s) [331.153287] [070/131] (727s left) syncobj_eventfd (invalid-bad-pad) [331.203805] Starting subtest: invalid-bad-pad [331.204682] Subtest invalid-bad-pad: SUCCESS (0.000s) [331.348722] [071/131] (727s left) gem_exec_reloc (basic-wc) [331.402405] Subtest basic-wc: SKIP (0.000s) [331.495579] [072/131] (727s left) kms_flip (2x-plain-flip-ts-check) [333.491761] Starting subtest: 2x-plain-flip-ts-check [333.510253] Subtest 2x-plain-flip-ts-check: SKIP (0.018s) [333.685603] [073/131] (725s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs) [335.683622] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs [335.684453] Starting dynamic subtest: pipe-A-HDMI-A-4 [335.705693] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.003s) [335.716482] Starting dynamic subtest: pipe-B-HDMI-A-4 [335.738417] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.002s) [335.749073] Starting dynamic subtest: pipe-C-HDMI-A-4 [335.771657] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.003s) [335.782482] Starting dynamic subtest: pipe-D-HDMI-A-4 [335.804771] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.003s) [335.806448] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.020s) [335.926974] [074/131] (722s left) kms_psr2_su (page_flip-nv12) [335.980535] Subtest page_flip-NV12: SKIP (0.000s) [336.055612] [075/131] (722s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20) [338.046463] Starting subtest: planes-downscale-factor-0-75-upscale-20x20 [338.047326] Starting dynamic subtest: pipe-A [338.147811] Dynamic subtest pipe-A: SUCCESS (0.102s) [338.159795] Starting dynamic subtest: pipe-B [338.288426] Dynamic subtest pipe-B: SUCCESS (0.139s) [338.300636] Starting dynamic subtest: pipe-C [338.427503] Dynamic subtest pipe-C: SUCCESS (0.138s) [338.439481] Starting dynamic subtest: pipe-D [338.565942] Dynamic subtest pipe-D: SUCCESS (0.137s) [338.566894] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (0.521s) [338.764461] [076/131] (720s left) gem_userptr_blits (stress-mm) [338.833969] Starting subtest: stress-mm [344.206691] Subtest stress-mm: SUCCESS (5.369s) [344.418650] [077/131] (714s left) i915_hangman (gt-error-state-capture) [344.483158] Starting subtest: gt-error-state-capture [344.484154] Starting dynamic subtest: rcs0 [353.814569] Dynamic subtest rcs0: SUCCESS (9.333s) [353.833493] Starting dynamic subtest: bcs0 [363.783846] Dynamic subtest bcs0: SUCCESS (9.967s) [363.820699] Starting dynamic subtest: vcs0 [373.816452] Dynamic subtest vcs0: SUCCESS (10.030s) [373.831645] Starting dynamic subtest: vcs1 [383.823535] Dynamic subtest vcs1: SUCCESS (10.005s) [383.839091] Starting dynamic subtest: vecs0 [393.769288] Dynamic subtest vecs0: SUCCESS (9.944s) [393.770222] Subtest gt-error-state-capture: SUCCESS (49.288s) [393.946575] [078/131] (665s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs) [395.946265] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs [395.947332] Starting dynamic subtest: pipe-A-HDMI-A-4 [395.951354] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s) [395.963014] Starting dynamic subtest: pipe-B-HDMI-A-4 [395.966870] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s) [395.978561] Starting dynamic subtest: pipe-C-HDMI-A-4 [395.984225] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s) [395.995312] Starting dynamic subtest: pipe-D-HDMI-A-4 [395.998730] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s) [396.000471] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SKIP (0.011s) [396.170370] [079/131] (663s left) gem_eio (in-flight-immediate) [396.333712] Starting subtest: in-flight-immediate [400.243003] Subtest in-flight-immediate: SUCCESS (3.909s) [402.328152] [080/131] (657s left) gem_userptr_blits (dmabuf-sync) [402.415012] Starting subtest: dmabuf-sync [402.418630] Subtest dmabuf-sync: SKIP (0.003s) [402.609600] [081/131] (656s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render) [404.616442] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render [404.618186] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [404.843439] [082/131] (654s left) kms_atomic_interruptible (atomic-setmode) [406.844025] Starting subtest: atomic-setmode [406.846380] Starting dynamic subtest: pipe-A-HDMI-A-4 [413.056442] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (6.211s) [413.057344] Subtest atomic-setmode: SUCCESS (6.214s) [413.218154] [083/131] (646s left) gem_exec_schedule (u-lateslice) [413.284113] Starting subtest: u-lateslice [413.285079] Starting dynamic subtest: rcs0 [413.319182] Dynamic subtest rcs0: SUCCESS (0.034s) [413.332121] Starting dynamic subtest: bcs0 [413.339891] Dynamic subtest bcs0: SUCCESS (0.019s) [413.352820] Starting dynamic subtest: vcs0 [413.359245] Dynamic subtest vcs0: SUCCESS (0.018s) [413.372479] Starting dynamic subtest: vcs1 [413.378795] Dynamic subtest vcs1: SUCCESS (0.018s) [413.392144] Starting dynamic subtest: vecs0 [413.398607] Dynamic subtest vecs0: SUCCESS (0.018s) [413.399521] Subtest u-lateslice: SUCCESS (0.115s) [413.887376] [084/131] (645s left) gem_exec_reloc (basic-cpu-gtt-noreloc) [413.944714] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s) [414.059069] [085/131] (645s left) kms_psr (psr2-sprite-plane-move) [416.060402] Subtest psr2-sprite-plane-move: SKIP (0.000s) [416.129595] [086/131] (643s left) syncobj_wait (single-wait-all-for-submit-signaled) [416.183511] Starting subtest: single-wait-all-for-submit-signaled [416.184464] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [416.314892] [087/131] (643s left) kms_psr (fbc-psr-primary-mmap-gtt) [418.316656] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.000s) [418.396853] [088/131] (641s left) gem_mmap (big-bo) [418.450094] Subtest big-bo: SKIP (0.000s) [418.535341] [089/131] (641s left) kms_flip (flip-vs-fences) [420.537043] Starting subtest: flip-vs-fences [420.539107] Subtest flip-vs-fences: SKIP (0.000s) [420.684154] [090/131] (639s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled) [420.762989] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled [420.764062] Starting dynamic subtest: smem [420.854801] Dynamic subtest smem: SUCCESS (0.091s) [420.866801] Starting dynamic subtest: lmem0 [421.794145] Dynamic subtest lmem0: SUCCESS (0.935s) [421.795435] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SUCCESS (1.029s) [422.053414] [091/131] (638s left) gem_exec_balancer (waits) [422.116336] Starting subtest: waits [429.328763] Subtest waits: SUCCESS (7.209s) [429.699434] [092/131] (630s left) gen9_exec_parse (shadow-peek) [429.753730] Subtest shadow-peek: SKIP (0.000s) [429.831416] [093/131] (630s left) gem_fence_thrash (bo-copy) [429.879938] Starting subtest: bo-copy [429.882663] Subtest bo-copy: SKIP (0.002s) [429.961366] [094/131] (630s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt) [431.963954] Starting subtest: psr-farfromfence-mmap-gtt [431.965595] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s) [432.180669] [095/131] (628s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [434.187797] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip [434.753441] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.565s) [435.021385] [096/131] (625s left) kms_content_protection (mei-interface) [437.072725] Starting subtest: mei-interface [437.343268] Subtest mei-interface: SKIP (0.268s) [437.560027] [097/131] (623s left) gem_mmap_gtt (fault-concurrent) [437.611702] Subtest fault-concurrent: SKIP (0.000s) [437.685550] [098/131] (623s left) api_intel_allocator (open-vm) [437.737412] Starting subtest: open-vm [437.750059] Subtest open-vm: SUCCESS (0.013s) [437.974146] [099/131] (622s left) dmabuf_sync_file (import-multiple-read-write) [438.030154] Starting subtest: import-multiple-read-write [438.035590] Subtest import-multiple-read-write: SUCCESS (0.006s) [438.134515] [100/131] (622s left) syncobj_basic (bad-handle-to-fd) [438.186345] Starting subtest: bad-handle-to-fd [438.187383] Subtest bad-handle-to-fd: SUCCESS (0.000s) [438.306262] [101/131] (622s left) gem_exec_create (basic) [438.370129] Starting subtest: basic [438.371188] Starting dynamic subtest: smem [440.472662] Dynamic subtest smem: SUCCESS (2.102s) [440.486511] Starting dynamic subtest: lmem0 [442.574793] Dynamic subtest lmem0: SUCCESS (2.101s) [442.575808] Subtest basic: SUCCESS (4.206s) [442.794028] [102/131] (618s left) gem_exec_await (wide-contexts) [442.963219] Starting subtest: wide-contexts [465.339673] Subtest wide-contexts: SUCCESS (22.378s) [465.693534] [103/131] (595s left) kms_psr (fbc-pr-cursor-plane-move) [467.758719] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s) [467.832794] [104/131] (593s left) kms_psr (pr-sprite-render) [469.833225] Subtest pr-sprite-render: SKIP (0.000s) [469.915872] [105/131] (591s left) kms_big_fb (y-tiled-16bpp-rotate-180) [471.933777] Starting subtest: y-tiled-16bpp-rotate-180 [473.677622] Subtest y-tiled-16bpp-rotate-180: SUCCESS (1.740s) [473.875041] [106/131] (587s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180) [475.890835] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180 [476.998003] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.100s) [477.181129] [107/131] (584s left) gem_ringfill (basic-all) [477.591259] Starting subtest: basic-all [478.888429] Subtest basic-all: SUCCESS (1.295s) [479.104289] [108/131] (582s left) kms_flip (2x-flip-vs-dpms) [481.106810] Starting subtest: 2x-flip-vs-dpms [481.123726] Subtest 2x-flip-vs-dpms: SKIP (0.018s) [481.271612] [109/131] (580s left) syncobj_timeline (wait-all-interrupted) [481.338455] Starting subtest: wait-all-interrupted [481.444450] Subtest wait-all-interrupted: SUCCESS (0.102s) [481.620263] [110/131] (580s left) kms_big_fb (x-tiled-16bpp-rotate-0) [483.625807] Starting subtest: x-tiled-16bpp-rotate-0 [485.344327] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.714s) [485.527855] [111/131] (576s left) kms_plane (plane-position-hole-dpms) [487.530178] Starting subtest: plane-position-hole-dpms [487.980426] Starting dynamic subtest: pipe-A-plane-1 [488.441029] Dynamic subtest pipe-A-plane-1: SUCCESS (0.460s) [488.453724] Starting dynamic subtest: pipe-A-plane-2 [488.890229] Dynamic subtest pipe-A-plane-2: SUCCESS (0.448s) [488.903051] Starting dynamic subtest: pipe-A-plane-3 [489.355872] Dynamic subtest pipe-A-plane-3: SUCCESS (0.464s) [489.369353] Starting dynamic subtest: pipe-A-plane-4 [489.845182] Dynamic subtest pipe-A-plane-4: SUCCESS (0.489s) [489.857686] Starting dynamic subtest: pipe-A-plane-5 [490.306136] Dynamic subtest pipe-A-plane-5: SUCCESS (0.460s) [490.318674] Starting dynamic subtest: pipe-A-plane-6 [490.784031] Dynamic subtest pipe-A-plane-6: SUCCESS (0.477s) [490.796700] Starting dynamic subtest: pipe-A-plane-7 [490.804907] Dynamic subtest pipe-A-plane-7: SUCCESS (0.019s) [491.089490] Starting dynamic subtest: pipe-B-plane-1 [491.520919] Dynamic subtest pipe-B-plane-1: SUCCESS (0.444s) [491.533606] Starting dynamic subtest: pipe-B-plane-2 [491.997054] Dynamic subtest pipe-B-plane-2: SUCCESS (0.475s) [492.009564] Starting dynamic subtest: pipe-B-plane-3 [492.440938] Dynamic subtest pipe-B-plane-3: SUCCESS (0.441s) [492.453579] Starting dynamic subtest: pipe-B-plane-4 [492.920172] Dynamic subtest pipe-B-plane-4: SUCCESS (0.479s) [492.933065] Starting dynamic subtest: pipe-B-plane-5 [493.373343] Dynamic subtest pipe-B-plane-5: SUCCESS (0.450s) [493.390244] Starting dynamic subtest: pipe-B-plane-6 [493.824251] Dynamic subtest pipe-B-plane-6: SUCCESS (0.449s) [493.837803] Starting dynamic subtest: pipe-B-plane-7 [493.850536] Dynamic subtest pipe-B-plane-7: SUCCESS (0.025s) [493.851546] Subtest plane-position-hole-dpms: SUCCESS (6.321s) [494.037455] [112/131] (567s left) syncobj_timeline (invalid-signal-bad-pad) [494.093085] Starting subtest: invalid-signal-bad-pad [494.094071] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [494.228990] [113/131] (567s left) gem_exec_params (no-bsd) [494.284146] Starting subtest: no-bsd [494.286561] Subtest no-bsd: SUCCESS (0.001s) [494.439918] [114/131] (567s left) kms_color (ctm-0-75) [496.443168] Starting subtest: ctm-0-75 [496.444217] Starting dynamic subtest: pipe-A-HDMI-A-4 [498.501323] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.058s) [498.514210] Starting dynamic subtest: pipe-B-HDMI-A-4 [500.293552] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (1.791s) [500.307611] Starting dynamic subtest: pipe-C-HDMI-A-4 [502.077534] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (1.782s) [502.090890] Starting dynamic subtest: pipe-D-HDMI-A-4 [503.890331] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (1.811s) [503.891299] Subtest ctm-0-75: SUCCESS (7.448s) [504.059125] [115/131] (558s left) gem_mmap_gtt (big-copy-odd) [504.114004] Subtest big-copy-odd: SKIP (0.000s) [504.184885] [116/131] (558s left) gem_ctx_persistence (engines-hostile-preempt) [504.241483] Starting subtest: engines-hostile-preempt [504.242467] Starting dynamic subtest: rcs0 [504.312545] Dynamic subtest rcs0: SUCCESS (0.070s) [504.334784] Starting dynamic subtest: bcs0 [504.365849] Dynamic subtest bcs0: SUCCESS (0.051s) [504.404683] Starting dynamic subtest: vcs0 [504.431604] Dynamic subtest vcs0: SUCCESS (0.063s) [504.451172] Starting dynamic subtest: vcs1 [504.473539] Dynamic subtest vcs1: SUCCESS (0.040s) [504.492897] Starting dynamic subtest: vecs0 [504.511613] Dynamic subtest vecs0: SUCCESS (0.036s) [504.512793] Subtest engines-hostile-preempt: SUCCESS (0.271s) [504.719958] [117/131] (557s left) gem_exec_balancer (full-late-pulse) [504.784356] Starting subtest: full-late-pulse [506.767673] Subtest full-late-pulse: SUCCESS (1.983s) [507.175163] [118/131] (555s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted) [507.227642] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted [507.337020] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.105s) [507.474584] [119/131] (555s left) gem_exec_schedule (preempt-other-chain) [507.543287] Starting subtest: preempt-other-chain [507.544241] Starting dynamic subtest: rcs0 [507.689514] Dynamic subtest rcs0: SUCCESS (0.142s) [507.701914] Starting dynamic subtest: bcs0 [507.818494] Dynamic subtest bcs0: SUCCESS (0.127s) [507.830916] Starting dynamic subtest: vcs0 [507.947222] Dynamic subtest vcs0: SUCCESS (0.127s) [507.959517] Starting dynamic subtest: vcs1 [508.074109] Dynamic subtest vcs1: SUCCESS (0.125s) [508.086409] Starting dynamic subtest: vecs0 [508.200749] Dynamic subtest vecs0: SUCCESS (0.125s) [508.201811] Subtest preempt-other-chain: SUCCESS (0.655s) [508.628378] [120/131] (554s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling) [510.628309] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling [510.629299] Starting dynamic subtest: pipe-A-valid-mode [511.447461] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.818s) [511.448358] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SUCCESS (0.820s) [511.638018] [121/131] (551s left) gem_exec_params (sol-reset-invalid) [511.695131] Starting subtest: sol-reset-invalid [511.697662] Subtest sol-reset-invalid: SUCCESS (0.002s) [511.917339] [122/131] (550s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs) [513.917692] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs [513.918591] Starting dynamic subtest: pipe-A-HDMI-A-4 [513.927063] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s) [513.939647] Starting dynamic subtest: pipe-B-HDMI-A-4 [513.948146] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s) [513.960557] Starting dynamic subtest: pipe-C-HDMI-A-4 [513.969146] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s) [513.981332] Starting dynamic subtest: pipe-D-HDMI-A-4 [513.990231] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s) [513.991896] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.010s) [514.148711] [123/131] (548s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes) [514.198077] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s) [514.277095] [124/131] (548s left) core_getversion (basic) [514.326508] Starting subtest: basic [514.328713] Subtest basic: SUCCESS (0.000s) [514.451496] [125/131] (548s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff) [516.459831] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff [516.461420] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [516.637986] [126/131] (546s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc) [518.646321] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc [518.648113] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [518.874943] [127/131] (544s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs) [520.874336] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs [520.876307] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s) [521.068933] [128/131] (542s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff) [523.093277] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff [526.164915] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (3.070s) [526.433791] [129/131] (537s left) gem_exec_params (invalid-bsd1-flag-on-vebox) [526.489696] Starting subtest: invalid-bsd1-flag-on-vebox [526.490857] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s) [526.681722] [130/131] (536s left) gem_eio (create-ext) [526.868781] Starting subtest: create-ext [527.141021] Subtest create-ext: SUCCESS (0.274s) [529.218083] [131/131] (534s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted) [529.289691] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted [529.290754] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.001s) [529.400476] Closing watchdogs Done.