[18:50:58.322] New invocation is queued and will start shortly
[18:50:59.483] Starting the invocation (attempt 1)
[18:50:59.546] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[18:50:59.547] PubSub topic is "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
[18:50:59.547] Buildbucket request:
{
"bucket": "luci.infra.ci",
"client_operation_id": "9022356810794531024",
"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\":\"c76c18519c1ae07f9c479cad6561220a65ed2eb6\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@c76c18519c1ae07f9c479cad6561220a65ed2eb6\",\"title\":\"c76c18519c1ae07f9c479cad6561220a65ed2eb6\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/c76c18519c1ae07f9c479cad6561220a65ed2eb6\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"c76c18519c1ae07f9c479cad6561220a65ed2eb6\"}}",
"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:9022356810794531024",
"scheduler_job_id:infra/infra-continuous-win10-64",
"user_agent:luci-scheduler-dev",
"buildset:commit/git/c76c18519c1ae07f9c479cad6561220a65ed2eb6",
"buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/c76c18519c1ae07f9c479cad6561220a65ed2eb6",
"gitiles_ref:refs/heads/master"
]
}
[18:51:00.554] Buildbucket response:
{
"build": {
"bucket": "luci.infra.ci",
"canary_preference": "PROD",
"created_by": "project:infra",
"created_ts": "1611773459649176",
"id": "8856926748733358752",
"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\": \"c76c18519c1ae07f9c479cad6561220a65ed2eb6\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@c76c18519c1ae07f9c479cad6561220a65ed2eb6\", \"title\": \"c76c18519c1ae07f9c479cad6561220a65ed2eb6\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/c76c18519c1ae07f9c479cad6561220a65ed2eb6\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"c76c18519c1ae07f9c479cad6561220a65ed2eb6\"}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "adhoc-testing@luci-token-server-dev.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611773460384979",
"tags": [
"build_address:luci.infra.ci/infra-continuous-win10-64/18445",
"builder:infra-continuous-win10-64",
"buildset:commit/git/c76c18519c1ae07f9c479cad6561220a65ed2eb6",
"buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/c76c18519c1ae07f9c479cad6561220a65ed2eb6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022356810794531024",
"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/8856926748733358752/+/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": "1611773460385092",
"url": "https://luci-milo-dev.appspot.com/b/8856926748733358752",
"utcnow_ts": "1611773460544670"
}
}
[18:51:00.554] Task URL: https://luci-milo-dev.appspot.com/b/8856926748733358752
[18:51:00.554] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:2:0) after 1m0s
[18:52:00.639] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:2:0)
[18:52:00.639] Timer tick, asking Buildbucket for the build status
[18:52:00.719] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:52:00.719] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:3:0) after 1m0s
[18:53:00.752] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:3:0)
[18:53:00.752] Timer tick, asking Buildbucket for the build status
[18:53:00.832] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:53:00.832] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:4:0) after 1m0s
[18:54:00.942] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:4:0)
[18:54:00.942] Timer tick, asking Buildbucket for the build status
[18:54:01.009] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:54:01.009] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:5:0) after 1m0s
[18:55:01.037] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:5:0)
[18:55:01.037] Timer tick, asking Buildbucket for the build status
[18:55:01.121] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:55:01.121] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:6:0) after 1m0s
[18:56:01.153] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:6:0)
[18:56:01.153] Timer tick, asking Buildbucket for the build status
[18:56:01.226] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:56:01.226] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:7:0) after 1m0s
[18:57:01.249] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:7:0)
[18:57:01.249] Timer tick, asking Buildbucket for the build status
[18:57:01.335] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:57:01.335] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:8:0) after 1m0s
[18:58:01.437] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:8:0)
[18:58:01.437] Timer tick, asking Buildbucket for the build status
[18:58:01.593] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:58:01.593] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:9:0) after 1m0s
[18:59:01.670] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:9:0)
[18:59:01.670] Timer tick, asking Buildbucket for the build status
[18:59:01.778] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:59:01.778] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:10:0) after 1m0s
[19:00:01.836] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:10:0)
[19:00:01.836] Timer tick, asking Buildbucket for the build status
[19:00:01.925] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:00:01.925] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:11:0) after 1m0s
[19:01:02.024] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:11:0)
[19:01:02.024] Timer tick, asking Buildbucket for the build status
[19:01:02.172] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:01:02.172] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:12:0) after 1m0s
[19:02:02.236] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:12:0)
[19:02:02.236] Timer tick, asking Buildbucket for the build status
[19:02:02.312] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:02:02.312] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:13:0) after 1m0s
[19:03:02.333] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:13:0)
[19:03:02.333] Timer tick, asking Buildbucket for the build status
[19:03:02.422] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:03:02.422] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:14:0) after 1m0s
[19:04:02.528] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:14:0)
[19:04:02.528] Timer tick, asking Buildbucket for the build status
[19:04:02.638] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:04:02.638] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:15:0) after 1m0s
[19:05:02.671] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:15:0)
[19:05:02.671] Timer tick, asking Buildbucket for the build status
[19:05:02.779] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:05:02.779] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:16:0) after 1m0s
[19:06:02.833] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:16:0)
[19:06:02.833] Timer tick, asking Buildbucket for the build status
[19:06:02.973] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:06:02.973] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:17:0) after 1m0s
[19:07:03.002] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:17:0)
[19:07:03.002] Timer tick, asking Buildbucket for the build status
[19:07:03.083] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:07:03.083] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:18:0) after 1m0s
[19:08:03.142] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:18:0)
[19:08:03.142] Timer tick, asking Buildbucket for the build status
[19:08:03.218] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:08:03.218] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:19:0) after 1m0s
[19:09:03.257] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:19:0)
[19:09:03.257] Timer tick, asking Buildbucket for the build status
[19:09:03.387] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:09:03.387] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:20:0) after 1m0s
[19:10:03.429] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:20:0)
[19:10:03.429] Timer tick, asking Buildbucket for the build status
[19:10:03.542] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:10:03.542] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:21:0) after 1m0s
[19:11:03.570] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:21:0)
[19:11:03.570] Timer tick, asking Buildbucket for the build status
[19:11:03.945] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:11:03.945] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:22:0) after 1m0s
[19:12:04.004] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:22:0)
[19:12:04.004] Timer tick, asking Buildbucket for the build status
[19:12:04.142] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:12:04.142] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:23:0) after 1m0s
[19:13:04.484] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:23:0)
[19:13:04.484] Timer tick, asking Buildbucket for the build status
[19:13:04.588] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:13:04.588] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:24:0) after 1m0s
[19:14:04.731] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:24:0)
[19:14:04.731] Timer tick, asking Buildbucket for the build status
[19:14:04.846] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:14:04.846] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:25:0) after 1m0s
[19:15:04.939] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:25:0)
[19:15:04.939] Timer tick, asking Buildbucket for the build status
[19:15:05.219] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:15:05.219] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:26:0) after 1m0s
[19:16:05.318] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:26:0)
[19:16:05.318] Timer tick, asking Buildbucket for the build status
[19:16:05.548] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:16:05.548] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:27:0) after 1m0s
[19:17:05.642] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:27:0)
[19:17:05.642] Timer tick, asking Buildbucket for the build status
[19:17:05.930] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:17:05.930] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:28:0) after 1m0s
[19:18:05.981] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:28:0)
[19:18:05.981] Timer tick, asking Buildbucket for the build status
[19:18:06.418] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:18:06.418] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:29:0) after 1m0s
[19:19:06.447] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:29:0)
[19:19:06.447] Timer tick, asking Buildbucket for the build status
[19:19:06.707] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:19:06.707] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:30:0) after 1m0s
[19:20:06.733] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:30:0)
[19:20:06.733] Timer tick, asking Buildbucket for the build status
[19:20:06.941] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:20:06.941] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:31:0) after 1m0s
[19:21:07.056] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:31:0)
[19:21:07.056] Timer tick, asking Buildbucket for the build status
[19:21:07.249] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:21:07.249] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:32:0) after 1m0s
[19:22:07.404] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:32:0)
[19:22:07.404] Timer tick, asking Buildbucket for the build status
[19:22:07.910] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:22:07.910] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:33:0) after 1m0s
[19:23:08.041] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:33:0)
[19:23:08.041] Timer tick, asking Buildbucket for the build status
[19:23:08.311] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:23:08.311] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:34:0) after 1m0s
[19:24:08.342] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:34:0)
[19:24:08.342] Timer tick, asking Buildbucket for the build status
[19:24:12.458] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:24:12.458] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:35:0) after 1m0s
[19:25:12.498] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:35:0)
[19:25:12.498] Timer tick, asking Buildbucket for the build status
[19:25:21.349] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:25:21.349] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:36:0) after 1m0s
[19:26:21.369] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:36:0)
[19:26:21.369] Timer tick, asking Buildbucket for the build status
[19:26:21.633] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:26:21.633] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:37:0) after 1m0s
[19:27:21.739] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:37:0)
[19:27:21.739] Timer tick, asking Buildbucket for the build status
[19:27:21.960] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:27:21.960] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:38:0) after 1m0s
[19:28:22.029] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:38:0)
[19:28:22.029] Timer tick, asking Buildbucket for the build status
[19:28:22.265] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:28:22.265] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:39:0) after 1m0s
[19:29:22.344] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:39:0)
[19:29:22.344] Timer tick, asking Buildbucket for the build status
[19:29:22.597] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:29:22.597] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:40:0) after 1m0s
[19:30:22.629] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:40:0)
[19:30:22.629] Timer tick, asking Buildbucket for the build status
[19:30:22.908] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:30:22.908] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:41:0) after 1m0s
[19:31:22.935] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:41:0)
[19:31:22.935] Timer tick, asking Buildbucket for the build status
[19:31:23.162] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:31:23.162] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:42:0) after 1m0s
[19:32:23.187] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:42:0)
[19:32:23.187] Timer tick, asking Buildbucket for the build status
[19:32:23.519] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:32:23.520] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:43:0) after 1m0s
[19:33:23.559] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:43:0)
[19:33:23.559] Timer tick, asking Buildbucket for the build status
[19:33:23.940] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:33:23.941] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:44:0) after 1m0s
[19:34:23.963] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:44:0)
[19:34:23.963] Timer tick, asking Buildbucket for the build status
[19:34:24.184] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:34:24.184] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:45:0) after 1m0s
[19:35:24.246] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:45:0)
[19:35:24.246] Timer tick, asking Buildbucket for the build status
[19:35:24.430] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:35:24.430] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:46:0) after 1m0s
[19:36:24.529] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:46:0)
[19:36:24.529] Timer tick, asking Buildbucket for the build status
[19:36:24.716] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:36:24.716] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:47:0) after 1m0s
[19:37:24.744] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:47:0)
[19:37:24.744] Timer tick, asking Buildbucket for the build status
[19:37:24.987] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:37:24.987] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:48:0) after 1m0s
[19:38:25.048] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:48:0)
[19:38:25.048] Timer tick, asking Buildbucket for the build status
[19:38:25.258] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:38:25.258] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:49:0) after 1m0s
[19:39:25.349] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:49:0)
[19:39:25.349] Timer tick, asking Buildbucket for the build status
[19:39:25.604] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:39:25.604] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:50:0) after 1m0s
[19:40:25.647] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:50:0)
[19:40:25.647] Timer tick, asking Buildbucket for the build status
[19:40:25.884] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:40:25.884] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:51:0) after 1m0s
[19:41:25.946] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:51:0)
[19:41:25.946] Timer tick, asking Buildbucket for the build status
[19:41:26.151] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:41:26.151] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:52:0) after 1m0s
[19:42:26.260] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:52:0)
[19:42:26.260] Timer tick, asking Buildbucket for the build status
[19:42:26.514] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:42:26.514] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:53:0) after 1m0s
[19:43:26.542] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:53:0)
[19:43:26.542] Timer tick, asking Buildbucket for the build status
[19:43:26.770] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:43:26.770] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:54:0) after 1m0s
[19:44:26.839] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:54:0)
[19:44:26.839] Timer tick, asking Buildbucket for the build status
[19:44:27.494] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:44:27.494] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:55:0) after 1m0s
[19:45:27.528] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:55:0)
[19:45:27.528] Timer tick, asking Buildbucket for the build status
[19:45:27.974] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:45:27.974] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:56:0) after 1m0s
[19:46:28.045] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:56:0)
[19:46:28.045] Timer tick, asking Buildbucket for the build status
[19:46:36.005] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:46:36.005] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:57:0) after 1m0s
[19:47:36.050] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:57:0)
[19:47:36.050] Timer tick, asking Buildbucket for the build status
[19:47:44.762] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:47:44.762] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:58:0) after 1m0s
[19:48:44.798] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:58:0)
[19:48:44.798] Timer tick, asking Buildbucket for the build status
[19:48:45.145] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:48:45.145] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:59:0) after 1m0s
[19:49:45.244] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:59:0)
[19:49:45.244] Timer tick, asking Buildbucket for the build status
[19:49:45.628] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:49:45.628] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:60:0) after 1m0s
[19:50:45.658] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:60:0)
[19:50:45.658] Timer tick, asking Buildbucket for the build status
[19:50:46.087] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:50:46.087] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:61:0) after 1m0s
[19:51:46.118] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:61:0)
[19:51:46.118] Timer tick, asking Buildbucket for the build status
[19:51:46.321] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:51:46.321] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:62:0) after 1m0s
[19:52:46.356] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:62:0)
[19:52:46.356] Timer tick, asking Buildbucket for the build status
[19:52:46.529] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:52:46.529] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:63:0) after 1m0s
[19:53:46.637] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:63:0)
[19:53:46.637] Timer tick, asking Buildbucket for the build status
[19:53:46.829] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:53:46.829] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:64:0) after 1m0s
[19:54:46.930] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:64:0)
[19:54:46.930] Timer tick, asking Buildbucket for the build status
[19:54:47.130] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:54:47.131] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:65:0) after 1m0s
[19:55:47.243] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:65:0)
[19:55:47.243] Timer tick, asking Buildbucket for the build status
[19:55:47.436] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:55:47.436] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:66:0) after 1m0s
[19:56:47.531] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:66:0)
[19:56:47.531] Timer tick, asking Buildbucket for the build status
[19:56:47.757] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:56:47.757] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:67:0) after 1m0s
[19:57:47.778] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:67:0)
[19:57:47.778] Timer tick, asking Buildbucket for the build status
[19:57:48.018] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:57:48.018] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:68:0) after 1m0s
[19:58:48.052] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:68:0)
[19:58:48.052] Timer tick, asking Buildbucket for the build status
[19:58:48.232] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:58:48.232] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:69:0) after 1m0s
[19:59:48.329] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:69:0)
[19:59:48.329] Timer tick, asking Buildbucket for the build status
[19:59:48.565] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:59:48.565] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:70:0) after 1m0s
[20:00:48.587] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:70:0)
[20:00:48.587] Timer tick, asking Buildbucket for the build status
[20:00:49.042] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:00:49.042] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:71:0) after 1m0s
[20:01:49.157] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:71:0)
[20:01:49.157] Timer tick, asking Buildbucket for the build status
[20:01:49.439] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:01:49.439] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:72:0) after 1m0s
[20:02:49.568] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:72:0)
[20:02:49.568] Timer tick, asking Buildbucket for the build status
[20:02:49.774] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:02:49.774] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:73:0) after 1m0s
[20:03:49.849] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:73:0)
[20:03:49.849] Timer tick, asking Buildbucket for the build status
[20:03:50.062] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:03:50.062] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:74:0) after 1m0s
[20:04:50.156] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:74:0)
[20:04:50.156] Timer tick, asking Buildbucket for the build status
[20:04:50.487] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:04:50.487] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:75:0) after 1m0s
[20:05:50.548] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:75:0)
[20:05:50.548] Timer tick, asking Buildbucket for the build status
[20:05:50.795] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:05:50.795] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:76:0) after 1m0s
[20:06:50.835] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:76:0)
[20:06:50.835] Timer tick, asking Buildbucket for the build status
[20:06:51.035] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:06:51.035] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:77:0) after 1m0s
[20:07:51.146] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:77:0)
[20:07:51.146] Timer tick, asking Buildbucket for the build status
[20:07:51.387] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:07:51.387] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:78:0) after 1m0s
[20:08:51.433] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:78:0)
[20:08:51.433] Timer tick, asking Buildbucket for the build status
[20:08:51.647] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:08:51.647] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:79:0) after 1m0s
[20:09:51.667] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:79:0)
[20:09:51.667] Timer tick, asking Buildbucket for the build status
[20:09:51.893] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:09:51.893] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:80:0) after 1m0s
[20:10:51.949] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:80:0)
[20:10:51.949] Timer tick, asking Buildbucket for the build status
[20:10:52.251] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:10:52.251] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:81:0) after 1m0s
[20:11:52.382] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:81:0)
[20:11:52.382] Timer tick, asking Buildbucket for the build status
[20:11:52.472] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:11:52.472] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:82:0) after 1m0s
[20:12:52.586] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:82:0)
[20:12:52.586] Timer tick, asking Buildbucket for the build status
[20:12:52.711] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:12:52.711] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:83:0) after 1m0s
[20:13:52.743] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:83:0)
[20:13:52.743] Timer tick, asking Buildbucket for the build status
[20:13:52.970] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:13:52.970] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:84:0) after 1m0s
[20:14:53.065] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:84:0)
[20:14:53.065] Timer tick, asking Buildbucket for the build status
[20:14:53.250] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:14:53.250] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:85:0) after 1m0s
[20:15:53.333] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:85:0)
[20:15:53.333] Timer tick, asking Buildbucket for the build status
[20:15:53.702] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:15:53.702] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:86:0) after 1m0s
[20:16:53.743] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:86:0)
[20:16:53.743] Timer tick, asking Buildbucket for the build status
[20:16:53.999] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:16:53.999] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:87:0) after 1m0s
[20:17:54.024] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:87:0)
[20:17:54.024] Timer tick, asking Buildbucket for the build status
[20:17:54.297] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:17:54.297] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:88:0) after 1m0s
[20:18:54.342] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:88:0)
[20:18:54.342] Timer tick, asking Buildbucket for the build status
[20:18:54.629] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:18:54.629] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:89:0) after 1m0s
[20:19:54.743] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:89:0)
[20:19:54.743] Timer tick, asking Buildbucket for the build status
[20:19:55.035] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:19:55.035] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:90:0) after 1m0s
[20:20:55.132] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:90:0)
[20:20:55.132] Timer tick, asking Buildbucket for the build status
[20:20:55.344] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:20:55.344] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:91:0) after 1m0s
[20:21:55.448] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:91:0)
[20:21:55.448] Timer tick, asking Buildbucket for the build status
[20:21:55.647] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:21:55.647] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:92:0) after 1m0s
[20:22:55.753] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:92:0)
[20:22:55.753] Timer tick, asking Buildbucket for the build status
[20:22:55.965] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:22:55.965] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:93:0) after 1m0s
[20:23:56.037] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:93:0)
[20:23:56.037] Timer tick, asking Buildbucket for the build status
[20:23:56.242] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:23:56.242] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:94:0) after 1m0s
[20:24:56.351] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:94:0)
[20:24:56.351] Timer tick, asking Buildbucket for the build status
[20:24:56.681] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:24:56.681] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:95:0) after 1m0s
[20:25:56.737] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:95:0)
[20:25:56.737] Timer tick, asking Buildbucket for the build status
[20:25:59.061] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:25:59.061] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:96:0) after 1m0s
[20:26:59.132] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:96:0)
[20:26:59.132] Timer tick, asking Buildbucket for the build status
[20:27:01.563] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:27:01.563] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:97:0) after 1m0s
[20:28:01.632] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:97:0)
[20:28:01.632] Timer tick, asking Buildbucket for the build status
[20:28:01.922] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:28:01.922] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:98:0) after 1m0s
[20:29:02.037] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:98:0)
[20:29:02.037] Timer tick, asking Buildbucket for the build status
[20:29:02.342] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:29:02.342] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:99:0) after 1m0s
[20:30:02.434] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:99:0)
[20:30:02.434] Timer tick, asking Buildbucket for the build status
[20:30:05.951] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:30:05.951] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:100:0) after 1m0s
[20:31:06.032] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:100:0)
[20:31:06.032] Timer tick, asking Buildbucket for the build status
[20:31:06.374] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:31:06.374] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:101:0) after 1m0s
[20:32:06.406] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:101:0)
[20:32:06.406] Timer tick, asking Buildbucket for the build status
[20:32:06.733] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:32:06.733] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:102:0) after 1m0s
[20:33:06.835] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:102:0)
[20:33:06.835] Timer tick, asking Buildbucket for the build status
[20:33:07.082] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:33:07.082] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:103:0) after 1m0s
[20:34:07.128] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:103:0)
[20:34:07.128] Timer tick, asking Buildbucket for the build status
[20:34:07.225] Build 8856926748733358752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:34:07.225] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:104:0) after 1m0s
[20:34:27.338] Received PubSub notification, asking Buildbucket for the build status
[20:34:27.458] Build 8856926748733358752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:07.356] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:104:0)
[20:35:07.356] Timer tick, asking Buildbucket for the build status
[20:35:07.549] Build 8856926748733358752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:07.549] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:106:0) after 1m0s
[20:36:07.652] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:106:0)
[20:36:07.652] Timer tick, asking Buildbucket for the build status
[20:36:08.073] Build 8856926748733358752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:08.073] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:107:0) after 1m0s
[20:37:08.110] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:107:0)
[20:37:08.110] Timer tick, asking Buildbucket for the build status
[20:37:08.285] Build 8856926748733358752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:08.285] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:108:0) after 1m0s
[20:38:08.311] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:108:0)
[20:38:08.311] Timer tick, asking Buildbucket for the build status
[20:38:08.508] Build 8856926748733358752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:08.508] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:109:0) after 1m0s
[20:39:08.538] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:109:0)
[20:39:08.538] Timer tick, asking Buildbucket for the build status
[20:39:08.759] Build 8856926748733358752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:08.759] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:110:0) after 1m0s
[20:40:08.835] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:110:0)
[20:40:08.835] Timer tick, asking Buildbucket for the build status
[20:40:09.100] Build 8856926748733358752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:09.100] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:111:0) after 1m0s
[20:41:09.133] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:111:0)
[20:41:09.133] Timer tick, asking Buildbucket for the build status
[20:41:09.381] Build 8856926748733358752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:09.381] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:112:0) after 1m0s
[20:42:09.450] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:112:0)
[20:42:09.450] Timer tick, asking Buildbucket for the build status
[20:42:09.630] Build 8856926748733358752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:09.630] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:113:0) after 1m0s
[20:43:09.655] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:113:0)
[20:43:09.655] Timer tick, asking Buildbucket for the build status
[20:43:09.882] Build 8856926748733358752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:09.882] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:114:0) after 1m0s
[20:44:09.952] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:114:0)
[20:44:09.952] Timer tick, asking Buildbucket for the build status
[20:44:10.220] Build 8856926748733358752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:10.220] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:115:0) after 1m0s
[20:45:10.253] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:115:0)
[20:45:10.253] Timer tick, asking Buildbucket for the build status
[20:45:10.502] Build 8856926748733358752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:10.502] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:116:0) after 1m0s
[20:46:10.546] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:116:0)
[20:46:10.546] Timer tick, asking Buildbucket for the build status
[20:46:10.754] Build 8856926748733358752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:10.754] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9022356810794531024:117:0) after 1m0s
[20:46:50.799] Received PubSub notification, asking Buildbucket for the build status
[20:46:50.951] Build 8856926748733358752: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:46:50.951] Buildbucket build:
{
"build": {
"bucket": "luci.infra.ci",
"canary_preference": "PROD",
"completed_ts": "1611780407225243",
"created_by": "project:infra",
"created_ts": "1611773459649176",
"id": "8856926748733358752",
"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\": \"c76c18519c1ae07f9c479cad6561220a65ed2eb6\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@c76c18519c1ae07f9c479cad6561220a65ed2eb6\", \"title\": \"c76c18519c1ae07f9c479cad6561220a65ed2eb6\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/c76c18519c1ae07f9c479cad6561220a65ed2eb6\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"c76c18519c1ae07f9c479cad6561220a65ed2eb6\"}}",
"project": "infra",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"got_revision\": \"c76c18519c1ae07f9c479cad6561220a65ed2eb6\", \"got_revision_cp\": \"refs/heads/master@{#37963}\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_044445a3bc7a4bfe795493d7956aa02cd526172de1fa7300f69fe152e82ea631_v2\", \"builder_d38bdc976f893fc6930479dce8a6d7dc793b2a74fe1392d4af00713a5c0bb46e_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-eclh\"], \"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\": [\"5672-4713de1\"], \"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": "1611779663927675",
"status": "COMPLETED",
"status_changed_ts": "1611780408560840",
"tags": [
"build_address:luci.infra.ci/infra-continuous-win10-64/18445",
"builder:infra-continuous-win10-64",
"buildset:commit/git/c76c18519c1ae07f9c479cad6561220a65ed2eb6",
"buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/c76c18519c1ae07f9c479cad6561220a65ed2eb6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022356810794531024",
"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/8856926748733358752/+/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:515e00d0a62c2210",
"user_agent:luci-scheduler-dev"
],
"updated_ts": "1611780408575392",
"url": "https://luci-milo-dev.appspot.com/b/8856926748733358752",
"utcnow_ts": "1611780410943647"
}
}
[20:46:50.951] Invocation finished in 1h55m52.651605021s with status SUCCEEDED