[18:16:32.177] New invocation is queued and will start shortly
[18:16:33.236] Starting the invocation (attempt 1)
[18:16:33.269] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[18:16:33.269] PubSub topic is "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
[18:16:33.270] Buildbucket request:
{
"bucket": "luci.v8.ci",
"client_operation_id": "9018916292573431568",
"parameters_json": "{\"builder_name\":\"V8 Win64 - dev image\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler-dev.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/v8/v8\",\"revision\":\"cde30ece0e9424aed22bb77985c5bfc4d4d2a01a\"},\"id\":\"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@cde30ece0e9424aed22bb77985c5bfc4d4d2a01a\",\"title\":\"cde30ece0e9424aed22bb77985c5bfc4d4d2a01a\",\"url\":\"https://chromium.googlesource.com/v8/v8/+/cde30ece0e9424aed22bb77985c5bfc4d4d2a01a\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/v8/v8\",\"revision\":\"cde30ece0e9424aed22bb77985c5bfc4d4d2a01a\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
},
"tags": [
"builder:V8 Win64 - dev image",
"scheduler_invocation_id:9018916292573431568",
"scheduler_job_id:v8/V8 Win64 - dev image",
"user_agent:luci-scheduler-dev",
"buildset:commit/git/cde30ece0e9424aed22bb77985c5bfc4d4d2a01a",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/cde30ece0e9424aed22bb77985c5bfc4d4d2a01a",
"gitiles_ref:refs/heads/master"
]
}
[18:16:33.899] Buildbucket response:
{
"build": {
"bucket": "luci.v8.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:v8",
"created_ts": "1615054593350754",
"id": "8853486230681710416",
"parameters_json": "{\"builder_name\": \"V8 Win64 - dev image\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler-dev.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"cde30ece0e9424aed22bb77985c5bfc4d4d2a01a\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@cde30ece0e9424aed22bb77985c5bfc4d4d2a01a\", \"title\": \"cde30ece0e9424aed22bb77985c5bfc4d4d2a01a\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/cde30ece0e9424aed22bb77985c5bfc4d4d2a01a\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"cde30ece0e9424aed22bb77985c5bfc4d4d2a01a\"}}",
"project": "v8",
"result_details_json": "{\"properties\": {}}",
"service_account": "v8-ci-builder-dev@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615054593789983",
"tags": [
"build_address:luci.v8.ci/V8 Win64 - dev image/685",
"builder:V8 Win64 - dev image",
"buildset:commit/git/cde30ece0e9424aed22bb77985c5bfc4d4d2a01a",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/cde30ece0e9424aed22bb77985c5bfc4d4d2a01a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018916292573431568",
"scheduler_job_id:v8/V8 Win64 - dev image",
"swarming_hostname:chromium-swarm-dev.appspot.com",
"swarming_tag:log_location:logdog://luci-logdog-dev.appspot.com/v8/buildbucket/cr-buildbucket-dev.appspot.com/8853486230681710416/+/annotations",
"swarming_tag:luci_project:v8",
"swarming_tag:recipe_name:v8",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler-dev"
],
"updated_ts": "1615054593790090",
"url": "https://luci-milo-dev.appspot.com/b/8853486230681710416",
"utcnow_ts": "1615054593889374"
}
}
[18:16:33.899] Task URL: https://luci-milo-dev.appspot.com/b/8853486230681710416
[18:16:33.899] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:2:0) after 1m0s
[18:17:33.960] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:2:0)
[18:17:33.960] Timer tick, asking Buildbucket for the build status
[18:17:34.044] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:17:34.044] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:3:0) after 1m0s
[18:18:34.119] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:3:0)
[18:18:34.119] Timer tick, asking Buildbucket for the build status
[18:18:34.192] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:18:34.192] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:4:0) after 1m0s
[18:19:34.231] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:4:0)
[18:19:34.231] Timer tick, asking Buildbucket for the build status
[18:19:34.318] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:19:34.318] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:5:0) after 1m0s
[18:20:34.336] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:5:0)
[18:20:34.336] Timer tick, asking Buildbucket for the build status
[18:20:34.496] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:20:34.496] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:6:0) after 1m0s
[18:21:34.524] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:6:0)
[18:21:34.524] Timer tick, asking Buildbucket for the build status
[18:21:34.609] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:21:34.609] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:7:0) after 1m0s
[18:22:34.629] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:7:0)
[18:22:34.629] Timer tick, asking Buildbucket for the build status
[18:22:34.702] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:22:34.702] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:8:0) after 1m0s
[18:23:34.720] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:8:0)
[18:23:34.720] Timer tick, asking Buildbucket for the build status
[18:23:34.792] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:23:34.792] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:9:0) after 1m0s
[18:24:34.811] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:9:0)
[18:24:34.811] Timer tick, asking Buildbucket for the build status
[18:24:34.905] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:24:34.905] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:10:0) after 1m0s
[18:25:34.928] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:10:0)
[18:25:34.928] Timer tick, asking Buildbucket for the build status
[18:25:35.012] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:25:35.012] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:11:0) after 1m0s
[18:26:35.031] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:11:0)
[18:26:35.031] Timer tick, asking Buildbucket for the build status
[18:26:35.098] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:26:35.098] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:12:0) after 1m0s
[18:27:35.123] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:12:0)
[18:27:35.123] Timer tick, asking Buildbucket for the build status
[18:27:35.226] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:27:35.226] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:13:0) after 1m0s
[18:28:35.244] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:13:0)
[18:28:35.244] Timer tick, asking Buildbucket for the build status
[18:28:35.327] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:28:35.327] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:14:0) after 1m0s
[18:29:35.407] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:14:0)
[18:29:35.407] Timer tick, asking Buildbucket for the build status
[18:29:35.480] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:29:35.480] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:15:0) after 1m0s
[18:30:35.529] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:15:0)
[18:30:35.529] Timer tick, asking Buildbucket for the build status
[18:30:35.613] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:30:35.613] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:16:0) after 1m0s
[18:31:35.685] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:16:0)
[18:31:35.685] Timer tick, asking Buildbucket for the build status
[18:31:35.753] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:31:35.753] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:17:0) after 1m0s
[18:32:35.865] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:17:0)
[18:32:35.865] Timer tick, asking Buildbucket for the build status
[18:32:35.945] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:32:35.945] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:18:0) after 1m0s
[18:33:36.075] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:18:0)
[18:33:36.075] Timer tick, asking Buildbucket for the build status
[18:33:36.204] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:33:36.204] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:19:0) after 1m0s
[18:34:36.247] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:19:0)
[18:34:36.247] Timer tick, asking Buildbucket for the build status
[18:34:36.406] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:34:36.406] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:20:0) after 1m0s
[18:35:36.446] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:20:0)
[18:35:36.446] Timer tick, asking Buildbucket for the build status
[18:35:36.593] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:35:36.593] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:21:0) after 1m0s
[18:36:36.634] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:21:0)
[18:36:36.634] Timer tick, asking Buildbucket for the build status
[18:36:36.730] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:36:36.730] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:22:0) after 1m0s
[18:37:36.761] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:22:0)
[18:37:36.761] Timer tick, asking Buildbucket for the build status
[18:37:36.870] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:37:36.870] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:23:0) after 1m0s
[18:38:36.928] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:23:0)
[18:38:36.928] Timer tick, asking Buildbucket for the build status
[18:38:37.054] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:38:37.054] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:24:0) after 1m0s
[18:39:37.172] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:24:0)
[18:39:37.172] Timer tick, asking Buildbucket for the build status
[18:39:37.316] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:39:37.316] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:25:0) after 1m0s
[18:40:37.424] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:25:0)
[18:40:37.424] Timer tick, asking Buildbucket for the build status
[18:40:37.500] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:40:37.500] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:26:0) after 1m0s
[18:41:37.535] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:26:0)
[18:41:37.535] Timer tick, asking Buildbucket for the build status
[18:41:37.611] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:41:37.611] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:27:0) after 1m0s
[18:42:37.632] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:27:0)
[18:42:37.632] Timer tick, asking Buildbucket for the build status
[18:42:37.700] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:42:37.700] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:28:0) after 1m0s
[18:43:37.719] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:28:0)
[18:43:37.719] Timer tick, asking Buildbucket for the build status
[18:43:37.807] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:43:37.807] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:29:0) after 1m0s
[18:44:37.851] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:29:0)
[18:44:37.851] Timer tick, asking Buildbucket for the build status
[18:44:37.924] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:44:37.924] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:30:0) after 1m0s
[18:45:37.963] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:30:0)
[18:45:37.963] Timer tick, asking Buildbucket for the build status
[18:45:38.063] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:45:38.063] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:31:0) after 1m0s
[18:46:38.120] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:31:0)
[18:46:38.120] Timer tick, asking Buildbucket for the build status
[18:46:38.200] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:46:38.200] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:32:0) after 1m0s
[18:47:38.226] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:32:0)
[18:47:38.226] Timer tick, asking Buildbucket for the build status
[18:47:38.331] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:47:38.331] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:33:0) after 1m0s
[18:48:38.427] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:33:0)
[18:48:38.427] Timer tick, asking Buildbucket for the build status
[18:48:38.513] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:48:38.513] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:34:0) after 1m0s
[18:49:38.630] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:34:0)
[18:49:38.630] Timer tick, asking Buildbucket for the build status
[18:49:38.717] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:49:38.717] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:35:0) after 1m0s
[18:50:38.828] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:35:0)
[18:50:38.828] Timer tick, asking Buildbucket for the build status
[18:50:38.903] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:50:38.903] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:36:0) after 1m0s
[18:51:38.948] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:36:0)
[18:51:38.948] Timer tick, asking Buildbucket for the build status
[18:51:39.023] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:51:39.023] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:37:0) after 1m0s
[18:52:39.134] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:37:0)
[18:52:39.134] Timer tick, asking Buildbucket for the build status
[18:52:39.220] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:52:39.220] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:38:0) after 1m0s
[18:53:39.250] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:38:0)
[18:53:39.250] Timer tick, asking Buildbucket for the build status
[18:53:39.373] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:53:39.373] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:39:0) after 1m0s
[18:54:39.395] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:39:0)
[18:54:39.395] Timer tick, asking Buildbucket for the build status
[18:54:39.462] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:54:39.462] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:40:0) after 1m0s
[18:55:39.479] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:40:0)
[18:55:39.479] Timer tick, asking Buildbucket for the build status
[18:55:39.565] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:55:39.565] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:41:0) after 1m0s
[18:56:39.589] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:41:0)
[18:56:39.589] Timer tick, asking Buildbucket for the build status
[18:56:39.667] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:56:39.667] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:42:0) after 1m0s
[18:57:39.691] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:42:0)
[18:57:39.691] Timer tick, asking Buildbucket for the build status
[18:57:39.772] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:57:39.772] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:43:0) after 1m0s
[18:58:39.828] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:43:0)
[18:58:39.828] Timer tick, asking Buildbucket for the build status
[18:58:39.894] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:58:39.894] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:44:0) after 1m0s
[18:59:39.930] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:44:0)
[18:59:39.930] Timer tick, asking Buildbucket for the build status
[18:59:40.034] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:59:40.034] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:45:0) after 1m0s
[19:00:40.135] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:45:0)
[19:00:40.135] Timer tick, asking Buildbucket for the build status
[19:00:40.211] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:00:40.211] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:46:0) after 1m0s
[19:01:40.244] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:46:0)
[19:01:40.244] Timer tick, asking Buildbucket for the build status
[19:01:40.321] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:01:40.321] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:47:0) after 1m0s
[19:02:40.345] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:47:0)
[19:02:40.345] Timer tick, asking Buildbucket for the build status
[19:02:40.418] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:02:40.418] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:48:0) after 1m0s
[19:03:40.531] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:48:0)
[19:03:40.531] Timer tick, asking Buildbucket for the build status
[19:03:40.601] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:03:40.601] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:49:0) after 1m0s
[19:04:40.625] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:49:0)
[19:04:40.625] Timer tick, asking Buildbucket for the build status
[19:04:40.699] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:04:40.699] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:50:0) after 1m0s
[19:05:40.727] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:50:0)
[19:05:40.727] Timer tick, asking Buildbucket for the build status
[19:05:40.830] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:05:40.830] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:51:0) after 1m0s
[19:06:40.859] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:51:0)
[19:06:40.859] Timer tick, asking Buildbucket for the build status
[19:06:40.935] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:06:40.935] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:52:0) after 1m0s
[19:07:40.958] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:52:0)
[19:07:40.958] Timer tick, asking Buildbucket for the build status
[19:07:41.133] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:07:41.133] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:53:0) after 1m0s
[19:08:41.156] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:53:0)
[19:08:41.156] Timer tick, asking Buildbucket for the build status
[19:08:41.293] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:08:41.293] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:54:0) after 1m0s
[19:09:41.321] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:54:0)
[19:09:41.321] Timer tick, asking Buildbucket for the build status
[19:09:41.526] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:09:41.526] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:55:0) after 1m0s
[19:10:41.551] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:55:0)
[19:10:41.551] Timer tick, asking Buildbucket for the build status
[19:10:41.632] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:10:41.632] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:56:0) after 1m0s
[19:11:41.732] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:56:0)
[19:11:41.732] Timer tick, asking Buildbucket for the build status
[19:11:41.834] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:11:41.834] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:57:0) after 1m0s
[19:12:41.852] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:57:0)
[19:12:41.852] Timer tick, asking Buildbucket for the build status
[19:12:41.929] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:12:41.929] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:58:0) after 1m0s
[19:13:42.035] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:58:0)
[19:13:42.035] Timer tick, asking Buildbucket for the build status
[19:13:42.131] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:13:42.131] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:59:0) after 1m0s
[19:14:42.233] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:59:0)
[19:14:42.233] Timer tick, asking Buildbucket for the build status
[19:14:42.313] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:14:42.313] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:60:0) after 1m0s
[19:15:42.349] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:60:0)
[19:15:42.349] Timer tick, asking Buildbucket for the build status
[19:15:42.452] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:15:42.452] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:61:0) after 1m0s
[19:16:42.532] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:61:0)
[19:16:42.532] Timer tick, asking Buildbucket for the build status
[19:16:42.598] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:16:42.598] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:62:0) after 1m0s
[19:17:42.630] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:62:0)
[19:17:42.630] Timer tick, asking Buildbucket for the build status
[19:17:42.745] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:17:42.745] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:63:0) after 1m0s
[19:18:42.767] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:63:0)
[19:18:42.767] Timer tick, asking Buildbucket for the build status
[19:18:42.842] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:18:42.842] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:64:0) after 1m0s
[19:19:42.948] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:64:0)
[19:19:42.948] Timer tick, asking Buildbucket for the build status
[19:19:43.121] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:19:43.121] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:65:0) after 1m0s
[19:20:43.145] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:65:0)
[19:20:43.145] Timer tick, asking Buildbucket for the build status
[19:20:43.217] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:20:43.217] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:66:0) after 1m0s
[19:21:43.330] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:66:0)
[19:21:43.330] Timer tick, asking Buildbucket for the build status
[19:21:43.399] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:21:43.399] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:67:0) after 1m0s
[19:22:43.475] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:67:0)
[19:22:43.475] Timer tick, asking Buildbucket for the build status
[19:22:43.593] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:22:43.593] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:68:0) after 1m0s
[19:23:43.660] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:68:0)
[19:23:43.660] Timer tick, asking Buildbucket for the build status
[19:23:43.737] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:23:43.737] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:69:0) after 1m0s
[19:24:43.821] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:69:0)
[19:24:43.821] Timer tick, asking Buildbucket for the build status
[19:24:43.891] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:24:43.891] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:70:0) after 1m0s
[19:25:43.932] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:70:0)
[19:25:43.932] Timer tick, asking Buildbucket for the build status
[19:25:43.995] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:25:43.995] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:71:0) after 1m0s
[19:26:44.055] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:71:0)
[19:26:44.055] Timer tick, asking Buildbucket for the build status
[19:26:44.122] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:26:44.122] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:72:0) after 1m0s
[19:27:44.227] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:72:0)
[19:27:44.227] Timer tick, asking Buildbucket for the build status
[19:27:44.298] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:27:44.298] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:73:0) after 1m0s
[19:28:44.325] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:73:0)
[19:28:44.325] Timer tick, asking Buildbucket for the build status
[19:28:44.391] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:28:44.391] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:74:0) after 1m0s
[19:29:44.432] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:74:0)
[19:29:44.432] Timer tick, asking Buildbucket for the build status
[19:29:44.545] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:29:44.545] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:75:0) after 1m0s
[19:30:44.635] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:75:0)
[19:30:44.635] Timer tick, asking Buildbucket for the build status
[19:30:44.873] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:30:44.873] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:76:0) after 1m0s
[19:31:44.950] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:76:0)
[19:31:44.950] Timer tick, asking Buildbucket for the build status
[19:31:45.038] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:31:45.038] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:77:0) after 1m0s
[19:32:45.139] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:77:0)
[19:32:45.139] Timer tick, asking Buildbucket for the build status
[19:32:45.285] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:32:45.285] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:78:0) after 1m0s
[19:33:45.321] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:78:0)
[19:33:45.321] Timer tick, asking Buildbucket for the build status
[19:33:45.418] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:33:45.418] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:79:0) after 1m0s
[19:34:45.448] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:79:0)
[19:34:45.448] Timer tick, asking Buildbucket for the build status
[19:34:45.524] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:34:45.524] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:80:0) after 1m0s
[19:35:45.630] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:80:0)
[19:35:45.630] Timer tick, asking Buildbucket for the build status
[19:35:45.693] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:35:45.693] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:81:0) after 1m0s
[19:36:45.768] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:81:0)
[19:36:45.768] Timer tick, asking Buildbucket for the build status
[19:36:45.853] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:36:45.853] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:82:0) after 1m0s
[19:37:45.941] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:82:0)
[19:37:45.941] Timer tick, asking Buildbucket for the build status
[19:37:46.116] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:37:46.116] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:83:0) after 1m0s
[19:38:46.134] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:83:0)
[19:38:46.134] Timer tick, asking Buildbucket for the build status
[19:38:46.218] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:38:46.218] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:84:0) after 1m0s
[19:39:46.242] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:84:0)
[19:39:46.242] Timer tick, asking Buildbucket for the build status
[19:39:46.434] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:39:46.435] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:85:0) after 1m0s
[19:40:46.530] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:85:0)
[19:40:46.530] Timer tick, asking Buildbucket for the build status
[19:40:46.603] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:40:46.603] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:86:0) after 1m0s
[19:41:46.647] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:86:0)
[19:41:46.647] Timer tick, asking Buildbucket for the build status
[19:41:46.716] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:41:46.716] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:87:0) after 1m0s
[19:42:46.764] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:87:0)
[19:42:46.764] Timer tick, asking Buildbucket for the build status
[19:42:46.887] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:42:46.887] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:88:0) after 1m0s
[19:43:46.931] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:88:0)
[19:43:46.931] Timer tick, asking Buildbucket for the build status
[19:43:47.004] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:43:47.004] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:89:0) after 1m0s
[19:44:47.037] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:89:0)
[19:44:47.037] Timer tick, asking Buildbucket for the build status
[19:44:47.130] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:44:47.130] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:90:0) after 1m0s
[19:45:47.164] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:90:0)
[19:45:47.164] Timer tick, asking Buildbucket for the build status
[19:45:47.230] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:45:47.230] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:91:0) after 1m0s
[19:46:47.259] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:91:0)
[19:46:47.259] Timer tick, asking Buildbucket for the build status
[19:46:47.333] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:46:47.333] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:92:0) after 1m0s
[19:47:47.359] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:92:0)
[19:47:47.359] Timer tick, asking Buildbucket for the build status
[19:47:47.502] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:47:47.502] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:93:0) after 1m0s
[19:48:47.529] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:93:0)
[19:48:47.529] Timer tick, asking Buildbucket for the build status
[19:48:47.592] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:48:47.592] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:94:0) after 1m0s
[19:49:47.664] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:94:0)
[19:49:47.664] Timer tick, asking Buildbucket for the build status
[19:49:47.752] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:49:47.752] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:95:0) after 1m0s
[19:50:47.850] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:95:0)
[19:50:47.850] Timer tick, asking Buildbucket for the build status
[19:50:47.943] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:50:47.943] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:96:0) after 1m0s
[19:51:47.964] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:96:0)
[19:51:47.964] Timer tick, asking Buildbucket for the build status
[19:51:48.035] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:51:48.035] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:97:0) after 1m0s
[19:52:48.058] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:97:0)
[19:52:48.058] Timer tick, asking Buildbucket for the build status
[19:52:48.288] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:52:48.288] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:98:0) after 1m0s
[19:53:48.453] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:98:0)
[19:53:48.453] Timer tick, asking Buildbucket for the build status
[19:53:48.625] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:53:48.625] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:99:0) after 1m0s
[19:54:48.737] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:99:0)
[19:54:48.737] Timer tick, asking Buildbucket for the build status
[19:54:48.809] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:54:48.809] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:100:0) after 1m0s
[19:55:48.836] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:100:0)
[19:55:48.836] Timer tick, asking Buildbucket for the build status
[19:55:48.995] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:55:48.995] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:101:0) after 1m0s
[19:56:49.065] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:101:0)
[19:56:49.065] Timer tick, asking Buildbucket for the build status
[19:56:49.150] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:56:49.150] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:102:0) after 1m0s
[19:57:49.173] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:102:0)
[19:57:49.173] Timer tick, asking Buildbucket for the build status
[19:57:49.250] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:57:49.250] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:103:0) after 1m0s
[19:58:49.356] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:103:0)
[19:58:49.356] Timer tick, asking Buildbucket for the build status
[19:58:49.429] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:58:49.429] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:104:0) after 1m0s
[19:59:49.458] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:104:0)
[19:59:49.458] Timer tick, asking Buildbucket for the build status
[19:59:49.536] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:59:49.536] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:105:0) after 1m0s
[20:00:49.622] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:105:0)
[20:00:49.622] Timer tick, asking Buildbucket for the build status
[20:00:49.710] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:00:49.710] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:106:0) after 1m0s
[20:01:49.733] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:106:0)
[20:01:49.733] Timer tick, asking Buildbucket for the build status
[20:01:49.810] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:01:49.810] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:107:0) after 1m0s
[20:02:49.850] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:107:0)
[20:02:49.850] Timer tick, asking Buildbucket for the build status
[20:02:49.930] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:02:49.930] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:108:0) after 1m0s
[20:03:49.961] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:108:0)
[20:03:49.961] Timer tick, asking Buildbucket for the build status
[20:03:50.160] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:03:50.161] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:109:0) after 1m0s
[20:04:50.193] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:109:0)
[20:04:50.193] Timer tick, asking Buildbucket for the build status
[20:04:50.294] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:04:50.294] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:110:0) after 1m0s
[20:05:50.322] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:110:0)
[20:05:50.322] Timer tick, asking Buildbucket for the build status
[20:05:50.398] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:05:50.398] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:111:0) after 1m0s
[20:06:50.429] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:111:0)
[20:06:50.429] Timer tick, asking Buildbucket for the build status
[20:06:50.510] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:06:50.510] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:112:0) after 1m0s
[20:07:50.530] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:112:0)
[20:07:50.530] Timer tick, asking Buildbucket for the build status
[20:07:50.613] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:07:50.613] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:113:0) after 1m0s
[20:08:50.659] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:113:0)
[20:08:50.659] Timer tick, asking Buildbucket for the build status
[20:08:50.746] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:08:50.746] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:114:0) after 1m0s
[20:09:50.860] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:114:0)
[20:09:50.861] Timer tick, asking Buildbucket for the build status
[20:09:50.945] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:09:50.945] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:115:0) after 1m0s
[20:10:51.042] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:115:0)
[20:10:51.042] Timer tick, asking Buildbucket for the build status
[20:10:51.188] Build 8853486230681710416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:10:51.188] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:116:0) after 1m0s
[20:11:47.977] Received PubSub notification, asking Buildbucket for the build status
[20:11:48.053] Build 8853486230681710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:51.237] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:116:0)
[20:11:51.237] Timer tick, asking Buildbucket for the build status
[20:11:51.320] Build 8853486230681710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:51.320] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:118:0) after 1m0s
[20:12:51.438] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:118:0)
[20:12:51.438] Timer tick, asking Buildbucket for the build status
[20:12:51.531] Build 8853486230681710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:51.531] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:119:0) after 1m0s
[20:13:51.556] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:119:0)
[20:13:51.557] Timer tick, asking Buildbucket for the build status
[20:13:51.630] Build 8853486230681710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:51.630] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:120:0) after 1m0s
[20:14:51.662] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:120:0)
[20:14:51.662] Timer tick, asking Buildbucket for the build status
[20:14:51.745] Build 8853486230681710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:51.745] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:121:0) after 1m0s
[20:15:51.865] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:121:0)
[20:15:51.865] Timer tick, asking Buildbucket for the build status
[20:15:51.937] Build 8853486230681710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:51.937] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:122:0) after 1m0s
[20:16:51.963] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:122:0)
[20:16:51.963] Timer tick, asking Buildbucket for the build status
[20:16:52.145] Build 8853486230681710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:52.145] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:123:0) after 1m0s
[20:17:52.171] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:123:0)
[20:17:52.171] Timer tick, asking Buildbucket for the build status
[20:17:52.285] Build 8853486230681710416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:52.285] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018916292573431568:124:0) after 1m0s
[20:18:25.137] Received PubSub notification, asking Buildbucket for the build status
[20:18:25.209] Build 8853486230681710416: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:18:25.209] Buildbucket build:
{
"build": {
"bucket": "luci.v8.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1615061901455289",
"created_by": "project:v8",
"created_ts": "1615054593350754",
"id": "8853486230681710416",
"parameters_json": "{\"builder_name\": \"V8 Win64 - dev image\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler-dev.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"cde30ece0e9424aed22bb77985c5bfc4d4d2a01a\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@cde30ece0e9424aed22bb77985c5bfc4d4d2a01a\", \"title\": \"cde30ece0e9424aed22bb77985c5bfc4d4d2a01a\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/cde30ece0e9424aed22bb77985c5bfc4d4d2a01a\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"cde30ece0e9424aed22bb77985c5bfc4d4d2a01a\"}}",
"project": "v8",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver-dev.appspot.com/\"}, \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler-dev.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"cde30ece0e9424aed22bb77985c5bfc4d4d2a01a\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@cde30ece0e9424aed22bb77985c5bfc4d4d2a01a\", \"title\": \"cde30ece0e9424aed22bb77985c5bfc4d4d2a01a\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/cde30ece0e9424aed22bb77985c5bfc4d4d2a01a\"}]}, \"bot_id\": \"dev-luci-chromium-ci-win10-0-1oti\", \"branch\": \"refs/heads/master\", \"builder_group\": \"client.v8\", \"buildername\": \"V8 Win64 - dev image\", \"buildnumber\": 685, \"got_revision\": \"cde30ece0e9424aed22bb77985c5bfc4d4d2a01a\", \"got_revision_cp\": \"refs/heads/master@{#73245}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"path_config\": \"generic\", \"recipe\": \"v8\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"cde30ece0e9424aed22bb77985c5bfc4d4d2a01a\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_044445a3bc7a4bfe795493d7956aa02cd526172de1fa7300f69fe152e82ea631_v2\", \"builder_a9c54e560aab64ffcab932ab26ad711a72ff73dbcd0bfe47f54d3e3349e5c381_v2\", \"git\", \"goma\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"dev-luci-chromium-ci-win10-0-1oti\"], \"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\": [\"5742-22b1e04\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "v8-ci-builder-dev@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615061506439823",
"status": "COMPLETED",
"status_changed_ts": "1615061902801485",
"tags": [
"build_address:luci.v8.ci/V8 Win64 - dev image/685",
"builder:V8 Win64 - dev image",
"buildset:commit/git/cde30ece0e9424aed22bb77985c5bfc4d4d2a01a",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/cde30ece0e9424aed22bb77985c5bfc4d4d2a01a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018916292573431568",
"scheduler_job_id:v8/V8 Win64 - dev image",
"swarming_hostname:chromium-swarm-dev.appspot.com",
"swarming_tag:log_location:logdog://luci-logdog-dev.appspot.com/v8/buildbucket/cr-buildbucket-dev.appspot.com/8853486230681710416/+/annotations",
"swarming_tag:luci_project:v8",
"swarming_tag:os:Windows",
"swarming_tag:recipe_name:v8",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:522192ea787dfd10",
"user_agent:luci-scheduler-dev"
],
"updated_ts": "1615061902818512",
"url": "https://luci-milo-dev.appspot.com/b/8853486230681710416",
"utcnow_ts": "1615061905202675"
}
}
[20:18:25.209] Invocation finished in 2h1m53.046835933s with status SUCCEEDED