cipd ensure -root /b/s/w/ir/k/recipe_cleanup/cipd -ensure-file /b/s/w/ir/tmp/t/tmpbFUKg1 -json-output /b/s/w/ir/tmp/t/tmpdG4Dqt.json
in dir /b/s/w/ir/k:
 allow_subannotations: False
 cmd: ['cipd',
 'ensure',
 '-root',
 '/b/s/w/ir/k/recipe_cleanup/cipd',
 '-ensure-file',
 '/b/s/w/ir/tmp/t/tmpbFUKg1',
 '-json-output',
 '/b/s/w/ir/tmp/t/tmpdG4Dqt.json']
 env: {}
 env_prefixes: {}
 env_suffixes: {}
 infra_step: True
 name_tokens: ('upload build results', 'ensure bloaty', 'ensure_installed')
 ok_ret: frozenset([0])
 step_test_data: <lambda>(...)
 trigger_specs: ()
full environment:
 BOTO_CONFIG: /b/s/w/ir/tmp/gsutil-task/.boto
 BUILDBUCKET_EXPERIMENTAL: FALSE
 CIPD_CACHE_DIR: /b/s/cipd_cache/cache
 CIPD_PROTOCOL: v2
 DEVSHELL_CLIENT_PORT: 37545
 DOCKER_CONFIG: /b/s/w/ir/tmp/docker-cfg-task
 DOCKER_TMPDIR: /b/s/w/ir/tmp/docker-tmp-task
 GIT_CONFIG_NOSYSTEM: 1
 GIT_TERMINAL_PROMPT: 0
 HOME: /home/swarming
 INFRA_GIT_WRAPPER_HOME: /b/s/w/ir/tmp/git-home-task
 INVOCATION_ID: 7380503e552449e8bb12fc162366837d
 JOURNAL_STREAM: 8:16748
 LANG: en_US.UTF-8
 LOGDOG_COORDINATOR_HOST: logs.chromium.org
 LOGDOG_STREAM_PREFIX: buildbucket/cr-buildbucket.appspot.com/8915190667404786208
 LOGDOG_STREAM_PROJECT: fuchsia
 LOGDOG_STREAM_SERVER_PATH: unix:/b/s/w/ir/tmp/ld.sock
 LOGNAME: swarming
 LUCI_CONTEXT: /b/s/w/ir/tmp/luci_context.992166507
 MAC_CHROMIUM_TMPDIR: /b/s/w/ir/tmp/t
 NO_GCE_CHECK: False
 PATH: /b/s/w/ir/cipd_bin_packages:/b/s/w/ir/cipd_bin_packages/bin:/b/s/cipd_cache/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin
 PWD: /b/s/w/ir/k
 PYTHONIOENCODING: UTF-8
 PYTHONUNBUFFERED: 1
 SHELL: /bin/bash
 SHLVL: 1
 SWARMING_BOT_ID: fuchsia-debian-16-6907d2bd-us-central1-c-pgvm
 SWARMING_EXTERNAL_BOT_SETUP: 1
 SWARMING_HEADLESS: 1
 SWARMING_SERVER: https://chromium-swarm.appspot.com
 SWARMING_TASK_ID: 446e152ca82f9611
 TEMP: /b/s/w/ir/tmp/t
 TEMPDIR: /b/s/w/ir/tmp/t
 TMP: /b/s/w/ir/tmp/t
 TMPDIR: /b/s/w/ir/tmp/t
 USER: swarming
 VPYTHON_VIRTUALENV_ROOT: /b/s/w/ir/cache/vpython
 _: /b/s/w/ir/cipd_bin_packages/vpython

