[21:01:34.217] New invocation is queued and will start shortly
[21:01:35.447] Starting the invocation (attempt 1)
[21:01:35.540] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:01:35.540] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:01:35.541] Buildbucket request:
{
"bucket": "luci.v8.ci",
"client_operation_id": "9050886638671032688",
"parameters_json": "{\"builder_name\":\"V8 Blink Win\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/v8/v8\",\"revision\":\"aff14d7ee81f4d58cbbb07bcabd2e99731fedda4\"},\"id\":\"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@aff14d7ee81f4d58cbbb07bcabd2e99731fedda4\",\"title\":\"aff14d7ee81f4d58cbbb07bcabd2e99731fedda4\",\"url\":\"https://chromium.googlesource.com/v8/v8/+/aff14d7ee81f4d58cbbb07bcabd2e99731fedda4\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/v8/v8\",\"revision\":\"aff14d7ee81f4d58cbbb07bcabd2e99731fedda4\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:V8 Blink Win",
"scheduler_invocation_id:9050886638671032688",
"scheduler_job_id:v8/V8 Blink Win",
"user_agent:luci-scheduler",
"buildset:commit/git/aff14d7ee81f4d58cbbb07bcabd2e99731fedda4",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/aff14d7ee81f4d58cbbb07bcabd2e99731fedda4",
"gitiles_ref:refs/heads/master"
]
}
[21:01:38.526] Buildbucket response:
{
"build": {
"bucket": "luci.v8.ci",
"canary_preference": "PROD",
"created_by": "project:v8",
"created_ts": "1584565296371710",
"id": "8885456575750521952",
"parameters_json": "{\"builder_name\": \"V8 Blink Win\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"aff14d7ee81f4d58cbbb07bcabd2e99731fedda4\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@aff14d7ee81f4d58cbbb07bcabd2e99731fedda4\", \"title\": \"aff14d7ee81f4d58cbbb07bcabd2e99731fedda4\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/aff14d7ee81f4d58cbbb07bcabd2e99731fedda4\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"aff14d7ee81f4d58cbbb07bcabd2e99731fedda4\"}}",
"project": "v8",
"result_details_json": "{\"properties\": {}}",
"service_account": "v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1584565297957403",
"tags": [
"build_address:luci.v8.ci/V8 Blink Win/1880",
"builder:V8 Blink Win",
"buildset:commit/git/aff14d7ee81f4d58cbbb07bcabd2e99731fedda4",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/aff14d7ee81f4d58cbbb07bcabd2e99731fedda4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9050886638671032688",
"scheduler_job_id:v8/V8 Blink Win",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/v8/buildbucket/cr-buildbucket.appspot.com/8885456575750521952/+/annotations",
"swarming_tag:luci_project:v8",
"swarming_tag:recipe_name:chromium_integration",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1584565297959188",
"url": "https://ci.chromium.org/b/8885456575750521952",
"utcnow_ts": "1584565298462855"
}
}
[21:01:38.526] Task URL: https://ci.chromium.org/b/8885456575750521952
[21:01:38.526] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:2:0) after 1m0s
[21:02:38.546] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:2:0)
[21:02:38.546] Timer tick, asking Buildbucket for the build status
[21:02:38.763] Build 8885456575750521952: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:02:38.763] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:3:0) after 1m0s
[21:02:51.298] Received PubSub notification, asking Buildbucket for the build status
[21:02:51.845] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:38.801] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:3:0)
[21:03:38.801] Timer tick, asking Buildbucket for the build status
[21:03:40.470] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:40.470] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:5:0) after 1m0s
[21:04:40.473] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:5:0)
[21:04:40.473] Timer tick, asking Buildbucket for the build status
[21:04:42.689] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:42.689] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:6:0) after 1m0s
[21:05:42.930] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:6:0)
[21:05:42.930] Timer tick, asking Buildbucket for the build status
[21:05:43.193] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:43.193] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:7:0) after 1m0s
[21:06:43.191] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:7:0)
[21:06:43.191] Timer tick, asking Buildbucket for the build status
[21:06:44.220] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:44.220] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:8:0) after 1m0s
[21:07:44.276] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:8:0)
[21:07:44.276] Timer tick, asking Buildbucket for the build status
[21:07:44.390] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:44.390] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:9:0) after 1m0s
[21:08:44.414] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:9:0)
[21:08:44.414] Timer tick, asking Buildbucket for the build status
[21:08:44.737] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:44.737] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:10:0) after 1m0s
[21:09:44.774] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:10:0)
[21:09:44.774] Timer tick, asking Buildbucket for the build status
[21:09:45.993] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:45.993] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:11:0) after 1m0s
[21:10:46.015] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:11:0)
[21:10:46.015] Timer tick, asking Buildbucket for the build status
[21:10:47.447] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:47.447] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:12:0) after 1m0s
[21:11:47.511] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:12:0)
[21:11:47.511] Timer tick, asking Buildbucket for the build status
[21:11:48.648] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:48.648] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:13:0) after 1m0s
[21:12:48.624] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:13:0)
[21:12:48.624] Timer tick, asking Buildbucket for the build status
[21:12:50.289] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:50.290] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:14:0) after 1m0s
[21:13:50.342] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:14:0)
[21:13:50.342] Timer tick, asking Buildbucket for the build status
[21:13:50.513] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:50.513] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:15:0) after 1m0s
[21:14:50.560] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:15:0)
[21:14:50.560] Timer tick, asking Buildbucket for the build status
[21:14:50.686] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:50.686] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:16:0) after 1m0s
[21:15:50.735] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:16:0)
[21:15:50.735] Timer tick, asking Buildbucket for the build status
[21:15:50.923] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:50.923] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:17:0) after 1m0s
[21:16:51.057] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:17:0)
[21:16:51.057] Timer tick, asking Buildbucket for the build status
[21:16:51.179] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:51.179] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:18:0) after 1m0s
[21:17:51.303] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:18:0)
[21:17:51.303] Timer tick, asking Buildbucket for the build status
[21:17:51.451] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:51.451] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:19:0) after 1m0s
[21:18:51.469] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:19:0)
[21:18:51.469] Timer tick, asking Buildbucket for the build status
[21:18:51.557] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:51.557] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:20:0) after 1m0s
[21:19:51.577] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:20:0)
[21:19:51.577] Timer tick, asking Buildbucket for the build status
[21:19:51.885] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:51.886] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:21:0) after 1m0s
[21:20:51.947] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:21:0)
[21:20:51.947] Timer tick, asking Buildbucket for the build status
[21:20:52.391] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:52.391] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:22:0) after 1m0s
[21:21:52.432] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:22:0)
[21:21:52.432] Timer tick, asking Buildbucket for the build status
[21:21:52.809] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:52.809] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:23:0) after 1m0s
[21:22:52.929] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:23:0)
[21:22:52.929] Timer tick, asking Buildbucket for the build status
[21:22:56.433] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:56.433] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:24:0) after 1m0s
[21:23:56.478] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:24:0)
[21:23:56.478] Timer tick, asking Buildbucket for the build status
[21:23:56.594] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:56.594] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:25:0) after 1m0s
[21:24:56.614] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:25:0)
[21:24:56.614] Timer tick, asking Buildbucket for the build status
[21:24:56.856] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:56.856] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:26:0) after 1m0s
[21:25:56.904] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:26:0)
[21:25:56.904] Timer tick, asking Buildbucket for the build status
[21:25:56.999] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:56.999] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:27:0) after 1m0s
[21:26:57.024] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:27:0)
[21:26:57.024] Timer tick, asking Buildbucket for the build status
[21:26:57.254] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:57.254] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:28:0) after 1m0s
[21:27:57.333] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:28:0)
[21:27:57.333] Timer tick, asking Buildbucket for the build status
[21:27:57.571] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:57.571] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:29:0) after 1m0s
[21:28:57.662] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:29:0)
[21:28:57.662] Timer tick, asking Buildbucket for the build status
[21:28:57.890] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:57.890] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:30:0) after 1m0s
[21:29:57.954] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:30:0)
[21:29:57.954] Timer tick, asking Buildbucket for the build status
[21:29:58.073] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:58.073] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:31:0) after 1m0s
[21:30:58.108] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:31:0)
[21:30:58.108] Timer tick, asking Buildbucket for the build status
[21:30:58.566] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:58.566] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:32:0) after 1m0s
[21:31:59.333] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:32:0)
[21:31:59.333] Timer tick, asking Buildbucket for the build status
[21:31:59.674] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:59.674] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:33:0) after 1m0s
[21:32:59.905] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:33:0)
[21:32:59.905] Timer tick, asking Buildbucket for the build status
[21:33:00.196] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:00.196] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:34:0) after 1m0s
[21:34:00.339] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:34:0)
[21:34:00.339] Timer tick, asking Buildbucket for the build status
[21:34:01.005] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:01.005] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:35:0) after 1m0s
[21:35:01.189] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:35:0)
[21:35:01.189] Timer tick, asking Buildbucket for the build status
[21:35:01.655] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:01.655] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:36:0) after 1m0s
[21:36:01.761] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:36:0)
[21:36:01.761] Timer tick, asking Buildbucket for the build status
[21:36:01.906] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:01.906] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:37:0) after 1m0s
[21:37:02.026] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:37:0)
[21:37:02.026] Timer tick, asking Buildbucket for the build status
[21:37:02.212] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:02.212] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:38:0) after 1m0s
[21:38:02.239] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:38:0)
[21:38:02.239] Timer tick, asking Buildbucket for the build status
[21:38:02.335] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:02.335] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:39:0) after 1m0s
[21:39:02.363] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:39:0)
[21:39:02.363] Timer tick, asking Buildbucket for the build status
[21:39:02.558] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:02.558] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:40:0) after 1m0s
[21:40:02.580] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:40:0)
[21:40:02.580] Timer tick, asking Buildbucket for the build status
[21:40:02.870] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:02.870] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:41:0) after 1m0s
[21:41:02.911] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:41:0)
[21:41:02.911] Timer tick, asking Buildbucket for the build status
[21:41:03.094] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:03.094] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:42:0) after 1m0s
[21:42:03.247] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:42:0)
[21:42:03.247] Timer tick, asking Buildbucket for the build status
[21:42:03.513] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:03.513] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:43:0) after 1m0s
[21:43:03.569] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:43:0)
[21:43:03.569] Timer tick, asking Buildbucket for the build status
[21:43:04.278] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:04.278] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:44:0) after 1m0s
[21:44:04.347] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:44:0)
[21:44:04.347] Timer tick, asking Buildbucket for the build status
[21:44:04.550] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:04.550] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:45:0) after 1m0s
[21:45:04.580] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:45:0)
[21:45:04.580] Timer tick, asking Buildbucket for the build status
[21:45:04.689] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:04.689] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:46:0) after 1m0s
[21:46:04.854] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:46:0)
[21:46:04.854] Timer tick, asking Buildbucket for the build status
[21:46:05.435] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:05.435] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:47:0) after 1m0s
[21:47:05.458] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:47:0)
[21:47:05.458] Timer tick, asking Buildbucket for the build status
[21:47:05.675] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:05.675] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:48:0) after 1m0s
[21:48:05.879] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:48:0)
[21:48:05.879] Timer tick, asking Buildbucket for the build status
[21:48:05.960] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:05.960] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:49:0) after 1m0s
[21:49:06.054] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:49:0)
[21:49:06.054] Timer tick, asking Buildbucket for the build status
[21:49:06.312] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:06.312] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:50:0) after 1m0s
[21:50:06.562] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:50:0)
[21:50:06.562] Timer tick, asking Buildbucket for the build status
[21:50:06.780] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:06.780] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:51:0) after 1m0s
[21:51:06.879] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:51:0)
[21:51:06.879] Timer tick, asking Buildbucket for the build status
[21:51:07.353] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:07.353] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:52:0) after 1m0s
[21:52:07.449] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:52:0)
[21:52:07.449] Timer tick, asking Buildbucket for the build status
[21:52:07.698] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:07.698] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:53:0) after 1m0s
[21:53:07.869] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:53:0)
[21:53:07.870] Timer tick, asking Buildbucket for the build status
[21:53:08.452] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:08.452] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:54:0) after 1m0s
[21:54:08.468] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:54:0)
[21:54:08.468] Timer tick, asking Buildbucket for the build status
[21:54:08.667] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:08.667] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:55:0) after 1m0s
[21:55:08.776] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:55:0)
[21:55:08.776] Timer tick, asking Buildbucket for the build status
[21:55:09.389] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:09.389] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:56:0) after 1m0s
[21:56:09.411] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:56:0)
[21:56:09.411] Timer tick, asking Buildbucket for the build status
[21:56:09.604] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:09.604] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:57:0) after 1m0s
[21:57:09.685] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:57:0)
[21:57:09.685] Timer tick, asking Buildbucket for the build status
[21:57:09.984] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:09.984] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:58:0) after 1m0s
[21:58:10.128] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:58:0)
[21:58:10.128] Timer tick, asking Buildbucket for the build status
[21:58:10.370] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:10.370] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:59:0) after 1m0s
[21:59:10.387] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:59:0)
[21:59:10.387] Timer tick, asking Buildbucket for the build status
[21:59:10.542] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:10.542] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:60:0) after 1m0s
[22:00:10.615] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:60:0)
[22:00:10.615] Timer tick, asking Buildbucket for the build status
[22:00:10.948] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:10.948] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:61:0) after 1m0s
[22:01:11.014] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:61:0)
[22:01:11.014] Timer tick, asking Buildbucket for the build status
[22:01:11.319] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:11.319] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:62:0) after 1m0s
[22:02:11.392] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:62:0)
[22:02:11.392] Timer tick, asking Buildbucket for the build status
[22:02:12.287] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:12.288] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:63:0) after 1m0s
[22:03:12.331] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:63:0)
[22:03:12.331] Timer tick, asking Buildbucket for the build status
[22:03:12.659] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:12.659] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:64:0) after 1m0s
[22:04:12.678] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:64:0)
[22:04:12.678] Timer tick, asking Buildbucket for the build status
[22:04:13.079] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:13.079] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:65:0) after 1m0s
[22:05:13.142] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:65:0)
[22:05:13.142] Timer tick, asking Buildbucket for the build status
[22:05:13.643] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:13.643] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:66:0) after 1m0s
[22:06:13.776] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:66:0)
[22:06:13.776] Timer tick, asking Buildbucket for the build status
[22:06:13.990] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:13.990] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:67:0) after 1m0s
[22:07:14.031] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:67:0)
[22:07:14.031] Timer tick, asking Buildbucket for the build status
[22:07:14.306] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:14.306] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:68:0) after 1m0s
[22:08:14.380] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:68:0)
[22:08:14.380] Timer tick, asking Buildbucket for the build status
[22:08:14.725] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:14.725] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:69:0) after 1m0s
[22:09:14.797] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:69:0)
[22:09:14.797] Timer tick, asking Buildbucket for the build status
[22:09:14.896] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:14.896] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:70:0) after 1m0s
[22:10:15.159] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:70:0)
[22:10:15.159] Timer tick, asking Buildbucket for the build status
[22:10:15.359] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:15.359] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:71:0) after 1m0s
[22:11:15.566] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:71:0)
[22:11:15.566] Timer tick, asking Buildbucket for the build status
[22:11:15.747] Build 8885456575750521952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:15.747] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Win:9050886638671032688:72:0) after 1m0s
[22:11:31.784] Received PubSub notification, asking Buildbucket for the build status
[22:11:32.170] Build 8885456575750521952: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:11:32.170] Buildbucket build:
{
"build": {
"bucket": "luci.v8.ci",
"canary_preference": "PROD",
"completed_ts": "1584569490971080",
"created_by": "project:v8",
"created_ts": "1584565296371710",
"id": "8885456575750521952",
"parameters_json": "{\"builder_name\": \"V8 Blink Win\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"aff14d7ee81f4d58cbbb07bcabd2e99731fedda4\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@aff14d7ee81f4d58cbbb07bcabd2e99731fedda4\", \"title\": \"aff14d7ee81f4d58cbbb07bcabd2e99731fedda4\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/aff14d7ee81f4d58cbbb07bcabd2e99731fedda4\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"aff14d7ee81f4d58cbbb07bcabd2e99731fedda4\"}}",
"project": "v8",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$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.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"aff14d7ee81f4d58cbbb07bcabd2e99731fedda4\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@aff14d7ee81f4d58cbbb07bcabd2e99731fedda4\", \"title\": \"aff14d7ee81f4d58cbbb07bcabd2e99731fedda4\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/aff14d7ee81f4d58cbbb07bcabd2e99731fedda4\"}]}, \"bot_id\": \"luci-v8-ci-win10-10-jmn7\", \"branch\": \"refs/heads/master\", \"buildername\": \"V8 Blink Win\", \"buildnumber\": 1880, \"got_angle_revision\": \"78a85f2c18569fb86a9a286f74272ccf56ffabae\", \"got_cr_revision\": \"12915eb6264ebb05de220d1e30ba1806bb9e143a\", \"got_cr_revision_cp\": \"refs/heads/master@{#751476}\", \"got_dawn_revision\": \"83e138ca962c6c6b38f103081e898dfd74de2815\", \"got_nacl_revision\": \"35bcc9f6d5e81c3c39ad57de97ef9cd22301ee9e\", \"got_revision\": \"aff14d7ee81f4d58cbbb07bcabd2e99731fedda4\", \"got_revision_cp\": \"refs/heads/master@{#66778}\", \"got_swarming_client_revision\": \"cc958279ffd6853e0a1b227a7e957ca334fe56af\", \"got_swiftshader_revision\": \"dc0f1319307ee723c6e8a09f2ac7efd9d7bf70c3\", \"got_v8_revision\": \"aff14d7ee81f4d58cbbb07bcabd2e99731fedda4\", \"got_v8_revision_cp\": \"refs/heads/master@{#66778}\", \"got_webrtc_revision\": \"ebf739be7bab158806c6cec117c0ac5af209b0a7\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30821}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"client.v8.fyi\", \"path_config\": \"generic\", \"recipe\": \"chromium_integration\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"aff14d7ee81f4d58cbbb07bcabd2e99731fedda4\", \"swarm_hashes_refs/heads/master(at){#66778}_without_patch\": {\"blink_web_tests\": \"8e0006ffde7e399bfe7e6724c183a6bc2bbcb677\"}}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_c45cd84c3011deeeb1bb95553d013b3b691464b45620fcd454d65c09381ae99d_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"host_class\": [\"default\"], \"id\": [\"luci-v8-ci-win10-10-jmn7\"], \"image\": [\"chrome-win10-1703-19112100-3085293b610\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.v8.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"4874-3598771\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
"service_account": "v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1584565370669096",
"status": "COMPLETED",
"status_changed_ts": "1584569491431763",
"tags": [
"build_address:luci.v8.ci/V8 Blink Win/1880",
"builder:V8 Blink Win",
"buildset:commit/git/aff14d7ee81f4d58cbbb07bcabd2e99731fedda4",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/aff14d7ee81f4d58cbbb07bcabd2e99731fedda4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9050886638671032688",
"scheduler_job_id:v8/V8 Blink Win",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/v8/buildbucket/cr-buildbucket.appspot.com/8885456575750521952/+/annotations",
"swarming_tag:luci_project:v8",
"swarming_tag:os:Windows",
"swarming_tag:recipe_name:chromium_integration",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:4b084637fe777b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1584569491444740",
"url": "https://ci.chromium.org/b/8885456575750521952",
"utcnow_ts": "1584569492158166"
}
}
[22:11:32.170] Invocation finished in 1h9m57.968145794s with status SUCCEEDED