[09:56:46.513] New invocation is queued and will start shortly
[09:56:47.749] Starting the invocation (attempt 1)
[09:56:47.784] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:56:47.785] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:56:47.785] Buildbucket request:
{
"bucket": "luci.emscripten-releases.ci",
"client_operation_id": "9045583242943705200",
"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\":\"0b3c16990d938fe507dbbe73657f6f8a5fc9e98d\"},\"id\":\"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@0b3c16990d938fe507dbbe73657f6f8a5fc9e98d\",\"title\":\"0b3c16990d938fe507dbbe73657f6f8a5fc9e98d\",\"url\":\"https://chromium.googlesource.com/emscripten-releases/+/0b3c16990d938fe507dbbe73657f6f8a5fc9e98d\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"0b3c16990d938fe507dbbe73657f6f8a5fc9e98d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux",
"scheduler_invocation_id:9045583242943705200",
"scheduler_job_id:emscripten-releases/linux",
"user_agent:luci-scheduler",
"buildset:commit/git/0b3c16990d938fe507dbbe73657f6f8a5fc9e98d",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/0b3c16990d938fe507dbbe73657f6f8a5fc9e98d",
"gitiles_ref:refs/heads/master"
]
}
[09:56:48.421] Buildbucket response:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"created_by": "project:emscripten-releases",
"created_ts": "1589623007905589",
"id": "8880153180821745216",
"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\": \"0b3c16990d938fe507dbbe73657f6f8a5fc9e98d\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@0b3c16990d938fe507dbbe73657f6f8a5fc9e98d\", \"title\": \"0b3c16990d938fe507dbbe73657f6f8a5fc9e98d\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/0b3c16990d938fe507dbbe73657f6f8a5fc9e98d\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"0b3c16990d938fe507dbbe73657f6f8a5fc9e98d\"}}",
"project": "emscripten-releases",
"result_details_json": "{\"properties\": {}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1589623008268579",
"tags": [
"builder:linux",
"buildset:commit/git/0b3c16990d938fe507dbbe73657f6f8a5fc9e98d",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/0b3c16990d938fe507dbbe73657f6f8a5fc9e98d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9045583242943705200",
"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/8880153180821745216/+/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": "1589623008268725",
"url": "https://ci.chromium.org/b/8880153180821745216",
"utcnow_ts": "1589623008413389"
}
}
[09:56:48.421] Task URL: https://ci.chromium.org/b/8880153180821745216
[09:56:48.421] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:2:0) after 1m0s
[09:57:45.138] Received PubSub notification, asking Buildbucket for the build status
[09:57:45.346] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:48.475] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:2:0)
[09:57:48.475] Timer tick, asking Buildbucket for the build status
[09:57:48.562] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:48.562] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:4:0) after 1m0s
[09:58:48.651] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:4:0)
[09:58:48.651] Timer tick, asking Buildbucket for the build status
[09:58:49.053] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:49.053] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:5:0) after 1m0s
[09:59:49.098] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:5:0)
[09:59:49.098] Timer tick, asking Buildbucket for the build status
[09:59:49.385] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:49.385] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:6:0) after 1m0s
[10:00:49.466] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:6:0)
[10:00:49.466] Timer tick, asking Buildbucket for the build status
[10:00:49.735] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:49.735] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:7:0) after 1m0s
[10:01:49.884] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:7:0)
[10:01:49.884] Timer tick, asking Buildbucket for the build status
[10:01:50.193] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:50.193] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:8:0) after 1m0s
[10:02:50.460] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:8:0)
[10:02:50.460] Timer tick, asking Buildbucket for the build status
[10:02:50.786] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:50.786] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:9:0) after 1m0s
[10:03:50.837] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:9:0)
[10:03:50.837] Timer tick, asking Buildbucket for the build status
[10:03:51.215] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:51.215] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:10:0) after 1m0s
[10:04:51.344] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:10:0)
[10:04:51.344] Timer tick, asking Buildbucket for the build status
[10:04:51.777] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:51.777] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:11:0) after 1m0s
[10:05:51.952] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:11:0)
[10:05:51.952] Timer tick, asking Buildbucket for the build status
[10:05:52.463] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:52.463] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:12:0) after 1m0s
[10:06:52.700] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:12:0)
[10:06:52.700] Timer tick, asking Buildbucket for the build status
[10:06:53.169] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:53.169] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:13:0) after 1m0s
[10:07:53.260] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:13:0)
[10:07:53.260] Timer tick, asking Buildbucket for the build status
[10:07:53.452] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:53.452] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:14:0) after 1m0s
[10:08:53.549] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:14:0)
[10:08:53.549] Timer tick, asking Buildbucket for the build status
[10:08:53.874] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:53.874] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:15:0) after 1m0s
[10:09:53.896] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:15:0)
[10:09:53.896] Timer tick, asking Buildbucket for the build status
[10:09:54.044] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:54.044] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:16:0) after 1m0s
[10:10:54.063] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:16:0)
[10:10:54.063] Timer tick, asking Buildbucket for the build status
[10:10:54.221] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:54.221] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:17:0) after 1m0s
[10:11:54.251] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:17:0)
[10:11:54.251] Timer tick, asking Buildbucket for the build status
[10:11:54.670] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:54.670] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:18:0) after 1m0s
[10:12:54.762] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:18:0)
[10:12:54.762] Timer tick, asking Buildbucket for the build status
[10:12:54.909] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:54.909] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:19:0) after 1m0s
[10:13:54.927] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:19:0)
[10:13:54.927] Timer tick, asking Buildbucket for the build status
[10:13:55.113] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:55.113] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:20:0) after 1m0s
[10:14:55.214] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:20:0)
[10:14:55.214] Timer tick, asking Buildbucket for the build status
[10:14:55.662] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:55.662] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:21:0) after 1m0s
[10:15:55.850] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:21:0)
[10:15:55.850] Timer tick, asking Buildbucket for the build status
[10:15:56.239] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:56.239] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:22:0) after 1m0s
[10:16:56.403] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:22:0)
[10:16:56.403] Timer tick, asking Buildbucket for the build status
[10:16:56.578] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:56.578] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:23:0) after 1m0s
[10:17:56.694] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:23:0)
[10:17:56.694] Timer tick, asking Buildbucket for the build status
[10:17:57.072] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:57.072] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:24:0) after 1m0s
[10:18:57.274] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:24:0)
[10:18:57.274] Timer tick, asking Buildbucket for the build status
[10:18:57.888] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:57.888] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:25:0) after 1m0s
[10:19:57.912] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:25:0)
[10:19:57.912] Timer tick, asking Buildbucket for the build status
[10:19:58.350] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:58.350] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:26:0) after 1m0s
[10:20:58.481] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:26:0)
[10:20:58.481] Timer tick, asking Buildbucket for the build status
[10:20:58.596] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:58.596] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:27:0) after 1m0s
[10:21:58.705] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:27:0)
[10:21:58.705] Timer tick, asking Buildbucket for the build status
[10:21:59.003] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:59.003] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:28:0) after 1m0s
[10:22:59.013] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:28:0)
[10:22:59.013] Timer tick, asking Buildbucket for the build status
[10:22:59.149] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:59.149] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:29:0) after 1m0s
[10:23:59.177] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:29:0)
[10:23:59.177] Timer tick, asking Buildbucket for the build status
[10:23:59.339] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:59.339] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:30:0) after 1m0s
[10:24:59.366] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:30:0)
[10:24:59.366] Timer tick, asking Buildbucket for the build status
[10:24:59.487] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:59.488] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:31:0) after 1m0s
[10:25:59.511] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:31:0)
[10:25:59.511] Timer tick, asking Buildbucket for the build status
[10:25:59.716] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:59.716] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:32:0) after 1m0s
[10:26:59.736] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:32:0)
[10:26:59.736] Timer tick, asking Buildbucket for the build status
[10:26:59.873] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:59.873] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:33:0) after 1m0s
[10:27:59.891] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:33:0)
[10:27:59.891] Timer tick, asking Buildbucket for the build status
[10:28:00.176] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:00.176] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:34:0) after 1m0s
[10:29:00.201] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:34:0)
[10:29:00.201] Timer tick, asking Buildbucket for the build status
[10:29:00.384] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:00.384] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:35:0) after 1m0s
[10:30:00.427] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:35:0)
[10:30:00.427] Timer tick, asking Buildbucket for the build status
[10:30:00.563] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:00.563] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:36:0) after 1m0s
[10:31:01.787] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:36:0)
[10:31:01.787] Timer tick, asking Buildbucket for the build status
[10:31:02.446] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:02.446] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:37:0) after 1m0s
[10:32:02.516] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:37:0)
[10:32:02.516] Timer tick, asking Buildbucket for the build status
[10:32:02.817] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:02.817] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:38:0) after 1m0s
[10:33:02.840] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:38:0)
[10:33:02.840] Timer tick, asking Buildbucket for the build status
[10:33:03.072] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:03.072] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:39:0) after 1m0s
[10:34:03.094] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:39:0)
[10:34:03.094] Timer tick, asking Buildbucket for the build status
[10:34:03.207] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:03.208] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:40:0) after 1m0s
[10:35:03.230] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:40:0)
[10:35:03.230] Timer tick, asking Buildbucket for the build status
[10:35:03.374] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:03.374] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:41:0) after 1m0s
[10:36:03.395] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:41:0)
[10:36:03.395] Timer tick, asking Buildbucket for the build status
[10:36:03.614] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:03.615] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:42:0) after 1m0s
[10:37:03.736] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:42:0)
[10:37:03.736] Timer tick, asking Buildbucket for the build status
[10:37:03.885] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:03.885] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:43:0) after 1m0s
[10:38:03.928] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:43:0)
[10:38:03.928] Timer tick, asking Buildbucket for the build status
[10:38:04.208] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:04.208] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:44:0) after 1m0s
[10:39:04.324] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:44:0)
[10:39:04.324] Timer tick, asking Buildbucket for the build status
[10:39:04.578] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:04.578] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:45:0) after 1m0s
[10:40:04.702] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:45:0)
[10:40:04.702] Timer tick, asking Buildbucket for the build status
[10:40:04.929] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:04.929] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:46:0) after 1m0s
[10:41:05.093] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:46:0)
[10:41:05.093] Timer tick, asking Buildbucket for the build status
[10:41:05.473] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:05.474] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:47:0) after 1m0s
[10:42:05.592] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:47:0)
[10:42:05.592] Timer tick, asking Buildbucket for the build status
[10:42:06.292] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:06.292] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:48:0) after 1m0s
[10:43:06.337] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:48:0)
[10:43:06.337] Timer tick, asking Buildbucket for the build status
[10:43:06.699] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:06.699] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:49:0) after 1m0s
[10:44:06.723] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:49:0)
[10:44:06.723] Timer tick, asking Buildbucket for the build status
[10:44:06.879] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:06.879] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:50:0) after 1m0s
[10:45:06.904] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:50:0)
[10:45:06.905] Timer tick, asking Buildbucket for the build status
[10:45:07.148] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:07.148] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:51:0) after 1m0s
[10:46:07.274] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:51:0)
[10:46:07.274] Timer tick, asking Buildbucket for the build status
[10:46:07.463] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:07.463] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:52:0) after 1m0s
[10:47:07.495] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:52:0)
[10:47:07.495] Timer tick, asking Buildbucket for the build status
[10:47:07.642] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:07.642] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:53:0) after 1m0s
[10:48:07.666] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:53:0)
[10:48:07.666] Timer tick, asking Buildbucket for the build status
[10:48:07.879] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:07.879] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:54:0) after 1m0s
[10:49:07.947] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:54:0)
[10:49:07.947] Timer tick, asking Buildbucket for the build status
[10:49:08.398] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:08.398] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:55:0) after 1m0s
[10:50:08.431] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:55:0)
[10:50:08.431] Timer tick, asking Buildbucket for the build status
[10:50:09.378] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:09.378] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:56:0) after 1m0s
[10:51:09.407] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:56:0)
[10:51:09.407] Timer tick, asking Buildbucket for the build status
[10:51:09.656] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:09.656] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:57:0) after 1m0s
[10:52:09.675] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:57:0)
[10:52:09.675] Timer tick, asking Buildbucket for the build status
[10:52:10.163] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:10.163] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:58:0) after 1m0s
[10:53:10.298] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:58:0)
[10:53:10.298] Timer tick, asking Buildbucket for the build status
[10:53:10.672] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:10.672] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:59:0) after 1m0s
[10:54:10.694] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:59:0)
[10:54:10.694] Timer tick, asking Buildbucket for the build status
[10:54:11.204] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:11.204] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:60:0) after 1m0s
[10:55:11.225] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:60:0)
[10:55:11.225] Timer tick, asking Buildbucket for the build status
[10:55:11.840] Build 8880153180821745216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:11.840] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9045583242943705200:61:0) after 1m0s
[10:55:55.000] Received PubSub notification, asking Buildbucket for the build status
[10:55:55.100] Build 8880153180821745216: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:55:55.100] Buildbucket build:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"completed_ts": "1589626553131603",
"created_by": "project:emscripten-releases",
"created_ts": "1589623007905589",
"id": "8880153180821745216",
"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\": \"0b3c16990d938fe507dbbe73657f6f8a5fc9e98d\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@0b3c16990d938fe507dbbe73657f6f8a5fc9e98d\", \"title\": \"0b3c16990d938fe507dbbe73657f6f8a5fc9e98d\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/0b3c16990d938fe507dbbe73657f6f8a5fc9e98d\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"0b3c16990d938fe507dbbe73657f6f8a5fc9e98d\"}}",
"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\": \"0b3c16990d938fe507dbbe73657f6f8a5fc9e98d\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@0b3c16990d938fe507dbbe73657f6f8a5fc9e98d\", \"title\": \"0b3c16990d938fe507dbbe73657f6f8a5fc9e98d\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/0b3c16990d938fe507dbbe73657f6f8a5fc9e98d\"}]}, \"bot_id\": \"luci-emscripten-releases-ci-xenial-0-uz9h\", \"branch\": \"refs/heads/master\", \"buildername\": \"linux\", \"got_revision\": \"0b3c16990d938fe507dbbe73657f6f8a5fc9e98d\", \"path_config\": \"generic\", \"recipe\": \"emscripten_releases\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"0b3c16990d938fe507dbbe73657f6f8a5fc9e98d\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_461cb3affc6f270af3ac9b28cfd8af8c60e3aebc1d1ae3ebd8f2aa2c00b55fae_v2\", \"builder_e437bc7da551d62da6a64b09ca05a66344db3b0846e125cb83052108c473fa36_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-uz9h\"], \"image\": [\"chrome-xenial-20041200-f56df5dd7ad\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.emscripten-releases.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5088-a734129\"], \"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": "1589623063390714",
"status": "COMPLETED",
"status_changed_ts": "1589626554340061",
"tags": [
"builder:linux",
"buildset:commit/git/0b3c16990d938fe507dbbe73657f6f8a5fc9e98d",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/0b3c16990d938fe507dbbe73657f6f8a5fc9e98d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9045583242943705200",
"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/8880153180821745216/+/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:4c35bbb6d783ba10",
"user_agent:luci-scheduler"
],
"updated_ts": "1589626554361659",
"url": "https://ci.chromium.org/b/8880153180821745216",
"utcnow_ts": "1589626555089111"
}
}
[10:55:55.100] Invocation finished in 59m8.603048685s with status SUCCEEDED