[22:24:52.151] New invocation is queued and will start shortly
[22:24:53.220] Starting the invocation (attempt 1)
[22:24:53.256] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[22:24:53.256] PubSub topic is "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
[22:24:53.256] Buildbucket request:
{
"bucket": "luci.infra.ci",
"client_operation_id": "9021346786915928656",
"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\":\"07f869cc9dd7b83e15ff008527e4e2c5cd8a24b1\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@07f869cc9dd7b83e15ff008527e4e2c5cd8a24b1\",\"title\":\"07f869cc9dd7b83e15ff008527e4e2c5cd8a24b1\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/07f869cc9dd7b83e15ff008527e4e2c5cd8a24b1\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"07f869cc9dd7b83e15ff008527e4e2c5cd8a24b1\"}}",
"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:9021346786915928656",
"scheduler_job_id:infra/infra-continuous-win10-64",
"user_agent:luci-scheduler-dev",
"buildset:commit/git/07f869cc9dd7b83e15ff008527e4e2c5cd8a24b1",
"buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/07f869cc9dd7b83e15ff008527e4e2c5cd8a24b1",
"gitiles_ref:refs/heads/master"
]
}
[22:24:53.865] Buildbucket response:
{
"build": {
"bucket": "luci.infra.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:infra",
"created_ts": "1612736693333242",
"id": "8855916725010206752",
"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\": \"07f869cc9dd7b83e15ff008527e4e2c5cd8a24b1\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@07f869cc9dd7b83e15ff008527e4e2c5cd8a24b1\", \"title\": \"07f869cc9dd7b83e15ff008527e4e2c5cd8a24b1\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/07f869cc9dd7b83e15ff008527e4e2c5cd8a24b1\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"07f869cc9dd7b83e15ff008527e4e2c5cd8a24b1\"}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "adhoc-testing@luci-token-server-dev.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612736693779890",
"tags": [
"build_address:luci.infra.ci/infra-continuous-win10-64/18546",
"builder:infra-continuous-win10-64",
"buildset:commit/git/07f869cc9dd7b83e15ff008527e4e2c5cd8a24b1",
"buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/07f869cc9dd7b83e15ff008527e4e2c5cd8a24b1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021346786915928656",
"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/8855916725010206752/+/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": "1612736693779998",
"url": "https://luci-milo-dev.appspot.com/b/8855916725010206752",
"utcnow_ts": "1612736693858927"
}
}
[22:24:53.865] Task URL: https://luci-milo-dev.appspot.com/b/8855916725010206752
[22:24:53.865] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:2:0) after 1m0s
[22:25:53.889] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:2:0)
[22:25:53.889] Timer tick, asking Buildbucket for the build status
[22:25:53.962] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:25:53.962] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:3:0) after 1m0s
[22:26:53.983] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:3:0)
[22:26:53.983] Timer tick, asking Buildbucket for the build status
[22:26:54.071] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:26:54.071] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:4:0) after 1m0s
[22:27:54.176] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:4:0)
[22:27:54.176] Timer tick, asking Buildbucket for the build status
[22:27:54.265] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:27:54.265] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:5:0) after 1m0s
[22:28:54.297] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:5:0)
[22:28:54.297] Timer tick, asking Buildbucket for the build status
[22:28:54.414] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:28:54.414] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:6:0) after 1m0s
[22:29:54.482] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:6:0)
[22:29:54.482] Timer tick, asking Buildbucket for the build status
[22:29:56.086] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:29:56.086] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:7:0) after 1m0s
[22:30:56.175] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:7:0)
[22:30:56.175] Timer tick, asking Buildbucket for the build status
[22:30:56.263] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:30:56.263] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:8:0) after 1m0s
[22:31:56.278] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:8:0)
[22:31:56.278] Timer tick, asking Buildbucket for the build status
[22:31:56.398] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:31:56.398] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:9:0) after 1m0s
[22:32:56.486] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:9:0)
[22:32:56.486] Timer tick, asking Buildbucket for the build status
[22:32:56.584] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:32:56.584] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:10:0) after 1m0s
[22:33:56.692] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:10:0)
[22:33:56.692] Timer tick, asking Buildbucket for the build status
[22:33:56.766] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:33:56.766] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:11:0) after 1m0s
[22:34:56.813] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:11:0)
[22:34:56.813] Timer tick, asking Buildbucket for the build status
[22:34:56.894] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:34:56.894] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:12:0) after 1m0s
[22:35:56.975] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:12:0)
[22:35:56.975] Timer tick, asking Buildbucket for the build status
[22:35:57.059] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:35:57.059] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:13:0) after 1m0s
[22:36:57.077] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:13:0)
[22:36:57.078] Timer tick, asking Buildbucket for the build status
[22:36:57.147] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:36:57.147] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:14:0) after 1m0s
[22:37:57.167] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:14:0)
[22:37:57.167] Timer tick, asking Buildbucket for the build status
[22:37:57.240] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:37:57.240] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:15:0) after 1m0s
[22:38:57.276] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:15:0)
[22:38:57.276] Timer tick, asking Buildbucket for the build status
[22:38:57.355] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:38:57.355] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:16:0) after 1m0s
[22:39:57.369] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:16:0)
[22:39:57.369] Timer tick, asking Buildbucket for the build status
[22:39:57.480] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:39:57.480] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:17:0) after 1m0s
[22:40:57.584] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:17:0)
[22:40:57.584] Timer tick, asking Buildbucket for the build status
[22:40:57.663] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:40:57.663] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:18:0) after 1m0s
[22:41:57.695] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:18:0)
[22:41:57.695] Timer tick, asking Buildbucket for the build status
[22:41:57.773] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:41:57.773] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:19:0) after 1m0s
[22:42:57.793] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:19:0)
[22:42:57.793] Timer tick, asking Buildbucket for the build status
[22:42:57.878] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:42:57.878] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:20:0) after 1m0s
[22:43:57.985] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:20:0)
[22:43:57.985] Timer tick, asking Buildbucket for the build status
[22:43:58.056] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:43:58.056] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:21:0) after 1m0s
[22:44:58.083] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:21:0)
[22:44:58.083] Timer tick, asking Buildbucket for the build status
[22:44:58.162] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:44:58.162] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:22:0) after 1m0s
[22:45:58.184] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:22:0)
[22:45:58.184] Timer tick, asking Buildbucket for the build status
[22:45:58.261] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:45:58.261] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:23:0) after 1m0s
[22:46:58.300] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:23:0)
[22:46:58.300] Timer tick, asking Buildbucket for the build status
[22:46:58.393] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:46:58.393] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:24:0) after 1m0s
[22:47:58.475] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:24:0)
[22:47:58.475] Timer tick, asking Buildbucket for the build status
[22:47:58.540] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:47:58.540] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:25:0) after 1m0s
[22:48:58.596] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:25:0)
[22:48:58.596] Timer tick, asking Buildbucket for the build status
[22:48:58.672] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:48:58.672] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:26:0) after 1m0s
[22:49:58.702] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:26:0)
[22:49:58.702] Timer tick, asking Buildbucket for the build status
[22:49:58.784] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:49:58.784] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:27:0) after 1m0s
[22:50:58.901] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:27:0)
[22:50:58.901] Timer tick, asking Buildbucket for the build status
[22:50:58.998] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:50:58.998] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:28:0) after 1m0s
[22:51:59.084] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:28:0)
[22:51:59.084] Timer tick, asking Buildbucket for the build status
[22:51:59.191] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:51:59.191] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:29:0) after 1m0s
[22:52:59.285] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:29:0)
[22:52:59.285] Timer tick, asking Buildbucket for the build status
[22:52:59.349] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:52:59.349] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:30:0) after 1m0s
[22:53:59.386] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:30:0)
[22:53:59.386] Timer tick, asking Buildbucket for the build status
[22:53:59.467] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:53:59.467] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:31:0) after 1m0s
[22:54:59.576] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:31:0)
[22:54:59.576] Timer tick, asking Buildbucket for the build status
[22:54:59.678] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:54:59.678] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:32:0) after 1m0s
[22:55:59.787] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:32:0)
[22:55:59.787] Timer tick, asking Buildbucket for the build status
[22:55:59.859] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:55:59.859] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:33:0) after 1m0s
[22:56:59.898] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:33:0)
[22:56:59.898] Timer tick, asking Buildbucket for the build status
[22:56:59.969] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:56:59.969] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:34:0) after 1m0s
[22:58:00.085] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:34:0)
[22:58:00.085] Timer tick, asking Buildbucket for the build status
[22:58:00.170] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:58:00.170] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:35:0) after 1m0s
[22:59:00.201] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:35:0)
[22:59:00.201] Timer tick, asking Buildbucket for the build status
[22:59:00.279] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:59:00.279] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:36:0) after 1m0s
[23:00:00.377] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:36:0)
[23:00:00.377] Timer tick, asking Buildbucket for the build status
[23:00:00.540] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:00:00.540] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:37:0) after 1m0s
[23:01:00.584] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:37:0)
[23:01:00.584] Timer tick, asking Buildbucket for the build status
[23:01:00.667] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:01:00.667] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:38:0) after 1m0s
[23:02:00.701] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:38:0)
[23:02:00.701] Timer tick, asking Buildbucket for the build status
[23:02:00.785] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:02:00.785] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:39:0) after 1m0s
[23:03:00.808] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:39:0)
[23:03:00.808] Timer tick, asking Buildbucket for the build status
[23:03:00.887] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:03:00.887] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:40:0) after 1m0s
[23:04:00.947] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:40:0)
[23:04:00.947] Timer tick, asking Buildbucket for the build status
[23:04:01.062] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:04:01.062] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:41:0) after 1m0s
[23:05:01.085] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:41:0)
[23:05:01.085] Timer tick, asking Buildbucket for the build status
[23:05:01.165] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:05:01.165] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:42:0) after 1m0s
[23:06:01.189] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:42:0)
[23:06:01.189] Timer tick, asking Buildbucket for the build status
[23:06:01.281] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:06:01.281] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:43:0) after 1m0s
[23:07:01.306] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:43:0)
[23:07:01.306] Timer tick, asking Buildbucket for the build status
[23:07:01.388] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:07:01.388] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:44:0) after 1m0s
[23:08:01.494] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:44:0)
[23:08:01.494] Timer tick, asking Buildbucket for the build status
[23:08:01.589] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:08:01.589] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:45:0) after 1m0s
[23:09:01.699] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:45:0)
[23:09:01.699] Timer tick, asking Buildbucket for the build status
[23:09:01.771] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:09:01.771] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:46:0) after 1m0s
[23:10:01.886] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:46:0)
[23:10:01.886] Timer tick, asking Buildbucket for the build status
[23:10:01.964] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:10:01.964] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:47:0) after 1m0s
[23:11:01.982] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:47:0)
[23:11:01.982] Timer tick, asking Buildbucket for the build status
[23:11:02.058] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:11:02.058] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:48:0) after 1m0s
[23:12:02.086] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:48:0)
[23:12:02.086] Timer tick, asking Buildbucket for the build status
[23:12:02.172] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:12:02.172] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:49:0) after 1m0s
[23:13:02.286] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:49:0)
[23:13:02.286] Timer tick, asking Buildbucket for the build status
[23:13:02.353] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:13:02.353] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:50:0) after 1m0s
[23:14:02.389] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:50:0)
[23:14:02.389] Timer tick, asking Buildbucket for the build status
[23:14:02.483] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:14:02.483] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:51:0) after 1m0s
[23:15:02.502] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:51:0)
[23:15:02.502] Timer tick, asking Buildbucket for the build status
[23:15:02.593] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:15:02.593] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:52:0) after 1m0s
[23:16:02.676] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:52:0)
[23:16:02.676] Timer tick, asking Buildbucket for the build status
[23:16:02.939] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:16:02.939] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:53:0) after 1m0s
[23:17:02.999] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:53:0)
[23:17:02.999] Timer tick, asking Buildbucket for the build status
[23:17:03.099] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:17:03.099] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:54:0) after 1m0s
[23:18:03.188] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:54:0)
[23:18:03.188] Timer tick, asking Buildbucket for the build status
[23:18:03.290] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:18:03.290] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:55:0) after 1m0s
[23:19:03.384] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:55:0)
[23:19:03.384] Timer tick, asking Buildbucket for the build status
[23:19:03.507] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:19:03.507] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:56:0) after 1m0s
[23:20:03.616] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:56:0)
[23:20:03.616] Timer tick, asking Buildbucket for the build status
[23:20:03.786] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:20:03.786] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:57:0) after 1m0s
[23:21:03.876] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:57:0)
[23:21:03.876] Timer tick, asking Buildbucket for the build status
[23:21:03.966] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:21:03.966] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:58:0) after 1m0s
[23:22:03.987] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:58:0)
[23:22:03.987] Timer tick, asking Buildbucket for the build status
[23:22:04.090] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:22:04.090] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:59:0) after 1m0s
[23:23:04.197] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:59:0)
[23:23:04.197] Timer tick, asking Buildbucket for the build status
[23:23:04.271] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:23:04.271] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:60:0) after 1m0s
[23:24:04.376] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:60:0)
[23:24:04.376] Timer tick, asking Buildbucket for the build status
[23:24:04.490] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:24:04.490] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:61:0) after 1m0s
[23:25:04.511] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:61:0)
[23:25:04.511] Timer tick, asking Buildbucket for the build status
[23:25:04.608] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:25:04.608] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:62:0) after 1m0s
[23:26:04.633] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:62:0)
[23:26:04.633] Timer tick, asking Buildbucket for the build status
[23:26:04.702] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:26:04.702] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:63:0) after 1m0s
[23:27:04.777] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:63:0)
[23:27:04.777] Timer tick, asking Buildbucket for the build status
[23:27:04.848] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:27:04.848] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:64:0) after 1m0s
[23:28:04.897] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:64:0)
[23:28:04.897] Timer tick, asking Buildbucket for the build status
[23:28:04.982] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:28:04.982] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:65:0) after 1m0s
[23:29:05.089] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:65:0)
[23:29:05.089] Timer tick, asking Buildbucket for the build status
[23:29:05.172] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:29:05.172] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:66:0) after 1m0s
[23:30:05.277] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:66:0)
[23:30:05.277] Timer tick, asking Buildbucket for the build status
[23:30:05.359] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:30:05.359] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:67:0) after 1m0s
[23:31:05.384] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:67:0)
[23:31:05.384] Timer tick, asking Buildbucket for the build status
[23:31:05.492] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:31:05.492] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:68:0) after 1m0s
[23:32:05.590] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:68:0)
[23:32:05.590] Timer tick, asking Buildbucket for the build status
[23:32:05.676] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:32:05.676] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:69:0) after 1m0s
[23:33:05.806] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:69:0)
[23:33:05.806] Timer tick, asking Buildbucket for the build status
[23:33:05.888] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:33:05.888] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:70:0) after 1m0s
[23:34:05.984] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:70:0)
[23:34:05.984] Timer tick, asking Buildbucket for the build status
[23:34:06.099] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:34:06.099] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:71:0) after 1m0s
[23:35:06.200] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:71:0)
[23:35:06.200] Timer tick, asking Buildbucket for the build status
[23:35:06.280] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:35:06.280] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:72:0) after 1m0s
[23:36:06.301] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:72:0)
[23:36:06.301] Timer tick, asking Buildbucket for the build status
[23:36:06.374] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:36:06.374] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:73:0) after 1m0s
[23:37:06.406] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:73:0)
[23:37:06.406] Timer tick, asking Buildbucket for the build status
[23:37:06.487] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:37:06.487] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:74:0) after 1m0s
[23:38:06.531] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:74:0)
[23:38:06.531] Timer tick, asking Buildbucket for the build status
[23:38:06.613] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:38:06.613] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:75:0) after 1m0s
[23:39:06.702] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:75:0)
[23:39:06.702] Timer tick, asking Buildbucket for the build status
[23:39:06.785] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:39:06.785] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:76:0) after 1m0s
[23:40:06.877] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:76:0)
[23:40:06.877] Timer tick, asking Buildbucket for the build status
[23:40:06.955] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:40:06.955] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:77:0) after 1m0s
[23:41:06.988] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:77:0)
[23:41:06.988] Timer tick, asking Buildbucket for the build status
[23:41:07.135] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:41:07.135] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:78:0) after 1m0s
[23:42:07.188] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:78:0)
[23:42:07.188] Timer tick, asking Buildbucket for the build status
[23:42:07.268] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:42:07.268] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:79:0) after 1m0s
[23:43:07.298] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:79:0)
[23:43:07.298] Timer tick, asking Buildbucket for the build status
[23:43:07.374] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:43:07.374] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:80:0) after 1m0s
[23:44:07.492] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:80:0)
[23:44:07.492] Timer tick, asking Buildbucket for the build status
[23:44:07.568] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:44:07.568] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:81:0) after 1m0s
[23:45:07.675] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:81:0)
[23:45:07.675] Timer tick, asking Buildbucket for the build status
[23:45:07.781] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:45:07.781] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:82:0) after 1m0s
[23:46:07.886] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:82:0)
[23:46:07.886] Timer tick, asking Buildbucket for the build status
[23:46:07.979] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:46:07.979] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:83:0) after 1m0s
[23:47:08.089] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:83:0)
[23:47:08.089] Timer tick, asking Buildbucket for the build status
[23:47:08.156] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:47:08.156] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:84:0) after 1m0s
[23:48:08.186] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:84:0)
[23:48:08.186] Timer tick, asking Buildbucket for the build status
[23:48:08.259] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:48:08.259] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:85:0) after 1m0s
[23:49:08.292] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:85:0)
[23:49:08.292] Timer tick, asking Buildbucket for the build status
[23:49:08.377] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:49:08.377] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:86:0) after 1m0s
[23:50:08.485] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:86:0)
[23:50:08.485] Timer tick, asking Buildbucket for the build status
[23:50:08.555] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:50:08.555] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:87:0) after 1m0s
[23:51:08.588] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:87:0)
[23:51:08.588] Timer tick, asking Buildbucket for the build status
[23:51:08.678] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:51:08.678] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:88:0) after 1m0s
[23:52:08.796] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:88:0)
[23:52:08.796] Timer tick, asking Buildbucket for the build status
[23:52:08.862] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:52:08.862] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:89:0) after 1m0s
[23:53:08.918] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:89:0)
[23:53:08.919] Timer tick, asking Buildbucket for the build status
[23:53:08.991] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:53:08.991] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:90:0) after 1m0s
[23:54:09.088] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:90:0)
[23:54:09.088] Timer tick, asking Buildbucket for the build status
[23:54:09.193] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:54:09.193] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:91:0) after 1m0s
[23:55:09.290] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:91:0)
[23:55:09.290] Timer tick, asking Buildbucket for the build status
[23:55:09.383] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:55:09.383] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:92:0) after 1m0s
[23:56:09.488] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:92:0)
[23:56:09.488] Timer tick, asking Buildbucket for the build status
[23:56:09.570] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:56:09.570] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:93:0) after 1m0s
[23:57:09.601] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:93:0)
[23:57:09.601] Timer tick, asking Buildbucket for the build status
[23:57:09.668] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:57:09.668] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:94:0) after 1m0s
[23:58:09.718] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:94:0)
[23:58:09.718] Timer tick, asking Buildbucket for the build status
[23:58:09.805] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:58:09.805] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:95:0) after 1m0s
[23:59:09.888] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:95:0)
[23:59:09.888] Timer tick, asking Buildbucket for the build status
[23:59:09.959] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:59:09.959] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:96:0) after 1m0s
[00:00:09.989] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:96:0)
[00:00:09.989] Timer tick, asking Buildbucket for the build status
[00:00:10.071] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:00:10.071] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:97:0) after 1m0s
[00:01:10.112] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:97:0)
[00:01:10.112] Timer tick, asking Buildbucket for the build status
[00:01:10.187] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:01:10.187] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:98:0) after 1m0s
[00:02:10.215] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:98:0)
[00:02:10.215] Timer tick, asking Buildbucket for the build status
[00:02:10.294] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:02:10.294] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:99:0) after 1m0s
[00:03:10.390] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:99:0)
[00:03:10.390] Timer tick, asking Buildbucket for the build status
[00:03:10.486] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:03:10.486] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:100:0) after 1m0s
[00:04:10.587] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:100:0)
[00:04:10.587] Timer tick, asking Buildbucket for the build status
[00:04:10.653] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:04:10.653] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:101:0) after 1m0s
[00:05:10.677] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:101:0)
[00:05:10.677] Timer tick, asking Buildbucket for the build status
[00:05:10.763] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:05:10.763] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:102:0) after 1m0s
[00:06:10.793] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:102:0)
[00:06:10.793] Timer tick, asking Buildbucket for the build status
[00:06:10.869] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:06:10.869] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:103:0) after 1m0s
[00:07:10.890] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:103:0)
[00:07:10.890] Timer tick, asking Buildbucket for the build status
[00:07:10.988] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:07:10.988] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:104:0) after 1m0s
[00:08:11.014] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:104:0)
[00:08:11.014] Timer tick, asking Buildbucket for the build status
[00:08:11.113] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:08:11.113] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:105:0) after 1m0s
[00:09:11.202] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:105:0)
[00:09:11.202] Timer tick, asking Buildbucket for the build status
[00:09:11.288] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:09:11.288] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:106:0) after 1m0s
[00:10:11.328] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:106:0)
[00:10:11.328] Timer tick, asking Buildbucket for the build status
[00:10:11.457] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:10:11.457] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:107:0) after 1m0s
[00:11:11.476] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:107:0)
[00:11:11.476] Timer tick, asking Buildbucket for the build status
[00:11:11.558] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:11:11.558] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:108:0) after 1m0s
[00:12:11.578] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:108:0)
[00:12:11.578] Timer tick, asking Buildbucket for the build status
[00:12:11.658] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:12:11.658] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:109:0) after 1m0s
[00:13:11.687] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:109:0)
[00:13:11.687] Timer tick, asking Buildbucket for the build status
[00:13:11.785] Build 8855916725010206752: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:13:11.785] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:110:0) after 1m0s
[00:13:49.586] Received PubSub notification, asking Buildbucket for the build status
[00:13:49.659] Build 8855916725010206752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:11.892] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:110:0)
[00:14:11.892] Timer tick, asking Buildbucket for the build status
[00:14:11.982] Build 8855916725010206752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:11.982] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:112:0) after 1m0s
[00:15:12.012] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:112:0)
[00:15:12.012] Timer tick, asking Buildbucket for the build status
[00:15:12.176] Build 8855916725010206752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:12.176] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:113:0) after 1m0s
[00:16:12.215] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:113:0)
[00:16:12.215] Timer tick, asking Buildbucket for the build status
[00:16:12.299] Build 8855916725010206752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:12.299] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:114:0) after 1m0s
[00:17:12.332] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:114:0)
[00:17:12.333] Timer tick, asking Buildbucket for the build status
[00:17:12.413] Build 8855916725010206752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:12.413] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:115:0) after 1m0s
[00:18:12.519] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:115:0)
[00:18:12.519] Timer tick, asking Buildbucket for the build status
[00:18:12.605] Build 8855916725010206752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:12.605] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:116:0) after 1m0s
[00:19:12.725] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:116:0)
[00:19:12.725] Timer tick, asking Buildbucket for the build status
[00:19:12.800] Build 8855916725010206752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:12.800] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:117:0) after 1m0s
[00:20:12.902] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:117:0)
[00:20:12.902] Timer tick, asking Buildbucket for the build status
[00:20:13.004] Build 8855916725010206752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:13.004] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9021346786915928656:118:0) after 1m0s
[00:20:23.788] Received PubSub notification, asking Buildbucket for the build status
[00:20:23.878] Build 8855916725010206752: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:20:23.878] Buildbucket build:
{
"build": {
"bucket": "luci.infra.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1612743619481126",
"created_by": "project:infra",
"created_ts": "1612736693333242",
"id": "8855916725010206752",
"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\": \"07f869cc9dd7b83e15ff008527e4e2c5cd8a24b1\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@07f869cc9dd7b83e15ff008527e4e2c5cd8a24b1\", \"title\": \"07f869cc9dd7b83e15ff008527e4e2c5cd8a24b1\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/07f869cc9dd7b83e15ff008527e4e2c5cd8a24b1\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"07f869cc9dd7b83e15ff008527e4e2c5cd8a24b1\"}}",
"project": "infra",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"got_revision\": \"07f869cc9dd7b83e15ff008527e4e2c5cd8a24b1\", \"got_revision_cp\": \"refs/heads/master@{#38311}\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_044445a3bc7a4bfe795493d7956aa02cd526172de1fa7300f69fe152e82ea631_v2\", \"builder_5de1032f0e9ef497433aad28840ee258c037976023b410f653133cee0ad04e2c_v2\", \"builder_82ed111fed7ea8169e482f00b5f3e5338a65daa41208585de67cb0a736b1d538_v2\", \"builder_a9c54e560aab64ffcab932ab26ad711a72ff73dbcd0bfe47f54d3e3349e5c381_v2\", \"git\", \"goma\", \"infra_gclient_with_go\", \"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-y6ah\"], \"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\": [\"5680-19e8880\"], \"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": "1612743227561166",
"status": "COMPLETED",
"status_changed_ts": "1612743228043364",
"tags": [
"build_address:luci.infra.ci/infra-continuous-win10-64/18546",
"builder:infra-continuous-win10-64",
"buildset:commit/git/07f869cc9dd7b83e15ff008527e4e2c5cd8a24b1",
"buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/07f869cc9dd7b83e15ff008527e4e2c5cd8a24b1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021346786915928656",
"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/8855916725010206752/+/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:51976a8ec9476510",
"user_agent:luci-scheduler-dev"
],
"updated_ts": "1612743619535741",
"url": "https://luci-milo-dev.appspot.com/b/8855916725010206752",
"utcnow_ts": "1612743623868508"
}
}
[00:20:23.878] Invocation finished in 1h55m31.745796426s with status SUCCEEDED