[03:32:36.396] New invocation is queued and will start shortly
[03:32:37.463] Starting the invocation (attempt 1)
[03:32:37.514] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:32:37.514] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:32:37.514] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020965037884082720",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"8b29a603c82d1da66828b7d444473a0f7a5676ce\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9020965037884082720",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/8b29a603c82d1da66828b7d444473a0f7a5676ce",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8b29a603c82d1da66828b7d444473a0f7a5676ce",
"gitiles_ref:refs/heads/master"
]
}
[03:32:38.194] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613100757639961",
"id": "8855534975916505536",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8b29a603c82d1da66828b7d444473a0f7a5676ce\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613100758055283",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180510",
"builder:Linux Builder (dbg)",
"buildset:commit/git/8b29a603c82d1da66828b7d444473a0f7a5676ce",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8b29a603c82d1da66828b7d444473a0f7a5676ce",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020965037884082720",
"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/8855534975916505536/+/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": "1613100758055484",
"url": "https://ci.chromium.org/b/8855534975916505536",
"utcnow_ts": "1613100758181719"
}
}
[03:32:38.194] Task URL: https://ci.chromium.org/b/8855534975916505536
[03:32:38.194] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:2:0) after 1m0s
[03:32:41.182] Received PubSub notification, asking Buildbucket for the build status
[03:32:41.326] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:38.217] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:2:0)
[03:33:38.217] Timer tick, asking Buildbucket for the build status
[03:33:38.535] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:38.535] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:4:0) after 1m0s
[03:34:38.562] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:4:0)
[03:34:38.562] Timer tick, asking Buildbucket for the build status
[03:34:38.693] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:38.693] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:5:0) after 1m0s
[03:35:38.744] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:5:0)
[03:35:38.744] Timer tick, asking Buildbucket for the build status
[03:35:38.829] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:38.829] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:6:0) after 1m0s
[03:36:38.855] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:6:0)
[03:36:38.855] Timer tick, asking Buildbucket for the build status
[03:36:39.050] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:39.050] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:7:0) after 1m0s
[03:37:39.082] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:7:0)
[03:37:39.082] Timer tick, asking Buildbucket for the build status
[03:37:39.162] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:39.162] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:8:0) after 1m0s
[03:38:39.181] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:8:0)
[03:38:39.181] Timer tick, asking Buildbucket for the build status
[03:38:39.268] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:39.268] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:9:0) after 1m0s
[03:39:39.314] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:9:0)
[03:39:39.314] Timer tick, asking Buildbucket for the build status
[03:39:39.394] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:39.394] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:10:0) after 1m0s
[03:40:39.409] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:10:0)
[03:40:39.409] Timer tick, asking Buildbucket for the build status
[03:40:39.545] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:39.545] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:11:0) after 1m0s
[03:41:39.568] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:11:0)
[03:41:39.568] Timer tick, asking Buildbucket for the build status
[03:41:39.661] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:39.661] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:12:0) after 1m0s
[03:42:39.680] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:12:0)
[03:42:39.681] Timer tick, asking Buildbucket for the build status
[03:42:39.775] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:39.775] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:13:0) after 1m0s
[03:43:39.830] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:13:0)
[03:43:39.830] Timer tick, asking Buildbucket for the build status
[03:43:39.920] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:39.920] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:14:0) after 1m0s
[03:44:40.075] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:14:0)
[03:44:40.075] Timer tick, asking Buildbucket for the build status
[03:44:40.157] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:40.157] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:15:0) after 1m0s
[03:45:40.237] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:15:0)
[03:45:40.237] Timer tick, asking Buildbucket for the build status
[03:45:40.371] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:40.371] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:16:0) after 1m0s
[03:46:40.424] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:16:0)
[03:46:40.424] Timer tick, asking Buildbucket for the build status
[03:46:40.524] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:40.524] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:17:0) after 1m0s
[03:47:40.623] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:17:0)
[03:47:40.623] Timer tick, asking Buildbucket for the build status
[03:47:40.828] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:40.828] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:18:0) after 1m0s
[03:48:40.921] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:18:0)
[03:48:40.921] Timer tick, asking Buildbucket for the build status
[03:48:41.067] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:41.067] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:19:0) after 1m0s
[03:49:41.068] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:19:0)
[03:49:41.068] Timer tick, asking Buildbucket for the build status
[03:49:41.453] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:41.453] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:20:0) after 1m0s
[03:50:41.460] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:20:0)
[03:50:41.460] Timer tick, asking Buildbucket for the build status
[03:50:41.809] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:41.809] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:21:0) after 1m0s
[03:51:41.908] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:21:0)
[03:51:41.908] Timer tick, asking Buildbucket for the build status
[03:51:41.980] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:41.980] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:22:0) after 1m0s
[03:52:42.029] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:22:0)
[03:52:42.029] Timer tick, asking Buildbucket for the build status
[03:52:42.135] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:42.135] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:23:0) after 1m0s
[03:53:42.255] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:23:0)
[03:53:42.255] Timer tick, asking Buildbucket for the build status
[03:53:42.352] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:42.353] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:24:0) after 1m0s
[03:54:42.439] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:24:0)
[03:54:42.439] Timer tick, asking Buildbucket for the build status
[03:54:42.556] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:42.556] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:25:0) after 1m0s
[03:55:42.800] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:25:0)
[03:55:42.800] Timer tick, asking Buildbucket for the build status
[03:55:42.925] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:42.925] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:26:0) after 1m0s
[03:56:42.956] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:26:0)
[03:56:42.956] Timer tick, asking Buildbucket for the build status
[03:56:43.034] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:43.034] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:27:0) after 1m0s
[03:57:43.138] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:27:0)
[03:57:43.138] Timer tick, asking Buildbucket for the build status
[03:57:43.245] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:43.245] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:28:0) after 1m0s
[03:58:43.289] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:28:0)
[03:58:43.289] Timer tick, asking Buildbucket for the build status
[03:58:43.418] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:43.418] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:29:0) after 1m0s
[03:59:43.609] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:29:0)
[03:59:43.609] Timer tick, asking Buildbucket for the build status
[03:59:43.681] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:43.681] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:30:0) after 1m0s
[04:00:43.703] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:30:0)
[04:00:43.703] Timer tick, asking Buildbucket for the build status
[04:00:43.869] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:43.869] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:31:0) after 1m0s
[04:01:43.889] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:31:0)
[04:01:43.889] Timer tick, asking Buildbucket for the build status
[04:01:44.104] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:44.104] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:32:0) after 1m0s
[04:02:44.127] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:32:0)
[04:02:44.127] Timer tick, asking Buildbucket for the build status
[04:02:44.217] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:44.217] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:33:0) after 1m0s
[04:03:44.289] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:33:0)
[04:03:44.289] Timer tick, asking Buildbucket for the build status
[04:03:44.366] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:44.366] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:34:0) after 1m0s
[04:04:44.448] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:34:0)
[04:04:44.449] Timer tick, asking Buildbucket for the build status
[04:04:44.556] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:44.556] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:35:0) after 1m0s
[04:05:44.617] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:35:0)
[04:05:44.617] Timer tick, asking Buildbucket for the build status
[04:05:44.706] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:44.706] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:36:0) after 1m0s
[04:06:44.734] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:36:0)
[04:06:44.734] Timer tick, asking Buildbucket for the build status
[04:06:44.805] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:44.805] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:37:0) after 1m0s
[04:07:44.898] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:37:0)
[04:07:44.898] Timer tick, asking Buildbucket for the build status
[04:07:44.994] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:44.994] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:38:0) after 1m0s
[04:08:45.041] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:38:0)
[04:08:45.041] Timer tick, asking Buildbucket for the build status
[04:08:45.250] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:45.250] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:39:0) after 1m0s
[04:09:45.247] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:39:0)
[04:09:45.247] Timer tick, asking Buildbucket for the build status
[04:09:45.399] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:45.399] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:40:0) after 1m0s
[04:10:45.487] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:40:0)
[04:10:45.487] Timer tick, asking Buildbucket for the build status
[04:10:45.683] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:45.683] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:41:0) after 1m0s
[04:11:45.734] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:41:0)
[04:11:45.735] Timer tick, asking Buildbucket for the build status
[04:11:45.823] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:45.823] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:42:0) after 1m0s
[04:12:45.878] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:42:0)
[04:12:45.878] Timer tick, asking Buildbucket for the build status
[04:12:45.988] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:45.988] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:43:0) after 1m0s
[04:13:45.965] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:43:0)
[04:13:45.965] Timer tick, asking Buildbucket for the build status
[04:13:46.042] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:46.042] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:44:0) after 1m0s
[04:14:46.066] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:44:0)
[04:14:46.066] Timer tick, asking Buildbucket for the build status
[04:14:46.156] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:46.156] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:45:0) after 1m0s
[04:15:46.193] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:45:0)
[04:15:46.193] Timer tick, asking Buildbucket for the build status
[04:15:46.303] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:46.303] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:46:0) after 1m0s
[04:16:46.362] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:46:0)
[04:16:46.362] Timer tick, asking Buildbucket for the build status
[04:16:46.463] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:46.463] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:47:0) after 1m0s
[04:17:46.513] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:47:0)
[04:17:46.513] Timer tick, asking Buildbucket for the build status
[04:17:46.600] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:46.600] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:48:0) after 1m0s
[04:18:46.646] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:48:0)
[04:18:46.646] Timer tick, asking Buildbucket for the build status
[04:18:46.723] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:46.723] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:49:0) after 1m0s
[04:19:46.810] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:49:0)
[04:19:46.810] Timer tick, asking Buildbucket for the build status
[04:19:46.997] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:46.997] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:50:0) after 1m0s
[04:20:47.010] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:50:0)
[04:20:47.010] Timer tick, asking Buildbucket for the build status
[04:20:47.120] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:47.120] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:51:0) after 1m0s
[04:21:47.168] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:51:0)
[04:21:47.168] Timer tick, asking Buildbucket for the build status
[04:21:47.272] Build 8855534975916505536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:47.272] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020965037884082720:52:0) after 1m0s
[04:22:34.693] Received PubSub notification, asking Buildbucket for the build status
[04:22:34.785] Build 8855534975916505536: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[04:22:34.785] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613103754153135",
"created_by": "project:chromium",
"created_ts": "1613100757639961",
"id": "8855534975916505536",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8b29a603c82d1da66828b7d444473a0f7a5676ce\"}}",
"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\": \"8b29a603c82d1da66828b7d444473a0f7a5676ce\", \"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-central1-b-8-82-6f2a\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180510, \"got_angle_revision\": \"a8a2a71b3ab5e535def6239997f6f24da918556b\", \"got_dawn_revision\": \"d44159c23c104746dd12b35d251922d89d45f4e8\", \"got_nacl_revision\": \"82ac8c0a6f0d3ffc843c693dd5149a356b866ae5\", \"got_revision\": \"8b29a603c82d1da66828b7d444473a0f7a5676ce\", \"got_revision_cp\": \"refs/heads/master@{#853381}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"673a7fe5c3ff6686c98951cafb24a93ca5bd1303\", \"got_v8_revision\": \"358aa1391624d156e3a358fae69b15a0dcee52b9\", \"got_v8_revision_cp\": \"refs/heads/9.0.166@{#1}\", \"got_webrtc_revision\": \"f28d7e89b7a3c985d83f59d16b9f3c3f45ef7997\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33224}\", \"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\": \"8b29a603c82d1da66828b7d444473a0f7a5676ce\", \"swarm_hashes_refs/heads/master(at){#853381}_without_patch\": {\"absl_hardening_tests\": \"1e364ac0ffe15453ca14484c69b52b097d16ba2d\", \"accessibility_unittests\": \"8c37301d88c731324dabdca9b4f928743899cf5a\", \"angle_unittests\": \"3ba6edc766ffe7c79e6d5868129f02aa86a20c41\", \"app_shell_unittests\": \"1b80de89f045c2cebe24f9a603be77913443470c\", \"aura_unittests\": \"2eb7e426d6989da3a7f243d3115967482f393ba5\", \"base_unittests\": \"0564b5d876de22de6ae897f112a5fad38f03969e\", \"base_util_unittests\": \"3eb4ca60e2f83c4a961c2ac0e1bd096127d7c8c7\", \"blink_common_unittests\": \"efca6096151f5c71eb2d6a8dbecfecce60559fba\", \"blink_fuzzer_unittests\": \"e27a8f57d2638eea2398245a1367e8857c3ea834\", \"blink_heap_unittests\": \"4a3ba7b661d70f220d2cd77697049b908d3d0ebc\", \"blink_platform_unittests\": \"87687106125bf10434f6caf1ef78215c2228ac9d\", \"blink_python_tests\": \"1b056a88e02d31c3c5b2575e3a2b1bbd34adec06\", \"blink_unittests\": \"bc9c0b337207b3aa73182a0ad21b6f4fc3b32bb2\", \"blink_web_tests\": \"4a1d691260b6a3a174ec1dd0dde05ba901bbac8e\", \"boringssl_crypto_tests\": \"e715039fd9d5647c837ec6e38fb9b08ae04cfc44\", \"boringssl_ssl_tests\": \"ba33031198a54457872d2cfdd169fdda6118e9c9\", \"browser_tests\": \"13464125f07f9e2fb1373471d885b8fefd70ae31\", \"capture_unittests\": \"e379d261cf79cea0b0345fa1037c1970ad2746bc\", \"cast_unittests\": \"cde9a7f6807703fc6beae8d860a9fc9e64ce0f13\", \"cc_unittests\": \"0ced6bd1a179baa0d2d3757e35d1e27de697dac6\", \"chrome_app_unittests\": \"bbc76136cda77ab4d679e88bcc08a32a03eab835\", \"chromedriver_unittests\": \"80926adfcc5837d6b6f8725f6d3975d291427b55\", \"components_browsertests\": \"280a207d64e9a90277ccd5ba17c34a062b0914ba\", \"components_unittests\": \"03876670857ef67ba58685d3a18924d90b4775e4\", \"compositor_unittests\": \"cf67313a88f6ddb340da045bea1ef1404fc76a35\", \"content_browsertests\": \"a0ee274085c6a2b464b11cf224c1ae7837695b6b\", \"content_shell_crash_test\": \"89e85ee3a6c8bf045916eb2b4b8fd6289689b9f0\", \"content_unittests\": \"a61a9cc988346c785df7bfea5776a41278e29bc2\", \"crashpad_tests\": \"3fbae95edd956bdb33a38aa0ab8824d8c8694ba3\", \"cronet_tests\": \"a6e0e0de4fa682e14a494de459e548616bdec794\", \"cronet_unittests\": \"70736dbe4a56179d0753d12c611dc1c37a4c3225\", \"crypto_unittests\": \"10ff4de816d1904803e06ceff3665fb80d25b7d2\", \"dbus_unittests\": \"67885cc6ff435b7ecdf478f5622d15b7740dac27\", \"device_unittests\": \"c5f6de0c6df091589cfa1bd7756a76fe843c635d\", \"display_unittests\": \"337a61effa3174203e1d72e1ab406b73d6bc9c89\", \"events_unittests\": \"9d5db4f34184e3669ba655ad7d31e5d066654c06\", \"extensions_browsertests\": \"3e7a1c9125e24b01c545e92c80ba0a2ecae2ea8a\", \"extensions_unittests\": \"09706fbd021cb549496dd5afb306b81e88d858c0\", \"filesystem_service_unittests\": \"42612ec94485f4f7f2762ac940c8453a55318511\", \"flatbuffers_unittests\": \"a70d9e1d8a525a4da115cbe8994192708136ab4b\", \"gcm_unit_tests\": \"1c02727b31111eea5bd6b24d7cc37c0f7a70945f\", \"gfx_unittests\": \"8a15ace3b0e4cb30853b71925d86700420e7e477\", \"gin_unittests\": \"3020218975ccab8ea37991f4298656f275f1e876\", \"google_apis_unittests\": \"4f44bd125f3cf8e642aea89434a1640edddc2dbd\", \"gpu_unittests\": \"e2d349e2de730d40d7e693ef42f81846788ac6cd\", \"grit_python_unittests\": \"6eb7a1f1dc57239cce2e1f3e8d13a9b7cd73171c\", \"gwp_asan_unittests\": \"bdd1d58d8edad0b2dfb7508cb936b7bb6d8cb4dc\", \"headless_browsertests\": \"f78ab813420328c426386024998c1eddcba22459\", \"headless_unittests\": \"2886f10b1898ae7e24c34fca0d811b58aaa27df2\", \"interactive_ui_tests\": \"1cd440ceb982b3e9d04e4e41fae60fedccf910e8\", \"ipc_tests\": \"cd0457eb0221da26f7eaaa046bdf6468ea60f805\", \"jingle_unittests\": \"64e454aefe6e3b1a00059bde9c25a1b23e49790e\", \"latency_unittests\": \"d598c45d8af2060a525999af9729b34caf4f315b\", \"libjingle_xmpp_unittests\": \"797a61dcedd7a0de699f98435e70065a14d83cac\", \"liburlpattern_unittests\": \"86ad183a887e5e4a10d044038e52b1b2aac5657c\", \"media_blink_unittests\": \"00c429a21c2c37a1e52c4b01fcfab874591db6e4\", \"media_unittests\": \"91d0513166f74f135e296f4acfbbbc74b279bf8d\", \"message_center_unittests\": \"dacf0e8346b7a3d652dd7031007e3eac28ea992b\", \"metrics_python_tests\": \"8c8fc269ce74b42b146892a80768890749556bf2\", \"midi_unittests\": \"776a8565e8c2808573211e811ba30d5f13123ead\", \"mojo_core_unittests\": \"44b36adebe2ddcffc43c9c5d98568eaf9391558e\", \"mojo_unittests\": \"fe0413ab6e78ee769024e2848d7574de0e99653e\", \"nacl_helper_nonsfi_unittests\": \"05b841ec1a69cf3176d66c6c15a06841a51b3780\", \"nacl_loader_unittests\": \"89e4a83d6c43a7ef55b531d47a160e99a4d070b3\", \"native_theme_unittests\": \"e2829c6e4e03ae266cfeba48b38f8b6301c7112f\", \"net_unittests\": \"f05b188005436ea6ebb7077e9fc3ef64def1669a\", \"openscreen_unittests\": \"40190c7d3df73088547e33227e3f7fb66b1a3ae4\", \"pdf_unittests\": \"172e1045f4c4935cb0c871291b8277a51ca8cd45\", \"perfetto_unittests\": \"35467a6aca875def96c800df58782e059c244b8a\", \"ppapi_unittests\": \"ce6db9c2a42e68e542db78aa577b37b5d3ba0a24\", \"printing_unittests\": \"0a42883ec126f711f6250ba1f38bc7815aa1d213\", \"remoting_unittests\": \"9165cf2d7bb66e82f57edea152b85996959b9341\", \"sandbox_linux_unittests\": \"baaa8304e94dc833ce72ab4ca8b786ace2f1847f\", \"service_manager_unittests\": \"228bbe04e53eea1b6a61189b1829d813c635f8e0\", \"services_unittests\": \"41f2b5edca083224bab49407eb6301494cdf9653\", \"shell_dialogs_unittests\": \"94437fac961473a16a866300f1bb3cb0eb46734d\", \"skia_unittests\": \"0b0ba377daf9cf1441e814fbdf3027e7ebe22c9a\", \"snapshot_unittests\": \"82efddf76115696157c331db49fcc9183c737277\", \"sql_unittests\": \"236e16345147c61a6ed3226ba45900c060fddf6e\", \"storage_unittests\": \"8bb782563dca3e3ddbea9aa03dd9a0d0aa801fb1\", \"sync_integration_tests\": \"3e7cd11e4041f4661b11d730f6c4a46099d8a1ca\", \"telemetry_gpu_unittests\": \"690df861658de998048c75e5ff95f0d371a0d363\", \"telemetry_perf_unittests\": \"31971bebfb8e28ca911377b89d1c02f657dee19f\", \"telemetry_unittests\": \"d2008a1d2cda9684b84e595b8f3b3659a092f09d\", \"traffic_annotation_auditor_unittests\": \"c4557ed8d63da4bc9cca86ef06b6f72f47e31b97\", \"ui_base_unittests\": \"9311c67c26757a4e84b0b6d10b756c025935a237\", \"ui_touch_selection_unittests\": \"25abbec30eb8cc654e0749d6bf9f19b8569db9e9\", \"unit_tests\": \"f901bd3fb780eab1a1015291b0b4f59e6872f861\", \"url_unittests\": \"5ef5f7dc313eaf991bde385e2c9da7959f53e1d7\", \"views_perftests\": \"f87cf118bf281671b82ac74458c5da28051f10fa\", \"views_unittests\": \"fbc6a269fc92f5fcbf822832ec3417e41df1cc63\", \"viz_unittests\": \"b23ff2185d8164d49e6be44516c35b65f216ecbf\", \"vr_common_unittests\": \"e90e1621a6d30318074bf9480a29dc9a7265a4b9\", \"vr_pixeltests\": \"b5d1d0942cf9adf8c45c0fd5a7145183c2e438b0\", \"webdriver_wpt_tests\": \"56afe043c0e38224817139e236269941778ec530\", \"weblayer_browsertests\": \"4328ae832d688d4c2667c6e27cfad3220f908c6b\", \"weblayer_unittests\": \"d95564eaba3e698bee4ec8e5890bdfe698a38baa\", \"wm_unittests\": \"790368afd4569dd2a8b7b4b92dd8bc83c310be10\", \"wtf_unittests\": \"2be48152219ec31a2ce715b632b71fcc97dd1439\", \"x11_unittests\": \"d5d2b6516d1ed1baee89884c1907b262e577da95\", \"xr_browser_tests\": \"f920e63fee633ae486d756850c1fbca7d3560a3f\", \"zlib_unittests\": \"b8c0f77f7a9f5dd8520213a880bb76a3a4ccb06c\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_17616f83fd632132c65ea3dd60ce01b78f71f01fa76c3e3446f88a64858a3864_v2\", \"builder_2295bac873f7edd8c9763e89419d85b38a875955550d968c436d775d3f06377b_v2\", \"builder_9f247f4686c5cf47ea762220cc037b3e853f43c1442c10d387faa806e919f9a9_v2\", \"builder_ce300ca2149b7ede2a11dc5f29b170d3e5c2bdd2b201177604ba7c6bb221adeb_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"builder_ffe623326ac74578ce917ff55ef6cefa75094e5ad3ad5fe3409a729d79be647a_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-central1-b-8-82-6f2a\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"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\": [\"5690-40331dd\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1613100760228285",
"status": "COMPLETED",
"status_changed_ts": "1613103754413557",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180510",
"builder:Linux Builder (dbg)",
"buildset:commit/git/8b29a603c82d1da66828b7d444473a0f7a5676ce",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8b29a603c82d1da66828b7d444473a0f7a5676ce",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020965037884082720",
"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/8855534975916505536/+/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:51ad1dbe353f8210",
"user_agent:luci-scheduler"
],
"updated_ts": "1613103754418409",
"url": "https://ci.chromium.org/b/8855534975916505536",
"utcnow_ts": "1613103754775042"
}
}
[04:22:34.786] Invocation finished in 49m58.406553521s with status SUCCEEDED