[06:54:02.921] New invocation is queued and will start shortly
[06:54:04.164] Starting the invocation (attempt 1)
[06:54:04.206] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:54:04.206] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:54:04.206] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019049827946963088",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"f89fc2ac30e582dfe9e334baf19ef8e535eea30d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9019049827946963088",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/f89fc2ac30e582dfe9e334baf19ef8e535eea30d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f89fc2ac30e582dfe9e334baf19ef8e535eea30d",
"gitiles_ref:refs/heads/master"
]
}
[06:54:04.906] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614927244272122",
"id": "8853619765868348592",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f89fc2ac30e582dfe9e334baf19ef8e535eea30d\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614927244735416",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/181135",
"builder:Linux Builder (dbg)",
"buildset:commit/git/f89fc2ac30e582dfe9e334baf19ef8e535eea30d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f89fc2ac30e582dfe9e334baf19ef8e535eea30d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019049827946963088",
"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/8853619765868348592/+/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": "1614927244735525",
"url": "https://ci.chromium.org/b/8853619765868348592",
"utcnow_ts": "1614927244898583"
}
}
[06:54:04.906] Task URL: https://ci.chromium.org/b/8853619765868348592
[06:54:04.906] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:2:0) after 1m0s
[06:54:07.085] Received PubSub notification, asking Buildbucket for the build status
[06:54:07.220] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:05.012] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:2:0)
[06:55:05.012] Timer tick, asking Buildbucket for the build status
[06:55:05.265] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:05.265] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:4:0) after 1m0s
[06:56:05.559] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:4:0)
[06:56:05.559] Timer tick, asking Buildbucket for the build status
[06:56:05.631] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:05.631] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:5:0) after 1m0s
[06:57:05.744] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:5:0)
[06:57:05.744] Timer tick, asking Buildbucket for the build status
[06:57:05.842] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:05.842] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:6:0) after 1m0s
[06:58:06.115] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:6:0)
[06:58:06.115] Timer tick, asking Buildbucket for the build status
[06:58:06.364] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:06.364] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:7:0) after 1m0s
[06:59:06.460] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:7:0)
[06:59:06.460] Timer tick, asking Buildbucket for the build status
[06:59:06.559] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:06.559] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:8:0) after 1m0s
[07:00:06.726] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:8:0)
[07:00:06.726] Timer tick, asking Buildbucket for the build status
[07:00:07.059] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:07.059] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:9:0) after 1m0s
[07:01:07.095] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:9:0)
[07:01:07.095] Timer tick, asking Buildbucket for the build status
[07:01:07.189] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:07.189] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:10:0) after 1m0s
[07:02:07.269] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:10:0)
[07:02:07.269] Timer tick, asking Buildbucket for the build status
[07:02:07.376] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:07.376] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:11:0) after 1m0s
[07:03:07.666] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:11:0)
[07:03:07.666] Timer tick, asking Buildbucket for the build status
[07:03:07.744] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:07.744] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:12:0) after 1m0s
[07:04:07.953] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:12:0)
[07:04:07.953] Timer tick, asking Buildbucket for the build status
[07:04:09.003] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:09.003] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:13:0) after 1m0s
[07:05:09.043] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:13:0)
[07:05:09.043] Timer tick, asking Buildbucket for the build status
[07:05:09.157] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:09.157] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:14:0) after 1m0s
[07:06:09.250] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:14:0)
[07:06:09.250] Timer tick, asking Buildbucket for the build status
[07:06:09.363] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:09.363] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:15:0) after 1m0s
[07:07:09.388] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:15:0)
[07:07:09.388] Timer tick, asking Buildbucket for the build status
[07:07:09.621] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:09.621] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:16:0) after 1m0s
[07:08:09.638] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:16:0)
[07:08:09.638] Timer tick, asking Buildbucket for the build status
[07:08:09.711] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:09.711] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:17:0) after 1m0s
[07:09:09.740] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:17:0)
[07:09:09.740] Timer tick, asking Buildbucket for the build status
[07:09:10.362] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:10.362] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:18:0) after 1m0s
[07:10:10.403] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:18:0)
[07:10:10.403] Timer tick, asking Buildbucket for the build status
[07:10:10.486] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:10.486] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:19:0) after 1m0s
[07:11:10.519] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:19:0)
[07:11:10.519] Timer tick, asking Buildbucket for the build status
[07:11:10.583] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:10.583] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:20:0) after 1m0s
[07:12:10.592] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:20:0)
[07:12:10.592] Timer tick, asking Buildbucket for the build status
[07:12:10.683] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:10.683] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:21:0) after 1m0s
[07:13:10.699] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:21:0)
[07:13:10.699] Timer tick, asking Buildbucket for the build status
[07:13:11.124] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:11.124] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:22:0) after 1m0s
[07:14:11.165] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:22:0)
[07:14:11.165] Timer tick, asking Buildbucket for the build status
[07:14:11.270] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:11.270] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:23:0) after 1m0s
[07:15:11.286] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:23:0)
[07:15:11.286] Timer tick, asking Buildbucket for the build status
[07:15:11.370] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:11.370] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:24:0) after 1m0s
[07:16:11.404] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:24:0)
[07:16:11.404] Timer tick, asking Buildbucket for the build status
[07:16:11.482] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:11.482] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:25:0) after 1m0s
[07:17:11.497] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:25:0)
[07:17:11.497] Timer tick, asking Buildbucket for the build status
[07:17:11.587] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:11.587] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:26:0) after 1m0s
[07:18:11.641] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:26:0)
[07:18:11.641] Timer tick, asking Buildbucket for the build status
[07:18:11.824] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:11.824] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:27:0) after 1m0s
[07:19:11.837] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:27:0)
[07:19:11.837] Timer tick, asking Buildbucket for the build status
[07:19:12.257] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:12.257] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:28:0) after 1m0s
[07:20:12.278] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:28:0)
[07:20:12.278] Timer tick, asking Buildbucket for the build status
[07:20:12.563] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:12.563] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:29:0) after 1m0s
[07:21:12.585] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:29:0)
[07:21:12.585] Timer tick, asking Buildbucket for the build status
[07:21:12.718] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:12.718] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:30:0) after 1m0s
[07:22:12.713] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:30:0)
[07:22:12.713] Timer tick, asking Buildbucket for the build status
[07:22:12.782] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:12.782] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:31:0) after 1m0s
[07:23:12.870] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:31:0)
[07:23:12.870] Timer tick, asking Buildbucket for the build status
[07:23:13.125] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:13.125] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:32:0) after 1m0s
[07:24:13.150] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:32:0)
[07:24:13.150] Timer tick, asking Buildbucket for the build status
[07:24:13.237] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:13.237] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:33:0) after 1m0s
[07:25:13.242] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:33:0)
[07:25:13.242] Timer tick, asking Buildbucket for the build status
[07:25:13.306] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:13.306] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:34:0) after 1m0s
[07:26:13.278] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:34:0)
[07:26:13.278] Timer tick, asking Buildbucket for the build status
[07:26:13.513] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:13.513] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:35:0) after 1m0s
[07:27:13.550] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:35:0)
[07:27:13.550] Timer tick, asking Buildbucket for the build status
[07:27:13.643] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:13.643] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:36:0) after 1m0s
[07:28:13.777] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:36:0)
[07:28:13.777] Timer tick, asking Buildbucket for the build status
[07:28:13.858] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:13.858] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:37:0) after 1m0s
[07:29:13.906] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:37:0)
[07:29:13.906] Timer tick, asking Buildbucket for the build status
[07:29:14.038] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:14.038] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:38:0) after 1m0s
[07:30:14.195] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:38:0)
[07:30:14.195] Timer tick, asking Buildbucket for the build status
[07:30:14.327] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:14.327] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:39:0) after 1m0s
[07:31:14.388] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:39:0)
[07:31:14.388] Timer tick, asking Buildbucket for the build status
[07:31:14.472] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:14.472] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:40:0) after 1m0s
[07:32:14.489] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:40:0)
[07:32:14.489] Timer tick, asking Buildbucket for the build status
[07:32:14.570] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:14.570] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:41:0) after 1m0s
[07:33:14.638] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:41:0)
[07:33:14.638] Timer tick, asking Buildbucket for the build status
[07:33:14.713] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:14.713] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:42:0) after 1m0s
[07:34:14.743] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:42:0)
[07:34:14.743] Timer tick, asking Buildbucket for the build status
[07:34:14.835] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:14.835] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:43:0) after 1m0s
[07:35:15.106] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:43:0)
[07:35:15.106] Timer tick, asking Buildbucket for the build status
[07:35:15.273] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:15.273] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:44:0) after 1m0s
[07:36:15.530] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:44:0)
[07:36:15.530] Timer tick, asking Buildbucket for the build status
[07:36:15.596] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:15.596] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:45:0) after 1m0s
[07:37:15.884] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:45:0)
[07:37:15.884] Timer tick, asking Buildbucket for the build status
[07:37:15.965] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:15.965] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:46:0) after 1m0s
[07:38:16.070] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:46:0)
[07:38:16.070] Timer tick, asking Buildbucket for the build status
[07:38:16.167] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:16.167] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:47:0) after 1m0s
[07:39:16.487] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:47:0)
[07:39:16.487] Timer tick, asking Buildbucket for the build status
[07:39:16.568] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:16.568] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:48:0) after 1m0s
[07:40:16.742] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:48:0)
[07:40:16.742] Timer tick, asking Buildbucket for the build status
[07:40:16.844] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:16.844] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:49:0) after 1m0s
[07:41:16.933] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:49:0)
[07:41:16.933] Timer tick, asking Buildbucket for the build status
[07:41:17.139] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:17.139] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:50:0) after 1m0s
[07:42:17.185] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:50:0)
[07:42:17.185] Timer tick, asking Buildbucket for the build status
[07:42:17.407] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:17.407] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:51:0) after 1m0s
[07:43:17.534] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:51:0)
[07:43:17.534] Timer tick, asking Buildbucket for the build status
[07:43:18.437] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:18.437] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:52:0) after 1m0s
[07:44:18.556] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:52:0)
[07:44:18.556] Timer tick, asking Buildbucket for the build status
[07:44:18.649] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:18.649] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:53:0) after 1m0s
[07:45:18.714] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:53:0)
[07:45:18.714] Timer tick, asking Buildbucket for the build status
[07:45:18.783] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:18.783] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:54:0) after 1m0s
[07:46:18.763] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:54:0)
[07:46:18.763] Timer tick, asking Buildbucket for the build status
[07:46:18.849] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:18.849] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:55:0) after 1m0s
[07:47:18.917] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:55:0)
[07:47:18.917] Timer tick, asking Buildbucket for the build status
[07:47:19.113] Build 8853619765868348592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:19.113] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019049827946963088:56:0) after 1m0s
[07:47:45.730] Received PubSub notification, asking Buildbucket for the build status
[07:47:45.832] Build 8853619765868348592: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:47:45.832] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614930465008115",
"created_by": "project:chromium",
"created_ts": "1614927244272122",
"id": "8853619765868348592",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f89fc2ac30e582dfe9e334baf19ef8e535eea30d\"}}",
"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\": \"f89fc2ac30e582dfe9e334baf19ef8e535eea30d\", \"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-69-gk1w\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 181135, \"got_angle_revision\": \"fe2efefac498b56334ad167f174c32dff8914f48\", \"got_dawn_revision\": \"80915849ce7d5f4c0fe834924ed420ed0002b210\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"f89fc2ac30e582dfe9e334baf19ef8e535eea30d\", \"got_revision_cp\": \"refs/heads/master@{#860144}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"6846389f25cad4233a4bd04fd3fc6c60ae30ff35\", \"got_v8_revision\": \"3bc17d5d7e100f5ffd1b05ac33cc86a5cce961cc\", \"got_v8_revision_cp\": \"refs/heads/9.1.48@{#1}\", \"got_webrtc_revision\": \"3208bf102b75e8ec1eaa6640dfa3b545310b1e02\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33382}\", \"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\": \"f89fc2ac30e582dfe9e334baf19ef8e535eea30d\", \"swarm_hashes_refs/heads/master(at){#860144}_without_patch\": {\"absl_hardening_tests\": \"8b7518cc637c4cf199cbf4976f3a18c0cd2106b2\", \"accessibility_unittests\": \"5a4a2c1def6dc8ec9cfbd972267efa13f2a74bee\", \"angle_unittests\": \"102d86ef7a6d2e8e18d2b624a0eb9dd0de210fe2\", \"app_shell_unittests\": \"78c36a2910a687bb44d6abee2b83b983d86bbdaf\", \"aura_unittests\": \"2a05809c65b275d41ffd9f70287618aca49c6abe\", \"base_unittests\": \"928f44f44d41c099bbe6093fb0e2a1fea98d5301\", \"base_util_unittests\": \"e714e72e939811d05105faec74a5914cec6b5c0e\", \"blink_common_unittests\": \"0906d280b8e269e4422a8082b701760250389aec\", \"blink_fuzzer_unittests\": \"a7a4aeaaa0d439d53b98069840d57aac4a9b1181\", \"blink_heap_unittests\": \"8a4d4ab3f2735c871d2fcff29490147a26f32de4\", \"blink_platform_unittests\": \"989598f3c01c5d271311f5a1acf9b3ad7bcbb408\", \"blink_python_tests\": \"fb8aee3baa072cc7916083acdc930307e5f70e40\", \"blink_unittests\": \"f5045736a15d33417614a2759349eb9ef19e1265\", \"blink_web_tests\": \"312ab00e89e8aff03ede5b0674b66886671dd238\", \"boringssl_crypto_tests\": \"5e3b23a61eb1dd4dad5f676db55680538c0405cd\", \"boringssl_ssl_tests\": \"99b2a5b08aa6390509442d6ef458e892ca934624\", \"browser_tests\": \"84e1847553a2137b116a0b964f046dffc57d4ccf\", \"capture_unittests\": \"f5bdec4f3f98b12b37655e9a2d773db27d85dc09\", \"cast_unittests\": \"b153267ccfaac533cc465f7f59a833e057930cf6\", \"cc_unittests\": \"7d1c10848dc4506845e774fcf09969577efaba5b\", \"chrome_app_unittests\": \"ba22adab5eb72a2771dfd9c2ccc8b8e748cd270e\", \"chromedriver_unittests\": \"fe5205990039095ce71e4595e4de40c3b6e04b5e\", \"color_unittests\": \"2ddd6ce53f2043e737818a98b76f042dca70992d\", \"components_browsertests\": \"68f9a716495a3012af8870a948fbac43d6db6259\", \"components_unittests\": \"d6913ed2095091ec3af606db62c37d9bfd4b9d98\", \"compositor_unittests\": \"081a449c170037894f18e67dcdc9e6532ee3b2d3\", \"content_browsertests\": \"fe2cf3082f80530d3f1430c5f6c9f0cfce196b84\", \"content_shell_crash_test\": \"4c09c656e8283f8aef26a9ad77c74e1fa18a4b77\", \"content_unittests\": \"2258c646280fda96d89bce59c6b6a5eb0031dd9f\", \"crashpad_tests\": \"1de49d35ae123de446fa7354e0a45bc17cc0045f\", \"cronet_tests\": \"168bcf408a40178aca299225fd0364166e4dee9e\", \"cronet_unittests\": \"380b7f3f515de48e2b33c09dfef158254c69bac8\", \"crypto_unittests\": \"27f444e8a96b1919530e8416ea8dd10c0e3be8a7\", \"dbus_unittests\": \"965f67cd3fd2eb11fd47c72c1afbce4875f9703f\", \"device_unittests\": \"6ade58f9536f387ab7380d58e3ddb687cf51c849\", \"display_unittests\": \"185162586220ddf2644ca51c3ef139b6a18f5259\", \"events_unittests\": \"6c8888c30a66f3752e89dfd0c598dc4a00c91612\", \"extensions_browsertests\": \"cd518c2ac248791646d102055f9ca401f158ddb0\", \"extensions_unittests\": \"06e8268f00c053a8115d3507301ccb98dc05145e\", \"filesystem_service_unittests\": \"cf0dfa080efe144cb37b5eda2fe87678237090e5\", \"flatbuffers_unittests\": \"123fc665b859d2862b8d14757814952110df3994\", \"gcm_unit_tests\": \"db3c3a46dce31538debaed47d6c74d8762044c60\", \"gfx_unittests\": \"0f1ea9c8c2213c49baf2288d8310641883f7e445\", \"gin_unittests\": \"bdd95bd977a5d88f193f06b3d1617325e8371a80\", \"google_apis_unittests\": \"96df338b475b10637058730a1d1c5313cc84377c\", \"gpu_unittests\": \"05b8d246fe791ec6a1f0c901fdc469ee8800f20c\", \"grit_python_unittests\": \"f3a4430dabc578f6d6fa58cb9ef7264f3f78d825\", \"gwp_asan_unittests\": \"b4367bbe23d3b8c8a03a3863f84d0e1df1d7c41d\", \"headless_browsertests\": \"a60359142197bd2def88d313d8c009fdb8797862\", \"headless_unittests\": \"f41e7d38b1f1fe86faf52d949d3bf64a89d58433\", \"interactive_ui_tests\": \"40e5c7ec684f68425be0777bcfe2c6c94444db3c\", \"ipc_tests\": \"7e93b4725059d036b22f5a6e524165321d9562bb\", \"jingle_unittests\": \"dd08f8494aa2085aa2a9356e021acf2472fff074\", \"latency_unittests\": \"ff83bc0be7170c07bf775dc91ba694c3b26f927b\", \"libjingle_xmpp_unittests\": \"c699062bb935be20137d39b1e48ef24f2f5a63cd\", \"liburlpattern_unittests\": \"ea7ca8a3408c8a01273e6cd59432ede5a81c0073\", \"media_blink_unittests\": \"ee5c2f0ad5a0fe44fababd6c62c1635e27a4102d\", \"media_unittests\": \"12e3573dbe84d4a15dbb8876e831433742397c86\", \"message_center_unittests\": \"95540643aabd59167f2806031983dc2aa89ec5d4\", \"metrics_python_tests\": \"e6467f81bea2b352fac144a540aa85b6fa0597cd\", \"midi_unittests\": \"73edb5dca42af115f77a347e4829e2668e268239\", \"mojo_core_unittests\": \"b3901a64b33de4c4fe8dc78b5f1cbd2b13302e6e\", \"mojo_unittests\": \"990edb9471267d6bc1b8cae074d3f5c8f384c387\", \"nacl_helper_nonsfi_unittests\": \"87150e3e49c5304dd1c79997a6cd0324d13f56e8\", \"nacl_loader_unittests\": \"b31a8797390408bfdbb96242541a2af6ef7d3133\", \"native_theme_unittests\": \"f1280709107cb909859c1d97c68d40803bc93976\", \"net_unittests\": \"819a0f93fea8c821673212c487938e6af8c0ca8b\", \"openscreen_unittests\": \"509069001c17b0aac34e48be250004fcf7411b9b\", \"pdf_unittests\": \"ddd9d5713d4d5a0030fed3ce35992c1a7132c196\", \"perfetto_unittests\": \"b0679ea308ffa61220802aad49cbe187a64c03e6\", \"ppapi_unittests\": \"cf911fc2baacec053ca847ac13b14f5966128d80\", \"printing_unittests\": \"2e9dc7e6a31b4401c4eca030114a7071d856ccbb\", \"remoting_unittests\": \"02cc55aa3ca80af8fc760f982dd533d3d51b983a\", \"sandbox_linux_unittests\": \"db8c6350b5659aaa57a25d274e649105447650ec\", \"service_manager_unittests\": \"806beada2e74cb5214b25ca573f88928c7121321\", \"services_unittests\": \"4b2a0002b3ef2e70883d6083d62693e59fdd0f3a\", \"shell_dialogs_unittests\": \"02d0552af315801ce3d12b088c1721ba1951e9f5\", \"skia_unittests\": \"d6ffdcff3d86335abd373b5a1624c6885ac43e65\", \"snapshot_unittests\": \"02ba94670df436427f4b83477e5707485237bbba\", \"sql_unittests\": \"fe3ce46c1f5a73a35b2493175b74fad39fc70256\", \"storage_unittests\": \"82ea0bc4cee334d569d65b8642d4a7bcfd56af93\", \"sync_integration_tests\": \"8d805ab3a95ae26569181bfb1d78f48a5913938f\", \"telemetry_gpu_unittests\": \"76c836437db7541edc0f56e2dcd8d9c75bda6c27\", \"telemetry_perf_unittests\": \"6751e42944028a9bfb95a4242693ba294d3fb996\", \"telemetry_unittests\": \"4e8560774cd11dd5c357c338209be095ab50591a\", \"traffic_annotation_auditor_unittests\": \"17a3d5895d4ef49b7799299c7b1b3908064eb202\", \"ui_base_unittests\": \"809dc944a6a4ce10c5dfc3f194b0aca0750914bd\", \"ui_touch_selection_unittests\": \"3be66d14a96f00d4f51df2f5f92c196be5f689eb\", \"unit_tests\": \"7d0467aee03050f1ae0f2933e589cdf6f09dd9eb\", \"url_unittests\": \"fbe01ff7e121e0d38e6ab8b8235211d7b8f775c7\", \"views_perftests\": \"47f03f0bcfe0ce912fe4f0d462b29d9bd5956891\", \"views_unittests\": \"545cc87fcbaa0385a9a415e0cbfd107310b8169e\", \"viz_unittests\": \"0aeffc65cdd353d62b22ce69e425f94a8542bce7\", \"vr_common_unittests\": \"da3adbae3a3efc8e80f930f60319436f517cf567\", \"vr_pixeltests\": \"cf469681ba37335a809c1f3923a68c4c6db52b61\", \"webdriver_wpt_tests\": \"ef7c935df31370a4d97acb07cede143cb423d07e\", \"weblayer_browsertests\": \"e48541aac4f64fa9933e76957551ce32467df431\", \"weblayer_unittests\": \"4ca216938cbe9c72b731ba7448fe9054e9858926\", \"wm_unittests\": \"f75d2db18c6cf7c563b8316e93e4ef4afbdbd106\", \"wtf_unittests\": \"8d4cd40de0b33123636a8df9c717d3538a9ced41\", \"x11_unittests\": \"915ee0ff59a6d68e45dae6168f52d5f8ea41ee0a\", \"xr_browser_tests\": \"0a09efe1563afaec34353edfbf94fe34b59808fc\", \"zlib_unittests\": \"e01ea1a78b71ea79211a51535ec61fd598fedbd4\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4026221a727cf2e856e94035b8eeb49c4c65d62e8974e693170551540c198531_v2\", \"builder_864635b37f8a928d1dc914b08e925b260febdb791940988e6cd5b520b91ad323_v2\", \"builder_c0379f96998ef0ae805f9cba371bee413f8de83d71b7accc592dcc5afbbc3b2d_v2\", \"builder_d7cc7c59327c05146a034898ae78722818cd22c61c9435c4c4348e98bea5a132_v2\", \"builder_db15b71ef3cc643e8b8a6db72309cfdfa15c11bf324abacf3c7ac043fc971405_v2\", \"builder_dd9616d41d89d2602800dfeda62c5b43a746c971e6e18e9b0c84ab0482a0e409_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-69-gk1w\"], \"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\": [\"5725-1a0d85e\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614927246114758",
"status": "COMPLETED",
"status_changed_ts": "1614930465413489",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/181135",
"builder:Linux Builder (dbg)",
"buildset:commit/git/f89fc2ac30e582dfe9e334baf19ef8e535eea30d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f89fc2ac30e582dfe9e334baf19ef8e535eea30d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019049827946963088",
"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/8853619765868348592/+/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:5219fbb74f3b7410",
"user_agent:luci-scheduler"
],
"updated_ts": "1614930465418007",
"url": "https://ci.chromium.org/b/8853619765868348592",
"utcnow_ts": "1614930465824975"
}
}
[07:47:45.832] Invocation finished in 53m42.926531394s with status SUCCEEDED