[19:09:34.476] New invocation is queued and will start shortly
[19:09:35.712] Starting the invocation (attempt 1)
[19:09:35.763] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:09:35.764] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:09:35.764] Buildbucket request:
{
"bucket": "luci.v8.ci",
"client_operation_id": "9044461300217773552",
"parameters_json": "{\"builder_name\":\"V8 Blink Linux Debug\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/v8/v8\",\"revision\":\"464ee4b7ad358b8cb5fee672eeb8a74f016ca156\"},\"id\":\"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@464ee4b7ad358b8cb5fee672eeb8a74f016ca156\",\"title\":\"464ee4b7ad358b8cb5fee672eeb8a74f016ca156\",\"url\":\"https://chromium.googlesource.com/v8/v8/+/464ee4b7ad358b8cb5fee672eeb8a74f016ca156\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/v8/v8\",\"revision\":\"97ae101029626c1b832d3b6374e3e2b96bccce05\"},\"id\":\"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@97ae101029626c1b832d3b6374e3e2b96bccce05\",\"title\":\"97ae101029626c1b832d3b6374e3e2b96bccce05\",\"url\":\"https://chromium.googlesource.com/v8/v8/+/97ae101029626c1b832d3b6374e3e2b96bccce05\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/v8/v8\",\"revision\":\"97ae101029626c1b832d3b6374e3e2b96bccce05\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:V8 Blink Linux Debug",
"scheduler_invocation_id:9044461300217773552",
"scheduler_job_id:v8/V8 Blink Linux Debug",
"user_agent:luci-scheduler",
"buildset:commit/git/97ae101029626c1b832d3b6374e3e2b96bccce05",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/97ae101029626c1b832d3b6374e3e2b96bccce05",
"gitiles_ref:refs/heads/master"
]
}
[19:09:37.613] Buildbucket response:
{
"build": {
"bucket": "luci.v8.ci",
"canary_preference": "PROD",
"created_by": "project:v8",
"created_ts": "1590692975962666",
"id": "8879031237995698992",
"parameters_json": "{\"builder_name\": \"V8 Blink Linux Debug\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"464ee4b7ad358b8cb5fee672eeb8a74f016ca156\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@464ee4b7ad358b8cb5fee672eeb8a74f016ca156\", \"title\": \"464ee4b7ad358b8cb5fee672eeb8a74f016ca156\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/464ee4b7ad358b8cb5fee672eeb8a74f016ca156\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"97ae101029626c1b832d3b6374e3e2b96bccce05\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@97ae101029626c1b832d3b6374e3e2b96bccce05\", \"title\": \"97ae101029626c1b832d3b6374e3e2b96bccce05\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/97ae101029626c1b832d3b6374e3e2b96bccce05\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"97ae101029626c1b832d3b6374e3e2b96bccce05\"}}",
"project": "v8",
"result_details_json": "{\"properties\": {}}",
"service_account": "v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1590692977229828",
"tags": [
"build_address:luci.v8.ci/V8 Blink Linux Debug/4349",
"builder:V8 Blink Linux Debug",
"buildset:commit/git/97ae101029626c1b832d3b6374e3e2b96bccce05",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/97ae101029626c1b832d3b6374e3e2b96bccce05",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9044461300217773552",
"scheduler_job_id:v8/V8 Blink Linux Debug",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/v8/buildbucket/cr-buildbucket.appspot.com/8879031237995698992/+/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": "1590692977230658",
"url": "https://ci.chromium.org/b/8879031237995698992",
"utcnow_ts": "1590692977590563"
}
}
[19:09:37.613] Task URL: https://ci.chromium.org/b/8879031237995698992
[19:09:37.613] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:2:0) after 1m0s
[19:10:31.582] Received PubSub notification, asking Buildbucket for the build status
[19:10:31.712] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:37.634] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:2:0)
[19:10:37.634] Timer tick, asking Buildbucket for the build status
[19:10:37.708] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:37.708] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:4:0) after 1m0s
[19:11:37.791] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:4:0)
[19:11:37.791] Timer tick, asking Buildbucket for the build status
[19:11:38.193] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:38.193] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:5:0) after 1m0s
[19:12:38.203] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:5:0)
[19:12:38.203] Timer tick, asking Buildbucket for the build status
[19:12:38.444] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:38.444] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:6:0) after 1m0s
[19:13:38.545] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:6:0)
[19:13:38.545] Timer tick, asking Buildbucket for the build status
[19:13:38.933] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:38.933] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:7:0) after 1m0s
[19:14:38.958] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:7:0)
[19:14:38.958] Timer tick, asking Buildbucket for the build status
[19:14:39.096] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:39.096] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:8:0) after 1m0s
[19:15:39.120] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:8:0)
[19:15:39.120] Timer tick, asking Buildbucket for the build status
[19:15:39.441] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:39.441] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:9:0) after 1m0s
[19:16:39.478] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:9:0)
[19:16:39.478] Timer tick, asking Buildbucket for the build status
[19:16:39.844] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:39.844] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:10:0) after 1m0s
[19:17:39.958] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:10:0)
[19:17:39.958] Timer tick, asking Buildbucket for the build status
[19:17:40.179] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:40.179] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:11:0) after 1m0s
[19:18:40.278] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:11:0)
[19:18:40.278] Timer tick, asking Buildbucket for the build status
[19:18:41.660] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:41.660] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:12:0) after 1m0s
[19:19:41.714] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:12:0)
[19:19:41.714] Timer tick, asking Buildbucket for the build status
[19:19:41.973] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:41.973] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:13:0) after 1m0s
[19:20:41.959] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:13:0)
[19:20:41.959] Timer tick, asking Buildbucket for the build status
[19:20:42.261] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:42.261] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:14:0) after 1m0s
[19:21:42.350] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:14:0)
[19:21:42.350] Timer tick, asking Buildbucket for the build status
[19:21:42.508] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:42.508] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:15:0) after 1m0s
[19:22:42.581] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:15:0)
[19:22:42.581] Timer tick, asking Buildbucket for the build status
[19:22:42.747] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:42.747] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:16:0) after 1m0s
[19:23:42.914] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:16:0)
[19:23:42.914] Timer tick, asking Buildbucket for the build status
[19:23:43.102] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:43.102] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:17:0) after 1m0s
[19:24:43.296] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:17:0)
[19:24:43.296] Timer tick, asking Buildbucket for the build status
[19:24:43.649] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:43.650] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:18:0) after 1m0s
[19:25:43.687] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:18:0)
[19:25:43.687] Timer tick, asking Buildbucket for the build status
[19:25:43.813] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:43.813] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:19:0) after 1m0s
[19:26:43.979] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:19:0)
[19:26:43.979] Timer tick, asking Buildbucket for the build status
[19:26:44.256] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:44.256] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:20:0) after 1m0s
[19:27:44.295] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:20:0)
[19:27:44.295] Timer tick, asking Buildbucket for the build status
[19:27:44.468] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:44.468] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:21:0) after 1m0s
[19:28:44.522] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:21:0)
[19:28:44.522] Timer tick, asking Buildbucket for the build status
[19:28:44.809] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:44.809] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:22:0) after 1m0s
[19:29:44.886] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:22:0)
[19:29:44.886] Timer tick, asking Buildbucket for the build status
[19:29:45.338] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:45.338] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:23:0) after 1m0s
[19:30:45.428] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:23:0)
[19:30:45.428] Timer tick, asking Buildbucket for the build status
[19:30:45.580] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:45.580] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:24:0) after 1m0s
[19:31:45.624] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:24:0)
[19:31:45.624] Timer tick, asking Buildbucket for the build status
[19:31:45.742] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:45.742] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:25:0) after 1m0s
[19:32:45.791] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:25:0)
[19:32:45.791] Timer tick, asking Buildbucket for the build status
[19:32:45.973] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:45.973] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:26:0) after 1m0s
[19:33:46.048] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:26:0)
[19:33:46.048] Timer tick, asking Buildbucket for the build status
[19:33:46.211] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:46.211] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:27:0) after 1m0s
[19:34:46.238] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:27:0)
[19:34:46.238] Timer tick, asking Buildbucket for the build status
[19:34:46.444] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:46.444] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:28:0) after 1m0s
[19:35:46.547] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:28:0)
[19:35:46.547] Timer tick, asking Buildbucket for the build status
[19:35:46.754] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:46.754] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:29:0) after 1m0s
[19:36:46.763] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:29:0)
[19:36:46.763] Timer tick, asking Buildbucket for the build status
[19:36:46.979] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:46.979] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:30:0) after 1m0s
[19:37:46.985] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:30:0)
[19:37:46.985] Timer tick, asking Buildbucket for the build status
[19:37:47.200] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:47.200] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:31:0) after 1m0s
[19:38:47.307] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:31:0)
[19:38:47.307] Timer tick, asking Buildbucket for the build status
[19:38:47.449] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:47.449] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:32:0) after 1m0s
[19:39:47.422] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:32:0)
[19:39:47.422] Timer tick, asking Buildbucket for the build status
[19:39:47.941] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:47.941] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:33:0) after 1m0s
[19:40:47.997] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:33:0)
[19:40:47.997] Timer tick, asking Buildbucket for the build status
[19:40:48.185] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:48.185] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:34:0) after 1m0s
[19:41:48.215] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:34:0)
[19:41:48.215] Timer tick, asking Buildbucket for the build status
[19:41:49.745] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:49.745] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:35:0) after 1m0s
[19:42:49.781] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:35:0)
[19:42:49.781] Timer tick, asking Buildbucket for the build status
[19:42:49.979] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:49.979] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:36:0) after 1m0s
[19:43:50.025] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:36:0)
[19:43:50.025] Timer tick, asking Buildbucket for the build status
[19:43:50.238] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:50.238] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:37:0) after 1m0s
[19:44:50.257] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:37:0)
[19:44:50.257] Timer tick, asking Buildbucket for the build status
[19:44:50.410] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:50.410] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:38:0) after 1m0s
[19:45:50.468] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:38:0)
[19:45:50.468] Timer tick, asking Buildbucket for the build status
[19:45:50.595] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:50.595] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:39:0) after 1m0s
[19:46:50.636] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:39:0)
[19:46:50.636] Timer tick, asking Buildbucket for the build status
[19:46:50.850] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:50.850] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:40:0) after 1m0s
[19:47:50.856] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:40:0)
[19:47:50.856] Timer tick, asking Buildbucket for the build status
[19:47:51.036] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:51.036] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:41:0) after 1m0s
[19:48:51.091] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:41:0)
[19:48:51.091] Timer tick, asking Buildbucket for the build status
[19:48:51.466] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:51.466] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:42:0) after 1m0s
[19:49:51.828] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:42:0)
[19:49:51.828] Timer tick, asking Buildbucket for the build status
[19:49:51.945] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:51.945] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:43:0) after 1m0s
[19:50:52.094] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:43:0)
[19:50:52.094] Timer tick, asking Buildbucket for the build status
[19:50:52.269] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:52.269] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:44:0) after 1m0s
[19:51:52.484] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:44:0)
[19:51:52.484] Timer tick, asking Buildbucket for the build status
[19:51:52.615] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:52.615] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:45:0) after 1m0s
[19:52:52.964] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:45:0)
[19:52:52.964] Timer tick, asking Buildbucket for the build status
[19:52:53.114] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:53.114] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:46:0) after 1m0s
[19:53:53.162] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:46:0)
[19:53:53.162] Timer tick, asking Buildbucket for the build status
[19:53:53.303] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:53.303] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:47:0) after 1m0s
[19:54:53.744] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:47:0)
[19:54:53.744] Timer tick, asking Buildbucket for the build status
[19:54:53.888] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:53.888] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:48:0) after 1m0s
[19:55:54.044] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:48:0)
[19:55:54.044] Timer tick, asking Buildbucket for the build status
[19:55:54.154] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:54.154] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:49:0) after 1m0s
[19:56:54.250] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:49:0)
[19:56:54.250] Timer tick, asking Buildbucket for the build status
[19:56:54.768] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:54.768] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:50:0) after 1m0s
[19:57:54.778] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:50:0)
[19:57:54.778] Timer tick, asking Buildbucket for the build status
[19:57:55.138] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:55.138] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:51:0) after 1m0s
[19:58:55.212] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:51:0)
[19:58:55.212] Timer tick, asking Buildbucket for the build status
[19:58:55.389] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:55.389] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:52:0) after 1m0s
[19:59:55.496] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:52:0)
[19:59:55.496] Timer tick, asking Buildbucket for the build status
[19:59:55.652] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:55.652] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:53:0) after 1m0s
[20:00:55.851] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:53:0)
[20:00:55.851] Timer tick, asking Buildbucket for the build status
[20:00:56.229] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:56.229] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:54:0) after 1m0s
[20:01:56.484] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:54:0)
[20:01:56.484] Timer tick, asking Buildbucket for the build status
[20:01:56.631] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:56.631] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:55:0) after 1m0s
[20:02:56.812] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:55:0)
[20:02:56.812] Timer tick, asking Buildbucket for the build status
[20:02:58.039] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:58.039] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:56:0) after 1m0s
[20:03:58.292] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:56:0)
[20:03:58.292] Timer tick, asking Buildbucket for the build status
[20:03:58.400] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:58.400] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:57:0) after 1m0s
[20:04:58.507] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:57:0)
[20:04:58.507] Timer tick, asking Buildbucket for the build status
[20:04:58.645] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:58.645] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:58:0) after 1m0s
[20:05:58.669] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:58:0)
[20:05:58.669] Timer tick, asking Buildbucket for the build status
[20:06:00.916] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:00.916] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:59:0) after 1m0s
[20:07:03.011] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:59:0)
[20:07:03.011] Timer tick, asking Buildbucket for the build status
[20:07:03.266] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:03.266] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:60:0) after 1m0s
[20:08:03.357] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:60:0)
[20:08:03.357] Timer tick, asking Buildbucket for the build status
[20:08:03.913] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:03.913] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:61:0) after 1m0s
[20:09:03.946] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:61:0)
[20:09:03.946] Timer tick, asking Buildbucket for the build status
[20:09:04.345] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:04.345] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:62:0) after 1m0s
[20:10:04.436] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:62:0)
[20:10:04.436] Timer tick, asking Buildbucket for the build status
[20:10:06.672] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:06.672] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:63:0) after 1m0s
[20:11:06.807] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:63:0)
[20:11:06.807] Timer tick, asking Buildbucket for the build status
[20:11:07.270] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:07.270] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:64:0) after 1m0s
[20:12:07.430] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:64:0)
[20:12:07.431] Timer tick, asking Buildbucket for the build status
[20:12:07.765] Build 8879031237995698992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:07.765] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9044461300217773552:65:0) after 1m0s
[20:12:22.198] Received PubSub notification, asking Buildbucket for the build status
[20:12:22.427] Build 8879031237995698992: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[20:12:22.427] Buildbucket build:
{
"build": {
"bucket": "luci.v8.ci",
"canary_preference": "PROD",
"completed_ts": "1590696740506866",
"created_by": "project:v8",
"created_ts": "1590692975962666",
"failure_reason": "BUILD_FAILURE",
"id": "8879031237995698992",
"parameters_json": "{\"builder_name\": \"V8 Blink Linux Debug\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"464ee4b7ad358b8cb5fee672eeb8a74f016ca156\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@464ee4b7ad358b8cb5fee672eeb8a74f016ca156\", \"title\": \"464ee4b7ad358b8cb5fee672eeb8a74f016ca156\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/464ee4b7ad358b8cb5fee672eeb8a74f016ca156\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"97ae101029626c1b832d3b6374e3e2b96bccce05\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@97ae101029626c1b832d3b6374e3e2b96bccce05\", \"title\": \"97ae101029626c1b832d3b6374e3e2b96bccce05\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/97ae101029626c1b832d3b6374e3e2b96bccce05\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"97ae101029626c1b832d3b6374e3e2b96bccce05\"}}",
"project": "v8",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**blink_web_tests** failed because of:\\n\\n- virtual/stable/http/tests/serviceworker/webexposed/global-interface-listing-service-worker.html\\n\\n- http/tests/serviceworker/webexposed/global-interface-listing-service-worker.html\\n\\n- webexposed/global-interface-listing.html\\n\\n- virtual/stable/webexposed/global-interface-listing-dedicated-worker.html\\n\\n- ...4 more failure(s) (8 total)...\"}, \"properties\": {\"$build/goma\": {\"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/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\": \"464ee4b7ad358b8cb5fee672eeb8a74f016ca156\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@464ee4b7ad358b8cb5fee672eeb8a74f016ca156\", \"title\": \"464ee4b7ad358b8cb5fee672eeb8a74f016ca156\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/464ee4b7ad358b8cb5fee672eeb8a74f016ca156\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"97ae101029626c1b832d3b6374e3e2b96bccce05\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@97ae101029626c1b832d3b6374e3e2b96bccce05\", \"title\": \"97ae101029626c1b832d3b6374e3e2b96bccce05\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/97ae101029626c1b832d3b6374e3e2b96bccce05\"}]}, \"bot_id\": \"luci-v8-ci-xenial-40-i5md\", \"branch\": \"refs/heads/master\", \"buildername\": \"V8 Blink Linux Debug\", \"buildnumber\": 4349, \"got_angle_revision\": \"0652d0d6df2a3281f318ad0f0be851591c404b84\", \"got_cr_revision\": \"c34826baf03ef30e4d1fabd1fb4503b72e39fc53\", \"got_cr_revision_cp\": \"refs/heads/master@{#772815}\", \"got_dawn_revision\": \"295a4177aebc5c306a84b0d2c49218496299b2ce\", \"got_nacl_revision\": \"87616f7ce2ea8383efd3731960c15f4ba5852d93\", \"got_revision\": \"97ae101029626c1b832d3b6374e3e2b96bccce05\", \"got_revision_cp\": \"refs/heads/master@{#68052}\", \"got_swarming_client_revision\": \"90c5e17a82612bc898c90ab1530dd1bd5822eae8\", \"got_swiftshader_revision\": \"9e718f962f87c30d08e91053f0e9ce3467cbd488\", \"got_v8_revision\": \"97ae101029626c1b832d3b6374e3e2b96bccce05\", \"got_v8_revision_cp\": \"refs/heads/master@{#68052}\", \"got_webrtc_revision\": \"ed5d5947300f25380ea86491975e2cc4a8d644a6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31376}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"client.v8.fyi\", \"path_config\": \"generic\", \"recipe\": \"chromium_integration\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"97ae101029626c1b832d3b6374e3e2b96bccce05\", \"swarm_hashes_refs/heads/master(at){#68052}_without_patch\": {\"blink_unittests\": \"d8f890ead406851beb09d636b5850399c6ff9d6c\", \"blink_web_tests\": \"61e664e03c814e7ac0fcb20d8be7a3e6b5b9db76\"}}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_7d42915ebb031f6f96457c5c10eaeeb343fd1ff32cf54759d19a88c640a69bcb_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"host_class\": [\"default\"], \"id\": [\"luci-v8-ci-xenial-40-i5md\"], \"image\": [\"chrome-xenial-20041200-f56df5dd7ad\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.v8.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5142-e16b32c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**blink_web_tests** failed because of:\\n\\n- virtual/stable/http/tests/serviceworker/webexposed/global-interface-listing-service-worker.html\\n\\n- http/tests/serviceworker/webexposed/global-interface-listing-service-worker.html\\n\\n- webexposed/global-interface-listing.html\\n\\n- virtual/stable/webexposed/global-interface-listing-dedicated-worker.html\\n\\n- ...4 more failure(s) (8 total)...\"}}",
"service_account": "v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1590693030863212",
"status": "COMPLETED",
"status_changed_ts": "1590693031245524",
"tags": [
"build_address:luci.v8.ci/V8 Blink Linux Debug/4349",
"builder:V8 Blink Linux Debug",
"buildset:commit/git/97ae101029626c1b832d3b6374e3e2b96bccce05",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/97ae101029626c1b832d3b6374e3e2b96bccce05",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9044461300217773552",
"scheduler_job_id:v8/V8 Blink Linux Debug",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/v8/buildbucket/cr-buildbucket.appspot.com/8879031237995698992/+/annotations",
"swarming_tag:luci_project:v8",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:chromium_integration",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:4c7582262fc47310",
"user_agent:luci-scheduler"
],
"updated_ts": "1590696741429165",
"url": "https://ci.chromium.org/b/8879031237995698992",
"utcnow_ts": "1590696742415958"
}
}
[20:12:22.427] Invocation finished in 1h2m47.966578715s with status FAILED