[45.105157] Initializing watchdogs [45.105290] /dev/watchdog0 [45.120656] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics] [45.125923] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [45.128689] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [45.130582] [001/131] (960s left) gem_tiled_blits (basic) [45.533189] Starting subtest: basic [45.557847] Subtest basic: SUCCESS (0.025s) [45.715355] [002/131] (959s left) sysfs_heartbeat_interval (nopreempt) [45.801981] Starting subtest: nopreempt [45.802740] Starting dynamic subtest: vecs0 [49.418001] Dynamic subtest vecs0: SUCCESS (3.610s) [49.423597] Starting dynamic subtest: vcs0 [53.056584] Dynamic subtest vcs0: SUCCESS (3.634s) [53.065105] Starting dynamic subtest: bcs0 [56.666767] Dynamic subtest bcs0: SUCCESS (3.605s) [56.675109] Starting dynamic subtest: rcs0 [60.336374] Dynamic subtest rcs0: SUCCESS (3.666s) [60.344620] Starting dynamic subtest: vcs1 [63.930373] Dynamic subtest vcs1: SUCCESS (3.592s) [63.931326] Subtest nopreempt: SUCCESS (18.110s) [63.992800] [003/131] (941s left) gem_mmap_offset (partial-remap) [64.031797] Starting subtest: partial-remap [64.032568] Starting dynamic subtest: smem0 [64.037605] Dynamic subtest smem0: SUCCESS (0.004s) [64.038296] Subtest partial-remap: SUCCESS (0.004s) [64.153913] [004/131] (941s left) kms_addfb_basic (legacy-format) [64.192279] Starting subtest: legacy-format [64.230928] Subtest legacy-format: SUCCESS (0.037s) [64.366219] [005/131] (941s left) prime_self_import (basic-llseek-size) [64.406049] Starting subtest: basic-llseek-size [64.408929] Subtest basic-llseek-size: SUCCESS (0.003s) [64.482795] [006/131] (941s left) kms_chamelium_hpd (dp-hpd-after-suspend) [64.637583] Subtest dp-hpd-after-suspend: SKIP (0.000s) [64.733337] [007/131] (941s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc) [64.840881] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc [64.842360] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [64.930366] [008/131] (940s left) gem_eio (in-flight-internal-immediate) [64.976248] Starting subtest: in-flight-internal-immediate [65.223750] Subtest in-flight-internal-immediate: SUCCESS (0.247s) [65.338225] [009/131] (940s left) perf_pmu (busy-idle) [65.380013] Starting subtest: busy-idle [65.380767] Starting dynamic subtest: rcs0 [66.017095] Dynamic subtest rcs0: SUCCESS (0.636s) [66.025129] Starting dynamic subtest: bcs0 [66.658515] Dynamic subtest bcs0: SUCCESS (0.640s) [66.667698] Starting dynamic subtest: vcs0 [67.350018] Dynamic subtest vcs0: SUCCESS (0.691s) [67.355874] Starting dynamic subtest: vcs1 [68.043159] Dynamic subtest vcs1: SUCCESS (0.689s) [68.052147] Starting dynamic subtest: vecs0 [68.685415] Dynamic subtest vecs0: SUCCESS (0.644s) [68.686490] Subtest busy-idle: SUCCESS (3.303s) [68.741861] [010/131] (937s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc) [68.837893] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc [68.839309] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [68.936048] [011/131] (937s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size) [69.022665] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size [69.025009] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [69.073280] [012/131] (936s left) kms_vblank (wait-idle) [69.163725] Starting subtest: wait-idle [69.164419] Starting dynamic subtest: pipe-A-HDMI-A-1 [70.326831] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.162s) [70.335415] Starting dynamic subtest: pipe-D-HDMI-A-1 [71.479573] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.149s) [71.480340] Subtest wait-idle: SUCCESS (2.316s) [71.602537] [013/131] (934s left) kms_vblank (query-busy) [71.693838] Starting subtest: query-busy [71.694554] Starting dynamic subtest: pipe-A-HDMI-A-1 [72.963887] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.268s) [72.974275] Starting dynamic subtest: pipe-D-HDMI-A-1 [74.214736] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.247s) [74.215499] Subtest query-busy: SUCCESS (2.520s) [74.319157] [014/131] (931s left) kms_joiner (invalid-modeset-big-joiner) [74.413726] Starting subtest: invalid-modeset-big-joiner [74.415072] Subtest invalid-modeset-big-joiner: SKIP (0.000s) [74.470198] [015/131] (931s left) gem_gtt_cpu_tlb [74.597590] [016/131] (931s left) gem_exec_whisper (basic-forked) [74.647425] Starting subtest: basic-forked [76.049004] Subtest basic-forked: SUCCESS (1.401s) [76.252291] [017/131] (929s left) gem_vm_create (invalid-create) [76.292393] Starting subtest: invalid-create [76.293147] Subtest invalid-create: SUCCESS (0.000s) [76.379728] [018/131] (929s left) syncobj_timeline (invalid-signal-zero-handles) [76.423069] Starting subtest: invalid-signal-zero-handles [76.423845] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [76.494292] [019/131] (929s left) i915_pm_rps (waitboost) [76.534763] Starting subtest: waitboost [79.090582] Subtest waitboost: SUCCESS (2.526s) [79.192589] [020/131] (927s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf) [79.286350] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s) [79.324081] [021/131] (927s left) gem_userptr_blits (huge-split) [79.383545] Starting subtest: huge-split [79.387014] Subtest huge-split: SUCCESS (0.004s) [79.500775] [022/131] (926s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow) [79.596838] Starting subtest: yf-tiled-addfb-size-offset-overflow [79.598201] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s) [79.679731] [023/131] (926s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted) [79.785793] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted [79.885502] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.101s) [79.987798] [024/131] (926s left) perf_pmu (gt-awake) [80.025188] Starting subtest: gt-awake [83.056811] Subtest gt-awake: SUCCESS (3.022s) [83.129108] [025/131] (923s left) kms_pipe_crc_basic (read-crc) [83.223954] Starting subtest: read-crc [83.224686] Starting dynamic subtest: pipe-A-HDMI-A-1 [83.566621] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.342s) [83.573976] Starting dynamic subtest: pipe-B-HDMI-A-1 [83.876608] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.307s) [83.883563] Starting dynamic subtest: pipe-C-HDMI-A-1 [84.169547] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.291s) [84.176897] Starting dynamic subtest: pipe-D-HDMI-A-1 [84.466114] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.295s) [84.466872] Subtest read-crc: SUCCESS (1.243s) [84.565660] [026/131] (921s left) kms_psr (fbc-psr2-sprite-mmap-cpu) [84.666897] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.000s) [84.700557] [027/131] (921s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled) [84.737998] Starting subtest: multi-wait-all-for-submit-submitted-signaled [84.842029] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.103s) [84.911790] [028/131] (921s left) drm_read (invalid-buffer) [85.044228] Starting subtest: invalid-buffer [85.044981] Subtest invalid-buffer: SUCCESS (0.000s) [85.149794] [029/131] (921s left) kms_cursor_crc (cursor-random-32x32) [85.237533] Starting subtest: cursor-random-32x32 [85.288130] Subtest cursor-random-32x32: SKIP (0.049s) [85.366956] [030/131] (921s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render) [85.457698] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render [86.687248] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (1.230s) [86.839766] [031/131] (919s left) gem_lmem_swapping (parallel-random-verify-ccs) [86.879358] Subtest parallel-random-verify-ccs: SKIP (0.000s) [86.920754] [032/131] (919s left) kms_draw_crc (draw-method-mmap-cpu) [87.013218] Starting subtest: draw-method-mmap-cpu [87.013934] Starting dynamic subtest: xrgb8888-untiled [87.178393] Dynamic subtest xrgb8888-untiled: SUCCESS (0.164s) [87.192708] Starting dynamic subtest: rgb565-untiled [87.344875] Dynamic subtest rgb565-untiled: SUCCESS (0.164s) [87.359368] Starting dynamic subtest: xrgb2101010-untiled [87.494663] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.148s) [87.507795] Starting dynamic subtest: xbgr16161616f-untiled [87.669895] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.174s) [87.685665] Starting dynamic subtest: xrgb8888-xtiled [87.761678] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.090s) [87.776299] Starting dynamic subtest: rgb565-xtiled [87.853295] Dynamic subtest rgb565-xtiled: SUCCESS (0.090s) [87.869176] Starting dynamic subtest: xrgb2101010-xtiled [87.936453] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.082s) [87.946037] Starting dynamic subtest: xbgr16161616f-xtiled [88.019813] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.082s) [88.035759] Starting dynamic subtest: xrgb8888-ytiled [88.120040] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.098s) [88.133218] Starting dynamic subtest: rgb565-ytiled [88.211657] Dynamic subtest rgb565-ytiled: SUCCESS (0.090s) [88.224828] Starting dynamic subtest: xrgb2101010-ytiled [88.295060] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.082s) [88.307667] Starting dynamic subtest: xbgr16161616f-ytiled [88.386838] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.090s) [88.387953] Subtest draw-method-mmap-cpu: SUCCESS (1.374s) [88.494815] [033/131] (918s left) gem_softpin (evict-active) [88.537312] Starting subtest: evict-active [88.541904] Subtest evict-active: SUCCESS (0.005s) [88.654804] [034/131] (918s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-blt) [88.747887] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-blt [88.749320] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-blt: SKIP (0.000s) [88.841287] [035/131] (918s left) kms_lease (lessee-list) [88.929864] Starting subtest: lessee-list [88.930639] Starting dynamic subtest: pipe-A-HDMI-A-1 [88.931528] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s) [88.940754] Starting dynamic subtest: pipe-B-HDMI-A-1 [88.941544] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s) [88.948412] Starting dynamic subtest: pipe-C-HDMI-A-1 [88.949115] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s) [88.955449] Starting dynamic subtest: pipe-D-HDMI-A-1 [88.956153] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s) [88.956844] Subtest lessee-list: SUCCESS (0.011s) [88.991720] [036/131] (917s left) prime_vgem (basic-read) [89.092435] Starting subtest: basic-read [89.113948] Subtest basic-read: SUCCESS (0.022s) [89.202266] [FACT prime_vgem (basic-read)] new: kernel.kmod_is_loaded.vgem: true [89.203856] [037/131] (917s left) i915_query (query-regions-garbage-items) [89.241705] Starting subtest: query-regions-garbage-items [89.242408] Subtest query-regions-garbage-items: SUCCESS (0.000s) [89.302428] [038/131] (917s left) kms_flip (2x-flip-vs-suspend-interruptible) [89.398707] Starting subtest: 2x-flip-vs-suspend-interruptible [89.408601] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.009s) [89.471848] [039/131] (917s left) kms_getfb (getfb-handle-valid) [89.509836] Starting subtest: getfb-handle-valid [89.510563] Subtest getfb-handle-valid: SUCCESS (0.000s) [89.604141] [040/131] (917s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt) [89.697760] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt [89.699147] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [89.778537] [041/131] (917s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-cpu) [89.871864] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-cpu [90.964955] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (1.093s) [91.096991] [042/131] (916s left) gem_exec_reloc (basic-concurrent0) [91.140827] Starting subtest: basic-concurrent0 [96.575680] Subtest basic-concurrent0: SUCCESS (5.405s) [96.655823] [043/131] (910s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc) [96.748947] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc [97.980910] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (1.232s) [98.105706] [044/131] (909s left) gem_exec_reloc (basic-cpu-noreloc) [98.147494] Starting subtest: basic-cpu-noreloc [98.150122] Subtest basic-cpu-noreloc: SUCCESS (0.003s) [98.262584] [045/131] (908s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [98.356249] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [98.357710] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [98.447159] [046/131] (908s left) gem_basic (bad-close) [98.484902] Starting subtest: bad-close [98.486408] Subtest bad-close: SUCCESS (0.000s) [98.538722] [047/131] (908s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt) [98.630568] Starting subtest: fbcpsr-rgb101010-draw-blt [98.632023] Subtest fbcpsr-rgb101010-draw-blt: SKIP (0.000s) [98.700448] [048/131] (908s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc) [98.789812] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc [98.790511] Starting dynamic subtest: pipe-A-HDMI-A-1 [98.796783] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s) [98.802978] Starting dynamic subtest: pipe-B-HDMI-A-1 [98.809100] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s) [98.815169] Starting dynamic subtest: pipe-C-HDMI-A-1 [98.821436] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s) [98.827367] Starting dynamic subtest: pipe-D-HDMI-A-1 [98.833364] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s) [98.834062] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.007s) [99.025518] [049/131] (908s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling) [99.115925] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling [99.116695] Starting dynamic subtest: pipe-A-valid-mode [100.242733] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.125s) [100.243530] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SUCCESS (1.127s) [100.388587] [050/131] (907s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot) [100.485879] Starting subtest: modeset-atomic-cursor-hotspot [100.487286] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s) [100.546262] [051/131] (906s left) gem_busy (busy) [100.594569] Starting subtest: busy [100.595315] Starting dynamic subtest: all-engines [100.629193] Dynamic subtest all-engines: SUCCESS (0.034s) [100.636871] Starting dynamic subtest: rcs0 [100.643230] Dynamic subtest rcs0: SUCCESS (0.013s) [100.650111] Starting dynamic subtest: bcs0 [100.661112] Dynamic subtest bcs0: SUCCESS (0.017s) [100.668480] Starting dynamic subtest: vcs0 [100.673920] Dynamic subtest vcs0: SUCCESS (0.012s) [100.680497] Starting dynamic subtest: vcs1 [100.686020] Dynamic subtest vcs1: SUCCESS (0.011s) [100.693311] Starting dynamic subtest: vecs0 [100.697975] Dynamic subtest vecs0: SUCCESS (0.011s) [100.698718] Subtest busy: SUCCESS (0.104s) [101.059826] [052/131] (906s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render) [101.153893] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render [101.155293] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [101.235257] [053/131] (906s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt) [101.328044] Starting subtest: psr-rgb565-draw-mmap-gtt [101.329427] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s) [101.433752] [054/131] (906s left) kms_chamelium_edid (dp-mode-timings) [101.578778] Subtest dp-mode-timings: SKIP (0.000s) [101.668754] [055/131] (905s left) gem_ctx_isolation (nonpriv) [101.720065] Starting subtest: nonpriv [101.720803] Starting dynamic subtest: rcs0 [102.357855] Dynamic subtest rcs0: SUCCESS (0.629s) [102.363759] Starting dynamic subtest: bcs0 [103.084289] Dynamic subtest bcs0: SUCCESS (0.726s) [103.090153] Starting dynamic subtest: vcs0 [103.757411] Dynamic subtest vcs0: SUCCESS (0.672s) [103.763640] Starting dynamic subtest: vcs1 [104.436631] Dynamic subtest vcs1: SUCCESS (0.679s) [104.444036] Starting dynamic subtest: vecs0 [105.135500] Dynamic subtest vecs0: SUCCESS (0.698s) [105.136306] Subtest nonpriv: SUCCESS (3.407s) [105.302908] [056/131] (902s left) kms_psr_stress_test (flip-primary-invalidate-overlay) [105.339289] Subtest flip-primary-invalidate-overlay: SKIP (0.000s) [105.393939] [057/131] (902s left) kms_pm_rpm (modeset-lpsp-stress-no-wait) [106.800349] Starting subtest: modeset-lpsp-stress-no-wait [107.813599] Subtest modeset-lpsp-stress-no-wait: SUCCESS (1.013s) [107.906513] [058/131] (899s left) dumb_buffer (create-valid-dumb) [107.950273] Starting subtest: create-valid-dumb [107.951058] Subtest create-valid-dumb: SUCCESS (0.000s) [108.058588] [059/131] (899s left) kms_atomic_transition (modeset-transition-nonblocking-fencing) [108.152552] Starting subtest: modeset-transition-nonblocking-fencing [108.153354] Starting dynamic subtest: 1x-outputs [109.354702] Dynamic subtest 1x-outputs: SUCCESS (1.202s) [109.380933] Subtest modeset-transition-nonblocking-fencing: SUCCESS (1.229s) [109.532964] [060/131] (898s left) gem_mmap_gtt (cpuset-medium-copy-odd) [109.576141] Starting subtest: cpuset-medium-copy-odd [116.899025] Subtest cpuset-medium-copy-odd: SUCCESS (7.323s) [116.963293] [061/131] (890s left) kms_cursor_crc (cursor-rapid-movement-256x85) [117.106877] Starting subtest: cursor-rapid-movement-256x85 [117.111841] Starting dynamic subtest: pipe-A-HDMI-A-1 [117.375341] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.263s) [117.409228] Starting dynamic subtest: pipe-D-HDMI-A-1 [117.615276] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.213s) [117.616071] Subtest cursor-rapid-movement-256x85: SUCCESS (0.508s) [117.763820] [062/131] (890s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format) [117.861443] Starting subtest: plane-upscale-20x20-with-pixel-format [117.862240] Starting dynamic subtest: pipe-A [118.977791] Dynamic subtest pipe-A: SUCCESS (1.117s) [118.984338] Starting dynamic subtest: pipe-B [120.170441] Dynamic subtest pipe-B: SUCCESS (1.191s) [120.180765] Starting dynamic subtest: pipe-C [120.378160] Dynamic subtest pipe-C: SUCCESS (0.207s) [120.388798] Starting dynamic subtest: pipe-D [120.586095] Dynamic subtest pipe-D: SUCCESS (0.207s) [120.586888] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (2.726s) [120.759938] [063/131] (887s left) gem_ctx_persistence (smoketest) [120.807194] Starting subtest: smoketest [159.192793] Subtest smoketest: SUCCESS (38.384s) [159.261919] [064/131] (848s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf) [159.360819] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [159.396208] [065/131] (848s left) gem_exec_suspend (basic-s3) [159.442411] Starting subtest: basic-S3 [159.443192] Starting dynamic subtest: smem [176.978868] Dynamic subtest smem: SUCCESS (2.456s) [176.979736] Subtest basic-S3: SUCCESS (2.458s) [185.188148] [066/131] (845s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt) [185.286159] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt [185.287598] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [185.368290] [067/131] (845s left) gem_reg_read (bad-register) [185.403984] Starting subtest: bad-register [185.404686] Subtest bad-register: SUCCESS (0.000s) [185.464730] [068/131] (845s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-pwrite) [185.559651] Starting subtest: psr-1p-offscren-pri-shrfb-draw-pwrite [185.561116] Subtest psr-1p-offscren-pri-shrfb-draw-pwrite: SKIP (0.000s) [185.655638] [069/131] (845s left) gem_exec_fence (syncobj-unused-fence) [186.006398] Starting subtest: syncobj-unused-fence [186.008219] Subtest syncobj-unused-fence: SUCCESS (0.002s) [186.313501] [070/131] (845s left) syncobj_eventfd (invalid-bad-pad) [186.357509] Starting subtest: invalid-bad-pad [186.358219] Subtest invalid-bad-pad: SUCCESS (0.000s) [186.420241] [071/131] (844s left) gem_exec_reloc (basic-wc) [186.460591] Starting subtest: basic-wc [186.465334] Subtest basic-wc: SUCCESS (0.005s) [186.576699] [072/131] (844s left) kms_flip (2x-plain-flip-ts-check) [186.666995] Starting subtest: 2x-plain-flip-ts-check [186.675583] Subtest 2x-plain-flip-ts-check: SKIP (0.009s) [186.747767] [073/131] (844s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs) [186.839291] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs [186.840069] Starting dynamic subtest: pipe-A-HDMI-A-1 [186.858478] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s) [186.866330] Starting dynamic subtest: pipe-B-HDMI-A-1 [186.884851] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s) [186.891963] Starting dynamic subtest: pipe-C-HDMI-A-1 [186.910571] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s) [186.917881] Starting dynamic subtest: pipe-D-HDMI-A-1 [186.936610] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.002s) [186.938047] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.013s) [187.086896] [074/131] (844s left) kms_psr2_su (page_flip-nv12) [187.127226] Subtest page_flip-NV12: SKIP (0.000s) [187.168092] [075/131] (844s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20) [187.257382] Starting subtest: planes-downscale-factor-0-75-upscale-20x20 [187.258313] Starting dynamic subtest: pipe-A [187.384400] Dynamic subtest pipe-A: SUCCESS (0.127s) [187.392121] Starting dynamic subtest: pipe-B [187.543472] Dynamic subtest pipe-B: SUCCESS (0.157s) [187.551196] Starting dynamic subtest: pipe-C [187.694028] Dynamic subtest pipe-C: SUCCESS (0.149s) [187.701697] Starting dynamic subtest: pipe-D [187.837532] Dynamic subtest pipe-D: SUCCESS (0.142s) [187.838559] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (0.578s) [188.023654] [076/131] (843s left) gem_userptr_blits (stress-mm) [188.074709] Starting subtest: stress-mm [193.495881] Subtest stress-mm: SUCCESS (5.369s) [193.588885] [077/131] (838s left) i915_hangman (gt-error-state-capture) [193.636132] Starting subtest: gt-error-state-capture [193.636877] Starting dynamic subtest: rcs0 [203.088267] Dynamic subtest rcs0: SUCCESS (9.436s) [203.100946] Starting dynamic subtest: bcs0 [213.031902] Dynamic subtest bcs0: SUCCESS (9.934s) [213.049412] Starting dynamic subtest: vcs0 [223.021159] Dynamic subtest vcs0: SUCCESS (9.995s) [223.039480] Starting dynamic subtest: vcs1 [232.998734] Dynamic subtest vcs1: SUCCESS (9.982s) [233.009106] Starting dynamic subtest: vecs0 [243.057987] Dynamic subtest vecs0: SUCCESS (10.060s) [243.059072] Subtest gt-error-state-capture: SUCCESS (49.416s) [243.188021] [078/131] (788s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs) [243.284005] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs [243.284773] Starting dynamic subtest: pipe-A-HDMI-A-1 [243.287672] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [243.297629] Starting dynamic subtest: pipe-B-HDMI-A-1 [243.300530] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [243.310962] Starting dynamic subtest: pipe-C-HDMI-A-1 [243.313847] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [243.323249] Starting dynamic subtest: pipe-D-HDMI-A-1 [243.326177] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [243.327660] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SKIP (0.009s) [243.549456] [079/131] (788s left) gem_eio (in-flight-immediate) [243.593860] Starting subtest: in-flight-immediate [245.850841] Subtest in-flight-immediate: SUCCESS (2.256s) [245.969070] [080/131] (785s left) gem_userptr_blits (dmabuf-sync) [246.017787] Starting subtest: dmabuf-sync [246.020666] Subtest dmabuf-sync: SKIP (0.002s) [246.144767] [081/131] (785s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render) [246.239047] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render [246.240410] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [246.337006] [082/131] (785s left) kms_atomic_interruptible (atomic-setmode) [246.427187] Starting subtest: atomic-setmode [246.428961] Starting dynamic subtest: pipe-A-HDMI-A-1 [252.631327] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.202s) [252.632098] Subtest atomic-setmode: SUCCESS (6.204s) [252.756061] [083/131] (779s left) gem_exec_schedule (u-lateslice) [252.806065] Starting subtest: u-lateslice [252.806762] Starting dynamic subtest: rcs0 [252.821586] Dynamic subtest rcs0: SUCCESS (0.015s) [252.830034] Starting dynamic subtest: bcs0 [252.836341] Dynamic subtest bcs0: SUCCESS (0.014s) [252.843847] Starting dynamic subtest: vcs0 [252.850382] Dynamic subtest vcs0: SUCCESS (0.013s) [252.859838] Starting dynamic subtest: vcs1 [252.867437] Dynamic subtest vcs1: SUCCESS (0.016s) [252.875233] Starting dynamic subtest: vecs0 [252.882277] Dynamic subtest vecs0: SUCCESS (0.014s) [252.883140] Subtest u-lateslice: SUCCESS (0.077s) [253.194179] [084/131] (778s left) gem_exec_reloc (basic-cpu-gtt-noreloc) [253.234393] Starting subtest: basic-cpu-gtt-noreloc [253.237276] Subtest basic-cpu-gtt-noreloc: SUCCESS (0.003s) [253.355209] [085/131] (778s left) kms_psr (psr2-sprite-plane-move) [253.448148] Subtest psr2-sprite-plane-move: SKIP (0.000s) [253.491098] [086/131] (778s left) syncobj_wait (single-wait-all-for-submit-signaled) [253.528366] Starting subtest: single-wait-all-for-submit-signaled [253.529117] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [253.590783] [087/131] (778s left) kms_psr (fbc-psr-primary-mmap-gtt) [253.682451] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.000s) [253.725799] [088/131] (778s left) gem_mmap (big-bo) [253.762656] Starting subtest: big-bo [254.181006] Subtest big-bo: SUCCESS (0.409s) [254.258619] [089/131] (777s left) kms_flip (flip-vs-fences) [254.397043] Starting subtest: flip-vs-fences [254.399439] Starting dynamic subtest: A-HDMI-A1 [262.163835] Dynamic subtest A-HDMI-A1: SUCCESS (7.738s) [262.173209] Starting dynamic subtest: B-HDMI-A1 [269.815119] Dynamic subtest B-HDMI-A1: SUCCESS (7.671s) [269.824397] Starting dynamic subtest: C-HDMI-A1 [277.593334] Dynamic subtest C-HDMI-A1: SUCCESS (7.771s) [277.600708] Starting dynamic subtest: D-HDMI-A1 [285.362530] Dynamic subtest D-HDMI-A1: SUCCESS (7.773s) [285.363234] Subtest flip-vs-fences: SUCCESS (30.961s) [285.574635] [090/131] (746s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled) [285.622148] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled [285.622894] Starting dynamic subtest: smem [285.697553] Dynamic subtest smem: SUCCESS (0.075s) [285.698340] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SUCCESS (0.076s) [285.882632] [091/131] (746s left) gem_exec_balancer (waits) [285.929471] Starting subtest: waits [292.557581] Subtest waits: SUCCESS (6.621s) [292.740742] [092/131] (739s left) gen9_exec_parse (shadow-peek) [292.780451] Subtest shadow-peek: SKIP (0.000s) [292.821204] [093/131] (739s left) gem_fence_thrash (bo-copy) [292.859718] Starting subtest: bo-copy [294.174068] Subtest bo-copy: SUCCESS (1.307s) [294.267724] [094/131] (737s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt) [294.363777] Starting subtest: psr-farfromfence-mmap-gtt [294.365195] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s) [294.480364] [095/131] (737s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [294.578698] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip [294.958965] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.380s) [295.115777] [096/131] (737s left) kms_content_protection (mei-interface) [295.217400] Starting subtest: mei-interface [295.563994] Subtest mei-interface: SKIP (0.345s) [295.734406] [097/131] (736s left) gem_mmap_gtt (fault-concurrent) [295.772731] Starting subtest: fault-concurrent [298.463208] Subtest fault-concurrent: SUCCESS (2.657s) [298.535587] [098/131] (733s left) api_intel_allocator (open-vm) [298.573115] Starting subtest: open-vm [298.573831] Subtest open-vm: SUCCESS (0.001s) [298.688422] [099/131] (733s left) dmabuf_sync_file (import-multiple-read-write) [298.725679] Starting subtest: import-multiple-read-write [298.729884] Subtest import-multiple-read-write: SUCCESS (0.004s) [298.776203] [100/131] (733s left) syncobj_basic (bad-handle-to-fd) [298.811265] Starting subtest: bad-handle-to-fd [298.812044] Subtest bad-handle-to-fd: SUCCESS (0.000s) [298.874306] [101/131] (733s left) gem_exec_create (basic) [298.919995] Starting subtest: basic [298.920837] Starting dynamic subtest: smem [300.970013] Dynamic subtest smem: SUCCESS (2.050s) [300.970825] Subtest basic: SUCCESS (2.051s) [301.156999] [102/131] (731s left) gem_exec_await (wide-contexts) [301.233225] Starting subtest: wide-contexts [322.958043] Subtest wide-contexts: SUCCESS (21.727s) [323.159584] [103/131] (709s left) kms_psr (fbc-pr-cursor-plane-move) [323.301094] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s) [323.347941] [104/131] (709s left) kms_psr (pr-sprite-render) [323.440018] Subtest pr-sprite-render: SKIP (0.000s) [323.480425] [105/131] (709s left) kms_big_fb (y-tiled-16bpp-rotate-180) [323.581678] Starting subtest: y-tiled-16bpp-rotate-180 [324.828040] Subtest y-tiled-16bpp-rotate-180: SUCCESS (1.246s) [324.987456] [106/131] (707s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180) [325.101044] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180 [325.719854] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.618s) [325.847961] [107/131] (706s left) gem_ringfill (basic-all) [326.079480] Starting subtest: basic-all [327.218736] Subtest basic-all: SUCCESS (1.131s) [327.358751] [108/131] (705s left) kms_flip (2x-flip-vs-dpms) [327.455298] Starting subtest: 2x-flip-vs-dpms [327.464707] Subtest 2x-flip-vs-dpms: SKIP (0.009s) [327.530346] [109/131] (705s left) syncobj_timeline (wait-all-interrupted) [327.573702] Starting subtest: wait-all-interrupted [327.676328] Subtest wait-all-interrupted: SUCCESS (0.102s) [327.748943] [110/131] (705s left) kms_big_fb (x-tiled-16bpp-rotate-0) [327.845186] Starting subtest: x-tiled-16bpp-rotate-0 [329.120499] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.275s) [329.271957] [111/131] (703s left) kms_plane (plane-position-hole-dpms) [329.364725] Starting subtest: plane-position-hole-dpms [329.576628] Starting dynamic subtest: pipe-A-plane-1 [329.911701] Dynamic subtest pipe-A-plane-1: SUCCESS (0.335s) [329.919379] Starting dynamic subtest: pipe-A-plane-2 [330.209676] Dynamic subtest pipe-A-plane-2: SUCCESS (0.297s) [330.217388] Starting dynamic subtest: pipe-A-plane-3 [330.546748] Dynamic subtest pipe-A-plane-3: SUCCESS (0.336s) [330.554437] Starting dynamic subtest: pipe-A-plane-4 [330.880716] Dynamic subtest pipe-A-plane-4: SUCCESS (0.333s) [330.888432] Starting dynamic subtest: pipe-A-plane-5 [331.206885] Dynamic subtest pipe-A-plane-5: SUCCESS (0.326s) [331.215310] Starting dynamic subtest: pipe-A-plane-6 [331.558505] Dynamic subtest pipe-A-plane-6: SUCCESS (0.350s) [331.566327] Starting dynamic subtest: pipe-A-plane-7 [331.567696] Dynamic subtest pipe-A-plane-7: SUCCESS (0.006s) [331.747283] Starting dynamic subtest: pipe-B-plane-1 [332.052970] Dynamic subtest pipe-B-plane-1: SUCCESS (0.315s) [332.062656] Starting dynamic subtest: pipe-B-plane-2 [332.371734] Dynamic subtest pipe-B-plane-2: SUCCESS (0.318s) [332.379368] Starting dynamic subtest: pipe-B-plane-3 [332.695070] Dynamic subtest pipe-B-plane-3: SUCCESS (0.322s) [332.705017] Starting dynamic subtest: pipe-B-plane-4 [333.012011] Dynamic subtest pipe-B-plane-4: SUCCESS (0.316s) [333.021843] Starting dynamic subtest: pipe-B-plane-5 [333.319442] Dynamic subtest pipe-B-plane-5: SUCCESS (0.306s) [333.327279] Starting dynamic subtest: pipe-B-plane-6 [333.618787] Dynamic subtest pipe-B-plane-6: SUCCESS (0.299s) [333.626779] Starting dynamic subtest: pipe-B-plane-7 [333.628275] Dynamic subtest pipe-B-plane-7: SUCCESS (0.006s) [333.629017] Subtest plane-position-hole-dpms: SUCCESS (4.261s) [333.769072] [112/131] (699s left) syncobj_timeline (invalid-signal-bad-pad) [333.812786] Starting subtest: invalid-signal-bad-pad [333.813509] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [333.888145] [113/131] (699s left) gem_exec_params (no-bsd) [333.927481] Starting subtest: no-bsd [333.928211] Subtest no-bsd: SUCCESS (0.001s) [334.045133] [114/131] (699s left) kms_color (ctm-0-75) [334.137388] Starting subtest: ctm-0-75 [334.138106] Starting dynamic subtest: pipe-A-HDMI-A-1 [335.242783] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.104s) [335.251774] Starting dynamic subtest: pipe-B-HDMI-A-1 [336.285728] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.043s) [336.295644] Starting dynamic subtest: pipe-C-HDMI-A-1 [337.316663] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.029s) [337.324600] Starting dynamic subtest: pipe-D-HDMI-A-1 [338.356353] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.039s) [338.357100] Subtest ctm-0-75: SUCCESS (4.219s) [338.517817] [115/131] (694s left) gem_mmap_gtt (big-copy-odd) [338.561344] Starting subtest: big-copy-odd [345.783698] Subtest big-copy-odd: SUCCESS (7.222s) [345.884164] [116/131] (687s left) gem_ctx_persistence (engines-hostile-preempt) [345.950625] Starting subtest: engines-hostile-preempt [345.951442] Starting dynamic subtest: rcs0 [346.060205] Dynamic subtest rcs0: SUCCESS (0.108s) [346.080004] Starting dynamic subtest: bcs0 [346.178155] Dynamic subtest bcs0: SUCCESS (0.116s) [346.198284] Starting dynamic subtest: vcs0 [346.289009] Dynamic subtest vcs0: SUCCESS (0.109s) [346.308604] Starting dynamic subtest: vcs1 [346.394177] Dynamic subtest vcs1: SUCCESS (0.103s) [346.413890] Starting dynamic subtest: vecs0 [346.502024] Dynamic subtest vecs0: SUCCESS (0.106s) [346.503274] Subtest engines-hostile-preempt: SUCCESS (0.552s) [346.578354] [117/131] (686s left) gem_exec_balancer (full-late-pulse) [346.623030] Starting subtest: full-late-pulse [348.018957] Subtest full-late-pulse: SUCCESS (1.395s) [348.193266] [118/131] (685s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted) [348.237130] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted [348.337148] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.104s) [348.412219] [119/131] (684s left) gem_exec_schedule (preempt-other-chain) [348.463499] Starting subtest: preempt-other-chain [348.464388] Starting dynamic subtest: rcs0 [348.496222] Dynamic subtest rcs0: SUCCESS (0.032s) [348.504829] Starting dynamic subtest: bcs0 [348.529881] Dynamic subtest bcs0: SUCCESS (0.033s) [348.538422] Starting dynamic subtest: vcs0 [348.565126] Dynamic subtest vcs0: SUCCESS (0.034s) [348.573710] Starting dynamic subtest: vcs1 [348.599951] Dynamic subtest vcs1: SUCCESS (0.034s) [348.608448] Starting dynamic subtest: vecs0 [348.633633] Dynamic subtest vecs0: SUCCESS (0.033s) [348.634449] Subtest preempt-other-chain: SUCCESS (0.170s) [348.939838] [120/131] (684s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling) [349.034513] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling [349.036451] Starting dynamic subtest: pipe-A-valid-mode [350.112218] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.076s) [350.112979] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SUCCESS (1.079s) [350.259543] [121/131] (683s left) gem_exec_params (sol-reset-invalid) [350.302449] Starting subtest: sol-reset-invalid [350.303234] Subtest sol-reset-invalid: SUCCESS (0.001s) [350.411448] [122/131] (682s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs) [350.505981] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs [350.506752] Starting dynamic subtest: pipe-A-HDMI-A-1 [350.514049] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [350.525556] Starting dynamic subtest: pipe-B-HDMI-A-1 [350.532681] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [350.543655] Starting dynamic subtest: pipe-C-HDMI-A-1 [350.550829] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [350.558217] Starting dynamic subtest: pipe-D-HDMI-A-1 [350.565307] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [350.566785] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.007s) [350.762527] [123/131] (682s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes) [350.800791] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s) [350.842173] [124/131] (682s left) core_getversion (basic) [350.877495] Starting subtest: basic [350.879026] Subtest basic: SUCCESS (0.000s) [350.938805] [125/131] (682s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff) [351.032098] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff [351.033596] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [351.132119] [126/131] (682s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc) [351.225736] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc [351.227286] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [351.323712] [127/131] (682s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs) [351.413888] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs [351.415508] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s) [351.559139] [128/131] (682s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff) [351.656306] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff [353.141220] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (1.485s) [353.268840] [129/131] (680s left) gem_exec_params (invalid-bsd1-flag-on-vebox) [353.307265] Starting subtest: invalid-bsd1-flag-on-vebox [353.308063] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s) [353.401855] [130/131] (680s left) gem_eio (create-ext) [353.447224] Starting subtest: create-ext [353.469112] Subtest create-ext: SUCCESS (0.022s) [353.592804] [131/131] (680s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted) [353.630499] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted [353.631242] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s) [353.697747] Closing watchdogs Done.