[04:03:14.433] New invocation is queued and will start shortly
[04:03:15.506] Starting the invocation (attempt 1)
[04:03:15.554] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:03:15.556] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:03:15.556] Buildbucket request:
{
"bucket": "luci.emscripten-releases.ci",
"client_operation_id": "9061822342421167200",
"parameters_json": "{\"builder_name\":\"win\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"e6a2b9315b9832d14f9ac143ddee9d76113f8b89\"},\"id\":\"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@e6a2b9315b9832d14f9ac143ddee9d76113f8b89\",\"title\":\"e6a2b9315b9832d14f9ac143ddee9d76113f8b89\",\"url\":\"https://chromium.googlesource.com/emscripten-releases/+/e6a2b9315b9832d14f9ac143ddee9d76113f8b89\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"e6a2b9315b9832d14f9ac143ddee9d76113f8b89\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win",
"scheduler_invocation_id:9061822342421167200",
"scheduler_job_id:emscripten-releases/win",
"user_agent:luci-scheduler",
"buildset:commit/git/e6a2b9315b9832d14f9ac143ddee9d76113f8b89",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/e6a2b9315b9832d14f9ac143ddee9d76113f8b89",
"gitiles_ref:refs/heads/master"
]
}
[04:03:16.952] Buildbucket response:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"created_by": "project:emscripten-releases",
"created_ts": "1574136196235301",
"id": "8896392279854680128",
"parameters_json": "{\"builder_name\": \"win\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"e6a2b9315b9832d14f9ac143ddee9d76113f8b89\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@e6a2b9315b9832d14f9ac143ddee9d76113f8b89\", \"title\": \"e6a2b9315b9832d14f9ac143ddee9d76113f8b89\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/e6a2b9315b9832d14f9ac143ddee9d76113f8b89\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"e6a2b9315b9832d14f9ac143ddee9d76113f8b89\"}}",
"project": "emscripten-releases",
"result_details_json": "{\"properties\": {}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1574136196666466",
"tags": [
"builder:win",
"buildset:commit/git/e6a2b9315b9832d14f9ac143ddee9d76113f8b89",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/e6a2b9315b9832d14f9ac143ddee9d76113f8b89",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9061822342421167200",
"scheduler_job_id:emscripten-releases/win",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/emscripten-releases/buildbucket/cr-buildbucket.appspot.com/8896392279854680128/+/annotations",
"swarming_tag:luci_project:emscripten-releases",
"swarming_tag:recipe_name:emscripten_releases",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1574136196666713",
"url": "https://ci.chromium.org/b/8896392279854680128",
"utcnow_ts": "1574136196935522"
}
}
[04:03:16.952] Task URL: https://ci.chromium.org/b/8896392279854680128
[04:03:16.952] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:2:0) after 1m0s
[04:04:17.083] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:2:0)
[04:04:17.083] Timer tick, asking Buildbucket for the build status
[04:04:17.538] Build 8896392279854680128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:04:17.538] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:3:0) after 1m0s
[04:05:17.683] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:3:0)
[04:05:17.683] Timer tick, asking Buildbucket for the build status
[04:05:17.840] Build 8896392279854680128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:05:17.840] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:4:0) after 1m0s
[04:06:17.884] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:4:0)
[04:06:17.884] Timer tick, asking Buildbucket for the build status
[04:06:18.212] Build 8896392279854680128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:06:18.212] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:5:0) after 1m0s
[04:07:18.273] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:5:0)
[04:07:18.273] Timer tick, asking Buildbucket for the build status
[04:07:18.464] Build 8896392279854680128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:07:18.464] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:6:0) after 1m0s
[04:08:18.559] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:6:0)
[04:08:18.559] Timer tick, asking Buildbucket for the build status
[04:08:18.694] Build 8896392279854680128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:08:18.694] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:7:0) after 1m0s
[04:09:18.905] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:7:0)
[04:09:18.905] Timer tick, asking Buildbucket for the build status
[04:09:19.017] Build 8896392279854680128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:09:19.017] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:8:0) after 1m0s
[04:10:19.126] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:8:0)
[04:10:19.126] Timer tick, asking Buildbucket for the build status
[04:10:19.314] Build 8896392279854680128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:10:19.314] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:9:0) after 1m0s
[04:11:19.369] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:9:0)
[04:11:19.369] Timer tick, asking Buildbucket for the build status
[04:11:20.061] Build 8896392279854680128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:11:20.061] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:10:0) after 1m0s
[04:12:20.235] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:10:0)
[04:12:20.235] Timer tick, asking Buildbucket for the build status
[04:12:20.513] Build 8896392279854680128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:12:20.513] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:11:0) after 1m0s
[04:13:20.603] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:11:0)
[04:13:20.603] Timer tick, asking Buildbucket for the build status
[04:13:20.776] Build 8896392279854680128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:13:20.776] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:12:0) after 1m0s
[04:14:20.830] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:12:0)
[04:14:20.830] Timer tick, asking Buildbucket for the build status
[04:14:20.924] Build 8896392279854680128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:14:20.924] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:13:0) after 1m0s
[04:15:21.058] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:13:0)
[04:15:21.058] Timer tick, asking Buildbucket for the build status
[04:15:21.178] Build 8896392279854680128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:15:21.178] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:14:0) after 1m0s
[04:16:21.206] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:14:0)
[04:16:21.206] Timer tick, asking Buildbucket for the build status
[04:16:21.393] Build 8896392279854680128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:16:21.393] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:15:0) after 1m0s
[04:17:21.478] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:15:0)
[04:17:21.478] Timer tick, asking Buildbucket for the build status
[04:17:21.570] Build 8896392279854680128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:17:21.570] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:16:0) after 1m0s
[04:18:21.740] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:16:0)
[04:18:21.740] Timer tick, asking Buildbucket for the build status
[04:18:22.149] Build 8896392279854680128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:18:22.149] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:17:0) after 1m0s
[04:19:22.223] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:17:0)
[04:19:22.223] Timer tick, asking Buildbucket for the build status
[04:19:22.346] Build 8896392279854680128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:19:22.347] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:18:0) after 1m0s
[04:20:22.373] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:18:0)
[04:20:22.373] Timer tick, asking Buildbucket for the build status
[04:20:22.557] Build 8896392279854680128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:20:22.557] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:19:0) after 1m0s
[04:21:22.647] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:19:0)
[04:21:22.647] Timer tick, asking Buildbucket for the build status
[04:21:22.848] Build 8896392279854680128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:21:22.848] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:20:0) after 1m0s
[04:22:22.869] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:20:0)
[04:22:22.869] Timer tick, asking Buildbucket for the build status
[04:22:23.016] Build 8896392279854680128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:22:23.016] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:21:0) after 1m0s
[04:23:23.102] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:21:0)
[04:23:23.102] Timer tick, asking Buildbucket for the build status
[04:23:23.264] Build 8896392279854680128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:23:23.264] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:22:0) after 1m0s
[04:24:23.277] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:22:0)
[04:24:23.277] Timer tick, asking Buildbucket for the build status
[04:24:23.395] Build 8896392279854680128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:24:23.395] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:23:0) after 1m0s
[04:25:23.461] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:23:0)
[04:25:23.461] Timer tick, asking Buildbucket for the build status
[04:25:23.731] Build 8896392279854680128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:25:23.731] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:24:0) after 1m0s
[04:26:23.791] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:24:0)
[04:26:23.791] Timer tick, asking Buildbucket for the build status
[04:26:23.882] Build 8896392279854680128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:26:23.882] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:25:0) after 1m0s
[04:27:23.893] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:25:0)
[04:27:23.893] Timer tick, asking Buildbucket for the build status
[04:27:24.068] Build 8896392279854680128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:27:24.068] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:26:0) after 1m0s
[04:28:24.119] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:26:0)
[04:28:24.119] Timer tick, asking Buildbucket for the build status
[04:28:24.447] Build 8896392279854680128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:28:24.447] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:27:0) after 1m0s
[04:29:24.485] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:27:0)
[04:29:24.485] Timer tick, asking Buildbucket for the build status
[04:29:24.680] Build 8896392279854680128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:29:24.680] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:28:0) after 1m0s
[04:30:24.706] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:28:0)
[04:30:24.706] Timer tick, asking Buildbucket for the build status
[04:30:24.832] Build 8896392279854680128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:30:24.832] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:29:0) after 1m0s
[04:31:24.967] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:29:0)
[04:31:24.967] Timer tick, asking Buildbucket for the build status
[04:31:25.095] Build 8896392279854680128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:31:25.095] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:30:0) after 1m0s
[04:32:25.100] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:30:0)
[04:32:25.100] Timer tick, asking Buildbucket for the build status
[04:32:25.269] Build 8896392279854680128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:32:25.269] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:31:0) after 1m0s
[04:33:25.409] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:31:0)
[04:33:25.409] Timer tick, asking Buildbucket for the build status
[04:33:25.692] Build 8896392279854680128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:33:25.692] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:32:0) after 1m0s
[04:34:25.774] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:32:0)
[04:34:25.774] Timer tick, asking Buildbucket for the build status
[04:34:26.128] Build 8896392279854680128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:34:26.128] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:33:0) after 1m0s
[04:35:26.156] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:33:0)
[04:35:26.156] Timer tick, asking Buildbucket for the build status
[04:35:26.274] Build 8896392279854680128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:35:26.274] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:34:0) after 1m0s
[04:36:26.272] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:34:0)
[04:36:26.272] Timer tick, asking Buildbucket for the build status
[04:36:26.405] Build 8896392279854680128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:36:26.405] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:35:0) after 1m0s
[04:37:26.476] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:35:0)
[04:37:26.476] Timer tick, asking Buildbucket for the build status
[04:37:26.674] Build 8896392279854680128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:37:26.674] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:36:0) after 1m0s
[04:38:26.694] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:36:0)
[04:38:26.694] Timer tick, asking Buildbucket for the build status
[04:38:26.932] Build 8896392279854680128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:38:26.932] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:37:0) after 1m0s
[04:39:26.990] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:37:0)
[04:39:26.990] Timer tick, asking Buildbucket for the build status
[04:39:27.312] Build 8896392279854680128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:39:27.312] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:38:0) after 1m0s
[04:40:27.397] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:38:0)
[04:40:27.397] Timer tick, asking Buildbucket for the build status
[04:40:27.548] Build 8896392279854680128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:40:27.548] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:39:0) after 1m0s
[04:41:27.568] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:39:0)
[04:41:27.568] Timer tick, asking Buildbucket for the build status
[04:41:27.827] Build 8896392279854680128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:41:27.827] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:40:0) after 1m0s
[04:42:27.826] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:40:0)
[04:42:27.826] Timer tick, asking Buildbucket for the build status
[04:42:27.967] Build 8896392279854680128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:42:27.967] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:41:0) after 1m0s
[04:43:28.012] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:41:0)
[04:43:28.012] Timer tick, asking Buildbucket for the build status
[04:43:28.198] Build 8896392279854680128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:43:28.198] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:42:0) after 1m0s
[04:44:28.256] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:42:0)
[04:44:28.256] Timer tick, asking Buildbucket for the build status
[04:44:28.385] Build 8896392279854680128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:44:28.385] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:43:0) after 1m0s
[04:45:28.544] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:43:0)
[04:45:28.544] Timer tick, asking Buildbucket for the build status
[04:45:28.659] Build 8896392279854680128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:45:28.659] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:44:0) after 1m0s
[04:46:28.786] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:44:0)
[04:46:28.786] Timer tick, asking Buildbucket for the build status
[04:46:29.017] Build 8896392279854680128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:46:29.017] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:45:0) after 1m0s
[04:47:00.070] Received PubSub notification, asking Buildbucket for the build status
[04:47:00.704] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:29.079] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:45:0)
[04:47:29.079] Timer tick, asking Buildbucket for the build status
[04:47:29.205] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:29.205] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:47:0) after 1m0s
[04:48:29.234] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:47:0)
[04:48:29.234] Timer tick, asking Buildbucket for the build status
[04:48:29.384] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:29.384] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:48:0) after 1m0s
[04:49:29.406] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:48:0)
[04:49:29.406] Timer tick, asking Buildbucket for the build status
[04:49:29.560] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:29.560] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:49:0) after 1m0s
[04:50:29.744] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:49:0)
[04:50:29.744] Timer tick, asking Buildbucket for the build status
[04:50:30.049] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:30.049] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:50:0) after 1m0s
[04:51:30.089] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:50:0)
[04:51:30.089] Timer tick, asking Buildbucket for the build status
[04:51:30.251] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:30.251] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:51:0) after 1m0s
[04:52:30.275] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:51:0)
[04:52:30.275] Timer tick, asking Buildbucket for the build status
[04:52:30.520] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:30.520] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:52:0) after 1m0s
[04:53:30.615] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:52:0)
[04:53:30.615] Timer tick, asking Buildbucket for the build status
[04:53:30.771] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:30.771] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:53:0) after 1m0s
[04:54:30.905] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:53:0)
[04:54:30.905] Timer tick, asking Buildbucket for the build status
[04:54:31.089] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:31.089] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:54:0) after 1m0s
[04:55:31.189] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:54:0)
[04:55:31.189] Timer tick, asking Buildbucket for the build status
[04:55:31.338] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:31.338] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:55:0) after 1m0s
[04:56:31.421] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:55:0)
[04:56:31.421] Timer tick, asking Buildbucket for the build status
[04:56:31.897] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:31.897] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:56:0) after 1m0s
[04:57:31.904] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:56:0)
[04:57:31.904] Timer tick, asking Buildbucket for the build status
[04:57:32.213] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:32.213] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:57:0) after 1m0s
[04:58:32.514] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:57:0)
[04:58:32.514] Timer tick, asking Buildbucket for the build status
[04:58:32.868] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:32.868] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:58:0) after 1m0s
[04:59:32.889] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:58:0)
[04:59:32.889] Timer tick, asking Buildbucket for the build status
[04:59:33.106] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:33.106] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:59:0) after 1m0s
[05:00:33.139] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:59:0)
[05:00:33.139] Timer tick, asking Buildbucket for the build status
[05:00:33.270] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:33.270] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:60:0) after 1m0s
[05:01:33.298] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:60:0)
[05:01:33.298] Timer tick, asking Buildbucket for the build status
[05:01:33.494] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:33.494] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:61:0) after 1m0s
[05:02:33.564] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:61:0)
[05:02:33.564] Timer tick, asking Buildbucket for the build status
[05:02:33.781] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:33.781] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:62:0) after 1m0s
[05:03:33.818] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:62:0)
[05:03:33.818] Timer tick, asking Buildbucket for the build status
[05:03:33.926] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:33.926] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:63:0) after 1m0s
[05:04:33.981] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:63:0)
[05:04:33.981] Timer tick, asking Buildbucket for the build status
[05:04:34.690] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:34.691] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:64:0) after 1m0s
[05:05:34.721] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:64:0)
[05:05:34.721] Timer tick, asking Buildbucket for the build status
[05:05:34.977] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:34.977] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:65:0) after 1m0s
[05:06:35.197] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:65:0)
[05:06:35.197] Timer tick, asking Buildbucket for the build status
[05:06:35.274] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:35.274] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:66:0) after 1m0s
[05:07:35.312] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:66:0)
[05:07:35.312] Timer tick, asking Buildbucket for the build status
[05:07:35.726] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:35.726] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:67:0) after 1m0s
[05:08:35.768] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:67:0)
[05:08:35.768] Timer tick, asking Buildbucket for the build status
[05:08:35.976] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:35.976] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:68:0) after 1m0s
[05:09:36.075] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:68:0)
[05:09:36.075] Timer tick, asking Buildbucket for the build status
[05:09:36.183] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:36.183] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:69:0) after 1m0s
[05:10:36.263] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:69:0)
[05:10:36.263] Timer tick, asking Buildbucket for the build status
[05:10:36.533] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:36.533] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:70:0) after 1m0s
[05:11:36.672] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:70:0)
[05:11:36.672] Timer tick, asking Buildbucket for the build status
[05:11:36.847] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:36.847] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:71:0) after 1m0s
[05:12:36.916] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:71:0)
[05:12:36.916] Timer tick, asking Buildbucket for the build status
[05:12:37.046] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:37.046] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:72:0) after 1m0s
[05:13:37.205] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:72:0)
[05:13:37.205] Timer tick, asking Buildbucket for the build status
[05:13:37.600] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:37.600] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:73:0) after 1m0s
[05:14:37.589] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:73:0)
[05:14:37.589] Timer tick, asking Buildbucket for the build status
[05:14:37.707] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:37.707] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:74:0) after 1m0s
[05:15:37.780] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:74:0)
[05:15:37.780] Timer tick, asking Buildbucket for the build status
[05:15:38.073] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:38.074] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:75:0) after 1m0s
[05:16:38.113] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:75:0)
[05:16:38.113] Timer tick, asking Buildbucket for the build status
[05:16:38.276] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:38.276] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:76:0) after 1m0s
[05:17:38.340] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:76:0)
[05:17:38.340] Timer tick, asking Buildbucket for the build status
[05:17:38.513] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:38.513] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:77:0) after 1m0s
[05:18:38.633] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:77:0)
[05:18:38.633] Timer tick, asking Buildbucket for the build status
[05:18:38.787] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:38.787] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:78:0) after 1m0s
[05:19:38.830] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:78:0)
[05:19:38.830] Timer tick, asking Buildbucket for the build status
[05:19:39.086] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:39.086] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:79:0) after 1m0s
[05:20:39.119] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:79:0)
[05:20:39.119] Timer tick, asking Buildbucket for the build status
[05:20:39.386] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:39.386] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:80:0) after 1m0s
[05:21:39.413] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:80:0)
[05:21:39.413] Timer tick, asking Buildbucket for the build status
[05:21:39.913] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:39.913] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:81:0) after 1m0s
[05:22:39.947] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:81:0)
[05:22:39.947] Timer tick, asking Buildbucket for the build status
[05:22:40.042] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:40.042] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:82:0) after 1m0s
[05:23:40.087] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:82:0)
[05:23:40.087] Timer tick, asking Buildbucket for the build status
[05:23:40.228] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:40.228] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:83:0) after 1m0s
[05:24:40.284] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:83:0)
[05:24:40.284] Timer tick, asking Buildbucket for the build status
[05:24:40.593] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:40.593] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:84:0) after 1m0s
[05:25:40.625] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:84:0)
[05:25:40.625] Timer tick, asking Buildbucket for the build status
[05:25:40.705] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:40.705] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:85:0) after 1m0s
[05:26:40.741] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:85:0)
[05:26:40.741] Timer tick, asking Buildbucket for the build status
[05:26:40.866] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:40.866] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:86:0) after 1m0s
[05:27:40.894] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:86:0)
[05:27:40.894] Timer tick, asking Buildbucket for the build status
[05:27:40.987] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:40.987] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:87:0) after 1m0s
[05:28:41.094] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:87:0)
[05:28:41.094] Timer tick, asking Buildbucket for the build status
[05:28:41.205] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:41.205] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:88:0) after 1m0s
[05:29:41.210] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:88:0)
[05:29:41.210] Timer tick, asking Buildbucket for the build status
[05:29:41.341] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:41.341] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:89:0) after 1m0s
[05:30:41.447] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:89:0)
[05:30:41.447] Timer tick, asking Buildbucket for the build status
[05:30:41.640] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:41.640] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:90:0) after 1m0s
[05:31:41.615] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:90:0)
[05:31:41.615] Timer tick, asking Buildbucket for the build status
[05:31:41.737] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:41.737] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:91:0) after 1m0s
[05:32:41.760] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:91:0)
[05:32:41.760] Timer tick, asking Buildbucket for the build status
[05:32:42.178] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:42.178] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:92:0) after 1m0s
[05:33:42.209] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:92:0)
[05:33:42.209] Timer tick, asking Buildbucket for the build status
[05:33:42.582] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:42.582] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:93:0) after 1m0s
[05:34:42.680] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:93:0)
[05:34:42.680] Timer tick, asking Buildbucket for the build status
[05:34:42.776] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:42.776] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:94:0) after 1m0s
[05:35:42.877] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:94:0)
[05:35:42.877] Timer tick, asking Buildbucket for the build status
[05:35:43.128] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:43.128] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:95:0) after 1m0s
[05:36:43.204] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:95:0)
[05:36:43.204] Timer tick, asking Buildbucket for the build status
[05:36:43.265] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:43.265] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:96:0) after 1m0s
[05:37:43.405] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:96:0)
[05:37:43.405] Timer tick, asking Buildbucket for the build status
[05:37:43.571] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:43.571] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:97:0) after 1m0s
[05:38:43.569] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:97:0)
[05:38:43.569] Timer tick, asking Buildbucket for the build status
[05:38:43.710] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:43.710] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:98:0) after 1m0s
[05:39:43.783] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:98:0)
[05:39:43.783] Timer tick, asking Buildbucket for the build status
[05:39:43.891] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:43.891] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:99:0) after 1m0s
[05:40:43.956] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:99:0)
[05:40:43.956] Timer tick, asking Buildbucket for the build status
[05:40:44.219] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:44.219] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:100:0) after 1m0s
[05:41:44.254] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:100:0)
[05:41:44.254] Timer tick, asking Buildbucket for the build status
[05:41:44.520] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:44.520] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:101:0) after 1m0s
[05:42:44.621] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:101:0)
[05:42:44.621] Timer tick, asking Buildbucket for the build status
[05:42:44.752] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:44.752] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:102:0) after 1m0s
[05:43:44.933] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:102:0)
[05:43:44.933] Timer tick, asking Buildbucket for the build status
[05:43:45.178] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:45.178] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:103:0) after 1m0s
[05:44:45.303] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:103:0)
[05:44:45.303] Timer tick, asking Buildbucket for the build status
[05:44:45.544] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:45.544] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:104:0) after 1m0s
[05:45:45.677] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:104:0)
[05:45:45.677] Timer tick, asking Buildbucket for the build status
[05:45:45.782] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:45.782] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:105:0) after 1m0s
[05:46:45.874] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:105:0)
[05:46:45.874] Timer tick, asking Buildbucket for the build status
[05:46:45.978] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:45.979] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:106:0) after 1m0s
[05:47:46.061] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:106:0)
[05:47:46.061] Timer tick, asking Buildbucket for the build status
[05:47:46.180] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:46.180] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:107:0) after 1m0s
[05:48:46.244] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:107:0)
[05:48:46.244] Timer tick, asking Buildbucket for the build status
[05:48:46.376] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:46.376] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:108:0) after 1m0s
[05:49:46.409] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:108:0)
[05:49:46.409] Timer tick, asking Buildbucket for the build status
[05:49:46.743] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:46.743] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:109:0) after 1m0s
[05:50:46.812] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:109:0)
[05:50:46.812] Timer tick, asking Buildbucket for the build status
[05:50:47.018] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:47.018] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:110:0) after 1m0s
[05:51:47.140] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:110:0)
[05:51:47.140] Timer tick, asking Buildbucket for the build status
[05:51:47.282] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:47.282] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:111:0) after 1m0s
[05:52:47.375] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:111:0)
[05:52:47.375] Timer tick, asking Buildbucket for the build status
[05:52:47.498] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:47.498] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:112:0) after 1m0s
[05:53:47.759] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:112:0)
[05:53:47.759] Timer tick, asking Buildbucket for the build status
[05:53:47.858] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:47.858] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:113:0) after 1m0s
[05:54:47.982] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:113:0)
[05:54:47.982] Timer tick, asking Buildbucket for the build status
[05:54:48.110] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:48.110] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:114:0) after 1m0s
[05:55:48.136] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:114:0)
[05:55:48.136] Timer tick, asking Buildbucket for the build status
[05:55:48.250] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:48.250] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:115:0) after 1m0s
[05:56:48.260] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:115:0)
[05:56:48.261] Timer tick, asking Buildbucket for the build status
[05:56:48.459] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:48.459] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:116:0) after 1m0s
[05:57:48.488] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:116:0)
[05:57:48.488] Timer tick, asking Buildbucket for the build status
[05:57:48.639] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:48.639] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:117:0) after 1m0s
[05:58:48.712] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:117:0)
[05:58:48.712] Timer tick, asking Buildbucket for the build status
[05:58:49.071] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:49.071] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:118:0) after 1m0s
[05:59:49.114] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:118:0)
[05:59:49.114] Timer tick, asking Buildbucket for the build status
[05:59:49.288] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:49.288] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:119:0) after 1m0s
[06:00:49.341] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:119:0)
[06:00:49.341] Timer tick, asking Buildbucket for the build status
[06:00:49.472] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:49.472] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:120:0) after 1m0s
[06:01:49.538] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:120:0)
[06:01:49.538] Timer tick, asking Buildbucket for the build status
[06:01:49.850] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:49.850] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:121:0) after 1m0s
[06:02:49.965] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:121:0)
[06:02:49.965] Timer tick, asking Buildbucket for the build status
[06:02:50.077] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:50.077] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:122:0) after 1m0s
[06:03:50.077] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:122:0)
[06:03:50.077] Timer tick, asking Buildbucket for the build status
[06:03:50.684] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:50.684] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:123:0) after 1m0s
[06:04:50.858] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:123:0)
[06:04:50.858] Timer tick, asking Buildbucket for the build status
[06:04:51.223] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:51.223] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:124:0) after 1m0s
[06:05:51.251] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:124:0)
[06:05:51.251] Timer tick, asking Buildbucket for the build status
[06:05:51.411] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:51.411] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:125:0) after 1m0s
[06:06:51.467] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:125:0)
[06:06:51.467] Timer tick, asking Buildbucket for the build status
[06:06:51.654] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:51.654] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:126:0) after 1m0s
[06:07:51.712] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:126:0)
[06:07:51.712] Timer tick, asking Buildbucket for the build status
[06:07:52.001] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:52.001] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:127:0) after 1m0s
[06:08:52.115] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:127:0)
[06:08:52.115] Timer tick, asking Buildbucket for the build status
[06:08:52.372] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:52.372] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:128:0) after 1m0s
[06:09:52.411] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:128:0)
[06:09:52.411] Timer tick, asking Buildbucket for the build status
[06:09:52.539] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:52.539] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:129:0) after 1m0s
[06:10:52.666] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:129:0)
[06:10:52.666] Timer tick, asking Buildbucket for the build status
[06:10:52.919] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:52.919] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:130:0) after 1m0s
[06:11:52.945] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:130:0)
[06:11:52.945] Timer tick, asking Buildbucket for the build status
[06:11:53.204] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:53.204] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:131:0) after 1m0s
[06:12:53.272] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:131:0)
[06:12:53.272] Timer tick, asking Buildbucket for the build status
[06:12:53.509] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:53.509] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:132:0) after 1m0s
[06:13:53.555] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:132:0)
[06:13:53.555] Timer tick, asking Buildbucket for the build status
[06:13:53.719] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:53.719] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:133:0) after 1m0s
[06:14:53.705] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:133:0)
[06:14:53.705] Timer tick, asking Buildbucket for the build status
[06:14:53.888] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:53.888] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:134:0) after 1m0s
[06:15:53.931] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:134:0)
[06:15:53.931] Timer tick, asking Buildbucket for the build status
[06:15:54.191] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:54.191] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:135:0) after 1m0s
[06:16:54.280] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:135:0)
[06:16:54.280] Timer tick, asking Buildbucket for the build status
[06:16:54.499] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:54.499] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:136:0) after 1m0s
[06:17:54.575] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:136:0)
[06:17:54.575] Timer tick, asking Buildbucket for the build status
[06:17:54.810] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:54.810] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:137:0) after 1m0s
[06:18:55.185] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:137:0)
[06:18:55.185] Timer tick, asking Buildbucket for the build status
[06:18:55.636] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:55.636] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:138:0) after 1m0s
[06:19:55.812] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:138:0)
[06:19:55.812] Timer tick, asking Buildbucket for the build status
[06:19:55.950] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:55.950] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:139:0) after 1m0s
[06:20:56.217] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:139:0)
[06:20:56.217] Timer tick, asking Buildbucket for the build status
[06:20:56.349] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:56.349] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:140:0) after 1m0s
[06:21:56.621] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:140:0)
[06:21:56.621] Timer tick, asking Buildbucket for the build status
[06:21:57.013] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:57.013] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:141:0) after 1m0s
[06:22:57.081] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:141:0)
[06:22:57.081] Timer tick, asking Buildbucket for the build status
[06:22:57.175] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:57.175] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:142:0) after 1m0s
[06:23:57.314] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:142:0)
[06:23:57.314] Timer tick, asking Buildbucket for the build status
[06:23:57.398] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:57.398] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:143:0) after 1m0s
[06:24:57.499] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:143:0)
[06:24:57.499] Timer tick, asking Buildbucket for the build status
[06:24:57.776] Build 8896392279854680128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:57.776] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061822342421167200:144:0) after 1m0s
[06:25:10.625] Received PubSub notification, asking Buildbucket for the build status
[06:25:10.988] Build 8896392279854680128: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[06:25:10.988] Buildbucket build:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"completed_ts": "1574144708547777",
"created_by": "project:emscripten-releases",
"created_ts": "1574136196235301",
"id": "8896392279854680128",
"parameters_json": "{\"builder_name\": \"win\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"e6a2b9315b9832d14f9ac143ddee9d76113f8b89\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@e6a2b9315b9832d14f9ac143ddee9d76113f8b89\", \"title\": \"e6a2b9315b9832d14f9ac143ddee9d76113f8b89\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/e6a2b9315b9832d14f9ac143ddee9d76113f8b89\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"e6a2b9315b9832d14f9ac143ddee9d76113f8b89\"}}",
"project": "emscripten-releases",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"e6a2b9315b9832d14f9ac143ddee9d76113f8b89\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@e6a2b9315b9832d14f9ac143ddee9d76113f8b89\", \"title\": \"e6a2b9315b9832d14f9ac143ddee9d76113f8b89\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/e6a2b9315b9832d14f9ac143ddee9d76113f8b89\"}]}, \"bot_id\": \"luci-emscripten-releases-ci-win10-0-5ddk\", \"branch\": \"refs/heads/master\", \"buildername\": \"win\", \"got_revision\": \"e6a2b9315b9832d14f9ac143ddee9d76113f8b89\", \"path_config\": \"generic\", \"recipe\": \"emscripten_releases\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"e6a2b9315b9832d14f9ac143ddee9d76113f8b89\"}, \"swarming\": {\"bot_dimensions\": {\"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"host_class\": [\"default\"], \"id\": [\"luci-emscripten-releases-ci-win10-0-5ddk\"], \"image\": [\"chrome-win10-1703-19102400-d35fedf5a0d\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.emscripten-releases.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"4638-f6b223c\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1574138818759478",
"status": "COMPLETED",
"status_changed_ts": "1574144708890967",
"tags": [
"builder:win",
"buildset:commit/git/e6a2b9315b9832d14f9ac143ddee9d76113f8b89",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/e6a2b9315b9832d14f9ac143ddee9d76113f8b89",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9061822342421167200",
"scheduler_job_id:emscripten-releases/win",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/emscripten-releases/buildbucket/cr-buildbucket.appspot.com/8896392279854680128/+/annotations",
"swarming_tag:luci_project:emscripten-releases",
"swarming_tag:os:Windows",
"swarming_tag:recipe_name:emscripten_releases",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:489aa5b81b3ba110",
"user_agent:luci-scheduler"
],
"updated_ts": "1574144708927577",
"url": "https://ci.chromium.org/b/8896392279854680128",
"utcnow_ts": "1574144710917764"
}
}
[06:25:10.989] Invocation finished in 2h21m56.584286013s with status SUCCEEDED