[03:40:22.046] New invocation is queued and will start shortly
[03:40:23.151] Starting the invocation (attempt 1)
[03:40:23.246] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[03:40:23.246] PubSub topic is "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
[03:40:23.247] Buildbucket request:
{
"bucket": "luci.v8.ci",
"client_operation_id": "9021145743548619808",
"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\":\"ddb7d3079ca3036adef754c378bc3f0d1259db04\"},\"id\":\"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@ddb7d3079ca3036adef754c378bc3f0d1259db04\",\"title\":\"ddb7d3079ca3036adef754c378bc3f0d1259db04\",\"url\":\"https://chromium.googlesource.com/v8/v8/+/ddb7d3079ca3036adef754c378bc3f0d1259db04\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/v8/v8\",\"revision\":\"ddb7d3079ca3036adef754c378bc3f0d1259db04\"}}",
"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:9021145743548619808",
"scheduler_job_id:v8/V8 Win64 - dev image",
"user_agent:luci-scheduler-dev",
"buildset:commit/git/ddb7d3079ca3036adef754c378bc3f0d1259db04",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/ddb7d3079ca3036adef754c378bc3f0d1259db04",
"gitiles_ref:refs/heads/master"
]
}
[03:40:23.880] Buildbucket response:
{
"build": {
"bucket": "luci.v8.ci",
"canary_preference": "PROD",
"created_by": "project:v8",
"created_ts": "1612928423361151",
"id": "8855715681504101280",
"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\": \"ddb7d3079ca3036adef754c378bc3f0d1259db04\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@ddb7d3079ca3036adef754c378bc3f0d1259db04\", \"title\": \"ddb7d3079ca3036adef754c378bc3f0d1259db04\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/ddb7d3079ca3036adef754c378bc3f0d1259db04\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"ddb7d3079ca3036adef754c378bc3f0d1259db04\"}}",
"project": "v8",
"result_details_json": "{\"properties\": {}}",
"service_account": "v8-ci-builder-dev@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612928423748290",
"tags": [
"build_address:luci.v8.ci/V8 Win64 - dev image/453",
"builder:V8 Win64 - dev image",
"buildset:commit/git/ddb7d3079ca3036adef754c378bc3f0d1259db04",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/ddb7d3079ca3036adef754c378bc3f0d1259db04",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021145743548619808",
"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/8855715681504101280/+/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": "1612928423748410",
"url": "https://luci-milo-dev.appspot.com/b/8855715681504101280",
"utcnow_ts": "1612928423870615"
}
}
[03:40:23.880] Task URL: https://luci-milo-dev.appspot.com/b/8855715681504101280
[03:40:23.880] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:2:0) after 1m0s
[03:41:23.899] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:2:0)
[03:41:23.899] Timer tick, asking Buildbucket for the build status
[03:41:25.015] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:41:25.015] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:3:0) after 1m0s
[03:42:25.153] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:3:0)
[03:42:25.153] Timer tick, asking Buildbucket for the build status
[03:42:25.300] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:42:25.300] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:4:0) after 1m0s
[03:43:25.342] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:4:0)
[03:43:25.342] Timer tick, asking Buildbucket for the build status
[03:43:25.430] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:43:25.430] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:5:0) after 1m0s
[03:44:25.455] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:5:0)
[03:44:25.455] Timer tick, asking Buildbucket for the build status
[03:44:25.538] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:44:25.538] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:6:0) after 1m0s
[03:45:25.560] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:6:0)
[03:45:25.560] Timer tick, asking Buildbucket for the build status
[03:45:25.647] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:45:25.647] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:7:0) after 1m0s
[03:46:25.746] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:7:0)
[03:46:25.746] Timer tick, asking Buildbucket for the build status
[03:46:25.912] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:46:25.912] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:8:0) after 1m0s
[03:47:25.936] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:8:0)
[03:47:25.936] Timer tick, asking Buildbucket for the build status
[03:47:26.052] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:47:26.052] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:9:0) after 1m0s
[03:48:26.139] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:9:0)
[03:48:26.139] Timer tick, asking Buildbucket for the build status
[03:48:26.218] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:48:26.218] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:10:0) after 1m0s
[03:49:26.240] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:10:0)
[03:49:26.240] Timer tick, asking Buildbucket for the build status
[03:49:26.333] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:49:26.333] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:11:0) after 1m0s
[03:50:26.448] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:11:0)
[03:50:26.448] Timer tick, asking Buildbucket for the build status
[03:50:26.541] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:50:26.541] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:12:0) after 1m0s
[03:51:26.630] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:12:0)
[03:51:26.630] Timer tick, asking Buildbucket for the build status
[03:51:26.823] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:51:26.823] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:13:0) after 1m0s
[03:52:26.942] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:13:0)
[03:52:26.942] Timer tick, asking Buildbucket for the build status
[03:52:27.103] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:52:27.104] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:14:0) after 1m0s
[03:53:27.129] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:14:0)
[03:53:27.129] Timer tick, asking Buildbucket for the build status
[03:53:27.312] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:53:27.312] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:15:0) after 1m0s
[03:54:27.354] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:15:0)
[03:54:27.354] Timer tick, asking Buildbucket for the build status
[03:54:27.451] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:54:27.451] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:16:0) after 1m0s
[03:55:27.531] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:16:0)
[03:55:27.531] Timer tick, asking Buildbucket for the build status
[03:55:27.624] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:55:27.624] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:17:0) after 1m0s
[03:56:27.730] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:17:0)
[03:56:27.730] Timer tick, asking Buildbucket for the build status
[03:56:27.830] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:56:27.830] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:18:0) after 1m0s
[03:57:27.859] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:18:0)
[03:57:27.859] Timer tick, asking Buildbucket for the build status
[03:57:27.959] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:57:27.959] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:19:0) after 1m0s
[03:58:28.036] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:19:0)
[03:58:28.036] Timer tick, asking Buildbucket for the build status
[03:58:28.125] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:58:28.125] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:20:0) after 1m0s
[03:59:28.230] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:20:0)
[03:59:28.230] Timer tick, asking Buildbucket for the build status
[03:59:28.391] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:59:28.391] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:21:0) after 1m0s
[04:00:28.435] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:21:0)
[04:00:28.435] Timer tick, asking Buildbucket for the build status
[04:00:28.532] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:00:28.532] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:22:0) after 1m0s
[04:01:28.639] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:22:0)
[04:01:28.639] Timer tick, asking Buildbucket for the build status
[04:01:28.739] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:01:28.739] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:23:0) after 1m0s
[04:02:28.837] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:23:0)
[04:02:28.837] Timer tick, asking Buildbucket for the build status
[04:02:28.920] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:02:28.920] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:24:0) after 1m0s
[04:03:28.954] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:24:0)
[04:03:28.954] Timer tick, asking Buildbucket for the build status
[04:03:29.037] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:03:29.037] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:25:0) after 1m0s
[04:04:29.149] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:25:0)
[04:04:29.149] Timer tick, asking Buildbucket for the build status
[04:04:29.308] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:04:29.308] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:26:0) after 1m0s
[04:05:29.343] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:26:0)
[04:05:29.343] Timer tick, asking Buildbucket for the build status
[04:05:29.437] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:05:29.437] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:27:0) after 1m0s
[04:06:29.543] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:27:0)
[04:06:29.543] Timer tick, asking Buildbucket for the build status
[04:06:29.647] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:06:29.647] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:28:0) after 1m0s
[04:07:29.741] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:28:0)
[04:07:29.741] Timer tick, asking Buildbucket for the build status
[04:07:29.836] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:07:29.836] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:29:0) after 1m0s
[04:08:29.865] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:29:0)
[04:08:29.865] Timer tick, asking Buildbucket for the build status
[04:08:29.985] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:08:29.985] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:30:0) after 1m0s
[04:09:30.051] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:30:0)
[04:09:30.051] Timer tick, asking Buildbucket for the build status
[04:09:30.152] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:09:30.152] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:31:0) after 1m0s
[04:10:30.174] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:31:0)
[04:10:30.174] Timer tick, asking Buildbucket for the build status
[04:10:30.258] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:10:30.258] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:32:0) after 1m0s
[04:11:30.291] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:32:0)
[04:11:30.291] Timer tick, asking Buildbucket for the build status
[04:11:30.377] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:11:30.377] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:33:0) after 1m0s
[04:12:30.444] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:33:0)
[04:12:30.444] Timer tick, asking Buildbucket for the build status
[04:12:30.573] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:12:30.573] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:34:0) after 1m0s
[04:13:30.632] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:34:0)
[04:13:30.632] Timer tick, asking Buildbucket for the build status
[04:13:30.785] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:13:30.785] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:35:0) after 1m0s
[04:14:30.950] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:35:0)
[04:14:30.950] Timer tick, asking Buildbucket for the build status
[04:14:31.078] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:14:31.078] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:36:0) after 1m0s
[04:15:31.166] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:36:0)
[04:15:31.166] Timer tick, asking Buildbucket for the build status
[04:15:31.244] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:15:31.244] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:37:0) after 1m0s
[04:16:31.282] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:37:0)
[04:16:31.282] Timer tick, asking Buildbucket for the build status
[04:16:31.373] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:16:31.373] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:38:0) after 1m0s
[04:17:31.431] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:38:0)
[04:17:31.431] Timer tick, asking Buildbucket for the build status
[04:17:31.556] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:17:31.556] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:39:0) after 1m0s
[04:18:31.745] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:39:0)
[04:18:31.745] Timer tick, asking Buildbucket for the build status
[04:18:31.968] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:18:31.968] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:40:0) after 1m0s
[04:19:32.036] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:40:0)
[04:19:32.036] Timer tick, asking Buildbucket for the build status
[04:19:32.154] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:19:32.154] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:41:0) after 1m0s
[04:20:32.195] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:41:0)
[04:20:32.195] Timer tick, asking Buildbucket for the build status
[04:20:32.332] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:20:32.332] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:42:0) after 1m0s
[04:21:32.443] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:42:0)
[04:21:32.443] Timer tick, asking Buildbucket for the build status
[04:21:32.644] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:21:32.644] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:43:0) after 1m0s
[04:22:32.746] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:43:0)
[04:22:32.746] Timer tick, asking Buildbucket for the build status
[04:22:32.869] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:22:32.869] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:44:0) after 1m0s
[04:23:32.930] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:44:0)
[04:23:32.930] Timer tick, asking Buildbucket for the build status
[04:23:33.055] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:23:33.055] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:45:0) after 1m0s
[04:24:33.149] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:45:0)
[04:24:33.149] Timer tick, asking Buildbucket for the build status
[04:24:33.349] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:24:33.349] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:46:0) after 1m0s
[04:25:33.446] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:46:0)
[04:25:33.446] Timer tick, asking Buildbucket for the build status
[04:25:33.554] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:25:33.554] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:47:0) after 1m0s
[04:26:33.653] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:47:0)
[04:26:33.653] Timer tick, asking Buildbucket for the build status
[04:26:33.865] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:26:33.865] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:48:0) after 1m0s
[04:27:33.955] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:48:0)
[04:27:33.955] Timer tick, asking Buildbucket for the build status
[04:27:34.191] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:27:34.191] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:49:0) after 1m0s
[04:28:34.212] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:49:0)
[04:28:34.212] Timer tick, asking Buildbucket for the build status
[04:28:34.320] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:28:34.320] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:50:0) after 1m0s
[04:29:34.364] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:50:0)
[04:29:34.364] Timer tick, asking Buildbucket for the build status
[04:29:34.465] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:29:34.466] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:51:0) after 1m0s
[04:30:34.561] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:51:0)
[04:30:34.561] Timer tick, asking Buildbucket for the build status
[04:30:34.682] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:30:34.682] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:52:0) after 1m0s
[04:31:34.744] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:52:0)
[04:31:34.744] Timer tick, asking Buildbucket for the build status
[04:31:34.857] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:31:34.857] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:53:0) after 1m0s
[04:32:34.892] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:53:0)
[04:32:34.892] Timer tick, asking Buildbucket for the build status
[04:32:35.000] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:32:35.000] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:54:0) after 1m0s
[04:33:35.040] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:54:0)
[04:33:35.040] Timer tick, asking Buildbucket for the build status
[04:33:35.152] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:33:35.152] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:55:0) after 1m0s
[04:34:35.251] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:55:0)
[04:34:35.251] Timer tick, asking Buildbucket for the build status
[04:34:35.389] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:34:35.389] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:56:0) after 1m0s
[04:35:35.444] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:56:0)
[04:35:35.444] Timer tick, asking Buildbucket for the build status
[04:35:35.549] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:35:35.549] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:57:0) after 1m0s
[04:36:35.643] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:57:0)
[04:36:35.643] Timer tick, asking Buildbucket for the build status
[04:36:35.737] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:36:35.737] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:58:0) after 1m0s
[04:37:35.845] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:58:0)
[04:37:35.845] Timer tick, asking Buildbucket for the build status
[04:37:35.947] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:37:35.947] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:59:0) after 1m0s
[04:38:36.047] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:59:0)
[04:38:36.047] Timer tick, asking Buildbucket for the build status
[04:38:36.166] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:38:36.166] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:60:0) after 1m0s
[04:39:36.231] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:60:0)
[04:39:36.231] Timer tick, asking Buildbucket for the build status
[04:39:36.351] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:39:36.351] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:61:0) after 1m0s
[04:40:36.441] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:61:0)
[04:40:36.441] Timer tick, asking Buildbucket for the build status
[04:40:36.560] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:40:36.561] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:62:0) after 1m0s
[04:41:36.584] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:62:0)
[04:41:36.584] Timer tick, asking Buildbucket for the build status
[04:41:36.693] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:41:36.693] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:63:0) after 1m0s
[04:42:36.733] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:63:0)
[04:42:36.733] Timer tick, asking Buildbucket for the build status
[04:42:36.849] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:42:36.849] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:64:0) after 1m0s
[04:43:36.874] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:64:0)
[04:43:36.874] Timer tick, asking Buildbucket for the build status
[04:43:37.002] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:43:37.002] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:65:0) after 1m0s
[04:44:37.038] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:65:0)
[04:44:37.038] Timer tick, asking Buildbucket for the build status
[04:44:37.140] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:44:37.140] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:66:0) after 1m0s
[04:45:37.165] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:66:0)
[04:45:37.165] Timer tick, asking Buildbucket for the build status
[04:45:37.277] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:45:37.277] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:67:0) after 1m0s
[04:46:37.308] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:67:0)
[04:46:37.308] Timer tick, asking Buildbucket for the build status
[04:46:37.424] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:46:37.424] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:68:0) after 1m0s
[04:47:37.553] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:68:0)
[04:47:37.553] Timer tick, asking Buildbucket for the build status
[04:47:37.696] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:47:37.696] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:69:0) after 1m0s
[04:48:37.731] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:69:0)
[04:48:37.731] Timer tick, asking Buildbucket for the build status
[04:48:37.828] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:48:37.828] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:70:0) after 1m0s
[04:49:37.933] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:70:0)
[04:49:37.933] Timer tick, asking Buildbucket for the build status
[04:49:38.032] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:49:38.032] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:71:0) after 1m0s
[04:50:38.079] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:71:0)
[04:50:38.079] Timer tick, asking Buildbucket for the build status
[04:50:38.234] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:50:38.234] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:72:0) after 1m0s
[04:51:38.344] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:72:0)
[04:51:38.344] Timer tick, asking Buildbucket for the build status
[04:51:38.443] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:51:38.443] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:73:0) after 1m0s
[04:52:38.470] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:73:0)
[04:52:38.470] Timer tick, asking Buildbucket for the build status
[04:52:38.608] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:52:38.608] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:74:0) after 1m0s
[04:53:38.644] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:74:0)
[04:53:38.644] Timer tick, asking Buildbucket for the build status
[04:53:38.741] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:53:38.742] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:75:0) after 1m0s
[04:54:38.841] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:75:0)
[04:54:38.841] Timer tick, asking Buildbucket for the build status
[04:54:38.990] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:54:38.990] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:76:0) after 1m0s
[04:55:39.044] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:76:0)
[04:55:39.044] Timer tick, asking Buildbucket for the build status
[04:55:39.165] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:55:39.165] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:77:0) after 1m0s
[04:56:39.231] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:77:0)
[04:56:39.231] Timer tick, asking Buildbucket for the build status
[04:56:39.353] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:56:39.353] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:78:0) after 1m0s
[04:57:39.447] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:78:0)
[04:57:39.447] Timer tick, asking Buildbucket for the build status
[04:57:39.552] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:57:39.552] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:79:0) after 1m0s
[04:58:39.576] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:79:0)
[04:58:39.576] Timer tick, asking Buildbucket for the build status
[04:58:39.700] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:58:39.700] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:80:0) after 1m0s
[04:59:39.738] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:80:0)
[04:59:39.738] Timer tick, asking Buildbucket for the build status
[04:59:39.831] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:59:39.831] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:81:0) after 1m0s
[05:00:39.855] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:81:0)
[05:00:39.855] Timer tick, asking Buildbucket for the build status
[05:00:40.012] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:00:40.012] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:82:0) after 1m0s
[05:01:40.052] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:82:0)
[05:01:40.052] Timer tick, asking Buildbucket for the build status
[05:01:40.169] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:01:40.169] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:83:0) after 1m0s
[05:02:40.240] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:83:0)
[05:02:40.240] Timer tick, asking Buildbucket for the build status
[05:02:40.355] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:02:40.355] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:84:0) after 1m0s
[05:03:40.384] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:84:0)
[05:03:40.384] Timer tick, asking Buildbucket for the build status
[05:03:40.525] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:03:40.525] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:85:0) after 1m0s
[05:04:40.553] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:85:0)
[05:04:40.553] Timer tick, asking Buildbucket for the build status
[05:04:40.691] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:04:40.691] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:86:0) after 1m0s
[05:05:40.714] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:86:0)
[05:05:40.714] Timer tick, asking Buildbucket for the build status
[05:05:40.808] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:05:40.808] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:87:0) after 1m0s
[05:06:40.855] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:87:0)
[05:06:40.855] Timer tick, asking Buildbucket for the build status
[05:06:40.994] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:06:40.994] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:88:0) after 1m0s
[05:07:41.046] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:88:0)
[05:07:41.046] Timer tick, asking Buildbucket for the build status
[05:07:41.146] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:07:41.146] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:89:0) after 1m0s
[05:08:41.255] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:89:0)
[05:08:41.255] Timer tick, asking Buildbucket for the build status
[05:08:41.350] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:08:41.350] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:90:0) after 1m0s
[05:09:41.467] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:90:0)
[05:09:41.467] Timer tick, asking Buildbucket for the build status
[05:09:41.602] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:09:41.602] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:91:0) after 1m0s
[05:10:41.644] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:91:0)
[05:10:41.644] Timer tick, asking Buildbucket for the build status
[05:10:41.760] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:10:41.761] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:92:0) after 1m0s
[05:11:41.824] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:92:0)
[05:11:41.824] Timer tick, asking Buildbucket for the build status
[05:11:41.925] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:11:41.925] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:93:0) after 1m0s
[05:12:42.050] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:93:0)
[05:12:42.050] Timer tick, asking Buildbucket for the build status
[05:12:42.159] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:12:42.159] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:94:0) after 1m0s
[05:13:42.185] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:94:0)
[05:13:42.185] Timer tick, asking Buildbucket for the build status
[05:13:42.286] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:13:42.286] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:95:0) after 1m0s
[05:14:42.349] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:95:0)
[05:14:42.349] Timer tick, asking Buildbucket for the build status
[05:14:42.472] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:14:42.472] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:96:0) after 1m0s
[05:15:42.531] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:96:0)
[05:15:42.531] Timer tick, asking Buildbucket for the build status
[05:15:42.634] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:15:42.634] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:97:0) after 1m0s
[05:16:42.666] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:97:0)
[05:16:42.666] Timer tick, asking Buildbucket for the build status
[05:16:42.784] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:16:42.784] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:98:0) after 1m0s
[05:17:42.822] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:98:0)
[05:17:42.822] Timer tick, asking Buildbucket for the build status
[05:17:42.962] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:17:42.962] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:99:0) after 1m0s
[05:18:43.046] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:99:0)
[05:18:43.046] Timer tick, asking Buildbucket for the build status
[05:18:43.164] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:18:43.164] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:100:0) after 1m0s
[05:19:43.254] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:100:0)
[05:19:43.254] Timer tick, asking Buildbucket for the build status
[05:19:43.379] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:19:43.379] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:101:0) after 1m0s
[05:20:43.454] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:101:0)
[05:20:43.454] Timer tick, asking Buildbucket for the build status
[05:20:43.567] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:20:43.567] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:102:0) after 1m0s
[05:21:43.646] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:102:0)
[05:21:43.646] Timer tick, asking Buildbucket for the build status
[05:21:43.756] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:21:43.756] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:103:0) after 1m0s
[05:22:43.785] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:103:0)
[05:22:43.785] Timer tick, asking Buildbucket for the build status
[05:22:43.906] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:22:43.906] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:104:0) after 1m0s
[05:23:43.951] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:104:0)
[05:23:43.951] Timer tick, asking Buildbucket for the build status
[05:23:44.060] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:23:44.060] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:105:0) after 1m0s
[05:24:44.132] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:105:0)
[05:24:44.132] Timer tick, asking Buildbucket for the build status
[05:24:44.250] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:24:44.250] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:106:0) after 1m0s
[05:25:44.286] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:106:0)
[05:25:44.286] Timer tick, asking Buildbucket for the build status
[05:25:44.405] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:25:44.405] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:107:0) after 1m0s
[05:26:44.449] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:107:0)
[05:26:44.449] Timer tick, asking Buildbucket for the build status
[05:26:44.561] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:26:44.561] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:108:0) after 1m0s
[05:27:44.641] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:108:0)
[05:27:44.641] Timer tick, asking Buildbucket for the build status
[05:27:44.751] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:27:44.751] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:109:0) after 1m0s
[05:28:44.844] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:109:0)
[05:28:44.844] Timer tick, asking Buildbucket for the build status
[05:28:44.948] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:28:44.948] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:110:0) after 1m0s
[05:29:45.039] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:110:0)
[05:29:45.039] Timer tick, asking Buildbucket for the build status
[05:29:45.235] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:29:45.235] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:111:0) after 1m0s
[05:30:45.331] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:111:0)
[05:30:45.331] Timer tick, asking Buildbucket for the build status
[05:30:45.452] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:30:45.452] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:112:0) after 1m0s
[05:31:45.543] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:112:0)
[05:31:45.543] Timer tick, asking Buildbucket for the build status
[05:31:45.648] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:31:45.648] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:113:0) after 1m0s
[05:32:45.745] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:113:0)
[05:32:45.745] Timer tick, asking Buildbucket for the build status
[05:32:45.819] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:32:45.819] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:114:0) after 1m0s
[05:33:45.847] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:114:0)
[05:33:45.847] Timer tick, asking Buildbucket for the build status
[05:33:45.959] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:33:45.959] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:115:0) after 1m0s
[05:34:46.048] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:115:0)
[05:34:46.048] Timer tick, asking Buildbucket for the build status
[05:34:46.161] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:34:46.161] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:116:0) after 1m0s
[05:35:46.260] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:116:0)
[05:35:46.260] Timer tick, asking Buildbucket for the build status
[05:35:46.619] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:35:46.619] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:117:0) after 1m0s
[05:36:46.648] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:117:0)
[05:36:46.648] Timer tick, asking Buildbucket for the build status
[05:36:46.758] Build 8855715681504101280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:36:46.758] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:118:0) after 1m0s
[05:37:37.883] Received PubSub notification, asking Buildbucket for the build status
[05:37:37.973] Build 8855715681504101280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:46.850] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:118:0)
[05:37:46.850] Timer tick, asking Buildbucket for the build status
[05:37:46.968] Build 8855715681504101280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:46.968] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:120:0) after 1m0s
[05:38:47.033] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:120:0)
[05:38:47.033] Timer tick, asking Buildbucket for the build status
[05:38:47.203] Build 8855715681504101280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:47.203] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:121:0) after 1m0s
[05:39:47.242] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:121:0)
[05:39:47.242] Timer tick, asking Buildbucket for the build status
[05:39:47.363] Build 8855715681504101280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:47.363] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:122:0) after 1m0s
[05:40:47.447] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:122:0)
[05:40:47.447] Timer tick, asking Buildbucket for the build status
[05:40:47.578] Build 8855715681504101280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:47.578] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:123:0) after 1m0s
[05:41:47.650] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:123:0)
[05:41:47.650] Timer tick, asking Buildbucket for the build status
[05:41:47.758] Build 8855715681504101280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:47.758] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:124:0) after 1m0s
[05:42:47.865] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:124:0)
[05:42:47.865] Timer tick, asking Buildbucket for the build status
[05:42:48.094] Build 8855715681504101280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:48.094] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:125:0) after 1m0s
[05:43:48.148] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:125:0)
[05:43:48.148] Timer tick, asking Buildbucket for the build status
[05:43:48.350] Build 8855715681504101280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:48.350] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:126:0) after 1m0s
[05:44:48.453] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:126:0)
[05:44:48.453] Timer tick, asking Buildbucket for the build status
[05:44:48.649] Build 8855715681504101280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:48.649] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:127:0) after 1m0s
[05:45:48.733] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:127:0)
[05:45:48.733] Timer tick, asking Buildbucket for the build status
[05:45:48.862] Build 8855715681504101280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:48.862] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9021145743548619808:128:0) after 1m0s
[05:46:25.262] Received PubSub notification, asking Buildbucket for the build status
[05:46:25.347] Build 8855715681504101280: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:46:25.347] Buildbucket build:
{
"build": {
"bucket": "luci.v8.ci",
"canary_preference": "PROD",
"completed_ts": "1612935981510349",
"created_by": "project:v8",
"created_ts": "1612928423361151",
"id": "8855715681504101280",
"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\": \"ddb7d3079ca3036adef754c378bc3f0d1259db04\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@ddb7d3079ca3036adef754c378bc3f0d1259db04\", \"title\": \"ddb7d3079ca3036adef754c378bc3f0d1259db04\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/ddb7d3079ca3036adef754c378bc3f0d1259db04\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"ddb7d3079ca3036adef754c378bc3f0d1259db04\"}}",
"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\": \"ddb7d3079ca3036adef754c378bc3f0d1259db04\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@ddb7d3079ca3036adef754c378bc3f0d1259db04\", \"title\": \"ddb7d3079ca3036adef754c378bc3f0d1259db04\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/ddb7d3079ca3036adef754c378bc3f0d1259db04\"}]}, \"bot_id\": \"dev-luci-chromium-ci-win10-0-xhcv\", \"branch\": \"refs/heads/master\", \"builder_group\": \"client.v8\", \"buildername\": \"V8 Win64 - dev image\", \"buildnumber\": 453, \"got_revision\": \"ddb7d3079ca3036adef754c378bc3f0d1259db04\", \"got_revision_cp\": \"refs/heads/master@{#72616}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"path_config\": \"generic\", \"recipe\": \"v8\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"ddb7d3079ca3036adef754c378bc3f0d1259db04\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_82ed111fed7ea8169e482f00b5f3e5338a65daa41208585de67cb0a736b1d538_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-xhcv\"], \"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\": [\"5689-3f07daa\"], \"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": "1612935455832280",
"status": "COMPLETED",
"status_changed_ts": "1612935982975169",
"tags": [
"build_address:luci.v8.ci/V8 Win64 - dev image/453",
"builder:V8 Win64 - dev image",
"buildset:commit/git/ddb7d3079ca3036adef754c378bc3f0d1259db04",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/ddb7d3079ca3036adef754c378bc3f0d1259db04",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021145743548619808",
"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/8855715681504101280/+/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:51a2d82028475b10",
"user_agent:luci-scheduler-dev"
],
"updated_ts": "1612935982987145",
"url": "https://luci-milo-dev.appspot.com/b/8855715681504101280",
"utcnow_ts": "1612935985339949"
}
}
[05:46:25.347] Invocation finished in 2h6m3.318576988s with status SUCCEEDED