[P31354 16:45:39.474 action_plan.go:140 I] In root:
[P31354 16:45:39.475 action_plan.go:146 I]   to install:
[P31354 16:45:39.475 action_plan.go:148 I]     fuchsia/tools/bloatalyzer/linux-amd64:zTeT8z2KpcketApsM1QvM6D5bUKNB5FUfA9N2xr2m8cC
[P31354 16:45:39.475 action_plan.go:148 I]     fuchsia/third_party/bloaty/linux-amd64:ea39606664f9a1b6415090c3330b2f8f2c659789
[P31354 16:45:39.475 action_plan.go:159 I]   to remove:
[P31354 16:45:39.475 action_plan.go:161 I]     fuchsia/tools/ninjatrace/linux-amd64:dBEFD5BffLIq8nyY_bC-aeQ1xekWZOGds2FdnDDg8tQC
[P31354 16:45:39.475 deployer.go:531 I] Removing fuchsia/tools/ninjatrace/linux-amd64 from /b/s/w/ir/k/recipe_cleanup/cipd(/)
[P31354 16:45:39.476 client.go:572 I] cipd: using instance cache at "/b/s/cipd_cache/cache/instances"
[P31354 16:45:39.476 client.go:1383 I] cipd: resolving fetch URL for fuchsia/tools/bloatalyzer/linux-amd64:zTeT8z2KpcketApsM1QvM6D5bUKNB5FUfA9N2xr2m8cC
[P31354 16:45:39.499 storage.go:308 I] cipd: initiating the fetch
[P31354 16:45:39.576 storage.go:275 I] cipd: about to fetch 1.2 MB
[P31354 16:45:39.576 storage.go:256 I] cipd: fetching - 0% (?? KB/s)
[P31354 16:45:39.583 storage.go:256 I] cipd: fetching - 100% (?? KB/s)
[P31354 16:45:39.584 storage.go:256 I] cipd: fetching - 100% (?? KB/s)
[P31354 16:45:39.584 client.go:1377 I] cipd: successfully fetched fuchsia/tools/bloatalyzer/linux-amd64:zTeT8z2KpcketApsM1QvM6D5bUKNB5FUfA9N2xr2m8cC in 0.1s
[P31354 16:45:39.584 instancecache.go:221 I] cipd: still need to purge 1 cached instance(s)
[P31354 16:45:39.584 instancecache.go:235 I] cipd: purging cached instance 1183edd080a60f2535dc3983b903a09686966ebb (age 38m43.669539841s)
[P31354 16:45:39.586 deployer.go:288 I] Deploying fuchsia/tools/bloatalyzer/linux-amd64:zTeT8z2KpcketApsM1QvM6D5bUKNB5FUfA9N2xr2m8cC into /b/s/w/ir/k/recipe_cleanup/cipd(/)
[P31354 16:45:39.586 reader.go:325 I] cipd: about to extract 3.1 MB (3 files)
[P31354 16:45:39.627 reader.go:364 I] cipd: extracting - 99%
[P31354 16:45:39.627 reader.go:364 I] cipd: extracting - 100%
[P31354 16:45:39.627 deployer.go:361 I] Moving files to their final destination...
[P31354 16:45:39.628 deployer.go:376 I] Cleaning up...
[P31354 16:45:39.628 deployer.go:381 I] Deployed fuchsia/tools/bloatalyzer/linux-amd64:zTeT8z2KpcketApsM1QvM6D5bUKNB5FUfA9N2xr2m8cC
[P31354 16:45:39.628 client.go:1383 I] cipd: resolving fetch URL for fuchsia/third_party/bloaty/linux-amd64:ea39606664f9a1b6415090c3330b2f8f2c659789
[P31354 16:45:39.645 storage.go:308 I] cipd: initiating the fetch
[P31354 16:45:39.691 storage.go:275 I] cipd: about to fetch 2.0 MB
[P31354 16:45:39.691 storage.go:256 I] cipd: fetching - 0% (?? KB/s)
[P31354 16:45:39.699 storage.go:256 I] cipd: fetching - 100% (?? KB/s)
[P31354 16:45:39.699 storage.go:256 I] cipd: fetching - 100% (?? KB/s)
[P31354 16:45:39.699 client.go:1377 I] cipd: successfully fetched fuchsia/third_party/bloaty/linux-amd64:ea39606664f9a1b6415090c3330b2f8f2c659789 in 0.1s
[P31354 16:45:39.699 instancecache.go:221 I] cipd: still need to purge 1 cached instance(s)
[P31354 16:45:39.699 instancecache.go:235 I] cipd: purging cached instance dY80Mmqb8UVE6k__OVcRvRSQHJdBZvoXZqHn6ktxgsIC (age 38m43.778230044s)
[P31354 16:45:39.701 deployer.go:288 I] Deploying fuchsia/third_party/bloaty/linux-amd64:ea39606664f9a1b6415090c3330b2f8f2c659789 into /b/s/w/ir/k/recipe_cleanup/cipd(/)
[P31354 16:45:39.701 reader.go:325 I] cipd: about to extract 7.8 MB (3 files)
[P31354 16:45:39.767 reader.go:364 I] cipd: extracting - 99%
[P31354 16:45:39.767 reader.go:364 I] cipd: extracting - 100%
[P31354 16:45:39.767 deployer.go:361 I] Moving files to their final destination...
[P31354 16:45:39.768 deployer.go:376 I] Cleaning up...
[P31354 16:45:39.768 deployer.go:381 I] Deployed fuchsia/third_party/bloaty/linux-amd64:ea39606664f9a1b6415090c3330b2f8f2c659789
[P31354 16:45:39.768 client.go:1575 I] All changes applied.