[14:01:43.522] New invocation is queued and will start shortly
[14:01:44.629] Starting the invocation (attempt 1)
[14:01:44.656] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:01:44.656] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:01:44.656] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018116951192674144",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"c5b3bf49e89aee1b51b73af5a9c756a4b10562b9\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9018116951192674144",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/c5b3bf49e89aee1b51b73af5a9c756a4b10562b9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c5b3bf49e89aee1b51b73af5a9c756a4b10562b9",
"gitiles_ref:refs/heads/master"
]
}
[14:01:45.418] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615816904807388",
"id": "8852686889182962288",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c5b3bf49e89aee1b51b73af5a9c756a4b10562b9\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615816905304263",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/181388",
"builder:Linux Builder (dbg)",
"buildset:commit/git/c5b3bf49e89aee1b51b73af5a9c756a4b10562b9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c5b3bf49e89aee1b51b73af5a9c756a4b10562b9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018116951192674144",
"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/8852686889182962288/+/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": "1615816905304559",
"url": "https://ci.chromium.org/b/8852686889182962288",
"utcnow_ts": "1615816905412249"
}
}
[14:01:45.418] Task URL: https://ci.chromium.org/b/8852686889182962288
[14:01:45.418] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:2:0) after 1m0s
[14:01:47.517] Received PubSub notification, asking Buildbucket for the build status
[14:01:47.609] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:45.385] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:2:0)
[14:02:45.385] Timer tick, asking Buildbucket for the build status
[14:02:45.471] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:45.471] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:4:0) after 1m0s
[14:03:45.593] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:4:0)
[14:03:45.593] Timer tick, asking Buildbucket for the build status
[14:03:45.678] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:45.678] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:5:0) after 1m0s
[14:04:45.760] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:5:0)
[14:04:45.760] Timer tick, asking Buildbucket for the build status
[14:04:48.152] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:48.152] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:6:0) after 1m0s
[14:05:48.175] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:6:0)
[14:05:48.175] Timer tick, asking Buildbucket for the build status
[14:05:48.259] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:48.259] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:7:0) after 1m0s
[14:06:48.273] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:7:0)
[14:06:48.273] Timer tick, asking Buildbucket for the build status
[14:06:48.510] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:48.510] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:8:0) after 1m0s
[14:07:48.521] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:8:0)
[14:07:48.521] Timer tick, asking Buildbucket for the build status
[14:07:48.696] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:48.696] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:9:0) after 1m0s
[14:08:48.721] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:9:0)
[14:08:48.721] Timer tick, asking Buildbucket for the build status
[14:08:48.916] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:48.916] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:10:0) after 1m0s
[14:09:48.940] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:10:0)
[14:09:48.941] Timer tick, asking Buildbucket for the build status
[14:09:49.015] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:49.015] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:11:0) after 1m0s
[14:10:49.017] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:11:0)
[14:10:49.017] Timer tick, asking Buildbucket for the build status
[14:10:49.165] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:49.165] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:12:0) after 1m0s
[14:11:49.180] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:12:0)
[14:11:49.180] Timer tick, asking Buildbucket for the build status
[14:11:49.343] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:49.343] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:13:0) after 1m0s
[14:12:49.425] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:13:0)
[14:12:49.425] Timer tick, asking Buildbucket for the build status
[14:12:49.500] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:49.500] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:14:0) after 1m0s
[14:13:49.590] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:14:0)
[14:13:49.590] Timer tick, asking Buildbucket for the build status
[14:13:49.759] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:49.759] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:15:0) after 1m0s
[14:14:49.836] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:15:0)
[14:14:49.836] Timer tick, asking Buildbucket for the build status
[14:14:49.912] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:49.912] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:16:0) after 1m0s
[14:15:49.906] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:16:0)
[14:15:49.906] Timer tick, asking Buildbucket for the build status
[14:15:49.987] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:49.987] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:17:0) after 1m0s
[14:16:50.162] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:17:0)
[14:16:50.162] Timer tick, asking Buildbucket for the build status
[14:16:50.311] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:50.311] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:18:0) after 1m0s
[14:17:50.706] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:18:0)
[14:17:50.706] Timer tick, asking Buildbucket for the build status
[14:17:50.832] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:50.832] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:19:0) after 1m0s
[14:18:51.012] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:19:0)
[14:18:51.012] Timer tick, asking Buildbucket for the build status
[14:18:51.107] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:51.107] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:20:0) after 1m0s
[14:19:51.215] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:20:0)
[14:19:51.215] Timer tick, asking Buildbucket for the build status
[14:19:51.300] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:51.300] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:21:0) after 1m0s
[14:20:51.519] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:21:0)
[14:20:51.519] Timer tick, asking Buildbucket for the build status
[14:20:51.580] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:51.580] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:22:0) after 1m0s
[14:21:51.737] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:22:0)
[14:21:51.737] Timer tick, asking Buildbucket for the build status
[14:21:51.820] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:51.820] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:23:0) after 1m0s
[14:22:51.935] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:23:0)
[14:22:51.935] Timer tick, asking Buildbucket for the build status
[14:22:51.996] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:51.996] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:24:0) after 1m0s
[14:23:52.577] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:24:0)
[14:23:52.577] Timer tick, asking Buildbucket for the build status
[14:23:52.653] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:52.653] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:25:0) after 1m0s
[14:24:53.092] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:25:0)
[14:24:53.092] Timer tick, asking Buildbucket for the build status
[14:24:53.193] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:53.193] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:26:0) after 1m0s
[14:25:53.660] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:26:0)
[14:25:53.660] Timer tick, asking Buildbucket for the build status
[14:25:53.906] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:53.906] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:27:0) after 1m0s
[14:26:53.942] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:27:0)
[14:26:53.942] Timer tick, asking Buildbucket for the build status
[14:26:54.063] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:54.063] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:28:0) after 1m0s
[14:27:54.165] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:28:0)
[14:27:54.165] Timer tick, asking Buildbucket for the build status
[14:27:54.328] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:54.328] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:29:0) after 1m0s
[14:28:54.428] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:29:0)
[14:28:54.428] Timer tick, asking Buildbucket for the build status
[14:28:54.514] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:54.514] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:30:0) after 1m0s
[14:29:54.604] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:30:0)
[14:29:54.604] Timer tick, asking Buildbucket for the build status
[14:29:54.689] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:54.689] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:31:0) after 1m0s
[14:30:54.735] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:31:0)
[14:30:54.735] Timer tick, asking Buildbucket for the build status
[14:30:54.958] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:54.958] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:32:0) after 1m0s
[14:31:55.041] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:32:0)
[14:31:55.041] Timer tick, asking Buildbucket for the build status
[14:31:55.153] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:55.153] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:33:0) after 1m0s
[14:32:55.200] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:33:0)
[14:32:55.200] Timer tick, asking Buildbucket for the build status
[14:32:55.263] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:55.263] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:34:0) after 1m0s
[14:33:55.444] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:34:0)
[14:33:55.444] Timer tick, asking Buildbucket for the build status
[14:33:55.545] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:55.545] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:35:0) after 1m0s
[14:34:55.684] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:35:0)
[14:34:55.684] Timer tick, asking Buildbucket for the build status
[14:34:55.761] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:55.761] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:36:0) after 1m0s
[14:35:55.763] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:36:0)
[14:35:55.763] Timer tick, asking Buildbucket for the build status
[14:35:55.886] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:55.886] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:37:0) after 1m0s
[14:36:56.013] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:37:0)
[14:36:56.013] Timer tick, asking Buildbucket for the build status
[14:36:56.353] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:56.353] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:38:0) after 1m0s
[14:37:56.591] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:38:0)
[14:37:56.591] Timer tick, asking Buildbucket for the build status
[14:37:56.815] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:56.815] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:39:0) after 1m0s
[14:38:56.839] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:39:0)
[14:38:56.839] Timer tick, asking Buildbucket for the build status
[14:38:56.954] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:56.954] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:40:0) after 1m0s
[14:39:56.989] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:40:0)
[14:39:56.989] Timer tick, asking Buildbucket for the build status
[14:39:57.073] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:57.073] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:41:0) after 1m0s
[14:40:57.077] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:41:0)
[14:40:57.077] Timer tick, asking Buildbucket for the build status
[14:40:57.175] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:57.175] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:42:0) after 1m0s
[14:41:57.234] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:42:0)
[14:41:57.234] Timer tick, asking Buildbucket for the build status
[14:41:58.967] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:58.967] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:43:0) after 1m0s
[14:42:58.984] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:43:0)
[14:42:58.984] Timer tick, asking Buildbucket for the build status
[14:42:59.086] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:59.086] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:44:0) after 1m0s
[14:43:59.200] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:44:0)
[14:43:59.201] Timer tick, asking Buildbucket for the build status
[14:43:59.270] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:59.271] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:45:0) after 1m0s
[14:44:59.355] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:45:0)
[14:44:59.355] Timer tick, asking Buildbucket for the build status
[14:44:59.453] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:59.453] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:46:0) after 1m0s
[14:45:59.616] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:46:0)
[14:45:59.616] Timer tick, asking Buildbucket for the build status
[14:45:59.684] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:59.684] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:47:0) after 1m0s
[14:46:59.781] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:47:0)
[14:46:59.781] Timer tick, asking Buildbucket for the build status
[14:46:59.861] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:59.861] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:48:0) after 1m0s
[14:47:59.915] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:48:0)
[14:47:59.915] Timer tick, asking Buildbucket for the build status
[14:48:00.088] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:00.088] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:49:0) after 1m0s
[14:49:00.225] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:49:0)
[14:49:00.225] Timer tick, asking Buildbucket for the build status
[14:49:00.291] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:00.291] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:50:0) after 1m0s
[14:50:00.324] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:50:0)
[14:50:00.324] Timer tick, asking Buildbucket for the build status
[14:50:00.401] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:00.401] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:51:0) after 1m0s
[14:51:00.490] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:51:0)
[14:51:00.490] Timer tick, asking Buildbucket for the build status
[14:51:00.586] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:00.586] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:52:0) after 1m0s
[14:52:00.889] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:52:0)
[14:52:00.889] Timer tick, asking Buildbucket for the build status
[14:52:01.016] Build 8852686889182962288: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:01.016] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018116951192674144:53:0) after 1m0s
[14:52:21.154] Received PubSub notification, asking Buildbucket for the build status
[14:52:21.236] Build 8852686889182962288: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:52:21.236] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615819940617444",
"created_by": "project:chromium",
"created_ts": "1615816904807388",
"id": "8852686889182962288",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c5b3bf49e89aee1b51b73af5a9c756a4b10562b9\"}}",
"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\": \"c5b3bf49e89aee1b51b73af5a9c756a4b10562b9\", \"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-32-a32o\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 181388, \"got_angle_revision\": \"45ce8d1e89ea780ed7f87a10e65a6d12c0ca5d33\", \"got_dawn_revision\": \"d41aa4378d25e551e6e2f3ae0406757e994ff24b\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"c5b3bf49e89aee1b51b73af5a9c756a4b10562b9\", \"got_revision_cp\": \"refs/heads/master@{#862797}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"5cdf55ff2084d8aa719fe74fbe1622b61ff64294\", \"got_v8_revision\": \"9becce304a5e9b05bff62eef6c5e53b944120eb2\", \"got_v8_revision_cp\": \"refs/heads/9.1.125@{#1}\", \"got_webrtc_revision\": \"86473404362e38131203537b8a8c8ec7c1abc31a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33444}\", \"is_cached\": true, \"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\": \"c5b3bf49e89aee1b51b73af5a9c756a4b10562b9\", \"swarm_hashes_refs/heads/master(at){#862797}_without_patch\": {\"absl_hardening_tests\": \"6638d013c1796a02cfabdd5884eb24dc13deefc6\", \"accessibility_unittests\": \"6b48e9bb21b71b4471b1b9d0158c6fd8381c224f\", \"angle_unittests\": \"395f356be6c18c32251b5fcb6878195e0a13eef3\", \"app_shell_unittests\": \"93082d18cc40eb4a176587489794ed330a503bb8\", \"aura_unittests\": \"1acd6cc45dd313150735d77bcb013f691842498b\", \"base_unittests\": \"5626ce40829bcb91f301a860984c7cd917ddbf57\", \"base_util_unittests\": \"8168eb47e74918be0ab910dae7b58d9de9f5407e\", \"blink_common_unittests\": \"a713b71d9b741f2f41bf93f126520b45cf77583d\", \"blink_fuzzer_unittests\": \"9f084264e01c718d071a264576032dc75e84aed2\", \"blink_heap_unittests\": \"0f2ec3787b86d28af1831fde222295e80872718a\", \"blink_platform_unittests\": \"a95f36f1851166fd5589b205f41697e777525260\", \"blink_python_tests\": \"81990f15f0c5c18df478a50522cabf7ad282e423\", \"blink_unittests\": \"bf52a1ccba457a16f4e1e597bcffd0c8ead27d42\", \"blink_web_tests\": \"1409aafc1efc2272aae28dd26e8790243611db52\", \"boringssl_crypto_tests\": \"68d833097272fd426c19822a6ed50925a764f3d0\", \"boringssl_ssl_tests\": \"7a2f2c836d2d56a8f8ca40acd419d11f031eaf4f\", \"browser_tests\": \"0e0607f70455e51cf3cac2ed2d5fe1bdfa7d6a98\", \"capture_unittests\": \"2e3a1c20f9719e661d52fcca28b73c3a2884725b\", \"cast_unittests\": \"6939355dd596c08335e9ff4ae2ec120eb6a929e7\", \"cc_unittests\": \"be8cdfb724be38225391d374e318ffc8121a8996\", \"chrome_app_unittests\": \"a0e66343358b111d688149bb9b6b2c2466257b3a\", \"chromedriver_unittests\": \"e562e81a375f91d0f4452ffb58b1055d9d763a66\", \"color_unittests\": \"58fa53f09f7a56e8aa37ee59b5168d2758f4543c\", \"components_browsertests\": \"d2a3f5f720d3d09c9f1ae0072d391754b8b8cc15\", \"components_unittests\": \"decde181fcff69a5c0532e13f61843196cc29727\", \"compositor_unittests\": \"666a00b769db86e82646eabf21d16a44d3d4bbda\", \"content_browsertests\": \"61a697d0023c1570e2ad778f0cd0792a54d6bb4b\", \"content_shell_crash_test\": \"46e8ebecad6574a375de17f6b0b9b3a547906d1c\", \"content_unittests\": \"37174e285e39fc85fb654c7414bc242a08612b14\", \"crashpad_tests\": \"ad95657b64a440487d46ccad955f3e57e913aee9\", \"cronet_tests\": \"d41a96afa9c32ebb234d0ef7568be3cc0edc1b0f\", \"cronet_unittests\": \"f46380b6f342e13f7ec21cd11ea53f2c1fe80a0e\", \"crypto_unittests\": \"152a22c522d1eec46d799171d397606a1a005527\", \"dbus_unittests\": \"a2a78b4383617e947c7901a7165cb6e32e707548\", \"device_unittests\": \"bc00e0ddfea61d64799a9f30e6798c07eed39361\", \"display_unittests\": \"95bd137337dc7ce4ee2ffa3f578ea66c2eb7300c\", \"events_unittests\": \"187c89135ae6cb019518248c0e68ce7a81f8cd1e\", \"extensions_browsertests\": \"90768cd9f3dc3a0b9b8c49c18f4bd068efe197d7\", \"extensions_unittests\": \"052d989def947d24d91aa01409cb3ecbb553f31f\", \"filesystem_service_unittests\": \"37157a21767192a8ff3a11f9376ca7ee7159cb12\", \"flatbuffers_unittests\": \"917c1926f9a03d6ef30fc9665ef3a1d956152ddf\", \"gcm_unit_tests\": \"bf12183b42d3ceb4dbcf91b0db24eddacc12a0d9\", \"gfx_unittests\": \"9fcf830774f1972bbff893a1fe022600fa4c51b9\", \"gin_unittests\": \"774e2828d491c4b3a1ce0c98dcf7bd57ab9e9721\", \"google_apis_unittests\": \"f556afe705371f50aa3df8048b3b7202511d564a\", \"gpu_unittests\": \"ac5ff6aba4d4d4b62f825e87b8d55c029d8db1ea\", \"grit_python_unittests\": \"34dc6f3cc2d88a5fac848f4742c34f024387cdb5\", \"gwp_asan_unittests\": \"e04985207e29d01258cbe5b28209e954dd032ea8\", \"headless_browsertests\": \"22eaa41a149bbfeb9b62cac494d78a8d12c1ec14\", \"headless_unittests\": \"f30624fca1f72cef2df5da0288aff1ab268ee50d\", \"interactive_ui_tests\": \"1d4340dcdee6e4b9df2d4f7c700b11335a78840b\", \"ipc_tests\": \"6c2b9adb04918ca633f96a05ec67685a36c0e7c4\", \"jingle_unittests\": \"8867fb6b9a45374173ef70799ea344519f0b51fa\", \"latency_unittests\": \"fc6d727a92bdce5bb0c2b81b02bda80b3fa1c52e\", \"libjingle_xmpp_unittests\": \"cee804b4072e8a8fec2799d2a5df33132907cdec\", \"liburlpattern_unittests\": \"e10d536dda83f17a30aa043e8df24747371292c3\", \"media_blink_unittests\": \"5b55d325c821c38e7eadc825ce7ddec7ee923687\", \"media_unittests\": \"04d6f2ecff921c7cf0405d959d72c92ac0476cf7\", \"message_center_unittests\": \"1506cf6964ce48feaab1cb0704e4e356819dc3bd\", \"metrics_python_tests\": \"6ca446b358540dea7bed415bf719564e8d998a9f\", \"midi_unittests\": \"23dc50a410d248cf6a670cbd98d9768301576b1f\", \"mojo_core_unittests\": \"c756e244802ee2d86605e922b23d21c15fec35be\", \"mojo_unittests\": \"b099176791370fb4592d7ca04270079a93667f1b\", \"nacl_helper_nonsfi_unittests\": \"60c45615a2363dad8de66c6dc3a5c1750e20649d\", \"nacl_loader_unittests\": \"922f78da179b4d789b5975e52fc41b1abfa15ff2\", \"native_theme_unittests\": \"25e07c732f18bbf3c9e3feec6e668bb598d80643\", \"net_unittests\": \"9df0519008ee286f9362229c7844f0900db7dcc7\", \"openscreen_unittests\": \"fbf1fcf68ee0ff839f6bd61b1a68ad790c040806\", \"pdf_unittests\": \"41862f62a4abb5066a7f50477f0b792e368d29ec\", \"perfetto_unittests\": \"0f08abb816452a12a40084d81f560243132e24af\", \"ppapi_unittests\": \"32208a6317bde0ae1956e760652b4e9538995cb4\", \"printing_unittests\": \"a646cb6dff9908d1956bef58ee3975f731861db5\", \"remoting_unittests\": \"561f001233f1e0926f85d15ca9018e0337a1e348\", \"sandbox_linux_unittests\": \"e05233b6a56b1c8ff62c60d01fbbadb22b5ce6c4\", \"service_manager_unittests\": \"796d5b22861d5418f37822f8a02f8a8711fea37d\", \"services_unittests\": \"c15668e3f82bb40aa76ddc483d9cb4bc32a4ca51\", \"shell_dialogs_unittests\": \"349ecaf3c28ad50f95c10c522bc6cb080eeb9ff0\", \"skia_unittests\": \"a1f455843ea50350ad50654619f57c10897916cd\", \"snapshot_unittests\": \"1a172b6b7afcff9b6e97f90e117c05659da55689\", \"sql_unittests\": \"a2e5fa216db8d3dcf2db3acabb0b6dd99cee8065\", \"storage_unittests\": \"361dcc13b8bc0a47924adb07f428a8d678e7cfac\", \"sync_integration_tests\": \"73bc08d9fe1b891310c80dedd786af43adfa6baf\", \"telemetry_gpu_unittests\": \"a8b7c72f0e81c1d857f017f700f8ccf10a6aefde\", \"telemetry_perf_unittests\": \"9192cc9c6faa0be650bdc66801bc9cece07b588c\", \"telemetry_unittests\": \"d983c6da3fd26a43f0f66d22f5a9fecb972b2b86\", \"traffic_annotation_auditor_unittests\": \"c76822a8030ff1e87b8004e234c7136ee00a8bdb\", \"ui_base_unittests\": \"16ffa92c9f1ba64b4057696f5e9bf693087b0a2e\", \"ui_touch_selection_unittests\": \"edf5c8980bc6b6c451ca92861573cfca9da86c15\", \"unit_tests\": \"db987305300cb575f614d5414d71445e9592c017\", \"url_unittests\": \"fd3b80def5a5e5fdae212ed6112f12c15d80c5c0\", \"views_perftests\": \"27c31cbc6bef6bb444ca9f56c29034679552cdd0\", \"views_unittests\": \"78aacc2ec384007f0ee8df6fdf6823b86fa1ac04\", \"viz_unittests\": \"84aed3f62e6bd19c40f45d5d6f846792ff45cd98\", \"vr_common_unittests\": \"4e8b23e831ff7a4886ce8ba2db889764705e6e3c\", \"vr_pixeltests\": \"511532822ed3c5c44e1585ea9a694573b04d36e4\", \"webdriver_wpt_tests\": \"953b9776313c267acbba163517ff0180a98c69b9\", \"weblayer_browsertests\": \"d6905f72319344869275541585a3ddec9c1478d6\", \"weblayer_unittests\": \"cb674c0e1d1205503491dfdbf54ff57c41be3272\", \"wm_unittests\": \"f82d06e3770700dcd4f5e58d0a194a8ca88ebebe\", \"wtf_unittests\": \"23fe90597800ebde522ecd77ca7567261abb0fd3\", \"x11_unittests\": \"bb9a21ec0ac0f0208c49694a4ce9cf3008ffa3aa\", \"xr_browser_tests\": \"7614a8853e5b77836843d091e1033776f3c02b35\", \"zlib_unittests\": \"712e922bffd34a717a3a5106889e8ab143cc0a44\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_28be8b4e850be8bd7a9db0671ff876681ccdf0c2c048860e172c20e0c8b9b79b_v2\", \"builder_93a7e775fd8f3ff9ef99e2aeb686615c0006e7587b0f2c5be32706e8df4f86a4_v2\", \"builder_a10052c67097968898fa29710cdaa0ada58a120001760a536a006ca29eefe964_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"builder_f2d41554cc5e5ccdd409a1e3331deca1f73b654eb50c3540ea4abf5478e808d4_v2\", \"builder_fa0031875b7f2f11c46443055ab400bfaeb07a1d2a142b58c631314016c04e0a_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-32-a32o\"], \"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\": [\"5754-8c4f760\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615816906918802",
"status": "COMPLETED",
"status_changed_ts": "1615819940992275",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/181388",
"builder:Linux Builder (dbg)",
"buildset:commit/git/c5b3bf49e89aee1b51b73af5a9c756a4b10562b9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c5b3bf49e89aee1b51b73af5a9c756a4b10562b9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018116951192674144",
"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/8852686889182962288/+/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:524f02db633ba710",
"user_agent:luci-scheduler"
],
"updated_ts": "1615819940996741",
"url": "https://ci.chromium.org/b/8852686889182962288",
"utcnow_ts": "1615819941228586"
}
}
[14:52:21.236] Invocation finished in 50m37.728832135s with status SUCCEEDED