[03:14:32.227] New invocation is queued and will start shortly
[03:14:33.374] Starting the invocation (attempt 1)
[03:14:33.414] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[03:14:33.414] PubSub topic is "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
[03:14:33.414] Buildbucket request:
{
"bucket": "luci.v8.ci",
"client_operation_id": "9022959307978124768",
"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\":\"61972b112d4a764f95d1c56197ca2c25174c7342\"},\"id\":\"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@61972b112d4a764f95d1c56197ca2c25174c7342\",\"title\":\"61972b112d4a764f95d1c56197ca2c25174c7342\",\"url\":\"https://chromium.googlesource.com/v8/v8/+/61972b112d4a764f95d1c56197ca2c25174c7342\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/v8/v8\",\"revision\":\"61972b112d4a764f95d1c56197ca2c25174c7342\"}}",
"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:9022959307978124768",
"scheduler_job_id:v8/V8 Win64 - dev image",
"user_agent:luci-scheduler-dev",
"buildset:commit/git/61972b112d4a764f95d1c56197ca2c25174c7342",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/61972b112d4a764f95d1c56197ca2c25174c7342",
"gitiles_ref:refs/heads/master"
]
}
[03:14:34.102] Buildbucket response:
{
"build": {
"bucket": "luci.v8.ci",
"canary_preference": "PROD",
"created_by": "project:v8",
"created_ts": "1611198873544764",
"id": "8857529245933427296",
"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\": \"61972b112d4a764f95d1c56197ca2c25174c7342\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@61972b112d4a764f95d1c56197ca2c25174c7342\", \"title\": \"61972b112d4a764f95d1c56197ca2c25174c7342\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/61972b112d4a764f95d1c56197ca2c25174c7342\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"61972b112d4a764f95d1c56197ca2c25174c7342\"}}",
"project": "v8",
"result_details_json": "{\"properties\": {}}",
"service_account": "v8-ci-builder-dev@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611198873982168",
"tags": [
"build_address:luci.v8.ci/V8 Win64 - dev image/280",
"builder:V8 Win64 - dev image",
"buildset:commit/git/61972b112d4a764f95d1c56197ca2c25174c7342",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/61972b112d4a764f95d1c56197ca2c25174c7342",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022959307978124768",
"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/8857529245933427296/+/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": "1611198873982275",
"url": "https://luci-milo-dev.appspot.com/b/8857529245933427296",
"utcnow_ts": "1611198874092944"
}
}
[03:14:34.102] Task URL: https://luci-milo-dev.appspot.com/b/8857529245933427296
[03:14:34.102] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:2:0) after 1m0s
[03:15:34.164] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:2:0)
[03:15:34.164] Timer tick, asking Buildbucket for the build status
[03:15:34.273] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:15:34.273] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:3:0) after 1m0s
[03:16:34.374] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:3:0)
[03:16:34.374] Timer tick, asking Buildbucket for the build status
[03:16:34.524] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:16:34.525] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:4:0) after 1m0s
[03:17:34.557] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:4:0)
[03:17:34.557] Timer tick, asking Buildbucket for the build status
[03:17:34.663] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:17:34.663] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:5:0) after 1m0s
[03:18:34.754] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:5:0)
[03:18:34.754] Timer tick, asking Buildbucket for the build status
[03:18:34.834] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:18:34.834] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:6:0) after 1m0s
[03:19:34.869] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:6:0)
[03:19:34.869] Timer tick, asking Buildbucket for the build status
[03:19:35.132] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:19:35.132] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:7:0) after 1m0s
[03:20:35.158] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:7:0)
[03:20:35.158] Timer tick, asking Buildbucket for the build status
[03:20:35.242] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:20:35.242] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:8:0) after 1m0s
[03:21:35.262] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:8:0)
[03:21:35.262] Timer tick, asking Buildbucket for the build status
[03:21:35.361] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:21:35.361] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:9:0) after 1m0s
[03:22:35.457] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:9:0)
[03:22:35.457] Timer tick, asking Buildbucket for the build status
[03:22:35.541] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:22:35.541] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:10:0) after 1m0s
[03:23:35.573] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:10:0)
[03:23:35.573] Timer tick, asking Buildbucket for the build status
[03:23:35.689] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:23:35.689] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:11:0) after 1m0s
[03:24:35.755] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:11:0)
[03:24:35.755] Timer tick, asking Buildbucket for the build status
[03:24:35.847] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:24:35.847] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:12:0) after 1m0s
[03:25:35.870] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:12:0)
[03:25:35.870] Timer tick, asking Buildbucket for the build status
[03:25:35.952] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:25:35.952] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:13:0) after 1m0s
[03:26:36.057] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:13:0)
[03:26:36.057] Timer tick, asking Buildbucket for the build status
[03:26:36.157] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:26:36.157] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:14:0) after 1m0s
[03:27:36.261] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:14:0)
[03:27:36.261] Timer tick, asking Buildbucket for the build status
[03:27:36.353] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:27:36.353] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:15:0) after 1m0s
[03:28:36.389] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:15:0)
[03:28:36.389] Timer tick, asking Buildbucket for the build status
[03:28:36.477] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:28:36.477] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:16:0) after 1m0s
[03:29:36.557] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:16:0)
[03:29:36.557] Timer tick, asking Buildbucket for the build status
[03:29:36.646] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:29:36.646] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:17:0) after 1m0s
[03:30:36.672] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:17:0)
[03:30:36.672] Timer tick, asking Buildbucket for the build status
[03:30:36.769] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:30:36.769] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:18:0) after 1m0s
[03:31:36.797] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:18:0)
[03:31:36.797] Timer tick, asking Buildbucket for the build status
[03:31:36.973] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:31:36.973] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:19:0) after 1m0s
[03:32:37.058] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:19:0)
[03:32:37.058] Timer tick, asking Buildbucket for the build status
[03:32:37.171] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:32:37.171] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:20:0) after 1m0s
[03:33:37.208] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:20:0)
[03:33:37.208] Timer tick, asking Buildbucket for the build status
[03:33:37.319] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:33:37.319] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:21:0) after 1m0s
[03:34:37.360] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:21:0)
[03:34:37.360] Timer tick, asking Buildbucket for the build status
[03:34:37.457] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:34:37.457] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:22:0) after 1m0s
[03:35:37.558] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:22:0)
[03:35:37.558] Timer tick, asking Buildbucket for the build status
[03:35:37.656] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:35:37.656] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:23:0) after 1m0s
[03:36:37.683] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:23:0)
[03:36:37.683] Timer tick, asking Buildbucket for the build status
[03:36:37.775] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:36:37.775] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:24:0) after 1m0s
[03:37:37.801] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:24:0)
[03:37:37.801] Timer tick, asking Buildbucket for the build status
[03:37:37.883] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:37:37.883] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:25:0) after 1m0s
[03:38:37.971] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:25:0)
[03:38:37.971] Timer tick, asking Buildbucket for the build status
[03:38:38.065] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:38:38.065] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:26:0) after 1m0s
[03:39:38.177] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:26:0)
[03:39:38.177] Timer tick, asking Buildbucket for the build status
[03:39:38.260] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:39:38.260] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:27:0) after 1m0s
[03:40:38.290] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:27:0)
[03:40:38.290] Timer tick, asking Buildbucket for the build status
[03:40:38.375] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:40:38.375] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:28:0) after 1m0s
[03:41:38.484] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:28:0)
[03:41:38.484] Timer tick, asking Buildbucket for the build status
[03:41:38.575] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:41:38.575] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:29:0) after 1m0s
[03:42:38.660] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:29:0)
[03:42:38.660] Timer tick, asking Buildbucket for the build status
[03:42:38.778] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:42:38.778] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:30:0) after 1m0s
[03:43:38.876] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:30:0)
[03:43:38.876] Timer tick, asking Buildbucket for the build status
[03:43:38.965] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:43:38.965] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:31:0) after 1m0s
[03:44:39.071] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:31:0)
[03:44:39.071] Timer tick, asking Buildbucket for the build status
[03:44:39.172] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:44:39.172] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:32:0) after 1m0s
[03:45:39.275] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:32:0)
[03:45:39.275] Timer tick, asking Buildbucket for the build status
[03:45:39.384] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:45:39.384] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:33:0) after 1m0s
[03:46:39.481] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:33:0)
[03:46:39.481] Timer tick, asking Buildbucket for the build status
[03:46:39.596] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:46:39.596] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:34:0) after 1m0s
[03:47:39.622] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:34:0)
[03:47:39.622] Timer tick, asking Buildbucket for the build status
[03:47:39.706] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:47:39.706] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:35:0) after 1m0s
[03:48:39.760] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:35:0)
[03:48:39.760] Timer tick, asking Buildbucket for the build status
[03:48:39.840] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:48:39.840] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:36:0) after 1m0s
[03:49:39.867] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:36:0)
[03:49:39.867] Timer tick, asking Buildbucket for the build status
[03:49:39.951] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:49:39.951] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:37:0) after 1m0s
[03:50:40.083] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:37:0)
[03:50:40.083] Timer tick, asking Buildbucket for the build status
[03:50:40.171] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:50:40.171] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:38:0) after 1m0s
[03:51:40.263] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:38:0)
[03:51:40.263] Timer tick, asking Buildbucket for the build status
[03:51:40.358] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:51:40.358] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:39:0) after 1m0s
[03:52:40.474] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:39:0)
[03:52:40.474] Timer tick, asking Buildbucket for the build status
[03:52:40.559] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:52:40.559] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:40:0) after 1m0s
[03:53:40.660] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:40:0)
[03:53:40.660] Timer tick, asking Buildbucket for the build status
[03:53:40.757] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:53:40.757] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:41:0) after 1m0s
[03:54:40.858] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:41:0)
[03:54:40.858] Timer tick, asking Buildbucket for the build status
[03:54:40.982] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:54:40.982] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:42:0) after 1m0s
[03:55:41.077] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:42:0)
[03:55:41.077] Timer tick, asking Buildbucket for the build status
[03:55:41.165] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:55:41.165] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:43:0) after 1m0s
[03:56:41.257] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:43:0)
[03:56:41.257] Timer tick, asking Buildbucket for the build status
[03:56:41.337] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:56:41.337] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:44:0) after 1m0s
[03:57:41.361] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:44:0)
[03:57:41.361] Timer tick, asking Buildbucket for the build status
[03:57:41.461] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:57:41.461] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:45:0) after 1m0s
[03:58:41.557] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:45:0)
[03:58:41.557] Timer tick, asking Buildbucket for the build status
[03:58:41.641] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:58:41.641] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:46:0) after 1m0s
[03:59:41.666] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:46:0)
[03:59:41.666] Timer tick, asking Buildbucket for the build status
[03:59:41.760] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:59:41.760] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:47:0) after 1m0s
[04:00:41.800] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:47:0)
[04:00:41.800] Timer tick, asking Buildbucket for the build status
[04:00:41.901] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:00:41.901] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:48:0) after 1m0s
[04:01:41.959] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:48:0)
[04:01:41.959] Timer tick, asking Buildbucket for the build status
[04:01:42.051] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:01:42.051] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:49:0) after 1m0s
[04:02:42.182] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:49:0)
[04:02:42.182] Timer tick, asking Buildbucket for the build status
[04:02:42.418] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:02:42.418] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:50:0) after 1m0s
[04:03:42.441] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:50:0)
[04:03:42.441] Timer tick, asking Buildbucket for the build status
[04:03:42.564] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:03:42.564] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:51:0) after 1m0s
[04:04:42.672] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:51:0)
[04:04:42.672] Timer tick, asking Buildbucket for the build status
[04:04:42.788] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:04:42.788] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:52:0) after 1m0s
[04:05:42.859] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:52:0)
[04:05:42.859] Timer tick, asking Buildbucket for the build status
[04:05:42.961] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:05:42.961] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:53:0) after 1m0s
[04:06:43.060] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:53:0)
[04:06:43.060] Timer tick, asking Buildbucket for the build status
[04:06:43.158] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:06:43.158] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:54:0) after 1m0s
[04:07:43.259] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:54:0)
[04:07:43.259] Timer tick, asking Buildbucket for the build status
[04:07:43.363] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:07:43.363] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:55:0) after 1m0s
[04:08:43.461] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:55:0)
[04:08:43.461] Timer tick, asking Buildbucket for the build status
[04:08:43.549] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:08:43.549] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:56:0) after 1m0s
[04:09:43.676] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:56:0)
[04:09:43.676] Timer tick, asking Buildbucket for the build status
[04:09:43.768] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:09:43.768] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:57:0) after 1m0s
[04:10:43.800] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:57:0)
[04:10:43.800] Timer tick, asking Buildbucket for the build status
[04:10:43.900] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:10:43.900] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:58:0) after 1m0s
[04:11:43.959] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:58:0)
[04:11:43.959] Timer tick, asking Buildbucket for the build status
[04:11:44.065] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:11:44.065] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:59:0) after 1m0s
[04:12:44.170] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:59:0)
[04:12:44.170] Timer tick, asking Buildbucket for the build status
[04:12:44.287] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:12:44.287] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:60:0) after 1m0s
[04:13:44.312] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:60:0)
[04:13:44.312] Timer tick, asking Buildbucket for the build status
[04:13:44.399] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:13:44.399] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:61:0) after 1m0s
[04:14:44.422] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:61:0)
[04:14:44.422] Timer tick, asking Buildbucket for the build status
[04:14:44.513] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:14:44.513] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:62:0) after 1m0s
[04:15:44.569] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:62:0)
[04:15:44.569] Timer tick, asking Buildbucket for the build status
[04:15:44.679] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:15:44.679] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:63:0) after 1m0s
[04:16:44.704] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:63:0)
[04:16:44.704] Timer tick, asking Buildbucket for the build status
[04:16:44.794] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:16:44.795] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:64:0) after 1m0s
[04:17:44.863] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:64:0)
[04:17:44.863] Timer tick, asking Buildbucket for the build status
[04:17:44.957] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:17:44.957] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:65:0) after 1m0s
[04:18:45.060] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:65:0)
[04:18:45.060] Timer tick, asking Buildbucket for the build status
[04:18:45.161] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:18:45.161] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:66:0) after 1m0s
[04:19:45.191] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:66:0)
[04:19:45.191] Timer tick, asking Buildbucket for the build status
[04:19:45.316] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:19:45.316] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:67:0) after 1m0s
[04:20:45.336] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:67:0)
[04:20:45.336] Timer tick, asking Buildbucket for the build status
[04:20:45.435] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:20:45.435] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:68:0) after 1m0s
[04:21:45.472] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:68:0)
[04:21:45.472] Timer tick, asking Buildbucket for the build status
[04:21:45.569] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:21:45.569] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:69:0) after 1m0s
[04:22:45.592] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:69:0)
[04:22:45.592] Timer tick, asking Buildbucket for the build status
[04:22:45.716] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:22:45.716] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:70:0) after 1m0s
[04:23:45.758] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:70:0)
[04:23:45.758] Timer tick, asking Buildbucket for the build status
[04:23:45.873] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:23:45.873] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:71:0) after 1m0s
[04:24:45.988] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:71:0)
[04:24:45.988] Timer tick, asking Buildbucket for the build status
[04:24:46.088] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:24:46.088] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:72:0) after 1m0s
[04:25:46.158] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:72:0)
[04:25:46.158] Timer tick, asking Buildbucket for the build status
[04:25:46.259] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:25:46.259] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:73:0) after 1m0s
[04:26:46.284] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:73:0)
[04:26:46.284] Timer tick, asking Buildbucket for the build status
[04:26:46.371] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:26:46.371] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:74:0) after 1m0s
[04:27:46.399] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:74:0)
[04:27:46.399] Timer tick, asking Buildbucket for the build status
[04:27:46.496] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:27:46.496] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:75:0) after 1m0s
[04:28:46.567] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:75:0)
[04:28:46.567] Timer tick, asking Buildbucket for the build status
[04:28:46.655] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:28:46.655] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:76:0) after 1m0s
[04:29:46.773] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:76:0)
[04:29:46.773] Timer tick, asking Buildbucket for the build status
[04:29:46.963] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:29:46.963] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:77:0) after 1m0s
[04:30:47.065] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:77:0)
[04:30:47.065] Timer tick, asking Buildbucket for the build status
[04:30:47.166] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:30:47.166] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:78:0) after 1m0s
[04:31:47.265] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:78:0)
[04:31:47.265] Timer tick, asking Buildbucket for the build status
[04:31:47.356] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:31:47.356] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:79:0) after 1m0s
[04:32:47.476] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:79:0)
[04:32:47.476] Timer tick, asking Buildbucket for the build status
[04:32:47.568] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:32:47.568] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:80:0) after 1m0s
[04:33:47.673] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:80:0)
[04:33:47.673] Timer tick, asking Buildbucket for the build status
[04:33:47.756] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:33:47.756] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:81:0) after 1m0s
[04:34:47.788] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:81:0)
[04:34:47.788] Timer tick, asking Buildbucket for the build status
[04:34:47.885] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:34:47.885] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:82:0) after 1m0s
[04:35:47.910] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:82:0)
[04:35:47.910] Timer tick, asking Buildbucket for the build status
[04:35:47.990] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:35:47.990] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:83:0) after 1m0s
[04:36:48.060] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:83:0)
[04:36:48.060] Timer tick, asking Buildbucket for the build status
[04:36:48.149] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:36:48.149] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:84:0) after 1m0s
[04:37:48.281] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:84:0)
[04:37:48.281] Timer tick, asking Buildbucket for the build status
[04:37:48.366] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:37:48.366] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:85:0) after 1m0s
[04:38:48.459] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:85:0)
[04:38:48.459] Timer tick, asking Buildbucket for the build status
[04:38:48.542] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:38:48.542] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:86:0) after 1m0s
[04:39:48.568] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:86:0)
[04:39:48.568] Timer tick, asking Buildbucket for the build status
[04:39:48.654] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:39:48.654] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:87:0) after 1m0s
[04:40:48.763] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:87:0)
[04:40:48.763] Timer tick, asking Buildbucket for the build status
[04:40:48.860] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:40:48.860] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:88:0) after 1m0s
[04:41:48.959] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:88:0)
[04:41:48.959] Timer tick, asking Buildbucket for the build status
[04:41:49.048] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:41:49.048] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:89:0) after 1m0s
[04:42:49.068] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:89:0)
[04:42:49.068] Timer tick, asking Buildbucket for the build status
[04:42:49.162] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:42:49.162] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:90:0) after 1m0s
[04:43:49.282] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:90:0)
[04:43:49.282] Timer tick, asking Buildbucket for the build status
[04:43:49.367] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:43:49.367] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:91:0) after 1m0s
[04:44:49.461] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:91:0)
[04:44:49.461] Timer tick, asking Buildbucket for the build status
[04:44:49.560] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:44:49.560] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:92:0) after 1m0s
[04:45:49.584] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:92:0)
[04:45:49.584] Timer tick, asking Buildbucket for the build status
[04:45:49.672] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:45:49.672] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:93:0) after 1m0s
[04:46:49.760] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:93:0)
[04:46:49.760] Timer tick, asking Buildbucket for the build status
[04:46:49.863] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:46:49.863] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:94:0) after 1m0s
[04:47:49.970] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:94:0)
[04:47:49.970] Timer tick, asking Buildbucket for the build status
[04:47:50.059] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:47:50.059] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:95:0) after 1m0s
[04:48:50.162] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:95:0)
[04:48:50.162] Timer tick, asking Buildbucket for the build status
[04:48:50.244] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:48:50.244] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:96:0) after 1m0s
[04:49:50.281] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:96:0)
[04:49:50.281] Timer tick, asking Buildbucket for the build status
[04:49:50.363] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:49:50.363] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:97:0) after 1m0s
[04:50:50.460] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:97:0)
[04:50:50.460] Timer tick, asking Buildbucket for the build status
[04:50:50.546] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:50:50.546] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:98:0) after 1m0s
[04:51:50.586] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:98:0)
[04:51:50.586] Timer tick, asking Buildbucket for the build status
[04:51:50.671] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:51:50.671] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:99:0) after 1m0s
[04:52:50.704] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:99:0)
[04:52:50.704] Timer tick, asking Buildbucket for the build status
[04:52:50.804] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:52:50.804] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:100:0) after 1m0s
[04:53:50.829] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:100:0)
[04:53:50.829] Timer tick, asking Buildbucket for the build status
[04:53:50.937] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:53:50.937] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:101:0) after 1m0s
[04:54:50.978] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:101:0)
[04:54:50.978] Timer tick, asking Buildbucket for the build status
[04:54:51.071] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:54:51.071] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:102:0) after 1m0s
[04:55:51.161] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:102:0)
[04:55:51.161] Timer tick, asking Buildbucket for the build status
[04:55:51.243] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:55:51.243] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:103:0) after 1m0s
[04:56:51.279] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:103:0)
[04:56:51.279] Timer tick, asking Buildbucket for the build status
[04:56:51.363] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:56:51.363] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:104:0) after 1m0s
[04:57:51.463] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:104:0)
[04:57:51.463] Timer tick, asking Buildbucket for the build status
[04:57:51.567] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:57:51.567] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:105:0) after 1m0s
[04:58:51.676] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:105:0)
[04:58:51.676] Timer tick, asking Buildbucket for the build status
[04:58:51.761] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:58:51.761] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:106:0) after 1m0s
[04:59:51.795] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:106:0)
[04:59:51.795] Timer tick, asking Buildbucket for the build status
[04:59:51.887] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:59:51.887] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:107:0) after 1m0s
[05:00:51.963] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:107:0)
[05:00:51.963] Timer tick, asking Buildbucket for the build status
[05:00:52.101] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:00:52.101] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:108:0) after 1m0s
[05:01:52.145] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:108:0)
[05:01:52.145] Timer tick, asking Buildbucket for the build status
[05:01:52.251] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:01:52.251] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:109:0) after 1m0s
[05:02:52.279] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:109:0)
[05:02:52.279] Timer tick, asking Buildbucket for the build status
[05:02:52.376] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:02:52.376] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:110:0) after 1m0s
[05:03:52.423] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:110:0)
[05:03:52.423] Timer tick, asking Buildbucket for the build status
[05:03:52.508] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:03:52.508] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:111:0) after 1m0s
[05:04:52.559] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:111:0)
[05:04:52.559] Timer tick, asking Buildbucket for the build status
[05:04:52.646] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:04:52.646] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:112:0) after 1m0s
[05:05:52.681] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:112:0)
[05:05:52.681] Timer tick, asking Buildbucket for the build status
[05:05:52.779] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:05:52.779] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:113:0) after 1m0s
[05:06:52.806] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:113:0)
[05:06:52.806] Timer tick, asking Buildbucket for the build status
[05:06:52.899] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:06:52.899] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:114:0) after 1m0s
[05:07:53.023] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:114:0)
[05:07:53.023] Timer tick, asking Buildbucket for the build status
[05:07:53.164] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:07:53.164] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:115:0) after 1m0s
[05:08:53.276] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:115:0)
[05:08:53.276] Timer tick, asking Buildbucket for the build status
[05:08:53.481] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:08:53.481] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:116:0) after 1m0s
[05:09:53.578] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:116:0)
[05:09:53.578] Timer tick, asking Buildbucket for the build status
[05:09:53.690] Build 8857529245933427296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:09:53.690] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:117:0) after 1m0s
[05:10:15.961] Received PubSub notification, asking Buildbucket for the build status
[05:10:16.047] Build 8857529245933427296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:53.758] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:117:0)
[05:10:53.758] Timer tick, asking Buildbucket for the build status
[05:10:53.847] Build 8857529245933427296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:53.847] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:119:0) after 1m0s
[05:11:53.877] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:119:0)
[05:11:53.877] Timer tick, asking Buildbucket for the build status
[05:11:53.983] Build 8857529245933427296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:53.983] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:120:0) after 1m0s
[05:12:54.063] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:120:0)
[05:12:54.063] Timer tick, asking Buildbucket for the build status
[05:12:54.186] Build 8857529245933427296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:54.186] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9022959307978124768:121:0) after 1m0s
[05:13:36.769] Received PubSub notification, asking Buildbucket for the build status
[05:13:36.861] Build 8857529245933427296: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:13:36.861] Buildbucket build:
{
"build": {
"bucket": "luci.v8.ci",
"canary_preference": "PROD",
"completed_ts": "1611206014945430",
"created_by": "project:v8",
"created_ts": "1611198873544764",
"id": "8857529245933427296",
"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\": \"61972b112d4a764f95d1c56197ca2c25174c7342\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@61972b112d4a764f95d1c56197ca2c25174c7342\", \"title\": \"61972b112d4a764f95d1c56197ca2c25174c7342\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/61972b112d4a764f95d1c56197ca2c25174c7342\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"61972b112d4a764f95d1c56197ca2c25174c7342\"}}",
"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\": \"61972b112d4a764f95d1c56197ca2c25174c7342\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@61972b112d4a764f95d1c56197ca2c25174c7342\", \"title\": \"61972b112d4a764f95d1c56197ca2c25174c7342\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/61972b112d4a764f95d1c56197ca2c25174c7342\"}]}, \"bot_id\": \"dev-luci-chromium-ci-win10-0-b9rm\", \"branch\": \"refs/heads/master\", \"builder_group\": \"client.v8\", \"buildername\": \"V8 Win64 - dev image\", \"buildnumber\": 280, \"got_revision\": \"61972b112d4a764f95d1c56197ca2c25174c7342\", \"got_revision_cp\": \"refs/heads/master@{#72210}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"path_config\": \"generic\", \"recipe\": \"v8\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"61972b112d4a764f95d1c56197ca2c25174c7342\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_044445a3bc7a4bfe795493d7956aa02cd526172de1fa7300f69fe152e82ea631_v2\", \"builder_5de1032f0e9ef497433aad28840ee258c037976023b410f653133cee0ad04e2c_v2\", \"builder_82ed111fed7ea8169e482f00b5f3e5338a65daa41208585de67cb0a736b1d538_v2\", \"builder_a9c54e560aab64ffcab932ab26ad711a72ff73dbcd0bfe47f54d3e3349e5c381_v2\", \"builder_d38bdc976f893fc6930479dce8a6d7dc793b2a74fe1392d4af00713a5c0bb46e_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-b9rm\"], \"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\": [\"5671-1d9dea8\"], \"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": "1611205812846835",
"status": "COMPLETED",
"status_changed_ts": "1611206015523634",
"tags": [
"build_address:luci.v8.ci/V8 Win64 - dev image/280",
"builder:V8 Win64 - dev image",
"buildset:commit/git/61972b112d4a764f95d1c56197ca2c25174c7342",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/61972b112d4a764f95d1c56197ca2c25174c7342",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022959307978124768",
"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/8857529245933427296/+/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:513bc15682b41510",
"user_agent:luci-scheduler-dev"
],
"updated_ts": "1611206015534382",
"url": "https://luci-milo-dev.appspot.com/b/8857529245933427296",
"utcnow_ts": "1611206016852066"
}
}
[05:13:36.861] Invocation finished in 1h59m4.650829226s with status SUCCEEDED