[22:37:22.456] New invocation is queued and will start shortly
[22:37:23.535] Starting the invocation (attempt 1)
[22:37:23.581] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:37:23.581] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:37:23.581] Buildbucket request:
{
"bucket": "luci.emscripten-releases.ci",
"client_operation_id": "9068637616623203600",
"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\":\"17748eb435b5da201850fd6bed3ee9eb7f0f4a69\"},\"id\":\"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@17748eb435b5da201850fd6bed3ee9eb7f0f4a69\",\"title\":\"17748eb435b5da201850fd6bed3ee9eb7f0f4a69\",\"url\":\"https://chromium.googlesource.com/emscripten-releases/+/17748eb435b5da201850fd6bed3ee9eb7f0f4a69\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"17748eb435b5da201850fd6bed3ee9eb7f0f4a69\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux",
"scheduler_invocation_id:9068637616623203600",
"scheduler_job_id:emscripten-releases/linux",
"user_agent:luci-scheduler",
"buildset:commit/git/17748eb435b5da201850fd6bed3ee9eb7f0f4a69",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/17748eb435b5da201850fd6bed3ee9eb7f0f4a69",
"gitiles_ref:refs/heads/master"
]
}
[22:37:24.395] Buildbucket response:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"created_by": "project:emscripten-releases",
"created_ts": "1567636643692395",
"id": "8903207554662065312",
"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\": \"17748eb435b5da201850fd6bed3ee9eb7f0f4a69\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@17748eb435b5da201850fd6bed3ee9eb7f0f4a69\", \"title\": \"17748eb435b5da201850fd6bed3ee9eb7f0f4a69\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/17748eb435b5da201850fd6bed3ee9eb7f0f4a69\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"17748eb435b5da201850fd6bed3ee9eb7f0f4a69\"}}",
"project": "emscripten-releases",
"result_details_json": "{\"properties\": {}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1567636644126968",
"tags": [
"builder:linux",
"buildset:commit/git/17748eb435b5da201850fd6bed3ee9eb7f0f4a69",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/17748eb435b5da201850fd6bed3ee9eb7f0f4a69",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9068637616623203600",
"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/8903207554662065312/+/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": "1567636644127108",
"url": "https://ci.chromium.org/b/8903207554662065312",
"utcnow_ts": "1567636644377064"
}
}
[22:37:24.395] Task URL: https://ci.chromium.org/b/8903207554662065312
[22:37:24.395] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:2:0) after 1m0s
[22:38:24.440] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:2:0)
[22:38:24.440] Timer tick, asking Buildbucket for the build status
[22:38:25.127] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:38:25.127] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:3:0) after 1m0s
[22:39:25.149] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:3:0)
[22:39:25.149] Timer tick, asking Buildbucket for the build status
[22:39:25.570] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:39:25.570] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:4:0) after 1m0s
[22:40:25.596] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:4:0)
[22:40:25.596] Timer tick, asking Buildbucket for the build status
[22:40:26.653] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:40:26.653] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:5:0) after 1m0s
[22:41:26.807] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:5:0)
[22:41:26.807] Timer tick, asking Buildbucket for the build status
[22:41:42.043] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:41:42.044] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:6:0) after 1m0s
[22:42:42.058] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:6:0)
[22:42:42.058] Timer tick, asking Buildbucket for the build status
[22:42:42.235] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:42:42.235] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:7:0) after 1m0s
[22:43:42.359] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:7:0)
[22:43:42.359] Timer tick, asking Buildbucket for the build status
[22:43:42.623] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:43:42.623] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:8:0) after 1m0s
[22:44:42.706] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:8:0)
[22:44:42.706] Timer tick, asking Buildbucket for the build status
[22:44:42.827] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:44:42.827] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:9:0) after 1m0s
[22:45:42.952] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:9:0)
[22:45:42.953] Timer tick, asking Buildbucket for the build status
[22:45:43.228] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:45:43.228] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:10:0) after 1m0s
[22:46:43.420] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:10:0)
[22:46:43.420] Timer tick, asking Buildbucket for the build status
[22:46:44.220] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:46:44.220] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:11:0) after 1m0s
[22:47:44.270] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:11:0)
[22:47:44.270] Timer tick, asking Buildbucket for the build status
[22:47:49.401] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:47:49.401] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:12:0) after 1m0s
[22:48:49.421] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:12:0)
[22:48:49.421] Timer tick, asking Buildbucket for the build status
[22:48:49.552] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:48:49.552] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:13:0) after 1m0s
[22:49:49.583] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:13:0)
[22:49:49.583] Timer tick, asking Buildbucket for the build status
[22:49:50.524] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:49:50.524] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:14:0) after 1m0s
[22:50:50.568] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:14:0)
[22:50:50.568] Timer tick, asking Buildbucket for the build status
[22:50:50.717] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:50:50.717] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:15:0) after 1m0s
[22:51:50.782] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:15:0)
[22:51:50.782] Timer tick, asking Buildbucket for the build status
[22:51:50.921] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:51:50.921] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:16:0) after 1m0s
[22:52:51.575] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:16:0)
[22:52:51.575] Timer tick, asking Buildbucket for the build status
[22:52:52.098] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:52:52.098] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:17:0) after 1m0s
[22:53:52.553] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:17:0)
[22:53:52.553] Timer tick, asking Buildbucket for the build status
[22:53:53.335] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:53:53.335] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:18:0) after 1m0s
[22:54:53.583] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:18:0)
[22:54:53.583] Timer tick, asking Buildbucket for the build status
[22:54:54.256] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:54:54.256] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:19:0) after 1m0s
[22:55:54.398] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:19:0)
[22:55:54.398] Timer tick, asking Buildbucket for the build status
[22:55:54.685] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:55:54.685] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:20:0) after 1m0s
[22:56:54.746] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:20:0)
[22:56:54.746] Timer tick, asking Buildbucket for the build status
[22:56:55.426] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:56:55.426] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:21:0) after 1m0s
[22:57:55.678] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:21:0)
[22:57:55.678] Timer tick, asking Buildbucket for the build status
[22:57:55.971] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:57:55.971] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:22:0) after 1m0s
[22:58:56.046] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:22:0)
[22:58:56.047] Timer tick, asking Buildbucket for the build status
[22:58:56.252] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:58:56.252] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:23:0) after 1m0s
[22:59:56.356] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:23:0)
[22:59:56.356] Timer tick, asking Buildbucket for the build status
[22:59:56.683] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:59:56.683] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:24:0) after 1m0s
[23:00:56.691] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:24:0)
[23:00:56.691] Timer tick, asking Buildbucket for the build status
[23:00:56.837] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:00:56.837] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:25:0) after 1m0s
[23:01:57.032] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:25:0)
[23:01:57.032] Timer tick, asking Buildbucket for the build status
[23:01:57.229] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:01:57.230] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:26:0) after 1m0s
[23:02:57.277] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:26:0)
[23:02:57.277] Timer tick, asking Buildbucket for the build status
[23:02:57.404] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:02:57.404] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:27:0) after 1m0s
[23:03:57.524] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:27:0)
[23:03:57.524] Timer tick, asking Buildbucket for the build status
[23:03:57.704] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:03:57.704] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:28:0) after 1m0s
[23:04:57.785] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:28:0)
[23:04:57.785] Timer tick, asking Buildbucket for the build status
[23:04:58.007] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:04:58.008] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:29:0) after 1m0s
[23:05:58.406] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:29:0)
[23:05:58.406] Timer tick, asking Buildbucket for the build status
[23:05:58.771] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:05:58.771] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:30:0) after 1m0s
[23:06:58.907] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:30:0)
[23:06:58.907] Timer tick, asking Buildbucket for the build status
[23:06:59.076] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:06:59.076] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:31:0) after 1m0s
[23:07:59.296] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:31:0)
[23:07:59.296] Timer tick, asking Buildbucket for the build status
[23:07:59.718] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:07:59.718] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:32:0) after 1m0s
[23:08:59.970] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:32:0)
[23:08:59.970] Timer tick, asking Buildbucket for the build status
[23:09:00.319] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:09:00.319] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:33:0) after 1m0s
[23:10:00.452] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:33:0)
[23:10:00.452] Timer tick, asking Buildbucket for the build status
[23:10:00.610] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:10:00.610] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:34:0) after 1m0s
[23:11:00.911] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:34:0)
[23:11:00.911] Timer tick, asking Buildbucket for the build status
[23:11:01.195] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:11:01.195] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:35:0) after 1m0s
[23:12:01.310] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:35:0)
[23:12:01.310] Timer tick, asking Buildbucket for the build status
[23:12:01.493] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:12:01.493] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:36:0) after 1m0s
[23:13:01.550] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:36:0)
[23:13:01.550] Timer tick, asking Buildbucket for the build status
[23:13:03.150] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:13:03.150] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:37:0) after 1m0s
[23:14:03.206] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:37:0)
[23:14:03.206] Timer tick, asking Buildbucket for the build status
[23:14:03.361] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:14:03.361] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:38:0) after 1m0s
[23:15:03.360] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:38:0)
[23:15:03.360] Timer tick, asking Buildbucket for the build status
[23:15:03.995] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:15:03.995] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:39:0) after 1m0s
[23:16:04.168] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:39:0)
[23:16:04.168] Timer tick, asking Buildbucket for the build status
[23:16:04.319] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:16:04.319] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:40:0) after 1m0s
[23:17:04.365] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:40:0)
[23:17:04.365] Timer tick, asking Buildbucket for the build status
[23:17:05.085] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:17:05.085] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:41:0) after 1m0s
[23:18:05.177] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:41:0)
[23:18:05.177] Timer tick, asking Buildbucket for the build status
[23:18:05.461] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:18:05.461] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:42:0) after 1m0s
[23:19:05.523] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:42:0)
[23:19:05.523] Timer tick, asking Buildbucket for the build status
[23:19:05.911] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:19:05.911] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:43:0) after 1m0s
[23:20:05.940] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:43:0)
[23:20:05.940] Timer tick, asking Buildbucket for the build status
[23:20:06.258] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:20:06.258] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:44:0) after 1m0s
[23:21:06.342] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:44:0)
[23:21:06.342] Timer tick, asking Buildbucket for the build status
[23:21:07.223] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:21:07.223] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:45:0) after 1m0s
[23:22:07.277] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:45:0)
[23:22:07.278] Timer tick, asking Buildbucket for the build status
[23:22:08.329] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:22:08.330] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:46:0) after 1m0s
[23:23:08.392] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:46:0)
[23:23:08.392] Timer tick, asking Buildbucket for the build status
[23:23:08.675] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:23:08.675] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:47:0) after 1m0s
[23:24:08.749] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:47:0)
[23:24:08.749] Timer tick, asking Buildbucket for the build status
[23:24:09.178] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:24:09.178] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:48:0) after 1m0s
[23:25:09.371] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:48:0)
[23:25:09.371] Timer tick, asking Buildbucket for the build status
[23:25:09.531] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:25:09.531] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:49:0) after 1m0s
[23:26:09.614] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:49:0)
[23:26:09.614] Timer tick, asking Buildbucket for the build status
[23:26:09.779] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:26:09.779] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:50:0) after 1m0s
[23:27:09.796] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:50:0)
[23:27:09.796] Timer tick, asking Buildbucket for the build status
[23:27:09.916] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:27:09.916] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:51:0) after 1m0s
[23:28:10.073] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:51:0)
[23:28:10.073] Timer tick, asking Buildbucket for the build status
[23:28:10.168] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:28:10.168] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:52:0) after 1m0s
[23:29:10.207] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:52:0)
[23:29:10.207] Timer tick, asking Buildbucket for the build status
[23:29:10.904] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:29:10.904] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:53:0) after 1m0s
[23:30:11.117] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:53:0)
[23:30:11.117] Timer tick, asking Buildbucket for the build status
[23:30:11.634] Build 8903207554662065312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:30:11.634] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:54:0) after 1m0s
[23:31:03.317] Received PubSub notification, asking Buildbucket for the build status
[23:31:03.466] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:11.827] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:54:0)
[23:31:11.827] Timer tick, asking Buildbucket for the build status
[23:31:12.261] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:12.261] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:56:0) after 1m0s
[23:32:12.467] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:56:0)
[23:32:12.467] Timer tick, asking Buildbucket for the build status
[23:32:13.723] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:13.723] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:57:0) after 1m0s
[23:33:13.852] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:57:0)
[23:33:13.852] Timer tick, asking Buildbucket for the build status
[23:33:14.123] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:14.123] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:58:0) after 1m0s
[23:34:14.227] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:58:0)
[23:34:14.227] Timer tick, asking Buildbucket for the build status
[23:34:14.704] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:14.704] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:59:0) after 1m0s
[23:35:14.741] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:59:0)
[23:35:14.741] Timer tick, asking Buildbucket for the build status
[23:35:15.363] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:15.363] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:60:0) after 1m0s
[23:36:15.421] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:60:0)
[23:36:15.421] Timer tick, asking Buildbucket for the build status
[23:36:15.999] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:15.999] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:61:0) after 1m0s
[23:37:16.064] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:61:0)
[23:37:16.064] Timer tick, asking Buildbucket for the build status
[23:37:16.194] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:16.194] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:62:0) after 1m0s
[23:38:16.219] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:62:0)
[23:38:16.219] Timer tick, asking Buildbucket for the build status
[23:38:16.382] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:16.382] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:63:0) after 1m0s
[23:39:16.432] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:63:0)
[23:39:16.432] Timer tick, asking Buildbucket for the build status
[23:39:16.582] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:16.582] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:64:0) after 1m0s
[23:40:16.609] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:64:0)
[23:40:16.609] Timer tick, asking Buildbucket for the build status
[23:40:16.798] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:16.798] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:65:0) after 1m0s
[23:41:16.800] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:65:0)
[23:41:16.800] Timer tick, asking Buildbucket for the build status
[23:41:17.069] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:17.069] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:66:0) after 1m0s
[23:42:17.132] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:66:0)
[23:42:17.132] Timer tick, asking Buildbucket for the build status
[23:42:17.442] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:17.442] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:67:0) after 1m0s
[23:43:17.505] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:67:0)
[23:43:17.505] Timer tick, asking Buildbucket for the build status
[23:43:17.751] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:17.751] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:68:0) after 1m0s
[23:44:17.782] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:68:0)
[23:44:17.782] Timer tick, asking Buildbucket for the build status
[23:44:19.175] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:19.175] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:69:0) after 1m0s
[23:45:19.266] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:69:0)
[23:45:19.266] Timer tick, asking Buildbucket for the build status
[23:45:19.441] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:19.441] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:70:0) after 1m0s
[23:46:19.455] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:70:0)
[23:46:19.455] Timer tick, asking Buildbucket for the build status
[23:46:19.947] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:19.947] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:71:0) after 1m0s
[23:47:20.013] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:71:0)
[23:47:20.013] Timer tick, asking Buildbucket for the build status
[23:47:20.415] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:20.415] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:72:0) after 1m0s
[23:48:20.524] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:72:0)
[23:48:20.524] Timer tick, asking Buildbucket for the build status
[23:48:20.654] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:20.654] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:73:0) after 1m0s
[23:49:20.744] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:73:0)
[23:49:20.744] Timer tick, asking Buildbucket for the build status
[23:49:20.933] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:20.933] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:74:0) after 1m0s
[23:50:20.995] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:74:0)
[23:50:20.995] Timer tick, asking Buildbucket for the build status
[23:50:21.259] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:21.259] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:75:0) after 1m0s
[23:51:21.254] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:75:0)
[23:51:21.254] Timer tick, asking Buildbucket for the build status
[23:51:21.397] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:21.397] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:76:0) after 1m0s
[23:52:21.429] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:76:0)
[23:52:21.429] Timer tick, asking Buildbucket for the build status
[23:52:21.637] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:21.637] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:77:0) after 1m0s
[23:53:21.816] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:77:0)
[23:53:21.816] Timer tick, asking Buildbucket for the build status
[23:53:21.981] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:21.981] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:78:0) after 1m0s
[23:54:22.116] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:78:0)
[23:54:22.116] Timer tick, asking Buildbucket for the build status
[23:54:22.565] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:22.565] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:79:0) after 1m0s
[23:55:22.853] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:79:0)
[23:55:22.853] Timer tick, asking Buildbucket for the build status
[23:55:23.600] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:23.600] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:80:0) after 1m0s
[23:56:23.733] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:80:0)
[23:56:23.734] Timer tick, asking Buildbucket for the build status
[23:56:24.458] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:24.458] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:81:0) after 1m0s
[23:57:24.489] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:81:0)
[23:57:24.489] Timer tick, asking Buildbucket for the build status
[23:57:24.647] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:24.647] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:82:0) after 1m0s
[23:58:24.705] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:82:0)
[23:58:24.705] Timer tick, asking Buildbucket for the build status
[23:58:24.939] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:24.940] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:83:0) after 1m0s
[23:59:24.972] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:83:0)
[23:59:24.972] Timer tick, asking Buildbucket for the build status
[23:59:25.542] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:25.542] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:84:0) after 1m0s
[00:00:25.538] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:84:0)
[00:00:25.538] Timer tick, asking Buildbucket for the build status
[00:00:26.109] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:26.109] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:85:0) after 1m0s
[00:01:26.141] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:85:0)
[00:01:26.141] Timer tick, asking Buildbucket for the build status
[00:01:26.584] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:26.584] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:86:0) after 1m0s
[00:02:26.642] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:86:0)
[00:02:26.642] Timer tick, asking Buildbucket for the build status
[00:02:26.843] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:26.843] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:87:0) after 1m0s
[00:03:26.939] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:87:0)
[00:03:26.939] Timer tick, asking Buildbucket for the build status
[00:03:27.864] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:27.864] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:88:0) after 1m0s
[00:04:27.922] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:88:0)
[00:04:27.922] Timer tick, asking Buildbucket for the build status
[00:04:28.338] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:28.338] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:89:0) after 1m0s
[00:05:28.366] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:89:0)
[00:05:28.366] Timer tick, asking Buildbucket for the build status
[00:05:32.650] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:32.650] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:90:0) after 1m0s
[00:06:32.740] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:90:0)
[00:06:32.740] Timer tick, asking Buildbucket for the build status
[00:06:33.166] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:33.166] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:91:0) after 1m0s
[00:07:33.253] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:91:0)
[00:07:33.253] Timer tick, asking Buildbucket for the build status
[00:07:33.941] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:33.941] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:92:0) after 1m0s
[00:08:33.990] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:92:0)
[00:08:33.990] Timer tick, asking Buildbucket for the build status
[00:08:35.354] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:35.355] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:93:0) after 1m0s
[00:09:35.513] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:93:0)
[00:09:35.513] Timer tick, asking Buildbucket for the build status
[00:09:35.710] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:35.710] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:94:0) after 1m0s
[00:10:35.808] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:94:0)
[00:10:35.808] Timer tick, asking Buildbucket for the build status
[00:10:36.621] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:36.621] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:95:0) after 1m0s
[00:11:36.648] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:95:0)
[00:11:36.648] Timer tick, asking Buildbucket for the build status
[00:11:40.208] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:40.208] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:96:0) after 1m0s
[00:12:40.212] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:96:0)
[00:12:40.212] Timer tick, asking Buildbucket for the build status
[00:12:41.314] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:41.314] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:97:0) after 1m0s
[00:13:41.339] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:97:0)
[00:13:41.339] Timer tick, asking Buildbucket for the build status
[00:13:41.460] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:41.460] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:98:0) after 1m0s
[00:14:41.489] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:98:0)
[00:14:41.489] Timer tick, asking Buildbucket for the build status
[00:14:41.653] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:41.653] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:99:0) after 1m0s
[00:15:41.715] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:99:0)
[00:15:41.715] Timer tick, asking Buildbucket for the build status
[00:15:42.535] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:42.535] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:100:0) after 1m0s
[00:16:42.614] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:100:0)
[00:16:42.614] Timer tick, asking Buildbucket for the build status
[00:16:42.732] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:42.732] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:101:0) after 1m0s
[00:17:42.728] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:101:0)
[00:17:42.729] Timer tick, asking Buildbucket for the build status
[00:17:43.522] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:43.522] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:102:0) after 1m0s
[00:18:43.552] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:102:0)
[00:18:43.552] Timer tick, asking Buildbucket for the build status
[00:18:43.884] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:43.884] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:103:0) after 1m0s
[00:19:43.864] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:103:0)
[00:19:43.864] Timer tick, asking Buildbucket for the build status
[00:19:45.515] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:45.515] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:104:0) after 1m0s
[00:20:45.612] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:104:0)
[00:20:45.612] Timer tick, asking Buildbucket for the build status
[00:20:46.533] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:46.533] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:105:0) after 1m0s
[00:21:46.575] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:105:0)
[00:21:46.575] Timer tick, asking Buildbucket for the build status
[00:21:47.451] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:47.451] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:106:0) after 1m0s
[00:22:47.595] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:106:0)
[00:22:47.595] Timer tick, asking Buildbucket for the build status
[00:22:48.884] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:48.884] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:107:0) after 1m0s
[00:23:49.010] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:107:0)
[00:23:49.010] Timer tick, asking Buildbucket for the build status
[00:23:49.205] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:49.205] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:108:0) after 1m0s
[00:24:49.259] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:108:0)
[00:24:49.259] Timer tick, asking Buildbucket for the build status
[00:24:50.056] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:50.056] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:109:0) after 1m0s
[00:25:50.102] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:109:0)
[00:25:50.102] Timer tick, asking Buildbucket for the build status
[00:25:50.338] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:50.338] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:110:0) after 1m0s
[00:26:50.398] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:110:0)
[00:26:50.398] Timer tick, asking Buildbucket for the build status
[00:26:50.870] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:50.870] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:111:0) after 1m0s
[00:27:50.888] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:111:0)
[00:27:50.888] Timer tick, asking Buildbucket for the build status
[00:27:53.068] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:53.068] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:112:0) after 1m0s
[00:28:53.161] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:112:0)
[00:28:53.161] Timer tick, asking Buildbucket for the build status
[00:28:55.311] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:55.311] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:113:0) after 1m0s
[00:29:55.485] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:113:0)
[00:29:55.485] Timer tick, asking Buildbucket for the build status
[00:29:55.792] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:55.792] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:114:0) after 1m0s
[00:30:55.914] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:114:0)
[00:30:55.914] Timer tick, asking Buildbucket for the build status
[00:30:56.906] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:56.906] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:115:0) after 1m0s
[00:31:57.103] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:115:0)
[00:31:57.103] Timer tick, asking Buildbucket for the build status
[00:31:57.357] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:57.357] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:116:0) after 1m0s
[00:32:57.443] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:116:0)
[00:32:57.443] Timer tick, asking Buildbucket for the build status
[00:32:57.761] Build 8903207554662065312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:57.761] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9068637616623203600:117:0) after 1m0s
[00:33:21.331] Received PubSub notification, asking Buildbucket for the build status
[00:33:21.593] Build 8903207554662065312: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:33:21.593] Buildbucket build:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"completed_ts": "1567643600095044",
"created_by": "project:emscripten-releases",
"created_ts": "1567636643692395",
"id": "8903207554662065312",
"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\": \"17748eb435b5da201850fd6bed3ee9eb7f0f4a69\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@17748eb435b5da201850fd6bed3ee9eb7f0f4a69\", \"title\": \"17748eb435b5da201850fd6bed3ee9eb7f0f4a69\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/17748eb435b5da201850fd6bed3ee9eb7f0f4a69\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"17748eb435b5da201850fd6bed3ee9eb7f0f4a69\"}}",
"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\": \"17748eb435b5da201850fd6bed3ee9eb7f0f4a69\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@17748eb435b5da201850fd6bed3ee9eb7f0f4a69\", \"title\": \"17748eb435b5da201850fd6bed3ee9eb7f0f4a69\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/17748eb435b5da201850fd6bed3ee9eb7f0f4a69\"}]}, \"bot_id\": \"luci-emscripten-releases-ci-xenial-0-34jh\", \"branch\": \"refs/heads/master\", \"buildername\": \"linux\", \"got_revision\": \"17748eb435b5da201850fd6bed3ee9eb7f0f4a69\", \"path_config\": \"generic\", \"recipe\": \"emscripten_releases\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"17748eb435b5da201850fd6bed3ee9eb7f0f4a69\"}, \"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\"], \"gpu\": [\"none\"], \"host_class\": [\"default\"], \"id\": [\"luci-emscripten-releases-ci-xenial-0-34jh\"], \"image\": [\"chrome-xenial-19052201-9cb74617499\"], \"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\": [\"4397-8786906\"], \"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": "1567639861920086",
"status": "COMPLETED",
"status_changed_ts": "1567643600876645",
"tags": [
"builder:linux",
"buildset:commit/git/17748eb435b5da201850fd6bed3ee9eb7f0f4a69",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/17748eb435b5da201850fd6bed3ee9eb7f0f4a69",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9068637616623203600",
"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/8903207554662065312/+/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:47173e6d2c739610",
"user_agent:luci-scheduler"
],
"updated_ts": "1567643600898841",
"url": "https://ci.chromium.org/b/8903207554662065312",
"utcnow_ts": "1567643601580838"
}
}
[00:33:21.593] Invocation finished in 1h55m59.1552707s with status SUCCEEDED