[20:26:54.636] New invocation is queued and will start shortly
[20:26:56.175] Starting the invocation (attempt 1)
[20:26:56.243] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:26:56.243] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:26:56.243] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9054693891860314704",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"b1ab634df3bd87a04bbd8ca848452d951bec9bd4\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9054693891860314704",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/b1ab634df3bd87a04bbd8ca848452d951bec9bd4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b1ab634df3bd87a04bbd8ca848452d951bec9bd4",
"gitiles_ref:refs/heads/master"
]
}
[20:26:57.544] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1580934416393210",
"id": "8889263829354214768",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b1ab634df3bd87a04bbd8ca848452d951bec9bd4\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1580934417277451",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168271",
"builder:Linux Builder (dbg)",
"buildset:commit/git/b1ab634df3bd87a04bbd8ca848452d951bec9bd4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b1ab634df3bd87a04bbd8ca848452d951bec9bd4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054693891860314704",
"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/8889263829354214768/+/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": "1580934417277606",
"url": "https://ci.chromium.org/b/8889263829354214768",
"utcnow_ts": "1580934417496250"
}
}
[20:26:57.544] Task URL: https://ci.chromium.org/b/8889263829354214768
[20:26:57.544] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:2:0) after 1m0s
[20:27:57.583] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:2:0)
[20:27:57.583] Timer tick, asking Buildbucket for the build status
[20:27:58.136] Build 8889263829354214768: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:27:58.136] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:3:0) after 1m0s
[20:28:58.114] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:3:0)
[20:28:58.114] Timer tick, asking Buildbucket for the build status
[20:28:59.089] Build 8889263829354214768: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:28:59.089] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:4:0) after 1m0s
[20:29:59.107] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:4:0)
[20:29:59.107] Timer tick, asking Buildbucket for the build status
[20:29:59.228] Build 8889263829354214768: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:29:59.228] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:5:0) after 1m0s
[20:30:59.246] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:5:0)
[20:30:59.246] Timer tick, asking Buildbucket for the build status
[20:30:59.844] Build 8889263829354214768: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:30:59.844] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:6:0) after 1m0s
[20:31:39.808] Received PubSub notification, asking Buildbucket for the build status
[20:31:40.186] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:59.866] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:6:0)
[20:31:59.866] Timer tick, asking Buildbucket for the build status
[20:32:00.364] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:00.364] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:8:0) after 1m0s
[20:33:00.418] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:8:0)
[20:33:00.418] Timer tick, asking Buildbucket for the build status
[20:33:02.745] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:02.745] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:9:0) after 1m0s
[20:34:02.839] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:9:0)
[20:34:02.839] Timer tick, asking Buildbucket for the build status
[20:34:03.081] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:03.081] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:10:0) after 1m0s
[20:35:03.232] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:10:0)
[20:35:03.232] Timer tick, asking Buildbucket for the build status
[20:35:03.495] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:03.495] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:11:0) after 1m0s
[20:36:03.517] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:11:0)
[20:36:03.517] Timer tick, asking Buildbucket for the build status
[20:36:03.910] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:03.910] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:12:0) after 1m0s
[20:37:03.942] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:12:0)
[20:37:03.942] Timer tick, asking Buildbucket for the build status
[20:37:04.477] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:04.477] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:13:0) after 1m0s
[20:38:04.739] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:13:0)
[20:38:04.739] Timer tick, asking Buildbucket for the build status
[20:38:05.280] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:05.280] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:14:0) after 1m0s
[20:39:05.318] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:14:0)
[20:39:05.318] Timer tick, asking Buildbucket for the build status
[20:39:08.246] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:08.246] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:15:0) after 1m0s
[20:40:08.279] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:15:0)
[20:40:08.279] Timer tick, asking Buildbucket for the build status
[20:40:08.482] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:08.482] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:16:0) after 1m0s
[20:41:08.608] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:16:0)
[20:41:08.608] Timer tick, asking Buildbucket for the build status
[20:41:08.784] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:08.784] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:17:0) after 1m0s
[20:42:09.121] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:17:0)
[20:42:09.121] Timer tick, asking Buildbucket for the build status
[20:42:09.260] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:09.260] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:18:0) after 1m0s
[20:43:09.455] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:18:0)
[20:43:09.455] Timer tick, asking Buildbucket for the build status
[20:43:09.613] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:09.613] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:19:0) after 1m0s
[20:44:09.790] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:19:0)
[20:44:09.790] Timer tick, asking Buildbucket for the build status
[20:44:10.451] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:10.451] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:20:0) after 1m0s
[20:45:10.593] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:20:0)
[20:45:10.593] Timer tick, asking Buildbucket for the build status
[20:45:10.849] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:10.849] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:21:0) after 1m0s
[20:46:11.091] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:21:0)
[20:46:11.091] Timer tick, asking Buildbucket for the build status
[20:46:11.475] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:11.475] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:22:0) after 1m0s
[20:47:11.598] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:22:0)
[20:47:11.598] Timer tick, asking Buildbucket for the build status
[20:47:12.151] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:12.151] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:23:0) after 1m0s
[20:48:12.790] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:23:0)
[20:48:12.790] Timer tick, asking Buildbucket for the build status
[20:48:12.968] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:12.968] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:24:0) after 1m0s
[20:49:13.140] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:24:0)
[20:49:13.140] Timer tick, asking Buildbucket for the build status
[20:49:13.896] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:13.896] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:25:0) after 1m0s
[20:50:14.059] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:25:0)
[20:50:14.059] Timer tick, asking Buildbucket for the build status
[20:50:14.553] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:14.553] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:26:0) after 1m0s
[20:51:14.674] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:26:0)
[20:51:14.674] Timer tick, asking Buildbucket for the build status
[20:51:15.206] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:15.206] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:27:0) after 1m0s
[20:52:15.295] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:27:0)
[20:52:15.296] Timer tick, asking Buildbucket for the build status
[20:52:15.440] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:15.440] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:28:0) after 1m0s
[20:53:15.672] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:28:0)
[20:53:15.672] Timer tick, asking Buildbucket for the build status
[20:53:15.833] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:15.833] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:29:0) after 1m0s
[20:54:16.008] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:29:0)
[20:54:16.008] Timer tick, asking Buildbucket for the build status
[20:54:16.199] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:16.199] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:30:0) after 1m0s
[20:55:16.225] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:30:0)
[20:55:16.225] Timer tick, asking Buildbucket for the build status
[20:55:16.397] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:16.397] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:31:0) after 1m0s
[20:56:16.421] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:31:0)
[20:56:16.421] Timer tick, asking Buildbucket for the build status
[20:56:17.184] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:17.184] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:32:0) after 1m0s
[20:57:17.233] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:32:0)
[20:57:17.233] Timer tick, asking Buildbucket for the build status
[20:57:17.644] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:17.644] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:33:0) after 1m0s
[20:58:17.756] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:33:0)
[20:58:17.756] Timer tick, asking Buildbucket for the build status
[20:58:18.210] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:18.210] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:34:0) after 1m0s
[20:59:18.196] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:34:0)
[20:59:18.196] Timer tick, asking Buildbucket for the build status
[20:59:18.393] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:18.393] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:35:0) after 1m0s
[21:00:18.568] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:35:0)
[21:00:18.568] Timer tick, asking Buildbucket for the build status
[21:00:18.759] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:18.759] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:36:0) after 1m0s
[21:01:18.770] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:36:0)
[21:01:18.770] Timer tick, asking Buildbucket for the build status
[21:01:18.989] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:18.989] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:37:0) after 1m0s
[21:02:19.056] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:37:0)
[21:02:19.056] Timer tick, asking Buildbucket for the build status
[21:02:19.303] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:19.303] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:38:0) after 1m0s
[21:03:19.371] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:38:0)
[21:03:19.371] Timer tick, asking Buildbucket for the build status
[21:03:19.585] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:19.585] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:39:0) after 1m0s
[21:04:19.629] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:39:0)
[21:04:19.629] Timer tick, asking Buildbucket for the build status
[21:04:20.312] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:20.312] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:40:0) after 1m0s
[21:05:20.388] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:40:0)
[21:05:20.388] Timer tick, asking Buildbucket for the build status
[21:05:20.760] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:20.760] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:41:0) after 1m0s
[21:06:20.777] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:41:0)
[21:06:20.777] Timer tick, asking Buildbucket for the build status
[21:06:21.964] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:21.964] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:42:0) after 1m0s
[21:07:22.077] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:42:0)
[21:07:22.077] Timer tick, asking Buildbucket for the build status
[21:07:22.744] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:22.744] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:43:0) after 1m0s
[21:08:22.751] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:43:0)
[21:08:22.751] Timer tick, asking Buildbucket for the build status
[21:08:22.947] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:22.947] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:44:0) after 1m0s
[21:09:22.957] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:44:0)
[21:09:22.957] Timer tick, asking Buildbucket for the build status
[21:09:23.161] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:23.161] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:45:0) after 1m0s
[21:10:23.219] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:45:0)
[21:10:23.219] Timer tick, asking Buildbucket for the build status
[21:10:23.385] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:23.385] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:46:0) after 1m0s
[21:11:23.453] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:46:0)
[21:11:23.453] Timer tick, asking Buildbucket for the build status
[21:11:23.867] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:23.867] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:47:0) after 1m0s
[21:12:23.882] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:47:0)
[21:12:23.882] Timer tick, asking Buildbucket for the build status
[21:12:24.059] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:24.059] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:48:0) after 1m0s
[21:13:24.119] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:48:0)
[21:13:24.119] Timer tick, asking Buildbucket for the build status
[21:13:24.405] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:24.405] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:49:0) after 1m0s
[21:14:24.454] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:49:0)
[21:14:24.454] Timer tick, asking Buildbucket for the build status
[21:14:24.697] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:24.697] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:50:0) after 1m0s
[21:15:24.763] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:50:0)
[21:15:24.763] Timer tick, asking Buildbucket for the build status
[21:15:24.978] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:24.978] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:51:0) after 1m0s
[21:16:25.015] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:51:0)
[21:16:25.015] Timer tick, asking Buildbucket for the build status
[21:16:25.282] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:25.282] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:52:0) after 1m0s
[21:17:25.348] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:52:0)
[21:17:25.348] Timer tick, asking Buildbucket for the build status
[21:17:25.981] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:25.981] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:53:0) after 1m0s
[21:18:26.001] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:53:0)
[21:18:26.001] Timer tick, asking Buildbucket for the build status
[21:18:26.190] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:26.191] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:54:0) after 1m0s
[21:19:26.211] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:54:0)
[21:19:26.211] Timer tick, asking Buildbucket for the build status
[21:19:26.378] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:26.378] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:55:0) after 1m0s
[21:20:26.455] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:55:0)
[21:20:26.455] Timer tick, asking Buildbucket for the build status
[21:20:26.768] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:26.768] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:56:0) after 1m0s
[21:21:26.800] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:56:0)
[21:21:26.800] Timer tick, asking Buildbucket for the build status
[21:21:27.498] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:27.498] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:57:0) after 1m0s
[21:22:27.526] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:57:0)
[21:22:27.526] Timer tick, asking Buildbucket for the build status
[21:22:27.670] Build 8889263829354214768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:27.670] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054693891860314704:58:0) after 1m0s
[21:22:39.242] Received PubSub notification, asking Buildbucket for the build status
[21:22:39.370] Build 8889263829354214768: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:22:39.370] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1580937758596715",
"created_by": "project:chromium",
"created_ts": "1580934416393210",
"id": "8889263829354214768",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b1ab634df3bd87a04bbd8ca848452d951bec9bd4\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-8-074t\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 168271, \"got_angle_revision\": \"a44d96dcd676fc7d446b41fb766caad9bdab9fda\", \"got_dawn_revision\": \"47b15048a1fab6c360dc1594764506224655752b\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"b1ab634df3bd87a04bbd8ca848452d951bec9bd4\", \"got_revision_cp\": \"refs/heads/master@{#738659}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"8e8e1d0dd7292440b803b95bc0832589520f784d\", \"got_v8_revision\": \"4dc7c627a1ebc90c34cdb39c44015a83d924f4ee\", \"got_v8_revision_cp\": \"refs/heads/8.2.12@{#1}\", \"got_webrtc_revision\": \"02b17a5507ae6be7cb8775760627b79b7faba69c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30458}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b1ab634df3bd87a04bbd8ca848452d951bec9bd4\", \"swarm_hashes_refs/heads/master(at){#738659}_without_patch\": {\"accessibility_unittests\": \"cf866923963c6c47b1e954060b11bd071bcb0ef7\", \"angle_unittests\": \"e6a2e07d5c12067b71ac162aef35b88cfe7d948a\", \"app_shell_unittests\": \"f6de416620643955e755d94d1c259eb935658876\", \"aura_unittests\": \"ce931cea665147b0cd49d24b85eee0057f70ea58\", \"base_unittests\": \"712f4947b54ee41f09e223a272fdd62add6ded0d\", \"base_util_unittests\": \"1fb24bf247e4c9ff5abdd7750c9e5d4ba74014d0\", \"blink_common_unittests\": \"6c9d843da00785d7956ee4420c784256f3cfcad8\", \"blink_fuzzer_unittests\": \"44caa8ec27f0842fd81a7706a5e9e6de2e20e1cf\", \"blink_heap_unittests\": \"d36c9c46b1f9aecd5f9849003363b0b86c7e6ea6\", \"blink_platform_unittests\": \"58dff9effdd4957dae9817ff91ae2e13483d49b6\", \"blink_python_tests\": \"45f126c04cedc68e444171b6efbd9b742febd59f\", \"blink_unittests\": \"f0758fff2972f9ffdb66d8d06f778f91824933aa\", \"blink_web_tests\": \"045be4f6c9b06be5f8dc459b9b0135885616fb2a\", \"boringssl_crypto_tests\": \"59ffb3dea1f049cbd1273457caef906771add2ec\", \"boringssl_ssl_tests\": \"9d93285a4117d25760a190a2546ea756631a04f4\", \"browser_tests\": \"b78fb3c873e4ce639dab06a729649b44f4060153\", \"cacheinvalidation_unittests\": \"6380104f37c3571d0d5b29db58ed9a95e25d4918\", \"capture_unittests\": \"c1477c748e1093bd8704dacf1da0270a6386781b\", \"cast_unittests\": \"d800dba295af81c7d0cbdc5bca030a10b6313a93\", \"cc_unittests\": \"d523a8ffc83e54d328943cdffc044738a54623fd\", \"chrome_app_unittests\": \"66b24f6f68f1b6e3764e362d891650059aeb0dee\", \"chromedriver_unittests\": \"2446716cfed798bd17ed9fccf66f66f7efc92b1f\", \"components_browsertests\": \"090d853c22837cf10f2c150a3135e9404c0a1546\", \"components_unittests\": \"b3437f6bec61ab4491edbdbb640638e02a73a5e7\", \"compositor_unittests\": \"2a91b6800cf4c4113d6dd40002694c3289cccf90\", \"content_browsertests\": \"cdcf14925e74705d20223ffd000ac3740a10d61d\", \"content_shell_crash_test\": \"6fb5721f365f52d56a643d71fab139a40c88f59a\", \"content_unittests\": \"15e2d221834349936da44d34ce0f2e400b66f384\", \"crashpad_tests\": \"97dca390746ab8567b9524558b89a33e0117cc59\", \"cronet_tests\": \"dfe9a990add57d94baa28b12979bde39cb2823ab\", \"cronet_unittests\": \"5633af7c662e8fbb22d1dd0193a3605065071e72\", \"crypto_unittests\": \"11dde5e8a63f1a3f08858116887b4741e24d9071\", \"dbus_unittests\": \"9ca9077bb30479a16583f3ad19e7871f79bd83b8\", \"device_unittests\": \"7ea6d17b95c302f7f6b036d2eb2fbabadf0253ba\", \"display_unittests\": \"568729668e883fab8356ec20b055c724b7d61abf\", \"events_unittests\": \"7e0a1ed771ed283b7cefbcc3d84ecd27d0c2772c\", \"extensions_browsertests\": \"98fb0b40d6dc0d6fc08844699d5009c34a2b2258\", \"extensions_unittests\": \"d8d4f4ce3befc784eb38bcca023c270d2bd08878\", \"filesystem_service_unittests\": \"0b01fcc33be9dc424593c044c839c7f7662da738\", \"flatbuffers_unittests\": \"ca71348ce5934d53fb892115f8e6e8a2436d5e6c\", \"gcm_unit_tests\": \"c9267c440921d92b6bf3459b41e01fba9c084b9e\", \"gfx_unittests\": \"4625b34311ca572ba2d1f5fdd6b7fc31987cea49\", \"gin_unittests\": \"7eebd351168cd96c81b921053efa297f52b4591e\", \"google_apis_unittests\": \"3e91be035693df34b52c0ef1c15e60f5f9bbaf70\", \"gpu_unittests\": \"b35c72e91f2ae2ce90db99de2e3507e5d6736132\", \"grit_python_unittests\": \"a906de1211aa1e6d0b6deb8a9a162d6998fb6336\", \"gwp_asan_unittests\": \"8fc6d56be132770b2ee265dbeddb3b544a9642a0\", \"headless_browsertests\": \"14fda5176a3ea08bbf215b28caf7d119709776d4\", \"headless_unittests\": \"3208b619f1939c9fe9973ed669062810fe99c062\", \"interactive_ui_tests\": \"7599eeea95a78200f81c446a1d659da16cf69b12\", \"ipc_tests\": \"497f650881ffb75d7babe2dd74db50b13967f141\", \"jingle_unittests\": \"d796e49b839dd77889ef09ad452c526246ee7ea0\", \"latency_unittests\": \"58bac4d34a6a8ce684182c45cb3b72726952dd17\", \"libjingle_xmpp_unittests\": \"470247dfd68a33eb390adc0d42884d117d07d94b\", \"media_blink_unittests\": \"8278fdde12439da4b27e507067279d2f2785f9d7\", \"media_service_unittests\": \"6f783cbf1909a52315160e769b88ff635127544c\", \"media_unittests\": \"384de335ac526458bcdedbae2fbf13762d83fe7a\", \"message_center_unittests\": \"6c82003d2ae4d1bae073aa505e41e9a598337105\", \"metrics_python_tests\": \"a9fd9705b2a485da6cec066e35a4c239d1c79df5\", \"midi_unittests\": \"0300237b144968e57853e02fe1cda46eec29617f\", \"mojo_core_unittests\": \"df61682da07ad1c046f0577d98fec4c0f422bc18\", \"mojo_unittests\": \"44bed50117fc0cca00bff74ac8a528d67141580e\", \"nacl_helper_nonsfi_unittests\": \"53cd259b7b1e63cfce3b0db5e6fbd19310b9abc2\", \"nacl_loader_unittests\": \"3a2fa7e0ab818b23bb82876ed7f6975132006046\", \"native_theme_unittests\": \"372e9629053a288f1e58f513a7e94e7c65c01c7a\", \"net_unittests\": \"4cbc2855a84778a811d4f322bfa21cef001baec2\", \"pdf_unittests\": \"e1cf54a57a94c42229cb4a1f66ed85d85ff430fe\", \"perfetto_unittests\": \"977903dd56561d1d863119e8fe34709a9264e30b\", \"ppapi_unittests\": \"b0c4759f463fd08767a7278b9d350af67533da99\", \"printing_unittests\": \"42d01585d33cd3e7a05deed422a1e7c042ae5fb2\", \"remoting_unittests\": \"4e7cd1fe5fef92c471afc2f7c20bad3e213a27f6\", \"sandbox_linux_unittests\": \"8fd52c5d27e8e0be6081b7efa31224dae8cb44f6\", \"service_manager_unittests\": \"245bc588d9f88087f133ff86d210a7cf5d3cc8a6\", \"services_unittests\": \"769a9d4aea5d35d9b323fa4d6fdca1ebbac9add9\", \"shell_dialogs_unittests\": \"4c6666246365476cc88041b23911eb5c90b11142\", \"skia_unittests\": \"3f156842563d95b586596e2c6febd02c6ce568f2\", \"snapshot_unittests\": \"714ec07a93632aee0df656fd62f1175e494f0a33\", \"sql_unittests\": \"e0b85af04651f692556bb86f3d7c34732b893b77\", \"storage_unittests\": \"7b13aaf143c96617e11567a6f449f4370f962857\", \"sync_integration_tests\": \"4217389a73ab66fffe1b4eda05e07c5cb8c31db1\", \"telemetry_gpu_unittests\": \"891e1329c7e5ee45d6acbf725e1fb08161e1ce44\", \"telemetry_perf_unittests\": \"15a88827804f86acd136932c5d45aa41fc5d2e21\", \"telemetry_unittests\": \"f19d43f7b540c05945f3eb65cb1819dd55f1e6b5\", \"traffic_annotation_auditor_unittests\": \"33fa11c76213c0b6c629d9a21a4555bae13eeca9\", \"ui_base_unittests\": \"166b3e6de43cecb861cdf3fa4ef2d308538b3baa\", \"ui_touch_selection_unittests\": \"565878944cc022d79edec03edb807d7adb44ecb4\", \"unit_tests\": \"55a9cee30f49ec2cecdb64cde1a3db5e7eeb066b\", \"url_unittests\": \"34652ba7cca8da879ad7ab10b09f204ed0a12188\", \"views_perftests\": \"dc4596db6b684161e9f38d40d378021dd14782fa\", \"views_unittests\": \"3a1c03df057b7209f3fcaddd408a46c906920e27\", \"viz_unittests\": \"df6e4ae73a3d0d57184489428d7f4b1cc227459d\", \"vr_common_unittests\": \"0dd58d2551d9ae49a8edccf60abc3aa0bb172c3a\", \"vr_pixeltests\": \"9a1d7c34f2894008527ce7417410bde943ac7d22\", \"webdriver_wpt_tests\": \"1055e77cdc5b4484ff4b2a56cb658f7ffbb13132\", \"weblayer_browsertests\": \"285aa6aa1b98344a2b110d982626f36d83419247\", \"wm_unittests\": \"9ff9e3e64b85e669137486a3e22a1ea364c2f6d4\", \"wtf_unittests\": \"d17ce118e225ff0acc5f9028a6c3528ef9cb6f47\", \"xr_browser_tests\": \"75945735feaebeb9d4d3876b807b36fe75f3d5f7\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_361cbaa79261c75a92fc63a8f8c6fc117764238b3277286fa51086e6da3301df_v2\", \"builder_94dc7d486ab1bafc5bfb11010ef18f0cf20e8e07ae86b58c09f57ba294c280ac_v2\", \"builder_980e79f61a9eb10b3ecd5f710f08f0308a5299da9889db3d2b6a7010c019cc1f_v2\", \"builder_a1b9c6892397d61c3624774723419f5ae48fcf776e7d2304bd4682bf5cd4c049_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-8-074t\"], \"image\": [\"chrome-xenial-20012600-8e1a7e485b7\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4809-bb2013c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1580934698987960",
"status": "COMPLETED",
"status_changed_ts": "1580937758925805",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168271",
"builder:Linux Builder (dbg)",
"buildset:commit/git/b1ab634df3bd87a04bbd8ca848452d951bec9bd4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b1ab634df3bd87a04bbd8ca848452d951bec9bd4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054693891860314704",
"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/8889263829354214768/+/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:4a2fda555a9edc10",
"user_agent:luci-scheduler"
],
"updated_ts": "1580937758932515",
"url": "https://ci.chromium.org/b/8889263829354214768",
"utcnow_ts": "1580937759359111"
}
}
[21:22:39.370] Invocation finished in 55m44.750628949s with status SUCCEEDED