[07:39:46.706] New invocation is queued and will start shortly
[07:39:49.739] Starting the invocation (attempt 1)
[07:39:49.793] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:39:49.793] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:39:49.793] Buildbucket request:
{
"bucket": "luci.emscripten-releases.ci",
"client_operation_id": "9044776489344505920",
"parameters_json": "{\"builder_name\":\"mac\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"40c21a872f7f3d7f2d3f6499b37e94f97bcd7460\"},\"id\":\"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@40c21a872f7f3d7f2d3f6499b37e94f97bcd7460\",\"title\":\"40c21a872f7f3d7f2d3f6499b37e94f97bcd7460\",\"url\":\"https://chromium.googlesource.com/emscripten-releases/+/40c21a872f7f3d7f2d3f6499b37e94f97bcd7460\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"40c21a872f7f3d7f2d3f6499b37e94f97bcd7460\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:mac",
"scheduler_invocation_id:9044776489344505920",
"scheduler_job_id:emscripten-releases/mac",
"user_agent:luci-scheduler",
"buildset:commit/git/40c21a872f7f3d7f2d3f6499b37e94f97bcd7460",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/40c21a872f7f3d7f2d3f6499b37e94f97bcd7460",
"gitiles_ref:refs/heads/master"
]
}
[07:39:50.550] Buildbucket response:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"created_by": "project:emscripten-releases",
"created_ts": "1590392389909141",
"id": "8879346425316585600",
"parameters_json": "{\"builder_name\": \"mac\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"40c21a872f7f3d7f2d3f6499b37e94f97bcd7460\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@40c21a872f7f3d7f2d3f6499b37e94f97bcd7460\", \"title\": \"40c21a872f7f3d7f2d3f6499b37e94f97bcd7460\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/40c21a872f7f3d7f2d3f6499b37e94f97bcd7460\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"40c21a872f7f3d7f2d3f6499b37e94f97bcd7460\"}}",
"project": "emscripten-releases",
"result_details_json": "{\"properties\": {}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1590392390366134",
"tags": [
"builder:mac",
"buildset:commit/git/40c21a872f7f3d7f2d3f6499b37e94f97bcd7460",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/40c21a872f7f3d7f2d3f6499b37e94f97bcd7460",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9044776489344505920",
"scheduler_job_id:emscripten-releases/mac",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/emscripten-releases/buildbucket/cr-buildbucket.appspot.com/8879346425316585600/+/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": "1590392390366246",
"url": "https://ci.chromium.org/b/8879346425316585600",
"utcnow_ts": "1590392390529829"
}
}
[07:39:50.550] Task URL: https://ci.chromium.org/b/8879346425316585600
[07:39:50.550] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:2:0) after 1m0s
[07:40:23.560] Received PubSub notification, asking Buildbucket for the build status
[07:40:24.267] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:50.704] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:2:0)
[07:40:50.704] Timer tick, asking Buildbucket for the build status
[07:40:51.267] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:51.267] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:4:0) after 1m0s
[07:41:51.647] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:4:0)
[07:41:51.647] Timer tick, asking Buildbucket for the build status
[07:41:52.199] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:52.199] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:5:0) after 1m0s
[07:42:52.339] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:5:0)
[07:42:52.339] Timer tick, asking Buildbucket for the build status
[07:42:52.578] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:52.578] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:6:0) after 1m0s
[07:43:53.041] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:6:0)
[07:43:53.041] Timer tick, asking Buildbucket for the build status
[07:43:53.341] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:53.341] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:7:0) after 1m0s
[07:44:53.748] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:7:0)
[07:44:53.748] Timer tick, asking Buildbucket for the build status
[07:44:53.923] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:53.923] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:8:0) after 1m0s
[07:45:53.995] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:8:0)
[07:45:53.995] Timer tick, asking Buildbucket for the build status
[07:45:54.364] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:54.364] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:9:0) after 1m0s
[07:46:54.482] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:9:0)
[07:46:54.482] Timer tick, asking Buildbucket for the build status
[07:46:54.859] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:54.859] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:10:0) after 1m0s
[07:47:54.865] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:10:0)
[07:47:54.865] Timer tick, asking Buildbucket for the build status
[07:47:56.115] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:56.115] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:11:0) after 1m0s
[07:48:56.233] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:11:0)
[07:48:56.233] Timer tick, asking Buildbucket for the build status
[07:48:56.446] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:56.446] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:12:0) after 1m0s
[07:49:56.457] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:12:0)
[07:49:56.457] Timer tick, asking Buildbucket for the build status
[07:49:56.814] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:56.814] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:13:0) after 1m0s
[07:50:56.897] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:13:0)
[07:50:56.897] Timer tick, asking Buildbucket for the build status
[07:50:57.284] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:57.284] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:14:0) after 1m0s
[07:51:57.620] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:14:0)
[07:51:57.620] Timer tick, asking Buildbucket for the build status
[07:51:57.778] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:57.778] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:15:0) after 1m0s
[07:52:57.860] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:15:0)
[07:52:57.860] Timer tick, asking Buildbucket for the build status
[07:52:58.681] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:58.681] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:16:0) after 1m0s
[07:53:58.942] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:16:0)
[07:53:58.942] Timer tick, asking Buildbucket for the build status
[07:53:59.179] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:59.179] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:17:0) after 1m0s
[07:54:59.201] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:17:0)
[07:54:59.201] Timer tick, asking Buildbucket for the build status
[07:54:59.588] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:59.588] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:18:0) after 1m0s
[07:55:59.571] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:18:0)
[07:55:59.571] Timer tick, asking Buildbucket for the build status
[07:55:59.866] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:59.866] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:19:0) after 1m0s
[07:56:59.925] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:19:0)
[07:56:59.925] Timer tick, asking Buildbucket for the build status
[07:57:00.616] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:00.616] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:20:0) after 1m0s
[07:58:01.046] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:20:0)
[07:58:01.046] Timer tick, asking Buildbucket for the build status
[07:58:01.241] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:01.241] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:21:0) after 1m0s
[07:59:01.443] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:21:0)
[07:59:01.443] Timer tick, asking Buildbucket for the build status
[07:59:01.624] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:01.624] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:22:0) after 1m0s
[08:00:01.651] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:22:0)
[08:00:01.651] Timer tick, asking Buildbucket for the build status
[08:00:02.385] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:02.385] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:23:0) after 1m0s
[08:01:02.402] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:23:0)
[08:01:02.402] Timer tick, asking Buildbucket for the build status
[08:01:02.647] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:02.647] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:24:0) after 1m0s
[08:02:02.684] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:24:0)
[08:02:02.684] Timer tick, asking Buildbucket for the build status
[08:02:02.954] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:02.954] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:25:0) after 1m0s
[08:03:02.975] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:25:0)
[08:03:02.975] Timer tick, asking Buildbucket for the build status
[08:03:03.115] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:03.115] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:26:0) after 1m0s
[08:04:03.138] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:26:0)
[08:04:03.138] Timer tick, asking Buildbucket for the build status
[08:04:03.454] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:03.454] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:27:0) after 1m0s
[08:05:03.482] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:27:0)
[08:05:03.482] Timer tick, asking Buildbucket for the build status
[08:05:03.901] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:03.901] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:28:0) after 1m0s
[08:06:03.882] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:28:0)
[08:06:03.882] Timer tick, asking Buildbucket for the build status
[08:06:04.071] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:04.071] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:29:0) after 1m0s
[08:07:04.121] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:29:0)
[08:07:04.121] Timer tick, asking Buildbucket for the build status
[08:07:04.365] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:04.365] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:30:0) after 1m0s
[08:08:04.406] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:30:0)
[08:08:04.406] Timer tick, asking Buildbucket for the build status
[08:08:04.813] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:04.813] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:31:0) after 1m0s
[08:09:04.979] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:31:0)
[08:09:04.979] Timer tick, asking Buildbucket for the build status
[08:09:05.177] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:05.177] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:32:0) after 1m0s
[08:10:05.183] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:32:0)
[08:10:05.183] Timer tick, asking Buildbucket for the build status
[08:10:05.444] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:05.444] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:33:0) after 1m0s
[08:11:05.507] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:33:0)
[08:11:05.507] Timer tick, asking Buildbucket for the build status
[08:11:06.136] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:06.136] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:34:0) after 1m0s
[08:12:07.703] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:34:0)
[08:12:07.703] Timer tick, asking Buildbucket for the build status
[08:12:08.241] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:08.241] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:35:0) after 1m0s
[08:13:10.174] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:35:0)
[08:13:10.174] Timer tick, asking Buildbucket for the build status
[08:13:10.365] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:10.365] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:36:0) after 1m0s
[08:14:10.403] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:36:0)
[08:14:10.403] Timer tick, asking Buildbucket for the build status
[08:14:10.771] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:10.771] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:37:0) after 1m0s
[08:15:10.827] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:37:0)
[08:15:10.827] Timer tick, asking Buildbucket for the build status
[08:15:11.074] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:11.074] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:38:0) after 1m0s
[08:16:11.198] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:38:0)
[08:16:11.198] Timer tick, asking Buildbucket for the build status
[08:16:11.441] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:11.441] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:39:0) after 1m0s
[08:17:11.462] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:39:0)
[08:17:11.462] Timer tick, asking Buildbucket for the build status
[08:17:11.703] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:11.703] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:40:0) after 1m0s
[08:18:11.722] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:40:0)
[08:18:11.722] Timer tick, asking Buildbucket for the build status
[08:18:12.003] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:12.003] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:41:0) after 1m0s
[08:19:12.030] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:41:0)
[08:19:12.030] Timer tick, asking Buildbucket for the build status
[08:19:12.730] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:12.730] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:42:0) after 1m0s
[08:20:12.726] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:42:0)
[08:20:12.726] Timer tick, asking Buildbucket for the build status
[08:20:14.411] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:14.411] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:43:0) after 1m0s
[08:21:14.433] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:43:0)
[08:21:14.433] Timer tick, asking Buildbucket for the build status
[08:21:14.825] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:14.825] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:44:0) after 1m0s
[08:22:14.877] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:44:0)
[08:22:14.877] Timer tick, asking Buildbucket for the build status
[08:22:15.736] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:15.736] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:45:0) after 1m0s
[08:23:15.759] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:45:0)
[08:23:15.759] Timer tick, asking Buildbucket for the build status
[08:23:15.905] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:15.906] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:46:0) after 1m0s
[08:24:15.977] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:46:0)
[08:24:15.977] Timer tick, asking Buildbucket for the build status
[08:24:16.269] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:16.269] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:47:0) after 1m0s
[08:25:16.393] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:47:0)
[08:25:16.393] Timer tick, asking Buildbucket for the build status
[08:25:17.002] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:17.002] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:48:0) after 1m0s
[08:26:17.022] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:48:0)
[08:26:17.022] Timer tick, asking Buildbucket for the build status
[08:26:17.370] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:17.371] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:49:0) after 1m0s
[08:27:17.388] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:49:0)
[08:27:17.388] Timer tick, asking Buildbucket for the build status
[08:27:17.832] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:17.832] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:50:0) after 1m0s
[08:28:17.828] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:50:0)
[08:28:17.828] Timer tick, asking Buildbucket for the build status
[08:28:18.409] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:18.409] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:51:0) after 1m0s
[08:29:18.413] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:51:0)
[08:29:18.413] Timer tick, asking Buildbucket for the build status
[08:29:18.704] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:18.704] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:52:0) after 1m0s
[08:30:18.776] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:52:0)
[08:30:18.776] Timer tick, asking Buildbucket for the build status
[08:30:19.068] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:19.068] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:53:0) after 1m0s
[08:31:19.124] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:53:0)
[08:31:19.124] Timer tick, asking Buildbucket for the build status
[08:31:21.162] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:21.162] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:54:0) after 1m0s
[08:32:21.266] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:54:0)
[08:32:21.266] Timer tick, asking Buildbucket for the build status
[08:32:21.448] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:21.448] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:55:0) after 1m0s
[08:33:21.477] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:55:0)
[08:33:21.477] Timer tick, asking Buildbucket for the build status
[08:33:21.618] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:21.618] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:56:0) after 1m0s
[08:34:21.688] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:56:0)
[08:34:21.688] Timer tick, asking Buildbucket for the build status
[08:34:21.985] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:21.985] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:57:0) after 1m0s
[08:35:22.186] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:57:0)
[08:35:22.186] Timer tick, asking Buildbucket for the build status
[08:35:23.151] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:23.151] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:58:0) after 1m0s
[08:36:23.187] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:58:0)
[08:36:23.187] Timer tick, asking Buildbucket for the build status
[08:36:23.496] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:23.496] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:59:0) after 1m0s
[08:37:23.548] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:59:0)
[08:37:23.548] Timer tick, asking Buildbucket for the build status
[08:37:23.835] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:23.835] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:60:0) after 1m0s
[08:38:24.034] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:60:0)
[08:38:24.034] Timer tick, asking Buildbucket for the build status
[08:38:24.278] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:24.278] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:61:0) after 1m0s
[08:39:24.289] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:61:0)
[08:39:24.289] Timer tick, asking Buildbucket for the build status
[08:39:24.758] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:24.758] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:62:0) after 1m0s
[08:40:25.026] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:62:0)
[08:40:25.026] Timer tick, asking Buildbucket for the build status
[08:40:26.525] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:26.525] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:63:0) after 1m0s
[08:41:26.637] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:63:0)
[08:41:26.637] Timer tick, asking Buildbucket for the build status
[08:41:26.880] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:26.880] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:64:0) after 1m0s
[08:42:26.918] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:64:0)
[08:42:26.918] Timer tick, asking Buildbucket for the build status
[08:42:27.338] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:27.338] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:65:0) after 1m0s
[08:43:27.523] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:65:0)
[08:43:27.523] Timer tick, asking Buildbucket for the build status
[08:43:27.776] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:27.776] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:66:0) after 1m0s
[08:44:27.879] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:66:0)
[08:44:27.879] Timer tick, asking Buildbucket for the build status
[08:44:28.053] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:28.053] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:67:0) after 1m0s
[08:45:28.113] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:67:0)
[08:45:28.113] Timer tick, asking Buildbucket for the build status
[08:45:28.241] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:28.241] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:68:0) after 1m0s
[08:46:28.264] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:68:0)
[08:46:28.264] Timer tick, asking Buildbucket for the build status
[08:46:28.717] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:28.717] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:69:0) after 1m0s
[08:47:28.783] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:69:0)
[08:47:28.783] Timer tick, asking Buildbucket for the build status
[08:47:29.004] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:29.004] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:70:0) after 1m0s
[08:48:29.047] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:70:0)
[08:48:29.047] Timer tick, asking Buildbucket for the build status
[08:48:29.921] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:29.921] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:71:0) after 1m0s
[08:49:29.923] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:71:0)
[08:49:29.923] Timer tick, asking Buildbucket for the build status
[08:49:30.111] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:30.112] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:72:0) after 1m0s
[08:50:30.218] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:72:0)
[08:50:30.218] Timer tick, asking Buildbucket for the build status
[08:50:31.811] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:31.811] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:73:0) after 1m0s
[08:51:31.939] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:73:0)
[08:51:31.939] Timer tick, asking Buildbucket for the build status
[08:51:32.116] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:32.116] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:74:0) after 1m0s
[08:52:32.196] Handling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:74:0)
[08:52:32.196] Timer tick, asking Buildbucket for the build status
[08:52:32.488] Build 8879346425316585600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:32.488] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/mac:9044776489344505920:75:0) after 1m0s
[08:52:57.450] Received PubSub notification, asking Buildbucket for the build status
[08:52:57.764] Build 8879346425316585600: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[08:52:57.764] Buildbucket build:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"completed_ts": "1590396776570384",
"created_by": "project:emscripten-releases",
"created_ts": "1590392389909141",
"id": "8879346425316585600",
"parameters_json": "{\"builder_name\": \"mac\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"40c21a872f7f3d7f2d3f6499b37e94f97bcd7460\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@40c21a872f7f3d7f2d3f6499b37e94f97bcd7460\", \"title\": \"40c21a872f7f3d7f2d3f6499b37e94f97bcd7460\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/40c21a872f7f3d7f2d3f6499b37e94f97bcd7460\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"40c21a872f7f3d7f2d3f6499b37e94f97bcd7460\"}}",
"project": "emscripten-releases",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$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\": \"40c21a872f7f3d7f2d3f6499b37e94f97bcd7460\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@40c21a872f7f3d7f2d3f6499b37e94f97bcd7460\", \"title\": \"40c21a872f7f3d7f2d3f6499b37e94f97bcd7460\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/40c21a872f7f3d7f2d3f6499b37e94f97bcd7460\"}]}, \"bot_id\": \"build498-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"mac\", \"got_revision\": \"40c21a872f7f3d7f2d3f6499b37e94f97bcd7460\", \"path_config\": \"generic\", \"recipe\": \"emscripten_releases\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"40c21a872f7f3d7f2d3f6499b37e94f97bcd7460\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_0d6fa4fff4995a408e468cf6236551b5d2129f3e939116f3b74cbba851b7eb7d_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"4\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-i7-4578U\"], \"gce\": [\"0\"], \"gpu\": [\"8086\", \"8086:0a2e\"], \"hidpi\": [\"0\"], \"host_class\": [\"default\"], \"id\": [\"build498-m9\"], \"mac_model\": [\"Macmini7,1\"], \"machine_type\": [\"n1-standard-4\"], \"os\": [\"Mac\", \"Mac-10.13\", \"Mac-10.13.6\"], \"pool\": [\"luci.emscripten-releases.ci\"], \"python\": [\"2.7.10\"], \"server_version\": [\"5100-d2625c1\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1590392422630177",
"status": "COMPLETED",
"status_changed_ts": "1590396776973098",
"tags": [
"builder:mac",
"buildset:commit/git/40c21a872f7f3d7f2d3f6499b37e94f97bcd7460",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/40c21a872f7f3d7f2d3f6499b37e94f97bcd7460",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9044776489344505920",
"scheduler_job_id:emscripten-releases/mac",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/emscripten-releases/buildbucket/cr-buildbucket.appspot.com/8879346425316585600/+/annotations",
"swarming_tag:luci_project:emscripten-releases",
"swarming_tag:os:Mac",
"swarming_tag:recipe_name:emscripten_releases",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:4c63978c5a442f10",
"user_agent:luci-scheduler"
],
"updated_ts": "1590396777046207",
"url": "https://ci.chromium.org/b/8879346425316585600",
"utcnow_ts": "1590396777743868"
}
}
[08:52:57.764] Invocation finished in 1h13m11.078925185s with status SUCCEEDED