[16:14:48.088] New invocation is queued and will start shortly
[16:14:49.251] Starting the invocation (attempt 1)
[16:14:49.292] Popped gitiles commit info from properties and tags
[16:14:49.292] Popped a tag as redundant: buildset:commit/git/fe831dfc73de153b619fcf22fac44e5af310b235
[16:14:49.292] Popped a tag as redundant: buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/fe831dfc73de153b619fcf22fac44e5af310b235
[16:14:49.292] Popped a tag as redundant: gitiles_ref:refs/heads/master
[16:14:49.292] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[16:14:49.292] PubSub topic is "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
[16:14:49.292] Buildbucket request:
{
"requestId": "9018470966636063824",
"builder": {
"project": "infra",
"bucket": "ci",
"builder": "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": "fe831dfc73de153b619fcf22fac44e5af310b235"
},
"id": "https://chromium.googlesource.com/infra/infra/+/refs/heads/master@fe831dfc73de153b619fcf22fac44e5af310b235",
"title": "fe831dfc73de153b619fcf22fac44e5af310b235",
"url": "https://chromium.googlesource.com/infra/infra/+/fe831dfc73de153b619fcf22fac44e5af310b235"
}
]
}
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "infra/infra",
"id": "fe831dfc73de153b619fcf22fac44e5af310b235",
"ref": "refs/heads/master"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "9018470966636063824"
},
{
"key": "scheduler_job_id",
"value": "infra/infra-continuous-win10-64"
},
{
"key": "user_agent",
"value": "luci-scheduler-dev"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
}
}
[16:14:49.796] Scheduled build:
{
"id": "8853040904612244928",
"builder": {
"project": "infra",
"bucket": "ci",
"builder": "infra-continuous-win10-64"
},
"number": 18845,
"createdBy": "project:infra",
"createTime": "2021-03-11T16:14:49.385896Z",
"updateTime": "2021-03-11T16:14:49.725271Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "infra/infra",
"id": "fe831dfc73de153b619fcf22fac44e5af310b235",
"ref": "refs/heads/master"
}
}
}
[16:14:49.796] Task URL: https://cr-buildbucket-dev.appspot.com/build/8853040904612244928
[16:14:49.796] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:2:0) after 1m0s
[16:15:49.877] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:2:0)
[16:15:49.877] Timer tick, asking Buildbucket for the build status
[16:15:49.956] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:15:49.956] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:3:0) after 1m0s
[16:16:49.975] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:3:0)
[16:16:49.975] Timer tick, asking Buildbucket for the build status
[16:16:50.048] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:16:50.048] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:4:0) after 1m0s
[16:17:50.154] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:4:0)
[16:17:50.154] Timer tick, asking Buildbucket for the build status
[16:17:50.273] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:17:50.273] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:5:0) after 1m0s
[16:18:50.354] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:5:0)
[16:18:50.354] Timer tick, asking Buildbucket for the build status
[16:18:50.431] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:18:50.431] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:6:0) after 1m0s
[16:19:50.470] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:6:0)
[16:19:50.470] Timer tick, asking Buildbucket for the build status
[16:19:50.543] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:19:50.543] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:7:0) after 1m0s
[16:20:50.573] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:7:0)
[16:20:50.573] Timer tick, asking Buildbucket for the build status
[16:20:50.656] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:20:50.656] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:8:0) after 1m0s
[16:21:50.757] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:8:0)
[16:21:50.757] Timer tick, asking Buildbucket for the build status
[16:21:50.826] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:21:50.827] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:9:0) after 1m0s
[16:22:50.853] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:9:0)
[16:22:50.853] Timer tick, asking Buildbucket for the build status
[16:22:50.928] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:22:50.928] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:10:0) after 1m0s
[16:23:50.978] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:10:0)
[16:23:50.978] Timer tick, asking Buildbucket for the build status
[16:23:51.053] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:23:51.053] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:11:0) after 1m0s
[16:24:51.164] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:11:0)
[16:24:51.164] Timer tick, asking Buildbucket for the build status
[16:24:51.241] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:24:51.241] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:12:0) after 1m0s
[16:25:51.265] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:12:0)
[16:25:51.265] Timer tick, asking Buildbucket for the build status
[16:25:51.338] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:25:51.338] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:13:0) after 1m0s
[16:26:51.376] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:13:0)
[16:26:51.376] Timer tick, asking Buildbucket for the build status
[16:26:51.540] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:26:51.540] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:14:0) after 1m0s
[16:27:51.575] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:14:0)
[16:27:51.575] Timer tick, asking Buildbucket for the build status
[16:27:51.746] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:27:51.746] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:15:0) after 1m0s
[16:28:51.772] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:15:0)
[16:28:51.772] Timer tick, asking Buildbucket for the build status
[16:28:51.840] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:28:51.840] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:16:0) after 1m0s
[16:29:51.871] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:16:0)
[16:29:51.871] Timer tick, asking Buildbucket for the build status
[16:29:51.946] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:29:51.946] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:17:0) after 1m0s
[16:30:52.051] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:17:0)
[16:30:52.051] Timer tick, asking Buildbucket for the build status
[16:30:52.119] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:30:52.119] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:18:0) after 1m0s
[16:31:52.145] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:18:0)
[16:31:52.145] Timer tick, asking Buildbucket for the build status
[16:31:52.242] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:31:52.242] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:19:0) after 1m0s
[16:32:52.354] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:19:0)
[16:32:52.354] Timer tick, asking Buildbucket for the build status
[16:32:52.415] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:32:52.415] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:20:0) after 1m0s
[16:33:52.464] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:20:0)
[16:33:52.464] Timer tick, asking Buildbucket for the build status
[16:33:52.561] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:33:52.561] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:21:0) after 1m0s
[16:34:52.579] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:21:0)
[16:34:52.579] Timer tick, asking Buildbucket for the build status
[16:34:52.665] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:34:52.665] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:22:0) after 1m0s
[16:35:52.751] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:22:0)
[16:35:52.751] Timer tick, asking Buildbucket for the build status
[16:35:52.826] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:35:52.826] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:23:0) after 1m0s
[16:36:52.880] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:23:0)
[16:36:52.880] Timer tick, asking Buildbucket for the build status
[16:36:52.970] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:36:52.970] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:24:0) after 1m0s
[16:37:53.053] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:24:0)
[16:37:53.053] Timer tick, asking Buildbucket for the build status
[16:37:53.145] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:37:53.145] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:25:0) after 1m0s
[16:38:53.262] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:25:0)
[16:38:53.262] Timer tick, asking Buildbucket for the build status
[16:38:53.338] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:38:53.338] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:26:0) after 1m0s
[16:39:53.367] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:26:0)
[16:39:53.367] Timer tick, asking Buildbucket for the build status
[16:39:53.437] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:39:53.437] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:27:0) after 1m0s
[16:40:53.464] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:27:0)
[16:40:53.464] Timer tick, asking Buildbucket for the build status
[16:40:53.555] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:40:53.555] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:28:0) after 1m0s
[16:41:53.667] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:28:0)
[16:41:53.667] Timer tick, asking Buildbucket for the build status
[16:41:53.752] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:41:53.752] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:29:0) after 1m0s
[16:42:53.853] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:29:0)
[16:42:53.853] Timer tick, asking Buildbucket for the build status
[16:42:53.915] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:42:53.915] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:30:0) after 1m0s
[16:43:53.935] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:30:0)
[16:43:53.935] Timer tick, asking Buildbucket for the build status
[16:43:54.054] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:43:54.054] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:31:0) after 1m0s
[16:44:54.164] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:31:0)
[16:44:54.164] Timer tick, asking Buildbucket for the build status
[16:44:54.239] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:44:54.239] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:32:0) after 1m0s
[16:45:54.261] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:32:0)
[16:45:54.261] Timer tick, asking Buildbucket for the build status
[16:45:54.335] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:45:54.335] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:33:0) after 1m0s
[16:46:54.372] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:33:0)
[16:46:54.372] Timer tick, asking Buildbucket for the build status
[16:46:54.455] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:46:54.455] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:34:0) after 1m0s
[16:47:54.569] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:34:0)
[16:47:54.569] Timer tick, asking Buildbucket for the build status
[16:47:54.636] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:47:54.636] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:35:0) after 1m0s
[16:48:54.657] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:35:0)
[16:48:54.657] Timer tick, asking Buildbucket for the build status
[16:48:54.730] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:48:54.730] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:36:0) after 1m0s
[16:49:54.752] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:36:0)
[16:49:54.752] Timer tick, asking Buildbucket for the build status
[16:49:54.836] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:49:54.836] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:37:0) after 1m0s
[16:50:54.864] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:37:0)
[16:50:54.864] Timer tick, asking Buildbucket for the build status
[16:50:54.941] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:50:54.941] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:38:0) after 1m0s
[16:51:54.965] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:38:0)
[16:51:54.965] Timer tick, asking Buildbucket for the build status
[16:51:55.031] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:51:55.031] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:39:0) after 1m0s
[16:52:55.066] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:39:0)
[16:52:55.066] Timer tick, asking Buildbucket for the build status
[16:52:55.139] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:52:55.139] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:40:0) after 1m0s
[16:53:55.170] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:40:0)
[16:53:55.170] Timer tick, asking Buildbucket for the build status
[16:53:55.241] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:53:55.241] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:41:0) after 1m0s
[16:54:55.271] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:41:0)
[16:54:55.271] Timer tick, asking Buildbucket for the build status
[16:54:55.355] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:54:55.355] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:42:0) after 1m0s
[16:55:55.481] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:42:0)
[16:55:55.481] Timer tick, asking Buildbucket for the build status
[16:55:55.540] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:55:55.540] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:43:0) after 1m0s
[16:56:55.570] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:43:0)
[16:56:55.570] Timer tick, asking Buildbucket for the build status
[16:56:55.649] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:56:55.649] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:44:0) after 1m0s
[16:57:55.760] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:44:0)
[16:57:55.760] Timer tick, asking Buildbucket for the build status
[16:57:55.829] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:57:55.829] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:45:0) after 1m0s
[16:58:55.867] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:45:0)
[16:58:55.867] Timer tick, asking Buildbucket for the build status
[16:58:55.943] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:58:55.943] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:46:0) after 1m0s
[16:59:55.969] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:46:0)
[16:59:55.969] Timer tick, asking Buildbucket for the build status
[16:59:56.045] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:59:56.045] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:47:0) after 1m0s
[17:00:56.076] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:47:0)
[17:00:56.076] Timer tick, asking Buildbucket for the build status
[17:00:56.229] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:00:56.229] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:48:0) after 1m0s
[17:01:56.310] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:48:0)
[17:01:56.310] Timer tick, asking Buildbucket for the build status
[17:01:56.394] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:01:56.394] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:49:0) after 1m0s
[17:02:56.455] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:49:0)
[17:02:56.455] Timer tick, asking Buildbucket for the build status
[17:02:56.519] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:02:56.519] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:50:0) after 1m0s
[17:03:56.538] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:50:0)
[17:03:56.538] Timer tick, asking Buildbucket for the build status
[17:03:56.601] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:03:56.601] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:51:0) after 1m0s
[17:04:56.626] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:51:0)
[17:04:56.626] Timer tick, asking Buildbucket for the build status
[17:04:56.721] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:04:56.721] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:52:0) after 1m0s
[17:05:56.797] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:52:0)
[17:05:56.797] Timer tick, asking Buildbucket for the build status
[17:05:56.879] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:05:56.879] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:53:0) after 1m0s
[17:06:56.955] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:53:0)
[17:06:56.955] Timer tick, asking Buildbucket for the build status
[17:06:57.027] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:06:57.027] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:54:0) after 1m0s
[17:07:57.065] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:54:0)
[17:07:57.065] Timer tick, asking Buildbucket for the build status
[17:07:57.141] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:07:57.141] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:55:0) after 1m0s
[17:08:57.164] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:55:0)
[17:08:57.164] Timer tick, asking Buildbucket for the build status
[17:08:57.234] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:08:57.234] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:56:0) after 1m0s
[17:09:57.269] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:56:0)
[17:09:57.269] Timer tick, asking Buildbucket for the build status
[17:09:57.331] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:09:57.331] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:57:0) after 1m0s
[17:10:57.367] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:57:0)
[17:10:57.367] Timer tick, asking Buildbucket for the build status
[17:10:57.435] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:10:57.435] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:58:0) after 1m0s
[17:11:57.469] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:58:0)
[17:11:57.469] Timer tick, asking Buildbucket for the build status
[17:11:57.544] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:11:57.544] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:59:0) after 1m0s
[17:12:57.576] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:59:0)
[17:12:57.576] Timer tick, asking Buildbucket for the build status
[17:12:57.645] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:12:57.645] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:60:0) after 1m0s
[17:13:57.722] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:60:0)
[17:13:57.722] Timer tick, asking Buildbucket for the build status
[17:13:57.868] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:13:57.868] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:61:0) after 1m0s
[17:14:57.959] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:61:0)
[17:14:57.959] Timer tick, asking Buildbucket for the build status
[17:14:58.035] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:14:58.035] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:62:0) after 1m0s
[17:15:58.072] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:62:0)
[17:15:58.072] Timer tick, asking Buildbucket for the build status
[17:15:58.152] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:15:58.152] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:63:0) after 1m0s
[17:16:58.267] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:63:0)
[17:16:58.267] Timer tick, asking Buildbucket for the build status
[17:16:58.334] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:16:58.334] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:64:0) after 1m0s
[17:17:58.359] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:64:0)
[17:17:58.359] Timer tick, asking Buildbucket for the build status
[17:17:58.459] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:17:58.459] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:65:0) after 1m0s
[17:18:58.572] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:65:0)
[17:18:58.572] Timer tick, asking Buildbucket for the build status
[17:18:58.659] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:18:58.659] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:66:0) after 1m0s
[17:19:58.756] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:66:0)
[17:19:58.756] Timer tick, asking Buildbucket for the build status
[17:19:58.831] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:19:58.831] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:67:0) after 1m0s
[17:20:58.877] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:67:0)
[17:20:58.877] Timer tick, asking Buildbucket for the build status
[17:20:58.966] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:20:58.966] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:68:0) after 1m0s
[17:21:59.068] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:68:0)
[17:21:59.068] Timer tick, asking Buildbucket for the build status
[17:21:59.153] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:21:59.153] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:69:0) after 1m0s
[17:22:59.268] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:69:0)
[17:22:59.268] Timer tick, asking Buildbucket for the build status
[17:22:59.348] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:22:59.348] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:70:0) after 1m0s
[17:23:59.454] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:70:0)
[17:23:59.454] Timer tick, asking Buildbucket for the build status
[17:23:59.549] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:23:59.549] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:71:0) after 1m0s
[17:24:59.654] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:71:0)
[17:24:59.654] Timer tick, asking Buildbucket for the build status
[17:24:59.750] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:24:59.750] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:72:0) after 1m0s
[17:25:59.864] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:72:0)
[17:25:59.864] Timer tick, asking Buildbucket for the build status
[17:25:59.948] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:25:59.948] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:73:0) after 1m0s
[17:27:00.059] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:73:0)
[17:27:00.059] Timer tick, asking Buildbucket for the build status
[17:27:00.375] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:27:00.375] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:74:0) after 1m0s
[17:28:00.463] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:74:0)
[17:28:00.463] Timer tick, asking Buildbucket for the build status
[17:28:00.548] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:28:00.548] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:75:0) after 1m0s
[17:29:00.571] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:75:0)
[17:29:00.571] Timer tick, asking Buildbucket for the build status
[17:29:00.755] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:29:00.755] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:76:0) after 1m0s
[17:30:00.855] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:76:0)
[17:30:00.855] Timer tick, asking Buildbucket for the build status
[17:30:00.946] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:30:00.946] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:77:0) after 1m0s
[17:31:00.978] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:77:0)
[17:31:00.978] Timer tick, asking Buildbucket for the build status
[17:31:01.256] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:31:01.256] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:78:0) after 1m0s
[17:32:01.362] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:78:0)
[17:32:01.362] Timer tick, asking Buildbucket for the build status
[17:32:01.448] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:32:01.448] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:79:0) after 1m0s
[17:33:01.473] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:79:0)
[17:33:01.473] Timer tick, asking Buildbucket for the build status
[17:33:01.603] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:33:01.603] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:80:0) after 1m0s
[17:34:01.658] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:80:0)
[17:34:01.658] Timer tick, asking Buildbucket for the build status
[17:34:01.801] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:34:01.801] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:81:0) after 1m0s
[17:35:01.860] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:81:0)
[17:35:01.860] Timer tick, asking Buildbucket for the build status
[17:35:01.930] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:35:01.930] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:82:0) after 1m0s
[17:36:01.955] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:82:0)
[17:36:01.955] Timer tick, asking Buildbucket for the build status
[17:36:02.077] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:36:02.077] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:83:0) after 1m0s
[17:37:02.165] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:83:0)
[17:37:02.165] Timer tick, asking Buildbucket for the build status
[17:37:02.234] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:37:02.234] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:84:0) after 1m0s
[17:38:02.256] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:84:0)
[17:38:02.256] Timer tick, asking Buildbucket for the build status
[17:38:02.331] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:38:02.331] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:85:0) after 1m0s
[17:39:02.351] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:85:0)
[17:39:02.351] Timer tick, asking Buildbucket for the build status
[17:39:02.443] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:39:02.443] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:86:0) after 1m0s
[17:40:02.470] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:86:0)
[17:40:02.470] Timer tick, asking Buildbucket for the build status
[17:40:02.538] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:40:02.538] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:87:0) after 1m0s
[17:41:02.559] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:87:0)
[17:41:02.559] Timer tick, asking Buildbucket for the build status
[17:41:02.643] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:41:02.643] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:88:0) after 1m0s
[17:42:02.664] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:88:0)
[17:42:02.664] Timer tick, asking Buildbucket for the build status
[17:42:02.736] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:42:02.736] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:89:0) after 1m0s
[17:43:02.758] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:89:0)
[17:43:02.758] Timer tick, asking Buildbucket for the build status
[17:43:02.832] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:43:02.832] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:90:0) after 1m0s
[17:44:02.867] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:90:0)
[17:44:02.867] Timer tick, asking Buildbucket for the build status
[17:44:02.950] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:44:02.950] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:91:0) after 1m0s
[17:45:03.078] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:91:0)
[17:45:03.078] Timer tick, asking Buildbucket for the build status
[17:45:03.179] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:45:03.179] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:92:0) after 1m0s
[17:46:03.267] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:92:0)
[17:46:03.267] Timer tick, asking Buildbucket for the build status
[17:46:03.364] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:46:03.364] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:93:0) after 1m0s
[17:47:03.462] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:93:0)
[17:47:03.462] Timer tick, asking Buildbucket for the build status
[17:47:03.551] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:47:03.551] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:94:0) after 1m0s
[17:48:03.664] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:94:0)
[17:48:03.664] Timer tick, asking Buildbucket for the build status
[17:48:03.758] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:48:03.758] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:95:0) after 1m0s
[17:49:03.858] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:95:0)
[17:49:03.858] Timer tick, asking Buildbucket for the build status
[17:49:03.930] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:49:03.930] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:96:0) after 1m0s
[17:50:03.956] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:96:0)
[17:50:03.956] Timer tick, asking Buildbucket for the build status
[17:50:04.049] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:50:04.049] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:97:0) after 1m0s
[17:51:04.076] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:97:0)
[17:51:04.076] Timer tick, asking Buildbucket for the build status
[17:51:04.144] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:51:04.144] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:98:0) after 1m0s
[17:52:04.168] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:98:0)
[17:52:04.168] Timer tick, asking Buildbucket for the build status
[17:52:04.237] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:52:04.237] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:99:0) after 1m0s
[17:53:04.268] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:99:0)
[17:53:04.268] Timer tick, asking Buildbucket for the build status
[17:53:04.339] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:53:04.339] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:100:0) after 1m0s
[17:54:04.362] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:100:0)
[17:54:04.362] Timer tick, asking Buildbucket for the build status
[17:54:04.453] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:54:04.453] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:101:0) after 1m0s
[17:55:04.566] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:101:0)
[17:55:04.566] Timer tick, asking Buildbucket for the build status
[17:55:04.649] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:55:04.650] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:102:0) after 1m0s
[17:56:04.775] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:102:0)
[17:56:04.775] Timer tick, asking Buildbucket for the build status
[17:56:04.933] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:56:04.933] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:103:0) after 1m0s
[17:57:04.953] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:103:0)
[17:57:04.953] Timer tick, asking Buildbucket for the build status
[17:57:05.051] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:57:05.051] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:104:0) after 1m0s
[17:58:05.168] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:104:0)
[17:58:05.168] Timer tick, asking Buildbucket for the build status
[17:58:05.236] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:58:05.236] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:105:0) after 1m0s
[17:59:05.257] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:105:0)
[17:59:05.257] Timer tick, asking Buildbucket for the build status
[17:59:05.337] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:59:05.338] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:106:0) after 1m0s
[18:00:05.377] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:106:0)
[18:00:05.377] Timer tick, asking Buildbucket for the build status
[18:00:05.465] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:00:05.465] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:107:0) after 1m0s
[18:01:05.567] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:107:0)
[18:01:05.567] Timer tick, asking Buildbucket for the build status
[18:01:05.635] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:01:05.635] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:108:0) after 1m0s
[18:02:05.665] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:108:0)
[18:02:05.665] Timer tick, asking Buildbucket for the build status
[18:02:05.738] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:02:05.738] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:109:0) after 1m0s
[18:03:05.765] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:109:0)
[18:03:05.765] Timer tick, asking Buildbucket for the build status
[18:03:05.831] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:03:05.831] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:110:0) after 1m0s
[18:04:05.874] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:110:0)
[18:04:05.874] Timer tick, asking Buildbucket for the build status
[18:04:05.950] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:04:05.950] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:111:0) after 1m0s
[18:05:06.055] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:111:0)
[18:05:06.055] Timer tick, asking Buildbucket for the build status
[18:05:06.163] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:05:06.163] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:112:0) after 1m0s
[18:06:06.190] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:112:0)
[18:06:06.190] Timer tick, asking Buildbucket for the build status
[18:06:06.279] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:06:06.279] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:113:0) after 1m0s
[18:07:06.372] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:113:0)
[18:07:06.372] Timer tick, asking Buildbucket for the build status
[18:07:06.443] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:07:06.443] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:114:0) after 1m0s
[18:08:06.467] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:114:0)
[18:08:06.467] Timer tick, asking Buildbucket for the build status
[18:08:06.567] Build 8853040904612244928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:08:06.568] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:115:0) after 1m0s
[18:08:40.976] Received PubSub notification, asking Buildbucket for the build status
[18:08:41.061] Build 8853040904612244928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:06.668] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:115:0)
[18:09:06.668] Timer tick, asking Buildbucket for the build status
[18:09:06.779] Build 8853040904612244928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:06.779] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:117:0) after 1m0s
[18:10:06.868] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:117:0)
[18:10:06.868] Timer tick, asking Buildbucket for the build status
[18:10:06.961] Build 8853040904612244928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:06.961] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:118:0) after 1m0s
[18:11:07.084] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:118:0)
[18:11:07.084] Timer tick, asking Buildbucket for the build status
[18:11:07.152] Build 8853040904612244928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:07.152] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:119:0) after 1m0s
[18:12:07.256] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:119:0)
[18:12:07.256] Timer tick, asking Buildbucket for the build status
[18:12:07.342] Build 8853040904612244928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:07.342] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:120:0) after 1m0s
[18:13:07.376] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:120:0)
[18:13:07.376] Timer tick, asking Buildbucket for the build status
[18:13:07.450] Build 8853040904612244928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:07.450] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:121:0) after 1m0s
[18:14:07.484] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:121:0)
[18:14:07.484] Timer tick, asking Buildbucket for the build status
[18:14:07.592] Build 8853040904612244928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:07.592] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:122:0) after 1m0s
[18:15:07.667] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:122:0)
[18:15:07.667] Timer tick, asking Buildbucket for the build status
[18:15:07.746] Build 8853040904612244928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:07.746] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:123:0) after 1m0s
[18:16:07.779] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:123:0)
[18:16:07.779] Timer tick, asking Buildbucket for the build status
[18:16:07.850] Build 8853040904612244928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:07.850] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:124:0) after 1m0s
[18:17:07.882] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:124:0)
[18:17:07.882] Timer tick, asking Buildbucket for the build status
[18:17:07.959] Build 8853040904612244928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:07.959] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:125:0) after 1m0s
[18:18:08.057] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:125:0)
[18:18:08.057] Timer tick, asking Buildbucket for the build status
[18:18:08.134] Build 8853040904612244928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:08.134] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:126:0) after 1m0s
[18:19:08.189] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:126:0)
[18:19:08.189] Timer tick, asking Buildbucket for the build status
[18:19:08.258] Build 8853040904612244928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:08.258] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:127:0) after 1m0s
[18:20:08.294] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:127:0)
[18:20:08.294] Timer tick, asking Buildbucket for the build status
[18:20:08.380] Build 8853040904612244928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:08.380] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9018470966636063824:128:0) after 1m0s
[18:20:31.057] Received PubSub notification, asking Buildbucket for the build status
[18:20:31.141] Build 8853040904612244928: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[18:20:31.141] Buildbucket build:
{
"build": {
"bucket": "luci.infra.ci",
"canary_preference": "PROD",
"completed_ts": "1615486830538747",
"created_by": "project:infra",
"created_ts": "1615479289385896",
"id": "8853040904612244928",
"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\": \"fe831dfc73de153b619fcf22fac44e5af310b235\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@fe831dfc73de153b619fcf22fac44e5af310b235\", \"title\": \"fe831dfc73de153b619fcf22fac44e5af310b235\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/fe831dfc73de153b619fcf22fac44e5af310b235\"}]}}}",
"project": "infra",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"got_revision\": \"fe831dfc73de153b619fcf22fac44e5af310b235\", \"got_revision_cp\": \"refs/heads/master@{#39255}\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_a9c54e560aab64ffcab932ab26ad711a72ff73dbcd0bfe47f54d3e3349e5c381_v2\", \"git\", \"goma\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"dev-luci-chromium-ci-win10-0-6rd2\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5755-f07b01c\"], \"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": "1615486117994635",
"status": "COMPLETED",
"status_changed_ts": "1615486119664952",
"tags": [
"build_address:luci.infra.ci/infra-continuous-win10-64/18845",
"builder:infra-continuous-win10-64",
"buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/fe831dfc73de153b619fcf22fac44e5af310b235",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018470966636063824",
"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/8853040904612244928/+/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:523ae340606f4b10",
"user_agent:luci-scheduler-dev"
],
"updated_ts": "1615486830539091",
"url": "https://luci-milo-dev.appspot.com/b/8853040904612244928",
"utcnow_ts": "1615486831134471"
}
}
[18:20:31.141] Invocation finished in 2h5m43.069746731s with status SUCCEEDED