[19:57:26.271] New invocation is queued and will start shortly
[19:57:28.011] Starting the invocation (attempt 1)
[19:57:28.099] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:57:28.101] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:57:28.101] Buildbucket request:
{
"bucket": "luci.v8.ci",
"client_operation_id": "9037210531611444192",
"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\":\"d4641e6cc1a0b1a351a75f07612a7ada220e5e51\"},\"id\":\"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@d4641e6cc1a0b1a351a75f07612a7ada220e5e51\",\"title\":\"d4641e6cc1a0b1a351a75f07612a7ada220e5e51\",\"url\":\"https://chromium.googlesource.com/v8/v8/+/d4641e6cc1a0b1a351a75f07612a7ada220e5e51\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/v8/v8\",\"revision\":\"d4641e6cc1a0b1a351a75f07612a7ada220e5e51\"}}",
"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:9037210531611444192",
"scheduler_job_id:v8/V8 Blink Linux Debug",
"user_agent:luci-scheduler",
"buildset:commit/git/d4641e6cc1a0b1a351a75f07612a7ada220e5e51",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/d4641e6cc1a0b1a351a75f07612a7ada220e5e51",
"gitiles_ref:refs/heads/master"
]
}
[19:57:28.829] Buildbucket response:
{
"build": {
"bucket": "luci.v8.ci",
"canary_preference": "PROD",
"created_by": "project:v8",
"created_ts": "1597607848184048",
"id": "8871780468941195120",
"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\": \"d4641e6cc1a0b1a351a75f07612a7ada220e5e51\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@d4641e6cc1a0b1a351a75f07612a7ada220e5e51\", \"title\": \"d4641e6cc1a0b1a351a75f07612a7ada220e5e51\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/d4641e6cc1a0b1a351a75f07612a7ada220e5e51\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"d4641e6cc1a0b1a351a75f07612a7ada220e5e51\"}}",
"project": "v8",
"result_details_json": "{\"properties\": {}}",
"service_account": "v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1597607848673988",
"tags": [
"build_address:luci.v8.ci/V8 Blink Linux Debug/5514",
"builder:V8 Blink Linux Debug",
"buildset:commit/git/d4641e6cc1a0b1a351a75f07612a7ada220e5e51",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/d4641e6cc1a0b1a351a75f07612a7ada220e5e51",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9037210531611444192",
"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/8871780468941195120/+/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": "1597607848674157",
"url": "https://ci.chromium.org/b/8871780468941195120",
"utcnow_ts": "1597607848820571"
}
}
[19:57:28.829] Task URL: https://ci.chromium.org/b/8871780468941195120
[19:57:28.829] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:2:0) after 1m0s
[19:58:22.804] Received PubSub notification, asking Buildbucket for the build status
[19:58:22.953] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:29.285] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:2:0)
[19:58:29.285] Timer tick, asking Buildbucket for the build status
[19:58:29.362] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:29.362] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:4:0) after 1m0s
[19:59:29.648] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:4:0)
[19:59:29.648] Timer tick, asking Buildbucket for the build status
[19:59:29.778] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:29.778] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:5:0) after 1m0s
[20:00:29.958] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:5:0)
[20:00:29.958] Timer tick, asking Buildbucket for the build status
[20:00:30.249] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:30.249] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:6:0) after 1m0s
[20:01:30.634] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:6:0)
[20:01:30.634] Timer tick, asking Buildbucket for the build status
[20:01:30.800] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:30.800] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:7:0) after 1m0s
[20:02:30.983] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:7:0)
[20:02:30.983] Timer tick, asking Buildbucket for the build status
[20:02:31.191] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:31.191] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:8:0) after 1m0s
[20:03:31.451] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:8:0)
[20:03:31.451] Timer tick, asking Buildbucket for the build status
[20:03:31.774] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:31.774] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:9:0) after 1m0s
[20:04:31.901] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:9:0)
[20:04:31.901] Timer tick, asking Buildbucket for the build status
[20:04:32.376] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:32.376] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:10:0) after 1m0s
[20:05:32.491] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:10:0)
[20:05:32.491] Timer tick, asking Buildbucket for the build status
[20:05:32.782] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:32.782] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:11:0) after 1m0s
[20:06:32.960] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:11:0)
[20:06:32.960] Timer tick, asking Buildbucket for the build status
[20:06:33.311] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:33.311] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:12:0) after 1m0s
[20:07:33.335] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:12:0)
[20:07:33.335] Timer tick, asking Buildbucket for the build status
[20:07:33.444] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:33.444] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:13:0) after 1m0s
[20:08:33.466] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:13:0)
[20:08:33.466] Timer tick, asking Buildbucket for the build status
[20:08:33.581] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:33.581] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:14:0) after 1m0s
[20:09:33.650] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:14:0)
[20:09:33.650] Timer tick, asking Buildbucket for the build status
[20:09:33.783] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:33.783] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:15:0) after 1m0s
[20:10:33.877] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:15:0)
[20:10:33.877] Timer tick, asking Buildbucket for the build status
[20:10:33.953] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:33.953] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:16:0) after 1m0s
[20:11:34.156] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:16:0)
[20:11:34.156] Timer tick, asking Buildbucket for the build status
[20:11:34.525] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:34.525] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:17:0) after 1m0s
[20:12:34.546] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:17:0)
[20:12:34.547] Timer tick, asking Buildbucket for the build status
[20:12:34.802] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:34.802] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:18:0) after 1m0s
[20:13:34.861] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:18:0)
[20:13:34.861] Timer tick, asking Buildbucket for the build status
[20:13:35.196] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:35.196] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:19:0) after 1m0s
[20:14:35.275] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:19:0)
[20:14:35.275] Timer tick, asking Buildbucket for the build status
[20:14:35.343] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:35.343] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:20:0) after 1m0s
[20:15:35.396] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:20:0)
[20:15:35.396] Timer tick, asking Buildbucket for the build status
[20:15:35.484] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:35.484] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:21:0) after 1m0s
[20:16:35.504] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:21:0)
[20:16:35.504] Timer tick, asking Buildbucket for the build status
[20:16:35.577] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:35.577] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:22:0) after 1m0s
[20:17:35.709] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:22:0)
[20:17:35.709] Timer tick, asking Buildbucket for the build status
[20:17:35.924] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:35.924] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:23:0) after 1m0s
[20:18:35.950] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:23:0)
[20:18:35.950] Timer tick, asking Buildbucket for the build status
[20:18:36.330] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:36.330] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:24:0) after 1m0s
[20:19:36.414] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:24:0)
[20:19:36.414] Timer tick, asking Buildbucket for the build status
[20:19:36.517] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:36.517] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:25:0) after 1m0s
[20:20:36.685] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:25:0)
[20:20:36.685] Timer tick, asking Buildbucket for the build status
[20:20:37.403] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:37.403] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:26:0) after 1m0s
[20:21:37.495] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:26:0)
[20:21:37.495] Timer tick, asking Buildbucket for the build status
[20:21:37.598] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:37.598] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:27:0) after 1m0s
[20:22:37.619] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:27:0)
[20:22:37.619] Timer tick, asking Buildbucket for the build status
[20:22:37.933] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:37.933] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:28:0) after 1m0s
[20:23:37.956] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:28:0)
[20:23:37.956] Timer tick, asking Buildbucket for the build status
[20:23:38.234] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:38.234] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:29:0) after 1m0s
[20:24:38.259] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:29:0)
[20:24:38.259] Timer tick, asking Buildbucket for the build status
[20:24:38.403] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:38.403] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:30:0) after 1m0s
[20:25:38.430] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:30:0)
[20:25:38.430] Timer tick, asking Buildbucket for the build status
[20:25:38.905] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:38.905] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:31:0) after 1m0s
[20:26:38.896] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:31:0)
[20:26:38.896] Timer tick, asking Buildbucket for the build status
[20:26:38.967] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:38.967] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:32:0) after 1m0s
[20:27:39.022] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:32:0)
[20:27:39.022] Timer tick, asking Buildbucket for the build status
[20:27:39.232] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:39.232] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:33:0) after 1m0s
[20:28:39.269] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:33:0)
[20:28:39.269] Timer tick, asking Buildbucket for the build status
[20:28:39.367] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:39.367] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:34:0) after 1m0s
[20:29:39.430] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:34:0)
[20:29:39.430] Timer tick, asking Buildbucket for the build status
[20:29:39.507] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:39.507] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:35:0) after 1m0s
[20:30:39.533] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:35:0)
[20:30:39.533] Timer tick, asking Buildbucket for the build status
[20:30:39.602] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:39.602] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:36:0) after 1m0s
[20:31:39.714] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:36:0)
[20:31:39.714] Timer tick, asking Buildbucket for the build status
[20:31:39.927] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:39.927] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:37:0) after 1m0s
[20:32:39.943] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:37:0)
[20:32:39.943] Timer tick, asking Buildbucket for the build status
[20:32:40.155] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:40.155] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:38:0) after 1m0s
[20:33:40.369] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:38:0)
[20:33:40.369] Timer tick, asking Buildbucket for the build status
[20:33:40.470] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:40.470] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:39:0) after 1m0s
[20:34:40.548] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:39:0)
[20:34:40.548] Timer tick, asking Buildbucket for the build status
[20:34:41.141] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:41.141] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:40:0) after 1m0s
[20:35:41.198] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:40:0)
[20:35:41.198] Timer tick, asking Buildbucket for the build status
[20:35:41.516] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:41.516] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:41:0) after 1m0s
[20:36:41.537] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:41:0)
[20:36:41.537] Timer tick, asking Buildbucket for the build status
[20:36:41.673] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:41.673] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:42:0) after 1m0s
[20:37:41.697] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:42:0)
[20:37:41.697] Timer tick, asking Buildbucket for the build status
[20:37:42.086] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:42.086] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:43:0) after 1m0s
[20:38:42.179] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:43:0)
[20:38:42.179] Timer tick, asking Buildbucket for the build status
[20:38:42.416] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:42.416] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:44:0) after 1m0s
[20:39:42.424] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:44:0)
[20:39:42.424] Timer tick, asking Buildbucket for the build status
[20:39:42.690] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:42.690] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:45:0) after 1m0s
[20:40:42.706] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:45:0)
[20:40:42.706] Timer tick, asking Buildbucket for the build status
[20:40:42.834] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:42.834] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:46:0) after 1m0s
[20:41:42.873] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:46:0)
[20:41:42.873] Timer tick, asking Buildbucket for the build status
[20:41:42.993] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:42.993] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:47:0) after 1m0s
[20:42:43.046] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:47:0)
[20:42:43.046] Timer tick, asking Buildbucket for the build status
[20:42:43.167] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:43.167] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:48:0) after 1m0s
[20:43:43.357] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:48:0)
[20:43:43.357] Timer tick, asking Buildbucket for the build status
[20:43:43.421] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:43.421] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:49:0) after 1m0s
[20:44:44.219] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:49:0)
[20:44:44.219] Timer tick, asking Buildbucket for the build status
[20:44:44.298] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:44.298] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:50:0) after 1m0s
[20:45:44.496] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:50:0)
[20:45:44.496] Timer tick, asking Buildbucket for the build status
[20:45:44.627] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:44.627] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:51:0) after 1m0s
[20:46:44.793] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:51:0)
[20:46:44.793] Timer tick, asking Buildbucket for the build status
[20:46:45.817] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:45.817] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:52:0) after 1m0s
[20:47:45.944] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:52:0)
[20:47:45.944] Timer tick, asking Buildbucket for the build status
[20:47:46.070] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:46.070] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:53:0) after 1m0s
[20:48:46.277] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:53:0)
[20:48:46.277] Timer tick, asking Buildbucket for the build status
[20:48:46.580] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:46.581] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:54:0) after 1m0s
[20:49:46.683] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:54:0)
[20:49:46.683] Timer tick, asking Buildbucket for the build status
[20:49:46.813] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:46.813] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:55:0) after 1m0s
[20:50:47.005] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:55:0)
[20:50:47.005] Timer tick, asking Buildbucket for the build status
[20:50:47.162] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:47.162] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:56:0) after 1m0s
[20:51:47.209] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:56:0)
[20:51:47.209] Timer tick, asking Buildbucket for the build status
[20:51:47.327] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:47.327] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:57:0) after 1m0s
[20:52:47.547] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:57:0)
[20:52:47.547] Timer tick, asking Buildbucket for the build status
[20:52:47.908] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:47.908] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:58:0) after 1m0s
[20:53:48.005] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:58:0)
[20:53:48.005] Timer tick, asking Buildbucket for the build status
[20:53:48.121] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:48.121] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:59:0) after 1m0s
[20:54:48.199] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:59:0)
[20:54:48.199] Timer tick, asking Buildbucket for the build status
[20:54:48.284] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:48.284] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:60:0) after 1m0s
[20:55:48.561] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:60:0)
[20:55:48.561] Timer tick, asking Buildbucket for the build status
[20:55:48.644] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:48.644] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:61:0) after 1m0s
[20:56:48.635] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:61:0)
[20:56:48.635] Timer tick, asking Buildbucket for the build status
[20:56:48.703] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:48.703] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:62:0) after 1m0s
[20:57:48.838] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:62:0)
[20:57:48.838] Timer tick, asking Buildbucket for the build status
[20:57:48.964] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:48.964] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:63:0) after 1m0s
[20:58:49.082] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:63:0)
[20:58:49.082] Timer tick, asking Buildbucket for the build status
[20:58:49.400] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:49.400] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:64:0) after 1m0s
[20:59:49.488] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:64:0)
[20:59:49.488] Timer tick, asking Buildbucket for the build status
[20:59:49.635] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:49.635] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:65:0) after 1m0s
[21:00:49.675] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:65:0)
[21:00:49.675] Timer tick, asking Buildbucket for the build status
[21:00:50.038] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:50.038] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:66:0) after 1m0s
[21:01:50.246] Handling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:66:0)
[21:01:50.246] Timer tick, asking Buildbucket for the build status
[21:01:50.510] Build 8871780468941195120: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:50.510] Scheduling timer "check-buildbucket-build-status" (v8/V8 Blink Linux Debug:9037210531611444192:67:0) after 1m0s
[21:02:34.461] Received PubSub notification, asking Buildbucket for the build status
[21:02:34.535] Build 8871780468941195120: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:02:34.535] Buildbucket build:
{
"build": {
"bucket": "luci.v8.ci",
"canary_preference": "PROD",
"completed_ts": "1597611751572545",
"created_by": "project:v8",
"created_ts": "1597607848184048",
"id": "8871780468941195120",
"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\": \"d4641e6cc1a0b1a351a75f07612a7ada220e5e51\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@d4641e6cc1a0b1a351a75f07612a7ada220e5e51\", \"title\": \"d4641e6cc1a0b1a351a75f07612a7ada220e5e51\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/d4641e6cc1a0b1a351a75f07612a7ada220e5e51\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"d4641e6cc1a0b1a351a75f07612a7ada220e5e51\"}}",
"project": "v8",
"result": "SUCCESS",
"result_details_json": "{\"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\": \"d4641e6cc1a0b1a351a75f07612a7ada220e5e51\"}, \"id\": \"https://chromium.googlesource.com/v8/v8/+/refs/heads/master@d4641e6cc1a0b1a351a75f07612a7ada220e5e51\", \"title\": \"d4641e6cc1a0b1a351a75f07612a7ada220e5e51\", \"url\": \"https://chromium.googlesource.com/v8/v8/+/d4641e6cc1a0b1a351a75f07612a7ada220e5e51\"}]}, \"bot_id\": \"luci-v8-ci-xenial-48-hoq8\", \"branch\": \"refs/heads/master\", \"buildername\": \"V8 Blink Linux Debug\", \"buildnumber\": 5514, \"got_angle_revision\": \"9ae6d7f2ee9e12b707483dc9cadd7c3529595016\", \"got_cr_revision\": \"8404c7625f6a3d747ca35a5313dfd27423d227e8\", \"got_cr_revision_cp\": \"refs/heads/master@{#798500}\", \"got_dawn_revision\": \"5e9b29fab92d6d79125555ea0d84afde9ace908b\", \"got_nacl_revision\": \"3008f9e6de122325d8f9dbf02f7cdd51fa1ec306\", \"got_revision\": \"d4641e6cc1a0b1a351a75f07612a7ada220e5e51\", \"got_revision_cp\": \"refs/heads/master@{#69410}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"abe07b9438553f741e776dedb59a2d4b502a9983\", \"got_v8_revision\": \"d4641e6cc1a0b1a351a75f07612a7ada220e5e51\", \"got_v8_revision_cp\": \"refs/heads/master@{#69410}\", \"got_webrtc_revision\": \"383f2cfca4a1ebd9626134101fe70d5a716b2d92\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31921}\", \"isolate_server\": \"https://isolateserver.appspot.com/\", \"mastername\": \"client.v8.fyi\", \"path_config\": \"generic\", \"recipe\": \"chromium_integration\", \"repository\": \"https://chromium.googlesource.com/v8/v8\", \"revision\": \"d4641e6cc1a0b1a351a75f07612a7ada220e5e51\", \"swarm_hashes\": {\"blink_unittests\": \"fadcfa8c007063e047bb953888c22503f44006dc\", \"blink_web_tests\": \"638e45b676c5d53470b4dd83952f0d735c4a8cd9\"}, \"swarm_hashes_refs/heads/master(at){#69410}_without_patch\": {\"blink_unittests\": \"fadcfa8c007063e047bb953888c22503f44006dc\", \"blink_web_tests\": \"638e45b676c5d53470b4dd83952f0d735c4a8cd9\"}}, \"swarming\": {\"bot_dimensions\": {\"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-48-hoq8\"], \"image\": [\"chrome-xenial-20081300-1358d8153ce\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.v8.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5488-fc78d20\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "v8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1597607881831264",
"status": "COMPLETED",
"status_changed_ts": "1597611752199618",
"tags": [
"build_address:luci.v8.ci/V8 Blink Linux Debug/5514",
"builder:V8 Blink Linux Debug",
"buildset:commit/git/d4641e6cc1a0b1a351a75f07612a7ada220e5e51",
"buildset:commit/gitiles/chromium.googlesource.com/v8/v8/+/d4641e6cc1a0b1a351a75f07612a7ada220e5e51",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9037210531611444192",
"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/8871780468941195120/+/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:4e11aacb66810110",
"user_agent:luci-scheduler"
],
"updated_ts": "1597611752311843",
"url": "https://ci.chromium.org/b/8871780468941195120",
"utcnow_ts": "1597611754525711"
}
}
[21:02:34.535] Invocation finished in 1h5m8.280640598s with status SUCCEEDED