[14:18:32.482] New invocation is queued and will start shortly
[14:18:33.594] Starting the invocation (attempt 1)
[14:18:33.635] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:18:33.635] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:18:33.635] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028715738292540688",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d3dd69af2790f08c773b0973b5e5a962e1281d4f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9028715738292540688",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/d3dd69af2790f08c773b0973b5e5a962e1281d4f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d3dd69af2790f08c773b0973b5e5a962e1281d4f",
"gitiles_ref:refs/heads/master"
]
}
[14:18:35.410] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605709113864249",
"id": "8863285676179413520",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d3dd69af2790f08c773b0973b5e5a962e1281d4f\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605709115165092",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/177798",
"builder:Linux Builder (dbg)",
"buildset:commit/git/d3dd69af2790f08c773b0973b5e5a962e1281d4f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d3dd69af2790f08c773b0973b5e5a962e1281d4f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028715738292540688",
"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/8863285676179413520/+/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": "1605709115165271",
"url": "https://ci.chromium.org/b/8863285676179413520",
"utcnow_ts": "1605709115387106"
}
}
[14:18:35.410] Task URL: https://ci.chromium.org/b/8863285676179413520
[14:18:35.410] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:2:0) after 1m0s
[14:18:42.428] Received PubSub notification, asking Buildbucket for the build status
[14:18:42.494] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:35.462] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:2:0)
[14:19:35.462] Timer tick, asking Buildbucket for the build status
[14:19:35.575] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:35.576] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:4:0) after 1m0s
[14:20:35.604] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:4:0)
[14:20:35.604] Timer tick, asking Buildbucket for the build status
[14:20:35.729] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:35.729] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:5:0) after 1m0s
[14:21:35.756] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:5:0)
[14:21:35.756] Timer tick, asking Buildbucket for the build status
[14:21:36.227] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:36.227] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:6:0) after 1m0s
[14:22:36.258] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:6:0)
[14:22:36.258] Timer tick, asking Buildbucket for the build status
[14:22:36.419] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:36.419] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:7:0) after 1m0s
[14:23:36.441] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:7:0)
[14:23:36.441] Timer tick, asking Buildbucket for the build status
[14:23:36.572] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:36.572] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:8:0) after 1m0s
[14:24:36.618] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:8:0)
[14:24:36.618] Timer tick, asking Buildbucket for the build status
[14:24:36.726] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:36.726] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:9:0) after 1m0s
[14:25:36.812] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:9:0)
[14:25:36.812] Timer tick, asking Buildbucket for the build status
[14:25:37.139] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:37.139] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:10:0) after 1m0s
[14:26:37.239] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:10:0)
[14:26:37.239] Timer tick, asking Buildbucket for the build status
[14:26:37.333] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:37.333] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:11:0) after 1m0s
[14:27:37.421] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:11:0)
[14:27:37.421] Timer tick, asking Buildbucket for the build status
[14:27:37.792] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:37.792] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:12:0) after 1m0s
[14:28:37.859] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:12:0)
[14:28:37.859] Timer tick, asking Buildbucket for the build status
[14:28:37.954] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:37.954] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:13:0) after 1m0s
[14:29:38.023] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:13:0)
[14:29:38.023] Timer tick, asking Buildbucket for the build status
[14:29:38.328] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:38.328] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:14:0) after 1m0s
[14:30:38.354] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:14:0)
[14:30:38.354] Timer tick, asking Buildbucket for the build status
[14:30:38.775] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:38.775] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:15:0) after 1m0s
[14:31:38.807] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:15:0)
[14:31:38.807] Timer tick, asking Buildbucket for the build status
[14:31:38.873] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:38.873] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:16:0) after 1m0s
[14:32:38.976] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:16:0)
[14:32:38.976] Timer tick, asking Buildbucket for the build status
[14:32:39.247] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:39.247] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:17:0) after 1m0s
[14:33:39.287] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:17:0)
[14:33:39.287] Timer tick, asking Buildbucket for the build status
[14:33:39.392] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:39.393] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:18:0) after 1m0s
[14:34:39.414] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:18:0)
[14:34:39.414] Timer tick, asking Buildbucket for the build status
[14:34:39.522] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:39.523] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:19:0) after 1m0s
[14:35:39.639] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:19:0)
[14:35:39.639] Timer tick, asking Buildbucket for the build status
[14:35:39.703] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:39.703] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:20:0) after 1m0s
[14:36:39.760] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:20:0)
[14:36:39.760] Timer tick, asking Buildbucket for the build status
[14:36:39.865] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:39.865] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:21:0) after 1m0s
[14:37:39.861] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:21:0)
[14:37:39.861] Timer tick, asking Buildbucket for the build status
[14:37:39.940] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:39.941] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:22:0) after 1m0s
[14:38:39.986] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:22:0)
[14:38:39.986] Timer tick, asking Buildbucket for the build status
[14:38:40.371] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:40.371] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:23:0) after 1m0s
[14:39:40.414] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:23:0)
[14:39:40.414] Timer tick, asking Buildbucket for the build status
[14:39:40.631] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:40.631] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:24:0) after 1m0s
[14:40:40.666] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:24:0)
[14:40:40.666] Timer tick, asking Buildbucket for the build status
[14:40:40.805] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:40.805] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:25:0) after 1m0s
[14:41:40.837] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:25:0)
[14:41:40.837] Timer tick, asking Buildbucket for the build status
[14:41:40.893] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:40.893] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:26:0) after 1m0s
[14:42:40.929] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:26:0)
[14:42:40.929] Timer tick, asking Buildbucket for the build status
[14:42:40.988] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:40.988] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:27:0) after 1m0s
[14:43:41.024] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:27:0)
[14:43:41.024] Timer tick, asking Buildbucket for the build status
[14:43:41.240] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:41.240] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:28:0) after 1m0s
[14:44:41.318] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:28:0)
[14:44:41.318] Timer tick, asking Buildbucket for the build status
[14:44:41.385] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:41.385] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:29:0) after 1m0s
[14:45:41.439] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:29:0)
[14:45:41.439] Timer tick, asking Buildbucket for the build status
[14:45:41.504] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:41.504] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:30:0) after 1m0s
[14:46:41.555] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:30:0)
[14:46:41.555] Timer tick, asking Buildbucket for the build status
[14:46:41.619] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:41.619] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:31:0) after 1m0s
[14:47:41.664] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:31:0)
[14:47:41.664] Timer tick, asking Buildbucket for the build status
[14:47:41.744] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:41.744] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:32:0) after 1m0s
[14:48:41.792] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:32:0)
[14:48:41.792] Timer tick, asking Buildbucket for the build status
[14:48:41.952] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:41.952] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:33:0) after 1m0s
[14:49:41.954] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:33:0)
[14:49:41.954] Timer tick, asking Buildbucket for the build status
[14:49:42.105] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:42.105] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:34:0) after 1m0s
[14:50:42.143] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:34:0)
[14:50:42.143] Timer tick, asking Buildbucket for the build status
[14:50:42.215] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:42.215] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:35:0) after 1m0s
[14:51:42.232] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:35:0)
[14:51:42.232] Timer tick, asking Buildbucket for the build status
[14:51:42.330] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:42.330] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:36:0) after 1m0s
[14:52:42.362] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:36:0)
[14:52:42.362] Timer tick, asking Buildbucket for the build status
[14:52:42.609] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:42.609] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:37:0) after 1m0s
[14:53:42.659] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:37:0)
[14:53:42.659] Timer tick, asking Buildbucket for the build status
[14:53:43.637] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:43.637] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:38:0) after 1m0s
[14:54:43.672] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:38:0)
[14:54:43.672] Timer tick, asking Buildbucket for the build status
[14:54:43.766] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:43.766] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:39:0) after 1m0s
[14:55:43.822] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:39:0)
[14:55:43.822] Timer tick, asking Buildbucket for the build status
[14:55:43.926] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:43.926] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:40:0) after 1m0s
[14:56:43.948] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:40:0)
[14:56:43.948] Timer tick, asking Buildbucket for the build status
[14:56:44.010] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:44.010] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:41:0) after 1m0s
[14:57:44.061] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:41:0)
[14:57:44.061] Timer tick, asking Buildbucket for the build status
[14:57:44.109] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:44.109] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:42:0) after 1m0s
[14:58:44.173] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:42:0)
[14:58:44.173] Timer tick, asking Buildbucket for the build status
[14:58:44.306] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:44.306] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:43:0) after 1m0s
[14:59:44.358] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:43:0)
[14:59:44.358] Timer tick, asking Buildbucket for the build status
[14:59:44.463] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:44.463] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:44:0) after 1m0s
[15:00:44.467] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:44:0)
[15:00:44.467] Timer tick, asking Buildbucket for the build status
[15:00:44.595] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:44.595] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:45:0) after 1m0s
[15:01:44.685] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:45:0)
[15:01:44.685] Timer tick, asking Buildbucket for the build status
[15:01:45.036] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:45.036] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:46:0) after 1m0s
[15:02:45.067] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:46:0)
[15:02:45.067] Timer tick, asking Buildbucket for the build status
[15:02:45.441] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:45.441] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:47:0) after 1m0s
[15:03:45.492] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:47:0)
[15:03:45.492] Timer tick, asking Buildbucket for the build status
[15:03:45.610] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:45.610] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:48:0) after 1m0s
[15:04:45.660] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:48:0)
[15:04:45.660] Timer tick, asking Buildbucket for the build status
[15:04:59.026] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:59.026] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:49:0) after 1m0s
[15:05:59.126] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:49:0)
[15:05:59.126] Timer tick, asking Buildbucket for the build status
[15:05:59.212] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:59.212] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:50:0) after 1m0s
[15:06:59.229] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:50:0)
[15:06:59.229] Timer tick, asking Buildbucket for the build status
[15:06:59.346] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:59.346] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:51:0) after 1m0s
[15:07:59.417] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:51:0)
[15:07:59.417] Timer tick, asking Buildbucket for the build status
[15:07:59.478] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:59.478] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:52:0) after 1m0s
[15:08:59.558] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:52:0)
[15:08:59.558] Timer tick, asking Buildbucket for the build status
[15:08:59.750] Build 8863285676179413520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:59.750] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028715738292540688:53:0) after 1m0s
[15:09:25.461] Received PubSub notification, asking Buildbucket for the build status
[15:09:25.623] Build 8863285676179413520: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:09:25.623] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605712164391256",
"created_by": "project:chromium",
"created_ts": "1605709113864249",
"id": "8863285676179413520",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d3dd69af2790f08c773b0973b5e5a962e1281d4f\"}}",
"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\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"d3dd69af2790f08c773b0973b5e5a962e1281d4f\", \"project\": \"chromium/src\"}], \"$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-99-e3yw\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 177798, \"got_angle_revision\": \"d1219d7bc85c22e75fa8b1148a38ddab60601b04\", \"got_dawn_revision\": \"55f251dffe05a471f5979a315fa6fee54804e3b8\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"d3dd69af2790f08c773b0973b5e5a962e1281d4f\", \"got_revision_cp\": \"refs/heads/master@{#828698}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"50066a3edffa96879ad1545a8e61c009c86c6e71\", \"got_v8_revision\": \"3644d1fc3b7f59e11f5e80b6feb79634736e0192\", \"got_v8_revision_cp\": \"refs/heads/8.9.7@{#1}\", \"got_webrtc_revision\": \"afaca889d46b2c493de34a8f0771c89dea17bb1a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32614}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.linux:linux-clang-tidy-dbg\", \"tryserver.chromium.linux:linux_chromium_dbg_ng\", \"tryserver.chromium.linux:linux_chromium_compile_dbg_ng\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d3dd69af2790f08c773b0973b5e5a962e1281d4f\", \"swarm_hashes_refs/heads/master(at){#828698}_without_patch\": {\"absl_hardening_tests\": \"978c886aa6e7b9d939b4479fa7ad875fba309eb5\", \"accessibility_unittests\": \"f8142d0ac2d5ecd881eeb8aad36d2a63171d51b6\", \"angle_unittests\": \"fa4600b211f33b8174ec1585f275a6a9566f7a59\", \"app_shell_unittests\": \"442266d57853bc4c35dedb7acdcfa754ec1e4248\", \"aura_unittests\": \"9d4318f3cb7bfffc121bd3f579e0822ea692ee6e\", \"base_unittests\": \"c96850b7a5e3d9d756e620101a5ac205cd2d9814\", \"base_util_unittests\": \"76d5e4737663470c2b25032950da7550c606428b\", \"blink_common_unittests\": \"1092d20b38db89a7e201458e0517eaee97dbedb2\", \"blink_fuzzer_unittests\": \"b060229671b117735c1916a26d6c6475f4b6364b\", \"blink_heap_unittests\": \"daf3cc5faa560965746dec306fdbb8cdb1f34a5e\", \"blink_platform_unittests\": \"67cd91946e5ca72d98a8d24e9a2a62580b0616cb\", \"blink_python_tests\": \"6780340349deb41ac976ddda65bd6a0931449101\", \"blink_unittests\": \"ce061e6ae960bbbb0d4d218caf520d492ddd1284\", \"blink_web_tests\": \"9076f76b3fa0b269012695a52544380c7d3d5543\", \"boringssl_crypto_tests\": \"246ddcbc992220b66fe8fc5591b97bada04a9583\", \"boringssl_ssl_tests\": \"9706f12ab3e2f2326374e71358096ab6ec37776f\", \"browser_tests\": \"15da35812fbeb283de67dac28e50c4c6f919afda\", \"capture_unittests\": \"a5921a0ad160095751710eacfcad5393679b5473\", \"cast_unittests\": \"a0ade143d9fb2006c08431b483bb3d9bdf47c233\", \"cc_unittests\": \"380658dafb95bd1b8f85b6559ff01b4abfbb59cb\", \"chrome_app_unittests\": \"44262784a62f2282a0528aa94fc3b663719afa91\", \"chromedriver_unittests\": \"1378a36b445065902b32c1bcd8727f9692ee77f7\", \"components_browsertests\": \"8bbdbf7170f128a6a644a7eed512ea56b5e7945e\", \"components_unittests\": \"76a6368d623fdb2d36b4fb432cb3e9df647627e6\", \"compositor_unittests\": \"e26611bcdb5df93494f1cf57f365d0068058defc\", \"content_browsertests\": \"2571575dfc84d25cd6c6df5fa93a791adc65b9a3\", \"content_shell_crash_test\": \"436dd5d0be3a327ced20d721a0980aebfaaf61f3\", \"content_unittests\": \"5a5feeb4afef4021baf612807d1a3a238075c10e\", \"crashpad_tests\": \"1d923a4cbb68545845251148d137acaf69fee280\", \"cronet_tests\": \"7675b5886abfc81712cd0dd1c20f90c879acd26e\", \"cronet_unittests\": \"a6305ba7677a607179c4f2fe198b5109654786d1\", \"crypto_unittests\": \"fd21353eb715b05ca4508c4cc66fcedb8875cae2\", \"dbus_unittests\": \"5ca7099a533380ff3c350b64ac03e8dff39292aa\", \"device_unittests\": \"59a840e8f6146087ed0de18b4bde0fc97bfbed00\", \"display_unittests\": \"afb558c93e3ab373c3d8099d2be9024be556b3b0\", \"events_unittests\": \"ba54b18f17e5eee2638925c508564efc4911ce81\", \"extension_docserver_python_unittests\": \"b066845569e12497e6aa19c9812ac44fcd4f31c0\", \"extensions_browsertests\": \"1ccb74d527170dd1ff150021afe81135f7a09cbc\", \"extensions_unittests\": \"bf5e68a2f8d494c849f91ee9b46095ffcab74d68\", \"filesystem_service_unittests\": \"9e246356d584f02118c662879f65a21b5b213500\", \"flatbuffers_unittests\": \"d33d035d560586b16b3cc2d0fb3d4f805cfe7d33\", \"gcm_unit_tests\": \"82392819d9ee70c808600d7d5d6c9ddc665d18db\", \"gfx_unittests\": \"b4a1d1ef7117afb4d6daeb58c07776391d8269f6\", \"gin_unittests\": \"d958f2ac0d9ad7d977adc174e9b745d52d95aef5\", \"google_apis_unittests\": \"54c719d5c807bd5014652cf0d7375a51c1254d42\", \"gpu_unittests\": \"05771af5074b0765116fafe5a0806d7b6e811b4a\", \"grit_python_unittests\": \"b20d4d77fd059e1da02f2886f0fe402b433cc81c\", \"gwp_asan_unittests\": \"9e75e133c195b097349048441a10b28d6a1de6bf\", \"headless_browsertests\": \"cf2cf2260b2efaf8598e87521a314f54481b7407\", \"headless_unittests\": \"2a3eb4c47966742265454acdc96fdef589d522dc\", \"interactive_ui_tests\": \"c3e286d42c34acf940ca665f953c3792338ef23c\", \"ipc_tests\": \"64b21e56063696541892cfdbab4390a71c7b8728\", \"jingle_unittests\": \"429681c12aa0edfe5b2358471b34ed5430e30b19\", \"latency_unittests\": \"7604dbd624c715713f78e3e329e8baca1ce11258\", \"libjingle_xmpp_unittests\": \"2960e97a817d2dc3849c5254eb8b9e96ab1c39e5\", \"liburlpattern_unittests\": \"80f3824047f22dc36189a99c40d076496c2b2d71\", \"media_blink_unittests\": \"88a8187c9c46477c9b4b5c6eacd694fc80bb9c90\", \"media_unittests\": \"758e2079b6acb922b3c6dbeb03e22ae6d2251efc\", \"message_center_unittests\": \"c58ce92bd68fb197f97c0b18dfc5193a63b73dd7\", \"metrics_python_tests\": \"513b2d8ed7318d8f2894a68645f6c936239cb1c5\", \"midi_unittests\": \"9f86e8a28c593eec50f82277873f23c5dc99dca3\", \"mojo_core_unittests\": \"9b56675515392d92b254943f22b4f0b2a069277b\", \"mojo_unittests\": \"5ed98db42551842b7651ffb3bf7583cb26cca048\", \"nacl_helper_nonsfi_unittests\": \"34162ce9889e2b1defae8aadf5012493543794d2\", \"nacl_loader_unittests\": \"508be19da584522077135b8d79e45c40bc1660f2\", \"native_theme_unittests\": \"839909239bcc9b7c48440d981d1ee511fb136ae0\", \"net_unittests\": \"7485fe85764c71e1a5c59698fbbda693adaca5f5\", \"openscreen_unittests\": \"c1ce6ba2d6afc5ebcfe0c8411392c41c850e631a\", \"pdf_unittests\": \"1cd769ee6626296b1dd67d6485cab1eb94fbc083\", \"perfetto_unittests\": \"875cfccb292021c51ea256f41f811167cc4c85d1\", \"ppapi_unittests\": \"2ae2ff50ee87e2eb4381536c0fb38ccf8c33ac42\", \"printing_unittests\": \"e413e02d6093b9e7772cdccf89b003685bb860a6\", \"remoting_unittests\": \"34c8a2fbc273bd23983407e6699ecd36cbfb1759\", \"sandbox_linux_unittests\": \"2540a2a4490f92208499d9cebccc3e63635973cf\", \"service_manager_unittests\": \"32540a543dbfbd9af13d6b79844ffc975e18660c\", \"services_unittests\": \"a506232e9bf183238f7709a29734805194ea82ad\", \"shell_dialogs_unittests\": \"c5b513b39dfb9121a4b8cec8b74b6ff020e5235d\", \"skia_unittests\": \"105efd0f9ca33c8375bf4562538b649eef804888\", \"snapshot_unittests\": \"b6bf20269153df715da658acd2520490d8007e8f\", \"sql_unittests\": \"52a68d0a9ea76510607a954cb4be2f3a70ee23af\", \"storage_unittests\": \"d119536e12edc124c976b44e2f9b37e0a2668b9f\", \"sync_integration_tests\": \"126da0cbdf3ccc3a4c307b149d823df5f0e751e6\", \"telemetry_gpu_unittests\": \"2cb61ee688d8e34fa68daab74331347d62c39db5\", \"telemetry_perf_unittests\": \"74a2b69914440625c8a9fd45790617445ff9147b\", \"telemetry_unittests\": \"6e0b7a47220e668734937bb636b596cfd110888d\", \"traffic_annotation_auditor_unittests\": \"c2899e0ac081fbd774692084e57166ac5458bfc0\", \"ui_base_unittests\": \"f8788ae8718b676c05912a0945039155bbd5d8ea\", \"ui_touch_selection_unittests\": \"baf271439e8b6e24a08274ddd0b6615094eab3d7\", \"unit_tests\": \"863ffbd069aa49d182413a0d651802b446ae4eea\", \"url_unittests\": \"ec0f5630e17257773bf5cbd5e36bf49d32ef42a4\", \"views_perftests\": \"020dc710e498548d50f439389769b9df2c32849e\", \"views_unittests\": \"77eea5a086e5735e66f16fd8a1c713a9c0452017\", \"viz_unittests\": \"d08e6dbe2280c0a6086927f930173739076328dc\", \"vr_common_unittests\": \"9225b89f77e0d2d405924fa2eafdbc2cb3e33874\", \"vr_pixeltests\": \"bccd302b04c294d594779adafbd6fe72e0a60df5\", \"webdriver_wpt_tests\": \"806ba2528cc1acbc777c4750d801b00c01b8c8e3\", \"weblayer_browsertests\": \"8b333c8b755d472fd737504f144a9cabb38b658e\", \"weblayer_unittests\": \"6d9c27ff072ab77f91cfcfa10fb0f1c35a6e62ac\", \"wm_unittests\": \"1710d16515330e826a566807d9976aadd29b16f8\", \"wtf_unittests\": \"142a30b6c93ad037daad91222aa6db00435eb36b\", \"x11_unittests\": \"b187e00836c0308e3b8a8473847806de0af31d6f\", \"xr_browser_tests\": \"33ad61098db07b2480dc24891e6c9240ab6e66e0\", \"zlib_unittests\": \"d77fabac1e25516f1e8d2b8510d2c5ee63d32062\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_387e931c7b633ee2f48b892df14288ffa2061feda74b30444810d565fa474120_v2\", \"builder_4107b14b7476412be0315d38f8e370eb2ac2c1b388bb8ffb59d7bdd8f08032e9_v2\", \"builder_6440ef9dedd0dc3b34dcb22ab34f3415d4cc49eb5cc8c1aeab1a9757364e9da5_v2\", \"builder_ded6992437bb43fbf38c4db56f613c83c13b8efc5129044b4fc05fb02888bbc4_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-99-e3yw\"], \"image\": [\"chrome-xenial-20110800-08efb743065\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5635-1756fdb\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1605709120993698",
"status": "COMPLETED",
"status_changed_ts": "1605712164870806",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/177798",
"builder:Linux Builder (dbg)",
"buildset:commit/git/d3dd69af2790f08c773b0973b5e5a962e1281d4f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d3dd69af2790f08c773b0973b5e5a962e1281d4f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028715738292540688",
"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/8863285676179413520/+/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:4ff48a3843bf2810",
"user_agent:luci-scheduler"
],
"updated_ts": "1605712164901305",
"url": "https://ci.chromium.org/b/8863285676179413520",
"utcnow_ts": "1605712165608318"
}
}
[15:09:25.623] Invocation finished in 50m53.15797624s with status SUCCEEDED