[23:13:56.082] New invocation is queued and will start shortly
[23:13:57.192] Starting the invocation (attempt 1)
[23:13:57.235] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[23:13:57.235] PubSub topic is "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
[23:13:57.235] Buildbucket request:
{
"bucket": "luci.v8.ci",
"client_operation_id": "9023518027171333232",
"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\":\"e451d996fb398622bdf73fbb5757bb95c445963b\"},\"id\":\"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@e451d996fb398622bdf73fbb5757bb95c445963b\",\"title\":\"e451d996fb398622bdf73fbb5757bb95c445963b\",\"url\":\"https://chromium.googlesource.com/v8/v8/+/e451d996fb398622bdf73fbb5757bb95c445963b\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/v8/v8\",\"revision\":\"e451d996fb398622bdf73fbb5757bb95c445963b\"}}",
"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:9023518027171333232",
"scheduler_job_id:v8/V8 Win64 - dev image",
"user_agent:luci-scheduler-dev",
"buildset:commit/git/e451d996fb398622bdf73fbb5757bb95c445963b",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/e451d996fb398622bdf73fbb5757bb95c445963b",
"gitiles_ref:refs/heads/master"
]
}
[23:13:57.930] Buildbucket response:
{
"build": {
"bucket": "luci.v8.ci",
"canary_preference": "PROD",
"created_by": "project:v8",
"created_ts": "1610666037315396",
"id": "8858087965214311776",
"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\": \"e451d996fb398622bdf73fbb5757bb95c445963b\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@e451d996fb398622bdf73fbb5757bb95c445963b\", \"title\": \"e451d996fb398622bdf73fbb5757bb95c445963b\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/e451d996fb398622bdf73fbb5757bb95c445963b\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"e451d996fb398622bdf73fbb5757bb95c445963b\"}}",
"project": "v8",
"result_details_json": "{\"properties\": {}}",
"service_account": "v8-ci-builder-dev@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610666037821291",
"tags": [
"build_address:luci.v8.ci/V8 Win64 - dev image/234",
"builder:V8 Win64 - dev image",
"buildset:commit/git/e451d996fb398622bdf73fbb5757bb95c445963b",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/e451d996fb398622bdf73fbb5757bb95c445963b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023518027171333232",
"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/8858087965214311776/+/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": "1610666037821398",
"url": "https://luci-milo-dev.appspot.com/b/8858087965214311776",
"utcnow_ts": "1610666037923326"
}
}
[23:13:57.930] Task URL: https://luci-milo-dev.appspot.com/b/8858087965214311776
[23:13:57.930] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:2:0) after 1m0s
[23:14:57.997] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:2:0)
[23:14:57.997] Timer tick, asking Buildbucket for the build status
[23:14:58.094] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:14:58.094] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:3:0) after 1m0s
[23:15:58.113] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:3:0)
[23:15:58.113] Timer tick, asking Buildbucket for the build status
[23:15:58.216] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:15:58.216] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:4:0) after 1m0s
[23:16:58.238] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:4:0)
[23:16:58.238] Timer tick, asking Buildbucket for the build status
[23:16:58.321] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:16:58.321] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:5:0) after 1m0s
[23:17:58.387] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:5:0)
[23:17:58.387] Timer tick, asking Buildbucket for the build status
[23:17:58.464] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:17:58.464] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:6:0) after 1m0s
[23:18:58.483] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:6:0)
[23:18:58.483] Timer tick, asking Buildbucket for the build status
[23:18:58.587] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:18:58.587] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:7:0) after 1m0s
[23:19:58.616] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:7:0)
[23:19:58.616] Timer tick, asking Buildbucket for the build status
[23:19:58.787] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:19:58.787] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:8:0) after 1m0s
[23:20:58.886] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:8:0)
[23:20:58.886] Timer tick, asking Buildbucket for the build status
[23:20:58.999] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:20:58.999] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:9:0) after 1m0s
[23:21:59.108] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:9:0)
[23:21:59.108] Timer tick, asking Buildbucket for the build status
[23:21:59.215] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:21:59.215] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:10:0) after 1m0s
[23:22:59.245] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:10:0)
[23:22:59.245] Timer tick, asking Buildbucket for the build status
[23:22:59.370] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:22:59.370] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:11:0) after 1m0s
[23:23:59.401] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:11:0)
[23:23:59.401] Timer tick, asking Buildbucket for the build status
[23:23:59.704] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:23:59.704] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:12:0) after 1m0s
[23:24:59.722] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:12:0)
[23:24:59.722] Timer tick, asking Buildbucket for the build status
[23:24:59.806] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:24:59.806] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:13:0) after 1m0s
[23:25:59.895] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:13:0)
[23:25:59.895] Timer tick, asking Buildbucket for the build status
[23:26:00.157] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:26:00.157] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:14:0) after 1m0s
[23:27:00.209] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:14:0)
[23:27:00.209] Timer tick, asking Buildbucket for the build status
[23:27:00.422] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:27:00.422] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:15:0) after 1m0s
[23:28:00.496] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:15:0)
[23:28:00.496] Timer tick, asking Buildbucket for the build status
[23:28:00.693] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:28:00.693] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:16:0) after 1m0s
[23:29:00.709] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:16:0)
[23:29:00.709] Timer tick, asking Buildbucket for the build status
[23:29:00.823] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:29:00.823] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:17:0) after 1m0s
[23:30:00.898] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:17:0)
[23:30:00.898] Timer tick, asking Buildbucket for the build status
[23:30:01.239] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:30:01.239] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:18:0) after 1m0s
[23:31:01.258] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:18:0)
[23:31:01.258] Timer tick, asking Buildbucket for the build status
[23:31:01.386] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:31:01.386] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:19:0) after 1m0s
[23:32:01.498] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:19:0)
[23:32:01.498] Timer tick, asking Buildbucket for the build status
[23:32:01.610] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:32:01.610] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:20:0) after 1m0s
[23:33:01.691] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:20:0)
[23:33:01.691] Timer tick, asking Buildbucket for the build status
[23:33:01.816] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:33:01.816] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:21:0) after 1m0s
[23:34:01.918] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:21:0)
[23:34:01.918] Timer tick, asking Buildbucket for the build status
[23:34:02.091] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:34:02.091] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:22:0) after 1m0s
[23:35:02.112] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:22:0)
[23:35:02.112] Timer tick, asking Buildbucket for the build status
[23:35:02.211] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:35:02.211] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:23:0) after 1m0s
[23:36:02.319] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:23:0)
[23:36:02.319] Timer tick, asking Buildbucket for the build status
[23:36:02.425] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:36:02.425] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:24:0) after 1m0s
[23:37:02.512] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:24:0)
[23:37:02.512] Timer tick, asking Buildbucket for the build status
[23:37:02.611] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:37:02.611] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:25:0) after 1m0s
[23:38:02.701] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:25:0)
[23:38:02.701] Timer tick, asking Buildbucket for the build status
[23:38:02.847] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:38:02.847] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:26:0) after 1m0s
[23:39:02.870] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:26:0)
[23:39:02.870] Timer tick, asking Buildbucket for the build status
[23:39:02.965] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:39:02.965] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:27:0) after 1m0s
[23:40:03.028] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:27:0)
[23:40:03.028] Timer tick, asking Buildbucket for the build status
[23:40:03.259] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:40:03.259] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:28:0) after 1m0s
[23:41:03.285] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:28:0)
[23:41:03.285] Timer tick, asking Buildbucket for the build status
[23:41:03.473] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:41:03.473] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:29:0) after 1m0s
[23:42:03.509] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:29:0)
[23:42:03.509] Timer tick, asking Buildbucket for the build status
[23:42:03.731] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:42:03.731] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:30:0) after 1m0s
[23:43:03.805] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:30:0)
[23:43:03.805] Timer tick, asking Buildbucket for the build status
[23:43:03.951] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:43:03.951] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:31:0) after 1m0s
[23:44:04.001] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:31:0)
[23:44:04.001] Timer tick, asking Buildbucket for the build status
[23:44:04.098] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:44:04.098] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:32:0) after 1m0s
[23:45:04.206] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:32:0)
[23:45:04.206] Timer tick, asking Buildbucket for the build status
[23:45:04.302] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:45:04.303] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:33:0) after 1m0s
[23:46:04.328] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:33:0)
[23:46:04.328] Timer tick, asking Buildbucket for the build status
[23:46:04.428] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:46:04.428] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:34:0) after 1m0s
[23:47:04.492] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:34:0)
[23:47:04.492] Timer tick, asking Buildbucket for the build status
[23:47:04.577] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:47:04.577] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:35:0) after 1m0s
[23:48:04.614] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:35:0)
[23:48:04.614] Timer tick, asking Buildbucket for the build status
[23:48:04.714] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:48:04.714] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:36:0) after 1m0s
[23:49:04.806] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:36:0)
[23:49:04.806] Timer tick, asking Buildbucket for the build status
[23:49:04.949] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:49:04.949] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:37:0) after 1m0s
[23:50:05.004] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:37:0)
[23:50:05.004] Timer tick, asking Buildbucket for the build status
[23:50:05.122] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:50:05.123] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:38:0) after 1m0s
[23:51:05.192] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:38:0)
[23:51:05.192] Timer tick, asking Buildbucket for the build status
[23:51:05.300] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:51:05.300] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:39:0) after 1m0s
[23:52:05.326] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:39:0)
[23:52:05.326] Timer tick, asking Buildbucket for the build status
[23:52:05.409] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:52:05.409] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:40:0) after 1m0s
[23:53:05.434] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:40:0)
[23:53:05.434] Timer tick, asking Buildbucket for the build status
[23:53:05.531] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:53:05.531] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:41:0) after 1m0s
[23:54:05.570] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:41:0)
[23:54:05.570] Timer tick, asking Buildbucket for the build status
[23:54:05.665] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:54:05.665] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:42:0) after 1m0s
[23:55:05.688] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:42:0)
[23:55:05.688] Timer tick, asking Buildbucket for the build status
[23:55:05.774] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:55:05.774] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:43:0) after 1m0s
[23:56:05.803] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:43:0)
[23:56:05.803] Timer tick, asking Buildbucket for the build status
[23:56:05.892] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:56:05.892] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:44:0) after 1m0s
[23:57:06.022] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:44:0)
[23:57:06.022] Timer tick, asking Buildbucket for the build status
[23:57:06.166] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:57:06.166] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:45:0) after 1m0s
[23:58:06.211] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:45:0)
[23:58:06.211] Timer tick, asking Buildbucket for the build status
[23:58:06.328] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:58:06.328] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:46:0) after 1m0s
[23:59:06.417] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:46:0)
[23:59:06.417] Timer tick, asking Buildbucket for the build status
[23:59:06.521] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:59:06.521] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:47:0) after 1m0s
[00:00:06.614] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:47:0)
[00:00:06.614] Timer tick, asking Buildbucket for the build status
[00:00:06.745] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:00:06.746] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:48:0) after 1m0s
[00:01:06.791] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:48:0)
[00:01:06.791] Timer tick, asking Buildbucket for the build status
[00:01:06.896] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:01:06.896] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:49:0) after 1m0s
[00:02:06.971] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:49:0)
[00:02:06.971] Timer tick, asking Buildbucket for the build status
[00:02:07.093] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:02:07.093] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:50:0) after 1m0s
[00:03:07.203] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:50:0)
[00:03:07.203] Timer tick, asking Buildbucket for the build status
[00:03:07.304] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:03:07.304] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:51:0) after 1m0s
[00:04:07.343] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:51:0)
[00:04:07.343] Timer tick, asking Buildbucket for the build status
[00:04:07.427] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:04:07.427] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:52:0) after 1m0s
[00:05:07.501] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:52:0)
[00:05:07.501] Timer tick, asking Buildbucket for the build status
[00:05:07.579] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:05:07.579] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:53:0) after 1m0s
[00:06:07.729] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:53:0)
[00:06:07.729] Timer tick, asking Buildbucket for the build status
[00:06:07.850] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:06:07.850] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:54:0) after 1m0s
[00:07:07.897] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:54:0)
[00:07:07.897] Timer tick, asking Buildbucket for the build status
[00:07:07.992] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:07:07.992] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:55:0) after 1m0s
[00:08:08.125] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:55:0)
[00:08:08.125] Timer tick, asking Buildbucket for the build status
[00:08:08.219] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:08:08.219] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:56:0) after 1m0s
[00:09:08.249] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:56:0)
[00:09:08.249] Timer tick, asking Buildbucket for the build status
[00:09:08.395] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:09:08.395] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:57:0) after 1m0s
[00:10:08.503] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:57:0)
[00:10:08.503] Timer tick, asking Buildbucket for the build status
[00:10:08.625] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:10:08.625] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:58:0) after 1m0s
[00:11:08.711] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:58:0)
[00:11:08.711] Timer tick, asking Buildbucket for the build status
[00:11:08.815] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:11:08.815] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:59:0) after 1m0s
[00:12:08.841] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:59:0)
[00:12:08.841] Timer tick, asking Buildbucket for the build status
[00:12:09.812] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:12:09.812] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:60:0) after 1m0s
[00:13:09.914] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:60:0)
[00:13:09.914] Timer tick, asking Buildbucket for the build status
[00:13:09.998] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:13:09.998] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:61:0) after 1m0s
[00:14:10.096] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:61:0)
[00:14:10.096] Timer tick, asking Buildbucket for the build status
[00:14:10.196] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:14:10.196] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:62:0) after 1m0s
[00:15:10.221] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:62:0)
[00:15:10.221] Timer tick, asking Buildbucket for the build status
[00:15:10.317] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:15:10.317] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:63:0) after 1m0s
[00:16:10.394] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:63:0)
[00:16:10.394] Timer tick, asking Buildbucket for the build status
[00:16:10.564] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:16:10.564] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:64:0) after 1m0s
[00:17:10.592] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:64:0)
[00:17:10.592] Timer tick, asking Buildbucket for the build status
[00:17:10.692] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:17:10.692] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:65:0) after 1m0s
[00:18:10.820] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:65:0)
[00:18:10.820] Timer tick, asking Buildbucket for the build status
[00:18:10.918] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:18:10.918] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:66:0) after 1m0s
[00:19:11.049] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:66:0)
[00:19:11.049] Timer tick, asking Buildbucket for the build status
[00:19:11.144] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:19:11.144] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:67:0) after 1m0s
[00:20:11.216] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:67:0)
[00:20:11.216] Timer tick, asking Buildbucket for the build status
[00:20:11.410] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:20:11.410] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:68:0) after 1m0s
[00:21:11.509] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:68:0)
[00:21:11.509] Timer tick, asking Buildbucket for the build status
[00:21:11.722] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:21:11.722] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:69:0) after 1m0s
[00:22:11.748] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:69:0)
[00:22:11.748] Timer tick, asking Buildbucket for the build status
[00:22:11.864] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:22:11.864] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:70:0) after 1m0s
[00:23:11.904] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:70:0)
[00:23:11.904] Timer tick, asking Buildbucket for the build status
[00:23:12.004] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:23:12.004] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:71:0) after 1m0s
[00:24:12.102] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:71:0)
[00:24:12.102] Timer tick, asking Buildbucket for the build status
[00:24:12.206] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:24:12.206] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:72:0) after 1m0s
[00:25:12.301] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:72:0)
[00:25:12.301] Timer tick, asking Buildbucket for the build status
[00:25:12.396] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:25:12.396] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:73:0) after 1m0s
[00:26:12.523] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:73:0)
[00:26:12.523] Timer tick, asking Buildbucket for the build status
[00:26:12.626] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:26:12.626] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:74:0) after 1m0s
[00:27:12.706] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:74:0)
[00:27:12.706] Timer tick, asking Buildbucket for the build status
[00:27:12.801] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:27:12.801] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:75:0) after 1m0s
[00:28:12.907] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:75:0)
[00:28:12.907] Timer tick, asking Buildbucket for the build status
[00:28:13.002] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:28:13.002] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:76:0) after 1m0s
[00:29:13.106] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:76:0)
[00:29:13.106] Timer tick, asking Buildbucket for the build status
[00:29:13.199] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:29:13.199] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:77:0) after 1m0s
[00:30:13.293] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:77:0)
[00:30:13.293] Timer tick, asking Buildbucket for the build status
[00:30:13.481] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:30:13.482] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:78:0) after 1m0s
[00:31:13.517] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:78:0)
[00:31:13.517] Timer tick, asking Buildbucket for the build status
[00:31:13.700] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:31:13.700] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:79:0) after 1m0s
[00:32:13.732] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:79:0)
[00:32:13.732] Timer tick, asking Buildbucket for the build status
[00:32:13.831] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:32:13.831] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:80:0) after 1m0s
[00:33:13.906] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:80:0)
[00:33:13.906] Timer tick, asking Buildbucket for the build status
[00:33:14.000] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:33:14.000] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:81:0) after 1m0s
[00:34:14.109] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:81:0)
[00:34:14.109] Timer tick, asking Buildbucket for the build status
[00:34:14.206] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:34:14.206] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:82:0) after 1m0s
[00:35:14.327] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:82:0)
[00:35:14.327] Timer tick, asking Buildbucket for the build status
[00:35:14.425] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:35:14.425] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:83:0) after 1m0s
[00:36:14.490] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:83:0)
[00:36:14.490] Timer tick, asking Buildbucket for the build status
[00:36:14.576] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:36:14.577] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:84:0) after 1m0s
[00:37:14.608] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:84:0)
[00:37:14.608] Timer tick, asking Buildbucket for the build status
[00:37:14.692] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:37:14.692] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:85:0) after 1m0s
[00:38:14.822] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:85:0)
[00:38:14.822] Timer tick, asking Buildbucket for the build status
[00:38:14.924] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:38:14.924] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:86:0) after 1m0s
[00:39:14.991] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:86:0)
[00:39:14.991] Timer tick, asking Buildbucket for the build status
[00:39:15.137] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:39:15.137] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:87:0) after 1m0s
[00:40:15.191] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:87:0)
[00:40:15.191] Timer tick, asking Buildbucket for the build status
[00:40:15.358] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:40:15.358] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:88:0) after 1m0s
[00:41:15.432] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:88:0)
[00:41:15.432] Timer tick, asking Buildbucket for the build status
[00:41:15.561] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:41:15.561] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:89:0) after 1m0s
[00:42:15.600] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:89:0)
[00:42:15.600] Timer tick, asking Buildbucket for the build status
[00:42:15.707] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:42:15.707] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:90:0) after 1m0s
[00:43:15.805] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:90:0)
[00:43:15.805] Timer tick, asking Buildbucket for the build status
[00:43:15.965] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:43:15.965] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:91:0) after 1m0s
[00:44:16.004] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:91:0)
[00:44:16.004] Timer tick, asking Buildbucket for the build status
[00:44:16.106] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:44:16.106] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:92:0) after 1m0s
[00:45:16.217] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:92:0)
[00:45:16.217] Timer tick, asking Buildbucket for the build status
[00:45:16.320] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:45:16.320] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:93:0) after 1m0s
[00:46:16.349] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:93:0)
[00:46:16.349] Timer tick, asking Buildbucket for the build status
[00:46:16.437] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:46:16.437] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:94:0) after 1m0s
[00:47:16.469] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:94:0)
[00:47:16.469] Timer tick, asking Buildbucket for the build status
[00:47:16.554] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:47:16.554] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:95:0) after 1m0s
[00:48:16.602] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:95:0)
[00:48:16.602] Timer tick, asking Buildbucket for the build status
[00:48:16.704] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:48:16.704] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:96:0) after 1m0s
[00:49:16.809] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:96:0)
[00:49:16.809] Timer tick, asking Buildbucket for the build status
[00:49:16.960] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:49:16.960] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:97:0) after 1m0s
[00:50:16.982] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:97:0)
[00:50:16.982] Timer tick, asking Buildbucket for the build status
[00:50:17.094] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:50:17.094] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:98:0) after 1m0s
[00:51:17.209] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:98:0)
[00:51:17.209] Timer tick, asking Buildbucket for the build status
[00:51:17.328] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:51:17.328] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:99:0) after 1m0s
[00:52:17.391] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:99:0)
[00:52:17.391] Timer tick, asking Buildbucket for the build status
[00:52:17.535] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:52:17.535] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:100:0) after 1m0s
[00:53:17.603] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:100:0)
[00:53:17.603] Timer tick, asking Buildbucket for the build status
[00:53:17.697] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:53:17.697] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:101:0) after 1m0s
[00:54:17.733] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:101:0)
[00:54:17.733] Timer tick, asking Buildbucket for the build status
[00:54:17.824] Build 8858087965214311776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:54:17.824] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:102:0) after 1m0s
[00:55:10.705] Received PubSub notification, asking Buildbucket for the build status
[00:55:10.801] Build 8858087965214311776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:17.896] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:102:0)
[00:55:17.896] Timer tick, asking Buildbucket for the build status
[00:55:18.101] Build 8858087965214311776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:18.101] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:104:0) after 1m0s
[00:56:18.125] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:104:0)
[00:56:18.125] Timer tick, asking Buildbucket for the build status
[00:56:18.228] Build 8858087965214311776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:18.228] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:105:0) after 1m0s
[00:57:18.303] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:105:0)
[00:57:18.303] Timer tick, asking Buildbucket for the build status
[00:57:18.409] Build 8858087965214311776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:18.409] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9023518027171333232:106:0) after 1m0s
[00:57:26.495] Received PubSub notification, asking Buildbucket for the build status
[00:57:26.589] Build 8858087965214311776: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:57:26.589] Buildbucket build:
{
"build": {
"bucket": "luci.v8.ci",
"canary_preference": "PROD",
"completed_ts": "1610672243862629",
"created_by": "project:v8",
"created_ts": "1610666037315396",
"id": "8858087965214311776",
"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\": \"e451d996fb398622bdf73fbb5757bb95c445963b\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@e451d996fb398622bdf73fbb5757bb95c445963b\", \"title\": \"e451d996fb398622bdf73fbb5757bb95c445963b\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/e451d996fb398622bdf73fbb5757bb95c445963b\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"e451d996fb398622bdf73fbb5757bb95c445963b\"}}",
"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\": \"e451d996fb398622bdf73fbb5757bb95c445963b\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@e451d996fb398622bdf73fbb5757bb95c445963b\", \"title\": \"e451d996fb398622bdf73fbb5757bb95c445963b\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/e451d996fb398622bdf73fbb5757bb95c445963b\"}]}, \"bot_id\": \"dev-luci-chromium-ci-win10-0-1gy8\", \"branch\": \"refs/heads/master\", \"builder_group\": \"client.v8\", \"buildername\": \"V8 Win64 - dev image\", \"buildnumber\": 234, \"got_revision\": \"e451d996fb398622bdf73fbb5757bb95c445963b\", \"got_revision_cp\": \"refs/heads/master@{#72103}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"path_config\": \"generic\", \"recipe\": \"v8\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"e451d996fb398622bdf73fbb5757bb95c445963b\"}, \"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-1gy8\"], \"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\": [\"5666-679c9bd\"], \"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": "1610672105920146",
"status": "COMPLETED",
"status_changed_ts": "1610672244163518",
"tags": [
"build_address:luci.v8.ci/V8 Win64 - dev image/234",
"builder:V8 Win64 - dev image",
"buildset:commit/git/e451d996fb398622bdf73fbb5757bb95c445963b",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/e451d996fb398622bdf73fbb5757bb95c445963b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023518027171333232",
"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/8858087965214311776/+/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:511bfedd19c04710",
"user_agent:luci-scheduler-dev"
],
"updated_ts": "1610672244178312",
"url": "https://luci-milo-dev.appspot.com/b/8858087965214311776",
"utcnow_ts": "1610672246581773"
}
}
[00:57:26.589] Invocation finished in 1h43m30.523408445s with status SUCCEEDED