[09:27:04.379] New invocation is queued and will start shortly
[09:27:05.476] Starting the invocation (attempt 1)
[09:27:05.522] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[09:27:05.522] PubSub topic is "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
[09:27:05.522] Buildbucket request:
{
"bucket": "luci.infra.ci",
"client_operation_id": "9034622878713284240",
"parameters_json": "{\"builder_name\":\"infra-continuous-win10-64\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler-dev.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"264059dc192f40c44f6e88945f22f37c2e32a4e8\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@264059dc192f40c44f6e88945f22f37c2e32a4e8\",\"title\":\"264059dc192f40c44f6e88945f22f37c2e32a4e8\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/264059dc192f40c44f6e88945f22f37c2e32a4e8\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"264059dc192f40c44f6e88945f22f37c2e32a4e8\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
},
"tags": [
"builder:infra-continuous-win10-64",
"scheduler_invocation_id:9034622878713284240",
"scheduler_job_id:infra/infra-continuous-win10-64",
"user_agent:luci-scheduler-dev",
"buildset:commit/git/264059dc192f40c44f6e88945f22f37c2e32a4e8",
"buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/264059dc192f40c44f6e88945f22f37c2e32a4e8",
"gitiles_ref:refs/heads/master"
]
}
[09:27:06.202] Buildbucket response:
{
"build": {
"bucket": "luci.infra.ci",
"canary_preference": "PROD",
"created_by": "project:infra",
"created_ts": "1600075625670626",
"id": "8869192816695554736",
"parameters_json": "{\"builder_name\": \"infra-continuous-win10-64\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler-dev.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"264059dc192f40c44f6e88945f22f37c2e32a4e8\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@264059dc192f40c44f6e88945f22f37c2e32a4e8\", \"title\": \"264059dc192f40c44f6e88945f22f37c2e32a4e8\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/264059dc192f40c44f6e88945f22f37c2e32a4e8\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"264059dc192f40c44f6e88945f22f37c2e32a4e8\"}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "adhoc-testing@luci-token-server-dev.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1600075626083903",
"tags": [
"build_address:luci.infra.ci/infra-continuous-win10-64/17698",
"builder:infra-continuous-win10-64",
"buildset:commit/git/264059dc192f40c44f6e88945f22f37c2e32a4e8",
"buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/264059dc192f40c44f6e88945f22f37c2e32a4e8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9034622878713284240",
"scheduler_job_id:infra/infra-continuous-win10-64",
"swarming_hostname:chromium-swarm-dev.appspot.com",
"swarming_tag:log_location:logdog://luci-logdog-dev.appspot.com/infra/buildbucket/cr-buildbucket-dev.appspot.com/8869192816695554736/+/annotations",
"swarming_tag:luci_project:infra",
"swarming_tag:recipe_name:infra_continuous",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/infra/infra",
"swarming_task_id:",
"user_agent:luci-scheduler-dev"
],
"updated_ts": "1600075626084018",
"url": "https://luci-milo-dev.appspot.com/b/8869192816695554736",
"utcnow_ts": "1600075626195515"
}
}
[09:27:06.202] Task URL: https://luci-milo-dev.appspot.com/b/8869192816695554736
[09:27:06.202] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:2:0) after 1m0s
[09:28:06.221] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:2:0)
[09:28:06.221] Timer tick, asking Buildbucket for the build status
[09:28:06.306] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:28:06.306] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:3:0) after 1m0s
[09:29:06.328] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:3:0)
[09:29:06.328] Timer tick, asking Buildbucket for the build status
[09:29:06.413] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:29:06.413] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:4:0) after 1m0s
[09:30:06.434] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:4:0)
[09:30:06.434] Timer tick, asking Buildbucket for the build status
[09:30:06.518] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:30:06.518] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:5:0) after 1m0s
[09:31:06.553] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:5:0)
[09:31:06.553] Timer tick, asking Buildbucket for the build status
[09:31:06.637] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:31:06.637] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:6:0) after 1m0s
[09:32:06.656] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:6:0)
[09:32:06.656] Timer tick, asking Buildbucket for the build status
[09:32:06.739] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:32:06.739] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:7:0) after 1m0s
[09:33:06.761] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:7:0)
[09:33:06.761] Timer tick, asking Buildbucket for the build status
[09:33:06.851] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:33:06.851] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:8:0) after 1m0s
[09:34:06.915] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:8:0)
[09:34:06.915] Timer tick, asking Buildbucket for the build status
[09:34:07.057] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:34:07.057] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:9:0) after 1m0s
[09:35:07.084] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:9:0)
[09:35:07.084] Timer tick, asking Buildbucket for the build status
[09:35:07.165] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:35:07.165] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:10:0) after 1m0s
[09:36:07.186] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:10:0)
[09:36:07.186] Timer tick, asking Buildbucket for the build status
[09:36:07.274] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:36:07.274] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:11:0) after 1m0s
[09:37:07.299] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:11:0)
[09:37:07.299] Timer tick, asking Buildbucket for the build status
[09:37:07.398] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:37:07.399] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:12:0) after 1m0s
[09:38:07.421] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:12:0)
[09:38:07.421] Timer tick, asking Buildbucket for the build status
[09:38:07.519] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:38:07.519] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:13:0) after 1m0s
[09:39:07.540] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:13:0)
[09:39:07.540] Timer tick, asking Buildbucket for the build status
[09:39:07.628] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:39:07.628] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:14:0) after 1m0s
[09:40:07.649] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:14:0)
[09:40:07.649] Timer tick, asking Buildbucket for the build status
[09:40:07.741] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:40:07.741] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:15:0) after 1m0s
[09:41:07.762] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:15:0)
[09:41:07.762] Timer tick, asking Buildbucket for the build status
[09:41:07.989] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:41:07.989] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:16:0) after 1m0s
[09:42:08.010] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:16:0)
[09:42:08.010] Timer tick, asking Buildbucket for the build status
[09:42:08.101] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:42:08.101] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:17:0) after 1m0s
[09:43:08.191] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:17:0)
[09:43:08.191] Timer tick, asking Buildbucket for the build status
[09:43:08.278] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:43:08.278] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:18:0) after 1m0s
[09:44:08.309] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:18:0)
[09:44:08.309] Timer tick, asking Buildbucket for the build status
[09:44:08.408] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:44:08.408] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:19:0) after 1m0s
[09:45:08.432] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:19:0)
[09:45:08.432] Timer tick, asking Buildbucket for the build status
[09:45:08.525] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:45:08.525] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:20:0) after 1m0s
[09:46:08.546] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:20:0)
[09:46:08.546] Timer tick, asking Buildbucket for the build status
[09:46:08.625] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:46:08.625] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:21:0) after 1m0s
[09:47:08.645] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:21:0)
[09:47:08.645] Timer tick, asking Buildbucket for the build status
[09:47:08.742] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:47:08.742] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:22:0) after 1m0s
[09:48:08.769] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:22:0)
[09:48:08.769] Timer tick, asking Buildbucket for the build status
[09:48:08.847] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:48:08.847] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:23:0) after 1m0s
[09:49:08.891] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:23:0)
[09:49:08.891] Timer tick, asking Buildbucket for the build status
[09:49:08.982] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:49:08.982] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:24:0) after 1m0s
[09:50:09.088] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:24:0)
[09:50:09.088] Timer tick, asking Buildbucket for the build status
[09:50:09.163] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:50:09.164] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:25:0) after 1m0s
[09:51:09.218] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:25:0)
[09:51:09.218] Timer tick, asking Buildbucket for the build status
[09:51:09.330] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:51:09.330] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:26:0) after 1m0s
[09:52:09.350] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:26:0)
[09:52:09.350] Timer tick, asking Buildbucket for the build status
[09:52:09.427] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:52:09.427] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:27:0) after 1m0s
[09:53:09.449] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:27:0)
[09:53:09.449] Timer tick, asking Buildbucket for the build status
[09:53:09.559] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:53:09.559] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:28:0) after 1m0s
[09:54:09.580] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:28:0)
[09:54:09.580] Timer tick, asking Buildbucket for the build status
[09:54:09.678] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:54:09.678] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:29:0) after 1m0s
[09:55:09.699] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:29:0)
[09:55:09.699] Timer tick, asking Buildbucket for the build status
[09:55:09.796] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:55:09.796] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:30:0) after 1m0s
[09:56:09.818] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:30:0)
[09:56:09.818] Timer tick, asking Buildbucket for the build status
[09:56:09.942] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:56:09.942] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:31:0) after 1m0s
[09:57:09.971] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:31:0)
[09:57:09.971] Timer tick, asking Buildbucket for the build status
[09:57:10.115] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:57:10.115] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:32:0) after 1m0s
[09:58:10.137] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:32:0)
[09:58:10.137] Timer tick, asking Buildbucket for the build status
[09:58:10.245] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:58:10.245] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:33:0) after 1m0s
[09:59:10.270] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:33:0)
[09:59:10.270] Timer tick, asking Buildbucket for the build status
[09:59:10.358] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:59:10.358] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:34:0) after 1m0s
[10:00:10.377] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:34:0)
[10:00:10.377] Timer tick, asking Buildbucket for the build status
[10:00:10.513] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:00:10.513] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:35:0) after 1m0s
[10:01:10.572] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:35:0)
[10:01:10.572] Timer tick, asking Buildbucket for the build status
[10:01:10.730] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:01:10.730] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:36:0) after 1m0s
[10:02:10.752] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:36:0)
[10:02:10.752] Timer tick, asking Buildbucket for the build status
[10:02:10.838] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:02:10.838] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:37:0) after 1m0s
[10:03:10.890] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:37:0)
[10:03:10.890] Timer tick, asking Buildbucket for the build status
[10:03:10.969] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:03:10.969] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:38:0) after 1m0s
[10:04:11.001] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:38:0)
[10:04:11.001] Timer tick, asking Buildbucket for the build status
[10:04:11.146] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:04:11.146] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:39:0) after 1m0s
[10:05:11.178] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:39:0)
[10:05:11.178] Timer tick, asking Buildbucket for the build status
[10:05:11.252] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:05:11.252] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:40:0) after 1m0s
[10:06:11.288] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:40:0)
[10:06:11.288] Timer tick, asking Buildbucket for the build status
[10:06:11.379] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:06:11.379] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:41:0) after 1m0s
[10:07:11.407] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:41:0)
[10:07:11.407] Timer tick, asking Buildbucket for the build status
[10:07:11.489] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:07:11.489] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:42:0) after 1m0s
[10:08:11.514] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:42:0)
[10:08:11.514] Timer tick, asking Buildbucket for the build status
[10:08:11.602] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:08:11.602] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:43:0) after 1m0s
[10:09:11.693] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:43:0)
[10:09:11.693] Timer tick, asking Buildbucket for the build status
[10:09:11.783] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:09:11.783] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:44:0) after 1m0s
[10:10:11.888] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:44:0)
[10:10:11.888] Timer tick, asking Buildbucket for the build status
[10:10:12.025] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:10:12.025] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:45:0) after 1m0s
[10:11:12.050] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:45:0)
[10:11:12.050] Timer tick, asking Buildbucket for the build status
[10:11:12.143] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:11:12.143] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:46:0) after 1m0s
[10:12:12.165] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:46:0)
[10:12:12.165] Timer tick, asking Buildbucket for the build status
[10:12:12.251] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:12:12.251] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:47:0) after 1m0s
[10:13:12.271] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:47:0)
[10:13:12.271] Timer tick, asking Buildbucket for the build status
[10:13:12.356] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:13:12.356] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:48:0) after 1m0s
[10:14:12.385] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:48:0)
[10:14:12.385] Timer tick, asking Buildbucket for the build status
[10:14:12.464] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:14:12.464] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:49:0) after 1m0s
[10:15:12.516] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:49:0)
[10:15:12.516] Timer tick, asking Buildbucket for the build status
[10:15:12.592] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:15:12.592] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:50:0) after 1m0s
[10:16:12.692] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:50:0)
[10:16:12.692] Timer tick, asking Buildbucket for the build status
[10:16:12.807] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:16:12.807] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:51:0) after 1m0s
[10:17:12.829] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:51:0)
[10:17:12.829] Timer tick, asking Buildbucket for the build status
[10:17:12.943] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:17:12.943] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:52:0) after 1m0s
[10:18:13.023] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:52:0)
[10:18:13.023] Timer tick, asking Buildbucket for the build status
[10:18:13.114] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:18:13.114] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:53:0) after 1m0s
[10:19:13.190] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:53:0)
[10:19:13.190] Timer tick, asking Buildbucket for the build status
[10:19:13.309] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:19:13.309] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:54:0) after 1m0s
[10:20:13.332] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:54:0)
[10:20:13.332] Timer tick, asking Buildbucket for the build status
[10:20:13.415] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:20:13.415] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:55:0) after 1m0s
[10:21:13.436] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:55:0)
[10:21:13.436] Timer tick, asking Buildbucket for the build status
[10:21:13.527] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:21:13.527] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:56:0) after 1m0s
[10:22:13.547] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:56:0)
[10:22:13.547] Timer tick, asking Buildbucket for the build status
[10:22:13.642] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:22:13.642] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:57:0) after 1m0s
[10:23:13.668] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:57:0)
[10:23:13.668] Timer tick, asking Buildbucket for the build status
[10:23:13.746] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:23:13.746] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:58:0) after 1m0s
[10:24:13.793] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:58:0)
[10:24:13.793] Timer tick, asking Buildbucket for the build status
[10:24:13.869] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:24:13.869] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:59:0) after 1m0s
[10:25:13.894] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:59:0)
[10:25:13.894] Timer tick, asking Buildbucket for the build status
[10:25:14.003] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:25:14.003] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:60:0) after 1m0s
[10:26:14.064] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:60:0)
[10:26:14.064] Timer tick, asking Buildbucket for the build status
[10:26:14.252] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:26:14.252] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:61:0) after 1m0s
[10:27:14.276] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:61:0)
[10:27:14.276] Timer tick, asking Buildbucket for the build status
[10:27:14.495] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:27:14.495] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:62:0) after 1m0s
[10:28:14.517] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:62:0)
[10:28:14.517] Timer tick, asking Buildbucket for the build status
[10:28:14.668] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:28:14.668] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:63:0) after 1m0s
[10:29:14.709] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:63:0)
[10:29:14.709] Timer tick, asking Buildbucket for the build status
[10:29:14.806] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:29:14.806] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:64:0) after 1m0s
[10:30:14.891] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:64:0)
[10:30:14.891] Timer tick, asking Buildbucket for the build status
[10:30:14.976] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:30:14.977] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:65:0) after 1m0s
[10:31:14.999] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:65:0)
[10:31:15.000] Timer tick, asking Buildbucket for the build status
[10:31:15.121] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:31:15.121] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:66:0) after 1m0s
[10:32:15.149] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:66:0)
[10:32:15.149] Timer tick, asking Buildbucket for the build status
[10:32:15.283] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:32:15.283] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:67:0) after 1m0s
[10:33:15.312] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:67:0)
[10:33:15.312] Timer tick, asking Buildbucket for the build status
[10:33:15.423] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:33:15.423] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:68:0) after 1m0s
[10:34:15.445] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:68:0)
[10:34:15.445] Timer tick, asking Buildbucket for the build status
[10:34:15.548] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:34:15.548] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:69:0) after 1m0s
[10:35:15.578] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:69:0)
[10:35:15.578] Timer tick, asking Buildbucket for the build status
[10:35:15.748] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:35:15.748] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:70:0) after 1m0s
[10:36:15.772] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:70:0)
[10:36:15.772] Timer tick, asking Buildbucket for the build status
[10:36:15.901] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:36:15.901] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:71:0) after 1m0s
[10:37:15.927] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:71:0)
[10:37:15.928] Timer tick, asking Buildbucket for the build status
[10:37:16.023] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:37:16.023] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:72:0) after 1m0s
[10:38:16.080] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:72:0)
[10:38:16.080] Timer tick, asking Buildbucket for the build status
[10:38:16.178] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:38:16.178] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:73:0) after 1m0s
[10:39:16.279] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:73:0)
[10:39:16.279] Timer tick, asking Buildbucket for the build status
[10:39:16.429] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:39:16.429] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:74:0) after 1m0s
[10:40:16.452] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:74:0)
[10:40:16.452] Timer tick, asking Buildbucket for the build status
[10:40:16.583] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:40:16.583] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:75:0) after 1m0s
[10:41:16.607] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:75:0)
[10:41:16.607] Timer tick, asking Buildbucket for the build status
[10:41:16.706] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:41:16.706] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:76:0) after 1m0s
[10:42:16.778] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:76:0)
[10:42:16.778] Timer tick, asking Buildbucket for the build status
[10:42:16.920] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:42:16.920] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:77:0) after 1m0s
[10:43:16.974] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:77:0)
[10:43:16.974] Timer tick, asking Buildbucket for the build status
[10:43:17.139] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:43:17.139] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:78:0) after 1m0s
[10:44:17.194] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:78:0)
[10:44:17.194] Timer tick, asking Buildbucket for the build status
[10:44:17.277] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:44:17.277] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:79:0) after 1m0s
[10:45:17.336] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:79:0)
[10:45:17.336] Timer tick, asking Buildbucket for the build status
[10:45:17.420] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:45:17.420] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:80:0) after 1m0s
[10:46:17.447] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:80:0)
[10:46:17.447] Timer tick, asking Buildbucket for the build status
[10:46:17.567] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:46:17.567] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:81:0) after 1m0s
[10:47:17.588] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:81:0)
[10:47:17.588] Timer tick, asking Buildbucket for the build status
[10:47:17.668] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:47:17.669] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:82:0) after 1m0s
[10:48:17.690] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:82:0)
[10:48:17.690] Timer tick, asking Buildbucket for the build status
[10:48:17.773] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:48:17.773] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:83:0) after 1m0s
[10:49:17.919] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:83:0)
[10:49:17.919] Timer tick, asking Buildbucket for the build status
[10:49:18.027] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:49:18.027] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:84:0) after 1m0s
[10:50:18.091] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:84:0)
[10:50:18.091] Timer tick, asking Buildbucket for the build status
[10:50:18.198] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:50:18.198] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:85:0) after 1m0s
[10:51:18.261] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:85:0)
[10:51:18.261] Timer tick, asking Buildbucket for the build status
[10:51:18.348] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:51:18.348] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:86:0) after 1m0s
[10:52:18.371] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:86:0)
[10:52:18.371] Timer tick, asking Buildbucket for the build status
[10:52:18.466] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:52:18.466] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:87:0) after 1m0s
[10:53:18.489] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:87:0)
[10:53:18.489] Timer tick, asking Buildbucket for the build status
[10:53:18.625] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:53:18.625] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:88:0) after 1m0s
[10:54:18.650] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:88:0)
[10:54:18.650] Timer tick, asking Buildbucket for the build status
[10:54:18.813] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:54:18.813] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:89:0) after 1m0s
[10:55:18.894] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:89:0)
[10:55:18.894] Timer tick, asking Buildbucket for the build status
[10:55:18.988] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:55:18.988] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:90:0) after 1m0s
[10:56:19.080] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:90:0)
[10:56:19.080] Timer tick, asking Buildbucket for the build status
[10:56:19.195] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:56:19.195] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:91:0) after 1m0s
[10:57:19.284] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:91:0)
[10:57:19.284] Timer tick, asking Buildbucket for the build status
[10:57:19.362] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:57:19.362] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:92:0) after 1m0s
[10:58:19.419] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:92:0)
[10:58:19.419] Timer tick, asking Buildbucket for the build status
[10:58:19.519] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:58:19.519] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:93:0) after 1m0s
[10:59:19.597] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:93:0)
[10:59:19.597] Timer tick, asking Buildbucket for the build status
[10:59:19.737] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:59:19.737] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:94:0) after 1m0s
[11:00:19.761] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:94:0)
[11:00:19.761] Timer tick, asking Buildbucket for the build status
[11:00:19.913] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:00:19.913] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:95:0) after 1m0s
[11:01:19.939] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:95:0)
[11:01:19.939] Timer tick, asking Buildbucket for the build status
[11:01:20.023] Build 8869192816695554736: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:01:20.023] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:96:0) after 1m0s
[11:01:40.429] Received PubSub notification, asking Buildbucket for the build status
[11:01:40.521] Build 8869192816695554736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:20.056] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:96:0)
[11:02:20.056] Timer tick, asking Buildbucket for the build status
[11:02:20.193] Build 8869192816695554736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:20.193] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:98:0) after 1m0s
[11:03:20.217] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:98:0)
[11:03:20.217] Timer tick, asking Buildbucket for the build status
[11:03:20.322] Build 8869192816695554736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:20.322] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:99:0) after 1m0s
[11:04:20.399] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:99:0)
[11:04:20.399] Timer tick, asking Buildbucket for the build status
[11:04:20.479] Build 8869192816695554736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:20.479] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:100:0) after 1m0s
[11:05:20.506] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:100:0)
[11:05:20.506] Timer tick, asking Buildbucket for the build status
[11:05:20.624] Build 8869192816695554736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:20.624] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:101:0) after 1m0s
[11:06:20.648] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:101:0)
[11:06:20.648] Timer tick, asking Buildbucket for the build status
[11:06:20.745] Build 8869192816695554736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:20.745] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:102:0) after 1m0s
[11:07:20.771] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:102:0)
[11:07:20.771] Timer tick, asking Buildbucket for the build status
[11:07:20.850] Build 8869192816695554736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:20.850] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:103:0) after 1m0s
[11:08:20.874] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:103:0)
[11:08:20.874] Timer tick, asking Buildbucket for the build status
[11:08:20.981] Build 8869192816695554736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:20.981] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:104:0) after 1m0s
[11:09:21.076] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:104:0)
[11:09:21.076] Timer tick, asking Buildbucket for the build status
[11:09:21.156] Build 8869192816695554736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:21.156] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9034622878713284240:105:0) after 1m0s
[11:09:37.390] Received PubSub notification, asking Buildbucket for the build status
[11:09:37.534] Build 8869192816695554736: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:09:37.534] Buildbucket build:
{
"build": {
"bucket": "luci.infra.ci",
"canary_preference": "PROD",
"completed_ts": "1600081771560127",
"created_by": "project:infra",
"created_ts": "1600075625670626",
"id": "8869192816695554736",
"parameters_json": "{\"builder_name\": \"infra-continuous-win10-64\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler-dev.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"264059dc192f40c44f6e88945f22f37c2e32a4e8\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@264059dc192f40c44f6e88945f22f37c2e32a4e8\", \"title\": \"264059dc192f40c44f6e88945f22f37c2e32a4e8\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/264059dc192f40c44f6e88945f22f37c2e32a4e8\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"264059dc192f40c44f6e88945f22f37c2e32a4e8\"}}",
"project": "infra",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"got_revision\": \"264059dc192f40c44f6e88945f22f37c2e32a4e8\", \"got_revision_cp\": \"refs/heads/master@{#35025}\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_044445a3bc7a4bfe795493d7956aa02cd526172de1fa7300f69fe152e82ea631_v2\", \"builder_5de1032f0e9ef497433aad28840ee258c037976023b410f653133cee0ad04e2c_v2\", \"builder_82ed111fed7ea8169e482f00b5f3e5338a65daa41208585de67cb0a736b1d538_v2\", \"builder_a9c54e560aab64ffcab932ab26ad711a72ff73dbcd0bfe47f54d3e3349e5c381_v2\", \"git\", \"goma\", \"infra_gclient_with_go\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"dev-luci-chromium-ci-win10-0-9gyj\"], \"image\": [\"chrome-win10-1703-20083100-22dcea0839e\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5522-67570db\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "adhoc-testing@luci-token-server-dev.iam.gserviceaccount.com",
"started_ts": "1600081297233350",
"status": "COMPLETED",
"status_changed_ts": "1600081773064109",
"tags": [
"build_address:luci.infra.ci/infra-continuous-win10-64/17698",
"builder:infra-continuous-win10-64",
"buildset:commit/git/264059dc192f40c44f6e88945f22f37c2e32a4e8",
"buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/264059dc192f40c44f6e88945f22f37c2e32a4e8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9034622878713284240",
"scheduler_job_id:infra/infra-continuous-win10-64",
"swarming_hostname:chromium-swarm-dev.appspot.com",
"swarming_tag:log_location:logdog://luci-logdog-dev.appspot.com/infra/buildbucket/cr-buildbucket-dev.appspot.com/8869192816695554736/+/annotations",
"swarming_tag:luci_project:infra",
"swarming_tag:os:Windows",
"swarming_tag:recipe_name:infra_continuous",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/infra/infra",
"swarming_task_id:4ea4c1ff4fd7c310",
"user_agent:luci-scheduler-dev"
],
"updated_ts": "1600081773076493",
"url": "https://luci-milo-dev.appspot.com/b/8869192816695554736",
"utcnow_ts": "1600081777525261"
}
}
[11:09:37.534] Invocation finished in 1h42m33.172202219s with status SUCCEEDED