[04:29:43.289] New invocation is queued and will start shortly
[04:29:44.568] Starting the invocation (attempt 1)
[04:29:44.607] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:29:44.607] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:29:44.607] Buildbucket request:
{
"bucket": "luci.emscripten-releases.ci",
"client_operation_id": "9032286065327285120",
"parameters_json": "{\"builder_name\":\"win\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"70219cfad1f5d4fc360bf541e654243a1fff2d79\"},\"id\":\"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@70219cfad1f5d4fc360bf541e654243a1fff2d79\",\"title\":\"70219cfad1f5d4fc360bf541e654243a1fff2d79\",\"url\":\"https://chromium.googlesource.com/emscripten-releases/+/70219cfad1f5d4fc360bf541e654243a1fff2d79\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"70219cfad1f5d4fc360bf541e654243a1fff2d79\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win",
"scheduler_invocation_id:9032286065327285120",
"scheduler_job_id:emscripten-releases/win",
"user_agent:luci-scheduler",
"buildset:commit/git/70219cfad1f5d4fc360bf541e654243a1fff2d79",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/70219cfad1f5d4fc360bf541e654243a1fff2d79",
"gitiles_ref:refs/heads/master"
]
}
[04:29:45.489] Buildbucket response:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"created_by": "project:emscripten-releases",
"created_ts": "1602304184703212",
"id": "8866856003179535408",
"parameters_json": "{\"builder_name\": \"win\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"70219cfad1f5d4fc360bf541e654243a1fff2d79\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@70219cfad1f5d4fc360bf541e654243a1fff2d79\", \"title\": \"70219cfad1f5d4fc360bf541e654243a1fff2d79\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/70219cfad1f5d4fc360bf541e654243a1fff2d79\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"70219cfad1f5d4fc360bf541e654243a1fff2d79\"}}",
"project": "emscripten-releases",
"result_details_json": "{\"properties\": {}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1602304185224425",
"tags": [
"builder:win",
"buildset:commit/git/70219cfad1f5d4fc360bf541e654243a1fff2d79",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/70219cfad1f5d4fc360bf541e654243a1fff2d79",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9032286065327285120",
"scheduler_job_id:emscripten-releases/win",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/emscripten-releases/buildbucket/cr-buildbucket.appspot.com/8866856003179535408/+/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": "1602304185224721",
"url": "https://ci.chromium.org/b/8866856003179535408",
"utcnow_ts": "1602304185476673"
}
}
[04:29:45.489] Task URL: https://ci.chromium.org/b/8866856003179535408
[04:29:45.489] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:2:0) after 1m0s
[04:30:45.577] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:2:0)
[04:30:45.577] Timer tick, asking Buildbucket for the build status
[04:30:46.225] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:30:46.225] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:3:0) after 1m0s
[04:31:46.223] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:3:0)
[04:31:46.223] Timer tick, asking Buildbucket for the build status
[04:31:46.308] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:31:46.308] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:4:0) after 1m0s
[04:32:46.335] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:4:0)
[04:32:46.335] Timer tick, asking Buildbucket for the build status
[04:32:46.571] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:32:46.571] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:5:0) after 1m0s
[04:33:46.598] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:5:0)
[04:33:46.598] Timer tick, asking Buildbucket for the build status
[04:33:46.661] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:33:46.661] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:6:0) after 1m0s
[04:34:46.680] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:6:0)
[04:34:46.680] Timer tick, asking Buildbucket for the build status
[04:34:47.071] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:34:47.071] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:7:0) after 1m0s
[04:35:47.128] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:7:0)
[04:35:47.128] Timer tick, asking Buildbucket for the build status
[04:35:47.235] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:35:47.235] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:8:0) after 1m0s
[04:36:47.273] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:8:0)
[04:36:47.273] Timer tick, asking Buildbucket for the build status
[04:36:47.352] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:36:47.352] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:9:0) after 1m0s
[04:37:47.389] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:9:0)
[04:37:47.389] Timer tick, asking Buildbucket for the build status
[04:37:47.482] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:37:47.482] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:10:0) after 1m0s
[04:38:47.509] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:10:0)
[04:38:47.509] Timer tick, asking Buildbucket for the build status
[04:38:47.598] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:38:47.599] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:11:0) after 1m0s
[04:39:47.618] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:11:0)
[04:39:47.618] Timer tick, asking Buildbucket for the build status
[04:39:47.755] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:39:47.755] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:12:0) after 1m0s
[04:40:47.835] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:12:0)
[04:40:47.835] Timer tick, asking Buildbucket for the build status
[04:40:48.181] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:40:48.181] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:13:0) after 1m0s
[04:41:48.201] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:13:0)
[04:41:48.201] Timer tick, asking Buildbucket for the build status
[04:41:48.271] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:41:48.271] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:14:0) after 1m0s
[04:42:48.308] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:14:0)
[04:42:48.308] Timer tick, asking Buildbucket for the build status
[04:42:48.412] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:42:48.412] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:15:0) after 1m0s
[04:43:48.435] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:15:0)
[04:43:48.435] Timer tick, asking Buildbucket for the build status
[04:43:48.497] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:43:48.497] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:16:0) after 1m0s
[04:44:48.520] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:16:0)
[04:44:48.520] Timer tick, asking Buildbucket for the build status
[04:44:48.670] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:44:48.670] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:17:0) after 1m0s
[04:45:48.723] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:17:0)
[04:45:48.723] Timer tick, asking Buildbucket for the build status
[04:45:49.022] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:45:49.022] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:18:0) after 1m0s
[04:46:49.044] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:18:0)
[04:46:49.044] Timer tick, asking Buildbucket for the build status
[04:46:49.119] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:46:49.119] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:19:0) after 1m0s
[04:47:49.142] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:19:0)
[04:47:49.142] Timer tick, asking Buildbucket for the build status
[04:47:49.204] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:47:49.204] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:20:0) after 1m0s
[04:48:49.227] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:20:0)
[04:48:49.227] Timer tick, asking Buildbucket for the build status
[04:48:49.298] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:48:49.299] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:21:0) after 1m0s
[04:49:49.320] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:21:0)
[04:49:49.320] Timer tick, asking Buildbucket for the build status
[04:49:49.409] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:49:49.409] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:22:0) after 1m0s
[04:50:49.406] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:22:0)
[04:50:49.406] Timer tick, asking Buildbucket for the build status
[04:50:49.486] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:50:49.486] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:23:0) after 1m0s
[04:51:49.540] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:23:0)
[04:51:49.540] Timer tick, asking Buildbucket for the build status
[04:51:49.628] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:51:49.628] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:24:0) after 1m0s
[04:52:49.653] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:24:0)
[04:52:49.653] Timer tick, asking Buildbucket for the build status
[04:52:49.743] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:52:49.743] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:25:0) after 1m0s
[04:53:49.769] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:25:0)
[04:53:49.769] Timer tick, asking Buildbucket for the build status
[04:53:49.844] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:53:49.844] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:26:0) after 1m0s
[04:54:49.866] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:26:0)
[04:54:49.866] Timer tick, asking Buildbucket for the build status
[04:54:49.956] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:54:49.956] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:27:0) after 1m0s
[04:55:50.033] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:27:0)
[04:55:50.033] Timer tick, asking Buildbucket for the build status
[04:55:50.273] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:55:50.273] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:28:0) after 1m0s
[04:56:50.490] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:28:0)
[04:56:50.490] Timer tick, asking Buildbucket for the build status
[04:56:50.565] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:56:50.565] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:29:0) after 1m0s
[04:57:50.863] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:29:0)
[04:57:50.863] Timer tick, asking Buildbucket for the build status
[04:57:51.683] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:57:51.683] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:30:0) after 1m0s
[04:58:51.906] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:30:0)
[04:58:51.906] Timer tick, asking Buildbucket for the build status
[04:58:51.982] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:58:51.982] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:31:0) after 1m0s
[04:59:52.104] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:31:0)
[04:59:52.104] Timer tick, asking Buildbucket for the build status
[04:59:52.190] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:59:52.190] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:32:0) after 1m0s
[05:00:52.915] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:32:0)
[05:00:52.915] Timer tick, asking Buildbucket for the build status
[05:00:53.002] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:00:53.003] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:33:0) after 1m0s
[05:01:53.248] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:33:0)
[05:01:53.248] Timer tick, asking Buildbucket for the build status
[05:01:53.321] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:01:53.321] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:34:0) after 1m0s
[05:02:53.404] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:34:0)
[05:02:53.404] Timer tick, asking Buildbucket for the build status
[05:02:53.842] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:02:53.842] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:35:0) after 1m0s
[05:03:53.975] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:35:0)
[05:03:53.975] Timer tick, asking Buildbucket for the build status
[05:03:54.046] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:03:54.046] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:36:0) after 1m0s
[05:04:54.207] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:36:0)
[05:04:54.207] Timer tick, asking Buildbucket for the build status
[05:04:54.306] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:04:54.306] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:37:0) after 1m0s
[05:05:54.378] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:37:0)
[05:05:54.378] Timer tick, asking Buildbucket for the build status
[05:05:54.451] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:05:54.451] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:38:0) after 1m0s
[05:06:54.469] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:38:0)
[05:06:54.469] Timer tick, asking Buildbucket for the build status
[05:06:54.802] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:06:54.802] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:39:0) after 1m0s
[05:07:54.845] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:39:0)
[05:07:54.845] Timer tick, asking Buildbucket for the build status
[05:07:54.916] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:07:54.916] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:40:0) after 1m0s
[05:08:54.938] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:40:0)
[05:08:54.938] Timer tick, asking Buildbucket for the build status
[05:08:55.056] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:08:55.056] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:41:0) after 1m0s
[05:09:55.081] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:41:0)
[05:09:55.081] Timer tick, asking Buildbucket for the build status
[05:09:55.299] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:09:55.301] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:42:0) after 1m0s
[05:10:55.330] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:42:0)
[05:10:55.331] Timer tick, asking Buildbucket for the build status
[05:10:55.415] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:10:55.415] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:43:0) after 1m0s
[05:11:55.541] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:43:0)
[05:11:55.541] Timer tick, asking Buildbucket for the build status
[05:11:55.611] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:11:55.611] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:44:0) after 1m0s
[05:12:55.685] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:44:0)
[05:12:55.685] Timer tick, asking Buildbucket for the build status
[05:12:55.881] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:12:55.881] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:45:0) after 1m0s
[05:13:55.947] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:45:0)
[05:13:55.947] Timer tick, asking Buildbucket for the build status
[05:13:56.047] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:13:56.047] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:46:0) after 1m0s
[05:14:56.071] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:46:0)
[05:14:56.071] Timer tick, asking Buildbucket for the build status
[05:14:56.194] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:14:56.194] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:47:0) after 1m0s
[05:15:56.216] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:47:0)
[05:15:56.216] Timer tick, asking Buildbucket for the build status
[05:15:56.281] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:15:56.281] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:48:0) after 1m0s
[05:16:56.364] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:48:0)
[05:16:56.364] Timer tick, asking Buildbucket for the build status
[05:16:56.431] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:16:56.431] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:49:0) after 1m0s
[05:17:56.495] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:49:0)
[05:17:56.495] Timer tick, asking Buildbucket for the build status
[05:17:56.577] Build 8866856003179535408: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:17:56.577] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:50:0) after 1m0s
[05:18:10.252] Received PubSub notification, asking Buildbucket for the build status
[05:18:10.408] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:56.690] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:50:0)
[05:18:56.690] Timer tick, asking Buildbucket for the build status
[05:18:56.757] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:56.757] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:52:0) after 1m0s
[05:19:56.781] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:52:0)
[05:19:56.781] Timer tick, asking Buildbucket for the build status
[05:19:56.941] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:56.941] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:53:0) after 1m0s
[05:20:57.053] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:53:0)
[05:20:57.053] Timer tick, asking Buildbucket for the build status
[05:20:57.496] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:57.496] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:54:0) after 1m0s
[05:21:57.535] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:54:0)
[05:21:57.535] Timer tick, asking Buildbucket for the build status
[05:21:57.902] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:57.902] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:55:0) after 1m0s
[05:22:58.034] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:55:0)
[05:22:58.034] Timer tick, asking Buildbucket for the build status
[05:22:58.123] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:58.123] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:56:0) after 1m0s
[05:23:58.152] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:56:0)
[05:23:58.152] Timer tick, asking Buildbucket for the build status
[05:23:58.215] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:58.215] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:57:0) after 1m0s
[05:24:58.505] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:57:0)
[05:24:58.505] Timer tick, asking Buildbucket for the build status
[05:24:58.870] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:58.870] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:58:0) after 1m0s
[05:25:58.911] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:58:0)
[05:25:58.911] Timer tick, asking Buildbucket for the build status
[05:25:58.972] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:58.972] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:59:0) after 1m0s
[05:26:59.044] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:59:0)
[05:26:59.044] Timer tick, asking Buildbucket for the build status
[05:26:59.365] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:59.365] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:60:0) after 1m0s
[05:27:59.523] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:60:0)
[05:27:59.523] Timer tick, asking Buildbucket for the build status
[05:27:59.583] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:59.583] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:61:0) after 1m0s
[05:28:59.685] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:61:0)
[05:28:59.686] Timer tick, asking Buildbucket for the build status
[05:28:59.795] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:59.795] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:62:0) after 1m0s
[05:29:59.860] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:62:0)
[05:29:59.860] Timer tick, asking Buildbucket for the build status
[05:29:59.958] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:59.958] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:63:0) after 1m0s
[05:31:00.016] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:63:0)
[05:31:00.016] Timer tick, asking Buildbucket for the build status
[05:31:00.264] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:00.264] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:64:0) after 1m0s
[05:32:00.282] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:64:0)
[05:32:00.282] Timer tick, asking Buildbucket for the build status
[05:32:00.425] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:00.425] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:65:0) after 1m0s
[05:33:00.452] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:65:0)
[05:33:00.452] Timer tick, asking Buildbucket for the build status
[05:33:00.729] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:00.729] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:66:0) after 1m0s
[05:34:02.494] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:66:0)
[05:34:02.494] Timer tick, asking Buildbucket for the build status
[05:34:02.658] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:02.658] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:67:0) after 1m0s
[05:35:02.682] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:67:0)
[05:35:02.682] Timer tick, asking Buildbucket for the build status
[05:35:03.188] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:03.188] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:68:0) after 1m0s
[05:36:03.302] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:68:0)
[05:36:03.302] Timer tick, asking Buildbucket for the build status
[05:36:03.415] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:03.415] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:69:0) after 1m0s
[05:37:03.489] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:69:0)
[05:37:03.489] Timer tick, asking Buildbucket for the build status
[05:37:03.558] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:03.558] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:70:0) after 1m0s
[05:38:03.861] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:70:0)
[05:38:03.861] Timer tick, asking Buildbucket for the build status
[05:38:03.932] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:03.932] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:71:0) after 1m0s
[05:39:03.971] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:71:0)
[05:39:03.971] Timer tick, asking Buildbucket for the build status
[05:39:04.033] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:04.033] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:72:0) after 1m0s
[05:40:04.157] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:72:0)
[05:40:04.157] Timer tick, asking Buildbucket for the build status
[05:40:04.251] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:04.251] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:73:0) after 1m0s
[05:41:04.410] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:73:0)
[05:41:04.410] Timer tick, asking Buildbucket for the build status
[05:41:04.490] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:04.490] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:74:0) after 1m0s
[05:42:04.821] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:74:0)
[05:42:04.822] Timer tick, asking Buildbucket for the build status
[05:42:04.896] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:04.896] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:75:0) after 1m0s
[05:43:04.965] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:75:0)
[05:43:04.965] Timer tick, asking Buildbucket for the build status
[05:43:05.029] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:05.029] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:76:0) after 1m0s
[05:44:05.056] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:76:0)
[05:44:05.056] Timer tick, asking Buildbucket for the build status
[05:44:05.291] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:05.291] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:77:0) after 1m0s
[05:45:05.274] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:77:0)
[05:45:05.274] Timer tick, asking Buildbucket for the build status
[05:45:07.292] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:07.292] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:78:0) after 1m0s
[05:46:07.385] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:78:0)
[05:46:07.385] Timer tick, asking Buildbucket for the build status
[05:46:07.827] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:07.827] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:79:0) after 1m0s
[05:47:07.915] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:79:0)
[05:47:07.915] Timer tick, asking Buildbucket for the build status
[05:47:08.202] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:08.202] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:80:0) after 1m0s
[05:48:08.227] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:80:0)
[05:48:08.227] Timer tick, asking Buildbucket for the build status
[05:48:08.318] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:08.318] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:81:0) after 1m0s
[05:49:08.345] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:81:0)
[05:49:08.345] Timer tick, asking Buildbucket for the build status
[05:49:08.448] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:08.448] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:82:0) after 1m0s
[05:50:08.527] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:82:0)
[05:50:08.527] Timer tick, asking Buildbucket for the build status
[05:50:08.637] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:08.637] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:83:0) after 1m0s
[05:51:08.675] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:83:0)
[05:51:08.675] Timer tick, asking Buildbucket for the build status
[05:51:08.740] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:08.740] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:84:0) after 1m0s
[05:52:08.850] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:84:0)
[05:52:08.850] Timer tick, asking Buildbucket for the build status
[05:52:08.971] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:08.971] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:85:0) after 1m0s
[05:53:09.063] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:85:0)
[05:53:09.063] Timer tick, asking Buildbucket for the build status
[05:53:09.180] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:09.180] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:86:0) after 1m0s
[05:54:09.341] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:86:0)
[05:54:09.341] Timer tick, asking Buildbucket for the build status
[05:54:09.408] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:09.408] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:87:0) after 1m0s
[05:55:09.508] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:87:0)
[05:55:09.508] Timer tick, asking Buildbucket for the build status
[05:55:09.604] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:09.605] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:88:0) after 1m0s
[05:56:09.589] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:88:0)
[05:56:09.589] Timer tick, asking Buildbucket for the build status
[05:56:09.661] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:09.661] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:89:0) after 1m0s
[05:57:10.235] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:89:0)
[05:57:10.235] Timer tick, asking Buildbucket for the build status
[05:57:10.497] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:10.497] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:90:0) after 1m0s
[05:58:12.227] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:90:0)
[05:58:12.227] Timer tick, asking Buildbucket for the build status
[05:58:12.337] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:12.337] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:91:0) after 1m0s
[05:59:12.361] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:91:0)
[05:59:12.361] Timer tick, asking Buildbucket for the build status
[05:59:12.471] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:12.471] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:92:0) after 1m0s
[06:00:12.563] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:92:0)
[06:00:12.563] Timer tick, asking Buildbucket for the build status
[06:00:12.875] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:12.876] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:93:0) after 1m0s
[06:01:14.616] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:93:0)
[06:01:14.616] Timer tick, asking Buildbucket for the build status
[06:01:14.682] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:14.682] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:94:0) after 1m0s
[06:02:14.848] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:94:0)
[06:02:14.848] Timer tick, asking Buildbucket for the build status
[06:02:14.942] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:14.942] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:95:0) after 1m0s
[06:03:15.086] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:95:0)
[06:03:15.086] Timer tick, asking Buildbucket for the build status
[06:03:15.243] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:15.243] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:96:0) after 1m0s
[06:04:15.225] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:96:0)
[06:04:15.225] Timer tick, asking Buildbucket for the build status
[06:04:15.308] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:15.308] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:97:0) after 1m0s
[06:05:15.359] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:97:0)
[06:05:15.359] Timer tick, asking Buildbucket for the build status
[06:05:15.458] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:15.458] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:98:0) after 1m0s
[06:06:15.487] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:98:0)
[06:06:15.487] Timer tick, asking Buildbucket for the build status
[06:06:15.620] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:15.620] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:99:0) after 1m0s
[06:07:15.772] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:99:0)
[06:07:15.772] Timer tick, asking Buildbucket for the build status
[06:07:15.927] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:15.927] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:100:0) after 1m0s
[06:08:16.018] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:100:0)
[06:08:16.018] Timer tick, asking Buildbucket for the build status
[06:08:16.185] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:16.185] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:101:0) after 1m0s
[06:09:16.329] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:101:0)
[06:09:16.329] Timer tick, asking Buildbucket for the build status
[06:09:16.414] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:16.414] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:102:0) after 1m0s
[06:10:16.508] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:102:0)
[06:10:16.508] Timer tick, asking Buildbucket for the build status
[06:10:16.748] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:16.748] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:103:0) after 1m0s
[06:11:16.773] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:103:0)
[06:11:16.773] Timer tick, asking Buildbucket for the build status
[06:11:16.840] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:16.840] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:104:0) after 1m0s
[06:12:16.895] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:104:0)
[06:12:16.895] Timer tick, asking Buildbucket for the build status
[06:12:16.957] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:16.957] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:105:0) after 1m0s
[06:13:16.979] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:105:0)
[06:13:16.979] Timer tick, asking Buildbucket for the build status
[06:13:17.035] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:17.035] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:106:0) after 1m0s
[06:14:17.123] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:106:0)
[06:14:17.123] Timer tick, asking Buildbucket for the build status
[06:14:17.178] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:17.178] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:107:0) after 1m0s
[06:15:17.202] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:107:0)
[06:15:17.202] Timer tick, asking Buildbucket for the build status
[06:15:17.303] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:17.303] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:108:0) after 1m0s
[06:16:17.326] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:108:0)
[06:16:17.326] Timer tick, asking Buildbucket for the build status
[06:16:17.394] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:17.394] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:109:0) after 1m0s
[06:17:17.469] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:109:0)
[06:17:17.469] Timer tick, asking Buildbucket for the build status
[06:17:17.688] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:17.688] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:110:0) after 1m0s
[06:18:17.712] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:110:0)
[06:18:17.712] Timer tick, asking Buildbucket for the build status
[06:18:17.777] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:17.777] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:111:0) after 1m0s
[06:19:17.803] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:111:0)
[06:19:17.803] Timer tick, asking Buildbucket for the build status
[06:19:18.177] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:18.177] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:112:0) after 1m0s
[06:20:18.290] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:112:0)
[06:20:18.290] Timer tick, asking Buildbucket for the build status
[06:20:18.389] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:18.389] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:113:0) after 1m0s
[06:21:18.461] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:113:0)
[06:21:18.461] Timer tick, asking Buildbucket for the build status
[06:21:18.578] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:18.578] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:114:0) after 1m0s
[06:22:18.676] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:114:0)
[06:22:18.676] Timer tick, asking Buildbucket for the build status
[06:22:18.897] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:18.897] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:115:0) after 1m0s
[06:23:18.994] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:115:0)
[06:23:18.994] Timer tick, asking Buildbucket for the build status
[06:23:19.054] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:19.054] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:116:0) after 1m0s
[06:24:19.079] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:116:0)
[06:24:19.079] Timer tick, asking Buildbucket for the build status
[06:24:19.184] Build 8866856003179535408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:19.184] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9032286065327285120:117:0) after 1m0s
[06:24:54.194] Received PubSub notification, asking Buildbucket for the build status
[06:24:54.255] Build 8866856003179535408: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[06:24:54.255] Buildbucket build:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"completed_ts": "1602311093423004",
"created_by": "project:emscripten-releases",
"created_ts": "1602304184703212",
"id": "8866856003179535408",
"parameters_json": "{\"builder_name\": \"win\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"70219cfad1f5d4fc360bf541e654243a1fff2d79\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@70219cfad1f5d4fc360bf541e654243a1fff2d79\", \"title\": \"70219cfad1f5d4fc360bf541e654243a1fff2d79\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/70219cfad1f5d4fc360bf541e654243a1fff2d79\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"70219cfad1f5d4fc360bf541e654243a1fff2d79\"}}",
"project": "emscripten-releases",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"70219cfad1f5d4fc360bf541e654243a1fff2d79\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@70219cfad1f5d4fc360bf541e654243a1fff2d79\", \"title\": \"70219cfad1f5d4fc360bf541e654243a1fff2d79\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/70219cfad1f5d4fc360bf541e654243a1fff2d79\"}]}, \"bot_id\": \"luci-emscripten-releases-ci-win10-0-tu01\", \"branch\": \"refs/heads/master\", \"buildername\": \"win\", \"got_revision\": \"70219cfad1f5d4fc360bf541e654243a1fff2d79\", \"path_config\": \"generic\", \"recipe\": \"emscripten_releases\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"70219cfad1f5d4fc360bf541e654243a1fff2d79\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_0175bca77590805533ed6e20351c9bfa7effd036e42d11a5b619a6ce75a8e486_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"host_class\": [\"default\"], \"id\": [\"luci-emscripten-releases-ci-win10-0-tu01\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.emscripten-releases.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5570-fa4adf0\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1602307089102529",
"status": "COMPLETED",
"status_changed_ts": "1602311093914070",
"tags": [
"builder:win",
"buildset:commit/git/70219cfad1f5d4fc360bf541e654243a1fff2d79",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/70219cfad1f5d4fc360bf541e654243a1fff2d79",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9032286065327285120",
"scheduler_job_id:emscripten-releases/win",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/emscripten-releases/buildbucket/cr-buildbucket.appspot.com/8866856003179535408/+/annotations",
"swarming_tag:luci_project:emscripten-releases",
"swarming_tag:os:Windows",
"swarming_tag:recipe_name:emscripten_releases",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:4f29971d1fa72210",
"user_agent:luci-scheduler"
],
"updated_ts": "1602311093924104",
"url": "https://ci.chromium.org/b/8866856003179535408",
"utcnow_ts": "1602311094248092"
}
}
[06:24:54.255] Invocation finished in 1h55m10.983535501s with status SUCCEEDED