[22:03:42.089] New invocation is queued and will start shortly
[22:03:43.163] Starting the invocation (attempt 1)
[22:03:43.200] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[22:03:43.200] PubSub topic is "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
[22:03:43.200] Buildbucket request:
{
"bucket": "luci.v8.ci",
"client_operation_id": "9021166924736988656",
"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\":\"36dedea6fb713ee98287632313565a82450abeb3\"},\"id\":\"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@36dedea6fb713ee98287632313565a82450abeb3\",\"title\":\"36dedea6fb713ee98287632313565a82450abeb3\",\"url\":\"https://chromium.googlesource.com/v8/v8/+/36dedea6fb713ee98287632313565a82450abeb3\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/v8/v8\",\"revision\":\"bd82cdbd2ab2c6c982f305d7df3836362fa165d5\"},\"id\":\"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@bd82cdbd2ab2c6c982f305d7df3836362fa165d5\",\"title\":\"bd82cdbd2ab2c6c982f305d7df3836362fa165d5\",\"url\":\"https://chromium.googlesource.com/v8/v8/+/bd82cdbd2ab2c6c982f305d7df3836362fa165d5\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/v8/v8\",\"revision\":\"306463e8bba028a695b06e687deb9a0d2e05360a\"},\"id\":\"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@306463e8bba028a695b06e687deb9a0d2e05360a\",\"title\":\"306463e8bba028a695b06e687deb9a0d2e05360a\",\"url\":\"https://chromium.googlesource.com/v8/v8/+/306463e8bba028a695b06e687deb9a0d2e05360a\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/v8/v8\",\"revision\":\"5d67f90e0f9b76f4e98488126d7658e9228c332f\"},\"id\":\"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@5d67f90e0f9b76f4e98488126d7658e9228c332f\",\"title\":\"5d67f90e0f9b76f4e98488126d7658e9228c332f\",\"url\":\"https://chromium.googlesource.com/v8/v8/+/5d67f90e0f9b76f4e98488126d7658e9228c332f\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/v8/v8\",\"revision\":\"5d67f90e0f9b76f4e98488126d7658e9228c332f\"}}",
"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:9021166924736988656",
"scheduler_job_id:v8/V8 Win64 - dev image",
"user_agent:luci-scheduler-dev",
"buildset:commit/git/5d67f90e0f9b76f4e98488126d7658e9228c332f",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/5d67f90e0f9b76f4e98488126d7658e9228c332f",
"gitiles_ref:refs/heads/master"
]
}
[22:03:43.984] Buildbucket response:
{
"build": {
"bucket": "luci.v8.ci",
"canary_preference": "PROD",
"created_by": "project:v8",
"created_ts": "1612908223303593",
"id": "8855736862799858336",
"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\": \"36dedea6fb713ee98287632313565a82450abeb3\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@36dedea6fb713ee98287632313565a82450abeb3\", \"title\": \"36dedea6fb713ee98287632313565a82450abeb3\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/36dedea6fb713ee98287632313565a82450abeb3\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"bd82cdbd2ab2c6c982f305d7df3836362fa165d5\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@bd82cdbd2ab2c6c982f305d7df3836362fa165d5\", \"title\": \"bd82cdbd2ab2c6c982f305d7df3836362fa165d5\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/bd82cdbd2ab2c6c982f305d7df3836362fa165d5\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"306463e8bba028a695b06e687deb9a0d2e05360a\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@306463e8bba028a695b06e687deb9a0d2e05360a\", \"title\": \"306463e8bba028a695b06e687deb9a0d2e05360a\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/306463e8bba028a695b06e687deb9a0d2e05360a\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"5d67f90e0f9b76f4e98488126d7658e9228c332f\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@5d67f90e0f9b76f4e98488126d7658e9228c332f\", \"title\": \"5d67f90e0f9b76f4e98488126d7658e9228c332f\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/5d67f90e0f9b76f4e98488126d7658e9228c332f\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"5d67f90e0f9b76f4e98488126d7658e9228c332f\"}}",
"project": "v8",
"result_details_json": "{\"properties\": {}}",
"service_account": "v8-ci-builder-dev@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612908223803011",
"tags": [
"build_address:luci.v8.ci/V8 Win64 - dev image/449",
"builder:V8 Win64 - dev image",
"buildset:commit/git/5d67f90e0f9b76f4e98488126d7658e9228c332f",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/5d67f90e0f9b76f4e98488126d7658e9228c332f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021166924736988656",
"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/8855736862799858336/+/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": "1612908223803155",
"url": "https://luci-milo-dev.appspot.com/b/8855736862799858336",
"utcnow_ts": "1612908223974778"
}
}
[22:03:43.984] Task URL: https://luci-milo-dev.appspot.com/b/8855736862799858336
[22:03:43.984] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:2:0) after 1m0s
[22:04:44.047] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:2:0)
[22:04:44.047] Timer tick, asking Buildbucket for the build status
[22:04:44.232] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:04:44.232] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:3:0) after 1m0s
[22:05:44.272] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:3:0)
[22:05:44.272] Timer tick, asking Buildbucket for the build status
[22:05:44.445] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:05:44.445] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:4:0) after 1m0s
[22:06:44.529] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:4:0)
[22:06:44.529] Timer tick, asking Buildbucket for the build status
[22:06:44.635] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:06:44.635] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:5:0) after 1m0s
[22:07:44.661] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:5:0)
[22:07:44.661] Timer tick, asking Buildbucket for the build status
[22:07:44.770] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:07:44.770] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:6:0) after 1m0s
[22:08:44.842] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:6:0)
[22:08:44.842] Timer tick, asking Buildbucket for the build status
[22:08:44.951] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:08:44.951] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:7:0) after 1m0s
[22:09:45.029] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:7:0)
[22:09:45.029] Timer tick, asking Buildbucket for the build status
[22:09:45.212] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:09:45.212] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:8:0) after 1m0s
[22:10:45.250] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:8:0)
[22:10:45.251] Timer tick, asking Buildbucket for the build status
[22:10:45.454] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:10:45.454] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:9:0) after 1m0s
[22:11:45.548] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:9:0)
[22:11:45.548] Timer tick, asking Buildbucket for the build status
[22:11:46.943] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:11:46.943] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:10:0) after 1m0s
[22:12:47.029] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:10:0)
[22:12:47.029] Timer tick, asking Buildbucket for the build status
[22:12:47.124] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:12:47.124] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:11:0) after 1m0s
[22:13:47.235] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:11:0)
[22:13:47.235] Timer tick, asking Buildbucket for the build status
[22:13:47.527] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:13:47.527] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:12:0) after 1m0s
[22:14:47.630] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:12:0)
[22:14:47.630] Timer tick, asking Buildbucket for the build status
[22:14:47.830] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:14:47.830] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:13:0) after 1m0s
[22:15:47.946] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:13:0)
[22:15:47.946] Timer tick, asking Buildbucket for the build status
[22:15:48.082] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:15:48.082] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:14:0) after 1m0s
[22:16:48.155] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:14:0)
[22:16:48.155] Timer tick, asking Buildbucket for the build status
[22:16:48.270] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:16:48.270] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:15:0) after 1m0s
[22:17:48.345] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:15:0)
[22:17:48.345] Timer tick, asking Buildbucket for the build status
[22:17:48.492] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:17:48.492] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:16:0) after 1m0s
[22:18:48.561] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:16:0)
[22:18:48.561] Timer tick, asking Buildbucket for the build status
[22:18:48.673] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:18:48.673] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:17:0) after 1m0s
[22:19:48.809] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:17:0)
[22:19:48.809] Timer tick, asking Buildbucket for the build status
[22:19:48.908] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:19:48.908] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:18:0) after 1m0s
[22:20:48.940] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:18:0)
[22:20:48.940] Timer tick, asking Buildbucket for the build status
[22:20:49.062] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:20:49.062] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:19:0) after 1m0s
[22:21:49.086] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:19:0)
[22:21:49.086] Timer tick, asking Buildbucket for the build status
[22:21:50.422] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:21:50.422] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:20:0) after 1m0s
[22:22:50.544] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:20:0)
[22:22:50.544] Timer tick, asking Buildbucket for the build status
[22:22:50.645] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:22:50.645] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:21:0) after 1m0s
[22:23:50.730] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:21:0)
[22:23:50.730] Timer tick, asking Buildbucket for the build status
[22:23:50.882] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:23:50.882] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:22:0) after 1m0s
[22:24:50.910] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:22:0)
[22:24:50.910] Timer tick, asking Buildbucket for the build status
[22:24:51.017] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:24:51.017] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:23:0) after 1m0s
[22:25:51.045] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:23:0)
[22:25:51.045] Timer tick, asking Buildbucket for the build status
[22:25:51.175] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:25:51.176] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:24:0) after 1m0s
[22:26:51.201] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:24:0)
[22:26:51.201] Timer tick, asking Buildbucket for the build status
[22:26:51.303] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:26:51.303] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:25:0) after 1m0s
[22:27:51.342] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:25:0)
[22:27:51.342] Timer tick, asking Buildbucket for the build status
[22:27:51.435] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:27:51.435] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:26:0) after 1m0s
[22:28:51.543] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:26:0)
[22:28:51.543] Timer tick, asking Buildbucket for the build status
[22:28:51.648] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:28:51.648] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:27:0) after 1m0s
[22:29:51.672] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:27:0)
[22:29:51.672] Timer tick, asking Buildbucket for the build status
[22:29:51.782] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:29:51.782] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:28:0) after 1m0s
[22:30:51.805] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:28:0)
[22:30:51.805] Timer tick, asking Buildbucket for the build status
[22:30:51.929] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:30:51.929] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:29:0) after 1m0s
[22:31:51.956] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:29:0)
[22:31:51.956] Timer tick, asking Buildbucket for the build status
[22:31:52.062] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:31:52.062] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:30:0) after 1m0s
[22:32:52.134] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:30:0)
[22:32:52.134] Timer tick, asking Buildbucket for the build status
[22:32:52.251] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:32:52.251] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:31:0) after 1m0s
[22:33:52.345] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:31:0)
[22:33:52.345] Timer tick, asking Buildbucket for the build status
[22:33:52.606] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:33:52.606] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:32:0) after 1m0s
[22:34:52.651] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:32:0)
[22:34:52.651] Timer tick, asking Buildbucket for the build status
[22:34:52.832] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:34:52.832] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:33:0) after 1m0s
[22:35:52.937] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:33:0)
[22:35:52.937] Timer tick, asking Buildbucket for the build status
[22:35:53.054] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:35:53.054] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:34:0) after 1m0s
[22:36:53.138] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:34:0)
[22:36:53.138] Timer tick, asking Buildbucket for the build status
[22:36:53.249] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:36:53.249] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:35:0) after 1m0s
[22:37:53.342] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:35:0)
[22:37:53.342] Timer tick, asking Buildbucket for the build status
[22:37:53.463] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:37:53.463] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:36:0) after 1m0s
[22:38:53.544] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:36:0)
[22:38:53.544] Timer tick, asking Buildbucket for the build status
[22:38:53.679] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:38:53.679] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:37:0) after 1m0s
[22:39:53.729] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:37:0)
[22:39:53.729] Timer tick, asking Buildbucket for the build status
[22:39:53.823] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:39:53.824] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:38:0) after 1m0s
[22:40:53.950] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:38:0)
[22:40:53.950] Timer tick, asking Buildbucket for the build status
[22:40:54.058] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:40:54.058] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:39:0) after 1m0s
[22:41:54.133] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:39:0)
[22:41:54.133] Timer tick, asking Buildbucket for the build status
[22:41:54.266] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:41:54.266] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:40:0) after 1m0s
[22:42:54.343] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:40:0)
[22:42:54.344] Timer tick, asking Buildbucket for the build status
[22:42:54.465] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:42:54.465] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:41:0) after 1m0s
[22:43:54.531] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:41:0)
[22:43:54.531] Timer tick, asking Buildbucket for the build status
[22:43:54.665] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:43:54.665] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:42:0) after 1m0s
[22:44:54.744] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:42:0)
[22:44:54.744] Timer tick, asking Buildbucket for the build status
[22:44:54.849] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:44:54.849] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:43:0) after 1m0s
[22:45:54.953] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:43:0)
[22:45:54.953] Timer tick, asking Buildbucket for the build status
[22:45:55.066] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:45:55.066] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:44:0) after 1m0s
[22:46:55.095] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:44:0)
[22:46:55.095] Timer tick, asking Buildbucket for the build status
[22:46:55.212] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:46:55.212] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:45:0) after 1m0s
[22:47:55.264] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:45:0)
[22:47:55.264] Timer tick, asking Buildbucket for the build status
[22:47:55.470] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:47:55.470] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:46:0) after 1m0s
[22:48:55.495] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:46:0)
[22:48:55.495] Timer tick, asking Buildbucket for the build status
[22:48:55.657] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:48:55.657] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:47:0) after 1m0s
[22:49:55.741] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:47:0)
[22:49:55.741] Timer tick, asking Buildbucket for the build status
[22:49:55.895] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:49:55.895] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:48:0) after 1m0s
[22:50:55.935] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:48:0)
[22:50:55.935] Timer tick, asking Buildbucket for the build status
[22:50:56.048] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:50:56.048] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:49:0) after 1m0s
[22:51:57.328] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:49:0)
[22:51:57.328] Timer tick, asking Buildbucket for the build status
[22:51:57.512] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:51:57.512] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:50:0) after 1m0s
[22:52:57.539] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:50:0)
[22:52:57.539] Timer tick, asking Buildbucket for the build status
[22:52:57.634] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:52:57.634] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:51:0) after 1m0s
[22:53:57.743] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:51:0)
[22:53:57.743] Timer tick, asking Buildbucket for the build status
[22:53:57.893] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:53:57.893] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:52:0) after 1m0s
[22:54:57.935] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:52:0)
[22:54:57.935] Timer tick, asking Buildbucket for the build status
[22:54:58.122] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:54:58.123] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:53:0) after 1m0s
[22:55:58.145] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:53:0)
[22:55:58.145] Timer tick, asking Buildbucket for the build status
[22:55:58.267] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:55:58.267] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:54:0) after 1m0s
[22:56:58.293] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:54:0)
[22:56:58.293] Timer tick, asking Buildbucket for the build status
[22:56:58.411] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:56:58.411] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:55:0) after 1m0s
[22:57:58.452] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:55:0)
[22:57:58.452] Timer tick, asking Buildbucket for the build status
[22:57:58.581] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:57:58.581] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:56:0) after 1m0s
[22:58:58.606] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:56:0)
[22:58:58.606] Timer tick, asking Buildbucket for the build status
[22:58:58.781] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:58:58.781] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:57:0) after 1m0s
[22:59:58.845] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:57:0)
[22:59:58.845] Timer tick, asking Buildbucket for the build status
[22:59:58.969] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:59:58.969] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:58:0) after 1m0s
[23:00:59.031] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:58:0)
[23:00:59.031] Timer tick, asking Buildbucket for the build status
[23:00:59.181] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:00:59.181] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:59:0) after 1m0s
[23:01:59.247] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:59:0)
[23:01:59.247] Timer tick, asking Buildbucket for the build status
[23:01:59.418] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:01:59.418] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:60:0) after 1m0s
[23:02:59.446] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:60:0)
[23:02:59.446] Timer tick, asking Buildbucket for the build status
[23:02:59.568] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:02:59.568] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:61:0) after 1m0s
[23:03:59.636] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:61:0)
[23:03:59.636] Timer tick, asking Buildbucket for the build status
[23:03:59.736] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:03:59.736] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:62:0) after 1m0s
[23:04:59.832] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:62:0)
[23:04:59.832] Timer tick, asking Buildbucket for the build status
[23:04:59.975] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:04:59.975] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:63:0) after 1m0s
[23:06:00.059] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:63:0)
[23:06:00.059] Timer tick, asking Buildbucket for the build status
[23:06:00.411] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:06:00.411] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:64:0) after 1m0s
[23:07:00.442] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:64:0)
[23:07:00.442] Timer tick, asking Buildbucket for the build status
[23:07:00.571] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:07:00.572] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:65:0) after 1m0s
[23:08:00.658] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:65:0)
[23:08:00.658] Timer tick, asking Buildbucket for the build status
[23:08:00.758] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:08:00.758] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:66:0) after 1m0s
[23:09:00.850] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:66:0)
[23:09:00.850] Timer tick, asking Buildbucket for the build status
[23:09:00.988] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:09:00.988] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:67:0) after 1m0s
[23:10:01.044] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:67:0)
[23:10:01.044] Timer tick, asking Buildbucket for the build status
[23:10:01.215] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:10:01.215] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:68:0) after 1m0s
[23:11:01.237] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:68:0)
[23:11:01.237] Timer tick, asking Buildbucket for the build status
[23:11:01.369] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:11:01.369] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:69:0) after 1m0s
[23:12:01.442] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:69:0)
[23:12:01.442] Timer tick, asking Buildbucket for the build status
[23:12:01.558] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:12:01.559] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:70:0) after 1m0s
[23:13:01.595] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:70:0)
[23:13:01.595] Timer tick, asking Buildbucket for the build status
[23:13:01.733] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:13:01.733] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:71:0) after 1m0s
[23:14:01.848] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:71:0)
[23:14:01.848] Timer tick, asking Buildbucket for the build status
[23:14:01.956] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:14:01.956] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:72:0) after 1m0s
[23:15:02.051] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:72:0)
[23:15:02.051] Timer tick, asking Buildbucket for the build status
[23:15:02.356] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:15:02.356] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:73:0) after 1m0s
[23:16:02.448] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:73:0)
[23:16:02.448] Timer tick, asking Buildbucket for the build status
[23:16:02.568] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:16:02.568] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:74:0) after 1m0s
[23:17:02.633] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:74:0)
[23:17:02.633] Timer tick, asking Buildbucket for the build status
[23:17:02.734] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:17:02.734] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:75:0) after 1m0s
[23:18:02.773] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:75:0)
[23:18:02.773] Timer tick, asking Buildbucket for the build status
[23:18:02.907] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:18:02.907] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:76:0) after 1m0s
[23:19:02.941] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:76:0)
[23:19:02.941] Timer tick, asking Buildbucket for the build status
[23:19:03.065] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:19:03.065] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:77:0) after 1m0s
[23:20:03.103] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:77:0)
[23:20:03.103] Timer tick, asking Buildbucket for the build status
[23:20:03.232] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:20:03.232] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:78:0) after 1m0s
[23:21:03.340] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:78:0)
[23:21:03.340] Timer tick, asking Buildbucket for the build status
[23:21:03.465] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:21:03.465] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:79:0) after 1m0s
[23:22:03.555] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:79:0)
[23:22:03.555] Timer tick, asking Buildbucket for the build status
[23:22:03.860] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:22:03.860] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:80:0) after 1m0s
[23:23:03.994] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:80:0)
[23:23:03.994] Timer tick, asking Buildbucket for the build status
[23:23:04.237] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:23:04.237] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:81:0) after 1m0s
[23:24:04.340] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:81:0)
[23:24:04.340] Timer tick, asking Buildbucket for the build status
[23:24:04.477] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:24:04.477] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:82:0) after 1m0s
[23:25:04.675] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:82:0)
[23:25:04.675] Timer tick, asking Buildbucket for the build status
[23:25:04.786] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:25:04.786] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:83:0) after 1m0s
[23:26:04.852] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:83:0)
[23:26:04.852] Timer tick, asking Buildbucket for the build status
[23:26:04.975] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:26:04.975] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:84:0) after 1m0s
[23:27:05.049] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:84:0)
[23:27:05.049] Timer tick, asking Buildbucket for the build status
[23:27:05.193] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:27:05.193] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:85:0) after 1m0s
[23:28:05.258] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:85:0)
[23:28:05.258] Timer tick, asking Buildbucket for the build status
[23:28:05.373] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:28:05.373] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:86:0) after 1m0s
[23:29:05.409] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:86:0)
[23:29:05.409] Timer tick, asking Buildbucket for the build status
[23:29:05.513] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:29:05.513] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:87:0) after 1m0s
[23:30:05.556] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:87:0)
[23:30:05.557] Timer tick, asking Buildbucket for the build status
[23:30:05.762] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:30:05.762] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:88:0) after 1m0s
[23:31:05.862] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:88:0)
[23:31:05.862] Timer tick, asking Buildbucket for the build status
[23:31:05.993] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:31:05.994] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:89:0) after 1m0s
[23:32:06.056] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:89:0)
[23:32:06.056] Timer tick, asking Buildbucket for the build status
[23:32:06.171] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:32:06.171] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:90:0) after 1m0s
[23:33:06.205] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:90:0)
[23:33:06.205] Timer tick, asking Buildbucket for the build status
[23:33:06.325] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:33:06.325] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:91:0) after 1m0s
[23:34:06.367] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:91:0)
[23:34:06.367] Timer tick, asking Buildbucket for the build status
[23:34:06.467] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:34:06.467] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:92:0) after 1m0s
[23:35:06.496] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:92:0)
[23:35:06.496] Timer tick, asking Buildbucket for the build status
[23:35:06.583] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:35:06.583] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:93:0) after 1m0s
[23:36:06.663] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:93:0)
[23:36:06.663] Timer tick, asking Buildbucket for the build status
[23:36:06.782] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:36:06.782] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:94:0) after 1m0s
[23:37:06.833] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:94:0)
[23:37:06.833] Timer tick, asking Buildbucket for the build status
[23:37:06.946] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:37:06.946] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:95:0) after 1m0s
[23:38:06.982] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:95:0)
[23:38:06.982] Timer tick, asking Buildbucket for the build status
[23:38:07.080] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:38:07.080] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:96:0) after 1m0s
[23:39:07.154] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:96:0)
[23:39:07.154] Timer tick, asking Buildbucket for the build status
[23:39:07.435] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:39:07.435] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:97:0) after 1m0s
[23:40:07.563] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:97:0)
[23:40:07.563] Timer tick, asking Buildbucket for the build status
[23:40:07.683] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:40:07.683] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:98:0) after 1m0s
[23:41:07.756] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:98:0)
[23:41:07.756] Timer tick, asking Buildbucket for the build status
[23:41:07.963] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:41:07.963] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:99:0) after 1m0s
[23:42:08.095] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:99:0)
[23:42:08.095] Timer tick, asking Buildbucket for the build status
[23:42:08.287] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:42:08.287] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:100:0) after 1m0s
[23:43:08.348] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:100:0)
[23:43:08.348] Timer tick, asking Buildbucket for the build status
[23:43:08.677] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:43:08.677] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:101:0) after 1m0s
[23:44:08.748] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:101:0)
[23:44:08.748] Timer tick, asking Buildbucket for the build status
[23:44:08.982] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:44:08.982] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:102:0) after 1m0s
[23:45:09.048] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:102:0)
[23:45:09.048] Timer tick, asking Buildbucket for the build status
[23:45:09.273] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:45:09.273] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:103:0) after 1m0s
[23:46:09.331] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:103:0)
[23:46:09.331] Timer tick, asking Buildbucket for the build status
[23:46:09.562] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:46:09.562] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:104:0) after 1m0s
[23:47:09.687] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:104:0)
[23:47:09.687] Timer tick, asking Buildbucket for the build status
[23:47:10.028] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:47:10.028] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:105:0) after 1m0s
[23:48:10.147] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:105:0)
[23:48:10.147] Timer tick, asking Buildbucket for the build status
[23:48:10.526] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:48:10.526] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:106:0) after 1m0s
[23:49:10.642] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:106:0)
[23:49:10.642] Timer tick, asking Buildbucket for the build status
[23:49:10.772] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:49:10.772] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:107:0) after 1m0s
[23:50:10.811] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:107:0)
[23:50:10.811] Timer tick, asking Buildbucket for the build status
[23:50:11.012] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:50:11.012] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:108:0) after 1m0s
[23:51:11.054] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:108:0)
[23:51:11.054] Timer tick, asking Buildbucket for the build status
[23:51:11.282] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:51:11.282] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:109:0) after 1m0s
[23:52:11.488] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:109:0)
[23:52:11.488] Timer tick, asking Buildbucket for the build status
[23:52:11.663] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:52:11.663] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:110:0) after 1m0s
[23:53:11.695] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:110:0)
[23:53:11.695] Timer tick, asking Buildbucket for the build status
[23:53:12.024] Build 8855736862799858336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:53:12.024] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:111:0) after 1m0s
[23:53:52.134] Received PubSub notification, asking Buildbucket for the build status
[23:53:52.233] Build 8855736862799858336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:12.074] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:111:0)
[23:54:12.074] Timer tick, asking Buildbucket for the build status
[23:54:12.290] Build 8855736862799858336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:12.290] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:113:0) after 1m0s
[23:55:12.346] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:113:0)
[23:55:12.346] Timer tick, asking Buildbucket for the build status
[23:55:12.615] Build 8855736862799858336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:12.615] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:114:0) after 1m0s
[23:56:12.741] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:114:0)
[23:56:12.741] Timer tick, asking Buildbucket for the build status
[23:56:12.872] Build 8855736862799858336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:12.872] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021166924736988656:115:0) after 1m0s
[23:56:29.060] Received PubSub notification, asking Buildbucket for the build status
[23:56:29.185] Build 8855736862799858336: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:56:29.185] Buildbucket build:
{
"build": {
"bucket": "luci.v8.ci",
"canary_preference": "PROD",
"completed_ts": "1612914987385648",
"created_by": "project:v8",
"created_ts": "1612908223303593",
"id": "8855736862799858336",
"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\": \"36dedea6fb713ee98287632313565a82450abeb3\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@36dedea6fb713ee98287632313565a82450abeb3\", \"title\": \"36dedea6fb713ee98287632313565a82450abeb3\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/36dedea6fb713ee98287632313565a82450abeb3\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"bd82cdbd2ab2c6c982f305d7df3836362fa165d5\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@bd82cdbd2ab2c6c982f305d7df3836362fa165d5\", \"title\": \"bd82cdbd2ab2c6c982f305d7df3836362fa165d5\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/bd82cdbd2ab2c6c982f305d7df3836362fa165d5\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"306463e8bba028a695b06e687deb9a0d2e05360a\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@306463e8bba028a695b06e687deb9a0d2e05360a\", \"title\": \"306463e8bba028a695b06e687deb9a0d2e05360a\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/306463e8bba028a695b06e687deb9a0d2e05360a\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"5d67f90e0f9b76f4e98488126d7658e9228c332f\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@5d67f90e0f9b76f4e98488126d7658e9228c332f\", \"title\": \"5d67f90e0f9b76f4e98488126d7658e9228c332f\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/5d67f90e0f9b76f4e98488126d7658e9228c332f\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"5d67f90e0f9b76f4e98488126d7658e9228c332f\"}}",
"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\": \"36dedea6fb713ee98287632313565a82450abeb3\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@36dedea6fb713ee98287632313565a82450abeb3\", \"title\": \"36dedea6fb713ee98287632313565a82450abeb3\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/36dedea6fb713ee98287632313565a82450abeb3\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"bd82cdbd2ab2c6c982f305d7df3836362fa165d5\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@bd82cdbd2ab2c6c982f305d7df3836362fa165d5\", \"title\": \"bd82cdbd2ab2c6c982f305d7df3836362fa165d5\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/bd82cdbd2ab2c6c982f305d7df3836362fa165d5\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"306463e8bba028a695b06e687deb9a0d2e05360a\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@306463e8bba028a695b06e687deb9a0d2e05360a\", \"title\": \"306463e8bba028a695b06e687deb9a0d2e05360a\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/306463e8bba028a695b06e687deb9a0d2e05360a\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"5d67f90e0f9b76f4e98488126d7658e9228c332f\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@5d67f90e0f9b76f4e98488126d7658e9228c332f\", \"title\": \"5d67f90e0f9b76f4e98488126d7658e9228c332f\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/5d67f90e0f9b76f4e98488126d7658e9228c332f\"}]}, \"bot_id\": \"dev-luci-chromium-ci-win10-0-nmfo\", \"branch\": \"refs/heads/master\", \"builder_group\": \"client.v8\", \"buildername\": \"V8 Win64 - dev image\", \"buildnumber\": 449, \"got_revision\": \"5d67f90e0f9b76f4e98488126d7658e9228c332f\", \"got_revision_cp\": \"refs/heads/master@{#72609}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"path_config\": \"generic\", \"recipe\": \"v8\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"5d67f90e0f9b76f4e98488126d7658e9228c332f\"}, \"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-nmfo\"], \"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\": [\"swarming-dev-default-v020\"], \"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": "1612914830175911",
"status": "COMPLETED",
"status_changed_ts": "1612914987711810",
"tags": [
"build_address:luci.v8.ci/V8 Win64 - dev image/449",
"builder:V8 Win64 - dev image",
"buildset:commit/git/5d67f90e0f9b76f4e98488126d7658e9228c332f",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/5d67f90e0f9b76f4e98488126d7658e9228c332f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021166924736988656",
"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/8855736862799858336/+/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:51a1a3e86fcd8a10",
"user_agent:luci-scheduler-dev"
],
"updated_ts": "1612914987737203",
"url": "https://luci-milo-dev.appspot.com/b/8855736862799858336",
"utcnow_ts": "1612914989170138"
}
}
[23:56:29.187] Invocation finished in 1h52m47.115370191s with status SUCCEEDED