[20:00:22.463] New invocation is queued and will start shortly
[20:00:23.597] Starting the invocation (attempt 1)
[20:00:23.652] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:00:23.664] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:00:23.664] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9025523338194977072",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"43597aa3e5a5c641f454b1b63b2843245c1d2214\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9025523338194977072",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/43597aa3e5a5c641f454b1b63b2843245c1d2214",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/43597aa3e5a5c641f454b1b63b2843245c1d2214",
"gitiles_ref:refs/heads/master"
]
}
[20:00:24.891] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1608753623787857",
"id": "8860093276142042336",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"43597aa3e5a5c641f454b1b63b2843245c1d2214\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1608753624453496",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/178982",
"builder:Linux Builder (dbg)",
"buildset:commit/git/43597aa3e5a5c641f454b1b63b2843245c1d2214",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/43597aa3e5a5c641f454b1b63b2843245c1d2214",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025523338194977072",
"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/8860093276142042336/+/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": "1608753624453688",
"url": "https://ci.chromium.org/b/8860093276142042336",
"utcnow_ts": "1608753624814037"
}
}
[20:00:24.891] Task URL: https://ci.chromium.org/b/8860093276142042336
[20:00:24.891] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:2:0) after 1m0s
[20:00:29.774] Received PubSub notification, asking Buildbucket for the build status
[20:00:29.947] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:24.955] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:2:0)
[20:01:24.955] Timer tick, asking Buildbucket for the build status
[20:01:25.403] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:25.403] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:4:0) after 1m0s
[20:02:25.479] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:4:0)
[20:02:25.479] Timer tick, asking Buildbucket for the build status
[20:02:25.733] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:25.733] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:5:0) after 1m0s
[20:03:25.817] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:5:0)
[20:03:25.817] Timer tick, asking Buildbucket for the build status
[20:03:25.947] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:25.947] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:6:0) after 1m0s
[20:04:25.969] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:6:0)
[20:04:25.969] Timer tick, asking Buildbucket for the build status
[20:04:26.083] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:26.083] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:7:0) after 1m0s
[20:05:26.187] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:7:0)
[20:05:26.187] Timer tick, asking Buildbucket for the build status
[20:05:26.329] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:26.329] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:8:0) after 1m0s
[20:06:26.411] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:8:0)
[20:06:26.411] Timer tick, asking Buildbucket for the build status
[20:06:26.517] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:26.517] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:9:0) after 1m0s
[20:07:26.536] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:9:0)
[20:07:26.537] Timer tick, asking Buildbucket for the build status
[20:07:26.598] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:26.598] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:10:0) after 1m0s
[20:08:26.661] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:10:0)
[20:08:26.661] Timer tick, asking Buildbucket for the build status
[20:08:26.738] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:26.738] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:11:0) after 1m0s
[20:09:26.757] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:11:0)
[20:09:26.757] Timer tick, asking Buildbucket for the build status
[20:09:26.834] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:26.834] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:12:0) after 1m0s
[20:10:26.830] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:12:0)
[20:10:26.830] Timer tick, asking Buildbucket for the build status
[20:10:26.904] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:26.904] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:13:0) after 1m0s
[20:11:26.927] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:13:0)
[20:11:26.927] Timer tick, asking Buildbucket for the build status
[20:11:27.056] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:27.056] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:14:0) after 1m0s
[20:12:27.084] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:14:0)
[20:12:27.084] Timer tick, asking Buildbucket for the build status
[20:12:27.303] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:27.303] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:15:0) after 1m0s
[20:13:27.283] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:15:0)
[20:13:27.283] Timer tick, asking Buildbucket for the build status
[20:13:27.346] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:27.346] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:16:0) after 1m0s
[20:14:27.396] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:16:0)
[20:14:27.396] Timer tick, asking Buildbucket for the build status
[20:14:27.471] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:27.471] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:17:0) after 1m0s
[20:15:27.491] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:17:0)
[20:15:27.491] Timer tick, asking Buildbucket for the build status
[20:15:27.567] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:27.567] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:18:0) after 1m0s
[20:16:27.587] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:18:0)
[20:16:27.587] Timer tick, asking Buildbucket for the build status
[20:16:29.848] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:29.848] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:19:0) after 1m0s
[20:17:29.854] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:19:0)
[20:17:29.854] Timer tick, asking Buildbucket for the build status
[20:17:29.930] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:29.930] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:20:0) after 1m0s
[20:18:29.920] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:20:0)
[20:18:29.920] Timer tick, asking Buildbucket for the build status
[20:18:29.973] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:29.973] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:21:0) after 1m0s
[20:19:29.949] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:21:0)
[20:19:29.949] Timer tick, asking Buildbucket for the build status
[20:19:30.027] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:30.027] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:22:0) after 1m0s
[20:20:30.105] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:22:0)
[20:20:30.105] Timer tick, asking Buildbucket for the build status
[20:20:30.441] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:30.441] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:23:0) after 1m0s
[20:21:30.474] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:23:0)
[20:21:30.474] Timer tick, asking Buildbucket for the build status
[20:21:30.744] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:30.744] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:24:0) after 1m0s
[20:22:30.787] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:24:0)
[20:22:30.787] Timer tick, asking Buildbucket for the build status
[20:22:30.853] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:30.853] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:25:0) after 1m0s
[20:23:30.884] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:25:0)
[20:23:30.884] Timer tick, asking Buildbucket for the build status
[20:23:31.074] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:31.074] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:26:0) after 1m0s
[20:24:31.131] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:26:0)
[20:24:31.131] Timer tick, asking Buildbucket for the build status
[20:24:31.277] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:31.277] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:27:0) after 1m0s
[20:25:31.292] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:27:0)
[20:25:31.292] Timer tick, asking Buildbucket for the build status
[20:25:31.387] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:31.387] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:28:0) after 1m0s
[20:26:31.409] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:28:0)
[20:26:31.409] Timer tick, asking Buildbucket for the build status
[20:26:31.471] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:31.471] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:29:0) after 1m0s
[20:27:31.929] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:29:0)
[20:27:31.929] Timer tick, asking Buildbucket for the build status
[20:27:32.126] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:32.126] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:30:0) after 1m0s
[20:28:32.234] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:30:0)
[20:28:32.234] Timer tick, asking Buildbucket for the build status
[20:28:32.327] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:32.327] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:31:0) after 1m0s
[20:29:32.432] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:31:0)
[20:29:32.432] Timer tick, asking Buildbucket for the build status
[20:29:32.622] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:32.622] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:32:0) after 1m0s
[20:30:32.646] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:32:0)
[20:30:32.646] Timer tick, asking Buildbucket for the build status
[20:30:32.747] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:32.747] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:33:0) after 1m0s
[20:31:32.798] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:33:0)
[20:31:32.798] Timer tick, asking Buildbucket for the build status
[20:31:32.872] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:32.872] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:34:0) after 1m0s
[20:32:32.998] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:34:0)
[20:32:32.998] Timer tick, asking Buildbucket for the build status
[20:32:33.078] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:33.078] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:35:0) after 1m0s
[20:33:33.150] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:35:0)
[20:33:33.150] Timer tick, asking Buildbucket for the build status
[20:33:33.230] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:33.230] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:36:0) after 1m0s
[20:34:33.316] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:36:0)
[20:34:33.316] Timer tick, asking Buildbucket for the build status
[20:34:33.486] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:33.486] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:37:0) after 1m0s
[20:35:33.657] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:37:0)
[20:35:33.657] Timer tick, asking Buildbucket for the build status
[20:35:33.962] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:33.962] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:38:0) after 1m0s
[20:36:33.978] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:38:0)
[20:36:33.978] Timer tick, asking Buildbucket for the build status
[20:36:35.460] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:35.460] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:39:0) after 1m0s
[20:37:35.666] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:39:0)
[20:37:35.666] Timer tick, asking Buildbucket for the build status
[20:37:35.747] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:35.747] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:40:0) after 1m0s
[20:38:35.777] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:40:0)
[20:38:35.777] Timer tick, asking Buildbucket for the build status
[20:38:35.888] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:35.888] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:41:0) after 1m0s
[20:39:35.956] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:41:0)
[20:39:35.956] Timer tick, asking Buildbucket for the build status
[20:39:36.012] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:36.012] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:42:0) after 1m0s
[20:40:36.033] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:42:0)
[20:40:36.033] Timer tick, asking Buildbucket for the build status
[20:40:36.146] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:36.146] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:43:0) after 1m0s
[20:41:36.207] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:43:0)
[20:41:36.207] Timer tick, asking Buildbucket for the build status
[20:41:36.298] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:36.298] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:44:0) after 1m0s
[20:42:36.319] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:44:0)
[20:42:36.319] Timer tick, asking Buildbucket for the build status
[20:42:36.405] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:36.406] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:45:0) after 1m0s
[20:43:36.487] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:45:0)
[20:43:36.487] Timer tick, asking Buildbucket for the build status
[20:43:36.546] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:36.546] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:46:0) after 1m0s
[20:44:36.588] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:46:0)
[20:44:36.588] Timer tick, asking Buildbucket for the build status
[20:44:36.643] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:36.643] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:47:0) after 1m0s
[20:45:36.750] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:47:0)
[20:45:36.750] Timer tick, asking Buildbucket for the build status
[20:45:37.027] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:37.027] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:48:0) after 1m0s
[20:46:37.100] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:48:0)
[20:46:37.100] Timer tick, asking Buildbucket for the build status
[20:46:37.617] Build 8860093276142042336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:37.617] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025523338194977072:49:0) after 1m0s
[20:47:37.669] Received PubSub notification, asking Buildbucket for the build status
[20:47:37.871] Build 8860093276142042336: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:47:37.871] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1608756456643292",
"created_by": "project:chromium",
"created_ts": "1608753623787857",
"id": "8860093276142042336",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"43597aa3e5a5c641f454b1b63b2843245c1d2214\"}}",
"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\": \"43597aa3e5a5c641f454b1b63b2843245c1d2214\", \"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-216-wpb3\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 178982, \"got_angle_revision\": \"d447829c19fd6275b94676aab20e303c224fe126\", \"got_dawn_revision\": \"33bf309c1d45e4da80ba77913eab9dadfc8f5e26\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"43597aa3e5a5c641f454b1b63b2843245c1d2214\", \"got_revision_cp\": \"refs/heads/master@{#839162}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"1cc5b3357d2ff3c81ef7ec0b07a6660796bde5cd\", \"got_v8_revision\": \"711cf5ad4a12abe0f6b50058cb2248d7fb80374e\", \"got_v8_revision_cp\": \"refs/heads/8.9.187@{#1}\", \"got_webrtc_revision\": \"c463a784c340874c75032da7602ec1fde43f75ed\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32874}\", \"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\": \"43597aa3e5a5c641f454b1b63b2843245c1d2214\", \"swarm_hashes_refs/heads/master(at){#839162}_without_patch\": {\"absl_hardening_tests\": \"05b82325773cd2684634ae9319fa37a2b9a174db\", \"accessibility_unittests\": \"e4e8ae8367d1e6b2421ddd0323131a647736f2d5\", \"angle_unittests\": \"4f28ce51930183778c84330fa8e71e44d70537ba\", \"app_shell_unittests\": \"193977ef7b58c18ee03435485ace90571ac90f42\", \"aura_unittests\": \"6f5ae57ec0d27d4f076c6d7450a35aa7f922714d\", \"base_unittests\": \"be12245ecf2a25ab2b0249b0ac96a72d9b21480c\", \"base_util_unittests\": \"d8b6c88dcdcbb3cea533471d52e3dfcde0d5f42f\", \"blink_common_unittests\": \"195c40a2b6099157ff334278ed58f787e32fef93\", \"blink_fuzzer_unittests\": \"f84226c0085aad8edae21dc4dc82a504dac58fba\", \"blink_heap_unittests\": \"3a799118293537bc5efa87b802287ccca96a16f8\", \"blink_platform_unittests\": \"99e62795be967a7b36cb9c724fc1ab9dc5c276b2\", \"blink_python_tests\": \"c332bf25905a91a448aeeeff29d3aabf9f6bbf2b\", \"blink_unittests\": \"a0ac492e7ec26b52d4384ce6b001ba476e458d7b\", \"blink_web_tests\": \"7a592adada0011c8fb983b77b56ba1e74c2892c3\", \"boringssl_crypto_tests\": \"ea57dbfc27e92ce31fe96500c911967c4db3f056\", \"boringssl_ssl_tests\": \"3c92404f39c68eeaa9224daaee18b4ab39520884\", \"browser_tests\": \"b54792a561892178dc63c1494e69c40ab95fef2b\", \"capture_unittests\": \"6ee9c66d914c109f6ffd5d2418ed898362a55c65\", \"cast_unittests\": \"fc44a00ca6502786490c6462205219d004dc02f5\", \"cc_unittests\": \"e3aaccf66f7dc2d7a82f66f8b225e365cc0f8359\", \"chrome_app_unittests\": \"f4f7820799a078b4f0796f6da280fc11e7b640ac\", \"chromedriver_unittests\": \"972cda3003be675b6fc1f34ef9b83bd4a2601c69\", \"components_browsertests\": \"2487a7a35b62459ebba56ef81bb87a2f58b99811\", \"components_unittests\": \"1b767d2eda96b250ccb28f538ad85595fa40daad\", \"compositor_unittests\": \"581dba8a206d051ca301e7f962491630bb5e68bc\", \"content_browsertests\": \"99539774d12dacfe2c9ca94a2e324470f4cf8e66\", \"content_shell_crash_test\": \"52968bfc61108c7e7752de913b5e4e87327bf081\", \"content_unittests\": \"af351ab1bdfaf85d82703240f3bf049d341664f7\", \"crashpad_tests\": \"ca5c73dd9a2688e1b73399b5650e41a3cf1b5e70\", \"cronet_tests\": \"dc7e293561cf9399df3f287f1f59954d8df62070\", \"cronet_unittests\": \"6ed010c390d6b5b8516b00aef83dbb413f8fe304\", \"crypto_unittests\": \"c2020df2d4d284a891d1434a8a33cd67d5d0afa4\", \"dbus_unittests\": \"f505b4bc9b68f90232630bd388051a06707859e0\", \"device_unittests\": \"67da31ff11c81e7134ea95faad7545d31d7a4443\", \"display_unittests\": \"70ed9c036d20a26b1495d60385aece291ca0b0ec\", \"events_unittests\": \"6cc6149b710d3377cdc3fe79888975127b04d5bc\", \"extension_docserver_python_unittests\": \"08b4fe2cfbadbfb40a4645dc07846ca537e03335\", \"extensions_browsertests\": \"c51302dff6cf968f55a8dd80ebc406228eb1d9ea\", \"extensions_unittests\": \"3b7d8aed3bcf0fc2f3067bee40dbe04241dec4f2\", \"filesystem_service_unittests\": \"452cba7025fe9d99b2e4859fdef810af87b5de27\", \"flatbuffers_unittests\": \"d051d66da1ab229778a7e9a8f6ace686eaf5e782\", \"gcm_unit_tests\": \"7921c407a42108af732ebd03a6035f594f052edd\", \"gfx_unittests\": \"cee386f483c1940d93306d1b63e345a862e99ede\", \"gin_unittests\": \"c79073ae93886927b53a4178cf1dad22864b0534\", \"google_apis_unittests\": \"41ddc5616a2617f376dd1bd026738cd5a8923db8\", \"gpu_unittests\": \"aa7a26e890065c89abe68c4c9d1e542dba42d19c\", \"grit_python_unittests\": \"275c161e38b800af0a18bf8ee2ae20e83dfa4ea2\", \"gwp_asan_unittests\": \"cbb321565e9601b66d8024432a0ed14140751520\", \"headless_browsertests\": \"55fe94ba0946edbe068ad1c856876e0f01e4c763\", \"headless_unittests\": \"323fee93adac849c9ab8e13d5d9952eb3b8d7398\", \"interactive_ui_tests\": \"c669d09ee17c2de33c5995f0fcbce624914826c9\", \"ipc_tests\": \"fa14f180d51a7ad844a249fd8797076a08b255f7\", \"jingle_unittests\": \"e999e82ee326385f5f487a735fc7001ca95cd3d6\", \"latency_unittests\": \"403524d0eec28c36e7d0cdff0d379591154e1c71\", \"libjingle_xmpp_unittests\": \"c70f176996919e4f47ca8e2542df58ef6c9d877c\", \"liburlpattern_unittests\": \"7f85305efe83f057d40c7b891712eebb136bf387\", \"media_blink_unittests\": \"2e4b52d120d895fabef9eedf40dbc98885a7fe2f\", \"media_unittests\": \"d8d21340a8a60adc7f57cf6a8448a2df3e11ab2e\", \"message_center_unittests\": \"876d06d1f504db88f83876a547a904006549d959\", \"metrics_python_tests\": \"f20f17da57f7e4739abc3bd5587e111b63e4d6c6\", \"midi_unittests\": \"8e004d2c7cf9ae0eaccbb838cfa8129be1036551\", \"mojo_core_unittests\": \"e55f0bdb141d510b8e932cba94705884b0d22664\", \"mojo_unittests\": \"41a1bc4a85f3fd7e2452f3b360c33dea215bf0d0\", \"nacl_helper_nonsfi_unittests\": \"f8a8e8c582eaaafe5171084f709310946d8b50ac\", \"nacl_loader_unittests\": \"6642c25c9e8ec7d41de6f07a738cc6469c9f4e40\", \"native_theme_unittests\": \"5275d9db8ec199787152e001bfbf8e2c86fd4bc7\", \"net_unittests\": \"9755c9fd9ea6817aa3bc50d3a8a9d99cf4192b9b\", \"openscreen_unittests\": \"bd44be7a241e0c438b7ca24621e223b07e1d5150\", \"pdf_unittests\": \"13bedbf6f443ed3514769cd67a2936415f50a70e\", \"perfetto_unittests\": \"66fdccb91a4cd9e75ee82efd9434f45accde70b2\", \"ppapi_unittests\": \"d04724f332b2814661c5ee5549d263e3911bfa74\", \"printing_unittests\": \"48d0d0e61acd65ed08233508d683662a4c3fb814\", \"remoting_unittests\": \"08a9cd359ef6ae48461106473be86fe5f882cb99\", \"sandbox_linux_unittests\": \"58f662bf00369f9a13cfdb4359efaf53cf0c7fab\", \"service_manager_unittests\": \"52936a89d14c8c4a57f6923a24d6265440adb620\", \"services_unittests\": \"b8b0471a89d9b47d3fac3304c3f3c5b58c3d319f\", \"shell_dialogs_unittests\": \"d20f14f945cb935d2b69178f423747db5254e5f9\", \"skia_unittests\": \"3e6911bae331b8ca0f7b9a9452b7b3fc7f494a24\", \"snapshot_unittests\": \"65caf019123b42586360931f6f24c1a8d723ec67\", \"sql_unittests\": \"45687034d3b39ea4e1461e4ed31ae1b6ec952ddf\", \"storage_unittests\": \"cb11ec49be36dbe8d5ad0086e41a7d428b5aa1e6\", \"sync_integration_tests\": \"c2d7ed351cba390a2483ed42a357c3f50eb145f7\", \"telemetry_gpu_unittests\": \"583f702c4a71bbed41dd020153b4b9a14b5ea493\", \"telemetry_perf_unittests\": \"a66858f748e1c5fb79bab9b58cd85fdcb9b6be30\", \"telemetry_unittests\": \"9fd2998a859fcc5843f9506632d0369907269da9\", \"traffic_annotation_auditor_unittests\": \"2ee2987efc875864cfb9790c8326d7b22addaf36\", \"ui_base_unittests\": \"a3e58eab3af16134049fdc35f4e275b1609e17bf\", \"ui_touch_selection_unittests\": \"19218ce383af0f4ac1a8b68b3f1de72cf2217dda\", \"unit_tests\": \"c6b9a2aae76ae5fa0f0ea83dbaf182acd68b45ee\", \"url_unittests\": \"2a1ba338490387caca1d54b9390674fb0efaa239\", \"views_perftests\": \"181f1e9d41131d24139b512c85604c29dfb8c8ec\", \"views_unittests\": \"713af9e49bbc9c4ae8512b973cd9cac2801e6169\", \"viz_unittests\": \"5bee4337b13ae7b86b77b5c9770ea196340b58b9\", \"vr_common_unittests\": \"a5bb0a926f85334f3ae3c321ad9a875e4d395a1a\", \"vr_pixeltests\": \"10375c0279d543eef23ae93bb8397172e0828e91\", \"webdriver_wpt_tests\": \"f4b78fec08a65760035d0f04fa66750117b1485c\", \"weblayer_browsertests\": \"4489f5958e02c20d9ebb33531f464809662294bc\", \"weblayer_unittests\": \"8ea3a8bb51f0e52bdfd0db1a08abea04663b752b\", \"wm_unittests\": \"db82ea30822d7dd689a09a7ede9972978d42a890\", \"wtf_unittests\": \"434cceb3d8b4417f0eadd0edd04d171a27441052\", \"x11_unittests\": \"eeefaace3e10795ba20047c25ffa11bd237cf26e\", \"xr_browser_tests\": \"41e78ff8ae87d3f7e735f645e6396c8282ba7823\", \"zlib_unittests\": \"27f1a19ec7d148e9d2da0a9627aff1341a886c1c\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"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-216-wpb3\"], \"image\": [\"chrome-xenial-20121300-d43316a0aad\"], \"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\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1608753627976470",
"status": "COMPLETED",
"status_changed_ts": "1608756457008597",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/178982",
"builder:Linux Builder (dbg)",
"buildset:commit/git/43597aa3e5a5c641f454b1b63b2843245c1d2214",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/43597aa3e5a5c641f454b1b63b2843245c1d2214",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025523338194977072",
"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/8860093276142042336/+/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:50aa01c29b6dd010",
"user_agent:luci-scheduler"
],
"updated_ts": "1608756457040799",
"url": "https://ci.chromium.org/b/8860093276142042336",
"utcnow_ts": "1608756457806391"
}
}
[20:47:37.871] Invocation finished in 47m15.424505068s with status SUCCEEDED