[00:32:55.547] New invocation is queued and will start shortly
[00:32:56.681] Starting the invocation (attempt 1)
[00:32:56.743] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:32:56.744] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:32:56.744] Buildbucket request:
{
"bucket": "luci.emscripten-releases.ci",
"client_operation_id": "9030489023896695008",
"parameters_json": "{\"builder_name\":\"linux\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"67499d71a243f8f552e6c371fc39f19f315ac2ca\"},\"id\":\"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@67499d71a243f8f552e6c371fc39f19f315ac2ca\",\"title\":\"67499d71a243f8f552e6c371fc39f19f315ac2ca\",\"url\":\"https://chromium.googlesource.com/emscripten-releases/+/67499d71a243f8f552e6c371fc39f19f315ac2ca\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"67499d71a243f8f552e6c371fc39f19f315ac2ca\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux",
"scheduler_invocation_id:9030489023896695008",
"scheduler_job_id:emscripten-releases/linux",
"user_agent:luci-scheduler",
"buildset:commit/git/67499d71a243f8f552e6c371fc39f19f315ac2ca",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/67499d71a243f8f552e6c371fc39f19f315ac2ca",
"gitiles_ref:refs/heads/master"
]
}
[00:32:57.271] Buildbucket response:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"created_by": "project:emscripten-releases",
"created_ts": "1604017976864390",
"id": "8865058961850396752",
"parameters_json": "{\"builder_name\": \"linux\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"67499d71a243f8f552e6c371fc39f19f315ac2ca\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@67499d71a243f8f552e6c371fc39f19f315ac2ca\", \"title\": \"67499d71a243f8f552e6c371fc39f19f315ac2ca\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/67499d71a243f8f552e6c371fc39f19f315ac2ca\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"67499d71a243f8f552e6c371fc39f19f315ac2ca\"}}",
"project": "emscripten-releases",
"result_details_json": "{\"properties\": {}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604017977132415",
"tags": [
"builder:linux",
"buildset:commit/git/67499d71a243f8f552e6c371fc39f19f315ac2ca",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/67499d71a243f8f552e6c371fc39f19f315ac2ca",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030489023896695008",
"scheduler_job_id:emscripten-releases/linux",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/emscripten-releases/buildbucket/cr-buildbucket.appspot.com/8865058961850396752/+/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": "1604017977132553",
"url": "https://ci.chromium.org/b/8865058961850396752",
"utcnow_ts": "1604017977254971"
}
}
[00:32:57.271] Task URL: https://ci.chromium.org/b/8865058961850396752
[00:32:57.271] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:2:0) after 1m0s
[00:33:45.845] Received PubSub notification, asking Buildbucket for the build status
[00:33:45.925] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:57.338] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:2:0)
[00:33:57.338] Timer tick, asking Buildbucket for the build status
[00:33:57.805] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:57.805] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:4:0) after 1m0s
[00:34:57.800] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:4:0)
[00:34:57.800] Timer tick, asking Buildbucket for the build status
[00:34:57.964] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:57.964] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:5:0) after 1m0s
[00:35:57.987] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:5:0)
[00:35:57.987] Timer tick, asking Buildbucket for the build status
[00:35:59.322] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:59.322] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:6:0) after 1m0s
[00:36:59.394] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:6:0)
[00:36:59.394] Timer tick, asking Buildbucket for the build status
[00:36:59.571] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:59.571] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:7:0) after 1m0s
[00:37:59.567] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:7:0)
[00:37:59.567] Timer tick, asking Buildbucket for the build status
[00:38:00.153] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:00.153] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:8:0) after 1m0s
[00:39:00.153] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:8:0)
[00:39:00.153] Timer tick, asking Buildbucket for the build status
[00:39:00.268] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:00.268] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:9:0) after 1m0s
[00:40:00.304] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:9:0)
[00:40:00.305] Timer tick, asking Buildbucket for the build status
[00:40:00.619] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:00.619] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:10:0) after 1m0s
[00:41:00.702] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:10:0)
[00:41:00.702] Timer tick, asking Buildbucket for the build status
[00:41:00.797] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:00.797] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:11:0) after 1m0s
[00:42:00.873] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:11:0)
[00:42:00.873] Timer tick, asking Buildbucket for the build status
[00:42:01.082] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:01.082] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:12:0) after 1m0s
[00:43:01.384] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:12:0)
[00:43:01.384] Timer tick, asking Buildbucket for the build status
[00:43:01.567] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:01.567] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:13:0) after 1m0s
[00:44:01.606] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:13:0)
[00:44:01.606] Timer tick, asking Buildbucket for the build status
[00:44:01.908] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:01.908] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:14:0) after 1m0s
[00:45:02.222] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:14:0)
[00:45:02.222] Timer tick, asking Buildbucket for the build status
[00:45:02.619] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:02.619] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:15:0) after 1m0s
[00:46:02.639] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:15:0)
[00:46:02.639] Timer tick, asking Buildbucket for the build status
[00:46:03.227] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:03.227] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:16:0) after 1m0s
[00:47:03.248] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:16:0)
[00:47:03.248] Timer tick, asking Buildbucket for the build status
[00:47:03.418] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:03.418] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:17:0) after 1m0s
[00:48:03.479] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:17:0)
[00:48:03.479] Timer tick, asking Buildbucket for the build status
[00:48:03.608] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:03.608] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:18:0) after 1m0s
[00:49:03.637] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:18:0)
[00:49:03.637] Timer tick, asking Buildbucket for the build status
[00:49:03.723] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:03.723] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:19:0) after 1m0s
[00:50:03.744] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:19:0)
[00:50:03.744] Timer tick, asking Buildbucket for the build status
[00:50:03.844] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:03.844] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:20:0) after 1m0s
[00:51:03.875] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:20:0)
[00:51:03.875] Timer tick, asking Buildbucket for the build status
[00:51:03.955] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:03.955] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:21:0) after 1m0s
[00:52:04.057] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:21:0)
[00:52:04.057] Timer tick, asking Buildbucket for the build status
[00:52:04.139] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:04.139] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:22:0) after 1m0s
[00:53:04.152] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:22:0)
[00:53:04.152] Timer tick, asking Buildbucket for the build status
[00:53:04.271] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:04.271] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:23:0) after 1m0s
[00:54:04.412] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:23:0)
[00:54:04.412] Timer tick, asking Buildbucket for the build status
[00:54:04.979] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:04.979] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:24:0) after 1m0s
[00:55:05.088] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:24:0)
[00:55:05.088] Timer tick, asking Buildbucket for the build status
[00:55:05.157] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:05.159] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:25:0) after 1m0s
[00:56:05.212] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:25:0)
[00:56:05.212] Timer tick, asking Buildbucket for the build status
[00:56:05.333] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:05.333] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:26:0) after 1m0s
[00:57:05.350] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:26:0)
[00:57:05.350] Timer tick, asking Buildbucket for the build status
[00:57:05.438] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:05.438] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:27:0) after 1m0s
[00:58:05.476] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:27:0)
[00:58:05.476] Timer tick, asking Buildbucket for the build status
[00:58:05.657] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:05.657] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:28:0) after 1m0s
[00:59:05.719] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:28:0)
[00:59:05.719] Timer tick, asking Buildbucket for the build status
[00:59:05.908] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:05.908] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:29:0) after 1m0s
[01:00:05.960] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:29:0)
[01:00:05.960] Timer tick, asking Buildbucket for the build status
[01:00:06.095] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:06.095] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:30:0) after 1m0s
[01:01:06.297] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:30:0)
[01:01:06.297] Timer tick, asking Buildbucket for the build status
[01:01:06.376] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:06.376] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:31:0) after 1m0s
[01:02:06.467] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:31:0)
[01:02:06.467] Timer tick, asking Buildbucket for the build status
[01:02:06.971] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:06.971] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:32:0) after 1m0s
[01:03:07.036] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:32:0)
[01:03:07.036] Timer tick, asking Buildbucket for the build status
[01:03:07.936] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:07.936] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:33:0) after 1m0s
[01:04:08.043] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:33:0)
[01:04:08.043] Timer tick, asking Buildbucket for the build status
[01:04:08.118] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:08.118] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:34:0) after 1m0s
[01:05:08.169] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:34:0)
[01:05:08.169] Timer tick, asking Buildbucket for the build status
[01:05:08.261] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:08.261] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:35:0) after 1m0s
[01:06:08.243] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:35:0)
[01:06:08.243] Timer tick, asking Buildbucket for the build status
[01:06:08.329] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:08.329] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:36:0) after 1m0s
[01:07:08.368] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:36:0)
[01:07:08.368] Timer tick, asking Buildbucket for the build status
[01:07:08.478] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:08.478] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:37:0) after 1m0s
[01:08:08.542] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:37:0)
[01:08:08.542] Timer tick, asking Buildbucket for the build status
[01:08:08.677] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:08.677] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:38:0) after 1m0s
[01:09:08.705] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:38:0)
[01:09:08.705] Timer tick, asking Buildbucket for the build status
[01:09:08.766] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:08.766] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:39:0) after 1m0s
[01:10:08.814] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:39:0)
[01:10:08.814] Timer tick, asking Buildbucket for the build status
[01:10:09.139] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:09.139] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:40:0) after 1m0s
[01:11:09.235] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:40:0)
[01:11:09.235] Timer tick, asking Buildbucket for the build status
[01:11:09.343] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:09.343] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:41:0) after 1m0s
[01:12:09.395] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:41:0)
[01:12:09.395] Timer tick, asking Buildbucket for the build status
[01:12:09.510] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:09.510] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:42:0) after 1m0s
[01:13:09.585] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:42:0)
[01:13:09.585] Timer tick, asking Buildbucket for the build status
[01:13:10.089] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:10.089] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:43:0) after 1m0s
[01:14:10.200] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:43:0)
[01:14:10.200] Timer tick, asking Buildbucket for the build status
[01:14:10.611] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:10.611] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:44:0) after 1m0s
[01:15:10.703] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:44:0)
[01:15:10.703] Timer tick, asking Buildbucket for the build status
[01:15:10.781] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:10.781] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:45:0) after 1m0s
[01:16:10.915] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:45:0)
[01:16:10.915] Timer tick, asking Buildbucket for the build status
[01:16:11.291] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:11.291] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:46:0) after 1m0s
[01:17:11.393] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:46:0)
[01:17:11.393] Timer tick, asking Buildbucket for the build status
[01:17:11.476] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:11.476] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:47:0) after 1m0s
[01:18:11.555] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:47:0)
[01:18:11.555] Timer tick, asking Buildbucket for the build status
[01:18:11.667] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:11.667] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:48:0) after 1m0s
[01:19:11.677] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:48:0)
[01:19:11.677] Timer tick, asking Buildbucket for the build status
[01:19:12.312] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:12.312] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:49:0) after 1m0s
[01:20:12.305] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:49:0)
[01:20:12.305] Timer tick, asking Buildbucket for the build status
[01:20:12.375] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:12.375] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:50:0) after 1m0s
[01:21:12.384] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:50:0)
[01:21:12.384] Timer tick, asking Buildbucket for the build status
[01:21:14.730] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:14.730] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:51:0) after 1m0s
[01:22:14.798] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:51:0)
[01:22:14.798] Timer tick, asking Buildbucket for the build status
[01:22:14.885] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:14.885] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:52:0) after 1m0s
[01:23:14.921] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:52:0)
[01:23:14.921] Timer tick, asking Buildbucket for the build status
[01:23:15.189] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:15.189] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:53:0) after 1m0s
[01:24:15.208] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:53:0)
[01:24:15.208] Timer tick, asking Buildbucket for the build status
[01:24:15.297] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:15.297] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:54:0) after 1m0s
[01:25:15.324] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:54:0)
[01:25:15.324] Timer tick, asking Buildbucket for the build status
[01:25:15.483] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:15.483] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:55:0) after 1m0s
[01:26:15.531] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:55:0)
[01:26:15.531] Timer tick, asking Buildbucket for the build status
[01:26:15.600] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:15.600] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:56:0) after 1m0s
[01:27:15.601] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:56:0)
[01:27:15.601] Timer tick, asking Buildbucket for the build status
[01:27:16.015] Build 8865058961850396752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:16.015] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9030489023896695008:57:0) after 1m0s
[01:27:54.981] Received PubSub notification, asking Buildbucket for the build status
[01:27:58.319] Build 8865058961850396752: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[01:27:58.319] Buildbucket build:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"completed_ts": "1604021273692655",
"created_by": "project:emscripten-releases",
"created_ts": "1604017976864390",
"id": "8865058961850396752",
"parameters_json": "{\"builder_name\": \"linux\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"67499d71a243f8f552e6c371fc39f19f315ac2ca\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@67499d71a243f8f552e6c371fc39f19f315ac2ca\", \"title\": \"67499d71a243f8f552e6c371fc39f19f315ac2ca\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/67499d71a243f8f552e6c371fc39f19f315ac2ca\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"67499d71a243f8f552e6c371fc39f19f315ac2ca\"}}",
"project": "emscripten-releases",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/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\": \"67499d71a243f8f552e6c371fc39f19f315ac2ca\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@67499d71a243f8f552e6c371fc39f19f315ac2ca\", \"title\": \"67499d71a243f8f552e6c371fc39f19f315ac2ca\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/67499d71a243f8f552e6c371fc39f19f315ac2ca\"}]}, \"bot_id\": \"luci-emscripten-releases-ci-xenial-0-twes\", \"branch\": \"refs/heads/master\", \"buildername\": \"linux\", \"got_revision\": \"67499d71a243f8f552e6c371fc39f19f315ac2ca\", \"path_config\": \"generic\", \"recipe\": \"emscripten_releases\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"67499d71a243f8f552e6c371fc39f19f315ac2ca\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_461cb3affc6f270af3ac9b28cfd8af8c60e3aebc1d1ae3ebd8f2aa2c00b55fae_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"host_class\": [\"default\"], \"id\": [\"luci-emscripten-releases-ci-xenial-0-twes\"], \"image\": [\"chrome-xenial-20102500-5da31bca5f9\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.emscripten-releases.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5614-d862eaa\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604018024950861",
"status": "COMPLETED",
"status_changed_ts": "1604021274476310",
"tags": [
"builder:linux",
"buildset:commit/git/67499d71a243f8f552e6c371fc39f19f315ac2ca",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/67499d71a243f8f552e6c371fc39f19f315ac2ca",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030489023896695008",
"scheduler_job_id:emscripten-releases/linux",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/emscripten-releases/buildbucket/cr-buildbucket.appspot.com/8865058961850396752/+/annotations",
"swarming_tag:luci_project:emscripten-releases",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:emscripten_releases",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:4f8fbd8273dd0610",
"user_agent:luci-scheduler"
],
"updated_ts": "1604021274611856",
"url": "https://ci.chromium.org/b/8865058961850396752",
"utcnow_ts": "1604021276191205"
}
}
[01:27:58.319] Invocation finished in 55m2.789651904s with status SUCCEEDED