[39.949521] Initializing watchdogs [39.949565] /dev/watchdog0 [39.955077] [001/143] (960s left) gem_exec_suspend (basic-s0) [40.022231] Starting subtest: basic-S0 [40.025446] Starting dynamic subtest: smem [60.450334] Dynamic subtest smem: SUCCESS (6.432s) [60.453588] Subtest basic-S0: SUCCESS (6.433s) [60.634804] [002/143] (953s left) gem_userptr_blits (sync-unmap-after-close) [60.724118] Starting subtest: sync-unmap-after-close [60.747108] Subtest sync-unmap-after-close: SUCCESS (0.023s) [60.855775] [003/143] (953s left) gem_userptr_blits (usage-restrictions) [60.938215] Starting subtest: usage-restrictions [60.940843] Subtest usage-restrictions: SUCCESS (0.000s) [61.046698] [004/143] (953s left) gem_ctx_param (get-priority-new-ctx) [61.117722] Starting subtest: get-priority-new-ctx [61.120168] Subtest get-priority-new-ctx: SUCCESS (0.002s) [61.202710] [005/143] (953s left) gem_ctx_persistence (file) [61.259993] Starting subtest: file [61.370174] Subtest file: SUCCESS (0.110s) [61.468638] [006/143] (953s left) gem_exec_balancer (parallel-keep-in-fence) [61.760878] Starting subtest: parallel-keep-in-fence [62.663598] Subtest parallel-keep-in-fence: SUCCESS (0.903s) [62.751224] [007/143] (951s left) syncobj_timeline (multi-wait-available-signaled) [62.837576] Starting subtest: multi-wait-available-signaled [62.840211] Subtest multi-wait-available-signaled: SUCCESS (0.001s) [62.926647] [008/143] (951s left) gem_mmap_gtt (cpuset-medium-copy-xy) [63.007365] Subtest cpuset-medium-copy-XY: SKIP (0.000s) [63.057942] [009/143] (951s left) i915_pm_sseu (full-enable) [63.126552] Subtest full-enable: SKIP (0.000s) [63.203957] [010/143] (951s left) kms_big_fb (x-tiled-32bpp-rotate-180) [63.348448] Starting subtest: x-tiled-32bpp-rotate-180 [64.966527] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.619s) [65.117364] [011/143] (949s left) kms_big_fb (y-tiled-64bpp-rotate-90) [65.189980] Starting subtest: y-tiled-64bpp-rotate-90 [65.193806] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s) [65.277900] [012/143] (949s left) sw_sync (sync_busy) [65.345253] Starting subtest: sync_busy [65.347507] Subtest sync_busy: SUCCESS (0.001s) [65.397782] [013/143] (949s left) kms_busy (basic) [65.470279] Starting subtest: basic [65.472357] Starting dynamic subtest: flip [66.102666] Dynamic subtest flip: SUCCESS (0.632s) [66.115835] Starting dynamic subtest: modeset [69.842393] Dynamic subtest modeset: SUCCESS (3.739s) [69.845046] Subtest basic: SUCCESS (4.371s) [70.758684] [014/143] (944s left) kms_rotation_crc (bad-pixel-format) [70.831819] Starting subtest: bad-pixel-format [70.836439] Subtest bad-pixel-format: SKIP (0.001s) [70.888441] [015/143] (943s left) kms_writeback (writeback-invalid-parameters) [70.983889] Subtest writeback-invalid-parameters: SKIP (0.000s) [71.003035] [016/143] (943s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers) [71.067848] Starting subtest: plane-downscale-factor-0-75-with-modifiers [71.070285] Starting dynamic subtest: pipe-A-eDP-1 [71.787415] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.722s) [71.805428] Starting dynamic subtest: pipe-B-eDP-1 [73.719594] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.929s) [73.737023] Starting dynamic subtest: pipe-C-eDP-1 [75.618809] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.898s) [75.636160] Starting dynamic subtest: pipe-D-eDP-1 [77.650711] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.029s) [77.653369] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (6.585s) [78.895048] [017/143] (935s left) gem_render_copy_redux (interruptible) [78.980850] Starting subtest: interruptible [79.317123] Subtest interruptible: SUCCESS (0.338s) [79.418195] [018/143] (935s left) kms_psr2_sf (primary-plane-update-sf-dmg-area-big-fb) [84.703943] Starting subtest: primary-plane-update-sf-dmg-area-big-fb [84.706707] Starting dynamic subtest: pipe-A-eDP-1 [92.914063] Dynamic subtest pipe-A-eDP-1: SUCCESS (8.208s) [92.932049] Starting dynamic subtest: pipe-B-eDP-1 [101.124893] Dynamic subtest pipe-B-eDP-1: SUCCESS (8.207s) [101.127588] Subtest primary-plane-update-sf-dmg-area-big-fb: SUCCESS (16.421s) [102.008331] [019/143] (912s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4-tiled-mtl-mc-ccs) [102.451600] Starting subtest: pipe-C-crc-sprite-planes-basic-4-tiled-mtl-mc-ccs [108.016955] Subtest pipe-C-crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (5.566s) [109.217057] [020/143] (905s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa [109.295045] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled [109.397547] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.102s) [109.471314] [021/143] (905s left) kms_pm_rpm (legacy-planes-dpms) [111.597642] Starting subtest: legacy-planes-dpms [111.601564] Starting dynamic subtest: plane-40 [135.317023] Dynamic subtest plane-40: SUCCESS (23.720s) [135.333605] Starting dynamic subtest: plane-49 [159.747178] Dynamic subtest plane-49: SUCCESS (24.429s) [159.765108] Starting dynamic subtest: plane-58 [183.979609] Dynamic subtest plane-58: SUCCESS (24.231s) [183.997450] Starting dynamic subtest: plane-67 [208.217930] Dynamic subtest plane-67: SUCCESS (24.238s) [208.220611] Subtest legacy-planes-dpms: SUCCESS (96.622s) [209.393265] [022/143] (805s left) kms_psr (psr-cursor-blt) [209.486524] Starting subtest: psr-cursor-blt [209.489550] Starting dynamic subtest: eDP-1 [211.337236] Dynamic subtest eDP-1: SUCCESS (1.848s) [211.339836] Subtest psr-cursor-blt: SUCCESS (1.850s) [212.256135] [023/143] (802s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled) [212.329645] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled [212.334587] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s) [212.514576] [024/143] (802s left) v3d/v3d_submit_csd (valid-multisync-submission) [212.595104] Subtest valid-multisync-submission: SKIP (0.000s) [212.632322] [025/143] (802s left) kms_rotation_crc (primary-y-tiled-reflect-x-180) [212.690079] Starting subtest: primary-y-tiled-reflect-x-180 [212.751501] Subtest primary-y-tiled-reflect-x-180: SKIP (0.059s) [212.853051] [026/143] (802s left) gem_exec_capture (capture-recoverable) [212.940184] Starting subtest: capture-recoverable [212.946205] Subtest capture-recoverable: SUCCESS (0.008s) [213.052297] [027/143] (802s left) i915_pm_rpm (gem-evict-pwrite) [214.569487] Starting subtest: gem-evict-pwrite [214.575036] Subtest gem-evict-pwrite: SKIP (0.000s) [215.361328] [028/143] (799s left) kms_sysfs_edid_timing [215.519826] [029/143] (799s left) perf_pmu (enable-race) [215.564395] Starting subtest: enable-race [215.566595] Starting dynamic subtest: rcs0 [228.327024] Dynamic subtest rcs0: SUCCESS (12.766s) [228.337778] Starting dynamic subtest: bcs0 [241.084673] Dynamic subtest bcs0: SUCCESS (12.756s) [241.095268] Starting dynamic subtest: vcs0 [256.482784] Dynamic subtest vcs0: SUCCESS (15.396s) [256.500159] Starting dynamic subtest: vcs1 [272.417754] Dynamic subtest vcs1: SUCCESS (15.933s) [272.435478] Starting dynamic subtest: vecs0 [288.418140] Dynamic subtest vecs0: SUCCESS (15.999s) [288.436379] Starting dynamic subtest: ccs0 [301.174572] Dynamic subtest ccs0: SUCCESS (12.754s) [301.177718] Subtest enable-race: SUCCESS (85.612s) [301.262284] [030/143] (713s left) kms_invalid_mode (uint-max-clock) [301.384298] Starting subtest: uint-max-clock [301.386885] Starting dynamic subtest: pipe-A-eDP-1 [301.681796] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.299s) [301.699822] Starting dynamic subtest: pipe-B-eDP-1 [301.702555] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [301.715625] Starting dynamic subtest: pipe-C-eDP-1 [301.718224] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [301.727716] Starting dynamic subtest: pipe-D-eDP-1 [301.729775] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [301.731939] Subtest uint-max-clock: SUCCESS (0.310s) [302.563550] [031/143] (712s left) drm_fdinfo (memory-info-purgeable) [302.626662] Starting subtest: memory-info-purgeable [302.629525] Starting dynamic subtest: smem0 [305.366476] Dynamic subtest smem0: SUCCESS (2.742s) [305.368895] Subtest memory-info-purgeable: SUCCESS (2.742s) [305.433853] [032/143] (709s left) kms_ccs (pipe-d-random-ccs-data-y-tiled-gen12-mc-ccs) [305.907967] Starting subtest: pipe-D-random-ccs-data-y-tiled-gen12-mc-ccs [305.915584] Subtest pipe-D-random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.000s) [306.731806] [033/143] (708s left) kms_chamelium_hpd (dp-hpd-storm-disable) [307.138785] Subtest dp-hpd-storm-disable: SKIP (0.000s) [308.033490] [034/143] (707s left) gem_partial_pwrite_pread (reads-uncached) [308.112257] Subtest reads-uncached: SKIP (0.000s) [308.174681] [035/143] (707s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt) [308.280515] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt [308.284489] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [308.381246] [036/143] (707s left) kms_dsc (dsc-with-bpc) [308.459151] Starting subtest: dsc-with-bpc [308.463674] Subtest dsc-with-bpc: SKIP (0.000s) [308.524947] [037/143] (706s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary) [308.609802] Starting subtest: psr-shrfb-scaledprimary [312.475257] Subtest psr-shrfb-scaledprimary: SUCCESS (3.871s) [312.584231] [038/143] (702s left) kms_ccs (pipe-d-bad-aux-stride-y-tiled-ccs) [313.043048] Starting subtest: pipe-D-bad-aux-stride-y-tiled-ccs [313.048996] Subtest pipe-D-bad-aux-stride-y-tiled-ccs: SKIP (0.000s) [313.889436] [039/143] (701s left) kms_ccs (pipe-b-bad-aux-stride-4-tiled-mtl-rc-ccs-cc) [314.321505] Starting subtest: pipe-B-bad-aux-stride-4-tiled-mtl-rc-ccs-cc [314.324374] Subtest pipe-B-bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.000s) [315.234014] [040/143] (700s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling) [315.340608] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling [315.343132] Starting dynamic subtest: pipe-A-default-mode [315.643976] Dynamic subtest pipe-A-default-mode: SKIP (0.302s) [315.649472] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.304s) [316.580965] [041/143] (699s left) kms_psr (psr2-cursor-plane-move) [316.677244] Starting subtest: psr2-cursor-plane-move [316.679603] Starting dynamic subtest: eDP-1 [318.477541] Dynamic subtest eDP-1: SUCCESS (1.798s) [318.480339] Subtest psr2-cursor-plane-move: SUCCESS (1.800s) [319.401087] [042/143] (696s left) kms_ccs (pipe-d-bad-rotation-90-4-tiled-dg2-rc-ccs-cc) [319.853077] Starting subtest: pipe-D-bad-rotation-90-4-tiled-dg2-rc-ccs-cc [319.858467] Subtest pipe-D-bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s) [320.672158] [043/143] (694s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode) [321.051492] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s) [321.927301] [044/143] (693s left) gem_mmap_gtt (basic-small-bo) [322.003554] Subtest basic-small-bo: SKIP (0.000s) [322.039640] [045/143] (693s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic) [322.144509] Starting subtest: nonblocking-modeset-vs-cursor-atomic [323.697758] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.550s) [324.592401] [046/143] (691s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move) [324.717074] Starting subtest: fbc-1p-primscrn-spr-indfb-move [327.915561] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (3.203s) [328.054313] [047/143] (687s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow) [328.158271] Starting subtest: yf-tiled-addfb-size-offset-overflow [328.163196] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s) [328.251242] [048/143] (687s left) kms_psr (fbc-pr-cursor-blt) [328.363565] Starting subtest: fbc-pr-cursor-blt [328.367500] Subtest fbc-pr-cursor-blt: SKIP (0.000s) [328.471509] [049/143] (687s left) gem_exec_fence (basic-wait) [328.676217] Starting subtest: basic-wait [328.678852] Starting dynamic subtest: rcs0 [328.735400] Dynamic subtest rcs0: SUCCESS (0.059s) [328.753074] Starting dynamic subtest: bcs0 [328.787257] Dynamic subtest bcs0: SUCCESS (0.051s) [328.804365] Starting dynamic subtest: vcs0 [328.843959] Dynamic subtest vcs0: SUCCESS (0.055s) [328.861092] Starting dynamic subtest: vcs1 [328.895754] Dynamic subtest vcs1: SUCCESS (0.050s) [328.912798] Starting dynamic subtest: vecs0 [328.947045] Dynamic subtest vecs0: SUCCESS (0.049s) [328.964256] Starting dynamic subtest: ccs0 [328.999967] Dynamic subtest ccs0: SUCCESS (0.051s) [329.002693] Subtest basic-wait: SUCCESS (0.326s) [330.538248] [050/143] (685s left) gem_ctx_shared (q-promotion) [330.630135] Starting subtest: Q-promotion [330.632894] Starting dynamic subtest: rcs0 [330.762032] Dynamic subtest rcs0: SUCCESS (0.129s) [330.787007] Starting dynamic subtest: vcs0 [330.865817] Dynamic subtest vcs0: SUCCESS (0.104s) [330.886024] Starting dynamic subtest: vcs1 [330.949301] Dynamic subtest vcs1: SUCCESS (0.082s) [330.977411] Starting dynamic subtest: vecs0 [331.032815] Dynamic subtest vecs0: SUCCESS (0.083s) [331.058346] Starting dynamic subtest: ccs0 [331.126079] Dynamic subtest ccs0: SUCCESS (0.093s) [331.128671] Subtest Q-promotion: SUCCESS (0.496s) [332.546262] [051/143] (683s left) syncobj_timeline (wait-for-submit-snapshot) [332.635714] Starting subtest: wait-for-submit-snapshot [332.717302] Subtest wait-for-submit-snapshot: SUCCESS (0.082s) [332.792721] [052/143] (683s left) kms_psr (fbc-psr2-cursor-blt) [332.874727] Starting subtest: fbc-psr2-cursor-blt [332.877014] Starting dynamic subtest: eDP-1 [332.881568] Dynamic subtest eDP-1: SKIP (0.000s) [332.885921] Subtest fbc-psr2-cursor-blt: SKIP (0.001s) [332.983297] [053/143] (682s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu) [333.091491] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu [337.672116] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (4.586s) [337.792575] [054/143] (678s left) gem_exec_reloc (basic-wc-cpu) [337.861127] Subtest basic-wc-cpu: SKIP (0.000s) [337.903429] [055/143] (678s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size) [338.022521] Starting subtest: cursorB-vs-flipB-varying-size [338.027387] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s) [338.131691] [056/143] (677s left) kms_atomic_transition (modeset-transition-fencing) [338.226485] Starting subtest: modeset-transition-fencing [338.229111] Starting dynamic subtest: 1x-outputs [350.395467] Dynamic subtest 1x-outputs: SUCCESS (12.168s) [350.700307] Subtest modeset-transition-fencing: SUCCESS (12.472s) [351.576940] [057/143] (664s left) gem_exec_whisper (basic-queues-forked-all) [351.632944] Starting subtest: basic-queues-forked-all [378.956970] Subtest basic-queues-forked-all: SUCCESS (27.322s) [379.144773] [058/143] (636s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted) [379.224828] Starting subtest: etime-single-wait-for-submit-available-unsubmitted [379.334243] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.108s) [379.417748] [059/143] (636s left) gem_userptr_blits (map-fixed-invalidate) [379.501135] Starting subtest: map-fixed-invalidate [379.505728] Subtest map-fixed-invalidate: SKIP (0.000s) [379.621946] [060/143] (636s left) kms_lease (simple-lease) [379.707601] Starting subtest: simple-lease [379.710315] Starting dynamic subtest: pipe-A-eDP-1 [380.217701] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.508s) [380.244543] Starting dynamic subtest: pipe-B-eDP-1 [381.788545] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.564s) [381.798808] Starting dynamic subtest: pipe-C-eDP-1 [383.304671] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.516s) [383.323957] Starting dynamic subtest: pipe-D-eDP-1 [384.870309] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.562s) [384.872834] Subtest simple-lease: SUCCESS (5.163s) [385.771742] [061/143] (630s left) gem_softpin (allocator-nopin) [385.822970] Starting subtest: allocator-nopin [385.906865] Subtest allocator-nopin: SUCCESS (0.084s) [386.002866] [062/143] (630s left) kms_flip (2x-dpms-vs-vblank-race) [386.112314] Starting subtest: 2x-dpms-vs-vblank-race [386.123878] Subtest 2x-dpms-vs-vblank-race: SKIP (0.013s) [386.205213] [063/143] (630s left) gem_partial_pwrite_pread (write-uncached) [386.277772] Subtest write-uncached: SKIP (0.000s) [386.339263] [064/143] (629s left) gen9_exec_parse (secure-batches) [386.400884] Subtest secure-batches: SKIP (0.000s) [386.438489] [065/143] (629s left) kms_flip (2x-flip-vs-expired-vblank-interruptible) [386.535727] Starting subtest: 2x-flip-vs-expired-vblank-interruptible [386.547498] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.013s) [386.616869] [066/143] (629s left) gem_exec_params (invalid-bsd2-flag-on-vebox) [386.690704] Starting subtest: invalid-bsd2-flag-on-vebox [386.693101] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s) [386.774281] [067/143] (629s left) i915_hangman (engine-engine-hang) [386.837103] Starting subtest: engine-engine-hang [386.839021] Starting dynamic subtest: rcs0 [388.416804] Dynamic subtest rcs0: SUCCESS (1.579s) [388.437438] Starting dynamic subtest: bcs0 [390.399157] Dynamic subtest bcs0: SUCCESS (1.981s) [390.419359] Starting dynamic subtest: vcs0 [392.383162] Dynamic subtest vcs0: SUCCESS (1.982s) [392.404677] Starting dynamic subtest: vcs1 [394.431275] Dynamic subtest vcs1: SUCCESS (2.046s) [394.451828] Starting dynamic subtest: vecs0 [396.416447] Dynamic subtest vecs0: SUCCESS (1.982s) [396.438526] Starting dynamic subtest: ccs0 [398.400317] Dynamic subtest ccs0: SUCCESS (1.982s) [398.403453] Subtest engine-engine-hang: SUCCESS (11.563s) [398.526221] [068/143] (617s left) sw_sync (sync_merge_invalid) [398.593999] Starting subtest: sync_merge_invalid [398.612044] Subtest sync_merge_invalid: SUCCESS (0.018s) [398.681570] [069/143] (617s left) syncobj_wait (invalid-wait-illegal-handle) [398.764098] Starting subtest: invalid-wait-illegal-handle [398.766594] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [398.853776] [070/143] (617s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling) [398.958400] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling [398.961249] Starting dynamic subtest: pipe-A-default-mode [399.252298] Dynamic subtest pipe-A-default-mode: SKIP (0.291s) [399.257698] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.294s) [400.181748] [071/143] (616s left) kms_ccs (pipe-a-crc-primary-rotation-180-4-tiled-mtl-rc-ccs) [400.585683] Starting subtest: pipe-A-crc-primary-rotation-180-4-tiled-mtl-rc-ccs [401.670615] Subtest pipe-A-crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (1.082s) [402.856609] [072/143] (613s left) api_intel_allocator (reserve-simple) [402.944054] Starting subtest: reserve-simple [402.950241] Subtest reserve-simple: SUCCESS (0.005s) [403.032277] [073/143] (613s left) kms_cursor_crc (cursor-offscreen-512x512) [403.317457] Starting subtest: cursor-offscreen-512x512 [403.322529] Subtest cursor-offscreen-512x512: SKIP (0.002s) [403.465545] [074/143] (613s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy) [403.551093] Starting subtest: map-fixed-invalidate-overlap-busy [403.556174] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s) [403.665662] [075/143] (613s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move) [403.731029] Starting subtest: psr-1p-primscrn-spr-indfb-move [409.403642] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (5.675s) [409.530623] [076/143] (607s left) kms_plane (plane-panning-bottom-right) [409.620674] Starting subtest: plane-panning-bottom-right [409.623104] Starting dynamic subtest: pipe-A [411.354560] Dynamic subtest pipe-A: SUCCESS (1.734s) [411.373551] Starting dynamic subtest: pipe-B [413.878335] Dynamic subtest pipe-B: SUCCESS (2.519s) [413.880828] Subtest plane-panning-bottom-right: SUCCESS (4.258s) [414.820553] [077/143] (601s left) kms_ccs (pipe-a-bad-pixel-format-y-tiled-ccs) [414.906361] Starting subtest: pipe-A-bad-pixel-format-y-tiled-ccs [414.911052] Subtest pipe-A-bad-pixel-format-y-tiled-ccs: SKIP (0.000s) [416.097944] [078/143] (600s left) kms_ccs (pipe-b-random-ccs-data-4-tiled-mtl-rc-ccs) [416.519115] Starting subtest: pipe-B-random-ccs-data-4-tiled-mtl-rc-ccs [417.341367] Subtest pipe-B-random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (0.822s) [418.534357] [079/143] (598s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled) [418.592170] Starting subtest: yf-tiled-ccs-to-yf-tiled [418.596766] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s) [418.782023] [080/143] (598s left) prime_mmap (test_map_unmap) [418.872722] Starting subtest: test_map_unmap [418.875365] Starting dynamic subtest: test_map_unmap-smem [418.905263] Dynamic subtest test_map_unmap-smem: SUCCESS (0.034s) [418.908167] Subtest test_map_unmap: SUCCESS (0.035s) [418.996001] [081/143] (597s left) kms_addfb_basic (bad-pitch-65536) [419.081931] Starting subtest: bad-pitch-65536 [419.084106] Subtest bad-pitch-65536: SUCCESS (0.000s) [419.175360] [082/143] (597s left) api_intel_bb (intel-bb-blit-x) [419.230333] Starting subtest: intel-bb-blit-x [422.825309] Subtest intel-bb-blit-x: SUCCESS (3.593s) [422.925163] [083/143] (594s left) kms_scaling_modes (scaling-mode-none) [423.008496] Starting subtest: scaling-mode-none [423.010926] Starting dynamic subtest: pipe-A-eDP-1 [423.108329] Dynamic subtest pipe-A-eDP-1: SKIP (0.098s) [423.128897] Starting dynamic subtest: pipe-B-eDP-1 [423.163846] Dynamic subtest pipe-B-eDP-1: SKIP (0.054s) [423.182823] Starting dynamic subtest: pipe-C-eDP-1 [423.194719] Dynamic subtest pipe-C-eDP-1: SKIP (0.029s) [423.210676] Starting dynamic subtest: pipe-D-eDP-1 [423.222926] Dynamic subtest pipe-D-eDP-1: SKIP (0.029s) [423.226972] Subtest scaling-mode-none: SKIP (0.215s) [423.316315] [084/143] (593s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt) [423.416091] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt [423.420552] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [423.488505] [085/143] (593s left) kms_ccs (pipe-a-random-ccs-data-y-tiled-gen12-rc-ccs-cc) [423.838060] Starting subtest: pipe-A-random-ccs-data-y-tiled-gen12-rc-ccs-cc [423.845642] Subtest pipe-A-random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s) [424.757506] [086/143] (592s left) gem_exec_fence (syncobj-wait) [425.260146] Starting subtest: syncobj-wait [426.498982] Subtest syncobj-wait: SUCCESS (1.238s) [428.492550] [087/143] (588s left) kms_pm_backlight (fade-with-suspend) [428.613360] Starting subtest: fade-with-suspend [444.513433] Starting dynamic subtest: eDP-1 [447.181981] Dynamic subtest eDP-1: SUCCESS (2.671s) [447.184603] Subtest fade-with-suspend: SUCCESS (3.924s) [448.091061] [088/143] (583s left) kms_flip (plain-flip-ts-check) [448.192219] Starting subtest: plain-flip-ts-check [448.199463] Starting dynamic subtest: A-eDP1 [457.161966] Dynamic subtest A-eDP1: SUCCESS (8.963s) [457.186060] Starting dynamic subtest: B-eDP1 [466.131258] Dynamic subtest B-eDP1: SUCCESS (8.968s) [466.152328] Starting dynamic subtest: C-eDP1 [475.136522] Dynamic subtest C-eDP1: SUCCESS (9.000s) [475.157704] Starting dynamic subtest: D-eDP1 [484.169003] Dynamic subtest D-eDP1: SUCCESS (9.033s) [484.177057] Subtest plain-flip-ts-check: SUCCESS (35.987s) [485.484456] [089/143] (546s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt) [485.563615] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt [488.857886] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (3.298s) [488.994559] [090/143] (542s left) syncobj_eventfd (invalid-bad-pad) [489.073041] Starting subtest: invalid-bad-pad [489.075115] Subtest invalid-bad-pad: SUCCESS (0.000s) [489.159375] [091/143] (542s left) gem_pread (display) [489.243572] Subtest display: SKIP (0.000s) [489.299018] [092/143] (542s left) kms_psr (fbc-psr-primary-mmap-cpu) [489.414933] Starting subtest: fbc-psr-primary-mmap-cpu [489.417313] Starting dynamic subtest: eDP-1 [489.422017] Dynamic subtest eDP-1: SKIP (0.000s) [489.426690] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.002s) [489.543546] [093/143] (542s left) gem_exec_params (cliprects_ptr-dirt) [489.617489] Starting subtest: cliprects_ptr-dirt [489.619591] Subtest cliprects_ptr-dirt: SUCCESS (0.000s) [489.714337] [094/143] (542s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff) [489.800294] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff [489.803959] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [489.873971] [095/143] (542s left) kms_ccs (pipe-b-ccs-on-another-bo-y-tiled-gen12-rc-ccs) [490.241798] Starting subtest: pipe-B-ccs-on-another-bo-y-tiled-gen12-rc-ccs [490.247785] Subtest pipe-B-ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.000s) [491.099797] [096/143] (540s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [491.210919] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip [491.215599] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s) [491.299001] [097/143] (540s left) kms_feature_discovery (display) [491.392008] Starting subtest: display [491.394670] Subtest display: SUCCESS (0.000s) [491.465817] [098/143] (540s left) gem_exec_schedule (semaphore-power) [491.653332] Subtest semaphore-power: SKIP (0.000s) [491.836926] [099/143] (540s left) gem_mmap_gtt (basic-write-gtt) [491.914192] Subtest basic-write-gtt: SKIP (0.000s) [491.953640] [100/143] (540s left) drm_fdinfo (isolation) [492.011449] Starting subtest: isolation [492.013483] Starting dynamic subtest: rcs0 [492.017471] Dynamic subtest rcs0: SKIP (0.000s) [492.037723] Starting dynamic subtest: bcs0 [492.042470] Dynamic subtest bcs0: SKIP (0.000s) [492.056593] Starting dynamic subtest: vcs0 [492.061058] Dynamic subtest vcs0: SKIP (0.000s) [492.077195] Starting dynamic subtest: vcs1 [492.081963] Dynamic subtest vcs1: SKIP (0.000s) [492.098757] Starting dynamic subtest: vecs0 [492.103492] Dynamic subtest vecs0: SKIP (0.000s) [492.114832] Starting dynamic subtest: ccs0 [492.119459] Dynamic subtest ccs0: SKIP (0.000s) [492.124192] Subtest isolation: SKIP (0.002s) [492.154011] [101/143] (539s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc) [492.570019] Starting subtest: pipe-B-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc [492.575675] Subtest pipe-B-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.001s) [493.468217] [102/143] (538s left) kms_chamelium_color (ctm-red-to-blue) [493.558274] Subtest ctm-red-to-blue: SKIP (0.000s) [493.591309] [103/143] (538s left) gem_mmap_gtt (basic-small-copy) [493.672655] Subtest basic-small-copy: SKIP (0.000s) [493.726756] [104/143] (538s left) kms_ccs (pipe-c-ccs-on-another-bo-4-tiled-mtl-mc-ccs) [494.183625] Starting subtest: pipe-C-ccs-on-another-bo-4-tiled-mtl-mc-ccs [494.223991] Subtest pipe-C-ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.040s) [495.004007] [105/143] (537s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite) [495.090024] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite [495.094556] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [495.162824] [106/143] (537s left) kms_sequence (get-idle) [495.227623] Starting subtest: get-idle [495.230390] Starting dynamic subtest: pipe-A-eDP-1 [497.044654] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.815s) [497.063990] Starting dynamic subtest: pipe-B-eDP-1 [499.588741] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.542s) [499.601396] Starting dynamic subtest: pipe-C-eDP-1 [502.137154] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.546s) [502.154731] Starting dynamic subtest: pipe-D-eDP-1 [504.711644] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.569s) [504.714192] Subtest get-idle: SUCCESS (9.484s) [505.628067] [107/143] (526s left) kms_addfb_basic (basic-y-tiled-legacy) [505.715469] Starting subtest: basic-y-tiled-legacy [505.720299] Subtest basic-y-tiled-legacy: SKIP (0.000s) [505.820801] [108/143] (526s left) kms_big_fb (x-tiled-64bpp-rotate-0) [505.902649] Starting subtest: x-tiled-64bpp-rotate-0 [507.575549] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.672s) [507.764358] [109/143] (524s left) kms_rotation_crc (sprite-rotation-90-pos-100-0) [507.861365] Starting subtest: sprite-rotation-90-pos-100-0 [507.865869] Subtest sprite-rotation-90-pos-100-0: SKIP (0.002s) [507.928655] [110/143] (524s left) vc4/vc4_tiling (set-bad-handle) [508.045817] Subtest set-bad-handle: SKIP (0.000s) [508.097720] [111/143] (524s left) perf (non-system-wide-paranoid) [508.237349] Starting subtest: non-system-wide-paranoid [508.283745] Subtest non-system-wide-paranoid: SUCCESS (0.050s) [508.329038] [112/143] (524s left) kms_flip (2x-flip-vs-fences-interruptible) [508.424869] Starting subtest: 2x-flip-vs-fences-interruptible [508.429748] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s) [508.495255] [113/143] (523s left) gem_mmap_wc (bad-size) [508.564262] Subtest bad-size: SKIP (0.000s) [508.610034] [114/143] (523s left) gem_exec_schedule (pi-distinct-iova) [508.822873] Starting subtest: pi-distinct-iova [508.825430] Starting dynamic subtest: rcs0 [508.927994] Dynamic subtest rcs0: SUCCESS (0.106s) [508.950231] Starting dynamic subtest: vcs0 [509.012292] Dynamic subtest vcs0: SUCCESS (0.084s) [509.026875] Starting dynamic subtest: vcs1 [509.064818] Dynamic subtest vcs1: SUCCESS (0.052s) [509.084677] Starting dynamic subtest: vecs0 [509.162196] Dynamic subtest vecs0: SUCCESS (0.098s) [509.181627] Starting dynamic subtest: ccs0 [509.224206] Dynamic subtest ccs0: SUCCESS (0.061s) [509.226874] Subtest pi-distinct-iova: SUCCESS (0.405s) [510.206127] [115/143] (522s left) gem_cs_tlb (engines) [510.284506] Starting subtest: engines [510.286967] Starting dynamic subtest: rcs0 [512.447800] Dynamic subtest rcs0: SUCCESS (2.155s) [512.463655] Starting dynamic subtest: bcs0 [514.598532] Dynamic subtest bcs0: SUCCESS (2.153s) [514.615451] Starting dynamic subtest: vcs0 [516.751139] Dynamic subtest vcs0: SUCCESS (2.152s) [516.762620] Starting dynamic subtest: vcs1 [518.905311] Dynamic subtest vcs1: SUCCESS (2.153s) [518.925772] Starting dynamic subtest: vecs0 [521.059684] Dynamic subtest vecs0: SUCCESS (2.154s) [521.076092] Starting dynamic subtest: ccs0 [523.214498] Dynamic subtest ccs0: SUCCESS (2.155s) [523.216613] Subtest engines: SUCCESS (12.926s) [523.312781] [116/143] (509s left) kms_big_fb (4-tiled-8bpp-rotate-180) [523.401022] Starting subtest: 4-tiled-8bpp-rotate-180 [524.657336] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.259s) [524.780408] [117/143] (507s left) kms_ccs (pipe-d-crc-primary-rotation-180-4-tiled-dg2-rc-ccs) [525.264972] Starting subtest: pipe-D-crc-primary-rotation-180-4-tiled-dg2-rc-ccs [525.271005] Subtest pipe-D-crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.000s) [526.077915] [118/143] (506s left) perf_pmu (most-busy-idle-check-all) [526.134496] Starting subtest: most-busy-idle-check-all [526.136615] Starting dynamic subtest: rcs0 [528.089042] Dynamic subtest rcs0: SUCCESS (1.956s) [528.112460] Starting dynamic subtest: bcs0 [530.072883] Dynamic subtest bcs0: SUCCESS (1.981s) [530.093680] Starting dynamic subtest: vcs0 [532.057238] Dynamic subtest vcs0: SUCCESS (1.982s) [532.078166] Starting dynamic subtest: vcs1 [534.104732] Dynamic subtest vcs1: SUCCESS (2.046s) [534.125790] Starting dynamic subtest: vecs0 [536.089306] Dynamic subtest vecs0: SUCCESS (1.982s) [536.110933] Starting dynamic subtest: ccs0 [538.073263] Dynamic subtest ccs0: SUCCESS (1.982s) [538.076261] Subtest most-busy-idle-check-all: SUCCESS (11.941s) [538.172550] [119/143] (494s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt) [538.281440] Starting subtest: psr-1p-primscrn-indfb-plflip-blt [543.637953] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (5.358s) [543.763474] [120/143] (488s left) syncobj_timeline (multi-wait-signaled) [543.829575] Starting subtest: multi-wait-signaled [543.832195] Subtest multi-wait-signaled: SUCCESS (0.000s) [543.914593] [121/143] (488s left) gem_exec_suspend (basic-s3) [543.999933] Starting subtest: basic-S3 [544.002561] Starting dynamic subtest: smem [565.412762] Dynamic subtest smem: SUCCESS (7.063s) [565.416058] Subtest basic-S3: SUCCESS (7.065s) [565.600729] [122/143] (481s left) kms_color (legacy-gamma) [565.681016] Starting subtest: legacy-gamma [565.683485] Starting dynamic subtest: pipe-A [566.451301] Dynamic subtest pipe-A: SUCCESS (0.769s) [566.470723] Starting dynamic subtest: pipe-B [567.974761] Dynamic subtest pipe-B: SUCCESS (1.521s) [567.996391] Starting dynamic subtest: pipe-C [569.449946] Dynamic subtest pipe-C: SUCCESS (1.474s) [569.470590] Starting dynamic subtest: pipe-D [570.939591] Dynamic subtest pipe-D: SUCCESS (1.488s) [570.942183] Subtest legacy-gamma: SUCCESS (5.257s) [571.879188] [123/143] (475s left) kms_invalid_mode (bad-vsync-start) [571.964824] Starting subtest: bad-vsync-start [571.967423] Starting dynamic subtest: pipe-A-eDP-1 [572.254007] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s) [572.275144] Starting dynamic subtest: pipe-B-eDP-1 [572.278007] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s) [572.293099] Starting dynamic subtest: pipe-C-eDP-1 [572.296249] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [572.306800] Starting dynamic subtest: pipe-D-eDP-1 [572.309786] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [572.312697] Subtest bad-vsync-start: SUCCESS (0.301s) [573.161891] [124/143] (474s left) kms_cursor_crc (cursor-rapid-movement-128x128) [573.361395] Starting subtest: cursor-rapid-movement-128x128 [573.363902] Starting dynamic subtest: pipe-A-eDP-1 [573.939303] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.569s) [573.971963] Starting dynamic subtest: pipe-D-eDP-1 [575.224537] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.269s) [575.227180] Subtest cursor-rapid-movement-128x128: SUCCESS (1.862s) [576.128826] [125/143] (471s left) gem_ccs (ctrl-surf-copy) [576.217166] Starting subtest: ctrl-surf-copy [576.223225] Subtest ctrl-surf-copy: SKIP (0.000s) [576.312565] [126/143] (470s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-render) [576.397424] Starting subtest: psr-1p-offscren-pri-indfb-draw-render [581.149121] Subtest psr-1p-offscren-pri-indfb-draw-render: SUCCESS (4.757s) [581.277491] [127/143] (466s left) syncobj_wait (invalid-signal-zero-handles) [581.354882] Starting subtest: invalid-signal-zero-handles [581.357132] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [581.446418] [128/143] (465s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [581.529505] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu [581.534512] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [581.613780] [129/143] (465s left) gem_lmem_swapping (parallel-random-engines) [581.679073] Subtest parallel-random-engines: SKIP (0.000s) [581.724004] [130/143] (465s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [581.836549] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [581.841110] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [581.927284] [131/143] (465s left) vc4/vc4_perfmon (create-single-perfmon) [582.028514] Subtest create-single-perfmon: SKIP (0.000s) [582.084362] [132/143] (465s left) kms_cursor_edge_walk (128x128-top-edge) [582.174741] Starting subtest: 128x128-top-edge [582.176945] Starting dynamic subtest: pipe-A-eDP-1 [585.770420] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.595s) [585.794378] Starting dynamic subtest: pipe-D-eDP-1 [589.029223] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.254s) [589.031700] Subtest 128x128-top-edge: SUCCESS (6.853s) [589.929816] [133/143] (457s left) v3d/v3d_perfmon (create-two-perfmon) [590.003160] Subtest create-two-perfmon: SKIP (0.000s) [590.058878] [134/143] (457s left) gem_exec_params (cliprects-invalid) [590.105919] Starting subtest: cliprects-invalid [590.108324] Subtest cliprects-invalid: SUCCESS (0.000s) [590.204322] [135/143] (457s left) gem_vm_create (invalid-destroy) [590.265571] Starting subtest: invalid-destroy [590.268247] Subtest invalid-destroy: SUCCESS (0.001s) [590.366470] [136/143] (457s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible) [590.460164] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s) [590.506013] [137/143] (457s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc) [590.605989] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc [590.609952] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [590.691113] [138/143] (456s left) gem_ctx_persistence (legacy-engines-hostile-preempt) [590.790671] Starting subtest: legacy-engines-hostile-preempt [590.793191] Starting dynamic subtest: render [590.855480] Dynamic subtest render: SUCCESS (0.063s) [590.876195] Starting dynamic subtest: bsd1 [592.410117] Dynamic subtest bsd1: SUCCESS (1.551s) [592.432615] Starting dynamic subtest: bsd2 [594.457322] Dynamic subtest bsd2: SUCCESS (2.044s) [594.479357] Starting dynamic subtest: blt [594.691475] Dynamic subtest blt: SUCCESS (0.231s) [594.711978] Starting dynamic subtest: vebox [596.425898] Dynamic subtest vebox: SUCCESS (1.732s) [596.428553] Subtest legacy-engines-hostile-preempt: SUCCESS (5.634s) [596.536003] [139/143] (451s left) v3d/v3d_get_param (get-bad-flags) [596.652443] Subtest get-bad-flags: SKIP (0.000s) [596.699343] [140/143] (451s left) kms_addfb_basic (bad-pitch-1024) [596.768433] Starting subtest: bad-pitch-1024 [596.770678] Subtest bad-pitch-1024: SUCCESS (0.000s) [596.872345] [141/143] (450s left) kms_ccs (pipe-c-crc-primary-basic-y-tiled-ccs) [597.274991] Starting subtest: pipe-C-crc-primary-basic-y-tiled-ccs [597.280994] Subtest pipe-C-crc-primary-basic-y-tiled-ccs: SKIP (0.000s) [598.116393] [142/143] (449s left) kms_flip (2x-nonexisting-fb-interruptible) [598.186590] Starting subtest: 2x-nonexisting-fb-interruptible [598.200157] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.013s) [598.271229] [143/143] (449s left) kms_prop_blob (blob-prop-lifetime) [598.351913] Starting subtest: blob-prop-lifetime [598.354591] Subtest blob-prop-lifetime: SUCCESS (0.001s) [598.430802] Closing watchdogs Done.