[18:24:46.296] New invocation is queued and will start shortly
[18:24:47.430] Starting the invocation (attempt 1)
[18:24:47.508] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[18:24:47.508] PubSub topic is "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
[18:24:47.508] Buildbucket request:
{
"bucket": "luci.v8.ci",
"client_operation_id": "9018553386592630320",
"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\":\"f80b29204ccba5953307139c8ad3c304b2554fe0\"},\"id\":\"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@f80b29204ccba5953307139c8ad3c304b2554fe0\",\"title\":\"f80b29204ccba5953307139c8ad3c304b2554fe0\",\"url\":\"https://chromium.googlesource.com/v8/v8/+/f80b29204ccba5953307139c8ad3c304b2554fe0\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/v8/v8\",\"revision\":\"668513d8abe24d0d1127afbb81a1aa6fbd7ad0a1\"},\"id\":\"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@668513d8abe24d0d1127afbb81a1aa6fbd7ad0a1\",\"title\":\"668513d8abe24d0d1127afbb81a1aa6fbd7ad0a1\",\"url\":\"https://chromium.googlesource.com/v8/v8/+/668513d8abe24d0d1127afbb81a1aa6fbd7ad0a1\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/v8/v8\",\"revision\":\"668513d8abe24d0d1127afbb81a1aa6fbd7ad0a1\"}}",
"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:9018553386592630320",
"scheduler_job_id:v8/V8 Win64 - dev image",
"user_agent:luci-scheduler-dev",
"buildset:commit/git/668513d8abe24d0d1127afbb81a1aa6fbd7ad0a1",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/668513d8abe24d0d1127afbb81a1aa6fbd7ad0a1",
"gitiles_ref:refs/heads/master"
]
}
[18:24:48.151] Buildbucket response:
{
"build": {
"bucket": "luci.v8.ci",
"canary_preference": "PROD",
"created_by": "project:v8",
"created_ts": "1615400687657332",
"id": "8853123324498039552",
"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\": \"f80b29204ccba5953307139c8ad3c304b2554fe0\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@f80b29204ccba5953307139c8ad3c304b2554fe0\", \"title\": \"f80b29204ccba5953307139c8ad3c304b2554fe0\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/f80b29204ccba5953307139c8ad3c304b2554fe0\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"668513d8abe24d0d1127afbb81a1aa6fbd7ad0a1\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@668513d8abe24d0d1127afbb81a1aa6fbd7ad0a1\", \"title\": \"668513d8abe24d0d1127afbb81a1aa6fbd7ad0a1\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/668513d8abe24d0d1127afbb81a1aa6fbd7ad0a1\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"668513d8abe24d0d1127afbb81a1aa6fbd7ad0a1\"}}",
"project": "v8",
"result_details_json": "{\"properties\": {}}",
"service_account": "v8-ci-builder-dev@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615400688027083",
"tags": [
"build_address:luci.v8.ci/V8 Win64 - dev image/720",
"builder:V8 Win64 - dev image",
"buildset:commit/git/668513d8abe24d0d1127afbb81a1aa6fbd7ad0a1",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/668513d8abe24d0d1127afbb81a1aa6fbd7ad0a1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018553386592630320",
"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/8853123324498039552/+/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": "1615400688027191",
"url": "https://luci-milo-dev.appspot.com/b/8853123324498039552",
"utcnow_ts": "1615400688144437"
}
}
[18:24:48.151] Task URL: https://luci-milo-dev.appspot.com/b/8853123324498039552
[18:24:48.151] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:2:0) after 1m0s
[18:25:48.241] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:2:0)
[18:25:48.241] Timer tick, asking Buildbucket for the build status
[18:25:48.312] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:25:48.312] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:3:0) after 1m0s
[18:26:48.329] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:3:0)
[18:26:48.329] Timer tick, asking Buildbucket for the build status
[18:26:48.399] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:26:48.399] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:4:0) after 1m0s
[18:27:48.431] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:4:0)
[18:27:48.431] Timer tick, asking Buildbucket for the build status
[18:27:48.517] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:27:48.517] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:5:0) after 1m0s
[18:28:48.543] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:5:0)
[18:28:48.543] Timer tick, asking Buildbucket for the build status
[18:28:48.615] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:28:48.615] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:6:0) after 1m0s
[18:29:48.640] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:6:0)
[18:29:48.640] Timer tick, asking Buildbucket for the build status
[18:29:48.721] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:29:48.721] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:7:0) after 1m0s
[18:30:48.738] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:7:0)
[18:30:48.738] Timer tick, asking Buildbucket for the build status
[18:30:48.803] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:30:48.803] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:8:0) after 1m0s
[18:31:48.821] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:8:0)
[18:31:48.821] Timer tick, asking Buildbucket for the build status
[18:31:48.925] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:31:48.925] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:9:0) after 1m0s
[18:32:48.944] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:9:0)
[18:32:48.944] Timer tick, asking Buildbucket for the build status
[18:32:49.018] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:32:49.018] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:10:0) after 1m0s
[18:33:49.037] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:10:0)
[18:33:49.037] Timer tick, asking Buildbucket for the build status
[18:33:49.112] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:33:49.112] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:11:0) after 1m0s
[18:34:49.167] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:11:0)
[18:34:49.167] Timer tick, asking Buildbucket for the build status
[18:34:49.244] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:34:49.244] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:12:0) after 1m0s
[18:35:49.341] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:12:0)
[18:35:49.341] Timer tick, asking Buildbucket for the build status
[18:35:49.495] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:35:49.495] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:13:0) after 1m0s
[18:36:49.543] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:13:0)
[18:36:49.543] Timer tick, asking Buildbucket for the build status
[18:36:49.732] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:36:49.732] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:14:0) after 1m0s
[18:37:49.835] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:14:0)
[18:37:49.835] Timer tick, asking Buildbucket for the build status
[18:37:49.907] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:37:49.907] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:15:0) after 1m0s
[18:38:49.931] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:15:0)
[18:38:49.931] Timer tick, asking Buildbucket for the build status
[18:38:50.037] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:38:50.037] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:16:0) after 1m0s
[18:39:50.054] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:16:0)
[18:39:50.054] Timer tick, asking Buildbucket for the build status
[18:39:50.121] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:39:50.121] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:17:0) after 1m0s
[18:40:50.144] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:17:0)
[18:40:50.144] Timer tick, asking Buildbucket for the build status
[18:40:50.251] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:40:50.251] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:18:0) after 1m0s
[18:41:50.341] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:18:0)
[18:41:50.341] Timer tick, asking Buildbucket for the build status
[18:41:50.420] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:41:50.420] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:19:0) after 1m0s
[18:42:50.462] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:19:0)
[18:42:50.462] Timer tick, asking Buildbucket for the build status
[18:42:50.601] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:42:50.601] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:20:0) after 1m0s
[18:43:50.645] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:20:0)
[18:43:50.645] Timer tick, asking Buildbucket for the build status
[18:43:50.726] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:43:50.726] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:21:0) after 1m0s
[18:44:50.853] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:21:0)
[18:44:50.853] Timer tick, asking Buildbucket for the build status
[18:44:50.994] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:44:50.994] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:22:0) after 1m0s
[18:45:51.035] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:22:0)
[18:45:51.035] Timer tick, asking Buildbucket for the build status
[18:45:51.115] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:45:51.115] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:23:0) after 1m0s
[18:46:51.136] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:23:0)
[18:46:51.136] Timer tick, asking Buildbucket for the build status
[18:46:51.226] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:46:51.226] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:24:0) after 1m0s
[18:47:51.343] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:24:0)
[18:47:51.343] Timer tick, asking Buildbucket for the build status
[18:47:51.409] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:47:51.409] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:25:0) after 1m0s
[18:48:51.466] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:25:0)
[18:48:51.466] Timer tick, asking Buildbucket for the build status
[18:48:51.548] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:48:51.548] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:26:0) after 1m0s
[18:49:51.643] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:26:0)
[18:49:51.643] Timer tick, asking Buildbucket for the build status
[18:49:51.788] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:49:51.788] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:27:0) after 1m0s
[18:50:51.849] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:27:0)
[18:50:51.849] Timer tick, asking Buildbucket for the build status
[18:50:52.006] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:50:52.006] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:28:0) after 1m0s
[18:51:52.048] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:28:0)
[18:51:52.048] Timer tick, asking Buildbucket for the build status
[18:51:52.132] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:51:52.132] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:29:0) after 1m0s
[18:52:52.151] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:29:0)
[18:52:52.151] Timer tick, asking Buildbucket for the build status
[18:52:52.246] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:52:52.246] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:30:0) after 1m0s
[18:53:52.343] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:30:0)
[18:53:52.343] Timer tick, asking Buildbucket for the build status
[18:53:52.430] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:53:52.430] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:31:0) after 1m0s
[18:54:52.537] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:31:0)
[18:54:52.537] Timer tick, asking Buildbucket for the build status
[18:54:52.609] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:54:52.609] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:32:0) after 1m0s
[18:55:52.634] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:32:0)
[18:55:52.634] Timer tick, asking Buildbucket for the build status
[18:55:52.699] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:55:52.699] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:33:0) after 1m0s
[18:56:52.734] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:33:0)
[18:56:52.734] Timer tick, asking Buildbucket for the build status
[18:56:52.821] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:56:52.821] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:34:0) after 1m0s
[18:57:52.842] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:34:0)
[18:57:52.842] Timer tick, asking Buildbucket for the build status
[18:57:53.044] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:57:53.044] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:35:0) after 1m0s
[18:58:53.146] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:35:0)
[18:58:53.146] Timer tick, asking Buildbucket for the build status
[18:58:53.216] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:58:53.216] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:36:0) after 1m0s
[18:59:53.236] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:36:0)
[18:59:53.236] Timer tick, asking Buildbucket for the build status
[18:59:53.317] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:59:53.317] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:37:0) after 1m0s
[19:00:53.348] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:37:0)
[19:00:53.348] Timer tick, asking Buildbucket for the build status
[19:00:53.412] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:00:53.412] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:38:0) after 1m0s
[19:01:53.432] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:38:0)
[19:01:53.432] Timer tick, asking Buildbucket for the build status
[19:01:53.517] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:01:53.517] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:39:0) after 1m0s
[19:02:53.537] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:39:0)
[19:02:53.537] Timer tick, asking Buildbucket for the build status
[19:02:53.634] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:02:53.634] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:40:0) after 1m0s
[19:03:53.750] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:40:0)
[19:03:53.750] Timer tick, asking Buildbucket for the build status
[19:03:53.924] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:03:53.924] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:41:0) after 1m0s
[19:04:53.944] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:41:0)
[19:04:53.944] Timer tick, asking Buildbucket for the build status
[19:04:54.100] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:04:54.100] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:42:0) after 1m0s
[19:05:54.149] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:42:0)
[19:05:54.149] Timer tick, asking Buildbucket for the build status
[19:05:54.222] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:05:54.222] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:43:0) after 1m0s
[19:06:54.248] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:43:0)
[19:06:54.248] Timer tick, asking Buildbucket for the build status
[19:06:54.326] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:06:54.326] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:44:0) after 1m0s
[19:07:54.433] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:44:0)
[19:07:54.433] Timer tick, asking Buildbucket for the build status
[19:07:54.544] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:07:54.544] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:45:0) after 1m0s
[19:08:54.574] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:45:0)
[19:08:54.574] Timer tick, asking Buildbucket for the build status
[19:08:54.649] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:08:54.649] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:46:0) after 1m0s
[19:09:54.733] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:46:0)
[19:09:54.734] Timer tick, asking Buildbucket for the build status
[19:09:54.820] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:09:54.820] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:47:0) after 1m0s
[19:10:54.843] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:47:0)
[19:10:54.843] Timer tick, asking Buildbucket for the build status
[19:10:54.925] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:10:54.925] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:48:0) after 1m0s
[19:11:54.944] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:48:0)
[19:11:54.944] Timer tick, asking Buildbucket for the build status
[19:11:55.010] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:11:55.010] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:49:0) after 1m0s
[19:12:55.042] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:49:0)
[19:12:55.042] Timer tick, asking Buildbucket for the build status
[19:12:55.120] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:12:55.120] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:50:0) after 1m0s
[19:13:55.148] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:50:0)
[19:13:55.148] Timer tick, asking Buildbucket for the build status
[19:13:55.216] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:13:55.216] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:51:0) after 1m0s
[19:14:55.246] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:51:0)
[19:14:55.246] Timer tick, asking Buildbucket for the build status
[19:14:55.330] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:14:55.330] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:52:0) after 1m0s
[19:15:55.454] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:52:0)
[19:15:55.454] Timer tick, asking Buildbucket for the build status
[19:15:55.597] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:15:55.597] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:53:0) after 1m0s
[19:16:55.616] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:53:0)
[19:16:55.616] Timer tick, asking Buildbucket for the build status
[19:16:55.737] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:16:55.737] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:54:0) after 1m0s
[19:17:55.849] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:54:0)
[19:17:55.849] Timer tick, asking Buildbucket for the build status
[19:17:55.925] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:17:55.925] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:55:0) after 1m0s
[19:18:55.948] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:55:0)
[19:18:55.948] Timer tick, asking Buildbucket for the build status
[19:18:56.112] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:18:56.112] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:56:0) after 1m0s
[19:19:56.137] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:56:0)
[19:19:56.137] Timer tick, asking Buildbucket for the build status
[19:19:56.253] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:19:56.253] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:57:0) after 1m0s
[19:20:56.343] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:57:0)
[19:20:56.343] Timer tick, asking Buildbucket for the build status
[19:20:56.430] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:20:56.431] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:58:0) after 1m0s
[19:21:56.536] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:58:0)
[19:21:56.536] Timer tick, asking Buildbucket for the build status
[19:21:56.616] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:21:56.616] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:59:0) after 1m0s
[19:22:56.645] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:59:0)
[19:22:56.645] Timer tick, asking Buildbucket for the build status
[19:22:56.733] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:22:56.733] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:60:0) after 1m0s
[19:23:56.836] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:60:0)
[19:23:56.836] Timer tick, asking Buildbucket for the build status
[19:23:56.900] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:23:56.900] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:61:0) after 1m0s
[19:24:56.958] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:61:0)
[19:24:56.958] Timer tick, asking Buildbucket for the build status
[19:24:57.051] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:24:57.051] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:62:0) after 1m0s
[19:25:57.144] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:62:0)
[19:25:57.144] Timer tick, asking Buildbucket for the build status
[19:25:57.300] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:25:57.300] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:63:0) after 1m0s
[19:26:57.324] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:63:0)
[19:26:57.324] Timer tick, asking Buildbucket for the build status
[19:26:57.424] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:26:57.424] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:64:0) after 1m0s
[19:27:57.452] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:64:0)
[19:27:57.452] Timer tick, asking Buildbucket for the build status
[19:27:57.571] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:27:57.571] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:65:0) after 1m0s
[19:28:57.649] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:65:0)
[19:28:57.649] Timer tick, asking Buildbucket for the build status
[19:28:57.752] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:28:57.752] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:66:0) after 1m0s
[19:29:57.838] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:66:0)
[19:29:57.838] Timer tick, asking Buildbucket for the build status
[19:29:57.907] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:29:57.907] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:67:0) after 1m0s
[19:30:57.928] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:67:0)
[19:30:57.928] Timer tick, asking Buildbucket for the build status
[19:30:58.046] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:30:58.046] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:68:0) after 1m0s
[19:31:58.135] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:68:0)
[19:31:58.135] Timer tick, asking Buildbucket for the build status
[19:31:58.216] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:31:58.216] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:69:0) after 1m0s
[19:32:58.244] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:69:0)
[19:32:58.244] Timer tick, asking Buildbucket for the build status
[19:32:58.317] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:32:58.317] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:70:0) after 1m0s
[19:33:58.337] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:70:0)
[19:33:58.337] Timer tick, asking Buildbucket for the build status
[19:33:58.422] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:33:58.422] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:71:0) after 1m0s
[19:34:58.450] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:71:0)
[19:34:58.450] Timer tick, asking Buildbucket for the build status
[19:34:58.597] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:34:58.597] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:72:0) after 1m0s
[19:35:58.651] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:72:0)
[19:35:58.651] Timer tick, asking Buildbucket for the build status
[19:35:58.720] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:35:58.720] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:73:0) after 1m0s
[19:36:58.757] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:73:0)
[19:36:58.757] Timer tick, asking Buildbucket for the build status
[19:36:58.922] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:36:58.922] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:74:0) after 1m0s
[19:37:58.959] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:74:0)
[19:37:58.959] Timer tick, asking Buildbucket for the build status
[19:37:59.076] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:37:59.076] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:75:0) after 1m0s
[19:38:59.136] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:75:0)
[19:38:59.136] Timer tick, asking Buildbucket for the build status
[19:38:59.213] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:38:59.213] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:76:0) after 1m0s
[19:39:59.239] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:76:0)
[19:39:59.239] Timer tick, asking Buildbucket for the build status
[19:39:59.363] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:39:59.363] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:77:0) after 1m0s
[19:40:59.446] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:77:0)
[19:40:59.446] Timer tick, asking Buildbucket for the build status
[19:40:59.511] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:40:59.511] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:78:0) after 1m0s
[19:41:59.568] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:78:0)
[19:41:59.568] Timer tick, asking Buildbucket for the build status
[19:41:59.705] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:41:59.705] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:79:0) after 1m0s
[19:42:59.749] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:79:0)
[19:42:59.749] Timer tick, asking Buildbucket for the build status
[19:42:59.819] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:42:59.819] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:80:0) after 1m0s
[19:43:59.849] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:80:0)
[19:43:59.849] Timer tick, asking Buildbucket for the build status
[19:43:59.975] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:43:59.975] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:81:0) after 1m0s
[19:45:00.035] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:81:0)
[19:45:00.035] Timer tick, asking Buildbucket for the build status
[19:45:00.206] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:45:00.206] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:82:0) after 1m0s
[19:46:00.257] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:82:0)
[19:46:00.257] Timer tick, asking Buildbucket for the build status
[19:46:00.405] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:46:00.405] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:83:0) after 1m0s
[19:47:00.458] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:83:0)
[19:47:00.458] Timer tick, asking Buildbucket for the build status
[19:47:00.707] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:47:00.707] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:84:0) after 1m0s
[19:48:00.731] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:84:0)
[19:48:00.731] Timer tick, asking Buildbucket for the build status
[19:48:00.808] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:48:00.808] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:85:0) after 1m0s
[19:49:00.877] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:85:0)
[19:49:00.877] Timer tick, asking Buildbucket for the build status
[19:49:01.004] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:49:01.004] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:86:0) after 1m0s
[19:50:01.025] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:86:0)
[19:50:01.025] Timer tick, asking Buildbucket for the build status
[19:50:01.107] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:50:01.107] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:87:0) after 1m0s
[19:51:01.139] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:87:0)
[19:51:01.139] Timer tick, asking Buildbucket for the build status
[19:51:01.203] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:51:01.203] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:88:0) after 1m0s
[19:52:01.264] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:88:0)
[19:52:01.264] Timer tick, asking Buildbucket for the build status
[19:52:01.353] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:52:01.353] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:89:0) after 1m0s
[19:53:01.377] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:89:0)
[19:53:01.377] Timer tick, asking Buildbucket for the build status
[19:53:01.462] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:53:01.462] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:90:0) after 1m0s
[19:54:01.487] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:90:0)
[19:54:01.487] Timer tick, asking Buildbucket for the build status
[19:54:01.566] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:54:01.567] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:91:0) after 1m0s
[19:55:01.649] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:91:0)
[19:55:01.649] Timer tick, asking Buildbucket for the build status
[19:55:01.722] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:55:01.722] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:92:0) after 1m0s
[19:56:01.854] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:92:0)
[19:56:01.854] Timer tick, asking Buildbucket for the build status
[19:56:02.002] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:56:02.002] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:93:0) after 1m0s
[19:57:02.052] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:93:0)
[19:57:02.052] Timer tick, asking Buildbucket for the build status
[19:57:02.134] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:57:02.134] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:94:0) after 1m0s
[19:58:02.166] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:94:0)
[19:58:02.166] Timer tick, asking Buildbucket for the build status
[19:58:02.241] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:58:02.241] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:95:0) after 1m0s
[19:59:02.271] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:95:0)
[19:59:02.271] Timer tick, asking Buildbucket for the build status
[19:59:02.342] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:59:02.342] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:96:0) after 1m0s
[20:00:02.407] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:96:0)
[20:00:02.407] Timer tick, asking Buildbucket for the build status
[20:00:02.523] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:00:02.523] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:97:0) after 1m0s
[20:01:02.547] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:97:0)
[20:01:02.547] Timer tick, asking Buildbucket for the build status
[20:01:02.727] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:01:02.727] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:98:0) after 1m0s
[20:02:02.948] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:98:0)
[20:02:02.948] Timer tick, asking Buildbucket for the build status
[20:02:03.105] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:02:03.105] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:99:0) after 1m0s
[20:03:03.156] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:99:0)
[20:03:03.156] Timer tick, asking Buildbucket for the build status
[20:03:03.236] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:03:03.236] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:100:0) after 1m0s
[20:04:03.352] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:100:0)
[20:04:03.352] Timer tick, asking Buildbucket for the build status
[20:04:03.622] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:04:03.622] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:101:0) after 1m0s
[20:05:03.658] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:101:0)
[20:05:03.658] Timer tick, asking Buildbucket for the build status
[20:05:03.742] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:05:03.742] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:102:0) after 1m0s
[20:06:03.851] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:102:0)
[20:06:03.851] Timer tick, asking Buildbucket for the build status
[20:06:03.929] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:06:03.929] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:103:0) after 1m0s
[20:07:04.055] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:103:0)
[20:07:04.055] Timer tick, asking Buildbucket for the build status
[20:07:04.131] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:07:04.131] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:104:0) after 1m0s
[20:08:04.264] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:104:0)
[20:08:04.264] Timer tick, asking Buildbucket for the build status
[20:08:04.348] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:08:04.348] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:105:0) after 1m0s
[20:09:04.371] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:105:0)
[20:09:04.371] Timer tick, asking Buildbucket for the build status
[20:09:04.461] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:09:04.461] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:106:0) after 1m0s
[20:10:04.547] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:106:0)
[20:10:04.547] Timer tick, asking Buildbucket for the build status
[20:10:04.708] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:10:04.708] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:107:0) after 1m0s
[20:11:04.749] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:107:0)
[20:11:04.749] Timer tick, asking Buildbucket for the build status
[20:11:04.930] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:11:04.930] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:108:0) after 1m0s
[20:12:05.048] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:108:0)
[20:12:05.048] Timer tick, asking Buildbucket for the build status
[20:12:05.206] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:12:05.206] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:109:0) after 1m0s
[20:13:05.258] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:109:0)
[20:13:05.258] Timer tick, asking Buildbucket for the build status
[20:13:05.404] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:13:05.404] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:110:0) after 1m0s
[20:14:05.454] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:110:0)
[20:14:05.454] Timer tick, asking Buildbucket for the build status
[20:14:05.531] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:14:05.531] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:111:0) after 1m0s
[20:15:05.668] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:111:0)
[20:15:05.668] Timer tick, asking Buildbucket for the build status
[20:15:05.809] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:15:05.809] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:112:0) after 1m0s
[20:16:05.861] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:112:0)
[20:16:05.862] Timer tick, asking Buildbucket for the build status
[20:16:05.950] Build 8853123324498039552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:16:05.950] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:113:0) after 1m0s
[20:16:12.648] Received PubSub notification, asking Buildbucket for the build status
[20:16:12.799] Build 8853123324498039552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:06.060] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:113:0)
[20:17:06.060] Timer tick, asking Buildbucket for the build status
[20:17:06.132] Build 8853123324498039552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:06.132] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:115:0) after 1m0s
[20:18:06.247] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:115:0)
[20:18:06.247] Timer tick, asking Buildbucket for the build status
[20:18:06.325] Build 8853123324498039552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:06.325] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:116:0) after 1m0s
[20:19:06.352] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:116:0)
[20:19:06.352] Timer tick, asking Buildbucket for the build status
[20:19:06.447] Build 8853123324498039552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:06.447] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:117:0) after 1m0s
[20:20:06.536] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:117:0)
[20:20:06.536] Timer tick, asking Buildbucket for the build status
[20:20:06.645] Build 8853123324498039552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:06.645] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:118:0) after 1m0s
[20:21:06.738] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:118:0)
[20:21:06.739] Timer tick, asking Buildbucket for the build status
[20:21:06.810] Build 8853123324498039552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:06.810] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:119:0) after 1m0s
[20:22:06.850] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:119:0)
[20:22:06.850] Timer tick, asking Buildbucket for the build status
[20:22:06.933] Build 8853123324498039552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:06.933] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:120:0) after 1m0s
[20:23:07.050] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:120:0)
[20:23:07.050] Timer tick, asking Buildbucket for the build status
[20:23:07.235] Build 8853123324498039552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:07.235] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:121:0) after 1m0s
[20:24:07.335] Handling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:121:0)
[20:24:07.335] Timer tick, asking Buildbucket for the build status
[20:24:07.418] Build 8853123324498039552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:07.418] Scheduling timer "check-buildbucket-build-status" (v8/V8 Win64 - dev image:9018553386592630320:122:0) after 1m0s
[20:24:15.076] Received PubSub notification, asking Buildbucket for the build status
[20:24:15.182] Build 8853123324498039552: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:24:15.182] Buildbucket build:
{
"build": {
"bucket": "luci.v8.ci",
"canary_preference": "PROD",
"completed_ts": "1615407851234341",
"created_by": "project:v8",
"created_ts": "1615400687657332",
"id": "8853123324498039552",
"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\": \"f80b29204ccba5953307139c8ad3c304b2554fe0\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@f80b29204ccba5953307139c8ad3c304b2554fe0\", \"title\": \"f80b29204ccba5953307139c8ad3c304b2554fe0\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/f80b29204ccba5953307139c8ad3c304b2554fe0\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"668513d8abe24d0d1127afbb81a1aa6fbd7ad0a1\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@668513d8abe24d0d1127afbb81a1aa6fbd7ad0a1\", \"title\": \"668513d8abe24d0d1127afbb81a1aa6fbd7ad0a1\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/668513d8abe24d0d1127afbb81a1aa6fbd7ad0a1\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"668513d8abe24d0d1127afbb81a1aa6fbd7ad0a1\"}}",
"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\": \"f80b29204ccba5953307139c8ad3c304b2554fe0\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@f80b29204ccba5953307139c8ad3c304b2554fe0\", \"title\": \"f80b29204ccba5953307139c8ad3c304b2554fe0\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/f80b29204ccba5953307139c8ad3c304b2554fe0\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"668513d8abe24d0d1127afbb81a1aa6fbd7ad0a1\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@668513d8abe24d0d1127afbb81a1aa6fbd7ad0a1\", \"title\": \"668513d8abe24d0d1127afbb81a1aa6fbd7ad0a1\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/668513d8abe24d0d1127afbb81a1aa6fbd7ad0a1\"}]}, \"bot_id\": \"dev-luci-chromium-ci-win10-0-lkd1\", \"branch\": \"refs/heads/master\", \"builder_group\": \"client.v8\", \"buildername\": \"V8 Win64 - dev image\", \"buildnumber\": 720, \"got_revision\": \"668513d8abe24d0d1127afbb81a1aa6fbd7ad0a1\", \"got_revision_cp\": \"refs/heads/master@{#73325}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"path_config\": \"generic\", \"recipe\": \"v8\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"668513d8abe24d0d1127afbb81a1aa6fbd7ad0a1\"}, \"swarming\": {\"bot_dimensions\": {\"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-lkd1\"], \"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\": [\"5753-b4ced58\"], \"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": "1615407369729525",
"status": "COMPLETED",
"status_changed_ts": "1615407852636840",
"tags": [
"build_address:luci.v8.ci/V8 Win64 - dev image/720",
"builder:V8 Win64 - dev image",
"buildset:commit/git/668513d8abe24d0d1127afbb81a1aa6fbd7ad0a1",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/668513d8abe24d0d1127afbb81a1aa6fbd7ad0a1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018553386592630320",
"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/8853123324498039552/+/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:523633e328bece10",
"user_agent:luci-scheduler-dev"
],
"updated_ts": "1615407852678263",
"url": "https://luci-milo-dev.appspot.com/b/8853123324498039552",
"utcnow_ts": "1615407855164460"
}
}
[20:24:15.182] Invocation finished in 1h59m28.906433831s with status SUCCEEDED