[22:28:36.121] New invocation is queued and will start shortly
[22:28:37.191] Starting the invocation (attempt 1)
[22:28:37.231] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:28:37.231] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:28:37.231] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9052783699407307536",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"07a07d65ffad58feb3c867b69ec562a9156ed3b4\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9052783699407307536",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/07a07d65ffad58feb3c867b69ec562a9156ed3b4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/07a07d65ffad58feb3c867b69ec562a9156ed3b4",
"gitiles_ref:refs/heads/master"
]
}
[22:28:38.332] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1582756117375840",
"id": "8887353637425261504",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"07a07d65ffad58feb3c867b69ec562a9156ed3b4\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1582756118052543",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169062",
"builder:Linux Builder (dbg)",
"buildset:commit/git/07a07d65ffad58feb3c867b69ec562a9156ed3b4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/07a07d65ffad58feb3c867b69ec562a9156ed3b4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9052783699407307536",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8887353637425261504/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1582756118052643",
"url": "https://ci.chromium.org/b/8887353637425261504",
"utcnow_ts": "1582756118319313"
}
}
[22:28:38.332] Task URL: https://ci.chromium.org/b/8887353637425261504
[22:28:38.332] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:2:0) after 1m0s
[22:29:38.314] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:2:0)
[22:29:38.314] Timer tick, asking Buildbucket for the build status
[22:29:38.413] Build 8887353637425261504: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:29:38.414] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:3:0) after 1m0s
[22:30:38.508] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:3:0)
[22:30:38.508] Timer tick, asking Buildbucket for the build status
[22:30:38.654] Build 8887353637425261504: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:30:38.654] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:4:0) after 1m0s
[22:31:38.698] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:4:0)
[22:31:38.698] Timer tick, asking Buildbucket for the build status
[22:31:38.888] Build 8887353637425261504: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:31:38.888] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:5:0) after 1m0s
[22:32:38.902] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:5:0)
[22:32:38.902] Timer tick, asking Buildbucket for the build status
[22:32:39.105] Build 8887353637425261504: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:32:39.105] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:6:0) after 1m0s
[22:33:39.144] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:6:0)
[22:33:39.144] Timer tick, asking Buildbucket for the build status
[22:33:40.879] Build 8887353637425261504: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:33:40.879] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:7:0) after 1m0s
[22:34:14.354] Received PubSub notification, asking Buildbucket for the build status
[22:34:14.445] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:40.885] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:7:0)
[22:34:40.885] Timer tick, asking Buildbucket for the build status
[22:34:41.009] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:41.009] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:9:0) after 1m0s
[22:35:41.011] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:9:0)
[22:35:41.011] Timer tick, asking Buildbucket for the build status
[22:35:41.128] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:41.128] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:10:0) after 1m0s
[22:36:41.152] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:10:0)
[22:36:41.152] Timer tick, asking Buildbucket for the build status
[22:36:41.240] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:41.240] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:11:0) after 1m0s
[22:37:41.300] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:11:0)
[22:37:41.300] Timer tick, asking Buildbucket for the build status
[22:37:41.649] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:41.649] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:12:0) after 1m0s
[22:38:41.784] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:12:0)
[22:38:41.784] Timer tick, asking Buildbucket for the build status
[22:38:41.855] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:41.855] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:13:0) after 1m0s
[22:39:41.886] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:13:0)
[22:39:41.886] Timer tick, asking Buildbucket for the build status
[22:39:42.066] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:42.066] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:14:0) after 1m0s
[22:40:42.082] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:14:0)
[22:40:42.082] Timer tick, asking Buildbucket for the build status
[22:40:42.161] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:42.161] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:15:0) after 1m0s
[22:41:42.183] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:15:0)
[22:41:42.183] Timer tick, asking Buildbucket for the build status
[22:41:42.451] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:42.451] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:16:0) after 1m0s
[22:42:42.461] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:16:0)
[22:42:42.461] Timer tick, asking Buildbucket for the build status
[22:42:42.598] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:42.598] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:17:0) after 1m0s
[22:43:42.629] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:17:0)
[22:43:42.629] Timer tick, asking Buildbucket for the build status
[22:43:42.763] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:42.763] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:18:0) after 1m0s
[22:44:42.789] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:18:0)
[22:44:42.789] Timer tick, asking Buildbucket for the build status
[22:44:42.870] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:42.870] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:19:0) after 1m0s
[22:45:42.880] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:19:0)
[22:45:42.880] Timer tick, asking Buildbucket for the build status
[22:45:43.036] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:43.036] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:20:0) after 1m0s
[22:46:43.068] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:20:0)
[22:46:43.068] Timer tick, asking Buildbucket for the build status
[22:46:43.309] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:43.309] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:21:0) after 1m0s
[22:47:43.365] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:21:0)
[22:47:43.365] Timer tick, asking Buildbucket for the build status
[22:47:43.480] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:43.480] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:22:0) after 1m0s
[22:48:43.532] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:22:0)
[22:48:43.532] Timer tick, asking Buildbucket for the build status
[22:48:43.636] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:43.636] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:23:0) after 1m0s
[22:49:43.672] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:23:0)
[22:49:43.672] Timer tick, asking Buildbucket for the build status
[22:49:43.788] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:43.788] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:24:0) after 1m0s
[22:50:43.784] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:24:0)
[22:50:43.784] Timer tick, asking Buildbucket for the build status
[22:50:44.002] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:44.002] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:25:0) after 1m0s
[22:51:44.137] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:25:0)
[22:51:44.137] Timer tick, asking Buildbucket for the build status
[22:51:44.282] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:44.282] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:26:0) after 1m0s
[22:52:44.330] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:26:0)
[22:52:44.330] Timer tick, asking Buildbucket for the build status
[22:52:44.468] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:44.468] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:27:0) after 1m0s
[22:53:44.488] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:27:0)
[22:53:44.488] Timer tick, asking Buildbucket for the build status
[22:53:44.663] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:44.663] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:28:0) after 1m0s
[22:54:44.723] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:28:0)
[22:54:44.723] Timer tick, asking Buildbucket for the build status
[22:54:45.170] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:45.170] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:29:0) after 1m0s
[22:55:45.196] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:29:0)
[22:55:45.196] Timer tick, asking Buildbucket for the build status
[22:55:45.250] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:45.250] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:30:0) after 1m0s
[22:56:45.282] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:30:0)
[22:56:45.282] Timer tick, asking Buildbucket for the build status
[22:56:45.376] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:45.376] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:31:0) after 1m0s
[22:57:45.429] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:31:0)
[22:57:45.429] Timer tick, asking Buildbucket for the build status
[22:57:45.797] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:45.797] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:32:0) after 1m0s
[22:58:45.850] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:32:0)
[22:58:45.850] Timer tick, asking Buildbucket for the build status
[22:58:46.005] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:46.005] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:33:0) after 1m0s
[22:59:46.069] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:33:0)
[22:59:46.069] Timer tick, asking Buildbucket for the build status
[22:59:46.178] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:46.178] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:34:0) after 1m0s
[23:00:46.204] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:34:0)
[23:00:46.204] Timer tick, asking Buildbucket for the build status
[23:00:46.311] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:46.311] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:35:0) after 1m0s
[23:01:46.418] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:35:0)
[23:01:46.418] Timer tick, asking Buildbucket for the build status
[23:01:46.569] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:46.569] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:36:0) after 1m0s
[23:02:46.635] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:36:0)
[23:02:46.635] Timer tick, asking Buildbucket for the build status
[23:02:47.632] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:47.632] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:37:0) after 1m0s
[23:03:47.655] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:37:0)
[23:03:47.655] Timer tick, asking Buildbucket for the build status
[23:03:47.830] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:47.830] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:38:0) after 1m0s
[23:04:47.863] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:38:0)
[23:04:47.863] Timer tick, asking Buildbucket for the build status
[23:04:48.013] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:48.013] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:39:0) after 1m0s
[23:05:48.121] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:39:0)
[23:05:48.121] Timer tick, asking Buildbucket for the build status
[23:05:48.237] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:48.237] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:40:0) after 1m0s
[23:06:48.339] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:40:0)
[23:06:48.339] Timer tick, asking Buildbucket for the build status
[23:06:48.682] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:48.682] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:41:0) after 1m0s
[23:07:48.791] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:41:0)
[23:07:48.791] Timer tick, asking Buildbucket for the build status
[23:07:48.882] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:48.882] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:42:0) after 1m0s
[23:08:48.939] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:42:0)
[23:08:48.940] Timer tick, asking Buildbucket for the build status
[23:08:49.068] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:49.069] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:43:0) after 1m0s
[23:09:49.128] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:43:0)
[23:09:49.128] Timer tick, asking Buildbucket for the build status
[23:09:49.312] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:49.312] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:44:0) after 1m0s
[23:10:49.346] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:44:0)
[23:10:49.346] Timer tick, asking Buildbucket for the build status
[23:10:49.577] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:49.577] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:45:0) after 1m0s
[23:11:49.638] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:45:0)
[23:11:49.638] Timer tick, asking Buildbucket for the build status
[23:11:49.746] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:49.746] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:46:0) after 1m0s
[23:12:49.774] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:46:0)
[23:12:49.774] Timer tick, asking Buildbucket for the build status
[23:12:49.895] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:49.895] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:47:0) after 1m0s
[23:13:49.959] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:47:0)
[23:13:49.959] Timer tick, asking Buildbucket for the build status
[23:13:50.077] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:50.077] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:48:0) after 1m0s
[23:14:50.105] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:48:0)
[23:14:50.105] Timer tick, asking Buildbucket for the build status
[23:14:50.300] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:50.300] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:49:0) after 1m0s
[23:15:50.356] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:49:0)
[23:15:50.356] Timer tick, asking Buildbucket for the build status
[23:15:50.590] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:50.590] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:50:0) after 1m0s
[23:16:50.644] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:50:0)
[23:16:50.644] Timer tick, asking Buildbucket for the build status
[23:16:51.047] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:51.047] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:51:0) after 1m0s
[23:17:51.207] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:51:0)
[23:17:51.207] Timer tick, asking Buildbucket for the build status
[23:17:51.517] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:51.517] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:52:0) after 1m0s
[23:18:51.600] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:52:0)
[23:18:51.600] Timer tick, asking Buildbucket for the build status
[23:18:51.996] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:51.996] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:53:0) after 1m0s
[23:19:52.018] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:53:0)
[23:19:52.018] Timer tick, asking Buildbucket for the build status
[23:19:52.098] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:52.098] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:54:0) after 1m0s
[23:20:52.255] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:54:0)
[23:20:52.255] Timer tick, asking Buildbucket for the build status
[23:20:52.339] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:52.339] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:55:0) after 1m0s
[23:21:52.515] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:55:0)
[23:21:52.515] Timer tick, asking Buildbucket for the build status
[23:21:52.682] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:52.682] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:56:0) after 1m0s
[23:22:52.755] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:56:0)
[23:22:52.755] Timer tick, asking Buildbucket for the build status
[23:22:52.886] Build 8887353637425261504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:52.886] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052783699407307536:57:0) after 1m0s
[23:23:36.774] Received PubSub notification, asking Buildbucket for the build status
[23:23:36.919] Build 8887353637425261504: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:23:36.919] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1582759415761463",
"created_by": "project:chromium",
"created_ts": "1582756117375840",
"id": "8887353637425261504",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"07a07d65ffad58feb3c867b69ec562a9156ed3b4\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"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}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-53-6ba3\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 169062, \"got_angle_revision\": \"8aea6d5a87b866990f409d9f179660c685216d9b\", \"got_dawn_revision\": \"a9d7d478429d8deaac52a0578826783877cd556a\", \"got_nacl_revision\": \"021c8b6784ea41113fe6d54f36359a0c329a5cc5\", \"got_revision\": \"07a07d65ffad58feb3c867b69ec562a9156ed3b4\", \"got_revision_cp\": \"refs/heads/master@{#744825}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"4d40271e3f09de5e6734b4223ea15b4faf758d2a\", \"got_v8_revision\": \"f8918f993aa5527146e183553a2fdfd913148f83\", \"got_v8_revision_cp\": \"refs/heads/8.2.195@{#1}\", \"got_webrtc_revision\": \"9731a14ff8ec3e09cf58c033898251dc2c75628f\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30620}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"07a07d65ffad58feb3c867b69ec562a9156ed3b4\", \"swarm_hashes_refs/heads/master(at){#744825}_without_patch\": {\"accessibility_unittests\": \"5fd48bccf5072cfe08f228123c398acd4f8136fd\", \"angle_unittests\": \"fe92991f8ea61eadf4624657120861d403c862de\", \"app_shell_unittests\": \"99c5e27f0893a9e15e14289ba82c869610b74138\", \"aura_unittests\": \"2e455836b3345cd659f9258aa3e592bf2cf14cff\", \"base_unittests\": \"a948b94a929bd8101e1c21a5d26712c2b2c0cd57\", \"base_util_unittests\": \"9253cec4f2de146d311346218501049bc708e763\", \"blink_common_unittests\": \"0f97c536d3af863190583c3e244bd6dbdb31a48c\", \"blink_fuzzer_unittests\": \"7cbea12a99312421897389411c4e17a01bcdb171\", \"blink_heap_unittests\": \"b87d8eb8c7425fd95f2a44d67147167ceab89009\", \"blink_platform_unittests\": \"207dc2fb7d87f528dbc869d50a6094bb772dabc1\", \"blink_python_tests\": \"80dd24e832dc4809687a7b70b8b078a728441737\", \"blink_unittests\": \"53850fab73109e289eceacf7f7ace8fa1cab767d\", \"blink_web_tests\": \"aff3ca9af0dd1e5d0b0fa35cb36c756221f022ed\", \"boringssl_crypto_tests\": \"083946481205d94d5264538821c61258910a531e\", \"boringssl_ssl_tests\": \"b56207e40dbb8c259327f95f0d2162df138dc202\", \"browser_tests\": \"9b8e74817800a56b544e180f0a2af6ff6009be25\", \"cacheinvalidation_unittests\": \"96ad7e3dadb3f272e9dbf3de71d979080884d8be\", \"capture_unittests\": \"3a05f1db7e3df515ef1fea1ff46ea1025ce61adb\", \"cast_unittests\": \"3eae1dae9eca8c6b9361f97a23dec80b0309a26a\", \"cc_unittests\": \"6a49c11b938388a25e0f225f7d7762494a0e43de\", \"chrome_app_unittests\": \"020a997c6961e6ce4f5df22ce0889b96ef405bad\", \"chromedriver_unittests\": \"4b1363a212007b676587030bff9529f928236d96\", \"components_browsertests\": \"ed922071851e18f77c83eeaaf2ee1990d89bf64c\", \"components_unittests\": \"752ef39392b795a7999487efa6b2073388791ed5\", \"compositor_unittests\": \"a5b560a4d478ec5b6d2dc625aa83314397e49f00\", \"content_browsertests\": \"0df6f5dcd4476542205f7addfdae0fb08613d88d\", \"content_shell_crash_test\": \"fea46ab42fed02fb5b5c6beff94c9608d0ce7785\", \"content_unittests\": \"a2ed09a508a21dd789fe1fa60b2266a57128d3e8\", \"crashpad_tests\": \"769b9ec45a1c472687a33772cdde9163b71bacf2\", \"cronet_tests\": \"0bcffcef7408bf68528964cb41158bafdecadc7a\", \"cronet_unittests\": \"f7b03242e536fd93f2a5df163b8ab45c96015b27\", \"crypto_unittests\": \"3636d1c1824feeaf0c2389cf634f3e6579a94a48\", \"dbus_unittests\": \"9854cc70fce8c3018270f7e2d3eb1553a31d1cba\", \"device_unittests\": \"d13f06004fbc9128f940dfbfb9ebfd93b23c1087\", \"display_unittests\": \"1deaca2c2c3165249c959b017c54bd70c34dd4bd\", \"events_unittests\": \"5e7c6451326cdcc7d82dd13987f66e5b6ab788a4\", \"extensions_browsertests\": \"eadf15246a08aa3f2122478e4f4478839be05e58\", \"extensions_unittests\": \"7d319ff543710ee54d93737268efff04ae3b5187\", \"filesystem_service_unittests\": \"a2e6a21bf1ca638cc5bdbcb7b1d88beff0507853\", \"flatbuffers_unittests\": \"9b972b84314b0e944fad99f4c5be3f50c351ec0c\", \"gcm_unit_tests\": \"551034ff46140533852df0f3cc39b48e31439ebc\", \"gfx_unittests\": \"a640b110367eb479a0c1eee25347985f25db1a08\", \"gin_unittests\": \"deae3e87509e2fecbad048e35292b03bb203b006\", \"google_apis_unittests\": \"a39cd67290cc6b42d48adab9cff20c22f745c19d\", \"gpu_unittests\": \"020179d880f38a255502ca414a877c2f9b3a1ce8\", \"grit_python_unittests\": \"8d3af1ca6ce7611b3ef6d2516a78cd61f915c28b\", \"gwp_asan_unittests\": \"757af6ece85270e511fdcd4fc3786fc709c92aeb\", \"headless_browsertests\": \"fbde800f3da49e99daba7ee71dd1388dfd00c3da\", \"headless_unittests\": \"4965b0ca3cae94b4a10431cc547ec9bd4b43e8d5\", \"interactive_ui_tests\": \"11ee6e2aee5d08e31d5f438bd502ad501f6c72fc\", \"ipc_tests\": \"9fb61dc929872f6dbea4b83e6f6c3cf981a7a8bb\", \"jingle_unittests\": \"2b25e10a09a07e5ee758336be70be67084efb93f\", \"latency_unittests\": \"06ab223a164e2ff88a72d506d46ebc3a423e0811\", \"libjingle_xmpp_unittests\": \"dab4c3ee45eb490f2dccf9da8efaa848780e6f9a\", \"media_blink_unittests\": \"e9eb17b713c32e904d61208aca090e2b3c216442\", \"media_service_unittests\": \"f40d11e516aa3d42dc64ed520b315a6d1ea3bda3\", \"media_unittests\": \"186797e88909d088094cc4928466c9d8e886539b\", \"message_center_unittests\": \"7a01e210f35de79fde0eb1b497ad6b7102db919e\", \"metrics_python_tests\": \"9429a7dfcef972ad13d9fbace22a26113574e7a8\", \"midi_unittests\": \"53b82eb928c3c57d7cf9926e81768ee893037e0c\", \"mojo_core_unittests\": \"ba8b52765e1972e9636f1f2a492373e31858218d\", \"mojo_unittests\": \"26f4e7960f38ede5479a1e406a5edfa0901b3aaa\", \"nacl_helper_nonsfi_unittests\": \"e6147388a300c62a559a511d5bccadfd2e26eb84\", \"nacl_loader_unittests\": \"e4481bc7d6a41631faf18964aa4dac213329bc69\", \"native_theme_unittests\": \"4c525ab0f6ea09fc22bdb24812be41169a0e7a36\", \"net_unittests\": \"f0096a85a5ab69393f6ad1ad9a3bfc48292a9f82\", \"pdf_unittests\": \"0cbf6e26697b161893caa47ed23d81521c0b0c1b\", \"perfetto_unittests\": \"31f6991b3179173bc532d0b8778f50f4cddb7ddc\", \"ppapi_unittests\": \"bb220e0cd1c4fd07f23d2859cc3536fc2a919369\", \"printing_unittests\": \"6c0da77f91888ba2ff7f1b93130dafb5dfbb4147\", \"remoting_unittests\": \"b2a2d259d4781e62991d2eb03de4bfd721232e9e\", \"sandbox_linux_unittests\": \"ccc6cd41ddd544c4d19c89f1827bad6c9344c38f\", \"service_manager_unittests\": \"75bf459c7bc8f291ea4dd5f25345193abe91e7fd\", \"services_unittests\": \"ea11d866b9a4e3f3d81db3a8cde3bd9bcdcb1934\", \"shell_dialogs_unittests\": \"2d0d6963d5e1ac86908f658d330a7726cf4daa58\", \"skia_unittests\": \"2cb52096722549f8bc78c1b734b3ee4f1cd3b930\", \"snapshot_unittests\": \"7fab19834a4c366a8964db67b15f47be4b65d25f\", \"sql_unittests\": \"89645e0571a7c7077594c462cbb8d54ace945f29\", \"storage_unittests\": \"d5821f91bb40c28eb2b4c58078e6c70f7c213e51\", \"sync_integration_tests\": \"008b14249562c2fa0ff182802e813fae1df01078\", \"telemetry_gpu_unittests\": \"4d69ebf39dac6164abedd31a149637d53cf7c789\", \"telemetry_perf_unittests\": \"8a1ce1e9283b6e560317ae52e93f526e6e0e9074\", \"telemetry_unittests\": \"46c86f6e48fd1c961d23db6ac39f5671fa73aa23\", \"traffic_annotation_auditor_unittests\": \"3eeff40869a95aedc68ce542ad23240c34df94fc\", \"ui_base_unittests\": \"c3e485b797ed7df0a76077cfb79b27c9f42cbb49\", \"ui_touch_selection_unittests\": \"722affc1b74fbb5846b5795fab57cfef125ec01d\", \"unit_tests\": \"c5f39f28ab9891ce8b111b7cad3bb0cf4fdbee5a\", \"url_unittests\": \"bb22492c9f32b5051ba8b20219fc456fc4c7451b\", \"views_perftests\": \"8f0e6cd39a22eca3eec396f4a08c5e85d7ac2abc\", \"views_unittests\": \"308f679049ed29a7353183e1b2897e3f189f95fc\", \"viz_unittests\": \"ceaa4ba7ca7cc0135015329103e2e01a83c71ae2\", \"vr_common_unittests\": \"1a765c91ff8ffe4c757030746dc77988fee4b07d\", \"vr_pixeltests\": \"ca820e7b944d2cfca4e304722af318c93ae7f718\", \"webdriver_wpt_tests\": \"33bc635758bb1799fa5df0e62fcfe3542e5c2bf3\", \"weblayer_browsertests\": \"df0895fd6ab5c5c4088d9e5e129cebb0a1622d95\", \"wm_unittests\": \"490b8f35304b15dce25417f6b36216ce6ca929f7\", \"wtf_unittests\": \"69830c8eb3468e46401eb36303f0a9434fcb7c90\", \"xr_browser_tests\": \"1477eb570c7da79601dff4588ead44695782d507\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2295bac873f7edd8c9763e89419d85b38a875955550d968c436d775d3f06377b_v2\", \"builder_69f5bab4a885266166e099964d6d1498f6d3761c92bc1d5b083a29cb822fe90c_v2\", \"builder_f5174a4d80cdc4c8aa1989fa45d69979d28910f768af140dd646791c34143bfe_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\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-53-6ba3\"], \"image\": [\"chrome-xenial-20012600-8e1a7e485b7\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4838-b69615e\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1582756453097677",
"status": "COMPLETED",
"status_changed_ts": "1582759416468610",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169062",
"builder:Linux Builder (dbg)",
"buildset:commit/git/07a07d65ffad58feb3c867b69ec562a9156ed3b4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/07a07d65ffad58feb3c867b69ec562a9156ed3b4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9052783699407307536",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8887353637425261504/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:4a9c6f4b35835210",
"user_agent:luci-scheduler"
],
"updated_ts": "1582759416487548",
"url": "https://ci.chromium.org/b/8887353637425261504",
"utcnow_ts": "1582759416898208"
}
}
[23:23:36.919] Invocation finished in 55m0.816412834s with status SUCCEEDED